VIFIB DESCENTRALIZED CLOUD COMPUTING

SlapOS is a decentralized Cloud Computing technology that can automate the deployment and configuration of applications in a heterogeneous environment.
/srv/slapgrid/slappart9/srv/testnode/ij/inst/test0-0/parts/erp5-util
6.217
31
0
0
4
PASSED
Completed
python setup.py test
running test
running egg_info
creating erp5.util.egg-info
writing requirements to erp5.util.egg-info/requires.txt
writing erp5.util.egg-info/PKG-INFO
writing namespace_packages to erp5.util.egg-info/namespace_packages.txt
writing top-level names to erp5.util.egg-info/top_level.txt
writing dependency_links to erp5.util.egg-info/dependency_links.txt
writing entry points to erp5.util.egg-info/entry_points.txt
writing manifest file 'erp5.util.egg-info/SOURCES.txt'
reading manifest file 'erp5.util.egg-info/SOURCES.txt'
reading manifest template 'MANIFEST.in'
writing manifest file 'erp5.util.egg-info/SOURCES.txt'
running build_ext
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp2PnR29/testnode/foo', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clone /tmp/tmp2PnR29/rep0 -b master /tmp/tmp2PnR29/testnode/foo/rep0', {}
TESTNODE LOG : "git : Cloning into '/tmp/tmp2PnR29/testnode/foo/rep0'...", {}
TESTNODE LOG : 'git : done.', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp2PnR29/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp2PnR29/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp2PnR29/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp2PnR29/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at 8ef49c8 next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp2PnR29/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : 8ef49c8e180a99c2de41b38756d3517671a77197', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp2PnR29/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-list --topo-order --count 8ef49c8e180a99c2de41b38756d3517671a77197', {}
TESTNODE LOG : 'git : 2', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp2PnR29/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp2PnR29/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : 8ef49c8e180a99c2de41b38756d3517671a77197', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp2PnR29/testnode/foo', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clone /tmp/tmp2PnR29/rep1 -b master /tmp/tmp2PnR29/testnode/foo/rep1', {}
TESTNODE LOG : "git : Cloning into '/tmp/tmp2PnR29/testnode/foo/rep1'...", {}
TESTNODE LOG : 'git : done.', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp2PnR29/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp2PnR29/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp2PnR29/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp2PnR29/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at 54cf0a7 next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp2PnR29/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : 54cf0a7bc119fa31a062bf6a7f08d3204f1760e9', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp2PnR29/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-list --topo-order --count 54cf0a7bc119fa31a062bf6a7f08d3204f1760e9', {}
TESTNODE LOG : 'git : 2', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp2PnR29/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp2PnR29/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : 54cf0a7bc119fa31a062bf6a7f08d3204f1760e9', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp2PnR29/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git config --get remote.origin.url', {}
TESTNODE LOG : 'git : /tmp/tmp2PnR29/rep0', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp2PnR29/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp2PnR29/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp2PnR29/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp2PnR29/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at 8ef49c8 next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp2PnR29/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : 8ef49c8e180a99c2de41b38756d3517671a77197', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp2PnR29/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp2PnR29/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : 8ef49c8e180a99c2de41b38756d3517671a77197', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp2PnR29/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git config --get remote.origin.url', {}
TESTNODE LOG : 'git : /tmp/tmp2PnR29/rep1', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp2PnR29/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp2PnR29/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : 'git : From /tmp/tmp2PnR29/rep1', {}
TESTNODE LOG : 'git : 54cf0a7..5e521ea master -> origin/master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp2PnR29/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp2PnR29/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at 5e521ea new_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp2PnR29/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : 5e521eaf2aaa7ec7cb7ec140649f6f9ed2f9dfeb', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp2PnR29/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-list --topo-order --count 5e521eaf2aaa7ec7cb7ec140649f6f9ed2f9dfeb', {}
TESTNODE LOG : 'git : 3', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp2PnR29/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp2PnR29/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : 5e521eaf2aaa7ec7cb7ec140649f6f9ed2f9dfeb', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clone /tmp/tmpCYAr49/rep2 -b foo /tmp/tmpCYAr49/testnode/foo/rep2', {}
TESTNODE LOG : "git : Cloning into '/tmp/tmpCYAr49/testnode/foo/rep2'...", {}
TESTNODE LOG : 'git : done.', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * foo', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at c402bee next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : c402bee24d9bc53b42856df86f132a32de40a00d', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-list --topo-order --count c402bee24d9bc53b42856df86f132a32de40a00d', {}
TESTNODE LOG : 'git : 2', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : c402bee24d9bc53b42856df86f132a32de40a00d', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clone /tmp/tmpCYAr49/rep0 -b master /tmp/tmpCYAr49/testnode/foo/rep0', {}
TESTNODE LOG : "git : Cloning into '/tmp/tmpCYAr49/testnode/foo/rep0'...", {}
TESTNODE LOG : 'git : done.', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at 8ef49c8 next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : 8ef49c8e180a99c2de41b38756d3517671a77197', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : 8ef49c8e180a99c2de41b38756d3517671a77197', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clone /tmp/tmpCYAr49/rep1 -b master /tmp/tmpCYAr49/testnode/foo/rep1', {}
TESTNODE LOG : "git : Cloning into '/tmp/tmpCYAr49/testnode/foo/rep1'...", {}
TESTNODE LOG : 'git : done.', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at 54cf0a7 next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : 54cf0a7bc119fa31a062bf6a7f08d3204f1760e9', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : 54cf0a7bc119fa31a062bf6a7f08d3204f1760e9', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git config --get remote.origin.url', {}
TESTNODE LOG : 'git : /tmp/tmpCYAr49/rep2', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * foo', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * foo', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git checkout origin/master -b master', {}
TESTNODE LOG : "git : Switched to a new branch 'master'", {}
TESTNODE LOG : 'git : Branch master set up to track remote branch master from origin.', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at c402bee next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : c402bee24d9bc53b42856df86f132a32de40a00d', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : c402bee24d9bc53b42856df86f132a32de40a00d', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git config --get remote.origin.url', {}
TESTNODE LOG : 'git : /tmp/tmpCYAr49/rep0', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at 8ef49c8 next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : 8ef49c8e180a99c2de41b38756d3517671a77197', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : 8ef49c8e180a99c2de41b38756d3517671a77197', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git config --get remote.origin.url', {}
TESTNODE LOG : 'git : /tmp/tmpCYAr49/rep1', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at 54cf0a7 next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : 54cf0a7bc119fa31a062bf6a7f08d3204f1760e9', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : 54cf0a7bc119fa31a062bf6a7f08d3204f1760e9', {}
foo
* master
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git config --get remote.origin.url', {}
TESTNODE LOG : 'git : /tmp/tmpCYAr49/rep2', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : 'git : From /tmp/tmpCYAr49/rep2', {}
TESTNODE LOG : 'git : * [new branch] bar -> origin/bar', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : foo', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : foo', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git checkout origin/bar -b bar', {}
TESTNODE LOG : "git : Switched to a new branch 'bar'", {}
TESTNODE LOG : 'git : Branch bar set up to track remote branch bar from origin.', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at c402bee next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : c402bee24d9bc53b42856df86f132a32de40a00d', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : c402bee24d9bc53b42856df86f132a32de40a00d', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git config --get remote.origin.url', {}
TESTNODE LOG : 'git : /tmp/tmpCYAr49/rep0', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at 8ef49c8 next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : 8ef49c8e180a99c2de41b38756d3517671a77197', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : 8ef49c8e180a99c2de41b38756d3517671a77197', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git config --get remote.origin.url', {}
TESTNODE LOG : 'git : /tmp/tmpCYAr49/rep1', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at 54cf0a7 next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : 54cf0a7bc119fa31a062bf6a7f08d3204f1760e9', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCYAr49/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : 54cf0a7bc119fa31a062bf6a7f08d3204f1760e9', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpwSS7yP/testnode/foo', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clone /tmp/tmpwSS7yP/rep0 -b master /tmp/tmpwSS7yP/testnode/foo/rep0', {}
TESTNODE LOG : "git : Cloning into '/tmp/tmpwSS7yP/testnode/foo/rep0'...", {}
TESTNODE LOG : 'git : done.', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpwSS7yP/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpwSS7yP/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpwSS7yP/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpwSS7yP/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at 8ef49c8 next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpwSS7yP/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : 8ef49c8e180a99c2de41b38756d3517671a77197', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpwSS7yP/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpwSS7yP/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : 8ef49c8e180a99c2de41b38756d3517671a77197', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpwSS7yP/testnode/foo', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clone /tmp/tmpwSS7yP/rep1 -b master /tmp/tmpwSS7yP/testnode/foo/rep1', {}
TESTNODE LOG : "git : Cloning into '/tmp/tmpwSS7yP/testnode/foo/rep1'...", {}
TESTNODE LOG : 'git : done.', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpwSS7yP/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpwSS7yP/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpwSS7yP/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpwSS7yP/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at 54cf0a7 next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpwSS7yP/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : 54cf0a7bc119fa31a062bf6a7f08d3204f1760e9', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpwSS7yP/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpwSS7yP/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : 54cf0a7bc119fa31a062bf6a7f08d3204f1760e9', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpwSS7yP/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git config --get remote.origin.url', {}
TESTNODE LOG : 'git : /tmp/tmpwSS7yP/rep0', {}
TESTNODE LOG : 'Wrong repository or wrong url, deleting repos /tmp/tmpwSS7yP/testnode/foo/rep0', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpwSS7yP/testnode/foo', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clone /tmp/tmpwSS7yP/rep2 -b master /tmp/tmpwSS7yP/testnode/foo/rep0', {}
TESTNODE LOG : "git : Cloning into '/tmp/tmpwSS7yP/testnode/foo/rep0'...", {}
TESTNODE LOG : 'git : done.', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpwSS7yP/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpwSS7yP/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpwSS7yP/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpwSS7yP/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at c402bee next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpwSS7yP/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : c402bee24d9bc53b42856df86f132a32de40a00d', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpwSS7yP/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpwSS7yP/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : c402bee24d9bc53b42856df86f132a32de40a00d', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpwSS7yP/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git config --get remote.origin.url', {}
TESTNODE LOG : 'git : /tmp/tmpwSS7yP/rep1', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpwSS7yP/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpwSS7yP/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpwSS7yP/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpwSS7yP/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at 54cf0a7 next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpwSS7yP/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : 54cf0a7bc119fa31a062bf6a7f08d3204f1760e9', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpwSS7yP/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpwSS7yP/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : 54cf0a7bc119fa31a062bf6a7f08d3204f1760e9', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpvn3qYT/testnode/foo', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clone /tmp/tmpvn3qYT/rep0 -b master /tmp/tmpvn3qYT/testnode/foo/rep0', {}
TESTNODE LOG : "git : Cloning into '/tmp/tmpvn3qYT/testnode/foo/rep0'...", {}
TESTNODE LOG : 'git : done.', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpvn3qYT/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpvn3qYT/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpvn3qYT/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpvn3qYT/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at 9f1208e next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpvn3qYT/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : 9f1208e1ccc7f4518a7487e6d319a077e03d4c59', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpvn3qYT/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-list --topo-order --count 9f1208e1ccc7f4518a7487e6d319a077e03d4c59', {}
TESTNODE LOG : 'git : 2', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpvn3qYT/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpvn3qYT/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : 9f1208e1ccc7f4518a7487e6d319a077e03d4c59', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpvn3qYT/testnode/foo', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clone /tmp/tmpvn3qYT/rep1 -b master /tmp/tmpvn3qYT/testnode/foo/rep1', {}
TESTNODE LOG : "git : Cloning into '/tmp/tmpvn3qYT/testnode/foo/rep1'...", {}
TESTNODE LOG : 'git : done.', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpvn3qYT/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpvn3qYT/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpvn3qYT/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpvn3qYT/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at 5e93485 next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpvn3qYT/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : 5e934859132eed3bbf0649ea523a67ea7df30241', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpvn3qYT/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-list --topo-order --count 5e934859132eed3bbf0649ea523a67ea7df30241', {}
TESTNODE LOG : 'git : 2', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpvn3qYT/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpvn3qYT/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : 5e934859132eed3bbf0649ea523a67ea7df30241', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpvn3qYT/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git config --get remote.origin.url', {}
TESTNODE LOG : 'git : /tmp/tmpvn3qYT/rep0', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpvn3qYT/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpvn3qYT/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpvn3qYT/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpvn3qYT/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at 9f1208e next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpvn3qYT/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : 9f1208e1ccc7f4518a7487e6d319a077e03d4c59', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpvn3qYT/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpvn3qYT/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : 9f1208e1ccc7f4518a7487e6d319a077e03d4c59', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpvn3qYT/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git config --get remote.origin.url', {}
TESTNODE LOG : 'git : /tmp/tmpvn3qYT/rep1', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpvn3qYT/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpvn3qYT/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpvn3qYT/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpvn3qYT/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at 5e93485 next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpvn3qYT/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : 5e934859132eed3bbf0649ea523a67ea7df30241', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpvn3qYT/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpvn3qYT/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : 5e934859132eed3bbf0649ea523a67ea7df30241', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp6KvVxH/testnode/foo', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clone /tmp/tmp6KvVxH/rep0 -b master /tmp/tmp6KvVxH/testnode/foo/rep0', {}
TESTNODE LOG : "git : Cloning into '/tmp/tmp6KvVxH/testnode/foo/rep0'...", {}
TESTNODE LOG : 'git : done.', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp6KvVxH/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp6KvVxH/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp6KvVxH/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp6KvVxH/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at 9f1208e next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp6KvVxH/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : 9f1208e1ccc7f4518a7487e6d319a077e03d4c59', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp6KvVxH/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp6KvVxH/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : 9f1208e1ccc7f4518a7487e6d319a077e03d4c59', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp6KvVxH/testnode/foo', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clone /tmp/tmp6KvVxH/rep1 -b master /tmp/tmp6KvVxH/testnode/foo/rep1', {}
TESTNODE LOG : "git : Cloning into '/tmp/tmp6KvVxH/testnode/foo/rep1'...", {}
TESTNODE LOG : 'git : done.', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp6KvVxH/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp6KvVxH/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp6KvVxH/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp6KvVxH/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at 5e93485 next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp6KvVxH/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : 5e934859132eed3bbf0649ea523a67ea7df30241', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp6KvVxH/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp6KvVxH/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : 5e934859132eed3bbf0649ea523a67ea7df30241', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmp6KvVxH/testnode/foo', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clone /tmp/tmp6KvVxH/broken -b foo /tmp/tmp6KvVxH/testnode/foo/rep2', {}
TESTNODE LOG : "git : fatal: repository '/tmp/tmp6KvVxH/broken' does not exist", {}
TESTNODE LOG : 'Error while getting repository, ignoring this test suite', {'exc_info': 1}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpKXm3ok/testnode/foo', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clone /tmp/tmpKXm3ok/rep0 -b master /tmp/tmpKXm3ok/testnode/foo/rep0', {}
TESTNODE LOG : "git : Cloning into '/tmp/tmpKXm3ok/testnode/foo/rep0'...", {}
TESTNODE LOG : 'git : done.', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpKXm3ok/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpKXm3ok/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpKXm3ok/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpKXm3ok/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at ed6c0a5 next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpKXm3ok/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : ed6c0a5f2bff71a9712a1372ef0ac4001ebe8e81', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpKXm3ok/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-list --topo-order --count ed6c0a5f2bff71a9712a1372ef0ac4001ebe8e81', {}
TESTNODE LOG : 'git : 2', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpKXm3ok/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpKXm3ok/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : ed6c0a5f2bff71a9712a1372ef0ac4001ebe8e81', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpKXm3ok/testnode/foo', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clone /tmp/tmpKXm3ok/rep1 -b master /tmp/tmpKXm3ok/testnode/foo/rep1', {}
TESTNODE LOG : "git : Cloning into '/tmp/tmpKXm3ok/testnode/foo/rep1'...", {}
TESTNODE LOG : 'git : done.', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpKXm3ok/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpKXm3ok/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpKXm3ok/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpKXm3ok/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at bdc9eac next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpKXm3ok/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : bdc9eac0c6feea72b81e4c790cc172f5afabf0f5', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpKXm3ok/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-list --topo-order --count bdc9eac0c6feea72b81e4c790cc172f5afabf0f5', {}
TESTNODE LOG : 'git : 2', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpKXm3ok/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpKXm3ok/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : bdc9eac0c6feea72b81e4c790cc172f5afabf0f5', {}
TESTNODE LOG : 'Disagreement on tested revision, checking out: %r != %r', {}
TESTNODE LOG : 'rep0=2-ed6c0a5f2bff71a9712a1372ef0ac4001ebe8e81,rep1=2-bdc9eac0c6feea72b81e4c790cc172f5afabf0f5', {}
TESTNODE LOG : 'rep0=2-ed6c0a5f2bff71a9712a1372ef0ac4001ebe8e81,rep1=1-08036c1c395d05802d926653baa49dd390842c1f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpKXm3ok/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : ed6c0a5f2bff71a9712a1372ef0ac4001ebe8e81', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpKXm3ok/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpKXm3ok/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : 'checking link /tmp/tmpKXm3ok/testnode/foo/rep0/rep0.git -> /tmp/tmpKXm3ok/testnode/foo/rep0/.git..', {}
TESTNODE LOG : 'link: /tmp/tmpKXm3ok/testnode/foo/rep0/rep0.git -> /tmp/tmpKXm3ok/testnode/foo/rep0/.git created', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpKXm3ok/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : bdc9eac0c6feea72b81e4c790cc172f5afabf0f5', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpKXm3ok/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpKXm3ok/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git reset --hard 08036c1c395d05802d926653baa49dd390842c1f', {}
TESTNODE LOG : 'git : HEAD is now at 08036c1 first_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpKXm3ok/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpKXm3ok/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : 'checking link /tmp/tmpKXm3ok/testnode/foo/rep1/rep1.git -> /tmp/tmpKXm3ok/testnode/foo/rep1/.git..', {}
TESTNODE LOG : 'link: /tmp/tmpKXm3ok/testnode/foo/rep1/rep1.git -> /tmp/tmpKXm3ok/testnode/foo/rep1/.git created', {}
TESTNODE LOG : "testnode.checkOldTestSuite, DELETING : '/tmp/tmpyODPTT/testnode/bar'", {}
TESTNODE LOG : "Configured slapproxy log to '/tmp/tmpUUlenV/var/log/testnode/slapproxy.log'", {}
TESTNODE LOG : 'testnode, retry_software_count : 0', {}
TESTNODE LOG : 'Before status_dict = slapos_method(...)', {}
TESTNODE LOG : {'status_code': 0}, {}
TESTNODE LOG : 'After status_dict = slapos_method(...)', {}
TESTNODE LOG : "Configured slapproxy log to '/tmp/tmpUUlenV/var/log/testnode/slapproxy.log'", {}
TESTNODE LOG : 'testnode, retry_software_count : 0', {}
TESTNODE LOG : 'Before status_dict = slapos_method(...)', {}
TESTNODE LOG : {'status_code': 0}, {}
TESTNODE LOG : 'After status_dict = slapos_method(...)', {}
TESTNODE LOG : 'Before status_dict = slapos_method(...)', {}
TESTNODE LOG : {'status_code': 0}, {}
TESTNODE LOG : 'After status_dict = slapos_method(...)', {}
TESTNODE LOG : "Configured slapproxy log to '/tmp/tmpUUlenV/var/log/testnode/slapproxy.log'", {}
TESTNODE LOG : 'testnode, retry_software_count : 0', {}
TESTNODE LOG : 'Before status_dict = slapos_method(...)', {}
TESTNODE LOG : {'status_code': 1}, {}
TESTNODE LOG : 'After status_dict = slapos_method(...)', {}
TESTNODE LOG : 'Testnode.cleanUp', {}
TESTNODE LOG : 'ProcessManager killPreviousRun, going to kill set([])', {}
TESTNODE LOG : 'ProcessManager killPreviousRun, exception when killing supervisor', {}
TESTNODE LOG : 'Got following test suite data from master : %r', {}
TESTNODE LOG : [{'project_title': 'foo', 'test_suite': 'Foo', 'vcs_repository_list': [{'url': '/tmp/tmpuBQ9Ga/rep0', 'profile_path': 'software.cfg', 'branch': 'master'}, {'url': '/tmp/tmpuBQ9Ga/rep1', 'buildout_section_id': 'rep1', 'branch': 'master'}], 'test_suite_title': 'Foo-Test', 'test_suite_reference': 'foo'}, {'project_title': 'bar', 'test_suite': 'Foo', 'vcs_repository_list': [{'url': '/tmp/tmpuBQ9Ga/rep0', 'profile_path': 'software.cfg', 'branch': 'master'}, {'url': '/tmp/tmpuBQ9Ga/rep1', 'buildout_section_id': 'rep1', 'branch': 'master'}], 'test_suite_title': 'Foo-Test', 'test_suite_reference': 'bar'}], {}
TESTNODE LOG : 'Type of current test is %s', {}
TESTNODE LOG : 'UnitTest', {}
TESTNODE LOG : 'ProcessManager killPreviousRun, going to kill set([])', {}
TESTNODE LOG : 'ProcessManager killPreviousRun, exception when killing supervisor', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foo', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clone /tmp/tmpuBQ9Ga/rep0 -b master /tmp/tmpuBQ9Ga/testnode/foo/rep0', {}
TESTNODE LOG : "git : Cloning into '/tmp/tmpuBQ9Ga/testnode/foo/rep0'...", {}
TESTNODE LOG : 'git : done.', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at ed6c0a5 next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : ed6c0a5f2bff71a9712a1372ef0ac4001ebe8e81', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : ed6c0a5f2bff71a9712a1372ef0ac4001ebe8e81', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foo', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clone /tmp/tmpuBQ9Ga/rep1 -b master /tmp/tmpuBQ9Ga/testnode/foo/rep1', {}
TESTNODE LOG : "git : Cloning into '/tmp/tmpuBQ9Ga/testnode/foo/rep1'...", {}
TESTNODE LOG : 'git : done.', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at bdc9eac next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : bdc9eac0c6feea72b81e4c790cc172f5afabf0f5', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : bdc9eac0c6feea72b81e4c790cc172f5afabf0f5', {}
TESTNODE LOG : 'testnode, test_result : %r', {}
TESTNODE LOG : <TestResultProxy('/tmp/tmpuBQ9Ga/test/results/Foo-Test', 'Foo-Test-Node', 'rep0=2-ed6c0a5f2bff71a9712a1372ef0ac4001ebe8e81,rep1=2-bdc9eac0c6feea72b81e4c790cc172f5afabf0f5') at 7f33d1100b90>, {}
TESTNODE LOG : "going to switch to log '/tmp/tmpuBQ9Ga/var/log/testnode/foo-JCT6rTsfPw8mHhp7boKeP70wYKyDf61g/suite.log'", {}
TESTNODE LOG : 'End of processing, going to sleep %s', {}
TESTNODE LOG : 119.85635089874268, {}
TESTNODE LOG : 'Testnode.cleanUp', {}
TESTNODE LOG : 'ProcessManager killPreviousRun, going to kill set([])', {}
TESTNODE LOG : 'ProcessManager killPreviousRun, exception when killing supervisor', {}
TESTNODE LOG : 'Got following test suite data from master : %r', {}
TESTNODE LOG : [{'project_title': 'bar', 'test_suite': 'Foo', 'vcs_repository_list': [{'url': '/tmp/tmpuBQ9Ga/rep0', 'profile_path': 'software.cfg', 'branch': 'master'}, {'url': '/tmp/tmpuBQ9Ga/rep1', 'buildout_section_id': 'rep1', 'branch': 'master'}], 'test_suite_title': 'Foo-Test', 'test_suite_reference': 'bar'}, {'project_title': 'foo', 'test_suite': 'Foo', 'vcs_repository_list': [{'url': '/tmp/tmpuBQ9Ga/rep0', 'profile_path': 'software.cfg', 'branch': 'master'}, {'url': '/tmp/tmpuBQ9Ga/rep1', 'buildout_section_id': 'rep1', 'branch': 'master'}], 'test_suite_title': 'Foo-Test', 'test_suite_reference': 'foo'}], {}
TESTNODE LOG : 'Type of current test is %s', {}
TESTNODE LOG : 'UnitTest', {}
TESTNODE LOG : 'ProcessManager killPreviousRun, going to kill set([])', {}
TESTNODE LOG : 'ProcessManager killPreviousRun, exception when killing supervisor', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/bar', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clone /tmp/tmpuBQ9Ga/rep0 -b master /tmp/tmpuBQ9Ga/testnode/bar/rep0', {}
TESTNODE LOG : "git : Cloning into '/tmp/tmpuBQ9Ga/testnode/bar/rep0'...", {}
TESTNODE LOG : 'git : done.', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/bar/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/bar/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/bar/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/bar/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at ed6c0a5 next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/bar/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : ed6c0a5f2bff71a9712a1372ef0ac4001ebe8e81', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/bar/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/bar/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : ed6c0a5f2bff71a9712a1372ef0ac4001ebe8e81', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/bar', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clone /tmp/tmpuBQ9Ga/rep1 -b master /tmp/tmpuBQ9Ga/testnode/bar/rep1', {}
TESTNODE LOG : "git : Cloning into '/tmp/tmpuBQ9Ga/testnode/bar/rep1'...", {}
TESTNODE LOG : 'git : done.', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/bar/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/bar/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/bar/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/bar/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at bdc9eac next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/bar/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : bdc9eac0c6feea72b81e4c790cc172f5afabf0f5', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/bar/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/bar/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : bdc9eac0c6feea72b81e4c790cc172f5afabf0f5', {}
TESTNODE LOG : 'testnode, test_result : %r', {}
TESTNODE LOG : <TestResultProxy('/tmp/tmpuBQ9Ga/test/results/Foo-Test', 'Foo-Test-Node', 'rep0=2-ed6c0a5f2bff71a9712a1372ef0ac4001ebe8e81,rep1=2-bdc9eac0c6feea72b81e4c790cc172f5afabf0f5') at 7f33d1100c50>, {}
TESTNODE LOG : "going to switch to log '/tmp/tmpuBQ9Ga/var/log/testnode/bar-PBNVSP5jOz3oGYgm7ildGHXMIL9mHayK/suite.log'", {}
TESTNODE LOG : 'End of processing, going to sleep %s', {}
TESTNODE LOG : 119.8980188369751, {}
TESTNODE LOG : 'Testnode.cleanUp', {}
TESTNODE LOG : 'ProcessManager killPreviousRun, going to kill set([])', {}
TESTNODE LOG : 'ProcessManager killPreviousRun, exception when killing supervisor', {}
TESTNODE LOG : 'Got following test suite data from master : %r', {}
TESTNODE LOG : [{'project_title': 'foo', 'test_suite': 'Foo', 'vcs_repository_list': [{'url': '/tmp/tmpuBQ9Ga/rep0', 'profile_path': 'software.cfg', 'branch': 'master'}, {'url': '/tmp/tmpuBQ9Ga/rep1', 'buildout_section_id': 'rep1', 'branch': 'master'}], 'test_suite_title': 'Foo-Test', 'test_suite_reference': 'foo'}, {'project_title': 'qux', 'test_suite': 'Foo', 'vcs_repository_list': [{'url': '/tmp/tmpuBQ9Ga/rep0', 'profile_path': 'software.cfg', 'branch': 'master'}, {'url': '/tmp/tmpuBQ9Ga/rep1', 'buildout_section_id': 'rep1', 'branch': 'master'}], 'test_suite_title': 'Foo-Test', 'test_suite_reference': 'qux'}], {}
TESTNODE LOG : 'Type of current test is %s', {}
TESTNODE LOG : 'UnitTest', {}
TESTNODE LOG : "testnode.checkOldTestSuite, DELETING : '/tmp/tmpuBQ9Ga/testnode/bar'", {}
TESTNODE LOG : 'ProcessManager killPreviousRun, going to kill set([])', {}
TESTNODE LOG : 'ProcessManager killPreviousRun, exception when killing supervisor', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git config --get remote.origin.url', {}
TESTNODE LOG : 'git : /tmp/tmpuBQ9Ga/rep0', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at ed6c0a5 next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : ed6c0a5f2bff71a9712a1372ef0ac4001ebe8e81', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : ed6c0a5f2bff71a9712a1372ef0ac4001ebe8e81', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git config --get remote.origin.url', {}
TESTNODE LOG : 'git : /tmp/tmpuBQ9Ga/rep1', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at bdc9eac next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : bdc9eac0c6feea72b81e4c790cc172f5afabf0f5', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : bdc9eac0c6feea72b81e4c790cc172f5afabf0f5', {}
TESTNODE LOG : 'testnode, test_result : %r', {}
TESTNODE LOG : None, {}
TESTNODE LOG : 'Testnode.cleanUp', {}
TESTNODE LOG : 'ProcessManager killPreviousRun, going to kill set([])', {}
TESTNODE LOG : 'ProcessManager killPreviousRun, exception when killing supervisor', {}
TESTNODE LOG : 'ProcessManager killPreviousRun, going to kill set([])', {}
TESTNODE LOG : 'ProcessManager killPreviousRun, exception when killing supervisor', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/qux', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clone /tmp/tmpuBQ9Ga/rep0 -b master /tmp/tmpuBQ9Ga/testnode/qux/rep0', {}
TESTNODE LOG : "git : Cloning into '/tmp/tmpuBQ9Ga/testnode/qux/rep0'...", {}
TESTNODE LOG : 'git : done.', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/qux/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/qux/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/qux/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/qux/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at ed6c0a5 next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/qux/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : ed6c0a5f2bff71a9712a1372ef0ac4001ebe8e81', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/qux/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/qux/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : ed6c0a5f2bff71a9712a1372ef0ac4001ebe8e81', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/qux', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clone /tmp/tmpuBQ9Ga/rep1 -b master /tmp/tmpuBQ9Ga/testnode/qux/rep1', {}
TESTNODE LOG : "git : Cloning into '/tmp/tmpuBQ9Ga/testnode/qux/rep1'...", {}
TESTNODE LOG : 'git : done.', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/qux/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/qux/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/qux/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/qux/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at bdc9eac next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/qux/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : bdc9eac0c6feea72b81e4c790cc172f5afabf0f5', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/qux/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/qux/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : bdc9eac0c6feea72b81e4c790cc172f5afabf0f5', {}
TESTNODE LOG : 'testnode, test_result : %r', {}
TESTNODE LOG : <TestResultProxy('/tmp/tmpuBQ9Ga/test/results/Foo-Test', 'Foo-Test-Node', 'rep0=2-ed6c0a5f2bff71a9712a1372ef0ac4001ebe8e81,rep1=2-bdc9eac0c6feea72b81e4c790cc172f5afabf0f5') at 7f33d1100ed0>, {}
TESTNODE LOG : "going to switch to log '/tmp/tmpuBQ9Ga/var/log/testnode/qux-zVFt364uQPImggUWOJ7JaD89FBwvSAQX/suite.log'", {}
TESTNODE LOG : 'End of processing, going to sleep %s', {}
TESTNODE LOG : 119.79522204399109, {}
TESTNODE LOG : 'Testnode.cleanUp', {}
TESTNODE LOG : 'ProcessManager killPreviousRun, going to kill set([])', {}
TESTNODE LOG : 'ProcessManager killPreviousRun, exception when killing supervisor', {}
TESTNODE LOG : 'Got following test suite data from master : %r', {}
TESTNODE LOG : [{'project_title': 'foox', 'test_suite': 'Foo', 'vcs_repository_list': [{'url': '/tmp/tmpuBQ9Ga/rep0', 'profile_path': 'software.cfg', 'branch': 'master'}, {'url': '/tmp/tmpuBQ9Ga/rep1', 'buildout_section_id': 'rep1', 'branch': 'master'}], 'test_suite_title': 'Foo-Test', 'test_suite_reference': 'foox'}], {}
TESTNODE LOG : 'Type of current test is %s', {}
TESTNODE LOG : 'UnitTest', {}
TESTNODE LOG : "testnode.checkOldTestSuite, DELETING : '/tmp/tmpuBQ9Ga/testnode/qux'", {}
TESTNODE LOG : "testnode.checkOldTestSuite, DELETING : '/tmp/tmpuBQ9Ga/testnode/foo'", {}
TESTNODE LOG : 'ProcessManager killPreviousRun, going to kill set([])', {}
TESTNODE LOG : 'ProcessManager killPreviousRun, exception when killing supervisor', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foox', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clone /tmp/tmpuBQ9Ga/rep0 -b master /tmp/tmpuBQ9Ga/testnode/foox/rep0', {}
TESTNODE LOG : "git : Cloning into '/tmp/tmpuBQ9Ga/testnode/foox/rep0'...", {}
TESTNODE LOG : 'git : done.', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foox/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foox/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foox/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foox/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at ed6c0a5 next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foox/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : ed6c0a5f2bff71a9712a1372ef0ac4001ebe8e81', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foox/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foox/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : ed6c0a5f2bff71a9712a1372ef0ac4001ebe8e81', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foox', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clone /tmp/tmpuBQ9Ga/rep1 -b master /tmp/tmpuBQ9Ga/testnode/foox/rep1', {}
TESTNODE LOG : "git : Cloning into '/tmp/tmpuBQ9Ga/testnode/foox/rep1'...", {}
TESTNODE LOG : 'git : done.', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foox/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foox/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foox/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foox/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at bdc9eac next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foox/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : bdc9eac0c6feea72b81e4c790cc172f5afabf0f5', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foox/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/foox/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : bdc9eac0c6feea72b81e4c790cc172f5afabf0f5', {}
TESTNODE LOG : 'testnode, test_result : %r', {}
TESTNODE LOG : <TestResultProxy('/tmp/tmpuBQ9Ga/test/results/Foo-Test', 'Foo-Test-Node', 'rep0=2-ed6c0a5f2bff71a9712a1372ef0ac4001ebe8e81,rep1=2-bdc9eac0c6feea72b81e4c790cc172f5afabf0f5') at 7f33d11005d0>, {}
TESTNODE LOG : "going to switch to log '/tmp/tmpuBQ9Ga/var/log/testnode/foox-ewitL7B02SFRxiLJrJSaq2AodCC3kerg/suite.log'", {}
TESTNODE LOG : 'End of processing, going to sleep %s', {}
TESTNODE LOG : 119.88729095458984, {}
TESTNODE LOG : 'Testnode.cleanUp', {}
TESTNODE LOG : 'ProcessManager killPreviousRun, going to kill set([])', {}
TESTNODE LOG : 'ProcessManager killPreviousRun, exception when killing supervisor', {}
TESTNODE LOG : 'Got following test suite data from master : %r', {}
TESTNODE LOG : [{'project_title': 'bax', 'test_suite': 'Foo', 'vcs_repository_list': [{'url': '/tmp/tmpuBQ9Ga/rep0', 'profile_path': 'software.cfg', 'branch': 'master'}, {'url': '/tmp/tmpuBQ9Ga/rep1', 'buildout_section_id': 'rep1', 'branch': 'master'}], 'test_suite_title': 'Foo-Test', 'test_suite_reference': 'bax'}], {}
TESTNODE LOG : 'Type of current test is %s', {}
TESTNODE LOG : 'UnitTest', {}
TESTNODE LOG : "testnode.checkOldTestSuite, DELETING : '/tmp/tmpuBQ9Ga/testnode/foox'", {}
TESTNODE LOG : 'ProcessManager killPreviousRun, going to kill set([])', {}
TESTNODE LOG : 'ProcessManager killPreviousRun, exception when killing supervisor', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/bax', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clone /tmp/tmpuBQ9Ga/rep0 -b master /tmp/tmpuBQ9Ga/testnode/bax/rep0', {}
TESTNODE LOG : "git : Cloning into '/tmp/tmpuBQ9Ga/testnode/bax/rep0'...", {}
TESTNODE LOG : 'git : done.', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/bax/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/bax/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/bax/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/bax/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at ed6c0a5 next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/bax/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : ed6c0a5f2bff71a9712a1372ef0ac4001ebe8e81', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/bax/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/bax/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : ed6c0a5f2bff71a9712a1372ef0ac4001ebe8e81', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/bax', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clone /tmp/tmpuBQ9Ga/rep1 -b master /tmp/tmpuBQ9Ga/testnode/bax/rep1', {}
TESTNODE LOG : "git : Cloning into '/tmp/tmpuBQ9Ga/testnode/bax/rep1'...", {}
TESTNODE LOG : 'git : done.', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/bax/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/bax/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/bax/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/bax/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at bdc9eac next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/bax/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : bdc9eac0c6feea72b81e4c790cc172f5afabf0f5', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/bax/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpuBQ9Ga/testnode/bax/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : bdc9eac0c6feea72b81e4c790cc172f5afabf0f5', {}
TESTNODE LOG : 'testnode, test_result : %r', {}
TESTNODE LOG : <TestResultProxy('/tmp/tmpuBQ9Ga/test/results/Foo-Test', 'Foo-Test-Node', 'rep0=2-ed6c0a5f2bff71a9712a1372ef0ac4001ebe8e81,rep1=2-bdc9eac0c6feea72b81e4c790cc172f5afabf0f5') at 7f33d1100e90>, {}
TESTNODE LOG : "going to switch to log '/tmp/tmpuBQ9Ga/var/log/testnode/bax-uMsarkIp07mmhJffldNU4U42FHxadjux/suite.log'", {}
TESTNODE LOG : 'End of processing, going to sleep %s', {}
TESTNODE LOG : 119.88867402076721, {}
TESTNODE LOG : 'Testnode.cleanUp', {}
TESTNODE LOG : 'ProcessManager killPreviousRun, going to kill set([])', {}
TESTNODE LOG : 'ProcessManager killPreviousRun, exception when killing supervisor', {}
TESTNODE LOG : '', {'exc_info': 1}
TESTNODE LOG : 'GENERAL EXCEPTION, QUITING', {}
TESTNODE LOG : 'Testnode.cleanUp', {}
TESTNODE LOG : 'ProcessManager killPreviousRun, going to kill set([])', {}
TESTNODE LOG : 'ProcessManager killPreviousRun, exception when killing supervisor', {}
TESTNODE LOG : 'GENERAL EXCEPTION, QUITING, cleanup finished', {}
TESTNODE LOG : "subprocess_kw : {'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ sleep 0', {}
TESTNODE LOG : "subprocess_kw : {'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ sleep 3', {}
TESTNODE LOG : 'PROCESS TOO LONG OR DEAD, GOING TO BE TERMINATED', {}
TESTNODE LOG : 'killCommand, new_child_set : set([]), child_set: set([])', {}
TESTNODE LOG : 'killCommand, finishing, child_set : set([])', {}
TESTNODE LOG : "SlapOSControler : GOING TO RESET ALL SOFTWARE : '/tmp/tmptUVQdp/testnode/soft'", {}
TESTNODE LOG : 'Testnode.cleanUp', {}
TESTNODE LOG : 'ProcessManager killPreviousRun, going to kill set([])', {}
TESTNODE LOG : 'ProcessManager killPreviousRun, exception when killing supervisor', {}
TESTNODE LOG : 'Got following test suite data from master : %r', {}
TESTNODE LOG : [{'project_title': 'aa', 'test_suite': 'Foo', 'vcs_repository_list': [{'url': '/tmp/tmpCdOOYg/rep0', 'profile_path': 'software.cfg', 'branch': 'master'}, {'url': '/tmp/tmpCdOOYg/rep1', 'buildout_section_id': 'rep1', 'branch': 'master'}], 'test_suite_title': 'Foo-Test', 'test_suite_reference': 'aa'}, {'project_title': 'bb', 'test_suite': 'Foo', 'vcs_repository_list': [{'url': '/tmp/tmpCdOOYg/rep0', 'profile_path': 'software.cfg', 'branch': 'master'}, {'url': '/tmp/tmpCdOOYg/rep1', 'buildout_section_id': 'rep1', 'branch': 'master'}], 'test_suite_title': 'Foo-Test', 'test_suite_reference': 'bb'}], {}
TESTNODE LOG : 'Type of current test is %s', {}
TESTNODE LOG : 'UnitTest', {}
TESTNODE LOG : 'ProcessManager killPreviousRun, going to kill set([])', {}
TESTNODE LOG : 'ProcessManager killPreviousRun, exception when killing supervisor', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/aa', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clone /tmp/tmpCdOOYg/rep0 -b master /tmp/tmpCdOOYg/testnode/aa/rep0', {}
TESTNODE LOG : "git : Cloning into '/tmp/tmpCdOOYg/testnode/aa/rep0'...", {}
TESTNODE LOG : 'git : done.', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/aa/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/aa/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/aa/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/aa/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at ab4497d next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/aa/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : ab4497d5c081c8b846581abbf3ea70149472684c', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/aa/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-list --topo-order --count ab4497d5c081c8b846581abbf3ea70149472684c', {}
TESTNODE LOG : 'git : 2', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/aa/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/aa/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : ab4497d5c081c8b846581abbf3ea70149472684c', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/aa', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clone /tmp/tmpCdOOYg/rep1 -b master /tmp/tmpCdOOYg/testnode/aa/rep1', {}
TESTNODE LOG : "git : Cloning into '/tmp/tmpCdOOYg/testnode/aa/rep1'...", {}
TESTNODE LOG : 'git : done.', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/aa/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/aa/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/aa/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/aa/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at 21c3ceb next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/aa/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : 21c3ceb6c877050a64ddc6998e321789c02bbed0', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/aa/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-list --topo-order --count 21c3ceb6c877050a64ddc6998e321789c02bbed0', {}
TESTNODE LOG : 'git : 2', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/aa/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/aa/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : 21c3ceb6c877050a64ddc6998e321789c02bbed0', {}
TESTNODE LOG : 'testnode, test_result : %r', {}
TESTNODE LOG : <TestResultProxy('/tmp/tmpCdOOYg/test/results/Foo-Test', 'Foo-Test-Node', 'rep0=2-ab4497d5c081c8b846581abbf3ea70149472684c,rep1=2-21c3ceb6c877050a64ddc6998e321789c02bbed0') at 7f33d1150f10>, {}
TESTNODE LOG : "going to switch to log '/tmp/tmpCdOOYg/var/log/testnode/aa-OoUSOEz9ZHcFOZ4zzpfwroMH8aRHeNes/suite.log'", {}
TESTNODE LOG : 'End of processing, going to sleep %s', {}
TESTNODE LOG : 119.86374306678772, {}
TESTNODE LOG : 'Testnode.cleanUp', {}
TESTNODE LOG : 'ProcessManager killPreviousRun, going to kill set([])', {}
TESTNODE LOG : 'ProcessManager killPreviousRun, exception when killing supervisor', {}
TESTNODE LOG : 'Got following test suite data from master : %r', {}
TESTNODE LOG : [{'project_title': 'bb', 'test_suite': 'Foo', 'vcs_repository_list': [{'url': '/tmp/tmpCdOOYg/rep0', 'profile_path': 'software.cfg', 'branch': 'master'}, {'url': '/tmp/tmpCdOOYg/rep1', 'buildout_section_id': 'rep1', 'branch': 'master'}], 'test_suite_title': 'Foo-Test', 'test_suite_reference': 'bb'}, {'project_title': 'aa', 'test_suite': 'Foo', 'vcs_repository_list': [{'url': '/tmp/tmpCdOOYg/rep0', 'profile_path': 'software.cfg', 'branch': 'master'}, {'url': '/tmp/tmpCdOOYg/rep1', 'buildout_section_id': 'rep1', 'branch': 'master'}], 'test_suite_title': 'Foo-Test', 'test_suite_reference': 'aa'}], {}
TESTNODE LOG : 'Type of current test is %s', {}
TESTNODE LOG : 'UnitTest', {}
TESTNODE LOG : 'ProcessManager killPreviousRun, going to kill set([])', {}
TESTNODE LOG : 'ProcessManager killPreviousRun, exception when killing supervisor', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/bb', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clone /tmp/tmpCdOOYg/rep0 -b master /tmp/tmpCdOOYg/testnode/bb/rep0', {}
TESTNODE LOG : "git : Cloning into '/tmp/tmpCdOOYg/testnode/bb/rep0'...", {}
TESTNODE LOG : 'git : done.', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/bb/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/bb/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/bb/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/bb/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at ab4497d next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/bb/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : ab4497d5c081c8b846581abbf3ea70149472684c', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/bb/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/bb/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : ab4497d5c081c8b846581abbf3ea70149472684c', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/bb', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clone /tmp/tmpCdOOYg/rep1 -b master /tmp/tmpCdOOYg/testnode/bb/rep1', {}
TESTNODE LOG : "git : Cloning into '/tmp/tmpCdOOYg/testnode/bb/rep1'...", {}
TESTNODE LOG : 'git : done.', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/bb/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/bb/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/bb/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/bb/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at 21c3ceb next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/bb/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : 21c3ceb6c877050a64ddc6998e321789c02bbed0', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/bb/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/bb/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : 21c3ceb6c877050a64ddc6998e321789c02bbed0', {}
TESTNODE LOG : 'testnode, test_result : %r', {}
TESTNODE LOG : <TestResultProxy('/tmp/tmpCdOOYg/test/results/Foo-Test', 'Foo-Test-Node', 'rep0=2-ab4497d5c081c8b846581abbf3ea70149472684c,rep1=2-21c3ceb6c877050a64ddc6998e321789c02bbed0') at 7f33d11565d0>, {}
TESTNODE LOG : "going to switch to log '/tmp/tmpCdOOYg/var/log/testnode/bb-RSd8FBo2nzC5JAbSHKioBZdMDU7M7aql/suite.log'", {}
TESTNODE LOG : 'End of processing, going to sleep %s', {}
TESTNODE LOG : 119.88022208213806, {}
TESTNODE LOG : 'Testnode.cleanUp', {}
TESTNODE LOG : 'ProcessManager killPreviousRun, going to kill set([])', {}
TESTNODE LOG : 'ProcessManager killPreviousRun, exception when killing supervisor', {}
TESTNODE LOG : 'Got following test suite data from master : %r', {}
TESTNODE LOG : [{'project_title': 'bb', 'test_suite': 'Foo', 'vcs_repository_list': [{'url': '/tmp/tmpCdOOYg/rep0', 'profile_path': 'software.cfg', 'branch': 'master'}, {'url': '/tmp/tmpCdOOYg/rep1', 'buildout_section_id': 'rep1', 'branch': 'master'}], 'test_suite_title': 'Foo-Test', 'test_suite_reference': 'bb'}, {'project_title': 'aa', 'test_suite': 'Foo', 'vcs_repository_list': [{'url': '/tmp/tmpCdOOYg/rep0', 'profile_path': 'software.cfg', 'branch': 'master'}, {'url': '/tmp/tmpCdOOYg/rep1', 'buildout_section_id': 'rep1', 'branch': 'master'}], 'test_suite_title': 'Foo-Test', 'test_suite_reference': 'aa'}], {}
TESTNODE LOG : 'Type of current test is %s', {}
TESTNODE LOG : 'UnitTest', {}
TESTNODE LOG : 'ProcessManager killPreviousRun, going to kill set([])', {}
TESTNODE LOG : 'ProcessManager killPreviousRun, exception when killing supervisor', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/bb/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git config --get remote.origin.url', {}
TESTNODE LOG : 'git : /tmp/tmpCdOOYg/rep0', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/bb/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/bb/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/bb/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/bb/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at ab4497d next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/bb/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : ab4497d5c081c8b846581abbf3ea70149472684c', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/bb/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/bb/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : ab4497d5c081c8b846581abbf3ea70149472684c', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/bb/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git config --get remote.origin.url', {}
TESTNODE LOG : 'git : /tmp/tmpCdOOYg/rep1', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/bb/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/bb/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/bb/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/bb/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at 21c3ceb next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/bb/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : 21c3ceb6c877050a64ddc6998e321789c02bbed0', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/bb/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpCdOOYg/testnode/bb/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : 21c3ceb6c877050a64ddc6998e321789c02bbed0', {}
TESTNODE LOG : 'testnode, test_result : %r', {}
TESTNODE LOG : <TestResultProxy('/tmp/tmpCdOOYg/test/results/Foo-Test', 'Foo-Test-Node', 'rep0=2-ab4497d5c081c8b846581abbf3ea70149472684c,rep1=2-21c3ceb6c877050a64ddc6998e321789c02bbed0') at 7f33d1156710>, {}
TESTNODE LOG : "going to switch to log '/tmp/tmpCdOOYg/var/log/testnode/bb-Br7ximOl33HX3khNbA90GXeab4yOoaAb/suite.log'", {}
TESTNODE LOG : 'End of processing, going to sleep %s', {}
TESTNODE LOG : 119.90450406074524, {}
TESTNODE LOG : 'Testnode.cleanUp', {}
TESTNODE LOG : 'ProcessManager killPreviousRun, going to kill set([])', {}
TESTNODE LOG : 'ProcessManager killPreviousRun, exception when killing supervisor', {}
TESTNODE LOG : '', {'exc_info': 1}
TESTNODE LOG : 'GENERAL EXCEPTION, QUITING', {}
TESTNODE LOG : 'Testnode.cleanUp', {}
TESTNODE LOG : 'ProcessManager killPreviousRun, going to kill set([])', {}
TESTNODE LOG : 'ProcessManager killPreviousRun, exception when killing supervisor', {}
TESTNODE LOG : 'GENERAL EXCEPTION, QUITING, cleanup finished', {}
TESTNODE LOG : "deleting log directory '/tmp/tmpWTjlgx/var/log/testnode/ab-llzje'", {}
TESTNODE LOG : "deleting temp directory '/tmp/tmpjstOof/tmp/buildoutA'", {}
TESTNODE LOG : "deleting temp directory '/tmp/tmpjstOof/tmp/tmpC'", {}
TESTNODE LOG : "Configured slapproxy log to '/tmp/tmpvB3fcQ/var/log/testnode/slapproxy.log'", {}
TESTNODE LOG : 'testnode, retry_software_count : 0', {}
TESTNODE LOG : 'Before status_dict = slapos_method(...)', {}
TESTNODE LOG : {'status_code': 1}, {}
TESTNODE LOG : 'After status_dict = slapos_method(...)', {}
TESTNODE LOG : "Configured slapproxy log to '/tmp/tmpvB3fcQ/var/log/testnode/slapproxy.log'", {}
TESTNODE LOG : 'testnode, retry_software_count : 1', {}
TESTNODE LOG : 'Before status_dict = slapos_method(...)', {}
TESTNODE LOG : {'status_code': 1}, {}
TESTNODE LOG : 'After status_dict = slapos_method(...)', {}
TESTNODE LOG : "Configured slapproxy log to '/tmp/tmpvB3fcQ/var/log/testnode/slapproxy.log'", {}
TESTNODE LOG : 'testnode, retry_software_count : 2', {}
TESTNODE LOG : 'Before status_dict = slapos_method(...)', {}
TESTNODE LOG : {'status_code': 1}, {}
TESTNODE LOG : 'After status_dict = slapos_method(...)', {}
TESTNODE LOG : "Configured slapproxy log to '/tmp/tmpvB3fcQ/var/log/testnode/slapproxy.log'", {}
TESTNODE LOG : 'testnode, retry_software_count : 3', {}
TESTNODE LOG : 'Before status_dict = slapos_method(...)', {}
TESTNODE LOG : {'status_code': 1}, {}
TESTNODE LOG : 'After status_dict = slapos_method(...)', {}
TESTNODE LOG : "Configured slapproxy log to '/tmp/tmpvB3fcQ/var/log/testnode/slapproxy.log'", {}
TESTNODE LOG : 'testnode, retry_software_count : 4', {}
TESTNODE LOG : 'Before status_dict = slapos_method(...)', {}
TESTNODE LOG : {'status_code': 1}, {}
TESTNODE LOG : 'After status_dict = slapos_method(...)', {}
TESTNODE LOG : "Configured slapproxy log to '/tmp/tmpvB3fcQ/var/log/testnode/slapproxy.log'", {}
TESTNODE LOG : 'testnode, retry_software_count : 5', {}
TESTNODE LOG : 'Before status_dict = slapos_method(...)', {}
TESTNODE LOG : {'status_code': 1}, {}
TESTNODE LOG : 'After status_dict = slapos_method(...)', {}
TESTNODE LOG : "Configured slapproxy log to '/tmp/tmpvB3fcQ/var/log/testnode/slapproxy.log'", {}
TESTNODE LOG : 'testnode, retry_software_count : 6', {}
TESTNODE LOG : 'Before status_dict = slapos_method(...)', {}
TESTNODE LOG : {'status_code': 1}, {}
TESTNODE LOG : 'After status_dict = slapos_method(...)', {}
TESTNODE LOG : "Configured slapproxy log to '/tmp/tmpvB3fcQ/var/log/testnode/slapproxy.log'", {}
TESTNODE LOG : 'testnode, retry_software_count : 7', {}
TESTNODE LOG : 'Before status_dict = slapos_method(...)', {}
TESTNODE LOG : {'status_code': 1}, {}
TESTNODE LOG : 'After status_dict = slapos_method(...)', {}
TESTNODE LOG : "Configured slapproxy log to '/tmp/tmpvB3fcQ/var/log/testnode/slapproxy.log'", {}
TESTNODE LOG : 'testnode, retry_software_count : 8', {}
TESTNODE LOG : 'Before status_dict = slapos_method(...)', {}
TESTNODE LOG : {'status_code': 1}, {}
TESTNODE LOG : 'After status_dict = slapos_method(...)', {}
TESTNODE LOG : "Configured slapproxy log to '/tmp/tmpvB3fcQ/var/log/testnode/slapproxy.log'", {}
TESTNODE LOG : 'testnode, retry_software_count : 9', {}
TESTNODE LOG : 'Before status_dict = slapos_method(...)', {}
TESTNODE LOG : {'status_code': 1}, {}
TESTNODE LOG : 'After status_dict = slapos_method(...)', {}
TESTNODE LOG : "Configured slapproxy log to '/tmp/tmpvB3fcQ/var/log/testnode/slapproxy.log'", {}
TESTNODE LOG : 'testnode, retry_software_count : 10', {}
TESTNODE LOG : 'Before status_dict = slapos_method(...)', {}
TESTNODE LOG : {'status_code': 1}, {}
TESTNODE LOG : 'After status_dict = slapos_method(...)', {}
TESTNODE LOG : "Configured slapproxy log to '/tmp/tmpvB3fcQ/var/log/testnode/slapproxy.log'", {}
TESTNODE LOG : 'testnode, retry_software_count : 0', {}
TESTNODE LOG : 'Before status_dict = slapos_method(...)', {}
TESTNODE LOG : {'status_code': 1}, {}
TESTNODE LOG : 'After status_dict = slapos_method(...)', {}
TESTNODE LOG : "Configured slapproxy log to '/tmp/tmpvB3fcQ/var/log/testnode/slapproxy.log'", {}
TESTNODE LOG : 'testnode, retry_software_count : 1', {}
TESTNODE LOG : 'Before status_dict = slapos_method(...)', {}
TESTNODE LOG : {'status_code': 1}, {}
TESTNODE LOG : 'After status_dict = slapos_method(...)', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clone /tmp/tmpDlUiUb/rep2 -b foo /tmp/tmpDlUiUb/testnode/foo/rep2', {}
TESTNODE LOG : "git : Cloning into '/tmp/tmpDlUiUb/testnode/foo/rep2'...", {}
TESTNODE LOG : 'git : done.', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * foo', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at 43d2d25 next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : 43d2d2545fd2710cae4e306edd92eab05c8249b7', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-list --topo-order --count 43d2d2545fd2710cae4e306edd92eab05c8249b7', {}
TESTNODE LOG : 'git : 2', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : 43d2d2545fd2710cae4e306edd92eab05c8249b7', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clone /tmp/tmpDlUiUb/rep0 -b master /tmp/tmpDlUiUb/testnode/foo/rep0', {}
TESTNODE LOG : "git : Cloning into '/tmp/tmpDlUiUb/testnode/foo/rep0'...", {}
TESTNODE LOG : 'git : done.', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at ab4497d next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : ab4497d5c081c8b846581abbf3ea70149472684c', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : ab4497d5c081c8b846581abbf3ea70149472684c', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clone /tmp/tmpDlUiUb/rep1 -b master /tmp/tmpDlUiUb/testnode/foo/rep1', {}
TESTNODE LOG : "git : Cloning into '/tmp/tmpDlUiUb/testnode/foo/rep1'...", {}
TESTNODE LOG : 'git : done.', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at 21c3ceb next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : 21c3ceb6c877050a64ddc6998e321789c02bbed0', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : 21c3ceb6c877050a64ddc6998e321789c02bbed0', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git config --get remote.origin.url', {}
TESTNODE LOG : 'git : /tmp/tmpDlUiUb/rep2', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * foo', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * foo', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git checkout origin/master -b master', {}
TESTNODE LOG : "git : Switched to a new branch 'master'", {}
TESTNODE LOG : 'git : Branch master set up to track remote branch master from origin.', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at 43d2d25 next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : 43d2d2545fd2710cae4e306edd92eab05c8249b7', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : 43d2d2545fd2710cae4e306edd92eab05c8249b7', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git config --get remote.origin.url', {}
TESTNODE LOG : 'git : /tmp/tmpDlUiUb/rep0', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at ab4497d next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : ab4497d5c081c8b846581abbf3ea70149472684c', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : ab4497d5c081c8b846581abbf3ea70149472684c', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git config --get remote.origin.url', {}
TESTNODE LOG : 'git : /tmp/tmpDlUiUb/rep1', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at 21c3ceb next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : 21c3ceb6c877050a64ddc6998e321789c02bbed0', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : 21c3ceb6c877050a64ddc6998e321789c02bbed0', {}
foo
* master
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git config --get remote.origin.url', {}
TESTNODE LOG : 'git : /tmp/tmpDlUiUb/rep2', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : 'git : From /tmp/tmpDlUiUb/rep2', {}
TESTNODE LOG : 'git : * [new branch] bar -> origin/bar', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : foo', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : foo', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git checkout origin/bar -b bar', {}
TESTNODE LOG : "git : Switched to a new branch 'bar'", {}
TESTNODE LOG : 'git : Branch bar set up to track remote branch bar from origin.', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at 43d2d25 next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : 43d2d2545fd2710cae4e306edd92eab05c8249b7', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep2', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : 43d2d2545fd2710cae4e306edd92eab05c8249b7', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git config --get remote.origin.url', {}
TESTNODE LOG : 'git : /tmp/tmpDlUiUb/rep0', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at ab4497d next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : ab4497d5c081c8b846581abbf3ea70149472684c', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep0', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : ab4497d5c081c8b846581abbf3ea70149472684c', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git config --get remote.origin.url', {}
TESTNODE LOG : 'git : /tmp/tmpDlUiUb/rep1', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git clean -fdx', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git fetch --all --prune', {}
TESTNODE LOG : 'git : Fetching origin', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git branch', {}
TESTNODE LOG : 'git : * master', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : "$ git reset --hard '@{u}'", {}
TESTNODE LOG : 'git : HEAD is now at 21c3ceb next_commit', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git rev-parse HEAD', {}
TESTNODE LOG : 'git : 21c3ceb6c877050a64ddc6998e321789c02bbed0', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git update-server-info -f', {}
TESTNODE LOG : "subprocess_kw : {'cwd': '/tmp/tmpDlUiUb/testnode/foo/rep1', 'preexec_fn': <built-in function setsid>}", {}
TESTNODE LOG : '$ git log -1 --format=%H -- .', {}
TESTNODE LOG : 'git : 21c3ceb6c877050a64ddc6998e321789c02bbed0', {}
TESTNODE LOG : 'Testnode.cleanUp', {}
TESTNODE LOG : 'ProcessManager killPreviousRun, going to kill set([])', {}
TESTNODE LOG : 'ProcessManager killPreviousRun, exception when killing supervisor', {}
TESTNODE LOG : 'Got following test suite data from master : %r', {}
TESTNODE LOG : [{'project_title': 'foo', 'test_suite': 'Foo', 'vcs_repository_list': [{'url': '/tmp/tmpIHLyLt/rep0', 'profile_path': 'software.cfg', 'branch': 'master'}, {'url': '/tmp/tmpIHLyLt/rep1', 'buildout_section_id': 'rep1', 'branch': 'master'}], 'test_suite_title': 'Foo-Test', 'test_suite_reference': 'foo'}, {'project_title': 'bar', 'test_suite': 'Foo', 'vcs_repository_list': [{'url': '/tmp/tmpIHLyLt/rep0', 'profile_path': 'software.cfg', 'branch': 'master'}, {'url': '/tmp/tmpIHLyLt/rep1', 'buildout_section_id': 'rep1', 'branch': 'master'}], 'test_suite_title': 'Foo-Test', 'test_suite_reference': 'bar'}], {}
TESTNODE LOG : 'SlapOS Master url is: http://Foo', {}
TESTNODE LOG : 'SlapOS Master hateoas url is: http://Foo', {}
TESTNODE LOG : 'Type of current test is %s', {}
TESTNODE LOG : 'ScalabilityTest', {}
TESTNODE LOG : '', {'exc_info': 1}
TESTNODE LOG : 'GENERAL EXCEPTION, QUITING', {}
TESTNODE LOG : 'Testnode.cleanUp', {}
TESTNODE LOG : 'ProcessManager killPreviousRun, going to kill set([])', {}
TESTNODE LOG : 'ProcessManager killPreviousRun, exception when killing supervisor', {}
TESTNODE LOG : 'GENERAL EXCEPTION, QUITING, cleanup finished', {}
test_01_getDelNodeTestSuite (erp5.tests.testERP5TestNode.ERP5TestNode) ... ok
test_02_NodeTestSuiteWorkingDirectory (erp5.tests.testERP5TestNode.ERP5TestNode) ... ok
test_03_NodeTestSuiteCheckDataAfterEdit (erp5.tests.testERP5TestNode.ERP5TestNode) ... ok
test_04_constructProfile (erp5.tests.testERP5TestNode.ERP5TestNode) ... ok
test_05_updateRevisionList (erp5.tests.testERP5TestNode.ERP5TestNode) ... ok
test_05b_changeRepositoryBranch (erp5.tests.testERP5TestNode.ERP5TestNode) ... Switched to a new branch 'foo'
Switched to a new branch 'bar'
ok
test_05c_changeRepositoryUrl (erp5.tests.testERP5TestNode.ERP5TestNode) ... Switched to a new branch 'foo'
ok
test_05d_LocalModificationOnRepository (erp5.tests.testERP5TestNode.ERP5TestNode) ... Switched to a new branch 'foo'
ok
test_05e_IgnoringIncorrectRepository (erp5.tests.testERP5TestNode.ERP5TestNode) ... ok
test_06_checkRevision (erp5.tests.testERP5TestNode.ERP5TestNode) ... ok
test_07_checkExistingTestSuite (erp5.tests.testERP5TestNode.ERP5TestNode) ... ok
test_09_runTestSuite (erp5.tests.testERP5TestNode.ERP5TestNode) ... ok
test_10_prepareSlapOS (erp5.tests.testERP5TestNode.ERP5TestNode) ... ok
test_11_run (erp5.tests.testERP5TestNode.ERP5TestNode) ... 2017-08-11 18:43:12,523 testsuite : INFO Activated logfile '/tmp/tmpuBQ9Ga/var/log/testnode/foo-JCT6rTsfPw8mHhp7boKeP70wYKyDf61g/suite.log' output
2017-08-11 18:43:12,524 testsuite : INFO Testnode.cleanUp
2017-08-11 18:43:12,524 testsuite : INFO ProcessManager killPreviousRun, going to kill set([])
2017-08-11 18:43:12,524 testsuite : INFO ProcessManager killPreviousRun, exception when killing supervisor
2017-08-11 18:43:12,626 testsuite : INFO Activated logfile '/tmp/tmpuBQ9Ga/var/log/testnode/bar-PBNVSP5jOz3oGYgm7ildGHXMIL9mHayK/suite.log' output
2017-08-11 18:43:12,626 testsuite : INFO Testnode.cleanUp
2017-08-11 18:43:12,627 testsuite : INFO ProcessManager killPreviousRun, going to kill set([])
2017-08-11 18:43:12,627 testsuite : INFO ProcessManager killPreviousRun, exception when killing supervisor
2017-08-11 18:43:12,831 testsuite : INFO Activated logfile '/tmp/tmpuBQ9Ga/var/log/testnode/qux-zVFt364uQPImggUWOJ7JaD89FBwvSAQX/suite.log' output
2017-08-11 18:43:12,832 testsuite : INFO Testnode.cleanUp
2017-08-11 18:43:12,832 testsuite : INFO ProcessManager killPreviousRun, going to kill set([])
2017-08-11 18:43:12,832 testsuite : INFO ProcessManager killPreviousRun, exception when killing supervisor
2017-08-11 18:43:12,945 testsuite : INFO Activated logfile '/tmp/tmpuBQ9Ga/var/log/testnode/foox-ewitL7B02SFRxiLJrJSaq2AodCC3kerg/suite.log' output
2017-08-11 18:43:12,945 testsuite : INFO Testnode.cleanUp
2017-08-11 18:43:12,945 testsuite : INFO ProcessManager killPreviousRun, going to kill set([])
2017-08-11 18:43:12,945 testsuite : INFO ProcessManager killPreviousRun, exception when killing supervisor
2017-08-11 18:43:13,057 testsuite : INFO Activated logfile '/tmp/tmpuBQ9Ga/var/log/testnode/bax-uMsarkIp07mmhJffldNU4U42FHxadjux/suite.log' output
2017-08-11 18:43:13,057 testsuite : INFO Testnode.cleanUp
2017-08-11 18:43:13,057 testsuite : INFO ProcessManager killPreviousRun, going to kill set([])
2017-08-11 18:43:13,057 testsuite : INFO ProcessManager killPreviousRun, exception when killing supervisor
ok
test_12_spawn (erp5.tests.testERP5TestNode.ERP5TestNode) ... Exception in thread Thread-958:
Traceback (most recent call last):
File "/srv/slapgrid/slappart9/srv/testnode/ij/soft/583e83d92301a82e525cd27480a95e23/parts/python2.7/lib/python2.7/threading.py", line 801, in __bootstrap_inner
self.run()
File "/srv/slapgrid/slappart9/srv/testnode/ij/soft/583e83d92301a82e525cd27480a95e23/parts/python2.7/lib/python2.7/threading.py", line 1073, in run
self.function(*self.args, **self.kwargs)
File "/srv/slapgrid/slappart9/srv/testnode/ij/inst/test0-0/parts/erp5-util/erp5/util/testnode/ProcessManager.py", line 157, in timeoutExpired
raise SubprocessError('Dead or too long process killed')
SubprocessError: <unprintable SubprocessError object>

