builder: mozilla-central_win8_64_test-dromaeojs-e10s-pgo slave: t-w864-ix-074 starttime: 1476905743.69 results: success (0) buildid: 20161019103003 builduid: 5e0bc85648714446977ffc5491062a3b revision: f40960c63bfac865d510ec9da42eeed74c384082 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 12:35:43.693221) ========= master: http://buildbot-master111.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 12:35:43.693856) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 12:35:43.694499) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 12:35:43.839803) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-19 12:35:43.840091) ========= '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-074\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-074 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-074 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-074\AppData\Local LOGONSERVER=\\T-W864-IX-074 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-074 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-074 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-074 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False --12:35: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.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. WARNING: Certificate verification error for hg.mozilla.org: certificate signature failure HTTP request sent, awaiting response... 200 Script output follows Length: 12,179 (12K) [text/x-python] 0K .......... . 100% 1.74 GB/s 12:35:44 (1.74 GB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=1.203000 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-19 12:35:45.113005) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 7 secs) (at 2016-10-19 12:35:45.113343) ========= '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-074\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-074 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-074 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-074\AppData\Local LOGONSERVER=\\T-W864-IX-074 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-074 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-074 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-074 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=2.606000 ========= master_lag: 4.90 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 7 secs) (at 2016-10-19 12:35:52.618092) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-10-19 12:35:52.618393) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo mozilla-central --rev f40960c63bfac865d510ec9da42eeed74c384082 --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 f40960c63bfac865d510ec9da42eeed74c384082 --destination scripts --debug'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-074\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-074 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-074 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-074\AppData\Local LOGONSERVER=\\T-W864-IX-074 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-074 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-074 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-074 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 2016-10-19 12:35:52,858 truncating revision to first 12 chars 2016-10-19 12:35:52,858 Setting DEBUG logging. 2016-10-19 12:35:52,858 attempt 1/10 2016-10-19 12:35:52,858 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f40960c63bfa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-19 12:35:53,299 unpacking tar archive at: mozilla-central-f40960c63bfa/testing/mozharness/ 2016-10-19 12:35:53,397 skipping symlink on windows: configs/single_locale/linux32.py program finished with exit code 0 elapsedTime=1.070000 ========= master_lag: 3.87 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-10-19 12:35:57.557834) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 12:35:57.558123) ========= script_repo_revision: f40960c63bfac865d510ec9da42eeed74c384082 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 12:35:57.558487) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 12:35:57.558761) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 12:35:57.582565) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 22 mins, 55 secs) (at 2016-10-19 12:35:57.582824) ========= 'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'dromaeojs-e10s' '--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-e10s', '--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-074\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-074 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-074 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-074\AppData\Local LOGONSERVER=\\T-W864-IX-074 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-074 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-074 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-074 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 12:35:57 INFO - MultiFileLogger online at 20161019 12:35:57 in C:\slave\test 12:35:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 12:35:57 INFO - Dumping config to C:\slave\test\logs\localconfig.json. 12:35:58 INFO - {'append_to_log': False, 12:35:58 INFO - 'base_work_dir': 'C:\\slave\\test', 12:35:58 INFO - 'blob_upload_branch': 'Firefox', 12:35:58 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt', 12:35:58 INFO - 'branch': 'Firefox', 12:35:58 INFO - 'buildbot_json_path': 'buildprops.json', 12:35:58 INFO - 'config_files': ('talos/windows_config.py',), 12:35:58 INFO - 'default_actions': ('clobber', 12:35:58 INFO - 'read-buildbot-config', 12:35:58 INFO - 'download-and-extract', 12:35:58 INFO - 'populate-webroot', 12:35:58 INFO - 'create-virtualenv', 12:35:58 INFO - 'install', 12:35:58 INFO - 'run-tests'), 12:35:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:35:58 INFO - 'download_minidump_stackwalk': True, 12:35:58 INFO - 'download_symbols': 'ondemand', 12:35:58 INFO - 'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python', 12:35:58 INFO - 'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'), 12:35:58 INFO - 'hg': 'c:/mozilla-build/hg/hg', 12:35:58 INFO - 'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python', 12:35:58 INFO - 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'), 12:35:58 INFO - 'python': 'c:/mozilla-build/python27/python.exe', 12:35:58 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe', 12:35:58 INFO - 'C:/mozilla-build/tooltool.py'), 12:35:58 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe', 12:35:58 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 12:35:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:35:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:35:58 INFO - 'installer_path': 'installer.exe', 12:35:58 INFO - 'log_level': 'info', 12:35:58 INFO - 'log_name': 'talos', 12:35:58 INFO - 'log_to_console': True, 12:35:58 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe', 12:35:58 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe', 12:35:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest', 12:35:58 INFO - 'opt_config_files': (), 12:35:58 INFO - 'pip_index': False, 12:35:58 INFO - 'sps_profile': False, 12:35:58 INFO - 'sps_profile_interval': 0, 12:35:58 INFO - 'suite': 'dromaeojs-e10s', 12:35:58 INFO - 'system_bits': '32', 12:35:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:35:58 INFO - 'title': 'T-W864-IX-074', 12:35:58 INFO - 'use_talos_json': True, 12:35:58 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'), 12:35:58 INFO - 'virtualenv_path': 'C:\\slave\\test\\build/venv', 12:35:58 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll', 12:35:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:35:58 INFO - 'work_dir': 'build'} 12:35:58 INFO - [mozharness: 2016-10-19 19:35:58.043000Z] Running clobber step. 12:35:58 INFO - Running pre-action listener: _resource_record_pre_action 12:35:58 INFO - Running main action method: clobber 12:35:58 INFO - rmtree: C:\slave\test\build 12:35:58 INFO - Using _rmtree_windows ... 12:35:58 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1 12:37:27 INFO - Running post-action listener: _resource_record_post_action 12:37:27 INFO - [mozharness: 2016-10-19 19:37:27.830000Z] Finished clobber step (success) 12:37:27 INFO - [mozharness: 2016-10-19 19:37:27.830000Z] Running read-buildbot-config step. 12:37:27 INFO - Running pre-action listener: _resource_record_pre_action 12:37:27 INFO - Running main action method: read_buildbot_config 12:37:27 INFO - Using buildbot properties: 12:37:27 INFO - { 12:37:27 INFO - "project": "", 12:37:27 INFO - "product": "firefox", 12:37:27 INFO - "script_repo_revision": "production", 12:37:27 INFO - "builddir": "mozilla-central_win8_64_test-dromaeojs-e10s", 12:37:27 INFO - "repository": "", 12:37:27 INFO - "buildername": "Windows 8 64-bit mozilla-central pgo talos dromaeojs-e10s", 12:37:27 INFO - "buildid": "20161019103003", 12:37:27 INFO - "pgo_build": "True", 12:37:27 INFO - "basedir": "C:\\slave\\test", 12:37:27 INFO - "buildnumber": 138, 12:37:27 INFO - "slavename": "t-w864-ix-074", 12:37:27 INFO - "master": "http://buildbot-master111.bb.releng.scl3.mozilla.com:8201/", 12:37:27 INFO - "platform": "win8_64", 12:37:27 INFO - "scheduler": "tests-mozilla-central-win64-pgo-talos", 12:37:27 INFO - "branch": "mozilla-central", 12:37:27 INFO - "repo_path": "mozilla-central", 12:37:27 INFO - "revision": "f40960c63bfac865d510ec9da42eeed74c384082", 12:37:27 INFO - "stage_platform": "win64-pgo", 12:37:27 INFO - "builduid": "5e0bc85648714446977ffc5491062a3b", 12:37:27 INFO - "slavebuilddir": "test" 12:37:27 INFO - } 12:37:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/AXX8G2WyQVeUvEiWIOpCXQ/artifacts/public/build/firefox-52.0a1.en-US.win64.zip. 12:37:27 INFO - Running post-action listener: _resource_record_post_action 12:37:27 INFO - [mozharness: 2016-10-19 19:37:27.833000Z] Finished read-buildbot-config step (success) 12:37:27 INFO - [mozharness: 2016-10-19 19:37:27.834000Z] Running download-and-extract step. 12:37:27 INFO - Running pre-action listener: _resource_record_pre_action 12:37:27 INFO - Running main action method: download_and_extract 12:37:27 INFO - mkdir: C:\slave\test\build\tests 12:37: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')]} 12:37:27 INFO - trying https://queue.taskcluster.net/v1/task/AXX8G2WyQVeUvEiWIOpCXQ/artifacts/public/build/firefox-52.0a1.en-US.win64.test_packages.json 12:37:27 INFO - Downloading https://queue.taskcluster.net/v1/task/AXX8G2WyQVeUvEiWIOpCXQ/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 12:37:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AXX8G2WyQVeUvEiWIOpCXQ/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 12:37:28 INFO - Downloaded 1218 bytes. 12:37:28 INFO - Reading from file C:\slave\test\build\firefox-52.0a1.en-US.win64.test_packages.json 12:37:28 INFO - Using the following test package requirements: 12:37:28 INFO - {u'common': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 12:37:28 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 12:37:28 INFO - u'firefox-52.0a1.en-US.win64.cppunittest.tests.zip'], 12:37:28 INFO - u'gtest': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 12:37:28 INFO - u'jittest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 12:37:28 INFO - u'jsshell-win64.zip'], 12:37:28 INFO - u'mochitest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 12:37:28 INFO - u'firefox-52.0a1.en-US.win64.mochitest.tests.zip'], 12:37:28 INFO - u'mozbase': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 12:37:28 INFO - u'reftest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 12:37:28 INFO - u'firefox-52.0a1.en-US.win64.reftest.tests.zip'], 12:37:28 INFO - u'talos': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 12:37:28 INFO - u'firefox-52.0a1.en-US.win64.talos.tests.zip'], 12:37:28 INFO - u'web-platform': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 12:37:28 INFO - u'firefox-52.0a1.en-US.win64.web-platform.tests.zip'], 12:37:28 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 12:37:28 INFO - u'firefox-52.0a1.en-US.win64.xpcshell.tests.zip']} 12:37:28 INFO - Downloading packages: [u'firefox-52.0a1.en-US.win64.common.tests.zip'] for test suite category: common 12:37:28 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/AXX8G2WyQVeUvEiWIOpCXQ/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip 12:37:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AXX8G2WyQVeUvEiWIOpCXQ/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip'}, attempt #1 12:37:28 INFO - Fetch https://queue.taskcluster.net/v1/task/AXX8G2WyQVeUvEiWIOpCXQ/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip into memory 12:37:29 INFO - Http code: 200 12:37:29 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 12:37:29 INFO - x-amz-cf-id: yqMJo4yoVRH0CV3qT7gOR6dBv_xN75XC3sWcUgHHmat7hicrJ-Q9Gg== 12:37:29 INFO - x-amz-version-id: CSiTsYSC4tlRSqrnJaOR7XmglOteqQ75 12:37:29 INFO - Expected file size: 17543177 12:37:29 INFO - Obtained file size: 17543177 12:37:50 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 12:37:50 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/AXX8G2WyQVeUvEiWIOpCXQ/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip 12:37:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AXX8G2WyQVeUvEiWIOpCXQ/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip'}, attempt #1 12:37:50 INFO - Fetch https://queue.taskcluster.net/v1/task/AXX8G2WyQVeUvEiWIOpCXQ/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip into memory 12:37:51 INFO - Http code: 200 12:37:51 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 12:37:51 INFO - x-amz-cf-id: 379uJV3B_yCljJZe1ogWHjGF8cKs9g8KByJwzQudoXfHucmvBbu3ug== 12:37:51 INFO - x-amz-version-id: CSiTsYSC4tlRSqrnJaOR7XmglOteqQ75 12:37:51 INFO - Expected file size: 17543177 12:37:51 INFO - Obtained file size: 17543177 12:38:04 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/AXX8G2WyQVeUvEiWIOpCXQ/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip 12:38:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AXX8G2WyQVeUvEiWIOpCXQ/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip'}, attempt #1 12:38:04 INFO - Fetch https://queue.taskcluster.net/v1/task/AXX8G2WyQVeUvEiWIOpCXQ/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip into memory 12:38:04 INFO - Http code: 200 12:38:04 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 12:38:04 INFO - x-amz-cf-id: xKS9BuMBkCUq_a_4LT43pgIe7-hAFmu-FFguxzne4sISQH7VIhhPWQ== 12:38:04 INFO - x-amz-version-id: fmuV4zgcyeWYB5Uu.xG2Kr06R_uFr1Qe 12:38:04 INFO - Expected file size: 14409028 12:38:04 INFO - Obtained file size: 14409028 12:38: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')]} 12:38:05 INFO - trying https://queue.taskcluster.net/v1/task/AXX8G2WyQVeUvEiWIOpCXQ/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 12:38:05 INFO - Downloading https://queue.taskcluster.net/v1/task/AXX8G2WyQVeUvEiWIOpCXQ/artifacts/public/build/firefox-52.0a1.en-US.win64.zip to C:\slave\test\build\firefox-52.0a1.en-US.win64.zip 12:38:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AXX8G2WyQVeUvEiWIOpCXQ/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 12:38:07 INFO - Downloaded 57280639 bytes. 12:38:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AXX8G2WyQVeUvEiWIOpCXQ/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 12:38:07 INFO - mkdir: C:\slave\test\properties 12:38:07 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url 12:38:07 INFO - Writing to file C:\slave\test\properties\build_url 12:38:07 INFO - Contents: 12:38:07 INFO - build_url:https://queue.taskcluster.net/v1/task/AXX8G2WyQVeUvEiWIOpCXQ/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 12:38:07 INFO - Running post-action listener: _resource_record_post_action 12:38:07 INFO - Running post-action listener: set_extra_try_arguments 12:38:07 INFO - [mozharness: 2016-10-19 19:38:07.992000Z] Finished download-and-extract step (success) 12:38:07 INFO - [mozharness: 2016-10-19 19:38:07.992000Z] Running populate-webroot step. 12:38:07 INFO - Running pre-action listener: _resource_record_pre_action 12:38:07 INFO - Running main action method: populate_webroot 12:38:07 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']}, 12:38:07 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']}, 12:38:07 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome', 12:38:07 INFO - u'--tppagecycles', 12:38:07 INFO - u'7'], 12:38:07 INFO - u'tests': [u'tsvgm']}}, 12:38:07 INFO - u'suites': {u'chromez': {u'talos_options': [u'--disable-e10s'], 12:38:07 INFO - u'tests': [u'tresize', u'tcanvasmark']}, 12:38:07 INFO - u'chromez-e10s': {u'tests': [u'tresize', u'tcanvasmark']}, 12:38:07 INFO - u'dromaeojs': {u'talos_options': [u'--disable-e10s'], 12:38:07 INFO - u'tests': [u'dromaeo_css', u'kraken']}, 12:38:07 INFO - u'dromaeojs-e10s': {u'tests': [u'dromaeo_css', u'kraken']}, 12:38:07 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:38:07 INFO - u'talos_options': [u'--disable-e10s'], 12:38:07 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 12:38:07 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:38:07 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 12:38:07 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:38:07 INFO - u'talos_options': [u'--disable-e10s'], 12:38:07 INFO - u'tests': [u'damp', u'tps']}, 12:38:07 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:38:07 INFO - u'tests': [u'damp', u'tps']}, 12:38:07 INFO - u'g3': {u'talos_options': [u'--disable-e10s'], 12:38:07 INFO - u'tests': [u'dromaeo_dom']}, 12:38:07 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']}, 12:38:07 INFO - u'g4': {u'talos_options': [u'--disable-e10s'], 12:38:08 INFO - u'tests': [u'basic_compositor_video']}, 12:38:08 INFO - u'g4-e10s': {u'tests': [u'basic_compositor_video']}, 12:38:08 INFO - u'other': {u'talos_options': [u'--disable-e10s'], 12:38:08 INFO - u'tests': [u'a11yr', 12:38:08 INFO - u'ts_paint', 12:38:08 INFO - u'tpaint', 12:38:08 INFO - u'sessionrestore', 12:38:08 INFO - u'sessionrestore_no_auto_restore', 12:38:08 INFO - u'tabpaint']}, 12:38:08 INFO - u'other-e10s': {u'tests': [u'a11yr', 12:38:08 INFO - u'ts_paint', 12:38:08 INFO - u'tpaint', 12:38:08 INFO - u'sessionrestore', 12:38:08 INFO - u'sessionrestore_no_auto_restore', 12:38:08 INFO - u'tabpaint']}, 12:38:08 INFO - u'other-e10s_l64': {u'tests': [u'a11yr', 12:38:08 INFO - u'ts_paint', 12:38:08 INFO - u'tpaint', 12:38:08 INFO - u'sessionrestore', 12:38:08 INFO - u'sessionrestore_no_auto_restore', 12:38:08 INFO - u'tabpaint']}, 12:38:08 INFO - u'other-e10s_nol64': {u'tests': [u'a11yr', 12:38:08 INFO - u'ts_paint', 12:38:08 INFO - u'tpaint', 12:38:08 INFO - u'sessionrestore', 12:38:08 INFO - u'sessionrestore_no_auto_restore', 12:38:08 INFO - u'tabpaint']}, 12:38:08 INFO - u'other_l64': {u'talos_options': [u'--disable-e10s'], 12:38:08 INFO - u'tests': [u'a11yr', 12:38:08 INFO - u'ts_paint', 12:38:08 INFO - u'tpaint', 12:38:08 INFO - u'sessionrestore', 12:38:08 INFO - u'sessionrestore_no_auto_restore', 12:38:08 INFO - u'tabpaint']}, 12:38:08 INFO - u'other_nol64': {u'talos_options': [u'--disable-e10s'], 12:38:08 INFO - u'tests': [u'a11yr', 12:38:08 INFO - u'ts_paint', 12:38:08 INFO - u'tpaint', 12:38:08 INFO - u'sessionrestore', 12:38:08 INFO - u'sessionrestore_no_auto_restore', 12:38:08 INFO - u'tabpaint']}, 12:38:08 INFO - u'svgr': {u'talos_options': [u'--disable-e10s'], 12:38:08 INFO - u'tests': [u'tsvgx', 12:38:08 INFO - u'tsvgr_opacity', 12:38:08 INFO - u'tart', 12:38:08 INFO - u'tscrollx', 12:38:08 INFO - u'cart']}, 12:38:08 INFO - u'svgr-e10s': {u'tests': [u'tsvgx', 12:38:08 INFO - u'tsvgr_opacity', 12:38:08 INFO - u'tart', 12:38:08 INFO - u'tscrollx', 12:38:08 INFO - u'cart']}, 12:38:08 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:38:08 INFO - u'talos_options': [u'--disable-e10s'], 12:38:08 INFO - u'tests': [u'tp5o']}, 12:38:08 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:38:08 INFO - u'tests': [u'tp5o']}, 12:38:08 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:38:08 INFO - u'talos_options': [u'--disable-e10s', 12:38:08 INFO - u'--xperf_path', 12:38:08 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:38:08 INFO - u'tests': [u'tp5n']}, 12:38:08 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:38:08 INFO - u'talos_options': [u'--xperf_path', 12:38:08 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:38:08 INFO - u'tests': [u'tp5n']}}, 12:38:08 INFO - u'talos.zip': {u'path': u'', 12:38:08 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:38:08 INFO - Running post-action listener: _resource_record_post_action 12:38:08 INFO - [mozharness: 2016-10-19 19:38:08.026000Z] Finished populate-webroot step (success) 12:38:08 INFO - [mozharness: 2016-10-19 19:38:08.026000Z] Running create-virtualenv step. 12:38:08 INFO - Running pre-action listener: _resource_record_pre_action 12:38:08 INFO - Running main action method: create_virtualenv 12:38:08 INFO - Creating virtualenv C:\slave\test\build/venv 12:38:08 INFO - mkdir: C:\slave\test\build\venv\Scripts 12:38:08 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll 12:38:08 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'! 12:38:08 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 12:38:08 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build/venv 12:38:17 INFO - New python executable in C:\slave\test\build/venv\Scripts\python.exe 12:38:21 INFO - Installing distribute......................................................................................................................................................................................done. 12:38:22 INFO - Return code: 0 12:38:22 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', '--version'] 12:38:22 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip --version 12:38:22 INFO - Reading from file tmpfile_stdout 12:38:22 INFO - Output received: 12:38:22 INFO - pip 0.8.2 from c:\slave\test\build\venv\lib\site-packages\pip-0.8.2-py2.7.egg (python 2.7) 12:38:22 INFO - Using _rmtree_windows ... 12:38:22 INFO - Using _rmtree_windows ... 12:38:22 INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv 12:38:22 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')]} 12:38:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:38:22 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')]} 12:38:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:38:22 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 0x022BC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0233DE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x028046B0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02318E90>, '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 0x01CAA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02844520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-074', 'USERDOMAIN': 'T-W864-IX-074', '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-074', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-074\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-074', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-074', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-074', '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-074\\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 12:38:22 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 12:38:22 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 12:38:22 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 12:38:22 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-074\\AppData\\Roaming', 12:38:22 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 12:38:22 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 12:38:22 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 12:38:22 INFO - 'COMPUTERNAME': 'T-W864-IX-074', 12:38:22 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 12:38:22 INFO - 'DCLOCATION': 'SCL3', 12:38:22 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 12:38:22 INFO - 'FP_NO_HOST_CHECK': 'NO', 12:38:22 INFO - 'HOMEDRIVE': 'C:', 12:38:22 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-074', 12:38:22 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 12:38:22 INFO - 'KTS_VERSION': '1.19c', 12:38:22 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-074\\AppData\\Local', 12:38:22 INFO - 'LOGONSERVER': '\\\\T-W864-IX-074', 12:38:22 INFO - 'MONDIR': 'C:\\Monitor_config\\', 12:38:22 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 12:38:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:38:22 INFO - 'MOZ_NO_REMOTE': '1', 12:38:22 INFO - 'NO_EM_RESTART': '1', 12:38:22 INFO - 'NUMBER_OF_PROCESSORS': '8', 12:38:22 INFO - 'OS': 'Windows_NT', 12:38:22 INFO - 'OURDRIVE': 'C:', 12:38:22 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;', 12:38:22 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 12:38:22 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 12:38:22 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 12:38:22 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 12:38:22 INFO - 'PROCESSOR_LEVEL': '6', 12:38:22 INFO - 'PROCESSOR_REVISION': '1e05', 12:38:22 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 12:38:22 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 12:38:22 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 12:38:22 INFO - 'PROGRAMW6432': 'C:\\Program Files', 12:38:22 INFO - 'PROMPT': '$P$G', 12:38:22 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 12:38:22 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 12:38:22 INFO - 'PUBLIC': 'C:\\Users\\Public', 12:38:22 INFO - 'PWD': 'C:\\slave\\test', 12:38:22 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 12:38:22 INFO - 'SLAVEDIR': 'C:\\slave\\', 12:38:22 INFO - 'SYSTEMDRIVE': 'C:', 12:38:22 INFO - 'SYSTEMROOT': 'C:\\windows', 12:38:22 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 12:38:22 INFO - 'TEST1': 'testie', 12:38:22 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 12:38:22 INFO - 'USERDOMAIN': 'T-W864-IX-074', 12:38:22 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-074', 12:38:22 INFO - 'USERNAME': 'cltbld', 12:38:22 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-074', 12:38:22 INFO - 'WINDIR': 'C:\\windows', 12:38:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 12:38:23 INFO - Ignoring indexes: http://pypi.python.org/simple/ 12:38:23 INFO - Downloading/unpacking pip>=1.5 12:38:27 INFO - Running setup.py egg_info for package pip 12:38:27 INFO - warning: no files found matching 'pip\cacert.pem' 12:38:27 INFO - warning: no files found matching '*.html' under directory 'docs' 12:38:27 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 12:38:27 INFO - no previously-included directories found matching 'docs\_build\_sources' 12:38:27 INFO - Installing collected packages: pip 12:38:27 INFO - Found existing installation: pip 0.8.2 12:38:27 INFO - Uninstalling pip: 12:38:27 INFO - Successfully uninstalled pip 12:38:27 INFO - Running setup.py install for pip 12:38:27 INFO - warning: no files found matching 'pip\cacert.pem' 12:38:27 INFO - warning: no files found matching '*.html' under directory 'docs' 12:38:27 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 12:38:27 INFO - no previously-included directories found matching 'docs\_build\_sources' 12:38:27 INFO - Installing pip-script.py script to C:\slave\test\build\venv\Scripts 12:38:27 INFO - Installing pip.exe script to C:\slave\test\build\venv\Scripts 12:38:27 INFO - Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts 12:38:27 INFO - Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts 12:38:27 INFO - Installing pip2-script.py script to C:\slave\test\build\venv\Scripts 12:38:27 INFO - Installing pip2.exe script to C:\slave\test\build\venv\Scripts 12:38:27 INFO - Successfully installed pip 12:38:27 INFO - Cleaning up... 12:38:27 INFO - Return code: 0 12:38:27 INFO - Installing psutil>=3.1.1 into virtualenv C:\slave\test\build/venv 12:38: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')]} 12:38:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:38: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')]} 12:38:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:38: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', '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 0x022BC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0233DE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x028046B0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02318E90>, '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 0x01CAA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02844520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-074', 'USERDOMAIN': 'T-W864-IX-074', '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-074', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-074\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-074', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-074', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-074', '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-074\\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 12:38: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', 'psutil>=3.1.1'] in C:\slave\test\build 12:38: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 psutil>=3.1.1 12:38:27 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 12:38:27 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-074\\AppData\\Roaming', 12:38:27 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 12:38:27 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 12:38:27 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 12:38:27 INFO - 'COMPUTERNAME': 'T-W864-IX-074', 12:38:27 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 12:38:27 INFO - 'DCLOCATION': 'SCL3', 12:38:27 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 12:38:27 INFO - 'FP_NO_HOST_CHECK': 'NO', 12:38:27 INFO - 'HOMEDRIVE': 'C:', 12:38:27 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-074', 12:38:27 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 12:38:27 INFO - 'KTS_VERSION': '1.19c', 12:38:27 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-074\\AppData\\Local', 12:38:27 INFO - 'LOGONSERVER': '\\\\T-W864-IX-074', 12:38:27 INFO - 'MONDIR': 'C:\\Monitor_config\\', 12:38:27 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 12:38:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:38:27 INFO - 'MOZ_NO_REMOTE': '1', 12:38:27 INFO - 'NO_EM_RESTART': '1', 12:38:27 INFO - 'NUMBER_OF_PROCESSORS': '8', 12:38:27 INFO - 'OS': 'Windows_NT', 12:38:27 INFO - 'OURDRIVE': 'C:', 12:38: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;', 12:38:27 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 12:38:27 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 12:38:27 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 12:38:27 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 12:38:27 INFO - 'PROCESSOR_LEVEL': '6', 12:38:27 INFO - 'PROCESSOR_REVISION': '1e05', 12:38:27 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 12:38:27 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 12:38:27 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 12:38:27 INFO - 'PROGRAMW6432': 'C:\\Program Files', 12:38:27 INFO - 'PROMPT': '$P$G', 12:38:27 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 12:38:27 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 12:38:27 INFO - 'PUBLIC': 'C:\\Users\\Public', 12:38:27 INFO - 'PWD': 'C:\\slave\\test', 12:38:27 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 12:38:27 INFO - 'SLAVEDIR': 'C:\\slave\\', 12:38:27 INFO - 'SYSTEMDRIVE': 'C:', 12:38:27 INFO - 'SYSTEMROOT': 'C:\\windows', 12:38:27 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 12:38:27 INFO - 'TEST1': 'testie', 12:38:27 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 12:38:27 INFO - 'USERDOMAIN': 'T-W864-IX-074', 12:38:27 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-074', 12:38:27 INFO - 'USERNAME': 'cltbld', 12:38:27 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-074', 12:38:27 INFO - 'WINDIR': 'C:\\windows', 12:38:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 12:38:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:38:31 INFO - Downloading/unpacking psutil>=3.1.1 12:38:31 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 12:38:31 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 12:38:32 INFO - Installing collected packages: psutil 12:38:32 INFO - Successfully installed psutil 12:38:32 INFO - Cleaning up... 12:38:33 INFO - Return code: 0 12:38:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv C:\slave\test\build/venv 12:38:33 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')]} 12:38:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:38:33 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')]} 12:38:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:38:33 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 0x022BC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0233DE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x028046B0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02318E90>, '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 0x01CAA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02844520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-074', 'USERDOMAIN': 'T-W864-IX-074', '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-074', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-074\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-074', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-074', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-074', '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-074\\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 12:38:33 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 12:38:33 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 12:38:33 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 12:38:33 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-074\\AppData\\Roaming', 12:38:33 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 12:38:33 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 12:38:33 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 12:38:33 INFO - 'COMPUTERNAME': 'T-W864-IX-074', 12:38:33 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 12:38:33 INFO - 'DCLOCATION': 'SCL3', 12:38:33 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 12:38:33 INFO - 'FP_NO_HOST_CHECK': 'NO', 12:38:33 INFO - 'HOMEDRIVE': 'C:', 12:38:33 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-074', 12:38:33 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 12:38:33 INFO - 'KTS_VERSION': '1.19c', 12:38:33 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-074\\AppData\\Local', 12:38:33 INFO - 'LOGONSERVER': '\\\\T-W864-IX-074', 12:38:33 INFO - 'MONDIR': 'C:\\Monitor_config\\', 12:38:33 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 12:38:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:38:33 INFO - 'MOZ_NO_REMOTE': '1', 12:38:33 INFO - 'NO_EM_RESTART': '1', 12:38:33 INFO - 'NUMBER_OF_PROCESSORS': '8', 12:38:33 INFO - 'OS': 'Windows_NT', 12:38:33 INFO - 'OURDRIVE': 'C:', 12:38:33 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;', 12:38:33 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 12:38:33 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 12:38:33 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 12:38:33 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 12:38:33 INFO - 'PROCESSOR_LEVEL': '6', 12:38:33 INFO - 'PROCESSOR_REVISION': '1e05', 12:38:33 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 12:38:33 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 12:38:33 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 12:38:33 INFO - 'PROGRAMW6432': 'C:\\Program Files', 12:38:33 INFO - 'PROMPT': '$P$G', 12:38:33 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 12:38:33 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 12:38:33 INFO - 'PUBLIC': 'C:\\Users\\Public', 12:38:33 INFO - 'PWD': 'C:\\slave\\test', 12:38:33 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 12:38:33 INFO - 'SLAVEDIR': 'C:\\slave\\', 12:38:33 INFO - 'SYSTEMDRIVE': 'C:', 12:38:33 INFO - 'SYSTEMROOT': 'C:\\windows', 12:38:33 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 12:38:33 INFO - 'TEST1': 'testie', 12:38:33 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 12:38:33 INFO - 'USERDOMAIN': 'T-W864-IX-074', 12:38:33 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-074', 12:38:33 INFO - 'USERNAME': 'cltbld', 12:38:33 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-074', 12:38:33 INFO - 'WINDIR': 'C:\\windows', 12:38:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 12:38:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:38:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:38:33 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 12:38:33 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 12:38:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:38:34 INFO - Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor 12:38:34 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) 12:38:34 INFO - Installing collected packages: mozsystemmonitor 12:38:34 INFO - Running setup.py install for mozsystemmonitor 12:38:34 INFO - Successfully installed mozsystemmonitor 12:38:34 INFO - Cleaning up... 12:38:35 INFO - Return code: 0 12:38:35 INFO - Installing jsonschema==2.5.1 into virtualenv C:\slave\test\build/venv 12:38:35 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')]} 12:38:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:38:35 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')]} 12:38:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:38:35 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 0x022BC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0233DE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x028046B0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02318E90>, '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 0x01CAA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02844520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-074', 'USERDOMAIN': 'T-W864-IX-074', '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-074', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-074\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-074', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-074', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-074', '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-074\\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 12:38:35 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 12:38:35 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 12:38:35 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 12:38:35 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-074\\AppData\\Roaming', 12:38:35 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 12:38:35 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 12:38:35 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 12:38:35 INFO - 'COMPUTERNAME': 'T-W864-IX-074', 12:38:35 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 12:38:35 INFO - 'DCLOCATION': 'SCL3', 12:38:35 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 12:38:35 INFO - 'FP_NO_HOST_CHECK': 'NO', 12:38:35 INFO - 'HOMEDRIVE': 'C:', 12:38:35 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-074', 12:38:35 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 12:38:35 INFO - 'KTS_VERSION': '1.19c', 12:38:35 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-074\\AppData\\Local', 12:38:35 INFO - 'LOGONSERVER': '\\\\T-W864-IX-074', 12:38:35 INFO - 'MONDIR': 'C:\\Monitor_config\\', 12:38:35 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 12:38:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:38:35 INFO - 'MOZ_NO_REMOTE': '1', 12:38:35 INFO - 'NO_EM_RESTART': '1', 12:38:35 INFO - 'NUMBER_OF_PROCESSORS': '8', 12:38:35 INFO - 'OS': 'Windows_NT', 12:38:35 INFO - 'OURDRIVE': 'C:', 12:38:35 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;', 12:38:35 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 12:38:35 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 12:38:35 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 12:38:35 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 12:38:35 INFO - 'PROCESSOR_LEVEL': '6', 12:38:35 INFO - 'PROCESSOR_REVISION': '1e05', 12:38:35 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 12:38:35 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 12:38:35 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 12:38:35 INFO - 'PROGRAMW6432': 'C:\\Program Files', 12:38:35 INFO - 'PROMPT': '$P$G', 12:38:35 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 12:38:35 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 12:38:35 INFO - 'PUBLIC': 'C:\\Users\\Public', 12:38:35 INFO - 'PWD': 'C:\\slave\\test', 12:38:35 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 12:38:35 INFO - 'SLAVEDIR': 'C:\\slave\\', 12:38:35 INFO - 'SYSTEMDRIVE': 'C:', 12:38:35 INFO - 'SYSTEMROOT': 'C:\\windows', 12:38:35 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 12:38:35 INFO - 'TEST1': 'testie', 12:38:35 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 12:38:35 INFO - 'USERDOMAIN': 'T-W864-IX-074', 12:38:35 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-074', 12:38:35 INFO - 'USERNAME': 'cltbld', 12:38:35 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-074', 12:38:35 INFO - 'WINDIR': 'C:\\windows', 12:38:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 12:38:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:38:35 INFO - Downloading/unpacking jsonschema==2.5.1 12:38:35 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 12:38:35 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 12:38:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:38:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:38:36 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 12:38:36 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 12:38:36 INFO - Downloading functools32-3.2.3-2.tar.gz 12:38:36 INFO - Running setup.py (path:C:\slave\test\build\venv\build\functools32\setup.py) egg_info for package functools32 12:38:36 INFO - warning: no files found matching '*.txt' 12:38:36 INFO - no previously-included directories found matching 'build' 12:38:36 INFO - no previously-included directories found matching 'dist' 12:38:36 INFO - no previously-included directories found matching '.git*' 12:38:36 INFO - Installing collected packages: jsonschema, functools32 12:38:37 INFO - Running setup.py install for functools32 12:38:37 INFO - warning: no files found matching '*.txt' 12:38:37 INFO - no previously-included directories found matching 'build' 12:38:37 INFO - no previously-included directories found matching 'dist' 12:38:37 INFO - no previously-included directories found matching '.git*' 12:38:37 INFO - Successfully installed jsonschema functools32 12:38:37 INFO - Cleaning up... 12:38:37 INFO - Return code: 0 12:38:37 INFO - Installing functools32==3.2.3-2 into virtualenv C:\slave\test\build/venv 12:38: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')]} 12:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:38: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')]} 12:38:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:38:37 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 0x022BC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0233DE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x028046B0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02318E90>, '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 0x01CAA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02844520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-074', 'USERDOMAIN': 'T-W864-IX-074', '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-074', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-074\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-074', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-074', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-074', '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-074\\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 12:38:37 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 12:38:37 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 12:38:37 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 12:38:37 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-074\\AppData\\Roaming', 12:38:37 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 12:38:37 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 12:38:37 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 12:38:37 INFO - 'COMPUTERNAME': 'T-W864-IX-074', 12:38:37 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 12:38:37 INFO - 'DCLOCATION': 'SCL3', 12:38:37 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 12:38:37 INFO - 'FP_NO_HOST_CHECK': 'NO', 12:38:37 INFO - 'HOMEDRIVE': 'C:', 12:38:37 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-074', 12:38:37 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 12:38:37 INFO - 'KTS_VERSION': '1.19c', 12:38:37 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-074\\AppData\\Local', 12:38:37 INFO - 'LOGONSERVER': '\\\\T-W864-IX-074', 12:38:37 INFO - 'MONDIR': 'C:\\Monitor_config\\', 12:38:37 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 12:38:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:38:37 INFO - 'MOZ_NO_REMOTE': '1', 12:38:37 INFO - 'NO_EM_RESTART': '1', 12:38:37 INFO - 'NUMBER_OF_PROCESSORS': '8', 12:38:37 INFO - 'OS': 'Windows_NT', 12:38:37 INFO - 'OURDRIVE': 'C:', 12:38:37 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;', 12:38:37 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 12:38:37 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 12:38:37 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 12:38:37 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 12:38:37 INFO - 'PROCESSOR_LEVEL': '6', 12:38:37 INFO - 'PROCESSOR_REVISION': '1e05', 12:38:37 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 12:38:37 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 12:38:37 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 12:38:37 INFO - 'PROGRAMW6432': 'C:\\Program Files', 12:38:37 INFO - 'PROMPT': '$P$G', 12:38:37 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 12:38:37 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 12:38:37 INFO - 'PUBLIC': 'C:\\Users\\Public', 12:38:37 INFO - 'PWD': 'C:\\slave\\test', 12:38:37 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 12:38:37 INFO - 'SLAVEDIR': 'C:\\slave\\', 12:38:37 INFO - 'SYSTEMDRIVE': 'C:', 12:38:37 INFO - 'SYSTEMROOT': 'C:\\windows', 12:38:37 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 12:38:37 INFO - 'TEST1': 'testie', 12:38:37 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 12:38:37 INFO - 'USERDOMAIN': 'T-W864-IX-074', 12:38:37 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-074', 12:38:37 INFO - 'USERNAME': 'cltbld', 12:38:37 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-074', 12:38:37 INFO - 'WINDIR': 'C:\\windows', 12:38:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 12:38:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:38:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in c:\slave\test\build\venv\lib\site-packages 12:38:37 INFO - Cleaning up... 12:38:37 INFO - Return code: 0 12:38:37 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv 12:38: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')]} 12:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:38: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')]} 12:38:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:38:37 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 0x022BC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0233DE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x028046B0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02318E90>, '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 0x01CAA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02844520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-074', 'USERDOMAIN': 'T-W864-IX-074', '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-074', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-074\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-074', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-074', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-074', '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-074\\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 12:38:38 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 12:38:38 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 12:38:38 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 12:38:38 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-074\\AppData\\Roaming', 12:38:38 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 12:38:38 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 12:38:38 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 12:38:38 INFO - 'COMPUTERNAME': 'T-W864-IX-074', 12:38:38 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 12:38:38 INFO - 'DCLOCATION': 'SCL3', 12:38:38 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 12:38:38 INFO - 'FP_NO_HOST_CHECK': 'NO', 12:38:38 INFO - 'HOMEDRIVE': 'C:', 12:38:38 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-074', 12:38:38 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 12:38:38 INFO - 'KTS_VERSION': '1.19c', 12:38:38 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-074\\AppData\\Local', 12:38:38 INFO - 'LOGONSERVER': '\\\\T-W864-IX-074', 12:38:38 INFO - 'MONDIR': 'C:\\Monitor_config\\', 12:38:38 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 12:38:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:38:38 INFO - 'MOZ_NO_REMOTE': '1', 12:38:38 INFO - 'NO_EM_RESTART': '1', 12:38:38 INFO - 'NUMBER_OF_PROCESSORS': '8', 12:38:38 INFO - 'OS': 'Windows_NT', 12:38:38 INFO - 'OURDRIVE': 'C:', 12:38:38 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;', 12:38:38 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 12:38:38 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 12:38:38 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 12:38:38 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 12:38:38 INFO - 'PROCESSOR_LEVEL': '6', 12:38:38 INFO - 'PROCESSOR_REVISION': '1e05', 12:38:38 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 12:38:38 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 12:38:38 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 12:38:38 INFO - 'PROGRAMW6432': 'C:\\Program Files', 12:38:38 INFO - 'PROMPT': '$P$G', 12:38:38 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 12:38:38 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 12:38:38 INFO - 'PUBLIC': 'C:\\Users\\Public', 12:38:38 INFO - 'PWD': 'C:\\slave\\test', 12:38:38 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 12:38:38 INFO - 'SLAVEDIR': 'C:\\slave\\', 12:38:38 INFO - 'SYSTEMDRIVE': 'C:', 12:38:38 INFO - 'SYSTEMROOT': 'C:\\windows', 12:38:38 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 12:38:38 INFO - 'TEST1': 'testie', 12:38:38 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 12:38:38 INFO - 'USERDOMAIN': 'T-W864-IX-074', 12:38:38 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-074', 12:38:38 INFO - 'USERNAME': 'cltbld', 12:38:38 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-074', 12:38:38 INFO - 'WINDIR': 'C:\\windows', 12:38:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 12:38:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:38:38 INFO - Downloading/unpacking blobuploader==1.2.4 12:38:38 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 12:38:38 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 12:38:39 INFO - Downloading blobuploader-1.2.4.tar.gz 12:38:39 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader 12:38:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:38:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:38:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:38:39 INFO - Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests 12:38:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:38:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:38:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:38:40 INFO - Downloading docopt-0.6.1.tar.gz 12:38:40 INFO - Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt 12:38:40 INFO - Installing collected packages: blobuploader, requests, docopt 12:38:40 INFO - Running setup.py install for blobuploader 12:38:40 INFO - Running setup.py install for requests 12:38:40 INFO - Running setup.py install for docopt 12:38:40 INFO - Successfully installed blobuploader requests docopt 12:38:40 INFO - Cleaning up... 12:38:42 INFO - Return code: 0 12:38:42 INFO - Installing None into virtualenv C:\slave\test\build/venv 12:38:42 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')]} 12:38:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:38:42 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')]} 12:38:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:38:42 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 0x022BC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0233DE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x028046B0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02318E90>, '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 0x01CAA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02844520>, '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-074', 'USERDOMAIN': 'T-W864-IX-074', '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-074', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-074\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-074', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-074', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-074', '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-074\\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 12:38:42 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 12:38:42 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 12:38:42 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 12:38:42 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-074\\AppData\\Roaming', 12:38:42 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 12:38:42 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 12:38:42 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 12:38:42 INFO - 'COMPUTERNAME': 'T-W864-IX-074', 12:38:42 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 12:38:42 INFO - 'DCLOCATION': 'SCL3', 12:38:42 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 12:38:42 INFO - 'FP_NO_HOST_CHECK': 'NO', 12:38:42 INFO - 'HOMEDRIVE': 'C:', 12:38:42 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-074', 12:38:42 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 12:38:42 INFO - 'KTS_VERSION': '1.19c', 12:38:42 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-074\\AppData\\Local', 12:38:42 INFO - 'LOGONSERVER': '\\\\T-W864-IX-074', 12:38:42 INFO - 'MONDIR': 'C:\\Monitor_config\\', 12:38:42 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 12:38:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:38:42 INFO - 'MOZ_NO_REMOTE': '1', 12:38:42 INFO - 'NO_EM_RESTART': '1', 12:38:42 INFO - 'NUMBER_OF_PROCESSORS': '8', 12:38:42 INFO - 'OS': 'Windows_NT', 12:38:42 INFO - 'OURDRIVE': 'C:', 12:38:42 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;', 12:38:42 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 12:38:42 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 12:38:42 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 12:38:42 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 12:38:42 INFO - 'PROCESSOR_LEVEL': '6', 12:38:42 INFO - 'PROCESSOR_REVISION': '1e05', 12:38:42 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 12:38:42 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 12:38:42 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 12:38:42 INFO - 'PROGRAMW6432': 'C:\\Program Files', 12:38:42 INFO - 'PROMPT': '$P$G', 12:38:42 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 12:38:42 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 12:38:42 INFO - 'PUBLIC': 'C:\\Users\\Public', 12:38:42 INFO - 'PWD': 'C:\\slave\\test', 12:38:42 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 12:38:42 INFO - 'SLAVEDIR': 'C:\\slave\\', 12:38:42 INFO - 'SYSTEMDRIVE': 'C:', 12:38:42 INFO - 'SYSTEMROOT': 'C:\\windows', 12:38:42 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 12:38:42 INFO - 'TEST1': 'testie', 12:38:42 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 12:38:42 INFO - 'USERDOMAIN': 'T-W864-IX-074', 12:38:42 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-074', 12:38:42 INFO - 'USERNAME': 'cltbld', 12:38:42 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-074', 12:38:42 INFO - 'WINDIR': 'C:\\windows', 12:38:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 12:38:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:38:42 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 12:38:42 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-js7hxt-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 12:38:42 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 12:38:42 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-3_evw4-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 12:38:43 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 12:38:43 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-tvyei7-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 12:38:43 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 12:38:43 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ewh5ri-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 12:38:43 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 12:38:43 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jndfea-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 12:38:43 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 12:38:43 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-35ztuf-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 12:38:43 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 12:38:43 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-5o3pbp-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 12:38:43 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 12:38:43 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-gzshqz-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 12:38:43 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 12:38:43 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-f_2wum-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 12:38:43 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 12:38:43 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-pfwkwm-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 12:38:43 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 12:38:43 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-lgwpcw-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 12:38:44 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 12:38:44 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-p4j5rg-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 12:38:44 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 12:38:44 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-zg6ayg-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 12:38:44 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 12:38:44 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-6vsqmu-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 12:38:44 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 12:38:44 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-tblpz4-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 12:38:44 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 12:38:44 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-k8hxfy-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 12:38:44 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 12:38:44 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qao7sq-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 12:38:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:38:44 INFO - Running setup.py install for manifestparser 12:38:44 INFO - Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts 12:38:44 INFO - Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts 12:38:45 INFO - Running setup.py install for mozcrash 12:38:45 INFO - Running setup.py install for mozdebug 12:38:45 INFO - Running setup.py install for mozdevice 12:38:46 INFO - Installing sutini-script.py script to C:\slave\test\build\venv\Scripts 12:38:46 INFO - Installing sutini.exe script to C:\slave\test\build\venv\Scripts 12:38:46 INFO - Installing dm-script.py script to C:\slave\test\build\venv\Scripts 12:38:46 INFO - Installing dm.exe script to C:\slave\test\build\venv\Scripts 12:38:46 INFO - Running setup.py install for mozfile 12:38:46 INFO - Running setup.py install for mozhttpd 12:38:47 INFO - Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts 12:38:47 INFO - Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts 12:38:47 INFO - Running setup.py install for mozinfo 12:38:47 INFO - Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts 12:38:47 INFO - Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts 12:38:47 INFO - Running setup.py install for mozInstall 12:38:48 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts 12:38:48 INFO - Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts 12:38:48 INFO - Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts 12:38:48 INFO - Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts 12:38:48 INFO - Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts 12:38:48 INFO - Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts 12:38:48 INFO - Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts 12:38:48 INFO - Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts 12:38:48 INFO - Running setup.py install for mozleak 12:38:48 INFO - Running setup.py install for mozlog 12:38:48 INFO - Installing structlog-script.py script to C:\slave\test\build\venv\Scripts 12:38:48 INFO - Installing structlog.exe script to C:\slave\test\build\venv\Scripts 12:38:49 INFO - Running setup.py install for moznetwork 12:38:49 INFO - Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts 12:38:49 INFO - Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts 12:38:49 INFO - Running setup.py install for mozprocess 12:38:50 INFO - Running setup.py install for mozprofile 12:38:50 INFO - Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts 12:38:50 INFO - Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts 12:38:50 INFO - Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts 12:38:50 INFO - Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts 12:38:50 INFO - Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts 12:38:50 INFO - Installing view-profile.exe script to C:\slave\test\build\venv\Scripts 12:38:50 INFO - Running setup.py install for mozrunner 12:38:51 INFO - Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts 12:38:51 INFO - Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts 12:38:51 INFO - Running setup.py install for mozscreenshot 12:38:51 INFO - Running setup.py install for moztest 12:38:52 INFO - Running setup.py install for mozversion 12:38:52 INFO - Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts 12:38:52 INFO - Installing mozversion.exe script to C:\slave\test\build\venv\Scripts 12:38:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:38:52 INFO - Cleaning up... 12:38:52 INFO - Return code: 0 12:38:52 INFO - Installing None into virtualenv C:\slave\test\build/venv 12:38: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')]} 12:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:38: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')]} 12:38:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:38:52 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 0x022BC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0233DE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x028046B0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02318E90>, '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 0x01CAA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02844520>, '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-074', 'USERDOMAIN': 'T-W864-IX-074', '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-074', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-074\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-074', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-074', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-074', '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-074\\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 12:38:52 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 12:38:52 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 12:38:52 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 12:38:52 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-074\\AppData\\Roaming', 12:38:52 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 12:38:52 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 12:38:52 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 12:38:52 INFO - 'COMPUTERNAME': 'T-W864-IX-074', 12:38:52 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 12:38:52 INFO - 'DCLOCATION': 'SCL3', 12:38:52 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 12:38:52 INFO - 'FP_NO_HOST_CHECK': 'NO', 12:38:52 INFO - 'HOMEDRIVE': 'C:', 12:38:52 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-074', 12:38:52 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 12:38:52 INFO - 'KTS_VERSION': '1.19c', 12:38:52 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-074\\AppData\\Local', 12:38:52 INFO - 'LOGONSERVER': '\\\\T-W864-IX-074', 12:38:52 INFO - 'MONDIR': 'C:\\Monitor_config\\', 12:38:52 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 12:38:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:38:52 INFO - 'MOZ_NO_REMOTE': '1', 12:38:52 INFO - 'NO_EM_RESTART': '1', 12:38:52 INFO - 'NUMBER_OF_PROCESSORS': '8', 12:38:52 INFO - 'OS': 'Windows_NT', 12:38:52 INFO - 'OURDRIVE': 'C:', 12:38: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;', 12:38:52 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 12:38:52 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 12:38:52 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 12:38:52 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 12:38:52 INFO - 'PROCESSOR_LEVEL': '6', 12:38:52 INFO - 'PROCESSOR_REVISION': '1e05', 12:38:52 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 12:38:52 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 12:38:52 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 12:38:52 INFO - 'PROGRAMW6432': 'C:\\Program Files', 12:38:52 INFO - 'PROMPT': '$P$G', 12:38:52 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 12:38:52 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 12:38:52 INFO - 'PUBLIC': 'C:\\Users\\Public', 12:38:52 INFO - 'PWD': 'C:\\slave\\test', 12:38:52 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 12:38:52 INFO - 'SLAVEDIR': 'C:\\slave\\', 12:38:52 INFO - 'SYSTEMDRIVE': 'C:', 12:38:52 INFO - 'SYSTEMROOT': 'C:\\windows', 12:38:52 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 12:38:52 INFO - 'TEST1': 'testie', 12:38:52 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 12:38:52 INFO - 'USERDOMAIN': 'T-W864-IX-074', 12:38:52 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-074', 12:38:52 INFO - 'USERNAME': 'cltbld', 12:38:52 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-074', 12:38:52 INFO - 'WINDIR': 'C:\\windows', 12:38:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 12:38:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:38:53 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 12:38:53 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-pmql8m-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 12:38:53 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)) 12:38:53 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 12:38:53 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-2um4g2-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 12:38:53 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)) 12:38:53 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 12:38:53 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rmonwg-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 12:38:53 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)) 12:38:53 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 12:38:53 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ea2xa5-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 12:38:53 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)) 12:38:53 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 12:38:53 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-pey8at-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 12:38:53 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)) 12:38:53 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 12:38:53 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rdx6wh-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 12:38:53 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)) 12:38:53 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 12:38:53 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-etaifu-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 12:38:53 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)) 12:38:53 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 12:38:53 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-1ti9of-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 12:38:54 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)) 12:38:54 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 12:38:54 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-gnfbdx-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 12:38:54 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)) 12:38:54 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 12:38:54 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-0km7yx-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 12:38:54 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)) 12:38:54 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 12:38:54 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xr_qfk-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 12:38:54 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)) 12:38:54 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 12:38:54 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-zwqpsc-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 12:38:54 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)) 12:38:54 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 12:38:54 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-t0y48r-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 12:38:54 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)) 12:38:54 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 12:38:54 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-v0k92w-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 12:38:54 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)) 12:38:54 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 12:38:54 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-sl6qqd-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 12:38:54 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)) 12:38:54 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 12:38:54 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jwiq0e-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 12:38:55 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)) 12:38:55 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 12:38:55 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-u6tnjh-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 12:38:55 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)) 12:38:55 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)) 12:38:55 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)) 12:38:55 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)) 12:38:55 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)) 12:38:55 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)) 12:38:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10)) 12:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:38:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:38:56 INFO - Downloading blessings-1.6.tar.gz 12:38:56 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings 12:38:56 INFO - Installing collected packages: blessings 12:38:56 INFO - Running setup.py install for blessings 12:38:56 INFO - Successfully installed blessings 12:38:56 INFO - Cleaning up... 12:38:59 INFO - Return code: 0 12:38:59 INFO - Done creating virtualenv C:\slave\test\build/venv. 12:38:59 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 12:38:59 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 12:38:59 INFO - Reading from file tmpfile_stdout 12:38:59 INFO - Using _rmtree_windows ... 12:38:59 INFO - Using _rmtree_windows ... 12:38:59 INFO - Current package versions: 12:38:59 INFO - blessings == 1.6 12:38:59 INFO - blobuploader == 1.2.4 12:38:59 INFO - docopt == 0.6.1 12:38:59 INFO - functools32 == 3.2.3-2 12:38:59 INFO - jsonschema == 2.5.1 12:38:59 INFO - manifestparser == 1.1 12:38:59 INFO - mozInstall == 1.12 12:38:59 INFO - mozcrash == 0.17 12:38:59 INFO - mozdebug == 0.1 12:38:59 INFO - mozdevice == 0.48 12:38:59 INFO - mozfile == 1.2 12:38:59 INFO - mozhttpd == 0.7 12:38:59 INFO - mozinfo == 0.9 12:38:59 INFO - mozleak == 0.1 12:38:59 INFO - mozlog == 3.4 12:38:59 INFO - moznetwork == 0.27 12:38:59 INFO - mozprocess == 0.23 12:38:59 INFO - mozprofile == 0.28 12:38:59 INFO - mozrunner == 6.12 12:38:59 INFO - mozscreenshot == 0.1 12:38:59 INFO - mozsystemmonitor == 0.3 12:38:59 INFO - moztest == 0.7 12:38:59 INFO - mozversion == 1.4 12:38:59 INFO - psutil == 3.1.1 12:38:59 INFO - requests == 1.2.3 12:38:59 INFO - Installing None into virtualenv C:\slave\test\build/venv 12:38:59 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')]} 12:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:38:59 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')]} 12:38:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:38:59 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 0x022BC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0233DE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x028046B0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02318E90>, '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 0x01CAA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02844520>, '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-074', 'USERDOMAIN': 'T-W864-IX-074', '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-074', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-074\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-074', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-074', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-074', '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-074\\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 12:38:59 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 12:38:59 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 12:38:59 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 12:38:59 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-074\\AppData\\Roaming', 12:38:59 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 12:38:59 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 12:38:59 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 12:38:59 INFO - 'COMPUTERNAME': 'T-W864-IX-074', 12:38:59 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 12:38:59 INFO - 'DCLOCATION': 'SCL3', 12:38:59 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 12:38:59 INFO - 'FP_NO_HOST_CHECK': 'NO', 12:38:59 INFO - 'HOMEDRIVE': 'C:', 12:38:59 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-074', 12:38:59 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 12:38:59 INFO - 'KTS_VERSION': '1.19c', 12:38:59 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-074\\AppData\\Local', 12:38:59 INFO - 'LOGONSERVER': '\\\\T-W864-IX-074', 12:38:59 INFO - 'MONDIR': 'C:\\Monitor_config\\', 12:38:59 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 12:38:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:38:59 INFO - 'MOZ_NO_REMOTE': '1', 12:38:59 INFO - 'NO_EM_RESTART': '1', 12:38:59 INFO - 'NUMBER_OF_PROCESSORS': '8', 12:38:59 INFO - 'OS': 'Windows_NT', 12:38:59 INFO - 'OURDRIVE': 'C:', 12:38:59 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;', 12:38:59 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 12:38:59 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 12:38:59 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 12:38:59 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 12:38:59 INFO - 'PROCESSOR_LEVEL': '6', 12:38:59 INFO - 'PROCESSOR_REVISION': '1e05', 12:38:59 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 12:38:59 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 12:38:59 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 12:38:59 INFO - 'PROGRAMW6432': 'C:\\Program Files', 12:38:59 INFO - 'PROMPT': '$P$G', 12:38:59 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 12:38:59 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 12:38:59 INFO - 'PUBLIC': 'C:\\Users\\Public', 12:38:59 INFO - 'PWD': 'C:\\slave\\test', 12:38:59 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 12:38:59 INFO - 'SLAVEDIR': 'C:\\slave\\', 12:38:59 INFO - 'SYSTEMDRIVE': 'C:', 12:38:59 INFO - 'SYSTEMROOT': 'C:\\windows', 12:38:59 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 12:38:59 INFO - 'TEST1': 'testie', 12:38:59 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 12:38:59 INFO - 'USERDOMAIN': 'T-W864-IX-074', 12:38:59 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-074', 12:38:59 INFO - 'USERNAME': 'cltbld', 12:38:59 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-074', 12:38:59 INFO - 'WINDIR': 'C:\\windows', 12:38:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 12:39:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:00 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)) 12:39:00 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)) 12:39:00 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)) 12:39:00 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)) 12:39:00 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)) 12:39:00 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)) 12:39:00 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)) 12:39:00 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)) 12:39:00 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)) 12:39:00 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)) 12:39:00 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)) 12:39:00 INFO - Cleaning up... 12:39:00 INFO - Return code: 0 12:39:00 INFO - Installing jsonschema into virtualenv C:\slave\test\build/venv 12:39: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')]} 12:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39: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')]} 12:39:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022BC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0233DE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x028046B0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02318E90>, '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 0x01CAA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02844520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-074', 'USERDOMAIN': 'T-W864-IX-074', '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-074', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-074\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-074', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-074', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-074', '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-074\\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 12:39: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', 'jsonschema'] in C:\slave\test\build 12:39: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 jsonschema 12:39:00 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 12:39:00 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-074\\AppData\\Roaming', 12:39:00 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 12:39:00 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 12:39:00 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 12:39:00 INFO - 'COMPUTERNAME': 'T-W864-IX-074', 12:39:00 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 12:39:00 INFO - 'DCLOCATION': 'SCL3', 12:39:00 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 12:39:00 INFO - 'FP_NO_HOST_CHECK': 'NO', 12:39:00 INFO - 'HOMEDRIVE': 'C:', 12:39:00 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-074', 12:39:00 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 12:39:00 INFO - 'KTS_VERSION': '1.19c', 12:39:00 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-074\\AppData\\Local', 12:39:00 INFO - 'LOGONSERVER': '\\\\T-W864-IX-074', 12:39:00 INFO - 'MONDIR': 'C:\\Monitor_config\\', 12:39:00 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 12:39:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:00 INFO - 'MOZ_NO_REMOTE': '1', 12:39:00 INFO - 'NO_EM_RESTART': '1', 12:39:00 INFO - 'NUMBER_OF_PROCESSORS': '8', 12:39:00 INFO - 'OS': 'Windows_NT', 12:39:00 INFO - 'OURDRIVE': 'C:', 12:39: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;', 12:39:00 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 12:39:00 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 12:39:00 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 12:39:00 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 12:39:00 INFO - 'PROCESSOR_LEVEL': '6', 12:39:00 INFO - 'PROCESSOR_REVISION': '1e05', 12:39:00 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 12:39:00 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 12:39:00 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 12:39:00 INFO - 'PROGRAMW6432': 'C:\\Program Files', 12:39:00 INFO - 'PROMPT': '$P$G', 12:39:00 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 12:39:00 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 12:39:00 INFO - 'PUBLIC': 'C:\\Users\\Public', 12:39:00 INFO - 'PWD': 'C:\\slave\\test', 12:39:00 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 12:39:00 INFO - 'SLAVEDIR': 'C:\\slave\\', 12:39:00 INFO - 'SYSTEMDRIVE': 'C:', 12:39:00 INFO - 'SYSTEMROOT': 'C:\\windows', 12:39:00 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 12:39:00 INFO - 'TEST1': 'testie', 12:39:00 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 12:39:00 INFO - 'USERDOMAIN': 'T-W864-IX-074', 12:39:00 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-074', 12:39:00 INFO - 'USERNAME': 'cltbld', 12:39:00 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-074', 12:39:00 INFO - 'WINDIR': 'C:\\windows', 12:39:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 12:39:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in c:\slave\test\build\venv\lib\site-packages 12:39:00 INFO - Cleaning up... 12:39:00 INFO - Return code: 0 12:39:00 INFO - Running post-action listener: _resource_record_post_action 12:39:00 INFO - Running post-action listener: _start_resource_monitoring 12:39:00 INFO - Starting resource monitoring. 12:39:00 INFO - [mozharness: 2016-10-19 19:39:00.736000Z] Finished create-virtualenv step (success) 12:39:00 INFO - [mozharness: 2016-10-19 19:39:00.736000Z] Running install step. 12:39:00 INFO - Running pre-action listener: _resource_record_pre_action 12:39:00 INFO - Running main action method: install 12:39:00 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 12:39:00 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 12:39:01 INFO - Reading from file tmpfile_stdout 12:39:01 INFO - Using _rmtree_windows ... 12:39:01 INFO - Using _rmtree_windows ... 12:39:01 INFO - Detecting whether we're running mozinstall >=1.0... 12:39:01 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h'] 12:39:01 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h 12:39:01 INFO - Reading from file tmpfile_stdout 12:39:01 INFO - Output received: 12:39:01 INFO - Usage: mozinstall-script.py [options] installer 12:39:01 INFO - Options: 12:39:01 INFO - -h, --help show this help message and exit 12:39:01 INFO - -d DEST, --destination=DEST 12:39:01 INFO - Directory to install application into. [default: 12:39:01 INFO - "C:\slave\test"] 12:39:01 INFO - --app=APP Application being installed. [default: firefox] 12:39:01 INFO - Using _rmtree_windows ... 12:39:01 INFO - Using _rmtree_windows ... 12:39:01 INFO - mkdir: C:\slave\test\build\application 12:39:01 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'] 12:39:01 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 12:39:03 INFO - Reading from file tmpfile_stdout 12:39:03 INFO - Output received: 12:39:03 INFO - C:\slave\test\build\application\firefox\firefox.exe 12:39:03 INFO - Using _rmtree_windows ... 12:39:03 INFO - Using _rmtree_windows ... 12:39:03 INFO - Running post-action listener: _resource_record_post_action 12:39:03 INFO - [mozharness: 2016-10-19 19:39:03.654000Z] Finished install step (success) 12:39:03 INFO - [mozharness: 2016-10-19 19:39:03.654000Z] Running run-tests step. 12:39:03 INFO - Running pre-action listener: _resource_record_pre_action 12:39:03 INFO - Running main action method: run_tests 12:39:03 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version'] 12:39:03 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version 12:39:03 INFO - Python 2.7.3 12:39:03 INFO - Return code: 0 12:39:03 INFO - grabbing minidump binary from tooltool 12:39:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:39:03 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 0x02318E90>, '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 0x01CAA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02844520>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1 12:39:03 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 12:39:03 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 12:39:03 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 12:39:03 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 12:39:05 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmpafsrwb 12:39:05 INFO - INFO - File integrity verified, renaming tmpafsrwb to win32-minidump_stackwalk.exe 12:39:05 INFO - Return code: 0 12:39:05 INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755 12:39:05 INFO - mkdir: C:\slave\test\build\blobber_upload_dir 12:39:05 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir 12:39:05 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe 12:39:05 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir 12:39:05 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AXX8G2WyQVeUvEiWIOpCXQ/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-074', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs-e10s_errorsummary.log', '--log-raw=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs-e10s_raw.log'] in C:\slave\test\build 12:39:05 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\tests\talos\talos\run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath C:\slave\test\build\application\firefox\firefox --symbolsPath https://queue.taskcluster.net/v1/task/AXX8G2WyQVeUvEiWIOpCXQ/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip --title T-W864-IX-074 --webServer localhost --log-tbpl-level=debug --log-errorsummary=C:\slave\test\build\blobber_upload_dir\dromaeojs-e10s_errorsummary.log --log-raw=C:\slave\test\build\blobber_upload_dir\dromaeojs-e10s_raw.log 12:39:05 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 12:39:05 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-074\\AppData\\Roaming', 12:39:05 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 12:39:05 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 12:39:05 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 12:39:05 INFO - 'COMPUTERNAME': 'T-W864-IX-074', 12:39:05 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 12:39:05 INFO - 'DCLOCATION': 'SCL3', 12:39:05 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 12:39:05 INFO - 'FP_NO_HOST_CHECK': 'NO', 12:39:05 INFO - 'HOMEDRIVE': 'C:', 12:39:05 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-074', 12:39:05 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 12:39:05 INFO - 'KTS_VERSION': '1.19c', 12:39:05 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-074\\AppData\\Local', 12:39:05 INFO - 'LOGONSERVER': '\\\\T-W864-IX-074', 12:39:05 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir', 12:39:05 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe', 12:39:05 INFO - 'MONDIR': 'C:\\Monitor_config\\', 12:39:05 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 12:39:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:05 INFO - 'MOZ_NO_REMOTE': '1', 12:39:05 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir', 12:39:05 INFO - 'NO_EM_RESTART': '1', 12:39:05 INFO - 'NUMBER_OF_PROCESSORS': '8', 12:39:05 INFO - 'OS': 'Windows_NT', 12:39:05 INFO - 'OURDRIVE': 'C:', 12:39: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;', 12:39:05 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 12:39:05 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 12:39:05 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 12:39:05 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 12:39:05 INFO - 'PROCESSOR_LEVEL': '6', 12:39:05 INFO - 'PROCESSOR_REVISION': '1e05', 12:39:05 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 12:39:05 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 12:39:05 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 12:39:05 INFO - 'PROGRAMW6432': 'C:\\Program Files', 12:39:05 INFO - 'PROMPT': '$P$G', 12:39:05 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 12:39:05 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 12:39:05 INFO - 'PUBLIC': 'C:\\Users\\Public', 12:39:05 INFO - 'PWD': 'C:\\slave\\test', 12:39:05 INFO - 'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos', 12:39:05 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 12:39:05 INFO - 'SLAVEDIR': 'C:\\slave\\', 12:39:05 INFO - 'SYSTEMDRIVE': 'C:', 12:39:05 INFO - 'SYSTEMROOT': 'C:\\windows', 12:39:05 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 12:39:05 INFO - 'TEST1': 'testie', 12:39:05 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 12:39:05 INFO - 'USERDOMAIN': 'T-W864-IX-074', 12:39:05 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-074', 12:39:05 INFO - 'USERNAME': 'cltbld', 12:39:05 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-074', 12:39:05 INFO - 'WINDIR': 'C:\\windows', 12:39:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 12:39:05 INFO - Calling ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AXX8G2WyQVeUvEiWIOpCXQ/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-074', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs-e10s_errorsummary.log', '--log-raw=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs-e10s_raw.log'] with output_timeout 3600 ProcessManager NOT managing child processes ProcessManager UNABLE to use job objects to manage child processes 12:39:06 INFO - mozversion application_buildid: 20161019103003 12:39:06 INFO - mozversion application_changeset: f40960c63bfac865d510ec9da42eeed74c384082 12:39:06 INFO - mozversion application_display_name: Nightly 12:39:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:39:06 INFO - mozversion application_name: Firefox 12:39:06 INFO - mozversion application_remotingname: firefox 12:39:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:39:06 INFO - mozversion application_vendor: Mozilla 12:39:06 INFO - mozversion application_version: 52.0a1 12:39:06 INFO - mozversion platform_buildid: 20161019103003 12:39:06 INFO - mozversion platform_changeset: f40960c63bfac865d510ec9da42eeed74c384082 12:39:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:39:06 INFO - mozversion platform_version: 52.0a1 12:39:06 INFO - using testdate: 1476905946 12:39:06 INFO - actual date: 1476905946 12:39:06 INFO - starting webserver on 'localhost:49275' 12:39:06 INFO - SUITE-START | Running 2 tests 12:39:06 INFO - TEST-START | dromaeo_css 12:39:06 INFO - operating with platform_type : w8_ 12:39:06 INFO - Initialising browser for dromaeo_css test... 12:39:06 INFO - TEST-INFO | started process 2360 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmptiwkpv\profile http://localhost:49275/getInfo.html) 12:39:14 INFO - PROCESS | 2360 | __metrics Screen width/height:1600/1200 12:39:14 INFO - PROCESS | 2360 | colorDepth:24 12:39:14 INFO - PROCESS | 2360 | Browser inner width/height: 1010/674 12:39:14 INFO - PROCESS | 2360 | __metrics 12:39:15 ERROR - PROCESS | 2360 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3087: TypeError: this.tabs is undefined 12:39:16 INFO - TEST-INFO | 2360: exit 0 12:39:16 INFO - Browser initialized. 12:39:16 INFO - Running cycle 1/1 for dromaeo_css test... 12:39:16 INFO - TEST-INFO | started process 3064 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmptiwkpv\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:39:16 INFO - PROCESS | 3064 | [GFX1-]: Invalid size in UpdateRenderTarget Size(124,0), 0 12:39:27 INFO - PROCESS | 3064 | RSS: Main: 159383552 12:39:27 INFO - PROCESS | 3064 | 12:40:17 INFO - PROCESS | 3064 | 1476906017295 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] 12:42:26 INFO - PROCESS | 3064 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 12:42:29 INFO - PROCESS | 3064 | RSS: Main: 125878272 12:42:29 INFO - PROCESS | 3064 | 12:45:31 INFO - PROCESS | 3064 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 12:45:31 INFO - PROCESS | 3064 | RSS: Main: 100421632 12:45:31 INFO - PROCESS | 3064 | 12:48:33 INFO - PROCESS | 3064 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 12:48:34 INFO - PROCESS | 3064 | RSS: Main: 94584832 12:48:34 INFO - PROCESS | 3064 | 12:51:35 INFO - PROCESS | 3064 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 12:51:36 INFO - PROCESS | 3064 | RSS: Main: 93044736 12:51:36 INFO - PROCESS | 3064 | 12:54:39 INFO - PROCESS | 3064 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 12:54:39 INFO - PROCESS | 3064 | RSS: Main: 97222656 12:54:39 INFO - PROCESS | 3064 | 12:57:42 INFO - PROCESS | 3064 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 12:57:42 INFO - PROCESS | 3064 | RSS: Main: 89206784 12:57:42 INFO - PROCESS | 3064 | 12:57:42 INFO - PROCESS | 3064 | __start_tp_report 12:57:42 INFO - PROCESS | 3064 | _x_x_mozilla_page_load 12:57:42 INFO - PROCESS | 3064 | _x_x_mozilla_page_load_details 12:57:42 INFO - PROCESS | 3064 | |i|pagename|runs| 12:57:42 INFO - PROCESS | 3064 | |0;dojo.html;2781;2786.066667666332;2815.3524689321457;2818.055951256329;2820.8025438219306;5120.615953803465;5136.101182293102;5191.870203244921;5220.895582088356;5258.86852828679;5074.847754567369;5131.640785145041;5144.228365745131;5250.789968401269;5272.630915835884;4676.97661511692;4728.101660684476;4773.18855794514;4784.99515101829;4838.056578967103;4243.236217480852;4799.160146974283;4803.807847686088;4834.97582512087;4855.247436647325;4461.977690111545;4517.683762136652;4581.633469322446;4626.352310676508;4660.720356778605;4630.421197350332;4646.094011667727;4663.766811659403;4705.317728929286;4753.33453316536;4506.864794056183;4554.931676024862;4566.315052742082;4584.426946631671;4593.311003349524;5168.7415629218385;5172.818951336722;5180.715060671661;5200.6619569727845;5275.340582427197;5496.532794712454;5514.145307477307;5529.834104976857;5531.889362212733;5607.186957891124;5494.697791621459;5570.164475328733;5574.498295153415;5592.944070559283;5601.439856014406;4985.1774457214515;5012.949870501321;5026.949730502648;5071.18860982241;5137.101007323741;5576.7211639417865;5588.329400471888;5603.579731520153;5604.075327570987;5612.971935140298;5344.9732751336;5354.518093371616;5378.51593356592;5381.865453363697;5382.730863456812;5361.195820626937;5390.380106287827;5455.208994695747;5455.345358556999;5476.91784623231;5298.576113910878;5415.729213539307;5433.538149257279;5439.939211853651;5445.727713614304;5377.435369286169;5382.946170538323;5402.756875940592;5463.2078348639225;5465.918011229755;3638.599754027055;3681.9447708284397;3694.538182727159;3733.6079711629886;3740.8690695825517;3204.8077115373153;3263.0537144228383;3268.19929117363;3294.357600267973;3312.7846689965077;5475.288212532345;5484.725763711798;5506.476884695948;5523.751431185607;5540.750666219949;5662.546996240373;5716.428357164334;5725.31296244445;5728.971355143198;5736.967345877699;5326.680399176062;5416.10634245353;5499.587530935196;5499.890002200013;5512.0905050667;4552;4554.863354099382;4568.520305367955;4618.722876627413;4624.699394539344;5827.3298570664065;5875.471207591338;5882.764689412375;5894.616849904743;5907.232059832194;5412.702301373462;5727.398623144676;5731.369549349485;5740.0815869460685;5747.4252574742195;5588.804391846428;5675.375708671961;5717.256756621613;5718.3423906249645;5727.31272247333;5405.729713514387;5453;5467.289252397163;5468.343798744176;5469.371022332482;5486.039943010037;5600.887982240414;5601;5606.607537472338;5606.943930560642;5390.460953904735;5549.334079910436;5555.555555555465;5571.60998730085;5624.437556244343;5465.672059676433;5530.834074977757;5541.473560011954;5542.7782888684005;5559.360673522435;5438.864028399322;5476.561875049907;5477.123660214346;5499.175123731472;5536;5452.073147565003;5466.234727138124;5467.753951072132;5479.452054794648;5500;5356.875056238234;5394;5406.486383793534;5411.648242864201;5456.42707515721 12:57:42 INFO - PROCESS | 3064 | |1;ext.html;528.537529661546;539.1185411851621;551.7848039264687;554.2268535393126;577.9884402311957;35638.64361356386;37364.81317593412;37491.062723431925;37497.25005499888;37627.059323516856;37317.253654926884;37741;37889.81055094727;37907.62092379075;38031.619683803154;8195.098539160688;8310.584470776466;8329.791755206108;8357.832843343129;8362;8343.54110523921;8364.2472177504;8396.706115285966;8403.62183701732;8408.201220884037;8430.145368019026;8444.366672499587;8482;8498.957505212466;8502.914970850305;8348.791280217982;8353.665853365857;8368.790780230482;8387.370947178986;8398.496090234576;8173.2644062034105;8188.14024527422;8240.258376746062;8244.958775206085;8257.38980898725;35327.4700879487;35524.64475355239;35574.644253557395;35591.64408355909;35667.643323566954;2907.854607269649;2923.8684259208385;3286.2277364819247;3497.877574284888;3752.0807402186365;27919.860400697868;28457.57313640297;28471.715282847115;28573.714262857313;28748.712512874812;4015.156817068419;4050.8177132028836;4075.3683179107284;4243.893902652459;4247.426597409341;268860;272042;272554;273028;275939.6203018992;47884;48095.278570821465;48180;48462.75768621134;48541.5145848537;50532.49467505278;50644.49355506398;50786;50883.49116508788;50969.23546146737;15211.163386013654;15419.691606168039;15436;15442.845571544141;15507.534773956799;11941.820872686743;11979.700507487383;12032.81950770739;12049.03607711381;12075.154739168349;14417.351219195161;14677.412903483955;14798.852011479747;14989.70020599582;15232.771508427382;2701.9324516887236;2774.250952242883;2798.258461507702;4987.800487980513;5102.647798333444;776.1578687124534;820.1839170025862;866.06032454786;891.9687810926587;907.9273658107336;26271.080512181983;26707.599386009224;27415.862920685267;27490.587641185397;27640.032598858943;900.9729708108767;920.5121285718579;937.0676177203726;942.7171848445439;959.6305422412421;13822.308884555932;14104;14396.136231826124;14716.926415367854;14739.852601474062;417636;421222;423865;424628.87685561995;425078;47632.04735905262;48064.712881583;48129.51870481321;48224;48335;1110.2394859521253;1145.2155273637584;1151.5336288803048;1158.808796548577;1161.372858656333;25748.356291092125;26919.865400672872;27045.72954270432;27089.561939425545;27615.171544853685;42419;42549.36175957301;42578;42870;42941.57058429376;339852;341841;342851.42871428415;343949;344735;24545.263642090766;24801.379965501008;24819.87590062038;24974.875125624254;24991;39558.2088358237;39682.603173969044;39897.40153897636;40890.1821963565;41022.79488602538;34021.56457903165;34905.825470872485;35368.64631353757;35545.644543554234;36187;35959.82020089883;36108.819455903606;36171;36352.81823590865;36524.26951461009;33114.33771324608;33503.66496335006;33779.4933076009;34090.488642670876;34335.828320858236;30866;31592.368152636358;31643;31784.523232151074;31801.8409907949;24471.941007374076;24501.38746531351;24522.87738561296;24596.385090372885;24776.25671229866 12:57:42 INFO - PROCESS | 3064 | |2;jquery.html;325.45323855922055;328.9013296011197;331.76610489604826;331.8175003747938;343.9071450708309;16081.75877361839;16175.838241617581;17045.659086818257;17164.141792910366;17255.913720431396;14291.428342866273;14897.329620167091;15204.619884502892;15360.769588456154;15940.442084527043;5137.383513978319;5210.713410762407;5356.276902618155;5403.351597808249;5439.864003399927;5310.973445132769;5325.360956685203;5341.759620817073;5355.7857685692525;5364.570834333244;5122.3084883540805;5298.867528311785;5301.284326615915;5304.443033481487;5338.172583249602;5265.420803711589;5320.920186197211;5329.733513324338;5329.9467005330225;5338.813141540067;4491.640668746525;4594.885127871797;4630.050839577879;4630.58324750774;4682.953170468286;18876;19238.230470781153;19367.51581210467;19407.51481212967;19571.021448927495;1973.8815671059783;2049.579836133589;2270.988645056764;2498.5502609530276;2760.682521510032;12144.392780360946;12424.813627795591;12428.502859885684;12642.810357844639;13061.085723999324;1727.5508367824457;1751.947441576742;1781.4388467632655;1804.0889350877853;1833;65445.67277163584;66550.66724666346;66597;67101.66449167723;67217;8930.240929521064;9115.498647574315;9123.863142052875;9158.40470369424;9294.302927280482;12019.158658893968;12158.817617735742;12184.147109702235;12188.963938065364;12203.572874949334;7042.823929401806;7100.396466300319;7287.70849166038;7295.927040729524;7301.634918254066;7142.607156606437;7187.353138217585;7224.20533741288;7237.710491580277;7265.564066156047;3850.6726928210855;3865.5168103987003;3870.5161854768153;3924.274009308287;3924.7841368724994;1617.9595510112106;1632.8938618989728;1662.5261800386832;1677.2620047179203;1696.872734544914;757.9166291707908;838.224642205957;848.1221935296938;866.7789713622985;914.4330515080693;15694.372225111096;16005.439809606607;16121.596960076093;16179;16675;764.6520833021074;768.2279309294123;814.8288859339605;852.2755657690913;861.3023451004706;8929.508877011827;8955.104489550993;9246;9270.397424167408;9421.246300296098;404905;407288;407624;409600;418243;58691;83449.58275208584;83864.58067709622;85123.5743821277;85810.71283930747;918.9356745027918;922.5940586142076;958.2669258017622;962;968.1818863060703;13653.658658533615;14834.851651483346;14990.625234369229;15083.321250543971;15167.696646067237;34301.31397371989;34690.13274668052;34721.30557388889;35109.82445087758;35400.46899296564;46972;47043.18272690951;47914.76042619904;48285.758571208324;48425.27362089501;6760.425363844129;6863.210730765826;6977.162740471176;7076.752313668997;7142;9412.764680883032;10756.784864302826;11035.39305338182;11080.002799748061;11113.722156945818;8545.914540854761;8555.786105347415;8573.199628078173;9783.0706082922;9997.550110245202;8840.29277657773;9090.318226132935;9503.572339244889;9663.323567350219;9696.75758106053;9182.403143795633;9565.665201717906;9627.326087173831;9747.268954828558;9768.755781105529;5964.343922168471;6201.472874805692;6237.594556353823;6330.588511746721;7232;6755.189377274758;8750.168733970262;9012.504312262627;9118.316126290421;9485.762855928657 12:57:42 INFO - PROCESS | 3064 | |3;mootools.html;1129.6385156749839;1135.3698697223042;1200.0339726520153;1368.7399394115118;1423.2314550142924;6664.233613134479;6884.759033433831;7057.858842823147;7469.626518674058;7507.986421833051;7196.712131514733;7482.363999060087;7482.812929676761;7638.236176382359;7645.885311720329;1963.9312624058161;1972.043558873945;1991.5618563915916;1991.75103112111;1995.2418081129151;1901.8763780354232;1919.7024461208466;1925.0952052535285;1931.90340482976;1935.5548223908509;1913.1964574878584;1915.6073005034004;1928.6142771445698;1929.60443109163;1937.2832052140727;1842.9170687319036;1865.5429419792101;1865.962680746391;1869.6073824496873;1873.2694249242807;1849.5930895203035;1862.81371862814;1885.1516817432073;1908;1932.6327997680396;7577.659005344773;7597.164311925684;7605.771826845204;7627.694892204305;7662.578558179298;4270.551592082848;4361.825526978917;4364.258076127035;4370.934435983463;4378.562143785628;2751.3671855473353;2829.759470445015;2851.116153992269;2853.20110369097;2892.638420197475;893.5934149961817;895.6551727584862;904.2810965282616;962.9229661627053;975.1272611013175;10319.638812641522;10338.741531461623;10364.689059328157;10375.740606484822;10397.584096636125;3651.3975194092677;3726.1616136369644;3748.081719978623;3797.9240415191543;3828.980855095707;7906.209379062163;7966.880496792553;7974.162712915177;7978.60106994648;7981.241782030698;4251.256030194765;4262.573742625775;4262.680298977589;4274.380214868826;4281.464816897887;3634.582023067328;3678.8712395066045;3957.5053118360206;3976.721629485908;3978.3037968356;3151.6690747471184;3191.2979144588153;3225.9838700806345;3252.658470860573;3258;961.4711908450324;965.464167387107;968.162539403411;971.8250317061675;982.332014230316;528.9867753306198;637.2257706886155;677.180611460129;678.4504551313452;686.1628812848317;4624.884377890579;4674.649401294916;4681.087187998308;4837.588804951619;5005.649604527648;722.9349358557755;750.3097150621442;783.6316931042401;788.286600626434;803.9437239393186;3016.4721173794496;3050.23744063984;3084.9691503085132;3125.5155450905145;3220.4042252182953;8986.685466008788;9139;9323.580438880266;9376.624935002523;9394.06059394055;9253.67612133572;9256.629734810667;9278.536073196314;9285.396449230779;9291.953540232256;7013.544119632207;7024.086868707035;7153.070100886852;7190.137183538009;7243.674034668347;4798.3042458843975;4803.423589169322;4946.183879659816;4953.851384458472;4994.525520075587;8295.58522073906;8499.532525711145;8544.914550854412;8605.65577376898;8637.265832404317;8482.151784821715;8596.957015215134;8801.119888011148;8813.867791982997;8914.777130571787;5853.0635098384055;6232;6355.90466142999;6356.173697419491;6361.681915904093;6580.341965803573;6821.420179284816;7020.964895175492;7035.507514473938;7203.71185152588;6336.20797400325;6345.96827015862;6678.332166783282;6696.497762667722;6727.663616819237;6349.460295874902;6363.459105976044;6371.331010243857;6378.840528986812;6393.1369265148605;5801.1878337033695;5968.582199246185;5979.910301345571;5987.341392446914;5987.790427335022;3911.980440097895;3935.547412047651;3938.5864484229887;3945.980270098631;4083.57122502133;4009.258287216874;4056.634902858757;4070.4504891840406;4100.794960251916;4141.378793181047 12:57:42 INFO - PROCESS | 3064 | |4;prototype.html;262.5811830130941;266.02080520924324;266.614741698246;275.3488000877923;279.09712081416626;5378.542823859977;5520.61984503874;5605.467480589343;5636.605437619363;5659.66042037478;5229.875576750997;5353.197020446935;5378.300820893288;5420.810271640494;5424;4030.6976976726714;4031.21391328691;4033.9798301008527;4085.9591404085877;4093.3626549380187;3997.460342853721;4006.2388146252265;4021.396790481422;4071.674266058723;4128.958710412888;3962.1085255817497;3968.5436174839974;4004.899877503057;4018.1160144768105;4039.151778126597;4023.396490526415;4032.7580345179385;4048.736832105904;4049.2104039712267;4069.552349241581;3373.5614370131725;3414.2659328244545;3416.829158542088;3430.2281986553076;3482.4776283557667;5237.869053273661;5347.144456886918;5440.238366628675;5451.482109199659;5451.618386712892;4719.62243020561;4735.73953432561;4737.265723812815;4741.170295198361;4753.762311884427;5617.550595952314;5690.260266165414;5755.136729490568;5778.393268706809;5817.272840894888;3693.242885208526;3738.8317525711136;3757.962420375816;3769.227308401771;3802.961970380316;6017.157597936336;6035.31011316832;6072.512234502531;6101.572889897709;6113.449789518964;3665.157013886768;3836.865709700147;3837.7505462144873;3858.614138586175;3859.980700096538;3883.728139030241;3920.9019774505864;3925.7448265862627;3956.643902048772;3965.2466031453932;4660.347551342815;4672;4684.805374629448;4696.201645720235;4710.528947105262;5701.657900525899;5822.883542329129;5830.970845145832;5856.736446859902;5904.852378690567;1305.6017914536158;1338.3843432021185;1340.8592097829783;1350.156152404747;1359.2659963619535;780.360104714129;800.203797221768;800.9959950200212;805.7220259010631;806.749907528668;4971.825986090469;5012.8496145115705;5027.455643771133;5038.924416133761;5046.293518907356;5148.588112950955;5181.948180518222;5184.533391994739;5209.072643122069;5288.2596436498925;5023.673461225008;5052.191649336162;5063.392392912874;5086.092715231788;5328.333958255218;3210.7912985655857;3222.758293128025;3251.6910893465083;3279.868805247811;3292.687194716498;6252.499800015988;6301.842453938688;6350.523295914597;6353.5870168438905;6359.904601430982;5901.29184497863;6063.241659918574;6070.878582428327;6170.876582468325;6200.286966998763;6248.656323902138;6254.718537665816;6284.905726414016;6288.773689130576;6317.905231421532;5769.07694768835;5935.477422095679;5992.64044157352;6086.1175129606845;6145.354737752472;5889.587728858939;5891.617044892068;5945.64326140433;5979.222701048836;6024.307204671519;5979.671118088547;6260.530460215411;6273.435390814849;6287.402696743802;6339.302676705466;3854.325493038763;3883.728139030241;3893.279743247508;3895.7078219133114;3905.8437662493184;5849.824505264849;6064.605800622945;6096.420840020191;6103.145559621746;6108.670774427858;5683.8010669626365;5729.2551968245525;5804.158397032491;5842.766289348378;5897.557683173865;5739.282589676291;5776.133579962871;5781.797637082682;5868.38381969887;5875.030619947832;5704.401037891128;5767.480926716616;5775.422457754191;5787.160861675117;5801.564882633904;5788.768449261982;5792.189093526994;5850.23946886902;5897.764089436546;5928.110783382527;5570.582206334622;5767.8558036049435;5798.275215598051;5827.76688932438;5835.44563266489 12:57:42 INFO - PROCESS | 3064 | |5;yui.html;622.4364080768298;669.2905520148643;707.6320313437013;708.7696498637944;714.6712512244368;12739.235645861254;13717.314134293296;13822.447102115915;13841.930790346034;13866.930665346685;12523.123381363308;13107.082504224709;13131.606051818437;13134.21194728317;13275.004374671915;605.2857627998949;619.7025427794662;621.1676353686059;622.2626187967251;626.5144513002414;605.0561124645545;609.7652403824537;611.4619135161053;611.920450341455;612.3509080374816;660.0429377402761;661.4278648968656;662.5858838226109;663.5852592129919;664.8504086580529;653.7973228299219;654.9520766773196;656.917885264342;659.6207180870971;659.6899457255082;484.0536750652466;484.35096970059936;484.7140187289481;485.3035893492849;485.8105338917825;11889.524419023228;11949;11952.163348565604;11957.162998590102;11958.701032474171;10931.617393391192;11152.609658661908;11279.548818047268;11376.488058037408;11378.293256011664;10178.949105254427;10215.693529194135;10228;10322;10481.685549433529;3552.2540266544056;3568.125809176742;3572.964270357289;3585.5338805955057;3650.1969566695284;64171.358286417475;64518;64794;65446.67276663634;65632.3436765631;8343.8331233375;8448.788780280542;8481.448705834102;8828.025730622612;8847.02682704902;16310.429134980219;16414.1792910354;16437.506874793777;16485.91757041207;16506.504804855875;7573.772786816405;7684.923150768533;7787.260210280015;7829.3736501079775;7858.292753652085;3952.3873799561115;4048.919021619551;4074.5517993020744;4125.628693417547;4154.065335299533;2815.8028937974145;2866.154484427099;2866.512692842222;2922.3424729435706;2924.1958461422855;449.5257503334014;453.1752210975992;460.298045480638;462.17040412459716;466.7129715225112;554.3431034224457;609.1411110334407;635.6630985577651;644.1658052821607;645.644895307579;8036.357091432671;8363;8425.789355266044;8437.662493500191;9244.168024877794;506.70104638263604;573.5067841656172;668.2849351194176;681.0771404746497;684.5379368925956;4292.613664770186;4323.805428755713;4351.042770590465;4376.693631445768;4593.071703503792;75804;87167.56416218005;98775.50612247037;99010.50494747481;100861;83626.07308744165;83984.06055788018;84040.15959840445;85026.57486712527;85540;72617.27382726104;73158;73275.26724732791;74827;75469;7865.528068315919;7997.280244777998;8036.758897233092;8173.711202150672;8210.712625058095;40833.79583102065;41274.58725412707;41465.17069658529;41743.7912810434;43789.56210437855;54930.725346373016;61820.69089654523;62647;63110.68444657747;64127.35872641214;10483.21375896826;10514.26400151982;10578.629747958785;10592.682219533426;10717.303375280582;12113.15207935436;12628.305443200712;12992.935035325141;13026.609201723963;13080.411381487665;11489.885101149215;11508.884911151115;11561.479733411848;11807;11818;11898.940505297418;12133;12208.633740987785;12219.327936963553;12632.305223212445;11236.157288203582;11270.943645282048;11336.149788765711;11340.546378144782;11366.374849383032;10073.345232559861;10139.138173255062;10143.79712405733;10311.123554497952;10667.946660266649;8968.23769979559;9020.819583608421;9382.67160649374;9388;9393.499551676116 12:57:42 INFO - PROCESS | 3064 | __end_tp_report 12:57:42 INFO - PROCESS | 3064 | __start_cc_report 12:57:42 INFO - PROCESS | 3064 | _x_x_mozilla_cycle_collect,294 12:57:42 INFO - PROCESS | 3064 | __end_cc_report 12:57:42 INFO - PROCESS | 3064 | __startTimestamp1476907062356__endTimestamp 12:57:42 INFO - PROCESS | 3064 | 12:57:42 INFO - PROCESS | 3064 | ------- Summary: start ------- 12:57:42 INFO - PROCESS | 3064 | Number of tests: 6 12:57:42 INFO - PROCESS | 3064 | 12:57:42 INFO - PROCESS | 3064 | [#0] dojo.html Cycles:165 Average:5119.08 Median:5411.65 stddev:700.60 (12.9%) stddev-sans-first:678.31 12:57:42 INFO - PROCESS | 3064 | Values: 2781.0 2786.1 2815.4 2818.1 2820.8 5120.6 5136.1 5191.9 5220.9 5258.9 5074.8 5131.6 5144.2 5250.8 5272.6 4677.0 4728.1 4773.2 4785.0 4838.1 4243.2 4799.2 4803.8 4835.0 4855.2 4462.0 4517.7 4581.6 4626.4 4660.7 4630.4 4646.1 4663.8 4705.3 4753.3 4506.9 4554.9 4566.3 4584.4 4593.3 5168.7 5172.8 5180.7 5200.7 5275.3 5496.5 5514.1 5529.8 5531.9 5607.2 5494.7 5570.2 5574.5 5592.9 5601.4 4985.2 5012.9 5026.9 5071.2 5137.1 5576.7 5588.3 5603.6 5604.1 5613.0 5345.0 5354.5 5378.5 5381.9 5382.7 5361.2 5390.4 5455.2 5455.3 5476.9 5298.6 5415.7 5433.5 5439.9 5445.7 5377.4 5382.9 5402.8 5463.2 5465.9 3638.6 3681.9 3694.5 3733.6 3740.9 3204.8 3263.1 3268.2 3294.4 3312.8 5475.3 5484.7 5506.5 5523.8 5540.8 5662.5 5716.4 5725.3 5729.0 5737.0 5326.7 5416.1 5499.6 5499.9 5512.1 4552.0 4554.9 4568.5 4618.7 4624.7 5827.3 5875.5 5882.8 5894.6 5907.2 5412.7 5727.4 5731.4 5740.1 5747.4 5588.8 5675.4 5717.3 5718.3 5727.3 5405.7 5453.0 5467.3 5468.3 5469.4 5486.0 5600.9 5601.0 5606.6 5606.9 5390.5 5549.3 5555.6 5571.6 5624.4 5465.7 5530.8 5541.5 5542.8 5559.4 5438.9 5476.6 5477.1 5499.2 5536.0 5452.1 5466.2 5467.8 5479.5 5500.0 5356.9 5394.0 5406.5 5411.6 5456.4 12:57:42 INFO - PROCESS | 3064 | 12:57:42 INFO - PROCESS | 3064 | [#1] ext.html Cycles:180 Average:48874.28 Median:36269.91 stddev:92794.78 (255.8%) stddev-sans-first:92984.10 12:57:42 INFO - PROCESS | 3064 | Values: 528.5 539.1 551.8 554.2 578.0 35638.6 37364.8 37491.1 37497.3 37627.1 37317.3 37741.0 37889.8 37907.6 38031.6 8195.1 8310.6 8329.8 8357.8 8362.0 8343.5 8364.2 8396.7 8403.6 8408.2 8430.1 8444.4 8482.0 8499.0 8502.9 8348.8 8353.7 8368.8 8387.4 8398.5 8173.3 8188.1 8240.3 8245.0 8257.4 35327.5 35524.6 35574.6 35591.6 35667.6 2907.9 2923.9 3286.2 3497.9 3752.1 27919.9 28457.6 28471.7 28573.7 28748.7 4015.2 4050.8 4075.4 4243.9 4247.4 268860.0 272042.0 272554.0 273028.0 275939.6 47884.0 48095.3 48180.0 48462.8 48541.5 50532.5 50644.5 50786.0 50883.5 50969.2 15211.2 15419.7 15436.0 15442.8 15507.5 11941.8 11979.7 12032.8 12049.0 12075.2 14417.4 14677.4 14798.9 14989.7 15232.8 2701.9 2774.3 2798.3 4987.8 5102.6 776.2 820.2 866.1 892.0 907.9 26271.1 26707.6 27415.9 27490.6 27640.0 901.0 920.5 937.1 942.7 959.6 13822.3 14104.0 14396.1 14716.9 14739.9 417636.0 421222.0 423865.0 424628.9 425078.0 47632.0 48064.7 48129.5 48224.0 48335.0 1110.2 1145.2 1151.5 1158.8 1161.4 25748.4 26919.9 27045.7 27089.6 27615.2 42419.0 42549.4 42578.0 42870.0 42941.6 339852.0 341841.0 342851.4 343949.0 344735.0 24545.3 24801.4 24819.9 24974.9 24991.0 39558.2 39682.6 39897.4 40890.2 41022.8 34021.6 34905.8 35368.6 35545.6 36187.0 35959.8 36108.8 36171.0 36352.8 36524.3 33114.3 33503.7 33779.5 34090.5 34335.8 30866.0 31592.4 31643.0 31784.5 31801.8 24471.9 24501.4 24522.9 24596.4 24776.3 12:57:42 INFO - PROCESS | 3064 | 12:57:42 INFO - PROCESS | 3064 | [#2] jquery.html Cycles:180 Average:24350.96 Median:5307.71 stddev:67552.76 (1272.7%) stddev-sans-first:67718.18 12:57:42 INFO - PROCESS | 3064 | Values: 325.5 328.9 331.8 331.8 343.9 16081.8 16175.8 17045.7 17164.1 17255.9 14291.4 14897.3 15204.6 15360.8 15940.4 5137.4 5210.7 5356.3 5403.4 5439.9 5311.0 5325.4 5341.8 5355.8 5364.6 5122.3 5298.9 5301.3 5304.4 5338.2 5265.4 5320.9 5329.7 5329.9 5338.8 4491.6 4594.9 4630.1 4630.6 4683.0 18876.0 19238.2 19367.5 19407.5 19571.0 1973.9 2049.6 2271.0 2498.6 2760.7 12144.4 12424.8 12428.5 12642.8 13061.1 1727.6 1751.9 1781.4 1804.1 1833.0 65445.7 66550.7 66597.0 67101.7 67217.0 8930.2 9115.5 9123.9 9158.4 9294.3 12019.2 12158.8 12184.1 12189.0 12203.6 7042.8 7100.4 7287.7 7295.9 7301.6 7142.6 7187.4 7224.2 7237.7 7265.6 3850.7 3865.5 3870.5 3924.3 3924.8 1618.0 1632.9 1662.5 1677.3 1696.9 757.9 838.2 848.1 866.8 914.4 15694.4 16005.4 16121.6 16179.0 16675.0 764.7 768.2 814.8 852.3 861.3 8929.5 8955.1 9246.0 9270.4 9421.2 404905.0 407288.0 407624.0 409600.0 418243.0 58691.0 83449.6 83864.6 85123.6 85810.7 918.9 922.6 958.3 962.0 968.2 13653.7 14834.9 14990.6 15083.3 15167.7 34301.3 34690.1 34721.3 35109.8 35400.5 46972.0 47043.2 47914.8 48285.8 48425.3 6760.4 6863.2 6977.2 7076.8 7142.0 9412.8 10756.8 11035.4 11080.0 11113.7 8545.9 8555.8 8573.2 9783.1 9997.6 8840.3 9090.3 9503.6 9663.3 9696.8 9182.4 9565.7 9627.3 9747.3 9768.8 5964.3 6201.5 6237.6 6330.6 7232.0 6755.2 8750.2 9012.5 9118.3 9485.8 12:57:42 INFO - PROCESS | 3064 | 12:57:42 INFO - PROCESS | 3064 | [#3] mootools.html Cycles:180 Average:4796.24 Median:3165.09 stddev:2796.88 (88.4%) stddev-sans-first:2791.16 12:57:42 INFO - PROCESS | 3064 | Values: 1129.6 1135.4 1200.0 1368.7 1423.2 6664.2 6884.8 7057.9 7469.6 7508.0 7196.7 7482.4 7482.8 7638.2 7645.9 1963.9 1972.0 1991.6 1991.8 1995.2 1901.9 1919.7 1925.1 1931.9 1935.6 1913.2 1915.6 1928.6 1929.6 1937.3 1842.9 1865.5 1866.0 1869.6 1873.3 1849.6 1862.8 1885.2 1908.0 1932.6 7577.7 7597.2 7605.8 7627.7 7662.6 4270.6 4361.8 4364.3 4370.9 4378.6 2751.4 2829.8 2851.1 2853.2 2892.6 893.6 895.7 904.3 962.9 975.1 10319.6 10338.7 10364.7 10375.7 10397.6 3651.4 3726.2 3748.1 3797.9 3829.0 7906.2 7966.9 7974.2 7978.6 7981.2 4251.3 4262.6 4262.7 4274.4 4281.5 3634.6 3678.9 3957.5 3976.7 3978.3 3151.7 3191.3 3226.0 3252.7 3258.0 961.5 965.5 968.2 971.8 982.3 529.0 637.2 677.2 678.5 686.2 4624.9 4674.6 4681.1 4837.6 5005.6 722.9 750.3 783.6 788.3 803.9 3016.5 3050.2 3085.0 3125.5 3220.4 8986.7 9139.0 9323.6 9376.6 9394.1 9253.7 9256.6 9278.5 9285.4 9292.0 7013.5 7024.1 7153.1 7190.1 7243.7 4798.3 4803.4 4946.2 4953.9 4994.5 8295.6 8499.5 8544.9 8605.7 8637.3 8482.2 8597.0 8801.1 8813.9 8914.8 5853.1 6232.0 6355.9 6356.2 6361.7 6580.3 6821.4 7021.0 7035.5 7203.7 6336.2 6346.0 6678.3 6696.5 6727.7 6349.5 6363.5 6371.3 6378.8 6393.1 5801.2 5968.6 5979.9 5987.3 5987.8 3912.0 3935.5 3938.6 3946.0 4083.6 4009.3 4056.6 4070.5 4100.8 4141.4 12:57:42 INFO - PROCESS | 3064 | 12:57:42 INFO - PROCESS | 3064 | [#4] prototype.html Cycles:180 Average:4754.42 Median:5399.68 stddev:1507.70 (27.9%) stddev-sans-first:1473.75 12:57:42 INFO - PROCESS | 3064 | Values: 262.6 266.0 266.6 275.3 279.1 5378.5 5520.6 5605.5 5636.6 5659.7 5229.9 5353.2 5378.3 5420.8 5424.0 4030.7 4031.2 4034.0 4086.0 4093.4 3997.5 4006.2 4021.4 4071.7 4129.0 3962.1 3968.5 4004.9 4018.1 4039.2 4023.4 4032.8 4048.7 4049.2 4069.6 3373.6 3414.3 3416.8 3430.2 3482.5 5237.9 5347.1 5440.2 5451.5 5451.6 4719.6 4735.7 4737.3 4741.2 4753.8 5617.6 5690.3 5755.1 5778.4 5817.3 3693.2 3738.8 3758.0 3769.2 3803.0 6017.2 6035.3 6072.5 6101.6 6113.4 3665.2 3836.9 3837.8 3858.6 3860.0 3883.7 3920.9 3925.7 3956.6 3965.2 4660.3 4672.0 4684.8 4696.2 4710.5 5701.7 5822.9 5831.0 5856.7 5904.9 1305.6 1338.4 1340.9 1350.2 1359.3 780.4 800.2 801.0 805.7 806.7 4971.8 5012.8 5027.5 5038.9 5046.3 5148.6 5181.9 5184.5 5209.1 5288.3 5023.7 5052.2 5063.4 5086.1 5328.3 3210.8 3222.8 3251.7 3279.9 3292.7 6252.5 6301.8 6350.5 6353.6 6359.9 5901.3 6063.2 6070.9 6170.9 6200.3 6248.7 6254.7 6284.9 6288.8 6317.9 5769.1 5935.5 5992.6 6086.1 6145.4 5889.6 5891.6 5945.6 5979.2 6024.3 5979.7 6260.5 6273.4 6287.4 6339.3 3854.3 3883.7 3893.3 3895.7 3905.8 5849.8 6064.6 6096.4 6103.1 6108.7 5683.8 5729.3 5804.2 5842.8 5897.6 5739.3 5776.1 5781.8 5868.4 5875.0 5704.4 5767.5 5775.4 5787.2 5801.6 5788.8 5792.2 5850.2 5897.8 5928.1 5570.6 5767.9 5798.3 5827.8 5835.4 12:57:42 INFO - PROCESS | 3064 | 12:57:42 INFO - PROCESS | 3064 | [#5] yui.html Cycles:180 Average:17401.51 Median:475.38 stddev:24929.20 (5244.0%) stddev-sans-first:24967.29 12:57:42 INFO - PROCESS | 3064 | Values: 622.4 669.3 707.6 708.8 714.7 12739.2 13717.3 13822.4 13841.9 13866.9 12523.1 13107.1 13131.6 13134.2 13275.0 605.3 619.7 621.2 622.3 626.5 605.1 609.8 611.5 611.9 612.4 660.0 661.4 662.6 663.6 664.9 653.8 655.0 656.9 659.6 659.7 484.1 484.4 484.7 485.3 485.8 11889.5 11949.0 11952.2 11957.2 11958.7 10931.6 11152.6 11279.5 11376.5 11378.3 10178.9 10215.7 10228.0 10322.0 10481.7 3552.3 3568.1 3573.0 3585.5 3650.2 64171.4 64518.0 64794.0 65446.7 65632.3 8343.8 8448.8 8481.4 8828.0 8847.0 16310.4 16414.2 16437.5 16485.9 16506.5 7573.8 7684.9 7787.3 7829.4 7858.3 3952.4 4048.9 4074.6 4125.6 4154.1 2815.8 2866.2 2866.5 2922.3 2924.2 449.5 453.2 460.3 462.2 466.7 554.3 609.1 635.7 644.2 645.6 8036.4 8363.0 8425.8 8437.7 9244.2 506.7 573.5 668.3 681.1 684.5 4292.6 4323.8 4351.0 4376.7 4593.1 75804.0 87167.6 98775.5 99010.5 100861.0 83626.1 83984.1 84040.2 85026.6 85540.0 72617.3 73158.0 73275.3 74827.0 75469.0 7865.5 7997.3 8036.8 8173.7 8210.7 40833.8 41274.6 41465.2 41743.8 43789.6 54930.7 61820.7 62647.0 63110.7 64127.4 10483.2 10514.3 10578.6 10592.7 10717.3 12113.2 12628.3 12992.9 13026.6 13080.4 11489.9 11508.9 11561.5 11807.0 11818.0 11898.9 12133.0 12208.6 12219.3 12632.3 11236.2 11270.9 11336.1 11340.5 11366.4 10073.3 10139.1 10143.8 10311.1 10667.9 8968.2 9020.8 9382.7 9388.0 9393.5 12:57:42 INFO - PROCESS | 3064 | -------- Summary: end -------- 12:57:42 INFO - PROCESS | 3064 | 12:57:42 INFO - PROCESS | 3064 | [Child 2888] WARNING: pipe error: 109: file c:/builds/moz2_slave/m-cen-w64-pgo-0000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 345 12:57:43 INFO - TEST-INFO | 3064: exit 0 12:57:43 INFO - TEST-OK | dromaeo_css | took 1117258ms 12:57:43 INFO - TEST-START | kraken 12:57:43 INFO - operating with platform_type : w8_ 12:57:43 INFO - Initialising browser for kraken test... 12:57:43 INFO - TEST-INFO | started process 2256 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpbdpzyd\profile http://localhost:49275/getInfo.html) 12:57:49 INFO - PROCESS | 2256 | __metrics Screen width/height:1600/1200 12:57:49 INFO - PROCESS | 2256 | colorDepth:24 12:57:49 INFO - PROCESS | 2256 | Browser inner width/height: 1010/674 12:57:49 INFO - PROCESS | 2256 | __metrics 12:57:50 ERROR - PROCESS | 2256 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3087: TypeError: this.tabs is undefined 12:57:50 INFO - PROCESS | 2256 | [Child 3980] WARNING: pipe error: 109: file c:/builds/moz2_slave/m-cen-w64-pgo-0000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 345 12:57:50 INFO - PROCESS | 2256 | console.error: 12:57:50 INFO - PROCESS | 2256 | Message: Error: Connection closed before committing the transaction. 12:57:50 INFO - PROCESS | 2256 | Stack: 12:57:50 INFO - PROCESS | 2256 | ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:937:23 12:57:50 INFO - PROCESS | 2256 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7 12:57:50 INFO - PROCESS | 2256 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11 12:57:50 INFO - PROCESS | 2256 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7 12:57:50 INFO - PROCESS | 2256 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:714:7 12:57:50 INFO - PROCESS | 2256 | TaskImpl_run@resource://gre/modules/Task.jsm:327:15 12:57:50 INFO - PROCESS | 2256 | Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:551:9 12:57:50 INFO - PROCESS | 2256 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15 12:57:50 INFO - PROCESS | 2256 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:388:5 12:57:50 INFO - PROCESS | 2256 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29 12:57:50 INFO - PROCESS | 2256 | Barrier/this.client.addBlocker/promise13.6% 12:58:47 INFO - TinderboxPrint: I/O read bytes / time
138,251,776 / 1,410,380 12:58:47 INFO - TinderboxPrint: I/O write bytes / time
407,085,056 / 4,301,140 12:58:47 INFO - TinderboxPrint: CPU idle
8,194.7 (86.4%) 12:58:47 INFO - TinderboxPrint: CPU user
1,235.8 (13.0%) 12:58:47 INFO - install - Wall time: 3s; CPU: 11.0%; Read bytes: 0; Write bytes: 33606656; Read time: 0; Write time: 146000 12:58:47 INFO - run-tests - Wall time: 1184s; CPU: 14.0%; Read bytes: 138251776; Write bytes: 317862912; Read time: 1410380; Write time: 4079600 12:58:48 INFO - Running post-run listener: _upload_blobber_files 12:58:48 INFO - Blob upload gear active. 12:58:48 INFO - Preparing to upload files from C:\slave\test\build\blobber_upload_dir. 12:58:48 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 12:58:48 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'] 12:58:48 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 12:58:48 INFO - (blobuploader) - INFO - Open directory for files ... 12:58:48 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs-e10s_errorsummary.log ... 12:58:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:58:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:58:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:58:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:58:49 INFO - (blobuploader) - INFO - Done attempting. 12:58:49 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs-e10s_raw.log ... 12:58:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:58:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:58:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:58:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:58:50 INFO - (blobuploader) - INFO - Done attempting. 12:58:50 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\resource-usage.json ... 12:58:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:58:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:58:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:58:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:58:52 INFO - (blobuploader) - INFO - Done attempting. 12:58:52 INFO - (blobuploader) - INFO - Iteration through files over. 12:58:52 INFO - Return code: 0 12:58:52 INFO - rmtree: C:\slave\test\build\uploaded_files.json 12:58:52 INFO - Using _rmtree_windows ... 12:58:52 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build\\uploaded_files.json',), kwargs: {}, attempt #1 12:58:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2cd9ac71d88b70e1f9817783a7ae4357cb2766f903c8d86e1447e97e0914100d1bdbf79228a1952c10309186eceda0df4d216780bfc7c97e399d149c9568aa29", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d14e5186e0db8bc9d751b4c4b48824bbb63f906d01782adae5d034e336bba655e5d0fa6391689021a4a70f336bb1061c20fb2f318099e46532264eecd16cec1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/116ff3ef0b9decec9dad0277ee15c218337fe3c6e8e9c8191d81cba779af216ee1bde8b0ac8daa1c91f507343f6aef024b01e0ad89266db6f299db0244c55af0"} 12:58:52 INFO - Writing buildbot properties ['blobber_files'] to C:\slave\test\properties\blobber_files 12:58:52 INFO - Writing to file C:\slave\test\properties\blobber_files 12:58:52 INFO - Contents: 12:58:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2cd9ac71d88b70e1f9817783a7ae4357cb2766f903c8d86e1447e97e0914100d1bdbf79228a1952c10309186eceda0df4d216780bfc7c97e399d149c9568aa29", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d14e5186e0db8bc9d751b4c4b48824bbb63f906d01782adae5d034e336bba655e5d0fa6391689021a4a70f336bb1061c20fb2f318099e46532264eecd16cec1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/116ff3ef0b9decec9dad0277ee15c218337fe3c6e8e9c8191d81cba779af216ee1bde8b0ac8daa1c91f507343f6aef024b01e0ad89266db6f299db0244c55af0"} 12:58:52 INFO - Running post-run listener: copy_logs_to_upload_dir 12:58:52 INFO - Copying logs to upload dir... 12:58:52 INFO - mkdir: C:\slave\test\build\upload\logs 12:58:52 INFO - Copying logs to upload dir... 12:58:52 INFO - Using _rmtree_windows ... 12:58:52 INFO - Using _rmtree_windows ... 12:58:52 INFO - Using _rmtree_windows ... 12:58:52 INFO - Using _rmtree_windows ... 12:58:52 INFO - Using _rmtree_windows ... 12:58:52 INFO - Using _rmtree_windows ... 12:58:52 INFO - Using _rmtree_windows ... program finished with exit code 0 elapsedTime=1375.286000 ========= master_lag: -0.07 ========= ========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 22 mins, 55 secs) (at 2016-10-19 12:58:52.798220) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 12:58:52.798921) ========= '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-074\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-074 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-074 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-074\AppData\Local LOGONSERVER=\\T-W864-IX-074 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-074 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-074 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-074 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2cd9ac71d88b70e1f9817783a7ae4357cb2766f903c8d86e1447e97e0914100d1bdbf79228a1952c10309186eceda0df4d216780bfc7c97e399d149c9568aa29", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d14e5186e0db8bc9d751b4c4b48824bbb63f906d01782adae5d034e336bba655e5d0fa6391689021a4a70f336bb1061c20fb2f318099e46532264eecd16cec1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/116ff3ef0b9decec9dad0277ee15c218337fe3c6e8e9c8191d81cba779af216ee1bde8b0ac8daa1c91f507343f6aef024b01e0ad89266db6f299db0244c55af0"} build_url:https://queue.taskcluster.net/v1/task/AXX8G2WyQVeUvEiWIOpCXQ/artifacts/public/build/firefox-52.0a1.en-US.win64.zip program finished with exit code 0 elapsedTime=0.101000 build_url: 'https://queue.taskcluster.net/v1/task/AXX8G2WyQVeUvEiWIOpCXQ/artifacts/public/build/firefox-52.0a1.en-US.win64.zip' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2cd9ac71d88b70e1f9817783a7ae4357cb2766f903c8d86e1447e97e0914100d1bdbf79228a1952c10309186eceda0df4d216780bfc7c97e399d149c9568aa29", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d14e5186e0db8bc9d751b4c4b48824bbb63f906d01782adae5d034e336bba655e5d0fa6391689021a4a70f336bb1061c20fb2f318099e46532264eecd16cec1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/116ff3ef0b9decec9dad0277ee15c218337fe3c6e8e9c8191d81cba779af216ee1bde8b0ac8daa1c91f507343f6aef024b01e0ad89266db6f299db0244c55af0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 12:58:52.924585) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 12:58:52.925397) ========= '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-074\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-074 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-074 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-074\AppData\Local LOGONSERVER=\\T-W864-IX-074 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-074 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-074 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-074 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=0.101000 ========= master_lag: 0.23 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 12:58:53.255277) ========= ========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-10-19 12:58:53.255649) ========= ========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-10-19 12:58:53.747034) ========= ========= Total master_lag: 9.02 =========