builder: mozilla-central_win8_64_test-dromaeojs-pgo slave: t-w864-ix-162 starttime: 1477544342.13 results: success (0) buildid: 20161026193001 builduid: 496b3b7034114f5d950a3311824d3c2a revision: 3f4c3a3cabaf94958834d3a8935adfb4a887942d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 21:59:02.127598) ========= master: http://buildbot-master119.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 21:59:02.128074) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 21:59:02.128378) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 21:59:02.288749) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-26 21:59:02.289192) ========= 'bash' '-c' 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir C:\slave\test\. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-162\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files COMMONPROGRAMW6432=C:\Program Files\Common Files COMPUTERNAME=T-W864-IX-162 COMSPEC=C:\windows\system32\cmd.exe DCLOCATION=SCL3 DNSSUFFIX=wintest.releng.scl3.mozilla.com FP_NO_HOST_CHECK=NO HOMEDRIVE=C: HOMEPATH=\Users\cltbld.T-W864-IX-162 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-162\AppData\Local LOGONSERVER=\\T-W864-IX-162 MONDIR=C:\Monitor_config\ MOZBUILDDIR=C:\mozilla-build\ MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 NUMBER_OF_PROCESSORS=8 OS=Windows_NT OURDRIVE=C: PATH=C:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;C:\mozilla-build\hg PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_ARCHITEW6432=AMD64 PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=C:\Program Files (x86) PROGRAMFILES(X86)=C:\Program Files (x86) PROGRAMW6432=C:\Program Files PROMPT=$P$G PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\ PUBLIC=C:\Users\Public PWD=C:\slave\test RUNLOGFILE=C:\slave\\runslave.log SLAVEDIR=C:\slave\ SYSTEMDRIVE=C: SYSTEMROOT=C:\windows TEMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp TEST1=testie TMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp USERDOMAIN=T-W864-IX-162 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-162 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-162 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False --21:59:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py => `archiver_client.py' Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. WARNING: Certificate verification error for hg.mozilla.org: certificate signature failure HTTP request sent, awaiting response... 200 Script output follows Length: 12,179 (12K) [text/x-python] 0K .......... . 100% 8.86 MB/s 21:59:03 (8.86 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=1.707000 ========= master_lag: 0.58 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-26 21:59:04.579563) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-10-26 21:59:04.579923) ========= 'rm' '-rf' 'scripts' 'properties' in dir C:\slave\test\. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-162\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files COMMONPROGRAMW6432=C:\Program Files\Common Files COMPUTERNAME=T-W864-IX-162 COMSPEC=C:\windows\system32\cmd.exe DCLOCATION=SCL3 DNSSUFFIX=wintest.releng.scl3.mozilla.com FP_NO_HOST_CHECK=NO HOMEDRIVE=C: HOMEPATH=\Users\cltbld.T-W864-IX-162 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-162\AppData\Local LOGONSERVER=\\T-W864-IX-162 MONDIR=C:\Monitor_config\ MOZBUILDDIR=C:\mozilla-build\ MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 NUMBER_OF_PROCESSORS=8 OS=Windows_NT OURDRIVE=C: PATH=C:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;C:\mozilla-build\hg PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_ARCHITEW6432=AMD64 PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=C:\Program Files (x86) PROGRAMFILES(X86)=C:\Program Files (x86) PROGRAMW6432=C:\Program Files PROMPT=$P$G PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\ PUBLIC=C:\Users\Public PWD=C:\slave\test RUNLOGFILE=C:\slave\\runslave.log SLAVEDIR=C:\slave\ SYSTEMDRIVE=C: SYSTEMROOT=C:\windows TEMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp TEST1=testie TMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp USERDOMAIN=T-W864-IX-162 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-162 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-162 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=3.313000 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-10-26 21:59:07.917223) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-26 21:59:07.917692) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo mozilla-central --rev 3f4c3a3cabaf94958834d3a8935adfb4a887942d --destination scripts --debug' in dir C:\slave\test\. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 3f4c3a3cabaf94958834d3a8935adfb4a887942d --destination scripts --debug'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-162\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files COMMONPROGRAMW6432=C:\Program Files\Common Files COMPUTERNAME=T-W864-IX-162 COMSPEC=C:\windows\system32\cmd.exe DCLOCATION=SCL3 DNSSUFFIX=wintest.releng.scl3.mozilla.com FP_NO_HOST_CHECK=NO HOMEDRIVE=C: HOMEPATH=\Users\cltbld.T-W864-IX-162 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-162\AppData\Local LOGONSERVER=\\T-W864-IX-162 MONDIR=C:\Monitor_config\ MOZBUILDDIR=C:\mozilla-build\ MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 NUMBER_OF_PROCESSORS=8 OS=Windows_NT OURDRIVE=C: PATH=C:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;C:\mozilla-build\hg PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_ARCHITEW6432=AMD64 PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=C:\Program Files (x86) PROGRAMFILES(X86)=C:\Program Files (x86) PROGRAMW6432=C:\Program Files PROMPT=$P$G PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\ PUBLIC=C:\Users\Public PWD=C:\slave\test RUNLOGFILE=C:\slave\\runslave.log SLAVEDIR=C:\slave\ SYSTEMDRIVE=C: SYSTEMROOT=C:\windows TEMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp TEST1=testie TMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp USERDOMAIN=T-W864-IX-162 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-162 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-162 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 2016-10-26 21:59:08,269 truncating revision to first 12 chars 2016-10-26 21:59:08,269 Setting DEBUG logging. 2016-10-26 21:59:08,269 attempt 1/10 2016-10-26 21:59:08,269 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3f4c3a3cabaf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-26 21:59:08,703 unpacking tar archive at: mozilla-central-3f4c3a3cabaf/testing/mozharness/ 2016-10-26 21:59:08,808 skipping symlink on windows: configs/single_locale/linux32.py program finished with exit code 0 elapsedTime=1.170000 ========= master_lag: 0.16 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-26 21:59:09.246800) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 21:59:09.247121) ========= script_repo_revision: 3f4c3a3cabaf94958834d3a8935adfb4a887942d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 21:59:09.247549) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 21:59:09.247857) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 21:59:09.949426) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 24 secs) (at 2016-10-26 21:59:09.949758) ========= 'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'dromaeojs' '--add-option' '--webServer,localhost' '--branch-name' 'Firefox' '--cfg' 'talos/windows_config.py' '--download-symbols' 'ondemand' '--use-talos-json' '--blob-upload-branch' 'Firefox' in dir C:\slave\test\. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['c:/mozilla-build/python27/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/windows_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-162\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files COMMONPROGRAMW6432=C:\Program Files\Common Files COMPUTERNAME=T-W864-IX-162 COMSPEC=C:\windows\system32\cmd.exe DCLOCATION=SCL3 DNSSUFFIX=wintest.releng.scl3.mozilla.com FP_NO_HOST_CHECK=NO HOMEDRIVE=C: HOMEPATH=\Users\cltbld.T-W864-IX-162 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-162\AppData\Local LOGONSERVER=\\T-W864-IX-162 MONDIR=C:\Monitor_config\ MOZBUILDDIR=C:\mozilla-build\ MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 NUMBER_OF_PROCESSORS=8 OS=Windows_NT OURDRIVE=C: PATH=C:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;C:\mozilla-build\hg PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_ARCHITEW6432=AMD64 PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=C:\Program Files (x86) PROGRAMFILES(X86)=C:\Program Files (x86) PROGRAMW6432=C:\Program Files PROMPT=$P$G PROPERTIES_FILE=C:\slave\test/buildprops.json PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\ PUBLIC=C:\Users\Public PWD=C:\slave\test RUNLOGFILE=C:\slave\\runslave.log SLAVEDIR=C:\slave\ SYSTEMDRIVE=C: SYSTEMROOT=C:\windows TEMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp TEST1=testie TMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp USERDOMAIN=T-W864-IX-162 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-162 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-162 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 21:59:10 INFO - MultiFileLogger online at 20161026 21:59:10 in C:\slave\test 21:59:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 21:59:10 INFO - Dumping config to C:\slave\test\logs\localconfig.json. 21:59:10 INFO - {'append_to_log': False, 21:59:10 INFO - 'base_work_dir': 'C:\\slave\\test', 21:59:10 INFO - 'blob_upload_branch': 'Firefox', 21:59:10 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt', 21:59:10 INFO - 'branch': 'Firefox', 21:59:10 INFO - 'buildbot_json_path': 'buildprops.json', 21:59:10 INFO - 'config_files': ('talos/windows_config.py',), 21:59:10 INFO - 'default_actions': ('clobber', 21:59:10 INFO - 'read-buildbot-config', 21:59:10 INFO - 'download-and-extract', 21:59:10 INFO - 'populate-webroot', 21:59:10 INFO - 'create-virtualenv', 21:59:10 INFO - 'install', 21:59:10 INFO - 'run-tests'), 21:59:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:59:10 INFO - 'download_minidump_stackwalk': True, 21:59:10 INFO - 'download_symbols': 'ondemand', 21:59:10 INFO - 'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python', 21:59:10 INFO - 'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'), 21:59:10 INFO - 'hg': 'c:/mozilla-build/hg/hg', 21:59:10 INFO - 'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python', 21:59:10 INFO - 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'), 21:59:10 INFO - 'python': 'c:/mozilla-build/python27/python.exe', 21:59:10 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe', 21:59:10 INFO - 'C:/mozilla-build/tooltool.py'), 21:59:10 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe', 21:59:10 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 21:59:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:59:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:59:10 INFO - 'installer_path': 'installer.exe', 21:59:10 INFO - 'log_level': 'info', 21:59:10 INFO - 'log_name': 'talos', 21:59:10 INFO - 'log_to_console': True, 21:59:10 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe', 21:59:10 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe', 21:59:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest', 21:59:10 INFO - 'opt_config_files': (), 21:59:10 INFO - 'pip_index': False, 21:59:10 INFO - 'sps_profile': False, 21:59:10 INFO - 'sps_profile_interval': 0, 21:59:10 INFO - 'suite': 'dromaeojs', 21:59:10 INFO - 'system_bits': '32', 21:59:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:59:10 INFO - 'title': 'T-W864-IX-162', 21:59:10 INFO - 'use_talos_json': True, 21:59:10 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'), 21:59:10 INFO - 'virtualenv_path': 'C:\\slave\\test\\build/venv', 21:59:10 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll', 21:59:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:59:10 INFO - 'work_dir': 'build'} 21:59:10 INFO - [mozharness: 2016-10-27 04:59:10.449000Z] Running clobber step. 21:59:10 INFO - Running pre-action listener: _resource_record_pre_action 21:59:10 INFO - Running main action method: clobber 21:59:10 INFO - rmtree: C:\slave\test\build 21:59:10 INFO - Using _rmtree_windows ... 21:59:10 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1 22:00:54 INFO - Running post-action listener: _resource_record_post_action 22:00:54 INFO - [mozharness: 2016-10-27 05:00:54.191000Z] Finished clobber step (success) 22:00:54 INFO - [mozharness: 2016-10-27 05:00:54.191000Z] Running read-buildbot-config step. 22:00:54 INFO - Running pre-action listener: _resource_record_pre_action 22:00:54 INFO - Running main action method: read_buildbot_config 22:00:54 INFO - Using buildbot properties: 22:00:54 INFO - { 22:00:54 INFO - "project": "", 22:00:54 INFO - "product": "firefox", 22:00:54 INFO - "script_repo_revision": "production", 22:00:54 INFO - "builddir": "mozilla-central_win8_64_test-dromaeojs", 22:00:54 INFO - "repository": "", 22:00:54 INFO - "buildername": "Windows 8 64-bit mozilla-central pgo talos dromaeojs", 22:00:54 INFO - "buildid": "20161026193001", 22:00:54 INFO - "pgo_build": "True", 22:00:54 INFO - "basedir": "C:\\slave\\test", 22:00:54 INFO - "buildnumber": 85, 22:00:54 INFO - "slavename": "t-w864-ix-162", 22:00:54 INFO - "master": "http://buildbot-master119.bb.releng.scl3.mozilla.com:8201/", 22:00:54 INFO - "platform": "win8_64", 22:00:54 INFO - "scheduler": "tests-mozilla-central-win64-pgo-talos", 22:00:54 INFO - "branch": "mozilla-central", 22:00:54 INFO - "repo_path": "mozilla-central", 22:00:54 INFO - "revision": "3f4c3a3cabaf94958834d3a8935adfb4a887942d", 22:00:54 INFO - "stage_platform": "win64-pgo", 22:00:54 INFO - "builduid": "496b3b7034114f5d950a3311824d3c2a", 22:00:54 INFO - "slavebuilddir": "test" 22:00:54 INFO - } 22:00:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/NYDovZ6hSWGqwBVKNxBVyw/artifacts/public/build/firefox-52.0a1.en-US.win64.zip. 22:00:54 INFO - Running post-action listener: _resource_record_post_action 22:00:54 INFO - [mozharness: 2016-10-27 05:00:54.194000Z] Finished read-buildbot-config step (success) 22:00:54 INFO - [mozharness: 2016-10-27 05:00:54.194000Z] Running download-and-extract step. 22:00:54 INFO - Running pre-action listener: _resource_record_pre_action 22:00:54 INFO - Running main action method: download_and_extract 22:00:54 INFO - mkdir: C:\slave\test\build\tests 22:00:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:54 INFO - trying https://queue.taskcluster.net/v1/task/NYDovZ6hSWGqwBVKNxBVyw/artifacts/public/build/firefox-52.0a1.en-US.win64.test_packages.json 22:00:54 INFO - Downloading https://queue.taskcluster.net/v1/task/NYDovZ6hSWGqwBVKNxBVyw/artifacts/public/build/firefox-52.0a1.en-US.win64.test_packages.json to C:\slave\test\build\firefox-52.0a1.en-US.win64.test_packages.json 22:00:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NYDovZ6hSWGqwBVKNxBVyw/artifacts/public/build/firefox-52.0a1.en-US.win64.test_packages.json', 'file_name': 'C:\\slave\\test\\build\\firefox-52.0a1.en-US.win64.test_packages.json'}, attempt #1 22:00:54 INFO - Downloaded 1218 bytes. 22:00:54 INFO - Reading from file C:\slave\test\build\firefox-52.0a1.en-US.win64.test_packages.json 22:00:54 INFO - Using the following test package requirements: 22:00:54 INFO - {u'common': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 22:00:54 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 22:00:54 INFO - u'firefox-52.0a1.en-US.win64.cppunittest.tests.zip'], 22:00:54 INFO - u'gtest': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 22:00:54 INFO - u'jittest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 22:00:54 INFO - u'jsshell-win64.zip'], 22:00:54 INFO - u'mochitest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 22:00:54 INFO - u'firefox-52.0a1.en-US.win64.mochitest.tests.zip'], 22:00:54 INFO - u'mozbase': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 22:00:54 INFO - u'reftest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 22:00:54 INFO - u'firefox-52.0a1.en-US.win64.reftest.tests.zip'], 22:00:54 INFO - u'talos': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 22:00:54 INFO - u'firefox-52.0a1.en-US.win64.talos.tests.zip'], 22:00:54 INFO - u'web-platform': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 22:00:54 INFO - u'firefox-52.0a1.en-US.win64.web-platform.tests.zip'], 22:00:54 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 22:00:54 INFO - u'firefox-52.0a1.en-US.win64.xpcshell.tests.zip']} 22:00:54 INFO - Downloading packages: [u'firefox-52.0a1.en-US.win64.common.tests.zip'] for test suite category: common 22:00:54 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/NYDovZ6hSWGqwBVKNxBVyw/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip 22:00:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NYDovZ6hSWGqwBVKNxBVyw/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip'}, attempt #1 22:00:54 INFO - Fetch https://queue.taskcluster.net/v1/task/NYDovZ6hSWGqwBVKNxBVyw/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip into memory 22:00:55 INFO - Http code: 200 22:00:55 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 22:00:55 INFO - x-amz-cf-id: aD-lzCuqlSTFDeptPLfelP477q9ZuR9KtsowQ3_NmYMYFF2mkl2njQ== 22:00:55 INFO - x-amz-version-id: 2cPRzsSnGC.G9tvTTIIPk6MLffxjbcUX 22:00:56 INFO - Expected file size: 17418131 22:00:56 INFO - Obtained file size: 17418131 22:01:20 INFO - Downloading packages: [u'firefox-52.0a1.en-US.win64.common.tests.zip', u'firefox-52.0a1.en-US.win64.talos.tests.zip'] for test suite category: talos 22:01:20 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/NYDovZ6hSWGqwBVKNxBVyw/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip 22:01:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NYDovZ6hSWGqwBVKNxBVyw/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip'}, attempt #1 22:01:20 INFO - Fetch https://queue.taskcluster.net/v1/task/NYDovZ6hSWGqwBVKNxBVyw/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip into memory 22:01:20 INFO - Http code: 200 22:01:20 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 22:01:20 INFO - x-amz-cf-id: EyBbc1nl5ZXWkO_AtXGQlKMMAmTfCOwrEmkSwDj7Ob1ANKYdhcYrLQ== 22:01:20 INFO - x-amz-version-id: 2cPRzsSnGC.G9tvTTIIPk6MLffxjbcUX 22:01:21 INFO - Expected file size: 17418131 22:01:21 INFO - Obtained file size: 17418131 22:01:30 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/NYDovZ6hSWGqwBVKNxBVyw/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip 22:01:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NYDovZ6hSWGqwBVKNxBVyw/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip'}, attempt #1 22:01:30 INFO - Fetch https://queue.taskcluster.net/v1/task/NYDovZ6hSWGqwBVKNxBVyw/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip into memory 22:01:31 INFO - Http code: 200 22:01:31 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 22:01:31 INFO - x-amz-cf-id: aqt4IWJSB4LZi6xRywg_xLA2__CRQcDZyxAxTMUmMst3ixXXToalLQ== 22:01:31 INFO - x-amz-version-id: QpevClK_.NZsGoMef.zseEnMHGi_n16M 22:01:31 INFO - Expected file size: 14409028 22:01:31 INFO - Obtained file size: 14409028 22:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:01:44 INFO - trying https://queue.taskcluster.net/v1/task/NYDovZ6hSWGqwBVKNxBVyw/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 22:01:44 INFO - Downloading https://queue.taskcluster.net/v1/task/NYDovZ6hSWGqwBVKNxBVyw/artifacts/public/build/firefox-52.0a1.en-US.win64.zip to C:\slave\test\build\firefox-52.0a1.en-US.win64.zip 22:01:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NYDovZ6hSWGqwBVKNxBVyw/artifacts/public/build/firefox-52.0a1.en-US.win64.zip', 'file_name': 'C:\\slave\\test\\build\\firefox-52.0a1.en-US.win64.zip'}, attempt #1 22:01:45 INFO - Downloaded 57237482 bytes. 22:01:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NYDovZ6hSWGqwBVKNxBVyw/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 22:01:45 INFO - mkdir: C:\slave\test\properties 22:01:45 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url 22:01:45 INFO - Writing to file C:\slave\test\properties\build_url 22:01:45 INFO - Contents: 22:01:45 INFO - build_url:https://queue.taskcluster.net/v1/task/NYDovZ6hSWGqwBVKNxBVyw/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 22:01:46 INFO - Running post-action listener: _resource_record_post_action 22:01:46 INFO - Running post-action listener: set_extra_try_arguments 22:01:46 INFO - [mozharness: 2016-10-27 05:01:46.112000Z] Finished download-and-extract step (success) 22:01:46 INFO - [mozharness: 2016-10-27 05:01:46.112000Z] Running populate-webroot step. 22:01:46 INFO - Running pre-action listener: _resource_record_pre_action 22:01:46 INFO - Running main action method: populate_webroot 22:01:46 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']}, 22:01:46 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']}, 22:01:46 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome', 22:01:46 INFO - u'--tppagecycles', 22:01:46 INFO - u'7'], 22:01:46 INFO - u'tests': [u'tsvgm']}}, 22:01:46 INFO - u'suites': {u'chromez': {u'talos_options': [u'--disable-e10s'], 22:01:46 INFO - u'tests': [u'tresize', u'tcanvasmark']}, 22:01:46 INFO - u'chromez-e10s': {u'tests': [u'tresize', u'tcanvasmark']}, 22:01:46 INFO - u'dromaeojs': {u'talos_options': [u'--disable-e10s'], 22:01:46 INFO - u'tests': [u'dromaeo_css', u'kraken']}, 22:01:46 INFO - u'dromaeojs-e10s': {u'tests': [u'dromaeo_css', u'kraken']}, 22:01:46 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:46 INFO - u'talos_options': [u'--disable-e10s'], 22:01:46 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 22:01:46 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:46 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 22:01:46 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:46 INFO - u'talos_options': [u'--disable-e10s'], 22:01:46 INFO - u'tests': [u'damp', u'tps']}, 22:01:46 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:46 INFO - u'tests': [u'damp', u'tps']}, 22:01:46 INFO - u'g3': {u'talos_options': [u'--disable-e10s'], 22:01:46 INFO - u'tests': [u'dromaeo_dom']}, 22:01:46 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']}, 22:01:46 INFO - u'g4': {u'talos_options': [u'--disable-e10s'], 22:01:46 INFO - u'tests': [u'basic_compositor_video']}, 22:01:46 INFO - u'g4-e10s': {u'tests': [u'basic_compositor_video']}, 22:01:46 INFO - u'other': {u'talos_options': [u'--disable-e10s'], 22:01:46 INFO - u'tests': [u'a11yr', 22:01:46 INFO - u'ts_paint', 22:01:46 INFO - u'tpaint', 22:01:46 INFO - u'sessionrestore', 22:01:46 INFO - u'sessionrestore_no_auto_restore', 22:01:46 INFO - u'tabpaint']}, 22:01:46 INFO - u'other-e10s': {u'tests': [u'a11yr', 22:01:46 INFO - u'ts_paint', 22:01:46 INFO - u'tpaint', 22:01:46 INFO - u'sessionrestore', 22:01:46 INFO - u'sessionrestore_no_auto_restore', 22:01:46 INFO - u'tabpaint']}, 22:01:46 INFO - u'other-e10s_l64': {u'tests': [u'a11yr', 22:01:46 INFO - u'ts_paint', 22:01:46 INFO - u'tpaint', 22:01:46 INFO - u'sessionrestore', 22:01:46 INFO - u'sessionrestore_no_auto_restore', 22:01:46 INFO - u'tabpaint']}, 22:01:46 INFO - u'other-e10s_nol64': {u'tests': [u'a11yr', 22:01:46 INFO - u'ts_paint', 22:01:46 INFO - u'tpaint', 22:01:46 INFO - u'sessionrestore', 22:01:46 INFO - u'sessionrestore_no_auto_restore', 22:01:46 INFO - u'tabpaint']}, 22:01:46 INFO - u'other_l64': {u'talos_options': [u'--disable-e10s'], 22:01:46 INFO - u'tests': [u'a11yr', 22:01:46 INFO - u'ts_paint', 22:01:46 INFO - u'tpaint', 22:01:46 INFO - u'sessionrestore', 22:01:46 INFO - u'sessionrestore_no_auto_restore', 22:01:46 INFO - u'tabpaint']}, 22:01:46 INFO - u'other_nol64': {u'talos_options': [u'--disable-e10s'], 22:01:46 INFO - u'tests': [u'a11yr', 22:01:46 INFO - u'ts_paint', 22:01:46 INFO - u'tpaint', 22:01:46 INFO - u'sessionrestore', 22:01:46 INFO - u'sessionrestore_no_auto_restore', 22:01:46 INFO - u'tabpaint']}, 22:01:46 INFO - u'svgr': {u'talos_options': [u'--disable-e10s'], 22:01:46 INFO - u'tests': [u'tsvgx', 22:01:46 INFO - u'tsvgr_opacity', 22:01:46 INFO - u'tart', 22:01:46 INFO - u'tscrollx', 22:01:46 INFO - u'cart']}, 22:01:46 INFO - u'svgr-e10s': {u'tests': [u'tsvgx', 22:01:46 INFO - u'tsvgr_opacity', 22:01:46 INFO - u'tart', 22:01:46 INFO - u'tscrollx', 22:01:46 INFO - u'cart']}, 22:01:46 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:46 INFO - u'talos_options': [u'--disable-e10s'], 22:01:46 INFO - u'tests': [u'tp5o']}, 22:01:46 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:46 INFO - u'tests': [u'tp5o']}, 22:01:46 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:46 INFO - u'talos_options': [u'--disable-e10s', 22:01:46 INFO - u'--xperf_path', 22:01:46 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:01:46 INFO - u'tests': [u'tp5n']}, 22:01:46 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:46 INFO - u'talos_options': [u'--xperf_path', 22:01:46 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:01:46 INFO - u'tests': [u'tp5n']}}, 22:01:46 INFO - u'talos.zip': {u'path': u'', 22:01:46 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:01:46 INFO - Running post-action listener: _resource_record_post_action 22:01:46 INFO - [mozharness: 2016-10-27 05:01:46.163000Z] Finished populate-webroot step (success) 22:01:46 INFO - [mozharness: 2016-10-27 05:01:46.164000Z] Running create-virtualenv step. 22:01:46 INFO - Running pre-action listener: _resource_record_pre_action 22:01:46 INFO - Running main action method: create_virtualenv 22:01:46 INFO - Creating virtualenv C:\slave\test\build/venv 22:01:46 INFO - mkdir: C:\slave\test\build\venv\Scripts 22:01:46 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll 22:01:46 WARNING - Can't copy c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll: [Errno 2] No such file or directory: 'c:/mozilla-build/python27/python27.dll'! 22:01:46 INFO - Running command: ['c:/mozilla-build/python27/python.exe', 'c:/mozilla-build/buildbotve/virtualenv.py', '--no-site-packages', '--distribute', 'C:\\slave\\test\\build/venv'] in C:\slave\test\build 22:01:46 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build/venv 22:01:52 INFO - New python executable in C:\slave\test\build/venv\Scripts\python.exe 22:01:56 INFO - Installing distribute......................................................................................................................................................................................done. 22:01:57 INFO - Return code: 0 22:01:57 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', '--version'] 22:01:57 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip --version 22:01:58 INFO - Reading from file tmpfile_stdout 22:01:58 INFO - Output received: 22:01:58 INFO - pip 0.8.2 from c:\slave\test\build\venv\lib\site-packages\pip-0.8.2-py2.7.egg (python 2.7) 22:01:58 INFO - Using _rmtree_windows ... 22:01:58 INFO - Using _rmtree_windows ... 22:01:58 INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv 22:01:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:01:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:58 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022BC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0233DE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x028058F8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02318E90>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01CBA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02844520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-162', 'USERDOMAIN': 'T-W864-IX-162', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-162', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-162\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-162', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-162', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-162', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-162\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 22:01:58 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in C:\slave\test\build 22:01:58 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:01:58 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 22:01:58 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-162\\AppData\\Roaming', 22:01:58 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 22:01:58 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 22:01:58 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 22:01:58 INFO - 'COMPUTERNAME': 'T-W864-IX-162', 22:01:58 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 22:01:58 INFO - 'DCLOCATION': 'SCL3', 22:01:58 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 22:01:58 INFO - 'FP_NO_HOST_CHECK': 'NO', 22:01:58 INFO - 'HOMEDRIVE': 'C:', 22:01:58 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-162', 22:01:58 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 22:01:58 INFO - 'KTS_VERSION': '1.19c', 22:01:58 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-162\\AppData\\Local', 22:01:58 INFO - 'LOGONSERVER': '\\\\T-W864-IX-162', 22:01:58 INFO - 'MONDIR': 'C:\\Monitor_config\\', 22:01:58 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 22:01:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:58 INFO - 'MOZ_NO_REMOTE': '1', 22:01:58 INFO - 'NO_EM_RESTART': '1', 22:01:58 INFO - 'NUMBER_OF_PROCESSORS': '8', 22:01:58 INFO - 'OS': 'Windows_NT', 22:01:58 INFO - 'OURDRIVE': 'C:', 22:01:58 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 22:01:58 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 22:01:58 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 22:01:58 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 22:01:58 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 22:01:58 INFO - 'PROCESSOR_LEVEL': '6', 22:01:58 INFO - 'PROCESSOR_REVISION': '1e05', 22:01:58 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 22:01:58 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 22:01:58 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 22:01:58 INFO - 'PROGRAMW6432': 'C:\\Program Files', 22:01:58 INFO - 'PROMPT': '$P$G', 22:01:58 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 22:01:58 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 22:01:58 INFO - 'PUBLIC': 'C:\\Users\\Public', 22:01:58 INFO - 'PWD': 'C:\\slave\\test', 22:01:58 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 22:01:58 INFO - 'SLAVEDIR': 'C:\\slave\\', 22:01:58 INFO - 'SYSTEMDRIVE': 'C:', 22:01:58 INFO - 'SYSTEMROOT': 'C:\\windows', 22:01:58 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 22:01:58 INFO - 'TEST1': 'testie', 22:01:58 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 22:01:58 INFO - 'USERDOMAIN': 'T-W864-IX-162', 22:01:58 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-162', 22:01:58 INFO - 'USERNAME': 'cltbld', 22:01:58 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-162', 22:01:58 INFO - 'WINDIR': 'C:\\windows', 22:01:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 22:01:59 INFO - Ignoring indexes: http://pypi.python.org/simple/ 22:01:59 INFO - Downloading/unpacking pip>=1.5 22:02:03 INFO - Running setup.py egg_info for package pip 22:02:03 INFO - warning: no files found matching 'pip\cacert.pem' 22:02:03 INFO - warning: no files found matching '*.html' under directory 'docs' 22:02:03 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 22:02:03 INFO - no previously-included directories found matching 'docs\_build\_sources' 22:02:03 INFO - Installing collected packages: pip 22:02:03 INFO - Found existing installation: pip 0.8.2 22:02:03 INFO - Uninstalling pip: 22:02:03 INFO - Successfully uninstalled pip 22:02:03 INFO - Running setup.py install for pip 22:02:03 INFO - warning: no files found matching 'pip\cacert.pem' 22:02:03 INFO - warning: no files found matching '*.html' under directory 'docs' 22:02:03 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 22:02:03 INFO - no previously-included directories found matching 'docs\_build\_sources' 22:02:03 INFO - Installing pip-script.py script to C:\slave\test\build\venv\Scripts 22:02:03 INFO - Installing pip.exe script to C:\slave\test\build\venv\Scripts 22:02:03 INFO - Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts 22:02:03 INFO - Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts 22:02:03 INFO - Installing pip2-script.py script to C:\slave\test\build\venv\Scripts 22:02:03 INFO - Installing pip2.exe script to C:\slave\test\build\venv\Scripts 22:02:03 INFO - Successfully installed pip 22:02:03 INFO - Cleaning up... 22:02:03 INFO - Return code: 0 22:02:03 INFO - Installing psutil>=3.1.1 into virtualenv C:\slave\test\build/venv 22:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:02:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:03 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022BC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0233DE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x028058F8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02318E90>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01CBA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02844520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-162', 'USERDOMAIN': 'T-W864-IX-162', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-162', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-162\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-162', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-162', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-162', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-162\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 22:02:03 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in C:\slave\test\build 22:02:03 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 22:02:03 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 22:02:03 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-162\\AppData\\Roaming', 22:02:03 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 22:02:03 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 22:02:03 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 22:02:03 INFO - 'COMPUTERNAME': 'T-W864-IX-162', 22:02:03 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 22:02:03 INFO - 'DCLOCATION': 'SCL3', 22:02:03 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 22:02:03 INFO - 'FP_NO_HOST_CHECK': 'NO', 22:02:03 INFO - 'HOMEDRIVE': 'C:', 22:02:03 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-162', 22:02:03 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 22:02:03 INFO - 'KTS_VERSION': '1.19c', 22:02:03 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-162\\AppData\\Local', 22:02:03 INFO - 'LOGONSERVER': '\\\\T-W864-IX-162', 22:02:03 INFO - 'MONDIR': 'C:\\Monitor_config\\', 22:02:03 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 22:02:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:03 INFO - 'MOZ_NO_REMOTE': '1', 22:02:03 INFO - 'NO_EM_RESTART': '1', 22:02:03 INFO - 'NUMBER_OF_PROCESSORS': '8', 22:02:03 INFO - 'OS': 'Windows_NT', 22:02:03 INFO - 'OURDRIVE': 'C:', 22:02:03 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 22:02:03 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 22:02:03 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 22:02:03 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 22:02:03 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 22:02:03 INFO - 'PROCESSOR_LEVEL': '6', 22:02:03 INFO - 'PROCESSOR_REVISION': '1e05', 22:02:03 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 22:02:03 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 22:02:03 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 22:02:03 INFO - 'PROGRAMW6432': 'C:\\Program Files', 22:02:03 INFO - 'PROMPT': '$P$G', 22:02:03 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 22:02:03 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 22:02:03 INFO - 'PUBLIC': 'C:\\Users\\Public', 22:02:03 INFO - 'PWD': 'C:\\slave\\test', 22:02:03 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 22:02:03 INFO - 'SLAVEDIR': 'C:\\slave\\', 22:02:03 INFO - 'SYSTEMDRIVE': 'C:', 22:02:03 INFO - 'SYSTEMROOT': 'C:\\windows', 22:02:03 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 22:02:03 INFO - 'TEST1': 'testie', 22:02:03 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 22:02:03 INFO - 'USERDOMAIN': 'T-W864-IX-162', 22:02:03 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-162', 22:02:03 INFO - 'USERNAME': 'cltbld', 22:02:03 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-162', 22:02:03 INFO - 'WINDIR': 'C:\\windows', 22:02:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 22:02:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:06 INFO - Downloading/unpacking psutil>=3.1.1 22:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:02:07 INFO - Installing collected packages: psutil 22:02:07 INFO - Successfully installed psutil 22:02:07 INFO - Cleaning up... 22:02:08 INFO - Return code: 0 22:02:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv C:\slave\test\build/venv 22:02:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:02:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:08 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022BC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0233DE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x028058F8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02318E90>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01CBA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02844520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-162', 'USERDOMAIN': 'T-W864-IX-162', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-162', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-162\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-162', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-162', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-162', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-162\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 22:02:08 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in C:\slave\test\build 22:02:08 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 22:02:08 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 22:02:08 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-162\\AppData\\Roaming', 22:02:08 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 22:02:08 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 22:02:08 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 22:02:08 INFO - 'COMPUTERNAME': 'T-W864-IX-162', 22:02:08 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 22:02:08 INFO - 'DCLOCATION': 'SCL3', 22:02:08 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 22:02:08 INFO - 'FP_NO_HOST_CHECK': 'NO', 22:02:08 INFO - 'HOMEDRIVE': 'C:', 22:02:08 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-162', 22:02:08 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 22:02:08 INFO - 'KTS_VERSION': '1.19c', 22:02:08 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-162\\AppData\\Local', 22:02:08 INFO - 'LOGONSERVER': '\\\\T-W864-IX-162', 22:02:08 INFO - 'MONDIR': 'C:\\Monitor_config\\', 22:02:08 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 22:02:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:08 INFO - 'MOZ_NO_REMOTE': '1', 22:02:08 INFO - 'NO_EM_RESTART': '1', 22:02:08 INFO - 'NUMBER_OF_PROCESSORS': '8', 22:02:08 INFO - 'OS': 'Windows_NT', 22:02:08 INFO - 'OURDRIVE': 'C:', 22:02:08 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 22:02:08 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 22:02:08 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 22:02:08 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 22:02:08 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 22:02:08 INFO - 'PROCESSOR_LEVEL': '6', 22:02:08 INFO - 'PROCESSOR_REVISION': '1e05', 22:02:08 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 22:02:08 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 22:02:08 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 22:02:08 INFO - 'PROGRAMW6432': 'C:\\Program Files', 22:02:08 INFO - 'PROMPT': '$P$G', 22:02:08 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 22:02:08 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 22:02:08 INFO - 'PUBLIC': 'C:\\Users\\Public', 22:02:08 INFO - 'PWD': 'C:\\slave\\test', 22:02:08 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 22:02:08 INFO - 'SLAVEDIR': 'C:\\slave\\', 22:02:08 INFO - 'SYSTEMDRIVE': 'C:', 22:02:08 INFO - 'SYSTEMROOT': 'C:\\windows', 22:02:08 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 22:02:08 INFO - 'TEST1': 'testie', 22:02:08 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 22:02:08 INFO - 'USERDOMAIN': 'T-W864-IX-162', 22:02:08 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-162', 22:02:08 INFO - 'USERNAME': 'cltbld', 22:02:08 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-162', 22:02:08 INFO - 'WINDIR': 'C:\\windows', 22:02:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 22:02:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:02:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:02:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:02:09 INFO - Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor 22:02:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in c:\slave\test\build\venv\lib\site-packages (from mozsystemmonitor==0.3) 22:02:09 INFO - Installing collected packages: mozsystemmonitor 22:02:09 INFO - Running setup.py install for mozsystemmonitor 22:02:09 INFO - Successfully installed mozsystemmonitor 22:02:09 INFO - Cleaning up... 22:02:10 INFO - Return code: 0 22:02:10 INFO - Installing jsonschema==2.5.1 into virtualenv C:\slave\test\build/venv 22:02:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:02:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:10 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022BC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0233DE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x028058F8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02318E90>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01CBA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02844520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-162', 'USERDOMAIN': 'T-W864-IX-162', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-162', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-162\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-162', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-162', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-162', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-162\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 22:02:10 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in C:\slave\test\build 22:02:10 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 22:02:10 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 22:02:10 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-162\\AppData\\Roaming', 22:02:10 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 22:02:10 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 22:02:10 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 22:02:10 INFO - 'COMPUTERNAME': 'T-W864-IX-162', 22:02:10 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 22:02:10 INFO - 'DCLOCATION': 'SCL3', 22:02:10 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 22:02:10 INFO - 'FP_NO_HOST_CHECK': 'NO', 22:02:10 INFO - 'HOMEDRIVE': 'C:', 22:02:10 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-162', 22:02:10 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 22:02:10 INFO - 'KTS_VERSION': '1.19c', 22:02:10 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-162\\AppData\\Local', 22:02:10 INFO - 'LOGONSERVER': '\\\\T-W864-IX-162', 22:02:10 INFO - 'MONDIR': 'C:\\Monitor_config\\', 22:02:10 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 22:02:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:10 INFO - 'MOZ_NO_REMOTE': '1', 22:02:10 INFO - 'NO_EM_RESTART': '1', 22:02:10 INFO - 'NUMBER_OF_PROCESSORS': '8', 22:02:10 INFO - 'OS': 'Windows_NT', 22:02:10 INFO - 'OURDRIVE': 'C:', 22:02:10 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 22:02:10 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 22:02:10 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 22:02:10 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 22:02:10 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 22:02:10 INFO - 'PROCESSOR_LEVEL': '6', 22:02:10 INFO - 'PROCESSOR_REVISION': '1e05', 22:02:10 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 22:02:10 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 22:02:10 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 22:02:10 INFO - 'PROGRAMW6432': 'C:\\Program Files', 22:02:10 INFO - 'PROMPT': '$P$G', 22:02:10 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 22:02:10 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 22:02:10 INFO - 'PUBLIC': 'C:\\Users\\Public', 22:02:10 INFO - 'PWD': 'C:\\slave\\test', 22:02:10 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 22:02:10 INFO - 'SLAVEDIR': 'C:\\slave\\', 22:02:10 INFO - 'SYSTEMDRIVE': 'C:', 22:02:10 INFO - 'SYSTEMROOT': 'C:\\windows', 22:02:10 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 22:02:10 INFO - 'TEST1': 'testie', 22:02:10 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 22:02:10 INFO - 'USERDOMAIN': 'T-W864-IX-162', 22:02:10 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-162', 22:02:10 INFO - 'USERNAME': 'cltbld', 22:02:10 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-162', 22:02:10 INFO - 'WINDIR': 'C:\\windows', 22:02:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 22:02:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:10 INFO - Downloading/unpacking jsonschema==2.5.1 22:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:02:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:02:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:02:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:02:11 INFO - Downloading functools32-3.2.3-2.tar.gz 22:02:11 INFO - Running setup.py (path:C:\slave\test\build\venv\build\functools32\setup.py) egg_info for package functools32 22:02:11 INFO - warning: no files found matching '*.txt' 22:02:11 INFO - no previously-included directories found matching 'build' 22:02:11 INFO - no previously-included directories found matching 'dist' 22:02:11 INFO - no previously-included directories found matching '.git*' 22:02:11 INFO - Installing collected packages: jsonschema, functools32 22:02:11 INFO - Running setup.py install for functools32 22:02:11 INFO - warning: no files found matching '*.txt' 22:02:11 INFO - no previously-included directories found matching 'build' 22:02:11 INFO - no previously-included directories found matching 'dist' 22:02:11 INFO - no previously-included directories found matching '.git*' 22:02:11 INFO - Successfully installed jsonschema functools32 22:02:11 INFO - Cleaning up... 22:02:12 INFO - Return code: 0 22:02:12 INFO - Installing functools32==3.2.3-2 into virtualenv C:\slave\test\build/venv 22:02:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:02:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:12 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022BC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0233DE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x028058F8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02318E90>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01CBA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02844520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-162', 'USERDOMAIN': 'T-W864-IX-162', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-162', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-162\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-162', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-162', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-162', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-162\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 22:02:12 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in C:\slave\test\build 22:02:12 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 22:02:12 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 22:02:12 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-162\\AppData\\Roaming', 22:02:12 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 22:02:12 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 22:02:12 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 22:02:12 INFO - 'COMPUTERNAME': 'T-W864-IX-162', 22:02:12 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 22:02:12 INFO - 'DCLOCATION': 'SCL3', 22:02:12 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 22:02:12 INFO - 'FP_NO_HOST_CHECK': 'NO', 22:02:12 INFO - 'HOMEDRIVE': 'C:', 22:02:12 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-162', 22:02:12 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 22:02:12 INFO - 'KTS_VERSION': '1.19c', 22:02:12 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-162\\AppData\\Local', 22:02:12 INFO - 'LOGONSERVER': '\\\\T-W864-IX-162', 22:02:12 INFO - 'MONDIR': 'C:\\Monitor_config\\', 22:02:12 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 22:02:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:12 INFO - 'MOZ_NO_REMOTE': '1', 22:02:12 INFO - 'NO_EM_RESTART': '1', 22:02:12 INFO - 'NUMBER_OF_PROCESSORS': '8', 22:02:12 INFO - 'OS': 'Windows_NT', 22:02:12 INFO - 'OURDRIVE': 'C:', 22:02:12 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 22:02:12 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 22:02:12 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 22:02:12 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 22:02:12 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 22:02:12 INFO - 'PROCESSOR_LEVEL': '6', 22:02:12 INFO - 'PROCESSOR_REVISION': '1e05', 22:02:12 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 22:02:12 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 22:02:12 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 22:02:12 INFO - 'PROGRAMW6432': 'C:\\Program Files', 22:02:12 INFO - 'PROMPT': '$P$G', 22:02:12 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 22:02:12 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 22:02:12 INFO - 'PUBLIC': 'C:\\Users\\Public', 22:02:12 INFO - 'PWD': 'C:\\slave\\test', 22:02:12 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 22:02:12 INFO - 'SLAVEDIR': 'C:\\slave\\', 22:02:12 INFO - 'SYSTEMDRIVE': 'C:', 22:02:12 INFO - 'SYSTEMROOT': 'C:\\windows', 22:02:12 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 22:02:12 INFO - 'TEST1': 'testie', 22:02:12 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 22:02:12 INFO - 'USERDOMAIN': 'T-W864-IX-162', 22:02:12 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-162', 22:02:12 INFO - 'USERNAME': 'cltbld', 22:02:12 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-162', 22:02:12 INFO - 'WINDIR': 'C:\\windows', 22:02:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 22:02:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in c:\slave\test\build\venv\lib\site-packages 22:02:12 INFO - Cleaning up... 22:02:12 INFO - Return code: 0 22:02:12 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv 22:02:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:02:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:12 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022BC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0233DE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x028058F8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02318E90>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01CBA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02844520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-162', 'USERDOMAIN': 'T-W864-IX-162', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-162', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-162\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-162', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-162', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-162', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-162\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 22:02:12 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in C:\slave\test\build 22:02:12 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:02:12 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 22:02:12 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-162\\AppData\\Roaming', 22:02:12 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 22:02:12 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 22:02:12 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 22:02:12 INFO - 'COMPUTERNAME': 'T-W864-IX-162', 22:02:12 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 22:02:12 INFO - 'DCLOCATION': 'SCL3', 22:02:12 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 22:02:12 INFO - 'FP_NO_HOST_CHECK': 'NO', 22:02:12 INFO - 'HOMEDRIVE': 'C:', 22:02:12 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-162', 22:02:12 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 22:02:12 INFO - 'KTS_VERSION': '1.19c', 22:02:12 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-162\\AppData\\Local', 22:02:12 INFO - 'LOGONSERVER': '\\\\T-W864-IX-162', 22:02:12 INFO - 'MONDIR': 'C:\\Monitor_config\\', 22:02:12 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 22:02:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:12 INFO - 'MOZ_NO_REMOTE': '1', 22:02:12 INFO - 'NO_EM_RESTART': '1', 22:02:12 INFO - 'NUMBER_OF_PROCESSORS': '8', 22:02:12 INFO - 'OS': 'Windows_NT', 22:02:12 INFO - 'OURDRIVE': 'C:', 22:02:12 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 22:02:12 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 22:02:12 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 22:02:12 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 22:02:12 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 22:02:12 INFO - 'PROCESSOR_LEVEL': '6', 22:02:12 INFO - 'PROCESSOR_REVISION': '1e05', 22:02:12 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 22:02:12 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 22:02:12 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 22:02:12 INFO - 'PROGRAMW6432': 'C:\\Program Files', 22:02:12 INFO - 'PROMPT': '$P$G', 22:02:12 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 22:02:12 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 22:02:12 INFO - 'PUBLIC': 'C:\\Users\\Public', 22:02:12 INFO - 'PWD': 'C:\\slave\\test', 22:02:12 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 22:02:12 INFO - 'SLAVEDIR': 'C:\\slave\\', 22:02:12 INFO - 'SYSTEMDRIVE': 'C:', 22:02:12 INFO - 'SYSTEMROOT': 'C:\\windows', 22:02:12 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 22:02:12 INFO - 'TEST1': 'testie', 22:02:12 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 22:02:12 INFO - 'USERDOMAIN': 'T-W864-IX-162', 22:02:12 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-162', 22:02:12 INFO - 'USERNAME': 'cltbld', 22:02:12 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-162', 22:02:12 INFO - 'WINDIR': 'C:\\windows', 22:02:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 22:02:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:13 INFO - Downloading/unpacking blobuploader==1.2.4 22:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:02:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:02:14 INFO - Downloading blobuploader-1.2.4.tar.gz 22:02:14 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader 22:02:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:02:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:02:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:02:14 INFO - Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests 22:02:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:02:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:02:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:02:14 INFO - Downloading docopt-0.6.1.tar.gz 22:02:14 INFO - Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt 22:02:14 INFO - Installing collected packages: blobuploader, requests, docopt 22:02:14 INFO - Running setup.py install for blobuploader 22:02:15 INFO - Running setup.py install for requests 22:02:15 INFO - Running setup.py install for docopt 22:02:15 INFO - Successfully installed blobuploader requests docopt 22:02:15 INFO - Cleaning up... 22:02:16 INFO - Return code: 0 22:02:16 INFO - Installing None into virtualenv C:\slave\test\build/venv 22:02:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:02:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:16 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--no-deps', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022BC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0233DE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x028058F8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02318E90>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01CBA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02844520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-162', 'USERDOMAIN': 'T-W864-IX-162', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-162', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-162\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-162', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-162', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-162', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-162\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 22:02:16 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--no-deps', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in C:\slave\test\build\tests\config 22:02:16 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --no-deps --timeout 120 -r C:\slave\test\build\tests\config\mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:02:16 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 22:02:16 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-162\\AppData\\Roaming', 22:02:16 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 22:02:16 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 22:02:16 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 22:02:16 INFO - 'COMPUTERNAME': 'T-W864-IX-162', 22:02:16 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 22:02:16 INFO - 'DCLOCATION': 'SCL3', 22:02:16 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 22:02:16 INFO - 'FP_NO_HOST_CHECK': 'NO', 22:02:16 INFO - 'HOMEDRIVE': 'C:', 22:02:16 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-162', 22:02:16 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 22:02:16 INFO - 'KTS_VERSION': '1.19c', 22:02:16 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-162\\AppData\\Local', 22:02:16 INFO - 'LOGONSERVER': '\\\\T-W864-IX-162', 22:02:16 INFO - 'MONDIR': 'C:\\Monitor_config\\', 22:02:16 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 22:02:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:16 INFO - 'MOZ_NO_REMOTE': '1', 22:02:16 INFO - 'NO_EM_RESTART': '1', 22:02:16 INFO - 'NUMBER_OF_PROCESSORS': '8', 22:02:16 INFO - 'OS': 'Windows_NT', 22:02:16 INFO - 'OURDRIVE': 'C:', 22:02:16 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 22:02:16 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 22:02:16 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 22:02:16 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 22:02:16 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 22:02:16 INFO - 'PROCESSOR_LEVEL': '6', 22:02:16 INFO - 'PROCESSOR_REVISION': '1e05', 22:02:16 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 22:02:16 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 22:02:16 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 22:02:16 INFO - 'PROGRAMW6432': 'C:\\Program Files', 22:02:16 INFO - 'PROMPT': '$P$G', 22:02:16 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 22:02:16 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 22:02:16 INFO - 'PUBLIC': 'C:\\Users\\Public', 22:02:16 INFO - 'PWD': 'C:\\slave\\test', 22:02:16 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 22:02:16 INFO - 'SLAVEDIR': 'C:\\slave\\', 22:02:16 INFO - 'SYSTEMDRIVE': 'C:', 22:02:16 INFO - 'SYSTEMROOT': 'C:\\windows', 22:02:16 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 22:02:16 INFO - 'TEST1': 'testie', 22:02:16 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 22:02:16 INFO - 'USERDOMAIN': 'T-W864-IX-162', 22:02:16 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-162', 22:02:16 INFO - 'USERNAME': 'cltbld', 22:02:16 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-162', 22:02:16 INFO - 'WINDIR': 'C:\\windows', 22:02:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 22:02:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:17 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 22:02:17 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-zjwytw-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 22:02:17 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 22:02:17 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-uqszwr-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 22:02:17 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 22:02:17 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-m9_um9-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 22:02:17 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 22:02:17 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-uoaomj-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 22:02:17 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 22:02:17 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-wmqsls-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 22:02:17 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 22:02:17 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-c9oids-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 22:02:17 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 22:02:17 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-eskqh4-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 22:02:18 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 22:02:18 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qs0m2j-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 22:02:18 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 22:02:18 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-wb3625-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 22:02:18 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 22:02:18 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-2_aqgv-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 22:02:18 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 22:02:18 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-lrc367-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 22:02:18 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 22:02:18 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-gvgyr6-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 22:02:18 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 22:02:18 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-grtpu1-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 22:02:18 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 22:02:18 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-z5bvpc-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 22:02:18 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 22:02:18 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-_llzcw-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 22:02:18 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 22:02:18 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-h57dpm-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 22:02:19 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 22:02:19 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qc4quw-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 22:02:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:02:19 INFO - Running setup.py install for manifestparser 22:02:19 INFO - Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts 22:02:19 INFO - Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts 22:02:19 INFO - Running setup.py install for mozcrash 22:02:20 INFO - Running setup.py install for mozdebug 22:02:20 INFO - Running setup.py install for mozdevice 22:02:20 INFO - Installing sutini-script.py script to C:\slave\test\build\venv\Scripts 22:02:20 INFO - Installing sutini.exe script to C:\slave\test\build\venv\Scripts 22:02:20 INFO - Installing dm-script.py script to C:\slave\test\build\venv\Scripts 22:02:20 INFO - Installing dm.exe script to C:\slave\test\build\venv\Scripts 22:02:21 INFO - Running setup.py install for mozfile 22:02:21 INFO - Running setup.py install for mozhttpd 22:02:21 INFO - Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts 22:02:21 INFO - Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts 22:02:22 INFO - Running setup.py install for mozinfo 22:02:22 INFO - Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts 22:02:22 INFO - Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts 22:02:22 INFO - Running setup.py install for mozInstall 22:02:22 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts 22:02:22 INFO - Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts 22:02:22 INFO - Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts 22:02:22 INFO - Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts 22:02:22 INFO - Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts 22:02:22 INFO - Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts 22:02:22 INFO - Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts 22:02:22 INFO - Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts 22:02:23 INFO - Running setup.py install for mozleak 22:02:23 INFO - Running setup.py install for mozlog 22:02:23 INFO - Installing structlog-script.py script to C:\slave\test\build\venv\Scripts 22:02:23 INFO - Installing structlog.exe script to C:\slave\test\build\venv\Scripts 22:02:24 INFO - Running setup.py install for moznetwork 22:02:24 INFO - Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts 22:02:24 INFO - Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts 22:02:24 INFO - Running setup.py install for mozprocess 22:02:25 INFO - Running setup.py install for mozprofile 22:02:25 INFO - Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts 22:02:25 INFO - Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts 22:02:25 INFO - Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts 22:02:25 INFO - Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts 22:02:25 INFO - Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts 22:02:25 INFO - Installing view-profile.exe script to C:\slave\test\build\venv\Scripts 22:02:25 INFO - Running setup.py install for mozrunner 22:02:26 INFO - Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts 22:02:26 INFO - Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts 22:02:26 INFO - Running setup.py install for mozscreenshot 22:02:27 INFO - Running setup.py install for moztest 22:02:27 INFO - Running setup.py install for mozversion 22:02:27 INFO - Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts 22:02:27 INFO - Installing mozversion.exe script to C:\slave\test\build\venv\Scripts 22:02:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:02:27 INFO - Cleaning up... 22:02:27 INFO - Return code: 0 22:02:27 INFO - Installing None into virtualenv C:\slave\test\build/venv 22:02:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:02:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:27 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022BC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0233DE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x028058F8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02318E90>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01CBA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02844520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-162', 'USERDOMAIN': 'T-W864-IX-162', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-162', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-162\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-162', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-162', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-162', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-162\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 22:02:27 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in C:\slave\test\build\tests\config 22:02:27 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 -r C:\slave\test\build\tests\config\mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:02:27 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 22:02:27 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-162\\AppData\\Roaming', 22:02:27 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 22:02:27 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 22:02:27 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 22:02:27 INFO - 'COMPUTERNAME': 'T-W864-IX-162', 22:02:27 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 22:02:27 INFO - 'DCLOCATION': 'SCL3', 22:02:27 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 22:02:27 INFO - 'FP_NO_HOST_CHECK': 'NO', 22:02:27 INFO - 'HOMEDRIVE': 'C:', 22:02:27 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-162', 22:02:27 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 22:02:27 INFO - 'KTS_VERSION': '1.19c', 22:02:27 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-162\\AppData\\Local', 22:02:27 INFO - 'LOGONSERVER': '\\\\T-W864-IX-162', 22:02:27 INFO - 'MONDIR': 'C:\\Monitor_config\\', 22:02:27 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 22:02:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:27 INFO - 'MOZ_NO_REMOTE': '1', 22:02:27 INFO - 'NO_EM_RESTART': '1', 22:02:27 INFO - 'NUMBER_OF_PROCESSORS': '8', 22:02:27 INFO - 'OS': 'Windows_NT', 22:02:27 INFO - 'OURDRIVE': 'C:', 22:02:27 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 22:02:27 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 22:02:27 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 22:02:27 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 22:02:27 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 22:02:27 INFO - 'PROCESSOR_LEVEL': '6', 22:02:27 INFO - 'PROCESSOR_REVISION': '1e05', 22:02:27 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 22:02:27 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 22:02:27 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 22:02:27 INFO - 'PROGRAMW6432': 'C:\\Program Files', 22:02:27 INFO - 'PROMPT': '$P$G', 22:02:27 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 22:02:27 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 22:02:27 INFO - 'PUBLIC': 'C:\\Users\\Public', 22:02:27 INFO - 'PWD': 'C:\\slave\\test', 22:02:27 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 22:02:27 INFO - 'SLAVEDIR': 'C:\\slave\\', 22:02:27 INFO - 'SYSTEMDRIVE': 'C:', 22:02:27 INFO - 'SYSTEMROOT': 'C:\\windows', 22:02:27 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 22:02:27 INFO - 'TEST1': 'testie', 22:02:27 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 22:02:27 INFO - 'USERDOMAIN': 'T-W864-IX-162', 22:02:27 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-162', 22:02:27 INFO - 'USERNAME': 'cltbld', 22:02:27 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-162', 22:02:27 INFO - 'WINDIR': 'C:\\windows', 22:02:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 22:02:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:28 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 22:02:28 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-spyk2l-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 22:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///C:/slave/test/build/tests/mozbase/manifestparser in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 1)) 22:02:28 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 22:02:28 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-h1hoee-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 22:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///C:/slave/test/build/tests/mozbase/mozcrash in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2)) 22:02:28 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 22:02:28 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-19hpzd-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 22:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///C:/slave/test/build/tests/mozbase/mozdebug in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 3)) 22:02:28 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 22:02:28 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-va9ljt-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 22:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///C:/slave/test/build/tests/mozbase/mozdevice in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4)) 22:02:28 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 22:02:28 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-3mpzne-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 22:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///C:/slave/test/build/tests/mozbase/mozfile in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 5)) 22:02:28 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 22:02:28 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-hptdqz-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 22:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///C:/slave/test/build/tests/mozbase/mozhttpd in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 6)) 22:02:28 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 22:02:28 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-r25r6m-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 22:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///C:/slave/test/build/tests/mozbase/mozinfo in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 7)) 22:02:29 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 22:02:29 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-bfehdg-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 22:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///C:/slave/test/build/tests/mozbase/mozinstall in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 8)) 22:02:29 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 22:02:29 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-_bez1i-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 22:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///C:/slave/test/build/tests/mozbase/mozleak in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 9)) 22:02:29 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 22:02:29 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-b0fm_d-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 22:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///C:/slave/test/build/tests/mozbase/mozlog in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10)) 22:02:29 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 22:02:29 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-bgorfz-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 22:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///C:/slave/test/build/tests/mozbase/moznetwork in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 11)) 22:02:29 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 22:02:29 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-5zzqar-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 22:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///C:/slave/test/build/tests/mozbase/mozprocess in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 12)) 22:02:29 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 22:02:29 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-hf6qax-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 22:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///C:/slave/test/build/tests/mozbase/mozprofile in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 13)) 22:02:29 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 22:02:29 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-iz4ydu-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 22:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///C:/slave/test/build/tests/mozbase/mozrunner in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 14)) 22:02:29 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 22:02:29 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-23uyfe-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 22:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///C:/slave/test/build/tests/mozbase/mozscreenshot in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 15)) 22:02:30 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 22:02:30 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-twce4n-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 22:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///C:/slave/test/build/tests/mozbase/moztest in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 16)) 22:02:30 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 22:02:30 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-fa0d1e-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 22:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///C:/slave/test/build/tests/mozbase/mozversion in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 17)) 22:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==0.17->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2)) 22:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==0.17->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2)) 22:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in c:\slave\test\build\venv\lib\site-packages (from mozdebug==0.1->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 3)) 22:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test\build\venv\lib\site-packages (from mozdevice==0.48->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4)) 22:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in c:\slave\test\build\venv\lib\site-packages (from mozdevice==0.48->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4)) 22:02:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10)) 22:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:02:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:02:31 INFO - Downloading blessings-1.6.tar.gz 22:02:31 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings 22:02:31 INFO - Installing collected packages: blessings 22:02:31 INFO - Running setup.py install for blessings 22:02:31 INFO - Successfully installed blessings 22:02:31 INFO - Cleaning up... 22:02:34 INFO - Return code: 0 22:02:34 INFO - Done creating virtualenv C:\slave\test\build/venv. 22:02:34 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 22:02:34 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 22:02:35 INFO - Reading from file tmpfile_stdout 22:02:35 INFO - Using _rmtree_windows ... 22:02:35 INFO - Using _rmtree_windows ... 22:02:35 INFO - Current package versions: 22:02:35 INFO - blessings == 1.6 22:02:35 INFO - blobuploader == 1.2.4 22:02:35 INFO - docopt == 0.6.1 22:02:35 INFO - functools32 == 3.2.3-2 22:02:35 INFO - jsonschema == 2.5.1 22:02:35 INFO - manifestparser == 1.1 22:02:35 INFO - mozInstall == 1.12 22:02:35 INFO - mozcrash == 0.17 22:02:35 INFO - mozdebug == 0.1 22:02:35 INFO - mozdevice == 0.48 22:02:35 INFO - mozfile == 1.2 22:02:35 INFO - mozhttpd == 0.7 22:02:35 INFO - mozinfo == 0.9 22:02:35 INFO - mozleak == 0.1 22:02:35 INFO - mozlog == 3.4 22:02:35 INFO - moznetwork == 0.27 22:02:35 INFO - mozprocess == 0.23 22:02:35 INFO - mozprofile == 0.28 22:02:35 INFO - mozrunner == 6.12 22:02:35 INFO - mozscreenshot == 0.1 22:02:35 INFO - mozsystemmonitor == 0.3 22:02:35 INFO - moztest == 0.7 22:02:35 INFO - mozversion == 1.4 22:02:35 INFO - psutil == 3.1.1 22:02:35 INFO - requests == 1.2.3 22:02:35 INFO - Installing None into virtualenv C:\slave\test\build/venv 22:02:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:02:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:02:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:35 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\talos\\requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022BC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0233DE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x028058F8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02318E90>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01CBA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02844520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build\\tests\\talos', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-162', 'USERDOMAIN': 'T-W864-IX-162', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-162', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-162\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-162', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-162', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-162', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-162\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 22:02:35 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\talos\\requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in C:\slave\test\build\tests\talos 22:02:35 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 -r C:\slave\test\build\tests\talos\requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:02:35 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 22:02:35 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-162\\AppData\\Roaming', 22:02:35 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 22:02:35 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 22:02:35 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 22:02:35 INFO - 'COMPUTERNAME': 'T-W864-IX-162', 22:02:35 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 22:02:35 INFO - 'DCLOCATION': 'SCL3', 22:02:35 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 22:02:35 INFO - 'FP_NO_HOST_CHECK': 'NO', 22:02:35 INFO - 'HOMEDRIVE': 'C:', 22:02:35 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-162', 22:02:35 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 22:02:35 INFO - 'KTS_VERSION': '1.19c', 22:02:35 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-162\\AppData\\Local', 22:02:35 INFO - 'LOGONSERVER': '\\\\T-W864-IX-162', 22:02:35 INFO - 'MONDIR': 'C:\\Monitor_config\\', 22:02:35 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 22:02:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:35 INFO - 'MOZ_NO_REMOTE': '1', 22:02:35 INFO - 'NO_EM_RESTART': '1', 22:02:35 INFO - 'NUMBER_OF_PROCESSORS': '8', 22:02:35 INFO - 'OS': 'Windows_NT', 22:02:35 INFO - 'OURDRIVE': 'C:', 22:02:35 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 22:02:35 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 22:02:35 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 22:02:35 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 22:02:35 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 22:02:35 INFO - 'PROCESSOR_LEVEL': '6', 22:02:35 INFO - 'PROCESSOR_REVISION': '1e05', 22:02:35 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 22:02:35 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 22:02:35 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 22:02:35 INFO - 'PROGRAMW6432': 'C:\\Program Files', 22:02:35 INFO - 'PROMPT': '$P$G', 22:02:35 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 22:02:35 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 22:02:35 INFO - 'PUBLIC': 'C:\\Users\\Public', 22:02:35 INFO - 'PWD': 'C:\\slave\\test', 22:02:35 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 22:02:35 INFO - 'SLAVEDIR': 'C:\\slave\\', 22:02:35 INFO - 'SYSTEMDRIVE': 'C:', 22:02:35 INFO - 'SYSTEMROOT': 'C:\\windows', 22:02:35 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 22:02:35 INFO - 'TEST1': 'testie', 22:02:35 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 22:02:35 INFO - 'USERDOMAIN': 'T-W864-IX-162', 22:02:35 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-162', 22:02:35 INFO - 'USERNAME': 'cltbld', 22:02:35 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-162', 22:02:35 INFO - 'WINDIR': 'C:\\windows', 22:02:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 22:02:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 1)) 22:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 2)) 22:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 3)) 22:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 4)) 22:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 5)) 22:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 6)) 22:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 7)) 22:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 8)) 22:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 9)) 22:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in c:\slave\test\build\venv\lib\site-packages (from mozlog>=3.1->-r C:\slave\test\build\tests\talos\requirements.txt (line 1)) 22:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test\build\venv\lib\site-packages (from mozhttpd>=0.7->-r C:\slave\test\build\tests\talos\requirements.txt (line 4)) 22:02:35 INFO - Cleaning up... 22:02:35 INFO - Return code: 0 22:02:35 INFO - Installing jsonschema into virtualenv C:\slave\test\build/venv 22:02:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:02:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:02:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:35 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022BC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0233DE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x028058F8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02318E90>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01CBA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02844520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-162', 'USERDOMAIN': 'T-W864-IX-162', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-162', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-162\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-162', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-162', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-162', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-162\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 22:02:35 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in C:\slave\test\build 22:02:35 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:02:35 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 22:02:35 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-162\\AppData\\Roaming', 22:02:35 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 22:02:35 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 22:02:35 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 22:02:35 INFO - 'COMPUTERNAME': 'T-W864-IX-162', 22:02:35 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 22:02:35 INFO - 'DCLOCATION': 'SCL3', 22:02:35 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 22:02:35 INFO - 'FP_NO_HOST_CHECK': 'NO', 22:02:35 INFO - 'HOMEDRIVE': 'C:', 22:02:35 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-162', 22:02:35 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 22:02:35 INFO - 'KTS_VERSION': '1.19c', 22:02:35 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-162\\AppData\\Local', 22:02:35 INFO - 'LOGONSERVER': '\\\\T-W864-IX-162', 22:02:35 INFO - 'MONDIR': 'C:\\Monitor_config\\', 22:02:35 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 22:02:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:35 INFO - 'MOZ_NO_REMOTE': '1', 22:02:35 INFO - 'NO_EM_RESTART': '1', 22:02:35 INFO - 'NUMBER_OF_PROCESSORS': '8', 22:02:35 INFO - 'OS': 'Windows_NT', 22:02:35 INFO - 'OURDRIVE': 'C:', 22:02:35 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 22:02:35 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 22:02:35 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 22:02:35 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 22:02:35 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 22:02:35 INFO - 'PROCESSOR_LEVEL': '6', 22:02:35 INFO - 'PROCESSOR_REVISION': '1e05', 22:02:35 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 22:02:35 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 22:02:35 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 22:02:35 INFO - 'PROGRAMW6432': 'C:\\Program Files', 22:02:35 INFO - 'PROMPT': '$P$G', 22:02:35 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 22:02:35 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 22:02:35 INFO - 'PUBLIC': 'C:\\Users\\Public', 22:02:35 INFO - 'PWD': 'C:\\slave\\test', 22:02:35 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 22:02:35 INFO - 'SLAVEDIR': 'C:\\slave\\', 22:02:35 INFO - 'SYSTEMDRIVE': 'C:', 22:02:35 INFO - 'SYSTEMROOT': 'C:\\windows', 22:02:35 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 22:02:35 INFO - 'TEST1': 'testie', 22:02:35 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 22:02:35 INFO - 'USERDOMAIN': 'T-W864-IX-162', 22:02:35 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-162', 22:02:35 INFO - 'USERNAME': 'cltbld', 22:02:35 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-162', 22:02:35 INFO - 'WINDIR': 'C:\\windows', 22:02:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 22:02:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in c:\slave\test\build\venv\lib\site-packages 22:02:35 INFO - Cleaning up... 22:02:35 INFO - Return code: 0 22:02:35 INFO - Running post-action listener: _resource_record_post_action 22:02:35 INFO - Running post-action listener: _start_resource_monitoring 22:02:35 INFO - Starting resource monitoring. 22:02:35 INFO - [mozharness: 2016-10-27 05:02:35.941000Z] Finished create-virtualenv step (success) 22:02:35 INFO - [mozharness: 2016-10-27 05:02:35.942000Z] Running install step. 22:02:35 INFO - Running pre-action listener: _resource_record_pre_action 22:02:35 INFO - Running main action method: install 22:02:35 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 22:02:35 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 22:02:36 INFO - Reading from file tmpfile_stdout 22:02:36 INFO - Using _rmtree_windows ... 22:02:36 INFO - Using _rmtree_windows ... 22:02:36 INFO - Detecting whether we're running mozinstall >=1.0... 22:02:36 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h'] 22:02:36 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h 22:02:36 INFO - Reading from file tmpfile_stdout 22:02:36 INFO - Output received: 22:02:36 INFO - Usage: mozinstall-script.py [options] installer 22:02:36 INFO - Options: 22:02:36 INFO - -h, --help show this help message and exit 22:02:36 INFO - -d DEST, --destination=DEST 22:02:36 INFO - Directory to install application into. [default: 22:02:36 INFO - "C:\slave\test"] 22:02:36 INFO - --app=APP Application being installed. [default: firefox] 22:02:36 INFO - Using _rmtree_windows ... 22:02:36 INFO - Using _rmtree_windows ... 22:02:36 INFO - mkdir: C:\slave\test\build\application 22:02:36 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', 'C:\\slave\\test\\build\\firefox-52.0a1.en-US.win64.zip', '--destination', 'C:\\slave\\test\\build\\application'] 22:02:36 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py C:\slave\test\build\firefox-52.0a1.en-US.win64.zip --destination C:\slave\test\build\application ProcessManager NOT managing child processes 22:02:38 INFO - Reading from file tmpfile_stdout 22:02:38 INFO - Output received: 22:02:38 INFO - C:\slave\test\build\application\firefox\firefox.exe 22:02:38 INFO - Using _rmtree_windows ... 22:02:38 INFO - Using _rmtree_windows ... 22:02:38 INFO - Running post-action listener: _resource_record_post_action 22:02:38 INFO - [mozharness: 2016-10-27 05:02:38.692000Z] Finished install step (success) 22:02:38 INFO - [mozharness: 2016-10-27 05:02:38.693000Z] Running run-tests step. 22:02:38 INFO - Running pre-action listener: _resource_record_pre_action 22:02:38 INFO - Running main action method: run_tests 22:02:38 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version'] 22:02:38 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version 22:02:38 INFO - Python 2.7.3 22:02:38 INFO - Return code: 0 22:02:38 INFO - grabbing minidump binary from tooltool 22:02:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:02:38 INFO - retry: Calling run_command with args: (['c:/mozilla-build/python27/python.exe', 'C:/mozilla-build/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', 'c:\\builds\\relengapi.tok', 'fetch', '-m', 'C:\\slave\\test\\build\\tests\\config/tooltool-manifests/win32/releng.manifest', '-o'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02318E90>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01CBA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02844520>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1 22:02:38 INFO - Running command: ['c:/mozilla-build/python27/python.exe', 'C:/mozilla-build/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', 'c:\\builds\\relengapi.tok', 'fetch', '-m', 'C:\\slave\\test\\build\\tests\\config/tooltool-manifests/win32/releng.manifest', '-o'] in C:\slave\test\build 22:02:38 INFO - Copy/paste: c:/mozilla-build/python27/python.exe C:/mozilla-build/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file c:\builds\relengapi.tok fetch -m C:\slave\test\build\tests\config/tooltool-manifests/win32/releng.manifest -o 22:02:38 INFO - Calling ['c:/mozilla-build/python27/python.exe', 'C:/mozilla-build/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', 'c:\\builds\\relengapi.tok', 'fetch', '-m', 'C:\\slave\\test\\build\\tests\\config/tooltool-manifests/win32/releng.manifest', '-o'] with output_timeout 600 ProcessManager UNABLE to use job objects to manage child processes 22:02:38 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 22:02:39 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmpmyehp5 22:02:39 INFO - INFO - File integrity verified, renaming tmpmyehp5 to win32-minidump_stackwalk.exe 22:02:39 INFO - Return code: 0 22:02:39 INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755 22:02:39 INFO - mkdir: C:\slave\test\build\blobber_upload_dir 22:02:39 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir 22:02:39 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe 22:02:39 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir 22:02:39 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NYDovZ6hSWGqwBVKNxBVyw/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-162', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs_errorsummary.log', '--log-raw=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs_raw.log'] in C:\slave\test\build 22:02:39 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\tests\talos\talos\run_tests.py --branchName Firefox --suite dromaeojs --executablePath C:\slave\test\build\application\firefox\firefox --symbolsPath https://queue.taskcluster.net/v1/task/NYDovZ6hSWGqwBVKNxBVyw/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip --title T-W864-IX-162 --webServer localhost --log-tbpl-level=debug --log-errorsummary=C:\slave\test\build\blobber_upload_dir\dromaeojs_errorsummary.log --log-raw=C:\slave\test\build\blobber_upload_dir\dromaeojs_raw.log 22:02:39 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 22:02:39 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-162\\AppData\\Roaming', 22:02:39 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 22:02:39 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 22:02:39 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 22:02:39 INFO - 'COMPUTERNAME': 'T-W864-IX-162', 22:02:39 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 22:02:39 INFO - 'DCLOCATION': 'SCL3', 22:02:39 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 22:02:39 INFO - 'FP_NO_HOST_CHECK': 'NO', 22:02:39 INFO - 'HOMEDRIVE': 'C:', 22:02:39 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-162', 22:02:39 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 22:02:39 INFO - 'KTS_VERSION': '1.19c', 22:02:39 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-162\\AppData\\Local', 22:02:39 INFO - 'LOGONSERVER': '\\\\T-W864-IX-162', 22:02:39 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir', 22:02:39 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe', 22:02:39 INFO - 'MONDIR': 'C:\\Monitor_config\\', 22:02:39 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 22:02:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:39 INFO - 'MOZ_NO_REMOTE': '1', 22:02:39 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir', 22:02:39 INFO - 'NO_EM_RESTART': '1', 22:02:39 INFO - 'NUMBER_OF_PROCESSORS': '8', 22:02:39 INFO - 'OS': 'Windows_NT', 22:02:39 INFO - 'OURDRIVE': 'C:', 22:02:39 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 22:02:39 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 22:02:39 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 22:02:39 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 22:02:39 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 22:02:39 INFO - 'PROCESSOR_LEVEL': '6', 22:02:39 INFO - 'PROCESSOR_REVISION': '1e05', 22:02:39 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 22:02:39 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 22:02:39 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 22:02:39 INFO - 'PROGRAMW6432': 'C:\\Program Files', 22:02:39 INFO - 'PROMPT': '$P$G', 22:02:39 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 22:02:39 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 22:02:39 INFO - 'PUBLIC': 'C:\\Users\\Public', 22:02:39 INFO - 'PWD': 'C:\\slave\\test', 22:02:39 INFO - 'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos', 22:02:39 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 22:02:39 INFO - 'SLAVEDIR': 'C:\\slave\\', 22:02:39 INFO - 'SYSTEMDRIVE': 'C:', 22:02:39 INFO - 'SYSTEMROOT': 'C:\\windows', 22:02:39 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 22:02:39 INFO - 'TEST1': 'testie', 22:02:39 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 22:02:39 INFO - 'USERDOMAIN': 'T-W864-IX-162', 22:02:39 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-162', 22:02:39 INFO - 'USERNAME': 'cltbld', 22:02:39 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-162', 22:02:39 INFO - 'WINDIR': 'C:\\windows', 22:02:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 22:02:39 INFO - Calling ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NYDovZ6hSWGqwBVKNxBVyw/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-162', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs_errorsummary.log', '--log-raw=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs_raw.log'] with output_timeout 3600 ProcessManager NOT managing child processes ProcessManager UNABLE to use job objects to manage child processes 22:02:40 INFO - mozversion application_buildid: 20161026193001 22:02:40 INFO - mozversion application_changeset: 3f4c3a3cabaf94958834d3a8935adfb4a887942d 22:02:40 INFO - mozversion application_display_name: Nightly 22:02:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:02:40 INFO - mozversion application_name: Firefox 22:02:40 INFO - mozversion application_remotingname: firefox 22:02:40 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:02:40 INFO - mozversion application_vendor: Mozilla 22:02:40 INFO - mozversion application_version: 52.0a1 22:02:40 INFO - mozversion platform_buildid: 20161026193001 22:02:40 INFO - mozversion platform_changeset: 3f4c3a3cabaf94958834d3a8935adfb4a887942d 22:02:40 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:02:40 INFO - mozversion platform_version: 52.0a1 22:02:40 INFO - using testdate: 1477544560 22:02:40 INFO - actual date: 1477544560 22:02:40 INFO - starting webserver on 'localhost:49237' 22:02:40 INFO - SUITE-START | Running 2 tests 22:02:40 INFO - TEST-START | dromaeo_css 22:02:40 INFO - operating with platform_type : w8_ 22:02:40 INFO - Initialising browser for dromaeo_css test... 22:02:40 INFO - TEST-INFO | started process 4212 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpbrfkd1\profile http://localhost:49237/getInfo.html) 22:02:48 INFO - PROCESS | 4212 | __metrics Screen width/height:1600/1200 22:02:48 INFO - PROCESS | 4212 | colorDepth:24 22:02:48 INFO - PROCESS | 4212 | Browser inner width/height: 1010/674 22:02:48 INFO - PROCESS | 4212 | __metrics 22:02:50 INFO - PROCESS | 4212 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:02:50 INFO - PROCESS | 4212 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:02:51 INFO - TEST-INFO | 4212: exit 0 22:02:51 INFO - Browser initialized. 22:02:51 INFO - Running cycle 1/1 for dromaeo_css test... 22:02:51 INFO - TEST-INFO | started process 3424 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpbrfkd1\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:02:52 INFO - PROCESS | 3424 | [GFX1-]: Invalid size in UpdateRenderTarget Size(124,0), 0 22:03:02 INFO - PROCESS | 3424 | RSS: Main: 160665600 22:03:02 INFO - PROCESS | 3424 | 22:03:53 INFO - PROCESS | 3424 | 1477544633702 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 22:06:05 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49237/tests/dromaeo/cssquery-ext.html) 22:06:07 INFO - PROCESS | 3424 | RSS: Main: 321216512 22:06:07 INFO - PROCESS | 3424 | 22:09:10 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-ext.html (next: http://localhost:49237/tests/dromaeo/cssquery-jquery.html) 22:09:10 INFO - PROCESS | 3424 | RSS: Main: 227082240 22:09:10 INFO - PROCESS | 3424 | 22:12:12 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49237/tests/dromaeo/cssquery-mootools.html) 22:12:13 INFO - PROCESS | 3424 | RSS: Main: 188178432 22:12:13 INFO - PROCESS | 3424 | 22:15:15 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49237/tests/dromaeo/cssquery-prototype.html) 22:15:16 INFO - PROCESS | 3424 | RSS: Main: 175788032 22:15:16 INFO - PROCESS | 3424 | 22:18:19 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49237/tests/dromaeo/cssquery-yui.html) 22:18:19 INFO - PROCESS | 3424 | RSS: Main: 162074624 22:18:19 INFO - PROCESS | 3424 | 22:21:22 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-yui.html (next: http://localhost:49237/tests/dromaeo/cssquery-dojo.html) 22:21:22 INFO - PROCESS | 3424 | RSS: Main: 243679232 22:21:22 INFO - PROCESS | 3424 | 22:21:22 INFO - PROCESS | 3424 | __start_tp_report 22:21:22 INFO - PROCESS | 3424 | _x_x_mozilla_page_load 22:21:22 INFO - PROCESS | 3424 | _x_x_mozilla_page_load_details 22:21:22 INFO - PROCESS | 3424 | |i|pagename|runs| 22:21:22 INFO - PROCESS | 3424 | |0;dojo.html;2883.4521440926223;2895.0591057906186;2914.9854250728745;2931.6775154732977;2945.440366330397;5182.689038657679;5219.42586315505;5278.683279003262;5292.659372168737;5340.54605358544;5167.638265321429;5194.986977539382;5242.68543887367;5246.239295302179;5287.995280896627;4675.929861052087;4693.342931989524;4700.623950083985;4711.787969541362;4759.428868535781;4744.715317080969;4754.477007529186;4766.094442055998;4767.451743049559;4778.928316075262;4616.1229366420275;4646.581807637312;4694.061187762444;4760.166970780099;4773.785179666923;4680.625549956029;4683.929741053904;4724.622030237607;4757.357756702835;4800.207965685658;4460.1525710114975;4521;4646.53534646536;4650.18621741194;4715.575598196145;5128.1794912813775;5150.716710580917;5158.97420512895;5195.19474481456;5210.973945130288;5510.724463776795;5578.30271216098;5584.720763961785;5599.608027438081;5602.85992850182;5536.252605898192;5538.556915446795;5632.577556683265;5639.774409023634;5690.487856092972;5149.0474262261605;5192.376914770214;5197.610179236573;5198.636095473356;5253.23828044939;5730.856728581819;5736.282964629421;5767.596268261182;5775.364709881909;5779.306483222041;5172.172452407597;5482.753276102585;5495.450454954553;5497.065498865202;5516.531094856982;5504.4495550444635;5505.788726480168;5555.2778138842505;5650.773969041193;5658.7170641467765;5542.39033706292;5551.805686800943;5567.49892509668;5574.024545704567;5577.330720313588;5508.834734957958;5526.530244929146;5562.527185189223;5562.638428502134;5637.379888212294;3599.4240921452442;3628.2017956049626;3628.7097032237357;3656.8537258509364;3657.4330978697812;3329.4506406442665;3332.183615014337;3342.5153352763714;3350.0284917373688;3360.1767566945764;5217.50433708797;5230.843074707765;5276.81531146408;5295.443978382292;5341.305630268118;5696.401877802854;5705.286839145107;5709.257796486513;5711.057675483582;5713.771449141987;5247.16045432729;5268.578513718893;5268.683878967274;5280.762365693553;5302.496262855023;4454.465464144323;4549.522300158502;4576.107659006462;4583.381243532081;4583.679142460062;5678.3186017678145;5685;5690.800821971211;5720.342160651495;5754.712264386764;5553.611247212656;5588.41321661236;5600.551955843604;5603.439656034527;5609.88780224385;5653.632513886584;5675.943240567707;5710.314762228393;5736.311642602915;5736.856578585402;5567.610267281251;5569.63797353187;5578.553715702815;5579.832605021856;5580.693061881473;5622.072358060874;5655.773769049192;5680.545556355399;5685.630434021776;5690.573207009408;5439.456054394687;5488.17677348401;5507.972460137674;5514.393416724077;5518.862028449321;5512.062949298549;5514.393416724077;5514.834554963358;5516.724163791875;5567.164925261243;5380.973095134499;5414.810481633124;5425.701586412785;5439.292891924183;5439.67361958268;5427.267318912054;5472.699001554953;5494.532964698045;5521.917171242354;5577.107662773937;5440.945590544202;5463.453654634504;5481.616286860041;5552.69460179694;5568.053430916673 22:21:22 INFO - PROCESS | 3424 | |1;ext.html;549.9945000549994;569.4391024840534;574.3481148896003;577.8555361159711;588.3116753398523;29127.271818204554;31600;31657.52513712296;31687.841560792192;31692.36615267699;31908.20229494264;38784;38910.22179556407;39277.60722392775;42639;8287.627056782445;8381.371397145238;8408.327333813311;8411.116832732536;8412.1587841216;8206.507609543447;8289;8296.58517074147;8300.169983001711;8308.169183081704;7561.2060733623;7721.9227807722045;9874.802503949917;9996.90003099967;10120.746981325488;9868.753281168028;9883.258755593324;9919.20646348294;9933.552990115462;9953.950230248875;9822.508874556244;9831.950840245752;9858.112769850748;9877.703668889944;9913.75215619608;29430.411391772257;30073.646685899188;36286.81856590726;37019.4447083294;37383;3007.45865744166;3347.2301370684636;3506.947395789065;3541.2917416516543;3613.7289703272095;29028.854855725796;29867.16261955111;29928.401431971237;29945.251368715737;30678.693213067807;3998.1603863188766;4022.155347377054;4031.133306339151;4121.402396652468;4137.937930931039;281203;281327;281461;281504;281872;46064;47821.521784781704;47833.76083119562;48408.27387589189;48559;50776.74611626992;50805.491945080816;51117;51252.74373628108;51309.23036154461;13943.860561394256;14190.077644953046;14223.431062757581;14230.786538201935;14251.714965700836;10723.678289651323;11001.724956876142;11025.724356890982;11039.944800275947;11055.281406708538;13250.138740981805;14765.40938362475;14817.555473335817;14847.70304593902;14929.925350373396;4893.965741240382;5131.179011358239;5276.604254680914;5288.206768984683;5391.811286605029;742.9405647548183;825.3974598543098;857.1514200941024;891.2825175733597;902.8194361127801;26324.21027369182;27045.459090818073;27285.1814445563;27297.590536141975;27630.585541216897;871.4074429388077;894.959726812282;902.4630344944748;910.5401772105045;912.5991602889533;13487.25820079905;13803.17180969145;13908.791368129487;13925.860741392456;13993.860061399255;419980;423449;426089;428665;430670;43098.56901431008;46508.302375464395;46520.7673961628;46860;47116;1133.625903451859;1157.3576664950697;1177.9928161422033;1180.0677464802882;1183.2308999150448;27374.726252738015;27743.44513109767;27893.58159627648;28390.148295551167;28498.287542811595;42394.78802605967;43029.35455968101;43042.35436468518;43392.78303608462;43543.782281088395;358882;359904;360872;360898;360978;23439.179628712915;24133.637995430432;24449.755502444747;24452.26643200707;24463.021479140636;39269.803650981565;39719.80140099281;40196.598034019284;40470;40970;35362.29275414529;35364.646353537166;36223.27553448864;36322.09194770152;36733;34729.65270347365;34872.47691284683;35010.474842876865;35512.822435887654;35526.269741676755;33809.49285760765;34117.829410852784;34148.65851341455;35221.64778352184;36555.268894621426;30929;32147.78246357393;32370.83814580912;32400.83799580987;32403.837980810888;24152.275431737075;24312.513749724552;24415.51168976646;24416.26751197467;24673.62989555194 22:21:22 INFO - PROCESS | 3424 | |2;jquery.html;315.57397513356955;330.19597280621673;336.2501621384314;337.46343314130536;349.77090006046046;13052.934735326335;14151.363188656509;16161.83838161618;16496.67006659866;17263.654726905454;14689.559313220594;14732.926335368307;14895.10629362239;14920.552383428487;14930.253487325645;4973.900521989558;5061.215511595708;5287.735613219343;5291.074062039147;5300.840974770763;4822.831200907969;5203.583713302926;5215.86960325993;5223.347081614798;5233.110371236899;5169.81905633301;5170.844874653766;5171.7414129293575;5183.974080129594;5187.144121220013;4907.852764417074;5147.816002319469;5175.896482070356;5220.738963051832;5227.947720522784;4824.2040063389495;5047.343845300087;5069.315642388267;5080;5088.898222035576;10736.409497477636;10938.195197792355;10942;10944.17918656096;10956.780864382668;1889.3576184097474;1935.912883920227;1956.6771482705337;2111.4510227340847;2230;10051.899481005243;12401.503939842396;12626.368681565886;12946.87053129466;13193.802092968614;1748.5191572317588;1755.5962128710341;1806.0788997611312;1808.7919889212778;1831.377331707226;67937.66031169813;70757;71516;72596.27403726001;72921.27078729251;9251.861222081674;9263.95368023169;9387.436753794795;9482.810343793086;9524.095210955087;12573.937130314473;12577.245365278113;12588;12594.937025314815;12598.55905043319;6358.809235722936;6586.571872828251;6690.431313338421;6704.061431399608;6730.259671436138;6307.62154270736;6321.399467050623;6382.329855365213;6388.968055159695;6391.616503009835;3804.543454785388;3930.665893399036;3931.8230679619487;4001.2197621463533;4065.9593404066172;1553.5727674889497;1561.5237352607564;1600.91194984277;1626.3738460692718;1640.753886916972;718.8708564393093;735.6910097758954;813.276184196066;833.6623667414707;871.2768402226137;16059.27733251983;16190;16300.429484968206;16319;16608.25262863174;793.5952664141214;816.4488969945382;818.9721899016696;842.9620667069996;848.898132224137;8686.435381700296;8735.213830755263;8820.735377938672;8870.467771933705;9154.542272886329;400023;434238;441450;443872;447128;79718.60140699375;91393.54303228442;91740;91963;92057.539712301;801.8436404901105;801.9975031210986;811.5374236685033;829.1468567751072;864.7708357285325;14735.410583576537;15153.696926061637;15210.923945380202;15232;15362.923185384001;35758.4636230462;36310;37035.444468332455;37180.25639487249;37328.44007339838;52234.47765522296;53084.20373694475;53835.500692454865;53956.66909948955;53977.46022539881;6718.966405168138;6801.251862295243;6891.138607674041;6986.161660600557;7240.565566066053;8070.43506954531;10944.78110437771;11146.990312615386;11170.832437513607;11466.885331146581;9370.437773733598;9401;9945.403275803475;9997.700068997941;10100.242481813746;9622.326437149331;9789.265805064506;9899.307048506824;9905.207583393456;10011.799764004825;9790.167835734042;9814.950925245328;10012.649557265751;10073.372591915599;10174;6752;6858.828529286808;6867.759628413181;6929.099217101744;7032.894506582507;9348.672796452092;9421.905780942378;9467.66863159786;9514.096160864707;9883.752906177404 22:21:22 INFO - PROCESS | 3424 | |3;mootools.html;1161.3148242536902;1232.0143884892086;1248.4694005047852;1276.4638851682294;1441.7765246386814;6497.382748638877;6959.930400695992;7255.310745479184;7259.310365515281;7507.512011719235;7437.033185685867;7499.100107987049;7508.81227969301;7511.136219334778;7511.812204694886;2005.6289586426485;2021.9696704549444;2021.9797802022013;2022.7673817510954;2032.979670203301;1928.6046360496134;1958.1677786940566;1968.3406058970263;1969.5863868587614;1976.2292705844732;1921.3275353626188;1925.124068548814;1936.4287535177157;1951.2877799603184;1952.160570954496;1858.814118588137;1864.7855496617792;1869.9065046747676;1874.2315650583264;1875.4186202277338;1888.8016758240462;1889;1914.9521261968423;1923.8172373624484;1927.5470264487835;7324.890126648104;7353.963230183868;7408.036955195844;7437.51656142349;7474.514156579805;4254;4427.092446048552;4430.734155950653;4433.179861725591;4435.467743870756;2787.2753084198052;2985.5820185174093;3031.03007037748;3035.711607397294;3042.2850630101907;966.1594412860856;977.3305285879125;988.1847475832467;1013.3413281367096;1023.902729240721;9626.229901607854;10014.749631259205;10155.746106347327;10169.389836609827;10222.744431389201;3575.4815551745373;3687.631236876291;3712.2389910068373;3718.8140592970244;3722.0880884183007;7916.920830791619;7917.643706033243;7927.960360198162;7945.64244608994;8025.438219324591;4327.0480494291205;4333.609975102256;4338.197433474817;4346.2828633275785;4382.07976324969;3574.392353299945;3602.657747513982;4084.3873418986796;4099.774512401847;4132.648724858421;3125.2030732163153;3155.4635711929027;3189.728873045817;3191.3776813521604;3202.4235637585457;934.4673536084503;960.0159836167844;961.9711408657752;962.5331714118647;968.1818863060703;727.9017332660023;747.1706405889458;755.1806290175222;757.049902372519;764.2663043478212;4428.645708343325;4540.114677637829;4639.373684552542;4664.207084795593;4767.165745994437;320.7786627227206;333.47977155637284;356.2909809479118;362.3966096449382;852.7058164933088;2956.9556456653168;3017.3211027518632;3069.7083777041144;3106.48742957414;3180.666030066856;8668.523231222343;8755.343349248831;9045.819083618422;9055.139761722627;9156.542172891328;9159.679411220575;9282.72151835446;9287;9302.53487325631;9306.2089722373;6874.587524748431;7080.327368899946;7080.575165490087;7082.256363081802;7098.716051357991;4400.625105760309;4404.867853964386;4473.753943533006;4475.3734477173875;4542.909141817211;8278.379121565786;8490.617922193393;8494.53280069602;8504.914950850412;8522.23299902987;8126.146754590683;8404.789880253042;8511.233988941025;8527;8574.185452382013;6441.71012304438;6577.079208910661;6577.947528395433;6581.967090164519;6617.338266173344;7266.237045110187;7274.418046556369;7336.633168341455;7341.77974660761;7407.62961851916;6275.560710750204;6436.935630643821;6477.0608261800835;6490.123833282447;6528.086067950586;6344.270408903035;6359.07793369968;6467.644279564669;6479.870402592016;6485.481161506974;5634.830955071355;5700.771969121189;5741.942580574308;5780.190773291826;5846.41535846412;3881.9417708734954;3940.15286713358;3948.526176858795;4025.2955732747237;4043.9797801011982;4060.675145988373;4067.633912947849;4080.551139374607;4133.338665813455;4142.109446468903 22:21:22 INFO - PROCESS | 3424 | |4;prototype.html;267.9674667645906;269.22194856863666;274.17063383265605;274.88729620855446;275.0908248239567;5120.462351453095;5182.637215394924;5196.662216955895;5210.973945130274;5223.373195216579;4885.706857588547;5128.846134615958;5140.845774626758;5154.046501397244;5232.1366974449265;3777.4333849922596;3782.9810850945846;3793.1275806564367;3841.78870162141;3879.2047630235875;3847.1728578355646;3853.5761066282685;3856.2094770572107;3861.1505468796818;3861.2856621524966;3825.349690552599;3830.4637350770913;3836.462895194675;3842.711796615251;3857.8842634721004;3572.7141828653644;3651.525301710774;3732.794696291703;3820.331441997639;3834.3098242316373;3327.617324007746;3330.2340461693702;3335.4830001349587;3338.4825352070466;3345.1469875181915;5016.247562865563;5019.447860735316;5022.196448568248;5027.648064635477;5057.367829021372;4168.936921085104;4381.233284175257;4429.822807087713;4490.236659767847;4497.145542346976;5340.439253878326;5347.812826551091;5354.598405119632;5358.5981051421295;5380;3599.5500562429697;3631.4915911772373;3645.7083433325533;3649.1424515238896;3660.633936606318;5596.684779076913;5635.041603158334;5648.237487939116;5762.164486149485;5803.709814509258;3622.637736226356;3624.836882340301;3631.7094632429344;3637.1634524059086;3649.4708267301626;3691.3171063353366;3710.406334986389;3711.4205627088913;3715.4241092630687;3732.7573707709457;4390.07808360248;4393.604575588212;4398.890027749332;4403.647708183337;4410.1400226956075;5220.903610241816;5385.488378604026;5396.541293990055;5431.891362172734;5442.401335853053;1281.5386460874079;1299.3568183749105;1300.9852315194164;1303.8761317674805;1313.4155300891011;769.8152443413652;798.5328582779139;798.6725442568519;803.8264134363777;811.939104567148;4997.775100120431;5125.743712814345;5130.589552835764;5131.512506311894;5154.819581314711;5469.835904922858;5477.4796394342475;5498.532624726863;5521.475459831309;5575;5043.495650435;5183.403908550489;5203.60972927032;5212.9739351303;5216.947830521722;2954.7340739333135;3006.8646910888624;3007.65411977621;3017.9849100754795;3018.23831194459;5704.4295570443455;5710.771569137271;5722.856928576819;5730.656160630376;5790.71046447676;5472.897196261682;5695.515881150149;5717.885642287131;5724.370319264877;5780.53755699543;5706.229658995982;5712.914306285409;5720;5731.3408957968695;5733.655980641175;5373.328333958255;5630.4369563045;5634.267545219095;5648.406917273627;5690.174924635988;5467.589930755289;5468.26178465902;5486.954740119272;5533.612647114664;5550.8057217997175;5595.916061259166;5733.512651424676;5743.62666426681;5764.798232062026;5772.769089236552;3753.680937120266;3754.5682246541996;3814.2371525695526;3828.9234215316096;3846.8461261549223;5542.2795036644975;5551.389347171888;5558.943800677858;5562;5593.188987596857;5401.297831282065;5417.079096553674;5427.918581221364;5435.184722291688;5442.401335853132;5152.922706159336;5360.571154307724;5396.78412863481;5426.240326354393;5434.347878254634;5302.443243459536;5305.389880163831;5306.991671582387;5322.33470816148;5334.67991920486;5232.241325007776;5277.894442111213;5356.973215134055;5382.9192562112385;5464.726763661881;5366.436524164907;5374.48942350476;5376.731163441734;5386.622936394571;5394.352677678704 22:21:22 INFO - PROCESS | 3424 | |5;yui.html;633.2938773267807;667.8864593019186;679.7484930575688;713.4827250243574;726.2483329753704;12436.626901192967;12804.167729097602;12849.100562960573;12887.162334448254;13846.446142154315;11924.642260732171;12111.48606424197;12121.939390303058;12126.636200913987;12143.27140371576;623.6195920488499;623.7785586116931;624.3475568031396;624.6033768556977;624.8375422390166;534.3961323704209;554.4870994330248;606.2149516376303;634.8412896775806;642.2742301199638;664.5912763650344;664.9268580456146;666.6400143922276;667.366002297819;667.7362441835472;662.0036844548971;662.910507081545;663.4195079305607;663.73450619752;665.0323778901686;409.45337973805005;423.2001517132622;426.29661059252174;430.06460947439194;431.74742775476386;11934.582289619908;12311.815322770166;12328.81506777399;12608.621741347773;12652.746945061139;12304.876951230463;12645.367731613382;12848.293343866084;13059.34703264833;13283.468661253635;10345.79308413835;10743.570257189704;10870.402127882964;11117.777644447066;11207.439628018567;3456.2914602506676;3458.4466485362473;3466.3760523106084;3486.825658717054;3495.7902525848276;55816.720916395156;56654.7167264161;56949.71525142348;57138.999999999585;57196.28411147631;9382.5308734563;9418.246540276761;9517.571709272961;9564.378315409476;9675.371100878421;15942;16027.839721602635;16051;16088.919555402148;16105.19474026294;7094.893576596355;7214.386777123898;7222.349988501061;7296.270372962661;7351.595662238521;4113.629773320416;4126.7523948563185;4135.069609337875;4289.249381358312;4293.8711838644895;2760.3789147441667;2849.1167738001286;2862.427514497109;2868.512352900012;2872.454233695591;493.1025533528943;494.8985457981177;498.8852563910321;507.6015327967602;512.4951922356476;568.3464016381195;582.7698059266651;626.9216347956506;652.9151210342625;662.4203821656051;8000.839983200303;8080.757577272574;8270.669173233004;8315.79420983966;8565.914340856636;639.9360063993563;651.2998526583941;674.9595024298558;675.864827034595;681.4820736240393;4185.895352616209;4214.4099826024385;4308.116836048603;4350.912271932017;4354.8911277217685;67220.6638966802;68624.31375686279;68709.65645171842;71314.64342678357;71586.21034474076;60145.39854601398;62945;63340;63618.68190659017;64083.67958160179;38841.61158388436;54143.72928135334;55079;55611.72194139003;55855.44144558503;8523.190296921783;8631.223189912938;8634.827303454022;8809.251213646912;8836.028036915806;37036;37352.43971340378;37479.81260093682;37891.62108378881;39163.41254881236;45869.77065114653;47244.29133562931;49743.75128124336;49835.25247121369;50990.490095098576;10215.94892025535;10741.355518668905;10859.945700271765;10905.945470272598;11621.024425847796;12401.565945192237;12641.523506451753;12662.810057848956;12705.872941270469;13120.868791311965;11710.355930423908;11750.706232343919;11891.881081189078;11985.760284794429;12556.937215313865;10067.647632332833;11099.500522476346;11936;12107.636770896886;12289.815652765037;11234.4382780859;11268.211225214156;11333.376664283544;11482.712932176762;11820.64538063825;9433.716988490356;9789.167920726817;9965.302428829913;10044.246681499062;10255.589776409159;9921.702348929544;9952.452615106238;10005.599776008878;10013.24900632441;10020.498975051072 22:21:22 INFO - PROCESS | 3424 | __end_tp_report 22:21:22 INFO - PROCESS | 3424 | __start_cc_report 22:21:22 INFO - PROCESS | 3424 | _x_x_mozilla_cycle_collect,2086 22:21:22 INFO - PROCESS | 3424 | __end_cc_report 22:21:22 INFO - PROCESS | 3424 | __startTimestamp1477545682640__endTimestamp 22:21:22 INFO - PROCESS | 3424 | 22:21:22 INFO - PROCESS | 3424 | ------- Summary: start ------- 22:21:22 INFO - PROCESS | 3424 | Number of tests: 6 22:21:22 INFO - PROCESS | 3424 | 22:21:22 INFO - PROCESS | 3424 | [#0] dojo.html Cycles:165 Average:5145.44 Median:5439.67 stddev:689.08 (12.7%) stddev-sans-first:667.96 22:21:22 INFO - PROCESS | 3424 | Values: 2883.5 2895.1 2915.0 2931.7 2945.4 5182.7 5219.4 5278.7 5292.7 5340.5 5167.6 5195.0 5242.7 5246.2 5288.0 4675.9 4693.3 4700.6 4711.8 4759.4 4744.7 4754.5 4766.1 4767.5 4778.9 4616.1 4646.6 4694.1 4760.2 4773.8 4680.6 4683.9 4724.6 4757.4 4800.2 4460.2 4521.0 4646.5 4650.2 4715.6 5128.2 5150.7 5159.0 5195.2 5211.0 5510.7 5578.3 5584.7 5599.6 5602.9 5536.3 5538.6 5632.6 5639.8 5690.5 5149.0 5192.4 5197.6 5198.6 5253.2 5730.9 5736.3 5767.6 5775.4 5779.3 5172.2 5482.8 5495.5 5497.1 5516.5 5504.4 5505.8 5555.3 5650.8 5658.7 5542.4 5551.8 5567.5 5574.0 5577.3 5508.8 5526.5 5562.5 5562.6 5637.4 3599.4 3628.2 3628.7 3656.9 3657.4 3329.5 3332.2 3342.5 3350.0 3360.2 5217.5 5230.8 5276.8 5295.4 5341.3 5696.4 5705.3 5709.3 5711.1 5713.8 5247.2 5268.6 5268.7 5280.8 5302.5 4454.5 4549.5 4576.1 4583.4 4583.7 5678.3 5685.0 5690.8 5720.3 5754.7 5553.6 5588.4 5600.6 5603.4 5609.9 5653.6 5675.9 5710.3 5736.3 5736.9 5567.6 5569.6 5578.6 5579.8 5580.7 5622.1 5655.8 5680.5 5685.6 5690.6 5439.5 5488.2 5508.0 5514.4 5518.9 5512.1 5514.4 5514.8 5516.7 5567.2 5381.0 5414.8 5425.7 5439.3 5439.7 5427.3 5472.7 5494.5 5521.9 5577.1 5440.9 5463.5 5481.6 5552.7 5568.1 22:21:22 INFO - PROCESS | 3424 | 22:21:22 INFO - PROCESS | 3424 | [#1] ext.html Cycles:180 Average:49602.68 Median:36255.05 stddev:95341.69 (263.0%) stddev-sans-first:95538.01 22:21:22 INFO - PROCESS | 3424 | Values: 550.0 569.4 574.3 577.9 588.3 29127.3 31600.0 31657.5 31687.8 31692.4 31908.2 38784.0 38910.2 39277.6 42639.0 8287.6 8381.4 8408.3 8411.1 8412.2 8206.5 8289.0 8296.6 8300.2 8308.2 7561.2 7721.9 9874.8 9996.9 10120.7 9868.8 9883.3 9919.2 9933.6 9954.0 9822.5 9832.0 9858.1 9877.7 9913.8 29430.4 30073.6 36286.8 37019.4 37383.0 3007.5 3347.2 3506.9 3541.3 3613.7 29028.9 29867.2 29928.4 29945.3 30678.7 3998.2 4022.2 4031.1 4121.4 4137.9 281203.0 281327.0 281461.0 281504.0 281872.0 46064.0 47821.5 47833.8 48408.3 48559.0 50776.7 50805.5 51117.0 51252.7 51309.2 13943.9 14190.1 14223.4 14230.8 14251.7 10723.7 11001.7 11025.7 11039.9 11055.3 13250.1 14765.4 14817.6 14847.7 14929.9 4894.0 5131.2 5276.6 5288.2 5391.8 742.9 825.4 857.2 891.3 902.8 26324.2 27045.5 27285.2 27297.6 27630.6 871.4 895.0 902.5 910.5 912.6 13487.3 13803.2 13908.8 13925.9 13993.9 419980.0 423449.0 426089.0 428665.0 430670.0 43098.6 46508.3 46520.8 46860.0 47116.0 1133.6 1157.4 1178.0 1180.1 1183.2 27374.7 27743.4 27893.6 28390.1 28498.3 42394.8 43029.4 43042.4 43392.8 43543.8 358882.0 359904.0 360872.0 360898.0 360978.0 23439.2 24133.6 24449.8 24452.3 24463.0 39269.8 39719.8 40196.6 40470.0 40970.0 35362.3 35364.6 36223.3 36322.1 36733.0 34729.7 34872.5 35010.5 35512.8 35526.3 33809.5 34117.8 34148.7 35221.6 36555.3 30929.0 32147.8 32370.8 32400.8 32403.8 24152.3 24312.5 24415.5 24416.3 24673.6 22:21:22 INFO - PROCESS | 3424 | 22:21:22 INFO - PROCESS | 3424 | [#2] jquery.html Cycles:180 Average:25386.46 Median:5171.29 stddev:71797.31 (1388.4%) stddev-sans-first:71974.04 22:21:22 INFO - PROCESS | 3424 | Values: 315.6 330.2 336.3 337.5 349.8 13052.9 14151.4 16161.8 16496.7 17263.7 14689.6 14732.9 14895.1 14920.6 14930.3 4973.9 5061.2 5287.7 5291.1 5300.8 4822.8 5203.6 5215.9 5223.3 5233.1 5169.8 5170.8 5171.7 5184.0 5187.1 4907.9 5147.8 5175.9 5220.7 5227.9 4824.2 5047.3 5069.3 5080.0 5088.9 10736.4 10938.2 10942.0 10944.2 10956.8 1889.4 1935.9 1956.7 2111.5 2230.0 10051.9 12401.5 12626.4 12946.9 13193.8 1748.5 1755.6 1806.1 1808.8 1831.4 67937.7 70757.0 71516.0 72596.3 72921.3 9251.9 9264.0 9387.4 9482.8 9524.1 12573.9 12577.2 12588.0 12594.9 12598.6 6358.8 6586.6 6690.4 6704.1 6730.3 6307.6 6321.4 6382.3 6389.0 6391.6 3804.5 3930.7 3931.8 4001.2 4066.0 1553.6 1561.5 1600.9 1626.4 1640.8 718.9 735.7 813.3 833.7 871.3 16059.3 16190.0 16300.4 16319.0 16608.3 793.6 816.4 819.0 843.0 848.9 8686.4 8735.2 8820.7 8870.5 9154.5 400023.0 434238.0 441450.0 443872.0 447128.0 79718.6 91393.5 91740.0 91963.0 92057.5 801.8 802.0 811.5 829.1 864.8 14735.4 15153.7 15210.9 15232.0 15362.9 35758.5 36310.0 37035.4 37180.3 37328.4 52234.5 53084.2 53835.5 53956.7 53977.5 6719.0 6801.3 6891.1 6986.2 7240.6 8070.4 10944.8 11147.0 11170.8 11466.9 9370.4 9401.0 9945.4 9997.7 10100.2 9622.3 9789.3 9899.3 9905.2 10011.8 9790.2 9815.0 10012.6 10073.4 10174.0 6752.0 6858.8 6867.8 6929.1 7032.9 9348.7 9421.9 9467.7 9514.1 9883.8 22:21:22 INFO - PROCESS | 3424 | 22:21:22 INFO - PROCESS | 3424 | [#3] mootools.html Cycles:180 Average:4760.77 Median:4541.51 stddev:2756.91 (60.7%) stddev-sans-first:2751.37 22:21:22 INFO - PROCESS | 3424 | Values: 1161.3 1232.0 1248.5 1276.5 1441.8 6497.4 6959.9 7255.3 7259.3 7507.5 7437.0 7499.1 7508.8 7511.1 7511.8 2005.6 2022.0 2022.0 2022.8 2033.0 1928.6 1958.2 1968.3 1969.6 1976.2 1921.3 1925.1 1936.4 1951.3 1952.2 1858.8 1864.8 1869.9 1874.2 1875.4 1888.8 1889.0 1915.0 1923.8 1927.5 7324.9 7354.0 7408.0 7437.5 7474.5 4254.0 4427.1 4430.7 4433.2 4435.5 2787.3 2985.6 3031.0 3035.7 3042.3 966.2 977.3 988.2 1013.3 1023.9 9626.2 10014.7 10155.7 10169.4 10222.7 3575.5 3687.6 3712.2 3718.8 3722.1 7916.9 7917.6 7928.0 7945.6 8025.4 4327.0 4333.6 4338.2 4346.3 4382.1 3574.4 3602.7 4084.4 4099.8 4132.6 3125.2 3155.5 3189.7 3191.4 3202.4 934.5 960.0 962.0 962.5 968.2 727.9 747.2 755.2 757.0 764.3 4428.6 4540.1 4639.4 4664.2 4767.2 320.8 333.5 356.3 362.4 852.7 2957.0 3017.3 3069.7 3106.5 3180.7 8668.5 8755.3 9045.8 9055.1 9156.5 9159.7 9282.7 9287.0 9302.5 9306.2 6874.6 7080.3 7080.6 7082.3 7098.7 4400.6 4404.9 4473.8 4475.4 4542.9 8278.4 8490.6 8494.5 8504.9 8522.2 8126.1 8404.8 8511.2 8527.0 8574.2 6441.7 6577.1 6577.9 6582.0 6617.3 7266.2 7274.4 7336.6 7341.8 7407.6 6275.6 6436.9 6477.1 6490.1 6528.1 6344.3 6359.1 6467.6 6479.9 6485.5 5634.8 5700.8 5741.9 5780.2 5846.4 3881.9 3940.2 3948.5 4025.3 4044.0 4060.7 4067.6 4080.6 4133.3 4142.1 22:21:22 INFO - PROCESS | 3424 | 22:21:22 INFO - PROCESS | 3424 | [#4] prototype.html Cycles:180 Average:4482.57 Median:5207.29 stddev:1387.46 (26.6%) stddev-sans-first:1354.82 22:21:22 INFO - PROCESS | 3424 | Values: 268.0 269.2 274.2 274.9 275.1 5120.5 5182.6 5196.7 5211.0 5223.4 4885.7 5128.8 5140.8 5154.0 5232.1 3777.4 3783.0 3793.1 3841.8 3879.2 3847.2 3853.6 3856.2 3861.2 3861.3 3825.3 3830.5 3836.5 3842.7 3857.9 3572.7 3651.5 3732.8 3820.3 3834.3 3327.6 3330.2 3335.5 3338.5 3345.1 5016.2 5019.4 5022.2 5027.6 5057.4 4168.9 4381.2 4429.8 4490.2 4497.1 5340.4 5347.8 5354.6 5358.6 5380.0 3599.6 3631.5 3645.7 3649.1 3660.6 5596.7 5635.0 5648.2 5762.2 5803.7 3622.6 3624.8 3631.7 3637.2 3649.5 3691.3 3710.4 3711.4 3715.4 3732.8 4390.1 4393.6 4398.9 4403.6 4410.1 5220.9 5385.5 5396.5 5431.9 5442.4 1281.5 1299.4 1301.0 1303.9 1313.4 769.8 798.5 798.7 803.8 811.9 4997.8 5125.7 5130.6 5131.5 5154.8 5469.8 5477.5 5498.5 5521.5 5575.0 5043.5 5183.4 5203.6 5213.0 5216.9 2954.7 3006.9 3007.7 3018.0 3018.2 5704.4 5710.8 5722.9 5730.7 5790.7 5472.9 5695.5 5717.9 5724.4 5780.5 5706.2 5712.9 5720.0 5731.3 5733.7 5373.3 5630.4 5634.3 5648.4 5690.2 5467.6 5468.3 5487.0 5533.6 5550.8 5595.9 5733.5 5743.6 5764.8 5772.8 3753.7 3754.6 3814.2 3828.9 3846.8 5542.3 5551.4 5558.9 5562.0 5593.2 5401.3 5417.1 5427.9 5435.2 5442.4 5152.9 5360.6 5396.8 5426.2 5434.3 5302.4 5305.4 5307.0 5322.3 5334.7 5232.2 5277.9 5357.0 5382.9 5464.7 5366.4 5374.5 5376.7 5386.6 5394.4 22:21:22 INFO - PROCESS | 3424 | 22:21:22 INFO - PROCESS | 3424 | [#5] yui.html Cycles:180 Average:14914.38 Median:25112.33 stddev:18891.32 (75.2%) stddev-sans-first:18913.88 22:21:22 INFO - PROCESS | 3424 | Values: 633.3 667.9 679.7 713.5 726.2 12436.6 12804.2 12849.1 12887.2 13846.4 11924.6 12111.5 12121.9 12126.6 12143.3 623.6 623.8 624.3 624.6 624.8 534.4 554.5 606.2 634.8 642.3 664.6 664.9 666.6 667.4 667.7 662.0 662.9 663.4 663.7 665.0 409.5 423.2 426.3 430.1 431.7 11934.6 12311.8 12328.8 12608.6 12652.7 12304.9 12645.4 12848.3 13059.3 13283.5 10345.8 10743.6 10870.4 11117.8 11207.4 3456.3 3458.4 3466.4 3486.8 3495.8 55816.7 56654.7 56949.7 57139.0 57196.3 9382.5 9418.2 9517.6 9564.4 9675.4 15942.0 16027.8 16051.0 16088.9 16105.2 7094.9 7214.4 7222.3 7296.3 7351.6 4113.6 4126.8 4135.1 4289.2 4293.9 2760.4 2849.1 2862.4 2868.5 2872.5 493.1 494.9 498.9 507.6 512.5 568.3 582.8 626.9 652.9 662.4 8000.8 8080.8 8270.7 8315.8 8565.9 639.9 651.3 675.0 675.9 681.5 4185.9 4214.4 4308.1 4350.9 4354.9 67220.7 68624.3 68709.7 71314.6 71586.2 60145.4 62945.0 63340.0 63618.7 64083.7 38841.6 54143.7 55079.0 55611.7 55855.4 8523.2 8631.2 8634.8 8809.3 8836.0 37036.0 37352.4 37479.8 37891.6 39163.4 45869.8 47244.3 49743.8 49835.3 50990.5 10215.9 10741.4 10859.9 10905.9 11621.0 12401.6 12641.5 12662.8 12705.9 13120.9 11710.4 11750.7 11891.9 11985.8 12556.9 10067.6 11099.5 11936.0 12107.6 12289.8 11234.4 11268.2 11333.4 11482.7 11820.6 9433.7 9789.2 9965.3 10044.2 10255.6 9921.7 9952.5 10005.6 10013.2 10020.5 22:21:22 INFO - PROCESS | 3424 | -------- Summary: end -------- 22:21:22 INFO - PROCESS | 3424 | 22:21:23 INFO - TEST-INFO | 3424: exit 0 22:21:23 INFO - TEST-OK | dromaeo_css | took 1123860ms 22:21:23 INFO - TEST-START | kraken 22:21:23 INFO - operating with platform_type : w8_ 22:21:23 INFO - Initialising browser for kraken test... 22:21:23 INFO - TEST-INFO | started process 2656 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpfu6vqa\profile http://localhost:49237/getInfo.html) 22:21:29 INFO - PROCESS | 2656 | __metrics Screen width/height:1600/1200 22:21:29 INFO - PROCESS | 2656 | colorDepth:24 22:21:29 INFO - PROCESS | 2656 | Browser inner width/height: 1010/674 22:21:29 INFO - PROCESS | 2656 | __metrics 22:21:30 INFO - PROCESS | 2656 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:21:30 INFO - PROCESS | 2656 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:21:30 INFO - PROCESS | 2656 | console.error: 22:21:30 INFO - PROCESS | 2656 | Message: Error: Connection closed before committing the transaction. 22:21:30 INFO - PROCESS | 2656 | Stack: 22:21:30 INFO - PROCESS | 2656 | ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:937:23 22:21:30 INFO - PROCESS | 2656 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7 22:21:30 INFO - PROCESS | 2656 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11 22:21:30 INFO - PROCESS | 2656 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7 22:21:30 INFO - PROCESS | 2656 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:714:7 22:21:30 INFO - PROCESS | 2656 | TaskImpl_run@resource://gre/modules/Task.jsm:327:15 22:21:30 INFO - PROCESS | 2656 | Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:551:9 22:21:30 INFO - PROCESS | 2656 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15 22:21:30 INFO - PROCESS | 2656 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:388:5 22:21:30 INFO - PROCESS | 2656 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29 22:21:30 INFO - PROCESS | 2656 | Barrier/this.client.addBlocker/promise13.4% 22:22:27 INFO - TinderboxPrint: I/O read bytes / time
277,685,760 / 3,357,660 22:22:27 INFO - TinderboxPrint: I/O write bytes / time
408,788,992 / 3,631,350 22:22:27 INFO - TinderboxPrint: CPU idle
8,258.4 (86.7%) 22:22:27 INFO - TinderboxPrint: CPU user
1,225.1 (12.9%) 22:22:27 INFO - install - Wall time: 3s; CPU: 11.0%; Read bytes: 0; Write bytes: 35445248; Read time: 0; Write time: 83360 22:22:27 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 277639168; Write bytes: 322309120; Read time: 3353930; Write time: 3500680 22:22:28 INFO - Running post-run listener: _upload_blobber_files 22:22:28 INFO - Blob upload gear active. 22:22:28 INFO - Preparing to upload files from C:\slave\test\build\blobber_upload_dir. 22:22:28 INFO - Files from C:\slave\test\build\blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:22:28 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\venv\\Scripts\\blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', 'C:\\slave\\test\\oauth.txt', '-b', 'Firefox', '-d', 'C:\\slave\\test\\build\\blobber_upload_dir', '--output-manifest', 'C:\\slave\\test\\build\\uploaded_files.json'] 22:22:28 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\venv\Scripts\blobberc.py -u https://blobupload.elasticbeanstalk.com -a C:\slave\test\oauth.txt -b Firefox -d C:\slave\test\build\blobber_upload_dir --output-manifest C:\slave\test\build\uploaded_files.json 22:22:28 INFO - (blobuploader) - INFO - Open directory for files ... 22:22:28 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_errorsummary.log ... 22:22:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:22:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:22:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:22:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:22:29 INFO - (blobuploader) - INFO - Done attempting. 22:22:29 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_raw.log ... 22:22:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:22:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:22:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:22:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:22:30 INFO - (blobuploader) - INFO - Done attempting. 22:22:30 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\resource-usage.json ... 22:22:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:22:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:22:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:22:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:22:33 INFO - (blobuploader) - INFO - Done attempting. 22:22:33 INFO - (blobuploader) - INFO - Iteration through files over. 22:22:33 INFO - Return code: 0 22:22:33 INFO - rmtree: C:\slave\test\build\uploaded_files.json 22:22:33 INFO - Using _rmtree_windows ... 22:22:33 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build\\uploaded_files.json',), kwargs: {}, attempt #1 22:22:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f2384c2f32723221c87f95385d04b4af3837ae68138f2fd5950cb9a70431ec3209d665e9aed6302fbce9ef0d61281b8bc93ad247dc82aa3923c562b5d41dc6c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4765ac1e7fb40f3fd73e8ebee838175affa3e710c0ce2c0827eccf1f6308a0a4dc2b474a812bf5a98fe38104284014ec4215d842a3522ea6919d02aa6167e76e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e481957d997ad5bca74c4abf32cd8389f404b4349eece126dde01f575664c472d6c4c818720e4d1309985962e6003724f86e4e6a1c6b5e66ccabb3bfb30ecd77"} 22:22:33 INFO - Writing buildbot properties ['blobber_files'] to C:\slave\test\properties\blobber_files 22:22:33 INFO - Writing to file C:\slave\test\properties\blobber_files 22:22:33 INFO - Contents: 22:22:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f2384c2f32723221c87f95385d04b4af3837ae68138f2fd5950cb9a70431ec3209d665e9aed6302fbce9ef0d61281b8bc93ad247dc82aa3923c562b5d41dc6c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4765ac1e7fb40f3fd73e8ebee838175affa3e710c0ce2c0827eccf1f6308a0a4dc2b474a812bf5a98fe38104284014ec4215d842a3522ea6919d02aa6167e76e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e481957d997ad5bca74c4abf32cd8389f404b4349eece126dde01f575664c472d6c4c818720e4d1309985962e6003724f86e4e6a1c6b5e66ccabb3bfb30ecd77"} 22:22:33 INFO - Running post-run listener: copy_logs_to_upload_dir 22:22:33 INFO - Copying logs to upload dir... 22:22:33 INFO - mkdir: C:\slave\test\build\upload\logs 22:22:33 INFO - Copying logs to upload dir... 22:22:33 INFO - Using _rmtree_windows ... 22:22:33 INFO - Using _rmtree_windows ... 22:22:33 INFO - Using _rmtree_windows ... 22:22:33 INFO - Using _rmtree_windows ... 22:22:33 INFO - Using _rmtree_windows ... 22:22:33 INFO - Using _rmtree_windows ... 22:22:33 INFO - Using _rmtree_windows ... program finished with exit code 0 elapsedTime=1404.033000 ========= master_lag: 0.09 ========= ========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 24 secs) (at 2016-10-26 22:22:34.075673) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 22:22:34.081352) ========= 'cmd' '/C' 'for' '%f' 'in' '(*)' 'do' '@type' '%f' in dir C:\slave\test\properties (timeout 1200 secs) watching logfiles {} argv: ['cmd', '/C', 'for', '%f', 'in', '(*)', 'do', '@type', '%f'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-162\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files COMMONPROGRAMW6432=C:\Program Files\Common Files COMPUTERNAME=T-W864-IX-162 COMSPEC=C:\windows\system32\cmd.exe DCLOCATION=SCL3 DNSSUFFIX=wintest.releng.scl3.mozilla.com FP_NO_HOST_CHECK=NO HOMEDRIVE=C: HOMEPATH=\Users\cltbld.T-W864-IX-162 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-162\AppData\Local LOGONSERVER=\\T-W864-IX-162 MONDIR=C:\Monitor_config\ MOZBUILDDIR=C:\mozilla-build\ MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 NUMBER_OF_PROCESSORS=8 OS=Windows_NT OURDRIVE=C: PATH=C:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;C:\mozilla-build\hg PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_ARCHITEW6432=AMD64 PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=C:\Program Files (x86) PROGRAMFILES(X86)=C:\Program Files (x86) PROGRAMW6432=C:\Program Files PROMPT=$P$G PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\ PUBLIC=C:\Users\Public PWD=C:\slave\test\properties RUNLOGFILE=C:\slave\\runslave.log SLAVEDIR=C:\slave\ SYSTEMDRIVE=C: SYSTEMROOT=C:\windows TEMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp TEST1=testie TMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp USERDOMAIN=T-W864-IX-162 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-162 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-162 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f2384c2f32723221c87f95385d04b4af3837ae68138f2fd5950cb9a70431ec3209d665e9aed6302fbce9ef0d61281b8bc93ad247dc82aa3923c562b5d41dc6c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4765ac1e7fb40f3fd73e8ebee838175affa3e710c0ce2c0827eccf1f6308a0a4dc2b474a812bf5a98fe38104284014ec4215d842a3522ea6919d02aa6167e76e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e481957d997ad5bca74c4abf32cd8389f404b4349eece126dde01f575664c472d6c4c818720e4d1309985962e6003724f86e4e6a1c6b5e66ccabb3bfb30ecd77"} build_url:https://queue.taskcluster.net/v1/task/NYDovZ6hSWGqwBVKNxBVyw/artifacts/public/build/firefox-52.0a1.en-US.win64.zip program finished with exit code 0 elapsedTime=0.102000 build_url: 'https://queue.taskcluster.net/v1/task/NYDovZ6hSWGqwBVKNxBVyw/artifacts/public/build/firefox-52.0a1.en-US.win64.zip' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f2384c2f32723221c87f95385d04b4af3837ae68138f2fd5950cb9a70431ec3209d665e9aed6302fbce9ef0d61281b8bc93ad247dc82aa3923c562b5d41dc6c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4765ac1e7fb40f3fd73e8ebee838175affa3e710c0ce2c0827eccf1f6308a0a4dc2b474a812bf5a98fe38104284014ec4215d842a3522ea6919d02aa6167e76e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e481957d997ad5bca74c4abf32cd8389f404b4349eece126dde01f575664c472d6c4c818720e4d1309985962e6003724f86e4e6a1c6b5e66ccabb3bfb30ecd77"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 22:22:34.209810) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 22:22:34.210159) ========= 'rm' '-f' 'oauth.txt' in dir C:\slave\test\. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-162\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files COMMONPROGRAMW6432=C:\Program Files\Common Files COMPUTERNAME=T-W864-IX-162 COMSPEC=C:\windows\system32\cmd.exe DCLOCATION=SCL3 DNSSUFFIX=wintest.releng.scl3.mozilla.com FP_NO_HOST_CHECK=NO HOMEDRIVE=C: HOMEPATH=\Users\cltbld.T-W864-IX-162 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-162\AppData\Local LOGONSERVER=\\T-W864-IX-162 MONDIR=C:\Monitor_config\ MOZBUILDDIR=C:\mozilla-build\ MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 NUMBER_OF_PROCESSORS=8 OS=Windows_NT OURDRIVE=C: PATH=C:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;C:\mozilla-build\hg PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_ARCHITEW6432=AMD64 PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=C:\Program Files (x86) PROGRAMFILES(X86)=C:\Program Files (x86) PROGRAMW6432=C:\Program Files PROMPT=$P$G PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\ PUBLIC=C:\Users\Public PWD=C:\slave\test RUNLOGFILE=C:\slave\\runslave.log SLAVEDIR=C:\slave\ SYSTEMDRIVE=C: SYSTEMROOT=C:\windows TEMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp TEST1=testie TMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp USERDOMAIN=T-W864-IX-162 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-162 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-162 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=0.101000 ========= master_lag: 0.03 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 22:22:34.337834) ========= ========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-10-26 22:22:34.338207) ========= ========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-10-26 22:22:35.090751) ========= ========= Total master_lag: 0.91 =========