builder: fx-team_win8_64_test-dromaeojs-pgo slave: t-w864-ix-177 starttime: 1477265187.43 results: success (0) buildid: 20161023123006 builduid: e56cd4dbefe34d1d82ee5740e6d07fee revision: a9a41b69f3f9be494ae0653601c08aa388d9afe4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-23 16:26:27.430622) ========= master: http://buildbot-master110.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-23 16:26:27.431100) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-23 16:26:27.431392) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-23 16:26:27.614886) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-23 16:26:27.615300) ========= '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-177\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-177 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-177 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-177\AppData\Local LOGONSERVER=\\T-W864-IX-177 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-177 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-177 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-177 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False --16:26:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py => `archiver_client.py' Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. WARNING: Certificate verification error for hg.mozilla.org: certificate signature failure HTTP request sent, awaiting response... 200 Script output follows Length: 12,179 (12K) [text/x-python] 0K .......... . 100% 8.59 MB/s 16:26:30 (8.59 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=2.080000 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-23 16:26:29.761738) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-10-23 16:26:29.762086) ========= '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-177\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-177 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-177 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-177\AppData\Local LOGONSERVER=\\T-W864-IX-177 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-177 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-177 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-177 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=2.709000 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-10-23 16:26:32.491739) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-23 16:26:32.492124) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo integration/fx-team --rev a9a41b69f3f9be494ae0653601c08aa388d9afe4 --destination scripts --debug' in dir C:\slave\test\. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev a9a41b69f3f9be494ae0653601c08aa388d9afe4 --destination scripts --debug'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-177\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-177 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-177 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-177\AppData\Local LOGONSERVER=\\T-W864-IX-177 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-177 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-177 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-177 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 2016-10-23 16:26:33,565 truncating revision to first 12 chars 2016-10-23 16:26:33,565 Setting DEBUG logging. 2016-10-23 16:26:33,565 attempt 1/10 2016-10-23 16:26:33,565 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a9a41b69f3f9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-23 16:26:34,476 unpacking tar archive at: fx-team-a9a41b69f3f9/testing/mozharness/ 2016-10-23 16:26:34,586 skipping symlink on windows: configs/single_locale/linux32.py program finished with exit code 0 elapsedTime=1.831000 ========= master_lag: 0.17 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-23 16:26:34.491995) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-23 16:26:34.492371) ========= script_repo_revision: a9a41b69f3f9be494ae0653601c08aa388d9afe4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-23 16:26:34.492772) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-23 16:26:34.493064) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-23 16:26:34.511745) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 7 secs) (at 2016-10-23 16:26:34.512376) ========= 'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'dromaeojs' '--add-option' '--webServer,localhost' '--branch-name' 'Fx-Team' '--cfg' 'talos/windows_config.py' '--download-symbols' 'ondemand' '--use-talos-json' '--blob-upload-branch' 'Fx-Team' 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', 'Fx-Team', '--cfg', 'talos/windows_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-177\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-177 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-177 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-177\AppData\Local LOGONSERVER=\\T-W864-IX-177 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-177 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-177 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-177 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 16:26:35 INFO - MultiFileLogger online at 20161023 16:26:35 in C:\slave\test 16:26:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 16:26:35 INFO - Dumping config to C:\slave\test\logs\localconfig.json. 16:26:35 INFO - {'append_to_log': False, 16:26:35 INFO - 'base_work_dir': 'C:\\slave\\test', 16:26:35 INFO - 'blob_upload_branch': 'Fx-Team', 16:26:35 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt', 16:26:35 INFO - 'branch': 'Fx-Team', 16:26:35 INFO - 'buildbot_json_path': 'buildprops.json', 16:26:35 INFO - 'config_files': ('talos/windows_config.py',), 16:26:35 INFO - 'default_actions': ('clobber', 16:26:35 INFO - 'read-buildbot-config', 16:26:35 INFO - 'download-and-extract', 16:26:35 INFO - 'populate-webroot', 16:26:35 INFO - 'create-virtualenv', 16:26:35 INFO - 'install', 16:26:35 INFO - 'run-tests'), 16:26:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:26:35 INFO - 'download_minidump_stackwalk': True, 16:26:35 INFO - 'download_symbols': 'ondemand', 16:26:35 INFO - 'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python', 16:26:35 INFO - 'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'), 16:26:35 INFO - 'hg': 'c:/mozilla-build/hg/hg', 16:26:35 INFO - 'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python', 16:26:35 INFO - 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'), 16:26:35 INFO - 'python': 'c:/mozilla-build/python27/python.exe', 16:26:35 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe', 16:26:35 INFO - 'C:/mozilla-build/tooltool.py'), 16:26:35 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe', 16:26:35 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 16:26:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:26:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:26:35 INFO - 'installer_path': 'installer.exe', 16:26:35 INFO - 'log_level': 'info', 16:26:35 INFO - 'log_name': 'talos', 16:26:35 INFO - 'log_to_console': True, 16:26:35 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe', 16:26:35 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe', 16:26:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest', 16:26:35 INFO - 'opt_config_files': (), 16:26:35 INFO - 'pip_index': False, 16:26:35 INFO - 'sps_profile': False, 16:26:35 INFO - 'sps_profile_interval': 0, 16:26:35 INFO - 'suite': 'dromaeojs', 16:26:35 INFO - 'system_bits': '32', 16:26:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:26:35 INFO - 'title': 'T-W864-IX-177', 16:26:35 INFO - 'use_talos_json': True, 16:26:35 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'), 16:26:35 INFO - 'virtualenv_path': 'C:\\slave\\test\\build/venv', 16:26:35 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll', 16:26:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:26:35 INFO - 'work_dir': 'build'} 16:26:35 INFO - [mozharness: 2016-10-23 23:26:35.390000Z] Running clobber step. 16:26:35 INFO - Running pre-action listener: _resource_record_pre_action 16:26:35 INFO - Running main action method: clobber 16:26:35 INFO - rmtree: C:\slave\test\build 16:26:35 INFO - Using _rmtree_windows ... 16:26:35 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1 16:28:12 INFO - Running post-action listener: _resource_record_post_action 16:28:12 INFO - [mozharness: 2016-10-23 23:28:12.900000Z] Finished clobber step (success) 16:28:12 INFO - [mozharness: 2016-10-23 23:28:12.900000Z] Running read-buildbot-config step. 16:28:12 INFO - Running pre-action listener: _resource_record_pre_action 16:28:12 INFO - Running main action method: read_buildbot_config 16:28:12 INFO - Using buildbot properties: 16:28:12 INFO - { 16:28:12 INFO - "project": "", 16:28:12 INFO - "product": "firefox", 16:28:12 INFO - "script_repo_revision": "production", 16:28:12 INFO - "builddir": "fx-team_win8_64_test-dromaeojs", 16:28:12 INFO - "repository": "", 16:28:12 INFO - "buildername": "Windows 8 64-bit fx-team pgo talos dromaeojs", 16:28:12 INFO - "buildid": "20161023123006", 16:28:12 INFO - "pgo_build": "True", 16:28:12 INFO - "basedir": "C:\\slave\\test", 16:28:12 INFO - "buildnumber": 36, 16:28:12 INFO - "slavename": "t-w864-ix-177", 16:28:12 INFO - "master": "http://buildbot-master110.bb.releng.scl3.mozilla.com:8201/", 16:28:12 INFO - "platform": "win8_64", 16:28:12 INFO - "scheduler": "tests-fx-team-win64-pgo-talos", 16:28:12 INFO - "branch": "fx-team", 16:28:12 INFO - "repo_path": "integration/fx-team", 16:28:12 INFO - "revision": "a9a41b69f3f9be494ae0653601c08aa388d9afe4", 16:28:12 INFO - "stage_platform": "win64-pgo", 16:28:12 INFO - "builduid": "e56cd4dbefe34d1d82ee5740e6d07fee", 16:28:12 INFO - "slavebuilddir": "test" 16:28:12 INFO - } 16:28:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/Dz6qAvbfQEKPBhFsTbJiMQ/artifacts/public/build/firefox-52.0a1.en-US.win64.zip. 16:28:12 INFO - Running post-action listener: _resource_record_post_action 16:28:12 INFO - [mozharness: 2016-10-23 23:28:12.903000Z] Finished read-buildbot-config step (success) 16:28:12 INFO - [mozharness: 2016-10-23 23:28:12.903000Z] Running download-and-extract step. 16:28:12 INFO - Running pre-action listener: _resource_record_pre_action 16:28:12 INFO - Running main action method: download_and_extract 16:28:12 INFO - mkdir: C:\slave\test\build\tests 16:28:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:12 INFO - trying https://queue.taskcluster.net/v1/task/Dz6qAvbfQEKPBhFsTbJiMQ/artifacts/public/build/firefox-52.0a1.en-US.win64.test_packages.json 16:28:12 INFO - Downloading https://queue.taskcluster.net/v1/task/Dz6qAvbfQEKPBhFsTbJiMQ/artifacts/public/build/firefox-52.0a1.en-US.win64.test_packages.json to C:\slave\test\build\firefox-52.0a1.en-US.win64.test_packages.json 16:28:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dz6qAvbfQEKPBhFsTbJiMQ/artifacts/public/build/firefox-52.0a1.en-US.win64.test_packages.json', 'file_name': 'C:\\slave\\test\\build\\firefox-52.0a1.en-US.win64.test_packages.json'}, attempt #1 16:28:13 INFO - Downloaded 1218 bytes. 16:28:13 INFO - Reading from file C:\slave\test\build\firefox-52.0a1.en-US.win64.test_packages.json 16:28:13 INFO - Using the following test package requirements: 16:28:13 INFO - {u'common': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 16:28:13 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 16:28:13 INFO - u'firefox-52.0a1.en-US.win64.cppunittest.tests.zip'], 16:28:13 INFO - u'gtest': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 16:28:13 INFO - u'jittest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 16:28:13 INFO - u'jsshell-win64.zip'], 16:28:13 INFO - u'mochitest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 16:28:13 INFO - u'firefox-52.0a1.en-US.win64.mochitest.tests.zip'], 16:28:13 INFO - u'mozbase': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 16:28:13 INFO - u'reftest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 16:28:13 INFO - u'firefox-52.0a1.en-US.win64.reftest.tests.zip'], 16:28:13 INFO - u'talos': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 16:28:13 INFO - u'firefox-52.0a1.en-US.win64.talos.tests.zip'], 16:28:13 INFO - u'web-platform': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 16:28:13 INFO - u'firefox-52.0a1.en-US.win64.web-platform.tests.zip'], 16:28:13 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 16:28:13 INFO - u'firefox-52.0a1.en-US.win64.xpcshell.tests.zip']} 16:28:13 INFO - Downloading packages: [u'firefox-52.0a1.en-US.win64.common.tests.zip'] for test suite category: common 16:28:13 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/Dz6qAvbfQEKPBhFsTbJiMQ/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip 16:28:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dz6qAvbfQEKPBhFsTbJiMQ/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip'}, attempt #1 16:28:13 INFO - Fetch https://queue.taskcluster.net/v1/task/Dz6qAvbfQEKPBhFsTbJiMQ/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip into memory 16:28:14 INFO - Http code: 200 16:28:14 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 16:28:14 INFO - x-amz-cf-id: FdSe-hRxj-Xxl8TfAqAmw-maya3XH2OCKOO8Xkg1Sw_0g0cxMPD_Wg== 16:28:14 INFO - x-amz-version-id: 5HDowgCluqrRYnBqxsLirbgRs7AhFcMg 16:28:14 INFO - Expected file size: 17468022 16:28:14 INFO - Obtained file size: 17468022 16:28:37 INFO - Downloading packages: [u'firefox-52.0a1.en-US.win64.common.tests.zip', u'firefox-52.0a1.en-US.win64.talos.tests.zip'] for test suite category: talos 16:28:37 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/Dz6qAvbfQEKPBhFsTbJiMQ/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip 16:28:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dz6qAvbfQEKPBhFsTbJiMQ/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip'}, attempt #1 16:28:37 INFO - Fetch https://queue.taskcluster.net/v1/task/Dz6qAvbfQEKPBhFsTbJiMQ/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip into memory 16:28:37 INFO - Http code: 200 16:28:37 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 16:28:37 INFO - x-amz-cf-id: KnsydDN-o2VFq62FdzpJegzl9C9wrFDVNwgRKeXg97CRkoxf0zC5Gw== 16:28:37 INFO - x-amz-version-id: 5HDowgCluqrRYnBqxsLirbgRs7AhFcMg 16:28:38 INFO - Expected file size: 17468022 16:28:38 INFO - Obtained file size: 17468022 16:28:47 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/Dz6qAvbfQEKPBhFsTbJiMQ/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip 16:28:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dz6qAvbfQEKPBhFsTbJiMQ/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip'}, attempt #1 16:28:47 INFO - Fetch https://queue.taskcluster.net/v1/task/Dz6qAvbfQEKPBhFsTbJiMQ/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip into memory 16:28:48 INFO - Http code: 200 16:28:48 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 16:28:48 INFO - x-amz-cf-id: CrFfbQwrrtIB2xXLUc1168LxhshHejAt15pAqBISSrEghKQTYRgktA== 16:28:48 INFO - x-amz-version-id: P0yI4obscF4YOFyRvoqC0ZCDlCdaVw.x 16:28:48 INFO - Expected file size: 14409028 16:28:48 INFO - Obtained file size: 14409028 16:28:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:55 INFO - trying https://queue.taskcluster.net/v1/task/Dz6qAvbfQEKPBhFsTbJiMQ/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 16:28:55 INFO - Downloading https://queue.taskcluster.net/v1/task/Dz6qAvbfQEKPBhFsTbJiMQ/artifacts/public/build/firefox-52.0a1.en-US.win64.zip to C:\slave\test\build\firefox-52.0a1.en-US.win64.zip 16:28:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dz6qAvbfQEKPBhFsTbJiMQ/artifacts/public/build/firefox-52.0a1.en-US.win64.zip', 'file_name': 'C:\\slave\\test\\build\\firefox-52.0a1.en-US.win64.zip'}, attempt #1 16:28:56 INFO - Downloaded 57144860 bytes. 16:28:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Dz6qAvbfQEKPBhFsTbJiMQ/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 16:28:56 INFO - mkdir: C:\slave\test\properties 16:28:56 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url 16:28:56 INFO - Writing to file C:\slave\test\properties\build_url 16:28:56 INFO - Contents: 16:28:56 INFO - build_url:https://queue.taskcluster.net/v1/task/Dz6qAvbfQEKPBhFsTbJiMQ/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 16:28:57 INFO - Running post-action listener: _resource_record_post_action 16:28:57 INFO - Running post-action listener: set_extra_try_arguments 16:28:57 INFO - [mozharness: 2016-10-23 23:28:57.651000Z] Finished download-and-extract step (success) 16:28:57 INFO - [mozharness: 2016-10-23 23:28:57.651000Z] Running populate-webroot step. 16:28:57 INFO - Running pre-action listener: _resource_record_pre_action 16:28:57 INFO - Running main action method: populate_webroot 16:28:57 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']}, 16:28:57 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']}, 16:28:57 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome', 16:28:57 INFO - u'--tppagecycles', 16:28:57 INFO - u'7'], 16:28:57 INFO - u'tests': [u'tsvgm']}}, 16:28:57 INFO - u'suites': {u'chromez': {u'talos_options': [u'--disable-e10s'], 16:28:57 INFO - u'tests': [u'tresize', u'tcanvasmark']}, 16:28:57 INFO - u'chromez-e10s': {u'tests': [u'tresize', u'tcanvasmark']}, 16:28:57 INFO - u'dromaeojs': {u'talos_options': [u'--disable-e10s'], 16:28:57 INFO - u'tests': [u'dromaeo_css', u'kraken']}, 16:28:57 INFO - u'dromaeojs-e10s': {u'tests': [u'dromaeo_css', u'kraken']}, 16:28:57 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:57 INFO - u'talos_options': [u'--disable-e10s'], 16:28:57 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 16:28:57 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:57 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 16:28:57 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:57 INFO - u'talos_options': [u'--disable-e10s'], 16:28:57 INFO - u'tests': [u'damp', u'tps']}, 16:28:57 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:57 INFO - u'tests': [u'damp', u'tps']}, 16:28:57 INFO - u'g3': {u'talos_options': [u'--disable-e10s'], 16:28:57 INFO - u'tests': [u'dromaeo_dom']}, 16:28:57 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']}, 16:28:57 INFO - u'g4': {u'talos_options': [u'--disable-e10s'], 16:28:57 INFO - u'tests': [u'basic_compositor_video']}, 16:28:57 INFO - u'g4-e10s': {u'tests': [u'basic_compositor_video']}, 16:28:57 INFO - u'other': {u'talos_options': [u'--disable-e10s'], 16:28:57 INFO - u'tests': [u'a11yr', 16:28:57 INFO - u'ts_paint', 16:28:57 INFO - u'tpaint', 16:28:57 INFO - u'sessionrestore', 16:28:57 INFO - u'sessionrestore_no_auto_restore', 16:28:57 INFO - u'tabpaint']}, 16:28:57 INFO - u'other-e10s': {u'tests': [u'a11yr', 16:28:57 INFO - u'ts_paint', 16:28:57 INFO - u'tpaint', 16:28:57 INFO - u'sessionrestore', 16:28:57 INFO - u'sessionrestore_no_auto_restore', 16:28:57 INFO - u'tabpaint']}, 16:28:57 INFO - u'other-e10s_l64': {u'tests': [u'a11yr', 16:28:57 INFO - u'ts_paint', 16:28:57 INFO - u'tpaint', 16:28:57 INFO - u'sessionrestore', 16:28:57 INFO - u'sessionrestore_no_auto_restore', 16:28:57 INFO - u'tabpaint']}, 16:28:57 INFO - u'other-e10s_nol64': {u'tests': [u'a11yr', 16:28:57 INFO - u'ts_paint', 16:28:57 INFO - u'tpaint', 16:28:57 INFO - u'sessionrestore', 16:28:57 INFO - u'sessionrestore_no_auto_restore', 16:28:57 INFO - u'tabpaint']}, 16:28:57 INFO - u'other_l64': {u'talos_options': [u'--disable-e10s'], 16:28:57 INFO - u'tests': [u'a11yr', 16:28:57 INFO - u'ts_paint', 16:28:57 INFO - u'tpaint', 16:28:57 INFO - u'sessionrestore', 16:28:57 INFO - u'sessionrestore_no_auto_restore', 16:28:57 INFO - u'tabpaint']}, 16:28:57 INFO - u'other_nol64': {u'talos_options': [u'--disable-e10s'], 16:28:57 INFO - u'tests': [u'a11yr', 16:28:57 INFO - u'ts_paint', 16:28:57 INFO - u'tpaint', 16:28:57 INFO - u'sessionrestore', 16:28:57 INFO - u'sessionrestore_no_auto_restore', 16:28:57 INFO - u'tabpaint']}, 16:28:57 INFO - u'svgr': {u'talos_options': [u'--disable-e10s'], 16:28:57 INFO - u'tests': [u'tsvgx', 16:28:57 INFO - u'tsvgr_opacity', 16:28:57 INFO - u'tart', 16:28:57 INFO - u'tscrollx', 16:28:57 INFO - u'cart']}, 16:28:57 INFO - u'svgr-e10s': {u'tests': [u'tsvgx', 16:28:57 INFO - u'tsvgr_opacity', 16:28:57 INFO - u'tart', 16:28:57 INFO - u'tscrollx', 16:28:57 INFO - u'cart']}, 16:28:57 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:57 INFO - u'talos_options': [u'--disable-e10s'], 16:28:57 INFO - u'tests': [u'tp5o']}, 16:28:57 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:57 INFO - u'tests': [u'tp5o']}, 16:28:57 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:57 INFO - u'talos_options': [u'--disable-e10s', 16:28:57 INFO - u'--xperf_path', 16:28:57 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:28:57 INFO - u'tests': [u'tp5n']}, 16:28:57 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:57 INFO - u'talos_options': [u'--xperf_path', 16:28:57 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:28:57 INFO - u'tests': [u'tp5n']}}, 16:28:57 INFO - u'talos.zip': {u'path': u'', 16:28:57 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:28:57 INFO - Running post-action listener: _resource_record_post_action 16:28:57 INFO - [mozharness: 2016-10-23 23:28:57.693000Z] Finished populate-webroot step (success) 16:28:57 INFO - [mozharness: 2016-10-23 23:28:57.693000Z] Running create-virtualenv step. 16:28:57 INFO - Running pre-action listener: _resource_record_pre_action 16:28:57 INFO - Running main action method: create_virtualenv 16:28:57 INFO - Creating virtualenv C:\slave\test\build/venv 16:28:57 INFO - mkdir: C:\slave\test\build\venv\Scripts 16:28:57 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll 16:28:57 WARNING - Can't copy c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll: [Errno 2] No such file or directory: 'c:/mozilla-build/python27/python27.dll'! 16:28:57 INFO - Running command: ['c:/mozilla-build/python27/python.exe', 'c:/mozilla-build/buildbotve/virtualenv.py', '--no-site-packages', '--distribute', 'C:\\slave\\test\\build/venv'] in C:\slave\test\build 16:28:57 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build/venv 16:29:04 INFO - New python executable in C:\slave\test\build/venv\Scripts\python.exe 16:29:07 INFO - Installing distribute......................................................................................................................................................................................done. 16:29:09 INFO - Return code: 0 16:29:09 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', '--version'] 16:29:09 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip --version 16:29:09 INFO - Reading from file tmpfile_stdout 16:29:09 INFO - Output received: 16:29:09 INFO - pip 0.8.2 from c:\slave\test\build\venv\lib\site-packages\pip-0.8.2-py2.7.egg (python 2.7) 16:29:09 INFO - Using _rmtree_windows ... 16:29:09 INFO - Using _rmtree_windows ... 16:29:09 INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv 16:29:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:09 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022FC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023A3E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024AEC28>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023EAE90>, '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 0x004EA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0288D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-177', 'USERDOMAIN': 'T-W864-IX-177', '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-177', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-177\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-177', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-177', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-177', '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-177\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 16:29:09 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in C:\slave\test\build 16:29:09 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:29:09 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 16:29:09 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-177\\AppData\\Roaming', 16:29:09 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 16:29:09 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 16:29:09 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 16:29:09 INFO - 'COMPUTERNAME': 'T-W864-IX-177', 16:29:09 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 16:29:09 INFO - 'DCLOCATION': 'SCL3', 16:29:09 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 16:29:09 INFO - 'FP_NO_HOST_CHECK': 'NO', 16:29:09 INFO - 'HOMEDRIVE': 'C:', 16:29:09 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-177', 16:29:09 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 16:29:09 INFO - 'KTS_VERSION': '1.19c', 16:29:09 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-177\\AppData\\Local', 16:29:09 INFO - 'LOGONSERVER': '\\\\T-W864-IX-177', 16:29:09 INFO - 'MONDIR': 'C:\\Monitor_config\\', 16:29:09 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 16:29:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:09 INFO - 'MOZ_NO_REMOTE': '1', 16:29:09 INFO - 'NO_EM_RESTART': '1', 16:29:09 INFO - 'NUMBER_OF_PROCESSORS': '8', 16:29:09 INFO - 'OS': 'Windows_NT', 16:29:09 INFO - 'OURDRIVE': 'C:', 16:29:09 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 16:29:09 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 16:29:09 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 16:29:09 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 16:29:09 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 16:29:09 INFO - 'PROCESSOR_LEVEL': '6', 16:29:09 INFO - 'PROCESSOR_REVISION': '1e05', 16:29:09 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 16:29:09 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 16:29:09 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 16:29:09 INFO - 'PROGRAMW6432': 'C:\\Program Files', 16:29:09 INFO - 'PROMPT': '$P$G', 16:29:09 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 16:29:09 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 16:29:09 INFO - 'PUBLIC': 'C:\\Users\\Public', 16:29:09 INFO - 'PWD': 'C:\\slave\\test', 16:29:09 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 16:29:09 INFO - 'SLAVEDIR': 'C:\\slave\\', 16:29:09 INFO - 'SYSTEMDRIVE': 'C:', 16:29:09 INFO - 'SYSTEMROOT': 'C:\\windows', 16:29:09 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:29:09 INFO - 'TEST1': 'testie', 16:29:09 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:29:09 INFO - 'USERDOMAIN': 'T-W864-IX-177', 16:29:09 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-177', 16:29:09 INFO - 'USERNAME': 'cltbld', 16:29:09 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-177', 16:29:09 INFO - 'WINDIR': 'C:\\windows', 16:29:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 16:29:10 INFO - Ignoring indexes: http://pypi.python.org/simple/ 16:29:10 INFO - Downloading/unpacking pip>=1.5 16:29:14 INFO - Running setup.py egg_info for package pip 16:29:14 INFO - warning: no files found matching 'pip\cacert.pem' 16:29:14 INFO - warning: no files found matching '*.html' under directory 'docs' 16:29:14 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 16:29:14 INFO - no previously-included directories found matching 'docs\_build\_sources' 16:29:14 INFO - Installing collected packages: pip 16:29:14 INFO - Found existing installation: pip 0.8.2 16:29:14 INFO - Uninstalling pip: 16:29:14 INFO - Successfully uninstalled pip 16:29:14 INFO - Running setup.py install for pip 16:29:14 INFO - warning: no files found matching 'pip\cacert.pem' 16:29:14 INFO - warning: no files found matching '*.html' under directory 'docs' 16:29:14 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 16:29:14 INFO - no previously-included directories found matching 'docs\_build\_sources' 16:29:14 INFO - Installing pip-script.py script to C:\slave\test\build\venv\Scripts 16:29:14 INFO - Installing pip.exe script to C:\slave\test\build\venv\Scripts 16:29:14 INFO - Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts 16:29:14 INFO - Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts 16:29:14 INFO - Installing pip2-script.py script to C:\slave\test\build\venv\Scripts 16:29:14 INFO - Installing pip2.exe script to C:\slave\test\build\venv\Scripts 16:29:14 INFO - Successfully installed pip 16:29:14 INFO - Cleaning up... 16:29:14 INFO - Return code: 0 16:29:14 INFO - Installing psutil>=3.1.1 into virtualenv C:\slave\test\build/venv 16:29:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:14 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022FC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023A3E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024AEC28>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023EAE90>, '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 0x004EA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0288D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-177', 'USERDOMAIN': 'T-W864-IX-177', '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-177', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-177\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-177', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-177', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-177', '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-177\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 16:29:14 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in C:\slave\test\build 16:29:14 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:29:14 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 16:29:14 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-177\\AppData\\Roaming', 16:29:14 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 16:29:14 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 16:29:14 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 16:29:14 INFO - 'COMPUTERNAME': 'T-W864-IX-177', 16:29:14 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 16:29:14 INFO - 'DCLOCATION': 'SCL3', 16:29:14 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 16:29:14 INFO - 'FP_NO_HOST_CHECK': 'NO', 16:29:14 INFO - 'HOMEDRIVE': 'C:', 16:29:14 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-177', 16:29:14 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 16:29:14 INFO - 'KTS_VERSION': '1.19c', 16:29:14 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-177\\AppData\\Local', 16:29:14 INFO - 'LOGONSERVER': '\\\\T-W864-IX-177', 16:29:14 INFO - 'MONDIR': 'C:\\Monitor_config\\', 16:29:14 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 16:29:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:14 INFO - 'MOZ_NO_REMOTE': '1', 16:29:14 INFO - 'NO_EM_RESTART': '1', 16:29:14 INFO - 'NUMBER_OF_PROCESSORS': '8', 16:29:14 INFO - 'OS': 'Windows_NT', 16:29:14 INFO - 'OURDRIVE': 'C:', 16:29:14 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 16:29:14 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 16:29:14 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 16:29:14 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 16:29:14 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 16:29:14 INFO - 'PROCESSOR_LEVEL': '6', 16:29:14 INFO - 'PROCESSOR_REVISION': '1e05', 16:29:14 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 16:29:14 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 16:29:14 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 16:29:14 INFO - 'PROGRAMW6432': 'C:\\Program Files', 16:29:14 INFO - 'PROMPT': '$P$G', 16:29:14 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 16:29:14 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 16:29:14 INFO - 'PUBLIC': 'C:\\Users\\Public', 16:29:14 INFO - 'PWD': 'C:\\slave\\test', 16:29:14 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 16:29:14 INFO - 'SLAVEDIR': 'C:\\slave\\', 16:29:14 INFO - 'SYSTEMDRIVE': 'C:', 16:29:14 INFO - 'SYSTEMROOT': 'C:\\windows', 16:29:14 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:29:14 INFO - 'TEST1': 'testie', 16:29:14 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:29:14 INFO - 'USERDOMAIN': 'T-W864-IX-177', 16:29:14 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-177', 16:29:14 INFO - 'USERNAME': 'cltbld', 16:29:14 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-177', 16:29:14 INFO - 'WINDIR': 'C:\\windows', 16:29:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 16:29:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:15 INFO - Downloading/unpacking psutil>=3.1.1 16:29:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:16 INFO - Installing collected packages: psutil 16:29:17 INFO - Successfully installed psutil 16:29:17 INFO - Cleaning up... 16:29:17 INFO - Return code: 0 16:29:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv C:\slave\test\build/venv 16:29:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:17 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022FC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023A3E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024AEC28>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023EAE90>, '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 0x004EA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0288D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-177', 'USERDOMAIN': 'T-W864-IX-177', '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-177', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-177\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-177', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-177', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-177', '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-177\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 16:29:17 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in C:\slave\test\build 16:29:17 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:29:17 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 16:29:17 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-177\\AppData\\Roaming', 16:29:17 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 16:29:17 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 16:29:17 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 16:29:17 INFO - 'COMPUTERNAME': 'T-W864-IX-177', 16:29:17 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 16:29:17 INFO - 'DCLOCATION': 'SCL3', 16:29:17 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 16:29:17 INFO - 'FP_NO_HOST_CHECK': 'NO', 16:29:17 INFO - 'HOMEDRIVE': 'C:', 16:29:17 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-177', 16:29:17 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 16:29:17 INFO - 'KTS_VERSION': '1.19c', 16:29:17 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-177\\AppData\\Local', 16:29:17 INFO - 'LOGONSERVER': '\\\\T-W864-IX-177', 16:29:17 INFO - 'MONDIR': 'C:\\Monitor_config\\', 16:29:17 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 16:29:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:17 INFO - 'MOZ_NO_REMOTE': '1', 16:29:17 INFO - 'NO_EM_RESTART': '1', 16:29:17 INFO - 'NUMBER_OF_PROCESSORS': '8', 16:29:17 INFO - 'OS': 'Windows_NT', 16:29:17 INFO - 'OURDRIVE': 'C:', 16:29:17 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 16:29:17 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 16:29:17 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 16:29:17 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 16:29:17 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 16:29:17 INFO - 'PROCESSOR_LEVEL': '6', 16:29:17 INFO - 'PROCESSOR_REVISION': '1e05', 16:29:17 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 16:29:17 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 16:29:17 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 16:29:17 INFO - 'PROGRAMW6432': 'C:\\Program Files', 16:29:17 INFO - 'PROMPT': '$P$G', 16:29:17 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 16:29:17 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 16:29:17 INFO - 'PUBLIC': 'C:\\Users\\Public', 16:29:17 INFO - 'PWD': 'C:\\slave\\test', 16:29:17 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 16:29:17 INFO - 'SLAVEDIR': 'C:\\slave\\', 16:29:17 INFO - 'SYSTEMDRIVE': 'C:', 16:29:17 INFO - 'SYSTEMROOT': 'C:\\windows', 16:29:17 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:29:17 INFO - 'TEST1': 'testie', 16:29:17 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:29:17 INFO - 'USERDOMAIN': 'T-W864-IX-177', 16:29:17 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-177', 16:29:17 INFO - 'USERNAME': 'cltbld', 16:29:17 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-177', 16:29:17 INFO - 'WINDIR': 'C:\\windows', 16:29:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 16:29:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:29:18 INFO - Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor 16:29:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in c:\slave\test\build\venv\lib\site-packages (from mozsystemmonitor==0.3) 16:29:18 INFO - Installing collected packages: mozsystemmonitor 16:29:18 INFO - Running setup.py install for mozsystemmonitor 16:29:18 INFO - Successfully installed mozsystemmonitor 16:29:18 INFO - Cleaning up... 16:29:18 INFO - Return code: 0 16:29:18 INFO - Installing jsonschema==2.5.1 into virtualenv C:\slave\test\build/venv 16:29:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:18 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022FC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023A3E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024AEC28>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023EAE90>, '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 0x004EA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0288D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-177', 'USERDOMAIN': 'T-W864-IX-177', '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-177', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-177\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-177', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-177', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-177', '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-177\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 16:29:18 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in C:\slave\test\build 16:29:18 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:29:18 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 16:29:18 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-177\\AppData\\Roaming', 16:29:18 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 16:29:18 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 16:29:18 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 16:29:18 INFO - 'COMPUTERNAME': 'T-W864-IX-177', 16:29:18 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 16:29:18 INFO - 'DCLOCATION': 'SCL3', 16:29:18 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 16:29:18 INFO - 'FP_NO_HOST_CHECK': 'NO', 16:29:18 INFO - 'HOMEDRIVE': 'C:', 16:29:18 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-177', 16:29:18 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 16:29:18 INFO - 'KTS_VERSION': '1.19c', 16:29:18 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-177\\AppData\\Local', 16:29:18 INFO - 'LOGONSERVER': '\\\\T-W864-IX-177', 16:29:18 INFO - 'MONDIR': 'C:\\Monitor_config\\', 16:29:18 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 16:29:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:18 INFO - 'MOZ_NO_REMOTE': '1', 16:29:18 INFO - 'NO_EM_RESTART': '1', 16:29:18 INFO - 'NUMBER_OF_PROCESSORS': '8', 16:29:18 INFO - 'OS': 'Windows_NT', 16:29:18 INFO - 'OURDRIVE': 'C:', 16:29:18 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 16:29:18 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 16:29:18 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 16:29:18 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 16:29:18 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 16:29:18 INFO - 'PROCESSOR_LEVEL': '6', 16:29:18 INFO - 'PROCESSOR_REVISION': '1e05', 16:29:18 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 16:29:18 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 16:29:18 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 16:29:18 INFO - 'PROGRAMW6432': 'C:\\Program Files', 16:29:18 INFO - 'PROMPT': '$P$G', 16:29:18 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 16:29:18 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 16:29:18 INFO - 'PUBLIC': 'C:\\Users\\Public', 16:29:18 INFO - 'PWD': 'C:\\slave\\test', 16:29:18 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 16:29:18 INFO - 'SLAVEDIR': 'C:\\slave\\', 16:29:18 INFO - 'SYSTEMDRIVE': 'C:', 16:29:18 INFO - 'SYSTEMROOT': 'C:\\windows', 16:29:18 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:29:18 INFO - 'TEST1': 'testie', 16:29:18 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:29:18 INFO - 'USERDOMAIN': 'T-W864-IX-177', 16:29:18 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-177', 16:29:18 INFO - 'USERNAME': 'cltbld', 16:29:18 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-177', 16:29:18 INFO - 'WINDIR': 'C:\\windows', 16:29:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 16:29:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:19 INFO - Downloading/unpacking jsonschema==2.5.1 16:29:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:29:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:29:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:20 INFO - Downloading functools32-3.2.3-2.tar.gz 16:29:20 INFO - Running setup.py (path:C:\slave\test\build\venv\build\functools32\setup.py) egg_info for package functools32 16:29:20 INFO - warning: no files found matching '*.txt' 16:29:20 INFO - no previously-included directories found matching 'build' 16:29:20 INFO - no previously-included directories found matching 'dist' 16:29:20 INFO - no previously-included directories found matching '.git*' 16:29:20 INFO - Installing collected packages: jsonschema, functools32 16:29:20 INFO - Running setup.py install for functools32 16:29:20 INFO - warning: no files found matching '*.txt' 16:29:20 INFO - no previously-included directories found matching 'build' 16:29:20 INFO - no previously-included directories found matching 'dist' 16:29:20 INFO - no previously-included directories found matching '.git*' 16:29:20 INFO - Successfully installed jsonschema functools32 16:29:20 INFO - Cleaning up... 16:29:21 INFO - Return code: 0 16:29:21 INFO - Installing functools32==3.2.3-2 into virtualenv C:\slave\test\build/venv 16:29: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')]} 16:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29: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')]} 16:29:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:21 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022FC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023A3E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024AEC28>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023EAE90>, '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 0x004EA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0288D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-177', 'USERDOMAIN': 'T-W864-IX-177', '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-177', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-177\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-177', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-177', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-177', '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-177\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 16:29:21 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in C:\slave\test\build 16:29:21 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:29:21 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 16:29:21 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-177\\AppData\\Roaming', 16:29:21 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 16:29:21 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 16:29:21 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 16:29:21 INFO - 'COMPUTERNAME': 'T-W864-IX-177', 16:29:21 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 16:29:21 INFO - 'DCLOCATION': 'SCL3', 16:29:21 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 16:29:21 INFO - 'FP_NO_HOST_CHECK': 'NO', 16:29:21 INFO - 'HOMEDRIVE': 'C:', 16:29:21 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-177', 16:29:21 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 16:29:21 INFO - 'KTS_VERSION': '1.19c', 16:29:21 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-177\\AppData\\Local', 16:29:21 INFO - 'LOGONSERVER': '\\\\T-W864-IX-177', 16:29:21 INFO - 'MONDIR': 'C:\\Monitor_config\\', 16:29:21 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 16:29:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:21 INFO - 'MOZ_NO_REMOTE': '1', 16:29:21 INFO - 'NO_EM_RESTART': '1', 16:29:21 INFO - 'NUMBER_OF_PROCESSORS': '8', 16:29:21 INFO - 'OS': 'Windows_NT', 16:29:21 INFO - 'OURDRIVE': 'C:', 16:29: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', 16:29:21 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 16:29:21 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 16:29:21 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 16:29:21 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 16:29:21 INFO - 'PROCESSOR_LEVEL': '6', 16:29:21 INFO - 'PROCESSOR_REVISION': '1e05', 16:29:21 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 16:29:21 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 16:29:21 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 16:29:21 INFO - 'PROGRAMW6432': 'C:\\Program Files', 16:29:21 INFO - 'PROMPT': '$P$G', 16:29:21 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 16:29:21 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 16:29:21 INFO - 'PUBLIC': 'C:\\Users\\Public', 16:29:21 INFO - 'PWD': 'C:\\slave\\test', 16:29:21 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 16:29:21 INFO - 'SLAVEDIR': 'C:\\slave\\', 16:29:21 INFO - 'SYSTEMDRIVE': 'C:', 16:29:21 INFO - 'SYSTEMROOT': 'C:\\windows', 16:29:21 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:29:21 INFO - 'TEST1': 'testie', 16:29:21 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:29:21 INFO - 'USERDOMAIN': 'T-W864-IX-177', 16:29:21 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-177', 16:29:21 INFO - 'USERNAME': 'cltbld', 16:29:21 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-177', 16:29:21 INFO - 'WINDIR': 'C:\\windows', 16:29:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 16:29:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in c:\slave\test\build\venv\lib\site-packages 16:29:21 INFO - Cleaning up... 16:29:21 INFO - Return code: 0 16:29:21 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv 16:29: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')]} 16:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29: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')]} 16:29:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:21 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022FC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023A3E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024AEC28>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023EAE90>, '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 0x004EA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0288D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-177', 'USERDOMAIN': 'T-W864-IX-177', '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-177', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-177\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-177', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-177', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-177', '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-177\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 16:29:21 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in C:\slave\test\build 16:29:21 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:29:21 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 16:29:21 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-177\\AppData\\Roaming', 16:29:21 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 16:29:21 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 16:29:21 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 16:29:21 INFO - 'COMPUTERNAME': 'T-W864-IX-177', 16:29:21 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 16:29:21 INFO - 'DCLOCATION': 'SCL3', 16:29:21 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 16:29:21 INFO - 'FP_NO_HOST_CHECK': 'NO', 16:29:21 INFO - 'HOMEDRIVE': 'C:', 16:29:21 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-177', 16:29:21 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 16:29:21 INFO - 'KTS_VERSION': '1.19c', 16:29:21 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-177\\AppData\\Local', 16:29:21 INFO - 'LOGONSERVER': '\\\\T-W864-IX-177', 16:29:21 INFO - 'MONDIR': 'C:\\Monitor_config\\', 16:29:21 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 16:29:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:21 INFO - 'MOZ_NO_REMOTE': '1', 16:29:21 INFO - 'NO_EM_RESTART': '1', 16:29:21 INFO - 'NUMBER_OF_PROCESSORS': '8', 16:29:21 INFO - 'OS': 'Windows_NT', 16:29:21 INFO - 'OURDRIVE': 'C:', 16:29: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', 16:29:21 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 16:29:21 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 16:29:21 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 16:29:21 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 16:29:21 INFO - 'PROCESSOR_LEVEL': '6', 16:29:21 INFO - 'PROCESSOR_REVISION': '1e05', 16:29:21 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 16:29:21 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 16:29:21 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 16:29:21 INFO - 'PROGRAMW6432': 'C:\\Program Files', 16:29:21 INFO - 'PROMPT': '$P$G', 16:29:21 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 16:29:21 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 16:29:21 INFO - 'PUBLIC': 'C:\\Users\\Public', 16:29:21 INFO - 'PWD': 'C:\\slave\\test', 16:29:21 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 16:29:21 INFO - 'SLAVEDIR': 'C:\\slave\\', 16:29:21 INFO - 'SYSTEMDRIVE': 'C:', 16:29:21 INFO - 'SYSTEMROOT': 'C:\\windows', 16:29:21 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:29:21 INFO - 'TEST1': 'testie', 16:29:21 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:29:21 INFO - 'USERDOMAIN': 'T-W864-IX-177', 16:29:21 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-177', 16:29:21 INFO - 'USERNAME': 'cltbld', 16:29:21 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-177', 16:29:21 INFO - 'WINDIR': 'C:\\windows', 16:29:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 16:29:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:21 INFO - Downloading/unpacking blobuploader==1.2.4 16:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:22 INFO - Downloading blobuploader-1.2.4.tar.gz 16:29:22 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader 16:29:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:29:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:23 INFO - Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests 16:29:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:29: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 16:29: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 16:29:23 INFO - Downloading docopt-0.6.1.tar.gz 16:29:23 INFO - Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt 16:29:23 INFO - Installing collected packages: blobuploader, requests, docopt 16:29:23 INFO - Running setup.py install for blobuploader 16:29:23 INFO - Running setup.py install for requests 16:29:24 INFO - Running setup.py install for docopt 16:29:24 INFO - Successfully installed blobuploader requests docopt 16:29:24 INFO - Cleaning up... 16:29:25 INFO - Return code: 0 16:29:25 INFO - Installing None into virtualenv C:\slave\test\build/venv 16:29:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:25 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--no-deps', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022FC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023A3E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024AEC28>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023EAE90>, '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 0x004EA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0288D520>, '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-177', 'USERDOMAIN': 'T-W864-IX-177', '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-177', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-177\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-177', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-177', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-177', '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-177\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 16:29:25 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--no-deps', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in C:\slave\test\build\tests\config 16:29:25 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --no-deps --timeout 120 -r C:\slave\test\build\tests\config\mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:29:25 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 16:29:25 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-177\\AppData\\Roaming', 16:29:25 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 16:29:25 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 16:29:25 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 16:29:25 INFO - 'COMPUTERNAME': 'T-W864-IX-177', 16:29:25 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 16:29:25 INFO - 'DCLOCATION': 'SCL3', 16:29:25 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 16:29:25 INFO - 'FP_NO_HOST_CHECK': 'NO', 16:29:25 INFO - 'HOMEDRIVE': 'C:', 16:29:25 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-177', 16:29:25 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 16:29:25 INFO - 'KTS_VERSION': '1.19c', 16:29:25 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-177\\AppData\\Local', 16:29:25 INFO - 'LOGONSERVER': '\\\\T-W864-IX-177', 16:29:25 INFO - 'MONDIR': 'C:\\Monitor_config\\', 16:29:25 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 16:29:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:25 INFO - 'MOZ_NO_REMOTE': '1', 16:29:25 INFO - 'NO_EM_RESTART': '1', 16:29:25 INFO - 'NUMBER_OF_PROCESSORS': '8', 16:29:25 INFO - 'OS': 'Windows_NT', 16:29:25 INFO - 'OURDRIVE': 'C:', 16:29:25 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 16:29:25 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 16:29:25 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 16:29:25 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 16:29:25 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 16:29:25 INFO - 'PROCESSOR_LEVEL': '6', 16:29:25 INFO - 'PROCESSOR_REVISION': '1e05', 16:29:25 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 16:29:25 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 16:29:25 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 16:29:25 INFO - 'PROGRAMW6432': 'C:\\Program Files', 16:29:25 INFO - 'PROMPT': '$P$G', 16:29:25 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 16:29:25 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 16:29:25 INFO - 'PUBLIC': 'C:\\Users\\Public', 16:29:25 INFO - 'PWD': 'C:\\slave\\test', 16:29:25 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 16:29:25 INFO - 'SLAVEDIR': 'C:\\slave\\', 16:29:25 INFO - 'SYSTEMDRIVE': 'C:', 16:29:25 INFO - 'SYSTEMROOT': 'C:\\windows', 16:29:25 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:29:25 INFO - 'TEST1': 'testie', 16:29:25 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:29:25 INFO - 'USERDOMAIN': 'T-W864-IX-177', 16:29:25 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-177', 16:29:25 INFO - 'USERNAME': 'cltbld', 16:29:25 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-177', 16:29:25 INFO - 'WINDIR': 'C:\\windows', 16:29:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 16:29:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:26 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 16:29:26 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-sar4mt-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 16:29:26 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 16:29:26 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ejrsh1-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 16:29:26 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 16:29:26 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qbsse3-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 16:29:26 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 16:29:26 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-54vb5p-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 16:29:26 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 16:29:26 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-m5ies_-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 16:29:26 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 16:29:26 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xdsjwj-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 16:29:26 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 16:29:26 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-2o99bq-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 16:29:27 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 16:29:27 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xhlxrv-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 16:29:27 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 16:29:27 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-9mlf9c-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 16:29:27 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 16:29:27 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-pfbkss-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 16:29:27 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 16:29:27 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-oqzecg-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 16:29:27 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 16:29:27 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-y_peki-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 16:29:27 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 16:29:27 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-yhsheo-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 16:29:27 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 16:29:27 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-pkucqc-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 16:29:27 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 16:29:27 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ra9pvy-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 16:29:28 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 16:29:28 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-wdub4a-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 16:29:28 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 16:29:28 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rg9cdb-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 16:29:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:29:28 INFO - Running setup.py install for manifestparser 16:29:28 INFO - Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts 16:29:28 INFO - Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts 16:29:28 INFO - Running setup.py install for mozcrash 16:29:29 INFO - Running setup.py install for mozdebug 16:29:29 INFO - Running setup.py install for mozdevice 16:29:29 INFO - Installing sutini-script.py script to C:\slave\test\build\venv\Scripts 16:29:29 INFO - Installing sutini.exe script to C:\slave\test\build\venv\Scripts 16:29:29 INFO - Installing dm-script.py script to C:\slave\test\build\venv\Scripts 16:29:29 INFO - Installing dm.exe script to C:\slave\test\build\venv\Scripts 16:29:30 INFO - Running setup.py install for mozfile 16:29:30 INFO - Running setup.py install for mozhttpd 16:29:30 INFO - Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts 16:29:30 INFO - Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts 16:29:30 INFO - Running setup.py install for mozinfo 16:29:31 INFO - Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts 16:29:31 INFO - Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts 16:29:31 INFO - Running setup.py install for mozInstall 16:29:31 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts 16:29:31 INFO - Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts 16:29:31 INFO - Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts 16:29:31 INFO - Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts 16:29:31 INFO - Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts 16:29:31 INFO - Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts 16:29:31 INFO - Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts 16:29:31 INFO - Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts 16:29:31 INFO - Running setup.py install for mozleak 16:29:32 INFO - Running setup.py install for mozlog 16:29:32 INFO - Installing structlog-script.py script to C:\slave\test\build\venv\Scripts 16:29:32 INFO - Installing structlog.exe script to C:\slave\test\build\venv\Scripts 16:29:33 INFO - Running setup.py install for moznetwork 16:29:33 INFO - Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts 16:29:33 INFO - Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts 16:29:33 INFO - Running setup.py install for mozprocess 16:29:34 INFO - Running setup.py install for mozprofile 16:29:34 INFO - Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts 16:29:34 INFO - Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts 16:29:34 INFO - Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts 16:29:34 INFO - Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts 16:29:34 INFO - Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts 16:29:34 INFO - Installing view-profile.exe script to C:\slave\test\build\venv\Scripts 16:29:34 INFO - Running setup.py install for mozrunner 16:29:34 INFO - Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts 16:29:34 INFO - Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts 16:29:35 INFO - Running setup.py install for mozscreenshot 16:29:35 INFO - Running setup.py install for moztest 16:29:36 INFO - Running setup.py install for mozversion 16:29:36 INFO - Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts 16:29:36 INFO - Installing mozversion.exe script to C:\slave\test\build\venv\Scripts 16:29:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:29:36 INFO - Cleaning up... 16:29:36 INFO - Return code: 0 16:29:36 INFO - Installing None into virtualenv C:\slave\test\build/venv 16:29:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:36 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022FC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023A3E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024AEC28>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023EAE90>, '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 0x004EA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0288D520>, '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-177', 'USERDOMAIN': 'T-W864-IX-177', '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-177', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-177\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-177', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-177', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-177', '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-177\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 16:29:36 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in C:\slave\test\build\tests\config 16:29:36 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 -r C:\slave\test\build\tests\config\mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:29:36 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 16:29:36 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-177\\AppData\\Roaming', 16:29:36 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 16:29:36 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 16:29:36 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 16:29:36 INFO - 'COMPUTERNAME': 'T-W864-IX-177', 16:29:36 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 16:29:36 INFO - 'DCLOCATION': 'SCL3', 16:29:36 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 16:29:36 INFO - 'FP_NO_HOST_CHECK': 'NO', 16:29:36 INFO - 'HOMEDRIVE': 'C:', 16:29:36 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-177', 16:29:36 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 16:29:36 INFO - 'KTS_VERSION': '1.19c', 16:29:36 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-177\\AppData\\Local', 16:29:36 INFO - 'LOGONSERVER': '\\\\T-W864-IX-177', 16:29:36 INFO - 'MONDIR': 'C:\\Monitor_config\\', 16:29:36 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 16:29:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:36 INFO - 'MOZ_NO_REMOTE': '1', 16:29:36 INFO - 'NO_EM_RESTART': '1', 16:29:36 INFO - 'NUMBER_OF_PROCESSORS': '8', 16:29:36 INFO - 'OS': 'Windows_NT', 16:29:36 INFO - 'OURDRIVE': 'C:', 16:29:36 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 16:29:36 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 16:29:36 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 16:29:36 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 16:29:36 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 16:29:36 INFO - 'PROCESSOR_LEVEL': '6', 16:29:36 INFO - 'PROCESSOR_REVISION': '1e05', 16:29:36 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 16:29:36 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 16:29:36 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 16:29:36 INFO - 'PROGRAMW6432': 'C:\\Program Files', 16:29:36 INFO - 'PROMPT': '$P$G', 16:29:36 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 16:29:36 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 16:29:36 INFO - 'PUBLIC': 'C:\\Users\\Public', 16:29:36 INFO - 'PWD': 'C:\\slave\\test', 16:29:36 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 16:29:36 INFO - 'SLAVEDIR': 'C:\\slave\\', 16:29:36 INFO - 'SYSTEMDRIVE': 'C:', 16:29:36 INFO - 'SYSTEMROOT': 'C:\\windows', 16:29:36 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:29:36 INFO - 'TEST1': 'testie', 16:29:36 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:29:36 INFO - 'USERDOMAIN': 'T-W864-IX-177', 16:29:36 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-177', 16:29:36 INFO - 'USERNAME': 'cltbld', 16:29:36 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-177', 16:29:36 INFO - 'WINDIR': 'C:\\windows', 16:29:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 16:29:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:37 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 16:29:37 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-v_ffmc-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 16:29:37 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///C:/slave/test/build/tests/mozbase/manifestparser in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 1)) 16:29:37 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 16:29:37 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-pvqqso-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 16:29:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///C:/slave/test/build/tests/mozbase/mozcrash in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2)) 16:29:37 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 16:29:37 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-9fwqwu-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 16:29:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///C:/slave/test/build/tests/mozbase/mozdebug in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 3)) 16:29:37 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 16:29:37 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-aiuy2u-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 16:29:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///C:/slave/test/build/tests/mozbase/mozdevice in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4)) 16:29:37 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 16:29:37 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-yq0uwq-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 16:29:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///C:/slave/test/build/tests/mozbase/mozfile in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 5)) 16:29:37 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 16:29:37 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-afijqc-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 16:29:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///C:/slave/test/build/tests/mozbase/mozhttpd in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 6)) 16:29:37 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 16:29:37 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ajy19z-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 16:29:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///C:/slave/test/build/tests/mozbase/mozinfo in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 7)) 16:29:37 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 16:29:37 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-zrtp9u-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 16:29:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///C:/slave/test/build/tests/mozbase/mozinstall in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 8)) 16:29:38 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 16:29:38 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-uea2do-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 16:29:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///C:/slave/test/build/tests/mozbase/mozleak in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 9)) 16:29:38 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 16:29:38 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-mmalf8-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 16:29:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///C:/slave/test/build/tests/mozbase/mozlog in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10)) 16:29:38 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 16:29:38 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-veq2lg-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 16:29:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///C:/slave/test/build/tests/mozbase/moznetwork in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 11)) 16:29:38 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 16:29:38 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-7zx3m7-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 16:29:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///C:/slave/test/build/tests/mozbase/mozprocess in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 12)) 16:29:38 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 16:29:38 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-authhv-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 16:29:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///C:/slave/test/build/tests/mozbase/mozprofile in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 13)) 16:29:38 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 16:29:38 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rpfa0s-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 16:29:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///C:/slave/test/build/tests/mozbase/mozrunner in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 14)) 16:29:38 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 16:29:38 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-g7xgml-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 16:29:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///C:/slave/test/build/tests/mozbase/mozscreenshot in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 15)) 16:29:38 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 16:29:38 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-iq2guo-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 16:29:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///C:/slave/test/build/tests/mozbase/moztest in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 16)) 16:29:38 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 16:29:38 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-nwevif-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 16:29:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///C:/slave/test/build/tests/mozbase/mozversion in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 17)) 16:29:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==0.17->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2)) 16:29:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==0.17->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2)) 16:29:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in c:\slave\test\build\venv\lib\site-packages (from mozdebug==0.1->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 3)) 16:29:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test\build\venv\lib\site-packages (from mozdevice==0.48->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4)) 16:29:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in c:\slave\test\build\venv\lib\site-packages (from mozdevice==0.48->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4)) 16:29:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10)) 16:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:40 INFO - Downloading blessings-1.6.tar.gz 16:29:40 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings 16:29:40 INFO - Installing collected packages: blessings 16:29:40 INFO - Running setup.py install for blessings 16:29:40 INFO - Successfully installed blessings 16:29:40 INFO - Cleaning up... 16:29:43 INFO - Return code: 0 16:29:43 INFO - Done creating virtualenv C:\slave\test\build/venv. 16:29:43 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 16:29:43 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 16:29:44 INFO - Reading from file tmpfile_stdout 16:29:44 INFO - Using _rmtree_windows ... 16:29:44 INFO - Using _rmtree_windows ... 16:29:44 INFO - Current package versions: 16:29:44 INFO - blessings == 1.6 16:29:44 INFO - blobuploader == 1.2.4 16:29:44 INFO - docopt == 0.6.1 16:29:44 INFO - functools32 == 3.2.3-2 16:29:44 INFO - jsonschema == 2.5.1 16:29:44 INFO - manifestparser == 1.1 16:29:44 INFO - mozInstall == 1.12 16:29:44 INFO - mozcrash == 0.17 16:29:44 INFO - mozdebug == 0.1 16:29:44 INFO - mozdevice == 0.48 16:29:44 INFO - mozfile == 1.2 16:29:44 INFO - mozhttpd == 0.7 16:29:44 INFO - mozinfo == 0.9 16:29:44 INFO - mozleak == 0.1 16:29:44 INFO - mozlog == 3.4 16:29:44 INFO - moznetwork == 0.27 16:29:44 INFO - mozprocess == 0.23 16:29:44 INFO - mozprofile == 0.28 16:29:44 INFO - mozrunner == 6.12 16:29:44 INFO - mozscreenshot == 0.1 16:29:44 INFO - mozsystemmonitor == 0.3 16:29:44 INFO - moztest == 0.7 16:29:44 INFO - mozversion == 1.4 16:29:44 INFO - psutil == 3.1.1 16:29:44 INFO - requests == 1.2.3 16:29:44 INFO - Installing None into virtualenv C:\slave\test\build/venv 16:29:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:44 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\talos\\requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022FC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023A3E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024AEC28>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023EAE90>, '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 0x004EA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0288D520>, '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-177', 'USERDOMAIN': 'T-W864-IX-177', '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-177', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-177\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-177', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-177', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-177', '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-177\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 16:29:44 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\talos\\requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in C:\slave\test\build\tests\talos 16:29:44 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 -r C:\slave\test\build\tests\talos\requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:29:44 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 16:29:44 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-177\\AppData\\Roaming', 16:29:44 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 16:29:44 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 16:29:44 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 16:29:44 INFO - 'COMPUTERNAME': 'T-W864-IX-177', 16:29:44 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 16:29:44 INFO - 'DCLOCATION': 'SCL3', 16:29:44 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 16:29:44 INFO - 'FP_NO_HOST_CHECK': 'NO', 16:29:44 INFO - 'HOMEDRIVE': 'C:', 16:29:44 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-177', 16:29:44 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 16:29:44 INFO - 'KTS_VERSION': '1.19c', 16:29:44 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-177\\AppData\\Local', 16:29:44 INFO - 'LOGONSERVER': '\\\\T-W864-IX-177', 16:29:44 INFO - 'MONDIR': 'C:\\Monitor_config\\', 16:29:44 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 16:29:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:44 INFO - 'MOZ_NO_REMOTE': '1', 16:29:44 INFO - 'NO_EM_RESTART': '1', 16:29:44 INFO - 'NUMBER_OF_PROCESSORS': '8', 16:29:44 INFO - 'OS': 'Windows_NT', 16:29:44 INFO - 'OURDRIVE': 'C:', 16:29:44 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 16:29:44 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 16:29:44 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 16:29:44 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 16:29:44 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 16:29:44 INFO - 'PROCESSOR_LEVEL': '6', 16:29:44 INFO - 'PROCESSOR_REVISION': '1e05', 16:29:44 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 16:29:44 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 16:29:44 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 16:29:44 INFO - 'PROGRAMW6432': 'C:\\Program Files', 16:29:44 INFO - 'PROMPT': '$P$G', 16:29:44 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 16:29:44 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 16:29:44 INFO - 'PUBLIC': 'C:\\Users\\Public', 16:29:44 INFO - 'PWD': 'C:\\slave\\test', 16:29:44 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 16:29:44 INFO - 'SLAVEDIR': 'C:\\slave\\', 16:29:44 INFO - 'SYSTEMDRIVE': 'C:', 16:29:44 INFO - 'SYSTEMROOT': 'C:\\windows', 16:29:44 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:29:44 INFO - 'TEST1': 'testie', 16:29:44 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:29:44 INFO - 'USERDOMAIN': 'T-W864-IX-177', 16:29:44 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-177', 16:29:44 INFO - 'USERNAME': 'cltbld', 16:29:44 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-177', 16:29:44 INFO - 'WINDIR': 'C:\\windows', 16:29:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 16:29:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 1)) 16:29:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 2)) 16:29:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 3)) 16:29:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 4)) 16:29:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 5)) 16:29:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 6)) 16:29:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 7)) 16:29:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 8)) 16:29:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 9)) 16:29:44 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in c:\slave\test\build\venv\lib\site-packages (from mozlog>=3.1->-r C:\slave\test\build\tests\talos\requirements.txt (line 1)) 16:29:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test\build\venv\lib\site-packages (from mozhttpd>=0.7->-r C:\slave\test\build\tests\talos\requirements.txt (line 4)) 16:29:44 INFO - Cleaning up... 16:29:44 INFO - Return code: 0 16:29:44 INFO - Installing jsonschema into virtualenv C:\slave\test\build/venv 16:29:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:44 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022FC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023A3E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024AEC28>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023EAE90>, '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 0x004EA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0288D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-177', 'USERDOMAIN': 'T-W864-IX-177', '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-177', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-177\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-177', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-177', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-177', '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-177\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 16:29:44 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in C:\slave\test\build 16:29:44 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:29:44 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 16:29:44 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-177\\AppData\\Roaming', 16:29:44 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 16:29:44 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 16:29:44 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 16:29:44 INFO - 'COMPUTERNAME': 'T-W864-IX-177', 16:29:44 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 16:29:44 INFO - 'DCLOCATION': 'SCL3', 16:29:44 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 16:29:44 INFO - 'FP_NO_HOST_CHECK': 'NO', 16:29:44 INFO - 'HOMEDRIVE': 'C:', 16:29:44 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-177', 16:29:44 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 16:29:44 INFO - 'KTS_VERSION': '1.19c', 16:29:44 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-177\\AppData\\Local', 16:29:44 INFO - 'LOGONSERVER': '\\\\T-W864-IX-177', 16:29:44 INFO - 'MONDIR': 'C:\\Monitor_config\\', 16:29:44 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 16:29:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:44 INFO - 'MOZ_NO_REMOTE': '1', 16:29:44 INFO - 'NO_EM_RESTART': '1', 16:29:44 INFO - 'NUMBER_OF_PROCESSORS': '8', 16:29:44 INFO - 'OS': 'Windows_NT', 16:29:44 INFO - 'OURDRIVE': 'C:', 16:29:44 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 16:29:44 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 16:29:44 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 16:29:44 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 16:29:44 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 16:29:44 INFO - 'PROCESSOR_LEVEL': '6', 16:29:44 INFO - 'PROCESSOR_REVISION': '1e05', 16:29:44 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 16:29:44 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 16:29:44 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 16:29:44 INFO - 'PROGRAMW6432': 'C:\\Program Files', 16:29:44 INFO - 'PROMPT': '$P$G', 16:29:44 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 16:29:44 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 16:29:44 INFO - 'PUBLIC': 'C:\\Users\\Public', 16:29:44 INFO - 'PWD': 'C:\\slave\\test', 16:29:44 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 16:29:44 INFO - 'SLAVEDIR': 'C:\\slave\\', 16:29:44 INFO - 'SYSTEMDRIVE': 'C:', 16:29:44 INFO - 'SYSTEMROOT': 'C:\\windows', 16:29:44 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:29:44 INFO - 'TEST1': 'testie', 16:29:44 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:29:44 INFO - 'USERDOMAIN': 'T-W864-IX-177', 16:29:44 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-177', 16:29:44 INFO - 'USERNAME': 'cltbld', 16:29:44 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-177', 16:29:44 INFO - 'WINDIR': 'C:\\windows', 16:29:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 16:29:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in c:\slave\test\build\venv\lib\site-packages 16:29:44 INFO - Cleaning up... 16:29:44 INFO - Return code: 0 16:29:44 INFO - Running post-action listener: _resource_record_post_action 16:29:44 INFO - Running post-action listener: _start_resource_monitoring 16:29:44 INFO - Starting resource monitoring. 16:29:44 INFO - [mozharness: 2016-10-23 23:29:44.985000Z] Finished create-virtualenv step (success) 16:29:44 INFO - [mozharness: 2016-10-23 23:29:44.985000Z] Running install step. 16:29:44 INFO - Running pre-action listener: _resource_record_pre_action 16:29:44 INFO - Running main action method: install 16:29:44 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 16:29:44 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 16:29:45 INFO - Reading from file tmpfile_stdout 16:29:45 INFO - Using _rmtree_windows ... 16:29:45 INFO - Using _rmtree_windows ... 16:29:45 INFO - Detecting whether we're running mozinstall >=1.0... 16:29:45 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h'] 16:29:45 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h 16:29:45 INFO - Reading from file tmpfile_stdout 16:29:45 INFO - Output received: 16:29:45 INFO - Usage: mozinstall-script.py [options] installer 16:29:45 INFO - Options: 16:29:45 INFO - -h, --help show this help message and exit 16:29:45 INFO - -d DEST, --destination=DEST 16:29:45 INFO - Directory to install application into. [default: 16:29:45 INFO - "C:\slave\test"] 16:29:45 INFO - --app=APP Application being installed. [default: firefox] 16:29:45 INFO - Using _rmtree_windows ... 16:29:45 INFO - Using _rmtree_windows ... 16:29:45 INFO - mkdir: C:\slave\test\build\application 16:29:45 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', 'C:\\slave\\test\\build\\firefox-52.0a1.en-US.win64.zip', '--destination', 'C:\\slave\\test\\build\\application'] 16:29:45 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py C:\slave\test\build\firefox-52.0a1.en-US.win64.zip --destination C:\slave\test\build\application ProcessManager NOT managing child processes 16:29:47 INFO - Reading from file tmpfile_stdout 16:29:47 INFO - Output received: 16:29:47 INFO - C:\slave\test\build\application\firefox\firefox.exe 16:29:47 INFO - Using _rmtree_windows ... 16:29:47 INFO - Using _rmtree_windows ... 16:29:47 INFO - Running post-action listener: _resource_record_post_action 16:29:47 INFO - [mozharness: 2016-10-23 23:29:47.671000Z] Finished install step (success) 16:29:47 INFO - [mozharness: 2016-10-23 23:29:47.671000Z] Running run-tests step. 16:29:47 INFO - Running pre-action listener: _resource_record_pre_action 16:29:47 INFO - Running main action method: run_tests 16:29:47 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version'] 16:29:47 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version 16:29:47 INFO - Python 2.7.3 16:29:47 INFO - Return code: 0 16:29:47 INFO - grabbing minidump binary from tooltool 16:29:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:47 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 0x023EAE90>, '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 0x004EA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0288D520>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1 16:29:47 INFO - Running command: ['c:/mozilla-build/python27/python.exe', 'C:/mozilla-build/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', 'c:\\builds\\relengapi.tok', 'fetch', '-m', 'C:\\slave\\test\\build\\tests\\config/tooltool-manifests/win32/releng.manifest', '-o'] in C:\slave\test\build 16:29:47 INFO - Copy/paste: c:/mozilla-build/python27/python.exe C:/mozilla-build/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file c:\builds\relengapi.tok fetch -m C:\slave\test\build\tests\config/tooltool-manifests/win32/releng.manifest -o 16:29:47 INFO - Calling ['c:/mozilla-build/python27/python.exe', 'C:/mozilla-build/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', 'c:\\builds\\relengapi.tok', 'fetch', '-m', 'C:\\slave\\test\\build\\tests\\config/tooltool-manifests/win32/releng.manifest', '-o'] with output_timeout 600 ProcessManager UNABLE to use job objects to manage child processes 16:29:47 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 16:29:48 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmp5wfm2c 16:29:48 INFO - INFO - File integrity verified, renaming tmp5wfm2c to win32-minidump_stackwalk.exe 16:29:48 INFO - Return code: 0 16:29:48 INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755 16:29:48 INFO - mkdir: C:\slave\test\build\blobber_upload_dir 16:29:48 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir 16:29:48 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe 16:29:48 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir 16:29:48 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dz6qAvbfQEKPBhFsTbJiMQ/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-177', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs_errorsummary.log', '--log-raw=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs_raw.log'] in C:\slave\test\build 16:29:48 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\tests\talos\talos\run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath C:\slave\test\build\application\firefox\firefox --symbolsPath https://queue.taskcluster.net/v1/task/Dz6qAvbfQEKPBhFsTbJiMQ/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip --title T-W864-IX-177 --webServer localhost --log-tbpl-level=debug --log-errorsummary=C:\slave\test\build\blobber_upload_dir\dromaeojs_errorsummary.log --log-raw=C:\slave\test\build\blobber_upload_dir\dromaeojs_raw.log 16:29:48 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 16:29:48 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-177\\AppData\\Roaming', 16:29:48 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 16:29:48 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 16:29:48 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 16:29:48 INFO - 'COMPUTERNAME': 'T-W864-IX-177', 16:29:48 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 16:29:48 INFO - 'DCLOCATION': 'SCL3', 16:29:48 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 16:29:48 INFO - 'FP_NO_HOST_CHECK': 'NO', 16:29:48 INFO - 'HOMEDRIVE': 'C:', 16:29:48 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-177', 16:29:48 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 16:29:48 INFO - 'KTS_VERSION': '1.19c', 16:29:48 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-177\\AppData\\Local', 16:29:48 INFO - 'LOGONSERVER': '\\\\T-W864-IX-177', 16:29:48 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir', 16:29:48 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe', 16:29:48 INFO - 'MONDIR': 'C:\\Monitor_config\\', 16:29:48 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 16:29:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:48 INFO - 'MOZ_NO_REMOTE': '1', 16:29:48 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir', 16:29:48 INFO - 'NO_EM_RESTART': '1', 16:29:48 INFO - 'NUMBER_OF_PROCESSORS': '8', 16:29:48 INFO - 'OS': 'Windows_NT', 16:29:48 INFO - 'OURDRIVE': 'C:', 16:29:48 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 16:29:48 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 16:29:48 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 16:29:48 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 16:29:48 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 16:29:48 INFO - 'PROCESSOR_LEVEL': '6', 16:29:48 INFO - 'PROCESSOR_REVISION': '1e05', 16:29:48 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 16:29:48 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 16:29:48 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 16:29:48 INFO - 'PROGRAMW6432': 'C:\\Program Files', 16:29:48 INFO - 'PROMPT': '$P$G', 16:29:48 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 16:29:48 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 16:29:48 INFO - 'PUBLIC': 'C:\\Users\\Public', 16:29:48 INFO - 'PWD': 'C:\\slave\\test', 16:29:48 INFO - 'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos', 16:29:48 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 16:29:48 INFO - 'SLAVEDIR': 'C:\\slave\\', 16:29:48 INFO - 'SYSTEMDRIVE': 'C:', 16:29:48 INFO - 'SYSTEMROOT': 'C:\\windows', 16:29:48 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:29:48 INFO - 'TEST1': 'testie', 16:29:48 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 16:29:48 INFO - 'USERDOMAIN': 'T-W864-IX-177', 16:29:48 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-177', 16:29:48 INFO - 'USERNAME': 'cltbld', 16:29:48 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-177', 16:29:48 INFO - 'WINDIR': 'C:\\windows', 16:29:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 16:29:48 INFO - Calling ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dz6qAvbfQEKPBhFsTbJiMQ/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-177', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs_errorsummary.log', '--log-raw=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs_raw.log'] with output_timeout 3600 ProcessManager NOT managing child processes ProcessManager UNABLE to use job objects to manage child processes 16:29:49 INFO - mozversion application_buildid: 20161023123006 16:29:49 INFO - mozversion application_changeset: a9a41b69f3f9be494ae0653601c08aa388d9afe4 16:29:49 INFO - mozversion application_display_name: Nightly 16:29:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:29:49 INFO - mozversion application_name: Firefox 16:29:49 INFO - mozversion application_remotingname: firefox 16:29:49 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:29:49 INFO - mozversion application_vendor: Mozilla 16:29:49 INFO - mozversion application_version: 52.0a1 16:29:49 INFO - mozversion platform_buildid: 20161023123006 16:29:49 INFO - mozversion platform_changeset: a9a41b69f3f9be494ae0653601c08aa388d9afe4 16:29:49 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:29:49 INFO - mozversion platform_version: 52.0a1 16:29:49 INFO - using testdate: 1477265389 16:29:49 INFO - actual date: 1477265389 16:29:49 INFO - starting webserver on 'localhost:49273' 16:29:49 INFO - SUITE-START | Running 2 tests 16:29:49 INFO - TEST-START | dromaeo_css 16:29:49 INFO - operating with platform_type : w8_ 16:29:49 INFO - Initialising browser for dromaeo_css test... 16:29:49 INFO - TEST-INFO | started process 2396 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmp8filrx\profile http://localhost:49273/getInfo.html) 16:29:57 INFO - PROCESS | 2396 | __metrics Screen width/height:1600/1200 16:29:57 INFO - PROCESS | 2396 | colorDepth:24 16:29:57 INFO - PROCESS | 2396 | Browser inner width/height: 1010/674 16:29:57 INFO - PROCESS | 2396 | __metrics 16:29:58 INFO - PROCESS | 2396 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:29:58 INFO - PROCESS | 2396 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:29:59 INFO - TEST-INFO | 2396: exit 0 16:29:59 INFO - Browser initialized. 16:29:59 INFO - Running cycle 1/1 for dromaeo_css test... 16:29:59 INFO - TEST-INFO | started process 1328 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmp8filrx\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:30:00 INFO - PROCESS | 1328 | [GFX1-]: Invalid size in UpdateRenderTarget Size(124,0), 0 16:30:11 INFO - PROCESS | 1328 | RSS: Main: 160948224 16:30:11 INFO - PROCESS | 1328 | 16:31:02 INFO - PROCESS | 1328 | 1477265462132 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:33:13 INFO - PROCESS | 1328 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 16:33:16 INFO - PROCESS | 1328 | RSS: Main: 429252608 16:33:16 INFO - PROCESS | 1328 | 16:36:19 INFO - PROCESS | 1328 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 16:36:20 INFO - PROCESS | 1328 | RSS: Main: 227905536 16:36:20 INFO - PROCESS | 1328 | 16:39:22 INFO - PROCESS | 1328 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 16:39:22 INFO - PROCESS | 1328 | RSS: Main: 185012224 16:39:22 INFO - PROCESS | 1328 | 16:42:24 INFO - PROCESS | 1328 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 16:42:25 INFO - PROCESS | 1328 | RSS: Main: 181477376 16:42:25 INFO - PROCESS | 1328 | 16:45:28 INFO - PROCESS | 1328 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 16:45:29 INFO - PROCESS | 1328 | RSS: Main: 167395328 16:45:29 INFO - PROCESS | 1328 | 16:48:31 INFO - PROCESS | 1328 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 16:48:31 INFO - PROCESS | 1328 | RSS: Main: 403070976 16:48:31 INFO - PROCESS | 1328 | 16:48:31 INFO - PROCESS | 1328 | __start_tp_report 16:48:31 INFO - PROCESS | 1328 | _x_x_mozilla_page_load 16:48:31 INFO - PROCESS | 1328 | _x_x_mozilla_page_load_details 16:48:31 INFO - PROCESS | 1328 | |i|pagename|runs| 16:48:31 INFO - PROCESS | 1328 | |0;dojo.html;2875.338672105417;2879.8992035278766;2907.869145888435;2923.1084519221636;2931.574921636363;5197.584193264539;5236.177224459908;5240.9213861792;5249.685018898859;5332.786688532464;5051.6716413433105;5114.488551144884;5219.8434046978555;5229.058769421503;5261.736913154346;4570;4583.152116858375;4596.678232523725;4629.976850115745;4648.442186937572;4618.376519169903;4637.281221410687;4679.438467383901;4690.343351930733;4695.976520117395;4730.455997560273;4733.5739783419485;4740.928886066712;4749.715017098968;4785;4700.106979673851;4721.433427988663;4735.834245801415;4780;4827.8551643450755;4560.794764235618;4580.129775342674;4691.225947718623;4746.335513028179;4752.263399173099;4963.6277279204205;5172.844814655567;5205.791768329263;5213.713245771481;5235.110031294689;5385.515303622654;5505.03661859173;5514.338279406497;5598.524125449342;5616.943830561683;5576.386597474275;5578.86052848678;5621.156826476021;5632.577556683265;5735.598508104435;5039.21892106724;5143;5144.305518754995;5172.301739265226;5203.609729270282;5746.827595172152;5748.971255143698;5754.712264386764;5761.049426844607;5785.768569257182;5469.535089517435;5493.917591236134;5504.2294078829;5514.062609356419;5551.500364967173;5386.003589335985;5432.701201433959;5442.972785136049;5483.040467918178;5605.775768969277;5478.479544443271;5483.917741233885;5487.122060470306;5544.7227638618715;5548.55611551075;5490.945090549043;5497.39528651848;5497.532709719719;5500.4499550044675;5563.944360556424;3571.910702232465;3582.874599389061;3586;3604.5133906922756;3616;3244.3511297740547;3255.5604993326074;3266.1671273825496;3298.802071875695;3313.8343082845763;5275.788968441296;5304.151335786256;5318.122509785842;5318.202269659505;5362.946370536322;5500.092484739973;5533;5544.972275138599;5551.8889622207325;5615.859603509945;5267.841964741064;5303.549198318109;5318.547923426475;5321.547668448148;5348.064088784525;4531.13908357411;4536.432945881765;4537.77311134442;4537.956270057905;4540.160070386989;5661.433856614306;5696.060150075274;5705.74324155414;5711.9714401428555;5715.514181294637;5521.585881059017;5550.9444905552045;5573.331200255995;5577.832665020056;5586.301712285965;5717.22817419643;5717.7712891485535;5726.828195153986;5728;5735.627184233012;5589.636673616202;5594.636348637326;5599.552035837205;5610.438956104357;5613.045782216951;5653.293338332708;5661.122526008476;5680.68756218412;5691.630044047124;5720.056190728483;5535.225068490334;5540.63985840919;5541.889162216814;5548.112302031655;5550.7779688812;5264.763085661078;5355.892882142413;5359.383670877743;5511.338639363302;5512.586556008235;5296.41739408657;5333.306670132858;5337.626366154487;5342.332208473941;5345.893082138257;5337.412884582771;5383.596230282823;5419.430959749169;5440.211169380497;5440.836774896759;5259.763310651107;5374.381946076095;5386.326709161355;5386.7037312946595;5398.568114550905 16:48:31 INFO - PROCESS | 1328 | |1;ext.html;552.8341497550736;572.6792995922286;579.6203486716199;581.1370115378662;593.2821286243645;30598.23504412388;37605.247895042085;37983.620163798354;38878.41682374767;41296.58703412965;39155.804220978855;39616;39732.602673973255;39768.204635907336;39785.40321895174;7415.555066695989;7577.583232922187;8040.43716939813;8209.13804050575;8213.671453141867;9870;10186.185105191604;10292.897071029307;10292.948535257314;10295.176385889112;9813.607455701764;9862.654807081753;9887.752806179831;9971.10260076593;9973.750656233617;7487.812804679872;7664.655090520884;7681.116671582728;9850.802983940317;9984.900150998506;7631.3894888408795;9513.143817056429;9701;9847.261455390875;10099.747506312327;36995.26009479795;37280.44079338812;37325.13374331273;37329.62670373289;37420.43869341962;3072.923176920595;3157.3053928135773;3204.5033019881957;3252.7397808175288;3288.4574045282498;29699.257518561993;29897.25256868574;29915;30076.548851767242;30457.69542304571;3402.2344972381266;3467.7052450541732;3478.89563313101;3545.503629491873;3563.4832949222478;295296;296638.99999999785;296884;296914;298410;48246.5175348249;48557.75721121372;48584.7570762151;48600.75699621479;48650;50880;50971.23543146856;50991.74504127455;51019.489805101475;51061.23408148881;15066.246687665573;15324.624683173903;15335.079895206323;15376;15407.460738874086;11270.21108522412;11482.827757583644;11992.700182495508;12168.452419641137;12214.938925305316;14131.032483178442;14154;14450;14509.564713058626;14522;5599.972000139973;5677.750894803136;5724.4561766632105;5778.913316300259;5788.739506722208;780.1340512031641;870.4081224767219;897.7800438892513;916.0610374366195;927.2350310993457;27012.32469188286;27280.863595681894;27729;27810.721892781217;27957;940.4028441939281;940.6331530703031;968.2834702320232;976.4531862157073;998.9850152247722;14045.71908561823;14435.566932992027;14463.78304325436;14540.709185816437;14589.343479543446;407173;408780;409254;413361;414066;47001.294980575316;47257.52742472531;47404.762976185586;47441.52558474371;47542;1082.2586528228032;1102.7077824376547;1105.6019832860325;1160.1414952934767;1164.336328292865;26051.218463446126;28607.364964013163;28744.13767586976;29108.7089129106;29166.27084322909;40659.390109148975;40770.79614601908;41172.588274116875;41241.793791030854;41309.38035929403;253966;272319;326265;326911;327666;34326.31347372988;35476;35478.29043419169;35506;35520.64479355277;40996.90030996876;41447.37828932508;41641.79179104085;41803.163936720484;42028.94927626834;35323;35912.4613130798;35952.28095438129;35996.64003360038;36305.63694363023;35424.291514169054;35530.46704299489;35757.28485430225;35778.28443431065;35973;33577.328453431284;34050.14874628154;34223.657763422045;34723.4791478123;34780.304393912484;30847.2288192788;33055.50416743703;33125;33139.83430082834;33201.83399082989;23883;24748;24787.25638230856;25076.373090672878;25227.243182703813 16:48:31 INFO - PROCESS | 1328 | |2;jquery.html;322.13828010073047;330.15645026956116;337.20251604954274;337.32871585544774;338.7628659938043;13210.141340812852;14252.287385630729;17101.40145094922;17598.29606815729;18490.2603895844;16768.83231167691;16790.916045419755;17163.82836171638;17240.224189911452;18087;5218.947810521884;5225.137852254383;5271.472852714736;5302.469753024686;5454.263674403965;5167.431582525938;5241.344831896013;5246.658967167122;5250.133727934886;5250.31745873036;6553.344665533432;6867.553609015398;6939.895901561481;6968.268331825161;6975;6752.831179220534;6910.930890691104;6951.200611929617;6960.79117626472;7014.964925175393;6540.607563546202;6742.561733487308;6792.539603985167;6798.150231221098;6798.388145066919;21687.59030663002;22500.21249256268;22926.426839328982;23148.53702925932;23175;2123.4160605833517;2205.2391924785925;2249.4826189976397;2509.8956459158094;2799.8460084695334;13491.66270843227;13493.662658433519;13502.729945401135;14452.349644266033;14691.412343506247;1853.2216469083016;1967.9409617711492;1977.634137684533;1984.8709833860753;2042.5097976485536;83438;84049.57975210146;84643;84650.57674711649;87233.56383218107;15604.375824967101;15725.911263071455;15962.76055859163;16012.199390030451;16027.519174424786;27347.726522734916;27376.58935115975;27383;27387.31531711723;27656.723432765415;9085.364024518352;9355.766105847408;9405.623775048922;9477.620895164255;9524.8571271431;7924.603769811486;7927.801804954807;7942.014496375906;8043.758687239275;8071.717489887826;7886.974693289835;7934.206579342135;7950.721724739722;8000.8799868002025;8028.237317454832;3038.3771326877936;3081.8889060993292;3097.1637657832257;3154.495280755068;3170.904872853772;704.2745971649209;770.8612449759097;814.3281792521194;831.4221615976838;853.8761879527434;16225.837741622432;16832.495025149266;16954.897931634405;17259.654806903793;17369.913150434168;811.3265989229044;853.0999795216106;862.3575436299997;866.9176428239307;913.6893456224915;7567.810804729816;9161.938887230046;9544.42733435996;9557.378770379903;9558.952205239068;393940;395942;396724;417722;420345;91230.54384728166;91929;92871.53564232135;93708;94697.526512367;891.6121487153109;934.514052692596;952.5951470625096;955.8709574207533;956.9186619137452;11957.641270761891;15099.366609055814;15965.441209558074;16087.67824643524;16223.756643650118;35914.46128308025;36902;37032;37210.44184337183;38904.61095389123;48302;50617.493825061276;50775;51571.22643160431;51815.481845181064;7134;7144.428225790318;7259.963700181465;7264.418846492163;7554.546727196166;9355.345125841126;10495;11226.943865280948;11619.128565357463;11804.70488237801;9839.803203936024;10232.386056836614;10343.482825858828;10392.272540922062;10665.626703065356;9840.065193806577;10097.990200980137;10273.434961077213;10323.896761032294;10333;10130.037646423578;10474.507949936793;10514.894851051391;10618.186180661976;10685.786284274427;7093.538919970186;7409.110906691016;7448.441366897396;7513.737019204302;7621.1997740236475;9456.810863782548;10217.642382516577;10267.94866025665;10339.327943683636;10543.886215185476 16:48:31 INFO - PROCESS | 1328 | |3;mootools.html;1219.7804395208864;1238.4550797649033;1294.8899343555797;1479.0386248938196;1491.2990894279699;7181.210066892638;7687.654055567499;7741.071071471424;7742.961285193566;7743.993280873493;6427.35726427357;6612.305707900673;7119.323664251888;7397.593132377717;7526.84946301075;1864.366115520726;1899.420676693608;1900.5913728548428;1902.7906930237664;1904.3620387170315;1882.5575989642423;1890.6124244529908;1905.8284754372103;1906.818852209038;1910.360029390156;1686.7891513560805;1740.4604572582477;1811.6829554827918;1869.8410635096034;1875.634251320993;1866.6826639471321;1881.9341323053627;1883.858710596704;1884.274554296592;1885.453218566614;1924.2687778644026;1984.335247692025;1984.563396052866;1986.771521275043;1989.8408127349778;7463.4029277657655;7541.5475071495885;7546.849063018763;7550.207228241065;7563.810904727371;4374.037711703452;4443.488998765119;4467.888302792424;4500.279955207151;4508.346289787995;2774.1400165948417;2806.789490788199;2911.8107323023937;2919.2409973406857;2922.956155657667;890.7149712092133;901.4456109492614;907.3603109807569;909.2998391238709;919.8758167647349;9979.950100249453;10138.341007834468;10146.340487868265;10177.287589868785;10181.490925453698;3692.8153592320277;3742.6257374262354;3848.114933565296;3852.8266228019806;3874.2445223181207;7797.259260370256;8018.358531317481;8538.146185381413;8635.266002389742;8636.654533818702;4330.480342358874;4464.553544645574;4464.955350446519;4467.084247729208;4484.753338566345;4213.2837417639075;4215.936760948588;4216.51510076339;4218.367244913287;4229.069604686964;3109.9067027989195;3189.2824114574037;3190.9788867562156;3294.5552350432863;3296.4396052671104;952.7094236258008;955.9091886270793;958;967.7241986033946;970.1608108985818;667.4660271782554;684.9520533562702;722.6134018300289;764.9196834332427;770.7841804294807;4962.280469331927;4977.303177555145;5085;5104.515071068243;5197.870053248699;816.3550794871985;830.4519017448575;834.3116928533984;834.3617132893341;834.4367551902442;3296.967030329714;3422.1615704152146;3521.6830485255937;3528.2061536154674;3593.9101522461624;8855.070217627184;9081.228095611816;9199.816003679889;9241.21449676785;9243.953780231055;8862.335324850534;9069.546522673973;9137.08629137081;9173.58718857653;9182.357234993486;7044.542104763276;7143.4999550031;7185.461090418239;7185.784426467214;7206.603636799921;4924.064427758714;4977.452480227244;5022.899542009066;5027.069992051483;5187.481251874933;8545.487270763773;8626.223639872442;8706.3034957202;8718;8743.737687869374;8640.524771137647;8914.821703566022;8957.955210223907;9015.909840901508;9043.819123617623;6184.288806787277;6244.0321750128805;6244.812655620339;6963.512554121366;7245.275472452712;7181.281871812777;7334.119905611361;7418.591977441292;7434.851302973802;7450.143233527997;6660.733570657119;6784.253732089565;6851;6872;6925.68834402443;6752.088468056946;6768.661566921733;6784.253732089565;6822.658867056726;6831.863362732817;5817.883642327045;5865;5892;5892.5285977122585;5899.085641725539;4152.958470415258;4385.144896745232;4390.253656878274;4459.885028742814;4463.397441345507;4205.264078786261;4231.597998190167;4235.2588297048505;4270.935935961025;4301.784910754387 16:48:31 INFO - PROCESS | 1328 | |4;prototype.html;283.1082091412053;286.2671560804341;292.5202667625095;292.71898976982095;293.1717896941139;5196.636235463519;5201.973990130044;5213.973930130353;5232.555232805212;5238.319018527591;5122.6926384416965;5141.280220769096;5157.458466860972;5164.819231326905;5168.250603662466;3662.359087159743;3759.774413535183;3770.490983717204;3778.3564149595013;3787.9431808522895;3761.4733937248807;3787.394016957274;3812.82842272097;3874.2057878135056;3923.6861051115984;3844.827672365119;3865.188310454808;3872.1481274119787;3903.590123037083;3925.548561915388;3790.886273411802;3859.749116307431;3861.4787003754695;3863;3864.516935383091;3373.4939759036097;3393.423118069934;3396.813175275359;3399.1162297802503;3402.8468718907707;4989.476105008995;5032.547070763612;5052.722100284483;5056.115179843549;5062.848114556569;4506.4817545982305;4529.942288954942;4535.750533720644;4564.657650676212;4574.908501829978;5254.185601231777;5385.811496597639;5387.757550910218;5396;5408.4050754416985;3700;3737.9439308410397;3752.6434988676033;3759.342115129841;3767.7378078343786;5579.939811435815;5596.138664321646;5606.579506536985;5625.887482250373;5626.9437305626825;3632.1282892105705;3775.7923314217983;3794.848206071726;3804.1630841214887;3813.542374915028;3855.978165786069;3867.497225360685;3875.0699832040673;3880.8447662093763;3925.666318362914;4455.420795296591;4469.910601787946;4480.417545719036;4488.4165058542185;4489.441018619421;5177.197534382177;5337.19942008694;5379.004884096455;5393.352797664305;5440.401555828856;1332.4137379552965;1332.9333533323295;1339.3370281710615;1341.3561490484622;1344.4740219850344;824.575343697996;841.5287439034161;845.8477474054729;858.013284722574;866.6230189867427;5104.967076009911;5223.190405487156;5255.737213139328;5368.677879327252;5372.973135134377;5584.497395234367;5595.160725891067;5612.1581762735095;5623.409541998031;5625.353084395265;5220.791168353299;5374.560281419895;5383.515483606494;5395.487428694268;5395.838124856261;2900.912972610825;2937.4418860416454;2950.498415269409;2966.857759762464;2969.198316454545;5687.431256874363;5701.629394089454;5721.742521586539;5728.684922329312;5742.913856292159;5356.250124982505;5587.804426845041;5621.98804215237;5623.822540264738;5627.915581266202;5697.487226149667;5723.399043100415;5729.656220626775;5733.483986441157;5742.425757424307;5237.16205407133;5572.637778544382;5576.414476480073;5588.189712491747;5590.189422533791;5418.403975562764;5478.506934375925;5480.314960629921;5496.80761173357;5501.972490137684;5767.538596912321;5772.278465191851;5777.7977770777825;5787.334456537552;5793.246877905845;3631.3463576556474;3667.6149004355225;3702.4816525686965;3725.7578257414266;3736.327461056927;5626.127950167731;5628.493435590816;5637.661740295595;5647.237622920853;5678.971605141948;5461.890762184814;5495.587830912617;5496.477834605706;5497.780088796563;5512.5589952804485;5296.443873393238;5337.306150200449;5416.241726158262;5452.945470545244;5471;5370.818419947605;5376.843978544632;5395.974764794676;5396.7571459283645;5416.4041955385665;5296.788128474818;5309.327561818015;5416.37711663148;5481.808136715196;5485.9725701371235;5381.67709937405;5387.542058924879;5398.082326004667;5406.324209473816;5415.810446634349 16:48:31 INFO - PROCESS | 1328 | |5;yui.html;643.3212960326855;698.1970733656298;700.8353037036295;700.9053777740007;730.7807657702688;12953.676158096041;13830.861691383096;13842.65393365165;13850.792238116437;13867.237301948415;12760.680982975407;13604.795928061063;13621.727565448686;13635;13641.113327633697;634.6192284629209;649.1949982022282;649.8277956341574;651.7816531461966;651.9445847103002;550.8980838544862;563.1018525451918;647.8704259148166;661.0876989754132;663.4692246203042;696.1750325863842;698.9545679530814;699.7166147710185;699.9326027807608;701.8876979683251;688.2257460357098;688.6935313785367;689.4932224814758;689.8792711275506;690.837653151509;423.9745615263094;428.6399424483418;429.39026582253274;430.59093860832337;431.22810169796026;12953.546625868144;13307.733845323137;13347.799783003165;13376.264305463195;13389.933050334783;13486.39311230997;13885.722285554333;14025.579232623038;14026.789598155934;14268.85731142696;10965.287256328313;11148.163887708455;11566.363849988247;11622.94188529052;11701.590444334493;3393.6776006279365;3444.4661077533024;3448.8792892248653;3455.775374600668;3502.1069627245142;66637.66681166612;66869.32522699086;66932.6653366735;67645.3235467644;68106.65946670284;9908.752281193028;10149.188064954786;10265.846012309821;10459.320144190604;10494.580216791395;17702.911485442746;17732.91133544324;17737;17767.911160444375;17771;7096.858062838714;7119.608421536762;7126.966589844444;7161.355478007004;7338.082739657543;3986.322325204664;4017;4042.656374208166;4086.1214838809797;4106.691998100155;2871.224769312274;3016.2007068126964;3026.9545956810666;3031.1512776422637;3041.2396900774806;501.5235526250077;505.2068252843001;507.4620901844057;515.6210185513645;518.245952139636;561.2899681902396;578.5487319890492;615.8922188616974;657.9703913323912;672.6939242644585;8402.201790829862;8804;8840.646374144962;8862.158094980967;9423.952880235554;571.817018554067;599.6701814002369;617.8671585609115;643.2377632505496;651.495091304243;4020.6984476164403;4363.978180109143;4749.905001899942;4901.803927842846;4914.655974081851;91509;93155.5342223298;96188;96874;96970;83770;84409.57795210984;84824.57587712146;85898.57050714831;86135.13864861397;74975.62512187513;75028.62485687537;75150.62424687842;75760.24239757642;75843.24156758472;8749.16882896124;8855.203031727175;8873.112688731075;8916.55417229149;9035.27717782589;43508.782456087516;44364.33453498135;44631.55368446404;45391;45991.31013034874;59250.70374648099;65356.673216635514;66413.66793166003;66718.9921511777;67488.32511674821;11672.241304315192;11823.70440738954;11887.227330223508;12000.279983201035;12470.625881223577;13922.651933701738;14016.29918504091;14381.9280903599;14451.27743612794;14712.926435367755;12008.939955300168;12088.879111208775;12162.878371216175;12274.447649855956;12458.377081146087;12880.935595321964;13367.465301387836;13596;13735.175889446666;13941.024128311326;12776.169548979287;13231.3384330785;13386.995975301697;13457.865421345661;13954.162750235018;10586.523606437575;10680;11026;11227.043621473007;11549.595764148215;9880.555375008285;10715.017721721506;11066.557337706723;11089.5564177432;11246.831297530707 16:48:31 INFO - PROCESS | 1328 | __end_tp_report 16:48:31 INFO - PROCESS | 1328 | __start_cc_report 16:48:31 INFO - PROCESS | 1328 | _x_x_mozilla_cycle_collect,3158 16:48:31 INFO - PROCESS | 1328 | __end_cc_report 16:48:31 INFO - PROCESS | 1328 | __startTimestamp1477266511882__endTimestamp 16:48:31 INFO - PROCESS | 1328 | 16:48:31 INFO - PROCESS | 1328 | ------- Summary: start ------- 16:48:31 INFO - PROCESS | 1328 | Number of tests: 6 16:48:31 INFO - PROCESS | 1328 | 16:48:31 INFO - PROCESS | 1328 | [#0] dojo.html Cycles:165 Average:5117.10 Median:5355.89 stddev:689.24 (12.9%) stddev-sans-first:668.54 16:48:31 INFO - PROCESS | 1328 | Values: 2875.3 2879.9 2907.9 2923.1 2931.6 5197.6 5236.2 5240.9 5249.7 5332.8 5051.7 5114.5 5219.8 5229.1 5261.7 4570.0 4583.2 4596.7 4630.0 4648.4 4618.4 4637.3 4679.4 4690.3 4696.0 4730.5 4733.6 4740.9 4749.7 4785.0 4700.1 4721.4 4735.8 4780.0 4827.9 4560.8 4580.1 4691.2 4746.3 4752.3 4963.6 5172.8 5205.8 5213.7 5235.1 5385.5 5505.0 5514.3 5598.5 5616.9 5576.4 5578.9 5621.2 5632.6 5735.6 5039.2 5143.0 5144.3 5172.3 5203.6 5746.8 5749.0 5754.7 5761.0 5785.8 5469.5 5493.9 5504.2 5514.1 5551.5 5386.0 5432.7 5443.0 5483.0 5605.8 5478.5 5483.9 5487.1 5544.7 5548.6 5490.9 5497.4 5497.5 5500.4 5563.9 3571.9 3582.9 3586.0 3604.5 3616.0 3244.4 3255.6 3266.2 3298.8 3313.8 5275.8 5304.2 5318.1 5318.2 5362.9 5500.1 5533.0 5545.0 5551.9 5615.9 5267.8 5303.5 5318.5 5321.5 5348.1 4531.1 4536.4 4537.8 4538.0 4540.2 5661.4 5696.1 5705.7 5712.0 5715.5 5521.6 5550.9 5573.3 5577.8 5586.3 5717.2 5717.8 5726.8 5728.0 5735.6 5589.6 5594.6 5599.6 5610.4 5613.0 5653.3 5661.1 5680.7 5691.6 5720.1 5535.2 5540.6 5541.9 5548.1 5550.8 5264.8 5355.9 5359.4 5511.3 5512.6 5296.4 5333.3 5337.6 5342.3 5345.9 5337.4 5383.6 5419.4 5440.2 5440.8 5259.8 5374.4 5386.3 5386.7 5398.6 16:48:31 INFO - PROCESS | 1328 | 16:48:31 INFO - PROCESS | 1328 | [#1] ext.html Cycles:180 Average:48737.43 Median:35845.37 stddev:89749.97 (250.4%) stddev-sans-first:89928.83 16:48:31 INFO - PROCESS | 1328 | Values: 552.8 572.7 579.6 581.1 593.3 30598.2 37605.2 37983.6 38878.4 41296.6 39155.8 39616.0 39732.6 39768.2 39785.4 7415.6 7577.6 8040.4 8209.1 8213.7 9870.0 10186.2 10292.9 10292.9 10295.2 9813.6 9862.7 9887.8 9971.1 9973.8 7487.8 7664.7 7681.1 9850.8 9984.9 7631.4 9513.1 9701.0 9847.3 10099.7 36995.3 37280.4 37325.1 37329.6 37420.4 3072.9 3157.3 3204.5 3252.7 3288.5 29699.3 29897.3 29915.0 30076.5 30457.7 3402.2 3467.7 3478.9 3545.5 3563.5 295296.0 296639.0 296884.0 296914.0 298410.0 48246.5 48557.8 48584.8 48600.8 48650.0 50880.0 50971.2 50991.7 51019.5 51061.2 15066.2 15324.6 15335.1 15376.0 15407.5 11270.2 11482.8 11992.7 12168.5 12214.9 14131.0 14154.0 14450.0 14509.6 14522.0 5600.0 5677.8 5724.5 5778.9 5788.7 780.1 870.4 897.8 916.1 927.2 27012.3 27280.9 27729.0 27810.7 27957.0 940.4 940.6 968.3 976.5 999.0 14045.7 14435.6 14463.8 14540.7 14589.3 407173.0 408780.0 409254.0 413361.0 414066.0 47001.3 47257.5 47404.8 47441.5 47542.0 1082.3 1102.7 1105.6 1160.1 1164.3 26051.2 28607.4 28744.1 29108.7 29166.3 40659.4 40770.8 41172.6 41241.8 41309.4 253966.0 272319.0 326265.0 326911.0 327666.0 34326.3 35476.0 35478.3 35506.0 35520.6 40996.9 41447.4 41641.8 41803.2 42028.9 35323.0 35912.5 35952.3 35996.6 36305.6 35424.3 35530.5 35757.3 35778.3 35973.0 33577.3 34050.1 34223.7 34723.5 34780.3 30847.2 33055.5 33125.0 33139.8 33201.8 23883.0 24748.0 24787.3 25076.4 25227.2 16:48:31 INFO - PROCESS | 1328 | 16:48:31 INFO - PROCESS | 1328 | [#2] jquery.html Cycles:180 Average:26616.56 Median:234323.50 stddev:67337.46 (28.7%) stddev-sans-first:67497.42 16:48:31 INFO - PROCESS | 1328 | Values: 322.1 330.2 337.2 337.3 338.8 13210.1 14252.3 17101.4 17598.3 18490.3 16768.8 16790.9 17163.8 17240.2 18087.0 5218.9 5225.1 5271.5 5302.5 5454.3 5167.4 5241.3 5246.7 5250.1 5250.3 6553.3 6867.6 6939.9 6968.3 6975.0 6752.8 6910.9 6951.2 6960.8 7015.0 6540.6 6742.6 6792.5 6798.2 6798.4 21687.6 22500.2 22926.4 23148.5 23175.0 2123.4 2205.2 2249.5 2509.9 2799.8 13491.7 13493.7 13502.7 14452.3 14691.4 1853.2 1967.9 1977.6 1984.9 2042.5 83438.0 84049.6 84643.0 84650.6 87233.6 15604.4 15725.9 15962.8 16012.2 16027.5 27347.7 27376.6 27383.0 27387.3 27656.7 9085.4 9355.8 9405.6 9477.6 9524.9 7924.6 7927.8 7942.0 8043.8 8071.7 7887.0 7934.2 7950.7 8000.9 8028.2 3038.4 3081.9 3097.2 3154.5 3170.9 704.3 770.9 814.3 831.4 853.9 16225.8 16832.5 16954.9 17259.7 17369.9 811.3 853.1 862.4 866.9 913.7 7567.8 9161.9 9544.4 9557.4 9559.0 393940.0 395942.0 396724.0 417722.0 420345.0 91230.5 91929.0 92871.5 93708.0 94697.5 891.6 934.5 952.6 955.9 956.9 11957.6 15099.4 15965.4 16087.7 16223.8 35914.5 36902.0 37032.0 37210.4 38904.6 48302.0 50617.5 50775.0 51571.2 51815.5 7134.0 7144.4 7260.0 7264.4 7554.5 9355.3 10495.0 11226.9 11619.1 11804.7 9839.8 10232.4 10343.5 10392.3 10665.6 9840.1 10098.0 10273.4 10323.9 10333.0 10130.0 10474.5 10514.9 10618.2 10685.8 7093.5 7409.1 7448.4 7513.7 7621.2 9456.8 10217.6 10267.9 10339.3 10543.9 16:48:31 INFO - PROCESS | 1328 | 16:48:31 INFO - PROCESS | 1328 | [#3] mootools.html Cycles:180 Average:4899.63 Median:5878.50 stddev:2805.15 (47.7%) stddev-sans-first:2799.39 16:48:31 INFO - PROCESS | 1328 | Values: 1219.8 1238.5 1294.9 1479.0 1491.3 7181.2 7687.7 7741.1 7743.0 7744.0 6427.4 6612.3 7119.3 7397.6 7526.8 1864.4 1899.4 1900.6 1902.8 1904.4 1882.6 1890.6 1905.8 1906.8 1910.4 1686.8 1740.5 1811.7 1869.8 1875.6 1866.7 1881.9 1883.9 1884.3 1885.5 1924.3 1984.3 1984.6 1986.8 1989.8 7463.4 7541.5 7546.8 7550.2 7563.8 4374.0 4443.5 4467.9 4500.3 4508.3 2774.1 2806.8 2911.8 2919.2 2923.0 890.7 901.4 907.4 909.3 919.9 9980.0 10138.3 10146.3 10177.3 10181.5 3692.8 3742.6 3848.1 3852.8 3874.2 7797.3 8018.4 8538.1 8635.3 8636.7 4330.5 4464.6 4465.0 4467.1 4484.8 4213.3 4215.9 4216.5 4218.4 4229.1 3109.9 3189.3 3191.0 3294.6 3296.4 952.7 955.9 958.0 967.7 970.2 667.5 685.0 722.6 764.9 770.8 4962.3 4977.3 5085.0 5104.5 5197.9 816.4 830.5 834.3 834.4 834.4 3297.0 3422.2 3521.7 3528.2 3593.9 8855.1 9081.2 9199.8 9241.2 9244.0 8862.3 9069.5 9137.1 9173.6 9182.4 7044.5 7143.5 7185.5 7185.8 7206.6 4924.1 4977.5 5022.9 5027.1 5187.5 8545.5 8626.2 8706.3 8718.0 8743.7 8640.5 8914.8 8958.0 9015.9 9043.8 6184.3 6244.0 6244.8 6963.5 7245.3 7181.3 7334.1 7418.6 7434.9 7450.1 6660.7 6784.3 6851.0 6872.0 6925.7 6752.1 6768.7 6784.3 6822.7 6831.9 5817.9 5865.0 5892.0 5892.5 5899.1 4153.0 4385.1 4390.3 4459.9 4463.4 4205.3 4231.6 4235.3 4270.9 4301.8 16:48:31 INFO - PROCESS | 1328 | 16:48:31 INFO - PROCESS | 1328 | [#4] prototype.html Cycles:180 Average:4518.66 Median:5254.96 stddev:1382.65 (26.3%) stddev-sans-first:1349.49 16:48:31 INFO - PROCESS | 1328 | Values: 283.1 286.3 292.5 292.7 293.2 5196.6 5202.0 5214.0 5232.6 5238.3 5122.7 5141.3 5157.5 5164.8 5168.3 3662.4 3759.8 3770.5 3778.4 3787.9 3761.5 3787.4 3812.8 3874.2 3923.7 3844.8 3865.2 3872.1 3903.6 3925.5 3790.9 3859.7 3861.5 3863.0 3864.5 3373.5 3393.4 3396.8 3399.1 3402.8 4989.5 5032.5 5052.7 5056.1 5062.8 4506.5 4529.9 4535.8 4564.7 4574.9 5254.2 5385.8 5387.8 5396.0 5408.4 3700.0 3737.9 3752.6 3759.3 3767.7 5579.9 5596.1 5606.6 5625.9 5626.9 3632.1 3775.8 3794.8 3804.2 3813.5 3856.0 3867.5 3875.1 3880.8 3925.7 4455.4 4469.9 4480.4 4488.4 4489.4 5177.2 5337.2 5379.0 5393.4 5440.4 1332.4 1332.9 1339.3 1341.4 1344.5 824.6 841.5 845.8 858.0 866.6 5105.0 5223.2 5255.7 5368.7 5373.0 5584.5 5595.2 5612.2 5623.4 5625.4 5220.8 5374.6 5383.5 5395.5 5395.8 2900.9 2937.4 2950.5 2966.9 2969.2 5687.4 5701.6 5721.7 5728.7 5742.9 5356.3 5587.8 5622.0 5623.8 5627.9 5697.5 5723.4 5729.7 5733.5 5742.4 5237.2 5572.6 5576.4 5588.2 5590.2 5418.4 5478.5 5480.3 5496.8 5502.0 5767.5 5772.3 5777.8 5787.3 5793.2 3631.3 3667.6 3702.5 3725.8 3736.3 5626.1 5628.5 5637.7 5647.2 5679.0 5461.9 5495.6 5496.5 5497.8 5512.6 5296.4 5337.3 5416.2 5452.9 5471.0 5370.8 5376.8 5396.0 5396.8 5416.4 5296.8 5309.3 5416.4 5481.8 5486.0 5381.7 5387.5 5398.1 5406.3 5415.8 16:48:31 INFO - PROCESS | 1328 | 16:48:31 INFO - PROCESS | 1328 | [#5] yui.html Cycles:180 Average:18299.05 Median:24364.16 stddev:25506.83 (104.7%) stddev-sans-first:25543.93 16:48:31 INFO - PROCESS | 1328 | Values: 643.3 698.2 700.8 700.9 730.8 12953.7 13830.9 13842.7 13850.8 13867.2 12760.7 13604.8 13621.7 13635.0 13641.1 634.6 649.2 649.8 651.8 651.9 550.9 563.1 647.9 661.1 663.5 696.2 699.0 699.7 699.9 701.9 688.2 688.7 689.5 689.9 690.8 424.0 428.6 429.4 430.6 431.2 12953.5 13307.7 13347.8 13376.3 13389.9 13486.4 13885.7 14025.6 14026.8 14268.9 10965.3 11148.2 11566.4 11622.9 11701.6 3393.7 3444.5 3448.9 3455.8 3502.1 66637.7 66869.3 66932.7 67645.3 68106.7 9908.8 10149.2 10265.8 10459.3 10494.6 17702.9 17732.9 17737.0 17767.9 17771.0 7096.9 7119.6 7127.0 7161.4 7338.1 3986.3 4017.0 4042.7 4086.1 4106.7 2871.2 3016.2 3027.0 3031.2 3041.2 501.5 505.2 507.5 515.6 518.2 561.3 578.5 615.9 658.0 672.7 8402.2 8804.0 8840.6 8862.2 9424.0 571.8 599.7 617.9 643.2 651.5 4020.7 4364.0 4749.9 4901.8 4914.7 91509.0 93155.5 96188.0 96874.0 96970.0 83770.0 84409.6 84824.6 85898.6 86135.1 74975.6 75028.6 75150.6 75760.2 75843.2 8749.2 8855.2 8873.1 8916.6 9035.3 43508.8 44364.3 44631.6 45391.0 45991.3 59250.7 65356.7 66413.7 66719.0 67488.3 11672.2 11823.7 11887.2 12000.3 12470.6 13922.7 14016.3 14381.9 14451.3 14712.9 12008.9 12088.9 12162.9 12274.4 12458.4 12880.9 13367.5 13596.0 13735.2 13941.0 12776.2 13231.3 13387.0 13457.9 13954.2 10586.5 10680.0 11026.0 11227.0 11549.6 9880.6 10715.0 11066.6 11089.6 11246.8 16:48:31 INFO - PROCESS | 1328 | -------- Summary: end -------- 16:48:31 INFO - PROCESS | 1328 | 16:48:32 INFO - TEST-INFO | 1328: exit 0 16:48:33 INFO - TEST-OK | dromaeo_css | took 1123647ms 16:48:33 INFO - TEST-START | kraken 16:48:33 INFO - operating with platform_type : w8_ 16:48:33 INFO - Initialising browser for kraken test... 16:48:33 INFO - TEST-INFO | started process 2112 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpji9pxb\profile http://localhost:49273/getInfo.html) 16:48:38 INFO - PROCESS | 2112 | __metrics Screen width/height:1600/1200 16:48:38 INFO - PROCESS | 2112 | colorDepth:24 16:48:38 INFO - PROCESS | 2112 | Browser inner width/height: 1010/674 16:48:38 INFO - PROCESS | 2112 | __metrics 16:48:39 INFO - PROCESS | 2112 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:48:39 INFO - PROCESS | 2112 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:48:39 INFO - PROCESS | 2112 | console.error: 16:48:39 INFO - PROCESS | 2112 | Message: Error: Connection closed before committing the transaction. 16:48:39 INFO - PROCESS | 2112 | Stack: 16:48:39 INFO - PROCESS | 2112 | ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:937:23 16:48:39 INFO - PROCESS | 2112 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7 16:48:39 INFO - PROCESS | 2112 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11 16:48:39 INFO - PROCESS | 2112 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7 16:48:39 INFO - PROCESS | 2112 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:714:7 16:48:39 INFO - PROCESS | 2112 | TaskImpl_run@resource://gre/modules/Task.jsm:327:15 16:48:39 INFO - PROCESS | 2112 | Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:551:9 16:48:39 INFO - PROCESS | 2112 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15 16:48:39 INFO - PROCESS | 2112 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:388:5 16:48:39 INFO - PROCESS | 2112 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29 16:48:39 INFO - PROCESS | 2112 | Barrier/this.client.addBlocker/promise13.5% 16:49:36 INFO - TinderboxPrint: I/O read bytes / time
232,707,072 / 2,272,240 16:49:36 INFO - TinderboxPrint: I/O write bytes / time
408,913,408 / 3,488,360 16:49:36 INFO - TinderboxPrint: CPU idle
8,249.6 (86.5%) 16:49:36 INFO - TinderboxPrint: CPU user
1,228.5 (12.9%) 16:49:36 INFO - install - Wall time: 3s; CPU: 11.0%; Read bytes: 0; Write bytes: 34822144; Read time: 0; Write time: 88130 16:49:36 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 232707072; Write bytes: 318398464; Read time: 2272240; Write time: 3343110 16:49:37 INFO - Running post-run listener: _upload_blobber_files 16:49:37 INFO - Blob upload gear active. 16:49:37 INFO - Preparing to upload files from C:\slave\test\build\blobber_upload_dir. 16:49:37 INFO - Files from C:\slave\test\build\blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:49:37 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', 'Fx-Team', '-d', 'C:\\slave\\test\\build\\blobber_upload_dir', '--output-manifest', 'C:\\slave\\test\\build\\uploaded_files.json'] 16:49:37 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 Fx-Team -d C:\slave\test\build\blobber_upload_dir --output-manifest C:\slave\test\build\uploaded_files.json 16:49:37 INFO - (blobuploader) - INFO - Open directory for files ... 16:49:37 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_errorsummary.log ... 16:49:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:49:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:49:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:49:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:49:38 INFO - (blobuploader) - INFO - Done attempting. 16:49:38 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_raw.log ... 16:49:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:49:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:49:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:49:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:49:39 INFO - (blobuploader) - INFO - Done attempting. 16:49:39 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\resource-usage.json ... 16:49:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:49:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:49:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:49:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:49:41 INFO - (blobuploader) - INFO - Done attempting. 16:49:41 INFO - (blobuploader) - INFO - Iteration through files over. 16:49:41 INFO - Return code: 0 16:49:41 INFO - rmtree: C:\slave\test\build\uploaded_files.json 16:49:41 INFO - Using _rmtree_windows ... 16:49:41 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build\\uploaded_files.json',), kwargs: {}, attempt #1 16:49:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fe86007aff00a9ac8ae4bc36f4448f390822b334f6adf523a72ce7bdfabd4e953dc1dcefb8859328016dfe7c4ab3ea5f0592261592c98f62bcacfbeea5833172", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e1ac29434fac5bf070831b1ce632a464d488d71a147b9d08a274ec628bc0fb2414d78eceb4703ea9f63be22634de0cf32b38bb3dc5a7e1653b4919dbdd1d8a0b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/57e934ed8fbe9d91933a4d9aae40af4088997b71942bda2647ddcaba75d89cd6a34a9b407c3c1d86a318869d5d6d715ab957520a564263539ab6a8bedfcf204e"} 16:49:41 INFO - Writing buildbot properties ['blobber_files'] to C:\slave\test\properties\blobber_files 16:49:41 INFO - Writing to file C:\slave\test\properties\blobber_files 16:49:41 INFO - Contents: 16:49:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fe86007aff00a9ac8ae4bc36f4448f390822b334f6adf523a72ce7bdfabd4e953dc1dcefb8859328016dfe7c4ab3ea5f0592261592c98f62bcacfbeea5833172", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e1ac29434fac5bf070831b1ce632a464d488d71a147b9d08a274ec628bc0fb2414d78eceb4703ea9f63be22634de0cf32b38bb3dc5a7e1653b4919dbdd1d8a0b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/57e934ed8fbe9d91933a4d9aae40af4088997b71942bda2647ddcaba75d89cd6a34a9b407c3c1d86a318869d5d6d715ab957520a564263539ab6a8bedfcf204e"} 16:49:41 INFO - Running post-run listener: copy_logs_to_upload_dir 16:49:41 INFO - Copying logs to upload dir... 16:49:41 INFO - mkdir: C:\slave\test\build\upload\logs 16:49:41 INFO - Copying logs to upload dir... 16:49:41 INFO - Using _rmtree_windows ... 16:49:41 INFO - Using _rmtree_windows ... 16:49:41 INFO - Using _rmtree_windows ... 16:49:41 INFO - Using _rmtree_windows ... 16:49:41 INFO - Using _rmtree_windows ... 16:49:41 INFO - Using _rmtree_windows ... 16:49:42 INFO - Using _rmtree_windows ... program finished with exit code 0 elapsedTime=1387.151000 ========= master_lag: 0.35 ========= ========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 7 secs) (at 2016-10-23 16:49:42.010532) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-23 16:49:42.016573) ========= '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-177\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-177 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-177 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-177\AppData\Local LOGONSERVER=\\T-W864-IX-177 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-177 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-177 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-177 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fe86007aff00a9ac8ae4bc36f4448f390822b334f6adf523a72ce7bdfabd4e953dc1dcefb8859328016dfe7c4ab3ea5f0592261592c98f62bcacfbeea5833172", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e1ac29434fac5bf070831b1ce632a464d488d71a147b9d08a274ec628bc0fb2414d78eceb4703ea9f63be22634de0cf32b38bb3dc5a7e1653b4919dbdd1d8a0b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/57e934ed8fbe9d91933a4d9aae40af4088997b71942bda2647ddcaba75d89cd6a34a9b407c3c1d86a318869d5d6d715ab957520a564263539ab6a8bedfcf204e"} build_url:https://queue.taskcluster.net/v1/task/Dz6qAvbfQEKPBhFsTbJiMQ/artifacts/public/build/firefox-52.0a1.en-US.win64.zip program finished with exit code 0 elapsedTime=0.102000 build_url: 'https://queue.taskcluster.net/v1/task/Dz6qAvbfQEKPBhFsTbJiMQ/artifacts/public/build/firefox-52.0a1.en-US.win64.zip' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fe86007aff00a9ac8ae4bc36f4448f390822b334f6adf523a72ce7bdfabd4e953dc1dcefb8859328016dfe7c4ab3ea5f0592261592c98f62bcacfbeea5833172", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e1ac29434fac5bf070831b1ce632a464d488d71a147b9d08a274ec628bc0fb2414d78eceb4703ea9f63be22634de0cf32b38bb3dc5a7e1653b4919dbdd1d8a0b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/57e934ed8fbe9d91933a4d9aae40af4088997b71942bda2647ddcaba75d89cd6a34a9b407c3c1d86a318869d5d6d715ab957520a564263539ab6a8bedfcf204e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-23 16:49:42.137369) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 16:49:42.137695) ========= '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-177\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-177 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-177 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-177\AppData\Local LOGONSERVER=\\T-W864-IX-177 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-177 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-177 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-177 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=0.102000 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 16:49:42.256972) ========= ========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-10-23 16:49:42.257301) ========= ========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-10-23 16:49:42.636213) ========= ========= Total master_lag: 0.64 =========