builder: fx-team_win8_64_test-dromaeojs-pgo
slave: t-w864-ix-115
starttime: 1474499089.68
results: success (0)
buildid: 20160921123003
builduid: a98ead63674d48699898b1dcca3ac00f
revision: 6757959dbba2a80fa1f58ea4e677c65cb5cd9e15
========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-21 16:04:49.676150) =========
master: http://buildbot-master112.bb.releng.scl3.mozilla.com:8201/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-21 16:04:49.676683) =========
========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-21 16:04:49.676973) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-21 16:04:49.759536) =========
========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-21 16:04:49.759846) =========
'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-115\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-115
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-115
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-115\AppData\Local
LOGONSERVER=\\T-W864-IX-115
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-115
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-115
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-115
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
--16:04:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py
=> `archiver_client.py'
Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25
Connecting to hg.mozilla.org|63.245.215.102|:443... connected.
HTTP request sent, awaiting response... 200 Script output follows
Length: 12,141 (12K) [text/x-python]
0K .......... . 100% 14.57 MB/s
16:04:50 (14.57 MB/s) - `archiver_client.py' saved [12141/12141]
program finished with exit code 0
elapsedTime=1.334000
========= master_lag: 1.45 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-21 16:04:52.548734) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 6 secs) (at 2016-09-21 16:04:52.549019) =========
'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-115\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-115
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-115
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-115\AppData\Local
LOGONSERVER=\\T-W864-IX-115
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-115
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-115
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-115
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
program finished with exit code 0
elapsedTime=3.011000
========= master_lag: 3.90 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 6 secs) (at 2016-09-21 16:04:59.460231) =========
========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-21 16:04:59.460559) =========
'bash' '-c' u'python archiver_client.py mozharness --repo integration/fx-team --rev 6757959dbba2a80fa1f58ea4e677c65cb5cd9e15 --destination scripts --debug'
in dir C:\slave\test\. (timeout 1200 secs)
watching logfiles {}
argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 6757959dbba2a80fa1f58ea4e677c65cb5cd9e15 --destination scripts --debug']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld.T-W864-IX-115\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-115
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-115
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-115\AppData\Local
LOGONSERVER=\\T-W864-IX-115
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-115
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-115
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-115
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
2016-09-21 16:04:59,068 truncating revision to first 12 chars
2016-09-21 16:04:59,068 Setting DEBUG logging.
2016-09-21 16:04:59,068 attempt 1/10
2016-09-21 16:04:59,068 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6757959dbba2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2016-09-21 16:04:59,493 unpacking tar archive at: fx-team-6757959dbba2/testing/mozharness/
2016-09-21 16:04:59,605 skipping symlink on windows: configs/single_locale/linux32.py
program finished with exit code 0
elapsedTime=1.102000
========= master_lag: 0.07 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-21 16:05:00.636446) =========
========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-21 16:05:00.636780) =========
script_repo_revision: 6757959dbba2a80fa1f58ea4e677c65cb5cd9e15
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-21 16:05:00.637186) =========
========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-21 16:05:00.637456) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-21 16:05:00.699773) =========
========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 26 secs) (at 2016-09-21 16:05:00.700059) =========
'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'dromaeojs' '--add-option' '--webServer,localhost' '--branch-name' 'Fx-Team' '--cfg' 'talos/windows_config.py' '--download-symbols' 'ondemand' '--use-talos-json' '--blob-upload-branch' 'Fx-Team'
in dir C:\slave\test\. (timeout 3600 secs) (maxTime 7200 secs)
watching logfiles {}
argv: ['c:/mozilla-build/python27/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/windows_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld.T-W864-IX-115\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-115
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-115
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-115\AppData\Local
LOGONSERVER=\\T-W864-IX-115
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-115
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-115
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-115
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
16:05:00 INFO - MultiFileLogger online at 20160921 16:05:00 in C:\slave\test
16:05:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team
16:05:00 INFO - Dumping config to C:\slave\test\logs\localconfig.json.
16:05:00 INFO - {'append_to_log': False,
16:05:00 INFO - 'base_work_dir': 'C:\\slave\\test',
16:05:00 INFO - 'blob_upload_branch': 'Fx-Team',
16:05:00 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt',
16:05:00 INFO - 'branch': 'Fx-Team',
16:05:00 INFO - 'buildbot_json_path': 'buildprops.json',
16:05:00 INFO - 'config_files': ('talos/windows_config.py',),
16:05:00 INFO - 'default_actions': ('clobber',
16:05:00 INFO - 'read-buildbot-config',
16:05:00 INFO - 'download-and-extract',
16:05:00 INFO - 'populate-webroot',
16:05:00 INFO - 'create-virtualenv',
16:05:00 INFO - 'install',
16:05:00 INFO - 'run-tests'),
16:05:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',),
16:05:00 INFO - 'download_minidump_stackwalk': True,
16:05:00 INFO - 'download_symbols': 'ondemand',
16:05:00 INFO - 'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python',
16:05:00 INFO - 'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'),
16:05:00 INFO - 'hg': 'c:/mozilla-build/hg/hg',
16:05:00 INFO - 'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python',
16:05:00 INFO - 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'),
16:05:00 INFO - 'python': 'c:/mozilla-build/python27/python.exe',
16:05:00 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe',
16:05:00 INFO - 'C:/mozilla-build/tooltool.py'),
16:05:00 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe',
16:05:00 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')},
16:05:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub',
16:05:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'),
16:05:00 INFO - 'installer_path': 'installer.exe',
16:05:00 INFO - 'log_level': 'info',
16:05:00 INFO - 'log_name': 'talos',
16:05:00 INFO - 'log_to_console': True,
16:05:00 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe',
16:05:00 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe',
16:05:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest',
16:05:00 INFO - 'opt_config_files': (),
16:05:00 INFO - 'pip_index': False,
16:05:00 INFO - 'sps_profile': False,
16:05:00 INFO - 'sps_profile_interval': 0,
16:05:00 INFO - 'suite': 'dromaeojs',
16:05:00 INFO - 'system_bits': '32',
16:05:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'),
16:05:00 INFO - 'title': 'T-W864-IX-115',
16:05:00 INFO - 'use_talos_json': True,
16:05:00 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'),
16:05:00 INFO - 'virtualenv_path': 'C:\\slave\\test\\build/venv',
16:05:00 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll',
16:05:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
16:05:00 INFO - 'work_dir': 'build'}
16:05:00 INFO - [mozharness: 2016-09-21 23:05:00.664000Z] Running clobber step.
16:05:00 INFO - Running pre-action listener: _resource_record_pre_action
16:05:00 INFO - Running main action method: clobber
16:05:00 INFO - rmtree: C:\slave\test\build
16:05:00 INFO - Using _rmtree_windows ...
16:05:00 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1
16:06:34 INFO - Running post-action listener: _resource_record_post_action
16:06:34 INFO - [mozharness: 2016-09-21 23:06:34.021000Z] Finished clobber step (success)
16:06:34 INFO - [mozharness: 2016-09-21 23:06:34.021000Z] Running read-buildbot-config step.
16:06:34 INFO - Running pre-action listener: _resource_record_pre_action
16:06:34 INFO - Running main action method: read_buildbot_config
16:06:34 INFO - Using buildbot properties:
16:06:34 INFO - {
16:06:34 INFO - "project": "",
16:06:34 INFO - "product": "firefox",
16:06:34 INFO - "script_repo_revision": "production",
16:06:34 INFO - "builddir": "fx-team_win8_64_test-dromaeojs",
16:06:34 INFO - "repository": "",
16:06:34 INFO - "buildername": "Windows 8 64-bit fx-team pgo talos dromaeojs",
16:06:34 INFO - "buildid": "20160921123003",
16:06:34 INFO - "pgo_build": "True",
16:06:34 INFO - "basedir": "C:\\slave\\test",
16:06:34 INFO - "buildnumber": 134,
16:06:34 INFO - "slavename": "t-w864-ix-115",
16:06:34 INFO - "master": "http://buildbot-master112.bb.releng.scl3.mozilla.com:8201/",
16:06:34 INFO - "platform": "win8_64",
16:06:34 INFO - "scheduler": "tests-fx-team-win64-pgo-talos",
16:06:34 INFO - "branch": "fx-team",
16:06:34 INFO - "repo_path": "integration/fx-team",
16:06:34 INFO - "revision": "6757959dbba2a80fa1f58ea4e677c65cb5cd9e15",
16:06:34 INFO - "stage_platform": "win64-pgo",
16:06:34 INFO - "builduid": "a98ead63674d48699898b1dcca3ac00f",
16:06:34 INFO - "slavebuilddir": "test"
16:06:34 INFO - }
16:06:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/dvshFOgSSIiORW6wy6HT8g/artifacts/public/build/firefox-52.0a1.en-US.win64.zip.
16:06:34 INFO - Running post-action listener: _resource_record_post_action
16:06:34 INFO - [mozharness: 2016-09-21 23:06:34.024000Z] Finished read-buildbot-config step (success)
16:06:34 INFO - [mozharness: 2016-09-21 23:06:34.024000Z] Running download-and-extract step.
16:06:34 INFO - Running pre-action listener: _resource_record_pre_action
16:06:34 INFO - Running main action method: download_and_extract
16:06:34 INFO - mkdir: C:\slave\test\build\tests
16:06:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
16:06:34 INFO - trying https://queue.taskcluster.net/v1/task/dvshFOgSSIiORW6wy6HT8g/artifacts/public/build/firefox-52.0a1.en-US.win64.test_packages.json
16:06:34 INFO - Downloading https://queue.taskcluster.net/v1/task/dvshFOgSSIiORW6wy6HT8g/artifacts/public/build/firefox-52.0a1.en-US.win64.test_packages.json to C:\slave\test\build\firefox-52.0a1.en-US.win64.test_packages.json
16:06:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dvshFOgSSIiORW6wy6HT8g/artifacts/public/build/firefox-52.0a1.en-US.win64.test_packages.json', 'file_name': 'C:\\slave\\test\\build\\firefox-52.0a1.en-US.win64.test_packages.json'}, attempt #1
16:06:34 INFO - Downloaded 1218 bytes.
16:06:34 INFO - Reading from file C:\slave\test\build\firefox-52.0a1.en-US.win64.test_packages.json
16:06:34 INFO - Using the following test package requirements:
16:06:34 INFO - {u'common': [u'firefox-52.0a1.en-US.win64.common.tests.zip'],
16:06:34 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.win64.common.tests.zip',
16:06:34 INFO - u'firefox-52.0a1.en-US.win64.cppunittest.tests.zip'],
16:06:34 INFO - u'gtest': [u'firefox-52.0a1.en-US.win64.common.tests.zip'],
16:06:34 INFO - u'jittest': [u'firefox-52.0a1.en-US.win64.common.tests.zip',
16:06:34 INFO - u'jsshell-win64.zip'],
16:06:34 INFO - u'mochitest': [u'firefox-52.0a1.en-US.win64.common.tests.zip',
16:06:34 INFO - u'firefox-52.0a1.en-US.win64.mochitest.tests.zip'],
16:06:34 INFO - u'mozbase': [u'firefox-52.0a1.en-US.win64.common.tests.zip'],
16:06:34 INFO - u'reftest': [u'firefox-52.0a1.en-US.win64.common.tests.zip',
16:06:34 INFO - u'firefox-52.0a1.en-US.win64.reftest.tests.zip'],
16:06:34 INFO - u'talos': [u'firefox-52.0a1.en-US.win64.common.tests.zip',
16:06:34 INFO - u'firefox-52.0a1.en-US.win64.talos.tests.zip'],
16:06:34 INFO - u'web-platform': [u'firefox-52.0a1.en-US.win64.common.tests.zip',
16:06:34 INFO - u'firefox-52.0a1.en-US.win64.web-platform.tests.zip'],
16:06:34 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.win64.common.tests.zip',
16:06:34 INFO - u'firefox-52.0a1.en-US.win64.xpcshell.tests.zip']}
16:06:34 INFO - Downloading packages: [u'firefox-52.0a1.en-US.win64.common.tests.zip'] for test suite category: common
16:06:34 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/dvshFOgSSIiORW6wy6HT8g/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip
16:06:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dvshFOgSSIiORW6wy6HT8g/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip'}, attempt #1
16:06:34 INFO - Fetch https://queue.taskcluster.net/v1/task/dvshFOgSSIiORW6wy6HT8g/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip into memory
16:06:35 INFO - Expected file size: 17583278
16:06:57 INFO - Downloading packages: [u'firefox-52.0a1.en-US.win64.common.tests.zip', u'firefox-52.0a1.en-US.win64.talos.tests.zip'] for test suite category: talos
16:06:57 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/dvshFOgSSIiORW6wy6HT8g/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip
16:06:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dvshFOgSSIiORW6wy6HT8g/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip'}, attempt #1
16:06:57 INFO - Fetch https://queue.taskcluster.net/v1/task/dvshFOgSSIiORW6wy6HT8g/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip into memory
16:06:57 INFO - Expected file size: 17583278
16:07:11 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/dvshFOgSSIiORW6wy6HT8g/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip
16:07:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dvshFOgSSIiORW6wy6HT8g/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip'}, attempt #1
16:07:11 INFO - Fetch https://queue.taskcluster.net/v1/task/dvshFOgSSIiORW6wy6HT8g/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip into memory
16:07:11 INFO - Expected file size: 14414059
16:07: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')]}
16:07:15 INFO - trying https://queue.taskcluster.net/v1/task/dvshFOgSSIiORW6wy6HT8g/artifacts/public/build/firefox-52.0a1.en-US.win64.zip
16:07:15 INFO - Downloading https://queue.taskcluster.net/v1/task/dvshFOgSSIiORW6wy6HT8g/artifacts/public/build/firefox-52.0a1.en-US.win64.zip to C:\slave\test\build\firefox-52.0a1.en-US.win64.zip
16:07:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dvshFOgSSIiORW6wy6HT8g/artifacts/public/build/firefox-52.0a1.en-US.win64.zip', 'file_name': 'C:\\slave\\test\\build\\firefox-52.0a1.en-US.win64.zip'}, attempt #1
16:07:17 INFO - Downloaded 57596872 bytes.
16:07:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dvshFOgSSIiORW6wy6HT8g/artifacts/public/build/firefox-52.0a1.en-US.win64.zip
16:07:17 INFO - mkdir: C:\slave\test\properties
16:07:17 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url
16:07:17 INFO - Writing to file C:\slave\test\properties\build_url
16:07:17 INFO - Contents:
16:07:17 INFO - build_url:https://queue.taskcluster.net/v1/task/dvshFOgSSIiORW6wy6HT8g/artifacts/public/build/firefox-52.0a1.en-US.win64.zip
16:07:18 INFO - Running post-action listener: _resource_record_post_action
16:07:18 INFO - Running post-action listener: set_extra_try_arguments
16:07:18 INFO - [mozharness: 2016-09-21 23:07:18.528000Z] Finished download-and-extract step (success)
16:07:18 INFO - [mozharness: 2016-09-21 23:07:18.528000Z] Running populate-webroot step.
16:07:18 INFO - Running pre-action listener: _resource_record_pre_action
16:07:18 INFO - Running main action method: populate_webroot
16:07:18 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']},
16:07:18 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']},
16:07:18 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome',
16:07:18 INFO - u'--tppagecycles',
16:07:18 INFO - u'7'],
16:07:18 INFO - u'tests': [u'tsvgm']}},
16:07:18 INFO - u'suites': {u'chromez': {u'talos_options': [u'--disable-e10s'],
16:07:18 INFO - u'tests': [u'tresize', u'tcanvasmark']},
16:07:18 INFO - u'chromez-e10s': {u'tests': [u'tresize', u'tcanvasmark']},
16:07:18 INFO - u'dromaeojs': {u'talos_options': [u'--disable-e10s'],
16:07:18 INFO - u'tests': [u'dromaeo_css', u'kraken']},
16:07:18 INFO - u'dromaeojs-e10s': {u'tests': [u'dromaeo_css', u'kraken']},
16:07:18 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
16:07:18 INFO - u'talos_options': [u'--disable-e10s'],
16:07:18 INFO - u'tests': [u'tp5o_scroll', u'glterrain']},
16:07:18 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
16:07:18 INFO - u'tests': [u'tp5o_scroll', u'glterrain']},
16:07:18 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
16:07:18 INFO - u'talos_options': [u'--disable-e10s'],
16:07:18 INFO - u'tests': [u'damp', u'tps']},
16:07:18 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
16:07:18 INFO - u'tests': [u'damp', u'tps']},
16:07:18 INFO - u'g3': {u'talos_options': [u'--disable-e10s'],
16:07:18 INFO - u'tests': [u'dromaeo_dom']},
16:07:18 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']},
16:07:18 INFO - u'g4': {u'talos_options': [u'--disable-e10s'],
16:07:18 INFO - u'tests': [u'basic_compositor_video']},
16:07:18 INFO - u'g4-e10s': {u'tests': [u'basic_compositor_video']},
16:07:18 INFO - u'other': {u'talos_options': [u'--disable-e10s'],
16:07:18 INFO - u'tests': [u'a11yr',
16:07:18 INFO - u'ts_paint',
16:07:18 INFO - u'tpaint',
16:07:18 INFO - u'sessionrestore',
16:07:18 INFO - u'sessionrestore_no_auto_restore',
16:07:18 INFO - u'tabpaint']},
16:07:18 INFO - u'other-e10s': {u'tests': [u'a11yr',
16:07:18 INFO - u'ts_paint',
16:07:18 INFO - u'tpaint',
16:07:18 INFO - u'sessionrestore',
16:07:18 INFO - u'sessionrestore_no_auto_restore',
16:07:18 INFO - u'tabpaint']},
16:07:18 INFO - u'other-e10s_l64': {u'tests': [u'a11yr',
16:07:18 INFO - u'ts_paint',
16:07:18 INFO - u'tpaint',
16:07:18 INFO - u'sessionrestore',
16:07:18 INFO - u'sessionrestore_no_auto_restore',
16:07:18 INFO - u'tabpaint']},
16:07:18 INFO - u'other-e10s_nol64': {u'tests': [u'a11yr',
16:07:18 INFO - u'ts_paint',
16:07:18 INFO - u'tpaint',
16:07:18 INFO - u'sessionrestore',
16:07:18 INFO - u'sessionrestore_no_auto_restore',
16:07:18 INFO - u'tabpaint']},
16:07:18 INFO - u'other_l64': {u'talos_options': [u'--disable-e10s'],
16:07:18 INFO - u'tests': [u'a11yr',
16:07:18 INFO - u'ts_paint',
16:07:18 INFO - u'tpaint',
16:07:18 INFO - u'sessionrestore',
16:07:18 INFO - u'sessionrestore_no_auto_restore',
16:07:18 INFO - u'tabpaint']},
16:07:18 INFO - u'other_nol64': {u'talos_options': [u'--disable-e10s'],
16:07:18 INFO - u'tests': [u'a11yr',
16:07:18 INFO - u'ts_paint',
16:07:18 INFO - u'tpaint',
16:07:18 INFO - u'sessionrestore',
16:07:18 INFO - u'sessionrestore_no_auto_restore',
16:07:18 INFO - u'tabpaint']},
16:07:18 INFO - u'svgr': {u'talos_options': [u'--disable-e10s'],
16:07:18 INFO - u'tests': [u'tsvgx',
16:07:18 INFO - u'tsvgr_opacity',
16:07:18 INFO - u'tart',
16:07:18 INFO - u'tscrollx',
16:07:18 INFO - u'cart']},
16:07:18 INFO - u'svgr-e10s': {u'tests': [u'tsvgx',
16:07:18 INFO - u'tsvgr_opacity',
16:07:18 INFO - u'tart',
16:07:18 INFO - u'tscrollx',
16:07:18 INFO - u'cart']},
16:07:18 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
16:07:18 INFO - u'talos_options': [u'--disable-e10s'],
16:07:18 INFO - u'tests': [u'tp5o']},
16:07:18 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
16:07:18 INFO - u'tests': [u'tp5o']},
16:07:18 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
16:07:18 INFO - u'talos_options': [u'--disable-e10s',
16:07:18 INFO - u'--xperf_path',
16:07:18 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
16:07:18 INFO - u'tests': [u'tp5n']},
16:07:18 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
16:07:18 INFO - u'talos_options': [u'--xperf_path',
16:07:18 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
16:07:18 INFO - u'tests': [u'tp5n']}},
16:07:18 INFO - u'talos.zip': {u'path': u'',
16:07:18 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}}
16:07:18 INFO - Running post-action listener: _resource_record_post_action
16:07:18 INFO - [mozharness: 2016-09-21 23:07:18.590000Z] Finished populate-webroot step (success)
16:07:18 INFO - [mozharness: 2016-09-21 23:07:18.590000Z] Running create-virtualenv step.
16:07:18 INFO - Running pre-action listener: _resource_record_pre_action
16:07:18 INFO - Running main action method: create_virtualenv
16:07:18 INFO - Creating virtualenv C:\slave\test\build/venv
16:07:18 INFO - mkdir: C:\slave\test\build\venv\Scripts
16:07:19 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll
16:07:19 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'!
16:07:19 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
16:07:19 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build/venv
16:07:29 INFO - New python executable in C:\slave\test\build/venv\Scripts\python.exe
16:07:31 INFO - Installing distribute......................................................................................................................................................................................done.
16:07:33 INFO - Return code: 0
16:07:33 INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv
16:07:33 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')]}
16:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
16:07:33 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')]}
16:07:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
16:07:33 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 0x0223C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022E8E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x023F0908>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02303E90>, '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 0x0079A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027D7520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-115', 'USERDOMAIN': 'T-W864-IX-115', '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-115', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-115\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-115', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-115', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-115', '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-115\\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
16:07:33 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
16:07:33 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
16:07:33 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
16:07:33 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-115\\AppData\\Roaming',
16:07:33 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
16:07:33 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
16:07:33 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
16:07:33 INFO - 'COMPUTERNAME': 'T-W864-IX-115',
16:07:33 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
16:07:33 INFO - 'DCLOCATION': 'SCL3',
16:07:33 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
16:07:33 INFO - 'FP_NO_HOST_CHECK': 'NO',
16:07:33 INFO - 'HOMEDRIVE': 'C:',
16:07:33 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-115',
16:07:33 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
16:07:33 INFO - 'KTS_VERSION': '1.19c',
16:07:33 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-115\\AppData\\Local',
16:07:33 INFO - 'LOGONSERVER': '\\\\T-W864-IX-115',
16:07:33 INFO - 'MONDIR': 'C:\\Monitor_config\\',
16:07:33 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
16:07:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
16:07:33 INFO - 'MOZ_NO_REMOTE': '1',
16:07:33 INFO - 'NO_EM_RESTART': '1',
16:07:33 INFO - 'NUMBER_OF_PROCESSORS': '8',
16:07:33 INFO - 'OS': 'Windows_NT',
16:07:33 INFO - 'OURDRIVE': 'C:',
16:07:33 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',
16:07:33 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
16:07:33 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
16:07:33 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
16:07:33 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
16:07:33 INFO - 'PROCESSOR_LEVEL': '6',
16:07:33 INFO - 'PROCESSOR_REVISION': '1e05',
16:07:33 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
16:07:33 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
16:07:33 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
16:07:33 INFO - 'PROGRAMW6432': 'C:\\Program Files',
16:07:33 INFO - 'PROMPT': '$P$G',
16:07:33 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
16:07:33 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
16:07:33 INFO - 'PUBLIC': 'C:\\Users\\Public',
16:07:33 INFO - 'PWD': 'C:\\slave\\test',
16:07:33 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
16:07:33 INFO - 'SLAVEDIR': 'C:\\slave\\',
16:07:33 INFO - 'SYSTEMDRIVE': 'C:',
16:07:33 INFO - 'SYSTEMROOT': 'C:\\windows',
16:07:33 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
16:07:33 INFO - 'TEST1': 'testie',
16:07:33 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
16:07:33 INFO - 'USERDOMAIN': 'T-W864-IX-115',
16:07:33 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-115',
16:07:33 INFO - 'USERNAME': 'cltbld',
16:07:33 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-115',
16:07:33 INFO - 'WINDIR': 'C:\\windows',
16:07:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
16:07:34 INFO - Ignoring indexes: http://pypi.python.org/simple/
16:07:34 INFO - Downloading/unpacking pip>=1.5
16:07:38 INFO - Running setup.py egg_info for package pip
16:07:38 INFO - warning: no files found matching 'pip\cacert.pem'
16:07:38 INFO - warning: no files found matching '*.html' under directory 'docs'
16:07:38 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build'
16:07:38 INFO - no previously-included directories found matching 'docs\_build\_sources'
16:07:38 INFO - Installing collected packages: pip
16:07:38 INFO - Found existing installation: pip 0.8.2
16:07:38 INFO - Uninstalling pip:
16:07:38 INFO - Successfully uninstalled pip
16:07:38 INFO - Running setup.py install for pip
16:07:38 INFO - warning: no files found matching 'pip\cacert.pem'
16:07:38 INFO - warning: no files found matching '*.html' under directory 'docs'
16:07:38 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build'
16:07:38 INFO - no previously-included directories found matching 'docs\_build\_sources'
16:07:38 INFO - Installing pip-script.py script to C:\slave\test\build\venv\Scripts
16:07:38 INFO - Installing pip.exe script to C:\slave\test\build\venv\Scripts
16:07:38 INFO - Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts
16:07:38 INFO - Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts
16:07:38 INFO - Installing pip2-script.py script to C:\slave\test\build\venv\Scripts
16:07:38 INFO - Installing pip2.exe script to C:\slave\test\build\venv\Scripts
16:07:38 INFO - Successfully installed pip
16:07:38 INFO - Cleaning up...
16:07:38 INFO - Return code: 0
16:07:38 INFO - Installing psutil>=3.1.1 into virtualenv C:\slave\test\build/venv
16:07: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')]}
16:07:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
16:07: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')]}
16:07:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
16:07: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', '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 0x0223C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022E8E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x023F0908>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02303E90>, '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 0x0079A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027D7520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-115', 'USERDOMAIN': 'T-W864-IX-115', '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-115', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-115\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-115', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-115', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-115', '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-115\\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
16:07: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', 'psutil>=3.1.1'] in C:\slave\test\build
16:07: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 psutil>=3.1.1
16:07:38 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
16:07:38 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-115\\AppData\\Roaming',
16:07:38 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
16:07:38 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
16:07:38 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
16:07:38 INFO - 'COMPUTERNAME': 'T-W864-IX-115',
16:07:38 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
16:07:38 INFO - 'DCLOCATION': 'SCL3',
16:07:38 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
16:07:38 INFO - 'FP_NO_HOST_CHECK': 'NO',
16:07:38 INFO - 'HOMEDRIVE': 'C:',
16:07:38 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-115',
16:07:38 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
16:07:38 INFO - 'KTS_VERSION': '1.19c',
16:07:38 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-115\\AppData\\Local',
16:07:38 INFO - 'LOGONSERVER': '\\\\T-W864-IX-115',
16:07:38 INFO - 'MONDIR': 'C:\\Monitor_config\\',
16:07:38 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
16:07:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
16:07:38 INFO - 'MOZ_NO_REMOTE': '1',
16:07:38 INFO - 'NO_EM_RESTART': '1',
16:07:38 INFO - 'NUMBER_OF_PROCESSORS': '8',
16:07:38 INFO - 'OS': 'Windows_NT',
16:07:38 INFO - 'OURDRIVE': 'C:',
16:07: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',
16:07:38 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
16:07:38 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
16:07:38 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
16:07:38 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
16:07:38 INFO - 'PROCESSOR_LEVEL': '6',
16:07:38 INFO - 'PROCESSOR_REVISION': '1e05',
16:07:38 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
16:07:38 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
16:07:38 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
16:07:38 INFO - 'PROGRAMW6432': 'C:\\Program Files',
16:07:38 INFO - 'PROMPT': '$P$G',
16:07:38 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
16:07:38 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
16:07:38 INFO - 'PUBLIC': 'C:\\Users\\Public',
16:07:38 INFO - 'PWD': 'C:\\slave\\test',
16:07:38 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
16:07:38 INFO - 'SLAVEDIR': 'C:\\slave\\',
16:07:38 INFO - 'SYSTEMDRIVE': 'C:',
16:07:38 INFO - 'SYSTEMROOT': 'C:\\windows',
16:07:38 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
16:07:38 INFO - 'TEST1': 'testie',
16:07:38 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
16:07:38 INFO - 'USERDOMAIN': 'T-W864-IX-115',
16:07:38 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-115',
16:07:38 INFO - 'USERNAME': 'cltbld',
16:07:38 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-115',
16:07:38 INFO - 'WINDIR': 'C:\\windows',
16:07:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
16:07:41 INFO - Ignoring indexes: https://pypi.python.org/simple/
16:07:41 INFO - Downloading/unpacking psutil>=3.1.1
16:07: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
16:07: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
16:07:42 INFO - Installing collected packages: psutil
16:07:42 INFO - Successfully installed psutil
16:07:42 INFO - Cleaning up...
16:07:42 INFO - Return code: 0
16:07:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv C:\slave\test\build/venv
16:07:42 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')]}
16:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
16:07:42 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')]}
16:07:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
16:07:42 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 0x0223C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022E8E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x023F0908>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02303E90>, '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 0x0079A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027D7520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-115', 'USERDOMAIN': 'T-W864-IX-115', '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-115', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-115\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-115', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-115', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-115', '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-115\\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
16:07:42 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
16:07:42 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
16:07:42 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
16:07:42 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-115\\AppData\\Roaming',
16:07:42 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
16:07:42 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
16:07:42 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
16:07:42 INFO - 'COMPUTERNAME': 'T-W864-IX-115',
16:07:42 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
16:07:42 INFO - 'DCLOCATION': 'SCL3',
16:07:42 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
16:07:42 INFO - 'FP_NO_HOST_CHECK': 'NO',
16:07:42 INFO - 'HOMEDRIVE': 'C:',
16:07:42 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-115',
16:07:42 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
16:07:42 INFO - 'KTS_VERSION': '1.19c',
16:07:42 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-115\\AppData\\Local',
16:07:42 INFO - 'LOGONSERVER': '\\\\T-W864-IX-115',
16:07:42 INFO - 'MONDIR': 'C:\\Monitor_config\\',
16:07:42 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
16:07:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
16:07:42 INFO - 'MOZ_NO_REMOTE': '1',
16:07:42 INFO - 'NO_EM_RESTART': '1',
16:07:42 INFO - 'NUMBER_OF_PROCESSORS': '8',
16:07:42 INFO - 'OS': 'Windows_NT',
16:07:42 INFO - 'OURDRIVE': 'C:',
16:07:42 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',
16:07:42 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
16:07:42 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
16:07:42 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
16:07:42 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
16:07:42 INFO - 'PROCESSOR_LEVEL': '6',
16:07:42 INFO - 'PROCESSOR_REVISION': '1e05',
16:07:42 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
16:07:42 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
16:07:42 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
16:07:42 INFO - 'PROGRAMW6432': 'C:\\Program Files',
16:07:42 INFO - 'PROMPT': '$P$G',
16:07:42 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
16:07:42 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
16:07:42 INFO - 'PUBLIC': 'C:\\Users\\Public',
16:07:42 INFO - 'PWD': 'C:\\slave\\test',
16:07:42 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
16:07:42 INFO - 'SLAVEDIR': 'C:\\slave\\',
16:07:42 INFO - 'SYSTEMDRIVE': 'C:',
16:07:42 INFO - 'SYSTEMROOT': 'C:\\windows',
16:07:42 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
16:07:42 INFO - 'TEST1': 'testie',
16:07:42 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
16:07:42 INFO - 'USERDOMAIN': 'T-W864-IX-115',
16:07:42 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-115',
16:07:42 INFO - 'USERNAME': 'cltbld',
16:07:42 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-115',
16:07:42 INFO - 'WINDIR': 'C:\\windows',
16:07:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
16:07:43 INFO - Ignoring indexes: https://pypi.python.org/simple/
16:07:43 INFO - Downloading/unpacking mozsystemmonitor==0.3
16:07:43 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
16:07:43 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
16:07:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz
16:07:44 INFO - Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor
16:07:44 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)
16:07:44 INFO - Installing collected packages: mozsystemmonitor
16:07:44 INFO - Running setup.py install for mozsystemmonitor
16:07:44 INFO - Successfully installed mozsystemmonitor
16:07:44 INFO - Cleaning up...
16:07:44 INFO - Return code: 0
16:07:44 INFO - Installing jsonschema==2.5.1 into virtualenv C:\slave\test\build/venv
16:07: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')]}
16:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
16:07: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')]}
16:07:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
16:07:44 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x0223C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022E8E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x023F0908>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02303E90>, '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 0x0079A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027D7520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-115', 'USERDOMAIN': 'T-W864-IX-115', '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-115', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-115\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-115', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-115', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-115', '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-115\\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
16:07:44 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in C:\slave\test\build
16:07:44 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1
16:07:44 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
16:07:44 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-115\\AppData\\Roaming',
16:07:44 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
16:07:44 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
16:07:44 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
16:07:44 INFO - 'COMPUTERNAME': 'T-W864-IX-115',
16:07:44 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
16:07:44 INFO - 'DCLOCATION': 'SCL3',
16:07:44 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
16:07:44 INFO - 'FP_NO_HOST_CHECK': 'NO',
16:07:44 INFO - 'HOMEDRIVE': 'C:',
16:07:44 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-115',
16:07:44 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
16:07:44 INFO - 'KTS_VERSION': '1.19c',
16:07:44 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-115\\AppData\\Local',
16:07:44 INFO - 'LOGONSERVER': '\\\\T-W864-IX-115',
16:07:44 INFO - 'MONDIR': 'C:\\Monitor_config\\',
16:07:44 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
16:07:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
16:07:44 INFO - 'MOZ_NO_REMOTE': '1',
16:07:44 INFO - 'NO_EM_RESTART': '1',
16:07:44 INFO - 'NUMBER_OF_PROCESSORS': '8',
16:07:44 INFO - 'OS': 'Windows_NT',
16:07:44 INFO - 'OURDRIVE': 'C:',
16:07:44 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
16:07:44 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
16:07:44 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
16:07:44 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
16:07:44 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
16:07:44 INFO - 'PROCESSOR_LEVEL': '6',
16:07:44 INFO - 'PROCESSOR_REVISION': '1e05',
16:07:44 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
16:07:44 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
16:07:44 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
16:07:44 INFO - 'PROGRAMW6432': 'C:\\Program Files',
16:07:44 INFO - 'PROMPT': '$P$G',
16:07:44 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
16:07:44 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
16:07:44 INFO - 'PUBLIC': 'C:\\Users\\Public',
16:07:44 INFO - 'PWD': 'C:\\slave\\test',
16:07:44 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
16:07:44 INFO - 'SLAVEDIR': 'C:\\slave\\',
16:07:44 INFO - 'SYSTEMDRIVE': 'C:',
16:07:44 INFO - 'SYSTEMROOT': 'C:\\windows',
16:07:44 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
16:07:44 INFO - 'TEST1': 'testie',
16:07:44 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
16:07:44 INFO - 'USERDOMAIN': 'T-W864-IX-115',
16:07:44 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-115',
16:07:44 INFO - 'USERNAME': 'cltbld',
16:07:44 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-115',
16:07:44 INFO - 'WINDIR': 'C:\\windows',
16:07:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
16:07:44 INFO - Ignoring indexes: https://pypi.python.org/simple/
16:07:44 INFO - Downloading/unpacking jsonschema==2.5.1
16:07:44 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
16:07:44 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
16:07:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl
16:07:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1)
16:07:45 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
16:07:45 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
16:07:45 INFO - Downloading functools32-3.2.3-2.tar.gz
16:07:45 INFO - Running setup.py (path:C:\slave\test\build\venv\build\functools32\setup.py) egg_info for package functools32
16:07:46 INFO - warning: no files found matching '*.txt'
16:07:46 INFO - no previously-included directories found matching 'build'
16:07:46 INFO - no previously-included directories found matching 'dist'
16:07:46 INFO - no previously-included directories found matching '.git*'
16:07:46 INFO - Installing collected packages: jsonschema, functools32
16:07:46 INFO - Running setup.py install for functools32
16:07:46 INFO - warning: no files found matching '*.txt'
16:07:46 INFO - no previously-included directories found matching 'build'
16:07:46 INFO - no previously-included directories found matching 'dist'
16:07:46 INFO - no previously-included directories found matching '.git*'
16:07:46 INFO - Successfully installed jsonschema functools32
16:07:46 INFO - Cleaning up...
16:07:47 INFO - Return code: 0
16:07:47 INFO - Installing functools32==3.2.3-2 into virtualenv C:\slave\test\build/venv
16:07:47 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')]}
16:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
16:07:47 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')]}
16:07:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
16:07:47 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 0x0223C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022E8E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x023F0908>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02303E90>, '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 0x0079A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027D7520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-115', 'USERDOMAIN': 'T-W864-IX-115', '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-115', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-115\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-115', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-115', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-115', '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-115\\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
16:07:47 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
16:07:47 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
16:07:47 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
16:07:47 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-115\\AppData\\Roaming',
16:07:47 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
16:07:47 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
16:07:47 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
16:07:47 INFO - 'COMPUTERNAME': 'T-W864-IX-115',
16:07:47 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
16:07:47 INFO - 'DCLOCATION': 'SCL3',
16:07:47 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
16:07:47 INFO - 'FP_NO_HOST_CHECK': 'NO',
16:07:47 INFO - 'HOMEDRIVE': 'C:',
16:07:47 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-115',
16:07:47 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
16:07:47 INFO - 'KTS_VERSION': '1.19c',
16:07:47 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-115\\AppData\\Local',
16:07:47 INFO - 'LOGONSERVER': '\\\\T-W864-IX-115',
16:07:47 INFO - 'MONDIR': 'C:\\Monitor_config\\',
16:07:47 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
16:07:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
16:07:47 INFO - 'MOZ_NO_REMOTE': '1',
16:07:47 INFO - 'NO_EM_RESTART': '1',
16:07:47 INFO - 'NUMBER_OF_PROCESSORS': '8',
16:07:47 INFO - 'OS': 'Windows_NT',
16:07:47 INFO - 'OURDRIVE': 'C:',
16:07:47 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',
16:07:47 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
16:07:47 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
16:07:47 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
16:07:47 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
16:07:47 INFO - 'PROCESSOR_LEVEL': '6',
16:07:47 INFO - 'PROCESSOR_REVISION': '1e05',
16:07:47 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
16:07:47 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
16:07:47 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
16:07:47 INFO - 'PROGRAMW6432': 'C:\\Program Files',
16:07:47 INFO - 'PROMPT': '$P$G',
16:07:47 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
16:07:47 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
16:07:47 INFO - 'PUBLIC': 'C:\\Users\\Public',
16:07:47 INFO - 'PWD': 'C:\\slave\\test',
16:07:47 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
16:07:47 INFO - 'SLAVEDIR': 'C:\\slave\\',
16:07:47 INFO - 'SYSTEMDRIVE': 'C:',
16:07:47 INFO - 'SYSTEMROOT': 'C:\\windows',
16:07:47 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
16:07:47 INFO - 'TEST1': 'testie',
16:07:47 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
16:07:47 INFO - 'USERDOMAIN': 'T-W864-IX-115',
16:07:47 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-115',
16:07:47 INFO - 'USERNAME': 'cltbld',
16:07:47 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-115',
16:07:47 INFO - 'WINDIR': 'C:\\windows',
16:07:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
16:07:47 INFO - Ignoring indexes: https://pypi.python.org/simple/
16:07:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in c:\slave\test\build\venv\lib\site-packages
16:07:47 INFO - Cleaning up...
16:07:47 INFO - Return code: 0
16:07:47 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv
16:07:47 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')]}
16:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
16:07:47 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')]}
16:07:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
16:07:47 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 0x0223C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022E8E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x023F0908>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02303E90>, '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 0x0079A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027D7520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-115', 'USERDOMAIN': 'T-W864-IX-115', '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-115', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-115\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-115', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-115', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-115', '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-115\\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
16:07:47 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
16:07:47 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
16:07:47 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
16:07:47 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-115\\AppData\\Roaming',
16:07:47 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
16:07:47 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
16:07:47 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
16:07:47 INFO - 'COMPUTERNAME': 'T-W864-IX-115',
16:07:47 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
16:07:47 INFO - 'DCLOCATION': 'SCL3',
16:07:47 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
16:07:47 INFO - 'FP_NO_HOST_CHECK': 'NO',
16:07:47 INFO - 'HOMEDRIVE': 'C:',
16:07:47 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-115',
16:07:47 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
16:07:47 INFO - 'KTS_VERSION': '1.19c',
16:07:47 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-115\\AppData\\Local',
16:07:47 INFO - 'LOGONSERVER': '\\\\T-W864-IX-115',
16:07:47 INFO - 'MONDIR': 'C:\\Monitor_config\\',
16:07:47 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
16:07:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
16:07:47 INFO - 'MOZ_NO_REMOTE': '1',
16:07:47 INFO - 'NO_EM_RESTART': '1',
16:07:47 INFO - 'NUMBER_OF_PROCESSORS': '8',
16:07:47 INFO - 'OS': 'Windows_NT',
16:07:47 INFO - 'OURDRIVE': 'C:',
16:07:47 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',
16:07:47 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
16:07:47 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
16:07:47 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
16:07:47 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
16:07:47 INFO - 'PROCESSOR_LEVEL': '6',
16:07:47 INFO - 'PROCESSOR_REVISION': '1e05',
16:07:47 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
16:07:47 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
16:07:47 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
16:07:47 INFO - 'PROGRAMW6432': 'C:\\Program Files',
16:07:47 INFO - 'PROMPT': '$P$G',
16:07:47 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
16:07:47 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
16:07:47 INFO - 'PUBLIC': 'C:\\Users\\Public',
16:07:47 INFO - 'PWD': 'C:\\slave\\test',
16:07:47 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
16:07:47 INFO - 'SLAVEDIR': 'C:\\slave\\',
16:07:47 INFO - 'SYSTEMDRIVE': 'C:',
16:07:47 INFO - 'SYSTEMROOT': 'C:\\windows',
16:07:47 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
16:07:47 INFO - 'TEST1': 'testie',
16:07:47 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
16:07:47 INFO - 'USERDOMAIN': 'T-W864-IX-115',
16:07:47 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-115',
16:07:47 INFO - 'USERNAME': 'cltbld',
16:07:47 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-115',
16:07:47 INFO - 'WINDIR': 'C:\\windows',
16:07:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
16:07:47 INFO - Ignoring indexes: https://pypi.python.org/simple/
16:07:47 INFO - Downloading/unpacking blobuploader==1.2.4
16:07:47 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
16:07:47 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
16:07:48 INFO - Downloading blobuploader-1.2.4.tar.gz
16:07:48 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader
16:07:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4)
16:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
16:07:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
16:07:49 INFO - Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests
16:07:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4)
16:07:49 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
16:07:49 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
16:07:49 INFO - Downloading docopt-0.6.1.tar.gz
16:07:49 INFO - Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt
16:07:50 INFO - Installing collected packages: blobuploader, requests, docopt
16:07:50 INFO - Running setup.py install for blobuploader
16:07:50 INFO - Running setup.py install for requests
16:07:50 INFO - Running setup.py install for docopt
16:07:51 INFO - Successfully installed blobuploader requests docopt
16:07:51 INFO - Cleaning up...
16:07:52 INFO - Return code: 0
16:07:52 INFO - Installing None into virtualenv C:\slave\test\build/venv
16:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
16:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
16:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
16:07:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
16:07:52 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 0x0223C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022E8E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x023F0908>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02303E90>, '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 0x0079A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027D7520>, '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-115', 'USERDOMAIN': 'T-W864-IX-115', '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-115', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-115\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-115', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-115', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-115', '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-115\\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
16:07:52 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
16:07:52 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
16:07:52 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
16:07:52 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-115\\AppData\\Roaming',
16:07:52 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
16:07:52 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
16:07:52 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
16:07:52 INFO - 'COMPUTERNAME': 'T-W864-IX-115',
16:07:52 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
16:07:52 INFO - 'DCLOCATION': 'SCL3',
16:07:52 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
16:07:52 INFO - 'FP_NO_HOST_CHECK': 'NO',
16:07:52 INFO - 'HOMEDRIVE': 'C:',
16:07:52 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-115',
16:07:52 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
16:07:52 INFO - 'KTS_VERSION': '1.19c',
16:07:52 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-115\\AppData\\Local',
16:07:52 INFO - 'LOGONSERVER': '\\\\T-W864-IX-115',
16:07:52 INFO - 'MONDIR': 'C:\\Monitor_config\\',
16:07:52 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
16:07:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
16:07:52 INFO - 'MOZ_NO_REMOTE': '1',
16:07:52 INFO - 'NO_EM_RESTART': '1',
16:07:52 INFO - 'NUMBER_OF_PROCESSORS': '8',
16:07:52 INFO - 'OS': 'Windows_NT',
16:07:52 INFO - 'OURDRIVE': 'C:',
16:07:52 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
16:07:52 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
16:07:52 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
16:07:52 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
16:07:52 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
16:07:52 INFO - 'PROCESSOR_LEVEL': '6',
16:07:52 INFO - 'PROCESSOR_REVISION': '1e05',
16:07:52 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
16:07:52 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
16:07:52 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
16:07:52 INFO - 'PROGRAMW6432': 'C:\\Program Files',
16:07:52 INFO - 'PROMPT': '$P$G',
16:07:52 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
16:07:52 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
16:07:52 INFO - 'PUBLIC': 'C:\\Users\\Public',
16:07:52 INFO - 'PWD': 'C:\\slave\\test',
16:07:52 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
16:07:52 INFO - 'SLAVEDIR': 'C:\\slave\\',
16:07:52 INFO - 'SYSTEMDRIVE': 'C:',
16:07:52 INFO - 'SYSTEMROOT': 'C:\\windows',
16:07:52 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
16:07:52 INFO - 'TEST1': 'testie',
16:07:52 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
16:07:52 INFO - 'USERDOMAIN': 'T-W864-IX-115',
16:07:52 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-115',
16:07:52 INFO - 'USERNAME': 'cltbld',
16:07:52 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-115',
16:07:52 INFO - 'WINDIR': 'C:\\windows',
16:07:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
16:07:52 INFO - Ignoring indexes: https://pypi.python.org/simple/
16:07:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser
16:07:52 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qhu05p-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser
16:07:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash
16:07:52 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-j5nx1u-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash
16:07:52 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug
16:07:52 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-fzz7ls-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug
16:07:53 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice
16:07:53 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qw2emk-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice
16:07:53 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile
16:07:53 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-m1kntb-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile
16:07:53 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd
16:07:53 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ebci71-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd
16:07:53 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo
16:07:53 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-pdu7yy-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo
16:07:53 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall
16:07:53 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-oll08k-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall
16:07:53 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak
16:07:53 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qagjrm-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak
16:07:53 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog
16:07:53 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-hjo5cj-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog
16:07:53 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork
16:07:53 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-y_clbc-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork
16:07:53 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess
16:07:54 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-keucvd-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess
16:07:54 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile
16:07:54 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ryd67t-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile
16:07:54 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner
16:07:54 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-dwrhjv-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner
16:07:54 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot
16:07:54 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-eccpq4-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot
16:07:54 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest
16:07:54 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jtp8cg-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest
16:07:54 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion
16:07:54 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-clxa9b-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion
16:07:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion
16:07:54 INFO - Running setup.py install for manifestparser
16:07:54 INFO - Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts
16:07:54 INFO - Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts
16:07:55 INFO - Running setup.py install for mozcrash
16:07:56 INFO - Running setup.py install for mozdebug
16:07:56 INFO - Running setup.py install for mozdevice
16:07:56 INFO - Installing sutini-script.py script to C:\slave\test\build\venv\Scripts
16:07:56 INFO - Installing sutini.exe script to C:\slave\test\build\venv\Scripts
16:07:56 INFO - Installing dm-script.py script to C:\slave\test\build\venv\Scripts
16:07:56 INFO - Installing dm.exe script to C:\slave\test\build\venv\Scripts
16:07:57 INFO - Running setup.py install for mozfile
16:07:57 INFO - Running setup.py install for mozhttpd
16:07:57 INFO - Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts
16:07:57 INFO - Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts
16:07:58 INFO - Running setup.py install for mozinfo
16:07:58 INFO - Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts
16:07:58 INFO - Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts
16:07:58 INFO - Running setup.py install for mozInstall
16:07:58 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts
16:07:58 INFO - Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts
16:07:58 INFO - Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts
16:07:58 INFO - Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts
16:07:58 INFO - Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts
16:07:58 INFO - Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts
16:07:58 INFO - Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts
16:07:58 INFO - Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts
16:07:58 INFO - Running setup.py install for mozleak
16:07:59 INFO - Running setup.py install for mozlog
16:07:59 INFO - Installing structlog-script.py script to C:\slave\test\build\venv\Scripts
16:07:59 INFO - Installing structlog.exe script to C:\slave\test\build\venv\Scripts
16:08:00 INFO - Running setup.py install for moznetwork
16:08:00 INFO - Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts
16:08:00 INFO - Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts
16:08:00 INFO - Running setup.py install for mozprocess
16:08:01 INFO - Running setup.py install for mozprofile
16:08:01 INFO - Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts
16:08:01 INFO - Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts
16:08:01 INFO - Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts
16:08:01 INFO - Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts
16:08:01 INFO - Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts
16:08:01 INFO - Installing view-profile.exe script to C:\slave\test\build\venv\Scripts
16:08:02 INFO - Running setup.py install for mozrunner
16:08:02 INFO - Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts
16:08:02 INFO - Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts
16:08:02 INFO - Running setup.py install for mozscreenshot
16:08:03 INFO - Running setup.py install for moztest
16:08:03 INFO - Running setup.py install for mozversion
16:08:03 INFO - Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts
16:08:03 INFO - Installing mozversion.exe script to C:\slave\test\build\venv\Scripts
16:08:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion
16:08:03 INFO - Cleaning up...
16:08:03 INFO - Return code: 0
16:08:03 INFO - Installing None into virtualenv C:\slave\test\build/venv
16:08: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')]}
16:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
16:08: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')]}
16:08:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
16:08:03 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 0x0223C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022E8E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x023F0908>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02303E90>, '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 0x0079A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027D7520>, '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-115', 'USERDOMAIN': 'T-W864-IX-115', '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-115', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-115\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-115', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-115', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-115', '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-115\\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
16:08:03 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
16:08:03 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
16:08:03 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
16:08:03 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-115\\AppData\\Roaming',
16:08:03 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
16:08:03 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
16:08:03 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
16:08:03 INFO - 'COMPUTERNAME': 'T-W864-IX-115',
16:08:03 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
16:08:03 INFO - 'DCLOCATION': 'SCL3',
16:08:03 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
16:08:03 INFO - 'FP_NO_HOST_CHECK': 'NO',
16:08:03 INFO - 'HOMEDRIVE': 'C:',
16:08:03 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-115',
16:08:03 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
16:08:03 INFO - 'KTS_VERSION': '1.19c',
16:08:03 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-115\\AppData\\Local',
16:08:03 INFO - 'LOGONSERVER': '\\\\T-W864-IX-115',
16:08:03 INFO - 'MONDIR': 'C:\\Monitor_config\\',
16:08:03 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
16:08:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
16:08:03 INFO - 'MOZ_NO_REMOTE': '1',
16:08:03 INFO - 'NO_EM_RESTART': '1',
16:08:03 INFO - 'NUMBER_OF_PROCESSORS': '8',
16:08:03 INFO - 'OS': 'Windows_NT',
16:08:03 INFO - 'OURDRIVE': 'C:',
16:08:03 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
16:08:03 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
16:08:03 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
16:08:03 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
16:08:03 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
16:08:03 INFO - 'PROCESSOR_LEVEL': '6',
16:08:03 INFO - 'PROCESSOR_REVISION': '1e05',
16:08:03 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
16:08:03 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
16:08:03 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
16:08:03 INFO - 'PROGRAMW6432': 'C:\\Program Files',
16:08:03 INFO - 'PROMPT': '$P$G',
16:08:03 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
16:08:03 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
16:08:03 INFO - 'PUBLIC': 'C:\\Users\\Public',
16:08:03 INFO - 'PWD': 'C:\\slave\\test',
16:08:03 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
16:08:03 INFO - 'SLAVEDIR': 'C:\\slave\\',
16:08:03 INFO - 'SYSTEMDRIVE': 'C:',
16:08:03 INFO - 'SYSTEMROOT': 'C:\\windows',
16:08:03 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
16:08:03 INFO - 'TEST1': 'testie',
16:08:03 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
16:08:03 INFO - 'USERDOMAIN': 'T-W864-IX-115',
16:08:03 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-115',
16:08:03 INFO - 'USERNAME': 'cltbld',
16:08:03 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-115',
16:08:03 INFO - 'WINDIR': 'C:\\windows',
16:08:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
16:08:04 INFO - Ignoring indexes: https://pypi.python.org/simple/
16:08:04 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser
16:08:04 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-goyce9-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser
16:08:04 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))
16:08:04 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash
16:08:04 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-wmsu2z-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash
16:08:04 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))
16:08:04 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug
16:08:04 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-an4atx-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug
16:08:04 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))
16:08:04 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice
16:08:04 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-cws1ca-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice
16:08:04 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))
16:08:04 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile
16:08:04 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-dghepm-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile
16:08:04 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))
16:08:04 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd
16:08:04 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-fgo2r6-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd
16:08:04 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))
16:08:04 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo
16:08:04 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-lbh2df-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo
16:08:04 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))
16:08:04 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall
16:08:04 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-p5mdot-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall
16:08:05 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))
16:08:05 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak
16:08:05 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-bmaaex-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak
16:08:05 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))
16:08:05 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog
16:08:05 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-_rmxhf-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog
16:08:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///C:/slave/test/build/tests/mozbase/mozlog in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10))
16:08:05 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork
16:08:05 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-sj7a2w-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork
16:08:05 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))
16:08:05 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess
16:08:05 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-1lguzi-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess
16:08:05 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))
16:08:05 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile
16:08:05 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-vkpn1c-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile
16:08:05 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))
16:08:05 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner
16:08:05 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-sk9hji-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner
16:08:05 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))
16:08:05 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot
16:08:05 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ygiwsv-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot
16:08:05 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))
16:08:05 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest
16:08:05 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-olro3_-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest
16:08:06 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))
16:08:06 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion
16:08:06 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-cakmre-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion
16:08:06 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))
16:08:06 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))
16:08:06 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))
16:08:06 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))
16:08:06 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))
16:08:06 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))
16:08:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10))
16:08:06 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
16:08:06 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
16:08:07 INFO - Downloading blessings-1.6.tar.gz
16:08:07 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings
16:08:07 INFO - Installing collected packages: blessings
16:08:07 INFO - Running setup.py install for blessings
16:08:07 INFO - Successfully installed blessings
16:08:07 INFO - Cleaning up...
16:08:10 INFO - Return code: 0
16:08:10 INFO - Done creating virtualenv C:\slave\test\build/venv.
16:08:10 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze']
16:08:10 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze
16:08:10 INFO - Reading from file tmpfile_stdout
16:08:10 INFO - Using _rmtree_windows ...
16:08:10 INFO - Using _rmtree_windows ...
16:08:10 INFO - Current package versions:
16:08:10 INFO - blessings == 1.6
16:08:10 INFO - blobuploader == 1.2.4
16:08:10 INFO - docopt == 0.6.1
16:08:10 INFO - functools32 == 3.2.3-2
16:08:10 INFO - jsonschema == 2.5.1
16:08:10 INFO - manifestparser == 1.1
16:08:10 INFO - mozInstall == 1.12
16:08:10 INFO - mozcrash == 0.17
16:08:10 INFO - mozdebug == 0.1
16:08:10 INFO - mozdevice == 0.48
16:08:10 INFO - mozfile == 1.2
16:08:10 INFO - mozhttpd == 0.7
16:08:10 INFO - mozinfo == 0.9
16:08:10 INFO - mozleak == 0.1
16:08:10 INFO - mozlog == 3.4
16:08:10 INFO - moznetwork == 0.27
16:08:10 INFO - mozprocess == 0.23
16:08:10 INFO - mozprofile == 0.28
16:08:10 INFO - mozrunner == 6.12
16:08:10 INFO - mozscreenshot == 0.1
16:08:10 INFO - mozsystemmonitor == 0.3
16:08:10 INFO - moztest == 0.7
16:08:10 INFO - mozversion == 1.4
16:08:10 INFO - psutil == 3.1.1
16:08:10 INFO - requests == 1.2.3
16:08:10 INFO - Installing None into virtualenv C:\slave\test\build/venv
16:08:10 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')]}
16:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
16:08:10 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')]}
16:08:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
16:08:10 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 0x0223C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022E8E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x023F0908>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02303E90>, '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 0x0079A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027D7520>, '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-115', 'USERDOMAIN': 'T-W864-IX-115', '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-115', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-115\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-115', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-115', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-115', '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-115\\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
16:08:10 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
16:08:10 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
16:08:10 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
16:08:10 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-115\\AppData\\Roaming',
16:08:10 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
16:08:10 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
16:08:10 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
16:08:10 INFO - 'COMPUTERNAME': 'T-W864-IX-115',
16:08:10 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
16:08:10 INFO - 'DCLOCATION': 'SCL3',
16:08:10 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
16:08:10 INFO - 'FP_NO_HOST_CHECK': 'NO',
16:08:10 INFO - 'HOMEDRIVE': 'C:',
16:08:10 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-115',
16:08:10 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
16:08:10 INFO - 'KTS_VERSION': '1.19c',
16:08:10 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-115\\AppData\\Local',
16:08:10 INFO - 'LOGONSERVER': '\\\\T-W864-IX-115',
16:08:10 INFO - 'MONDIR': 'C:\\Monitor_config\\',
16:08:10 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
16:08:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
16:08:10 INFO - 'MOZ_NO_REMOTE': '1',
16:08:10 INFO - 'NO_EM_RESTART': '1',
16:08:10 INFO - 'NUMBER_OF_PROCESSORS': '8',
16:08:10 INFO - 'OS': 'Windows_NT',
16:08:10 INFO - 'OURDRIVE': 'C:',
16:08:10 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',
16:08:10 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
16:08:10 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
16:08:10 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
16:08:10 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
16:08:10 INFO - 'PROCESSOR_LEVEL': '6',
16:08:10 INFO - 'PROCESSOR_REVISION': '1e05',
16:08:10 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
16:08:10 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
16:08:10 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
16:08:10 INFO - 'PROGRAMW6432': 'C:\\Program Files',
16:08:10 INFO - 'PROMPT': '$P$G',
16:08:10 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
16:08:10 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
16:08:10 INFO - 'PUBLIC': 'C:\\Users\\Public',
16:08:10 INFO - 'PWD': 'C:\\slave\\test',
16:08:10 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
16:08:10 INFO - 'SLAVEDIR': 'C:\\slave\\',
16:08:10 INFO - 'SYSTEMDRIVE': 'C:',
16:08:10 INFO - 'SYSTEMROOT': 'C:\\windows',
16:08:10 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
16:08:10 INFO - 'TEST1': 'testie',
16:08:10 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
16:08:10 INFO - 'USERDOMAIN': 'T-W864-IX-115',
16:08:10 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-115',
16:08:10 INFO - 'USERNAME': 'cltbld',
16:08:10 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-115',
16:08:10 INFO - 'WINDIR': 'C:\\windows',
16:08:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
16:08:11 INFO - Ignoring indexes: https://pypi.python.org/simple/
16:08:11 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))
16:08:11 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))
16:08:11 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))
16:08:11 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))
16:08:11 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))
16:08:11 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))
16:08:11 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))
16:08:11 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))
16:08:11 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))
16:08:11 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))
16:08:11 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))
16:08:11 INFO - Cleaning up...
16:08:11 INFO - Return code: 0
16:08:11 INFO - Installing jsonschema into virtualenv C:\slave\test\build/venv
16:08: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')]}
16:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
16:08: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')]}
16:08:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
16:08:11 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 0x0223C640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022E8E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x023F0908>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02303E90>, '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 0x0079A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027D7520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-115', 'USERDOMAIN': 'T-W864-IX-115', '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-115', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-115\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-115', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-115', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-115', '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-115\\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
16:08:11 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
16:08:11 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
16:08:11 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
16:08:11 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-115\\AppData\\Roaming',
16:08:11 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
16:08:11 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
16:08:11 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
16:08:11 INFO - 'COMPUTERNAME': 'T-W864-IX-115',
16:08:11 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
16:08:11 INFO - 'DCLOCATION': 'SCL3',
16:08:11 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
16:08:11 INFO - 'FP_NO_HOST_CHECK': 'NO',
16:08:11 INFO - 'HOMEDRIVE': 'C:',
16:08:11 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-115',
16:08:11 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
16:08:11 INFO - 'KTS_VERSION': '1.19c',
16:08:11 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-115\\AppData\\Local',
16:08:11 INFO - 'LOGONSERVER': '\\\\T-W864-IX-115',
16:08:11 INFO - 'MONDIR': 'C:\\Monitor_config\\',
16:08:11 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
16:08:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
16:08:11 INFO - 'MOZ_NO_REMOTE': '1',
16:08:11 INFO - 'NO_EM_RESTART': '1',
16:08:11 INFO - 'NUMBER_OF_PROCESSORS': '8',
16:08:11 INFO - 'OS': 'Windows_NT',
16:08:11 INFO - 'OURDRIVE': 'C:',
16:08:11 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',
16:08:11 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
16:08:11 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
16:08:11 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
16:08:11 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
16:08:11 INFO - 'PROCESSOR_LEVEL': '6',
16:08:11 INFO - 'PROCESSOR_REVISION': '1e05',
16:08:11 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
16:08:11 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
16:08:11 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
16:08:11 INFO - 'PROGRAMW6432': 'C:\\Program Files',
16:08:11 INFO - 'PROMPT': '$P$G',
16:08:11 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
16:08:11 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
16:08:11 INFO - 'PUBLIC': 'C:\\Users\\Public',
16:08:11 INFO - 'PWD': 'C:\\slave\\test',
16:08:11 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
16:08:11 INFO - 'SLAVEDIR': 'C:\\slave\\',
16:08:11 INFO - 'SYSTEMDRIVE': 'C:',
16:08:11 INFO - 'SYSTEMROOT': 'C:\\windows',
16:08:11 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
16:08:11 INFO - 'TEST1': 'testie',
16:08:11 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
16:08:11 INFO - 'USERDOMAIN': 'T-W864-IX-115',
16:08:11 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-115',
16:08:11 INFO - 'USERNAME': 'cltbld',
16:08:11 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-115',
16:08:11 INFO - 'WINDIR': 'C:\\windows',
16:08:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
16:08:11 INFO - Ignoring indexes: https://pypi.python.org/simple/
16:08:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in c:\slave\test\build\venv\lib\site-packages
16:08:11 INFO - Cleaning up...
16:08:11 INFO - Return code: 0
16:08:11 INFO - Running post-action listener: _resource_record_post_action
16:08:11 INFO - Running post-action listener: _start_resource_monitoring
16:08:11 INFO - Starting resource monitoring.
16:08:11 INFO - [mozharness: 2016-09-21 23:08:11.657000Z] Finished create-virtualenv step (success)
16:08:11 INFO - [mozharness: 2016-09-21 23:08:11.657000Z] Running install step.
16:08:11 INFO - Running pre-action listener: _resource_record_pre_action
16:08:11 INFO - Running main action method: install
16:08:11 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze']
16:08:11 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze
16:08:11 INFO - Reading from file tmpfile_stdout
16:08:11 INFO - Using _rmtree_windows ...
16:08:11 INFO - Using _rmtree_windows ...
16:08:11 INFO - Detecting whether we're running mozinstall >=1.0...
16:08:11 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h']
16:08:11 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h
16:08:12 INFO - Reading from file tmpfile_stdout
16:08:12 INFO - Output received:
16:08:12 INFO - Usage: mozinstall-script.py [options] installer
16:08:12 INFO - Options:
16:08:12 INFO - -h, --help show this help message and exit
16:08:12 INFO - -d DEST, --destination=DEST
16:08:12 INFO - Directory to install application into. [default:
16:08:12 INFO - "C:\slave\test"]
16:08:12 INFO - --app=APP Application being installed. [default: firefox]
16:08:12 INFO - Using _rmtree_windows ...
16:08:12 INFO - Using _rmtree_windows ...
16:08:12 INFO - mkdir: C:\slave\test\build\application
16:08:12 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', 'C:\\slave\\test\\build\\firefox-52.0a1.en-US.win64.zip', '--destination', 'C:\\slave\\test\\build\\application']
16:08:12 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py C:\slave\test\build\firefox-52.0a1.en-US.win64.zip --destination C:\slave\test\build\application
ProcessManager NOT managing child processes
16:08:14 INFO - Reading from file tmpfile_stdout
16:08:14 INFO - Output received:
16:08:14 INFO - C:\slave\test\build\application\firefox\firefox.exe
16:08:14 INFO - Using _rmtree_windows ...
16:08:14 INFO - Using _rmtree_windows ...
16:08:14 INFO - Running post-action listener: _resource_record_post_action
16:08:14 INFO - [mozharness: 2016-09-21 23:08:14.281000Z] Finished install step (success)
16:08:14 INFO - [mozharness: 2016-09-21 23:08:14.281000Z] Running run-tests step.
16:08:14 INFO - Running pre-action listener: _resource_record_pre_action
16:08:14 INFO - Running main action method: run_tests
16:08:14 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version']
16:08:14 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version
16:08:14 INFO - Python 2.7.3
16:08:14 INFO - Return code: 0
16:08:14 INFO - grabbing minidump binary from tooltool
16:08:14 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')]}
16:08:14 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 0x02303E90>, '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 0x0079A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027D7520>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1
16:08:14 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
16:08:14 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
16:08:14 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
16:08:14 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'...
16:08:16 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmpc4f_6s
16:08:16 INFO - INFO - File integrity verified, renaming tmpc4f_6s to win32-minidump_stackwalk.exe
16:08:16 INFO - Return code: 0
16:08:16 INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755
16:08:16 INFO - mkdir: C:\slave\test\build\blobber_upload_dir
16:08:16 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir
16:08:16 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe
16:08:16 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir
16:08:16 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dvshFOgSSIiORW6wy6HT8g/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-115', '--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
16:08:16 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\tests\talos\talos\run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath C:\slave\test\build\application\firefox\firefox --symbolsPath https://queue.taskcluster.net/v1/task/dvshFOgSSIiORW6wy6HT8g/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip --title T-W864-IX-115 --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
16:08:16 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
16:08:16 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-115\\AppData\\Roaming',
16:08:16 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
16:08:16 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
16:08:16 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
16:08:16 INFO - 'COMPUTERNAME': 'T-W864-IX-115',
16:08:16 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
16:08:16 INFO - 'DCLOCATION': 'SCL3',
16:08:16 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
16:08:16 INFO - 'FP_NO_HOST_CHECK': 'NO',
16:08:16 INFO - 'HOMEDRIVE': 'C:',
16:08:16 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-115',
16:08:16 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
16:08:16 INFO - 'KTS_VERSION': '1.19c',
16:08:16 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-115\\AppData\\Local',
16:08:16 INFO - 'LOGONSERVER': '\\\\T-W864-IX-115',
16:08:16 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir',
16:08:16 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe',
16:08:16 INFO - 'MONDIR': 'C:\\Monitor_config\\',
16:08:16 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
16:08:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
16:08:16 INFO - 'MOZ_NO_REMOTE': '1',
16:08:16 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir',
16:08:16 INFO - 'NO_EM_RESTART': '1',
16:08:16 INFO - 'NUMBER_OF_PROCESSORS': '8',
16:08:16 INFO - 'OS': 'Windows_NT',
16:08:16 INFO - 'OURDRIVE': 'C:',
16:08:16 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',
16:08:16 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
16:08:16 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
16:08:16 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
16:08:16 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
16:08:16 INFO - 'PROCESSOR_LEVEL': '6',
16:08:16 INFO - 'PROCESSOR_REVISION': '1e05',
16:08:16 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
16:08:16 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
16:08:16 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
16:08:16 INFO - 'PROGRAMW6432': 'C:\\Program Files',
16:08:16 INFO - 'PROMPT': '$P$G',
16:08:16 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
16:08:16 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
16:08:16 INFO - 'PUBLIC': 'C:\\Users\\Public',
16:08:16 INFO - 'PWD': 'C:\\slave\\test',
16:08:16 INFO - 'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos',
16:08:16 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
16:08:16 INFO - 'SLAVEDIR': 'C:\\slave\\',
16:08:16 INFO - 'SYSTEMDRIVE': 'C:',
16:08:16 INFO - 'SYSTEMROOT': 'C:\\windows',
16:08:16 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
16:08:16 INFO - 'TEST1': 'testie',
16:08:16 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
16:08:16 INFO - 'USERDOMAIN': 'T-W864-IX-115',
16:08:16 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-115',
16:08:16 INFO - 'USERNAME': 'cltbld',
16:08:16 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-115',
16:08:16 INFO - 'WINDIR': 'C:\\windows',
16:08:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
16:08:16 INFO - Calling ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dvshFOgSSIiORW6wy6HT8g/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-115', '--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
16:08:17 INFO - mozversion application_buildid: 20160921123003
16:08:17 INFO - mozversion application_changeset: 6757959dbba2a80fa1f58ea4e677c65cb5cd9e15
16:08:17 INFO - mozversion application_display_name: Nightly
16:08:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384}
16:08:17 INFO - mozversion application_name: Firefox
16:08:17 INFO - mozversion application_remotingname: firefox
16:08:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team
16:08:17 INFO - mozversion application_vendor: Mozilla
16:08:17 INFO - mozversion application_version: 52.0a1
16:08:17 INFO - mozversion platform_buildid: 20160921123003
16:08:17 INFO - mozversion platform_changeset: 6757959dbba2a80fa1f58ea4e677c65cb5cd9e15
16:08:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team
16:08:17 INFO - mozversion platform_version: 52.0a1
16:08:17 INFO - using testdate: 1474499297
16:08:17 INFO - actual date: 1474499297
16:08:17 INFO - starting webserver on 'localhost:49280'
16:08:17 INFO - SUITE-START | Running 2 tests
16:08:17 INFO - TEST-START | dromaeo_css
16:08:17 INFO - operating with platform_type : w8_
16:08:17 INFO - Initialising browser for dromaeo_css test...
16:08:17 INFO - TEST-INFO | started process 3620 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmp1nixb8\profile http://localhost:49280/getInfo.html)
16:08:24 INFO - PROCESS | 3620 | __metrics Screen width/height:1600/1200
16:08:24 INFO - PROCESS | 3620 | colorDepth:24
16:08:24 INFO - PROCESS | 3620 | Browser inner width/height: 1010/674
16:08:24 INFO - PROCESS | 3620 | __metrics
16:08:26 INFO - PROCESS | 3620 | 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"
16:08:26 INFO - PROCESS | 3620 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver]
16:08:27 INFO - TEST-INFO | 3620: exit 0
16:08:27 INFO - Browser initialized.
16:08:27 INFO - Running cycle 1/1 for dromaeo_css test...
16:08:27 INFO - TEST-INFO | started process 3036 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmp1nixb8\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1)
16:08:27 INFO - PROCESS | 3036 | [GFX1-]: Invalid size in UpdateRenderTarget Size(124,0), 0
16:08:38 INFO - PROCESS | 3036 | RSS: Main: 159793152
16:08:38 INFO - PROCESS | 3036 |
16:09:29 INFO - PROCESS | 3036 | 1474499369535 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]
16:11:39 INFO - PROCESS | 3036 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49280/tests/dromaeo/cssquery-ext.html)
16:11:41 INFO - PROCESS | 3036 | RSS: Main: 398323712
16:11:41 INFO - PROCESS | 3036 |
16:14:44 INFO - PROCESS | 3036 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-ext.html (next: http://localhost:49280/tests/dromaeo/cssquery-jquery.html)
16:14:45 INFO - PROCESS | 3036 | RSS: Main: 221011968
16:14:45 INFO - PROCESS | 3036 |
16:17:47 INFO - PROCESS | 3036 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49280/tests/dromaeo/cssquery-mootools.html)
16:17:47 INFO - PROCESS | 3036 | RSS: Main: 181116928
16:17:47 INFO - PROCESS | 3036 |
16:20:49 INFO - PROCESS | 3036 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49280/tests/dromaeo/cssquery-prototype.html)
16:20:50 INFO - PROCESS | 3036 | RSS: Main: 177885184
16:20:50 INFO - PROCESS | 3036 |
16:23:53 INFO - PROCESS | 3036 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49280/tests/dromaeo/cssquery-yui.html)
16:23:53 INFO - PROCESS | 3036 | RSS: Main: 165425152
16:23:53 INFO - PROCESS | 3036 |
16:26:56 INFO - PROCESS | 3036 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-yui.html (next: http://localhost:49280/tests/dromaeo/cssquery-dojo.html)
16:26:56 INFO - PROCESS | 3036 | RSS: Main: 266665984
16:26:56 INFO - PROCESS | 3036 |
16:26:56 INFO - PROCESS | 3036 | __start_tp_report
16:26:56 INFO - PROCESS | 3036 | _x_x_mozilla_page_load
16:26:56 INFO - PROCESS | 3036 | _x_x_mozilla_page_load_details
16:26:56 INFO - PROCESS | 3036 | |i|pagename|runs|
16:26:56 INFO - PROCESS | 3036 | |0;dojo.html;2831.22141411112;2848.2736902089964;2877.4820532304184;2897.043975488089;2899.9995001724396;5068.214426763853;5087.643864929457;5095.261187127864;5107.5403213710715;5205;5099.15863882459;5102.693838369701;5130.794768209276;5133.435322114574;5140.8971820563565;4555.2256116460285;4577.473590537097;4590.288505281678;4601.746903920283;4646.767661616923;4619.122366750324;4621.676482646216;4635.93046104307;4662.463816661094;4665.906681866378;4569.154706379297;4667.369905062824;4677.251639737643;4678.812847486097;4719.551642593948;4486.461624605068;4568.109218702354;4612.100640375128;4638.141943740385;4652.953470465286;4525.027119169362;4532.342810292522;4554.38515800366;4568.908621827545;4622.745748983804;5033.823816166417;5053.646244762868;5064.189729643276;5096.261042148868;5160.870978225536;5318.1225097858805;5455.427180146107;5495.175723641446;5498.642588231792;5546;5446.564274858002;5556.583256255756;5561.555075593943;5564.415736347666;5568.749406276727;5078.593712503028;5092.388913330424;5098.515641014098;5101.489851014869;5159.896802063975;5547.861303467364;5583.246261754611;5586.106223004381;5610.214569960127;5620.91568626471;5388.110961691355;5392.379876314196;5423.105187644073;5437.157240627709;5444.3194600674915;5419.187121931742;5461.836144915659;5476.726163691879;5533.170024496278;5534.4742249487035;5451.563874889999;5457.863553411117;5461.399246082928;5504.449555044544;5522.22688823565;5440.047991601454;5441.8095366662765;5445.591580631469;5452.345718513804;5501.752421141058;3726.2174943261675;3735.6077611850365;3736.5889752127246;3739.626037396293;3781.8487260509823;3227.144806626246;3284.0312107928216;3297.5053741938423;3298.686624770643;3309.5366648669205;5234.895302093937;5305.44292849253;5320.707361095177;5328.573714102862;5329.7068661224;5501.724913754377;5523.447655234444;5536.833894983157;5540.9168862467095;5585.441455854382;5186.792528298901;5255.264263003182;5259.631825772236;5262.052830490548;5269.288646032736;4362.236608593484;4380.518143004267;4382.671299652475;4386.0789234261165;4414.404055452537;5643.943560564506;5670.5180059695385;5675.489205971482;5679.858003549944;5683.60214784961;5497.955388476177;5514.5864060194845;5533.944660553343;5535.975844468786;5539.529140023144;5630.521405680399;5634.943650563442;5642.210090587239;5662.85842853932;5672.744726487401;5359.571234301325;5428.022955867982;5430;5447.96488667152;5453;5491.121420572689;5529.474699903502;5534.363548191848;5544.306961629796;5546.500814926676;5345.438728933562;5356.1697936819855;5370.946290537045;5392.137258038695;5397.3523177218985;5398.4871437213405;5403.459654034565;5414.512693857571;5418.891622167614;5419.864503387447;5267.183586544092;5289.47105289468;5310.548603368757;5353.036453438419;5402.432744561922;5491.917621235764;5493.945060549343;5497.312835895513;5501.889962200814;5506.752196151103;5356.437574054668;5393.1370980642905;5393.622446428869;5401.513863752281;5441.972790136182
16:26:56 INFO - PROCESS | 3036 | |1;ext.html;552.5469115325433;564.6809552602779;573.1917995626168;580.7822066724976;592.9970350148249;29664.85167574162;36729.632703672985;37742.62257377426;37836;40623.79688101563;38960.41559376611;39406.60593394065;39862;39871.20257594846;39916.60083399165;8336.95831520843;8458.492490450562;8477.364197685167;8477.576121193946;8478.957605211965;8383.413161078726;8417.494950303002;8462.78843028923;8502.914970850305;8504.107068757785;8455.53494557799;8472.449290796108;8484.89696339475;8514.829703405929;8536.231739143475;8408.537530435824;8426.410151289412;8480.78798030051;8488.872666910001;8521.744347669579;8360.58197090143;8382.580870956428;8419.789505262355;8451.239388455007;8489.235968762841;36611.81694091539;36823.44764828503;37065.814670926746;37190.81404592987;37222.44166337507;3202.7758056936023;3219.7746157768966;3236.72487838534;3246.2533617267923;3343.4483310253777;25623;25789.35526611831;25917.481650367077;26621.866890665617;26885.596716049276;4001.6198461146437;4048.6153815387493;4053.1893621275567;4171.144915292358;4253.787310634487;228291;293213;293667;295447;297451;30572.69427305743;49923;50296.74851625792;50661.90733297342;51031;31348.843255783577;32791.1802204942;32836.67163328336;32923.67076329254;32928.1767955803;13641.386137623831;13686.110402823784;13738.381772820247;13754.65613359674;13797.034207605571;11321.264117832314;11392.20254582188;11401.94299028516;11427.371494567713;11569.363684997237;7521.623918804038;7555.697772089165;7584.582847943306;7623.428242881806;7625.351845093229;3001.429728351606;3050.2069461939614;3050.572919791231;3052.8015678980796;3077.8307193104147;846.6697987784769;847.1824689174853;869.7129947117436;913.0048247410355;981.4052165231499;27465.862670686518;27745.647433370556;27754.306142346602;27771.44506886612;28076.157715268575;907.9001309855911;930.4882314726873;955.145145095136;975.6975337645353;1007.0091827272987;14483.203423811792;14966.551003469913;15178.620534486505;15455.149966751937;15714;473919;474347;474620;476355;478752;47858;47931.281030784565;48098;48171;48233.75883120632;1112.6161474291357;1134.982975255372;1169.923954942926;1181.8581770187632;1197.658667279821;25742.485150297263;28321.716782831907;28598.85700571484;28699.856500717364;28789.856050719613;41806.79096604497;41875.7906210467;42355.576444235165;42401.36397954095;42471.57528424676;302775;364754;366255;366370;366581;22557.210497632503;23615.881920590287;23978.76021239835;24071.51856962886;25306.873465632554;39906.40140397838;40933.38599920944;41064;41111;41434.19921211093;34616.30767384689;35050.474242885866;35177.47233791546;35236.29527409489;35679.28641427209;35021.29957400889;35086.47370289499;35344;35393.82303088468;35527.644723553465;33227.50158747669;33454.83272583621;33787.66212337845;33889.322213556086;34129.48805767965;30675.091985282248;31561.528231894932;31734.206644834063;32081;32127.35745285128;24037.75962240355;24246.75753242445;24288.635670464602;24475.26574202777;24636.753632463446
16:26:56 INFO - PROCESS | 3036 | |2;jquery.html;330.4349562248554;331.0267812630865;332.72383921345283;343.6408952644486;351.8680494814445;15938.601534961617;16322.510324690264;17116.657666846655;17227.397041103563;17570.56073598159;14286.142831430096;14304.71390572188;14613;14749.926250368733;16008.759868601981;5187.766550505236;5212.687238765668;5348.064088784467;5358.303420555342;5403.567714582844;5293.206019097147;5326.573874090082;5362.490563396471;5362.731863406814;5372.91940620891;4991.276264941581;5250.4487028861995;5266.999270138662;5279.208118782175;5298.311219541454;5240.056789777838;5282.260483532308;5287.149497675821;5310.230016647564;5318.388385335697;4980.153373926441;5093.465186155475;5116;5170.457102004273;5172.27588137661;10923.726906827313;11080.445977701083;11223.831642525369;11236.943815280953;11245.662630121109;2046;2090.059473237034;2175;2242.887855607213;2462.22439931421;8516.361272904556;8683.956580217058;8866.490219100082;9059.864102038475;9172.08279172084;1748.545378201664;1751.7372394140853;1752.115181833179;1769.6991511443086;1797.6854050541233;72646.63676681636;72867;72990.63504682442;74175;74236;8594.347402353975;8823.955880220557;8826.86759698605;9239.214666753267;9360.391574547633;12313.07651926109;12313.753724925631;12326.50693972249;12328.630141095782;12333.260004399584;7187.9281207188305;7202.099737532809;7271.272872712792;7350.228226036296;7374.967504549368;7148.964255178691;7178.4616153788675;7196.388306993859;7284.817879553054;7314.232005639331;3539.1152211947015;3588.990165507324;3894.4742459768136;3933.8229779659982;3986.9601303986587;1609.3884323957056;1674.933002679879;1675.4219794170992;1706.7269236922034;1712.3236321652878;796.6136423834436;841.5707988925692;853.9188777066169;858.9355798315152;877.9165979231963;15637.68724625501;16043.197840108181;16406.343746250015;17536;17559.034253115944;820.4216027700456;822.2106777493553;844.0926004545139;858.6136238692613;950.2018304624011;9011.482775836246;9567.61729530825;9591.9040809591;9627.90372096284;9711;291572;345857;407365;409438;410119;85795.57102214449;87917.52701020485;89285;90494;90711;921.1203300847675;930.8091841172543;949.9525023748785;952.066974365126;952.1525842000625;11860.466279017292;14761.483348082766;15065.774013390028;15614.09647588103;15628.531144065697;35483.467747984316;37273;37830.81084594559;38164.618353816106;38675;50499.24251136163;50777.984440311724;51094;51812;52040.21939670832;6890.483213758888;7253.854922901618;7342.229065948212;7425.70297188128;7435.51669141504;11031.669049928514;11076.501557429774;11542.653720388402;11726.003289720127;11966.162368634112;9356.766080847761;9704;9902;10366.844497332395;10465.215108866712;10025.548850301608;10102.090811826676;10138.341007834468;10215.642452514126;10261.179105671677;9843.310968232156;9878.4566848824;9885.901140988786;10295.588176472857;10316;6825.112735344572;6968.825779355354;7186.784396468114;7211.3870321023305;7609.771706848804;6640.313844193232;9566.712998610054;9932.900670993198;10407.427591482237;10537.57849686004
16:26:56 INFO - PROCESS | 3036 | |3;mootools.html;1149.528693235773;1178.0928684912617;1270.3203785974506;1417.5747275817253;1426.351010290318;7230.457715671326;7702.730404435839;7734.729284475045;7741.922580774198;7744.651490682919;6817.829554261146;6855.622940738257;6992.05607243022;7135.643217839113;7542.736004239852;1966.016991504248;2026.6858636911302;2033.4103110098054;2034.043999320317;2044.4990977210605;1971.2509246486316;1990.6018796240737;1997.091323447835;1998.1507859159872;2021.302650585553;1783.7591925090142;1835.4401907418232;1963.6956271777897;1978.5350442645968;2024.787397323282;1986.503374156461;1995.9600807983759;2006.769221539527;2008.1967213114724;2010.7285516455238;1899.4396652987402;1908.6755251607121;1941.4272789527124;1943.1644392911044;1944.5041514413876;7030.191527974246;7151.535150215272;7180.389666878322;7198.136223653143;7437.293457121565;4110.91778164438;4215.810288536993;4220.240356735786;4223.831046758126;4225.873223803291;2918;2955.0839239835504;3004.158835526056;3005.8046226995175;3005.9849700751574;971.6599190283415;983.695054533097;997.1723469520354;1001.2440607341483;1010.2776514791885;9912.35569687968;10056.145227655657;10126.544305506197;10158.187345012382;10166.745831354276;3717.888463346104;3756.398976163801;3822.694184465236;3906.1797022625565;3910.393888947218;8486.490810551386;8612.655493780305;8623.051464338918;8626.266767324722;8642.135786421308;4329.675274354436;4374.759388233614;4376.256036473807;4378.8029538670835;4393.406890069864;4046.5751096135073;4052.7365721228025;4053.7973101344814;4091.85678501251;4133.0700592366475;3202.0553936588763;3228.80627162371;3245.7403407727325;3255.202475393544;3255.9674403255663;992.9156021738233;1015.1827778638119;1017.7099526635021;1022.0648106982177;1039.8284283093205;769.9653515591812;796.6176235407037;800.7677773445752;808.9595520223966;831.5800520736989;4889.242167464049;4964.429090654621;4993.400791904922;5052.191649336089;5071.18860982241;361.5101537416815;363.5110776006267;364.45513956635;366.8477581803575;396.9503812023497;3276.2137087098927;3378.1048022274117;3398.150462384404;3449.292894956528;3452.689257966795;8954.015058343577;9411.858822117674;9419.387739796892;9424.528773561295;9461.19579835708;9315.39449935752;9372.968973412919;9384.24926005918;9391.859122113174;9411.717648470556;7089.397401220954;7140;7148;7179.78460646171;7182.676779544829;4903.4606193317995;4995.025969935973;5042.873928151826;5060.114479966065;5129.53834154913;8397.664093436195;8636.050034496075;8680.435771674822;8804.515751633722;8810.295176385745;8473.576321183793;8829.735107946772;8857;8867.467951922647;8910.643574256957;6690.899636505359;6762.729490820312;6804.591724496546;6834.077399550997;6837.282085381163;7158.677859496439;7287.744928927462;7297.817554561178;7332.853342933005;7341.229170937188;5596.748146333343;6661.16735408074;6707.295733947865;6762.729490820312;6828.0440738297675;6475.417212450902;6528.347165283433;6616.702248398929;6627.569208001464;6639.867202655823;5940.524758019435;6051.576389652682;6052.75788968454;6054.7275372607455;6055.939440605537;4274.529801721746;4339.045410009793;4353.73877567347;4366.868993930188;4390.912181756411;4227.3724616023665;4229.703920725519;4298.075913678574;4299.054208074219;4387.846425375096
16:26:56 INFO - PROCESS | 3036 | |4;prototype.html;253.1027507485962;255.8260382939601;259.56134133314686;261.28277877227015;266.9839809611422;5078.466760990089;5122.615803814715;5197.584193264539;5213.791448342071;5225.634205605605;5004.5746111580465;5123.12906805843;5149.485051494858;5162.251473536335;5183.611229157809;3663.5054267673922;3778.6977041836585;3845.4231865220163;3878.5345758508947;3886.630770076838;3815.6835891617347;3862.1117143057113;3880.7865567393783;3887.708421868357;3891.571927088032;3825.1584651376793;3828.942565861514;3873.69010479161;3884.844606215748;3910.8240129194114;3865.014421322573;3913.9804300978453;3914.862979795722;3918.764874107534;3920.3335432976464;3300.240944582735;3331.200511877132;3339.532465454838;3345.749068819848;3355.899323020289;4982.900341993176;5008.424031236418;5049.914268432305;5073.441921388644;5075.873103172414;4283.614474697292;4488.5960263576435;4494.4606647202545;4498.415206023229;4505.414296141481;5429.56563474921;5475;5475.425080366544;5485.506304432581;5489.6980666063355;3554.87557935471;3614.27714457107;3630.7640003399692;3638.399664055428;3642.6721595056574;5385.380681221671;5753.108268218432;5778.075507918755;5781.971090144564;5794.55136215946;3591.2458383739186;3611.0069730823707;3636.1455058061333;3644.1618427761764;3654.3787556115526;3697.7781333120097;3701.9444708329397;3706.998220960705;3711.313407019656;3724.404095344732;4356.912861742748;4360.825566977349;4389.231884420214;4396.4064851244675;4427.6236519896165;5378.300820893337;5448.373437054789;5467.890642187134;5486.807961721321;5513.972430137904;1269.5239285268024;1283.749668814591;1293.2822283632486;1294.5630350311146;1295.533607901155;763.5304287863036;780.7462574663257;792.1919641965163;793.746001279585;800.3277247112453;4683.6721429500285;4683.906321873544;4704.447532314328;4707.693999890064;4737.573618374294;4953.90092198154;4963.528464795839;5007.223880298559;5028.918782461788;5039.470855560114;4425.690201685916;4764.309175169581;4779.4264688236935;4793.219932439177;4809.46097248884;2619.3582572269916;2624.514464824014;2629.500394924958;2642.828216165943;2644.801639877017;4992.525710057539;5067.341245638044;5097.541221290102;5099.847004589868;5149.176131818891;4789.4971028042255;4955.355803745562;5015.774290156952;5020.799168033311;5061.038402703474;4959.70241785494;5027.762645622663;5066.341375621219;5072.644914855999;5086.54221120101;4972.353594032753;4994.2508623706735;4998.275250088789;5001.424551266339;5010;4724.551167639069;4814.831480898151;4886.462489126122;4905.4603993561395;4922.286268491121;5046.318746969112;5072.391313042459;5082.974585127051;5111.309973153725;5556.972215138899;3607.621199773986;3622.836972336304;3624.7462677612316;3629.7822130672243;3640.199156185635;5569.164625306236;5688.63023903445;5723.084306510938;5757.3954734753925;5771.509421699203;5357.026850098233;5548.55611551083;5559.444055594408;5581.6371935824045;5624.493795558419;5498.78321182097;5535.474129957647;5541.556675466034;5544.22380866687;5545.195946587642;5432.185172224198;5441.483059109379;5483.670979741229;5511.53151982086;5530.723463826873;5416.8104116355735;5525;5542.445755424586;5589.496945274945;5602.467765562265;5446.754896029767;5509.256250406304;5513.814529876096;5515.365732940763;5529.944700552943
16:26:56 INFO - PROCESS | 3036 | |5;yui.html;645.8514541655419;669.3273260373325;719.6509692798992;720.783764870539;721.7762493626976;12906.483740650374;13724.107932984361;13744.793828092561;13794.172349659028;13837.377318020688;12969.870301296984;13829.861701382983;13843.861561384383;13899.722005559883;13998.720025599507;656.478099910571;674.5615350022475;679.6329981809841;679.9626020568892;680.7651360280695;590.6072461812889;599.5443462968154;658.8846951783419;670.179030687409;681.0465348512098;693.137044379748;693.4348505967646;695.4853408477716;696.6830092307988;699.4159876503126;696.4880812602732;697.689528159969;697.8534507753378;697.9685914133876;698.3609996852873;443.37705523739197;443.704936217415;505.6359421216718;508.6439492355366;516.9147090730025;13287.20276783396;13314.533991310354;13818.861811381857;13826.861731382658;13829.723405531933;11555.53777848885;11575.36335501547;12043.939780301042;12129;12186.75626487474;12079.818802717966;12142.635720928387;12247.938760306142;12256;12279.938600306941;3413.8975830725117;4157.293260145782;4166.937495937564;4189.455370801807;4225.767582782945;63740;69919.65040174767;71134.28865711328;71423.2857671427;71803.28196718018;9797.657082002239;10000.899991000142;10206.897931020743;10299.330543514647;10376.16990640747;16962.660746784994;17095.230714617872;17139.57151071208;17150.313987440364;17163.742543861852;7490.887636685454;7640.197779233212;7646.158922518519;7670.427562349705;7737.883931741028;4366.672499562545;4408.911821763547;4522.751248681288;4587.0596527712405;4614.238650622609;2707.1201859395774;2839.261791934112;2839.7444230019396;2856.657201135877;2980.508216144312;508.7659676548829;517.8213516336858;518.556634077858;519.5246349590158;519.9272101905736;589.4724221821532;639.9888176680834;661.47743282807;695.3255342317943;696.7178292791427;9723.367981081206;9911.900880991241;10034.564162839963;10274.983232729683;10409.53157107932;586.6216290492608;671.6507416143578;676.9796906092826;694.97220111196;707.85135121624;4375;4449.243628583149;4490.732180249019;4652.651051171176;4676.11125681011;89328;99932.00543956466;101317;102035.48982255041;103029;75793.24206757972;77805;80394.19605803984;85443.48408576228;93635;70436.295637044;70502.29497704958;73191.63404183052;74510.62744686242;74554.0356771457;9026.232770214605;9298.814023719622;9496.335256531976;9672.177864881563;9756.21950243993;43707.562924371625;43839.78080109579;44677.55322446864;45030.324545131196;45383.09233815239;59400.70299648474;63141.68429157825;63935.68032159809;64052;64191.358086418535;11007.830713132986;11129.554817807197;11130.944345278222;11589.420528973686;11836.171467997157;13929.164250144619;14168.787468188191;14248;14426.278686065865;14872.851271487147;12286.815697764361;12883.677908052374;13536.390862411412;13566.660833479242;13711;13309.66725831862;13426.194428334331;13445.865541344461;13596.456141754219;13620.271291618632;13511.662208444868;13609.251491167684;13724.519641812489;14255.358508867334;14256.42974281017;10053.246006549392;10700.89299106999;10805.567777289134;10942.671719848417;10942.726431839268;10402.531886064993;10839.729006774895;10843.078338341329;11015;11057.281276717309
16:26:56 INFO - PROCESS | 3036 | __end_tp_report
16:26:56 INFO - PROCESS | 3036 | __start_cc_report
16:26:56 INFO - PROCESS | 3036 | _x_x_mozilla_cycle_collect,2029
16:26:56 INFO - PROCESS | 3036 | __end_cc_report
16:26:56 INFO - PROCESS | 3036 | __startTimestamp1474500416752__endTimestamp
16:26:56 INFO - PROCESS | 3036 |
16:26:56 INFO - PROCESS | 3036 | ------- Summary: start -------
16:26:56 INFO - PROCESS | 3036 | Number of tests: 6
16:26:56 INFO - PROCESS | 3036 |
16:26:56 INFO - PROCESS | 3036 | [#0] dojo.html Cycles:165 Average:5062.84 Median:5356.44 stddev:669.97 (12.5%) stddev-sans-first:648.75
16:26:56 INFO - PROCESS | 3036 | Values: 2831.2 2848.3 2877.5 2897.0 2900.0 5068.2 5087.6 5095.3 5107.5 5205.0 5099.2 5102.7 5130.8 5133.4 5140.9 4555.2 4577.5 4590.3 4601.7 4646.8 4619.1 4621.7 4635.9 4662.5 4665.9 4569.2 4667.4 4677.3 4678.8 4719.6 4486.5 4568.1 4612.1 4638.1 4653.0 4525.0 4532.3 4554.4 4568.9 4622.7 5033.8 5053.6 5064.2 5096.3 5160.9 5318.1 5455.4 5495.2 5498.6 5546.0 5446.6 5556.6 5561.6 5564.4 5568.7 5078.6 5092.4 5098.5 5101.5 5159.9 5547.9 5583.2 5586.1 5610.2 5620.9 5388.1 5392.4 5423.1 5437.2 5444.3 5419.2 5461.8 5476.7 5533.2 5534.5 5451.6 5457.9 5461.4 5504.4 5522.2 5440.0 5441.8 5445.6 5452.3 5501.8 3726.2 3735.6 3736.6 3739.6 3781.8 3227.1 3284.0 3297.5 3298.7 3309.5 5234.9 5305.4 5320.7 5328.6 5329.7 5501.7 5523.4 5536.8 5540.9 5585.4 5186.8 5255.3 5259.6 5262.1 5269.3 4362.2 4380.5 4382.7 4386.1 4414.4 5643.9 5670.5 5675.5 5679.9 5683.6 5498.0 5514.6 5533.9 5536.0 5539.5 5630.5 5634.9 5642.2 5662.9 5672.7 5359.6 5428.0 5430.0 5448.0 5453.0 5491.1 5529.5 5534.4 5544.3 5546.5 5345.4 5356.2 5370.9 5392.1 5397.4 5398.5 5403.5 5414.5 5418.9 5419.9 5267.2 5289.5 5310.5 5353.0 5402.4 5491.9 5493.9 5497.3 5501.9 5506.8 5356.4 5393.1 5393.6 5401.5 5442.0
16:26:56 INFO - PROCESS | 3036 |
16:26:56 INFO - PROCESS | 3036 | [#1] ext.html Cycles:180 Average:50110.27 Median:201433.41 stddev:100789.13 (50.0%) stddev-sans-first:101003.18
16:26:56 INFO - PROCESS | 3036 | Values: 552.5 564.7 573.2 580.8 593.0 29664.9 36729.6 37742.6 37836.0 40623.8 38960.4 39406.6 39862.0 39871.2 39916.6 8337.0 8458.5 8477.4 8477.6 8479.0 8383.4 8417.5 8462.8 8502.9 8504.1 8455.5 8472.4 8484.9 8514.8 8536.2 8408.5 8426.4 8480.8 8488.9 8521.7 8360.6 8382.6 8419.8 8451.2 8489.2 36611.8 36823.4 37065.8 37190.8 37222.4 3202.8 3219.8 3236.7 3246.3 3343.4 25623.0 25789.4 25917.5 26621.9 26885.6 4001.6 4048.6 4053.2 4171.1 4253.8 228291.0 293213.0 293667.0 295447.0 297451.0 30572.7 49923.0 50296.7 50661.9 51031.0 31348.8 32791.2 32836.7 32923.7 32928.2 13641.4 13686.1 13738.4 13754.7 13797.0 11321.3 11392.2 11401.9 11427.4 11569.4 7521.6 7555.7 7584.6 7623.4 7625.4 3001.4 3050.2 3050.6 3052.8 3077.8 846.7 847.2 869.7 913.0 981.4 27465.9 27745.6 27754.3 27771.4 28076.2 907.9 930.5 955.1 975.7 1007.0 14483.2 14966.6 15178.6 15455.1 15714.0 473919.0 474347.0 474620.0 476355.0 478752.0 47858.0 47931.3 48098.0 48171.0 48233.8 1112.6 1135.0 1169.9 1181.9 1197.7 25742.5 28321.7 28598.9 28699.9 28789.9 41806.8 41875.8 42355.6 42401.4 42471.6 302775.0 364754.0 366255.0 366370.0 366581.0 22557.2 23615.9 23978.8 24071.5 25306.9 39906.4 40933.4 41064.0 41111.0 41434.2 34616.3 35050.5 35177.5 35236.3 35679.3 35021.3 35086.5 35344.0 35393.8 35527.6 33227.5 33454.8 33787.7 33889.3 34129.5 30675.1 31561.5 31734.2 32081.0 32127.4 24037.8 24246.8 24288.6 24475.3 24636.8
16:26:56 INFO - PROCESS | 3036 |
16:26:56 INFO - PROCESS | 3036 | [#2] jquery.html Cycles:180 Average:23780.87 Median:28499.88 stddev:62681.98 (219.9%) stddev-sans-first:62833.09
16:26:56 INFO - PROCESS | 3036 | Values: 330.4 331.0 332.7 343.6 351.9 15938.6 16322.5 17116.7 17227.4 17570.6 14286.1 14304.7 14613.0 14749.9 16008.8 5187.8 5212.7 5348.1 5358.3 5403.6 5293.2 5326.6 5362.5 5362.7 5372.9 4991.3 5250.4 5267.0 5279.2 5298.3 5240.1 5282.3 5287.1 5310.2 5318.4 4980.2 5093.5 5116.0 5170.5 5172.3 10923.7 11080.4 11223.8 11236.9 11245.7 2046.0 2090.1 2175.0 2242.9 2462.2 8516.4 8684.0 8866.5 9059.9 9172.1 1748.5 1751.7 1752.1 1769.7 1797.7 72646.6 72867.0 72990.6 74175.0 74236.0 8594.3 8824.0 8826.9 9239.2 9360.4 12313.1 12313.8 12326.5 12328.6 12333.3 7187.9 7202.1 7271.3 7350.2 7375.0 7149.0 7178.5 7196.4 7284.8 7314.2 3539.1 3589.0 3894.5 3933.8 3987.0 1609.4 1674.9 1675.4 1706.7 1712.3 796.6 841.6 853.9 858.9 877.9 15637.7 16043.2 16406.3 17536.0 17559.0 820.4 822.2 844.1 858.6 950.2 9011.5 9567.6 9591.9 9627.9 9711.0 291572.0 345857.0 407365.0 409438.0 410119.0 85795.6 87917.5 89285.0 90494.0 90711.0 921.1 930.8 950.0 952.1 952.2 11860.5 14761.5 15065.8 15614.1 15628.5 35483.5 37273.0 37830.8 38164.6 38675.0 50499.2 50778.0 51094.0 51812.0 52040.2 6890.5 7253.9 7342.2 7425.7 7435.5 11031.7 11076.5 11542.7 11726.0 11966.2 9356.8 9704.0 9902.0 10366.8 10465.2 10025.5 10102.1 10138.3 10215.6 10261.2 9843.3 9878.5 9885.9 10295.6 10316.0 6825.1 6968.8 7186.8 7211.4 7609.8 6640.3 9566.7 9932.9 10407.4 10537.6
16:26:56 INFO - PROCESS | 3036 |
16:26:56 INFO - PROCESS | 3036 | [#3] mootools.html Cycles:180 Average:4892.88 Median:4896.35 stddev:2816.93 (57.5%) stddev-sans-first:2810.79
16:26:56 INFO - PROCESS | 3036 | Values: 1149.5 1178.1 1270.3 1417.6 1426.4 7230.5 7702.7 7734.7 7741.9 7744.7 6817.8 6855.6 6992.1 7135.6 7542.7 1966.0 2026.7 2033.4 2034.0 2044.5 1971.3 1990.6 1997.1 1998.2 2021.3 1783.8 1835.4 1963.7 1978.5 2024.8 1986.5 1996.0 2006.8 2008.2 2010.7 1899.4 1908.7 1941.4 1943.2 1944.5 7030.2 7151.5 7180.4 7198.1 7437.3 4110.9 4215.8 4220.2 4223.8 4225.9 2918.0 2955.1 3004.2 3005.8 3006.0 971.7 983.7 997.2 1001.2 1010.3 9912.4 10056.1 10126.5 10158.2 10166.7 3717.9 3756.4 3822.7 3906.2 3910.4 8486.5 8612.7 8623.1 8626.3 8642.1 4329.7 4374.8 4376.3 4378.8 4393.4 4046.6 4052.7 4053.8 4091.9 4133.1 3202.1 3228.8 3245.7 3255.2 3256.0 992.9 1015.2 1017.7 1022.1 1039.8 770.0 796.6 800.8 809.0 831.6 4889.2 4964.4 4993.4 5052.2 5071.2 361.5 363.5 364.5 366.8 397.0 3276.2 3378.1 3398.2 3449.3 3452.7 8954.0 9411.9 9419.4 9424.5 9461.2 9315.4 9373.0 9384.2 9391.9 9411.7 7089.4 7140.0 7148.0 7179.8 7182.7 4903.5 4995.0 5042.9 5060.1 5129.5 8397.7 8636.1 8680.4 8804.5 8810.3 8473.6 8829.7 8857.0 8867.5 8910.6 6690.9 6762.7 6804.6 6834.1 6837.3 7158.7 7287.7 7297.8 7332.9 7341.2 5596.7 6661.2 6707.3 6762.7 6828.0 6475.4 6528.3 6616.7 6627.6 6639.9 5940.5 6051.6 6052.8 6054.7 6055.9 4274.5 4339.0 4353.7 4366.9 4390.9 4227.4 4229.7 4298.1 4299.1 4387.8
16:26:56 INFO - PROCESS | 3036 |
16:26:56 INFO - PROCESS | 3036 | [#4] prototype.html Cycles:180 Average:4359.49 Median:4977.63 stddev:1337.31 (26.9%) stddev-sans-first:1305.06
16:26:56 INFO - PROCESS | 3036 | Values: 253.1 255.8 259.6 261.3 267.0 5078.5 5122.6 5197.6 5213.8 5225.6 5004.6 5123.1 5149.5 5162.3 5183.6 3663.5 3778.7 3845.4 3878.5 3886.6 3815.7 3862.1 3880.8 3887.7 3891.6 3825.2 3828.9 3873.7 3884.8 3910.8 3865.0 3914.0 3914.9 3918.8 3920.3 3300.2 3331.2 3339.5 3345.7 3355.9 4982.9 5008.4 5049.9 5073.4 5075.9 4283.6 4488.6 4494.5 4498.4 4505.4 5429.6 5475.0 5475.4 5485.5 5489.7 3554.9 3614.3 3630.8 3638.4 3642.7 5385.4 5753.1 5778.1 5782.0 5794.6 3591.2 3611.0 3636.1 3644.2 3654.4 3697.8 3701.9 3707.0 3711.3 3724.4 4356.9 4360.8 4389.2 4396.4 4427.6 5378.3 5448.4 5467.9 5486.8 5514.0 1269.5 1283.7 1293.3 1294.6 1295.5 763.5 780.7 792.2 793.7 800.3 4683.7 4683.9 4704.4 4707.7 4737.6 4953.9 4963.5 5007.2 5028.9 5039.5 4425.7 4764.3 4779.4 4793.2 4809.5 2619.4 2624.5 2629.5 2642.8 2644.8 4992.5 5067.3 5097.5 5099.8 5149.2 4789.5 4955.4 5015.8 5020.8 5061.0 4959.7 5027.8 5066.3 5072.6 5086.5 4972.4 4994.3 4998.3 5001.4 5010.0 4724.6 4814.8 4886.5 4905.5 4922.3 5046.3 5072.4 5083.0 5111.3 5557.0 3607.6 3622.8 3624.7 3629.8 3640.2 5569.2 5688.6 5723.1 5757.4 5771.5 5357.0 5548.6 5559.4 5581.6 5624.5 5498.8 5535.5 5541.6 5544.2 5545.2 5432.2 5441.5 5483.7 5511.5 5530.7 5416.8 5525.0 5542.4 5589.5 5602.5 5446.8 5509.3 5513.8 5515.4 5529.9
16:26:56 INFO - PROCESS | 3036 |
16:26:56 INFO - PROCESS | 3036 | [#5] yui.html Cycles:180 Average:18340.19 Median:443.54 stddev:25548.34 (5760.1%) stddev-sans-first:25585.46
16:26:56 INFO - PROCESS | 3036 | Values: 645.9 669.3 719.7 720.8 721.8 12906.5 13724.1 13744.8 13794.2 13837.4 12969.9 13829.9 13843.9 13899.7 13998.7 656.5 674.6 679.6 680.0 680.8 590.6 599.5 658.9 670.2 681.0 693.1 693.4 695.5 696.7 699.4 696.5 697.7 697.9 698.0 698.4 443.4 443.7 505.6 508.6 516.9 13287.2 13314.5 13818.9 13826.9 13829.7 11555.5 11575.4 12043.9 12129.0 12186.8 12079.8 12142.6 12247.9 12256.0 12279.9 3413.9 4157.3 4166.9 4189.5 4225.8 63740.0 69919.7 71134.3 71423.3 71803.3 9797.7 10000.9 10206.9 10299.3 10376.2 16962.7 17095.2 17139.6 17150.3 17163.7 7490.9 7640.2 7646.2 7670.4 7737.9 4366.7 4408.9 4522.8 4587.1 4614.2 2707.1 2839.3 2839.7 2856.7 2980.5 508.8 517.8 518.6 519.5 519.9 589.5 640.0 661.5 695.3 696.7 9723.4 9911.9 10034.6 10275.0 10409.5 586.6 671.7 677.0 695.0 707.9 4375.0 4449.2 4490.7 4652.7 4676.1 89328.0 99932.0 101317.0 102035.5 103029.0 75793.2 77805.0 80394.2 85443.5 93635.0 70436.3 70502.3 73191.6 74510.6 74554.0 9026.2 9298.8 9496.3 9672.2 9756.2 43707.6 43839.8 44677.6 45030.3 45383.1 59400.7 63141.7 63935.7 64052.0 64191.4 11007.8 11129.6 11130.9 11589.4 11836.2 13929.2 14168.8 14248.0 14426.3 14872.9 12286.8 12883.7 13536.4 13566.7 13711.0 13309.7 13426.2 13445.9 13596.5 13620.3 13511.7 13609.3 13724.5 14255.4 14256.4 10053.2 10700.9 10805.6 10942.7 10942.7 10402.5 10839.7 10843.1 11015.0 11057.3
16:26:56 INFO - PROCESS | 3036 | -------- Summary: end --------
16:26:56 INFO - PROCESS | 3036 |
16:26:57 INFO - TEST-INFO | 3036: exit 0
16:26:58 INFO - TEST-OK | dromaeo_css | took 1120936ms
16:26:58 INFO - TEST-START | kraken
16:26:58 INFO - operating with platform_type : w8_
16:26:58 INFO - Initialising browser for kraken test...
16:26:58 INFO - TEST-INFO | started process 1836 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpf0_ywu\profile http://localhost:49280/getInfo.html)
16:27:03 INFO - PROCESS | 1836 | __metrics Screen width/height:1600/1200
16:27:03 INFO - PROCESS | 1836 | colorDepth:24
16:27:03 INFO - PROCESS | 1836 | Browser inner width/height: 1010/674
16:27:03 INFO - PROCESS | 1836 | __metrics
16:27:04 INFO - PROCESS | 1836 | 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"
16:27:04 INFO - PROCESS | 1836 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver]
16:27:04 INFO - PROCESS | 1836 | console.error:
16:27:04 INFO - PROCESS | 1836 | Message: Error: Connection closed before committing the transaction.
16:27:04 INFO - PROCESS | 1836 | Stack:
16:27:04 INFO - PROCESS | 1836 | ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:937:23
16:27:04 INFO - PROCESS | 1836 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7
16:27:04 INFO - PROCESS | 1836 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11
16:27:04 INFO - PROCESS | 1836 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7
16:27:04 INFO - PROCESS | 1836 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:714:7
16:27:04 INFO - PROCESS | 1836 | TaskImpl_run@resource://gre/modules/Task.jsm:324:13
16:27:04 INFO - PROCESS | 1836 | Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:551:9
16:27:04 INFO - PROCESS | 1836 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15
16:27:04 INFO - PROCESS | 1836 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:388:5
16:27:04 INFO - PROCESS | 1836 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29
16:27:04 INFO - PROCESS | 1836 | Barrier/this.client.addBlocker/promise13.4%
16:28:01 INFO - TinderboxPrint: I/O read bytes / time
120,567,808 / 1,207,430
16:28:01 INFO - TinderboxPrint: I/O write bytes / time
412,085,248 / 3,463,960
16:28:01 INFO - TinderboxPrint: CPU idle
8,238.7 (86.6%)
16:28:01 INFO - TinderboxPrint: CPU user
1,228.4 (12.9%)
16:28:01 INFO - install - Wall time: 3s; CPU: 11.0%; Read bytes: 0; Write bytes: 37987328; Read time: 0; Write time: 120520
16:28:01 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 120567808; Write bytes: 317061120; Read time: 1207430; Write time: 3295550
16:28:02 INFO - Running post-run listener: _upload_blobber_files
16:28:02 INFO - Blob upload gear active.
16:28:02 INFO - Preparing to upload files from C:\slave\test\build\blobber_upload_dir.
16:28:02 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
16:28:02 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\venv\\Scripts\\blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', 'C:\\slave\\test\\oauth.txt', '-b', 'Fx-Team', '-d', 'C:\\slave\\test\\build\\blobber_upload_dir', '--output-manifest', 'C:\\slave\\test\\build\\uploaded_files.json']
16:28:02 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\venv\Scripts\blobberc.py -u https://blobupload.elasticbeanstalk.com -a C:\slave\test\oauth.txt -b Fx-Team -d C:\slave\test\build\blobber_upload_dir --output-manifest C:\slave\test\build\uploaded_files.json
16:28:02 INFO - (blobuploader) - INFO - Open directory for files ...
16:28:02 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_errorsummary.log ...
16:28:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
16:28:02 INFO - (blobuploader) - INFO - Uploading, attempt #1.
16:28:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded
16:28:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
16:28:03 INFO - (blobuploader) - INFO - Done attempting.
16:28:03 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_raw.log ...
16:28:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
16:28:03 INFO - (blobuploader) - INFO - Uploading, attempt #1.
16:28:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded
16:28:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
16:28:04 INFO - (blobuploader) - INFO - Done attempting.
16:28:04 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\resource-usage.json ...
16:28:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
16:28:04 INFO - (blobuploader) - INFO - Uploading, attempt #1.
16:28:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded
16:28:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
16:28:22 INFO - (blobuploader) - INFO - Done attempting.
16:28:22 INFO - (blobuploader) - INFO - Iteration through files over.
16:28:22 INFO - Return code: 0
16:28:22 INFO - rmtree: C:\slave\test\build\uploaded_files.json
16:28:22 INFO - Using _rmtree_windows ...
16:28:22 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build\\uploaded_files.json',), kwargs: {}, attempt #1
16:28:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ac660a63f3ac2ce75a5d26a579b5a306cf1f98649b88ce0255f6514b095c219011ede0a54edf4058b91dd9bd113f4cf547a66cfa32b93b9e403e3a2a3d83dadc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4a92a4a7a91cd5353a600170ca976d7badc82bdd5aa3ac07b1d8e75c6d8f0f8f76d0cd454cc21b069d681f496c09d6d9ee98e6b378a28c9a0f3a0e5f63fca85b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1021f7237e349f0ea55acebcd2a7286a819dcb896d5ae54281bae75bba2857996f0605e56a947ce52942c44c6bec553a708837c55139b733213abdc20fc74e1d"}
16:28:22 INFO - Writing buildbot properties ['blobber_files'] to C:\slave\test\properties\blobber_files
16:28:22 INFO - Writing to file C:\slave\test\properties\blobber_files
16:28:22 INFO - Contents:
16:28:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ac660a63f3ac2ce75a5d26a579b5a306cf1f98649b88ce0255f6514b095c219011ede0a54edf4058b91dd9bd113f4cf547a66cfa32b93b9e403e3a2a3d83dadc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4a92a4a7a91cd5353a600170ca976d7badc82bdd5aa3ac07b1d8e75c6d8f0f8f76d0cd454cc21b069d681f496c09d6d9ee98e6b378a28c9a0f3a0e5f63fca85b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1021f7237e349f0ea55acebcd2a7286a819dcb896d5ae54281bae75bba2857996f0605e56a947ce52942c44c6bec553a708837c55139b733213abdc20fc74e1d"}
16:28:22 INFO - Running post-run listener: copy_logs_to_upload_dir
16:28:22 INFO - Copying logs to upload dir...
16:28:22 INFO - mkdir: C:\slave\test\build\upload\logs
16:28:22 INFO - Copying logs to upload dir...
16:28:22 INFO - Using _rmtree_windows ...
16:28:22 INFO - Using _rmtree_windows ...
16:28:22 INFO - Using _rmtree_windows ...
16:28:22 INFO - Using _rmtree_windows ...
16:28:22 INFO - Using _rmtree_windows ...
16:28:22 INFO - Using _rmtree_windows ...
16:28:22 INFO - Using _rmtree_windows ...
program finished with exit code 0
elapsedTime=1402.213000
========= master_lag: 4.06 =========
========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 26 secs) (at 2016-09-21 16:28:26.975943) =========
========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-21 16:28:26.986606) =========
'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-115\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-115
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-115
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-115\AppData\Local
LOGONSERVER=\\T-W864-IX-115
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-115
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-115
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-115
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ac660a63f3ac2ce75a5d26a579b5a306cf1f98649b88ce0255f6514b095c219011ede0a54edf4058b91dd9bd113f4cf547a66cfa32b93b9e403e3a2a3d83dadc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4a92a4a7a91cd5353a600170ca976d7badc82bdd5aa3ac07b1d8e75c6d8f0f8f76d0cd454cc21b069d681f496c09d6d9ee98e6b378a28c9a0f3a0e5f63fca85b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1021f7237e349f0ea55acebcd2a7286a819dcb896d5ae54281bae75bba2857996f0605e56a947ce52942c44c6bec553a708837c55139b733213abdc20fc74e1d"}
build_url:https://queue.taskcluster.net/v1/task/dvshFOgSSIiORW6wy6HT8g/artifacts/public/build/firefox-52.0a1.en-US.win64.zip
program finished with exit code 0
elapsedTime=0.102000
build_url: 'https://queue.taskcluster.net/v1/task/dvshFOgSSIiORW6wy6HT8g/artifacts/public/build/firefox-52.0a1.en-US.win64.zip'
blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ac660a63f3ac2ce75a5d26a579b5a306cf1f98649b88ce0255f6514b095c219011ede0a54edf4058b91dd9bd113f4cf547a66cfa32b93b9e403e3a2a3d83dadc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4a92a4a7a91cd5353a600170ca976d7badc82bdd5aa3ac07b1d8e75c6d8f0f8f76d0cd454cc21b069d681f496c09d6d9ee98e6b378a28c9a0f3a0e5f63fca85b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1021f7237e349f0ea55acebcd2a7286a819dcb896d5ae54281bae75bba2857996f0605e56a947ce52942c44c6bec553a708837c55139b733213abdc20fc74e1d"}'
========= master_lag: 0.18 =========
========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-21 16:28:27.266432) =========
========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 16:28:27.266782) =========
'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-115\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-115
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-115
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-115\AppData\Local
LOGONSERVER=\\T-W864-IX-115
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-115
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-115
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-115
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-09-21 16:28:27.385877) =========
========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-09-21 16:28:27.386198) =========
========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-09-21 16:28:27.920476) =========
========= Total master_lag: 9.69 =========