builder: autoland_win8_64_test-dromaeojs-pgo
slave: t-w864-ix-023
starttime: 1477287600.71
results: success (0)
buildid: 20161023203915
builduid: 179485a85efa471abcb5e14af3961381
revision: 04c1662be2ba75c56a625799ebaccbe487005941
========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-23 22:40:00.705980) =========
master: http://buildbot-master110.bb.releng.scl3.mozilla.com:8201/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-23 22:40:00.706340) =========
========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-23 22:40:00.706606) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-23 22:40:00.819579) =========
========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-23 22:40:00.819983) =========
'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-023\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-023
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-023
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-023\AppData\Local
LOGONSERVER=\\T-W864-IX-023
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-023
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-023
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-023
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
--22:40:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py
=> `archiver_client.py'
Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102
Connecting to hg.mozilla.org|63.245.215.25|:443... connected.
WARNING: Certificate verification error for hg.mozilla.org: certificate signature failure
HTTP request sent, awaiting response... 200 Script output follows
Length: 12,179 (12K) [text/x-python]
0K .......... . 100% 2.27 GB/s
22:40:01 (2.27 GB/s) - `archiver_client.py' saved [12179/12179]
program finished with exit code 0
elapsedTime=1.031000
========= master_lag: 0.08 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-23 22:40:01.926363) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-10-23 22:40:01.926677) =========
'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-023\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-023
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-023
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-023\AppData\Local
LOGONSERVER=\\T-W864-IX-023
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-023
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-023
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-023
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
program finished with exit code 0
elapsedTime=3.010000
========= master_lag: 0.02 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-10-23 22:40:04.954406) =========
========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-23 22:40:04.954759) =========
'bash' '-c' u'python archiver_client.py mozharness --repo integration/autoland --rev 04c1662be2ba75c56a625799ebaccbe487005941 --destination scripts --debug'
in dir C:\slave\test\. (timeout 1200 secs)
watching logfiles {}
argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 04c1662be2ba75c56a625799ebaccbe487005941 --destination scripts --debug']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld.T-W864-IX-023\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-023
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-023
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-023\AppData\Local
LOGONSERVER=\\T-W864-IX-023
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-023
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-023
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-023
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
2016-10-23 22:40:05,312 truncating revision to first 12 chars
2016-10-23 22:40:05,312 Setting DEBUG logging.
2016-10-23 22:40:05,312 attempt 1/10
2016-10-23 22:40:05,312 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/04c1662be2ba?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2016-10-23 22:40:06,394 unpacking tar archive at: autoland-04c1662be2ba/testing/mozharness/
2016-10-23 22:40:06,586 skipping symlink on windows: configs/single_locale/linux32.py
program finished with exit code 0
elapsedTime=1.796000
========= master_lag: 0.06 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-23 22:40:06.812280) =========
========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-23 22:40:06.812627) =========
script_repo_revision: 04c1662be2ba75c56a625799ebaccbe487005941
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-23 22:40:06.813060) =========
========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-23 22:40:06.813340) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-23 22:40:06.831101) =========
========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 9 secs) (at 2016-10-23 22:40:06.831499) =========
'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'dromaeojs' '--add-option' '--webServer,localhost' '--branch-name' 'Autoland' '--cfg' 'talos/windows_config.py' '--download-symbols' 'ondemand' '--use-talos-json' '--blob-upload-branch' 'Autoland'
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', 'Autoland', '--cfg', 'talos/windows_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld.T-W864-IX-023\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-023
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-023
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-023\AppData\Local
LOGONSERVER=\\T-W864-IX-023
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-023
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-023
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-023
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
22:40:07 INFO - MultiFileLogger online at 20161023 22:40:07 in C:\slave\test
22:40:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland
22:40:07 INFO - Dumping config to C:\slave\test\logs\localconfig.json.
22:40:07 INFO - {'append_to_log': False,
22:40:07 INFO - 'base_work_dir': 'C:\\slave\\test',
22:40:07 INFO - 'blob_upload_branch': 'Autoland',
22:40:07 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt',
22:40:07 INFO - 'branch': 'Autoland',
22:40:07 INFO - 'buildbot_json_path': 'buildprops.json',
22:40:07 INFO - 'config_files': ('talos/windows_config.py',),
22:40:07 INFO - 'default_actions': ('clobber',
22:40:07 INFO - 'read-buildbot-config',
22:40:07 INFO - 'download-and-extract',
22:40:07 INFO - 'populate-webroot',
22:40:07 INFO - 'create-virtualenv',
22:40:07 INFO - 'install',
22:40:07 INFO - 'run-tests'),
22:40:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',),
22:40:07 INFO - 'download_minidump_stackwalk': True,
22:40:07 INFO - 'download_symbols': 'ondemand',
22:40:07 INFO - 'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python',
22:40:07 INFO - 'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'),
22:40:07 INFO - 'hg': 'c:/mozilla-build/hg/hg',
22:40:07 INFO - 'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python',
22:40:07 INFO - 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'),
22:40:07 INFO - 'python': 'c:/mozilla-build/python27/python.exe',
22:40:07 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe',
22:40:07 INFO - 'C:/mozilla-build/tooltool.py'),
22:40:07 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe',
22:40:07 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')},
22:40:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub',
22:40:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'),
22:40:07 INFO - 'installer_path': 'installer.exe',
22:40:07 INFO - 'log_level': 'info',
22:40:07 INFO - 'log_name': 'talos',
22:40:07 INFO - 'log_to_console': True,
22:40:07 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe',
22:40:07 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe',
22:40:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest',
22:40:07 INFO - 'opt_config_files': (),
22:40:07 INFO - 'pip_index': False,
22:40:07 INFO - 'sps_profile': False,
22:40:07 INFO - 'sps_profile_interval': 0,
22:40:07 INFO - 'suite': 'dromaeojs',
22:40:07 INFO - 'system_bits': '32',
22:40:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'),
22:40:07 INFO - 'title': 'T-W864-IX-023',
22:40:07 INFO - 'use_talos_json': True,
22:40:07 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'),
22:40:07 INFO - 'virtualenv_path': 'C:\\slave\\test\\build/venv',
22:40:07 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll',
22:40:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
22:40:07 INFO - 'work_dir': 'build'}
22:40:07 INFO - [mozharness: 2016-10-24 05:40:07.394000Z] Running clobber step.
22:40:07 INFO - Running pre-action listener: _resource_record_pre_action
22:40:07 INFO - Running main action method: clobber
22:40:07 INFO - rmtree: C:\slave\test\build
22:40:07 INFO - Using _rmtree_windows ...
22:40:07 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1
22:41:35 INFO - Running post-action listener: _resource_record_post_action
22:41:35 INFO - [mozharness: 2016-10-24 05:41:35.642000Z] Finished clobber step (success)
22:41:35 INFO - [mozharness: 2016-10-24 05:41:35.642000Z] Running read-buildbot-config step.
22:41:35 INFO - Running pre-action listener: _resource_record_pre_action
22:41:35 INFO - Running main action method: read_buildbot_config
22:41:35 INFO - Using buildbot properties:
22:41:35 INFO - {
22:41:35 INFO - "project": "",
22:41:35 INFO - "product": "firefox",
22:41:35 INFO - "script_repo_revision": "production",
22:41:35 INFO - "builddir": "autoland_win8_64_test-dromaeojs",
22:41:35 INFO - "repository": "",
22:41:35 INFO - "buildername": "Windows 8 64-bit autoland pgo talos dromaeojs",
22:41:35 INFO - "buildid": "20161023203915",
22:41:35 INFO - "pgo_build": "True",
22:41:35 INFO - "basedir": "C:\\slave\\test",
22:41:35 INFO - "buildnumber": 33,
22:41:35 INFO - "slavename": "t-w864-ix-023",
22:41:35 INFO - "master": "http://buildbot-master110.bb.releng.scl3.mozilla.com:8201/",
22:41:35 INFO - "platform": "win8_64",
22:41:35 INFO - "scheduler": "tests-autoland-win64-pgo-talos",
22:41:35 INFO - "branch": "autoland",
22:41:35 INFO - "repo_path": "integration/autoland",
22:41:35 INFO - "revision": "04c1662be2ba75c56a625799ebaccbe487005941",
22:41:35 INFO - "stage_platform": "win64-pgo",
22:41:35 INFO - "builduid": "179485a85efa471abcb5e14af3961381",
22:41:35 INFO - "slavebuilddir": "test"
22:41:35 INFO - }
22:41:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/b1i22o8PSsuKkzCSA29Fkw/artifacts/public/build/firefox-52.0a1.en-US.win64.zip.
22:41:35 INFO - Running post-action listener: _resource_record_post_action
22:41:35 INFO - [mozharness: 2016-10-24 05:41:35.645000Z] Finished read-buildbot-config step (success)
22:41:35 INFO - [mozharness: 2016-10-24 05:41:35.646000Z] Running download-and-extract step.
22:41:35 INFO - Running pre-action listener: _resource_record_pre_action
22:41:35 INFO - Running main action method: download_and_extract
22:41:35 INFO - mkdir: C:\slave\test\build\tests
22:41:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
22:41:35 INFO - trying https://queue.taskcluster.net/v1/task/b1i22o8PSsuKkzCSA29Fkw/artifacts/public/build/firefox-52.0a1.en-US.win64.test_packages.json
22:41:35 INFO - Downloading https://queue.taskcluster.net/v1/task/b1i22o8PSsuKkzCSA29Fkw/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
22:41:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b1i22o8PSsuKkzCSA29Fkw/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
22:41:36 INFO - Downloaded 1218 bytes.
22:41:36 INFO - Reading from file C:\slave\test\build\firefox-52.0a1.en-US.win64.test_packages.json
22:41:36 INFO - Using the following test package requirements:
22:41:36 INFO - {u'common': [u'firefox-52.0a1.en-US.win64.common.tests.zip'],
22:41:36 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.win64.common.tests.zip',
22:41:36 INFO - u'firefox-52.0a1.en-US.win64.cppunittest.tests.zip'],
22:41:36 INFO - u'gtest': [u'firefox-52.0a1.en-US.win64.common.tests.zip'],
22:41:36 INFO - u'jittest': [u'firefox-52.0a1.en-US.win64.common.tests.zip',
22:41:36 INFO - u'jsshell-win64.zip'],
22:41:36 INFO - u'mochitest': [u'firefox-52.0a1.en-US.win64.common.tests.zip',
22:41:36 INFO - u'firefox-52.0a1.en-US.win64.mochitest.tests.zip'],
22:41:36 INFO - u'mozbase': [u'firefox-52.0a1.en-US.win64.common.tests.zip'],
22:41:36 INFO - u'reftest': [u'firefox-52.0a1.en-US.win64.common.tests.zip',
22:41:36 INFO - u'firefox-52.0a1.en-US.win64.reftest.tests.zip'],
22:41:36 INFO - u'talos': [u'firefox-52.0a1.en-US.win64.common.tests.zip',
22:41:36 INFO - u'firefox-52.0a1.en-US.win64.talos.tests.zip'],
22:41:36 INFO - u'web-platform': [u'firefox-52.0a1.en-US.win64.common.tests.zip',
22:41:36 INFO - u'firefox-52.0a1.en-US.win64.web-platform.tests.zip'],
22:41:36 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.win64.common.tests.zip',
22:41:36 INFO - u'firefox-52.0a1.en-US.win64.xpcshell.tests.zip']}
22:41:36 INFO - Downloading packages: [u'firefox-52.0a1.en-US.win64.common.tests.zip'] for test suite category: common
22:41:36 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/b1i22o8PSsuKkzCSA29Fkw/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip
22:41:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b1i22o8PSsuKkzCSA29Fkw/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip'}, attempt #1
22:41:36 INFO - Fetch https://queue.taskcluster.net/v1/task/b1i22o8PSsuKkzCSA29Fkw/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip into memory
22:41:37 INFO - Http code: 200
22:41:37 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront)
22:41:37 INFO - x-amz-cf-id: ViEETVUByzNsgSfUZ5lZCFy2ThLJeRrlLfIoSbwCznot4sNITgAiHg==
22:41:37 INFO - x-amz-version-id: 45bdpHSyywztcRJv33A9uGN4zu6Y1EKO
22:41:37 INFO - Expected file size: 17551799
22:41:37 INFO - Obtained file size: 17551799
22:41:59 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
22:41:59 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/b1i22o8PSsuKkzCSA29Fkw/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip
22:41:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b1i22o8PSsuKkzCSA29Fkw/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip'}, attempt #1
22:41:59 INFO - Fetch https://queue.taskcluster.net/v1/task/b1i22o8PSsuKkzCSA29Fkw/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip into memory
22:41:59 INFO - Http code: 200
22:41:59 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront)
22:41:59 INFO - x-amz-cf-id: Y_qG4xj1MbjxQ0lu8TNrScPmA5E5a1U1DCv4UcpoH-zNAH4ddn9ljA==
22:41:59 INFO - x-amz-version-id: 45bdpHSyywztcRJv33A9uGN4zu6Y1EKO
22:42:00 INFO - Expected file size: 17551799
22:42:00 INFO - Obtained file size: 17551799
22:42:10 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/b1i22o8PSsuKkzCSA29Fkw/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip
22:42:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b1i22o8PSsuKkzCSA29Fkw/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip'}, attempt #1
22:42:10 INFO - Fetch https://queue.taskcluster.net/v1/task/b1i22o8PSsuKkzCSA29Fkw/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip into memory
22:42:11 INFO - Http code: 200
22:42:11 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront)
22:42:11 INFO - x-amz-cf-id: ACmIGnk3_YxCfGSPzKkmwIF4cjriDM46r1WDi0fEfGz1eGSaupTZLw==
22:42:11 INFO - x-amz-version-id: 9Ds1WF9u78xdiA1ghHFBRLnlHbGCu32h
22:42:11 INFO - Expected file size: 14409028
22:42:11 INFO - Obtained file size: 14409028
22:42:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
22:42:21 INFO - trying https://queue.taskcluster.net/v1/task/b1i22o8PSsuKkzCSA29Fkw/artifacts/public/build/firefox-52.0a1.en-US.win64.zip
22:42:21 INFO - Downloading https://queue.taskcluster.net/v1/task/b1i22o8PSsuKkzCSA29Fkw/artifacts/public/build/firefox-52.0a1.en-US.win64.zip to C:\slave\test\build\firefox-52.0a1.en-US.win64.zip
22:42:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b1i22o8PSsuKkzCSA29Fkw/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
22:42:23 INFO - Downloaded 57294948 bytes.
22:42:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b1i22o8PSsuKkzCSA29Fkw/artifacts/public/build/firefox-52.0a1.en-US.win64.zip
22:42:23 INFO - mkdir: C:\slave\test\properties
22:42:23 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url
22:42:23 INFO - Writing to file C:\slave\test\properties\build_url
22:42:23 INFO - Contents:
22:42:23 INFO - build_url:https://queue.taskcluster.net/v1/task/b1i22o8PSsuKkzCSA29Fkw/artifacts/public/build/firefox-52.0a1.en-US.win64.zip
22:42:23 INFO - Running post-action listener: _resource_record_post_action
22:42:23 INFO - Running post-action listener: set_extra_try_arguments
22:42:23 INFO - [mozharness: 2016-10-24 05:42:23.956000Z] Finished download-and-extract step (success)
22:42:23 INFO - [mozharness: 2016-10-24 05:42:23.956000Z] Running populate-webroot step.
22:42:23 INFO - Running pre-action listener: _resource_record_pre_action
22:42:23 INFO - Running main action method: populate_webroot
22:42:23 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']},
22:42:23 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']},
22:42:23 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome',
22:42:23 INFO - u'--tppagecycles',
22:42:23 INFO - u'7'],
22:42:23 INFO - u'tests': [u'tsvgm']}},
22:42:23 INFO - u'suites': {u'chromez': {u'talos_options': [u'--disable-e10s'],
22:42:23 INFO - u'tests': [u'tresize', u'tcanvasmark']},
22:42:23 INFO - u'chromez-e10s': {u'tests': [u'tresize', u'tcanvasmark']},
22:42:23 INFO - u'dromaeojs': {u'talos_options': [u'--disable-e10s'],
22:42:23 INFO - u'tests': [u'dromaeo_css', u'kraken']},
22:42:23 INFO - u'dromaeojs-e10s': {u'tests': [u'dromaeo_css', u'kraken']},
22:42:23 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
22:42:23 INFO - u'talos_options': [u'--disable-e10s'],
22:42:23 INFO - u'tests': [u'tp5o_scroll', u'glterrain']},
22:42:23 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
22:42:23 INFO - u'tests': [u'tp5o_scroll', u'glterrain']},
22:42:23 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
22:42:23 INFO - u'talos_options': [u'--disable-e10s'],
22:42:23 INFO - u'tests': [u'damp', u'tps']},
22:42:23 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
22:42:23 INFO - u'tests': [u'damp', u'tps']},
22:42:23 INFO - u'g3': {u'talos_options': [u'--disable-e10s'],
22:42:23 INFO - u'tests': [u'dromaeo_dom']},
22:42:23 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']},
22:42:23 INFO - u'g4': {u'talos_options': [u'--disable-e10s'],
22:42:23 INFO - u'tests': [u'basic_compositor_video']},
22:42:23 INFO - u'g4-e10s': {u'tests': [u'basic_compositor_video']},
22:42:23 INFO - u'other': {u'talos_options': [u'--disable-e10s'],
22:42:23 INFO - u'tests': [u'a11yr',
22:42:23 INFO - u'ts_paint',
22:42:23 INFO - u'tpaint',
22:42:23 INFO - u'sessionrestore',
22:42:23 INFO - u'sessionrestore_no_auto_restore',
22:42:23 INFO - u'tabpaint']},
22:42:23 INFO - u'other-e10s': {u'tests': [u'a11yr',
22:42:23 INFO - u'ts_paint',
22:42:23 INFO - u'tpaint',
22:42:23 INFO - u'sessionrestore',
22:42:23 INFO - u'sessionrestore_no_auto_restore',
22:42:23 INFO - u'tabpaint']},
22:42:23 INFO - u'other-e10s_l64': {u'tests': [u'a11yr',
22:42:23 INFO - u'ts_paint',
22:42:23 INFO - u'tpaint',
22:42:23 INFO - u'sessionrestore',
22:42:23 INFO - u'sessionrestore_no_auto_restore',
22:42:23 INFO - u'tabpaint']},
22:42:23 INFO - u'other-e10s_nol64': {u'tests': [u'a11yr',
22:42:23 INFO - u'ts_paint',
22:42:23 INFO - u'tpaint',
22:42:23 INFO - u'sessionrestore',
22:42:23 INFO - u'sessionrestore_no_auto_restore',
22:42:23 INFO - u'tabpaint']},
22:42:23 INFO - u'other_l64': {u'talos_options': [u'--disable-e10s'],
22:42:23 INFO - u'tests': [u'a11yr',
22:42:23 INFO - u'ts_paint',
22:42:23 INFO - u'tpaint',
22:42:23 INFO - u'sessionrestore',
22:42:23 INFO - u'sessionrestore_no_auto_restore',
22:42:23 INFO - u'tabpaint']},
22:42:23 INFO - u'other_nol64': {u'talos_options': [u'--disable-e10s'],
22:42:23 INFO - u'tests': [u'a11yr',
22:42:23 INFO - u'ts_paint',
22:42:23 INFO - u'tpaint',
22:42:23 INFO - u'sessionrestore',
22:42:23 INFO - u'sessionrestore_no_auto_restore',
22:42:23 INFO - u'tabpaint']},
22:42:23 INFO - u'svgr': {u'talos_options': [u'--disable-e10s'],
22:42:23 INFO - u'tests': [u'tsvgx',
22:42:23 INFO - u'tsvgr_opacity',
22:42:23 INFO - u'tart',
22:42:23 INFO - u'tscrollx',
22:42:23 INFO - u'cart']},
22:42:23 INFO - u'svgr-e10s': {u'tests': [u'tsvgx',
22:42:23 INFO - u'tsvgr_opacity',
22:42:23 INFO - u'tart',
22:42:23 INFO - u'tscrollx',
22:42:23 INFO - u'cart']},
22:42:23 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
22:42:23 INFO - u'talos_options': [u'--disable-e10s'],
22:42:23 INFO - u'tests': [u'tp5o']},
22:42:23 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
22:42:23 INFO - u'tests': [u'tp5o']},
22:42:23 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
22:42:23 INFO - u'talos_options': [u'--disable-e10s',
22:42:23 INFO - u'--xperf_path',
22:42:23 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
22:42:23 INFO - u'tests': [u'tp5n']},
22:42:23 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
22:42:23 INFO - u'talos_options': [u'--xperf_path',
22:42:23 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
22:42:23 INFO - u'tests': [u'tp5n']}},
22:42:23 INFO - u'talos.zip': {u'path': u'',
22:42:23 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}}
22:42:23 INFO - Running post-action listener: _resource_record_post_action
22:42:23 INFO - [mozharness: 2016-10-24 05:42:23.992000Z] Finished populate-webroot step (success)
22:42:23 INFO - [mozharness: 2016-10-24 05:42:23.992000Z] Running create-virtualenv step.
22:42:23 INFO - Running pre-action listener: _resource_record_pre_action
22:42:23 INFO - Running main action method: create_virtualenv
22:42:23 INFO - Creating virtualenv C:\slave\test\build/venv
22:42:23 INFO - mkdir: C:\slave\test\build\venv\Scripts
22:42:24 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll
22:42:24 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'!
22:42:24 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
22:42:24 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build/venv
22:42:34 INFO - New python executable in C:\slave\test\build/venv\Scripts\python.exe
22:42:37 INFO - Installing distribute......................................................................................................................................................................................done.
22:42:39 INFO - Return code: 0
22:42:39 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', '--version']
22:42:39 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip --version
22:42:39 INFO - Reading from file tmpfile_stdout
22:42:39 INFO - Output received:
22:42:39 INFO - pip 0.8.2 from c:\slave\test\build\venv\lib\site-packages\pip-0.8.2-py2.7.egg (python 2.7)
22:42:39 INFO - Using _rmtree_windows ...
22:42:39 INFO - Using _rmtree_windows ...
22:42:39 INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv
22:42: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')]}
22:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
22:42: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')]}
22:42:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
22:42:39 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0234C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023F3E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024FE688>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0243AE90>, '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 0x01E4A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028DD520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-023', 'USERDOMAIN': 'T-W864-IX-023', '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-023', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-023\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-023', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-023', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-023', '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-023\\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
22:42:39 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in C:\slave\test\build
22:42:39 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5
22:42:39 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
22:42:39 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-023\\AppData\\Roaming',
22:42:39 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
22:42:39 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
22:42:39 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
22:42:39 INFO - 'COMPUTERNAME': 'T-W864-IX-023',
22:42:39 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
22:42:39 INFO - 'DCLOCATION': 'SCL3',
22:42:39 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
22:42:39 INFO - 'FP_NO_HOST_CHECK': 'NO',
22:42:39 INFO - 'HOMEDRIVE': 'C:',
22:42:39 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-023',
22:42:39 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
22:42:39 INFO - 'KTS_VERSION': '1.19c',
22:42:39 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-023\\AppData\\Local',
22:42:39 INFO - 'LOGONSERVER': '\\\\T-W864-IX-023',
22:42:39 INFO - 'MONDIR': 'C:\\Monitor_config\\',
22:42:39 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
22:42:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
22:42:39 INFO - 'MOZ_NO_REMOTE': '1',
22:42:39 INFO - 'NO_EM_RESTART': '1',
22:42:39 INFO - 'NUMBER_OF_PROCESSORS': '8',
22:42:39 INFO - 'OS': 'Windows_NT',
22:42:39 INFO - 'OURDRIVE': 'C:',
22:42: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',
22:42:39 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
22:42:39 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
22:42:39 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
22:42:39 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
22:42:39 INFO - 'PROCESSOR_LEVEL': '6',
22:42:39 INFO - 'PROCESSOR_REVISION': '1e05',
22:42:39 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
22:42:39 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
22:42:39 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
22:42:39 INFO - 'PROGRAMW6432': 'C:\\Program Files',
22:42:39 INFO - 'PROMPT': '$P$G',
22:42:39 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
22:42:39 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
22:42:39 INFO - 'PUBLIC': 'C:\\Users\\Public',
22:42:39 INFO - 'PWD': 'C:\\slave\\test',
22:42:39 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
22:42:39 INFO - 'SLAVEDIR': 'C:\\slave\\',
22:42:39 INFO - 'SYSTEMDRIVE': 'C:',
22:42:39 INFO - 'SYSTEMROOT': 'C:\\windows',
22:42:39 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
22:42:39 INFO - 'TEST1': 'testie',
22:42:39 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
22:42:39 INFO - 'USERDOMAIN': 'T-W864-IX-023',
22:42:39 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-023',
22:42:39 INFO - 'USERNAME': 'cltbld',
22:42:39 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-023',
22:42:39 INFO - 'WINDIR': 'C:\\windows',
22:42:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
22:42:40 INFO - Ignoring indexes: http://pypi.python.org/simple/
22:42:40 INFO - Downloading/unpacking pip>=1.5
22:42:44 INFO - Running setup.py egg_info for package pip
22:42:44 INFO - warning: no files found matching 'pip\cacert.pem'
22:42:44 INFO - warning: no files found matching '*.html' under directory 'docs'
22:42:44 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build'
22:42:44 INFO - no previously-included directories found matching 'docs\_build\_sources'
22:42:44 INFO - Installing collected packages: pip
22:42:44 INFO - Found existing installation: pip 0.8.2
22:42:44 INFO - Uninstalling pip:
22:42:44 INFO - Successfully uninstalled pip
22:42:44 INFO - Running setup.py install for pip
22:42:44 INFO - warning: no files found matching 'pip\cacert.pem'
22:42:44 INFO - warning: no files found matching '*.html' under directory 'docs'
22:42:44 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build'
22:42:44 INFO - no previously-included directories found matching 'docs\_build\_sources'
22:42:44 INFO - Installing pip-script.py script to C:\slave\test\build\venv\Scripts
22:42:44 INFO - Installing pip.exe script to C:\slave\test\build\venv\Scripts
22:42:44 INFO - Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts
22:42:44 INFO - Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts
22:42:44 INFO - Installing pip2-script.py script to C:\slave\test\build\venv\Scripts
22:42:44 INFO - Installing pip2.exe script to C:\slave\test\build\venv\Scripts
22:42:44 INFO - Successfully installed pip
22:42:44 INFO - Cleaning up...
22:42:44 INFO - Return code: 0
22:42:44 INFO - Installing psutil>=3.1.1 into virtualenv C:\slave\test\build/venv
22:42:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
22:42:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
22:42:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
22:42:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
22:42:44 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0234C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023F3E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024FE688>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0243AE90>, '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 0x01E4A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028DD520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-023', 'USERDOMAIN': 'T-W864-IX-023', '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-023', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-023\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-023', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-023', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-023', '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-023\\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
22:42:44 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in C:\slave\test\build
22:42:44 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1
22:42:44 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
22:42:44 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-023\\AppData\\Roaming',
22:42:44 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
22:42:44 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
22:42:44 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
22:42:44 INFO - 'COMPUTERNAME': 'T-W864-IX-023',
22:42:44 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
22:42:44 INFO - 'DCLOCATION': 'SCL3',
22:42:44 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
22:42:44 INFO - 'FP_NO_HOST_CHECK': 'NO',
22:42:44 INFO - 'HOMEDRIVE': 'C:',
22:42:44 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-023',
22:42:44 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
22:42:44 INFO - 'KTS_VERSION': '1.19c',
22:42:44 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-023\\AppData\\Local',
22:42:44 INFO - 'LOGONSERVER': '\\\\T-W864-IX-023',
22:42:44 INFO - 'MONDIR': 'C:\\Monitor_config\\',
22:42:44 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
22:42:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
22:42:44 INFO - 'MOZ_NO_REMOTE': '1',
22:42:44 INFO - 'NO_EM_RESTART': '1',
22:42:44 INFO - 'NUMBER_OF_PROCESSORS': '8',
22:42:44 INFO - 'OS': 'Windows_NT',
22:42:44 INFO - 'OURDRIVE': 'C:',
22:42:44 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
22:42:44 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
22:42:44 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
22:42:44 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
22:42:44 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
22:42:44 INFO - 'PROCESSOR_LEVEL': '6',
22:42:44 INFO - 'PROCESSOR_REVISION': '1e05',
22:42:44 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
22:42:44 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
22:42:44 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
22:42:44 INFO - 'PROGRAMW6432': 'C:\\Program Files',
22:42:44 INFO - 'PROMPT': '$P$G',
22:42:44 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
22:42:44 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
22:42:44 INFO - 'PUBLIC': 'C:\\Users\\Public',
22:42:44 INFO - 'PWD': 'C:\\slave\\test',
22:42:44 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
22:42:44 INFO - 'SLAVEDIR': 'C:\\slave\\',
22:42:44 INFO - 'SYSTEMDRIVE': 'C:',
22:42:44 INFO - 'SYSTEMROOT': 'C:\\windows',
22:42:44 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
22:42:44 INFO - 'TEST1': 'testie',
22:42:44 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
22:42:44 INFO - 'USERDOMAIN': 'T-W864-IX-023',
22:42:44 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-023',
22:42:44 INFO - 'USERNAME': 'cltbld',
22:42:44 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-023',
22:42:44 INFO - 'WINDIR': 'C:\\windows',
22:42:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
22:42:46 INFO - Ignoring indexes: https://pypi.python.org/simple/
22:42:46 INFO - Downloading/unpacking psutil>=3.1.1
22:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
22:42:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
22:42:47 INFO - Installing collected packages: psutil
22:42:47 INFO - Successfully installed psutil
22:42:47 INFO - Cleaning up...
22:42:48 INFO - Return code: 0
22:42:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv C:\slave\test\build/venv
22:42:48 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')]}
22:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
22:42:48 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')]}
22:42:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
22:42:48 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 0x0234C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023F3E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024FE688>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0243AE90>, '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 0x01E4A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028DD520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-023', 'USERDOMAIN': 'T-W864-IX-023', '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-023', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-023\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-023', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-023', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-023', '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-023\\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
22:42:48 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
22:42:48 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
22:42:48 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
22:42:48 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-023\\AppData\\Roaming',
22:42:48 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
22:42:48 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
22:42:48 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
22:42:48 INFO - 'COMPUTERNAME': 'T-W864-IX-023',
22:42:48 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
22:42:48 INFO - 'DCLOCATION': 'SCL3',
22:42:48 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
22:42:48 INFO - 'FP_NO_HOST_CHECK': 'NO',
22:42:48 INFO - 'HOMEDRIVE': 'C:',
22:42:48 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-023',
22:42:48 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
22:42:48 INFO - 'KTS_VERSION': '1.19c',
22:42:48 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-023\\AppData\\Local',
22:42:48 INFO - 'LOGONSERVER': '\\\\T-W864-IX-023',
22:42:48 INFO - 'MONDIR': 'C:\\Monitor_config\\',
22:42:48 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
22:42:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
22:42:48 INFO - 'MOZ_NO_REMOTE': '1',
22:42:48 INFO - 'NO_EM_RESTART': '1',
22:42:48 INFO - 'NUMBER_OF_PROCESSORS': '8',
22:42:48 INFO - 'OS': 'Windows_NT',
22:42:48 INFO - 'OURDRIVE': 'C:',
22:42:48 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
22:42:48 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
22:42:48 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
22:42:48 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
22:42:48 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
22:42:48 INFO - 'PROCESSOR_LEVEL': '6',
22:42:48 INFO - 'PROCESSOR_REVISION': '1e05',
22:42:48 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
22:42:48 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
22:42:48 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
22:42:48 INFO - 'PROGRAMW6432': 'C:\\Program Files',
22:42:48 INFO - 'PROMPT': '$P$G',
22:42:48 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
22:42:48 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
22:42:48 INFO - 'PUBLIC': 'C:\\Users\\Public',
22:42:48 INFO - 'PWD': 'C:\\slave\\test',
22:42:48 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
22:42:48 INFO - 'SLAVEDIR': 'C:\\slave\\',
22:42:48 INFO - 'SYSTEMDRIVE': 'C:',
22:42:48 INFO - 'SYSTEMROOT': 'C:\\windows',
22:42:48 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
22:42:48 INFO - 'TEST1': 'testie',
22:42:48 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
22:42:48 INFO - 'USERDOMAIN': 'T-W864-IX-023',
22:42:48 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-023',
22:42:48 INFO - 'USERNAME': 'cltbld',
22:42:48 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-023',
22:42:48 INFO - 'WINDIR': 'C:\\windows',
22:42:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
22:42:48 INFO - Ignoring indexes: https://pypi.python.org/simple/
22:42:48 INFO - Downloading/unpacking mozsystemmonitor==0.3
22:42:48 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
22:42:48 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
22:42:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz
22:42:49 INFO - Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor
22:42:49 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)
22:42:49 INFO - Installing collected packages: mozsystemmonitor
22:42:49 INFO - Running setup.py install for mozsystemmonitor
22:42:50 INFO - Successfully installed mozsystemmonitor
22:42:50 INFO - Cleaning up...
22:42:50 INFO - Return code: 0
22:42:50 INFO - Installing jsonschema==2.5.1 into virtualenv C:\slave\test\build/venv
22:42:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
22:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
22:42:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
22:42:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
22:42:50 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 0x0234C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023F3E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024FE688>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0243AE90>, '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 0x01E4A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028DD520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-023', 'USERDOMAIN': 'T-W864-IX-023', '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-023', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-023\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-023', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-023', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-023', '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-023\\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
22:42:50 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
22:42:50 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
22:42:50 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
22:42:50 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-023\\AppData\\Roaming',
22:42:50 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
22:42:50 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
22:42:50 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
22:42:50 INFO - 'COMPUTERNAME': 'T-W864-IX-023',
22:42:50 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
22:42:50 INFO - 'DCLOCATION': 'SCL3',
22:42:50 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
22:42:50 INFO - 'FP_NO_HOST_CHECK': 'NO',
22:42:50 INFO - 'HOMEDRIVE': 'C:',
22:42:50 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-023',
22:42:50 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
22:42:50 INFO - 'KTS_VERSION': '1.19c',
22:42:50 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-023\\AppData\\Local',
22:42:50 INFO - 'LOGONSERVER': '\\\\T-W864-IX-023',
22:42:50 INFO - 'MONDIR': 'C:\\Monitor_config\\',
22:42:50 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
22:42:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
22:42:50 INFO - 'MOZ_NO_REMOTE': '1',
22:42:50 INFO - 'NO_EM_RESTART': '1',
22:42:50 INFO - 'NUMBER_OF_PROCESSORS': '8',
22:42:50 INFO - 'OS': 'Windows_NT',
22:42:50 INFO - 'OURDRIVE': 'C:',
22:42:50 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',
22:42:50 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
22:42:50 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
22:42:50 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
22:42:50 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
22:42:50 INFO - 'PROCESSOR_LEVEL': '6',
22:42:50 INFO - 'PROCESSOR_REVISION': '1e05',
22:42:50 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
22:42:50 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
22:42:50 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
22:42:50 INFO - 'PROGRAMW6432': 'C:\\Program Files',
22:42:50 INFO - 'PROMPT': '$P$G',
22:42:50 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
22:42:50 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
22:42:50 INFO - 'PUBLIC': 'C:\\Users\\Public',
22:42:50 INFO - 'PWD': 'C:\\slave\\test',
22:42:50 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
22:42:50 INFO - 'SLAVEDIR': 'C:\\slave\\',
22:42:50 INFO - 'SYSTEMDRIVE': 'C:',
22:42:50 INFO - 'SYSTEMROOT': 'C:\\windows',
22:42:50 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
22:42:50 INFO - 'TEST1': 'testie',
22:42:50 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
22:42:50 INFO - 'USERDOMAIN': 'T-W864-IX-023',
22:42:50 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-023',
22:42:50 INFO - 'USERNAME': 'cltbld',
22:42:50 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-023',
22:42:50 INFO - 'WINDIR': 'C:\\windows',
22:42:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
22:42:50 INFO - Ignoring indexes: https://pypi.python.org/simple/
22:42:50 INFO - Downloading/unpacking jsonschema==2.5.1
22:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
22:42:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
22:42:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl
22:42:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1)
22:42:51 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
22:42:51 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
22:42:51 INFO - Downloading functools32-3.2.3-2.tar.gz
22:42:51 INFO - Running setup.py (path:C:\slave\test\build\venv\build\functools32\setup.py) egg_info for package functools32
22:42:51 INFO - warning: no files found matching '*.txt'
22:42:51 INFO - no previously-included directories found matching 'build'
22:42:51 INFO - no previously-included directories found matching 'dist'
22:42:51 INFO - no previously-included directories found matching '.git*'
22:42:51 INFO - Installing collected packages: jsonschema, functools32
22:42:52 INFO - Running setup.py install for functools32
22:42:52 INFO - warning: no files found matching '*.txt'
22:42:52 INFO - no previously-included directories found matching 'build'
22:42:52 INFO - no previously-included directories found matching 'dist'
22:42:52 INFO - no previously-included directories found matching '.git*'
22:42:52 INFO - Successfully installed jsonschema functools32
22:42:52 INFO - Cleaning up...
22:42:52 INFO - Return code: 0
22:42:52 INFO - Installing functools32==3.2.3-2 into virtualenv C:\slave\test\build/venv
22:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
22:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
22:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
22:42:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
22:42:52 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x0234C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023F3E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024FE688>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0243AE90>, '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 0x01E4A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028DD520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-023', 'USERDOMAIN': 'T-W864-IX-023', '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-023', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-023\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-023', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-023', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-023', '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-023\\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
22:42:52 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in C:\slave\test\build
22:42:52 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2
22:42:52 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
22:42:52 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-023\\AppData\\Roaming',
22:42:52 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
22:42:52 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
22:42:52 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
22:42:52 INFO - 'COMPUTERNAME': 'T-W864-IX-023',
22:42:52 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
22:42:52 INFO - 'DCLOCATION': 'SCL3',
22:42:52 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
22:42:52 INFO - 'FP_NO_HOST_CHECK': 'NO',
22:42:52 INFO - 'HOMEDRIVE': 'C:',
22:42:52 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-023',
22:42:52 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
22:42:52 INFO - 'KTS_VERSION': '1.19c',
22:42:52 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-023\\AppData\\Local',
22:42:52 INFO - 'LOGONSERVER': '\\\\T-W864-IX-023',
22:42:52 INFO - 'MONDIR': 'C:\\Monitor_config\\',
22:42:52 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
22:42:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
22:42:52 INFO - 'MOZ_NO_REMOTE': '1',
22:42:52 INFO - 'NO_EM_RESTART': '1',
22:42:52 INFO - 'NUMBER_OF_PROCESSORS': '8',
22:42:52 INFO - 'OS': 'Windows_NT',
22:42:52 INFO - 'OURDRIVE': 'C:',
22:42:52 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
22:42:52 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
22:42:52 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
22:42:52 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
22:42:52 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
22:42:52 INFO - 'PROCESSOR_LEVEL': '6',
22:42:52 INFO - 'PROCESSOR_REVISION': '1e05',
22:42:52 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
22:42:52 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
22:42:52 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
22:42:52 INFO - 'PROGRAMW6432': 'C:\\Program Files',
22:42:52 INFO - 'PROMPT': '$P$G',
22:42:52 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
22:42:52 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
22:42:52 INFO - 'PUBLIC': 'C:\\Users\\Public',
22:42:52 INFO - 'PWD': 'C:\\slave\\test',
22:42:52 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
22:42:52 INFO - 'SLAVEDIR': 'C:\\slave\\',
22:42:52 INFO - 'SYSTEMDRIVE': 'C:',
22:42:52 INFO - 'SYSTEMROOT': 'C:\\windows',
22:42:52 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
22:42:52 INFO - 'TEST1': 'testie',
22:42:52 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
22:42:52 INFO - 'USERDOMAIN': 'T-W864-IX-023',
22:42:52 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-023',
22:42:52 INFO - 'USERNAME': 'cltbld',
22:42:52 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-023',
22:42:52 INFO - 'WINDIR': 'C:\\windows',
22:42:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
22:42:53 INFO - Ignoring indexes: https://pypi.python.org/simple/
22:42:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in c:\slave\test\build\venv\lib\site-packages
22:42:53 INFO - Cleaning up...
22:42:53 INFO - Return code: 0
22:42:53 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv
22:42:53 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')]}
22:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
22:42:53 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')]}
22:42:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
22:42:53 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 0x0234C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023F3E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024FE688>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0243AE90>, '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 0x01E4A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028DD520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-023', 'USERDOMAIN': 'T-W864-IX-023', '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-023', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-023\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-023', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-023', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-023', '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-023\\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
22:42:53 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
22:42:53 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
22:42:53 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
22:42:53 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-023\\AppData\\Roaming',
22:42:53 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
22:42:53 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
22:42:53 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
22:42:53 INFO - 'COMPUTERNAME': 'T-W864-IX-023',
22:42:53 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
22:42:53 INFO - 'DCLOCATION': 'SCL3',
22:42:53 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
22:42:53 INFO - 'FP_NO_HOST_CHECK': 'NO',
22:42:53 INFO - 'HOMEDRIVE': 'C:',
22:42:53 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-023',
22:42:53 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
22:42:53 INFO - 'KTS_VERSION': '1.19c',
22:42:53 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-023\\AppData\\Local',
22:42:53 INFO - 'LOGONSERVER': '\\\\T-W864-IX-023',
22:42:53 INFO - 'MONDIR': 'C:\\Monitor_config\\',
22:42:53 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
22:42:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
22:42:53 INFO - 'MOZ_NO_REMOTE': '1',
22:42:53 INFO - 'NO_EM_RESTART': '1',
22:42:53 INFO - 'NUMBER_OF_PROCESSORS': '8',
22:42:53 INFO - 'OS': 'Windows_NT',
22:42:53 INFO - 'OURDRIVE': 'C:',
22:42:53 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',
22:42:53 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
22:42:53 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
22:42:53 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
22:42:53 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
22:42:53 INFO - 'PROCESSOR_LEVEL': '6',
22:42:53 INFO - 'PROCESSOR_REVISION': '1e05',
22:42:53 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
22:42:53 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
22:42:53 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
22:42:53 INFO - 'PROGRAMW6432': 'C:\\Program Files',
22:42:53 INFO - 'PROMPT': '$P$G',
22:42:53 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
22:42:53 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
22:42:53 INFO - 'PUBLIC': 'C:\\Users\\Public',
22:42:53 INFO - 'PWD': 'C:\\slave\\test',
22:42:53 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
22:42:53 INFO - 'SLAVEDIR': 'C:\\slave\\',
22:42:53 INFO - 'SYSTEMDRIVE': 'C:',
22:42:53 INFO - 'SYSTEMROOT': 'C:\\windows',
22:42:53 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
22:42:53 INFO - 'TEST1': 'testie',
22:42:53 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
22:42:53 INFO - 'USERDOMAIN': 'T-W864-IX-023',
22:42:53 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-023',
22:42:53 INFO - 'USERNAME': 'cltbld',
22:42:53 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-023',
22:42:53 INFO - 'WINDIR': 'C:\\windows',
22:42:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
22:42:53 INFO - Ignoring indexes: https://pypi.python.org/simple/
22:42:53 INFO - Downloading/unpacking blobuploader==1.2.4
22:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
22:42:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
22:42:54 INFO - Downloading blobuploader-1.2.4.tar.gz
22:42:54 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader
22:42:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4)
22:42:54 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
22:42:54 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
22:42:54 INFO - Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests
22:42:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4)
22:42:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
22:42:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
22:42:55 INFO - Downloading docopt-0.6.1.tar.gz
22:42:55 INFO - Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt
22:42:55 INFO - Installing collected packages: blobuploader, requests, docopt
22:42:55 INFO - Running setup.py install for blobuploader
22:42:55 INFO - Running setup.py install for requests
22:42:55 INFO - Running setup.py install for docopt
22:42:56 INFO - Successfully installed blobuploader requests docopt
22:42:56 INFO - Cleaning up...
22:42:57 INFO - Return code: 0
22:42:57 INFO - Installing None into virtualenv C:\slave\test\build/venv
22:42: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')]}
22:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
22:42: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')]}
22:42:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
22:42:57 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 0x0234C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023F3E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024FE688>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0243AE90>, '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 0x01E4A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028DD520>, '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-023', 'USERDOMAIN': 'T-W864-IX-023', '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-023', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-023\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-023', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-023', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-023', '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-023\\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
22:42:57 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
22:42:57 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
22:42:57 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
22:42:57 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-023\\AppData\\Roaming',
22:42:57 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
22:42:57 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
22:42:57 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
22:42:57 INFO - 'COMPUTERNAME': 'T-W864-IX-023',
22:42:57 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
22:42:57 INFO - 'DCLOCATION': 'SCL3',
22:42:57 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
22:42:57 INFO - 'FP_NO_HOST_CHECK': 'NO',
22:42:57 INFO - 'HOMEDRIVE': 'C:',
22:42:57 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-023',
22:42:57 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
22:42:57 INFO - 'KTS_VERSION': '1.19c',
22:42:57 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-023\\AppData\\Local',
22:42:57 INFO - 'LOGONSERVER': '\\\\T-W864-IX-023',
22:42:57 INFO - 'MONDIR': 'C:\\Monitor_config\\',
22:42:57 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
22:42:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
22:42:57 INFO - 'MOZ_NO_REMOTE': '1',
22:42:57 INFO - 'NO_EM_RESTART': '1',
22:42:57 INFO - 'NUMBER_OF_PROCESSORS': '8',
22:42:57 INFO - 'OS': 'Windows_NT',
22:42:57 INFO - 'OURDRIVE': 'C:',
22:42: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',
22:42:57 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
22:42:57 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
22:42:57 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
22:42:57 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
22:42:57 INFO - 'PROCESSOR_LEVEL': '6',
22:42:57 INFO - 'PROCESSOR_REVISION': '1e05',
22:42:57 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
22:42:57 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
22:42:57 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
22:42:57 INFO - 'PROGRAMW6432': 'C:\\Program Files',
22:42:57 INFO - 'PROMPT': '$P$G',
22:42:57 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
22:42:57 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
22:42:57 INFO - 'PUBLIC': 'C:\\Users\\Public',
22:42:57 INFO - 'PWD': 'C:\\slave\\test',
22:42:57 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
22:42:57 INFO - 'SLAVEDIR': 'C:\\slave\\',
22:42:57 INFO - 'SYSTEMDRIVE': 'C:',
22:42:57 INFO - 'SYSTEMROOT': 'C:\\windows',
22:42:57 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
22:42:57 INFO - 'TEST1': 'testie',
22:42:57 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
22:42:57 INFO - 'USERDOMAIN': 'T-W864-IX-023',
22:42:57 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-023',
22:42:57 INFO - 'USERNAME': 'cltbld',
22:42:57 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-023',
22:42:57 INFO - 'WINDIR': 'C:\\windows',
22:42:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
22:42:57 INFO - Ignoring indexes: https://pypi.python.org/simple/
22:42:57 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser
22:42:57 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-iyjhyo-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser
22:42:57 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash
22:42:57 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ujewsb-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash
22:42:57 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug
22:42:57 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-kds_g7-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug
22:42:57 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice
22:42:57 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-cvlpp5-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice
22:42:57 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile
22:42:57 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-cla0ld-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile
22:42:58 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd
22:42:58 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-8okerz-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd
22:42:58 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo
22:42:58 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xb9p2j-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo
22:42:58 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall
22:42:58 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-gzhuvh-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall
22:42:58 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak
22:42:58 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-64rqhz-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak
22:42:58 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog
22:42:58 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-bjbqmc-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog
22:42:58 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork
22:42:58 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-eppbsb-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork
22:42:58 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess
22:42:58 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qndnib-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess
22:42:58 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile
22:42:58 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-baosjc-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile
22:42:58 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner
22:42:58 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-pzoiv5-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner
22:42:59 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot
22:42:59 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-83ae3z-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot
22:42:59 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest
22:42:59 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-o85xli-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest
22:42:59 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion
22:42:59 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ktrztd-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion
22:42:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion
22:42:59 INFO - Running setup.py install for manifestparser
22:42:59 INFO - Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts
22:42:59 INFO - Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts
22:43:00 INFO - Running setup.py install for mozcrash
22:43:00 INFO - Running setup.py install for mozdebug
22:43:00 INFO - Running setup.py install for mozdevice
22:43:01 INFO - Installing sutini-script.py script to C:\slave\test\build\venv\Scripts
22:43:01 INFO - Installing sutini.exe script to C:\slave\test\build\venv\Scripts
22:43:01 INFO - Installing dm-script.py script to C:\slave\test\build\venv\Scripts
22:43:01 INFO - Installing dm.exe script to C:\slave\test\build\venv\Scripts
22:43:01 INFO - Running setup.py install for mozfile
22:43:01 INFO - Running setup.py install for mozhttpd
22:43:02 INFO - Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts
22:43:02 INFO - Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts
22:43:02 INFO - Running setup.py install for mozinfo
22:43:02 INFO - Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts
22:43:02 INFO - Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts
22:43:02 INFO - Running setup.py install for mozInstall
22:43:02 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts
22:43:02 INFO - Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts
22:43:02 INFO - Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts
22:43:02 INFO - Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts
22:43:02 INFO - Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts
22:43:02 INFO - Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts
22:43:02 INFO - Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts
22:43:02 INFO - Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts
22:43:03 INFO - Running setup.py install for mozleak
22:43:03 INFO - Running setup.py install for mozlog
22:43:03 INFO - Installing structlog-script.py script to C:\slave\test\build\venv\Scripts
22:43:03 INFO - Installing structlog.exe script to C:\slave\test\build\venv\Scripts
22:43:04 INFO - Running setup.py install for moznetwork
22:43:04 INFO - Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts
22:43:04 INFO - Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts
22:43:04 INFO - Running setup.py install for mozprocess
22:43:05 INFO - Running setup.py install for mozprofile
22:43:05 INFO - Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts
22:43:05 INFO - Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts
22:43:05 INFO - Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts
22:43:05 INFO - Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts
22:43:05 INFO - Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts
22:43:05 INFO - Installing view-profile.exe script to C:\slave\test\build\venv\Scripts
22:43:05 INFO - Running setup.py install for mozrunner
22:43:06 INFO - Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts
22:43:06 INFO - Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts
22:43:06 INFO - Running setup.py install for mozscreenshot
22:43:06 INFO - Running setup.py install for moztest
22:43:07 INFO - Running setup.py install for mozversion
22:43:07 INFO - Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts
22:43:07 INFO - Installing mozversion.exe script to C:\slave\test\build\venv\Scripts
22:43:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion
22:43:07 INFO - Cleaning up...
22:43:07 INFO - Return code: 0
22:43:07 INFO - Installing None into virtualenv C:\slave\test\build/venv
22:43: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')]}
22:43:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
22:43: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')]}
22:43:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
22:43:07 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0234C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023F3E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024FE688>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0243AE90>, '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 0x01E4A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028DD520>, '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-023', 'USERDOMAIN': 'T-W864-IX-023', '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-023', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-023\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-023', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-023', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-023', '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-023\\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
22:43:07 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in C:\slave\test\build\tests\config
22:43:07 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 -r C:\slave\test\build\tests\config\mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub
22:43:07 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
22:43:07 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-023\\AppData\\Roaming',
22:43:07 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
22:43:07 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
22:43:07 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
22:43:07 INFO - 'COMPUTERNAME': 'T-W864-IX-023',
22:43:07 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
22:43:07 INFO - 'DCLOCATION': 'SCL3',
22:43:07 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
22:43:07 INFO - 'FP_NO_HOST_CHECK': 'NO',
22:43:07 INFO - 'HOMEDRIVE': 'C:',
22:43:07 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-023',
22:43:07 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
22:43:07 INFO - 'KTS_VERSION': '1.19c',
22:43:07 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-023\\AppData\\Local',
22:43:07 INFO - 'LOGONSERVER': '\\\\T-W864-IX-023',
22:43:07 INFO - 'MONDIR': 'C:\\Monitor_config\\',
22:43:07 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
22:43:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
22:43:07 INFO - 'MOZ_NO_REMOTE': '1',
22:43:07 INFO - 'NO_EM_RESTART': '1',
22:43:07 INFO - 'NUMBER_OF_PROCESSORS': '8',
22:43:07 INFO - 'OS': 'Windows_NT',
22:43:07 INFO - 'OURDRIVE': 'C:',
22:43:07 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
22:43:07 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
22:43:07 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
22:43:07 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
22:43:07 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
22:43:07 INFO - 'PROCESSOR_LEVEL': '6',
22:43:07 INFO - 'PROCESSOR_REVISION': '1e05',
22:43:07 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
22:43:07 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
22:43:07 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
22:43:07 INFO - 'PROGRAMW6432': 'C:\\Program Files',
22:43:07 INFO - 'PROMPT': '$P$G',
22:43:07 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
22:43:07 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
22:43:07 INFO - 'PUBLIC': 'C:\\Users\\Public',
22:43:07 INFO - 'PWD': 'C:\\slave\\test',
22:43:07 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
22:43:07 INFO - 'SLAVEDIR': 'C:\\slave\\',
22:43:07 INFO - 'SYSTEMDRIVE': 'C:',
22:43:07 INFO - 'SYSTEMROOT': 'C:\\windows',
22:43:07 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
22:43:07 INFO - 'TEST1': 'testie',
22:43:07 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
22:43:07 INFO - 'USERDOMAIN': 'T-W864-IX-023',
22:43:07 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-023',
22:43:07 INFO - 'USERNAME': 'cltbld',
22:43:07 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-023',
22:43:07 INFO - 'WINDIR': 'C:\\windows',
22:43:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
22:43:08 INFO - Ignoring indexes: https://pypi.python.org/simple/
22:43:08 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser
22:43:08 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-z_pzo5-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser
22:43:08 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))
22:43:08 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash
22:43:08 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-lzzwy4-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash
22:43:08 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))
22:43:08 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug
22:43:08 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qrv8_d-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug
22:43:08 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))
22:43:08 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice
22:43:08 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rjw2xw-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice
22:43:08 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))
22:43:08 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile
22:43:08 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ftqmw0-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile
22:43:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///C:/slave/test/build/tests/mozbase/mozfile in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 5))
22:43:08 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd
22:43:08 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-tvns6e-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd
22:43:09 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))
22:43:09 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo
22:43:09 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-vetaqp-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo
22:43:09 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))
22:43:09 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall
22:43:09 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-h8ggvw-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall
22:43:09 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))
22:43:09 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak
22:43:09 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-66gfhr-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak
22:43:09 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))
22:43:09 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog
22:43:09 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-sf0ipg-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog
22:43:09 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))
22:43:09 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork
22:43:09 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-tnozkb-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork
22:43:09 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))
22:43:09 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess
22:43:09 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-stdfg3-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess
22:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///C:/slave/test/build/tests/mozbase/mozprocess in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 12))
22:43:09 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile
22:43:09 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-a5rh46-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile
22:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///C:/slave/test/build/tests/mozbase/mozprofile in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 13))
22:43:09 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner
22:43:09 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-lfw8o_-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner
22:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///C:/slave/test/build/tests/mozbase/mozrunner in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 14))
22:43:09 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot
22:43:09 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-3iyaoc-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot
22:43:10 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))
22:43:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest
22:43:10 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ext_ab-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest
22:43:10 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))
22:43:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion
22:43:10 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-hl7zkc-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion
22:43:10 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))
22:43:10 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))
22:43:10 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))
22:43:10 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))
22:43:10 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))
22:43:10 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))
22:43:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10))
22:43:10 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
22:43:10 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
22:43:14 INFO - Downloading blessings-1.6.tar.gz
22:43:14 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings
22:43:14 INFO - Installing collected packages: blessings
22:43:14 INFO - Running setup.py install for blessings
22:43:14 INFO - Successfully installed blessings
22:43:14 INFO - Cleaning up...
22:43:17 INFO - Return code: 0
22:43:17 INFO - Done creating virtualenv C:\slave\test\build/venv.
22:43:17 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze']
22:43:17 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze
22:43:18 INFO - Reading from file tmpfile_stdout
22:43:18 INFO - Using _rmtree_windows ...
22:43:18 INFO - Using _rmtree_windows ...
22:43:18 INFO - Current package versions:
22:43:18 INFO - blessings == 1.6
22:43:18 INFO - blobuploader == 1.2.4
22:43:18 INFO - docopt == 0.6.1
22:43:18 INFO - functools32 == 3.2.3-2
22:43:18 INFO - jsonschema == 2.5.1
22:43:18 INFO - manifestparser == 1.1
22:43:18 INFO - mozInstall == 1.12
22:43:18 INFO - mozcrash == 0.17
22:43:18 INFO - mozdebug == 0.1
22:43:18 INFO - mozdevice == 0.48
22:43:18 INFO - mozfile == 1.2
22:43:18 INFO - mozhttpd == 0.7
22:43:18 INFO - mozinfo == 0.9
22:43:18 INFO - mozleak == 0.1
22:43:18 INFO - mozlog == 3.4
22:43:18 INFO - moznetwork == 0.27
22:43:18 INFO - mozprocess == 0.23
22:43:18 INFO - mozprofile == 0.28
22:43:18 INFO - mozrunner == 6.12
22:43:18 INFO - mozscreenshot == 0.1
22:43:18 INFO - mozsystemmonitor == 0.3
22:43:18 INFO - moztest == 0.7
22:43:18 INFO - mozversion == 1.4
22:43:18 INFO - psutil == 3.1.1
22:43:18 INFO - requests == 1.2.3
22:43:18 INFO - Installing None into virtualenv C:\slave\test\build/venv
22:43:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
22:43:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
22:43:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
22:43:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
22:43:18 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 0x0234C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023F3E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024FE688>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0243AE90>, '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 0x01E4A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028DD520>, '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-023', 'USERDOMAIN': 'T-W864-IX-023', '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-023', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-023\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-023', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-023', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-023', '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-023\\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
22:43:18 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
22:43:18 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
22:43:18 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
22:43:18 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-023\\AppData\\Roaming',
22:43:18 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
22:43:18 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
22:43:18 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
22:43:18 INFO - 'COMPUTERNAME': 'T-W864-IX-023',
22:43:18 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
22:43:18 INFO - 'DCLOCATION': 'SCL3',
22:43:18 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
22:43:18 INFO - 'FP_NO_HOST_CHECK': 'NO',
22:43:18 INFO - 'HOMEDRIVE': 'C:',
22:43:18 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-023',
22:43:18 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
22:43:18 INFO - 'KTS_VERSION': '1.19c',
22:43:18 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-023\\AppData\\Local',
22:43:18 INFO - 'LOGONSERVER': '\\\\T-W864-IX-023',
22:43:18 INFO - 'MONDIR': 'C:\\Monitor_config\\',
22:43:18 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
22:43:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
22:43:18 INFO - 'MOZ_NO_REMOTE': '1',
22:43:18 INFO - 'NO_EM_RESTART': '1',
22:43:18 INFO - 'NUMBER_OF_PROCESSORS': '8',
22:43:18 INFO - 'OS': 'Windows_NT',
22:43:18 INFO - 'OURDRIVE': 'C:',
22:43:18 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
22:43:18 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
22:43:18 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
22:43:18 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
22:43:18 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
22:43:18 INFO - 'PROCESSOR_LEVEL': '6',
22:43:18 INFO - 'PROCESSOR_REVISION': '1e05',
22:43:18 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
22:43:18 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
22:43:18 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
22:43:18 INFO - 'PROGRAMW6432': 'C:\\Program Files',
22:43:18 INFO - 'PROMPT': '$P$G',
22:43:18 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
22:43:18 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
22:43:18 INFO - 'PUBLIC': 'C:\\Users\\Public',
22:43:18 INFO - 'PWD': 'C:\\slave\\test',
22:43:18 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
22:43:18 INFO - 'SLAVEDIR': 'C:\\slave\\',
22:43:18 INFO - 'SYSTEMDRIVE': 'C:',
22:43:18 INFO - 'SYSTEMROOT': 'C:\\windows',
22:43:18 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
22:43:18 INFO - 'TEST1': 'testie',
22:43:18 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
22:43:18 INFO - 'USERDOMAIN': 'T-W864-IX-023',
22:43:18 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-023',
22:43:18 INFO - 'USERNAME': 'cltbld',
22:43:18 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-023',
22:43:18 INFO - 'WINDIR': 'C:\\windows',
22:43:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
22:43:18 INFO - Ignoring indexes: https://pypi.python.org/simple/
22:43:18 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))
22:43:18 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))
22:43:18 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))
22:43:18 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))
22:43:18 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))
22:43:18 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))
22:43:18 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))
22:43:18 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))
22:43:18 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))
22:43:18 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))
22:43:18 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))
22:43:18 INFO - Cleaning up...
22:43:18 INFO - Return code: 0
22:43:18 INFO - Installing jsonschema into virtualenv C:\slave\test\build/venv
22:43:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
22:43:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
22:43:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
22:43:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
22:43:18 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0234C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023F3E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024FE688>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0243AE90>, '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 0x01E4A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028DD520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-023', 'USERDOMAIN': 'T-W864-IX-023', '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-023', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-023\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-023', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-023', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-023', '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-023\\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
22:43:18 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in C:\slave\test\build
22:43:18 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema
22:43:18 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
22:43:18 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-023\\AppData\\Roaming',
22:43:18 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
22:43:18 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
22:43:18 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
22:43:18 INFO - 'COMPUTERNAME': 'T-W864-IX-023',
22:43:18 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
22:43:18 INFO - 'DCLOCATION': 'SCL3',
22:43:18 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
22:43:18 INFO - 'FP_NO_HOST_CHECK': 'NO',
22:43:18 INFO - 'HOMEDRIVE': 'C:',
22:43:18 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-023',
22:43:18 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
22:43:18 INFO - 'KTS_VERSION': '1.19c',
22:43:18 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-023\\AppData\\Local',
22:43:18 INFO - 'LOGONSERVER': '\\\\T-W864-IX-023',
22:43:18 INFO - 'MONDIR': 'C:\\Monitor_config\\',
22:43:18 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
22:43:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
22:43:18 INFO - 'MOZ_NO_REMOTE': '1',
22:43:18 INFO - 'NO_EM_RESTART': '1',
22:43:18 INFO - 'NUMBER_OF_PROCESSORS': '8',
22:43:18 INFO - 'OS': 'Windows_NT',
22:43:18 INFO - 'OURDRIVE': 'C:',
22:43:18 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
22:43:18 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
22:43:18 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
22:43:18 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
22:43:18 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
22:43:18 INFO - 'PROCESSOR_LEVEL': '6',
22:43:18 INFO - 'PROCESSOR_REVISION': '1e05',
22:43:18 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
22:43:18 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
22:43:18 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
22:43:18 INFO - 'PROGRAMW6432': 'C:\\Program Files',
22:43:18 INFO - 'PROMPT': '$P$G',
22:43:18 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
22:43:18 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
22:43:18 INFO - 'PUBLIC': 'C:\\Users\\Public',
22:43:18 INFO - 'PWD': 'C:\\slave\\test',
22:43:18 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
22:43:18 INFO - 'SLAVEDIR': 'C:\\slave\\',
22:43:18 INFO - 'SYSTEMDRIVE': 'C:',
22:43:18 INFO - 'SYSTEMROOT': 'C:\\windows',
22:43:18 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
22:43:18 INFO - 'TEST1': 'testie',
22:43:18 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
22:43:18 INFO - 'USERDOMAIN': 'T-W864-IX-023',
22:43:18 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-023',
22:43:18 INFO - 'USERNAME': 'cltbld',
22:43:18 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-023',
22:43:18 INFO - 'WINDIR': 'C:\\windows',
22:43:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
22:43:18 INFO - Ignoring indexes: https://pypi.python.org/simple/
22:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in c:\slave\test\build\venv\lib\site-packages
22:43:18 INFO - Cleaning up...
22:43:18 INFO - Return code: 0
22:43:18 INFO - Running post-action listener: _resource_record_post_action
22:43:18 INFO - Running post-action listener: _start_resource_monitoring
22:43:18 INFO - Starting resource monitoring.
22:43:18 INFO - [mozharness: 2016-10-24 05:43:18.860000Z] Finished create-virtualenv step (success)
22:43:18 INFO - [mozharness: 2016-10-24 05:43:18.860000Z] Running install step.
22:43:18 INFO - Running pre-action listener: _resource_record_pre_action
22:43:18 INFO - Running main action method: install
22:43:18 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze']
22:43:18 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze
22:43:19 INFO - Reading from file tmpfile_stdout
22:43:19 INFO - Using _rmtree_windows ...
22:43:19 INFO - Using _rmtree_windows ...
22:43:19 INFO - Detecting whether we're running mozinstall >=1.0...
22:43:19 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h']
22:43:19 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h
22:43:19 INFO - Reading from file tmpfile_stdout
22:43:19 INFO - Output received:
22:43:19 INFO - Usage: mozinstall-script.py [options] installer
22:43:19 INFO - Options:
22:43:19 INFO - -h, --help show this help message and exit
22:43:19 INFO - -d DEST, --destination=DEST
22:43:19 INFO - Directory to install application into. [default:
22:43:19 INFO - "C:\slave\test"]
22:43:19 INFO - --app=APP Application being installed. [default: firefox]
22:43:19 INFO - Using _rmtree_windows ...
22:43:19 INFO - Using _rmtree_windows ...
22:43:19 INFO - mkdir: C:\slave\test\build\application
22:43:19 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']
22:43:19 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
22:43:21 INFO - Reading from file tmpfile_stdout
22:43:21 INFO - Output received:
22:43:21 INFO - C:\slave\test\build\application\firefox\firefox.exe
22:43:21 INFO - Using _rmtree_windows ...
22:43:21 INFO - Using _rmtree_windows ...
22:43:21 INFO - Running post-action listener: _resource_record_post_action
22:43:21 INFO - [mozharness: 2016-10-24 05:43:21.784000Z] Finished install step (success)
22:43:21 INFO - [mozharness: 2016-10-24 05:43:21.784000Z] Running run-tests step.
22:43:21 INFO - Running pre-action listener: _resource_record_pre_action
22:43:21 INFO - Running main action method: run_tests
22:43:21 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version']
22:43:21 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version
22:43:21 INFO - Python 2.7.3
22:43:21 INFO - Return code: 0
22:43:21 INFO - grabbing minidump binary from tooltool
22:43:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
22:43:21 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 0x0243AE90>, '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 0x01E4A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028DD520>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1
22:43:21 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
22:43:21 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
22:43:21 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
22:43:21 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'...
22:43:23 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmp_t5qox
22:43:23 INFO - INFO - File integrity verified, renaming tmp_t5qox to win32-minidump_stackwalk.exe
22:43:23 INFO - Return code: 0
22:43:23 INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755
22:43:23 INFO - mkdir: C:\slave\test\build\blobber_upload_dir
22:43:23 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir
22:43:23 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe
22:43:23 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir
22:43:23 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b1i22o8PSsuKkzCSA29Fkw/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-023', '--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
22:43:23 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\tests\talos\talos\run_tests.py --branchName Autoland --suite dromaeojs --executablePath C:\slave\test\build\application\firefox\firefox --symbolsPath https://queue.taskcluster.net/v1/task/b1i22o8PSsuKkzCSA29Fkw/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip --title T-W864-IX-023 --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
22:43:23 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
22:43:23 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-023\\AppData\\Roaming',
22:43:23 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
22:43:23 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
22:43:23 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
22:43:23 INFO - 'COMPUTERNAME': 'T-W864-IX-023',
22:43:23 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
22:43:23 INFO - 'DCLOCATION': 'SCL3',
22:43:23 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
22:43:23 INFO - 'FP_NO_HOST_CHECK': 'NO',
22:43:23 INFO - 'HOMEDRIVE': 'C:',
22:43:23 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-023',
22:43:23 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
22:43:23 INFO - 'KTS_VERSION': '1.19c',
22:43:23 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-023\\AppData\\Local',
22:43:23 INFO - 'LOGONSERVER': '\\\\T-W864-IX-023',
22:43:23 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir',
22:43:23 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe',
22:43:23 INFO - 'MONDIR': 'C:\\Monitor_config\\',
22:43:23 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
22:43:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
22:43:23 INFO - 'MOZ_NO_REMOTE': '1',
22:43:23 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir',
22:43:23 INFO - 'NO_EM_RESTART': '1',
22:43:23 INFO - 'NUMBER_OF_PROCESSORS': '8',
22:43:23 INFO - 'OS': 'Windows_NT',
22:43:23 INFO - 'OURDRIVE': 'C:',
22:43:23 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',
22:43:23 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
22:43:23 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
22:43:23 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
22:43:23 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
22:43:23 INFO - 'PROCESSOR_LEVEL': '6',
22:43:23 INFO - 'PROCESSOR_REVISION': '1e05',
22:43:23 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
22:43:23 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
22:43:23 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
22:43:23 INFO - 'PROGRAMW6432': 'C:\\Program Files',
22:43:23 INFO - 'PROMPT': '$P$G',
22:43:23 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
22:43:23 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
22:43:23 INFO - 'PUBLIC': 'C:\\Users\\Public',
22:43:23 INFO - 'PWD': 'C:\\slave\\test',
22:43:23 INFO - 'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos',
22:43:23 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
22:43:23 INFO - 'SLAVEDIR': 'C:\\slave\\',
22:43:23 INFO - 'SYSTEMDRIVE': 'C:',
22:43:23 INFO - 'SYSTEMROOT': 'C:\\windows',
22:43:23 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
22:43:23 INFO - 'TEST1': 'testie',
22:43:23 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
22:43:23 INFO - 'USERDOMAIN': 'T-W864-IX-023',
22:43:23 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-023',
22:43:23 INFO - 'USERNAME': 'cltbld',
22:43:23 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-023',
22:43:23 INFO - 'WINDIR': 'C:\\windows',
22:43:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
22:43:23 INFO - Calling ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b1i22o8PSsuKkzCSA29Fkw/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-023', '--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
22:43:24 INFO - mozversion application_buildid: 20161023203915
22:43:24 INFO - mozversion application_changeset: 04c1662be2ba75c56a625799ebaccbe487005941
22:43:24 INFO - mozversion application_display_name: Nightly
22:43:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384}
22:43:24 INFO - mozversion application_name: Firefox
22:43:24 INFO - mozversion application_remotingname: firefox
22:43:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland
22:43:24 INFO - mozversion application_vendor: Mozilla
22:43:24 INFO - mozversion application_version: 52.0a1
22:43:24 INFO - mozversion platform_buildid: 20161023203915
22:43:24 INFO - mozversion platform_changeset: 04c1662be2ba75c56a625799ebaccbe487005941
22:43:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland
22:43:24 INFO - mozversion platform_version: 52.0a1
22:43:24 INFO - using testdate: 1477287804
22:43:24 INFO - actual date: 1477287804
22:43:24 INFO - starting webserver on 'localhost:49278'
22:43:24 INFO - SUITE-START | Running 2 tests
22:43:24 INFO - TEST-START | dromaeo_css
22:43:24 INFO - operating with platform_type : w8_
22:43:24 INFO - Initialising browser for dromaeo_css test...
22:43:24 INFO - TEST-INFO | started process 3852 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpsuham7\profile http://localhost:49278/getInfo.html)
22:43:32 INFO - PROCESS | 3852 | __metrics Screen width/height:1600/1200
22:43:32 INFO - PROCESS | 3852 | colorDepth:24
22:43:32 INFO - PROCESS | 3852 | Browser inner width/height: 1010/674
22:43:32 INFO - PROCESS | 3852 | __metrics
22:43:33 INFO - PROCESS | 3852 | 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"
22:43:33 INFO - PROCESS | 3852 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver]
22:43:34 INFO - TEST-INFO | 3852: exit 0
22:43:34 INFO - Browser initialized.
22:43:34 INFO - Running cycle 1/1 for dromaeo_css test...
22:43:34 INFO - TEST-INFO | started process 3168 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpsuham7\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1)
22:43:34 INFO - PROCESS | 3168 | [GFX1-]: Invalid size in UpdateRenderTarget Size(124,0), 0
22:43:45 INFO - PROCESS | 3168 | RSS: Main: 159551488
22:43:45 INFO - PROCESS | 3168 |
22:44:37 INFO - PROCESS | 3168 | 1477287877583 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]
22:46:48 INFO - PROCESS | 3168 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html)
22:46:50 INFO - PROCESS | 3168 | RSS: Main: 312025088
22:46:50 INFO - PROCESS | 3168 |
22:49:52 INFO - PROCESS | 3168 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html)
22:49:53 INFO - PROCESS | 3168 | RSS: Main: 226742272
22:49:53 INFO - PROCESS | 3168 |
22:52:55 INFO - PROCESS | 3168 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html)
22:52:56 INFO - PROCESS | 3168 | RSS: Main: 173113344
22:52:56 INFO - PROCESS | 3168 |
22:55:58 INFO - PROCESS | 3168 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html)
22:55:59 INFO - PROCESS | 3168 | RSS: Main: 171552768
22:55:59 INFO - PROCESS | 3168 |
22:59:02 INFO - PROCESS | 3168 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html)
22:59:02 INFO - PROCESS | 3168 | RSS: Main: 160972800
22:59:02 INFO - PROCESS | 3168 |
23:02:05 INFO - PROCESS | 3168 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html)
23:02:05 INFO - PROCESS | 3168 | RSS: Main: 216461312
23:02:05 INFO - PROCESS | 3168 |
23:02:05 INFO - PROCESS | 3168 | __start_tp_report
23:02:05 INFO - PROCESS | 3168 | _x_x_mozilla_page_load
23:02:05 INFO - PROCESS | 3168 | _x_x_mozilla_page_load_details
23:02:05 INFO - PROCESS | 3168 | |i|pagename|runs|
23:02:05 INFO - PROCESS | 3168 | |0;dojo.html;2776.59739337796;2790.079273839633;2814.3245621050955;2815.2539577012094;2837.347410095678;5009.499050094993;5014.323066386037;5048.924266136001;5078.327938296771;5088.2622019807195;4908.435529914061;5006.649534532584;5066.746662666861;5081.060003899282;5162.122439185338;4487.708298960557;4504.481984571784;4509.210888094587;4539.909201815962;4586.1974154522995;4564.2012647786505;4579.244424669925;4590.05903789724;4592.586667199951;4596.678232523725;4497.3029180476915;4535.478419981695;4574.771261436931;4591.288350305708;4595.195840727876;4540.137373898965;4586.7477288749105;4596.701214421086;4599;4616.053708989649;4435.68950173488;4517.728936263835;4529.1621050105505;4547.999440123168;4565.5206203348835;4960.057589058068;4984.40187177541;4994.250862370637;5030.245463180552;5037.4458809530925;5366.087765079946;5378.650387724785;5415.160650099241;5452.209429632681;5456.0997435423105;5289.259503669489;5459.945400545984;5491.341039075297;5494.642848214893;5543.445655434464;4936.975315123437;5001.699898006095;5006.674566153189;5047.41954675217;5049.495050494921;5282.920756188583;5555.416681248492;5556.277683901067;5566.526845218121;5568;5223.164293712987;5297.523222909879;5298.072837253542;5329.786808527616;5380.112281473513;5353.57171426285;5387.138057910715;5416.295881535454;5417.052015897202;5418.945810541923;5300.3639563252655;5352.892942141136;5372.623916325898;5380.623356365095;5389.9191512127345;5368.409474957752;5392.838214853561;5396.352437707422;5420.566354691615;5443.074677304868;3643.325984692787;3643.508126402902;3644.6902013328636;3657.231981283907;3690.8523659053335;3244.6593107723347;3255.8697652094124;3282.2778988622463;3283.277678910636;3326.8003919764406;5095.210242412358;5095.592352611782;5100.744962751847;5104.3109180260935;5105.285260063594;5470.945290547043;5472.151816468454;5477;5477.260569823103;5495.917561236584;5083.949160508348;5100.285959965608;5109.642325037286;5109.770060347293;5114.872128196825;4514.413126293561;4528.139653465831;4533.342665313511;4538.704984176018;4564.748938808398;5462.262594549765;5486.780528778804;5522;5530.308711410993;5544.611877168641;5360.142377219626;5419.187121931742;5429.429909859408;5447.400785913625;5473.151661492475;5520.06158952987;5542.11326187808;5549.72251387421;5555.111182210827;5615.438456154352;5244.711540865289;5247.055530004483;5333.4133245343755;5356.705381204071;5357.919631205613;5426.538744206787;5427.050266203478;5435.347758269033;5438.211459338453;5438.75525601341;5206.349206349207;5250.947490525045;5285;5287.735613219246;5296.523312901703;5174.172132458789;5236.738163091906;5237.659552129099;5280.920786188133;5311.097113490639;5226.764795584132;5227.2420499028185;5229.9738501308775;5238.345206849144;5296.285001524745;5192.221166825007;5228.215767634885;5233.215017747369;5286.9735651323035;5301.6818990860675;5212.113940630178;5216.713080780593;5220.086484865209;5297.470252974672;5368.785248590013
23:02:05 INFO - PROCESS | 3168 | |1;ext.html;536.0966770990881;550.243415303957;553.0597983428171;560.1905246918202;573.876616527447;28217.858910705443;35138.648613513855;36403.81798091009;36404.271914561694;38763.22473550534;36909.26181476369;37604.62395376052;37626.247475050484;37649.247015059686;37686.81156594213;7796.961015194916;8080.595970201481;8183.9590802045905;8229.053658829222;8232.17678232178;7553.848923021536;7654.617269136549;7680.807979800522;7716.884246736276;9563.426194428357;9528.380655257386;9704.70885873425;9773.07155820196;9783.46190959497;9853.753656158617;9592;9629.518524073803;9675.612975480972;9677.274204434696;9686.564104615309;7775.105862825791;7991.2807847294025;8019.318357939582;8166.142555031695;9653.565589548487;34027.31945361104;34570;34581;36849.81575092134;36860.26279474422;3043.6195475565555;3043.6804135565667;3120.828354440505;3208.7433005359517;3407.488876668495;27264.318392040357;27653.861730691217;27675.308117297227;27679.30801729953;27753.861230693918;3519.260955199411;3557;3557.5908770491465;3627.4921510988484;3660.4509323601405;279210;280058;280563;280947;281091.99999999796;41797.79101104536;43084.35373469401;44511.55488445139;45916;45922.31116533255;45718;48060.27909581359;48081.27878081831;48148;48207.75896120497;13709.794353084711;13784.517541885985;13803.585892423243;13812.86187138136;13856.861431385558;10622.521986510472;10682.62610808618;10738.624148154777;10769.084627806567;10776.245662803685;10469.68590942273;10671.679849604368;13013.934930325287;13506.459741610226;13539.630564651146;5466.835994920159;5505.504504594605;5535.252740880011;5553.555715542747;5602;796.4305521552118;822.9876551851727;845.0873057098319;885.6457417033238;923.6354931375699;26630.6005409919;26899.193024209304;27190;27283.317917051834;27350;952.3000594562991;965.8985806490217;989.6783545347647;998.2014388489325;1001.2890847498358;13970.511032114031;14056;14157.575272741835;14169.85830141706;14333.56999290023;390368;391368;393433;393896;393989;44732.77633611811;45029.09941801146;45030.549694503294;45063;45113.32330014987;1131.2703306367182;1134.1947217475686;1151.9977619470947;1156.647222597116;1156.647222597116;26142.607860882483;26536.601950970366;26675.866620666773;27179.72820271772;27224;40123;40381.798091009354;40424;40487.392689110275;40506.39240411337;276993;326793;327184;327522;327737;32600.673993259763;32979.175520611214;32994.05089236634;33363.499547507294;33394.83302583471;34082.48876266809;34096;38160;39302.80348598239;41735.58264417317;32770;33477.16307092342;33686.83156584201;33996;34086.14784630305;33712.831435842665;34116.488252675736;34208.14479638029;34429.483557746156;34820.25898705105;32190.19524511906;32272.193195170308;32504.187395315308;32665.510017349283;32788.508172376954;29905.551416728333;31147.84426077855;31151.68848311488;31173.376532469676;31217.53173702351;23761.762382375953;23953.52092958166;24211.273661790176;24386.292959492665;24422.145224917043
23:02:05 INFO - PROCESS | 3168 | |2;jquery.html;323.36781591987665;332.75209968573404;335.4063307944937;335.474981653712;354.1217779905833;13216.471341146354;14289.428422863086;16082.678346433078;16667.41664041759;17766.46700598984;14057.226852523107;14070.366833492491;14110.64723381916;14336.71326573468;14354.78467822981;5050.141475949097;5265.999460102587;5268.262443257928;5273.973630131844;5282.2076688496645;3840.7503512271614;4044.413560033793;4062.309407400749;5206.167013277876;5236.4763523647525;5512.503874651281;5784.971075144618;5788.42115788422;5855.326637436707;5858.970705146489;5606.271184745998;5749.0514065179195;5780.335261444946;5828.446297601742;5893.027650437694;5041.521055499758;5057.645964782467;5058.645894787366;5061.797528098871;5061.822836200715;19390.127444265043;19442.805571944384;19640.116194771268;19771.604567908562;19813.405597832087;2031.9849482596455;2065.979340206594;2169.6853956176424;2176.4232478393237;2495.201535508638;12013.159078864483;12403.255804651659;12444;12469.812952805714;13011.479540818356;1682.1589205397302;1720.9741853872076;1763.2329936477672;1793.704038833604;1814.4193857965456;65815.67092164508;66840.6657966707;67730;68252.29369265758;69050.65474672645;8796.604152813139;8849;8959.41763785352;9024.232940200025;9056.909430905607;11942;11958;11959.461824217931;11967.264746611692;11967.341796201292;6560.343965603402;6701.899471507932;6719.361660642231;6792.490563207681;6798.966005169942;6517;6528.54300198991;6630.403263706193;6642.734290628321;6759.797206083826;5456;5565.471280228453;5592.692401917852;5595.608307418523;5654.491095801315;1528.1671489038501;1609.3562574970106;1623.3750006247444;1629.7392417213189;1635.4276003398716;728.3917928529737;776.6660336055551;875.922615183328;888.9511076890703;905.42053086025;16629.833701663072;16683.83316166847;16685.83314166867;16741.330346786235;17277.56806079858;770.3952397368151;808.1595141053356;819.9098099209082;824.2499325613662;830.1325115254574;8893.377463577617;9204.95397523008;9234.907650923538;9247.861282080774;9390.295727820441;397586;407868;415360;416512;416632;78201.60899195468;80663.59668201621;80802;81746;81762.18237817545;899.6671231644334;902.4089221559889;904.5115637555778;918.6922381002439;921.5302987992245;14303.427862885368;14341.924355673158;14374.281285935871;14393.64015899611;14858.405663773761;32369.838150809097;33624.66375336313;34028.65971340255;34871.82564087163;35513.644863552065;48998.510014899395;49049.509504905924;49976;50017.49982500274;50286.49713502965;5026.924596131134;7103.401734609672;7105.360517553445;7260.2739726026975;7471.738489152854;11243.269187502787;11561.88438115608;11587.884121159017;11774.587889423829;11795.29228246308;9629.807403851744;9780.41317520951;10061.094501494901;10115.898841011496;10116.84824727615;6986.406155476841;7005.369516743517;7053.153621565445;7359.153697324876;7464.253574642492;6925.89611155823;7033.542819716702;7067.752628658178;7160.319769621878;7571.280728330799;10585.788284234426;10927.289726167774;10957.726056848642;11062.612808551663;11251.7749645005;7107.827208510745;8894.377393582387;10558.683239502827;10776.67669969902;11043.39261340634
23:02:05 INFO - PROCESS | 3168 | |3;mootools.html;1140.766142940697;1142.6229344316375;1205.1925210109225;1394.3376895974413;1432.6490009947565;7117.145942486903;7584.203658615848;7608.0489938757655;7611.314981651651;7618.123915749684;6882.208546017209;7070.4343652507805;7251.38363239124;7357.190709022003;7551.6601752921115;1942.2328180368781;1965.2139144342307;1965.7837637859825;1965.8722183058055;1966.6951622498536;1922.7500424944737;1935.7386752788334;1944.0862794486638;1944.9611007779906;1953.1210955070205;1689.3073839725714;1737.3832289537222;1854.8423384012308;1922.4040547430272;1943.6987266973572;1892.668782962983;1905.8665893387467;1905.990470047648;1908.9618207635908;1909.0550177662008;1864.3288416170167;1876.7278744582095;1904.6762050451457;1909.2172209394082;1913.2538310059088;6802.081718967926;6998.720051197997;7179.748708795167;7301.1968683444775;7603.239676032408;4282.593153650399;4404.317330813729;4419.204543182226;4420.138073075752;4426.645868330558;2746.1761471558452;2814.226087825844;2847.7721782257577;2852.4009957908656;2861.4563232985665;904.2314033071902;905.6377449020445;919.1543779722605;919.5218486387108;920.8158368326361;10200.13298869597;10223.488825558767;10231.334963227366;10237.48812559369;10253.07722304996;3671.5594128704724;3744.700423966076;3812.790296533717;3852.9422058669143;3873;8559.186877246651;8560.229579337889;8573.785655358666;8634.438761480484;8647.135286471428;4293.6779741518885;4305.720128191658;4309.633681137076;4311.202427550913;4321.891952701145;3971.384435412516;3976.0855003349393;3986.5016872890887;3986.960130398717;3988.66096381805;3184.85668144934;3230.1924518870283;3251.3334766372836;3266.7549933755063;3267.9836600816843;950.6292545907102;956.0535070280372;964.6720115160879;966.7873067925045;968.2157452463528;764.8393837294119;772.7372693284198;776.9728059518003;785.2422412372089;788.2157253532772;4659.557342052567;4661.720296782204;4838.2016967200725;4869.829555965595;4937.136001199776;772.5210369570902;814.3322475570094;818.5293456262553;820.3970081989733;822.6462621072876;3261.7390608751243;3279.770416070852;3329.933401332008;3360.3951288767767;3409.7724819065115;9048.457092574467;9324.1608255256;9342.90657093434;9382.390144640576;9390.154886060287;9213.262938964866;9265.861012084824;9325.860112098188;9344.813103738023;9346.813063738688;6735.629540375228;6960.65196740161;7027.824304392431;7102.112235970504;7158.892616610755;4739.620830333634;4744.454387745315;4770.499097594841;4795.592374648194;4834.613230941586;8538;8599.52702601363;8654.653813847375;8705.695300664447;8737.301015918583;8555.443896146731;8912.153345432174;8968.327375446737;8992.875890513686;8993.595288211915;6464.5798023128345;6673.599584024974;6717.596944183365;6839.418649414855;6841.931580684329;7274.090738657668;7296.890546641911;7325.304096110861;7327.937449069748;7337;6486.383793539606;6511.511636627367;6515.511336649675;6571.014347847861;6654.467642588678;6520.347965203442;6531.314212007861;6562.606243625398;6588.40704336612;6646.136002319668;5740.311162660508;5751.9137212941005;5754.223179870663;5759.94240057594;5771.3651498335985;4003.799810009546;4041.515018197835;4041.7574945503366;4090;4154.0238044059015;4064.878053658395;4065.4308396823876;4073.79631018442;4091.9565510794555;4171.10321280926
23:02:05 INFO - PROCESS | 3168 | |4;prototype.html;260.34912718204475;263.1355995554604;266.40591480997375;267.3170050520919;268.3398838856413;5052.141136006879;5192.558632516231;5206.921896171556;5225.32070830792;5239.318888544489;5080.517350851673;5091.490850914906;5105.463926287742;5122.897542049157;5125.333706618135;3696.2237930034726;3788.48855404521;3803.657670809627;3872.632099950514;3874.786886721229;3859.536855577335;3859.9035024124482;3870.612938706121;3872.9419058714143;3884.9805750971345;3820.6561409473143;3827.138893748898;3831.2912111259507;3853.3834586466173;3868.703984165308;3668.5047518584915;3795.2599243147597;3801.4107813288983;3834.2906562285925;3848.2303539291975;3206.3587282543353;3246.594175728034;3292.2921571861925;3301.9268737660354;3311.586051743532;4924.556789888928;4942.654014219006;4947.653664243504;4949.579285760715;4999.625028122905;4312.935305970413;4340.956590434087;4443.511213766483;4457.264551349023;4469.7541635210055;5274.815381461669;5283.679080229943;5316.282301889273;5316.760745766411;5322.92015619766;3590.6409359064146;3599.6940260077927;3608.6210947850623;3613.837377318027;3621.5473065866768;5354.464553544653;5638.182463542805;5643.717814109319;5665.603407761459;5679.438154507502;3625.728070394678;3637.744977982592;3642.9635703643153;3660.9816950915606;3666.7799932004164;3676.4448708148116;3682.7294583368694;3696.9278909116592;3727.105494681257;3731.850725970985;4417.491988421309;4429.534898835575;4435.733855968652;4439.511653718088;4442.755648439303;5380.677159370451;5457.727113644302;5466.972665136649;5494.752736126884;5505.834824955257;1267.9492820287269;1282.8524719657173;1286.2604002698486;1287.665207046156;1287.7682017236987;768.9769306920801;787.9566623835744;799.1050023973071;802.2899733735686;807.7657479331045;4594.88512787183;4606.959406791501;4613.792379342937;4998.675880539473;5158.303629010111;5544.972275138599;5614.326280846324;5673.858153546112;5678.602497825195;5705.572082093777;5277;5284.947150528523;5284.973575132177;5285.735713214401;5287.20691896211;2845.701201373867;2959.9408011840073;2981.8956336528117;2986.9402611948076;2991.7457016153435;5714.714264286769;5719.399463056402;5723.942760572341;5778;5789;5571.470710282517;5628.230930113258;5706.916975303984;5740.253767010262;5760.884782304414;5661.886762264731;5680.68756218412;5699.8860022800145;5713.171590119409;5769.88460230793;5611.494965453129;5628.634138780966;5664.207011018543;5697;5726.885462290647;5394.9460505394445;5533.114701647717;5560.527355174855;5589.972050139723;5590.664560126405;5670;5670.659760414388;5678.914816277842;5683.943160568507;5688.317401911797;3636.2727454508677;3706.6849317808287;3707.1102935295876;3707.3141468828353;3713.702903767638;5408.864778380572;5563.833085007456;5686.317641882835;5709.771609135588;5730.312362516524;5392.541633961;5406.972965135149;5407.351117865724;5408.323419739736;5573.470520300565;5211.348581427322;5460.34475862899;5463.125899856004;5483.835484935458;5485.917711234414;5375.35495740498;5378.892422151614;5429.375621803543;5444.482774136451;5486.91769623448;5197.740112994411;5370.650907691144;5433.185022246695;5442.897548397375;5454.509094181542;5268;5388.7036213007095;5406.513413792777;5420.105682562333;5493.917591236055
23:02:05 INFO - PROCESS | 3168 | |5;yui.html;622.6886556721639;642.7621779941422;662.9834254143649;701.7298340139048;711.4557363616832;12980.74038519229;12995.740085198302;13386.263755493444;13831.515896943622;14022.509212177576;12157.939210303935;13198.340082995835;13276.933615331935;13277.468901243963;13302.068855180141;568.5849329989111;629.4743888852813;645.2257291250495;645.8514541655422;646.6055706019324;577.7544543568987;640.801351581009;658.2101478226124;661.3518751623412;664.5182242873926;689.9689513971883;691.3017851969497;692.8129405060631;694.8888177891538;695.0477845351875;585.7247093865876;692.3872372949925;692.608676098003;694.5450729772008;694.6283738200038;441.86964845370693;487.81950678249274;496.23827424902964;496.5655051829649;500.96050694808054;12080.214786038967;12083.697907552294;12091.818622720666;12099.516019359215;12110.697232569168;11598.536058557647;12137.453814578364;12256.877431225663;12426.192297500724;12848.678783030498;11860.644180674593;11896.83115746776;11924.284542927366;12003.57987470443;12086.516539338416;3865.768053916746;3938.1729836734035;3965.2664257112237;4018.557958624549;4073.877783666495;57022.71488642572;59355.40644593542;59371;65167.34832651708;65589.67205163991;10446.268761186644;10627.202959777893;10635.893641063645;10641.308314959502;10940.781184376268;17891.552711182325;18201;18529.351472698392;18533.814661853477;19072.90463547701;7659.655315510815;7782.455228134089;7907.604619768988;7922.049354077432;7999.920000800034;4264.978675106667;4305.268104422255;4320.351947207944;4337.522872484024;4429.734215947054;2667.2398366465463;2772.1822062491615;2772.695003549608;2780.387375322349;2782.8469434181316;492.6009931955056;494.34499288442237;496.149104286151;497.93526841510374;498.17800628961777;614.9907751383732;624.3475568031419;625.433982246068;643.5077165967945;655.1254075808848;7961.164077771867;8458.36562257833;8461.746147615582;8988.191062804248;9038.412503187272;570.5549671256426;615.9045347971072;625.8591816841174;629.5750368501243;631.3465563142217;3856.4408160816524;3931.9606803932165;4018.784205729924;4044.4337792709043;4133.648639865585;93286.06713932774;93907;93909;97244.51377743066;97537;84242.57878710567;84410.5779471111;85579.5721021391;85742.57128714441;86592;72210;74562;74736.62631686807;75653.62173189208;75662.62168689122;7430.665620047002;7441.367483763941;7546.358559522502;7564.773056808304;7685.385169186564;44631.55368446274;45643.315350269106;45673.31490027586;45855.31217031814;46028.7698561505;58373.12440313484;58713.41286587079;63454;66151;66176;11267.323960562393;11429;11499.425028748696;11503.252288601549;11539.134564907497;12341.75316493683;12737.681557961125;13458.596242112751;13566;13999.930000349934;13047.869521305045;13444.731105378034;14013.5095271665;14056.718865622426;14118.929405352908;13127;13164.670883227613;13248.337583120998;13413.128146670826;14020.859791401956;12562.87437125617;12692.936535317263;12703.682407939876;13209;13252;10508.947455262674;10850.620228291971;10916.399598022184;11169.776604467703;11191.608293710007;10978.176636752436;10997.560097596326;11008.614698485515;11273;11377.829332559853
23:02:05 INFO - PROCESS | 3168 | __end_tp_report
23:02:05 INFO - PROCESS | 3168 | __start_cc_report
23:02:05 INFO - PROCESS | 3168 | _x_x_mozilla_cycle_collect,1664
23:02:05 INFO - PROCESS | 3168 | __end_cc_report
23:02:05 INFO - PROCESS | 3168 | __startTimestamp1477288925853__endTimestamp
23:02:05 INFO - PROCESS | 3168 |
23:02:05 INFO - PROCESS | 3168 | ------- Summary: start -------
23:02:05 INFO - PROCESS | 3168 | Number of tests: 6
23:02:05 INFO - PROCESS | 3168 |
23:02:05 INFO - PROCESS | 3168 | [#0] dojo.html Cycles:165 Average:4975.23 Median:5226.76 stddev:644.34 (12.3%) stddev-sans-first:622.81
23:02:05 INFO - PROCESS | 3168 | Values: 2776.6 2790.1 2814.3 2815.3 2837.3 5009.5 5014.3 5048.9 5078.3 5088.3 4908.4 5006.6 5066.7 5081.1 5162.1 4487.7 4504.5 4509.2 4539.9 4586.2 4564.2 4579.2 4590.1 4592.6 4596.7 4497.3 4535.5 4574.8 4591.3 4595.2 4540.1 4586.7 4596.7 4599.0 4616.1 4435.7 4517.7 4529.2 4548.0 4565.5 4960.1 4984.4 4994.3 5030.2 5037.4 5366.1 5378.7 5415.2 5452.2 5456.1 5289.3 5459.9 5491.3 5494.6 5543.4 4937.0 5001.7 5006.7 5047.4 5049.5 5282.9 5555.4 5556.3 5566.5 5568.0 5223.2 5297.5 5298.1 5329.8 5380.1 5353.6 5387.1 5416.3 5417.1 5418.9 5300.4 5352.9 5372.6 5380.6 5389.9 5368.4 5392.8 5396.4 5420.6 5443.1 3643.3 3643.5 3644.7 3657.2 3690.9 3244.7 3255.9 3282.3 3283.3 3326.8 5095.2 5095.6 5100.7 5104.3 5105.3 5470.9 5472.2 5477.0 5477.3 5495.9 5083.9 5100.3 5109.6 5109.8 5114.9 4514.4 4528.1 4533.3 4538.7 4564.7 5462.3 5486.8 5522.0 5530.3 5544.6 5360.1 5419.2 5429.4 5447.4 5473.2 5520.1 5542.1 5549.7 5555.1 5615.4 5244.7 5247.1 5333.4 5356.7 5357.9 5426.5 5427.1 5435.3 5438.2 5438.8 5206.3 5250.9 5285.0 5287.7 5296.5 5174.2 5236.7 5237.7 5280.9 5311.1 5226.8 5227.2 5230.0 5238.3 5296.3 5192.2 5228.2 5233.2 5287.0 5301.7 5212.1 5216.7 5220.1 5297.5 5368.8
23:02:05 INFO - PROCESS | 3168 |
23:02:05 INFO - PROCESS | 3168 | [#1] ext.html Cycles:180 Average:47035.72 Median:34700.63 stddev:87908.72 (253.3%) stddev-sans-first:88086.00
23:02:05 INFO - PROCESS | 3168 | Values: 536.1 550.2 553.1 560.2 573.9 28217.9 35138.6 36403.8 36404.3 38763.2 36909.3 37604.6 37626.2 37649.2 37686.8 7797.0 8080.6 8184.0 8229.1 8232.2 7553.8 7654.6 7680.8 7716.9 9563.4 9528.4 9704.7 9773.1 9783.5 9853.8 9592.0 9629.5 9675.6 9677.3 9686.6 7775.1 7991.3 8019.3 8166.1 9653.6 34027.3 34570.0 34581.0 36849.8 36860.3 3043.6 3043.7 3120.8 3208.7 3407.5 27264.3 27653.9 27675.3 27679.3 27753.9 3519.3 3557.0 3557.6 3627.5 3660.5 279210.0 280058.0 280563.0 280947.0 281092.0 41797.8 43084.4 44511.6 45916.0 45922.3 45718.0 48060.3 48081.3 48148.0 48207.8 13709.8 13784.5 13803.6 13812.9 13856.9 10622.5 10682.6 10738.6 10769.1 10776.2 10469.7 10671.7 13013.9 13506.5 13539.6 5466.8 5505.5 5535.3 5553.6 5602.0 796.4 823.0 845.1 885.6 923.6 26630.6 26899.2 27190.0 27283.3 27350.0 952.3 965.9 989.7 998.2 1001.3 13970.5 14056.0 14157.6 14169.9 14333.6 390368.0 391368.0 393433.0 393896.0 393989.0 44732.8 45029.1 45030.5 45063.0 45113.3 1131.3 1134.2 1152.0 1156.6 1156.6 26142.6 26536.6 26675.9 27179.7 27224.0 40123.0 40381.8 40424.0 40487.4 40506.4 276993.0 326793.0 327184.0 327522.0 327737.0 32600.7 32979.2 32994.1 33363.5 33394.8 34082.5 34096.0 38160.0 39302.8 41735.6 32770.0 33477.2 33686.8 33996.0 34086.1 33712.8 34116.5 34208.1 34429.5 34820.3 32190.2 32272.2 32504.2 32665.5 32788.5 29905.6 31147.8 31151.7 31173.4 31217.5 23761.8 23953.5 24211.3 24386.3 24422.1
23:02:05 INFO - PROCESS | 3168 |
23:02:05 INFO - PROCESS | 3168 | [#2] jquery.html Cycles:180 Average:24523.68 Median:5045.83 stddev:67787.67 (1343.4%) stddev-sans-first:67953.48
23:02:05 INFO - PROCESS | 3168 | Values: 323.4 332.8 335.4 335.5 354.1 13216.5 14289.4 16082.7 16667.4 17766.5 14057.2 14070.4 14110.6 14336.7 14354.8 5050.1 5266.0 5268.3 5274.0 5282.2 3840.8 4044.4 4062.3 5206.2 5236.5 5512.5 5785.0 5788.4 5855.3 5859.0 5606.3 5749.1 5780.3 5828.4 5893.0 5041.5 5057.6 5058.6 5061.8 5061.8 19390.1 19442.8 19640.1 19771.6 19813.4 2032.0 2066.0 2169.7 2176.4 2495.2 12013.2 12403.3 12444.0 12469.8 13011.5 1682.2 1721.0 1763.2 1793.7 1814.4 65815.7 66840.7 67730.0 68252.3 69050.7 8796.6 8849.0 8959.4 9024.2 9056.9 11942.0 11958.0 11959.5 11967.3 11967.3 6560.3 6701.9 6719.4 6792.5 6799.0 6517.0 6528.5 6630.4 6642.7 6759.8 5456.0 5565.5 5592.7 5595.6 5654.5 1528.2 1609.4 1623.4 1629.7 1635.4 728.4 776.7 875.9 889.0 905.4 16629.8 16683.8 16685.8 16741.3 17277.6 770.4 808.2 819.9 824.2 830.1 8893.4 9205.0 9234.9 9247.9 9390.3 397586.0 407868.0 415360.0 416512.0 416632.0 78201.6 80663.6 80802.0 81746.0 81762.2 899.7 902.4 904.5 918.7 921.5 14303.4 14341.9 14374.3 14393.6 14858.4 32369.8 33624.7 34028.7 34871.8 35513.6 48998.5 49049.5 49976.0 50017.5 50286.5 5026.9 7103.4 7105.4 7260.3 7471.7 11243.3 11561.9 11587.9 11774.6 11795.3 9629.8 9780.4 10061.1 10115.9 10116.8 6986.4 7005.4 7053.2 7359.2 7464.3 6925.9 7033.5 7067.8 7160.3 7571.3 10585.8 10927.3 10957.7 11062.6 11251.8 7107.8 8894.4 10558.7 10776.7 11043.4
23:02:05 INFO - PROCESS | 3168 |
23:02:05 INFO - PROCESS | 3168 | [#3] mootools.html Cycles:180 Average:4849.97 Median:5746.11 stddev:2820.38 (49.1%) stddev-sans-first:2814.52
23:02:05 INFO - PROCESS | 3168 | Values: 1140.8 1142.6 1205.2 1394.3 1432.6 7117.1 7584.2 7608.0 7611.3 7618.1 6882.2 7070.4 7251.4 7357.2 7551.7 1942.2 1965.2 1965.8 1965.9 1966.7 1922.8 1935.7 1944.1 1945.0 1953.1 1689.3 1737.4 1854.8 1922.4 1943.7 1892.7 1905.9 1906.0 1909.0 1909.1 1864.3 1876.7 1904.7 1909.2 1913.3 6802.1 6998.7 7179.7 7301.2 7603.2 4282.6 4404.3 4419.2 4420.1 4426.6 2746.2 2814.2 2847.8 2852.4 2861.5 904.2 905.6 919.2 919.5 920.8 10200.1 10223.5 10231.3 10237.5 10253.1 3671.6 3744.7 3812.8 3852.9 3873.0 8559.2 8560.2 8573.8 8634.4 8647.1 4293.7 4305.7 4309.6 4311.2 4321.9 3971.4 3976.1 3986.5 3987.0 3988.7 3184.9 3230.2 3251.3 3266.8 3268.0 950.6 956.1 964.7 966.8 968.2 764.8 772.7 777.0 785.2 788.2 4659.6 4661.7 4838.2 4869.8 4937.1 772.5 814.3 818.5 820.4 822.6 3261.7 3279.8 3329.9 3360.4 3409.8 9048.5 9324.2 9342.9 9382.4 9390.2 9213.3 9265.9 9325.9 9344.8 9346.8 6735.6 6960.7 7027.8 7102.1 7158.9 4739.6 4744.5 4770.5 4795.6 4834.6 8538.0 8599.5 8654.7 8705.7 8737.3 8555.4 8912.2 8968.3 8992.9 8993.6 6464.6 6673.6 6717.6 6839.4 6841.9 7274.1 7296.9 7325.3 7327.9 7337.0 6486.4 6511.5 6515.5 6571.0 6654.5 6520.3 6531.3 6562.6 6588.4 6646.1 5740.3 5751.9 5754.2 5759.9 5771.4 4003.8 4041.5 4041.8 4090.0 4154.0 4064.9 4065.4 4073.8 4092.0 4171.1
23:02:05 INFO - PROCESS | 3168 |
23:02:05 INFO - PROCESS | 3168 | [#4] prototype.html Cycles:180 Average:4482.53 Median:5232.32 stddev:1399.94 (26.8%) stddev-sans-first:1367.53
23:02:05 INFO - PROCESS | 3168 | Values: 260.3 263.1 266.4 267.3 268.3 5052.1 5192.6 5206.9 5225.3 5239.3 5080.5 5091.5 5105.5 5122.9 5125.3 3696.2 3788.5 3803.7 3872.6 3874.8 3859.5 3859.9 3870.6 3872.9 3885.0 3820.7 3827.1 3831.3 3853.4 3868.7 3668.5 3795.3 3801.4 3834.3 3848.2 3206.4 3246.6 3292.3 3301.9 3311.6 4924.6 4942.7 4947.7 4949.6 4999.6 4312.9 4341.0 4443.5 4457.3 4469.8 5274.8 5283.7 5316.3 5316.8 5322.9 3590.6 3599.7 3608.6 3613.8 3621.5 5354.5 5638.2 5643.7 5665.6 5679.4 3625.7 3637.7 3643.0 3661.0 3666.8 3676.4 3682.7 3696.9 3727.1 3731.9 4417.5 4429.5 4435.7 4439.5 4442.8 5380.7 5457.7 5467.0 5494.8 5505.8 1267.9 1282.9 1286.3 1287.7 1287.8 769.0 788.0 799.1 802.3 807.8 4594.9 4607.0 4613.8 4998.7 5158.3 5545.0 5614.3 5673.9 5678.6 5705.6 5277.0 5284.9 5285.0 5285.7 5287.2 2845.7 2959.9 2981.9 2986.9 2991.7 5714.7 5719.4 5723.9 5778.0 5789.0 5571.5 5628.2 5706.9 5740.3 5760.9 5661.9 5680.7 5699.9 5713.2 5769.9 5611.5 5628.6 5664.2 5697.0 5726.9 5394.9 5533.1 5560.5 5590.0 5590.7 5670.0 5670.7 5678.9 5683.9 5688.3 3636.3 3706.7 3707.1 3707.3 3713.7 5408.9 5563.8 5686.3 5709.8 5730.3 5392.5 5407.0 5407.4 5408.3 5573.5 5211.3 5460.3 5463.1 5483.8 5485.9 5375.4 5378.9 5429.4 5444.5 5486.9 5197.7 5370.7 5433.2 5442.9 5454.5 5268.0 5388.7 5406.5 5420.1 5493.9
23:02:05 INFO - PROCESS | 3168 |
23:02:05 INFO - PROCESS | 3168 | [#5] yui.html Cycles:180 Average:17991.11 Median:24530.64 stddev:25128.81 (102.4%) stddev-sans-first:25165.46
23:02:05 INFO - PROCESS | 3168 | Values: 622.7 642.8 663.0 701.7 711.5 12980.7 12995.7 13386.3 13831.5 14022.5 12157.9 13198.3 13276.9 13277.5 13302.1 568.6 629.5 645.2 645.9 646.6 577.8 640.8 658.2 661.4 664.5 690.0 691.3 692.8 694.9 695.0 585.7 692.4 692.6 694.5 694.6 441.9 487.8 496.2 496.6 501.0 12080.2 12083.7 12091.8 12099.5 12110.7 11598.5 12137.5 12256.9 12426.2 12848.7 11860.6 11896.8 11924.3 12003.6 12086.5 3865.8 3938.2 3965.3 4018.6 4073.9 57022.7 59355.4 59371.0 65167.3 65589.7 10446.3 10627.2 10635.9 10641.3 10940.8 17891.6 18201.0 18529.4 18533.8 19072.9 7659.7 7782.5 7907.6 7922.0 7999.9 4265.0 4305.3 4320.4 4337.5 4429.7 2667.2 2772.2 2772.7 2780.4 2782.8 492.6 494.3 496.1 497.9 498.2 615.0 624.3 625.4 643.5 655.1 7961.2 8458.4 8461.7 8988.2 9038.4 570.6 615.9 625.9 629.6 631.3 3856.4 3932.0 4018.8 4044.4 4133.6 93286.1 93907.0 93909.0 97244.5 97537.0 84242.6 84410.6 85579.6 85742.6 86592.0 72210.0 74562.0 74736.6 75653.6 75662.6 7430.7 7441.4 7546.4 7564.8 7685.4 44631.6 45643.3 45673.3 45855.3 46028.8 58373.1 58713.4 63454.0 66151.0 66176.0 11267.3 11429.0 11499.4 11503.3 11539.1 12341.8 12737.7 13458.6 13566.0 13999.9 13047.9 13444.7 14013.5 14056.7 14118.9 13127.0 13164.7 13248.3 13413.1 14020.9 12562.9 12692.9 12703.7 13209.0 13252.0 10508.9 10850.6 10916.4 11169.8 11191.6 10978.2 10997.6 11008.6 11273.0 11377.8
23:02:05 INFO - PROCESS | 3168 | -------- Summary: end --------
23:02:05 INFO - PROCESS | 3168 |
23:02:06 INFO - TEST-INFO | 3168: exit 0
23:02:07 INFO - TEST-OK | dromaeo_css | took 1122504ms
23:02:07 INFO - TEST-START | kraken
23:02:07 INFO - operating with platform_type : w8_
23:02:07 INFO - Initialising browser for kraken test...
23:02:07 INFO - TEST-INFO | started process 3940 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmp_ws0mv\profile http://localhost:49278/getInfo.html)
23:02:12 INFO - PROCESS | 3940 | __metrics Screen width/height:1600/1200
23:02:12 INFO - PROCESS | 3940 | colorDepth:24
23:02:12 INFO - PROCESS | 3940 | Browser inner width/height: 1010/674
23:02:12 INFO - PROCESS | 3940 | __metrics
23:02:13 INFO - PROCESS | 3940 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows"
23:02:13 INFO - PROCESS | 3940 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver]
23:02:13 INFO - PROCESS | 3940 | console.error:
23:02:13 INFO - PROCESS | 3940 | Message: Error: Connection closed before committing the transaction.
23:02:13 INFO - PROCESS | 3940 | Stack:
23:02:13 INFO - PROCESS | 3940 | ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:937:23
23:02:13 INFO - PROCESS | 3940 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7
23:02:13 INFO - PROCESS | 3940 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11
23:02:13 INFO - PROCESS | 3940 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7
23:02:13 INFO - PROCESS | 3940 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:714:7
23:02:13 INFO - PROCESS | 3940 | TaskImpl_run@resource://gre/modules/Task.jsm:327:15
23:02:13 INFO - PROCESS | 3940 | Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:551:9
23:02:13 INFO - PROCESS | 3940 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15
23:02:13 INFO - PROCESS | 3940 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:388:5
23:02:13 INFO - PROCESS | 3940 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29
23:02:13 INFO - PROCESS | 3940 | Barrier/this.client.addBlocker/promise13.3%
23:03:11 INFO - TinderboxPrint: I/O read bytes / time
76,516,864 / 565,790
23:03:11 INFO - TinderboxPrint: I/O write bytes / time
410,699,264 / 3,830,700
23:03:11 INFO - TinderboxPrint: CPU idle
8,260.8 (86.7%)
23:03:11 INFO - TinderboxPrint: CPU user
1,223.6 (12.8%)
23:03:11 INFO - install - Wall time: 3s; CPU: 11.0%; Read bytes: 0; Write bytes: 33169408; Read time: 0; Write time: 36190
23:03:11 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 76516864; Write bytes: 321398272; Read time: 565790; Write time: 3648350
23:03:11 INFO - Running post-run listener: _upload_blobber_files
23:03:11 INFO - Blob upload gear active.
23:03:11 INFO - Preparing to upload files from C:\slave\test\build\blobber_upload_dir.
23:03:11 INFO - Files from C:\slave\test\build\blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com
23:03:11 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', 'Autoland', '-d', 'C:\\slave\\test\\build\\blobber_upload_dir', '--output-manifest', 'C:\\slave\\test\\build\\uploaded_files.json']
23:03:11 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 Autoland -d C:\slave\test\build\blobber_upload_dir --output-manifest C:\slave\test\build\uploaded_files.json
23:03:12 INFO - (blobuploader) - INFO - Open directory for files ...
23:03:12 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_errorsummary.log ...
23:03:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
23:03:12 INFO - (blobuploader) - INFO - Uploading, attempt #1.
23:03:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded
23:03:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
23:03:13 INFO - (blobuploader) - INFO - Done attempting.
23:03:13 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_raw.log ...
23:03:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
23:03:13 INFO - (blobuploader) - INFO - Uploading, attempt #1.
23:03:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded
23:03:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
23:03:14 INFO - (blobuploader) - INFO - Done attempting.
23:03:14 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\resource-usage.json ...
23:03:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
23:03:14 INFO - (blobuploader) - INFO - Uploading, attempt #1.
23:03:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded
23:03:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
23:03:16 INFO - (blobuploader) - INFO - Done attempting.
23:03:16 INFO - (blobuploader) - INFO - Iteration through files over.
23:03:16 INFO - Return code: 0
23:03:16 INFO - rmtree: C:\slave\test\build\uploaded_files.json
23:03:16 INFO - Using _rmtree_windows ...
23:03:16 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build\\uploaded_files.json',), kwargs: {}, attempt #1
23:03:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/006d07fa3c3153abab1b371e4f71e05891c515629adfa12eccc74925baa45753f00d8954bde58f39c13e3fc75ca160c674589e87a7414cb829c2866c0759f4b1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0abf408c46169ce671c79417b743ab55dddccc99d0bcd7f27ec7b43967f0c9ddb484651033b9365ee0a5b523693082b99e6d56363a6af789407e439eee3b5775", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ce9ea749a61493d2898bde4c530dba4e9be1fbe1073f3a7870d4d97c8081a3474cb370740254beec4874c6bebc163534ea76459f0d1d3543a273bfd11431dbbe"}
23:03:16 INFO - Writing buildbot properties ['blobber_files'] to C:\slave\test\properties\blobber_files
23:03:16 INFO - Writing to file C:\slave\test\properties\blobber_files
23:03:16 INFO - Contents:
23:03:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/006d07fa3c3153abab1b371e4f71e05891c515629adfa12eccc74925baa45753f00d8954bde58f39c13e3fc75ca160c674589e87a7414cb829c2866c0759f4b1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0abf408c46169ce671c79417b743ab55dddccc99d0bcd7f27ec7b43967f0c9ddb484651033b9365ee0a5b523693082b99e6d56363a6af789407e439eee3b5775", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ce9ea749a61493d2898bde4c530dba4e9be1fbe1073f3a7870d4d97c8081a3474cb370740254beec4874c6bebc163534ea76459f0d1d3543a273bfd11431dbbe"}
23:03:16 INFO - Running post-run listener: copy_logs_to_upload_dir
23:03:16 INFO - Copying logs to upload dir...
23:03:16 INFO - mkdir: C:\slave\test\build\upload\logs
23:03:16 INFO - Copying logs to upload dir...
23:03:16 INFO - Using _rmtree_windows ...
23:03:16 INFO - Using _rmtree_windows ...
23:03:16 INFO - Using _rmtree_windows ...
23:03:16 INFO - Using _rmtree_windows ...
23:03:16 INFO - Using _rmtree_windows ...
23:03:16 INFO - Using _rmtree_windows ...
23:03:16 INFO - Using _rmtree_windows ...
program finished with exit code 0
elapsedTime=1389.616000
========= master_lag: 0.03 =========
========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 9 secs) (at 2016-10-23 23:03:16.474423) =========
========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-23 23:03:16.482556) =========
'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-023\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-023
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-023
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-023\AppData\Local
LOGONSERVER=\\T-W864-IX-023
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-023
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-023
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-023
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/006d07fa3c3153abab1b371e4f71e05891c515629adfa12eccc74925baa45753f00d8954bde58f39c13e3fc75ca160c674589e87a7414cb829c2866c0759f4b1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0abf408c46169ce671c79417b743ab55dddccc99d0bcd7f27ec7b43967f0c9ddb484651033b9365ee0a5b523693082b99e6d56363a6af789407e439eee3b5775", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ce9ea749a61493d2898bde4c530dba4e9be1fbe1073f3a7870d4d97c8081a3474cb370740254beec4874c6bebc163534ea76459f0d1d3543a273bfd11431dbbe"}
build_url:https://queue.taskcluster.net/v1/task/b1i22o8PSsuKkzCSA29Fkw/artifacts/public/build/firefox-52.0a1.en-US.win64.zip
program finished with exit code 0
elapsedTime=0.101000
build_url: 'https://queue.taskcluster.net/v1/task/b1i22o8PSsuKkzCSA29Fkw/artifacts/public/build/firefox-52.0a1.en-US.win64.zip'
blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/006d07fa3c3153abab1b371e4f71e05891c515629adfa12eccc74925baa45753f00d8954bde58f39c13e3fc75ca160c674589e87a7414cb829c2866c0759f4b1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0abf408c46169ce671c79417b743ab55dddccc99d0bcd7f27ec7b43967f0c9ddb484651033b9365ee0a5b523693082b99e6d56363a6af789407e439eee3b5775", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ce9ea749a61493d2898bde4c530dba4e9be1fbe1073f3a7870d4d97c8081a3474cb370740254beec4874c6bebc163534ea76459f0d1d3543a273bfd11431dbbe"}'
========= master_lag: 0.02 =========
========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-23 23:03:16.602974) =========
========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 23:03:16.603319) =========
'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-023\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-023
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-023
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-023\AppData\Local
LOGONSERVER=\\T-W864-IX-023
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-023
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-023
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-023
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
program finished with exit code 0
elapsedTime=0.101000
========= master_lag: 0.02 =========
========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 23:03:16.721393) =========
========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-10-23 23:03:16.721692) =========
========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-10-23 23:03:17.192370) =========
========= Total master_lag: 0.22 =========