builder: autoland_win8_64_test-dromaeojs-pgo
slave: t-w864-ix-163
starttime: 1478756752.05
results: success (0)
buildid: 20161109183932
builduid: dfec30c379fb4b3089c2660487183182
revision: 8ffd0e45ac580a8d0a85d603e5395297b5f2d9d3
========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-09 21:45:52.046835) =========
master: http://buildbot-master111.bb.releng.scl3.mozilla.com:8201/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-09 21:45:52.047326) =========
========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-09 21:45:52.047613) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-09 21:45:52.144922) =========
========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-09 21:45:52.145367) =========
'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-163\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-163
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-163
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-163\AppData\Local
LOGONSERVER=\\T-W864-IX-163
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:\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-163
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-163
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-163
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
--21:45:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py
=> `archiver_client.py'
Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102
Connecting to hg.mozilla.org|63.245.215.25|:443... connected.
WARNING: Certificate verification error for hg.mozilla.org: certificate signature failure
HTTP request sent, awaiting response... 200 Script output follows
Length: 12,179 (12K) [text/x-python]
0K .......... . 100% 7.99 MB/s
21:45:53 (7.99 MB/s) - `archiver_client.py' saved [12179/12179]
program finished with exit code 0
elapsedTime=1.261000
========= master_lag: 0.07 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-09 21:45:53.473097) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 4 secs) (at 2016-11-09 21:45:53.473661) =========
'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-163\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-163
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-163
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-163\AppData\Local
LOGONSERVER=\\T-W864-IX-163
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:\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-163
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-163
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-163
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
program finished with exit code 0
elapsedTime=3.309000
========= master_lag: 1.19 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 4 secs) (at 2016-11-09 21:45:57.974239) =========
========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-09 21:45:57.974603) =========
'bash' '-c' u'python archiver_client.py mozharness --repo integration/autoland --rev 8ffd0e45ac580a8d0a85d603e5395297b5f2d9d3 --destination scripts --debug'
in dir C:\slave\test\. (timeout 1200 secs)
watching logfiles {}
argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 8ffd0e45ac580a8d0a85d603e5395297b5f2d9d3 --destination scripts --debug']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld.T-W864-IX-163\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-163
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-163
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-163\AppData\Local
LOGONSERVER=\\T-W864-IX-163
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:\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-163
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-163
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-163
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
2016-11-09 21:45:58,411 truncating revision to first 12 chars
2016-11-09 21:45:58,411 Setting DEBUG logging.
2016-11-09 21:45:58,411 attempt 1/10
2016-11-09 21:45:58,411 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/8ffd0e45ac58?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2016-11-09 21:45:59,681 unpacking tar archive at: autoland-8ffd0e45ac58/testing/mozharness/
2016-11-09 21:45:59,782 skipping symlink on windows: configs/single_locale/linux32.py
program finished with exit code 0
elapsedTime=1.878000
========= master_lag: 0.39 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-09 21:46:00.246127) =========
========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-09 21:46:00.246439) =========
script_repo_revision: 8ffd0e45ac580a8d0a85d603e5395297b5f2d9d3
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-09 21:46:00.246825) =========
========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-09 21:46:00.247132) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-09 21:46:00.265328) =========
========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 30 secs) (at 2016-11-09 21:46:00.265718) =========
'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'dromaeojs' '--add-option' '--webServer,localhost' '--branch-name' 'Autoland' '--cfg' 'talos/windows_config.py' '--download-symbols' 'ondemand' '--use-talos-json' '--blob-upload-branch' 'Autoland'
in dir C:\slave\test\. (timeout 3600 secs) (maxTime 7200 secs)
watching logfiles {}
argv: ['c:/mozilla-build/python27/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/windows_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld.T-W864-IX-163\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-163
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-163
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-163\AppData\Local
LOGONSERVER=\\T-W864-IX-163
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:\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-163
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-163
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-163
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
21:46:01 INFO - MultiFileLogger online at 20161109 21:46:01 in C:\slave\test
21:46:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland
21:46:01 INFO - Dumping config to C:\slave\test\logs\localconfig.json.
21:46:01 INFO - {'append_to_log': False,
21:46:01 INFO - 'base_work_dir': 'C:\\slave\\test',
21:46:01 INFO - 'blob_upload_branch': 'Autoland',
21:46:01 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt',
21:46:01 INFO - 'branch': 'Autoland',
21:46:01 INFO - 'buildbot_json_path': 'buildprops.json',
21:46:01 INFO - 'config_files': ('talos/windows_config.py',),
21:46:01 INFO - 'default_actions': ('clobber',
21:46:01 INFO - 'read-buildbot-config',
21:46:01 INFO - 'download-and-extract',
21:46:01 INFO - 'populate-webroot',
21:46:01 INFO - 'create-virtualenv',
21:46:01 INFO - 'install',
21:46:01 INFO - 'run-tests'),
21:46:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',),
21:46:01 INFO - 'download_minidump_stackwalk': True,
21:46:01 INFO - 'download_symbols': 'ondemand',
21:46:01 INFO - 'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python',
21:46:01 INFO - 'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'),
21:46:01 INFO - 'hg': 'c:/mozilla-build/hg/hg',
21:46:01 INFO - 'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python',
21:46:01 INFO - 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'),
21:46:01 INFO - 'python': 'c:/mozilla-build/python27/python.exe',
21:46:01 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe',
21:46:01 INFO - 'C:/mozilla-build/tooltool.py'),
21:46:01 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe',
21:46:01 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')},
21:46:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub',
21:46:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'),
21:46:01 INFO - 'installer_path': 'installer.exe',
21:46:01 INFO - 'log_level': 'info',
21:46:01 INFO - 'log_name': 'talos',
21:46:01 INFO - 'log_to_console': True,
21:46:01 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe',
21:46:01 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe',
21:46:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest',
21:46:01 INFO - 'opt_config_files': (),
21:46:01 INFO - 'pip_index': False,
21:46:01 INFO - 'sps_profile': False,
21:46:01 INFO - 'sps_profile_interval': 0,
21:46:01 INFO - 'suite': 'dromaeojs',
21:46:01 INFO - 'system_bits': '32',
21:46:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'),
21:46:01 INFO - 'title': 'T-W864-IX-163',
21:46:01 INFO - 'use_talos_json': True,
21:46:01 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'),
21:46:01 INFO - 'virtualenv_path': 'C:\\slave\\test\\build/venv',
21:46:01 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll',
21:46:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
21:46:01 INFO - 'work_dir': 'build'}
21:46:01 INFO - [mozharness: 2016-11-10 05:46:01.207000Z] Running clobber step.
21:46:01 INFO - Running pre-action listener: _resource_record_pre_action
21:46:01 INFO - Running main action method: clobber
21:46:01 INFO - rmtree: C:\slave\test\build
21:46:01 INFO - Using _rmtree_windows ...
21:46:01 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1
21:47:37 INFO - Running post-action listener: _resource_record_post_action
21:47:37 INFO - [mozharness: 2016-11-10 05:47:37.665000Z] Finished clobber step (success)
21:47:37 INFO - [mozharness: 2016-11-10 05:47:37.665000Z] Running read-buildbot-config step.
21:47:37 INFO - Running pre-action listener: _resource_record_pre_action
21:47:37 INFO - Running main action method: read_buildbot_config
21:47:37 INFO - Using buildbot properties:
21:47:37 INFO - {
21:47:37 INFO - "project": "",
21:47:37 INFO - "product": "firefox",
21:47:37 INFO - "script_repo_revision": "production",
21:47:37 INFO - "builddir": "autoland_win8_64_test-dromaeojs",
21:47:37 INFO - "repository": "",
21:47:37 INFO - "buildername": "Windows 8 64-bit autoland pgo talos dromaeojs",
21:47:37 INFO - "buildid": "20161109183932",
21:47:37 INFO - "pgo_build": "True",
21:47:37 INFO - "basedir": "C:\\slave\\test",
21:47:37 INFO - "buildnumber": 83,
21:47:37 INFO - "slavename": "t-w864-ix-163",
21:47:37 INFO - "master": "http://buildbot-master111.bb.releng.scl3.mozilla.com:8201/",
21:47:37 INFO - "platform": "win8_64",
21:47:37 INFO - "scheduler": "tests-autoland-win64-pgo-talos",
21:47:37 INFO - "branch": "autoland",
21:47:37 INFO - "repo_path": "integration/autoland",
21:47:37 INFO - "revision": "8ffd0e45ac580a8d0a85d603e5395297b5f2d9d3",
21:47:37 INFO - "stage_platform": "win64-pgo",
21:47:37 INFO - "builduid": "dfec30c379fb4b3089c2660487183182",
21:47:37 INFO - "slavebuilddir": "test"
21:47:37 INFO - }
21:47:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ipf0qm3aQ568RcmsulYOZQ/artifacts/public/build/firefox-52.0a1.en-US.win64.zip.
21:47:37 INFO - Running post-action listener: _resource_record_post_action
21:47:37 INFO - [mozharness: 2016-11-10 05:47:37.668000Z] Finished read-buildbot-config step (success)
21:47:37 INFO - [mozharness: 2016-11-10 05:47:37.668000Z] Running download-and-extract step.
21:47:37 INFO - Running pre-action listener: _resource_record_pre_action
21:47:37 INFO - Running main action method: download_and_extract
21:47:37 INFO - mkdir: C:\slave\test\build\tests
21:47:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:47:37 INFO - trying https://queue.taskcluster.net/v1/task/Ipf0qm3aQ568RcmsulYOZQ/artifacts/public/build/firefox-52.0a1.en-US.win64.test_packages.json
21:47:37 INFO - Downloading https://queue.taskcluster.net/v1/task/Ipf0qm3aQ568RcmsulYOZQ/artifacts/public/build/firefox-52.0a1.en-US.win64.test_packages.json to C:\slave\test\build\firefox-52.0a1.en-US.win64.test_packages.json
21:47:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ipf0qm3aQ568RcmsulYOZQ/artifacts/public/build/firefox-52.0a1.en-US.win64.test_packages.json', 'file_name': 'C:\\slave\\test\\build\\firefox-52.0a1.en-US.win64.test_packages.json'}, attempt #1
21:47:38 INFO - Downloaded 1218 bytes.
21:47:38 INFO - Reading from file C:\slave\test\build\firefox-52.0a1.en-US.win64.test_packages.json
21:47:38 INFO - Using the following test package requirements:
21:47:38 INFO - {u'common': [u'firefox-52.0a1.en-US.win64.common.tests.zip'],
21:47:38 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.win64.common.tests.zip',
21:47:38 INFO - u'firefox-52.0a1.en-US.win64.cppunittest.tests.zip'],
21:47:38 INFO - u'gtest': [u'firefox-52.0a1.en-US.win64.common.tests.zip'],
21:47:38 INFO - u'jittest': [u'firefox-52.0a1.en-US.win64.common.tests.zip',
21:47:38 INFO - u'jsshell-win64.zip'],
21:47:38 INFO - u'mochitest': [u'firefox-52.0a1.en-US.win64.common.tests.zip',
21:47:38 INFO - u'firefox-52.0a1.en-US.win64.mochitest.tests.zip'],
21:47:38 INFO - u'mozbase': [u'firefox-52.0a1.en-US.win64.common.tests.zip'],
21:47:38 INFO - u'reftest': [u'firefox-52.0a1.en-US.win64.common.tests.zip',
21:47:38 INFO - u'firefox-52.0a1.en-US.win64.reftest.tests.zip'],
21:47:38 INFO - u'talos': [u'firefox-52.0a1.en-US.win64.common.tests.zip',
21:47:38 INFO - u'firefox-52.0a1.en-US.win64.talos.tests.zip'],
21:47:38 INFO - u'web-platform': [u'firefox-52.0a1.en-US.win64.common.tests.zip',
21:47:38 INFO - u'firefox-52.0a1.en-US.win64.web-platform.tests.zip'],
21:47:38 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.win64.common.tests.zip',
21:47:38 INFO - u'firefox-52.0a1.en-US.win64.xpcshell.tests.zip']}
21:47:38 INFO - Downloading packages: [u'firefox-52.0a1.en-US.win64.common.tests.zip'] for test suite category: common
21:47:38 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/Ipf0qm3aQ568RcmsulYOZQ/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip
21:47:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ipf0qm3aQ568RcmsulYOZQ/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip'}, attempt #1
21:47:38 INFO - Fetch https://queue.taskcluster.net/v1/task/Ipf0qm3aQ568RcmsulYOZQ/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip into memory
21:47:39 INFO - Http code: 200
21:47:39 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront)
21:47:39 INFO - x-amz-cf-id: wUnoSwecA1hTq2hasidmutn3ZRK21GAUBrcXsjSxHknWyvd2tXhwGQ==
21:47:39 INFO - x-amz-version-id: 8jBO1SOfqk3msDthjwpTFG0Of5l7c5l_
21:47:39 INFO - Expected file size: 17362715
21:47:39 INFO - Obtained file size: 17362715
21:48:10 INFO - Downloading packages: [u'firefox-52.0a1.en-US.win64.common.tests.zip', u'firefox-52.0a1.en-US.win64.talos.tests.zip'] for test suite category: talos
21:48:10 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/Ipf0qm3aQ568RcmsulYOZQ/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip
21:48:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ipf0qm3aQ568RcmsulYOZQ/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip'}, attempt #1
21:48:10 INFO - Fetch https://queue.taskcluster.net/v1/task/Ipf0qm3aQ568RcmsulYOZQ/artifacts/public/build/firefox-52.0a1.en-US.win64.common.tests.zip into memory
21:48:11 INFO - Http code: 200
21:48:11 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront)
21:48:11 INFO - x-amz-cf-id: D8fGIP1-40jZARSPbG2GXc8JPPu_p-kkPpVoOHG487k2i2pIELP5-Q==
21:48:11 INFO - x-amz-version-id: 8jBO1SOfqk3msDthjwpTFG0Of5l7c5l_
21:48:11 INFO - Expected file size: 17362715
21:48:11 INFO - Obtained file size: 17362715
21:48:21 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/Ipf0qm3aQ568RcmsulYOZQ/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip
21:48:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ipf0qm3aQ568RcmsulYOZQ/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip'}, attempt #1
21:48:21 INFO - Fetch https://queue.taskcluster.net/v1/task/Ipf0qm3aQ568RcmsulYOZQ/artifacts/public/build/firefox-52.0a1.en-US.win64.talos.tests.zip into memory
21:48:22 INFO - Http code: 200
21:48:22 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront)
21:48:22 INFO - x-amz-cf-id: EuJEF3904HbHwcpdRWpi2iCD4iOjrUaWiWKg4Ngoy6u3cnl6AVC3LQ==
21:48:22 INFO - x-amz-version-id: fq95vyg0iOhdQhLMVRL9NdD4tIHQw6OQ
21:48:22 INFO - Expected file size: 14409038
21:48:22 INFO - Obtained file size: 14409038
21:48: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')]}
21:48:42 INFO - trying https://queue.taskcluster.net/v1/task/Ipf0qm3aQ568RcmsulYOZQ/artifacts/public/build/firefox-52.0a1.en-US.win64.zip
21:48:42 INFO - Downloading https://queue.taskcluster.net/v1/task/Ipf0qm3aQ568RcmsulYOZQ/artifacts/public/build/firefox-52.0a1.en-US.win64.zip to C:\slave\test\build\firefox-52.0a1.en-US.win64.zip
21:48:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ipf0qm3aQ568RcmsulYOZQ/artifacts/public/build/firefox-52.0a1.en-US.win64.zip', 'file_name': 'C:\\slave\\test\\build\\firefox-52.0a1.en-US.win64.zip'}, attempt #1
21:48:43 INFO - Downloaded 57335326 bytes.
21:48:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ipf0qm3aQ568RcmsulYOZQ/artifacts/public/build/firefox-52.0a1.en-US.win64.zip
21:48:43 INFO - mkdir: C:\slave\test\properties
21:48:43 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url
21:48:43 INFO - Writing to file C:\slave\test\properties\build_url
21:48:43 INFO - Contents:
21:48:43 INFO - build_url:https://queue.taskcluster.net/v1/task/Ipf0qm3aQ568RcmsulYOZQ/artifacts/public/build/firefox-52.0a1.en-US.win64.zip
21:48:44 INFO - Running post-action listener: _resource_record_post_action
21:48:44 INFO - Running post-action listener: set_extra_try_arguments
21:48:44 INFO - [mozharness: 2016-11-10 05:48:44.558000Z] Finished download-and-extract step (success)
21:48:44 INFO - [mozharness: 2016-11-10 05:48:44.558000Z] Running populate-webroot step.
21:48:44 INFO - Running pre-action listener: _resource_record_pre_action
21:48:44 INFO - Running main action method: populate_webroot
21:48:44 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']},
21:48:44 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']},
21:48:44 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome',
21:48:44 INFO - u'--tppagecycles',
21:48:44 INFO - u'7'],
21:48:44 INFO - u'tests': [u'tsvgm']}},
21:48:44 INFO - u'suites': {u'chromez': {u'talos_options': [u'--disable-e10s'],
21:48:44 INFO - u'tests': [u'tresize', u'tcanvasmark']},
21:48:44 INFO - u'chromez-e10s': {u'tests': [u'tresize', u'tcanvasmark']},
21:48:44 INFO - u'dromaeojs': {u'talos_options': [u'--disable-e10s'],
21:48:44 INFO - u'tests': [u'dromaeo_css', u'kraken']},
21:48:44 INFO - u'dromaeojs-e10s': {u'tests': [u'dromaeo_css', u'kraken']},
21:48:44 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
21:48:44 INFO - u'talos_options': [u'--disable-e10s'],
21:48:44 INFO - u'tests': [u'tp5o_scroll', u'glterrain']},
21:48:44 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
21:48:44 INFO - u'tests': [u'tp5o_scroll', u'glterrain']},
21:48:44 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
21:48:44 INFO - u'talos_options': [u'--disable-e10s'],
21:48:44 INFO - u'tests': [u'damp', u'tps']},
21:48:44 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
21:48:44 INFO - u'tests': [u'damp', u'tps']},
21:48:44 INFO - u'g3': {u'talos_options': [u'--disable-e10s'],
21:48:44 INFO - u'tests': [u'dromaeo_dom']},
21:48:44 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']},
21:48:44 INFO - u'g4': {u'talos_options': [u'--disable-e10s'],
21:48:44 INFO - u'tests': [u'basic_compositor_video']},
21:48:44 INFO - u'g4-e10s': {u'tests': [u'basic_compositor_video']},
21:48:44 INFO - u'other': {u'talos_options': [u'--disable-e10s'],
21:48:44 INFO - u'tests': [u'a11yr',
21:48:44 INFO - u'ts_paint',
21:48:44 INFO - u'tpaint',
21:48:44 INFO - u'sessionrestore',
21:48:44 INFO - u'sessionrestore_no_auto_restore',
21:48:44 INFO - u'tabpaint']},
21:48:44 INFO - u'other-e10s': {u'tests': [u'a11yr',
21:48:44 INFO - u'ts_paint',
21:48:44 INFO - u'tpaint',
21:48:44 INFO - u'sessionrestore',
21:48:44 INFO - u'sessionrestore_no_auto_restore',
21:48:44 INFO - u'tabpaint']},
21:48:44 INFO - u'other-e10s_l64': {u'tests': [u'a11yr',
21:48:44 INFO - u'ts_paint',
21:48:44 INFO - u'tpaint',
21:48:44 INFO - u'sessionrestore',
21:48:44 INFO - u'sessionrestore_no_auto_restore',
21:48:44 INFO - u'tabpaint']},
21:48:44 INFO - u'other-e10s_nol64': {u'tests': [u'a11yr',
21:48:44 INFO - u'ts_paint',
21:48:44 INFO - u'tpaint',
21:48:44 INFO - u'sessionrestore',
21:48:44 INFO - u'sessionrestore_no_auto_restore',
21:48:44 INFO - u'tabpaint']},
21:48:44 INFO - u'other_l64': {u'talos_options': [u'--disable-e10s'],
21:48:44 INFO - u'tests': [u'a11yr',
21:48:44 INFO - u'ts_paint',
21:48:44 INFO - u'tpaint',
21:48:44 INFO - u'sessionrestore',
21:48:44 INFO - u'sessionrestore_no_auto_restore',
21:48:44 INFO - u'tabpaint']},
21:48:44 INFO - u'other_nol64': {u'talos_options': [u'--disable-e10s'],
21:48:44 INFO - u'tests': [u'a11yr',
21:48:44 INFO - u'ts_paint',
21:48:44 INFO - u'tpaint',
21:48:44 INFO - u'sessionrestore',
21:48:44 INFO - u'sessionrestore_no_auto_restore',
21:48:44 INFO - u'tabpaint']},
21:48:44 INFO - u'svgr': {u'talos_options': [u'--disable-e10s'],
21:48:44 INFO - u'tests': [u'tsvgx',
21:48:44 INFO - u'tsvgr_opacity',
21:48:44 INFO - u'tart',
21:48:44 INFO - u'tscrollx',
21:48:44 INFO - u'cart']},
21:48:44 INFO - u'svgr-e10s': {u'tests': [u'tsvgx',
21:48:44 INFO - u'tsvgr_opacity',
21:48:44 INFO - u'tart',
21:48:44 INFO - u'tscrollx',
21:48:44 INFO - u'cart']},
21:48:44 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
21:48:44 INFO - u'talos_options': [u'--disable-e10s'],
21:48:44 INFO - u'tests': [u'tp5o']},
21:48:44 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
21:48:44 INFO - u'tests': [u'tp5o']},
21:48:44 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
21:48:44 INFO - u'talos_options': [u'--disable-e10s',
21:48:44 INFO - u'--xperf_path',
21:48:44 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
21:48:44 INFO - u'tests': [u'tp5n']},
21:48:44 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
21:48:44 INFO - u'talos_options': [u'--xperf_path',
21:48:44 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
21:48:44 INFO - u'tests': [u'tp5n']}},
21:48:44 INFO - u'talos.zip': {u'path': u'',
21:48:44 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}}
21:48:44 INFO - Running post-action listener: _resource_record_post_action
21:48:44 INFO - [mozharness: 2016-11-10 05:48:44.594000Z] Finished populate-webroot step (success)
21:48:44 INFO - [mozharness: 2016-11-10 05:48:44.594000Z] Running create-virtualenv step.
21:48:44 INFO - Running pre-action listener: _resource_record_pre_action
21:48:44 INFO - Running main action method: create_virtualenv
21:48:44 INFO - Creating virtualenv C:\slave\test\build/venv
21:48:44 INFO - mkdir: C:\slave\test\build\venv\Scripts
21:48:45 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll
21:48:45 WARNING - Can't copy c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll: [Errno 2] No such file or directory: 'c:/mozilla-build/python27/python27.dll'!
21:48:45 INFO - Running command: ['c:/mozilla-build/python27/python.exe', 'c:/mozilla-build/buildbotve/virtualenv.py', '--no-site-packages', '--distribute', 'C:\\slave\\test\\build/venv'] in C:\slave\test\build
21:48:45 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build/venv
21:48:48 INFO - New python executable in C:\slave\test\build/venv\Scripts\python.exe
21:48:52 INFO - Installing distribute......................................................................................................................................................................................done.
21:48:53 INFO - Return code: 0
21:48:53 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', '--version']
21:48:53 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip --version
21:48:53 INFO - Reading from file tmpfile_stdout
21:48:53 INFO - Output received:
21:48:53 INFO - pip 0.8.2 from c:\slave\test\build\venv\lib\site-packages\pip-0.8.2-py2.7.egg (python 2.7)
21:48:53 INFO - Using _rmtree_windows ...
21:48:53 INFO - Using _rmtree_windows ...
21:48:53 INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv
21:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:48:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:48:53 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02370640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023EBE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0246AF08>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023C6E90>, '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 0x01DBA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028B3520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-163', 'USERDOMAIN': 'T-W864-IX-163', '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-163', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-163\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-163', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-163', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-163', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': '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-163\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
21:48:53 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in C:\slave\test\build
21:48:53 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5
21:48:53 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
21:48:53 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-163\\AppData\\Roaming',
21:48:53 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
21:48:53 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
21:48:53 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
21:48:53 INFO - 'COMPUTERNAME': 'T-W864-IX-163',
21:48:53 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
21:48:53 INFO - 'DCLOCATION': 'SCL3',
21:48:53 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
21:48:53 INFO - 'FP_NO_HOST_CHECK': 'NO',
21:48:53 INFO - 'HOMEDRIVE': 'C:',
21:48:53 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-163',
21:48:53 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
21:48:53 INFO - 'KTS_VERSION': '1.19c',
21:48:53 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-163\\AppData\\Local',
21:48:53 INFO - 'LOGONSERVER': '\\\\T-W864-IX-163',
21:48:53 INFO - 'MONDIR': 'C:\\Monitor_config\\',
21:48:53 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
21:48:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:48:53 INFO - 'MOZ_NO_REMOTE': '1',
21:48:53 INFO - 'NO_EM_RESTART': '1',
21:48:53 INFO - 'NUMBER_OF_PROCESSORS': '8',
21:48:53 INFO - 'OS': 'Windows_NT',
21:48:53 INFO - 'OURDRIVE': 'C:',
21:48:53 INFO - 'PATH': 'C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
21:48:53 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
21:48:53 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
21:48:53 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
21:48:53 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
21:48:53 INFO - 'PROCESSOR_LEVEL': '6',
21:48:53 INFO - 'PROCESSOR_REVISION': '1e05',
21:48:53 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
21:48:53 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
21:48:53 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
21:48:53 INFO - 'PROGRAMW6432': 'C:\\Program Files',
21:48:53 INFO - 'PROMPT': '$P$G',
21:48:53 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
21:48:53 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
21:48:53 INFO - 'PUBLIC': 'C:\\Users\\Public',
21:48:53 INFO - 'PWD': 'C:\\slave\\test',
21:48:53 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
21:48:53 INFO - 'SLAVEDIR': 'C:\\slave\\',
21:48:53 INFO - 'SYSTEMDRIVE': 'C:',
21:48:53 INFO - 'SYSTEMROOT': 'C:\\windows',
21:48:53 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
21:48:53 INFO - 'TEST1': 'testie',
21:48:53 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
21:48:53 INFO - 'USERDOMAIN': 'T-W864-IX-163',
21:48:53 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-163',
21:48:53 INFO - 'USERNAME': 'cltbld',
21:48:53 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-163',
21:48:53 INFO - 'WINDIR': 'C:\\windows',
21:48:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
21:48:54 INFO - Ignoring indexes: http://pypi.python.org/simple/
21:48:54 INFO - Downloading/unpacking pip>=1.5
21:48:58 INFO - Running setup.py egg_info for package pip
21:48:58 INFO - warning: no files found matching 'pip\cacert.pem'
21:48:58 INFO - warning: no files found matching '*.html' under directory 'docs'
21:48:58 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build'
21:48:58 INFO - no previously-included directories found matching 'docs\_build\_sources'
21:48:58 INFO - Installing collected packages: pip
21:48:58 INFO - Found existing installation: pip 0.8.2
21:48:58 INFO - Uninstalling pip:
21:48:58 INFO - Successfully uninstalled pip
21:48:58 INFO - Running setup.py install for pip
21:48:58 INFO - warning: no files found matching 'pip\cacert.pem'
21:48:58 INFO - warning: no files found matching '*.html' under directory 'docs'
21:48:58 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build'
21:48:58 INFO - no previously-included directories found matching 'docs\_build\_sources'
21:48:58 INFO - Installing pip-script.py script to C:\slave\test\build\venv\Scripts
21:48:58 INFO - Installing pip.exe script to C:\slave\test\build\venv\Scripts
21:48:58 INFO - Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts
21:48:58 INFO - Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts
21:48:58 INFO - Installing pip2-script.py script to C:\slave\test\build\venv\Scripts
21:48:58 INFO - Installing pip2.exe script to C:\slave\test\build\venv\Scripts
21:48:58 INFO - Successfully installed pip
21:48:58 INFO - Cleaning up...
21:48:58 INFO - Return code: 0
21:48:58 INFO - Installing psutil>=3.1.1 into virtualenv C:\slave\test\build/venv
21:48:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:48:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:48:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:48:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:48:58 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x02370640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023EBE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0246AF08>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023C6E90>, '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 0x01DBA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028B3520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-163', 'USERDOMAIN': 'T-W864-IX-163', '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-163', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-163\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-163', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-163', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-163', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': '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-163\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
21:48:58 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in C:\slave\test\build
21:48:58 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1
21:48:58 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
21:48:58 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-163\\AppData\\Roaming',
21:48:58 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
21:48:58 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
21:48:58 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
21:48:58 INFO - 'COMPUTERNAME': 'T-W864-IX-163',
21:48:58 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
21:48:58 INFO - 'DCLOCATION': 'SCL3',
21:48:58 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
21:48:58 INFO - 'FP_NO_HOST_CHECK': 'NO',
21:48:58 INFO - 'HOMEDRIVE': 'C:',
21:48:58 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-163',
21:48:58 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
21:48:58 INFO - 'KTS_VERSION': '1.19c',
21:48:58 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-163\\AppData\\Local',
21:48:58 INFO - 'LOGONSERVER': '\\\\T-W864-IX-163',
21:48:58 INFO - 'MONDIR': 'C:\\Monitor_config\\',
21:48:58 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
21:48:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:48:58 INFO - 'MOZ_NO_REMOTE': '1',
21:48:58 INFO - 'NO_EM_RESTART': '1',
21:48:58 INFO - 'NUMBER_OF_PROCESSORS': '8',
21:48:58 INFO - 'OS': 'Windows_NT',
21:48:58 INFO - 'OURDRIVE': 'C:',
21:48:58 INFO - 'PATH': 'C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
21:48:58 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
21:48:58 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
21:48:58 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
21:48:58 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
21:48:58 INFO - 'PROCESSOR_LEVEL': '6',
21:48:58 INFO - 'PROCESSOR_REVISION': '1e05',
21:48:58 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
21:48:58 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
21:48:58 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
21:48:58 INFO - 'PROGRAMW6432': 'C:\\Program Files',
21:48:58 INFO - 'PROMPT': '$P$G',
21:48:58 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
21:48:58 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
21:48:58 INFO - 'PUBLIC': 'C:\\Users\\Public',
21:48:58 INFO - 'PWD': 'C:\\slave\\test',
21:48:58 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
21:48:58 INFO - 'SLAVEDIR': 'C:\\slave\\',
21:48:58 INFO - 'SYSTEMDRIVE': 'C:',
21:48:58 INFO - 'SYSTEMROOT': 'C:\\windows',
21:48:58 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
21:48:58 INFO - 'TEST1': 'testie',
21:48:58 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
21:48:58 INFO - 'USERDOMAIN': 'T-W864-IX-163',
21:48:58 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-163',
21:48:58 INFO - 'USERNAME': 'cltbld',
21:48:58 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-163',
21:48:58 INFO - 'WINDIR': 'C:\\windows',
21:48:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
21:49:00 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:49:00 INFO - Downloading/unpacking psutil>=3.1.1
21:49:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
21:49:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
21:49:01 INFO - Installing collected packages: psutil
21:49:01 INFO - Successfully installed psutil
21:49:01 INFO - Cleaning up...
21:49:01 INFO - Return code: 0
21:49:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv C:\slave\test\build/venv
21:49:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:49:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:49:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:49:01 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 0x02370640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023EBE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0246AF08>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023C6E90>, '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 0x01DBA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028B3520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-163', 'USERDOMAIN': 'T-W864-IX-163', '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-163', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-163\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-163', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-163', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-163', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': '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-163\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
21:49:01 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in C:\slave\test\build
21:49:01 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3
21:49:01 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
21:49:01 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-163\\AppData\\Roaming',
21:49:01 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
21:49:01 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
21:49:01 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
21:49:01 INFO - 'COMPUTERNAME': 'T-W864-IX-163',
21:49:01 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
21:49:01 INFO - 'DCLOCATION': 'SCL3',
21:49:01 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
21:49:01 INFO - 'FP_NO_HOST_CHECK': 'NO',
21:49:01 INFO - 'HOMEDRIVE': 'C:',
21:49:01 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-163',
21:49:01 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
21:49:01 INFO - 'KTS_VERSION': '1.19c',
21:49:01 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-163\\AppData\\Local',
21:49:01 INFO - 'LOGONSERVER': '\\\\T-W864-IX-163',
21:49:01 INFO - 'MONDIR': 'C:\\Monitor_config\\',
21:49:01 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
21:49:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:49:01 INFO - 'MOZ_NO_REMOTE': '1',
21:49:01 INFO - 'NO_EM_RESTART': '1',
21:49:01 INFO - 'NUMBER_OF_PROCESSORS': '8',
21:49:01 INFO - 'OS': 'Windows_NT',
21:49:01 INFO - 'OURDRIVE': 'C:',
21:49:01 INFO - 'PATH': 'C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
21:49:01 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
21:49:01 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
21:49:01 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
21:49:01 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
21:49:01 INFO - 'PROCESSOR_LEVEL': '6',
21:49:01 INFO - 'PROCESSOR_REVISION': '1e05',
21:49:01 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
21:49:01 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
21:49:01 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
21:49:01 INFO - 'PROGRAMW6432': 'C:\\Program Files',
21:49:01 INFO - 'PROMPT': '$P$G',
21:49:01 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
21:49:01 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
21:49:01 INFO - 'PUBLIC': 'C:\\Users\\Public',
21:49:01 INFO - 'PWD': 'C:\\slave\\test',
21:49:01 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
21:49:01 INFO - 'SLAVEDIR': 'C:\\slave\\',
21:49:01 INFO - 'SYSTEMDRIVE': 'C:',
21:49:01 INFO - 'SYSTEMROOT': 'C:\\windows',
21:49:01 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
21:49:01 INFO - 'TEST1': 'testie',
21:49:01 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
21:49:01 INFO - 'USERDOMAIN': 'T-W864-IX-163',
21:49:01 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-163',
21:49:01 INFO - 'USERNAME': 'cltbld',
21:49:01 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-163',
21:49:01 INFO - 'WINDIR': 'C:\\windows',
21:49:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
21:49:02 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:49:02 INFO - Downloading/unpacking mozsystemmonitor==0.3
21:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
21:49:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
21:49:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz
21:49:03 INFO - Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor
21:49:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in c:\slave\test\build\venv\lib\site-packages (from mozsystemmonitor==0.3)
21:49:03 INFO - Installing collected packages: mozsystemmonitor
21:49:03 INFO - Running setup.py install for mozsystemmonitor
21:49:03 INFO - Successfully installed mozsystemmonitor
21:49:03 INFO - Cleaning up...
21:49:04 INFO - Return code: 0
21:49:04 INFO - Installing jsonschema==2.5.1 into virtualenv C:\slave\test\build/venv
21:49:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:49:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:49:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:49:04 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 0x02370640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023EBE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0246AF08>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023C6E90>, '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 0x01DBA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028B3520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-163', 'USERDOMAIN': 'T-W864-IX-163', '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-163', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-163\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-163', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-163', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-163', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': '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-163\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
21:49:04 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in C:\slave\test\build
21:49:04 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1
21:49:04 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
21:49:04 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-163\\AppData\\Roaming',
21:49:04 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
21:49:04 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
21:49:04 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
21:49:04 INFO - 'COMPUTERNAME': 'T-W864-IX-163',
21:49:04 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
21:49:04 INFO - 'DCLOCATION': 'SCL3',
21:49:04 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
21:49:04 INFO - 'FP_NO_HOST_CHECK': 'NO',
21:49:04 INFO - 'HOMEDRIVE': 'C:',
21:49:04 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-163',
21:49:04 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
21:49:04 INFO - 'KTS_VERSION': '1.19c',
21:49:04 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-163\\AppData\\Local',
21:49:04 INFO - 'LOGONSERVER': '\\\\T-W864-IX-163',
21:49:04 INFO - 'MONDIR': 'C:\\Monitor_config\\',
21:49:04 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
21:49:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:49:04 INFO - 'MOZ_NO_REMOTE': '1',
21:49:04 INFO - 'NO_EM_RESTART': '1',
21:49:04 INFO - 'NUMBER_OF_PROCESSORS': '8',
21:49:04 INFO - 'OS': 'Windows_NT',
21:49:04 INFO - 'OURDRIVE': 'C:',
21:49:04 INFO - 'PATH': 'C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
21:49:04 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
21:49:04 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
21:49:04 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
21:49:04 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
21:49:04 INFO - 'PROCESSOR_LEVEL': '6',
21:49:04 INFO - 'PROCESSOR_REVISION': '1e05',
21:49:04 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
21:49:04 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
21:49:04 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
21:49:04 INFO - 'PROGRAMW6432': 'C:\\Program Files',
21:49:04 INFO - 'PROMPT': '$P$G',
21:49:04 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
21:49:04 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
21:49:04 INFO - 'PUBLIC': 'C:\\Users\\Public',
21:49:04 INFO - 'PWD': 'C:\\slave\\test',
21:49:04 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
21:49:04 INFO - 'SLAVEDIR': 'C:\\slave\\',
21:49:04 INFO - 'SYSTEMDRIVE': 'C:',
21:49:04 INFO - 'SYSTEMROOT': 'C:\\windows',
21:49:04 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
21:49:04 INFO - 'TEST1': 'testie',
21:49:04 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
21:49:04 INFO - 'USERDOMAIN': 'T-W864-IX-163',
21:49:04 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-163',
21:49:04 INFO - 'USERNAME': 'cltbld',
21:49:04 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-163',
21:49:04 INFO - 'WINDIR': 'C:\\windows',
21:49:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
21:49:04 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:49:04 INFO - Downloading/unpacking jsonschema==2.5.1
21:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
21:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
21:49:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl
21:49:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1)
21:49:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
21:49:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
21:49:05 INFO - Downloading functools32-3.2.3-2.tar.gz
21:49:05 INFO - Running setup.py (path:C:\slave\test\build\venv\build\functools32\setup.py) egg_info for package functools32
21:49:05 INFO - warning: no files found matching '*.txt'
21:49:05 INFO - no previously-included directories found matching 'build'
21:49:05 INFO - no previously-included directories found matching 'dist'
21:49:05 INFO - no previously-included directories found matching '.git*'
21:49:05 INFO - Installing collected packages: jsonschema, functools32
21:49:05 INFO - Running setup.py install for functools32
21:49:05 INFO - warning: no files found matching '*.txt'
21:49:05 INFO - no previously-included directories found matching 'build'
21:49:05 INFO - no previously-included directories found matching 'dist'
21:49:05 INFO - no previously-included directories found matching '.git*'
21:49:05 INFO - Successfully installed jsonschema functools32
21:49:05 INFO - Cleaning up...
21:49:06 INFO - Return code: 0
21:49:06 INFO - Installing functools32==3.2.3-2 into virtualenv C:\slave\test\build/venv
21:49:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:49:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:49:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:49:06 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 0x02370640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023EBE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0246AF08>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023C6E90>, '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 0x01DBA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028B3520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-163', 'USERDOMAIN': 'T-W864-IX-163', '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-163', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-163\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-163', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-163', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-163', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': '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-163\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
21:49:06 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in C:\slave\test\build
21:49:06 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2
21:49:06 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
21:49:06 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-163\\AppData\\Roaming',
21:49:06 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
21:49:06 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
21:49:06 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
21:49:06 INFO - 'COMPUTERNAME': 'T-W864-IX-163',
21:49:06 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
21:49:06 INFO - 'DCLOCATION': 'SCL3',
21:49:06 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
21:49:06 INFO - 'FP_NO_HOST_CHECK': 'NO',
21:49:06 INFO - 'HOMEDRIVE': 'C:',
21:49:06 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-163',
21:49:06 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
21:49:06 INFO - 'KTS_VERSION': '1.19c',
21:49:06 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-163\\AppData\\Local',
21:49:06 INFO - 'LOGONSERVER': '\\\\T-W864-IX-163',
21:49:06 INFO - 'MONDIR': 'C:\\Monitor_config\\',
21:49:06 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
21:49:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:49:06 INFO - 'MOZ_NO_REMOTE': '1',
21:49:06 INFO - 'NO_EM_RESTART': '1',
21:49:06 INFO - 'NUMBER_OF_PROCESSORS': '8',
21:49:06 INFO - 'OS': 'Windows_NT',
21:49:06 INFO - 'OURDRIVE': 'C:',
21:49:06 INFO - 'PATH': 'C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
21:49:06 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
21:49:06 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
21:49:06 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
21:49:06 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
21:49:06 INFO - 'PROCESSOR_LEVEL': '6',
21:49:06 INFO - 'PROCESSOR_REVISION': '1e05',
21:49:06 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
21:49:06 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
21:49:06 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
21:49:06 INFO - 'PROGRAMW6432': 'C:\\Program Files',
21:49:06 INFO - 'PROMPT': '$P$G',
21:49:06 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
21:49:06 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
21:49:06 INFO - 'PUBLIC': 'C:\\Users\\Public',
21:49:06 INFO - 'PWD': 'C:\\slave\\test',
21:49:06 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
21:49:06 INFO - 'SLAVEDIR': 'C:\\slave\\',
21:49:06 INFO - 'SYSTEMDRIVE': 'C:',
21:49:06 INFO - 'SYSTEMROOT': 'C:\\windows',
21:49:06 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
21:49:06 INFO - 'TEST1': 'testie',
21:49:06 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
21:49:06 INFO - 'USERDOMAIN': 'T-W864-IX-163',
21:49:06 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-163',
21:49:06 INFO - 'USERNAME': 'cltbld',
21:49:06 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-163',
21:49:06 INFO - 'WINDIR': 'C:\\windows',
21:49:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
21:49:06 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:49:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in c:\slave\test\build\venv\lib\site-packages
21:49:06 INFO - Cleaning up...
21:49:06 INFO - Return code: 0
21:49:06 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv
21:49:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:49:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:49:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:49:06 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 0x02370640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023EBE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0246AF08>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023C6E90>, '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 0x01DBA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028B3520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-163', 'USERDOMAIN': 'T-W864-IX-163', '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-163', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-163\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-163', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-163', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-163', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': '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-163\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
21:49:06 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in C:\slave\test\build
21:49:06 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4
21:49:06 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
21:49:06 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-163\\AppData\\Roaming',
21:49:06 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
21:49:06 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
21:49:06 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
21:49:06 INFO - 'COMPUTERNAME': 'T-W864-IX-163',
21:49:06 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
21:49:06 INFO - 'DCLOCATION': 'SCL3',
21:49:06 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
21:49:06 INFO - 'FP_NO_HOST_CHECK': 'NO',
21:49:06 INFO - 'HOMEDRIVE': 'C:',
21:49:06 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-163',
21:49:06 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
21:49:06 INFO - 'KTS_VERSION': '1.19c',
21:49:06 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-163\\AppData\\Local',
21:49:06 INFO - 'LOGONSERVER': '\\\\T-W864-IX-163',
21:49:06 INFO - 'MONDIR': 'C:\\Monitor_config\\',
21:49:06 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
21:49:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:49:06 INFO - 'MOZ_NO_REMOTE': '1',
21:49:06 INFO - 'NO_EM_RESTART': '1',
21:49:06 INFO - 'NUMBER_OF_PROCESSORS': '8',
21:49:06 INFO - 'OS': 'Windows_NT',
21:49:06 INFO - 'OURDRIVE': 'C:',
21:49:06 INFO - 'PATH': 'C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
21:49:06 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
21:49:06 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
21:49:06 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
21:49:06 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
21:49:06 INFO - 'PROCESSOR_LEVEL': '6',
21:49:06 INFO - 'PROCESSOR_REVISION': '1e05',
21:49:06 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
21:49:06 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
21:49:06 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
21:49:06 INFO - 'PROGRAMW6432': 'C:\\Program Files',
21:49:06 INFO - 'PROMPT': '$P$G',
21:49:06 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
21:49:06 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
21:49:06 INFO - 'PUBLIC': 'C:\\Users\\Public',
21:49:06 INFO - 'PWD': 'C:\\slave\\test',
21:49:06 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
21:49:06 INFO - 'SLAVEDIR': 'C:\\slave\\',
21:49:06 INFO - 'SYSTEMDRIVE': 'C:',
21:49:06 INFO - 'SYSTEMROOT': 'C:\\windows',
21:49:06 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
21:49:06 INFO - 'TEST1': 'testie',
21:49:06 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
21:49:06 INFO - 'USERDOMAIN': 'T-W864-IX-163',
21:49:06 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-163',
21:49:06 INFO - 'USERNAME': 'cltbld',
21:49:06 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-163',
21:49:06 INFO - 'WINDIR': 'C:\\windows',
21:49:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
21:49:07 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:49:07 INFO - Downloading/unpacking blobuploader==1.2.4
21:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
21:49:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
21:49:08 INFO - Downloading blobuploader-1.2.4.tar.gz
21:49:08 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader
21:49:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4)
21:49:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
21:49:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
21:49:08 INFO - Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests
21:49:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4)
21:49:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
21:49:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
21:49:08 INFO - Downloading docopt-0.6.1.tar.gz
21:49:08 INFO - Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt
21:49:09 INFO - Installing collected packages: blobuploader, requests, docopt
21:49:09 INFO - Running setup.py install for blobuploader
21:49:09 INFO - Running setup.py install for requests
21:49:09 INFO - Running setup.py install for docopt
21:49:09 INFO - Successfully installed blobuploader requests docopt
21:49:09 INFO - Cleaning up...
21:49:10 INFO - Return code: 0
21:49:10 INFO - Installing None into virtualenv C:\slave\test\build/venv
21:49: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')]}
21:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:49: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')]}
21:49:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:49:10 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 0x02370640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023EBE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0246AF08>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023C6E90>, '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 0x01DBA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028B3520>, '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-163', 'USERDOMAIN': 'T-W864-IX-163', '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-163', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-163\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-163', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-163', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-163', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': '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-163\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
21:49:11 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--no-deps', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in C:\slave\test\build\tests\config
21:49:11 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --no-deps --timeout 120 -r C:\slave\test\build\tests\config\mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub
21:49:11 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
21:49:11 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-163\\AppData\\Roaming',
21:49:11 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
21:49:11 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
21:49:11 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
21:49:11 INFO - 'COMPUTERNAME': 'T-W864-IX-163',
21:49:11 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
21:49:11 INFO - 'DCLOCATION': 'SCL3',
21:49:11 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
21:49:11 INFO - 'FP_NO_HOST_CHECK': 'NO',
21:49:11 INFO - 'HOMEDRIVE': 'C:',
21:49:11 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-163',
21:49:11 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
21:49:11 INFO - 'KTS_VERSION': '1.19c',
21:49:11 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-163\\AppData\\Local',
21:49:11 INFO - 'LOGONSERVER': '\\\\T-W864-IX-163',
21:49:11 INFO - 'MONDIR': 'C:\\Monitor_config\\',
21:49:11 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
21:49:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:49:11 INFO - 'MOZ_NO_REMOTE': '1',
21:49:11 INFO - 'NO_EM_RESTART': '1',
21:49:11 INFO - 'NUMBER_OF_PROCESSORS': '8',
21:49:11 INFO - 'OS': 'Windows_NT',
21:49:11 INFO - 'OURDRIVE': 'C:',
21:49:11 INFO - 'PATH': 'C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
21:49:11 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
21:49:11 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
21:49:11 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
21:49:11 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
21:49:11 INFO - 'PROCESSOR_LEVEL': '6',
21:49:11 INFO - 'PROCESSOR_REVISION': '1e05',
21:49:11 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
21:49:11 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
21:49:11 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
21:49:11 INFO - 'PROGRAMW6432': 'C:\\Program Files',
21:49:11 INFO - 'PROMPT': '$P$G',
21:49:11 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
21:49:11 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
21:49:11 INFO - 'PUBLIC': 'C:\\Users\\Public',
21:49:11 INFO - 'PWD': 'C:\\slave\\test',
21:49:11 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
21:49:11 INFO - 'SLAVEDIR': 'C:\\slave\\',
21:49:11 INFO - 'SYSTEMDRIVE': 'C:',
21:49:11 INFO - 'SYSTEMROOT': 'C:\\windows',
21:49:11 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
21:49:11 INFO - 'TEST1': 'testie',
21:49:11 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
21:49:11 INFO - 'USERDOMAIN': 'T-W864-IX-163',
21:49:11 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-163',
21:49:11 INFO - 'USERNAME': 'cltbld',
21:49:11 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-163',
21:49:11 INFO - 'WINDIR': 'C:\\windows',
21:49:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
21:49:11 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:49:11 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser
21:49:11 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xt_sjj-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser
21:49:11 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash
21:49:11 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-kulfdm-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash
21:49:11 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug
21:49:11 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-dkhrj2-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug
21:49:11 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice
21:49:11 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-kl6fxp-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice
21:49:11 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile
21:49:11 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ddnwkw-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile
21:49:11 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd
21:49:11 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-bplotd-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd
21:49:12 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo
21:49:12 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-7mx_k2-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo
21:49:12 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall
21:49:12 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-btpwor-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall
21:49:12 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak
21:49:12 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-teqz1r-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak
21:49:12 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog
21:49:12 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jonkdp-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog
21:49:12 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork
21:49:12 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rxj63f-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork
21:49:12 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess
21:49:12 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-krmzlj-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess
21:49:12 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile
21:49:12 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-cwotda-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile
21:49:12 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner
21:49:12 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-polnpb-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner
21:49:12 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot
21:49:12 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-1a4lel-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot
21:49:13 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest
21:49:13 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-yccxsj-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest
21:49:13 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion
21:49:13 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-r0z9xg-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion
21:49:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion
21:49:13 INFO - Running setup.py install for manifestparser
21:49:13 INFO - Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts
21:49:13 INFO - Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts
21:49:13 INFO - Running setup.py install for mozcrash
21:49:14 INFO - Running setup.py install for mozdebug
21:49:14 INFO - Running setup.py install for mozdevice
21:49:15 INFO - Installing sutini-script.py script to C:\slave\test\build\venv\Scripts
21:49:15 INFO - Installing sutini.exe script to C:\slave\test\build\venv\Scripts
21:49:15 INFO - Installing dm-script.py script to C:\slave\test\build\venv\Scripts
21:49:15 INFO - Installing dm.exe script to C:\slave\test\build\venv\Scripts
21:49:15 INFO - Running setup.py install for mozfile
21:49:16 INFO - Running setup.py install for mozhttpd
21:49:16 INFO - Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts
21:49:16 INFO - Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts
21:49:16 INFO - Running setup.py install for mozinfo
21:49:16 INFO - Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts
21:49:16 INFO - Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts
21:49:16 INFO - Running setup.py install for mozInstall
21:49:16 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts
21:49:16 INFO - Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts
21:49:16 INFO - Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts
21:49:16 INFO - Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts
21:49:16 INFO - Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts
21:49:16 INFO - Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts
21:49:16 INFO - Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts
21:49:16 INFO - Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts
21:49:17 INFO - Running setup.py install for mozleak
21:49:17 INFO - Running setup.py install for mozlog
21:49:18 INFO - Installing structlog-script.py script to C:\slave\test\build\venv\Scripts
21:49:18 INFO - Installing structlog.exe script to C:\slave\test\build\venv\Scripts
21:49:18 INFO - Running setup.py install for moznetwork
21:49:18 INFO - Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts
21:49:18 INFO - Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts
21:49:19 INFO - Running setup.py install for mozprocess
21:49:19 INFO - Running setup.py install for mozprofile
21:49:19 INFO - Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts
21:49:19 INFO - Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts
21:49:19 INFO - Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts
21:49:19 INFO - Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts
21:49:19 INFO - Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts
21:49:19 INFO - Installing view-profile.exe script to C:\slave\test\build\venv\Scripts
21:49:20 INFO - Running setup.py install for mozrunner
21:49:20 INFO - Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts
21:49:20 INFO - Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts
21:49:21 INFO - Running setup.py install for mozscreenshot
21:49:21 INFO - Running setup.py install for moztest
21:49:22 INFO - Running setup.py install for mozversion
21:49:22 INFO - Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts
21:49:22 INFO - Installing mozversion.exe script to C:\slave\test\build\venv\Scripts
21:49:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion
21:49:22 INFO - Cleaning up...
21:49:22 INFO - Return code: 0
21:49:22 INFO - Installing None into virtualenv C:\slave\test\build/venv
21:49:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:49:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:49:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:49:22 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 0x02370640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023EBE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0246AF08>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023C6E90>, '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 0x01DBA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028B3520>, '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-163', 'USERDOMAIN': 'T-W864-IX-163', '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-163', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-163\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-163', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-163', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-163', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': '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-163\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
21:49:22 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in C:\slave\test\build\tests\config
21:49:22 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 -r C:\slave\test\build\tests\config\mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub
21:49:22 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
21:49:22 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-163\\AppData\\Roaming',
21:49:22 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
21:49:22 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
21:49:22 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
21:49:22 INFO - 'COMPUTERNAME': 'T-W864-IX-163',
21:49:22 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
21:49:22 INFO - 'DCLOCATION': 'SCL3',
21:49:22 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
21:49:22 INFO - 'FP_NO_HOST_CHECK': 'NO',
21:49:22 INFO - 'HOMEDRIVE': 'C:',
21:49:22 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-163',
21:49:22 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
21:49:22 INFO - 'KTS_VERSION': '1.19c',
21:49:22 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-163\\AppData\\Local',
21:49:22 INFO - 'LOGONSERVER': '\\\\T-W864-IX-163',
21:49:22 INFO - 'MONDIR': 'C:\\Monitor_config\\',
21:49:22 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
21:49:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:49:22 INFO - 'MOZ_NO_REMOTE': '1',
21:49:22 INFO - 'NO_EM_RESTART': '1',
21:49:22 INFO - 'NUMBER_OF_PROCESSORS': '8',
21:49:22 INFO - 'OS': 'Windows_NT',
21:49:22 INFO - 'OURDRIVE': 'C:',
21:49:22 INFO - 'PATH': 'C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
21:49:22 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
21:49:22 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
21:49:22 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
21:49:22 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
21:49:22 INFO - 'PROCESSOR_LEVEL': '6',
21:49:22 INFO - 'PROCESSOR_REVISION': '1e05',
21:49:22 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
21:49:22 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
21:49:22 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
21:49:22 INFO - 'PROGRAMW6432': 'C:\\Program Files',
21:49:22 INFO - 'PROMPT': '$P$G',
21:49:22 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
21:49:22 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
21:49:22 INFO - 'PUBLIC': 'C:\\Users\\Public',
21:49:22 INFO - 'PWD': 'C:\\slave\\test',
21:49:22 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
21:49:22 INFO - 'SLAVEDIR': 'C:\\slave\\',
21:49:22 INFO - 'SYSTEMDRIVE': 'C:',
21:49:22 INFO - 'SYSTEMROOT': 'C:\\windows',
21:49:22 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
21:49:22 INFO - 'TEST1': 'testie',
21:49:22 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
21:49:22 INFO - 'USERDOMAIN': 'T-W864-IX-163',
21:49:22 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-163',
21:49:22 INFO - 'USERNAME': 'cltbld',
21:49:22 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-163',
21:49:22 INFO - 'WINDIR': 'C:\\windows',
21:49:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
21:49:22 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:49:22 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser
21:49:22 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ubkouv-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser
21:49:22 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///C:/slave/test/build/tests/mozbase/manifestparser in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 1))
21:49:22 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash
21:49:22 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-pmz771-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash
21:49:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///C:/slave/test/build/tests/mozbase/mozcrash in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2))
21:49:23 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug
21:49:23 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-bm3go9-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug
21:49:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///C:/slave/test/build/tests/mozbase/mozdebug in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 3))
21:49:23 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice
21:49:23 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-_cqhkv-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice
21:49:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///C:/slave/test/build/tests/mozbase/mozdevice in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4))
21:49:23 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile
21:49:23 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-h7eh02-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile
21:49:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///C:/slave/test/build/tests/mozbase/mozfile in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 5))
21:49:23 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd
21:49:23 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-e2euds-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd
21:49:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///C:/slave/test/build/tests/mozbase/mozhttpd in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 6))
21:49:23 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo
21:49:23 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-nesh1n-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo
21:49:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///C:/slave/test/build/tests/mozbase/mozinfo in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 7))
21:49:23 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall
21:49:23 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-fpuung-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall
21:49:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///C:/slave/test/build/tests/mozbase/mozinstall in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 8))
21:49:23 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak
21:49:23 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-_j4qde-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak
21:49:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///C:/slave/test/build/tests/mozbase/mozleak in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 9))
21:49:23 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog
21:49:23 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-lv9lvo-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog
21:49:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///C:/slave/test/build/tests/mozbase/mozlog in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10))
21:49:24 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork
21:49:24 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-geqsmf-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork
21:49:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///C:/slave/test/build/tests/mozbase/moznetwork in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 11))
21:49:24 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess
21:49:24 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-z7jfta-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess
21:49:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///C:/slave/test/build/tests/mozbase/mozprocess in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 12))
21:49:24 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile
21:49:24 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-s_9qho-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile
21:49:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///C:/slave/test/build/tests/mozbase/mozprofile in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 13))
21:49:24 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner
21:49:24 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rtn0sf-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner
21:49:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///C:/slave/test/build/tests/mozbase/mozrunner in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 14))
21:49:24 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot
21:49:24 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-iu97c4-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot
21:49:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///C:/slave/test/build/tests/mozbase/mozscreenshot in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 15))
21:49:24 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest
21:49:24 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xe1cas-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest
21:49:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///C:/slave/test/build/tests/mozbase/moztest in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 16))
21:49:24 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion
21:49:24 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-cf90qz-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion
21:49:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///C:/slave/test/build/tests/mozbase/mozversion in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 17))
21:49:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==1.0->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2))
21:49:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==1.0->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2))
21:49:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in c:\slave\test\build\venv\lib\site-packages (from mozdebug==0.1->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 3))
21:49:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test\build\venv\lib\site-packages (from mozdevice==0.48->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4))
21:49:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in c:\slave\test\build\venv\lib\site-packages (from mozdevice==0.48->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4))
21:49:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10))
21:49:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
21:49:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
21:49:25 INFO - Downloading blessings-1.6.tar.gz
21:49:25 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings
21:49:26 INFO - Installing collected packages: blessings
21:49:26 INFO - Running setup.py install for blessings
21:49:26 INFO - Successfully installed blessings
21:49:26 INFO - Cleaning up...
21:49:29 INFO - Return code: 0
21:49:29 INFO - Done creating virtualenv C:\slave\test\build/venv.
21:49:29 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze']
21:49:29 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze
21:49:29 INFO - Reading from file tmpfile_stdout
21:49:29 INFO - Using _rmtree_windows ...
21:49:29 INFO - Using _rmtree_windows ...
21:49:29 INFO - Current package versions:
21:49:29 INFO - blessings == 1.6
21:49:29 INFO - blobuploader == 1.2.4
21:49:29 INFO - docopt == 0.6.1
21:49:29 INFO - functools32 == 3.2.3-2
21:49:29 INFO - jsonschema == 2.5.1
21:49:29 INFO - manifestparser == 1.1
21:49:29 INFO - mozInstall == 1.12
21:49:29 INFO - mozcrash == 1.0
21:49:29 INFO - mozdebug == 0.1
21:49:29 INFO - mozdevice == 0.48
21:49:29 INFO - mozfile == 1.2
21:49:29 INFO - mozhttpd == 0.7
21:49:29 INFO - mozinfo == 0.9
21:49:29 INFO - mozleak == 0.1
21:49:29 INFO - mozlog == 3.4
21:49:29 INFO - moznetwork == 0.27
21:49:29 INFO - mozprocess == 0.23
21:49:29 INFO - mozprofile == 0.28
21:49:29 INFO - mozrunner == 6.13
21:49:29 INFO - mozscreenshot == 0.1
21:49:29 INFO - mozsystemmonitor == 0.3
21:49:29 INFO - moztest == 0.7
21:49:29 INFO - mozversion == 1.4
21:49:29 INFO - psutil == 3.1.1
21:49:29 INFO - requests == 1.2.3
21:49:29 INFO - Installing None into virtualenv C:\slave\test\build/venv
21:49:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:49:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:49:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:49:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:49:29 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 0x02370640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023EBE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0246AF08>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023C6E90>, '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 0x01DBA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028B3520>, '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-163', 'USERDOMAIN': 'T-W864-IX-163', '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-163', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-163\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-163', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-163', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-163', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': '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-163\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
21:49:29 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\talos\\requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in C:\slave\test\build\tests\talos
21:49:29 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 -r C:\slave\test\build\tests\talos\requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub
21:49:29 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
21:49:29 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-163\\AppData\\Roaming',
21:49:29 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
21:49:29 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
21:49:29 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
21:49:29 INFO - 'COMPUTERNAME': 'T-W864-IX-163',
21:49:29 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
21:49:29 INFO - 'DCLOCATION': 'SCL3',
21:49:29 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
21:49:29 INFO - 'FP_NO_HOST_CHECK': 'NO',
21:49:29 INFO - 'HOMEDRIVE': 'C:',
21:49:29 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-163',
21:49:29 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
21:49:29 INFO - 'KTS_VERSION': '1.19c',
21:49:29 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-163\\AppData\\Local',
21:49:29 INFO - 'LOGONSERVER': '\\\\T-W864-IX-163',
21:49:29 INFO - 'MONDIR': 'C:\\Monitor_config\\',
21:49:29 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
21:49:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:49:29 INFO - 'MOZ_NO_REMOTE': '1',
21:49:29 INFO - 'NO_EM_RESTART': '1',
21:49:29 INFO - 'NUMBER_OF_PROCESSORS': '8',
21:49:29 INFO - 'OS': 'Windows_NT',
21:49:29 INFO - 'OURDRIVE': 'C:',
21:49:29 INFO - 'PATH': 'C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
21:49:29 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
21:49:29 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
21:49:29 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
21:49:29 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
21:49:29 INFO - 'PROCESSOR_LEVEL': '6',
21:49:29 INFO - 'PROCESSOR_REVISION': '1e05',
21:49:29 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
21:49:29 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
21:49:29 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
21:49:29 INFO - 'PROGRAMW6432': 'C:\\Program Files',
21:49:29 INFO - 'PROMPT': '$P$G',
21:49:29 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
21:49:29 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
21:49:29 INFO - 'PUBLIC': 'C:\\Users\\Public',
21:49:29 INFO - 'PWD': 'C:\\slave\\test',
21:49:29 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
21:49:29 INFO - 'SLAVEDIR': 'C:\\slave\\',
21:49:29 INFO - 'SYSTEMDRIVE': 'C:',
21:49:29 INFO - 'SYSTEMROOT': 'C:\\windows',
21:49:29 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
21:49:29 INFO - 'TEST1': 'testie',
21:49:29 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
21:49:29 INFO - 'USERDOMAIN': 'T-W864-IX-163',
21:49:29 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-163',
21:49:29 INFO - 'USERNAME': 'cltbld',
21:49:29 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-163',
21:49:29 INFO - 'WINDIR': 'C:\\windows',
21:49:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
21:49:30 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:49:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 1))
21:49:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 2))
21:49:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 3))
21:49:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 4))
21:49:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 5))
21:49:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 6))
21:49:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 7))
21:49:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 8))
21:49:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 9))
21:49:30 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in c:\slave\test\build\venv\lib\site-packages (from mozlog>=3.1->-r C:\slave\test\build\tests\talos\requirements.txt (line 1))
21:49:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test\build\venv\lib\site-packages (from mozhttpd>=0.7->-r C:\slave\test\build\tests\talos\requirements.txt (line 4))
21:49:30 INFO - Cleaning up...
21:49:30 INFO - Return code: 0
21:49:30 INFO - Installing jsonschema into virtualenv C:\slave\test\build/venv
21:49:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:49:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:49:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:49:30 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 0x02370640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023EBE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0246AF08>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023C6E90>, '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 0x01DBA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028B3520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-163', 'USERDOMAIN': 'T-W864-IX-163', '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-163', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-163\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-163', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-163', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-163', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'PATH': '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-163\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
21:49:30 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in C:\slave\test\build
21:49:30 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema
21:49:30 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
21:49:30 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-163\\AppData\\Roaming',
21:49:30 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
21:49:30 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
21:49:30 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
21:49:30 INFO - 'COMPUTERNAME': 'T-W864-IX-163',
21:49:30 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
21:49:30 INFO - 'DCLOCATION': 'SCL3',
21:49:30 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
21:49:30 INFO - 'FP_NO_HOST_CHECK': 'NO',
21:49:30 INFO - 'HOMEDRIVE': 'C:',
21:49:30 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-163',
21:49:30 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
21:49:30 INFO - 'KTS_VERSION': '1.19c',
21:49:30 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-163\\AppData\\Local',
21:49:30 INFO - 'LOGONSERVER': '\\\\T-W864-IX-163',
21:49:30 INFO - 'MONDIR': 'C:\\Monitor_config\\',
21:49:30 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
21:49:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:49:30 INFO - 'MOZ_NO_REMOTE': '1',
21:49:30 INFO - 'NO_EM_RESTART': '1',
21:49:30 INFO - 'NUMBER_OF_PROCESSORS': '8',
21:49:30 INFO - 'OS': 'Windows_NT',
21:49:30 INFO - 'OURDRIVE': 'C:',
21:49:30 INFO - 'PATH': 'C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
21:49:30 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
21:49:30 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
21:49:30 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
21:49:30 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
21:49:30 INFO - 'PROCESSOR_LEVEL': '6',
21:49:30 INFO - 'PROCESSOR_REVISION': '1e05',
21:49:30 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
21:49:30 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
21:49:30 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
21:49:30 INFO - 'PROGRAMW6432': 'C:\\Program Files',
21:49:30 INFO - 'PROMPT': '$P$G',
21:49:30 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
21:49:30 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
21:49:30 INFO - 'PUBLIC': 'C:\\Users\\Public',
21:49:30 INFO - 'PWD': 'C:\\slave\\test',
21:49:30 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
21:49:30 INFO - 'SLAVEDIR': 'C:\\slave\\',
21:49:30 INFO - 'SYSTEMDRIVE': 'C:',
21:49:30 INFO - 'SYSTEMROOT': 'C:\\windows',
21:49:30 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
21:49:30 INFO - 'TEST1': 'testie',
21:49:30 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
21:49:30 INFO - 'USERDOMAIN': 'T-W864-IX-163',
21:49:30 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-163',
21:49:30 INFO - 'USERNAME': 'cltbld',
21:49:30 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-163',
21:49:30 INFO - 'WINDIR': 'C:\\windows',
21:49:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
21:49:30 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:49:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in c:\slave\test\build\venv\lib\site-packages
21:49:30 INFO - Cleaning up...
21:49:30 INFO - Return code: 0
21:49:30 INFO - Running post-action listener: _resource_record_post_action
21:49:30 INFO - Running post-action listener: _start_resource_monitoring
21:49:30 INFO - Starting resource monitoring.
21:49:30 INFO - [mozharness: 2016-11-10 05:49:30.749000Z] Finished create-virtualenv step (success)
21:49:30 INFO - [mozharness: 2016-11-10 05:49:30.750000Z] Running install step.
21:49:30 INFO - Running pre-action listener: _resource_record_pre_action
21:49:30 INFO - Running main action method: install
21:49:30 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze']
21:49:30 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze
21:49:31 INFO - Reading from file tmpfile_stdout
21:49:31 INFO - Using _rmtree_windows ...
21:49:31 INFO - Using _rmtree_windows ...
21:49:31 INFO - Detecting whether we're running mozinstall >=1.0...
21:49:31 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h']
21:49:31 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h
21:49:31 INFO - Reading from file tmpfile_stdout
21:49:31 INFO - Output received:
21:49:31 INFO - Usage: mozinstall-script.py [options] installer
21:49:31 INFO - Options:
21:49:31 INFO - -h, --help show this help message and exit
21:49:31 INFO - -d DEST, --destination=DEST
21:49:31 INFO - Directory to install application into. [default:
21:49:31 INFO - "C:\slave\test"]
21:49:31 INFO - --app=APP Application being installed. [default: firefox]
21:49:31 INFO - Using _rmtree_windows ...
21:49:31 INFO - Using _rmtree_windows ...
21:49:31 INFO - mkdir: C:\slave\test\build\application
21:49:31 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', 'C:\\slave\\test\\build\\firefox-52.0a1.en-US.win64.zip', '--destination', 'C:\\slave\\test\\build\\application']
21:49:31 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
21:49:34 INFO - Reading from file tmpfile_stdout
21:49:34 INFO - Output received:
21:49:34 INFO - C:\slave\test\build\application\firefox\firefox.exe
21:49:34 INFO - Using _rmtree_windows ...
21:49:34 INFO - Using _rmtree_windows ...
21:49:34 INFO - Running post-action listener: _resource_record_post_action
21:49:34 INFO - [mozharness: 2016-11-10 05:49:34.350000Z] Finished install step (success)
21:49:34 INFO - [mozharness: 2016-11-10 05:49:34.350000Z] Running run-tests step.
21:49:34 INFO - Running pre-action listener: _resource_record_pre_action
21:49:34 INFO - Running main action method: run_tests
21:49:34 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version']
21:49:34 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version
21:49:34 INFO - Python 2.7.3
21:49:34 INFO - Return code: 0
21:49:34 INFO - grabbing minidump binary from tooltool
21:49: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')]}
21:49:34 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 0x023C6E90>, '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 0x01DBA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028B3520>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1
ProcessManager NOT managing child processes
21:49:34 INFO - Running command: ['c:/mozilla-build/python27/python.exe', 'C:/mozilla-build/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', 'c:\\builds\\relengapi.tok', 'fetch', '-m', 'C:\\slave\\test\\build\\tests\\config/tooltool-manifests/win32/releng.manifest', '-o'] in C:\slave\test\build
21:49:34 INFO - Copy/paste: c:/mozilla-build/python27/python.exe C:/mozilla-build/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file c:\builds\relengapi.tok fetch -m C:\slave\test\build\tests\config/tooltool-manifests/win32/releng.manifest -o
21:49:34 INFO - Calling ['c:/mozilla-build/python27/python.exe', 'C:/mozilla-build/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', 'c:\\builds\\relengapi.tok', 'fetch', '-m', 'C:\\slave\\test\\build\\tests\\config/tooltool-manifests/win32/releng.manifest', '-o'] with output_timeout 600
ProcessManager UNABLE to use job objects to manage child processes
21:49:34 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'...
21:49:35 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmpfjdstk
21:49:35 INFO - INFO - File integrity verified, renaming tmpfjdstk to win32-minidump_stackwalk.exe
21:49:35 INFO - Return code: 0
21:49:35 INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755
21:49:35 INFO - mkdir: C:\slave\test\build\blobber_upload_dir
21:49:35 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir
21:49:35 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe
21:49:35 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir
21:49:35 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ipf0qm3aQ568RcmsulYOZQ/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-163', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs_errorsummary.log', '--log-raw=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs_raw.log'] in C:\slave\test\build
21:49:35 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\tests\talos\talos\run_tests.py --branchName Autoland --suite dromaeojs --executablePath C:\slave\test\build\application\firefox\firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ipf0qm3aQ568RcmsulYOZQ/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip --title T-W864-IX-163 --webServer localhost --log-tbpl-level=debug --log-errorsummary=C:\slave\test\build\blobber_upload_dir\dromaeojs_errorsummary.log --log-raw=C:\slave\test\build\blobber_upload_dir\dromaeojs_raw.log
21:49:35 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
21:49:35 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-163\\AppData\\Roaming',
21:49:35 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
21:49:35 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
21:49:35 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
21:49:35 INFO - 'COMPUTERNAME': 'T-W864-IX-163',
21:49:35 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
21:49:35 INFO - 'DCLOCATION': 'SCL3',
21:49:35 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
21:49:35 INFO - 'FP_NO_HOST_CHECK': 'NO',
21:49:35 INFO - 'HOMEDRIVE': 'C:',
21:49:35 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-163',
21:49:35 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
21:49:35 INFO - 'KTS_VERSION': '1.19c',
21:49:35 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-163\\AppData\\Local',
21:49:35 INFO - 'LOGONSERVER': '\\\\T-W864-IX-163',
21:49:35 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir',
21:49:35 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe',
21:49:35 INFO - 'MONDIR': 'C:\\Monitor_config\\',
21:49:35 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
21:49:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:49:35 INFO - 'MOZ_NO_REMOTE': '1',
21:49:35 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir',
21:49:35 INFO - 'NO_EM_RESTART': '1',
21:49:35 INFO - 'NUMBER_OF_PROCESSORS': '8',
21:49:35 INFO - 'OS': 'Windows_NT',
21:49:35 INFO - 'OURDRIVE': 'C:',
21:49:35 INFO - 'PATH': 'C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
21:49:35 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
21:49:35 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
21:49:35 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
21:49:35 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
21:49:35 INFO - 'PROCESSOR_LEVEL': '6',
21:49:35 INFO - 'PROCESSOR_REVISION': '1e05',
21:49:35 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
21:49:35 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
21:49:35 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
21:49:35 INFO - 'PROGRAMW6432': 'C:\\Program Files',
21:49:35 INFO - 'PROMPT': '$P$G',
21:49:35 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
21:49:35 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
21:49:35 INFO - 'PUBLIC': 'C:\\Users\\Public',
21:49:35 INFO - 'PWD': 'C:\\slave\\test',
21:49:35 INFO - 'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos',
21:49:35 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
21:49:35 INFO - 'SLAVEDIR': 'C:\\slave\\',
21:49:35 INFO - 'SYSTEMDRIVE': 'C:',
21:49:35 INFO - 'SYSTEMROOT': 'C:\\windows',
21:49:35 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
21:49:35 INFO - 'TEST1': 'testie',
21:49:35 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
21:49:35 INFO - 'USERDOMAIN': 'T-W864-IX-163',
21:49:35 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-163',
21:49:35 INFO - 'USERNAME': 'cltbld',
21:49:35 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-163',
21:49:35 INFO - 'WINDIR': 'C:\\windows',
21:49:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
21:49:35 INFO - Calling ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ipf0qm3aQ568RcmsulYOZQ/artifacts/public/build/firefox-52.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-163', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs_errorsummary.log', '--log-raw=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs_raw.log'] with output_timeout 3600
ProcessManager NOT managing child processes
ProcessManager UNABLE to use job objects to manage child processes
21:49:36 INFO - mozversion application_buildid: 20161109183932
21:49:36 INFO - mozversion application_changeset: 8ffd0e45ac580a8d0a85d603e5395297b5f2d9d3
21:49:36 INFO - mozversion application_display_name: Nightly
21:49:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384}
21:49:36 INFO - mozversion application_name: Firefox
21:49:36 INFO - mozversion application_remotingname: firefox
21:49:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland
21:49:36 INFO - mozversion application_vendor: Mozilla
21:49:36 INFO - mozversion application_version: 52.0a1
21:49:36 INFO - mozversion platform_buildid: 20161109183932
21:49:36 INFO - mozversion platform_changeset: 8ffd0e45ac580a8d0a85d603e5395297b5f2d9d3
21:49:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland
21:49:36 INFO - mozversion platform_version: 52.0a1
21:49:36 INFO - using testdate: 1478756976
21:49:36 INFO - actual date: 1478756976
21:49:36 INFO - starting webserver on 'localhost:49266'
21:49:36 INFO - SUITE-START | Running 2 tests
21:49:36 INFO - TEST-START | dromaeo_css
21:49:36 INFO - operating with platform_type : w8_
21:49:36 INFO - Initialising browser for dromaeo_css test...
21:49:36 INFO - TEST-INFO | started process 3808 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpygeecu\profile http://localhost:49266/getInfo.html)
21:49:44 INFO - PROCESS | 3808 | __metrics Screen width/height:1600/1200
21:49:44 INFO - PROCESS | 3808 | colorDepth:24
21:49:44 INFO - PROCESS | 3808 | Browser inner width/height: 1010/674
21:49:44 INFO - PROCESS | 3808 | __metrics
21:49:45 INFO - PROCESS | 3808 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows"
21:49:45 INFO - PROCESS | 3808 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver]
21:49:47 INFO - TEST-INFO | 3808: exit 0
21:49:47 INFO - Browser initialized.
21:49:47 INFO - Running cycle 1/1 for dromaeo_css test...
21:49:47 INFO - TEST-INFO | started process 2160 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpygeecu\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1)
21:49:48 INFO - PROCESS | 2160 | [GFX1-]: Invalid size in UpdateRenderTarget Size(124,0), 0
21:49:58 INFO - PROCESS | 2160 | RSS: Main: 157806592
21:49:58 INFO - PROCESS | 2160 |
21:50:49 INFO - PROCESS | 2160 | 1478757049708 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no]
21:53:00 INFO - PROCESS | 2160 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html)
21:53:03 INFO - PROCESS | 2160 | RSS: Main: 345481216
21:53:03 INFO - PROCESS | 2160 |
21:56:06 INFO - PROCESS | 2160 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html)
21:56:06 INFO - PROCESS | 2160 | RSS: Main: 226856960
21:56:06 INFO - PROCESS | 2160 |
21:59:09 INFO - PROCESS | 2160 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html)
21:59:09 INFO - PROCESS | 2160 | RSS: Main: 178348032
21:59:09 INFO - PROCESS | 2160 |
22:02:12 INFO - PROCESS | 2160 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html)
22:02:12 INFO - PROCESS | 2160 | RSS: Main: 179642368
22:02:12 INFO - PROCESS | 2160 |
22:05:15 INFO - PROCESS | 2160 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html)
22:05:16 INFO - PROCESS | 2160 | RSS: Main: 166842368
22:05:16 INFO - PROCESS | 2160 |
22:08:19 INFO - PROCESS | 2160 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html)
22:08:19 INFO - PROCESS | 2160 | RSS: Main: 221290496
22:08:19 INFO - PROCESS | 2160 |
22:08:19 INFO - PROCESS | 2160 | __start_tp_report
22:08:19 INFO - PROCESS | 2160 | _x_x_mozilla_page_load
22:08:19 INFO - PROCESS | 2160 | _x_x_mozilla_page_load_details
22:08:19 INFO - PROCESS | 2160 | |i|pagename|runs|
22:08:19 INFO - PROCESS | 2160 | |0;dojo.html;2827;2853.44357850219;2862.828230306182;2871.9712802871977;2880.092770777206;4979.128652485819;5046.596272298217;5053.140966035774;5089.7455127243675;5104.412992505859;5092.032513822372;5151.330327057477;5198.064348417283;5243.161094224924;5307.150855863053;4633.559811817872;4645.790939407735;4653.860384188463;4664.55686709762;4719.10337035962;4691.038337140878;4695.8356457524;4696.084263568606;4721.9055618887605;4722.598579120779;4528.818847246106;4590.449146102455;4592.908141837162;4705.623550115983;4714.363560919283;4651.37206477128;4682.040181762731;4717.386739723848;4747.643926705511;4803.087413391444;4511.120331535352;4543.159515489612;4682.227432473638;4719.056188762262;4725.078609671115;4897.681650692693;5065.949340506585;5069.822556210552;5102.336696229503;5106.897862042739;5478.068728316196;5490.6431081979945;5499.560035197174;5510.6969116698565;5558.9715902558155;5535.391106978229;5538.553111281954;5542.944570554283;5549.861253468655;5553.16702494625;5001.649884508086;5053.469385714484;5062.493750624982;5130.050940576006;5132.769025393866;5698.401667824819;5702.600817942704;5711.314642242957;5713.5714821388565;5752.108423194411;5443.292371991616;5452.509274165344;5454.7272636368025;5458.317710286215;5459.454054594588;5433.538149257279;5471.398146203915;5546.363357144993;5600.355959064678;5655.0386434306265;5604.439556044363;5665.80169694067;5679.460451257124;5701.857453563611;5711.257536520309;5657.858553536194;5667.801626943037;5668.57485688575;5669.829905102853;5678.233438485751;3613.9277214455565;3654.4335627977707;3714.7399682022537;3719.386301260316;3753.0242137044565;3309.8841540545964;3315.1380641033506;3315.270640459095;3348.7153591944957;3388.15296175956;5440.129579267298;5441.238226648273;5444.156155795858;5455.1544510600925;5482.780688772485;5692.857678558069;5718.771249150071;5718.914216286759;5719.19931209631;5722.2561067061015;5211.348581427322;5212.296339994128;5244.895102097937;5260.0531904257605;5472.370677372073;4588.036512332381;4595.035042641083;4602.355670206174;4634.629229661619;4641.118187544355;5505.587080968943;5663.093904975184;5666.600239139067;5695.60130790849;5767.106098554815;5391.029614669397;5403.756830942539;5437.646552974044;5550.4449555044175;5564.777408903598;5551.167324901297;5562.888742225214;5612.775488980558;5624.578156638187;5630.915536267041;5380.946190538045;5391.05656510117;5392.110301800316;5402.486763757437;5404.32445944257;5491.450854914637;5503.9174412383045;5512.145617429305;5514.255575497417;5514.944850551443;5280.709560974184;5326.600504962066;5327.786888524415;5335.1730481775385;5344.518993290467;5425.321834770653;5425.484578964992;5437.918431223614;5439.4288599696465;5439.728013599383;5344.78620855177;5345.518903298722;5370.650907690988;5370.919436208538;5386.245925570345;5401.756920938488;5469.425710300361;5523.502884740393;5534.889302213853;5539.639923404966;5414.348623669661;5475;5475.041867673221;5486.423925487926;5532.1701744737
22:08:19 INFO - PROCESS | 2160 | |1;ext.html;550.966941983481;555.0037682360163;560.6944215402602;568.4571234471081;570.2415787003287;35914.820425897866;36446.45330320048;37167.62832371675;37370.252594948084;40168;37498.62501374992;37923.43114853273;38158.61841381586;38172.61827381725;38229.61770382295;7150.356467917886;7319.707211711525;8145.0633177184645;8291.95854020729;9779.413235205875;9838.262130340217;9870.21038316933;9900.20798336135;9927.503624818766;9973.950130249375;9997.400155990628;10037.799244015116;10068.345557538772;10081.798364032715;10086.798264034715;7394.482386232966;7562.432817538706;9676.080772326617;9926.25553083518;9968.60125594979;9554.092361225672;9760.4631745254;9883.604655813831;9884.061014203711;9886.901130988743;35885.46171807425;36050;36216.45675314873;36216.81891590552;36218.27563448743;3091.4435401627925;3128.2492201871614;3138.1056398926426;3182.6499085100622;3563.5901871284873;27124.728752712417;27253.182404527895;27831.16506504808;28090.157295281173;28975;4015.3575427931682;4053.8114803143244;4055.4119652650497;4065.5324637666454;4206.369044643328;273320;274862;274918;275437.62281188666;276492;49582;49836.25245621319;49911.75044124829;49926.50073499219;49973;31624.367512649616;32693;32821.67178328234;32834;52530.474695253324;14324.283785810876;14456.566303010926;14487.92756036213;14495;14555.981081324417;10501.89498105009;10697.304675196086;10704.732381690364;10719;10981.780364392667;15587.376504939903;16072.839271607369;16091.839081609269;16401.83598164027;16502.504924852034;6221.813345599639;6284.654344011124;6316.336784637639;6335.778247761306;6336.524760642878;784.8234147316922;852.9445586036887;859.9742007739778;872.5768002518773;891.2914233184633;26852.74924080882;26915.596266056025;27180.72819271782;27328.726712733016;27372;919.8114386550741;966.8549717542285;994.5077186792583;1004.969850904474;1048.4600430778155;13857.168569885838;14334.49829255971;14509.637259068397;14553.490627828187;14588.124712517283;421310;423339;428304;428504;428963;47358.5264147361;47700.761496192295;47751.76124119357;47761.28358074632;47781.76109119502;1064.6965614799744;1076.4079756134095;1132.1904838041005;1160.4197901049474;1168.9064874810165;26792.732072679024;27693.58459623067;27756.722432776223;28052.29869253285;28082;41686.540971065864;42083;42134.15731685411;42305.365419519345;42305.78847105745;306647;306838;311807;312514;459794;34682.47976280307;34973.300533988666;35093.649063510056;35306.64693353033;35378.82310588431;38310.80844595759;38517.80741096276;38541.80729096336;38840.805795971966;39260.11098335272;33651.3269734599;33841;33997.49003764995;34472;34494;33626.32747345088;33707.966103386825;33740.325193495504;34232.14419639529;34532.482012769324;32167.51748723818;32379.51430728494;32622.184445389055;32624;32714.672853271164;29998.600111991425;30376.392472150874;30580;30598.694013059583;30648.693513064583;22712.165520545506;23430.76569234354;23629.64555531634;23722.406939826644;23729.28812135639
22:08:19 INFO - PROCESS | 2160 | |2;jquery.html;324.4241471388287;341.28500790843174;347.7478827849809;349.2578271173756;365.5083912138175;13068.542601008954;14039.087459315137;16067.598310042255;16744;17173;15987.200639967985;16478.258478368472;16680.49958501247;16728.41450549228;16835.57911052224;4600.033992861503;5227.921581176295;5400.864978375533;5472.069748142825;5479.589030822684;3807.8667246646373;3967.801609919507;5185.24813901984;5327.680339179642;5644.689542075184;5805.680687562203;5857.853553661172;5929.584929054968;5938.762449502036;5943.851403714899;5715.542756579484;5922.407759224065;5927.318358388798;5966.105084237356;5973.551983601247;5221.530062294411;5226.477352264781;5227.66020208689;5228.503292187236;5244.816431424882;19870.60258794816;20103.698444523343;20345.694814577793;20461.283855065;20487.180512779472;2047.488127968008;2192.2984644913636;2259.367377134405;2334.4163959010248;2715.4840580289683;8424.705135320295;8478.448900821488;9054.411463254868;9102.590383432762;12686.492540298377;1805.6840052990674;1855.3969959762996;1874.4751469588537;1876.0713446843763;1883.0961138653522;65922;68070.65964670145;68466;76504;77773.61113194398;8852.690155844515;9033.36766426357;9257.583408746623;9294.628214871465;9752.658656947115;12872.485100596059;12928.547500837614;12935.611931642066;12951;12991.051342298731;7107.182673992454;7297.598632075287;7298.635068246673;7407.59258240802;7408.777736667908;6599.7360105595235;6740.797776066725;6822.897656535156;6872.450203983669;7202.96398518004;3991.201759648082;4002.9599704002585;4004.6796256299426;4059.6752259819145;4138.937915931264;1614.152569900788;1702.838230368113;1713.143428285857;1744.6946784312695;1747.571844898008;790.7469609724948;799.6041959230103;815.2581151152423;820.9220124088203;835.9122292159236;16007.359705611878;16434.589135271475;16690.83309166917;16769.24538395775;16795.2442140104;829.5354601423222;845.0619812008665;869.3827382558328;893.620211410148;917.4586993673764;8987.910120898707;9393.812123757487;9432.103950124727;9461.952690236505;9516.953854921087;384187;384623;386896;397375;397990;79810;81160.59419702864;82589.17410825935;83036.58481707674;83669.58165209257;881.8456770065213;893.4549924546021;899.487292243415;918.0498184379269;921.4563407589554;14654.340554675278;14699.338529765972;14701.55895323142;14816.555503334486;15178.848211518185;33473.30953737919;34253.65746342505;34280.31439371149;34562.82718586492;35057.82471087628;42687.93571549337;47079.293810593554;47415.25847415231;47922.281165783235;48518.272225917346;7092.326229008236;7127.964360178166;7216.242294558996;7315.963420182865;7449.404047676281;9881.407115573089;11348.319100853645;11524.59663911759;11617.244879082833;11649.767004660029;9661.323707340418;9704.078112579293;9923.851142233018;10161.593536258466;10313.896861031593;8919.866202006846;9849.753756156153;10142.239332050274;10158.898411015794;10368.896311036793;10400;10451.16390688728;10500.684979450629;10516.263861529926;10635.8936410638;7257.346838784323;7317.524360916524;7358.411327093927;7492.70029198826;7569.659365328684;8854.955725221333;9627.5667594957;10002.399856008662;10096.495175241062;10507.31702439339
22:08:19 INFO - PROCESS | 2160 | |3;mootools.html;1187.0325684567076;1190.5237904838064;1256.2274201366158;1458.0741229319378;1488.0476495043167;6917.930820691791;7326;7328.743493977712;7330.157031941329;7335.816604584888;6569.507286953473;6762.695678694458;6963.338482844122;7140.821479463016;7168.641567921609;1979.1984246380239;2012.406340129658;2012.9698054529194;2016.3969644132876;2018.414659748671;1974.8123928226796;1975.8814471131707;1987.4137129546746;2021.3228568429595;2031.7460317460318;1707.6243226490153;1772.1139430284857;1898.7626546681665;1929.8649094563386;1961.9215231390726;1946.5231018400511;1949.1716020691292;1955.7261983322346;1956.9412917612494;1958.7453631027875;1908.1318000309825;1912.4645099372199;1961.5096225943514;1965.027311480812;1966.360932696865;7130.572165670076;7237.3848222901115;7417.443691723142;7446.85106297871;7451.627418629047;4392.38506609075;4433.246348120827;4518.43519560055;4521.231390663595;4523.253663145577;2625.5274050670873;2788.525950588405;2832.702566230537;2889.58101075345;2892.985535072311;914.2046419614911;934.9813003739955;956.2254573795248;958.8849338079406;963.5760265483235;10087.04173103554;10134.89865101347;10139.44233067181;10159.59361625534;10176.745581360452;3670.6512881276235;3789.905252368658;3819.2170605025904;3843.6540711336115;3849.1531862990096;7509.774706758806;7817.179196184433;8205.79485512867;8251.092379838214;8251.257386835214;4327.069680018811;4391.3193455014525;4422.601965823092;4444.488883778342;4455.2648812946145;4195.035141917376;4195.035141917376;4195.265828480065;4195.349720793282;4195.349720793282;3326.567546218976;3364.7644664873224;3385.4244778387733;3388.8305584720665;3461.44616861301;1062.2033474893828;1073.559840465421;1080.0711388206137;1083.685731137977;1087.1791797193227;777.9260970207821;812.7033632724132;815.1155995744565;816.2368185746227;816.5917041479261;4705.7176569405265;4769.809207631725;4775.068861572029;4906.288588154769;4941.50584941503;788.3732432716005;818.6504731420741;859.4971941414343;901.5041727050096;912.8995810460844;3088.81467111974;3168.6254139341527;3290.128116049249;3302.6532214117174;3355.6308806031316;8925.285977121945;8983.191512763882;9156.908430915606;9171.862422063674;9317.487538185329;8971.865422018675;9015.233705135006;9027.09729027092;9056.50189239585;9090.090990900857;6653.63405012729;6804.353586409283;6815.318468153145;6816.693248803716;6835.760748373883;4558.407407037064;4697.0840686065885;4750.527336525688;4853.757312134449;4941.209406494943;8073.717419890276;8379.371547133867;8404.831903362021;8425.157484251771;8445;8383.245507904317;8402;8465.95767021161;8553.61508732121;8610.397272191138;6596.868062638624;6723.630200339028;6729.629870357177;6745.392914637706;6754.155730533684;6927.3419025192525;6961.89557156633;6982.1272340957385;6984.615846128511;6994.755183568755;6244.250689917239;6295.496360291258;6333.334999825136;6385;6450.935490645221;6227.906581401373;6246.125542424155;6279.2464904209955;6312.842178945563;6359.077933699495;5689.2319536862;5766.798162064308;5782.161586570008;5815.651060936358;5816.389279125631;3935.7835319057726;4027.859024934113;4050.7772072535113;4109.3425051991535;4156.8129434174925;4247.957520424756;4270.145970805789;4275.700700950903;4291.077418355068;4425.181341451842
22:08:19 INFO - PROCESS | 2160 | |4;prototype.html;263.8812534359538;265.352539802881;267.59058640280364;269.16961174775827;270.99458010839794;5096.4648711885275;5160.79356825727;5172.741362931848;5201.479852014797;5225.216217567362;5032.144535428976;5036.622253331006;5061.620378471611;5071.366079240095;5082.517160869721;3644.7061293240918;3738.495303134083;3739.0278527582886;3749.512563366772;3812.561555421127;3675.5665290536713;3769.641884021027;3773.6981041516615;3787.450819631166;3837.158164081243;3785.9053523661855;3792.6965842732516;3798.4360556624306;3798.582155962842;3800.258949504848;3569.214772749991;3784.829682664273;3789.5263092113487;3791.938257287964;3811.656950874407;3178.713915747594;3185.665505121975;3191.4095892259775;3214.8231847248394;3246.3020450603235;4915;4929.876753081166;4934.111859865223;4942.406911170647;4970.15507363749;4334.219840428722;4361.890952726176;4369.12617476506;4371.409859668967;4379.75911324877;5056.519630635084;5300.92048619271;5329.7601607927345;5364;5370.516653501204;3541.7603838656523;3560.8219589020446;3568.7858728476376;3600.261946301002;3602.0814692253307;5612.522935550483;5633.281849036042;5653.830385088454;5655.293088363955;5665.5467562594895;3625.619309972415;3695.2447587395773;3702.370596998463;3716.7398282119993;3725.273571653556;3746.83139258734;3763.9435408468894;3765.9058523537133;3769.4157405602177;3772;4354.345348767448;4408;4419.292913133948;4428.31361139024;4430.62339701129;5320.148776195868;5362.597805164551;5371.26696945619;5383.327084114486;5386.165144402624;1199.3163896578867;1208.4441157067672;1211.1824518450012;1216.382211658492;1218.4029825385674;799.7044787444378;817.65249768848;828.5774255129927;830.2361827119065;830.4602008694397;5057.6459647824295;5086.92369614456;5210.270562121306;5211.530962213343;5216.295800066942;5439.347278326626;5447.863803404946;5481.945180548223;5596.418292292936;5609.6353737007785;5114.820981265638;5259.658122222043;5281.8643991542;5282.966058067672;5285;2813.7045610210635;2818.8724510196084;2833.6056032652377;2856.5429531275313;2857.7999540032415;5403.839043936147;5417.702026388508;5433.728313584384;5485.6982865942755;5496.477834605706;5216.686998780086;5310.495502927216;5375.650582712111;5381.919271210935;5437;5370.2750128732905;5391.867707781332;5447.400785913546;5451.754671039813;5482.64246374063;5231.3199284092825;5294.391145018372;5318.941608575007;5344.946550534445;5355.812546560852;4898.853034408973;5214.809779892378;5248.2390053442805;5253.632245742761;5254.290670759398;5433.500589728611;5476.452354764491;5476.808311709071;5480.451954804487;5481.2874326338915;3521.5069890214877;3538.310029544214;3568.4290513517712;3575.5530558680166;3591;5044.293798868088;5344.759485823225;5381.973090134681;5457.707762739738;5512.779488820563;5195.584353251656;5209.140491818807;5211.374635043819;5219.765110569958;5248.60635452335;5190.662606930538;5196.038732834438;5206.505381988705;5216.9739151304;5241.659292145999;4860.274602516056;5073.923891141562;5102.285680004877;5123.795048198031;5159.948400515947;5149.2276158576515;5181.238378951175;5191.844244672666;5301.204819277139;5332.920006199833;4886.92669609949;5248.134057880559;5256.763445644879;5271.235670827785;5281.524662780368
22:08:19 INFO - PROCESS | 2160 | |5;yui.html;614.7356636646243;665.1486097794824;723.6598798564676;727.2727272727273;729.6060127531132;12763.808542871853;12963.351832408365;12977.221366718004;13108.868911310885;13950.441982320708;12104.213226140295;12131.818022729643;12161.27032378058;12161.45273462694;12270.386480675952;552.259971638005;565.6747370262095;570.2928368822671;652.9314421985682;663.8738639658474;565.7850016993536;567.4609121334728;645.325634711725;666.2438132719374;667.109408939067;697.7522979342336;700.0793955947937;701.3092104277283;701.7929710735345;702.0311969482133;692.7921623512951;694.6457306773532;697.1390332938817;697.3444961735952;697.3967518096861;425.93823895534973;432.7208950227086;489.61320556760114;495.57380652638705;513.6507175120917;11959.402029898558;12367.62897113088;12368.81446778299;12378.566750163702;12382.938085309606;11302.943485282522;11450.828237576443;11499.827502587468;11519.30884146954;11960.923516883435;11025.173112016631;11093.223474356799;11144;11448.71378215543;11629.651110466615;3971.7616942983514;3988.3419235826054;4077.225327187825;4132.235536425771;4183.560726123774;55327.17009244864;55401.445985540035;55693.443065569234;58725;60115.398846011856;9784.608615655294;9832.394415479903;9886.456244906456;9896.802063958825;10042.849357259647;16177.838221617869;16241.83758162427;16262.18689065542;17252.654946901243;17367.392141274995;7029.613371264527;7040.331168538981;7070.681819318143;7145.464090193256;7153.606551639606;3800.3919372900205;3913.25648126855;3936.2717897189114;3954.7429417087797;3995.980020099939;2387.570237357292;2457.471643596635;2458.213371721032;2458.840175388594;2459.963100553493;459.8689373528528;464.9721016739006;467.89238475150904;474.5823675165901;475.9286107083965;594.5867622002753;603.7403916315939;611.7583554495949;614.7325913227671;631.7757196195377;7595.886061709079;7872.842543149105;7941.483803552751;8072.757817265491;8205.384596155312;580.1848402993801;608.67131748856;623.432676264597;628.4344090318658;637.174858558159;3799.5820459749407;3854.5952674969285;3901.9174851866705;3916.118873253552;4122.628963393309;67852.3214767846;68939;69087.3091269091;70903.64548177329;71568;52259.21611175835;57326.42673573211;60867;61288.38711612916;62187.6890615544;54356.45643543514;54483;54771.726141369836;55095.449045509835;55234.447655522934;7488.068897774549;7529.774106776806;7707.961460192663;7883.960580197062;8019.7193098243615;37296.44055339226;37820.43269351017;38233.23533529369;38433.615663843004;39116;47753.761231193625;50728.746356267984;51055.48944510656;51067.74466127794;52209.47790522046;9750.268729845147;9813.460259685786;9881.357711749;10150.898491014996;10585.682429527127;10814.188935829687;10881.564737410416;10920.890791091988;10947.34315941046;11203.71990700239;10001.099901008944;10085.747856303651;10134.645287414905;10137.64518241858;10398.948005259925;9486.85769713441;9609.471479068718;9637.855432168382;9738.853917191105;9928.51072339155;9431.245500359817;9588.089131532493;9642.662506812228;9818.263630227904;9824.852627210455;7685.577293248925;9091.727248182566;9218.861717074384;9245.399049061789;9692.660756873476;7517.361024312994;8100.35197184212;8166.387520935835;8454.957725211334;8575.828483430172
22:08:19 INFO - PROCESS | 2160 | __end_tp_report
22:08:19 INFO - PROCESS | 2160 | __start_cc_report
22:08:19 INFO - PROCESS | 2160 | _x_x_mozilla_cycle_collect,2187
22:08:19 INFO - PROCESS | 2160 | __end_cc_report
22:08:19 INFO - PROCESS | 2160 | __startTimestamp1478758099401__endTimestamp
22:08:19 INFO - PROCESS | 2160 |
22:08:19 INFO - PROCESS | 2160 | ------- Summary: start -------
22:08:19 INFO - PROCESS | 2160 | Number of tests: 6
22:08:19 INFO - PROCESS | 2160 |
22:08:19 INFO - PROCESS | 2160 | [#0] dojo.html Cycles:165 Average:5105.92 Median:5392.11 stddev:678.52 (12.6%) stddev-sans-first:656.63
22:08:19 INFO - PROCESS | 2160 | Values: 2827.0 2853.4 2862.8 2872.0 2880.1 4979.1 5046.6 5053.1 5089.7 5104.4 5092.0 5151.3 5198.1 5243.2 5307.2 4633.6 4645.8 4653.9 4664.6 4719.1 4691.0 4695.8 4696.1 4721.9 4722.6 4528.8 4590.4 4592.9 4705.6 4714.4 4651.4 4682.0 4717.4 4747.6 4803.1 4511.1 4543.2 4682.2 4719.1 4725.1 4897.7 5065.9 5069.8 5102.3 5106.9 5478.1 5490.6 5499.6 5510.7 5559.0 5535.4 5538.6 5542.9 5549.9 5553.2 5001.6 5053.5 5062.5 5130.1 5132.8 5698.4 5702.6 5711.3 5713.6 5752.1 5443.3 5452.5 5454.7 5458.3 5459.5 5433.5 5471.4 5546.4 5600.4 5655.0 5604.4 5665.8 5679.5 5701.9 5711.3 5657.9 5667.8 5668.6 5669.8 5678.2 3613.9 3654.4 3714.7 3719.4 3753.0 3309.9 3315.1 3315.3 3348.7 3388.2 5440.1 5441.2 5444.2 5455.2 5482.8 5692.9 5718.8 5718.9 5719.2 5722.3 5211.3 5212.3 5244.9 5260.1 5472.4 4588.0 4595.0 4602.4 4634.6 4641.1 5505.6 5663.1 5666.6 5695.6 5767.1 5391.0 5403.8 5437.6 5550.4 5564.8 5551.2 5562.9 5612.8 5624.6 5630.9 5380.9 5391.1 5392.1 5402.5 5404.3 5491.5 5503.9 5512.1 5514.3 5514.9 5280.7 5326.6 5327.8 5335.2 5344.5 5425.3 5425.5 5437.9 5439.4 5439.7 5344.8 5345.5 5370.7 5370.9 5386.2 5401.8 5469.4 5523.5 5534.9 5539.6 5414.3 5475.0 5475.0 5486.4 5532.2
22:08:19 INFO - PROCESS | 2160 |
22:08:19 INFO - PROCESS | 2160 | [#1] ext.html Cycles:180 Average:48853.97 Median:35200.15 stddev:93563.58 (265.8%) stddev-sans-first:93755.76
22:08:19 INFO - PROCESS | 2160 | Values: 551.0 555.0 560.7 568.5 570.2 35914.8 36446.5 37167.6 37370.3 40168.0 37498.6 37923.4 38158.6 38172.6 38229.6 7150.4 7319.7 8145.1 8292.0 9779.4 9838.3 9870.2 9900.2 9927.5 9974.0 9997.4 10037.8 10068.3 10081.8 10086.8 7394.5 7562.4 9676.1 9926.3 9968.6 9554.1 9760.5 9883.6 9884.1 9886.9 35885.5 36050.0 36216.5 36216.8 36218.3 3091.4 3128.2 3138.1 3182.6 3563.6 27124.7 27253.2 27831.2 28090.2 28975.0 4015.4 4053.8 4055.4 4065.5 4206.4 273320.0 274862.0 274918.0 275437.6 276492.0 49582.0 49836.3 49911.8 49926.5 49973.0 31624.4 32693.0 32821.7 32834.0 52530.5 14324.3 14456.6 14487.9 14495.0 14556.0 10501.9 10697.3 10704.7 10719.0 10981.8 15587.4 16072.8 16091.8 16401.8 16502.5 6221.8 6284.7 6316.3 6335.8 6336.5 784.8 852.9 860.0 872.6 891.3 26852.7 26915.6 27180.7 27328.7 27372.0 919.8 966.9 994.5 1005.0 1048.5 13857.2 14334.5 14509.6 14553.5 14588.1 421310.0 423339.0 428304.0 428504.0 428963.0 47358.5 47700.8 47751.8 47761.3 47781.8 1064.7 1076.4 1132.2 1160.4 1168.9 26792.7 27693.6 27756.7 28052.3 28082.0 41686.5 42083.0 42134.2 42305.4 42305.8 306647.0 306838.0 311807.0 312514.0 459794.0 34682.5 34973.3 35093.6 35306.6 35378.8 38310.8 38517.8 38541.8 38840.8 39260.1 33651.3 33841.0 33997.5 34472.0 34494.0 33626.3 33708.0 33740.3 34232.1 34532.5 32167.5 32379.5 32622.2 32624.0 32714.7 29998.6 30376.4 30580.0 30598.7 30648.7 22712.2 23430.8 23629.6 23722.4 23729.3
22:08:19 INFO - PROCESS | 2160 |
22:08:19 INFO - PROCESS | 2160 | [#2] jquery.html Cycles:180 Average:24148.85 Median:26851.76 stddev:64577.03 (240.5%) stddev-sans-first:64733.41
22:08:19 INFO - PROCESS | 2160 | Values: 324.4 341.3 347.7 349.3 365.5 13068.5 14039.1 16067.6 16744.0 17173.0 15987.2 16478.3 16680.5 16728.4 16835.6 4600.0 5227.9 5400.9 5472.1 5479.6 3807.9 3967.8 5185.2 5327.7 5644.7 5805.7 5857.9 5929.6 5938.8 5943.9 5715.5 5922.4 5927.3 5966.1 5973.6 5221.5 5226.5 5227.7 5228.5 5244.8 19870.6 20103.7 20345.7 20461.3 20487.2 2047.5 2192.3 2259.4 2334.4 2715.5 8424.7 8478.4 9054.4 9102.6 12686.5 1805.7 1855.4 1874.5 1876.1 1883.1 65922.0 68070.7 68466.0 76504.0 77773.6 8852.7 9033.4 9257.6 9294.6 9752.7 12872.5 12928.5 12935.6 12951.0 12991.1 7107.2 7297.6 7298.6 7407.6 7408.8 6599.7 6740.8 6822.9 6872.5 7203.0 3991.2 4003.0 4004.7 4059.7 4138.9 1614.2 1702.8 1713.1 1744.7 1747.6 790.7 799.6 815.3 820.9 835.9 16007.4 16434.6 16690.8 16769.2 16795.2 829.5 845.1 869.4 893.6 917.5 8987.9 9393.8 9432.1 9462.0 9517.0 384187.0 384623.0 386896.0 397375.0 397990.0 79810.0 81160.6 82589.2 83036.6 83669.6 881.8 893.5 899.5 918.0 921.5 14654.3 14699.3 14701.6 14816.6 15178.8 33473.3 34253.7 34280.3 34562.8 35057.8 42687.9 47079.3 47415.3 47922.3 48518.3 7092.3 7128.0 7216.2 7316.0 7449.4 9881.4 11348.3 11524.6 11617.2 11649.8 9661.3 9704.1 9923.9 10161.6 10313.9 8919.9 9849.8 10142.2 10158.9 10368.9 10400.0 10451.2 10500.7 10516.3 10635.9 7257.3 7317.5 7358.4 7492.7 7569.7 8855.0 9627.6 10002.4 10096.5 10507.3
22:08:19 INFO - PROCESS | 2160 |
22:08:19 INFO - PROCESS | 2160 | [#3] mootools.html Cycles:180 Average:4791.53 Median:4814.41 stddev:2696.52 (56.0%) stddev-sans-first:2690.47
22:08:19 INFO - PROCESS | 2160 | Values: 1187.0 1190.5 1256.2 1458.1 1488.0 6917.9 7326.0 7328.7 7330.2 7335.8 6569.5 6762.7 6963.3 7140.8 7168.6 1979.2 2012.4 2013.0 2016.4 2018.4 1974.8 1975.9 1987.4 2021.3 2031.7 1707.6 1772.1 1898.8 1929.9 1961.9 1946.5 1949.2 1955.7 1956.9 1958.7 1908.1 1912.5 1961.5 1965.0 1966.4 7130.6 7237.4 7417.4 7446.9 7451.6 4392.4 4433.2 4518.4 4521.2 4523.3 2625.5 2788.5 2832.7 2889.6 2893.0 914.2 935.0 956.2 958.9 963.6 10087.0 10134.9 10139.4 10159.6 10176.7 3670.7 3789.9 3819.2 3843.7 3849.2 7509.8 7817.2 8205.8 8251.1 8251.3 4327.1 4391.3 4422.6 4444.5 4455.3 4195.0 4195.0 4195.3 4195.3 4195.3 3326.6 3364.8 3385.4 3388.8 3461.4 1062.2 1073.6 1080.1 1083.7 1087.2 777.9 812.7 815.1 816.2 816.6 4705.7 4769.8 4775.1 4906.3 4941.5 788.4 818.7 859.5 901.5 912.9 3088.8 3168.6 3290.1 3302.7 3355.6 8925.3 8983.2 9156.9 9171.9 9317.5 8971.9 9015.2 9027.1 9056.5 9090.1 6653.6 6804.4 6815.3 6816.7 6835.8 4558.4 4697.1 4750.5 4853.8 4941.2 8073.7 8379.4 8404.8 8425.2 8445.0 8383.2 8402.0 8466.0 8553.6 8610.4 6596.9 6723.6 6729.6 6745.4 6754.2 6927.3 6961.9 6982.1 6984.6 6994.8 6244.3 6295.5 6333.3 6385.0 6450.9 6227.9 6246.1 6279.2 6312.8 6359.1 5689.2 5766.8 5782.2 5815.7 5816.4 3935.8 4027.9 4050.8 4109.3 4156.8 4248.0 4270.1 4275.7 4291.1 4425.2
22:08:19 INFO - PROCESS | 2160 |
22:08:19 INFO - PROCESS | 2160 | [#4] prototype.html Cycles:180 Average:4376.67 Median:5119.31 stddev:1344.18 (26.3%) stddev-sans-first:1312.03
22:08:19 INFO - PROCESS | 2160 | Values: 263.9 265.4 267.6 269.2 271.0 5096.5 5160.8 5172.7 5201.5 5225.2 5032.1 5036.6 5061.6 5071.4 5082.5 3644.7 3738.5 3739.0 3749.5 3812.6 3675.6 3769.6 3773.7 3787.5 3837.2 3785.9 3792.7 3798.4 3798.6 3800.3 3569.2 3784.8 3789.5 3791.9 3811.7 3178.7 3185.7 3191.4 3214.8 3246.3 4915.0 4929.9 4934.1 4942.4 4970.2 4334.2 4361.9 4369.1 4371.4 4379.8 5056.5 5300.9 5329.8 5364.0 5370.5 3541.8 3560.8 3568.8 3600.3 3602.1 5612.5 5633.3 5653.8 5655.3 5665.5 3625.6 3695.2 3702.4 3716.7 3725.3 3746.8 3763.9 3765.9 3769.4 3772.0 4354.3 4408.0 4419.3 4428.3 4430.6 5320.1 5362.6 5371.3 5383.3 5386.2 1199.3 1208.4 1211.2 1216.4 1218.4 799.7 817.7 828.6 830.2 830.5 5057.6 5086.9 5210.3 5211.5 5216.3 5439.3 5447.9 5481.9 5596.4 5609.6 5114.8 5259.7 5281.9 5283.0 5285.0 2813.7 2818.9 2833.6 2856.5 2857.8 5403.8 5417.7 5433.7 5485.7 5496.5 5216.7 5310.5 5375.7 5381.9 5437.0 5370.3 5391.9 5447.4 5451.8 5482.6 5231.3 5294.4 5318.9 5344.9 5355.8 4898.9 5214.8 5248.2 5253.6 5254.3 5433.5 5476.5 5476.8 5480.5 5481.3 3521.5 3538.3 3568.4 3575.6 3591.0 5044.3 5344.8 5382.0 5457.7 5512.8 5195.6 5209.1 5211.4 5219.8 5248.6 5190.7 5196.0 5206.5 5217.0 5241.7 4860.3 5073.9 5102.3 5123.8 5159.9 5149.2 5181.2 5191.8 5301.2 5332.9 4886.9 5248.1 5256.8 5271.2 5281.5
22:08:19 INFO - PROCESS | 2160 |
22:08:19 INFO - PROCESS | 2160 | [#5] yui.html Cycles:180 Average:14617.52 Median:55364.31 stddev:18988.00 (34.3%) stddev-sans-first:19012.15
22:08:19 INFO - PROCESS | 2160 | Values: 614.7 665.1 723.7 727.3 729.6 12763.8 12963.4 12977.2 13108.9 13950.4 12104.2 12131.8 12161.3 12161.5 12270.4 552.3 565.7 570.3 652.9 663.9 565.8 567.5 645.3 666.2 667.1 697.8 700.1 701.3 701.8 702.0 692.8 694.6 697.1 697.3 697.4 425.9 432.7 489.6 495.6 513.7 11959.4 12367.6 12368.8 12378.6 12382.9 11302.9 11450.8 11499.8 11519.3 11960.9 11025.2 11093.2 11144.0 11448.7 11629.7 3971.8 3988.3 4077.2 4132.2 4183.6 55327.2 55401.4 55693.4 58725.0 60115.4 9784.6 9832.4 9886.5 9896.8 10042.8 16177.8 16241.8 16262.2 17252.7 17367.4 7029.6 7040.3 7070.7 7145.5 7153.6 3800.4 3913.3 3936.3 3954.7 3996.0 2387.6 2457.5 2458.2 2458.8 2460.0 459.9 465.0 467.9 474.6 475.9 594.6 603.7 611.8 614.7 631.8 7595.9 7872.8 7941.5 8072.8 8205.4 580.2 608.7 623.4 628.4 637.2 3799.6 3854.6 3901.9 3916.1 4122.6 67852.3 68939.0 69087.3 70903.6 71568.0 52259.2 57326.4 60867.0 61288.4 62187.7 54356.5 54483.0 54771.7 55095.4 55234.4 7488.1 7529.8 7708.0 7884.0 8019.7 37296.4 37820.4 38233.2 38433.6 39116.0 47753.8 50728.7 51055.5 51067.7 52209.5 9750.3 9813.5 9881.4 10150.9 10585.7 10814.2 10881.6 10920.9 10947.3 11203.7 10001.1 10085.7 10134.6 10137.6 10398.9 9486.9 9609.5 9637.9 9738.9 9928.5 9431.2 9588.1 9642.7 9818.3 9824.9 7685.6 9091.7 9218.9 9245.4 9692.7 7517.4 8100.4 8166.4 8455.0 8575.8
22:08:19 INFO - PROCESS | 2160 | -------- Summary: end --------
22:08:19 INFO - PROCESS | 2160 |
22:08:20 INFO - TEST-INFO | 2160: exit 0
22:08:20 INFO - TEST-OK | dromaeo_css | took 1124263ms
22:08:20 INFO - TEST-START | kraken
22:08:20 INFO - operating with platform_type : w8_
22:08:20 INFO - Initialising browser for kraken test...
22:08:20 INFO - TEST-INFO | started process 1184 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmp9cjwnq\profile http://localhost:49266/getInfo.html)
22:08:25 INFO - PROCESS | 1184 | __metrics Screen width/height:1600/1200
22:08:25 INFO - PROCESS | 1184 | colorDepth:24
22:08:25 INFO - PROCESS | 1184 | Browser inner width/height: 1010/674
22:08:25 INFO - PROCESS | 1184 | __metrics
22:08:27 INFO - PROCESS | 1184 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows"
22:08:27 INFO - PROCESS | 1184 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver]
22:08:27 INFO - PROCESS | 1184 | console.error:
22:08:27 INFO - PROCESS | 1184 | Message: Error: Connection closed before committing the transaction.
22:08:27 INFO - PROCESS | 1184 | Stack:
22:08:27 INFO - PROCESS | 1184 | ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:932:23
22:08:27 INFO - PROCESS | 1184 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7
22:08:27 INFO - PROCESS | 1184 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11
22:08:27 INFO - PROCESS | 1184 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7
22:08:27 INFO - PROCESS | 1184 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7
22:08:27 INFO - PROCESS | 1184 | TaskImpl_run@resource://gre/modules/Task.jsm:324:15
22:08:27 INFO - PROCESS | 1184 | Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:551:9
22:08:27 INFO - PROCESS | 1184 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15
22:08:27 INFO - PROCESS | 1184 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:386:5
22:08:27 INFO - PROCESS | 1184 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29
22:08:27 INFO - PROCESS | 1184 | Barrier/this.client.addBlocker/promise13.4%
22:09:24 INFO - TinderboxPrint: I/O read bytes / time
236,937,216 / 2,255,810
22:09:24 INFO - TinderboxPrint: I/O write bytes / time
419,016,704 / 3,890,290
22:09:24 INFO - TinderboxPrint: CPU idle
8,265.5 (86.6%)
22:09:24 INFO - TinderboxPrint: CPU user
1,230.8 (12.9%)
22:09:24 INFO - install - Wall time: 4s; CPU: 8.0%; Read bytes: 28672; Write bytes: 58026496; Read time: 5420; Write time: 321590
22:09:24 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 236908544; Write bytes: 322844160; Read time: 2250390; Write time: 3521200
22:09:25 INFO - Running post-run listener: _upload_blobber_files
22:09:25 INFO - Blob upload gear active.
22:09:25 INFO - Preparing to upload files from C:\slave\test\build\blobber_upload_dir.
22:09:25 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
22:09:25 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\venv\\Scripts\\blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', 'C:\\slave\\test\\oauth.txt', '-b', 'Autoland', '-d', 'C:\\slave\\test\\build\\blobber_upload_dir', '--output-manifest', 'C:\\slave\\test\\build\\uploaded_files.json']
22:09:25 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\venv\Scripts\blobberc.py -u https://blobupload.elasticbeanstalk.com -a C:\slave\test\oauth.txt -b Autoland -d C:\slave\test\build\blobber_upload_dir --output-manifest C:\slave\test\build\uploaded_files.json
22:09:25 INFO - (blobuploader) - INFO - Open directory for files ...
22:09:25 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_errorsummary.log ...
22:09:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
22:09:25 INFO - (blobuploader) - INFO - Uploading, attempt #1.
22:09:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded
22:09:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
22:09:26 INFO - (blobuploader) - INFO - Done attempting.
22:09:26 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_raw.log ...
22:09:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
22:09:26 INFO - (blobuploader) - INFO - Uploading, attempt #1.
22:09:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded
22:09:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
22:09:27 INFO - (blobuploader) - INFO - Done attempting.
22:09:27 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\resource-usage.json ...
22:09:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
22:09:27 INFO - (blobuploader) - INFO - Uploading, attempt #1.
22:09:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded
22:09:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
22:09:30 INFO - (blobuploader) - INFO - Done attempting.
22:09:30 INFO - (blobuploader) - INFO - Iteration through files over.
22:09:30 INFO - Return code: 0
22:09:30 INFO - rmtree: C:\slave\test\build\uploaded_files.json
22:09:30 INFO - Using _rmtree_windows ...
22:09:30 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build\\uploaded_files.json',), kwargs: {}, attempt #1
22:09:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d535c6eb8cea2d2d925090046bf0cadea41003c724f0e40d4b41b1dfb4f4deab998906a992769825083663afb2584330ee202fe3da70529816693aba6f159100", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d2a11c1b81dc5ad386aea1b4a2b044b4771106633a2ca1f9f0c31a9565adf9896e7005c0ede0f354661a56be7f42969241b6fa14e57a37085e98ce25396e45ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9e8f8014dbf3c5c9ca2aef391d37bff8ab840f6ad6b0fc7c671f0bdb361473eddb0d32e0bbc704e81e7128b277abfc539e6eab23fcf64bec29a17edf5c51d69e"}
22:09:30 INFO - Writing buildbot properties ['blobber_files'] to C:\slave\test\properties\blobber_files
22:09:30 INFO - Writing to file C:\slave\test\properties\blobber_files
22:09:30 INFO - Contents:
22:09:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d535c6eb8cea2d2d925090046bf0cadea41003c724f0e40d4b41b1dfb4f4deab998906a992769825083663afb2584330ee202fe3da70529816693aba6f159100", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d2a11c1b81dc5ad386aea1b4a2b044b4771106633a2ca1f9f0c31a9565adf9896e7005c0ede0f354661a56be7f42969241b6fa14e57a37085e98ce25396e45ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9e8f8014dbf3c5c9ca2aef391d37bff8ab840f6ad6b0fc7c671f0bdb361473eddb0d32e0bbc704e81e7128b277abfc539e6eab23fcf64bec29a17edf5c51d69e"}
22:09:30 INFO - Running post-run listener: copy_logs_to_upload_dir
22:09:30 INFO - Copying logs to upload dir...
22:09:30 INFO - mkdir: C:\slave\test\build\upload\logs
22:09:30 INFO - Copying logs to upload dir...
22:09:30 INFO - Using _rmtree_windows ...
22:09:30 INFO - Using _rmtree_windows ...
22:09:30 INFO - Using _rmtree_windows ...
22:09:30 INFO - Using _rmtree_windows ...
22:09:30 INFO - Using _rmtree_windows ...
22:09:30 INFO - Using _rmtree_windows ...
22:09:30 INFO - Using _rmtree_windows ...
program finished with exit code 0
elapsedTime=1410.475000
========= master_lag: -0.23 =========
========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 30 secs) (at 2016-11-09 22:09:30.513500) =========
========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-09 22:09:30.514840) =========
'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-163\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-163
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-163
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-163\AppData\Local
LOGONSERVER=\\T-W864-IX-163
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:\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-163
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-163
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-163
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d535c6eb8cea2d2d925090046bf0cadea41003c724f0e40d4b41b1dfb4f4deab998906a992769825083663afb2584330ee202fe3da70529816693aba6f159100", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d2a11c1b81dc5ad386aea1b4a2b044b4771106633a2ca1f9f0c31a9565adf9896e7005c0ede0f354661a56be7f42969241b6fa14e57a37085e98ce25396e45ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9e8f8014dbf3c5c9ca2aef391d37bff8ab840f6ad6b0fc7c671f0bdb361473eddb0d32e0bbc704e81e7128b277abfc539e6eab23fcf64bec29a17edf5c51d69e"}
build_url:https://queue.taskcluster.net/v1/task/Ipf0qm3aQ568RcmsulYOZQ/artifacts/public/build/firefox-52.0a1.en-US.win64.zip
program finished with exit code 0
elapsedTime=0.101000
build_url: 'https://queue.taskcluster.net/v1/task/Ipf0qm3aQ568RcmsulYOZQ/artifacts/public/build/firefox-52.0a1.en-US.win64.zip'
blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d535c6eb8cea2d2d925090046bf0cadea41003c724f0e40d4b41b1dfb4f4deab998906a992769825083663afb2584330ee202fe3da70529816693aba6f159100", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d2a11c1b81dc5ad386aea1b4a2b044b4771106633a2ca1f9f0c31a9565adf9896e7005c0ede0f354661a56be7f42969241b6fa14e57a37085e98ce25396e45ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9e8f8014dbf3c5c9ca2aef391d37bff8ab840f6ad6b0fc7c671f0bdb361473eddb0d32e0bbc704e81e7128b277abfc539e6eab23fcf64bec29a17edf5c51d69e"}'
========= master_lag: 0.02 =========
========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-09 22:09:30.636056) =========
========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 22:09:30.636394) =========
'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-163\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-163
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-163
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-163\AppData\Local
LOGONSERVER=\\T-W864-IX-163
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:\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-163
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-163
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-163
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-11-09 22:09:30.754693) =========
========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-11-09 22:09:30.755028) =========
========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-11-09 22:09:31.349548) =========
========= Total master_lag: 1.46 =========