builder: autoland_win8_64_test-dromaeojs-pgo
slave: t-w864-ix-014
starttime: 1471818512.9
results: success (0)
buildid: 20160821123001
builduid: 3b810fe83c7b4aa6a444c197508ad016
revision: 2a3b10281c9c7fd450fa27bdfa11d60bc0e0133c
========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-21 15:28:32.896129) =========
master: http://buildbot-master119.bb.releng.scl3.mozilla.com:8201/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-21 15:28:32.896570) =========
========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-21 15:28:32.896855) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-21 15:28:33.231494) =========
========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-21 15:28:33.231770) =========
'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-014\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-014
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-014
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-014\AppData\Local
LOGONSERVER=\\T-W864-IX-014
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-014
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-014
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-014
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
--15:28:34-- 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.
HTTP request sent, awaiting response... 200 Script output follows
Length: 12,141 (12K) [text/x-python]
0K .......... . 100% 8.26 MB/s
15:28:34 (8.26 MB/s) - `archiver_client.py' saved [12141/12141]
program finished with exit code 0
elapsedTime=1.234000
========= master_lag: 0.04 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-21 15:28:34.503482) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-08-21 15:28:34.503783) =========
'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-014\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-014
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-014
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-014\AppData\Local
LOGONSERVER=\\T-W864-IX-014
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-014
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-014
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-014
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
program finished with exit code 0
elapsedTime=3.511000
========= master_lag: 0.09 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-08-21 15:28:38.104437) =========
========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-21 15:28:38.104780) =========
'bash' '-c' u'python archiver_client.py mozharness --repo integration/autoland --rev 2a3b10281c9c7fd450fa27bdfa11d60bc0e0133c --destination scripts --debug'
in dir C:\slave\test\. (timeout 1200 secs)
watching logfiles {}
argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 2a3b10281c9c7fd450fa27bdfa11d60bc0e0133c --destination scripts --debug']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld.T-W864-IX-014\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-014
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-014
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-014\AppData\Local
LOGONSERVER=\\T-W864-IX-014
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-014
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-014
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-014
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
2016-08-21 15:28:38,641 truncating revision to first 12 chars
2016-08-21 15:28:38,641 Setting DEBUG logging.
2016-08-21 15:28:38,641 attempt 1/10
2016-08-21 15:28:38,641 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/2a3b10281c9c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2016-08-21 15:28:39,944 unpacking tar archive at: autoland-2a3b10281c9c/testing/mozharness/
2016-08-21 15:28:40,052 skipping symlink on windows: configs/single_locale/linux32.py
program finished with exit code 0
elapsedTime=2.030000
========= master_lag: 0.08 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-21 15:28:40.214165) =========
========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-21 15:28:40.214650) =========
script_repo_revision: 2a3b10281c9c7fd450fa27bdfa11d60bc0e0133c
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-21 15:28:40.215254) =========
========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-21 15:28:40.215690) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-21 15:28:40.257554) =========
========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 20 secs) (at 2016-08-21 15:28:40.257897) =========
'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'dromaeojs' '--add-option' '--webServer,localhost' '--branch-name' 'Autoland' '--cfg' 'talos/windows_config.py' '--download-symbols' 'ondemand' '--use-talos-json' '--blob-upload-branch' 'Autoland'
in dir C:\slave\test\. (timeout 3600 secs) (maxTime 7200 secs)
watching logfiles {}
argv: ['c:/mozilla-build/python27/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/windows_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld.T-W864-IX-014\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-014
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-014
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-014\AppData\Local
LOGONSERVER=\\T-W864-IX-014
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-014
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-014
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-014
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
15:28:40 INFO - MultiFileLogger online at 20160821 15:28:40 in C:\slave\test
15:28:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland
15:28:40 INFO - Dumping config to C:\slave\test\logs\localconfig.json.
15:28:40 INFO - {'append_to_log': False,
15:28:40 INFO - 'base_work_dir': 'C:\\slave\\test',
15:28:40 INFO - 'blob_upload_branch': 'Autoland',
15:28:40 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt',
15:28:40 INFO - 'branch': 'Autoland',
15:28:40 INFO - 'buildbot_json_path': 'buildprops.json',
15:28:40 INFO - 'config_files': ('talos/windows_config.py',),
15:28:40 INFO - 'default_actions': ('clobber',
15:28:40 INFO - 'read-buildbot-config',
15:28:40 INFO - 'download-and-extract',
15:28:40 INFO - 'populate-webroot',
15:28:40 INFO - 'create-virtualenv',
15:28:40 INFO - 'install',
15:28:40 INFO - 'run-tests'),
15:28:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',),
15:28:40 INFO - 'download_minidump_stackwalk': True,
15:28:40 INFO - 'download_symbols': 'ondemand',
15:28:40 INFO - 'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python',
15:28:40 INFO - 'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'),
15:28:40 INFO - 'hg': 'c:/mozilla-build/hg/hg',
15:28:40 INFO - 'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python',
15:28:40 INFO - 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'),
15:28:40 INFO - 'python': 'c:/mozilla-build/python27/python.exe',
15:28:40 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe',
15:28:40 INFO - 'C:/mozilla-build/tooltool.py'),
15:28:40 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe',
15:28:40 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')},
15:28:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub',
15:28:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'),
15:28:40 INFO - 'installer_path': 'installer.exe',
15:28:40 INFO - 'log_level': 'info',
15:28:40 INFO - 'log_name': 'talos',
15:28:40 INFO - 'log_to_console': True,
15:28:40 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe',
15:28:40 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe',
15:28:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest',
15:28:40 INFO - 'opt_config_files': (),
15:28:40 INFO - 'pip_index': False,
15:28:40 INFO - 'sps_profile': False,
15:28:40 INFO - 'sps_profile_interval': 0,
15:28:40 INFO - 'suite': 'dromaeojs',
15:28:40 INFO - 'system_bits': '32',
15:28:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'),
15:28:40 INFO - 'title': 'T-W864-IX-014',
15:28:40 INFO - 'use_talos_json': True,
15:28:40 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'),
15:28:40 INFO - 'virtualenv_path': 'C:\\slave\\test\\build/venv',
15:28:40 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll',
15:28:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
15:28:40 INFO - 'work_dir': 'build'}
15:28:40 INFO - [mozharness: 2016-08-21 22:28:40.880000Z] Running clobber step.
15:28:40 INFO - Running pre-action listener: _resource_record_pre_action
15:28:40 INFO - Running main action method: clobber
15:28:40 INFO - rmtree: C:\slave\test\build
15:28:40 INFO - Using _rmtree_windows ...
15:28:40 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1
15:30:15 INFO - Running post-action listener: _resource_record_post_action
15:30:15 INFO - [mozharness: 2016-08-21 22:30:15.103000Z] Finished clobber step (success)
15:30:15 INFO - [mozharness: 2016-08-21 22:30:15.103000Z] Running read-buildbot-config step.
15:30:15 INFO - Running pre-action listener: _resource_record_pre_action
15:30:15 INFO - Running main action method: read_buildbot_config
15:30:15 INFO - Using buildbot properties:
15:30:15 INFO - {
15:30:15 INFO - "project": "",
15:30:15 INFO - "product": "firefox",
15:30:15 INFO - "script_repo_revision": "production",
15:30:15 INFO - "builddir": "autoland_win8_64_test-dromaeojs",
15:30:15 INFO - "repository": "",
15:30:15 INFO - "buildername": "Windows 8 64-bit autoland pgo talos dromaeojs",
15:30:15 INFO - "buildid": "20160821123001",
15:30:15 INFO - "pgo_build": "True",
15:30:15 INFO - "basedir": "C:\\slave\\test",
15:30:15 INFO - "buildnumber": 34,
15:30:15 INFO - "slavename": "t-w864-ix-014",
15:30:15 INFO - "master": "http://buildbot-master119.bb.releng.scl3.mozilla.com:8201/",
15:30:15 INFO - "platform": "win8_64",
15:30:15 INFO - "scheduler": "tests-autoland-win64-pgo-talos",
15:30:15 INFO - "branch": "autoland",
15:30:15 INFO - "repo_path": "integration/autoland",
15:30:15 INFO - "revision": "2a3b10281c9c7fd450fa27bdfa11d60bc0e0133c",
15:30:15 INFO - "stage_platform": "win64-pgo",
15:30:15 INFO - "builduid": "3b810fe83c7b4aa6a444c197508ad016",
15:30:15 INFO - "slavebuilddir": "test"
15:30:15 INFO - }
15:30:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/BCJ1gsNrQ2yD9n8HeblaZw/artifacts/public/build/firefox-51.0a1.en-US.win64.zip.
15:30:15 INFO - Running post-action listener: _resource_record_post_action
15:30:15 INFO - [mozharness: 2016-08-21 22:30:15.107000Z] Finished read-buildbot-config step (success)
15:30:15 INFO - [mozharness: 2016-08-21 22:30:15.107000Z] Running download-and-extract step.
15:30:15 INFO - Running pre-action listener: _resource_record_pre_action
15:30:15 INFO - Running main action method: download_and_extract
15:30:15 INFO - mkdir: C:\slave\test\build\tests
15:30:15 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')]}
15:30:15 INFO - trying https://queue.taskcluster.net/v1/task/BCJ1gsNrQ2yD9n8HeblaZw/artifacts/public/build/firefox-51.0a1.en-US.win64.test_packages.json
15:30:15 INFO - Downloading https://queue.taskcluster.net/v1/task/BCJ1gsNrQ2yD9n8HeblaZw/artifacts/public/build/firefox-51.0a1.en-US.win64.test_packages.json to C:\slave\test\build\firefox-51.0a1.en-US.win64.test_packages.json
15:30:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BCJ1gsNrQ2yD9n8HeblaZw/artifacts/public/build/firefox-51.0a1.en-US.win64.test_packages.json', 'file_name': 'C:\\slave\\test\\build\\firefox-51.0a1.en-US.win64.test_packages.json'}, attempt #1
15:30:15 INFO - Downloaded 1218 bytes.
15:30:15 INFO - Reading from file C:\slave\test\build\firefox-51.0a1.en-US.win64.test_packages.json
15:30:15 INFO - Using the following test package requirements:
15:30:15 INFO - {u'common': [u'firefox-51.0a1.en-US.win64.common.tests.zip'],
15:30:15 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.win64.common.tests.zip',
15:30:15 INFO - u'firefox-51.0a1.en-US.win64.cppunittest.tests.zip'],
15:30:15 INFO - u'gtest': [u'firefox-51.0a1.en-US.win64.common.tests.zip'],
15:30:15 INFO - u'jittest': [u'firefox-51.0a1.en-US.win64.common.tests.zip',
15:30:15 INFO - u'jsshell-win64.zip'],
15:30:15 INFO - u'mochitest': [u'firefox-51.0a1.en-US.win64.common.tests.zip',
15:30:15 INFO - u'firefox-51.0a1.en-US.win64.mochitest.tests.zip'],
15:30:15 INFO - u'mozbase': [u'firefox-51.0a1.en-US.win64.common.tests.zip'],
15:30:15 INFO - u'reftest': [u'firefox-51.0a1.en-US.win64.common.tests.zip',
15:30:15 INFO - u'firefox-51.0a1.en-US.win64.reftest.tests.zip'],
15:30:15 INFO - u'talos': [u'firefox-51.0a1.en-US.win64.common.tests.zip',
15:30:15 INFO - u'firefox-51.0a1.en-US.win64.talos.tests.zip'],
15:30:15 INFO - u'web-platform': [u'firefox-51.0a1.en-US.win64.common.tests.zip',
15:30:15 INFO - u'firefox-51.0a1.en-US.win64.web-platform.tests.zip'],
15:30:15 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.win64.common.tests.zip',
15:30:15 INFO - u'firefox-51.0a1.en-US.win64.xpcshell.tests.zip']}
15:30:15 INFO - Downloading packages: [u'firefox-51.0a1.en-US.win64.common.tests.zip'] for test suite category: common
15:30:15 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')]}
15:30:15 INFO - trying https://queue.taskcluster.net/v1/task/BCJ1gsNrQ2yD9n8HeblaZw/artifacts/public/build/firefox-51.0a1.en-US.win64.common.tests.zip
15:30:15 INFO - Downloading https://queue.taskcluster.net/v1/task/BCJ1gsNrQ2yD9n8HeblaZw/artifacts/public/build/firefox-51.0a1.en-US.win64.common.tests.zip to C:\slave\test\build\firefox-51.0a1.en-US.win64.common.tests.zip
15:30:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BCJ1gsNrQ2yD9n8HeblaZw/artifacts/public/build/firefox-51.0a1.en-US.win64.common.tests.zip', 'file_name': u'C:\\slave\\test\\build\\firefox-51.0a1.en-US.win64.common.tests.zip'}, attempt #1
15:30:16 INFO - Downloaded 17514846 bytes.
15:30:16 INFO - Using ZipFile to extract C:\slave\test\build\firefox-51.0a1.en-US.win64.common.tests.zip to C:\slave\test\build\tests
15:30:45 INFO - Downloading packages: [u'firefox-51.0a1.en-US.win64.common.tests.zip', u'firefox-51.0a1.en-US.win64.talos.tests.zip'] for test suite category: talos
15:30:45 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')]}
15:30:45 INFO - trying https://queue.taskcluster.net/v1/task/BCJ1gsNrQ2yD9n8HeblaZw/artifacts/public/build/firefox-51.0a1.en-US.win64.common.tests.zip
15:30:45 INFO - Downloading https://queue.taskcluster.net/v1/task/BCJ1gsNrQ2yD9n8HeblaZw/artifacts/public/build/firefox-51.0a1.en-US.win64.common.tests.zip to C:\slave\test\build\firefox-51.0a1.en-US.win64.common.tests.zip
15:30:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BCJ1gsNrQ2yD9n8HeblaZw/artifacts/public/build/firefox-51.0a1.en-US.win64.common.tests.zip', 'file_name': u'C:\\slave\\test\\build\\firefox-51.0a1.en-US.win64.common.tests.zip'}, attempt #1
15:30:46 INFO - Downloaded 17514846 bytes.
15:30:46 INFO - Using ZipFile to extract C:\slave\test\build\firefox-51.0a1.en-US.win64.common.tests.zip to C:\slave\test\build\tests
15:30:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
15:30:56 INFO - trying https://queue.taskcluster.net/v1/task/BCJ1gsNrQ2yD9n8HeblaZw/artifacts/public/build/firefox-51.0a1.en-US.win64.talos.tests.zip
15:30:56 INFO - Downloading https://queue.taskcluster.net/v1/task/BCJ1gsNrQ2yD9n8HeblaZw/artifacts/public/build/firefox-51.0a1.en-US.win64.talos.tests.zip to C:\slave\test\build\firefox-51.0a1.en-US.win64.talos.tests.zip
15:30:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BCJ1gsNrQ2yD9n8HeblaZw/artifacts/public/build/firefox-51.0a1.en-US.win64.talos.tests.zip', 'file_name': u'C:\\slave\\test\\build\\firefox-51.0a1.en-US.win64.talos.tests.zip'}, attempt #1
15:30:57 INFO - Downloaded 14413981 bytes.
15:30:57 INFO - Using ZipFile to extract C:\slave\test\build\firefox-51.0a1.en-US.win64.talos.tests.zip to C:\slave\test\build\tests
15:31:11 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')]}
15:31:11 INFO - trying https://queue.taskcluster.net/v1/task/BCJ1gsNrQ2yD9n8HeblaZw/artifacts/public/build/firefox-51.0a1.en-US.win64.zip
15:31:11 INFO - Downloading https://queue.taskcluster.net/v1/task/BCJ1gsNrQ2yD9n8HeblaZw/artifacts/public/build/firefox-51.0a1.en-US.win64.zip to C:\slave\test\build\firefox-51.0a1.en-US.win64.zip
15:31:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BCJ1gsNrQ2yD9n8HeblaZw/artifacts/public/build/firefox-51.0a1.en-US.win64.zip', 'file_name': 'C:\\slave\\test\\build\\firefox-51.0a1.en-US.win64.zip'}, attempt #1
15:31:13 INFO - Downloaded 57854406 bytes.
15:31:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BCJ1gsNrQ2yD9n8HeblaZw/artifacts/public/build/firefox-51.0a1.en-US.win64.zip
15:31:13 INFO - mkdir: C:\slave\test\properties
15:31:13 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url
15:31:13 INFO - Writing to file C:\slave\test\properties\build_url
15:31:13 INFO - Contents:
15:31:13 INFO - build_url:https://queue.taskcluster.net/v1/task/BCJ1gsNrQ2yD9n8HeblaZw/artifacts/public/build/firefox-51.0a1.en-US.win64.zip
15:31:14 INFO - Running post-action listener: _resource_record_post_action
15:31:14 INFO - Running post-action listener: set_extra_try_arguments
15:31:14 INFO - [mozharness: 2016-08-21 22:31:14.662000Z] Finished download-and-extract step (success)
15:31:14 INFO - [mozharness: 2016-08-21 22:31:14.662000Z] Running populate-webroot step.
15:31:14 INFO - Running pre-action listener: _resource_record_pre_action
15:31:14 INFO - Running main action method: populate_webroot
15:31:14 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']},
15:31:14 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']},
15:31:14 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome',
15:31:14 INFO - u'--tppagecycles',
15:31:14 INFO - u'7'],
15:31:14 INFO - u'tests': [u'tsvgm']}},
15:31:14 INFO - u'suites': {u'chromez': {u'talos_options': [u'--disable-e10s'],
15:31:14 INFO - u'tests': [u'tresize', u'tcanvasmark']},
15:31:14 INFO - u'chromez-e10s': {u'tests': [u'tresize', u'tcanvasmark']},
15:31:14 INFO - u'dromaeojs': {u'talos_options': [u'--disable-e10s'],
15:31:14 INFO - u'tests': [u'dromaeo_css', u'kraken']},
15:31:14 INFO - u'dromaeojs-e10s': {u'tests': [u'dromaeo_css', u'kraken']},
15:31:14 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
15:31:14 INFO - u'talos_options': [u'--disable-e10s'],
15:31:14 INFO - u'tests': [u'tp5o_scroll', u'glterrain']},
15:31:14 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
15:31:14 INFO - u'tests': [u'tp5o_scroll', u'glterrain']},
15:31:14 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
15:31:14 INFO - u'talos_options': [u'--disable-e10s'],
15:31:14 INFO - u'tests': [u'damp', u'tps']},
15:31:14 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
15:31:14 INFO - u'tests': [u'damp', u'tps']},
15:31:14 INFO - u'g3': {u'talos_options': [u'--disable-e10s'],
15:31:14 INFO - u'tests': [u'dromaeo_dom']},
15:31:14 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']},
15:31:14 INFO - u'g4': {u'talos_options': [u'--disable-e10s'],
15:31:14 INFO - u'tests': [u'basic_compositor_video']},
15:31:14 INFO - u'g4-e10s': {u'tests': [u'basic_compositor_video']},
15:31:14 INFO - u'other': {u'talos_options': [u'--disable-e10s'],
15:31:14 INFO - u'tests': [u'a11yr',
15:31:14 INFO - u'ts_paint',
15:31:14 INFO - u'tpaint',
15:31:14 INFO - u'sessionrestore',
15:31:14 INFO - u'sessionrestore_no_auto_restore',
15:31:14 INFO - u'tabpaint']},
15:31:14 INFO - u'other-e10s': {u'tests': [u'a11yr',
15:31:14 INFO - u'ts_paint',
15:31:14 INFO - u'tpaint',
15:31:14 INFO - u'sessionrestore',
15:31:14 INFO - u'sessionrestore_no_auto_restore',
15:31:14 INFO - u'tabpaint']},
15:31:14 INFO - u'other-e10s_l64': {u'tests': [u'a11yr',
15:31:14 INFO - u'ts_paint',
15:31:14 INFO - u'tpaint',
15:31:14 INFO - u'sessionrestore',
15:31:14 INFO - u'sessionrestore_no_auto_restore',
15:31:14 INFO - u'tabpaint']},
15:31:14 INFO - u'other-e10s_nol64': {u'tests': [u'a11yr',
15:31:14 INFO - u'ts_paint',
15:31:14 INFO - u'tpaint',
15:31:14 INFO - u'sessionrestore',
15:31:14 INFO - u'sessionrestore_no_auto_restore',
15:31:14 INFO - u'tabpaint']},
15:31:14 INFO - u'other_l64': {u'talos_options': [u'--disable-e10s'],
15:31:14 INFO - u'tests': [u'a11yr',
15:31:14 INFO - u'ts_paint',
15:31:14 INFO - u'tpaint',
15:31:14 INFO - u'sessionrestore',
15:31:14 INFO - u'sessionrestore_no_auto_restore',
15:31:14 INFO - u'tabpaint']},
15:31:14 INFO - u'other_nol64': {u'talos_options': [u'--disable-e10s'],
15:31:14 INFO - u'tests': [u'a11yr',
15:31:14 INFO - u'ts_paint',
15:31:14 INFO - u'tpaint',
15:31:14 INFO - u'sessionrestore',
15:31:14 INFO - u'sessionrestore_no_auto_restore',
15:31:14 INFO - u'tabpaint']},
15:31:14 INFO - u'svgr': {u'talos_options': [u'--disable-e10s'],
15:31:14 INFO - u'tests': [u'tsvgx',
15:31:14 INFO - u'tsvgr_opacity',
15:31:14 INFO - u'tart',
15:31:14 INFO - u'tscrollx',
15:31:14 INFO - u'cart']},
15:31:14 INFO - u'svgr-e10s': {u'tests': [u'tsvgx',
15:31:14 INFO - u'tsvgr_opacity',
15:31:14 INFO - u'tart',
15:31:14 INFO - u'tscrollx',
15:31:14 INFO - u'cart']},
15:31:14 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
15:31:14 INFO - u'talos_options': [u'--disable-e10s'],
15:31:14 INFO - u'tests': [u'tp5o']},
15:31:14 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
15:31:14 INFO - u'tests': [u'tp5o']},
15:31:14 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
15:31:14 INFO - u'talos_options': [u'--disable-e10s',
15:31:14 INFO - u'--xperf_path',
15:31:14 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
15:31:14 INFO - u'tests': [u'tp5n']},
15:31:14 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
15:31:14 INFO - u'talos_options': [u'--xperf_path',
15:31:14 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
15:31:14 INFO - u'tests': [u'tp5n']}},
15:31:14 INFO - u'talos.zip': {u'path': u'',
15:31:14 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}}
15:31:14 INFO - Running post-action listener: _resource_record_post_action
15:31:14 INFO - [mozharness: 2016-08-21 22:31:14.703000Z] Finished populate-webroot step (success)
15:31:14 INFO - [mozharness: 2016-08-21 22:31:14.703000Z] Running create-virtualenv step.
15:31:14 INFO - Running pre-action listener: _resource_record_pre_action
15:31:14 INFO - Running main action method: create_virtualenv
15:31:14 INFO - Creating virtualenv C:\slave\test\build/venv
15:31:14 INFO - mkdir: C:\slave\test\build\venv\Scripts
15:31:15 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll
15:31:15 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'!
15:31:15 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
15:31:15 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build/venv
15:31:22 INFO - New python executable in C:\slave\test\build/venv\Scripts\python.exe
15:31:25 INFO - Installing distribute......................................................................................................................................................................................done.
15:31:27 INFO - Return code: 0
15:31:27 INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv
15:31:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
15:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
15:31:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
15:31:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
15:31:27 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0224C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022F3E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02404FB8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x006F8BF0>, '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 0x0071A9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027D05C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-014', 'USERDOMAIN': 'T-W864-IX-014', '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-014', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-014\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-014', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-014', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-014', '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-014\\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
15:31:27 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in C:\slave\test\build
15:31:27 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5
15:31:27 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
15:31:27 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-014\\AppData\\Roaming',
15:31:27 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
15:31:27 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
15:31:27 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
15:31:27 INFO - 'COMPUTERNAME': 'T-W864-IX-014',
15:31:27 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
15:31:27 INFO - 'DCLOCATION': 'SCL3',
15:31:27 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
15:31:27 INFO - 'FP_NO_HOST_CHECK': 'NO',
15:31:27 INFO - 'HOMEDRIVE': 'C:',
15:31:27 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-014',
15:31:27 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
15:31:27 INFO - 'KTS_VERSION': '1.19c',
15:31:27 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-014\\AppData\\Local',
15:31:27 INFO - 'LOGONSERVER': '\\\\T-W864-IX-014',
15:31:27 INFO - 'MONDIR': 'C:\\Monitor_config\\',
15:31:27 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
15:31:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
15:31:27 INFO - 'MOZ_NO_REMOTE': '1',
15:31:27 INFO - 'NO_EM_RESTART': '1',
15:31:27 INFO - 'NUMBER_OF_PROCESSORS': '8',
15:31:27 INFO - 'OS': 'Windows_NT',
15:31:27 INFO - 'OURDRIVE': 'C:',
15:31:27 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
15:31:27 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
15:31:27 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
15:31:27 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
15:31:27 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
15:31:27 INFO - 'PROCESSOR_LEVEL': '6',
15:31:27 INFO - 'PROCESSOR_REVISION': '1e05',
15:31:27 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
15:31:27 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
15:31:27 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
15:31:27 INFO - 'PROGRAMW6432': 'C:\\Program Files',
15:31:27 INFO - 'PROMPT': '$P$G',
15:31:27 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
15:31:27 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
15:31:27 INFO - 'PUBLIC': 'C:\\Users\\Public',
15:31:27 INFO - 'PWD': 'C:\\slave\\test',
15:31:27 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
15:31:27 INFO - 'SLAVEDIR': 'C:\\slave\\',
15:31:27 INFO - 'SYSTEMDRIVE': 'C:',
15:31:27 INFO - 'SYSTEMROOT': 'C:\\windows',
15:31:27 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
15:31:27 INFO - 'TEST1': 'testie',
15:31:27 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
15:31:27 INFO - 'USERDOMAIN': 'T-W864-IX-014',
15:31:27 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-014',
15:31:27 INFO - 'USERNAME': 'cltbld',
15:31:27 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-014',
15:31:27 INFO - 'WINDIR': 'C:\\windows',
15:31:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
15:31:28 INFO - Ignoring indexes: http://pypi.python.org/simple/
15:31:28 INFO - Downloading/unpacking pip>=1.5
15:31:32 INFO - Running setup.py egg_info for package pip
15:31:32 INFO - warning: no files found matching 'pip\cacert.pem'
15:31:32 INFO - warning: no files found matching '*.html' under directory 'docs'
15:31:32 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build'
15:31:32 INFO - no previously-included directories found matching 'docs\_build\_sources'
15:31:32 INFO - Installing collected packages: pip
15:31:32 INFO - Found existing installation: pip 0.8.2
15:31:32 INFO - Uninstalling pip:
15:31:32 INFO - Successfully uninstalled pip
15:31:32 INFO - Running setup.py install for pip
15:31:32 INFO - warning: no files found matching 'pip\cacert.pem'
15:31:32 INFO - warning: no files found matching '*.html' under directory 'docs'
15:31:32 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build'
15:31:32 INFO - no previously-included directories found matching 'docs\_build\_sources'
15:31:32 INFO - Installing pip-script.py script to C:\slave\test\build\venv\Scripts
15:31:32 INFO - Installing pip.exe script to C:\slave\test\build\venv\Scripts
15:31:32 INFO - Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts
15:31:32 INFO - Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts
15:31:32 INFO - Installing pip2-script.py script to C:\slave\test\build\venv\Scripts
15:31:32 INFO - Installing pip2.exe script to C:\slave\test\build\venv\Scripts
15:31:32 INFO - Successfully installed pip
15:31:32 INFO - Cleaning up...
15:31:32 INFO - Return code: 0
15:31:32 INFO - Installing psutil>=3.1.1 into virtualenv C:\slave\test\build/venv
15:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
15:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
15:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
15:31:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
15:31:32 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x0224C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022F3E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02404FB8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x006F8BF0>, '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 0x0071A9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027D05C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-014', 'USERDOMAIN': 'T-W864-IX-014', '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-014', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-014\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-014', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-014', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-014', '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-014\\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
15:31:32 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in C:\slave\test\build
15:31:32 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1
15:31:32 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
15:31:32 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-014\\AppData\\Roaming',
15:31:32 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
15:31:32 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
15:31:32 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
15:31:32 INFO - 'COMPUTERNAME': 'T-W864-IX-014',
15:31:32 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
15:31:32 INFO - 'DCLOCATION': 'SCL3',
15:31:32 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
15:31:32 INFO - 'FP_NO_HOST_CHECK': 'NO',
15:31:32 INFO - 'HOMEDRIVE': 'C:',
15:31:32 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-014',
15:31:32 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
15:31:32 INFO - 'KTS_VERSION': '1.19c',
15:31:32 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-014\\AppData\\Local',
15:31:32 INFO - 'LOGONSERVER': '\\\\T-W864-IX-014',
15:31:32 INFO - 'MONDIR': 'C:\\Monitor_config\\',
15:31:32 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
15:31:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
15:31:32 INFO - 'MOZ_NO_REMOTE': '1',
15:31:32 INFO - 'NO_EM_RESTART': '1',
15:31:32 INFO - 'NUMBER_OF_PROCESSORS': '8',
15:31:32 INFO - 'OS': 'Windows_NT',
15:31:32 INFO - 'OURDRIVE': 'C:',
15:31:32 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
15:31:32 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
15:31:32 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
15:31:32 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
15:31:32 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
15:31:32 INFO - 'PROCESSOR_LEVEL': '6',
15:31:32 INFO - 'PROCESSOR_REVISION': '1e05',
15:31:32 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
15:31:32 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
15:31:32 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
15:31:32 INFO - 'PROGRAMW6432': 'C:\\Program Files',
15:31:32 INFO - 'PROMPT': '$P$G',
15:31:32 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
15:31:32 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
15:31:32 INFO - 'PUBLIC': 'C:\\Users\\Public',
15:31:32 INFO - 'PWD': 'C:\\slave\\test',
15:31:32 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
15:31:32 INFO - 'SLAVEDIR': 'C:\\slave\\',
15:31:32 INFO - 'SYSTEMDRIVE': 'C:',
15:31:32 INFO - 'SYSTEMROOT': 'C:\\windows',
15:31:32 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
15:31:32 INFO - 'TEST1': 'testie',
15:31:32 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
15:31:32 INFO - 'USERDOMAIN': 'T-W864-IX-014',
15:31:32 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-014',
15:31:32 INFO - 'USERNAME': 'cltbld',
15:31:32 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-014',
15:31:32 INFO - 'WINDIR': 'C:\\windows',
15:31:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
15:31:34 INFO - Ignoring indexes: https://pypi.python.org/simple/
15:31:34 INFO - Downloading/unpacking psutil>=3.1.1
15:31:34 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
15:31:34 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
15:31:35 INFO - Installing collected packages: psutil
15:31:35 INFO - Successfully installed psutil
15:31:35 INFO - Cleaning up...
15:31:36 INFO - Return code: 0
15:31:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv C:\slave\test\build/venv
15:31: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')]}
15:31:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
15:31: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')]}
15:31:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
15:31:36 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0224C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022F3E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02404FB8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x006F8BF0>, '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 0x0071A9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027D05C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-014', 'USERDOMAIN': 'T-W864-IX-014', '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-014', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-014\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-014', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-014', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-014', '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-014\\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
15:31:36 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in C:\slave\test\build
15:31:36 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3
15:31:36 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
15:31:36 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-014\\AppData\\Roaming',
15:31:36 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
15:31:36 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
15:31:36 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
15:31:36 INFO - 'COMPUTERNAME': 'T-W864-IX-014',
15:31:36 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
15:31:36 INFO - 'DCLOCATION': 'SCL3',
15:31:36 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
15:31:36 INFO - 'FP_NO_HOST_CHECK': 'NO',
15:31:36 INFO - 'HOMEDRIVE': 'C:',
15:31:36 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-014',
15:31:36 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
15:31:36 INFO - 'KTS_VERSION': '1.19c',
15:31:36 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-014\\AppData\\Local',
15:31:36 INFO - 'LOGONSERVER': '\\\\T-W864-IX-014',
15:31:36 INFO - 'MONDIR': 'C:\\Monitor_config\\',
15:31:36 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
15:31:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
15:31:36 INFO - 'MOZ_NO_REMOTE': '1',
15:31:36 INFO - 'NO_EM_RESTART': '1',
15:31:36 INFO - 'NUMBER_OF_PROCESSORS': '8',
15:31:36 INFO - 'OS': 'Windows_NT',
15:31:36 INFO - 'OURDRIVE': 'C:',
15:31:36 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
15:31:36 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
15:31:36 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
15:31:36 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
15:31:36 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
15:31:36 INFO - 'PROCESSOR_LEVEL': '6',
15:31:36 INFO - 'PROCESSOR_REVISION': '1e05',
15:31:36 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
15:31:36 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
15:31:36 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
15:31:36 INFO - 'PROGRAMW6432': 'C:\\Program Files',
15:31:36 INFO - 'PROMPT': '$P$G',
15:31:36 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
15:31:36 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
15:31:36 INFO - 'PUBLIC': 'C:\\Users\\Public',
15:31:36 INFO - 'PWD': 'C:\\slave\\test',
15:31:36 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
15:31:36 INFO - 'SLAVEDIR': 'C:\\slave\\',
15:31:36 INFO - 'SYSTEMDRIVE': 'C:',
15:31:36 INFO - 'SYSTEMROOT': 'C:\\windows',
15:31:36 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
15:31:36 INFO - 'TEST1': 'testie',
15:31:36 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
15:31:36 INFO - 'USERDOMAIN': 'T-W864-IX-014',
15:31:36 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-014',
15:31:36 INFO - 'USERNAME': 'cltbld',
15:31:36 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-014',
15:31:36 INFO - 'WINDIR': 'C:\\windows',
15:31:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
15:31:36 INFO - Ignoring indexes: https://pypi.python.org/simple/
15:31:36 INFO - Downloading/unpacking mozsystemmonitor==0.3
15:31:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
15:31:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
15:31:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz
15:31:37 INFO - Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor
15:31:37 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)
15:31:37 INFO - Installing collected packages: mozsystemmonitor
15:31:37 INFO - Running setup.py install for mozsystemmonitor
15:31:37 INFO - Successfully installed mozsystemmonitor
15:31:37 INFO - Cleaning up...
15:31:38 INFO - Return code: 0
15:31:38 INFO - Installing jsonschema==2.5.1 into virtualenv C:\slave\test\build/venv
15:31:38 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')]}
15:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
15:31:38 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')]}
15:31:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
15:31:38 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 0x0224C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022F3E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02404FB8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x006F8BF0>, '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 0x0071A9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027D05C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-014', 'USERDOMAIN': 'T-W864-IX-014', '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-014', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-014\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-014', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-014', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-014', '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-014\\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
15:31:38 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in C:\slave\test\build
15:31:38 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1
15:31:38 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
15:31:38 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-014\\AppData\\Roaming',
15:31:38 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
15:31:38 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
15:31:38 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
15:31:38 INFO - 'COMPUTERNAME': 'T-W864-IX-014',
15:31:38 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
15:31:38 INFO - 'DCLOCATION': 'SCL3',
15:31:38 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
15:31:38 INFO - 'FP_NO_HOST_CHECK': 'NO',
15:31:38 INFO - 'HOMEDRIVE': 'C:',
15:31:38 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-014',
15:31:38 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
15:31:38 INFO - 'KTS_VERSION': '1.19c',
15:31:38 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-014\\AppData\\Local',
15:31:38 INFO - 'LOGONSERVER': '\\\\T-W864-IX-014',
15:31:38 INFO - 'MONDIR': 'C:\\Monitor_config\\',
15:31:38 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
15:31:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
15:31:38 INFO - 'MOZ_NO_REMOTE': '1',
15:31:38 INFO - 'NO_EM_RESTART': '1',
15:31:38 INFO - 'NUMBER_OF_PROCESSORS': '8',
15:31:38 INFO - 'OS': 'Windows_NT',
15:31:38 INFO - 'OURDRIVE': 'C:',
15:31:38 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
15:31:38 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
15:31:38 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
15:31:38 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
15:31:38 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
15:31:38 INFO - 'PROCESSOR_LEVEL': '6',
15:31:38 INFO - 'PROCESSOR_REVISION': '1e05',
15:31:38 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
15:31:38 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
15:31:38 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
15:31:38 INFO - 'PROGRAMW6432': 'C:\\Program Files',
15:31:38 INFO - 'PROMPT': '$P$G',
15:31:38 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
15:31:38 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
15:31:38 INFO - 'PUBLIC': 'C:\\Users\\Public',
15:31:38 INFO - 'PWD': 'C:\\slave\\test',
15:31:38 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
15:31:38 INFO - 'SLAVEDIR': 'C:\\slave\\',
15:31:38 INFO - 'SYSTEMDRIVE': 'C:',
15:31:38 INFO - 'SYSTEMROOT': 'C:\\windows',
15:31:38 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
15:31:38 INFO - 'TEST1': 'testie',
15:31:38 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
15:31:38 INFO - 'USERDOMAIN': 'T-W864-IX-014',
15:31:38 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-014',
15:31:38 INFO - 'USERNAME': 'cltbld',
15:31:38 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-014',
15:31:38 INFO - 'WINDIR': 'C:\\windows',
15:31:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
15:31:38 INFO - Ignoring indexes: https://pypi.python.org/simple/
15:31:38 INFO - Downloading/unpacking jsonschema==2.5.1
15:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
15:31:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
15:31:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl
15:31:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1)
15:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
15:31:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
15:31:39 INFO - Downloading functools32-3.2.3-2.tar.gz
15:31:39 INFO - Running setup.py (path:C:\slave\test\build\venv\build\functools32\setup.py) egg_info for package functools32
15:31:39 INFO - warning: no files found matching '*.txt'
15:31:39 INFO - no previously-included directories found matching 'build'
15:31:39 INFO - no previously-included directories found matching 'dist'
15:31:39 INFO - no previously-included directories found matching '.git*'
15:31:39 INFO - Installing collected packages: jsonschema, functools32
15:31:39 INFO - Running setup.py install for functools32
15:31:39 INFO - warning: no files found matching '*.txt'
15:31:39 INFO - no previously-included directories found matching 'build'
15:31:39 INFO - no previously-included directories found matching 'dist'
15:31:39 INFO - no previously-included directories found matching '.git*'
15:31:39 INFO - Successfully installed jsonschema functools32
15:31:39 INFO - Cleaning up...
15:31:40 INFO - Return code: 0
15:31:40 INFO - Installing functools32==3.2.3-2 into virtualenv C:\slave\test\build/venv
15:31:40 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')]}
15:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
15:31:40 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')]}
15:31:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
15:31:40 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 0x0224C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022F3E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02404FB8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x006F8BF0>, '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 0x0071A9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027D05C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-014', 'USERDOMAIN': 'T-W864-IX-014', '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-014', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-014\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-014', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-014', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-014', '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-014\\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
15:31:40 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
15:31:40 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
15:31:40 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
15:31:40 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-014\\AppData\\Roaming',
15:31:40 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
15:31:40 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
15:31:40 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
15:31:40 INFO - 'COMPUTERNAME': 'T-W864-IX-014',
15:31:40 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
15:31:40 INFO - 'DCLOCATION': 'SCL3',
15:31:40 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
15:31:40 INFO - 'FP_NO_HOST_CHECK': 'NO',
15:31:40 INFO - 'HOMEDRIVE': 'C:',
15:31:40 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-014',
15:31:40 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
15:31:40 INFO - 'KTS_VERSION': '1.19c',
15:31:40 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-014\\AppData\\Local',
15:31:40 INFO - 'LOGONSERVER': '\\\\T-W864-IX-014',
15:31:40 INFO - 'MONDIR': 'C:\\Monitor_config\\',
15:31:40 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
15:31:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
15:31:40 INFO - 'MOZ_NO_REMOTE': '1',
15:31:40 INFO - 'NO_EM_RESTART': '1',
15:31:40 INFO - 'NUMBER_OF_PROCESSORS': '8',
15:31:40 INFO - 'OS': 'Windows_NT',
15:31:40 INFO - 'OURDRIVE': 'C:',
15:31:40 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',
15:31:40 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
15:31:40 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
15:31:40 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
15:31:40 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
15:31:40 INFO - 'PROCESSOR_LEVEL': '6',
15:31:40 INFO - 'PROCESSOR_REVISION': '1e05',
15:31:40 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
15:31:40 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
15:31:40 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
15:31:40 INFO - 'PROGRAMW6432': 'C:\\Program Files',
15:31:40 INFO - 'PROMPT': '$P$G',
15:31:40 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
15:31:40 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
15:31:40 INFO - 'PUBLIC': 'C:\\Users\\Public',
15:31:40 INFO - 'PWD': 'C:\\slave\\test',
15:31:40 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
15:31:40 INFO - 'SLAVEDIR': 'C:\\slave\\',
15:31:40 INFO - 'SYSTEMDRIVE': 'C:',
15:31:40 INFO - 'SYSTEMROOT': 'C:\\windows',
15:31:40 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
15:31:40 INFO - 'TEST1': 'testie',
15:31:40 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
15:31:40 INFO - 'USERDOMAIN': 'T-W864-IX-014',
15:31:40 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-014',
15:31:40 INFO - 'USERNAME': 'cltbld',
15:31:40 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-014',
15:31:40 INFO - 'WINDIR': 'C:\\windows',
15:31:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
15:31:40 INFO - Ignoring indexes: https://pypi.python.org/simple/
15:31:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in c:\slave\test\build\venv\lib\site-packages
15:31:40 INFO - Cleaning up...
15:31:40 INFO - Return code: 0
15:31:40 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv
15:31:40 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')]}
15:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
15:31:40 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')]}
15:31:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
15:31:40 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 0x0224C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022F3E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02404FB8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x006F8BF0>, '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 0x0071A9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027D05C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-014', 'USERDOMAIN': 'T-W864-IX-014', '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-014', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-014\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-014', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-014', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-014', '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-014\\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
15:31:40 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
15:31:40 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
15:31:40 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
15:31:40 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-014\\AppData\\Roaming',
15:31:40 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
15:31:40 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
15:31:40 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
15:31:40 INFO - 'COMPUTERNAME': 'T-W864-IX-014',
15:31:40 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
15:31:40 INFO - 'DCLOCATION': 'SCL3',
15:31:40 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
15:31:40 INFO - 'FP_NO_HOST_CHECK': 'NO',
15:31:40 INFO - 'HOMEDRIVE': 'C:',
15:31:40 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-014',
15:31:40 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
15:31:40 INFO - 'KTS_VERSION': '1.19c',
15:31:40 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-014\\AppData\\Local',
15:31:40 INFO - 'LOGONSERVER': '\\\\T-W864-IX-014',
15:31:40 INFO - 'MONDIR': 'C:\\Monitor_config\\',
15:31:40 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
15:31:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
15:31:40 INFO - 'MOZ_NO_REMOTE': '1',
15:31:40 INFO - 'NO_EM_RESTART': '1',
15:31:40 INFO - 'NUMBER_OF_PROCESSORS': '8',
15:31:40 INFO - 'OS': 'Windows_NT',
15:31:40 INFO - 'OURDRIVE': 'C:',
15:31:40 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',
15:31:40 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
15:31:40 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
15:31:40 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
15:31:40 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
15:31:40 INFO - 'PROCESSOR_LEVEL': '6',
15:31:40 INFO - 'PROCESSOR_REVISION': '1e05',
15:31:40 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
15:31:40 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
15:31:40 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
15:31:40 INFO - 'PROGRAMW6432': 'C:\\Program Files',
15:31:40 INFO - 'PROMPT': '$P$G',
15:31:40 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
15:31:40 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
15:31:40 INFO - 'PUBLIC': 'C:\\Users\\Public',
15:31:40 INFO - 'PWD': 'C:\\slave\\test',
15:31:40 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
15:31:40 INFO - 'SLAVEDIR': 'C:\\slave\\',
15:31:40 INFO - 'SYSTEMDRIVE': 'C:',
15:31:40 INFO - 'SYSTEMROOT': 'C:\\windows',
15:31:40 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
15:31:40 INFO - 'TEST1': 'testie',
15:31:40 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
15:31:40 INFO - 'USERDOMAIN': 'T-W864-IX-014',
15:31:40 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-014',
15:31:40 INFO - 'USERNAME': 'cltbld',
15:31:40 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-014',
15:31:40 INFO - 'WINDIR': 'C:\\windows',
15:31:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
15:31:41 INFO - Ignoring indexes: https://pypi.python.org/simple/
15:31:41 INFO - Downloading/unpacking blobuploader==1.2.4
15:31:41 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
15:31:41 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
15:31:42 INFO - Downloading blobuploader-1.2.4.tar.gz
15:31:42 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader
15:31:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4)
15:31:42 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
15:31:42 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
15:31:42 INFO - Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests
15:31:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4)
15:31:42 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
15:31:42 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
15:31:42 INFO - Downloading docopt-0.6.1.tar.gz
15:31:42 INFO - Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt
15:31:42 INFO - Installing collected packages: blobuploader, requests, docopt
15:31:42 INFO - Running setup.py install for blobuploader
15:31:43 INFO - Running setup.py install for requests
15:31:43 INFO - Running setup.py install for docopt
15:31:43 INFO - Successfully installed blobuploader requests docopt
15:31:43 INFO - Cleaning up...
15:31:44 INFO - Return code: 0
15:31:44 INFO - Installing None into virtualenv C:\slave\test\build/venv
15:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
15:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
15:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
15:31:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
15:31:44 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 0x0224C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022F3E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02404FB8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x006F8BF0>, '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 0x0071A9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027D05C0>, '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-014', 'USERDOMAIN': 'T-W864-IX-014', '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-014', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-014\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-014', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-014', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-014', '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-014\\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
15:31:45 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
15:31:45 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
15:31:45 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
15:31:45 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-014\\AppData\\Roaming',
15:31:45 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
15:31:45 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
15:31:45 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
15:31:45 INFO - 'COMPUTERNAME': 'T-W864-IX-014',
15:31:45 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
15:31:45 INFO - 'DCLOCATION': 'SCL3',
15:31:45 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
15:31:45 INFO - 'FP_NO_HOST_CHECK': 'NO',
15:31:45 INFO - 'HOMEDRIVE': 'C:',
15:31:45 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-014',
15:31:45 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
15:31:45 INFO - 'KTS_VERSION': '1.19c',
15:31:45 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-014\\AppData\\Local',
15:31:45 INFO - 'LOGONSERVER': '\\\\T-W864-IX-014',
15:31:45 INFO - 'MONDIR': 'C:\\Monitor_config\\',
15:31:45 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
15:31:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
15:31:45 INFO - 'MOZ_NO_REMOTE': '1',
15:31:45 INFO - 'NO_EM_RESTART': '1',
15:31:45 INFO - 'NUMBER_OF_PROCESSORS': '8',
15:31:45 INFO - 'OS': 'Windows_NT',
15:31:45 INFO - 'OURDRIVE': 'C:',
15:31:45 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',
15:31:45 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
15:31:45 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
15:31:45 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
15:31:45 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
15:31:45 INFO - 'PROCESSOR_LEVEL': '6',
15:31:45 INFO - 'PROCESSOR_REVISION': '1e05',
15:31:45 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
15:31:45 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
15:31:45 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
15:31:45 INFO - 'PROGRAMW6432': 'C:\\Program Files',
15:31:45 INFO - 'PROMPT': '$P$G',
15:31:45 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
15:31:45 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
15:31:45 INFO - 'PUBLIC': 'C:\\Users\\Public',
15:31:45 INFO - 'PWD': 'C:\\slave\\test',
15:31:45 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
15:31:45 INFO - 'SLAVEDIR': 'C:\\slave\\',
15:31:45 INFO - 'SYSTEMDRIVE': 'C:',
15:31:45 INFO - 'SYSTEMROOT': 'C:\\windows',
15:31:45 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
15:31:45 INFO - 'TEST1': 'testie',
15:31:45 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
15:31:45 INFO - 'USERDOMAIN': 'T-W864-IX-014',
15:31:45 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-014',
15:31:45 INFO - 'USERNAME': 'cltbld',
15:31:45 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-014',
15:31:45 INFO - 'WINDIR': 'C:\\windows',
15:31:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
15:31:45 INFO - Ignoring indexes: https://pypi.python.org/simple/
15:31:45 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser
15:31:45 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-k6qpkp-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser
15:31:45 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash
15:31:45 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-dthmsb-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash
15:31:45 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug
15:31:45 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-mruihb-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug
15:31:45 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice
15:31:45 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-j6r_xs-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice
15:31:45 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile
15:31:45 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-_dgvnb-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile
15:31:45 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd
15:31:45 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-f4ozer-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd
15:31:45 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo
15:31:45 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-o41uqd-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo
15:31:46 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall
15:31:46 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-4axlf7-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall
15:31:46 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak
15:31:46 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-_bowno-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak
15:31:46 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog
15:31:46 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-8fotzt-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog
15:31:46 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork
15:31:46 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qoiwry-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork
15:31:46 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess
15:31:46 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-fpfd84-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess
15:31:46 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile
15:31:46 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-hh41pu-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile
15:31:46 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner
15:31:46 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ggcuw4-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner
15:31:46 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot
15:31:46 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-t09tbs-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot
15:31:47 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest
15:31:47 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-3wvqcw-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest
15:31:47 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion
15:31:47 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jr2rgn-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion
15:31:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion
15:31:47 INFO - Running setup.py install for manifestparser
15:31:47 INFO - Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts
15:31:47 INFO - Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts
15:31:48 INFO - Running setup.py install for mozcrash
15:31:48 INFO - Running setup.py install for mozdebug
15:31:48 INFO - Running setup.py install for mozdevice
15:31:48 INFO - Installing sutini-script.py script to C:\slave\test\build\venv\Scripts
15:31:48 INFO - Installing sutini.exe script to C:\slave\test\build\venv\Scripts
15:31:48 INFO - Installing dm-script.py script to C:\slave\test\build\venv\Scripts
15:31:48 INFO - Installing dm.exe script to C:\slave\test\build\venv\Scripts
15:31:49 INFO - Running setup.py install for mozfile
15:31:49 INFO - Running setup.py install for mozhttpd
15:31:50 INFO - Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts
15:31:50 INFO - Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts
15:31:50 INFO - Running setup.py install for mozinfo
15:31:50 INFO - Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts
15:31:50 INFO - Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts
15:31:50 INFO - Running setup.py install for mozInstall
15:31:50 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts
15:31:50 INFO - Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts
15:31:50 INFO - Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts
15:31:50 INFO - Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts
15:31:50 INFO - Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts
15:31:50 INFO - Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts
15:31:50 INFO - Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts
15:31:50 INFO - Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts
15:31:51 INFO - Running setup.py install for mozleak
15:31:51 INFO - Running setup.py install for mozlog
15:31:51 INFO - Installing structlog-script.py script to C:\slave\test\build\venv\Scripts
15:31:51 INFO - Installing structlog.exe script to C:\slave\test\build\venv\Scripts
15:31:52 INFO - Running setup.py install for moznetwork
15:31:52 INFO - Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts
15:31:52 INFO - Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts
15:31:52 INFO - Running setup.py install for mozprocess
15:31:53 INFO - Running setup.py install for mozprofile
15:31:53 INFO - Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts
15:31:53 INFO - Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts
15:31:53 INFO - Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts
15:31:53 INFO - Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts
15:31:53 INFO - Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts
15:31:53 INFO - Installing view-profile.exe script to C:\slave\test\build\venv\Scripts
15:31:53 INFO - Running setup.py install for mozrunner
15:31:54 INFO - Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts
15:31:54 INFO - Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts
15:31:54 INFO - Running setup.py install for mozscreenshot
15:31:54 INFO - Running setup.py install for moztest
15:31:55 INFO - Running setup.py install for mozversion
15:31:55 INFO - Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts
15:31:55 INFO - Installing mozversion.exe script to C:\slave\test\build\venv\Scripts
15:31:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion
15:31:55 INFO - Cleaning up...
15:31:55 INFO - Return code: 0
15:31:55 INFO - Installing None into virtualenv C:\slave\test\build/venv
15:31:55 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')]}
15:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
15:31:55 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')]}
15:31:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
15:31:55 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 0x0224C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022F3E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02404FB8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x006F8BF0>, '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 0x0071A9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027D05C0>, '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-014', 'USERDOMAIN': 'T-W864-IX-014', '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-014', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-014\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-014', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-014', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-014', '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-014\\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
15:31:55 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
15:31:55 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
15:31:55 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
15:31:55 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-014\\AppData\\Roaming',
15:31:55 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
15:31:55 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
15:31:55 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
15:31:55 INFO - 'COMPUTERNAME': 'T-W864-IX-014',
15:31:55 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
15:31:55 INFO - 'DCLOCATION': 'SCL3',
15:31:55 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
15:31:55 INFO - 'FP_NO_HOST_CHECK': 'NO',
15:31:55 INFO - 'HOMEDRIVE': 'C:',
15:31:55 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-014',
15:31:55 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
15:31:55 INFO - 'KTS_VERSION': '1.19c',
15:31:55 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-014\\AppData\\Local',
15:31:55 INFO - 'LOGONSERVER': '\\\\T-W864-IX-014',
15:31:55 INFO - 'MONDIR': 'C:\\Monitor_config\\',
15:31:55 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
15:31:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
15:31:55 INFO - 'MOZ_NO_REMOTE': '1',
15:31:55 INFO - 'NO_EM_RESTART': '1',
15:31:55 INFO - 'NUMBER_OF_PROCESSORS': '8',
15:31:55 INFO - 'OS': 'Windows_NT',
15:31:55 INFO - 'OURDRIVE': 'C:',
15:31: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',
15:31:55 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
15:31:55 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
15:31:55 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
15:31:55 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
15:31:55 INFO - 'PROCESSOR_LEVEL': '6',
15:31:55 INFO - 'PROCESSOR_REVISION': '1e05',
15:31:55 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
15:31:55 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
15:31:55 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
15:31:55 INFO - 'PROGRAMW6432': 'C:\\Program Files',
15:31:55 INFO - 'PROMPT': '$P$G',
15:31:55 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
15:31:55 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
15:31:55 INFO - 'PUBLIC': 'C:\\Users\\Public',
15:31:55 INFO - 'PWD': 'C:\\slave\\test',
15:31:55 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
15:31:55 INFO - 'SLAVEDIR': 'C:\\slave\\',
15:31:55 INFO - 'SYSTEMDRIVE': 'C:',
15:31:55 INFO - 'SYSTEMROOT': 'C:\\windows',
15:31:55 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
15:31:55 INFO - 'TEST1': 'testie',
15:31:55 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
15:31:55 INFO - 'USERDOMAIN': 'T-W864-IX-014',
15:31:55 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-014',
15:31:55 INFO - 'USERNAME': 'cltbld',
15:31:55 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-014',
15:31:55 INFO - 'WINDIR': 'C:\\windows',
15:31:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
15:31:55 INFO - Ignoring indexes: https://pypi.python.org/simple/
15:31:55 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser
15:31:56 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ukmaky-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser
15:31:56 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))
15:31:56 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash
15:31:56 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-x9tslz-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash
15:31:56 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))
15:31:56 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug
15:31:56 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-207kd0-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug
15:31:56 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))
15:31:56 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice
15:31:56 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-3ukmyi-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice
15:31:56 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))
15:31:56 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile
15:31:56 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-gys5xh-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile
15:31:56 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))
15:31:56 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd
15:31:56 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-vw2ftu-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd
15:31:56 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))
15:31:56 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo
15:31:56 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-g87mme-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo
15:31:56 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))
15:31:56 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall
15:31:56 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-bdzgr1-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall
15:31:56 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))
15:31:56 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak
15:31:56 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-cpbau8-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak
15:31:57 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))
15:31:57 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog
15:31:57 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-kxmwco-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog
15:31:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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))
15:31:57 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork
15:31:57 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-avably-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork
15:31:57 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))
15:31:57 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess
15:31:57 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xfloox-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess
15:31:57 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))
15:31:57 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile
15:31:57 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-4l41c3-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile
15:31:57 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))
15:31:57 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner
15:31:57 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xibrkp-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner
15:31:57 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))
15:31:57 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot
15:31:57 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jjacab-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot
15:31:57 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))
15:31:57 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest
15:31:57 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ff2gz1-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest
15:31:57 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))
15:31:57 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion
15:31:57 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-zqb2zh-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion
15:31:58 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))
15:31:58 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))
15:31:58 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))
15:31:58 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))
15:31:58 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))
15:31:58 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))
15:31:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10))
15:31: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
15:31: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
15:31:59 INFO - Downloading blessings-1.6.tar.gz
15:31:59 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings
15:31:59 INFO - Installing collected packages: blessings
15:31:59 INFO - Running setup.py install for blessings
15:31:59 INFO - Successfully installed blessings
15:31:59 INFO - Cleaning up...
15:32:02 INFO - Return code: 0
15:32:02 INFO - Done creating virtualenv C:\slave\test\build/venv.
15:32:02 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze']
15:32:02 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze
15:32:02 INFO - Reading from file tmpfile_stdout
15:32:02 INFO - Using _rmtree_windows ...
15:32:02 INFO - Using _rmtree_windows ...
15:32:02 INFO - Current package versions:
15:32:02 INFO - blessings == 1.6
15:32:02 INFO - blobuploader == 1.2.4
15:32:02 INFO - docopt == 0.6.1
15:32:02 INFO - functools32 == 3.2.3-2
15:32:02 INFO - jsonschema == 2.5.1
15:32:02 INFO - manifestparser == 1.1
15:32:02 INFO - mozInstall == 1.12
15:32:02 INFO - mozcrash == 0.17
15:32:02 INFO - mozdebug == 0.1
15:32:02 INFO - mozdevice == 0.48
15:32:02 INFO - mozfile == 1.2
15:32:02 INFO - mozhttpd == 0.7
15:32:02 INFO - mozinfo == 0.9
15:32:02 INFO - mozleak == 0.1
15:32:02 INFO - mozlog == 3.3
15:32:02 INFO - moznetwork == 0.27
15:32:02 INFO - mozprocess == 0.23
15:32:02 INFO - mozprofile == 0.28
15:32:02 INFO - mozrunner == 6.12
15:32:02 INFO - mozscreenshot == 0.1
15:32:02 INFO - mozsystemmonitor == 0.3
15:32:02 INFO - moztest == 0.7
15:32:02 INFO - mozversion == 1.4
15:32:02 INFO - psutil == 3.1.1
15:32:02 INFO - requests == 1.2.3
15:32:02 INFO - Installing None into virtualenv C:\slave\test\build/venv
15:32: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')]}
15:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
15:32: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')]}
15:32:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
15:32:02 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 0x0224C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022F3E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02404FB8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x006F8BF0>, '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 0x0071A9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027D05C0>, '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-014', 'USERDOMAIN': 'T-W864-IX-014', '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-014', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-014\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-014', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-014', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-014', '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-014\\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
15:32:02 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
15:32:02 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
15:32:02 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
15:32:02 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-014\\AppData\\Roaming',
15:32:02 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
15:32:02 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
15:32:02 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
15:32:02 INFO - 'COMPUTERNAME': 'T-W864-IX-014',
15:32:02 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
15:32:02 INFO - 'DCLOCATION': 'SCL3',
15:32:02 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
15:32:02 INFO - 'FP_NO_HOST_CHECK': 'NO',
15:32:02 INFO - 'HOMEDRIVE': 'C:',
15:32:02 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-014',
15:32:02 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
15:32:02 INFO - 'KTS_VERSION': '1.19c',
15:32:02 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-014\\AppData\\Local',
15:32:02 INFO - 'LOGONSERVER': '\\\\T-W864-IX-014',
15:32:02 INFO - 'MONDIR': 'C:\\Monitor_config\\',
15:32:02 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
15:32:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
15:32:02 INFO - 'MOZ_NO_REMOTE': '1',
15:32:02 INFO - 'NO_EM_RESTART': '1',
15:32:02 INFO - 'NUMBER_OF_PROCESSORS': '8',
15:32:02 INFO - 'OS': 'Windows_NT',
15:32:02 INFO - 'OURDRIVE': 'C:',
15:32: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',
15:32:02 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
15:32:02 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
15:32:02 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
15:32:02 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
15:32:02 INFO - 'PROCESSOR_LEVEL': '6',
15:32:02 INFO - 'PROCESSOR_REVISION': '1e05',
15:32:02 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
15:32:02 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
15:32:02 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
15:32:02 INFO - 'PROGRAMW6432': 'C:\\Program Files',
15:32:02 INFO - 'PROMPT': '$P$G',
15:32:02 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
15:32:02 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
15:32:02 INFO - 'PUBLIC': 'C:\\Users\\Public',
15:32:02 INFO - 'PWD': 'C:\\slave\\test',
15:32:02 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
15:32:02 INFO - 'SLAVEDIR': 'C:\\slave\\',
15:32:02 INFO - 'SYSTEMDRIVE': 'C:',
15:32:02 INFO - 'SYSTEMROOT': 'C:\\windows',
15:32:02 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
15:32:02 INFO - 'TEST1': 'testie',
15:32:02 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
15:32:02 INFO - 'USERDOMAIN': 'T-W864-IX-014',
15:32:02 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-014',
15:32:02 INFO - 'USERNAME': 'cltbld',
15:32:02 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-014',
15:32:02 INFO - 'WINDIR': 'C:\\windows',
15:32:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
15:32:03 INFO - Ignoring indexes: https://pypi.python.org/simple/
15:32:03 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))
15:32:03 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))
15:32:03 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))
15:32:03 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))
15:32:03 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))
15:32:03 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))
15:32:03 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))
15:32:03 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))
15:32:03 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))
15:32:03 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))
15:32:03 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))
15:32:03 INFO - Cleaning up...
15:32:03 INFO - Return code: 0
15:32:03 INFO - Installing jsonschema into virtualenv C:\slave\test\build/venv
15:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
15:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
15:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
15:32:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
15:32:03 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 0x0224C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022F3E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02404FB8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x006F8BF0>, '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 0x0071A9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027D05C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-014', 'USERDOMAIN': 'T-W864-IX-014', '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-014', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-014\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-014', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-014', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-014', '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-014\\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
15:32:03 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
15:32:03 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
15:32:03 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
15:32:03 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-014\\AppData\\Roaming',
15:32:03 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
15:32:03 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
15:32:03 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
15:32:03 INFO - 'COMPUTERNAME': 'T-W864-IX-014',
15:32:03 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
15:32:03 INFO - 'DCLOCATION': 'SCL3',
15:32:03 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
15:32:03 INFO - 'FP_NO_HOST_CHECK': 'NO',
15:32:03 INFO - 'HOMEDRIVE': 'C:',
15:32:03 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-014',
15:32:03 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
15:32:03 INFO - 'KTS_VERSION': '1.19c',
15:32:03 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-014\\AppData\\Local',
15:32:03 INFO - 'LOGONSERVER': '\\\\T-W864-IX-014',
15:32:03 INFO - 'MONDIR': 'C:\\Monitor_config\\',
15:32:03 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
15:32:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
15:32:03 INFO - 'MOZ_NO_REMOTE': '1',
15:32:03 INFO - 'NO_EM_RESTART': '1',
15:32:03 INFO - 'NUMBER_OF_PROCESSORS': '8',
15:32:03 INFO - 'OS': 'Windows_NT',
15:32:03 INFO - 'OURDRIVE': 'C:',
15:32:03 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
15:32:03 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
15:32:03 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
15:32:03 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
15:32:03 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
15:32:03 INFO - 'PROCESSOR_LEVEL': '6',
15:32:03 INFO - 'PROCESSOR_REVISION': '1e05',
15:32:03 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
15:32:03 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
15:32:03 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
15:32:03 INFO - 'PROGRAMW6432': 'C:\\Program Files',
15:32:03 INFO - 'PROMPT': '$P$G',
15:32:03 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
15:32:03 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
15:32:03 INFO - 'PUBLIC': 'C:\\Users\\Public',
15:32:03 INFO - 'PWD': 'C:\\slave\\test',
15:32:03 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
15:32:03 INFO - 'SLAVEDIR': 'C:\\slave\\',
15:32:03 INFO - 'SYSTEMDRIVE': 'C:',
15:32:03 INFO - 'SYSTEMROOT': 'C:\\windows',
15:32:03 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
15:32:03 INFO - 'TEST1': 'testie',
15:32:03 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
15:32:03 INFO - 'USERDOMAIN': 'T-W864-IX-014',
15:32:03 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-014',
15:32:03 INFO - 'USERNAME': 'cltbld',
15:32:03 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-014',
15:32:03 INFO - 'WINDIR': 'C:\\windows',
15:32:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
15:32:03 INFO - Ignoring indexes: https://pypi.python.org/simple/
15:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in c:\slave\test\build\venv\lib\site-packages
15:32:03 INFO - Cleaning up...
15:32:03 INFO - Return code: 0
15:32:03 INFO - Running post-action listener: _resource_record_post_action
15:32:03 INFO - Running post-action listener: _start_resource_monitoring
15:32:03 INFO - Starting resource monitoring.
15:32:03 INFO - [mozharness: 2016-08-21 22:32:03.592000Z] Finished create-virtualenv step (success)
15:32:03 INFO - [mozharness: 2016-08-21 22:32:03.592000Z] Running install step.
15:32:03 INFO - Running pre-action listener: _resource_record_pre_action
15:32:03 INFO - Running main action method: install
15:32:03 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze']
15:32:03 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze
15:32:03 INFO - Reading from file tmpfile_stdout
15:32:03 INFO - Using _rmtree_windows ...
15:32:03 INFO - Using _rmtree_windows ...
15:32:03 INFO - Detecting whether we're running mozinstall >=1.0...
15:32:03 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h']
15:32:03 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h
15:32:03 INFO - Reading from file tmpfile_stdout
15:32:03 INFO - Output received:
15:32:03 INFO - Usage: mozinstall-script.py [options] installer
15:32:03 INFO - Options:
15:32:03 INFO - -h, --help show this help message and exit
15:32:03 INFO - -d DEST, --destination=DEST
15:32:03 INFO - Directory to install application into. [default:
15:32:03 INFO - "C:\slave\test"]
15:32:03 INFO - --app=APP Application being installed. [default: firefox]
15:32:03 INFO - Using _rmtree_windows ...
15:32:03 INFO - Using _rmtree_windows ...
15:32:03 INFO - mkdir: C:\slave\test\build\application
15:32:03 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-51.0a1.en-US.win64.zip', '--destination', 'C:\\slave\\test\\build\\application']
15:32:03 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py C:\slave\test\build\firefox-51.0a1.en-US.win64.zip --destination C:\slave\test\build\application
ProcessManager NOT managing child processes
15:32:06 INFO - Reading from file tmpfile_stdout
15:32:06 INFO - Output received:
15:32:06 INFO - C:\slave\test\build\application\firefox\firefox.exe
15:32:06 INFO - Using _rmtree_windows ...
15:32:06 INFO - Using _rmtree_windows ...
15:32:06 INFO - Running post-action listener: _resource_record_post_action
15:32:06 INFO - [mozharness: 2016-08-21 22:32:06.083000Z] Finished install step (success)
15:32:06 INFO - [mozharness: 2016-08-21 22:32:06.083000Z] Running run-tests step.
15:32:06 INFO - Running pre-action listener: _resource_record_pre_action
15:32:06 INFO - Running main action method: run_tests
15:32:06 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version']
15:32:06 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version
15:32:06 INFO - Python 2.7.3
15:32:06 INFO - Return code: 0
15:32:06 INFO - grabbing minidump binary from tooltool
15:32: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')]}
15:32:06 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 0x006F8BF0>, '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 0x0071A9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027D05C0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1
15:32:06 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
15:32:06 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
15:32:06 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
15:32:06 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'...
15:32:06 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmp9qxmov
15:32:06 INFO - INFO - File integrity verified, renaming tmp9qxmov to win32-minidump_stackwalk.exe
15:32:06 INFO - Return code: 0
15:32:06 INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755
15:32:06 INFO - mkdir: C:\slave\test\build\blobber_upload_dir
15:32:06 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir
15:32:06 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe
15:32:06 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir
15:32:06 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BCJ1gsNrQ2yD9n8HeblaZw/artifacts/public/build/firefox-51.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-014', '--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
15:32:06 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\tests\talos\talos\run_tests.py --branchName Autoland --suite dromaeojs --executablePath C:\slave\test\build\application\firefox\firefox --symbolsPath https://queue.taskcluster.net/v1/task/BCJ1gsNrQ2yD9n8HeblaZw/artifacts/public/build/firefox-51.0a1.en-US.win64.crashreporter-symbols.zip --title T-W864-IX-014 --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
15:32:06 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
15:32:06 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-014\\AppData\\Roaming',
15:32:06 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
15:32:06 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
15:32:06 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
15:32:06 INFO - 'COMPUTERNAME': 'T-W864-IX-014',
15:32:06 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
15:32:06 INFO - 'DCLOCATION': 'SCL3',
15:32:06 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
15:32:06 INFO - 'FP_NO_HOST_CHECK': 'NO',
15:32:06 INFO - 'HOMEDRIVE': 'C:',
15:32:06 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-014',
15:32:06 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
15:32:06 INFO - 'KTS_VERSION': '1.19c',
15:32:06 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-014\\AppData\\Local',
15:32:06 INFO - 'LOGONSERVER': '\\\\T-W864-IX-014',
15:32:06 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir',
15:32:06 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe',
15:32:06 INFO - 'MONDIR': 'C:\\Monitor_config\\',
15:32:06 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
15:32:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
15:32:06 INFO - 'MOZ_NO_REMOTE': '1',
15:32:06 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir',
15:32:06 INFO - 'NO_EM_RESTART': '1',
15:32:06 INFO - 'NUMBER_OF_PROCESSORS': '8',
15:32:06 INFO - 'OS': 'Windows_NT',
15:32:06 INFO - 'OURDRIVE': 'C:',
15:32: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',
15:32:06 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
15:32:06 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
15:32:06 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
15:32:06 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
15:32:06 INFO - 'PROCESSOR_LEVEL': '6',
15:32:06 INFO - 'PROCESSOR_REVISION': '1e05',
15:32:06 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
15:32:06 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
15:32:06 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
15:32:06 INFO - 'PROGRAMW6432': 'C:\\Program Files',
15:32:06 INFO - 'PROMPT': '$P$G',
15:32:06 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
15:32:06 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
15:32:06 INFO - 'PUBLIC': 'C:\\Users\\Public',
15:32:06 INFO - 'PWD': 'C:\\slave\\test',
15:32:06 INFO - 'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos',
15:32:06 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
15:32:06 INFO - 'SLAVEDIR': 'C:\\slave\\',
15:32:06 INFO - 'SYSTEMDRIVE': 'C:',
15:32:06 INFO - 'SYSTEMROOT': 'C:\\windows',
15:32:06 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
15:32:06 INFO - 'TEST1': 'testie',
15:32:06 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
15:32:06 INFO - 'USERDOMAIN': 'T-W864-IX-014',
15:32:06 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-014',
15:32:06 INFO - 'USERNAME': 'cltbld',
15:32:06 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-014',
15:32:06 INFO - 'WINDIR': 'C:\\windows',
15:32:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
15:32:06 INFO - Calling ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BCJ1gsNrQ2yD9n8HeblaZw/artifacts/public/build/firefox-51.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-014', '--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
15:32:07 INFO - mozversion application_buildid: 20160821123001
15:32:07 INFO - mozversion application_changeset: 2a3b10281c9c7fd450fa27bdfa11d60bc0e0133c
15:32:07 INFO - mozversion application_display_name: Nightly
15:32:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384}
15:32:07 INFO - mozversion application_name: Firefox
15:32:07 INFO - mozversion application_remotingname: firefox
15:32:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland
15:32:07 INFO - mozversion application_vendor: Mozilla
15:32:07 INFO - mozversion application_version: 51.0a1
15:32:07 INFO - mozversion platform_buildid: 20160821123001
15:32:07 INFO - mozversion platform_changeset: 2a3b10281c9c7fd450fa27bdfa11d60bc0e0133c
15:32:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland
15:32:07 INFO - mozversion platform_version: 51.0a1
15:32:07 INFO - using testdate: 1471818727
15:32:07 INFO - actual date: 1471818727
15:32:07 INFO - starting webserver on 'localhost:49276'
15:32:07 INFO - SUITE-START | Running 2 tests
15:32:07 INFO - TEST-START | dromaeo_css
15:32:07 INFO - operating with platform_type : w8_
15:32:07 INFO - Initialising browser for dromaeo_css test...
15:32:08 INFO - TEST-INFO | started process 1552 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpewzwmx\profile http://localhost:49276/getInfo.html)
15:32:19 INFO - PROCESS | 1552 | __metrics Screen width/height:1600/1200
15:32:19 INFO - PROCESS | 1552 | colorDepth:24
15:32:19 INFO - PROCESS | 1552 | Browser inner width/height: 1010/674
15:32:19 INFO - PROCESS | 1552 | __metrics
15:32:21 INFO - PROCESS | 1552 | 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"
15:32:21 INFO - PROCESS | 1552 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver]
15:32:22 INFO - TEST-INFO | 1552: exit 0
15:32:22 INFO - Browser initialized.
15:32:22 INFO - Running cycle 1/1 for dromaeo_css test...
15:32:22 INFO - TEST-INFO | started process 3772 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpewzwmx\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1)
15:32:22 INFO - PROCESS | 3772 | [GFX1-]: Invalid size in UpdateRenderTarget Size(124,0), 0
15:32:33 INFO - PROCESS | 3772 | RSS: Main: 163827712
15:32:33 INFO - PROCESS | 3772 |
15:33:25 INFO - PROCESS | 3772 | 1471818805403 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]
15:35:33 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html)
15:35:34 INFO - PROCESS | 3772 | RSS: Main: 206372864
15:35:34 INFO - PROCESS | 3772 |
15:38:37 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html)
15:38:38 INFO - PROCESS | 3772 | RSS: Main: 222539776
15:38:38 INFO - PROCESS | 3772 |
15:41:40 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html)
15:41:40 INFO - PROCESS | 3772 | RSS: Main: 177414144
15:41:40 INFO - PROCESS | 3772 |
15:44:42 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html)
15:44:43 INFO - PROCESS | 3772 | RSS: Main: 208662528
15:44:43 INFO - PROCESS | 3772 |
15:47:46 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html)
15:47:47 INFO - PROCESS | 3772 | RSS: Main: 170176512
15:47:47 INFO - PROCESS | 3772 |
15:50:50 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html)
15:50:50 INFO - PROCESS | 3772 | RSS: Main: 251351040
15:50:50 INFO - PROCESS | 3772 |
15:50:50 INFO - PROCESS | 3772 | __start_tp_report
15:50:50 INFO - PROCESS | 3772 | _x_x_mozilla_page_load
15:50:50 INFO - PROCESS | 3772 | _x_x_mozilla_page_load_details
15:50:50 INFO - PROCESS | 3772 | |i|pagename|runs|
15:50:50 INFO - PROCESS | 3772 | |0;dojo.html;2877.4676684813307;2906.070057581572;2924.312786495175;2931.09136167788;2939.3533422647024;5128.53843154116;5190.455002224769;5193.1171700810855;5209.505097015787;5223.981323641891;5069.746512674361;5080.517350851663;5171.793128274864;5213.713245771481;5240.842774716764;4639.466461356937;4661.440627124733;4718.103560323545;4718.7168769873915;4733.621310295185;4726.503717109706;4744.64415168862;4794.976025119887;4797.2564252540915;4797.592204662608;4582.977085114553;4661.09108723799;4730.195866702652;4748.97625511872;4766.118268120409;4537.659675524316;4673.626109911233;4691.061787642451;4698.130845793539;4698.577128058457;4580.358749775034;4649.674522783406;4661.04448588042;4661.766911654404;4689.929651055237;4992.575631071363;5055.165897626887;5143.948560514385;5190.4031036430915;5231.686098834082;5486.286782718221;5550.111982082888;5556.249906262643;5561.165825126263;5570.693611851347;5590.664560126405;5601.467860553241;5606.243157173811;5606.6636001840025;5613.214150019001;4951.084049450863;5006.599472042228;5044.066847633199;5122.871928201787;5128.692278463304;5705.115707065412;5712.143178523254;5720.056190728566;5721.685307308138;5723.084306510938;5447.618666693373;5450.046241907729;5450.509454149145;5454.91817622736;5457.918131228034;5393.865153371119;5447.455254474521;5493.7802487900835;5552.278203833475;5560.332760068818;5512.944870551243;5516.779328826882;5517.282753242133;5520.530754885799;5524.861878452991;5433;5493.505584497414;5509.807156749494;5533.1976863354585;5555.833325000256;3445.242046749711;3507.4914137449928;3519.9120021999142;3619.819009049537;3621.8913432597064;3207.566978457925;3234.1106195795874;3245.2049247933937;3252.593425821772;3265.330607225513;5249.160134378558;5251.343582052244;5254.553362964114;5262.210668399771;5267.473252674702;5218.452062533455;5464.797744496204;5466.125419932791;5502.202180683778;5505.449455054542;5351.491608297206;5389.434109418455;5391.272178255964;5405.918911216335;5411;4580.450345958507;4584.770761461914;4586.633069354443;4589.311603259538;4591.150637132075;5625.634333768374;5642.069058605284;5766.538676905838;5850.736716847752;5887.35239123696;5504.53211477029;5561.499465048165;5576.77692892296;5627.971860140673;5637.3235211774845;5831.096180092092;5872.354041055566;5880.14737863016;5882.764689412375;5888.646681199141;5542.806001789918;5545.112781954868;5549.750261238173;5550.333959924835;5558.277423934863;5463.836084917459;5552.194931734956;5609.5512359012;5612.270404847507;5657.038303488334;5412.377576578744;5493.752781124779;5504.119340905436;5505.807296744595;5509.669419834822;5479.698616576126;5488.643238189505;5504.779808807763;5506.449355064622;5511.779528818803;5119.283300337881;5131.717755523333;5265.973670131778;5303.098473259633;5314.123169677115;5451.127819549012;5477.041517734301;5481.506664400223;5482.780688772405;5493.313335833021;5256.474352564713;5318.388385335736;5421.078416669255;5443.537299329443;5447.101228297287
15:50:50 INFO - PROCESS | 3772 | |1;ext.html;546.6692650946178;547.6111960508036;564.0777329066974;564.2974496751544;575.3987083497744;29585.852070739642;38363.42454863176;38393.23213535728;38855.80572097139;38921.61078389215;39375.409368859415;39562.60437395625;39689.404658930136;39747.403788943186;39771.204575908465;8403.36974726895;8403.5378054207;8505.787355316135;8542.487450752944;8561.828763424728;8341.874871876928;8438.789030274262;8443.83112337753;8444.746657600252;8466.703665371713;8364.414490985602;8378.706745263917;8399.412041157091;8426.325893928471;8490;8319.916800832036;8396.202360775747;8434.45176063557;8439.324854011664;8464.746057618282;8310.542920139389;8347.66437370018;8400.915990840074;8414.368922330788;8424.789380265482;37293.627063729284;37607.811960940024;37717.62282377196;37766.811165944;37909.620903790885;3095.148834070626;3172.286235596995;3254.528093426464;3304.5373647689344;3462.9653703463146;29474.852625736734;30120.54819177714;30176.547351789523;30304.24239394011;30392.54411183834;3644.5626524816926;3664.212194378195;3694.464302676097;3716.554013518395;3759.3421151298685;318376;319459;321302;321871;322535;50090;50427.74786126046;50450.74774626177;50451;50564.49435505671;31491.527627085612;32452;32484.863029794316;33018.504722429185;33607.159821004185;15399.769003464957;15497.07017578949;15558.844411555965;15570.143642099567;15612.4535641252;11483.483243254073;11490;11510.079193664487;11510.251833630788;11535.192536522363;16496.917515412348;16566.6686666266;16636.6672666546;16658.250378732988;16670.16649167561;6276.435120839055;6285.214348206474;6372.299047104815;6383.202099737533;6406.487481001509;783.9412044096601;864.5547543015352;882.761654353321;890.5369208011798;903.8056817784208;27389.589156162674;27693.723062769113;27862.860685696443;27889.16332510028;28211.294717631812;751.4289140253446;902.1024081039277;931.3992474853817;939.9624015039321;991.0188912976101;13936.86063139376;14156.433742650179;14188.503402380868;14452.927735361467;14458.132512049311;483173;489317;490743;492252;496241;48909;49317.75341123343;49453;49583.256251156265;49687.75156124196;1060.8037513060108;1157.890000449956;1174.5536696055615;1183.4851839449695;1195.9940200299118;27561.724382756718;28478;28599.714002859706;28843.27891802638;29085.418291634473;43049.354259685504;43529.56470435255;43608.34587481254;43637.56362436462;43814.56185438232;335152;335484;336392;337601;337925;25033.499330013663;25444.872775636744;25754.613680795177;26483;26508.8674556626;41811;42019;42101;42393;42840.35739463973;35910.8204458976;36514.8174259127;37867.81066094652;39460.2107957845;40537.79731101326;35843.82078089593;36486.27027459489;36604;37240.44139337966;38430;33810.15474613154;33843.66156338504;34768.82615586906;34867.82566087153;34889;31427.68572314339;32947;33102;33145.83427082849;33208.33583328272;24188.63717044281;24322.391940200927;24541.63187552224;24713;24868.50262994694
15:50:50 INFO - PROCESS | 3772 | |2;jquery.html;321.6477956637481;340.1038264173901;342.4965301007519;342.53928466212943;359.5361983041876;13221.405036773343;16850;16955.915220423896;17331.133443327813;18148;16614.335426582922;16771.329146834112;17114.743278850798;17158.485245442625;17217.741733874;5141.408737995141;5213.817516386927;5380.623356365056;5390.703511306877;5470.56235501159;3433.9484907726405;5351.678899266037;5388.892222155574;5392.541633961118;5806.506446951993;5981.431763982437;6041.3052498962525;6044.909326360108;6049.334573196945;6069.544784141207;5376.704281264529;5380.704061276629;5388.488093631099;5697.715114244271;6046.3349031606485;5196.194589838581;5210.973945130288;5212.087884620214;5213.556847667953;5218.452062533417;13192.604221873358;19780.80219197804;20427.897860510602;20661.276855309992;20911.8954405227;1963.2539634938776;1969.931052413173;2016.6974953757053;2299.620562607168;2363.888972183071;8552.78618034548;8808.427452215585;9131.863022054675;9282.72151835446;9300.395474294217;1813.0662708705026;1815.4916623345484;1841.4015444980434;1860.748798912143;1915.4732448576613;59687.70156149235;62325;67849.66075169641;72673.27326726718;74485.25514744838;9128.45229286245;9502.524873756285;9573.760655983657;9594.472304023346;9691.224702023821;13023.674408139683;13079.934600326937;13096.476140954255;13109.41007654658;13115.606531804062;7334.559926404433;7397.741079062314;7398.667059982314;7439.330460258603;7476.364509016686;7185.964070179615;7188.9216617506745;7237.428011636869;7238.92761072393;7331.78004659861;3985.820638071236;4015.658669013108;4049;4079.3880917862557;4144.274751918402;1712.3921008042214;1718.3470281293028;1731.2127474765616;1747.5543736347404;1749.588846621043;750.1335956969709;785.5012067337168;831.4346244553641;877.9824403511894;884.3690022183952;16586.58533536647;16663.66672666564;16716.66566668684;16882.240299186567;17179.914100429418;797.147052653655;828.9005319361595;847.6058632735808;887.4276091920675;934.4159900062461;9046.366754327133;9216;9393.859092113624;9394.510454729501;9461.90538094624;367519;381933;382113;383982;384684;42331;64726;77426.22573774302;77629.05927351749;78428.60785696036;917.2707697380465;921.7972046149837;942.9481378524247;943.5235206220951;945.0313428735601;11715.941420292844;14662.193579352812;15075.773863391838;15440.768388473956;15540.456084037005;35442.52349419056;36046.45930310995;36088.81955590205;36812.44781328336;37327;47799.76100119477;48044;48051;48156.5184348152;48272.75863620659;5263.73681315925;7496.9250307498405;7498.962505187657;7548.056492938383;7841;10030.348027378197;11804.881951180378;11940.940295298467;12190.75618487643;12426.502939882303;10278.743031424274;10423.270371073952;10432.843507347548;10519.26365154432;10718.464076796285;10111.494425278854;10300.793984120126;10365;10366.378017318984;10459;10567.366714088335;10571.841422378824;10580.100691441314;10656.840147397641;10790.298630588986;7436.776896693108;7484.941641048755;7535.623218839146;7554.773356799085;7622.771316860503;10207.948960255448;10331.896681033093;10670.62652807148;10701.946490267499;10703.143748499946
15:50:50 INFO - PROCESS | 3772 | |3;mootools.html;1202.224565155475;1203.217908359566;1259.3388471052697;1479.933402996865;1480.8667219950203;7010.439164866812;7571.697132114723;7580.469367144302;7593.354564861987;7595.734149304775;6614.239362473305;7225.241349658276;7301.817454563638;7405.592692401916;7409.222031686676;1924.0860591219164;1949.1034124302837;1952.7851936287068;1955.4133759872052;1958.2167133146713;1919.8752081114753;1929.6430160420298;1943.7764657064406;1961.264525802824;1963.2834015584351;1650.9504714858513;1887.2356695538328;1938.3990962801577;1940.7088936659472;1961.431184956361;1952.355722611542;1968.7637483502072;1974.6544354737864;1975.802419758027;1976.377441106047;1883.7456943312613;1898.364048043907;1899.7245399417006;1904.7428597139346;1908.265317852623;7598.392128629696;7686.807829804244;7759;7771.261730135628;7773.650185741599;4149.2531344358;4228.4080228768;4231.788410579458;4231.957680423187;4232.343986682069;2777.5833624956217;2817.60553522507;2851;2861.570764385359;2872.8276303421862;881.4270724029432;887.9467231966103;906.6690657909816;921.8571121476182;922.7231830450905;9293.628254869796;9319.207867331284;9346.719598412059;9376.01551837061;9387.812243755086;3566.233259849145;3645.1251699591908;3657.2868290683596;3735.159589092487;3740.251949610089;7835.725749598737;7865.528068315805;7874.527528348317;7875.527468351917;7893;4144;4171.520275168395;4183.163367326547;4188.623023927861;4197.664186865043;3839.1361943562474;3866.845326186977;3889.86385476507;3891.1633998690418;3895.6170559451552;3223.323102148528;3265.526498657729;3305.5537502436864;3322.2691007978206;3332.0836769888474;989.8861630912393;1012.9290949633455;1021.2953062387078;1025.1747343388645;1025.702546261576;792.7027364738224;802.1897883138073;804.9758507244792;812.4353574265829;820.5117954816874;5114.590832733373;5215.322008138917;5230.424653288135;5244.475552444725;5286.577073834084;332.76207511629303;333.0358611818771;346.44741637088805;349.0296974411141;349.35369566302137;3498.2653642734804;3517.525134106863;3561.1631266652316;3563.1982803868923;3563.625819288989;9254.76863078415;9482.857757133648;9635.421874687541;9637.18083962857;9644.03559644044;9457.952710236405;9533.094356036165;9534.856977145348;9548.618055277711;9554.952225238829;7146.392556632744;7159.498835081598;7196.208417074117;7226.927730722626;7245.565266083946;4829.782659780248;4935.383077115361;4992.950070499393;5013.749312534285;5064;8718.825623487368;8737.91262087371;8752.649894004424;8842.479893230398;8895.955520222358;8600.13998600135;8914.28685705155;8931.464112153291;8949.910500894908;8971.147740964598;6635.63504007265;6647.833804154935;6730.394264516217;6738.090357801634;6739.629320387426;7301.780946571611;7307.7807665770115;7347.706091756484;7380.483366164317;7394.482386232912;6590.736370545124;6596.406323430914;6598.472122230114;6641.26946035926;6702.798916032527;6355.237371515448;6496.350364963655;6538.1827271591055;6563.7702680405955;6623.933760662332;6138.754449821957;6291.1192433058495;6315.684215789101;6319.715612797527;6320.968395158179;4234.703570750018;4252.277112890878;4277.230098582285;4281.1437712458255;4384.539623339503;4340.92904461646;4353.172897149531;4353.281708518186;4364.781760911878;4505.526919673387
15:50:50 INFO - PROCESS | 3772 | |4;prototype.html;262.50124762950406;280.6800247717602;281.818227243428;286.0659945278665;295.1543826935828;4890.706557606546;5063.5189656982575;5146.485351464851;5192.169252919529;5192.844214673556;4860.441049279334;5108.923366149511;5118.667286626367;5139.563137133338;5141.922871156936;3945.4081887716784;3945.5857135000915;3962.969627896753;3967.3453880109746;3971.9801400992956;3774.169682669808;3858.7971983253833;3884.164904545522;3893.2602805467013;3961.2869683456966;3798.8670396536127;3851.0372406898277;3915.804209789499;3918.2376424620716;3942.349512330462;3899.278633452792;3903.1608204236227;3907.199024200032;3907.8151306685245;3909.5699473058085;3386.255023894739;3399.6090449598364;3406.386850366933;3408.9488657670154;3417.2652879631;4784.497627749106;5040.7650125719065;5045.974770126126;5050.191969284933;5072.340595722532;4465.464144302705;4469.262571675669;4476.082403107388;4476.440444944382;4487.618552423048;5242.136794807789;5339.9733001335135;5379.300690910196;5383.246345511592;5393.271908292409;3619.9276014479565;3627.3289441453417;3662.706983441345;3665.358562251622;3677.5586929568353;5517.751701173457;5574.804881829116;5588.804391846266;5607.971960140214;5617.466340697627;3796.6013568575454;3798.867039653654;3805.5243094613174;3824.349860523718;3856.132370216735;3619.4570814378053;3792.089898424358;3826.827792749333;3912.7456715313415;3923.391874259494;4220.177065472265;4304.440422745023;4405.845795397146;4424.911501770011;4425.712328698624;5343.545798607084;5352.681337570653;5353.38436079848;5356.651817631841;5371.677699338053;1322.5701646964776;1330.7272009238084;1335.6861137632648;1335.7243832140282;1340.3097404836321;839.9622017009249;851.7479305421022;852.3947996922254;859.5186695450568;902.9683961061331;5240.951809638012;5328.4671532846405;5338.91991620126;5346.572274218053;5373.731313434313;5507.476789704971;5518.117101263779;5523.392426833045;5533.584981126432;5535.726782839889;5192.870178245574;5287.656302340336;5309.256704061435;5362.785488580413;5389.356246344824;2906.88372465099;2924.5174546199637;2941.911742647724;2944.455275773989;2947.1600593830653;5726.284214473191;5751.964646363695;5786.479216870502;5789.160571717078;5806.506446952057;5349.705766182819;5520.861978450571;5573.804916827973;5579.832605021856;5587.44125587438;5688.8906663201105;5700.743466544015;5704.857378565486;5716.228309178207;5726.885462290814;5325.467453254643;5490.560755139659;5499.560035197254;5505.999230419511;5639.830805075854;5539.9169012464035;5541.667499950016;5549.139883318092;5558.333000040021;5563.496426607961;5856.75385345621;5856.765729370777;5863.618864773776;5867.911981320369;5899.439553242435;3738.4111253197234;3824.674902633196;3919.1769728357363;3962.128331767007;3967.26605577969;5606.85982850432;5621.2411324472305;5640.125780504029;5646.435356464321;5663.2071509989455;5225.536849682095;5297.073012222922;5434.83695489136;5450.127979523258;5469.453054694499;5444.346678398618;5450.454954504517;5453.836384908459;5455.727213639381;5456.8813393253495;5245.65903216305;5310.150141147637;5343.4656534347805;5350.250964864844;5397.9460205397445;5403.9459605403445;5425.558498675533;5438.510534051954;5446.727663616883;5453.618246722692;5399.865003374947;5404.54061404785;5414.184623995421;5420.186971954238;5428.809991650273
15:50:50 INFO - PROCESS | 3772 | |5;yui.html;622.8660837919847;666.6699983508167;684.7432212920155;712.0383343887589;715.6421789105448;13298.66753331166;13733.381997810098;14520.491782787605;14716;14736.263186840642;13585.456581736744;13966.952478564122;13976.440942362318;13978.161310321388;13992.790108148385;547.6631871399081;630.8517498387876;639.3957709964086;644.8420137066425;645.5965021861336;619.860531380438;633.20532731422;633.5944995203074;636.668932155279;639.3159319528107;661.9007148927675;663.3167837127767;664.3190729502275;664.3920812456596;665.3546060321505;558.1934105217962;657.9769708060219;661.9073329733793;662.2814246542483;662.9966850165742;473.2144639897788;475.76687423162747;480.6419217682849;483.15689122481496;486.7541891344848;12968.416421261067;12974.935125324408;12983.740325193538;12990.28553429561;13000.28498432586;11713.707157321136;12197.14619976602;12210.26738395699;12217.633470995885;12728.427220775087;11699.766004679945;11765.705857353549;11781.293122412682;12015.459304331325;12090.576829810914;4054.898627534306;4070.4911886014247;4079.5920407959266;4083.734557253769;4117.114820313647;63010.05484917776;71484.6425767873;71491.64254178749;71646.64176679135;72173;10268.178545716324;10295.9485202575;10353;10584.364938103585;10648.893511064945;16602.83397166037;17305;17893.568514518807;17918;17927.910360448113;7831.451798374173;7930.325922296554;7940.84118317642;8090.959545202354;8217.917820821835;4295.140971805651;4341.891452713644;4363.301871700576;4396.296592545242;4442.600165985077;2990.641123065246;3101.0541784755414;3109.036198778386;3111.6110486189227;3113.3306339136743;510.41557416757604;512.9256257842592;516.073647802196;517.9515018103392;522.6289334572496;460.30148751108305;515.6132900324757;545.6971380883648;549.2776998247372;552.9115341545414;9539.379940303857;9615.51922403877;9713.757156071155;9759.658411955548;9952.303338766216;608.8843119807223;617.0651463033507;628.4752231886426;641.7272659119856;668.1381018486098;4209.473815773028;4238.533761286256;4279;4361;4401.581849724271;63734;86646;102664.48667756614;106365.46817265864;108758;89301.55349223342;89820;90481;92374;92628;68131.99999999901;80269.59865200636;80482;80689.59655201803;81781.27936971284;8808.163224493663;8942;9669.806603867743;9744.220462363135;10004.349717268355;43519.564804351554;44019.55980440155;44871;45929.081418372116;46775.83060423517;39326;39628.631566317184;61604;61746;62165;11870.940645297063;11901.940490297493;11964.341961191869;12012.699682508008;12160.391980400767;14042.87581177748;14369.712605747618;14389.928050359682;14396.20820854863;15011.624709382353;13461.326933653083;13871.375788089763;13891.305434728021;14067.366968486238;14084.22536760488;12785.680357991125;13168;13184.73630527365;13408.463661453432;13518.526851560147;12669.746605067663;12759.170653907466;13070.869291306964;13379.331033448094;13583.456661733815;9772;9874.654387096418;10027.197824174194;10079.395236285847;10097.5456104474;9836.803263934824;9854.21166306708;10040.648577300051;10055.29612927088;10086.596536138471
15:50:50 INFO - PROCESS | 3772 | __end_tp_report
15:50:50 INFO - PROCESS | 3772 | __start_cc_report
15:50:50 INFO - PROCESS | 3772 | _x_x_mozilla_cycle_collect,820
15:50:50 INFO - PROCESS | 3772 | __end_cc_report
15:50:50 INFO - PROCESS | 3772 | __startTimestamp1471819850485__endTimestamp
15:50:50 INFO - PROCESS | 3772 |
15:50:50 INFO - PROCESS | 3772 | ------- Summary: start -------
15:50:50 INFO - PROCESS | 3772 | Number of tests: 6
15:50:50 INFO - PROCESS | 3772 |
15:50:50 INFO - PROCESS | 3772 | [#0] dojo.html Cycles:165 Average:5108.64 Median:5405.92 stddev:692.72 (12.8%) stddev-sans-first:672.37
15:50:50 INFO - PROCESS | 3772 | Values: 2877.5 2906.1 2924.3 2931.1 2939.4 5128.5 5190.5 5193.1 5209.5 5224.0 5069.7 5080.5 5171.8 5213.7 5240.8 4639.5 4661.4 4718.1 4718.7 4733.6 4726.5 4744.6 4795.0 4797.3 4797.6 4583.0 4661.1 4730.2 4749.0 4766.1 4537.7 4673.6 4691.1 4698.1 4698.6 4580.4 4649.7 4661.0 4661.8 4689.9 4992.6 5055.2 5143.9 5190.4 5231.7 5486.3 5550.1 5556.2 5561.2 5570.7 5590.7 5601.5 5606.2 5606.7 5613.2 4951.1 5006.6 5044.1 5122.9 5128.7 5705.1 5712.1 5720.1 5721.7 5723.1 5447.6 5450.0 5450.5 5454.9 5457.9 5393.9 5447.5 5493.8 5552.3 5560.3 5512.9 5516.8 5517.3 5520.5 5524.9 5433.0 5493.5 5509.8 5533.2 5555.8 3445.2 3507.5 3519.9 3619.8 3621.9 3207.6 3234.1 3245.2 3252.6 3265.3 5249.2 5251.3 5254.6 5262.2 5267.5 5218.5 5464.8 5466.1 5502.2 5505.4 5351.5 5389.4 5391.3 5405.9 5411.0 4580.5 4584.8 4586.6 4589.3 4591.2 5625.6 5642.1 5766.5 5850.7 5887.4 5504.5 5561.5 5576.8 5628.0 5637.3 5831.1 5872.4 5880.1 5882.8 5888.6 5542.8 5545.1 5549.8 5550.3 5558.3 5463.8 5552.2 5609.6 5612.3 5657.0 5412.4 5493.8 5504.1 5505.8 5509.7 5479.7 5488.6 5504.8 5506.4 5511.8 5119.3 5131.7 5266.0 5303.1 5314.1 5451.1 5477.0 5481.5 5482.8 5493.3 5256.5 5318.4 5421.1 5443.5 5447.1
15:50:50 INFO - PROCESS | 3772 |
15:50:50 INFO - PROCESS | 3772 | [#1] ext.html Cycles:180 Average:52099.36 Median:37267.03 stddev:103436.69 (277.6%) stddev-sans-first:103654.44
15:50:50 INFO - PROCESS | 3772 | Values: 546.7 547.6 564.1 564.3 575.4 29585.9 38363.4 38393.2 38855.8 38921.6 39375.4 39562.6 39689.4 39747.4 39771.2 8403.4 8403.5 8505.8 8542.5 8561.8 8341.9 8438.8 8443.8 8444.7 8466.7 8364.4 8378.7 8399.4 8426.3 8490.0 8319.9 8396.2 8434.5 8439.3 8464.7 8310.5 8347.7 8400.9 8414.4 8424.8 37293.6 37607.8 37717.6 37766.8 37909.6 3095.1 3172.3 3254.5 3304.5 3463.0 29474.9 30120.5 30176.5 30304.2 30392.5 3644.6 3664.2 3694.5 3716.6 3759.3 318376.0 319459.0 321302.0 321871.0 322535.0 50090.0 50427.7 50450.7 50451.0 50564.5 31491.5 32452.0 32484.9 33018.5 33607.2 15399.8 15497.1 15558.8 15570.1 15612.5 11483.5 11490.0 11510.1 11510.3 11535.2 16496.9 16566.7 16636.7 16658.3 16670.2 6276.4 6285.2 6372.3 6383.2 6406.5 783.9 864.6 882.8 890.5 903.8 27389.6 27693.7 27862.9 27889.2 28211.3 751.4 902.1 931.4 940.0 991.0 13936.9 14156.4 14188.5 14452.9 14458.1 483173.0 489317.0 490743.0 492252.0 496241.0 48909.0 49317.8 49453.0 49583.3 49687.8 1060.8 1157.9 1174.6 1183.5 1196.0 27561.7 28478.0 28599.7 28843.3 29085.4 43049.4 43529.6 43608.3 43637.6 43814.6 335152.0 335484.0 336392.0 337601.0 337925.0 25033.5 25444.9 25754.6 26483.0 26508.9 41811.0 42019.0 42101.0 42393.0 42840.4 35910.8 36514.8 37867.8 39460.2 40537.8 35843.8 36486.3 36604.0 37240.4 38430.0 33810.2 33843.7 34768.8 34867.8 34889.0 31427.7 32947.0 33102.0 33145.8 33208.3 24188.6 24322.4 24541.6 24713.0 24868.5
15:50:50 INFO - PROCESS | 3772 |
15:50:50 INFO - PROCESS | 3772 | [#2] jquery.html Cycles:180 Average:23541.76 Median:23237.64 stddev:62622.12 (269.5%) stddev-sans-first:62773.52
15:50:50 INFO - PROCESS | 3772 | Values: 321.6 340.1 342.5 342.5 359.5 13221.4 16850.0 16955.9 17331.1 18148.0 16614.3 16771.3 17114.7 17158.5 17217.7 5141.4 5213.8 5380.6 5390.7 5470.6 3433.9 5351.7 5388.9 5392.5 5806.5 5981.4 6041.3 6044.9 6049.3 6069.5 5376.7 5380.7 5388.5 5697.7 6046.3 5196.2 5211.0 5212.1 5213.6 5218.5 13192.6 19780.8 20427.9 20661.3 20911.9 1963.3 1969.9 2016.7 2299.6 2363.9 8552.8 8808.4 9131.9 9282.7 9300.4 1813.1 1815.5 1841.4 1860.7 1915.5 59687.7 62325.0 67849.7 72673.3 74485.3 9128.5 9502.5 9573.8 9594.5 9691.2 13023.7 13079.9 13096.5 13109.4 13115.6 7334.6 7397.7 7398.7 7439.3 7476.4 7186.0 7188.9 7237.4 7238.9 7331.8 3985.8 4015.7 4049.0 4079.4 4144.3 1712.4 1718.3 1731.2 1747.6 1749.6 750.1 785.5 831.4 878.0 884.4 16586.6 16663.7 16716.7 16882.2 17179.9 797.1 828.9 847.6 887.4 934.4 9046.4 9216.0 9393.9 9394.5 9461.9 367519.0 381933.0 382113.0 383982.0 384684.0 42331.0 64726.0 77426.2 77629.1 78428.6 917.3 921.8 942.9 943.5 945.0 11715.9 14662.2 15075.8 15440.8 15540.5 35442.5 36046.5 36088.8 36812.4 37327.0 47799.8 48044.0 48051.0 48156.5 48272.8 5263.7 7496.9 7499.0 7548.1 7841.0 10030.3 11804.9 11940.9 12190.8 12426.5 10278.7 10423.3 10432.8 10519.3 10718.5 10111.5 10300.8 10365.0 10366.4 10459.0 10567.4 10571.8 10580.1 10656.8 10790.3 7436.8 7484.9 7535.6 7554.8 7622.8 10207.9 10331.9 10670.6 10701.9 10703.1
15:50:50 INFO - PROCESS | 3772 |
15:50:50 INFO - PROCESS | 3772 | [#3] mootools.html Cycles:180 Average:4873.84 Median:5222.87 stddev:2811.16 (53.8%) stddev-sans-first:2805.51
15:50:50 INFO - PROCESS | 3772 | Values: 1202.2 1203.2 1259.3 1479.9 1480.9 7010.4 7571.7 7580.5 7593.4 7595.7 6614.2 7225.2 7301.8 7405.6 7409.2 1924.1 1949.1 1952.8 1955.4 1958.2 1919.9 1929.6 1943.8 1961.3 1963.3 1651.0 1887.2 1938.4 1940.7 1961.4 1952.4 1968.8 1974.7 1975.8 1976.4 1883.7 1898.4 1899.7 1904.7 1908.3 7598.4 7686.8 7759.0 7771.3 7773.7 4149.3 4228.4 4231.8 4232.0 4232.3 2777.6 2817.6 2851.0 2861.6 2872.8 881.4 887.9 906.7 921.9 922.7 9293.6 9319.2 9346.7 9376.0 9387.8 3566.2 3645.1 3657.3 3735.2 3740.3 7835.7 7865.5 7874.5 7875.5 7893.0 4144.0 4171.5 4183.2 4188.6 4197.7 3839.1 3866.8 3889.9 3891.2 3895.6 3223.3 3265.5 3305.6 3322.3 3332.1 989.9 1012.9 1021.3 1025.2 1025.7 792.7 802.2 805.0 812.4 820.5 5114.6 5215.3 5230.4 5244.5 5286.6 332.8 333.0 346.4 349.0 349.4 3498.3 3517.5 3561.2 3563.2 3563.6 9254.8 9482.9 9635.4 9637.2 9644.0 9458.0 9533.1 9534.9 9548.6 9555.0 7146.4 7159.5 7196.2 7226.9 7245.6 4829.8 4935.4 4993.0 5013.7 5064.0 8718.8 8737.9 8752.6 8842.5 8896.0 8600.1 8914.3 8931.5 8949.9 8971.1 6635.6 6647.8 6730.4 6738.1 6739.6 7301.8 7307.8 7347.7 7380.5 7394.5 6590.7 6596.4 6598.5 6641.3 6702.8 6355.2 6496.4 6538.2 6563.8 6623.9 6138.8 6291.1 6315.7 6319.7 6321.0 4234.7 4252.3 4277.2 4281.1 4384.5 4340.9 4353.2 4353.3 4364.8 4505.5
15:50:50 INFO - PROCESS | 3772 |
15:50:50 INFO - PROCESS | 3772 | [#4] prototype.html Cycles:180 Average:4516.58 Median:5292.36 stddev:1375.00 (26.0%) stddev-sans-first:1341.28
15:50:50 INFO - PROCESS | 3772 | Values: 262.5 280.7 281.8 286.1 295.2 4890.7 5063.5 5146.5 5192.2 5192.8 4860.4 5108.9 5118.7 5139.6 5141.9 3945.4 3945.6 3963.0 3967.3 3972.0 3774.2 3858.8 3884.2 3893.3 3961.3 3798.9 3851.0 3915.8 3918.2 3942.3 3899.3 3903.2 3907.2 3907.8 3909.6 3386.3 3399.6 3406.4 3408.9 3417.3 4784.5 5040.8 5046.0 5050.2 5072.3 4465.5 4469.3 4476.1 4476.4 4487.6 5242.1 5340.0 5379.3 5383.2 5393.3 3619.9 3627.3 3662.7 3665.4 3677.6 5517.8 5574.8 5588.8 5608.0 5617.5 3796.6 3798.9 3805.5 3824.3 3856.1 3619.5 3792.1 3826.8 3912.7 3923.4 4220.2 4304.4 4405.8 4424.9 4425.7 5343.5 5352.7 5353.4 5356.7 5371.7 1322.6 1330.7 1335.7 1335.7 1340.3 840.0 851.7 852.4 859.5 903.0 5241.0 5328.5 5338.9 5346.6 5373.7 5507.5 5518.1 5523.4 5533.6 5535.7 5192.9 5287.7 5309.3 5362.8 5389.4 2906.9 2924.5 2941.9 2944.5 2947.2 5726.3 5752.0 5786.5 5789.2 5806.5 5349.7 5520.9 5573.8 5579.8 5587.4 5688.9 5700.7 5704.9 5716.2 5726.9 5325.5 5490.6 5499.6 5506.0 5639.8 5539.9 5541.7 5549.1 5558.3 5563.5 5856.8 5856.8 5863.6 5867.9 5899.4 3738.4 3824.7 3919.2 3962.1 3967.3 5606.9 5621.2 5640.1 5646.4 5663.2 5225.5 5297.1 5434.8 5450.1 5469.5 5444.3 5450.5 5453.8 5455.7 5456.9 5245.7 5310.2 5343.5 5350.3 5397.9 5403.9 5425.6 5438.5 5446.7 5453.6 5399.9 5404.5 5414.2 5420.2 5428.8
15:50:50 INFO - PROCESS | 3772 |
15:50:50 INFO - PROCESS | 3772 | [#5] yui.html Cycles:180 Average:18298.84 Median:4398.94 stddev:25861.99 (587.9%) stddev-sans-first:25900.49
15:50:50 INFO - PROCESS | 3772 | Values: 622.9 666.7 684.7 712.0 715.6 13298.7 13733.4 14520.5 14716.0 14736.3 13585.5 13967.0 13976.4 13978.2 13992.8 547.7 630.9 639.4 644.8 645.6 619.9 633.2 633.6 636.7 639.3 661.9 663.3 664.3 664.4 665.4 558.2 658.0 661.9 662.3 663.0 473.2 475.8 480.6 483.2 486.8 12968.4 12974.9 12983.7 12990.3 13000.3 11713.7 12197.1 12210.3 12217.6 12728.4 11699.8 11765.7 11781.3 12015.5 12090.6 4054.9 4070.5 4079.6 4083.7 4117.1 63010.1 71484.6 71491.6 71646.6 72173.0 10268.2 10295.9 10353.0 10584.4 10648.9 16602.8 17305.0 17893.6 17918.0 17927.9 7831.5 7930.3 7940.8 8091.0 8217.9 4295.1 4341.9 4363.3 4396.3 4442.6 2990.6 3101.1 3109.0 3111.6 3113.3 510.4 512.9 516.1 518.0 522.6 460.3 515.6 545.7 549.3 552.9 9539.4 9615.5 9713.8 9759.7 9952.3 608.9 617.1 628.5 641.7 668.1 4209.5 4238.5 4279.0 4361.0 4401.6 63734.0 86646.0 102664.5 106365.5 108758.0 89301.6 89820.0 90481.0 92374.0 92628.0 68132.0 80269.6 80482.0 80689.6 81781.3 8808.2 8942.0 9669.8 9744.2 10004.3 43519.6 44019.6 44871.0 45929.1 46775.8 39326.0 39628.6 61604.0 61746.0 62165.0 11870.9 11901.9 11964.3 12012.7 12160.4 14042.9 14369.7 14389.9 14396.2 15011.6 13461.3 13871.4 13891.3 14067.4 14084.2 12785.7 13168.0 13184.7 13408.5 13518.5 12669.7 12759.2 13070.9 13379.3 13583.5 9772.0 9874.7 10027.2 10079.4 10097.5 9836.8 9854.2 10040.6 10055.3 10086.6
15:50:50 INFO - PROCESS | 3772 | -------- Summary: end --------
15:50:50 INFO - PROCESS | 3772 |
15:50:51 INFO - TEST-INFO | 3772: exit 0
15:50:51 INFO - TEST-OK | dromaeo_css | took 1123837ms
15:50:51 INFO - TEST-START | kraken
15:50:51 INFO - operating with platform_type : w8_
15:50:51 INFO - Initialising browser for kraken test...
15:50:51 INFO - TEST-INFO | started process 996 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpg6yvym\profile http://localhost:49276/getInfo.html)
15:50:57 INFO - PROCESS | 996 | __metrics Screen width/height:1600/1200
15:50:57 INFO - PROCESS | 996 | colorDepth:24
15:50:57 INFO - PROCESS | 996 | Browser inner width/height: 1010/674
15:50:57 INFO - PROCESS | 996 | __metrics
15:50:58 INFO - PROCESS | 996 | 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"
15:50:58 INFO - PROCESS | 996 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver]
15:50:58 INFO - PROCESS | 996 | console.error:
15:50:58 INFO - PROCESS | 996 | Message: Error: Connection closed before committing the transaction.
15:50:58 INFO - PROCESS | 996 | Stack:
15:50:58 INFO - PROCESS | 996 | ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:937:23
15:50:58 INFO - PROCESS | 996 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7
15:50:58 INFO - PROCESS | 996 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11
15:50:58 INFO - PROCESS | 996 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7
15:50:58 INFO - PROCESS | 996 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:714:7
15:50:58 INFO - PROCESS | 996 | TaskImpl_run@resource://gre/modules/Task.jsm:324:13
15:50:58 INFO - PROCESS | 996 | Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:551:9
15:50:58 INFO - PROCESS | 996 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15
15:50:58 INFO - PROCESS | 996 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:388:5
15:50:58 INFO - PROCESS | 996 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29
15:50:58 INFO - PROCESS | 996 | Barrier/this.client.addBlocker/promise13.3%
15:51:55 INFO - TinderboxPrint: I/O read bytes / time
66,926,080 / 1,681,430
15:51:55 INFO - TinderboxPrint: I/O write bytes / time
405,594,624 / 3,882,730
15:51:55 INFO - TinderboxPrint: CPU idle
8,261.7 (86.7%)
15:51:55 INFO - TinderboxPrint: CPU user
1,222.4 (12.8%)
15:51:55 INFO - install - Wall time: 2s; CPU: 12.0%; Read bytes: 0; Write bytes: 46544384; Read time: 0; Write time: 105570
15:51:55 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 65625088; Write bytes: 309591040; Read time: 1666590; Write time: 3735990
15:51:56 INFO - Running post-run listener: _upload_blobber_files
15:51:56 INFO - Blob upload gear active.
15:51:56 INFO - Preparing to upload files from C:\slave\test\build\blobber_upload_dir.
15:51:56 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
15:51:56 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\venv\\Scripts\\blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', 'C:\\slave\\test\\oauth.txt', '-b', 'Autoland', '-d', 'C:\\slave\\test\\build\\blobber_upload_dir', '--output-manifest', 'C:\\slave\\test\\build\\uploaded_files.json']
15:51:56 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\venv\Scripts\blobberc.py -u https://blobupload.elasticbeanstalk.com -a C:\slave\test\oauth.txt -b Autoland -d C:\slave\test\build\blobber_upload_dir --output-manifest C:\slave\test\build\uploaded_files.json
15:51:56 INFO - (blobuploader) - INFO - Open directory for files ...
15:51:56 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_errorsummary.log ...
15:51:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
15:51:56 INFO - (blobuploader) - INFO - Uploading, attempt #1.
15:51:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded
15:51:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
15:51:57 INFO - (blobuploader) - INFO - Done attempting.
15:51:57 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_raw.log ...
15:51:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
15:51:57 INFO - (blobuploader) - INFO - Uploading, attempt #1.
15:51:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded
15:51:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
15:51:58 INFO - (blobuploader) - INFO - Done attempting.
15:51:58 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\resource-usage.json ...
15:51:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
15:51:58 INFO - (blobuploader) - INFO - Uploading, attempt #1.
15:52:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded
15:52:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
15:52:00 INFO - (blobuploader) - INFO - Done attempting.
15:52:00 INFO - (blobuploader) - INFO - Iteration through files over.
15:52:00 INFO - Return code: 0
15:52:00 INFO - rmtree: C:\slave\test\build\uploaded_files.json
15:52:00 INFO - Using _rmtree_windows ...
15:52:00 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build\\uploaded_files.json',), kwargs: {}, attempt #1
15:52:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/fce7fed921a1ef12a47b7290474b3d92ded6c34b1a18e040915dd465271504e02881a70e5079337d7b928345a7751e05a35af0d1640277cbde4f196817119a34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/36184ca3e0e413534de902494f7886d0b1fdeaeb59d4831b1c8ea19d58a50b7713dbf9e13aa02a15c5b73475726a200b9f40726b117af2312366f0c46a389f2b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a36d49ed07317b18ac2966b1842d352b49d7c380b3de59148a04ae2d58846a7fbfc7982106260cc14585a80c519a0a3611244a68c4c083a9cf71a824f44b657d"}
15:52:00 INFO - Writing buildbot properties ['blobber_files'] to C:\slave\test\properties\blobber_files
15:52:00 INFO - Writing to file C:\slave\test\properties\blobber_files
15:52:00 INFO - Contents:
15:52:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/fce7fed921a1ef12a47b7290474b3d92ded6c34b1a18e040915dd465271504e02881a70e5079337d7b928345a7751e05a35af0d1640277cbde4f196817119a34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/36184ca3e0e413534de902494f7886d0b1fdeaeb59d4831b1c8ea19d58a50b7713dbf9e13aa02a15c5b73475726a200b9f40726b117af2312366f0c46a389f2b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a36d49ed07317b18ac2966b1842d352b49d7c380b3de59148a04ae2d58846a7fbfc7982106260cc14585a80c519a0a3611244a68c4c083a9cf71a824f44b657d"}
15:52:00 INFO - Running post-run listener: copy_logs_to_upload_dir
15:52:00 INFO - Copying logs to upload dir...
15:52:00 INFO - mkdir: C:\slave\test\build\upload\logs
15:52:00 INFO - Copying logs to upload dir...
15:52:00 INFO - Using _rmtree_windows ...
15:52:00 INFO - Using _rmtree_windows ...
15:52:00 INFO - Using _rmtree_windows ...
15:52:00 INFO - Using _rmtree_windows ...
15:52:00 INFO - Using _rmtree_windows ...
15:52:00 INFO - Using _rmtree_windows ...
15:52:00 INFO - Using _rmtree_windows ...
program finished with exit code 0
elapsedTime=1400.660000
========= master_lag: 0.12 =========
========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 20 secs) (at 2016-08-21 15:52:01.034076) =========
========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-21 15:52:01.034973) =========
'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-014\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-014
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-014
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-014\AppData\Local
LOGONSERVER=\\T-W864-IX-014
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-014
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-014
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-014
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/fce7fed921a1ef12a47b7290474b3d92ded6c34b1a18e040915dd465271504e02881a70e5079337d7b928345a7751e05a35af0d1640277cbde4f196817119a34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/36184ca3e0e413534de902494f7886d0b1fdeaeb59d4831b1c8ea19d58a50b7713dbf9e13aa02a15c5b73475726a200b9f40726b117af2312366f0c46a389f2b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a36d49ed07317b18ac2966b1842d352b49d7c380b3de59148a04ae2d58846a7fbfc7982106260cc14585a80c519a0a3611244a68c4c083a9cf71a824f44b657d"}
build_url:https://queue.taskcluster.net/v1/task/BCJ1gsNrQ2yD9n8HeblaZw/artifacts/public/build/firefox-51.0a1.en-US.win64.zip
program finished with exit code 0
elapsedTime=0.102000
build_url: 'https://queue.taskcluster.net/v1/task/BCJ1gsNrQ2yD9n8HeblaZw/artifacts/public/build/firefox-51.0a1.en-US.win64.zip'
blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/fce7fed921a1ef12a47b7290474b3d92ded6c34b1a18e040915dd465271504e02881a70e5079337d7b928345a7751e05a35af0d1640277cbde4f196817119a34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/36184ca3e0e413534de902494f7886d0b1fdeaeb59d4831b1c8ea19d58a50b7713dbf9e13aa02a15c5b73475726a200b9f40726b117af2312366f0c46a389f2b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a36d49ed07317b18ac2966b1842d352b49d7c380b3de59148a04ae2d58846a7fbfc7982106260cc14585a80c519a0a3611244a68c4c083a9cf71a824f44b657d"}'
========= master_lag: 0.02 =========
========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-21 15:52:01.158950) =========
========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-21 15:52:01.159269) =========
'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-014\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-014
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-014
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-014\AppData\Local
LOGONSERVER=\\T-W864-IX-014
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-014
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-014
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-014
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-08-21 15:52:01.280396) =========
========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-08-21 15:52:01.280698) =========
========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-08-21 15:52:01.703606) =========
========= Total master_lag: 0.37 =========