builder: fx-team_win8_64_test-dromaeojs-pgo
slave: t-w864-ix-152
starttime: 1476403476.98
results: success (0)
buildid: 20161013123018
builduid: d1ace9580dd04d3c8b85f40a81349036
revision: 62ccb498db3ec05bef1b6427d5b1b4b0e501cad5
========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 17:04:36.979827) =========
master: http://buildbot-master126.bb.releng.scl3.mozilla.com:8201/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 17:04:36.980305) =========
========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 17:04:36.980586) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 17:04:37.100549) =========
========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-13 17:04:37.100947) =========
'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-152\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-152
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-152
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-152\AppData\Local
LOGONSERVER=\\T-W864-IX-152
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-152
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-152
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-152
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
--17:04:38-- 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
17:04:38 (2.27 GB/s) - `archiver_client.py' saved [12179/12179]
program finished with exit code 0
elapsedTime=1.338000
========= master_lag: 0.05 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-13 17:04:38.492632) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 4 secs) (at 2016-10-13 17:04:38.493246) =========
'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-152\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-152
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-152
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-152\AppData\Local
LOGONSERVER=\\T-W864-IX-152
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-152
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-152
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-152
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
program finished with exit code 0
elapsedTime=4.010000
========= master_lag: 0.02 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 4 secs) (at 2016-10-13 17:04:42.526570) =========
========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-13 17:04:42.526950) =========
'bash' '-c' u'python archiver_client.py mozharness --repo integration/fx-team --rev 62ccb498db3ec05bef1b6427d5b1b4b0e501cad5 --destination scripts --debug'
in dir C:\slave\test\. (timeout 1200 secs)
watching logfiles {}
argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 62ccb498db3ec05bef1b6427d5b1b4b0e501cad5 --destination scripts --debug']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld.T-W864-IX-152\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-152
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-152
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-152\AppData\Local
LOGONSERVER=\\T-W864-IX-152
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-152
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-152
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-152
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
2016-10-13 17:04:43,345 truncating revision to first 12 chars
2016-10-13 17:04:43,345 Setting DEBUG logging.
2016-10-13 17:04:43,345 attempt 1/10
2016-10-13 17:04:43,345 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/62ccb498db3e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2016-10-13 17:04:44,778 unpacking tar archive at: fx-team-62ccb498db3e/testing/mozharness/
2016-10-13 17:04:44,897 skipping symlink on windows: configs/single_locale/linux32.py
program finished with exit code 0
elapsedTime=2.134000
========= master_lag: 0.06 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-13 17:04:44.721179) =========
========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 17:04:44.721782) =========
script_repo_revision: 62ccb498db3ec05bef1b6427d5b1b4b0e501cad5
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 17:04:44.722449) =========
========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 17:04:44.722906) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 17:04:44.742896) =========
========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 12 secs) (at 2016-10-13 17:04:44.743535) =========
'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'dromaeojs' '--add-option' '--webServer,localhost' '--branch-name' 'Fx-Team' '--cfg' 'talos/windows_config.py' '--download-symbols' 'ondemand' '--use-talos-json' '--blob-upload-branch' 'Fx-Team'
in dir C:\slave\test\. (timeout 3600 secs) (maxTime 7200 secs)
watching logfiles {}
argv: ['c:/mozilla-build/python27/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/windows_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld.T-W864-IX-152\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-152
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-152
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-152\AppData\Local
LOGONSERVER=\\T-W864-IX-152
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-152
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-152
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-152
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
17:04:45 INFO - MultiFileLogger online at 20161013 17:04:45 in C:\slave\test
17:04:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team
17:04:45 INFO - Dumping config to C:\slave\test\logs\localconfig.json.
17:04:45 INFO - {'append_to_log': False,
17:04:45 INFO - 'base_work_dir': 'C:\\slave\\test',
17:04:45 INFO - 'blob_upload_branch': 'Fx-Team',
17:04:45 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt',
17:04:45 INFO - 'branch': 'Fx-Team',
17:04:45 INFO - 'buildbot_json_path': 'buildprops.json',
17:04:45 INFO - 'config_files': ('talos/windows_config.py',),
17:04:45 INFO - 'default_actions': ('clobber',
17:04:45 INFO - 'read-buildbot-config',
17:04:45 INFO - 'download-and-extract',
17:04:45 INFO - 'populate-webroot',
17:04:45 INFO - 'create-virtualenv',
17:04:45 INFO - 'install',
17:04:45 INFO - 'run-tests'),
17:04:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',),
17:04:45 INFO - 'download_minidump_stackwalk': True,
17:04:45 INFO - 'download_symbols': 'ondemand',
17:04:45 INFO - 'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python',
17:04:45 INFO - 'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'),
17:04:45 INFO - 'hg': 'c:/mozilla-build/hg/hg',
17:04:45 INFO - 'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python',
17:04:45 INFO - 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'),
17:04:45 INFO - 'python': 'c:/mozilla-build/python27/python.exe',
17:04:45 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe',
17:04:45 INFO - 'C:/mozilla-build/tooltool.py'),
17:04:45 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe',
17:04:45 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')},
17:04:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub',
17:04:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'),
17:04:45 INFO - 'installer_path': 'installer.exe',
17:04:45 INFO - 'log_level': 'info',
17:04:45 INFO - 'log_name': 'talos',
17:04:45 INFO - 'log_to_console': True,
17:04:45 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe',
17:04:45 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe',
17:04:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest',
17:04:45 INFO - 'opt_config_files': (),
17:04:45 INFO - 'pip_index': False,
17:04:45 INFO - 'sps_profile': False,
17:04:45 INFO - 'sps_profile_interval': 0,
17:04:45 INFO - 'suite': 'dromaeojs',
17:04:45 INFO - 'system_bits': '32',
17:04:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'),
17:04:45 INFO - 'title': 'T-W864-IX-152',
17:04:45 INFO - 'use_talos_json': True,
17:04:45 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'),
17:04:45 INFO - 'virtualenv_path': 'C:\\slave\\test\\build/venv',
17:04:45 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll',
17:04:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
17:04:45 INFO - 'work_dir': 'build'}
17:04:45 INFO - [mozharness: 2016-10-14 00:04:45.833000Z] Running clobber step.
17:04:45 INFO - Running pre-action listener: _resource_record_pre_action
17:04:45 INFO - Running main action method: clobber
17:04:45 INFO - rmtree: C:\slave\test\build
17:04:45 INFO - Using _rmtree_windows ...
17:04:45 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1
17:06:21 INFO - Running post-action listener: _resource_record_post_action
17:06:21 INFO - [mozharness: 2016-10-14 00:06:21.115000Z] Finished clobber step (success)
17:06:21 INFO - [mozharness: 2016-10-14 00:06:21.115000Z] Running read-buildbot-config step.
17:06:21 INFO - Running pre-action listener: _resource_record_pre_action
17:06:21 INFO - Running main action method: read_buildbot_config
17:06:21 INFO - Using buildbot properties:
17:06:21 INFO - {
17:06:21 INFO - "project": "",
17:06:21 INFO - "product": "firefox",
17:06:21 INFO - "script_repo_revision": "production",
17:06:21 INFO - "builddir": "fx-team_win8_64_test-dromaeojs",
17:06:21 INFO - "repository": "",
17:06:21 INFO - "buildername": "Windows 8 64-bit fx-team pgo talos dromaeojs",
17:06:21 INFO - "buildid": "20161013123018",
17:06:21 INFO - "pgo_build": "True",
17:06:21 INFO - "basedir": "C:\\slave\\test",
17:06:21 INFO - "buildnumber": 31,
17:06:21 INFO - "slavename": "t-w864-ix-152",
17:06:21 INFO - "master": "http://buildbot-master126.bb.releng.scl3.mozilla.com:8201/",
17:06:21 INFO - "platform": "win8_64",
17:06:21 INFO - "scheduler": "tests-fx-team-win64-pgo-talos",
17:06:21 INFO - "branch": "fx-team",
17:06:21 INFO - "repo_path": "integration/fx-team",
17:06:21 INFO - "revision": "62ccb498db3ec05bef1b6427d5b1b4b0e501cad5",
17:06:21 INFO - "stage_platform": "win64-pgo",
17:06:21 INFO - "builduid": "d1ace9580dd04d3c8b85f40a81349036",
17:06:21 INFO - "slavebuilddir": "test"
17:06:21 INFO - }
17:06:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/IviLE9gZSRCcZglg5E817Q/artifacts/public/build/firefox-52.0a1.en-US.win64.zip.
17:06:21 INFO - Running post-action listener: _resource_record_post_action
17:06:21 INFO - [mozharness: 2016-10-14 00:06:21.119000Z] Finished read-buildbot-config step (success)
17:06:21 INFO - [mozharness: 2016-10-14 00:06:21.119000Z] Running download-and-extract step.
17:06:21 INFO - Running pre-action listener: _resource_record_pre_action
17:06:21 INFO - Running main action method: download_and_extract
17:06:21 INFO - mkdir: C:\slave\test\build\tests
17:06: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')]}
17:06:21 INFO - trying https://queue.taskcluster.net/v1/task/IviLE9gZSRCcZglg5E817Q/artifacts/public/build/firefox-52.0a1.en-US.win64.test_packages.json
17:06:21 INFO - Downloading https://queue.taskcluster.net/v1/task/IviLE9gZSRCcZglg5E817Q/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
17:06:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IviLE9gZSRCcZglg5E817Q/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
17:06:21 INFO - Downloaded 1218 bytes.
17:06:21 INFO - Reading from file C:\slave\test\build\firefox-52.0a1.en-US.win64.test_packages.json
17:06:21 INFO - Using the following test package requirements:
17:06:21 INFO - {u'common': [u'firefox-52.0a1.en-US.win64.common.tests.zip'],
17:06:21 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.win64.common.tests.zip',
17:06:21 INFO - u'firefox-52.0a1.en-US.win64.cppunittest.tests.zip'],
17:06:21 INFO - u'gtest': [u'firefox-52.0a1.en-US.win64.common.tests.zip'],
17:06:21 INFO - u'jittest': [u'firefox-52.0a1.en-US.win64.common.tests.zip',
17:06:21 INFO - u'jsshell-win64.zip'],
17:06:21 INFO - u'mochitest': [u'firefox-52.0a1.en-US.win64.common.tests.zip',
17:06:21 INFO - u'firefox-52.0a1.en-US.win64.mochitest.tests.zip'],
17:06:21 INFO - u'mozbase': [u'firefox-52.0a1.en-US.win64.common.tests.zip'],
17:06:21 INFO - u'reftest': [u'firefox-52.0a1.en-US.win64.common.tests.zip',
17:06:21 INFO - u'firefox-52.0a1.en-US.win64.reftest.tests.zip'],
17:06:21 INFO - u'talos': [u'firefox-52.0a1.en-US.win64.common.tests.zip',
17:06:21 INFO - u'firefox-52.0a1.en-US.win64.talos.tests.zip'],
17:06:21 INFO - u'web-platform': [u'firefox-52.0a1.en-US.win64.common.tests.zip',
17:06:21 INFO - u'firefox-52.0a1.en-US.win64.web-platform.tests.zip'],
17:06:21 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.win64.common.tests.zip',
17:06:21 INFO - u'firefox-52.0a1.en-US.win64.xpcshell.tests.zip']}
17:06:21 INFO - Downloading packages: [u'firefox-52.0a1.en-US.win64.common.tests.zip'] for test suite category: common
17:06:21 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/IviLE9gZSRCcZglg5E817Q/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip
17:06:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IviLE9gZSRCcZglg5E817Q/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip'}, attempt #1
17:06:21 INFO - Fetch https://queue.taskcluster.net/v1/task/IviLE9gZSRCcZglg5E817Q/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip into memory
17:06:22 INFO - Http code: 200
17:06:22 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront)
17:06:22 INFO - x-amz-cf-id: UpAoFd4kumV_wUL3v_a28DHLhruWR7oe5IHLTBeAjfblQUWtiXzaVA==
17:06:22 INFO - x-amz-version-id: fgMu2NmoWu0QfelylPiw4POyx6WrolCh
17:06:23 INFO - Expected file size: 17556144
17:06:23 INFO - Obtained file size: 17556144
17:06:43 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
17:06:43 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/IviLE9gZSRCcZglg5E817Q/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip
17:06:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IviLE9gZSRCcZglg5E817Q/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip'}, attempt #1
17:06:43 INFO - Fetch https://queue.taskcluster.net/v1/task/IviLE9gZSRCcZglg5E817Q/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip into memory
17:06:44 INFO - Http code: 200
17:06:44 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront)
17:06:44 INFO - x-amz-cf-id: UAUlG4ijqwC6D-X1n_WNAofvXZh8qqNyRCfTjUymhOcHt5iuo89Atw==
17:06:44 INFO - x-amz-version-id: fgMu2NmoWu0QfelylPiw4POyx6WrolCh
17:06:44 INFO - Expected file size: 17556144
17:06:44 INFO - Obtained file size: 17556144
17:06:53 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/IviLE9gZSRCcZglg5E817Q/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip
17:06:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IviLE9gZSRCcZglg5E817Q/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip'}, attempt #1
17:06:53 INFO - Fetch https://queue.taskcluster.net/v1/task/IviLE9gZSRCcZglg5E817Q/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip into memory
17:06:54 INFO - Http code: 200
17:06:54 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront)
17:06:54 INFO - x-amz-cf-id: Q5DwNhpGMhNMe7ooszOCVl2ahpUBX857PlSyDwynnR23cZuwklLYwA==
17:06:54 INFO - x-amz-version-id: lgfZla9PNe8k7iYGmdbBxOW_yZyVihEZ
17:06:55 INFO - Expected file size: 14409006
17:06:55 INFO - Obtained file size: 14409006
17:07:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
17:07:05 INFO - trying https://queue.taskcluster.net/v1/task/IviLE9gZSRCcZglg5E817Q/artifacts/public/build/firefox-52.0a1.en-US.win64.zip
17:07:05 INFO - Downloading https://queue.taskcluster.net/v1/task/IviLE9gZSRCcZglg5E817Q/artifacts/public/build/firefox-52.0a1.en-US.win64.zip to C:\slave\test\build\firefox-52.0a1.en-US.win64.zip
17:07:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IviLE9gZSRCcZglg5E817Q/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
17:07:08 INFO - Downloaded 57706134 bytes.
17:07:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IviLE9gZSRCcZglg5E817Q/artifacts/public/build/firefox-52.0a1.en-US.win64.zip
17:07:08 INFO - mkdir: C:\slave\test\properties
17:07:08 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url
17:07:08 INFO - Writing to file C:\slave\test\properties\build_url
17:07:08 INFO - Contents:
17:07:08 INFO - build_url:https://queue.taskcluster.net/v1/task/IviLE9gZSRCcZglg5E817Q/artifacts/public/build/firefox-52.0a1.en-US.win64.zip
17:07:08 INFO - Running post-action listener: _resource_record_post_action
17:07:08 INFO - Running post-action listener: set_extra_try_arguments
17:07:08 INFO - [mozharness: 2016-10-14 00:07:08.840000Z] Finished download-and-extract step (success)
17:07:08 INFO - [mozharness: 2016-10-14 00:07:08.840000Z] Running populate-webroot step.
17:07:08 INFO - Running pre-action listener: _resource_record_pre_action
17:07:08 INFO - Running main action method: populate_webroot
17:07:08 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']},
17:07:08 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']},
17:07:08 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome',
17:07:08 INFO - u'--tppagecycles',
17:07:08 INFO - u'7'],
17:07:08 INFO - u'tests': [u'tsvgm']}},
17:07:08 INFO - u'suites': {u'chromez': {u'talos_options': [u'--disable-e10s'],
17:07:08 INFO - u'tests': [u'tresize', u'tcanvasmark']},
17:07:08 INFO - u'chromez-e10s': {u'tests': [u'tresize', u'tcanvasmark']},
17:07:08 INFO - u'dromaeojs': {u'talos_options': [u'--disable-e10s'],
17:07:08 INFO - u'tests': [u'dromaeo_css', u'kraken']},
17:07:08 INFO - u'dromaeojs-e10s': {u'tests': [u'dromaeo_css', u'kraken']},
17:07:08 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
17:07:08 INFO - u'talos_options': [u'--disable-e10s'],
17:07:08 INFO - u'tests': [u'tp5o_scroll', u'glterrain']},
17:07:08 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
17:07:08 INFO - u'tests': [u'tp5o_scroll', u'glterrain']},
17:07:08 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
17:07:08 INFO - u'talos_options': [u'--disable-e10s'],
17:07:08 INFO - u'tests': [u'damp', u'tps']},
17:07:08 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
17:07:08 INFO - u'tests': [u'damp', u'tps']},
17:07:08 INFO - u'g3': {u'talos_options': [u'--disable-e10s'],
17:07:08 INFO - u'tests': [u'dromaeo_dom']},
17:07:08 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']},
17:07:08 INFO - u'g4': {u'talos_options': [u'--disable-e10s'],
17:07:08 INFO - u'tests': [u'basic_compositor_video']},
17:07:08 INFO - u'g4-e10s': {u'tests': [u'basic_compositor_video']},
17:07:08 INFO - u'other': {u'talos_options': [u'--disable-e10s'],
17:07:08 INFO - u'tests': [u'a11yr',
17:07:08 INFO - u'ts_paint',
17:07:08 INFO - u'tpaint',
17:07:08 INFO - u'sessionrestore',
17:07:08 INFO - u'sessionrestore_no_auto_restore',
17:07:08 INFO - u'tabpaint']},
17:07:08 INFO - u'other-e10s': {u'tests': [u'a11yr',
17:07:08 INFO - u'ts_paint',
17:07:08 INFO - u'tpaint',
17:07:08 INFO - u'sessionrestore',
17:07:08 INFO - u'sessionrestore_no_auto_restore',
17:07:08 INFO - u'tabpaint']},
17:07:08 INFO - u'other-e10s_l64': {u'tests': [u'a11yr',
17:07:08 INFO - u'ts_paint',
17:07:08 INFO - u'tpaint',
17:07:08 INFO - u'sessionrestore',
17:07:08 INFO - u'sessionrestore_no_auto_restore',
17:07:08 INFO - u'tabpaint']},
17:07:08 INFO - u'other-e10s_nol64': {u'tests': [u'a11yr',
17:07:08 INFO - u'ts_paint',
17:07:08 INFO - u'tpaint',
17:07:08 INFO - u'sessionrestore',
17:07:08 INFO - u'sessionrestore_no_auto_restore',
17:07:08 INFO - u'tabpaint']},
17:07:08 INFO - u'other_l64': {u'talos_options': [u'--disable-e10s'],
17:07:08 INFO - u'tests': [u'a11yr',
17:07:08 INFO - u'ts_paint',
17:07:08 INFO - u'tpaint',
17:07:08 INFO - u'sessionrestore',
17:07:08 INFO - u'sessionrestore_no_auto_restore',
17:07:08 INFO - u'tabpaint']},
17:07:08 INFO - u'other_nol64': {u'talos_options': [u'--disable-e10s'],
17:07:08 INFO - u'tests': [u'a11yr',
17:07:08 INFO - u'ts_paint',
17:07:08 INFO - u'tpaint',
17:07:08 INFO - u'sessionrestore',
17:07:08 INFO - u'sessionrestore_no_auto_restore',
17:07:08 INFO - u'tabpaint']},
17:07:08 INFO - u'svgr': {u'talos_options': [u'--disable-e10s'],
17:07:08 INFO - u'tests': [u'tsvgx',
17:07:08 INFO - u'tsvgr_opacity',
17:07:08 INFO - u'tart',
17:07:08 INFO - u'tscrollx',
17:07:08 INFO - u'cart']},
17:07:08 INFO - u'svgr-e10s': {u'tests': [u'tsvgx',
17:07:08 INFO - u'tsvgr_opacity',
17:07:08 INFO - u'tart',
17:07:08 INFO - u'tscrollx',
17:07:08 INFO - u'cart']},
17:07:08 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
17:07:08 INFO - u'talos_options': [u'--disable-e10s'],
17:07:08 INFO - u'tests': [u'tp5o']},
17:07:08 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
17:07:08 INFO - u'tests': [u'tp5o']},
17:07:08 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
17:07:08 INFO - u'talos_options': [u'--disable-e10s',
17:07:08 INFO - u'--xperf_path',
17:07:08 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
17:07:08 INFO - u'tests': [u'tp5n']},
17:07:08 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
17:07:08 INFO - u'talos_options': [u'--xperf_path',
17:07:08 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
17:07:08 INFO - u'tests': [u'tp5n']}},
17:07:08 INFO - u'talos.zip': {u'path': u'',
17:07:08 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}}
17:07:08 INFO - Running post-action listener: _resource_record_post_action
17:07:08 INFO - [mozharness: 2016-10-14 00:07:08.864000Z] Finished populate-webroot step (success)
17:07:08 INFO - [mozharness: 2016-10-14 00:07:08.864000Z] Running create-virtualenv step.
17:07:08 INFO - Running pre-action listener: _resource_record_pre_action
17:07:08 INFO - Running main action method: create_virtualenv
17:07:08 INFO - Creating virtualenv C:\slave\test\build/venv
17:07:08 INFO - mkdir: C:\slave\test\build\venv\Scripts
17:07:09 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll
17:07:09 WARNING - Can't copy c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll: [Errno 2] No such file or directory: 'c:/mozilla-build/python27/python27.dll'!
17:07:09 INFO - Running command: ['c:/mozilla-build/python27/python.exe', 'c:/mozilla-build/buildbotve/virtualenv.py', '--no-site-packages', '--distribute', 'C:\\slave\\test\\build/venv'] in C:\slave\test\build
17:07:09 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build/venv
17:07:14 INFO - New python executable in C:\slave\test\build/venv\Scripts\python.exe
17:07:18 INFO - Installing distribute......................................................................................................................................................................................done.
17:07:19 INFO - Return code: 0
17:07:19 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', '--version']
17:07:19 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip --version
17:07:20 INFO - Reading from file tmpfile_stdout
17:07:20 INFO - Output received:
17:07:20 INFO - pip 0.8.2 from c:\slave\test\build\venv\lib\site-packages\pip-0.8.2-py2.7.egg (python 2.7)
17:07:20 INFO - Using _rmtree_windows ...
17:07:20 INFO - Using _rmtree_windows ...
17:07:20 INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv
17:07:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
17:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
17:07:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
17:07:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
17:07:20 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 0x0226C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02313E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0241EAC0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0235AE90>, '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 0x004DA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027FD520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-152', 'USERDOMAIN': 'T-W864-IX-152', '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-152', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-152\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-152', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-152', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-152', '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-152\\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
17:07:20 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
17:07:20 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
17:07:20 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
17:07:20 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-152\\AppData\\Roaming',
17:07:20 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
17:07:20 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
17:07:20 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
17:07:20 INFO - 'COMPUTERNAME': 'T-W864-IX-152',
17:07:20 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
17:07:20 INFO - 'DCLOCATION': 'SCL3',
17:07:20 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
17:07:20 INFO - 'FP_NO_HOST_CHECK': 'NO',
17:07:20 INFO - 'HOMEDRIVE': 'C:',
17:07:20 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-152',
17:07:20 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
17:07:20 INFO - 'KTS_VERSION': '1.19c',
17:07:20 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-152\\AppData\\Local',
17:07:20 INFO - 'LOGONSERVER': '\\\\T-W864-IX-152',
17:07:20 INFO - 'MONDIR': 'C:\\Monitor_config\\',
17:07:20 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
17:07:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
17:07:20 INFO - 'MOZ_NO_REMOTE': '1',
17:07:20 INFO - 'NO_EM_RESTART': '1',
17:07:20 INFO - 'NUMBER_OF_PROCESSORS': '8',
17:07:20 INFO - 'OS': 'Windows_NT',
17:07:20 INFO - 'OURDRIVE': 'C:',
17:07:20 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
17:07:20 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
17:07:20 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
17:07:20 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
17:07:20 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
17:07:20 INFO - 'PROCESSOR_LEVEL': '6',
17:07:20 INFO - 'PROCESSOR_REVISION': '1e05',
17:07:20 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
17:07:20 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
17:07:20 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
17:07:20 INFO - 'PROGRAMW6432': 'C:\\Program Files',
17:07:20 INFO - 'PROMPT': '$P$G',
17:07:20 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
17:07:20 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
17:07:20 INFO - 'PUBLIC': 'C:\\Users\\Public',
17:07:20 INFO - 'PWD': 'C:\\slave\\test',
17:07:20 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
17:07:20 INFO - 'SLAVEDIR': 'C:\\slave\\',
17:07:20 INFO - 'SYSTEMDRIVE': 'C:',
17:07:20 INFO - 'SYSTEMROOT': 'C:\\windows',
17:07:20 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
17:07:20 INFO - 'TEST1': 'testie',
17:07:20 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
17:07:20 INFO - 'USERDOMAIN': 'T-W864-IX-152',
17:07:20 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-152',
17:07:20 INFO - 'USERNAME': 'cltbld',
17:07:20 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-152',
17:07:20 INFO - 'WINDIR': 'C:\\windows',
17:07:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
17:07:20 INFO - Ignoring indexes: http://pypi.python.org/simple/
17:07:20 INFO - Downloading/unpacking pip>=1.5
17:07:25 INFO - Running setup.py egg_info for package pip
17:07:25 INFO - warning: no files found matching 'pip\cacert.pem'
17:07:25 INFO - warning: no files found matching '*.html' under directory 'docs'
17:07:25 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build'
17:07:25 INFO - no previously-included directories found matching 'docs\_build\_sources'
17:07:25 INFO - Installing collected packages: pip
17:07:25 INFO - Found existing installation: pip 0.8.2
17:07:25 INFO - Uninstalling pip:
17:07:25 INFO - Successfully uninstalled pip
17:07:25 INFO - Running setup.py install for pip
17:07:25 INFO - warning: no files found matching 'pip\cacert.pem'
17:07:25 INFO - warning: no files found matching '*.html' under directory 'docs'
17:07:25 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build'
17:07:25 INFO - no previously-included directories found matching 'docs\_build\_sources'
17:07:25 INFO - Installing pip-script.py script to C:\slave\test\build\venv\Scripts
17:07:25 INFO - Installing pip.exe script to C:\slave\test\build\venv\Scripts
17:07:25 INFO - Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts
17:07:25 INFO - Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts
17:07:25 INFO - Installing pip2-script.py script to C:\slave\test\build\venv\Scripts
17:07:25 INFO - Installing pip2.exe script to C:\slave\test\build\venv\Scripts
17:07:25 INFO - Successfully installed pip
17:07:25 INFO - Cleaning up...
17:07:25 INFO - Return code: 0
17:07:25 INFO - Installing psutil>=3.1.1 into virtualenv C:\slave\test\build/venv
17:07:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
17:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
17:07:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
17:07:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
17:07:25 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 0x0226C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02313E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0241EAC0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0235AE90>, '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 0x004DA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027FD520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-152', 'USERDOMAIN': 'T-W864-IX-152', '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-152', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-152\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-152', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-152', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-152', '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-152\\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
17:07:25 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
17:07:25 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
17:07:25 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
17:07:25 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-152\\AppData\\Roaming',
17:07:25 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
17:07:25 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
17:07:25 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
17:07:25 INFO - 'COMPUTERNAME': 'T-W864-IX-152',
17:07:25 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
17:07:25 INFO - 'DCLOCATION': 'SCL3',
17:07:25 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
17:07:25 INFO - 'FP_NO_HOST_CHECK': 'NO',
17:07:25 INFO - 'HOMEDRIVE': 'C:',
17:07:25 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-152',
17:07:25 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
17:07:25 INFO - 'KTS_VERSION': '1.19c',
17:07:25 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-152\\AppData\\Local',
17:07:25 INFO - 'LOGONSERVER': '\\\\T-W864-IX-152',
17:07:25 INFO - 'MONDIR': 'C:\\Monitor_config\\',
17:07:25 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
17:07:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
17:07:25 INFO - 'MOZ_NO_REMOTE': '1',
17:07:25 INFO - 'NO_EM_RESTART': '1',
17:07:25 INFO - 'NUMBER_OF_PROCESSORS': '8',
17:07:25 INFO - 'OS': 'Windows_NT',
17:07:25 INFO - 'OURDRIVE': 'C:',
17:07:25 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',
17:07:25 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
17:07:25 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
17:07:25 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
17:07:25 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
17:07:25 INFO - 'PROCESSOR_LEVEL': '6',
17:07:25 INFO - 'PROCESSOR_REVISION': '1e05',
17:07:25 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
17:07:25 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
17:07:25 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
17:07:25 INFO - 'PROGRAMW6432': 'C:\\Program Files',
17:07:25 INFO - 'PROMPT': '$P$G',
17:07:25 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
17:07:25 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
17:07:25 INFO - 'PUBLIC': 'C:\\Users\\Public',
17:07:25 INFO - 'PWD': 'C:\\slave\\test',
17:07:25 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
17:07:25 INFO - 'SLAVEDIR': 'C:\\slave\\',
17:07:25 INFO - 'SYSTEMDRIVE': 'C:',
17:07:25 INFO - 'SYSTEMROOT': 'C:\\windows',
17:07:25 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
17:07:25 INFO - 'TEST1': 'testie',
17:07:25 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
17:07:25 INFO - 'USERDOMAIN': 'T-W864-IX-152',
17:07:25 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-152',
17:07:25 INFO - 'USERNAME': 'cltbld',
17:07:25 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-152',
17:07:25 INFO - 'WINDIR': 'C:\\windows',
17:07:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
17:07:27 INFO - Ignoring indexes: https://pypi.python.org/simple/
17:07:27 INFO - Downloading/unpacking psutil>=3.1.1
17:07:27 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
17:07:27 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
17:07:28 INFO - Installing collected packages: psutil
17:07:28 INFO - Successfully installed psutil
17:07:28 INFO - Cleaning up...
17:07:29 INFO - Return code: 0
17:07:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv C:\slave\test\build/venv
17:07:29 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')]}
17:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
17:07:29 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')]}
17:07:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
17:07:29 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 0x0226C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02313E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0241EAC0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0235AE90>, '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 0x004DA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027FD520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-152', 'USERDOMAIN': 'T-W864-IX-152', '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-152', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-152\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-152', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-152', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-152', '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-152\\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
17:07:29 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
17:07:29 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
17:07:29 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
17:07:29 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-152\\AppData\\Roaming',
17:07:29 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
17:07:29 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
17:07:29 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
17:07:29 INFO - 'COMPUTERNAME': 'T-W864-IX-152',
17:07:29 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
17:07:29 INFO - 'DCLOCATION': 'SCL3',
17:07:29 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
17:07:29 INFO - 'FP_NO_HOST_CHECK': 'NO',
17:07:29 INFO - 'HOMEDRIVE': 'C:',
17:07:29 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-152',
17:07:29 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
17:07:29 INFO - 'KTS_VERSION': '1.19c',
17:07:29 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-152\\AppData\\Local',
17:07:29 INFO - 'LOGONSERVER': '\\\\T-W864-IX-152',
17:07:29 INFO - 'MONDIR': 'C:\\Monitor_config\\',
17:07:29 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
17:07:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
17:07:29 INFO - 'MOZ_NO_REMOTE': '1',
17:07:29 INFO - 'NO_EM_RESTART': '1',
17:07:29 INFO - 'NUMBER_OF_PROCESSORS': '8',
17:07:29 INFO - 'OS': 'Windows_NT',
17:07:29 INFO - 'OURDRIVE': 'C:',
17:07:29 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',
17:07:29 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
17:07:29 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
17:07:29 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
17:07:29 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
17:07:29 INFO - 'PROCESSOR_LEVEL': '6',
17:07:29 INFO - 'PROCESSOR_REVISION': '1e05',
17:07:29 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
17:07:29 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
17:07:29 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
17:07:29 INFO - 'PROGRAMW6432': 'C:\\Program Files',
17:07:29 INFO - 'PROMPT': '$P$G',
17:07:29 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
17:07:29 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
17:07:29 INFO - 'PUBLIC': 'C:\\Users\\Public',
17:07:29 INFO - 'PWD': 'C:\\slave\\test',
17:07:29 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
17:07:29 INFO - 'SLAVEDIR': 'C:\\slave\\',
17:07:29 INFO - 'SYSTEMDRIVE': 'C:',
17:07:29 INFO - 'SYSTEMROOT': 'C:\\windows',
17:07:29 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
17:07:29 INFO - 'TEST1': 'testie',
17:07:29 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
17:07:29 INFO - 'USERDOMAIN': 'T-W864-IX-152',
17:07:29 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-152',
17:07:29 INFO - 'USERNAME': 'cltbld',
17:07:29 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-152',
17:07:29 INFO - 'WINDIR': 'C:\\windows',
17:07:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
17:07:29 INFO - Ignoring indexes: https://pypi.python.org/simple/
17:07:29 INFO - Downloading/unpacking mozsystemmonitor==0.3
17:07:29 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
17:07:29 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
17:07:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz
17:07:30 INFO - Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor
17:07:30 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)
17:07:30 INFO - Installing collected packages: mozsystemmonitor
17:07:30 INFO - Running setup.py install for mozsystemmonitor
17:07:30 INFO - Successfully installed mozsystemmonitor
17:07:30 INFO - Cleaning up...
17:07:31 INFO - Return code: 0
17:07:31 INFO - Installing jsonschema==2.5.1 into virtualenv C:\slave\test\build/venv
17:07:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
17:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
17:07:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
17:07:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
17:07:31 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 0x0226C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02313E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0241EAC0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0235AE90>, '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 0x004DA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027FD520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-152', 'USERDOMAIN': 'T-W864-IX-152', '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-152', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-152\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-152', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-152', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-152', '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-152\\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
17:07:31 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
17:07:31 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
17:07:31 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
17:07:31 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-152\\AppData\\Roaming',
17:07:31 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
17:07:31 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
17:07:31 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
17:07:31 INFO - 'COMPUTERNAME': 'T-W864-IX-152',
17:07:31 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
17:07:31 INFO - 'DCLOCATION': 'SCL3',
17:07:31 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
17:07:31 INFO - 'FP_NO_HOST_CHECK': 'NO',
17:07:31 INFO - 'HOMEDRIVE': 'C:',
17:07:31 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-152',
17:07:31 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
17:07:31 INFO - 'KTS_VERSION': '1.19c',
17:07:31 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-152\\AppData\\Local',
17:07:31 INFO - 'LOGONSERVER': '\\\\T-W864-IX-152',
17:07:31 INFO - 'MONDIR': 'C:\\Monitor_config\\',
17:07:31 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
17:07:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
17:07:31 INFO - 'MOZ_NO_REMOTE': '1',
17:07:31 INFO - 'NO_EM_RESTART': '1',
17:07:31 INFO - 'NUMBER_OF_PROCESSORS': '8',
17:07:31 INFO - 'OS': 'Windows_NT',
17:07:31 INFO - 'OURDRIVE': 'C:',
17:07:31 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',
17:07:31 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
17:07:31 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
17:07:31 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
17:07:31 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
17:07:31 INFO - 'PROCESSOR_LEVEL': '6',
17:07:31 INFO - 'PROCESSOR_REVISION': '1e05',
17:07:31 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
17:07:31 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
17:07:31 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
17:07:31 INFO - 'PROGRAMW6432': 'C:\\Program Files',
17:07:31 INFO - 'PROMPT': '$P$G',
17:07:31 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
17:07:31 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
17:07:31 INFO - 'PUBLIC': 'C:\\Users\\Public',
17:07:31 INFO - 'PWD': 'C:\\slave\\test',
17:07:31 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
17:07:31 INFO - 'SLAVEDIR': 'C:\\slave\\',
17:07:31 INFO - 'SYSTEMDRIVE': 'C:',
17:07:31 INFO - 'SYSTEMROOT': 'C:\\windows',
17:07:31 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
17:07:31 INFO - 'TEST1': 'testie',
17:07:31 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
17:07:31 INFO - 'USERDOMAIN': 'T-W864-IX-152',
17:07:31 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-152',
17:07:31 INFO - 'USERNAME': 'cltbld',
17:07:31 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-152',
17:07:31 INFO - 'WINDIR': 'C:\\windows',
17:07:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
17:07:31 INFO - Ignoring indexes: https://pypi.python.org/simple/
17:07:31 INFO - Downloading/unpacking jsonschema==2.5.1
17:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
17:07:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
17:07:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl
17:07:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1)
17:07:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
17:07:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
17:07:35 INFO - Downloading functools32-3.2.3-2.tar.gz
17:07:35 INFO - Running setup.py (path:C:\slave\test\build\venv\build\functools32\setup.py) egg_info for package functools32
17:07:35 INFO - warning: no files found matching '*.txt'
17:07:35 INFO - no previously-included directories found matching 'build'
17:07:35 INFO - no previously-included directories found matching 'dist'
17:07:35 INFO - no previously-included directories found matching '.git*'
17:07:35 INFO - Installing collected packages: jsonschema, functools32
17:07:35 INFO - Running setup.py install for functools32
17:07:36 INFO - warning: no files found matching '*.txt'
17:07:36 INFO - no previously-included directories found matching 'build'
17:07:36 INFO - no previously-included directories found matching 'dist'
17:07:36 INFO - no previously-included directories found matching '.git*'
17:07:36 INFO - Successfully installed jsonschema functools32
17:07:36 INFO - Cleaning up...
17:07:36 INFO - Return code: 0
17:07:36 INFO - Installing functools32==3.2.3-2 into virtualenv C:\slave\test\build/venv
17:07:36 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')]}
17:07:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
17:07:36 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')]}
17:07:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
17:07:36 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 0x0226C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02313E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0241EAC0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0235AE90>, '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 0x004DA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027FD520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-152', 'USERDOMAIN': 'T-W864-IX-152', '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-152', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-152\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-152', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-152', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-152', '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-152\\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
17:07:36 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
17:07:36 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
17:07:36 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
17:07:36 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-152\\AppData\\Roaming',
17:07:36 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
17:07:36 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
17:07:36 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
17:07:36 INFO - 'COMPUTERNAME': 'T-W864-IX-152',
17:07:36 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
17:07:36 INFO - 'DCLOCATION': 'SCL3',
17:07:36 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
17:07:36 INFO - 'FP_NO_HOST_CHECK': 'NO',
17:07:36 INFO - 'HOMEDRIVE': 'C:',
17:07:36 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-152',
17:07:36 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
17:07:36 INFO - 'KTS_VERSION': '1.19c',
17:07:36 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-152\\AppData\\Local',
17:07:36 INFO - 'LOGONSERVER': '\\\\T-W864-IX-152',
17:07:36 INFO - 'MONDIR': 'C:\\Monitor_config\\',
17:07:36 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
17:07:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
17:07:36 INFO - 'MOZ_NO_REMOTE': '1',
17:07:36 INFO - 'NO_EM_RESTART': '1',
17:07:36 INFO - 'NUMBER_OF_PROCESSORS': '8',
17:07:36 INFO - 'OS': 'Windows_NT',
17:07:36 INFO - 'OURDRIVE': 'C:',
17:07:36 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',
17:07:36 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
17:07:36 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
17:07:36 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
17:07:36 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
17:07:36 INFO - 'PROCESSOR_LEVEL': '6',
17:07:36 INFO - 'PROCESSOR_REVISION': '1e05',
17:07:36 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
17:07:36 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
17:07:36 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
17:07:36 INFO - 'PROGRAMW6432': 'C:\\Program Files',
17:07:36 INFO - 'PROMPT': '$P$G',
17:07:36 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
17:07:36 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
17:07:36 INFO - 'PUBLIC': 'C:\\Users\\Public',
17:07:36 INFO - 'PWD': 'C:\\slave\\test',
17:07:36 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
17:07:36 INFO - 'SLAVEDIR': 'C:\\slave\\',
17:07:36 INFO - 'SYSTEMDRIVE': 'C:',
17:07:36 INFO - 'SYSTEMROOT': 'C:\\windows',
17:07:36 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
17:07:36 INFO - 'TEST1': 'testie',
17:07:36 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
17:07:36 INFO - 'USERDOMAIN': 'T-W864-IX-152',
17:07:36 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-152',
17:07:36 INFO - 'USERNAME': 'cltbld',
17:07:36 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-152',
17:07:36 INFO - 'WINDIR': 'C:\\windows',
17:07:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
17:07:36 INFO - Ignoring indexes: https://pypi.python.org/simple/
17:07:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in c:\slave\test\build\venv\lib\site-packages
17:07:36 INFO - Cleaning up...
17:07:36 INFO - Return code: 0
17:07:36 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv
17:07:36 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')]}
17:07:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
17:07:36 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')]}
17:07:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
17:07:36 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 0x0226C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02313E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0241EAC0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0235AE90>, '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 0x004DA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027FD520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-152', 'USERDOMAIN': 'T-W864-IX-152', '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-152', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-152\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-152', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-152', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-152', '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-152\\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
17:07:37 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in C:\slave\test\build
17:07:37 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4
17:07:37 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
17:07:37 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-152\\AppData\\Roaming',
17:07:37 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
17:07:37 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
17:07:37 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
17:07:37 INFO - 'COMPUTERNAME': 'T-W864-IX-152',
17:07:37 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
17:07:37 INFO - 'DCLOCATION': 'SCL3',
17:07:37 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
17:07:37 INFO - 'FP_NO_HOST_CHECK': 'NO',
17:07:37 INFO - 'HOMEDRIVE': 'C:',
17:07:37 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-152',
17:07:37 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
17:07:37 INFO - 'KTS_VERSION': '1.19c',
17:07:37 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-152\\AppData\\Local',
17:07:37 INFO - 'LOGONSERVER': '\\\\T-W864-IX-152',
17:07:37 INFO - 'MONDIR': 'C:\\Monitor_config\\',
17:07:37 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
17:07:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
17:07:37 INFO - 'MOZ_NO_REMOTE': '1',
17:07:37 INFO - 'NO_EM_RESTART': '1',
17:07:37 INFO - 'NUMBER_OF_PROCESSORS': '8',
17:07:37 INFO - 'OS': 'Windows_NT',
17:07:37 INFO - 'OURDRIVE': 'C:',
17:07:37 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
17:07:37 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
17:07:37 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
17:07:37 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
17:07:37 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
17:07:37 INFO - 'PROCESSOR_LEVEL': '6',
17:07:37 INFO - 'PROCESSOR_REVISION': '1e05',
17:07:37 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
17:07:37 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
17:07:37 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
17:07:37 INFO - 'PROGRAMW6432': 'C:\\Program Files',
17:07:37 INFO - 'PROMPT': '$P$G',
17:07:37 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
17:07:37 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
17:07:37 INFO - 'PUBLIC': 'C:\\Users\\Public',
17:07:37 INFO - 'PWD': 'C:\\slave\\test',
17:07:37 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
17:07:37 INFO - 'SLAVEDIR': 'C:\\slave\\',
17:07:37 INFO - 'SYSTEMDRIVE': 'C:',
17:07:37 INFO - 'SYSTEMROOT': 'C:\\windows',
17:07:37 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
17:07:37 INFO - 'TEST1': 'testie',
17:07:37 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
17:07:37 INFO - 'USERDOMAIN': 'T-W864-IX-152',
17:07:37 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-152',
17:07:37 INFO - 'USERNAME': 'cltbld',
17:07:37 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-152',
17:07:37 INFO - 'WINDIR': 'C:\\windows',
17:07:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
17:07:37 INFO - Ignoring indexes: https://pypi.python.org/simple/
17:07:37 INFO - Downloading/unpacking blobuploader==1.2.4
17:07:37 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
17:07:37 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
17:07:38 INFO - Downloading blobuploader-1.2.4.tar.gz
17:07:38 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader
17:07:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4)
17:07:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
17:07:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
17:07:38 INFO - Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests
17:07:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4)
17:07:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
17:07:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
17:07:38 INFO - Downloading docopt-0.6.1.tar.gz
17:07:38 INFO - Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt
17:07:39 INFO - Installing collected packages: blobuploader, requests, docopt
17:07:39 INFO - Running setup.py install for blobuploader
17:07:39 INFO - Running setup.py install for requests
17:07:39 INFO - Running setup.py install for docopt
17:07:39 INFO - Successfully installed blobuploader requests docopt
17:07:39 INFO - Cleaning up...
17:07:41 INFO - Return code: 0
17:07:41 INFO - Installing None into virtualenv C:\slave\test\build/venv
17:07:41 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')]}
17:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
17:07:41 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')]}
17:07:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
17:07:41 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 0x0226C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02313E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0241EAC0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0235AE90>, '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 0x004DA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027FD520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-152', 'USERDOMAIN': 'T-W864-IX-152', '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-152', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-152\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-152', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-152', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-152', '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-152\\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
17:07:41 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
17:07:41 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
17:07:41 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
17:07:41 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-152\\AppData\\Roaming',
17:07:41 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
17:07:41 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
17:07:41 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
17:07:41 INFO - 'COMPUTERNAME': 'T-W864-IX-152',
17:07:41 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
17:07:41 INFO - 'DCLOCATION': 'SCL3',
17:07:41 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
17:07:41 INFO - 'FP_NO_HOST_CHECK': 'NO',
17:07:41 INFO - 'HOMEDRIVE': 'C:',
17:07:41 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-152',
17:07:41 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
17:07:41 INFO - 'KTS_VERSION': '1.19c',
17:07:41 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-152\\AppData\\Local',
17:07:41 INFO - 'LOGONSERVER': '\\\\T-W864-IX-152',
17:07:41 INFO - 'MONDIR': 'C:\\Monitor_config\\',
17:07:41 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
17:07:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
17:07:41 INFO - 'MOZ_NO_REMOTE': '1',
17:07:41 INFO - 'NO_EM_RESTART': '1',
17:07:41 INFO - 'NUMBER_OF_PROCESSORS': '8',
17:07:41 INFO - 'OS': 'Windows_NT',
17:07:41 INFO - 'OURDRIVE': 'C:',
17:07:41 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',
17:07:41 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
17:07:41 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
17:07:41 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
17:07:41 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
17:07:41 INFO - 'PROCESSOR_LEVEL': '6',
17:07:41 INFO - 'PROCESSOR_REVISION': '1e05',
17:07:41 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
17:07:41 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
17:07:41 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
17:07:41 INFO - 'PROGRAMW6432': 'C:\\Program Files',
17:07:41 INFO - 'PROMPT': '$P$G',
17:07:41 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
17:07:41 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
17:07:41 INFO - 'PUBLIC': 'C:\\Users\\Public',
17:07:41 INFO - 'PWD': 'C:\\slave\\test',
17:07:41 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
17:07:41 INFO - 'SLAVEDIR': 'C:\\slave\\',
17:07:41 INFO - 'SYSTEMDRIVE': 'C:',
17:07:41 INFO - 'SYSTEMROOT': 'C:\\windows',
17:07:41 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
17:07:41 INFO - 'TEST1': 'testie',
17:07:41 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
17:07:41 INFO - 'USERDOMAIN': 'T-W864-IX-152',
17:07:41 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-152',
17:07:41 INFO - 'USERNAME': 'cltbld',
17:07:41 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-152',
17:07:41 INFO - 'WINDIR': 'C:\\windows',
17:07:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
17:07:41 INFO - Ignoring indexes: https://pypi.python.org/simple/
17:07:41 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser
17:07:41 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jx6pbe-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser
17:07:41 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash
17:07:41 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-8_vbhl-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash
17:07:41 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug
17:07:41 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-n6gha3-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug
17:07:41 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice
17:07:41 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-a2f1pa-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice
17:07:41 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile
17:07:41 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-wmr7eo-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile
17:07:42 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd
17:07:42 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-t4gzok-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd
17:07:42 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo
17:07:42 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-9bhgjy-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo
17:07:42 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall
17:07:42 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ow1huo-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall
17:07:42 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak
17:07:42 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-i2twfa-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak
17:07:42 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog
17:07:42 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-_yregt-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog
17:07:42 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork
17:07:42 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ae3eqm-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork
17:07:42 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess
17:07:42 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-u_ohal-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess
17:07:42 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile
17:07:42 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-nf2svt-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile
17:07:42 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner
17:07:42 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qajiix-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner
17:07:43 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot
17:07:43 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-tuvtqu-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot
17:07:43 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest
17:07:43 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-icaqsq-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest
17:07:43 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion
17:07:43 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-uvbb_v-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion
17:07:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion
17:07:43 INFO - Running setup.py install for manifestparser
17:07:43 INFO - Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts
17:07:43 INFO - Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts
17:07:43 INFO - Running setup.py install for mozcrash
17:07:44 INFO - Running setup.py install for mozdebug
17:07:44 INFO - Running setup.py install for mozdevice
17:07:45 INFO - Installing sutini-script.py script to C:\slave\test\build\venv\Scripts
17:07:45 INFO - Installing sutini.exe script to C:\slave\test\build\venv\Scripts
17:07:45 INFO - Installing dm-script.py script to C:\slave\test\build\venv\Scripts
17:07:45 INFO - Installing dm.exe script to C:\slave\test\build\venv\Scripts
17:07:45 INFO - Running setup.py install for mozfile
17:07:45 INFO - Running setup.py install for mozhttpd
17:07:46 INFO - Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts
17:07:46 INFO - Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts
17:07:46 INFO - Running setup.py install for mozinfo
17:07:46 INFO - Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts
17:07:46 INFO - Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts
17:07:46 INFO - Running setup.py install for mozInstall
17:07:46 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts
17:07:46 INFO - Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts
17:07:46 INFO - Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts
17:07:46 INFO - Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts
17:07:46 INFO - Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts
17:07:46 INFO - Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts
17:07:46 INFO - Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts
17:07:46 INFO - Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts
17:07:46 INFO - Running setup.py install for mozleak
17:07:47 INFO - Running setup.py install for mozlog
17:07:47 INFO - Installing structlog-script.py script to C:\slave\test\build\venv\Scripts
17:07:47 INFO - Installing structlog.exe script to C:\slave\test\build\venv\Scripts
17:07:48 INFO - Running setup.py install for moznetwork
17:07:48 INFO - Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts
17:07:48 INFO - Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts
17:07:48 INFO - Running setup.py install for mozprocess
17:07:49 INFO - Running setup.py install for mozprofile
17:07:49 INFO - Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts
17:07:49 INFO - Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts
17:07:49 INFO - Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts
17:07:49 INFO - Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts
17:07:49 INFO - Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts
17:07:49 INFO - Installing view-profile.exe script to C:\slave\test\build\venv\Scripts
17:07:49 INFO - Running setup.py install for mozrunner
17:07:50 INFO - Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts
17:07:50 INFO - Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts
17:07:50 INFO - Running setup.py install for mozscreenshot
17:07:50 INFO - Running setup.py install for moztest
17:07:51 INFO - Running setup.py install for mozversion
17:07:51 INFO - Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts
17:07:51 INFO - Installing mozversion.exe script to C:\slave\test\build\venv\Scripts
17:07:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion
17:07:51 INFO - Cleaning up...
17:07:51 INFO - Return code: 0
17:07:51 INFO - Installing None into virtualenv C:\slave\test\build/venv
17:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
17:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
17:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
17:07:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
17:07:51 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 0x0226C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02313E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0241EAC0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0235AE90>, '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 0x004DA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027FD520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-152', 'USERDOMAIN': 'T-W864-IX-152', '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-152', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-152\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-152', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-152', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-152', '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-152\\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
17:07:51 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
17:07:51 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
17:07:51 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
17:07:51 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-152\\AppData\\Roaming',
17:07:51 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
17:07:51 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
17:07:51 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
17:07:51 INFO - 'COMPUTERNAME': 'T-W864-IX-152',
17:07:51 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
17:07:51 INFO - 'DCLOCATION': 'SCL3',
17:07:51 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
17:07:51 INFO - 'FP_NO_HOST_CHECK': 'NO',
17:07:51 INFO - 'HOMEDRIVE': 'C:',
17:07:51 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-152',
17:07:51 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
17:07:51 INFO - 'KTS_VERSION': '1.19c',
17:07:51 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-152\\AppData\\Local',
17:07:51 INFO - 'LOGONSERVER': '\\\\T-W864-IX-152',
17:07:51 INFO - 'MONDIR': 'C:\\Monitor_config\\',
17:07:51 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
17:07:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
17:07:51 INFO - 'MOZ_NO_REMOTE': '1',
17:07:51 INFO - 'NO_EM_RESTART': '1',
17:07:51 INFO - 'NUMBER_OF_PROCESSORS': '8',
17:07:51 INFO - 'OS': 'Windows_NT',
17:07:51 INFO - 'OURDRIVE': 'C:',
17:07:51 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
17:07:51 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
17:07:51 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
17:07:51 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
17:07:51 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
17:07:51 INFO - 'PROCESSOR_LEVEL': '6',
17:07:51 INFO - 'PROCESSOR_REVISION': '1e05',
17:07:51 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
17:07:51 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
17:07:51 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
17:07:51 INFO - 'PROGRAMW6432': 'C:\\Program Files',
17:07:51 INFO - 'PROMPT': '$P$G',
17:07:51 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
17:07:51 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
17:07:51 INFO - 'PUBLIC': 'C:\\Users\\Public',
17:07:51 INFO - 'PWD': 'C:\\slave\\test',
17:07:51 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
17:07:51 INFO - 'SLAVEDIR': 'C:\\slave\\',
17:07:51 INFO - 'SYSTEMDRIVE': 'C:',
17:07:51 INFO - 'SYSTEMROOT': 'C:\\windows',
17:07:51 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
17:07:51 INFO - 'TEST1': 'testie',
17:07:51 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
17:07:51 INFO - 'USERDOMAIN': 'T-W864-IX-152',
17:07:51 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-152',
17:07:51 INFO - 'USERNAME': 'cltbld',
17:07:51 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-152',
17:07:51 INFO - 'WINDIR': 'C:\\windows',
17:07:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
17:07:51 INFO - Ignoring indexes: https://pypi.python.org/simple/
17:07:51 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser
17:07:51 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-vdwgbs-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser
17:07:52 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))
17:07:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash
17:07:52 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-nilu8x-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash
17:07:52 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))
17:07:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug
17:07:52 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ndl4aj-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug
17:07:52 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))
17:07:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice
17:07:52 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-y2tgtc-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice
17:07:52 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))
17:07:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile
17:07:52 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-tl1f0c-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile
17:07:52 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))
17:07:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd
17:07:52 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jdrryz-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd
17:07:52 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))
17:07:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo
17:07:52 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-a2sqxb-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo
17:07:52 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))
17:07:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall
17:07:52 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-owda3b-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall
17:07:52 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))
17:07:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak
17:07:52 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jjvazm-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak
17:07:52 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))
17:07:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog
17:07:52 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-bvb1cx-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog
17:07:53 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))
17:07:53 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork
17:07:53 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-199yae-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork
17:07:53 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))
17:07:53 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess
17:07:53 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-55yekb-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess
17:07:53 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))
17:07:53 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile
17:07:53 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-oddmzq-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile
17:07:53 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))
17:07:53 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner
17:07:53 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-4rzci4-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner
17:07:53 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))
17:07:53 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot
17:07:53 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-cvlinp-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot
17:07:53 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))
17:07:53 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest
17:07:53 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-l5scq7-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest
17:07:53 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))
17:07:53 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion
17:07:53 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-nnqmzk-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion
17:07:54 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))
17:07:54 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))
17:07:54 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))
17:07:54 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))
17:07:54 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))
17:07:54 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))
17:07:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10))
17:07: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
17:07: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
17:07:55 INFO - Downloading blessings-1.6.tar.gz
17:07:55 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings
17:07:55 INFO - Installing collected packages: blessings
17:07:55 INFO - Running setup.py install for blessings
17:07:55 INFO - Successfully installed blessings
17:07:55 INFO - Cleaning up...
17:07:58 INFO - Return code: 0
17:07:58 INFO - Done creating virtualenv C:\slave\test\build/venv.
17:07:58 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze']
17:07:58 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze
17:07:58 INFO - Reading from file tmpfile_stdout
17:07:58 INFO - Using _rmtree_windows ...
17:07:58 INFO - Using _rmtree_windows ...
17:07:58 INFO - Current package versions:
17:07:58 INFO - blessings == 1.6
17:07:58 INFO - blobuploader == 1.2.4
17:07:58 INFO - docopt == 0.6.1
17:07:58 INFO - functools32 == 3.2.3-2
17:07:58 INFO - jsonschema == 2.5.1
17:07:58 INFO - manifestparser == 1.1
17:07:58 INFO - mozInstall == 1.12
17:07:58 INFO - mozcrash == 0.17
17:07:58 INFO - mozdebug == 0.1
17:07:58 INFO - mozdevice == 0.48
17:07:58 INFO - mozfile == 1.2
17:07:58 INFO - mozhttpd == 0.7
17:07:58 INFO - mozinfo == 0.9
17:07:58 INFO - mozleak == 0.1
17:07:58 INFO - mozlog == 3.4
17:07:58 INFO - moznetwork == 0.27
17:07:58 INFO - mozprocess == 0.23
17:07:58 INFO - mozprofile == 0.28
17:07:58 INFO - mozrunner == 6.12
17:07:58 INFO - mozscreenshot == 0.1
17:07:58 INFO - mozsystemmonitor == 0.3
17:07:58 INFO - moztest == 0.7
17:07:58 INFO - mozversion == 1.4
17:07:58 INFO - psutil == 3.1.1
17:07:58 INFO - requests == 1.2.3
17:07:58 INFO - Installing None into virtualenv C:\slave\test\build/venv
17:07:58 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')]}
17:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
17:07:58 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')]}
17:07:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
17:07:58 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 0x0226C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02313E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0241EAC0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0235AE90>, '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 0x004DA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027FD520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build\\tests\\talos', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-152', 'USERDOMAIN': 'T-W864-IX-152', '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-152', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-152\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-152', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-152', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-152', '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-152\\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
17:07:58 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
17:07:58 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
17:07:58 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
17:07:58 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-152\\AppData\\Roaming',
17:07:58 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
17:07:58 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
17:07:58 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
17:07:58 INFO - 'COMPUTERNAME': 'T-W864-IX-152',
17:07:58 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
17:07:58 INFO - 'DCLOCATION': 'SCL3',
17:07:58 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
17:07:58 INFO - 'FP_NO_HOST_CHECK': 'NO',
17:07:58 INFO - 'HOMEDRIVE': 'C:',
17:07:58 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-152',
17:07:58 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
17:07:58 INFO - 'KTS_VERSION': '1.19c',
17:07:58 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-152\\AppData\\Local',
17:07:58 INFO - 'LOGONSERVER': '\\\\T-W864-IX-152',
17:07:58 INFO - 'MONDIR': 'C:\\Monitor_config\\',
17:07:58 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
17:07:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
17:07:58 INFO - 'MOZ_NO_REMOTE': '1',
17:07:58 INFO - 'NO_EM_RESTART': '1',
17:07:58 INFO - 'NUMBER_OF_PROCESSORS': '8',
17:07:58 INFO - 'OS': 'Windows_NT',
17:07:58 INFO - 'OURDRIVE': 'C:',
17:07:58 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',
17:07:58 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
17:07:58 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
17:07:58 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
17:07:58 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
17:07:58 INFO - 'PROCESSOR_LEVEL': '6',
17:07:58 INFO - 'PROCESSOR_REVISION': '1e05',
17:07:58 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
17:07:58 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
17:07:58 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
17:07:58 INFO - 'PROGRAMW6432': 'C:\\Program Files',
17:07:58 INFO - 'PROMPT': '$P$G',
17:07:58 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
17:07:58 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
17:07:58 INFO - 'PUBLIC': 'C:\\Users\\Public',
17:07:58 INFO - 'PWD': 'C:\\slave\\test',
17:07:58 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
17:07:58 INFO - 'SLAVEDIR': 'C:\\slave\\',
17:07:58 INFO - 'SYSTEMDRIVE': 'C:',
17:07:58 INFO - 'SYSTEMROOT': 'C:\\windows',
17:07:58 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
17:07:58 INFO - 'TEST1': 'testie',
17:07:58 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
17:07:58 INFO - 'USERDOMAIN': 'T-W864-IX-152',
17:07:58 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-152',
17:07:58 INFO - 'USERNAME': 'cltbld',
17:07:58 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-152',
17:07:58 INFO - 'WINDIR': 'C:\\windows',
17:07:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
17:07:59 INFO - Ignoring indexes: https://pypi.python.org/simple/
17:07:59 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))
17:07:59 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))
17:07:59 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))
17:07:59 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))
17:07:59 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))
17:07:59 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))
17:07:59 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))
17:07:59 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))
17:07:59 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))
17:07:59 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))
17:07:59 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))
17:07:59 INFO - Cleaning up...
17:07:59 INFO - Return code: 0
17:07:59 INFO - Installing jsonschema into virtualenv C:\slave\test\build/venv
17:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
17:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
17:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
17:07:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
17:07:59 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 0x0226C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02313E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0241EAC0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0235AE90>, '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 0x004DA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027FD520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-152', 'USERDOMAIN': 'T-W864-IX-152', '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-152', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-152\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-152', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-152', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-152', '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-152\\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
17:07:59 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
17:07:59 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
17:07:59 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
17:07:59 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-152\\AppData\\Roaming',
17:07:59 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
17:07:59 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
17:07:59 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
17:07:59 INFO - 'COMPUTERNAME': 'T-W864-IX-152',
17:07:59 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
17:07:59 INFO - 'DCLOCATION': 'SCL3',
17:07:59 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
17:07:59 INFO - 'FP_NO_HOST_CHECK': 'NO',
17:07:59 INFO - 'HOMEDRIVE': 'C:',
17:07:59 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-152',
17:07:59 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
17:07:59 INFO - 'KTS_VERSION': '1.19c',
17:07:59 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-152\\AppData\\Local',
17:07:59 INFO - 'LOGONSERVER': '\\\\T-W864-IX-152',
17:07:59 INFO - 'MONDIR': 'C:\\Monitor_config\\',
17:07:59 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
17:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
17:07:59 INFO - 'MOZ_NO_REMOTE': '1',
17:07:59 INFO - 'NO_EM_RESTART': '1',
17:07:59 INFO - 'NUMBER_OF_PROCESSORS': '8',
17:07:59 INFO - 'OS': 'Windows_NT',
17:07:59 INFO - 'OURDRIVE': 'C:',
17:07:59 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
17:07:59 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
17:07:59 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
17:07:59 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
17:07:59 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
17:07:59 INFO - 'PROCESSOR_LEVEL': '6',
17:07:59 INFO - 'PROCESSOR_REVISION': '1e05',
17:07:59 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
17:07:59 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
17:07:59 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
17:07:59 INFO - 'PROGRAMW6432': 'C:\\Program Files',
17:07:59 INFO - 'PROMPT': '$P$G',
17:07:59 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
17:07:59 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
17:07:59 INFO - 'PUBLIC': 'C:\\Users\\Public',
17:07:59 INFO - 'PWD': 'C:\\slave\\test',
17:07:59 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
17:07:59 INFO - 'SLAVEDIR': 'C:\\slave\\',
17:07:59 INFO - 'SYSTEMDRIVE': 'C:',
17:07:59 INFO - 'SYSTEMROOT': 'C:\\windows',
17:07:59 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
17:07:59 INFO - 'TEST1': 'testie',
17:07:59 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
17:07:59 INFO - 'USERDOMAIN': 'T-W864-IX-152',
17:07:59 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-152',
17:07:59 INFO - 'USERNAME': 'cltbld',
17:07:59 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-152',
17:07:59 INFO - 'WINDIR': 'C:\\windows',
17:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
17:07:59 INFO - Ignoring indexes: https://pypi.python.org/simple/
17:07:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in c:\slave\test\build\venv\lib\site-packages
17:07:59 INFO - Cleaning up...
17:07:59 INFO - Return code: 0
17:07:59 INFO - Running post-action listener: _resource_record_post_action
17:07:59 INFO - Running post-action listener: _start_resource_monitoring
17:07:59 INFO - Starting resource monitoring.
17:07:59 INFO - [mozharness: 2016-10-14 00:07:59.747000Z] Finished create-virtualenv step (success)
17:07:59 INFO - [mozharness: 2016-10-14 00:07:59.747000Z] Running install step.
17:07:59 INFO - Running pre-action listener: _resource_record_pre_action
17:07:59 INFO - Running main action method: install
17:07:59 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze']
17:07:59 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze
17:08:00 INFO - Reading from file tmpfile_stdout
17:08:00 INFO - Using _rmtree_windows ...
17:08:00 INFO - Using _rmtree_windows ...
17:08:00 INFO - Detecting whether we're running mozinstall >=1.0...
17:08:00 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h']
17:08:00 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h
17:08:00 INFO - Reading from file tmpfile_stdout
17:08:00 INFO - Output received:
17:08:00 INFO - Usage: mozinstall-script.py [options] installer
17:08:00 INFO - Options:
17:08:00 INFO - -h, --help show this help message and exit
17:08:00 INFO - -d DEST, --destination=DEST
17:08:00 INFO - Directory to install application into. [default:
17:08:00 INFO - "C:\slave\test"]
17:08:00 INFO - --app=APP Application being installed. [default: firefox]
17:08:00 INFO - Using _rmtree_windows ...
17:08:00 INFO - Using _rmtree_windows ...
17:08:00 INFO - mkdir: C:\slave\test\build\application
17:08:00 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']
17:08:00 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
17:08:02 INFO - Reading from file tmpfile_stdout
17:08:02 INFO - Output received:
17:08:02 INFO - C:\slave\test\build\application\firefox\firefox.exe
17:08:02 INFO - Using _rmtree_windows ...
17:08:02 INFO - Using _rmtree_windows ...
17:08:02 INFO - Running post-action listener: _resource_record_post_action
17:08:02 INFO - [mozharness: 2016-10-14 00:08:02.827000Z] Finished install step (success)
17:08:02 INFO - [mozharness: 2016-10-14 00:08:02.827000Z] Running run-tests step.
17:08:02 INFO - Running pre-action listener: _resource_record_pre_action
17:08:02 INFO - Running main action method: run_tests
17:08:02 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version']
17:08:02 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version
17:08:02 INFO - Python 2.7.3
17:08:02 INFO - Return code: 0
17:08:02 INFO - grabbing minidump binary from tooltool
17:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
17:08:02 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 0x0235AE90>, '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 0x004DA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027FD520>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1
17:08:02 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
17:08:02 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
17:08:02 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
17:08:02 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'...
17:08:03 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmpuraiqr
17:08:03 INFO - INFO - File integrity verified, renaming tmpuraiqr to win32-minidump_stackwalk.exe
17:08:03 INFO - Return code: 0
17:08:03 INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755
17:08:03 INFO - mkdir: C:\slave\test\build\blobber_upload_dir
17:08:03 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir
17:08:03 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe
17:08:03 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir
17:08:03 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IviLE9gZSRCcZglg5E817Q/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-152', '--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
17:08:03 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\tests\talos\talos\run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath C:\slave\test\build\application\firefox\firefox --symbolsPath https://queue.taskcluster.net/v1/task/IviLE9gZSRCcZglg5E817Q/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip --title T-W864-IX-152 --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
17:08:03 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
17:08:03 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-152\\AppData\\Roaming',
17:08:03 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
17:08:03 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
17:08:03 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
17:08:03 INFO - 'COMPUTERNAME': 'T-W864-IX-152',
17:08:03 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
17:08:03 INFO - 'DCLOCATION': 'SCL3',
17:08:03 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
17:08:03 INFO - 'FP_NO_HOST_CHECK': 'NO',
17:08:03 INFO - 'HOMEDRIVE': 'C:',
17:08:03 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-152',
17:08:03 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
17:08:03 INFO - 'KTS_VERSION': '1.19c',
17:08:03 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-152\\AppData\\Local',
17:08:03 INFO - 'LOGONSERVER': '\\\\T-W864-IX-152',
17:08:03 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir',
17:08:03 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe',
17:08:03 INFO - 'MONDIR': 'C:\\Monitor_config\\',
17:08:03 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
17:08:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
17:08:03 INFO - 'MOZ_NO_REMOTE': '1',
17:08:03 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir',
17:08:03 INFO - 'NO_EM_RESTART': '1',
17:08:03 INFO - 'NUMBER_OF_PROCESSORS': '8',
17:08:03 INFO - 'OS': 'Windows_NT',
17:08:03 INFO - 'OURDRIVE': 'C:',
17:08:03 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',
17:08:03 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
17:08:03 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
17:08:03 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
17:08:03 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
17:08:03 INFO - 'PROCESSOR_LEVEL': '6',
17:08:03 INFO - 'PROCESSOR_REVISION': '1e05',
17:08:03 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
17:08:03 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
17:08:03 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
17:08:03 INFO - 'PROGRAMW6432': 'C:\\Program Files',
17:08:03 INFO - 'PROMPT': '$P$G',
17:08:03 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
17:08:03 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
17:08:03 INFO - 'PUBLIC': 'C:\\Users\\Public',
17:08:03 INFO - 'PWD': 'C:\\slave\\test',
17:08:03 INFO - 'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos',
17:08:03 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
17:08:03 INFO - 'SLAVEDIR': 'C:\\slave\\',
17:08:03 INFO - 'SYSTEMDRIVE': 'C:',
17:08:03 INFO - 'SYSTEMROOT': 'C:\\windows',
17:08:03 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
17:08:03 INFO - 'TEST1': 'testie',
17:08:03 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
17:08:03 INFO - 'USERDOMAIN': 'T-W864-IX-152',
17:08:03 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-152',
17:08:03 INFO - 'USERNAME': 'cltbld',
17:08:03 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-152',
17:08:03 INFO - 'WINDIR': 'C:\\windows',
17:08:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
17:08:03 INFO - Calling ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IviLE9gZSRCcZglg5E817Q/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-152', '--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
17:08:04 INFO - mozversion application_buildid: 20161013123018
17:08:04 INFO - mozversion application_changeset: 62ccb498db3ec05bef1b6427d5b1b4b0e501cad5
17:08:04 INFO - mozversion application_display_name: Nightly
17:08:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384}
17:08:04 INFO - mozversion application_name: Firefox
17:08:04 INFO - mozversion application_remotingname: firefox
17:08:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team
17:08:04 INFO - mozversion application_vendor: Mozilla
17:08:04 INFO - mozversion application_version: 52.0a1
17:08:04 INFO - mozversion platform_buildid: 20161013123018
17:08:04 INFO - mozversion platform_changeset: 62ccb498db3ec05bef1b6427d5b1b4b0e501cad5
17:08:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team
17:08:04 INFO - mozversion platform_version: 52.0a1
17:08:04 INFO - using testdate: 1476403684
17:08:04 INFO - actual date: 1476403684
17:08:04 INFO - starting webserver on 'localhost:49240'
17:08:04 INFO - SUITE-START | Running 2 tests
17:08:04 INFO - TEST-START | dromaeo_css
17:08:04 INFO - operating with platform_type : w8_
17:08:04 INFO - Initialising browser for dromaeo_css test...
17:08:05 INFO - TEST-INFO | started process 2788 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpvktc6f\profile http://localhost:49240/getInfo.html)
17:08:13 INFO - PROCESS | 2788 | __metrics Screen width/height:1600/1200
17:08:13 INFO - PROCESS | 2788 | colorDepth:24
17:08:13 INFO - PROCESS | 2788 | Browser inner width/height: 1010/674
17:08:13 INFO - PROCESS | 2788 | __metrics
17:08:14 INFO - PROCESS | 2788 | 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"
17:08:14 INFO - PROCESS | 2788 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver]
17:08:15 INFO - TEST-INFO | 2788: exit 0
17:08:15 INFO - Browser initialized.
17:08:15 INFO - Running cycle 1/1 for dromaeo_css test...
17:08:15 INFO - TEST-INFO | started process 2888 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpvktc6f\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1)
17:08:16 INFO - PROCESS | 2888 | [GFX1-]: Invalid size in UpdateRenderTarget Size(124,0), 0
17:08:27 INFO - PROCESS | 2888 | RSS: Main: 162369536
17:08:27 INFO - PROCESS | 2888 |
17:09:18 INFO - PROCESS | 2888 | 1476403758558 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]
17:11:28 INFO - PROCESS | 2888 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html)
17:11:30 INFO - PROCESS | 2888 | RSS: Main: 344707072
17:11:30 INFO - PROCESS | 2888 |
17:14:33 INFO - PROCESS | 2888 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html)
17:14:33 INFO - PROCESS | 2888 | RSS: Main: 223277056
17:14:33 INFO - PROCESS | 2888 |
17:17:35 INFO - PROCESS | 2888 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html)
17:17:36 INFO - PROCESS | 2888 | RSS: Main: 197775360
17:17:36 INFO - PROCESS | 2888 |
17:20:38 INFO - PROCESS | 2888 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html)
17:20:39 INFO - PROCESS | 2888 | RSS: Main: 173985792
17:20:39 INFO - PROCESS | 2888 |
17:23:42 INFO - PROCESS | 2888 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html)
17:23:42 INFO - PROCESS | 2888 | RSS: Main: 163823616
17:23:42 INFO - PROCESS | 2888 |
17:26:45 INFO - PROCESS | 2888 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html)
17:26:45 INFO - PROCESS | 2888 | RSS: Main: 293273600
17:26:45 INFO - PROCESS | 2888 |
17:26:45 INFO - PROCESS | 2888 | __start_tp_report
17:26:45 INFO - PROCESS | 2888 | _x_x_mozilla_page_load
17:26:45 INFO - PROCESS | 2888 | _x_x_mozilla_page_load_details
17:26:45 INFO - PROCESS | 2888 | |i|pagename|runs|
17:26:45 INFO - PROCESS | 2888 | |0;dojo.html;2805.3126983888947;2817.2252630526614;2840.9289767755804;2853.571964205369;2856.471552762739;4944.233643785215;5029.371328583927;5040.369953755776;5046.167382381912;5086.440491545927;4947.257911313296;5013.147764879979;5038.823641172559;5068.873278168047;5160.200168973805;4509.165804326194;4526.569975852305;4544.772761361935;4579.656525760564;4652.97634520405;4612.331211974261;4615.723056616597;4616.030633566955;4626.421697287839;4626.8149274029;353.28330879977045;4602.953970460303;4620.838270660528;4669.579737823595;4679.92980105297;4500.684952053358;4507.864764057083;4539.886502837422;4600.769961501945;4617.907641847178;4360.411344468488;4491.550844915515;4527.049319642879;4545.977270113628;4600.194965880991;4995.450500444948;5022.522860328263;5049.5202955719515;5092.159793634083;5107.106256405114;5217.243499692523;5254.448282930313;5285.603579731535;5306.204069389584;5359.383670877821;5396.541293990015;5421.105517589593;5421.701806400646;5454.61817672763;5511.972440137773;4987.600991920638;5009.173486374707;5012.273220383024;5021;5074.771635276422;5395.271638328775;5399.379071406838;5441.809536666197;5531.834044978657;5542.667439953616;5249.055170069348;5256.106461901486;5258.553022993088;5260.368755749335;5288.3918349390315;5393.352797664227;5403.567714582824;5406.83779486616;5406.864828379322;5410.053240682865;5317.787288508416;5329.573634109262;5350.9732451337495;5367.543758780547;5373.328333958255;5340.225667278223;5348.277982472317;5351.598630102758;5357.19642053695;5360.249565060894;3615.5119058927235;3624.3294990426857;3635.781853088823;3636.78179309237;3643.617420170897;3251.398491279121;3264.1513206565987;3320.734341252694;3324.7173990210617;3330.467125259995;5020.071286811952;5030.84907452777;5043.268726034705;5076.416212135578;5081.720505372166;5328.17413300939;5484.91772623411;5499.1476321170285;5501.202325662756;5559.138333558305;4793.23308270675;4952.232403977389;4999.575036121971;5008.073506401327;5015.3229314042865;4484.887877803081;4497.527759585262;4506.1663592235545;4512.075024619945;4566.26939689648;5484.451554844483;5518.2826232589505;5523.917141242965;5530.889382212334;5577.916331254954;5160.896782064413;5244.606654500852;5246;5276.07668657991;5309.044372012921;5360.383555891122;5361.329833770778;5369.785208591768;5370.919436208382;5375.758090885998;5145.331106956071;5176.4305926348825;5177.4822517747925;5209.817656382009;5220.556252718561;5221.608379371638;5271.78912843482;5273.630845840754;5303.231031500488;5304.28392167068;5095.388553373619;5150.562202212854;5159.277701121921;5163.767630456563;5168.405633352213;5299.814506492255;5309.7345132743985;5335.413104558573;5335.573154147736;5338.626296159387;5123.769430375568;5143.871403214949;5179.896402071862;5221.556167725786;5282.154855223146;5276.551493123127;5281.920771188512;5289.444608316071;5294.814681486129;5339.839804805862;5160.587153027674;5162;5187.974060129675;5196.2725218470205;5207.3751149862255
17:26:45 INFO - PROCESS | 2888 | |1;ext.html;536.7826030457666;537.6263496869676;538.6014349381456;550.2324257660566;553.7010014592121;28061.719382806165;35850.46224306637;36249.8375276203;36676.083097922565;38789.806050969775;36669.44995825058;36974.075648108745;37046;37063;37084.999999999935;8339.791505212388;8352.204276080642;8464.619092140869;8482.957585212096;8484.872726909101;8316.542590157569;8357.916420835774;8367.665293388258;8371.874421883676;8386.077531471534;8447.450915690491;8469.32245420365;8490.10853860345;8495.235428811406;8514.829703405929;8380.664773409057;8399.11809260031;8426.705065322683;8429.283510901581;8429.873551896726;8449.915500844974;8481.067082620906;8484.745457636282;8502.149785021511;8516.403851730382;34315.14212144716;35015.64984350175;35109;35122;35181.29637407263;2838.517452033139;2858.3282928511785;2897.739203471677;2899.7100289971045;3011.3224524482034;28166.718332816614;28181.43637127246;28208.435831283463;29275.414491710046;29777.85111074431;3877.7867217303037;3970.166265084336;3993.3610622300585;4007.078371974433;4016.8192431340367;254539.72793128842;272939;274688;275165;275855;45436;45640.5435945643;45694.771526142154;45706.54293457089;45774.77112614416;29974.250643733645;30593.541096883564;47671.761641192265;48023.15814734813;48088.75955620199;14529.128252304896;14931.25343732809;14953.102813831205;14992.70014599702;15022.023568468014;11420;11529.192956493132;11544.76910461786;11553.36456494884;11554.422278886022;15478.5356439307;15665.216739163225;15676.764848527282;15735.921320393325;15831.366745330059;6158;6164.815055548341;6205.6586887720705;6226.221722284715;6266.216722909637;786.7167819584945;817.6402382951483;861.3238607693056;866.1987661413168;939.4832841936908;26350;26782;26985.865070674914;27092.187234383;27154.1853744388;912.8174365127002;916.2669864108686;938.3759799733238;986.9358491698017;993.8062077894741;13805.930970345084;14120.96399274161;14164.716705665829;14292;14357.78463323051;472185;476667;477530;478715;478752;44268.55731442709;44620.3306950396;44718.10563788706;44791.55208447939;45223.321650175276;1027.3476342522551;1068.6580294305747;1113.9498722557341;1124.8031594470935;1129.2039112425884;25041;27475.387235828664;27557.31106722348;27566;27810.721892780814;39656;40342.1931561373;40347;40353.596464034985;40400.39399408952;352220;352477;353788;354107;356059;21442.783582462755;22207.22274720377;23295;24024.27927162188;24522.632160517962;37136;38468.6153138465;38507.41642461883;38514.229715404974;39557.40663890102;33414;33998.32003359869;34375.48436773501;34413.827930860185;34876.825615871756;32708.836455817567;32805.015849523596;32821.01536953895;33176.83411582927;33655;32194.67805321917;32205.033848984567;32675.183120422178;32716.345673086882;33173.17067073342;24737.876310618332;25224.621630675923;25233.369165771004;25333.113341032975;25672.486550268517;23074.423139421648;23616.17343392973;23727.52544949126;23973.160939367037;24085.638715419635
17:26:45 INFO - PROCESS | 2888 | |2;jquery.html;281.8393515696053;287.84887933834733;293.53767815690287;298.67593660877947;303.9908802735918;13170.802437963413;14082.155070695766;14446.349914253857;15166.545003649895;15211.543653690407;15261.771073433907;15810.130442825668;16083.597910052255;16172.514824555254;16191.676166476664;4962.330085438456;4998.825041123561;5117.283580298752;5337.412884582713;5350.036993341197;5053.494650534935;5186.170212765958;5188.688678679272;5195.948040519603;5205.60957928155;5040.495950404967;5139.511746384088;5143.665661731994;5143.742812859361;5165.096108181072;5163.251328557357;5283.762230699608;5285.841424757264;5298.92051619226;5308.495692909168;4899.8040078396825;5043.974780126113;5090.54185123337;5139.254808052811;5160.277561141444;11220.438978051065;11284.605038823602;11314.208005439623;11409.42952852354;11413.201075924688;1868.0659670164916;2077.5948690005303;2081.9687704684443;2123.1295168980646;2253.3915842722536;8320.958395208047;8755.430896991675;8755.56222188888;11851.814818518165;12182.756344873053;1718.3813827022261;1731.37670438642;1761.3042848075067;1770.9911450442794;1773.272958087178;66727.66636166789;67125.3287467124;68973.65513172402;70254.59490810156;70803.64598177027;8896.59965301563;8897.11028897118;9000.459972401677;9158.175764181122;9423.62305507772;11322;11639.359835208976;11664.008559272557;11780.11649126319;11806.291622502677;6553.901691474632;6709;6771.747226763065;6957.886738121876;6963.895541566881;6541.771038013741;6557;6639.236487803964;6650.733970641217;6667.86664266712;3660.670539651444;3735.831887565066;3777.131259810204;3794.482207117175;3806.904827379338;1586.5636949838656;1648.6867495175877;1650.2408891909856;1651.3724784581782;1680.7646929429889;774.2876553570728;810.2990912860333;856.9185927336893;874.8469017921839;882.8896387951506;15634.45279415215;16053.197340132947;16133.17669407849;16428.835711642732;16851.41020064292;834.9729832306176;845.1252953193415;857.4126723194631;873.676739606337;899.3389858454032;8919.286457083417;9052.230560402308;9112.589933453011;9151.130642588943;9236.491992940319;403106;406736;407171;407310;410976;53413.73293133509;77131.22868771353;77783.61108194536;81197;86606;863.1713554987283;881.2025117268882;905;909.0091799938099;909.1908201700492;14487.782683259971;14736.336864840894;14787;14940;15215.619609509851;33705.83147084249;34254.31491370109;34501.827490862386;35123.297534049685;35459.290814183056;48084.7595762019;48192.27711584259;48335;48424.27363589619;48703.26945095755;7026.754063607749;7037.964810175917;7065.1521817382245;7207.5675459472595;7217.566945983258;8542.273906718;10355.223358248311;11229.71925701864;11252.887471125185;11305.660830175108;9759.658411955548;9972.102510774064;10055;10085.344452610558;10239.539220735234;9635.759106022406;9717.80564388694;9837.409755414412;9865.802683946138;10027.04743049409;10039.24705647094;10154.796904062025;10170.08469237772;10185.490725463846;10287.022732840667;7036.944458331292;7045.013698082375;7050.964745176241;7069.681864316015;7088.964555177191;7422.925770742223;9291.396059256127;9842.360246583949;10031.54858031405;10193.592256309665
17:26:45 INFO - PROCESS | 2888 | |3;mootools.html;916.9083091690829;922.9261659067275;1064.7967796390078;1082.0856376361971;1104.3815463340527;5899.852503687404;6617.205935287766;6781;6806.523543351967;6806.897896531556;6852.6916288767;6898.655067246643;6906.482013848969;6910.101686780724;6925.065116209323;1912.7322174895492;1927.7012063130237;1937.6899696048636;1940.0396803582246;1940.194819150051;1888.7166924961227;1899.230811521329;1904.7142928560688;1954.540682939508;1955.6773132433132;1851.3705340184335;1858.8141185881439;1862.5064357945155;1864.4313484387255;1865.5522674558144;1749.9562510937265;1805.8645601579933;1805.9187336569885;1806.7831860176864;1810.1220907859743;1744.520256929342;1759.1380223690428;1760.4630587670756;1762.9206685699173;1793.0496836676582;6394.13679153313;6552.4601718596095;6599.241087274977;6650.501212409089;6818.727250909958;3898.727089103764;4178.728382655148;4180.352045432963;4183.100633363811;4191.161767646483;2661.866906654679;2719.986400067987;2758.475889580973;2765.1013420638374;2766.51585972454;909.6134142989204;911.0707078779674;914.1087439746261;917.0874979395478;927.3091546797679;9105.408148470327;9159;9209.079092090804;9238.399504032284;9258;3264.7388208943225;3385.136790118504;3529.8941031769086;3532.1875968527384;3542.2738338640515;7209.71161153548;7229.385502232369;7241.203467618558;7251.7099316027825;7254.746083887144;4016.256992456405;4070.023194433374;4072.3891416287793;4074.1851629674184;4075.4294398784195;3362.3611513812784;3467.583889933174;3833.2525157594;3846.5961074087377;3852.5569559500454;2800.9299767505977;2895.739383455499;2906.4187162567573;2923.839188844634;2935.7944943853727;837.6146972392646;838.7316058861228;840.5755093677776;848.410354803418;852.5822347049901;679.3614002837317;735.8123678461958;737.8266107464741;738.7451329291385;775.8439924512436;4186.832526698898;4360.738355698668;4399.428074350378;4462.687611867138;4641.6054635355695;744.4081954845802;773.4237992695478;803.6899853239182;804.3404408385068;805.7260531419346;3142.073088438916;3148.8978857399725;3151.8653284817447;3174.0953828158863;3223.9838800805846;8168.959155204186;8529.82940341202;8533.146685331418;8555.315574754004;8563.571821408905;8486.533240671699;8530.061693213742;8532.360072994426;8538.402311838112;8550.486970781772;6540.640264785387;6599.70301336441;6601.3068627794355;6609.074729537869;6618.271990081087;4304.9784751077295;4312.827486900489;4447.510773814943;4528.139653465831;4542.386777784956;7645.503042302233;7828.2954534092205;7934.841303174019;8000.119986801331;8012.799680008046;7801.4929029612895;8106.39202059836;8113.18868113184;8121.918780812352;8127.878081828659;5931.169636250842;6040.305364882919;6051.880402125621;6059.848503787441;6060.606060606046;5667.829965101054;6278.843028924313;6591.571547849375;6625.337466253336;6775.051492790914;6063.909041364472;6090.878182436415;6096.512279017757;6121.989871671124;6131.662758548323;5887.941120588911;5904.52763778888;5919.733611987384;5937.050071988461;5977.1034344846885;5057.924131137962;5090.08378491875;5159.329287192641;5296.841094767163;5384.838454846361;3718.6467285607823;3777.8488860445273;3782.2435512898082;3797.1836055248255;3847.3459511883607;3821.369474036864;3840.498997549588;3849.480320156855;3860.401637746154;4030.1536677298095
17:26:45 INFO - PROCESS | 2888 | |4;prototype.html;264.6784157248942;265.6055757200557;267.20906117891053;271.10265022774615;271.8667852752152;5175.611829112818;5194.506521880416;5196.0647083524955;5211.687298762072;5230.13702739048;5132.871678208046;5140.20326849338;5142.434332223453;5144.485551444854;5159.664621799589;3668.991027467441;3688.4467329900463;3778.5465744110747;3837.328467518187;3839;3836.884893453187;3837.597052309495;3842.9423558646645;3845.5769865314933;3846.769193848364;3810.5046343975246;3810.5998870118656;3818.713596480261;3827.2919509890758;3829.32986727323;3643.417053271477;3712.535933008374;3780.6748849457663;3786.072412258987;3808.828602712857;3285.3265080658407;3302.256992176765;3312.188513814107;3324.3683700096904;3327.367800117994;4977.452480227172;4998.950010499885;4999.550130462161;5007.69953802773;5021.196608542616;4108.446194042162;4319.67602429819;4352.825886964518;4421.248387774086;4436.911261774746;5384.91922621161;5391;5392.487713667196;5398;5406.162044883049;3534.9469757953652;3537.6992955598803;3550;3550.29585798818;3557.1640664443835;5502.58730595203;5527.899398228647;5582.911332290165;5620.9437905621235;5647.661140331593;3466.376052310558;3479.460683594047;3479.6172421033666;3480.7911525308564;3482;3506.2286297014616;3509.3683137035578;3520.1727594015388;3521.1197200699826;3539.68142867138;4226.619604235633;4227.3447615619625;4237.300845360481;4237.597428244312;4238.830446782094;5115.570104200549;5396.32713858705;5402.162664786964;5446.700431476307;5461.726913654302;1260.8865202131851;1268.5877089945805;1270.879266469684;1273.630647112327;1280.9944193807817;746.6341492668553;756.6330329790047;770.9823033595712;785.8860465232509;786.563457281203;5043.344365232496;5082.449852794933;5230.869228269324;5240.868978275574;5250.894982100336;5546.639468434539;5556.944430555724;5574.637648552831;5579.2746942897165;5615.438456154434;4971.726555039435;5159.664621799571;5165.845024649267;5199.922001169985;5219.138842091088;2967.1691926260683;2969.2576855786056;2977.6277965254344;2985.5969444124767;2986.970130298713;5594.1888426177975;5610.551155907599;5660.179274005246;5661.688607126647;5677.489025987681;5436.83689489308;5707.6290041147195;5759.75369605854;5804.245448091806;5805.88388232233;5740.712964351849;5740.885182296331;5748.798792042258;5748.885022299531;5755;5497.185928643618;5594.873947899772;5650.378458369658;5652.293463317085;5680.517156041783;5515.586331025109;5545.528630066489;5562.137868630369;5574.108142697149;5577.721113944368;5715.342735585461;5721.942780572141;5723.170140329712;5725.055365864586;5725.8568535786935;3465.9826700866333;3605.531280933462;3613.0967258185456;3639.8180090995875;3644.8177591120866;5468.835934921959;5612.214289999321;5634.943650563442;5638.2670252866865;5661.603687741983;5480.588955828249;5499.642523235977;5508.338999319947;5522.447755224445;5524.58565607573;5278.577713782965;5467.644603100785;5504.339479262514;5506.449355064461;5512.91730624033;5448.536874365724;5456.672599644034;5462.562994960473;5463.371712252982;5466.1527463243265;5202.817901373585;5337.492938170868;5389.299391079291;5391.892162156813;5396.379416367168;5057.342545469065;5405.8918821622565;5426.891462170814;5436.945630543644;5441.401445841034
17:26:45 INFO - PROCESS | 2888 | |5;yui.html;613.8925688004599;686.1217641418986;689.386446063004;691.7924622613216;700.7512333121745;13685.589432317034;13938.442462301497;14524.419023239085;14793.482228122019;14802.925985370071;12613.369331533433;12855.48578056879;12866.935665321684;12888.42002109905;12920.095593308472;619.2197830733274;633.5691729623854;633.8542135308882;634.311771727676;634.3783092569284;544.9618526703132;557.7880405445925;615.9784407545736;632.4782054804781;636.7102968149504;667.7495939022866;672.2873753820941;672.899065140228;673.3939454490973;674.2515807453723;660.5475249454139;665.9467242620603;667.2293501006345;668.1781408867072;668.3516988521127;416.89369210851345;425.6849931051031;474.3193517302647;483.1400107808107;484.4235359921682;12832.358382080953;12844.908182804473;12845.550405735754;12867.42096605655;12874.420651070724;10969.945150274278;11207.71980700489;11442.370669613169;11453.713657158554;11579;11802;11877.346745928971;12019.51921923122;12035.638930832001;12044;4073.2203929846305;4074.857379991716;4095.201435720036;4138.151678905817;4169.791510424467;59795.402045979856;65829.67085164592;66045.66977165132;66202.33797662058;66626;10048.79902401948;10110.292279540508;10189.847152292721;10235.7441063974;10263.332883362707;16356.754648680278;16792.885742993043;16873.240704168344;16897.408590699266;16955.49133525996;6973.616451095137;7330.157031941289;7348.191698913115;7363.079615048119;7514;4110.280700877334;4155.335146376565;4213.747175169499;4237.322028475429;4361.629261512743;2798.1605518344413;2891.7252860978174;2901.04265592354;2907.302247460594;2913.0532576912588;504.94698056704254;521.5436493068565;523.5340546913251;523.6988731479338;525.2515165888593;524.9133892907628;534.7486681259802;585.2012003615035;617.9351168127372;626.9373062693785;8887.311765617325;9365.765855853659;9679;9711.368761030652;9791.853122203172;535.4377903201623;648.6108334998963;658.3975662269066;667.6761770541284;685.6023506366296;4321.524632290446;4565.155446242456;4579.633629309647;4601.470830854428;4632.420947381577;91888;97637.51181244048;98689;100482;100564.4971775151;82716.10493632694;83296.58351708202;84364;84653.57673211595;84902.57548712217;70378;70907.93638095433;71371;72628.63685681538;72852.63573682203;8181.713640022571;8430.789230269293;8479.915200847912;8500.44747091437;8592.140785921358;39208;43120.56879431166;43172.352414713176;43550.34674479822;43550.782246088565;55561.16658250049;56163.438365615824;59224.703876480344;62326;63089.684551576946;10549.736256593647;10830.238528451497;11141.554337826396;11172.944135279271;11465.828012579985;12180.419664029609;12664.810027849406;13031;13064.281464519543;13548.051636385359;12393.62819115428;12455.688607784516;12665.416822897138;12913;12938.223706577635;9965.25260605472;11942.223755455867;12397.690057748629;12691.80962285548;12714.237145770914;12606.243625382507;12674;12720;12940.41768120418;12966.611001669966;9728.756781080247;9835.950820245853;10282.691519254435;10585.88848170931;10664.200184986003;10164.33931794431;10303.124234439856;10334.793304134026;10432.165426765992;10731.678049658523
17:26:45 INFO - PROCESS | 2888 | __end_tp_report
17:26:45 INFO - PROCESS | 2888 | __start_cc_report
17:26:45 INFO - PROCESS | 2888 | _x_x_mozilla_cycle_collect,2073
17:26:45 INFO - PROCESS | 2888 | __end_cc_report
17:26:45 INFO - PROCESS | 2888 | __startTimestamp1476404805838__endTimestamp
17:26:45 INFO - PROCESS | 2888 |
17:26:45 INFO - PROCESS | 2888 | ------- Summary: start -------
17:26:45 INFO - PROCESS | 2888 | Number of tests: 6
17:26:45 INFO - PROCESS | 2888 |
17:26:45 INFO - PROCESS | 2888 | [#0] dojo.html Cycles:165 Average:4916.04 Median:5160.90 stddev:715.46 (13.9%) stddev-sans-first:698.23
17:26:45 INFO - PROCESS | 2888 | Values: 2805.3 2817.2 2840.9 2853.6 2856.5 4944.2 5029.4 5040.4 5046.2 5086.4 4947.3 5013.1 5038.8 5068.9 5160.2 4509.2 4526.6 4544.8 4579.7 4653.0 4612.3 4615.7 4616.0 4626.4 4626.8 353.3 4603.0 4620.8 4669.6 4679.9 4500.7 4507.9 4539.9 4600.8 4617.9 4360.4 4491.6 4527.0 4546.0 4600.2 4995.5 5022.5 5049.5 5092.2 5107.1 5217.2 5254.4 5285.6 5306.2 5359.4 5396.5 5421.1 5421.7 5454.6 5512.0 4987.6 5009.2 5012.3 5021.0 5074.8 5395.3 5399.4 5441.8 5531.8 5542.7 5249.1 5256.1 5258.6 5260.4 5288.4 5393.4 5403.6 5406.8 5406.9 5410.1 5317.8 5329.6 5351.0 5367.5 5373.3 5340.2 5348.3 5351.6 5357.2 5360.2 3615.5 3624.3 3635.8 3636.8 3643.6 3251.4 3264.2 3320.7 3324.7 3330.5 5020.1 5030.8 5043.3 5076.4 5081.7 5328.2 5484.9 5499.1 5501.2 5559.1 4793.2 4952.2 4999.6 5008.1 5015.3 4484.9 4497.5 4506.2 4512.1 4566.3 5484.5 5518.3 5523.9 5530.9 5577.9 5160.9 5244.6 5246.0 5276.1 5309.0 5360.4 5361.3 5369.8 5370.9 5375.8 5145.3 5176.4 5177.5 5209.8 5220.6 5221.6 5271.8 5273.6 5303.2 5304.3 5095.4 5150.6 5159.3 5163.8 5168.4 5299.8 5309.7 5335.4 5335.6 5338.6 5123.8 5143.9 5179.9 5221.6 5282.2 5276.6 5281.9 5289.4 5294.8 5339.8 5160.6 5162.0 5188.0 5196.3 5207.4
17:26:45 INFO - PROCESS | 2888 |
17:26:45 INFO - PROCESS | 2888 | [#1] ext.html Cycles:180 Average:49654.45 Median:353947.50 stddev:100044.06 (28.3%) stddev-sans-first:100256.74
17:26:45 INFO - PROCESS | 2888 | Values: 536.8 537.6 538.6 550.2 553.7 28061.7 35850.5 36249.8 36676.1 38789.8 36669.4 36974.1 37046.0 37063.0 37085.0 8339.8 8352.2 8464.6 8483.0 8484.9 8316.5 8357.9 8367.7 8371.9 8386.1 8447.5 8469.3 8490.1 8495.2 8514.8 8380.7 8399.1 8426.7 8429.3 8429.9 8449.9 8481.1 8484.7 8502.1 8516.4 34315.1 35015.6 35109.0 35122.0 35181.3 2838.5 2858.3 2897.7 2899.7 3011.3 28166.7 28181.4 28208.4 29275.4 29777.9 3877.8 3970.2 3993.4 4007.1 4016.8 254539.7 272939.0 274688.0 275165.0 275855.0 45436.0 45640.5 45694.8 45706.5 45774.8 29974.3 30593.5 47671.8 48023.2 48088.8 14529.1 14931.3 14953.1 14992.7 15022.0 11420.0 11529.2 11544.8 11553.4 11554.4 15478.5 15665.2 15676.8 15735.9 15831.4 6158.0 6164.8 6205.7 6226.2 6266.2 786.7 817.6 861.3 866.2 939.5 26350.0 26782.0 26985.9 27092.2 27154.2 912.8 916.3 938.4 986.9 993.8 13805.9 14121.0 14164.7 14292.0 14357.8 472185.0 476667.0 477530.0 478715.0 478752.0 44268.6 44620.3 44718.1 44791.6 45223.3 1027.3 1068.7 1113.9 1124.8 1129.2 25041.0 27475.4 27557.3 27566.0 27810.7 39656.0 40342.2 40347.0 40353.6 40400.4 352220.0 352477.0 353788.0 354107.0 356059.0 21442.8 22207.2 23295.0 24024.3 24522.6 37136.0 38468.6 38507.4 38514.2 39557.4 33414.0 33998.3 34375.5 34413.8 34876.8 32708.8 32805.0 32821.0 33176.8 33655.0 32194.7 32205.0 32675.2 32716.3 33173.2 24737.9 25224.6 25233.4 25333.1 25672.5 23074.4 23616.2 23727.5 23973.2 24085.6
17:26:45 INFO - PROCESS | 2888 |
17:26:45 INFO - PROCESS | 2888 | [#2] jquery.html Cycles:180 Average:23941.05 Median:5042.24 stddev:67155.78 (1331.9%) stddev-sans-first:67320.67
17:26:45 INFO - PROCESS | 2888 | Values: 281.8 287.8 293.5 298.7 304.0 13170.8 14082.2 14446.3 15166.5 15211.5 15261.8 15810.1 16083.6 16172.5 16191.7 4962.3 4998.8 5117.3 5337.4 5350.0 5053.5 5186.2 5188.7 5195.9 5205.6 5040.5 5139.5 5143.7 5143.7 5165.1 5163.3 5283.8 5285.8 5298.9 5308.5 4899.8 5044.0 5090.5 5139.3 5160.3 11220.4 11284.6 11314.2 11409.4 11413.2 1868.1 2077.6 2082.0 2123.1 2253.4 8321.0 8755.4 8755.6 11851.8 12182.8 1718.4 1731.4 1761.3 1771.0 1773.3 66727.7 67125.3 68973.7 70254.6 70803.6 8896.6 8897.1 9000.5 9158.2 9423.6 11322.0 11639.4 11664.0 11780.1 11806.3 6553.9 6709.0 6771.7 6957.9 6963.9 6541.8 6557.0 6639.2 6650.7 6667.9 3660.7 3735.8 3777.1 3794.5 3806.9 1586.6 1648.7 1650.2 1651.4 1680.8 774.3 810.3 856.9 874.8 882.9 15634.5 16053.2 16133.2 16428.8 16851.4 835.0 845.1 857.4 873.7 899.3 8919.3 9052.2 9112.6 9151.1 9236.5 403106.0 406736.0 407171.0 407310.0 410976.0 53413.7 77131.2 77783.6 81197.0 86606.0 863.2 881.2 905.0 909.0 909.2 14487.8 14736.3 14787.0 14940.0 15215.6 33705.8 34254.3 34501.8 35123.3 35459.3 48084.8 48192.3 48335.0 48424.3 48703.3 7026.8 7038.0 7065.2 7207.6 7217.6 8542.3 10355.2 11229.7 11252.9 11305.7 9759.7 9972.1 10055.0 10085.3 10239.5 9635.8 9717.8 9837.4 9865.8 10027.0 10039.2 10154.8 10170.1 10185.5 10287.0 7036.9 7045.0 7051.0 7069.7 7089.0 7422.9 9291.4 9842.4 10031.5 10193.6
17:26:45 INFO - PROCESS | 2888 |
17:26:45 INFO - PROCESS | 2888 | [#3] mootools.html Cycles:180 Average:4440.69 Median:5902.19 stddev:2521.88 (42.7%) stddev-sans-first:2515.04
17:26:45 INFO - PROCESS | 2888 | Values: 916.9 922.9 1064.8 1082.1 1104.4 5899.9 6617.2 6781.0 6806.5 6806.9 6852.7 6898.7 6906.5 6910.1 6925.1 1912.7 1927.7 1937.7 1940.0 1940.2 1888.7 1899.2 1904.7 1954.5 1955.7 1851.4 1858.8 1862.5 1864.4 1865.6 1750.0 1805.9 1805.9 1806.8 1810.1 1744.5 1759.1 1760.5 1762.9 1793.0 6394.1 6552.5 6599.2 6650.5 6818.7 3898.7 4178.7 4180.4 4183.1 4191.2 2661.9 2720.0 2758.5 2765.1 2766.5 909.6 911.1 914.1 917.1 927.3 9105.4 9159.0 9209.1 9238.4 9258.0 3264.7 3385.1 3529.9 3532.2 3542.3 7209.7 7229.4 7241.2 7251.7 7254.7 4016.3 4070.0 4072.4 4074.2 4075.4 3362.4 3467.6 3833.3 3846.6 3852.6 2800.9 2895.7 2906.4 2923.8 2935.8 837.6 838.7 840.6 848.4 852.6 679.4 735.8 737.8 738.7 775.8 4186.8 4360.7 4399.4 4462.7 4641.6 744.4 773.4 803.7 804.3 805.7 3142.1 3148.9 3151.9 3174.1 3224.0 8169.0 8529.8 8533.1 8555.3 8563.6 8486.5 8530.1 8532.4 8538.4 8550.5 6540.6 6599.7 6601.3 6609.1 6618.3 4305.0 4312.8 4447.5 4528.1 4542.4 7645.5 7828.3 7934.8 8000.1 8012.8 7801.5 8106.4 8113.2 8121.9 8127.9 5931.2 6040.3 6051.9 6059.8 6060.6 5667.8 6278.8 6591.6 6625.3 6775.1 6063.9 6090.9 6096.5 6122.0 6131.7 5887.9 5904.5 5919.7 5937.1 5977.1 5057.9 5090.1 5159.3 5296.8 5384.8 3718.6 3777.8 3782.2 3797.2 3847.3 3821.4 3840.5 3849.5 3860.4 4030.2
17:26:45 INFO - PROCESS | 2888 |
17:26:45 INFO - PROCESS | 2888 | [#4] prototype.html Cycles:180 Average:4464.93 Median:5201.37 stddev:1412.79 (27.2%) stddev-sans-first:1381.13
17:26:45 INFO - PROCESS | 2888 | Values: 264.7 265.6 267.2 271.1 271.9 5175.6 5194.5 5196.1 5211.7 5230.1 5132.9 5140.2 5142.4 5144.5 5159.7 3669.0 3688.4 3778.5 3837.3 3839.0 3836.9 3837.6 3842.9 3845.6 3846.8 3810.5 3810.6 3818.7 3827.3 3829.3 3643.4 3712.5 3780.7 3786.1 3808.8 3285.3 3302.3 3312.2 3324.4 3327.4 4977.5 4999.0 4999.6 5007.7 5021.2 4108.4 4319.7 4352.8 4421.2 4436.9 5384.9 5391.0 5392.5 5398.0 5406.2 3534.9 3537.7 3550.0 3550.3 3557.2 5502.6 5527.9 5582.9 5620.9 5647.7 3466.4 3479.5 3479.6 3480.8 3482.0 3506.2 3509.4 3520.2 3521.1 3539.7 4226.6 4227.3 4237.3 4237.6 4238.8 5115.6 5396.3 5402.2 5446.7 5461.7 1260.9 1268.6 1270.9 1273.6 1281.0 746.6 756.6 771.0 785.9 786.6 5043.3 5082.4 5230.9 5240.9 5250.9 5546.6 5556.9 5574.6 5579.3 5615.4 4971.7 5159.7 5165.8 5199.9 5219.1 2967.2 2969.3 2977.6 2985.6 2987.0 5594.2 5610.6 5660.2 5661.7 5677.5 5436.8 5707.6 5759.8 5804.2 5805.9 5740.7 5740.9 5748.8 5748.9 5755.0 5497.2 5594.9 5650.4 5652.3 5680.5 5515.6 5545.5 5562.1 5574.1 5577.7 5715.3 5721.9 5723.2 5725.1 5725.9 3466.0 3605.5 3613.1 3639.8 3644.8 5468.8 5612.2 5634.9 5638.3 5661.6 5480.6 5499.6 5508.3 5522.4 5524.6 5278.6 5467.6 5504.3 5506.4 5512.9 5448.5 5456.7 5462.6 5463.4 5466.2 5202.8 5337.5 5389.3 5391.9 5396.4 5057.3 5405.9 5426.9 5436.9 5441.4
17:26:45 INFO - PROCESS | 2888 |
17:26:45 INFO - PROCESS | 2888 | [#5] yui.html Cycles:180 Average:17743.77 Median:23956.21 stddev:25031.49 (104.5%) stddev-sans-first:25068.66
17:26:45 INFO - PROCESS | 2888 | Values: 613.9 686.1 689.4 691.8 700.8 13685.6 13938.4 14524.4 14793.5 14802.9 12613.4 12855.5 12866.9 12888.4 12920.1 619.2 633.6 633.9 634.3 634.4 545.0 557.8 616.0 632.5 636.7 667.7 672.3 672.9 673.4 674.3 660.5 665.9 667.2 668.2 668.4 416.9 425.7 474.3 483.1 484.4 12832.4 12844.9 12845.6 12867.4 12874.4 10969.9 11207.7 11442.4 11453.7 11579.0 11802.0 11877.3 12019.5 12035.6 12044.0 4073.2 4074.9 4095.2 4138.2 4169.8 59795.4 65829.7 66045.7 66202.3 66626.0 10048.8 10110.3 10189.8 10235.7 10263.3 16356.8 16792.9 16873.2 16897.4 16955.5 6973.6 7330.2 7348.2 7363.1 7514.0 4110.3 4155.3 4213.7 4237.3 4361.6 2798.2 2891.7 2901.0 2907.3 2913.1 504.9 521.5 523.5 523.7 525.3 524.9 534.7 585.2 617.9 626.9 8887.3 9365.8 9679.0 9711.4 9791.9 535.4 648.6 658.4 667.7 685.6 4321.5 4565.2 4579.6 4601.5 4632.4 91888.0 97637.5 98689.0 100482.0 100564.5 82716.1 83296.6 84364.0 84653.6 84902.6 70378.0 70907.9 71371.0 72628.6 72852.6 8181.7 8430.8 8479.9 8500.4 8592.1 39208.0 43120.6 43172.4 43550.3 43550.8 55561.2 56163.4 59224.7 62326.0 63089.7 10549.7 10830.2 11141.6 11172.9 11465.8 12180.4 12664.8 13031.0 13064.3 13548.1 12393.6 12455.7 12665.4 12913.0 12938.2 9965.3 11942.2 12397.7 12691.8 12714.2 12606.2 12674.0 12720.0 12940.4 12966.6 9728.8 9836.0 10282.7 10585.9 10664.2 10164.3 10303.1 10334.8 10432.2 10731.7
17:26:45 INFO - PROCESS | 2888 | -------- Summary: end --------
17:26:45 INFO - PROCESS | 2888 |
17:26:46 INFO - TEST-INFO | 2888: exit 0
17:26:47 INFO - TEST-OK | dromaeo_css | took 1122264ms
17:26:47 INFO - TEST-START | kraken
17:26:47 INFO - operating with platform_type : w8_
17:26:47 INFO - Initialising browser for kraken test...
17:26:47 INFO - TEST-INFO | started process 384 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpii9jug\profile http://localhost:49240/getInfo.html)
17:26:52 INFO - PROCESS | 384 | __metrics Screen width/height:1600/1200
17:26:52 INFO - PROCESS | 384 | colorDepth:24
17:26:52 INFO - PROCESS | 384 | Browser inner width/height: 1010/674
17:26:52 INFO - PROCESS | 384 | __metrics
17:26:53 INFO - PROCESS | 384 | 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"
17:26:53 INFO - PROCESS | 384 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver]
17:26:53 INFO - PROCESS | 384 | console.error:
17:26:53 INFO - PROCESS | 384 | Message: Error: Connection closed before committing the transaction.
17:26:53 INFO - PROCESS | 384 | Stack:
17:26:53 INFO - PROCESS | 384 | ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:937:23
17:26:53 INFO - PROCESS | 384 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7
17:26:53 INFO - PROCESS | 384 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11
17:26:53 INFO - PROCESS | 384 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7
17:26:53 INFO - PROCESS | 384 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:714:7
17:26:53 INFO - PROCESS | 384 | TaskImpl_run@resource://gre/modules/Task.jsm:327:15
17:26:53 INFO - PROCESS | 384 | Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:551:9
17:26:53 INFO - PROCESS | 384 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15
17:26:53 INFO - PROCESS | 384 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:388:5
17:26:53 INFO - PROCESS | 384 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29
17:26:53 INFO - PROCESS | 384 | Barrier/this.client.addBlocker/promise13.3%
17:27:51 INFO - TinderboxPrint: I/O read bytes / time
258,245,120 / 2,760,030
17:27:51 INFO - TinderboxPrint: I/O write bytes / time
411,312,128 / 3,833,660
17:27:51 INFO - TinderboxPrint: CPU idle
8,257.3 (86.7%)
17:27:51 INFO - TinderboxPrint: CPU user
1,220.0 (12.8%)
17:27:51 INFO - install - Wall time: 3s; CPU: 12.0%; Read bytes: 0; Write bytes: 33820672; Read time: 0; Write time: 37210
17:27:51 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 258198528; Write bytes: 320878080; Read time: 2753210; Write time: 3535790
17:27:51 INFO - Running post-run listener: _upload_blobber_files
17:27:51 INFO - Blob upload gear active.
17:27:51 INFO - Preparing to upload files from C:\slave\test\build\blobber_upload_dir.
17:27:51 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
17:27:51 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\venv\\Scripts\\blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', 'C:\\slave\\test\\oauth.txt', '-b', 'Fx-Team', '-d', 'C:\\slave\\test\\build\\blobber_upload_dir', '--output-manifest', 'C:\\slave\\test\\build\\uploaded_files.json']
17:27:51 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\venv\Scripts\blobberc.py -u https://blobupload.elasticbeanstalk.com -a C:\slave\test\oauth.txt -b Fx-Team -d C:\slave\test\build\blobber_upload_dir --output-manifest C:\slave\test\build\uploaded_files.json
17:27:52 INFO - (blobuploader) - INFO - Open directory for files ...
17:27:52 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_errorsummary.log ...
17:27:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
17:27:52 INFO - (blobuploader) - INFO - Uploading, attempt #1.
17:27:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded
17:27:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
17:27:53 INFO - (blobuploader) - INFO - Done attempting.
17:27:53 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_raw.log ...
17:27:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
17:27:53 INFO - (blobuploader) - INFO - Uploading, attempt #1.
17:27:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded
17:27:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
17:27:54 INFO - (blobuploader) - INFO - Done attempting.
17:27:54 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\resource-usage.json ...
17:27:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
17:27:54 INFO - (blobuploader) - INFO - Uploading, attempt #1.
17:27:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded
17:27:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
17:27:56 INFO - (blobuploader) - INFO - Done attempting.
17:27:56 INFO - (blobuploader) - INFO - Iteration through files over.
17:27:56 INFO - Return code: 0
17:27:56 INFO - rmtree: C:\slave\test\build\uploaded_files.json
17:27:56 INFO - Using _rmtree_windows ...
17:27:56 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build\\uploaded_files.json',), kwargs: {}, attempt #1
17:27:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e10106500ebb030a56d2f78b3d1f072cca51bf925861d50e903293a05d6920eddaf697c7df831f00e3b87e96d0be9195bdf4e21bc3261b01c1ca1cd902c57f02", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d302da572df6e2d52cf2e75141aad2992790bf4607bc1442d34ff01d5fb960c8490a1c6ad7ea37044e37bcaaf0efd760d84d72091df651c9163465dcea02c461", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/080c7ba16217dc393f4f9c9ffbb20510eaa6e5a4a71bd7092512c0f35651f478376079c2f54caaa70c955be12e0fb48994fcc1f7eb0b675701efce5d0f2d56ca"}
17:27:56 INFO - Writing buildbot properties ['blobber_files'] to C:\slave\test\properties\blobber_files
17:27:56 INFO - Writing to file C:\slave\test\properties\blobber_files
17:27:56 INFO - Contents:
17:27:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e10106500ebb030a56d2f78b3d1f072cca51bf925861d50e903293a05d6920eddaf697c7df831f00e3b87e96d0be9195bdf4e21bc3261b01c1ca1cd902c57f02", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d302da572df6e2d52cf2e75141aad2992790bf4607bc1442d34ff01d5fb960c8490a1c6ad7ea37044e37bcaaf0efd760d84d72091df651c9163465dcea02c461", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/080c7ba16217dc393f4f9c9ffbb20510eaa6e5a4a71bd7092512c0f35651f478376079c2f54caaa70c955be12e0fb48994fcc1f7eb0b675701efce5d0f2d56ca"}
17:27:56 INFO - Running post-run listener: copy_logs_to_upload_dir
17:27:56 INFO - Copying logs to upload dir...
17:27:56 INFO - mkdir: C:\slave\test\build\upload\logs
17:27:56 INFO - Copying logs to upload dir...
17:27:56 INFO - Using _rmtree_windows ...
17:27:56 INFO - Using _rmtree_windows ...
17:27:56 INFO - Using _rmtree_windows ...
17:27:56 INFO - Using _rmtree_windows ...
17:27:56 INFO - Using _rmtree_windows ...
17:27:56 INFO - Using _rmtree_windows ...
17:27:56 INFO - Using _rmtree_windows ...
program finished with exit code 0
elapsedTime=1391.822000
========= master_lag: 0.62 =========
========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 12 secs) (at 2016-10-13 17:27:57.190088) =========
========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 17:27:57.190889) =========
'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-152\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-152
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-152
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-152\AppData\Local
LOGONSERVER=\\T-W864-IX-152
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-152
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-152
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-152
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e10106500ebb030a56d2f78b3d1f072cca51bf925861d50e903293a05d6920eddaf697c7df831f00e3b87e96d0be9195bdf4e21bc3261b01c1ca1cd902c57f02", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d302da572df6e2d52cf2e75141aad2992790bf4607bc1442d34ff01d5fb960c8490a1c6ad7ea37044e37bcaaf0efd760d84d72091df651c9163465dcea02c461", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/080c7ba16217dc393f4f9c9ffbb20510eaa6e5a4a71bd7092512c0f35651f478376079c2f54caaa70c955be12e0fb48994fcc1f7eb0b675701efce5d0f2d56ca"}
build_url:https://queue.taskcluster.net/v1/task/IviLE9gZSRCcZglg5E817Q/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/IviLE9gZSRCcZglg5E817Q/artifacts/public/build/firefox-52.0a1.en-US.win64.zip'
blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e10106500ebb030a56d2f78b3d1f072cca51bf925861d50e903293a05d6920eddaf697c7df831f00e3b87e96d0be9195bdf4e21bc3261b01c1ca1cd902c57f02", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d302da572df6e2d52cf2e75141aad2992790bf4607bc1442d34ff01d5fb960c8490a1c6ad7ea37044e37bcaaf0efd760d84d72091df651c9163465dcea02c461", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/080c7ba16217dc393f4f9c9ffbb20510eaa6e5a4a71bd7092512c0f35651f478376079c2f54caaa70c955be12e0fb48994fcc1f7eb0b675701efce5d0f2d56ca"}'
========= master_lag: 0.25 =========
========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 17:27:57.542753) =========
========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 17:27:57.543110) =========
'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-152\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-152
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-152
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-152\AppData\Local
LOGONSERVER=\\T-W864-IX-152
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-152
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-152
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-152
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-13 17:27:57.662105) =========
========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-10-13 17:27:57.662423) =========
========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-10-13 17:27:58.163342) =========
========= Total master_lag: 1.03 =========