builder: fx-team_win8_64_test-dromaeojs-pgo slave: t-w864-ix-231 starttime: 1476944803.67 results: success (0) buildid: 20161019213008 builduid: 6f46793ffb224841b328bdbaf3a7682f revision: 998ad5a74da80fe63664a8dcf30d8f269ffe4e65 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 23:26:43.672372) ========= master: http://buildbot-master127.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 23:26:43.672840) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 23:26:43.673119) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 23:26:43.813237) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-19 23:26:43.813621) ========= '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-231\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-231 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-231 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-231\AppData\Local LOGONSERVER=\\T-W864-IX-231 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-231 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-231 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-231 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False --23:26:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py => `archiver_client.py' Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. WARNING: Certificate verification error for hg.mozilla.org: certificate signature failure HTTP request sent, awaiting response... 200 Script output follows Length: 12,179 (12K) [text/x-python] 0K .......... . 100% 9.68 MB/s 23:26:45 (9.68 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=1.158000 ========= master_lag: 0.13 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-19 23:26:45.099081) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-10-19 23:26:45.099420) ========= '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-231\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-231 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-231 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-231\AppData\Local LOGONSERVER=\\T-W864-IX-231 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-231 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-231 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-231 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=2.608000 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-10-19 23:26:47.726190) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-19 23:26:47.726556) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo integration/fx-team --rev 998ad5a74da80fe63664a8dcf30d8f269ffe4e65 --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 998ad5a74da80fe63664a8dcf30d8f269ffe4e65 --destination scripts --debug'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-231\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-231 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-231 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-231\AppData\Local LOGONSERVER=\\T-W864-IX-231 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-231 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-231 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-231 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 2016-10-19 23:26:48,081 truncating revision to first 12 chars 2016-10-19 23:26:48,081 Setting DEBUG logging. 2016-10-19 23:26:48,081 attempt 1/10 2016-10-19 23:26:48,081 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/998ad5a74da8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-19 23:26:48,509 unpacking tar archive at: fx-team-998ad5a74da8/testing/mozharness/ 2016-10-19 23:26:48,678 skipping symlink on windows: configs/single_locale/linux32.py program finished with exit code 0 elapsedTime=1.098000 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-19 23:26:48.907726) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 23:26:48.908004) ========= script_repo_revision: 998ad5a74da80fe63664a8dcf30d8f269ffe4e65 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 23:26:48.908391) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 23:26:48.908659) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 23:26:48.926386) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 22 mins, 21 secs) (at 2016-10-19 23:26:48.926662) ========= '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-231\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-231 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-231 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-231\AppData\Local LOGONSERVER=\\T-W864-IX-231 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-231 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-231 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-231 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 23:26:49 INFO - MultiFileLogger online at 20161019 23:26:49 in C:\slave\test 23:26:49 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 23:26:49 INFO - Dumping config to C:\slave\test\logs\localconfig.json. 23:26:49 INFO - {'append_to_log': False, 23:26:49 INFO - 'base_work_dir': 'C:\\slave\\test', 23:26:49 INFO - 'blob_upload_branch': 'Fx-Team', 23:26:49 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt', 23:26:49 INFO - 'branch': 'Fx-Team', 23:26:49 INFO - 'buildbot_json_path': 'buildprops.json', 23:26:49 INFO - 'config_files': ('talos/windows_config.py',), 23:26:49 INFO - 'default_actions': ('clobber', 23:26:49 INFO - 'read-buildbot-config', 23:26:49 INFO - 'download-and-extract', 23:26:49 INFO - 'populate-webroot', 23:26:49 INFO - 'create-virtualenv', 23:26:49 INFO - 'install', 23:26:49 INFO - 'run-tests'), 23:26:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:26:49 INFO - 'download_minidump_stackwalk': True, 23:26:49 INFO - 'download_symbols': 'ondemand', 23:26:49 INFO - 'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python', 23:26:49 INFO - 'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'), 23:26:49 INFO - 'hg': 'c:/mozilla-build/hg/hg', 23:26:49 INFO - 'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python', 23:26:49 INFO - 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'), 23:26:49 INFO - 'python': 'c:/mozilla-build/python27/python.exe', 23:26:49 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe', 23:26:49 INFO - 'C:/mozilla-build/tooltool.py'), 23:26:49 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe', 23:26:49 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 23:26:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:26:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:26:49 INFO - 'installer_path': 'installer.exe', 23:26:49 INFO - 'log_level': 'info', 23:26:49 INFO - 'log_name': 'talos', 23:26:49 INFO - 'log_to_console': True, 23:26:49 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe', 23:26:49 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe', 23:26:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest', 23:26:49 INFO - 'opt_config_files': (), 23:26:49 INFO - 'pip_index': False, 23:26:49 INFO - 'sps_profile': False, 23:26:49 INFO - 'sps_profile_interval': 0, 23:26:49 INFO - 'suite': 'dromaeojs', 23:26:49 INFO - 'system_bits': '32', 23:26:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:26:49 INFO - 'title': 'T-W864-IX-231', 23:26:49 INFO - 'use_talos_json': True, 23:26:49 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'), 23:26:49 INFO - 'virtualenv_path': 'C:\\slave\\test\\build/venv', 23:26:49 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll', 23:26:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:26:49 INFO - 'work_dir': 'build'} 23:26:49 INFO - [mozharness: 2016-10-20 06:26:49.505000Z] Running clobber step. 23:26:49 INFO - Running pre-action listener: _resource_record_pre_action 23:26:49 INFO - Running main action method: clobber 23:26:49 INFO - rmtree: C:\slave\test\build 23:26:49 INFO - Using _rmtree_windows ... 23:26:49 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1 23:27:45 INFO - Running post-action listener: _resource_record_post_action 23:27:45 INFO - [mozharness: 2016-10-20 06:27:45.243000Z] Finished clobber step (success) 23:27:45 INFO - [mozharness: 2016-10-20 06:27:45.243000Z] Running read-buildbot-config step. 23:27:45 INFO - Running pre-action listener: _resource_record_pre_action 23:27:45 INFO - Running main action method: read_buildbot_config 23:27:45 INFO - Using buildbot properties: 23:27:45 INFO - { 23:27:45 INFO - "project": "", 23:27:45 INFO - "product": "firefox", 23:27:45 INFO - "script_repo_revision": "production", 23:27:45 INFO - "builddir": "fx-team_win8_64_test-dromaeojs", 23:27:45 INFO - "repository": "", 23:27:45 INFO - "buildername": "Windows 8 64-bit fx-team pgo talos dromaeojs", 23:27:45 INFO - "buildid": "20161019213008", 23:27:45 INFO - "pgo_build": "True", 23:27:45 INFO - "basedir": "C:\\slave\\test", 23:27:45 INFO - "buildnumber": 10, 23:27:45 INFO - "slavename": "t-w864-ix-231", 23:27:45 INFO - "master": "http://buildbot-master127.bb.releng.scl3.mozilla.com:8201/", 23:27:45 INFO - "platform": "win8_64", 23:27:45 INFO - "scheduler": "tests-fx-team-win64-pgo-talos", 23:27:45 INFO - "branch": "fx-team", 23:27:45 INFO - "repo_path": "integration/fx-team", 23:27:45 INFO - "revision": "998ad5a74da80fe63664a8dcf30d8f269ffe4e65", 23:27:45 INFO - "stage_platform": "win64-pgo", 23:27:45 INFO - "builduid": "6f46793ffb224841b328bdbaf3a7682f", 23:27:45 INFO - "slavebuilddir": "test" 23:27:45 INFO - } 23:27:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ua4yd61JQBqx40qnO5dEfg/artifacts/public/build/firefox-52.0a1.en-US.win64.zip. 23:27:45 INFO - Running post-action listener: _resource_record_post_action 23:27:45 INFO - [mozharness: 2016-10-20 06:27:45.246000Z] Finished read-buildbot-config step (success) 23:27:45 INFO - [mozharness: 2016-10-20 06:27:45.247000Z] Running download-and-extract step. 23:27:45 INFO - Running pre-action listener: _resource_record_pre_action 23:27:45 INFO - Running main action method: download_and_extract 23:27:45 INFO - mkdir: C:\slave\test\build\tests 23:27:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:27:45 INFO - trying https://queue.taskcluster.net/v1/task/Ua4yd61JQBqx40qnO5dEfg/artifacts/public/build/firefox-52.0a1.en-US.win64.test_packages.json 23:27:45 INFO - Downloading https://queue.taskcluster.net/v1/task/Ua4yd61JQBqx40qnO5dEfg/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 23:27:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ua4yd61JQBqx40qnO5dEfg/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 23:27:45 INFO - Downloaded 1218 bytes. 23:27:45 INFO - Reading from file C:\slave\test\build\firefox-52.0a1.en-US.win64.test_packages.json 23:27:45 INFO - Using the following test package requirements: 23:27:45 INFO - {u'common': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 23:27:45 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 23:27:45 INFO - u'firefox-52.0a1.en-US.win64.cppunittest.tests.zip'], 23:27:45 INFO - u'gtest': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 23:27:45 INFO - u'jittest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 23:27:45 INFO - u'jsshell-win64.zip'], 23:27:45 INFO - u'mochitest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 23:27:45 INFO - u'firefox-52.0a1.en-US.win64.mochitest.tests.zip'], 23:27:45 INFO - u'mozbase': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 23:27:45 INFO - u'reftest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 23:27:45 INFO - u'firefox-52.0a1.en-US.win64.reftest.tests.zip'], 23:27:45 INFO - u'talos': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 23:27:45 INFO - u'firefox-52.0a1.en-US.win64.talos.tests.zip'], 23:27:45 INFO - u'web-platform': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 23:27:45 INFO - u'firefox-52.0a1.en-US.win64.web-platform.tests.zip'], 23:27:45 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 23:27:45 INFO - u'firefox-52.0a1.en-US.win64.xpcshell.tests.zip']} 23:27:45 INFO - Downloading packages: [u'firefox-52.0a1.en-US.win64.common.tests.zip'] for test suite category: common 23:27:45 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/Ua4yd61JQBqx40qnO5dEfg/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip 23:27:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ua4yd61JQBqx40qnO5dEfg/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip'}, attempt #1 23:27:45 INFO - Fetch https://queue.taskcluster.net/v1/task/Ua4yd61JQBqx40qnO5dEfg/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip into memory 23:27:46 INFO - Http code: 200 23:27:46 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 23:27:46 INFO - x-amz-cf-id: IiNOCpBcrxyr23IBB2KHy3wsMAelnkEEfIMySN2mN96dFt-wGyj7Gw== 23:27:46 INFO - x-amz-version-id: .1Gyoq92VOZ9O9.OjrKkDctbMUlw_908 23:27:47 INFO - Expected file size: 17546751 23:27:47 INFO - Obtained file size: 17546751 23:28:08 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 23:28:08 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/Ua4yd61JQBqx40qnO5dEfg/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip 23:28:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ua4yd61JQBqx40qnO5dEfg/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip'}, attempt #1 23:28:08 INFO - Fetch https://queue.taskcluster.net/v1/task/Ua4yd61JQBqx40qnO5dEfg/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip into memory 23:28:08 INFO - Http code: 200 23:28:08 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 23:28:08 INFO - x-amz-cf-id: 35qhtL9egwMPXi82LxxMW0cSRj5zK_XRUJ6siKX-4cEZ0cW_uwI1VA== 23:28:08 INFO - x-amz-version-id: .1Gyoq92VOZ9O9.OjrKkDctbMUlw_908 23:28:08 INFO - Expected file size: 17546751 23:28:08 INFO - Obtained file size: 17546751 23:28:16 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/Ua4yd61JQBqx40qnO5dEfg/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip 23:28:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ua4yd61JQBqx40qnO5dEfg/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip'}, attempt #1 23:28:16 INFO - Fetch https://queue.taskcluster.net/v1/task/Ua4yd61JQBqx40qnO5dEfg/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip into memory 23:28:17 INFO - Http code: 200 23:28:17 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 23:28:17 INFO - x-amz-cf-id: XGunBEpnQEY_Wql3tBesus35hJVghYKp6q-TqyK4mqT1KRi6bK3nwQ== 23:28:17 INFO - x-amz-version-id: egodoFKoK7ZUdlkSJSDvr2PDptVIbN1y 23:28:17 INFO - Expected file size: 14409028 23:28:17 INFO - Obtained file size: 14409028 23:28: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')]} 23:28:25 INFO - trying https://queue.taskcluster.net/v1/task/Ua4yd61JQBqx40qnO5dEfg/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 23:28:25 INFO - Downloading https://queue.taskcluster.net/v1/task/Ua4yd61JQBqx40qnO5dEfg/artifacts/public/build/firefox-52.0a1.en-US.win64.zip to C:\slave\test\build\firefox-52.0a1.en-US.win64.zip 23:28:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ua4yd61JQBqx40qnO5dEfg/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 23:28:26 INFO - Downloaded 57271084 bytes. 23:28:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ua4yd61JQBqx40qnO5dEfg/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 23:28:26 INFO - mkdir: C:\slave\test\properties 23:28:26 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url 23:28:26 INFO - Writing to file C:\slave\test\properties\build_url 23:28:26 INFO - Contents: 23:28:26 INFO - build_url:https://queue.taskcluster.net/v1/task/Ua4yd61JQBqx40qnO5dEfg/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 23:28:27 INFO - Running post-action listener: _resource_record_post_action 23:28:27 INFO - Running post-action listener: set_extra_try_arguments 23:28:27 INFO - [mozharness: 2016-10-20 06:28:27.555000Z] Finished download-and-extract step (success) 23:28:27 INFO - [mozharness: 2016-10-20 06:28:27.555000Z] Running populate-webroot step. 23:28:27 INFO - Running pre-action listener: _resource_record_pre_action 23:28:27 INFO - Running main action method: populate_webroot 23:28:27 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']}, 23:28:27 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']}, 23:28:27 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome', 23:28:27 INFO - u'--tppagecycles', 23:28:27 INFO - u'7'], 23:28:27 INFO - u'tests': [u'tsvgm']}}, 23:28:27 INFO - u'suites': {u'chromez': {u'talos_options': [u'--disable-e10s'], 23:28:27 INFO - u'tests': [u'tresize', u'tcanvasmark']}, 23:28:27 INFO - u'chromez-e10s': {u'tests': [u'tresize', u'tcanvasmark']}, 23:28:27 INFO - u'dromaeojs': {u'talos_options': [u'--disable-e10s'], 23:28:27 INFO - u'tests': [u'dromaeo_css', u'kraken']}, 23:28:27 INFO - u'dromaeojs-e10s': {u'tests': [u'dromaeo_css', u'kraken']}, 23:28:27 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:28:27 INFO - u'talos_options': [u'--disable-e10s'], 23:28:27 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 23:28:27 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:28:27 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 23:28:27 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:28:27 INFO - u'talos_options': [u'--disable-e10s'], 23:28:27 INFO - u'tests': [u'damp', u'tps']}, 23:28:27 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:28:27 INFO - u'tests': [u'damp', u'tps']}, 23:28:27 INFO - u'g3': {u'talos_options': [u'--disable-e10s'], 23:28:27 INFO - u'tests': [u'dromaeo_dom']}, 23:28:27 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']}, 23:28:27 INFO - u'g4': {u'talos_options': [u'--disable-e10s'], 23:28:27 INFO - u'tests': [u'basic_compositor_video']}, 23:28:27 INFO - u'g4-e10s': {u'tests': [u'basic_compositor_video']}, 23:28:27 INFO - u'other': {u'talos_options': [u'--disable-e10s'], 23:28:27 INFO - u'tests': [u'a11yr', 23:28:27 INFO - u'ts_paint', 23:28:27 INFO - u'tpaint', 23:28:27 INFO - u'sessionrestore', 23:28:27 INFO - u'sessionrestore_no_auto_restore', 23:28:27 INFO - u'tabpaint']}, 23:28:27 INFO - u'other-e10s': {u'tests': [u'a11yr', 23:28:27 INFO - u'ts_paint', 23:28:27 INFO - u'tpaint', 23:28:27 INFO - u'sessionrestore', 23:28:27 INFO - u'sessionrestore_no_auto_restore', 23:28:27 INFO - u'tabpaint']}, 23:28:27 INFO - u'other-e10s_l64': {u'tests': [u'a11yr', 23:28:27 INFO - u'ts_paint', 23:28:27 INFO - u'tpaint', 23:28:27 INFO - u'sessionrestore', 23:28:27 INFO - u'sessionrestore_no_auto_restore', 23:28:27 INFO - u'tabpaint']}, 23:28:27 INFO - u'other-e10s_nol64': {u'tests': [u'a11yr', 23:28:27 INFO - u'ts_paint', 23:28:27 INFO - u'tpaint', 23:28:27 INFO - u'sessionrestore', 23:28:27 INFO - u'sessionrestore_no_auto_restore', 23:28:27 INFO - u'tabpaint']}, 23:28:27 INFO - u'other_l64': {u'talos_options': [u'--disable-e10s'], 23:28:27 INFO - u'tests': [u'a11yr', 23:28:27 INFO - u'ts_paint', 23:28:27 INFO - u'tpaint', 23:28:27 INFO - u'sessionrestore', 23:28:27 INFO - u'sessionrestore_no_auto_restore', 23:28:27 INFO - u'tabpaint']}, 23:28:27 INFO - u'other_nol64': {u'talos_options': [u'--disable-e10s'], 23:28:27 INFO - u'tests': [u'a11yr', 23:28:27 INFO - u'ts_paint', 23:28:27 INFO - u'tpaint', 23:28:27 INFO - u'sessionrestore', 23:28:27 INFO - u'sessionrestore_no_auto_restore', 23:28:27 INFO - u'tabpaint']}, 23:28:27 INFO - u'svgr': {u'talos_options': [u'--disable-e10s'], 23:28:27 INFO - u'tests': [u'tsvgx', 23:28:27 INFO - u'tsvgr_opacity', 23:28:27 INFO - u'tart', 23:28:27 INFO - u'tscrollx', 23:28:27 INFO - u'cart']}, 23:28:27 INFO - u'svgr-e10s': {u'tests': [u'tsvgx', 23:28:27 INFO - u'tsvgr_opacity', 23:28:27 INFO - u'tart', 23:28:27 INFO - u'tscrollx', 23:28:27 INFO - u'cart']}, 23:28:27 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:28:27 INFO - u'talos_options': [u'--disable-e10s'], 23:28:27 INFO - u'tests': [u'tp5o']}, 23:28:27 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:28:27 INFO - u'tests': [u'tp5o']}, 23:28:27 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:28:27 INFO - u'talos_options': [u'--disable-e10s', 23:28:27 INFO - u'--xperf_path', 23:28:27 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:28:27 INFO - u'tests': [u'tp5n']}, 23:28:27 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:28:27 INFO - u'talos_options': [u'--xperf_path', 23:28:27 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:28:27 INFO - u'tests': [u'tp5n']}}, 23:28:27 INFO - u'talos.zip': {u'path': u'', 23:28:27 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:28:27 INFO - Running post-action listener: _resource_record_post_action 23:28:27 INFO - [mozharness: 2016-10-20 06:28:27.577000Z] Finished populate-webroot step (success) 23:28:27 INFO - [mozharness: 2016-10-20 06:28:27.577000Z] Running create-virtualenv step. 23:28:27 INFO - Running pre-action listener: _resource_record_pre_action 23:28:27 INFO - Running main action method: create_virtualenv 23:28:27 INFO - Creating virtualenv C:\slave\test\build/venv 23:28:27 INFO - mkdir: C:\slave\test\build\venv\Scripts 23:28:27 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll 23:28:27 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'! 23:28:27 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 23:28:27 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build/venv 23:28:34 INFO - New python executable in C:\slave\test\build/venv\Scripts\python.exe 23:28:37 INFO - Installing distribute......................................................................................................................................................................................done. 23:28:38 INFO - Return code: 0 23:28:38 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', '--version'] 23:28:38 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip --version 23:28:39 INFO - Reading from file tmpfile_stdout 23:28:39 INFO - Output received: 23:28:39 INFO - pip 0.8.2 from c:\slave\test\build\venv\lib\site-packages\pip-0.8.2-py2.7.egg (python 2.7) 23:28:39 INFO - Using _rmtree_windows ... 23:28:39 INFO - Using _rmtree_windows ... 23:28:39 INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv 23:28:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:28:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:28:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:28:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:28:39 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0236C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02413E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0251E0E8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0245AE90>, '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 0x0087A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0283D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-231', 'USERDOMAIN': 'T-W864-IX-231', '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-231', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-231\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-231', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-231', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-231', '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-231\\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 23:28:39 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in C:\slave\test\build 23:28:39 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:28:39 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 23:28:39 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-231\\AppData\\Roaming', 23:28:39 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 23:28:39 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 23:28:39 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 23:28:39 INFO - 'COMPUTERNAME': 'T-W864-IX-231', 23:28:39 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 23:28:39 INFO - 'DCLOCATION': 'SCL3', 23:28:39 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 23:28:39 INFO - 'FP_NO_HOST_CHECK': 'NO', 23:28:39 INFO - 'HOMEDRIVE': 'C:', 23:28:39 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-231', 23:28:39 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 23:28:39 INFO - 'KTS_VERSION': '1.19c', 23:28:39 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-231\\AppData\\Local', 23:28:39 INFO - 'LOGONSERVER': '\\\\T-W864-IX-231', 23:28:39 INFO - 'MONDIR': 'C:\\Monitor_config\\', 23:28:39 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 23:28:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:28:39 INFO - 'MOZ_NO_REMOTE': '1', 23:28:39 INFO - 'NO_EM_RESTART': '1', 23:28:39 INFO - 'NUMBER_OF_PROCESSORS': '8', 23:28:39 INFO - 'OS': 'Windows_NT', 23:28:39 INFO - 'OURDRIVE': 'C:', 23:28:39 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 23:28:39 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 23:28:39 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 23:28:39 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 23:28:39 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 23:28:39 INFO - 'PROCESSOR_LEVEL': '6', 23:28:39 INFO - 'PROCESSOR_REVISION': '1e05', 23:28:39 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 23:28:39 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 23:28:39 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 23:28:39 INFO - 'PROGRAMW6432': 'C:\\Program Files', 23:28:39 INFO - 'PROMPT': '$P$G', 23:28:39 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 23:28:39 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 23:28:39 INFO - 'PUBLIC': 'C:\\Users\\Public', 23:28:39 INFO - 'PWD': 'C:\\slave\\test', 23:28:39 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 23:28:39 INFO - 'SLAVEDIR': 'C:\\slave\\', 23:28:39 INFO - 'SYSTEMDRIVE': 'C:', 23:28:39 INFO - 'SYSTEMROOT': 'C:\\windows', 23:28:39 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 23:28:39 INFO - 'TEST1': 'testie', 23:28:39 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 23:28:39 INFO - 'USERDOMAIN': 'T-W864-IX-231', 23:28:39 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-231', 23:28:39 INFO - 'USERNAME': 'cltbld', 23:28:39 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-231', 23:28:39 INFO - 'WINDIR': 'C:\\windows', 23:28:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 23:28:40 INFO - Ignoring indexes: http://pypi.python.org/simple/ 23:28:40 INFO - Downloading/unpacking pip>=1.5 23:28:44 INFO - Running setup.py egg_info for package pip 23:28:44 INFO - warning: no files found matching 'pip\cacert.pem' 23:28:44 INFO - warning: no files found matching '*.html' under directory 'docs' 23:28:44 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 23:28:44 INFO - no previously-included directories found matching 'docs\_build\_sources' 23:28:44 INFO - Installing collected packages: pip 23:28:44 INFO - Found existing installation: pip 0.8.2 23:28:44 INFO - Uninstalling pip: 23:28:44 INFO - Successfully uninstalled pip 23:28:44 INFO - Running setup.py install for pip 23:28:44 INFO - warning: no files found matching 'pip\cacert.pem' 23:28:44 INFO - warning: no files found matching '*.html' under directory 'docs' 23:28:44 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 23:28:44 INFO - no previously-included directories found matching 'docs\_build\_sources' 23:28:44 INFO - Installing pip-script.py script to C:\slave\test\build\venv\Scripts 23:28:44 INFO - Installing pip.exe script to C:\slave\test\build\venv\Scripts 23:28:44 INFO - Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts 23:28:44 INFO - Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts 23:28:44 INFO - Installing pip2-script.py script to C:\slave\test\build\venv\Scripts 23:28:44 INFO - Installing pip2.exe script to C:\slave\test\build\venv\Scripts 23:28:44 INFO - Successfully installed pip 23:28:44 INFO - Cleaning up... 23:28:44 INFO - Return code: 0 23:28:44 INFO - Installing psutil>=3.1.1 into virtualenv C:\slave\test\build/venv 23:28: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')]} 23:28:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:28: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')]} 23:28:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:28:44 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0236C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02413E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0251E0E8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0245AE90>, '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 0x0087A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0283D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-231', 'USERDOMAIN': 'T-W864-IX-231', '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-231', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-231\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-231', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-231', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-231', '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-231\\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 23:28: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', 'psutil>=3.1.1'] in C:\slave\test\build 23:28: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 psutil>=3.1.1 23:28:44 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 23:28:44 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-231\\AppData\\Roaming', 23:28:44 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 23:28:44 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 23:28:44 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 23:28:44 INFO - 'COMPUTERNAME': 'T-W864-IX-231', 23:28:44 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 23:28:44 INFO - 'DCLOCATION': 'SCL3', 23:28:44 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 23:28:44 INFO - 'FP_NO_HOST_CHECK': 'NO', 23:28:44 INFO - 'HOMEDRIVE': 'C:', 23:28:44 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-231', 23:28:44 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 23:28:44 INFO - 'KTS_VERSION': '1.19c', 23:28:44 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-231\\AppData\\Local', 23:28:44 INFO - 'LOGONSERVER': '\\\\T-W864-IX-231', 23:28:44 INFO - 'MONDIR': 'C:\\Monitor_config\\', 23:28:44 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 23:28:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:28:44 INFO - 'MOZ_NO_REMOTE': '1', 23:28:44 INFO - 'NO_EM_RESTART': '1', 23:28:44 INFO - 'NUMBER_OF_PROCESSORS': '8', 23:28:44 INFO - 'OS': 'Windows_NT', 23:28:44 INFO - 'OURDRIVE': 'C:', 23:28: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', 23:28:44 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 23:28:44 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 23:28:44 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 23:28:44 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 23:28:44 INFO - 'PROCESSOR_LEVEL': '6', 23:28:44 INFO - 'PROCESSOR_REVISION': '1e05', 23:28:44 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 23:28:44 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 23:28:44 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 23:28:44 INFO - 'PROGRAMW6432': 'C:\\Program Files', 23:28:44 INFO - 'PROMPT': '$P$G', 23:28:44 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 23:28:44 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 23:28:44 INFO - 'PUBLIC': 'C:\\Users\\Public', 23:28:44 INFO - 'PWD': 'C:\\slave\\test', 23:28:44 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 23:28:44 INFO - 'SLAVEDIR': 'C:\\slave\\', 23:28:44 INFO - 'SYSTEMDRIVE': 'C:', 23:28:44 INFO - 'SYSTEMROOT': 'C:\\windows', 23:28:44 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 23:28:44 INFO - 'TEST1': 'testie', 23:28:44 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 23:28:44 INFO - 'USERDOMAIN': 'T-W864-IX-231', 23:28:44 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-231', 23:28:44 INFO - 'USERNAME': 'cltbld', 23:28:44 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-231', 23:28:44 INFO - 'WINDIR': 'C:\\windows', 23:28:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 23:28:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:28:46 INFO - Downloading/unpacking psutil>=3.1.1 23:28:46 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 23:28:46 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 23:28:47 INFO - Installing collected packages: psutil 23:28:47 INFO - Successfully installed psutil 23:28:47 INFO - Cleaning up... 23:28:47 INFO - Return code: 0 23:28:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv C:\slave\test\build/venv 23:28: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')]} 23:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:28: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')]} 23:28:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:28:47 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0236C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02413E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0251E0E8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0245AE90>, '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 0x0087A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0283D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-231', 'USERDOMAIN': 'T-W864-IX-231', '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-231', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-231\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-231', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-231', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-231', '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-231\\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 23:28:47 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in C:\slave\test\build 23:28:47 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:28:47 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 23:28:47 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-231\\AppData\\Roaming', 23:28:47 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 23:28:47 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 23:28:47 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 23:28:47 INFO - 'COMPUTERNAME': 'T-W864-IX-231', 23:28:47 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 23:28:47 INFO - 'DCLOCATION': 'SCL3', 23:28:47 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 23:28:47 INFO - 'FP_NO_HOST_CHECK': 'NO', 23:28:47 INFO - 'HOMEDRIVE': 'C:', 23:28:47 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-231', 23:28:47 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 23:28:47 INFO - 'KTS_VERSION': '1.19c', 23:28:47 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-231\\AppData\\Local', 23:28:47 INFO - 'LOGONSERVER': '\\\\T-W864-IX-231', 23:28:47 INFO - 'MONDIR': 'C:\\Monitor_config\\', 23:28:47 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 23:28:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:28:47 INFO - 'MOZ_NO_REMOTE': '1', 23:28:47 INFO - 'NO_EM_RESTART': '1', 23:28:47 INFO - 'NUMBER_OF_PROCESSORS': '8', 23:28:47 INFO - 'OS': 'Windows_NT', 23:28:47 INFO - 'OURDRIVE': 'C:', 23:28:47 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 23:28:47 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 23:28:47 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 23:28:47 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 23:28:47 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 23:28:47 INFO - 'PROCESSOR_LEVEL': '6', 23:28:47 INFO - 'PROCESSOR_REVISION': '1e05', 23:28:47 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 23:28:47 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 23:28:47 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 23:28:47 INFO - 'PROGRAMW6432': 'C:\\Program Files', 23:28:47 INFO - 'PROMPT': '$P$G', 23:28:47 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 23:28:47 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 23:28:47 INFO - 'PUBLIC': 'C:\\Users\\Public', 23:28:47 INFO - 'PWD': 'C:\\slave\\test', 23:28:47 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 23:28:47 INFO - 'SLAVEDIR': 'C:\\slave\\', 23:28:47 INFO - 'SYSTEMDRIVE': 'C:', 23:28:47 INFO - 'SYSTEMROOT': 'C:\\windows', 23:28:47 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 23:28:47 INFO - 'TEST1': 'testie', 23:28:47 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 23:28:47 INFO - 'USERDOMAIN': 'T-W864-IX-231', 23:28:47 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-231', 23:28:47 INFO - 'USERNAME': 'cltbld', 23:28:47 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-231', 23:28:47 INFO - 'WINDIR': 'C:\\windows', 23:28:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 23:28:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:28:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:28:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:28:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:28:48 INFO - Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor 23:28:48 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) 23:28:48 INFO - Installing collected packages: mozsystemmonitor 23:28:48 INFO - Running setup.py install for mozsystemmonitor 23:28:48 INFO - Successfully installed mozsystemmonitor 23:28:48 INFO - Cleaning up... 23:28:49 INFO - Return code: 0 23:28:49 INFO - Installing jsonschema==2.5.1 into virtualenv C:\slave\test\build/venv 23:28:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:28:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:28:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:28:49 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x0236C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02413E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0251E0E8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0245AE90>, '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 0x0087A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0283D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-231', 'USERDOMAIN': 'T-W864-IX-231', '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-231', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-231\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-231', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-231', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-231', '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-231\\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 23:28:49 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in C:\slave\test\build 23:28:49 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 23:28:49 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 23:28:49 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-231\\AppData\\Roaming', 23:28:49 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 23:28:49 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 23:28:49 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 23:28:49 INFO - 'COMPUTERNAME': 'T-W864-IX-231', 23:28:49 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 23:28:49 INFO - 'DCLOCATION': 'SCL3', 23:28:49 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 23:28:49 INFO - 'FP_NO_HOST_CHECK': 'NO', 23:28:49 INFO - 'HOMEDRIVE': 'C:', 23:28:49 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-231', 23:28:49 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 23:28:49 INFO - 'KTS_VERSION': '1.19c', 23:28:49 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-231\\AppData\\Local', 23:28:49 INFO - 'LOGONSERVER': '\\\\T-W864-IX-231', 23:28:49 INFO - 'MONDIR': 'C:\\Monitor_config\\', 23:28:49 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 23:28:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:28:49 INFO - 'MOZ_NO_REMOTE': '1', 23:28:49 INFO - 'NO_EM_RESTART': '1', 23:28:49 INFO - 'NUMBER_OF_PROCESSORS': '8', 23:28:49 INFO - 'OS': 'Windows_NT', 23:28:49 INFO - 'OURDRIVE': 'C:', 23:28:49 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 23:28:49 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 23:28:49 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 23:28:49 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 23:28:49 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 23:28:49 INFO - 'PROCESSOR_LEVEL': '6', 23:28:49 INFO - 'PROCESSOR_REVISION': '1e05', 23:28:49 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 23:28:49 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 23:28:49 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 23:28:49 INFO - 'PROGRAMW6432': 'C:\\Program Files', 23:28:49 INFO - 'PROMPT': '$P$G', 23:28:49 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 23:28:49 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 23:28:49 INFO - 'PUBLIC': 'C:\\Users\\Public', 23:28:49 INFO - 'PWD': 'C:\\slave\\test', 23:28:49 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 23:28:49 INFO - 'SLAVEDIR': 'C:\\slave\\', 23:28:49 INFO - 'SYSTEMDRIVE': 'C:', 23:28:49 INFO - 'SYSTEMROOT': 'C:\\windows', 23:28:49 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 23:28:49 INFO - 'TEST1': 'testie', 23:28:49 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 23:28:49 INFO - 'USERDOMAIN': 'T-W864-IX-231', 23:28:49 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-231', 23:28:49 INFO - 'USERNAME': 'cltbld', 23:28:49 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-231', 23:28:49 INFO - 'WINDIR': 'C:\\windows', 23:28:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 23:28:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:28:49 INFO - Downloading/unpacking jsonschema==2.5.1 23:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:28:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:28:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:28:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:28:50 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 23:28:50 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 23:28:50 INFO - Downloading functools32-3.2.3-2.tar.gz 23:28:50 INFO - Running setup.py (path:C:\slave\test\build\venv\build\functools32\setup.py) egg_info for package functools32 23:28:50 INFO - warning: no files found matching '*.txt' 23:28:50 INFO - no previously-included directories found matching 'build' 23:28:50 INFO - no previously-included directories found matching 'dist' 23:28:50 INFO - no previously-included directories found matching '.git*' 23:28:50 INFO - Installing collected packages: jsonschema, functools32 23:28:50 INFO - Running setup.py install for functools32 23:28:50 INFO - warning: no files found matching '*.txt' 23:28:50 INFO - no previously-included directories found matching 'build' 23:28:50 INFO - no previously-included directories found matching 'dist' 23:28:50 INFO - no previously-included directories found matching '.git*' 23:28:50 INFO - Successfully installed jsonschema functools32 23:28:50 INFO - Cleaning up... 23:28:51 INFO - Return code: 0 23:28:51 INFO - Installing functools32==3.2.3-2 into virtualenv C:\slave\test\build/venv 23:28:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:28:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:28:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:28:51 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x0236C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02413E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0251E0E8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0245AE90>, '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 0x0087A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0283D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-231', 'USERDOMAIN': 'T-W864-IX-231', '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-231', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-231\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-231', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-231', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-231', '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-231\\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 23:28:51 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in C:\slave\test\build 23:28:51 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 23:28:51 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 23:28:51 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-231\\AppData\\Roaming', 23:28:51 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 23:28:51 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 23:28:51 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 23:28:51 INFO - 'COMPUTERNAME': 'T-W864-IX-231', 23:28:51 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 23:28:51 INFO - 'DCLOCATION': 'SCL3', 23:28:51 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 23:28:51 INFO - 'FP_NO_HOST_CHECK': 'NO', 23:28:51 INFO - 'HOMEDRIVE': 'C:', 23:28:51 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-231', 23:28:51 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 23:28:51 INFO - 'KTS_VERSION': '1.19c', 23:28:51 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-231\\AppData\\Local', 23:28:51 INFO - 'LOGONSERVER': '\\\\T-W864-IX-231', 23:28:51 INFO - 'MONDIR': 'C:\\Monitor_config\\', 23:28:51 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 23:28:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:28:51 INFO - 'MOZ_NO_REMOTE': '1', 23:28:51 INFO - 'NO_EM_RESTART': '1', 23:28:51 INFO - 'NUMBER_OF_PROCESSORS': '8', 23:28:51 INFO - 'OS': 'Windows_NT', 23:28:51 INFO - 'OURDRIVE': 'C:', 23:28:51 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 23:28:51 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 23:28:51 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 23:28:51 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 23:28:51 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 23:28:51 INFO - 'PROCESSOR_LEVEL': '6', 23:28:51 INFO - 'PROCESSOR_REVISION': '1e05', 23:28:51 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 23:28:51 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 23:28:51 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 23:28:51 INFO - 'PROGRAMW6432': 'C:\\Program Files', 23:28:51 INFO - 'PROMPT': '$P$G', 23:28:51 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 23:28:51 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 23:28:51 INFO - 'PUBLIC': 'C:\\Users\\Public', 23:28:51 INFO - 'PWD': 'C:\\slave\\test', 23:28:51 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 23:28:51 INFO - 'SLAVEDIR': 'C:\\slave\\', 23:28:51 INFO - 'SYSTEMDRIVE': 'C:', 23:28:51 INFO - 'SYSTEMROOT': 'C:\\windows', 23:28:51 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 23:28:51 INFO - 'TEST1': 'testie', 23:28:51 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 23:28:51 INFO - 'USERDOMAIN': 'T-W864-IX-231', 23:28:51 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-231', 23:28:51 INFO - 'USERNAME': 'cltbld', 23:28:51 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-231', 23:28:51 INFO - 'WINDIR': 'C:\\windows', 23:28:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 23:28:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:28:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in c:\slave\test\build\venv\lib\site-packages 23:28:51 INFO - Cleaning up... 23:28:51 INFO - Return code: 0 23:28:51 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv 23:28:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:28:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:28:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:28:51 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x0236C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02413E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0251E0E8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0245AE90>, '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 0x0087A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0283D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-231', 'USERDOMAIN': 'T-W864-IX-231', '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-231', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-231\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-231', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-231', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-231', '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-231\\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 23:28:51 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in C:\slave\test\build 23:28:51 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:28:51 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 23:28:51 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-231\\AppData\\Roaming', 23:28:51 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 23:28:51 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 23:28:51 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 23:28:51 INFO - 'COMPUTERNAME': 'T-W864-IX-231', 23:28:51 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 23:28:51 INFO - 'DCLOCATION': 'SCL3', 23:28:51 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 23:28:51 INFO - 'FP_NO_HOST_CHECK': 'NO', 23:28:51 INFO - 'HOMEDRIVE': 'C:', 23:28:51 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-231', 23:28:51 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 23:28:51 INFO - 'KTS_VERSION': '1.19c', 23:28:51 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-231\\AppData\\Local', 23:28:51 INFO - 'LOGONSERVER': '\\\\T-W864-IX-231', 23:28:51 INFO - 'MONDIR': 'C:\\Monitor_config\\', 23:28:51 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 23:28:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:28:51 INFO - 'MOZ_NO_REMOTE': '1', 23:28:51 INFO - 'NO_EM_RESTART': '1', 23:28:51 INFO - 'NUMBER_OF_PROCESSORS': '8', 23:28:51 INFO - 'OS': 'Windows_NT', 23:28:51 INFO - 'OURDRIVE': 'C:', 23:28:51 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 23:28:51 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 23:28:51 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 23:28:51 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 23:28:51 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 23:28:51 INFO - 'PROCESSOR_LEVEL': '6', 23:28:51 INFO - 'PROCESSOR_REVISION': '1e05', 23:28:51 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 23:28:51 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 23:28:51 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 23:28:51 INFO - 'PROGRAMW6432': 'C:\\Program Files', 23:28:51 INFO - 'PROMPT': '$P$G', 23:28:51 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 23:28:51 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 23:28:51 INFO - 'PUBLIC': 'C:\\Users\\Public', 23:28:51 INFO - 'PWD': 'C:\\slave\\test', 23:28:51 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 23:28:51 INFO - 'SLAVEDIR': 'C:\\slave\\', 23:28:51 INFO - 'SYSTEMDRIVE': 'C:', 23:28:51 INFO - 'SYSTEMROOT': 'C:\\windows', 23:28:51 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 23:28:51 INFO - 'TEST1': 'testie', 23:28:51 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 23:28:51 INFO - 'USERDOMAIN': 'T-W864-IX-231', 23:28:51 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-231', 23:28:51 INFO - 'USERNAME': 'cltbld', 23:28:51 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-231', 23:28:51 INFO - 'WINDIR': 'C:\\windows', 23:28:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 23:28:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:28:52 INFO - Downloading/unpacking blobuploader==1.2.4 23:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:28:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:28:53 INFO - Downloading blobuploader-1.2.4.tar.gz 23:28:53 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader 23:28:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:28:53 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 23:28:53 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 23:28:53 INFO - Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests 23:28:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:28:53 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 23:28:53 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 23:28:54 INFO - Downloading docopt-0.6.1.tar.gz 23:28:54 INFO - Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt 23:28:54 INFO - Installing collected packages: blobuploader, requests, docopt 23:28:54 INFO - Running setup.py install for blobuploader 23:28:54 INFO - Running setup.py install for requests 23:28:54 INFO - Running setup.py install for docopt 23:28:54 INFO - Successfully installed blobuploader requests docopt 23:28:54 INFO - Cleaning up... 23:28:56 INFO - Return code: 0 23:28:56 INFO - Installing None into virtualenv C:\slave\test\build/venv 23:28:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:28:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:28:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:28:56 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 0x0236C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02413E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0251E0E8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0245AE90>, '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 0x0087A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0283D520>, '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-231', 'USERDOMAIN': 'T-W864-IX-231', '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-231', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-231\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-231', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-231', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-231', '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-231\\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 23:28:56 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 23:28:56 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 23:28:56 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 23:28:56 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-231\\AppData\\Roaming', 23:28:56 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 23:28:56 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 23:28:56 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 23:28:56 INFO - 'COMPUTERNAME': 'T-W864-IX-231', 23:28:56 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 23:28:56 INFO - 'DCLOCATION': 'SCL3', 23:28:56 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 23:28:56 INFO - 'FP_NO_HOST_CHECK': 'NO', 23:28:56 INFO - 'HOMEDRIVE': 'C:', 23:28:56 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-231', 23:28:56 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 23:28:56 INFO - 'KTS_VERSION': '1.19c', 23:28:56 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-231\\AppData\\Local', 23:28:56 INFO - 'LOGONSERVER': '\\\\T-W864-IX-231', 23:28:56 INFO - 'MONDIR': 'C:\\Monitor_config\\', 23:28:56 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 23:28:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:28:56 INFO - 'MOZ_NO_REMOTE': '1', 23:28:56 INFO - 'NO_EM_RESTART': '1', 23:28:56 INFO - 'NUMBER_OF_PROCESSORS': '8', 23:28:56 INFO - 'OS': 'Windows_NT', 23:28:56 INFO - 'OURDRIVE': 'C:', 23:28:56 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 23:28:56 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 23:28:56 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 23:28:56 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 23:28:56 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 23:28:56 INFO - 'PROCESSOR_LEVEL': '6', 23:28:56 INFO - 'PROCESSOR_REVISION': '1e05', 23:28:56 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 23:28:56 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 23:28:56 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 23:28:56 INFO - 'PROGRAMW6432': 'C:\\Program Files', 23:28:56 INFO - 'PROMPT': '$P$G', 23:28:56 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 23:28:56 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 23:28:56 INFO - 'PUBLIC': 'C:\\Users\\Public', 23:28:56 INFO - 'PWD': 'C:\\slave\\test', 23:28:56 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 23:28:56 INFO - 'SLAVEDIR': 'C:\\slave\\', 23:28:56 INFO - 'SYSTEMDRIVE': 'C:', 23:28:56 INFO - 'SYSTEMROOT': 'C:\\windows', 23:28:56 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 23:28:56 INFO - 'TEST1': 'testie', 23:28:56 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 23:28:56 INFO - 'USERDOMAIN': 'T-W864-IX-231', 23:28:56 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-231', 23:28:56 INFO - 'USERNAME': 'cltbld', 23:28:56 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-231', 23:28:56 INFO - 'WINDIR': 'C:\\windows', 23:28:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 23:28:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:28:56 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 23:28:56 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-filraa-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 23:28:56 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 23:28:56 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-fx03zi-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 23:28:56 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 23:28:56 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-amri8c-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 23:28:56 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 23:28:56 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-m7kzpt-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 23:28:56 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 23:28:56 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-gqfsnm-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 23:28:57 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 23:28:57 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-v3go1r-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 23:28:57 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 23:28:57 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-65ech7-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 23:28:57 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 23:28:57 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jucwmu-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 23:28:57 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 23:28:57 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-8xegqz-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 23:28:57 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 23:28:57 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-vyf6bq-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 23:28:57 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 23:28:57 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rd__f7-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 23:28:57 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 23:28:57 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-hopnpx-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 23:28:57 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 23:28:57 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-avw9zp-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 23:28:57 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 23:28:57 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-fewadz-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 23:28:58 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 23:28:58 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-cbwkdt-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 23:28:58 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 23:28:58 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qdcxk5-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 23:28:58 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 23:28:58 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-yti1qu-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 23:28:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:28:58 INFO - Running setup.py install for manifestparser 23:28:58 INFO - Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts 23:28:58 INFO - Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts 23:28:59 INFO - Running setup.py install for mozcrash 23:28:59 INFO - Running setup.py install for mozdebug 23:28:59 INFO - Running setup.py install for mozdevice 23:29:00 INFO - Installing sutini-script.py script to C:\slave\test\build\venv\Scripts 23:29:00 INFO - Installing sutini.exe script to C:\slave\test\build\venv\Scripts 23:29:00 INFO - Installing dm-script.py script to C:\slave\test\build\venv\Scripts 23:29:00 INFO - Installing dm.exe script to C:\slave\test\build\venv\Scripts 23:29:00 INFO - Running setup.py install for mozfile 23:29:01 INFO - Running setup.py install for mozhttpd 23:29:01 INFO - Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts 23:29:01 INFO - Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts 23:29:01 INFO - Running setup.py install for mozinfo 23:29:01 INFO - Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts 23:29:01 INFO - Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts 23:29:01 INFO - Running setup.py install for mozInstall 23:29:02 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts 23:29:02 INFO - Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts 23:29:02 INFO - Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts 23:29:02 INFO - Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts 23:29:02 INFO - Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts 23:29:02 INFO - Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts 23:29:02 INFO - Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts 23:29:02 INFO - Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts 23:29:02 INFO - Running setup.py install for mozleak 23:29:02 INFO - Running setup.py install for mozlog 23:29:02 INFO - Installing structlog-script.py script to C:\slave\test\build\venv\Scripts 23:29:02 INFO - Installing structlog.exe script to C:\slave\test\build\venv\Scripts 23:29:03 INFO - Running setup.py install for moznetwork 23:29:03 INFO - Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts 23:29:03 INFO - Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts 23:29:04 INFO - Running setup.py install for mozprocess 23:29:04 INFO - Running setup.py install for mozprofile 23:29:04 INFO - Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts 23:29:04 INFO - Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts 23:29:04 INFO - Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts 23:29:04 INFO - Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts 23:29:04 INFO - Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts 23:29:04 INFO - Installing view-profile.exe script to C:\slave\test\build\venv\Scripts 23:29:05 INFO - Running setup.py install for mozrunner 23:29:05 INFO - Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts 23:29:05 INFO - Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts 23:29:05 INFO - Running setup.py install for mozscreenshot 23:29:06 INFO - Running setup.py install for moztest 23:29:06 INFO - Running setup.py install for mozversion 23:29:06 INFO - Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts 23:29:06 INFO - Installing mozversion.exe script to C:\slave\test\build\venv\Scripts 23:29:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:29:07 INFO - Cleaning up... 23:29:07 INFO - Return code: 0 23:29:07 INFO - Installing None into virtualenv C:\slave\test\build/venv 23:29:07 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')]} 23:29:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29:07 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')]} 23:29:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:07 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 0x0236C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02413E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0251E0E8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0245AE90>, '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 0x0087A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0283D520>, '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-231', 'USERDOMAIN': 'T-W864-IX-231', '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-231', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-231\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-231', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-231', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-231', '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-231\\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 23:29:07 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 23:29:07 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 23:29:07 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 23:29:07 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-231\\AppData\\Roaming', 23:29:07 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 23:29:07 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 23:29:07 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 23:29:07 INFO - 'COMPUTERNAME': 'T-W864-IX-231', 23:29:07 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 23:29:07 INFO - 'DCLOCATION': 'SCL3', 23:29:07 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 23:29:07 INFO - 'FP_NO_HOST_CHECK': 'NO', 23:29:07 INFO - 'HOMEDRIVE': 'C:', 23:29:07 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-231', 23:29:07 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 23:29:07 INFO - 'KTS_VERSION': '1.19c', 23:29:07 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-231\\AppData\\Local', 23:29:07 INFO - 'LOGONSERVER': '\\\\T-W864-IX-231', 23:29:07 INFO - 'MONDIR': 'C:\\Monitor_config\\', 23:29:07 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 23:29:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:07 INFO - 'MOZ_NO_REMOTE': '1', 23:29:07 INFO - 'NO_EM_RESTART': '1', 23:29:07 INFO - 'NUMBER_OF_PROCESSORS': '8', 23:29:07 INFO - 'OS': 'Windows_NT', 23:29:07 INFO - 'OURDRIVE': 'C:', 23:29:07 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', 23:29:07 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 23:29:07 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 23:29:07 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 23:29:07 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 23:29:07 INFO - 'PROCESSOR_LEVEL': '6', 23:29:07 INFO - 'PROCESSOR_REVISION': '1e05', 23:29:07 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 23:29:07 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 23:29:07 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 23:29:07 INFO - 'PROGRAMW6432': 'C:\\Program Files', 23:29:07 INFO - 'PROMPT': '$P$G', 23:29:07 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 23:29:07 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 23:29:07 INFO - 'PUBLIC': 'C:\\Users\\Public', 23:29:07 INFO - 'PWD': 'C:\\slave\\test', 23:29:07 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 23:29:07 INFO - 'SLAVEDIR': 'C:\\slave\\', 23:29:07 INFO - 'SYSTEMDRIVE': 'C:', 23:29:07 INFO - 'SYSTEMROOT': 'C:\\windows', 23:29:07 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 23:29:07 INFO - 'TEST1': 'testie', 23:29:07 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 23:29:07 INFO - 'USERDOMAIN': 'T-W864-IX-231', 23:29:07 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-231', 23:29:07 INFO - 'USERNAME': 'cltbld', 23:29:07 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-231', 23:29:07 INFO - 'WINDIR': 'C:\\windows', 23:29:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 23:29:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:07 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 23:29:07 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-gpbywa-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 23:29:07 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)) 23:29:07 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 23:29:07 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-wqoyre-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 23:29:07 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)) 23:29:07 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 23:29:07 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qxqssm-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 23:29:07 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)) 23:29:07 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 23:29:07 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-3khcgq-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 23:29:07 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)) 23:29:07 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 23:29:07 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-bqxpe_-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 23:29:08 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)) 23:29:08 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 23:29:08 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qztqy3-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 23:29:08 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)) 23:29:08 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 23:29:08 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-1betas-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 23:29:08 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)) 23:29:08 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 23:29:08 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rd9vco-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 23:29:08 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)) 23:29:08 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 23:29:08 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-5yvnpi-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 23:29:08 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)) 23:29:08 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 23:29:08 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jigauw-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 23:29:08 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)) 23:29:08 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 23:29:08 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qcyv02-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 23:29:08 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)) 23:29:08 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 23:29:08 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-8ostpe-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 23:29:09 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)) 23:29:09 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 23:29:09 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-dorg3o-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 23:29:09 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)) 23:29:09 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 23:29:09 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-dqc2fj-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 23:29:09 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)) 23:29:09 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 23:29:09 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-gnmior-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 23:29:09 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)) 23:29:09 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 23:29:09 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rldmuq-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 23:29:09 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)) 23:29:09 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 23:29:09 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-woclo1-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 23:29:09 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)) 23:29:09 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)) 23:29:09 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)) 23:29:09 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)) 23:29:09 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)) 23:29:09 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)) 23:29:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10)) 23:29:09 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 23:29:09 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 23:29:10 INFO - Downloading blessings-1.6.tar.gz 23:29:10 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings 23:29:11 INFO - Installing collected packages: blessings 23:29:11 INFO - Running setup.py install for blessings 23:29:11 INFO - Successfully installed blessings 23:29:11 INFO - Cleaning up... 23:29:14 INFO - Return code: 0 23:29:14 INFO - Done creating virtualenv C:\slave\test\build/venv. 23:29:14 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 23:29:14 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 23:29:14 INFO - Reading from file tmpfile_stdout 23:29:14 INFO - Using _rmtree_windows ... 23:29:14 INFO - Using _rmtree_windows ... 23:29:14 INFO - Current package versions: 23:29:14 INFO - blessings == 1.6 23:29:14 INFO - blobuploader == 1.2.4 23:29:14 INFO - docopt == 0.6.1 23:29:14 INFO - functools32 == 3.2.3-2 23:29:14 INFO - jsonschema == 2.5.1 23:29:14 INFO - manifestparser == 1.1 23:29:14 INFO - mozInstall == 1.12 23:29:14 INFO - mozcrash == 0.17 23:29:14 INFO - mozdebug == 0.1 23:29:14 INFO - mozdevice == 0.48 23:29:14 INFO - mozfile == 1.2 23:29:14 INFO - mozhttpd == 0.7 23:29:14 INFO - mozinfo == 0.9 23:29:14 INFO - mozleak == 0.1 23:29:14 INFO - mozlog == 3.4 23:29:14 INFO - moznetwork == 0.27 23:29:14 INFO - mozprocess == 0.23 23:29:14 INFO - mozprofile == 0.28 23:29:14 INFO - mozrunner == 6.12 23:29:14 INFO - mozscreenshot == 0.1 23:29:14 INFO - mozsystemmonitor == 0.3 23:29:14 INFO - moztest == 0.7 23:29:14 INFO - mozversion == 1.4 23:29:14 INFO - psutil == 3.1.1 23:29:14 INFO - requests == 1.2.3 23:29:14 INFO - Installing None into virtualenv C:\slave\test\build/venv 23: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')]} 23:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23: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')]} 23:29:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:14 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 0x0236C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02413E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0251E0E8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0245AE90>, '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 0x0087A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0283D520>, '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-231', 'USERDOMAIN': 'T-W864-IX-231', '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-231', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-231\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-231', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-231', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-231', '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-231\\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 23:29:14 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 23:29:14 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 23:29:14 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 23:29:14 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-231\\AppData\\Roaming', 23:29:14 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 23:29:14 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 23:29:14 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 23:29:14 INFO - 'COMPUTERNAME': 'T-W864-IX-231', 23:29:14 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 23:29:14 INFO - 'DCLOCATION': 'SCL3', 23:29:14 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 23:29:14 INFO - 'FP_NO_HOST_CHECK': 'NO', 23:29:14 INFO - 'HOMEDRIVE': 'C:', 23:29:14 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-231', 23:29:14 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 23:29:14 INFO - 'KTS_VERSION': '1.19c', 23:29:14 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-231\\AppData\\Local', 23:29:14 INFO - 'LOGONSERVER': '\\\\T-W864-IX-231', 23:29:14 INFO - 'MONDIR': 'C:\\Monitor_config\\', 23:29:14 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 23:29:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:14 INFO - 'MOZ_NO_REMOTE': '1', 23:29:14 INFO - 'NO_EM_RESTART': '1', 23:29:14 INFO - 'NUMBER_OF_PROCESSORS': '8', 23:29:14 INFO - 'OS': 'Windows_NT', 23:29:14 INFO - 'OURDRIVE': 'C:', 23: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', 23:29:14 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 23:29:14 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 23:29:14 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 23:29:14 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 23:29:14 INFO - 'PROCESSOR_LEVEL': '6', 23:29:14 INFO - 'PROCESSOR_REVISION': '1e05', 23:29:14 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 23:29:14 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 23:29:14 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 23:29:14 INFO - 'PROGRAMW6432': 'C:\\Program Files', 23:29:14 INFO - 'PROMPT': '$P$G', 23:29:14 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 23:29:14 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 23:29:14 INFO - 'PUBLIC': 'C:\\Users\\Public', 23:29:14 INFO - 'PWD': 'C:\\slave\\test', 23:29:14 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 23:29:14 INFO - 'SLAVEDIR': 'C:\\slave\\', 23:29:14 INFO - 'SYSTEMDRIVE': 'C:', 23:29:14 INFO - 'SYSTEMROOT': 'C:\\windows', 23:29:14 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 23:29:14 INFO - 'TEST1': 'testie', 23:29:14 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 23:29:14 INFO - 'USERDOMAIN': 'T-W864-IX-231', 23:29:14 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-231', 23:29:14 INFO - 'USERNAME': 'cltbld', 23:29:14 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-231', 23:29:14 INFO - 'WINDIR': 'C:\\windows', 23:29:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 23:29:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:14 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)) 23:29:14 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)) 23:29:14 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)) 23:29:14 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)) 23:29:14 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)) 23:29:14 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)) 23:29:14 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)) 23:29:14 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)) 23:29:14 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)) 23:29:14 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)) 23:29:14 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)) 23:29:14 INFO - Cleaning up... 23:29:14 INFO - Return code: 0 23:29:14 INFO - Installing jsonschema into virtualenv C:\slave\test\build/venv 23: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')]} 23:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23: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')]} 23:29:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0236C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02413E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0251E0E8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0245AE90>, '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 0x0087A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0283D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-231', 'USERDOMAIN': 'T-W864-IX-231', '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-231', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-231\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-231', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-231', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-231', '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-231\\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 23: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', 'jsonschema'] in C:\slave\test\build 23: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 jsonschema 23:29:14 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 23:29:14 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-231\\AppData\\Roaming', 23:29:14 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 23:29:14 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 23:29:14 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 23:29:14 INFO - 'COMPUTERNAME': 'T-W864-IX-231', 23:29:14 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 23:29:14 INFO - 'DCLOCATION': 'SCL3', 23:29:14 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 23:29:14 INFO - 'FP_NO_HOST_CHECK': 'NO', 23:29:14 INFO - 'HOMEDRIVE': 'C:', 23:29:14 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-231', 23:29:14 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 23:29:14 INFO - 'KTS_VERSION': '1.19c', 23:29:14 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-231\\AppData\\Local', 23:29:14 INFO - 'LOGONSERVER': '\\\\T-W864-IX-231', 23:29:14 INFO - 'MONDIR': 'C:\\Monitor_config\\', 23:29:14 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 23:29:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:14 INFO - 'MOZ_NO_REMOTE': '1', 23:29:14 INFO - 'NO_EM_RESTART': '1', 23:29:14 INFO - 'NUMBER_OF_PROCESSORS': '8', 23:29:14 INFO - 'OS': 'Windows_NT', 23:29:14 INFO - 'OURDRIVE': 'C:', 23: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', 23:29:14 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 23:29:14 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 23:29:14 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 23:29:14 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 23:29:14 INFO - 'PROCESSOR_LEVEL': '6', 23:29:14 INFO - 'PROCESSOR_REVISION': '1e05', 23:29:14 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 23:29:14 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 23:29:14 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 23:29:14 INFO - 'PROGRAMW6432': 'C:\\Program Files', 23:29:14 INFO - 'PROMPT': '$P$G', 23:29:14 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 23:29:14 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 23:29:14 INFO - 'PUBLIC': 'C:\\Users\\Public', 23:29:14 INFO - 'PWD': 'C:\\slave\\test', 23:29:14 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 23:29:14 INFO - 'SLAVEDIR': 'C:\\slave\\', 23:29:14 INFO - 'SYSTEMDRIVE': 'C:', 23:29:14 INFO - 'SYSTEMROOT': 'C:\\windows', 23:29:14 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 23:29:14 INFO - 'TEST1': 'testie', 23:29:14 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 23:29:14 INFO - 'USERDOMAIN': 'T-W864-IX-231', 23:29:14 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-231', 23:29:14 INFO - 'USERNAME': 'cltbld', 23:29:14 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-231', 23:29:14 INFO - 'WINDIR': 'C:\\windows', 23:29:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 23:29:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in c:\slave\test\build\venv\lib\site-packages 23:29:15 INFO - Cleaning up... 23:29:15 INFO - Return code: 0 23:29:15 INFO - Running post-action listener: _resource_record_post_action 23:29:15 INFO - Running post-action listener: _start_resource_monitoring 23:29:15 INFO - Starting resource monitoring. 23:29:15 INFO - [mozharness: 2016-10-20 06:29:15.380000Z] Finished create-virtualenv step (success) 23:29:15 INFO - [mozharness: 2016-10-20 06:29:15.380000Z] Running install step. 23:29:15 INFO - Running pre-action listener: _resource_record_pre_action 23:29:15 INFO - Running main action method: install 23:29:15 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 23:29:15 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 23:29:15 INFO - Reading from file tmpfile_stdout 23:29:15 INFO - Using _rmtree_windows ... 23:29:15 INFO - Using _rmtree_windows ... 23:29:15 INFO - Detecting whether we're running mozinstall >=1.0... 23:29:15 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h'] 23:29:15 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h 23:29:15 INFO - Reading from file tmpfile_stdout 23:29:15 INFO - Output received: 23:29:15 INFO - Usage: mozinstall-script.py [options] installer 23:29:15 INFO - Options: 23:29:15 INFO - -h, --help show this help message and exit 23:29:15 INFO - -d DEST, --destination=DEST 23:29:15 INFO - Directory to install application into. [default: 23:29:15 INFO - "C:\slave\test"] 23:29:15 INFO - --app=APP Application being installed. [default: firefox] 23:29:15 INFO - Using _rmtree_windows ... 23:29:15 INFO - Using _rmtree_windows ... 23:29:15 INFO - mkdir: C:\slave\test\build\application 23:29:15 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'] 23:29:15 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 23:29:18 INFO - Reading from file tmpfile_stdout 23:29:18 INFO - Output received: 23:29:18 INFO - C:\slave\test\build\application\firefox\firefox.exe 23:29:18 INFO - Using _rmtree_windows ... 23:29:18 INFO - Using _rmtree_windows ... 23:29:18 INFO - Running post-action listener: _resource_record_post_action 23:29:18 INFO - [mozharness: 2016-10-20 06:29:18.331000Z] Finished install step (success) 23:29:18 INFO - [mozharness: 2016-10-20 06:29:18.331000Z] Running run-tests step. 23:29:18 INFO - Running pre-action listener: _resource_record_pre_action 23:29:18 INFO - Running main action method: run_tests 23:29:18 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version'] 23:29:18 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version 23:29:18 INFO - Python 2.7.3 23:29:18 INFO - Return code: 0 23:29:18 INFO - grabbing minidump binary from tooltool 23: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')]} 23:29:18 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 0x0245AE90>, '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 0x0087A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0283D520>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1 23:29:18 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 23:29:18 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 23:29:18 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 23:29:18 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 23:29:18 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmpdwbcod 23:29:18 INFO - INFO - File integrity verified, renaming tmpdwbcod to win32-minidump_stackwalk.exe 23:29:18 INFO - Return code: 0 23:29:18 INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755 23:29:18 INFO - mkdir: C:\slave\test\build\blobber_upload_dir 23:29:18 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir 23:29:18 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe 23:29:18 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir 23:29:18 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/Ua4yd61JQBqx40qnO5dEfg/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-231', '--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 23:29:18 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/Ua4yd61JQBqx40qnO5dEfg/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip --title T-W864-IX-231 --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 23:29:18 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 23:29:18 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-231\\AppData\\Roaming', 23:29:18 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 23:29:18 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 23:29:18 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 23:29:18 INFO - 'COMPUTERNAME': 'T-W864-IX-231', 23:29:18 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 23:29:18 INFO - 'DCLOCATION': 'SCL3', 23:29:18 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 23:29:18 INFO - 'FP_NO_HOST_CHECK': 'NO', 23:29:18 INFO - 'HOMEDRIVE': 'C:', 23:29:18 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-231', 23:29:18 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 23:29:18 INFO - 'KTS_VERSION': '1.19c', 23:29:18 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-231\\AppData\\Local', 23:29:18 INFO - 'LOGONSERVER': '\\\\T-W864-IX-231', 23:29:18 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir', 23:29:18 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe', 23:29:18 INFO - 'MONDIR': 'C:\\Monitor_config\\', 23:29:18 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 23:29:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:18 INFO - 'MOZ_NO_REMOTE': '1', 23:29:18 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir', 23:29:18 INFO - 'NO_EM_RESTART': '1', 23:29:18 INFO - 'NUMBER_OF_PROCESSORS': '8', 23:29:18 INFO - 'OS': 'Windows_NT', 23:29:18 INFO - 'OURDRIVE': 'C:', 23: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', 23:29:18 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 23:29:18 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 23:29:18 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 23:29:18 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 23:29:18 INFO - 'PROCESSOR_LEVEL': '6', 23:29:18 INFO - 'PROCESSOR_REVISION': '1e05', 23:29:18 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 23:29:18 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 23:29:18 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 23:29:18 INFO - 'PROGRAMW6432': 'C:\\Program Files', 23:29:18 INFO - 'PROMPT': '$P$G', 23:29:18 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 23:29:18 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 23:29:18 INFO - 'PUBLIC': 'C:\\Users\\Public', 23:29:18 INFO - 'PWD': 'C:\\slave\\test', 23:29:18 INFO - 'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos', 23:29:18 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 23:29:18 INFO - 'SLAVEDIR': 'C:\\slave\\', 23:29:18 INFO - 'SYSTEMDRIVE': 'C:', 23:29:18 INFO - 'SYSTEMROOT': 'C:\\windows', 23:29:18 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 23:29:18 INFO - 'TEST1': 'testie', 23:29:18 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 23:29:18 INFO - 'USERDOMAIN': 'T-W864-IX-231', 23:29:18 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-231', 23:29:18 INFO - 'USERNAME': 'cltbld', 23:29:18 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-231', 23:29:18 INFO - 'WINDIR': 'C:\\windows', 23:29:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 23:29:18 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/Ua4yd61JQBqx40qnO5dEfg/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-231', '--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 23:29:19 INFO - mozversion application_buildid: 20161019213008 23:29:19 INFO - mozversion application_changeset: 998ad5a74da80fe63664a8dcf30d8f269ffe4e65 23:29:19 INFO - mozversion application_display_name: Nightly 23:29:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:29:19 INFO - mozversion application_name: Firefox 23:29:19 INFO - mozversion application_remotingname: firefox 23:29:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:29:19 INFO - mozversion application_vendor: Mozilla 23:29:19 INFO - mozversion application_version: 52.0a1 23:29:19 INFO - mozversion platform_buildid: 20161019213008 23:29:19 INFO - mozversion platform_changeset: 998ad5a74da80fe63664a8dcf30d8f269ffe4e65 23:29:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:29:19 INFO - mozversion platform_version: 52.0a1 23:29:19 INFO - using testdate: 1476944959 23:29:19 INFO - actual date: 1476944959 23:29:19 INFO - starting webserver on 'localhost:49285' 23:29:19 INFO - SUITE-START | Running 2 tests 23:29:19 INFO - TEST-START | dromaeo_css 23:29:19 INFO - operating with platform_type : w8_ 23:29:19 INFO - Initialising browser for dromaeo_css test... 23:29:19 INFO - TEST-INFO | started process 1688 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpg9c1lf\profile http://localhost:49285/getInfo.html) 23:29:27 INFO - PROCESS | 1688 | __metrics Screen width/height:1600/1200 23:29:27 INFO - PROCESS | 1688 | colorDepth:24 23:29:27 INFO - PROCESS | 1688 | Browser inner width/height: 1010/674 23:29:27 INFO - PROCESS | 1688 | __metrics 23:29:28 INFO - PROCESS | 1688 | 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" 23:29:28 INFO - PROCESS | 1688 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:29:29 INFO - TEST-INFO | 1688: exit 0 23:29:29 INFO - Browser initialized. 23:29:29 INFO - Running cycle 1/1 for dromaeo_css test... 23:29:29 INFO - TEST-INFO | started process 1228 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpg9c1lf\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:29:29 INFO - PROCESS | 1228 | [GFX1-]: Invalid size in UpdateRenderTarget Size(124,0), 0 23:29:40 INFO - PROCESS | 1228 | RSS: Main: 160059392 23:29:40 INFO - PROCESS | 1228 | 23:30:32 INFO - PROCESS | 1228 | 1476945032273 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] 23:32:42 INFO - PROCESS | 1228 | Cycle 1(1): loaded http://localhost:49285/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49285/tests/dromaeo/cssquery-ext.html) 23:32:45 INFO - PROCESS | 1228 | RSS: Main: 335233024 23:32:45 INFO - PROCESS | 1228 | 23:35:47 INFO - PROCESS | 1228 | Cycle 1(1): loaded http://localhost:49285/tests/dromaeo/cssquery-ext.html (next: http://localhost:49285/tests/dromaeo/cssquery-jquery.html) 23:35:48 INFO - PROCESS | 1228 | RSS: Main: 221663232 23:35:48 INFO - PROCESS | 1228 | 23:38:50 INFO - PROCESS | 1228 | Cycle 1(1): loaded http://localhost:49285/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49285/tests/dromaeo/cssquery-mootools.html) 23:38:51 INFO - PROCESS | 1228 | RSS: Main: 176386048 23:38:51 INFO - PROCESS | 1228 | 23:41:53 INFO - PROCESS | 1228 | Cycle 1(1): loaded http://localhost:49285/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49285/tests/dromaeo/cssquery-prototype.html) 23:41:53 INFO - PROCESS | 1228 | RSS: Main: 178012160 23:41:53 INFO - PROCESS | 1228 | 23:44:56 INFO - PROCESS | 1228 | Cycle 1(1): loaded http://localhost:49285/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49285/tests/dromaeo/cssquery-yui.html) 23:44:57 INFO - PROCESS | 1228 | RSS: Main: 159240192 23:44:57 INFO - PROCESS | 1228 | 23:48:00 INFO - PROCESS | 1228 | Cycle 1(1): loaded http://localhost:49285/tests/dromaeo/cssquery-yui.html (next: http://localhost:49285/tests/dromaeo/cssquery-dojo.html) 23:48:00 INFO - PROCESS | 1228 | RSS: Main: 201900032 23:48:00 INFO - PROCESS | 1228 | 23:48:00 INFO - PROCESS | 1228 | __start_tp_report 23:48:00 INFO - PROCESS | 1228 | _x_x_mozilla_page_load 23:48:00 INFO - PROCESS | 1228 | _x_x_mozilla_page_load_details 23:48:00 INFO - PROCESS | 1228 | |i|pagename|runs| 23:48:00 INFO - PROCESS | 1228 | |0;dojo.html;2744.8490333031677;2752.174347695691;2779.4996900557903;2780.972190278097;2785.1226863537986;4899.755012249387;4953.678010929287;4983.975080124604;4985.576226020784;5031.195008798598;4838.63710221733;4878.634102442322;4928.408590969079;4965.7020578765205;5032.094223039851;4357.869263922087;4389.7269791760355;4392.143532011259;4410.448693913261;4481.731096134243;4313.28830742927;4377.190219809329;4395.802188901507;4409.647228221735;4470;4321.611055005064;4405.2511073117485;4410.75740834254;4417.160739459492;4463.4643842738915;4348.130373925196;4365.476142862877;4390.792532053679;4410.206162890679;4421.137878113769;4310.870673879788;4354.521002689701;4377.212101821671;4381.6494680425485;4420.3369494575745;4895.11887860185;4897.926531102036;4906.607471402279;4914.852554423373;4937.654364194508;5161.354830646169;5209.348831396075;5212.947870521322;5253.001929633358;5298.682079075229;5312.229726689647;5323.920141197885;5341.305630268079;5349.3045904032615;5394.703291318976;4932.112219800434;4933.28467372229;4935.555799978019;4943.530364615356;5004.374453193351;5384.703841288767;5444.373897001896;5445.1832225166545;5447.400785913546;5467.261919640877;5134.358205224347;5181.093308670967;5184.7407629618365;5187.403448603459;5190.636655434083;5277.736113194325;5281.709505977131;5284.81503147388;5288.8413347599635;5290.603204759658;5205.401378841406;5225.346831646044;5229.215617657382;5231.633785635046;5232.39827419844;5209.817656382009;5245.475452454801;5253.290805741252;5254.106801843695;5256.316678831728;3542.167590616203;3555.1112221944513;3558.644135586472;3560;3560.1989552351033;3146.4021835851113;3148.7008734170217;3194.552762613236;3196.3447493263825;3224.629167645704;4874.4150701916;4928.186849169847;4929.926051109236;4934.407871055496;4992.700437973734;5201.349831271091;5224.085784987612;5274.4198138204765;5285.471452854684;5306.708131052752;4813.181759100961;4872.488388719134;4877.439094504107;4908.092002979461;4933.950660493421;4329.403368965636;4346.326319420495;4355;4357.978210108992;4410.272305069628;5265.420803711665;5290.878859384515;5319.175527793275;5325.041492531382;5386.892262154814;5179.689218646893;5213.45258747826;5229.189475631283;5236.423993360651;5286.8942621148135;5321.148616221386;5337.519623233928;5359.4104648487855;5366.919496207482;5368.355797304349;5111;5185.11852985001;5196.298499702491;5202.401723801811;5203.219517072469;5205.297284866495;5251.632385732962;5267.9736601316745;5272.130098533699;5283.1546952487415;5083.466236045162;5095.312132862016;5095.719735414587;5115.2071428928575;5120;5146.639735218649;5162.432132465501;5167.483251674803;5183.481651834786;5209.114450543492;5058.08954388199;5094.490550944876;5098.490150984871;5098.770555324945;5164.922526162186;5073.695578265316;5118.71847048401;5140.588752899834;5144.6398752087;5151.8196863109615;5010.323606313247;5048.268001139888;5062.291279220985;5107.897842043212;5117.948820511747 23:48:00 INFO - PROCESS | 1228 | |1;ext.html;550.221436667116;559.9664020158791;561.6938768371235;562.7270773674767;579.2643342954451;28126.296842578944;36717.265654686926;36909;37458.250834983315;39276.10858371238;39388.212235755265;39655.206895862066;39697.60302396975;39745.403818942665;39745.40381894274;8387.916120838805;8495.447795893248;8525.104863989285;8536.658533658647;8540.78648033798;8356.874646880271;8388.412811103226;8421.368397370192;8454.365922555802;8480;8236.094029656733;8488.193621605968;8490.78773030673;8491.023532293804;8502.532360720157;8425.1153628869;8444.535550544686;8466.449680770731;8468.407211495198;8471.195236452528;8267.793305167359;8317.500949943023;8339.95830020846;8347.499150051017;8368.24685778283;36291.81854090739;36603.4509482358;36708.81645591755;36736;36751;3158.273597072663;3622.6920711739535;3652.6529979652155;3657.871974480907;3726.6273372662786;28276.85861570679;28330.433391332263;28744.568831467546;28914.42171156586;29402.852985734935;3904.45840903;3935.60643935607;3966.801659916993;4027.597240275978;4048.838046478137;284076;286618;287087;287325.9435919754;287757;47696;48000.7599962005;48038;48058;48093.75953120282;29889.701102989126;30629.693703062683;30641.540376894365;32032;49737.021038316845;13488.258145802076;13508.257045862572;13549.864501355058;13556.661083472794;13561;10519.84220236697;10615.946920265504;10617.203709721802;10635.149188064936;10751.892481075245;16240.350385984428;16250.106244156685;16270.75593866093;16290.83709162917;16409.58976025585;6169;6232.220972378453;6243.469305109026;6243.906341404882;6266.185395898595;793.7936136604525;866.2939704141105;867.8394497018072;869.3045563549135;899.5187574647532;27710.077565573218;27892.16323510298;28055.43889122206;28245;28435.857820710764;887.8339929191702;929.2658799548416;934.9205317547949;1022.7954409118206;1027.9162512462613;14206.644833879236;14481.637959050897;14501.564953051426;14527.709445811024;14667.266636668124;411311;412513;413843;415467;415485;47671.523284767405;48279.517204828204;48361.516384835704;48374;48384;1079.740862193068;1100.1034157161728;1147.185498296219;1160.4023927677254;1163.9301641901513;26212.475750484504;28174;28536.42927141404;28592.42815143727;28746.281342966595;40937;41274.58725412707;41435.7928210357;41519.37720934128;41604.58395416128;312539;315187;316934;317075;317987;21373.572528549652;21847.67228491542;21933.341999739394;22061.33815985523;22976.770232297462;33860.49209261814;34347.313053739286;36715.816420918796;38554.03614909537;40280.19439611133;33253;34248.31503369869;34823.25883705855;35052.47421288734;35509.28981420409;34910.301793964485;35031.64968350284;35480;35513;35972;33411.66588334086;33966;34015.319693606485;34250.314993700486;34443.827780860935;30807.69192308138;32315.676843231267;32349;32393.838030809697;32584.51123233201;24032.75967240375;24190.51618967646;24246.87876560606;24515.632265515676;24635.63046554339 23:48:00 INFO - PROCESS | 1228 | |2;jquery.html;296.6929228248763;316.2520638689499;318.0918477746035;321.21463022908983;322.1286420233269;12810.743785124303;13816.240106794123;15917.76123358149;16753.66492670149;17531.298748050063;14698.118112913233;15024.699506009872;15046.172460514666;16149.83850161498;16494.17529123545;5025.522575355344;5045.369328833895;5258.684478931276;5269.3676758789;5289.576833853302;5088.7964481420695;5203.557697595709;5205.349331333583;5206;5208.453112423198;4970.478099799523;5124.333836601237;5137.255098010786;5141.305923700309;5149.201873709562;5067.417247016585;5092.083424983502;5142.228665700156;5152.639315247934;5156.20078887773;4463.174312752151;4464.6874718769695;4464.843730469451;4472.591133792877;4478.664100192466;10982.560697572088;16114.75827862583;18542.165602547917;19976.300829471045;20093.196272149096;1908.6850669639632;2029.2593203480772;2156.2992027591094;2292.2321022457495;2440.9877950610135;7828.882566761503;8107.675692972274;8117.904082948786;8164.6325915333955;8552.828943421158;1646.7941507311587;1721.2684609041232;1722.9138543072922;1751.1244377811095;1773.219783295346;65548.85020331456;68636;69851.65074174647;70320;71378.64310678413;8721.345899057596;8833.779155521035;8960.507172105597;8969.14793094655;9024.954875225712;11605.129615278887;11659.53361865516;11667.824982625267;11670.591529296435;11692.064634829363;6502.577332473374;6683.6324002180345;6719.092922455504;6768.492363072789;6805.863882722318;6487.481001519867;6528.640924749089;6607.867842643121;6610.900836487456;6652.268250492442;3676.852925882988;3686.299603075407;3712.1090938175184;3714.3871261242134;3757.9060523486582;1548.1175729833888;1554.6502037041575;1574.496161228396;1589.6741168060519;1596.4093285484214;768.6310570925987;785.8389030248785;864.7492227254152;895.7044175422095;910.6630546697631;16233.756493652605;16499.67000660004;16581.419650312182;16989.40537081196;17010.31958721662;814.9551774652332;825.0800357601352;830.3647709502236;863.4948555095214;876.1282523888644;8721.781955451164;8963.507007114671;9080.455172689659;9640.276979226586;9781.364211326383;416699;418578;419859;419965;422591;79822.60088699636;80016;80327.19672803197;80726.59636701779;81606.59196704098;810.8945837041265;844.9155084491501;847.8177191903646;850.8638617821242;851.29342645604;14444.411114777156;14719.852801471849;14879.330430130454;15017.399304027716;15222.923885380502;33593.83203083969;34444;34648.653513464546;35016.12459688528;35121.297574047865;43885.34171987359;50424.24363634622;51100;51189;51242.74378628083;6579.111819904251;6640;6660.267370589135;6709.563878347892;6741.258461569321;8954.552272386225;11067.83398249043;11226.438678066228;11410.030147437561;11650.592229271935;9457.716268511957;9457.858132127885;9620.518974051129;10008.749781255236;10320.174386048948;9537.570809313736;9576.760580985252;9795.706128816148;9845.507724613884;9929.65246216379;9491.145796878314;9754.122129008423;9805.330220213124;10249;10508.21188410857;6768.052472653931;6781.440268738316;6857.451403887777;6895.965520172568;6930.203026652;7832.686692532235;9426.57580408897;9455.385399948982;9474.621015159317;9508 23:48:00 INFO - PROCESS | 1228 | |3;mootools.html;1150.5225331487434;1222.547657366774;1257.27706568723;1274.6430999320187;1501.0843385534822;6441.259255185655;7001.824954376137;7235.746748863791;7240.0949881264905;7399.223081576438;7181.425485961124;7235.38499227565;7272.96363518183;7303.8539229215385;7316.341529262365;1949.2495389275125;1970.2611520679745;1973.9111739971736;1974.881507109578;1976.5157536403528;1898.610784789122;1931.430228082712;1933.0045026811204;1933.6519426503223;1935.8257756801886;1888.6222755448896;1889.4142815727168;1891.4231159496348;1897.2411035585808;1897.4307707687708;1849.4266777299013;1896.3457607125588;1897.2411035585737;1898.981010189901;1908.532409559653;1855.2115350975916;1874.2784028149124;1880;1880.6614809334314;1886.7452893859427;7191.89212161818;7330.780076597657;7340.155882073576;7409.48133630646;7607.80980475487;4275.40144379787;4393.428854248959;4397;4398.406215160944;4404.317330813729;2730.426610411816;2826.816256943292;2857.3856620826623;2876.424715056976;2888.9711102889123;954.3680306675593;969.3360048366891;971.028971028971;979.774651830076;982.4105536678007;9916.909139994596;9968;9986.500674966295;10039.24705647072;10124.088832005082;3578.355895938756;3593.838277277529;3663.7069034477177;3667.7249206309634;3675.3016926783826;7835.177306382861;7839.568823714751;7839.764807055797;7846.136924938252;7916.247956444128;4221.493420789464;4222.894427639334;4224.4508213931995;4231.978840105841;4265.253580623441;3662.340778659867;3772.13240954582;3977.4033894915992;3996.540397854284;4004.6996475264473;3033.8634761435787;3105.2547388627017;3170.9207269817975;3199.504076868089;3202.663720309334;895.3374502867961;897.7755561109723;898.9640414383351;906.6600024990629;924.2605915267893;650.9869802603921;743.9993209133706;748.292863244229;806.7257132574953;836.3142223376773;4706.317583950308;4844.878878028077;5059.62052846038;5071.695698258116;5175.948240517547;328.67625388991826;343.03777902982375;344.18943388320645;355.09450900204376;355.9092431429969;3452.102453362094;3488.4418493040994;3510.684038436502;3515.4199557072798;3557.626449222846;8508.872366914502;8878.023417424078;8899.466032037968;8901.73294801157;8917.10828917103;8839.734807955772;8840.204381605687;8840.204381605687;8857.955710221537;8869.645214191489;6710.027046078389;6821.522493425512;6835.1114355134505;6886.931130688629;6895.689693963784;4845.248986407112;4884.682495637772;4890.828820991248;4896.290037944407;4993.675411098267;7969.721059763112;8088.595570221348;8223.136570659995;8244.670213191404;8279.172082791914;8179;8315.210055044761;8391.874121888299;8402;8453.830923381374;5473.808416705396;5777;5949.405059494016;5982.341942386421;6010.789622363196;6520.41316281518;6778.796636100925;7079.858402831812;7127.322904324081;7216.927830721836;6550.313933472035;6617.735290588323;6626.403623673892;6714.966425168039;6729.596224226562;6372.808815735535;6450.193725784277;6498.3826536478955;6535.934640653532;6564.146660934048;5881.088431293157;6005.609635373687;6009.7295621698;6010.1285313628405;6097.451229389376;4098.159877225221;4104.774237416971;4141.047559061372;4149.419081328677;4219.177260434309;4098.7950602470355;4101.589841015994;4129.648979836627;4176.206520761046;4229.13302772937 23:48:00 INFO - PROCESS | 1228 | |4;prototype.html;249.7664683520908;256.8369085630624;258.52173479063737;261.93713508757895;268.7366380946672;5040.924386134211;5090;5114.514121158489;5120.4623514530995;5135.435102138762;4888.584470320027;5060.595152387809;5079.384117179656;5094.439611642726;5109.156989096795;3569.607343192247;3719.311927293446;3728.6830619397247;3746.3631182699005;3753.943690844633;3685.963140368589;3693.741438099334;3714.9814250928707;3717.8103007037757;3734.775913445202;3663.7069034477177;3681.742278040538;3742.270257299828;3756.1173124315765;3779.6787273081823;3724.217914237986;3730.682891954187;3734.850605975758;3736.103335199546;3740.2893450244364;3125.499760115135;3169.9207519811957;3175.6983086606733;3192.74458043356;3198.328351046283;4937.506249375069;4938.308636790852;4947.713594465429;4949.727764972925;4960.925586116211;4313.935290970638;4320.935185972213;4329.502107257643;4329.610335069828;4362.585554372329;5105.540501354859;5275.683458992473;5303.628745987782;5314.282571852789;5366.91949620756;3513.1568423578415;3518;3518.1556426457464;3524.54180956474;3555.8044307563073;5585.748641311151;5593.188987596816;5620.185073164409;5624.690642014688;5632.746526406321;3555.7333200009584;3557.1996300832106;3557.3952428087287;3560.537130173113;3567.090391950036;3513.332466831294;3590.9102272443397;3601.3517566837695;3620.3483372992587;3631.5642122944887;4261.850835220753;4269.765162916069;4280.700350975402;4282.057947251599;4284.057507348379;5347.946520534745;5355.196720491957;5377.623566350318;5380.946190538123;5381.8967111741995;1194.9761004779855;1229.3361584744316;1257.9308138052495;1258.5154715434624;1273.1978853322348;755.1089714137371;762.5196126440308;764.5183534373309;768.8654485465021;769.9836216194569;4346.9571300090065;4416.570886012681;4445.333200019958;4491;4492.3710680504755;5284.603654725911;5377.811776587879;5461.344638643309;5541.972290138524;5542.2795036644975;5101.336826212569;5108.6168537359845;5111.412187598474;5124.205748109049;5168.431472538018;2829.2926768307925;2897.9277667262827;2922.225610213295;2931.721486458783;2953.74893134086;5593.244911936918;5603.27382290772;5613.438656134354;5633.2395126657375;5648.181013752983;5583.274174357308;5593.496585307342;5611.306572844976;5638.633488823213;5671.688057156896;5339.741154295914;5560.7219639017885;5615.354234263112;5627.606067575231;5639.859003524863;5499;5503;5530.723463826873;5541.889162216652;5556.416111608071;5283.128283833124;5451.727413629382;5455.454454554513;5480.013597552479;5486.396496385474;5553.611597100725;5576.302962129734;5577.410438025144;5592.972035139798;5675.148727690715;3577.4633804929467;3581.086822860154;3591.92242327306;3592.9281414371044;3597.496350510878;5281.471852814688;5520.660000699519;5574.721263936868;5583.426606971622;5587.608867379245;5333.866653333697;5341.786328546815;5342.813001544927;5352.330958630171;5418.295621569171;5350.759215835375;5369.785208591613;5371.677699338053;5434.429384914527;5461.208124821958;5062.341895553554;5327.764427280244;5355.732213389237;5364.4099149094345;5383.865403364791;5448.50166204297;5453.454654534674;5456.345238571238;5463.562914966714;5504.6421982571;5115.87210319745;5279.125910301787;5281.966442919427;5292.02097611943;5400.621956463167 23:48:00 INFO - PROCESS | 1228 | |5;yui.html;646.2471221027503;724.3951300663946;728.9321144523273;735.2316828913788;740.885162799766;13225.404856781444;13873.722525549496;14459.349329280181;14608.780868286984;15317.617059573517;13970.16179029259;14321.355539000744;14323.355449004794;14371.64070898228;14394.136351818897;659.2451642868912;672.6434989455596;673.632870085802;675.1560549313358;675.267334941589;555.9555235581164;572.2246356187347;638.0588631768152;657.6415853359906;661.6923130744203;699.0562740300604;700.5061431690646;701.4038067642514;701.8947157926326;710.8009757267973;696.3419568507762;697.0763738047083;697.2713514377488;700.9649517524155;701.8701540215051;428.1693514581701;436.6659505478312;438.25934171250486;438.53515273809546;441.4305545845855;12372.257664540157;12738.299393533352;12963.87036129636;13370.532031378854;13391.263480508567;11888.465019074163;12355;12448.190867593668;12475.812862807064;12997.610071697864;11095.83356249657;11114.944425277821;11198.552057917674;11268.774624507547;11494.597689080925;3459.9827000865084;3463.8268086595567;3470.7570470067108;3489.8778542751134;3504.1414853360834;73005.26994730091;73210.63394683045;73299;73310.6334468335;73519;9643.373180743229;9651.276154288456;9668.468234247042;9700.417974921527;9863.704088877344;17472.65054698899;17540.91229543844;17564.209610567556;17599.20803563843;17606.823931760773;7199.06412166415;7267.418606511466;7281.5631062136445;7441.55350678961;7526.209747976493;3688.893332000443;3759.0790256386813;3812.1422679897355;3852.4221366794645;3915.256101340736;2793.3435642623967;2879.12186783029;2888.2923683697627;3032.938471534945;3165.984170079181;526.8656492594364;528.2340606121139;533.4718628557778;537.0226188337189;540.2085944091924;472.9219678753036;525.6399366434005;670.6143967218869;672.1060988884772;686.2656957056003;8903.376763626484;9130.589123489459;9315.115064068903;9361.578728957213;9476.668316608886;589.3105067071536;642.6728805017624;650.4861159683796;653.2552889705739;654.630133974303;4242.978785106116;4412.382266482695;4452.332150177434;4489.371487991683;4571.474280457724;98791;101169.49415253024;101703;101909;103563.4821825886;85049;87098.12901871027;89379.10620893838;90174;91306;56999;75594.22028898534;75618.62190689122;77355.22644773593;77547;8254.958725206576;8341.17216044658;8724.171203735636;8730.257928076184;8774.301276189759;44844.32733508935;45184.54815451935;45234.77382613066;45436.318455222536;47105.52894471012;51257.743711281204;65276.67361663161;66962;67224.3277567218;67588.6620566894;10269.794604107727;10318.587256509656;10457.372557646566;10467.581296748045;10922.56309747633;12567.87432125667;13241.80137297922;13745.862541374858;13796.517121900686;13901.58295251144;12753.362331883183;13374.06381553282;13552.457901683822;13563.118397304144;13678.384472698554;12780.36098195068;13375.665608359479;13431.664208394868;13553.525626603021;13636.727265454834;12060.336681482602;12458.626241212778;12532.812007820072;12721;12890.29103399322;9849.212063035084;10152;10280.897191027994;10555.788884222118;10621.468926553487;10613.204009699459;10726.184860597272;10782.514786834769;10957.780844382909;11120 23:48:00 INFO - PROCESS | 1228 | __end_tp_report 23:48:00 INFO - PROCESS | 1228 | __start_cc_report 23:48:00 INFO - PROCESS | 1228 | _x_x_mozilla_cycle_collect,2189 23:48:00 INFO - PROCESS | 1228 | __end_cc_report 23:48:00 INFO - PROCESS | 1228 | __startTimestamp1476946080681__endTimestamp 23:48:00 INFO - PROCESS | 1228 | 23:48:00 INFO - PROCESS | 1228 | ------- Summary: start ------- 23:48:00 INFO - PROCESS | 1228 | Number of tests: 6 23:48:00 INFO - PROCESS | 1228 | 23:48:00 INFO - PROCESS | 1228 | [#0] dojo.html Cycles:165 Average:4833.37 Median:5095.31 stddev:626.72 (12.3%) stddev-sans-first:606.85 23:48:00 INFO - PROCESS | 1228 | Values: 2744.8 2752.2 2779.5 2781.0 2785.1 4899.8 4953.7 4984.0 4985.6 5031.2 4838.6 4878.6 4928.4 4965.7 5032.1 4357.9 4389.7 4392.1 4410.4 4481.7 4313.3 4377.2 4395.8 4409.6 4470.0 4321.6 4405.3 4410.8 4417.2 4463.5 4348.1 4365.5 4390.8 4410.2 4421.1 4310.9 4354.5 4377.2 4381.6 4420.3 4895.1 4897.9 4906.6 4914.9 4937.7 5161.4 5209.3 5212.9 5253.0 5298.7 5312.2 5323.9 5341.3 5349.3 5394.7 4932.1 4933.3 4935.6 4943.5 5004.4 5384.7 5444.4 5445.2 5447.4 5467.3 5134.4 5181.1 5184.7 5187.4 5190.6 5277.7 5281.7 5284.8 5288.8 5290.6 5205.4 5225.3 5229.2 5231.6 5232.4 5209.8 5245.5 5253.3 5254.1 5256.3 3542.2 3555.1 3558.6 3560.0 3560.2 3146.4 3148.7 3194.6 3196.3 3224.6 4874.4 4928.2 4929.9 4934.4 4992.7 5201.3 5224.1 5274.4 5285.5 5306.7 4813.2 4872.5 4877.4 4908.1 4934.0 4329.4 4346.3 4355.0 4358.0 4410.3 5265.4 5290.9 5319.2 5325.0 5386.9 5179.7 5213.5 5229.2 5236.4 5286.9 5321.1 5337.5 5359.4 5366.9 5368.4 5111.0 5185.1 5196.3 5202.4 5203.2 5205.3 5251.6 5268.0 5272.1 5283.2 5083.5 5095.3 5095.7 5115.2 5120.0 5146.6 5162.4 5167.5 5183.5 5209.1 5058.1 5094.5 5098.5 5098.8 5164.9 5073.7 5118.7 5140.6 5144.6 5151.8 5010.3 5048.3 5062.3 5107.9 5117.9 23:48:00 INFO - PROCESS | 1228 | 23:48:00 INFO - PROCESS | 1228 | [#1] ext.html Cycles:180 Average:47742.38 Median:19957.26 stddev:90548.58 (453.7%) stddev-sans-first:90733.26 23:48:00 INFO - PROCESS | 1228 | Values: 550.2 560.0 561.7 562.7 579.3 28126.3 36717.3 36909.0 37458.3 39276.1 39388.2 39655.2 39697.6 39745.4 39745.4 8387.9 8495.4 8525.1 8536.7 8540.8 8356.9 8388.4 8421.4 8454.4 8480.0 8236.1 8488.2 8490.8 8491.0 8502.5 8425.1 8444.5 8466.4 8468.4 8471.2 8267.8 8317.5 8340.0 8347.5 8368.2 36291.8 36603.5 36708.8 36736.0 36751.0 3158.3 3622.7 3652.7 3657.9 3726.6 28276.9 28330.4 28744.6 28914.4 29402.9 3904.5 3935.6 3966.8 4027.6 4048.8 284076.0 286618.0 287087.0 287325.9 287757.0 47696.0 48000.8 48038.0 48058.0 48093.8 29889.7 30629.7 30641.5 32032.0 49737.0 13488.3 13508.3 13549.9 13556.7 13561.0 10519.8 10615.9 10617.2 10635.1 10751.9 16240.4 16250.1 16270.8 16290.8 16409.6 6169.0 6232.2 6243.5 6243.9 6266.2 793.8 866.3 867.8 869.3 899.5 27710.1 27892.2 28055.4 28245.0 28435.9 887.8 929.3 934.9 1022.8 1027.9 14206.6 14481.6 14501.6 14527.7 14667.3 411311.0 412513.0 413843.0 415467.0 415485.0 47671.5 48279.5 48361.5 48374.0 48384.0 1079.7 1100.1 1147.2 1160.4 1163.9 26212.5 28174.0 28536.4 28592.4 28746.3 40937.0 41274.6 41435.8 41519.4 41604.6 312539.0 315187.0 316934.0 317075.0 317987.0 21373.6 21847.7 21933.3 22061.3 22976.8 33860.5 34347.3 36715.8 38554.0 40280.2 33253.0 34248.3 34823.3 35052.5 35509.3 34910.3 35031.6 35480.0 35513.0 35972.0 33411.7 33966.0 34015.3 34250.3 34443.8 30807.7 32315.7 32349.0 32393.8 32584.5 24032.8 24190.5 24246.9 24515.6 24635.6 23:48:00 INFO - PROCESS | 1228 | 23:48:00 INFO - PROCESS | 1228 | [#2] jquery.html Cycles:180 Average:24558.60 Median:5139.28 stddev:69254.76 (1347.6%) stddev-sans-first:69425.08 23:48:00 INFO - PROCESS | 1228 | Values: 296.7 316.3 318.1 321.2 322.1 12810.7 13816.2 15917.8 16753.7 17531.3 14698.1 15024.7 15046.2 16149.8 16494.2 5025.5 5045.4 5258.7 5269.4 5289.6 5088.8 5203.6 5205.3 5206.0 5208.5 4970.5 5124.3 5137.3 5141.3 5149.2 5067.4 5092.1 5142.2 5152.6 5156.2 4463.2 4464.7 4464.8 4472.6 4478.7 10982.6 16114.8 18542.2 19976.3 20093.2 1908.7 2029.3 2156.3 2292.2 2441.0 7828.9 8107.7 8117.9 8164.6 8552.8 1646.8 1721.3 1722.9 1751.1 1773.2 65548.9 68636.0 69851.7 70320.0 71378.6 8721.3 8833.8 8960.5 8969.1 9025.0 11605.1 11659.5 11667.8 11670.6 11692.1 6502.6 6683.6 6719.1 6768.5 6805.9 6487.5 6528.6 6607.9 6610.9 6652.3 3676.9 3686.3 3712.1 3714.4 3757.9 1548.1 1554.7 1574.5 1589.7 1596.4 768.6 785.8 864.7 895.7 910.7 16233.8 16499.7 16581.4 16989.4 17010.3 815.0 825.1 830.4 863.5 876.1 8721.8 8963.5 9080.5 9640.3 9781.4 416699.0 418578.0 419859.0 419965.0 422591.0 79822.6 80016.0 80327.2 80726.6 81606.6 810.9 844.9 847.8 850.9 851.3 14444.4 14719.9 14879.3 15017.4 15222.9 33593.8 34444.0 34648.7 35016.1 35121.3 43885.3 50424.2 51100.0 51189.0 51242.7 6579.1 6640.0 6660.3 6709.6 6741.3 8954.6 11067.8 11226.4 11410.0 11650.6 9457.7 9457.9 9620.5 10008.7 10320.2 9537.6 9576.8 9795.7 9845.5 9929.7 9491.1 9754.1 9805.3 10249.0 10508.2 6768.1 6781.4 6857.5 6896.0 6930.2 7832.7 9426.6 9455.4 9474.6 9508.0 23:48:00 INFO - PROCESS | 1228 | 23:48:00 INFO - PROCESS | 1228 | [#3] mootools.html Cycles:180 Average:4724.33 Median:5123.82 stddev:2697.17 (52.6%) stddev-sans-first:2691.37 23:48:00 INFO - PROCESS | 1228 | Values: 1150.5 1222.5 1257.3 1274.6 1501.1 6441.3 7001.8 7235.7 7240.1 7399.2 7181.4 7235.4 7273.0 7303.9 7316.3 1949.2 1970.3 1973.9 1974.9 1976.5 1898.6 1931.4 1933.0 1933.7 1935.8 1888.6 1889.4 1891.4 1897.2 1897.4 1849.4 1896.3 1897.2 1899.0 1908.5 1855.2 1874.3 1880.0 1880.7 1886.7 7191.9 7330.8 7340.2 7409.5 7607.8 4275.4 4393.4 4397.0 4398.4 4404.3 2730.4 2826.8 2857.4 2876.4 2889.0 954.4 969.3 971.0 979.8 982.4 9916.9 9968.0 9986.5 10039.2 10124.1 3578.4 3593.8 3663.7 3667.7 3675.3 7835.2 7839.6 7839.8 7846.1 7916.2 4221.5 4222.9 4224.5 4232.0 4265.3 3662.3 3772.1 3977.4 3996.5 4004.7 3033.9 3105.3 3170.9 3199.5 3202.7 895.3 897.8 899.0 906.7 924.3 651.0 744.0 748.3 806.7 836.3 4706.3 4844.9 5059.6 5071.7 5175.9 328.7 343.0 344.2 355.1 355.9 3452.1 3488.4 3510.7 3515.4 3557.6 8508.9 8878.0 8899.5 8901.7 8917.1 8839.7 8840.2 8840.2 8858.0 8869.6 6710.0 6821.5 6835.1 6886.9 6895.7 4845.2 4884.7 4890.8 4896.3 4993.7 7969.7 8088.6 8223.1 8244.7 8279.2 8179.0 8315.2 8391.9 8402.0 8453.8 5473.8 5777.0 5949.4 5982.3 6010.8 6520.4 6778.8 7079.9 7127.3 7216.9 6550.3 6617.7 6626.4 6715.0 6729.6 6372.8 6450.2 6498.4 6535.9 6564.1 5881.1 6005.6 6009.7 6010.1 6097.5 4098.2 4104.8 4141.0 4149.4 4219.2 4098.8 4101.6 4129.6 4176.2 4229.1 23:48:00 INFO - PROCESS | 1228 | 23:48:00 INFO - PROCESS | 1228 | [#4] prototype.html Cycles:180 Average:4391.35 Median:5110.28 stddev:1385.68 (27.1%) stddev-sans-first:1354.25 23:48:00 INFO - PROCESS | 1228 | Values: 249.8 256.8 258.5 261.9 268.7 5040.9 5090.0 5114.5 5120.5 5135.4 4888.6 5060.6 5079.4 5094.4 5109.2 3569.6 3719.3 3728.7 3746.4 3753.9 3686.0 3693.7 3715.0 3717.8 3734.8 3663.7 3681.7 3742.3 3756.1 3779.7 3724.2 3730.7 3734.9 3736.1 3740.3 3125.5 3169.9 3175.7 3192.7 3198.3 4937.5 4938.3 4947.7 4949.7 4960.9 4313.9 4320.9 4329.5 4329.6 4362.6 5105.5 5275.7 5303.6 5314.3 5366.9 3513.2 3518.0 3518.2 3524.5 3555.8 5585.7 5593.2 5620.2 5624.7 5632.7 3555.7 3557.2 3557.4 3560.5 3567.1 3513.3 3590.9 3601.4 3620.3 3631.6 4261.9 4269.8 4280.7 4282.1 4284.1 5347.9 5355.2 5377.6 5380.9 5381.9 1195.0 1229.3 1257.9 1258.5 1273.2 755.1 762.5 764.5 768.9 770.0 4347.0 4416.6 4445.3 4491.0 4492.4 5284.6 5377.8 5461.3 5542.0 5542.3 5101.3 5108.6 5111.4 5124.2 5168.4 2829.3 2897.9 2922.2 2931.7 2953.7 5593.2 5603.3 5613.4 5633.2 5648.2 5583.3 5593.5 5611.3 5638.6 5671.7 5339.7 5560.7 5615.4 5627.6 5639.9 5499.0 5503.0 5530.7 5541.9 5556.4 5283.1 5451.7 5455.5 5480.0 5486.4 5553.6 5576.3 5577.4 5593.0 5675.1 3577.5 3581.1 3591.9 3592.9 3597.5 5281.5 5520.7 5574.7 5583.4 5587.6 5333.9 5341.8 5342.8 5352.3 5418.3 5350.8 5369.8 5371.7 5434.4 5461.2 5062.3 5327.8 5355.7 5364.4 5383.9 5448.5 5453.5 5456.3 5463.6 5504.6 5115.9 5279.1 5282.0 5292.0 5400.6 23:48:00 INFO - PROCESS | 1228 | 23:48:00 INFO - PROCESS | 1228 | [#5] yui.html Cycles:180 Average:18538.56 Median:24648.33 stddev:26534.73 (107.7%) stddev-sans-first:26575.16 23:48:00 INFO - PROCESS | 1228 | Values: 646.2 724.4 728.9 735.2 740.9 13225.4 13873.7 14459.3 14608.8 15317.6 13970.2 14321.4 14323.4 14371.6 14394.1 659.2 672.6 673.6 675.2 675.3 556.0 572.2 638.1 657.6 661.7 699.1 700.5 701.4 701.9 710.8 696.3 697.1 697.3 701.0 701.9 428.2 436.7 438.3 438.5 441.4 12372.3 12738.3 12963.9 13370.5 13391.3 11888.5 12355.0 12448.2 12475.8 12997.6 11095.8 11114.9 11198.6 11268.8 11494.6 3460.0 3463.8 3470.8 3489.9 3504.1 73005.3 73210.6 73299.0 73310.6 73519.0 9643.4 9651.3 9668.5 9700.4 9863.7 17472.7 17540.9 17564.2 17599.2 17606.8 7199.1 7267.4 7281.6 7441.6 7526.2 3688.9 3759.1 3812.1 3852.4 3915.3 2793.3 2879.1 2888.3 3032.9 3166.0 526.9 528.2 533.5 537.0 540.2 472.9 525.6 670.6 672.1 686.3 8903.4 9130.6 9315.1 9361.6 9476.7 589.3 642.7 650.5 653.3 654.6 4243.0 4412.4 4452.3 4489.4 4571.5 98791.0 101169.5 101703.0 101909.0 103563.5 85049.0 87098.1 89379.1 90174.0 91306.0 56999.0 75594.2 75618.6 77355.2 77547.0 8255.0 8341.2 8724.2 8730.3 8774.3 44844.3 45184.5 45234.8 45436.3 47105.5 51257.7 65276.7 66962.0 67224.3 67588.7 10269.8 10318.6 10457.4 10467.6 10922.6 12567.9 13241.8 13745.9 13796.5 13901.6 12753.4 13374.1 13552.5 13563.1 13678.4 12780.4 13375.7 13431.7 13553.5 13636.7 12060.3 12458.6 12532.8 12721.0 12890.3 9849.2 10152.0 10280.9 10555.8 10621.5 10613.2 10726.2 10782.5 10957.8 11120.0 23:48:00 INFO - PROCESS | 1228 | -------- Summary: end -------- 23:48:00 INFO - PROCESS | 1228 | 23:48:01 INFO - TEST-INFO | 1228: exit 0 23:48:02 INFO - TEST-OK | dromaeo_css | took 1122404ms 23:48:02 INFO - TEST-START | kraken 23:48:02 INFO - operating with platform_type : w8_ 23:48:02 INFO - Initialising browser for kraken test... 23:48:02 INFO - TEST-INFO | started process 3172 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpxneh8f\profile http://localhost:49285/getInfo.html) 23:48:07 INFO - PROCESS | 3172 | __metrics Screen width/height:1600/1200 23:48:07 INFO - PROCESS | 3172 | colorDepth:24 23:48:07 INFO - PROCESS | 3172 | Browser inner width/height: 1010/674 23:48:07 INFO - PROCESS | 3172 | __metrics 23:48:08 INFO - PROCESS | 3172 | 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" 23:48:08 INFO - PROCESS | 3172 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:48:08 INFO - PROCESS | 3172 | console.error: 23:48:08 INFO - PROCESS | 3172 | Message: Error: Connection closed before committing the transaction. 23:48:08 INFO - PROCESS | 3172 | Stack: 23:48:08 INFO - PROCESS | 3172 | ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:937:23 23:48:08 INFO - PROCESS | 3172 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7 23:48:08 INFO - PROCESS | 3172 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11 23:48:08 INFO - PROCESS | 3172 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7 23:48:08 INFO - PROCESS | 3172 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:714:7 23:48:08 INFO - PROCESS | 3172 | TaskImpl_run@resource://gre/modules/Task.jsm:327:15 23:48:08 INFO - PROCESS | 3172 | Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:551:9 23:48:08 INFO - PROCESS | 3172 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15 23:48:08 INFO - PROCESS | 3172 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:388:5 23:48:08 INFO - PROCESS | 3172 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29 23:48:08 INFO - PROCESS | 3172 | Barrier/this.client.addBlocker/promise13.5% 23:49:05 INFO - TinderboxPrint: I/O read bytes / time
40,311,808 / 448,310 23:49:05 INFO - TinderboxPrint: I/O write bytes / time
404,209,152 / 3,263,140 23:49:05 INFO - TinderboxPrint: CPU idle
8,232.7 (86.5%) 23:49:05 INFO - TinderboxPrint: CPU user
1,230.2 (12.9%) 23:49:05 INFO - install - Wall time: 3s; CPU: 12.0%; Read bytes: 92672; Write bytes: 36695040; Read time: 9730; Write time: 61010 23:49:05 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 39977984; Write bytes: 314384896; Read time: 432310; Write time: 3099040 23:49:05 INFO - Running post-run listener: _upload_blobber_files 23:49:05 INFO - Blob upload gear active. 23:49:05 INFO - Preparing to upload files from C:\slave\test\build\blobber_upload_dir. 23:49:05 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 23:49:05 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'] 23:49:05 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 23:49:06 INFO - (blobuploader) - INFO - Open directory for files ... 23:49:06 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_errorsummary.log ... 23:49:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:49:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:49:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:49:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:49:07 INFO - (blobuploader) - INFO - Done attempting. 23:49:07 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_raw.log ... 23:49:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:49:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:49:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:49:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:49:08 INFO - (blobuploader) - INFO - Done attempting. 23:49:08 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\resource-usage.json ... 23:49:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:49:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:49:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:49:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:49:10 INFO - (blobuploader) - INFO - Done attempting. 23:49:10 INFO - (blobuploader) - INFO - Iteration through files over. 23:49:10 INFO - Return code: 0 23:49:10 INFO - rmtree: C:\slave\test\build\uploaded_files.json 23:49:10 INFO - Using _rmtree_windows ... 23:49:10 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build\\uploaded_files.json',), kwargs: {}, attempt #1 23:49:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fb8c785b5de004ce58d740d6193bc57be7a31155d1d6fd3fdb127c654df761034cca381ea163b75e2be1bb469efab3a00efba165a61c09cb05913ae04e363bc1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aed3c0177caee53029c630a260c42b9c85fb55f42d9ce404a5553bb4130a82dcd1d911c203db1fbf9de0e2e183d38f2d47a21bf9804facad88c68cbc53033f10", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f6f145c7c0d0aea5ce5729bdc97ac5032d7422a56c0d281af2cc2f1d034f5f0b82fa7cc97f4aa74ec583c8f7a310bd608adc713ff5486f5fb72649e40f017a57"} 23:49:10 INFO - Writing buildbot properties ['blobber_files'] to C:\slave\test\properties\blobber_files 23:49:10 INFO - Writing to file C:\slave\test\properties\blobber_files 23:49:10 INFO - Contents: 23:49:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fb8c785b5de004ce58d740d6193bc57be7a31155d1d6fd3fdb127c654df761034cca381ea163b75e2be1bb469efab3a00efba165a61c09cb05913ae04e363bc1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aed3c0177caee53029c630a260c42b9c85fb55f42d9ce404a5553bb4130a82dcd1d911c203db1fbf9de0e2e183d38f2d47a21bf9804facad88c68cbc53033f10", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f6f145c7c0d0aea5ce5729bdc97ac5032d7422a56c0d281af2cc2f1d034f5f0b82fa7cc97f4aa74ec583c8f7a310bd608adc713ff5486f5fb72649e40f017a57"} 23:49:10 INFO - Running post-run listener: copy_logs_to_upload_dir 23:49:10 INFO - Copying logs to upload dir... 23:49:10 INFO - mkdir: C:\slave\test\build\upload\logs 23:49:10 INFO - Copying logs to upload dir... 23:49:10 INFO - Using _rmtree_windows ... 23:49:10 INFO - Using _rmtree_windows ... 23:49:10 INFO - Using _rmtree_windows ... 23:49:10 INFO - Using _rmtree_windows ... 23:49:10 INFO - Using _rmtree_windows ... 23:49:10 INFO - Using _rmtree_windows ... 23:49:10 INFO - Using _rmtree_windows ... program finished with exit code 0 elapsedTime=1341.560000 ========= master_lag: 0.04 ========= ========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 22 mins, 21 secs) (at 2016-10-19 23:49:10.523940) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 23:49:10.524913) ========= '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-231\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-231 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-231 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-231\AppData\Local LOGONSERVER=\\T-W864-IX-231 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-231 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-231 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-231 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/fb8c785b5de004ce58d740d6193bc57be7a31155d1d6fd3fdb127c654df761034cca381ea163b75e2be1bb469efab3a00efba165a61c09cb05913ae04e363bc1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aed3c0177caee53029c630a260c42b9c85fb55f42d9ce404a5553bb4130a82dcd1d911c203db1fbf9de0e2e183d38f2d47a21bf9804facad88c68cbc53033f10", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f6f145c7c0d0aea5ce5729bdc97ac5032d7422a56c0d281af2cc2f1d034f5f0b82fa7cc97f4aa74ec583c8f7a310bd608adc713ff5486f5fb72649e40f017a57"} build_url:https://queue.taskcluster.net/v1/task/Ua4yd61JQBqx40qnO5dEfg/artifacts/public/build/firefox-52.0a1.en-US.win64.zip program finished with exit code 0 elapsedTime=0.101000 build_url: 'https://queue.taskcluster.net/v1/task/Ua4yd61JQBqx40qnO5dEfg/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/fb8c785b5de004ce58d740d6193bc57be7a31155d1d6fd3fdb127c654df761034cca381ea163b75e2be1bb469efab3a00efba165a61c09cb05913ae04e363bc1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aed3c0177caee53029c630a260c42b9c85fb55f42d9ce404a5553bb4130a82dcd1d911c203db1fbf9de0e2e183d38f2d47a21bf9804facad88c68cbc53033f10", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f6f145c7c0d0aea5ce5729bdc97ac5032d7422a56c0d281af2cc2f1d034f5f0b82fa7cc97f4aa74ec583c8f7a310bd608adc713ff5486f5fb72649e40f017a57"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 23:49:10.647608) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 23:49:10.647993) ========= '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-231\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-231 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-231 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-231\AppData\Local LOGONSERVER=\\T-W864-IX-231 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-231 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-231 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-231 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=0.101000 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 23:49:10.768293) ========= ========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-10-19 23:49:10.768668) ========= ========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-10-19 23:49:11.311857) ========= ========= Total master_lag: 0.31 =========