ok
test_13_SlaposControlerResetSoftware (erp5.tests.testERP5TestNode.ERP5TestNode) ... ok
test_14_createFolder (erp5.tests.testERP5TestNode.ERP5TestNode) ... ok
test_15_suite_log_directory (erp5.tests.testERP5TestNode.ERP5TestNode) ... 2017-08-11 18:43:15,349 testsuite : INFO Activated logfile '/tmp/tmpCdOOYg/var/log/testnode/aa-OoUSOEz9ZHcFOZ4zzpfwroMH8aRHeNes/suite.log' output
2017-08-11 18:43:15,349 testsuite : INFO Testnode.cleanUp
2017-08-11 18:43:15,349 testsuite : INFO ProcessManager killPreviousRun, going to kill set([])
2017-08-11 18:43:15,349 testsuite : INFO ProcessManager killPreviousRun, exception when killing supervisor
2017-08-11 18:43:15,469 testsuite : INFO Activated logfile '/tmp/tmpCdOOYg/var/log/testnode/bb-RSd8FBo2nzC5JAbSHKioBZdMDU7M7aql/suite.log' output
2017-08-11 18:43:15,470 testsuite : INFO Testnode.cleanUp
2017-08-11 18:43:15,470 testsuite : INFO ProcessManager killPreviousRun, going to kill set([])
2017-08-11 18:43:15,470 testsuite : INFO ProcessManager killPreviousRun, exception when killing supervisor
2017-08-11 18:43:15,565 testsuite : INFO Activated logfile '/tmp/tmpCdOOYg/var/log/testnode/bb-Br7ximOl33HX3khNbA90GXeab4yOoaAb/suite.log' output
2017-08-11 18:43:15,566 testsuite : INFO Testnode.cleanUp
2017-08-11 18:43:15,566 testsuite : INFO ProcessManager killPreviousRun, going to kill set([])
2017-08-11 18:43:15,566 testsuite : INFO ProcessManager killPreviousRun, exception when killing supervisor
ok
test_16_cleanupLogDirectory (erp5.tests.testERP5TestNode.ERP5TestNode) ... ok
test_17_cleanupTempDirectory (erp5.tests.testERP5TestNode.ERP5TestNode) ... ok
test_18_resetSoftwareAfterManyBuildFailures (erp5.tests.testERP5TestNode.ERP5TestNode) ... ok
test_scalability_04_constructProfile (erp5.tests.testERP5TestNode.ERP5TestNode) ... ok
test_scalability_05b_changeRepositoryBranch (erp5.tests.testERP5TestNode.ERP5TestNode) ... Switched to a new branch 'foo'
Switched to a new branch 'bar'
ok
test_scalability_09_runTestSuite (erp5.tests.testERP5TestNode.ERP5TestNode) ... ok
test_scalability_10_prepareSlapOS (erp5.tests.testERP5TestNode.ERP5TestNode) ... ok
test_scalability_18_resetSoftwareAfterManyBuildFailures (erp5.tests.testERP5TestNode.ERP5TestNode) ... ok
test_scalability_as_master_11_run (erp5.tests.testERP5TestNode.ERP5TestNode) ... skipped 'Not implemented'
test_scalability_as_master_15_suite_log_directory (erp5.tests.testERP5TestNode.ERP5TestNode) ... skipped 'Not implemented'
test_scalability_as_slave_11_run (erp5.tests.testERP5TestNode.ERP5TestNode) ... skipped 'Not implemented'
test_scalability_as_slave_15_suite_log_directory (erp5.tests.testERP5TestNode.ERP5TestNode) ... skipped 'Not implemented'
test_zzzz_scalability_19_xxxx (erp5.tests.testERP5TestNode.ERP5TestNode) ... ok

----------------------------------------------------------------------
Ran 31 tests in 6.217s

OK (skipped=4)