builder: mozilla-central_win8_64_test-dromaeojs-pgo slave: t-w864-ix-150 starttime: 1477920897.97 results: success (0) buildid: 20161031030202 builduid: f081758597ca469e9265bc7a5fa9f6e3 revision: e3279760cd977aac30bd9e8032d3ee71f55d2a67 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 06:34:57.965880) ========= master: http://buildbot-master109.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 06:34:57.966402) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 06:34:57.966693) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 06:34:58.102760) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-31 06:34:58.103175) ========= '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-150\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-150 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-150 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-150\AppData\Local LOGONSERVER=\\T-W864-IX-150 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-150 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-150 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-150 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False --06:34:59-- 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% 2.46 GB/s 06:34:59 (2.46 GB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=1.244000 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-31 06:34:59.417776) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-10-31 06:34:59.418293) ========= '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-150\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-150 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-150 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-150\AppData\Local LOGONSERVER=\\T-W864-IX-150 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-150 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-150 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-150 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=3.308000 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-10-31 06:35:02.807309) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-31 06:35:02.807686) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo mozilla-central --rev e3279760cd977aac30bd9e8032d3ee71f55d2a67 --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 e3279760cd977aac30bd9e8032d3ee71f55d2a67 --destination scripts --debug'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-150\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-150 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-150 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-150\AppData\Local LOGONSERVER=\\T-W864-IX-150 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-150 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-150 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-150 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 2016-10-31 06:35:03,338 truncating revision to first 12 chars 2016-10-31 06:35:03,338 Setting DEBUG logging. 2016-10-31 06:35:03,338 attempt 1/10 2016-10-31 06:35:03,338 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e3279760cd97?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-31 06:35:04,507 unpacking tar archive at: mozilla-central-e3279760cd97/testing/mozharness/ 2016-10-31 06:35:04,614 skipping symlink on windows: configs/single_locale/linux32.py program finished with exit code 0 elapsedTime=2.278000 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-31 06:35:05.127532) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 06:35:05.127849) ========= script_repo_revision: e3279760cd977aac30bd9e8032d3ee71f55d2a67 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 06:35:05.128251) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 06:35:05.128553) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 06:35:05.146499) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 51 secs) (at 2016-10-31 06:35:05.146786) ========= 'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'dromaeojs' '--add-option' '--webServer,localhost' '--branch-name' 'Firefox' '--cfg' 'talos/windows_config.py' '--download-symbols' 'ondemand' '--use-talos-json' '--blob-upload-branch' 'Firefox' in dir C:\slave\test\. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['c:/mozilla-build/python27/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/windows_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-150\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-150 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-150 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-150\AppData\Local LOGONSERVER=\\T-W864-IX-150 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-150 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-150 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-150 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 06:35:05 INFO - MultiFileLogger online at 20161031 06:35:05 in C:\slave\test 06:35:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:35:05 INFO - Dumping config to C:\slave\test\logs\localconfig.json. 06:35:05 INFO - {'append_to_log': False, 06:35:05 INFO - 'base_work_dir': 'C:\\slave\\test', 06:35:05 INFO - 'blob_upload_branch': 'Firefox', 06:35:05 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt', 06:35:05 INFO - 'branch': 'Firefox', 06:35:05 INFO - 'buildbot_json_path': 'buildprops.json', 06:35:05 INFO - 'config_files': ('talos/windows_config.py',), 06:35:05 INFO - 'default_actions': ('clobber', 06:35:05 INFO - 'read-buildbot-config', 06:35:05 INFO - 'download-and-extract', 06:35:05 INFO - 'populate-webroot', 06:35:05 INFO - 'create-virtualenv', 06:35:05 INFO - 'install', 06:35:05 INFO - 'run-tests'), 06:35:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:35:05 INFO - 'download_minidump_stackwalk': True, 06:35:05 INFO - 'download_symbols': 'ondemand', 06:35:05 INFO - 'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python', 06:35:05 INFO - 'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'), 06:35:05 INFO - 'hg': 'c:/mozilla-build/hg/hg', 06:35:05 INFO - 'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python', 06:35:05 INFO - 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'), 06:35:05 INFO - 'python': 'c:/mozilla-build/python27/python.exe', 06:35:05 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe', 06:35:05 INFO - 'C:/mozilla-build/tooltool.py'), 06:35:05 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe', 06:35:05 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 06:35:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:35:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:35:05 INFO - 'installer_path': 'installer.exe', 06:35:05 INFO - 'log_level': 'info', 06:35:05 INFO - 'log_name': 'talos', 06:35:05 INFO - 'log_to_console': True, 06:35:05 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe', 06:35:05 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe', 06:35:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest', 06:35:05 INFO - 'opt_config_files': (), 06:35:05 INFO - 'pip_index': False, 06:35:05 INFO - 'sps_profile': False, 06:35:05 INFO - 'sps_profile_interval': 0, 06:35:05 INFO - 'suite': 'dromaeojs', 06:35:05 INFO - 'system_bits': '32', 06:35:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:35:05 INFO - 'title': 'T-W864-IX-150', 06:35:05 INFO - 'use_talos_json': True, 06:35:05 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'), 06:35:05 INFO - 'virtualenv_path': 'C:\\slave\\test\\build/venv', 06:35:05 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll', 06:35:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:35:05 INFO - 'work_dir': 'build'} 06:35:05 INFO - [mozharness: 2016-10-31 13:35:05.753000Z] Running clobber step. 06:35:05 INFO - Running pre-action listener: _resource_record_pre_action 06:35:05 INFO - Running main action method: clobber 06:35:05 INFO - rmtree: C:\slave\test\build 06:35:05 INFO - Using _rmtree_windows ... 06:35:05 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1 06:37:23 INFO - Running post-action listener: _resource_record_post_action 06:37:23 INFO - [mozharness: 2016-10-31 13:37:23.561000Z] Finished clobber step (success) 06:37:23 INFO - [mozharness: 2016-10-31 13:37:23.561000Z] Running read-buildbot-config step. 06:37:23 INFO - Running pre-action listener: _resource_record_pre_action 06:37:23 INFO - Running main action method: read_buildbot_config 06:37:23 INFO - Using buildbot properties: 06:37:23 INFO - { 06:37:23 INFO - "project": "", 06:37:23 INFO - "product": "firefox", 06:37:23 INFO - "script_repo_revision": "production", 06:37:23 INFO - "builddir": "mozilla-central_win8_64_test-dromaeojs", 06:37:23 INFO - "repository": "", 06:37:23 INFO - "buildername": "Windows 8 64-bit mozilla-central pgo talos dromaeojs", 06:37:23 INFO - "buildid": "20161031030202", 06:37:23 INFO - "stage_platform": "win64-pgo", 06:37:23 INFO - "basedir": "C:\\slave\\test", 06:37:23 INFO - "nightly_build": "True", 06:37:23 INFO - "buildnumber": 122, 06:37:23 INFO - "slavename": "t-w864-ix-150", 06:37:23 INFO - "master": "http://buildbot-master109.bb.releng.scl3.mozilla.com:8201/", 06:37:23 INFO - "platform": "win8_64", 06:37:23 INFO - "scheduler": "tests-mozilla-central-win64-pgo-talos", 06:37:23 INFO - "branch": "mozilla-central", 06:37:23 INFO - "repo_path": "mozilla-central", 06:37:23 INFO - "revision": "e3279760cd977aac30bd9e8032d3ee71f55d2a67", 06:37:23 INFO - "pgo_build": "True", 06:37:23 INFO - "builduid": "f081758597ca469e9265bc7a5fa9f6e3", 06:37:23 INFO - "slavebuilddir": "test" 06:37:23 INFO - } 06:37:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/JGsltOo7S6m30Sg4kcAseg/artifacts/public/build/firefox-52.0a1.en-US.win64.zip. 06:37:23 INFO - Running post-action listener: _resource_record_post_action 06:37:23 INFO - [mozharness: 2016-10-31 13:37:23.565000Z] Finished read-buildbot-config step (success) 06:37:23 INFO - [mozharness: 2016-10-31 13:37:23.565000Z] Running download-and-extract step. 06:37:23 INFO - Running pre-action listener: _resource_record_pre_action 06:37:23 INFO - Running main action method: download_and_extract 06:37:23 INFO - mkdir: C:\slave\test\build\tests 06:37:23 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')]} 06:37:23 INFO - trying https://queue.taskcluster.net/v1/task/JGsltOo7S6m30Sg4kcAseg/artifacts/public/build/firefox-52.0a1.en-US.win64.test_packages.json 06:37:23 INFO - Downloading https://queue.taskcluster.net/v1/task/JGsltOo7S6m30Sg4kcAseg/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 06:37:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JGsltOo7S6m30Sg4kcAseg/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 06:37:24 INFO - Downloaded 1218 bytes. 06:37:24 INFO - Reading from file C:\slave\test\build\firefox-52.0a1.en-US.win64.test_packages.json 06:37:24 INFO - Using the following test package requirements: 06:37:24 INFO - {u'common': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 06:37:24 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 06:37:24 INFO - u'firefox-52.0a1.en-US.win64.cppunittest.tests.zip'], 06:37:24 INFO - u'gtest': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 06:37:24 INFO - u'jittest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 06:37:24 INFO - u'jsshell-win64.zip'], 06:37:24 INFO - u'mochitest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 06:37:24 INFO - u'firefox-52.0a1.en-US.win64.mochitest.tests.zip'], 06:37:24 INFO - u'mozbase': [u'firefox-52.0a1.en-US.win64.common.tests.zip'], 06:37:24 INFO - u'reftest': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 06:37:24 INFO - u'firefox-52.0a1.en-US.win64.reftest.tests.zip'], 06:37:24 INFO - u'talos': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 06:37:24 INFO - u'firefox-52.0a1.en-US.win64.talos.tests.zip'], 06:37:24 INFO - u'web-platform': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 06:37:24 INFO - u'firefox-52.0a1.en-US.win64.web-platform.tests.zip'], 06:37:24 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.win64.common.tests.zip', 06:37:24 INFO - u'firefox-52.0a1.en-US.win64.xpcshell.tests.zip']} 06:37:24 INFO - Downloading packages: [u'firefox-52.0a1.en-US.win64.common.tests.zip'] for test suite category: common 06:37:24 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/JGsltOo7S6m30Sg4kcAseg/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip 06:37:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JGsltOo7S6m30Sg4kcAseg/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip'}, attempt #1 06:37:24 INFO - Fetch https://queue.taskcluster.net/v1/task/JGsltOo7S6m30Sg4kcAseg/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip into memory 06:37:25 INFO - Http code: 200 06:37:25 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 06:37:25 INFO - x-amz-cf-id: -d-z9bTrL4hG6enmNKD9RJ-OAMBcYp6yt5HyD9dRsdd1AiOnwtJ4kw== 06:37:25 INFO - x-amz-version-id: bxKfKvhrktW1zGfksmCyigC8o7uLPxhW 06:37:25 INFO - Expected file size: 17433783 06:37:25 INFO - Obtained file size: 17433783 06: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 06:37:50 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/JGsltOo7S6m30Sg4kcAseg/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip 06:37:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JGsltOo7S6m30Sg4kcAseg/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip'}, attempt #1 06:37:50 INFO - Fetch https://queue.taskcluster.net/v1/task/JGsltOo7S6m30Sg4kcAseg/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip into memory 06:37:50 INFO - Http code: 200 06:37:50 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 06:37:50 INFO - x-amz-cf-id: UhjV_Cq30-r_rot6E_7frLwcTc3KMei8QNEqnruQKpptcuv0NpeM5g== 06:37:50 INFO - x-amz-version-id: bxKfKvhrktW1zGfksmCyigC8o7uLPxhW 06:37:51 INFO - Expected file size: 17433783 06:37:51 INFO - Obtained file size: 17433783 06:38:02 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/JGsltOo7S6m30Sg4kcAseg/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip 06:38:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JGsltOo7S6m30Sg4kcAseg/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip'}, attempt #1 06:38:02 INFO - Fetch https://queue.taskcluster.net/v1/task/JGsltOo7S6m30Sg4kcAseg/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip into memory 06:38:02 INFO - Http code: 200 06:38:02 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 06:38:02 INFO - x-amz-cf-id: yZaHPeBEdqC7T35IhP_XzAfHHyqMRGkWR2cBYC4Zjr00F1BeNix53Q== 06:38:02 INFO - x-amz-version-id: OdbwXEbRSY3n.k_axjHYBwqGgMMQXL5m 06:38:02 INFO - Expected file size: 14409038 06:38:02 INFO - Obtained file size: 14409038 06:38:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:07 INFO - trying https://queue.taskcluster.net/v1/task/JGsltOo7S6m30Sg4kcAseg/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 06:38:07 INFO - Downloading https://queue.taskcluster.net/v1/task/JGsltOo7S6m30Sg4kcAseg/artifacts/public/build/firefox-52.0a1.en-US.win64.zip to C:\slave\test\build\firefox-52.0a1.en-US.win64.zip 06:38:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JGsltOo7S6m30Sg4kcAseg/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 06:38:08 INFO - Downloaded 57301425 bytes. 06:38:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JGsltOo7S6m30Sg4kcAseg/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 06:38:08 INFO - mkdir: C:\slave\test\properties 06:38:08 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url 06:38:08 INFO - Writing to file C:\slave\test\properties\build_url 06:38:08 INFO - Contents: 06:38:08 INFO - build_url:https://queue.taskcluster.net/v1/task/JGsltOo7S6m30Sg4kcAseg/artifacts/public/build/firefox-52.0a1.en-US.win64.zip 06:38:09 INFO - Running post-action listener: _resource_record_post_action 06:38:09 INFO - Running post-action listener: set_extra_try_arguments 06:38:09 INFO - [mozharness: 2016-10-31 13:38:09.222000Z] Finished download-and-extract step (success) 06:38:09 INFO - [mozharness: 2016-10-31 13:38:09.222000Z] Running populate-webroot step. 06:38:09 INFO - Running pre-action listener: _resource_record_pre_action 06:38:09 INFO - Running main action method: populate_webroot 06:38:09 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']}, 06:38:09 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']}, 06:38:09 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome', 06:38:09 INFO - u'--tppagecycles', 06:38:09 INFO - u'7'], 06:38:09 INFO - u'tests': [u'tsvgm']}}, 06:38:09 INFO - u'suites': {u'chromez': {u'talos_options': [u'--disable-e10s'], 06:38:09 INFO - u'tests': [u'tresize', u'tcanvasmark']}, 06:38:09 INFO - u'chromez-e10s': {u'tests': [u'tresize', u'tcanvasmark']}, 06:38:09 INFO - u'dromaeojs': {u'talos_options': [u'--disable-e10s'], 06:38:09 INFO - u'tests': [u'dromaeo_css', u'kraken']}, 06:38:09 INFO - u'dromaeojs-e10s': {u'tests': [u'dromaeo_css', u'kraken']}, 06:38:09 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:09 INFO - u'talos_options': [u'--disable-e10s'], 06:38:09 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 06:38:09 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:09 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 06:38:09 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:09 INFO - u'talos_options': [u'--disable-e10s'], 06:38:09 INFO - u'tests': [u'damp', u'tps']}, 06:38:09 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:09 INFO - u'tests': [u'damp', u'tps']}, 06:38:09 INFO - u'g3': {u'talos_options': [u'--disable-e10s'], 06:38:09 INFO - u'tests': [u'dromaeo_dom']}, 06:38:09 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']}, 06:38:09 INFO - u'g4': {u'talos_options': [u'--disable-e10s'], 06:38:09 INFO - u'tests': [u'basic_compositor_video']}, 06:38:09 INFO - u'g4-e10s': {u'tests': [u'basic_compositor_video']}, 06:38:09 INFO - u'other': {u'talos_options': [u'--disable-e10s'], 06:38:09 INFO - u'tests': [u'a11yr', 06:38:09 INFO - u'ts_paint', 06:38:09 INFO - u'tpaint', 06:38:09 INFO - u'sessionrestore', 06:38:09 INFO - u'sessionrestore_no_auto_restore', 06:38:09 INFO - u'tabpaint']}, 06:38:09 INFO - u'other-e10s': {u'tests': [u'a11yr', 06:38:09 INFO - u'ts_paint', 06:38:09 INFO - u'tpaint', 06:38:09 INFO - u'sessionrestore', 06:38:09 INFO - u'sessionrestore_no_auto_restore', 06:38:09 INFO - u'tabpaint']}, 06:38:09 INFO - u'other-e10s_l64': {u'tests': [u'a11yr', 06:38:09 INFO - u'ts_paint', 06:38:09 INFO - u'tpaint', 06:38:09 INFO - u'sessionrestore', 06:38:09 INFO - u'sessionrestore_no_auto_restore', 06:38:09 INFO - u'tabpaint']}, 06:38:09 INFO - u'other-e10s_nol64': {u'tests': [u'a11yr', 06:38:09 INFO - u'ts_paint', 06:38:09 INFO - u'tpaint', 06:38:09 INFO - u'sessionrestore', 06:38:09 INFO - u'sessionrestore_no_auto_restore', 06:38:09 INFO - u'tabpaint']}, 06:38:09 INFO - u'other_l64': {u'talos_options': [u'--disable-e10s'], 06:38:09 INFO - u'tests': [u'a11yr', 06:38:09 INFO - u'ts_paint', 06:38:09 INFO - u'tpaint', 06:38:09 INFO - u'sessionrestore', 06:38:09 INFO - u'sessionrestore_no_auto_restore', 06:38:09 INFO - u'tabpaint']}, 06:38:09 INFO - u'other_nol64': {u'talos_options': [u'--disable-e10s'], 06:38:09 INFO - u'tests': [u'a11yr', 06:38:09 INFO - u'ts_paint', 06:38:09 INFO - u'tpaint', 06:38:09 INFO - u'sessionrestore', 06:38:09 INFO - u'sessionrestore_no_auto_restore', 06:38:09 INFO - u'tabpaint']}, 06:38:09 INFO - u'svgr': {u'talos_options': [u'--disable-e10s'], 06:38:09 INFO - u'tests': [u'tsvgx', 06:38:09 INFO - u'tsvgr_opacity', 06:38:09 INFO - u'tart', 06:38:09 INFO - u'tscrollx', 06:38:09 INFO - u'cart']}, 06:38:09 INFO - u'svgr-e10s': {u'tests': [u'tsvgx', 06:38:09 INFO - u'tsvgr_opacity', 06:38:09 INFO - u'tart', 06:38:09 INFO - u'tscrollx', 06:38:09 INFO - u'cart']}, 06:38:09 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:09 INFO - u'talos_options': [u'--disable-e10s'], 06:38:09 INFO - u'tests': [u'tp5o']}, 06:38:09 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:09 INFO - u'tests': [u'tp5o']}, 06:38:09 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:09 INFO - u'talos_options': [u'--disable-e10s', 06:38:09 INFO - u'--xperf_path', 06:38:09 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:38:09 INFO - u'tests': [u'tp5n']}, 06:38:09 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:09 INFO - u'talos_options': [u'--xperf_path', 06:38:09 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:38:09 INFO - u'tests': [u'tp5n']}}, 06:38:09 INFO - u'talos.zip': {u'path': u'', 06:38:09 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:38:09 INFO - Running post-action listener: _resource_record_post_action 06:38:09 INFO - [mozharness: 2016-10-31 13:38:09.302000Z] Finished populate-webroot step (success) 06:38:09 INFO - [mozharness: 2016-10-31 13:38:09.302000Z] Running create-virtualenv step. 06:38:09 INFO - Running pre-action listener: _resource_record_pre_action 06:38:09 INFO - Running main action method: create_virtualenv 06:38:09 INFO - Creating virtualenv C:\slave\test\build/venv 06:38:09 INFO - mkdir: C:\slave\test\build\venv\Scripts 06:38:09 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll 06:38:09 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'! 06:38:09 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 06:38:09 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build/venv 06:38:18 INFO - New python executable in C:\slave\test\build/venv\Scripts\python.exe 06:38:20 INFO - Installing distribute......................................................................................................................................................................................done. 06:38:22 INFO - Return code: 0 06:38:22 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', '--version'] 06:38:22 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip --version 06:38:22 INFO - Reading from file tmpfile_stdout 06:38:22 INFO - Output received: 06: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) 06:38:22 INFO - Using _rmtree_windows ... 06:38:22 INFO - Using _rmtree_windows ... 06:38:22 INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv 06: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')]} 06:38:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06: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')]} 06:38:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06: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 0x0228C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02333E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0243F600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0237AE90>, '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 0x01CCA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0281D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-150', 'USERDOMAIN': 'T-W864-IX-150', '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-150', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-150\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-150', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-150', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-150', '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-150\\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 06: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 06: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 06:38:22 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 06:38:22 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-150\\AppData\\Roaming', 06:38:22 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 06:38:22 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 06:38:22 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 06:38:22 INFO - 'COMPUTERNAME': 'T-W864-IX-150', 06:38:22 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 06:38:22 INFO - 'DCLOCATION': 'SCL3', 06:38:22 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 06:38:22 INFO - 'FP_NO_HOST_CHECK': 'NO', 06:38:22 INFO - 'HOMEDRIVE': 'C:', 06:38:22 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-150', 06:38:22 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 06:38:22 INFO - 'KTS_VERSION': '1.19c', 06:38:22 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-150\\AppData\\Local', 06:38:22 INFO - 'LOGONSERVER': '\\\\T-W864-IX-150', 06:38:22 INFO - 'MONDIR': 'C:\\Monitor_config\\', 06:38:22 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 06:38:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:22 INFO - 'MOZ_NO_REMOTE': '1', 06:38:22 INFO - 'NO_EM_RESTART': '1', 06:38:22 INFO - 'NUMBER_OF_PROCESSORS': '8', 06:38:22 INFO - 'OS': 'Windows_NT', 06:38:22 INFO - 'OURDRIVE': 'C:', 06: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', 06:38:22 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 06:38:22 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 06:38:22 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 06:38:22 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 06:38:22 INFO - 'PROCESSOR_LEVEL': '6', 06:38:22 INFO - 'PROCESSOR_REVISION': '1e05', 06:38:22 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 06:38:22 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 06:38:22 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 06:38:22 INFO - 'PROGRAMW6432': 'C:\\Program Files', 06:38:22 INFO - 'PROMPT': '$P$G', 06:38:22 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 06:38:22 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 06:38:22 INFO - 'PUBLIC': 'C:\\Users\\Public', 06:38:22 INFO - 'PWD': 'C:\\slave\\test', 06:38:22 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 06:38:22 INFO - 'SLAVEDIR': 'C:\\slave\\', 06:38:22 INFO - 'SYSTEMDRIVE': 'C:', 06:38:22 INFO - 'SYSTEMROOT': 'C:\\windows', 06:38:22 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 06:38:22 INFO - 'TEST1': 'testie', 06:38:22 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 06:38:22 INFO - 'USERDOMAIN': 'T-W864-IX-150', 06:38:22 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-150', 06:38:22 INFO - 'USERNAME': 'cltbld', 06:38:22 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-150', 06:38:22 INFO - 'WINDIR': 'C:\\windows', 06:38:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 06:38:23 INFO - Ignoring indexes: http://pypi.python.org/simple/ 06:38:23 INFO - Downloading/unpacking pip>=1.5 06:38:27 INFO - Running setup.py egg_info for package pip 06:38:27 INFO - warning: no files found matching 'pip\cacert.pem' 06:38:27 INFO - warning: no files found matching '*.html' under directory 'docs' 06:38:27 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 06:38:27 INFO - no previously-included directories found matching 'docs\_build\_sources' 06:38:27 INFO - Installing collected packages: pip 06:38:27 INFO - Found existing installation: pip 0.8.2 06:38:27 INFO - Uninstalling pip: 06:38:27 INFO - Successfully uninstalled pip 06:38:27 INFO - Running setup.py install for pip 06:38:27 INFO - warning: no files found matching 'pip\cacert.pem' 06:38:27 INFO - warning: no files found matching '*.html' under directory 'docs' 06:38:27 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 06:38:27 INFO - no previously-included directories found matching 'docs\_build\_sources' 06:38:27 INFO - Installing pip-script.py script to C:\slave\test\build\venv\Scripts 06:38:27 INFO - Installing pip.exe script to C:\slave\test\build\venv\Scripts 06:38:27 INFO - Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts 06:38:27 INFO - Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts 06:38:27 INFO - Installing pip2-script.py script to C:\slave\test\build\venv\Scripts 06:38:27 INFO - Installing pip2.exe script to C:\slave\test\build\venv\Scripts 06:38:27 INFO - Successfully installed pip 06:38:27 INFO - Cleaning up... 06:38:27 INFO - Return code: 0 06:38:27 INFO - Installing psutil>=3.1.1 into virtualenv C:\slave\test\build/venv 06: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')]} 06:38:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06: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')]} 06:38:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06: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 0x0228C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02333E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0243F600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0237AE90>, '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 0x01CCA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0281D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-150', 'USERDOMAIN': 'T-W864-IX-150', '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-150', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-150\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-150', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-150', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-150', '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-150\\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 06: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 06: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 06:38:27 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 06:38:27 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-150\\AppData\\Roaming', 06:38:27 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 06:38:27 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 06:38:27 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 06:38:27 INFO - 'COMPUTERNAME': 'T-W864-IX-150', 06:38:27 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 06:38:27 INFO - 'DCLOCATION': 'SCL3', 06:38:27 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 06:38:27 INFO - 'FP_NO_HOST_CHECK': 'NO', 06:38:27 INFO - 'HOMEDRIVE': 'C:', 06:38:27 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-150', 06:38:27 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 06:38:27 INFO - 'KTS_VERSION': '1.19c', 06:38:27 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-150\\AppData\\Local', 06:38:27 INFO - 'LOGONSERVER': '\\\\T-W864-IX-150', 06:38:27 INFO - 'MONDIR': 'C:\\Monitor_config\\', 06:38:27 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 06:38:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:27 INFO - 'MOZ_NO_REMOTE': '1', 06:38:27 INFO - 'NO_EM_RESTART': '1', 06:38:27 INFO - 'NUMBER_OF_PROCESSORS': '8', 06:38:27 INFO - 'OS': 'Windows_NT', 06:38:27 INFO - 'OURDRIVE': 'C:', 06: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', 06:38:27 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 06:38:27 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 06:38:27 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 06:38:27 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 06:38:27 INFO - 'PROCESSOR_LEVEL': '6', 06:38:27 INFO - 'PROCESSOR_REVISION': '1e05', 06:38:27 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 06:38:27 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 06:38:27 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 06:38:27 INFO - 'PROGRAMW6432': 'C:\\Program Files', 06:38:27 INFO - 'PROMPT': '$P$G', 06:38:27 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 06:38:27 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 06:38:27 INFO - 'PUBLIC': 'C:\\Users\\Public', 06:38:27 INFO - 'PWD': 'C:\\slave\\test', 06:38:27 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 06:38:27 INFO - 'SLAVEDIR': 'C:\\slave\\', 06:38:27 INFO - 'SYSTEMDRIVE': 'C:', 06:38:27 INFO - 'SYSTEMROOT': 'C:\\windows', 06:38:27 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 06:38:27 INFO - 'TEST1': 'testie', 06:38:27 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 06:38:27 INFO - 'USERDOMAIN': 'T-W864-IX-150', 06:38:27 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-150', 06:38:27 INFO - 'USERNAME': 'cltbld', 06:38:27 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-150', 06:38:27 INFO - 'WINDIR': 'C:\\windows', 06:38:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 06:38:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:28 INFO - Downloading/unpacking psutil>=3.1.1 06:38:28 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 06:38:28 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 06:38:29 INFO - Installing collected packages: psutil 06:38:29 INFO - Successfully installed psutil 06:38:29 INFO - Cleaning up... 06:38:30 INFO - Return code: 0 06:38:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv C:\slave\test\build/venv 06:38:30 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')]} 06:38:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:30 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')]} 06:38:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:30 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 0x0228C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02333E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0243F600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0237AE90>, '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 0x01CCA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0281D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-150', 'USERDOMAIN': 'T-W864-IX-150', '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-150', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-150\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-150', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-150', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-150', '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-150\\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 06:38:30 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 06:38:30 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 06:38:30 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 06:38:30 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-150\\AppData\\Roaming', 06:38:30 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 06:38:30 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 06:38:30 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 06:38:30 INFO - 'COMPUTERNAME': 'T-W864-IX-150', 06:38:30 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 06:38:30 INFO - 'DCLOCATION': 'SCL3', 06:38:30 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 06:38:30 INFO - 'FP_NO_HOST_CHECK': 'NO', 06:38:30 INFO - 'HOMEDRIVE': 'C:', 06:38:30 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-150', 06:38:30 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 06:38:30 INFO - 'KTS_VERSION': '1.19c', 06:38:30 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-150\\AppData\\Local', 06:38:30 INFO - 'LOGONSERVER': '\\\\T-W864-IX-150', 06:38:30 INFO - 'MONDIR': 'C:\\Monitor_config\\', 06:38:30 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 06:38:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:30 INFO - 'MOZ_NO_REMOTE': '1', 06:38:30 INFO - 'NO_EM_RESTART': '1', 06:38:30 INFO - 'NUMBER_OF_PROCESSORS': '8', 06:38:30 INFO - 'OS': 'Windows_NT', 06:38:30 INFO - 'OURDRIVE': 'C:', 06:38:30 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', 06:38:30 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 06:38:30 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 06:38:30 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 06:38:30 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 06:38:30 INFO - 'PROCESSOR_LEVEL': '6', 06:38:30 INFO - 'PROCESSOR_REVISION': '1e05', 06:38:30 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 06:38:30 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 06:38:30 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 06:38:30 INFO - 'PROGRAMW6432': 'C:\\Program Files', 06:38:30 INFO - 'PROMPT': '$P$G', 06:38:30 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 06:38:30 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 06:38:30 INFO - 'PUBLIC': 'C:\\Users\\Public', 06:38:30 INFO - 'PWD': 'C:\\slave\\test', 06:38:30 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 06:38:30 INFO - 'SLAVEDIR': 'C:\\slave\\', 06:38:30 INFO - 'SYSTEMDRIVE': 'C:', 06:38:30 INFO - 'SYSTEMROOT': 'C:\\windows', 06:38:30 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 06:38:30 INFO - 'TEST1': 'testie', 06:38:30 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 06:38:30 INFO - 'USERDOMAIN': 'T-W864-IX-150', 06:38:30 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-150', 06:38:30 INFO - 'USERNAME': 'cltbld', 06:38:30 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-150', 06:38:30 INFO - 'WINDIR': 'C:\\windows', 06:38:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 06:38:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:38:30 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 06:38:30 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 06:38:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:38:31 INFO - Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor 06:38:31 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) 06:38:31 INFO - Installing collected packages: mozsystemmonitor 06:38:31 INFO - Running setup.py install for mozsystemmonitor 06:38:31 INFO - Successfully installed mozsystemmonitor 06:38:31 INFO - Cleaning up... 06:38:32 INFO - Return code: 0 06:38:32 INFO - Installing jsonschema==2.5.1 into virtualenv C:\slave\test\build/venv 06:38:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:32 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 0x0228C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02333E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0243F600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0237AE90>, '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 0x01CCA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0281D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-150', 'USERDOMAIN': 'T-W864-IX-150', '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-150', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-150\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-150', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-150', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-150', '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-150\\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 06:38:32 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 06:38:32 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 06:38:32 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 06:38:32 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-150\\AppData\\Roaming', 06:38:32 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 06:38:32 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 06:38:32 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 06:38:32 INFO - 'COMPUTERNAME': 'T-W864-IX-150', 06:38:32 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 06:38:32 INFO - 'DCLOCATION': 'SCL3', 06:38:32 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 06:38:32 INFO - 'FP_NO_HOST_CHECK': 'NO', 06:38:32 INFO - 'HOMEDRIVE': 'C:', 06:38:32 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-150', 06:38:32 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 06:38:32 INFO - 'KTS_VERSION': '1.19c', 06:38:32 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-150\\AppData\\Local', 06:38:32 INFO - 'LOGONSERVER': '\\\\T-W864-IX-150', 06:38:32 INFO - 'MONDIR': 'C:\\Monitor_config\\', 06:38:32 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 06:38:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:32 INFO - 'MOZ_NO_REMOTE': '1', 06:38:32 INFO - 'NO_EM_RESTART': '1', 06:38:32 INFO - 'NUMBER_OF_PROCESSORS': '8', 06:38:32 INFO - 'OS': 'Windows_NT', 06:38:32 INFO - 'OURDRIVE': 'C:', 06:38:32 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 06:38:32 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 06:38:32 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 06:38:32 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 06:38:32 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 06:38:32 INFO - 'PROCESSOR_LEVEL': '6', 06:38:32 INFO - 'PROCESSOR_REVISION': '1e05', 06:38:32 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 06:38:32 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 06:38:32 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 06:38:32 INFO - 'PROGRAMW6432': 'C:\\Program Files', 06:38:32 INFO - 'PROMPT': '$P$G', 06:38:32 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 06:38:32 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 06:38:32 INFO - 'PUBLIC': 'C:\\Users\\Public', 06:38:32 INFO - 'PWD': 'C:\\slave\\test', 06:38:32 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 06:38:32 INFO - 'SLAVEDIR': 'C:\\slave\\', 06:38:32 INFO - 'SYSTEMDRIVE': 'C:', 06:38:32 INFO - 'SYSTEMROOT': 'C:\\windows', 06:38:32 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 06:38:32 INFO - 'TEST1': 'testie', 06:38:32 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 06:38:32 INFO - 'USERDOMAIN': 'T-W864-IX-150', 06:38:32 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-150', 06:38:32 INFO - 'USERNAME': 'cltbld', 06:38:32 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-150', 06:38:32 INFO - 'WINDIR': 'C:\\windows', 06:38:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 06:38:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:32 INFO - Downloading/unpacking jsonschema==2.5.1 06:38:32 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 06:38:32 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 06:38:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:38:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06: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 06: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 06:38:33 INFO - Downloading functools32-3.2.3-2.tar.gz 06:38:33 INFO - Running setup.py (path:C:\slave\test\build\venv\build\functools32\setup.py) egg_info for package functools32 06:38:33 INFO - warning: no files found matching '*.txt' 06:38:33 INFO - no previously-included directories found matching 'build' 06:38:33 INFO - no previously-included directories found matching 'dist' 06:38:33 INFO - no previously-included directories found matching '.git*' 06:38:33 INFO - Installing collected packages: jsonschema, functools32 06:38:33 INFO - Running setup.py install for functools32 06:38:33 INFO - warning: no files found matching '*.txt' 06:38:33 INFO - no previously-included directories found matching 'build' 06:38:33 INFO - no previously-included directories found matching 'dist' 06:38:33 INFO - no previously-included directories found matching '.git*' 06:38:33 INFO - Successfully installed jsonschema functools32 06:38:33 INFO - Cleaning up... 06:38:34 INFO - Return code: 0 06:38:34 INFO - Installing functools32==3.2.3-2 into virtualenv C:\slave\test\build/venv 06:38:34 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')]} 06:38:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:34 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')]} 06:38:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:34 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 0x0228C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02333E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0243F600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0237AE90>, '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 0x01CCA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0281D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-150', 'USERDOMAIN': 'T-W864-IX-150', '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-150', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-150\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-150', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-150', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-150', '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-150\\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 06:38:34 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 06:38:34 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 06:38:34 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 06:38:34 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-150\\AppData\\Roaming', 06:38:34 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 06:38:34 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 06:38:34 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 06:38:34 INFO - 'COMPUTERNAME': 'T-W864-IX-150', 06:38:34 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 06:38:34 INFO - 'DCLOCATION': 'SCL3', 06:38:34 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 06:38:34 INFO - 'FP_NO_HOST_CHECK': 'NO', 06:38:34 INFO - 'HOMEDRIVE': 'C:', 06:38:34 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-150', 06:38:34 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 06:38:34 INFO - 'KTS_VERSION': '1.19c', 06:38:34 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-150\\AppData\\Local', 06:38:34 INFO - 'LOGONSERVER': '\\\\T-W864-IX-150', 06:38:34 INFO - 'MONDIR': 'C:\\Monitor_config\\', 06:38:34 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 06:38:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:34 INFO - 'MOZ_NO_REMOTE': '1', 06:38:34 INFO - 'NO_EM_RESTART': '1', 06:38:34 INFO - 'NUMBER_OF_PROCESSORS': '8', 06:38:34 INFO - 'OS': 'Windows_NT', 06:38:34 INFO - 'OURDRIVE': 'C:', 06:38:34 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 06:38:34 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 06:38:34 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 06:38:34 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 06:38:34 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 06:38:34 INFO - 'PROCESSOR_LEVEL': '6', 06:38:34 INFO - 'PROCESSOR_REVISION': '1e05', 06:38:34 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 06:38:34 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 06:38:34 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 06:38:34 INFO - 'PROGRAMW6432': 'C:\\Program Files', 06:38:34 INFO - 'PROMPT': '$P$G', 06:38:34 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 06:38:34 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 06:38:34 INFO - 'PUBLIC': 'C:\\Users\\Public', 06:38:34 INFO - 'PWD': 'C:\\slave\\test', 06:38:34 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 06:38:34 INFO - 'SLAVEDIR': 'C:\\slave\\', 06:38:34 INFO - 'SYSTEMDRIVE': 'C:', 06:38:34 INFO - 'SYSTEMROOT': 'C:\\windows', 06:38:34 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 06:38:34 INFO - 'TEST1': 'testie', 06:38:34 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 06:38:34 INFO - 'USERDOMAIN': 'T-W864-IX-150', 06:38:34 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-150', 06:38:34 INFO - 'USERNAME': 'cltbld', 06:38:34 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-150', 06:38:34 INFO - 'WINDIR': 'C:\\windows', 06:38:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 06:38:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in c:\slave\test\build\venv\lib\site-packages 06:38:34 INFO - Cleaning up... 06:38:34 INFO - Return code: 0 06:38:34 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv 06:38:34 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')]} 06:38:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:34 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')]} 06:38:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:34 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 0x0228C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02333E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0243F600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0237AE90>, '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 0x01CCA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0281D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-150', 'USERDOMAIN': 'T-W864-IX-150', '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-150', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-150\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-150', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-150', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-150', '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-150\\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 06:38:34 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 06:38:34 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 06:38:34 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 06:38:34 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-150\\AppData\\Roaming', 06:38:34 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 06:38:34 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 06:38:34 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 06:38:34 INFO - 'COMPUTERNAME': 'T-W864-IX-150', 06:38:34 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 06:38:34 INFO - 'DCLOCATION': 'SCL3', 06:38:34 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 06:38:34 INFO - 'FP_NO_HOST_CHECK': 'NO', 06:38:34 INFO - 'HOMEDRIVE': 'C:', 06:38:34 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-150', 06:38:34 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 06:38:34 INFO - 'KTS_VERSION': '1.19c', 06:38:34 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-150\\AppData\\Local', 06:38:34 INFO - 'LOGONSERVER': '\\\\T-W864-IX-150', 06:38:34 INFO - 'MONDIR': 'C:\\Monitor_config\\', 06:38:34 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 06:38:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:34 INFO - 'MOZ_NO_REMOTE': '1', 06:38:34 INFO - 'NO_EM_RESTART': '1', 06:38:34 INFO - 'NUMBER_OF_PROCESSORS': '8', 06:38:34 INFO - 'OS': 'Windows_NT', 06:38:34 INFO - 'OURDRIVE': 'C:', 06:38:34 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 06:38:34 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 06:38:34 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 06:38:34 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 06:38:34 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 06:38:34 INFO - 'PROCESSOR_LEVEL': '6', 06:38:34 INFO - 'PROCESSOR_REVISION': '1e05', 06:38:34 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 06:38:34 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 06:38:34 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 06:38:34 INFO - 'PROGRAMW6432': 'C:\\Program Files', 06:38:34 INFO - 'PROMPT': '$P$G', 06:38:34 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 06:38:34 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 06:38:34 INFO - 'PUBLIC': 'C:\\Users\\Public', 06:38:34 INFO - 'PWD': 'C:\\slave\\test', 06:38:34 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 06:38:34 INFO - 'SLAVEDIR': 'C:\\slave\\', 06:38:34 INFO - 'SYSTEMDRIVE': 'C:', 06:38:34 INFO - 'SYSTEMROOT': 'C:\\windows', 06:38:34 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 06:38:34 INFO - 'TEST1': 'testie', 06:38:34 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 06:38:34 INFO - 'USERDOMAIN': 'T-W864-IX-150', 06:38:34 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-150', 06:38:34 INFO - 'USERNAME': 'cltbld', 06:38:34 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-150', 06:38:34 INFO - 'WINDIR': 'C:\\windows', 06:38:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 06:38:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:35 INFO - Downloading/unpacking blobuploader==1.2.4 06: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 06: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 06:38:36 INFO - Downloading blobuploader-1.2.4.tar.gz 06:38:36 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader 06:38:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06: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 06: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 06:38:36 INFO - Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests 06:38:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06: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 06: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 06:38:36 INFO - Downloading docopt-0.6.1.tar.gz 06:38:36 INFO - Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt 06:38:37 INFO - Installing collected packages: blobuploader, requests, docopt 06:38:37 INFO - Running setup.py install for blobuploader 06:38:37 INFO - Running setup.py install for requests 06:38:37 INFO - Running setup.py install for docopt 06:38:37 INFO - Successfully installed blobuploader requests docopt 06:38:37 INFO - Cleaning up... 06:38:39 INFO - Return code: 0 06:38:39 INFO - Installing None into virtualenv C:\slave\test\build/venv 06:38:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:39 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 0x0228C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02333E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0243F600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0237AE90>, '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 0x01CCA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0281D520>, '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-150', 'USERDOMAIN': 'T-W864-IX-150', '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-150', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-150\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-150', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-150', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-150', '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-150\\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 06:38:39 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 06:38:39 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 06:38:39 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 06:38:39 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-150\\AppData\\Roaming', 06:38:39 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 06:38:39 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 06:38:39 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 06:38:39 INFO - 'COMPUTERNAME': 'T-W864-IX-150', 06:38:39 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 06:38:39 INFO - 'DCLOCATION': 'SCL3', 06:38:39 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 06:38:39 INFO - 'FP_NO_HOST_CHECK': 'NO', 06:38:39 INFO - 'HOMEDRIVE': 'C:', 06:38:39 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-150', 06:38:39 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 06:38:39 INFO - 'KTS_VERSION': '1.19c', 06:38:39 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-150\\AppData\\Local', 06:38:39 INFO - 'LOGONSERVER': '\\\\T-W864-IX-150', 06:38:39 INFO - 'MONDIR': 'C:\\Monitor_config\\', 06:38:39 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 06:38:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:39 INFO - 'MOZ_NO_REMOTE': '1', 06:38:39 INFO - 'NO_EM_RESTART': '1', 06:38:39 INFO - 'NUMBER_OF_PROCESSORS': '8', 06:38:39 INFO - 'OS': 'Windows_NT', 06:38:39 INFO - 'OURDRIVE': 'C:', 06:38:39 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 06:38:39 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 06:38:39 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 06:38:39 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 06:38:39 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 06:38:39 INFO - 'PROCESSOR_LEVEL': '6', 06:38:39 INFO - 'PROCESSOR_REVISION': '1e05', 06:38:39 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 06:38:39 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 06:38:39 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 06:38:39 INFO - 'PROGRAMW6432': 'C:\\Program Files', 06:38:39 INFO - 'PROMPT': '$P$G', 06:38:39 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 06:38:39 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 06:38:39 INFO - 'PUBLIC': 'C:\\Users\\Public', 06:38:39 INFO - 'PWD': 'C:\\slave\\test', 06:38:39 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 06:38:39 INFO - 'SLAVEDIR': 'C:\\slave\\', 06:38:39 INFO - 'SYSTEMDRIVE': 'C:', 06:38:39 INFO - 'SYSTEMROOT': 'C:\\windows', 06:38:39 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 06:38:39 INFO - 'TEST1': 'testie', 06:38:39 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 06:38:39 INFO - 'USERDOMAIN': 'T-W864-IX-150', 06:38:39 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-150', 06:38:39 INFO - 'USERNAME': 'cltbld', 06:38:39 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-150', 06:38:39 INFO - 'WINDIR': 'C:\\windows', 06:38:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 06:38:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:39 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 06:38:39 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-y10v9g-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 06:38:39 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 06:38:39 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-zzitst-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 06:38:39 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 06:38:39 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-yplyfs-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 06:38:39 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 06:38:39 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xwmkkl-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 06:38:39 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 06:38:39 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-j8ru5n-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 06:38:40 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 06:38:40 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ku8aws-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 06:38:40 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 06:38:40 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ym5ltx-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 06:38:40 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 06:38:40 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-e7kk89-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 06:38:40 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 06:38:40 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-glrccl-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 06:38:40 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 06:38:40 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-4fjf2w-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 06:38:40 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 06:38:40 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-199ew6-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 06:38:40 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 06:38:40 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-8brlkw-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 06:38:40 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 06:38:40 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-s6bft_-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 06:38:40 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 06:38:40 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-yuw5mz-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 06:38:41 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 06:38:41 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-20tw27-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 06:38:41 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 06:38:41 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-kftinf-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 06:38:41 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 06:38:41 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-9ebul3-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 06:38:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:38:41 INFO - Running setup.py install for manifestparser 06:38:41 INFO - Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts 06:38:41 INFO - Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts 06:38:41 INFO - Running setup.py install for mozcrash 06:38:42 INFO - Running setup.py install for mozdebug 06:38:42 INFO - Running setup.py install for mozdevice 06:38:42 INFO - Installing sutini-script.py script to C:\slave\test\build\venv\Scripts 06:38:42 INFO - Installing sutini.exe script to C:\slave\test\build\venv\Scripts 06:38:42 INFO - Installing dm-script.py script to C:\slave\test\build\venv\Scripts 06:38:42 INFO - Installing dm.exe script to C:\slave\test\build\venv\Scripts 06:38:43 INFO - Running setup.py install for mozfile 06:38:43 INFO - Running setup.py install for mozhttpd 06:38:44 INFO - Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts 06:38:44 INFO - Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts 06:38:44 INFO - Running setup.py install for mozinfo 06:38:44 INFO - Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts 06:38:44 INFO - Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts 06:38:44 INFO - Running setup.py install for mozInstall 06:38:44 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts 06:38:44 INFO - Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts 06:38:44 INFO - Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts 06:38:44 INFO - Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts 06:38:44 INFO - Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts 06:38:44 INFO - Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts 06:38:44 INFO - Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts 06:38:44 INFO - Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts 06:38:45 INFO - Running setup.py install for mozleak 06:38:45 INFO - Running setup.py install for mozlog 06:38:45 INFO - Installing structlog-script.py script to C:\slave\test\build\venv\Scripts 06:38:45 INFO - Installing structlog.exe script to C:\slave\test\build\venv\Scripts 06:38:46 INFO - Running setup.py install for moznetwork 06:38:46 INFO - Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts 06:38:46 INFO - Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts 06:38:46 INFO - Running setup.py install for mozprocess 06:38:47 INFO - Running setup.py install for mozprofile 06:38:47 INFO - Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts 06:38:47 INFO - Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts 06:38:47 INFO - Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts 06:38:47 INFO - Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts 06:38:47 INFO - Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts 06:38:47 INFO - Installing view-profile.exe script to C:\slave\test\build\venv\Scripts 06:38:47 INFO - Running setup.py install for mozrunner 06:38:48 INFO - Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts 06:38:48 INFO - Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts 06:38:48 INFO - Running setup.py install for mozscreenshot 06:38:49 INFO - Running setup.py install for moztest 06:38:49 INFO - Running setup.py install for mozversion 06:38:49 INFO - Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts 06:38:49 INFO - Installing mozversion.exe script to C:\slave\test\build\venv\Scripts 06:38:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:38:49 INFO - Cleaning up... 06:38:49 INFO - Return code: 0 06:38:49 INFO - Installing None into virtualenv C:\slave\test\build/venv 06:38:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:49 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 0x0228C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02333E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0243F600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0237AE90>, '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 0x01CCA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0281D520>, '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-150', 'USERDOMAIN': 'T-W864-IX-150', '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-150', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-150\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-150', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-150', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-150', '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-150\\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 06:38:49 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 06:38:49 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 06:38:49 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 06:38:49 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-150\\AppData\\Roaming', 06:38:49 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 06:38:49 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 06:38:49 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 06:38:49 INFO - 'COMPUTERNAME': 'T-W864-IX-150', 06:38:49 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 06:38:49 INFO - 'DCLOCATION': 'SCL3', 06:38:49 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 06:38:49 INFO - 'FP_NO_HOST_CHECK': 'NO', 06:38:49 INFO - 'HOMEDRIVE': 'C:', 06:38:49 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-150', 06:38:49 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 06:38:49 INFO - 'KTS_VERSION': '1.19c', 06:38:49 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-150\\AppData\\Local', 06:38:49 INFO - 'LOGONSERVER': '\\\\T-W864-IX-150', 06:38:49 INFO - 'MONDIR': 'C:\\Monitor_config\\', 06:38:49 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 06:38:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:49 INFO - 'MOZ_NO_REMOTE': '1', 06:38:49 INFO - 'NO_EM_RESTART': '1', 06:38:49 INFO - 'NUMBER_OF_PROCESSORS': '8', 06:38:49 INFO - 'OS': 'Windows_NT', 06:38:49 INFO - 'OURDRIVE': 'C:', 06:38:49 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 06:38:49 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 06:38:49 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 06:38:49 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 06:38:49 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 06:38:49 INFO - 'PROCESSOR_LEVEL': '6', 06:38:49 INFO - 'PROCESSOR_REVISION': '1e05', 06:38:49 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 06:38:49 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 06:38:49 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 06:38:49 INFO - 'PROGRAMW6432': 'C:\\Program Files', 06:38:49 INFO - 'PROMPT': '$P$G', 06:38:49 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 06:38:49 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 06:38:49 INFO - 'PUBLIC': 'C:\\Users\\Public', 06:38:49 INFO - 'PWD': 'C:\\slave\\test', 06:38:49 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 06:38:49 INFO - 'SLAVEDIR': 'C:\\slave\\', 06:38:49 INFO - 'SYSTEMDRIVE': 'C:', 06:38:49 INFO - 'SYSTEMROOT': 'C:\\windows', 06:38:49 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 06:38:49 INFO - 'TEST1': 'testie', 06:38:49 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 06:38:49 INFO - 'USERDOMAIN': 'T-W864-IX-150', 06:38:49 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-150', 06:38:49 INFO - 'USERNAME': 'cltbld', 06:38:49 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-150', 06:38:49 INFO - 'WINDIR': 'C:\\windows', 06:38:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 06:38:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:50 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 06:38:50 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xu8fa8-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 06:38:50 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)) 06:38:50 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 06:38:50 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ibz9h_-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 06:38:50 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)) 06:38:50 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 06:38:50 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-vtp68x-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 06:38:50 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)) 06:38:50 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 06:38:50 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xysz1t-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 06:38:50 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)) 06:38:50 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 06:38:50 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-tt1_iw-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 06:38:50 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)) 06:38:50 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 06:38:50 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-heyag7-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 06:38:50 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)) 06:38:50 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 06:38:50 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-y4zfh1-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 06:38:50 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)) 06:38:51 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 06:38:51 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-nunhsh-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 06:38:51 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)) 06:38:51 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 06:38:51 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-tgnpi0-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 06:38:51 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)) 06:38:51 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 06:38:51 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-zly8sx-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 06:38:51 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)) 06:38:51 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 06:38:51 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-8mlgqa-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 06:38:51 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)) 06:38:51 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 06:38:51 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xi1ib2-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 06:38:51 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)) 06:38:51 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 06:38:51 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-lzkse3-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 06:38:51 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)) 06:38:51 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 06:38:51 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jfe3tj-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 06:38:51 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)) 06:38:51 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 06:38:51 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-afd9uk-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 06:38:52 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)) 06:38:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 06:38:52 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-edks35-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 06:38:52 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)) 06:38:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 06:38:52 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-idr99i-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 06:38:52 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)) 06:38:52 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)) 06:38:52 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)) 06:38:52 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)) 06:38:52 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)) 06:38:52 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)) 06:38:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10)) 06:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:53 INFO - Downloading blessings-1.6.tar.gz 06:38:53 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings 06:38:53 INFO - Installing collected packages: blessings 06:38:53 INFO - Running setup.py install for blessings 06:38:53 INFO - Successfully installed blessings 06:38:53 INFO - Cleaning up... 06:38:56 INFO - Return code: 0 06:38:56 INFO - Done creating virtualenv C:\slave\test\build/venv. 06:38:56 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 06:38:56 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 06:38:56 INFO - Reading from file tmpfile_stdout 06:38:56 INFO - Using _rmtree_windows ... 06:38:56 INFO - Using _rmtree_windows ... 06:38:56 INFO - Current package versions: 06:38:56 INFO - blessings == 1.6 06:38:56 INFO - blobuploader == 1.2.4 06:38:56 INFO - docopt == 0.6.1 06:38:56 INFO - functools32 == 3.2.3-2 06:38:56 INFO - jsonschema == 2.5.1 06:38:56 INFO - manifestparser == 1.1 06:38:56 INFO - mozInstall == 1.12 06:38:56 INFO - mozcrash == 0.17 06:38:56 INFO - mozdebug == 0.1 06:38:56 INFO - mozdevice == 0.48 06:38:56 INFO - mozfile == 1.2 06:38:56 INFO - mozhttpd == 0.7 06:38:56 INFO - mozinfo == 0.9 06:38:56 INFO - mozleak == 0.1 06:38:56 INFO - mozlog == 3.4 06:38:56 INFO - moznetwork == 0.27 06:38:56 INFO - mozprocess == 0.23 06:38:56 INFO - mozprofile == 0.28 06:38:56 INFO - mozrunner == 6.12 06:38:56 INFO - mozscreenshot == 0.1 06:38:56 INFO - mozsystemmonitor == 0.3 06:38:56 INFO - moztest == 0.7 06:38:56 INFO - mozversion == 1.4 06:38:56 INFO - psutil == 3.1.1 06:38:56 INFO - requests == 1.2.3 06:38:56 INFO - Installing None into virtualenv C:\slave\test\build/venv 06:38:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:56 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 0x0228C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02333E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0243F600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0237AE90>, '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 0x01CCA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0281D520>, '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-150', 'USERDOMAIN': 'T-W864-IX-150', '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-150', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-150\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-150', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-150', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-150', '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-150\\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 06:38:56 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 06:38:56 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 06:38:56 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 06:38:56 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-150\\AppData\\Roaming', 06:38:56 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 06:38:56 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 06:38:56 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 06:38:56 INFO - 'COMPUTERNAME': 'T-W864-IX-150', 06:38:56 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 06:38:56 INFO - 'DCLOCATION': 'SCL3', 06:38:56 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 06:38:56 INFO - 'FP_NO_HOST_CHECK': 'NO', 06:38:56 INFO - 'HOMEDRIVE': 'C:', 06:38:56 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-150', 06:38:56 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 06:38:56 INFO - 'KTS_VERSION': '1.19c', 06:38:56 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-150\\AppData\\Local', 06:38:56 INFO - 'LOGONSERVER': '\\\\T-W864-IX-150', 06:38:56 INFO - 'MONDIR': 'C:\\Monitor_config\\', 06:38:56 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 06:38:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:56 INFO - 'MOZ_NO_REMOTE': '1', 06:38:56 INFO - 'NO_EM_RESTART': '1', 06:38:56 INFO - 'NUMBER_OF_PROCESSORS': '8', 06:38:56 INFO - 'OS': 'Windows_NT', 06:38:56 INFO - 'OURDRIVE': 'C:', 06:38:56 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 06:38:56 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 06:38:56 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 06:38:56 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 06:38:56 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 06:38:56 INFO - 'PROCESSOR_LEVEL': '6', 06:38:56 INFO - 'PROCESSOR_REVISION': '1e05', 06:38:56 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 06:38:56 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 06:38:56 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 06:38:56 INFO - 'PROGRAMW6432': 'C:\\Program Files', 06:38:56 INFO - 'PROMPT': '$P$G', 06:38:56 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 06:38:56 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 06:38:56 INFO - 'PUBLIC': 'C:\\Users\\Public', 06:38:56 INFO - 'PWD': 'C:\\slave\\test', 06:38:56 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 06:38:56 INFO - 'SLAVEDIR': 'C:\\slave\\', 06:38:56 INFO - 'SYSTEMDRIVE': 'C:', 06:38:56 INFO - 'SYSTEMROOT': 'C:\\windows', 06:38:56 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 06:38:56 INFO - 'TEST1': 'testie', 06:38:56 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 06:38:56 INFO - 'USERDOMAIN': 'T-W864-IX-150', 06:38:56 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-150', 06:38:56 INFO - 'USERNAME': 'cltbld', 06:38:56 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-150', 06:38:56 INFO - 'WINDIR': 'C:\\windows', 06:38:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 06:38:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:57 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)) 06:38:57 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)) 06:38:57 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)) 06:38:57 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)) 06:38:57 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)) 06:38:57 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)) 06:38:57 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)) 06:38:57 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)) 06:38:57 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)) 06:38:57 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)) 06:38:57 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)) 06:38:57 INFO - Cleaning up... 06:38:57 INFO - Return code: 0 06:38:57 INFO - Installing jsonschema into virtualenv C:\slave\test\build/venv 06:38:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:57 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0228C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02333E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0243F600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0237AE90>, '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 0x01CCA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0281D520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-150', 'USERDOMAIN': 'T-W864-IX-150', '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-150', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-150\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-150', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-150', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-150', '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-150\\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 06:38:57 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in C:\slave\test\build 06:38:57 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:38:57 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 06:38:57 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-150\\AppData\\Roaming', 06:38:57 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 06:38:57 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 06:38:57 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 06:38:57 INFO - 'COMPUTERNAME': 'T-W864-IX-150', 06:38:57 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 06:38:57 INFO - 'DCLOCATION': 'SCL3', 06:38:57 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 06:38:57 INFO - 'FP_NO_HOST_CHECK': 'NO', 06:38:57 INFO - 'HOMEDRIVE': 'C:', 06:38:57 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-150', 06:38:57 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 06:38:57 INFO - 'KTS_VERSION': '1.19c', 06:38:57 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-150\\AppData\\Local', 06:38:57 INFO - 'LOGONSERVER': '\\\\T-W864-IX-150', 06:38:57 INFO - 'MONDIR': 'C:\\Monitor_config\\', 06:38:57 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 06:38:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:57 INFO - 'MOZ_NO_REMOTE': '1', 06:38:57 INFO - 'NO_EM_RESTART': '1', 06:38:57 INFO - 'NUMBER_OF_PROCESSORS': '8', 06:38:57 INFO - 'OS': 'Windows_NT', 06:38:57 INFO - 'OURDRIVE': 'C:', 06:38:57 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 06:38:57 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 06:38:57 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 06:38:57 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 06:38:57 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 06:38:57 INFO - 'PROCESSOR_LEVEL': '6', 06:38:57 INFO - 'PROCESSOR_REVISION': '1e05', 06:38:57 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 06:38:57 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 06:38:57 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 06:38:57 INFO - 'PROGRAMW6432': 'C:\\Program Files', 06:38:57 INFO - 'PROMPT': '$P$G', 06:38:57 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 06:38:57 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 06:38:57 INFO - 'PUBLIC': 'C:\\Users\\Public', 06:38:57 INFO - 'PWD': 'C:\\slave\\test', 06:38:57 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 06:38:57 INFO - 'SLAVEDIR': 'C:\\slave\\', 06:38:57 INFO - 'SYSTEMDRIVE': 'C:', 06:38:57 INFO - 'SYSTEMROOT': 'C:\\windows', 06:38:57 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 06:38:57 INFO - 'TEST1': 'testie', 06:38:57 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 06:38:57 INFO - 'USERDOMAIN': 'T-W864-IX-150', 06:38:57 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-150', 06:38:57 INFO - 'USERNAME': 'cltbld', 06:38:57 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-150', 06:38:57 INFO - 'WINDIR': 'C:\\windows', 06:38:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 06:38:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in c:\slave\test\build\venv\lib\site-packages 06:38:57 INFO - Cleaning up... 06:38:57 INFO - Return code: 0 06:38:57 INFO - Running post-action listener: _resource_record_post_action 06:38:57 INFO - Running post-action listener: _start_resource_monitoring 06:38:57 INFO - Starting resource monitoring. 06:38:57 INFO - [mozharness: 2016-10-31 13:38:57.745000Z] Finished create-virtualenv step (success) 06:38:57 INFO - [mozharness: 2016-10-31 13:38:57.745000Z] Running install step. 06:38:57 INFO - Running pre-action listener: _resource_record_pre_action 06:38:57 INFO - Running main action method: install 06:38:57 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 06:38:57 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 06:38:58 INFO - Reading from file tmpfile_stdout 06:38:58 INFO - Using _rmtree_windows ... 06:38:58 INFO - Using _rmtree_windows ... 06:38:58 INFO - Detecting whether we're running mozinstall >=1.0... 06:38:58 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h'] 06:38:58 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h 06:38:58 INFO - Reading from file tmpfile_stdout 06:38:58 INFO - Output received: 06:38:58 INFO - Usage: mozinstall-script.py [options] installer 06:38:58 INFO - Options: 06:38:58 INFO - -h, --help show this help message and exit 06:38:58 INFO - -d DEST, --destination=DEST 06:38:58 INFO - Directory to install application into. [default: 06:38:58 INFO - "C:\slave\test"] 06:38:58 INFO - --app=APP Application being installed. [default: firefox] 06:38:58 INFO - Using _rmtree_windows ... 06:38:58 INFO - Using _rmtree_windows ... 06:38:58 INFO - mkdir: C:\slave\test\build\application 06:38:58 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'] 06:38:58 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 06:39:00 INFO - Reading from file tmpfile_stdout 06:39:00 INFO - Output received: 06:39:00 INFO - C:\slave\test\build\application\firefox\firefox.exe 06:39:00 INFO - Using _rmtree_windows ... 06:39:00 INFO - Using _rmtree_windows ... 06:39:00 INFO - Running post-action listener: _resource_record_post_action 06:39:00 INFO - [mozharness: 2016-10-31 13:39:00.315000Z] Finished install step (success) 06:39:00 INFO - [mozharness: 2016-10-31 13:39:00.315000Z] Running run-tests step. 06:39:00 INFO - Running pre-action listener: _resource_record_pre_action 06:39:00 INFO - Running main action method: run_tests 06:39:00 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version'] 06:39:00 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version 06:39:00 INFO - Python 2.7.3 06:39:00 INFO - Return code: 0 06:39:00 INFO - grabbing minidump binary from tooltool 06: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')]} 06:39:00 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 0x0237AE90>, '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 0x01CCA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0281D520>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1 06:39:00 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 06:39:00 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 06:39:00 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 06:39:00 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 06:39:02 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmpasj5vp 06:39:02 INFO - INFO - File integrity verified, renaming tmpasj5vp to win32-minidump_stackwalk.exe 06:39:02 INFO - Return code: 0 06:39:02 INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755 06:39:02 INFO - mkdir: C:\slave\test\build\blobber_upload_dir 06:39:02 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir 06:39:02 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe 06:39:02 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir 06:39:02 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JGsltOo7S6m30Sg4kcAseg/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-150', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs_errorsummary.log', '--log-raw=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs_raw.log'] in C:\slave\test\build 06:39:02 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\tests\talos\talos\run_tests.py --branchName Firefox --suite dromaeojs --executablePath C:\slave\test\build\application\firefox\firefox --symbolsPath https://queue.taskcluster.net/v1/task/JGsltOo7S6m30Sg4kcAseg/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip --title T-W864-IX-150 --webServer localhost --log-tbpl-level=debug --log-errorsummary=C:\slave\test\build\blobber_upload_dir\dromaeojs_errorsummary.log --log-raw=C:\slave\test\build\blobber_upload_dir\dromaeojs_raw.log 06:39:02 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 06:39:02 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-150\\AppData\\Roaming', 06:39:02 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 06:39:02 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 06:39:02 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 06:39:02 INFO - 'COMPUTERNAME': 'T-W864-IX-150', 06:39:02 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 06:39:02 INFO - 'DCLOCATION': 'SCL3', 06:39:02 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 06:39:02 INFO - 'FP_NO_HOST_CHECK': 'NO', 06:39:02 INFO - 'HOMEDRIVE': 'C:', 06:39:02 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-150', 06:39:02 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 06:39:02 INFO - 'KTS_VERSION': '1.19c', 06:39:02 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-150\\AppData\\Local', 06:39:02 INFO - 'LOGONSERVER': '\\\\T-W864-IX-150', 06:39:02 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir', 06:39:02 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe', 06:39:02 INFO - 'MONDIR': 'C:\\Monitor_config\\', 06:39:02 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 06:39:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:02 INFO - 'MOZ_NO_REMOTE': '1', 06:39:02 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir', 06:39:02 INFO - 'NO_EM_RESTART': '1', 06:39:02 INFO - 'NUMBER_OF_PROCESSORS': '8', 06:39:02 INFO - 'OS': 'Windows_NT', 06:39:02 INFO - 'OURDRIVE': 'C:', 06:39:02 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 06:39:02 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 06:39:02 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 06:39:02 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 06:39:02 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 06:39:02 INFO - 'PROCESSOR_LEVEL': '6', 06:39:02 INFO - 'PROCESSOR_REVISION': '1e05', 06:39:02 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 06:39:02 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 06:39:02 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 06:39:02 INFO - 'PROGRAMW6432': 'C:\\Program Files', 06:39:02 INFO - 'PROMPT': '$P$G', 06:39:02 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 06:39:02 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 06:39:02 INFO - 'PUBLIC': 'C:\\Users\\Public', 06:39:02 INFO - 'PWD': 'C:\\slave\\test', 06:39:02 INFO - 'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos', 06:39:02 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 06:39:02 INFO - 'SLAVEDIR': 'C:\\slave\\', 06:39:02 INFO - 'SYSTEMDRIVE': 'C:', 06:39:02 INFO - 'SYSTEMROOT': 'C:\\windows', 06:39:02 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 06:39:02 INFO - 'TEST1': 'testie', 06:39:02 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 06:39:02 INFO - 'USERDOMAIN': 'T-W864-IX-150', 06:39:02 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-150', 06:39:02 INFO - 'USERNAME': 'cltbld', 06:39:02 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-150', 06:39:02 INFO - 'WINDIR': 'C:\\windows', 06:39:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 06:39:02 INFO - Calling ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JGsltOo7S6m30Sg4kcAseg/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-150', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs_errorsummary.log', '--log-raw=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs_raw.log'] with output_timeout 3600 ProcessManager NOT managing child processes ProcessManager UNABLE to use job objects to manage child processes 06:39:03 INFO - mozversion application_buildid: 20161031030202 06:39:03 INFO - mozversion application_changeset: e3279760cd977aac30bd9e8032d3ee71f55d2a67 06:39:03 INFO - mozversion application_display_name: Nightly 06:39:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:39:03 INFO - mozversion application_name: Firefox 06:39:03 INFO - mozversion application_remotingname: firefox 06:39:03 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:39:03 INFO - mozversion application_vendor: Mozilla 06:39:03 INFO - mozversion application_version: 52.0a1 06:39:03 INFO - mozversion platform_buildid: 20161031030202 06:39:03 INFO - mozversion platform_changeset: e3279760cd977aac30bd9e8032d3ee71f55d2a67 06:39:03 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:39:03 INFO - mozversion platform_version: 52.0a1 06:39:03 INFO - using testdate: 1477921143 06:39:03 INFO - actual date: 1477921143 06:39:03 INFO - starting webserver on 'localhost:49277' 06:39:03 INFO - SUITE-START | Running 2 tests 06:39:03 INFO - TEST-START | dromaeo_css 06:39:03 INFO - operating with platform_type : w8_ 06:39:03 INFO - Initialising browser for dromaeo_css test... 06:39:03 INFO - TEST-INFO | started process 4068 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpfedpdr\profile http://localhost:49277/getInfo.html) 06:39:11 INFO - PROCESS | 4068 | __metrics Screen width/height:1600/1200 06:39:11 INFO - PROCESS | 4068 | colorDepth:24 06:39:11 INFO - PROCESS | 4068 | Browser inner width/height: 1010/674 06:39:11 INFO - PROCESS | 4068 | __metrics 06:39:12 INFO - PROCESS | 4068 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:39:12 INFO - PROCESS | 4068 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:39:13 INFO - TEST-INFO | 4068: exit 0 06:39:13 INFO - Browser initialized. 06:39:13 INFO - Running cycle 1/1 for dromaeo_css test... 06:39:13 INFO - TEST-INFO | started process 3180 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpfedpdr\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:39:14 INFO - PROCESS | 3180 | [GFX1-]: Invalid size in UpdateRenderTarget Size(124,0), 0 06:39:25 INFO - PROCESS | 3180 | RSS: Main: 160632832 06:39:25 INFO - PROCESS | 3180 | 06:40:16 INFO - PROCESS | 3180 | 1477921216475 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] 06:42:27 INFO - PROCESS | 3180 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 06:42:28 INFO - PROCESS | 3180 | RSS: Main: 261865472 06:42:28 INFO - PROCESS | 3180 | 06:45:31 INFO - PROCESS | 3180 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 06:45:32 INFO - PROCESS | 3180 | RSS: Main: 218628096 06:45:32 INFO - PROCESS | 3180 | 06:48:34 INFO - PROCESS | 3180 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 06:48:34 INFO - PROCESS | 3180 | RSS: Main: 181309440 06:48:34 INFO - PROCESS | 3180 | 06:51:36 INFO - PROCESS | 3180 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 06:51:37 INFO - PROCESS | 3180 | RSS: Main: 172826624 06:51:37 INFO - PROCESS | 3180 | 06:54:40 INFO - PROCESS | 3180 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 06:54:40 INFO - PROCESS | 3180 | RSS: Main: 168087552 06:54:40 INFO - PROCESS | 3180 | 06:57:43 INFO - PROCESS | 3180 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 06:57:43 INFO - PROCESS | 3180 | RSS: Main: 238878720 06:57:43 INFO - PROCESS | 3180 | 06:57:43 INFO - PROCESS | 3180 | __start_tp_report 06:57:43 INFO - PROCESS | 3180 | _x_x_mozilla_page_load 06:57:43 INFO - PROCESS | 3180 | _x_x_mozilla_page_load_details 06:57:43 INFO - PROCESS | 3180 | |i|pagename|runs| 06:57:43 INFO - PROCESS | 3180 | |0;dojo.html;2849.52982757845;2873.0662534676235;2887.9566806497905;2889.6676882158545;2907.360380716243;5016.871203979112;5050.621203409741;5064.974675126628;5118.2322651602235;5198.610104242178;5045.873853153673;5162.870928226796;5177.948220517785;5234.973825130878;5310.468953104697;4570;4611.792469338871;4638.443386793572;4654.045920586289;4734.479207287196;4614.554286228287;4661.184292748772;4681;4702.835400760974;4714.5756881880625;351.8729514045676;4703.6472264580125;4707.741074240916;4743.051389722053;4749.62003039756;4655.348251244828;4682.29765535169;4703.0358776451085;4707.129181101507;4708.223143181371;4581.3815134956685;4634.2353511670535;4646.094011667727;4649.674522783406;4654.790534425959;5110.131277682803;5136.537711605936;5198.168293073128;5221.973890130563;5280.445553216934;5572.749226284827;5574.470425309589;5586.162075688639;5588.497035266845;5588.608797384185;5578.0517312057045;5586.86032849178;5611.719414029282;5612.747426365782;5619.943800561983;5167.457416971201;5168.61235407346;5171.198464238049;5176.741162941876;5178.275041494194;5679.062954612443;5724.255846739898;5725.742341594555;5726.883257764696;5730.054541000688;5407.513323800877;5428.972855135778;5438.510534051875;5439.3200849893765;5453.209284653703;5479.0411677957;5554.166874968706;5554.944450555443;5556.333240011225;5557.722113894289;5335.653182543122;5455.509004189563;5462.8361149165585;5464.3442786865835;5469.863253418617;5464.7814087436855;5464.890702185934;5473.781048758085;5476.863078423071;5543.445655434505;3757.098296408842;3775.5846856845724;3777.8299976501125;3818.5417749870194;3823.6941044716355;3243.870245190213;3244.4808830587463;3245.9675403246138;3298.5711857458377;3361.394948909171;5059.848204553869;5064.316317297118;5099.59203263738;5126.15418455958;5165.948340516622;5609.775608975677;5614.214010038598;5622.269105016322;5624.55003599711;5688.317401911797;4908.680935739166;5070.6957582545165;5086.64393492452;5158.638895277295;5168.250603662523;4438.423005009393;4453.465584129925;4470.351798989193;4521.773911304487;4530.592246697813;5630.155476678449;5635.126555383922;5635.633683810539;5649.378568357395;5706.058500347479;5505.807296744595;5546.861328466821;5563.13771365439;5576.302962129734;5577.163425486209;5591.916121258103;5642.153676948491;5649.350324712546;5671.149327600893;5739.540836732968;5443.891122177613;5454.209139674805;5454.3454785426;5455.236266922713;5494.2582751328055;5560.527355174693;5566.777328906798;5569.10894256917;5571.7771289149605;5647.576431767716;5303.522682958398;5307.177387504943;5358.705271210121;5377.758000890048;5411.675299482044;5359.544438722753;5359.678419294854;5404.621676482609;5412.512873841373;5463.31708536433;5251.36983561975;5303.973480132575;5309.920351194658;5315.840524784263;5367.704776237344;5373.811916582901;5385.299911011543;5401.054815407209;5401.432849550741;5419.0245755764345;5387.461253874738;5394.514493695587;5396.271503346998;5403;5454.836354909359 06:57:43 INFO - PROCESS | 3180 | |1;ext.html;549.3462779292641;560.179337270898;564.8870225954809;569.6325869813968;569.9401562835902;27794.722052779467;29862.40275194495;29874.402511949775;29915;36107.4583881242;34632.48051279233;38049;38136.23727525455;38148.80925595375;38196.809015954954;8204.630791614392;8335.499870007789;8338.374621903351;8347.457415267989;8348.373871959628;8341.95829020854;8385.119562445947;8388.706395276167;8423.326133909302;8434.45176063557;8398.160183981614;8447.493150410995;8451.577421128919;8456.112108228639;8458;8404.453710508797;8412.36907231957;8456.069832318502;8462.19609137131;8465.068842427328;8126.146754590801;8194.713185038554;8197.508149510988;8202;8205.425620206588;35373.29253414917;35429.29141417183;35741;35752.64247357545;35878.46182307268;2982.4333376658365;3452.5511683480986;3481.860725570974;3607.152319204985;3705.314516814398;27999.440011199662;28295;28612.284692882637;29211.123666290045;29453.263668408246;3897.9610203897882;3898.941515877236;3949.782761948092;3994.2810294147043;4132.73137246081;292583;292834;292863;293108;293336;28690.569641455393;29562.260943476154;45232.54767452349;45636;45724.771376142904;30360;30653.540196897065;30689.232769180504;30728.231794205323;30791.076267712004;10791.6222932197;10802.351858888493;10832.458377081115;10918.126549875991;10925.07136893373;9587.616495340248;9603.663871764455;9658.275629327829;9700.417974921527;9718.173955213886;7118.572885626879;7160.212376638566;7218.783436496913;7219.566825990458;7224.422046236288;2847.928801779972;2887.379213469072;2888.03250910943;2911.5050441424587;2919.3723349479965;851.586980314547;855.3456605696647;856.5246288309924;867.8654808504692;918.9678361257323;26979.460410792068;27108.864455677594;27273.86363068172;27886.442271154465;28027;740.4335683202247;907.5598334807613;937.1846493550654;943.834828904939;979.1090108001684;13576.864231357758;13908.860911390959;13925.442982280798;14099.929500352639;14210.786838197435;429710.1376820993;431630;433971;434173;435564;42383.576164237966;42976.35535466971;45543;45751.08497830025;45865.770671146434;1049.496241803923;1065.2223876569992;1107.1309022417363;1129.2829053551054;1154.0825044089968;25333;26910.461790764468;27608.861955690092;27698.169054928385;27734.306642334104;39774.20451590894;40050.1989960205;40163.39754903737;40175.397369040074;40182.1963560733;330618;331942;333972;334884;335927;23691.763082368954;24046.75953240515;24645.137420190207;24706.50586988286;25773.3556661085;38262.6173738259;38375.61624383832;38682;38714;38849.417258741705;32523.18692032718;32753.672463276016;32920.506192407614;33334.499982499794;33337.33325333528;32904.34191316208;33075.83462082771;33133.83433082819;33225.501617475275;33313.50029749507;31597.526037109;31795.84102079475;31800.8409957958;31932.52101218437;32054.519182212753;28365.574516381857;29751.851240743657;30052.84973575118;30182.396352072396;30320.084769482528;22596.209132680277;23179.188728394427;23452.765472345058;23479.295621131394;23519.294421167393 06:57:43 INFO - PROCESS | 3180 | |2;jquery.html;313.1732226920928;333.70133730311375;338.33854813838957;339.10645449241247;352.716063568827;13179.011574131942;13773.449062037518;14296.213708246043;16130.83869161308;17442.38951636693;14141.929290353533;14317.42730290787;14624.707505849876;14906.40374385026;15063.698726025501;4615.861524154272;4782.97608511957;4791.448983366905;4801.855944321658;4806.663533552635;3567.143885467482;3764.247150569883;4866.829660961867;5094.490550944913;5098.082345177866;5145.202493613496;5159.974200128994;5164.277001219813;5173.715445650488;5175.534201921826;5118.795248190068;5737.5696822738255;5738.77044918207;5751.281089863767;5754.367019627837;4985.950140498585;5053.444121146671;5054.873628159326;5057.367829021372;5059.468755780626;11061.778764424747;16108.11405372704;19088.61822763537;19896.801031989784;19906;1884.2839720906104;1969.1631056800802;2126.734158230221;2328.895199716017;2349.5183487385043;8753.956230218871;9106.499142547158;9723.46520941348;11673.88326116745;13371.33143342829;1750.5273576134373;1781.8930864148192;1782.679117758803;1797.5236562310997;1806.8554515638718;72990.27009729888;73234.26765732327;73335.56607499017;75393;75714.62142689306;9095.545222738836;9267.119623635745;9335.253179745605;9533.189678877374;9701.563429645683;12708.110432269837;12733.172343797623;12741.617751467471;12761.489540418464;12774;6638.302978187317;6751.628660423724;6857.588544687334;6857.691403886837;6860.1081859358965;6411.67941602918;6418.4865210783955;6426.550141490145;6508.869822603521;6525.445337146396;4045.7774822384463;4055.6349928506575;4063.22798668258;4100.6924480664065;4124.91750164995;1683.3014299065997;1696.50801267631;1738.078818226342;1761.9471415857545;1764.303100275384;803.8834369016577;825.3562221467265;826.9297109745619;850.7022542110212;855.9315254779602;16561.751573726404;16600.683822206312;16839.221528447913;16869.409570664968;17336.133193340283;808.458332916947;814.4217605500161;817.9550124743196;820.979475513117;832.0223737108873;9185.402948808307;9446.527673616292;9454;9488.430694158373;9719.708408747749;401360.8639136063;405302;409336;413640;413766;65991;80617;81097.13120285449;83282.58358708168;83452.58273708592;849.2569002123142;870.9433886797465;873.3973558244791;873.7553485024204;876.2332958661171;14547.127172369692;14637.121772693672;14706.117632942058;14883.85116148868;15043.323050462537;36660.633393665725;37157;37241.25517489581;37308.81345593255;37632.43551346677;48659.75670121627;49045.50954490552;49400.752996236224;49432;50045.74977125237;7446.404287657083;7477.738279160203;7481.364084052916;7498.775036748906;7518.624068796647;10112.241581881535;11629.476673549541;11738.178327516991;11844.111691623335;12260.570880019513;10127.18982481385;10355.43045132525;10392.688219353431;10496.737581560523;10516.684499464722;9640.276979226726;10061.949690251795;10271.126954208677;10379.636712715019;10506.527206275889;10286.897131028594;10460.58157673715;10612.097971672494;10687.893121069;10746.570137194425;7282.563046217244;7338.889916651361;7416.295451932274;7505.887411688938;7521.285477879593;9173.541322933694;9734.269929755155;10005.499725013866;10460.738481538023;10524.894751052698 06:57:43 INFO - PROCESS | 3180 | |3;mootools.html;1083.8753543342518;1111.5387114347545;1113.6770336602385;1183.0771997841682;1287.246960528091;6492.156019717436;7066.540674856131;7269.3457588817;7297.598632075234;7313.085864266966;7281.526700764447;7325.743598974037;7339.155997060339;7342.926570734291;7374.930635057914;1901.5816520365531;1915.9425217243504;1923;1924.4034349351746;1926.566522532426;1872.4850666066804;1900.3633782682818;1908.7709474863036;1922.192679074785;1923.8653294269407;1908.5896532245565;1911.3596945023435;1927.7012063130167;1928.2961718972615;1930.7683078030586;1876.3620369074513;1904.3905950095975;1909.3699079303797;1914.5692219250695;1915.5977244778612;1842.1986435900426;1868.5889104397147;1870.1677753399742;1882.3788149910497;1884.6984482482737;6830.658467076676;6924.688389022506;6943.965280173617;6945.930540694579;7180.389666878322;4294.978525107385;4469.620082293009;4484.910301793979;4487.439070116236;4499.865004049851;2684.7315268473194;2840.588114723374;2874.3532705141174;2889.6387951506063;2890.898818541341;891.1845661219976;913.7806926337697;913.9223166030895;922.7047344849651;922.7231830450838;9831.754206144831;9948.751281217956;9949.90050099497;9954.850677239847;9964.800703985953;3708.573514045919;3748.3253014457114;3764.7176461765475;3837.213371258885;3993.3011722948368;7703.268189521987;7728.7681369559;7766.534007959541;7793.844123117506;7796;4428.357888106271;4433.091216300651;4434.201843668171;4439.356293337448;4443.488998765119;3566.465030245484;3660.7803531788177;4197.412362269285;4197.685173611992;4202.991282092337;2728.249731323902;2892.942141157207;2902.3469719312984;2925.5372313843077;2926.326944802707;855.4268640011207;856.8543347630917;875.2210532625968;877.3814460805118;888.3781353052889;731.5500966905421;733.8605664923648;734.889766535024;740.4187712645655;763.2482005224849;4477.3221690669325;4536.931946020813;4595.149897268949;4676.742779147179;4926.6551341406475;362.42374624347417;365.174705166326;369.8594534077087;372.13293027246453;374.32994939059324;3027.3642535067884;3143.811371317728;3203.4073696366245;3263.396271689745;3303.2072302647193;8629.52537610425;9014.18872301496;9175;9289.62841486333;9313.394629349206;8873;9112.589933453011;9118.81762364749;9132.771680708036;9138.63445462174;6595.73617055322;6616.4376028037195;6773.966130169318;6860.735957134134;6892.379685828299;4566.88582785433;4581.977090114528;4606.30905364198;4676.275177347517;4717.787699553597;8305.086440491661;8344.456275589035;8368.163183681583;8375;8440.915590844259;8494.405391622528;8514.361422893184;8606.870896936425;8616.956915215384;8653.30773538128;5925.674087925206;6093.958523894545;6102.664353460602;6306.842328941813;6338.112664227104;7116.537425067354;7169.713211471482;7182.209956904632;7205.459590530626;7212.963935180291;6345.270293916259;6371.585846919936;6402.583832050902;6437.613743175424;6561.80314590563;6319.652419116993;6340.270868849957;6370.17187765606;6371.808845734636;6392.872142557216;5612.298462692163;5623.268975033219;5694.686792226467;5720.856978575569;5758.884822303614;4008.719389642697;4056.513218413691;4119.711620186558;4146.3365861462025;4174.123434078878;4106.404571337199;4113.943028485757;4179.937300940427;4244.363345498076;4311.353297005348 06:57:43 INFO - PROCESS | 3180 | |4;prototype.html;266.97997650176234;273.7426818790337;274.7019483860011;281.8711062195908;284.53478562550237;5210.921836172461;5284.83733578613;5294.920576191355;5295.62930594859;5296.8146114885985;5168.2764412982115;5213.218017297398;5235;5240.318758561391;5249.606279529032;3739.756915800478;3820.8853734388013;3836.5971572984854;3873.5351757788962;3886.125621735115;3838.846446142151;3899.4345819856103;3919.962029427188;3998.2403343364667;4002.899927501807;3903.6727512645693;3905.140869008828;3921.9215615687667;3930.78380689062;3941.3890846918775;3814.599467055947;3905.4141878718137;3915.256101340736;3942.80285985701;3945.4870866787132;3376.1728376547658;3396.8111161093666;3412.744044196695;3416.8633254669785;3437.295354452331;5107.982346972962;5142.254373115878;5146.614003949681;5147.2279158126585;5158.509941555546;4384.276594361926;4561.863144105682;4601.746903920283;4602.516735742733;4602.907941841145;5426;5434.64674796137;5436.456354364572;5454.91817622732;5459.535939445152;3722.516072910504;3731.8320675569666;3740.495033170542;3758.68051215647;3767.5102236709326;5439.347278326587;5724.084146536534;5746.741396637161;5767.971160144214;5768.375389197905;3670.963290367062;3725.8509659613856;3733.570639376452;3742.9064273392837;3743.419769935664;3804.923901521954;3810.7523011004196;3811.313963486544;3827.1771569112216;3841.7887016213817;4472.2620767573635;4491.371208030879;4512.81948722054;4528.479224889114;4534.410526631583;5199.610029247821;5463.890722185534;5480.835574932758;5494.203340515603;5558.6942718150085;1296.3453456004656;1316.4470922212693;1322.2000689582665;1326.5091915991145;1327.9136856104321;789.8025493626593;808.9604857757753;810.687885164216;810.6947814019424;819.2790344496924;5053.898922021539;5158.174692049254;5165.586753059746;5175.767090480937;5179.378474583074;5565.6920623653405;5589.981410038534;5601.527053227025;5670.716464176857;5713;5158.948410515922;5261.894762104736;5263.368395792453;5272.604554658416;5274.26160337553;2967.299757220962;2973.8215707057648;3029.909102726922;3034.1656044587917;3039.787214894936;5746.798862039808;5758.62568933018;5759.9136012959;5761.654300741969;5774.364819869811;5497.752601132958;5752.3097228332035;5752.913706294409;5755.194272801811;5781.82654520365;5734.6845923473775;5737.770489180386;5744.482996530249;5748.540116790647;5767.22142510764;5373.328333958255;5659.858503537444;5664.971675141598;5668.688222147822;5685.744141513725;5559.833205003856;5588.6646801192055;5618.634788738719;5622.2128901954575;5624.493795558255;5799.971000144972;5800.796972105956;5807.128930660435;5807.767689292381;5809.82570522885;3774.8490060397276;3831.5248629278485;3881.6118388160958;3889.144388234584;3893.8247778849454;5630.0991841305195;5645.769920881311;5648.774049038157;5665.150227465913;5694.544436444991;5496.450354964471;5505.944940550704;5510.366307874646;5526.972365138148;5551.22282880389;5303.15149576066;5460.754266058117;5503.394626590992;5508.55931525469;5537.8061767837935;5384.957499013045;5406.189071639285;5417.214503896992;5420.186971954238;5422.376426710821;5310.734463276898;5338.4394638563945;5466.644668096561;5471.699056551769;5534.695591742493;4986.6010719143105;5490.6980116094;5511.291499635126;5521.3926468087675;5529.889402212014 06:57:43 INFO - PROCESS | 3180 | |5;yui.html;605.3280858247346;611.4313688269907;617.2253821454075;623.6289407802359;629.3800606402692;13157.67105822355;13628.795568066475;14077.648058798535;14227.430902763903;14246.857531424683;12618.495260189604;12703.428345724442;12930.870691293085;12939.90010849079;12962.222266664006;608.1668114682891;635.3297271378693;635.5932203389834;635.6694518850195;637.3499030988389;534.3881255961921;548.5090843694891;614.183136428549;631.1668597451365;635.1711017122653;666.5367569539172;668.585477004258;670.0920253057111;670.5674839728372;671.3622059043903;662.8077857421342;666.7366390275814;667.1227336053074;667.4860357524703;667.5293917787972;409.1285561753446;414.7905307819562;479.8944232268895;486.9975650121727;489.8750818541285;12624.368781560977;12800.359982000862;12830.871691283155;12854.228746275254;12856.55002074923;11274.098072154207;12112.939435302855;12223.633291001284;12307.138500304982;12643.431045602878;11350.659480215607;11764.941175294069;11779.88220117805;12084.335361555111;12215.656277809434;4150.377443383486;4196.790160491963;4223.049813791903;4321.6326612238;4326.58897404746;55702.72148639231;56155.71922140404;56915;57000.999999999585;57040.42959570434;9451;9697.6605818796;9753.658621948198;9785.853212201822;9892.55483503244;15873.682526349408;16125.919370403308;16213.837861621469;16253.431129910396;16283.185840707918;7134.643267836691;7152.213256541881;7195.316444937723;7272.163701174327;7369.4472914531625;4060.37064255035;4078;4090.754554726726;4104;4209.116085622054;2397.604395274795;2466.3834041489627;2468.1114798672465;2469.1728271029046;2471.394508345467;513.7842106315281;530.1967519208403;539.7598068859398;540.0980362794144;541.7643325153571;555.4112640600976;591.860668213687;642.7043559962376;651.6285717141184;662.7845950066247;8868;8883;9136.177744003071;9192.586333615003;9204.95397523008;576.7260551238128;608.1455554945309;656.1568384625733;669.7153709673466;674;4348.760818154969;4404.96483326418;4486.484054333728;4491.685582009293;4512.954870451319;65057.67471162614;66668;67059.66470167619;68030;68605.31394686089;50387.24419133716;50769;57832.421675783546;60001;61563.384366156664;54116;54429.183562246595;54568.181477277874;54844;55062.17406738902;8060.637271322687;8422.578871056545;8426.915730842613;8490.702825401082;8590.699325523577;35614.465783012754;35962.46056309105;36360.45459318059;37848.05379865525;38151.618483814804;47369.28946065743;50623;50979;51621;53654.46345536651;11026.669199924016;11375.089992800722;11576;11632.767344653228;11665.300081995107;12585.43365548571;13327.466901323838;13568.796468053184;13789.724205515633;14240.287985600886;12586.559470418491;12781;12781.360931953179;12860;12880.742385152433;9986.900130998887;11341.501571897275;12044.51821927113;12609.93695031519;13321.400536975665;11835.822462662894;12025;12068.698282543006;12223.877761222275;12571.497140114294;10170.745731356776;10221.43782091992;10374.533146008296;10376.584936602452;11015.83476247841;10774.892251077388;10871.25129265778;10911.345319280868;11037.503312350804;11052.834207486734 06:57:43 INFO - PROCESS | 3180 | __end_tp_report 06:57:43 INFO - PROCESS | 3180 | __start_cc_report 06:57:43 INFO - PROCESS | 3180 | _x_x_mozilla_cycle_collect,1336 06:57:43 INFO - PROCESS | 3180 | __end_cc_report 06:57:43 INFO - PROCESS | 3180 | __startTimestamp1477922263868__endTimestamp 06:57:43 INFO - PROCESS | 3180 | 06:57:43 INFO - PROCESS | 3180 | ------- Summary: start ------- 06:57:43 INFO - PROCESS | 3180 | Number of tests: 6 06:57:43 INFO - PROCESS | 3180 | 06:57:43 INFO - PROCESS | 3180 | [#0] dojo.html Cycles:165 Average:5059.02 Median:5358.71 stddev:761.68 (14.2%) stddev-sans-first:744.03 06:57:43 INFO - PROCESS | 3180 | Values: 2849.5 2873.1 2888.0 2889.7 2907.4 5016.9 5050.6 5065.0 5118.2 5198.6 5045.9 5162.9 5177.9 5235.0 5310.5 4570.0 4611.8 4638.4 4654.0 4734.5 4614.6 4661.2 4681.0 4702.8 4714.6 351.9 4703.6 4707.7 4743.1 4749.6 4655.3 4682.3 4703.0 4707.1 4708.2 4581.4 4634.2 4646.1 4649.7 4654.8 5110.1 5136.5 5198.2 5222.0 5280.4 5572.7 5574.5 5586.2 5588.5 5588.6 5578.1 5586.9 5611.7 5612.7 5619.9 5167.5 5168.6 5171.2 5176.7 5178.3 5679.1 5724.3 5725.7 5726.9 5730.1 5407.5 5429.0 5438.5 5439.3 5453.2 5479.0 5554.2 5554.9 5556.3 5557.7 5335.7 5455.5 5462.8 5464.3 5469.9 5464.8 5464.9 5473.8 5476.9 5543.4 3757.1 3775.6 3777.8 3818.5 3823.7 3243.9 3244.5 3246.0 3298.6 3361.4 5059.8 5064.3 5099.6 5126.2 5165.9 5609.8 5614.2 5622.3 5624.6 5688.3 4908.7 5070.7 5086.6 5158.6 5168.3 4438.4 4453.5 4470.4 4521.8 4530.6 5630.2 5635.1 5635.6 5649.4 5706.1 5505.8 5546.9 5563.1 5576.3 5577.2 5591.9 5642.2 5649.4 5671.1 5739.5 5443.9 5454.2 5454.3 5455.2 5494.3 5560.5 5566.8 5569.1 5571.8 5647.6 5303.5 5307.2 5358.7 5377.8 5411.7 5359.5 5359.7 5404.6 5412.5 5463.3 5251.4 5304.0 5309.9 5315.8 5367.7 5373.8 5385.3 5401.1 5401.4 5419.0 5387.5 5394.5 5396.3 5403.0 5454.8 06:57:43 INFO - PROCESS | 3180 | 06:57:43 INFO - PROCESS | 3180 | [#1] ext.html Cycles:180 Average:47551.35 Median:35401.29 stddev:94946.49 (268.2%) stddev-sans-first:95147.25 06:57:43 INFO - PROCESS | 3180 | Values: 549.3 560.2 564.9 569.6 569.9 27794.7 29862.4 29874.4 29915.0 36107.5 34632.5 38049.0 38136.2 38148.8 38196.8 8204.6 8335.5 8338.4 8347.5 8348.4 8342.0 8385.1 8388.7 8423.3 8434.5 8398.2 8447.5 8451.6 8456.1 8458.0 8404.5 8412.4 8456.1 8462.2 8465.1 8126.1 8194.7 8197.5 8202.0 8205.4 35373.3 35429.3 35741.0 35752.6 35878.5 2982.4 3452.6 3481.9 3607.2 3705.3 27999.4 28295.0 28612.3 29211.1 29453.3 3898.0 3898.9 3949.8 3994.3 4132.7 292583.0 292834.0 292863.0 293108.0 293336.0 28690.6 29562.3 45232.5 45636.0 45724.8 30360.0 30653.5 30689.2 30728.2 30791.1 10791.6 10802.4 10832.5 10918.1 10925.1 9587.6 9603.7 9658.3 9700.4 9718.2 7118.6 7160.2 7218.8 7219.6 7224.4 2847.9 2887.4 2888.0 2911.5 2919.4 851.6 855.3 856.5 867.9 919.0 26979.5 27108.9 27273.9 27886.4 28027.0 740.4 907.6 937.2 943.8 979.1 13576.9 13908.9 13925.4 14099.9 14210.8 429710.1 431630.0 433971.0 434173.0 435564.0 42383.6 42976.4 45543.0 45751.1 45865.8 1049.5 1065.2 1107.1 1129.3 1154.1 25333.0 26910.5 27608.9 27698.2 27734.3 39774.2 40050.2 40163.4 40175.4 40182.2 330618.0 331942.0 333972.0 334884.0 335927.0 23691.8 24046.8 24645.1 24706.5 25773.4 38262.6 38375.6 38682.0 38714.0 38849.4 32523.2 32753.7 32920.5 33334.5 33337.3 32904.3 33075.8 33133.8 33225.5 33313.5 31597.5 31795.8 31800.8 31932.5 32054.5 28365.6 29751.9 30052.8 30182.4 30320.1 22596.2 23179.2 23452.8 23479.3 23519.3 06:57:43 INFO - PROCESS | 3180 | 06:57:43 INFO - PROCESS | 3180 | [#2] jquery.html Cycles:180 Average:24642.29 Median:209190.93 stddev:67554.38 (32.3%) stddev-sans-first:67719.19 06:57:43 INFO - PROCESS | 3180 | Values: 313.2 333.7 338.3 339.1 352.7 13179.0 13773.4 14296.2 16130.8 17442.4 14141.9 14317.4 14624.7 14906.4 15063.7 4615.9 4783.0 4791.4 4801.9 4806.7 3567.1 3764.2 4866.8 5094.5 5098.1 5145.2 5160.0 5164.3 5173.7 5175.5 5118.8 5737.6 5738.8 5751.3 5754.4 4986.0 5053.4 5054.9 5057.4 5059.5 11061.8 16108.1 19088.6 19896.8 19906.0 1884.3 1969.2 2126.7 2328.9 2349.5 8754.0 9106.5 9723.5 11673.9 13371.3 1750.5 1781.9 1782.7 1797.5 1806.9 72990.3 73234.3 73335.6 75393.0 75714.6 9095.5 9267.1 9335.3 9533.2 9701.6 12708.1 12733.2 12741.6 12761.5 12774.0 6638.3 6751.6 6857.6 6857.7 6860.1 6411.7 6418.5 6426.6 6508.9 6525.4 4045.8 4055.6 4063.2 4100.7 4124.9 1683.3 1696.5 1738.1 1761.9 1764.3 803.9 825.4 826.9 850.7 855.9 16561.8 16600.7 16839.2 16869.4 17336.1 808.5 814.4 818.0 821.0 832.0 9185.4 9446.5 9454.0 9488.4 9719.7 401360.9 405302.0 409336.0 413640.0 413766.0 65991.0 80617.0 81097.1 83282.6 83452.6 849.3 870.9 873.4 873.8 876.2 14547.1 14637.1 14706.1 14883.9 15043.3 36660.6 37157.0 37241.3 37308.8 37632.4 48659.8 49045.5 49400.8 49432.0 50045.7 7446.4 7477.7 7481.4 7498.8 7518.6 10112.2 11629.5 11738.2 11844.1 12260.6 10127.2 10355.4 10392.7 10496.7 10516.7 9640.3 10061.9 10271.1 10379.6 10506.5 10286.9 10460.6 10612.1 10687.9 10746.6 7282.6 7338.9 7416.3 7505.9 7521.3 9173.5 9734.3 10005.5 10460.7 10524.9 06:57:43 INFO - PROCESS | 3180 | 06:57:43 INFO - PROCESS | 3180 | [#3] mootools.html Cycles:180 Average:4705.85 Median:5617.78 stddev:2731.59 (48.6%) stddev-sans-first:2725.69 06:57:43 INFO - PROCESS | 3180 | Values: 1083.9 1111.5 1113.7 1183.1 1287.2 6492.2 7066.5 7269.3 7297.6 7313.1 7281.5 7325.7 7339.2 7342.9 7374.9 1901.6 1915.9 1923.0 1924.4 1926.6 1872.5 1900.4 1908.8 1922.2 1923.9 1908.6 1911.4 1927.7 1928.3 1930.8 1876.4 1904.4 1909.4 1914.6 1915.6 1842.2 1868.6 1870.2 1882.4 1884.7 6830.7 6924.7 6944.0 6945.9 7180.4 4295.0 4469.6 4484.9 4487.4 4499.9 2684.7 2840.6 2874.4 2889.6 2890.9 891.2 913.8 913.9 922.7 922.7 9831.8 9948.8 9949.9 9954.9 9964.8 3708.6 3748.3 3764.7 3837.2 3993.3 7703.3 7728.8 7766.5 7793.8 7796.0 4428.4 4433.1 4434.2 4439.4 4443.5 3566.5 3660.8 4197.4 4197.7 4203.0 2728.2 2892.9 2902.3 2925.5 2926.3 855.4 856.9 875.2 877.4 888.4 731.6 733.9 734.9 740.4 763.2 4477.3 4536.9 4595.1 4676.7 4926.7 362.4 365.2 369.9 372.1 374.3 3027.4 3143.8 3203.4 3263.4 3303.2 8629.5 9014.2 9175.0 9289.6 9313.4 8873.0 9112.6 9118.8 9132.8 9138.6 6595.7 6616.4 6774.0 6860.7 6892.4 4566.9 4582.0 4606.3 4676.3 4717.8 8305.1 8344.5 8368.2 8375.0 8440.9 8494.4 8514.4 8606.9 8617.0 8653.3 5925.7 6094.0 6102.7 6306.8 6338.1 7116.5 7169.7 7182.2 7205.5 7213.0 6345.3 6371.6 6402.6 6437.6 6561.8 6319.7 6340.3 6370.2 6371.8 6392.9 5612.3 5623.3 5694.7 5720.9 5758.9 4008.7 4056.5 4119.7 4146.3 4174.1 4106.4 4113.9 4179.9 4244.4 4311.4 06:57:43 INFO - PROCESS | 3180 | 06:57:43 INFO - PROCESS | 3180 | [#4] prototype.html Cycles:180 Average:4554.20 Median:5267.99 stddev:1399.34 (26.6%) stddev-sans-first:1365.77 06:57:43 INFO - PROCESS | 3180 | Values: 267.0 273.7 274.7 281.9 284.5 5210.9 5284.8 5294.9 5295.6 5296.8 5168.3 5213.2 5235.0 5240.3 5249.6 3739.8 3820.9 3836.6 3873.5 3886.1 3838.8 3899.4 3920.0 3998.2 4002.9 3903.7 3905.1 3921.9 3930.8 3941.4 3814.6 3905.4 3915.3 3942.8 3945.5 3376.2 3396.8 3412.7 3416.9 3437.3 5108.0 5142.3 5146.6 5147.2 5158.5 4384.3 4561.9 4601.7 4602.5 4602.9 5426.0 5434.6 5436.5 5454.9 5459.5 3722.5 3731.8 3740.5 3758.7 3767.5 5439.3 5724.1 5746.7 5768.0 5768.4 3671.0 3725.9 3733.6 3742.9 3743.4 3804.9 3810.8 3811.3 3827.2 3841.8 4472.3 4491.4 4512.8 4528.5 4534.4 5199.6 5463.9 5480.8 5494.2 5558.7 1296.3 1316.4 1322.2 1326.5 1327.9 789.8 809.0 810.7 810.7 819.3 5053.9 5158.2 5165.6 5175.8 5179.4 5565.7 5590.0 5601.5 5670.7 5713.0 5158.9 5261.9 5263.4 5272.6 5274.3 2967.3 2973.8 3029.9 3034.2 3039.8 5746.8 5758.6 5759.9 5761.7 5774.4 5497.8 5752.3 5752.9 5755.2 5781.8 5734.7 5737.8 5744.5 5748.5 5767.2 5373.3 5659.9 5665.0 5668.7 5685.7 5559.8 5588.7 5618.6 5622.2 5624.5 5800.0 5800.8 5807.1 5807.8 5809.8 3774.8 3831.5 3881.6 3889.1 3893.8 5630.1 5645.8 5648.8 5665.2 5694.5 5496.5 5505.9 5510.4 5527.0 5551.2 5303.2 5460.8 5503.4 5508.6 5537.8 5385.0 5406.2 5417.2 5420.2 5422.4 5310.7 5338.4 5466.6 5471.7 5534.7 4986.6 5490.7 5511.3 5521.4 5529.9 06:57:43 INFO - PROCESS | 3180 | 06:57:43 INFO - PROCESS | 3180 | [#5] yui.html Cycles:180 Average:14993.60 Median:25941.12 stddev:18408.48 (71.0%) stddev-sans-first:18428.41 06:57:43 INFO - PROCESS | 3180 | Values: 605.3 611.4 617.2 623.6 629.4 13157.7 13628.8 14077.6 14227.4 14246.9 12618.5 12703.4 12930.9 12939.9 12962.2 608.2 635.3 635.6 635.7 637.3 534.4 548.5 614.2 631.2 635.2 666.5 668.6 670.1 670.6 671.4 662.8 666.7 667.1 667.5 667.5 409.1 414.8 479.9 487.0 489.9 12624.4 12800.4 12830.9 12854.2 12856.6 11274.1 12112.9 12223.6 12307.1 12643.4 11350.7 11764.9 11779.9 12084.3 12215.7 4150.4 4196.8 4223.0 4321.6 4326.6 55702.7 56155.7 56915.0 57001.0 57040.4 9451.0 9697.7 9753.7 9785.9 9892.6 15873.7 16125.9 16213.8 16253.4 16283.2 7134.6 7152.2 7195.3 7272.2 7369.4 4060.4 4078.0 4090.8 4104.0 4209.1 2397.6 2466.4 2468.1 2469.2 2471.4 513.8 530.2 539.8 540.1 541.8 555.4 591.9 642.7 651.6 662.8 8868.0 8883.0 9136.2 9192.6 9205.0 576.7 608.1 656.2 669.7 674.0 4348.8 4405.0 4486.5 4491.7 4513.0 65057.7 66668.0 67059.7 68030.0 68605.3 50387.2 50769.0 57832.4 60001.0 61563.4 54116.0 54429.2 54568.2 54844.0 55062.2 8060.6 8422.6 8426.9 8490.7 8590.7 35614.5 35962.5 36360.5 37848.1 38151.6 47369.3 50623.0 50979.0 51621.0 53654.5 11026.7 11375.1 11576.0 11632.8 11665.3 12585.4 13327.5 13568.8 13789.7 14240.3 12586.6 12781.0 12781.4 12860.0 12880.7 9986.9 11341.5 12044.5 12609.9 13321.4 11835.8 12025.0 12068.7 12223.9 12571.5 10170.7 10221.4 10374.5 10376.6 11015.8 10774.9 10871.3 10911.3 11037.5 11052.8 06:57:43 INFO - PROCESS | 3180 | -------- Summary: end -------- 06:57:43 INFO - PROCESS | 3180 | 06:57:44 INFO - TEST-INFO | 3180: exit 0 06:57:45 INFO - TEST-OK | dromaeo_css | took 1121962ms 06:57:45 INFO - TEST-START | kraken 06:57:45 INFO - operating with platform_type : w8_ 06:57:45 INFO - Initialising browser for kraken test... 06:57:45 INFO - TEST-INFO | started process 3740 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmp2sbqc6\profile http://localhost:49277/getInfo.html) 06:57:50 INFO - PROCESS | 3740 | __metrics Screen width/height:1600/1200 06:57:50 INFO - PROCESS | 3740 | colorDepth:24 06:57:50 INFO - PROCESS | 3740 | Browser inner width/height: 1010/674 06:57:50 INFO - PROCESS | 3740 | __metrics 06:57:51 INFO - PROCESS | 3740 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:57:51 INFO - PROCESS | 3740 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:57:51 INFO - PROCESS | 3740 | console.error: 06:57:51 INFO - PROCESS | 3740 | Message: Error: Connection closed before committing the transaction. 06:57:51 INFO - PROCESS | 3740 | Stack: 06:57:51 INFO - PROCESS | 3740 | ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:937:23 06:57:51 INFO - PROCESS | 3740 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7 06:57:51 INFO - PROCESS | 3740 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11 06:57:51 INFO - PROCESS | 3740 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7 06:57:51 INFO - PROCESS | 3740 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:714:7 06:57:51 INFO - PROCESS | 3740 | TaskImpl_run@resource://gre/modules/Task.jsm:327:15 06:57:51 INFO - PROCESS | 3740 | Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:551:9 06:57:51 INFO - PROCESS | 3740 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15 06:57:51 INFO - PROCESS | 3740 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:388:5 06:57:51 INFO - PROCESS | 3740 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29 06:57:51 INFO - PROCESS | 3740 | Barrier/this.client.addBlocker/promise13.3% 06:58:49 INFO - TinderboxPrint: I/O read bytes / time
189,156,352 / 1,748,240 06:58:49 INFO - TinderboxPrint: I/O write bytes / time
409,079,296 / 3,515,130 06:58:49 INFO - TinderboxPrint: CPU idle
8,251.8 (86.6%) 06:58:49 INFO - TinderboxPrint: CPU user
1,224.1 (12.9%) 06:58:49 INFO - install - Wall time: 3s; CPU: 12.0%; Read bytes: 0; Write bytes: 38839808; Read time: 0; Write time: 72870 06:58:49 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 189156352; Write bytes: 323741696; Read time: 1748240; Write time: 3405860 06:58:49 INFO - Running post-run listener: _upload_blobber_files 06:58:49 INFO - Blob upload gear active. 06:58:49 INFO - Preparing to upload files from C:\slave\test\build\blobber_upload_dir. 06:58:49 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 06:58:49 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'] 06:58:49 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 06:58:50 INFO - (blobuploader) - INFO - Open directory for files ... 06:58:50 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_errorsummary.log ... 06:58:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:58:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:58:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:58:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:58:50 INFO - (blobuploader) - INFO - Done attempting. 06:58:50 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_raw.log ... 06:58:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:58:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:58:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:58:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:58:51 INFO - (blobuploader) - INFO - Done attempting. 06:58:51 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\resource-usage.json ... 06:58:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:58:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:58:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:58:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:58:54 INFO - (blobuploader) - INFO - Done attempting. 06:58:54 INFO - (blobuploader) - INFO - Iteration through files over. 06:58:54 INFO - Return code: 0 06:58:54 INFO - rmtree: C:\slave\test\build\uploaded_files.json 06:58:54 INFO - Using _rmtree_windows ... 06:58:54 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build\\uploaded_files.json',), kwargs: {}, attempt #1 06:58:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/65de8c73e776fc090b3553d833e8d5878ebca3eb19b212ed7c4b17fb012e02a848294c043f723c69ea869eff8e9da1657e85781cb00ec2e77c7e541bd41c79b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a451bff2f6833af836df0da0c155c279d80671c9832b6ac83f128acfe15a82499b14a10ef7e828f3fea227d495cc0ddcd43bd74d73db0ee9f531ef8ba5a6eed0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/643dba1433e355a39b794d7365e5cd1f23e4843624d0d9bba2887df62d03e120e0b7ac34fdada38e5fc03405f8aa6e83c08ae6d36ab143026bff88883fc7ec0f"} 06:58:54 INFO - Writing buildbot properties ['blobber_files'] to C:\slave\test\properties\blobber_files 06:58:54 INFO - Writing to file C:\slave\test\properties\blobber_files 06:58:54 INFO - Contents: 06:58:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/65de8c73e776fc090b3553d833e8d5878ebca3eb19b212ed7c4b17fb012e02a848294c043f723c69ea869eff8e9da1657e85781cb00ec2e77c7e541bd41c79b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a451bff2f6833af836df0da0c155c279d80671c9832b6ac83f128acfe15a82499b14a10ef7e828f3fea227d495cc0ddcd43bd74d73db0ee9f531ef8ba5a6eed0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/643dba1433e355a39b794d7365e5cd1f23e4843624d0d9bba2887df62d03e120e0b7ac34fdada38e5fc03405f8aa6e83c08ae6d36ab143026bff88883fc7ec0f"} 06:58:54 INFO - Running post-run listener: copy_logs_to_upload_dir 06:58:54 INFO - Copying logs to upload dir... 06:58:54 INFO - mkdir: C:\slave\test\build\upload\logs 06:58:54 INFO - Copying logs to upload dir... 06:58:54 INFO - Using _rmtree_windows ... 06:58:54 INFO - Using _rmtree_windows ... 06:58:54 INFO - Using _rmtree_windows ... 06:58:54 INFO - Using _rmtree_windows ... 06:58:54 INFO - Using _rmtree_windows ... 06:58:54 INFO - Using _rmtree_windows ... 06:58:54 INFO - Using _rmtree_windows ... program finished with exit code 0 elapsedTime=1428.907000 ========= master_lag: 2.42 ========= ========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 51 secs) (at 2016-10-31 06:58:56.469421) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 06:58:56.470155) ========= '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-150\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-150 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-150 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-150\AppData\Local LOGONSERVER=\\T-W864-IX-150 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-150 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-150 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-150 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/65de8c73e776fc090b3553d833e8d5878ebca3eb19b212ed7c4b17fb012e02a848294c043f723c69ea869eff8e9da1657e85781cb00ec2e77c7e541bd41c79b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a451bff2f6833af836df0da0c155c279d80671c9832b6ac83f128acfe15a82499b14a10ef7e828f3fea227d495cc0ddcd43bd74d73db0ee9f531ef8ba5a6eed0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/643dba1433e355a39b794d7365e5cd1f23e4843624d0d9bba2887df62d03e120e0b7ac34fdada38e5fc03405f8aa6e83c08ae6d36ab143026bff88883fc7ec0f"} build_url:https://queue.taskcluster.net/v1/task/JGsltOo7S6m30Sg4kcAseg/artifacts/public/build/firefox-52.0a1.en-US.win64.zip program finished with exit code 0 elapsedTime=0.102000 build_url: 'https://queue.taskcluster.net/v1/task/JGsltOo7S6m30Sg4kcAseg/artifacts/public/build/firefox-52.0a1.en-US.win64.zip' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/65de8c73e776fc090b3553d833e8d5878ebca3eb19b212ed7c4b17fb012e02a848294c043f723c69ea869eff8e9da1657e85781cb00ec2e77c7e541bd41c79b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a451bff2f6833af836df0da0c155c279d80671c9832b6ac83f128acfe15a82499b14a10ef7e828f3fea227d495cc0ddcd43bd74d73db0ee9f531ef8ba5a6eed0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/643dba1433e355a39b794d7365e5cd1f23e4843624d0d9bba2887df62d03e120e0b7ac34fdada38e5fc03405f8aa6e83c08ae6d36ab143026bff88883fc7ec0f"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 06:58:56.600321) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 06:58:56.600648) ========= '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-150\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-150 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-150 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-150\AppData\Local LOGONSERVER=\\T-W864-IX-150 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-150 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-150 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-150 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=0.100000 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 06:58:56.719949) ========= ========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-10-31 06:58:56.720252) ========= ========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-10-31 06:58:57.151268) ========= ========= Total master_lag: 2.66 =========