builder: autoland_win8_64_test-dromaeojs-pgo slave: t-w864-ix-077 starttime: 1476722810.85 results: success (0) buildid: 20161017063144 builduid: 61e521d822be4360b834c8339a8aa6d9 revision: a7fc516956bc16b7a0463e0cc9eb996f2f842314 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 09:46:50.847058) ========= master: http://buildbot-master110.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 09:46:50.847556) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 09:46:50.847846) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 09:46:51.083962) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-17 09:46:51.084398) ========= '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-077\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-077 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-077 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-077\AppData\Local LOGONSERVER=\\T-W864-IX-077 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-077 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-077 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-077 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False --09:46:52-- 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 09:46:53 (2.27 GB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=2.013000 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-17 09:46:53.163240) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-10-17 09:46:53.163634) ========= '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-077\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-077 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-077 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-077\AppData\Local LOGONSERVER=\\T-W864-IX-077 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-077 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-077 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-077 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=3.716000 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-10-17 09:46:56.901512) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-17 09:46:56.901902) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo integration/autoland --rev a7fc516956bc16b7a0463e0cc9eb996f2f842314 --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 a7fc516956bc16b7a0463e0cc9eb996f2f842314 --destination scripts --debug'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-077\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-077 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-077 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-077\AppData\Local LOGONSERVER=\\T-W864-IX-077 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-077 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-077 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-077 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 2016-10-17 09:46:57,967 truncating revision to first 12 chars 2016-10-17 09:46:57,967 Setting DEBUG logging. 2016-10-17 09:46:57,967 attempt 1/10 2016-10-17 09:46:57,967 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/a7fc516956bc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-17 09:46:58,421 unpacking tar archive at: autoland-a7fc516956bc/testing/mozharness/ 2016-10-17 09:46:58,861 skipping symlink on windows: configs/single_locale/linux32.py program finished with exit code 0 elapsedTime=1.646000 ========= master_lag: 0.17 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-17 09:46:58.714290) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 09:46:58.714611) ========= script_repo_revision: a7fc516956bc16b7a0463e0cc9eb996f2f842314 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 09:46:58.715007) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 09:46:58.715298) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 09:46:58.732687) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 15 secs) (at 2016-10-17 09:46:58.732957) ========= '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-077\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-077 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-077 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-077\AppData\Local LOGONSERVER=\\T-W864-IX-077 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-077 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-077 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-077 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 09:46:59 INFO - MultiFileLogger online at 20161017 09:46:59 in C:\slave\test 09:46:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 09:46:59 INFO - Dumping config to C:\slave\test\logs\localconfig.json. 09:46:59 INFO - {'append_to_log': False, 09:46:59 INFO - 'base_work_dir': 'C:\\slave\\test', 09:46:59 INFO - 'blob_upload_branch': 'Autoland', 09:46:59 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt', 09:46:59 INFO - 'branch': 'Autoland', 09:46:59 INFO - 'buildbot_json_path': 'buildprops.json', 09:46:59 INFO - 'config_files': ('talos/windows_config.py',), 09:46:59 INFO - 'default_actions': ('clobber', 09:46:59 INFO - 'read-buildbot-config', 09:46:59 INFO - 'download-and-extract', 09:46:59 INFO - 'populate-webroot', 09:46:59 INFO - 'create-virtualenv', 09:46:59 INFO - 'install', 09:46:59 INFO - 'run-tests'), 09:46:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:46:59 INFO - 'download_minidump_stackwalk': True, 09:46:59 INFO - 'download_symbols': 'ondemand', 09:46:59 INFO - 'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python', 09:46:59 INFO - 'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'), 09:46:59 INFO - 'hg': 'c:/mozilla-build/hg/hg', 09:46:59 INFO - 'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python', 09:46:59 INFO - 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'), 09:46:59 INFO - 'python': 'c:/mozilla-build/python27/python.exe', 09:46:59 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe', 09:46:59 INFO - 'C:/mozilla-build/tooltool.py'), 09:46:59 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe', 09:46:59 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 09:46:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:46:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:46:59 INFO - 'installer_path': 'installer.exe', 09:46:59 INFO - 'log_level': 'info', 09:46:59 INFO - 'log_name': 'talos', 09:46:59 INFO - 'log_to_console': True, 09:46:59 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe', 09:46:59 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe', 09:46:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest', 09:46:59 INFO - 'opt_config_files': (), 09:46:59 INFO - 'pip_index': False, 09:46:59 INFO - 'sps_profile': False, 09:46:59 INFO - 'sps_profile_interval': 0, 09:46:59 INFO - 'suite': 'dromaeojs', 09:46:59 INFO - 'system_bits': '32', 09:46:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:46:59 INFO - 'title': 'T-W864-IX-077', 09:46:59 INFO - 'use_talos_json': True, 09:46:59 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'), 09:46:59 INFO - 'virtualenv_path': 'C:\\slave\\test\\build/venv', 09:46:59 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll', 09:46:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:46:59 INFO - 'work_dir': 'build'} 09:46:59 INFO - [mozharness: 2016-10-17 16:46:59.667000Z] Running clobber step. 09:46:59 INFO - Running pre-action listener: _resource_record_pre_action 09:46:59 INFO - Running main action method: clobber 09:46:59 INFO - rmtree: C:\slave\test\build 09:46:59 INFO - Using _rmtree_windows ... 09:46:59 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1 09:48:37 INFO - Running post-action listener: _resource_record_post_action 09:48:37 INFO - [mozharness: 2016-10-17 16:48:37.603000Z] Finished clobber step (success) 09:48:37 INFO - [mozharness: 2016-10-17 16:48:37.603000Z] Running read-buildbot-config step. 09:48:37 INFO - Running pre-action listener: _resource_record_pre_action 09:48:37 INFO - Running main action method: read_buildbot_config 09:48:37 INFO - Using buildbot properties: 09:48:37 INFO - { 09:48:37 INFO - "project": "", 09:48:37 INFO - "product": "firefox", 09:48:37 INFO - "script_repo_revision": "production", 09:48:37 INFO - "builddir": "autoland_win8_64_test-dromaeojs", 09:48:37 INFO - "repository": "", 09:48:37 INFO - "buildername": "Windows 8 64-bit autoland pgo talos dromaeojs", 09:48:37 INFO - "buildid": "20161017063144", 09:48:37 INFO - "pgo_build": "True", 09:48:37 INFO - "basedir": "C:\\slave\\test", 09:48:37 INFO - "buildnumber": 24, 09:48:37 INFO - "slavename": "t-w864-ix-077", 09:48:37 INFO - "master": "http://buildbot-master110.bb.releng.scl3.mozilla.com:8201/", 09:48:37 INFO - "platform": "win8_64", 09:48:37 INFO - "scheduler": "tests-autoland-win64-pgo-talos", 09:48:37 INFO - "branch": "autoland", 09:48:37 INFO - "repo_path": "integration/autoland", 09:48:37 INFO - "revision": "a7fc516956bc16b7a0463e0cc9eb996f2f842314", 09:48:37 INFO - "stage_platform": "win64-pgo", 09:48:37 INFO - "builduid": "61e521d822be4360b834c8339a8aa6d9", 09:48:37 INFO - "slavebuilddir": "test" 09:48:37 INFO - } 09:48:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/Bz1EB0CvRv-h0jjmtgecPA/artifacts/public/build/firefox-52.0a1.en-US.win64.zip. 09:48:37 INFO - Running post-action listener: _resource_record_post_action 09:48:37 INFO - [mozharness: 2016-10-17 16:48:37.606000Z] Finished read-buildbot-config step (success) 09:48:37 INFO - [mozharness: 2016-10-17 16:48:37.606000Z] Running download-and-extract step. 09:48:37 INFO - Running pre-action listener: _resource_record_pre_action 09:48:37 INFO - Running main action method: download_and_extract 09:48:37 INFO - mkdir: C:\slave\test\build\tests 09:48:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:37 INFO - trying https://queue.taskcluster.net/v1/task/Bz1EB0CvRv-h0jjmtgecPA/artifacts/public/build/firefox-52.0a1.en-US.win64.test_packages.json 09:48:37 INFO - Downloading https://queue.taskcluster.net/v1/task/Bz1EB0CvRv-h0jjmtgecPA/artifacts/public/build/firefox-52.0a1.en-US.win64.test_packages.json to C:\slave\test\build\firefox-52.0a1.en-US.win64.test_packages.json 09:48:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Bz1EB0CvRv-h0jjmtgecPA/artifacts/public/build/firefox-52.0a1.en-US.win64.test_packages.json', 'file_name': 'C:\\slave\\test\\build\\firefox-52.0a1.en-US.win64.test_packages.json'}, attempt #1 09:48:38 INFO - Downloaded 1218 bytes. 09:48:38 INFO - Reading from file C:\slave\test\build\firefox-52.0a1.en-US.win64.test_packages.json 09:48:38 INFO - Using the following test package requirements: 09:48:38 INFO - {u'common': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 09:48:38 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 09:48:38 INFO - u'firefox-52.0a1.en-US.win64.cppunittest.tests.zip'], 09:48:38 INFO - u'gtest': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 09:48:38 INFO - u'jittest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 09:48:38 INFO - u'jsshell-win64.zip'], 09:48:38 INFO - u'mochitest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 09:48:38 INFO - u'firefox-52.0a1.en-US.win64.mochitest.tests.zip'], 09:48:38 INFO - u'mozbase': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 09:48:38 INFO - u'reftest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 09:48:38 INFO - u'firefox-52.0a1.en-US.win64.reftest.tests.zip'], 09:48:38 INFO - u'talos': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 09:48:38 INFO - u'firefox-52.0a1.en-US.win64.talos.tests.zip'], 09:48:38 INFO - u'web-platform': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 09:48:38 INFO - u'firefox-52.0a1.en-US.win64.web-platform.tests.zip'], 09:48:38 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 09:48:38 INFO - u'firefox-52.0a1.en-US.win64.xpcshell.tests.zip']} 09:48:38 INFO - Downloading packages: [u'firefox-52.0a1.en-US.win64.common.tests.zip'] for test suite category: common 09:48:38 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/Bz1EB0CvRv-h0jjmtgecPA/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip 09:48:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Bz1EB0CvRv-h0jjmtgecPA/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip'}, attempt #1 09:48:38 INFO - Fetch https://queue.taskcluster.net/v1/task/Bz1EB0CvRv-h0jjmtgecPA/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip into memory 09:48:39 INFO - Http code: 200 09:48:39 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 09:48:39 INFO - x-amz-cf-id: D9SIjBEcaRvDmbG3Qqxki2cBnBQGdqnzBQrmR1FCKIZBYsv972TPIw== 09:48:39 INFO - x-amz-version-id: eFi7BDnFOlh6lmFHnZRrATpmb5QnlMnf 09:48:39 INFO - Expected file size: 17524889 09:48:39 INFO - Obtained file size: 17524889 09:49:02 INFO - Downloading packages: [u'firefox-52.0a1.en-US.win64.common.tests.zip', u'firefox-52.0a1.en-US.win64.talos.tests.zip'] for test suite category: talos 09:49:02 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/Bz1EB0CvRv-h0jjmtgecPA/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip 09:49:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Bz1EB0CvRv-h0jjmtgecPA/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip'}, attempt #1 09:49:02 INFO - Fetch https://queue.taskcluster.net/v1/task/Bz1EB0CvRv-h0jjmtgecPA/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip into memory 09:49:02 INFO - Http code: 200 09:49:02 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 09:49:02 INFO - x-amz-cf-id: mY4YsmrZF169YLT8TTdUKWtEajqtyIWe61Qc_8HVWnnf1tESrcdTFg== 09:49:02 INFO - x-amz-version-id: eFi7BDnFOlh6lmFHnZRrATpmb5QnlMnf 09:49:03 INFO - Expected file size: 17524889 09:49:03 INFO - Obtained file size: 17524889 09:49:13 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/Bz1EB0CvRv-h0jjmtgecPA/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip 09:49:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Bz1EB0CvRv-h0jjmtgecPA/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip'}, attempt #1 09:49:13 INFO - Fetch https://queue.taskcluster.net/v1/task/Bz1EB0CvRv-h0jjmtgecPA/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip into memory 09:49:13 INFO - Http code: 200 09:49:13 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 09:49:13 INFO - x-amz-cf-id: BY6QTs20HvuNK4_Sw9Stvu745w-qx3DILtDeGDxSTUA4nl-Z0KtrAw== 09:49:13 INFO - x-amz-version-id: zXF04NPO100yMLww.6Ibrrm6LAO7dGV9 09:49:13 INFO - Expected file size: 14409028 09:49:13 INFO - Obtained file size: 14409028 09:49:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:24 INFO - trying https://queue.taskcluster.net/v1/task/Bz1EB0CvRv-h0jjmtgecPA/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 09:49:24 INFO - Downloading https://queue.taskcluster.net/v1/task/Bz1EB0CvRv-h0jjmtgecPA/artifacts/public/build/firefox-52.0a1.en-US.win64.zip to C:\slave\test\build\firefox-52.0a1.en-US.win64.zip 09:49:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Bz1EB0CvRv-h0jjmtgecPA/artifacts/public/build/firefox-52.0a1.en-US.win64.zip', 'file_name': 'C:\\slave\\test\\build\\firefox-52.0a1.en-US.win64.zip'}, attempt #1 09:49:25 INFO - Downloaded 57142126 bytes. 09:49:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Bz1EB0CvRv-h0jjmtgecPA/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 09:49:25 INFO - mkdir: C:\slave\test\properties 09:49:25 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url 09:49:25 INFO - Writing to file C:\slave\test\properties\build_url 09:49:25 INFO - Contents: 09:49:25 INFO - build_url:https://queue.taskcluster.net/v1/task/Bz1EB0CvRv-h0jjmtgecPA/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 09:49:26 INFO - Running post-action listener: _resource_record_post_action 09:49:26 INFO - Running post-action listener: set_extra_try_arguments 09:49:26 INFO - [mozharness: 2016-10-17 16:49:26.366000Z] Finished download-and-extract step (success) 09:49:26 INFO - [mozharness: 2016-10-17 16:49:26.366000Z] Running populate-webroot step. 09:49:26 INFO - Running pre-action listener: _resource_record_pre_action 09:49:26 INFO - Running main action method: populate_webroot 09:49:26 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']}, 09:49:26 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']}, 09:49:26 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome', 09:49:26 INFO - u'--tppagecycles', 09:49:26 INFO - u'7'], 09:49:26 INFO - u'tests': [u'tsvgm']}}, 09:49:26 INFO - u'suites': {u'chromez': {u'talos_options': [u'--disable-e10s'], 09:49:26 INFO - u'tests': [u'tresize', u'tcanvasmark']}, 09:49:26 INFO - u'chromez-e10s': {u'tests': [u'tresize', u'tcanvasmark']}, 09:49:26 INFO - u'dromaeojs': {u'talos_options': [u'--disable-e10s'], 09:49:26 INFO - u'tests': [u'dromaeo_css', u'kraken']}, 09:49:26 INFO - u'dromaeojs-e10s': {u'tests': [u'dromaeo_css', u'kraken']}, 09:49:26 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:26 INFO - u'talos_options': [u'--disable-e10s'], 09:49:26 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 09:49:26 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:26 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 09:49:26 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:26 INFO - u'talos_options': [u'--disable-e10s'], 09:49:26 INFO - u'tests': [u'damp', u'tps']}, 09:49:26 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:26 INFO - u'tests': [u'damp', u'tps']}, 09:49:26 INFO - u'g3': {u'talos_options': [u'--disable-e10s'], 09:49:26 INFO - u'tests': [u'dromaeo_dom']}, 09:49:26 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']}, 09:49:26 INFO - u'g4': {u'talos_options': [u'--disable-e10s'], 09:49:26 INFO - u'tests': [u'basic_compositor_video']}, 09:49:26 INFO - u'g4-e10s': {u'tests': [u'basic_compositor_video']}, 09:49:26 INFO - u'other': {u'talos_options': [u'--disable-e10s'], 09:49:26 INFO - u'tests': [u'a11yr', 09:49:26 INFO - u'ts_paint', 09:49:26 INFO - u'tpaint', 09:49:26 INFO - u'sessionrestore', 09:49:26 INFO - u'sessionrestore_no_auto_restore', 09:49:26 INFO - u'tabpaint']}, 09:49:26 INFO - u'other-e10s': {u'tests': [u'a11yr', 09:49:26 INFO - u'ts_paint', 09:49:26 INFO - u'tpaint', 09:49:26 INFO - u'sessionrestore', 09:49:26 INFO - u'sessionrestore_no_auto_restore', 09:49:26 INFO - u'tabpaint']}, 09:49:26 INFO - u'other-e10s_l64': {u'tests': [u'a11yr', 09:49:26 INFO - u'ts_paint', 09:49:26 INFO - u'tpaint', 09:49:26 INFO - u'sessionrestore', 09:49:26 INFO - u'sessionrestore_no_auto_restore', 09:49:26 INFO - u'tabpaint']}, 09:49:26 INFO - u'other-e10s_nol64': {u'tests': [u'a11yr', 09:49:26 INFO - u'ts_paint', 09:49:26 INFO - u'tpaint', 09:49:26 INFO - u'sessionrestore', 09:49:26 INFO - u'sessionrestore_no_auto_restore', 09:49:26 INFO - u'tabpaint']}, 09:49:26 INFO - u'other_l64': {u'talos_options': [u'--disable-e10s'], 09:49:26 INFO - u'tests': [u'a11yr', 09:49:26 INFO - u'ts_paint', 09:49:26 INFO - u'tpaint', 09:49:26 INFO - u'sessionrestore', 09:49:26 INFO - u'sessionrestore_no_auto_restore', 09:49:26 INFO - u'tabpaint']}, 09:49:26 INFO - u'other_nol64': {u'talos_options': [u'--disable-e10s'], 09:49:26 INFO - u'tests': [u'a11yr', 09:49:26 INFO - u'ts_paint', 09:49:26 INFO - u'tpaint', 09:49:26 INFO - u'sessionrestore', 09:49:26 INFO - u'sessionrestore_no_auto_restore', 09:49:26 INFO - u'tabpaint']}, 09:49:26 INFO - u'svgr': {u'talos_options': [u'--disable-e10s'], 09:49:26 INFO - u'tests': [u'tsvgx', 09:49:26 INFO - u'tsvgr_opacity', 09:49:26 INFO - u'tart', 09:49:26 INFO - u'tscrollx', 09:49:26 INFO - u'cart']}, 09:49:26 INFO - u'svgr-e10s': {u'tests': [u'tsvgx', 09:49:26 INFO - u'tsvgr_opacity', 09:49:26 INFO - u'tart', 09:49:26 INFO - u'tscrollx', 09:49:26 INFO - u'cart']}, 09:49:26 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:26 INFO - u'talos_options': [u'--disable-e10s'], 09:49:26 INFO - u'tests': [u'tp5o']}, 09:49:26 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:26 INFO - u'tests': [u'tp5o']}, 09:49:26 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:26 INFO - u'talos_options': [u'--disable-e10s', 09:49:26 INFO - u'--xperf_path', 09:49:26 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:49:26 INFO - u'tests': [u'tp5n']}, 09:49:26 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:26 INFO - u'talos_options': [u'--xperf_path', 09:49:26 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:49:26 INFO - u'tests': [u'tp5n']}}, 09:49:26 INFO - u'talos.zip': {u'path': u'', 09:49:26 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:49:26 INFO - Running post-action listener: _resource_record_post_action 09:49:26 INFO - [mozharness: 2016-10-17 16:49:26.423000Z] Finished populate-webroot step (success) 09:49:26 INFO - [mozharness: 2016-10-17 16:49:26.423000Z] Running create-virtualenv step. 09:49:26 INFO - Running pre-action listener: _resource_record_pre_action 09:49:26 INFO - Running main action method: create_virtualenv 09:49:26 INFO - Creating virtualenv C:\slave\test\build/venv 09:49:26 INFO - mkdir: C:\slave\test\build\venv\Scripts 09:49:26 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll 09:49:26 WARNING - Can't copy c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll: [Errno 2] No such file or directory: 'c:/mozilla-build/python27/python27.dll'! 09:49:26 INFO - Running command: ['c:/mozilla-build/python27/python.exe', 'c:/mozilla-build/buildbotve/virtualenv.py', '--no-site-packages', '--distribute', 'C:\\slave\\test\\build/venv'] in C:\slave\test\build 09:49:26 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build/venv 09:49:35 INFO - New python executable in C:\slave\test\build/venv\Scripts\python.exe 09:49:38 INFO - Installing distribute......................................................................................................................................................................................done. 09:49:39 INFO - Return code: 0 09:49:39 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', '--version'] 09:49:39 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip --version 09:49:39 INFO - Reading from file tmpfile_stdout 09:49:39 INFO - Output received: 09:49:39 INFO - pip 0.8.2 from c:\slave\test\build\venv\lib\site-packages\pip-0.8.2-py2.7.egg (python 2.7) 09:49:39 INFO - Using _rmtree_windows ... 09:49:39 INFO - Using _rmtree_windows ... 09:49:39 INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv 09:49:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:39 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 0x0237C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02423E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0252F330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0246AE90>, '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 0x01DBA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0290D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-077', 'USERDOMAIN': 'T-W864-IX-077', '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-077', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-077\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-077', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-077', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-077', '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-077\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 09:49:39 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in C:\slave\test\build 09:49:39 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:49:39 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 09:49:39 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-077\\AppData\\Roaming', 09:49:39 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 09:49:39 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 09:49:39 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 09:49:39 INFO - 'COMPUTERNAME': 'T-W864-IX-077', 09:49:39 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 09:49:39 INFO - 'DCLOCATION': 'SCL3', 09:49:39 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 09:49:39 INFO - 'FP_NO_HOST_CHECK': 'NO', 09:49:39 INFO - 'HOMEDRIVE': 'C:', 09:49:39 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-077', 09:49:39 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 09:49:39 INFO - 'KTS_VERSION': '1.19c', 09:49:39 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-077\\AppData\\Local', 09:49:39 INFO - 'LOGONSERVER': '\\\\T-W864-IX-077', 09:49:39 INFO - 'MONDIR': 'C:\\Monitor_config\\', 09:49:39 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 09:49:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:39 INFO - 'MOZ_NO_REMOTE': '1', 09:49:39 INFO - 'NO_EM_RESTART': '1', 09:49:39 INFO - 'NUMBER_OF_PROCESSORS': '8', 09:49:39 INFO - 'OS': 'Windows_NT', 09:49:39 INFO - 'OURDRIVE': 'C:', 09:49:39 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 09:49:39 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 09:49:39 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 09:49:39 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 09:49:39 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 09:49:39 INFO - 'PROCESSOR_LEVEL': '6', 09:49:39 INFO - 'PROCESSOR_REVISION': '1e05', 09:49:39 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 09:49:39 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 09:49:39 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 09:49:39 INFO - 'PROGRAMW6432': 'C:\\Program Files', 09:49:39 INFO - 'PROMPT': '$P$G', 09:49:39 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 09:49:39 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 09:49:39 INFO - 'PUBLIC': 'C:\\Users\\Public', 09:49:39 INFO - 'PWD': 'C:\\slave\\test', 09:49:39 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 09:49:39 INFO - 'SLAVEDIR': 'C:\\slave\\', 09:49:39 INFO - 'SYSTEMDRIVE': 'C:', 09:49:39 INFO - 'SYSTEMROOT': 'C:\\windows', 09:49:39 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:49:39 INFO - 'TEST1': 'testie', 09:49:39 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:49:39 INFO - 'USERDOMAIN': 'T-W864-IX-077', 09:49:39 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-077', 09:49:39 INFO - 'USERNAME': 'cltbld', 09:49:39 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-077', 09:49:39 INFO - 'WINDIR': 'C:\\windows', 09:49:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 09:49:40 INFO - Ignoring indexes: http://pypi.python.org/simple/ 09:49:40 INFO - Downloading/unpacking pip>=1.5 09:49:44 INFO - Running setup.py egg_info for package pip 09:49:44 INFO - warning: no files found matching 'pip\cacert.pem' 09:49:44 INFO - warning: no files found matching '*.html' under directory 'docs' 09:49:44 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 09:49:44 INFO - no previously-included directories found matching 'docs\_build\_sources' 09:49:44 INFO - Installing collected packages: pip 09:49:44 INFO - Found existing installation: pip 0.8.2 09:49:44 INFO - Uninstalling pip: 09:49:44 INFO - Successfully uninstalled pip 09:49:44 INFO - Running setup.py install for pip 09:49:44 INFO - warning: no files found matching 'pip\cacert.pem' 09:49:44 INFO - warning: no files found matching '*.html' under directory 'docs' 09:49:44 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 09:49:44 INFO - no previously-included directories found matching 'docs\_build\_sources' 09:49:44 INFO - Installing pip-script.py script to C:\slave\test\build\venv\Scripts 09:49:44 INFO - Installing pip.exe script to C:\slave\test\build\venv\Scripts 09:49:44 INFO - Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts 09:49:44 INFO - Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts 09:49:44 INFO - Installing pip2-script.py script to C:\slave\test\build\venv\Scripts 09:49:44 INFO - Installing pip2.exe script to C:\slave\test\build\venv\Scripts 09:49:44 INFO - Successfully installed pip 09:49:44 INFO - Cleaning up... 09:49:44 INFO - Return code: 0 09:49:44 INFO - Installing psutil>=3.1.1 into virtualenv C:\slave\test\build/venv 09:49:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:44 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x0237C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02423E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0252F330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0246AE90>, '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 0x01DBA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0290D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-077', 'USERDOMAIN': 'T-W864-IX-077', '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-077', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-077\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-077', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-077', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-077', '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-077\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 09:49:45 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in C:\slave\test\build 09:49:45 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:49:45 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 09:49:45 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-077\\AppData\\Roaming', 09:49:45 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 09:49:45 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 09:49:45 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 09:49:45 INFO - 'COMPUTERNAME': 'T-W864-IX-077', 09:49:45 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 09:49:45 INFO - 'DCLOCATION': 'SCL3', 09:49:45 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 09:49:45 INFO - 'FP_NO_HOST_CHECK': 'NO', 09:49:45 INFO - 'HOMEDRIVE': 'C:', 09:49:45 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-077', 09:49:45 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 09:49:45 INFO - 'KTS_VERSION': '1.19c', 09:49:45 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-077\\AppData\\Local', 09:49:45 INFO - 'LOGONSERVER': '\\\\T-W864-IX-077', 09:49:45 INFO - 'MONDIR': 'C:\\Monitor_config\\', 09:49:45 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 09:49:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:45 INFO - 'MOZ_NO_REMOTE': '1', 09:49:45 INFO - 'NO_EM_RESTART': '1', 09:49:45 INFO - 'NUMBER_OF_PROCESSORS': '8', 09:49:45 INFO - 'OS': 'Windows_NT', 09:49:45 INFO - 'OURDRIVE': 'C:', 09:49:45 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 09:49:45 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 09:49:45 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 09:49:45 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 09:49:45 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 09:49:45 INFO - 'PROCESSOR_LEVEL': '6', 09:49:45 INFO - 'PROCESSOR_REVISION': '1e05', 09:49:45 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 09:49:45 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 09:49:45 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 09:49:45 INFO - 'PROGRAMW6432': 'C:\\Program Files', 09:49:45 INFO - 'PROMPT': '$P$G', 09:49:45 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 09:49:45 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 09:49:45 INFO - 'PUBLIC': 'C:\\Users\\Public', 09:49:45 INFO - 'PWD': 'C:\\slave\\test', 09:49:45 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 09:49:45 INFO - 'SLAVEDIR': 'C:\\slave\\', 09:49:45 INFO - 'SYSTEMDRIVE': 'C:', 09:49:45 INFO - 'SYSTEMROOT': 'C:\\windows', 09:49:45 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:49:45 INFO - 'TEST1': 'testie', 09:49:45 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:49:45 INFO - 'USERDOMAIN': 'T-W864-IX-077', 09:49:45 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-077', 09:49:45 INFO - 'USERNAME': 'cltbld', 09:49:45 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-077', 09:49:45 INFO - 'WINDIR': 'C:\\windows', 09:49:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 09:49:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:47 INFO - Downloading/unpacking psutil>=3.1.1 09:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:48 INFO - Installing collected packages: psutil 09:49:48 INFO - Successfully installed psutil 09:49:48 INFO - Cleaning up... 09:49:49 INFO - Return code: 0 09:49:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv C:\slave\test\build/venv 09:49:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:49 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 0x0237C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02423E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0252F330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0246AE90>, '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 0x01DBA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0290D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-077', 'USERDOMAIN': 'T-W864-IX-077', '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-077', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-077\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-077', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-077', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-077', '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-077\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 09:49:49 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in C:\slave\test\build 09:49:49 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:49:49 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 09:49:49 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-077\\AppData\\Roaming', 09:49:49 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 09:49:49 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 09:49:49 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 09:49:49 INFO - 'COMPUTERNAME': 'T-W864-IX-077', 09:49:49 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 09:49:49 INFO - 'DCLOCATION': 'SCL3', 09:49:49 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 09:49:49 INFO - 'FP_NO_HOST_CHECK': 'NO', 09:49:49 INFO - 'HOMEDRIVE': 'C:', 09:49:49 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-077', 09:49:49 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 09:49:49 INFO - 'KTS_VERSION': '1.19c', 09:49:49 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-077\\AppData\\Local', 09:49:49 INFO - 'LOGONSERVER': '\\\\T-W864-IX-077', 09:49:49 INFO - 'MONDIR': 'C:\\Monitor_config\\', 09:49:49 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 09:49:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:49 INFO - 'MOZ_NO_REMOTE': '1', 09:49:49 INFO - 'NO_EM_RESTART': '1', 09:49:49 INFO - 'NUMBER_OF_PROCESSORS': '8', 09:49:49 INFO - 'OS': 'Windows_NT', 09:49:49 INFO - 'OURDRIVE': 'C:', 09:49:49 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 09:49:49 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 09:49:49 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 09:49:49 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 09:49:49 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 09:49:49 INFO - 'PROCESSOR_LEVEL': '6', 09:49:49 INFO - 'PROCESSOR_REVISION': '1e05', 09:49:49 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 09:49:49 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 09:49:49 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 09:49:49 INFO - 'PROGRAMW6432': 'C:\\Program Files', 09:49:49 INFO - 'PROMPT': '$P$G', 09:49:49 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 09:49:49 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 09:49:49 INFO - 'PUBLIC': 'C:\\Users\\Public', 09:49:49 INFO - 'PWD': 'C:\\slave\\test', 09:49:49 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 09:49:49 INFO - 'SLAVEDIR': 'C:\\slave\\', 09:49:49 INFO - 'SYSTEMDRIVE': 'C:', 09:49:49 INFO - 'SYSTEMROOT': 'C:\\windows', 09:49:49 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:49:49 INFO - 'TEST1': 'testie', 09:49:49 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:49:49 INFO - 'USERDOMAIN': 'T-W864-IX-077', 09:49:49 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-077', 09:49:49 INFO - 'USERNAME': 'cltbld', 09:49:49 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-077', 09:49:49 INFO - 'WINDIR': 'C:\\windows', 09:49:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 09:49:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:49:50 INFO - Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor 09:49:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in c:\slave\test\build\venv\lib\site-packages (from mozsystemmonitor==0.3) 09:49:50 INFO - Installing collected packages: mozsystemmonitor 09:49:50 INFO - Running setup.py install for mozsystemmonitor 09:49:50 INFO - Successfully installed mozsystemmonitor 09:49:50 INFO - Cleaning up... 09:49:50 INFO - Return code: 0 09:49:50 INFO - Installing jsonschema==2.5.1 into virtualenv C:\slave\test\build/venv 09:49:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:50 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 0x0237C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02423E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0252F330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0246AE90>, '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 0x01DBA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0290D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-077', 'USERDOMAIN': 'T-W864-IX-077', '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-077', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-077\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-077', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-077', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-077', '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-077\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 09:49:50 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in C:\slave\test\build 09:49:50 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:49:50 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 09:49:50 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-077\\AppData\\Roaming', 09:49:50 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 09:49:50 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 09:49:50 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 09:49:50 INFO - 'COMPUTERNAME': 'T-W864-IX-077', 09:49:50 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 09:49:50 INFO - 'DCLOCATION': 'SCL3', 09:49:50 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 09:49:50 INFO - 'FP_NO_HOST_CHECK': 'NO', 09:49:50 INFO - 'HOMEDRIVE': 'C:', 09:49:50 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-077', 09:49:50 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 09:49:50 INFO - 'KTS_VERSION': '1.19c', 09:49:50 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-077\\AppData\\Local', 09:49:50 INFO - 'LOGONSERVER': '\\\\T-W864-IX-077', 09:49:50 INFO - 'MONDIR': 'C:\\Monitor_config\\', 09:49:50 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 09:49:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:50 INFO - 'MOZ_NO_REMOTE': '1', 09:49:50 INFO - 'NO_EM_RESTART': '1', 09:49:50 INFO - 'NUMBER_OF_PROCESSORS': '8', 09:49:50 INFO - 'OS': 'Windows_NT', 09:49:50 INFO - 'OURDRIVE': 'C:', 09:49:50 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 09:49:50 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 09:49:50 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 09:49:50 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 09:49:50 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 09:49:50 INFO - 'PROCESSOR_LEVEL': '6', 09:49:50 INFO - 'PROCESSOR_REVISION': '1e05', 09:49:50 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 09:49:50 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 09:49:50 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 09:49:50 INFO - 'PROGRAMW6432': 'C:\\Program Files', 09:49:50 INFO - 'PROMPT': '$P$G', 09:49:50 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 09:49:50 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 09:49:50 INFO - 'PUBLIC': 'C:\\Users\\Public', 09:49:50 INFO - 'PWD': 'C:\\slave\\test', 09:49:50 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 09:49:50 INFO - 'SLAVEDIR': 'C:\\slave\\', 09:49:50 INFO - 'SYSTEMDRIVE': 'C:', 09:49:50 INFO - 'SYSTEMROOT': 'C:\\windows', 09:49:50 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:49:50 INFO - 'TEST1': 'testie', 09:49:50 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:49:50 INFO - 'USERDOMAIN': 'T-W864-IX-077', 09:49:50 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-077', 09:49:50 INFO - 'USERNAME': 'cltbld', 09:49:50 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-077', 09:49:50 INFO - 'WINDIR': 'C:\\windows', 09:49:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 09:49:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:51 INFO - Downloading/unpacking jsonschema==2.5.1 09:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:49:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:52 INFO - Downloading functools32-3.2.3-2.tar.gz 09:49:52 INFO - Running setup.py (path:C:\slave\test\build\venv\build\functools32\setup.py) egg_info for package functools32 09:49:52 INFO - warning: no files found matching '*.txt' 09:49:52 INFO - no previously-included directories found matching 'build' 09:49:52 INFO - no previously-included directories found matching 'dist' 09:49:52 INFO - no previously-included directories found matching '.git*' 09:49:52 INFO - Installing collected packages: jsonschema, functools32 09:49:52 INFO - Running setup.py install for functools32 09:49:52 INFO - warning: no files found matching '*.txt' 09:49:52 INFO - no previously-included directories found matching 'build' 09:49:52 INFO - no previously-included directories found matching 'dist' 09:49:52 INFO - no previously-included directories found matching '.git*' 09:49:52 INFO - Successfully installed jsonschema functools32 09:49:52 INFO - Cleaning up... 09:49:53 INFO - Return code: 0 09:49:53 INFO - Installing functools32==3.2.3-2 into virtualenv C:\slave\test\build/venv 09:49:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:53 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 0x0237C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02423E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0252F330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0246AE90>, '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 0x01DBA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0290D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-077', 'USERDOMAIN': 'T-W864-IX-077', '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-077', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-077\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-077', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-077', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-077', '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-077\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 09:49:53 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in C:\slave\test\build 09:49:53 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:49:53 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 09:49:53 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-077\\AppData\\Roaming', 09:49:53 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 09:49:53 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 09:49:53 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 09:49:53 INFO - 'COMPUTERNAME': 'T-W864-IX-077', 09:49:53 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 09:49:53 INFO - 'DCLOCATION': 'SCL3', 09:49:53 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 09:49:53 INFO - 'FP_NO_HOST_CHECK': 'NO', 09:49:53 INFO - 'HOMEDRIVE': 'C:', 09:49:53 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-077', 09:49:53 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 09:49:53 INFO - 'KTS_VERSION': '1.19c', 09:49:53 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-077\\AppData\\Local', 09:49:53 INFO - 'LOGONSERVER': '\\\\T-W864-IX-077', 09:49:53 INFO - 'MONDIR': 'C:\\Monitor_config\\', 09:49:53 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 09:49:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:53 INFO - 'MOZ_NO_REMOTE': '1', 09:49:53 INFO - 'NO_EM_RESTART': '1', 09:49:53 INFO - 'NUMBER_OF_PROCESSORS': '8', 09:49:53 INFO - 'OS': 'Windows_NT', 09:49:53 INFO - 'OURDRIVE': 'C:', 09:49:53 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 09:49:53 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 09:49:53 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 09:49:53 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 09:49:53 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 09:49:53 INFO - 'PROCESSOR_LEVEL': '6', 09:49:53 INFO - 'PROCESSOR_REVISION': '1e05', 09:49:53 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 09:49:53 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 09:49:53 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 09:49:53 INFO - 'PROGRAMW6432': 'C:\\Program Files', 09:49:53 INFO - 'PROMPT': '$P$G', 09:49:53 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 09:49:53 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 09:49:53 INFO - 'PUBLIC': 'C:\\Users\\Public', 09:49:53 INFO - 'PWD': 'C:\\slave\\test', 09:49:53 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 09:49:53 INFO - 'SLAVEDIR': 'C:\\slave\\', 09:49:53 INFO - 'SYSTEMDRIVE': 'C:', 09:49:53 INFO - 'SYSTEMROOT': 'C:\\windows', 09:49:53 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:49:53 INFO - 'TEST1': 'testie', 09:49:53 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:49:53 INFO - 'USERDOMAIN': 'T-W864-IX-077', 09:49:53 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-077', 09:49:53 INFO - 'USERNAME': 'cltbld', 09:49:53 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-077', 09:49:53 INFO - 'WINDIR': 'C:\\windows', 09:49:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 09:49:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in c:\slave\test\build\venv\lib\site-packages 09:49:53 INFO - Cleaning up... 09:49:53 INFO - Return code: 0 09:49:53 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv 09:49:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:53 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 0x0237C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02423E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0252F330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0246AE90>, '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 0x01DBA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0290D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-077', 'USERDOMAIN': 'T-W864-IX-077', '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-077', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-077\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-077', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-077', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-077', '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-077\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 09:49:53 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in C:\slave\test\build 09:49:53 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:49:53 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 09:49:53 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-077\\AppData\\Roaming', 09:49:53 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 09:49:53 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 09:49:53 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 09:49:53 INFO - 'COMPUTERNAME': 'T-W864-IX-077', 09:49:53 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 09:49:53 INFO - 'DCLOCATION': 'SCL3', 09:49:53 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 09:49:53 INFO - 'FP_NO_HOST_CHECK': 'NO', 09:49:53 INFO - 'HOMEDRIVE': 'C:', 09:49:53 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-077', 09:49:53 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 09:49:53 INFO - 'KTS_VERSION': '1.19c', 09:49:53 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-077\\AppData\\Local', 09:49:53 INFO - 'LOGONSERVER': '\\\\T-W864-IX-077', 09:49:53 INFO - 'MONDIR': 'C:\\Monitor_config\\', 09:49:53 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 09:49:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:53 INFO - 'MOZ_NO_REMOTE': '1', 09:49:53 INFO - 'NO_EM_RESTART': '1', 09:49:53 INFO - 'NUMBER_OF_PROCESSORS': '8', 09:49:53 INFO - 'OS': 'Windows_NT', 09:49:53 INFO - 'OURDRIVE': 'C:', 09:49:53 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 09:49:53 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 09:49:53 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 09:49:53 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 09:49:53 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 09:49:53 INFO - 'PROCESSOR_LEVEL': '6', 09:49:53 INFO - 'PROCESSOR_REVISION': '1e05', 09:49:53 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 09:49:53 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 09:49:53 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 09:49:53 INFO - 'PROGRAMW6432': 'C:\\Program Files', 09:49:53 INFO - 'PROMPT': '$P$G', 09:49:53 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 09:49:53 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 09:49:53 INFO - 'PUBLIC': 'C:\\Users\\Public', 09:49:53 INFO - 'PWD': 'C:\\slave\\test', 09:49:53 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 09:49:53 INFO - 'SLAVEDIR': 'C:\\slave\\', 09:49:53 INFO - 'SYSTEMDRIVE': 'C:', 09:49:53 INFO - 'SYSTEMROOT': 'C:\\windows', 09:49:53 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:49:53 INFO - 'TEST1': 'testie', 09:49:53 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:49:53 INFO - 'USERDOMAIN': 'T-W864-IX-077', 09:49:53 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-077', 09:49:53 INFO - 'USERNAME': 'cltbld', 09:49:53 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-077', 09:49:53 INFO - 'WINDIR': 'C:\\windows', 09:49:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 09:49:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:54 INFO - Downloading/unpacking blobuploader==1.2.4 09:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:55 INFO - Downloading blobuploader-1.2.4.tar.gz 09:49:55 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader 09:49:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:55 INFO - Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests 09:49:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:56 INFO - Downloading docopt-0.6.1.tar.gz 09:49:56 INFO - Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt 09:49:56 INFO - Installing collected packages: blobuploader, requests, docopt 09:49:56 INFO - Running setup.py install for blobuploader 09:49:56 INFO - Running setup.py install for requests 09:49:56 INFO - Running setup.py install for docopt 09:49:57 INFO - Successfully installed blobuploader requests docopt 09:49:57 INFO - Cleaning up... 09:49:58 INFO - Return code: 0 09:49:58 INFO - Installing None into virtualenv C:\slave\test\build/venv 09:49:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:58 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 0x0237C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02423E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0252F330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0246AE90>, '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 0x01DBA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0290D520>, '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-077', 'USERDOMAIN': 'T-W864-IX-077', '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-077', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-077\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-077', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-077', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-077', '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-077\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 09:49:58 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--no-deps', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in C:\slave\test\build\tests\config 09:49:58 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --no-deps --timeout 120 -r C:\slave\test\build\tests\config\mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:49:58 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 09:49:58 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-077\\AppData\\Roaming', 09:49:58 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 09:49:58 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 09:49:58 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 09:49:58 INFO - 'COMPUTERNAME': 'T-W864-IX-077', 09:49:58 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 09:49:58 INFO - 'DCLOCATION': 'SCL3', 09:49:58 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 09:49:58 INFO - 'FP_NO_HOST_CHECK': 'NO', 09:49:58 INFO - 'HOMEDRIVE': 'C:', 09:49:58 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-077', 09:49:58 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 09:49:58 INFO - 'KTS_VERSION': '1.19c', 09:49:58 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-077\\AppData\\Local', 09:49:58 INFO - 'LOGONSERVER': '\\\\T-W864-IX-077', 09:49:58 INFO - 'MONDIR': 'C:\\Monitor_config\\', 09:49:58 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 09:49:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:58 INFO - 'MOZ_NO_REMOTE': '1', 09:49:58 INFO - 'NO_EM_RESTART': '1', 09:49:58 INFO - 'NUMBER_OF_PROCESSORS': '8', 09:49:58 INFO - 'OS': 'Windows_NT', 09:49:58 INFO - 'OURDRIVE': 'C:', 09:49:58 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 09:49:58 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 09:49:58 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 09:49:58 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 09:49:58 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 09:49:58 INFO - 'PROCESSOR_LEVEL': '6', 09:49:58 INFO - 'PROCESSOR_REVISION': '1e05', 09:49:58 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 09:49:58 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 09:49:58 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 09:49:58 INFO - 'PROGRAMW6432': 'C:\\Program Files', 09:49:58 INFO - 'PROMPT': '$P$G', 09:49:58 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 09:49:58 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 09:49:58 INFO - 'PUBLIC': 'C:\\Users\\Public', 09:49:58 INFO - 'PWD': 'C:\\slave\\test', 09:49:58 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 09:49:58 INFO - 'SLAVEDIR': 'C:\\slave\\', 09:49:58 INFO - 'SYSTEMDRIVE': 'C:', 09:49:58 INFO - 'SYSTEMROOT': 'C:\\windows', 09:49:58 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:49:58 INFO - 'TEST1': 'testie', 09:49:58 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:49:58 INFO - 'USERDOMAIN': 'T-W864-IX-077', 09:49:58 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-077', 09:49:58 INFO - 'USERNAME': 'cltbld', 09:49:58 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-077', 09:49:58 INFO - 'WINDIR': 'C:\\windows', 09:49:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 09:49:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:58 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 09:49:58 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-vl1ck3-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 09:49:58 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 09:49:58 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-g0cwxf-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 09:49:58 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 09:49:58 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ag7oqm-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 09:49:58 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 09:49:59 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-po0bql-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 09:49:59 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 09:49:59 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-znvuoy-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 09:49:59 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 09:49:59 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-txtpqp-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 09:49:59 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 09:49:59 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ilzkcq-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 09:49:59 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 09:49:59 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-goarec-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 09:49:59 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 09:49:59 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-yqx48z-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 09:49:59 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 09:49:59 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-gmj_o2-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 09:49:59 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 09:49:59 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-tu7rq_-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 09:49:59 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 09:49:59 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-wcruss-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 09:49:59 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 09:50:00 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-x7ymbz-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 09:50:00 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 09:50:00 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-5chm54-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 09:50:00 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 09:50:00 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xbf3nf-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 09:50:00 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 09:50:00 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-hdnsr5-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 09:50:00 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 09:50:00 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-pvgowz-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 09:50:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:50:00 INFO - Running setup.py install for manifestparser 09:50:00 INFO - Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts 09:50:00 INFO - Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts 09:50:01 INFO - Running setup.py install for mozcrash 09:50:01 INFO - Running setup.py install for mozdebug 09:50:01 INFO - Running setup.py install for mozdevice 09:50:02 INFO - Installing sutini-script.py script to C:\slave\test\build\venv\Scripts 09:50:02 INFO - Installing sutini.exe script to C:\slave\test\build\venv\Scripts 09:50:02 INFO - Installing dm-script.py script to C:\slave\test\build\venv\Scripts 09:50:02 INFO - Installing dm.exe script to C:\slave\test\build\venv\Scripts 09:50:02 INFO - Running setup.py install for mozfile 09:50:03 INFO - Running setup.py install for mozhttpd 09:50:03 INFO - Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts 09:50:03 INFO - Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts 09:50:03 INFO - Running setup.py install for mozinfo 09:50:03 INFO - Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts 09:50:03 INFO - Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts 09:50:04 INFO - Running setup.py install for mozInstall 09:50:04 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts 09:50:04 INFO - Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts 09:50:04 INFO - Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts 09:50:04 INFO - Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts 09:50:04 INFO - Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts 09:50:04 INFO - Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts 09:50:04 INFO - Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts 09:50:04 INFO - Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts 09:50:04 INFO - Running setup.py install for mozleak 09:50:04 INFO - Running setup.py install for mozlog 09:50:04 INFO - Installing structlog-script.py script to C:\slave\test\build\venv\Scripts 09:50:04 INFO - Installing structlog.exe script to C:\slave\test\build\venv\Scripts 09:50:05 INFO - Running setup.py install for moznetwork 09:50:05 INFO - Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts 09:50:05 INFO - Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts 09:50:05 INFO - Running setup.py install for mozprocess 09:50:06 INFO - Running setup.py install for mozprofile 09:50:06 INFO - Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts 09:50:06 INFO - Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts 09:50:06 INFO - Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts 09:50:06 INFO - Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts 09:50:06 INFO - Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts 09:50:06 INFO - Installing view-profile.exe script to C:\slave\test\build\venv\Scripts 09:50:07 INFO - Running setup.py install for mozrunner 09:50:07 INFO - Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts 09:50:07 INFO - Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts 09:50:07 INFO - Running setup.py install for mozscreenshot 09:50:08 INFO - Running setup.py install for moztest 09:50:08 INFO - Running setup.py install for mozversion 09:50:08 INFO - Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts 09:50:08 INFO - Installing mozversion.exe script to C:\slave\test\build\venv\Scripts 09:50:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:50:08 INFO - Cleaning up... 09:50:08 INFO - Return code: 0 09:50:08 INFO - Installing None into virtualenv C:\slave\test\build/venv 09:50:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:50:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:08 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 0x0237C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02423E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0252F330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0246AE90>, '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 0x01DBA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0290D520>, '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-077', 'USERDOMAIN': 'T-W864-IX-077', '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-077', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-077\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-077', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-077', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-077', '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-077\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 09:50:08 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in C:\slave\test\build\tests\config 09:50:08 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 -r C:\slave\test\build\tests\config\mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:50:09 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 09:50:09 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-077\\AppData\\Roaming', 09:50:09 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 09:50:09 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 09:50:09 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 09:50:09 INFO - 'COMPUTERNAME': 'T-W864-IX-077', 09:50:09 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 09:50:09 INFO - 'DCLOCATION': 'SCL3', 09:50:09 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 09:50:09 INFO - 'FP_NO_HOST_CHECK': 'NO', 09:50:09 INFO - 'HOMEDRIVE': 'C:', 09:50:09 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-077', 09:50:09 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 09:50:09 INFO - 'KTS_VERSION': '1.19c', 09:50:09 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-077\\AppData\\Local', 09:50:09 INFO - 'LOGONSERVER': '\\\\T-W864-IX-077', 09:50:09 INFO - 'MONDIR': 'C:\\Monitor_config\\', 09:50:09 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 09:50:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:09 INFO - 'MOZ_NO_REMOTE': '1', 09:50:09 INFO - 'NO_EM_RESTART': '1', 09:50:09 INFO - 'NUMBER_OF_PROCESSORS': '8', 09:50:09 INFO - 'OS': 'Windows_NT', 09:50:09 INFO - 'OURDRIVE': 'C:', 09:50: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', 09:50:09 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 09:50:09 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 09:50:09 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 09:50:09 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 09:50:09 INFO - 'PROCESSOR_LEVEL': '6', 09:50:09 INFO - 'PROCESSOR_REVISION': '1e05', 09:50:09 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 09:50:09 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 09:50:09 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 09:50:09 INFO - 'PROGRAMW6432': 'C:\\Program Files', 09:50:09 INFO - 'PROMPT': '$P$G', 09:50:09 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 09:50:09 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 09:50:09 INFO - 'PUBLIC': 'C:\\Users\\Public', 09:50:09 INFO - 'PWD': 'C:\\slave\\test', 09:50:09 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 09:50:09 INFO - 'SLAVEDIR': 'C:\\slave\\', 09:50:09 INFO - 'SYSTEMDRIVE': 'C:', 09:50:09 INFO - 'SYSTEMROOT': 'C:\\windows', 09:50:09 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:50:09 INFO - 'TEST1': 'testie', 09:50:09 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:50:09 INFO - 'USERDOMAIN': 'T-W864-IX-077', 09:50:09 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-077', 09:50:09 INFO - 'USERNAME': 'cltbld', 09:50:09 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-077', 09:50:09 INFO - 'WINDIR': 'C:\\windows', 09:50:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 09:50:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:09 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 09:50:09 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-omp0rv-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 09:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///C:/slave/test/build/tests/mozbase/manifestparser in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 1)) 09:50:09 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 09:50:09 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-cykug7-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 09:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///C:/slave/test/build/tests/mozbase/mozcrash in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2)) 09:50:09 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 09:50:09 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-o2ifxc-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 09:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///C:/slave/test/build/tests/mozbase/mozdebug in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 3)) 09:50:09 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 09:50:09 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-yfrfgn-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 09:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///C:/slave/test/build/tests/mozbase/mozdevice in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4)) 09:50:09 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 09:50:09 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-6jslok-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 09:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///C:/slave/test/build/tests/mozbase/mozfile in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 5)) 09:50:09 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 09:50:09 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-fxi4q3-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 09:50:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///C:/slave/test/build/tests/mozbase/mozhttpd in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 6)) 09:50:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 09:50:10 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-cdvjrz-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 09:50:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///C:/slave/test/build/tests/mozbase/mozinfo in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 7)) 09:50:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 09:50:10 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xg6zd7-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 09:50:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///C:/slave/test/build/tests/mozbase/mozinstall in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 8)) 09:50:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 09:50:10 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ob6q7z-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 09:50:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///C:/slave/test/build/tests/mozbase/mozleak in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 9)) 09:50:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 09:50:10 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-e1ls09-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 09:50:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///C:/slave/test/build/tests/mozbase/mozlog in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10)) 09:50:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 09:50:10 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-clmhmh-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 09:50:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///C:/slave/test/build/tests/mozbase/moznetwork in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 11)) 09:50:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 09:50:10 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qissqw-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 09:50:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///C:/slave/test/build/tests/mozbase/mozprocess in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 12)) 09:50:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 09:50:10 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-3p0eqb-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 09:50:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///C:/slave/test/build/tests/mozbase/mozprofile in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 13)) 09:50:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 09:50:10 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-dsjnnq-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 09:50:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///C:/slave/test/build/tests/mozbase/mozrunner in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 14)) 09:50:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 09:50:10 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-4vqsfi-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 09:50:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///C:/slave/test/build/tests/mozbase/mozscreenshot in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 15)) 09:50:11 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 09:50:11 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-_olldv-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 09:50:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///C:/slave/test/build/tests/mozbase/moztest in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 16)) 09:50:11 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 09:50:11 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-sgssfs-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 09:50:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///C:/slave/test/build/tests/mozbase/mozversion in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 17)) 09:50:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==0.17->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2)) 09:50:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==0.17->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2)) 09:50:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in c:\slave\test\build\venv\lib\site-packages (from mozdebug==0.1->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 3)) 09:50:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test\build\venv\lib\site-packages (from mozdevice==0.48->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4)) 09:50:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in c:\slave\test\build\venv\lib\site-packages (from mozdevice==0.48->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4)) 09:50:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10)) 09:50:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:12 INFO - Downloading blessings-1.6.tar.gz 09:50:12 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings 09:50:12 INFO - Installing collected packages: blessings 09:50:12 INFO - Running setup.py install for blessings 09:50:12 INFO - Successfully installed blessings 09:50:12 INFO - Cleaning up... 09:50:15 INFO - Return code: 0 09:50:15 INFO - Done creating virtualenv C:\slave\test\build/venv. 09:50:15 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 09:50:15 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 09:50:16 INFO - Reading from file tmpfile_stdout 09:50:16 INFO - Using _rmtree_windows ... 09:50:16 INFO - Using _rmtree_windows ... 09:50:16 INFO - Current package versions: 09:50:16 INFO - blessings == 1.6 09:50:16 INFO - blobuploader == 1.2.4 09:50:16 INFO - docopt == 0.6.1 09:50:16 INFO - functools32 == 3.2.3-2 09:50:16 INFO - jsonschema == 2.5.1 09:50:16 INFO - manifestparser == 1.1 09:50:16 INFO - mozInstall == 1.12 09:50:16 INFO - mozcrash == 0.17 09:50:16 INFO - mozdebug == 0.1 09:50:16 INFO - mozdevice == 0.48 09:50:16 INFO - mozfile == 1.2 09:50:16 INFO - mozhttpd == 0.7 09:50:16 INFO - mozinfo == 0.9 09:50:16 INFO - mozleak == 0.1 09:50:16 INFO - mozlog == 3.4 09:50:16 INFO - moznetwork == 0.27 09:50:16 INFO - mozprocess == 0.23 09:50:16 INFO - mozprofile == 0.28 09:50:16 INFO - mozrunner == 6.12 09:50:16 INFO - mozscreenshot == 0.1 09:50:16 INFO - mozsystemmonitor == 0.3 09:50:16 INFO - moztest == 0.7 09:50:16 INFO - mozversion == 1.4 09:50:16 INFO - psutil == 3.1.1 09:50:16 INFO - requests == 1.2.3 09:50:16 INFO - Installing None into virtualenv C:\slave\test\build/venv 09:50:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:50:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:50:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:16 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 0x0237C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02423E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0252F330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0246AE90>, '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 0x01DBA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0290D520>, '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-077', 'USERDOMAIN': 'T-W864-IX-077', '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-077', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-077\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-077', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-077', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-077', '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-077\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 09:50:16 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\talos\\requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in C:\slave\test\build\tests\talos 09:50:16 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 -r C:\slave\test\build\tests\talos\requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:50:16 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 09:50:16 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-077\\AppData\\Roaming', 09:50:16 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 09:50:16 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 09:50:16 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 09:50:16 INFO - 'COMPUTERNAME': 'T-W864-IX-077', 09:50:16 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 09:50:16 INFO - 'DCLOCATION': 'SCL3', 09:50:16 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 09:50:16 INFO - 'FP_NO_HOST_CHECK': 'NO', 09:50:16 INFO - 'HOMEDRIVE': 'C:', 09:50:16 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-077', 09:50:16 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 09:50:16 INFO - 'KTS_VERSION': '1.19c', 09:50:16 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-077\\AppData\\Local', 09:50:16 INFO - 'LOGONSERVER': '\\\\T-W864-IX-077', 09:50:16 INFO - 'MONDIR': 'C:\\Monitor_config\\', 09:50:16 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 09:50:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:16 INFO - 'MOZ_NO_REMOTE': '1', 09:50:16 INFO - 'NO_EM_RESTART': '1', 09:50:16 INFO - 'NUMBER_OF_PROCESSORS': '8', 09:50:16 INFO - 'OS': 'Windows_NT', 09:50:16 INFO - 'OURDRIVE': 'C:', 09:50:16 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 09:50:16 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 09:50:16 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 09:50:16 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 09:50:16 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 09:50:16 INFO - 'PROCESSOR_LEVEL': '6', 09:50:16 INFO - 'PROCESSOR_REVISION': '1e05', 09:50:16 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 09:50:16 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 09:50:16 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 09:50:16 INFO - 'PROGRAMW6432': 'C:\\Program Files', 09:50:16 INFO - 'PROMPT': '$P$G', 09:50:16 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 09:50:16 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 09:50:16 INFO - 'PUBLIC': 'C:\\Users\\Public', 09:50:16 INFO - 'PWD': 'C:\\slave\\test', 09:50:16 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 09:50:16 INFO - 'SLAVEDIR': 'C:\\slave\\', 09:50:16 INFO - 'SYSTEMDRIVE': 'C:', 09:50:16 INFO - 'SYSTEMROOT': 'C:\\windows', 09:50:16 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:50:16 INFO - 'TEST1': 'testie', 09:50:16 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:50:16 INFO - 'USERDOMAIN': 'T-W864-IX-077', 09:50:16 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-077', 09:50:16 INFO - 'USERNAME': 'cltbld', 09:50:16 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-077', 09:50:16 INFO - 'WINDIR': 'C:\\windows', 09:50:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 09:50:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 1)) 09:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 2)) 09:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 3)) 09:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 4)) 09:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 5)) 09:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 6)) 09:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 7)) 09:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 8)) 09:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 9)) 09:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in c:\slave\test\build\venv\lib\site-packages (from mozlog>=3.1->-r C:\slave\test\build\tests\talos\requirements.txt (line 1)) 09:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test\build\venv\lib\site-packages (from mozhttpd>=0.7->-r C:\slave\test\build\tests\talos\requirements.txt (line 4)) 09:50:16 INFO - Cleaning up... 09:50:16 INFO - Return code: 0 09:50:16 INFO - Installing jsonschema into virtualenv C:\slave\test\build/venv 09:50:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:50:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:50:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:16 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 0x0237C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02423E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0252F330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0246AE90>, '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 0x01DBA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0290D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-077', 'USERDOMAIN': 'T-W864-IX-077', '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-077', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-077\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-077', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-077', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-077', '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-077\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 09:50:16 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in C:\slave\test\build 09:50:16 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:50:16 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 09:50:16 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-077\\AppData\\Roaming', 09:50:16 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 09:50:16 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 09:50:16 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 09:50:16 INFO - 'COMPUTERNAME': 'T-W864-IX-077', 09:50:16 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 09:50:16 INFO - 'DCLOCATION': 'SCL3', 09:50:16 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 09:50:16 INFO - 'FP_NO_HOST_CHECK': 'NO', 09:50:16 INFO - 'HOMEDRIVE': 'C:', 09:50:16 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-077', 09:50:16 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 09:50:16 INFO - 'KTS_VERSION': '1.19c', 09:50:16 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-077\\AppData\\Local', 09:50:16 INFO - 'LOGONSERVER': '\\\\T-W864-IX-077', 09:50:16 INFO - 'MONDIR': 'C:\\Monitor_config\\', 09:50:16 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 09:50:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:16 INFO - 'MOZ_NO_REMOTE': '1', 09:50:16 INFO - 'NO_EM_RESTART': '1', 09:50:16 INFO - 'NUMBER_OF_PROCESSORS': '8', 09:50:16 INFO - 'OS': 'Windows_NT', 09:50:16 INFO - 'OURDRIVE': 'C:', 09:50:16 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 09:50:16 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 09:50:16 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 09:50:16 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 09:50:16 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 09:50:16 INFO - 'PROCESSOR_LEVEL': '6', 09:50:16 INFO - 'PROCESSOR_REVISION': '1e05', 09:50:16 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 09:50:16 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 09:50:16 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 09:50:16 INFO - 'PROGRAMW6432': 'C:\\Program Files', 09:50:16 INFO - 'PROMPT': '$P$G', 09:50:16 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 09:50:16 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 09:50:16 INFO - 'PUBLIC': 'C:\\Users\\Public', 09:50:16 INFO - 'PWD': 'C:\\slave\\test', 09:50:16 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 09:50:16 INFO - 'SLAVEDIR': 'C:\\slave\\', 09:50:16 INFO - 'SYSTEMDRIVE': 'C:', 09:50:16 INFO - 'SYSTEMROOT': 'C:\\windows', 09:50:16 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:50:16 INFO - 'TEST1': 'testie', 09:50:16 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:50:16 INFO - 'USERDOMAIN': 'T-W864-IX-077', 09:50:16 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-077', 09:50:16 INFO - 'USERNAME': 'cltbld', 09:50:16 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-077', 09:50:16 INFO - 'WINDIR': 'C:\\windows', 09:50:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 09:50:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in c:\slave\test\build\venv\lib\site-packages 09:50:16 INFO - Cleaning up... 09:50:16 INFO - Return code: 0 09:50:16 INFO - Running post-action listener: _resource_record_post_action 09:50:16 INFO - Running post-action listener: _start_resource_monitoring 09:50:16 INFO - Starting resource monitoring. 09:50:16 INFO - [mozharness: 2016-10-17 16:50:16.912000Z] Finished create-virtualenv step (success) 09:50:16 INFO - [mozharness: 2016-10-17 16:50:16.912000Z] Running install step. 09:50:16 INFO - Running pre-action listener: _resource_record_pre_action 09:50:16 INFO - Running main action method: install 09:50:16 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 09:50:16 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 09:50:17 INFO - Reading from file tmpfile_stdout 09:50:17 INFO - Using _rmtree_windows ... 09:50:17 INFO - Using _rmtree_windows ... 09:50:17 INFO - Detecting whether we're running mozinstall >=1.0... 09:50:17 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h'] 09:50:17 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h 09:50:17 INFO - Reading from file tmpfile_stdout 09:50:17 INFO - Output received: 09:50:17 INFO - Usage: mozinstall-script.py [options] installer 09:50:17 INFO - Options: 09:50:17 INFO - -h, --help show this help message and exit 09:50:17 INFO - -d DEST, --destination=DEST 09:50:17 INFO - Directory to install application into. [default: 09:50:17 INFO - "C:\slave\test"] 09:50:17 INFO - --app=APP Application being installed. [default: firefox] 09:50:17 INFO - Using _rmtree_windows ... 09:50:17 INFO - Using _rmtree_windows ... 09:50:17 INFO - mkdir: C:\slave\test\build\application 09:50:17 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', 'C:\\slave\\test\\build\\firefox-52.0a1.en-US.win64.zip', '--destination', 'C:\\slave\\test\\build\\application'] 09:50:17 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py C:\slave\test\build\firefox-52.0a1.en-US.win64.zip --destination C:\slave\test\build\application ProcessManager NOT managing child processes 09:50:19 INFO - Reading from file tmpfile_stdout 09:50:19 INFO - Output received: 09:50:19 INFO - C:\slave\test\build\application\firefox\firefox.exe 09:50:19 INFO - Using _rmtree_windows ... 09:50:19 INFO - Using _rmtree_windows ... 09:50:19 INFO - Running post-action listener: _resource_record_post_action 09:50:19 INFO - [mozharness: 2016-10-17 16:50:19.430000Z] Finished install step (success) 09:50:19 INFO - [mozharness: 2016-10-17 16:50:19.430000Z] Running run-tests step. 09:50:19 INFO - Running pre-action listener: _resource_record_pre_action 09:50:19 INFO - Running main action method: run_tests 09:50:19 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version'] 09:50:19 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version 09:50:19 INFO - Python 2.7.3 09:50:19 INFO - Return code: 0 09:50:19 INFO - grabbing minidump binary from tooltool 09:50: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')]} 09:50:19 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 0x0246AE90>, '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 0x01DBA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0290D520>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1 09:50:19 INFO - Running command: ['c:/mozilla-build/python27/python.exe', 'C:/mozilla-build/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', 'c:\\builds\\relengapi.tok', 'fetch', '-m', 'C:\\slave\\test\\build\\tests\\config/tooltool-manifests/win32/releng.manifest', '-o'] in C:\slave\test\build 09:50:19 INFO - Copy/paste: c:/mozilla-build/python27/python.exe C:/mozilla-build/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file c:\builds\relengapi.tok fetch -m C:\slave\test\build\tests\config/tooltool-manifests/win32/releng.manifest -o 09:50:19 INFO - Calling ['c:/mozilla-build/python27/python.exe', 'C:/mozilla-build/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', 'c:\\builds\\relengapi.tok', 'fetch', '-m', 'C:\\slave\\test\\build\\tests\\config/tooltool-manifests/win32/releng.manifest', '-o'] with output_timeout 600 ProcessManager UNABLE to use job objects to manage child processes 09:50:19 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 09:50:21 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmpiqhovn 09:50:21 INFO - INFO - File integrity verified, renaming tmpiqhovn to win32-minidump_stackwalk.exe 09:50:21 INFO - Return code: 0 09:50:21 INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755 09:50:21 INFO - mkdir: C:\slave\test\build\blobber_upload_dir 09:50:21 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir 09:50:21 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe 09:50:21 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir 09:50:21 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/Bz1EB0CvRv-h0jjmtgecPA/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-077', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs_errorsummary.log', '--log-raw=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs_raw.log'] in C:\slave\test\build 09:50:21 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/Bz1EB0CvRv-h0jjmtgecPA/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip --title T-W864-IX-077 --webServer localhost --log-tbpl-level=debug --log-errorsummary=C:\slave\test\build\blobber_upload_dir\dromaeojs_errorsummary.log --log-raw=C:\slave\test\build\blobber_upload_dir\dromaeojs_raw.log 09:50:21 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 09:50:21 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-077\\AppData\\Roaming', 09:50:21 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 09:50:21 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 09:50:21 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 09:50:21 INFO - 'COMPUTERNAME': 'T-W864-IX-077', 09:50:21 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 09:50:21 INFO - 'DCLOCATION': 'SCL3', 09:50:21 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 09:50:21 INFO - 'FP_NO_HOST_CHECK': 'NO', 09:50:21 INFO - 'HOMEDRIVE': 'C:', 09:50:21 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-077', 09:50:21 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 09:50:21 INFO - 'KTS_VERSION': '1.19c', 09:50:21 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-077\\AppData\\Local', 09:50:21 INFO - 'LOGONSERVER': '\\\\T-W864-IX-077', 09:50:21 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir', 09:50:21 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe', 09:50:21 INFO - 'MONDIR': 'C:\\Monitor_config\\', 09:50:21 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 09:50:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:21 INFO - 'MOZ_NO_REMOTE': '1', 09:50:21 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir', 09:50:21 INFO - 'NO_EM_RESTART': '1', 09:50:21 INFO - 'NUMBER_OF_PROCESSORS': '8', 09:50:21 INFO - 'OS': 'Windows_NT', 09:50:21 INFO - 'OURDRIVE': 'C:', 09:50:21 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 09:50:21 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 09:50:21 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 09:50:21 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 09:50:21 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 09:50:21 INFO - 'PROCESSOR_LEVEL': '6', 09:50:21 INFO - 'PROCESSOR_REVISION': '1e05', 09:50:21 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 09:50:21 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 09:50:21 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 09:50:21 INFO - 'PROGRAMW6432': 'C:\\Program Files', 09:50:21 INFO - 'PROMPT': '$P$G', 09:50:21 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 09:50:21 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 09:50:21 INFO - 'PUBLIC': 'C:\\Users\\Public', 09:50:21 INFO - 'PWD': 'C:\\slave\\test', 09:50:21 INFO - 'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos', 09:50:21 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 09:50:21 INFO - 'SLAVEDIR': 'C:\\slave\\', 09:50:21 INFO - 'SYSTEMDRIVE': 'C:', 09:50:21 INFO - 'SYSTEMROOT': 'C:\\windows', 09:50:21 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:50:21 INFO - 'TEST1': 'testie', 09:50:21 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:50:21 INFO - 'USERDOMAIN': 'T-W864-IX-077', 09:50:21 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-077', 09:50:21 INFO - 'USERNAME': 'cltbld', 09:50:21 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-077', 09:50:21 INFO - 'WINDIR': 'C:\\windows', 09:50:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 09:50:21 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/Bz1EB0CvRv-h0jjmtgecPA/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-077', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs_errorsummary.log', '--log-raw=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs_raw.log'] with output_timeout 3600 ProcessManager NOT managing child processes ProcessManager UNABLE to use job objects to manage child processes 09:50:22 INFO - mozversion application_buildid: 20161017063144 09:50:22 INFO - mozversion application_changeset: a7fc516956bc16b7a0463e0cc9eb996f2f842314 09:50:22 INFO - mozversion application_display_name: Nightly 09:50:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:50:22 INFO - mozversion application_name: Firefox 09:50:22 INFO - mozversion application_remotingname: firefox 09:50:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 09:50:22 INFO - mozversion application_vendor: Mozilla 09:50:22 INFO - mozversion application_version: 52.0a1 09:50:22 INFO - mozversion platform_buildid: 20161017063144 09:50:22 INFO - mozversion platform_changeset: a7fc516956bc16b7a0463e0cc9eb996f2f842314 09:50:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 09:50:22 INFO - mozversion platform_version: 52.0a1 09:50:22 INFO - using testdate: 1476723022 09:50:22 INFO - actual date: 1476723022 09:50:22 INFO - starting webserver on 'localhost:49275' 09:50:22 INFO - SUITE-START | Running 2 tests 09:50:22 INFO - TEST-START | dromaeo_css 09:50:22 INFO - operating with platform_type : w8_ 09:50:22 INFO - Initialising browser for dromaeo_css test... 09:50:22 INFO - TEST-INFO | started process 3124 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmp8agkqc\profile http://localhost:49275/getInfo.html) 09:50:30 INFO - PROCESS | 3124 | __metrics Screen width/height:1600/1200 09:50:30 INFO - PROCESS | 3124 | colorDepth:24 09:50:30 INFO - PROCESS | 3124 | Browser inner width/height: 1010/674 09:50:30 INFO - PROCESS | 3124 | __metrics 09:50:31 INFO - PROCESS | 3124 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:50:31 INFO - PROCESS | 3124 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:50:32 INFO - TEST-INFO | 3124: exit 0 09:50:32 INFO - Browser initialized. 09:50:32 INFO - Running cycle 1/1 for dromaeo_css test... 09:50:32 INFO - TEST-INFO | started process 3764 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmp8agkqc\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:50:33 INFO - PROCESS | 3764 | [GFX1-]: Invalid size in UpdateRenderTarget Size(124,0), 0 09:50:44 INFO - PROCESS | 3764 | RSS: Main: 160972800 09:50:44 INFO - PROCESS | 3764 | 09:51:35 INFO - PROCESS | 3764 | 1476723095159 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:53:47 INFO - PROCESS | 3764 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 09:53:48 INFO - PROCESS | 3764 | RSS: Main: 268611584 09:53:48 INFO - PROCESS | 3764 | 09:56:51 INFO - PROCESS | 3764 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 09:56:51 INFO - PROCESS | 3764 | RSS: Main: 232140800 09:56:51 INFO - PROCESS | 3764 | 09:59:53 INFO - PROCESS | 3764 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 09:59:54 INFO - PROCESS | 3764 | RSS: Main: 183808000 09:59:54 INFO - PROCESS | 3764 | 10:02:56 INFO - PROCESS | 3764 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 10:02:57 INFO - PROCESS | 3764 | RSS: Main: 171294720 10:02:57 INFO - PROCESS | 3764 | 10:06:00 INFO - PROCESS | 3764 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 10:06:00 INFO - PROCESS | 3764 | RSS: Main: 169934848 10:06:00 INFO - PROCESS | 3764 | 10:09:03 INFO - PROCESS | 3764 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 10:09:03 INFO - PROCESS | 3764 | RSS: Main: 387383296 10:09:03 INFO - PROCESS | 3764 | 10:09:03 INFO - PROCESS | 3764 | __start_tp_report 10:09:03 INFO - PROCESS | 3764 | _x_x_mozilla_page_load 10:09:03 INFO - PROCESS | 3764 | _x_x_mozilla_page_load_details 10:09:03 INFO - PROCESS | 3764 | |i|pagename|runs| 10:09:03 INFO - PROCESS | 3764 | |0;dojo.html;2889.5665650152473;2911.446825103229;2925.809822361546;2949.837758923258;2961.1856739396662;5284.682919024856;5310.6017048721405;5344.35867695877;5345.759440825167;5384.91922621161;5219.243209734586;5244.737763111839;5257.86855328616;5274.789008439658;5279.577633789307;4714.127886341021;4735.9526404736025;4747.335373047776;4762.880927976794;4815.566599006089;4780.78486468108;4799.952000480003;4805.0389922015565;4807.711537307755;4840.491748366406;4749.4063242094735;4756.357891684613;4779.139754844126;4793.880152996168;4799.880002999918;4814.470408255124;4816.060868130716;4834.854954351375;4852.393450818648;4918.409790825124;4659.114768194032;4662.230731929228;4684.906301873977;4699.295105734133;4744.14605371033;5192.740362981874;5212.4266330703595;5250.763715632767;5266.368035835724;5309.41596424393;5577.358603760579;5661.207430959669;5689.687067211302;5700.600957932947;5709.714514274269;5585;5687;5719.771209151629;5733.569982251306;5738.885222295531;5231.607629427808;5256.369235691665;5267.604929630293;5276.103062479349;5303.655262407931;5831.3877042910735;5866.061430171152;5873.2658417697785;5873.911891321633;5880.970595147082;5396.406395296514;5583.302087239095;5585.3297604287745;5587.916181257285;5592.496675299161;5531.695756733418;5661.094224923992;5710.086386178192;5721.284839395075;5770.2498675171955;5618.887622247532;5650.095984642519;5661.46216109469;5663.263775709213;5663.348714897839;5597.160425936061;5665.886682266331;5672.7730890763905;5674.546036317085;5732.598718089777;3648.3980143276594;3682.742208045411;3684.042149041215;3685.7419980601635;3692.1877187018813;3324.819689010415;3336.215989242526;3337.499375093707;3373.3421982713626;3376.122208225879;5238.92141617876;5282.735863206824;5285.07511185541;5292.285541451932;5337.653052551572;5485.9725701371235;5549.500544950974;5572.359178694421;5722.37053924068;5731.656100633975;5173.172292433268;5173.456787037382;5178.948210517847;5183.403908550565;5185.22221666753;4614.653900957442;4618.907621847611;4620.653450991189;4626.814927402934;4628.745419001987;5703.173039909273;5704.258446401941;5709.115087161496;5714.485696287271;5715.628484148517;5615.129654903497;5617.775288988558;5618.157276408571;5618.297712785902;5629.324481062299;5814.069748840166;5865.296164460292;5878.2064421302575;5879.265091863517;5882.941170588239;5619.80330688424;5643.266375371176;5673.290838645169;5687.090065589486;5690.829275121753;5686.2323586315315;5761.135829625589;5763.308402991668;5765.164051212467;5765.423457654201;5415.431379705232;5627.352854421631;5632.774689012557;5633.324001119728;5640.943590564042;5436.53789427903;5482.972585137049;5517.475839795213;5542.3626282977975;5609.971950140223;5518.806841760519;5523.392426832965;5533;5534.1145416733125;5586.972065139648;5614.9719251403485;5616.241807356118;5619.494245517923;5628.240187574625;5628.634138780966;5419.4038655747045;5421.403645598902;5455.263539422286;5514.531264842373;5532.743028076817 10:09:03 INFO - PROCESS | 3764 | |1;ext.html;558.3969313141807;558.8630785457564;574.244867998582;578.0721941284236;581.9941800581993;29304.706952930464;29879.70120298799;31216.68783312166;31256.843715781448;36443.81778091112;37228;37404.625953740455;37704.43443348352;37891.052723681925;37940.43089353662;8210.71262505811;8292.419530632858;8353.498790072616;8363.707270245543;8372.079071302182;7565.130010048832;7770.533767973911;8313.875291870596;8383.413161078726;8419.07390187079;7793.883091753628;7810.726624568141;7849.097353804328;9854.802903941916;10110.545025473835;9971.750706232402;9997.600095996151;10003.74990625233;10047.447390393525;10064.547095380725;9792.657256995972;9829.754256143653;9888.505574721235;9894.10953014225;9908.207343412581;29349;29852.402951941058;29987.700122998707;31401.685983140105;36570.26859462796;3087.861046252924;3212.7429805615493;3265.7387409007224;3737.4767532545466;3788.6021967693273;28935.71064289351;29117;29152.41695166106;29299.853500732574;29753.70246297531;3982.780947047911;4024.7786371749544;4066.3493840985598;4116;4166.66666666666;289518;293699;294885;295476;297022;47579.28631070536;47633;47814;47852.76073619679;47911.520884791404;31662.841685791886;32446;49155.262671059965;49254.261186082236;49308.26037609439;14926.925365373321;15272.770908436383;15353.923230383776;15358.078515289119;15371.15458649785;11684.824727629093;11700.2979821211;11708.941455292668;11743.944809658276;11746.471408786625;14623.488177913934;16182.352705891868;16191.352345906267;16199.109049002182;16240.1067941262;5561.360443548962;6539.705713242915;6543.640099794557;6558.606483610999;6640.402363787282;792.6948124971811;874.5321253129545;916.2898753465984;937.2782957122977;973.78576713123;27663.30841728973;27850;27909.860450697615;28232.29419264494;28332.433351332857;937.3344925103116;988.8912219655832;993.1210878372548;994.9651762188289;1019.576875596634;14219.289035548181;14614.561563153122;14658.926705366404;14934;14947.103173809606;426101;427289;427699;428183;428791;43463;44878.77560612176;46739.766301168274;48022.27966580504;48224.27663585049;1162.3723189477757;1173.4308860202625;1183.2427246562206;1184.1651635596884;1185.0637995983077;27844.30389240204;28438.573421398283;28761.85619071975;28937.276568085967;29072.56391154092;42331.7883410581;42674;42779.35830962476;42798.786006071015;42843;367740;368357;369900;371644;373219;24731.876340618182;25115.49769004646;25151.371215719755;25155.622665659663;25223.621645675696;39789;41225;41497.37753933754;42463;42616.36075458809;35561;35775.82112089423;35830;36278.81860590786;36606.084847879014;35447.63247491484;35770.64229357673;35832.00214313371;36147.27705445824;36598.268034638626;34023.31953360968;34077.14807129842;34420.48369274413;34470;34962.72742271846;31967;32454.83772581122;32653;32794.83602581972;33042.66957330396;24631.137910173056;24916.875415622806;25001.499970000135;25029.49941001206;25064.525952663305 10:09:04 INFO - PROCESS | 3764 | |2;jquery.html;322.8321272938074;334.5097590235501;335.47498165371184;339.5297512944571;347.8799814064147;12941.805872911902;13513.459461621536;16164.75752863708;16374.099424531645;16496.75254871178;16278.186090695477;16947.237374318156;17080.23138958747;17121;17270.82729172708;5112.616553758465;5172.456892026349;5238.554722848562;5409.83770486886;5411.107167317388;3810.371288737369;5206.947930520703;5292.364916210041;5292.629515933886;5295.7881684732565;4020.0552870075508;5493.2034854946005;5748.166515855199;5753.453421924911;5813.563982701293;5641.717914104278;5799.623024503415;5804.622699524517;5810.709464526778;5850.707464626794;5104.540591346797;5141.126008578551;5141.177411614124;5144.382674079097;5144.459831717653;19478.51303717404;19747.21011159552;20166.39500814978;20310;20331.18675252988;2202.6365649667787;2244.6408574628144;2783.582462630601;2953.099304712062;3148.889788857402;14371.209583472904;15032.699346013018;15171.924140379228;15237.771433428508;15344.232788360538;1912.961740765177;1945.9902700486548;1984.1765667248076;1984.9206031758713;2029.573789504206;85701.99999999937;86871;87933.12066879313;88345.55827220887;92782;15250.46623368199;15551.844481555267;15846.76229856553;15858.44495442677;15883.28525216368;26796.866015669795;26840.06059787898;26903.040665526776;26928.576428121563;26958.191254262405;8963.327750418744;9047.185753282236;9076.500792456478;9104.271658267455;9219.262459003263;7657.234276572298;7661.923380766121;7668.616569171519;7695.884561731578;7773.3004029637605;7828.765137045898;7944.523328600302;7948.165442628557;7949.880751788728;7953.880691789628;3159.2891599389955;3224.3712476066944;3231.2083539532964;3261.6249131349723;3311.9006429807146;781.5740421470313;819.2381085590339;904.9909500905038;907.9228265597366;933.5110498754476;16517.421890233785;16747;16867.409640662765;17229.483115506555;17447.12764361777;816.621463781605;817.5176645778901;862.4437237981467;865.904750477447;924.4638109896244;8896.688615898542;9307.603859421006;9333.533323333942;9423.717288481219;9529.571169297398;210140;380531;408719;415945;416526;76101;83788.16211837926;87248;87275.56362218276;87521;876.4565969099199;900.0369604523097;920.4661296448044;924.505389616552;924.5284904698652;15304.540863774104;15380.077195368314;15563.688726225639;15785.605359866095;15844;36674.26651467009;36959.260814784095;37381.43927841139;37465;38711.2257754849;50449.24326135038;50712.492875072254;50958.74520627373;51215.487845121075;51699.74150129225;7206.495545311778;7366.337029667356;7419.109706835215;7430.331270185493;7860.5676687782725;10424.218183636409;11805.76388472243;11871;11918;12120.09099317537;9580.185684216642;10224.335418197794;10301.896981030093;10472.10987066108;10753.838692419464;9168.495732734496;9174.403663761834;9527.857082143635;10353.792924141324;10463.372197668165;9423.717288481357;10248;10485;10519.73700657459;10644.627438039632;7664.80837979055;7675.385969122569;7689.50018248812;7724.961375193088;7816.452848300564;8490.405671603176;9832.31173817826;10058.698239052841;10109.394563693857;10184.949075254577 10:09:04 INFO - PROCESS | 3764 | |3;mootools.html;1172.0740614914218;1239.2936026464915;1255.9937200313998;1298.7921932490801;1516.3631274864556;6441.581297215684;6985.126859142607;7079.539829911058;7181.712731490734;7400.481966262364;7422.4062075034;7465.104187497494;7501.137369202544;7506.7372641957545;7509.586972716512;1986.1558837494078;2002.0590322548378;2008.3071340387544;2011;2011.1050582490798;1985.3051431998829;2007.7590689117326;2007.7691065527506;2018.28350935418;2020.2121172742643;1989.6219718253485;1999.070432249004;2001.4696105532046;2008.0963566395108;2009.5980803839218;1952.8144826241555;1954.4429837496386;1956.0610906764691;1956.8923709195988;1958.1579920634122;1942.3104797796861;1953.794851540582;1959.5395082155824;1990.5222746540726;1992.6811710126456;7258.0927384076995;7294.598797066159;7312.707491700326;7416.7404140854815;7510.737124200681;4298.376735373385;4382.320740285261;4386.670999675037;4390.473143222834;4402.295632698753;2937.970620293791;3013.2015016020773;3045.284358175827;3047.9238019049703;3051.7406020488284;1024.8104100741386;1032.9845052324222;1042.306865934153;1050.2910535388583;1053.262716098734;9282.53587320638;9476.715698529055;9500.714978550655;9650.90349096507;9656.662016829447;3715.034091136324;3722.3113723961155;3735.43968404736;3833.50164478616;3837.079101015792;7612.276833700789;7613.467057306047;7632.732854350071;7640.121386040565;7696.499727517694;4325.97837010813;4326.805293761789;4329.441401095603;4330.2638551446325;4334.306510958231;3637.4907512948207;3735.7198210134347;3950.288947989332;4025.9798701006894;4076.1236334188293;3076.9077027621433;3154.0537838648315;3194.8242846643657;3196.568463257477;3318.1704573856537;924.7872989212519;929.809389075238;930.9860352094724;944.4946953379908;954.5036580977992;740.988885166723;794.5868148562715;801.2628381888676;801.8115742800437;803.1847674610275;4745;4782.760861956958;4892.828750993698;4915.975420122876;5100.617453690988;372.9706011408478;375.9229357981607;386.9806509674505;393.8621482481109;395.6419440406437;3168.2712976015187;3421.1447138215444;3488.2151515909227;3644.7630903991158;3660.3228402745576;8922.375433719577;9093.454392736458;9106.544672766335;9128.45229286245;9179.265658747285;9090.227330676966;9092.8636070459;9118.179363857153;9121.817563648823;9134.725958221265;6849.280825513349;7033.437325013987;7045.68294426752;7056.941458781122;7080.398166155935;4829.0320970399125;5130.794768209379;5131.79472821083;5189.610779191651;5314.893702125859;8383.53890536002;8484.89696339472;8504.107068757692;8521.147885211429;8639.611217495354;8598.82802343962;8667.219950204511;8721.258693011165;8764.649414023368;8880;6455.193100862392;6602.504812139013;6849.04113424131;6849.24658287578;6851.554648947803;7167.462440316893;7326.1941186468375;7329.1937886833475;7404.185539590533;7418;6477.093206951125;6640.634765087966;6699.129113215251;6736.32636736342;6784.151981002375;6460.773872914426;6528.347165283433;6540.476761859135;6555.246146693191;6617.933820661924;6114.541409394402;6167.876642467036;6202.4417802398;6205.47253483459;6223.595466294676;4113.465249517543;4122.196171746481;4186.476690413699;4220.683448741295;4241.045764702917;4114.855980040684;4244.72409293395;4256.851010214627;4308;4426.004149066434 10:09:04 INFO - PROCESS | 3764 | |4;prototype.html;285.34086260737695;287.83305682704025;292.08577153509515;294.9941001179976;297.9851007449627;5201.8699532511655;5317.1818935964;5327;5351.839444816657;5416.674999500033;5314.893702125955;5344.652597581155;5346.117890548055;5358.65168764031;5380.515753582177;3824.158685089276;3905.7070719695994;3909.6090390960962;3972.7417717848393;4002.2195671844;3970.1662650843214;3980.24375368679;3991.8203680834285;4000.7799571023584;4004.4193591929297;3938.6258305460933;3957.8021098945082;3963.286608410485;3964.3458829293277;3982.183652351261;3810.6570408663074;3827.8086095695103;3897.279003384383;3974.4833171687783;3985.900352491182;3221.2269055426527;3378;3400.4559270516597;3408.897733068012;3414.470757032664;5130.486506480597;5150.150225212836;5157.613179011589;5168.2764412982215;5169.767360468788;4415.183191109655;4544.840930567414;4594.379758732595;4595.747233902134;4665.720056796603;5450.781968721247;5457.2875363302965;5472.26124473195;5500.22996780451;5502.8349149525175;3719.497867787841;3765.510483637137;3770.7926064066464;3783.886483405502;3786.8106594670157;5554.333479982388;5759.769609215627;5821.3014438267255;5835.649861008311;5872.148538461899;3839.2321535692413;3840.2127563849344;3855.7879316637855;3857.189990102054;3867.207222519377;3913.7064720146104;3920.5883382245024;3920.8039598020555;3929.9542854288156;3930.7051971102283;4569.13186494565;4579.175748365326;4593.8868120664865;4598.379218805485;4614.630829533629;5438.1802059752345;5494.148406996922;5496.065668836308;5519.365272993577;5524.889502209933;1351.932403379827;1363.577291039781;1364.2019418640207;1365.7336819320137;1367.8700523450257;809.008964019072;845.5603086395163;852.411835833273;858.6694122762657;859.6303589456469;4629.629629629621;5102.397777133689;5192.039472697563;5251.789928402897;5284.445133261029;5721.199032135504;5726.942730572724;5733.569982251348;5740.684262365527;5748.741306641127;5087.26234695967;5265.236540701577;5312.867178320573;5336.653117547347;5348.277982472394;3030.9848450758045;3033.4084853453805;3046.314579219702;3048.481758101128;3052.427999580218;5797.797077102281;5805.94194058054;5830.212921255661;5835.519904040766;5835.562332825055;5719.8570035749435;5725.689836182458;5823.88352232953;5858.707064646751;5860.238169037998;5808.680522571215;5840.445157710011;5847.590668653153;5865.794697185578;5867.973104706659;5454.318210223722;5697.7151142443545;5701.6864072474755;5743.741531631003;5785.884282314246;5576.386597474194;5610.298712660918;5610.85972850682;5624.268845050117;5628.718564071698;5830.183774271521;5838.766449342149;5866.794662186803;5893.941060589339;5910.286017055006;3637.8181090944818;3820.4651348810635;3852.0947577319866;3856.4215367693946;3875.341191997311;5696.629719068247;5734.706117552845;5745.242283703762;5754.5901254192995;5764.19301297827;5621.156826476062;5623.606347555796;5642.830715078554;5646.548276137982;5663.716814159358;5182.196759502283;5520.1443776214755;5572.414896435978;5598.944010559842;5614.41048689898;5428;5449.64577302474;5465.289512363367;5470.425605311385;5495.725213739377;5437.293151890229;5553.8333849984565;5630.60585758993;5640.464155905182;5682.176084467646;5204.73976301191;5505.807296744595;5541.33503979525;5572.219889215594;5585.357683866408 10:09:04 INFO - PROCESS | 3764 | |5;yui.html;637.4804534304542;645.2772894358313;729.6242435145904;735.5366119344814;736.0578459571747;14522.564323070312;15024.549263522085;15383.461578844743;15383.923080384597;15834.920825395857;14926.402943882258;15120.243987800593;15139.167345796004;15149.621259468491;15162.166080865549;658.8517583543688;674.1034424215782;675.5406323699882;675.966201689916;676.5196710335667;577.8670905691694;594.3640304873787;663.3399767231612;678.9456843452512;683.9384455399013;712.2094475132599;713.7751608243412;714.3106901839724;714.3249629100476;714.7855643307013;602.0577795749638;701.8105111619834;705.8341289796894;705.9788206353818;706.3678008182674;452.6220605794166;504.11276153968913;514.6037551085643;514.9562287205592;516.0350145228409;11991.16061875669;12081;12136.696582585506;12165.817512737316;12185.268883866907;11604.361760103191;12017.879821201763;12051.096167787451;12091.27946212104;12122.757544849143;12532.310722910237;12621.93689031549;12683.936580317131;12755.872441275562;12890.162139460905;4121.9587804122175;4164.729292595972;4188.476440444944;4240.872773816791;4261.488621365425;67342.66328668375;69687;70535.26514227108;71478;74923.25076749272;10239.283250172417;10305.484725763681;10375.688729338131;10642.893571064345;10775.892241077645;18433.81566184321;18450.169742361624;18469.53826154357;18496.907515462335;18514.722279165824;7435.739749108755;7612.1246056704185;7620.542767433972;7632.122305934778;7943.404244681672;4314.762688052125;4319.200947824663;4361.629261512743;4403.383526306319;4542.454905411372;2986.641603007653;3134.98432507836;3140;3141.4502462069045;3141.5287706844156;517.0718560184478;519.6180807106773;542.7259234086761;546.0117187889932;546.9972650136804;633.8478765096436;649.344162395974;690.4476418864888;690.7858563845124;693.0782059860373;9310.53447327631;9641.855372169422;9719.805603887882;9805.166560842266;9998.200143988464;521.7208793295569;624.1698540940538;687.0930371909132;706.869229192601;713.4043074033241;4258.508330893029;4626.375439315717;4627.375304333939;4718.598919091847;4880.853574392774;99852;101226.4938675302;102376.48811755894;103405;104423;87868.92458763912;88911.66632500518;89894.55052724695;90656.32201720601;91930.54034729784;72451.63774181201;79305.60347198343;79381.60309198417;79586.60206698929;79625;8838.204561589488;8937.687180948635;8958.10418958099;9010.549472526216;9121.726348209564;45318.77340613276;45671.77164114158;45837.541624583326;45895.3115703258;47539.86901964733;61427;65950.67024664846;68426;68548.6572567134;69333;11264.831027534758;11296.096312294832;11299.604513841976;11459;11585.246958947642;13324.866751332362;13516.729665406834;13612.455501779817;13702.00335970248;14319.498817541336;11995;12178.512859485521;12441.626751197478;12671.429785659482;12716.682082948;12519.24884506896;12637.684057898627;12680.034873583261;13126.409311581192;13303.86696133065;10755.193360497837;11743.647690569296;12711.42798574085;12722.427490762753;12851;9419.293552983416;9453.243740500606;9525;9932.404055756677;10187;9936.950315248378;9989.350692204984;10146.239032072772;10202.540885660015;10523.842142368023 10:09:04 INFO - PROCESS | 3764 | __end_tp_report 10:09:04 INFO - PROCESS | 3764 | __start_cc_report 10:09:04 INFO - PROCESS | 3764 | _x_x_mozilla_cycle_collect,1283 10:09:04 INFO - PROCESS | 3764 | __end_cc_report 10:09:04 INFO - PROCESS | 3764 | __startTimestamp1476724143980__endTimestamp 10:09:04 INFO - PROCESS | 3764 | 10:09:04 INFO - PROCESS | 3764 | ------- Summary: start ------- 10:09:04 INFO - PROCESS | 3764 | Number of tests: 6 10:09:04 INFO - PROCESS | 3764 | 10:09:04 INFO - PROCESS | 3764 | [#0] dojo.html Cycles:165 Average:5204.51 Median:5485.97 stddev:700.69 (12.8%) stddev-sans-first:678.90 10:09:04 INFO - PROCESS | 3764 | Values: 2889.6 2911.4 2925.8 2949.8 2961.2 5284.7 5310.6 5344.4 5345.8 5384.9 5219.2 5244.7 5257.9 5274.8 5279.6 4714.1 4736.0 4747.3 4762.9 4815.6 4780.8 4800.0 4805.0 4807.7 4840.5 4749.4 4756.4 4779.1 4793.9 4799.9 4814.5 4816.1 4834.9 4852.4 4918.4 4659.1 4662.2 4684.9 4699.3 4744.1 5192.7 5212.4 5250.8 5266.4 5309.4 5577.4 5661.2 5689.7 5700.6 5709.7 5585.0 5687.0 5719.8 5733.6 5738.9 5231.6 5256.4 5267.6 5276.1 5303.7 5831.4 5866.1 5873.3 5873.9 5881.0 5396.4 5583.3 5585.3 5587.9 5592.5 5531.7 5661.1 5710.1 5721.3 5770.2 5618.9 5650.1 5661.5 5663.3 5663.3 5597.2 5665.9 5672.8 5674.5 5732.6 3648.4 3682.7 3684.0 3685.7 3692.2 3324.8 3336.2 3337.5 3373.3 3376.1 5238.9 5282.7 5285.1 5292.3 5337.7 5486.0 5549.5 5572.4 5722.4 5731.7 5173.2 5173.5 5178.9 5183.4 5185.2 4614.7 4618.9 4620.7 4626.8 4628.7 5703.2 5704.3 5709.1 5714.5 5715.6 5615.1 5617.8 5618.2 5618.3 5629.3 5814.1 5865.3 5878.2 5879.3 5882.9 5619.8 5643.3 5673.3 5687.1 5690.8 5686.2 5761.1 5763.3 5765.2 5765.4 5415.4 5627.4 5632.8 5633.3 5640.9 5436.5 5483.0 5517.5 5542.4 5610.0 5518.8 5523.4 5533.0 5534.1 5587.0 5615.0 5616.2 5619.5 5628.2 5628.6 5419.4 5421.4 5455.3 5514.5 5532.7 10:09:04 INFO - PROCESS | 3764 | 10:09:04 INFO - PROCESS | 3764 | [#1] ext.html Cycles:180 Average:50221.97 Median:36361.32 stddev:97269.31 (267.5%) stddev-sans-first:97470.71 10:09:04 INFO - PROCESS | 3764 | Values: 558.4 558.9 574.2 578.1 582.0 29304.7 29879.7 31216.7 31256.8 36443.8 37228.0 37404.6 37704.4 37891.1 37940.4 8210.7 8292.4 8353.5 8363.7 8372.1 7565.1 7770.5 8313.9 8383.4 8419.1 7793.9 7810.7 7849.1 9854.8 10110.5 9971.8 9997.6 10003.7 10047.4 10064.5 9792.7 9829.8 9888.5 9894.1 9908.2 29349.0 29852.4 29987.7 31401.7 36570.3 3087.9 3212.7 3265.7 3737.5 3788.6 28935.7 29117.0 29152.4 29299.9 29753.7 3982.8 4024.8 4066.3 4116.0 4166.7 289518.0 293699.0 294885.0 295476.0 297022.0 47579.3 47633.0 47814.0 47852.8 47911.5 31662.8 32446.0 49155.3 49254.3 49308.3 14926.9 15272.8 15353.9 15358.1 15371.2 11684.8 11700.3 11708.9 11743.9 11746.5 14623.5 16182.4 16191.4 16199.1 16240.1 5561.4 6539.7 6543.6 6558.6 6640.4 792.7 874.5 916.3 937.3 973.8 27663.3 27850.0 27909.9 28232.3 28332.4 937.3 988.9 993.1 995.0 1019.6 14219.3 14614.6 14658.9 14934.0 14947.1 426101.0 427289.0 427699.0 428183.0 428791.0 43463.0 44878.8 46739.8 48022.3 48224.3 1162.4 1173.4 1183.2 1184.2 1185.1 27844.3 28438.6 28761.9 28937.3 29072.6 42331.8 42674.0 42779.4 42798.8 42843.0 367740.0 368357.0 369900.0 371644.0 373219.0 24731.9 25115.5 25151.4 25155.6 25223.6 39789.0 41225.0 41497.4 42463.0 42616.4 35561.0 35775.8 35830.0 36278.8 36606.1 35447.6 35770.6 35832.0 36147.3 36598.3 34023.3 34077.1 34420.5 34470.0 34962.7 31967.0 32454.8 32653.0 32794.8 33042.7 24631.1 24916.9 25001.5 25029.5 25064.5 10:09:04 INFO - PROCESS | 3764 | 10:09:04 INFO - PROCESS | 3764 | [#2] jquery.html Cycles:180 Average:25219.03 Median:50580.87 stddev:62604.41 (123.8%) stddev-sans-first:62752.13 10:09:04 INFO - PROCESS | 3764 | Values: 322.8 334.5 335.5 339.5 347.9 12941.8 13513.5 16164.8 16374.1 16496.8 16278.2 16947.2 17080.2 17121.0 17270.8 5112.6 5172.5 5238.6 5409.8 5411.1 3810.4 5206.9 5292.4 5292.6 5295.8 4020.1 5493.2 5748.2 5753.5 5813.6 5641.7 5799.6 5804.6 5810.7 5850.7 5104.5 5141.1 5141.2 5144.4 5144.5 19478.5 19747.2 20166.4 20310.0 20331.2 2202.6 2244.6 2783.6 2953.1 3148.9 14371.2 15032.7 15171.9 15237.8 15344.2 1913.0 1946.0 1984.2 1984.9 2029.6 85702.0 86871.0 87933.1 88345.6 92782.0 15250.5 15551.8 15846.8 15858.4 15883.3 26796.9 26840.1 26903.0 26928.6 26958.2 8963.3 9047.2 9076.5 9104.3 9219.3 7657.2 7661.9 7668.6 7695.9 7773.3 7828.8 7944.5 7948.2 7949.9 7953.9 3159.3 3224.4 3231.2 3261.6 3311.9 781.6 819.2 905.0 907.9 933.5 16517.4 16747.0 16867.4 17229.5 17447.1 816.6 817.5 862.4 865.9 924.5 8896.7 9307.6 9333.5 9423.7 9529.6 210140.0 380531.0 408719.0 415945.0 416526.0 76101.0 83788.2 87248.0 87275.6 87521.0 876.5 900.0 920.5 924.5 924.5 15304.5 15380.1 15563.7 15785.6 15844.0 36674.3 36959.3 37381.4 37465.0 38711.2 50449.2 50712.5 50958.7 51215.5 51699.7 7206.5 7366.3 7419.1 7430.3 7860.6 10424.2 11805.8 11871.0 11918.0 12120.1 9580.2 10224.3 10301.9 10472.1 10753.8 9168.5 9174.4 9527.9 10353.8 10463.4 9423.7 10248.0 10485.0 10519.7 10644.6 7664.8 7675.4 7689.5 7725.0 7816.5 8490.4 9832.3 10058.7 10109.4 10184.9 10:09:04 INFO - PROCESS | 3764 | 10:09:04 INFO - PROCESS | 3764 | [#3] mootools.html Cycles:180 Average:4826.99 Median:5115.71 stddev:2725.15 (53.3%) stddev-sans-first:2718.95 10:09:04 INFO - PROCESS | 3764 | Values: 1172.1 1239.3 1256.0 1298.8 1516.4 6441.6 6985.1 7079.5 7181.7 7400.5 7422.4 7465.1 7501.1 7506.7 7509.6 1986.2 2002.1 2008.3 2011.0 2011.1 1985.3 2007.8 2007.8 2018.3 2020.2 1989.6 1999.1 2001.5 2008.1 2009.6 1952.8 1954.4 1956.1 1956.9 1958.2 1942.3 1953.8 1959.5 1990.5 1992.7 7258.1 7294.6 7312.7 7416.7 7510.7 4298.4 4382.3 4386.7 4390.5 4402.3 2938.0 3013.2 3045.3 3047.9 3051.7 1024.8 1033.0 1042.3 1050.3 1053.3 9282.5 9476.7 9500.7 9650.9 9656.7 3715.0 3722.3 3735.4 3833.5 3837.1 7612.3 7613.5 7632.7 7640.1 7696.5 4326.0 4326.8 4329.4 4330.3 4334.3 3637.5 3735.7 3950.3 4026.0 4076.1 3076.9 3154.1 3194.8 3196.6 3318.2 924.8 929.8 931.0 944.5 954.5 741.0 794.6 801.3 801.8 803.2 4745.0 4782.8 4892.8 4916.0 5100.6 373.0 375.9 387.0 393.9 395.6 3168.3 3421.1 3488.2 3644.8 3660.3 8922.4 9093.5 9106.5 9128.5 9179.3 9090.2 9092.9 9118.2 9121.8 9134.7 6849.3 7033.4 7045.7 7056.9 7080.4 4829.0 5130.8 5131.8 5189.6 5314.9 8383.5 8484.9 8504.1 8521.1 8639.6 8598.8 8667.2 8721.3 8764.6 8880.0 6455.2 6602.5 6849.0 6849.2 6851.6 7167.5 7326.2 7329.2 7404.2 7418.0 6477.1 6640.6 6699.1 6736.3 6784.2 6460.8 6528.3 6540.5 6555.2 6617.9 6114.5 6167.9 6202.4 6205.5 6223.6 4113.5 4122.2 4186.5 4220.7 4241.0 4114.9 4244.7 4256.9 4308.0 4426.0 10:09:04 INFO - PROCESS | 3764 | 10:09:04 INFO - PROCESS | 3764 | [#4] prototype.html Cycles:180 Average:4607.61 Median:5345.39 stddev:1414.29 (26.5%) stddev-sans-first:1380.55 10:09:04 INFO - PROCESS | 3764 | Values: 285.3 287.8 292.1 295.0 298.0 5201.9 5317.2 5327.0 5351.8 5416.7 5314.9 5344.7 5346.1 5358.7 5380.5 3824.2 3905.7 3909.6 3972.7 4002.2 3970.2 3980.2 3991.8 4000.8 4004.4 3938.6 3957.8 3963.3 3964.3 3982.2 3810.7 3827.8 3897.3 3974.5 3985.9 3221.2 3378.0 3400.5 3408.9 3414.5 5130.5 5150.2 5157.6 5168.3 5169.8 4415.2 4544.8 4594.4 4595.7 4665.7 5450.8 5457.3 5472.3 5500.2 5502.8 3719.5 3765.5 3770.8 3783.9 3786.8 5554.3 5759.8 5821.3 5835.6 5872.1 3839.2 3840.2 3855.8 3857.2 3867.2 3913.7 3920.6 3920.8 3930.0 3930.7 4569.1 4579.2 4593.9 4598.4 4614.6 5438.2 5494.1 5496.1 5519.4 5524.9 1351.9 1363.6 1364.2 1365.7 1367.9 809.0 845.6 852.4 858.7 859.6 4629.6 5102.4 5192.0 5251.8 5284.4 5721.2 5726.9 5733.6 5740.7 5748.7 5087.3 5265.2 5312.9 5336.7 5348.3 3031.0 3033.4 3046.3 3048.5 3052.4 5797.8 5805.9 5830.2 5835.5 5835.6 5719.9 5725.7 5823.9 5858.7 5860.2 5808.7 5840.4 5847.6 5865.8 5868.0 5454.3 5697.7 5701.7 5743.7 5785.9 5576.4 5610.3 5610.9 5624.3 5628.7 5830.2 5838.8 5866.8 5893.9 5910.3 3637.8 3820.5 3852.1 3856.4 3875.3 5696.6 5734.7 5745.2 5754.6 5764.2 5621.2 5623.6 5642.8 5646.5 5663.7 5182.2 5520.1 5572.4 5598.9 5614.4 5428.0 5449.6 5465.3 5470.4 5495.7 5437.3 5553.8 5630.6 5640.5 5682.2 5204.7 5505.8 5541.3 5572.2 5585.4 10:09:04 INFO - PROCESS | 3764 | 10:09:04 INFO - PROCESS | 3764 | [#5] yui.html Cycles:180 Average:18904.58 Median:4672.99 stddev:26960.78 (576.9%) stddev-sans-first:27001.52 10:09:04 INFO - PROCESS | 3764 | Values: 637.5 645.3 729.6 735.5 736.1 14522.6 15024.5 15383.5 15383.9 15834.9 14926.4 15120.2 15139.2 15149.6 15162.2 658.9 674.1 675.5 676.0 676.5 577.9 594.4 663.3 678.9 683.9 712.2 713.8 714.3 714.3 714.8 602.1 701.8 705.8 706.0 706.4 452.6 504.1 514.6 515.0 516.0 11991.2 12081.0 12136.7 12165.8 12185.3 11604.4 12017.9 12051.1 12091.3 12122.8 12532.3 12621.9 12683.9 12755.9 12890.2 4122.0 4164.7 4188.5 4240.9 4261.5 67342.7 69687.0 70535.3 71478.0 74923.3 10239.3 10305.5 10375.7 10642.9 10775.9 18433.8 18450.2 18469.5 18496.9 18514.7 7435.7 7612.1 7620.5 7632.1 7943.4 4314.8 4319.2 4361.6 4403.4 4542.5 2986.6 3135.0 3140.0 3141.5 3141.5 517.1 519.6 542.7 546.0 547.0 633.8 649.3 690.4 690.8 693.1 9310.5 9641.9 9719.8 9805.2 9998.2 521.7 624.2 687.1 706.9 713.4 4258.5 4626.4 4627.4 4718.6 4880.9 99852.0 101226.5 102376.5 103405.0 104423.0 87868.9 88911.7 89894.6 90656.3 91930.5 72451.6 79305.6 79381.6 79586.6 79625.0 8838.2 8937.7 8958.1 9010.5 9121.7 45318.8 45671.8 45837.5 45895.3 47539.9 61427.0 65950.7 68426.0 68548.7 69333.0 11264.8 11296.1 11299.6 11459.0 11585.2 13324.9 13516.7 13612.5 13702.0 14319.5 11995.0 12178.5 12441.6 12671.4 12716.7 12519.2 12637.7 12680.0 13126.4 13303.9 10755.2 11743.6 12711.4 12722.4 12851.0 9419.3 9453.2 9525.0 9932.4 10187.0 9937.0 9989.4 10146.2 10202.5 10523.8 10:09:04 INFO - PROCESS | 3764 | -------- Summary: end -------- 10:09:04 INFO - PROCESS | 3764 | 10:09:04 INFO - TEST-INFO | 3764: exit 0 10:09:05 INFO - TEST-OK | dromaeo_css | took 1122946ms 10:09:05 INFO - TEST-START | kraken 10:09:05 INFO - operating with platform_type : w8_ 10:09:05 INFO - Initialising browser for kraken test... 10:09:05 INFO - TEST-INFO | started process 1844 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpb2jim5\profile http://localhost:49275/getInfo.html) 10:09:10 INFO - PROCESS | 1844 | __metrics Screen width/height:1600/1200 10:09:10 INFO - PROCESS | 1844 | colorDepth:24 10:09:10 INFO - PROCESS | 1844 | Browser inner width/height: 1010/674 10:09:10 INFO - PROCESS | 1844 | __metrics 10:09:11 INFO - PROCESS | 1844 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:09:11 INFO - PROCESS | 1844 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:09:11 INFO - PROCESS | 1844 | console.error: 10:09:11 INFO - PROCESS | 1844 | Message: Error: Connection closed before committing the transaction. 10:09:11 INFO - PROCESS | 1844 | Stack: 10:09:11 INFO - PROCESS | 1844 | ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:937:23 10:09:11 INFO - PROCESS | 1844 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7 10:09:11 INFO - PROCESS | 1844 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11 10:09:11 INFO - PROCESS | 1844 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7 10:09:11 INFO - PROCESS | 1844 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:714:7 10:09:11 INFO - PROCESS | 1844 | TaskImpl_run@resource://gre/modules/Task.jsm:327:15 10:09:11 INFO - PROCESS | 1844 | Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:551:9 10:09:11 INFO - PROCESS | 1844 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15 10:09:11 INFO - PROCESS | 1844 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:388:5 10:09:11 INFO - PROCESS | 1844 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29 10:09:11 INFO - PROCESS | 1844 | Barrier/this.client.addBlocker/promise13.3% 10:10:09 INFO - TinderboxPrint: I/O read bytes / time
298,512,384 / 3,292,310 10:10:09 INFO - TinderboxPrint: I/O write bytes / time
421,854,208 / 3,706,330 10:10:09 INFO - TinderboxPrint: CPU idle
8,271.3 (86.7%) 10:10:09 INFO - TinderboxPrint: CPU user
1,213.8 (12.7%) 10:10:09 INFO - install - Wall time: 3s; CPU: 12.0%; Read bytes: 0; Write bytes: 41767936; Read time: 0; Write time: 73030 10:10:09 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 298512384; Write bytes: 327211008; Read time: 3292310; Write time: 3595250 10:10:09 INFO - Running post-run listener: _upload_blobber_files 10:10:09 INFO - Blob upload gear active. 10:10:09 INFO - Preparing to upload files from C:\slave\test\build\blobber_upload_dir. 10:10:09 INFO - Files from C:\slave\test\build\blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:10:09 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\venv\\Scripts\\blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', 'C:\\slave\\test\\oauth.txt', '-b', 'Autoland', '-d', 'C:\\slave\\test\\build\\blobber_upload_dir', '--output-manifest', 'C:\\slave\\test\\build\\uploaded_files.json'] 10:10:09 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\venv\Scripts\blobberc.py -u https://blobupload.elasticbeanstalk.com -a C:\slave\test\oauth.txt -b Autoland -d C:\slave\test\build\blobber_upload_dir --output-manifest C:\slave\test\build\uploaded_files.json 10:10:10 INFO - (blobuploader) - INFO - Open directory for files ... 10:10:10 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_errorsummary.log ... 10:10:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:10:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:10:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:10:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:10:10 INFO - (blobuploader) - INFO - Done attempting. 10:10:10 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_raw.log ... 10:10:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:10:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:10:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:10:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:10:11 INFO - (blobuploader) - INFO - Done attempting. 10:10:11 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\resource-usage.json ... 10:10:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:10:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:10:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:10:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:10:14 INFO - (blobuploader) - INFO - Done attempting. 10:10:14 INFO - (blobuploader) - INFO - Iteration through files over. 10:10:14 INFO - Return code: 0 10:10:14 INFO - rmtree: C:\slave\test\build\uploaded_files.json 10:10:14 INFO - Using _rmtree_windows ... 10:10:14 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build\\uploaded_files.json',), kwargs: {}, attempt #1 10:10:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6ecf1bdccf147f3df99d8fc0223eec530e0bed77ccf0cc7a7010eec3c9a8a1bc49256cf1ffd451638afeb3c79ee5e44a5b5329c5024952d5202f956a7bb0a807", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/690900d8d774a4507f1c35d00ce0716d2df64e03619917db233eb4ab5eddffa3b521a8f28e889eea639bf7028c6ddf9ecd87bcb3f91b9c4b54f21872233e6196", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c1c3d030b0c3c8a79acbe612c67d2c42c9aee858ace6965e1bff01b7f1928fef525d4b275913982d546b0b59808636e4dfa0fc91addbee1840b54c6ced60d32a"} 10:10:14 INFO - Writing buildbot properties ['blobber_files'] to C:\slave\test\properties\blobber_files 10:10:14 INFO - Writing to file C:\slave\test\properties\blobber_files 10:10:14 INFO - Contents: 10:10:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6ecf1bdccf147f3df99d8fc0223eec530e0bed77ccf0cc7a7010eec3c9a8a1bc49256cf1ffd451638afeb3c79ee5e44a5b5329c5024952d5202f956a7bb0a807", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/690900d8d774a4507f1c35d00ce0716d2df64e03619917db233eb4ab5eddffa3b521a8f28e889eea639bf7028c6ddf9ecd87bcb3f91b9c4b54f21872233e6196", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c1c3d030b0c3c8a79acbe612c67d2c42c9aee858ace6965e1bff01b7f1928fef525d4b275913982d546b0b59808636e4dfa0fc91addbee1840b54c6ced60d32a"} 10:10:14 INFO - Running post-run listener: copy_logs_to_upload_dir 10:10:14 INFO - Copying logs to upload dir... 10:10:14 INFO - mkdir: C:\slave\test\build\upload\logs 10:10:14 INFO - Copying logs to upload dir... 10:10:14 INFO - Using _rmtree_windows ... 10:10:14 INFO - Using _rmtree_windows ... 10:10:14 INFO - Using _rmtree_windows ... 10:10:14 INFO - Using _rmtree_windows ... 10:10:14 INFO - Using _rmtree_windows ... 10:10:14 INFO - Using _rmtree_windows ... 10:10:14 INFO - Using _rmtree_windows ... program finished with exit code 0 elapsedTime=1395.131000 ========= master_lag: 0.39 ========= ========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 15 secs) (at 2016-10-17 10:10:14.252330) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 10:10:14.258608) ========= '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-077\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-077 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-077 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-077\AppData\Local LOGONSERVER=\\T-W864-IX-077 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-077 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-077 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-077 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/6ecf1bdccf147f3df99d8fc0223eec530e0bed77ccf0cc7a7010eec3c9a8a1bc49256cf1ffd451638afeb3c79ee5e44a5b5329c5024952d5202f956a7bb0a807", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/690900d8d774a4507f1c35d00ce0716d2df64e03619917db233eb4ab5eddffa3b521a8f28e889eea639bf7028c6ddf9ecd87bcb3f91b9c4b54f21872233e6196", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c1c3d030b0c3c8a79acbe612c67d2c42c9aee858ace6965e1bff01b7f1928fef525d4b275913982d546b0b59808636e4dfa0fc91addbee1840b54c6ced60d32a"} build_url:https://queue.taskcluster.net/v1/task/Bz1EB0CvRv-h0jjmtgecPA/artifacts/public/build/firefox-52.0a1.en-US.win64.zip program finished with exit code 0 elapsedTime=0.102000 build_url: 'https://queue.taskcluster.net/v1/task/Bz1EB0CvRv-h0jjmtgecPA/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/6ecf1bdccf147f3df99d8fc0223eec530e0bed77ccf0cc7a7010eec3c9a8a1bc49256cf1ffd451638afeb3c79ee5e44a5b5329c5024952d5202f956a7bb0a807", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/690900d8d774a4507f1c35d00ce0716d2df64e03619917db233eb4ab5eddffa3b521a8f28e889eea639bf7028c6ddf9ecd87bcb3f91b9c4b54f21872233e6196", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c1c3d030b0c3c8a79acbe612c67d2c42c9aee858ace6965e1bff01b7f1928fef525d4b275913982d546b0b59808636e4dfa0fc91addbee1840b54c6ced60d32a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 10:10:14.378779) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 10:10:14.379100) ========= '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-077\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-077 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-077 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-077\AppData\Local LOGONSERVER=\\T-W864-IX-077 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-077 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-077 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-077 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-17 10:10:14.496773) ========= ========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-10-17 10:10:14.497086) ========= ========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-10-17 10:10:14.961678) ========= ========= Total master_lag: 0.68 =========