builder: mozilla-central_win8_64_test-dromaeojs slave: t-w864-ix-189 starttime: 1476749153.5 results: success (0) buildid: 20161017153519 builduid: 806b249512b9415f81a5f632c3c661b8 revision: 56b3f2c6f53e72698fea6c25130efceef2a26548 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 17:05:53.497343) ========= master: http://buildbot-master111.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 17:05:53.498112) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 17:05:53.498600) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 17:05:53.599301) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-17 17:05:53.599704) ========= '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-189\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-189 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-189 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-189\AppData\Local LOGONSERVER=\\T-W864-IX-189 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-189 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-189 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-189 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False --17:05:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py => `archiver_client.py' Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. WARNING: Certificate verification error for hg.mozilla.org: certificate signature failure HTTP request sent, awaiting response... 200 Script output follows Length: 12,179 (12K) [text/x-python] 0K .......... . 100% 2.46 GB/s 17:05:54 (2.46 GB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=1.383000 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-17 17:05:55.025115) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 7 secs) (at 2016-10-17 17:05:55.025447) ========= '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-189\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-189 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-189 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-189\AppData\Local LOGONSERVER=\\T-W864-IX-189 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-189 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-189 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-189 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=3.008000 ========= master_lag: 4.10 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 7 secs) (at 2016-10-17 17:06:02.128807) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-10-17 17:06:02.129180) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo mozilla-central --rev 56b3f2c6f53e72698fea6c25130efceef2a26548 --destination scripts --debug' in dir C:\\slave\test\. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 56b3f2c6f53e72698fea6c25130efceef2a26548 --destination scripts --debug'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-189\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-189 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-189 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-189\AppData\Local LOGONSERVER=\\T-W864-IX-189 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-189 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-189 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-189 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 2016-10-17 17:06:02,572 truncating revision to first 12 chars 2016-10-17 17:06:02,572 Setting DEBUG logging. 2016-10-17 17:06:02,572 attempt 1/10 2016-10-17 17:06:02,572 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/56b3f2c6f53e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-17 17:06:03,003 unpacking tar archive at: mozilla-central-56b3f2c6f53e/testing/mozharness/ 2016-10-17 17:06:03,101 skipping symlink on windows: configs/single_locale/linux32.py program finished with exit code 0 elapsedTime=1.470000 ========= master_lag: 3.44 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-10-17 17:06:07.043263) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 17:06:07.043584) ========= script_repo_revision: 56b3f2c6f53e72698fea6c25130efceef2a26548 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 17:06:07.043975) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 17:06:07.044255) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 17:06:07.065002) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 25 secs) (at 2016-10-17 17:06:07.065311) ========= 'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'dromaeojs' '--add-option' '--webServer,localhost' '--branch-name' 'Firefox-Non-PGO' '--cfg' 'talos/windows_config.py' '--download-symbols' 'ondemand' '--use-talos-json' '--blob-upload-branch' 'Firefox-Non-PGO' in dir C:\\slave\test\. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['c:/mozilla-build/python27/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/windows_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-189\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-189 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-189 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-189\AppData\Local LOGONSERVER=\\T-W864-IX-189 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-189 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-189 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-189 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 17:06:08 INFO - MultiFileLogger online at 20161017 17:06:08 in C:\slave\test 17:06:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 17:06:08 INFO - Dumping config to C:\slave\test\logs\localconfig.json. 17:06:08 INFO - {'append_to_log': False, 17:06:08 INFO - 'base_work_dir': 'C:\\slave\\test', 17:06:08 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:06:08 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt', 17:06:08 INFO - 'branch': 'Firefox-Non-PGO', 17:06:08 INFO - 'buildbot_json_path': 'buildprops.json', 17:06:08 INFO - 'config_files': ('talos/windows_config.py',), 17:06:08 INFO - 'default_actions': ('clobber', 17:06:08 INFO - 'read-buildbot-config', 17:06:08 INFO - 'download-and-extract', 17:06:08 INFO - 'populate-webroot', 17:06:08 INFO - 'create-virtualenv', 17:06:08 INFO - 'install', 17:06:08 INFO - 'run-tests'), 17:06:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:06:08 INFO - 'download_minidump_stackwalk': True, 17:06:08 INFO - 'download_symbols': 'ondemand', 17:06:08 INFO - 'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python', 17:06:08 INFO - 'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'), 17:06:08 INFO - 'hg': 'c:/mozilla-build/hg/hg', 17:06:08 INFO - 'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python', 17:06:08 INFO - 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'), 17:06:08 INFO - 'python': 'c:/mozilla-build/python27/python.exe', 17:06:08 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe', 17:06:08 INFO - 'C:/mozilla-build/tooltool.py'), 17:06:08 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe', 17:06:08 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 17:06:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:06:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:06:08 INFO - 'installer_path': 'installer.exe', 17:06:08 INFO - 'log_level': 'info', 17:06:08 INFO - 'log_name': 'talos', 17:06:08 INFO - 'log_to_console': True, 17:06:08 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe', 17:06:08 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe', 17:06:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest', 17:06:08 INFO - 'opt_config_files': (), 17:06:08 INFO - 'pip_index': False, 17:06:08 INFO - 'sps_profile': False, 17:06:08 INFO - 'sps_profile_interval': 0, 17:06:08 INFO - 'suite': 'dromaeojs', 17:06:08 INFO - 'system_bits': '32', 17:06:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:06:08 INFO - 'title': 'T-W864-IX-189', 17:06:08 INFO - 'use_talos_json': True, 17:06:08 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'), 17:06:08 INFO - 'virtualenv_path': 'C:\\slave\\test\\build/venv', 17:06:08 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll', 17:06:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:06:08 INFO - 'work_dir': 'build'} 17:06:08 INFO - [mozharness: 2016-10-18 00:06:08.091000Z] Running clobber step. 17:06:08 INFO - Running pre-action listener: _resource_record_pre_action 17:06:08 INFO - Running main action method: clobber 17:06:08 INFO - rmtree: C:\slave\test\build 17:06:08 INFO - Using _rmtree_windows ... 17:06:08 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1 17:07:45 INFO - Running post-action listener: _resource_record_post_action 17:07:45 INFO - [mozharness: 2016-10-18 00:07:45.434000Z] Finished clobber step (success) 17:07:45 INFO - [mozharness: 2016-10-18 00:07:45.434000Z] Running read-buildbot-config step. 17:07:45 INFO - Running pre-action listener: _resource_record_pre_action 17:07:45 INFO - Running main action method: read_buildbot_config 17:07:45 INFO - Using buildbot properties: 17:07:45 INFO - { 17:07:45 INFO - "project": "", 17:07:45 INFO - "product": "firefox", 17:07:45 INFO - "script_repo_revision": "production", 17:07:45 INFO - "builddir": "mozilla-central_win8_64_test-dromaeojs", 17:07:45 INFO - "repository": "", 17:07:45 INFO - "buildername": "Windows 8 64-bit mozilla-central talos dromaeojs", 17:07:45 INFO - "buildid": "20161017153519", 17:07:45 INFO - "pgo_build": "False", 17:07:45 INFO - "basedir": "C:\\slave\\test", 17:07:45 INFO - "buildnumber": 71, 17:07:45 INFO - "slavename": "t-w864-ix-189", 17:07:45 INFO - "master": "http://buildbot-master111.bb.releng.scl3.mozilla.com:8201/", 17:07:45 INFO - "platform": "win8_64", 17:07:45 INFO - "scheduler": "tests-mozilla-central-win64-talos", 17:07:45 INFO - "branch": "mozilla-central", 17:07:45 INFO - "repo_path": "mozilla-central", 17:07:45 INFO - "revision": "56b3f2c6f53e72698fea6c25130efceef2a26548", 17:07:45 INFO - "stage_platform": "win64", 17:07:45 INFO - "builduid": "806b249512b9415f81a5f632c3c661b8", 17:07:45 INFO - "slavebuilddir": "test" 17:07:45 INFO - } 17:07:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/JteFUZqGQUaU_oH0lWLEpw/artifacts/public/build/firefox-52.0a1.en-US.win64.zip. 17:07:45 INFO - Running post-action listener: _resource_record_post_action 17:07:45 INFO - [mozharness: 2016-10-18 00:07:45.437000Z] Finished read-buildbot-config step (success) 17:07:45 INFO - [mozharness: 2016-10-18 00:07:45.438000Z] Running download-and-extract step. 17:07:45 INFO - Running pre-action listener: _resource_record_pre_action 17:07:45 INFO - Running main action method: download_and_extract 17:07:45 INFO - mkdir: C:\slave\test\build\tests 17:07:45 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')]} 17:07:45 INFO - trying https://queue.taskcluster.net/v1/task/JteFUZqGQUaU_oH0lWLEpw/artifacts/public/build/firefox-52.0a1.en-US.win64.test_packages.json 17:07:45 INFO - Downloading https://queue.taskcluster.net/v1/task/JteFUZqGQUaU_oH0lWLEpw/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 17:07:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JteFUZqGQUaU_oH0lWLEpw/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 17:07:46 INFO - Downloaded 1274 bytes. 17:07:46 INFO - Reading from file C:\slave\test\build\firefox-52.0a1.en-US.win64.test_packages.json 17:07:46 INFO - Using the following test package requirements: 17:07:46 INFO - {u'common': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 17:07:46 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 17:07:46 INFO - u'firefox-52.0a1.en-US.win64.cppunittest.tests.zip'], 17:07:46 INFO - u'gtest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 17:07:46 INFO - u'firefox-52.0a1.en-US.win64.gtest.tests.zip'], 17:07:46 INFO - u'jittest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 17:07:46 INFO - u'jsshell-win64.zip'], 17:07:46 INFO - u'mochitest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 17:07:46 INFO - u'firefox-52.0a1.en-US.win64.mochitest.tests.zip'], 17:07:46 INFO - u'mozbase': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 17:07:46 INFO - u'reftest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 17:07:46 INFO - u'firefox-52.0a1.en-US.win64.reftest.tests.zip'], 17:07:46 INFO - u'talos': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 17:07:46 INFO - u'firefox-52.0a1.en-US.win64.talos.tests.zip'], 17:07:46 INFO - u'web-platform': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 17:07:46 INFO - u'firefox-52.0a1.en-US.win64.web-platform.tests.zip'], 17:07:46 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 17:07:46 INFO - u'firefox-52.0a1.en-US.win64.xpcshell.tests.zip']} 17:07:46 INFO - Downloading packages: [u'firefox-52.0a1.en-US.win64.common.tests.zip'] for test suite category: common 17:07:46 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/JteFUZqGQUaU_oH0lWLEpw/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip 17:07:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JteFUZqGQUaU_oH0lWLEpw/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip'}, attempt #1 17:07:46 INFO - Fetch https://queue.taskcluster.net/v1/task/JteFUZqGQUaU_oH0lWLEpw/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip into memory 17:07:47 INFO - Http code: 200 17:07:47 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 17:07:47 INFO - x-amz-cf-id: ZtXube199FKj725cksAJmtmp7vczUBe8UYHTPCUl7TiZzbW0Eiro5Q== 17:07:47 INFO - x-amz-version-id: Hlqp1UjZWktRt3.lMMHnc1c7uamvSYfY 17:07:47 INFO - Expected file size: 17529852 17:07:47 INFO - Obtained file size: 17529852 17:08:15 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 17:08:15 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/JteFUZqGQUaU_oH0lWLEpw/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip 17:08:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JteFUZqGQUaU_oH0lWLEpw/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip'}, attempt #1 17:08:15 INFO - Fetch https://queue.taskcluster.net/v1/task/JteFUZqGQUaU_oH0lWLEpw/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip into memory 17:08:15 INFO - Http code: 200 17:08:15 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 17:08:15 INFO - x-amz-cf-id: -lCmdPAJCMRR5NyNyGrEKec95773C3Cq4WYH8g_w12q5Xiwcj23s6w== 17:08:15 INFO - x-amz-version-id: Hlqp1UjZWktRt3.lMMHnc1c7uamvSYfY 17:08:15 INFO - Expected file size: 17529852 17:08:15 INFO - Obtained file size: 17529852 17:08:29 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/JteFUZqGQUaU_oH0lWLEpw/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip 17:08:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JteFUZqGQUaU_oH0lWLEpw/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip'}, attempt #1 17:08:29 INFO - Fetch https://queue.taskcluster.net/v1/task/JteFUZqGQUaU_oH0lWLEpw/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip into memory 17:08:30 INFO - Http code: 200 17:08:30 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 17:08:30 INFO - x-amz-cf-id: b1mYTT1jhwcQOFt2feYd26HWsb9scW3-UHQpPqKAQ0XlSUnDDdtSBA== 17:08:30 INFO - x-amz-version-id: CRcuVFL1RBQVco371.axHV32.pDD7rxo 17:08:30 INFO - Expected file size: 14409028 17:08:30 INFO - Obtained file size: 14409028 17:08: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')]} 17:08:37 INFO - trying https://queue.taskcluster.net/v1/task/JteFUZqGQUaU_oH0lWLEpw/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 17:08:37 INFO - Downloading https://queue.taskcluster.net/v1/task/JteFUZqGQUaU_oH0lWLEpw/artifacts/public/build/firefox-52.0a1.en-US.win64.zip to C:\slave\test\build\firefox-52.0a1.en-US.win64.zip 17:08:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JteFUZqGQUaU_oH0lWLEpw/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 17:08:39 INFO - Downloaded 56919109 bytes. 17:08:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JteFUZqGQUaU_oH0lWLEpw/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 17:08:39 INFO - mkdir: C:\slave\test\properties 17:08:39 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url 17:08:39 INFO - Writing to file C:\slave\test\properties\build_url 17:08:39 INFO - Contents: 17:08:39 INFO - build_url:https://queue.taskcluster.net/v1/task/JteFUZqGQUaU_oH0lWLEpw/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 17:08:39 INFO - Running post-action listener: _resource_record_post_action 17:08:39 INFO - Running post-action listener: set_extra_try_arguments 17:08:39 INFO - [mozharness: 2016-10-18 00:08:39.883000Z] Finished download-and-extract step (success) 17:08:39 INFO - [mozharness: 2016-10-18 00:08:39.883000Z] Running populate-webroot step. 17:08:39 INFO - Running pre-action listener: _resource_record_pre_action 17:08:39 INFO - Running main action method: populate_webroot 17:08:39 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']}, 17:08:39 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']}, 17:08:39 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome', 17:08:39 INFO - u'--tppagecycles', 17:08:39 INFO - u'7'], 17:08:39 INFO - u'tests': [u'tsvgm']}}, 17:08:39 INFO - u'suites': {u'chromez': {u'talos_options': [u'--disable-e10s'], 17:08:39 INFO - u'tests': [u'tresize', u'tcanvasmark']}, 17:08:39 INFO - u'chromez-e10s': {u'tests': [u'tresize', u'tcanvasmark']}, 17:08:39 INFO - u'dromaeojs': {u'talos_options': [u'--disable-e10s'], 17:08:39 INFO - u'tests': [u'dromaeo_css', u'kraken']}, 17:08:39 INFO - u'dromaeojs-e10s': {u'tests': [u'dromaeo_css', u'kraken']}, 17:08:39 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:39 INFO - u'talos_options': [u'--disable-e10s'], 17:08:39 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 17:08:39 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:39 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 17:08:39 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:39 INFO - u'talos_options': [u'--disable-e10s'], 17:08:39 INFO - u'tests': [u'damp', u'tps']}, 17:08:39 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:39 INFO - u'tests': [u'damp', u'tps']}, 17:08:39 INFO - u'g3': {u'talos_options': [u'--disable-e10s'], 17:08:39 INFO - u'tests': [u'dromaeo_dom']}, 17:08:39 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']}, 17:08:39 INFO - u'g4': {u'talos_options': [u'--disable-e10s'], 17:08:39 INFO - u'tests': [u'basic_compositor_video']}, 17:08:39 INFO - u'g4-e10s': {u'tests': [u'basic_compositor_video']}, 17:08:39 INFO - u'other': {u'talos_options': [u'--disable-e10s'], 17:08:39 INFO - u'tests': [u'a11yr', 17:08:39 INFO - u'ts_paint', 17:08:39 INFO - u'tpaint', 17:08:39 INFO - u'sessionrestore', 17:08:39 INFO - u'sessionrestore_no_auto_restore', 17:08:39 INFO - u'tabpaint']}, 17:08:39 INFO - u'other-e10s': {u'tests': [u'a11yr', 17:08:39 INFO - u'ts_paint', 17:08:39 INFO - u'tpaint', 17:08:39 INFO - u'sessionrestore', 17:08:39 INFO - u'sessionrestore_no_auto_restore', 17:08:39 INFO - u'tabpaint']}, 17:08:39 INFO - u'other-e10s_l64': {u'tests': [u'a11yr', 17:08:39 INFO - u'ts_paint', 17:08:39 INFO - u'tpaint', 17:08:39 INFO - u'sessionrestore', 17:08:39 INFO - u'sessionrestore_no_auto_restore', 17:08:39 INFO - u'tabpaint']}, 17:08:39 INFO - u'other-e10s_nol64': {u'tests': [u'a11yr', 17:08:39 INFO - u'ts_paint', 17:08:39 INFO - u'tpaint', 17:08:39 INFO - u'sessionrestore', 17:08:39 INFO - u'sessionrestore_no_auto_restore', 17:08:39 INFO - u'tabpaint']}, 17:08:39 INFO - u'other_l64': {u'talos_options': [u'--disable-e10s'], 17:08:39 INFO - u'tests': [u'a11yr', 17:08:39 INFO - u'ts_paint', 17:08:39 INFO - u'tpaint', 17:08:39 INFO - u'sessionrestore', 17:08:39 INFO - u'sessionrestore_no_auto_restore', 17:08:39 INFO - u'tabpaint']}, 17:08:39 INFO - u'other_nol64': {u'talos_options': [u'--disable-e10s'], 17:08:39 INFO - u'tests': [u'a11yr', 17:08:39 INFO - u'ts_paint', 17:08:39 INFO - u'tpaint', 17:08:39 INFO - u'sessionrestore', 17:08:39 INFO - u'sessionrestore_no_auto_restore', 17:08:39 INFO - u'tabpaint']}, 17:08:39 INFO - u'svgr': {u'talos_options': [u'--disable-e10s'], 17:08:39 INFO - u'tests': [u'tsvgx', 17:08:39 INFO - u'tsvgr_opacity', 17:08:39 INFO - u'tart', 17:08:39 INFO - u'tscrollx', 17:08:39 INFO - u'cart']}, 17:08:39 INFO - u'svgr-e10s': {u'tests': [u'tsvgx', 17:08:39 INFO - u'tsvgr_opacity', 17:08:39 INFO - u'tart', 17:08:39 INFO - u'tscrollx', 17:08:39 INFO - u'cart']}, 17:08:39 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:39 INFO - u'talos_options': [u'--disable-e10s'], 17:08:39 INFO - u'tests': [u'tp5o']}, 17:08:39 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:39 INFO - u'tests': [u'tp5o']}, 17:08:39 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:39 INFO - u'talos_options': [u'--disable-e10s', 17:08:39 INFO - u'--xperf_path', 17:08:39 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:08:39 INFO - u'tests': [u'tp5n']}, 17:08:39 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:39 INFO - u'talos_options': [u'--xperf_path', 17:08:39 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:08:39 INFO - u'tests': [u'tp5n']}}, 17:08:39 INFO - u'talos.zip': {u'path': u'', 17:08:39 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:08:39 INFO - Running post-action listener: _resource_record_post_action 17:08:39 INFO - [mozharness: 2016-10-18 00:08:39.901000Z] Finished populate-webroot step (success) 17:08:39 INFO - [mozharness: 2016-10-18 00:08:39.901000Z] Running create-virtualenv step. 17:08:39 INFO - Running pre-action listener: _resource_record_pre_action 17:08:39 INFO - Running main action method: create_virtualenv 17:08:39 INFO - Creating virtualenv C:\slave\test\build/venv 17:08:39 INFO - mkdir: C:\slave\test\build\venv\Scripts 17:08:39 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll 17:08:39 WARNING - Can't copy c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll: [Errno 2] No such file or directory: 'c:/mozilla-build/python27/python27.dll'! 17:08:39 INFO - Running command: ['c:/mozilla-build/python27/python.exe', 'c:/mozilla-build/buildbotve/virtualenv.py', '--no-site-packages', '--distribute', 'C:\\slave\\test\\build/venv'] in C:\slave\test\build 17:08:39 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build/venv 17:08:47 INFO - New python executable in C:\slave\test\build/venv\Scripts\python.exe 17:08:51 INFO - Installing distribute......................................................................................................................................................................................done. 17:08:53 INFO - Return code: 0 17:08:53 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', '--version'] 17:08:53 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip --version 17:08:53 INFO - Reading from file tmpfile_stdout 17:08:53 INFO - Output received: 17:08:53 INFO - pip 0.8.2 from c:\slave\test\build\venv\lib\site-packages\pip-0.8.2-py2.7.egg (python 2.7) 17:08:53 INFO - Using _rmtree_windows ... 17:08:53 INFO - Using _rmtree_windows ... 17:08:53 INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv 17:08: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')]} 17:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08: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')]} 17:08:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0242C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024D6E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x025E16D0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024F2E90>, '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 0x007CA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02907520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-189', 'USERDOMAIN': 'T-W864-IX-189', '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-189', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-189\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-189', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-189', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-189', '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-189\\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 17:08: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', 'pip>=1.5'] in C:\slave\test\build 17:08: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 pip>=1.5 17:08:53 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 17:08:53 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-189\\AppData\\Roaming', 17:08:53 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 17:08:53 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 17:08:53 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 17:08:53 INFO - 'COMPUTERNAME': 'T-W864-IX-189', 17:08:53 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 17:08:53 INFO - 'DCLOCATION': 'SCL3', 17:08:53 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 17:08:53 INFO - 'FP_NO_HOST_CHECK': 'NO', 17:08:53 INFO - 'HOMEDRIVE': 'C:', 17:08:53 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-189', 17:08:53 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 17:08:53 INFO - 'KTS_VERSION': '1.19c', 17:08:53 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-189\\AppData\\Local', 17:08:53 INFO - 'LOGONSERVER': '\\\\T-W864-IX-189', 17:08:53 INFO - 'MONDIR': 'C:\\Monitor_config\\', 17:08:53 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 17:08:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:53 INFO - 'MOZ_NO_REMOTE': '1', 17:08:53 INFO - 'NO_EM_RESTART': '1', 17:08:53 INFO - 'NUMBER_OF_PROCESSORS': '8', 17:08:53 INFO - 'OS': 'Windows_NT', 17:08:53 INFO - 'OURDRIVE': 'C:', 17:08: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', 17:08:53 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 17:08:53 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 17:08:53 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 17:08:53 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 17:08:53 INFO - 'PROCESSOR_LEVEL': '6', 17:08:53 INFO - 'PROCESSOR_REVISION': '1e05', 17:08:53 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 17:08:53 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 17:08:53 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 17:08:53 INFO - 'PROGRAMW6432': 'C:\\Program Files', 17:08:53 INFO - 'PROMPT': '$P$G', 17:08:53 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 17:08:53 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 17:08:53 INFO - 'PUBLIC': 'C:\\Users\\Public', 17:08:53 INFO - 'PWD': 'C:\\slave\\test', 17:08:53 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 17:08:53 INFO - 'SLAVEDIR': 'C:\\slave\\', 17:08:53 INFO - 'SYSTEMDRIVE': 'C:', 17:08:53 INFO - 'SYSTEMROOT': 'C:\\windows', 17:08:53 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 17:08:53 INFO - 'TEST1': 'testie', 17:08:53 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 17:08:53 INFO - 'USERDOMAIN': 'T-W864-IX-189', 17:08:53 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-189', 17:08:53 INFO - 'USERNAME': 'cltbld', 17:08:53 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-189', 17:08:53 INFO - 'WINDIR': 'C:\\windows', 17:08:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 17:08:54 INFO - Ignoring indexes: http://pypi.python.org/simple/ 17:08:54 INFO - Downloading/unpacking pip>=1.5 17:08:58 INFO - Running setup.py egg_info for package pip 17:08:58 INFO - warning: no files found matching 'pip\cacert.pem' 17:08:58 INFO - warning: no files found matching '*.html' under directory 'docs' 17:08:58 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 17:08:58 INFO - no previously-included directories found matching 'docs\_build\_sources' 17:08:58 INFO - Installing collected packages: pip 17:08:58 INFO - Found existing installation: pip 0.8.2 17:08:58 INFO - Uninstalling pip: 17:08:58 INFO - Successfully uninstalled pip 17:08:58 INFO - Running setup.py install for pip 17:08:58 INFO - warning: no files found matching 'pip\cacert.pem' 17:08:58 INFO - warning: no files found matching '*.html' under directory 'docs' 17:08:58 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 17:08:58 INFO - no previously-included directories found matching 'docs\_build\_sources' 17:08:58 INFO - Installing pip-script.py script to C:\slave\test\build\venv\Scripts 17:08:58 INFO - Installing pip.exe script to C:\slave\test\build\venv\Scripts 17:08:58 INFO - Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts 17:08:58 INFO - Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts 17:08:58 INFO - Installing pip2-script.py script to C:\slave\test\build\venv\Scripts 17:08:58 INFO - Installing pip2.exe script to C:\slave\test\build\venv\Scripts 17:08:58 INFO - Successfully installed pip 17:08:58 INFO - Cleaning up... 17:08:58 INFO - Return code: 0 17:08:58 INFO - Installing psutil>=3.1.1 into virtualenv C:\slave\test\build/venv 17:08: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')]} 17:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08: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')]} 17:08:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:58 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x0242C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024D6E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x025E16D0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024F2E90>, '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 0x007CA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02907520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-189', 'USERDOMAIN': 'T-W864-IX-189', '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-189', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-189\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-189', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-189', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-189', '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-189\\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 17:08:58 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in C:\slave\test\build 17:08:58 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:08:58 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 17:08:58 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-189\\AppData\\Roaming', 17:08:58 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 17:08:58 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 17:08:58 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 17:08:58 INFO - 'COMPUTERNAME': 'T-W864-IX-189', 17:08:58 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 17:08:58 INFO - 'DCLOCATION': 'SCL3', 17:08:58 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 17:08:58 INFO - 'FP_NO_HOST_CHECK': 'NO', 17:08:58 INFO - 'HOMEDRIVE': 'C:', 17:08:58 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-189', 17:08:58 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 17:08:58 INFO - 'KTS_VERSION': '1.19c', 17:08:58 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-189\\AppData\\Local', 17:08:58 INFO - 'LOGONSERVER': '\\\\T-W864-IX-189', 17:08:58 INFO - 'MONDIR': 'C:\\Monitor_config\\', 17:08:58 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 17:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:58 INFO - 'MOZ_NO_REMOTE': '1', 17:08:58 INFO - 'NO_EM_RESTART': '1', 17:08:58 INFO - 'NUMBER_OF_PROCESSORS': '8', 17:08:58 INFO - 'OS': 'Windows_NT', 17:08:58 INFO - 'OURDRIVE': 'C:', 17:08: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', 17:08:58 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 17:08:58 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 17:08:58 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 17:08:58 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 17:08:58 INFO - 'PROCESSOR_LEVEL': '6', 17:08:58 INFO - 'PROCESSOR_REVISION': '1e05', 17:08:58 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 17:08:58 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 17:08:58 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 17:08:58 INFO - 'PROGRAMW6432': 'C:\\Program Files', 17:08:58 INFO - 'PROMPT': '$P$G', 17:08:58 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 17:08:58 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 17:08:58 INFO - 'PUBLIC': 'C:\\Users\\Public', 17:08:58 INFO - 'PWD': 'C:\\slave\\test', 17:08:58 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 17:08:58 INFO - 'SLAVEDIR': 'C:\\slave\\', 17:08:58 INFO - 'SYSTEMDRIVE': 'C:', 17:08:58 INFO - 'SYSTEMROOT': 'C:\\windows', 17:08:58 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 17:08:58 INFO - 'TEST1': 'testie', 17:08:58 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 17:08:58 INFO - 'USERDOMAIN': 'T-W864-IX-189', 17:08:58 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-189', 17:08:58 INFO - 'USERNAME': 'cltbld', 17:08:58 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-189', 17:08:58 INFO - 'WINDIR': 'C:\\windows', 17:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 17:09:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:00 INFO - Downloading/unpacking psutil>=3.1.1 17:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:01 INFO - Installing collected packages: psutil 17:09:01 INFO - Successfully installed psutil 17:09:01 INFO - Cleaning up... 17:09:02 INFO - Return code: 0 17:09:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv C:\slave\test\build/venv 17:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:09:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:02 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0242C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024D6E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x025E16D0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024F2E90>, '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 0x007CA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02907520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-189', 'USERDOMAIN': 'T-W864-IX-189', '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-189', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-189\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-189', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-189', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-189', '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-189\\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 17:09:02 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in C:\slave\test\build 17:09:02 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:09:02 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 17:09:02 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-189\\AppData\\Roaming', 17:09:02 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 17:09:02 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 17:09:02 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 17:09:02 INFO - 'COMPUTERNAME': 'T-W864-IX-189', 17:09:02 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 17:09:02 INFO - 'DCLOCATION': 'SCL3', 17:09:02 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 17:09:02 INFO - 'FP_NO_HOST_CHECK': 'NO', 17:09:02 INFO - 'HOMEDRIVE': 'C:', 17:09:02 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-189', 17:09:02 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 17:09:02 INFO - 'KTS_VERSION': '1.19c', 17:09:02 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-189\\AppData\\Local', 17:09:02 INFO - 'LOGONSERVER': '\\\\T-W864-IX-189', 17:09:02 INFO - 'MONDIR': 'C:\\Monitor_config\\', 17:09:02 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 17:09:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:02 INFO - 'MOZ_NO_REMOTE': '1', 17:09:02 INFO - 'NO_EM_RESTART': '1', 17:09:02 INFO - 'NUMBER_OF_PROCESSORS': '8', 17:09:02 INFO - 'OS': 'Windows_NT', 17:09:02 INFO - 'OURDRIVE': 'C:', 17:09:02 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 17:09:02 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 17:09:02 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 17:09:02 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 17:09:02 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 17:09:02 INFO - 'PROCESSOR_LEVEL': '6', 17:09:02 INFO - 'PROCESSOR_REVISION': '1e05', 17:09:02 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 17:09:02 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 17:09:02 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 17:09:02 INFO - 'PROGRAMW6432': 'C:\\Program Files', 17:09:02 INFO - 'PROMPT': '$P$G', 17:09:02 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 17:09:02 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 17:09:02 INFO - 'PUBLIC': 'C:\\Users\\Public', 17:09:02 INFO - 'PWD': 'C:\\slave\\test', 17:09:02 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 17:09:02 INFO - 'SLAVEDIR': 'C:\\slave\\', 17:09:02 INFO - 'SYSTEMDRIVE': 'C:', 17:09:02 INFO - 'SYSTEMROOT': 'C:\\windows', 17:09:02 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 17:09:02 INFO - 'TEST1': 'testie', 17:09:02 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 17:09:02 INFO - 'USERDOMAIN': 'T-W864-IX-189', 17:09:02 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-189', 17:09:02 INFO - 'USERNAME': 'cltbld', 17:09:02 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-189', 17:09:02 INFO - 'WINDIR': 'C:\\windows', 17:09:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 17:09:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:09:03 INFO - Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor 17:09:03 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) 17:09:03 INFO - Installing collected packages: mozsystemmonitor 17:09:03 INFO - Running setup.py install for mozsystemmonitor 17:09:03 INFO - Successfully installed mozsystemmonitor 17:09:03 INFO - Cleaning up... 17:09:03 INFO - Return code: 0 17:09:03 INFO - Installing jsonschema==2.5.1 into virtualenv C:\slave\test\build/venv 17:09:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:09:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:03 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x0242C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024D6E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x025E16D0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024F2E90>, '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 0x007CA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02907520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-189', 'USERDOMAIN': 'T-W864-IX-189', '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-189', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-189\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-189', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-189', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-189', '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-189\\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 17:09:04 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in C:\slave\test\build 17:09:04 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:09:04 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 17:09:04 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-189\\AppData\\Roaming', 17:09:04 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 17:09:04 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 17:09:04 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 17:09:04 INFO - 'COMPUTERNAME': 'T-W864-IX-189', 17:09:04 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 17:09:04 INFO - 'DCLOCATION': 'SCL3', 17:09:04 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 17:09:04 INFO - 'FP_NO_HOST_CHECK': 'NO', 17:09:04 INFO - 'HOMEDRIVE': 'C:', 17:09:04 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-189', 17:09:04 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 17:09:04 INFO - 'KTS_VERSION': '1.19c', 17:09:04 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-189\\AppData\\Local', 17:09:04 INFO - 'LOGONSERVER': '\\\\T-W864-IX-189', 17:09:04 INFO - 'MONDIR': 'C:\\Monitor_config\\', 17:09:04 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 17:09:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:04 INFO - 'MOZ_NO_REMOTE': '1', 17:09:04 INFO - 'NO_EM_RESTART': '1', 17:09:04 INFO - 'NUMBER_OF_PROCESSORS': '8', 17:09:04 INFO - 'OS': 'Windows_NT', 17:09:04 INFO - 'OURDRIVE': 'C:', 17:09:04 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 17:09:04 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 17:09:04 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 17:09:04 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 17:09:04 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 17:09:04 INFO - 'PROCESSOR_LEVEL': '6', 17:09:04 INFO - 'PROCESSOR_REVISION': '1e05', 17:09:04 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 17:09:04 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 17:09:04 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 17:09:04 INFO - 'PROGRAMW6432': 'C:\\Program Files', 17:09:04 INFO - 'PROMPT': '$P$G', 17:09:04 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 17:09:04 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 17:09:04 INFO - 'PUBLIC': 'C:\\Users\\Public', 17:09:04 INFO - 'PWD': 'C:\\slave\\test', 17:09:04 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 17:09:04 INFO - 'SLAVEDIR': 'C:\\slave\\', 17:09:04 INFO - 'SYSTEMDRIVE': 'C:', 17:09:04 INFO - 'SYSTEMROOT': 'C:\\windows', 17:09:04 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 17:09:04 INFO - 'TEST1': 'testie', 17:09:04 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 17:09:04 INFO - 'USERDOMAIN': 'T-W864-IX-189', 17:09:04 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-189', 17:09:04 INFO - 'USERNAME': 'cltbld', 17:09:04 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-189', 17:09:04 INFO - 'WINDIR': 'C:\\windows', 17:09:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 17:09:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:04 INFO - Downloading/unpacking jsonschema==2.5.1 17:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:09:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:05 INFO - Downloading functools32-3.2.3-2.tar.gz 17:09:05 INFO - Running setup.py (path:C:\slave\test\build\venv\build\functools32\setup.py) egg_info for package functools32 17:09:05 INFO - warning: no files found matching '*.txt' 17:09:05 INFO - no previously-included directories found matching 'build' 17:09:05 INFO - no previously-included directories found matching 'dist' 17:09:05 INFO - no previously-included directories found matching '.git*' 17:09:05 INFO - Installing collected packages: jsonschema, functools32 17:09:05 INFO - Running setup.py install for functools32 17:09:05 INFO - warning: no files found matching '*.txt' 17:09:05 INFO - no previously-included directories found matching 'build' 17:09:05 INFO - no previously-included directories found matching 'dist' 17:09:05 INFO - no previously-included directories found matching '.git*' 17:09:05 INFO - Successfully installed jsonschema functools32 17:09:05 INFO - Cleaning up... 17:09:06 INFO - Return code: 0 17:09:06 INFO - Installing functools32==3.2.3-2 into virtualenv C:\slave\test\build/venv 17:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:09:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:06 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0242C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024D6E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x025E16D0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024F2E90>, '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 0x007CA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02907520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-189', 'USERDOMAIN': 'T-W864-IX-189', '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-189', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-189\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-189', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-189', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-189', '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-189\\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 17:09:06 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 17:09:06 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 17:09:06 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 17:09:06 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-189\\AppData\\Roaming', 17:09:06 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 17:09:06 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 17:09:06 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 17:09:06 INFO - 'COMPUTERNAME': 'T-W864-IX-189', 17:09:06 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 17:09:06 INFO - 'DCLOCATION': 'SCL3', 17:09:06 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 17:09:06 INFO - 'FP_NO_HOST_CHECK': 'NO', 17:09:06 INFO - 'HOMEDRIVE': 'C:', 17:09:06 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-189', 17:09:06 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 17:09:06 INFO - 'KTS_VERSION': '1.19c', 17:09:06 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-189\\AppData\\Local', 17:09:06 INFO - 'LOGONSERVER': '\\\\T-W864-IX-189', 17:09:06 INFO - 'MONDIR': 'C:\\Monitor_config\\', 17:09:06 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 17:09:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:06 INFO - 'MOZ_NO_REMOTE': '1', 17:09:06 INFO - 'NO_EM_RESTART': '1', 17:09:06 INFO - 'NUMBER_OF_PROCESSORS': '8', 17:09:06 INFO - 'OS': 'Windows_NT', 17:09:06 INFO - 'OURDRIVE': 'C:', 17:09:06 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', 17:09:06 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 17:09:06 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 17:09:06 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 17:09:06 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 17:09:06 INFO - 'PROCESSOR_LEVEL': '6', 17:09:06 INFO - 'PROCESSOR_REVISION': '1e05', 17:09:06 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 17:09:06 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 17:09:06 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 17:09:06 INFO - 'PROGRAMW6432': 'C:\\Program Files', 17:09:06 INFO - 'PROMPT': '$P$G', 17:09:06 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 17:09:06 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 17:09:06 INFO - 'PUBLIC': 'C:\\Users\\Public', 17:09:06 INFO - 'PWD': 'C:\\slave\\test', 17:09:06 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 17:09:06 INFO - 'SLAVEDIR': 'C:\\slave\\', 17:09:06 INFO - 'SYSTEMDRIVE': 'C:', 17:09:06 INFO - 'SYSTEMROOT': 'C:\\windows', 17:09:06 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 17:09:06 INFO - 'TEST1': 'testie', 17:09:06 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 17:09:06 INFO - 'USERDOMAIN': 'T-W864-IX-189', 17:09:06 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-189', 17:09:06 INFO - 'USERNAME': 'cltbld', 17:09:06 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-189', 17:09:06 INFO - 'WINDIR': 'C:\\windows', 17:09:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 17:09:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in c:\slave\test\build\venv\lib\site-packages 17:09:06 INFO - Cleaning up... 17:09:06 INFO - Return code: 0 17:09:06 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv 17:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:09:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:06 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x0242C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024D6E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x025E16D0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024F2E90>, '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 0x007CA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02907520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-189', 'USERDOMAIN': 'T-W864-IX-189', '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-189', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-189\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-189', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-189', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-189', '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-189\\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 17:09:06 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 17:09:06 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 17:09:06 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 17:09:06 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-189\\AppData\\Roaming', 17:09:06 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 17:09:06 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 17:09:06 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 17:09:06 INFO - 'COMPUTERNAME': 'T-W864-IX-189', 17:09:06 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 17:09:06 INFO - 'DCLOCATION': 'SCL3', 17:09:06 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 17:09:06 INFO - 'FP_NO_HOST_CHECK': 'NO', 17:09:06 INFO - 'HOMEDRIVE': 'C:', 17:09:06 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-189', 17:09:06 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 17:09:06 INFO - 'KTS_VERSION': '1.19c', 17:09:06 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-189\\AppData\\Local', 17:09:06 INFO - 'LOGONSERVER': '\\\\T-W864-IX-189', 17:09:06 INFO - 'MONDIR': 'C:\\Monitor_config\\', 17:09:06 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 17:09:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:06 INFO - 'MOZ_NO_REMOTE': '1', 17:09:06 INFO - 'NO_EM_RESTART': '1', 17:09:06 INFO - 'NUMBER_OF_PROCESSORS': '8', 17:09:06 INFO - 'OS': 'Windows_NT', 17:09:06 INFO - 'OURDRIVE': 'C:', 17:09:06 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', 17:09:06 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 17:09:06 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 17:09:06 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 17:09:06 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 17:09:06 INFO - 'PROCESSOR_LEVEL': '6', 17:09:06 INFO - 'PROCESSOR_REVISION': '1e05', 17:09:06 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 17:09:06 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 17:09:06 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 17:09:06 INFO - 'PROGRAMW6432': 'C:\\Program Files', 17:09:06 INFO - 'PROMPT': '$P$G', 17:09:06 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 17:09:06 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 17:09:06 INFO - 'PUBLIC': 'C:\\Users\\Public', 17:09:06 INFO - 'PWD': 'C:\\slave\\test', 17:09:06 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 17:09:06 INFO - 'SLAVEDIR': 'C:\\slave\\', 17:09:06 INFO - 'SYSTEMDRIVE': 'C:', 17:09:06 INFO - 'SYSTEMROOT': 'C:\\windows', 17:09:06 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 17:09:06 INFO - 'TEST1': 'testie', 17:09:06 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 17:09:06 INFO - 'USERDOMAIN': 'T-W864-IX-189', 17:09:06 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-189', 17:09:06 INFO - 'USERNAME': 'cltbld', 17:09:06 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-189', 17:09:06 INFO - 'WINDIR': 'C:\\windows', 17:09:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 17:09:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:06 INFO - Downloading/unpacking blobuploader==1.2.4 17:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:07 INFO - Downloading blobuploader-1.2.4.tar.gz 17:09:07 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader 17:09:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:08 INFO - Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests 17:09:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:08 INFO - Downloading docopt-0.6.1.tar.gz 17:09:08 INFO - Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt 17:09:08 INFO - Installing collected packages: blobuploader, requests, docopt 17:09:08 INFO - Running setup.py install for blobuploader 17:09:08 INFO - Running setup.py install for requests 17:09:09 INFO - Running setup.py install for docopt 17:09:09 INFO - Successfully installed blobuploader requests docopt 17:09:09 INFO - Cleaning up... 17:09:10 INFO - Return code: 0 17:09:10 INFO - Installing None into virtualenv C:\slave\test\build/venv 17:09:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:09:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:10 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 0x0242C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024D6E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x025E16D0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024F2E90>, '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 0x007CA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02907520>, '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-189', 'USERDOMAIN': 'T-W864-IX-189', '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-189', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-189\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-189', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-189', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-189', '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-189\\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 17:09:10 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 17:09:10 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 17:09:10 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 17:09:10 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-189\\AppData\\Roaming', 17:09:10 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 17:09:10 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 17:09:10 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 17:09:10 INFO - 'COMPUTERNAME': 'T-W864-IX-189', 17:09:10 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 17:09:10 INFO - 'DCLOCATION': 'SCL3', 17:09:10 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 17:09:10 INFO - 'FP_NO_HOST_CHECK': 'NO', 17:09:10 INFO - 'HOMEDRIVE': 'C:', 17:09:10 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-189', 17:09:10 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 17:09:10 INFO - 'KTS_VERSION': '1.19c', 17:09:10 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-189\\AppData\\Local', 17:09:10 INFO - 'LOGONSERVER': '\\\\T-W864-IX-189', 17:09:10 INFO - 'MONDIR': 'C:\\Monitor_config\\', 17:09:10 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 17:09:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:10 INFO - 'MOZ_NO_REMOTE': '1', 17:09:10 INFO - 'NO_EM_RESTART': '1', 17:09:10 INFO - 'NUMBER_OF_PROCESSORS': '8', 17:09:10 INFO - 'OS': 'Windows_NT', 17:09:10 INFO - 'OURDRIVE': 'C:', 17:09:10 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 17:09:10 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 17:09:10 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 17:09:10 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 17:09:10 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 17:09:10 INFO - 'PROCESSOR_LEVEL': '6', 17:09:10 INFO - 'PROCESSOR_REVISION': '1e05', 17:09:10 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 17:09:10 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 17:09:10 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 17:09:10 INFO - 'PROGRAMW6432': 'C:\\Program Files', 17:09:10 INFO - 'PROMPT': '$P$G', 17:09:10 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 17:09:10 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 17:09:10 INFO - 'PUBLIC': 'C:\\Users\\Public', 17:09:10 INFO - 'PWD': 'C:\\slave\\test', 17:09:10 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 17:09:10 INFO - 'SLAVEDIR': 'C:\\slave\\', 17:09:10 INFO - 'SYSTEMDRIVE': 'C:', 17:09:10 INFO - 'SYSTEMROOT': 'C:\\windows', 17:09:10 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 17:09:10 INFO - 'TEST1': 'testie', 17:09:10 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 17:09:10 INFO - 'USERDOMAIN': 'T-W864-IX-189', 17:09:10 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-189', 17:09:10 INFO - 'USERNAME': 'cltbld', 17:09:10 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-189', 17:09:10 INFO - 'WINDIR': 'C:\\windows', 17:09:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 17:09:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:11 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 17:09:11 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-hp2ipe-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 17:09:11 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 17:09:11 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-juuunb-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 17:09:11 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 17:09:11 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-k7aeat-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 17:09:11 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 17:09:11 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-gp4g1p-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 17:09:11 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 17:09:11 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-a0mufh-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 17:09:11 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 17:09:11 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-fwdkpu-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 17:09:11 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 17:09:11 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-apsoyt-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 17:09:11 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 17:09:11 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xsmgee-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 17:09:12 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 17:09:12 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-_tsuur-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 17:09:12 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 17:09:12 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-tb3giw-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 17:09:12 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 17:09:12 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ncvqh5-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 17:09:12 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 17:09:12 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-y3hrmp-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 17:09:12 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 17:09:12 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-2ruuwv-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 17:09:12 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 17:09:12 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-v9rk4v-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 17:09:12 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 17:09:12 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ihrk0k-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 17:09:12 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 17:09:12 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-hirm5q-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 17:09:12 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 17:09:12 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-f0gj6o-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 17:09:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:09:13 INFO - Running setup.py install for manifestparser 17:09:13 INFO - Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts 17:09:13 INFO - Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts 17:09:14 INFO - Running setup.py install for mozcrash 17:09:14 INFO - Running setup.py install for mozdebug 17:09:14 INFO - Running setup.py install for mozdevice 17:09:14 INFO - Installing sutini-script.py script to C:\slave\test\build\venv\Scripts 17:09:14 INFO - Installing sutini.exe script to C:\slave\test\build\venv\Scripts 17:09:14 INFO - Installing dm-script.py script to C:\slave\test\build\venv\Scripts 17:09:14 INFO - Installing dm.exe script to C:\slave\test\build\venv\Scripts 17:09:15 INFO - Running setup.py install for mozfile 17:09:15 INFO - Running setup.py install for mozhttpd 17:09:15 INFO - Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts 17:09:15 INFO - Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts 17:09:16 INFO - Running setup.py install for mozinfo 17:09:16 INFO - Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts 17:09:16 INFO - Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts 17:09:16 INFO - Running setup.py install for mozInstall 17:09:16 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts 17:09:16 INFO - Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts 17:09:16 INFO - Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts 17:09:16 INFO - Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts 17:09:16 INFO - Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts 17:09:16 INFO - Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts 17:09:16 INFO - Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts 17:09:16 INFO - Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts 17:09:16 INFO - Running setup.py install for mozleak 17:09:17 INFO - Running setup.py install for mozlog 17:09:17 INFO - Installing structlog-script.py script to C:\slave\test\build\venv\Scripts 17:09:17 INFO - Installing structlog.exe script to C:\slave\test\build\venv\Scripts 17:09:18 INFO - Running setup.py install for moznetwork 17:09:18 INFO - Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts 17:09:18 INFO - Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts 17:09:18 INFO - Running setup.py install for mozprocess 17:09:19 INFO - Running setup.py install for mozprofile 17:09:19 INFO - Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts 17:09:19 INFO - Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts 17:09:19 INFO - Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts 17:09:19 INFO - Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts 17:09:19 INFO - Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts 17:09:19 INFO - Installing view-profile.exe script to C:\slave\test\build\venv\Scripts 17:09:19 INFO - Running setup.py install for mozrunner 17:09:19 INFO - Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts 17:09:19 INFO - Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts 17:09:20 INFO - Running setup.py install for mozscreenshot 17:09:20 INFO - Running setup.py install for moztest 17:09:21 INFO - Running setup.py install for mozversion 17:09:21 INFO - Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts 17:09:21 INFO - Installing mozversion.exe script to C:\slave\test\build\venv\Scripts 17:09:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:09:21 INFO - Cleaning up... 17:09:21 INFO - Return code: 0 17:09:21 INFO - Installing None into virtualenv C:\slave\test\build/venv 17:09:21 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')]} 17:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:21 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')]} 17:09:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:21 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 0x0242C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024D6E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x025E16D0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024F2E90>, '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 0x007CA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02907520>, '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-189', 'USERDOMAIN': 'T-W864-IX-189', '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-189', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-189\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-189', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-189', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-189', '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-189\\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 17:09:21 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 17:09:21 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 17:09:21 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 17:09:21 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-189\\AppData\\Roaming', 17:09:21 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 17:09:21 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 17:09:21 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 17:09:21 INFO - 'COMPUTERNAME': 'T-W864-IX-189', 17:09:21 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 17:09:21 INFO - 'DCLOCATION': 'SCL3', 17:09:21 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 17:09:21 INFO - 'FP_NO_HOST_CHECK': 'NO', 17:09:21 INFO - 'HOMEDRIVE': 'C:', 17:09:21 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-189', 17:09:21 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 17:09:21 INFO - 'KTS_VERSION': '1.19c', 17:09:21 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-189\\AppData\\Local', 17:09:21 INFO - 'LOGONSERVER': '\\\\T-W864-IX-189', 17:09:21 INFO - 'MONDIR': 'C:\\Monitor_config\\', 17:09:21 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 17:09:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:21 INFO - 'MOZ_NO_REMOTE': '1', 17:09:21 INFO - 'NO_EM_RESTART': '1', 17:09:21 INFO - 'NUMBER_OF_PROCESSORS': '8', 17:09:21 INFO - 'OS': 'Windows_NT', 17:09:21 INFO - 'OURDRIVE': 'C:', 17:09: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', 17:09:21 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 17:09:21 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 17:09:21 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 17:09:21 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 17:09:21 INFO - 'PROCESSOR_LEVEL': '6', 17:09:21 INFO - 'PROCESSOR_REVISION': '1e05', 17:09:21 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 17:09:21 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 17:09:21 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 17:09:21 INFO - 'PROGRAMW6432': 'C:\\Program Files', 17:09:21 INFO - 'PROMPT': '$P$G', 17:09:21 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 17:09:21 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 17:09:21 INFO - 'PUBLIC': 'C:\\Users\\Public', 17:09:21 INFO - 'PWD': 'C:\\slave\\test', 17:09:21 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 17:09:21 INFO - 'SLAVEDIR': 'C:\\slave\\', 17:09:21 INFO - 'SYSTEMDRIVE': 'C:', 17:09:21 INFO - 'SYSTEMROOT': 'C:\\windows', 17:09:21 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 17:09:21 INFO - 'TEST1': 'testie', 17:09:21 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 17:09:21 INFO - 'USERDOMAIN': 'T-W864-IX-189', 17:09:21 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-189', 17:09:21 INFO - 'USERNAME': 'cltbld', 17:09:21 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-189', 17:09:21 INFO - 'WINDIR': 'C:\\windows', 17:09:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 17:09:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:21 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 17:09:21 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jktuys-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 17:09:21 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)) 17:09:21 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 17:09:21 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-hy6aog-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 17:09:22 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)) 17:09:22 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 17:09:22 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-0r1n91-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 17:09:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///C:/slave/test/build/tests/mozbase/mozdebug in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 3)) 17:09:22 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 17:09:22 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-939zuc-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 17:09:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///C:/slave/test/build/tests/mozbase/mozdevice in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4)) 17:09:22 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 17:09:22 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-2qjto_-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 17:09:22 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)) 17:09:22 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 17:09:22 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-d3v87d-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 17:09:22 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)) 17:09:22 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 17:09:22 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rwiz_p-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 17:09:22 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)) 17:09:22 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 17:09:22 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-tslmqr-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 17:09:22 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)) 17:09:22 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 17:09:22 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qy4js1-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 17:09:22 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)) 17:09:22 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 17:09:22 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-9duybr-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 17:09:22 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)) 17:09:22 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 17:09:22 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-3f4tei-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 17:09:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///C:/slave/test/build/tests/mozbase/moznetwork in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 11)) 17:09:23 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 17:09:23 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-8mnn3a-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 17:09:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///C:/slave/test/build/tests/mozbase/mozprocess in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 12)) 17:09:23 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 17:09:23 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ajhkyb-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 17:09:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///C:/slave/test/build/tests/mozbase/mozprofile in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 13)) 17:09:23 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 17:09:23 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-znvlve-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 17:09:23 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)) 17:09:23 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 17:09:23 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-zg8ifo-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 17:09:23 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)) 17:09:23 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 17:09:23 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-3zjf6u-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 17:09:23 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)) 17:09:23 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 17:09:23 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-iidf6n-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 17:09:23 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)) 17:09:23 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)) 17:09:23 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)) 17:09:23 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)) 17:09:23 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)) 17:09:23 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)) 17:09:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10)) 17:09:23 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 17:09:23 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 17:09:24 INFO - Downloading blessings-1.6.tar.gz 17:09:24 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings 17:09:25 INFO - Installing collected packages: blessings 17:09:25 INFO - Running setup.py install for blessings 17:09:25 INFO - Successfully installed blessings 17:09:25 INFO - Cleaning up... 17:09:28 INFO - Return code: 0 17:09:28 INFO - Done creating virtualenv C:\slave\test\build/venv. 17:09:28 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 17:09:28 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 17:09:28 INFO - Reading from file tmpfile_stdout 17:09:28 INFO - Using _rmtree_windows ... 17:09:28 INFO - Using _rmtree_windows ... 17:09:28 INFO - Current package versions: 17:09:28 INFO - blessings == 1.6 17:09:28 INFO - blobuploader == 1.2.4 17:09:28 INFO - docopt == 0.6.1 17:09:28 INFO - functools32 == 3.2.3-2 17:09:28 INFO - jsonschema == 2.5.1 17:09:28 INFO - manifestparser == 1.1 17:09:28 INFO - mozInstall == 1.12 17:09:28 INFO - mozcrash == 0.17 17:09:28 INFO - mozdebug == 0.1 17:09:28 INFO - mozdevice == 0.48 17:09:28 INFO - mozfile == 1.2 17:09:28 INFO - mozhttpd == 0.7 17:09:28 INFO - mozinfo == 0.9 17:09:28 INFO - mozleak == 0.1 17:09:28 INFO - mozlog == 3.4 17:09:28 INFO - moznetwork == 0.27 17:09:28 INFO - mozprocess == 0.23 17:09:28 INFO - mozprofile == 0.28 17:09:28 INFO - mozrunner == 6.12 17:09:28 INFO - mozscreenshot == 0.1 17:09:28 INFO - mozsystemmonitor == 0.3 17:09:28 INFO - moztest == 0.7 17:09:28 INFO - mozversion == 1.4 17:09:28 INFO - psutil == 3.1.1 17:09:28 INFO - requests == 1.2.3 17:09:28 INFO - Installing None into virtualenv C:\slave\test\build/venv 17:09:28 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')]} 17:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:28 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')]} 17:09:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:28 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 0x0242C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024D6E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x025E16D0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024F2E90>, '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 0x007CA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02907520>, '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-189', 'USERDOMAIN': 'T-W864-IX-189', '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-189', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-189\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-189', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-189', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-189', '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-189\\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 17:09:28 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 17:09:28 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 17:09:28 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 17:09:28 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-189\\AppData\\Roaming', 17:09:28 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 17:09:28 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 17:09:28 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 17:09:28 INFO - 'COMPUTERNAME': 'T-W864-IX-189', 17:09:28 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 17:09:28 INFO - 'DCLOCATION': 'SCL3', 17:09:28 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 17:09:28 INFO - 'FP_NO_HOST_CHECK': 'NO', 17:09:28 INFO - 'HOMEDRIVE': 'C:', 17:09:28 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-189', 17:09:28 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 17:09:28 INFO - 'KTS_VERSION': '1.19c', 17:09:28 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-189\\AppData\\Local', 17:09:28 INFO - 'LOGONSERVER': '\\\\T-W864-IX-189', 17:09:28 INFO - 'MONDIR': 'C:\\Monitor_config\\', 17:09:28 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 17:09:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:28 INFO - 'MOZ_NO_REMOTE': '1', 17:09:28 INFO - 'NO_EM_RESTART': '1', 17:09:28 INFO - 'NUMBER_OF_PROCESSORS': '8', 17:09:28 INFO - 'OS': 'Windows_NT', 17:09:28 INFO - 'OURDRIVE': 'C:', 17:09:28 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', 17:09:28 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 17:09:28 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 17:09:28 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 17:09:28 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 17:09:28 INFO - 'PROCESSOR_LEVEL': '6', 17:09:28 INFO - 'PROCESSOR_REVISION': '1e05', 17:09:28 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 17:09:28 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 17:09:28 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 17:09:28 INFO - 'PROGRAMW6432': 'C:\\Program Files', 17:09:28 INFO - 'PROMPT': '$P$G', 17:09:28 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 17:09:28 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 17:09:28 INFO - 'PUBLIC': 'C:\\Users\\Public', 17:09:28 INFO - 'PWD': 'C:\\slave\\test', 17:09:28 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 17:09:28 INFO - 'SLAVEDIR': 'C:\\slave\\', 17:09:28 INFO - 'SYSTEMDRIVE': 'C:', 17:09:28 INFO - 'SYSTEMROOT': 'C:\\windows', 17:09:28 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 17:09:28 INFO - 'TEST1': 'testie', 17:09:28 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 17:09:28 INFO - 'USERDOMAIN': 'T-W864-IX-189', 17:09:28 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-189', 17:09:28 INFO - 'USERNAME': 'cltbld', 17:09:28 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-189', 17:09:28 INFO - 'WINDIR': 'C:\\windows', 17:09:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 17:09:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 1)) 17:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 2)) 17:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 3)) 17:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 4)) 17:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 5)) 17:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 6)) 17:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 7)) 17:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 8)) 17:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 9)) 17:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in c:\slave\test\build\venv\lib\site-packages (from mozlog>=3.1->-r C:\slave\test\build\tests\talos\requirements.txt (line 1)) 17:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test\build\venv\lib\site-packages (from mozhttpd>=0.7->-r C:\slave\test\build\tests\talos\requirements.txt (line 4)) 17:09:29 INFO - Cleaning up... 17:09:29 INFO - Return code: 0 17:09:29 INFO - Installing jsonschema into virtualenv C:\slave\test\build/venv 17:09:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:09:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:09:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:29 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0242C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024D6E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x025E16D0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024F2E90>, '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 0x007CA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02907520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-189', 'USERDOMAIN': 'T-W864-IX-189', '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-189', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-189\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-189', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-189', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-189', '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-189\\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 17:09:29 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in C:\slave\test\build 17:09:29 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:09:29 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 17:09:29 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-189\\AppData\\Roaming', 17:09:29 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 17:09:29 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 17:09:29 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 17:09:29 INFO - 'COMPUTERNAME': 'T-W864-IX-189', 17:09:29 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 17:09:29 INFO - 'DCLOCATION': 'SCL3', 17:09:29 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 17:09:29 INFO - 'FP_NO_HOST_CHECK': 'NO', 17:09:29 INFO - 'HOMEDRIVE': 'C:', 17:09:29 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-189', 17:09:29 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 17:09:29 INFO - 'KTS_VERSION': '1.19c', 17:09:29 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-189\\AppData\\Local', 17:09:29 INFO - 'LOGONSERVER': '\\\\T-W864-IX-189', 17:09:29 INFO - 'MONDIR': 'C:\\Monitor_config\\', 17:09:29 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 17:09:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:29 INFO - 'MOZ_NO_REMOTE': '1', 17:09:29 INFO - 'NO_EM_RESTART': '1', 17:09:29 INFO - 'NUMBER_OF_PROCESSORS': '8', 17:09:29 INFO - 'OS': 'Windows_NT', 17:09:29 INFO - 'OURDRIVE': 'C:', 17:09:29 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 17:09:29 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 17:09:29 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 17:09:29 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 17:09:29 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 17:09:29 INFO - 'PROCESSOR_LEVEL': '6', 17:09:29 INFO - 'PROCESSOR_REVISION': '1e05', 17:09:29 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 17:09:29 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 17:09:29 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 17:09:29 INFO - 'PROGRAMW6432': 'C:\\Program Files', 17:09:29 INFO - 'PROMPT': '$P$G', 17:09:29 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 17:09:29 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 17:09:29 INFO - 'PUBLIC': 'C:\\Users\\Public', 17:09:29 INFO - 'PWD': 'C:\\slave\\test', 17:09:29 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 17:09:29 INFO - 'SLAVEDIR': 'C:\\slave\\', 17:09:29 INFO - 'SYSTEMDRIVE': 'C:', 17:09:29 INFO - 'SYSTEMROOT': 'C:\\windows', 17:09:29 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 17:09:29 INFO - 'TEST1': 'testie', 17:09:29 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 17:09:29 INFO - 'USERDOMAIN': 'T-W864-IX-189', 17:09:29 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-189', 17:09:29 INFO - 'USERNAME': 'cltbld', 17:09:29 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-189', 17:09:29 INFO - 'WINDIR': 'C:\\windows', 17:09:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 17:09:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in c:\slave\test\build\venv\lib\site-packages 17:09:29 INFO - Cleaning up... 17:09:29 INFO - Return code: 0 17:09:29 INFO - Running post-action listener: _resource_record_post_action 17:09:29 INFO - Running post-action listener: _start_resource_monitoring 17:09:29 INFO - Starting resource monitoring. 17:09:29 INFO - [mozharness: 2016-10-18 00:09:29.701000Z] Finished create-virtualenv step (success) 17:09:29 INFO - [mozharness: 2016-10-18 00:09:29.701000Z] Running install step. 17:09:29 INFO - Running pre-action listener: _resource_record_pre_action 17:09:29 INFO - Running main action method: install 17:09:29 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 17:09:29 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 17:09:30 INFO - Reading from file tmpfile_stdout 17:09:30 INFO - Using _rmtree_windows ... 17:09:30 INFO - Using _rmtree_windows ... 17:09:30 INFO - Detecting whether we're running mozinstall >=1.0... 17:09:30 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h'] 17:09:30 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h 17:09:30 INFO - Reading from file tmpfile_stdout 17:09:30 INFO - Output received: 17:09:30 INFO - Usage: mozinstall-script.py [options] installer 17:09:30 INFO - Options: 17:09:30 INFO - -h, --help show this help message and exit 17:09:30 INFO - -d DEST, --destination=DEST 17:09:30 INFO - Directory to install application into. [default: 17:09:30 INFO - "C:\slave\test"] 17:09:30 INFO - --app=APP Application being installed. [default: firefox] 17:09:30 INFO - Using _rmtree_windows ... 17:09:30 INFO - Using _rmtree_windows ... 17:09:30 INFO - mkdir: C:\slave\test\build\application 17:09:30 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', 'C:\\slave\\test\\build\\firefox-52.0a1.en-US.win64.zip', '--destination', 'C:\\slave\\test\\build\\application'] 17:09:30 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py C:\slave\test\build\firefox-52.0a1.en-US.win64.zip --destination C:\slave\test\build\application 17:09:32 INFO - Reading from file tmpfile_stdout 17:09:32 INFO - Output received: 17:09:32 INFO - C:\slave\test\build\application\firefox\firefox.exe 17:09:32 INFO - Using _rmtree_windows ... 17:09:32 INFO - Using _rmtree_windows ... 17:09:32 INFO - Running post-action listener: _resource_record_post_action 17:09:32 INFO - [mozharness: 2016-10-18 00:09:32.599000Z] Finished install step (success) 17:09:32 INFO - [mozharness: 2016-10-18 00:09:32.599000Z] Running run-tests step. 17:09:32 INFO - Running pre-action listener: _resource_record_pre_action 17:09:32 INFO - Running main action method: run_tests 17:09:32 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version'] 17:09:32 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version 17:09:32 INFO - Python 2.7.3 17:09:32 INFO - Return code: 0 17:09:32 INFO - grabbing minidump binary from tooltool 17:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:09:32 INFO - retry: Calling run_command with args: (['c:/mozilla-build/python27/python.exe', 'C:/mozilla-build/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', 'c:\\builds\\relengapi.tok', 'fetch', '-m', 'C:\\slave\\test\\build\\tests\\config/tooltool-manifests/win32/releng.manifest', '-o'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x024F2E90>, '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 0x007CA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02907520>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1 17:09:32 INFO - Running command: ['c:/mozilla-build/python27/python.exe', 'C:/mozilla-build/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', 'c:\\builds\\relengapi.tok', 'fetch', '-m', 'C:\\slave\\test\\build\\tests\\config/tooltool-manifests/win32/releng.manifest', '-o'] in C:\slave\test\build 17:09:32 INFO - Copy/paste: c:/mozilla-build/python27/python.exe C:/mozilla-build/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file c:\builds\relengapi.tok fetch -m C:\slave\test\build\tests\config/tooltool-manifests/win32/releng.manifest -o 17:09:32 INFO - Calling ['c:/mozilla-build/python27/python.exe', 'C:/mozilla-build/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', 'c:\\builds\\relengapi.tok', 'fetch', '-m', 'C:\\slave\\test\\build\\tests\\config/tooltool-manifests/win32/releng.manifest', '-o'] with output_timeout 600 ProcessManager UNABLE to use job objects to manage child processes ProcessManager NOT managing child processes 17:09:32 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 17:09:34 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmppi5vam 17:09:34 INFO - INFO - File integrity verified, renaming tmppi5vam to win32-minidump_stackwalk.exe 17:09:34 INFO - Return code: 0 17:09:34 INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755 17:09:34 INFO - mkdir: C:\slave\test\build\blobber_upload_dir 17:09:34 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir 17:09:34 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe 17:09:34 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir 17:09:34 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JteFUZqGQUaU_oH0lWLEpw/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-189', '--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 17:09:34 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\tests\talos\talos\run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath C:\slave\test\build\application\firefox\firefox --symbolsPath https://queue.taskcluster.net/v1/task/JteFUZqGQUaU_oH0lWLEpw/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip --title T-W864-IX-189 --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 17:09:34 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 17:09:34 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-189\\AppData\\Roaming', 17:09:34 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 17:09:34 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 17:09:34 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 17:09:34 INFO - 'COMPUTERNAME': 'T-W864-IX-189', 17:09:34 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 17:09:34 INFO - 'DCLOCATION': 'SCL3', 17:09:34 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 17:09:34 INFO - 'FP_NO_HOST_CHECK': 'NO', 17:09:34 INFO - 'HOMEDRIVE': 'C:', 17:09:34 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-189', 17:09:34 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 17:09:34 INFO - 'KTS_VERSION': '1.19c', 17:09:34 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-189\\AppData\\Local', 17:09:34 INFO - 'LOGONSERVER': '\\\\T-W864-IX-189', 17:09:34 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir', 17:09:34 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe', 17:09:34 INFO - 'MONDIR': 'C:\\Monitor_config\\', 17:09:34 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 17:09:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:34 INFO - 'MOZ_NO_REMOTE': '1', 17:09:34 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir', 17:09:34 INFO - 'NO_EM_RESTART': '1', 17:09:34 INFO - 'NUMBER_OF_PROCESSORS': '8', 17:09:34 INFO - 'OS': 'Windows_NT', 17:09:34 INFO - 'OURDRIVE': 'C:', 17:09:34 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 17:09:34 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 17:09:34 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 17:09:34 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 17:09:34 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 17:09:34 INFO - 'PROCESSOR_LEVEL': '6', 17:09:34 INFO - 'PROCESSOR_REVISION': '1e05', 17:09:34 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 17:09:34 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 17:09:34 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 17:09:34 INFO - 'PROGRAMW6432': 'C:\\Program Files', 17:09:34 INFO - 'PROMPT': '$P$G', 17:09:34 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 17:09:34 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 17:09:34 INFO - 'PUBLIC': 'C:\\Users\\Public', 17:09:34 INFO - 'PWD': 'C:\\slave\\test', 17:09:34 INFO - 'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos', 17:09:34 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 17:09:34 INFO - 'SLAVEDIR': 'C:\\slave\\', 17:09:34 INFO - 'SYSTEMDRIVE': 'C:', 17:09:34 INFO - 'SYSTEMROOT': 'C:\\windows', 17:09:34 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 17:09:34 INFO - 'TEST1': 'testie', 17:09:34 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 17:09:34 INFO - 'USERDOMAIN': 'T-W864-IX-189', 17:09:34 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-189', 17:09:34 INFO - 'USERNAME': 'cltbld', 17:09:34 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-189', 17:09:34 INFO - 'WINDIR': 'C:\\windows', 17:09:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 17:09:34 INFO - Calling ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JteFUZqGQUaU_oH0lWLEpw/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-189', '--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 UNABLE to use job objects to manage child processes ProcessManager NOT managing child processes 17:09:35 INFO - mozversion application_buildid: 20161017153519 17:09:35 INFO - mozversion application_changeset: 56b3f2c6f53e72698fea6c25130efceef2a26548 17:09:35 INFO - mozversion application_display_name: Nightly 17:09:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:09:35 INFO - mozversion application_name: Firefox 17:09:35 INFO - mozversion application_remotingname: firefox 17:09:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:09:35 INFO - mozversion application_vendor: Mozilla 17:09:35 INFO - mozversion application_version: 52.0a1 17:09:35 INFO - mozversion platform_buildid: 20161017153519 17:09:35 INFO - mozversion platform_changeset: 56b3f2c6f53e72698fea6c25130efceef2a26548 17:09:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:09:35 INFO - mozversion platform_version: 52.0a1 17:09:35 INFO - using testdate: 1476749375 17:09:35 INFO - actual date: 1476749375 17:09:35 INFO - starting webserver on 'localhost:49275' 17:09:35 INFO - SUITE-START | Running 2 tests 17:09:35 INFO - TEST-START | dromaeo_css 17:09:35 INFO - operating with platform_type : w8_ 17:09:35 INFO - Initialising browser for dromaeo_css test... 17:09:35 INFO - TEST-INFO | started process 796 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpwj5jbs\profile http://localhost:49275/getInfo.html) 17:09:43 INFO - PROCESS | 796 | __metrics Screen width/height:1600/1200 17:09:43 INFO - PROCESS | 796 | colorDepth:24 17:09:43 INFO - PROCESS | 796 | Browser inner width/height: 1010/674 17:09:43 INFO - PROCESS | 796 | __metrics 17:09:45 INFO - PROCESS | 796 | 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" 17:09:45 INFO - PROCESS | 796 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:09:46 INFO - TEST-INFO | 796: exit 0 17:09:46 INFO - Browser initialized. 17:09:46 INFO - Running cycle 1/1 for dromaeo_css test... 17:09:46 INFO - TEST-INFO | started process 3244 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpwj5jbs\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:09:47 INFO - PROCESS | 3244 | [GFX1-]: Invalid size in UpdateRenderTarget Size(124,0), 0 17:09:58 INFO - PROCESS | 3244 | RSS: Main: 176607232 17:09:58 INFO - PROCESS | 3244 | 17:10:49 INFO - PROCESS | 3244 | 1476749449919 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] 17:13:00 INFO - PROCESS | 3244 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 17:13:02 INFO - PROCESS | 3244 | RSS: Main: 251252736 17:13:02 INFO - PROCESS | 3244 | 17:16:05 INFO - PROCESS | 3244 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 17:16:05 INFO - PROCESS | 3244 | RSS: Main: 234287104 17:16:05 INFO - PROCESS | 3244 | 17:19:08 INFO - PROCESS | 3244 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 17:19:08 INFO - PROCESS | 3244 | RSS: Main: 175857664 17:19:08 INFO - PROCESS | 3244 | 17:22:11 INFO - PROCESS | 3244 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 17:22:11 INFO - PROCESS | 3244 | RSS: Main: 170442752 17:22:11 INFO - PROCESS | 3244 | 17:25:14 INFO - PROCESS | 3244 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 17:25:15 INFO - PROCESS | 3244 | RSS: Main: 165294080 17:25:15 INFO - PROCESS | 3244 | 17:28:18 INFO - PROCESS | 3244 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 17:28:18 INFO - PROCESS | 3244 | RSS: Main: 261361664 17:28:18 INFO - PROCESS | 3244 | 17:28:18 INFO - PROCESS | 3244 | __start_tp_report 17:28:18 INFO - PROCESS | 3244 | _x_x_mozilla_page_load 17:28:18 INFO - PROCESS | 3244 | _x_x_mozilla_page_load_details 17:28:18 INFO - PROCESS | 3244 | |i|pagename|runs| 17:28:18 INFO - PROCESS | 3244 | |0;dojo.html;2607.3351295419666;2620.9475810483777;2644.3521337272364;2647.9338016549596;2658.7607115359615;4356.825726970921;4409.29451287794;4420.115976804644;4420.690551661385;4482.641388688905;4261.382099595557;4319.611234988851;4364.454443194601;4377.47470303564;4433.445819272591;3967.404889266604;3984.1234928315725;4005.218982298453;4006.6794656427414;4011.5587285398583;4031.818568164425;4034.0519977805193;4063.8577649782264;4074.348104303312;4140.855070072548;786.4917500831845;4035.2131334389805;4059.8579049733266;4118.526369467505;4126.917461650765;3835.5397352317623;4002.079521709994;4012.277789997799;4064.04494943688;4064.9390259146135;3897.688184945226;3934.3705007198996;3951.209758048402;3962.5443074046566;4011.7191796574252;4234.110836724291;4278.144371125787;4289.528151903288;4289.785510724451;4335;4463.129689710508;4519.322101684741;4548.636109111296;4582.152301824173;4591.219492686218;4607.907841843178;4615.169269531483;4619.237825758746;4626.1441633297945;4668.579827815479;4307.461567304087;4318.201132790444;4320.827166913288;4322.092360604277;4338.370936214263;4602.148602508547;4649.465311489154;4649.814007439732;4693.859184224479;4709.62323014158;4541.182587134282;4543.886402839889;4554.840580579664;4556.544345565417;4559.042601053749;4604.309353596987;4624.028953919647;4628.814847406066;4632;4633.4208223972;4480.932786008212;4579.931301030487;4587.632989360844;4589.747563883951;4590.563896429834;4489.6408287336935;4565;4568.74871882043;4571.245744452128;4575.679702420865;3120.828354440482;3139.780215384901;3178.8410579470933;3178.968210317867;3182.98408507956;2894.305366712016;2907.0697376839207;2924.2835505301337;2955.6896525864904;2960.748336391388;4252.064545799919;4257.425247591597;4260.339647354665;4310.7198032128435;4311.202427550913;4467.620252278528;4477;4499.0776890737325;4515.887102822456;4591.494935557086;4237.660987121023;4267.551907049778;4292.077203401222;4340.110277393127;4350.73895566267;3881.3789793633446;3912;3912.080661044652;3917.275304068756;3960.2475529649273;4545.13642407948;4591.150637132141;4606.378138951199;4644.8374306899095;4659.906801863944;4604.3323718061365;4612.285095810154;4615.123126605934;4619.214733495381;4625.444946606429;4605.746683932416;4623.237165867594;4630.166570017294;4631.235846085358;4668.883277918079;4594.264917613166;4599.379083823641;4599.4710608280475;4651.395318608559;4659.534046595313;4639.907201856012;4645.2103142465185;4649.697769644962;4691.9912218873105;4708.929366059443;4359.67302452311;4372.322290045048;4409.955900440955;4492.73043617371;4555.225611646094;4442.3558584004495;4445.888852778707;4448.844290449819;4453.487848897418;4453.821847126079;4389.846355377546;4391.429114215131;4397.868063958086;4401.40581021558;4415.933760993652;4555.817767289272;4561.2473941799235;4562.908741825211;4600.769961501978;4620.2607582786595;4487.192305385062;4499.190145773792;4501.2347900857585;4506.7070640408265;4556.863294101182 17:28:18 INFO - PROCESS | 3244 | |1;ext.html;565.8670212500062;567.9974844399635;576.8586696259417;579.7014537513179;585.1398444286897;25337.873310633444;34966.30067398651;35967.4604880927;37822.24355512888;38978.61021389785;35326.2934741305;35676.821615891946;35713.82143089287;35729.64270357296;35743.4638480423;7577.84844303115;7724;7741.496802707806;7743.7676869694;7770.106437759645;7052.435805135577;7223.711051557932;9194.448333100036;9435.103665151799;9473.668421605245;9602.183814375787;9607.4715890626;9695.078967498077;9702.369345992487;9705.75735606612;7076.540024898417;9202.079792020777;9257.583408746623;9271.16559509644;9310.674126405544;7047.859042819115;9408;9827.115559599599;9829.606815727362;9853.950730246375;33223.66776332254;33407;33552.496712549335;33602.495962560584;33614;2583.3799888026924;2596.64945232395;2686.153861533611;2752.5045491811466;2800.915972520828;25839.224823255143;26720.331991700365;26943.191704248708;26995.325116872038;27571.86214068917;3647.051766540692;3650.671439570451;3655.8354874030733;3682.650148235913;3747.775133491999;193046;193299;193588;193755;194371;43595.34606980898;43959.340609890874;44083.77958110189;44087.33868991968;44112;47463.762681186374;47506.28740568894;47514.524854751704;47742.761286193345;47853.521464785605;12845;13132.146410483288;13135.540256090992;13140;13145.21128732279;8885.4668719877;8978.371513993958;9990.250731195189;10063.295569310225;10071.597136114473;13329.600111996655;13589.592312230649;13844.169349839041;14138.929305353613;14286.142831430148;5337.759800808973;5390;5407.972960135174;5425.186222066643;5428.4028756836715;814.7637185216339;851.2466467176594;860.0238729042456;969.781799095212;1022.5500779656927;24396.390090247885;25679.358016049748;25886.093986710373;25962.480750384886;26039.869800650875;914.5763726125687;936.8266870628955;971.6647756523988;983.2036050798876;1014.9391036537831;13399.12905661129;13687.034992080004;13909.930450347683;14043.297835108204;14064.648383790487;284059;285045;285546;287098;288056;44228;44436.3334549982;44476.332855007204;44541.777291113984;44553.55446445559;1059.6979860739652;1088.1729885287239;1199.0886925936177;1202.9157958942965;1213.0901823632275;24708.629370559098;26717;26785.464290714466;26795.464090718466;27058.1882543524;37949.81025094857;38416;38451;38457;38474.0381490465;225192;226789;226884;228036;228166;23610.88194559016;24637.630435543124;24756.504869902863;24794.752052479966;29690.40619187561;36500.26999460049;37418.812905935294;38383.80808096053;38556.614433855306;38616;31245.375092498478;32033.519497208028;32354;32433.189170270933;33253.33493330071;31699.30555902682;32102.51846222262;32376.838115810213;32497.537610807096;32520.512192316663;32277.193070173435;32423;32503.349933001682;32515.34969300648;32522.34955300928;27231.59152612752;29026.27434314159;29258.853705731333;29437.411251774418;29444.263893402836;22824.201152959566;22858.164552561684;23114.884425577766;23187.3043808686;23193 17:28:18 INFO - PROCESS | 3244 | |2;jquery.html;325.55236549744103;336.67510852027794;338.461845665392;339.1639608365379;367.2673017330425;11944.462499187535;12923.483060677574;15003.774943375858;15076.683129711446;15625.687486250268;15233;15264.542063738105;15368.231588420591;15376.538703838904;15544.61138471536;4860.125177468046;5087;5109.4379618241965;5114.795408183668;5117.309163262949;3239.206394433367;3409.147713071732;4718.197906355927;4726.361941137937;4970;4950.480199579047;4973.751312434382;4998.525140111702;5039.521245481674;5048.258350868944;4972.5276098770555;5007.399112106534;5038.2190760432195;5039.244113383022;5042.294078828949;4727.905441891143;4851.02979404117;4857.684250523705;4858.878528036792;4860;10355.068043876086;10412.79174416515;10461.476926153662;10534;10641.255112142153;1757.3497805811803;1829.4652217766975;1862.5622978600154;1879.5583037986062;2426.1023421334044;7894.526328420313;8208.548529830858;11246.156538259664;11406.258593191416;11753.647390578211;1648.8351164883536;1695.7965044194652;1714.9828501714949;1727.4558514068028;1728.0495727350033;49992.750036249585;53421.46578534243;55163.724181379235;55292.723536382466;57810.42189578093;8180.590970451453;8221.465604735673;8428.410011299273;8488.957555212184;8566;11297.661070167907;11413.543458261742;11433.714157145972;11452.656420307405;11458.369789661649;6184.783532576338;6285.9057114143325;6316.968415157987;6343.460805831463;6399.136116624196;6114.847128821726;6126.6017708848785;6201.627902325875;6214.906776398358;6221.222347206599;3666.431703086026;3668.3396988541786;3671.706263498914;3719.5722491913234;3720.627937206312;1557.0657605436875;1577.3927038090417;1665.6841095534635;1717.6564687062637;1757.657256834905;829.2329595124486;861.5261606116611;903.2412773270485;960.2366118935463;963.6964356227766;14475.78286325706;15424.460143895134;15473.690526189414;15624.21878906073;15896.602584935468;829.5105887526388;830.1408042675802;833.3666413525764;852.2244757270978;856.6787454704486;5683.8863222736145;8607.784805379915;8756.992945811186;8863.739746364765;8990.145936136056;234755;248328;249398;280697;281900;60060.69969650124;62307;65226.34773652298;65358;68126.97809532861;837.6272558711315;845.8223773007737;870.1689886158704;875.5840975536696;877.5436772878068;14024.789628155382;14030.649233768829;14070.437182512995;14197.645058873197;14524.273786310854;26310.86844565765;27490.900363985216;30113.548296776004;30311.393772124877;30374;38501.6149838498;38930.80534597309;41519;41827;41859;6204.5967012144065;6394.488440924808;6501.674916254074;6513.283538810632;6679.666016699242;9114.498702571422;9853.753656158653;10014.899851001397;10018.599256029676;10151.390916545031;6649.335066493312;7173.677184526813;8549.401541892008;8839.116088391109;8893;8533.829323413622;8756.649734010569;8922.55387230623;8956.641734330553;9016.684416045407;8117.188281171835;8395.95802020986;8748.868766968373;8870.068642792414;9232.723018309462;6525.412712855866;6543.607383557001;6643.833904152241;6719.899201511884;7114.608696521741;6734.259231484631;7884.250996155585;8794.076621954602;9108.772280693036;9392.966773654756 17:28:18 INFO - PROCESS | 3244 | |3;mootools.html;1221.2062159596264;1254.6675131090262;1305.5586054078872;1570.8586227239546;1578.9921050394746;6432.388923052308;6799.932000679992;6894.276101009385;6904.067950826643;6905.792826215209;5822.679752613604;5991.490723288515;5994.520438364932;6110.266767987848;6698.765543205989;1653.7767401400838;1808.1230603157458;1859.4049904030649;1862.264405559803;1881.5766452548135;1885.4343696890946;1890.810918908112;1893.1670065171281;1893.2900162439084;1894.6684330242222;1817.109616288016;1906.094605062598;1909.3508207209545;1910.2931915191398;1911.0444777611194;1583.097634348422;1638.3200971596714;1850.2506484873647;1902.048975512244;1913.062599326334;1810.5383127302453;1813.6916724156792;1827.2873579304082;1830.4417152768401;1832.9450116496525;7029.051078104441;7077.044598979123;7079.823004424879;7081.5042946993735;7094.858102837966;3983.4821473208585;4116.0533077392065;4121.072758629314;4124.546299907008;4124.896877578085;2393.7247216570145;2412.7345991940874;2479.8964460814946;2481.1936120760824;2485.403503159247;819.5205804604254;837.6523742646795;853.4495250563414;862.1809281182839;862.9482231066094;9300.441973481613;9331.113544213222;9334.299927505464;9342.019087995799;9361.438313701132;3435.484677298425;3462.4806279058344;3635.472856435802;3638.799866007395;3640.5631324241263;8021.919780802117;8034.076081250731;8036.276735093869;8040.437169398086;8040.994875640545;4065.959340406558;4068.979655101765;4071.3485842265095;4071.7964101795383;4074.714769966074;3732.869349572806;3733.141377483194;3733.775973441602;3736.2527494500664;3738.0467980664757;2873.726995935383;2931.3697555025774;2987.7908546401545;2992.2968102495897;3098.5662007318992;955.3646824861389;986.4574484033752;1033.5504055735778;1035.6012935020071;1037.6368271105205;732.8021434212733;759.9050118735158;768.8116411479224;773.443120952913;788.6845261895288;4468.977655111704;4553.908921821545;4580.862574122782;4593;4622.815087396534;789.5894135049742;814.2061490047157;822.880682301063;834.3158609939912;841.2975165736678;2990.491616425213;3008.503596906486;3019.743321817626;3040.239940014996;3115.065480355884;7619.390448764086;7911;8014.19858014194;8021.438499305109;8564.914350856412;7043.471739619446;7314.414846812242;7880.842383152305;8017.478863873829;8071;6225.844353891099;6360.9045864312075;6386.744530218739;6389.648569328731;6394.360563943568;4461.464624245112;4552.795124219352;4575.862724118282;4616.261398176276;4665.743384113771;7648.120466146242;7723.266289702469;7734.149243583089;7735.845283094194;7847.058352997677;7613.276738709814;7708.576028318272;7813.960930195312;7820.726274580363;7870.9606451967375;5949;5979.581429300081;6043.758249669964;6046.969765151146;6052.334243233329;6617.371349721769;6688.632125232964;6717.395434410731;6720.193576770819;6731.057651928636;5967.880642387041;6054.061620448838;6109.327973922954;6244.063390491281;6327.462165715966;6064.4541991221;6126.050462178369;6168.105624684305;6236.812895613139;6251.9062214067735;5306.204069389622;5360.517553420211;5382.865428364322;5388.030154572215;5402.297701298806;3617.8733744318824;3636.5999740029106;3644.6355364463343;3701.4817925489915;3706.7952915302094;3735.5890852005714;3789.3558095123344;3795.791231482295;3811.5426148862316;3851.8459261629223 17:28:18 INFO - PROCESS | 3244 | |4;prototype.html;265.90028739222794;268.96503454550907;272.7749606574576;273.9739724726152;277.0552416260552;4591.219492686243;4612.723236605798;4617.707042028229;4619.445666520022;4641.814327426899;4537.47819000815;4543.182227199103;4557.703749256304;4574.336721175428;4578.908421831561;3387.407203739348;3474.444088945769;3482.1370566746796;3552.6447355264527;3559.3237284915913;3555.288942211568;3557.484164796103;3563.4832949222346;3576.9805605402466;3577.177249232678;3547.5388199534154;3552.378333791589;3557.7687450315775;3562.821858907057;3593.389123848952;3389.7288216942707;3457;3505.2113274513285;3515.6289047271584;3562.287542491499;3133.5926329577237;3151.795133316327;3155.2111972006996;3159.8150693489943;3166.350898065914;4475.418195634579;4494.865154045351;4510.503844577094;4516.593506584423;4523.886902827423;3917.1186483041374;4035.7982100894837;4068.6745060395097;4070.735402198877;4081.244969680589;4665.743384113873;4669.719816810968;4674.7428891410955;4677;4686.906261874743;3311.4867195584725;3333.1333853198103;3338.1487720631085;3339.682730140633;3364.2934983653463;4969.8012079516775;4979.30289759434;4980.452150263468;4984.800607975641;4995.225740010304;3392.1350055736125;3440.139965008748;3440.174358154025;3463.9480407793903;3467.4278744006956;3476.3221171871746;3478.41732011934;3481.47777833327;3504.5093686883856;3512.631173726773;4001.8799436016966;4023.275810354106;4025.5571887092397;4027.2549578328103;4044.4337792709043;4624.9768751156025;4653.371794807657;4680.063987202505;4717.443243729561;4719.858404247878;1207.8912897839061;1217.9160547113077;1224.650974472289;1227.92018518796;1229.5081967213007;768.9388643671697;782.1904329019437;798.4291231769313;799.1738876666789;802.2338666573525;4253.553376895381;4349.325854492558;4433.977830110894;4485.820567177341;4510.458744950627;4836.733979631154;4871.732054736953;4877.268409738496;4885.267209918469;4887.486813884562;4467.709598876063;4481.887952801206;4484.39460672805;4488.730676159441;4505.842295519707;2485.5774518331928;2534.681965377993;2554.106062877978;2587.48250349927;2591.6630837990942;4865.756712164378;4869.172240719086;4875.536824001714;4886.755662216946;4889.511048895082;4991.850244492671;4996.150654388763;4998.625103117281;4999.675021123688;5016.695659128653;4703.223968045303;4847.981923796042;4848.442429120696;4854.80580776765;4860.3195552621955;4866.343043689057;4879.4388645304825;4880.511948805233;4889.437714662859;4896.726851018832;4758.405199350082;4760.167700218364;4760.500147484464;4771.71369717818;4793.760311984456;4657.93013104797;4721.7403042832975;4807.6153907688;4837.419509658864;4844.224924012282;3447.207142357322;3453.6546345365264;3458;3469.462233353834;3477.860885564549;4850.83022094225;4879.878003049952;4886.29148773433;4887.094033326935;4920.188168952082;4574.4510658721165;4669.855885308121;4699.955519349094;4719.4100737407825;4735.242361222188;4682.367880336247;4682.869294470939;4690.882727931829;4699.154152252628;4712.81148754046;4617.607503362252;4629.421322334708;4638.1187574360765;4646.65150113736;4661.48723640406;4483.574060464251;4738.691985020962;4797.976010119927;4805.13507568641;4836.322914792002;4650.535216335347;4714.349977507844;4730.526947305242;4757.26262429324;4762.190427627381 17:28:18 INFO - PROCESS | 3244 | |5;yui.html;568.3378863623877;619.674670797831;648.7405037984805;675.7634827810264;703.3037293079851;12446.81329780054;12828.935855320711;13544.796828047574;13559.661008474768;13564.796528052088;12355.876441235585;12580.68548286291;12591.307478088724;12604.243745375285;12611.369431528432;753.7701001194647;773.2344978471301;778.1362687416963;780.9570473623949;782.6165179062275;603.4629180029777;620.5128973755603;739.2422766664185;755.3654929858917;763.812865847868;800.3277247112425;806.3911746631285;806.657170702452;807.1807115777491;816.2531283875277;787.7557957033338;789.5223389849174;791.1890312429806;791.8020494876281;791.9960400197991;486.761486871434;488.6994498383504;580.9564282678774;587.4301927130676;592.5467017731439;12645.178063425848;12672;12674.429650665743;12684.30236337001;12707.237565746085;10768.78462430755;10954.123670106372;11201.327920324806;11222.438878056146;11684.12369072323;10904.78190436187;10975;11133.665990020312;11204.439778011149;11328.26366286197;3892.824822882949;3918.804059796999;3992.1017771001584;3998.0604557928864;4058.391241313797;51030.74484627553;51439.48560514385;52227;54322.91354172934;54740.726296368266;9407.576659050359;9421;9427.575759090858;9437.858432123523;9759.463229522444;15936.681266374608;17787.911060444614;17846.643067138586;17870.19584118718;17893.7315940261;6586.604803711697;6712.563683360566;6763.695633696496;6939;6976.232614412411;3580.462930560385;3583.6595523425235;3676.7242456815848;3685.8894233173046;3775.377884244143;2545.3127655532903;2682.1819345099543;2684.2484104450787;2689.045388886956;2689.852058136782;434.53287715705744;439.7207773064063;440.4626355845863;440.88757366871243;463.96056335211887;401.8332392057322;490.28173725492326;490.9803607855646;548.0901703172793;564.4440226377016;7392.519486233486;7440.962795185989;7507.099148102263;7662.540247585162;7771.805704857424;515.7163560041962;562.9746661400247;569.313976658126;575.2550447170923;583.6479483139619;3271.1495011297234;3512.4028915084496;3537.752357335013;3632.3098611263777;3637.1452708613456;64158.679206603665;82264;87902.92339768077;87907;88071.11928880757;53811;68702;69217.3078269221;73165.6341718288;73165.6341718288;65165;65298.67350663311;65432;66233.66883165554;67164;6878.243393226641;6906;7008.334208250208;7060.682269297791;7148.678309475982;36389.27221455609;37524.62475375211;37810.43284350792;38040.23919521649;38319.6168038316;52608.73695631498;54066.88996650377;55050.724746376014;55568.44431555633;55706.442935571744;9736.46449445259;9743.415395076318;10029.648962286285;10095.67799406126;10442.321249118782;10683.786324273626;10685;10829;10944.1791865612;11203.60787372438;9467;9553.990492994684;9761.804763904824;9882.11061004513;9969.40183588987;8823.69117080899;10534.841977370192;10600.204984626029;10638.627648032281;10885.644599649375;10543.683689489328;10690.73273168177;10763.51564179598;10912.181586380895;11130.387828669502;8544.18830211129;8717.433366831136;8769.166929141722;8858.379913406;9055.139761722889;8940.240079593308;9001.819963600823;9038.3673142882;9080;9162.496062716615 17:28:18 INFO - PROCESS | 3244 | __end_tp_report 17:28:18 INFO - PROCESS | 3244 | __start_cc_report 17:28:18 INFO - PROCESS | 3244 | _x_x_mozilla_cycle_collect,1264 17:28:18 INFO - PROCESS | 3244 | __end_cc_report 17:28:18 INFO - PROCESS | 3244 | __startTimestamp1476750498584__endTimestamp 17:28:18 INFO - PROCESS | 3244 | 17:28:18 INFO - PROCESS | 3244 | ------- Summary: start ------- 17:28:18 INFO - PROCESS | 3244 | Number of tests: 6 17:28:18 INFO - PROCESS | 3244 | 17:28:18 INFO - PROCESS | 3244 | [#0] dojo.html Cycles:165 Average:4248.05 Median:4445.89 stddev:560.21 (12.6%) stddev-sans-first:546.94 17:28:18 INFO - PROCESS | 3244 | Values: 2607.3 2620.9 2644.4 2647.9 2658.8 4356.8 4409.3 4420.1 4420.7 4482.6 4261.4 4319.6 4364.5 4377.5 4433.4 3967.4 3984.1 4005.2 4006.7 4011.6 4031.8 4034.1 4063.9 4074.3 4140.9 786.5 4035.2 4059.9 4118.5 4126.9 3835.5 4002.1 4012.3 4064.0 4064.9 3897.7 3934.4 3951.2 3962.5 4011.7 4234.1 4278.1 4289.5 4289.8 4335.0 4463.1 4519.3 4548.6 4582.2 4591.2 4607.9 4615.2 4619.2 4626.1 4668.6 4307.5 4318.2 4320.8 4322.1 4338.4 4602.1 4649.5 4649.8 4693.9 4709.6 4541.2 4543.9 4554.8 4556.5 4559.0 4604.3 4624.0 4628.8 4632.0 4633.4 4480.9 4579.9 4587.6 4589.7 4590.6 4489.6 4565.0 4568.7 4571.2 4575.7 3120.8 3139.8 3178.8 3179.0 3183.0 2894.3 2907.1 2924.3 2955.7 2960.7 4252.1 4257.4 4260.3 4310.7 4311.2 4467.6 4477.0 4499.1 4515.9 4591.5 4237.7 4267.6 4292.1 4340.1 4350.7 3881.4 3912.0 3912.1 3917.3 3960.2 4545.1 4591.2 4606.4 4644.8 4659.9 4604.3 4612.3 4615.1 4619.2 4625.4 4605.7 4623.2 4630.2 4631.2 4668.9 4594.3 4599.4 4599.5 4651.4 4659.5 4639.9 4645.2 4649.7 4692.0 4708.9 4359.7 4372.3 4410.0 4492.7 4555.2 4442.4 4445.9 4448.8 4453.5 4453.8 4389.8 4391.4 4397.9 4401.4 4415.9 4555.8 4561.2 4562.9 4600.8 4620.3 4487.2 4499.2 4501.2 4506.7 4556.9 17:28:18 INFO - PROCESS | 3244 | 17:28:18 INFO - PROCESS | 3244 | [#1] ext.html Cycles:180 Average:38481.54 Median:33330.17 stddev:62199.12 (186.6%) stddev-sans-first:62308.45 17:28:18 INFO - PROCESS | 3244 | Values: 565.9 568.0 576.9 579.7 585.1 25337.9 34966.3 35967.5 37822.2 38978.6 35326.3 35676.8 35713.8 35729.6 35743.5 7577.8 7724.0 7741.5 7743.8 7770.1 7052.4 7223.7 9194.4 9435.1 9473.7 9602.2 9607.5 9695.1 9702.4 9705.8 7076.5 9202.1 9257.6 9271.2 9310.7 7047.9 9408.0 9827.1 9829.6 9854.0 33223.7 33407.0 33552.5 33602.5 33614.0 2583.4 2596.6 2686.2 2752.5 2800.9 25839.2 26720.3 26943.2 26995.3 27571.9 3647.1 3650.7 3655.8 3682.7 3747.8 193046.0 193299.0 193588.0 193755.0 194371.0 43595.3 43959.3 44083.8 44087.3 44112.0 47463.8 47506.3 47514.5 47742.8 47853.5 12845.0 13132.1 13135.5 13140.0 13145.2 8885.5 8978.4 9990.3 10063.3 10071.6 13329.6 13589.6 13844.2 14138.9 14286.1 5337.8 5390.0 5408.0 5425.2 5428.4 814.8 851.2 860.0 969.8 1022.6 24396.4 25679.4 25886.1 25962.5 26039.9 914.6 936.8 971.7 983.2 1014.9 13399.1 13687.0 13909.9 14043.3 14064.6 284059.0 285045.0 285546.0 287098.0 288056.0 44228.0 44436.3 44476.3 44541.8 44553.6 1059.7 1088.2 1199.1 1202.9 1213.1 24708.6 26717.0 26785.5 26795.5 27058.2 37949.8 38416.0 38451.0 38457.0 38474.0 225192.0 226789.0 226884.0 228036.0 228166.0 23610.9 24637.6 24756.5 24794.8 29690.4 36500.3 37418.8 38383.8 38556.6 38616.0 31245.4 32033.5 32354.0 32433.2 33253.3 31699.3 32102.5 32376.8 32497.5 32520.5 32277.2 32423.0 32503.3 32515.3 32522.3 27231.6 29026.3 29258.9 29437.4 29444.3 22824.2 22858.2 23114.9 23187.3 23193.0 17:28:18 INFO - PROCESS | 3244 | 17:28:18 INFO - PROCESS | 3244 | [#2] jquery.html Cycles:180 Average:18334.75 Median:27495.64 stddev:43251.93 (157.3%) stddev-sans-first:43352.13 17:28:18 INFO - PROCESS | 3244 | Values: 325.6 336.7 338.5 339.2 367.3 11944.5 12923.5 15003.8 15076.7 15625.7 15233.0 15264.5 15368.2 15376.5 15544.6 4860.1 5087.0 5109.4 5114.8 5117.3 3239.2 3409.1 4718.2 4726.4 4970.0 4950.5 4973.8 4998.5 5039.5 5048.3 4972.5 5007.4 5038.2 5039.2 5042.3 4727.9 4851.0 4857.7 4858.9 4860.0 10355.1 10412.8 10461.5 10534.0 10641.3 1757.3 1829.5 1862.6 1879.6 2426.1 7894.5 8208.5 11246.2 11406.3 11753.6 1648.8 1695.8 1715.0 1727.5 1728.0 49992.8 53421.5 55163.7 55292.7 57810.4 8180.6 8221.5 8428.4 8489.0 8566.0 11297.7 11413.5 11433.7 11452.7 11458.4 6184.8 6285.9 6317.0 6343.5 6399.1 6114.8 6126.6 6201.6 6214.9 6221.2 3666.4 3668.3 3671.7 3719.6 3720.6 1557.1 1577.4 1665.7 1717.7 1757.7 829.2 861.5 903.2 960.2 963.7 14475.8 15424.5 15473.7 15624.2 15896.6 829.5 830.1 833.4 852.2 856.7 5683.9 8607.8 8757.0 8863.7 8990.1 234755.0 248328.0 249398.0 280697.0 281900.0 60060.7 62307.0 65226.3 65358.0 68127.0 837.6 845.8 870.2 875.6 877.5 14024.8 14030.6 14070.4 14197.6 14524.3 26310.9 27490.9 30113.5 30311.4 30374.0 38501.6 38930.8 41519.0 41827.0 41859.0 6204.6 6394.5 6501.7 6513.3 6679.7 9114.5 9853.8 10014.9 10018.6 10151.4 6649.3 7173.7 8549.4 8839.1 8893.0 8533.8 8756.6 8922.6 8956.6 9016.7 8117.2 8396.0 8748.9 8870.1 9232.7 6525.4 6543.6 6643.8 6719.9 7114.6 6734.3 7884.3 8794.1 9108.8 9393.0 17:28:18 INFO - PROCESS | 3244 | 17:28:18 INFO - PROCESS | 3244 | [#3] mootools.html Cycles:180 Average:4439.73 Median:5385.45 stddev:2484.10 (46.1%) stddev-sans-first:2479.30 17:28:18 INFO - PROCESS | 3244 | Values: 1221.2 1254.7 1305.6 1570.9 1579.0 6432.4 6799.9 6894.3 6904.1 6905.8 5822.7 5991.5 5994.5 6110.3 6698.8 1653.8 1808.1 1859.4 1862.3 1881.6 1885.4 1890.8 1893.2 1893.3 1894.7 1817.1 1906.1 1909.4 1910.3 1911.0 1583.1 1638.3 1850.3 1902.0 1913.1 1810.5 1813.7 1827.3 1830.4 1832.9 7029.1 7077.0 7079.8 7081.5 7094.9 3983.5 4116.1 4121.1 4124.5 4124.9 2393.7 2412.7 2479.9 2481.2 2485.4 819.5 837.7 853.4 862.2 862.9 9300.4 9331.1 9334.3 9342.0 9361.4 3435.5 3462.5 3635.5 3638.8 3640.6 8021.9 8034.1 8036.3 8040.4 8041.0 4066.0 4069.0 4071.3 4071.8 4074.7 3732.9 3733.1 3733.8 3736.3 3738.0 2873.7 2931.4 2987.8 2992.3 3098.6 955.4 986.5 1033.6 1035.6 1037.6 732.8 759.9 768.8 773.4 788.7 4469.0 4553.9 4580.9 4593.0 4622.8 789.6 814.2 822.9 834.3 841.3 2990.5 3008.5 3019.7 3040.2 3115.1 7619.4 7911.0 8014.2 8021.4 8564.9 7043.5 7314.4 7880.8 8017.5 8071.0 6225.8 6360.9 6386.7 6389.6 6394.4 4461.5 4552.8 4575.9 4616.3 4665.7 7648.1 7723.3 7734.1 7735.8 7847.1 7613.3 7708.6 7814.0 7820.7 7871.0 5949.0 5979.6 6043.8 6047.0 6052.3 6617.4 6688.6 6717.4 6720.2 6731.1 5967.9 6054.1 6109.3 6244.1 6327.5 6064.5 6126.1 6168.1 6236.8 6251.9 5306.2 5360.5 5382.9 5388.0 5402.3 3617.9 3636.6 3644.6 3701.5 3706.8 3735.6 3789.4 3795.8 3811.5 3851.8 17:28:18 INFO - PROCESS | 3244 | 17:28:18 INFO - PROCESS | 3244 | [#4] prototype.html Cycles:180 Average:3976.12 Median:4576.68 stddev:1164.91 (25.5%) stddev-sans-first:1134.40 17:28:18 INFO - PROCESS | 3244 | Values: 265.9 269.0 272.8 274.0 277.1 4591.2 4612.7 4617.7 4619.4 4641.8 4537.5 4543.2 4557.7 4574.3 4578.9 3387.4 3474.4 3482.1 3552.6 3559.3 3555.3 3557.5 3563.5 3577.0 3577.2 3547.5 3552.4 3557.8 3562.8 3593.4 3389.7 3457.0 3505.2 3515.6 3562.3 3133.6 3151.8 3155.2 3159.8 3166.4 4475.4 4494.9 4510.5 4516.6 4523.9 3917.1 4035.8 4068.7 4070.7 4081.2 4665.7 4669.7 4674.7 4677.0 4686.9 3311.5 3333.1 3338.1 3339.7 3364.3 4969.8 4979.3 4980.5 4984.8 4995.2 3392.1 3440.1 3440.2 3463.9 3467.4 3476.3 3478.4 3481.5 3504.5 3512.6 4001.9 4023.3 4025.6 4027.3 4044.4 4625.0 4653.4 4680.1 4717.4 4719.9 1207.9 1217.9 1224.7 1227.9 1229.5 768.9 782.2 798.4 799.2 802.2 4253.6 4349.3 4434.0 4485.8 4510.5 4836.7 4871.7 4877.3 4885.3 4887.5 4467.7 4481.9 4484.4 4488.7 4505.8 2485.6 2534.7 2554.1 2587.5 2591.7 4865.8 4869.2 4875.5 4886.8 4889.5 4991.9 4996.2 4998.6 4999.7 5016.7 4703.2 4848.0 4848.4 4854.8 4860.3 4866.3 4879.4 4880.5 4889.4 4896.7 4758.4 4760.2 4760.5 4771.7 4793.8 4657.9 4721.7 4807.6 4837.4 4844.2 3447.2 3453.7 3458.0 3469.5 3477.9 4850.8 4879.9 4886.3 4887.1 4920.2 4574.5 4669.9 4700.0 4719.4 4735.2 4682.4 4682.9 4690.9 4699.2 4712.8 4617.6 4629.4 4638.1 4646.7 4661.5 4483.6 4738.7 4798.0 4805.1 4836.3 4650.5 4714.3 4730.5 4757.3 4762.2 17:28:18 INFO - PROCESS | 3244 | 17:28:18 INFO - PROCESS | 3244 | [#5] yui.html Cycles:180 Average:15517.07 Median:27644.41 stddev:21358.36 (77.3%) stddev-sans-first:21388.78 17:28:18 INFO - PROCESS | 3244 | Values: 568.3 619.7 648.7 675.8 703.3 12446.8 12828.9 13544.8 13559.7 13564.8 12355.9 12580.7 12591.3 12604.2 12611.4 753.8 773.2 778.1 781.0 782.6 603.5 620.5 739.2 755.4 763.8 800.3 806.4 806.7 807.2 816.3 787.8 789.5 791.2 791.8 792.0 486.8 488.7 581.0 587.4 592.5 12645.2 12672.0 12674.4 12684.3 12707.2 10768.8 10954.1 11201.3 11222.4 11684.1 10904.8 10975.0 11133.7 11204.4 11328.3 3892.8 3918.8 3992.1 3998.1 4058.4 51030.7 51439.5 52227.0 54322.9 54740.7 9407.6 9421.0 9427.6 9437.9 9759.5 15936.7 17787.9 17846.6 17870.2 17893.7 6586.6 6712.6 6763.7 6939.0 6976.2 3580.5 3583.7 3676.7 3685.9 3775.4 2545.3 2682.2 2684.2 2689.0 2689.9 434.5 439.7 440.5 440.9 464.0 401.8 490.3 491.0 548.1 564.4 7392.5 7441.0 7507.1 7662.5 7771.8 515.7 563.0 569.3 575.3 583.6 3271.1 3512.4 3537.8 3632.3 3637.1 64158.7 82264.0 87902.9 87907.0 88071.1 53811.0 68702.0 69217.3 73165.6 73165.6 65165.0 65298.7 65432.0 66233.7 67164.0 6878.2 6906.0 7008.3 7060.7 7148.7 36389.3 37524.6 37810.4 38040.2 38319.6 52608.7 54066.9 55050.7 55568.4 55706.4 9736.5 9743.4 10029.6 10095.7 10442.3 10683.8 10685.0 10829.0 10944.2 11203.6 9467.0 9554.0 9761.8 9882.1 9969.4 8823.7 10534.8 10600.2 10638.6 10885.6 10543.7 10690.7 10763.5 10912.2 11130.4 8544.2 8717.4 8769.2 8858.4 9055.1 8940.2 9001.8 9038.4 9080.0 9162.5 17:28:18 INFO - PROCESS | 3244 | -------- Summary: end -------- 17:28:18 INFO - PROCESS | 3244 | 17:28:19 INFO - TEST-INFO | 3244: exit 0 17:28:20 INFO - TEST-OK | dromaeo_css | took 1124571ms 17:28:20 INFO - TEST-START | kraken 17:28:20 INFO - operating with platform_type : w8_ 17:28:20 INFO - Initialising browser for kraken test... 17:28:20 INFO - TEST-INFO | started process 1576 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmp5otlgr\profile http://localhost:49275/getInfo.html) 17:28:25 INFO - PROCESS | 1576 | __metrics Screen width/height:1600/1200 17:28:25 INFO - PROCESS | 1576 | colorDepth:24 17:28:25 INFO - PROCESS | 1576 | Browser inner width/height: 1010/674 17:28:25 INFO - PROCESS | 1576 | __metrics 17:28:26 INFO - PROCESS | 1576 | 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" 17:28:26 INFO - PROCESS | 1576 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:28:27 INFO - PROCESS | 1576 | console.error: 17:28:27 INFO - PROCESS | 1576 | Message: Error: Connection closed before committing the transaction. 17:28:27 INFO - PROCESS | 1576 | Stack: 17:28:27 INFO - PROCESS | 1576 | ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:937:23 17:28:27 INFO - PROCESS | 1576 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7 17:28:27 INFO - PROCESS | 1576 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11 17:28:27 INFO - PROCESS | 1576 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7 17:28:27 INFO - PROCESS | 1576 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:714:7 17:28:27 INFO - PROCESS | 1576 | TaskImpl_run@resource://gre/modules/Task.jsm:327:15 17:28:27 INFO - PROCESS | 1576 | Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:551:9 17:28:27 INFO - PROCESS | 1576 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15 17:28:27 INFO - PROCESS | 1576 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:388:5 17:28:27 INFO - PROCESS | 1576 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29 17:28:27 INFO - PROCESS | 1576 | Barrier/this.client.addBlocker/promise13.4% 17:29:26 INFO - TinderboxPrint: I/O read bytes / time
252,784,128 / 2,022,090 17:29:26 INFO - TinderboxPrint: I/O write bytes / time
414,734,336 / 3,363,030 17:29:26 INFO - TinderboxPrint: CPU idle
8,291.0 (86.6%) 17:29:26 INFO - TinderboxPrint: CPU user
1,230.8 (12.9%) 17:29:26 INFO - install - Wall time: 3s; CPU: 11.0%; Read bytes: 0; Write bytes: 35069440; Read time: 0; Write time: 60250 17:29:27 INFO - run-tests - Wall time: 1194s; CPU: 13.0%; Read bytes: 252784128; Write bytes: 320359424; Read time: 2022090; Write time: 3230520 17:29:27 INFO - Running post-run listener: _upload_blobber_files 17:29:27 INFO - Blob upload gear active. 17:29:27 INFO - Preparing to upload files from C:\slave\test\build\blobber_upload_dir. 17:29:27 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 17:29:27 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\venv\\Scripts\\blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', 'C:\\slave\\test\\oauth.txt', '-b', 'Firefox-Non-PGO', '-d', 'C:\\slave\\test\\build\\blobber_upload_dir', '--output-manifest', 'C:\\slave\\test\\build\\uploaded_files.json'] 17:29:27 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\venv\Scripts\blobberc.py -u https://blobupload.elasticbeanstalk.com -a C:\slave\test\oauth.txt -b Firefox-Non-PGO -d C:\slave\test\build\blobber_upload_dir --output-manifest C:\slave\test\build\uploaded_files.json 17:29:28 INFO - (blobuploader) - INFO - Open directory for files ... 17:29:28 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_errorsummary.log ... 17:29:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:29:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:29:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:29:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:29:28 INFO - (blobuploader) - INFO - Done attempting. 17:29:28 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_raw.log ... 17:29:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:29:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:29:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:29:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:29:29 INFO - (blobuploader) - INFO - Done attempting. 17:29:29 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\resource-usage.json ... 17:29:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:29:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:29:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:29:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:29:32 INFO - (blobuploader) - INFO - Done attempting. 17:29:32 INFO - (blobuploader) - INFO - Iteration through files over. 17:29:32 INFO - Return code: 0 17:29:32 INFO - rmtree: C:\slave\test\build\uploaded_files.json 17:29:32 INFO - Using _rmtree_windows ... 17:29:32 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build\\uploaded_files.json',), kwargs: {}, attempt #1 17:29:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/041df102980438f0bfeb6290aadad1eef102174b7043647c8ca14a1dafd756e5b3eb5a82c10a5a802cbdcb6b93b075e525d46e9b2533ee0c2f4b72125316ea6c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0552a3f5ab4d1e1e1c16127781167321206aae73a07e420ad8ff9882cb1b82a053bb7ad7a9a5f13e476494ae29f295978fdd816d109eb22571fe95c052a7774b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3a025107a3dfd7fec08367c6c34c8d516058ce562491126a917a09d2ef772f43f4de73e5b2d847653e094878c218c24baea38da6e7a8aae74dfcb66a2ce221f8"} 17:29:32 INFO - Writing buildbot properties ['blobber_files'] to C:\slave\test\properties\blobber_files 17:29:32 INFO - Writing to file C:\slave\test\properties\blobber_files 17:29:32 INFO - Contents: 17:29:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/041df102980438f0bfeb6290aadad1eef102174b7043647c8ca14a1dafd756e5b3eb5a82c10a5a802cbdcb6b93b075e525d46e9b2533ee0c2f4b72125316ea6c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0552a3f5ab4d1e1e1c16127781167321206aae73a07e420ad8ff9882cb1b82a053bb7ad7a9a5f13e476494ae29f295978fdd816d109eb22571fe95c052a7774b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3a025107a3dfd7fec08367c6c34c8d516058ce562491126a917a09d2ef772f43f4de73e5b2d847653e094878c218c24baea38da6e7a8aae74dfcb66a2ce221f8"} 17:29:32 INFO - Running post-run listener: copy_logs_to_upload_dir 17:29:32 INFO - Copying logs to upload dir... 17:29:32 INFO - mkdir: C:\slave\test\build\upload\logs 17:29:32 INFO - Copying logs to upload dir... 17:29:32 INFO - Using _rmtree_windows ... 17:29:32 INFO - Using _rmtree_windows ... 17:29:32 INFO - Using _rmtree_windows ... 17:29:32 INFO - Using _rmtree_windows ... 17:29:32 INFO - Using _rmtree_windows ... 17:29:32 INFO - Using _rmtree_windows ... 17:29:32 INFO - Using _rmtree_windows ... program finished with exit code 0 elapsedTime=1405.793000 ========= master_lag: 0.05 ========= ========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 25 secs) (at 2016-10-17 17:29:32.912314) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 17:29:32.913230) ========= '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-189\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-189 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-189 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-189\AppData\Local LOGONSERVER=\\T-W864-IX-189 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-189 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-189 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-189 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/041df102980438f0bfeb6290aadad1eef102174b7043647c8ca14a1dafd756e5b3eb5a82c10a5a802cbdcb6b93b075e525d46e9b2533ee0c2f4b72125316ea6c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0552a3f5ab4d1e1e1c16127781167321206aae73a07e420ad8ff9882cb1b82a053bb7ad7a9a5f13e476494ae29f295978fdd816d109eb22571fe95c052a7774b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3a025107a3dfd7fec08367c6c34c8d516058ce562491126a917a09d2ef772f43f4de73e5b2d847653e094878c218c24baea38da6e7a8aae74dfcb66a2ce221f8"} build_url:https://queue.taskcluster.net/v1/task/JteFUZqGQUaU_oH0lWLEpw/artifacts/public/build/firefox-52.0a1.en-US.win64.zip program finished with exit code 0 elapsedTime=0.101000 build_url: 'https://queue.taskcluster.net/v1/task/JteFUZqGQUaU_oH0lWLEpw/artifacts/public/build/firefox-52.0a1.en-US.win64.zip' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/041df102980438f0bfeb6290aadad1eef102174b7043647c8ca14a1dafd756e5b3eb5a82c10a5a802cbdcb6b93b075e525d46e9b2533ee0c2f4b72125316ea6c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0552a3f5ab4d1e1e1c16127781167321206aae73a07e420ad8ff9882cb1b82a053bb7ad7a9a5f13e476494ae29f295978fdd816d109eb22571fe95c052a7774b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3a025107a3dfd7fec08367c6c34c8d516058ce562491126a917a09d2ef772f43f4de73e5b2d847653e094878c218c24baea38da6e7a8aae74dfcb66a2ce221f8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 17:29:33.036285) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 17:29:33.036663) ========= '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-189\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-189 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-189 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-189\AppData\Local LOGONSERVER=\\T-W864-IX-189 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-189 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-189 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-189 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 17:29:33.155391) ========= ========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-10-17 17:29:33.155735) ========= ========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-10-17 17:29:33.656646) ========= ========= Total master_lag: 7.68 =========