builder: mozilla-central_win8_64_test-dromaeojs-pgo slave: t-w864-ix-208 starttime: 1476638623.49 results: success (0) buildid: 20161016073001 builduid: 52ab78f8c15342c38a89ce65c3130b98 revision: 9079d167112122805f99f57bb8856e1b1675af0f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-16 10:23:43.490231) ========= master: http://buildbot-master109.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-16 10:23:43.490681) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-16 10:23:43.490955) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-16 10:23:43.618535) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-10-16 10:23:43.618946) ========= '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-208\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-208 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-208 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-208\AppData\Local LOGONSERVER=\\T-W864-IX-208 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-208 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-208 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-208 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False --10:23: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% 8.26 MB/s 10:23:44 (8.26 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=1.133000 ========= master_lag: 3.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-10-16 10:23:47.849790) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 4 secs) (at 2016-10-16 10:23:47.850076) ========= '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-208\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-208 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-208 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-208\AppData\Local LOGONSERVER=\\T-W864-IX-208 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-208 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-208 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-208 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=2.405000 ========= master_lag: 1.81 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 4 secs) (at 2016-10-16 10:23:52.067127) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-16 10:23:52.067429) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo mozilla-central --rev 9079d167112122805f99f57bb8856e1b1675af0f --destination scripts --debug' in dir C:\slave\test\. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 9079d167112122805f99f57bb8856e1b1675af0f --destination scripts --debug'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-208\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-208 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-208 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-208\AppData\Local LOGONSERVER=\\T-W864-IX-208 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-208 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-208 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-208 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 2016-10-16 10:23:52,602 truncating revision to first 12 chars 2016-10-16 10:23:52,604 Setting DEBUG logging. 2016-10-16 10:23:52,604 attempt 1/10 2016-10-16 10:23:52,604 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9079d1671121?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-16 10:23:53,015 unpacking tar archive at: mozilla-central-9079d1671121/testing/mozharness/ 2016-10-16 10:23:53,114 skipping symlink on windows: configs/single_locale/linux32.py program finished with exit code 0 elapsedTime=1.069000 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-16 10:23:53.214453) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-16 10:23:53.214736) ========= script_repo_revision: 9079d167112122805f99f57bb8856e1b1675af0f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-16 10:23:53.215090) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-16 10:23:53.215351) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-16 10:23:53.232771) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 22 mins, 31 secs) (at 2016-10-16 10:23:53.233036) ========= 'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'dromaeojs' '--add-option' '--webServer,localhost' '--branch-name' 'Firefox' '--cfg' 'talos/windows_config.py' '--download-symbols' 'ondemand' '--use-talos-json' '--blob-upload-branch' 'Firefox' in dir C:\slave\test\. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['c:/mozilla-build/python27/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/windows_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-208\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-208 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-208 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-208\AppData\Local LOGONSERVER=\\T-W864-IX-208 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-208 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-208 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-208 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 10:23:53 INFO - MultiFileLogger online at 20161016 10:23:53 in C:\slave\test 10:23:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:23:53 INFO - Dumping config to C:\slave\test\logs\localconfig.json. 10:23:53 INFO - {'append_to_log': False, 10:23:53 INFO - 'base_work_dir': 'C:\\slave\\test', 10:23:53 INFO - 'blob_upload_branch': 'Firefox', 10:23:53 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt', 10:23:53 INFO - 'branch': 'Firefox', 10:23:53 INFO - 'buildbot_json_path': 'buildprops.json', 10:23:53 INFO - 'config_files': ('talos/windows_config.py',), 10:23:53 INFO - 'default_actions': ('clobber', 10:23:53 INFO - 'read-buildbot-config', 10:23:53 INFO - 'download-and-extract', 10:23:53 INFO - 'populate-webroot', 10:23:53 INFO - 'create-virtualenv', 10:23:53 INFO - 'install', 10:23:53 INFO - 'run-tests'), 10:23:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:23:53 INFO - 'download_minidump_stackwalk': True, 10:23:53 INFO - 'download_symbols': 'ondemand', 10:23:53 INFO - 'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python', 10:23:53 INFO - 'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'), 10:23:53 INFO - 'hg': 'c:/mozilla-build/hg/hg', 10:23:53 INFO - 'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python', 10:23:53 INFO - 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'), 10:23:53 INFO - 'python': 'c:/mozilla-build/python27/python.exe', 10:23:53 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe', 10:23:53 INFO - 'C:/mozilla-build/tooltool.py'), 10:23:53 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe', 10:23:53 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 10:23:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:23:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:23:53 INFO - 'installer_path': 'installer.exe', 10:23:53 INFO - 'log_level': 'info', 10:23:53 INFO - 'log_name': 'talos', 10:23:53 INFO - 'log_to_console': True, 10:23:53 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe', 10:23:53 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe', 10:23:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest', 10:23:53 INFO - 'opt_config_files': (), 10:23:53 INFO - 'pip_index': False, 10:23:53 INFO - 'sps_profile': False, 10:23:53 INFO - 'sps_profile_interval': 0, 10:23:53 INFO - 'suite': 'dromaeojs', 10:23:53 INFO - 'system_bits': '32', 10:23:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:23:53 INFO - 'title': 'T-W864-IX-208', 10:23:53 INFO - 'use_talos_json': True, 10:23:53 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'), 10:23:53 INFO - 'virtualenv_path': 'C:\\slave\\test\\build/venv', 10:23:53 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll', 10:23:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:23:53 INFO - 'work_dir': 'build'} 10:23:53 INFO - [mozharness: 2016-10-16 17:23:53.952000Z] Running clobber step. 10:23:53 INFO - Running pre-action listener: _resource_record_pre_action 10:23:53 INFO - Running main action method: clobber 10:23:53 INFO - rmtree: C:\slave\test\build 10:23:53 INFO - Using _rmtree_windows ... 10:23:54 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1 10:24:50 INFO - Running post-action listener: _resource_record_post_action 10:24:50 INFO - [mozharness: 2016-10-16 17:24:50.803000Z] Finished clobber step (success) 10:24:50 INFO - [mozharness: 2016-10-16 17:24:50.803000Z] Running read-buildbot-config step. 10:24:50 INFO - Running pre-action listener: _resource_record_pre_action 10:24:50 INFO - Running main action method: read_buildbot_config 10:24:50 INFO - Using buildbot properties: 10:24:50 INFO - { 10:24:50 INFO - "project": "", 10:24:50 INFO - "product": "firefox", 10:24:50 INFO - "script_repo_revision": "production", 10:24:50 INFO - "builddir": "mozilla-central_win8_64_test-dromaeojs", 10:24:50 INFO - "repository": "", 10:24:50 INFO - "buildername": "Windows 8 64-bit mozilla-central pgo talos dromaeojs", 10:24:50 INFO - "buildid": "20161016073001", 10:24:50 INFO - "pgo_build": "True", 10:24:50 INFO - "basedir": "C:\\slave\\test", 10:24:50 INFO - "buildnumber": 108, 10:24:50 INFO - "slavename": "t-w864-ix-208", 10:24:50 INFO - "master": "http://buildbot-master109.bb.releng.scl3.mozilla.com:8201/", 10:24:50 INFO - "platform": "win8_64", 10:24:50 INFO - "scheduler": "tests-mozilla-central-win64-pgo-talos", 10:24:50 INFO - "branch": "mozilla-central", 10:24:50 INFO - "repo_path": "mozilla-central", 10:24:50 INFO - "revision": "9079d167112122805f99f57bb8856e1b1675af0f", 10:24:50 INFO - "stage_platform": "win64-pgo", 10:24:50 INFO - "builduid": "52ab78f8c15342c38a89ce65c3130b98", 10:24:50 INFO - "slavebuilddir": "test" 10:24:50 INFO - } 10:24:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/M3tl11ZsQ9G9gV8AHmzWEA/artifacts/public/build/firefox-52.0a1.en-US.win64.zip. 10:24:50 INFO - Running post-action listener: _resource_record_post_action 10:24:50 INFO - [mozharness: 2016-10-16 17:24:50.806000Z] Finished read-buildbot-config step (success) 10:24:50 INFO - [mozharness: 2016-10-16 17:24:50.806000Z] Running download-and-extract step. 10:24:50 INFO - Running pre-action listener: _resource_record_pre_action 10:24:50 INFO - Running main action method: download_and_extract 10:24:50 INFO - mkdir: C:\slave\test\build\tests 10:24:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:24:50 INFO - trying https://queue.taskcluster.net/v1/task/M3tl11ZsQ9G9gV8AHmzWEA/artifacts/public/build/firefox-52.0a1.en-US.win64.test_packages.json 10:24:50 INFO - Downloading https://queue.taskcluster.net/v1/task/M3tl11ZsQ9G9gV8AHmzWEA/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 10:24:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M3tl11ZsQ9G9gV8AHmzWEA/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 10:24:51 INFO - Downloaded 1218 bytes. 10:24:51 INFO - Reading from file C:\slave\test\build\firefox-52.0a1.en-US.win64.test_packages.json 10:24:51 INFO - Using the following test package requirements: 10:24:51 INFO - {u'common': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 10:24:51 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 10:24:51 INFO - u'firefox-52.0a1.en-US.win64.cppunittest.tests.zip'], 10:24:51 INFO - u'gtest': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 10:24:51 INFO - u'jittest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 10:24:51 INFO - u'jsshell-win64.zip'], 10:24:51 INFO - u'mochitest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 10:24:51 INFO - u'firefox-52.0a1.en-US.win64.mochitest.tests.zip'], 10:24:51 INFO - u'mozbase': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 10:24:51 INFO - u'reftest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 10:24:51 INFO - u'firefox-52.0a1.en-US.win64.reftest.tests.zip'], 10:24:51 INFO - u'talos': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 10:24:51 INFO - u'firefox-52.0a1.en-US.win64.talos.tests.zip'], 10:24:51 INFO - u'web-platform': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 10:24:51 INFO - u'firefox-52.0a1.en-US.win64.web-platform.tests.zip'], 10:24:51 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 10:24:51 INFO - u'firefox-52.0a1.en-US.win64.xpcshell.tests.zip']} 10:24:51 INFO - Downloading packages: [u'firefox-52.0a1.en-US.win64.common.tests.zip'] for test suite category: common 10:24:51 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/M3tl11ZsQ9G9gV8AHmzWEA/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip 10:24:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M3tl11ZsQ9G9gV8AHmzWEA/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip'}, attempt #1 10:24:51 INFO - Fetch https://queue.taskcluster.net/v1/task/M3tl11ZsQ9G9gV8AHmzWEA/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip into memory 10:24:52 INFO - Http code: 200 10:24:52 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 10:24:52 INFO - x-amz-cf-id: GkbYOUfTRV150uPXn5vit7hvuel6SXwdtAVUyMgVDgwibuXML6iVuw== 10:24:52 INFO - x-amz-version-id: WSeaaA5JY5qsfIqtBd9VGTg_RhW2gSwX 10:24:52 INFO - Expected file size: 17558273 10:24:52 INFO - Obtained file size: 17558273 10:25:17 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 10:25:17 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/M3tl11ZsQ9G9gV8AHmzWEA/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip 10:25:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M3tl11ZsQ9G9gV8AHmzWEA/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip'}, attempt #1 10:25:17 INFO - Fetch https://queue.taskcluster.net/v1/task/M3tl11ZsQ9G9gV8AHmzWEA/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip into memory 10:25:18 INFO - Http code: 200 10:25:18 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 10:25:18 INFO - x-amz-cf-id: ke2vO6vOlN1OkWnnx2j5YNSuwUNXJjCn8to2Uy_W2CjCOXePMZsCKg== 10:25:18 INFO - x-amz-version-id: WSeaaA5JY5qsfIqtBd9VGTg_RhW2gSwX 10:25:18 INFO - Expected file size: 17558273 10:25:18 INFO - Obtained file size: 17558273 10:25:28 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/M3tl11ZsQ9G9gV8AHmzWEA/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip 10:25:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M3tl11ZsQ9G9gV8AHmzWEA/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip'}, attempt #1 10:25:28 INFO - Fetch https://queue.taskcluster.net/v1/task/M3tl11ZsQ9G9gV8AHmzWEA/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip into memory 10:25:29 INFO - Http code: 200 10:25:29 INFO - via: 1.1 c54d7f08e2f3dab1918454910cc8aad0.cloudfront.net (CloudFront) 10:25:29 INFO - x-amz-cf-id: h0Pahf_iK6iTbL7zBMxLylxQXQW4Z4X1wpEjQUj_ff2dL3HzZ4IaFw== 10:25:29 INFO - x-amz-version-id: .sbmEsunNHHKh2cAfemgOANEVthp18i4 10:25:29 INFO - Expected file size: 14409028 10:25:29 INFO - Obtained file size: 14409028 10:25:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:25:37 INFO - trying https://queue.taskcluster.net/v1/task/M3tl11ZsQ9G9gV8AHmzWEA/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 10:25:37 INFO - Downloading https://queue.taskcluster.net/v1/task/M3tl11ZsQ9G9gV8AHmzWEA/artifacts/public/build/firefox-52.0a1.en-US.win64.zip to C:\slave\test\build\firefox-52.0a1.en-US.win64.zip 10:25:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M3tl11ZsQ9G9gV8AHmzWEA/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 10:25:38 INFO - Downloaded 57383529 bytes. 10:25:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M3tl11ZsQ9G9gV8AHmzWEA/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 10:25:38 INFO - mkdir: C:\slave\test\properties 10:25:38 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url 10:25:38 INFO - Writing to file C:\slave\test\properties\build_url 10:25:38 INFO - Contents: 10:25:38 INFO - build_url:https://queue.taskcluster.net/v1/task/M3tl11ZsQ9G9gV8AHmzWEA/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 10:25:39 INFO - Running post-action listener: _resource_record_post_action 10:25:39 INFO - Running post-action listener: set_extra_try_arguments 10:25:39 INFO - [mozharness: 2016-10-16 17:25:39.252000Z] Finished download-and-extract step (success) 10:25:39 INFO - [mozharness: 2016-10-16 17:25:39.252000Z] Running populate-webroot step. 10:25:39 INFO - Running pre-action listener: _resource_record_pre_action 10:25:39 INFO - Running main action method: populate_webroot 10:25:39 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']}, 10:25:39 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']}, 10:25:39 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome', 10:25:39 INFO - u'--tppagecycles', 10:25:39 INFO - u'7'], 10:25:39 INFO - u'tests': [u'tsvgm']}}, 10:25:39 INFO - u'suites': {u'chromez': {u'talos_options': [u'--disable-e10s'], 10:25:39 INFO - u'tests': [u'tresize', u'tcanvasmark']}, 10:25:39 INFO - u'chromez-e10s': {u'tests': [u'tresize', u'tcanvasmark']}, 10:25:39 INFO - u'dromaeojs': {u'talos_options': [u'--disable-e10s'], 10:25:39 INFO - u'tests': [u'dromaeo_css', u'kraken']}, 10:25:39 INFO - u'dromaeojs-e10s': {u'tests': [u'dromaeo_css', u'kraken']}, 10:25:39 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:25:39 INFO - u'talos_options': [u'--disable-e10s'], 10:25:39 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 10:25:39 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:25:39 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 10:25:39 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:25:39 INFO - u'talos_options': [u'--disable-e10s'], 10:25:39 INFO - u'tests': [u'damp', u'tps']}, 10:25:39 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:25:39 INFO - u'tests': [u'damp', u'tps']}, 10:25:39 INFO - u'g3': {u'talos_options': [u'--disable-e10s'], 10:25:39 INFO - u'tests': [u'dromaeo_dom']}, 10:25:39 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']}, 10:25:39 INFO - u'g4': {u'talos_options': [u'--disable-e10s'], 10:25:39 INFO - u'tests': [u'basic_compositor_video']}, 10:25:39 INFO - u'g4-e10s': {u'tests': [u'basic_compositor_video']}, 10:25:39 INFO - u'other': {u'talos_options': [u'--disable-e10s'], 10:25:39 INFO - u'tests': [u'a11yr', 10:25:39 INFO - u'ts_paint', 10:25:39 INFO - u'tpaint', 10:25:39 INFO - u'sessionrestore', 10:25:39 INFO - u'sessionrestore_no_auto_restore', 10:25:39 INFO - u'tabpaint']}, 10:25:39 INFO - u'other-e10s': {u'tests': [u'a11yr', 10:25:39 INFO - u'ts_paint', 10:25:39 INFO - u'tpaint', 10:25:39 INFO - u'sessionrestore', 10:25:39 INFO - u'sessionrestore_no_auto_restore', 10:25:39 INFO - u'tabpaint']}, 10:25:39 INFO - u'other-e10s_l64': {u'tests': [u'a11yr', 10:25:39 INFO - u'ts_paint', 10:25:39 INFO - u'tpaint', 10:25:39 INFO - u'sessionrestore', 10:25:39 INFO - u'sessionrestore_no_auto_restore', 10:25:39 INFO - u'tabpaint']}, 10:25:39 INFO - u'other-e10s_nol64': {u'tests': [u'a11yr', 10:25:39 INFO - u'ts_paint', 10:25:39 INFO - u'tpaint', 10:25:39 INFO - u'sessionrestore', 10:25:39 INFO - u'sessionrestore_no_auto_restore', 10:25:39 INFO - u'tabpaint']}, 10:25:39 INFO - u'other_l64': {u'talos_options': [u'--disable-e10s'], 10:25:39 INFO - u'tests': [u'a11yr', 10:25:39 INFO - u'ts_paint', 10:25:39 INFO - u'tpaint', 10:25:39 INFO - u'sessionrestore', 10:25:39 INFO - u'sessionrestore_no_auto_restore', 10:25:39 INFO - u'tabpaint']}, 10:25:39 INFO - u'other_nol64': {u'talos_options': [u'--disable-e10s'], 10:25:39 INFO - u'tests': [u'a11yr', 10:25:39 INFO - u'ts_paint', 10:25:39 INFO - u'tpaint', 10:25:39 INFO - u'sessionrestore', 10:25:39 INFO - u'sessionrestore_no_auto_restore', 10:25:39 INFO - u'tabpaint']}, 10:25:39 INFO - u'svgr': {u'talos_options': [u'--disable-e10s'], 10:25:39 INFO - u'tests': [u'tsvgx', 10:25:39 INFO - u'tsvgr_opacity', 10:25:39 INFO - u'tart', 10:25:39 INFO - u'tscrollx', 10:25:39 INFO - u'cart']}, 10:25:39 INFO - u'svgr-e10s': {u'tests': [u'tsvgx', 10:25:39 INFO - u'tsvgr_opacity', 10:25:39 INFO - u'tart', 10:25:39 INFO - u'tscrollx', 10:25:39 INFO - u'cart']}, 10:25:39 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:25:39 INFO - u'talos_options': [u'--disable-e10s'], 10:25:39 INFO - u'tests': [u'tp5o']}, 10:25:39 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:25:39 INFO - u'tests': [u'tp5o']}, 10:25:39 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:25:39 INFO - u'talos_options': [u'--disable-e10s', 10:25:39 INFO - u'--xperf_path', 10:25:39 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:25:39 INFO - u'tests': [u'tp5n']}, 10:25:39 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:25:39 INFO - u'talos_options': [u'--xperf_path', 10:25:39 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:25:39 INFO - u'tests': [u'tp5n']}}, 10:25:39 INFO - u'talos.zip': {u'path': u'', 10:25:39 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:25:39 INFO - Running post-action listener: _resource_record_post_action 10:25:39 INFO - [mozharness: 2016-10-16 17:25:39.266000Z] Finished populate-webroot step (success) 10:25:39 INFO - [mozharness: 2016-10-16 17:25:39.266000Z] Running create-virtualenv step. 10:25:39 INFO - Running pre-action listener: _resource_record_pre_action 10:25:39 INFO - Running main action method: create_virtualenv 10:25:39 INFO - Creating virtualenv C:\slave\test\build/venv 10:25:39 INFO - mkdir: C:\slave\test\build\venv\Scripts 10:25:39 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll 10:25:39 WARNING - Can't copy c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll: [Errno 2] No such file or directory: 'c:/mozilla-build/python27/python27.dll'! 10:25:39 INFO - Running command: ['c:/mozilla-build/python27/python.exe', 'c:/mozilla-build/buildbotve/virtualenv.py', '--no-site-packages', '--distribute', 'C:\\slave\\test\\build/venv'] in C:\slave\test\build 10:25:39 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build/venv 10:25:48 INFO - New python executable in C:\slave\test\build/venv\Scripts\python.exe 10:25:50 INFO - Installing distribute......................................................................................................................................................................................done. 10:25:51 INFO - Return code: 0 10:25:51 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', '--version'] 10:25:51 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip --version 10:25:52 INFO - Reading from file tmpfile_stdout 10:25:52 INFO - Output received: 10:25:52 INFO - pip 0.8.2 from c:\slave\test\build\venv\lib\site-packages\pip-0.8.2-py2.7.egg (python 2.7) 10:25:52 INFO - Using _rmtree_windows ... 10:25:52 INFO - Using _rmtree_windows ... 10:25:52 INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv 10:25:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:25:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:25:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:25:52 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 0x0232C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023D3E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024DF1C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0241AE90>, '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 0x01E2A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027FD520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-208', 'USERDOMAIN': 'T-W864-IX-208', '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-208', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-208', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-208', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-208', '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-208\\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 10:25:52 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 10:25:52 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 10:25:52 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 10:25:52 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Roaming', 10:25:52 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 10:25:52 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 10:25:52 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 10:25:52 INFO - 'COMPUTERNAME': 'T-W864-IX-208', 10:25:52 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 10:25:52 INFO - 'DCLOCATION': 'SCL3', 10:25:52 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 10:25:52 INFO - 'FP_NO_HOST_CHECK': 'NO', 10:25:52 INFO - 'HOMEDRIVE': 'C:', 10:25:52 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-208', 10:25:52 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 10:25:52 INFO - 'KTS_VERSION': '1.19c', 10:25:52 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Local', 10:25:52 INFO - 'LOGONSERVER': '\\\\T-W864-IX-208', 10:25:52 INFO - 'MONDIR': 'C:\\Monitor_config\\', 10:25:52 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 10:25:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:25:52 INFO - 'MOZ_NO_REMOTE': '1', 10:25:52 INFO - 'NO_EM_RESTART': '1', 10:25:52 INFO - 'NUMBER_OF_PROCESSORS': '8', 10:25:52 INFO - 'OS': 'Windows_NT', 10:25:52 INFO - 'OURDRIVE': 'C:', 10:25:52 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', 10:25:52 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 10:25:52 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 10:25:52 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 10:25:52 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 10:25:52 INFO - 'PROCESSOR_LEVEL': '6', 10:25:52 INFO - 'PROCESSOR_REVISION': '1e05', 10:25:52 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 10:25:52 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 10:25:52 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 10:25:52 INFO - 'PROGRAMW6432': 'C:\\Program Files', 10:25:52 INFO - 'PROMPT': '$P$G', 10:25:52 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 10:25:52 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 10:25:52 INFO - 'PUBLIC': 'C:\\Users\\Public', 10:25:52 INFO - 'PWD': 'C:\\slave\\test', 10:25:52 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 10:25:52 INFO - 'SLAVEDIR': 'C:\\slave\\', 10:25:52 INFO - 'SYSTEMDRIVE': 'C:', 10:25:52 INFO - 'SYSTEMROOT': 'C:\\windows', 10:25:52 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 10:25:52 INFO - 'TEST1': 'testie', 10:25:52 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 10:25:52 INFO - 'USERDOMAIN': 'T-W864-IX-208', 10:25:52 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-208', 10:25:52 INFO - 'USERNAME': 'cltbld', 10:25:52 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-208', 10:25:52 INFO - 'WINDIR': 'C:\\windows', 10:25:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 10:25:52 INFO - Ignoring indexes: http://pypi.python.org/simple/ 10:25:52 INFO - Downloading/unpacking pip>=1.5 10:25:57 INFO - Running setup.py egg_info for package pip 10:25:57 INFO - warning: no files found matching 'pip\cacert.pem' 10:25:57 INFO - warning: no files found matching '*.html' under directory 'docs' 10:25:57 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 10:25:57 INFO - no previously-included directories found matching 'docs\_build\_sources' 10:25:57 INFO - Installing collected packages: pip 10:25:57 INFO - Found existing installation: pip 0.8.2 10:25:57 INFO - Uninstalling pip: 10:25:57 INFO - Successfully uninstalled pip 10:25:57 INFO - Running setup.py install for pip 10:25:57 INFO - warning: no files found matching 'pip\cacert.pem' 10:25:57 INFO - warning: no files found matching '*.html' under directory 'docs' 10:25:57 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 10:25:57 INFO - no previously-included directories found matching 'docs\_build\_sources' 10:25:57 INFO - Installing pip-script.py script to C:\slave\test\build\venv\Scripts 10:25:57 INFO - Installing pip.exe script to C:\slave\test\build\venv\Scripts 10:25:57 INFO - Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts 10:25:57 INFO - Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts 10:25:57 INFO - Installing pip2-script.py script to C:\slave\test\build\venv\Scripts 10:25:57 INFO - Installing pip2.exe script to C:\slave\test\build\venv\Scripts 10:25:57 INFO - Successfully installed pip 10:25:57 INFO - Cleaning up... 10:25:57 INFO - Return code: 0 10:25:57 INFO - Installing psutil>=3.1.1 into virtualenv C:\slave\test\build/venv 10:25:57 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')]} 10:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:25:57 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')]} 10:25:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:25:57 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 0x0232C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023D3E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024DF1C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0241AE90>, '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 0x01E2A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027FD520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-208', 'USERDOMAIN': 'T-W864-IX-208', '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-208', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-208', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-208', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-208', '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-208\\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 10:25:57 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 10:25:57 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 10:25:57 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 10:25:57 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Roaming', 10:25:57 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 10:25:57 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 10:25:57 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 10:25:57 INFO - 'COMPUTERNAME': 'T-W864-IX-208', 10:25:57 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 10:25:57 INFO - 'DCLOCATION': 'SCL3', 10:25:57 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 10:25:57 INFO - 'FP_NO_HOST_CHECK': 'NO', 10:25:57 INFO - 'HOMEDRIVE': 'C:', 10:25:57 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-208', 10:25:57 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 10:25:57 INFO - 'KTS_VERSION': '1.19c', 10:25:57 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Local', 10:25:57 INFO - 'LOGONSERVER': '\\\\T-W864-IX-208', 10:25:57 INFO - 'MONDIR': 'C:\\Monitor_config\\', 10:25:57 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 10:25:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:25:57 INFO - 'MOZ_NO_REMOTE': '1', 10:25:57 INFO - 'NO_EM_RESTART': '1', 10:25:57 INFO - 'NUMBER_OF_PROCESSORS': '8', 10:25:57 INFO - 'OS': 'Windows_NT', 10:25:57 INFO - 'OURDRIVE': 'C:', 10:25:57 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', 10:25:57 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 10:25:57 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 10:25:57 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 10:25:57 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 10:25:57 INFO - 'PROCESSOR_LEVEL': '6', 10:25:57 INFO - 'PROCESSOR_REVISION': '1e05', 10:25:57 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 10:25:57 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 10:25:57 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 10:25:57 INFO - 'PROGRAMW6432': 'C:\\Program Files', 10:25:57 INFO - 'PROMPT': '$P$G', 10:25:57 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 10:25:57 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 10:25:57 INFO - 'PUBLIC': 'C:\\Users\\Public', 10:25:57 INFO - 'PWD': 'C:\\slave\\test', 10:25:57 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 10:25:57 INFO - 'SLAVEDIR': 'C:\\slave\\', 10:25:57 INFO - 'SYSTEMDRIVE': 'C:', 10:25:57 INFO - 'SYSTEMROOT': 'C:\\windows', 10:25:57 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 10:25:57 INFO - 'TEST1': 'testie', 10:25:57 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 10:25:57 INFO - 'USERDOMAIN': 'T-W864-IX-208', 10:25:57 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-208', 10:25:57 INFO - 'USERNAME': 'cltbld', 10:25:57 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-208', 10:25:57 INFO - 'WINDIR': 'C:\\windows', 10:25:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 10:25:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:25:58 INFO - Downloading/unpacking psutil>=3.1.1 10:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:25:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:00 INFO - Installing collected packages: psutil 10:26:00 INFO - Successfully installed psutil 10:26:00 INFO - Cleaning up... 10:26:00 INFO - Return code: 0 10:26:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv C:\slave\test\build/venv 10:26:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:26:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:00 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0232C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023D3E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024DF1C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0241AE90>, '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 0x01E2A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027FD520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-208', 'USERDOMAIN': 'T-W864-IX-208', '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-208', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-208', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-208', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-208', '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-208\\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 10:26:00 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in C:\slave\test\build 10:26:00 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:26:00 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 10:26:00 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Roaming', 10:26:00 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 10:26:00 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 10:26:00 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 10:26:00 INFO - 'COMPUTERNAME': 'T-W864-IX-208', 10:26:00 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 10:26:00 INFO - 'DCLOCATION': 'SCL3', 10:26:00 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 10:26:00 INFO - 'FP_NO_HOST_CHECK': 'NO', 10:26:00 INFO - 'HOMEDRIVE': 'C:', 10:26:00 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-208', 10:26:00 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 10:26:00 INFO - 'KTS_VERSION': '1.19c', 10:26:00 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Local', 10:26:00 INFO - 'LOGONSERVER': '\\\\T-W864-IX-208', 10:26:00 INFO - 'MONDIR': 'C:\\Monitor_config\\', 10:26:00 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 10:26:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:00 INFO - 'MOZ_NO_REMOTE': '1', 10:26:00 INFO - 'NO_EM_RESTART': '1', 10:26:00 INFO - 'NUMBER_OF_PROCESSORS': '8', 10:26:00 INFO - 'OS': 'Windows_NT', 10:26:00 INFO - 'OURDRIVE': 'C:', 10:26:00 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 10:26:00 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 10:26:00 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 10:26:00 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 10:26:00 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 10:26:00 INFO - 'PROCESSOR_LEVEL': '6', 10:26:00 INFO - 'PROCESSOR_REVISION': '1e05', 10:26:00 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 10:26:00 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 10:26:00 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 10:26:00 INFO - 'PROGRAMW6432': 'C:\\Program Files', 10:26:00 INFO - 'PROMPT': '$P$G', 10:26:00 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 10:26:00 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 10:26:00 INFO - 'PUBLIC': 'C:\\Users\\Public', 10:26:00 INFO - 'PWD': 'C:\\slave\\test', 10:26:00 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 10:26:00 INFO - 'SLAVEDIR': 'C:\\slave\\', 10:26:00 INFO - 'SYSTEMDRIVE': 'C:', 10:26:00 INFO - 'SYSTEMROOT': 'C:\\windows', 10:26:00 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 10:26:00 INFO - 'TEST1': 'testie', 10:26:00 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 10:26:00 INFO - 'USERDOMAIN': 'T-W864-IX-208', 10:26:00 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-208', 10:26:00 INFO - 'USERNAME': 'cltbld', 10:26:00 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-208', 10:26:00 INFO - 'WINDIR': 'C:\\windows', 10:26:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 10:26:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:26:01 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 10:26:01 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 10:26:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:26:02 INFO - Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor 10:26:02 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) 10:26:02 INFO - Installing collected packages: mozsystemmonitor 10:26:02 INFO - Running setup.py install for mozsystemmonitor 10:26:02 INFO - Successfully installed mozsystemmonitor 10:26:02 INFO - Cleaning up... 10:26:02 INFO - Return code: 0 10:26:02 INFO - Installing jsonschema==2.5.1 into virtualenv C:\slave\test\build/venv 10:26:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:26:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:02 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0232C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023D3E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024DF1C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0241AE90>, '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 0x01E2A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027FD520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-208', 'USERDOMAIN': 'T-W864-IX-208', '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-208', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-208', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-208', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-208', '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-208\\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 10:26:02 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in C:\slave\test\build 10:26:02 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:26:02 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 10:26:02 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Roaming', 10:26:02 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 10:26:02 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 10:26:02 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 10:26:02 INFO - 'COMPUTERNAME': 'T-W864-IX-208', 10:26:02 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 10:26:02 INFO - 'DCLOCATION': 'SCL3', 10:26:02 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 10:26:02 INFO - 'FP_NO_HOST_CHECK': 'NO', 10:26:02 INFO - 'HOMEDRIVE': 'C:', 10:26:02 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-208', 10:26:02 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 10:26:02 INFO - 'KTS_VERSION': '1.19c', 10:26:02 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Local', 10:26:02 INFO - 'LOGONSERVER': '\\\\T-W864-IX-208', 10:26:02 INFO - 'MONDIR': 'C:\\Monitor_config\\', 10:26:02 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 10:26:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:02 INFO - 'MOZ_NO_REMOTE': '1', 10:26:02 INFO - 'NO_EM_RESTART': '1', 10:26:02 INFO - 'NUMBER_OF_PROCESSORS': '8', 10:26:02 INFO - 'OS': 'Windows_NT', 10:26:02 INFO - 'OURDRIVE': 'C:', 10:26:02 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 10:26:02 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 10:26:02 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 10:26:02 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 10:26:02 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 10:26:02 INFO - 'PROCESSOR_LEVEL': '6', 10:26:02 INFO - 'PROCESSOR_REVISION': '1e05', 10:26:02 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 10:26:02 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 10:26:02 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 10:26:02 INFO - 'PROGRAMW6432': 'C:\\Program Files', 10:26:02 INFO - 'PROMPT': '$P$G', 10:26:02 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 10:26:02 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 10:26:02 INFO - 'PUBLIC': 'C:\\Users\\Public', 10:26:02 INFO - 'PWD': 'C:\\slave\\test', 10:26:02 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 10:26:02 INFO - 'SLAVEDIR': 'C:\\slave\\', 10:26:02 INFO - 'SYSTEMDRIVE': 'C:', 10:26:02 INFO - 'SYSTEMROOT': 'C:\\windows', 10:26:02 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 10:26:02 INFO - 'TEST1': 'testie', 10:26:02 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 10:26:02 INFO - 'USERDOMAIN': 'T-W864-IX-208', 10:26:02 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-208', 10:26:02 INFO - 'USERNAME': 'cltbld', 10:26:02 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-208', 10:26:02 INFO - 'WINDIR': 'C:\\windows', 10:26:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 10:26:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:03 INFO - Downloading/unpacking jsonschema==2.5.1 10:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:26:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:04 INFO - Downloading functools32-3.2.3-2.tar.gz 10:26:04 INFO - Running setup.py (path:C:\slave\test\build\venv\build\functools32\setup.py) egg_info for package functools32 10:26:04 INFO - warning: no files found matching '*.txt' 10:26:04 INFO - no previously-included directories found matching 'build' 10:26:04 INFO - no previously-included directories found matching 'dist' 10:26:04 INFO - no previously-included directories found matching '.git*' 10:26:04 INFO - Installing collected packages: jsonschema, functools32 10:26:04 INFO - Running setup.py install for functools32 10:26:04 INFO - warning: no files found matching '*.txt' 10:26:04 INFO - no previously-included directories found matching 'build' 10:26:04 INFO - no previously-included directories found matching 'dist' 10:26:04 INFO - no previously-included directories found matching '.git*' 10:26:04 INFO - Successfully installed jsonschema functools32 10:26:04 INFO - Cleaning up... 10:26:05 INFO - Return code: 0 10:26:05 INFO - Installing functools32==3.2.3-2 into virtualenv C:\slave\test\build/venv 10:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:26:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:05 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x0232C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023D3E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024DF1C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0241AE90>, '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 0x01E2A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027FD520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-208', 'USERDOMAIN': 'T-W864-IX-208', '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-208', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-208', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-208', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-208', '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-208\\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 10:26:05 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in C:\slave\test\build 10:26:05 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:26:05 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 10:26:05 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Roaming', 10:26:05 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 10:26:05 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 10:26:05 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 10:26:05 INFO - 'COMPUTERNAME': 'T-W864-IX-208', 10:26:05 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 10:26:05 INFO - 'DCLOCATION': 'SCL3', 10:26:05 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 10:26:05 INFO - 'FP_NO_HOST_CHECK': 'NO', 10:26:05 INFO - 'HOMEDRIVE': 'C:', 10:26:05 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-208', 10:26:05 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 10:26:05 INFO - 'KTS_VERSION': '1.19c', 10:26:05 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Local', 10:26:05 INFO - 'LOGONSERVER': '\\\\T-W864-IX-208', 10:26:05 INFO - 'MONDIR': 'C:\\Monitor_config\\', 10:26:05 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 10:26:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:05 INFO - 'MOZ_NO_REMOTE': '1', 10:26:05 INFO - 'NO_EM_RESTART': '1', 10:26:05 INFO - 'NUMBER_OF_PROCESSORS': '8', 10:26:05 INFO - 'OS': 'Windows_NT', 10:26:05 INFO - 'OURDRIVE': 'C:', 10:26:05 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 10:26:05 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 10:26:05 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 10:26:05 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 10:26:05 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 10:26:05 INFO - 'PROCESSOR_LEVEL': '6', 10:26:05 INFO - 'PROCESSOR_REVISION': '1e05', 10:26:05 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 10:26:05 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 10:26:05 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 10:26:05 INFO - 'PROGRAMW6432': 'C:\\Program Files', 10:26:05 INFO - 'PROMPT': '$P$G', 10:26:05 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 10:26:05 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 10:26:05 INFO - 'PUBLIC': 'C:\\Users\\Public', 10:26:05 INFO - 'PWD': 'C:\\slave\\test', 10:26:05 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 10:26:05 INFO - 'SLAVEDIR': 'C:\\slave\\', 10:26:05 INFO - 'SYSTEMDRIVE': 'C:', 10:26:05 INFO - 'SYSTEMROOT': 'C:\\windows', 10:26:05 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 10:26:05 INFO - 'TEST1': 'testie', 10:26:05 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 10:26:05 INFO - 'USERDOMAIN': 'T-W864-IX-208', 10:26:05 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-208', 10:26:05 INFO - 'USERNAME': 'cltbld', 10:26:05 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-208', 10:26:05 INFO - 'WINDIR': 'C:\\windows', 10:26:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 10:26:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in c:\slave\test\build\venv\lib\site-packages 10:26:05 INFO - Cleaning up... 10:26:05 INFO - Return code: 0 10:26:05 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv 10:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:26:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:05 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0232C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023D3E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024DF1C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0241AE90>, '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 0x01E2A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027FD520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-208', 'USERDOMAIN': 'T-W864-IX-208', '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-208', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-208', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-208', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-208', '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-208\\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 10:26:05 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in C:\slave\test\build 10:26:05 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:26:05 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 10:26:05 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Roaming', 10:26:05 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 10:26:05 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 10:26:05 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 10:26:05 INFO - 'COMPUTERNAME': 'T-W864-IX-208', 10:26:05 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 10:26:05 INFO - 'DCLOCATION': 'SCL3', 10:26:05 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 10:26:05 INFO - 'FP_NO_HOST_CHECK': 'NO', 10:26:05 INFO - 'HOMEDRIVE': 'C:', 10:26:05 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-208', 10:26:05 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 10:26:05 INFO - 'KTS_VERSION': '1.19c', 10:26:05 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Local', 10:26:05 INFO - 'LOGONSERVER': '\\\\T-W864-IX-208', 10:26:05 INFO - 'MONDIR': 'C:\\Monitor_config\\', 10:26:05 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 10:26:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:05 INFO - 'MOZ_NO_REMOTE': '1', 10:26:05 INFO - 'NO_EM_RESTART': '1', 10:26:05 INFO - 'NUMBER_OF_PROCESSORS': '8', 10:26:05 INFO - 'OS': 'Windows_NT', 10:26:05 INFO - 'OURDRIVE': 'C:', 10:26:05 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 10:26:05 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 10:26:05 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 10:26:05 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 10:26:05 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 10:26:05 INFO - 'PROCESSOR_LEVEL': '6', 10:26:05 INFO - 'PROCESSOR_REVISION': '1e05', 10:26:05 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 10:26:05 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 10:26:05 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 10:26:05 INFO - 'PROGRAMW6432': 'C:\\Program Files', 10:26:05 INFO - 'PROMPT': '$P$G', 10:26:05 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 10:26:05 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 10:26:05 INFO - 'PUBLIC': 'C:\\Users\\Public', 10:26:05 INFO - 'PWD': 'C:\\slave\\test', 10:26:05 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 10:26:05 INFO - 'SLAVEDIR': 'C:\\slave\\', 10:26:05 INFO - 'SYSTEMDRIVE': 'C:', 10:26:05 INFO - 'SYSTEMROOT': 'C:\\windows', 10:26:05 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 10:26:05 INFO - 'TEST1': 'testie', 10:26:05 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 10:26:05 INFO - 'USERDOMAIN': 'T-W864-IX-208', 10:26:05 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-208', 10:26:05 INFO - 'USERNAME': 'cltbld', 10:26:05 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-208', 10:26:05 INFO - 'WINDIR': 'C:\\windows', 10:26:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 10:26:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:05 INFO - Downloading/unpacking blobuploader==1.2.4 10:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:06 INFO - Downloading blobuploader-1.2.4.tar.gz 10:26:06 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader 10:26:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:07 INFO - Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests 10:26:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:26:07 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 10:26:07 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 10:26:07 INFO - Downloading docopt-0.6.1.tar.gz 10:26:07 INFO - Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt 10:26:07 INFO - Installing collected packages: blobuploader, requests, docopt 10:26:07 INFO - Running setup.py install for blobuploader 10:26:07 INFO - Running setup.py install for requests 10:26:08 INFO - Running setup.py install for docopt 10:26:08 INFO - Successfully installed blobuploader requests docopt 10:26:08 INFO - Cleaning up... 10:26:09 INFO - Return code: 0 10:26:09 INFO - Installing None into virtualenv C:\slave\test\build/venv 10:26:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:26:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:09 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--no-deps', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0232C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023D3E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024DF1C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0241AE90>, '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 0x01E2A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027FD520>, '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-208', 'USERDOMAIN': 'T-W864-IX-208', '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-208', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-208', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-208', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-208', '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-208\\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 10:26:09 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--no-deps', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in C:\slave\test\build\tests\config 10:26:09 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --no-deps --timeout 120 -r C:\slave\test\build\tests\config\mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:26:09 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 10:26:09 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Roaming', 10:26:09 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 10:26:09 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 10:26:09 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 10:26:09 INFO - 'COMPUTERNAME': 'T-W864-IX-208', 10:26:09 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 10:26:09 INFO - 'DCLOCATION': 'SCL3', 10:26:09 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 10:26:09 INFO - 'FP_NO_HOST_CHECK': 'NO', 10:26:09 INFO - 'HOMEDRIVE': 'C:', 10:26:09 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-208', 10:26:09 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 10:26:09 INFO - 'KTS_VERSION': '1.19c', 10:26:09 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Local', 10:26:09 INFO - 'LOGONSERVER': '\\\\T-W864-IX-208', 10:26:09 INFO - 'MONDIR': 'C:\\Monitor_config\\', 10:26:09 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 10:26:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:09 INFO - 'MOZ_NO_REMOTE': '1', 10:26:09 INFO - 'NO_EM_RESTART': '1', 10:26:09 INFO - 'NUMBER_OF_PROCESSORS': '8', 10:26:09 INFO - 'OS': 'Windows_NT', 10:26:09 INFO - 'OURDRIVE': 'C:', 10:26:09 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 10:26:09 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 10:26:09 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 10:26:09 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 10:26:09 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 10:26:09 INFO - 'PROCESSOR_LEVEL': '6', 10:26:09 INFO - 'PROCESSOR_REVISION': '1e05', 10:26:09 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 10:26:09 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 10:26:09 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 10:26:09 INFO - 'PROGRAMW6432': 'C:\\Program Files', 10:26:09 INFO - 'PROMPT': '$P$G', 10:26:09 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 10:26:09 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 10:26:09 INFO - 'PUBLIC': 'C:\\Users\\Public', 10:26:09 INFO - 'PWD': 'C:\\slave\\test', 10:26:09 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 10:26:09 INFO - 'SLAVEDIR': 'C:\\slave\\', 10:26:09 INFO - 'SYSTEMDRIVE': 'C:', 10:26:09 INFO - 'SYSTEMROOT': 'C:\\windows', 10:26:09 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 10:26:09 INFO - 'TEST1': 'testie', 10:26:09 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 10:26:09 INFO - 'USERDOMAIN': 'T-W864-IX-208', 10:26:09 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-208', 10:26:09 INFO - 'USERNAME': 'cltbld', 10:26:09 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-208', 10:26:09 INFO - 'WINDIR': 'C:\\windows', 10:26:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 10:26:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:09 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 10:26:09 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-lkjqyi-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 10:26:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 10:26:10 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ms54b1-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 10:26:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 10:26:10 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-pu2ot8-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 10:26:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 10:26:10 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-pogmvx-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 10:26:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 10:26:10 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-e1z6m_-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 10:26:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 10:26:10 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-6hrqhr-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 10:26:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 10:26:10 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-uvzxlp-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 10:26:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 10:26:10 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-74bumx-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 10:26:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 10:26:10 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-uu9_qw-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 10:26:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 10:26:10 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-e98sb1-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 10:26:11 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 10:26:11 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-6ogrtz-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 10:26:11 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 10:26:11 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qvjdg3-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 10:26:11 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 10:26:11 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-_g5rhh-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 10:26:11 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 10:26:11 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-_4alpf-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 10:26:11 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 10:26:11 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-f98bkt-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 10:26:11 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 10:26:11 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-irdchf-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 10:26:11 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 10:26:11 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-9vzuop-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 10:26:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:26:11 INFO - Running setup.py install for manifestparser 10:26:12 INFO - Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts 10:26:12 INFO - Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts 10:26:12 INFO - Running setup.py install for mozcrash 10:26:12 INFO - Running setup.py install for mozdebug 10:26:13 INFO - Running setup.py install for mozdevice 10:26:13 INFO - Installing sutini-script.py script to C:\slave\test\build\venv\Scripts 10:26:13 INFO - Installing sutini.exe script to C:\slave\test\build\venv\Scripts 10:26:13 INFO - Installing dm-script.py script to C:\slave\test\build\venv\Scripts 10:26:13 INFO - Installing dm.exe script to C:\slave\test\build\venv\Scripts 10:26:14 INFO - Running setup.py install for mozfile 10:26:14 INFO - Running setup.py install for mozhttpd 10:26:14 INFO - Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts 10:26:14 INFO - Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts 10:26:14 INFO - Running setup.py install for mozinfo 10:26:14 INFO - Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts 10:26:14 INFO - Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts 10:26:15 INFO - Running setup.py install for mozInstall 10:26:15 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts 10:26:15 INFO - Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts 10:26:15 INFO - Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts 10:26:15 INFO - Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts 10:26:15 INFO - Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts 10:26:15 INFO - Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts 10:26:15 INFO - Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts 10:26:15 INFO - Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts 10:26:15 INFO - Running setup.py install for mozleak 10:26:15 INFO - Running setup.py install for mozlog 10:26:16 INFO - Installing structlog-script.py script to C:\slave\test\build\venv\Scripts 10:26:16 INFO - Installing structlog.exe script to C:\slave\test\build\venv\Scripts 10:26:16 INFO - Running setup.py install for moznetwork 10:26:17 INFO - Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts 10:26:17 INFO - Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts 10:26:17 INFO - Running setup.py install for mozprocess 10:26:17 INFO - Running setup.py install for mozprofile 10:26:18 INFO - Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts 10:26:18 INFO - Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts 10:26:18 INFO - Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts 10:26:18 INFO - Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts 10:26:18 INFO - Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts 10:26:18 INFO - Installing view-profile.exe script to C:\slave\test\build\venv\Scripts 10:26:18 INFO - Running setup.py install for mozrunner 10:26:18 INFO - Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts 10:26:18 INFO - Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts 10:26:19 INFO - Running setup.py install for mozscreenshot 10:26:19 INFO - Running setup.py install for moztest 10:26:19 INFO - Running setup.py install for mozversion 10:26:19 INFO - Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts 10:26:19 INFO - Installing mozversion.exe script to C:\slave\test\build\venv\Scripts 10:26:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:26:20 INFO - Cleaning up... 10:26:20 INFO - Return code: 0 10:26:20 INFO - Installing None into virtualenv C:\slave\test\build/venv 10:26:20 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')]} 10:26:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:20 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')]} 10:26:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:20 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 0x0232C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023D3E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024DF1C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0241AE90>, '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 0x01E2A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027FD520>, '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-208', 'USERDOMAIN': 'T-W864-IX-208', '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-208', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-208', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-208', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-208', '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-208\\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 10:26:20 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 10:26:20 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 10:26:20 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 10:26:20 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Roaming', 10:26:20 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 10:26:20 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 10:26:20 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 10:26:20 INFO - 'COMPUTERNAME': 'T-W864-IX-208', 10:26:20 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 10:26:20 INFO - 'DCLOCATION': 'SCL3', 10:26:20 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 10:26:20 INFO - 'FP_NO_HOST_CHECK': 'NO', 10:26:20 INFO - 'HOMEDRIVE': 'C:', 10:26:20 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-208', 10:26:20 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 10:26:20 INFO - 'KTS_VERSION': '1.19c', 10:26:20 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Local', 10:26:20 INFO - 'LOGONSERVER': '\\\\T-W864-IX-208', 10:26:20 INFO - 'MONDIR': 'C:\\Monitor_config\\', 10:26:20 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 10:26:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:20 INFO - 'MOZ_NO_REMOTE': '1', 10:26:20 INFO - 'NO_EM_RESTART': '1', 10:26:20 INFO - 'NUMBER_OF_PROCESSORS': '8', 10:26:20 INFO - 'OS': 'Windows_NT', 10:26:20 INFO - 'OURDRIVE': 'C:', 10:26:20 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', 10:26:20 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 10:26:20 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 10:26:20 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 10:26:20 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 10:26:20 INFO - 'PROCESSOR_LEVEL': '6', 10:26:20 INFO - 'PROCESSOR_REVISION': '1e05', 10:26:20 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 10:26:20 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 10:26:20 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 10:26:20 INFO - 'PROGRAMW6432': 'C:\\Program Files', 10:26:20 INFO - 'PROMPT': '$P$G', 10:26:20 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 10:26:20 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 10:26:20 INFO - 'PUBLIC': 'C:\\Users\\Public', 10:26:20 INFO - 'PWD': 'C:\\slave\\test', 10:26:20 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 10:26:20 INFO - 'SLAVEDIR': 'C:\\slave\\', 10:26:20 INFO - 'SYSTEMDRIVE': 'C:', 10:26:20 INFO - 'SYSTEMROOT': 'C:\\windows', 10:26:20 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 10:26:20 INFO - 'TEST1': 'testie', 10:26:20 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 10:26:20 INFO - 'USERDOMAIN': 'T-W864-IX-208', 10:26:20 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-208', 10:26:20 INFO - 'USERNAME': 'cltbld', 10:26:20 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-208', 10:26:20 INFO - 'WINDIR': 'C:\\windows', 10:26:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 10:26:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:20 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 10:26:20 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-subkwv-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 10:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///C:/slave/test/build/tests/mozbase/manifestparser in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 1)) 10:26:20 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 10:26:20 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-osqbvm-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 10:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///C:/slave/test/build/tests/mozbase/mozcrash in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2)) 10:26:20 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 10:26:20 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-py4kyj-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 10:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///C:/slave/test/build/tests/mozbase/mozdebug in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 3)) 10:26:20 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 10:26:20 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-o_kqrj-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 10:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///C:/slave/test/build/tests/mozbase/mozdevice in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4)) 10:26:20 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 10:26:20 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-fc0zaf-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 10:26:21 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)) 10:26:21 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 10:26:21 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-x50sx9-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 10:26:21 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)) 10:26:21 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 10:26:21 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-feyjev-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 10:26:21 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)) 10:26:21 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 10:26:21 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-m9zcoo-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 10:26:21 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)) 10:26:21 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 10:26:21 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-vfyxlu-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 10:26:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///C:/slave/test/build/tests/mozbase/mozleak in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 9)) 10:26:21 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 10:26:21 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-r7wylu-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 10:26:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///C:/slave/test/build/tests/mozbase/mozlog in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10)) 10:26:21 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 10:26:21 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-7stkoh-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 10:26:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///C:/slave/test/build/tests/mozbase/moznetwork in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 11)) 10:26:21 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 10:26:21 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-bff6hf-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 10:26:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///C:/slave/test/build/tests/mozbase/mozprocess in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 12)) 10:26:21 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 10:26:21 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-o2enpy-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 10:26:22 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)) 10:26:22 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 10:26:22 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-khimjn-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 10:26:22 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)) 10:26:22 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 10:26:22 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-6v5oya-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 10:26:22 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)) 10:26:22 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 10:26:22 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-cm_r3m-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 10:26:22 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)) 10:26:22 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 10:26:22 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-lty7ak-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 10:26:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///C:/slave/test/build/tests/mozbase/mozversion in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 17)) 10:26:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==0.17->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2)) 10:26:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==0.17->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2)) 10:26:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in c:\slave\test\build\venv\lib\site-packages (from mozdebug==0.1->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 3)) 10:26:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test\build\venv\lib\site-packages (from mozdevice==0.48->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4)) 10:26:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in c:\slave\test\build\venv\lib\site-packages (from mozdevice==0.48->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4)) 10:26:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10)) 10:26:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:23 INFO - Downloading blessings-1.6.tar.gz 10:26:23 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings 10:26:23 INFO - Installing collected packages: blessings 10:26:23 INFO - Running setup.py install for blessings 10:26:24 INFO - Successfully installed blessings 10:26:24 INFO - Cleaning up... 10:26:26 INFO - Return code: 0 10:26:26 INFO - Done creating virtualenv C:\slave\test\build/venv. 10:26:26 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 10:26:26 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 10:26:27 INFO - Reading from file tmpfile_stdout 10:26:27 INFO - Using _rmtree_windows ... 10:26:27 INFO - Using _rmtree_windows ... 10:26:27 INFO - Current package versions: 10:26:27 INFO - blessings == 1.6 10:26:27 INFO - blobuploader == 1.2.4 10:26:27 INFO - docopt == 0.6.1 10:26:27 INFO - functools32 == 3.2.3-2 10:26:27 INFO - jsonschema == 2.5.1 10:26:27 INFO - manifestparser == 1.1 10:26:27 INFO - mozInstall == 1.12 10:26:27 INFO - mozcrash == 0.17 10:26:27 INFO - mozdebug == 0.1 10:26:27 INFO - mozdevice == 0.48 10:26:27 INFO - mozfile == 1.2 10:26:27 INFO - mozhttpd == 0.7 10:26:27 INFO - mozinfo == 0.9 10:26:27 INFO - mozleak == 0.1 10:26:27 INFO - mozlog == 3.4 10:26:27 INFO - moznetwork == 0.27 10:26:27 INFO - mozprocess == 0.23 10:26:27 INFO - mozprofile == 0.28 10:26:27 INFO - mozrunner == 6.12 10:26:27 INFO - mozscreenshot == 0.1 10:26:27 INFO - mozsystemmonitor == 0.3 10:26:27 INFO - moztest == 0.7 10:26:27 INFO - mozversion == 1.4 10:26:27 INFO - psutil == 3.1.1 10:26:27 INFO - requests == 1.2.3 10:26:27 INFO - Installing None into virtualenv C:\slave\test\build/venv 10:26:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:26:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:26:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:27 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 0x0232C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023D3E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024DF1C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0241AE90>, '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 0x01E2A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027FD520>, '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-208', 'USERDOMAIN': 'T-W864-IX-208', '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-208', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-208', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-208', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-208', '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-208\\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 10:26:27 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 10:26:27 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 10:26:27 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 10:26:27 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Roaming', 10:26:27 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 10:26:27 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 10:26:27 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 10:26:27 INFO - 'COMPUTERNAME': 'T-W864-IX-208', 10:26:27 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 10:26:27 INFO - 'DCLOCATION': 'SCL3', 10:26:27 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 10:26:27 INFO - 'FP_NO_HOST_CHECK': 'NO', 10:26:27 INFO - 'HOMEDRIVE': 'C:', 10:26:27 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-208', 10:26:27 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 10:26:27 INFO - 'KTS_VERSION': '1.19c', 10:26:27 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Local', 10:26:27 INFO - 'LOGONSERVER': '\\\\T-W864-IX-208', 10:26:27 INFO - 'MONDIR': 'C:\\Monitor_config\\', 10:26:27 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 10:26:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:27 INFO - 'MOZ_NO_REMOTE': '1', 10:26:27 INFO - 'NO_EM_RESTART': '1', 10:26:27 INFO - 'NUMBER_OF_PROCESSORS': '8', 10:26:27 INFO - 'OS': 'Windows_NT', 10:26:27 INFO - 'OURDRIVE': 'C:', 10:26:27 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 10:26:27 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 10:26:27 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 10:26:27 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 10:26:27 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 10:26:27 INFO - 'PROCESSOR_LEVEL': '6', 10:26:27 INFO - 'PROCESSOR_REVISION': '1e05', 10:26:27 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 10:26:27 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 10:26:27 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 10:26:27 INFO - 'PROGRAMW6432': 'C:\\Program Files', 10:26:27 INFO - 'PROMPT': '$P$G', 10:26:27 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 10:26:27 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 10:26:27 INFO - 'PUBLIC': 'C:\\Users\\Public', 10:26:27 INFO - 'PWD': 'C:\\slave\\test', 10:26:27 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 10:26:27 INFO - 'SLAVEDIR': 'C:\\slave\\', 10:26:27 INFO - 'SYSTEMDRIVE': 'C:', 10:26:27 INFO - 'SYSTEMROOT': 'C:\\windows', 10:26:27 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 10:26:27 INFO - 'TEST1': 'testie', 10:26:27 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 10:26:27 INFO - 'USERDOMAIN': 'T-W864-IX-208', 10:26:27 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-208', 10:26:27 INFO - 'USERNAME': 'cltbld', 10:26:27 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-208', 10:26:27 INFO - 'WINDIR': 'C:\\windows', 10:26:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 10:26:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 1)) 10:26:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 2)) 10:26:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 3)) 10:26:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 4)) 10:26:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 5)) 10:26:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 6)) 10:26:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 7)) 10:26:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 8)) 10:26:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 9)) 10:26:27 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in c:\slave\test\build\venv\lib\site-packages (from mozlog>=3.1->-r C:\slave\test\build\tests\talos\requirements.txt (line 1)) 10:26:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test\build\venv\lib\site-packages (from mozhttpd>=0.7->-r C:\slave\test\build\tests\talos\requirements.txt (line 4)) 10:26:27 INFO - Cleaning up... 10:26:27 INFO - Return code: 0 10:26:27 INFO - Installing jsonschema into virtualenv C:\slave\test\build/venv 10:26:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:26:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:26:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:27 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0232C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023D3E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024DF1C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0241AE90>, '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 0x01E2A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027FD520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-208', 'USERDOMAIN': 'T-W864-IX-208', '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-208', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-208', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-208', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-208', '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-208\\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 10:26:27 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in C:\slave\test\build 10:26:27 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:26:27 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 10:26:27 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Roaming', 10:26:27 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 10:26:27 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 10:26:27 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 10:26:27 INFO - 'COMPUTERNAME': 'T-W864-IX-208', 10:26:27 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 10:26:27 INFO - 'DCLOCATION': 'SCL3', 10:26:27 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 10:26:27 INFO - 'FP_NO_HOST_CHECK': 'NO', 10:26:27 INFO - 'HOMEDRIVE': 'C:', 10:26:27 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-208', 10:26:27 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 10:26:27 INFO - 'KTS_VERSION': '1.19c', 10:26:27 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Local', 10:26:27 INFO - 'LOGONSERVER': '\\\\T-W864-IX-208', 10:26:27 INFO - 'MONDIR': 'C:\\Monitor_config\\', 10:26:27 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 10:26:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:27 INFO - 'MOZ_NO_REMOTE': '1', 10:26:27 INFO - 'NO_EM_RESTART': '1', 10:26:27 INFO - 'NUMBER_OF_PROCESSORS': '8', 10:26:27 INFO - 'OS': 'Windows_NT', 10:26:27 INFO - 'OURDRIVE': 'C:', 10:26:27 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 10:26:27 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 10:26:27 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 10:26:27 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 10:26:27 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 10:26:27 INFO - 'PROCESSOR_LEVEL': '6', 10:26:27 INFO - 'PROCESSOR_REVISION': '1e05', 10:26:27 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 10:26:27 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 10:26:27 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 10:26:27 INFO - 'PROGRAMW6432': 'C:\\Program Files', 10:26:27 INFO - 'PROMPT': '$P$G', 10:26:27 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 10:26:27 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 10:26:27 INFO - 'PUBLIC': 'C:\\Users\\Public', 10:26:27 INFO - 'PWD': 'C:\\slave\\test', 10:26:27 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 10:26:27 INFO - 'SLAVEDIR': 'C:\\slave\\', 10:26:27 INFO - 'SYSTEMDRIVE': 'C:', 10:26:27 INFO - 'SYSTEMROOT': 'C:\\windows', 10:26:27 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 10:26:27 INFO - 'TEST1': 'testie', 10:26:27 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 10:26:27 INFO - 'USERDOMAIN': 'T-W864-IX-208', 10:26:27 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-208', 10:26:27 INFO - 'USERNAME': 'cltbld', 10:26:27 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-208', 10:26:27 INFO - 'WINDIR': 'C:\\windows', 10:26:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 10:26:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in c:\slave\test\build\venv\lib\site-packages 10:26:27 INFO - Cleaning up... 10:26:27 INFO - Return code: 0 10:26:27 INFO - Running post-action listener: _resource_record_post_action 10:26:27 INFO - Running post-action listener: _start_resource_monitoring 10:26:27 INFO - Starting resource monitoring. 10:26:28 INFO - [mozharness: 2016-10-16 17:26:28.055000Z] Finished create-virtualenv step (success) 10:26:28 INFO - [mozharness: 2016-10-16 17:26:28.055000Z] Running install step. 10:26:28 INFO - Running pre-action listener: _resource_record_pre_action 10:26:28 INFO - Running main action method: install 10:26:28 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 10:26:28 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 10:26:28 INFO - Reading from file tmpfile_stdout 10:26:28 INFO - Using _rmtree_windows ... 10:26:28 INFO - Using _rmtree_windows ... 10:26:28 INFO - Detecting whether we're running mozinstall >=1.0... 10:26:28 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h'] 10:26:28 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h 10:26:28 INFO - Reading from file tmpfile_stdout 10:26:28 INFO - Output received: 10:26:28 INFO - Usage: mozinstall-script.py [options] installer 10:26:28 INFO - Options: 10:26:28 INFO - -h, --help show this help message and exit 10:26:28 INFO - -d DEST, --destination=DEST 10:26:28 INFO - Directory to install application into. [default: 10:26:28 INFO - "C:\slave\test"] 10:26:28 INFO - --app=APP Application being installed. [default: firefox] 10:26:28 INFO - Using _rmtree_windows ... 10:26:28 INFO - Using _rmtree_windows ... 10:26:28 INFO - mkdir: C:\slave\test\build\application 10:26:28 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', 'C:\\slave\\test\\build\\firefox-52.0a1.en-US.win64.zip', '--destination', 'C:\\slave\\test\\build\\application'] 10:26:28 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py C:\slave\test\build\firefox-52.0a1.en-US.win64.zip --destination C:\slave\test\build\application ProcessManager NOT managing child processes 10:26:31 INFO - Reading from file tmpfile_stdout 10:26:31 INFO - Output received: 10:26:31 INFO - C:\slave\test\build\application\firefox\firefox.exe 10:26:31 INFO - Using _rmtree_windows ... 10:26:31 INFO - Using _rmtree_windows ... 10:26:31 INFO - Running post-action listener: _resource_record_post_action 10:26:31 INFO - [mozharness: 2016-10-16 17:26:31.340000Z] Finished install step (success) 10:26:31 INFO - [mozharness: 2016-10-16 17:26:31.340000Z] Running run-tests step. 10:26:31 INFO - Running pre-action listener: _resource_record_pre_action 10:26:31 INFO - Running main action method: run_tests 10:26:31 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version'] 10:26:31 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version 10:26:31 INFO - Python 2.7.3 10:26:31 INFO - Return code: 0 10:26:31 INFO - grabbing minidump binary from tooltool 10:26:31 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')]} 10:26:31 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 0x0241AE90>, '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 0x01E2A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027FD520>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1 10:26:31 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 10:26:31 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 10:26:31 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 10:26:31 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 10:26:32 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmpxv8epm 10:26:32 INFO - INFO - File integrity verified, renaming tmpxv8epm to win32-minidump_stackwalk.exe 10:26:32 INFO - Return code: 0 10:26:32 INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755 10:26:32 INFO - mkdir: C:\slave\test\build\blobber_upload_dir 10:26:32 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir 10:26:32 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe 10:26:32 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir 10:26:32 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M3tl11ZsQ9G9gV8AHmzWEA/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-208', '--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 10:26:32 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\tests\talos\talos\run_tests.py --branchName Firefox --suite dromaeojs --executablePath C:\slave\test\build\application\firefox\firefox --symbolsPath https://queue.taskcluster.net/v1/task/M3tl11ZsQ9G9gV8AHmzWEA/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip --title T-W864-IX-208 --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 10:26:32 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 10:26:32 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Roaming', 10:26:32 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 10:26:32 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 10:26:32 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 10:26:32 INFO - 'COMPUTERNAME': 'T-W864-IX-208', 10:26:32 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 10:26:32 INFO - 'DCLOCATION': 'SCL3', 10:26:32 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 10:26:32 INFO - 'FP_NO_HOST_CHECK': 'NO', 10:26:32 INFO - 'HOMEDRIVE': 'C:', 10:26:32 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-208', 10:26:32 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 10:26:32 INFO - 'KTS_VERSION': '1.19c', 10:26:32 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-208\\AppData\\Local', 10:26:32 INFO - 'LOGONSERVER': '\\\\T-W864-IX-208', 10:26:32 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir', 10:26:32 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe', 10:26:32 INFO - 'MONDIR': 'C:\\Monitor_config\\', 10:26:32 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 10:26:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:32 INFO - 'MOZ_NO_REMOTE': '1', 10:26:32 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir', 10:26:32 INFO - 'NO_EM_RESTART': '1', 10:26:32 INFO - 'NUMBER_OF_PROCESSORS': '8', 10:26:32 INFO - 'OS': 'Windows_NT', 10:26:32 INFO - 'OURDRIVE': 'C:', 10:26:32 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 10:26:32 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 10:26:32 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 10:26:32 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 10:26:32 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 10:26:32 INFO - 'PROCESSOR_LEVEL': '6', 10:26:32 INFO - 'PROCESSOR_REVISION': '1e05', 10:26:32 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 10:26:32 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 10:26:32 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 10:26:32 INFO - 'PROGRAMW6432': 'C:\\Program Files', 10:26:32 INFO - 'PROMPT': '$P$G', 10:26:32 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 10:26:32 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 10:26:32 INFO - 'PUBLIC': 'C:\\Users\\Public', 10:26:32 INFO - 'PWD': 'C:\\slave\\test', 10:26:32 INFO - 'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos', 10:26:32 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 10:26:32 INFO - 'SLAVEDIR': 'C:\\slave\\', 10:26:32 INFO - 'SYSTEMDRIVE': 'C:', 10:26:32 INFO - 'SYSTEMROOT': 'C:\\windows', 10:26:32 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 10:26:32 INFO - 'TEST1': 'testie', 10:26:32 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 10:26:32 INFO - 'USERDOMAIN': 'T-W864-IX-208', 10:26:32 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-208', 10:26:32 INFO - 'USERNAME': 'cltbld', 10:26:32 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-208', 10:26:32 INFO - 'WINDIR': 'C:\\windows', 10:26:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 10:26:32 INFO - Calling ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M3tl11ZsQ9G9gV8AHmzWEA/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-208', '--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 10:26:33 INFO - mozversion application_buildid: 20161016073001 10:26:33 INFO - mozversion application_changeset: 9079d167112122805f99f57bb8856e1b1675af0f 10:26:33 INFO - mozversion application_display_name: Nightly 10:26:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:26:33 INFO - mozversion application_name: Firefox 10:26:33 INFO - mozversion application_remotingname: firefox 10:26:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:26:33 INFO - mozversion application_vendor: Mozilla 10:26:33 INFO - mozversion application_version: 52.0a1 10:26:33 INFO - mozversion platform_buildid: 20161016073001 10:26:33 INFO - mozversion platform_changeset: 9079d167112122805f99f57bb8856e1b1675af0f 10:26:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:26:33 INFO - mozversion platform_version: 52.0a1 10:26:33 INFO - using testdate: 1476638793 10:26:33 INFO - actual date: 1476638793 10:26:33 INFO - starting webserver on 'localhost:49286' 10:26:33 INFO - SUITE-START | Running 2 tests 10:26:33 INFO - TEST-START | dromaeo_css 10:26:33 INFO - operating with platform_type : w8_ 10:26:33 INFO - Initialising browser for dromaeo_css test... 10:26:33 INFO - TEST-INFO | started process 32 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmp0x_84t\profile http://localhost:49286/getInfo.html) 10:26:40 INFO - PROCESS | 32 | __metrics Screen width/height:1600/1200 10:26:40 INFO - PROCESS | 32 | colorDepth:24 10:26:40 INFO - PROCESS | 32 | Browser inner width/height: 1010/674 10:26:40 INFO - PROCESS | 32 | __metrics 10:26:41 INFO - PROCESS | 32 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:26:41 INFO - PROCESS | 32 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:26:43 INFO - TEST-INFO | 32: exit 0 10:26:43 INFO - Browser initialized. 10:26:43 INFO - Running cycle 1/1 for dromaeo_css test... 10:26:43 INFO - TEST-INFO | started process 3832 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmp0x_84t\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:26:43 INFO - PROCESS | 3832 | [GFX1-]: Invalid size in UpdateRenderTarget Size(124,0), 0 10:26:54 INFO - PROCESS | 3832 | RSS: Main: 159952896 10:26:54 INFO - PROCESS | 3832 | 10:27:46 INFO - PROCESS | 3832 | 1476638866459 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] 10:29:56 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:49286/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49286/tests/dromaeo/cssquery-ext.html) 10:29:59 INFO - PROCESS | 3832 | RSS: Main: 392454144 10:29:59 INFO - PROCESS | 3832 | 10:33:01 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:49286/tests/dromaeo/cssquery-ext.html (next: http://localhost:49286/tests/dromaeo/cssquery-jquery.html) 10:33:02 INFO - PROCESS | 3832 | RSS: Main: 236032000 10:33:02 INFO - PROCESS | 3832 | 10:36:04 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:49286/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49286/tests/dromaeo/cssquery-mootools.html) 10:36:05 INFO - PROCESS | 3832 | RSS: Main: 174383104 10:36:05 INFO - PROCESS | 3832 | 10:39:07 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:49286/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49286/tests/dromaeo/cssquery-prototype.html) 10:39:07 INFO - PROCESS | 3832 | RSS: Main: 173522944 10:39:07 INFO - PROCESS | 3832 | 10:42:10 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:49286/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49286/tests/dromaeo/cssquery-yui.html) 10:42:11 INFO - PROCESS | 3832 | RSS: Main: 168230912 10:42:11 INFO - PROCESS | 3832 | 10:45:14 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:49286/tests/dromaeo/cssquery-yui.html (next: http://localhost:49286/tests/dromaeo/cssquery-dojo.html) 10:45:14 INFO - PROCESS | 3832 | RSS: Main: 243109888 10:45:14 INFO - PROCESS | 3832 | 10:45:14 INFO - PROCESS | 3832 | __start_tp_report 10:45:14 INFO - PROCESS | 3832 | _x_x_mozilla_page_load 10:45:14 INFO - PROCESS | 3832 | _x_x_mozilla_page_load_details 10:45:14 INFO - PROCESS | 3832 | |i|pagename|runs| 10:45:14 INFO - PROCESS | 3832 | |0;dojo.html;2859.4709978653946;2881.207667891328;2915.227464721849;2916.1251624512656;2928.8828446862126;5188.6367954243215;5191.948080519193;5199.116150254456;5214.139666954948;5278.89442211156;5073.213651883964;5174.922376164361;5221.973890130554;5237.607179461546;5249.763760630772;4614.769261536927;4635.58279754822;4643.071385722852;4688.882777930562;4704.1767690654;4690.671652984292;4695.037517308943;4704.294355846616;4714.50497697742;4724.763761811912;3424.47279302319;4640.46634637016;4696.906061878761;4698.718076915379;4744.810207591692;4496.572825581565;4728;4761.2143996240575;4785.808567657289;4847.2002119650215;4558.316252562109;4662.624525764907;4670.579647831678;4687.648426368036;4782.832600858953;5121.180611102206;5137.717425541594;5157.6647517911215;5162.251473536354;5196.558292545138;5544.390117087117;5572.5263352615075;5648.54811615074;5652.434756524356;5652.547796176296;5658.74535645897;5695.572832037614;5696.943030569682;5704.286964129484;5737.426257374271;5059.139946209117;5059.949400505948;5071.366079240095;5132.666376685504;5196.792128314825;5726.3700992890745;5774.0761478163295;5780.826575202751;5785.942140578541;5805.071188609802;5482.9467600090165;5494.917576236359;5508.9724551377785;5526.06056970308;5534.086875665551;5483.945160548423;5517.062099443105;5522.3649280333275;5530.225768392428;5633.605647604629;5486.231927530149;5511.889762204733;5520.171974203901;5533.557315414757;5535.280413546213;5502.532284755841;5540.085885828793;5542.39033706292;5543.861403464945;5549.084401073777;3641.9817900910325;3646.4530320451613;3647.179384638488;3656.323580137683;3662.5421822272215;3344.2809795894;3345.849436775351;3347.0795531229105;3364.6635336466647;3366.73066154707;5279.788808447619;5303.098473259555;5313.149896016619;5327.520523152934;5330.760115794721;5666.744996475086;5674.120511320752;5699.544036477072;5706.9714651426475;5712.485876271156;5272.314599102092;5326.414094449608;5333.679979201261;5339.652922560022;5340.851716880889;4523.547645235516;4579.633629309647;4649.186392381387;4682.1338052460405;4727.550882666142;5695.088785794253;5710.314762228559;5711.143328500758;5715.799947001835;5748.051571490657;5644.379118296902;5652.039153344023;5655.4910058094965;5657.15142728594;5711.942880571141;5713.085906254979;5725.570582206268;5729.398413166724;5730.426957304237;5738.540916726735;5369.328833895763;5471.261379713687;5480.095784195563;5542.556595472433;5565.833025009256;5616.438356164351;5663.150527420919;5663.830085097454;5666.943330566642;5673.404292549388;5413.702246376487;5498.120300751861;5500.147477141049;5502.697351645698;5509.889802204014;5489.313835770528;5494.532964698045;5509.256250406143;5513.862153446196;5521.585881058856;5443.863903402288;5464.808731694372;5464.836054918359;5472;5479.205515200353;4566.8173273068705;5462;5504.504594586507;5522.502974732293;5523.28197334344;5409.83770486886;5445.727713614383;5471.8084867029465;5498.477644623755;5559.24950131727 10:45:14 INFO - PROCESS | 3832 | |1;ext.html;551.2282804074296;554.9278593782808;558.6898722495748;567.6452217364146;576.8586696259417;28636.856815715917;35493.46759798602;36180.09549761254;36501.81749091251;38848.25182866771;36829.81585092077;37250.25499490008;37299;37462;37476;8169.387295952798;8281.17188281173;8305.418620696553;8312.54281014544;8316.667333306661;7647.158812530617;7768.495047821873;9531.189848862856;9639.903600963971;9700.175485083777;9770;9775.657851975182;9845.507724613777;9851.113399794018;9857.457839818808;7650.923490765133;9633.325667203299;9682.225421966226;9711.708648740549;9714.562844672007;7734.265244801735;7922.128565857751;7928.9603551982445;9373.812523749555;9615.807683846284;35473.82263088694;35564.288714225826;35870.64129358699;35909.820450897576;35910.28179436423;2533.910418520036;2535.290118766748;2535.759102885223;2594.6497222875046;2664.6669166354204;28385.57421638677;28533.28666783326;28586;28617.57073643897;28881.711182888113;3775.5658099318657;3795.8688211414437;3831.942520862189;3878.3794592865006;3955.0507878109333;195908;295184;295232;295370;296182.99999999785;43930;44863.10273794506;47855.56433307006;48765.26852097221;49458.25812612814;51169.744151279;51172;51347.22979155316;51429.742851285504;51495.97008059818;12682.175658582162;12708.618741437771;12817.102802803714;12826.61520154397;12849.972002239798;8968;9385.624575016924;9518.857217141749;9614.71155865325;9636.084571965652;15532.844671553366;15586.220688965506;15682.921585392;16055.839441605667;16056.75914861278;6192.133101365813;6222.471089957314;6222.790909227249;6251.624902505864;6320.209973753281;728.617475825196;799.1369321133162;827.664795757719;848.7708318753902;908.1871724806261;26044.96785867805;27040;27389.726102739118;27448.862755686092;27556.862215689194;834.3033566971525;896.3322324868016;902.5622573052065;927.4759760735163;993.5777294649889;13969.860301396857;14318.85681143196;14411.207383594003;14591.124532528082;14624.415023398944;423552;427604;431678;432665;435314;46948.7652561735;47265;47374.05251895012;47380.289295660594;47391.28913066307;987.2546227598117;1007.5617106558524;1049.4647729657777;1063.8297872340388;1074.4466599701161;25786.613200802378;28040.71959280381;28060.71939280581;28399.858000709864;28479.572806408334;40590.18819623532;40602.59397406106;41029.589704102575;41066.79466602648;41175;309185;310333;311815;312481;440099.3985090162;35572.466413003305;36388.81805590955;37063.258734824616;37185.44221836729;37404;40579;40841.69058022438;40863.7956810214;40979;41175.58824411837;35192.824035879654;35514.467282990256;35680.28639427145;35970.8201458991;36250.27499450049;35099.473507897914;35110.47334290039;35901.461478077326;35954;35987.820060899525;33490.33019339648;33761;34120;34140.82929585435;34545;31066.844665776527;31715;32018;32336.67663323337;32602.34795304033;20206;20242.79757202409;20261.189552417738;20281.79718202799;20351.898240508704 10:45:14 INFO - PROCESS | 3832 | |2;jquery.html;325.8957133717212;334.98492567834444;339.74519110667;343.7147167850684;361.3658030157074;13432.194068355906;14382.99319047667;16439.75340369894;16870.22862599425;17273.136343182854;13227;14075.296235188225;14109.576712698636;15067;15276.159811210378;5217.034848553029;5222.529972302492;5418.943306055321;5439.891202175954;5441.428649991733;4766.880827979311;5373.892522149555;5394.487523685244;5406.107992181285;5426.9185962210595;5148.510891465305;5336.4129945705945;5363.356397232318;5375.408705042442;5384.976854397672;5319.654222475527;5328.17413300939;5360.142377219626;5362.517373436371;5369.114096174127;4563.383943167696;4728.929066064012;4738.691985020997;4748.240281554935;4751.667383283171;20039.799602004085;20126.89936550308;20152.899235503875;20427.693584596243;20432.182712691476;1801.9459416217535;1873.7002079667325;1874.8593855460758;1901.6862217734058;2003.4190084875515;11665;11749.236299640495;12067.517299308018;12287.508499660004;13009.739805203937;1772.4151030160144;1833.7157740550235;1847.3072597775833;1867.915943782533;1875.5779949511386;66512.66743666299;67126;67550;67921.66039169821;69234.3076569233;8070.798230044178;8444.071152173256;8645.913540864636;8648.654053837776;8998.50508222041;10918.563257469772;10999.450027498593;11037.11703063753;11042.668719938414;11058.944705276423;6372.426481616584;6445.323241059715;6446.580972236789;6516.869662606721;6527.673616319165;6332.746690132343;6376.33048529907;6466.708998095097;6473.352664733489;6475.805725828139;3463.0995941055508;3499.2651543176216;3570.2680950405106;3576.5886923004186;3579.785212887183;1605.9678806423806;1666.758320043587;1668.299314288002;1695.8982461052376;1708.3593652380357;795.8368534450424;808.9645254074794;814.6985615322369;860.6643409070467;913.584319134792;16368.099754513378;16777.245023973952;16779.161041947853;17274.481765547054;17388.47834564965;752.4807882561015;762.4472257613186;788.4993029426356;794.8608993426127;798.4371018431991;8955.776105597282;9502.904970950201;9518.286128540387;9545.665901693408;9546.18857397115;380167;386122;386630;386633;413225;79429;79773.80339294915;80394;81110.59444702738;82997;781.4725060584083;795.9641816118288;796.4305521552118;831.1522247307834;841.6254766628914;14798.112113273239;14804.333804979016;15026.774598380814;15108.169050702318;15337.6165595861;34877.82561087178;35456.29087418289;35610.28779424449;35913.74301899421;36168.27663446664;49268;50113;50441;50556.747216265154;51119.488805111476;5031.723255220998;7207.531510451804;7327.644385788646;7455.142658594331;7651.885221721567;9680.951595241979;11538.423078846192;11638.709032273922;11765.823512647146;11829.349385783864;9493;9780.364276322016;9811.460369679737;9976.650817221362;10243.641472548425;9646.131848133702;9651.131398174199;9919.355241909252;10250.026247506476;10300.793984120126;9833.525745785793;10041.096301332915;10125.189984801345;10141.29010969225;10356.275060745675;7033;7198.5680859148615;7408.185099639143;7475.289847464483;7642.04474440695;9378.906210938076;9588.856167157637;9899.406035637885;10174.440405777457;10202.642907498202 10:45:14 INFO - PROCESS | 3832 | |3;mootools.html;1102.6636875752893;1142.4630423700858;1145.9197856150067;1226.7914454542727;1409.0700137908975;6695.631740254284;6928.2725313842075;7125.501214914945;7127.251638577953;7129.3940015098715;7023.297670232974;7225.49421540491;7231.096112985877;7244.891326630105;7247.45644076695;1936.6417212815675;1946.250693483005;1954.5113721569608;1960.725498430221;1961.0586918279234;1810.3301778342031;1826.506843152348;1834.4129878438905;1848.8705790594597;1853.8702290839647;1891.4609336339147;1899.5061284066105;1911.2641632971267;1923.0384807596201;1923.5960448305873;1850.232153656231;1882.4823173627226;1884.9340273090513;1889.3292881027244;1889.5937373464633;1874.8218919202654;1878.2862512245397;1913.206019501905;1922.3079691311116;1922.3944457495843;7308.0499535060635;7366.300201480851;7370.189279179286;7390.482666213367;7398.334149926479;4208.389783481409;4331.740095594275;4355.73865568067;4358.8038538265855;4359.585839345257;2869.727375899286;2962.3334749681367;2963.1110666799873;2984.6567644720917;2984.8955286565083;933.1834644685899;938.7981583959413;940.6942743608355;950.7005293332578;956.4882787708542;10049.598016079348;10148.797024059551;10183.59265629374;10184.847227291597;10197.439140847324;3690.6678398943686;3703.370427027358;3806.6193380662266;3881.320768865494;3883.30100581898;7785.961070194726;7852.921470785333;7875.212478752193;7878.172791856772;7885.053793544811;4145.709800314009;4181.289180839264;4184.058586817941;4186.204621121977;4189.120284740238;3598.4962105305276;3705.2589482103685;3899.7855117968215;3905.7851818149707;3915.7258991870294;3128.5932828732575;3212.823294718813;3253.300540383829;3263.8087098208985;3272.803631782053;950.6530116507425;955.1976339874539;957.7031120352713;971.7279161834698;990.2325697584286;648.8669822686338;699.6536714326339;719.8056524738291;733.7285204474379;746.5744525620453;4543.295789152687;4630.21286381316;4637.211674015425;4638.373819534387;4794.520547945178;766.4787944197999;770.4298818873992;776.4797585617649;777.2227772227773;780.0522365326156;3072.6620071792086;3111.1599868035505;3152.98423507881;3207.486802111651;3218.4206842768526;8774.692885748967;8854.734357969272;9135.817283654422;9181.081891810765;9239.584218710173;9134.177923986874;9145.81708365829;9160.175584197454;9162.404443711137;9165.90834091664;6912.654367281716;6929.722811087601;7009.334113259232;7042.154941407064;7107.502474826712;4601.28680054592;4634.72191668501;4665.813367465264;4679.953200467951;4752.168370535212;8377.70678026266;8386.035605905156;8435.451695639764;8458.619362128842;8460.703875364332;8212.260896519341;8532.91467085346;8555.187257210555;8555.700550480704;8566.828663426571;6272.717727702173;6378.425941665272;6392.0731493934045;6425.9036114457385;6434.646094464662;6521.152250207443;6834.794956151323;6838.897416538855;7015.789526314014;7050.25972272904;6520.478361730955;6525.836854078686;6623.337666233531;6665.500087493554;6720.428763554957;6230.50155987529;6254.6247225166635;6264.2796078451565;6298.307186209422;6364.299927008118;5859.9121013183985;5901.262342207224;5949.524038076857;5957.463828255478;5958.314793798769;3940.8226629802302;3943.4873466450326;3954.7429417088947;4020.798960051927;4031.9193616126927;4035.3745169498775;4082.510098788164;4088.918221635491;4116.073883376336;4244.38456423823 10:45:14 INFO - PROCESS | 3832 | |4;prototype.html;263.6282841193916;268.3626387330091;268.8843797167218;270.41185421707803;273.1954394308761;5197.103057384052;5243.606729495289;5244.659097158687;5249.790008399659;5268.472143078512;5121.950000249949;5155.407128180261;5197.63616546841;5200.349956255468;5203.947960520393;3706.388445906422;3790.924181516368;3813.161104556993;3872.3610604250266;3898.5906479819637;3889.436031775405;3894.941575876364;3896.902577435558;3898.298306304864;3909.882703518899;3826.617338266165;3865.942010869839;3871.2838124946834;3875.2636998970247;3876.9418458723144;3689.94465083024;3772.7170462215445;3840.2127563849344;3922.313595120871;3942.743721658083;3417.79493230407;3421.1105112670634;3427.1260828488826;3428.6970951038693;3429.9485507717404;5024.673396229234;5087.771050302746;5092.465291144451;5092.79628814847;5101.311322971388;4467.776611169428;4536.387587675687;4562.384078149441;4567.840125595588;4581.862544123682;5427.755750991176;5434.619576629638;5436.592255580807;5438.939406815673;5461.317335333083;3787.4886890269736;3790.692211187136;3793.430985352192;3795.7912314822674;3800.5439347278225;5469.726513674301;5636.182753500761;5703.372629010805;5704.689600711718;5713.4000929902595;3854.2655804887913;3861.613838616116;3875.476810630585;3875.6899448044087;3876.1860009398342;3915.314819906505;3917.725759196886;3926.509186351706;3929.44987701722;3930.8993481825137;4352.347147927773;4525.321201819687;4530.728156310632;4535.4103966484145;4538.500764915857;5445.720255739898;5448.264484294569;5468.535174510212;5472.863178420572;5492.395836457987;1301.6875949771986;1313.1989486413281;1313.967150821218;1317.8748018938186;1318.973620527584;791.1811275330006;819.4757750583909;824.5547404401556;828.2835347424434;840.369722707969;5071.492850714899;5127.154019586801;5271;5279.841604751864;5282.524572788468;5657.773689052474;5664.801731939362;5671.914921276184;5682.488576028178;5698.971505142447;4980.676256043345;5243.056249874983;5272.470983414767;5275.4460781618145;5286.60350473716;2994.595729576523;3031.969680303213;3038.468268053082;3043.802152860101;3052.4200401923563;5794.21778059965;5805.419458054161;5810.302763668303;5814.877569687118;5819.592628515963;5559.332880054339;5746.597738158289;5758.602424569524;5762.94237057624;5787.913181302284;5754.971225143931;5761.539076873756;5769.134629805562;5772.998041018647;5785.25200529745;5434.331826017501;5655.406182350794;5676.893005863982;5705.201271821865;5724;5574.749136288958;5579.302587176603;5581;5583;5586.217929489793;5761.39505351932;5763.193152958673;5766.3368712598585;5767.68277744728;5793.710314484175;3323.6705317873043;3403.727701783901;3426.2119712465774;3433.9656603434646;3441.1913200398385;4959.404871415309;4961.8511444656715;4965.45380008206;4970.40355157369;4981.37732783402;4847.175980083323;4875.488073752205;4877.829410882954;4878.487668822676;4882.217136232455;4603.58567728906;4801.175553289728;4803.903921921612;4835.3714017178945;4853.199222128309;4776.904461910812;4789.425268967746;4790.963840367899;4800.279958006327;4805.038992201504;5251.632385732962;5288.762005709829;5386.326709161355;5531.612787105025;5543.944560554342;5431.321084864392;5483.643563168382;5484.067708489487;5484.7806087757635;5490.407781743409 10:45:14 INFO - PROCESS | 3832 | |5;yui.html;532.5340327213688;572.3789688188318;576.9960269131709;587.5387820560858;598.533144147565;11371.260868043582;12269.386530673453;12316.076294277931;12331.568395106173;12406.131570790048;12060.457279422426;12115.212511186766;12235.816462753044;12266.32535210563;12269.754604907897;533.2534451767518;547.0836349115216;603.6408337039477;607.9726412311456;616.8951278282681;613.8894998900219;615.0251850816461;615.6336979497192;616.442119881508;618.2550027217193;633.1452539072262;643.4530648948403;644.851684112652;646.1825790375179;646.3213625693027;641.0544446940771;641.2881701311541;641.5412979719499;643.5655932245762;644.3524258120582;471.2342443529265;471.87495313741886;472.4047699898119;472.81087564973944;473.5146474863258;11400.201985860993;11441.42792860362;11450;11453.541858325658;11457.25527840696;12041.458134383885;12170.756584868253;12256.142070055099;12556.937215313865;12991.610251692464;9987.850182247272;10000.149987251092;10002.749931251705;10221.33561318512;10450.738731531697;3311.5529403530454;3318.734501239895;3398.7790793598338;3402.387570237356;3463.1688394785324;65953.67023164853;66277;67039.99440008453;67197.3280267196;67865.32134678689;9115.225205857443;9150.313726470542;9155.13026262504;9267.351285410092;9423.764405889908;15582.532524024298;16102.75845862313;16107.355705771872;16174.353025879069;16210.83789162117;7183.928160718326;7301.598412087386;7381.37258333037;7428.888566671504;7504.662290196845;3990.481237439172;4085.652719518874;4135.255653982252;4136.91726165475;4210.073783767566;2673.224764818181;2782.095818858879;2784.805063645566;2786;2788.721127887195;476.1072988147224;480.495479746272;505.4692572798547;508.88550076232553;509.16242780625663;462.454303921376;554.5646667366099;573.6300086444304;578.3955766224306;583.3495652347602;7787.883181752165;7820.648070836826;8135.633896474673;8406.369522285853;8461.23848853606;515.4201523286303;600.129811772931;603.1435361786274;604.0908432808595;612.6691586543305;3802.296575133609;3857.8263978121054;3865.845366185321;3937.547182074041;4057.39139129133;85262;88141;88761.11238887657;96411;103615;60466.69766651138;81276;86398.56800716082;87187.56406217928;87277;66350.66824665846;68068.31931680719;68286.31713682899;70103.64948175226;76512.61743691246;8086.280311056979;8264;8507.617157228064;8739.082396348545;8766.386352955233;43557;44778;45038.324425134306;45350;46305.53694463147;59053.40946590479;64079;64128.679356602916;64494;66320.66839665771;10636.787264254517;10638.255322127687;10832.18758593093;10850.782984340427;11116.44417779124;12125.592546992626;12152.939235303767;12454.813177802522;12566.246025238515;12606.982882738717;11724;11725.76548469043;12003.39983000829;12263.632091037283;12417.379131043232;11140.944295278472;11178.55285788592;11657.825132622847;12136.575219867262;12196;11163.720906977065;11185.161112916401;11332.150088743212;11385.829212561985;11647.941760291144;9642.325037247325;9689.612415503301;9696.175825054666;9767.706968790664;10006.949965250127;9166.404183728037;9587.072175032734;9588.137067663944;9636.46999415039;9796.804063918538 10:45:14 INFO - PROCESS | 3832 | __end_tp_report 10:45:14 INFO - PROCESS | 3832 | __start_cc_report 10:45:14 INFO - PROCESS | 3832 | _x_x_mozilla_cycle_collect,2576 10:45:14 INFO - PROCESS | 3832 | __end_cc_report 10:45:14 INFO - PROCESS | 3832 | __startTimestamp1476639914254__endTimestamp 10:45:14 INFO - PROCESS | 3832 | 10:45:14 INFO - PROCESS | 3832 | ------- Summary: start ------- 10:45:14 INFO - PROCESS | 3832 | Number of tests: 6 10:45:14 INFO - PROCESS | 3832 | 10:45:14 INFO - PROCESS | 3832 | [#0] dojo.html Cycles:165 Average:5133.75 Median:5464.81 stddev:702.53 (12.9%) stddev-sans-first:681.65 10:45:14 INFO - PROCESS | 3832 | Values: 2859.5 2881.2 2915.2 2916.1 2928.9 5188.6 5191.9 5199.1 5214.1 5278.9 5073.2 5174.9 5222.0 5237.6 5249.8 4614.8 4635.6 4643.1 4688.9 4704.2 4690.7 4695.0 4704.3 4714.5 4724.8 3424.5 4640.5 4696.9 4698.7 4744.8 4496.6 4728.0 4761.2 4785.8 4847.2 4558.3 4662.6 4670.6 4687.6 4782.8 5121.2 5137.7 5157.7 5162.3 5196.6 5544.4 5572.5 5648.5 5652.4 5652.5 5658.7 5695.6 5696.9 5704.3 5737.4 5059.1 5059.9 5071.4 5132.7 5196.8 5726.4 5774.1 5780.8 5785.9 5805.1 5482.9 5494.9 5509.0 5526.1 5534.1 5483.9 5517.1 5522.4 5530.2 5633.6 5486.2 5511.9 5520.2 5533.6 5535.3 5502.5 5540.1 5542.4 5543.9 5549.1 3642.0 3646.5 3647.2 3656.3 3662.5 3344.3 3345.8 3347.1 3364.7 3366.7 5279.8 5303.1 5313.1 5327.5 5330.8 5666.7 5674.1 5699.5 5707.0 5712.5 5272.3 5326.4 5333.7 5339.7 5340.9 4523.5 4579.6 4649.2 4682.1 4727.6 5695.1 5710.3 5711.1 5715.8 5748.1 5644.4 5652.0 5655.5 5657.2 5711.9 5713.1 5725.6 5729.4 5730.4 5738.5 5369.3 5471.3 5480.1 5542.6 5565.8 5616.4 5663.2 5663.8 5666.9 5673.4 5413.7 5498.1 5500.1 5502.7 5509.9 5489.3 5494.5 5509.3 5513.9 5521.6 5443.9 5464.8 5464.8 5472.0 5479.2 4566.8 5462.0 5504.5 5522.5 5523.3 5409.8 5445.7 5471.8 5498.5 5559.2 10:45:14 INFO - PROCESS | 3832 | 10:45:14 INFO - PROCESS | 3832 | [#1] ext.html Cycles:180 Average:49134.85 Median:37469.00 stddev:93963.63 (250.8%) stddev-sans-first:94156.41 10:45:14 INFO - PROCESS | 3832 | Values: 551.2 554.9 558.7 567.6 576.9 28636.9 35493.5 36180.1 36501.8 38848.3 36829.8 37250.3 37299.0 37462.0 37476.0 8169.4 8281.2 8305.4 8312.5 8316.7 7647.2 7768.5 9531.2 9639.9 9700.2 9770.0 9775.7 9845.5 9851.1 9857.5 7650.9 9633.3 9682.2 9711.7 9714.6 7734.3 7922.1 7929.0 9373.8 9615.8 35473.8 35564.3 35870.6 35909.8 35910.3 2533.9 2535.3 2535.8 2594.6 2664.7 28385.6 28533.3 28586.0 28617.6 28881.7 3775.6 3795.9 3831.9 3878.4 3955.1 195908.0 295184.0 295232.0 295370.0 296183.0 43930.0 44863.1 47855.6 48765.3 49458.3 51169.7 51172.0 51347.2 51429.7 51496.0 12682.2 12708.6 12817.1 12826.6 12850.0 8968.0 9385.6 9518.9 9614.7 9636.1 15532.8 15586.2 15682.9 16055.8 16056.8 6192.1 6222.5 6222.8 6251.6 6320.2 728.6 799.1 827.7 848.8 908.2 26045.0 27040.0 27389.7 27448.9 27556.9 834.3 896.3 902.6 927.5 993.6 13969.9 14318.9 14411.2 14591.1 14624.4 423552.0 427604.0 431678.0 432665.0 435314.0 46948.8 47265.0 47374.1 47380.3 47391.3 987.3 1007.6 1049.5 1063.8 1074.4 25786.6 28040.7 28060.7 28399.9 28479.6 40590.2 40602.6 41029.6 41066.8 41175.0 309185.0 310333.0 311815.0 312481.0 440099.4 35572.5 36388.8 37063.3 37185.4 37404.0 40579.0 40841.7 40863.8 40979.0 41175.6 35192.8 35514.5 35680.3 35970.8 36250.3 35099.5 35110.5 35901.5 35954.0 35987.8 33490.3 33761.0 34120.0 34140.8 34545.0 31066.8 31715.0 32018.0 32336.7 32602.3 20206.0 20242.8 20261.2 20281.8 20351.9 10:45:14 INFO - PROCESS | 3832 | 10:45:14 INFO - PROCESS | 3832 | [#2] jquery.html Cycles:180 Average:24003.93 Median:27572.36 stddev:64622.07 (234.4%) stddev-sans-first:64778.89 10:45:14 INFO - PROCESS | 3832 | Values: 325.9 335.0 339.7 343.7 361.4 13432.2 14383.0 16439.8 16870.2 17273.1 13227.0 14075.3 14109.6 15067.0 15276.2 5217.0 5222.5 5418.9 5439.9 5441.4 4766.9 5373.9 5394.5 5406.1 5426.9 5148.5 5336.4 5363.4 5375.4 5385.0 5319.7 5328.2 5360.1 5362.5 5369.1 4563.4 4728.9 4738.7 4748.2 4751.7 20039.8 20126.9 20152.9 20427.7 20432.2 1801.9 1873.7 1874.9 1901.7 2003.4 11665.0 11749.2 12067.5 12287.5 13009.7 1772.4 1833.7 1847.3 1867.9 1875.6 66512.7 67126.0 67550.0 67921.7 69234.3 8070.8 8444.1 8645.9 8648.7 8998.5 10918.6 10999.5 11037.1 11042.7 11058.9 6372.4 6445.3 6446.6 6516.9 6527.7 6332.7 6376.3 6466.7 6473.4 6475.8 3463.1 3499.3 3570.3 3576.6 3579.8 1606.0 1666.8 1668.3 1695.9 1708.4 795.8 809.0 814.7 860.7 913.6 16368.1 16777.2 16779.2 17274.5 17388.5 752.5 762.4 788.5 794.9 798.4 8955.8 9502.9 9518.3 9545.7 9546.2 380167.0 386122.0 386630.0 386633.0 413225.0 79429.0 79773.8 80394.0 81110.6 82997.0 781.5 796.0 796.4 831.2 841.6 14798.1 14804.3 15026.8 15108.2 15337.6 34877.8 35456.3 35610.3 35913.7 36168.3 49268.0 50113.0 50441.0 50556.7 51119.5 5031.7 7207.5 7327.6 7455.1 7651.9 9681.0 11538.4 11638.7 11765.8 11829.3 9493.0 9780.4 9811.5 9976.7 10243.6 9646.1 9651.1 9919.4 10250.0 10300.8 9833.5 10041.1 10125.2 10141.3 10356.3 7033.0 7198.6 7408.2 7475.3 7642.0 9378.9 9588.9 9899.4 10174.4 10202.6 10:45:14 INFO - PROCESS | 3832 | 10:45:14 INFO - PROCESS | 3832 | [#3] mootools.html Cycles:180 Average:4739.87 Median:5880.59 stddev:2731.88 (46.5%) stddev-sans-first:2725.87 10:45:14 INFO - PROCESS | 3832 | Values: 1102.7 1142.5 1145.9 1226.8 1409.1 6695.6 6928.3 7125.5 7127.3 7129.4 7023.3 7225.5 7231.1 7244.9 7247.5 1936.6 1946.3 1954.5 1960.7 1961.1 1810.3 1826.5 1834.4 1848.9 1853.9 1891.5 1899.5 1911.3 1923.0 1923.6 1850.2 1882.5 1884.9 1889.3 1889.6 1874.8 1878.3 1913.2 1922.3 1922.4 7308.0 7366.3 7370.2 7390.5 7398.3 4208.4 4331.7 4355.7 4358.8 4359.6 2869.7 2962.3 2963.1 2984.7 2984.9 933.2 938.8 940.7 950.7 956.5 10049.6 10148.8 10183.6 10184.8 10197.4 3690.7 3703.4 3806.6 3881.3 3883.3 7786.0 7852.9 7875.2 7878.2 7885.1 4145.7 4181.3 4184.1 4186.2 4189.1 3598.5 3705.3 3899.8 3905.8 3915.7 3128.6 3212.8 3253.3 3263.8 3272.8 950.7 955.2 957.7 971.7 990.2 648.9 699.7 719.8 733.7 746.6 4543.3 4630.2 4637.2 4638.4 4794.5 766.5 770.4 776.5 777.2 780.1 3072.7 3111.2 3153.0 3207.5 3218.4 8774.7 8854.7 9135.8 9181.1 9239.6 9134.2 9145.8 9160.2 9162.4 9165.9 6912.7 6929.7 7009.3 7042.2 7107.5 4601.3 4634.7 4665.8 4680.0 4752.2 8377.7 8386.0 8435.5 8458.6 8460.7 8212.3 8532.9 8555.2 8555.7 8566.8 6272.7 6378.4 6392.1 6425.9 6434.6 6521.2 6834.8 6838.9 7015.8 7050.3 6520.5 6525.8 6623.3 6665.5 6720.4 6230.5 6254.6 6264.3 6298.3 6364.3 5859.9 5901.3 5949.5 5957.5 5958.3 3940.8 3943.5 3954.7 4020.8 4031.9 4035.4 4082.5 4088.9 4116.1 4244.4 10:45:14 INFO - PROCESS | 3832 | 10:45:14 INFO - PROCESS | 3832 | [#4] prototype.html Cycles:180 Average:4472.82 Median:5003.03 stddev:1369.27 (27.4%) stddev-sans-first:1336.17 10:45:14 INFO - PROCESS | 3832 | Values: 263.6 268.4 268.9 270.4 273.2 5197.1 5243.6 5244.7 5249.8 5268.5 5122.0 5155.4 5197.6 5200.3 5203.9 3706.4 3790.9 3813.2 3872.4 3898.6 3889.4 3894.9 3896.9 3898.3 3909.9 3826.6 3865.9 3871.3 3875.3 3876.9 3689.9 3772.7 3840.2 3922.3 3942.7 3417.8 3421.1 3427.1 3428.7 3429.9 5024.7 5087.8 5092.5 5092.8 5101.3 4467.8 4536.4 4562.4 4567.8 4581.9 5427.8 5434.6 5436.6 5438.9 5461.3 3787.5 3790.7 3793.4 3795.8 3800.5 5469.7 5636.2 5703.4 5704.7 5713.4 3854.3 3861.6 3875.5 3875.7 3876.2 3915.3 3917.7 3926.5 3929.4 3930.9 4352.3 4525.3 4530.7 4535.4 4538.5 5445.7 5448.3 5468.5 5472.9 5492.4 1301.7 1313.2 1314.0 1317.9 1319.0 791.2 819.5 824.6 828.3 840.4 5071.5 5127.2 5271.0 5279.8 5282.5 5657.8 5664.8 5671.9 5682.5 5699.0 4980.7 5243.1 5272.5 5275.4 5286.6 2994.6 3032.0 3038.5 3043.8 3052.4 5794.2 5805.4 5810.3 5814.9 5819.6 5559.3 5746.6 5758.6 5762.9 5787.9 5755.0 5761.5 5769.1 5773.0 5785.3 5434.3 5655.4 5676.9 5705.2 5724.0 5574.7 5579.3 5581.0 5583.0 5586.2 5761.4 5763.2 5766.3 5767.7 5793.7 3323.7 3403.7 3426.2 3434.0 3441.2 4959.4 4961.9 4965.5 4970.4 4981.4 4847.2 4875.5 4877.8 4878.5 4882.2 4603.6 4801.2 4803.9 4835.4 4853.2 4776.9 4789.4 4791.0 4800.3 4805.0 5251.6 5288.8 5386.3 5531.6 5543.9 5431.3 5483.6 5484.1 5484.8 5490.4 10:45:14 INFO - PROCESS | 3832 | 10:45:14 INFO - PROCESS | 3832 | [#5] yui.html Cycles:180 Average:17297.02 Median:509.02 stddev:24784.54 (4869.0%) stddev-sans-first:24822.10 10:45:14 INFO - PROCESS | 3832 | Values: 532.5 572.4 577.0 587.5 598.5 11371.3 12269.4 12316.1 12331.6 12406.1 12060.5 12115.2 12235.8 12266.3 12269.8 533.3 547.1 603.6 608.0 616.9 613.9 615.0 615.6 616.4 618.3 633.1 643.5 644.9 646.2 646.3 641.1 641.3 641.5 643.6 644.4 471.2 471.9 472.4 472.8 473.5 11400.2 11441.4 11450.0 11453.5 11457.3 12041.5 12170.8 12256.1 12556.9 12991.6 9987.9 10000.1 10002.7 10221.3 10450.7 3311.6 3318.7 3398.8 3402.4 3463.2 65953.7 66277.0 67040.0 67197.3 67865.3 9115.2 9150.3 9155.1 9267.4 9423.8 15582.5 16102.8 16107.4 16174.4 16210.8 7183.9 7301.6 7381.4 7428.9 7504.7 3990.5 4085.7 4135.3 4136.9 4210.1 2673.2 2782.1 2784.8 2786.0 2788.7 476.1 480.5 505.5 508.9 509.2 462.5 554.6 573.6 578.4 583.3 7787.9 7820.6 8135.6 8406.4 8461.2 515.4 600.1 603.1 604.1 612.7 3802.3 3857.8 3865.8 3937.5 4057.4 85262.0 88141.0 88761.1 96411.0 103615.0 60466.7 81276.0 86398.6 87187.6 87277.0 66350.7 68068.3 68286.3 70103.6 76512.6 8086.3 8264.0 8507.6 8739.1 8766.4 43557.0 44778.0 45038.3 45350.0 46305.5 59053.4 64079.0 64128.7 64494.0 66320.7 10636.8 10638.3 10832.2 10850.8 11116.4 12125.6 12152.9 12454.8 12566.2 12607.0 11724.0 11725.8 12003.4 12263.6 12417.4 11140.9 11178.6 11657.8 12136.6 12196.0 11163.7 11185.2 11332.2 11385.8 11647.9 9642.3 9689.6 9696.2 9767.7 10006.9 9166.4 9587.1 9588.1 9636.5 9796.8 10:45:14 INFO - PROCESS | 3832 | -------- Summary: end -------- 10:45:14 INFO - PROCESS | 3832 | 10:45:14 INFO - TEST-INFO | 3832: exit 0 10:45:15 INFO - TEST-OK | dromaeo_css | took 1122200ms 10:45:15 INFO - TEST-START | kraken 10:45:15 INFO - operating with platform_type : w8_ 10:45:15 INFO - Initialising browser for kraken test... 10:45:15 INFO - TEST-INFO | started process 3956 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmp_ci7fv\profile http://localhost:49286/getInfo.html) 10:45:20 INFO - PROCESS | 3956 | __metrics Screen width/height:1600/1200 10:45:20 INFO - PROCESS | 3956 | colorDepth:24 10:45:20 INFO - PROCESS | 3956 | Browser inner width/height: 1010/674 10:45:20 INFO - PROCESS | 3956 | __metrics 10:45:21 INFO - PROCESS | 3956 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:45:21 INFO - PROCESS | 3956 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:45:22 INFO - PROCESS | 3956 | console.error: 10:45:22 INFO - PROCESS | 3956 | Message: Error: Connection closed before committing the transaction. 10:45:22 INFO - PROCESS | 3956 | Stack: 10:45:22 INFO - PROCESS | 3956 | ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:937:23 10:45:22 INFO - PROCESS | 3956 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7 10:45:22 INFO - PROCESS | 3956 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11 10:45:22 INFO - PROCESS | 3956 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7 10:45:22 INFO - PROCESS | 3956 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:714:7 10:45:22 INFO - PROCESS | 3956 | TaskImpl_run@resource://gre/modules/Task.jsm:327:15 10:45:22 INFO - PROCESS | 3956 | Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:551:9 10:45:22 INFO - PROCESS | 3956 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15 10:45:22 INFO - PROCESS | 3956 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:388:5 10:45:22 INFO - PROCESS | 3956 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29 10:45:22 INFO - PROCESS | 3956 | Barrier/this.client.addBlocker/promise13.4% 10:46:19 INFO - TinderboxPrint: I/O read bytes / time
40,332,288 / 390,990 10:46:19 INFO - TinderboxPrint: I/O write bytes / time
405,600,256 / 3,605,910 10:46:19 INFO - TinderboxPrint: CPU idle
8,248.6 (86.6%) 10:46:19 INFO - TinderboxPrint: CPU user
1,225.5 (12.9%) 10:46:19 INFO - install - Wall time: 3s; CPU: 8.0%; Read bytes: 0; Write bytes: 90142720; Read time: 0; Write time: 158870 10:46:19 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 40332288; Write bytes: 312274944; Read time: 390990; Write time: 3426680 10:46:19 INFO - Running post-run listener: _upload_blobber_files 10:46:19 INFO - Blob upload gear active. 10:46:19 INFO - Preparing to upload files from C:\slave\test\build\blobber_upload_dir. 10:46:19 INFO - Files from C:\slave\test\build\blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:46:19 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\venv\\Scripts\\blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', 'C:\\slave\\test\\oauth.txt', '-b', 'Firefox', '-d', 'C:\\slave\\test\\build\\blobber_upload_dir', '--output-manifest', 'C:\\slave\\test\\build\\uploaded_files.json'] 10:46:19 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\venv\Scripts\blobberc.py -u https://blobupload.elasticbeanstalk.com -a C:\slave\test\oauth.txt -b Firefox -d C:\slave\test\build\blobber_upload_dir --output-manifest C:\slave\test\build\uploaded_files.json 10:46:20 INFO - (blobuploader) - INFO - Open directory for files ... 10:46:20 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_errorsummary.log ... 10:46:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:46:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:46:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:46:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:46:20 INFO - (blobuploader) - INFO - Done attempting. 10:46:20 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_raw.log ... 10:46:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:46:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:46:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:46:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:46:21 INFO - (blobuploader) - INFO - Done attempting. 10:46:21 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\resource-usage.json ... 10:46:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:46:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:46:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:46:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:46:23 INFO - (blobuploader) - INFO - Done attempting. 10:46:23 INFO - (blobuploader) - INFO - Iteration through files over. 10:46:23 INFO - Return code: 0 10:46:23 INFO - rmtree: C:\slave\test\build\uploaded_files.json 10:46:23 INFO - Using _rmtree_windows ... 10:46:23 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build\\uploaded_files.json',), kwargs: {}, attempt #1 10:46:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d74822df465029e945c1e8a8e477e2978dad8edb5da937e787cb6c10937c5f0104a7bf0e8b1b3a5398271f6266bd1ed1685a5b150870946c550571d7cc120d45", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de7ba4187768f313f9044f4b10cfabd78e33e52ab057a93f6a2a1a35244f31e983515bec8dafd496642ea54c4e757df36df9ceb19e2ede6d4afbe8c6af469f33", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6df064fad01cafa68f59146dea6bdc098047dc6bc977433244bb769fcf0a6ae7a06b5ae99a5593b0f20c7702ad75b2686bd0b00ea0662ea721f567fc7452a4b0"} 10:46:23 INFO - Writing buildbot properties ['blobber_files'] to C:\slave\test\properties\blobber_files 10:46:23 INFO - Writing to file C:\slave\test\properties\blobber_files 10:46:23 INFO - Contents: 10:46:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d74822df465029e945c1e8a8e477e2978dad8edb5da937e787cb6c10937c5f0104a7bf0e8b1b3a5398271f6266bd1ed1685a5b150870946c550571d7cc120d45", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de7ba4187768f313f9044f4b10cfabd78e33e52ab057a93f6a2a1a35244f31e983515bec8dafd496642ea54c4e757df36df9ceb19e2ede6d4afbe8c6af469f33", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6df064fad01cafa68f59146dea6bdc098047dc6bc977433244bb769fcf0a6ae7a06b5ae99a5593b0f20c7702ad75b2686bd0b00ea0662ea721f567fc7452a4b0"} 10:46:23 INFO - Running post-run listener: copy_logs_to_upload_dir 10:46:23 INFO - Copying logs to upload dir... 10:46:23 INFO - mkdir: C:\slave\test\build\upload\logs 10:46:23 INFO - Copying logs to upload dir... 10:46:23 INFO - Using _rmtree_windows ... 10:46:23 INFO - Using _rmtree_windows ... 10:46:23 INFO - Using _rmtree_windows ... 10:46:23 INFO - Using _rmtree_windows ... 10:46:23 INFO - Using _rmtree_windows ... 10:46:23 INFO - Using _rmtree_windows ... 10:46:23 INFO - Using _rmtree_windows ... program finished with exit code 0 elapsedTime=1350.462000 ========= master_lag: 0.92 ========= ========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 22 mins, 31 secs) (at 2016-10-16 10:46:24.618544) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-16 10:46:24.619409) ========= '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-208\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-208 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-208 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-208\AppData\Local LOGONSERVER=\\T-W864-IX-208 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-208 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-208 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-208 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d74822df465029e945c1e8a8e477e2978dad8edb5da937e787cb6c10937c5f0104a7bf0e8b1b3a5398271f6266bd1ed1685a5b150870946c550571d7cc120d45", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de7ba4187768f313f9044f4b10cfabd78e33e52ab057a93f6a2a1a35244f31e983515bec8dafd496642ea54c4e757df36df9ceb19e2ede6d4afbe8c6af469f33", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6df064fad01cafa68f59146dea6bdc098047dc6bc977433244bb769fcf0a6ae7a06b5ae99a5593b0f20c7702ad75b2686bd0b00ea0662ea721f567fc7452a4b0"} build_url:https://queue.taskcluster.net/v1/task/M3tl11ZsQ9G9gV8AHmzWEA/artifacts/public/build/firefox-52.0a1.en-US.win64.zip program finished with exit code 0 elapsedTime=0.102000 build_url: 'https://queue.taskcluster.net/v1/task/M3tl11ZsQ9G9gV8AHmzWEA/artifacts/public/build/firefox-52.0a1.en-US.win64.zip' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d74822df465029e945c1e8a8e477e2978dad8edb5da937e787cb6c10937c5f0104a7bf0e8b1b3a5398271f6266bd1ed1685a5b150870946c550571d7cc120d45", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de7ba4187768f313f9044f4b10cfabd78e33e52ab057a93f6a2a1a35244f31e983515bec8dafd496642ea54c4e757df36df9ceb19e2ede6d4afbe8c6af469f33", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6df064fad01cafa68f59146dea6bdc098047dc6bc977433244bb769fcf0a6ae7a06b5ae99a5593b0f20c7702ad75b2686bd0b00ea0662ea721f567fc7452a4b0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-16 10:46:24.742124) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 10:46:24.742473) ========= '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-208\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-208 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-208 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-208\AppData\Local LOGONSERVER=\\T-W864-IX-208 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-208 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-208 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-208 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-16 10:46:24.861229) ========= ========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-10-16 10:46:24.861565) ========= ========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-10-16 10:46:25.403496) ========= ========= Total master_lag: 5.95 =========