builder: fx-team_win8_64_test-dromaeojs-pgo
slave: t-w864-ix-164
starttime: 1476764888.23
results: success (0)
buildid: 20161017183007
builduid: 30bef4653d534d289e3bb824957efae6
revision: 47be3ae8a710b35f040dffe7403877e764ab61ac
========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 21:28:08.226631) =========
master: http://buildbot-master109.bb.releng.scl3.mozilla.com:8201/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 21:28:08.227106) =========
========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 21:28:08.227406) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 21:28:08.704607) =========
========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-17 21:28:08.705010) =========
'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-164\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-164
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-164
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-164\AppData\Local
LOGONSERVER=\\T-W864-IX-164
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-164
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-164
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-164
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
--21:28:09-- 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% 18.07 MB/s
21:28:09 (18.07 MB/s) - `archiver_client.py' saved [12179/12179]
program finished with exit code 0
elapsedTime=1.200000
========= master_lag: 0.06 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-17 21:28:09.960061) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-10-17 21:28:09.960402) =========
'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-164\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-164
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-164
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-164\AppData\Local
LOGONSERVER=\\T-W864-IX-164
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-164
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-164
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-164
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
program finished with exit code 0
elapsedTime=2.805000
========= master_lag: 0.02 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-10-17 21:28:12.782227) =========
========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-17 21:28:12.782664) =========
'bash' '-c' u'python archiver_client.py mozharness --repo integration/fx-team --rev 47be3ae8a710b35f040dffe7403877e764ab61ac --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 47be3ae8a710b35f040dffe7403877e764ab61ac --destination scripts --debug']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld.T-W864-IX-164\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-164
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-164
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-164\AppData\Local
LOGONSERVER=\\T-W864-IX-164
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-164
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-164
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-164
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
2016-10-17 21:28:12,868 truncating revision to first 12 chars
2016-10-17 21:28:12,868 Setting DEBUG logging.
2016-10-17 21:28:12,868 attempt 1/10
2016-10-17 21:28:12,868 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/47be3ae8a710?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2016-10-17 21:28:13,885 unpacking tar archive at: fx-team-47be3ae8a710/testing/mozharness/
2016-10-17 21:28:13,980 skipping symlink on windows: configs/single_locale/linux32.py
program finished with exit code 0
elapsedTime=1.698000
========= master_lag: 0.05 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-17 21:28:14.529161) =========
========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 21:28:14.529536) =========
script_repo_revision: 47be3ae8a710b35f040dffe7403877e764ab61ac
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 21:28:14.529990) =========
========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 21:28:14.530273) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 21:28:14.549031) =========
========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 7 secs) (at 2016-10-17 21:28:14.549431) =========
'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-164\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-164
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-164
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-164\AppData\Local
LOGONSERVER=\\T-W864-IX-164
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-164
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-164
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-164
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
21:28:14 INFO - MultiFileLogger online at 20161017 21:28:14 in C:\slave\test
21:28:14 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
21:28:14 INFO - Dumping config to C:\slave\test\logs\localconfig.json.
21:28:14 INFO - {'append_to_log': False,
21:28:14 INFO - 'base_work_dir': 'C:\\slave\\test',
21:28:14 INFO - 'blob_upload_branch': 'Fx-Team',
21:28:14 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt',
21:28:14 INFO - 'branch': 'Fx-Team',
21:28:14 INFO - 'buildbot_json_path': 'buildprops.json',
21:28:14 INFO - 'config_files': ('talos/windows_config.py',),
21:28:14 INFO - 'default_actions': ('clobber',
21:28:14 INFO - 'read-buildbot-config',
21:28:14 INFO - 'download-and-extract',
21:28:14 INFO - 'populate-webroot',
21:28:14 INFO - 'create-virtualenv',
21:28:14 INFO - 'install',
21:28:14 INFO - 'run-tests'),
21:28:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',),
21:28:14 INFO - 'download_minidump_stackwalk': True,
21:28:14 INFO - 'download_symbols': 'ondemand',
21:28:14 INFO - 'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python',
21:28:14 INFO - 'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'),
21:28:14 INFO - 'hg': 'c:/mozilla-build/hg/hg',
21:28:14 INFO - 'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python',
21:28:14 INFO - 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'),
21:28:14 INFO - 'python': 'c:/mozilla-build/python27/python.exe',
21:28:14 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe',
21:28:14 INFO - 'C:/mozilla-build/tooltool.py'),
21:28:14 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe',
21:28:14 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')},
21:28:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub',
21:28:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'),
21:28:14 INFO - 'installer_path': 'installer.exe',
21:28:14 INFO - 'log_level': 'info',
21:28:14 INFO - 'log_name': 'talos',
21:28:14 INFO - 'log_to_console': True,
21:28:14 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe',
21:28:14 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe',
21:28:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest',
21:28:14 INFO - 'opt_config_files': (),
21:28:14 INFO - 'pip_index': False,
21:28:14 INFO - 'sps_profile': False,
21:28:14 INFO - 'sps_profile_interval': 0,
21:28:14 INFO - 'suite': 'dromaeojs',
21:28:14 INFO - 'system_bits': '32',
21:28:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'),
21:28:14 INFO - 'title': 'T-W864-IX-164',
21:28:14 INFO - 'use_talos_json': True,
21:28:14 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'),
21:28:14 INFO - 'virtualenv_path': 'C:\\slave\\test\\build/venv',
21:28:14 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll',
21:28:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
21:28:14 INFO - 'work_dir': 'build'}
21:28:14 INFO - [mozharness: 2016-10-18 04:28:14.962000Z] Running clobber step.
21:28:14 INFO - Running pre-action listener: _resource_record_pre_action
21:28:14 INFO - Running main action method: clobber
21:28:14 INFO - rmtree: C:\slave\test\build
21:28:14 INFO - Using _rmtree_windows ...
21:28:14 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1
21:29:52 INFO - Running post-action listener: _resource_record_post_action
21:29:52 INFO - [mozharness: 2016-10-18 04:29:52.893000Z] Finished clobber step (success)
21:29:52 INFO - [mozharness: 2016-10-18 04:29:52.893000Z] Running read-buildbot-config step.
21:29:52 INFO - Running pre-action listener: _resource_record_pre_action
21:29:52 INFO - Running main action method: read_buildbot_config
21:29:52 INFO - Using buildbot properties:
21:29:52 INFO - {
21:29:52 INFO - "project": "",
21:29:52 INFO - "product": "firefox",
21:29:52 INFO - "script_repo_revision": "production",
21:29:52 INFO - "builddir": "fx-team_win8_64_test-dromaeojs",
21:29:52 INFO - "repository": "",
21:29:52 INFO - "buildername": "Windows 8 64-bit fx-team pgo talos dromaeojs",
21:29:52 INFO - "buildid": "20161017183007",
21:29:52 INFO - "pgo_build": "True",
21:29:52 INFO - "basedir": "C:\\slave\\test",
21:29:52 INFO - "buildnumber": 6,
21:29:52 INFO - "slavename": "t-w864-ix-164",
21:29:52 INFO - "master": "http://buildbot-master109.bb.releng.scl3.mozilla.com:8201/",
21:29:52 INFO - "platform": "win8_64",
21:29:52 INFO - "scheduler": "tests-fx-team-win64-pgo-talos",
21:29:52 INFO - "branch": "fx-team",
21:29:52 INFO - "repo_path": "integration/fx-team",
21:29:52 INFO - "revision": "47be3ae8a710b35f040dffe7403877e764ab61ac",
21:29:52 INFO - "stage_platform": "win64-pgo",
21:29:52 INFO - "builduid": "30bef4653d534d289e3bb824957efae6",
21:29:52 INFO - "slavebuilddir": "test"
21:29:52 INFO - }
21:29:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/WzOP4LHtS9q7G9fPWHo64A/artifacts/public/build/firefox-52.0a1.en-US.win64.zip.
21:29:52 INFO - Running post-action listener: _resource_record_post_action
21:29:52 INFO - [mozharness: 2016-10-18 04:29:52.896000Z] Finished read-buildbot-config step (success)
21:29:52 INFO - [mozharness: 2016-10-18 04:29:52.896000Z] Running download-and-extract step.
21:29:52 INFO - Running pre-action listener: _resource_record_pre_action
21:29:52 INFO - Running main action method: download_and_extract
21:29:52 INFO - mkdir: C:\slave\test\build\tests
21:29:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:29:52 INFO - trying https://queue.taskcluster.net/v1/task/WzOP4LHtS9q7G9fPWHo64A/artifacts/public/build/firefox-52.0a1.en-US.win64.test_packages.json
21:29:52 INFO - Downloading https://queue.taskcluster.net/v1/task/WzOP4LHtS9q7G9fPWHo64A/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
21:29:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WzOP4LHtS9q7G9fPWHo64A/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
21:29:53 INFO - Downloaded 1218 bytes.
21:29:53 INFO - Reading from file C:\slave\test\build\firefox-52.0a1.en-US.win64.test_packages.json
21:29:53 INFO - Using the following test package requirements:
21:29:53 INFO - {u'common': [u'firefox-52.0a1.en-US.win64.common.tests.zip'],
21:29:53 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.win64.common.tests.zip',
21:29:53 INFO - u'firefox-52.0a1.en-US.win64.cppunittest.tests.zip'],
21:29:53 INFO - u'gtest': [u'firefox-52.0a1.en-US.win64.common.tests.zip'],
21:29:53 INFO - u'jittest': [u'firefox-52.0a1.en-US.win64.common.tests.zip',
21:29:53 INFO - u'jsshell-win64.zip'],
21:29:53 INFO - u'mochitest': [u'firefox-52.0a1.en-US.win64.common.tests.zip',
21:29:53 INFO - u'firefox-52.0a1.en-US.win64.mochitest.tests.zip'],
21:29:53 INFO - u'mozbase': [u'firefox-52.0a1.en-US.win64.common.tests.zip'],
21:29:53 INFO - u'reftest': [u'firefox-52.0a1.en-US.win64.common.tests.zip',
21:29:53 INFO - u'firefox-52.0a1.en-US.win64.reftest.tests.zip'],
21:29:53 INFO - u'talos': [u'firefox-52.0a1.en-US.win64.common.tests.zip',
21:29:53 INFO - u'firefox-52.0a1.en-US.win64.talos.tests.zip'],
21:29:53 INFO - u'web-platform': [u'firefox-52.0a1.en-US.win64.common.tests.zip',
21:29:53 INFO - u'firefox-52.0a1.en-US.win64.web-platform.tests.zip'],
21:29:53 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.win64.common.tests.zip',
21:29:53 INFO - u'firefox-52.0a1.en-US.win64.xpcshell.tests.zip']}
21:29:53 INFO - Downloading packages: [u'firefox-52.0a1.en-US.win64.common.tests.zip'] for test suite category: common
21:29:53 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/WzOP4LHtS9q7G9fPWHo64A/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip
21:29:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WzOP4LHtS9q7G9fPWHo64A/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip'}, attempt #1
21:29:53 INFO - Fetch https://queue.taskcluster.net/v1/task/WzOP4LHtS9q7G9fPWHo64A/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip into memory
21:29:54 INFO - Http code: 200
21:29:54 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront)
21:29:54 INFO - x-amz-cf-id: -7De0RanKFThVjnRpuPs8ZeNsJoNvW7bKZlLci0T_etqIyDzZeNmSg==
21:29:54 INFO - x-amz-version-id: _80lA67M4p9lR5wg_.Fe55wkcu5e8tKn
21:29:54 INFO - Expected file size: 17524915
21:29:54 INFO - Obtained file size: 17524915
21:30:17 INFO - Downloading packages: [u'firefox-52.0a1.en-US.win64.common.tests.zip', u'firefox-52.0a1.en-US.win64.talos.tests.zip'] for test suite category: talos
21:30:17 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/WzOP4LHtS9q7G9fPWHo64A/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip
21:30:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WzOP4LHtS9q7G9fPWHo64A/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip'}, attempt #1
21:30:17 INFO - Fetch https://queue.taskcluster.net/v1/task/WzOP4LHtS9q7G9fPWHo64A/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip into memory
21:30:17 INFO - Http code: 200
21:30:17 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront)
21:30:17 INFO - x-amz-cf-id: 6uaw2S_60Sucz-m-cdMIY9KVpou19yB6C7USh7umvrsXSCliay-iSw==
21:30:17 INFO - x-amz-version-id: _80lA67M4p9lR5wg_.Fe55wkcu5e8tKn
21:30:18 INFO - Expected file size: 17524915
21:30:18 INFO - Obtained file size: 17524915
21:30:26 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/WzOP4LHtS9q7G9fPWHo64A/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip
21:30:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WzOP4LHtS9q7G9fPWHo64A/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip'}, attempt #1
21:30:26 INFO - Fetch https://queue.taskcluster.net/v1/task/WzOP4LHtS9q7G9fPWHo64A/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip into memory
21:30:27 INFO - Http code: 200
21:30:27 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront)
21:30:27 INFO - x-amz-cf-id: hiKWXy33knZfDrmKqqbesBT41K9jbsZyMYvjvCjUbzmhJ0sKSuWqtQ==
21:30:27 INFO - x-amz-version-id: nqhO4P9OsvnsuDOS9e.Y1qVCFmakrVTj
21:30:27 INFO - Expected file size: 14409028
21:30:27 INFO - Obtained file size: 14409028
21:30: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')]}
21:30:36 INFO - trying https://queue.taskcluster.net/v1/task/WzOP4LHtS9q7G9fPWHo64A/artifacts/public/build/firefox-52.0a1.en-US.win64.zip
21:30:36 INFO - Downloading https://queue.taskcluster.net/v1/task/WzOP4LHtS9q7G9fPWHo64A/artifacts/public/build/firefox-52.0a1.en-US.win64.zip to C:\slave\test\build\firefox-52.0a1.en-US.win64.zip
21:30:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WzOP4LHtS9q7G9fPWHo64A/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
21:30:37 INFO - Downloaded 57286577 bytes.
21:30:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WzOP4LHtS9q7G9fPWHo64A/artifacts/public/build/firefox-52.0a1.en-US.win64.zip
21:30:37 INFO - mkdir: C:\slave\test\properties
21:30:37 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url
21:30:37 INFO - Writing to file C:\slave\test\properties\build_url
21:30:37 INFO - Contents:
21:30:37 INFO - build_url:https://queue.taskcluster.net/v1/task/WzOP4LHtS9q7G9fPWHo64A/artifacts/public/build/firefox-52.0a1.en-US.win64.zip
21:30:38 INFO - Running post-action listener: _resource_record_post_action
21:30:38 INFO - Running post-action listener: set_extra_try_arguments
21:30:38 INFO - [mozharness: 2016-10-18 04:30:38.417000Z] Finished download-and-extract step (success)
21:30:38 INFO - [mozharness: 2016-10-18 04:30:38.417000Z] Running populate-webroot step.
21:30:38 INFO - Running pre-action listener: _resource_record_pre_action
21:30:38 INFO - Running main action method: populate_webroot
21:30:38 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']},
21:30:38 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']},
21:30:38 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome',
21:30:38 INFO - u'--tppagecycles',
21:30:38 INFO - u'7'],
21:30:38 INFO - u'tests': [u'tsvgm']}},
21:30:38 INFO - u'suites': {u'chromez': {u'talos_options': [u'--disable-e10s'],
21:30:38 INFO - u'tests': [u'tresize', u'tcanvasmark']},
21:30:38 INFO - u'chromez-e10s': {u'tests': [u'tresize', u'tcanvasmark']},
21:30:38 INFO - u'dromaeojs': {u'talos_options': [u'--disable-e10s'],
21:30:38 INFO - u'tests': [u'dromaeo_css', u'kraken']},
21:30:38 INFO - u'dromaeojs-e10s': {u'tests': [u'dromaeo_css', u'kraken']},
21:30:38 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
21:30:38 INFO - u'talos_options': [u'--disable-e10s'],
21:30:38 INFO - u'tests': [u'tp5o_scroll', u'glterrain']},
21:30:38 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
21:30:38 INFO - u'tests': [u'tp5o_scroll', u'glterrain']},
21:30:38 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
21:30:38 INFO - u'talos_options': [u'--disable-e10s'],
21:30:38 INFO - u'tests': [u'damp', u'tps']},
21:30:38 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
21:30:38 INFO - u'tests': [u'damp', u'tps']},
21:30:38 INFO - u'g3': {u'talos_options': [u'--disable-e10s'],
21:30:38 INFO - u'tests': [u'dromaeo_dom']},
21:30:38 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']},
21:30:38 INFO - u'g4': {u'talos_options': [u'--disable-e10s'],
21:30:38 INFO - u'tests': [u'basic_compositor_video']},
21:30:38 INFO - u'g4-e10s': {u'tests': [u'basic_compositor_video']},
21:30:38 INFO - u'other': {u'talos_options': [u'--disable-e10s'],
21:30:38 INFO - u'tests': [u'a11yr',
21:30:38 INFO - u'ts_paint',
21:30:38 INFO - u'tpaint',
21:30:38 INFO - u'sessionrestore',
21:30:38 INFO - u'sessionrestore_no_auto_restore',
21:30:38 INFO - u'tabpaint']},
21:30:38 INFO - u'other-e10s': {u'tests': [u'a11yr',
21:30:38 INFO - u'ts_paint',
21:30:38 INFO - u'tpaint',
21:30:38 INFO - u'sessionrestore',
21:30:38 INFO - u'sessionrestore_no_auto_restore',
21:30:38 INFO - u'tabpaint']},
21:30:38 INFO - u'other-e10s_l64': {u'tests': [u'a11yr',
21:30:38 INFO - u'ts_paint',
21:30:38 INFO - u'tpaint',
21:30:38 INFO - u'sessionrestore',
21:30:38 INFO - u'sessionrestore_no_auto_restore',
21:30:38 INFO - u'tabpaint']},
21:30:38 INFO - u'other-e10s_nol64': {u'tests': [u'a11yr',
21:30:38 INFO - u'ts_paint',
21:30:38 INFO - u'tpaint',
21:30:38 INFO - u'sessionrestore',
21:30:38 INFO - u'sessionrestore_no_auto_restore',
21:30:38 INFO - u'tabpaint']},
21:30:38 INFO - u'other_l64': {u'talos_options': [u'--disable-e10s'],
21:30:38 INFO - u'tests': [u'a11yr',
21:30:38 INFO - u'ts_paint',
21:30:38 INFO - u'tpaint',
21:30:38 INFO - u'sessionrestore',
21:30:38 INFO - u'sessionrestore_no_auto_restore',
21:30:38 INFO - u'tabpaint']},
21:30:38 INFO - u'other_nol64': {u'talos_options': [u'--disable-e10s'],
21:30:38 INFO - u'tests': [u'a11yr',
21:30:38 INFO - u'ts_paint',
21:30:38 INFO - u'tpaint',
21:30:38 INFO - u'sessionrestore',
21:30:38 INFO - u'sessionrestore_no_auto_restore',
21:30:38 INFO - u'tabpaint']},
21:30:38 INFO - u'svgr': {u'talos_options': [u'--disable-e10s'],
21:30:38 INFO - u'tests': [u'tsvgx',
21:30:38 INFO - u'tsvgr_opacity',
21:30:38 INFO - u'tart',
21:30:38 INFO - u'tscrollx',
21:30:38 INFO - u'cart']},
21:30:38 INFO - u'svgr-e10s': {u'tests': [u'tsvgx',
21:30:38 INFO - u'tsvgr_opacity',
21:30:38 INFO - u'tart',
21:30:38 INFO - u'tscrollx',
21:30:38 INFO - u'cart']},
21:30:38 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
21:30:38 INFO - u'talos_options': [u'--disable-e10s'],
21:30:38 INFO - u'tests': [u'tp5o']},
21:30:38 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
21:30:38 INFO - u'tests': [u'tp5o']},
21:30:38 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
21:30:38 INFO - u'talos_options': [u'--disable-e10s',
21:30:38 INFO - u'--xperf_path',
21:30:38 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
21:30:38 INFO - u'tests': [u'tp5n']},
21:30:38 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
21:30:38 INFO - u'talos_options': [u'--xperf_path',
21:30:38 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
21:30:38 INFO - u'tests': [u'tp5n']}},
21:30:38 INFO - u'talos.zip': {u'path': u'',
21:30:38 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}}
21:30:38 INFO - Running post-action listener: _resource_record_post_action
21:30:38 INFO - [mozharness: 2016-10-18 04:30:38.502000Z] Finished populate-webroot step (success)
21:30:38 INFO - [mozharness: 2016-10-18 04:30:38.502000Z] Running create-virtualenv step.
21:30:38 INFO - Running pre-action listener: _resource_record_pre_action
21:30:38 INFO - Running main action method: create_virtualenv
21:30:38 INFO - Creating virtualenv C:\slave\test\build/venv
21:30:38 INFO - mkdir: C:\slave\test\build\venv\Scripts
21:30:38 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll
21:30:38 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'!
21:30:38 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
21:30:38 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build/venv
21:30:44 INFO - New python executable in C:\slave\test\build/venv\Scripts\python.exe
21:30:48 INFO - Installing distribute......................................................................................................................................................................................done.
21:30:49 INFO - Return code: 0
21:30:49 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', '--version']
21:30:49 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip --version
21:30:49 INFO - Reading from file tmpfile_stdout
21:30:49 INFO - Output received:
21:30:49 INFO - pip 0.8.2 from c:\slave\test\build\venv\lib\site-packages\pip-0.8.2-py2.7.egg (python 2.7)
21:30:49 INFO - Using _rmtree_windows ...
21:30:49 INFO - Using _rmtree_windows ...
21:30:49 INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv
21:30:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:30:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:30:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:30:49 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 0x023DC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0245DE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02864110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02438E90>, '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 0x0049A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028A4520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-164', 'USERDOMAIN': 'T-W864-IX-164', '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-164', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-164\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-164', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-164', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-164', '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-164\\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
21:30:49 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
21:30:49 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
21:30:49 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
21:30:49 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-164\\AppData\\Roaming',
21:30:49 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
21:30:49 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
21:30:49 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
21:30:49 INFO - 'COMPUTERNAME': 'T-W864-IX-164',
21:30:49 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
21:30:49 INFO - 'DCLOCATION': 'SCL3',
21:30:49 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
21:30:49 INFO - 'FP_NO_HOST_CHECK': 'NO',
21:30:49 INFO - 'HOMEDRIVE': 'C:',
21:30:49 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-164',
21:30:49 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
21:30:49 INFO - 'KTS_VERSION': '1.19c',
21:30:49 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-164\\AppData\\Local',
21:30:49 INFO - 'LOGONSERVER': '\\\\T-W864-IX-164',
21:30:49 INFO - 'MONDIR': 'C:\\Monitor_config\\',
21:30:49 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
21:30:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:30:49 INFO - 'MOZ_NO_REMOTE': '1',
21:30:49 INFO - 'NO_EM_RESTART': '1',
21:30:49 INFO - 'NUMBER_OF_PROCESSORS': '8',
21:30:49 INFO - 'OS': 'Windows_NT',
21:30:49 INFO - 'OURDRIVE': 'C:',
21:30:49 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
21:30:49 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
21:30:49 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
21:30:49 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
21:30:49 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
21:30:49 INFO - 'PROCESSOR_LEVEL': '6',
21:30:49 INFO - 'PROCESSOR_REVISION': '1e05',
21:30:49 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
21:30:49 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
21:30:49 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
21:30:49 INFO - 'PROGRAMW6432': 'C:\\Program Files',
21:30:49 INFO - 'PROMPT': '$P$G',
21:30:49 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
21:30:49 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
21:30:49 INFO - 'PUBLIC': 'C:\\Users\\Public',
21:30:49 INFO - 'PWD': 'C:\\slave\\test',
21:30:49 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
21:30:49 INFO - 'SLAVEDIR': 'C:\\slave\\',
21:30:49 INFO - 'SYSTEMDRIVE': 'C:',
21:30:49 INFO - 'SYSTEMROOT': 'C:\\windows',
21:30:49 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
21:30:49 INFO - 'TEST1': 'testie',
21:30:49 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
21:30:49 INFO - 'USERDOMAIN': 'T-W864-IX-164',
21:30:49 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-164',
21:30:49 INFO - 'USERNAME': 'cltbld',
21:30:49 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-164',
21:30:49 INFO - 'WINDIR': 'C:\\windows',
21:30:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
21:30:50 INFO - Ignoring indexes: http://pypi.python.org/simple/
21:30:50 INFO - Downloading/unpacking pip>=1.5
21:30:54 INFO - Running setup.py egg_info for package pip
21:30:54 INFO - warning: no files found matching 'pip\cacert.pem'
21:30:54 INFO - warning: no files found matching '*.html' under directory 'docs'
21:30:54 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build'
21:30:54 INFO - no previously-included directories found matching 'docs\_build\_sources'
21:30:54 INFO - Installing collected packages: pip
21:30:54 INFO - Found existing installation: pip 0.8.2
21:30:54 INFO - Uninstalling pip:
21:30:54 INFO - Successfully uninstalled pip
21:30:54 INFO - Running setup.py install for pip
21:30:54 INFO - warning: no files found matching 'pip\cacert.pem'
21:30:54 INFO - warning: no files found matching '*.html' under directory 'docs'
21:30:54 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build'
21:30:54 INFO - no previously-included directories found matching 'docs\_build\_sources'
21:30:54 INFO - Installing pip-script.py script to C:\slave\test\build\venv\Scripts
21:30:54 INFO - Installing pip.exe script to C:\slave\test\build\venv\Scripts
21:30:54 INFO - Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts
21:30:54 INFO - Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts
21:30:54 INFO - Installing pip2-script.py script to C:\slave\test\build\venv\Scripts
21:30:54 INFO - Installing pip2.exe script to C:\slave\test\build\venv\Scripts
21:30:54 INFO - Successfully installed pip
21:30:54 INFO - Cleaning up...
21:30:54 INFO - Return code: 0
21:30:54 INFO - Installing psutil>=3.1.1 into virtualenv C:\slave\test\build/venv
21:30:54 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')]}
21:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:30:54 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')]}
21:30:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:30:54 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 0x023DC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0245DE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02864110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02438E90>, '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 0x0049A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028A4520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-164', 'USERDOMAIN': 'T-W864-IX-164', '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-164', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-164\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-164', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-164', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-164', '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-164\\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
21:30:54 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
21:30:54 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
21:30:55 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
21:30:55 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-164\\AppData\\Roaming',
21:30:55 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
21:30:55 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
21:30:55 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
21:30:55 INFO - 'COMPUTERNAME': 'T-W864-IX-164',
21:30:55 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
21:30:55 INFO - 'DCLOCATION': 'SCL3',
21:30:55 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
21:30:55 INFO - 'FP_NO_HOST_CHECK': 'NO',
21:30:55 INFO - 'HOMEDRIVE': 'C:',
21:30:55 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-164',
21:30:55 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
21:30:55 INFO - 'KTS_VERSION': '1.19c',
21:30:55 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-164\\AppData\\Local',
21:30:55 INFO - 'LOGONSERVER': '\\\\T-W864-IX-164',
21:30:55 INFO - 'MONDIR': 'C:\\Monitor_config\\',
21:30:55 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
21:30:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:30:55 INFO - 'MOZ_NO_REMOTE': '1',
21:30:55 INFO - 'NO_EM_RESTART': '1',
21:30:55 INFO - 'NUMBER_OF_PROCESSORS': '8',
21:30:55 INFO - 'OS': 'Windows_NT',
21:30:55 INFO - 'OURDRIVE': 'C:',
21:30:55 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',
21:30:55 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
21:30:55 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
21:30:55 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
21:30:55 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
21:30:55 INFO - 'PROCESSOR_LEVEL': '6',
21:30:55 INFO - 'PROCESSOR_REVISION': '1e05',
21:30:55 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
21:30:55 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
21:30:55 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
21:30:55 INFO - 'PROGRAMW6432': 'C:\\Program Files',
21:30:55 INFO - 'PROMPT': '$P$G',
21:30:55 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
21:30:55 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
21:30:55 INFO - 'PUBLIC': 'C:\\Users\\Public',
21:30:55 INFO - 'PWD': 'C:\\slave\\test',
21:30:55 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
21:30:55 INFO - 'SLAVEDIR': 'C:\\slave\\',
21:30:55 INFO - 'SYSTEMDRIVE': 'C:',
21:30:55 INFO - 'SYSTEMROOT': 'C:\\windows',
21:30:55 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
21:30:55 INFO - 'TEST1': 'testie',
21:30:55 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
21:30:55 INFO - 'USERDOMAIN': 'T-W864-IX-164',
21:30:55 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-164',
21:30:55 INFO - 'USERNAME': 'cltbld',
21:30:55 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-164',
21:30:55 INFO - 'WINDIR': 'C:\\windows',
21:30:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
21:30:56 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:30:56 INFO - Downloading/unpacking psutil>=3.1.1
21:30:56 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
21:30:56 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
21:30:57 INFO - Installing collected packages: psutil
21:30:57 INFO - Successfully installed psutil
21:30:57 INFO - Cleaning up...
21:30:58 INFO - Return code: 0
21:30:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv C:\slave\test\build/venv
21:30: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')]}
21:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:30: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')]}
21:30:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:30:58 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 0x023DC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0245DE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02864110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02438E90>, '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 0x0049A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028A4520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-164', 'USERDOMAIN': 'T-W864-IX-164', '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-164', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-164\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-164', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-164', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-164', '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-164\\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
21:30:58 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
21:30:58 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
21:30:58 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
21:30:58 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-164\\AppData\\Roaming',
21:30:58 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
21:30:58 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
21:30:58 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
21:30:58 INFO - 'COMPUTERNAME': 'T-W864-IX-164',
21:30:58 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
21:30:58 INFO - 'DCLOCATION': 'SCL3',
21:30:58 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
21:30:58 INFO - 'FP_NO_HOST_CHECK': 'NO',
21:30:58 INFO - 'HOMEDRIVE': 'C:',
21:30:58 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-164',
21:30:58 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
21:30:58 INFO - 'KTS_VERSION': '1.19c',
21:30:58 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-164\\AppData\\Local',
21:30:58 INFO - 'LOGONSERVER': '\\\\T-W864-IX-164',
21:30:58 INFO - 'MONDIR': 'C:\\Monitor_config\\',
21:30:58 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
21:30:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:30:58 INFO - 'MOZ_NO_REMOTE': '1',
21:30:58 INFO - 'NO_EM_RESTART': '1',
21:30:58 INFO - 'NUMBER_OF_PROCESSORS': '8',
21:30:58 INFO - 'OS': 'Windows_NT',
21:30:58 INFO - 'OURDRIVE': 'C:',
21:30: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',
21:30:58 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
21:30:58 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
21:30:58 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
21:30:58 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
21:30:58 INFO - 'PROCESSOR_LEVEL': '6',
21:30:58 INFO - 'PROCESSOR_REVISION': '1e05',
21:30:58 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
21:30:58 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
21:30:58 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
21:30:58 INFO - 'PROGRAMW6432': 'C:\\Program Files',
21:30:58 INFO - 'PROMPT': '$P$G',
21:30:58 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
21:30:58 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
21:30:58 INFO - 'PUBLIC': 'C:\\Users\\Public',
21:30:58 INFO - 'PWD': 'C:\\slave\\test',
21:30:58 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
21:30:58 INFO - 'SLAVEDIR': 'C:\\slave\\',
21:30:58 INFO - 'SYSTEMDRIVE': 'C:',
21:30:58 INFO - 'SYSTEMROOT': 'C:\\windows',
21:30:58 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
21:30:58 INFO - 'TEST1': 'testie',
21:30:58 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
21:30:58 INFO - 'USERDOMAIN': 'T-W864-IX-164',
21:30:58 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-164',
21:30:58 INFO - 'USERNAME': 'cltbld',
21:30:58 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-164',
21:30:58 INFO - 'WINDIR': 'C:\\windows',
21:30:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
21:30:58 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:30:58 INFO - Downloading/unpacking mozsystemmonitor==0.3
21:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
21:30:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
21:30:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz
21:30:59 INFO - Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor
21:30:59 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)
21:30:59 INFO - Installing collected packages: mozsystemmonitor
21:30:59 INFO - Running setup.py install for mozsystemmonitor
21:30:59 INFO - Successfully installed mozsystemmonitor
21:30:59 INFO - Cleaning up...
21:31:00 INFO - Return code: 0
21:31:00 INFO - Installing jsonschema==2.5.1 into virtualenv C:\slave\test\build/venv
21:31:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:31:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:31:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:31:00 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x023DC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0245DE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02864110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02438E90>, '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 0x0049A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028A4520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-164', 'USERDOMAIN': 'T-W864-IX-164', '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-164', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-164\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-164', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-164', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-164', '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-164\\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
21:31:00 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in C:\slave\test\build
21:31:00 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1
21:31:00 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
21:31:00 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-164\\AppData\\Roaming',
21:31:00 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
21:31:00 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
21:31:00 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
21:31:00 INFO - 'COMPUTERNAME': 'T-W864-IX-164',
21:31:00 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
21:31:00 INFO - 'DCLOCATION': 'SCL3',
21:31:00 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
21:31:00 INFO - 'FP_NO_HOST_CHECK': 'NO',
21:31:00 INFO - 'HOMEDRIVE': 'C:',
21:31:00 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-164',
21:31:00 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
21:31:00 INFO - 'KTS_VERSION': '1.19c',
21:31:00 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-164\\AppData\\Local',
21:31:00 INFO - 'LOGONSERVER': '\\\\T-W864-IX-164',
21:31:00 INFO - 'MONDIR': 'C:\\Monitor_config\\',
21:31:00 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
21:31:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:31:00 INFO - 'MOZ_NO_REMOTE': '1',
21:31:00 INFO - 'NO_EM_RESTART': '1',
21:31:00 INFO - 'NUMBER_OF_PROCESSORS': '8',
21:31:00 INFO - 'OS': 'Windows_NT',
21:31:00 INFO - 'OURDRIVE': 'C:',
21:31:00 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
21:31:00 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
21:31:00 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
21:31:00 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
21:31:00 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
21:31:00 INFO - 'PROCESSOR_LEVEL': '6',
21:31:00 INFO - 'PROCESSOR_REVISION': '1e05',
21:31:00 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
21:31:00 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
21:31:00 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
21:31:00 INFO - 'PROGRAMW6432': 'C:\\Program Files',
21:31:00 INFO - 'PROMPT': '$P$G',
21:31:00 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
21:31:00 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
21:31:00 INFO - 'PUBLIC': 'C:\\Users\\Public',
21:31:00 INFO - 'PWD': 'C:\\slave\\test',
21:31:00 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
21:31:00 INFO - 'SLAVEDIR': 'C:\\slave\\',
21:31:00 INFO - 'SYSTEMDRIVE': 'C:',
21:31:00 INFO - 'SYSTEMROOT': 'C:\\windows',
21:31:00 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
21:31:00 INFO - 'TEST1': 'testie',
21:31:00 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
21:31:00 INFO - 'USERDOMAIN': 'T-W864-IX-164',
21:31:00 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-164',
21:31:00 INFO - 'USERNAME': 'cltbld',
21:31:00 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-164',
21:31:00 INFO - 'WINDIR': 'C:\\windows',
21:31:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
21:31:00 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:31:00 INFO - Downloading/unpacking jsonschema==2.5.1
21:31:00 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
21:31:00 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
21:31:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl
21:31:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1)
21:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
21:31:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
21:31:01 INFO - Downloading functools32-3.2.3-2.tar.gz
21:31:01 INFO - Running setup.py (path:C:\slave\test\build\venv\build\functools32\setup.py) egg_info for package functools32
21:31:01 INFO - warning: no files found matching '*.txt'
21:31:01 INFO - no previously-included directories found matching 'build'
21:31:01 INFO - no previously-included directories found matching 'dist'
21:31:01 INFO - no previously-included directories found matching '.git*'
21:31:01 INFO - Installing collected packages: jsonschema, functools32
21:31:01 INFO - Running setup.py install for functools32
21:31:01 INFO - warning: no files found matching '*.txt'
21:31:01 INFO - no previously-included directories found matching 'build'
21:31:01 INFO - no previously-included directories found matching 'dist'
21:31:01 INFO - no previously-included directories found matching '.git*'
21:31:01 INFO - Successfully installed jsonschema functools32
21:31:01 INFO - Cleaning up...
21:31:02 INFO - Return code: 0
21:31:02 INFO - Installing functools32==3.2.3-2 into virtualenv C:\slave\test\build/venv
21:31: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')]}
21:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:31: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')]}
21:31:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:31:02 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x023DC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0245DE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02864110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02438E90>, '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 0x0049A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028A4520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-164', 'USERDOMAIN': 'T-W864-IX-164', '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-164', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-164\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-164', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-164', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-164', '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-164\\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
21:31:02 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in C:\slave\test\build
21:31:02 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2
21:31:02 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
21:31:02 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-164\\AppData\\Roaming',
21:31:02 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
21:31:02 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
21:31:02 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
21:31:02 INFO - 'COMPUTERNAME': 'T-W864-IX-164',
21:31:02 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
21:31:02 INFO - 'DCLOCATION': 'SCL3',
21:31:02 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
21:31:02 INFO - 'FP_NO_HOST_CHECK': 'NO',
21:31:02 INFO - 'HOMEDRIVE': 'C:',
21:31:02 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-164',
21:31:02 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
21:31:02 INFO - 'KTS_VERSION': '1.19c',
21:31:02 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-164\\AppData\\Local',
21:31:02 INFO - 'LOGONSERVER': '\\\\T-W864-IX-164',
21:31:02 INFO - 'MONDIR': 'C:\\Monitor_config\\',
21:31:02 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
21:31:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:31:02 INFO - 'MOZ_NO_REMOTE': '1',
21:31:02 INFO - 'NO_EM_RESTART': '1',
21:31:02 INFO - 'NUMBER_OF_PROCESSORS': '8',
21:31:02 INFO - 'OS': 'Windows_NT',
21:31:02 INFO - 'OURDRIVE': 'C:',
21:31:02 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
21:31:02 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
21:31:02 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
21:31:02 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
21:31:02 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
21:31:02 INFO - 'PROCESSOR_LEVEL': '6',
21:31:02 INFO - 'PROCESSOR_REVISION': '1e05',
21:31:02 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
21:31:02 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
21:31:02 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
21:31:02 INFO - 'PROGRAMW6432': 'C:\\Program Files',
21:31:02 INFO - 'PROMPT': '$P$G',
21:31:02 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
21:31:02 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
21:31:02 INFO - 'PUBLIC': 'C:\\Users\\Public',
21:31:02 INFO - 'PWD': 'C:\\slave\\test',
21:31:02 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
21:31:02 INFO - 'SLAVEDIR': 'C:\\slave\\',
21:31:02 INFO - 'SYSTEMDRIVE': 'C:',
21:31:02 INFO - 'SYSTEMROOT': 'C:\\windows',
21:31:02 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
21:31:02 INFO - 'TEST1': 'testie',
21:31:02 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
21:31:02 INFO - 'USERDOMAIN': 'T-W864-IX-164',
21:31:02 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-164',
21:31:02 INFO - 'USERNAME': 'cltbld',
21:31:02 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-164',
21:31:02 INFO - 'WINDIR': 'C:\\windows',
21:31:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
21:31:02 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:31:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in c:\slave\test\build\venv\lib\site-packages
21:31:02 INFO - Cleaning up...
21:31:02 INFO - Return code: 0
21:31:02 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv
21:31: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')]}
21:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:31: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')]}
21:31:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:31:02 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x023DC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0245DE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02864110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02438E90>, '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 0x0049A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028A4520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-164', 'USERDOMAIN': 'T-W864-IX-164', '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-164', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-164\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-164', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-164', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-164', '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-164\\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
21:31:02 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in C:\slave\test\build
21:31:02 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4
21:31:02 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
21:31:02 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-164\\AppData\\Roaming',
21:31:02 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
21:31:02 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
21:31:02 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
21:31:02 INFO - 'COMPUTERNAME': 'T-W864-IX-164',
21:31:02 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
21:31:02 INFO - 'DCLOCATION': 'SCL3',
21:31:02 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
21:31:02 INFO - 'FP_NO_HOST_CHECK': 'NO',
21:31:02 INFO - 'HOMEDRIVE': 'C:',
21:31:02 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-164',
21:31:02 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
21:31:02 INFO - 'KTS_VERSION': '1.19c',
21:31:02 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-164\\AppData\\Local',
21:31:02 INFO - 'LOGONSERVER': '\\\\T-W864-IX-164',
21:31:02 INFO - 'MONDIR': 'C:\\Monitor_config\\',
21:31:02 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
21:31:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:31:02 INFO - 'MOZ_NO_REMOTE': '1',
21:31:02 INFO - 'NO_EM_RESTART': '1',
21:31:02 INFO - 'NUMBER_OF_PROCESSORS': '8',
21:31:02 INFO - 'OS': 'Windows_NT',
21:31:02 INFO - 'OURDRIVE': 'C:',
21:31:02 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
21:31:02 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
21:31:02 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
21:31:02 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
21:31:02 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
21:31:02 INFO - 'PROCESSOR_LEVEL': '6',
21:31:02 INFO - 'PROCESSOR_REVISION': '1e05',
21:31:02 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
21:31:02 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
21:31:02 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
21:31:02 INFO - 'PROGRAMW6432': 'C:\\Program Files',
21:31:02 INFO - 'PROMPT': '$P$G',
21:31:02 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
21:31:02 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
21:31:02 INFO - 'PUBLIC': 'C:\\Users\\Public',
21:31:02 INFO - 'PWD': 'C:\\slave\\test',
21:31:02 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
21:31:02 INFO - 'SLAVEDIR': 'C:\\slave\\',
21:31:02 INFO - 'SYSTEMDRIVE': 'C:',
21:31:02 INFO - 'SYSTEMROOT': 'C:\\windows',
21:31:02 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
21:31:02 INFO - 'TEST1': 'testie',
21:31:02 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
21:31:02 INFO - 'USERDOMAIN': 'T-W864-IX-164',
21:31:02 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-164',
21:31:02 INFO - 'USERNAME': 'cltbld',
21:31:02 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-164',
21:31:02 INFO - 'WINDIR': 'C:\\windows',
21:31:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
21:31:03 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:31:03 INFO - Downloading/unpacking blobuploader==1.2.4
21:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
21:31:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
21:31:04 INFO - Downloading blobuploader-1.2.4.tar.gz
21:31:04 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader
21:31:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4)
21:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
21:31:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
21:31:04 INFO - Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests
21:31:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4)
21:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
21:31:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
21:31:04 INFO - Downloading docopt-0.6.1.tar.gz
21:31:04 INFO - Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt
21:31:04 INFO - Installing collected packages: blobuploader, requests, docopt
21:31:04 INFO - Running setup.py install for blobuploader
21:31:05 INFO - Running setup.py install for requests
21:31:05 INFO - Running setup.py install for docopt
21:31:05 INFO - Successfully installed blobuploader requests docopt
21:31:05 INFO - Cleaning up...
21:31:06 INFO - Return code: 0
21:31:06 INFO - Installing None into virtualenv C:\slave\test\build/venv
21:31:06 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')]}
21:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:31:06 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')]}
21:31:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:31:06 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 0x023DC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0245DE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02864110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02438E90>, '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 0x0049A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028A4520>, '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-164', 'USERDOMAIN': 'T-W864-IX-164', '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-164', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-164\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-164', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-164', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-164', '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-164\\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
21:31:06 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
21:31:06 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
21:31:06 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
21:31:06 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-164\\AppData\\Roaming',
21:31:06 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
21:31:06 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
21:31:06 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
21:31:06 INFO - 'COMPUTERNAME': 'T-W864-IX-164',
21:31:06 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
21:31:06 INFO - 'DCLOCATION': 'SCL3',
21:31:06 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
21:31:06 INFO - 'FP_NO_HOST_CHECK': 'NO',
21:31:06 INFO - 'HOMEDRIVE': 'C:',
21:31:06 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-164',
21:31:06 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
21:31:06 INFO - 'KTS_VERSION': '1.19c',
21:31:06 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-164\\AppData\\Local',
21:31:06 INFO - 'LOGONSERVER': '\\\\T-W864-IX-164',
21:31:06 INFO - 'MONDIR': 'C:\\Monitor_config\\',
21:31:06 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
21:31:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:31:06 INFO - 'MOZ_NO_REMOTE': '1',
21:31:06 INFO - 'NO_EM_RESTART': '1',
21:31:06 INFO - 'NUMBER_OF_PROCESSORS': '8',
21:31:06 INFO - 'OS': 'Windows_NT',
21:31:06 INFO - 'OURDRIVE': 'C:',
21:31:06 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',
21:31:06 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
21:31:06 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
21:31:06 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
21:31:06 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
21:31:06 INFO - 'PROCESSOR_LEVEL': '6',
21:31:06 INFO - 'PROCESSOR_REVISION': '1e05',
21:31:06 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
21:31:06 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
21:31:06 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
21:31:06 INFO - 'PROGRAMW6432': 'C:\\Program Files',
21:31:06 INFO - 'PROMPT': '$P$G',
21:31:06 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
21:31:06 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
21:31:06 INFO - 'PUBLIC': 'C:\\Users\\Public',
21:31:06 INFO - 'PWD': 'C:\\slave\\test',
21:31:06 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
21:31:06 INFO - 'SLAVEDIR': 'C:\\slave\\',
21:31:06 INFO - 'SYSTEMDRIVE': 'C:',
21:31:06 INFO - 'SYSTEMROOT': 'C:\\windows',
21:31:06 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
21:31:06 INFO - 'TEST1': 'testie',
21:31:06 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
21:31:06 INFO - 'USERDOMAIN': 'T-W864-IX-164',
21:31:06 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-164',
21:31:06 INFO - 'USERNAME': 'cltbld',
21:31:06 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-164',
21:31:06 INFO - 'WINDIR': 'C:\\windows',
21:31:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
21:31:07 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:31:07 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser
21:31:07 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rtywu5-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser
21:31:07 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash
21:31:07 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-6iexec-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash
21:31:07 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug
21:31:07 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-bm7lp5-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug
21:31:07 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice
21:31:07 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-wihadi-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice
21:31:07 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile
21:31:07 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-z5s8cz-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile
21:31:07 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd
21:31:07 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-mahxyt-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd
21:31:07 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo
21:31:07 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rh8yvn-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo
21:31:08 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall
21:31:08 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ax_dio-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall
21:31:08 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak
21:31:08 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-bwp00x-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak
21:31:08 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog
21:31:08 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-0nqzo4-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog
21:31:08 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork
21:31:08 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-lnsd_4-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork
21:31:08 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess
21:31:08 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-8exsiu-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess
21:31:08 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile
21:31:08 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ly6z07-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile
21:31:08 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner
21:31:08 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rcaehl-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner
21:31:08 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot
21:31:08 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-sorik4-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot
21:31:08 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest
21:31:08 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xwftrg-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest
21:31:09 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion
21:31:09 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ccqsw4-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion
21:31:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion
21:31:09 INFO - Running setup.py install for manifestparser
21:31:09 INFO - Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts
21:31:09 INFO - Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts
21:31:09 INFO - Running setup.py install for mozcrash
21:31:10 INFO - Running setup.py install for mozdebug
21:31:10 INFO - Running setup.py install for mozdevice
21:31:10 INFO - Installing sutini-script.py script to C:\slave\test\build\venv\Scripts
21:31:10 INFO - Installing sutini.exe script to C:\slave\test\build\venv\Scripts
21:31:10 INFO - Installing dm-script.py script to C:\slave\test\build\venv\Scripts
21:31:10 INFO - Installing dm.exe script to C:\slave\test\build\venv\Scripts
21:31:11 INFO - Running setup.py install for mozfile
21:31:11 INFO - Running setup.py install for mozhttpd
21:31:11 INFO - Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts
21:31:11 INFO - Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts
21:31:12 INFO - Running setup.py install for mozinfo
21:31:12 INFO - Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts
21:31:12 INFO - Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts
21:31:12 INFO - Running setup.py install for mozInstall
21:31:12 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts
21:31:12 INFO - Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts
21:31:12 INFO - Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts
21:31:12 INFO - Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts
21:31:12 INFO - Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts
21:31:12 INFO - Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts
21:31:12 INFO - Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts
21:31:12 INFO - Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts
21:31:13 INFO - Running setup.py install for mozleak
21:31:13 INFO - Running setup.py install for mozlog
21:31:13 INFO - Installing structlog-script.py script to C:\slave\test\build\venv\Scripts
21:31:13 INFO - Installing structlog.exe script to C:\slave\test\build\venv\Scripts
21:31:14 INFO - Running setup.py install for moznetwork
21:31:14 INFO - Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts
21:31:14 INFO - Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts
21:31:14 INFO - Running setup.py install for mozprocess
21:31:15 INFO - Running setup.py install for mozprofile
21:31:15 INFO - Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts
21:31:15 INFO - Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts
21:31:15 INFO - Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts
21:31:15 INFO - Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts
21:31:15 INFO - Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts
21:31:15 INFO - Installing view-profile.exe script to C:\slave\test\build\venv\Scripts
21:31:15 INFO - Running setup.py install for mozrunner
21:31:16 INFO - Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts
21:31:16 INFO - Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts
21:31:16 INFO - Running setup.py install for mozscreenshot
21:31:17 INFO - Running setup.py install for moztest
21:31:17 INFO - Running setup.py install for mozversion
21:31:17 INFO - Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts
21:31:17 INFO - Installing mozversion.exe script to C:\slave\test\build\venv\Scripts
21:31:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion
21:31:17 INFO - Cleaning up...
21:31:17 INFO - Return code: 0
21:31:17 INFO - Installing None into virtualenv C:\slave\test\build/venv
21:31:17 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')]}
21:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:31:17 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')]}
21:31:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:31:17 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 0x023DC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0245DE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02864110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02438E90>, '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 0x0049A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028A4520>, '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-164', 'USERDOMAIN': 'T-W864-IX-164', '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-164', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-164\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-164', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-164', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-164', '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-164\\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
21:31:17 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
21:31:17 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
21:31:17 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
21:31:17 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-164\\AppData\\Roaming',
21:31:17 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
21:31:17 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
21:31:17 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
21:31:17 INFO - 'COMPUTERNAME': 'T-W864-IX-164',
21:31:17 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
21:31:17 INFO - 'DCLOCATION': 'SCL3',
21:31:17 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
21:31:17 INFO - 'FP_NO_HOST_CHECK': 'NO',
21:31:17 INFO - 'HOMEDRIVE': 'C:',
21:31:17 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-164',
21:31:17 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
21:31:17 INFO - 'KTS_VERSION': '1.19c',
21:31:17 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-164\\AppData\\Local',
21:31:17 INFO - 'LOGONSERVER': '\\\\T-W864-IX-164',
21:31:17 INFO - 'MONDIR': 'C:\\Monitor_config\\',
21:31:17 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
21:31:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:31:17 INFO - 'MOZ_NO_REMOTE': '1',
21:31:17 INFO - 'NO_EM_RESTART': '1',
21:31:17 INFO - 'NUMBER_OF_PROCESSORS': '8',
21:31:17 INFO - 'OS': 'Windows_NT',
21:31:17 INFO - 'OURDRIVE': 'C:',
21:31:17 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',
21:31:17 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
21:31:17 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
21:31:17 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
21:31:17 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
21:31:17 INFO - 'PROCESSOR_LEVEL': '6',
21:31:17 INFO - 'PROCESSOR_REVISION': '1e05',
21:31:17 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
21:31:17 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
21:31:17 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
21:31:17 INFO - 'PROGRAMW6432': 'C:\\Program Files',
21:31:17 INFO - 'PROMPT': '$P$G',
21:31:17 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
21:31:17 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
21:31:17 INFO - 'PUBLIC': 'C:\\Users\\Public',
21:31:17 INFO - 'PWD': 'C:\\slave\\test',
21:31:17 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
21:31:17 INFO - 'SLAVEDIR': 'C:\\slave\\',
21:31:17 INFO - 'SYSTEMDRIVE': 'C:',
21:31:17 INFO - 'SYSTEMROOT': 'C:\\windows',
21:31:17 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
21:31:17 INFO - 'TEST1': 'testie',
21:31:17 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
21:31:17 INFO - 'USERDOMAIN': 'T-W864-IX-164',
21:31:17 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-164',
21:31:17 INFO - 'USERNAME': 'cltbld',
21:31:17 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-164',
21:31:17 INFO - 'WINDIR': 'C:\\windows',
21:31:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
21:31:18 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:31:18 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser
21:31:18 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qwfmfx-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser
21:31:18 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))
21:31:18 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash
21:31:18 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-tm1v7w-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash
21:31:18 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))
21:31:18 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug
21:31:18 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-lniwif-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug
21:31:18 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))
21:31:18 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice
21:31:18 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rzqgci-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice
21:31:18 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))
21:31:18 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile
21:31:18 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-zfgszg-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile
21:31:18 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))
21:31:18 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd
21:31:18 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-eqtk5p-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd
21:31:18 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))
21:31:18 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo
21:31:18 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ih6cgo-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo
21:31:19 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))
21:31:19 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall
21:31:19 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-bit9wz-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall
21:31:19 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))
21:31:19 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak
21:31:19 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-l4misc-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak
21:31:19 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))
21:31:19 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog
21:31:19 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-r84rfi-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog
21:31:19 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))
21:31:19 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork
21:31:19 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-hbx9ra-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork
21:31:19 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))
21:31:19 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess
21:31:19 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xmywfb-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess
21:31:19 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))
21:31:19 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile
21:31:19 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-baj8qn-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile
21:31:19 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))
21:31:19 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner
21:31:19 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-5ftpkw-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner
21:31:19 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))
21:31:19 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot
21:31:19 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-gcyucf-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot
21:31:20 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))
21:31:20 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest
21:31:20 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-kx2f2n-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest
21:31:20 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))
21:31:20 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion
21:31:20 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-f2ci6u-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion
21:31:20 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))
21:31:20 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))
21:31:20 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))
21:31:20 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))
21:31:20 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))
21:31:20 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))
21:31:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10))
21:31:20 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
21:31:20 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
21:31:21 INFO - Downloading blessings-1.6.tar.gz
21:31:21 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings
21:31:21 INFO - Installing collected packages: blessings
21:31:21 INFO - Running setup.py install for blessings
21:31:21 INFO - Successfully installed blessings
21:31:21 INFO - Cleaning up...
21:31:24 INFO - Return code: 0
21:31:24 INFO - Done creating virtualenv C:\slave\test\build/venv.
21:31:24 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze']
21:31:24 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze
21:31:25 INFO - Reading from file tmpfile_stdout
21:31:25 INFO - Using _rmtree_windows ...
21:31:25 INFO - Using _rmtree_windows ...
21:31:25 INFO - Current package versions:
21:31:25 INFO - blessings == 1.6
21:31:25 INFO - blobuploader == 1.2.4
21:31:25 INFO - docopt == 0.6.1
21:31:25 INFO - functools32 == 3.2.3-2
21:31:25 INFO - jsonschema == 2.5.1
21:31:25 INFO - manifestparser == 1.1
21:31:25 INFO - mozInstall == 1.12
21:31:25 INFO - mozcrash == 0.17
21:31:25 INFO - mozdebug == 0.1
21:31:25 INFO - mozdevice == 0.48
21:31:25 INFO - mozfile == 1.2
21:31:25 INFO - mozhttpd == 0.7
21:31:25 INFO - mozinfo == 0.9
21:31:25 INFO - mozleak == 0.1
21:31:25 INFO - mozlog == 3.4
21:31:25 INFO - moznetwork == 0.27
21:31:25 INFO - mozprocess == 0.23
21:31:25 INFO - mozprofile == 0.28
21:31:25 INFO - mozrunner == 6.12
21:31:25 INFO - mozscreenshot == 0.1
21:31:25 INFO - mozsystemmonitor == 0.3
21:31:25 INFO - moztest == 0.7
21:31:25 INFO - mozversion == 1.4
21:31:25 INFO - psutil == 3.1.1
21:31:25 INFO - requests == 1.2.3
21:31:25 INFO - Installing None into virtualenv C:\slave\test\build/venv
21:31: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')]}
21:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:31: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')]}
21:31:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:31:25 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 0x023DC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0245DE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02864110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02438E90>, '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 0x0049A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028A4520>, '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-164', 'USERDOMAIN': 'T-W864-IX-164', '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-164', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-164\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-164', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-164', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-164', '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-164\\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
21:31:25 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
21:31:25 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
21:31:25 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
21:31:25 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-164\\AppData\\Roaming',
21:31:25 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
21:31:25 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
21:31:25 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
21:31:25 INFO - 'COMPUTERNAME': 'T-W864-IX-164',
21:31:25 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
21:31:25 INFO - 'DCLOCATION': 'SCL3',
21:31:25 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
21:31:25 INFO - 'FP_NO_HOST_CHECK': 'NO',
21:31:25 INFO - 'HOMEDRIVE': 'C:',
21:31:25 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-164',
21:31:25 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
21:31:25 INFO - 'KTS_VERSION': '1.19c',
21:31:25 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-164\\AppData\\Local',
21:31:25 INFO - 'LOGONSERVER': '\\\\T-W864-IX-164',
21:31:25 INFO - 'MONDIR': 'C:\\Monitor_config\\',
21:31:25 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
21:31:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:31:25 INFO - 'MOZ_NO_REMOTE': '1',
21:31:25 INFO - 'NO_EM_RESTART': '1',
21:31:25 INFO - 'NUMBER_OF_PROCESSORS': '8',
21:31:25 INFO - 'OS': 'Windows_NT',
21:31:25 INFO - 'OURDRIVE': 'C:',
21:31: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',
21:31:25 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
21:31:25 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
21:31:25 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
21:31:25 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
21:31:25 INFO - 'PROCESSOR_LEVEL': '6',
21:31:25 INFO - 'PROCESSOR_REVISION': '1e05',
21:31:25 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
21:31:25 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
21:31:25 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
21:31:25 INFO - 'PROGRAMW6432': 'C:\\Program Files',
21:31:25 INFO - 'PROMPT': '$P$G',
21:31:25 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
21:31:25 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
21:31:25 INFO - 'PUBLIC': 'C:\\Users\\Public',
21:31:25 INFO - 'PWD': 'C:\\slave\\test',
21:31:25 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
21:31:25 INFO - 'SLAVEDIR': 'C:\\slave\\',
21:31:25 INFO - 'SYSTEMDRIVE': 'C:',
21:31:25 INFO - 'SYSTEMROOT': 'C:\\windows',
21:31:25 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
21:31:25 INFO - 'TEST1': 'testie',
21:31:25 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
21:31:25 INFO - 'USERDOMAIN': 'T-W864-IX-164',
21:31:25 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-164',
21:31:25 INFO - 'USERNAME': 'cltbld',
21:31:25 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-164',
21:31:25 INFO - 'WINDIR': 'C:\\windows',
21:31:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
21:31:25 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:31:25 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))
21:31:25 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))
21:31:25 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))
21:31:25 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))
21:31:25 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))
21:31:25 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))
21:31:25 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))
21:31:25 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))
21:31:25 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))
21:31:25 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))
21:31:25 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))
21:31:25 INFO - Cleaning up...
21:31:25 INFO - Return code: 0
21:31:25 INFO - Installing jsonschema into virtualenv C:\slave\test\build/venv
21:31: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')]}
21:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:31: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')]}
21:31:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:31: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x023DC640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0245DE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02864110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02438E90>, '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 0x0049A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028A4520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-164', 'USERDOMAIN': 'T-W864-IX-164', '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-164', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-164\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-164', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-164', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-164', '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-164\\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
21:31: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', 'jsonschema'] in C:\slave\test\build
21:31: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 jsonschema
21:31:25 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
21:31:25 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-164\\AppData\\Roaming',
21:31:25 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
21:31:25 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
21:31:25 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
21:31:25 INFO - 'COMPUTERNAME': 'T-W864-IX-164',
21:31:25 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
21:31:25 INFO - 'DCLOCATION': 'SCL3',
21:31:25 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
21:31:25 INFO - 'FP_NO_HOST_CHECK': 'NO',
21:31:25 INFO - 'HOMEDRIVE': 'C:',
21:31:25 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-164',
21:31:25 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
21:31:25 INFO - 'KTS_VERSION': '1.19c',
21:31:25 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-164\\AppData\\Local',
21:31:25 INFO - 'LOGONSERVER': '\\\\T-W864-IX-164',
21:31:25 INFO - 'MONDIR': 'C:\\Monitor_config\\',
21:31:25 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
21:31:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:31:25 INFO - 'MOZ_NO_REMOTE': '1',
21:31:25 INFO - 'NO_EM_RESTART': '1',
21:31:25 INFO - 'NUMBER_OF_PROCESSORS': '8',
21:31:25 INFO - 'OS': 'Windows_NT',
21:31:25 INFO - 'OURDRIVE': 'C:',
21:31: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',
21:31:25 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
21:31:25 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
21:31:25 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
21:31:25 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
21:31:25 INFO - 'PROCESSOR_LEVEL': '6',
21:31:25 INFO - 'PROCESSOR_REVISION': '1e05',
21:31:25 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
21:31:25 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
21:31:25 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
21:31:25 INFO - 'PROGRAMW6432': 'C:\\Program Files',
21:31:25 INFO - 'PROMPT': '$P$G',
21:31:25 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
21:31:25 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
21:31:25 INFO - 'PUBLIC': 'C:\\Users\\Public',
21:31:25 INFO - 'PWD': 'C:\\slave\\test',
21:31:25 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
21:31:25 INFO - 'SLAVEDIR': 'C:\\slave\\',
21:31:25 INFO - 'SYSTEMDRIVE': 'C:',
21:31:25 INFO - 'SYSTEMROOT': 'C:\\windows',
21:31:25 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
21:31:25 INFO - 'TEST1': 'testie',
21:31:25 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
21:31:25 INFO - 'USERDOMAIN': 'T-W864-IX-164',
21:31:25 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-164',
21:31:25 INFO - 'USERNAME': 'cltbld',
21:31:25 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-164',
21:31:25 INFO - 'WINDIR': 'C:\\windows',
21:31:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
21:31:25 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:31:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in c:\slave\test\build\venv\lib\site-packages
21:31:25 INFO - Cleaning up...
21:31:25 INFO - Return code: 0
21:31:25 INFO - Running post-action listener: _resource_record_post_action
21:31:25 INFO - Running post-action listener: _start_resource_monitoring
21:31:25 INFO - Starting resource monitoring.
21:31:25 INFO - [mozharness: 2016-10-18 04:31:25.831000Z] Finished create-virtualenv step (success)
21:31:25 INFO - [mozharness: 2016-10-18 04:31:25.831000Z] Running install step.
21:31:25 INFO - Running pre-action listener: _resource_record_pre_action
21:31:25 INFO - Running main action method: install
21:31:25 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze']
21:31:25 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze
21:31:26 INFO - Reading from file tmpfile_stdout
21:31:26 INFO - Using _rmtree_windows ...
21:31:26 INFO - Using _rmtree_windows ...
21:31:26 INFO - Detecting whether we're running mozinstall >=1.0...
21:31:26 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h']
21:31:26 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h
21:31:26 INFO - Reading from file tmpfile_stdout
21:31:26 INFO - Output received:
21:31:26 INFO - Usage: mozinstall-script.py [options] installer
21:31:26 INFO - Options:
21:31:26 INFO - -h, --help show this help message and exit
21:31:26 INFO - -d DEST, --destination=DEST
21:31:26 INFO - Directory to install application into. [default:
21:31:26 INFO - "C:\slave\test"]
21:31:26 INFO - --app=APP Application being installed. [default: firefox]
21:31:26 INFO - Using _rmtree_windows ...
21:31:26 INFO - Using _rmtree_windows ...
21:31:26 INFO - mkdir: C:\slave\test\build\application
21:31:26 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']
21:31:26 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
21:31:28 INFO - Reading from file tmpfile_stdout
21:31:28 INFO - Output received:
21:31:28 INFO - C:\slave\test\build\application\firefox\firefox.exe
21:31:28 INFO - Using _rmtree_windows ...
21:31:28 INFO - Using _rmtree_windows ...
21:31:28 INFO - Running post-action listener: _resource_record_post_action
21:31:28 INFO - [mozharness: 2016-10-18 04:31:28.406000Z] Finished install step (success)
21:31:28 INFO - [mozharness: 2016-10-18 04:31:28.406000Z] Running run-tests step.
21:31:28 INFO - Running pre-action listener: _resource_record_pre_action
21:31:28 INFO - Running main action method: run_tests
21:31:28 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version']
21:31:28 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version
21:31:28 INFO - Python 2.7.3
21:31:28 INFO - Return code: 0
21:31:28 INFO - grabbing minidump binary from tooltool
21:31:28 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')]}
21:31:28 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 0x02438E90>, '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 0x0049A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028A4520>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1
21:31:28 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
21:31:28 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
21:31:28 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
21:31:28 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'...
21:31:28 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmpivwtxp
21:31:28 INFO - INFO - File integrity verified, renaming tmpivwtxp to win32-minidump_stackwalk.exe
21:31:28 INFO - Return code: 0
21:31:28 INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755
21:31:28 INFO - mkdir: C:\slave\test\build\blobber_upload_dir
21:31:28 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir
21:31:28 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe
21:31:28 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir
21:31:28 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/WzOP4LHtS9q7G9fPWHo64A/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-164', '--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
21:31:28 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/WzOP4LHtS9q7G9fPWHo64A/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip --title T-W864-IX-164 --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
21:31:28 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
21:31:28 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-164\\AppData\\Roaming',
21:31:28 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
21:31:28 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
21:31:28 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
21:31:28 INFO - 'COMPUTERNAME': 'T-W864-IX-164',
21:31:28 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
21:31:28 INFO - 'DCLOCATION': 'SCL3',
21:31:28 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
21:31:28 INFO - 'FP_NO_HOST_CHECK': 'NO',
21:31:28 INFO - 'HOMEDRIVE': 'C:',
21:31:28 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-164',
21:31:28 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
21:31:28 INFO - 'KTS_VERSION': '1.19c',
21:31:28 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-164\\AppData\\Local',
21:31:28 INFO - 'LOGONSERVER': '\\\\T-W864-IX-164',
21:31:28 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir',
21:31:28 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe',
21:31:28 INFO - 'MONDIR': 'C:\\Monitor_config\\',
21:31:28 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
21:31:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:31:28 INFO - 'MOZ_NO_REMOTE': '1',
21:31:28 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir',
21:31:28 INFO - 'NO_EM_RESTART': '1',
21:31:28 INFO - 'NUMBER_OF_PROCESSORS': '8',
21:31:28 INFO - 'OS': 'Windows_NT',
21:31:28 INFO - 'OURDRIVE': 'C:',
21:31:28 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',
21:31:28 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
21:31:28 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
21:31:28 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
21:31:28 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
21:31:28 INFO - 'PROCESSOR_LEVEL': '6',
21:31:28 INFO - 'PROCESSOR_REVISION': '1e05',
21:31:28 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
21:31:28 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
21:31:28 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
21:31:28 INFO - 'PROGRAMW6432': 'C:\\Program Files',
21:31:28 INFO - 'PROMPT': '$P$G',
21:31:28 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
21:31:28 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
21:31:28 INFO - 'PUBLIC': 'C:\\Users\\Public',
21:31:28 INFO - 'PWD': 'C:\\slave\\test',
21:31:28 INFO - 'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos',
21:31:28 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
21:31:28 INFO - 'SLAVEDIR': 'C:\\slave\\',
21:31:28 INFO - 'SYSTEMDRIVE': 'C:',
21:31:28 INFO - 'SYSTEMROOT': 'C:\\windows',
21:31:28 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
21:31:28 INFO - 'TEST1': 'testie',
21:31:28 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
21:31:28 INFO - 'USERDOMAIN': 'T-W864-IX-164',
21:31:28 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-164',
21:31:28 INFO - 'USERNAME': 'cltbld',
21:31:28 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-164',
21:31:28 INFO - 'WINDIR': 'C:\\windows',
21:31:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
21:31:28 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/WzOP4LHtS9q7G9fPWHo64A/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-164', '--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
21:31:29 INFO - mozversion application_buildid: 20161017183007
21:31:29 INFO - mozversion application_changeset: 47be3ae8a710b35f040dffe7403877e764ab61ac
21:31:29 INFO - mozversion application_display_name: Nightly
21:31:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384}
21:31:29 INFO - mozversion application_name: Firefox
21:31:29 INFO - mozversion application_remotingname: firefox
21:31:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team
21:31:29 INFO - mozversion application_vendor: Mozilla
21:31:29 INFO - mozversion application_version: 52.0a1
21:31:29 INFO - mozversion platform_buildid: 20161017183007
21:31:29 INFO - mozversion platform_changeset: 47be3ae8a710b35f040dffe7403877e764ab61ac
21:31:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team
21:31:29 INFO - mozversion platform_version: 52.0a1
21:31:29 INFO - using testdate: 1476765089
21:31:29 INFO - actual date: 1476765089
21:31:29 INFO - starting webserver on 'localhost:49274'
21:31:29 INFO - SUITE-START | Running 2 tests
21:31:29 INFO - TEST-START | dromaeo_css
21:31:29 INFO - operating with platform_type : w8_
21:31:29 INFO - Initialising browser for dromaeo_css test...
21:31:29 INFO - TEST-INFO | started process 2772 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpqbtsvt\profile http://localhost:49274/getInfo.html)
21:31:37 INFO - PROCESS | 2772 | __metrics Screen width/height:1600/1200
21:31:37 INFO - PROCESS | 2772 | colorDepth:24
21:31:37 INFO - PROCESS | 2772 | Browser inner width/height: 1010/674
21:31:37 INFO - PROCESS | 2772 | __metrics
21:31:39 INFO - PROCESS | 2772 | 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"
21:31:39 INFO - PROCESS | 2772 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver]
21:31:40 INFO - TEST-INFO | 2772: exit 0
21:31:40 INFO - Browser initialized.
21:31:40 INFO - Running cycle 1/1 for dromaeo_css test...
21:31:40 INFO - TEST-INFO | started process 1844 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpqbtsvt\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1)
21:31:40 INFO - PROCESS | 1844 | [GFX1-]: Invalid size in UpdateRenderTarget Size(124,0), 0
21:31:51 INFO - PROCESS | 1844 | RSS: Main: 162373632
21:31:51 INFO - PROCESS | 1844 |
21:32:43 INFO - PROCESS | 1844 | 1476765163439 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]
21:34:52 INFO - PROCESS | 1844 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html)
21:34:55 INFO - PROCESS | 1844 | RSS: Main: 423694336
21:34:55 INFO - PROCESS | 1844 |
21:37:58 INFO - PROCESS | 1844 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html)
21:37:59 INFO - PROCESS | 1844 | RSS: Main: 222924800
21:37:59 INFO - PROCESS | 1844 |
21:41:01 INFO - PROCESS | 1844 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html)
21:41:01 INFO - PROCESS | 1844 | RSS: Main: 171692032
21:41:01 INFO - PROCESS | 1844 |
21:44:04 INFO - PROCESS | 1844 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html)
21:44:04 INFO - PROCESS | 1844 | RSS: Main: 170049536
21:44:04 INFO - PROCESS | 1844 |
21:47:07 INFO - PROCESS | 1844 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html)
21:47:08 INFO - PROCESS | 1844 | RSS: Main: 160919552
21:47:08 INFO - PROCESS | 1844 |
21:50:11 INFO - PROCESS | 1844 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html)
21:50:11 INFO - PROCESS | 1844 | RSS: Main: 294866944
21:50:11 INFO - PROCESS | 1844 |
21:50:11 INFO - PROCESS | 1844 | __start_tp_report
21:50:11 INFO - PROCESS | 1844 | _x_x_mozilla_page_load
21:50:11 INFO - PROCESS | 1844 | _x_x_mozilla_page_load_details
21:50:11 INFO - PROCESS | 1844 | |i|pagename|runs|
21:50:11 INFO - PROCESS | 1844 | |0;dojo.html;2853.2438903690527;2868.3259434033;2881.855907204639;2904.085213157855;2918.8978385756504;5070.239464080385;5080.0347933892535;5100.515451032155;5119.6160287978455;5161.045206636775;5004;5131.666441681297;5140.306058682077;5153.30430391897;5256.448072952342;4563.840265590705;4624;4624.190766615846;4658.208104622206;4664.207084795576;4608.078384323132;4622.722636641813;4651.720896746189;4658.836940707076;4680.4149481314835;4637.9536204638025;4645.6980296280635;4647.512011238822;4657.836975705834;4697.694649847766;4538.047010127877;4543.440488696162;4591.058832939239;4645.396098507189;4656.487786343533;4594.356790049395;4614.769261536943;4650.139724151009;4663.9766801166115;4665.136949664289;5053.343065401475;5092.745362731848;5097.439281679012;5101.056304583664;5157.690538567698;5350.759215835296;5421.539169170625;5500.614956953015;5508.55931525477;5518.475744804237;5399.379071406799;5439.347278326626;5447.918281225785;5457.536109430703;5515.751791169407;5029.471905449948;5057.822976195889;5086.23706444029;5112.718800465973;5123.666961647481;5601.803936862272;5631.943680563224;5647.350554686182;5652.434756524397;5711.828645140652;5285.762140703678;5329.440408757025;5389.487998640123;5400.378956419983;5404;5457.918131228034;5459.69971651563;5512.283403157564;5529.170624406291;5537.058700021006;5375.704336261465;5397.70312632809;5417.377001644862;5429.375621803464;5432;5383.950129724666;5386.326709161355;5440.075187218104;5456.263404440429;5514.035043867307;3656.9634303657153;3688.483612294281;3697.0387699197863;3714.591394946554;3736.084659258499;3204.3110731192905;3208.598925134358;3234.3369609230053;3236.0615421527496;3243.9837800810847;5228.738563071831;5236.947630523722;5237.292965449616;5238.580913526985;5301.363836339664;5401.000814849265;5409.918851217235;5415.918761218585;5457.208704737791;5525.778968841201;5331.680099194061;5342.465753424626;5379.1662292344745;5390.9191362129595;5402.027635025733;4462.397576327155;4467.955320446819;4481.574250446202;4482.350059241392;4485.416895803524;5696.971515142398;5734.111212762028;5745.937001654791;5747.597668163188;5749.252597162342;5602.915956260741;5602.943970560405;5604.971975140262;5605.215269862304;5612.242347283064;5692.1461780733225;5700.25896633435;5710.457506536873;5712.80005199816;5724.627899186539;5470.8085217017215;5491.945080549143;5492.395836458067;5496.120620700669;5496.203050557727;5482.643628164156;5487.20435536837;5492.286002819608;5526.806561770319;5544.390117087037;5346.331708536433;5350.143976963667;5354.3574771027725;5354.54486368663;5425.348958125051;5194.22086687;5273.578113750814;5310.150375939831;5333.4133245343755;5357.276767636475;5301;5301.840944771663;5303.602229832701;5304.389995150453;5310.9734451327495;5264.52619264268;5302.734863256745;5327.147656374961;5343.064963631271;5368.973155134199;5280.841574752763;5325.334333208349;5325.520703136736;5335.1730481775385;5336.466353364633
21:50:11 INFO - PROCESS | 1844 | |1;ext.html;573.5211098732558;588.4204059001883;589.5607772209704;597.1341554745615;597.1401182297494;36339.81830090849;37309.25381492372;37708.81145594272;40854.79572602133;40918.79540602293;38346.616533834655;38448.80775596118;38671;38778.22443551134;38794.61205387945;7411.0736157980255;7566.129895062083;8264.710735124272;8456.577171141449;8473.237408633222;9797.853032204523;10091.89908100917;10097.697069087939;10243.231757618209;10337.379757214554;10020.649277275297;10078.596856125747;10088.445135517544;10094;10094.596216151345;7588.886166707503;7696.653650585681;7773.183815699326;10023.148032417217;10075.445850478183;7497.3131045514865;9613.759656008655;9854.162396196332;9965.302428829984;10178.134858537032;35669.82165089184;35852.46221306682;35858.28283434343;35950.46074308887;35992.28015439703;3054.57235986962;3135.858886350097;3179.0780673604627;3348.146222713217;3414.078198886287;29047.56428653572;29056.273593160127;29106.85446572775;29402.70597294021;29589.408211835856;3967.266055779661;3990.900034199196;3991.2815693175216;4085.9795701021303;4122.154958233555;305860;305881;307210;308094.99999999773;308745;47980.760096199294;48246;48285.75857120692;48367.274490882664;48376.27435588469;49632.255516167286;49700.75149624229;49767.75116124396;50384.496155038716;50543;12826.935865320615;13079.869201307865;13105.2136871788;13108.737825243632;13115.081944264;9255.398399104037;9296.349255552183;9348;9386.15524602789;9520.809583808285;12933.417996190194;13561.45754169822;13895.722085558233;13901.860981390259;14350.856491434952;5645.266115404971;5662.631928924607;5678.318601767732;5683.119116536944;5686.175504551899;790.4308897593723;827.2430725885868;871.2942516561478;875.5534677314615;891.0732837848565;27098.458030839272;27178.864105679742;27207;27715.722842771313;27744.583831242548;886.1227384888914;909.1363204955319;944.8441007233866;954.6754103604808;977.3744803325877;13653.044286899822;14321.64195895111;14517.854821451861;14545.636359090895;14622.561323160322;433176;440120;443405;664345;665733;47213.819654508225;47219;47333;47900.28149577759;47903.28145077827;1085.3921803789904;1090.3294473898495;1090.8963648453384;1145.7135716070982;1163.709072731817;25473.49053018966;27489.587656184773;27646.861765691043;28192.29519262035;28355;40106;40216.396754049296;40748.59251407448;40753.59246407498;40783.1843363137;320734;321570;324419;324883;325085;18678;23190.652140218248;24844.627330590418;24900.12849550257;24929.127480538093;40643.593564065166;41081.38377924393;41544.792276038424;41668.583314167685;41721;34571.82714086514;34665.65334346624;34846.825765871006;35453;36048.81975590105;32881.67118328786;34350.82824585861;34645.48031779576;35109.297814043064;35367.11582210465;33481;33970.32059358848;34138.14654633654;34348.656513434544;34545.30909381748;30572.235694107825;31759.523607146373;31776.364472709953;31802.840985794923;31835.93459956366;24237.63643545313;24243.636345455187;24502.99318178411;24505;24769
21:50:11 INFO - PROCESS | 1844 | |2;jquery.html;318.27115904578517;330.4959936097451;331.60870173195633;332.86518959821274;350.28017424193274;13046.347682615879;14188.290585470737;16128.75806862898;16806.411775587825;17444.912775436103;16196;16343.673126537491;16578.088205148713;16604;16781.748273775873;4656.464506581736;4896.657233993622;5184.974075129629;5389.676619402829;5399.136138217886;5229.450907654698;5363.222332761767;5370.3287089113865;5372.7045012524295;5382.946170538303;5097.668651537638;5260.605454590902;5310.256564081013;5320.521153096221;5330.973345133289;5264.657797243186;5284.180951952453;5300.337457817773;5303.549198318147;5308.044551980642;4546.681732278742;4657.091867085919;4666.953330466686;4670.859874203779;4789.80840766369;18400.447986560426;19285.4214373569;19526.51183720404;19542.12060457283;19569;1971.5169783403014;1986.6523358412364;2080.7191029211012;2372.1223147435385;2524.8611326377227;8653.394262401634;8660.30717542595;11218.878112188797;12736.299503527302;12991.415386307544;1694.4154266778064;1743.0848804377677;1775.316503146298;1780.6794776940146;1826.4977131289002;69418.65290673565;70696.29303707;71915.64042179807;73399;77510.6124469374;8725.956370218108;8874.201321881063;8962;9111.772205694911;9256.398334108262;12332.383380831103;12338.198017128858;12343;12353.073519486075;12423.75152496945;6338.58799178052;6371.139896114058;6596.142501474777;6669.46644268467;6759.324067593201;5965.194698715704;6115;6214.564980451415;6432.324605916405;6453.064305675651;3724.571674257441;3821.980890095532;3849.172427928009;3880.1075752576503;3934.213157368538;1601.0953811096692;1634.689409012284;1646.102873933709;1686.5614940115659;1691.37419154911;808.3169721585251;808.9959550202329;849.9277561407349;876.513534988075;887.8934527856699;15646.843531564766;15681.294341754421;15973;16041.358345666044;16227.83772162287;820.2003047029099;838.149278482341;848.4098502660562;884.5179377239291;892.901780804111;8702.173293537231;8806.603702833389;9079.636814527477;9234.215091717278;9282.67510637138;363101;365312;373100;374836;375899;74806.62596686982;75137.62431187919;75965.62017189879;76019.61990190014;76366.23633763591;867.7700409391516;894.141624040915;894.2309613732185;895.0154829687422;896.6278994217457;13666.794998075236;14073.577792666236;14207.573772786833;14334.139951602938;14485.275736213358;34467;34735.652643473244;34999.4750078744;35190.29619407546;35791.82104089463;47581.76209119071;48534;48966.75516622394;49161.50838491712;49245.50754492409;6844.315568443116;6994.720211191496;7037.401820845285;7115.822104447223;7182.3894968928225;9867.753306167404;10083.243756718422;10250.282480226313;10594.841077383999;11049.33703977764;7949.642266098155;8073.052294292315;8404.915950840414;8405.663773449238;8841.646334146562;8880.111988801069;9080.182783549511;9161.725148245563;9197.448153110834;9408.247340212904;8013.439059265796;8073.475224110414;8386.245237928615;8585.613647385757;8759.12408759119;7131.7503887365765;7142.714291428285;7205.71177152908;7257.818554536178;7370.484066115535;6585.045168450643;8599.570021498776;8608.91391086081;8647;8994.235489983424
21:50:11 INFO - PROCESS | 1844 | |3;mootools.html;1185.7450648110655;1241.2924632959212;1260.7982722764355;1303.042263936007;1469.8162729658793;6746.156730408699;7350.963245183773;7604.163542010381;7620.199879012707;7779.2220777922175;7546.207648196929;7570.848583028336;7577.545347279153;7581.355584775287;7581.962090189555;1994.8104930031623;2016.5361966747657;2018.9293374731888;2020.0303854149943;2021.1511165310606;1976.5256338478805;1981.4848139483765;1981.9306324278652;2008.4777957731021;2021.2117274263048;1907.0083556550585;1918.539550507875;1928.257620815989;1931.565397785501;1938.118156238915;1948.7271781950537;1951.6487032334173;1954.5211423201335;1955.3840540229924;1956.5891162855817;1905.9237630494763;1909.7039958806408;1911.8948457834813;1945.3191383015974;1951.9609607807906;7503.962480187564;7510.624468776539;7513.511621744569;7589.924100758977;7592.316691497736;4185.476815398075;4300.827966881321;4309.461317335333;4337.652987760972;4342.956570434287;2865.1834227245135;2927.312081660808;2978.2852115492124;2980.5976193213855;2981.254686328418;915.6154415145588;915.9313051521096;936.1247233836385;936.8079543693526;938.0947385772694;10349.275550711453;10411.010953959438;10437.42594157321;10438.68683939483;10452.372857628567;3683.9815800920824;3694.4088945769086;3784.1674831537016;3791.867284645024;3893.8831835044994;8057.6374063167295;8074.959625201836;8148.796280093045;8151.836963260702;8166.83666326682;4357.694961352675;4370.344448332712;4370.409994650745;4374.147041326974;4377.518472967971;3803.2963901678277;3808.619138086169;3913.7064720146104;4083.571225021389;4099.590040995936;3192.138122706903;3221.64561898191;3277.623073346548;3294.4399452093203;3297.1757060734817;900.6712549919363;901.3825529512305;907.2379201470665;911.4941207629696;912.1516989199976;747.622450662412;780.1457404142454;799.5802203842912;802.6749166587541;807.7778610882054;4764.8332308369045;4789.736564488987;4817.759112044384;4834.854954351375;5041.621878359138;366.6809875408359;372.2480589209781;373.83364402840476;373.8859647807445;380.7924681048835;3259.445894197992;3281.6882396172327;3326.866925323008;3366.646502117291;3461.4288642373726;8828.602712877935;9141.085891410805;9272.629094836131;9429.151376376021;9554.61781528731;9346;9359.29805264608;9373.578188981512;9376.67181648639;9377.531123443801;6948.200956889921;7002.159740831133;7170.103737032871;7187.460940429489;7220.241874603091;4852.878678033077;4864.489228630943;4874.4150701916;4900.093482705711;5027.949720502895;8734.344924130588;8768.78078048054;8771.649134034567;8780.25367843715;8794.384393092421;8329.708460203863;8588.441751286146;8639.654413823377;8844.380893337404;8870.778230544289;6215.751369945332;6808.863822723617;6951.652417379009;6961.547499412522;6973.58158510491;6914.9308506916295;7137.678804453916;7224.711011559479;7366.116066072105;7526.698932042876;6703.798886033427;6729.865402692017;6756.482229302133;6852.451803855779;6884.51808373409;6579.967100164468;6663.200415950117;6731.124953755981;6734.3602357775935;6761.357671021246;5822.4759771619065;5915.585908986502;5923.911141332969;5934.9406505934385;5940.732667030081;3850.537935447764;3880.262750077476;3900.863469778544;3904.8047597620575;3979.5025621797276;3951.7628942263555;3968.543617484026;4049.2913740095955;4060.9187816244103;4140.585941405835
21:50:11 INFO - PROCESS | 1844 | |4;prototype.html;274.9518834204014;275.27465129384075;282.2323280676559;284.1277278754224;289.9246195989045;5268.446813084628;5278.736063196844;5281.551068159206;5304.734763261841;5313.442088580701;4957.529034741703;5092.872678183047;5099.031184075023;5104.3619547556555;5106.514881086291;3871.399933010388;3871.986566985166;3890.1247219375628;3914.197589494147;3955.1101002274545;3937.425029987999;3944.5660977292473;3951.5455722591983;3959.485266915297;3973.582773808752;3701.9269209242775;3844.1735026969195;3873.128546077124;3876.7092468064866;3920.4903362562827;3845.769253844778;3860.208657225262;3873.9806300968316;3880.185161116169;3901.804909754515;3309;3327.517509961042;3332.900012999614;3338.9332213355597;3347.9497807532907;4988.451270360294;5071.329591562054;5105.846824595268;5146.845594632167;5150.4334523202415;4483.865484035484;4490.304002879526;4501.459824821042;4516.954830451719;4517.893116186522;5452.318460192476;5454.61817672763;5468.043092458844;5482.945170548283;5494.203340515643;3710.5547334319785;3731.5708693500324;3736.925261494755;3744.326021316162;3750.362438385481;5422.48486393792;5703.486686198221;5734;5747.59766816323;5757.827265182052;3735.1035751419463;3762.4761971401626;3763.6424539668687;3765.058735316171;3768.4535742317757;3806.562245341766;3814.1418180909072;3814.389697648363;3816.1604447022164;3828.406596977473;4355.695101342939;4410.25025745624;4443.400140980926;4449.310356894686;4476.171908196994;5433.483819037185;5484.725763711798;5501.587380946445;5503.614746967673;5506.852327592243;1276.5532063777603;1306.732119915415;1311.5081844308384;1317.8484474285387;1322.1406086043955;916.7937214126902;951.5432592355708;951.5670369981642;953.427943234054;961.2646325560952;5421.5391691706645;5460.836174914759;5500.3949565547755;5549.445055494418;5550.333959924754;5571.804986825442;5616.831495055155;5705.800296989585;5713.74288157034;5732.971335143297;5442.2380866678695;5453.781848726086;5456.427075157131;5487.972560137254;5515.365732940683;3005.9779674910637;3007.443622929765;3029.5758593796886;3063.1729433053397;3074.1699741069788;5525.702319333041;5706.657600543981;5712.2288491054005;5718.313802343662;5793.362730099686;5679.5172410345585;5704.71476426177;5710.200571919934;5731.7103651678035;5744.281964754406;5446.509814116748;5771.740271687784;5786.508146807484;5792.102224155263;5822.7088645567555;5583.525400340854;5609.579281553982;5612.4387561245185;5646.209530665628;5647.632903861236;5503.917441238465;5514.476124768141;5523.28197334344;5533.972330138324;5537.584681148849;5449.6185267032515;5720.742566584597;5756.539476841926;5767;5772.480476757112;3920.3531417316963;3924.13603538317;3926.5680775115284;3927.9803600981813;3928.7053470990363;5410.431904650112;5651.858703532444;5655.688937108499;5667.291588551431;5672.5745569081655;5219.425863154974;5426.538744206787;5453.736699269759;5470.152126420411;5493.368262649847;5408.432114627907;5418;5421.62048656606;5436.592255580768;5436.836894893159;5195.6622819516615;5302.920456193237;5305.893882122413;5351.976133484569;5469.07025805606;5520.282363292747;5538.47384498472;5540.473655002768;5545.972270138785;5558;5240.895182096413;5461.262729531462;5463.699496527729;5471.398146203835;5495.175723641486
21:50:11 INFO - PROCESS | 1844 | |5;yui.html;650.3236633900743;726.1032624708488;726.5749536521134;739.6856336057176;742.0724094881401;12831.679208019805;13683.657908552292;14069.296535173238;15203.23983800811;15863;14140.92929535351;14389.208593527352;14413.495527656534;14422.567322980327;14427.062240954358;564.266453610307;579.3945327133156;644.7131026693112;661.3551787007677;665.9134312539363;633.1041576169714;651.475562172451;657.8684263147389;659.1233659233209;660.8843452395836;698.8462538241604;703.0157779109262;703.4653663215942;703.6833424958763;705.3827900586987;583.2883881664362;603.1525706382539;701.0675801184437;701.6947627781906;701.7333413302938;495.86611614863784;504.2335649812265;510.14550627698827;510.33911085144825;511.92577076323727;13469.932650336783;13549.932250338685;13556.051076424654;13567.86432135676;13606.251656158907;11984.760304793943;12327.137100402975;12335.198212116184;12614.55849045279;12912.482065997126;12107.213031153035;12228.938855305667;12254.20347677407;12280.466150379787;12338.81491777624;3601.441776524643;3761.5110035695457;3996.540397854255;4021.919561608781;4119.340905455143;60491;61385;61558.692206539126;61943.38056619421;62405.687971560306;9803.16673082796;10112.292139550307;10182.134518565857;10437.739056523496;10515.158787296998;16285.592860178353;16449.6710065798;16621.252043657823;16874.662506750043;16892.324307027826;7645.770626881203;7694.422918281151;7726.7295644653295;7853.175416581291;7942.880856787153;4041.131156801302;4100.0569868929715;4126.8761937141935;4217.536071032184;4323.070539833888;2982.746466550324;3086.6141732283463;3090.799098058619;3092.2424006118645;3095.4273459409633;534.3454268521108;538.6714104396315;541.9060828214813;542.0378827581075;553.5599198637093;574.2534704883634;630.3412933484519;637.2671427858;642.2838535033497;677.3903486861765;8490;8547.188017138362;8724.95637521821;8734.82530349402;8800;509.0480800902336;565.9688717120515;649.0588646462649;650.3691419323249;673.3199468536814;3778.981105094457;3862.806859657062;3882.9029274267805;3901.804909754501;4095.7542547447247;91340;94560.52719736357;95370;95400;95665.52167239258;72780;73513.63243183857;73889.26110738824;82980;83329.16670833336;67706.66146669236;69844;72030.63984680043;72036.99999999895;72166;8544.444611100258;8576.298465983195;8726.781830454289;8729.214370706413;8774.561271936505;39851.60148398595;42416.57583424126;42420.78789606032;42897.142057159304;44215.55784442114;61650.691746542776;61844.38155618566;62920.68539657273;63436;64065.35934640594;12022.338771367658;12161.33112678811;12173.45219465144;12183.329916854658;12645.430955606837;14479.493217737328;14558.199299038655;14610.74642825305;14824.88746842423;14961.700765984837;10695.786084278116;12016.63950081499;13227.603171904859;13446.93276533611;13694.931525342708;12091.334976576021;12271.877281227073;12734.87265127374;13616.38726257301;13739.722284322985;13104.606861794162;13162.511934337217;13347.332633368487;13357.799633005317;13788.93105534466;11284;11297.661070167907;11368.715782105182;11650.6504804856;11807.763844722886;10893.564257429614;11055.834162487408;11078.390688512209;11148;11310.547578097114
21:50:11 INFO - PROCESS | 1844 | __end_tp_report
21:50:11 INFO - PROCESS | 1844 | __start_cc_report
21:50:11 INFO - PROCESS | 1844 | _x_x_mozilla_cycle_collect,2841
21:50:11 INFO - PROCESS | 1844 | __end_cc_report
21:50:11 INFO - PROCESS | 1844 | __startTimestamp1476766211254__endTimestamp
21:50:11 INFO - PROCESS | 1844 |
21:50:11 INFO - PROCESS | 1844 | ------- Summary: start -------
21:50:11 INFO - PROCESS | 1844 | Number of tests: 6
21:50:11 INFO - PROCESS | 1844 |
21:50:11 INFO - PROCESS | 1844 | [#0] dojo.html Cycles:165 Average:5056.11 Median:5325.33 stddev:668.19 (12.5%) stddev-sans-first:647.50
21:50:11 INFO - PROCESS | 1844 | Values: 2853.2 2868.3 2881.9 2904.1 2918.9 5070.2 5080.0 5100.5 5119.6 5161.0 5004.0 5131.7 5140.3 5153.3 5256.4 4563.8 4624.0 4624.2 4658.2 4664.2 4608.1 4622.7 4651.7 4658.8 4680.4 4638.0 4645.7 4647.5 4657.8 4697.7 4538.0 4543.4 4591.1 4645.4 4656.5 4594.4 4614.8 4650.1 4664.0 4665.1 5053.3 5092.7 5097.4 5101.1 5157.7 5350.8 5421.5 5500.6 5508.6 5518.5 5399.4 5439.3 5447.9 5457.5 5515.8 5029.5 5057.8 5086.2 5112.7 5123.7 5601.8 5631.9 5647.4 5652.4 5711.8 5285.8 5329.4 5389.5 5400.4 5404.0 5457.9 5459.7 5512.3 5529.2 5537.1 5375.7 5397.7 5417.4 5429.4 5432.0 5384.0 5386.3 5440.1 5456.3 5514.0 3657.0 3688.5 3697.0 3714.6 3736.1 3204.3 3208.6 3234.3 3236.1 3244.0 5228.7 5236.9 5237.3 5238.6 5301.4 5401.0 5409.9 5415.9 5457.2 5525.8 5331.7 5342.5 5379.2 5390.9 5402.0 4462.4 4468.0 4481.6 4482.4 4485.4 5697.0 5734.1 5745.9 5747.6 5749.3 5602.9 5602.9 5605.0 5605.2 5612.2 5692.1 5700.3 5710.5 5712.8 5724.6 5470.8 5491.9 5492.4 5496.1 5496.2 5482.6 5487.2 5492.3 5526.8 5544.4 5346.3 5350.1 5354.4 5354.5 5425.3 5194.2 5273.6 5310.2 5333.4 5357.3 5301.0 5301.8 5303.6 5304.4 5311.0 5264.5 5302.7 5327.1 5343.1 5369.0 5280.8 5325.3 5325.5 5335.2 5336.5
21:50:11 INFO - PROCESS | 1844 |
21:50:11 INFO - PROCESS | 1844 | [#1] ext.html Cycles:180 Average:52244.31 Median:35561.41 stddev:107937.00 (303.5%) stddev-sans-first:108170.07
21:50:11 INFO - PROCESS | 1844 | Values: 573.5 588.4 589.6 597.1 597.1 36339.8 37309.3 37708.8 40854.8 40918.8 38346.6 38448.8 38671.0 38778.2 38794.6 7411.1 7566.1 8264.7 8456.6 8473.2 9797.9 10091.9 10097.7 10243.2 10337.4 10020.6 10078.6 10088.4 10094.0 10094.6 7588.9 7696.7 7773.2 10023.1 10075.4 7497.3 9613.8 9854.2 9965.3 10178.1 35669.8 35852.5 35858.3 35950.5 35992.3 3054.6 3135.9 3179.1 3348.1 3414.1 29047.6 29056.3 29106.9 29402.7 29589.4 3967.3 3990.9 3991.3 4086.0 4122.2 305860.0 305881.0 307210.0 308095.0 308745.0 47980.8 48246.0 48285.8 48367.3 48376.3 49632.3 49700.8 49767.8 50384.5 50543.0 12826.9 13079.9 13105.2 13108.7 13115.1 9255.4 9296.3 9348.0 9386.2 9520.8 12933.4 13561.5 13895.7 13901.9 14350.9 5645.3 5662.6 5678.3 5683.1 5686.2 790.4 827.2 871.3 875.6 891.1 27098.5 27178.9 27207.0 27715.7 27744.6 886.1 909.1 944.8 954.7 977.4 13653.0 14321.6 14517.9 14545.6 14622.6 433176.0 440120.0 443405.0 664345.0 665733.0 47213.8 47219.0 47333.0 47900.3 47903.3 1085.4 1090.3 1090.9 1145.7 1163.7 25473.5 27489.6 27646.9 28192.3 28355.0 40106.0 40216.4 40748.6 40753.6 40783.2 320734.0 321570.0 324419.0 324883.0 325085.0 18678.0 23190.7 24844.6 24900.1 24929.1 40643.6 41081.4 41544.8 41668.6 41721.0 34571.8 34665.7 34846.8 35453.0 36048.8 32881.7 34350.8 34645.5 35109.3 35367.1 33481.0 33970.3 34138.1 34348.7 34545.3 30572.2 31759.5 31776.4 31802.8 31835.9 24237.6 24243.6 24503.0 24505.0 24769.0
21:50:11 INFO - PROCESS | 1844 |
21:50:11 INFO - PROCESS | 1844 | [#2] jquery.html Cycles:180 Average:23182.96 Median:5301.94 stddev:61415.86 (1158.4%) stddev-sans-first:61564.15
21:50:11 INFO - PROCESS | 1844 | Values: 318.3 330.5 331.6 332.9 350.3 13046.3 14188.3 16128.8 16806.4 17444.9 16196.0 16343.7 16578.1 16604.0 16781.7 4656.5 4896.7 5185.0 5389.7 5399.1 5229.5 5363.2 5370.3 5372.7 5382.9 5097.7 5260.6 5310.3 5320.5 5331.0 5264.7 5284.2 5300.3 5303.5 5308.0 4546.7 4657.1 4667.0 4670.9 4789.8 18400.4 19285.4 19526.5 19542.1 19569.0 1971.5 1986.7 2080.7 2372.1 2524.9 8653.4 8660.3 11218.9 12736.3 12991.4 1694.4 1743.1 1775.3 1780.7 1826.5 69418.7 70696.3 71915.6 73399.0 77510.6 8726.0 8874.2 8962.0 9111.8 9256.4 12332.4 12338.2 12343.0 12353.1 12423.8 6338.6 6371.1 6596.1 6669.5 6759.3 5965.2 6115.0 6214.6 6432.3 6453.1 3724.6 3822.0 3849.2 3880.1 3934.2 1601.1 1634.7 1646.1 1686.6 1691.4 808.3 809.0 849.9 876.5 887.9 15646.8 15681.3 15973.0 16041.4 16227.8 820.2 838.1 848.4 884.5 892.9 8702.2 8806.6 9079.6 9234.2 9282.7 363101.0 365312.0 373100.0 374836.0 375899.0 74806.6 75137.6 75965.6 76019.6 76366.2 867.8 894.1 894.2 895.0 896.6 13666.8 14073.6 14207.6 14334.1 14485.3 34467.0 34735.7 34999.5 35190.3 35791.8 47581.8 48534.0 48966.8 49161.5 49245.5 6844.3 6994.7 7037.4 7115.8 7182.4 9867.8 10083.2 10250.3 10594.8 11049.3 7949.6 8073.1 8404.9 8405.7 8841.6 8880.1 9080.2 9161.7 9197.4 9408.2 8013.4 8073.5 8386.2 8585.6 8759.1 7131.8 7142.7 7205.7 7257.8 7370.5 6585.0 8599.6 8608.9 8647.0 8994.2
21:50:11 INFO - PROCESS | 1844 |
21:50:11 INFO - PROCESS | 1844 | [#3] mootools.html Cycles:180 Average:4870.18 Median:4869.45 stddev:2846.60 (58.5%) stddev-sans-first:2841.12
21:50:11 INFO - PROCESS | 1844 | Values: 1185.7 1241.3 1260.8 1303.0 1469.8 6746.2 7351.0 7604.2 7620.2 7779.2 7546.2 7570.8 7577.5 7581.4 7582.0 1994.8 2016.5 2018.9 2020.0 2021.2 1976.5 1981.5 1981.9 2008.5 2021.2 1907.0 1918.5 1928.3 1931.6 1938.1 1948.7 1951.6 1954.5 1955.4 1956.6 1905.9 1909.7 1911.9 1945.3 1952.0 7504.0 7510.6 7513.5 7589.9 7592.3 4185.5 4300.8 4309.5 4337.7 4343.0 2865.2 2927.3 2978.3 2980.6 2981.3 915.6 915.9 936.1 936.8 938.1 10349.3 10411.0 10437.4 10438.7 10452.4 3684.0 3694.4 3784.2 3791.9 3893.9 8057.6 8075.0 8148.8 8151.8 8166.8 4357.7 4370.3 4370.4 4374.1 4377.5 3803.3 3808.6 3913.7 4083.6 4099.6 3192.1 3221.6 3277.6 3294.4 3297.2 900.7 901.4 907.2 911.5 912.2 747.6 780.1 799.6 802.7 807.8 4764.8 4789.7 4817.8 4834.9 5041.6 366.7 372.2 373.8 373.9 380.8 3259.4 3281.7 3326.9 3366.6 3461.4 8828.6 9141.1 9272.6 9429.2 9554.6 9346.0 9359.3 9373.6 9376.7 9377.5 6948.2 7002.2 7170.1 7187.5 7220.2 4852.9 4864.5 4874.4 4900.1 5027.9 8734.3 8768.8 8771.6 8780.3 8794.4 8329.7 8588.4 8639.7 8844.4 8870.8 6215.8 6808.9 6951.7 6961.5 6973.6 6914.9 7137.7 7224.7 7366.1 7526.7 6703.8 6729.9 6756.5 6852.5 6884.5 6580.0 6663.2 6731.1 6734.4 6761.4 5822.5 5915.6 5923.9 5934.9 5940.7 3850.5 3880.3 3900.9 3904.8 3979.5 3951.8 3968.5 4049.3 4060.9 4140.6
21:50:11 INFO - PROCESS | 1844 |
21:50:11 INFO - PROCESS | 1844 | [#4] prototype.html Cycles:180 Average:4557.27 Median:5380.20 stddev:1389.35 (25.8%) stddev-sans-first:1355.56
21:50:11 INFO - PROCESS | 1844 | Values: 275.0 275.3 282.2 284.1 289.9 5268.4 5278.7 5281.6 5304.7 5313.4 4957.5 5092.9 5099.0 5104.4 5106.5 3871.4 3872.0 3890.1 3914.2 3955.1 3937.4 3944.6 3951.5 3959.5 3973.6 3701.9 3844.2 3873.1 3876.7 3920.5 3845.8 3860.2 3874.0 3880.2 3901.8 3309.0 3327.5 3332.9 3338.9 3347.9 4988.5 5071.3 5105.8 5146.8 5150.4 4483.9 4490.3 4501.5 4517.0 4517.9 5452.3 5454.6 5468.0 5482.9 5494.2 3710.6 3731.6 3736.9 3744.3 3750.4 5422.5 5703.5 5734.0 5747.6 5757.8 3735.1 3762.5 3763.6 3765.1 3768.5 3806.6 3814.1 3814.4 3816.2 3828.4 4355.7 4410.3 4443.4 4449.3 4476.2 5433.5 5484.7 5501.6 5503.6 5506.9 1276.6 1306.7 1311.5 1317.8 1322.1 916.8 951.5 951.6 953.4 961.3 5421.5 5460.8 5500.4 5549.4 5550.3 5571.8 5616.8 5705.8 5713.7 5733.0 5442.2 5453.8 5456.4 5488.0 5515.4 3006.0 3007.4 3029.6 3063.2 3074.2 5525.7 5706.7 5712.2 5718.3 5793.4 5679.5 5704.7 5710.2 5731.7 5744.3 5446.5 5771.7 5786.5 5792.1 5822.7 5583.5 5609.6 5612.4 5646.2 5647.6 5503.9 5514.5 5523.3 5534.0 5537.6 5449.6 5720.7 5756.5 5767.0 5772.5 3920.4 3924.1 3926.6 3928.0 3928.7 5410.4 5651.9 5655.7 5667.3 5672.6 5219.4 5426.5 5453.7 5470.2 5493.4 5408.4 5418.0 5421.6 5436.6 5436.8 5195.7 5302.9 5305.9 5352.0 5469.1 5520.3 5538.5 5540.5 5546.0 5558.0 5240.9 5461.3 5463.7 5471.4 5495.2
21:50:11 INFO - PROCESS | 1844 |
21:50:11 INFO - PROCESS | 1844 | [#5] yui.html Cycles:180 Average:17697.73 Median:42658.96 stddev:24142.54 (56.6%) stddev-sans-first:24176.34
21:50:11 INFO - PROCESS | 1844 | Values: 650.3 726.1 726.6 739.7 742.1 12831.7 13683.7 14069.3 15203.2 15863.0 14140.9 14389.2 14413.5 14422.6 14427.1 564.3 579.4 644.7 661.4 665.9 633.1 651.5 657.9 659.1 660.9 698.8 703.0 703.5 703.7 705.4 583.3 603.2 701.1 701.7 701.7 495.9 504.2 510.1 510.3 511.9 13469.9 13549.9 13556.1 13567.9 13606.3 11984.8 12327.1 12335.2 12614.6 12912.5 12107.2 12228.9 12254.2 12280.5 12338.8 3601.4 3761.5 3996.5 4021.9 4119.3 60491.0 61385.0 61558.7 61943.4 62405.7 9803.2 10112.3 10182.1 10437.7 10515.2 16285.6 16449.7 16621.3 16874.7 16892.3 7645.8 7694.4 7726.7 7853.2 7942.9 4041.1 4100.1 4126.9 4217.5 4323.1 2982.7 3086.6 3090.8 3092.2 3095.4 534.3 538.7 541.9 542.0 553.6 574.3 630.3 637.3 642.3 677.4 8490.0 8547.2 8725.0 8734.8 8800.0 509.0 566.0 649.1 650.4 673.3 3779.0 3862.8 3882.9 3901.8 4095.8 91340.0 94560.5 95370.0 95400.0 95665.5 72780.0 73513.6 73889.3 82980.0 83329.2 67706.7 69844.0 72030.6 72037.0 72166.0 8544.4 8576.3 8726.8 8729.2 8774.6 39851.6 42416.6 42420.8 42897.1 44215.6 61650.7 61844.4 62920.7 63436.0 64065.4 12022.3 12161.3 12173.5 12183.3 12645.4 14479.5 14558.2 14610.7 14824.9 14961.7 10695.8 12016.6 13227.6 13446.9 13694.9 12091.3 12271.9 12734.9 13616.4 13739.7 13104.6 13162.5 13347.3 13357.8 13788.9 11284.0 11297.7 11368.7 11650.7 11807.8 10893.6 11055.8 11078.4 11148.0 11310.5
21:50:11 INFO - PROCESS | 1844 | -------- Summary: end --------
21:50:11 INFO - PROCESS | 1844 |
21:50:11 INFO - TEST-INFO | 1844: exit 0
21:50:12 INFO - TEST-OK | dromaeo_css | took 1122934ms
21:50:12 INFO - TEST-START | kraken
21:50:12 INFO - operating with platform_type : w8_
21:50:12 INFO - Initialising browser for kraken test...
21:50:12 INFO - TEST-INFO | started process 584 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmp0den0p\profile http://localhost:49274/getInfo.html)
21:50:17 INFO - PROCESS | 584 | __metrics Screen width/height:1600/1200
21:50:17 INFO - PROCESS | 584 | colorDepth:24
21:50:17 INFO - PROCESS | 584 | Browser inner width/height: 1010/674
21:50:17 INFO - PROCESS | 584 | __metrics
21:50:19 INFO - PROCESS | 584 | 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"
21:50:19 INFO - PROCESS | 584 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver]
21:50:19 INFO - PROCESS | 584 | console.error:
21:50:19 INFO - PROCESS | 584 | Message: Error: Connection closed before committing the transaction.
21:50:19 INFO - PROCESS | 584 | Stack:
21:50:19 INFO - PROCESS | 584 | ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:937:23
21:50:19 INFO - PROCESS | 584 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7
21:50:19 INFO - PROCESS | 584 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11
21:50:19 INFO - PROCESS | 584 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7
21:50:19 INFO - PROCESS | 584 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:714:7
21:50:19 INFO - PROCESS | 584 | TaskImpl_run@resource://gre/modules/Task.jsm:327:15
21:50:19 INFO - PROCESS | 584 | Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:551:9
21:50:19 INFO - PROCESS | 584 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15
21:50:19 INFO - PROCESS | 584 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:388:5
21:50:19 INFO - PROCESS | 584 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29
21:50:19 INFO - PROCESS | 584 | Barrier/this.client.addBlocker/promise13.4%
21:51:16 INFO - TinderboxPrint: I/O read bytes / time
232,697,344 / 2,464,290
21:51:16 INFO - TinderboxPrint: I/O write bytes / time
409,315,328 / 3,283,440
21:51:16 INFO - TinderboxPrint: CPU idle
8,235.4 (86.6%)
21:51:16 INFO - TinderboxPrint: CPU user
1,227.7 (12.9%)
21:51:16 INFO - install - Wall time: 3s; CPU: 13.0%; Read bytes: 0; Write bytes: 37507584; Read time: 0; Write time: 67900
21:51:16 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 232598016; Write bytes: 315454976; Read time: 2449410; Write time: 3171920
21:51:16 INFO - Running post-run listener: _upload_blobber_files
21:51:16 INFO - Blob upload gear active.
21:51:16 INFO - Preparing to upload files from C:\slave\test\build\blobber_upload_dir.
21:51:16 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
21:51:16 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']
21:51:16 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
21:51:17 INFO - (blobuploader) - INFO - Open directory for files ...
21:51:17 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_errorsummary.log ...
21:51:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
21:51:17 INFO - (blobuploader) - INFO - Uploading, attempt #1.
21:51:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded
21:51:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
21:51:17 INFO - (blobuploader) - INFO - Done attempting.
21:51:17 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_raw.log ...
21:51:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
21:51:17 INFO - (blobuploader) - INFO - Uploading, attempt #1.
21:51:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded
21:51:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
21:51:18 INFO - (blobuploader) - INFO - Done attempting.
21:51:18 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\resource-usage.json ...
21:51:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
21:51:18 INFO - (blobuploader) - INFO - Uploading, attempt #1.
21:51:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded
21:51:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
21:51:21 INFO - (blobuploader) - INFO - Done attempting.
21:51:21 INFO - (blobuploader) - INFO - Iteration through files over.
21:51:21 INFO - Return code: 0
21:51:21 INFO - rmtree: C:\slave\test\build\uploaded_files.json
21:51:21 INFO - Using _rmtree_windows ...
21:51:21 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build\\uploaded_files.json',), kwargs: {}, attempt #1
21:51:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/da022b329613e801265534bcda6fb727a299a976d90fbe0b6f0d1e55f4631bea8a70fe43cccfac2a4fa30a7c7c46fa20e9ce2c50bdb107f4de84a11ea7fb0250", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f81c8e32a76b0687e19dca47e08af32c8ea89440fc30a27de103251b2acf85660569f34191abebb50724fb4aedffd469dce844174061b96f6da89e1e352fdc78", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/55d1f7eb56b4ed55ee0d7a5cffea7f67ea09f410e9836c1ff81ffe17d437c3e9ece201d50064eaa2ca05ca49837f03638a775606337c986b66ea47b372fa5261"}
21:51:21 INFO - Writing buildbot properties ['blobber_files'] to C:\slave\test\properties\blobber_files
21:51:21 INFO - Writing to file C:\slave\test\properties\blobber_files
21:51:21 INFO - Contents:
21:51:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/da022b329613e801265534bcda6fb727a299a976d90fbe0b6f0d1e55f4631bea8a70fe43cccfac2a4fa30a7c7c46fa20e9ce2c50bdb107f4de84a11ea7fb0250", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f81c8e32a76b0687e19dca47e08af32c8ea89440fc30a27de103251b2acf85660569f34191abebb50724fb4aedffd469dce844174061b96f6da89e1e352fdc78", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/55d1f7eb56b4ed55ee0d7a5cffea7f67ea09f410e9836c1ff81ffe17d437c3e9ece201d50064eaa2ca05ca49837f03638a775606337c986b66ea47b372fa5261"}
21:51:21 INFO - Running post-run listener: copy_logs_to_upload_dir
21:51:21 INFO - Copying logs to upload dir...
21:51:21 INFO - mkdir: C:\slave\test\build\upload\logs
21:51:21 INFO - Copying logs to upload dir...
21:51:21 INFO - Using _rmtree_windows ...
21:51:21 INFO - Using _rmtree_windows ...
21:51:21 INFO - Using _rmtree_windows ...
21:51:21 INFO - Using _rmtree_windows ...
21:51:21 INFO - Using _rmtree_windows ...
21:51:21 INFO - Using _rmtree_windows ...
21:51:21 INFO - Using _rmtree_windows ...
program finished with exit code 0
elapsedTime=1387.455000
========= master_lag: -0.26 =========
========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 7 secs) (at 2016-10-17 21:51:21.743215) =========
========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 21:51:21.744016) =========
'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-164\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-164
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-164
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-164\AppData\Local
LOGONSERVER=\\T-W864-IX-164
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-164
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-164
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-164
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/da022b329613e801265534bcda6fb727a299a976d90fbe0b6f0d1e55f4631bea8a70fe43cccfac2a4fa30a7c7c46fa20e9ce2c50bdb107f4de84a11ea7fb0250", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f81c8e32a76b0687e19dca47e08af32c8ea89440fc30a27de103251b2acf85660569f34191abebb50724fb4aedffd469dce844174061b96f6da89e1e352fdc78", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/55d1f7eb56b4ed55ee0d7a5cffea7f67ea09f410e9836c1ff81ffe17d437c3e9ece201d50064eaa2ca05ca49837f03638a775606337c986b66ea47b372fa5261"}
build_url:https://queue.taskcluster.net/v1/task/WzOP4LHtS9q7G9fPWHo64A/artifacts/public/build/firefox-52.0a1.en-US.win64.zip
program finished with exit code 0
elapsedTime=0.102000
build_url: 'https://queue.taskcluster.net/v1/task/WzOP4LHtS9q7G9fPWHo64A/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/da022b329613e801265534bcda6fb727a299a976d90fbe0b6f0d1e55f4631bea8a70fe43cccfac2a4fa30a7c7c46fa20e9ce2c50bdb107f4de84a11ea7fb0250", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f81c8e32a76b0687e19dca47e08af32c8ea89440fc30a27de103251b2acf85660569f34191abebb50724fb4aedffd469dce844174061b96f6da89e1e352fdc78", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/55d1f7eb56b4ed55ee0d7a5cffea7f67ea09f410e9836c1ff81ffe17d437c3e9ece201d50064eaa2ca05ca49837f03638a775606337c986b66ea47b372fa5261"}'
========= master_lag: 0.02 =========
========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 21:51:21.866698) =========
========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 21:51:21.867093) =========
'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-164\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-164
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-164
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-164\AppData\Local
LOGONSERVER=\\T-W864-IX-164
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-164
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-164
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-164
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-17 21:51:21.986212) =========
========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-10-17 21:51:21.986549) =========
========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-10-17 21:51:22.533513) =========
========= Total master_lag: -0.10 =========