builder: mozilla-central_win8_64_test-dromaeojs-pgo slave: t-w864-ix-170 starttime: 1478908927.97 results: success (0) buildid: 20161111133014 builduid: 0511addcaf71485982a36c0b305aeafd revision: 5d1c54f240d077b6b8e141fd44b52a3b694a5dfd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-11 16:02:07.972844) ========= master: http://buildbot-master119.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-11 16:02:07.973305) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 4 secs) (at 2016-11-11 16:02:07.973598) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 4 secs) (at 2016-11-11 16:02:12.961571) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-11 16:02:12.961893) ========= '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-170\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-170 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-170 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-170\AppData\Local LOGONSERVER=\\T-W864-IX-170 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-170 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-170 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-170 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False --16:02:13-- 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% 2.27 GB/s 16:02:14 (2.27 GB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=1.436000 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-11 16:02:14.442175) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-11-11 16:02:14.442498) ========= '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-170\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-170 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-170 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-170\AppData\Local LOGONSERVER=\\T-W864-IX-170 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-170 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-170 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-170 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=3.014000 ========= master_lag: 0.12 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-11-11 16:02:17.576174) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-11 16:02:17.576661) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo mozilla-central --rev 5d1c54f240d077b6b8e141fd44b52a3b694a5dfd --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 5d1c54f240d077b6b8e141fd44b52a3b694a5dfd --destination scripts --debug'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-170\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-170 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-170 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-170\AppData\Local LOGONSERVER=\\T-W864-IX-170 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-170 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-170 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-170 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 2016-11-11 16:02:17,625 truncating revision to first 12 chars 2016-11-11 16:02:17,627 Setting DEBUG logging. 2016-11-11 16:02:17,627 attempt 1/10 2016-11-11 16:02:17,627 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5d1c54f240d0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-11 16:02:19,085 unpacking tar archive at: mozilla-central-5d1c54f240d0/testing/mozharness/ 2016-11-11 16:02:19,190 skipping symlink on windows: configs/single_locale/linux32.py program finished with exit code 0 elapsedTime=2.154000 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-11 16:02:19.784493) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-11 16:02:19.784825) ========= script_repo_revision: 5d1c54f240d077b6b8e141fd44b52a3b694a5dfd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-11 16:02:19.785216) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-11 16:02:19.785507) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-11 16:02:19.827960) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 9 secs) (at 2016-11-11 16:02:19.828344) ========= '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-170\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-170 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-170 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-170\AppData\Local LOGONSERVER=\\T-W864-IX-170 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-170 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-170 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-170 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 16:02:20 INFO - MultiFileLogger online at 20161111 16:02:20 in C:\slave\test 16:02:20 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 16:02:20 INFO - Dumping config to C:\slave\test\logs\localconfig.json. 16:02:20 INFO - {'append_to_log': False, 16:02:20 INFO - 'base_work_dir': 'C:\\slave\\test', 16:02:20 INFO - 'blob_upload_branch': 'Firefox', 16:02:20 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt', 16:02:20 INFO - 'branch': 'Firefox', 16:02:20 INFO - 'buildbot_json_path': 'buildprops.json', 16:02:20 INFO - 'config_files': ('talos/windows_config.py',), 16:02:20 INFO - 'default_actions': ('clobber', 16:02:20 INFO - 'read-buildbot-config', 16:02:20 INFO - 'download-and-extract', 16:02:20 INFO - 'populate-webroot', 16:02:20 INFO - 'create-virtualenv', 16:02:20 INFO - 'install', 16:02:20 INFO - 'run-tests'), 16:02:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:02:20 INFO - 'download_minidump_stackwalk': True, 16:02:20 INFO - 'download_symbols': 'ondemand', 16:02:20 INFO - 'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python', 16:02:20 INFO - 'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'), 16:02:20 INFO - 'hg': 'c:/mozilla-build/hg/hg', 16:02:20 INFO - 'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python', 16:02:20 INFO - 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'), 16:02:20 INFO - 'python': 'c:/mozilla-build/python27/python.exe', 16:02:20 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe', 16:02:20 INFO - 'C:/mozilla-build/tooltool.py'), 16:02:20 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe', 16:02:20 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 16:02:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:02:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:02:20 INFO - 'installer_path': 'installer.exe', 16:02:20 INFO - 'log_level': 'info', 16:02:20 INFO - 'log_name': 'talos', 16:02:20 INFO - 'log_to_console': True, 16:02:20 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe', 16:02:20 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe', 16:02:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest', 16:02:20 INFO - 'opt_config_files': (), 16:02:20 INFO - 'pip_index': False, 16:02:20 INFO - 'sps_profile': False, 16:02:20 INFO - 'sps_profile_interval': 0, 16:02:20 INFO - 'suite': 'dromaeojs', 16:02:20 INFO - 'system_bits': '32', 16:02:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:02:20 INFO - 'title': 'T-W864-IX-170', 16:02:20 INFO - 'use_talos_json': True, 16:02:20 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'), 16:02:20 INFO - 'virtualenv_path': 'C:\\slave\\test\\build/venv', 16:02:20 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll', 16:02:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:02:20 INFO - 'work_dir': 'build'} 16:02:20 INFO - [mozharness: 2016-11-12 00:02:20.167000Z] Running clobber step. 16:02:20 INFO - Running pre-action listener: _resource_record_pre_action 16:02:20 INFO - Running main action method: clobber 16:02:20 INFO - rmtree: C:\slave\test\build 16:02:20 INFO - Using _rmtree_windows ... 16:02:20 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1 16:03:55 INFO - Running post-action listener: _resource_record_post_action 16:03:55 INFO - [mozharness: 2016-11-12 00:03:55.716000Z] Finished clobber step (success) 16:03:55 INFO - [mozharness: 2016-11-12 00:03:55.716000Z] Running read-buildbot-config step. 16:03:55 INFO - Running pre-action listener: _resource_record_pre_action 16:03:55 INFO - Running main action method: read_buildbot_config 16:03:55 INFO - Using buildbot properties: 16:03:55 INFO - { 16:03:55 INFO - "project": "", 16:03:55 INFO - "product": "firefox", 16:03:55 INFO - "script_repo_revision": "production", 16:03:55 INFO - "builddir": "mozilla-central_win8_64_test-dromaeojs", 16:03:55 INFO - "repository": "", 16:03:55 INFO - "buildername": "Windows 8 64-bit mozilla-central pgo talos dromaeojs", 16:03:55 INFO - "buildid": "20161111133014", 16:03:55 INFO - "pgo_build": "True", 16:03:55 INFO - "basedir": "C:\\slave\\test", 16:03:55 INFO - "buildnumber": 96, 16:03:55 INFO - "slavename": "t-w864-ix-170", 16:03:55 INFO - "master": "http://buildbot-master119.bb.releng.scl3.mozilla.com:8201/", 16:03:55 INFO - "platform": "win8_64", 16:03:55 INFO - "scheduler": "tests-mozilla-central-win64-pgo-talos", 16:03:55 INFO - "branch": "mozilla-central", 16:03:55 INFO - "repo_path": "mozilla-central", 16:03:55 INFO - "revision": "5d1c54f240d077b6b8e141fd44b52a3b694a5dfd", 16:03:55 INFO - "stage_platform": "win64-pgo", 16:03:55 INFO - "builduid": "0511addcaf71485982a36c0b305aeafd", 16:03:55 INFO - "slavebuilddir": "test" 16:03:55 INFO - } 16:03:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/eTOpnRcCSvmaQfqfpzyd2Q/artifacts/public/build/firefox-52.0a1.en-US.win64.zip. 16:03:55 INFO - Running post-action listener: _resource_record_post_action 16:03:55 INFO - [mozharness: 2016-11-12 00:03:55.719000Z] Finished read-buildbot-config step (success) 16:03:55 INFO - [mozharness: 2016-11-12 00:03:55.719000Z] Running download-and-extract step. 16:03:55 INFO - Running pre-action listener: _resource_record_pre_action 16:03:55 INFO - Running main action method: download_and_extract 16:03:55 INFO - mkdir: C:\slave\test\build\tests 16:03:55 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')]} 16:03:55 INFO - trying https://queue.taskcluster.net/v1/task/eTOpnRcCSvmaQfqfpzyd2Q/artifacts/public/build/firefox-52.0a1.en-US.win64.test_packages.json 16:03:55 INFO - Downloading https://queue.taskcluster.net/v1/task/eTOpnRcCSvmaQfqfpzyd2Q/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 16:03:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eTOpnRcCSvmaQfqfpzyd2Q/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 16:03:56 INFO - Downloaded 1218 bytes. 16:03:56 INFO - Reading from file C:\slave\test\build\firefox-52.0a1.en-US.win64.test_packages.json 16:03:56 INFO - Using the following test package requirements: 16:03:56 INFO - {u'common': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 16:03:56 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 16:03:56 INFO - u'firefox-52.0a1.en-US.win64.cppunittest.tests.zip'], 16:03:56 INFO - u'gtest': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 16:03:56 INFO - u'jittest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 16:03:56 INFO - u'jsshell-win64.zip'], 16:03:56 INFO - u'mochitest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 16:03:56 INFO - u'firefox-52.0a1.en-US.win64.mochitest.tests.zip'], 16:03:56 INFO - u'mozbase': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 16:03:56 INFO - u'reftest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 16:03:56 INFO - u'firefox-52.0a1.en-US.win64.reftest.tests.zip'], 16:03:56 INFO - u'talos': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 16:03:56 INFO - u'firefox-52.0a1.en-US.win64.talos.tests.zip'], 16:03:56 INFO - u'web-platform': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 16:03:56 INFO - u'firefox-52.0a1.en-US.win64.web-platform.tests.zip'], 16:03:56 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 16:03:56 INFO - u'firefox-52.0a1.en-US.win64.xpcshell.tests.zip']} 16:03:56 INFO - Downloading packages: [u'firefox-52.0a1.en-US.win64.common.tests.zip'] for test suite category: common 16:03:56 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/eTOpnRcCSvmaQfqfpzyd2Q/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip 16:03:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eTOpnRcCSvmaQfqfpzyd2Q/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip'}, attempt #1 16:03:56 INFO - Fetch https://queue.taskcluster.net/v1/task/eTOpnRcCSvmaQfqfpzyd2Q/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip into memory 16:03:57 INFO - Http code: 200 16:03:57 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 16:03:57 INFO - x-amz-cf-id: 2pvFaeeir-yOTczFkN1j7KFTVOhjN5xd7scPIodbfb14fr98fy7Hlg== 16:03:57 INFO - x-amz-version-id: N6PY_at1vuAA_G7zGENBZcXefAI7wH_T 16:03:57 INFO - Expected file size: 17370804 16:03:57 INFO - Obtained file size: 17370804 16:04:21 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 16:04:21 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/eTOpnRcCSvmaQfqfpzyd2Q/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip 16:04:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eTOpnRcCSvmaQfqfpzyd2Q/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip'}, attempt #1 16:04:21 INFO - Fetch https://queue.taskcluster.net/v1/task/eTOpnRcCSvmaQfqfpzyd2Q/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip into memory 16:04:22 INFO - Http code: 200 16:04:22 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 16:04:22 INFO - x-amz-cf-id: _10nMpVn2I4-W1Bg8umpd6jV_XxgJKcjIKRLrhdl8sWNWdsp3R2pOA== 16:04:22 INFO - x-amz-version-id: N6PY_at1vuAA_G7zGENBZcXefAI7wH_T 16:04:22 INFO - Expected file size: 17370804 16:04:22 INFO - Obtained file size: 17370804 16:04:31 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/eTOpnRcCSvmaQfqfpzyd2Q/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip 16:04:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eTOpnRcCSvmaQfqfpzyd2Q/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip'}, attempt #1 16:04:31 INFO - Fetch https://queue.taskcluster.net/v1/task/eTOpnRcCSvmaQfqfpzyd2Q/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip into memory 16:04:31 INFO - Http code: 200 16:04:31 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 16:04:31 INFO - x-amz-cf-id: xHCy6M4miwEeyEZAfgsXslF04cKpEHgpxK-gYKaahOj--c9f1COC-g== 16:04:31 INFO - x-amz-version-id: 3WARqj23eomjkSZiDm6hqWurua1WF8db 16:04:32 INFO - Expected file size: 14409038 16:04:32 INFO - Obtained file size: 14409038 16:04:41 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')]} 16:04:41 INFO - trying https://queue.taskcluster.net/v1/task/eTOpnRcCSvmaQfqfpzyd2Q/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 16:04:41 INFO - Downloading https://queue.taskcluster.net/v1/task/eTOpnRcCSvmaQfqfpzyd2Q/artifacts/public/build/firefox-52.0a1.en-US.win64.zip to C:\slave\test\build\firefox-52.0a1.en-US.win64.zip 16:04:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eTOpnRcCSvmaQfqfpzyd2Q/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 16:04:42 INFO - Downloaded 57335522 bytes. 16:04:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eTOpnRcCSvmaQfqfpzyd2Q/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 16:04:42 INFO - mkdir: C:\slave\test\properties 16:04:42 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url 16:04:42 INFO - Writing to file C:\slave\test\properties\build_url 16:04:42 INFO - Contents: 16:04:42 INFO - build_url:https://queue.taskcluster.net/v1/task/eTOpnRcCSvmaQfqfpzyd2Q/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 16:04:43 INFO - Running post-action listener: _resource_record_post_action 16:04:43 INFO - Running post-action listener: set_extra_try_arguments 16:04:43 INFO - [mozharness: 2016-11-12 00:04:43.301000Z] Finished download-and-extract step (success) 16:04:43 INFO - [mozharness: 2016-11-12 00:04:43.301000Z] Running populate-webroot step. 16:04:43 INFO - Running pre-action listener: _resource_record_pre_action 16:04:43 INFO - Running main action method: populate_webroot 16:04:43 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']}, 16:04:43 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']}, 16:04:43 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome', 16:04:43 INFO - u'--tppagecycles', 16:04:43 INFO - u'7'], 16:04:43 INFO - u'tests': [u'tsvgm']}}, 16:04:43 INFO - u'suites': {u'chromez': {u'talos_options': [u'--disable-e10s'], 16:04:43 INFO - u'tests': [u'tresize', u'tcanvasmark']}, 16:04:43 INFO - u'chromez-e10s': {u'tests': [u'tresize', u'tcanvasmark']}, 16:04:43 INFO - u'dromaeojs': {u'talos_options': [u'--disable-e10s'], 16:04:43 INFO - u'tests': [u'dromaeo_css', u'kraken']}, 16:04:43 INFO - u'dromaeojs-e10s': {u'tests': [u'dromaeo_css', u'kraken']}, 16:04:43 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:43 INFO - u'talos_options': [u'--disable-e10s'], 16:04:43 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 16:04:43 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:43 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 16:04:43 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:43 INFO - u'talos_options': [u'--disable-e10s'], 16:04:43 INFO - u'tests': [u'damp', u'tps']}, 16:04:43 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:43 INFO - u'tests': [u'damp', u'tps']}, 16:04:43 INFO - u'g3': {u'talos_options': [u'--disable-e10s'], 16:04:43 INFO - u'tests': [u'dromaeo_dom']}, 16:04:43 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']}, 16:04:43 INFO - u'g4': {u'talos_options': [u'--disable-e10s'], 16:04:43 INFO - u'tests': [u'basic_compositor_video']}, 16:04:43 INFO - u'g4-e10s': {u'tests': [u'basic_compositor_video']}, 16:04:43 INFO - u'other': {u'talos_options': [u'--disable-e10s'], 16:04:43 INFO - u'tests': [u'a11yr', 16:04:43 INFO - u'ts_paint', 16:04:43 INFO - u'tpaint', 16:04:43 INFO - u'sessionrestore', 16:04:43 INFO - u'sessionrestore_no_auto_restore', 16:04:43 INFO - u'tabpaint']}, 16:04:43 INFO - u'other-e10s': {u'tests': [u'a11yr', 16:04:43 INFO - u'ts_paint', 16:04:43 INFO - u'tpaint', 16:04:43 INFO - u'sessionrestore', 16:04:43 INFO - u'sessionrestore_no_auto_restore', 16:04:43 INFO - u'tabpaint']}, 16:04:43 INFO - u'other-e10s_l64': {u'tests': [u'a11yr', 16:04:43 INFO - u'ts_paint', 16:04:43 INFO - u'tpaint', 16:04:43 INFO - u'sessionrestore', 16:04:43 INFO - u'sessionrestore_no_auto_restore', 16:04:43 INFO - u'tabpaint']}, 16:04:43 INFO - u'other-e10s_nol64': {u'tests': [u'a11yr', 16:04:43 INFO - u'ts_paint', 16:04:43 INFO - u'tpaint', 16:04:43 INFO - u'sessionrestore', 16:04:43 INFO - u'sessionrestore_no_auto_restore', 16:04:43 INFO - u'tabpaint']}, 16:04:43 INFO - u'other_l64': {u'talos_options': [u'--disable-e10s'], 16:04:43 INFO - u'tests': [u'a11yr', 16:04:43 INFO - u'ts_paint', 16:04:43 INFO - u'tpaint', 16:04:43 INFO - u'sessionrestore', 16:04:43 INFO - u'sessionrestore_no_auto_restore', 16:04:43 INFO - u'tabpaint']}, 16:04:43 INFO - u'other_nol64': {u'talos_options': [u'--disable-e10s'], 16:04:43 INFO - u'tests': [u'a11yr', 16:04:43 INFO - u'ts_paint', 16:04:43 INFO - u'tpaint', 16:04:43 INFO - u'sessionrestore', 16:04:43 INFO - u'sessionrestore_no_auto_restore', 16:04:43 INFO - u'tabpaint']}, 16:04:43 INFO - u'svgr': {u'talos_options': [u'--disable-e10s'], 16:04:43 INFO - u'tests': [u'tsvgx', 16:04:43 INFO - u'tsvgr_opacity', 16:04:43 INFO - u'tart', 16:04:43 INFO - u'tscrollx', 16:04:43 INFO - u'cart']}, 16:04:43 INFO - u'svgr-e10s': {u'tests': [u'tsvgx', 16:04:43 INFO - u'tsvgr_opacity', 16:04:43 INFO - u'tart', 16:04:43 INFO - u'tscrollx', 16:04:43 INFO - u'cart']}, 16:04:43 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:43 INFO - u'talos_options': [u'--disable-e10s'], 16:04:43 INFO - u'tests': [u'tp5o']}, 16:04:43 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:43 INFO - u'tests': [u'tp5o']}, 16:04:43 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:43 INFO - u'talos_options': [u'--disable-e10s', 16:04:43 INFO - u'--xperf_path', 16:04:43 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:04:43 INFO - u'tests': [u'tp5n']}, 16:04:43 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:43 INFO - u'talos_options': [u'--xperf_path', 16:04:43 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:04:43 INFO - u'tests': [u'tp5n']}}, 16:04:43 INFO - u'talos.zip': {u'path': u'', 16:04:43 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:04:43 INFO - Running post-action listener: _resource_record_post_action 16:04:43 INFO - [mozharness: 2016-11-12 00:04:43.339000Z] Finished populate-webroot step (success) 16:04:43 INFO - [mozharness: 2016-11-12 00:04:43.339000Z] Running create-virtualenv step. 16:04:43 INFO - Running pre-action listener: _resource_record_pre_action 16:04:43 INFO - Running main action method: create_virtualenv 16:04:43 INFO - Creating virtualenv C:\slave\test\build/venv 16:04:43 INFO - mkdir: C:\slave\test\build\venv\Scripts 16:04:43 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll 16:04:43 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'! 16:04:43 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 16:04:43 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build/venv 16:04:49 INFO - New python executable in C:\slave\test\build/venv\Scripts\python.exe 16:04:52 INFO - Installing distribute......................................................................................................................................................................................done. 16:04:54 INFO - Return code: 0 16:04:54 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', '--version'] 16:04:54 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip --version 16:04:54 INFO - Reading from file tmpfile_stdout 16:04:54 INFO - Output received: 16:04:54 INFO - pip 0.8.2 from c:\slave\test\build\venv\lib\site-packages\pip-0.8.2-py2.7.egg (python 2.7) 16:04:54 INFO - Using _rmtree_windows ... 16:04:54 INFO - Using _rmtree_windows ... 16:04:54 INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv 16:04: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')]} 16:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04: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')]} 16:04:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:54 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 0x022FC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023A8E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024B0A70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023C3E90>, '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 0x01DFA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027D7520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-170', 'USERDOMAIN': 'T-W864-IX-170', '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-170', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-170\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-170', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-170', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-170', '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-170\\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 16:04:54 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 16:04:54 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 16:04:54 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 16:04:54 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-170\\AppData\\Roaming', 16:04:54 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 16:04:54 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 16:04:54 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 16:04:54 INFO - 'COMPUTERNAME': 'T-W864-IX-170', 16:04:54 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 16:04:54 INFO - 'DCLOCATION': 'SCL3', 16:04:54 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 16:04:54 INFO - 'FP_NO_HOST_CHECK': 'NO', 16:04:54 INFO - 'HOMEDRIVE': 'C:', 16:04:54 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-170', 16:04:54 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 16:04:54 INFO - 'KTS_VERSION': '1.19c', 16:04:54 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-170\\AppData\\Local', 16:04:54 INFO - 'LOGONSERVER': '\\\\T-W864-IX-170', 16:04:54 INFO - 'MONDIR': 'C:\\Monitor_config\\', 16:04:54 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 16:04:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:54 INFO - 'MOZ_NO_REMOTE': '1', 16:04:54 INFO - 'NO_EM_RESTART': '1', 16:04:54 INFO - 'NUMBER_OF_PROCESSORS': '8', 16:04:54 INFO - 'OS': 'Windows_NT', 16:04:54 INFO - 'OURDRIVE': 'C:', 16:04:54 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', 16:04:54 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 16:04:54 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 16:04:54 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 16:04:54 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 16:04:54 INFO - 'PROCESSOR_LEVEL': '6', 16:04:54 INFO - 'PROCESSOR_REVISION': '1e05', 16:04:54 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 16:04:54 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 16:04:54 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 16:04:54 INFO - 'PROGRAMW6432': 'C:\\Program Files', 16:04:54 INFO - 'PROMPT': '$P$G', 16:04:54 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 16:04:54 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 16:04:54 INFO - 'PUBLIC': 'C:\\Users\\Public', 16:04:54 INFO - 'PWD': 'C:\\slave\\test', 16:04:54 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 16:04:54 INFO - 'SLAVEDIR': 'C:\\slave\\', 16:04:54 INFO - 'SYSTEMDRIVE': 'C:', 16:04:54 INFO - 'SYSTEMROOT': 'C:\\windows', 16:04:54 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:04:54 INFO - 'TEST1': 'testie', 16:04:54 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:04:54 INFO - 'USERDOMAIN': 'T-W864-IX-170', 16:04:54 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-170', 16:04:54 INFO - 'USERNAME': 'cltbld', 16:04:54 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-170', 16:04:54 INFO - 'WINDIR': 'C:\\windows', 16:04:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 16:04:55 INFO - Ignoring indexes: http://pypi.python.org/simple/ 16:04:55 INFO - Downloading/unpacking pip>=1.5 16:04:59 INFO - Running setup.py egg_info for package pip 16:04:59 INFO - warning: no files found matching 'pip\cacert.pem' 16:04:59 INFO - warning: no files found matching '*.html' under directory 'docs' 16:04:59 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 16:04:59 INFO - no previously-included directories found matching 'docs\_build\_sources' 16:04:59 INFO - Installing collected packages: pip 16:04:59 INFO - Found existing installation: pip 0.8.2 16:04:59 INFO - Uninstalling pip: 16:04:59 INFO - Successfully uninstalled pip 16:04:59 INFO - Running setup.py install for pip 16:04:59 INFO - warning: no files found matching 'pip\cacert.pem' 16:04:59 INFO - warning: no files found matching '*.html' under directory 'docs' 16:04:59 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 16:04:59 INFO - no previously-included directories found matching 'docs\_build\_sources' 16:04:59 INFO - Installing pip-script.py script to C:\slave\test\build\venv\Scripts 16:04:59 INFO - Installing pip.exe script to C:\slave\test\build\venv\Scripts 16:04:59 INFO - Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts 16:04:59 INFO - Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts 16:04:59 INFO - Installing pip2-script.py script to C:\slave\test\build\venv\Scripts 16:04:59 INFO - Installing pip2.exe script to C:\slave\test\build\venv\Scripts 16:04:59 INFO - Successfully installed pip 16:04:59 INFO - Cleaning up... 16:04:59 INFO - Return code: 0 16:04:59 INFO - Installing psutil>=3.1.1 into virtualenv C:\slave\test\build/venv 16:04:59 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')]} 16:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:59 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')]} 16:04:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:59 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 0x022FC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023A8E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024B0A70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023C3E90>, '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 0x01DFA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027D7520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-170', 'USERDOMAIN': 'T-W864-IX-170', '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-170', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-170\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-170', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-170', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-170', '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-170\\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 16:04:59 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 16:04:59 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 16:04:59 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 16:04:59 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-170\\AppData\\Roaming', 16:04:59 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 16:04:59 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 16:04:59 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 16:04:59 INFO - 'COMPUTERNAME': 'T-W864-IX-170', 16:04:59 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 16:04:59 INFO - 'DCLOCATION': 'SCL3', 16:04:59 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 16:04:59 INFO - 'FP_NO_HOST_CHECK': 'NO', 16:04:59 INFO - 'HOMEDRIVE': 'C:', 16:04:59 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-170', 16:04:59 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 16:04:59 INFO - 'KTS_VERSION': '1.19c', 16:04:59 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-170\\AppData\\Local', 16:04:59 INFO - 'LOGONSERVER': '\\\\T-W864-IX-170', 16:04:59 INFO - 'MONDIR': 'C:\\Monitor_config\\', 16:04:59 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 16:04:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:59 INFO - 'MOZ_NO_REMOTE': '1', 16:04:59 INFO - 'NO_EM_RESTART': '1', 16:04:59 INFO - 'NUMBER_OF_PROCESSORS': '8', 16:04:59 INFO - 'OS': 'Windows_NT', 16:04:59 INFO - 'OURDRIVE': 'C:', 16:04:59 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', 16:04:59 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 16:04:59 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 16:04:59 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 16:04:59 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 16:04:59 INFO - 'PROCESSOR_LEVEL': '6', 16:04:59 INFO - 'PROCESSOR_REVISION': '1e05', 16:04:59 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 16:04:59 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 16:04:59 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 16:04:59 INFO - 'PROGRAMW6432': 'C:\\Program Files', 16:04:59 INFO - 'PROMPT': '$P$G', 16:04:59 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 16:04:59 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 16:04:59 INFO - 'PUBLIC': 'C:\\Users\\Public', 16:04:59 INFO - 'PWD': 'C:\\slave\\test', 16:04:59 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 16:04:59 INFO - 'SLAVEDIR': 'C:\\slave\\', 16:04:59 INFO - 'SYSTEMDRIVE': 'C:', 16:04:59 INFO - 'SYSTEMROOT': 'C:\\windows', 16:04:59 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:04:59 INFO - 'TEST1': 'testie', 16:04:59 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:04:59 INFO - 'USERDOMAIN': 'T-W864-IX-170', 16:04:59 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-170', 16:04:59 INFO - 'USERNAME': 'cltbld', 16:04:59 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-170', 16:04:59 INFO - 'WINDIR': 'C:\\windows', 16:04:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 16:05:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:01 INFO - Downloading/unpacking psutil>=3.1.1 16:05:01 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 16:05:01 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 16:05:02 INFO - Installing collected packages: psutil 16:05:02 INFO - Successfully installed psutil 16:05:02 INFO - Cleaning up... 16:05:02 INFO - Return code: 0 16:05:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv C:\slave\test\build/venv 16:05:02 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')]} 16:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:02 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')]} 16:05:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:02 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 0x022FC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023A8E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024B0A70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023C3E90>, '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 0x01DFA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027D7520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-170', 'USERDOMAIN': 'T-W864-IX-170', '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-170', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-170\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-170', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-170', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-170', '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-170\\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 16:05:02 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 16:05:02 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 16:05:02 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 16:05:02 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-170\\AppData\\Roaming', 16:05:02 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 16:05:02 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 16:05:02 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 16:05:02 INFO - 'COMPUTERNAME': 'T-W864-IX-170', 16:05:02 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 16:05:02 INFO - 'DCLOCATION': 'SCL3', 16:05:02 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 16:05:02 INFO - 'FP_NO_HOST_CHECK': 'NO', 16:05:02 INFO - 'HOMEDRIVE': 'C:', 16:05:02 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-170', 16:05:02 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 16:05:02 INFO - 'KTS_VERSION': '1.19c', 16:05:02 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-170\\AppData\\Local', 16:05:02 INFO - 'LOGONSERVER': '\\\\T-W864-IX-170', 16:05:02 INFO - 'MONDIR': 'C:\\Monitor_config\\', 16:05:02 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 16:05:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:02 INFO - 'MOZ_NO_REMOTE': '1', 16:05:02 INFO - 'NO_EM_RESTART': '1', 16:05:02 INFO - 'NUMBER_OF_PROCESSORS': '8', 16:05:02 INFO - 'OS': 'Windows_NT', 16:05:02 INFO - 'OURDRIVE': 'C:', 16:05:02 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', 16:05:02 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 16:05:02 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 16:05:02 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 16:05:02 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 16:05:02 INFO - 'PROCESSOR_LEVEL': '6', 16:05:02 INFO - 'PROCESSOR_REVISION': '1e05', 16:05:02 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 16:05:02 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 16:05:02 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 16:05:02 INFO - 'PROGRAMW6432': 'C:\\Program Files', 16:05:02 INFO - 'PROMPT': '$P$G', 16:05:02 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 16:05:02 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 16:05:02 INFO - 'PUBLIC': 'C:\\Users\\Public', 16:05:02 INFO - 'PWD': 'C:\\slave\\test', 16:05:02 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 16:05:02 INFO - 'SLAVEDIR': 'C:\\slave\\', 16:05:02 INFO - 'SYSTEMDRIVE': 'C:', 16:05:02 INFO - 'SYSTEMROOT': 'C:\\windows', 16:05:02 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:05:02 INFO - 'TEST1': 'testie', 16:05:02 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:05:02 INFO - 'USERDOMAIN': 'T-W864-IX-170', 16:05:02 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-170', 16:05:02 INFO - 'USERNAME': 'cltbld', 16:05:02 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-170', 16:05:02 INFO - 'WINDIR': 'C:\\windows', 16:05:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 16:05:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:05:03 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 16:05:03 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 16:05:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:05:04 INFO - Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor 16:05:04 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) 16:05:04 INFO - Installing collected packages: mozsystemmonitor 16:05:04 INFO - Running setup.py install for mozsystemmonitor 16:05:04 INFO - Successfully installed mozsystemmonitor 16:05:04 INFO - Cleaning up... 16:05:04 INFO - Return code: 0 16:05:04 INFO - Installing jsonschema==2.5.1 into virtualenv C:\slave\test\build/venv 16:05:04 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')]} 16:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:04 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')]} 16:05:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:04 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 0x022FC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023A8E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024B0A70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023C3E90>, '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 0x01DFA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027D7520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-170', 'USERDOMAIN': 'T-W864-IX-170', '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-170', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-170\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-170', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-170', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-170', '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-170\\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 16:05:04 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 16:05:04 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 16:05:04 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 16:05:04 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-170\\AppData\\Roaming', 16:05:04 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 16:05:04 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 16:05:04 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 16:05:04 INFO - 'COMPUTERNAME': 'T-W864-IX-170', 16:05:04 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 16:05:04 INFO - 'DCLOCATION': 'SCL3', 16:05:04 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 16:05:04 INFO - 'FP_NO_HOST_CHECK': 'NO', 16:05:04 INFO - 'HOMEDRIVE': 'C:', 16:05:04 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-170', 16:05:04 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 16:05:04 INFO - 'KTS_VERSION': '1.19c', 16:05:04 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-170\\AppData\\Local', 16:05:04 INFO - 'LOGONSERVER': '\\\\T-W864-IX-170', 16:05:04 INFO - 'MONDIR': 'C:\\Monitor_config\\', 16:05:04 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 16:05:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:04 INFO - 'MOZ_NO_REMOTE': '1', 16:05:04 INFO - 'NO_EM_RESTART': '1', 16:05:04 INFO - 'NUMBER_OF_PROCESSORS': '8', 16:05:04 INFO - 'OS': 'Windows_NT', 16:05:04 INFO - 'OURDRIVE': 'C:', 16:05:04 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', 16:05:04 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 16:05:04 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 16:05:04 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 16:05:04 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 16:05:04 INFO - 'PROCESSOR_LEVEL': '6', 16:05:04 INFO - 'PROCESSOR_REVISION': '1e05', 16:05:04 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 16:05:04 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 16:05:04 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 16:05:04 INFO - 'PROGRAMW6432': 'C:\\Program Files', 16:05:04 INFO - 'PROMPT': '$P$G', 16:05:04 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 16:05:04 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 16:05:04 INFO - 'PUBLIC': 'C:\\Users\\Public', 16:05:04 INFO - 'PWD': 'C:\\slave\\test', 16:05:04 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 16:05:04 INFO - 'SLAVEDIR': 'C:\\slave\\', 16:05:04 INFO - 'SYSTEMDRIVE': 'C:', 16:05:04 INFO - 'SYSTEMROOT': 'C:\\windows', 16:05:04 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:05:04 INFO - 'TEST1': 'testie', 16:05:04 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:05:04 INFO - 'USERDOMAIN': 'T-W864-IX-170', 16:05:04 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-170', 16:05:04 INFO - 'USERNAME': 'cltbld', 16:05:04 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-170', 16:05:04 INFO - 'WINDIR': 'C:\\windows', 16:05:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 16:05:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:04 INFO - Downloading/unpacking jsonschema==2.5.1 16:05:04 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 16:05:04 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 16:05:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:05:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:05: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 16:05: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 16:05:06 INFO - Downloading functools32-3.2.3-2.tar.gz 16:05:06 INFO - Running setup.py (path:C:\slave\test\build\venv\build\functools32\setup.py) egg_info for package functools32 16:05:06 INFO - warning: no files found matching '*.txt' 16:05:06 INFO - no previously-included directories found matching 'build' 16:05:06 INFO - no previously-included directories found matching 'dist' 16:05:06 INFO - no previously-included directories found matching '.git*' 16:05:06 INFO - Installing collected packages: jsonschema, functools32 16:05:06 INFO - Running setup.py install for functools32 16:05:06 INFO - warning: no files found matching '*.txt' 16:05:06 INFO - no previously-included directories found matching 'build' 16:05:06 INFO - no previously-included directories found matching 'dist' 16:05:06 INFO - no previously-included directories found matching '.git*' 16:05:06 INFO - Successfully installed jsonschema functools32 16:05:06 INFO - Cleaning up... 16:05:06 INFO - Return code: 0 16:05:06 INFO - Installing functools32==3.2.3-2 into virtualenv C:\slave\test\build/venv 16:05:06 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')]} 16:05:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:06 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')]} 16:05:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:06 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 0x022FC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023A8E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024B0A70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023C3E90>, '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 0x01DFA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027D7520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-170', 'USERDOMAIN': 'T-W864-IX-170', '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-170', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-170\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-170', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-170', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-170', '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-170\\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 16:05:07 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 16:05:07 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 16:05:07 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 16:05:07 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-170\\AppData\\Roaming', 16:05:07 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 16:05:07 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 16:05:07 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 16:05:07 INFO - 'COMPUTERNAME': 'T-W864-IX-170', 16:05:07 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 16:05:07 INFO - 'DCLOCATION': 'SCL3', 16:05:07 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 16:05:07 INFO - 'FP_NO_HOST_CHECK': 'NO', 16:05:07 INFO - 'HOMEDRIVE': 'C:', 16:05:07 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-170', 16:05:07 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 16:05:07 INFO - 'KTS_VERSION': '1.19c', 16:05:07 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-170\\AppData\\Local', 16:05:07 INFO - 'LOGONSERVER': '\\\\T-W864-IX-170', 16:05:07 INFO - 'MONDIR': 'C:\\Monitor_config\\', 16:05:07 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 16:05:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:07 INFO - 'MOZ_NO_REMOTE': '1', 16:05:07 INFO - 'NO_EM_RESTART': '1', 16:05:07 INFO - 'NUMBER_OF_PROCESSORS': '8', 16:05:07 INFO - 'OS': 'Windows_NT', 16:05:07 INFO - 'OURDRIVE': 'C:', 16:05:07 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', 16:05:07 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 16:05:07 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 16:05:07 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 16:05:07 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 16:05:07 INFO - 'PROCESSOR_LEVEL': '6', 16:05:07 INFO - 'PROCESSOR_REVISION': '1e05', 16:05:07 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 16:05:07 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 16:05:07 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 16:05:07 INFO - 'PROGRAMW6432': 'C:\\Program Files', 16:05:07 INFO - 'PROMPT': '$P$G', 16:05:07 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 16:05:07 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 16:05:07 INFO - 'PUBLIC': 'C:\\Users\\Public', 16:05:07 INFO - 'PWD': 'C:\\slave\\test', 16:05:07 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 16:05:07 INFO - 'SLAVEDIR': 'C:\\slave\\', 16:05:07 INFO - 'SYSTEMDRIVE': 'C:', 16:05:07 INFO - 'SYSTEMROOT': 'C:\\windows', 16:05:07 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:05:07 INFO - 'TEST1': 'testie', 16:05:07 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:05:07 INFO - 'USERDOMAIN': 'T-W864-IX-170', 16:05:07 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-170', 16:05:07 INFO - 'USERNAME': 'cltbld', 16:05:07 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-170', 16:05:07 INFO - 'WINDIR': 'C:\\windows', 16:05:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 16:05:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in c:\slave\test\build\venv\lib\site-packages 16:05:07 INFO - Cleaning up... 16:05:07 INFO - Return code: 0 16:05:07 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv 16:05:07 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')]} 16:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:07 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')]} 16:05:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:07 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 0x022FC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023A8E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024B0A70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023C3E90>, '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 0x01DFA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027D7520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-170', 'USERDOMAIN': 'T-W864-IX-170', '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-170', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-170\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-170', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-170', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-170', '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-170\\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 16:05:07 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 16:05:07 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 16:05:07 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 16:05:07 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-170\\AppData\\Roaming', 16:05:07 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 16:05:07 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 16:05:07 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 16:05:07 INFO - 'COMPUTERNAME': 'T-W864-IX-170', 16:05:07 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 16:05:07 INFO - 'DCLOCATION': 'SCL3', 16:05:07 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 16:05:07 INFO - 'FP_NO_HOST_CHECK': 'NO', 16:05:07 INFO - 'HOMEDRIVE': 'C:', 16:05:07 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-170', 16:05:07 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 16:05:07 INFO - 'KTS_VERSION': '1.19c', 16:05:07 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-170\\AppData\\Local', 16:05:07 INFO - 'LOGONSERVER': '\\\\T-W864-IX-170', 16:05:07 INFO - 'MONDIR': 'C:\\Monitor_config\\', 16:05:07 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 16:05:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:07 INFO - 'MOZ_NO_REMOTE': '1', 16:05:07 INFO - 'NO_EM_RESTART': '1', 16:05:07 INFO - 'NUMBER_OF_PROCESSORS': '8', 16:05:07 INFO - 'OS': 'Windows_NT', 16:05:07 INFO - 'OURDRIVE': 'C:', 16:05:07 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', 16:05:07 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 16:05:07 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 16:05:07 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 16:05:07 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 16:05:07 INFO - 'PROCESSOR_LEVEL': '6', 16:05:07 INFO - 'PROCESSOR_REVISION': '1e05', 16:05:07 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 16:05:07 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 16:05:07 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 16:05:07 INFO - 'PROGRAMW6432': 'C:\\Program Files', 16:05:07 INFO - 'PROMPT': '$P$G', 16:05:07 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 16:05:07 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 16:05:07 INFO - 'PUBLIC': 'C:\\Users\\Public', 16:05:07 INFO - 'PWD': 'C:\\slave\\test', 16:05:07 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 16:05:07 INFO - 'SLAVEDIR': 'C:\\slave\\', 16:05:07 INFO - 'SYSTEMDRIVE': 'C:', 16:05:07 INFO - 'SYSTEMROOT': 'C:\\windows', 16:05:07 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:05:07 INFO - 'TEST1': 'testie', 16:05:07 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:05:07 INFO - 'USERDOMAIN': 'T-W864-IX-170', 16:05:07 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-170', 16:05:07 INFO - 'USERNAME': 'cltbld', 16:05:07 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-170', 16:05:07 INFO - 'WINDIR': 'C:\\windows', 16:05:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 16:05:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:07 INFO - Downloading/unpacking blobuploader==1.2.4 16:05:07 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 16:05:07 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 16:05:08 INFO - Downloading blobuploader-1.2.4.tar.gz 16:05:08 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader 16:05:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:05: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 16:05: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 16:05:08 INFO - Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests 16:05:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:05:09 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 16:05:09 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 16:05:09 INFO - Downloading docopt-0.6.1.tar.gz 16:05:09 INFO - Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt 16:05:09 INFO - Installing collected packages: blobuploader, requests, docopt 16:05:09 INFO - Running setup.py install for blobuploader 16:05:09 INFO - Running setup.py install for requests 16:05:10 INFO - Running setup.py install for docopt 16:05:10 INFO - Successfully installed blobuploader requests docopt 16:05:10 INFO - Cleaning up... 16:05:11 INFO - Return code: 0 16:05:11 INFO - Installing None into virtualenv C:\slave\test\build/venv 16:05:11 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')]} 16:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:11 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')]} 16:05:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:11 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 0x022FC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023A8E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024B0A70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023C3E90>, '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 0x01DFA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027D7520>, '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-170', 'USERDOMAIN': 'T-W864-IX-170', '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-170', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-170\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-170', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-170', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-170', '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-170\\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 16:05:11 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 16:05:11 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 16:05:11 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 16:05:11 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-170\\AppData\\Roaming', 16:05:11 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 16:05:11 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 16:05:11 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 16:05:11 INFO - 'COMPUTERNAME': 'T-W864-IX-170', 16:05:11 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 16:05:11 INFO - 'DCLOCATION': 'SCL3', 16:05:11 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 16:05:11 INFO - 'FP_NO_HOST_CHECK': 'NO', 16:05:11 INFO - 'HOMEDRIVE': 'C:', 16:05:11 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-170', 16:05:11 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 16:05:11 INFO - 'KTS_VERSION': '1.19c', 16:05:11 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-170\\AppData\\Local', 16:05:11 INFO - 'LOGONSERVER': '\\\\T-W864-IX-170', 16:05:11 INFO - 'MONDIR': 'C:\\Monitor_config\\', 16:05:11 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 16:05:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:11 INFO - 'MOZ_NO_REMOTE': '1', 16:05:11 INFO - 'NO_EM_RESTART': '1', 16:05:11 INFO - 'NUMBER_OF_PROCESSORS': '8', 16:05:11 INFO - 'OS': 'Windows_NT', 16:05:11 INFO - 'OURDRIVE': 'C:', 16:05:11 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', 16:05:11 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 16:05:11 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 16:05:11 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 16:05:11 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 16:05:11 INFO - 'PROCESSOR_LEVEL': '6', 16:05:11 INFO - 'PROCESSOR_REVISION': '1e05', 16:05:11 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 16:05:11 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 16:05:11 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 16:05:11 INFO - 'PROGRAMW6432': 'C:\\Program Files', 16:05:11 INFO - 'PROMPT': '$P$G', 16:05:11 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 16:05:11 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 16:05:11 INFO - 'PUBLIC': 'C:\\Users\\Public', 16:05:11 INFO - 'PWD': 'C:\\slave\\test', 16:05:11 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 16:05:11 INFO - 'SLAVEDIR': 'C:\\slave\\', 16:05:11 INFO - 'SYSTEMDRIVE': 'C:', 16:05:11 INFO - 'SYSTEMROOT': 'C:\\windows', 16:05:11 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:05:11 INFO - 'TEST1': 'testie', 16:05:11 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:05:11 INFO - 'USERDOMAIN': 'T-W864-IX-170', 16:05:11 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-170', 16:05:11 INFO - 'USERNAME': 'cltbld', 16:05:11 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-170', 16:05:11 INFO - 'WINDIR': 'C:\\windows', 16:05:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 16:05:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:11 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 16:05:11 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-a8foxt-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 16:05:11 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 16:05:11 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-btnare-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 16:05:11 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 16:05:12 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-hmdyts-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 16:05:12 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 16:05:12 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xsejbw-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 16:05:12 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 16:05:12 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-87akmw-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 16:05:12 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 16:05:12 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-9lyucm-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 16:05:12 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 16:05:12 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jioudd-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 16:05:12 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 16:05:12 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-gxtnza-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 16:05:12 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 16:05:12 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-nzc4bg-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 16:05:12 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 16:05:12 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-_dhex6-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 16:05:12 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 16:05:12 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-b8lfjc-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 16:05:12 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 16:05:13 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ee1sgn-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 16:05:13 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 16:05:13 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-wdqtyy-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 16:05:13 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 16:05:13 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-pw1v3u-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 16:05:13 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 16:05:13 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-eii60m-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 16:05:13 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 16:05:13 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ghzkrr-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 16:05:13 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 16:05:13 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-vh1j5z-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 16:05:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:05:13 INFO - Running setup.py install for manifestparser 16:05:13 INFO - Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts 16:05:13 INFO - Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts 16:05:14 INFO - Running setup.py install for mozcrash 16:05:14 INFO - Running setup.py install for mozdebug 16:05:15 INFO - Running setup.py install for mozdevice 16:05:15 INFO - Installing sutini-script.py script to C:\slave\test\build\venv\Scripts 16:05:15 INFO - Installing sutini.exe script to C:\slave\test\build\venv\Scripts 16:05:15 INFO - Installing dm-script.py script to C:\slave\test\build\venv\Scripts 16:05:15 INFO - Installing dm.exe script to C:\slave\test\build\venv\Scripts 16:05:15 INFO - Running setup.py install for mozfile 16:05:16 INFO - Running setup.py install for mozhttpd 16:05:16 INFO - Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts 16:05:16 INFO - Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts 16:05:16 INFO - Running setup.py install for mozinfo 16:05:16 INFO - Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts 16:05:16 INFO - Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts 16:05:17 INFO - Running setup.py install for mozInstall 16:05:17 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts 16:05:17 INFO - Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts 16:05:17 INFO - Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts 16:05:17 INFO - Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts 16:05:17 INFO - Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts 16:05:17 INFO - Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts 16:05:17 INFO - Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts 16:05:17 INFO - Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts 16:05:17 INFO - Running setup.py install for mozleak 16:05:17 INFO - Running setup.py install for mozlog 16:05:18 INFO - Installing structlog-script.py script to C:\slave\test\build\venv\Scripts 16:05:18 INFO - Installing structlog.exe script to C:\slave\test\build\venv\Scripts 16:05:18 INFO - Running setup.py install for moznetwork 16:05:18 INFO - Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts 16:05:18 INFO - Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts 16:05:19 INFO - Running setup.py install for mozprocess 16:05:19 INFO - Running setup.py install for mozprofile 16:05:19 INFO - Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts 16:05:19 INFO - Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts 16:05:19 INFO - Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts 16:05:19 INFO - Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts 16:05:19 INFO - Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts 16:05:19 INFO - Installing view-profile.exe script to C:\slave\test\build\venv\Scripts 16:05:20 INFO - Running setup.py install for mozrunner 16:05:20 INFO - Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts 16:05:20 INFO - Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts 16:05:20 INFO - Running setup.py install for mozscreenshot 16:05:21 INFO - Running setup.py install for moztest 16:05:21 INFO - Running setup.py install for mozversion 16:05:21 INFO - Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts 16:05:21 INFO - Installing mozversion.exe script to C:\slave\test\build\venv\Scripts 16:05:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:05:22 INFO - Cleaning up... 16:05:22 INFO - Return code: 0 16:05:22 INFO - Installing None into virtualenv C:\slave\test\build/venv 16:05:22 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')]} 16:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:22 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')]} 16:05:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:22 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 0x022FC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023A8E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024B0A70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023C3E90>, '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 0x01DFA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027D7520>, '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-170', 'USERDOMAIN': 'T-W864-IX-170', '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-170', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-170\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-170', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-170', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-170', '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-170\\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 16:05:22 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 16:05:22 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 16:05:22 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 16:05:22 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-170\\AppData\\Roaming', 16:05:22 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 16:05:22 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 16:05:22 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 16:05:22 INFO - 'COMPUTERNAME': 'T-W864-IX-170', 16:05:22 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 16:05:22 INFO - 'DCLOCATION': 'SCL3', 16:05:22 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 16:05:22 INFO - 'FP_NO_HOST_CHECK': 'NO', 16:05:22 INFO - 'HOMEDRIVE': 'C:', 16:05:22 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-170', 16:05:22 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 16:05:22 INFO - 'KTS_VERSION': '1.19c', 16:05:22 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-170\\AppData\\Local', 16:05:22 INFO - 'LOGONSERVER': '\\\\T-W864-IX-170', 16:05:22 INFO - 'MONDIR': 'C:\\Monitor_config\\', 16:05:22 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 16:05:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:22 INFO - 'MOZ_NO_REMOTE': '1', 16:05:22 INFO - 'NO_EM_RESTART': '1', 16:05:22 INFO - 'NUMBER_OF_PROCESSORS': '8', 16:05:22 INFO - 'OS': 'Windows_NT', 16:05:22 INFO - 'OURDRIVE': 'C:', 16:05:22 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', 16:05:22 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 16:05:22 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 16:05:22 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 16:05:22 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 16:05:22 INFO - 'PROCESSOR_LEVEL': '6', 16:05:22 INFO - 'PROCESSOR_REVISION': '1e05', 16:05:22 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 16:05:22 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 16:05:22 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 16:05:22 INFO - 'PROGRAMW6432': 'C:\\Program Files', 16:05:22 INFO - 'PROMPT': '$P$G', 16:05:22 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 16:05:22 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 16:05:22 INFO - 'PUBLIC': 'C:\\Users\\Public', 16:05:22 INFO - 'PWD': 'C:\\slave\\test', 16:05:22 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 16:05:22 INFO - 'SLAVEDIR': 'C:\\slave\\', 16:05:22 INFO - 'SYSTEMDRIVE': 'C:', 16:05:22 INFO - 'SYSTEMROOT': 'C:\\windows', 16:05:22 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:05:22 INFO - 'TEST1': 'testie', 16:05:22 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:05:22 INFO - 'USERDOMAIN': 'T-W864-IX-170', 16:05:22 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-170', 16:05:22 INFO - 'USERNAME': 'cltbld', 16:05:22 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-170', 16:05:22 INFO - 'WINDIR': 'C:\\windows', 16:05:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 16:05:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:22 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 16:05:22 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-l0ldsx-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 16:05:22 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)) 16:05:22 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 16:05:22 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-zgzijt-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 16:05:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 16:05:22 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 16:05:22 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xuwn2i-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 16:05:22 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)) 16:05:22 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 16:05:22 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-uc68pg-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 16:05:22 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)) 16:05:22 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 16:05:22 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xz66fj-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 16:05:23 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)) 16:05:23 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 16:05:23 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-0xlcnu-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 16:05:23 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)) 16:05:23 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 16:05:23 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-lyysqm-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 16:05:23 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)) 16:05:23 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 16:05:23 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rj9lqv-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 16:05:23 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)) 16:05:23 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 16:05:23 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rzmlbl-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 16:05:23 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)) 16:05:23 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 16:05:23 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-8c_fby-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 16:05:23 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)) 16:05:23 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 16:05:23 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-akoptu-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 16:05:23 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)) 16:05:23 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 16:05:23 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-hwomsx-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 16:05:23 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)) 16:05:23 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 16:05:23 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-twv_kl-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 16:05:23 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)) 16:05:23 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 16:05:24 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-th4gwg-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 16:05:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 16:05:24 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 16:05:24 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-6fj2_b-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 16:05:24 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)) 16:05:24 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 16:05:24 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qandnj-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 16:05:24 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)) 16:05:24 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 16:05:24 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-t8tmqe-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 16:05:24 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)) 16:05:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==1.0->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2)) 16:05:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==1.0->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2)) 16:05:24 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)) 16:05:24 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)) 16:05:24 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)) 16:05:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10)) 16:05:24 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 16:05:24 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 16:05:25 INFO - Downloading blessings-1.6.tar.gz 16:05:25 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings 16:05:25 INFO - Installing collected packages: blessings 16:05:25 INFO - Running setup.py install for blessings 16:05:25 INFO - Successfully installed blessings 16:05:25 INFO - Cleaning up... 16:05:28 INFO - Return code: 0 16:05:28 INFO - Done creating virtualenv C:\slave\test\build/venv. 16:05:28 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 16:05:28 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 16:05:29 INFO - Reading from file tmpfile_stdout 16:05:29 INFO - Using _rmtree_windows ... 16:05:29 INFO - Using _rmtree_windows ... 16:05:29 INFO - Current package versions: 16:05:29 INFO - blessings == 1.6 16:05:29 INFO - blobuploader == 1.2.4 16:05:29 INFO - docopt == 0.6.1 16:05:29 INFO - functools32 == 3.2.3-2 16:05:29 INFO - jsonschema == 2.5.1 16:05:29 INFO - manifestparser == 1.1 16:05:29 INFO - mozInstall == 1.12 16:05:29 INFO - mozcrash == 1.0 16:05:29 INFO - mozdebug == 0.1 16:05:29 INFO - mozdevice == 0.48 16:05:29 INFO - mozfile == 1.2 16:05:29 INFO - mozhttpd == 0.7 16:05:29 INFO - mozinfo == 0.9 16:05:29 INFO - mozleak == 0.1 16:05:29 INFO - mozlog == 3.4 16:05:29 INFO - moznetwork == 0.27 16:05:29 INFO - mozprocess == 0.23 16:05:29 INFO - mozprofile == 0.28 16:05:29 INFO - mozrunner == 6.13 16:05:29 INFO - mozscreenshot == 0.1 16:05:29 INFO - mozsystemmonitor == 0.3 16:05:29 INFO - moztest == 0.7 16:05:29 INFO - mozversion == 1.4 16:05:29 INFO - psutil == 3.1.1 16:05:29 INFO - requests == 1.2.3 16:05:29 INFO - Installing None into virtualenv C:\slave\test\build/venv 16:05:29 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')]} 16:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:29 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')]} 16:05:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:29 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 0x022FC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023A8E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024B0A70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023C3E90>, '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 0x01DFA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027D7520>, '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-170', 'USERDOMAIN': 'T-W864-IX-170', '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-170', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-170\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-170', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-170', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-170', '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-170\\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 16:05:29 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 16:05:29 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 16:05:29 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 16:05:29 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-170\\AppData\\Roaming', 16:05:29 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 16:05:29 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 16:05:29 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 16:05:29 INFO - 'COMPUTERNAME': 'T-W864-IX-170', 16:05:29 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 16:05:29 INFO - 'DCLOCATION': 'SCL3', 16:05:29 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 16:05:29 INFO - 'FP_NO_HOST_CHECK': 'NO', 16:05:29 INFO - 'HOMEDRIVE': 'C:', 16:05:29 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-170', 16:05:29 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 16:05:29 INFO - 'KTS_VERSION': '1.19c', 16:05:29 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-170\\AppData\\Local', 16:05:29 INFO - 'LOGONSERVER': '\\\\T-W864-IX-170', 16:05:29 INFO - 'MONDIR': 'C:\\Monitor_config\\', 16:05:29 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 16:05:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:29 INFO - 'MOZ_NO_REMOTE': '1', 16:05:29 INFO - 'NO_EM_RESTART': '1', 16:05:29 INFO - 'NUMBER_OF_PROCESSORS': '8', 16:05:29 INFO - 'OS': 'Windows_NT', 16:05:29 INFO - 'OURDRIVE': 'C:', 16:05:29 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', 16:05:29 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 16:05:29 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 16:05:29 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 16:05:29 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 16:05:29 INFO - 'PROCESSOR_LEVEL': '6', 16:05:29 INFO - 'PROCESSOR_REVISION': '1e05', 16:05:29 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 16:05:29 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 16:05:29 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 16:05:29 INFO - 'PROGRAMW6432': 'C:\\Program Files', 16:05:29 INFO - 'PROMPT': '$P$G', 16:05:29 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 16:05:29 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 16:05:29 INFO - 'PUBLIC': 'C:\\Users\\Public', 16:05:29 INFO - 'PWD': 'C:\\slave\\test', 16:05:29 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 16:05:29 INFO - 'SLAVEDIR': 'C:\\slave\\', 16:05:29 INFO - 'SYSTEMDRIVE': 'C:', 16:05:29 INFO - 'SYSTEMROOT': 'C:\\windows', 16:05:29 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:05:29 INFO - 'TEST1': 'testie', 16:05:29 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:05:29 INFO - 'USERDOMAIN': 'T-W864-IX-170', 16:05:29 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-170', 16:05:29 INFO - 'USERNAME': 'cltbld', 16:05:29 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-170', 16:05:29 INFO - 'WINDIR': 'C:\\windows', 16:05:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 16:05:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:29 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)) 16:05:29 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)) 16:05:29 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)) 16:05:29 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)) 16:05:29 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)) 16:05:29 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)) 16:05:29 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)) 16:05:29 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)) 16:05:29 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)) 16:05:29 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)) 16:05:29 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)) 16:05:29 INFO - Cleaning up... 16:05:29 INFO - Return code: 0 16:05:29 INFO - Installing jsonschema into virtualenv C:\slave\test\build/venv 16:05:29 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')]} 16:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:29 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')]} 16:05:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:29 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 0x022FC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023A8E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024B0A70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023C3E90>, '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 0x01DFA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027D7520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-170', 'USERDOMAIN': 'T-W864-IX-170', '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-170', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-170\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-170', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-170', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-170', '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-170\\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 16:05:29 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 16:05:29 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 16:05:29 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 16:05:29 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-170\\AppData\\Roaming', 16:05:29 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 16:05:29 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 16:05:29 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 16:05:29 INFO - 'COMPUTERNAME': 'T-W864-IX-170', 16:05:29 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 16:05:29 INFO - 'DCLOCATION': 'SCL3', 16:05:29 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 16:05:29 INFO - 'FP_NO_HOST_CHECK': 'NO', 16:05:29 INFO - 'HOMEDRIVE': 'C:', 16:05:29 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-170', 16:05:29 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 16:05:29 INFO - 'KTS_VERSION': '1.19c', 16:05:29 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-170\\AppData\\Local', 16:05:29 INFO - 'LOGONSERVER': '\\\\T-W864-IX-170', 16:05:29 INFO - 'MONDIR': 'C:\\Monitor_config\\', 16:05:29 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 16:05:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:29 INFO - 'MOZ_NO_REMOTE': '1', 16:05:29 INFO - 'NO_EM_RESTART': '1', 16:05:29 INFO - 'NUMBER_OF_PROCESSORS': '8', 16:05:29 INFO - 'OS': 'Windows_NT', 16:05:29 INFO - 'OURDRIVE': 'C:', 16:05:29 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', 16:05:29 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 16:05:29 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 16:05:29 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 16:05:29 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 16:05:29 INFO - 'PROCESSOR_LEVEL': '6', 16:05:29 INFO - 'PROCESSOR_REVISION': '1e05', 16:05:29 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 16:05:29 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 16:05:29 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 16:05:29 INFO - 'PROGRAMW6432': 'C:\\Program Files', 16:05:29 INFO - 'PROMPT': '$P$G', 16:05:29 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 16:05:29 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 16:05:29 INFO - 'PUBLIC': 'C:\\Users\\Public', 16:05:29 INFO - 'PWD': 'C:\\slave\\test', 16:05:29 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 16:05:29 INFO - 'SLAVEDIR': 'C:\\slave\\', 16:05:29 INFO - 'SYSTEMDRIVE': 'C:', 16:05:29 INFO - 'SYSTEMROOT': 'C:\\windows', 16:05:29 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:05:29 INFO - 'TEST1': 'testie', 16:05:29 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:05:29 INFO - 'USERDOMAIN': 'T-W864-IX-170', 16:05:29 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-170', 16:05:29 INFO - 'USERNAME': 'cltbld', 16:05:29 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-170', 16:05:29 INFO - 'WINDIR': 'C:\\windows', 16:05:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 16:05:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in c:\slave\test\build\venv\lib\site-packages 16:05:29 INFO - Cleaning up... 16:05:29 INFO - Return code: 0 16:05:29 INFO - Running post-action listener: _resource_record_post_action 16:05:29 INFO - Running post-action listener: _start_resource_monitoring 16:05:29 INFO - Starting resource monitoring. 16:05:30 INFO - [mozharness: 2016-11-12 00:05:30.051000Z] Finished create-virtualenv step (success) 16:05:30 INFO - [mozharness: 2016-11-12 00:05:30.051000Z] Running install step. 16:05:30 INFO - Running pre-action listener: _resource_record_pre_action 16:05:30 INFO - Running main action method: install 16:05:30 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 16:05:30 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 16:05:30 INFO - Reading from file tmpfile_stdout 16:05:30 INFO - Using _rmtree_windows ... 16:05:30 INFO - Using _rmtree_windows ... 16:05:30 INFO - Detecting whether we're running mozinstall >=1.0... 16:05:30 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h'] 16:05:30 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h 16:05:30 INFO - Reading from file tmpfile_stdout 16:05:30 INFO - Output received: 16:05:30 INFO - Usage: mozinstall-script.py [options] installer 16:05:30 INFO - Options: 16:05:30 INFO - -h, --help show this help message and exit 16:05:30 INFO - -d DEST, --destination=DEST 16:05:30 INFO - Directory to install application into. [default: 16:05:30 INFO - "C:\slave\test"] 16:05:30 INFO - --app=APP Application being installed. [default: firefox] 16:05:30 INFO - Using _rmtree_windows ... 16:05:30 INFO - Using _rmtree_windows ... 16:05:30 INFO - mkdir: C:\slave\test\build\application 16:05:30 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'] 16:05:30 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 16:05:32 INFO - Reading from file tmpfile_stdout 16:05:32 INFO - Output received: 16:05:32 INFO - C:\slave\test\build\application\firefox\firefox.exe 16:05:32 INFO - Using _rmtree_windows ... 16:05:32 INFO - Using _rmtree_windows ... 16:05:32 INFO - Running post-action listener: _resource_record_post_action 16:05:32 INFO - [mozharness: 2016-11-12 00:05:32.631000Z] Finished install step (success) 16:05:32 INFO - [mozharness: 2016-11-12 00:05:32.631000Z] Running run-tests step. 16:05:32 INFO - Running pre-action listener: _resource_record_pre_action 16:05:32 INFO - Running main action method: run_tests 16:05:32 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version'] 16:05:32 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version 16:05:32 INFO - Python 2.7.3 16:05:32 INFO - Return code: 0 16:05:32 INFO - grabbing minidump binary from tooltool 16:05:32 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')]} 16:05:32 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 0x023C3E90>, '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 0x01DFA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027D7520>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1 16:05:32 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 16:05:32 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 16:05:32 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 16:05:32 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 16:05:33 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmpbtzsbb 16:05:33 INFO - INFO - File integrity verified, renaming tmpbtzsbb to win32-minidump_stackwalk.exe 16:05:33 INFO - Return code: 0 16:05:33 INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755 16:05:33 INFO - mkdir: C:\slave\test\build\blobber_upload_dir 16:05:33 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir 16:05:33 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe 16:05:33 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir 16:05:33 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/eTOpnRcCSvmaQfqfpzyd2Q/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-170', '--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 16:05:33 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/eTOpnRcCSvmaQfqfpzyd2Q/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip --title T-W864-IX-170 --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 16:05:33 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 16:05:33 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-170\\AppData\\Roaming', 16:05:33 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 16:05:33 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 16:05:33 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 16:05:33 INFO - 'COMPUTERNAME': 'T-W864-IX-170', 16:05:33 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 16:05:33 INFO - 'DCLOCATION': 'SCL3', 16:05:33 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 16:05:33 INFO - 'FP_NO_HOST_CHECK': 'NO', 16:05:33 INFO - 'HOMEDRIVE': 'C:', 16:05:33 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-170', 16:05:33 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 16:05:33 INFO - 'KTS_VERSION': '1.19c', 16:05:33 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-170\\AppData\\Local', 16:05:33 INFO - 'LOGONSERVER': '\\\\T-W864-IX-170', 16:05:33 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir', 16:05:33 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe', 16:05:33 INFO - 'MONDIR': 'C:\\Monitor_config\\', 16:05:33 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 16:05:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:33 INFO - 'MOZ_NO_REMOTE': '1', 16:05:33 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir', 16:05:33 INFO - 'NO_EM_RESTART': '1', 16:05:33 INFO - 'NUMBER_OF_PROCESSORS': '8', 16:05:33 INFO - 'OS': 'Windows_NT', 16:05:33 INFO - 'OURDRIVE': 'C:', 16:05:33 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', 16:05:33 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 16:05:33 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 16:05:33 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 16:05:33 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 16:05:33 INFO - 'PROCESSOR_LEVEL': '6', 16:05:33 INFO - 'PROCESSOR_REVISION': '1e05', 16:05:33 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 16:05:33 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 16:05:33 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 16:05:33 INFO - 'PROGRAMW6432': 'C:\\Program Files', 16:05:33 INFO - 'PROMPT': '$P$G', 16:05:33 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 16:05:33 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 16:05:33 INFO - 'PUBLIC': 'C:\\Users\\Public', 16:05:33 INFO - 'PWD': 'C:\\slave\\test', 16:05:33 INFO - 'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos', 16:05:33 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 16:05:33 INFO - 'SLAVEDIR': 'C:\\slave\\', 16:05:33 INFO - 'SYSTEMDRIVE': 'C:', 16:05:33 INFO - 'SYSTEMROOT': 'C:\\windows', 16:05:33 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:05:33 INFO - 'TEST1': 'testie', 16:05:33 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:05:33 INFO - 'USERDOMAIN': 'T-W864-IX-170', 16:05:33 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-170', 16:05:33 INFO - 'USERNAME': 'cltbld', 16:05:33 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-170', 16:05:33 INFO - 'WINDIR': 'C:\\windows', 16:05:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 16:05:33 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/eTOpnRcCSvmaQfqfpzyd2Q/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-170', '--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 16:05:34 INFO - mozversion application_buildid: 20161111133014 16:05:34 INFO - mozversion application_changeset: 5d1c54f240d077b6b8e141fd44b52a3b694a5dfd 16:05:34 INFO - mozversion application_display_name: Nightly 16:05:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:05:34 INFO - mozversion application_name: Firefox 16:05:34 INFO - mozversion application_remotingname: firefox 16:05:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:05:34 INFO - mozversion application_vendor: Mozilla 16:05:34 INFO - mozversion application_version: 52.0a1 16:05:34 INFO - mozversion platform_buildid: 20161111133014 16:05:34 INFO - mozversion platform_changeset: 5d1c54f240d077b6b8e141fd44b52a3b694a5dfd 16:05:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:05:34 INFO - mozversion platform_version: 52.0a1 16:05:34 INFO - using testdate: 1478909134 16:05:34 INFO - actual date: 1478909134 16:05:34 INFO - starting webserver on 'localhost:49264' 16:05:34 INFO - SUITE-START | Running 2 tests 16:05:34 INFO - TEST-START | dromaeo_css 16:05:34 INFO - operating with platform_type : w8_ 16:05:34 INFO - Initialising browser for dromaeo_css test... 16:05:34 INFO - TEST-INFO | started process 3844 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpu18v2c\profile http://localhost:49264/getInfo.html) 16:05:42 INFO - PROCESS | 3844 | __metrics Screen width/height:1600/1200 16:05:42 INFO - PROCESS | 3844 | colorDepth:24 16:05:42 INFO - PROCESS | 3844 | Browser inner width/height: 1010/674 16:05:42 INFO - PROCESS | 3844 | __metrics 16:05:44 INFO - PROCESS | 3844 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:05:44 INFO - PROCESS | 3844 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:05:45 INFO - TEST-INFO | 3844: exit 0 16:05:45 INFO - Browser initialized. 16:05:45 INFO - Running cycle 1/1 for dromaeo_css test... 16:05:45 INFO - TEST-INFO | started process 1072 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpu18v2c\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:05:46 INFO - PROCESS | 1072 | [GFX1-]: Invalid size in UpdateRenderTarget Size(124,0), 0 16:05:56 INFO - PROCESS | 1072 | RSS: Main: 158228480 16:05:56 INFO - PROCESS | 1072 | 16:06:48 INFO - PROCESS | 1072 | 1478909208088 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] 16:08:59 INFO - PROCESS | 1072 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49264/tests/dromaeo/cssquery-ext.html) 16:09:02 INFO - PROCESS | 1072 | RSS: Main: 342319104 16:09:02 INFO - PROCESS | 1072 | 16:12:05 INFO - PROCESS | 1072 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-ext.html (next: http://localhost:49264/tests/dromaeo/cssquery-jquery.html) 16:12:05 INFO - PROCESS | 1072 | RSS: Main: 225370112 16:12:05 INFO - PROCESS | 1072 | 16:15:08 INFO - PROCESS | 1072 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49264/tests/dromaeo/cssquery-mootools.html) 16:15:08 INFO - PROCESS | 1072 | RSS: Main: 175161344 16:15:08 INFO - PROCESS | 1072 | 16:18:10 INFO - PROCESS | 1072 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49264/tests/dromaeo/cssquery-prototype.html) 16:18:11 INFO - PROCESS | 1072 | RSS: Main: 176840704 16:18:11 INFO - PROCESS | 1072 | 16:21:14 INFO - PROCESS | 1072 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49264/tests/dromaeo/cssquery-yui.html) 16:21:15 INFO - PROCESS | 1072 | RSS: Main: 163831808 16:21:15 INFO - PROCESS | 1072 | 16:24:17 INFO - PROCESS | 1072 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-yui.html (next: http://localhost:49264/tests/dromaeo/cssquery-dojo.html) 16:24:17 INFO - PROCESS | 1072 | RSS: Main: 231399424 16:24:17 INFO - PROCESS | 1072 | 16:24:17 INFO - PROCESS | 1072 | __start_tp_report 16:24:17 INFO - PROCESS | 1072 | _x_x_mozilla_page_load 16:24:17 INFO - PROCESS | 1072 | _x_x_mozilla_page_load_details 16:24:17 INFO - PROCESS | 1072 | |i|pagename|runs| 16:24:17 INFO - PROCESS | 1072 | |0;dojo.html;2933.897313594024;2959.215807810929;2986.2086547065032;2988.7758418118633;3001.744851687607;5354.303940487741;5363.034653762321;5379.865503362418;5389.946100538993;5448.128299472085;5261.526462618363;5328.946710532893;5381.461853814617;5393.541548968333;5416.485433883775;4720.221163508017;4746.21687421575;4751.572358487735;4759.4764575896625;4819.590334821544;4786.042791441726;4803.831865884695;4811.711297322155;4822.373091498101;4834;4697;4702.177119004177;4713.787879545412;4813.7593120343845;4830.420349558058;4719.315699223594;4767.475577686451;4770.284457331393;4781.784819683088;4823.083614113307;4522.706024108423;4624.30635404692;4762;4800.255960326155;4820.734859582722;5223.895522089537;5243.8164664236565;5285.7621407036395;5312.043832110218;5436.483534064258;5653.038983372837;5676.120201368794;5701.2018317435595;5704.629199102045;5710.571707121982;5649.576281778883;5751.079827227665;5753.9642864284415;5755.625884317547;5763.077907534775;5231.110711179109;5277.419483856773;5291.444398338196;5307.814226502054;5314.893702125936;5874.794382196603;5888.5289176865745;5920.111983202468;5922.466977972003;5929.436703513159;5520.951019306319;5609.130584759288;5625.774969001276;5648.322201335866;5651.8304450866535;5710;5722.599418040697;5729.88540229193;5737.655740655574;5751.309842818889;5755.482006619424;5761.48146666802;5769.798057067983;5774.3070831499645;5775.88448231033;5763.193152958589;5772.220750198753;5779.075347944308;5786.3056433228285;5787.392323806024;3955.7626542407547;3972.443857859902;3973.562908080109;3980.144268982183;3985.262726395626;3454.6545345465756;3454.913627159341;3458.844352004166;3463.6016858061644;3464.185916309665;5439;5441.727913604304;5443.537299329522;5446.264754258124;5452.291202143696;5768.653880767168;5803.912941305884;5815.244018277597;5818.5345172386105;5885.852853678693;5417.431169727122;5422.6475279106735;5428;5431.565474762009;5441.428649991773;4610.193216187154;4621.953780462152;4642.675012749142;4657.394538710014;4751.95248047522;5959.642421454727;5978.163057172086;5980.192673988956;6013.729382177812;6016.969915150396;5802.7098645066735;5842.152887831326;5845.590808643354;5846.152307915243;5854.385289544707;5754.021816291157;5811.418858114154;5817.738201781015;5959.404059594006;5972.820815375546;5636.0418728815375;5640.351359593699;5646.943530564642;5654.915176272277;5658.321001479849;5621;5709.058005429058;5718.228039214653;5728.226689396878;5728.398518155534;5553.333599968029;5588.993981083444;5589.357223919139;5590.413006634245;5600.383957764561;5530.115181570929;5545.029619816597;5545.972270138624;5548.861278467909;5594.720263986866;5538.086215774352;5567.387587365468;5576.86057848557;5577.191307260506;5582.385937546947;5627.943720562906;5689.601727879174;5699.715014249354;5716.228309178207;5767.077267637158;5553.750081246434;5586.636868603528;5606.159076138611;5606.271184745957;5660 16:24:17 INFO - PROCESS | 1072 | |1;ext.html;522.6315447609436;541.5775694957935;590.610197269802;598.3986093975554;607.2743072028921;31888.36223275536;35720.10699732505;35726.642733572655;35730.46404303938;35895.64104358956;36253.63746362535;36581.26837463256;36690.8165459173;36725.816370918175;36819.263614727686;7365.963170184142;7564.962175189116;7970.760877173694;9502.762430939212;9802.166815820663;9710.514474276293;9823.50882455878;9877.851832222523;9881.20950323976;9884.258680598949;9896.455694936776;9918.156956658693;9941.05559971805;9950.203983681287;9957.950210248939;7314.268573142696;7447.069116360455;7484.326410623015;9850.901490985107;9875.383023498778;7555.395568354518;7620.237976202391;9440.811183776286;9727.464989425578;9779.973102824171;35706.46440303398;35842;35909.82045089784;36013;36044.09889752751;2779.5552711566256;2936.5154749466315;2979.865906034234;3139.073973177918;3197.376511580243;27453.450930981267;27673.44653106947;28795.712042879513;28878.42243155125;29165.56251656227;3938.9214740020466;4006.1787333596544;4063.9796801015805;4087.9182416351505;4123.804096811921;290004;291945;292417;292931;293678;45377;45402.545974540495;45475.31787023197;45480.772596136805;45502.54497454983;44248.77875610601;48294;48590.757046214545;48668.51331486711;48758;12043.21719088274;12336;12347.93826030882;12379.257244565355;12397;10145.28982971185;10196.898031019595;10203.38779673222;10256.794864102676;10257.743556411;12907.354632268349;13376.933115334361;13390.330483475787;13448.394822233024;13538.796918046237;5414.431484694051;5430.992772310295;5466.535344495763;5480.7533660985355;5506.311711036121;762.9237076292326;845.9619317130744;891.777055736066;911.6900253913701;922.1838672774643;25849.741502585108;26743.866280668473;27038.459230815668;27294.863525682642;27362.863185683946;858.8368210040072;870.3863776037878;904.9864152149635;958.4776296918196;993.5826952679892;13733.587992360246;14026.158430494203;14061.578152655436;14384.136951782926;14386;443653;446701;454130;454153;456260;47172.292415613796;47306.290405643944;47386.289205661946;47411;47456.5254347459;960.3661583354952;961.5288508630861;963.7494251494521;964.1997142371955;997.8303688372994;26638.7336126644;28883.711162888103;29269.70730292755;29553.55669664914;29564.852175738983;42400.36399453949;42663;42912.35631465593;42928.35607465828;42981;377279;381261;386434.2713145778;386538;386718;23333.649995250424;24088.51822963496;24204.87897560501;24788.752112478644;34057;33039.33921321608;33096.50355244625;33568.49647255244;33756;34115.14712132117;33044.66955330416;33495;34773.652263477044;34800;34849.47725784166;34652.65347346494;34902.650973490956;34960;35350.46974295439;35705.46441803323;33132.503012455316;33514.16214594557;33527.329453410304;33585.16037099092;33815.661843381255;30454.238644034078;31442.528362075045;31504.527432088078;31525.054248372584;31597.21006974844;21150.69421265278;22601.88699056494;23697.881510592335;24234.87882560576;24282.71518544465 16:24:18 INFO - PROCESS | 1072 | |2;jquery.html;330.8544240534166;337.19578804551156;351.6009329411118;352.66320663766106;367.99170273450756;12856.614301570957;13723.245221512812;16291.674166516677;16453.67092658149;16608.418705345317;15575.221238938037;15640.765388519152;15787.28957196926;15829.683406331866;15836.129012904286;4335.609795118438;5162.690238585678;5388.568914486832;5394.595405344595;5396.5952553558445;5287.973560132194;5426.565874730032;5449;5452.236686863842;5453.836384908439;5373.355197376301;5387.730613469331;5393.59548033897;5398.514133727964;6571.704273307712;6844;6943.062686537329;7007.264237255116;7037.366637002643;7042.36618704314;6514.283428822826;6730;6751.392374686302;6776.525643204977;6783.42340901024;21281.78718212829;21389.25137620176;21458.570828583343;21604.675929861063;21686.674699879513;2144.7533533643673;2168.4253672776726;2251.2683377902085;2288.5880541502524;2334.789868911789;13467.932660336734;13838;13976.930115349358;14130.010899237057;14579.781303280459;1895.3555791030979;1985.2753744883157;2064.463239557711;2072.274703853654;2100;62951;65617.3438265616;76830.61584692096;85940.57029714873;89363;14756.778648320284;15701.057936523845;15705.68588628221;15712.371505139896;15745.68508629821;26239.344016399744;26357.472850543265;26396.340091497867;26404.339891502867;26512.867435662698;8069.556174410463;8119.675212991414;8194.22154895284;8289;8320.209580089882;6638.004299355135;6663.733450661919;6752.898706519406;6794.218664853506;6816.727330906709;7741;7886.921130788619;7909.6836126555445;7927.969363982761;7929.960350198212;3223.9194020149216;3230.725388342017;3242.5298331741765;3268.150280926976;3337.365900478901;660.6762686283687;693.5803838677629;707.2503146664552;734.5812886654555;772.9033870766154;15393.692126157413;16254.837451625332;16432.67134657324;16740.748888766677;16822.831771682126;777.7899967008876;788.7160622176012;791.2008871040291;819.3486178488116;845.2392846438132;5472.5621950243885;5500.642458240201;5574.693391863405;5602;5753.367129615739;419922;426428;428335;429116;429355;67654;78863.72131270137;79686;79799.60601181973;83551.16448835556;391.0946159640423;401.5803485357808;403.5057055107529;403.65890822255733;410.3393536406383;9575.186109180797;9717.805643887225;9741.80516389654;9875.456849873326;10022.649207277711;31690.524642129927;34223;35282.294354113284;36022.63977360193;36146.63853361433;43075.56924430715;48071.032763212075;48478.757606213156;48697.02605947932;49136.50863491462;7238.710451581877;7470.365018973448;7500.662470188746;7593.278638529331;7613.961930190314;11130.332180069221;11430.599929002445;11433;11606.187566870238;11643.476043578228;10009.199264058712;10138.087572118544;10251.436171010666;10295.12491438236;10390.792184156426;9970;10007.899921000988;10160.08559229673;10290.742731431774;10419.843702344318;9925.454100024279;10032.548535315782;10151.64469243573;10524.210684198562;10623.415712135598;7448.14346350155;7481.139668938142;7505.88741168872;7523.3229009389415;7584.5070070445245;9224.354295199271;10181.847272290774;10267.281290309607;10377.896221037994;10399.648045754004 16:24:18 INFO - PROCESS | 1072 | |3;mootools.html;1072.0083922371807;1084.6366467233477;1162.9360385178818;1188.92996303327;1213.1507944438895;7119.394851437628;7562.432817538679;7568.848623027536;7591.848163036743;7630.122535908372;6627.701753421095;6870.79387618371;7115.18175409828;7256.709731610742;7433.405327573794;1895.9241630334805;1912.225548652798;1917.4918646558674;1920.1167462966982;1921.0106795000586;1811.5471132216946;1834.0646270402124;1835.1191428114514;1842.4748946550235;1845.649326627943;1679.7480377943346;1727.317709504745;1731.8008429030633;1736.1059054586897;1776.4315419065904;1618.150471002727;1809.1135343681567;1855.5453913791073;1866.831985121332;1879.4267748336752;1768.3015208992504;1769.902655353955;1771.2383675019737;1772.1050869311043;1773.2995466790674;7253.093363329584;7351.485396022281;7365.705371785122;7368.447366447538;7372.115346158442;4344.9348259776125;4507.954920450787;4513.842015529441;4523.457185137771;4527.230370836933;2856.957145642817;2965.37727077314;3084.3522860199387;3101.8914337998062;3103.5189545620465;962.302330810164;975.3367709957226;996.8454889492141;1021.1371391174446;1025.2003437318904;10380.32527885685;10477.738056548571;10504.737381565523;10525.105366043896;10540.631077912312;3793.203427280247;3972.106276087915;4009.979950100231;4020.075382662004;4025.1748391579654;7400.148982867039;8015.358771298283;8118.35053195743;8130.146334634896;8133.024037115584;4269.167512335127;4400.933985990213;4411.492678341968;4412.955870441318;4432.268675668479;4176.206520761046;4178.561251068594;4186.099988502487;4187.120704651997;4191.140816132685;2962.5852380666724;2966.6143401357685;2974.2415684000443;2982.3140677644265;3023.788334816542;867.9522626255616;886.414966122369;899.1278459893892;899.680613382253;902.4810733828075;714.9177844547839;716.9856602867914;725.9165196002422;736.1828370508731;753.4725692015611;4646.070785842845;4690.718556886598;4701.882452938636;4714.363560919301;4728.71627702339;344.8827398684409;347.1581415068449;350.64935064935065;362.6663469607967;367.4524957812893;2946.337074158297;3006.5490176473268;3021.9848900755355;3033.878644854181;3106.378724255158;8795.47227166372;9460.8580871287;9545;9552.665656701982;9559.617615295449;8827.382083254111;9473.431594104375;9478.90521094794;9485.573149208301;9501.572429240701;6763.661816909135;7112.217656057829;7117.003619493275;7133.464990125657;7139.714411423589;4568.565986231302;4576.107659006462;4713.622910167247;4754.904901902012;4816.879578010437;8373.162683731578;8376.623051962555;8629.43908645936;8664.090270521505;8670.349723770616;8550.82898342042;8713.30293576525;8794.340424468062;8844.292456603585;8854.734357969272;6503.991881258413;6669.699863506251;6699.330066993261;6704.530682852153;6707.631080290631;7171.928280717335;7178.318059784312;7194.956731274041;7221.494495385273;7283.599402032939;6543.083968244355;6625.834354141185;6669.199696036507;6689.665516724242;6709.094272273181;6367.363263673596;6370.617762934239;6381.787460382512;6527.902081468686;6638.767643132467;5915.201447804491;5969;6022.427869352405;6035.78874739382;6060.727267272895;3396.9096455765075;4182.895427614212;4218.620324170839;4294.119705460435;4367.868963931087;4099.364598487239;4105.938410923779;4127.195196936568;4157.9605098725315;4185.142045880648 16:24:18 INFO - PROCESS | 1072 | |4;prototype.html;285.8799304292198;286.58874515070863;287.3434202846496;290.564153769346;296.11314114227883;5380.273663055486;5410.215518749784;5410.431904650014;5427.755750991205;5451.509364157225;5264.868378290545;5266.34170728659;5294.602904782138;5347.839564813052;5373.570114390849;3827.364004196018;3907;3921.392184211452;3985.306244845943;4021.6380525752675;3939.72421930465;3974.112296659093;3998.820642749694;4000.819963101653;4007.8797636070963;3970.7617542947373;3980.761154330735;3993.640572348488;4005.299072662287;4012.1775036117524;3811.866584669537;3921.3333733265413;3927.116398810259;4001.899952501182;4006.779627120507;3479.7564170508076;3486.3550243205086;3486.3898817707054;3490.3193877193958;3494.5457090578316;5153.433122356538;5176.637635365489;5184.533391994739;5217.739113044333;5244.344456942882;4475.261581838992;4621.884452888671;4643.6517261205545;4653.581177694024;4710.788014539354;5483.698396588186;5503.367112782042;5504.522964665916;5524.171374293848;5533.529649979757;3859.9614003859883;3864.241769994646;3873.5545412277665;3878;3888.863889763845;5642.238297829823;5702.716888700051;5742.196092547047;5820.214271073435;5852.76588936442;3963.920721585552;3972.411035585731;3978.5026871641044;3981.8606348777653;3992.441058251847;4046.59534046593;4066.8373265069067;4076.612721791425;4106.527749308808;4107.3918062030225;4505.797239124247;4679.321498382716;4698.7783176373705;4715.929261061086;4731.243001119804;5570.637908535932;5573.554115670818;5582.720863956786;5583.302087239095;5704.80033198836;1340.671535473815;1366.2280811341561;1366.3782978744648;1372.9359746196778;1376.421902800826;865.1219012702112;867.6312567158932;912.598456679059;931.5994122527243;935.8128374325162;4938.111139994836;5251.422343542207;5320.680759154463;5349.3580770307035;5370.113931201308;5730.226419433407;5758.544873076121;5775.942240577624;5785.739641716049;5835.883282334329;5114.846554603368;5366.490183432567;5390.676559406448;5402.6758394496455;5417.620766546304;2973.583698282242;2989.9967022095248;2996.4456575533595;2999.2951656360738;3022.2293315204483;5734.856628584319;5749.367569567345;5759.395263497272;5795.014847475939;5815.476607105296;5536.363318218376;5679.460451257124;5703.636717910802;5711.857203569861;5738.225339579103;5693.28833895763;5696.259486266758;5735.713214339266;5742.626729262584;5744.913826292609;5307.920381194208;5547.445255474582;5586.77652893896;5602.1512900741845;5627.971860140673;5464.890702185855;5471.8084867029465;5477.808276710296;5490.505854473116;5499.625093726569;5737.368889422077;5751.874253919562;5757.424257574209;5760.1119244508955;5767.423257674199;3612.548431446069;3626.3835148024373;3647.3799454092336;3704.407294832814;3759.7029024986336;5606.131049687305;5612.663240205601;5625.578081643975;5637.2107904894165;5639.943600563942;5433.456654334693;5444.787575330574;5478.205660179331;5483.8080667176455;5501.174823776306;5285.735713214247;5389;5393.703346315833;5427.538659214011;5447.782088716407;5333.2000699633;5368.489993450616;5373.656585853537;5379.515843574097;5398.677324055631;5427.565794736491;5522.735678371848;5539.473749993744;5565.666060036411;5628.60599758013;5548.140038294071;5559.081482221866;5568.025595520687;5569.805056822992;5597.496225339739 16:24:18 INFO - PROCESS | 1072 | |5;yui.html;583.9591228613996;640.7853369121344;644.4135836388886;653.9149910511633;669.334012657406;11958.222715523485;12659.873401265984;12779.169353991996;13027.34863256838;13042.152260103087;11161.553537858495;11244.381559014251;11265.718357041078;11270.492827822747;11298.887011129886;385.38915818427824;393.62408899500906;413.4459823836059;416.28191369887;420.3673471425516;420.42191986019225;422.20835932626323;428.1949934123843;428.9056407590341;430.6253559403323;445.779339227083;451.49658131183656;452.2899048493866;452.4231604704012;452.5745798948994;399.99800000999807;402.1554735056387;434.1295702117235;434.48947486703315;463.73798803675817;336.2384199787483;339.7536785830253;343.0737010072788;343.6134348857535;344.1705489769643;11390;11400.201985860993;11435.42822858862;11450.141239407078;11484.655460336204;10806.72983175419;10888.564457421693;10902.781944361068;11093.445327733582;11579.131565132564;11254.831177532262;11286.379249141293;11469.082473402192;11544.59593914209;11562.94218528902;4042.090529630839;4053.5541090480024;4055.3308704063793;4097.938530922039;4167.499900011988;53876.73061634706;55351.72324138354;55774.566502782196;56046.03263477865;57649.99999999958;9133.77165570866;9138.954305228432;9322.766930826649;9356.719298421058;9514.38156519824;15210.619734506727;15470.381184752483;15493.767593486107;15512.922435387976;15542.611434714223;6727.562708424035;6885.345892140239;6907.378335949788;6983.755568555076;7160.820979475555;3842.6733727632904;3880;3882.1847412043785;3959.2279505496726;3968.464257325282;2663.227663977425;2796.1471751116105;2800.2999250187454;2811.9437611248068;2813.8030337876153;479.1853848457636;482.27176962785745;486.22204472843873;488.75562218890553;502.25164504887454;500.19468655464675;578.9363170051291;582.4408567774983;587.7766448749534;612.1185492890223;7205.495615306878;7656.425768067417;7791.181925897699;7857.934297607333;8042.3968202383885;540.4649397096924;545.5989847462113;547.5728931433488;553.2448208195784;555.303094616254;3444.603870554868;3467.7052450541987;3540.8406621702084;3599.370110230699;3666.3400587894434;49284.75357623261;71282.64358678173;71815;72029.27970720225;72557.6372118136;54976.450235497934;55555.72222138944;60679;61264.387356125866;61931.69034154891;52780.73609631927;53427.73286133622;53602.463975359744;53994;54482.45517544853;7877.502897961887;8156.306713929383;8194.877076843733;8210.220029097227;8313.376496762647;35413.46879796857;35489;35949.82025089858;36082.45876311805;36668.63331366652;44975.550244497135;47028.7648561755;48919;50021.49978500168;50069.24896126634;8923.643054277756;9189.632414703605;9345.252379809735;9407.294452915921;9859.408435493893;11847.466863991314;12260.509579616715;12306.75386492283;12514.249145050962;12698.238105713686;10999.945000274947;11031.393273370042;11107.222494425636;11121;11662.475188616701;11600.883991160317;11695.590654327058;11714.23857449263;11876.081706331353;11974.22167559106;10341.844872327072;10437.530311135864;10449.84325235107;11391.259568128045;11481.483333249857;10037.19702423819;10083.747906302402;10184.083432491112;10338.12125969301;10533.36799792015;9542.141207291377;9915.752106197402;10062.89937100649;10105.89894101079;10134.138598219233 16:24:18 INFO - PROCESS | 1072 | __end_tp_report 16:24:18 INFO - PROCESS | 1072 | __start_cc_report 16:24:18 INFO - PROCESS | 1072 | _x_x_mozilla_cycle_collect,2365 16:24:18 INFO - PROCESS | 1072 | __end_cc_report 16:24:18 INFO - PROCESS | 1072 | __startTimestamp1478910257978__endTimestamp 16:24:18 INFO - PROCESS | 1072 | 16:24:18 INFO - PROCESS | 1072 | ------- Summary: start ------- 16:24:18 INFO - PROCESS | 1072 | Number of tests: 6 16:24:18 INFO - PROCESS | 1072 | 16:24:18 INFO - PROCESS | 1072 | [#0] dojo.html Cycles:165 Average:5277.24 Median:5553.75 stddev:699.72 (12.6%) stddev-sans-first:677.29 16:24:18 INFO - PROCESS | 1072 | Values: 2933.9 2959.2 2986.2 2988.8 3001.7 5354.3 5363.0 5379.9 5389.9 5448.1 5261.5 5328.9 5381.5 5393.5 5416.5 4720.2 4746.2 4751.6 4759.5 4819.6 4786.0 4803.8 4811.7 4822.4 4834.0 4697.0 4702.2 4713.8 4813.8 4830.4 4719.3 4767.5 4770.3 4781.8 4823.1 4522.7 4624.3 4762.0 4800.3 4820.7 5223.9 5243.8 5285.8 5312.0 5436.5 5653.0 5676.1 5701.2 5704.6 5710.6 5649.6 5751.1 5754.0 5755.6 5763.1 5231.1 5277.4 5291.4 5307.8 5314.9 5874.8 5888.5 5920.1 5922.5 5929.4 5521.0 5609.1 5625.8 5648.3 5651.8 5710.0 5722.6 5729.9 5737.7 5751.3 5755.5 5761.5 5769.8 5774.3 5775.9 5763.2 5772.2 5779.1 5786.3 5787.4 3955.8 3972.4 3973.6 3980.1 3985.3 3454.7 3454.9 3458.8 3463.6 3464.2 5439.0 5441.7 5443.5 5446.3 5452.3 5768.7 5803.9 5815.2 5818.5 5885.9 5417.4 5422.6 5428.0 5431.6 5441.4 4610.2 4622.0 4642.7 4657.4 4752.0 5959.6 5978.2 5980.2 6013.7 6017.0 5802.7 5842.2 5845.6 5846.2 5854.4 5754.0 5811.4 5817.7 5959.4 5972.8 5636.0 5640.4 5646.9 5654.9 5658.3 5621.0 5709.1 5718.2 5728.2 5728.4 5553.3 5589.0 5589.4 5590.4 5600.4 5530.1 5545.0 5546.0 5548.9 5594.7 5538.1 5567.4 5576.9 5577.2 5582.4 5627.9 5689.6 5699.7 5716.2 5767.1 5553.8 5586.6 5606.2 5606.3 5660.0 16:24:18 INFO - PROCESS | 1072 | 16:24:18 INFO - PROCESS | 1072 | [#1] ext.html Cycles:180 Average:50827.90 Median:36417.45 stddev:101053.93 (277.5%) stddev-sans-first:101266.83 16:24:18 INFO - PROCESS | 1072 | Values: 522.6 541.6 590.6 598.4 607.3 31888.4 35720.1 35726.6 35730.5 35895.6 36253.6 36581.3 36690.8 36725.8 36819.3 7366.0 7565.0 7970.8 9502.8 9802.2 9710.5 9823.5 9877.9 9881.2 9884.3 9896.5 9918.2 9941.1 9950.2 9958.0 7314.3 7447.1 7484.3 9850.9 9875.4 7555.4 7620.2 9440.8 9727.5 9780.0 35706.5 35842.0 35909.8 36013.0 36044.1 2779.6 2936.5 2979.9 3139.1 3197.4 27453.5 27673.4 28795.7 28878.4 29165.6 3938.9 4006.2 4064.0 4087.9 4123.8 290004.0 291945.0 292417.0 292931.0 293678.0 45377.0 45402.5 45475.3 45480.8 45502.5 44248.8 48294.0 48590.8 48668.5 48758.0 12043.2 12336.0 12347.9 12379.3 12397.0 10145.3 10196.9 10203.4 10256.8 10257.7 12907.4 13376.9 13390.3 13448.4 13538.8 5414.4 5431.0 5466.5 5480.8 5506.3 762.9 846.0 891.8 911.7 922.2 25849.7 26743.9 27038.5 27294.9 27362.9 858.8 870.4 905.0 958.5 993.6 13733.6 14026.2 14061.6 14384.1 14386.0 443653.0 446701.0 454130.0 454153.0 456260.0 47172.3 47306.3 47386.3 47411.0 47456.5 960.4 961.5 963.7 964.2 997.8 26638.7 28883.7 29269.7 29553.6 29564.9 42400.4 42663.0 42912.4 42928.4 42981.0 377279.0 381261.0 386434.3 386538.0 386718.0 23333.6 24088.5 24204.9 24788.8 34057.0 33039.3 33096.5 33568.5 33756.0 34115.1 33044.7 33495.0 34773.7 34800.0 34849.5 34652.7 34902.7 34960.0 35350.5 35705.5 33132.5 33514.2 33527.3 33585.2 33815.7 30454.2 31442.5 31504.5 31525.1 31597.2 21150.7 22601.9 23697.9 24234.9 24282.7 16:24:18 INFO - PROCESS | 1072 | 16:24:18 INFO - PROCESS | 1072 | [#2] jquery.html Cycles:180 Average:25902.32 Median:428725.50 stddev:70284.97 (16.4%) stddev-sans-first:70455.92 16:24:18 INFO - PROCESS | 1072 | Values: 330.9 337.2 351.6 352.7 368.0 12856.6 13723.2 16291.7 16453.7 16608.4 15575.2 15640.8 15787.3 15829.7 15836.1 4335.6 5162.7 5388.6 5394.6 5396.6 5288.0 5426.6 5449.0 5452.2 5453.8 5373.4 5387.7 5393.6 5398.5 6571.7 6844.0 6943.1 7007.3 7037.4 7042.4 6514.3 6730.0 6751.4 6776.5 6783.4 21281.8 21389.3 21458.6 21604.7 21686.7 2144.8 2168.4 2251.3 2288.6 2334.8 13467.9 13838.0 13976.9 14130.0 14579.8 1895.4 1985.3 2064.5 2072.3 2100.0 62951.0 65617.3 76830.6 85940.6 89363.0 14756.8 15701.1 15705.7 15712.4 15745.7 26239.3 26357.5 26396.3 26404.3 26512.9 8069.6 8119.7 8194.2 8289.0 8320.2 6638.0 6663.7 6752.9 6794.2 6816.7 7741.0 7886.9 7909.7 7928.0 7930.0 3223.9 3230.7 3242.5 3268.2 3337.4 660.7 693.6 707.3 734.6 772.9 15393.7 16254.8 16432.7 16740.7 16822.8 777.8 788.7 791.2 819.3 845.2 5472.6 5500.6 5574.7 5602.0 5753.4 419922.0 426428.0 428335.0 429116.0 429355.0 67654.0 78863.7 79686.0 79799.6 83551.2 391.1 401.6 403.5 403.7 410.3 9575.2 9717.8 9741.8 9875.5 10022.6 31690.5 34223.0 35282.3 36022.6 36146.6 43075.6 48071.0 48478.8 48697.0 49136.5 7238.7 7470.4 7500.7 7593.3 7614.0 11130.3 11430.6 11433.0 11606.2 11643.5 10009.2 10138.1 10251.4 10295.1 10390.8 9970.0 10007.9 10160.1 10290.7 10419.8 9925.5 10032.5 10151.6 10524.2 10623.4 7448.1 7481.1 7505.9 7523.3 7584.5 9224.4 10181.8 10267.3 10377.9 10399.6 16:24:18 INFO - PROCESS | 1072 | 16:24:18 INFO - PROCESS | 1072 | [#3] mootools.html Cycles:180 Average:4811.72 Median:4696.30 stddev:2851.66 (60.7%) stddev-sans-first:2845.81 16:24:18 INFO - PROCESS | 1072 | Values: 1072.0 1084.6 1162.9 1188.9 1213.2 7119.4 7562.4 7568.8 7591.8 7630.1 6627.7 6870.8 7115.2 7256.7 7433.4 1895.9 1912.2 1917.5 1920.1 1921.0 1811.5 1834.1 1835.1 1842.5 1845.6 1679.7 1727.3 1731.8 1736.1 1776.4 1618.2 1809.1 1855.5 1866.8 1879.4 1768.3 1769.9 1771.2 1772.1 1773.3 7253.1 7351.5 7365.7 7368.4 7372.1 4344.9 4508.0 4513.8 4523.5 4527.2 2857.0 2965.4 3084.4 3101.9 3103.5 962.3 975.3 996.8 1021.1 1025.2 10380.3 10477.7 10504.7 10525.1 10540.6 3793.2 3972.1 4010.0 4020.1 4025.2 7400.1 8015.4 8118.4 8130.1 8133.0 4269.2 4400.9 4411.5 4413.0 4432.3 4176.2 4178.6 4186.1 4187.1 4191.1 2962.6 2966.6 2974.2 2982.3 3023.8 868.0 886.4 899.1 899.7 902.5 714.9 717.0 725.9 736.2 753.5 4646.1 4690.7 4701.9 4714.4 4728.7 344.9 347.2 350.6 362.7 367.5 2946.3 3006.5 3022.0 3033.9 3106.4 8795.5 9460.9 9545.0 9552.7 9559.6 8827.4 9473.4 9478.9 9485.6 9501.6 6763.7 7112.2 7117.0 7133.5 7139.7 4568.6 4576.1 4713.6 4754.9 4816.9 8373.2 8376.6 8629.4 8664.1 8670.3 8550.8 8713.3 8794.3 8844.3 8854.7 6504.0 6669.7 6699.3 6704.5 6707.6 7171.9 7178.3 7195.0 7221.5 7283.6 6543.1 6625.8 6669.2 6689.7 6709.1 6367.4 6370.6 6381.8 6527.9 6638.8 5915.2 5969.0 6022.4 6035.8 6060.7 3396.9 4182.9 4218.6 4294.1 4367.9 4099.4 4105.9 4127.2 4158.0 4185.1 16:24:18 INFO - PROCESS | 1072 | 16:24:18 INFO - PROCESS | 1072 | [#4] prototype.html Cycles:180 Average:4605.96 Median:5373.61 stddev:1387.96 (25.8%) stddev-sans-first:1353.45 16:24:18 INFO - PROCESS | 1072 | Values: 285.9 286.6 287.3 290.6 296.1 5380.3 5410.2 5410.4 5427.8 5451.5 5264.9 5266.3 5294.6 5347.8 5373.6 3827.4 3907.0 3921.4 3985.3 4021.6 3939.7 3974.1 3998.8 4000.8 4007.9 3970.8 3980.8 3993.6 4005.3 4012.2 3811.9 3921.3 3927.1 4001.9 4006.8 3479.8 3486.4 3486.4 3490.3 3494.5 5153.4 5176.6 5184.5 5217.7 5244.3 4475.3 4621.9 4643.7 4653.6 4710.8 5483.7 5503.4 5504.5 5524.2 5533.5 3860.0 3864.2 3873.6 3878.0 3888.9 5642.2 5702.7 5742.2 5820.2 5852.8 3963.9 3972.4 3978.5 3981.9 3992.4 4046.6 4066.8 4076.6 4106.5 4107.4 4505.8 4679.3 4698.8 4715.9 4731.2 5570.6 5573.6 5582.7 5583.3 5704.8 1340.7 1366.2 1366.4 1372.9 1376.4 865.1 867.6 912.6 931.6 935.8 4938.1 5251.4 5320.7 5349.4 5370.1 5730.2 5758.5 5775.9 5785.7 5835.9 5114.8 5366.5 5390.7 5402.7 5417.6 2973.6 2990.0 2996.4 2999.3 3022.2 5734.9 5749.4 5759.4 5795.0 5815.5 5536.4 5679.5 5703.6 5711.9 5738.2 5693.3 5696.3 5735.7 5742.6 5744.9 5307.9 5547.4 5586.8 5602.2 5628.0 5464.9 5471.8 5477.8 5490.5 5499.6 5737.4 5751.9 5757.4 5760.1 5767.4 3612.5 3626.4 3647.4 3704.4 3759.7 5606.1 5612.7 5625.6 5637.2 5639.9 5433.5 5444.8 5478.2 5483.8 5501.2 5285.7 5389.0 5393.7 5427.5 5447.8 5333.2 5368.5 5373.7 5379.5 5398.7 5427.6 5522.7 5539.5 5565.7 5628.6 5548.1 5559.1 5568.0 5569.8 5597.5 16:24:18 INFO - PROCESS | 1072 | 16:24:18 INFO - PROCESS | 1072 | [#5] yui.html Cycles:180 Average:14428.46 Median:2255.69 stddev:18505.83 (820.4%) stddev-sans-first:18528.54 16:24:18 INFO - PROCESS | 1072 | Values: 584.0 640.8 644.4 653.9 669.3 11958.2 12659.9 12779.2 13027.3 13042.2 11161.6 11244.4 11265.7 11270.5 11298.9 385.4 393.6 413.4 416.3 420.4 420.4 422.2 428.2 428.9 430.6 445.8 451.5 452.3 452.4 452.6 400.0 402.2 434.1 434.5 463.7 336.2 339.8 343.1 343.6 344.2 11390.0 11400.2 11435.4 11450.1 11484.7 10806.7 10888.6 10902.8 11093.4 11579.1 11254.8 11286.4 11469.1 11544.6 11562.9 4042.1 4053.6 4055.3 4097.9 4167.5 53876.7 55351.7 55774.6 56046.0 57650.0 9133.8 9139.0 9322.8 9356.7 9514.4 15210.6 15470.4 15493.8 15512.9 15542.6 6727.6 6885.3 6907.4 6983.8 7160.8 3842.7 3880.0 3882.2 3959.2 3968.5 2663.2 2796.1 2800.3 2811.9 2813.8 479.2 482.3 486.2 488.8 502.3 500.2 578.9 582.4 587.8 612.1 7205.5 7656.4 7791.2 7857.9 8042.4 540.5 545.6 547.6 553.2 555.3 3444.6 3467.7 3540.8 3599.4 3666.3 49284.8 71282.6 71815.0 72029.3 72557.6 54976.5 55555.7 60679.0 61264.4 61931.7 52780.7 53427.7 53602.5 53994.0 54482.5 7877.5 8156.3 8194.9 8210.2 8313.4 35413.5 35489.0 35949.8 36082.5 36668.6 44975.6 47028.8 48919.0 50021.5 50069.2 8923.6 9189.6 9345.3 9407.3 9859.4 11847.5 12260.5 12306.8 12514.2 12698.2 10999.9 11031.4 11107.2 11121.0 11662.5 11600.9 11695.6 11714.2 11876.1 11974.2 10341.8 10437.5 10449.8 11391.3 11481.5 10037.2 10083.7 10184.1 10338.1 10533.4 9542.1 9915.8 10062.9 10105.9 10134.1 16:24:18 INFO - PROCESS | 1072 | -------- Summary: end -------- 16:24:18 INFO - PROCESS | 1072 | 16:24:18 INFO - TEST-INFO | 1072: exit 0 16:24:19 INFO - TEST-OK | dromaeo_css | took 1124850ms 16:24:19 INFO - TEST-START | kraken 16:24:19 INFO - operating with platform_type : w8_ 16:24:19 INFO - Initialising browser for kraken test... 16:24:19 INFO - TEST-INFO | started process 2624 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmprwumrq\profile http://localhost:49264/getInfo.html) 16:24:24 INFO - PROCESS | 2624 | __metrics Screen width/height:1600/1200 16:24:24 INFO - PROCESS | 2624 | colorDepth:24 16:24:24 INFO - PROCESS | 2624 | Browser inner width/height: 1010/674 16:24:24 INFO - PROCESS | 2624 | __metrics 16:24:26 INFO - PROCESS | 2624 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:24:26 INFO - PROCESS | 2624 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:24:26 INFO - PROCESS | 2624 | console.error: 16:24:26 INFO - PROCESS | 2624 | Message: Error: Connection closed before committing the transaction. 16:24:26 INFO - PROCESS | 2624 | Stack: 16:24:26 INFO - PROCESS | 2624 | ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:932:23 16:24:26 INFO - PROCESS | 2624 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 16:24:26 INFO - PROCESS | 2624 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 16:24:26 INFO - PROCESS | 2624 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 16:24:26 INFO - PROCESS | 2624 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 16:24:26 INFO - PROCESS | 2624 | TaskImpl_run@resource://gre/modules/Task.jsm:324:15 16:24:26 INFO - PROCESS | 2624 | Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:550:9 16:24:26 INFO - PROCESS | 2624 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15 16:24:26 INFO - PROCESS | 2624 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:386:5 16:24:26 INFO - PROCESS | 2624 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29 16:24:26 INFO - PROCESS | 2624 | Barrier/this.client.addBlocker/promise13.5% 16:25:23 INFO - TinderboxPrint: I/O read bytes / time
210,241,536 / 2,005,350 16:25:23 INFO - TinderboxPrint: I/O write bytes / time
414,086,656 / 3,721,500 16:25:23 INFO - TinderboxPrint: CPU idle
8,258.9 (86.5%) 16:25:23 INFO - TinderboxPrint: CPU user
1,233.7 (12.9%) 16:25:23 INFO - install - Wall time: 3s; CPU: 12.0%; Read bytes: 0; Write bytes: 39096832; Read time: 0; Write time: 123560 16:25:23 INFO - run-tests - Wall time: 1191s; CPU: 13.0%; Read bytes: 210241536; Write bytes: 328168448; Read time: 2005350; Write time: 3559380 16:25:23 INFO - Running post-run listener: _upload_blobber_files 16:25:23 INFO - Blob upload gear active. 16:25:23 INFO - Preparing to upload files from C:\slave\test\build\blobber_upload_dir. 16:25:23 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 16:25:23 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'] 16:25:23 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 16:25:24 INFO - (blobuploader) - INFO - Open directory for files ... 16:25:24 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_errorsummary.log ... 16:25:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:25:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:25:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:25:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:25:25 INFO - (blobuploader) - INFO - Done attempting. 16:25:25 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_raw.log ... 16:25:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:25:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:25:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:25:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:25:26 INFO - (blobuploader) - INFO - Done attempting. 16:25:26 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\resource-usage.json ... 16:25:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:25:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:25:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:25:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:25:28 INFO - (blobuploader) - INFO - Done attempting. 16:25:28 INFO - (blobuploader) - INFO - Iteration through files over. 16:25:28 INFO - Return code: 0 16:25:28 INFO - rmtree: C:\slave\test\build\uploaded_files.json 16:25:28 INFO - Using _rmtree_windows ... 16:25:28 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build\\uploaded_files.json',), kwargs: {}, attempt #1 16:25:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5acaf56d05b85349131b747824a80feeb3800ed16696ee44300e53d9916cbf64f9b5653b8fd99290a417f4616bb3c3cd21254475ac841dff406bf0e06913e523", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ddfe3b75b01049e12d8c89f418df7a4d1e04abed426eeb8b77d8b2ecc998db1bbb4793a4675089f6d18bb187593e5c35d7019f95fd8ac0027ed242edf1a66b39", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ebaf84494e094145f64b1682784fa3dde8ac5ad4b4a8e6430b3318bcd662d9896727c0b808b3bb70736e4fee259208aed9bb3fea22f671d2e09940cc11dc4857"} 16:25:28 INFO - Writing buildbot properties ['blobber_files'] to C:\slave\test\properties\blobber_files 16:25:28 INFO - Writing to file C:\slave\test\properties\blobber_files 16:25:28 INFO - Contents: 16:25:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5acaf56d05b85349131b747824a80feeb3800ed16696ee44300e53d9916cbf64f9b5653b8fd99290a417f4616bb3c3cd21254475ac841dff406bf0e06913e523", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ddfe3b75b01049e12d8c89f418df7a4d1e04abed426eeb8b77d8b2ecc998db1bbb4793a4675089f6d18bb187593e5c35d7019f95fd8ac0027ed242edf1a66b39", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ebaf84494e094145f64b1682784fa3dde8ac5ad4b4a8e6430b3318bcd662d9896727c0b808b3bb70736e4fee259208aed9bb3fea22f671d2e09940cc11dc4857"} 16:25:28 INFO - Running post-run listener: copy_logs_to_upload_dir 16:25:28 INFO - Copying logs to upload dir... 16:25:28 INFO - mkdir: C:\slave\test\build\upload\logs 16:25:28 INFO - Copying logs to upload dir... 16:25:28 INFO - Using _rmtree_windows ... 16:25:28 INFO - Using _rmtree_windows ... 16:25:28 INFO - Using _rmtree_windows ... 16:25:28 INFO - Using _rmtree_windows ... 16:25:28 INFO - Using _rmtree_windows ... 16:25:28 INFO - Using _rmtree_windows ... 16:25:28 INFO - Using _rmtree_windows ... program finished with exit code 0 elapsedTime=1389.246000 ========= master_lag: 0.60 ========= ========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 9 secs) (at 2016-11-11 16:25:29.678991) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-11 16:25:29.679735) ========= '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-170\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-170 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-170 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-170\AppData\Local LOGONSERVER=\\T-W864-IX-170 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-170 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-170 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-170 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/5acaf56d05b85349131b747824a80feeb3800ed16696ee44300e53d9916cbf64f9b5653b8fd99290a417f4616bb3c3cd21254475ac841dff406bf0e06913e523", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ddfe3b75b01049e12d8c89f418df7a4d1e04abed426eeb8b77d8b2ecc998db1bbb4793a4675089f6d18bb187593e5c35d7019f95fd8ac0027ed242edf1a66b39", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ebaf84494e094145f64b1682784fa3dde8ac5ad4b4a8e6430b3318bcd662d9896727c0b808b3bb70736e4fee259208aed9bb3fea22f671d2e09940cc11dc4857"} build_url:https://queue.taskcluster.net/v1/task/eTOpnRcCSvmaQfqfpzyd2Q/artifacts/public/build/firefox-52.0a1.en-US.win64.zip program finished with exit code 0 elapsedTime=0.101000 build_url: 'https://queue.taskcluster.net/v1/task/eTOpnRcCSvmaQfqfpzyd2Q/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/5acaf56d05b85349131b747824a80feeb3800ed16696ee44300e53d9916cbf64f9b5653b8fd99290a417f4616bb3c3cd21254475ac841dff406bf0e06913e523", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ddfe3b75b01049e12d8c89f418df7a4d1e04abed426eeb8b77d8b2ecc998db1bbb4793a4675089f6d18bb187593e5c35d7019f95fd8ac0027ed242edf1a66b39", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ebaf84494e094145f64b1682784fa3dde8ac5ad4b4a8e6430b3318bcd662d9896727c0b808b3bb70736e4fee259208aed9bb3fea22f671d2e09940cc11dc4857"}' ========= master_lag: 0.27 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-11 16:25:30.048098) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 16:25:30.048753) ========= '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-170\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-170 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-170 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-170\AppData\Local LOGONSERVER=\\T-W864-IX-170 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-170 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-170 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-170 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-11-11 16:25:30.177232) ========= ========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-11-11 16:25:30.177530) ========= ========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-11-11 16:25:30.809549) ========= ========= Total master_lag: 1.12 =========