builder: autoland_win8_64_test-dromaeojs-pgo slave: t-w864-ix-013 starttime: 1477327065.53 results: success (0) buildid: 20161024063015 builduid: 78954d42bc7c4e37ae00344d70ba7b9f revision: 5c11e677e0b472167b2c2c2095c8b899a62a1ade ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 09:37:45.533706) ========= master: http://buildbot-master127.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 09:37:45.534414) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 09:37:45.534709) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 09:37:45.796442) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-24 09:37:45.796953) ========= '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-013\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-013 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-013 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-013\AppData\Local LOGONSERVER=\\T-W864-IX-013 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-013 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-013 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-013 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False --09:37:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py => `archiver_client.py' Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|: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% 29.54 MB/s 09:37:47 (29.54 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=1.416000 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-24 09:37:47.256712) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-10-24 09:37:47.257211) ========= '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-013\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-013 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-013 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-013\AppData\Local LOGONSERVER=\\T-W864-IX-013 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-013 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-013 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-013 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=2.909000 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-10-24 09:37:50.191952) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-24 09:37:50.192316) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo integration/autoland --rev 5c11e677e0b472167b2c2c2095c8b899a62a1ade --destination scripts --debug' in dir C:\slave\test\. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 5c11e677e0b472167b2c2c2095c8b899a62a1ade --destination scripts --debug'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-013\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-013 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-013 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-013\AppData\Local LOGONSERVER=\\T-W864-IX-013 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-013 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-013 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-013 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 2016-10-24 09:37:51,137 truncating revision to first 12 chars 2016-10-24 09:37:51,137 Setting DEBUG logging. 2016-10-24 09:37:51,137 attempt 1/10 2016-10-24 09:37:51,137 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/5c11e677e0b4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-24 09:37:51,615 unpacking tar archive at: autoland-5c11e677e0b4/testing/mozharness/ 2016-10-24 09:37:51,759 skipping symlink on windows: configs/single_locale/linux32.py program finished with exit code 0 elapsedTime=1.194000 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-24 09:37:51.436263) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 09:37:51.436571) ========= script_repo_revision: 5c11e677e0b472167b2c2c2095c8b899a62a1ade ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 09:37:51.436996) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 09:37:51.437282) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 09:37:51.455489) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 22 secs) (at 2016-10-24 09:37:51.455796) ========= 'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'dromaeojs' '--add-option' '--webServer,localhost' '--branch-name' 'Autoland' '--cfg' 'talos/windows_config.py' '--download-symbols' 'ondemand' '--use-talos-json' '--blob-upload-branch' 'Autoland' 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', 'Autoland', '--cfg', 'talos/windows_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-013\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-013 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-013 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-013\AppData\Local LOGONSERVER=\\T-W864-IX-013 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-013 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-013 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-013 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 09:37:52 INFO - MultiFileLogger online at 20161024 09:37:52 in C:\slave\test 09:37:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 09:37:52 INFO - Dumping config to C:\slave\test\logs\localconfig.json. 09:37:52 INFO - {'append_to_log': False, 09:37:52 INFO - 'base_work_dir': 'C:\\slave\\test', 09:37:52 INFO - 'blob_upload_branch': 'Autoland', 09:37:52 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt', 09:37:52 INFO - 'branch': 'Autoland', 09:37:52 INFO - 'buildbot_json_path': 'buildprops.json', 09:37:52 INFO - 'config_files': ('talos/windows_config.py',), 09:37:52 INFO - 'default_actions': ('clobber', 09:37:52 INFO - 'read-buildbot-config', 09:37:52 INFO - 'download-and-extract', 09:37:52 INFO - 'populate-webroot', 09:37:52 INFO - 'create-virtualenv', 09:37:52 INFO - 'install', 09:37:52 INFO - 'run-tests'), 09:37:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:37:52 INFO - 'download_minidump_stackwalk': True, 09:37:52 INFO - 'download_symbols': 'ondemand', 09:37:52 INFO - 'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python', 09:37:52 INFO - 'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'), 09:37:52 INFO - 'hg': 'c:/mozilla-build/hg/hg', 09:37:52 INFO - 'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python', 09:37:52 INFO - 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'), 09:37:52 INFO - 'python': 'c:/mozilla-build/python27/python.exe', 09:37:52 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe', 09:37:52 INFO - 'C:/mozilla-build/tooltool.py'), 09:37:52 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe', 09:37:52 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 09:37:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:37:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:37:52 INFO - 'installer_path': 'installer.exe', 09:37:52 INFO - 'log_level': 'info', 09:37:52 INFO - 'log_name': 'talos', 09:37:52 INFO - 'log_to_console': True, 09:37:52 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe', 09:37:52 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe', 09:37:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest', 09:37:52 INFO - 'opt_config_files': (), 09:37:52 INFO - 'pip_index': False, 09:37:52 INFO - 'sps_profile': False, 09:37:52 INFO - 'sps_profile_interval': 0, 09:37:52 INFO - 'suite': 'dromaeojs', 09:37:52 INFO - 'system_bits': '32', 09:37:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:37:52 INFO - 'title': 'T-W864-IX-013', 09:37:52 INFO - 'use_talos_json': True, 09:37:52 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'), 09:37:52 INFO - 'virtualenv_path': 'C:\\slave\\test\\build/venv', 09:37:52 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll', 09:37:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:37:52 INFO - 'work_dir': 'build'} 09:37:52 INFO - [mozharness: 2016-10-24 16:37:52.566000Z] Running clobber step. 09:37:52 INFO - Running pre-action listener: _resource_record_pre_action 09:37:52 INFO - Running main action method: clobber 09:37:52 INFO - rmtree: C:\slave\test\build 09:37:52 INFO - Using _rmtree_windows ... 09:37:52 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1 09:39:25 INFO - Running post-action listener: _resource_record_post_action 09:39:25 INFO - [mozharness: 2016-10-24 16:39:25.085000Z] Finished clobber step (success) 09:39:25 INFO - [mozharness: 2016-10-24 16:39:25.085000Z] Running read-buildbot-config step. 09:39:25 INFO - Running pre-action listener: _resource_record_pre_action 09:39:25 INFO - Running main action method: read_buildbot_config 09:39:25 INFO - Using buildbot properties: 09:39:25 INFO - { 09:39:25 INFO - "project": "", 09:39:25 INFO - "product": "firefox", 09:39:25 INFO - "script_repo_revision": "production", 09:39:25 INFO - "builddir": "autoland_win8_64_test-dromaeojs", 09:39:25 INFO - "repository": "", 09:39:25 INFO - "buildername": "Windows 8 64-bit autoland pgo talos dromaeojs", 09:39:25 INFO - "buildid": "20161024063015", 09:39:25 INFO - "pgo_build": "True", 09:39:25 INFO - "basedir": "C:\\slave\\test", 09:39:25 INFO - "buildnumber": 64, 09:39:25 INFO - "slavename": "t-w864-ix-013", 09:39:25 INFO - "master": "http://buildbot-master127.bb.releng.scl3.mozilla.com:8201/", 09:39:25 INFO - "platform": "win8_64", 09:39:25 INFO - "scheduler": "tests-autoland-win64-pgo-talos", 09:39:25 INFO - "branch": "autoland", 09:39:25 INFO - "repo_path": "integration/autoland", 09:39:25 INFO - "revision": "5c11e677e0b472167b2c2c2095c8b899a62a1ade", 09:39:25 INFO - "stage_platform": "win64-pgo", 09:39:25 INFO - "builduid": "78954d42bc7c4e37ae00344d70ba7b9f", 09:39:25 INFO - "slavebuilddir": "test" 09:39:25 INFO - } 09:39:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/eqoZfNznQ4iQdyuDjEBHGg/artifacts/public/build/firefox-52.0a1.en-US.win64.zip. 09:39:25 INFO - Running post-action listener: _resource_record_post_action 09:39:25 INFO - [mozharness: 2016-10-24 16:39:25.088000Z] Finished read-buildbot-config step (success) 09:39:25 INFO - [mozharness: 2016-10-24 16:39:25.088000Z] Running download-and-extract step. 09:39:25 INFO - Running pre-action listener: _resource_record_pre_action 09:39:25 INFO - Running main action method: download_and_extract 09:39:25 INFO - mkdir: C:\slave\test\build\tests 09:39:25 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')]} 09:39:25 INFO - trying https://queue.taskcluster.net/v1/task/eqoZfNznQ4iQdyuDjEBHGg/artifacts/public/build/firefox-52.0a1.en-US.win64.test_packages.json 09:39:25 INFO - Downloading https://queue.taskcluster.net/v1/task/eqoZfNznQ4iQdyuDjEBHGg/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 09:39:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eqoZfNznQ4iQdyuDjEBHGg/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 09:39:25 INFO - Downloaded 1218 bytes. 09:39:25 INFO - Reading from file C:\slave\test\build\firefox-52.0a1.en-US.win64.test_packages.json 09:39:25 INFO - Using the following test package requirements: 09:39:25 INFO - {u'common': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 09:39:25 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 09:39:25 INFO - u'firefox-52.0a1.en-US.win64.cppunittest.tests.zip'], 09:39:25 INFO - u'gtest': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 09:39:25 INFO - u'jittest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 09:39:25 INFO - u'jsshell-win64.zip'], 09:39:25 INFO - u'mochitest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 09:39:25 INFO - u'firefox-52.0a1.en-US.win64.mochitest.tests.zip'], 09:39:25 INFO - u'mozbase': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 09:39:25 INFO - u'reftest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 09:39:25 INFO - u'firefox-52.0a1.en-US.win64.reftest.tests.zip'], 09:39:25 INFO - u'talos': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 09:39:25 INFO - u'firefox-52.0a1.en-US.win64.talos.tests.zip'], 09:39:25 INFO - u'web-platform': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 09:39:25 INFO - u'firefox-52.0a1.en-US.win64.web-platform.tests.zip'], 09:39:25 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 09:39:25 INFO - u'firefox-52.0a1.en-US.win64.xpcshell.tests.zip']} 09:39:25 INFO - Downloading packages: [u'firefox-52.0a1.en-US.win64.common.tests.zip'] for test suite category: common 09:39:25 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/eqoZfNznQ4iQdyuDjEBHGg/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip 09:39:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eqoZfNznQ4iQdyuDjEBHGg/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip'}, attempt #1 09:39:25 INFO - Fetch https://queue.taskcluster.net/v1/task/eqoZfNznQ4iQdyuDjEBHGg/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip into memory 09:39:26 INFO - Http code: 200 09:39:26 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 09:39:26 INFO - x-amz-cf-id: V7j0NCUVzIzCSwpcpdaeg204LxYjm8U7LMAagMVH2WJabsTxI7O8wg== 09:39:26 INFO - x-amz-version-id: _RDOtD7DvVlTOvQGv0U004v1NIZ99Y6O 09:39:26 INFO - Expected file size: 17451303 09:39:26 INFO - Obtained file size: 17451303 09:39:55 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 09:39:55 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/eqoZfNznQ4iQdyuDjEBHGg/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip 09:39:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eqoZfNznQ4iQdyuDjEBHGg/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip'}, attempt #1 09:39:55 INFO - Fetch https://queue.taskcluster.net/v1/task/eqoZfNznQ4iQdyuDjEBHGg/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip into memory 09:39:56 INFO - Http code: 200 09:39:56 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 09:39:56 INFO - x-amz-cf-id: fhVckBfaxaUBeqsbCwMBgdeXL1hUidN3h-0ToBOqer4_L2AdO2uNfQ== 09:39:56 INFO - x-amz-version-id: _RDOtD7DvVlTOvQGv0U004v1NIZ99Y6O 09:39:56 INFO - Expected file size: 17451303 09:39:56 INFO - Obtained file size: 17451303 09:40:08 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/eqoZfNznQ4iQdyuDjEBHGg/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip 09:40:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eqoZfNznQ4iQdyuDjEBHGg/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip'}, attempt #1 09:40:08 INFO - Fetch https://queue.taskcluster.net/v1/task/eqoZfNznQ4iQdyuDjEBHGg/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip into memory 09:40:08 INFO - Http code: 200 09:40:08 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 09:40:08 INFO - x-amz-cf-id: AHv5ZfwsyWdAq92t-YzliHgb-4DK6fY6vaHkVKDscPRdRyDpleiBKw== 09:40:08 INFO - x-amz-version-id: 52lbr5WPy4Ci3PXwlp5IhH.MudVq7iAL 09:40:09 INFO - Expected file size: 14409028 09:40:09 INFO - Obtained file size: 14409028 09:40:17 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')]} 09:40:17 INFO - trying https://queue.taskcluster.net/v1/task/eqoZfNznQ4iQdyuDjEBHGg/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 09:40:17 INFO - Downloading https://queue.taskcluster.net/v1/task/eqoZfNznQ4iQdyuDjEBHGg/artifacts/public/build/firefox-52.0a1.en-US.win64.zip to C:\slave\test\build\firefox-52.0a1.en-US.win64.zip 09:40:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eqoZfNznQ4iQdyuDjEBHGg/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 09:40:18 INFO - Downloaded 57224335 bytes. 09:40:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eqoZfNznQ4iQdyuDjEBHGg/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 09:40:18 INFO - mkdir: C:\slave\test\properties 09:40:18 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url 09:40:18 INFO - Writing to file C:\slave\test\properties\build_url 09:40:18 INFO - Contents: 09:40:18 INFO - build_url:https://queue.taskcluster.net/v1/task/eqoZfNznQ4iQdyuDjEBHGg/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 09:40:19 INFO - Running post-action listener: _resource_record_post_action 09:40:19 INFO - Running post-action listener: set_extra_try_arguments 09:40:19 INFO - [mozharness: 2016-10-24 16:40:19.494000Z] Finished download-and-extract step (success) 09:40:19 INFO - [mozharness: 2016-10-24 16:40:19.494000Z] Running populate-webroot step. 09:40:19 INFO - Running pre-action listener: _resource_record_pre_action 09:40:19 INFO - Running main action method: populate_webroot 09:40:19 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']}, 09:40:19 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']}, 09:40:19 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome', 09:40:19 INFO - u'--tppagecycles', 09:40:19 INFO - u'7'], 09:40:19 INFO - u'tests': [u'tsvgm']}}, 09:40:19 INFO - u'suites': {u'chromez': {u'talos_options': [u'--disable-e10s'], 09:40:19 INFO - u'tests': [u'tresize', u'tcanvasmark']}, 09:40:19 INFO - u'chromez-e10s': {u'tests': [u'tresize', u'tcanvasmark']}, 09:40:19 INFO - u'dromaeojs': {u'talos_options': [u'--disable-e10s'], 09:40:19 INFO - u'tests': [u'dromaeo_css', u'kraken']}, 09:40:19 INFO - u'dromaeojs-e10s': {u'tests': [u'dromaeo_css', u'kraken']}, 09:40:19 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:40:19 INFO - u'talos_options': [u'--disable-e10s'], 09:40:19 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 09:40:19 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:40:19 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 09:40:19 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:40:19 INFO - u'talos_options': [u'--disable-e10s'], 09:40:19 INFO - u'tests': [u'damp', u'tps']}, 09:40:19 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:40:19 INFO - u'tests': [u'damp', u'tps']}, 09:40:19 INFO - u'g3': {u'talos_options': [u'--disable-e10s'], 09:40:19 INFO - u'tests': [u'dromaeo_dom']}, 09:40:19 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']}, 09:40:19 INFO - u'g4': {u'talos_options': [u'--disable-e10s'], 09:40:19 INFO - u'tests': [u'basic_compositor_video']}, 09:40:19 INFO - u'g4-e10s': {u'tests': [u'basic_compositor_video']}, 09:40:19 INFO - u'other': {u'talos_options': [u'--disable-e10s'], 09:40:19 INFO - u'tests': [u'a11yr', 09:40:19 INFO - u'ts_paint', 09:40:19 INFO - u'tpaint', 09:40:19 INFO - u'sessionrestore', 09:40:19 INFO - u'sessionrestore_no_auto_restore', 09:40:19 INFO - u'tabpaint']}, 09:40:19 INFO - u'other-e10s': {u'tests': [u'a11yr', 09:40:19 INFO - u'ts_paint', 09:40:19 INFO - u'tpaint', 09:40:19 INFO - u'sessionrestore', 09:40:19 INFO - u'sessionrestore_no_auto_restore', 09:40:19 INFO - u'tabpaint']}, 09:40:19 INFO - u'other-e10s_l64': {u'tests': [u'a11yr', 09:40:19 INFO - u'ts_paint', 09:40:19 INFO - u'tpaint', 09:40:19 INFO - u'sessionrestore', 09:40:19 INFO - u'sessionrestore_no_auto_restore', 09:40:19 INFO - u'tabpaint']}, 09:40:19 INFO - u'other-e10s_nol64': {u'tests': [u'a11yr', 09:40:19 INFO - u'ts_paint', 09:40:19 INFO - u'tpaint', 09:40:19 INFO - u'sessionrestore', 09:40:19 INFO - u'sessionrestore_no_auto_restore', 09:40:19 INFO - u'tabpaint']}, 09:40:19 INFO - u'other_l64': {u'talos_options': [u'--disable-e10s'], 09:40:19 INFO - u'tests': [u'a11yr', 09:40:19 INFO - u'ts_paint', 09:40:19 INFO - u'tpaint', 09:40:19 INFO - u'sessionrestore', 09:40:19 INFO - u'sessionrestore_no_auto_restore', 09:40:19 INFO - u'tabpaint']}, 09:40:19 INFO - u'other_nol64': {u'talos_options': [u'--disable-e10s'], 09:40:19 INFO - u'tests': [u'a11yr', 09:40:19 INFO - u'ts_paint', 09:40:19 INFO - u'tpaint', 09:40:19 INFO - u'sessionrestore', 09:40:19 INFO - u'sessionrestore_no_auto_restore', 09:40:19 INFO - u'tabpaint']}, 09:40:19 INFO - u'svgr': {u'talos_options': [u'--disable-e10s'], 09:40:19 INFO - u'tests': [u'tsvgx', 09:40:19 INFO - u'tsvgr_opacity', 09:40:19 INFO - u'tart', 09:40:19 INFO - u'tscrollx', 09:40:19 INFO - u'cart']}, 09:40:19 INFO - u'svgr-e10s': {u'tests': [u'tsvgx', 09:40:19 INFO - u'tsvgr_opacity', 09:40:19 INFO - u'tart', 09:40:19 INFO - u'tscrollx', 09:40:19 INFO - u'cart']}, 09:40:19 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:40:19 INFO - u'talos_options': [u'--disable-e10s'], 09:40:19 INFO - u'tests': [u'tp5o']}, 09:40:19 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:40:19 INFO - u'tests': [u'tp5o']}, 09:40:19 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:40:19 INFO - u'talos_options': [u'--disable-e10s', 09:40:19 INFO - u'--xperf_path', 09:40:19 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:40:19 INFO - u'tests': [u'tp5n']}, 09:40:19 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:40:19 INFO - u'talos_options': [u'--xperf_path', 09:40:19 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:40:19 INFO - u'tests': [u'tp5n']}}, 09:40:19 INFO - u'talos.zip': {u'path': u'', 09:40:19 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:40:19 INFO - Running post-action listener: _resource_record_post_action 09:40:19 INFO - [mozharness: 2016-10-24 16:40:19.581000Z] Finished populate-webroot step (success) 09:40:19 INFO - [mozharness: 2016-10-24 16:40:19.581000Z] Running create-virtualenv step. 09:40:19 INFO - Running pre-action listener: _resource_record_pre_action 09:40:19 INFO - Running main action method: create_virtualenv 09:40:19 INFO - Creating virtualenv C:\slave\test\build/venv 09:40:19 INFO - mkdir: C:\slave\test\build\venv\Scripts 09:40:19 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll 09:40:19 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'! 09:40:19 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 09:40:19 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build/venv 09:40:29 INFO - New python executable in C:\slave\test\build/venv\Scripts\python.exe 09:40:32 INFO - Installing distribute......................................................................................................................................................................................done. 09:40:33 INFO - Return code: 0 09:40:33 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', '--version'] 09:40:33 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip --version 09:40:34 INFO - Reading from file tmpfile_stdout 09:40:34 INFO - Output received: 09:40:34 INFO - pip 0.8.2 from c:\slave\test\build\venv\lib\site-packages\pip-0.8.2-py2.7.egg (python 2.7) 09:40:34 INFO - Using _rmtree_windows ... 09:40:34 INFO - Using _rmtree_windows ... 09:40:34 INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv 09:40:34 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')]} 09:40:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:34 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')]} 09:40:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:34 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 0x0232C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023ADE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02874980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02388E90>, '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 0x01DAA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028B4520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-013', 'USERDOMAIN': 'T-W864-IX-013', '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-013', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-013\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-013', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-013', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-013', '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-013\\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 09:40:34 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 09:40:34 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 09:40:34 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 09:40:34 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-013\\AppData\\Roaming', 09:40:34 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 09:40:34 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 09:40:34 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 09:40:34 INFO - 'COMPUTERNAME': 'T-W864-IX-013', 09:40:34 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 09:40:34 INFO - 'DCLOCATION': 'SCL3', 09:40:34 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 09:40:34 INFO - 'FP_NO_HOST_CHECK': 'NO', 09:40:34 INFO - 'HOMEDRIVE': 'C:', 09:40:34 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-013', 09:40:34 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 09:40:34 INFO - 'KTS_VERSION': '1.19c', 09:40:34 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-013\\AppData\\Local', 09:40:34 INFO - 'LOGONSERVER': '\\\\T-W864-IX-013', 09:40:34 INFO - 'MONDIR': 'C:\\Monitor_config\\', 09:40:34 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 09:40:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:34 INFO - 'MOZ_NO_REMOTE': '1', 09:40:34 INFO - 'NO_EM_RESTART': '1', 09:40:34 INFO - 'NUMBER_OF_PROCESSORS': '8', 09:40:34 INFO - 'OS': 'Windows_NT', 09:40:34 INFO - 'OURDRIVE': 'C:', 09:40:34 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;', 09:40:34 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 09:40:34 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 09:40:34 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 09:40:34 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 09:40:34 INFO - 'PROCESSOR_LEVEL': '6', 09:40:34 INFO - 'PROCESSOR_REVISION': '1e05', 09:40:34 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 09:40:34 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 09:40:34 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 09:40:34 INFO - 'PROGRAMW6432': 'C:\\Program Files', 09:40:34 INFO - 'PROMPT': '$P$G', 09:40:34 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 09:40:34 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 09:40:34 INFO - 'PUBLIC': 'C:\\Users\\Public', 09:40:34 INFO - 'PWD': 'C:\\slave\\test', 09:40:34 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 09:40:34 INFO - 'SLAVEDIR': 'C:\\slave\\', 09:40:34 INFO - 'SYSTEMDRIVE': 'C:', 09:40:34 INFO - 'SYSTEMROOT': 'C:\\windows', 09:40:34 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:40:34 INFO - 'TEST1': 'testie', 09:40:34 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:40:34 INFO - 'USERDOMAIN': 'T-W864-IX-013', 09:40:34 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-013', 09:40:34 INFO - 'USERNAME': 'cltbld', 09:40:34 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-013', 09:40:34 INFO - 'WINDIR': 'C:\\windows', 09:40:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 09:40:34 INFO - Ignoring indexes: http://pypi.python.org/simple/ 09:40:34 INFO - Downloading/unpacking pip>=1.5 09:40:38 INFO - Running setup.py egg_info for package pip 09:40:38 INFO - warning: no files found matching 'pip\cacert.pem' 09:40:38 INFO - warning: no files found matching '*.html' under directory 'docs' 09:40:38 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 09:40:38 INFO - no previously-included directories found matching 'docs\_build\_sources' 09:40:38 INFO - Installing collected packages: pip 09:40:38 INFO - Found existing installation: pip 0.8.2 09:40:38 INFO - Uninstalling pip: 09:40:38 INFO - Successfully uninstalled pip 09:40:38 INFO - Running setup.py install for pip 09:40:38 INFO - warning: no files found matching 'pip\cacert.pem' 09:40:38 INFO - warning: no files found matching '*.html' under directory 'docs' 09:40:38 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 09:40:38 INFO - no previously-included directories found matching 'docs\_build\_sources' 09:40:38 INFO - Installing pip-script.py script to C:\slave\test\build\venv\Scripts 09:40:38 INFO - Installing pip.exe script to C:\slave\test\build\venv\Scripts 09:40:38 INFO - Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts 09:40:38 INFO - Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts 09:40:38 INFO - Installing pip2-script.py script to C:\slave\test\build\venv\Scripts 09:40:38 INFO - Installing pip2.exe script to C:\slave\test\build\venv\Scripts 09:40:38 INFO - Successfully installed pip 09:40:38 INFO - Cleaning up... 09:40:38 INFO - Return code: 0 09:40:38 INFO - Installing psutil>=3.1.1 into virtualenv C:\slave\test\build/venv 09:40:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:38 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 0x0232C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023ADE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02874980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02388E90>, '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 0x01DAA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028B4520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-013', 'USERDOMAIN': 'T-W864-IX-013', '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-013', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-013\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-013', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-013', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-013', '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-013\\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 09:40:39 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 09:40:39 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 09:40:39 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 09:40:39 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-013\\AppData\\Roaming', 09:40:39 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 09:40:39 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 09:40:39 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 09:40:39 INFO - 'COMPUTERNAME': 'T-W864-IX-013', 09:40:39 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 09:40:39 INFO - 'DCLOCATION': 'SCL3', 09:40:39 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 09:40:39 INFO - 'FP_NO_HOST_CHECK': 'NO', 09:40:39 INFO - 'HOMEDRIVE': 'C:', 09:40:39 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-013', 09:40:39 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 09:40:39 INFO - 'KTS_VERSION': '1.19c', 09:40:39 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-013\\AppData\\Local', 09:40:39 INFO - 'LOGONSERVER': '\\\\T-W864-IX-013', 09:40:39 INFO - 'MONDIR': 'C:\\Monitor_config\\', 09:40:39 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 09:40:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:39 INFO - 'MOZ_NO_REMOTE': '1', 09:40:39 INFO - 'NO_EM_RESTART': '1', 09:40:39 INFO - 'NUMBER_OF_PROCESSORS': '8', 09:40:39 INFO - 'OS': 'Windows_NT', 09:40:39 INFO - 'OURDRIVE': 'C:', 09:40:39 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg;', 09:40:39 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 09:40:39 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 09:40:39 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 09:40:39 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 09:40:39 INFO - 'PROCESSOR_LEVEL': '6', 09:40:39 INFO - 'PROCESSOR_REVISION': '1e05', 09:40:39 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 09:40:39 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 09:40:39 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 09:40:39 INFO - 'PROGRAMW6432': 'C:\\Program Files', 09:40:39 INFO - 'PROMPT': '$P$G', 09:40:39 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 09:40:39 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 09:40:39 INFO - 'PUBLIC': 'C:\\Users\\Public', 09:40:39 INFO - 'PWD': 'C:\\slave\\test', 09:40:39 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 09:40:39 INFO - 'SLAVEDIR': 'C:\\slave\\', 09:40:39 INFO - 'SYSTEMDRIVE': 'C:', 09:40:39 INFO - 'SYSTEMROOT': 'C:\\windows', 09:40:39 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:40:39 INFO - 'TEST1': 'testie', 09:40:39 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:40:39 INFO - 'USERDOMAIN': 'T-W864-IX-013', 09:40:39 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-013', 09:40:39 INFO - 'USERNAME': 'cltbld', 09:40:39 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-013', 09:40:39 INFO - 'WINDIR': 'C:\\windows', 09:40:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 09:40:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:41 INFO - Downloading/unpacking psutil>=3.1.1 09:40:41 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 09:40:41 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 09:40:42 INFO - Installing collected packages: psutil 09:40:42 INFO - Successfully installed psutil 09:40:42 INFO - Cleaning up... 09:40:42 INFO - Return code: 0 09:40:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv C:\slave\test\build/venv 09:40:42 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')]} 09:40:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:42 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')]} 09:40:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:42 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 0x0232C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023ADE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02874980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02388E90>, '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 0x01DAA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028B4520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-013', 'USERDOMAIN': 'T-W864-IX-013', '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-013', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-013\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-013', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-013', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-013', '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-013\\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 09:40:42 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 09:40:42 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 09:40:42 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 09:40:42 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-013\\AppData\\Roaming', 09:40:42 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 09:40:42 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 09:40:42 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 09:40:42 INFO - 'COMPUTERNAME': 'T-W864-IX-013', 09:40:42 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 09:40:42 INFO - 'DCLOCATION': 'SCL3', 09:40:42 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 09:40:42 INFO - 'FP_NO_HOST_CHECK': 'NO', 09:40:42 INFO - 'HOMEDRIVE': 'C:', 09:40:42 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-013', 09:40:42 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 09:40:42 INFO - 'KTS_VERSION': '1.19c', 09:40:42 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-013\\AppData\\Local', 09:40:42 INFO - 'LOGONSERVER': '\\\\T-W864-IX-013', 09:40:42 INFO - 'MONDIR': 'C:\\Monitor_config\\', 09:40:42 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 09:40:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:42 INFO - 'MOZ_NO_REMOTE': '1', 09:40:42 INFO - 'NO_EM_RESTART': '1', 09:40:42 INFO - 'NUMBER_OF_PROCESSORS': '8', 09:40:42 INFO - 'OS': 'Windows_NT', 09:40:42 INFO - 'OURDRIVE': 'C:', 09:40:42 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;', 09:40:42 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 09:40:42 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 09:40:42 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 09:40:42 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 09:40:42 INFO - 'PROCESSOR_LEVEL': '6', 09:40:42 INFO - 'PROCESSOR_REVISION': '1e05', 09:40:42 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 09:40:42 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 09:40:42 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 09:40:42 INFO - 'PROGRAMW6432': 'C:\\Program Files', 09:40:42 INFO - 'PROMPT': '$P$G', 09:40:42 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 09:40:42 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 09:40:42 INFO - 'PUBLIC': 'C:\\Users\\Public', 09:40:42 INFO - 'PWD': 'C:\\slave\\test', 09:40:42 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 09:40:42 INFO - 'SLAVEDIR': 'C:\\slave\\', 09:40:42 INFO - 'SYSTEMDRIVE': 'C:', 09:40:42 INFO - 'SYSTEMROOT': 'C:\\windows', 09:40:42 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:40:42 INFO - 'TEST1': 'testie', 09:40:42 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:40:42 INFO - 'USERDOMAIN': 'T-W864-IX-013', 09:40:42 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-013', 09:40:42 INFO - 'USERNAME': 'cltbld', 09:40:42 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-013', 09:40:42 INFO - 'WINDIR': 'C:\\windows', 09:40:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 09:40:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:40:43 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 09:40:43 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 09:40:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:40:44 INFO - Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor 09:40:44 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) 09:40:44 INFO - Installing collected packages: mozsystemmonitor 09:40:44 INFO - Running setup.py install for mozsystemmonitor 09:40:44 INFO - Successfully installed mozsystemmonitor 09:40:44 INFO - Cleaning up... 09:40:44 INFO - Return code: 0 09:40:44 INFO - Installing jsonschema==2.5.1 into virtualenv C:\slave\test\build/venv 09:40:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:44 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 0x0232C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023ADE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02874980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02388E90>, '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 0x01DAA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028B4520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-013', 'USERDOMAIN': 'T-W864-IX-013', '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-013', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-013\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-013', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-013', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-013', '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-013\\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 09:40:44 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 09:40:44 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 09:40:44 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 09:40:44 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-013\\AppData\\Roaming', 09:40:44 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 09:40:44 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 09:40:44 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 09:40:44 INFO - 'COMPUTERNAME': 'T-W864-IX-013', 09:40:44 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 09:40:44 INFO - 'DCLOCATION': 'SCL3', 09:40:44 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 09:40:44 INFO - 'FP_NO_HOST_CHECK': 'NO', 09:40:44 INFO - 'HOMEDRIVE': 'C:', 09:40:44 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-013', 09:40:44 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 09:40:44 INFO - 'KTS_VERSION': '1.19c', 09:40:44 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-013\\AppData\\Local', 09:40:44 INFO - 'LOGONSERVER': '\\\\T-W864-IX-013', 09:40:44 INFO - 'MONDIR': 'C:\\Monitor_config\\', 09:40:44 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 09:40:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:44 INFO - 'MOZ_NO_REMOTE': '1', 09:40:44 INFO - 'NO_EM_RESTART': '1', 09:40:44 INFO - 'NUMBER_OF_PROCESSORS': '8', 09:40:44 INFO - 'OS': 'Windows_NT', 09:40:44 INFO - 'OURDRIVE': 'C:', 09:40:44 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;', 09:40:44 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 09:40:44 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 09:40:44 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 09:40:44 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 09:40:44 INFO - 'PROCESSOR_LEVEL': '6', 09:40:44 INFO - 'PROCESSOR_REVISION': '1e05', 09:40:44 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 09:40:44 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 09:40:44 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 09:40:44 INFO - 'PROGRAMW6432': 'C:\\Program Files', 09:40:44 INFO - 'PROMPT': '$P$G', 09:40:44 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 09:40:44 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 09:40:44 INFO - 'PUBLIC': 'C:\\Users\\Public', 09:40:44 INFO - 'PWD': 'C:\\slave\\test', 09:40:44 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 09:40:44 INFO - 'SLAVEDIR': 'C:\\slave\\', 09:40:44 INFO - 'SYSTEMDRIVE': 'C:', 09:40:44 INFO - 'SYSTEMROOT': 'C:\\windows', 09:40:44 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:40:44 INFO - 'TEST1': 'testie', 09:40:44 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:40:44 INFO - 'USERDOMAIN': 'T-W864-IX-013', 09:40:44 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-013', 09:40:44 INFO - 'USERNAME': 'cltbld', 09:40:44 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-013', 09:40:44 INFO - 'WINDIR': 'C:\\windows', 09:40:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 09:40:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:44 INFO - Downloading/unpacking jsonschema==2.5.1 09:40:44 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 09:40:44 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 09:40:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:40:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:40:45 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 09:40:45 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 09:40:46 INFO - Downloading functools32-3.2.3-2.tar.gz 09:40:46 INFO - Running setup.py (path:C:\slave\test\build\venv\build\functools32\setup.py) egg_info for package functools32 09:40:46 INFO - warning: no files found matching '*.txt' 09:40:46 INFO - no previously-included directories found matching 'build' 09:40:46 INFO - no previously-included directories found matching 'dist' 09:40:46 INFO - no previously-included directories found matching '.git*' 09:40:46 INFO - Installing collected packages: jsonschema, functools32 09:40:46 INFO - Running setup.py install for functools32 09:40:46 INFO - warning: no files found matching '*.txt' 09:40:46 INFO - no previously-included directories found matching 'build' 09:40:46 INFO - no previously-included directories found matching 'dist' 09:40:46 INFO - no previously-included directories found matching '.git*' 09:40:46 INFO - Successfully installed jsonschema functools32 09:40:46 INFO - Cleaning up... 09:40:46 INFO - Return code: 0 09:40:46 INFO - Installing functools32==3.2.3-2 into virtualenv C:\slave\test\build/venv 09:40:46 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')]} 09:40:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:46 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')]} 09:40:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:46 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 0x0232C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023ADE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02874980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02388E90>, '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 0x01DAA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028B4520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-013', 'USERDOMAIN': 'T-W864-IX-013', '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-013', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-013\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-013', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-013', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-013', '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-013\\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 09:40:46 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 09:40:46 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 09:40:46 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 09:40:46 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-013\\AppData\\Roaming', 09:40:46 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 09:40:46 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 09:40:46 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 09:40:46 INFO - 'COMPUTERNAME': 'T-W864-IX-013', 09:40:46 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 09:40:46 INFO - 'DCLOCATION': 'SCL3', 09:40:46 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 09:40:46 INFO - 'FP_NO_HOST_CHECK': 'NO', 09:40:46 INFO - 'HOMEDRIVE': 'C:', 09:40:46 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-013', 09:40:46 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 09:40:46 INFO - 'KTS_VERSION': '1.19c', 09:40:46 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-013\\AppData\\Local', 09:40:46 INFO - 'LOGONSERVER': '\\\\T-W864-IX-013', 09:40:46 INFO - 'MONDIR': 'C:\\Monitor_config\\', 09:40:46 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 09:40:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:46 INFO - 'MOZ_NO_REMOTE': '1', 09:40:46 INFO - 'NO_EM_RESTART': '1', 09:40:46 INFO - 'NUMBER_OF_PROCESSORS': '8', 09:40:46 INFO - 'OS': 'Windows_NT', 09:40:46 INFO - 'OURDRIVE': 'C:', 09:40:46 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;', 09:40:46 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 09:40:46 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 09:40:46 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 09:40:46 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 09:40:46 INFO - 'PROCESSOR_LEVEL': '6', 09:40:46 INFO - 'PROCESSOR_REVISION': '1e05', 09:40:46 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 09:40:46 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 09:40:46 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 09:40:46 INFO - 'PROGRAMW6432': 'C:\\Program Files', 09:40:46 INFO - 'PROMPT': '$P$G', 09:40:46 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 09:40:46 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 09:40:46 INFO - 'PUBLIC': 'C:\\Users\\Public', 09:40:46 INFO - 'PWD': 'C:\\slave\\test', 09:40:46 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 09:40:46 INFO - 'SLAVEDIR': 'C:\\slave\\', 09:40:46 INFO - 'SYSTEMDRIVE': 'C:', 09:40:46 INFO - 'SYSTEMROOT': 'C:\\windows', 09:40:46 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:40:46 INFO - 'TEST1': 'testie', 09:40:46 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:40:46 INFO - 'USERDOMAIN': 'T-W864-IX-013', 09:40:46 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-013', 09:40:46 INFO - 'USERNAME': 'cltbld', 09:40:46 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-013', 09:40:46 INFO - 'WINDIR': 'C:\\windows', 09:40:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 09:40:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in c:\slave\test\build\venv\lib\site-packages 09:40:47 INFO - Cleaning up... 09:40:47 INFO - Return code: 0 09:40:47 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv 09:40:47 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')]} 09:40:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:47 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')]} 09:40:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:47 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 0x0232C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023ADE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02874980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02388E90>, '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 0x01DAA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028B4520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-013', 'USERDOMAIN': 'T-W864-IX-013', '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-013', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-013\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-013', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-013', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-013', '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-013\\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 09:40:47 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 09:40:47 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 09:40:47 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 09:40:47 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-013\\AppData\\Roaming', 09:40:47 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 09:40:47 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 09:40:47 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 09:40:47 INFO - 'COMPUTERNAME': 'T-W864-IX-013', 09:40:47 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 09:40:47 INFO - 'DCLOCATION': 'SCL3', 09:40:47 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 09:40:47 INFO - 'FP_NO_HOST_CHECK': 'NO', 09:40:47 INFO - 'HOMEDRIVE': 'C:', 09:40:47 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-013', 09:40:47 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 09:40:47 INFO - 'KTS_VERSION': '1.19c', 09:40:47 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-013\\AppData\\Local', 09:40:47 INFO - 'LOGONSERVER': '\\\\T-W864-IX-013', 09:40:47 INFO - 'MONDIR': 'C:\\Monitor_config\\', 09:40:47 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 09:40:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:47 INFO - 'MOZ_NO_REMOTE': '1', 09:40:47 INFO - 'NO_EM_RESTART': '1', 09:40:47 INFO - 'NUMBER_OF_PROCESSORS': '8', 09:40:47 INFO - 'OS': 'Windows_NT', 09:40:47 INFO - 'OURDRIVE': 'C:', 09:40:47 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;', 09:40:47 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 09:40:47 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 09:40:47 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 09:40:47 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 09:40:47 INFO - 'PROCESSOR_LEVEL': '6', 09:40:47 INFO - 'PROCESSOR_REVISION': '1e05', 09:40:47 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 09:40:47 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 09:40:47 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 09:40:47 INFO - 'PROGRAMW6432': 'C:\\Program Files', 09:40:47 INFO - 'PROMPT': '$P$G', 09:40:47 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 09:40:47 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 09:40:47 INFO - 'PUBLIC': 'C:\\Users\\Public', 09:40:47 INFO - 'PWD': 'C:\\slave\\test', 09:40:47 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 09:40:47 INFO - 'SLAVEDIR': 'C:\\slave\\', 09:40:47 INFO - 'SYSTEMDRIVE': 'C:', 09:40:47 INFO - 'SYSTEMROOT': 'C:\\windows', 09:40:47 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:40:47 INFO - 'TEST1': 'testie', 09:40:47 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:40:47 INFO - 'USERDOMAIN': 'T-W864-IX-013', 09:40:47 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-013', 09:40:47 INFO - 'USERNAME': 'cltbld', 09:40:47 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-013', 09:40:47 INFO - 'WINDIR': 'C:\\windows', 09:40:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 09:40:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:47 INFO - Downloading/unpacking blobuploader==1.2.4 09:40:47 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 09:40:47 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 09:40:48 INFO - Downloading blobuploader-1.2.4.tar.gz 09:40:48 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader 09:40:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:40:48 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 09:40:48 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 09:40:48 INFO - Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests 09:40:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:40:49 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 09:40:49 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 09:40:49 INFO - Downloading docopt-0.6.1.tar.gz 09:40:49 INFO - Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt 09:40:49 INFO - Installing collected packages: blobuploader, requests, docopt 09:40:49 INFO - Running setup.py install for blobuploader 09:40:49 INFO - Running setup.py install for requests 09:40:50 INFO - Running setup.py install for docopt 09:40:50 INFO - Successfully installed blobuploader requests docopt 09:40:50 INFO - Cleaning up... 09:40:51 INFO - Return code: 0 09:40:51 INFO - Installing None into virtualenv C:\slave\test\build/venv 09:40:51 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')]} 09:40:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:51 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')]} 09:40:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:51 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 0x0232C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023ADE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02874980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02388E90>, '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 0x01DAA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028B4520>, '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-013', 'USERDOMAIN': 'T-W864-IX-013', '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-013', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-013\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-013', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-013', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-013', '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-013\\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 09:40:51 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 09:40:51 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 09:40:51 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 09:40:51 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-013\\AppData\\Roaming', 09:40:51 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 09:40:51 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 09:40:51 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 09:40:51 INFO - 'COMPUTERNAME': 'T-W864-IX-013', 09:40:51 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 09:40:51 INFO - 'DCLOCATION': 'SCL3', 09:40:51 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 09:40:51 INFO - 'FP_NO_HOST_CHECK': 'NO', 09:40:51 INFO - 'HOMEDRIVE': 'C:', 09:40:51 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-013', 09:40:51 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 09:40:51 INFO - 'KTS_VERSION': '1.19c', 09:40:51 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-013\\AppData\\Local', 09:40:51 INFO - 'LOGONSERVER': '\\\\T-W864-IX-013', 09:40:51 INFO - 'MONDIR': 'C:\\Monitor_config\\', 09:40:51 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 09:40:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:51 INFO - 'MOZ_NO_REMOTE': '1', 09:40:51 INFO - 'NO_EM_RESTART': '1', 09:40:51 INFO - 'NUMBER_OF_PROCESSORS': '8', 09:40:51 INFO - 'OS': 'Windows_NT', 09:40:51 INFO - 'OURDRIVE': 'C:', 09:40:51 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;', 09:40:51 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 09:40:51 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 09:40:51 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 09:40:51 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 09:40:51 INFO - 'PROCESSOR_LEVEL': '6', 09:40:51 INFO - 'PROCESSOR_REVISION': '1e05', 09:40:51 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 09:40:51 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 09:40:51 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 09:40:51 INFO - 'PROGRAMW6432': 'C:\\Program Files', 09:40:51 INFO - 'PROMPT': '$P$G', 09:40:51 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 09:40:51 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 09:40:51 INFO - 'PUBLIC': 'C:\\Users\\Public', 09:40:51 INFO - 'PWD': 'C:\\slave\\test', 09:40:51 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 09:40:51 INFO - 'SLAVEDIR': 'C:\\slave\\', 09:40:51 INFO - 'SYSTEMDRIVE': 'C:', 09:40:51 INFO - 'SYSTEMROOT': 'C:\\windows', 09:40:51 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:40:51 INFO - 'TEST1': 'testie', 09:40:51 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:40:51 INFO - 'USERDOMAIN': 'T-W864-IX-013', 09:40:51 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-013', 09:40:51 INFO - 'USERNAME': 'cltbld', 09:40:51 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-013', 09:40:51 INFO - 'WINDIR': 'C:\\windows', 09:40:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 09:40:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:51 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 09:40:51 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rknojo-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 09:40:51 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 09:40:51 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jwurrq-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 09:40:51 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 09:40:51 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-gejqdi-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 09:40:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 09:40:52 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-k2u2le-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 09:40:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 09:40:52 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-smox_c-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 09:40:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 09:40:52 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-kjvs1u-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 09:40:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 09:40:52 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-s48pjk-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 09:40:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 09:40:52 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-pqevkn-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 09:40:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 09:40:52 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-h2vb3w-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 09:40:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 09:40:52 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-bwrzz2-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 09:40:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 09:40:52 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ihpnpg-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 09:40:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 09:40:53 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-pnlxxa-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 09:40:53 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 09:40:53 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-37s7v1-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 09:40:53 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 09:40:53 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-shufoe-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 09:40:53 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 09:40:53 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-4awkjc-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 09:40:53 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 09:40:53 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-esxubv-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 09:40:53 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 09:40:53 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-9j2fgd-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 09:40:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:40:53 INFO - Running setup.py install for manifestparser 09:40:53 INFO - Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts 09:40:53 INFO - Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts 09:40:54 INFO - Running setup.py install for mozcrash 09:40:54 INFO - Running setup.py install for mozdebug 09:40:55 INFO - Running setup.py install for mozdevice 09:40:55 INFO - Installing sutini-script.py script to C:\slave\test\build\venv\Scripts 09:40:55 INFO - Installing sutini.exe script to C:\slave\test\build\venv\Scripts 09:40:55 INFO - Installing dm-script.py script to C:\slave\test\build\venv\Scripts 09:40:55 INFO - Installing dm.exe script to C:\slave\test\build\venv\Scripts 09:40:56 INFO - Running setup.py install for mozfile 09:40:56 INFO - Running setup.py install for mozhttpd 09:40:56 INFO - Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts 09:40:56 INFO - Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts 09:40:57 INFO - Running setup.py install for mozinfo 09:40:57 INFO - Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts 09:40:57 INFO - Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts 09:40:57 INFO - Running setup.py install for mozInstall 09:40:57 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts 09:40:57 INFO - Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts 09:40:57 INFO - Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts 09:40:57 INFO - Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts 09:40:57 INFO - Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts 09:40:57 INFO - Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts 09:40:57 INFO - Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts 09:40:57 INFO - Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts 09:40:57 INFO - Running setup.py install for mozleak 09:40:58 INFO - Running setup.py install for mozlog 09:40:58 INFO - Installing structlog-script.py script to C:\slave\test\build\venv\Scripts 09:40:58 INFO - Installing structlog.exe script to C:\slave\test\build\venv\Scripts 09:40:58 INFO - Running setup.py install for moznetwork 09:40:59 INFO - Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts 09:40:59 INFO - Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts 09:40:59 INFO - Running setup.py install for mozprocess 09:41:00 INFO - Running setup.py install for mozprofile 09:41:00 INFO - Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts 09:41:00 INFO - Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts 09:41:00 INFO - Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts 09:41:00 INFO - Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts 09:41:00 INFO - Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts 09:41:00 INFO - Installing view-profile.exe script to C:\slave\test\build\venv\Scripts 09:41:00 INFO - Running setup.py install for mozrunner 09:41:01 INFO - Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts 09:41:01 INFO - Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts 09:41:01 INFO - Running setup.py install for mozscreenshot 09:41:02 INFO - Running setup.py install for moztest 09:41:02 INFO - Running setup.py install for mozversion 09:41:02 INFO - Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts 09:41:02 INFO - Installing mozversion.exe script to C:\slave\test\build\venv\Scripts 09:41:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:41:02 INFO - Cleaning up... 09:41:02 INFO - Return code: 0 09:41:02 INFO - Installing None into virtualenv C:\slave\test\build/venv 09:41: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')]} 09:41:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:41: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')]} 09:41:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:41:02 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 0x0232C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023ADE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02874980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02388E90>, '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 0x01DAA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028B4520>, '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-013', 'USERDOMAIN': 'T-W864-IX-013', '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-013', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-013\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-013', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-013', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-013', '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-013\\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 09:41:02 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 09:41:02 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 09:41:02 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 09:41:02 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-013\\AppData\\Roaming', 09:41:03 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 09:41:03 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 09:41:03 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 09:41:03 INFO - 'COMPUTERNAME': 'T-W864-IX-013', 09:41:03 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 09:41:03 INFO - 'DCLOCATION': 'SCL3', 09:41:03 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 09:41:03 INFO - 'FP_NO_HOST_CHECK': 'NO', 09:41:03 INFO - 'HOMEDRIVE': 'C:', 09:41:03 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-013', 09:41:03 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 09:41:03 INFO - 'KTS_VERSION': '1.19c', 09:41:03 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-013\\AppData\\Local', 09:41:03 INFO - 'LOGONSERVER': '\\\\T-W864-IX-013', 09:41:03 INFO - 'MONDIR': 'C:\\Monitor_config\\', 09:41:03 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 09:41:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:41:03 INFO - 'MOZ_NO_REMOTE': '1', 09:41:03 INFO - 'NO_EM_RESTART': '1', 09:41:03 INFO - 'NUMBER_OF_PROCESSORS': '8', 09:41:03 INFO - 'OS': 'Windows_NT', 09:41:03 INFO - 'OURDRIVE': 'C:', 09:41:03 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg;', 09:41:03 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 09:41:03 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 09:41:03 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 09:41:03 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 09:41:03 INFO - 'PROCESSOR_LEVEL': '6', 09:41:03 INFO - 'PROCESSOR_REVISION': '1e05', 09:41:03 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 09:41:03 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 09:41:03 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 09:41:03 INFO - 'PROGRAMW6432': 'C:\\Program Files', 09:41:03 INFO - 'PROMPT': '$P$G', 09:41:03 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 09:41:03 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 09:41:03 INFO - 'PUBLIC': 'C:\\Users\\Public', 09:41:03 INFO - 'PWD': 'C:\\slave\\test', 09:41:03 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 09:41:03 INFO - 'SLAVEDIR': 'C:\\slave\\', 09:41:03 INFO - 'SYSTEMDRIVE': 'C:', 09:41:03 INFO - 'SYSTEMROOT': 'C:\\windows', 09:41:03 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:41:03 INFO - 'TEST1': 'testie', 09:41:03 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:41:03 INFO - 'USERDOMAIN': 'T-W864-IX-013', 09:41:03 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-013', 09:41:03 INFO - 'USERNAME': 'cltbld', 09:41:03 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-013', 09:41:03 INFO - 'WINDIR': 'C:\\windows', 09:41:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 09:41:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:41:03 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 09:41:03 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-udumpc-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 09:41:03 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)) 09:41:03 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 09:41:03 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-bilpts-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 09:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///C:/slave/test/build/tests/mozbase/mozcrash in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2)) 09:41:03 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 09:41:03 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-yhr309-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 09:41:03 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)) 09:41:03 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 09:41:03 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ataot0-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 09:41:03 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)) 09:41:03 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 09:41:03 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rgyvbv-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 09:41:03 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)) 09:41:03 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 09:41:03 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-hgub5n-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 09:41:04 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)) 09:41:04 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 09:41:04 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-60igbf-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 09:41:04 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)) 09:41:04 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 09:41:04 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-3mas_m-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 09:41:04 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)) 09:41:04 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 09:41:04 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-e21a3h-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 09:41:04 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)) 09:41:04 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 09:41:04 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-hoth5k-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 09:41:04 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)) 09:41:04 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 09:41:04 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ubl_bk-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 09:41:04 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)) 09:41:04 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 09:41:04 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xzbzie-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 09:41:04 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)) 09:41:04 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 09:41:04 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-iajads-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 09:41:04 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)) 09:41:04 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 09:41:04 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jzb_i8-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 09:41:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///C:/slave/test/build/tests/mozbase/mozrunner in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 14)) 09:41:05 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 09:41:05 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-8vemlh-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 09:41:05 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)) 09:41:05 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 09:41:05 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ftepzk-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 09:41:05 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)) 09:41:05 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 09:41:05 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-utmxif-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 09:41:05 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)) 09:41:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==0.17->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2)) 09:41:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==0.17->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2)) 09:41:05 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)) 09:41:05 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)) 09:41:05 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)) 09:41:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10)) 09:41:05 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 09:41:05 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 09:41:06 INFO - Downloading blessings-1.6.tar.gz 09:41:06 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings 09:41:06 INFO - Installing collected packages: blessings 09:41:06 INFO - Running setup.py install for blessings 09:41:06 INFO - Successfully installed blessings 09:41:06 INFO - Cleaning up... 09:41:09 INFO - Return code: 0 09:41:09 INFO - Done creating virtualenv C:\slave\test\build/venv. 09:41:09 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 09:41:09 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 09:41:10 INFO - Reading from file tmpfile_stdout 09:41:10 INFO - Using _rmtree_windows ... 09:41:10 INFO - Using _rmtree_windows ... 09:41:10 INFO - Current package versions: 09:41:10 INFO - blessings == 1.6 09:41:10 INFO - blobuploader == 1.2.4 09:41:10 INFO - docopt == 0.6.1 09:41:10 INFO - functools32 == 3.2.3-2 09:41:10 INFO - jsonschema == 2.5.1 09:41:10 INFO - manifestparser == 1.1 09:41:10 INFO - mozInstall == 1.12 09:41:10 INFO - mozcrash == 0.17 09:41:10 INFO - mozdebug == 0.1 09:41:10 INFO - mozdevice == 0.48 09:41:10 INFO - mozfile == 1.2 09:41:10 INFO - mozhttpd == 0.7 09:41:10 INFO - mozinfo == 0.9 09:41:10 INFO - mozleak == 0.1 09:41:10 INFO - mozlog == 3.4 09:41:10 INFO - moznetwork == 0.27 09:41:10 INFO - mozprocess == 0.23 09:41:10 INFO - mozprofile == 0.28 09:41:10 INFO - mozrunner == 6.12 09:41:10 INFO - mozscreenshot == 0.1 09:41:10 INFO - mozsystemmonitor == 0.3 09:41:10 INFO - moztest == 0.7 09:41:10 INFO - mozversion == 1.4 09:41:10 INFO - psutil == 3.1.1 09:41:10 INFO - requests == 1.2.3 09:41:10 INFO - Installing None into virtualenv C:\slave\test\build/venv 09:41:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:41:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:41:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:41:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:41:10 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 0x0232C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023ADE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02874980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02388E90>, '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 0x01DAA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028B4520>, '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-013', 'USERDOMAIN': 'T-W864-IX-013', '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-013', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-013\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-013', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-013', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-013', '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-013\\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 09:41:10 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 09:41:10 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 09:41:10 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 09:41:10 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-013\\AppData\\Roaming', 09:41:10 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 09:41:10 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 09:41:10 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 09:41:10 INFO - 'COMPUTERNAME': 'T-W864-IX-013', 09:41:10 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 09:41:10 INFO - 'DCLOCATION': 'SCL3', 09:41:10 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 09:41:10 INFO - 'FP_NO_HOST_CHECK': 'NO', 09:41:10 INFO - 'HOMEDRIVE': 'C:', 09:41:10 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-013', 09:41:10 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 09:41:10 INFO - 'KTS_VERSION': '1.19c', 09:41:10 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-013\\AppData\\Local', 09:41:10 INFO - 'LOGONSERVER': '\\\\T-W864-IX-013', 09:41:10 INFO - 'MONDIR': 'C:\\Monitor_config\\', 09:41:10 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 09:41:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:41:10 INFO - 'MOZ_NO_REMOTE': '1', 09:41:10 INFO - 'NO_EM_RESTART': '1', 09:41:10 INFO - 'NUMBER_OF_PROCESSORS': '8', 09:41:10 INFO - 'OS': 'Windows_NT', 09:41:10 INFO - 'OURDRIVE': 'C:', 09:41:10 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg;', 09:41:10 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 09:41:10 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 09:41:10 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 09:41:10 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 09:41:10 INFO - 'PROCESSOR_LEVEL': '6', 09:41:10 INFO - 'PROCESSOR_REVISION': '1e05', 09:41:10 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 09:41:10 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 09:41:10 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 09:41:10 INFO - 'PROGRAMW6432': 'C:\\Program Files', 09:41:10 INFO - 'PROMPT': '$P$G', 09:41:10 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 09:41:10 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 09:41:10 INFO - 'PUBLIC': 'C:\\Users\\Public', 09:41:10 INFO - 'PWD': 'C:\\slave\\test', 09:41:10 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 09:41:10 INFO - 'SLAVEDIR': 'C:\\slave\\', 09:41:10 INFO - 'SYSTEMDRIVE': 'C:', 09:41:10 INFO - 'SYSTEMROOT': 'C:\\windows', 09:41:10 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:41:10 INFO - 'TEST1': 'testie', 09:41:10 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:41:10 INFO - 'USERDOMAIN': 'T-W864-IX-013', 09:41:10 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-013', 09:41:10 INFO - 'USERNAME': 'cltbld', 09:41:10 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-013', 09:41:10 INFO - 'WINDIR': 'C:\\windows', 09:41:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 09:41:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:41:10 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)) 09:41:10 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)) 09:41:10 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)) 09:41:10 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)) 09:41:10 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)) 09:41:10 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)) 09:41:10 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)) 09:41:10 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)) 09:41:10 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)) 09:41:10 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)) 09:41:10 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)) 09:41:10 INFO - Cleaning up... 09:41:10 INFO - Return code: 0 09:41:10 INFO - Installing jsonschema into virtualenv C:\slave\test\build/venv 09:41:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:41:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:41:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:41:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:41:10 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0232C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023ADE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02874980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02388E90>, '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 0x01DAA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028B4520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-013', 'USERDOMAIN': 'T-W864-IX-013', '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-013', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-013\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-013', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-013', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-013', '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-013\\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 09:41:10 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in C:\slave\test\build 09:41:10 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:41:10 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 09:41:10 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-013\\AppData\\Roaming', 09:41:10 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 09:41:10 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 09:41:10 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 09:41:10 INFO - 'COMPUTERNAME': 'T-W864-IX-013', 09:41:10 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 09:41:10 INFO - 'DCLOCATION': 'SCL3', 09:41:10 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 09:41:10 INFO - 'FP_NO_HOST_CHECK': 'NO', 09:41:10 INFO - 'HOMEDRIVE': 'C:', 09:41:10 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-013', 09:41:10 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 09:41:10 INFO - 'KTS_VERSION': '1.19c', 09:41:10 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-013\\AppData\\Local', 09:41:10 INFO - 'LOGONSERVER': '\\\\T-W864-IX-013', 09:41:10 INFO - 'MONDIR': 'C:\\Monitor_config\\', 09:41:10 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 09:41:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:41:10 INFO - 'MOZ_NO_REMOTE': '1', 09:41:10 INFO - 'NO_EM_RESTART': '1', 09:41:10 INFO - 'NUMBER_OF_PROCESSORS': '8', 09:41:10 INFO - 'OS': 'Windows_NT', 09:41:10 INFO - 'OURDRIVE': 'C:', 09:41:10 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg;', 09:41:10 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 09:41:10 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 09:41:10 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 09:41:10 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 09:41:10 INFO - 'PROCESSOR_LEVEL': '6', 09:41:10 INFO - 'PROCESSOR_REVISION': '1e05', 09:41:10 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 09:41:10 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 09:41:10 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 09:41:10 INFO - 'PROGRAMW6432': 'C:\\Program Files', 09:41:10 INFO - 'PROMPT': '$P$G', 09:41:10 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 09:41:10 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 09:41:10 INFO - 'PUBLIC': 'C:\\Users\\Public', 09:41:10 INFO - 'PWD': 'C:\\slave\\test', 09:41:10 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 09:41:10 INFO - 'SLAVEDIR': 'C:\\slave\\', 09:41:10 INFO - 'SYSTEMDRIVE': 'C:', 09:41:10 INFO - 'SYSTEMROOT': 'C:\\windows', 09:41:10 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:41:10 INFO - 'TEST1': 'testie', 09:41:10 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:41:10 INFO - 'USERDOMAIN': 'T-W864-IX-013', 09:41:10 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-013', 09:41:10 INFO - 'USERNAME': 'cltbld', 09:41:10 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-013', 09:41:10 INFO - 'WINDIR': 'C:\\windows', 09:41:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 09:41:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:41:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in c:\slave\test\build\venv\lib\site-packages 09:41:10 INFO - Cleaning up... 09:41:11 INFO - Return code: 0 09:41:11 INFO - Running post-action listener: _resource_record_post_action 09:41:11 INFO - Running post-action listener: _start_resource_monitoring 09:41:11 INFO - Starting resource monitoring. 09:41:11 INFO - [mozharness: 2016-10-24 16:41:11.127000Z] Finished create-virtualenv step (success) 09:41:11 INFO - [mozharness: 2016-10-24 16:41:11.127000Z] Running install step. 09:41:11 INFO - Running pre-action listener: _resource_record_pre_action 09:41:11 INFO - Running main action method: install 09:41:11 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 09:41:11 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 09:41:11 INFO - Reading from file tmpfile_stdout 09:41:11 INFO - Using _rmtree_windows ... 09:41:11 INFO - Using _rmtree_windows ... 09:41:11 INFO - Detecting whether we're running mozinstall >=1.0... 09:41:11 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h'] 09:41:11 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h 09:41:11 INFO - Reading from file tmpfile_stdout 09:41:11 INFO - Output received: 09:41:11 INFO - Usage: mozinstall-script.py [options] installer 09:41:11 INFO - Options: 09:41:11 INFO - -h, --help show this help message and exit 09:41:11 INFO - -d DEST, --destination=DEST 09:41:11 INFO - Directory to install application into. [default: 09:41:11 INFO - "C:\slave\test"] 09:41:11 INFO - --app=APP Application being installed. [default: firefox] 09:41:11 INFO - Using _rmtree_windows ... 09:41:11 INFO - Using _rmtree_windows ... 09:41:11 INFO - mkdir: C:\slave\test\build\application 09:41:11 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'] 09:41:11 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 09:41:14 INFO - Reading from file tmpfile_stdout 09:41:14 INFO - Output received: 09:41:14 INFO - C:\slave\test\build\application\firefox\firefox.exe 09:41:14 INFO - Using _rmtree_windows ... 09:41:14 INFO - Using _rmtree_windows ... 09:41:14 INFO - Running post-action listener: _resource_record_post_action 09:41:14 INFO - [mozharness: 2016-10-24 16:41:14.141000Z] Finished install step (success) 09:41:14 INFO - [mozharness: 2016-10-24 16:41:14.141000Z] Running run-tests step. 09:41:14 INFO - Running pre-action listener: _resource_record_pre_action 09:41:14 INFO - Running main action method: run_tests 09:41:14 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version'] 09:41:14 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version 09:41:14 INFO - Python 2.7.3 09:41:14 INFO - Return code: 0 09:41:14 INFO - grabbing minidump binary from tooltool 09:41:14 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')]} 09:41:14 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 0x02388E90>, '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 0x01DAA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028B4520>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1 09:41:14 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 09:41:14 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 09:41:14 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 09:41:14 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 09:41:14 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmpwbkbky 09:41:14 INFO - INFO - File integrity verified, renaming tmpwbkbky to win32-minidump_stackwalk.exe 09:41:14 INFO - Return code: 0 09:41:14 INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755 09:41:14 INFO - mkdir: C:\slave\test\build\blobber_upload_dir 09:41:14 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir 09:41:14 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe 09:41:14 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir 09:41:14 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eqoZfNznQ4iQdyuDjEBHGg/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-013', '--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 09:41:14 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\tests\talos\talos\run_tests.py --branchName Autoland --suite dromaeojs --executablePath C:\slave\test\build\application\firefox\firefox --symbolsPath https://queue.taskcluster.net/v1/task/eqoZfNznQ4iQdyuDjEBHGg/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip --title T-W864-IX-013 --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 09:41:14 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 09:41:14 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-013\\AppData\\Roaming', 09:41:14 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 09:41:14 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 09:41:14 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 09:41:14 INFO - 'COMPUTERNAME': 'T-W864-IX-013', 09:41:14 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 09:41:14 INFO - 'DCLOCATION': 'SCL3', 09:41:14 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 09:41:14 INFO - 'FP_NO_HOST_CHECK': 'NO', 09:41:14 INFO - 'HOMEDRIVE': 'C:', 09:41:14 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-013', 09:41:14 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 09:41:14 INFO - 'KTS_VERSION': '1.19c', 09:41:14 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-013\\AppData\\Local', 09:41:14 INFO - 'LOGONSERVER': '\\\\T-W864-IX-013', 09:41:14 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir', 09:41:14 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe', 09:41:14 INFO - 'MONDIR': 'C:\\Monitor_config\\', 09:41:14 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 09:41:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:41:14 INFO - 'MOZ_NO_REMOTE': '1', 09:41:14 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir', 09:41:14 INFO - 'NO_EM_RESTART': '1', 09:41:14 INFO - 'NUMBER_OF_PROCESSORS': '8', 09:41:14 INFO - 'OS': 'Windows_NT', 09:41:14 INFO - 'OURDRIVE': 'C:', 09:41:14 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;', 09:41:14 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 09:41:14 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 09:41:14 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 09:41:14 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 09:41:14 INFO - 'PROCESSOR_LEVEL': '6', 09:41:14 INFO - 'PROCESSOR_REVISION': '1e05', 09:41:14 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 09:41:14 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 09:41:14 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 09:41:14 INFO - 'PROGRAMW6432': 'C:\\Program Files', 09:41:14 INFO - 'PROMPT': '$P$G', 09:41:14 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 09:41:14 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 09:41:14 INFO - 'PUBLIC': 'C:\\Users\\Public', 09:41:14 INFO - 'PWD': 'C:\\slave\\test', 09:41:14 INFO - 'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos', 09:41:14 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 09:41:14 INFO - 'SLAVEDIR': 'C:\\slave\\', 09:41:14 INFO - 'SYSTEMDRIVE': 'C:', 09:41:14 INFO - 'SYSTEMROOT': 'C:\\windows', 09:41:14 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:41:14 INFO - 'TEST1': 'testie', 09:41:14 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:41:14 INFO - 'USERDOMAIN': 'T-W864-IX-013', 09:41:14 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-013', 09:41:14 INFO - 'USERNAME': 'cltbld', 09:41:14 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-013', 09:41:14 INFO - 'WINDIR': 'C:\\windows', 09:41:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 09:41:14 INFO - Calling ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eqoZfNznQ4iQdyuDjEBHGg/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-013', '--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 09:41:15 INFO - mozversion application_buildid: 20161024063015 09:41:15 INFO - mozversion application_changeset: 5c11e677e0b472167b2c2c2095c8b899a62a1ade 09:41:15 INFO - mozversion application_display_name: Nightly 09:41:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:41:15 INFO - mozversion application_name: Firefox 09:41:15 INFO - mozversion application_remotingname: firefox 09:41:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 09:41:15 INFO - mozversion application_vendor: Mozilla 09:41:15 INFO - mozversion application_version: 52.0a1 09:41:15 INFO - mozversion platform_buildid: 20161024063015 09:41:15 INFO - mozversion platform_changeset: 5c11e677e0b472167b2c2c2095c8b899a62a1ade 09:41:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 09:41:15 INFO - mozversion platform_version: 52.0a1 09:41:15 INFO - using testdate: 1477327275 09:41:15 INFO - actual date: 1477327275 09:41:15 INFO - starting webserver on 'localhost:49280' 09:41:15 INFO - SUITE-START | Running 2 tests 09:41:15 INFO - TEST-START | dromaeo_css 09:41:15 INFO - operating with platform_type : w8_ 09:41:15 INFO - Initialising browser for dromaeo_css test... 09:41:15 INFO - TEST-INFO | started process 1284 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmp2iocl_\profile http://localhost:49280/getInfo.html) 09:41:23 INFO - PROCESS | 1284 | __metrics Screen width/height:1600/1200 09:41:23 INFO - PROCESS | 1284 | colorDepth:24 09:41:23 INFO - PROCESS | 1284 | Browser inner width/height: 1010/674 09:41:23 INFO - PROCESS | 1284 | __metrics 09:41:24 INFO - PROCESS | 1284 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:41:24 INFO - PROCESS | 1284 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:41:25 INFO - TEST-INFO | 1284: exit 0 09:41:25 INFO - Browser initialized. 09:41:25 INFO - Running cycle 1/1 for dromaeo_css test... 09:41:25 INFO - TEST-INFO | started process 932 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmp2iocl_\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:41:26 INFO - PROCESS | 932 | [GFX1-]: Invalid size in UpdateRenderTarget Size(124,0), 0 09:41:37 INFO - PROCESS | 932 | RSS: Main: 160509952 09:41:37 INFO - PROCESS | 932 | 09:42:28 INFO - PROCESS | 932 | 1477327348264 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] 09:44:40 INFO - PROCESS | 932 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49280/tests/dromaeo/cssquery-ext.html) 09:44:42 INFO - PROCESS | 932 | RSS: Main: 231333888 09:44:42 INFO - PROCESS | 932 | 09:47:44 INFO - PROCESS | 932 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-ext.html (next: http://localhost:49280/tests/dromaeo/cssquery-jquery.html) 09:47:45 INFO - PROCESS | 932 | RSS: Main: 221138944 09:47:45 INFO - PROCESS | 932 | 09:50:47 INFO - PROCESS | 932 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49280/tests/dromaeo/cssquery-mootools.html) 09:50:47 INFO - PROCESS | 932 | RSS: Main: 175038464 09:50:47 INFO - PROCESS | 932 | 09:53:50 INFO - PROCESS | 932 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49280/tests/dromaeo/cssquery-prototype.html) 09:53:50 INFO - PROCESS | 932 | RSS: Main: 174555136 09:53:50 INFO - PROCESS | 932 | 09:56:53 INFO - PROCESS | 932 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49280/tests/dromaeo/cssquery-yui.html) 09:56:54 INFO - PROCESS | 932 | RSS: Main: 162312192 09:56:54 INFO - PROCESS | 932 | 09:59:56 INFO - PROCESS | 932 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-yui.html (next: http://localhost:49280/tests/dromaeo/cssquery-dojo.html) 09:59:57 INFO - PROCESS | 932 | RSS: Main: 210481152 09:59:57 INFO - PROCESS | 932 | 09:59:57 INFO - PROCESS | 932 | __start_tp_report 09:59:57 INFO - PROCESS | 932 | _x_x_mozilla_page_load 09:59:57 INFO - PROCESS | 932 | _x_x_mozilla_page_load_details 09:59:57 INFO - PROCESS | 932 | |i|pagename|runs| 09:59:57 INFO - PROCESS | 932 | |0;dojo.html;2845.189121100487;2876.870540825663;2888.927776805579;2904.07069737684;2905.549639805831;5061.54446099851;5118.564921981627;5145.511176438242;5183.248428977796;5192.5067118623765;5037.1688671369275;5091.949080509194;5101.056304583654;5105.2086926526445;5156;4355.956440435602;4494.887627809315;4528.841490547831;4544.386507821451;4612.031473390592;4572.314152877062;4622.329762184498;4657.650676199281;4658.534146585348;4674.3222232776225;687.2304612411978;4656.208444564432;4664.160451118797;4704.247320428732;4720.244760838266;3650.6166852480374;4646.95353046472;4664.416947881515;4665.930011049837;4706.623470122382;4610.815567377301;4621.953780462186;4622.260438329851;4628.421447319085;4678.134545109132;5079.746012699387;5109.693418394908;5119.923201151985;5190.532852043334;5248.763805628756;5417.647852889589;5445.319335083114;5458.808941687022;5460.153676180159;5526.419725928759;5462.562994960394;5479.53423958964;5484.506394424521;5499.587530935156;5501.642393244426;5054.7978080876355;5059.848204553869;5065.6200784941275;5088.236764485283;5134.5892328613245;5561.944380556223;5587.329520457572;5595.972020139873;5597.076482380443;5674.0637794764225;5070;5335.919961200585;5341.973290133525;5342.1452567589;5360.973195133999;5452.482014208644;5460.481254280837;5461.453854614586;5464.371597266286;5531.446855314517;5318.813841515605;5347.2781174541715;5361.169018802092;5384.784608615611;5431.131019036935;5382.946170538245;5409.459054094637;5419.593530485229;5423.864403389868;5425.403205647375;3577.821108944542;3580.695640870503;3584.910377240538;3585.1933315003917;3587.121155316912;3296.489044198153;3306.421376259145;3312.93374132516;3312.966870331314;3313.204830840581;5248.291480650063;5252.29094072303;5255.185446255837;5257.894842103136;5264.0261551613075;5598.720063996784;5611.691356975405;5615.129654903497;5619.775208991677;5621.634593751393;5329.813456529003;5338.466153384708;5349.491798279158;5381.865453363697;5383.892322153535;4521.706089104197;4539.205639013159;4550.362949187116;4554.908901821945;4612.677112602153;5589.580781441408;5629.521490673174;5630.60585758993;5784.71076446176;5786.189933409326;5371.301730774974;5491.121420572689;5494.148406996922;5496.835094947158;5503.614746967834;5599.664020158803;5642.605017648725;5649.067903795828;5651.039323315129;5656.943430565641;5338.172583249602;5374.7581358839725;5425.050616142238;5438.75525601341;5504.91742623869;5521;5536.446355364593;5536.501714845522;5547.2233887256625;5597.328320601554;5356.196570514454;5367.731613419392;5398.946010539844;5410.2696136022705;5459.590530710292;5371.650842695212;5399.05516534597;5409.83770486886;5414.10667239901;5480.260164877691;5200.6619569727845;5201.895962080662;5251.737413129405;5259.184826351921;5330.733463326741;5272.182811664198;5353.866153346042;5359.732013399236;5372.865678358073;5406.702631355313;5291.894162116659;5292.259083728358;5300.1519756838725;5327.493888080626;5331.360236771612 09:59:57 INFO - PROCESS | 932 | |1;ext.html;520.1573451009364;544.7194694732212;550.3643291997744;567.7842419880448;577.9248697669302;35152.47271290929;38358;38432.23135537291;38470;38475.80762096189;38135.809320953354;38302.425463618;38415;38496;38593.42109868354;7371.447141464385;7547;8304.626291816867;8437.114103019187;8473.15268473154;9732.270079744012;9940.25448091396;9989.700308990741;10260.435676037814;10265.281430299881;10119.747006324864;10127.594896204144;10202.183825293958;10208.489575521195;10210.030047145508;7447.627618619047;7633.9618301908695;9784.266180036526;9890.357126786772;9900.306978511471;9472.573734181979;9690.75773105671;9777;9778;9786.5596048178;36318.45522317141;36696.44955325672;36701.265974680355;36760.63239367599;36783;3110.3468271662978;3116.329989052342;3149.700778426046;3177.2374630088843;3238.9838050809594;28647.856760716062;28964;28977.42045159106;29016;29822.40355192884;3949.822257998397;3965.4250133730447;3981.3430783920617;4044.2518134145275;4106.77412742299;314060;315888;316358;317043;317552.41223793966;51381.743091284305;51472.74263628658;51554.48445515572;51666.22500662493;51674.48325516697;30221.244468888453;30901.69098309033;30992.070237892898;32241.677583224337;53239.20141197885;13683.657908552366;13971.510997115052;14200;14237.715245695028;14244.145351278956;9536.380135291323;9597.616095356247;10497.212709046851;10523.947380263202;10671.626493072705;16382.180890955642;16437.424690136027;16463.83536164647;16474.434928681756;16505.95604077009;6218.81343559694;6285.402886725754;6339.619622822645;6367.204099487564;6370.904436433457;833.2667252817482;934.1872570863256;942.5805516545208;972.7957129002847;997.5211898288717;27454.5881811773;28353.574696379572;28398.71601284002;28839.711602884123;28994.420111598072;948.7059011706393;959.7312752429331;968.1818863060703;968.9079537443931;1000.099910080933;14474.986750927334;14705.92647036758;14918.179500127597;14977.700445991019;15096.39614415411;442510;444022.59774022986;445430;447455;447832;48300;48631.75684121627;48751.26873096907;49346.50653493491;49457.752711236215;1073.2272763610188;1100.5377741348652;1139.145640769423;1155.763068570941;1181.9645410637695;26161.869190653924;27845.44309113847;28322.00872969436;28628.427431450837;28986.27534311659;41983.16033679248;42124;42164;42537;42568.78715606402;318677;320550.177992887;320830;320832;322637;24412;24665.506689866463;25246.116385926405;25273.62089568621;26359.4728105433;42229.15541689088;42304.365434517895;42705.35941960811;42801.78599107109;43064.13871722611;35805.46291805573;35843;36199;36673.63326366702;36794.63205367912;35123.648763512036;35673.28653426969;35994.020328882165;36694.44958325574;38662.52037316655;34859.651403486656;34999.82500087483;35409.46885796663;35771;35873.28253434969;31512;32302.676973229965;32445.675543244266;33046.66953330436;33087.338253235284;24980.625290621017;25176.874115629304;25203.873980629978;25680.871595641904;25801.354966125997 09:59:57 INFO - PROCESS | 932 | |2;jquery.html;303.5310445361916;318.90751682012217;319.3676520489431;321.4519244687806;325.7166265349146;13009.544665936693;13739.931300343496;16181.352745890179;16260.268287927027;17005.57486062849;15079.170645614488;15295.847041529581;15314.310856011478;16041;16250.83749162511;4089.488813898263;4981.626378021645;5226.79092836288;5244.79020839166;5246.973765131169;5159.690418574879;5244.423113457517;5254.737263136847;5258;5265.526102650761;4971.875703107415;5173.844784656466;5211.45279745627;5212.1660534314515;5220.112580861262;5005.274235235888;5028.094942910275;5066.935943451898;5068.695878247317;5072.695638261697;4249.830006799724;4384.780760961939;4392.956070439287;4393.758343291118;4396.252637051709;19190.520236994187;19858.404247872586;19879.403617891487;20121.597568048703;20152.69770953437;2013.9194432222694;2016.9294074707316;2027.6654352031896;2061.742282214723;2246.5169988452562;12505.874941250562;12639;12664.620061398173;12685.936570317182;13306.86693133066;1743.808181100078;1771.158699617684;1791.1939627167696;1809.1135343681633;1839.3746126316983;68179.3182068178;68448.3155168447;68662.31337686609;69040.09599040107;69234;7796.961015195001;8305.543195124204;8487.830243395098;8535.914640853636;8628.309735221168;11164;11179.44102794857;11188.272762270426;11211.990920817003;11364.829527557093;6798.932010679929;6827.21487028998;6894.793156205322;7001.194862590765;7016;6778.762743303961;6793.932060679429;6907.378335949788;6910.965445172843;6918.688659010357;5395.086653207302;5490.56075513958;5496.835094947158;5525.182157099827;5571.721413929368;1555.1913005237213;1577.1719847080374;1577.944771932977;1579.1393690438738;1579.5498282989292;684.5037347922815;876.3383645347722;902.278177458031;910.4264313482464;921.3044151665583;16627.916860415622;16743.497695069167;16923.57691057709;17110.230039647995;17251.137443127795;843.3969711656196;854.5727136431784;894.4007514964989;897.7710683775596;908.3913777768911;9525.428474291564;9730.17293530058;9806.705798826046;9893.406395616286;10005.749856253506;319418;385316;389158;390301;421805;81178.59410702909;85146;86709.56645216733;86807;87436;878.714417814213;890.701614958996;891.5675897189858;891.8528442806864;896.6368620708623;14299.785503217252;14742.852571474148;14835.851641483447;14864.097120473521;14958.925205373904;34547.82726086354;35340.46989295214;35795.82102089473;35881.46177807387;36235.45646815353;48995.755021224664;52153.47846521486;52426;53128;53191.20213196728;6691.498137639599;6830;6854.383105520527;6934.063901373452;6950.756723514653;8457.407981441485;10898.618548351087;11063.114950804078;11071;11281.830772538255;9206.677766278148;9791.510424478605;9854.753631159278;9896.604135834486;9954.701358959242;9377.1091746284;9410.058994100535;9585.760355991157;9609.711708648752;9850.852237216592;9400.29497787655;9872;9886.110250077527;9935.900640993787;10051.04515071067;5742.684152371659;6051.12258722474;6221.346758590283;6839.555428897106;6852.862942741217;7011.579305241702;8721.171488708562;9660;9706.126448619376;9861.704148875546 09:59:57 INFO - PROCESS | 932 | |3;mootools.html;1222.7798996180686;1240.2682417373749;1270.2568997136675;1454.2147240490128;1455.7234125516159;6653.101831252779;7113;7113.28867113289;7119.572825630453;7124.073870396841;6572.178477690289;6752.729890804374;6795.456363490921;6911.792646220609;6995.230524642286;1724.8275172482745;1852.21280955594;1916.8754030988011;1919.1172060852025;1928.16124985631;1881.8964956927364;1884.1144662008835;1887.6602211601905;1887.7168424736262;1895.1471837673034;1748.1783561726031;1768.8231176882337;1820.4447643468736;1821.4717731857745;1826.3881599664062;1662.7921509811274;1708.0776380754378;1837.2467288411688;1888.811118888114;1893.933712320062;1859.7954225035235;1871.7753869535607;1872.7378167056622;1874.0348720409;1874.709420039896;7318.34134927859;7351.191368949411;7395.593242371668;7404.777856664308;7412.740554080635;4146.481689788777;4259.957400425987;4278.251306021465;4285.871423857289;4293.141371725636;2725.604787305849;2823;2829.745322920947;2842.857857107136;2847.686754457008;831.4304701279643;854.179987212277;866.8309679612478;868.7263511993765;877.6182360673128;10106.039926206999;10136.847947280723;10145.086942175165;10165.644202452879;10191.745206369826;3609.620989796086;3613.7109031277437;3752.981235093807;3827.5789663137034;3849.5957924418094;7788.415868809862;7973.800654983555;7977.2022797719765;8558.144185581517;8563.871541926876;3875.992242017096;3920.1963597463023;4128.545859955402;4234.534201237861;4238.855509012611;3877.0501227199516;3877.2051729395407;3885.3200689879723;3887.183691424776;3887.9611203888167;3222.242772948355;3275.082976766509;3292.7859689120132;3332.5167850662;3355.261842394669;981.4454833019464;985.1822986920838;985.3496692183124;987.7579992901785;997.2869398380193;743.8809790433505;760.3916866506772;769.7305942919933;780.9336206422518;784.4861615641764;4589.541045895384;4746.28805679144;4808.797800549863;4820;5014.2979982802435;763.2291385700482;765.9004329437138;769.5575044349522;801.1627848897915;801.8356236971407;2965.851707414664;3063.0963865659683;3081.0910781319117;3184.076617780864;3198.616166060088;8621.31029517637;9002.099790021077;9044.773880653036;9216.124468175512;9220.354575179806;8997.730068097968;9154.267658587298;9157;9158.450492970444;9168.404053736485;6856.4514838813775;6999.545029573062;7037.612931288828;7039.753608623673;7048.823779405453;4743.66794324394;4879.975600121977;4929.334539837076;4972.254161875748;4998;8160.428769986044;8297.543635100128;8304.169583041648;8380;8392.622331994953;8368.497890126611;8502.107278735644;8671;8698.434601750865;8720.476771393736;5949.315828679584;6183.103449999635;6309.621422714652;6469.77355792545;6649.933500665125;7164.498485106201;7332.0834895638045;7334.889976650248;7345.228750981284;7358.632068396666;6618.503612229006;6621.27166011748;6624.536282460374;6659.433948114271;6856.897146542706;6263.812085637438;6279.874402512016;6314.55798094129;6607.372299631527;6626.900596491153;5460.34475862899;5510.8071217507195;5549.889002220014;5553.9444605555045;5586.888262234814;3715.572709138484;3764.472973783618;3819.988496400149;3822.3310920589342;3936.9606303936594;3982.143839074613;3998.1603863189057;4020.175863947942;4058.4521089652517;4125.752454852718 09:59:57 INFO - PROCESS | 932 | |4;prototype.html;254.97450254974493;257.1488373483769;261.2814759411618;263.6282841193916;267.98166965530976;5275.702685821361;5280.894382112356;5291.2327712481765;5292.550133238675;5319.037317198688;4949.653524253304;5075.746212689369;5094.898102037966;5129.307543481629;5147.073526765181;3885.49488566486;3886.514185726784;3894.415837624351;3894.5131858517684;3901.1222474943124;3889.6499315061637;3891.299566078105;3908.589598092202;3911.27641386343;3912.9021774455723;3643.2512394050873;3768.830402631874;3786.943195852051;3794.2411517696432;3893.1045859452342;3771.17034252464;3777.9055523611855;3781.546214454283;3789.7915614641183;3805.6955443564448;3184.506401507747;3186.330870517171;3202.231464448539;3203.0051901471966;3220.983895080533;4834.226523756182;5075.441701412841;5107.259447380146;5134.563562097189;5137.484442089592;4369;4386.561343865588;4446.510883802779;4449.8850804437025;4456.710313829591;5391.029614669358;5479.027550081967;5484.149956756709;5505.917411238835;5519.9448005519835;3593.7125029997537;3601.9279614407565;3608.585012723544;3610.368185567515;3612.6929211017095;5450.809221677222;5729.424408287754;5737.82786516401;5747.971260143714;5750.654960702372;3641.3809652359164;3641.617630148849;3649.9635003650155;3652.4521321801412;3677.5770786359376;3698.63013698628;3699.8705045323823;3707.8331475083687;3715.7398982070995;3724.2365315110337;4277.615014648696;4343.401752252326;4377.846775362847;4390.8024138913825;4402.427684401007;5472.753726082336;5487.6981766003255;5492.752826122834;5521.751521181556;5523.613347065667;1213.7329787446747;1246.1962034487706;1259.785836407813;1274.955376561816;1277.5911708253454;803.7267329108131;827.9130691277329;835.1314632781839;835.7910522369408;836.832618497193;5344.305240318734;5350.4483699727425;5355;5360.874216414597;5364.91952620711;5502.477264659851;5646.124850648156;5651.547876169897;5651.717414129359;5655.2468734692375;5340.19897015443;5353.116735738559;5374.435684253097;5382.381026182039;5392.541633961078;3021.289996850738;3026.4854974654363;3038.2708150044273;3039.544068389759;3039.6321655255224;5460.290162278879;5762.798302059492;5776.624519406225;5785.247917770747;5787.797427090031;5733.226014487991;5734.283214598176;5739.62692424991;5750.453706897838;5752.827415177551;5730.169125476783;5761.279840019997;5773.24947756789;5783.739731712083;5783.913241301384;5448.482394172547;5783.248177736868;5808.883822323614;5823.475887170175;5824.446677565625;5703.800366987136;5716;5718.340262232258;5740.51205647508;5752.28096487939;5754.769809207753;5935.614185077956;5961.940380596138;5996.970015149896;6017.578769486094;3669.229461813049;3687.520622319081;3687.723420743401;3691.796951167604;3695.2240029594086;5799.565032622486;5826.650400975955;5829.804889997456;5838.883222335615;5851.385604511635;5466.480684334982;5607.8037268697035;5625.381208067191;5635.436456354331;5641.407652196624;5608.495235428831;5622;5627.268455100811;5630.634008789416;5660.886782264414;5284.630075894805;5401.810936617357;5419.864503387289;5516.282883225315;5551.195076713773;5578.967890940026;5606.411326810626;5632.887342253214;5636.633618814764;5644.109223410203;5414.133738601962;5507.669539827623;5545.750441230073;5562.332520097614;5572.944270557243 09:59:57 INFO - PROCESS | 932 | |5;yui.html;594.0435898203888;609.7164818359462;620.8634100497891;697.0798545919389;697.6093387702887;13316.933415332922;13841.30793460328;14239.145651260931;14273.571792846218;14449.927750361234;13199.274039927801;13470.191788492697;13526.526571569997;13602.659933501667;13607;548.8271194573716;558.7401858135966;639.8624295776407;642.6272761798169;658.2068607328158;649.730361899811;667.5160508631228;672.3646154384109;672.3881268046079;672.660306545194;698.4691634357899;699.3565919354181;701.6561884676523;701.8806802843503;701.9578825270474;569.9971500142493;577.5697105656271;674.1472037872047;696.7596179318127;698.2982102986491;500.7296060127527;500.9474005229435;501.8444282272471;505.3329604921505;505.37838458695643;12878.162919410302;12999.675008124777;13033.21800691952;13057.281849498273;13068.085234033622;11664.825027624593;11853.762924741543;11920.46357913896;11963.46164422603;12463.314517701523;11286.548538058469;11474.713132171679;11557.30656160633;11623.59317423886;11707.53169873204;3897.5517815451303;3935.311320518898;3935.9803200984097;3982.482277303932;4007.5992400759983;60415.395846041414;62394.376056239766;73968.26031739722;74098.62950685211;74608.25391746068;9758.609655613696;9836.754081148028;9864.260180486492;9970.152537034433;9983.201343892471;17048.744268835977;17155;17196;17197.398091066752;17438.825611743974;6854.691538880663;7004.404625606779;7073.646317684095;7154.570725756471;7231.5299505531975;4086.162336720965;4126;4135.193637240769;4182.226288136643;4195.916081678411;2871.6984716604456;3000.129962310949;3009.7291243788163;3011.3676128012926;3013.2918764090423;511.47829214201306;518.9931532826305;528.3026405145248;532.2761044978826;532.9680219186861;627.8336240896075;644.3986693067723;666.6067020457953;673.4040374268709;675.3651567526607;8685.826283474295;8859.778505537284;8949.821003579891;9027.23268522183;9032.683856065007;536.9221462887938;541.4179756761497;664.0338307762195;665.5939876675225;671.1677519875319;3892.416137579329;3913.882583522499;4104.281750693616;4118;4224.197402493578;94610;98089;100182;100351.49824250978;100387;54228;80957.59521202474;82057.58971205226;83655.16344836596;83784.58107709544;49638.75180624074;52188;75303.62348188333;75666;76416.23583764203;7914.525128492309;7927.563983980705;7997.720079797179;8080.636371363185;8206.138355472589;43966.340504893094;44028.33957490576;44509.109817804114;44513.55486445094;44904.550954490034;60548.39451605428;64531;64602.35397646151;64616.67691661511;66178;9823.459709716035;9931.453770042717;9984.251181161588;10110.8483372748;10654.680359589225;11593.942030289794;11640.35978021217;11800.586979456022;12053.337066461429;12450.377481126088;11229.88770112321;11300.547978080785;11475.024622906813;11554.59558915434;11908.880911190778;10523.315984460985;10937.507812148313;11080.778384432428;11397.544098235978;11889.167758256839;11134.220604557604;11188.552457901593;11272.549098035986;11306.060379428312;11378.772424551627;9375.249980001447;9381.880270193315;9982.800343993225;10093.798124037332;10097.949510252402;9878.110970012733;9889.901100988898;9925.875310091014;9938.701838944844;9951.353162044445 09:59:57 INFO - PROCESS | 932 | __end_tp_report 09:59:57 INFO - PROCESS | 932 | __start_cc_report 09:59:57 INFO - PROCESS | 932 | _x_x_mozilla_cycle_collect,1275 09:59:57 INFO - PROCESS | 932 | __end_cc_report 09:59:57 INFO - PROCESS | 932 | __startTimestamp1477328397229__endTimestamp 09:59:57 INFO - PROCESS | 932 | 09:59:57 INFO - PROCESS | 932 | ------- Summary: start ------- 09:59:57 INFO - PROCESS | 932 | Number of tests: 6 09:59:57 INFO - PROCESS | 932 | 09:59:57 INFO - PROCESS | 932 | [#0] dojo.html Cycles:165 Average:5022.27 Median:5331.36 stddev:752.76 (14.1%) stddev-sans-first:735.43 09:59:57 INFO - PROCESS | 932 | Values: 2845.2 2876.9 2888.9 2904.1 2905.5 5061.5 5118.6 5145.5 5183.2 5192.5 5037.2 5091.9 5101.1 5105.2 5156.0 4356.0 4494.9 4528.8 4544.4 4612.0 4572.3 4622.3 4657.7 4658.5 4674.3 687.2 4656.2 4664.2 4704.2 4720.2 3650.6 4647.0 4664.4 4665.9 4706.6 4610.8 4622.0 4622.3 4628.4 4678.1 5079.7 5109.7 5119.9 5190.5 5248.8 5417.6 5445.3 5458.8 5460.2 5526.4 5462.6 5479.5 5484.5 5499.6 5501.6 5054.8 5059.8 5065.6 5088.2 5134.6 5561.9 5587.3 5596.0 5597.1 5674.1 5070.0 5335.9 5342.0 5342.1 5361.0 5452.5 5460.5 5461.5 5464.4 5531.4 5318.8 5347.3 5361.2 5384.8 5431.1 5382.9 5409.5 5419.6 5423.9 5425.4 3577.8 3580.7 3584.9 3585.2 3587.1 3296.5 3306.4 3312.9 3313.0 3313.2 5248.3 5252.3 5255.2 5257.9 5264.0 5598.7 5611.7 5615.1 5619.8 5621.6 5329.8 5338.5 5349.5 5381.9 5383.9 4521.7 4539.2 4550.4 4554.9 4612.7 5589.6 5629.5 5630.6 5784.7 5786.2 5371.3 5491.1 5494.1 5496.8 5503.6 5599.7 5642.6 5649.1 5651.0 5656.9 5338.2 5374.8 5425.1 5438.8 5504.9 5521.0 5536.4 5536.5 5547.2 5597.3 5356.2 5367.7 5398.9 5410.3 5459.6 5371.7 5399.1 5409.8 5414.1 5480.3 5200.7 5201.9 5251.7 5259.2 5330.7 5272.2 5353.9 5359.7 5372.9 5406.7 5291.9 5292.3 5300.2 5327.5 5331.4 09:59:57 INFO - PROCESS | 932 | 09:59:57 INFO - PROCESS | 932 | [#1] ext.html Cycles:180 Average:50335.44 Median:36096.51 stddev:96626.82 (267.7%) stddev-sans-first:96825.49 09:59:57 INFO - PROCESS | 932 | Values: 520.2 544.7 550.4 567.8 577.9 35152.5 38358.0 38432.2 38470.0 38475.8 38135.8 38302.4 38415.0 38496.0 38593.4 7371.4 7547.0 8304.6 8437.1 8473.2 9732.3 9940.3 9989.7 10260.4 10265.3 10119.7 10127.6 10202.2 10208.5 10210.0 7447.6 7634.0 9784.3 9890.4 9900.3 9472.6 9690.8 9777.0 9778.0 9786.6 36318.5 36696.4 36701.3 36760.6 36783.0 3110.3 3116.3 3149.7 3177.2 3239.0 28647.9 28964.0 28977.4 29016.0 29822.4 3949.8 3965.4 3981.3 4044.3 4106.8 314060.0 315888.0 316358.0 317043.0 317552.4 51381.7 51472.7 51554.5 51666.2 51674.5 30221.2 30901.7 30992.1 32241.7 53239.2 13683.7 13971.5 14200.0 14237.7 14244.1 9536.4 9597.6 10497.2 10523.9 10671.6 16382.2 16437.4 16463.8 16474.4 16506.0 6218.8 6285.4 6339.6 6367.2 6370.9 833.3 934.2 942.6 972.8 997.5 27454.6 28353.6 28398.7 28839.7 28994.4 948.7 959.7 968.2 968.9 1000.1 14475.0 14705.9 14918.2 14977.7 15096.4 442510.0 444022.6 445430.0 447455.0 447832.0 48300.0 48631.8 48751.3 49346.5 49457.8 1073.2 1100.5 1139.1 1155.8 1182.0 26161.9 27845.4 28322.0 28628.4 28986.3 41983.2 42124.0 42164.0 42537.0 42568.8 318677.0 320550.2 320830.0 320832.0 322637.0 24412.0 24665.5 25246.1 25273.6 26359.5 42229.2 42304.4 42705.4 42801.8 43064.1 35805.5 35843.0 36199.0 36673.6 36794.6 35123.6 35673.3 35994.0 36694.4 38662.5 34859.7 34999.8 35409.5 35771.0 35873.3 31512.0 32302.7 32445.7 33046.7 33087.3 24980.6 25176.9 25203.9 25680.9 25801.4 09:59:57 INFO - PROCESS | 932 | 09:59:57 INFO - PROCESS | 932 | [#2] jquery.html Cycles:180 Average:23935.30 Median:5223.45 stddev:63525.24 (1216.2%) stddev-sans-first:63678.67 09:59:57 INFO - PROCESS | 932 | Values: 303.5 318.9 319.4 321.5 325.7 13009.5 13739.9 16181.4 16260.3 17005.6 15079.2 15295.8 15314.3 16041.0 16250.8 4089.5 4981.6 5226.8 5244.8 5247.0 5159.7 5244.4 5254.7 5258.0 5265.5 4971.9 5173.8 5211.5 5212.2 5220.1 5005.3 5028.1 5066.9 5068.7 5072.7 4249.8 4384.8 4393.0 4393.8 4396.3 19190.5 19858.4 19879.4 20121.6 20152.7 2013.9 2016.9 2027.7 2061.7 2246.5 12505.9 12639.0 12664.6 12685.9 13306.9 1743.8 1771.2 1791.2 1809.1 1839.4 68179.3 68448.3 68662.3 69040.1 69234.0 7797.0 8305.5 8487.8 8535.9 8628.3 11164.0 11179.4 11188.3 11212.0 11364.8 6798.9 6827.2 6894.8 7001.2 7016.0 6778.8 6793.9 6907.4 6911.0 6918.7 5395.1 5490.6 5496.8 5525.2 5571.7 1555.2 1577.2 1577.9 1579.1 1579.5 684.5 876.3 902.3 910.4 921.3 16627.9 16743.5 16923.6 17110.2 17251.1 843.4 854.6 894.4 897.8 908.4 9525.4 9730.2 9806.7 9893.4 10005.7 319418.0 385316.0 389158.0 390301.0 421805.0 81178.6 85146.0 86709.6 86807.0 87436.0 878.7 890.7 891.6 891.9 896.6 14299.8 14742.9 14835.9 14864.1 14958.9 34547.8 35340.5 35795.8 35881.5 36235.5 48995.8 52153.5 52426.0 53128.0 53191.2 6691.5 6830.0 6854.4 6934.1 6950.8 8457.4 10898.6 11063.1 11071.0 11281.8 9206.7 9791.5 9854.8 9896.6 9954.7 9377.1 9410.1 9585.8 9609.7 9850.9 9400.3 9872.0 9886.1 9935.9 10051.0 5742.7 6051.1 6221.3 6839.6 6852.9 7011.6 8721.2 9660.0 9706.1 9861.7 09:59:57 INFO - PROCESS | 932 | 09:59:57 INFO - PROCESS | 932 | [#3] mootools.html Cycles:180 Average:4735.18 Median:5485.58 stddev:2750.74 (50.1%) stddev-sans-first:2745.79 09:59:57 INFO - PROCESS | 932 | Values: 1222.8 1240.3 1270.3 1454.2 1455.7 6653.1 7113.0 7113.3 7119.6 7124.1 6572.2 6752.7 6795.5 6911.8 6995.2 1724.8 1852.2 1916.9 1919.1 1928.2 1881.9 1884.1 1887.7 1887.7 1895.1 1748.2 1768.8 1820.4 1821.5 1826.4 1662.8 1708.1 1837.2 1888.8 1893.9 1859.8 1871.8 1872.7 1874.0 1874.7 7318.3 7351.2 7395.6 7404.8 7412.7 4146.5 4260.0 4278.3 4285.9 4293.1 2725.6 2823.0 2829.7 2842.9 2847.7 831.4 854.2 866.8 868.7 877.6 10106.0 10136.8 10145.1 10165.6 10191.7 3609.6 3613.7 3753.0 3827.6 3849.6 7788.4 7973.8 7977.2 8558.1 8563.9 3876.0 3920.2 4128.5 4234.5 4238.9 3877.1 3877.2 3885.3 3887.2 3888.0 3222.2 3275.1 3292.8 3332.5 3355.3 981.4 985.2 985.3 987.8 997.3 743.9 760.4 769.7 780.9 784.5 4589.5 4746.3 4808.8 4820.0 5014.3 763.2 765.9 769.6 801.2 801.8 2965.9 3063.1 3081.1 3184.1 3198.6 8621.3 9002.1 9044.8 9216.1 9220.4 8997.7 9154.3 9157.0 9158.5 9168.4 6856.5 6999.5 7037.6 7039.8 7048.8 4743.7 4880.0 4929.3 4972.3 4998.0 8160.4 8297.5 8304.2 8380.0 8392.6 8368.5 8502.1 8671.0 8698.4 8720.5 5949.3 6183.1 6309.6 6469.8 6649.9 7164.5 7332.1 7334.9 7345.2 7358.6 6618.5 6621.3 6624.5 6659.4 6856.9 6263.8 6279.9 6314.6 6607.4 6626.9 5460.3 5510.8 5549.9 5553.9 5586.9 3715.6 3764.5 3820.0 3822.3 3937.0 3982.1 3998.2 4020.2 4058.5 4125.8 09:59:57 INFO - PROCESS | 932 | 09:59:57 INFO - PROCESS | 932 | [#4] prototype.html Cycles:180 Average:4556.95 Median:5357.94 stddev:1446.56 (27.0%) stddev-sans-first:1414.12 09:59:57 INFO - PROCESS | 932 | Values: 255.0 257.1 261.3 263.6 268.0 5275.7 5280.9 5291.2 5292.6 5319.0 4949.7 5075.7 5094.9 5129.3 5147.1 3885.5 3886.5 3894.4 3894.5 3901.1 3889.6 3891.3 3908.6 3911.3 3912.9 3643.3 3768.8 3786.9 3794.2 3893.1 3771.2 3777.9 3781.5 3789.8 3805.7 3184.5 3186.3 3202.2 3203.0 3221.0 4834.2 5075.4 5107.3 5134.6 5137.5 4369.0 4386.6 4446.5 4449.9 4456.7 5391.0 5479.0 5484.1 5505.9 5519.9 3593.7 3601.9 3608.6 3610.4 3612.7 5450.8 5729.4 5737.8 5748.0 5750.7 3641.4 3641.6 3650.0 3652.5 3677.6 3698.6 3699.9 3707.8 3715.7 3724.2 4277.6 4343.4 4377.8 4390.8 4402.4 5472.8 5487.7 5492.8 5521.8 5523.6 1213.7 1246.2 1259.8 1275.0 1277.6 803.7 827.9 835.1 835.8 836.8 5344.3 5350.4 5355.0 5360.9 5364.9 5502.5 5646.1 5651.5 5651.7 5655.2 5340.2 5353.1 5374.4 5382.4 5392.5 3021.3 3026.5 3038.3 3039.5 3039.6 5460.3 5762.8 5776.6 5785.2 5787.8 5733.2 5734.3 5739.6 5750.5 5752.8 5730.2 5761.3 5773.2 5783.7 5783.9 5448.5 5783.2 5808.9 5823.5 5824.4 5703.8 5716.0 5718.3 5740.5 5752.3 5754.8 5935.6 5961.9 5997.0 6017.6 3669.2 3687.5 3687.7 3691.8 3695.2 5799.6 5826.7 5829.8 5838.9 5851.4 5466.5 5607.8 5625.4 5635.4 5641.4 5608.5 5622.0 5627.3 5630.6 5660.9 5284.6 5401.8 5419.9 5516.3 5551.2 5579.0 5606.4 5632.9 5636.6 5644.1 5414.1 5507.7 5545.8 5562.3 5572.9 09:59:57 INFO - PROCESS | 932 | 09:59:57 INFO - PROCESS | 932 | [#5] yui.html Cycles:180 Average:17514.08 Median:26358.15 stddev:25032.89 (95.0%) stddev-sans-first:25070.88 09:59:57 INFO - PROCESS | 932 | Values: 594.0 609.7 620.9 697.1 697.6 13316.9 13841.3 14239.1 14273.6 14449.9 13199.3 13470.2 13526.5 13602.7 13607.0 548.8 558.7 639.9 642.6 658.2 649.7 667.5 672.4 672.4 672.7 698.5 699.4 701.7 701.9 702.0 570.0 577.6 674.1 696.8 698.3 500.7 500.9 501.8 505.3 505.4 12878.2 12999.7 13033.2 13057.3 13068.1 11664.8 11853.8 11920.5 11963.5 12463.3 11286.5 11474.7 11557.3 11623.6 11707.5 3897.6 3935.3 3936.0 3982.5 4007.6 60415.4 62394.4 73968.3 74098.6 74608.3 9758.6 9836.8 9864.3 9970.2 9983.2 17048.7 17155.0 17196.0 17197.4 17438.8 6854.7 7004.4 7073.6 7154.6 7231.5 4086.2 4126.0 4135.2 4182.2 4195.9 2871.7 3000.1 3009.7 3011.4 3013.3 511.5 519.0 528.3 532.3 533.0 627.8 644.4 666.6 673.4 675.4 8685.8 8859.8 8949.8 9027.2 9032.7 536.9 541.4 664.0 665.6 671.2 3892.4 3913.9 4104.3 4118.0 4224.2 94610.0 98089.0 100182.0 100351.5 100387.0 54228.0 80957.6 82057.6 83655.2 83784.6 49638.8 52188.0 75303.6 75666.0 76416.2 7914.5 7927.6 7997.7 8080.6 8206.1 43966.3 44028.3 44509.1 44513.6 44904.6 60548.4 64531.0 64602.4 64616.7 66178.0 9823.5 9931.5 9984.3 10110.8 10654.7 11593.9 11640.4 11800.6 12053.3 12450.4 11229.9 11300.5 11475.0 11554.6 11908.9 10523.3 10937.5 11080.8 11397.5 11889.2 11134.2 11188.6 11272.5 11306.1 11378.8 9375.2 9381.9 9982.8 10093.8 10097.9 9878.1 9889.9 9925.9 9938.7 9951.4 09:59:57 INFO - PROCESS | 932 | -------- Summary: end -------- 09:59:57 INFO - PROCESS | 932 | 09:59:57 INFO - TEST-INFO | 932: exit 0 09:59:58 INFO - TEST-OK | dromaeo_css | took 1122919ms 09:59:58 INFO - TEST-START | kraken 09:59:58 INFO - operating with platform_type : w8_ 09:59:58 INFO - Initialising browser for kraken test... 09:59:58 INFO - TEST-INFO | started process 3116 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpzln2_0\profile http://localhost:49280/getInfo.html) 10:00:07 INFO - PROCESS | 3116 | __metrics Screen width/height:1600/1200 10:00:07 INFO - PROCESS | 3116 | colorDepth:24 10:00:07 INFO - PROCESS | 3116 | Browser inner width/height: 1010/674 10:00:07 INFO - PROCESS | 3116 | __metrics 10:00:08 INFO - PROCESS | 3116 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:00:08 INFO - PROCESS | 3116 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:00:09 INFO - PROCESS | 3116 | console.error: 10:00:09 INFO - PROCESS | 3116 | Message: Error: Connection closed before committing the transaction. 10:00:09 INFO - PROCESS | 3116 | Stack: 10:00:09 INFO - PROCESS | 3116 | ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:937:23 10:00:09 INFO - PROCESS | 3116 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7 10:00:09 INFO - PROCESS | 3116 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11 10:00:09 INFO - PROCESS | 3116 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7 10:00:09 INFO - PROCESS | 3116 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:714:7 10:00:09 INFO - PROCESS | 3116 | TaskImpl_run@resource://gre/modules/Task.jsm:327:15 10:00:09 INFO - PROCESS | 3116 | Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:551:9 10:00:09 INFO - PROCESS | 3116 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15 10:00:09 INFO - PROCESS | 3116 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:388:5 10:00:09 INFO - PROCESS | 3116 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29 10:00:09 INFO - PROCESS | 3116 | Barrier/this.client.addBlocker/promise13.4% 10:01:06 INFO - TinderboxPrint: I/O read bytes / time
218,360,832 / 3,443,450 10:01:06 INFO - TinderboxPrint: I/O write bytes / time
420,397,056 / 4,718,730 10:01:06 INFO - TinderboxPrint: CPU idle
8,274.5 (86.6%) 10:01:06 INFO - TinderboxPrint: CPU user
1,232.6 (12.9%) 10:01:06 INFO - install - Wall time: 3s; CPU: 9.0%; Read bytes: 0; Write bytes: 38002688; Read time: 0; Write time: 123300 10:01:06 INFO - run-tests - Wall time: 1192s; CPU: 13.0%; Read bytes: 218360832; Write bytes: 326328320; Read time: 3443450; Write time: 4535240 10:01:06 INFO - Running post-run listener: _upload_blobber_files 10:01:06 INFO - Blob upload gear active. 10:01:06 INFO - Preparing to upload files from C:\slave\test\build\blobber_upload_dir. 10:01:06 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 10:01:06 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', 'Autoland', '-d', 'C:\\slave\\test\\build\\blobber_upload_dir', '--output-manifest', 'C:\\slave\\test\\build\\uploaded_files.json'] 10:01:06 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 Autoland -d C:\slave\test\build\blobber_upload_dir --output-manifest C:\slave\test\build\uploaded_files.json 10:01:07 INFO - (blobuploader) - INFO - Open directory for files ... 10:01:07 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_errorsummary.log ... 10:01:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:01:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:01:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:01:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:01:09 INFO - (blobuploader) - INFO - Done attempting. 10:01:09 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_raw.log ... 10:01:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:01:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:01:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:01:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:01:10 INFO - (blobuploader) - INFO - Done attempting. 10:01:10 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\resource-usage.json ... 10:01:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:01:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:01:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:01:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:01:13 INFO - (blobuploader) - INFO - Done attempting. 10:01:13 INFO - (blobuploader) - INFO - Iteration through files over. 10:01:13 INFO - Return code: 0 10:01:13 INFO - rmtree: C:\slave\test\build\uploaded_files.json 10:01:13 INFO - Using _rmtree_windows ... 10:01:13 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build\\uploaded_files.json',), kwargs: {}, attempt #1 10:01:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9500c2b72a2efd4bd0f5ed87d503e6464b70330c85fbd0200885c3551a1eecb2f1b557d74e3af87bc7d0cdc642821f94c9a46a84d0c10bda72ffb7c9482dcf18", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/14384428a2a89f0e1d77bf28a5dc11a785f8c055abb820baf609de019a8c077d944bd219bbb1107a0ffab07862e8ee0e7d01977a11885b6959a7facdb7929cfb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/44ddb3bb06b9e24ca6b20e18ceb80b42773c0e554c3af809f9194749626e0c1bd1714fa2d812b464688db52418c423b2601c57b5acf03b6066a7755b971b68a5"} 10:01:13 INFO - Writing buildbot properties ['blobber_files'] to C:\slave\test\properties\blobber_files 10:01:13 INFO - Writing to file C:\slave\test\properties\blobber_files 10:01:13 INFO - Contents: 10:01:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9500c2b72a2efd4bd0f5ed87d503e6464b70330c85fbd0200885c3551a1eecb2f1b557d74e3af87bc7d0cdc642821f94c9a46a84d0c10bda72ffb7c9482dcf18", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/14384428a2a89f0e1d77bf28a5dc11a785f8c055abb820baf609de019a8c077d944bd219bbb1107a0ffab07862e8ee0e7d01977a11885b6959a7facdb7929cfb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/44ddb3bb06b9e24ca6b20e18ceb80b42773c0e554c3af809f9194749626e0c1bd1714fa2d812b464688db52418c423b2601c57b5acf03b6066a7755b971b68a5"} 10:01:13 INFO - Running post-run listener: copy_logs_to_upload_dir 10:01:13 INFO - Copying logs to upload dir... 10:01:13 INFO - mkdir: C:\slave\test\build\upload\logs 10:01:13 INFO - Copying logs to upload dir... 10:01:13 INFO - Using _rmtree_windows ... 10:01:13 INFO - Using _rmtree_windows ... 10:01:13 INFO - Using _rmtree_windows ... 10:01:13 INFO - Using _rmtree_windows ... 10:01:13 INFO - Using _rmtree_windows ... 10:01:13 INFO - Using _rmtree_windows ... 10:01:13 INFO - Using _rmtree_windows ... program finished with exit code 0 elapsedTime=1401.464000 ========= master_lag: 0.59 ========= ========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 22 secs) (at 2016-10-24 10:01:13.508748) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 10:01:13.509965) ========= '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-013\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-013 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-013 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-013\AppData\Local LOGONSERVER=\\T-W864-IX-013 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-013 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-013 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-013 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9500c2b72a2efd4bd0f5ed87d503e6464b70330c85fbd0200885c3551a1eecb2f1b557d74e3af87bc7d0cdc642821f94c9a46a84d0c10bda72ffb7c9482dcf18", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/14384428a2a89f0e1d77bf28a5dc11a785f8c055abb820baf609de019a8c077d944bd219bbb1107a0ffab07862e8ee0e7d01977a11885b6959a7facdb7929cfb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/44ddb3bb06b9e24ca6b20e18ceb80b42773c0e554c3af809f9194749626e0c1bd1714fa2d812b464688db52418c423b2601c57b5acf03b6066a7755b971b68a5"} build_url:https://queue.taskcluster.net/v1/task/eqoZfNznQ4iQdyuDjEBHGg/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/eqoZfNznQ4iQdyuDjEBHGg/artifacts/public/build/firefox-52.0a1.en-US.win64.zip' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9500c2b72a2efd4bd0f5ed87d503e6464b70330c85fbd0200885c3551a1eecb2f1b557d74e3af87bc7d0cdc642821f94c9a46a84d0c10bda72ffb7c9482dcf18", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/14384428a2a89f0e1d77bf28a5dc11a785f8c055abb820baf609de019a8c077d944bd219bbb1107a0ffab07862e8ee0e7d01977a11885b6959a7facdb7929cfb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/44ddb3bb06b9e24ca6b20e18ceb80b42773c0e554c3af809f9194749626e0c1bd1714fa2d812b464688db52418c423b2601c57b5acf03b6066a7755b971b68a5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 10:01:13.634138) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 10:01:13.634545) ========= '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-013\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-013 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-013 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-013\AppData\Local LOGONSERVER=\\T-W864-IX-013 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-013 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-013 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-013 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=0.101000 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 10:01:13.753949) ========= ========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-10-24 10:01:13.754512) ========= ========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-10-24 10:01:14.207156) ========= ========= Total master_lag: 0.75 =========