builder: fx-team_win7_ix_test-dromaeojs-pgo
slave: t-w732-ix-086
starttime: 1474576521.16
results: success (0)
buildid: 20160922093055
builduid: b98a252e318f472ab80142df5fd82c7b
revision: 190e45ee01153267e1507726381f41379d2e3673
========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 13:35:21.159566) =========
master: http://buildbot-master111.bb.releng.scl3.mozilla.com:8201/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 13:35:21.160053) =========
========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 13:35:21.160354) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 13:35:21.300883) =========
========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-22 13:35:21.301283) =========
'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-086
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-086
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-086
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
--13:35:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py
=> `archiver_client.py'
Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102
Connecting to hg.mozilla.org|63.245.215.25|:443... connected.
HTTP request sent, awaiting response... 200 Script output follows
Length: 12,141 (12K) [text/x-python]
0K .......... . 100% 8.95 MB/s
13:35:22 (8.95 MB/s) - `archiver_client.py' saved [12141/12141]
program finished with exit code 0
elapsedTime=1.311000
========= master_lag: 0.02 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-22 13:35:22.629572) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 14 secs) (at 2016-09-22 13:35:22.629902) =========
'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-086
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-086
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-086
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=14.508000
========= master_lag: 0.00 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 14 secs) (at 2016-09-22 13:35:37.142200) =========
========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-22 13:35:37.142582) =========
'bash' '-c' u'python archiver_client.py mozharness --repo integration/fx-team --rev 190e45ee01153267e1507726381f41379d2e3673 --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 190e45ee01153267e1507726381f41379d2e3673 --destination scripts --debug']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld\AppData\Roaming
COMMONPROGRAMFILES=C:\Program Files\Common Files
COMPUTERNAME=T-W732-IX-086
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-086
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-086
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-22 13:35:37,325 truncating revision to first 12 chars
2016-09-22 13:35:37,325 Setting DEBUG logging.
2016-09-22 13:35:37,326 attempt 1/10
2016-09-22 13:35:37,326 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/190e45ee0115?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2016-09-22 13:35:38,483 unpacking tar archive at: fx-team-190e45ee0115/testing/mozharness/
2016-09-22 13:35:38,677 skipping symlink on windows: configs/single_locale/linux32.py
program finished with exit code 0
elapsedTime=1.943000
========= master_lag: 0.05 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-22 13:35:39.136967) =========
========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 13:35:39.137390) =========
script_repo_revision: 190e45ee01153267e1507726381f41379d2e3673
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 13:35:39.137896) =========
========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 13:35:39.138279) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 13:35:39.149609) =========
========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 46 secs) (at 2016-09-22 13:35:39.149975) =========
'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-086
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-086
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-086
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
13:35:39 INFO - MultiFileLogger online at 20160922 13:35:39 in C:\slave\test
13:35:39 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
13:35:39 INFO - Dumping config to C:\slave\test\logs\localconfig.json.
13:35:39 INFO - {'append_to_log': False,
13:35:39 INFO - 'base_work_dir': 'C:\\slave\\test',
13:35:39 INFO - 'blob_upload_branch': 'Fx-Team',
13:35:39 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt',
13:35:39 INFO - 'branch': 'Fx-Team',
13:35:39 INFO - 'buildbot_json_path': 'buildprops.json',
13:35:39 INFO - 'config_files': ('talos/windows_config.py',),
13:35:39 INFO - 'default_actions': ('clobber',
13:35:39 INFO - 'read-buildbot-config',
13:35:39 INFO - 'download-and-extract',
13:35:39 INFO - 'populate-webroot',
13:35:39 INFO - 'create-virtualenv',
13:35:39 INFO - 'install',
13:35:39 INFO - 'run-tests'),
13:35:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',),
13:35:39 INFO - 'download_minidump_stackwalk': True,
13:35:39 INFO - 'download_symbols': 'ondemand',
13:35:39 INFO - 'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python',
13:35:39 INFO - 'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'),
13:35:39 INFO - 'hg': 'c:/mozilla-build/hg/hg',
13:35:39 INFO - 'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python',
13:35:39 INFO - 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'),
13:35:39 INFO - 'python': 'c:/mozilla-build/python27/python.exe',
13:35:39 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe',
13:35:39 INFO - 'C:/mozilla-build/tooltool.py'),
13:35:39 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe',
13:35:39 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')},
13:35:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub',
13:35:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'),
13:35:39 INFO - 'installer_path': 'installer.exe',
13:35:39 INFO - 'log_level': 'info',
13:35:39 INFO - 'log_name': 'talos',
13:35:39 INFO - 'log_to_console': True,
13:35:39 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe',
13:35:39 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe',
13:35:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest',
13:35:39 INFO - 'opt_config_files': (),
13:35:39 INFO - 'pip_index': False,
13:35:39 INFO - 'sps_profile': False,
13:35:39 INFO - 'sps_profile_interval': 0,
13:35:39 INFO - 'suite': 'dromaeojs',
13:35:39 INFO - 'system_bits': '32',
13:35:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'),
13:35:39 INFO - 'title': 'T-W732-IX-086',
13:35:39 INFO - 'use_talos_json': True,
13:35:39 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'),
13:35:39 INFO - 'virtualenv_path': 'C:\\slave\\test\\build/venv',
13:35:39 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll',
13:35:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
13:35:39 INFO - 'work_dir': 'build'}
13:35:39 INFO - [mozharness: 2016-09-22 20:35:39.434000Z] Running clobber step.
13:35:39 INFO - Running pre-action listener: _resource_record_pre_action
13:35:39 INFO - Running main action method: clobber
13:35:39 INFO - rmtree: C:\slave\test\build
13:35:39 INFO - Using _rmtree_windows ...
13:35:39 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1
13:37:38 INFO - Running post-action listener: _resource_record_post_action
13:37:38 INFO - [mozharness: 2016-09-22 20:37:38.408000Z] Finished clobber step (success)
13:37:38 INFO - [mozharness: 2016-09-22 20:37:38.408000Z] Running read-buildbot-config step.
13:37:38 INFO - Running pre-action listener: _resource_record_pre_action
13:37:38 INFO - Running main action method: read_buildbot_config
13:37:38 INFO - Using buildbot properties:
13:37:38 INFO - {
13:37:38 INFO - "project": "",
13:37:38 INFO - "product": "firefox",
13:37:38 INFO - "script_repo_revision": "production",
13:37:38 INFO - "builddir": "fx-team_win7_ix_test-dromaeojs",
13:37:38 INFO - "repository": "",
13:37:38 INFO - "buildername": "Windows 7 32-bit fx-team pgo talos dromaeojs",
13:37:38 INFO - "buildid": "20160922093055",
13:37:38 INFO - "pgo_build": "True",
13:37:38 INFO - "basedir": "C:\\slave\\test",
13:37:38 INFO - "buildnumber": 213,
13:37:38 INFO - "slavename": "t-w732-ix-086",
13:37:38 INFO - "master": "http://buildbot-master111.bb.releng.scl3.mozilla.com:8201/",
13:37:38 INFO - "platform": "win7_ix",
13:37:38 INFO - "scheduler": "tests-fx-team-win32-pgo-talos",
13:37:38 INFO - "branch": "fx-team",
13:37:38 INFO - "repo_path": "integration/fx-team",
13:37:38 INFO - "revision": "190e45ee01153267e1507726381f41379d2e3673",
13:37:38 INFO - "stage_platform": "win32-pgo",
13:37:38 INFO - "builduid": "b98a252e318f472ab80142df5fd82c7b",
13:37:38 INFO - "slavebuilddir": "test"
13:37:38 INFO - }
13:37:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/fdJN3ltLS7aaJH-HDdPE2w/artifacts/public/build/firefox-52.0a1.en-US.win32.zip.
13:37:38 INFO - Running post-action listener: _resource_record_post_action
13:37:38 INFO - [mozharness: 2016-09-22 20:37:38.411000Z] Finished read-buildbot-config step (success)
13:37:38 INFO - [mozharness: 2016-09-22 20:37:38.412000Z] Running download-and-extract step.
13:37:38 INFO - Running pre-action listener: _resource_record_pre_action
13:37:38 INFO - Running main action method: download_and_extract
13:37:38 INFO - mkdir: C:\slave\test\build\tests
13:37:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
13:37:38 INFO - trying https://queue.taskcluster.net/v1/task/fdJN3ltLS7aaJH-HDdPE2w/artifacts/public/build/firefox-52.0a1.en-US.win32.test_packages.json
13:37:38 INFO - Downloading https://queue.taskcluster.net/v1/task/fdJN3ltLS7aaJH-HDdPE2w/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
13:37:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fdJN3ltLS7aaJH-HDdPE2w/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
13:37:39 INFO - Downloaded 1218 bytes.
13:37:39 INFO - Reading from file C:\slave\test\build\firefox-52.0a1.en-US.win32.test_packages.json
13:37:39 INFO - Using the following test package requirements:
13:37:39 INFO - {u'common': [u'firefox-52.0a1.en-US.win32.common.tests.zip'],
13:37:39 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.win32.common.tests.zip',
13:37:39 INFO - u'firefox-52.0a1.en-US.win32.cppunittest.tests.zip'],
13:37:39 INFO - u'gtest': [u'firefox-52.0a1.en-US.win32.common.tests.zip'],
13:37:39 INFO - u'jittest': [u'firefox-52.0a1.en-US.win32.common.tests.zip',
13:37:39 INFO - u'jsshell-win32.zip'],
13:37:39 INFO - u'mochitest': [u'firefox-52.0a1.en-US.win32.common.tests.zip',
13:37:39 INFO - u'firefox-52.0a1.en-US.win32.mochitest.tests.zip'],
13:37:39 INFO - u'mozbase': [u'firefox-52.0a1.en-US.win32.common.tests.zip'],
13:37:39 INFO - u'reftest': [u'firefox-52.0a1.en-US.win32.common.tests.zip',
13:37:39 INFO - u'firefox-52.0a1.en-US.win32.reftest.tests.zip'],
13:37:39 INFO - u'talos': [u'firefox-52.0a1.en-US.win32.common.tests.zip',
13:37:39 INFO - u'firefox-52.0a1.en-US.win32.talos.tests.zip'],
13:37:39 INFO - u'web-platform': [u'firefox-52.0a1.en-US.win32.common.tests.zip',
13:37:39 INFO - u'firefox-52.0a1.en-US.win32.web-platform.tests.zip'],
13:37:39 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.win32.common.tests.zip',
13:37:39 INFO - u'firefox-52.0a1.en-US.win32.xpcshell.tests.zip']}
13:37:39 INFO - Downloading packages: [u'firefox-52.0a1.en-US.win32.common.tests.zip'] for test suite category: common
13:37:39 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/fdJN3ltLS7aaJH-HDdPE2w/artifacts/public/build/firefox-52.0a1.en-US.win32.common.tests.zip
13:37:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fdJN3ltLS7aaJH-HDdPE2w/artifacts/public/build/firefox-52.0a1.en-US.win32.common.tests.zip'}, attempt #1
13:37:39 INFO - Fetch https://queue.taskcluster.net/v1/task/fdJN3ltLS7aaJH-HDdPE2w/artifacts/public/build/firefox-52.0a1.en-US.win32.common.tests.zip into memory
13:37:40 INFO - Expected file size: 17286862
13:38:10 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
13:38:10 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/fdJN3ltLS7aaJH-HDdPE2w/artifacts/public/build/firefox-52.0a1.en-US.win32.common.tests.zip
13:38:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fdJN3ltLS7aaJH-HDdPE2w/artifacts/public/build/firefox-52.0a1.en-US.win32.common.tests.zip'}, attempt #1
13:38:10 INFO - Fetch https://queue.taskcluster.net/v1/task/fdJN3ltLS7aaJH-HDdPE2w/artifacts/public/build/firefox-52.0a1.en-US.win32.common.tests.zip into memory
13:38:11 INFO - Expected file size: 17286862
13:38:23 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/fdJN3ltLS7aaJH-HDdPE2w/artifacts/public/build/firefox-52.0a1.en-US.win32.talos.tests.zip
13:38:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fdJN3ltLS7aaJH-HDdPE2w/artifacts/public/build/firefox-52.0a1.en-US.win32.talos.tests.zip'}, attempt #1
13:38:23 INFO - Fetch https://queue.taskcluster.net/v1/task/fdJN3ltLS7aaJH-HDdPE2w/artifacts/public/build/firefox-52.0a1.en-US.win32.talos.tests.zip into memory
13:38:24 INFO - Expected file size: 14414059
13:38:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
13:38:27 INFO - trying https://queue.taskcluster.net/v1/task/fdJN3ltLS7aaJH-HDdPE2w/artifacts/public/build/firefox-52.0a1.en-US.win32.zip
13:38:27 INFO - Downloading https://queue.taskcluster.net/v1/task/fdJN3ltLS7aaJH-HDdPE2w/artifacts/public/build/firefox-52.0a1.en-US.win32.zip to C:\slave\test\build\firefox-52.0a1.en-US.win32.zip
13:38:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fdJN3ltLS7aaJH-HDdPE2w/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
13:38:31 INFO - Downloaded 54755891 bytes.
13:38:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fdJN3ltLS7aaJH-HDdPE2w/artifacts/public/build/firefox-52.0a1.en-US.win32.zip
13:38:31 INFO - mkdir: C:\slave\test\properties
13:38:31 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url
13:38:31 INFO - Writing to file C:\slave\test\properties\build_url
13:38:31 INFO - Contents:
13:38:31 INFO - build_url:https://queue.taskcluster.net/v1/task/fdJN3ltLS7aaJH-HDdPE2w/artifacts/public/build/firefox-52.0a1.en-US.win32.zip
13:38:31 INFO - Running post-action listener: _resource_record_post_action
13:38:31 INFO - Running post-action listener: set_extra_try_arguments
13:38:31 INFO - [mozharness: 2016-09-22 20:38:31.899000Z] Finished download-and-extract step (success)
13:38:31 INFO - [mozharness: 2016-09-22 20:38:31.899000Z] Running populate-webroot step.
13:38:31 INFO - Running pre-action listener: _resource_record_pre_action
13:38:31 INFO - Running main action method: populate_webroot
13:38:31 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']},
13:38:31 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']},
13:38:31 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome',
13:38:31 INFO - u'--tppagecycles',
13:38:31 INFO - u'7'],
13:38:31 INFO - u'tests': [u'tsvgm']}},
13:38:31 INFO - u'suites': {u'chromez': {u'talos_options': [u'--disable-e10s'],
13:38:31 INFO - u'tests': [u'tresize', u'tcanvasmark']},
13:38:31 INFO - u'chromez-e10s': {u'tests': [u'tresize', u'tcanvasmark']},
13:38:31 INFO - u'dromaeojs': {u'talos_options': [u'--disable-e10s'],
13:38:31 INFO - u'tests': [u'dromaeo_css', u'kraken']},
13:38:31 INFO - u'dromaeojs-e10s': {u'tests': [u'dromaeo_css', u'kraken']},
13:38:31 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
13:38:31 INFO - u'talos_options': [u'--disable-e10s'],
13:38:31 INFO - u'tests': [u'tp5o_scroll', u'glterrain']},
13:38:31 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
13:38:31 INFO - u'tests': [u'tp5o_scroll', u'glterrain']},
13:38:31 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
13:38:31 INFO - u'talos_options': [u'--disable-e10s'],
13:38:31 INFO - u'tests': [u'damp', u'tps']},
13:38:31 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
13:38:31 INFO - u'tests': [u'damp', u'tps']},
13:38:31 INFO - u'g3': {u'talos_options': [u'--disable-e10s'],
13:38:31 INFO - u'tests': [u'dromaeo_dom']},
13:38:31 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']},
13:38:31 INFO - u'g4': {u'talos_options': [u'--disable-e10s'],
13:38:31 INFO - u'tests': [u'basic_compositor_video']},
13:38:31 INFO - u'g4-e10s': {u'tests': [u'basic_compositor_video']},
13:38:31 INFO - u'other': {u'talos_options': [u'--disable-e10s'],
13:38:31 INFO - u'tests': [u'a11yr',
13:38:31 INFO - u'ts_paint',
13:38:31 INFO - u'tpaint',
13:38:31 INFO - u'sessionrestore',
13:38:31 INFO - u'sessionrestore_no_auto_restore',
13:38:31 INFO - u'tabpaint']},
13:38:31 INFO - u'other-e10s': {u'tests': [u'a11yr',
13:38:31 INFO - u'ts_paint',
13:38:31 INFO - u'tpaint',
13:38:31 INFO - u'sessionrestore',
13:38:31 INFO - u'sessionrestore_no_auto_restore',
13:38:31 INFO - u'tabpaint']},
13:38:31 INFO - u'other-e10s_l64': {u'tests': [u'a11yr',
13:38:31 INFO - u'ts_paint',
13:38:31 INFO - u'tpaint',
13:38:31 INFO - u'sessionrestore',
13:38:31 INFO - u'sessionrestore_no_auto_restore',
13:38:31 INFO - u'tabpaint']},
13:38:31 INFO - u'other-e10s_nol64': {u'tests': [u'a11yr',
13:38:31 INFO - u'ts_paint',
13:38:31 INFO - u'tpaint',
13:38:31 INFO - u'sessionrestore',
13:38:31 INFO - u'sessionrestore_no_auto_restore',
13:38:31 INFO - u'tabpaint']},
13:38:31 INFO - u'other_l64': {u'talos_options': [u'--disable-e10s'],
13:38:31 INFO - u'tests': [u'a11yr',
13:38:31 INFO - u'ts_paint',
13:38:31 INFO - u'tpaint',
13:38:31 INFO - u'sessionrestore',
13:38:31 INFO - u'sessionrestore_no_auto_restore',
13:38:31 INFO - u'tabpaint']},
13:38:31 INFO - u'other_nol64': {u'talos_options': [u'--disable-e10s'],
13:38:31 INFO - u'tests': [u'a11yr',
13:38:31 INFO - u'ts_paint',
13:38:31 INFO - u'tpaint',
13:38:31 INFO - u'sessionrestore',
13:38:31 INFO - u'sessionrestore_no_auto_restore',
13:38:31 INFO - u'tabpaint']},
13:38:31 INFO - u'svgr': {u'talos_options': [u'--disable-e10s'],
13:38:31 INFO - u'tests': [u'tsvgx',
13:38:31 INFO - u'tsvgr_opacity',
13:38:31 INFO - u'tart',
13:38:31 INFO - u'tscrollx',
13:38:31 INFO - u'cart']},
13:38:31 INFO - u'svgr-e10s': {u'tests': [u'tsvgx',
13:38:31 INFO - u'tsvgr_opacity',
13:38:31 INFO - u'tart',
13:38:31 INFO - u'tscrollx',
13:38:31 INFO - u'cart']},
13:38:31 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
13:38:31 INFO - u'talos_options': [u'--disable-e10s'],
13:38:31 INFO - u'tests': [u'tp5o']},
13:38:31 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
13:38:31 INFO - u'tests': [u'tp5o']},
13:38:31 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
13:38:31 INFO - u'talos_options': [u'--disable-e10s',
13:38:31 INFO - u'--xperf_path',
13:38:31 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
13:38:31 INFO - u'tests': [u'tp5n']},
13:38:31 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
13:38:31 INFO - u'talos_options': [u'--xperf_path',
13:38:31 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
13:38:31 INFO - u'tests': [u'tp5n']}},
13:38:31 INFO - u'talos.zip': {u'path': u'',
13:38:31 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}}
13:38:31 INFO - Running post-action listener: _resource_record_post_action
13:38:31 INFO - [mozharness: 2016-09-22 20:38:31.982000Z] Finished populate-webroot step (success)
13:38:31 INFO - [mozharness: 2016-09-22 20:38:31.982000Z] Running create-virtualenv step.
13:38:31 INFO - Running pre-action listener: _resource_record_pre_action
13:38:31 INFO - Running main action method: create_virtualenv
13:38:31 INFO - Creating virtualenv C:\slave\test\build/venv
13:38:31 INFO - mkdir: C:\slave\test\build\venv\Scripts
13:38:31 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll
13:38:31 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'!
13:38:31 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
13:38:31 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build/venv
13:38:41 INFO - New python executable in C:\slave\test\build/venv\Scripts\python.exe
13:38:46 INFO - Installing distribute......................................................................................................................................................................................done.
13:38:47 INFO - Return code: 0
13:38:47 INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv
13:38:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
13:38:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
13:38:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
13:38:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
13:38:47 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x018D8640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0190FE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01852B28>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01929E90>, '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 0x0132A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01996520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-086', 'USERDOMAIN': 'T-W732-IX-086', '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-086', '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
13:38:47 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in C:\slave\test\build
13:38:47 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5
13:38:47 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
13:38:47 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
13:38:47 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
13:38:47 INFO - 'COMPUTERNAME': 'T-W732-IX-086',
13:38:47 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
13:38:47 INFO - 'CYGWINBASE': 'C:\\cygwin',
13:38:47 INFO - 'DCLOCATION': 'SCL3',
13:38:47 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
13:38:47 INFO - 'FP_NO_HOST_CHECK': 'NO',
13:38:47 INFO - 'HOMEDRIVE': 'C:',
13:38:47 INFO - 'HOMEPATH': '\\Users\\cltbld',
13:38:47 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
13:38:47 INFO - 'KTS_VERSION': '1.19c',
13:38:47 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
13:38:47 INFO - 'LOGONSERVER': '\\\\T-W732-IX-086',
13:38:47 INFO - 'MONDIR': 'C:\\Monitor_config\\',
13:38:47 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
13:38:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
13:38:47 INFO - 'MOZ_NO_REMOTE': '1',
13:38:47 INFO - 'NO_EM_RESTART': '1',
13:38:47 INFO - 'NUMBER_OF_PROCESSORS': '8',
13:38:47 INFO - 'OS': 'Windows_NT',
13:38:47 INFO - 'OURDRIVE': 'C:',
13:38:47 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;',
13:38:47 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
13:38:47 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
13:38:47 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
13:38:47 INFO - 'PROCESSOR_LEVEL': '6',
13:38:47 INFO - 'PROCESSOR_REVISION': '1e05',
13:38:47 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
13:38:47 INFO - 'PROGRAMFILES': 'C:\\Program Files',
13:38:47 INFO - 'PROMPT': '$P$G',
13:38:47 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
13:38:47 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
13:38:47 INFO - 'PUBLIC': 'C:\\Users\\Public',
13:38:47 INFO - 'PWD': 'C:\\slave\\test',
13:38:47 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
13:38:47 INFO - 'SLAVEDIR': 'C:\\slave\\',
13:38:47 INFO - 'SYSTEMDRIVE': 'C:',
13:38:47 INFO - 'SYSTEMROOT': 'C:\\windows',
13:38:47 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
13:38:47 INFO - 'TEST1': 'testie',
13:38:47 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
13:38:47 INFO - 'USERDOMAIN': 'T-W732-IX-086',
13:38:47 INFO - 'USERNAME': 'cltbld',
13:38:47 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
13:38:47 INFO - 'WINDIR': 'C:\\windows',
13:38:47 INFO - 'WINDOWS_TRACING_FLAGS': '3',
13:38:47 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
13:38:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
13:38:49 INFO - Ignoring indexes: http://pypi.python.org/simple/
13:38:49 INFO - Downloading/unpacking pip>=1.5
13:38:53 INFO - Running setup.py egg_info for package pip
13:38:53 INFO - warning: no files found matching 'pip\cacert.pem'
13:38:53 INFO - warning: no files found matching '*.html' under directory 'docs'
13:38:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build'
13:38:53 INFO - no previously-included directories found matching 'docs\_build\_sources'
13:38:53 INFO - Installing collected packages: pip
13:38:53 INFO - Found existing installation: pip 0.8.2
13:38:53 INFO - Uninstalling pip:
13:38:53 INFO - Successfully uninstalled pip
13:38:53 INFO - Running setup.py install for pip
13:38:53 INFO - warning: no files found matching 'pip\cacert.pem'
13:38:53 INFO - warning: no files found matching '*.html' under directory 'docs'
13:38:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build'
13:38:53 INFO - no previously-included directories found matching 'docs\_build\_sources'
13:38:53 INFO - Installing pip-script.py script to C:\slave\test\build\venv\Scripts
13:38:53 INFO - Installing pip.exe script to C:\slave\test\build\venv\Scripts
13:38:53 INFO - Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts
13:38:53 INFO - Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts
13:38:53 INFO - Installing pip2-script.py script to C:\slave\test\build\venv\Scripts
13:38:53 INFO - Installing pip2.exe script to C:\slave\test\build\venv\Scripts
13:38:53 INFO - Successfully installed pip
13:38:53 INFO - Cleaning up...
13:38:53 INFO - Return code: 0
13:38:53 INFO - Installing psutil>=3.1.1 into virtualenv C:\slave\test\build/venv
13:38: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')]}
13:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
13:38: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')]}
13:38:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
13:38: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 0x018D8640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0190FE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01852B28>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01929E90>, '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 0x0132A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01996520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-086', 'USERDOMAIN': 'T-W732-IX-086', '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-086', '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
13:38: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
13:38: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
13:38:53 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
13:38:53 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
13:38:53 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
13:38:53 INFO - 'COMPUTERNAME': 'T-W732-IX-086',
13:38:53 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
13:38:53 INFO - 'CYGWINBASE': 'C:\\cygwin',
13:38:53 INFO - 'DCLOCATION': 'SCL3',
13:38:53 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
13:38:53 INFO - 'FP_NO_HOST_CHECK': 'NO',
13:38:53 INFO - 'HOMEDRIVE': 'C:',
13:38:53 INFO - 'HOMEPATH': '\\Users\\cltbld',
13:38:53 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
13:38:53 INFO - 'KTS_VERSION': '1.19c',
13:38:53 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
13:38:53 INFO - 'LOGONSERVER': '\\\\T-W732-IX-086',
13:38:53 INFO - 'MONDIR': 'C:\\Monitor_config\\',
13:38:53 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
13:38:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
13:38:53 INFO - 'MOZ_NO_REMOTE': '1',
13:38:53 INFO - 'NO_EM_RESTART': '1',
13:38:53 INFO - 'NUMBER_OF_PROCESSORS': '8',
13:38:53 INFO - 'OS': 'Windows_NT',
13:38:53 INFO - 'OURDRIVE': 'C:',
13:38: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;',
13:38:53 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
13:38:53 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
13:38:53 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
13:38:53 INFO - 'PROCESSOR_LEVEL': '6',
13:38:53 INFO - 'PROCESSOR_REVISION': '1e05',
13:38:53 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
13:38:53 INFO - 'PROGRAMFILES': 'C:\\Program Files',
13:38:53 INFO - 'PROMPT': '$P$G',
13:38:53 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
13:38:53 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
13:38:53 INFO - 'PUBLIC': 'C:\\Users\\Public',
13:38:53 INFO - 'PWD': 'C:\\slave\\test',
13:38:53 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
13:38:53 INFO - 'SLAVEDIR': 'C:\\slave\\',
13:38:53 INFO - 'SYSTEMDRIVE': 'C:',
13:38:53 INFO - 'SYSTEMROOT': 'C:\\windows',
13:38:53 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
13:38:53 INFO - 'TEST1': 'testie',
13:38:53 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
13:38:53 INFO - 'USERDOMAIN': 'T-W732-IX-086',
13:38:53 INFO - 'USERNAME': 'cltbld',
13:38:53 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
13:38:53 INFO - 'WINDIR': 'C:\\windows',
13:38:53 INFO - 'WINDOWS_TRACING_FLAGS': '3',
13:38:53 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
13:38:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
13:38:55 INFO - Ignoring indexes: https://pypi.python.org/simple/
13:38:55 INFO - Downloading/unpacking psutil>=3.1.1
13:38: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
13:38: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
13:38:56 INFO - Installing collected packages: psutil
13:38:56 INFO - Successfully installed psutil
13:38:56 INFO - Cleaning up...
13:38:56 INFO - Return code: 0
13:38:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv C:\slave\test\build/venv
13:38: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')]}
13:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
13:38: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')]}
13:38:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
13:38: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 0x018D8640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0190FE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01852B28>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01929E90>, '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 0x0132A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01996520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-086', 'USERDOMAIN': 'T-W732-IX-086', '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-086', '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
13:38: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
13:38: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
13:38:56 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
13:38:56 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
13:38:56 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
13:38:56 INFO - 'COMPUTERNAME': 'T-W732-IX-086',
13:38:56 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
13:38:56 INFO - 'CYGWINBASE': 'C:\\cygwin',
13:38:56 INFO - 'DCLOCATION': 'SCL3',
13:38:56 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
13:38:56 INFO - 'FP_NO_HOST_CHECK': 'NO',
13:38:56 INFO - 'HOMEDRIVE': 'C:',
13:38:56 INFO - 'HOMEPATH': '\\Users\\cltbld',
13:38:56 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
13:38:56 INFO - 'KTS_VERSION': '1.19c',
13:38:56 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
13:38:56 INFO - 'LOGONSERVER': '\\\\T-W732-IX-086',
13:38:56 INFO - 'MONDIR': 'C:\\Monitor_config\\',
13:38:56 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
13:38:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
13:38:56 INFO - 'MOZ_NO_REMOTE': '1',
13:38:56 INFO - 'NO_EM_RESTART': '1',
13:38:56 INFO - 'NUMBER_OF_PROCESSORS': '8',
13:38:56 INFO - 'OS': 'Windows_NT',
13:38:56 INFO - 'OURDRIVE': 'C:',
13:38: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;',
13:38:56 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
13:38:56 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
13:38:56 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
13:38:56 INFO - 'PROCESSOR_LEVEL': '6',
13:38:56 INFO - 'PROCESSOR_REVISION': '1e05',
13:38:56 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
13:38:56 INFO - 'PROGRAMFILES': 'C:\\Program Files',
13:38:56 INFO - 'PROMPT': '$P$G',
13:38:56 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
13:38:56 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
13:38:56 INFO - 'PUBLIC': 'C:\\Users\\Public',
13:38:56 INFO - 'PWD': 'C:\\slave\\test',
13:38:56 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
13:38:56 INFO - 'SLAVEDIR': 'C:\\slave\\',
13:38:56 INFO - 'SYSTEMDRIVE': 'C:',
13:38:56 INFO - 'SYSTEMROOT': 'C:\\windows',
13:38:56 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
13:38:56 INFO - 'TEST1': 'testie',
13:38:56 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
13:38:56 INFO - 'USERDOMAIN': 'T-W732-IX-086',
13:38:56 INFO - 'USERNAME': 'cltbld',
13:38:56 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
13:38:56 INFO - 'WINDIR': 'C:\\windows',
13:38:56 INFO - 'WINDOWS_TRACING_FLAGS': '3',
13:38:56 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
13:38:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
13:38:57 INFO - Ignoring indexes: https://pypi.python.org/simple/
13:38:57 INFO - Downloading/unpacking mozsystemmonitor==0.3
13:38: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
13:38: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
13:38:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz
13:38:58 INFO - Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor
13:38: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)
13:38:58 INFO - Installing collected packages: mozsystemmonitor
13:38:58 INFO - Running setup.py install for mozsystemmonitor
13:38:58 INFO - Successfully installed mozsystemmonitor
13:38:58 INFO - Cleaning up...
13:38:58 INFO - Return code: 0
13:38:58 INFO - Installing jsonschema==2.5.1 into virtualenv C:\slave\test\build/venv
13:38: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')]}
13:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
13:38: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')]}
13:38:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
13:38: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 0x018D8640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0190FE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01852B28>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01929E90>, '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 0x0132A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01996520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-086', 'USERDOMAIN': 'T-W732-IX-086', '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-086', '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
13:38: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
13:38: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
13:38:58 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
13:38:58 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
13:38:58 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
13:38:58 INFO - 'COMPUTERNAME': 'T-W732-IX-086',
13:38:58 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
13:38:58 INFO - 'CYGWINBASE': 'C:\\cygwin',
13:38:58 INFO - 'DCLOCATION': 'SCL3',
13:38:58 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
13:38:58 INFO - 'FP_NO_HOST_CHECK': 'NO',
13:38:58 INFO - 'HOMEDRIVE': 'C:',
13:38:58 INFO - 'HOMEPATH': '\\Users\\cltbld',
13:38:58 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
13:38:58 INFO - 'KTS_VERSION': '1.19c',
13:38:58 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
13:38:58 INFO - 'LOGONSERVER': '\\\\T-W732-IX-086',
13:38:58 INFO - 'MONDIR': 'C:\\Monitor_config\\',
13:38:58 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
13:38:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
13:38:58 INFO - 'MOZ_NO_REMOTE': '1',
13:38:58 INFO - 'NO_EM_RESTART': '1',
13:38:58 INFO - 'NUMBER_OF_PROCESSORS': '8',
13:38:58 INFO - 'OS': 'Windows_NT',
13:38:58 INFO - 'OURDRIVE': 'C:',
13:38: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;',
13:38:58 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
13:38:58 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
13:38:58 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
13:38:58 INFO - 'PROCESSOR_LEVEL': '6',
13:38:58 INFO - 'PROCESSOR_REVISION': '1e05',
13:38:58 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
13:38:58 INFO - 'PROGRAMFILES': 'C:\\Program Files',
13:38:58 INFO - 'PROMPT': '$P$G',
13:38:58 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
13:38:58 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
13:38:58 INFO - 'PUBLIC': 'C:\\Users\\Public',
13:38:58 INFO - 'PWD': 'C:\\slave\\test',
13:38:58 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
13:38:58 INFO - 'SLAVEDIR': 'C:\\slave\\',
13:38:58 INFO - 'SYSTEMDRIVE': 'C:',
13:38:58 INFO - 'SYSTEMROOT': 'C:\\windows',
13:38:58 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
13:38:58 INFO - 'TEST1': 'testie',
13:38:58 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
13:38:58 INFO - 'USERDOMAIN': 'T-W732-IX-086',
13:38:58 INFO - 'USERNAME': 'cltbld',
13:38:58 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
13:38:58 INFO - 'WINDIR': 'C:\\windows',
13:38:58 INFO - 'WINDOWS_TRACING_FLAGS': '3',
13:38:58 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
13:38:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
13:38:58 INFO - Ignoring indexes: https://pypi.python.org/simple/
13:38:58 INFO - Downloading/unpacking jsonschema==2.5.1
13:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
13:38:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
13:38:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl
13:38:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1)
13:38: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
13:38: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
13:39:00 INFO - Downloading functools32-3.2.3-2.tar.gz
13:39:00 INFO - Running setup.py (path:C:\slave\test\build\venv\build\functools32\setup.py) egg_info for package functools32
13:39:00 INFO - warning: no files found matching '*.txt'
13:39:00 INFO - no previously-included directories found matching 'build'
13:39:00 INFO - no previously-included directories found matching 'dist'
13:39:00 INFO - no previously-included directories found matching '.git*'
13:39:00 INFO - Installing collected packages: jsonschema, functools32
13:39:00 INFO - Running setup.py install for functools32
13:39:01 INFO - warning: no files found matching '*.txt'
13:39:01 INFO - no previously-included directories found matching 'build'
13:39:01 INFO - no previously-included directories found matching 'dist'
13:39:01 INFO - no previously-included directories found matching '.git*'
13:39:01 INFO - Successfully installed jsonschema functools32
13:39:01 INFO - Cleaning up...
13:39:01 INFO - Return code: 0
13:39:01 INFO - Installing functools32==3.2.3-2 into virtualenv C:\slave\test\build/venv
13:39: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')]}
13:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
13:39: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')]}
13:39:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
13:39: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 0x018D8640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0190FE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01852B28>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01929E90>, '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 0x0132A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01996520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-086', 'USERDOMAIN': 'T-W732-IX-086', '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-086', '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
13:39: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
13:39: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
13:39:01 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
13:39:01 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
13:39:01 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
13:39:01 INFO - 'COMPUTERNAME': 'T-W732-IX-086',
13:39:01 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
13:39:01 INFO - 'CYGWINBASE': 'C:\\cygwin',
13:39:01 INFO - 'DCLOCATION': 'SCL3',
13:39:01 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
13:39:01 INFO - 'FP_NO_HOST_CHECK': 'NO',
13:39:01 INFO - 'HOMEDRIVE': 'C:',
13:39:01 INFO - 'HOMEPATH': '\\Users\\cltbld',
13:39:01 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
13:39:01 INFO - 'KTS_VERSION': '1.19c',
13:39:01 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
13:39:01 INFO - 'LOGONSERVER': '\\\\T-W732-IX-086',
13:39:01 INFO - 'MONDIR': 'C:\\Monitor_config\\',
13:39:01 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
13:39:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
13:39:01 INFO - 'MOZ_NO_REMOTE': '1',
13:39:01 INFO - 'NO_EM_RESTART': '1',
13:39:01 INFO - 'NUMBER_OF_PROCESSORS': '8',
13:39:01 INFO - 'OS': 'Windows_NT',
13:39:01 INFO - 'OURDRIVE': 'C:',
13:39: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;',
13:39:01 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
13:39:01 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
13:39:01 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
13:39:01 INFO - 'PROCESSOR_LEVEL': '6',
13:39:01 INFO - 'PROCESSOR_REVISION': '1e05',
13:39:01 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
13:39:01 INFO - 'PROGRAMFILES': 'C:\\Program Files',
13:39:01 INFO - 'PROMPT': '$P$G',
13:39:01 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
13:39:01 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
13:39:01 INFO - 'PUBLIC': 'C:\\Users\\Public',
13:39:01 INFO - 'PWD': 'C:\\slave\\test',
13:39:01 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
13:39:01 INFO - 'SLAVEDIR': 'C:\\slave\\',
13:39:01 INFO - 'SYSTEMDRIVE': 'C:',
13:39:01 INFO - 'SYSTEMROOT': 'C:\\windows',
13:39:01 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
13:39:01 INFO - 'TEST1': 'testie',
13:39:01 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
13:39:01 INFO - 'USERDOMAIN': 'T-W732-IX-086',
13:39:01 INFO - 'USERNAME': 'cltbld',
13:39:01 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
13:39:01 INFO - 'WINDIR': 'C:\\windows',
13:39:01 INFO - 'WINDOWS_TRACING_FLAGS': '3',
13:39:01 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
13:39:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
13:39:01 INFO - Ignoring indexes: https://pypi.python.org/simple/
13:39:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in c:\slave\test\build\venv\lib\site-packages
13:39:01 INFO - Cleaning up...
13:39:01 INFO - Return code: 0
13:39:01 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv
13:39: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')]}
13:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
13:39: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')]}
13:39:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
13:39: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 0x018D8640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0190FE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01852B28>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01929E90>, '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 0x0132A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01996520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-086', 'USERDOMAIN': 'T-W732-IX-086', '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-086', '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
13:39: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
13:39: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
13:39:01 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
13:39:01 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
13:39:01 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
13:39:01 INFO - 'COMPUTERNAME': 'T-W732-IX-086',
13:39:01 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
13:39:01 INFO - 'CYGWINBASE': 'C:\\cygwin',
13:39:01 INFO - 'DCLOCATION': 'SCL3',
13:39:01 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
13:39:01 INFO - 'FP_NO_HOST_CHECK': 'NO',
13:39:01 INFO - 'HOMEDRIVE': 'C:',
13:39:01 INFO - 'HOMEPATH': '\\Users\\cltbld',
13:39:01 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
13:39:02 INFO - 'KTS_VERSION': '1.19c',
13:39:02 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
13:39:02 INFO - 'LOGONSERVER': '\\\\T-W732-IX-086',
13:39:02 INFO - 'MONDIR': 'C:\\Monitor_config\\',
13:39:02 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
13:39:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
13:39:02 INFO - 'MOZ_NO_REMOTE': '1',
13:39:02 INFO - 'NO_EM_RESTART': '1',
13:39:02 INFO - 'NUMBER_OF_PROCESSORS': '8',
13:39:02 INFO - 'OS': 'Windows_NT',
13:39:02 INFO - 'OURDRIVE': 'C:',
13:39:02 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;',
13:39:02 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
13:39:02 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
13:39:02 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
13:39:02 INFO - 'PROCESSOR_LEVEL': '6',
13:39:02 INFO - 'PROCESSOR_REVISION': '1e05',
13:39:02 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
13:39:02 INFO - 'PROGRAMFILES': 'C:\\Program Files',
13:39:02 INFO - 'PROMPT': '$P$G',
13:39:02 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
13:39:02 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
13:39:02 INFO - 'PUBLIC': 'C:\\Users\\Public',
13:39:02 INFO - 'PWD': 'C:\\slave\\test',
13:39:02 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
13:39:02 INFO - 'SLAVEDIR': 'C:\\slave\\',
13:39:02 INFO - 'SYSTEMDRIVE': 'C:',
13:39:02 INFO - 'SYSTEMROOT': 'C:\\windows',
13:39:02 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
13:39:02 INFO - 'TEST1': 'testie',
13:39:02 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
13:39:02 INFO - 'USERDOMAIN': 'T-W732-IX-086',
13:39:02 INFO - 'USERNAME': 'cltbld',
13:39:02 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
13:39:02 INFO - 'WINDIR': 'C:\\windows',
13:39:02 INFO - 'WINDOWS_TRACING_FLAGS': '3',
13:39:02 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
13:39:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
13:39:02 INFO - Ignoring indexes: https://pypi.python.org/simple/
13:39:02 INFO - Downloading/unpacking blobuploader==1.2.4
13:39: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
13:39: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
13:39:06 INFO - Downloading blobuploader-1.2.4.tar.gz
13:39:06 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader
13:39:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4)
13:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
13:39:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
13:39:06 INFO - Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests
13:39:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4)
13:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
13:39:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
13:39:07 INFO - Downloading docopt-0.6.1.tar.gz
13:39:07 INFO - Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt
13:39:07 INFO - Installing collected packages: blobuploader, requests, docopt
13:39:07 INFO - Running setup.py install for blobuploader
13:39:07 INFO - Running setup.py install for requests
13:39:08 INFO - Running setup.py install for docopt
13:39:08 INFO - Successfully installed blobuploader requests docopt
13:39:08 INFO - Cleaning up...
13:39:09 INFO - Return code: 0
13:39:09 INFO - Installing None into virtualenv C:\slave\test\build/venv
13:39:09 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')]}
13:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
13:39:09 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')]}
13:39:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
13:39:09 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 0x018D8640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0190FE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01852B28>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01929E90>, '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 0x0132A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01996520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-086', 'USERDOMAIN': 'T-W732-IX-086', '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-086', '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
13:39:09 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
13:39:09 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
13:39:09 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
13:39:09 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
13:39:09 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
13:39:09 INFO - 'COMPUTERNAME': 'T-W732-IX-086',
13:39:09 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
13:39:09 INFO - 'CYGWINBASE': 'C:\\cygwin',
13:39:09 INFO - 'DCLOCATION': 'SCL3',
13:39:09 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
13:39:09 INFO - 'FP_NO_HOST_CHECK': 'NO',
13:39:09 INFO - 'HOMEDRIVE': 'C:',
13:39:09 INFO - 'HOMEPATH': '\\Users\\cltbld',
13:39:09 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
13:39:09 INFO - 'KTS_VERSION': '1.19c',
13:39:09 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
13:39:09 INFO - 'LOGONSERVER': '\\\\T-W732-IX-086',
13:39:09 INFO - 'MONDIR': 'C:\\Monitor_config\\',
13:39:09 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
13:39:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
13:39:09 INFO - 'MOZ_NO_REMOTE': '1',
13:39:09 INFO - 'NO_EM_RESTART': '1',
13:39:09 INFO - 'NUMBER_OF_PROCESSORS': '8',
13:39:09 INFO - 'OS': 'Windows_NT',
13:39:09 INFO - 'OURDRIVE': 'C:',
13:39:09 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;',
13:39:09 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
13:39:09 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
13:39:09 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
13:39:09 INFO - 'PROCESSOR_LEVEL': '6',
13:39:09 INFO - 'PROCESSOR_REVISION': '1e05',
13:39:09 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
13:39:09 INFO - 'PROGRAMFILES': 'C:\\Program Files',
13:39:09 INFO - 'PROMPT': '$P$G',
13:39:09 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
13:39:09 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
13:39:09 INFO - 'PUBLIC': 'C:\\Users\\Public',
13:39:09 INFO - 'PWD': 'C:\\slave\\test',
13:39:09 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
13:39:09 INFO - 'SLAVEDIR': 'C:\\slave\\',
13:39:09 INFO - 'SYSTEMDRIVE': 'C:',
13:39:09 INFO - 'SYSTEMROOT': 'C:\\windows',
13:39:09 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
13:39:09 INFO - 'TEST1': 'testie',
13:39:09 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
13:39:09 INFO - 'USERDOMAIN': 'T-W732-IX-086',
13:39:09 INFO - 'USERNAME': 'cltbld',
13:39:09 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
13:39:09 INFO - 'WINDIR': 'C:\\windows',
13:39:09 INFO - 'WINDOWS_TRACING_FLAGS': '3',
13:39:09 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
13:39:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
13:39:09 INFO - Ignoring indexes: https://pypi.python.org/simple/
13:39:09 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser
13:39:09 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-xqlthr-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser
13:39:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash
13:39:10 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-hmnpdm-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash
13:39:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug
13:39:10 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-7argc5-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug
13:39:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice
13:39:10 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-bx3qh5-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice
13:39:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile
13:39:10 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-j4oiws-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile
13:39:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd
13:39:10 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-unyeir-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd
13:39:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo
13:39:10 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-vqx9o9-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo
13:39:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall
13:39:10 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-ktmgfi-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall
13:39:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak
13:39:10 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-dzgw7r-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak
13:39:11 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog
13:39:11 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-yaowao-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog
13:39:11 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork
13:39:11 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-5m_dkj-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork
13:39:11 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess
13:39:11 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-mgo4k1-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess
13:39:11 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile
13:39:11 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-mpdbup-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile
13:39:11 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner
13:39:11 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-eujsth-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner
13:39:11 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot
13:39:11 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-_8tsqy-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot
13:39:11 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest
13:39:11 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-9334ix-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest
13:39:12 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion
13:39:12 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-0ybtxv-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion
13:39:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion
13:39:12 INFO - Running setup.py install for manifestparser
13:39:12 INFO - Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts
13:39:12 INFO - Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts
13:39:12 INFO - Running setup.py install for mozcrash
13:39:13 INFO - Running setup.py install for mozdebug
13:39:13 INFO - Running setup.py install for mozdevice
13:39:13 INFO - Installing sutini-script.py script to C:\slave\test\build\venv\Scripts
13:39:13 INFO - Installing sutini.exe script to C:\slave\test\build\venv\Scripts
13:39:13 INFO - Installing dm-script.py script to C:\slave\test\build\venv\Scripts
13:39:13 INFO - Installing dm.exe script to C:\slave\test\build\venv\Scripts
13:39:14 INFO - Running setup.py install for mozfile
13:39:14 INFO - Running setup.py install for mozhttpd
13:39:14 INFO - Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts
13:39:14 INFO - Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts
13:39:14 INFO - Running setup.py install for mozinfo
13:39:15 INFO - Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts
13:39:15 INFO - Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts
13:39:15 INFO - Running setup.py install for mozInstall
13:39:15 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts
13:39:15 INFO - Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts
13:39:15 INFO - Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts
13:39:15 INFO - Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts
13:39:15 INFO - Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts
13:39:15 INFO - Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts
13:39:15 INFO - Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts
13:39:15 INFO - Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts
13:39:15 INFO - Running setup.py install for mozleak
13:39:15 INFO - Running setup.py install for mozlog
13:39:16 INFO - Installing structlog-script.py script to C:\slave\test\build\venv\Scripts
13:39:16 INFO - Installing structlog.exe script to C:\slave\test\build\venv\Scripts
13:39:16 INFO - Running setup.py install for moznetwork
13:39:16 INFO - Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts
13:39:16 INFO - Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts
13:39:17 INFO - Running setup.py install for mozprocess
13:39:17 INFO - Running setup.py install for mozprofile
13:39:17 INFO - Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts
13:39:17 INFO - Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts
13:39:17 INFO - Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts
13:39:17 INFO - Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts
13:39:17 INFO - Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts
13:39:17 INFO - Installing view-profile.exe script to C:\slave\test\build\venv\Scripts
13:39:18 INFO - Running setup.py install for mozrunner
13:39:18 INFO - Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts
13:39:18 INFO - Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts
13:39:19 INFO - Running setup.py install for mozscreenshot
13:39:19 INFO - Running setup.py install for moztest
13:39:19 INFO - Running setup.py install for mozversion
13:39:19 INFO - Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts
13:39:19 INFO - Installing mozversion.exe script to C:\slave\test\build\venv\Scripts
13:39:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion
13:39:20 INFO - Cleaning up...
13:39:20 INFO - Return code: 0
13:39:20 INFO - Installing None into virtualenv C:\slave\test\build/venv
13:39:20 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')]}
13:39:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
13:39:20 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')]}
13:39:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
13:39:20 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 0x018D8640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0190FE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01852B28>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01929E90>, '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 0x0132A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01996520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-086', 'USERDOMAIN': 'T-W732-IX-086', '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-086', '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
13:39:20 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
13:39:20 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
13:39:20 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
13:39:20 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
13:39:20 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
13:39:20 INFO - 'COMPUTERNAME': 'T-W732-IX-086',
13:39:20 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
13:39:20 INFO - 'CYGWINBASE': 'C:\\cygwin',
13:39:20 INFO - 'DCLOCATION': 'SCL3',
13:39:20 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
13:39:20 INFO - 'FP_NO_HOST_CHECK': 'NO',
13:39:20 INFO - 'HOMEDRIVE': 'C:',
13:39:20 INFO - 'HOMEPATH': '\\Users\\cltbld',
13:39:20 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
13:39:20 INFO - 'KTS_VERSION': '1.19c',
13:39:20 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
13:39:20 INFO - 'LOGONSERVER': '\\\\T-W732-IX-086',
13:39:20 INFO - 'MONDIR': 'C:\\Monitor_config\\',
13:39:20 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
13:39:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
13:39:20 INFO - 'MOZ_NO_REMOTE': '1',
13:39:20 INFO - 'NO_EM_RESTART': '1',
13:39:20 INFO - 'NUMBER_OF_PROCESSORS': '8',
13:39:20 INFO - 'OS': 'Windows_NT',
13:39:20 INFO - 'OURDRIVE': 'C:',
13:39:20 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;',
13:39:20 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
13:39:20 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
13:39:20 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
13:39:20 INFO - 'PROCESSOR_LEVEL': '6',
13:39:20 INFO - 'PROCESSOR_REVISION': '1e05',
13:39:20 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
13:39:20 INFO - 'PROGRAMFILES': 'C:\\Program Files',
13:39:20 INFO - 'PROMPT': '$P$G',
13:39:20 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
13:39:20 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
13:39:20 INFO - 'PUBLIC': 'C:\\Users\\Public',
13:39:20 INFO - 'PWD': 'C:\\slave\\test',
13:39:20 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
13:39:20 INFO - 'SLAVEDIR': 'C:\\slave\\',
13:39:20 INFO - 'SYSTEMDRIVE': 'C:',
13:39:20 INFO - 'SYSTEMROOT': 'C:\\windows',
13:39:20 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
13:39:20 INFO - 'TEST1': 'testie',
13:39:20 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
13:39:20 INFO - 'USERDOMAIN': 'T-W732-IX-086',
13:39:20 INFO - 'USERNAME': 'cltbld',
13:39:20 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
13:39:20 INFO - 'WINDIR': 'C:\\windows',
13:39:20 INFO - 'WINDOWS_TRACING_FLAGS': '3',
13:39:20 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
13:39:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
13:39:20 INFO - Ignoring indexes: https://pypi.python.org/simple/
13:39:20 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser
13:39:20 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-cmthtu-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser
13:39:20 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))
13:39:20 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash
13:39:20 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-5499me-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash
13:39:20 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))
13:39:20 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug
13:39:20 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-vbd1ak-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug
13:39:21 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))
13:39:21 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice
13:39:21 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-yomhsy-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice
13:39:21 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))
13:39:21 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile
13:39:21 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-sayjsq-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile
13:39:21 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))
13:39:21 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd
13:39:21 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-ouhugn-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd
13:39:21 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))
13:39:21 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo
13:39:21 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-kxoukf-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo
13:39:21 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))
13:39:21 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall
13:39:21 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-swe_z1-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall
13:39:21 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))
13:39:21 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak
13:39:21 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-woe07x-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak
13:39:21 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))
13:39:21 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog
13:39:21 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-_azv7j-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog
13:39:21 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))
13:39:21 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork
13:39:21 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-37j84b-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork
13:39:22 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))
13:39:22 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess
13:39:22 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-gxfv0d-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess
13:39:22 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))
13:39:22 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile
13:39:22 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-8f7mhr-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile
13:39:22 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))
13:39:22 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner
13:39:22 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-li71fl-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner
13:39:22 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))
13:39:22 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot
13:39:22 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-v82dmr-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot
13:39:22 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))
13:39:22 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest
13:39:22 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-gywr9f-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest
13:39:22 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))
13:39:22 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion
13:39:22 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-bd5c84-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion
13:39:22 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))
13:39:22 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))
13:39:22 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))
13:39:22 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))
13:39:22 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))
13:39:22 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))
13:39:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10))
13:39:22 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
13:39:22 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
13:39:24 INFO - Downloading blessings-1.6.tar.gz
13:39:24 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings
13:39:24 INFO - Installing collected packages: blessings
13:39:24 INFO - Running setup.py install for blessings
13:39:24 INFO - Successfully installed blessings
13:39:24 INFO - Cleaning up...
13:39:27 INFO - Return code: 0
13:39:27 INFO - Done creating virtualenv C:\slave\test\build/venv.
13:39:27 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze']
13:39:27 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze
13:39:27 INFO - Reading from file tmpfile_stdout
13:39:27 INFO - Using _rmtree_windows ...
13:39:27 INFO - Using _rmtree_windows ...
13:39:27 INFO - Current package versions:
13:39:27 INFO - blessings == 1.6
13:39:27 INFO - blobuploader == 1.2.4
13:39:27 INFO - docopt == 0.6.1
13:39:27 INFO - functools32 == 3.2.3-2
13:39:27 INFO - jsonschema == 2.5.1
13:39:27 INFO - manifestparser == 1.1
13:39:27 INFO - mozInstall == 1.12
13:39:27 INFO - mozcrash == 0.17
13:39:27 INFO - mozdebug == 0.1
13:39:27 INFO - mozdevice == 0.48
13:39:27 INFO - mozfile == 1.2
13:39:27 INFO - mozhttpd == 0.7
13:39:27 INFO - mozinfo == 0.9
13:39:27 INFO - mozleak == 0.1
13:39:27 INFO - mozlog == 3.4
13:39:27 INFO - moznetwork == 0.27
13:39:27 INFO - mozprocess == 0.23
13:39:27 INFO - mozprofile == 0.28
13:39:27 INFO - mozrunner == 6.12
13:39:27 INFO - mozscreenshot == 0.1
13:39:27 INFO - mozsystemmonitor == 0.3
13:39:27 INFO - moztest == 0.7
13:39:27 INFO - mozversion == 1.4
13:39:27 INFO - psutil == 3.1.1
13:39:27 INFO - requests == 1.2.3
13:39:27 INFO - Installing None into virtualenv C:\slave\test\build/venv
13:39:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
13:39:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
13:39:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
13:39:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
13:39:27 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 0x018D8640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0190FE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01852B28>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01929E90>, '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 0x0132A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01996520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build\\tests\\talos', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-086', 'USERDOMAIN': 'T-W732-IX-086', '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-086', '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
13:39:27 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
13:39:27 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
13:39:27 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
13:39:27 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
13:39:27 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
13:39:27 INFO - 'COMPUTERNAME': 'T-W732-IX-086',
13:39:27 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
13:39:27 INFO - 'CYGWINBASE': 'C:\\cygwin',
13:39:27 INFO - 'DCLOCATION': 'SCL3',
13:39:27 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
13:39:27 INFO - 'FP_NO_HOST_CHECK': 'NO',
13:39:27 INFO - 'HOMEDRIVE': 'C:',
13:39:27 INFO - 'HOMEPATH': '\\Users\\cltbld',
13:39:27 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
13:39:27 INFO - 'KTS_VERSION': '1.19c',
13:39:27 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
13:39:27 INFO - 'LOGONSERVER': '\\\\T-W732-IX-086',
13:39:27 INFO - 'MONDIR': 'C:\\Monitor_config\\',
13:39:27 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
13:39:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
13:39:27 INFO - 'MOZ_NO_REMOTE': '1',
13:39:27 INFO - 'NO_EM_RESTART': '1',
13:39:27 INFO - 'NUMBER_OF_PROCESSORS': '8',
13:39:27 INFO - 'OS': 'Windows_NT',
13:39:27 INFO - 'OURDRIVE': 'C:',
13:39:27 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;',
13:39:27 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
13:39:27 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
13:39:27 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
13:39:27 INFO - 'PROCESSOR_LEVEL': '6',
13:39:27 INFO - 'PROCESSOR_REVISION': '1e05',
13:39:27 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
13:39:27 INFO - 'PROGRAMFILES': 'C:\\Program Files',
13:39:27 INFO - 'PROMPT': '$P$G',
13:39:27 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
13:39:27 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
13:39:27 INFO - 'PUBLIC': 'C:\\Users\\Public',
13:39:27 INFO - 'PWD': 'C:\\slave\\test',
13:39:27 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
13:39:27 INFO - 'SLAVEDIR': 'C:\\slave\\',
13:39:27 INFO - 'SYSTEMDRIVE': 'C:',
13:39:27 INFO - 'SYSTEMROOT': 'C:\\windows',
13:39:27 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
13:39:27 INFO - 'TEST1': 'testie',
13:39:27 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
13:39:27 INFO - 'USERDOMAIN': 'T-W732-IX-086',
13:39:27 INFO - 'USERNAME': 'cltbld',
13:39:27 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
13:39:27 INFO - 'WINDIR': 'C:\\windows',
13:39:27 INFO - 'WINDOWS_TRACING_FLAGS': '3',
13:39:27 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
13:39:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
13:39:28 INFO - Ignoring indexes: https://pypi.python.org/simple/
13:39:28 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))
13:39:28 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))
13:39:28 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))
13:39:28 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))
13:39:28 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))
13:39:28 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))
13:39:28 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))
13:39:28 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))
13:39:28 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))
13:39:28 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))
13:39:28 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))
13:39:28 INFO - Cleaning up...
13:39:28 INFO - Return code: 0
13:39:28 INFO - Installing jsonschema into virtualenv C:\slave\test\build/venv
13:39:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
13:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
13:39:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
13:39:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
13:39:28 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 0x018D8640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0190FE30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x01852B28>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01929E90>, '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 0x0132A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01996520>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-086', 'USERDOMAIN': 'T-W732-IX-086', '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-086', '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
13:39:28 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
13:39:28 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
13:39:28 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
13:39:28 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
13:39:28 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
13:39:28 INFO - 'COMPUTERNAME': 'T-W732-IX-086',
13:39:28 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
13:39:28 INFO - 'CYGWINBASE': 'C:\\cygwin',
13:39:28 INFO - 'DCLOCATION': 'SCL3',
13:39:28 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
13:39:28 INFO - 'FP_NO_HOST_CHECK': 'NO',
13:39:28 INFO - 'HOMEDRIVE': 'C:',
13:39:28 INFO - 'HOMEPATH': '\\Users\\cltbld',
13:39:28 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
13:39:28 INFO - 'KTS_VERSION': '1.19c',
13:39:28 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
13:39:28 INFO - 'LOGONSERVER': '\\\\T-W732-IX-086',
13:39:28 INFO - 'MONDIR': 'C:\\Monitor_config\\',
13:39:28 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
13:39:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
13:39:28 INFO - 'MOZ_NO_REMOTE': '1',
13:39:28 INFO - 'NO_EM_RESTART': '1',
13:39:28 INFO - 'NUMBER_OF_PROCESSORS': '8',
13:39:28 INFO - 'OS': 'Windows_NT',
13:39:28 INFO - 'OURDRIVE': 'C:',
13:39:28 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;',
13:39:28 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
13:39:28 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
13:39:28 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
13:39:28 INFO - 'PROCESSOR_LEVEL': '6',
13:39:28 INFO - 'PROCESSOR_REVISION': '1e05',
13:39:28 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
13:39:28 INFO - 'PROGRAMFILES': 'C:\\Program Files',
13:39:28 INFO - 'PROMPT': '$P$G',
13:39:28 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
13:39:28 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
13:39:28 INFO - 'PUBLIC': 'C:\\Users\\Public',
13:39:28 INFO - 'PWD': 'C:\\slave\\test',
13:39:28 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
13:39:28 INFO - 'SLAVEDIR': 'C:\\slave\\',
13:39:28 INFO - 'SYSTEMDRIVE': 'C:',
13:39:28 INFO - 'SYSTEMROOT': 'C:\\windows',
13:39:28 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
13:39:28 INFO - 'TEST1': 'testie',
13:39:28 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
13:39:28 INFO - 'USERDOMAIN': 'T-W732-IX-086',
13:39:28 INFO - 'USERNAME': 'cltbld',
13:39:28 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
13:39:28 INFO - 'WINDIR': 'C:\\windows',
13:39:28 INFO - 'WINDOWS_TRACING_FLAGS': '3',
13:39:28 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
13:39:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
13:39:28 INFO - Ignoring indexes: https://pypi.python.org/simple/
13:39:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in c:\slave\test\build\venv\lib\site-packages
13:39:28 INFO - Cleaning up...
13:39:28 INFO - Return code: 0
13:39:28 INFO - Running post-action listener: _resource_record_post_action
13:39:28 INFO - Running post-action listener: _start_resource_monitoring
13:39:28 INFO - Starting resource monitoring.
13:39:28 INFO - [mozharness: 2016-09-22 20:39:28.691000Z] Finished create-virtualenv step (success)
13:39:28 INFO - [mozharness: 2016-09-22 20:39:28.691000Z] Running install step.
13:39:28 INFO - Running pre-action listener: _resource_record_pre_action
13:39:28 INFO - Running main action method: install
13:39:28 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze']
13:39:28 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze
13:39:29 INFO - Reading from file tmpfile_stdout
13:39:29 INFO - Using _rmtree_windows ...
13:39:29 INFO - Using _rmtree_windows ...
13:39:29 INFO - Detecting whether we're running mozinstall >=1.0...
13:39:29 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h']
13:39:29 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h
13:39:29 INFO - Reading from file tmpfile_stdout
13:39:29 INFO - Output received:
13:39:29 INFO - Usage: mozinstall-script.py [options] installer
13:39:29 INFO - Options:
13:39:29 INFO - -h, --help show this help message and exit
13:39:29 INFO - -d DEST, --destination=DEST
13:39:29 INFO - Directory to install application into. [default:
13:39:29 INFO - "C:\slave\test"]
13:39:29 INFO - --app=APP Application being installed. [default: firefox]
13:39:29 INFO - Using _rmtree_windows ...
13:39:29 INFO - Using _rmtree_windows ...
13:39:29 INFO - mkdir: C:\slave\test\build\application
13:39:29 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']
13:39:29 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
13:39:31 INFO - Reading from file tmpfile_stdout
13:39:31 INFO - Output received:
13:39:31 INFO - C:\slave\test\build\application\firefox\firefox.exe
13:39:31 INFO - Using _rmtree_windows ...
13:39:31 INFO - Using _rmtree_windows ...
13:39:31 INFO - Running post-action listener: _resource_record_post_action
13:39:31 INFO - [mozharness: 2016-09-22 20:39:31.328000Z] Finished install step (success)
13:39:31 INFO - [mozharness: 2016-09-22 20:39:31.328000Z] Running run-tests step.
13:39:31 INFO - Running pre-action listener: _resource_record_pre_action
13:39:31 INFO - Running main action method: run_tests
13:39:31 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version']
13:39:31 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version
13:39:31 INFO - Python 2.7.3
13:39:31 INFO - Return code: 0
13:39:31 INFO - grabbing minidump binary from tooltool
13:39:31 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')]}
13:39:31 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 0x01929E90>, '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 0x0132A910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01996520>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1
13:39:31 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
13:39:31 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
13:39:31 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
13:39:31 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'...
13:39:31 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmpchnzkb
13:39:31 INFO - INFO - File integrity verified, renaming tmpchnzkb to win32-minidump_stackwalk.exe
13:39:31 INFO - Return code: 0
13:39:31 INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755
13:39:31 INFO - mkdir: C:\slave\test\build\blobber_upload_dir
13:39:31 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir
13:39:31 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe
13:39:31 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir
13:39:31 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/fdJN3ltLS7aaJH-HDdPE2w/artifacts/public/build/firefox-52.0a1.en-US.win32.crashreporter-symbols.zip', '--title', 'T-W732-IX-086', '--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
13:39:31 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/fdJN3ltLS7aaJH-HDdPE2w/artifacts/public/build/firefox-52.0a1.en-US.win32.crashreporter-symbols.zip --title T-W732-IX-086 --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
13:39:31 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
13:39:31 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
13:39:31 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
13:39:31 INFO - 'COMPUTERNAME': 'T-W732-IX-086',
13:39:31 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
13:39:31 INFO - 'CYGWINBASE': 'C:\\cygwin',
13:39:31 INFO - 'DCLOCATION': 'SCL3',
13:39:31 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
13:39:31 INFO - 'FP_NO_HOST_CHECK': 'NO',
13:39:31 INFO - 'HOMEDRIVE': 'C:',
13:39:31 INFO - 'HOMEPATH': '\\Users\\cltbld',
13:39:31 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
13:39:31 INFO - 'KTS_VERSION': '1.19c',
13:39:31 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
13:39:31 INFO - 'LOGONSERVER': '\\\\T-W732-IX-086',
13:39:31 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir',
13:39:31 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe',
13:39:31 INFO - 'MONDIR': 'C:\\Monitor_config\\',
13:39:31 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
13:39:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
13:39:31 INFO - 'MOZ_NO_REMOTE': '1',
13:39:31 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir',
13:39:31 INFO - 'NO_EM_RESTART': '1',
13:39:31 INFO - 'NUMBER_OF_PROCESSORS': '8',
13:39:31 INFO - 'OS': 'Windows_NT',
13:39:31 INFO - 'OURDRIVE': 'C:',
13:39:31 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;',
13:39:31 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
13:39:31 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
13:39:31 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
13:39:31 INFO - 'PROCESSOR_LEVEL': '6',
13:39:31 INFO - 'PROCESSOR_REVISION': '1e05',
13:39:31 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
13:39:31 INFO - 'PROGRAMFILES': 'C:\\Program Files',
13:39:31 INFO - 'PROMPT': '$P$G',
13:39:31 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
13:39:31 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
13:39:31 INFO - 'PUBLIC': 'C:\\Users\\Public',
13:39:31 INFO - 'PWD': 'C:\\slave\\test',
13:39:31 INFO - 'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos',
13:39:31 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
13:39:31 INFO - 'SLAVEDIR': 'C:\\slave\\',
13:39:31 INFO - 'SYSTEMDRIVE': 'C:',
13:39:31 INFO - 'SYSTEMROOT': 'C:\\windows',
13:39:31 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
13:39:31 INFO - 'TEST1': 'testie',
13:39:31 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
13:39:31 INFO - 'USERDOMAIN': 'T-W732-IX-086',
13:39:31 INFO - 'USERNAME': 'cltbld',
13:39:31 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
13:39:31 INFO - 'WINDIR': 'C:\\windows',
13:39:31 INFO - 'WINDOWS_TRACING_FLAGS': '3',
13:39:31 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
13:39:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
13:39:31 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/fdJN3ltLS7aaJH-HDdPE2w/artifacts/public/build/firefox-52.0a1.en-US.win32.crashreporter-symbols.zip', '--title', 'T-W732-IX-086', '--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
13:39:33 INFO - mozversion application_buildid: 20160922093055
13:39:33 INFO - mozversion application_changeset: 190e45ee01153267e1507726381f41379d2e3673
13:39:33 INFO - mozversion application_display_name: Nightly
13:39:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384}
13:39:33 INFO - mozversion application_name: Firefox
13:39:33 INFO - mozversion application_remotingname: firefox
13:39:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team
13:39:33 INFO - mozversion application_vendor: Mozilla
13:39:33 INFO - mozversion application_version: 52.0a1
13:39:33 INFO - mozversion platform_buildid: 20160922093055
13:39:33 INFO - mozversion platform_changeset: 190e45ee01153267e1507726381f41379d2e3673
13:39:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team
13:39:33 INFO - mozversion platform_version: 52.0a1
13:39:33 INFO - using testdate: 1474576773
13:39:33 INFO - actual date: 1474576773
13:39:33 INFO - starting webserver on 'localhost:49608'
13:39:33 INFO - SUITE-START | Running 2 tests
13:39:33 INFO - TEST-START | dromaeo_css
13:39:33 INFO - operating with platform_type : w7_
13:39:33 INFO - Initialising browser for dromaeo_css test...
13:39:33 INFO - TEST-INFO | started process 3960 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld\appdata\local\temp\tmpba2euq\profile http://localhost:49608/getInfo.html)
13:39:40 INFO - PROCESS | 3960 | __metrics Screen width/height:1600/1200
13:39:40 INFO - PROCESS | 3960 | colorDepth:24
13:39:40 INFO - PROCESS | 3960 | Browser inner width/height: 1010/674
13:39:40 INFO - PROCESS | 3960 | __metrics
13:39:41 INFO - PROCESS | 3960 | 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"
13:39:41 INFO - PROCESS | 3960 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver]
13:39:42 INFO - TEST-INFO | 3960: exit 0
13:39:42 INFO - Browser initialized.
13:39:42 INFO - Running cycle 1/1 for dromaeo_css test...
13:39:42 INFO - TEST-INFO | started process 3076 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld\appdata\local\temp\tmpba2euq\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1)
13:39:42 INFO - PROCESS | 3076 | [GFX1-]: Invalid size in UpdateRenderTarget Size(116,0), 0
13:39:53 INFO - PROCESS | 3076 | RSS: Main: 124112896
13:39:53 INFO - PROCESS | 3076 |
13:40:44 INFO - PROCESS | 3076 | 1474576844756 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]
13:42:54 INFO - PROCESS | 3076 | Cycle 1(1): loaded http://localhost:49608/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49608/tests/dromaeo/cssquery-ext.html)
13:42:56 INFO - PROCESS | 3076 | RSS: Main: 259334144
13:42:56 INFO - PROCESS | 3076 |
13:45:58 INFO - PROCESS | 3076 | Cycle 1(1): loaded http://localhost:49608/tests/dromaeo/cssquery-ext.html (next: http://localhost:49608/tests/dromaeo/cssquery-jquery.html)
13:45:59 INFO - PROCESS | 3076 | RSS: Main: 199012352
13:45:59 INFO - PROCESS | 3076 |
13:49:01 INFO - PROCESS | 3076 | Cycle 1(1): loaded http://localhost:49608/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49608/tests/dromaeo/cssquery-mootools.html)
13:49:02 INFO - PROCESS | 3076 | RSS: Main: 138211328
13:49:02 INFO - PROCESS | 3076 |
13:52:03 INFO - PROCESS | 3076 | Cycle 1(1): loaded http://localhost:49608/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49608/tests/dromaeo/cssquery-prototype.html)
13:52:04 INFO - PROCESS | 3076 | RSS: Main: 147099648
13:52:04 INFO - PROCESS | 3076 |
13:55:07 INFO - PROCESS | 3076 | Cycle 1(1): loaded http://localhost:49608/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49608/tests/dromaeo/cssquery-yui.html)
13:55:07 INFO - PROCESS | 3076 | RSS: Main: 134168576
13:55:07 INFO - PROCESS | 3076 |
13:58:10 INFO - PROCESS | 3076 | Cycle 1(1): loaded http://localhost:49608/tests/dromaeo/cssquery-yui.html (next: http://localhost:49608/tests/dromaeo/cssquery-dojo.html)
13:58:10 INFO - PROCESS | 3076 | RSS: Main: 248348672
13:58:10 INFO - PROCESS | 3076 |
13:58:10 INFO - PROCESS | 3076 | __start_tp_report
13:58:10 INFO - PROCESS | 3076 | _x_x_mozilla_page_load
13:58:10 INFO - PROCESS | 3076 | _x_x_mozilla_page_load_details
13:58:10 INFO - PROCESS | 3076 | |i|pagename|runs|
13:58:10 INFO - PROCESS | 3076 | |0;dojo.html;2757.2417585164076;2771.5704065869786;2812.66248050234;2814.8592570371475;2819.760320372768;4822.638302127346;4879.902401951963;4899;4916.827911023115;4934.827281045164;4727.290906364038;4791.9697265088;4855.126077306083;4857;4967.478414766442;4172.561881002482;4190.182914331706;4201.285781417158;4247.235497610429;4293.441852559178;4025.7383270087353;4208.936865947013;4246.214450326699;4282.29342158545;4296.957030429702;4202.411662367271;4230.534641189467;4269.914601707964;4294.463192100988;4319.50325712544;3940.6847452203756;4061.1065565575527;4158.313878210091;4280.892977675552;4298.290782020963;4122.381642753581;4147.6474499667265;4150.315197992358;4191.874243772691;4208.053188032699;4744.976275118603;4826.034793041371;4837.298591704183;4841.661083724141;4851.5391037851705;4896.583790377822;5022.296878437021;5029.17018691919;5123.410807757081;5129.025485157846;4997.800087996476;5020.196768517057;5066.088104141253;5175.197844334134;5191.169412893919;4666.813327466897;4703.200455922467;4741.5732584067255;4742.2886567014875;4747.548982846624;4958.975205123951;5039.924401133986;5121.53906148441;5221.765020574083;5234.92147617786;5003.699778013331;5004.274380214849;5016.372953380827;5020.723860187652;5022.246663000579;5085.262636917626;5101.387833459934;5106.463821298785;5107.897842043139;5113.744312784346;5040.067587496325;5080.517350851663;5084.084864724385;5088.363954505687;5094.490550944876;5026.271190677331;5033.219850923113;5034.395872495251;5086.21163719624;5148.3564554430695;3282.622498412665;3305.6033276007033;3430.5711786026745;3437.9686094171648;3439.3465241604517;3028.439738648357;3061.418330517239;3112.486439737463;3130.358276553301;3139.5447660089617;4791.329213910055;4819.277108433693;4831.98528309052;4877.097736918681;4897.7795999180125;4897.510248975145;5095.566876815438;5096.133657278272;5124.615653825978;5127.2052831811125;4848.200046992207;4855.368802055781;4936.975315123402;4952.950470495321;4953.90092198154;4134.91730165395;4223.936640950388;4231.090315582103;4249.320108782642;4298.570142985739;5376;5399.757010934517;5476.658218736435;5483.7258137092185;5489.533389661923;5046.21783623539;5105.770240339268;5186.844394668166;5200.063988482109;5210.6613070150315;5311.309529761106;5347.251384806053;5359.062164121186;5481.287432633732;5495.477929596682;5009.924851127309;5037.672551284155;5046.949530504648;5052.292679025013;5053.166227572409;5152.330197074356;5169.896602068013;5174.094533456705;5178.223266510054;5179.352580927384;4959.603231741524;5008.373953255843;5013.047520971004;5013.674111182761;5016.749162541932;4819.975900120477;4999.375078115236;5008.749562521786;5015.072211640858;5015.799368025384;4892.559669629608;4927.162382394929;4938.111139994836;4940.975295123501;4944.1100601892;4810.63920205979;4938.160512712776;4980.078685443204;5003;5033.773480193327;4888.926666100083;4898.583620392306;4924.803007879645;5001.224810154432;5010.9749451253965
13:58:10 INFO - PROCESS | 3076 | |1;ext.html;527.180234734987;556.4407770190958;557.7462254674124;560.6327855254808;564.041130078866;28740.856295718546;30778.07665770025;30895;31041.84479077607;40414.39378409326;38192.80903595485;41396.37905431414;41410.964725881866;41452.17095658085;41469;8275.62759675813;8304.837322774787;8342.040665323475;8348.206920342589;8425.662973481054;8295.294899933513;8381.371397145238;8397.538135402581;8424.663013479485;8427.410081294312;8369.246767790897;8396.790080247982;8422.241998220159;8441.915580844205;8446.282066024396;8146.5112093274;8362.331013518904;8396.202360775716;8410.957945210235;8425.11536288687;8282.006159260867;8314.875276870851;8377.9946406431;8381.580920953927;8399.076101628816;38037.80981095105;38094.238115237815;38272.42591361132;38408.23183536342;38434.615653843386;3060.617422822147;3154.921126971821;3221.7390441015827;3490.5636795400574;3576.034470692898;30046.69953300461;30290.697093029008;30471.238219044702;30842.228944276347;31337.37325253482;3448.379291727488;3546.060294022086;3558.4128618777872;3625.093726568358;3642.1076836175043;306829;324818;324938.9999999976;326174;326969;51765.741171294656;51813;52022;52103;52163.47836521662;54075;54914.72542637261;59636.40363596395;60252.39747602556;60890;14078.648033799236;14133.434662613587;14343.641408964651;14664.120152790867;14680.92659536717;11014.559417623366;11093.889061109447;11105.611303604497;11109.777804443866;11115.888841111486;18046.909765451088;18214.90892545529;18287.817121828877;18291.72562411565;18297.542561436072;7306.305900939402;7386.704531818775;7411.2588741125455;7450.478466507401;7455.776326710207;783.5807842804072;856.3577317012241;899.6626265150569;925.6898938855425;965.7633879699519;28439.857800711277;29076.273093172418;29356.706432935825;29674.703252967192;29754;915.706973768401;935.09841836482;977.8533220017055;1000.3747657713928;1058.6929790360864;14803.48187813443;14975.251237438084;14979.176145311894;15387.230638468032;15404;459918;464068;514171;517538;519411;49322.75338623284;50247.748761255956;50461.49538504568;51060;51134;1021.3871676993745;1064.5209655654987;1097.7639807441437;1106.9815769492086;1131.615250814727;27437.31406714848;28277.71722282751;29443.558346625246;29546.261343465725;29816.85091574615;43088.138237235704;43641.3453798187;44107;44116.779416104;44196.337054944845;340104;380087;380388;381744;381946;32238.19404514906;33015.17462063468;37713.62286377101;37855;38618.42072368861;42945.785271074696;42946.570534295504;42950.14099717926;44334.55665443304;44429.777851110535;36162.8191859039;37209.62790372062;37428.251434971695;37589.62410375971;37932.43101353537;37393.626063739015;37605.33567634499;37698;38216.80891595524;38232.426513601764;36369.45445818262;36671.266574668894;36775.448368275036;36790.26419471649;36884.63115368812;32131.839340803148;33555.32889342151;33933.32133357369;34008.65991340055;35035.299294013465;25702.485950281265;26170.738292617592;26279.21162365132;26319.605205921544;26511.602325965512
13:58:10 INFO - PROCESS | 3076 | |2;jquery.html;290.2091799845423;314.6475946939427;315.3944426700736;315.6149497612912;319.1844836442889;13066.542671006517;17164.485065448025;17258.65482690347;17364.305427782907;17600.20799064042;17072.914635426805;17152.82847171528;17264.395746148886;17436.953782773042;17579.64840703185;5207.270982062505;5410.783568657249;5415.458454154573;5415.9458405415835;5417.404085550606;4992.350994370745;5098.082345177866;5335.706536140511;5348.973255133719;5352.652077614962;5010;5293.338332708411;5308.734563271821;5309.469053094698;5311;5004.774785134678;5182.119039763249;5308.46915308468;5310.73446327684;5364.91952620711;4630.768461576908;4652.720836749772;4656.4412270527755;4656.953430465685;4666.836660716893;19931.402057938285;21627.35011972418;21947.780522194735;22062;22140.55718885613;1853.9351122710775;1894.5074280686983;1929.8938558379284;2409.204962362416;2758.6413766210467;13787.51743688976;13914.791278130837;14108.85891141096;14405;14447.855521444757;1715.073860115536;1744.6859565278244;1755.2452445448453;1814.8185181481879;1849.546861019059;81615;83720.0697975574;85058;85466.14533854707;85738;8574.528400937883;8661.30709543235;8708.651653933899;8908.955455222682;8959.23846473044;10403;10728.356298622108;10896.12830973536;11312.830307545393;11362.545498180145;6900.275471075565;7027.789166325018;7275.199728029913;7373.88939165913;7393.5231697380905;7420.406367490587;7547.320741133214;7556.282153195438;7663.042119735033;7672.194419585975;5683.658980461186;5734.168545560954;5771.740271687784;5799.6230245034785;5872.706364681749;1525.4279645133074;1531.931063102163;1535.094294366307;1541.352631894607;1544.7065057639238;812.4231795425196;826.2604968553111;883.4831623500196;893.4505279253342;900.9054049324726;18099.185536650883;18437.037516879707;18522.722159167624;19183.712244316346;19326;833.0960907415522;845.6617353058825;864.6498168241872;900.428228075177;901.1079031758512;9961.452120133463;10312.432816195182;10453.529591168415;10747.516361763739;10808.405537695502;433046;437295;442641;448620;453838;92502.1865309689;93992.53003735075;96181;96823.51588242014;97631;901.4816480523725;941.0636416765226;950.6197520991659;963.036963036963;964.344245912786;15952.202389880691;16188.167070762334;17050.48848534546;17245.396411125552;17715.645687086442;34832.47751283783;41595;41784.58215417807;45611.31583026191;45722;54752.45247547473;58142.70928645499;58287.70856145692;58531.70734146302;58728.70635646794;6026.427489388501;6046.183765191643;6154.846128846635;6327.588706734047;6340.587861788969;8644.870326945227;9327.906720932704;12076;12189.634310970685;12360.25838449696;9535.046495350409;10168.237382196512;10213.131883789663;10417.47912604382;10490.478880562428;9856.408615483095;10073.244506662177;10089.890112087518;10331;10453.68638940833;9760.414375137514;10165.491725413847;10278.229132815219;10465.581376744845;10592.576296948037;7192;7212.459065570209;7373.115226172894;7378.667959941708;7381.704731810667;7251.746188883364;9494.667686630935;9906.455144966807;10111.797764044824;10810.67567972962
13:58:10 INFO - PROCESS | 3076 | |3;mootools.html;1162.4013632979018;1189.7204157023098;1262.3435813377043;1554.9222538873053;1560.1653115583165;6864.65676716164;7314.122305323369;7332.523385979915;7334.156571994222;7337.596432196227;6406.519511036668;6609.504287178469;6747;6990.510664253505;7159.677814498347;1813.3200049981258;1875.3061367294051;1878.2017642501883;1879.5113270549618;1883.2372888979917;1887.1036257777582;1889.7543319368463;1899.6485650154696;1910.3504808365153;1914.4543805015574;1600.7038697840878;1654.7848779658627;1659.1538315459143;1822.2528763207088;1895.9431217063511;1910.1977169588736;1923.0480911948534;1923.1634239105895;1926.3739284732378;1937.1670181821812;1818.9818101818944;1822.362173239369;1827.2051657529018;1836.669399508088;1842.106578309532;7044.943258511213;7142.250063743284;7238.565686058853;7252.963735181291;7253.7098516059295;4259.2759230930815;4335.588119128678;4350.303951367766;4351.173277077345;4371.715838470489;2904.302967287857;2904.782141339408;2955.335049613841;2962.837043962581;2999.895003674861;921.7465197070859;943.3160958305242;952.9475878826662;953.142172045158;958.3195930889077;9213.262938964866;9236.445813251159;9238.769030774218;9248.583813728399;9249.075092490764;3535.116220944764;3704.8518059277867;3728.7203459740085;3754.511913451234;3760.1163726524246;8073.19268073188;8073.354131669453;8082.9191708083345;8113.837723245502;8122.593870306461;4277.465316835395;4312.460942382202;4334.089841133335;4340.826366945287;4346.717463364871;3813.790241536742;4011.338129208648;4016.116454380032;4023.3964905264443;4028.8589899353383;3042.2242328206166;3048.6646468888403;3117.1427857339413;3130.7182353588287;3145.889893853704;958.712386284112;961.9615215391306;986.8371718666483;988.0021178609657;1000.4747507558444;695.408902432928;737.7860420478108;787.0673252196166;793.15132807895;799.7480793550013;4525.773711314421;4582.610478109398;4619.2378257587125;4623.53764623535;4739.928901066487;318.62243241758125;334.4214508899617;334.87107463626677;335.77335298673296;342.6864419056585;2951.5867778511024;3010.412969470976;3039.893603723903;3065.494193458099;3134.1067795678123;8273.669053237923;8325.25072743456;8574.614142363609;8605.612747426381;8780.868286975701;8607.225349718556;8728.214460698568;8729.345299102466;8731.956340218258;8757.693480728143;6681.665916704145;6714.362135597111;6832.180138383326;6833.897491537631;6847.349501797321;4520.751358675305;4732.290156476556;4773.188557945227;4775.2359622460235;4880.975595122001;7783.377329813715;7895.881561776693;7919.326857217201;7957.1644977276555;7957.681692732457;7787.766367008999;8103.756887293391;8117.594120294079;8146.5519396433765;8171.468854524437;6268.2478102626155;6324.905126423016;6335.936640633535;6345.1434056401795;6355.618662880242;6820.863582728417;6838.58968461874;6857.759978400732;6878.828029299108;6918.757843475454;6250.281217660027;6314.431701146735;6373.267074286517;6387.616742995435;6454.451371633464;5973.731182096729;6216.53375996793;6267.4986001120715;6317.6209427434505;6319.178506794087;5508.504234618904;5561.332640083216;5641.097424412074;5684.658920464785;5733.483986441241;3928.7642741435607;3955.4066889966734;3968.7817170055923;3992.640662340403;4030.3148464760475;4040.3535434330365;4054.2702313583836;4079.326911059642;4124.484439445069;4181.60274773896
13:58:10 INFO - PROCESS | 3076 | |4;prototype.html;240.01712985325088;261.7356469965335;264.7101423940785;265.41343630576415;269.30116348076734;4925.729084900329;5100.77046532906;5114.181730923053;5194.792208311663;5257.7108259045735;5128.871778205546;5131.794728210867;5138;5154.020736060155;5157.5616072633875;3800.1259710266654;3801.1257410795533;3802.4106263529197;3804.752691075071;3812.7902965336893;3807.276617442691;3817.1983883384523;3818.198178382543;3818.3127037133445;3826.8469261229657;3779.4141908004303;3786.734928555002;3789.5642001169804;3796.1838204785968;3796.7721936683747;3768.4158955361963;3783.6027217142077;3783.7729736215915;3787.791671458069;3791.582925878165;3197.6322722886935;3276.3938671345877;3277.3117645294515;3277.5247589099686;3280.753943454227;4775.355327030841;5018.322526458955;5018.7992480300745;5019.64862459628;5045.394552653668;4336.609705126522;4368.694191406603;4372.803223854934;4382.9342559861625;4413.293872980308;5255.894882102337;5298.443663415324;5312.787488500456;5319.28189694394;5336.199570064521;3317.9668203318142;3401.4727717203873;3610.783352998802;3617.113807117247;3625.23869987303;5412.539934105605;5483.287172667528;5506.127916508366;5532.1425179097305;5558.305211848519;3425.7324789827426;3514.5958214805623;3575.4279315309427;3584.301061293075;3589.407747721649;3469.809160496197;3518.3315170117594;3520.876769313113;3567.964320356763;3632.4914511968345;4279.053030870946;4305.052888364555;4306.74159550428;4308.547602501755;4310;5093.337866077386;5237.135872581058;5313;5362.839114826562;5384.838454846361;1242.43469221504;1255.4413286087604;1256.560203928636;1256.9497220111275;1263.684078980255;761.1399118995499;774.1600363605551;776.8407476467311;785.5443842571295;786.2726977545748;4697.694649847817;4704.9059018819435;4725.605946245797;4728;4730.479647238801;4963.230699241623;4970.701757894538;4978.303037574742;4991.401031876126;5017.4731653175895;4728;4741.691790033706;4990.850274491771;5055.595552355802;5114.923276150861;2844.2747099489497;2903.187107609873;2923.736863682279;2944.0127913658193;2948.498755211619;5848.64908105515;5863.941360586425;5869.767348856788;5873.647581145059;5885.5585831062845;5349.1976203569775;5609.80365687199;5637.689927054052;5646.943530564642;5658.405867383948;5849.853753656193;5897.439743224387;5914.260717410324;5920.5559583031445;5930.940690593039;5370.731463426735;5523.978064058162;5577.3028371453565;5581.413951535031;5591.776328946797;5402.621816472809;5450.1007333789485;5458.8908221834545;5463.945360546502;5472.781088756406;5623.662580245198;5829.1437195774615;5859.794907178229;5908.704564771659;5921.526277897844;3593.6765691087926;3611.0430735854493;3621.7102631788866;3627.220147668264;3631.7276204285313;5523.585731070106;5563.415841336763;5575.553955683617;5599.0045325750525;5618.353889302783;5112.207607820794;5339.985402773461;5367.436419176087;5373.596980226421;5400.324959380077;5350.090484617702;5364.865878353073;5369.48989845964;5372.549411658908;5393.487618676219;5258.342707161605;5269.182132164397;5271.71005594696;5299.708516031656;5300.390455097713;5351.812686555952;5377.865553361197;5386.676799392049;5387.595930305164;5388.73056347189;5094.770735316845;5310.955282216297;5345.465453454779;5351.785928562814;5386.622936394415
13:58:10 INFO - PROCESS | 3076 | |5;yui.html;628.1143587541567;640.438247011952;699.2972063076608;701.9543729657572;728.340851529366;14499.565013049612;15775.132367719756;15776.921115394422;16142.75785863213;17248.22382992765;15470.994385364944;15638;15674.921625391857;15719.292631831566;15781.447649332276;538.9191621256804;644.4522156167255;660.0165753028002;663.0485253660988;663.1577896071985;549;640.7308930249283;657.3393739292005;660.2934859700123;663.4161937494997;687.8658661560997;689.8585789913055;689.9448044156455;691.8996745471903;692.6294432478625;559.8684309187338;686.6738299307839;686.7596341280537;686.7630667419733;687.1307795638471;417.1739954889306;475.1257685858003;485.7037207303542;493.4892386380115;494.38449130831987;14102.929485352508;14335.78496322556;14340.139591624431;14358.425662973574;14392.136471811726;12692.746145077139;12739.04457165707;12977.221366717933;13102.27937463439;13140.934295328558;13561.728765424636;13632.250226237553;13647.931760341235;13807.930960345135;14311.642208944755;4288.785560721983;4351.477822661301;4373.081652852905;4458.130664520388;4491.30384790358;81258.59370703167;85778.14221857765;85852.14147858504;86903;87267.12732872654;10509.264351495322;10555.26113172086;10565.313254638424;10593.788124237471;10669.359838409566;18624.627507450045;18757.155927983273;19023.714644280346;19144.138513766913;19349.61300774005;6872.381485666314;7300.671469783872;7502.3622992046285;7550.5469671819865;7606.733764318223;4037.414574886625;4168.812403441852;4309.935350969738;4397.384366188736;4415.735055896656;2961.4077184562743;3041.4829478988627;3117.968820311813;3158.368326334696;3172.888948886824;552.4475524475524;566.0292598194117;566.1846940405802;571.3686376553932;575.6718670357856;595.0806004722714;664.9534532582672;691.353584398589;702.4134847402374;716.2121666167175;9652.517374131265;9715.473976766092;10081.243906707026;10665.680029599125;10719.249652524248;573.2604939627917;675.3584095109666;707.9610918862114;738.7377480994277;740.0933856026433;4918.680285781485;4987.202047672355;4999.800007999639;5084.466625077979;5090.4655011223285;101603;112694;120233.39883300528;120580;121856;90082.54958725165;99518.01927922947;105091.94908050822;107547;108321.45839270912;92756.53621731984;93885;94478.52760736152;96755;97329;9523.476208808583;9558.808823823623;9659.130678238993;9765.658201962897;9817.410955342702;52209.738951305;54397;54603.180952286544;55749;56591.71704141453;69335.65332173307;80513.59743201247;81417.59291203506;82344.17655823365;82680.17319826725;11497.655070347902;11688.590899318484;11899;11938.880611193777;11940.940295298467;13387.129836560593;13850.722985540435;13880.791788122984;14128.50550230737;14368.353424096149;12813.103082784115;13231.933840330737;13283.203007819562;13397.464101436224;13401.195928244337;12901.225926444444;12981.156224845732;13210.27343496117;13473.730525389241;13798.911185856568;13211.27337996381;13448.193108413527;13522.12106213093;13527.256000920044;13724.519641812489;11404.087672986307;11454.817495389316;11643.126765492452;11692.298462092302;12071.75856482883;10919.781604368027;10950.123990080616;10964.671059868217;11010.889891101308;11119.332840029625
13:58:10 INFO - PROCESS | 3076 | __end_tp_report
13:58:10 INFO - PROCESS | 3076 | __start_cc_report
13:58:10 INFO - PROCESS | 3076 | _x_x_mozilla_cycle_collect,1567
13:58:10 INFO - PROCESS | 3076 | __end_cc_report
13:58:10 INFO - PROCESS | 3076 | __startTimestamp1474577890703__endTimestamp
13:58:10 INFO - PROCESS | 3076 |
13:58:10 INFO - PROCESS | 3076 | ------- Summary: start -------
13:58:10 INFO - PROCESS | 3076 | Number of tests: 6
13:58:10 INFO - PROCESS | 3076 |
13:58:10 INFO - PROCESS | 3076 | [#0] dojo.html Cycles:165 Average:4700.23 Median:4938.16 stddev:622.64 (12.6%) stddev-sans-first:605.61
13:58:10 INFO - PROCESS | 3076 | Values: 2757.2 2771.6 2812.7 2814.9 2819.8 4822.6 4879.9 4899.0 4916.8 4934.8 4727.3 4792.0 4855.1 4857.0 4967.5 4172.6 4190.2 4201.3 4247.2 4293.4 4025.7 4208.9 4246.2 4282.3 4297.0 4202.4 4230.5 4269.9 4294.5 4319.5 3940.7 4061.1 4158.3 4280.9 4298.3 4122.4 4147.6 4150.3 4191.9 4208.1 4745.0 4826.0 4837.3 4841.7 4851.5 4896.6 5022.3 5029.2 5123.4 5129.0 4997.8 5020.2 5066.1 5175.2 5191.2 4666.8 4703.2 4741.6 4742.3 4747.5 4959.0 5039.9 5121.5 5221.8 5234.9 5003.7 5004.3 5016.4 5020.7 5022.2 5085.3 5101.4 5106.5 5107.9 5113.7 5040.1 5080.5 5084.1 5088.4 5094.5 5026.3 5033.2 5034.4 5086.2 5148.4 3282.6 3305.6 3430.6 3438.0 3439.3 3028.4 3061.4 3112.5 3130.4 3139.5 4791.3 4819.3 4832.0 4877.1 4897.8 4897.5 5095.6 5096.1 5124.6 5127.2 4848.2 4855.4 4937.0 4953.0 4953.9 4134.9 4223.9 4231.1 4249.3 4298.6 5376.0 5399.8 5476.7 5483.7 5489.5 5046.2 5105.8 5186.8 5200.1 5210.7 5311.3 5347.3 5359.1 5481.3 5495.5 5009.9 5037.7 5046.9 5052.3 5053.2 5152.3 5169.9 5174.1 5178.2 5179.4 4959.6 5008.4 5013.0 5013.7 5016.7 4820.0 4999.4 5008.7 5015.1 5015.8 4892.6 4927.2 4938.1 4941.0 4944.1 4810.6 4938.2 4980.1 5003.0 5033.8 4888.9 4898.6 4924.8 5001.2 5011.0
13:58:10 INFO - PROCESS | 3076 |
13:58:10 INFO - PROCESS | 3076 | [#1] ext.html Cycles:180 Average:54548.26 Median:209212.90 stddev:106953.17 (51.1%) stddev-sans-first:107176.30
13:58:10 INFO - PROCESS | 3076 | Values: 527.2 556.4 557.7 560.6 564.0 28740.9 30778.1 30895.0 31041.8 40414.4 38192.8 41396.4 41411.0 41452.2 41469.0 8275.6 8304.8 8342.0 8348.2 8425.7 8295.3 8381.4 8397.5 8424.7 8427.4 8369.2 8396.8 8422.2 8441.9 8446.3 8146.5 8362.3 8396.2 8411.0 8425.1 8282.0 8314.9 8378.0 8381.6 8399.1 38037.8 38094.2 38272.4 38408.2 38434.6 3060.6 3154.9 3221.7 3490.6 3576.0 30046.7 30290.7 30471.2 30842.2 31337.4 3448.4 3546.1 3558.4 3625.1 3642.1 306829.0 324818.0 324939.0 326174.0 326969.0 51765.7 51813.0 52022.0 52103.0 52163.5 54075.0 54914.7 59636.4 60252.4 60890.0 14078.6 14133.4 14343.6 14664.1 14680.9 11014.6 11093.9 11105.6 11109.8 11115.9 18046.9 18214.9 18287.8 18291.7 18297.5 7306.3 7386.7 7411.3 7450.5 7455.8 783.6 856.4 899.7 925.7 965.8 28439.9 29076.3 29356.7 29674.7 29754.0 915.7 935.1 977.9 1000.4 1058.7 14803.5 14975.3 14979.2 15387.2 15404.0 459918.0 464068.0 514171.0 517538.0 519411.0 49322.8 50247.7 50461.5 51060.0 51134.0 1021.4 1064.5 1097.8 1107.0 1131.6 27437.3 28277.7 29443.6 29546.3 29816.9 43088.1 43641.3 44107.0 44116.8 44196.3 340104.0 380087.0 380388.0 381744.0 381946.0 32238.2 33015.2 37713.6 37855.0 38618.4 42945.8 42946.6 42950.1 44334.6 44429.8 36162.8 37209.6 37428.3 37589.6 37932.4 37393.6 37605.3 37698.0 38216.8 38232.4 36369.5 36671.3 36775.4 36790.3 36884.6 32131.8 33555.3 33933.3 34008.7 35035.3 25702.5 26170.7 26279.2 26319.6 26511.6
13:58:10 INFO - PROCESS | 3076 |
13:58:10 INFO - PROCESS | 3076 | [#2] jquery.html Cycles:180 Average:27134.46 Median:4829.59 stddev:73667.97 (1525.3%) stddev-sans-first:73847.06
13:58:10 INFO - PROCESS | 3076 | Values: 290.2 314.6 315.4 315.6 319.2 13066.5 17164.5 17258.7 17364.3 17600.2 17072.9 17152.8 17264.4 17437.0 17579.6 5207.3 5410.8 5415.5 5415.9 5417.4 4992.4 5098.1 5335.7 5349.0 5352.7 5010.0 5293.3 5308.7 5309.5 5311.0 5004.8 5182.1 5308.5 5310.7 5364.9 4630.8 4652.7 4656.4 4657.0 4666.8 19931.4 21627.4 21947.8 22062.0 22140.6 1853.9 1894.5 1929.9 2409.2 2758.6 13787.5 13914.8 14108.9 14405.0 14447.9 1715.1 1744.7 1755.2 1814.8 1849.5 81615.0 83720.1 85058.0 85466.1 85738.0 8574.5 8661.3 8708.7 8909.0 8959.2 10403.0 10728.4 10896.1 11312.8 11362.5 6900.3 7027.8 7275.2 7373.9 7393.5 7420.4 7547.3 7556.3 7663.0 7672.2 5683.7 5734.2 5771.7 5799.6 5872.7 1525.4 1531.9 1535.1 1541.4 1544.7 812.4 826.3 883.5 893.5 900.9 18099.2 18437.0 18522.7 19183.7 19326.0 833.1 845.7 864.6 900.4 901.1 9961.5 10312.4 10453.5 10747.5 10808.4 433046.0 437295.0 442641.0 448620.0 453838.0 92502.2 93992.5 96181.0 96823.5 97631.0 901.5 941.1 950.6 963.0 964.3 15952.2 16188.2 17050.5 17245.4 17715.6 34832.5 41595.0 41784.6 45611.3 45722.0 54752.5 58142.7 58287.7 58531.7 58728.7 6026.4 6046.2 6154.8 6327.6 6340.6 8644.9 9327.9 12076.0 12189.6 12360.3 9535.0 10168.2 10213.1 10417.5 10490.5 9856.4 10073.2 10089.9 10331.0 10453.7 9760.4 10165.5 10278.2 10465.6 10592.6 7192.0 7212.5 7373.1 7378.7 7381.7 7251.7 9494.7 9906.5 10111.8 10810.7
13:58:10 INFO - PROCESS | 3076 |
13:58:10 INFO - PROCESS | 3076 | [#3] mootools.html Cycles:180 Average:4620.88 Median:5194.74 stddev:2612.92 (50.3%) stddev-sans-first:2607.32
13:58:10 INFO - PROCESS | 3076 | Values: 1162.4 1189.7 1262.3 1554.9 1560.2 6864.7 7314.1 7332.5 7334.2 7337.6 6406.5 6609.5 6747.0 6990.5 7159.7 1813.3 1875.3 1878.2 1879.5 1883.2 1887.1 1889.8 1899.6 1910.4 1914.5 1600.7 1654.8 1659.2 1822.3 1895.9 1910.2 1923.0 1923.2 1926.4 1937.2 1819.0 1822.4 1827.2 1836.7 1842.1 7044.9 7142.3 7238.6 7253.0 7253.7 4259.3 4335.6 4350.3 4351.2 4371.7 2904.3 2904.8 2955.3 2962.8 2999.9 921.7 943.3 952.9 953.1 958.3 9213.3 9236.4 9238.8 9248.6 9249.1 3535.1 3704.9 3728.7 3754.5 3760.1 8073.2 8073.4 8082.9 8113.8 8122.6 4277.5 4312.5 4334.1 4340.8 4346.7 3813.8 4011.3 4016.1 4023.4 4028.9 3042.2 3048.7 3117.1 3130.7 3145.9 958.7 962.0 986.8 988.0 1000.5 695.4 737.8 787.1 793.2 799.7 4525.8 4582.6 4619.2 4623.5 4739.9 318.6 334.4 334.9 335.8 342.7 2951.6 3010.4 3039.9 3065.5 3134.1 8273.7 8325.3 8574.6 8605.6 8780.9 8607.2 8728.2 8729.3 8732.0 8757.7 6681.7 6714.4 6832.2 6833.9 6847.3 4520.8 4732.3 4773.2 4775.2 4881.0 7783.4 7895.9 7919.3 7957.2 7957.7 7787.8 8103.8 8117.6 8146.6 8171.5 6268.2 6324.9 6335.9 6345.1 6355.6 6820.9 6838.6 6857.8 6878.8 6918.8 6250.3 6314.4 6373.3 6387.6 6454.5 5973.7 6216.5 6267.5 6317.6 6319.2 5508.5 5561.3 5641.1 5684.7 5733.5 3928.8 3955.4 3968.8 3992.6 4030.3 4040.4 4054.3 4079.3 4124.5 4181.6
13:58:10 INFO - PROCESS | 3076 |
13:58:10 INFO - PROCESS | 3076 | [#4] prototype.html Cycles:180 Average:4413.18 Median:5094.05 stddev:1388.13 (27.3%) stddev-sans-first:1356.23
13:58:10 INFO - PROCESS | 3076 | Values: 240.0 261.7 264.7 265.4 269.3 4925.7 5100.8 5114.2 5194.8 5257.7 5128.9 5131.8 5138.0 5154.0 5157.6 3800.1 3801.1 3802.4 3804.8 3812.8 3807.3 3817.2 3818.2 3818.3 3826.8 3779.4 3786.7 3789.6 3796.2 3796.8 3768.4 3783.6 3783.8 3787.8 3791.6 3197.6 3276.4 3277.3 3277.5 3280.8 4775.4 5018.3 5018.8 5019.6 5045.4 4336.6 4368.7 4372.8 4382.9 4413.3 5255.9 5298.4 5312.8 5319.3 5336.2 3318.0 3401.5 3610.8 3617.1 3625.2 5412.5 5483.3 5506.1 5532.1 5558.3 3425.7 3514.6 3575.4 3584.3 3589.4 3469.8 3518.3 3520.9 3568.0 3632.5 4279.1 4305.1 4306.7 4308.5 4310.0 5093.3 5237.1 5313.0 5362.8 5384.8 1242.4 1255.4 1256.6 1256.9 1263.7 761.1 774.2 776.8 785.5 786.3 4697.7 4704.9 4725.6 4728.0 4730.5 4963.2 4970.7 4978.3 4991.4 5017.5 4728.0 4741.7 4990.9 5055.6 5114.9 2844.3 2903.2 2923.7 2944.0 2948.5 5848.6 5863.9 5869.8 5873.6 5885.6 5349.2 5609.8 5637.7 5646.9 5658.4 5849.9 5897.4 5914.3 5920.6 5930.9 5370.7 5524.0 5577.3 5581.4 5591.8 5402.6 5450.1 5458.9 5463.9 5472.8 5623.7 5829.1 5859.8 5908.7 5921.5 3593.7 3611.0 3621.7 3627.2 3631.7 5523.6 5563.4 5575.6 5599.0 5618.4 5112.2 5340.0 5367.4 5373.6 5400.3 5350.1 5364.9 5369.5 5372.5 5393.5 5258.3 5269.2 5271.7 5299.7 5300.4 5351.8 5377.9 5386.7 5387.6 5388.7 5094.8 5311.0 5345.5 5351.8 5386.6
13:58:10 INFO - PROCESS | 3076 |
13:58:10 INFO - PROCESS | 3076 | [#5] yui.html Cycles:180 Average:21446.38 Median:4330.71 stddev:31670.87 (731.3%) stddev-sans-first:31721.14
13:58:10 INFO - PROCESS | 3076 | Values: 628.1 640.4 699.3 702.0 728.3 14499.6 15775.1 15776.9 16142.8 17248.2 15471.0 15638.0 15674.9 15719.3 15781.4 538.9 644.5 660.0 663.0 663.2 549.0 640.7 657.3 660.3 663.4 687.9 689.9 689.9 691.9 692.6 559.9 686.7 686.8 686.8 687.1 417.2 475.1 485.7 493.5 494.4 14102.9 14335.8 14340.1 14358.4 14392.1 12692.7 12739.0 12977.2 13102.3 13140.9 13561.7 13632.3 13647.9 13807.9 14311.6 4288.8 4351.5 4373.1 4458.1 4491.3 81258.6 85778.1 85852.1 86903.0 87267.1 10509.3 10555.3 10565.3 10593.8 10669.4 18624.6 18757.2 19023.7 19144.1 19349.6 6872.4 7300.7 7502.4 7550.5 7606.7 4037.4 4168.8 4309.9 4397.4 4415.7 2961.4 3041.5 3118.0 3158.4 3172.9 552.4 566.0 566.2 571.4 575.7 595.1 665.0 691.4 702.4 716.2 9652.5 9715.5 10081.2 10665.7 10719.2 573.3 675.4 708.0 738.7 740.1 4918.7 4987.2 4999.8 5084.5 5090.5 101603.0 112694.0 120233.4 120580.0 121856.0 90082.5 99518.0 105091.9 107547.0 108321.5 92756.5 93885.0 94478.5 96755.0 97329.0 9523.5 9558.8 9659.1 9765.7 9817.4 52209.7 54397.0 54603.2 55749.0 56591.7 69335.7 80513.6 81417.6 82344.2 82680.2 11497.7 11688.6 11899.0 11938.9 11940.9 13387.1 13850.7 13880.8 14128.5 14368.4 12813.1 13231.9 13283.2 13397.5 13401.2 12901.2 12981.2 13210.3 13473.7 13798.9 13211.3 13448.2 13522.1 13527.3 13724.5 11404.1 11454.8 11643.1 11692.3 12071.8 10919.8 10950.1 10964.7 11010.9 11119.3
13:58:10 INFO - PROCESS | 3076 | -------- Summary: end --------
13:58:10 INFO - PROCESS | 3076 |
13:58:11 INFO - TEST-INFO | 3076: exit 0
13:58:11 INFO - TEST-OK | dromaeo_css | took 1118754ms
13:58:11 INFO - TEST-START | kraken
13:58:11 INFO - operating with platform_type : w7_
13:58:11 INFO - Initialising browser for kraken test...
13:58:11 INFO - TEST-INFO | started process 3876 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld\appdata\local\temp\tmpar627r\profile http://localhost:49608/getInfo.html)
13:58:16 INFO - PROCESS | 3876 | __metrics Screen width/height:1600/1200
13:58:16 INFO - PROCESS | 3876 | colorDepth:24
13:58:16 INFO - PROCESS | 3876 | Browser inner width/height: 1010/674
13:58:16 INFO - PROCESS | 3876 | __metrics
13:58:17 INFO - PROCESS | 3876 | 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"
13:58:17 INFO - PROCESS | 3876 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver]
13:58:17 INFO - PROCESS | 3876 | console.error:
13:58:17 INFO - PROCESS | 3876 | Message: Error: Connection closed before committing the transaction.
13:58:17 INFO - PROCESS | 3876 | Stack:
13:58:17 INFO - PROCESS | 3876 | ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:937:23
13:58:17 INFO - PROCESS | 3876 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7
13:58:17 INFO - PROCESS | 3876 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11
13:58:17 INFO - PROCESS | 3876 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7
13:58:17 INFO - PROCESS | 3876 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:714:7
13:58:17 INFO - PROCESS | 3876 | TaskImpl_run@resource://gre/modules/Task.jsm:324:13
13:58:17 INFO - PROCESS | 3876 | Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:551:9
13:58:17 INFO - PROCESS | 3876 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15
13:58:17 INFO - PROCESS | 3876 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:388:5
13:58:17 INFO - PROCESS | 3876 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29
13:58:17 INFO - PROCESS | 3876 | Barrier/this.client.addBlocker/promise13.1%
13:59:15 INFO - TinderboxPrint: I/O read bytes / time
195,827,200 / 2,317,280
13:59:15 INFO - TinderboxPrint: I/O write bytes / time
486,675,968 / 3,342,680
13:59:15 INFO - TinderboxPrint: CPU idle
8,235.4 (86.9%)
13:59:15 INFO - TinderboxPrint: CPU user
1,208.4 (12.7%)
13:59:15 INFO - install - Wall time: 3s; CPU: 10.0%; Read bytes: 0; Write bytes: 37992448; Read time: 0; Write time: 49070
13:59:15 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 195811840; Write bytes: 415407616; Read time: 2313980; Write time: 3261670
13:59:15 INFO - Running post-run listener: _upload_blobber_files
13:59:15 INFO - Blob upload gear active.
13:59:15 INFO - Preparing to upload files from C:\slave\test\build\blobber_upload_dir.
13:59:15 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
13:59:15 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']
13:59:15 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
13:59:16 INFO - (blobuploader) - INFO - Open directory for files ...
13:59:16 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_errorsummary.log ...
13:59:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
13:59:16 INFO - (blobuploader) - INFO - Uploading, attempt #1.
13:59:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded
13:59:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
13:59:17 INFO - (blobuploader) - INFO - Done attempting.
13:59:17 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs_raw.log ...
13:59:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
13:59:17 INFO - (blobuploader) - INFO - Uploading, attempt #1.
13:59:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded
13:59:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
13:59:18 INFO - (blobuploader) - INFO - Done attempting.
13:59:18 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\resource-usage.json ...
13:59:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
13:59:18 INFO - (blobuploader) - INFO - Uploading, attempt #1.
13:59:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded
13:59:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
13:59:25 INFO - (blobuploader) - INFO - Done attempting.
13:59:25 INFO - (blobuploader) - INFO - Iteration through files over.
13:59:25 INFO - Return code: 0
13:59:25 INFO - rmtree: C:\slave\test\build\uploaded_files.json
13:59:25 INFO - Using _rmtree_windows ...
13:59:25 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build\\uploaded_files.json',), kwargs: {}, attempt #1
13:59:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ff7fb21cc7441ffd2eeb8673f3e2094467a4adb77ba8a4d5744925a0e712487cc57404969bf808d298969436e680b4e686aa7f30dff7f7ca20cefda1a6c3609c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ec5b9a9588977582c4459506f64abf9da20a2b597fc5251cfd3b77c6e2f1c0ef206f7488c28092d373e29f08cc4c540bd33048beb84f889a3855eef37d629afd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/df215e5ccfc3efe1c47fe438566627c6e31e77722a567187bb2cb04970fd3e716b233490ee8a2f191b801f5e50709383e285aea2e8304a295ff9690ddda1d943"}
13:59:25 INFO - Writing buildbot properties ['blobber_files'] to C:\slave\test\properties\blobber_files
13:59:25 INFO - Writing to file C:\slave\test\properties\blobber_files
13:59:25 INFO - Contents:
13:59:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ff7fb21cc7441ffd2eeb8673f3e2094467a4adb77ba8a4d5744925a0e712487cc57404969bf808d298969436e680b4e686aa7f30dff7f7ca20cefda1a6c3609c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ec5b9a9588977582c4459506f64abf9da20a2b597fc5251cfd3b77c6e2f1c0ef206f7488c28092d373e29f08cc4c540bd33048beb84f889a3855eef37d629afd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/df215e5ccfc3efe1c47fe438566627c6e31e77722a567187bb2cb04970fd3e716b233490ee8a2f191b801f5e50709383e285aea2e8304a295ff9690ddda1d943"}
13:59:25 INFO - Running post-run listener: copy_logs_to_upload_dir
13:59:25 INFO - Copying logs to upload dir...
13:59:25 INFO - mkdir: C:\slave\test\build\upload\logs
13:59:25 INFO - Copying logs to upload dir...
13:59:25 INFO - Using _rmtree_windows ...
13:59:25 INFO - Using _rmtree_windows ...
13:59:25 INFO - Using _rmtree_windows ...
13:59:25 INFO - Using _rmtree_windows ...
13:59:25 INFO - Using _rmtree_windows ...
13:59:25 INFO - Using _rmtree_windows ...
13:59:25 INFO - Using _rmtree_windows ...
program finished with exit code 0
elapsedTime=1426.754000
========= master_lag: -0.12 =========
========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 46 secs) (at 2016-09-22 13:59:25.784464) =========
========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-22 13:59:25.785365) =========
'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-086
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-086
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-086
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/ff7fb21cc7441ffd2eeb8673f3e2094467a4adb77ba8a4d5744925a0e712487cc57404969bf808d298969436e680b4e686aa7f30dff7f7ca20cefda1a6c3609c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ec5b9a9588977582c4459506f64abf9da20a2b597fc5251cfd3b77c6e2f1c0ef206f7488c28092d373e29f08cc4c540bd33048beb84f889a3855eef37d629afd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/df215e5ccfc3efe1c47fe438566627c6e31e77722a567187bb2cb04970fd3e716b233490ee8a2f191b801f5e50709383e285aea2e8304a295ff9690ddda1d943"}
build_url:https://queue.taskcluster.net/v1/task/fdJN3ltLS7aaJH-HDdPE2w/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/fdJN3ltLS7aaJH-HDdPE2w/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/ff7fb21cc7441ffd2eeb8673f3e2094467a4adb77ba8a4d5744925a0e712487cc57404969bf808d298969436e680b4e686aa7f30dff7f7ca20cefda1a6c3609c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ec5b9a9588977582c4459506f64abf9da20a2b597fc5251cfd3b77c6e2f1c0ef206f7488c28092d373e29f08cc4c540bd33048beb84f889a3855eef37d629afd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/df215e5ccfc3efe1c47fe438566627c6e31e77722a567187bb2cb04970fd3e716b233490ee8a2f191b801f5e50709383e285aea2e8304a295ff9690ddda1d943"}'
========= master_lag: 0.02 =========
========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-22 13:59:25.905462) =========
========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 13:59:25.906290) =========
'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-086
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-086
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-086
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.01 =========
========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 13:59:26.021526) =========
========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-09-22 13:59:26.022294) =========
========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-09-22 13:59:26.557739) =========
========= Total master_lag: -0.01 =========