builder: fx-team_win7_ix_test-dromaeojs-pgo
slave: t-w732-ix-116
starttime: 1474495607.63
results: success (0)
buildid: 20160921123003
builduid: a98ead63674d48699898b1dcca3ac00f
revision: 6757959dbba2a80fa1f58ea4e677c65cb5cd9e15
========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-21 15:06:47.635109) =========
master: http://buildbot-master119.bb.releng.scl3.mozilla.com:8201/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-21 15:06:47.635562) =========
========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-21 15:06:47.635841) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-21 15:06:48.042414) =========
========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-21 15:06:48.042691) =========
'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\AppData\Roaming
COMMONPROGRAMFILES=C:\Program Files\Common Files
COMPUTERNAME=T-W732-IX-116
COMSPEC=C:\windows\system32\cmd.exe
CYGWINBASE=C:\cygwin
DCLOCATION=SCL3
DNSSUFFIX=wintest.releng.scl3.mozilla.com
FP_NO_HOST_CHECK=NO
HOMEDRIVE=C:
HOMEPATH=\Users\cltbld
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld\AppData\Local
LOGONSERVER=\\T-W732-IX-116
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:\Python24;C:\Python24\Scripts;C:\cygwin\bin;C:\WINDOWS\System32;C:\program files\gnuwin32\bin;C:\WINDOWS;C:\mozilla-build\msys\bin;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\info-zip;C:\mozilla-build\wget;C:\Program Files (x86)\GnuWin32\bin;
PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
PROCESSOR_ARCHITECTURE=x86
PROCESSOR_IDENTIFIER=x86 Family 6 Model 30 Stepping 5, GenuineIntel
PROCESSOR_LEVEL=6
PROCESSOR_REVISION=1e05
PROGRAMDATA=C:\ProgramData
PROGRAMFILES=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\AppData\Local\Temp
TEST1=testie
TMP=C:\Users\cltbld\AppData\Local\Temp
USERDOMAIN=T-W732-IX-116
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld
WINDIR=C:\windows
WINDOWS_TRACING_FLAGS=3
WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log
XPCOM_DEBUG_BREAK=warn
using PTY: False
--15:06:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py
=> `archiver_client.py'
Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102
Connecting to hg.mozilla.org|63.245.215.25|:443... connected.
HTTP request sent, awaiting response... 200 Script output follows
Length: 12,141 (12K) [text/x-python]
0K .......... . 100% 2.27 GB/s
15:06:49 (2.27 GB/s) - `archiver_client.py' saved [12141/12141]
program finished with exit code 0
elapsedTime=1.082000
========= master_lag: 0.84 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-21 15:06:49.967114) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 19 secs) (at 2016-09-21 15:06:49.967473) =========
'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\AppData\Roaming
COMMONPROGRAMFILES=C:\Program Files\Common Files
COMPUTERNAME=T-W732-IX-116
COMSPEC=C:\windows\system32\cmd.exe
CYGWINBASE=C:\cygwin
DCLOCATION=SCL3
DNSSUFFIX=wintest.releng.scl3.mozilla.com
FP_NO_HOST_CHECK=NO
HOMEDRIVE=C:
HOMEPATH=\Users\cltbld
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld\AppData\Local
LOGONSERVER=\\T-W732-IX-116
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:\Python24;C:\Python24\Scripts;C:\cygwin\bin;C:\WINDOWS\System32;C:\program files\gnuwin32\bin;C:\WINDOWS;C:\mozilla-build\msys\bin;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\info-zip;C:\mozilla-build\wget;C:\Program Files (x86)\GnuWin32\bin;
PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
PROCESSOR_ARCHITECTURE=x86
PROCESSOR_IDENTIFIER=x86 Family 6 Model 30 Stepping 5, GenuineIntel
PROCESSOR_LEVEL=6
PROCESSOR_REVISION=1e05
PROGRAMDATA=C:\ProgramData
PROGRAMFILES=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\AppData\Local\Temp
TEST1=testie
TMP=C:\Users\cltbld\AppData\Local\Temp
USERDOMAIN=T-W732-IX-116
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld
WINDIR=C:\windows
WINDOWS_TRACING_FLAGS=3
WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log
XPCOM_DEBUG_BREAK=warn
using PTY: False
program finished with exit code 0
elapsedTime=15.306000
========= master_lag: 4.51 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 19 secs) (at 2016-09-21 15:07:09.785171) =========
========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-21 15:07:09.785533) =========
'bash' '-c' u'python archiver_client.py mozharness --repo integration/fx-team --rev 6757959dbba2a80fa1f58ea4e677c65cb5cd9e15 --destination scripts --debug'
in dir C:\slave\test\. (timeout 1200 secs)
watching logfiles {}
argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 6757959dbba2a80fa1f58ea4e677c65cb5cd9e15 --destination scripts --debug']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld\AppData\Roaming
COMMONPROGRAMFILES=C:\Program Files\Common Files
COMPUTERNAME=T-W732-IX-116
COMSPEC=C:\windows\system32\cmd.exe
CYGWINBASE=C:\cygwin
DCLOCATION=SCL3
DNSSUFFIX=wintest.releng.scl3.mozilla.com
FP_NO_HOST_CHECK=NO
HOMEDRIVE=C:
HOMEPATH=\Users\cltbld
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld\AppData\Local
LOGONSERVER=\\T-W732-IX-116
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:\Python24;C:\Python24\Scripts;C:\cygwin\bin;C:\WINDOWS\System32;C:\program files\gnuwin32\bin;C:\WINDOWS;C:\mozilla-build\msys\bin;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\info-zip;C:\mozilla-build\wget;C:\Program Files (x86)\GnuWin32\bin;
PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
PROCESSOR_ARCHITECTURE=x86
PROCESSOR_IDENTIFIER=x86 Family 6 Model 30 Stepping 5, GenuineIntel
PROCESSOR_LEVEL=6
PROCESSOR_REVISION=1e05
PROGRAMDATA=C:\ProgramData
PROGRAMFILES=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\AppData\Local\Temp
TEST1=testie
TMP=C:\Users\cltbld\AppData\Local\Temp
USERDOMAIN=T-W732-IX-116
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld
WINDIR=C:\windows
WINDOWS_TRACING_FLAGS=3
WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log
XPCOM_DEBUG_BREAK=warn
using PTY: False
2016-09-21 15:07:10,140 truncating revision to first 12 chars
2016-09-21 15:07:10,140 Setting DEBUG logging.
2016-09-21 15:07:10,140 attempt 1/10
2016-09-21 15:07:10,140 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6757959dbba2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2016-09-21 15:07:10,627 unpacking tar archive at: fx-team-6757959dbba2/testing/mozharness/
2016-09-21 15:07:10,769 skipping symlink on windows: configs/single_locale/linux32.py
program finished with exit code 0
elapsedTime=1.298000
========= master_lag: 0.05 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-21 15:07:11.136799) =========
========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-21 15:07:11.137121) =========
script_repo_revision: 6757959dbba2a80fa1f58ea4e677c65cb5cd9e15
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-21 15:07:11.137511) =========
========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-21 15:07:11.137793) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-21 15:07:11.172610) =========
========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 24 mins, 12 secs) (at 2016-09-21 15:07:11.172888) =========
'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'dromaeojs' '--add-option' '--webServer,localhost' '--branch-name' 'Fx-Team' '--cfg' 'talos/windows_config.py' '--download-symbols' 'ondemand' '--use-talos-json' '--blob-upload-branch' 'Fx-Team'
in dir C:\slave\test\. (timeout 3600 secs) (maxTime 7200 secs)
watching logfiles {}
argv: ['c:/mozilla-build/python27/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/windows_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld\AppData\Roaming
COMMONPROGRAMFILES=C:\Program Files\Common Files
COMPUTERNAME=T-W732-IX-116
COMSPEC=C:\windows\system32\cmd.exe
CYGWINBASE=C:\cygwin
DCLOCATION=SCL3
DNSSUFFIX=wintest.releng.scl3.mozilla.com
FP_NO_HOST_CHECK=NO
HOMEDRIVE=C:
HOMEPATH=\Users\cltbld
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld\AppData\Local
LOGONSERVER=\\T-W732-IX-116
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:\Python24;C:\Python24\Scripts;C:\cygwin\bin;C:\WINDOWS\System32;C:\program files\gnuwin32\bin;C:\WINDOWS;C:\mozilla-build\msys\bin;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\info-zip;C:\mozilla-build\wget;C:\Program Files (x86)\GnuWin32\bin;
PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
PROCESSOR_ARCHITECTURE=x86
PROCESSOR_IDENTIFIER=x86 Family 6 Model 30 Stepping 5, GenuineIntel
PROCESSOR_LEVEL=6
PROCESSOR_REVISION=1e05
PROGRAMDATA=C:\ProgramData
PROGRAMFILES=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\AppData\Local\Temp
TEST1=testie
TMP=C:\Users\cltbld\AppData\Local\Temp
USERDOMAIN=T-W732-IX-116
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld
WINDIR=C:\windows
WINDOWS_TRACING_FLAGS=3
WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log
XPCOM_DEBUG_BREAK=warn
using PTY: False
15:07:11 INFO - MultiFileLogger online at 20160921 15:07:11 in C:\slave\test
15:07:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team
15:07:11 INFO - Dumping config to C:\slave\test\logs\localconfig.json.
15:07:11 INFO - {'append_to_log': False,
15:07:11 INFO - 'base_work_dir': 'C:\\slave\\test',
15:07:11 INFO - 'blob_upload_branch': 'Fx-Team',
15:07:11 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt',
15:07:11 INFO - 'branch': 'Fx-Team',
15:07:11 INFO - 'buildbot_json_path': 'buildprops.json',
15:07:11 INFO - 'config_files': ('talos/windows_config.py',),
15:07:11 INFO - 'default_actions': ('clobber',
15:07:11 INFO - 'read-buildbot-config',
15:07:11 INFO - 'download-and-extract',
15:07:11 INFO - 'populate-webroot',
15:07:11 INFO - 'create-virtualenv',
15:07:11 INFO - 'install',
15:07:11 INFO - 'run-tests'),
15:07:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',),
15:07:11 INFO - 'download_minidump_stackwalk': True,
15:07:11 INFO - 'download_symbols': 'ondemand',
15:07:11 INFO - 'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python',
15:07:11 INFO - 'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'),
15:07:11 INFO - 'hg': 'c:/mozilla-build/hg/hg',
15:07:11 INFO - 'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python',
15:07:11 INFO - 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'),
15:07:11 INFO - 'python': 'c:/mozilla-build/python27/python.exe',
15:07:11 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe',
15:07:11 INFO - 'C:/mozilla-build/tooltool.py'),
15:07:11 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe',
15:07:11 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')},
15:07:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub',
15:07:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'),
15:07:11 INFO - 'installer_path': 'installer.exe',
15:07:11 INFO - 'log_level': 'info',
15:07:11 INFO - 'log_name': 'talos',
15:07:11 INFO - 'log_to_console': True,
15:07:11 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe',
15:07:11 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe',
15:07:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest',
15:07:11 INFO - 'opt_config_files': (),
15:07:11 INFO - 'pip_index': False,
15:07:11 INFO - 'sps_profile': False,
15:07:11 INFO - 'sps_profile_interval': 0,
15:07:11 INFO - 'suite': 'dromaeojs',
15:07:11 INFO - 'system_bits': '32',
15:07:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'),
15:07:11 INFO - 'title': 'T-W732-IX-116',
15:07:11 INFO - 'use_talos_json': True,
15:07:11 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'),
15:07:11 INFO - 'virtualenv_path': 'C:\\slave\\test\\build/venv',
15:07:11 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll',
15:07:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
15:07:11 INFO - 'work_dir': 'build'}
15:07:11 INFO - [mozharness: 2016-09-21 22:07:11.580000Z] Running clobber step.
15:07:11 INFO - Running pre-action listener: _resource_record_pre_action
15:07:11 INFO - Running main action method: clobber
15:07:11 INFO - rmtree: C:\slave\test\build
15:07:11 INFO - Using _rmtree_windows ...
15:07:11 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1
15:09:53 INFO - Running post-action listener: _resource_record_post_action
15:09:53 INFO - [mozharness: 2016-09-21 22:09:53.936000Z] Finished clobber step (success)
15:09:53 INFO - [mozharness: 2016-09-21 22:09:53.936000Z] Running read-buildbot-config step.
15:09:53 INFO - Running pre-action listener: _resource_record_pre_action
15:09:53 INFO - Running main action method: read_buildbot_config
15:09:53 INFO - Using buildbot properties:
15:09:53 INFO - {
15:09:53 INFO - "project": "",
15:09:53 INFO - "product": "firefox",
15:09:53 INFO - "script_repo_revision": "production",
15:09:53 INFO - "builddir": "fx-team_win7_ix_test-dromaeojs",
15:09:53 INFO - "repository": "",
15:09:53 INFO - "buildername": "Windows 7 32-bit fx-team pgo talos dromaeojs",
15:09:53 INFO - "buildid": "20160921123003",
15:09:53 INFO - "pgo_build": "True",
15:09:53 INFO - "basedir": "C:\\slave\\test",
15:09:53 INFO - "buildnumber": 21,
15:09:53 INFO - "slavename": "t-w732-ix-116",
15:09:53 INFO - "master": "http://buildbot-master119.bb.releng.scl3.mozilla.com:8201/",
15:09:53 INFO - "platform": "win7_ix",
15:09:53 INFO - "scheduler": "tests-fx-team-win32-pgo-talos",
15:09:53 INFO - "branch": "fx-team",
15:09:53 INFO - "repo_path": "integration/fx-team",
15:09:53 INFO - "revision": "6757959dbba2a80fa1f58ea4e677c65cb5cd9e15",
15:09:53 INFO - "stage_platform": "win32-pgo",
15:09:53 INFO - "builduid": "a98ead63674d48699898b1dcca3ac00f",
15:09:53 INFO - "slavebuilddir": "test"
15:09:53 INFO - }
15:09:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/DapT4v3yQqy0sxpfh59F3g/artifacts/public/build/firefox-52.0a1.en-US.win32.zip.
15:09:53 INFO - Running post-action listener: _resource_record_post_action
15:09:53 INFO - [mozharness: 2016-09-21 22:09:53.940000Z] Finished read-buildbot-config step (success)
15:09:53 INFO - [mozharness: 2016-09-21 22:09:53.940000Z] Running download-and-extract step.
15:09:53 INFO - Running pre-action listener: _resource_record_pre_action
15:09:53 INFO - Running main action method: download_and_extract
15:09:53 INFO - mkdir: C:\slave\test\build\tests
15:09: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')]}
15:09:53 INFO - trying https://queue.taskcluster.net/v1/task/DapT4v3yQqy0sxpfh59F3g/artifacts/public/build/firefox-52.0a1.en-US.win32.test_packages.json
15:09:53 INFO - Downloading https://queue.taskcluster.net/v1/task/DapT4v3yQqy0sxpfh59F3g/artifacts/public/build/firefox-52.0a1.en-US.win32.test_packages.json to C:\slave\test\build\firefox-52.0a1.en-US.win32.test_packages.json
15:09:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DapT4v3yQqy0sxpfh59F3g/artifacts/public/build/firefox-52.0a1.en-US.win32.test_packages.json', 'file_name': 'C:\\slave\\test\\build\\firefox-52.0a1.en-US.win32.test_packages.json'}, attempt #1
15:09:55 INFO - Downloaded 1218 bytes.
15:09:55 INFO - Reading from file C:\slave\test\build\firefox-52.0a1.en-US.win32.test_packages.json
15:09:55 INFO - Using the following test package requirements:
15:09:55 INFO - {u'common': [u'firefox-52.0a1.en-US.win32.common.tests.zip'],
15:09:55 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.win32.common.tests.zip',
15:09:55 INFO - u'firefox-52.0a1.en-US.win32.cppunittest.tests.zip'],
15:09:55 INFO - u'gtest': [u'firefox-52.0a1.en-US.win32.common.tests.zip'],
15:09:55 INFO - u'jittest': [u'firefox-52.0a1.en-US.win32.common.tests.zip',
15:09:55 INFO - u'jsshell-win32.zip'],
15:09:55 INFO - u'mochitest': [u'firefox-52.0a1.en-US.win32.common.tests.zip',
15:09:55 INFO - u'firefox-52.0a1.en-US.win32.mochitest.tests.zip'],
15:09:55 INFO - u'mozbase': [u'firefox-52.0a1.en-US.win32.common.tests.zip'],
15:09:55 INFO - u'reftest': [u'firefox-52.0a1.en-US.win32.common.tests.zip',
15:09:55 INFO - u'firefox-52.0a1.en-US.win32.reftest.tests.zip'],
15:09:55 INFO - u'talos': [u'firefox-52.0a1.en-US.win32.common.tests.zip',
15:09:55 INFO - u'firefox-52.0a1.en-US.win32.talos.tests.zip'],
15:09:55 INFO - u'web-platform': [u'firefox-52.0a1.en-US.win32.common.tests.zip',
15:09:55 INFO - u'firefox-52.0a1.en-US.win32.web-platform.tests.zip'],
15:09:55 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.win32.common.tests.zip',
15:09:55 INFO - u'firefox-52.0a1.en-US.win32.xpcshell.tests.zip']}
15:09:55 INFO - Downloading packages: [u'firefox-52.0a1.en-US.win32.common.tests.zip'] for test suite category: common
15:09:55 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/DapT4v3yQqy0sxpfh59F3g/artifacts/public/build/firefox-52.0a1.en-US.win32.common.tests.zip
15:09:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DapT4v3yQqy0sxpfh59F3g/artifacts/public/build/firefox-52.0a1.en-US.win32.common.tests.zip'}, attempt #1
15:09:55 INFO - Fetch https://queue.taskcluster.net/v1/task/DapT4v3yQqy0sxpfh59F3g/artifacts/public/build/firefox-52.0a1.en-US.win32.common.tests.zip into memory
15:09:55 INFO - Expected file size: 17284499
15:10:17 INFO - Downloading packages: [u'firefox-52.0a1.en-US.win32.common.tests.zip', u'firefox-52.0a1.en-US.win32.talos.tests.zip'] for test suite category: talos
15:10:17 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/DapT4v3yQqy0sxpfh59F3g/artifacts/public/build/firefox-52.0a1.en-US.win32.common.tests.zip
15:10:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DapT4v3yQqy0sxpfh59F3g/artifacts/public/build/firefox-52.0a1.en-US.win32.common.tests.zip'}, attempt #1
15:10:17 INFO - Fetch https://queue.taskcluster.net/v1/task/DapT4v3yQqy0sxpfh59F3g/artifacts/public/build/firefox-52.0a1.en-US.win32.common.tests.zip into memory
15:10:18 INFO - Expected file size: 17284499
15:10:25 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/DapT4v3yQqy0sxpfh59F3g/artifacts/public/build/firefox-52.0a1.en-US.win32.talos.tests.zip
15:10:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DapT4v3yQqy0sxpfh59F3g/artifacts/public/build/firefox-52.0a1.en-US.win32.talos.tests.zip'}, attempt #1
15:10:25 INFO - Fetch https://queue.taskcluster.net/v1/task/DapT4v3yQqy0sxpfh59F3g/artifacts/public/build/firefox-52.0a1.en-US.win32.talos.tests.zip into memory
15:10:26 INFO - Expected file size: 14414059
15:10: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')]}
15:10:29 INFO - trying https://queue.taskcluster.net/v1/task/DapT4v3yQqy0sxpfh59F3g/artifacts/public/build/firefox-52.0a1.en-US.win32.zip
15:10:29 INFO - Downloading https://queue.taskcluster.net/v1/task/DapT4v3yQqy0sxpfh59F3g/artifacts/public/build/firefox-52.0a1.en-US.win32.zip to C:\slave\test\build\firefox-52.0a1.en-US.win32.zip
15:10:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DapT4v3yQqy0sxpfh59F3g/artifacts/public/build/firefox-52.0a1.en-US.win32.zip', 'file_name': 'C:\\slave\\test\\build\\firefox-52.0a1.en-US.win32.zip'}, attempt #1
15:10:32 INFO - Downloaded 54683999 bytes.
15:10:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DapT4v3yQqy0sxpfh59F3g/artifacts/public/build/firefox-52.0a1.en-US.win32.zip
15:10:32 INFO - mkdir: C:\slave\test\properties
15:10:32 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url
15:10:32 INFO - Writing to file C:\slave\test\properties\build_url
15:10:32 INFO - Contents:
15:10:32 INFO - build_url:https://queue.taskcluster.net/v1/task/DapT4v3yQqy0sxpfh59F3g/artifacts/public/build/firefox-52.0a1.en-US.win32.zip
15:10:33 INFO - Running post-action listener: _resource_record_post_action
15:10:33 INFO - Running post-action listener: set_extra_try_arguments
15:10:33 INFO - [mozharness: 2016-09-21 22:10:33.090000Z] Finished download-and-extract step (success)
15:10:33 INFO - [mozharness: 2016-09-21 22:10:33.090000Z] Running populate-webroot step.
15:10:33 INFO - Running pre-action listener: _resource_record_pre_action
15:10:33 INFO - Running main action method: populate_webroot
15:10:33 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']},
15:10:33 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']},
15:10:33 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome',
15:10:33 INFO - u'--tppagecycles',
15:10:33 INFO - u'7'],
15:10:33 INFO - u'tests': [u'tsvgm']}},
15:10:33 INFO - u'suites': {u'chromez': {u'talos_options': [u'--disable-e10s'],
15:10:33 INFO - u'tests': [u'tresize', u'tcanvasmark']},
15:10:33 INFO - u'chromez-e10s': {u'tests': [u'tresize', u'tcanvasmark']},
15:10:33 INFO - u'dromaeojs': {u'talos_options': [u'--disable-e10s'],
15:10:33 INFO - u'tests': [u'dromaeo_css', u'kraken']},
15:10:33 INFO - u'dromaeojs-e10s': {u'tests': [u'dromaeo_css', u'kraken']},
15:10:33 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
15:10:33 INFO - u'talos_options': [u'--disable-e10s'],
15:10:33 INFO - u'tests': [u'tp5o_scroll', u'glterrain']},
15:10:33 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
15:10:33 INFO - u'tests': [u'tp5o_scroll', u'glterrain']},
15:10:33 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
15:10:33 INFO - u'talos_options': [u'--disable-e10s'],
15:10:33 INFO - u'tests': [u'damp', u'tps']},
15:10:33 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
15:10:33 INFO - u'tests': [u'damp', u'tps']},
15:10:33 INFO - u'g3': {u'talos_options': [u'--disable-e10s'],
15:10:33 INFO - u'tests': [u'dromaeo_dom']},
15:10:33 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']},
15:10:33 INFO - u'g4': {u'talos_options': [u'--disable-e10s'],
15:10:33 INFO - u'tests': [u'basic_compositor_video']},
15:10:33 INFO - u'g4-e10s': {u'tests': [u'basic_compositor_video']},
15:10:33 INFO - u'other': {u'talos_options': [u'--disable-e10s'],
15:10:33 INFO - u'tests': [u'a11yr',
15:10:33 INFO - u'ts_paint',
15:10:33 INFO - u'tpaint',
15:10:33 INFO - u'sessionrestore',
15:10:33 INFO - u'sessionrestore_no_auto_restore',
15:10:33 INFO - u'tabpaint']},
15:10:33 INFO - u'other-e10s': {u'tests': [u'a11yr',
15:10:33 INFO - u'ts_paint',
15:10:33 INFO - u'tpaint',
15:10:33 INFO - u'sessionrestore',
15:10:33 INFO - u'sessionrestore_no_auto_restore',
15:10:33 INFO - u'tabpaint']},
15:10:33 INFO - u'other-e10s_l64': {u'tests': [u'a11yr',
15:10:33 INFO - u'ts_paint',
15:10:33 INFO - u'tpaint',
15:10:33 INFO - u'sessionrestore',
15:10:33 INFO - u'sessionrestore_no_auto_restore',
15:10:33 INFO - u'tabpaint']},
15:10:33 INFO - u'other-e10s_nol64': {u'tests': [u'a11yr',
15:10:33 INFO - u'ts_paint',
15:10:33 INFO - u'tpaint',
15:10:33 INFO - u'sessionrestore',
15:10:33 INFO - u'sessionrestore_no_auto_restore',
15:10:33 INFO - u'tabpaint']},
15:10:33 INFO - u'other_l64': {u'talos_options': [u'--disable-e10s'],
15:10:33 INFO - u'tests': [u'a11yr',
15:10:33 INFO - u'ts_paint',
15:10:33 INFO - u'tpaint',
15:10:33 INFO - u'sessionrestore',
15:10:33 INFO - u'sessionrestore_no_auto_restore',
15:10:33 INFO - u'tabpaint']},
15:10:33 INFO - u'other_nol64': {u'talos_options': [u'--disable-e10s'],
15:10:33 INFO - u'tests': [u'a11yr',
15:10:33 INFO - u'ts_paint',
15:10:33 INFO - u'tpaint',
15:10:33 INFO - u'sessionrestore',
15:10:33 INFO - u'sessionrestore_no_auto_restore',
15:10:33 INFO - u'tabpaint']},
15:10:33 INFO - u'svgr': {u'talos_options': [u'--disable-e10s'],
15:10:33 INFO - u'tests': [u'tsvgx',
15:10:33 INFO - u'tsvgr_opacity',
15:10:33 INFO - u'tart',
15:10:33 INFO - u'tscrollx',
15:10:33 INFO - u'cart']},
15:10:33 INFO - u'svgr-e10s': {u'tests': [u'tsvgx',
15:10:33 INFO - u'tsvgr_opacity',
15:10:33 INFO - u'tart',
15:10:33 INFO - u'tscrollx',
15:10:33 INFO - u'cart']},
15:10:33 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
15:10:33 INFO - u'talos_options': [u'--disable-e10s'],
15:10:33 INFO - u'tests': [u'tp5o']},
15:10:33 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
15:10:33 INFO - u'tests': [u'tp5o']},
15:10:33 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
15:10:33 INFO - u'talos_options': [u'--disable-e10s',
15:10:33 INFO - u'--xperf_path',
15:10:33 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
15:10:33 INFO - u'tests': [u'tp5n']},
15:10:33 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
15:10:33 INFO - u'talos_options': [u'--xperf_path',
15:10:33 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
15:10:33 INFO - u'tests': [u'tp5n']}},
15:10:33 INFO - u'talos.zip': {u'path': u'',
15:10:33 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}}
15:10:33 INFO - Running post-action listener: _resource_record_post_action
15:10:33 INFO - [mozharness: 2016-09-21 22:10:33.151000Z] Finished populate-webroot step (success)
15:10:33 INFO - [mozharness: 2016-09-21 22:10:33.151000Z] Running create-virtualenv step.
15:10:33 INFO - Running pre-action listener: _resource_record_pre_action
15:10:33 INFO - Running main action method: create_virtualenv
15:10:33 INFO - Creating virtualenv C:\slave\test\build/venv
15:10:33 INFO - mkdir: C:\slave\test\build\venv\Scripts
15:10:33 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll
15:10:33 WARNING - Can't copy c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll: [Errno 2] No such file or directory: 'c:/mozilla-build/python27/python27.dll'!
15:10:33 INFO - Running command: ['c:/mozilla-build/python27/python.exe', 'c:/mozilla-build/buildbotve/virtualenv.py', '--no-site-packages', '--distribute', 'C:\\slave\\test\\build/venv'] in C:\slave\test\build
15:10:33 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build/venv
15:10:43 INFO - New python executable in C:\slave\test\build/venv\Scripts\python.exe
15:10:46 INFO - Installing distribute......................................................................................................................................................................................done.
15:10:48 INFO - Return code: 0
15:10:48 INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv
15:10:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
15:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
15:10:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
15:10:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
15:10:48 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 0x01852640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018F9E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x017FB930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01913E90>, '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 0x0126A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x019C9520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-116', 'USERDOMAIN': 'T-W732-IX-116', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'OURDRIVE': 'C:', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W732-IX-116', 'MOZ_NO_REMOTE': '1', 'WINDOWS_TRACING_FLAGS': '3', 'CYGWINBASE': 'C:\\cygwin', 'PROGRAMDATA': 'C:\\ProgramData', 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
15:10:48 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in C:\slave\test\build
15:10:48 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5
15:10:48 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
15:10:48 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
15:10:48 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
15:10:48 INFO - 'COMPUTERNAME': 'T-W732-IX-116',
15:10:48 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
15:10:48 INFO - 'CYGWINBASE': 'C:\\cygwin',
15:10:48 INFO - 'DCLOCATION': 'SCL3',
15:10:48 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
15:10:48 INFO - 'FP_NO_HOST_CHECK': 'NO',
15:10:48 INFO - 'HOMEDRIVE': 'C:',
15:10:48 INFO - 'HOMEPATH': '\\Users\\cltbld',
15:10:48 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
15:10:48 INFO - 'KTS_VERSION': '1.19c',
15:10:48 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
15:10:48 INFO - 'LOGONSERVER': '\\\\T-W732-IX-116',
15:10:48 INFO - 'MONDIR': 'C:\\Monitor_config\\',
15:10:48 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
15:10:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
15:10:48 INFO - 'MOZ_NO_REMOTE': '1',
15:10:48 INFO - 'NO_EM_RESTART': '1',
15:10:48 INFO - 'NUMBER_OF_PROCESSORS': '8',
15:10:48 INFO - 'OS': 'Windows_NT',
15:10:48 INFO - 'OURDRIVE': 'C:',
15:10:48 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;',
15:10:48 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
15:10:48 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
15:10:48 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
15:10:48 INFO - 'PROCESSOR_LEVEL': '6',
15:10:48 INFO - 'PROCESSOR_REVISION': '1e05',
15:10:48 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
15:10:48 INFO - 'PROGRAMFILES': 'C:\\Program Files',
15:10:48 INFO - 'PROMPT': '$P$G',
15:10:48 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
15:10:48 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
15:10:48 INFO - 'PUBLIC': 'C:\\Users\\Public',
15:10:48 INFO - 'PWD': 'C:\\slave\\test',
15:10:48 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
15:10:48 INFO - 'SLAVEDIR': 'C:\\slave\\',
15:10:48 INFO - 'SYSTEMDRIVE': 'C:',
15:10:48 INFO - 'SYSTEMROOT': 'C:\\windows',
15:10:48 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
15:10:48 INFO - 'TEST1': 'testie',
15:10:48 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
15:10:48 INFO - 'USERDOMAIN': 'T-W732-IX-116',
15:10:48 INFO - 'USERNAME': 'cltbld',
15:10:48 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
15:10:48 INFO - 'WINDIR': 'C:\\windows',
15:10:48 INFO - 'WINDOWS_TRACING_FLAGS': '3',
15:10:48 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
15:10:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
15:10:49 INFO - Ignoring indexes: http://pypi.python.org/simple/
15:10:49 INFO - Downloading/unpacking pip>=1.5
15:10:53 INFO - Running setup.py egg_info for package pip
15:10:53 INFO - warning: no files found matching 'pip\cacert.pem'
15:10:53 INFO - warning: no files found matching '*.html' under directory 'docs'
15:10:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build'
15:10:53 INFO - no previously-included directories found matching 'docs\_build\_sources'
15:10:53 INFO - Installing collected packages: pip
15:10:53 INFO - Found existing installation: pip 0.8.2
15:10:53 INFO - Uninstalling pip:
15:10:53 INFO - Successfully uninstalled pip
15:10:53 INFO - Running setup.py install for pip
15:10:53 INFO - warning: no files found matching 'pip\cacert.pem'
15:10:53 INFO - warning: no files found matching '*.html' under directory 'docs'
15:10:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build'
15:10:53 INFO - no previously-included directories found matching 'docs\_build\_sources'
15:10:53 INFO - Installing pip-script.py script to C:\slave\test\build\venv\Scripts
15:10:53 INFO - Installing pip.exe script to C:\slave\test\build\venv\Scripts
15:10:53 INFO - Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts
15:10:53 INFO - Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts
15:10:53 INFO - Installing pip2-script.py script to C:\slave\test\build\venv\Scripts
15:10:53 INFO - Installing pip2.exe script to C:\slave\test\build\venv\Scripts
15:10:53 INFO - Successfully installed pip
15:10:53 INFO - Cleaning up...
15:10:53 INFO - Return code: 0
15:10:53 INFO - Installing psutil>=3.1.1 into virtualenv C:\slave\test\build/venv
15:10: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')]}
15:10:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
15:10: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')]}
15:10:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
15:10: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', '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 0x01852640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018F9E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x017FB930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01913E90>, '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 0x0126A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x019C9520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-116', 'USERDOMAIN': 'T-W732-IX-116', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'OURDRIVE': 'C:', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W732-IX-116', 'MOZ_NO_REMOTE': '1', 'WINDOWS_TRACING_FLAGS': '3', 'CYGWINBASE': 'C:\\cygwin', 'PROGRAMDATA': 'C:\\ProgramData', 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
15:10: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', 'psutil>=3.1.1'] in C:\slave\test\build
15:10: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 psutil>=3.1.1
15:10:53 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
15:10:53 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
15:10:53 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
15:10:53 INFO - 'COMPUTERNAME': 'T-W732-IX-116',
15:10:53 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
15:10:53 INFO - 'CYGWINBASE': 'C:\\cygwin',
15:10:53 INFO - 'DCLOCATION': 'SCL3',
15:10:53 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
15:10:53 INFO - 'FP_NO_HOST_CHECK': 'NO',
15:10:53 INFO - 'HOMEDRIVE': 'C:',
15:10:53 INFO - 'HOMEPATH': '\\Users\\cltbld',
15:10:53 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
15:10:53 INFO - 'KTS_VERSION': '1.19c',
15:10:53 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
15:10:53 INFO - 'LOGONSERVER': '\\\\T-W732-IX-116',
15:10:53 INFO - 'MONDIR': 'C:\\Monitor_config\\',
15:10:53 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
15:10:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
15:10:53 INFO - 'MOZ_NO_REMOTE': '1',
15:10:53 INFO - 'NO_EM_RESTART': '1',
15:10:53 INFO - 'NUMBER_OF_PROCESSORS': '8',
15:10:53 INFO - 'OS': 'Windows_NT',
15:10:53 INFO - 'OURDRIVE': 'C:',
15:10:53 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;',
15:10:53 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
15:10:53 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
15:10:53 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
15:10:53 INFO - 'PROCESSOR_LEVEL': '6',
15:10:53 INFO - 'PROCESSOR_REVISION': '1e05',
15:10:53 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
15:10:53 INFO - 'PROGRAMFILES': 'C:\\Program Files',
15:10:53 INFO - 'PROMPT': '$P$G',
15:10:53 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
15:10:53 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
15:10:53 INFO - 'PUBLIC': 'C:\\Users\\Public',
15:10:53 INFO - 'PWD': 'C:\\slave\\test',
15:10:53 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
15:10:53 INFO - 'SLAVEDIR': 'C:\\slave\\',
15:10:53 INFO - 'SYSTEMDRIVE': 'C:',
15:10:53 INFO - 'SYSTEMROOT': 'C:\\windows',
15:10:53 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
15:10:53 INFO - 'TEST1': 'testie',
15:10:53 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
15:10:53 INFO - 'USERDOMAIN': 'T-W732-IX-116',
15:10:53 INFO - 'USERNAME': 'cltbld',
15:10:53 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
15:10:53 INFO - 'WINDIR': 'C:\\windows',
15:10:53 INFO - 'WINDOWS_TRACING_FLAGS': '3',
15:10:53 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
15:10:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
15:10:55 INFO - Ignoring indexes: https://pypi.python.org/simple/
15:10:55 INFO - Downloading/unpacking psutil>=3.1.1
15:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
15:10:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
15:10:56 INFO - Installing collected packages: psutil
15:10:56 INFO - Successfully installed psutil
15:10:56 INFO - Cleaning up...
15:10:56 INFO - Return code: 0
15:10:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv C:\slave\test\build/venv
15:10:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
15:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
15:10:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
15:10:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
15:10:56 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 0x01852640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018F9E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x017FB930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01913E90>, '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 0x0126A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x019C9520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-116', 'USERDOMAIN': 'T-W732-IX-116', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'OURDRIVE': 'C:', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W732-IX-116', 'MOZ_NO_REMOTE': '1', 'WINDOWS_TRACING_FLAGS': '3', 'CYGWINBASE': 'C:\\cygwin', 'PROGRAMDATA': 'C:\\ProgramData', 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
15:10:56 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in C:\slave\test\build
15:10:56 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3
15:10:56 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
15:10:56 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
15:10:56 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
15:10:56 INFO - 'COMPUTERNAME': 'T-W732-IX-116',
15:10:56 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
15:10:56 INFO - 'CYGWINBASE': 'C:\\cygwin',
15:10:56 INFO - 'DCLOCATION': 'SCL3',
15:10:56 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
15:10:56 INFO - 'FP_NO_HOST_CHECK': 'NO',
15:10:56 INFO - 'HOMEDRIVE': 'C:',
15:10:56 INFO - 'HOMEPATH': '\\Users\\cltbld',
15:10:56 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
15:10:56 INFO - 'KTS_VERSION': '1.19c',
15:10:56 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
15:10:56 INFO - 'LOGONSERVER': '\\\\T-W732-IX-116',
15:10:56 INFO - 'MONDIR': 'C:\\Monitor_config\\',
15:10:56 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
15:10:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
15:10:56 INFO - 'MOZ_NO_REMOTE': '1',
15:10:56 INFO - 'NO_EM_RESTART': '1',
15:10:56 INFO - 'NUMBER_OF_PROCESSORS': '8',
15:10:56 INFO - 'OS': 'Windows_NT',
15:10:56 INFO - 'OURDRIVE': 'C:',
15:10:56 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;',
15:10:56 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
15:10:56 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
15:10:56 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
15:10:56 INFO - 'PROCESSOR_LEVEL': '6',
15:10:56 INFO - 'PROCESSOR_REVISION': '1e05',
15:10:56 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
15:10:56 INFO - 'PROGRAMFILES': 'C:\\Program Files',
15:10:56 INFO - 'PROMPT': '$P$G',
15:10:56 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
15:10:56 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
15:10:56 INFO - 'PUBLIC': 'C:\\Users\\Public',
15:10:56 INFO - 'PWD': 'C:\\slave\\test',
15:10:56 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
15:10:56 INFO - 'SLAVEDIR': 'C:\\slave\\',
15:10:56 INFO - 'SYSTEMDRIVE': 'C:',
15:10:56 INFO - 'SYSTEMROOT': 'C:\\windows',
15:10:56 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
15:10:56 INFO - 'TEST1': 'testie',
15:10:56 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
15:10:56 INFO - 'USERDOMAIN': 'T-W732-IX-116',
15:10:56 INFO - 'USERNAME': 'cltbld',
15:10:56 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
15:10:56 INFO - 'WINDIR': 'C:\\windows',
15:10:56 INFO - 'WINDOWS_TRACING_FLAGS': '3',
15:10:56 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
15:10:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
15:10:57 INFO - Ignoring indexes: https://pypi.python.org/simple/
15:10:57 INFO - Downloading/unpacking mozsystemmonitor==0.3
15:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
15:10:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
15:10:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz
15:10:58 INFO - Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor
15:10:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in c:\slave\test\build\venv\lib\site-packages (from mozsystemmonitor==0.3)
15:10:58 INFO - Installing collected packages: mozsystemmonitor
15:10:58 INFO - Running setup.py install for mozsystemmonitor
15:10:58 INFO - Successfully installed mozsystemmonitor
15:10:58 INFO - Cleaning up...
15:10:58 INFO - Return code: 0
15:10:58 INFO - Installing jsonschema==2.5.1 into virtualenv C:\slave\test\build/venv
15:10: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')]}
15:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
15:10: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')]}
15:10:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
15:10: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', '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 0x01852640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018F9E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x017FB930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01913E90>, '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 0x0126A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x019C9520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-116', 'USERDOMAIN': 'T-W732-IX-116', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'OURDRIVE': 'C:', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W732-IX-116', 'MOZ_NO_REMOTE': '1', 'WINDOWS_TRACING_FLAGS': '3', 'CYGWINBASE': 'C:\\cygwin', 'PROGRAMDATA': 'C:\\ProgramData', 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
15:10: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', 'jsonschema==2.5.1'] in C:\slave\test\build
15:10: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 jsonschema==2.5.1
15:10:58 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
15:10:58 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
15:10:58 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
15:10:58 INFO - 'COMPUTERNAME': 'T-W732-IX-116',
15:10:58 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
15:10:58 INFO - 'CYGWINBASE': 'C:\\cygwin',
15:10:58 INFO - 'DCLOCATION': 'SCL3',
15:10:58 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
15:10:58 INFO - 'FP_NO_HOST_CHECK': 'NO',
15:10:58 INFO - 'HOMEDRIVE': 'C:',
15:10:58 INFO - 'HOMEPATH': '\\Users\\cltbld',
15:10:58 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
15:10:58 INFO - 'KTS_VERSION': '1.19c',
15:10:58 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
15:10:58 INFO - 'LOGONSERVER': '\\\\T-W732-IX-116',
15:10:58 INFO - 'MONDIR': 'C:\\Monitor_config\\',
15:10:58 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
15:10:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
15:10:58 INFO - 'MOZ_NO_REMOTE': '1',
15:10:58 INFO - 'NO_EM_RESTART': '1',
15:10:58 INFO - 'NUMBER_OF_PROCESSORS': '8',
15:10:58 INFO - 'OS': 'Windows_NT',
15:10:58 INFO - 'OURDRIVE': 'C:',
15:10:58 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;',
15:10:58 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
15:10:58 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
15:10:58 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
15:10:58 INFO - 'PROCESSOR_LEVEL': '6',
15:10:58 INFO - 'PROCESSOR_REVISION': '1e05',
15:10:58 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
15:10:58 INFO - 'PROGRAMFILES': 'C:\\Program Files',
15:10:58 INFO - 'PROMPT': '$P$G',
15:10:58 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
15:10:58 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
15:10:58 INFO - 'PUBLIC': 'C:\\Users\\Public',
15:10:58 INFO - 'PWD': 'C:\\slave\\test',
15:10:58 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
15:10:58 INFO - 'SLAVEDIR': 'C:\\slave\\',
15:10:58 INFO - 'SYSTEMDRIVE': 'C:',
15:10:58 INFO - 'SYSTEMROOT': 'C:\\windows',
15:10:58 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
15:10:58 INFO - 'TEST1': 'testie',
15:10:58 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
15:10:58 INFO - 'USERDOMAIN': 'T-W732-IX-116',
15:10:58 INFO - 'USERNAME': 'cltbld',
15:10:58 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
15:10:58 INFO - 'WINDIR': 'C:\\windows',
15:10:58 INFO - 'WINDOWS_TRACING_FLAGS': '3',
15:10:58 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
15:10:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
15:10:59 INFO - Ignoring indexes: https://pypi.python.org/simple/
15:10:59 INFO - Downloading/unpacking jsonschema==2.5.1
15:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
15:10:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
15:11:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl
15:11:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1)
15:11: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
15:11: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
15:11:00 INFO - Downloading functools32-3.2.3-2.tar.gz
15:11:00 INFO - Running setup.py (path:C:\slave\test\build\venv\build\functools32\setup.py) egg_info for package functools32
15:11:00 INFO - warning: no files found matching '*.txt'
15:11:00 INFO - no previously-included directories found matching 'build'
15:11:00 INFO - no previously-included directories found matching 'dist'
15:11:00 INFO - no previously-included directories found matching '.git*'
15:11:00 INFO - Installing collected packages: jsonschema, functools32
15:11:00 INFO - Running setup.py install for functools32
15:11:00 INFO - warning: no files found matching '*.txt'
15:11:00 INFO - no previously-included directories found matching 'build'
15:11:00 INFO - no previously-included directories found matching 'dist'
15:11:00 INFO - no previously-included directories found matching '.git*'
15:11:00 INFO - Successfully installed jsonschema functools32
15:11:00 INFO - Cleaning up...
15:11:01 INFO - Return code: 0
15:11:01 INFO - Installing functools32==3.2.3-2 into virtualenv C:\slave\test\build/venv
15:11: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')]}
15:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
15:11: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')]}
15:11:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
15:11: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', '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 0x01852640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018F9E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x017FB930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01913E90>, '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 0x0126A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x019C9520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-116', 'USERDOMAIN': 'T-W732-IX-116', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'OURDRIVE': 'C:', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W732-IX-116', 'MOZ_NO_REMOTE': '1', 'WINDOWS_TRACING_FLAGS': '3', 'CYGWINBASE': 'C:\\cygwin', 'PROGRAMDATA': 'C:\\ProgramData', 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
15:11: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', 'functools32==3.2.3-2'] in C:\slave\test\build
15:11: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 functools32==3.2.3-2
15:11:01 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
15:11:01 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
15:11:01 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
15:11:01 INFO - 'COMPUTERNAME': 'T-W732-IX-116',
15:11:01 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
15:11:01 INFO - 'CYGWINBASE': 'C:\\cygwin',
15:11:01 INFO - 'DCLOCATION': 'SCL3',
15:11:01 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
15:11:01 INFO - 'FP_NO_HOST_CHECK': 'NO',
15:11:01 INFO - 'HOMEDRIVE': 'C:',
15:11:01 INFO - 'HOMEPATH': '\\Users\\cltbld',
15:11:01 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
15:11:01 INFO - 'KTS_VERSION': '1.19c',
15:11:01 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
15:11:01 INFO - 'LOGONSERVER': '\\\\T-W732-IX-116',
15:11:01 INFO - 'MONDIR': 'C:\\Monitor_config\\',
15:11:01 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
15:11:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
15:11:01 INFO - 'MOZ_NO_REMOTE': '1',
15:11:01 INFO - 'NO_EM_RESTART': '1',
15:11:01 INFO - 'NUMBER_OF_PROCESSORS': '8',
15:11:01 INFO - 'OS': 'Windows_NT',
15:11:01 INFO - 'OURDRIVE': 'C:',
15:11:01 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;',
15:11:01 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
15:11:01 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
15:11:01 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
15:11:01 INFO - 'PROCESSOR_LEVEL': '6',
15:11:01 INFO - 'PROCESSOR_REVISION': '1e05',
15:11:01 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
15:11:01 INFO - 'PROGRAMFILES': 'C:\\Program Files',
15:11:01 INFO - 'PROMPT': '$P$G',
15:11:01 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
15:11:01 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
15:11:01 INFO - 'PUBLIC': 'C:\\Users\\Public',
15:11:01 INFO - 'PWD': 'C:\\slave\\test',
15:11:01 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
15:11:01 INFO - 'SLAVEDIR': 'C:\\slave\\',
15:11:01 INFO - 'SYSTEMDRIVE': 'C:',
15:11:01 INFO - 'SYSTEMROOT': 'C:\\windows',
15:11:01 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
15:11:01 INFO - 'TEST1': 'testie',
15:11:01 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
15:11:01 INFO - 'USERDOMAIN': 'T-W732-IX-116',
15:11:01 INFO - 'USERNAME': 'cltbld',
15:11:01 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
15:11:01 INFO - 'WINDIR': 'C:\\windows',
15:11:01 INFO - 'WINDOWS_TRACING_FLAGS': '3',
15:11:01 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
15:11:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
15:11:01 INFO - Ignoring indexes: https://pypi.python.org/simple/
15:11:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in c:\slave\test\build\venv\lib\site-packages
15:11:01 INFO - Cleaning up...
15:11:01 INFO - Return code: 0
15:11:01 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv
15:11: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')]}
15:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
15:11: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')]}
15:11:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
15:11: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', '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 0x01852640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018F9E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x017FB930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01913E90>, '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 0x0126A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x019C9520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-116', 'USERDOMAIN': 'T-W732-IX-116', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'OURDRIVE': 'C:', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W732-IX-116', 'MOZ_NO_REMOTE': '1', 'WINDOWS_TRACING_FLAGS': '3', 'CYGWINBASE': 'C:\\cygwin', 'PROGRAMDATA': 'C:\\ProgramData', 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
15:11: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', 'blobuploader==1.2.4'] in C:\slave\test\build
15:11: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 blobuploader==1.2.4
15:11:01 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
15:11:01 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
15:11:01 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
15:11:01 INFO - 'COMPUTERNAME': 'T-W732-IX-116',
15:11:01 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
15:11:01 INFO - 'CYGWINBASE': 'C:\\cygwin',
15:11:01 INFO - 'DCLOCATION': 'SCL3',
15:11:01 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
15:11:01 INFO - 'FP_NO_HOST_CHECK': 'NO',
15:11:01 INFO - 'HOMEDRIVE': 'C:',
15:11:01 INFO - 'HOMEPATH': '\\Users\\cltbld',
15:11:01 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
15:11:01 INFO - 'KTS_VERSION': '1.19c',
15:11:01 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
15:11:01 INFO - 'LOGONSERVER': '\\\\T-W732-IX-116',
15:11:01 INFO - 'MONDIR': 'C:\\Monitor_config\\',
15:11:01 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
15:11:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
15:11:01 INFO - 'MOZ_NO_REMOTE': '1',
15:11:01 INFO - 'NO_EM_RESTART': '1',
15:11:01 INFO - 'NUMBER_OF_PROCESSORS': '8',
15:11:01 INFO - 'OS': 'Windows_NT',
15:11:01 INFO - 'OURDRIVE': 'C:',
15:11:01 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;',
15:11:01 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
15:11:01 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
15:11:01 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
15:11:01 INFO - 'PROCESSOR_LEVEL': '6',
15:11:01 INFO - 'PROCESSOR_REVISION': '1e05',
15:11:01 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
15:11:01 INFO - 'PROGRAMFILES': 'C:\\Program Files',
15:11:01 INFO - 'PROMPT': '$P$G',
15:11:01 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
15:11:01 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
15:11:01 INFO - 'PUBLIC': 'C:\\Users\\Public',
15:11:01 INFO - 'PWD': 'C:\\slave\\test',
15:11:01 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
15:11:01 INFO - 'SLAVEDIR': 'C:\\slave\\',
15:11:01 INFO - 'SYSTEMDRIVE': 'C:',
15:11:01 INFO - 'SYSTEMROOT': 'C:\\windows',
15:11:01 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
15:11:01 INFO - 'TEST1': 'testie',
15:11:01 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
15:11:01 INFO - 'USERDOMAIN': 'T-W732-IX-116',
15:11:01 INFO - 'USERNAME': 'cltbld',
15:11:01 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
15:11:01 INFO - 'WINDIR': 'C:\\windows',
15:11:01 INFO - 'WINDOWS_TRACING_FLAGS': '3',
15:11:01 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
15:11:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
15:11:02 INFO - Ignoring indexes: https://pypi.python.org/simple/
15:11:02 INFO - Downloading/unpacking blobuploader==1.2.4
15:11: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
15:11: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
15:11:03 INFO - Downloading blobuploader-1.2.4.tar.gz
15:11:03 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader
15:11:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4)
15:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
15:11:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
15:11:03 INFO - Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests
15:11:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4)
15:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
15:11:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
15:11:03 INFO - Downloading docopt-0.6.1.tar.gz
15:11:03 INFO - Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt
15:11:04 INFO - Installing collected packages: blobuploader, requests, docopt
15:11:04 INFO - Running setup.py install for blobuploader
15:11:04 INFO - Running setup.py install for requests
15:11:04 INFO - Running setup.py install for docopt
15:11:05 INFO - Successfully installed blobuploader requests docopt
15:11:05 INFO - Cleaning up...
15:11:06 INFO - Return code: 0
15:11:06 INFO - Installing None into virtualenv C:\slave\test\build/venv
15:11:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
15:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
15:11:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
15:11:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
15:11:06 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--no-deps', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01852640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018F9E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x017FB930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01913E90>, '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 0x0126A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x019C9520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-116', 'USERDOMAIN': 'T-W732-IX-116', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'OURDRIVE': 'C:', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W732-IX-116', 'MOZ_NO_REMOTE': '1', 'WINDOWS_TRACING_FLAGS': '3', 'CYGWINBASE': 'C:\\cygwin', 'PROGRAMDATA': 'C:\\ProgramData', 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
15:11:06 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--no-deps', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in C:\slave\test\build\tests\config
15:11:06 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --no-deps --timeout 120 -r C:\slave\test\build\tests\config\mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub
15:11:06 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
15:11:06 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
15:11:06 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
15:11:06 INFO - 'COMPUTERNAME': 'T-W732-IX-116',
15:11:06 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
15:11:06 INFO - 'CYGWINBASE': 'C:\\cygwin',
15:11:06 INFO - 'DCLOCATION': 'SCL3',
15:11:06 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
15:11:06 INFO - 'FP_NO_HOST_CHECK': 'NO',
15:11:06 INFO - 'HOMEDRIVE': 'C:',
15:11:06 INFO - 'HOMEPATH': '\\Users\\cltbld',
15:11:06 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
15:11:06 INFO - 'KTS_VERSION': '1.19c',
15:11:06 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
15:11:06 INFO - 'LOGONSERVER': '\\\\T-W732-IX-116',
15:11:06 INFO - 'MONDIR': 'C:\\Monitor_config\\',
15:11:06 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
15:11:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
15:11:06 INFO - 'MOZ_NO_REMOTE': '1',
15:11:06 INFO - 'NO_EM_RESTART': '1',
15:11:06 INFO - 'NUMBER_OF_PROCESSORS': '8',
15:11:06 INFO - 'OS': 'Windows_NT',
15:11:06 INFO - 'OURDRIVE': 'C:',
15:11:06 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;',
15:11:06 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
15:11:06 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
15:11:06 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
15:11:06 INFO - 'PROCESSOR_LEVEL': '6',
15:11:06 INFO - 'PROCESSOR_REVISION': '1e05',
15:11:06 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
15:11:06 INFO - 'PROGRAMFILES': 'C:\\Program Files',
15:11:06 INFO - 'PROMPT': '$P$G',
15:11:06 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
15:11:06 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
15:11:06 INFO - 'PUBLIC': 'C:\\Users\\Public',
15:11:06 INFO - 'PWD': 'C:\\slave\\test',
15:11:06 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
15:11:06 INFO - 'SLAVEDIR': 'C:\\slave\\',
15:11:06 INFO - 'SYSTEMDRIVE': 'C:',
15:11:06 INFO - 'SYSTEMROOT': 'C:\\windows',
15:11:06 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
15:11:06 INFO - 'TEST1': 'testie',
15:11:06 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
15:11:06 INFO - 'USERDOMAIN': 'T-W732-IX-116',
15:11:06 INFO - 'USERNAME': 'cltbld',
15:11:06 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
15:11:06 INFO - 'WINDIR': 'C:\\windows',
15:11:06 INFO - 'WINDOWS_TRACING_FLAGS': '3',
15:11:06 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
15:11:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
15:11:06 INFO - Ignoring indexes: https://pypi.python.org/simple/
15:11:06 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser
15:11:06 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-rsjjxn-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser
15:11:06 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash
15:11:06 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-qjgjfr-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash
15:11:06 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug
15:11:06 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-ppiub_-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug
15:11:06 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice
15:11:06 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-boiapk-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice
15:11:07 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile
15:11:07 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-qazrph-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile
15:11:07 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd
15:11:07 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-trxogn-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd
15:11:07 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo
15:11:07 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-8gllje-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo
15:11:07 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall
15:11:07 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-b6do7r-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall
15:11:07 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak
15:11:07 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-nusaki-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak
15:11:07 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog
15:11:07 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-kr3qnz-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog
15:11:07 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork
15:11:07 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-skqbjg-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork
15:11:07 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess
15:11:08 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-kiac_u-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess
15:11:08 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile
15:11:08 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-ewlmvm-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile
15:11:08 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner
15:11:08 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-sentvh-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner
15:11:08 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot
15:11:08 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-ggo1re-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot
15:11:08 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest
15:11:08 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-gjbhls-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest
15:11:08 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion
15:11:08 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-xru_h0-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion
15:11:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion
15:11:08 INFO - Running setup.py install for manifestparser
15:11:09 INFO - Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts
15:11:09 INFO - Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts
15:11:09 INFO - Running setup.py install for mozcrash
15:11:09 INFO - Running setup.py install for mozdebug
15:11:10 INFO - Running setup.py install for mozdevice
15:11:10 INFO - Installing sutini-script.py script to C:\slave\test\build\venv\Scripts
15:11:10 INFO - Installing sutini.exe script to C:\slave\test\build\venv\Scripts
15:11:10 INFO - Installing dm-script.py script to C:\slave\test\build\venv\Scripts
15:11:10 INFO - Installing dm.exe script to C:\slave\test\build\venv\Scripts
15:11:10 INFO - Running setup.py install for mozfile
15:11:11 INFO - Running setup.py install for mozhttpd
15:11:11 INFO - Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts
15:11:11 INFO - Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts
15:11:11 INFO - Running setup.py install for mozinfo
15:11:11 INFO - Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts
15:11:11 INFO - Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts
15:11:11 INFO - Running setup.py install for mozInstall
15:11:12 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts
15:11:12 INFO - Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts
15:11:12 INFO - Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts
15:11:12 INFO - Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts
15:11:12 INFO - Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts
15:11:12 INFO - Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts
15:11:12 INFO - Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts
15:11:12 INFO - Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts
15:11:12 INFO - Running setup.py install for mozleak
15:11:12 INFO - Running setup.py install for mozlog
15:11:12 INFO - Installing structlog-script.py script to C:\slave\test\build\venv\Scripts
15:11:12 INFO - Installing structlog.exe script to C:\slave\test\build\venv\Scripts
15:11:13 INFO - Running setup.py install for moznetwork
15:11:13 INFO - Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts
15:11:13 INFO - Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts
15:11:13 INFO - Running setup.py install for mozprocess
15:11:14 INFO - Running setup.py install for mozprofile
15:11:14 INFO - Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts
15:11:14 INFO - Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts
15:11:14 INFO - Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts
15:11:14 INFO - Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts
15:11:14 INFO - Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts
15:11:14 INFO - Installing view-profile.exe script to C:\slave\test\build\venv\Scripts
15:11:15 INFO - Running setup.py install for mozrunner
15:11:15 INFO - Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts
15:11:15 INFO - Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts
15:11:15 INFO - Running setup.py install for mozscreenshot
15:11:16 INFO - Running setup.py install for moztest
15:11:16 INFO - Running setup.py install for mozversion
15:11:17 INFO - Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts
15:11:17 INFO - Installing mozversion.exe script to C:\slave\test\build\venv\Scripts
15:11:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion
15:11:18 INFO - Cleaning up...
15:11:18 INFO - Return code: 0
15:11:18 INFO - Installing None into virtualenv C:\slave\test\build/venv
15:11:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
15:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
15:11:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
15:11:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
15:11:18 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 0x01852640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018F9E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x017FB930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01913E90>, '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 0x0126A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x019C9520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-116', 'USERDOMAIN': 'T-W732-IX-116', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'OURDRIVE': 'C:', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W732-IX-116', 'MOZ_NO_REMOTE': '1', 'WINDOWS_TRACING_FLAGS': '3', 'CYGWINBASE': 'C:\\cygwin', 'PROGRAMDATA': 'C:\\ProgramData', 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
15:11:18 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in C:\slave\test\build\tests\config
15:11:18 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 -r C:\slave\test\build\tests\config\mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub
15:11:18 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
15:11:18 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
15:11:18 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
15:11:18 INFO - 'COMPUTERNAME': 'T-W732-IX-116',
15:11:18 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
15:11:18 INFO - 'CYGWINBASE': 'C:\\cygwin',
15:11:18 INFO - 'DCLOCATION': 'SCL3',
15:11:18 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
15:11:18 INFO - 'FP_NO_HOST_CHECK': 'NO',
15:11:18 INFO - 'HOMEDRIVE': 'C:',
15:11:18 INFO - 'HOMEPATH': '\\Users\\cltbld',
15:11:18 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
15:11:18 INFO - 'KTS_VERSION': '1.19c',
15:11:18 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
15:11:18 INFO - 'LOGONSERVER': '\\\\T-W732-IX-116',
15:11:18 INFO - 'MONDIR': 'C:\\Monitor_config\\',
15:11:18 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
15:11:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
15:11:18 INFO - 'MOZ_NO_REMOTE': '1',
15:11:18 INFO - 'NO_EM_RESTART': '1',
15:11:18 INFO - 'NUMBER_OF_PROCESSORS': '8',
15:11:18 INFO - 'OS': 'Windows_NT',
15:11:18 INFO - 'OURDRIVE': 'C:',
15:11:18 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;',
15:11:18 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
15:11:18 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
15:11:18 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
15:11:18 INFO - 'PROCESSOR_LEVEL': '6',
15:11:18 INFO - 'PROCESSOR_REVISION': '1e05',
15:11:18 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
15:11:18 INFO - 'PROGRAMFILES': 'C:\\Program Files',
15:11:18 INFO - 'PROMPT': '$P$G',
15:11:18 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
15:11:18 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
15:11:18 INFO - 'PUBLIC': 'C:\\Users\\Public',
15:11:18 INFO - 'PWD': 'C:\\slave\\test',
15:11:18 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
15:11:18 INFO - 'SLAVEDIR': 'C:\\slave\\',
15:11:18 INFO - 'SYSTEMDRIVE': 'C:',
15:11:18 INFO - 'SYSTEMROOT': 'C:\\windows',
15:11:18 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
15:11:18 INFO - 'TEST1': 'testie',
15:11:18 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
15:11:18 INFO - 'USERDOMAIN': 'T-W732-IX-116',
15:11:18 INFO - 'USERNAME': 'cltbld',
15:11:18 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
15:11:18 INFO - 'WINDIR': 'C:\\windows',
15:11:18 INFO - 'WINDOWS_TRACING_FLAGS': '3',
15:11:18 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
15:11:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
15:11:18 INFO - Ignoring indexes: https://pypi.python.org/simple/
15:11:18 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser
15:11:18 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-jplhq9-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser
15:11:18 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///C:/slave/test/build/tests/mozbase/manifestparser in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 1))
15:11:18 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash
15:11:18 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-mgpyoh-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash
15:11:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///C:/slave/test/build/tests/mozbase/mozcrash in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2))
15:11:18 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug
15:11:18 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-xyth66-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug
15:11:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///C:/slave/test/build/tests/mozbase/mozdebug in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 3))
15:11:18 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice
15:11:18 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-uubovm-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice
15:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///C:/slave/test/build/tests/mozbase/mozdevice in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4))
15:11:19 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile
15:11:19 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-iqvedx-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile
15:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///C:/slave/test/build/tests/mozbase/mozfile in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 5))
15:11:19 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd
15:11:19 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-hkyoq3-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd
15:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///C:/slave/test/build/tests/mozbase/mozhttpd in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 6))
15:11:19 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo
15:11:19 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-ca_wht-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo
15:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///C:/slave/test/build/tests/mozbase/mozinfo in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 7))
15:11:19 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall
15:11:19 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-h2jvya-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall
15:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///C:/slave/test/build/tests/mozbase/mozinstall in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 8))
15:11:19 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak
15:11:19 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-ljvvxx-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak
15:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///C:/slave/test/build/tests/mozbase/mozleak in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 9))
15:11:19 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog
15:11:19 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-xhonzu-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog
15:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///C:/slave/test/build/tests/mozbase/mozlog in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10))
15:11:19 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork
15:11:19 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-pb9pvv-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork
15:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///C:/slave/test/build/tests/mozbase/moznetwork in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 11))
15:11:19 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess
15:11:20 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-zp4wu3-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess
15:11:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///C:/slave/test/build/tests/mozbase/mozprocess in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 12))
15:11:20 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile
15:11:20 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-pvgsgr-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile
15:11:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///C:/slave/test/build/tests/mozbase/mozprofile in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 13))
15:11:20 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner
15:11:20 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-o66rgb-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner
15:11:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///C:/slave/test/build/tests/mozbase/mozrunner in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 14))
15:11:20 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot
15:11:20 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-w7js1z-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot
15:11:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///C:/slave/test/build/tests/mozbase/mozscreenshot in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 15))
15:11:20 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest
15:11:20 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-nsvdzt-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest
15:11:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///C:/slave/test/build/tests/mozbase/moztest in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 16))
15:11:20 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion
15:11:20 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-iw9xo6-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion
15:11:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///C:/slave/test/build/tests/mozbase/mozversion in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 17))
15:11:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==0.17->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2))
15:11:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==0.17->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2))
15:11:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in c:\slave\test\build\venv\lib\site-packages (from mozdebug==0.1->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 3))
15:11:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test\build\venv\lib\site-packages (from mozdevice==0.48->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4))
15:11:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in c:\slave\test\build\venv\lib\site-packages (from mozdevice==0.48->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4))
15:11:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10))
15:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
15:11:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
15:11:21 INFO - Downloading blessings-1.6.tar.gz
15:11:21 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings
15:11:22 INFO - Installing collected packages: blessings
15:11:22 INFO - Running setup.py install for blessings
15:11:22 INFO - Successfully installed blessings
15:11:22 INFO - Cleaning up...
15:11:25 INFO - Return code: 0
15:11:25 INFO - Done creating virtualenv C:\slave\test\build/venv.
15:11:25 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze']
15:11:25 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze
15:11:25 INFO - Reading from file tmpfile_stdout
15:11:25 INFO - Using _rmtree_windows ...
15:11:25 INFO - Using _rmtree_windows ...
15:11:25 INFO - Current package versions:
15:11:25 INFO - blessings == 1.6
15:11:25 INFO - blobuploader == 1.2.4
15:11:25 INFO - docopt == 0.6.1
15:11:25 INFO - functools32 == 3.2.3-2
15:11:25 INFO - jsonschema == 2.5.1
15:11:25 INFO - manifestparser == 1.1
15:11:25 INFO - mozInstall == 1.12
15:11:25 INFO - mozcrash == 0.17
15:11:25 INFO - mozdebug == 0.1
15:11:25 INFO - mozdevice == 0.48
15:11:25 INFO - mozfile == 1.2
15:11:25 INFO - mozhttpd == 0.7
15:11:25 INFO - mozinfo == 0.9
15:11:25 INFO - mozleak == 0.1
15:11:25 INFO - mozlog == 3.4
15:11:25 INFO - moznetwork == 0.27
15:11:25 INFO - mozprocess == 0.23
15:11:25 INFO - mozprofile == 0.28
15:11:25 INFO - mozrunner == 6.12
15:11:25 INFO - mozscreenshot == 0.1
15:11:25 INFO - mozsystemmonitor == 0.3
15:11:25 INFO - moztest == 0.7
15:11:25 INFO - mozversion == 1.4
15:11:25 INFO - psutil == 3.1.1
15:11:25 INFO - requests == 1.2.3
15:11:25 INFO - Installing None into virtualenv C:\slave\test\build/venv
15:11:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
15:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
15:11:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
15:11:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
15:11:25 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\talos\\requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01852640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018F9E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x017FB930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01913E90>, '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 0x0126A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x019C9520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build\\tests\\talos', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-116', 'USERDOMAIN': 'T-W732-IX-116', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'OURDRIVE': 'C:', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W732-IX-116', 'MOZ_NO_REMOTE': '1', 'WINDOWS_TRACING_FLAGS': '3', 'CYGWINBASE': 'C:\\cygwin', 'PROGRAMDATA': 'C:\\ProgramData', 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
15:11:25 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\talos\\requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in C:\slave\test\build\tests\talos
15:11:25 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 -r C:\slave\test\build\tests\talos\requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub
15:11:25 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
15:11:25 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
15:11:25 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
15:11:25 INFO - 'COMPUTERNAME': 'T-W732-IX-116',
15:11:25 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
15:11:25 INFO - 'CYGWINBASE': 'C:\\cygwin',
15:11:25 INFO - 'DCLOCATION': 'SCL3',
15:11:25 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
15:11:25 INFO - 'FP_NO_HOST_CHECK': 'NO',
15:11:25 INFO - 'HOMEDRIVE': 'C:',
15:11:25 INFO - 'HOMEPATH': '\\Users\\cltbld',
15:11:25 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
15:11:25 INFO - 'KTS_VERSION': '1.19c',
15:11:25 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
15:11:25 INFO - 'LOGONSERVER': '\\\\T-W732-IX-116',
15:11:25 INFO - 'MONDIR': 'C:\\Monitor_config\\',
15:11:25 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
15:11:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
15:11:25 INFO - 'MOZ_NO_REMOTE': '1',
15:11:25 INFO - 'NO_EM_RESTART': '1',
15:11:25 INFO - 'NUMBER_OF_PROCESSORS': '8',
15:11:25 INFO - 'OS': 'Windows_NT',
15:11:25 INFO - 'OURDRIVE': 'C:',
15:11:25 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;',
15:11:25 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
15:11:25 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
15:11:25 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
15:11:25 INFO - 'PROCESSOR_LEVEL': '6',
15:11:25 INFO - 'PROCESSOR_REVISION': '1e05',
15:11:25 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
15:11:25 INFO - 'PROGRAMFILES': 'C:\\Program Files',
15:11:25 INFO - 'PROMPT': '$P$G',
15:11:25 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
15:11:25 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
15:11:25 INFO - 'PUBLIC': 'C:\\Users\\Public',
15:11:25 INFO - 'PWD': 'C:\\slave\\test',
15:11:25 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
15:11:25 INFO - 'SLAVEDIR': 'C:\\slave\\',
15:11:25 INFO - 'SYSTEMDRIVE': 'C:',
15:11:25 INFO - 'SYSTEMROOT': 'C:\\windows',
15:11:25 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
15:11:25 INFO - 'TEST1': 'testie',
15:11:25 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
15:11:25 INFO - 'USERDOMAIN': 'T-W732-IX-116',
15:11:25 INFO - 'USERNAME': 'cltbld',
15:11:25 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
15:11:25 INFO - 'WINDIR': 'C:\\windows',
15:11:25 INFO - 'WINDOWS_TRACING_FLAGS': '3',
15:11:25 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
15:11:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
15:11:26 INFO - Ignoring indexes: https://pypi.python.org/simple/
15:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 1))
15:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 2))
15:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 3))
15:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 4))
15:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 5))
15:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 6))
15:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 7))
15:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 8))
15:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 9))
15:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in c:\slave\test\build\venv\lib\site-packages (from mozlog>=3.1->-r C:\slave\test\build\tests\talos\requirements.txt (line 1))
15:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test\build\venv\lib\site-packages (from mozhttpd>=0.7->-r C:\slave\test\build\tests\talos\requirements.txt (line 4))
15:11:26 INFO - Cleaning up...
15:11:26 INFO - Return code: 0
15:11:26 INFO - Installing jsonschema into virtualenv C:\slave\test\build/venv
15:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
15:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
15:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
15:11:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
15:11:26 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 0x01852640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018F9E30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x017FB930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01913E90>, '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 0x0126A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x019C9520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-116', 'USERDOMAIN': 'T-W732-IX-116', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'OURDRIVE': 'C:', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W732-IX-116', 'MOZ_NO_REMOTE': '1', 'WINDOWS_TRACING_FLAGS': '3', 'CYGWINBASE': 'C:\\cygwin', 'PROGRAMDATA': 'C:\\ProgramData', 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'PWD': 'C:\\slave\\test', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
15:11:26 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in C:\slave\test\build
15:11:26 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema
15:11:26 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
15:11:26 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
15:11:26 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
15:11:26 INFO - 'COMPUTERNAME': 'T-W732-IX-116',
15:11:26 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
15:11:26 INFO - 'CYGWINBASE': 'C:\\cygwin',
15:11:26 INFO - 'DCLOCATION': 'SCL3',
15:11:26 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
15:11:26 INFO - 'FP_NO_HOST_CHECK': 'NO',
15:11:26 INFO - 'HOMEDRIVE': 'C:',
15:11:26 INFO - 'HOMEPATH': '\\Users\\cltbld',
15:11:26 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
15:11:26 INFO - 'KTS_VERSION': '1.19c',
15:11:26 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
15:11:26 INFO - 'LOGONSERVER': '\\\\T-W732-IX-116',
15:11:26 INFO - 'MONDIR': 'C:\\Monitor_config\\',
15:11:26 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
15:11:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
15:11:26 INFO - 'MOZ_NO_REMOTE': '1',
15:11:26 INFO - 'NO_EM_RESTART': '1',
15:11:26 INFO - 'NUMBER_OF_PROCESSORS': '8',
15:11:26 INFO - 'OS': 'Windows_NT',
15:11:26 INFO - 'OURDRIVE': 'C:',
15:11:26 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;',
15:11:26 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
15:11:26 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
15:11:26 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
15:11:26 INFO - 'PROCESSOR_LEVEL': '6',
15:11:26 INFO - 'PROCESSOR_REVISION': '1e05',
15:11:26 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
15:11:26 INFO - 'PROGRAMFILES': 'C:\\Program Files',
15:11:26 INFO - 'PROMPT': '$P$G',
15:11:26 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
15:11:26 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
15:11:26 INFO - 'PUBLIC': 'C:\\Users\\Public',
15:11:26 INFO - 'PWD': 'C:\\slave\\test',
15:11:26 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
15:11:26 INFO - 'SLAVEDIR': 'C:\\slave\\',
15:11:26 INFO - 'SYSTEMDRIVE': 'C:',
15:11:26 INFO - 'SYSTEMROOT': 'C:\\windows',
15:11:26 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
15:11:26 INFO - 'TEST1': 'testie',
15:11:26 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
15:11:26 INFO - 'USERDOMAIN': 'T-W732-IX-116',
15:11:26 INFO - 'USERNAME': 'cltbld',
15:11:26 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
15:11:26 INFO - 'WINDIR': 'C:\\windows',
15:11:26 INFO - 'WINDOWS_TRACING_FLAGS': '3',
15:11:26 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
15:11:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
15:11:26 INFO - Ignoring indexes: https://pypi.python.org/simple/
15:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in c:\slave\test\build\venv\lib\site-packages
15:11:26 INFO - Cleaning up...
15:11:26 INFO - Return code: 0
15:11:26 INFO - Running post-action listener: _resource_record_post_action
15:11:26 INFO - Running post-action listener: _start_resource_monitoring
15:11:26 INFO - Starting resource monitoring.
15:11:26 INFO - [mozharness: 2016-09-21 22:11:26.546000Z] Finished create-virtualenv step (success)
15:11:26 INFO - [mozharness: 2016-09-21 22:11:26.546000Z] Running install step.
15:11:26 INFO - Running pre-action listener: _resource_record_pre_action
15:11:26 INFO - Running main action method: install
15:11:26 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze']
15:11:26 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze
15:11:26 INFO - Reading from file tmpfile_stdout
15:11:26 INFO - Using _rmtree_windows ...
15:11:26 INFO - Using _rmtree_windows ...
15:11:26 INFO - Detecting whether we're running mozinstall >=1.0...
15:11:26 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h']
15:11:26 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h
15:11:27 INFO - Reading from file tmpfile_stdout
15:11:27 INFO - Output received:
15:11:27 INFO - Usage: mozinstall-script.py [options] installer
15:11:27 INFO - Options:
15:11:27 INFO - -h, --help show this help message and exit
15:11:27 INFO - -d DEST, --destination=DEST
15:11:27 INFO - Directory to install application into. [default:
15:11:27 INFO - "C:\slave\test"]
15:11:27 INFO - --app=APP Application being installed. [default: firefox]
15:11:27 INFO - Using _rmtree_windows ...
15:11:27 INFO - Using _rmtree_windows ...
15:11:27 INFO - mkdir: C:\slave\test\build\application
15:11:27 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.win32.zip', '--destination', 'C:\\slave\\test\\build\\application']
15:11:27 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.win32.zip --destination C:\slave\test\build\application
15:11:29 INFO - Reading from file tmpfile_stdout
15:11:29 INFO - Output received:
15:11:29 INFO - C:\slave\test\build\application\firefox\firefox.exe
15:11:29 INFO - Using _rmtree_windows ...
15:11:29 INFO - Using _rmtree_windows ...
15:11:29 INFO - Running post-action listener: _resource_record_post_action
15:11:29 INFO - [mozharness: 2016-09-21 22:11:29.007000Z] Finished install step (success)
15:11:29 INFO - [mozharness: 2016-09-21 22:11:29.007000Z] Running run-tests step.
15:11:29 INFO - Running pre-action listener: _resource_record_pre_action
15:11:29 INFO - Running main action method: run_tests
15:11:29 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version']
15:11:29 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version
15:11:29 INFO - Python 2.7.3
15:11:29 INFO - Return code: 0
15:11:29 INFO - grabbing minidump binary from tooltool
15:11: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')]}
15:11:29 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 0x01913E90>, '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 0x0126A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x019C9520>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1
15:11:29 INFO - Running command: ['c:/mozilla-build/python27/python.exe', 'C:/mozilla-build/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', 'c:\\builds\\relengapi.tok', 'fetch', '-m', 'C:\\slave\\test\\build\\tests\\config/tooltool-manifests/win32/releng.manifest', '-o'] in C:\slave\test\build
15:11:29 INFO - Copy/paste: c:/mozilla-build/python27/python.exe C:/mozilla-build/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file c:\builds\relengapi.tok fetch -m C:\slave\test\build\tests\config/tooltool-manifests/win32/releng.manifest -o
15:11:29 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
15:11:29 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'...
15:11:30 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmp4avbyz
15:11:30 INFO - INFO - File integrity verified, renaming tmp4avbyz to win32-minidump_stackwalk.exe
15:11:30 INFO - Return code: 0
15:11:30 INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755
15:11:30 INFO - mkdir: C:\slave\test\build\blobber_upload_dir
15:11:30 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir
15:11:30 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe
15:11:30 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir
15:11:30 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DapT4v3yQqy0sxpfh59F3g/artifacts/public/build/firefox-52.0a1.en-US.win32.crashreporter-symbols.zip', '--title', 'T-W732-IX-116', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs_errorsummary.log', '--log-raw=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs_raw.log'] in C:\slave\test\build
15:11:30 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\tests\talos\talos\run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath C:\slave\test\build\application\firefox\firefox --symbolsPath https://queue.taskcluster.net/v1/task/DapT4v3yQqy0sxpfh59F3g/artifacts/public/build/firefox-52.0a1.en-US.win32.crashreporter-symbols.zip --title T-W732-IX-116 --webServer localhost --log-tbpl-level=debug --log-errorsummary=C:\slave\test\build\blobber_upload_dir\dromaeojs_errorsummary.log --log-raw=C:\slave\test\build\blobber_upload_dir\dromaeojs_raw.log
15:11:30 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
15:11:30 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
15:11:30 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
15:11:30 INFO - 'COMPUTERNAME': 'T-W732-IX-116',
15:11:30 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
15:11:30 INFO - 'CYGWINBASE': 'C:\\cygwin',
15:11:30 INFO - 'DCLOCATION': 'SCL3',
15:11:30 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
15:11:30 INFO - 'FP_NO_HOST_CHECK': 'NO',
15:11:30 INFO - 'HOMEDRIVE': 'C:',
15:11:30 INFO - 'HOMEPATH': '\\Users\\cltbld',
15:11:30 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
15:11:30 INFO - 'KTS_VERSION': '1.19c',
15:11:30 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
15:11:30 INFO - 'LOGONSERVER': '\\\\T-W732-IX-116',
15:11:30 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir',
15:11:30 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe',
15:11:30 INFO - 'MONDIR': 'C:\\Monitor_config\\',
15:11:30 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
15:11:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
15:11:30 INFO - 'MOZ_NO_REMOTE': '1',
15:11:30 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir',
15:11:30 INFO - 'NO_EM_RESTART': '1',
15:11:30 INFO - 'NUMBER_OF_PROCESSORS': '8',
15:11:30 INFO - 'OS': 'Windows_NT',
15:11:30 INFO - 'OURDRIVE': 'C:',
15:11:30 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;',
15:11:30 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
15:11:30 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
15:11:30 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
15:11:30 INFO - 'PROCESSOR_LEVEL': '6',
15:11:30 INFO - 'PROCESSOR_REVISION': '1e05',
15:11:30 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
15:11:30 INFO - 'PROGRAMFILES': 'C:\\Program Files',
15:11:30 INFO - 'PROMPT': '$P$G',
15:11:30 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
15:11:30 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
15:11:30 INFO - 'PUBLIC': 'C:\\Users\\Public',
15:11:30 INFO - 'PWD': 'C:\\slave\\test',
15:11:30 INFO - 'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos',
15:11:30 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
15:11:30 INFO - 'SLAVEDIR': 'C:\\slave\\',
15:11:30 INFO - 'SYSTEMDRIVE': 'C:',
15:11:30 INFO - 'SYSTEMROOT': 'C:\\windows',
15:11:30 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
15:11:30 INFO - 'TEST1': 'testie',
15:11:30 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
15:11:30 INFO - 'USERDOMAIN': 'T-W732-IX-116',
15:11:30 INFO - 'USERNAME': 'cltbld',
15:11:30 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
15:11:30 INFO - 'WINDIR': 'C:\\windows',
15:11:30 INFO - 'WINDOWS_TRACING_FLAGS': '3',
15:11:30 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
15:11:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
15:11:30 INFO - Calling ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DapT4v3yQqy0sxpfh59F3g/artifacts/public/build/firefox-52.0a1.en-US.win32.crashreporter-symbols.zip', '--title', 'T-W732-IX-116', '--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
15:11:31 INFO - mozversion application_buildid: 20160921123003
15:11:31 INFO - mozversion application_changeset: 6757959dbba2a80fa1f58ea4e677c65cb5cd9e15
15:11:31 INFO - mozversion application_display_name: Nightly
15:11:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384}
15:11:31 INFO - mozversion application_name: Firefox
15:11:31 INFO - mozversion application_remotingname: firefox
15:11:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team
15:11:31 INFO - mozversion application_vendor: Mozilla
15:11:31 INFO - mozversion application_version: 52.0a1
15:11:31 INFO - mozversion platform_buildid: 20160921123003
15:11:31 INFO - mozversion platform_changeset: 6757959dbba2a80fa1f58ea4e677c65cb5cd9e15
15:11:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team
15:11:31 INFO - mozversion platform_version: 52.0a1
15:11:31 INFO - using testdate: 1474495891
15:11:31 INFO - actual date: 1474495891
15:11:31 INFO - starting webserver on 'localhost:49634'
15:11:31 INFO - SUITE-START | Running 2 tests
15:11:31 INFO - TEST-START | dromaeo_css
15:11:31 INFO - operating with platform_type : w7_
15:11:31 INFO - Initialising browser for dromaeo_css test...
15:11:31 INFO - TEST-INFO | started process 384 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld\appdata\local\temp\tmphpe4lf\profile http://localhost:49634/getInfo.html)
15:11:38 INFO - PROCESS | 384 | __metrics Screen width/height:1600/1200
15:11:38 INFO - PROCESS | 384 | colorDepth:24
15:11:38 INFO - PROCESS | 384 | Browser inner width/height: 1010/674
15:11:38 INFO - PROCESS | 384 | __metrics
15:11:39 INFO - PROCESS | 384 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows"
15:11:39 INFO - PROCESS | 384 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver]
15:11:40 INFO - TEST-INFO | 384: exit 0
15:11:40 INFO - Browser initialized.
15:11:40 INFO - Running cycle 1/1 for dromaeo_css test...
15:11:40 INFO - TEST-INFO | started process 2420 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld\appdata\local\temp\tmphpe4lf\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1)
15:11:41 INFO - PROCESS | 2420 | [GFX1-]: Invalid size in UpdateRenderTarget Size(116,0), 0
15:11:52 INFO - PROCESS | 2420 | RSS: Main: 123637760
15:11:52 INFO - PROCESS | 2420 |
15:12:43 INFO - PROCESS | 2420 | 1474495963924 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no]
15:14:51 INFO - PROCESS | 2420 | Cycle 1(1): loaded http://localhost:49634/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49634/tests/dromaeo/cssquery-ext.html)
15:14:53 INFO - PROCESS | 2420 | RSS: Main: 285958144
15:14:53 INFO - PROCESS | 2420 |
15:17:56 INFO - PROCESS | 2420 | Cycle 1(1): loaded http://localhost:49634/tests/dromaeo/cssquery-ext.html (next: http://localhost:49634/tests/dromaeo/cssquery-jquery.html)
15:17:56 INFO - PROCESS | 2420 | RSS: Main: 197865472
15:17:56 INFO - PROCESS | 2420 |
15:20:58 INFO - PROCESS | 2420 | Cycle 1(1): loaded http://localhost:49634/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49634/tests/dromaeo/cssquery-mootools.html)
15:20:59 INFO - PROCESS | 2420 | RSS: Main: 152821760
15:20:59 INFO - PROCESS | 2420 |
15:24:01 INFO - PROCESS | 2420 | Cycle 1(1): loaded http://localhost:49634/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49634/tests/dromaeo/cssquery-prototype.html)
15:24:01 INFO - PROCESS | 2420 | RSS: Main: 147972096
15:24:01 INFO - PROCESS | 2420 |
15:27:04 INFO - PROCESS | 2420 | Cycle 1(1): loaded http://localhost:49634/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49634/tests/dromaeo/cssquery-yui.html)
15:27:05 INFO - PROCESS | 2420 | RSS: Main: 135503872
15:27:05 INFO - PROCESS | 2420 |
15:30:07 INFO - PROCESS | 2420 | Cycle 1(1): loaded http://localhost:49634/tests/dromaeo/cssquery-yui.html (next: http://localhost:49634/tests/dromaeo/cssquery-dojo.html)
15:30:07 INFO - PROCESS | 2420 | RSS: Main: 251109376
15:30:07 INFO - PROCESS | 2420 |
15:30:07 INFO - PROCESS | 2420 | __start_tp_report
15:30:07 INFO - PROCESS | 2420 | _x_x_mozilla_page_load
15:30:07 INFO - PROCESS | 2420 | _x_x_mozilla_page_load_details
15:30:07 INFO - PROCESS | 2420 | |i|pagename|runs|
15:30:07 INFO - PROCESS | 2420 | |0;dojo.html;2732.83602983821;2759.806813523053;2763.3229858684626;2773.77809775218;2784.3735159589082;4711.269753188257;4712.835050773219;4815.229563269878;4820.228763397853;4839.709617422957;4672.696274742139;4731.148393289207;4741.336212930192;4857.271409288608;4879.414470263565;4166.458360413149;4201.201771663389;4205.600467955554;4209.894752631193;4223.429836972015;4154.8961275968195;4174.561671024544;4196.39152322913;4223.746575205498;4224.38746381776;4172.770497622645;4175.958240417603;4177.101923086536;4218.915621687564;4253.340732186516;4212.726172798758;4250.3624456331645;4254.532001479834;4303.634191093761;4309.741415515048;4143.4199212110325;4176.812043458051;4193.329067349209;4215.156968606291;4255.319148936186;4669.906601867978;4689.531046895318;4708.0819240248165;4722.858314250578;4724.291356296549;4846.709197448165;4882.048000639877;4984.925226121611;4986.10250154972;5025.874353141164;4913.459519452857;4952;4960.578350840183;4977.601791856643;5061.16490779021;4592.15045216636;4599.724016559017;4639.350490931272;4639.884002899921;4670.6497012724185;5001.674891132065;5005.72468514228;5040.168372218543;5093.337866077386;5108.744562771846;4765.285207218945;4802.73584952831;4823.059503396804;4922.852314430573;4926.531979461945;4848.224284114524;4907.312976183337;4924.03981223658;4935.728534930541;4941.876453088702;4901.215805471179;4907.288443175719;4994.825181118644;5006.6245031622775;5011.473795251519;4879.707217566886;4991.101601711654;4991.4758950310425;4996.6752161110135;5006.674566153261;3296.1430028192362;3325.916852078669;3329.9167520812175;3333.666633336647;3375.578052743407;3057.7400920921973;3065.26433655921;3111.051129405553;3112.859921303547;3118.828464434478;4774;4786.7845946932475;4822.228443449031;4880.072786170687;4887.486813884491;4893.168161412568;4990.3762029746285;5049.469805670426;5100.005498927673;5133.922991155136;4784.712917224978;4816.783244753994;4819.6867203631655;4856.660033797671;4867.5132486751045;4096.078382363944;4130.772807495557;4199.454070970754;4214.115035842446;4219.2194444027955;5144.511271429208;5192.558632516203;5295.364556253275;5429.592780541396;5431.83704488866;4965.4289756678445;4983.601311894967;4985.875353116201;4988.9251661225835;5008.6744361616375;5368.489993450616;5382.838514844561;5392;5393.379761327497;5402.216678581663;4926.3842019747535;4982.227754698028;4987.1521841287795;4999.675021123615;5002.874928126826;5011.7494125294315;5024.171011783015;5068.695878247317;5076.6446348755235;5084.313617661716;4802.423709154924;4907.263910413467;4932.8026878925875;4949.059678661043;4966.975165124151;4904.828331008398;4913.77887995034;4926.950730492649;4946.530079642428;4947.356843610308;4764.3568118304975;4816.95183048179;4870.683405578626;4898;4898.951010489992;4805.711657300433;4848.200046992207;4991.900161996812;5020.849374518771;5025.120603894377;4592.242280023758;4774.95225047745;4829.082474329866;4847.345608342828;4914.164592019294
15:30:07 INFO - PROCESS | 2420 | |1;ext.html;510.17097217022337;528.0468753899213;531.0626743797201;547.2639300141309;563.0849868962932;27906.44187116259;29699.960501382455;37787.433188502124;37870.24259514811;38810.417843732364;38693.806530967304;39234.803825980904;39508.407373889415;39529.40705889414;39559.60440395595;7919.406044546653;8288.875666865002;8425.915740842605;8435.367347448935;8453.408261421702;8280.378971577125;8350.457220280692;8357.791055223637;8363.707270245543;8363.749087527354;8332.916670833305;8377.246047855691;8385.958070209641;8409.537475438849;8411.074781774;8324.958375208116;8342.457740246864;8350.206730360605;8362.372822038371;8370;8225.383096267744;8282;8292.958535207346;8294.294984926288;8305.46014509055;37131.62868371309;37271.62728372736;37506.43740343897;37533;37571.81214093912;2950.7049295070537;2976.7320941115404;2989.5216765317664;2997.385535965144;3057.0828751374497;29020.564691529646;29279.414411711645;29302.560461593093;29844.55233171504;29913.25216869574;3563.928721425583;3577.481265216529;3628.981855090734;3647.7993710345922;3771.358868992278;343293;372065;494192;526559.3672031653;526999;49012.509874900796;50142.74928625333;50273.24590131151;50326.74836625793;50330;26773.598396024074;50453.74773126184;51118;51171.48828511742;51578.74210628923;13298.933505332412;13665.726685466236;13668.658283542793;13686;13693.657658558615;9982.101610854912;9991.700248992542;10009.399436033862;10021.09810117093;10031.398116113056;15269.465568705264;15561.922190388976;15825.446109386115;15859;15959.122248276457;5998.890205312031;6236.6258024518675;6305.274893387227;6317.6209427434505;6331.96834015827;725.7858931615186;804.9114597394282;816.542736067804;822.2805045585113;910.39003867409;26348.8682556586;27024.864875675496;27451.588226176624;27473.587896181572;27479.31301717473;729.6205972894065;847.4110493207162;866.991330086691;880.9735707928772;986.7039888033705;13397.933010334886;13930.512432065032;14030.859691402955;14066.859331406555;14109.365078571489;545121;555656;557134;557709;558375;41078.794606027375;45450.545494545295;45899;46085.769571151926;46340;1010.7624708193568;1066;1086.32104934416;1087.6791346552786;1094.4473041114186;26498.205053847643;27196.32009199786;27426.5886011706;27559.448811024067;27681;40716.79641601773;41119.177616448105;41386.379204312565;41412.1717565653;41527.754167375024;434554;437267;437829;438019;438439;21486;21819.45451363665;21827.781722183212;21835.344939651837;21935.341939741833;39777.80111099426;39937;40356.59643403528;40616.390754139305;41106.383404248365;33637.83181084079;34570;35560.93317200488;36027.63972360243;36038.63961360458;33705.83147084249;35105.82447087748;36059.63940360563;36278;37328.62671373251;32522.18694532561;32735;32787.83606081954;33577;33591;30121.09636710902;31935.520967185046;32285.977446416757;32450.513242300913;32899.67100328966;23924.40188995289;24018.69485541943;24259.272221833373;24574.754252457245;24631
15:30:08 INFO - PROCESS | 2420 | |2;jquery.html;273.14914042756817;291.26455699359116;295.9985200073999;299.80962089073444;300.7158235467484;13414;17001.914990425063;17138.742918856227;17772.822271777295;18780.71828922567;16302.429414970478;16545.91727041366;16707.49877503677;16941.152942352895;16964.83035169648;5278.3665960084845;5317.574594032488;5425.945740542603;5491.807786727465;5496.7526461309335;5065.062963351773;5131;5370.8925821483745;5380.91928621071;5390.326209223847;5221.660592061523;5345.812896548621;5348.759305831228;5349.732513374335;5350.30446042014;5131.1277082895995;5322.414534401213;5324.5740340772645;5375.704336261504;5407.783688652449;5242.55438287746;5249.606279529013;5250.921236181461;5255.76349064293;5284.947150528484;10410.323328983592;10892.237543371966;11006.614768483065;11240.100791936626;11241;1762.9647407051916;1862.7764668239897;1897.3548993342192;1945.0760888577954;2084.1871670048695;8432.072472028072;8816.735497935008;8843.380963332569;8897.955510222408;12562.680918503516;1661.5098545928859;1709.367534012411;1731.9740203896952;1739.391213075426;1833.9358122465783;81603.18396816016;83698.58150709269;84014.15985840124;84142.15857841405;94762.52618736931;8983.281337492985;9004.279657627374;9042.773930651654;9164;9217.539123043822;11703.180777345504;11709.531618735155;11714.531418743325;11714.88285117155;11717.589884354176;7039.894401583981;7090;7188.17336006366;7239.782806515813;7291.380232680175;7212;7260.346568808727;7287.27127287267;7338.991013684364;7414.814629634195;3588.4258518636893;3595.137167079882;3650.6166852480105;3658.122050707864;3698.981505092457;1462.020446300981;1501.3394106593064;1507.2614418934643;1511.7581187010026;1511.8488151184793;713.6146480900255;775.2247752247753;817.5912043978011;845.6701886264361;885.964561417549;17542.386016489363;17800.287988480315;17876.016819075077;18017.2793088275;18053.09734513269;776.5224387001953;781.1563511407666;805.6133056132971;828.1097819843692;861.6424183963585;9026.86459703105;9667.323287369958;9782.755431114138;10002.149817265614;10218.080372766486;407959;450907;457282;495113;499117;78919;102633;105501;107384;108404.45797770961;759.2028370211256;858.8411143938391;866.3502373220211;867.089555966233;869.8173383589391;16040.518784436486;16099.195040248174;16205.513834584981;16551;16603.409903823052;44763.77618111888;44894.102117958115;44936.77531612321;45603.08793824171;47813.760931195124;64407.677961609894;65852;66685.33314666791;67641.32358676351;68088.97866532105;6994.755183568551;7069.797970255051;7085.043519125058;7198.71205151788;7229.385502232159;11827.586034488751;11869.228500147463;12270.263784172977;12411.689707757378;12537.304479536944;9845.45849978258;9949.104580587493;10615.203859710708;10645;10732.302400343953;10337.121344685786;10504.369737815756;10615.256932014685;10704.411257380918;10771.569137234736;10598.2581219317;10811.243212975016;10836.891631083588;11003.889961100287;11320.207585468937;6804.285550017375;6861.245263021164;6873.725050998104;7235.602041887747;7288.817779555554;7551.773446796605;10375.792484150426;10431.843522347019;10521.473926303808;10915.890841091805
15:30:08 INFO - PROCESS | 2420 | |3;mootools.html;1103.5199688135663;1108.0415440643847;1196.91023173262;1333.9666508337284;1431.3988124987504;6789.083473731045;7232.0959880015;7237.167725711544;7243.239459856705;7246.746363877259;6370.203724534434;6601.009848522724;6772.153480814898;7022.613756243404;7116.430685545157;1885.849132069438;1913.23470611755;1916.9424917252504;1918.4052943587533;1920.0879582198413;1877.5681593233564;1889.187649310796;1908.7709474862966;1911.560341121543;1931.3723040011982;1720.8623310135222;1771.4419957713344;1874.7375367448567;1902.2010755482731;1952.326447375653;1912.5218695326098;1925.5474963383663;1926.094735474339;1928.3154480159621;1928.5757133430623;1855.2208072609537;1865.6268746250669;1869.401791426744;1869.9439016829517;1873.7470441490498;6834.4874134440115;6842.589444633338;6969.23338432772;6973.965130174367;6989.0564773755905;4121.773302468363;4209.410682504452;4212.368144778277;4222.725522841006;4223.1975924574235;2812.8171668841665;2835.8723857426467;2890.3496713239565;2916.1543152485756;2931.384409274055;882.6116508736136;906.5739102621757;915.3226612306911;918.6646873891049;921.1157289002499;9009.954950225207;9100.36297459178;9134.954325228331;9135.040820713863;9139.588718507683;3479.2171761353493;3665.7983810890655;3701.833417496219;3710.3135919854913;3719.08882323827;7870;7991.081025682005;7998.4001199910235;8001.8799718004275;8017.118117007125;4253.595908388698;4257.701960862772;4258.978705106517;4267.850625228102;4274.444322238089;3854.2676891390547;3914.8042597869994;3918.8824335269987;3923.9803800981385;3948.368261078271;3014.728674419313;3052.2979714665307;3084.568160457538;3111.766617503696;3124.8593813278003;987.2496902354262;987.7728122531857;998.6904059741504;1001.2090448545713;1009.3035805294323;682.1643486728717;756.6368143291251;763.8128658478709;767.056520479813;783.9690806589317;4533.977330113328;4546.272596384562;4549.772511374485;4555.589996900295;4655.720656760605;343.01725556281076;345.0889651320516;348.1140497433986;349.57875759709486;353.28636154967336;3133.8903138390046;3154.8264845433264;3197.31128427814;3208.278137419062;3256.77202595816;8366.707165249187;8427.789305267417;8595.14048595148;8636.481811091355;8638.827223455495;8351.95824020876;8561.82876342482;8592.312614990786;8607.440516366416;8607.61265743043;6540.771073012422;6547.541672082908;6693.364130407604;6707.0610114584;6722.193336799518;4515.616172625364;4574.290984897346;4582.404287442744;4582.977085114687;4711.104890070876;7937.2459616336355;8004.479708818908;8013.318867896294;8036.959815200887;8041.597920103854;8015.158408367038;8136.471129376571;8165;8212.17878212174;8221.876671850046;6036;6139.293981192041;6140.8771824564155;6142.262928448615;6145.10895920098;6803.523753337219;6838.794836154923;6871.622060786704;6874.828129296808;6880.105586273752;6324.146240257506;6337.619742815262;6374.394432528902;6467.126937863328;6500.284968653539;6007.969960150172;6031.547633927561;6133.264008318852;6252.874942501216;6259.3427690091885;5806.883862322815;5828.883422331614;5870.677112758668;5871.706414679164;5883.676397798162;3941.172353805733;3942.7634341939574;3973.9602603974745;3989.9601003989587;4064.4106604541585;3903.394973779069;3967.7420967637013;4075.694322925852;4150.584941505826;4161.8335266589
15:30:08 INFO - PROCESS | 2420 | |4;prototype.html;231.79022984199307;247.35810571566785;248.76118925831202;250.01992190612785;250.48900243503255;5000.549950504454;5111.616628752845;5184.559312458446;5252.264682944381;5270.762815673294;5041.924371134427;5042.647014708972;5051.696898186102;5123.719944624634;5167.870803229921;3690.778553286798;3720.9255814883686;3756.812159392033;3778.981105094471;3789.2232092421127;3686.7234957378305;3705.4997575327257;3709.9072523186865;3764.661180493755;3788.049154685339;3738.3084129436006;3745.8688945886897;3747.1194269346684;3752.9437058444146;3753.5120434343635;3671.229041901204;3684.797336146511;3722.6463485968925;3734.0478178064554;3757.6430239127376;3224.7581431392505;3230.8061516308862;3231.353729254135;3232.046546268856;3234.644189139193;4983.875403114915;5037.596992240648;5051.848444546669;5054.064997975386;5070.3887497938595;3950.249452603996;4142.958570414287;4168.895777605554;4236.872893813191;4263.211305908386;5195.844124676266;5205.24523944026;5284.339457567804;5303.15149576066;5310.389305229909;3276.639569647337;3363.4954756786433;3445.9310813783586;3454.464557993515;3456.3605732939486;5440.292761940962;5443.265159203536;5555.555555555544;5570.303712035955;5571.9721401393135;3461.8961431157104;3464.272502774395;3471.1842716961496;3473.3400653875683;3497.370473314828;3518.261165155346;3575.3028159509167;3591.9102022449647;3594.6405359464366;3613.4941108244866;4282.272013757669;4283.22901877665;4287.421198138274;4289.270823959934;4292.613664770186;5175.275461435402;5341.813036543703;5356.1697936819855;5367.5169234769055;5395.946040539544;1238.4798384678277;1242.0374209987333;1249.3003917805877;1249.5064449542563;1255.2844878419396;754.0461316434714;770.4760762681318;772.142921357293;777.8405426887588;780.7391063432516;4615.799892028097;4630.83792067276;4635.466921304026;4756.619470442356;4771.570558649738;4814.277858321279;4837.201861692852;4870.050340183701;4940.1601727706375;4948.8762780930765;4751.524847515221;4753.382060332135;5048.697078175322;5160.561352285098;5178.715170665574;2645.629611854303;2811.1707046421357;2812.0860720265996;2870.425914817045;2880.5247134223036;5749.1663708762;5754.683492407958;5794.971025144931;5873.588848780544;5912.408759124053;5494.450554944474;5572.498475137176;5582.041517995469;5629.662220266797;5636.379998200195;5496.532794712334;5807.622504537191;5813.040848260074;5903.2325797646035;5917.733701983335;5445.319335083114;5453.754581043783;5525.834224973257;5583.553315734813;5588.6646801192055;5472.945270547243;5490.972545137249;5496.7526461308535;5502.174673798802;5502.2296878436255;5826.76692932278;5828.6211396259105;5929.318128415115;5987.820365389045;5988.910166347421;3406.540117084162;3555.3422616814937;3562.7684200526883;3589.192431702846;3594.3889538778994;5520.205933071848;5541.307336582927;5565.0817615094675;5565.359983601776;5572.582056345709;5245.265662807286;5259.342582177228;5266.578673706018;5357.491038351351;5388.353397592314;5196.7401629917595;5364.6512976656395;5387.973060134675;5389.326334208224;5396.4333744957785;5221.608379371486;5221.98953402935;5239.371275446971;5241.266222728745;5242.16125419931;5221.068204764261;5359.651622644516;5360.65155764874;5377.166539186433;5379.784808607612;5195.246689230116;5346.625736198429;5350.117230657053;5362.356517217802;5374.301340825824
15:30:08 INFO - PROCESS | 2420 | |5;yui.html;592.6621825559428;631.939965703258;652.3215855510269;657.158836689038;666.3702800853195;14889.181095039768;15113.168775717331;15496.527829856173;15507.52678495544;15507.534773956786;13653.863461365383;13683.04218704691;13800.585982420518;13803.102798318127;13824.447022119102;470.0340799656704;475.2538514532186;571.4913726783167;585.3561082808898;591.6893630843798;551.2090150633833;564.2861779848495;566.7223060700269;568.4060157135782;582.548524893207;589.3693747689973;599.2359741329817;603.7222877476344;605.8545948972237;609.9390060993909;480.1022088694164;487.6440198654966;590.0176206616001;592.046804644522;595.3391735173954;432.3773765777271;438.2484039871604;441.53638679386836;442.287916454508;442.4005472584666;13572.253526056063;13653.317334133253;13682.931585342109;13683;13694.794578081337;12476.376181190995;12499;12530.498780048787;12872.485100595964;13071.54249601269;12476.18904771196;12828.422720977578;13091.47634094635;13245.933770331087;13286.53497127596;4213.094184750294;4229.72506787061;4243.533211346749;4268.210381079511;4325.4593175853015;68559;70310.29689703089;72394.63802681006;77552.61223693902;77713;9749.951250243703;9868.259880508991;9938.304318697621;9966.551505182284;10073.496325183858;17461.563460913578;18020.189091490913;18047.187876545326;18048.27806887736;18061.367852125113;7289.854202916018;7332.96333518329;7387.113546374362;7556.924430755622;7560.281773231534;3877.418387241936;3886.3393223152134;3906.3554513505524;3934.429507721364;3967.305721498726;3004.9549256761165;3021.6676165621766;3031.439183751013;3112.206387371206;3123.250419899208;522.9816956406507;531.3889027618193;532.5047705633721;535.5849216856889;536.227831922031;625.2715586341951;667.7762949411904;673.6530686696356;675.8780424495314;677.1332694151494;8973.775655608531;9434.481103539234;9543.522823858919;9793;9919.454430006419;540.8891177308642;562.7608266486727;628.7359309090193;668.4051194436955;676.3946268090032;4553.681242313072;4597.678162528658;4621.653375996813;4713.2458806590785;4726.95273047272;83289;116004;117104.41447792877;117431;121015;82729.58635206785;107235;107407;108620;111386;74112;91435.54282228547;92993;94108.52945735227;95420.52289738508;8893.599788009684;8943.463392196489;9230.169284764403;9390.765230869283;9419.670311539063;46879.29681054719;47600.523994759606;49447.50552494573;49528.75235623943;49748.751256243486;69301.30698692948;70553.64723176352;70659.64670176616;71761.28238717755;71845.28154718385;12628.242305461701;12664.936675316565;12673.746525069262;12690.365481725692;13046;15138.243087845784;15270.465533706267;15382.38470461169;15482;15676.372945082068;13447.476725137025;14086.859131408555;14426.85573144255;14494.34775435129;14881.627959301104;14154.646133846736;14328.49850255236;14409.42362305496;14421.7836732447;14784;12838.101332906606;13344.266065366499;13711.245881476614;13805.702680100323;13858.861411385757;11320.886791131983;11724.765504690029;12161.81757273624;12575.559855405018;12798.872011279767;11824.233559210708;11962.282263064244;12059.51761929513;12154.878451215374;12335.136540442083
15:30:08 INFO - PROCESS | 2420 | __end_tp_report
15:30:08 INFO - PROCESS | 2420 | __start_cc_report
15:30:08 INFO - PROCESS | 2420 | _x_x_mozilla_cycle_collect,1637
15:30:08 INFO - PROCESS | 2420 | __end_cc_report
15:30:08 INFO - PROCESS | 2420 | __startTimestamp1474497007993__endTimestamp
15:30:08 INFO - PROCESS | 2420 |
15:30:08 INFO - PROCESS | 2420 | ------- Summary: start -------
15:30:08 INFO - PROCESS | 2420 | Number of tests: 6
15:30:08 INFO - PROCESS | 2420 |
15:30:08 INFO - PROCESS | 2420 | [#0] dojo.html Cycles:165 Average:4629.97 Median:4848.22 stddev:593.18 (12.2%) stddev-sans-first:576.02
15:30:08 INFO - PROCESS | 2420 | Values: 2732.8 2759.8 2763.3 2773.8 2784.4 4711.3 4712.8 4815.2 4820.2 4839.7 4672.7 4731.1 4741.3 4857.3 4879.4 4166.5 4201.2 4205.6 4209.9 4223.4 4154.9 4174.6 4196.4 4223.7 4224.4 4172.8 4176.0 4177.1 4218.9 4253.3 4212.7 4250.4 4254.5 4303.6 4309.7 4143.4 4176.8 4193.3 4215.2 4255.3 4669.9 4689.5 4708.1 4722.9 4724.3 4846.7 4882.0 4984.9 4986.1 5025.9 4913.5 4952.0 4960.6 4977.6 5061.2 4592.2 4599.7 4639.4 4639.9 4670.6 5001.7 5005.7 5040.2 5093.3 5108.7 4765.3 4802.7 4823.1 4922.9 4926.5 4848.2 4907.3 4924.0 4935.7 4941.9 4901.2 4907.3 4994.8 5006.6 5011.5 4879.7 4991.1 4991.5 4996.7 5006.7 3296.1 3325.9 3329.9 3333.7 3375.6 3057.7 3065.3 3111.1 3112.9 3118.8 4774.0 4786.8 4822.2 4880.1 4887.5 4893.2 4990.4 5049.5 5100.0 5133.9 4784.7 4816.8 4819.7 4856.7 4867.5 4096.1 4130.8 4199.5 4214.1 4219.2 5144.5 5192.6 5295.4 5429.6 5431.8 4965.4 4983.6 4985.9 4988.9 5008.7 5368.5 5382.8 5392.0 5393.4 5402.2 4926.4 4982.2 4987.2 4999.7 5002.9 5011.7 5024.2 5068.7 5076.6 5084.3 4802.4 4907.3 4932.8 4949.1 4967.0 4904.8 4913.8 4927.0 4946.5 4947.4 4764.4 4817.0 4870.7 4898.0 4899.0 4805.7 4848.2 4991.9 5020.8 5025.1 4592.2 4775.0 4829.1 4847.3 4914.2
15:30:08 INFO - PROCESS | 2420 |
15:30:08 INFO - PROCESS | 2420 | [#1] ext.html Cycles:180 Average:59872.12 Median:38752.11 stddev:129939.60 (335.3%) stddev-sans-first:130227.68
15:30:08 INFO - PROCESS | 2420 | Values: 510.2 528.0 531.1 547.3 563.1 27906.4 29700.0 37787.4 37870.2 38810.4 38693.8 39234.8 39508.4 39529.4 39559.6 7919.4 8288.9 8425.9 8435.4 8453.4 8280.4 8350.5 8357.8 8363.7 8363.7 8332.9 8377.2 8386.0 8409.5 8411.1 8325.0 8342.5 8350.2 8362.4 8370.0 8225.4 8282.0 8293.0 8294.3 8305.5 37131.6 37271.6 37506.4 37533.0 37571.8 2950.7 2976.7 2989.5 2997.4 3057.1 29020.6 29279.4 29302.6 29844.6 29913.3 3563.9 3577.5 3629.0 3647.8 3771.4 343293.0 372065.0 494192.0 526559.4 526999.0 49012.5 50142.7 50273.2 50326.7 50330.0 26773.6 50453.7 51118.0 51171.5 51578.7 13298.9 13665.7 13668.7 13686.0 13693.7 9982.1 9991.7 10009.4 10021.1 10031.4 15269.5 15561.9 15825.4 15859.0 15959.1 5998.9 6236.6 6305.3 6317.6 6332.0 725.8 804.9 816.5 822.3 910.4 26348.9 27024.9 27451.6 27473.6 27479.3 729.6 847.4 867.0 881.0 986.7 13397.9 13930.5 14030.9 14066.9 14109.4 545121.0 555656.0 557134.0 557709.0 558375.0 41078.8 45450.5 45899.0 46085.8 46340.0 1010.8 1066.0 1086.3 1087.7 1094.4 26498.2 27196.3 27426.6 27559.4 27681.0 40716.8 41119.2 41386.4 41412.2 41527.8 434554.0 437267.0 437829.0 438019.0 438439.0 21486.0 21819.5 21827.8 21835.3 21935.3 39777.8 39937.0 40356.6 40616.4 41106.4 33637.8 34570.0 35560.9 36027.6 36038.6 33705.8 35105.8 36059.6 36278.0 37328.6 32522.2 32735.0 32787.8 33577.0 33591.0 30121.1 31935.5 32286.0 32450.5 32899.7 23924.4 24018.7 24259.3 24574.8 24631.0
15:30:08 INFO - PROCESS | 2420 |
15:30:08 INFO - PROCESS | 2420 | [#2] jquery.html Cycles:180 Average:27772.24 Median:252547.88 stddev:77241.45 (30.6%) stddev-sans-first:77430.54
15:30:08 INFO - PROCESS | 2420 | Values: 273.1 291.3 296.0 299.8 300.7 13414.0 17001.9 17138.7 17772.8 18780.7 16302.4 16545.9 16707.5 16941.2 16964.8 5278.4 5317.6 5425.9 5491.8 5496.8 5065.1 5131.0 5370.9 5380.9 5390.3 5221.7 5345.8 5348.8 5349.7 5350.3 5131.1 5322.4 5324.6 5375.7 5407.8 5242.6 5249.6 5250.9 5255.8 5284.9 10410.3 10892.2 11006.6 11240.1 11241.0 1763.0 1862.8 1897.4 1945.1 2084.2 8432.1 8816.7 8843.4 8898.0 12562.7 1661.5 1709.4 1732.0 1739.4 1833.9 81603.2 83698.6 84014.2 84142.2 94762.5 8983.3 9004.3 9042.8 9164.0 9217.5 11703.2 11709.5 11714.5 11714.9 11717.6 7039.9 7090.0 7188.2 7239.8 7291.4 7212.0 7260.3 7287.3 7339.0 7414.8 3588.4 3595.1 3650.6 3658.1 3699.0 1462.0 1501.3 1507.3 1511.8 1511.8 713.6 775.2 817.6 845.7 886.0 17542.4 17800.3 17876.0 18017.3 18053.1 776.5 781.2 805.6 828.1 861.6 9026.9 9667.3 9782.8 10002.1 10218.1 407959.0 450907.0 457282.0 495113.0 499117.0 78919.0 102633.0 105501.0 107384.0 108404.5 759.2 858.8 866.4 867.1 869.8 16040.5 16099.2 16205.5 16551.0 16603.4 44763.8 44894.1 44936.8 45603.1 47813.8 64407.7 65852.0 66685.3 67641.3 68089.0 6994.8 7069.8 7085.0 7198.7 7229.4 11827.6 11869.2 12270.3 12411.7 12537.3 9845.5 9949.1 10615.2 10645.0 10732.3 10337.1 10504.4 10615.3 10704.4 10771.6 10598.3 10811.2 10836.9 11003.9 11320.2 6804.3 6861.2 6873.7 7235.6 7288.8 7551.8 10375.8 10431.8 10521.5 10915.9
15:30:08 INFO - PROCESS | 2420 |
15:30:08 INFO - PROCESS | 2420 | [#3] mootools.html Cycles:180 Average:4589.62 Median:4683.41 stddev:2587.37 (55.2%) stddev-sans-first:2581.36
15:30:08 INFO - PROCESS | 2420 | Values: 1103.5 1108.0 1196.9 1334.0 1431.4 6789.1 7232.1 7237.2 7243.2 7246.7 6370.2 6601.0 6772.2 7022.6 7116.4 1885.8 1913.2 1916.9 1918.4 1920.1 1877.6 1889.2 1908.8 1911.6 1931.4 1720.9 1771.4 1874.7 1902.2 1952.3 1912.5 1925.5 1926.1 1928.3 1928.6 1855.2 1865.6 1869.4 1869.9 1873.7 6834.5 6842.6 6969.2 6974.0 6989.1 4121.8 4209.4 4212.4 4222.7 4223.2 2812.8 2835.9 2890.3 2916.2 2931.4 882.6 906.6 915.3 918.7 921.1 9010.0 9100.4 9135.0 9135.0 9139.6 3479.2 3665.8 3701.8 3710.3 3719.1 7870.0 7991.1 7998.4 8001.9 8017.1 4253.6 4257.7 4259.0 4267.9 4274.4 3854.3 3914.8 3918.9 3924.0 3948.4 3014.7 3052.3 3084.6 3111.8 3124.9 987.2 987.8 998.7 1001.2 1009.3 682.2 756.6 763.8 767.1 784.0 4534.0 4546.3 4549.8 4555.6 4655.7 343.0 345.1 348.1 349.6 353.3 3133.9 3154.8 3197.3 3208.3 3256.8 8366.7 8427.8 8595.1 8636.5 8638.8 8352.0 8561.8 8592.3 8607.4 8607.6 6540.8 6547.5 6693.4 6707.1 6722.2 4515.6 4574.3 4582.4 4583.0 4711.1 7937.2 8004.5 8013.3 8037.0 8041.6 8015.2 8136.5 8165.0 8212.2 8221.9 6036.0 6139.3 6140.9 6142.3 6145.1 6803.5 6838.8 6871.6 6874.8 6880.1 6324.1 6337.6 6374.4 6467.1 6500.3 6008.0 6031.5 6133.3 6252.9 6259.3 5806.9 5828.9 5870.7 5871.7 5883.7 3941.2 3942.8 3974.0 3990.0 4064.4 3903.4 3967.7 4075.7 4150.6 4161.8
15:30:08 INFO - PROCESS | 2420 |
15:30:08 INFO - PROCESS | 2420 | [#4] prototype.html Cycles:180 Average:4383.91 Median:5062.23 stddev:1398.80 (27.6%) stddev-sans-first:1367.57
15:30:08 INFO - PROCESS | 2420 | Values: 231.8 247.4 248.8 250.0 250.5 5000.5 5111.6 5184.6 5252.3 5270.8 5041.9 5042.6 5051.7 5123.7 5167.9 3690.8 3720.9 3756.8 3779.0 3789.2 3686.7 3705.5 3709.9 3764.7 3788.0 3738.3 3745.9 3747.1 3752.9 3753.5 3671.2 3684.8 3722.6 3734.0 3757.6 3224.8 3230.8 3231.4 3232.0 3234.6 4983.9 5037.6 5051.8 5054.1 5070.4 3950.2 4143.0 4168.9 4236.9 4263.2 5195.8 5205.2 5284.3 5303.2 5310.4 3276.6 3363.5 3445.9 3454.5 3456.4 5440.3 5443.3 5555.6 5570.3 5572.0 3461.9 3464.3 3471.2 3473.3 3497.4 3518.3 3575.3 3591.9 3594.6 3613.5 4282.3 4283.2 4287.4 4289.3 4292.6 5175.3 5341.8 5356.2 5367.5 5395.9 1238.5 1242.0 1249.3 1249.5 1255.3 754.0 770.5 772.1 777.8 780.7 4615.8 4630.8 4635.5 4756.6 4771.6 4814.3 4837.2 4870.1 4940.2 4948.9 4751.5 4753.4 5048.7 5160.6 5178.7 2645.6 2811.2 2812.1 2870.4 2880.5 5749.2 5754.7 5795.0 5873.6 5912.4 5494.5 5572.5 5582.0 5629.7 5636.4 5496.5 5807.6 5813.0 5903.2 5917.7 5445.3 5453.8 5525.8 5583.6 5588.7 5472.9 5491.0 5496.8 5502.2 5502.2 5826.8 5828.6 5929.3 5987.8 5988.9 3406.5 3555.3 3562.8 3589.2 3594.4 5520.2 5541.3 5565.1 5565.4 5572.6 5245.3 5259.3 5266.6 5357.5 5388.4 5196.7 5364.7 5388.0 5389.3 5396.4 5221.6 5222.0 5239.4 5241.3 5242.2 5221.1 5359.7 5360.7 5377.2 5379.8 5195.2 5346.6 5350.1 5362.4 5374.3
15:30:08 INFO - PROCESS | 2420 |
15:30:08 INFO - PROCESS | 2420 | [#5] yui.html Cycles:180 Average:20409.17 Median:439.89 stddev:29961.96 (6811.2%) stddev-sans-first:30009.07
15:30:08 INFO - PROCESS | 2420 | Values: 592.7 631.9 652.3 657.2 666.4 14889.2 15113.2 15496.5 15507.5 15507.5 13653.9 13683.0 13800.6 13803.1 13824.4 470.0 475.3 571.5 585.4 591.7 551.2 564.3 566.7 568.4 582.5 589.4 599.2 603.7 605.9 609.9 480.1 487.6 590.0 592.0 595.3 432.4 438.2 441.5 442.3 442.4 13572.3 13653.3 13682.9 13683.0 13694.8 12476.4 12499.0 12530.5 12872.5 13071.5 12476.2 12828.4 13091.5 13245.9 13286.5 4213.1 4229.7 4243.5 4268.2 4325.5 68559.0 70310.3 72394.6 77552.6 77713.0 9750.0 9868.3 9938.3 9966.6 10073.5 17461.6 18020.2 18047.2 18048.3 18061.4 7289.9 7333.0 7387.1 7556.9 7560.3 3877.4 3886.3 3906.4 3934.4 3967.3 3005.0 3021.7 3031.4 3112.2 3123.3 523.0 531.4 532.5 535.6 536.2 625.3 667.8 673.7 675.9 677.1 8973.8 9434.5 9543.5 9793.0 9919.5 540.9 562.8 628.7 668.4 676.4 4553.7 4597.7 4621.7 4713.2 4727.0 83289.0 116004.0 117104.4 117431.0 121015.0 82729.6 107235.0 107407.0 108620.0 111386.0 74112.0 91435.5 92993.0 94108.5 95420.5 8893.6 8943.5 9230.2 9390.8 9419.7 46879.3 47600.5 49447.5 49528.8 49748.8 69301.3 70553.6 70659.6 71761.3 71845.3 12628.2 12664.9 12673.7 12690.4 13046.0 15138.2 15270.5 15382.4 15482.0 15676.4 13447.5 14086.9 14426.9 14494.3 14881.6 14154.6 14328.5 14409.4 14421.8 14784.0 12838.1 13344.3 13711.2 13805.7 13858.9 11320.9 11724.8 12161.8 12575.6 12798.9 11824.2 11962.3 12059.5 12154.9 12335.1
15:30:08 INFO - PROCESS | 2420 | -------- Summary: end --------
15:30:08 INFO - PROCESS | 2420 |
15:30:08 INFO - TEST-INFO | 2420: exit 0
15:30:09 INFO - TEST-OK | dromaeo_css | took 1118028ms
15:30:09 INFO - TEST-START | kraken
15:30:09 INFO - operating with platform_type : w7_
15:30:09 INFO - Initialising browser for kraken test...
15:30:09 INFO - TEST-INFO | started process 3116 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld\appdata\local\temp\tmpr8ib7s\profile http://localhost:49634/getInfo.html)
15:30:13 INFO - PROCESS | 3116 | __metrics Screen width/height:1600/1200
15:30:13 INFO - PROCESS | 3116 | colorDepth:24
15:30:13 INFO - PROCESS | 3116 | Browser inner width/height: 1010/674
15:30:13 INFO - PROCESS | 3116 | __metrics
15:30:14 INFO - PROCESS | 3116 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows"
15:30:14 INFO - PROCESS | 3116 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver]
15:30:14 INFO - PROCESS | 3116 | console.error:
15:30:14 INFO - PROCESS | 3116 | Message: Error: Transaction canceled due to a closed connection.
15:30:14 INFO - PROCESS | 3116 | Stack:
15:30:14 INFO - PROCESS | 3116 | ConnectionData.prototype<.executeTransaction/promise<@resource://gre/modules/Sqlite.jsm:560:15
15:30:14 INFO - PROCESS | 3116 | Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:551:9
15:30:14 INFO - PROCESS | 3116 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15
15:30:14 INFO - PROCESS | 3116 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:388:5
15:30:14 INFO - PROCESS | 3116 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29
15:30:14 INFO - PROCESS | 3116 | Barrier/this.client.addBlocker/promise13.2%
15:31:11 INFO - TinderboxPrint: I/O read bytes / time
112,655,360 / 1,740,910
15:31:11 INFO - TinderboxPrint: I/O write bytes / time
461,783,552 / 3,269,550
15:31:11 INFO - TinderboxPrint: CPU idle
8,225.0 (86.8%)
15:31:11 INFO - TinderboxPrint: CPU user
1,209.1 (12.8%)
15:31:11 INFO - install - Wall time: 2s; CPU: 11.0%; Read bytes: 0; Write bytes: 53126656; Read time: 0; Write time: 196510
15:31:11 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 112655360; Write bytes: 389311488; Read time: 1740910; Write time: 3057240
15:31:12 INFO - Running post-run listener: _upload_blobber_files
15:31:12 INFO - Blob upload gear active.
15:31:12 INFO - Preparing to upload files from C:\slave\test\build\blobber_upload_dir.
15:31:12 INFO - Files from C:\slave\test\build\blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com
15:31:12 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\venv\\Scripts\\blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', 'C:\\slave\\test\\oauth.txt', '-b', 'Fx-Team', '-d', 'C:\\slave\\test\\build\\blobber_upload_dir', '--output-manifest', 'C:\\slave\\test\\build\\uploaded_files.json']
15:31:12 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\venv\Scripts\blobberc.py -u https://blobupload.elasticbeanstalk.com -a C:\slave\test\oauth.txt -b Fx-Team -d C:\slave\test\build\blobber_upload_dir --output-manifest C:\slave\test\build\uploaded_files.json
15:31:13 INFO - (blobuploader) - INFO - Open directory for files ...
15:31:13 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_errorsummary.log ...
15:31:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
15:31:13 INFO - (blobuploader) - INFO - Uploading, attempt #1.
15:31:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded
15:31:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
15:31:14 INFO - (blobuploader) - INFO - Done attempting.
15:31:14 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_raw.log ...
15:31:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
15:31:14 INFO - (blobuploader) - INFO - Uploading, attempt #1.
15:31:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded
15:31:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
15:31:15 INFO - (blobuploader) - INFO - Done attempting.
15:31:15 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\resource-usage.json ...
15:31:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
15:31:15 INFO - (blobuploader) - INFO - Uploading, attempt #1.
15:31:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded
15:31:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
15:31:23 INFO - (blobuploader) - INFO - Done attempting.
15:31:23 INFO - (blobuploader) - INFO - Iteration through files over.
15:31:23 INFO - Return code: 0
15:31:23 INFO - rmtree: C:\slave\test\build\uploaded_files.json
15:31:23 INFO - Using _rmtree_windows ...
15:31:23 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build\\uploaded_files.json',), kwargs: {}, attempt #1
15:31:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/94711d6576c3fd9c8a73f03990efb78df2135cdf17ecc7bc0396abacb39549246e67540beaaaaa9b349c73c82598c0946d715510ca5e5f025482b928b0b103a2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/76abbe4d8490c3f2d3b2b39c4f268565ba2ed86c3562d2927834cde1636e8db83c7e86a5b1542c7b61a2bbce63b4b5e7812cc52c46dd1dc168933a972052cb43", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/651f785a03ebabb1fc9410644ca70921b7ad332df52e096d6e36b5ba73e40c1862e43dfeff57da935767cdf6b3b14f0a40a2ac01da155a80f10f164ee64b32b6"}
15:31:23 INFO - Writing buildbot properties ['blobber_files'] to C:\slave\test\properties\blobber_files
15:31:23 INFO - Writing to file C:\slave\test\properties\blobber_files
15:31:23 INFO - Contents:
15:31:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/94711d6576c3fd9c8a73f03990efb78df2135cdf17ecc7bc0396abacb39549246e67540beaaaaa9b349c73c82598c0946d715510ca5e5f025482b928b0b103a2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/76abbe4d8490c3f2d3b2b39c4f268565ba2ed86c3562d2927834cde1636e8db83c7e86a5b1542c7b61a2bbce63b4b5e7812cc52c46dd1dc168933a972052cb43", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/651f785a03ebabb1fc9410644ca70921b7ad332df52e096d6e36b5ba73e40c1862e43dfeff57da935767cdf6b3b14f0a40a2ac01da155a80f10f164ee64b32b6"}
15:31:23 INFO - Running post-run listener: copy_logs_to_upload_dir
15:31:23 INFO - Copying logs to upload dir...
15:31:23 INFO - mkdir: C:\slave\test\build\upload\logs
15:31:23 INFO - Copying logs to upload dir...
15:31:23 INFO - Using _rmtree_windows ...
15:31:23 INFO - Using _rmtree_windows ...
15:31:23 INFO - Using _rmtree_windows ...
15:31:23 INFO - Using _rmtree_windows ...
15:31:23 INFO - Using _rmtree_windows ...
15:31:23 INFO - Using _rmtree_windows ...
15:31:23 INFO - Using _rmtree_windows ...
program finished with exit code 0
elapsedTime=1452.647000
========= master_lag: -0.08 =========
========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 24 mins, 12 secs) (at 2016-09-21 15:31:23.744291) =========
========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-21 15:31:23.750031) =========
'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\AppData\Roaming
COMMONPROGRAMFILES=C:\Program Files\Common Files
COMPUTERNAME=T-W732-IX-116
COMSPEC=C:\windows\system32\cmd.exe
CYGWINBASE=C:\cygwin
DCLOCATION=SCL3
DNSSUFFIX=wintest.releng.scl3.mozilla.com
FP_NO_HOST_CHECK=NO
HOMEDRIVE=C:
HOMEPATH=\Users\cltbld
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld\AppData\Local
LOGONSERVER=\\T-W732-IX-116
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:\Python24;C:\Python24\Scripts;C:\cygwin\bin;C:\WINDOWS\System32;C:\program files\gnuwin32\bin;C:\WINDOWS;C:\mozilla-build\msys\bin;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\info-zip;C:\mozilla-build\wget;C:\Program Files (x86)\GnuWin32\bin;
PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
PROCESSOR_ARCHITECTURE=x86
PROCESSOR_IDENTIFIER=x86 Family 6 Model 30 Stepping 5, GenuineIntel
PROCESSOR_LEVEL=6
PROCESSOR_REVISION=1e05
PROGRAMDATA=C:\ProgramData
PROGRAMFILES=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\AppData\Local\Temp
TEST1=testie
TMP=C:\Users\cltbld\AppData\Local\Temp
USERDOMAIN=T-W732-IX-116
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld
WINDIR=C:\windows
WINDOWS_TRACING_FLAGS=3
WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log
XPCOM_DEBUG_BREAK=warn
using PTY: False
blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/94711d6576c3fd9c8a73f03990efb78df2135cdf17ecc7bc0396abacb39549246e67540beaaaaa9b349c73c82598c0946d715510ca5e5f025482b928b0b103a2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/76abbe4d8490c3f2d3b2b39c4f268565ba2ed86c3562d2927834cde1636e8db83c7e86a5b1542c7b61a2bbce63b4b5e7812cc52c46dd1dc168933a972052cb43", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/651f785a03ebabb1fc9410644ca70921b7ad332df52e096d6e36b5ba73e40c1862e43dfeff57da935767cdf6b3b14f0a40a2ac01da155a80f10f164ee64b32b6"}
build_url:https://queue.taskcluster.net/v1/task/DapT4v3yQqy0sxpfh59F3g/artifacts/public/build/firefox-52.0a1.en-US.win32.zip
program finished with exit code 0
elapsedTime=0.101000
build_url: 'https://queue.taskcluster.net/v1/task/DapT4v3yQqy0sxpfh59F3g/artifacts/public/build/firefox-52.0a1.en-US.win32.zip'
blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/94711d6576c3fd9c8a73f03990efb78df2135cdf17ecc7bc0396abacb39549246e67540beaaaaa9b349c73c82598c0946d715510ca5e5f025482b928b0b103a2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/76abbe4d8490c3f2d3b2b39c4f268565ba2ed86c3562d2927834cde1636e8db83c7e86a5b1542c7b61a2bbce63b4b5e7812cc52c46dd1dc168933a972052cb43", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/651f785a03ebabb1fc9410644ca70921b7ad332df52e096d6e36b5ba73e40c1862e43dfeff57da935767cdf6b3b14f0a40a2ac01da155a80f10f164ee64b32b6"}'
========= master_lag: 0.16 =========
========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-21 15:31:24.015453) =========
========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 15:31:24.015799) =========
'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\AppData\Roaming
COMMONPROGRAMFILES=C:\Program Files\Common Files
COMPUTERNAME=T-W732-IX-116
COMSPEC=C:\windows\system32\cmd.exe
CYGWINBASE=C:\cygwin
DCLOCATION=SCL3
DNSSUFFIX=wintest.releng.scl3.mozilla.com
FP_NO_HOST_CHECK=NO
HOMEDRIVE=C:
HOMEPATH=\Users\cltbld
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld\AppData\Local
LOGONSERVER=\\T-W732-IX-116
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:\Python24;C:\Python24\Scripts;C:\cygwin\bin;C:\WINDOWS\System32;C:\program files\gnuwin32\bin;C:\WINDOWS;C:\mozilla-build\msys\bin;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\info-zip;C:\mozilla-build\wget;C:\Program Files (x86)\GnuWin32\bin;
PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
PROCESSOR_ARCHITECTURE=x86
PROCESSOR_IDENTIFIER=x86 Family 6 Model 30 Stepping 5, GenuineIntel
PROCESSOR_LEVEL=6
PROCESSOR_REVISION=1e05
PROGRAMDATA=C:\ProgramData
PROGRAMFILES=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\AppData\Local\Temp
TEST1=testie
TMP=C:\Users\cltbld\AppData\Local\Temp
USERDOMAIN=T-W732-IX-116
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld
WINDIR=C:\windows
WINDOWS_TRACING_FLAGS=3
WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log
XPCOM_DEBUG_BREAK=warn
using PTY: False
program finished with exit code 0
elapsedTime=0.101000
========= master_lag: 0.02 =========
========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 15:31:24.131860) =========
========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-09-21 15:31:24.132194) =========
========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-09-21 15:31:24.575716) =========
========= Total master_lag: 5.51 =========