builder: autoland_win8_64_test-dromaeojs-pgo slave: t-w864-ix-175 starttime: 1477609810.3 results: success (0) buildid: 20161027123009 builduid: 8a36ea8f1faa4b4d82694e84306a1094 revision: 23f92954349863643543975a05ca8f229dfcbf23 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-27 16:10:10.302825) ========= master: http://buildbot-master110.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-27 16:10:10.303254) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-27 16:10:10.303535) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-27 16:10:10.444737) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2016-10-27 16:10:10.445266) ========= '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-175\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-175 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-175 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-175\AppData\Local LOGONSERVER=\\T-W864-IX-175 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-175 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-175 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-175 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False --16:10:11-- 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% 2.27 GB/s 16:10:13 (2.27 GB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=2.512000 ========= master_lag: 3.58 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2016-10-27 16:10:16.536624) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-10-27 16:10:16.536966) ========= '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-175\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-175 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-175 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-175\AppData\Local LOGONSERVER=\\T-W864-IX-175 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-175 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-175 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-175 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=2.908000 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-10-27 16:10:19.468240) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-27 16:10:19.468877) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo integration/autoland --rev 23f92954349863643543975a05ca8f229dfcbf23 --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 23f92954349863643543975a05ca8f229dfcbf23 --destination scripts --debug'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-175\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-175 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-175 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-175\AppData\Local LOGONSERVER=\\T-W864-IX-175 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-175 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-175 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-175 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 2016-10-27 16:10:19,901 truncating revision to first 12 chars 2016-10-27 16:10:19,901 Setting DEBUG logging. 2016-10-27 16:10:19,901 attempt 1/10 2016-10-27 16:10:19,901 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/23f929543498?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-27 16:10:20,470 unpacking tar archive at: autoland-23f929543498/testing/mozharness/ 2016-10-27 16:10:20,617 skipping symlink on windows: configs/single_locale/linux32.py program finished with exit code 0 elapsedTime=1.330000 ========= master_lag: 0.18 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-27 16:10:20.975465) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-27 16:10:20.975797) ========= script_repo_revision: 23f92954349863643543975a05ca8f229dfcbf23 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-27 16:10:20.976181) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-27 16:10:20.976456) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-27 16:10:20.994991) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 24 mins, 6 secs) (at 2016-10-27 16:10:20.995369) ========= '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-175\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-175 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-175 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-175\AppData\Local LOGONSERVER=\\T-W864-IX-175 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-175 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-175 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-175 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 16:10:21 INFO - MultiFileLogger online at 20161027 16:10:21 in C:\slave\test 16:10:21 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 16:10:21 INFO - Dumping config to C:\slave\test\logs\localconfig.json. 16:10:21 INFO - {'append_to_log': False, 16:10:21 INFO - 'base_work_dir': 'C:\\slave\\test', 16:10:21 INFO - 'blob_upload_branch': 'Autoland', 16:10:21 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt', 16:10:21 INFO - 'branch': 'Autoland', 16:10:21 INFO - 'buildbot_json_path': 'buildprops.json', 16:10:21 INFO - 'config_files': ('talos/windows_config.py',), 16:10:21 INFO - 'default_actions': ('clobber', 16:10:21 INFO - 'read-buildbot-config', 16:10:21 INFO - 'download-and-extract', 16:10:21 INFO - 'populate-webroot', 16:10:21 INFO - 'create-virtualenv', 16:10:21 INFO - 'install', 16:10:21 INFO - 'run-tests'), 16:10:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:10:21 INFO - 'download_minidump_stackwalk': True, 16:10:21 INFO - 'download_symbols': 'ondemand', 16:10:21 INFO - 'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python', 16:10:21 INFO - 'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'), 16:10:21 INFO - 'hg': 'c:/mozilla-build/hg/hg', 16:10:21 INFO - 'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python', 16:10:21 INFO - 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'), 16:10:21 INFO - 'python': 'c:/mozilla-build/python27/python.exe', 16:10:21 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe', 16:10:21 INFO - 'C:/mozilla-build/tooltool.py'), 16:10:21 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe', 16:10:21 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 16:10:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:10:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:10:21 INFO - 'installer_path': 'installer.exe', 16:10:21 INFO - 'log_level': 'info', 16:10:21 INFO - 'log_name': 'talos', 16:10:21 INFO - 'log_to_console': True, 16:10:21 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe', 16:10:21 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe', 16:10:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest', 16:10:21 INFO - 'opt_config_files': (), 16:10:21 INFO - 'pip_index': False, 16:10:21 INFO - 'sps_profile': False, 16:10:21 INFO - 'sps_profile_interval': 0, 16:10:21 INFO - 'suite': 'dromaeojs', 16:10:21 INFO - 'system_bits': '32', 16:10:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:10:21 INFO - 'title': 'T-W864-IX-175', 16:10:21 INFO - 'use_talos_json': True, 16:10:21 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'), 16:10:21 INFO - 'virtualenv_path': 'C:\\slave\\test\\build/venv', 16:10:21 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll', 16:10:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:10:21 INFO - 'work_dir': 'build'} 16:10:21 INFO - [mozharness: 2016-10-27 23:10:21.453000Z] Running clobber step. 16:10:21 INFO - Running pre-action listener: _resource_record_pre_action 16:10:21 INFO - Running main action method: clobber 16:10:21 INFO - rmtree: C:\slave\test\build 16:10:21 INFO - Using _rmtree_windows ... 16:10:21 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1 16:12:52 INFO - Running post-action listener: _resource_record_post_action 16:12:52 INFO - [mozharness: 2016-10-27 23:12:52.242000Z] Finished clobber step (success) 16:12:52 INFO - [mozharness: 2016-10-27 23:12:52.242000Z] Running read-buildbot-config step. 16:12:52 INFO - Running pre-action listener: _resource_record_pre_action 16:12:52 INFO - Running main action method: read_buildbot_config 16:12:52 INFO - Using buildbot properties: 16:12:52 INFO - { 16:12:52 INFO - "project": "", 16:12:52 INFO - "product": "firefox", 16:12:52 INFO - "script_repo_revision": "production", 16:12:52 INFO - "builddir": "autoland_win8_64_test-dromaeojs", 16:12:52 INFO - "repository": "", 16:12:52 INFO - "buildername": "Windows 8 64-bit autoland pgo talos dromaeojs", 16:12:52 INFO - "buildid": "20161027123009", 16:12:52 INFO - "pgo_build": "True", 16:12:52 INFO - "basedir": "C:\\slave\\test", 16:12:52 INFO - "buildnumber": 36, 16:12:52 INFO - "slavename": "t-w864-ix-175", 16:12:52 INFO - "master": "http://buildbot-master110.bb.releng.scl3.mozilla.com:8201/", 16:12:52 INFO - "platform": "win8_64", 16:12:52 INFO - "scheduler": "tests-autoland-win64-pgo-talos", 16:12:52 INFO - "branch": "autoland", 16:12:52 INFO - "repo_path": "integration/autoland", 16:12:52 INFO - "revision": "23f92954349863643543975a05ca8f229dfcbf23", 16:12:52 INFO - "stage_platform": "win64-pgo", 16:12:52 INFO - "builduid": "8a36ea8f1faa4b4d82694e84306a1094", 16:12:52 INFO - "slavebuilddir": "test" 16:12:52 INFO - } 16:12:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/Zy-ftQv2Tfqn5pcBwG1k4g/artifacts/public/build/firefox-52.0a1.en-US.win64.zip. 16:12:52 INFO - Running post-action listener: _resource_record_post_action 16:12:52 INFO - [mozharness: 2016-10-27 23:12:52.246000Z] Finished read-buildbot-config step (success) 16:12:52 INFO - [mozharness: 2016-10-27 23:12:52.246000Z] Running download-and-extract step. 16:12:52 INFO - Running pre-action listener: _resource_record_pre_action 16:12:52 INFO - Running main action method: download_and_extract 16:12:52 INFO - mkdir: C:\slave\test\build\tests 16:12:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:52 INFO - trying https://queue.taskcluster.net/v1/task/Zy-ftQv2Tfqn5pcBwG1k4g/artifacts/public/build/firefox-52.0a1.en-US.win64.test_packages.json 16:12:52 INFO - Downloading https://queue.taskcluster.net/v1/task/Zy-ftQv2Tfqn5pcBwG1k4g/artifacts/public/build/firefox-52.0a1.en-US.win64.test_packages.json to C:\slave\test\build\firefox-52.0a1.en-US.win64.test_packages.json 16:12:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zy-ftQv2Tfqn5pcBwG1k4g/artifacts/public/build/firefox-52.0a1.en-US.win64.test_packages.json', 'file_name': 'C:\\slave\\test\\build\\firefox-52.0a1.en-US.win64.test_packages.json'}, attempt #1 16:12:53 INFO - Downloaded 1218 bytes. 16:12:53 INFO - Reading from file C:\slave\test\build\firefox-52.0a1.en-US.win64.test_packages.json 16:12:53 INFO - Using the following test package requirements: 16:12:53 INFO - {u'common': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 16:12:53 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 16:12:53 INFO - u'firefox-52.0a1.en-US.win64.cppunittest.tests.zip'], 16:12:53 INFO - u'gtest': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 16:12:53 INFO - u'jittest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 16:12:53 INFO - u'jsshell-win64.zip'], 16:12:53 INFO - u'mochitest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 16:12:53 INFO - u'firefox-52.0a1.en-US.win64.mochitest.tests.zip'], 16:12:53 INFO - u'mozbase': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 16:12:53 INFO - u'reftest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 16:12:53 INFO - u'firefox-52.0a1.en-US.win64.reftest.tests.zip'], 16:12:53 INFO - u'talos': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 16:12:53 INFO - u'firefox-52.0a1.en-US.win64.talos.tests.zip'], 16:12:53 INFO - u'web-platform': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 16:12:53 INFO - u'firefox-52.0a1.en-US.win64.web-platform.tests.zip'], 16:12:53 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 16:12:53 INFO - u'firefox-52.0a1.en-US.win64.xpcshell.tests.zip']} 16:12:53 INFO - Downloading packages: [u'firefox-52.0a1.en-US.win64.common.tests.zip'] for test suite category: common 16:12:53 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/Zy-ftQv2Tfqn5pcBwG1k4g/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip 16:12:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zy-ftQv2Tfqn5pcBwG1k4g/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip'}, attempt #1 16:12:53 INFO - Fetch https://queue.taskcluster.net/v1/task/Zy-ftQv2Tfqn5pcBwG1k4g/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip into memory 16:12:53 INFO - Http code: 200 16:12:53 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 16:12:53 INFO - x-amz-cf-id: kmCai-k-APH6v7Y7hBnE5R0_f8Sbtf6xdlU3fBZ_Fx8Na-Xp7OLibg== 16:12:53 INFO - x-amz-version-id: V5BZrC9fNi_TACWK_Y0daz7OtHEVVhtX 16:12:54 INFO - Expected file size: 17418358 16:12:54 INFO - Obtained file size: 17418358 16:13:19 INFO - Downloading packages: [u'firefox-52.0a1.en-US.win64.common.tests.zip', u'firefox-52.0a1.en-US.win64.talos.tests.zip'] for test suite category: talos 16:13:19 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/Zy-ftQv2Tfqn5pcBwG1k4g/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip 16:13:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zy-ftQv2Tfqn5pcBwG1k4g/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip'}, attempt #1 16:13:19 INFO - Fetch https://queue.taskcluster.net/v1/task/Zy-ftQv2Tfqn5pcBwG1k4g/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip into memory 16:13:20 INFO - Http code: 200 16:13:20 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 16:13:20 INFO - x-amz-cf-id: EJueKo-ll4eZ-bfor2eZ0ThTSZs5MW4LSfpe7gl3VYTvaQ5H_LxG-Q== 16:13:20 INFO - x-amz-version-id: V5BZrC9fNi_TACWK_Y0daz7OtHEVVhtX 16:13:20 INFO - Expected file size: 17418358 16:13:20 INFO - Obtained file size: 17418358 16:13:29 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/Zy-ftQv2Tfqn5pcBwG1k4g/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip 16:13:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zy-ftQv2Tfqn5pcBwG1k4g/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip'}, attempt #1 16:13:29 INFO - Fetch https://queue.taskcluster.net/v1/task/Zy-ftQv2Tfqn5pcBwG1k4g/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip into memory 16:13:29 INFO - Http code: 200 16:13:29 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 16:13:29 INFO - x-amz-cf-id: 3gEAATmoWE7MscT2gT7J1wDPTAbe60BjJdq8weY0_TE35eoOGTKrSg== 16:13:29 INFO - x-amz-version-id: KjzfEknc0LT5.3R5vb5fHF4g7T_eTiBx 16:13:30 INFO - Expected file size: 14409028 16:13:30 INFO - Obtained file size: 14409028 16:13:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:36 INFO - trying https://queue.taskcluster.net/v1/task/Zy-ftQv2Tfqn5pcBwG1k4g/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 16:13:36 INFO - Downloading https://queue.taskcluster.net/v1/task/Zy-ftQv2Tfqn5pcBwG1k4g/artifacts/public/build/firefox-52.0a1.en-US.win64.zip to C:\slave\test\build\firefox-52.0a1.en-US.win64.zip 16:13:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zy-ftQv2Tfqn5pcBwG1k4g/artifacts/public/build/firefox-52.0a1.en-US.win64.zip', 'file_name': 'C:\\slave\\test\\build\\firefox-52.0a1.en-US.win64.zip'}, attempt #1 16:13:38 INFO - Downloaded 57152202 bytes. 16:13:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Zy-ftQv2Tfqn5pcBwG1k4g/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 16:13:38 INFO - mkdir: C:\slave\test\properties 16:13:38 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url 16:13:38 INFO - Writing to file C:\slave\test\properties\build_url 16:13:38 INFO - Contents: 16:13:38 INFO - build_url:https://queue.taskcluster.net/v1/task/Zy-ftQv2Tfqn5pcBwG1k4g/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 16:13:38 INFO - Running post-action listener: _resource_record_post_action 16:13:38 INFO - Running post-action listener: set_extra_try_arguments 16:13:38 INFO - [mozharness: 2016-10-27 23:13:38.919000Z] Finished download-and-extract step (success) 16:13:38 INFO - [mozharness: 2016-10-27 23:13:38.919000Z] Running populate-webroot step. 16:13:38 INFO - Running pre-action listener: _resource_record_pre_action 16:13:38 INFO - Running main action method: populate_webroot 16:13:38 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']}, 16:13:38 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']}, 16:13:38 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome', 16:13:38 INFO - u'--tppagecycles', 16:13:38 INFO - u'7'], 16:13:38 INFO - u'tests': [u'tsvgm']}}, 16:13:38 INFO - u'suites': {u'chromez': {u'talos_options': [u'--disable-e10s'], 16:13:38 INFO - u'tests': [u'tresize', u'tcanvasmark']}, 16:13:38 INFO - u'chromez-e10s': {u'tests': [u'tresize', u'tcanvasmark']}, 16:13:38 INFO - u'dromaeojs': {u'talos_options': [u'--disable-e10s'], 16:13:38 INFO - u'tests': [u'dromaeo_css', u'kraken']}, 16:13:38 INFO - u'dromaeojs-e10s': {u'tests': [u'dromaeo_css', u'kraken']}, 16:13:38 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:38 INFO - u'talos_options': [u'--disable-e10s'], 16:13:38 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 16:13:38 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:38 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 16:13:38 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:38 INFO - u'talos_options': [u'--disable-e10s'], 16:13:38 INFO - u'tests': [u'damp', u'tps']}, 16:13:38 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:38 INFO - u'tests': [u'damp', u'tps']}, 16:13:38 INFO - u'g3': {u'talos_options': [u'--disable-e10s'], 16:13:38 INFO - u'tests': [u'dromaeo_dom']}, 16:13:38 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']}, 16:13:38 INFO - u'g4': {u'talos_options': [u'--disable-e10s'], 16:13:38 INFO - u'tests': [u'basic_compositor_video']}, 16:13:38 INFO - u'g4-e10s': {u'tests': [u'basic_compositor_video']}, 16:13:38 INFO - u'other': {u'talos_options': [u'--disable-e10s'], 16:13:38 INFO - u'tests': [u'a11yr', 16:13:38 INFO - u'ts_paint', 16:13:38 INFO - u'tpaint', 16:13:38 INFO - u'sessionrestore', 16:13:38 INFO - u'sessionrestore_no_auto_restore', 16:13:38 INFO - u'tabpaint']}, 16:13:38 INFO - u'other-e10s': {u'tests': [u'a11yr', 16:13:38 INFO - u'ts_paint', 16:13:38 INFO - u'tpaint', 16:13:38 INFO - u'sessionrestore', 16:13:38 INFO - u'sessionrestore_no_auto_restore', 16:13:38 INFO - u'tabpaint']}, 16:13:38 INFO - u'other-e10s_l64': {u'tests': [u'a11yr', 16:13:38 INFO - u'ts_paint', 16:13:38 INFO - u'tpaint', 16:13:38 INFO - u'sessionrestore', 16:13:38 INFO - u'sessionrestore_no_auto_restore', 16:13:38 INFO - u'tabpaint']}, 16:13:38 INFO - u'other-e10s_nol64': {u'tests': [u'a11yr', 16:13:38 INFO - u'ts_paint', 16:13:38 INFO - u'tpaint', 16:13:38 INFO - u'sessionrestore', 16:13:38 INFO - u'sessionrestore_no_auto_restore', 16:13:38 INFO - u'tabpaint']}, 16:13:38 INFO - u'other_l64': {u'talos_options': [u'--disable-e10s'], 16:13:38 INFO - u'tests': [u'a11yr', 16:13:38 INFO - u'ts_paint', 16:13:38 INFO - u'tpaint', 16:13:38 INFO - u'sessionrestore', 16:13:38 INFO - u'sessionrestore_no_auto_restore', 16:13:38 INFO - u'tabpaint']}, 16:13:38 INFO - u'other_nol64': {u'talos_options': [u'--disable-e10s'], 16:13:38 INFO - u'tests': [u'a11yr', 16:13:38 INFO - u'ts_paint', 16:13:38 INFO - u'tpaint', 16:13:38 INFO - u'sessionrestore', 16:13:38 INFO - u'sessionrestore_no_auto_restore', 16:13:38 INFO - u'tabpaint']}, 16:13:38 INFO - u'svgr': {u'talos_options': [u'--disable-e10s'], 16:13:38 INFO - u'tests': [u'tsvgx', 16:13:38 INFO - u'tsvgr_opacity', 16:13:38 INFO - u'tart', 16:13:38 INFO - u'tscrollx', 16:13:38 INFO - u'cart']}, 16:13:38 INFO - u'svgr-e10s': {u'tests': [u'tsvgx', 16:13:38 INFO - u'tsvgr_opacity', 16:13:38 INFO - u'tart', 16:13:38 INFO - u'tscrollx', 16:13:38 INFO - u'cart']}, 16:13:38 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:38 INFO - u'talos_options': [u'--disable-e10s'], 16:13:38 INFO - u'tests': [u'tp5o']}, 16:13:38 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:38 INFO - u'tests': [u'tp5o']}, 16:13:38 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:38 INFO - u'talos_options': [u'--disable-e10s', 16:13:38 INFO - u'--xperf_path', 16:13:38 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:13:38 INFO - u'tests': [u'tp5n']}, 16:13:38 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:38 INFO - u'talos_options': [u'--xperf_path', 16:13:38 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:13:38 INFO - u'tests': [u'tp5n']}}, 16:13:38 INFO - u'talos.zip': {u'path': u'', 16:13:38 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:13:38 INFO - Running post-action listener: _resource_record_post_action 16:13:38 INFO - [mozharness: 2016-10-27 23:13:38.971000Z] Finished populate-webroot step (success) 16:13:38 INFO - [mozharness: 2016-10-27 23:13:38.971000Z] Running create-virtualenv step. 16:13:38 INFO - Running pre-action listener: _resource_record_pre_action 16:13:38 INFO - Running main action method: create_virtualenv 16:13:38 INFO - Creating virtualenv C:\slave\test\build/venv 16:13:38 INFO - mkdir: C:\slave\test\build\venv\Scripts 16:13:39 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll 16:13:39 WARNING - Can't copy c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll: [Errno 2] No such file or directory: 'c:/mozilla-build/python27/python27.dll'! 16:13:39 INFO - Running command: ['c:/mozilla-build/python27/python.exe', 'c:/mozilla-build/buildbotve/virtualenv.py', '--no-site-packages', '--distribute', 'C:\\slave\\test\\build/venv'] in C:\slave\test\build 16:13:39 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build/venv 16:13:47 INFO - New python executable in C:\slave\test\build/venv\Scripts\python.exe 16:13:49 INFO - Installing distribute......................................................................................................................................................................................done. 16:13:51 INFO - Return code: 0 16:13:51 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', '--version'] 16:13:51 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip --version 16:13:51 INFO - Reading from file tmpfile_stdout 16:13:51 INFO - Output received: 16:13:51 INFO - pip 0.8.2 from c:\slave\test\build\venv\lib\site-packages\pip-0.8.2-py2.7.egg (python 2.7) 16:13:51 INFO - Using _rmtree_windows ... 16:13:51 INFO - Using _rmtree_windows ... 16:13:51 INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv 16:13: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')]} 16:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13: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')]} 16:13:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:51 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 0x023DC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02483E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0258E958>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024CAE90>, '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 0x01DDA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028AD520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-175', 'USERDOMAIN': 'T-W864-IX-175', '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-175', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-175\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-175', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-175', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-175', '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-175\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 16:13:51 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in C:\slave\test\build 16:13:51 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:13:51 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 16:13:51 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-175\\AppData\\Roaming', 16:13:51 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 16:13:51 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 16:13:51 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 16:13:51 INFO - 'COMPUTERNAME': 'T-W864-IX-175', 16:13:51 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 16:13:51 INFO - 'DCLOCATION': 'SCL3', 16:13:51 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 16:13:51 INFO - 'FP_NO_HOST_CHECK': 'NO', 16:13:51 INFO - 'HOMEDRIVE': 'C:', 16:13:51 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-175', 16:13:51 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 16:13:51 INFO - 'KTS_VERSION': '1.19c', 16:13:51 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-175\\AppData\\Local', 16:13:51 INFO - 'LOGONSERVER': '\\\\T-W864-IX-175', 16:13:51 INFO - 'MONDIR': 'C:\\Monitor_config\\', 16:13:51 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 16:13:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:51 INFO - 'MOZ_NO_REMOTE': '1', 16:13:51 INFO - 'NO_EM_RESTART': '1', 16:13:51 INFO - 'NUMBER_OF_PROCESSORS': '8', 16:13:51 INFO - 'OS': 'Windows_NT', 16:13:51 INFO - 'OURDRIVE': 'C:', 16:13: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', 16:13:51 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 16:13:51 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 16:13:51 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 16:13:51 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 16:13:51 INFO - 'PROCESSOR_LEVEL': '6', 16:13:51 INFO - 'PROCESSOR_REVISION': '1e05', 16:13:51 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 16:13:51 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 16:13:51 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 16:13:51 INFO - 'PROGRAMW6432': 'C:\\Program Files', 16:13:51 INFO - 'PROMPT': '$P$G', 16:13:51 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 16:13:51 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 16:13:51 INFO - 'PUBLIC': 'C:\\Users\\Public', 16:13:51 INFO - 'PWD': 'C:\\slave\\test', 16:13:51 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 16:13:51 INFO - 'SLAVEDIR': 'C:\\slave\\', 16:13:51 INFO - 'SYSTEMDRIVE': 'C:', 16:13:51 INFO - 'SYSTEMROOT': 'C:\\windows', 16:13:51 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:13:51 INFO - 'TEST1': 'testie', 16:13:51 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:13:51 INFO - 'USERDOMAIN': 'T-W864-IX-175', 16:13:51 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-175', 16:13:51 INFO - 'USERNAME': 'cltbld', 16:13:51 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-175', 16:13:51 INFO - 'WINDIR': 'C:\\windows', 16:13:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 16:13:52 INFO - Ignoring indexes: http://pypi.python.org/simple/ 16:13:52 INFO - Downloading/unpacking pip>=1.5 16:13:56 INFO - Running setup.py egg_info for package pip 16:13:56 INFO - warning: no files found matching 'pip\cacert.pem' 16:13:56 INFO - warning: no files found matching '*.html' under directory 'docs' 16:13:56 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 16:13:56 INFO - no previously-included directories found matching 'docs\_build\_sources' 16:13:56 INFO - Installing collected packages: pip 16:13:56 INFO - Found existing installation: pip 0.8.2 16:13:56 INFO - Uninstalling pip: 16:13:56 INFO - Successfully uninstalled pip 16:13:56 INFO - Running setup.py install for pip 16:13:56 INFO - warning: no files found matching 'pip\cacert.pem' 16:13:56 INFO - warning: no files found matching '*.html' under directory 'docs' 16:13:56 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 16:13:56 INFO - no previously-included directories found matching 'docs\_build\_sources' 16:13:56 INFO - Installing pip-script.py script to C:\slave\test\build\venv\Scripts 16:13:56 INFO - Installing pip.exe script to C:\slave\test\build\venv\Scripts 16:13:56 INFO - Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts 16:13:56 INFO - Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts 16:13:56 INFO - Installing pip2-script.py script to C:\slave\test\build\venv\Scripts 16:13:56 INFO - Installing pip2.exe script to C:\slave\test\build\venv\Scripts 16:13:56 INFO - Successfully installed pip 16:13:56 INFO - Cleaning up... 16:13:56 INFO - Return code: 0 16:13:56 INFO - Installing psutil>=3.1.1 into virtualenv C:\slave\test\build/venv 16:13:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:56 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 0x023DC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02483E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0258E958>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024CAE90>, '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 0x01DDA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028AD520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-175', 'USERDOMAIN': 'T-W864-IX-175', '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-175', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-175\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-175', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-175', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-175', '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-175\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 16:13:56 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in C:\slave\test\build 16:13:56 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:13:56 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 16:13:56 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-175\\AppData\\Roaming', 16:13:56 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 16:13:56 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 16:13:56 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 16:13:56 INFO - 'COMPUTERNAME': 'T-W864-IX-175', 16:13:56 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 16:13:56 INFO - 'DCLOCATION': 'SCL3', 16:13:56 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 16:13:56 INFO - 'FP_NO_HOST_CHECK': 'NO', 16:13:56 INFO - 'HOMEDRIVE': 'C:', 16:13:56 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-175', 16:13:56 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 16:13:56 INFO - 'KTS_VERSION': '1.19c', 16:13:56 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-175\\AppData\\Local', 16:13:56 INFO - 'LOGONSERVER': '\\\\T-W864-IX-175', 16:13:56 INFO - 'MONDIR': 'C:\\Monitor_config\\', 16:13:56 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 16:13:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:56 INFO - 'MOZ_NO_REMOTE': '1', 16:13:56 INFO - 'NO_EM_RESTART': '1', 16:13:56 INFO - 'NUMBER_OF_PROCESSORS': '8', 16:13:56 INFO - 'OS': 'Windows_NT', 16:13:56 INFO - 'OURDRIVE': 'C:', 16:13:56 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 16:13:56 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 16:13:56 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 16:13:56 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 16:13:56 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 16:13:56 INFO - 'PROCESSOR_LEVEL': '6', 16:13:56 INFO - 'PROCESSOR_REVISION': '1e05', 16:13:56 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 16:13:56 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 16:13:56 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 16:13:56 INFO - 'PROGRAMW6432': 'C:\\Program Files', 16:13:56 INFO - 'PROMPT': '$P$G', 16:13:56 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 16:13:56 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 16:13:56 INFO - 'PUBLIC': 'C:\\Users\\Public', 16:13:56 INFO - 'PWD': 'C:\\slave\\test', 16:13:56 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 16:13:56 INFO - 'SLAVEDIR': 'C:\\slave\\', 16:13:56 INFO - 'SYSTEMDRIVE': 'C:', 16:13:56 INFO - 'SYSTEMROOT': 'C:\\windows', 16:13:56 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:13:56 INFO - 'TEST1': 'testie', 16:13:56 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:13:56 INFO - 'USERDOMAIN': 'T-W864-IX-175', 16:13:56 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-175', 16:13:56 INFO - 'USERNAME': 'cltbld', 16:13:56 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-175', 16:13:56 INFO - 'WINDIR': 'C:\\windows', 16:13:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 16:13:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:58 INFO - Downloading/unpacking psutil>=3.1.1 16:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:59 INFO - Installing collected packages: psutil 16:14:00 INFO - Successfully installed psutil 16:14:00 INFO - Cleaning up... 16:14:00 INFO - Return code: 0 16:14:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv C:\slave\test\build/venv 16:14:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:00 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 0x023DC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02483E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0258E958>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024CAE90>, '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 0x01DDA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028AD520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-175', 'USERDOMAIN': 'T-W864-IX-175', '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-175', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-175\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-175', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-175', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-175', '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-175\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 16:14:00 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in C:\slave\test\build 16:14:00 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:14:00 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 16:14:00 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-175\\AppData\\Roaming', 16:14:00 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 16:14:00 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 16:14:00 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 16:14:00 INFO - 'COMPUTERNAME': 'T-W864-IX-175', 16:14:00 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 16:14:00 INFO - 'DCLOCATION': 'SCL3', 16:14:00 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 16:14:00 INFO - 'FP_NO_HOST_CHECK': 'NO', 16:14:00 INFO - 'HOMEDRIVE': 'C:', 16:14:00 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-175', 16:14:00 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 16:14:00 INFO - 'KTS_VERSION': '1.19c', 16:14:00 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-175\\AppData\\Local', 16:14:00 INFO - 'LOGONSERVER': '\\\\T-W864-IX-175', 16:14:00 INFO - 'MONDIR': 'C:\\Monitor_config\\', 16:14:00 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 16:14:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:00 INFO - 'MOZ_NO_REMOTE': '1', 16:14:00 INFO - 'NO_EM_RESTART': '1', 16:14:00 INFO - 'NUMBER_OF_PROCESSORS': '8', 16:14:00 INFO - 'OS': 'Windows_NT', 16:14:00 INFO - 'OURDRIVE': 'C:', 16:14:00 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 16:14:00 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 16:14:00 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 16:14:00 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 16:14:00 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 16:14:00 INFO - 'PROCESSOR_LEVEL': '6', 16:14:00 INFO - 'PROCESSOR_REVISION': '1e05', 16:14:00 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 16:14:00 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 16:14:00 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 16:14:00 INFO - 'PROGRAMW6432': 'C:\\Program Files', 16:14:00 INFO - 'PROMPT': '$P$G', 16:14:00 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 16:14:00 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 16:14:00 INFO - 'PUBLIC': 'C:\\Users\\Public', 16:14:00 INFO - 'PWD': 'C:\\slave\\test', 16:14:00 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 16:14:00 INFO - 'SLAVEDIR': 'C:\\slave\\', 16:14:00 INFO - 'SYSTEMDRIVE': 'C:', 16:14:00 INFO - 'SYSTEMROOT': 'C:\\windows', 16:14:00 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:14:00 INFO - 'TEST1': 'testie', 16:14:00 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:14:00 INFO - 'USERDOMAIN': 'T-W864-IX-175', 16:14:00 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-175', 16:14:00 INFO - 'USERNAME': 'cltbld', 16:14:00 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-175', 16:14:00 INFO - 'WINDIR': 'C:\\windows', 16:14:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 16:14:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:14:01 INFO - Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor 16:14:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in c:\slave\test\build\venv\lib\site-packages (from mozsystemmonitor==0.3) 16:14:01 INFO - Installing collected packages: mozsystemmonitor 16:14:01 INFO - Running setup.py install for mozsystemmonitor 16:14:01 INFO - Successfully installed mozsystemmonitor 16:14:01 INFO - Cleaning up... 16:14:02 INFO - Return code: 0 16:14:02 INFO - Installing jsonschema==2.5.1 into virtualenv C:\slave\test\build/venv 16:14:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:02 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x023DC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02483E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0258E958>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024CAE90>, '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 0x01DDA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028AD520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-175', 'USERDOMAIN': 'T-W864-IX-175', '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-175', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-175\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-175', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-175', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-175', '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-175\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 16:14:02 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in C:\slave\test\build 16:14:02 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:14:02 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 16:14:02 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-175\\AppData\\Roaming', 16:14:02 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 16:14:02 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 16:14:02 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 16:14:02 INFO - 'COMPUTERNAME': 'T-W864-IX-175', 16:14:02 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 16:14:02 INFO - 'DCLOCATION': 'SCL3', 16:14:02 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 16:14:02 INFO - 'FP_NO_HOST_CHECK': 'NO', 16:14:02 INFO - 'HOMEDRIVE': 'C:', 16:14:02 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-175', 16:14:02 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 16:14:02 INFO - 'KTS_VERSION': '1.19c', 16:14:02 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-175\\AppData\\Local', 16:14:02 INFO - 'LOGONSERVER': '\\\\T-W864-IX-175', 16:14:02 INFO - 'MONDIR': 'C:\\Monitor_config\\', 16:14:02 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 16:14:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:02 INFO - 'MOZ_NO_REMOTE': '1', 16:14:02 INFO - 'NO_EM_RESTART': '1', 16:14:02 INFO - 'NUMBER_OF_PROCESSORS': '8', 16:14:02 INFO - 'OS': 'Windows_NT', 16:14:02 INFO - 'OURDRIVE': 'C:', 16:14:02 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 16:14:02 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 16:14:02 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 16:14:02 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 16:14:02 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 16:14:02 INFO - 'PROCESSOR_LEVEL': '6', 16:14:02 INFO - 'PROCESSOR_REVISION': '1e05', 16:14:02 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 16:14:02 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 16:14:02 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 16:14:02 INFO - 'PROGRAMW6432': 'C:\\Program Files', 16:14:02 INFO - 'PROMPT': '$P$G', 16:14:02 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 16:14:02 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 16:14:02 INFO - 'PUBLIC': 'C:\\Users\\Public', 16:14:02 INFO - 'PWD': 'C:\\slave\\test', 16:14:02 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 16:14:02 INFO - 'SLAVEDIR': 'C:\\slave\\', 16:14:02 INFO - 'SYSTEMDRIVE': 'C:', 16:14:02 INFO - 'SYSTEMROOT': 'C:\\windows', 16:14:02 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:14:02 INFO - 'TEST1': 'testie', 16:14:02 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:14:02 INFO - 'USERDOMAIN': 'T-W864-IX-175', 16:14:02 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-175', 16:14:02 INFO - 'USERNAME': 'cltbld', 16:14:02 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-175', 16:14:02 INFO - 'WINDIR': 'C:\\windows', 16:14:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 16:14:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:02 INFO - Downloading/unpacking jsonschema==2.5.1 16:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:14:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:03 INFO - Downloading functools32-3.2.3-2.tar.gz 16:14:03 INFO - Running setup.py (path:C:\slave\test\build\venv\build\functools32\setup.py) egg_info for package functools32 16:14:03 INFO - warning: no files found matching '*.txt' 16:14:03 INFO - no previously-included directories found matching 'build' 16:14:03 INFO - no previously-included directories found matching 'dist' 16:14:03 INFO - no previously-included directories found matching '.git*' 16:14:03 INFO - Installing collected packages: jsonschema, functools32 16:14:04 INFO - Running setup.py install for functools32 16:14:04 INFO - warning: no files found matching '*.txt' 16:14:04 INFO - no previously-included directories found matching 'build' 16:14:04 INFO - no previously-included directories found matching 'dist' 16:14:04 INFO - no previously-included directories found matching '.git*' 16:14:04 INFO - Successfully installed jsonschema functools32 16:14:04 INFO - Cleaning up... 16:14:04 INFO - Return code: 0 16:14:04 INFO - Installing functools32==3.2.3-2 into virtualenv C:\slave\test\build/venv 16:14:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:04 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x023DC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02483E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0258E958>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024CAE90>, '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 0x01DDA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028AD520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-175', 'USERDOMAIN': 'T-W864-IX-175', '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-175', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-175\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-175', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-175', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-175', '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-175\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 16:14:04 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in C:\slave\test\build 16:14:04 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:14:04 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 16:14:04 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-175\\AppData\\Roaming', 16:14:04 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 16:14:04 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 16:14:04 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 16:14:04 INFO - 'COMPUTERNAME': 'T-W864-IX-175', 16:14:04 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 16:14:04 INFO - 'DCLOCATION': 'SCL3', 16:14:04 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 16:14:04 INFO - 'FP_NO_HOST_CHECK': 'NO', 16:14:04 INFO - 'HOMEDRIVE': 'C:', 16:14:04 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-175', 16:14:04 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 16:14:04 INFO - 'KTS_VERSION': '1.19c', 16:14:04 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-175\\AppData\\Local', 16:14:04 INFO - 'LOGONSERVER': '\\\\T-W864-IX-175', 16:14:04 INFO - 'MONDIR': 'C:\\Monitor_config\\', 16:14:04 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 16:14:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:04 INFO - 'MOZ_NO_REMOTE': '1', 16:14:04 INFO - 'NO_EM_RESTART': '1', 16:14:04 INFO - 'NUMBER_OF_PROCESSORS': '8', 16:14:04 INFO - 'OS': 'Windows_NT', 16:14:04 INFO - 'OURDRIVE': 'C:', 16:14:04 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 16:14:04 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 16:14:04 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 16:14:04 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 16:14:04 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 16:14:04 INFO - 'PROCESSOR_LEVEL': '6', 16:14:04 INFO - 'PROCESSOR_REVISION': '1e05', 16:14:04 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 16:14:04 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 16:14:04 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 16:14:04 INFO - 'PROGRAMW6432': 'C:\\Program Files', 16:14:04 INFO - 'PROMPT': '$P$G', 16:14:04 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 16:14:04 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 16:14:04 INFO - 'PUBLIC': 'C:\\Users\\Public', 16:14:04 INFO - 'PWD': 'C:\\slave\\test', 16:14:04 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 16:14:04 INFO - 'SLAVEDIR': 'C:\\slave\\', 16:14:04 INFO - 'SYSTEMDRIVE': 'C:', 16:14:04 INFO - 'SYSTEMROOT': 'C:\\windows', 16:14:04 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:14:04 INFO - 'TEST1': 'testie', 16:14:04 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:14:04 INFO - 'USERDOMAIN': 'T-W864-IX-175', 16:14:04 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-175', 16:14:04 INFO - 'USERNAME': 'cltbld', 16:14:04 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-175', 16:14:04 INFO - 'WINDIR': 'C:\\windows', 16:14:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 16:14:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in c:\slave\test\build\venv\lib\site-packages 16:14:05 INFO - Cleaning up... 16:14:05 INFO - Return code: 0 16:14:05 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv 16:14:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:05 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 0x023DC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02483E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0258E958>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024CAE90>, '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 0x01DDA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028AD520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-175', 'USERDOMAIN': 'T-W864-IX-175', '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-175', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-175\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-175', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-175', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-175', '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-175\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 16:14:05 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in C:\slave\test\build 16:14:05 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:14:05 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 16:14:05 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-175\\AppData\\Roaming', 16:14:05 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 16:14:05 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 16:14:05 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 16:14:05 INFO - 'COMPUTERNAME': 'T-W864-IX-175', 16:14:05 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 16:14:05 INFO - 'DCLOCATION': 'SCL3', 16:14:05 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 16:14:05 INFO - 'FP_NO_HOST_CHECK': 'NO', 16:14:05 INFO - 'HOMEDRIVE': 'C:', 16:14:05 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-175', 16:14:05 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 16:14:05 INFO - 'KTS_VERSION': '1.19c', 16:14:05 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-175\\AppData\\Local', 16:14:05 INFO - 'LOGONSERVER': '\\\\T-W864-IX-175', 16:14:05 INFO - 'MONDIR': 'C:\\Monitor_config\\', 16:14:05 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 16:14:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:05 INFO - 'MOZ_NO_REMOTE': '1', 16:14:05 INFO - 'NO_EM_RESTART': '1', 16:14:05 INFO - 'NUMBER_OF_PROCESSORS': '8', 16:14:05 INFO - 'OS': 'Windows_NT', 16:14:05 INFO - 'OURDRIVE': 'C:', 16:14:05 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 16:14:05 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 16:14:05 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 16:14:05 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 16:14:05 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 16:14:05 INFO - 'PROCESSOR_LEVEL': '6', 16:14:05 INFO - 'PROCESSOR_REVISION': '1e05', 16:14:05 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 16:14:05 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 16:14:05 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 16:14:05 INFO - 'PROGRAMW6432': 'C:\\Program Files', 16:14:05 INFO - 'PROMPT': '$P$G', 16:14:05 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 16:14:05 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 16:14:05 INFO - 'PUBLIC': 'C:\\Users\\Public', 16:14:05 INFO - 'PWD': 'C:\\slave\\test', 16:14:05 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 16:14:05 INFO - 'SLAVEDIR': 'C:\\slave\\', 16:14:05 INFO - 'SYSTEMDRIVE': 'C:', 16:14:05 INFO - 'SYSTEMROOT': 'C:\\windows', 16:14:05 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:14:05 INFO - 'TEST1': 'testie', 16:14:05 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:14:05 INFO - 'USERDOMAIN': 'T-W864-IX-175', 16:14:05 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-175', 16:14:05 INFO - 'USERNAME': 'cltbld', 16:14:05 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-175', 16:14:05 INFO - 'WINDIR': 'C:\\windows', 16:14:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 16:14:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:05 INFO - Downloading/unpacking blobuploader==1.2.4 16:14: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 16:14: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 16:14:06 INFO - Downloading blobuploader-1.2.4.tar.gz 16:14:06 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader 16:14:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:06 INFO - Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests 16:14:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:07 INFO - Downloading docopt-0.6.1.tar.gz 16:14:07 INFO - Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt 16:14:07 INFO - Installing collected packages: blobuploader, requests, docopt 16:14:07 INFO - Running setup.py install for blobuploader 16:14:07 INFO - Running setup.py install for requests 16:14:07 INFO - Running setup.py install for docopt 16:14:08 INFO - Successfully installed blobuploader requests docopt 16:14:08 INFO - Cleaning up... 16:14:09 INFO - Return code: 0 16:14:09 INFO - Installing None into virtualenv C:\slave\test\build/venv 16:14:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:09 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 0x023DC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02483E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0258E958>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024CAE90>, '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 0x01DDA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028AD520>, '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-175', 'USERDOMAIN': 'T-W864-IX-175', '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-175', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-175\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-175', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-175', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-175', '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-175\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 16:14:09 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--no-deps', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in C:\slave\test\build\tests\config 16:14:09 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --no-deps --timeout 120 -r C:\slave\test\build\tests\config\mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:14:09 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 16:14:09 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-175\\AppData\\Roaming', 16:14:09 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 16:14:09 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 16:14:09 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 16:14:09 INFO - 'COMPUTERNAME': 'T-W864-IX-175', 16:14:09 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 16:14:09 INFO - 'DCLOCATION': 'SCL3', 16:14:09 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 16:14:09 INFO - 'FP_NO_HOST_CHECK': 'NO', 16:14:09 INFO - 'HOMEDRIVE': 'C:', 16:14:09 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-175', 16:14:09 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 16:14:09 INFO - 'KTS_VERSION': '1.19c', 16:14:09 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-175\\AppData\\Local', 16:14:09 INFO - 'LOGONSERVER': '\\\\T-W864-IX-175', 16:14:09 INFO - 'MONDIR': 'C:\\Monitor_config\\', 16:14:09 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 16:14:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:09 INFO - 'MOZ_NO_REMOTE': '1', 16:14:09 INFO - 'NO_EM_RESTART': '1', 16:14:09 INFO - 'NUMBER_OF_PROCESSORS': '8', 16:14:09 INFO - 'OS': 'Windows_NT', 16:14:09 INFO - 'OURDRIVE': 'C:', 16:14:09 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 16:14:09 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 16:14:09 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 16:14:09 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 16:14:09 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 16:14:09 INFO - 'PROCESSOR_LEVEL': '6', 16:14:09 INFO - 'PROCESSOR_REVISION': '1e05', 16:14:09 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 16:14:09 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 16:14:09 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 16:14:09 INFO - 'PROGRAMW6432': 'C:\\Program Files', 16:14:09 INFO - 'PROMPT': '$P$G', 16:14:09 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 16:14:09 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 16:14:09 INFO - 'PUBLIC': 'C:\\Users\\Public', 16:14:09 INFO - 'PWD': 'C:\\slave\\test', 16:14:09 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 16:14:09 INFO - 'SLAVEDIR': 'C:\\slave\\', 16:14:09 INFO - 'SYSTEMDRIVE': 'C:', 16:14:09 INFO - 'SYSTEMROOT': 'C:\\windows', 16:14:09 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:14:09 INFO - 'TEST1': 'testie', 16:14:09 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:14:09 INFO - 'USERDOMAIN': 'T-W864-IX-175', 16:14:09 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-175', 16:14:09 INFO - 'USERNAME': 'cltbld', 16:14:09 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-175', 16:14:09 INFO - 'WINDIR': 'C:\\windows', 16:14:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 16:14:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:09 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 16:14:09 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-6aggxl-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 16:14:09 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 16:14:09 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-perazo-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 16:14:09 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 16:14:09 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qmgse2-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 16:14:09 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 16:14:09 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-yxrwpw-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 16:14:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 16:14:10 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-iblyvx-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 16:14:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 16:14:10 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-0l6nfp-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 16:14:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 16:14:10 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-yhdaws-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 16:14:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 16:14:10 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-71wmdv-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 16:14:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 16:14:10 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qmzxyl-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 16:14:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 16:14:10 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ax4xgi-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 16:14:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 16:14:10 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-erf6ie-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 16:14:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 16:14:10 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-epfkyx-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 16:14:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 16:14:10 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-itfahb-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 16:14:11 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 16:14:11 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-6tgubn-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 16:14:11 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 16:14:11 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qokrpm-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 16:14:11 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 16:14:11 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-tqjb4a-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 16:14:11 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 16:14:11 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-wi7cbu-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 16:14:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:14:11 INFO - Running setup.py install for manifestparser 16:14:11 INFO - Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts 16:14:11 INFO - Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts 16:14:12 INFO - Running setup.py install for mozcrash 16:14:12 INFO - Running setup.py install for mozdebug 16:14:12 INFO - Running setup.py install for mozdevice 16:14:12 INFO - Installing sutini-script.py script to C:\slave\test\build\venv\Scripts 16:14:12 INFO - Installing sutini.exe script to C:\slave\test\build\venv\Scripts 16:14:12 INFO - Installing dm-script.py script to C:\slave\test\build\venv\Scripts 16:14:12 INFO - Installing dm.exe script to C:\slave\test\build\venv\Scripts 16:14:13 INFO - Running setup.py install for mozfile 16:14:13 INFO - Running setup.py install for mozhttpd 16:14:13 INFO - Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts 16:14:13 INFO - Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts 16:14:14 INFO - Running setup.py install for mozinfo 16:14:14 INFO - Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts 16:14:14 INFO - Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts 16:14:14 INFO - Running setup.py install for mozInstall 16:14:14 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts 16:14:14 INFO - Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts 16:14:14 INFO - Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts 16:14:14 INFO - Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts 16:14:14 INFO - Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts 16:14:14 INFO - Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts 16:14:14 INFO - Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts 16:14:14 INFO - Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts 16:14:15 INFO - Running setup.py install for mozleak 16:14:15 INFO - Running setup.py install for mozlog 16:14:15 INFO - Installing structlog-script.py script to C:\slave\test\build\venv\Scripts 16:14:15 INFO - Installing structlog.exe script to C:\slave\test\build\venv\Scripts 16:14:16 INFO - Running setup.py install for moznetwork 16:14:16 INFO - Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts 16:14:16 INFO - Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts 16:14:16 INFO - Running setup.py install for mozprocess 16:14:17 INFO - Running setup.py install for mozprofile 16:14:17 INFO - Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts 16:14:17 INFO - Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts 16:14:17 INFO - Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts 16:14:17 INFO - Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts 16:14:17 INFO - Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts 16:14:17 INFO - Installing view-profile.exe script to C:\slave\test\build\venv\Scripts 16:14:17 INFO - Running setup.py install for mozrunner 16:14:18 INFO - Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts 16:14:18 INFO - Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts 16:14:18 INFO - Running setup.py install for mozscreenshot 16:14:18 INFO - Running setup.py install for moztest 16:14:19 INFO - Running setup.py install for mozversion 16:14:19 INFO - Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts 16:14:19 INFO - Installing mozversion.exe script to C:\slave\test\build\venv\Scripts 16:14:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:14:19 INFO - Cleaning up... 16:14:19 INFO - Return code: 0 16:14:19 INFO - Installing None into virtualenv C:\slave\test\build/venv 16:14:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:19 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 0x023DC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02483E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0258E958>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024CAE90>, '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 0x01DDA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028AD520>, '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-175', 'USERDOMAIN': 'T-W864-IX-175', '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-175', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-175\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-175', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-175', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-175', '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-175\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 16:14:19 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in C:\slave\test\build\tests\config 16:14:19 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 -r C:\slave\test\build\tests\config\mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:14:19 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 16:14:19 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-175\\AppData\\Roaming', 16:14:19 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 16:14:19 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 16:14:19 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 16:14:19 INFO - 'COMPUTERNAME': 'T-W864-IX-175', 16:14:19 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 16:14:19 INFO - 'DCLOCATION': 'SCL3', 16:14:19 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 16:14:19 INFO - 'FP_NO_HOST_CHECK': 'NO', 16:14:19 INFO - 'HOMEDRIVE': 'C:', 16:14:19 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-175', 16:14:19 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 16:14:19 INFO - 'KTS_VERSION': '1.19c', 16:14:19 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-175\\AppData\\Local', 16:14:19 INFO - 'LOGONSERVER': '\\\\T-W864-IX-175', 16:14:19 INFO - 'MONDIR': 'C:\\Monitor_config\\', 16:14:19 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 16:14:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:19 INFO - 'MOZ_NO_REMOTE': '1', 16:14:19 INFO - 'NO_EM_RESTART': '1', 16:14:19 INFO - 'NUMBER_OF_PROCESSORS': '8', 16:14:19 INFO - 'OS': 'Windows_NT', 16:14:19 INFO - 'OURDRIVE': 'C:', 16:14:19 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 16:14:19 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 16:14:19 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 16:14:19 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 16:14:19 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 16:14:19 INFO - 'PROCESSOR_LEVEL': '6', 16:14:19 INFO - 'PROCESSOR_REVISION': '1e05', 16:14:19 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 16:14:19 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 16:14:19 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 16:14:19 INFO - 'PROGRAMW6432': 'C:\\Program Files', 16:14:19 INFO - 'PROMPT': '$P$G', 16:14:19 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 16:14:19 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 16:14:19 INFO - 'PUBLIC': 'C:\\Users\\Public', 16:14:19 INFO - 'PWD': 'C:\\slave\\test', 16:14:19 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 16:14:19 INFO - 'SLAVEDIR': 'C:\\slave\\', 16:14:19 INFO - 'SYSTEMDRIVE': 'C:', 16:14:19 INFO - 'SYSTEMROOT': 'C:\\windows', 16:14:19 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:14:19 INFO - 'TEST1': 'testie', 16:14:19 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:14:19 INFO - 'USERDOMAIN': 'T-W864-IX-175', 16:14:19 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-175', 16:14:19 INFO - 'USERNAME': 'cltbld', 16:14:19 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-175', 16:14:19 INFO - 'WINDIR': 'C:\\windows', 16:14:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 16:14:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:19 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 16:14:20 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-3xvd_v-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 16:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///C:/slave/test/build/tests/mozbase/manifestparser in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 1)) 16:14:20 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 16:14:20 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qnxpp_-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 16:14:20 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)) 16:14:20 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 16:14:20 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-r1kzlk-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 16:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///C:/slave/test/build/tests/mozbase/mozdebug in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 3)) 16:14:20 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 16:14:20 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-8w6x8c-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 16:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///C:/slave/test/build/tests/mozbase/mozdevice in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4)) 16:14:20 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 16:14:20 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-de2pzt-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 16:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///C:/slave/test/build/tests/mozbase/mozfile in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 5)) 16:14:20 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 16:14:20 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-yjvovp-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 16:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///C:/slave/test/build/tests/mozbase/mozhttpd in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 6)) 16:14:20 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 16:14:20 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-iezwdc-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 16:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///C:/slave/test/build/tests/mozbase/mozinfo in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 7)) 16:14:20 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 16:14:20 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-dlowhx-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 16:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///C:/slave/test/build/tests/mozbase/mozinstall in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 8)) 16:14:20 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 16:14:20 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-cy8sie-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 16:14:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///C:/slave/test/build/tests/mozbase/mozleak in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 9)) 16:14:21 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 16:14:21 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-_vhypz-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 16:14:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///C:/slave/test/build/tests/mozbase/mozlog in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10)) 16:14:21 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 16:14:21 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-btignv-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 16:14:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///C:/slave/test/build/tests/mozbase/moznetwork in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 11)) 16:14:21 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 16:14:21 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-vwf8nd-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 16:14:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///C:/slave/test/build/tests/mozbase/mozprocess in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 12)) 16:14:21 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 16:14:21 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-sgif0o-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 16:14:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///C:/slave/test/build/tests/mozbase/mozprofile in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 13)) 16:14:21 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 16:14:21 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xrwxgg-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 16:14:21 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)) 16:14:21 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 16:14:21 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-usrymf-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 16:14:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///C:/slave/test/build/tests/mozbase/mozscreenshot in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 15)) 16:14:21 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 16:14:21 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jyznay-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 16:14:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///C:/slave/test/build/tests/mozbase/moztest in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 16)) 16:14:21 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 16:14:21 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-yoaov9-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 16:14:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///C:/slave/test/build/tests/mozbase/mozversion in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 17)) 16:14:22 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)) 16:14:22 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)) 16:14:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in c:\slave\test\build\venv\lib\site-packages (from mozdebug==0.1->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 3)) 16:14:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test\build\venv\lib\site-packages (from mozdevice==0.48->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4)) 16:14:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in c:\slave\test\build\venv\lib\site-packages (from mozdevice==0.48->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4)) 16:14:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10)) 16:14:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:23 INFO - Downloading blessings-1.6.tar.gz 16:14:23 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings 16:14:23 INFO - Installing collected packages: blessings 16:14:23 INFO - Running setup.py install for blessings 16:14:23 INFO - Successfully installed blessings 16:14:23 INFO - Cleaning up... 16:14:26 INFO - Return code: 0 16:14:26 INFO - Done creating virtualenv C:\slave\test\build/venv. 16:14:26 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 16:14:26 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 16:14:26 INFO - Reading from file tmpfile_stdout 16:14:26 INFO - Using _rmtree_windows ... 16:14:26 INFO - Using _rmtree_windows ... 16:14:26 INFO - Current package versions: 16:14:26 INFO - blessings == 1.6 16:14:26 INFO - blobuploader == 1.2.4 16:14:26 INFO - docopt == 0.6.1 16:14:26 INFO - functools32 == 3.2.3-2 16:14:26 INFO - jsonschema == 2.5.1 16:14:26 INFO - manifestparser == 1.1 16:14:26 INFO - mozInstall == 1.12 16:14:26 INFO - mozcrash == 0.17 16:14:26 INFO - mozdebug == 0.1 16:14:26 INFO - mozdevice == 0.48 16:14:26 INFO - mozfile == 1.2 16:14:26 INFO - mozhttpd == 0.7 16:14:26 INFO - mozinfo == 0.9 16:14:26 INFO - mozleak == 0.1 16:14:26 INFO - mozlog == 3.4 16:14:26 INFO - moznetwork == 0.27 16:14:26 INFO - mozprocess == 0.23 16:14:26 INFO - mozprofile == 0.28 16:14:26 INFO - mozrunner == 6.12 16:14:26 INFO - mozscreenshot == 0.1 16:14:26 INFO - mozsystemmonitor == 0.3 16:14:26 INFO - moztest == 0.7 16:14:26 INFO - mozversion == 1.4 16:14:26 INFO - psutil == 3.1.1 16:14:26 INFO - requests == 1.2.3 16:14:26 INFO - Installing None into virtualenv C:\slave\test\build/venv 16:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:26 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 0x023DC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02483E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0258E958>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024CAE90>, '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 0x01DDA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028AD520>, '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-175', 'USERDOMAIN': 'T-W864-IX-175', '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-175', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-175\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-175', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-175', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-175', '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-175\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 16:14:26 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\talos\\requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in C:\slave\test\build\tests\talos 16:14:26 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 -r C:\slave\test\build\tests\talos\requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:14:26 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 16:14:26 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-175\\AppData\\Roaming', 16:14:26 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 16:14:26 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 16:14:26 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 16:14:26 INFO - 'COMPUTERNAME': 'T-W864-IX-175', 16:14:26 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 16:14:26 INFO - 'DCLOCATION': 'SCL3', 16:14:26 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 16:14:26 INFO - 'FP_NO_HOST_CHECK': 'NO', 16:14:26 INFO - 'HOMEDRIVE': 'C:', 16:14:26 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-175', 16:14:26 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 16:14:26 INFO - 'KTS_VERSION': '1.19c', 16:14:26 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-175\\AppData\\Local', 16:14:26 INFO - 'LOGONSERVER': '\\\\T-W864-IX-175', 16:14:26 INFO - 'MONDIR': 'C:\\Monitor_config\\', 16:14:26 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 16:14:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:26 INFO - 'MOZ_NO_REMOTE': '1', 16:14:26 INFO - 'NO_EM_RESTART': '1', 16:14:26 INFO - 'NUMBER_OF_PROCESSORS': '8', 16:14:26 INFO - 'OS': 'Windows_NT', 16:14:26 INFO - 'OURDRIVE': 'C:', 16:14:26 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 16:14:26 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 16:14:26 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 16:14:26 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 16:14:26 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 16:14:26 INFO - 'PROCESSOR_LEVEL': '6', 16:14:26 INFO - 'PROCESSOR_REVISION': '1e05', 16:14:26 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 16:14:26 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 16:14:26 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 16:14:26 INFO - 'PROGRAMW6432': 'C:\\Program Files', 16:14:26 INFO - 'PROMPT': '$P$G', 16:14:26 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 16:14:26 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 16:14:26 INFO - 'PUBLIC': 'C:\\Users\\Public', 16:14:26 INFO - 'PWD': 'C:\\slave\\test', 16:14:26 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 16:14:26 INFO - 'SLAVEDIR': 'C:\\slave\\', 16:14:26 INFO - 'SYSTEMDRIVE': 'C:', 16:14:26 INFO - 'SYSTEMROOT': 'C:\\windows', 16:14:26 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:14:26 INFO - 'TEST1': 'testie', 16:14:26 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:14:26 INFO - 'USERDOMAIN': 'T-W864-IX-175', 16:14:26 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-175', 16:14:26 INFO - 'USERNAME': 'cltbld', 16:14:26 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-175', 16:14:26 INFO - 'WINDIR': 'C:\\windows', 16:14:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 16:14:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 1)) 16:14:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 2)) 16:14:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 3)) 16:14:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 4)) 16:14:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 5)) 16:14:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 6)) 16:14:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 7)) 16:14:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 8)) 16:14:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 9)) 16:14:27 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in c:\slave\test\build\venv\lib\site-packages (from mozlog>=3.1->-r C:\slave\test\build\tests\talos\requirements.txt (line 1)) 16:14:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test\build\venv\lib\site-packages (from mozhttpd>=0.7->-r C:\slave\test\build\tests\talos\requirements.txt (line 4)) 16:14:27 INFO - Cleaning up... 16:14:27 INFO - Return code: 0 16:14:27 INFO - Installing jsonschema into virtualenv C:\slave\test\build/venv 16:14:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:27 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 0x023DC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02483E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0258E958>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024CAE90>, '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 0x01DDA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028AD520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-175', 'USERDOMAIN': 'T-W864-IX-175', '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-175', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-175\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-175', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-175', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-175', '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-175\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 16:14:27 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in C:\slave\test\build 16:14:27 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:14:27 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 16:14:27 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-175\\AppData\\Roaming', 16:14:27 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 16:14:27 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 16:14:27 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 16:14:27 INFO - 'COMPUTERNAME': 'T-W864-IX-175', 16:14:27 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 16:14:27 INFO - 'DCLOCATION': 'SCL3', 16:14:27 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 16:14:27 INFO - 'FP_NO_HOST_CHECK': 'NO', 16:14:27 INFO - 'HOMEDRIVE': 'C:', 16:14:27 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-175', 16:14:27 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 16:14:27 INFO - 'KTS_VERSION': '1.19c', 16:14:27 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-175\\AppData\\Local', 16:14:27 INFO - 'LOGONSERVER': '\\\\T-W864-IX-175', 16:14:27 INFO - 'MONDIR': 'C:\\Monitor_config\\', 16:14:27 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 16:14:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:27 INFO - 'MOZ_NO_REMOTE': '1', 16:14:27 INFO - 'NO_EM_RESTART': '1', 16:14:27 INFO - 'NUMBER_OF_PROCESSORS': '8', 16:14:27 INFO - 'OS': 'Windows_NT', 16:14:27 INFO - 'OURDRIVE': 'C:', 16:14:27 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 16:14:27 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 16:14:27 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 16:14:27 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 16:14:27 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 16:14:27 INFO - 'PROCESSOR_LEVEL': '6', 16:14:27 INFO - 'PROCESSOR_REVISION': '1e05', 16:14:27 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 16:14:27 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 16:14:27 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 16:14:27 INFO - 'PROGRAMW6432': 'C:\\Program Files', 16:14:27 INFO - 'PROMPT': '$P$G', 16:14:27 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 16:14:27 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 16:14:27 INFO - 'PUBLIC': 'C:\\Users\\Public', 16:14:27 INFO - 'PWD': 'C:\\slave\\test', 16:14:27 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 16:14:27 INFO - 'SLAVEDIR': 'C:\\slave\\', 16:14:27 INFO - 'SYSTEMDRIVE': 'C:', 16:14:27 INFO - 'SYSTEMROOT': 'C:\\windows', 16:14:27 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:14:27 INFO - 'TEST1': 'testie', 16:14:27 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:14:27 INFO - 'USERDOMAIN': 'T-W864-IX-175', 16:14:27 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-175', 16:14:27 INFO - 'USERNAME': 'cltbld', 16:14:27 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-175', 16:14:27 INFO - 'WINDIR': 'C:\\windows', 16:14:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 16:14:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in c:\slave\test\build\venv\lib\site-packages 16:14:27 INFO - Cleaning up... 16:14:27 INFO - Return code: 0 16:14:27 INFO - Running post-action listener: _resource_record_post_action 16:14:27 INFO - Running post-action listener: _start_resource_monitoring 16:14:27 INFO - Starting resource monitoring. 16:14:27 INFO - [mozharness: 2016-10-27 23:14:27.758000Z] Finished create-virtualenv step (success) 16:14:27 INFO - [mozharness: 2016-10-27 23:14:27.758000Z] Running install step. 16:14:27 INFO - Running pre-action listener: _resource_record_pre_action 16:14:27 INFO - Running main action method: install 16:14:27 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 16:14:27 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 16:14:28 INFO - Reading from file tmpfile_stdout 16:14:28 INFO - Using _rmtree_windows ... 16:14:28 INFO - Using _rmtree_windows ... 16:14:28 INFO - Detecting whether we're running mozinstall >=1.0... 16:14:28 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h'] 16:14:28 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h 16:14:28 INFO - Reading from file tmpfile_stdout 16:14:28 INFO - Output received: 16:14:28 INFO - Usage: mozinstall-script.py [options] installer 16:14:28 INFO - Options: 16:14:28 INFO - -h, --help show this help message and exit 16:14:28 INFO - -d DEST, --destination=DEST 16:14:28 INFO - Directory to install application into. [default: 16:14:28 INFO - "C:\slave\test"] 16:14:28 INFO - --app=APP Application being installed. [default: firefox] 16:14:28 INFO - Using _rmtree_windows ... 16:14:28 INFO - Using _rmtree_windows ... 16:14:28 INFO - mkdir: C:\slave\test\build\application 16:14:28 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', 'C:\\slave\\test\\build\\firefox-52.0a1.en-US.win64.zip', '--destination', 'C:\\slave\\test\\build\\application'] 16:14:28 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py C:\slave\test\build\firefox-52.0a1.en-US.win64.zip --destination C:\slave\test\build\application ProcessManager NOT managing child processes 16:14:30 INFO - Reading from file tmpfile_stdout 16:14:30 INFO - Output received: 16:14:30 INFO - C:\slave\test\build\application\firefox\firefox.exe 16:14:30 INFO - Using _rmtree_windows ... 16:14:30 INFO - Using _rmtree_windows ... 16:14:30 INFO - Running post-action listener: _resource_record_post_action 16:14:30 INFO - [mozharness: 2016-10-27 23:14:30.594000Z] Finished install step (success) 16:14:30 INFO - [mozharness: 2016-10-27 23:14:30.594000Z] Running run-tests step. 16:14:30 INFO - Running pre-action listener: _resource_record_pre_action 16:14:30 INFO - Running main action method: run_tests 16:14:30 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version'] 16:14:30 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version 16:14:30 INFO - Python 2.7.3 16:14:30 INFO - Return code: 0 16:14:30 INFO - grabbing minidump binary from tooltool 16:14:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:30 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 0x024CAE90>, '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 0x01DDA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028AD520>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1 16:14:30 INFO - Running command: ['c:/mozilla-build/python27/python.exe', 'C:/mozilla-build/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', 'c:\\builds\\relengapi.tok', 'fetch', '-m', 'C:\\slave\\test\\build\\tests\\config/tooltool-manifests/win32/releng.manifest', '-o'] in C:\slave\test\build 16:14:30 INFO - Copy/paste: c:/mozilla-build/python27/python.exe C:/mozilla-build/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file c:\builds\relengapi.tok fetch -m C:\slave\test\build\tests\config/tooltool-manifests/win32/releng.manifest -o 16:14:30 INFO - Calling ['c:/mozilla-build/python27/python.exe', 'C:/mozilla-build/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', 'c:\\builds\\relengapi.tok', 'fetch', '-m', 'C:\\slave\\test\\build\\tests\\config/tooltool-manifests/win32/releng.manifest', '-o'] with output_timeout 600 ProcessManager UNABLE to use job objects to manage child processes 16:14:30 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 16:14:32 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmpckdwrd 16:14:32 INFO - INFO - File integrity verified, renaming tmpckdwrd to win32-minidump_stackwalk.exe 16:14:32 INFO - Return code: 0 16:14:32 INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755 16:14:32 INFO - mkdir: C:\slave\test\build\blobber_upload_dir 16:14:32 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir 16:14:32 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe 16:14:32 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir 16:14:32 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/Zy-ftQv2Tfqn5pcBwG1k4g/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-175', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs_errorsummary.log', '--log-raw=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs_raw.log'] in C:\slave\test\build 16:14:32 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/Zy-ftQv2Tfqn5pcBwG1k4g/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip --title T-W864-IX-175 --webServer localhost --log-tbpl-level=debug --log-errorsummary=C:\slave\test\build\blobber_upload_dir\dromaeojs_errorsummary.log --log-raw=C:\slave\test\build\blobber_upload_dir\dromaeojs_raw.log 16:14:32 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 16:14:32 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-175\\AppData\\Roaming', 16:14:32 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 16:14:32 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 16:14:32 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 16:14:32 INFO - 'COMPUTERNAME': 'T-W864-IX-175', 16:14:32 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 16:14:32 INFO - 'DCLOCATION': 'SCL3', 16:14:32 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 16:14:32 INFO - 'FP_NO_HOST_CHECK': 'NO', 16:14:32 INFO - 'HOMEDRIVE': 'C:', 16:14:32 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-175', 16:14:32 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 16:14:32 INFO - 'KTS_VERSION': '1.19c', 16:14:32 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-175\\AppData\\Local', 16:14:32 INFO - 'LOGONSERVER': '\\\\T-W864-IX-175', 16:14:32 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir', 16:14:32 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe', 16:14:32 INFO - 'MONDIR': 'C:\\Monitor_config\\', 16:14:32 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 16:14:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:32 INFO - 'MOZ_NO_REMOTE': '1', 16:14:32 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir', 16:14:32 INFO - 'NO_EM_RESTART': '1', 16:14:32 INFO - 'NUMBER_OF_PROCESSORS': '8', 16:14:32 INFO - 'OS': 'Windows_NT', 16:14:32 INFO - 'OURDRIVE': 'C:', 16:14:32 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 16:14:32 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 16:14:32 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 16:14:32 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 16:14:32 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 16:14:32 INFO - 'PROCESSOR_LEVEL': '6', 16:14:32 INFO - 'PROCESSOR_REVISION': '1e05', 16:14:32 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 16:14:32 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 16:14:32 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 16:14:32 INFO - 'PROGRAMW6432': 'C:\\Program Files', 16:14:32 INFO - 'PROMPT': '$P$G', 16:14:32 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 16:14:32 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 16:14:32 INFO - 'PUBLIC': 'C:\\Users\\Public', 16:14:32 INFO - 'PWD': 'C:\\slave\\test', 16:14:32 INFO - 'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos', 16:14:32 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 16:14:32 INFO - 'SLAVEDIR': 'C:\\slave\\', 16:14:32 INFO - 'SYSTEMDRIVE': 'C:', 16:14:32 INFO - 'SYSTEMROOT': 'C:\\windows', 16:14:32 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:14:32 INFO - 'TEST1': 'testie', 16:14:32 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:14:32 INFO - 'USERDOMAIN': 'T-W864-IX-175', 16:14:32 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-175', 16:14:32 INFO - 'USERNAME': 'cltbld', 16:14:32 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-175', 16:14:32 INFO - 'WINDIR': 'C:\\windows', 16:14:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 16:14:32 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/Zy-ftQv2Tfqn5pcBwG1k4g/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-175', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs_errorsummary.log', '--log-raw=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs_raw.log'] with output_timeout 3600 ProcessManager NOT managing child processes ProcessManager UNABLE to use job objects to manage child processes 16:14:33 INFO - mozversion application_buildid: 20161027123009 16:14:33 INFO - mozversion application_changeset: 23f92954349863643543975a05ca8f229dfcbf23 16:14:33 INFO - mozversion application_display_name: Nightly 16:14:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:14:33 INFO - mozversion application_name: Firefox 16:14:33 INFO - mozversion application_remotingname: firefox 16:14:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 16:14:33 INFO - mozversion application_vendor: Mozilla 16:14:33 INFO - mozversion application_version: 52.0a1 16:14:33 INFO - mozversion platform_buildid: 20161027123009 16:14:33 INFO - mozversion platform_changeset: 23f92954349863643543975a05ca8f229dfcbf23 16:14:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 16:14:33 INFO - mozversion platform_version: 52.0a1 16:14:33 INFO - using testdate: 1477610073 16:14:33 INFO - actual date: 1477610073 16:14:33 INFO - starting webserver on 'localhost:49275' 16:14:33 INFO - SUITE-START | Running 2 tests 16:14:33 INFO - TEST-START | dromaeo_css 16:14:33 INFO - operating with platform_type : w8_ 16:14:33 INFO - Initialising browser for dromaeo_css test... 16:14:33 INFO - TEST-INFO | started process 1012 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpyvx8eh\profile http://localhost:49275/getInfo.html) 16:14:41 INFO - PROCESS | 1012 | __metrics Screen width/height:1600/1200 16:14:41 INFO - PROCESS | 1012 | colorDepth:24 16:14:41 INFO - PROCESS | 1012 | Browser inner width/height: 1010/674 16:14:41 INFO - PROCESS | 1012 | __metrics 16:14:42 INFO - PROCESS | 1012 | 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" 16:14:42 INFO - PROCESS | 1012 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:14:44 INFO - TEST-INFO | 1012: exit 0 16:14:44 INFO - Browser initialized. 16:14:44 INFO - Running cycle 1/1 for dromaeo_css test... 16:14:44 INFO - TEST-INFO | started process 2936 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpyvx8eh\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:14:44 INFO - PROCESS | 2936 | [GFX1-]: Invalid size in UpdateRenderTarget Size(124,0), 0 16:14:55 INFO - PROCESS | 2936 | RSS: Main: 158199808 16:14:55 INFO - PROCESS | 2936 | 16:15:46 INFO - PROCESS | 2936 | 1477610146567 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:17:57 INFO - PROCESS | 2936 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 16:17:59 INFO - PROCESS | 2936 | RSS: Main: 227594240 16:17:59 INFO - PROCESS | 2936 | 16:21:01 INFO - PROCESS | 2936 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 16:21:02 INFO - PROCESS | 2936 | RSS: Main: 220508160 16:21:02 INFO - PROCESS | 2936 | 16:24:04 INFO - PROCESS | 2936 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 16:24:05 INFO - PROCESS | 2936 | RSS: Main: 170569728 16:24:05 INFO - PROCESS | 2936 | 16:27:07 INFO - PROCESS | 2936 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 16:27:07 INFO - PROCESS | 2936 | RSS: Main: 172244992 16:27:07 INFO - PROCESS | 2936 | 16:30:10 INFO - PROCESS | 2936 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 16:30:11 INFO - PROCESS | 2936 | RSS: Main: 163508224 16:30:11 INFO - PROCESS | 2936 | 16:33:13 INFO - PROCESS | 2936 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 16:33:14 INFO - PROCESS | 2936 | RSS: Main: 251408384 16:33:14 INFO - PROCESS | 2936 | 16:33:14 INFO - PROCESS | 2936 | __start_tp_report 16:33:14 INFO - PROCESS | 2936 | _x_x_mozilla_page_load 16:33:14 INFO - PROCESS | 2936 | _x_x_mozilla_page_load_details 16:33:14 INFO - PROCESS | 2936 | |i|pagename|runs| 16:33:14 INFO - PROCESS | 2936 | |0;dojo.html;2775.9583606245906;2805.5931889875956;2842.4173044525874;2844.033028770219;2848.1028476030037;5030.270610761438;5044.596432285413;5065.341505604266;5082.593392528589;5140.871478213042;5067.0879241736475;5116.616253780972;5140.5373516383515;5140.8971820563565;5226.033183860979;4549.590536851682;4582.747948862811;4593.517680643535;4600.6549508786975;4663.370444989934;4642.466116396607;4678.672492925497;4709.64677649176;4710.057988402316;4731.952680473186;315.43704632866326;4726.527347265281;4732.503087175849;4771.99788044511;4773.11697335994;4558.58972692456;4610.838620648261;4638.281066434708;4646.767661616939;4649.674522783406;4415.20526305265;4527.796249168795;4578.51925547816;4590.495045544987;4647.140279048387;5052.0906236877345;5094.261332106861;5114.64197506171;5121.718305493197;5216.582673386158;5472.042392581282;5513.117901135799;5531.944680553183;5563.972180139114;5594.860128496779;5535.640183388107;5547.694876781776;5552.11166213408;5566.610337276392;5572.136318870582;5134.845954621367;5135.255387968724;5139.717315547643;5140.974295128575;5188.377394712621;5588.748506317225;5616.5787565932715;5630.183623374588;5667.433256674382;5676.063449530864;5373.919391209135;5378.9462105379225;5384.353877534642;5418.539424148991;5448.264484294648;5559.9444005560235;5562.694051827108;5574.665520068809;5584.692841893735;5584.860378490489;5409.215663728737;5433.212184233264;5465.863353416196;5487.368952570426;5598.300212473441;5493.340799104133;5495.175723641406;5525.364583072998;5529.834104976857;5608.383077861432;3817.1602247505502;3826.445165450994;3832.0419895026243;3871.903202419962;3879.0884142226555;3283;3289.983550082234;3306.5866766654167;3310.851011704479;3344.39800835847;5139.434662187156;5159.226116082617;5203.557697595671;5208.401033881152;5223.947760522422;5562.527185189304;5576.163575463713;5577.525910297589;5580.497755202051;5638.379778224392;5071.239314102914;5158.948410515922;5179.352580927384;5182.067227899014;5244.868878277997;4449.844255451108;4472.753998530112;4474.485434175046;4481.551844815493;4506.301523263899;5674.460926212003;5674.460926212003;5680.573956953162;5709.172170035322;5740.856478588069;5567.77728890856;5605.439456054362;5606.85982850432;5614.803481878114;5617.269754931833;5607.859803504945;5689.715514224355;5707.400722924033;5709.429057094423;5716.199732037601;5461.0716178248995;5471;5521.254630624814;5533.5849811263515;5577.107662773937;5598.720063996865;5611.971940140274;5664.320281566238;5668.319801623831;5670.149477578396;5419.512243898068;5464.91802622953;5466.808661696821;5474.945250547444;5478.150886612581;5303.549198318032;5345.973270133624;5388.46115388458;5440.619156659154;5503.036968530571;5303.36359636846;5327.174287985368;5343.759530821045;5346.1713434417725;5426.891462170655;5307.6284660073425;5373.408925018323;5390.62265641417;5397.78408863641;5411.810586629449;5268.446813084571;5291.365036195682;5317.202419637086;5320.334958130234;5372.570194384518 16:33:14 INFO - PROCESS | 2936 | |1;ext.html;522.7125081205337;545.7325910303953;548.558410479564;549.64547866626;553.8643032457046;29566;37866.24267514652;39210.803945980304;39416;40586.39120413189;38635.80682096585;38853;38967.41548876769;39025.804870975604;39073.21853562934;7678.5392876427595;8203.548804815748;8300.750977470685;8336.87494687577;8338.874916876252;7788.260115289067;9625.326227164102;9948.104670579647;9975.50122493876;10238.539265733023;9947.403155810638;9972.850407243897;10003.99960004001;10034.297599168061;10041.648542301022;7939.642716077733;9864.556094975744;9956;9997.750056248578;10000.649977250834;7776.222377762235;9528.190103841182;9789.070038346346;9885.555150018266;10138.138258248058;36699.816500917594;37265.44101838474;37432.43851342232;37749.433758493644;37797.811010944766;3096.3807238552154;3100.3334283129234;3156.921076973071;3188.963586834288;3504.316658251642;28312.433751325065;28781;28958.131256062352;29281.707182928323;29578;3908.4137379393032;3936.5276166859876;3956.6636835868985;3957.149212919236;4049.2711311963835;297275;297970;298148.99999999785;298550;299458;49057;49450;49460.50539494631;49477.50522494729;49534.50465495299;30650.62072206756;31623;31753.682463175533;32817.50773738396;50512.74743626258;14339.283035848375;14352.210628415538;14571.854281457261;14581.489647862274;14589.85410145885;10291.43397113151;10553.208509361828;10904.127669786398;11072.778544429066;11107.166962477846;15979.280932357839;16913.830861691473;16920.661586768194;16947.152642367833;16950;6403.64779937108;6461.709223084878;6470.935290647033;6511.641859697667;6513.609183449008;769.1654554808096;852.3436953545859;864.822711344173;887.9200871921558;927.8376284150247;27019.864900675762;27076.323091922466;27104;27500;27837.443251134864;873.5763154869883;886.499127992682;897.0446474504631;912.8493798523169;946.1248345280588;13964.790528142086;14144.929275353557;14191.890919269055;14443.711125777425;14478.058926169975;438043;439985;441501.3774793381;442823;445371;46497;46944.295835562494;46973;46999.765001174776;47006.76496617495;1072.978540429187;1087.1954753482366;1138.9658310250707;1143.9942800285946;1162.5756598841363;26057.218283451526;27796.44407111887;27953.20178611471;28055.158345249674;28422.147335579964;40991.385129222486;41675.7916210417;41781.58218417777;41789;42699.7865010673;343563;347844;347991;348555;349583;24121.793910304765;25263.36841578975;25413.237602871945;25968.610470842574;26008.21975340743;40388.59611403848;40460.79769601133;40648.902664599365;40800.18399631931;41124.38313425241;34381.48427773635;34525.30949380948;34778.652213477544;35425.645743542234;35456.290874181854;34443.655563444045;34596.481052783725;34810.82594587112;34945.30109397747;34959.65040349564;32817.34365312633;32953.83523082369;33413.49879751854;33669.82155624541;33683.66316336805;30786.69213307838;31794.68205317917;31825.204369890937;32264.35471290608;32357.220352880817;23699.526009480058;23892.163774267818;24082.51834963256;24396.6340504889;24397.26808195757 16:33:14 INFO - PROCESS | 2936 | |2;jquery.html;314.5831772900907;326.5917602996255;340.76316959713;342.68644190565635;360.8484436536654;12928.806067908978;13982.580522584314;16053.999999999985;16396.83603163968;16646.001239925583;16230.756538651929;16264.43074492393;16323.347066117341;16362.754558681629;16542.172891355443;4191.622753952143;4994.1260279451135;5145.739293873006;5222.8694282642855;5229.790808367661;5180.36818402204;5306.495882891119;5311.521963023327;5313.814016509423;5325.653832500894;5002.624803139761;5260.342457192851;5280.155175171954;5289.391719952217;5395.919061214085;5157.071727089123;5272.051030814452;5295;5299.920501192485;5327.786888524454;4961.429435614915;5120.308758317617;5160.200168973815;5179.326687530634;5180.404253510819;11075.390853503053;11171.72070698239;11188.216824822266;11216.775664486746;11241.325520468798;1952.5997170579997;1977.5056235941015;2008.4777957730948;2285.748567657556;2298.6896768936313;8399.790005249917;9546.997565255617;12707.682307942283;12956;13072.542461013914;1724.6205834716468;1726.3871325679454;1739.695553278184;1758.474259110488;1838.6598479281377;68956;69879.30120698779;70317.2968270321;70876.93684594684;72886.27113728848;9367.203787678123;9388.765280868032;9441.15029647335;9466.432014079039;9622.278329125344;12544.184627999151;12551.3096779678;12560.371981401076;12569.308688022247;12698.682532936751;6665.533412661164;6668.233153187445;6782.2200446948245;6801.4898882584;6817.5909445433435;6365.2998170201245;6375.713092910737;6385.329540398284;6453.645049522322;6524.836879077966;4003.799810009488;4024.5774193709826;4048.736832105904;4092.7339722917914;4141;1522.5736793697783;1577.0931714264113;1580.1546172797728;1597.4488801363511;1644.161477646409;709.8828693265657;811.3671336357651;817.9672813087528;855.8630619101039;876.5529579914289;15923.12422816733;16195.109268990318;16489.6702065958;16570.171491425623;16939.830601694073;759.449399185597;777.8716511775607;809.2433574607643;813.4387272781762;837.7654256808104;8803.911960880308;9102.86345704815;9118.81762364749;9242.353035287466;9368.437893726263;403652;410947;411666;412953;415303;49353.75323123361;63986;76479;80941;81759.18240817635;872.5070335260557;872.8725576543536;895.6820328783189;897.8877640294963;905.0994260710635;14700.632484187554;14701.55895323142;14731.852681473476;14798.852011479747;15136.924315378352;35538.289234215685;35706.64293357033;36427.63572364242;36427.63572364242;37251.06872328105;50453.24320135127;50492.49507505025;50521.24218136804;50899.236511451614;50902;7181.856362872609;7214.927850721636;7290.125184977836;7300.634968251672;7371.438542263963;9438.38650487716;11061.723456913642;11297.774044519228;11433.885661143615;11559.826602600799;9586.651270438788;9698.321117521706;9722.270829687943;9994.800103997733;10047.949760251153;9338.95330523343;9427.15155635996;9469.289803264644;9631.759206019626;9678.693376394096;9558.330916835755;9625.278104142077;9756.512174391393;9895.158911492315;10013.749656258651;6993.2657071006815;7069.434445244471;7145.7498987537265;7193.748218812317;7201.459890508128;8670.566471676264;9461.148496635336;9822;9872.308938374244;9906 16:33:14 INFO - PROCESS | 2936 | |3;mootools.html;1136.9545218191272;1197.7843988082145;1210.3282678113644;1266.5756971414576;1486.0415032304156;6398.456131228845;6996.5452245604065;7192.208857025723;7209.495335326523;7220.169680486745;7024.157101147856;7079.893801592967;7081.645917704107;7085.964570177155;7095.645217739106;1992.6911328744068;2019.4850313170195;2019.6162729081427;2021.858469907107;2027.3613811649357;1957.109515170594;1984.3253293880077;1986.5530255692497;1994.3019943019972;1995.3814317561603;1970.4679736471144;1973.980260197401;1996.4210378990076;1999.62007218628;2000.8599398042143;1909.79947105554;1923.9711404328946;1926.3739284732378;1927.4314077347217;1927.8361339286178;1893.422506135628;1897.7627796525435;1908.5991941692262;1922.6923692209318;1935.3516571948414;6668.6332251726135;6866.588004719682;7069.575825450489;7069.575825450489;7113.573185608829;4306.461692288464;4413.757243351614;4416.55834416559;4418.536053714378;4423.093265880487;2738.5070687276284;2881.812682175652;2927.5169597016466;2930.941381172365;2941.676415594283;883.0815951410525;885.2475395913486;896.3187977137358;926.1757036237753;928.1600151862508;9731.12419882214;9795.971423000554;9824.508774561315;9836.754081148028;9854.16239619626;3721.218544105768;3789.5831458539537;3821.178446633987;3842.558105817867;3939.783311917815;7653.502522336031;7769.417293702995;7780.793976933584;7803.687852485837;7810.960945195237;4362.21480133579;4366.345048242725;4367.126574685076;4369.388285640013;4383.057642606855;3580.803055831902;3661.9267614647556;4014.9397759033636;4126.319157339006;4136.793160342031;3113.2216945763557;3166.857491412892;3226.72572831312;3229.6770322967513;3234.207619133327;983.8376667849725;984.1192133041031;993.7068564773409;996.352370958868;1004.2869562610629;606.9362716914749;709.0675761373777;728.388153950684;756.8221467955026;773.3040263762546;4380.102079073846;4471.821127154943;4579.793909274024;4628.352030715702;4652.767361631973;764.8011517005507;798.1220657276949;798.4530596541388;803.333233416263;838.6519594368269;2892.0889919675233;2926.6049083373896;2942.1026586891203;3029.6970302969967;3093.412251672175;8037.638306276232;8680.262177714965;8748.518831464331;8748.825023499621;8751.868721969175;8693.043765185825;8699.43453675509;8707.608157632922;8711.782205444788;8720.8691869622;6667.6666166691475;6854.34883686049;6876.243613202544;6987.441004719611;7004.15950085993;4392.12157568494;4399.6040356368085;4524.524924882971;4645.6051235644;4680.157571637138;7774.339181169664;8012.559309238048;8221.54781487024;8237.670493180205;8306.127856574973;7777.92222077772;7992.120866704541;8026.959865200637;8308.252257296872;8308.6676532938;6825.249222585412;6839.589624622538;6889.896651550131;6972.233054363915;7022.08712867324;6869;6986.266442023718;6992.720291188295;6996.19543752475;7005.334493223339;6267.185265915402;6273.843153921189;6459.6770161490795;6469.805905822833;6570.77002304917;6197.628142311476;6198.411150940653;6207.068939659087;6266.968665156645;6338.271098823509;5819.76720931158;5819.854503637443;5823.534117270693;5832.650040997553;5930.970345148246;3763.228538149618;3896.844126235032;3906.9218615628097;3940.9605903941742;3957.5053118360206;3938.7439816411843;3966.325724626878;3968.761874287552;3982.064214909436;3991.421243919557 16:33:14 INFO - PROCESS | 2936 | |4;prototype.html;282.8048646433962;283.842467430576;292.2124873466009;293.4732155780374;294.3729855407981;5123.897522049561;5151.201563757614;5162.92255616166;5168.992046550924;5169.560587350075;4803.543663351985;5033.54698077173;5054.696718196901;5113.571053749467;5131.307273518074;3743.1952130291984;3761.981190094046;3766.133789228479;3785.2240290740333;3805.695544356459;3779.546454425473;3811.2758575870635;3819.7899115548635;3864.7487913285686;3879.398693202544;3797.9810100949458;3809.9428508572255;3819.9809000954956;3828.808559572024;3829.770213787168;3745.45690874823;3762.9059273518105;3787.621237876218;3791.9951212928595;3815.4849095372188;3282.0810173151553;3299.835008249578;3308.93191755153;3310.543360921187;3331.6168640606397;4932.852014439537;4935.753212339405;4939.728314942677;4966.453690094087;5008.649394542384;4234.576542345741;4453;4465.508794032654;4479.955200448019;4494.235979883428;5311.865999060573;5332.973335133338;5333.906549157452;5353.732313384354;5421.674699518002;3664.2305115925687;3667.7249206309634;3675.915604896535;3689.929920323103;3695.4641576971458;5393.541548968303;5635.63368381058;5642.971785141048;5646.491815736604;5706.657600543981;3693.926121477555;3715.479832823407;3723.8138093095235;3738.6074462181623;3795.6204379562373;3782.735208535431;3788.1666033472593;3803.087259057806;3824.972764434854;3869.400242962345;4395.824167033283;4438.844640437569;4452.354408610798;4469.821207151677;4471.262241730143;5324.920126198032;5332.466753324714;5351.866203344947;5353.866153346197;5458.399576046631;1302.5310888080282;1324.0533018891538;1325.8266434205798;1326.8938484921184;1327.0975736499274;789.0452552411532;794.1185284334384;809.5385630190852;823.3824631526355;831.9625616847256;4950.8267210647455;5051.898962020739;5140.40885298188;5211.843644690665;5215.217717342429;5512.944870551323;5516.255305533701;5523.447655234444;5538.889222215533;5567.2762540870235;4966.751662416865;5159.355080614923;5171.3535808024;5195.610329225323;5223.216517522402;2905.6077429547163;2977.940441191164;2984.865681044358;2994.921828141867;3008.12764298351;5614.9157762633595;5632.831015069554;5656.91514627281;5707.657540547498;5731.713414329351;5328.626996110235;5588.524975377057;5638.210650508932;5643.379228284885;5666.858328541737;5581.939431508001;5595.160725891149;5623.100303951348;5633.436656334334;5648.63283886546;5266.077881573122;5523.447655234444;5555.2222688822785;5584.441555844383;5601.159826025966;5391.110466772939;5407.56659503233;5408.107662235687;5426.67439953604;5437.945620543744;5573.916391254215;5597.20139930035;5611.6352437091455;5701.002324593097;5736.942630573641;3642.6903713184674;3727.8508859645312;3730.4404339349317;3742.2224443389173;3744.5319335083113;5427.565794736491;5442.619016668795;5443.510084092451;5462.180672899097;5518.613697041169;5311.203319501951;5330.2804121443105;5405.378381486179;5444.8366549003595;5460.2870048367495;5124.615653825904;5318.255444237887;5342.252084708066;5354.170103633943;5363.383210930793;5278.736063196901;5279.736013199402;5293.629445938747;5297;5301.787928482818;5185.49620610034;5242.056429842665;5339.279197308314;5373;5416.7270691388285;5296.6292359536;5314.62797604164;5318.97340513295;5323.946760532345;5350.571954243574 16:33:14 INFO - PROCESS | 2936 | |5;yui.html;627.1439485102833;629.3894921925732;692.5325405351387;706.2443185791202;718.4791026505784;12499.937505312048;13140.094686270486;13217.273049982272;13302.268375239359;13773.862261377395;12518.12373133881;12565.623031309053;12691.492340306377;12706.237625742462;12721.681957951056;660.7522179182806;665.3379887012429;669.250439507752;671.7212356871917;676.952613317068;650.4958657040808;652.445421391818;652.7291174162717;669.5212922760226;669.6149713914494;677.1975209376905;679.5582871133778;679.7518905599445;707.4305184326615;707.632031343701;672.7544446277074;673.5756473421762;677.3700458573525;703.9964800175992;706.6713978000255;490.0199600798403;490.9828156014558;513.2199057432719;513.7816428018115;515.0574448758763;11874;11916.523339066427;11944.701382465508;11947;11974.401279936055;12082.15424920256;12154.088443366694;12251.632451026484;12300.384980751016;12370.690732731664;9791.412515249107;9969.950150249275;10367.963203679647;10381.273310868242;10830.241883068189;3368.4778859276853;3384.6107697614843;3418.6068602110827;3419.3674170278327;3447.6035255945385;41501.79249103765;50955.49044509581;51397.22904156441;55436.44563554353;56712.14931776027;9696.854547181798;9826.459544725109;9878.901210987799;9944.701658950244;10010.349327293849;16522.50432487027;16569;16572.17139143038;16597.419090332023;16788.32846686119;6055.364186760415;7064.399526040242;7083.787486375417;7368.410527157922;7439.628018599048;4011.4183443400543;4057.89855253621;4077.1641813428178;4150.377443383517;4151.232022075926;2578.7808036316746;2661.9068332608267;2665.18711792905;2667.573188289903;2670.6795184577977;471.66747443052566;475.8358366363599;476.4068734425662;501.3958180392618;502.1613904779028;517.6505858545466;616.6639181646013;626.6177631644694;636.1062706896818;648.2286079565303;8442;8495.192956669107;8570.614322355508;8676.956615216883;8794.864283834688;531.4127888683026;618.7584110919581;632.8576070384127;647.498188903594;648.3872740260502;3953.743006704555;4164.541900390955;4197.601227883346;4355.063661312833;4381.38660587518;68099.65950170218;69206;70580;70693.2930670697;71323.64338178276;59613.701931490934;61049.38950610526;61395.38604613897;61894.38105618976;62884.056739148946;46273.76863115663;56730.716346418005;57100.42899571034;57676;57970.68117275346;8200.38497112707;8225.629846657035;8331.916680833356;8413.621387037476;8413.789655258668;31580.684193157773;35372.21811201532;36488.81755591205;36686.44970325394;38270.80864595659;45458.54541454675;45599.31601025921;47600;48937;49350.77921493469;10945.343279403261;11128.888711112786;11245.38150401703;11274.267172633752;11606.47770850297;11826;12088.15382923187;12149.088818338483;12181.634550963485;12828.935855321037;11931.164818462972;12245.265284082983;12320.568780092653;12583.182093163916;12995.025373097245;11977.64067077989;12113.394330283274;12225.266484010988;12256.387180640753;12334.629961101182;12105.273683579013;12198.451069702061;12230.266184028987;12333.69165770827;12369.505219791108;9774;10147.949260253652;10294.279400441897;10336.948315258376;10390.493378460233;10016.198704103508;10077.788926751466;10354.04642330678;10561.52473138726;10576.629817956335 16:33:14 INFO - PROCESS | 2936 | __end_tp_report 16:33:14 INFO - PROCESS | 2936 | __start_cc_report 16:33:14 INFO - PROCESS | 2936 | _x_x_mozilla_cycle_collect,1128 16:33:14 INFO - PROCESS | 2936 | __end_cc_report 16:33:14 INFO - PROCESS | 2936 | __startTimestamp1477611194138__endTimestamp 16:33:14 INFO - PROCESS | 2936 | 16:33:14 INFO - PROCESS | 2936 | ------- Summary: start ------- 16:33:14 INFO - PROCESS | 2936 | Number of tests: 6 16:33:14 INFO - PROCESS | 2936 | 16:33:14 INFO - PROCESS | 2936 | [#0] dojo.html Cycles:165 Average:5059.02 Median:5327.17 stddev:768.60 (14.4%) stddev-sans-first:749.80 16:33:14 INFO - PROCESS | 2936 | Values: 2776.0 2805.6 2842.4 2844.0 2848.1 5030.3 5044.6 5065.3 5082.6 5140.9 5067.1 5116.6 5140.5 5140.9 5226.0 4549.6 4582.7 4593.5 4600.7 4663.4 4642.5 4678.7 4709.6 4710.1 4732.0 315.4 4726.5 4732.5 4772.0 4773.1 4558.6 4610.8 4638.3 4646.8 4649.7 4415.2 4527.8 4578.5 4590.5 4647.1 5052.1 5094.3 5114.6 5121.7 5216.6 5472.0 5513.1 5531.9 5564.0 5594.9 5535.6 5547.7 5552.1 5566.6 5572.1 5134.8 5135.3 5139.7 5141.0 5188.4 5588.7 5616.6 5630.2 5667.4 5676.1 5373.9 5378.9 5384.4 5418.5 5448.3 5559.9 5562.7 5574.7 5584.7 5584.9 5409.2 5433.2 5465.9 5487.4 5598.3 5493.3 5495.2 5525.4 5529.8 5608.4 3817.2 3826.4 3832.0 3871.9 3879.1 3283.0 3290.0 3306.6 3310.9 3344.4 5139.4 5159.2 5203.6 5208.4 5223.9 5562.5 5576.2 5577.5 5580.5 5638.4 5071.2 5158.9 5179.4 5182.1 5244.9 4449.8 4472.8 4474.5 4481.6 4506.3 5674.5 5674.5 5680.6 5709.2 5740.9 5567.8 5605.4 5606.9 5614.8 5617.3 5607.9 5689.7 5707.4 5709.4 5716.2 5461.1 5471.0 5521.3 5533.6 5577.1 5598.7 5612.0 5664.3 5668.3 5670.1 5419.5 5464.9 5466.8 5474.9 5478.2 5303.5 5346.0 5388.5 5440.6 5503.0 5303.4 5327.2 5343.8 5346.2 5426.9 5307.6 5373.4 5390.6 5397.8 5411.8 5268.4 5291.4 5317.2 5320.3 5372.6 16:33:14 INFO - PROCESS | 2936 | 16:33:14 INFO - PROCESS | 2936 | [#1] ext.html Cycles:180 Average:50093.11 Median:192264.15 stddev:97093.27 (50.5%) stddev-sans-first:97294.31 16:33:14 INFO - PROCESS | 2936 | Values: 522.7 545.7 548.6 549.6 553.9 29566.0 37866.2 39210.8 39416.0 40586.4 38635.8 38853.0 38967.4 39025.8 39073.2 7678.5 8203.5 8300.8 8336.9 8338.9 7788.3 9625.3 9948.1 9975.5 10238.5 9947.4 9972.9 10004.0 10034.3 10041.6 7939.6 9864.6 9956.0 9997.8 10000.6 7776.2 9528.2 9789.1 9885.6 10138.1 36699.8 37265.4 37432.4 37749.4 37797.8 3096.4 3100.3 3156.9 3189.0 3504.3 28312.4 28781.0 28958.1 29281.7 29578.0 3908.4 3936.5 3956.7 3957.1 4049.3 297275.0 297970.0 298149.0 298550.0 299458.0 49057.0 49450.0 49460.5 49477.5 49534.5 30650.6 31623.0 31753.7 32817.5 50512.7 14339.3 14352.2 14571.9 14581.5 14589.9 10291.4 10553.2 10904.1 11072.8 11107.2 15979.3 16913.8 16920.7 16947.2 16950.0 6403.6 6461.7 6470.9 6511.6 6513.6 769.2 852.3 864.8 887.9 927.8 27019.9 27076.3 27104.0 27500.0 27837.4 873.6 886.5 897.0 912.8 946.1 13964.8 14144.9 14191.9 14443.7 14478.1 438043.0 439985.0 441501.4 442823.0 445371.0 46497.0 46944.3 46973.0 46999.8 47006.8 1073.0 1087.2 1139.0 1144.0 1162.6 26057.2 27796.4 27953.2 28055.2 28422.1 40991.4 41675.8 41781.6 41789.0 42699.8 343563.0 347844.0 347991.0 348555.0 349583.0 24121.8 25263.4 25413.2 25968.6 26008.2 40388.6 40460.8 40648.9 40800.2 41124.4 34381.5 34525.3 34778.7 35425.6 35456.3 34443.7 34596.5 34810.8 34945.3 34959.7 32817.3 32953.8 33413.5 33669.8 33683.7 30786.7 31794.7 31825.2 32264.4 32357.2 23699.5 23892.2 24082.5 24396.6 24397.3 16:33:14 INFO - PROCESS | 2936 | 16:33:14 INFO - PROCESS | 2936 | [#2] jquery.html Cycles:180 Average:24187.97 Median:5201.64 stddev:67726.41 (1302.0%) stddev-sans-first:67892.68 16:33:14 INFO - PROCESS | 2936 | Values: 314.6 326.6 340.8 342.7 360.8 12928.8 13982.6 16054.0 16396.8 16646.0 16230.8 16264.4 16323.3 16362.8 16542.2 4191.6 4994.1 5145.7 5222.9 5229.8 5180.4 5306.5 5311.5 5313.8 5325.7 5002.6 5260.3 5280.2 5289.4 5395.9 5157.1 5272.1 5295.0 5299.9 5327.8 4961.4 5120.3 5160.2 5179.3 5180.4 11075.4 11171.7 11188.2 11216.8 11241.3 1952.6 1977.5 2008.5 2285.7 2298.7 8399.8 9547.0 12707.7 12956.0 13072.5 1724.6 1726.4 1739.7 1758.5 1838.7 68956.0 69879.3 70317.3 70876.9 72886.3 9367.2 9388.8 9441.2 9466.4 9622.3 12544.2 12551.3 12560.4 12569.3 12698.7 6665.5 6668.2 6782.2 6801.5 6817.6 6365.3 6375.7 6385.3 6453.6 6524.8 4003.8 4024.6 4048.7 4092.7 4141.0 1522.6 1577.1 1580.2 1597.4 1644.2 709.9 811.4 818.0 855.9 876.6 15923.1 16195.1 16489.7 16570.2 16939.8 759.4 777.9 809.2 813.4 837.8 8803.9 9102.9 9118.8 9242.4 9368.4 403652.0 410947.0 411666.0 412953.0 415303.0 49353.8 63986.0 76479.0 80941.0 81759.2 872.5 872.9 895.7 897.9 905.1 14700.6 14701.6 14731.9 14798.9 15136.9 35538.3 35706.6 36427.6 36427.6 37251.1 50453.2 50492.5 50521.2 50899.2 50902.0 7181.9 7214.9 7290.1 7300.6 7371.4 9438.4 11061.7 11297.8 11433.9 11559.8 9586.7 9698.3 9722.3 9994.8 10047.9 9339.0 9427.2 9469.3 9631.8 9678.7 9558.3 9625.3 9756.5 9895.2 10013.7 6993.3 7069.4 7145.7 7193.7 7201.5 8670.6 9461.1 9822.0 9872.3 9906.0 16:33:14 INFO - PROCESS | 2936 | 16:33:14 INFO - PROCESS | 2936 | [#3] mootools.html Cycles:180 Average:4675.77 Median:3268.95 stddev:2629.37 (80.4%) stddev-sans-first:2623.29 16:33:14 INFO - PROCESS | 2936 | Values: 1137.0 1197.8 1210.3 1266.6 1486.0 6398.5 6996.5 7192.2 7209.5 7220.2 7024.2 7079.9 7081.6 7086.0 7095.6 1992.7 2019.5 2019.6 2021.9 2027.4 1957.1 1984.3 1986.6 1994.3 1995.4 1970.5 1974.0 1996.4 1999.6 2000.9 1909.8 1924.0 1926.4 1927.4 1927.8 1893.4 1897.8 1908.6 1922.7 1935.4 6668.6 6866.6 7069.6 7069.6 7113.6 4306.5 4413.8 4416.6 4418.5 4423.1 2738.5 2881.8 2927.5 2930.9 2941.7 883.1 885.2 896.3 926.2 928.2 9731.1 9796.0 9824.5 9836.8 9854.2 3721.2 3789.6 3821.2 3842.6 3939.8 7653.5 7769.4 7780.8 7803.7 7811.0 4362.2 4366.3 4367.1 4369.4 4383.1 3580.8 3661.9 4014.9 4126.3 4136.8 3113.2 3166.9 3226.7 3229.7 3234.2 983.8 984.1 993.7 996.4 1004.3 606.9 709.1 728.4 756.8 773.3 4380.1 4471.8 4579.8 4628.4 4652.8 764.8 798.1 798.5 803.3 838.7 2892.1 2926.6 2942.1 3029.7 3093.4 8037.6 8680.3 8748.5 8748.8 8751.9 8693.0 8699.4 8707.6 8711.8 8720.9 6667.7 6854.3 6876.2 6987.4 7004.2 4392.1 4399.6 4524.5 4645.6 4680.2 7774.3 8012.6 8221.5 8237.7 8306.1 7777.9 7992.1 8027.0 8308.3 8308.7 6825.2 6839.6 6889.9 6972.2 7022.1 6869.0 6986.3 6992.7 6996.2 7005.3 6267.2 6273.8 6459.7 6469.8 6570.8 6197.6 6198.4 6207.1 6267.0 6338.3 5819.8 5819.9 5823.5 5832.7 5931.0 3763.2 3896.8 3906.9 3941.0 3957.5 3938.7 3966.3 3968.8 3982.1 3991.4 16:33:14 INFO - PROCESS | 2936 | 16:33:14 INFO - PROCESS | 2936 | [#4] prototype.html Cycles:180 Average:4457.24 Median:5170.46 stddev:1360.59 (26.3%) stddev-sans-first:1327.84 16:33:14 INFO - PROCESS | 2936 | Values: 282.8 283.8 292.2 293.5 294.4 5123.9 5151.2 5162.9 5169.0 5169.6 4803.5 5033.5 5054.7 5113.6 5131.3 3743.2 3762.0 3766.1 3785.2 3805.7 3779.5 3811.3 3819.8 3864.7 3879.4 3798.0 3809.9 3820.0 3828.8 3829.8 3745.5 3762.9 3787.6 3792.0 3815.5 3282.1 3299.8 3308.9 3310.5 3331.6 4932.9 4935.8 4939.7 4966.5 5008.6 4234.6 4453.0 4465.5 4480.0 4494.2 5311.9 5333.0 5333.9 5353.7 5421.7 3664.2 3667.7 3675.9 3689.9 3695.5 5393.5 5635.6 5643.0 5646.5 5706.7 3693.9 3715.5 3723.8 3738.6 3795.6 3782.7 3788.2 3803.1 3825.0 3869.4 4395.8 4438.8 4452.4 4469.8 4471.3 5324.9 5332.5 5351.9 5353.9 5458.4 1302.5 1324.1 1325.8 1326.9 1327.1 789.0 794.1 809.5 823.4 832.0 4950.8 5051.9 5140.4 5211.8 5215.2 5512.9 5516.3 5523.4 5538.9 5567.3 4966.8 5159.4 5171.4 5195.6 5223.2 2905.6 2977.9 2984.9 2994.9 3008.1 5614.9 5632.8 5656.9 5707.7 5731.7 5328.6 5588.5 5638.2 5643.4 5666.9 5581.9 5595.2 5623.1 5633.4 5648.6 5266.1 5523.4 5555.2 5584.4 5601.2 5391.1 5407.6 5408.1 5426.7 5437.9 5573.9 5597.2 5611.6 5701.0 5736.9 3642.7 3727.9 3730.4 3742.2 3744.5 5427.6 5442.6 5443.5 5462.2 5518.6 5311.2 5330.3 5405.4 5444.8 5460.3 5124.6 5318.3 5342.3 5354.2 5363.4 5278.7 5279.7 5293.6 5297.0 5301.8 5185.5 5242.1 5339.3 5373.0 5416.7 5296.6 5314.6 5319.0 5323.9 5350.6 16:33:14 INFO - PROCESS | 2936 | 16:33:14 INFO - PROCESS | 2936 | [#5] yui.html Cycles:180 Average:14782.75 Median:45936.54 stddev:18557.69 (40.4%) stddev-sans-first:18579.30 16:33:14 INFO - PROCESS | 2936 | Values: 627.1 629.4 692.5 706.2 718.5 12499.9 13140.1 13217.3 13302.3 13773.9 12518.1 12565.6 12691.5 12706.2 12721.7 660.8 665.3 669.3 671.7 677.0 650.5 652.4 652.7 669.5 669.6 677.2 679.6 679.8 707.4 707.6 672.8 673.6 677.4 704.0 706.7 490.0 491.0 513.2 513.8 515.1 11874.0 11916.5 11944.7 11947.0 11974.4 12082.2 12154.1 12251.6 12300.4 12370.7 9791.4 9970.0 10368.0 10381.3 10830.2 3368.5 3384.6 3418.6 3419.4 3447.6 41501.8 50955.5 51397.2 55436.4 56712.1 9696.9 9826.5 9878.9 9944.7 10010.3 16522.5 16569.0 16572.2 16597.4 16788.3 6055.4 7064.4 7083.8 7368.4 7439.6 4011.4 4057.9 4077.2 4150.4 4151.2 2578.8 2661.9 2665.2 2667.6 2670.7 471.7 475.8 476.4 501.4 502.2 517.7 616.7 626.6 636.1 648.2 8442.0 8495.2 8570.6 8677.0 8794.9 531.4 618.8 632.9 647.5 648.4 3953.7 4164.5 4197.6 4355.1 4381.4 68099.7 69206.0 70580.0 70693.3 71323.6 59613.7 61049.4 61395.4 61894.4 62884.1 46273.8 56730.7 57100.4 57676.0 57970.7 8200.4 8225.6 8331.9 8413.6 8413.8 31580.7 35372.2 36488.8 36686.4 38270.8 45458.5 45599.3 47600.0 48937.0 49350.8 10945.3 11128.9 11245.4 11274.3 11606.5 11826.0 12088.2 12149.1 12181.6 12828.9 11931.2 12245.3 12320.6 12583.2 12995.0 11977.6 12113.4 12225.3 12256.4 12334.6 12105.3 12198.5 12230.3 12333.7 12369.5 9774.0 10147.9 10294.3 10336.9 10390.5 10016.2 10077.8 10354.0 10561.5 10576.6 16:33:14 INFO - PROCESS | 2936 | -------- Summary: end -------- 16:33:14 INFO - PROCESS | 2936 | 16:33:14 INFO - TEST-INFO | 2936: exit 0 16:33:15 INFO - TEST-OK | dromaeo_css | took 1122133ms 16:33:15 INFO - TEST-START | kraken 16:33:15 INFO - operating with platform_type : w8_ 16:33:15 INFO - Initialising browser for kraken test... 16:33:15 INFO - TEST-INFO | started process 892 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpbq5_cf\profile http://localhost:49275/getInfo.html) 16:33:20 INFO - PROCESS | 892 | __metrics Screen width/height:1600/1200 16:33:20 INFO - PROCESS | 892 | colorDepth:24 16:33:20 INFO - PROCESS | 892 | Browser inner width/height: 1010/674 16:33:20 INFO - PROCESS | 892 | __metrics 16:33:21 INFO - PROCESS | 892 | 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" 16:33:21 INFO - PROCESS | 892 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:33:21 INFO - PROCESS | 892 | console.error: 16:33:21 INFO - PROCESS | 892 | Message: Error: Connection closed before committing the transaction. 16:33:21 INFO - PROCESS | 892 | Stack: 16:33:21 INFO - PROCESS | 892 | ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:937:23 16:33:21 INFO - PROCESS | 892 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7 16:33:21 INFO - PROCESS | 892 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11 16:33:21 INFO - PROCESS | 892 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7 16:33:21 INFO - PROCESS | 892 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:714:7 16:33:21 INFO - PROCESS | 892 | TaskImpl_run@resource://gre/modules/Task.jsm:327:15 16:33:21 INFO - PROCESS | 892 | Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:551:9 16:33:21 INFO - PROCESS | 892 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15 16:33:21 INFO - PROCESS | 892 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:388:5 16:33:21 INFO - PROCESS | 892 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29 16:33:21 INFO - PROCESS | 892 | Barrier/this.client.addBlocker/promise13.5% 16:34:19 INFO - TinderboxPrint: I/O read bytes / time
258,093,568 / 2,722,170 16:34:19 INFO - TinderboxPrint: I/O write bytes / time
408,549,376 / 3,255,910 16:34:19 INFO - TinderboxPrint: CPU idle
8,238.2 (86.5%) 16:34:19 INFO - TinderboxPrint: CPU user
1,230.5 (12.9%) 16:34:19 INFO - install - Wall time: 3s; CPU: 12.0%; Read bytes: 0; Write bytes: 35256832; Read time: 0; Write time: 71110 16:34:19 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 258093568; Write bytes: 317333504; Read time: 2722170; Write time: 3116480 16:34:19 INFO - Running post-run listener: _upload_blobber_files 16:34:19 INFO - Blob upload gear active. 16:34:19 INFO - Preparing to upload files from C:\slave\test\build\blobber_upload_dir. 16:34:19 INFO - Files from C:\slave\test\build\blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:34:19 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'] 16:34:19 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 16:34:20 INFO - (blobuploader) - INFO - Open directory for files ... 16:34:20 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_errorsummary.log ... 16:34:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:34:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:34:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:34:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:34:20 INFO - (blobuploader) - INFO - Done attempting. 16:34:20 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_raw.log ... 16:34:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:34:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:34:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:34:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:34:21 INFO - (blobuploader) - INFO - Done attempting. 16:34:21 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\resource-usage.json ... 16:34:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:34:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:34:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:34:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:34:24 INFO - (blobuploader) - INFO - Done attempting. 16:34:24 INFO - (blobuploader) - INFO - Iteration through files over. 16:34:24 INFO - Return code: 0 16:34:24 INFO - rmtree: C:\slave\test\build\uploaded_files.json 16:34:24 INFO - Using _rmtree_windows ... 16:34:24 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build\\uploaded_files.json',), kwargs: {}, attempt #1 16:34:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/55315727c031f42bbcbf055805761d5209fcf430ad9ac2fd03e45a91d4b4155a089801890753cbafce02ac2df385e47d4841989f8d1cb4be7aec9012659d89b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9a7ea7fb232dec91b03779f3ea2c934008ff4ae39fa4de5113e1a79de67b93ac8fbe4a44792b969b6ebe0f55eb2751a24cf99afd76ed238742fe4283ed7c79cd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1f684064fc0491796a3c9b4255c0caac82eee6c01b1785d7157214e873ac917716797a76946895e639b2d785c75d7388d741a5cc0009232c45ea6cc8923d38a3"} 16:34:24 INFO - Writing buildbot properties ['blobber_files'] to C:\slave\test\properties\blobber_files 16:34:24 INFO - Writing to file C:\slave\test\properties\blobber_files 16:34:24 INFO - Contents: 16:34:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/55315727c031f42bbcbf055805761d5209fcf430ad9ac2fd03e45a91d4b4155a089801890753cbafce02ac2df385e47d4841989f8d1cb4be7aec9012659d89b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9a7ea7fb232dec91b03779f3ea2c934008ff4ae39fa4de5113e1a79de67b93ac8fbe4a44792b969b6ebe0f55eb2751a24cf99afd76ed238742fe4283ed7c79cd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1f684064fc0491796a3c9b4255c0caac82eee6c01b1785d7157214e873ac917716797a76946895e639b2d785c75d7388d741a5cc0009232c45ea6cc8923d38a3"} 16:34:24 INFO - Running post-run listener: copy_logs_to_upload_dir 16:34:24 INFO - Copying logs to upload dir... 16:34:24 INFO - mkdir: C:\slave\test\build\upload\logs 16:34:24 INFO - Copying logs to upload dir... 16:34:24 INFO - Using _rmtree_windows ... 16:34:24 INFO - Using _rmtree_windows ... 16:34:24 INFO - Using _rmtree_windows ... 16:34:24 INFO - Using _rmtree_windows ... 16:34:24 INFO - Using _rmtree_windows ... 16:34:24 INFO - Using _rmtree_windows ... 16:34:24 INFO - Using _rmtree_windows ... program finished with exit code 0 elapsedTime=1443.371000 ========= master_lag: 3.10 ========= ========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 24 mins, 6 secs) (at 2016-10-27 16:34:27.467821) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-27 16:34:27.474177) ========= '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-175\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-175 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-175 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-175\AppData\Local LOGONSERVER=\\T-W864-IX-175 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-175 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-175 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-175 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/55315727c031f42bbcbf055805761d5209fcf430ad9ac2fd03e45a91d4b4155a089801890753cbafce02ac2df385e47d4841989f8d1cb4be7aec9012659d89b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9a7ea7fb232dec91b03779f3ea2c934008ff4ae39fa4de5113e1a79de67b93ac8fbe4a44792b969b6ebe0f55eb2751a24cf99afd76ed238742fe4283ed7c79cd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1f684064fc0491796a3c9b4255c0caac82eee6c01b1785d7157214e873ac917716797a76946895e639b2d785c75d7388d741a5cc0009232c45ea6cc8923d38a3"} build_url:https://queue.taskcluster.net/v1/task/Zy-ftQv2Tfqn5pcBwG1k4g/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/Zy-ftQv2Tfqn5pcBwG1k4g/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/55315727c031f42bbcbf055805761d5209fcf430ad9ac2fd03e45a91d4b4155a089801890753cbafce02ac2df385e47d4841989f8d1cb4be7aec9012659d89b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9a7ea7fb232dec91b03779f3ea2c934008ff4ae39fa4de5113e1a79de67b93ac8fbe4a44792b969b6ebe0f55eb2751a24cf99afd76ed238742fe4283ed7c79cd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1f684064fc0491796a3c9b4255c0caac82eee6c01b1785d7157214e873ac917716797a76946895e639b2d785c75d7388d741a5cc0009232c45ea6cc8923d38a3"}' ========= master_lag: 0.08 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-27 16:34:27.651395) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 16:34:27.651701) ========= '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-175\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-175 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-175 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-175\AppData\Local LOGONSERVER=\\T-W864-IX-175 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-175 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-175 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-175 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-27 16:34:27.771226) ========= ========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-10-27 16:34:27.771541) ========= ========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-10-27 16:34:28.215361) ========= ========= Total master_lag: 6.98 =========