builder: mozilla-central_win7_ix_test-dromaeojs-e10s
slave: t-w732-ix-010
starttime: 1480717247.56
results: success (0)
buildid: 20161202130744
builduid: ea432fef198b4a989b57c5728acb9d76
revision: 633e960e72dbd3006a2d0325416e50a19a7e1838
========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-02 14:20:47.556475) =========
master: http://buildbot-master127.bb.releng.scl3.mozilla.com:8201/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-02 14:20:47.556951) =========
========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-02 14:20:47.557253) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-02 14:20:47.656820) =========
========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-02 14:20:47.657201) =========
'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-010
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-010
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-010
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
--14:20:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py
=> `archiver_client.py'
Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25
Connecting to hg.mozilla.org|63.245.215.102|:443... connected.
WARNING: Certificate verification error for hg.mozilla.org: certificate signature failure
HTTP request sent, awaiting response... 200 Script output follows
Length: 12,179 (12K) [text/x-python]
0K .......... . 100% 2.46 GB/s
14:20:48 (2.46 GB/s) - `archiver_client.py' saved [12179/12179]
program finished with exit code 0
elapsedTime=1.070000
========= master_lag: 0.09 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-02 14:20:48.814685) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 10 secs) (at 2016-12-02 14:20:48.815003) =========
'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-010
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-010
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-010
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=7.502000
========= master_lag: 3.23 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 10 secs) (at 2016-12-02 14:20:59.548410) =========
========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-02 14:20:59.548755) =========
'bash' '-c' u'python archiver_client.py mozharness --repo mozilla-central --rev 633e960e72dbd3006a2d0325416e50a19a7e1838 --destination scripts --debug'
in dir C:\slave\test\. (timeout 1200 secs)
watching logfiles {}
argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 633e960e72dbd3006a2d0325416e50a19a7e1838 --destination scripts --debug']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld\AppData\Roaming
COMMONPROGRAMFILES=C:\Program Files\Common Files
COMPUTERNAME=T-W732-IX-010
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-010
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-010
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-12-02 14:20:59,732 truncating revision to first 12 chars
2016-12-02 14:20:59,732 Setting DEBUG logging.
2016-12-02 14:20:59,732 attempt 1/10
2016-12-02 14:20:59,732 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/633e960e72db?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2016-12-02 14:21:00,263 unpacking tar archive at: mozilla-central-633e960e72db/testing/mozharness/
2016-12-02 14:21:00,398 skipping symlink on windows: configs/single_locale/linux32.py
program finished with exit code 0
elapsedTime=1.069000
========= master_lag: 0.05 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-02 14:21:00.665892) =========
========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-02 14:21:00.666232) =========
script_repo_revision: 633e960e72dbd3006a2d0325416e50a19a7e1838
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-02 14:21:00.666622) =========
========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-02 14:21:00.666912) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-02 14:21:00.676157) =========
========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 24 mins, 31 secs) (at 2016-12-02 14:21:00.676565) =========
'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'dromaeojs-e10s' '--add-option' '--webServer,localhost' '--branch-name' 'Firefox-Non-PGO' '--cfg' 'talos/windows_config.py' '--download-symbols' 'ondemand' '--use-talos-json' '--blob-upload-branch' 'Firefox-Non-PGO'
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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/windows_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld\AppData\Roaming
COMMONPROGRAMFILES=C:\Program Files\Common Files
COMPUTERNAME=T-W732-IX-010
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-010
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-010
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
14:21:01 INFO - MultiFileLogger online at 20161202 14:21:01 in C:\slave\test
14:21:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO
14:21:01 INFO - Dumping config to C:\slave\test\logs\localconfig.json.
14:21:01 INFO - {'append_to_log': False,
14:21:01 INFO - 'base_work_dir': 'C:\\slave\\test',
14:21:01 INFO - 'blob_upload_branch': 'Firefox-Non-PGO',
14:21:01 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt',
14:21:01 INFO - 'branch': 'Firefox-Non-PGO',
14:21:01 INFO - 'buildbot_json_path': 'buildprops.json',
14:21:01 INFO - 'config_files': ('talos/windows_config.py',),
14:21:01 INFO - 'default_actions': ('clobber',
14:21:01 INFO - 'read-buildbot-config',
14:21:01 INFO - 'download-and-extract',
14:21:01 INFO - 'populate-webroot',
14:21:01 INFO - 'create-virtualenv',
14:21:01 INFO - 'install',
14:21:01 INFO - 'run-tests'),
14:21:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',),
14:21:01 INFO - 'download_minidump_stackwalk': True,
14:21:01 INFO - 'download_symbols': 'ondemand',
14:21:01 INFO - 'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python',
14:21:01 INFO - 'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'),
14:21:01 INFO - 'hg': 'c:/mozilla-build/hg/hg',
14:21:01 INFO - 'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python',
14:21:01 INFO - 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'),
14:21:01 INFO - 'python': 'c:/mozilla-build/python27/python.exe',
14:21:01 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe',
14:21:01 INFO - 'C:/mozilla-build/tooltool.py'),
14:21:01 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe',
14:21:01 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')},
14:21:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub',
14:21:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'),
14:21:01 INFO - 'installer_path': 'installer.exe',
14:21:01 INFO - 'log_level': 'info',
14:21:01 INFO - 'log_name': 'talos',
14:21:01 INFO - 'log_to_console': True,
14:21:01 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe',
14:21:01 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe',
14:21:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest',
14:21:01 INFO - 'opt_config_files': (),
14:21:01 INFO - 'pip_index': False,
14:21:01 INFO - 'sps_profile': False,
14:21:01 INFO - 'sps_profile_interval': 0,
14:21:01 INFO - 'suite': 'dromaeojs-e10s',
14:21:01 INFO - 'system_bits': '32',
14:21:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'),
14:21:01 INFO - 'title': 'T-W732-IX-010',
14:21:01 INFO - 'use_talos_json': True,
14:21:01 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'),
14:21:01 INFO - 'virtualenv_path': 'C:\\slave\\test\\build/venv',
14:21:01 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll',
14:21:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
14:21:01 INFO - 'work_dir': 'build'}
14:21:01 INFO - [mozharness: 2016-12-02 22:21:01.253000Z] Running clobber step.
14:21:01 INFO - Running pre-action listener: _resource_record_pre_action
14:21:01 INFO - Running main action method: clobber
14:21:01 INFO - rmtree: C:\slave\test\build
14:21:01 INFO - Using _rmtree_windows ...
14:21:01 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1
14:23:22 INFO - Running post-action listener: _resource_record_post_action
14:23:22 INFO - [mozharness: 2016-12-02 22:23:22.517000Z] Finished clobber step (success)
14:23:22 INFO - [mozharness: 2016-12-02 22:23:22.517000Z] Running read-buildbot-config step.
14:23:22 INFO - Running pre-action listener: _resource_record_pre_action
14:23:22 INFO - Running main action method: read_buildbot_config
14:23:22 INFO - Using buildbot properties:
14:23:22 INFO - {
14:23:22 INFO - "project": "",
14:23:22 INFO - "product": "firefox",
14:23:22 INFO - "script_repo_revision": "production",
14:23:22 INFO - "builddir": "mozilla-central_win7_ix_test-dromaeojs-e10s",
14:23:22 INFO - "repository": "",
14:23:22 INFO - "buildername": "Windows 7 32-bit mozilla-central talos dromaeojs-e10s",
14:23:22 INFO - "buildid": "20161202130744",
14:23:22 INFO - "pgo_build": "False",
14:23:22 INFO - "basedir": "C:\\slave\\test",
14:23:22 INFO - "buildnumber": 49,
14:23:22 INFO - "slavename": "t-w732-ix-010",
14:23:22 INFO - "master": "http://buildbot-master127.bb.releng.scl3.mozilla.com:8201/",
14:23:22 INFO - "platform": "win7_ix",
14:23:22 INFO - "scheduler": "tests-mozilla-central-win32-talos",
14:23:22 INFO - "branch": "mozilla-central",
14:23:22 INFO - "repo_path": "mozilla-central",
14:23:22 INFO - "revision": "633e960e72dbd3006a2d0325416e50a19a7e1838",
14:23:22 INFO - "stage_platform": "win32",
14:23:22 INFO - "builduid": "ea432fef198b4a989b57c5728acb9d76",
14:23:22 INFO - "slavebuilddir": "test"
14:23:22 INFO - }
14:23:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/UUZzPjZcQeGRz3KpQ_4tlA/artifacts/public/build/firefox-53.0a1.en-US.win32.zip.
14:23:22 INFO - Running post-action listener: _resource_record_post_action
14:23:22 INFO - [mozharness: 2016-12-02 22:23:22.521000Z] Finished read-buildbot-config step (success)
14:23:22 INFO - [mozharness: 2016-12-02 22:23:22.521000Z] Running download-and-extract step.
14:23:22 INFO - Running pre-action listener: _resource_record_pre_action
14:23:22 INFO - Running main action method: download_and_extract
14:23:22 INFO - mkdir: C:\slave\test\build\tests
14:23:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
14:23:22 INFO - trying https://queue.taskcluster.net/v1/task/UUZzPjZcQeGRz3KpQ_4tlA/artifacts/public/build/firefox-53.0a1.en-US.win32.test_packages.json
14:23:22 INFO - Downloading https://queue.taskcluster.net/v1/task/UUZzPjZcQeGRz3KpQ_4tlA/artifacts/public/build/firefox-53.0a1.en-US.win32.test_packages.json to C:\slave\test\build\firefox-53.0a1.en-US.win32.test_packages.json
14:23:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UUZzPjZcQeGRz3KpQ_4tlA/artifacts/public/build/firefox-53.0a1.en-US.win32.test_packages.json', 'file_name': 'C:\\slave\\test\\build\\firefox-53.0a1.en-US.win32.test_packages.json'}, attempt #1
14:23:23 INFO - Downloaded 1274 bytes.
14:23:23 INFO - Reading from file C:\slave\test\build\firefox-53.0a1.en-US.win32.test_packages.json
14:23:23 INFO - Using the following test package requirements:
14:23:23 INFO - {u'common': [u'firefox-53.0a1.en-US.win32.common.tests.zip'],
14:23:23 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.win32.common.tests.zip',
14:23:23 INFO - u'firefox-53.0a1.en-US.win32.cppunittest.tests.zip'],
14:23:23 INFO - u'gtest': [u'firefox-53.0a1.en-US.win32.common.tests.zip',
14:23:23 INFO - u'firefox-53.0a1.en-US.win32.gtest.tests.zip'],
14:23:23 INFO - u'jittest': [u'firefox-53.0a1.en-US.win32.common.tests.zip',
14:23:23 INFO - u'jsshell-win32.zip'],
14:23:23 INFO - u'mochitest': [u'firefox-53.0a1.en-US.win32.common.tests.zip',
14:23:23 INFO - u'firefox-53.0a1.en-US.win32.mochitest.tests.zip'],
14:23:23 INFO - u'mozbase': [u'firefox-53.0a1.en-US.win32.common.tests.zip'],
14:23:23 INFO - u'reftest': [u'firefox-53.0a1.en-US.win32.common.tests.zip',
14:23:23 INFO - u'firefox-53.0a1.en-US.win32.reftest.tests.zip'],
14:23:23 INFO - u'talos': [u'firefox-53.0a1.en-US.win32.common.tests.zip',
14:23:23 INFO - u'firefox-53.0a1.en-US.win32.talos.tests.zip'],
14:23:23 INFO - u'web-platform': [u'firefox-53.0a1.en-US.win32.common.tests.zip',
14:23:23 INFO - u'firefox-53.0a1.en-US.win32.web-platform.tests.zip'],
14:23:23 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.win32.common.tests.zip',
14:23:23 INFO - u'firefox-53.0a1.en-US.win32.xpcshell.tests.zip']}
14:23:23 INFO - Downloading packages: [u'firefox-53.0a1.en-US.win32.common.tests.zip'] for test suite category: common
14:23:23 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/UUZzPjZcQeGRz3KpQ_4tlA/artifacts/public/build/firefox-53.0a1.en-US.win32.common.tests.zip
14:23:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UUZzPjZcQeGRz3KpQ_4tlA/artifacts/public/build/firefox-53.0a1.en-US.win32.common.tests.zip'}, attempt #1
14:23:23 INFO - Fetch https://queue.taskcluster.net/v1/task/UUZzPjZcQeGRz3KpQ_4tlA/artifacts/public/build/firefox-53.0a1.en-US.win32.common.tests.zip into memory
14:23:25 INFO - Expected file size: 16889605
14:23:25 INFO - Obtained file size: 16889605
14:23:59 INFO - Downloading packages: [u'firefox-53.0a1.en-US.win32.common.tests.zip', u'firefox-53.0a1.en-US.win32.talos.tests.zip'] for test suite category: talos
14:23:59 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/UUZzPjZcQeGRz3KpQ_4tlA/artifacts/public/build/firefox-53.0a1.en-US.win32.common.tests.zip
14:23:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UUZzPjZcQeGRz3KpQ_4tlA/artifacts/public/build/firefox-53.0a1.en-US.win32.common.tests.zip'}, attempt #1
14:23:59 INFO - Fetch https://queue.taskcluster.net/v1/task/UUZzPjZcQeGRz3KpQ_4tlA/artifacts/public/build/firefox-53.0a1.en-US.win32.common.tests.zip into memory
14:24:01 INFO - Expected file size: 16889605
14:24:01 INFO - Obtained file size: 16889605
14:24:13 INFO - Downloading and extracting to C:\slave\test\build\tests these dirs * from https://queue.taskcluster.net/v1/task/UUZzPjZcQeGRz3KpQ_4tlA/artifacts/public/build/firefox-53.0a1.en-US.win32.talos.tests.zip
14:24:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UUZzPjZcQeGRz3KpQ_4tlA/artifacts/public/build/firefox-53.0a1.en-US.win32.talos.tests.zip'}, attempt #1
14:24:13 INFO - Fetch https://queue.taskcluster.net/v1/task/UUZzPjZcQeGRz3KpQ_4tlA/artifacts/public/build/firefox-53.0a1.en-US.win32.talos.tests.zip into memory
14:24:14 INFO - Expected file size: 14409734
14:24:14 INFO - Obtained file size: 14409734
14:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
14:24:15 INFO - trying https://queue.taskcluster.net/v1/task/UUZzPjZcQeGRz3KpQ_4tlA/artifacts/public/build/firefox-53.0a1.en-US.win32.zip
14:24:15 INFO - Downloading https://queue.taskcluster.net/v1/task/UUZzPjZcQeGRz3KpQ_4tlA/artifacts/public/build/firefox-53.0a1.en-US.win32.zip to C:\slave\test\build\firefox-53.0a1.en-US.win32.zip
14:24:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UUZzPjZcQeGRz3KpQ_4tlA/artifacts/public/build/firefox-53.0a1.en-US.win32.zip', 'file_name': 'C:\\slave\\test\\build\\firefox-53.0a1.en-US.win32.zip'}, attempt #1
14:24:19 INFO - Downloaded 53382950 bytes.
14:24:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UUZzPjZcQeGRz3KpQ_4tlA/artifacts/public/build/firefox-53.0a1.en-US.win32.zip
14:24:19 INFO - mkdir: C:\slave\test\properties
14:24:19 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url
14:24:19 INFO - Writing to file C:\slave\test\properties\build_url
14:24:19 INFO - Contents:
14:24:19 INFO - build_url:https://queue.taskcluster.net/v1/task/UUZzPjZcQeGRz3KpQ_4tlA/artifacts/public/build/firefox-53.0a1.en-US.win32.zip
14:24:19 INFO - Running post-action listener: _resource_record_post_action
14:24:19 INFO - Running post-action listener: set_extra_try_arguments
14:24:19 INFO - [mozharness: 2016-12-02 22:24:19.667000Z] Finished download-and-extract step (success)
14:24:19 INFO - [mozharness: 2016-12-02 22:24:19.667000Z] Running populate-webroot step.
14:24:19 INFO - Running pre-action listener: _resource_record_pre_action
14:24:19 INFO - Running main action method: populate_webroot
14:24:19 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']},
14:24:19 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']},
14:24:19 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome',
14:24:19 INFO - u'--tppagecycles',
14:24:19 INFO - u'7'],
14:24:19 INFO - u'tests': [u'tsvgm']}},
14:24:19 INFO - u'suites': {u'chromez': {u'talos_options': [u'--disable-e10s'],
14:24:19 INFO - u'tests': [u'tresize', u'tcanvasmark']},
14:24:19 INFO - u'chromez-e10s': {u'tests': [u'tresize', u'tcanvasmark']},
14:24:19 INFO - u'dromaeojs': {u'talos_options': [u'--disable-e10s'],
14:24:19 INFO - u'tests': [u'dromaeo_css', u'kraken']},
14:24:19 INFO - u'dromaeojs-e10s': {u'tests': [u'dromaeo_css', u'kraken']},
14:24:19 INFO - u'g1': {u'pagesets_name': u'tp5n.zip',
14:24:19 INFO - u'talos_options': [u'--disable-e10s'],
14:24:19 INFO - u'tests': [u'tp5o_scroll', u'glterrain']},
14:24:19 INFO - u'g1-e10s': {u'pagesets_name': u'tp5n.zip',
14:24:19 INFO - u'tests': [u'tp5o_scroll', u'glterrain']},
14:24:19 INFO - u'g2': {u'pagesets_name': u'tp5n.zip',
14:24:19 INFO - u'talos_options': [u'--disable-e10s'],
14:24:19 INFO - u'tests': [u'damp', u'tps']},
14:24:19 INFO - u'g2-e10s': {u'pagesets_name': u'tp5n.zip',
14:24:19 INFO - u'tests': [u'damp', u'tps']},
14:24:19 INFO - u'g3': {u'talos_options': [u'--disable-e10s'],
14:24:19 INFO - u'tests': [u'dromaeo_dom']},
14:24:19 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']},
14:24:19 INFO - u'g4': {u'talos_options': [u'--disable-e10s'],
14:24:19 INFO - u'tests': [u'basic_compositor_video']},
14:24:19 INFO - u'g4-e10s': {u'tests': [u'basic_compositor_video']},
14:24:19 INFO - u'other': {u'talos_options': [u'--disable-e10s'],
14:24:19 INFO - u'tests': [u'a11yr',
14:24:19 INFO - u'ts_paint',
14:24:19 INFO - u'tpaint',
14:24:19 INFO - u'sessionrestore',
14:24:19 INFO - u'sessionrestore_no_auto_restore',
14:24:19 INFO - u'tabpaint']},
14:24:19 INFO - u'other-e10s': {u'tests': [u'a11yr',
14:24:19 INFO - u'ts_paint',
14:24:19 INFO - u'tpaint',
14:24:19 INFO - u'sessionrestore',
14:24:19 INFO - u'sessionrestore_no_auto_restore',
14:24:19 INFO - u'tabpaint']},
14:24:19 INFO - u'other-e10s_l64': {u'tests': [u'a11yr',
14:24:19 INFO - u'ts_paint',
14:24:19 INFO - u'tpaint',
14:24:19 INFO - u'sessionrestore',
14:24:19 INFO - u'sessionrestore_no_auto_restore',
14:24:19 INFO - u'tabpaint']},
14:24:19 INFO - u'other-e10s_nol64': {u'tests': [u'a11yr',
14:24:19 INFO - u'ts_paint',
14:24:19 INFO - u'tpaint',
14:24:19 INFO - u'sessionrestore',
14:24:19 INFO - u'sessionrestore_no_auto_restore',
14:24:19 INFO - u'tabpaint']},
14:24:19 INFO - u'other_l64': {u'talos_options': [u'--disable-e10s'],
14:24:19 INFO - u'tests': [u'a11yr',
14:24:19 INFO - u'ts_paint',
14:24:19 INFO - u'tpaint',
14:24:19 INFO - u'sessionrestore',
14:24:19 INFO - u'sessionrestore_no_auto_restore',
14:24:19 INFO - u'tabpaint']},
14:24:19 INFO - u'other_nol64': {u'talos_options': [u'--disable-e10s'],
14:24:19 INFO - u'tests': [u'a11yr',
14:24:19 INFO - u'ts_paint',
14:24:19 INFO - u'tpaint',
14:24:19 INFO - u'sessionrestore',
14:24:19 INFO - u'sessionrestore_no_auto_restore',
14:24:19 INFO - u'tabpaint']},
14:24:19 INFO - u'svgr': {u'talos_options': [u'--disable-e10s'],
14:24:19 INFO - u'tests': [u'tsvgx',
14:24:19 INFO - u'tsvgr_opacity',
14:24:19 INFO - u'tart',
14:24:19 INFO - u'tscrollx',
14:24:19 INFO - u'cart',
14:24:19 INFO - u'tsvg_static']},
14:24:19 INFO - u'svgr-e10s': {u'tests': [u'tsvgx',
14:24:19 INFO - u'tsvgr_opacity',
14:24:19 INFO - u'tart',
14:24:19 INFO - u'tscrollx',
14:24:19 INFO - u'cart',
14:24:19 INFO - u'tsvg_static']},
14:24:19 INFO - u'tp5o': {u'pagesets_name': u'tp5n.zip',
14:24:19 INFO - u'talos_options': [u'--disable-e10s'],
14:24:19 INFO - u'tests': [u'tp5o']},
14:24:19 INFO - u'tp5o-e10s': {u'pagesets_name': u'tp5n.zip',
14:24:19 INFO - u'tests': [u'tp5o']},
14:24:19 INFO - u'xperf': {u'pagesets_name': u'tp5n.zip',
14:24:19 INFO - u'talos_options': [u'--disable-e10s',
14:24:19 INFO - u'--xperf_path',
14:24:19 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
14:24:19 INFO - u'tests': [u'tp5n']},
14:24:19 INFO - u'xperf-e10s': {u'pagesets_name': u'tp5n.zip',
14:24:19 INFO - u'talos_options': [u'--xperf_path',
14:24:19 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
14:24:19 INFO - u'tests': [u'tp5n']}},
14:24:19 INFO - u'talos.zip': {u'path': u'',
14:24:19 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}}
14:24:19 INFO - Running post-action listener: _resource_record_post_action
14:24:19 INFO - [mozharness: 2016-12-02 22:24:19.682000Z] Finished populate-webroot step (success)
14:24:19 INFO - [mozharness: 2016-12-02 22:24:19.682000Z] Running create-virtualenv step.
14:24:19 INFO - Running pre-action listener: _resource_record_pre_action
14:24:19 INFO - Running main action method: create_virtualenv
14:24:19 INFO - Creating virtualenv C:\slave\test\build/venv
14:24:19 INFO - mkdir: C:\slave\test\build\venv\Scripts
14:24:20 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll
14:24:20 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'!
14:24:20 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
14:24:20 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build/venv
14:24:38 INFO - New python executable in C:\slave\test\build/venv\Scripts\python.exe
14:24:42 INFO - Installing distribute......................................................................................................................................................................................done.
14:24:43 INFO - Return code: 0
14:24:43 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', '--version']
14:24:43 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip --version
14:24:44 INFO - Reading from file tmpfile_stdout
14:24:44 INFO - Output received:
14:24:44 INFO - pip 0.8.2 from c:\slave\test\build\venv\lib\site-packages\pip-0.8.2-py2.7.egg (python 2.7)
14:24:44 INFO - Using _rmtree_windows ...
14:24:44 INFO - Using _rmtree_windows ...
14:24:44 INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv
14:24:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
14:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
14:24:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
14:24:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
14:24:44 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x017FF640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018A8F20>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x017AB0C0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018C8E90>, '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 0x012AA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01FCB5C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-010', 'USERDOMAIN': 'T-W732-IX-010', '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-010', '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
14:24:44 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in C:\slave\test\build
14:24:44 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5
14:24:44 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
14:24:44 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
14:24:44 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
14:24:44 INFO - 'COMPUTERNAME': 'T-W732-IX-010',
14:24:44 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
14:24:44 INFO - 'CYGWINBASE': 'C:\\cygwin',
14:24:44 INFO - 'DCLOCATION': 'SCL3',
14:24:44 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
14:24:44 INFO - 'FP_NO_HOST_CHECK': 'NO',
14:24:44 INFO - 'HOMEDRIVE': 'C:',
14:24:44 INFO - 'HOMEPATH': '\\Users\\cltbld',
14:24:44 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
14:24:44 INFO - 'KTS_VERSION': '1.19c',
14:24:44 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
14:24:44 INFO - 'LOGONSERVER': '\\\\T-W732-IX-010',
14:24:44 INFO - 'MONDIR': 'C:\\Monitor_config\\',
14:24:44 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
14:24:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
14:24:44 INFO - 'MOZ_NO_REMOTE': '1',
14:24:44 INFO - 'NO_EM_RESTART': '1',
14:24:44 INFO - 'NUMBER_OF_PROCESSORS': '8',
14:24:44 INFO - 'OS': 'Windows_NT',
14:24:44 INFO - 'OURDRIVE': 'C:',
14:24:44 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;',
14:24:44 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
14:24:44 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
14:24:44 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
14:24:44 INFO - 'PROCESSOR_LEVEL': '6',
14:24:44 INFO - 'PROCESSOR_REVISION': '1e05',
14:24:44 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
14:24:44 INFO - 'PROGRAMFILES': 'C:\\Program Files',
14:24:44 INFO - 'PROMPT': '$P$G',
14:24:44 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
14:24:44 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
14:24:44 INFO - 'PUBLIC': 'C:\\Users\\Public',
14:24:44 INFO - 'PWD': 'C:\\slave\\test',
14:24:44 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
14:24:44 INFO - 'SLAVEDIR': 'C:\\slave\\',
14:24:44 INFO - 'SYSTEMDRIVE': 'C:',
14:24:44 INFO - 'SYSTEMROOT': 'C:\\windows',
14:24:44 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
14:24:44 INFO - 'TEST1': 'testie',
14:24:44 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
14:24:44 INFO - 'USERDOMAIN': 'T-W732-IX-010',
14:24:44 INFO - 'USERNAME': 'cltbld',
14:24:44 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
14:24:44 INFO - 'WINDIR': 'C:\\windows',
14:24:44 INFO - 'WINDOWS_TRACING_FLAGS': '3',
14:24:44 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
14:24:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
14:24:45 INFO - Ignoring indexes: http://pypi.python.org/simple/
14:24:45 INFO - Downloading/unpacking pip>=1.5
14:24:49 INFO - Running setup.py egg_info for package pip
14:24:49 INFO - warning: no files found matching 'pip\cacert.pem'
14:24:49 INFO - warning: no files found matching '*.html' under directory 'docs'
14:24:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build'
14:24:49 INFO - no previously-included directories found matching 'docs\_build\_sources'
14:24:49 INFO - Installing collected packages: pip
14:24:49 INFO - Found existing installation: pip 0.8.2
14:24:49 INFO - Uninstalling pip:
14:24:49 INFO - Successfully uninstalled pip
14:24:49 INFO - Running setup.py install for pip
14:24:49 INFO - warning: no files found matching 'pip\cacert.pem'
14:24:49 INFO - warning: no files found matching '*.html' under directory 'docs'
14:24:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build'
14:24:49 INFO - no previously-included directories found matching 'docs\_build\_sources'
14:24:49 INFO - Installing pip-script.py script to C:\slave\test\build\venv\Scripts
14:24:49 INFO - Installing pip.exe script to C:\slave\test\build\venv\Scripts
14:24:49 INFO - Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts
14:24:49 INFO - Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts
14:24:49 INFO - Installing pip2-script.py script to C:\slave\test\build\venv\Scripts
14:24:49 INFO - Installing pip2.exe script to C:\slave\test\build\venv\Scripts
14:24:49 INFO - Successfully installed pip
14:24:49 INFO - Cleaning up...
14:24:49 INFO - Return code: 0
14:24:49 INFO - Installing psutil>=3.1.1 into virtualenv C:\slave\test\build/venv
14:24:49 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')]}
14:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
14:24:49 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')]}
14:24:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
14:24:49 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 0x017FF640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018A8F20>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x017AB0C0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018C8E90>, '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 0x012AA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01FCB5C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-010', 'USERDOMAIN': 'T-W732-IX-010', '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-010', '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
14:24:49 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
14:24:49 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
14:24:49 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
14:24:49 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
14:24:49 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
14:24:49 INFO - 'COMPUTERNAME': 'T-W732-IX-010',
14:24:49 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
14:24:49 INFO - 'CYGWINBASE': 'C:\\cygwin',
14:24:49 INFO - 'DCLOCATION': 'SCL3',
14:24:49 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
14:24:49 INFO - 'FP_NO_HOST_CHECK': 'NO',
14:24:49 INFO - 'HOMEDRIVE': 'C:',
14:24:49 INFO - 'HOMEPATH': '\\Users\\cltbld',
14:24:49 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
14:24:49 INFO - 'KTS_VERSION': '1.19c',
14:24:49 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
14:24:49 INFO - 'LOGONSERVER': '\\\\T-W732-IX-010',
14:24:49 INFO - 'MONDIR': 'C:\\Monitor_config\\',
14:24:49 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
14:24:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
14:24:49 INFO - 'MOZ_NO_REMOTE': '1',
14:24:49 INFO - 'NO_EM_RESTART': '1',
14:24:49 INFO - 'NUMBER_OF_PROCESSORS': '8',
14:24:49 INFO - 'OS': 'Windows_NT',
14:24:49 INFO - 'OURDRIVE': 'C:',
14:24:49 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;',
14:24:49 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
14:24:49 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
14:24:49 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
14:24:49 INFO - 'PROCESSOR_LEVEL': '6',
14:24:49 INFO - 'PROCESSOR_REVISION': '1e05',
14:24:49 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
14:24:49 INFO - 'PROGRAMFILES': 'C:\\Program Files',
14:24:49 INFO - 'PROMPT': '$P$G',
14:24:49 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
14:24:49 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
14:24:49 INFO - 'PUBLIC': 'C:\\Users\\Public',
14:24:49 INFO - 'PWD': 'C:\\slave\\test',
14:24:49 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
14:24:49 INFO - 'SLAVEDIR': 'C:\\slave\\',
14:24:49 INFO - 'SYSTEMDRIVE': 'C:',
14:24:49 INFO - 'SYSTEMROOT': 'C:\\windows',
14:24:49 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
14:24:49 INFO - 'TEST1': 'testie',
14:24:49 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
14:24:49 INFO - 'USERDOMAIN': 'T-W732-IX-010',
14:24:49 INFO - 'USERNAME': 'cltbld',
14:24:49 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
14:24:49 INFO - 'WINDIR': 'C:\\windows',
14:24:49 INFO - 'WINDOWS_TRACING_FLAGS': '3',
14:24:49 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
14:24:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
14:24:50 INFO - Ignoring indexes: https://pypi.python.org/simple/
14:24:50 INFO - Downloading/unpacking psutil>=3.1.1
14:24:50 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
14:24:50 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
14:24:51 INFO - Installing collected packages: psutil
14:24:51 INFO - Successfully installed psutil
14:24:51 INFO - Cleaning up...
14:24:51 INFO - Return code: 0
14:24:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv C:\slave\test\build/venv
14:24:51 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')]}
14:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
14:24:51 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')]}
14:24:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
14:24:51 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 0x017FF640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018A8F20>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x017AB0C0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018C8E90>, '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 0x012AA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01FCB5C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-010', 'USERDOMAIN': 'T-W732-IX-010', '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-010', '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
14:24:51 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
14:24:51 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
14:24:51 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
14:24:51 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
14:24:51 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
14:24:51 INFO - 'COMPUTERNAME': 'T-W732-IX-010',
14:24:51 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
14:24:51 INFO - 'CYGWINBASE': 'C:\\cygwin',
14:24:51 INFO - 'DCLOCATION': 'SCL3',
14:24:51 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
14:24:51 INFO - 'FP_NO_HOST_CHECK': 'NO',
14:24:51 INFO - 'HOMEDRIVE': 'C:',
14:24:51 INFO - 'HOMEPATH': '\\Users\\cltbld',
14:24:51 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
14:24:51 INFO - 'KTS_VERSION': '1.19c',
14:24:51 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
14:24:51 INFO - 'LOGONSERVER': '\\\\T-W732-IX-010',
14:24:51 INFO - 'MONDIR': 'C:\\Monitor_config\\',
14:24:51 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
14:24:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
14:24:51 INFO - 'MOZ_NO_REMOTE': '1',
14:24:51 INFO - 'NO_EM_RESTART': '1',
14:24:51 INFO - 'NUMBER_OF_PROCESSORS': '8',
14:24:51 INFO - 'OS': 'Windows_NT',
14:24:51 INFO - 'OURDRIVE': 'C:',
14:24:51 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;',
14:24:51 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
14:24:51 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
14:24:51 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
14:24:51 INFO - 'PROCESSOR_LEVEL': '6',
14:24:51 INFO - 'PROCESSOR_REVISION': '1e05',
14:24:51 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
14:24:51 INFO - 'PROGRAMFILES': 'C:\\Program Files',
14:24:51 INFO - 'PROMPT': '$P$G',
14:24:51 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
14:24:51 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
14:24:51 INFO - 'PUBLIC': 'C:\\Users\\Public',
14:24:51 INFO - 'PWD': 'C:\\slave\\test',
14:24:51 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
14:24:51 INFO - 'SLAVEDIR': 'C:\\slave\\',
14:24:51 INFO - 'SYSTEMDRIVE': 'C:',
14:24:51 INFO - 'SYSTEMROOT': 'C:\\windows',
14:24:51 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
14:24:51 INFO - 'TEST1': 'testie',
14:24:51 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
14:24:51 INFO - 'USERDOMAIN': 'T-W732-IX-010',
14:24:51 INFO - 'USERNAME': 'cltbld',
14:24:51 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
14:24:51 INFO - 'WINDIR': 'C:\\windows',
14:24:51 INFO - 'WINDOWS_TRACING_FLAGS': '3',
14:24:51 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
14:24:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
14:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/
14:24:52 INFO - Downloading/unpacking mozsystemmonitor==0.3
14:24:52 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
14:24:52 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
14:24:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz
14:24:53 INFO - Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor
14:24:53 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)
14:24:53 INFO - Installing collected packages: mozsystemmonitor
14:24:53 INFO - Running setup.py install for mozsystemmonitor
14:24:54 INFO - Successfully installed mozsystemmonitor
14:24:54 INFO - Cleaning up...
14:24:54 INFO - Return code: 0
14:24:54 INFO - Installing jsonschema==2.5.1 into virtualenv C:\slave\test\build/venv
14:24:54 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')]}
14:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
14:24:54 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')]}
14:24:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
14:24:54 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 0x017FF640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018A8F20>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x017AB0C0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018C8E90>, '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 0x012AA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01FCB5C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-010', 'USERDOMAIN': 'T-W732-IX-010', '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-010', '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
14:24:54 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
14:24:54 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
14:24:54 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
14:24:54 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
14:24:54 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
14:24:54 INFO - 'COMPUTERNAME': 'T-W732-IX-010',
14:24:54 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
14:24:54 INFO - 'CYGWINBASE': 'C:\\cygwin',
14:24:54 INFO - 'DCLOCATION': 'SCL3',
14:24:54 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
14:24:54 INFO - 'FP_NO_HOST_CHECK': 'NO',
14:24:54 INFO - 'HOMEDRIVE': 'C:',
14:24:54 INFO - 'HOMEPATH': '\\Users\\cltbld',
14:24:54 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
14:24:54 INFO - 'KTS_VERSION': '1.19c',
14:24:54 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
14:24:54 INFO - 'LOGONSERVER': '\\\\T-W732-IX-010',
14:24:54 INFO - 'MONDIR': 'C:\\Monitor_config\\',
14:24:54 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
14:24:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
14:24:54 INFO - 'MOZ_NO_REMOTE': '1',
14:24:54 INFO - 'NO_EM_RESTART': '1',
14:24:54 INFO - 'NUMBER_OF_PROCESSORS': '8',
14:24:54 INFO - 'OS': 'Windows_NT',
14:24:54 INFO - 'OURDRIVE': 'C:',
14:24:54 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;',
14:24:54 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
14:24:54 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
14:24:54 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
14:24:54 INFO - 'PROCESSOR_LEVEL': '6',
14:24:54 INFO - 'PROCESSOR_REVISION': '1e05',
14:24:54 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
14:24:54 INFO - 'PROGRAMFILES': 'C:\\Program Files',
14:24:54 INFO - 'PROMPT': '$P$G',
14:24:54 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
14:24:54 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
14:24:54 INFO - 'PUBLIC': 'C:\\Users\\Public',
14:24:54 INFO - 'PWD': 'C:\\slave\\test',
14:24:54 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
14:24:54 INFO - 'SLAVEDIR': 'C:\\slave\\',
14:24:54 INFO - 'SYSTEMDRIVE': 'C:',
14:24:54 INFO - 'SYSTEMROOT': 'C:\\windows',
14:24:54 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
14:24:54 INFO - 'TEST1': 'testie',
14:24:54 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
14:24:54 INFO - 'USERDOMAIN': 'T-W732-IX-010',
14:24:54 INFO - 'USERNAME': 'cltbld',
14:24:54 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
14:24:54 INFO - 'WINDIR': 'C:\\windows',
14:24:54 INFO - 'WINDOWS_TRACING_FLAGS': '3',
14:24:54 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
14:24:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
14:24:54 INFO - Ignoring indexes: https://pypi.python.org/simple/
14:24:54 INFO - Downloading/unpacking jsonschema==2.5.1
14:24:54 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
14:24:54 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
14:24:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl
14:24:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1)
14:24: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
14:24: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
14:24:55 INFO - Downloading functools32-3.2.3-2.tar.gz
14:24:55 INFO - Running setup.py (path:C:\slave\test\build\venv\build\functools32\setup.py) egg_info for package functools32
14:24:56 INFO - warning: no files found matching '*.txt'
14:24:56 INFO - no previously-included directories found matching 'build'
14:24:56 INFO - no previously-included directories found matching 'dist'
14:24:56 INFO - no previously-included directories found matching '.git*'
14:24:56 INFO - Installing collected packages: jsonschema, functools32
14:24:56 INFO - Running setup.py install for functools32
14:24:56 INFO - warning: no files found matching '*.txt'
14:24:56 INFO - no previously-included directories found matching 'build'
14:24:56 INFO - no previously-included directories found matching 'dist'
14:24:56 INFO - no previously-included directories found matching '.git*'
14:24:56 INFO - Successfully installed jsonschema functools32
14:24:56 INFO - Cleaning up...
14:24:56 INFO - Return code: 0
14:24:56 INFO - Installing functools32==3.2.3-2 into virtualenv C:\slave\test\build/venv
14:24: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')]}
14:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
14:24: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')]}
14:24:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
14:24: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', '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 0x017FF640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018A8F20>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x017AB0C0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018C8E90>, '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 0x012AA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01FCB5C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-010', 'USERDOMAIN': 'T-W732-IX-010', '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-010', '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
14:24: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', 'functools32==3.2.3-2'] in C:\slave\test\build
14:24: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 functools32==3.2.3-2
14:24:56 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
14:24:56 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
14:24:56 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
14:24:56 INFO - 'COMPUTERNAME': 'T-W732-IX-010',
14:24:56 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
14:24:56 INFO - 'CYGWINBASE': 'C:\\cygwin',
14:24:56 INFO - 'DCLOCATION': 'SCL3',
14:24:56 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
14:24:56 INFO - 'FP_NO_HOST_CHECK': 'NO',
14:24:56 INFO - 'HOMEDRIVE': 'C:',
14:24:56 INFO - 'HOMEPATH': '\\Users\\cltbld',
14:24:56 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
14:24:56 INFO - 'KTS_VERSION': '1.19c',
14:24:56 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
14:24:56 INFO - 'LOGONSERVER': '\\\\T-W732-IX-010',
14:24:56 INFO - 'MONDIR': 'C:\\Monitor_config\\',
14:24:56 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
14:24:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
14:24:56 INFO - 'MOZ_NO_REMOTE': '1',
14:24:56 INFO - 'NO_EM_RESTART': '1',
14:24:56 INFO - 'NUMBER_OF_PROCESSORS': '8',
14:24:56 INFO - 'OS': 'Windows_NT',
14:24:56 INFO - 'OURDRIVE': 'C:',
14:24: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;',
14:24:56 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
14:24:56 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
14:24:56 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
14:24:56 INFO - 'PROCESSOR_LEVEL': '6',
14:24:56 INFO - 'PROCESSOR_REVISION': '1e05',
14:24:56 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
14:24:56 INFO - 'PROGRAMFILES': 'C:\\Program Files',
14:24:56 INFO - 'PROMPT': '$P$G',
14:24:56 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
14:24:56 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
14:24:56 INFO - 'PUBLIC': 'C:\\Users\\Public',
14:24:56 INFO - 'PWD': 'C:\\slave\\test',
14:24:56 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
14:24:56 INFO - 'SLAVEDIR': 'C:\\slave\\',
14:24:56 INFO - 'SYSTEMDRIVE': 'C:',
14:24:56 INFO - 'SYSTEMROOT': 'C:\\windows',
14:24:56 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
14:24:56 INFO - 'TEST1': 'testie',
14:24:56 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
14:24:56 INFO - 'USERDOMAIN': 'T-W732-IX-010',
14:24:56 INFO - 'USERNAME': 'cltbld',
14:24:56 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
14:24:56 INFO - 'WINDIR': 'C:\\windows',
14:24:56 INFO - 'WINDOWS_TRACING_FLAGS': '3',
14:24:56 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
14:24:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
14:24:57 INFO - Ignoring indexes: https://pypi.python.org/simple/
14:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in c:\slave\test\build\venv\lib\site-packages
14:24:57 INFO - Cleaning up...
14:24:57 INFO - Return code: 0
14:24:57 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv
14:24:57 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')]}
14:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
14:24:57 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')]}
14:24:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
14:24:57 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 0x017FF640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018A8F20>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x017AB0C0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018C8E90>, '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 0x012AA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01FCB5C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-010', 'USERDOMAIN': 'T-W732-IX-010', '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-010', '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
14:24:57 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
14:24:57 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
14:24:57 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
14:24:57 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
14:24:57 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
14:24:57 INFO - 'COMPUTERNAME': 'T-W732-IX-010',
14:24:57 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
14:24:57 INFO - 'CYGWINBASE': 'C:\\cygwin',
14:24:57 INFO - 'DCLOCATION': 'SCL3',
14:24:57 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
14:24:57 INFO - 'FP_NO_HOST_CHECK': 'NO',
14:24:57 INFO - 'HOMEDRIVE': 'C:',
14:24:57 INFO - 'HOMEPATH': '\\Users\\cltbld',
14:24:57 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
14:24:57 INFO - 'KTS_VERSION': '1.19c',
14:24:57 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
14:24:57 INFO - 'LOGONSERVER': '\\\\T-W732-IX-010',
14:24:57 INFO - 'MONDIR': 'C:\\Monitor_config\\',
14:24:57 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
14:24:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
14:24:57 INFO - 'MOZ_NO_REMOTE': '1',
14:24:57 INFO - 'NO_EM_RESTART': '1',
14:24:57 INFO - 'NUMBER_OF_PROCESSORS': '8',
14:24:57 INFO - 'OS': 'Windows_NT',
14:24:57 INFO - 'OURDRIVE': 'C:',
14:24:57 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;',
14:24:57 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
14:24:57 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
14:24:57 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
14:24:57 INFO - 'PROCESSOR_LEVEL': '6',
14:24:57 INFO - 'PROCESSOR_REVISION': '1e05',
14:24:57 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
14:24:57 INFO - 'PROGRAMFILES': 'C:\\Program Files',
14:24:57 INFO - 'PROMPT': '$P$G',
14:24:57 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
14:24:57 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
14:24:57 INFO - 'PUBLIC': 'C:\\Users\\Public',
14:24:57 INFO - 'PWD': 'C:\\slave\\test',
14:24:57 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
14:24:57 INFO - 'SLAVEDIR': 'C:\\slave\\',
14:24:57 INFO - 'SYSTEMDRIVE': 'C:',
14:24:57 INFO - 'SYSTEMROOT': 'C:\\windows',
14:24:57 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
14:24:57 INFO - 'TEST1': 'testie',
14:24:57 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
14:24:57 INFO - 'USERDOMAIN': 'T-W732-IX-010',
14:24:57 INFO - 'USERNAME': 'cltbld',
14:24:57 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
14:24:57 INFO - 'WINDIR': 'C:\\windows',
14:24:57 INFO - 'WINDOWS_TRACING_FLAGS': '3',
14:24:57 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
14:24:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
14:24:57 INFO - Ignoring indexes: https://pypi.python.org/simple/
14:24:57 INFO - Downloading/unpacking blobuploader==1.2.4
14:24: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
14:24: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
14:24:58 INFO - Downloading blobuploader-1.2.4.tar.gz
14:24:58 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader
14:24:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4)
14:24: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
14:24: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
14:24:59 INFO - Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests
14:24:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4)
14:24: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
14:24: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
14:24:59 INFO - Downloading docopt-0.6.1.tar.gz
14:24:59 INFO - Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt
14:24:59 INFO - Installing collected packages: blobuploader, requests, docopt
14:24:59 INFO - Running setup.py install for blobuploader
14:25:00 INFO - Running setup.py install for requests
14:25:00 INFO - Running setup.py install for docopt
14:25:00 INFO - Successfully installed blobuploader requests docopt
14:25:00 INFO - Cleaning up...
14:25:01 INFO - Return code: 0
14:25:01 INFO - Installing None into virtualenv C:\slave\test\build/venv
14:25: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')]}
14:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
14:25: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')]}
14:25:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
14:25:01 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 0x017FF640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018A8F20>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x017AB0C0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018C8E90>, '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 0x012AA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01FCB5C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-010', 'USERDOMAIN': 'T-W732-IX-010', '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-010', '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
14:25:02 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
14:25:02 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
14:25:02 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
14:25:02 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
14:25:02 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
14:25:02 INFO - 'COMPUTERNAME': 'T-W732-IX-010',
14:25:02 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
14:25:02 INFO - 'CYGWINBASE': 'C:\\cygwin',
14:25:02 INFO - 'DCLOCATION': 'SCL3',
14:25:02 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
14:25:02 INFO - 'FP_NO_HOST_CHECK': 'NO',
14:25:02 INFO - 'HOMEDRIVE': 'C:',
14:25:02 INFO - 'HOMEPATH': '\\Users\\cltbld',
14:25:02 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
14:25:02 INFO - 'KTS_VERSION': '1.19c',
14:25:02 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
14:25:02 INFO - 'LOGONSERVER': '\\\\T-W732-IX-010',
14:25:02 INFO - 'MONDIR': 'C:\\Monitor_config\\',
14:25:02 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
14:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
14:25:02 INFO - 'MOZ_NO_REMOTE': '1',
14:25:02 INFO - 'NO_EM_RESTART': '1',
14:25:02 INFO - 'NUMBER_OF_PROCESSORS': '8',
14:25:02 INFO - 'OS': 'Windows_NT',
14:25:02 INFO - 'OURDRIVE': 'C:',
14:25: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;',
14:25:02 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
14:25:02 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
14:25:02 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
14:25:02 INFO - 'PROCESSOR_LEVEL': '6',
14:25:02 INFO - 'PROCESSOR_REVISION': '1e05',
14:25:02 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
14:25:02 INFO - 'PROGRAMFILES': 'C:\\Program Files',
14:25:02 INFO - 'PROMPT': '$P$G',
14:25:02 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
14:25:02 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
14:25:02 INFO - 'PUBLIC': 'C:\\Users\\Public',
14:25:02 INFO - 'PWD': 'C:\\slave\\test',
14:25:02 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
14:25:02 INFO - 'SLAVEDIR': 'C:\\slave\\',
14:25:02 INFO - 'SYSTEMDRIVE': 'C:',
14:25:02 INFO - 'SYSTEMROOT': 'C:\\windows',
14:25:02 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
14:25:02 INFO - 'TEST1': 'testie',
14:25:02 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
14:25:02 INFO - 'USERDOMAIN': 'T-W732-IX-010',
14:25:02 INFO - 'USERNAME': 'cltbld',
14:25:02 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
14:25:02 INFO - 'WINDIR': 'C:\\windows',
14:25:02 INFO - 'WINDOWS_TRACING_FLAGS': '3',
14:25:02 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
14:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
14:25:02 INFO - Ignoring indexes: https://pypi.python.org/simple/
14:25:02 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser
14:25:02 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-le_ro0-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser
14:25:02 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash
14:25:02 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-oofp6s-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash
14:25:02 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug
14:25:02 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-aiszul-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug
14:25:02 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice
14:25:02 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-qixchi-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice
14:25:03 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile
14:25:03 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-d8bcn6-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile
14:25:03 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd
14:25:03 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-onieda-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd
14:25:03 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo
14:25:03 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-pvkr9b-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo
14:25:03 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall
14:25:03 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-wiqmti-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall
14:25:04 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak
14:25:04 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-x6baqt-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak
14:25:04 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog
14:25:04 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-yiknb2-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog
14:25:04 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork
14:25:04 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-4hecpn-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork
14:25:04 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess
14:25:04 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-1ty9oi-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess
14:25:04 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile
14:25:04 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-tckcvg-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile
14:25:04 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner
14:25:04 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-brk50k-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner
14:25:04 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot
14:25:04 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-nnheha-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot
14:25:05 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest
14:25:05 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-7maghe-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest
14:25:05 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion
14:25:05 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-jn7ymu-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion
14:25:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion
14:25:05 INFO - Running setup.py install for manifestparser
14:25:05 INFO - Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts
14:25:05 INFO - Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts
14:25:05 INFO - Running setup.py install for mozcrash
14:25:06 INFO - Running setup.py install for mozdebug
14:25:06 INFO - Running setup.py install for mozdevice
14:25:06 INFO - Installing sutini-script.py script to C:\slave\test\build\venv\Scripts
14:25:06 INFO - Installing sutini.exe script to C:\slave\test\build\venv\Scripts
14:25:06 INFO - Installing dm-script.py script to C:\slave\test\build\venv\Scripts
14:25:06 INFO - Installing dm.exe script to C:\slave\test\build\venv\Scripts
14:25:07 INFO - Running setup.py install for mozfile
14:25:07 INFO - Running setup.py install for mozhttpd
14:25:07 INFO - Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts
14:25:07 INFO - Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts
14:25:07 INFO - Running setup.py install for mozinfo
14:25:08 INFO - Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts
14:25:08 INFO - Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts
14:25:08 INFO - Running setup.py install for mozInstall
14:25:08 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts
14:25:08 INFO - Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts
14:25:08 INFO - Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts
14:25:08 INFO - Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts
14:25:08 INFO - Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts
14:25:08 INFO - Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts
14:25:08 INFO - Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts
14:25:08 INFO - Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts
14:25:08 INFO - Running setup.py install for mozleak
14:25:08 INFO - Running setup.py install for mozlog
14:25:09 INFO - Installing structlog-script.py script to C:\slave\test\build\venv\Scripts
14:25:09 INFO - Installing structlog.exe script to C:\slave\test\build\venv\Scripts
14:25:09 INFO - Running setup.py install for moznetwork
14:25:10 INFO - Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts
14:25:10 INFO - Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts
14:25:10 INFO - Running setup.py install for mozprocess
14:25:10 INFO - Running setup.py install for mozprofile
14:25:10 INFO - Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts
14:25:10 INFO - Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts
14:25:10 INFO - Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts
14:25:10 INFO - Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts
14:25:10 INFO - Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts
14:25:10 INFO - Installing view-profile.exe script to C:\slave\test\build\venv\Scripts
14:25:11 INFO - Running setup.py install for mozrunner
14:25:11 INFO - Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts
14:25:11 INFO - Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts
14:25:12 INFO - Running setup.py install for mozscreenshot
14:25:12 INFO - Running setup.py install for moztest
14:25:12 INFO - Running setup.py install for mozversion
14:25:12 INFO - Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts
14:25:12 INFO - Installing mozversion.exe script to C:\slave\test\build\venv\Scripts
14:25:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion
14:25:13 INFO - Cleaning up...
14:25:13 INFO - Return code: 0
14:25:13 INFO - Installing None into virtualenv C:\slave\test\build/venv
14:25:13 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')]}
14:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
14:25:13 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')]}
14:25:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
14:25:13 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 0x017FF640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018A8F20>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x017AB0C0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018C8E90>, '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 0x012AA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01FCB5C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-010', 'USERDOMAIN': 'T-W732-IX-010', '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-010', '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
14:25:13 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
14:25:13 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
14:25:13 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
14:25:13 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
14:25:13 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
14:25:13 INFO - 'COMPUTERNAME': 'T-W732-IX-010',
14:25:13 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
14:25:13 INFO - 'CYGWINBASE': 'C:\\cygwin',
14:25:13 INFO - 'DCLOCATION': 'SCL3',
14:25:13 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
14:25:13 INFO - 'FP_NO_HOST_CHECK': 'NO',
14:25:13 INFO - 'HOMEDRIVE': 'C:',
14:25:13 INFO - 'HOMEPATH': '\\Users\\cltbld',
14:25:13 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
14:25:13 INFO - 'KTS_VERSION': '1.19c',
14:25:13 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
14:25:13 INFO - 'LOGONSERVER': '\\\\T-W732-IX-010',
14:25:13 INFO - 'MONDIR': 'C:\\Monitor_config\\',
14:25:13 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
14:25:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
14:25:13 INFO - 'MOZ_NO_REMOTE': '1',
14:25:13 INFO - 'NO_EM_RESTART': '1',
14:25:13 INFO - 'NUMBER_OF_PROCESSORS': '8',
14:25:13 INFO - 'OS': 'Windows_NT',
14:25:13 INFO - 'OURDRIVE': 'C:',
14:25:13 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;',
14:25:13 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
14:25:13 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
14:25:13 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
14:25:13 INFO - 'PROCESSOR_LEVEL': '6',
14:25:13 INFO - 'PROCESSOR_REVISION': '1e05',
14:25:13 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
14:25:13 INFO - 'PROGRAMFILES': 'C:\\Program Files',
14:25:13 INFO - 'PROMPT': '$P$G',
14:25:13 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
14:25:13 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
14:25:13 INFO - 'PUBLIC': 'C:\\Users\\Public',
14:25:13 INFO - 'PWD': 'C:\\slave\\test',
14:25:13 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
14:25:13 INFO - 'SLAVEDIR': 'C:\\slave\\',
14:25:13 INFO - 'SYSTEMDRIVE': 'C:',
14:25:13 INFO - 'SYSTEMROOT': 'C:\\windows',
14:25:13 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
14:25:13 INFO - 'TEST1': 'testie',
14:25:13 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
14:25:13 INFO - 'USERDOMAIN': 'T-W732-IX-010',
14:25:13 INFO - 'USERNAME': 'cltbld',
14:25:13 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
14:25:13 INFO - 'WINDIR': 'C:\\windows',
14:25:13 INFO - 'WINDOWS_TRACING_FLAGS': '3',
14:25:13 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
14:25:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
14:25:13 INFO - Ignoring indexes: https://pypi.python.org/simple/
14:25:13 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser
14:25:13 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-tplejo-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser
14:25:13 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))
14:25:13 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash
14:25:13 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-79g5za-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash
14:25:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///C:/slave/test/build/tests/mozbase/mozcrash in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2))
14:25:13 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug
14:25:13 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-3yt76u-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug
14:25:14 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))
14:25:14 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice
14:25:14 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-ec6xbb-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice
14:25:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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))
14:25:14 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile
14:25:14 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-lfkxzn-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile
14:25:14 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))
14:25:14 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd
14:25:14 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-nddmga-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd
14:25:14 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))
14:25:14 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo
14:25:14 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-x5wblx-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo
14:25:14 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))
14:25:14 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall
14:25:14 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-huz9ui-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall
14:25:14 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))
14:25:14 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak
14:25:14 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-hixicr-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak
14:25:14 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))
14:25:14 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog
14:25:15 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-w_ybrk-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog
14:25:15 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))
14:25:15 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork
14:25:15 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-iumesy-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork
14:25:15 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))
14:25:15 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess
14:25:15 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-pq14u6-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess
14:25:15 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))
14:25:15 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile
14:25:15 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-zqpa9a-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile
14:25:15 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))
14:25:15 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner
14:25:15 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-zvgwz8-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner
14:25:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///C:/slave/test/build/tests/mozbase/mozrunner in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 14))
14:25:15 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot
14:25:15 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-lcolo0-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot
14:25:15 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))
14:25:15 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest
14:25:15 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-wybjrl-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest
14:25:15 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))
14:25:15 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion
14:25:15 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-6vl_yl-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion
14:25:16 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))
14:25:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==1.0->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2))
14:25:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==1.0->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2))
14:25:16 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))
14:25:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test\build\venv\lib\site-packages (from mozdevice==0.49->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4))
14:25:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in c:\slave\test\build\venv\lib\site-packages (from mozdevice==0.49->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4))
14:25:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10))
14:25:16 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
14:25:16 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
14:25:17 INFO - Downloading blessings-1.6.tar.gz
14:25:17 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings
14:25:17 INFO - Installing collected packages: blessings
14:25:17 INFO - Running setup.py install for blessings
14:25:17 INFO - Successfully installed blessings
14:25:17 INFO - Cleaning up...
14:25:20 INFO - Return code: 0
14:25:20 INFO - Done creating virtualenv C:\slave\test\build/venv.
14:25:20 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze']
14:25:20 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze
14:25:20 INFO - Reading from file tmpfile_stdout
14:25:20 INFO - Using _rmtree_windows ...
14:25:20 INFO - Using _rmtree_windows ...
14:25:20 INFO - Current package versions:
14:25:20 INFO - blessings == 1.6
14:25:20 INFO - blobuploader == 1.2.4
14:25:20 INFO - docopt == 0.6.1
14:25:20 INFO - functools32 == 3.2.3-2
14:25:20 INFO - jsonschema == 2.5.1
14:25:20 INFO - manifestparser == 1.1
14:25:20 INFO - mozInstall == 1.12
14:25:20 INFO - mozcrash == 1.0
14:25:20 INFO - mozdebug == 0.1
14:25:20 INFO - mozdevice == 0.49
14:25:20 INFO - mozfile == 1.2
14:25:20 INFO - mozhttpd == 0.7
14:25:20 INFO - mozinfo == 0.9
14:25:20 INFO - mozleak == 0.1
14:25:20 INFO - mozlog == 3.4
14:25:20 INFO - moznetwork == 0.27
14:25:20 INFO - mozprocess == 0.23
14:25:20 INFO - mozprofile == 0.28
14:25:20 INFO - mozrunner == 6.13
14:25:20 INFO - mozscreenshot == 0.1
14:25:20 INFO - mozsystemmonitor == 0.3
14:25:20 INFO - moztest == 0.7
14:25:20 INFO - mozversion == 1.4
14:25:20 INFO - psutil == 3.1.1
14:25:20 INFO - requests == 1.2.3
14:25:20 INFO - Installing None into virtualenv C:\slave\test\build/venv
14:25: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')]}
14:25:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
14:25: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')]}
14:25:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
14:25:20 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 0x017FF640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018A8F20>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x017AB0C0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018C8E90>, '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 0x012AA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01FCB5C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build\\tests\\talos', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-010', 'USERDOMAIN': 'T-W732-IX-010', '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-010', '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
14:25:20 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
14:25:20 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
14:25:20 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
14:25:20 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
14:25:20 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
14:25:20 INFO - 'COMPUTERNAME': 'T-W732-IX-010',
14:25:20 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
14:25:20 INFO - 'CYGWINBASE': 'C:\\cygwin',
14:25:20 INFO - 'DCLOCATION': 'SCL3',
14:25:20 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
14:25:20 INFO - 'FP_NO_HOST_CHECK': 'NO',
14:25:20 INFO - 'HOMEDRIVE': 'C:',
14:25:20 INFO - 'HOMEPATH': '\\Users\\cltbld',
14:25:20 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
14:25:20 INFO - 'KTS_VERSION': '1.19c',
14:25:20 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
14:25:20 INFO - 'LOGONSERVER': '\\\\T-W732-IX-010',
14:25:20 INFO - 'MONDIR': 'C:\\Monitor_config\\',
14:25:20 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
14:25:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
14:25:20 INFO - 'MOZ_NO_REMOTE': '1',
14:25:20 INFO - 'NO_EM_RESTART': '1',
14:25:20 INFO - 'NUMBER_OF_PROCESSORS': '8',
14:25:20 INFO - 'OS': 'Windows_NT',
14:25:20 INFO - 'OURDRIVE': 'C:',
14:25: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;',
14:25:20 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
14:25:20 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
14:25:20 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
14:25:20 INFO - 'PROCESSOR_LEVEL': '6',
14:25:20 INFO - 'PROCESSOR_REVISION': '1e05',
14:25:20 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
14:25:20 INFO - 'PROGRAMFILES': 'C:\\Program Files',
14:25:20 INFO - 'PROMPT': '$P$G',
14:25:20 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
14:25:20 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
14:25:20 INFO - 'PUBLIC': 'C:\\Users\\Public',
14:25:20 INFO - 'PWD': 'C:\\slave\\test',
14:25:20 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
14:25:20 INFO - 'SLAVEDIR': 'C:\\slave\\',
14:25:20 INFO - 'SYSTEMDRIVE': 'C:',
14:25:20 INFO - 'SYSTEMROOT': 'C:\\windows',
14:25:20 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
14:25:20 INFO - 'TEST1': 'testie',
14:25:20 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
14:25:20 INFO - 'USERDOMAIN': 'T-W732-IX-010',
14:25:20 INFO - 'USERNAME': 'cltbld',
14:25:20 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
14:25:20 INFO - 'WINDIR': 'C:\\windows',
14:25:20 INFO - 'WINDOWS_TRACING_FLAGS': '3',
14:25:20 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
14:25:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
14:25:21 INFO - Ignoring indexes: https://pypi.python.org/simple/
14:25:21 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))
14:25:21 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))
14:25:21 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))
14:25:21 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))
14:25:21 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))
14:25:21 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))
14:25:21 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))
14:25:21 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))
14:25:21 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))
14:25:21 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))
14:25:21 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))
14:25:21 INFO - Cleaning up...
14:25:21 INFO - Return code: 0
14:25:21 INFO - Installing jsonschema into virtualenv C:\slave\test\build/venv
14:25:21 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')]}
14:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
14:25:21 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')]}
14:25:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
14:25:21 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 0x017FF640>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018A8F20>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x017AB0C0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018C8E90>, '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 0x012AA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01FCB5C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-010', 'USERDOMAIN': 'T-W732-IX-010', '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-010', '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
14:25:21 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
14:25:21 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
14:25:21 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
14:25:21 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
14:25:21 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
14:25:21 INFO - 'COMPUTERNAME': 'T-W732-IX-010',
14:25:21 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
14:25:21 INFO - 'CYGWINBASE': 'C:\\cygwin',
14:25:21 INFO - 'DCLOCATION': 'SCL3',
14:25:21 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
14:25:21 INFO - 'FP_NO_HOST_CHECK': 'NO',
14:25:21 INFO - 'HOMEDRIVE': 'C:',
14:25:21 INFO - 'HOMEPATH': '\\Users\\cltbld',
14:25:21 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
14:25:21 INFO - 'KTS_VERSION': '1.19c',
14:25:21 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
14:25:21 INFO - 'LOGONSERVER': '\\\\T-W732-IX-010',
14:25:21 INFO - 'MONDIR': 'C:\\Monitor_config\\',
14:25:21 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
14:25:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
14:25:21 INFO - 'MOZ_NO_REMOTE': '1',
14:25:21 INFO - 'NO_EM_RESTART': '1',
14:25:21 INFO - 'NUMBER_OF_PROCESSORS': '8',
14:25:21 INFO - 'OS': 'Windows_NT',
14:25:21 INFO - 'OURDRIVE': 'C:',
14:25:21 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;',
14:25:21 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
14:25:21 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
14:25:21 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
14:25:21 INFO - 'PROCESSOR_LEVEL': '6',
14:25:21 INFO - 'PROCESSOR_REVISION': '1e05',
14:25:21 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
14:25:21 INFO - 'PROGRAMFILES': 'C:\\Program Files',
14:25:21 INFO - 'PROMPT': '$P$G',
14:25:21 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
14:25:21 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
14:25:21 INFO - 'PUBLIC': 'C:\\Users\\Public',
14:25:21 INFO - 'PWD': 'C:\\slave\\test',
14:25:21 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
14:25:21 INFO - 'SLAVEDIR': 'C:\\slave\\',
14:25:21 INFO - 'SYSTEMDRIVE': 'C:',
14:25:21 INFO - 'SYSTEMROOT': 'C:\\windows',
14:25:21 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
14:25:21 INFO - 'TEST1': 'testie',
14:25:21 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
14:25:21 INFO - 'USERDOMAIN': 'T-W732-IX-010',
14:25:21 INFO - 'USERNAME': 'cltbld',
14:25:21 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
14:25:21 INFO - 'WINDIR': 'C:\\windows',
14:25:21 INFO - 'WINDOWS_TRACING_FLAGS': '3',
14:25:21 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
14:25:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
14:25:21 INFO - Ignoring indexes: https://pypi.python.org/simple/
14:25:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in c:\slave\test\build\venv\lib\site-packages
14:25:21 INFO - Cleaning up...
14:25:21 INFO - Return code: 0
14:25:21 INFO - Running post-action listener: _resource_record_post_action
14:25:21 INFO - Running post-action listener: _start_resource_monitoring
14:25:21 INFO - Starting resource monitoring.
14:25:21 INFO - [mozharness: 2016-12-02 22:25:21.704000Z] Finished create-virtualenv step (success)
14:25:21 INFO - [mozharness: 2016-12-02 22:25:21.704000Z] Running install step.
14:25:21 INFO - Running pre-action listener: _resource_record_pre_action
14:25:21 INFO - Running main action method: install
14:25:21 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze']
14:25:21 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze
14:25:22 INFO - Reading from file tmpfile_stdout
14:25:22 INFO - Using _rmtree_windows ...
14:25:22 INFO - Using _rmtree_windows ...
14:25:22 INFO - Detecting whether we're running mozinstall >=1.0...
14:25:22 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h']
14:25:22 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h
14:25:22 INFO - Reading from file tmpfile_stdout
14:25:22 INFO - Output received:
14:25:22 INFO - Usage: mozinstall-script.py [options] installer
14:25:22 INFO - Options:
14:25:22 INFO - -h, --help show this help message and exit
14:25:22 INFO - -d DEST, --destination=DEST
14:25:22 INFO - Directory to install application into. [default:
14:25:22 INFO - "C:\slave\test"]
14:25:22 INFO - --app=APP Application being installed. [default: firefox]
14:25:22 INFO - Using _rmtree_windows ...
14:25:22 INFO - Using _rmtree_windows ...
14:25:22 INFO - mkdir: C:\slave\test\build\application
14:25:22 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-53.0a1.en-US.win32.zip', '--destination', 'C:\\slave\\test\\build\\application']
14:25:22 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py C:\slave\test\build\firefox-53.0a1.en-US.win32.zip --destination C:\slave\test\build\application
14:25:24 INFO - Reading from file tmpfile_stdout
14:25:24 INFO - Output received:
14:25:24 INFO - C:\slave\test\build\application\firefox\firefox.exe
14:25:24 INFO - Using _rmtree_windows ...
14:25:24 INFO - Using _rmtree_windows ...
14:25:24 INFO - Running post-action listener: _resource_record_post_action
14:25:24 INFO - [mozharness: 2016-12-02 22:25:24.299000Z] Finished install step (success)
14:25:24 INFO - [mozharness: 2016-12-02 22:25:24.300000Z] Running run-tests step.
14:25:24 INFO - Running pre-action listener: _resource_record_pre_action
14:25:24 INFO - Running main action method: run_tests
14:25:24 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version']
14:25:24 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version
14:25:24 INFO - Python 2.7.3
14:25:24 INFO - Return code: 0
14:25:24 INFO - grabbing minidump binary from tooltool
14:25:24 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')]}
14:25:24 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 0x018C8E90>, '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 0x012AA910>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01FCB5C0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1
14:25:24 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
14:25:24 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
14:25:24 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
14:25:24 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'...
14:25:27 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmpgmr25n
14:25:27 INFO - INFO - File integrity verified, renaming tmpgmr25n to win32-minidump_stackwalk.exe
14:25:27 INFO - Return code: 0
14:25:27 INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755
14:25:27 INFO - mkdir: C:\slave\test\build\blobber_upload_dir
14:25:27 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir
14:25:27 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe
14:25:27 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir
14:25:27 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UUZzPjZcQeGRz3KpQ_4tlA/artifacts/public/build/firefox-53.0a1.en-US.win32.crashreporter-symbols.zip', '--title', 'T-W732-IX-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs-e10s_errorsummary.log', '--log-raw=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs-e10s_raw.log'] in C:\slave\test\build
14:25:27 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\tests\talos\talos\run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath C:\slave\test\build\application\firefox\firefox --symbolsPath https://queue.taskcluster.net/v1/task/UUZzPjZcQeGRz3KpQ_4tlA/artifacts/public/build/firefox-53.0a1.en-US.win32.crashreporter-symbols.zip --title T-W732-IX-010 --webServer localhost --log-tbpl-level=debug --log-errorsummary=C:\slave\test\build\blobber_upload_dir\dromaeojs-e10s_errorsummary.log --log-raw=C:\slave\test\build\blobber_upload_dir\dromaeojs-e10s_raw.log
14:25:27 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
14:25:27 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
14:25:27 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
14:25:27 INFO - 'COMPUTERNAME': 'T-W732-IX-010',
14:25:27 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
14:25:27 INFO - 'CYGWINBASE': 'C:\\cygwin',
14:25:27 INFO - 'DCLOCATION': 'SCL3',
14:25:27 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
14:25:27 INFO - 'FP_NO_HOST_CHECK': 'NO',
14:25:27 INFO - 'HOMEDRIVE': 'C:',
14:25:27 INFO - 'HOMEPATH': '\\Users\\cltbld',
14:25:27 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
14:25:27 INFO - 'KTS_VERSION': '1.19c',
14:25:27 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
14:25:27 INFO - 'LOGONSERVER': '\\\\T-W732-IX-010',
14:25:27 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir',
14:25:27 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe',
14:25:27 INFO - 'MONDIR': 'C:\\Monitor_config\\',
14:25:27 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
14:25:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
14:25:27 INFO - 'MOZ_NO_REMOTE': '1',
14:25:27 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir',
14:25:27 INFO - 'NO_EM_RESTART': '1',
14:25:27 INFO - 'NUMBER_OF_PROCESSORS': '8',
14:25:27 INFO - 'OS': 'Windows_NT',
14:25:27 INFO - 'OURDRIVE': 'C:',
14:25: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;',
14:25:27 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
14:25:27 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
14:25:27 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
14:25:27 INFO - 'PROCESSOR_LEVEL': '6',
14:25:27 INFO - 'PROCESSOR_REVISION': '1e05',
14:25:27 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
14:25:27 INFO - 'PROGRAMFILES': 'C:\\Program Files',
14:25:27 INFO - 'PROMPT': '$P$G',
14:25:27 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
14:25:27 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
14:25:27 INFO - 'PUBLIC': 'C:\\Users\\Public',
14:25:27 INFO - 'PWD': 'C:\\slave\\test',
14:25:27 INFO - 'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos',
14:25:27 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
14:25:27 INFO - 'SLAVEDIR': 'C:\\slave\\',
14:25:27 INFO - 'SYSTEMDRIVE': 'C:',
14:25:27 INFO - 'SYSTEMROOT': 'C:\\windows',
14:25:27 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
14:25:27 INFO - 'TEST1': 'testie',
14:25:27 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
14:25:27 INFO - 'USERDOMAIN': 'T-W732-IX-010',
14:25:27 INFO - 'USERNAME': 'cltbld',
14:25:27 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
14:25:27 INFO - 'WINDIR': 'C:\\windows',
14:25:27 INFO - 'WINDOWS_TRACING_FLAGS': '3',
14:25:27 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
14:25:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
14:25:27 INFO - Calling ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UUZzPjZcQeGRz3KpQ_4tlA/artifacts/public/build/firefox-53.0a1.en-US.win32.crashreporter-symbols.zip', '--title', 'T-W732-IX-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs-e10s_errorsummary.log', '--log-raw=C:\\slave\\test\\build\\blobber_upload_dir\\dromaeojs-e10s_raw.log'] with output_timeout 3600
14:25:28 INFO - mozversion application_buildid: 20161202130744
14:25:28 INFO - mozversion application_changeset: 633e960e72dbd3006a2d0325416e50a19a7e1838
14:25:28 INFO - mozversion application_display_name: Nightly
14:25:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384}
14:25:28 INFO - mozversion application_name: Firefox
14:25:28 INFO - mozversion application_remotingname: firefox
14:25:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central
14:25:28 INFO - mozversion application_vendor: Mozilla
14:25:28 INFO - mozversion application_version: 53.0a1
14:25:28 INFO - mozversion platform_buildid: 20161202130744
14:25:28 INFO - mozversion platform_changeset: 633e960e72dbd3006a2d0325416e50a19a7e1838
14:25:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central
14:25:28 INFO - mozversion platform_version: 53.0a1
14:25:28 INFO - using testdate: 1480717528
14:25:28 INFO - actual date: 1480717528
14:25:28 INFO - starting webserver on 'localhost:49897'
14:25:28 INFO - SUITE-START | Running 2 tests
14:25:28 INFO - TEST-START | dromaeo_css
14:25:28 INFO - operating with platform_type : w7_
14:25:28 INFO - Initialising browser for dromaeo_css test...
14:25:29 INFO - TEST-INFO | started process 3224 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld\appdata\local\temp\tmpmtasg0\profile http://localhost:49897/getInfo.html)
14:25:39 INFO - PROCESS | 3224 | __metrics Screen width/height:1600/1200
14:25:39 INFO - PROCESS | 3224 | colorDepth:24
14:25:39 INFO - PROCESS | 3224 | Browser inner width/height: 1010/674
14:25:39 INFO - PROCESS | 3224 | __metrics
14:25:39 ERROR - PROCESS | 3224 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3220: TypeError: this.tabs is undefined
14:25:39 INFO - PROCESS | 3224 | [Child 1328] WARNING: pipe error: 109: file c:/builds/moz2_slave/m-cen-w32-00000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
14:25:40 INFO - TEST-INFO | 3224: exit 0
14:25:40 INFO - Browser initialized.
14:25:40 INFO - Running cycle 1/1 for dromaeo_css test...
14:25:40 INFO - TEST-INFO | started process 1404 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld\appdata\local\temp\tmpmtasg0\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1)
14:25:41 INFO - PROCESS | 1404 | [GFX1-]: Invalid size in UpdateRenderTarget Size(116,0), 0
14:25:52 INFO - PROCESS | 1404 | RSS: Main: 145379328
14:25:52 INFO - PROCESS | 1404 |
14:26:42 INFO - PROCESS | 1404 | 1480717602041 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]
14:28:55 INFO - PROCESS | 1404 | Cycle 1(1): loaded http://localhost:49897/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49897/tests/dromaeo/cssquery-ext.html)
14:28:56 INFO - PROCESS | 1404 | RSS: Main: 123109376
14:28:56 INFO - PROCESS | 1404 |
14:31:58 INFO - PROCESS | 1404 | Cycle 1(1): loaded http://localhost:49897/tests/dromaeo/cssquery-ext.html (next: http://localhost:49897/tests/dromaeo/cssquery-jquery.html)
14:31:59 INFO - PROCESS | 1404 | RSS: Main: 91426816
14:31:59 INFO - PROCESS | 1404 |
14:35:01 INFO - PROCESS | 1404 | Cycle 1(1): loaded http://localhost:49897/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49897/tests/dromaeo/cssquery-mootools.html)
14:35:01 INFO - PROCESS | 1404 | RSS: Main: 85618688
14:35:01 INFO - PROCESS | 1404 |
14:38:03 INFO - PROCESS | 1404 | Cycle 1(1): loaded http://localhost:49897/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49897/tests/dromaeo/cssquery-prototype.html)
14:38:04 INFO - PROCESS | 1404 | RSS: Main: 82497536
14:38:04 INFO - PROCESS | 1404 |
14:41:06 INFO - PROCESS | 1404 | Cycle 1(1): loaded http://localhost:49897/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49897/tests/dromaeo/cssquery-yui.html)
14:41:07 INFO - PROCESS | 1404 | RSS: Main: 87220224
14:41:07 INFO - PROCESS | 1404 |
14:44:10 INFO - PROCESS | 1404 | Cycle 1(1): loaded http://localhost:49897/tests/dromaeo/cssquery-yui.html (next: http://localhost:49897/tests/dromaeo/cssquery-dojo.html)
14:44:10 INFO - PROCESS | 1404 | RSS: Main: 78827520
14:44:10 INFO - PROCESS | 1404 |
14:44:10 INFO - PROCESS | 1404 | __start_tp_report
14:44:10 INFO - PROCESS | 1404 | _x_x_mozilla_page_load
14:44:10 INFO - PROCESS | 1404 | _x_x_mozilla_page_load_details
14:44:10 INFO - PROCESS | 1404 | |i|pagename|runs|
14:44:10 INFO - PROCESS | 1404 | |0;dojo.html;2367.1951536477595;2404.134511575832;2417.867017314048;2423.7212720537145;2430.6961629796274;3944.447777311179;4022.0950286185594;4051.918961620773;4138.0896202835365;4139.441175441315;4021.1756589899073;4090.1001779608514;4116.670666346693;4129.814158362873;4145.709800313979;3614.548181477315;3646.6535679110443;3650.3976843820806;3659.2864391443677;3673.3571624965657;160.09973924876272;3553.3781588222087;3608.458731190316;3614.457831325296;3672.8530858765616;3535.8232088395475;3557.2351944332095;3578.2664553766417;3597.6582224688614;3630.981845090784;3586.6234045425376;3630.4009838376637;3648.489211510364;3652.0504668786043;3656.1590834108038;3503.632118627558;3546;3581.015220814271;3632.928286155564;3647.252313275772;3894.084890050836;4058.289799285113;4064.4106604542176;4096.5903409659095;4119.670426365884;4251.4685664291965;4259.8083086261195;4334.674899382559;4334.783260836977;4345.717528360647;4315.978420107879;4344.587264209895;4400.207962566737;4404.22925987954;4405;3891.6497515223764;3949.624785645359;4005.4792876926394;4024.5170579530645;4042.312806822847;4325.632321252666;4419.911601767946;4425.468943726773;4427.557244275611;4429.955700442954;4193.119444916601;4193.6645068394455;4255.5957184067465;4276.8289268429535;4287.785610719514;4179.414881916534;4247.299195632686;4256.127493863751;4288.399624052635;4346.456692913386;4212.53662097169;4218.725782824106;4221.915561688749;4228.957710422918;4232.746035237896;4166.687498437629;4171.416001759756;4199.202151591188;4206.348016057516;4208.347706105558;3053.8473076346095;3101.798383105091;3105.844707764603;3110.688931106871;3114.2214446388402;2830.4056148209106;2845.2886778305424;2852.5863749756586;2880.8991685290916;2881.6109825173753;4015.598440155961;4089.754614723126;4128.669706423479;4148.274052040942;4153.439285696392;4246.598622454582;4295.570442955679;4324.935125973113;4352.608265256142;4424.623906967944;3821.178446633987;4036.2129384770274;4101.384792281182;4151.356539736345;4154.875353739392;3510.8420121094614;3743.3074881147077;3743.7005039596766;3752.0432289765936;3753.3431649461236;4304.677149213884;4341.131773645347;4405.84579539721;4486.7083639563325;4495.865124046284;4326.415933849016;4329.307310830252;4351.8694439166875;4411.073674528385;4411.426514553087;4374.10330882162;4389.956100439083;4479.238529449936;4489.9775501122285;4498.595126438636;4131.338985762263;4177.227212965611;4214.1150358425075;4301.010767523425;4314.482262128565;4240;4244.384564238107;4248;4351.282038463744;4361.978190109029;4055.9797201013807;4126.958730412657;4203.642690371353;4208.38978348144;4215.494140703136;4104.445899803608;4129.504459464883;4195.014171669716;4204.705670603151;4210.389493523483;3937.684985201234;4025.496812898388;4026.7583944963394;4058.289799285172;4059;4034.8991275218355;4119.941613403017;4216.388623649493;4222.472190976128;4230.725002874803;4059.878203653895;4148.585141485827;4148.751074935513;4149.481314835645;4166.854160104503
14:44:10 INFO - PROCESS | 1404 | |1;ext.html;551.8179000929694;555.0896529691307;555.7693557173773;560.4759549820915;561.539537579185;34941.825290873545;35415.93752187435;37141.442878356844;37592.7370168176;37674.24651506975;32191.356172876585;33665.49501757476;33895.15262118442;33973.830130849376;34058.489122663115;7029.332213439715;7114.110736157981;7143.107111611049;8870.334724895627;9115.68095116671;9181.31140164487;9208.296465153935;9284.953575232114;9286.582103805345;9291.76770580734;9294.442333460014;9302.162805347518;9333.346665733401;9340.299477539213;9361.67234146805;9262.583183756748;9264.212541933945;9306.90594616206;9310.441373517611;9324.254059675277;9147.313951453667;9194.218491428237;9209.125133112344;9221.446713197229;9224;32251.83874080638;32511.748825117535;32513.51229731556;32515.18712032218;32575.83712081448;2547.1467058535413;2660.6541149650616;2688.368233465134;2721.3332733480224;2769.2938300733385;24745.25764227076;25005.749942500704;25164.24507264785;25769.61345579818;25886;2652.429727608554;2667.079857449177;2690.0450340129364;2691.300261931912;2767.7785777137983;205008;205286;207109;207194.9640251804;208342;45616.08767824625;45855.77072114618;45856.3121553177;45864.77067614641;45897.54102458999;47039;47087;47165.764171178926;47178.76410617925;47338.763306183246;10606.522706478227;11096.61161859331;11133.721656958478;11155.163362747826;11245.044171245536;6446.387593178641;6694.330566943267;7959.602019899097;8064.516129032159;8114.229148231027;14590.343434545472;15290.235488225544;15443.691126177413;15446.150461724488;15529;6147.569670123138;6287.339829317947;6320.905186422207;6321.96839015802;6338.30278669346;736.9594672293075;781.9609019549;800.6317094136763;818.2104269379957;853.159637756809;22753.772462275167;23129.653055204184;24116.51766964686;24157.758422415904;24280.757192428202;820.4134044158455;862.4954401674964;863.2834747159842;925.5141050948172;984.8571957066185;13550.051496395157;13813.861861381258;14063.507777227747;14233.359498822578;14377.712445751027;296033;322266;330387;331872;451352;41823.58176418258;41882.790586046875;42337.57662423398;42427.151456970685;42482.57517424848;1046.602291129366;1057.5293994172673;1065.8134826405349;1066.9733256668646;1067.108964015056;24077.157299494433;24327.905244263697;24949.251522454357;24967.375815604755;24999.50001000006;36038;36069.45895811512;36462.4530632046;36596.63403365932;36607.63392366149;259739;267733;270861;271089.644551776;271210;20247.4938126548;20643.58712825765;20720.58558828845;20776.48058798542;21670.783292166878;35443.645563544036;35655.82172089123;35779.10552236215;35965;36058.63941360658;29822.25444363908;30778.692213077582;30808.07575772641;30957.226069348446;31299.84350078235;30322.393552129273;30467.542986854773;30549.23626909345;30952.84523577368;31914.20214494656;29572.964946226777;29892.252693682833;30051;30174.54738178973;30528.389432211676;27396.17811465659;28090.57864131999;28108.437831242853;28253.858730706215;28305.009324673538;21491.032903519692;22242.332730018126;22377.66433503531;22377.77622223822;22388.77611223867
14:44:10 INFO - PROCESS | 1404 | |2;jquery.html;293.19517923300543;300.7518796992481;306.1794391032035;310.12235373891883;315.1255266635089;11261.831072533898;11432;14833.332500037497;15969.201539922986;15991.280392382341;11768.999635031032;14803;15209;15223.010504317212;15295.770563441529;4011.418344340076;4250.447441832557;4254.383114448403;4284.97857510712;4309.870703878889;4194.937075943863;4232.217039847623;4262.9147417051645;4265.381519679645;4266.082792199676;4066.329055705805;4250.192463431954;4261.978690106545;4266.914661706764;4273.850415235467;4227.936580951288;4280.1653677532895;4323.913521729579;4334.111507141029;4338.2191205582985;4142;4231.682623803196;4233.1322078973735;4234.13200293939;4235.449391579105;10035.698929032067;10114;10343.948280258626;10349.172066234683;10368.170546356274;1523.3525751555544;1797.4787311679597;2065.607534568427;2127.851050426471;2139.497218153733;7735.845283094307;7800.843983120306;7871.976643036426;7889.211078892123;7957.562334071624;1499.2503748125937;1545.7140429020667;1574.3781206423514;1601.303433006646;1611.9516414507584;58049.41950580524;64319.3568064318;65777.67111164413;65843.67078164626;66271.337286627;8526.10475900034;8548.187922147386;8666.263367613697;8803.163699448542;8987.19115279628;11615.76768464626;11626.244294120856;11640;11669.241499302518;11682.357470339213;5832.125181222766;5865.736041878125;5962.731677074542;6020.668863212565;6038.698065096728;5637.830865074055;5669.6314739541795;5745.1669507921115;5747.1379293106365;5748.02283611787;3670.889873303805;3675.5956844747056;3687;3809.5999920008553;3813.5995720448955;1524.809398825147;1532.341093329879;1535.9001664891969;1560.141921942927;1579.518246934696;300.7849387687814;301.1417460238303;725.6190499987443;749.2544917806817;782.8434313137395;8670.696525621574;8672.436291641023;9133.40632858862;15475.458358957383;15989.28048237832;739.1167554771996;756.255088737593;760.8212070163507;764.694122351064;771.4831063187565;8404.411691181558;8613.138686131337;8671;8805.16350946659;8937.508437035895;224093;270685;273695;273711;274323;72429.63785181145;72576;74641;74680.25319746841;76765;806.3428305930647;841.1840514700731;843.4475418600827;844.4004756622867;845.3659755183612;13993;14268.643283917985;14300.427982880568;14508.637284067561;14510;36758.08104797295;37893.62106378901;38576.80711596424;39735.20529589334;41188.58811411847;46686;47041.52958470371;50837.49162508475;50937.74531127469;53128.203076953105;10101.545430455793;10292.897071029493;10337.586496540054;10386.688399348031;10414.323069000491;10976.12191024732;10993.065589424989;11168.1065514757;11170.162237832357;11980.341081240267;6226.221722284715;6249.25008998923;6311.147995020797;6362.840928976812;6394.296627371078;6623.735050597922;6709.228438729609;6709.597424154566;6734.259231484435;6734.989751537309;6114.205153330038;6352.841178970562;6370.140031095928;6469.223693156851;6486.902696459462;10136.391816491034;10197.54111064989;10474.68575942723;10707;10815.945920270664;8597.054324024477;8648.870266946127;8848.646054157762;9008;9122.771930701785
14:44:10 INFO - PROCESS | 1404 | |3;mootools.html;1121.1815374776413;1141.2239677019627;1171.9003884669803;1357.5248662967956;1425.0167384504698;4866.635002374818;5012.649114561982;5318.521333080022;5461.945380546188;5541.889162216758;5277.287566178565;5445.891082178354;5504.311961004874;5511.559075273978;5512.80705175319;1625.5529729324442;1667.758175064621;1670.964002318564;1671.6656668666255;1674.4223242981152;1596.9680606387865;1663.07699226929;1672.6069373697171;1682.2261759590542;1682.8233035531277;1640.1635166065332;1657.5856035991003;1662.8669706423518;1665.1258089502987;1667.758175064615;1526.6030831983765;1554.129687375068;1555.9455419060391;1558.0262336039975;1558.883083768722;1569.5212960047181;1575.2675006122208;1594.378192504924;1594.689035638051;1595.0748565831789;5350.170723537858;5424.294841670597;5449.591280653927;5451.209574611659;5464.316960379952;3189.1867573768773;3268.836558172082;3272.6236482804543;3274.7707660463775;3284;2102.0645812613393;2151.9354419367446;2167.7615462299136;2200.4168895242774;2211.966820497678;681.2336121862904;703.9648017599151;711.6299524247362;738.9261073892621;744.1219361153836;6638.336166383371;6770.32296770324;6772.76295329666;6774.187097548326;6780.864382712368;2815.4509870575453;2879.3521457672277;2905.564165375168;2937.647482302095;2951;6102.603330783485;6103.3591472894705;6105.236845394325;6116.113163591343;6121.540884433596;3307.851146698404;3320.9501857472155;3329.067860998924;3329.500574913734;3331.267121233325;2986.163874115251;3027.5307327364294;3028.560858675524;3035.2563621912773;3042.8478576071107;2374.7387787343378;2453.325335532707;2516.157087375713;2528.418463753347;2636.5122452346377;876.2201640539924;879.564615515324;884;884.5533005832013;887.5695287785419;725.122601652007;735.9116905971317;738.8522295540913;750.6359415683389;752.8042708895617;3791.7345785795283;3797.6202379762353;3874.41883717439;3891.8832435026993;3947.5262968443394;694.7360003198752;709.5990765217635;747.2378174262223;747.8392145688703;762.8970089037908;2645.8809353579136;2792;2803.621511095976;2808.66296044476;2920.196945839911;6174.9073763893575;6260.686965651699;6303.968480157661;6305.527085468608;6316.052592111128;6057.485113765291;6131.724072416752;6147.170132032118;6223.626582405071;6246.500279977591;5063.367079115111;5206.3752349717515;5211.921821172686;5220.425753167148;5223.5559977402345;3885.6502914737807;3971.424143499234;3979.3235150025143;4023.416604592376;4073.5519092899162;5654.3497497788285;5793.275840519935;5838.241028666246;5922.200502932222;5962.642241465526;5849.883002339844;5897.498712609305;5997.670128142994;6000.459958603747;6001.969990150022;4842.564169224786;4957.578605818546;4965.30485732005;4972.801087956586;4975.452700202903;4647.465541462775;4776.95223047779;5260.605454590845;5296.179092240709;5296.655717378358;4655.138799322136;4655.162070827148;4758.04839032188;4796.208625576741;4820.469748327751;4760.238361862085;4785.976070119627;4855.514448555116;4861.416630004422;4882.536159064884;4441.600255976978;4476.776161191862;4480.887977800581;4483.910321793611;4501.2122878495475;3321.1365045088933;3339.382214290364;3343.3814744272386;3362.0586235854;3362.865485380655;3345.882894098695;3368.360011597789;3382.8139452330356;3384.340053689507;3465.9826700866333
14:44:10 INFO - PROCESS | 1404 | |4;prototype.html;216.36712615599367;222.52268883245438;225.8238573912349;229.3280687585375;232.2382585120804;4462.174497717916;4504.549545045494;4628;4630.7221566705975;4646.55857693519;4434.512203657595;4514.322851572266;4523.5750738517345;4556.772161391926;4557.954420455802;3340.8663653453955;3360.865565377394;3363.6636336366414;3372.392969265531;3375.611804642461;3332.833358332086;3370.359631669975;3370.5281260623533;3380.323935212955;3381.408253555618;3278.1476816027885;3303.355845610107;3307.4873394623874;3314.453115235995;3318.0543545089654;3234.1752853022563;3300.488424294238;3324.1523411529906;3344.682255185766;3352.7988320700715;2899.652041754982;2902.434025365055;2902.724241197083;2908.650961884566;2908.6945870683485;4437.9112417751785;4443.178012067778;4448.221561226773;4465.829261224502;4467.530909254514;3911.941320880189;3920.5687374388795;3921.392184211452;3921.4117882317883;3922.3920292354733;4706.588023592908;4713.293006049086;4717.075413243777;4720.834770783041;4727.338172655831;3139.728409993956;3228.322052369005;3231.547583338311;3236.7410607151373;3248.626407963091;4916.852494425173;4921.704697718148;4932.309476673268;4936.234883593049;4939.6789208701675;3312.0063980806144;3312.966870331266;3320.7841490303053;3327.6672332767016;3329.20099176196;3358.983205083959;3369.4608862581867;3371.325734853039;3378.682313897582;3379.543761592203;3893.902652433655;3909.9609003909595;3910.648041676263;3911.6675082618294;3914.941275880864;4546.909061818811;4765.594924431392;4769.114685615222;4800.783964721596;4801.663883528119;1096.6929259807266;1102.4818335382358;1106.6071544601712;1106.6845948904524;1106.7288514314046;705.5907573607398;725.9092613423322;728.3190217146985;731.3016069653468;732.7911545209589;4538;4636.4899861015265;4644.837430689977;4646.83736069236;4649.767511624405;4973.701577905337;4995.476379704225;5001.724215481947;5001.8499445016705;5010.073136469765;4614.861554153381;4618.03021365517;4629.930551041737;4631.884202894955;4656.348111264358;2464.2114523352357;2557.948841023206;2576.587745960637;2576.9742302576733;2585.8319209251713;4949.331840201598;4986.526280003394;4993.325901003391;4994.775235114428;5001.799928002839;4933.407991041026;4966.776495057731;4972.900541989212;4973.875653108629;4993.00139972007;4966.553010229097;4971.067070428465;4998.525140111684;5000.024995125988;5009.799608015638;4696.506866779076;4854.490278520704;4859.173940430064;4881.047580967642;4926.310316555757;4738.289256611536;4760.547747963938;4764.2615394613895;4764.33299338086;4771.212749896228;4952.4057113146655;4982.252662100569;4991.6006719463085;4991.700497970133;5003.249512572997;3138.356636889478;3139.607549056368;3155.8422078896424;3158.131513833714;3180.346219965651;4579.450465944108;4776.8566942991765;4797.033216381267;4812.951870481251;4821.325014497903;4541.704789188692;4581.839635612738;4617.676762626718;4627.1439783640135;4638.83764068256;4605.585497305258;4625.606823420047;4639.002614437912;4642.30746167229;4643.953560464487;4527.185106680829;4529.84145554904;4535.160995215896;4541.591256786905;4556.794944227584;4420.938974646127;4608.262677971508;4673.696209746356;4687.67186296956;4713.835015774432;4549.590536851567;4607.940173759987;4665.976670116627;4728.092223282725;4746.359241502353
14:44:10 INFO - PROCESS | 1404 | |5;yui.html;595.062776127599;606.8877257707325;612.5834432585841;629.1035274733509;639.8720255948812;11696.356700381475;12401;12408.813867791967;12415.751684966295;12460.376981150941;11588.53645854167;11764.941175294132;12162.635120946363;12173.208741431823;12334.753304933896;606.6299557270062;615.9969200154004;621.2669050520384;623.227198274139;626.0327793558939;596.9283685957691;627.2598333965941;630.7256343490574;633.8003528888386;635.7806556737918;653.6306986552606;655.9114519539872;655.934406559345;655.9442447391978;656.0880376276979;648.9091527186198;650.1028580558822;650.5056157320471;650.6876699184371;650.6909218121355;460.903210325832;473.7465455981068;476.9236922092483;477.42470323260386;478.7079881272421;12676.176048556814;12906.419211135428;13016.15394999322;13033.54382596614;13044.347782610927;10839.512221949952;11728.120390970711;11743.94128029363;11769.176157668966;12111.091668124925;11151.330920144817;11314.830277545843;11368.658940231806;11404.942975285154;11497.885021149765;3756.4740936268945;3786.110264087937;3787.772733635991;3827.7129215308964;3837.0982819037504;62369.68815155941;62391;62474;62688;63471.68264158696;8934.642614295355;8961.775955601162;9113.544322783968;9136.817263654822;9355.06449355059;15459.613509662124;15735.842641573667;16022;16771.99368037897;16826.411075612294;6239.220097487814;6265.62406255617;6266.467350275278;6365.968170159213;6481.254655714559;3285.342931413727;3347.6819702128746;3363.730901527872;3375.3924293627383;3508.298340331944;2275.9544809103727;2280.156342153414;2361.7638236176244;2363.066588697455;2363.7399886012527;384.3178358413838;386.78726700315275;387.52528153012895;388.83668859079256;389.4508742672818;510.54306395775575;521.7808520421432;542.3248056170015;563.312758434709;585.4643001653525;6136.93382745359;6145.8156255312415;6679.265280819106;6722.697478613474;6785.9660701696175;405.94519739834743;440.7707991844223;499.0991260774265;529.1375058654369;553.4769642687702;3236.3527294541186;3376.2909788944107;3403.268297316089;3413.2149605590853;3429.4855771634457;64148;66433.66783166054;67342.66328668325;68035.65982170157;68049.65975170092;58427;59464;60192;60334.39665603376;60809;55123.44876551183;55174.17238741422;55782.72108639512;56832.43167568354;57513;6607.768728094494;7073.752418665322;7110.146782386147;7593.506422082547;7891.171427000312;37364.252714946095;39088.804555978175;39580.208395831345;39675.60324396719;39820.60179398169;50767;52140.914363425036;52351.73824130855;52800.735996319774;53237.7338113307;9669.516524173903;10037.849432258668;10761.515731791931;11562.537498500302;11706.473208705798;12688.74622507563;12948;13016.219026858418;13045.608631741063;13068.281244531641;10095.268276258206;10205.38767673942;10285.125764310118;10373.636922707668;10541.20940929418;10736.624218152327;10739.140868730326;10846.783064338511;11584.362860042442;11801.114916381133;9542;9964.701058968243;10355.223358248011;10530.201375759974;10603.628872989717;9361.906380936103;9541.475218862752;9667.661631842851;10233;10272.024157705006;8834.381593288408;9024.36829421934;9146.222571081533;9260.95369523175;9684.176844968257
14:44:10 INFO - PROCESS | 1404 | __end_tp_report
14:44:10 INFO - PROCESS | 1404 | __start_cc_report
14:44:10 INFO - PROCESS | 1404 | _x_x_mozilla_cycle_collect,299
14:44:10 INFO - PROCESS | 1404 | __end_cc_report
14:44:10 INFO - PROCESS | 1404 | __startTimestamp1480718650340__endTimestamp
14:44:10 INFO - PROCESS | 1404 |
14:44:10 INFO - PROCESS | 1404 | ------- Summary: start -------
14:44:10 INFO - PROCESS | 1404 | Number of tests: 6
14:44:10 INFO - PROCESS | 1404 |
14:44:10 INFO - PROCESS | 1404 | [#0] dojo.html Cycles:165 Average:3954.60 Median:4139.44 stddev:550.27 (13.3%) stddev-sans-first:537.68
14:44:10 INFO - PROCESS | 1404 | Values: 2367.2 2404.1 2417.9 2423.7 2430.7 3944.4 4022.1 4051.9 4138.1 4139.4 4021.2 4090.1 4116.7 4129.8 4145.7 3614.5 3646.7 3650.4 3659.3 3673.4 160.1 3553.4 3608.5 3614.5 3672.9 3535.8 3557.2 3578.3 3597.7 3631.0 3586.6 3630.4 3648.5 3652.1 3656.2 3503.6 3546.0 3581.0 3632.9 3647.3 3894.1 4058.3 4064.4 4096.6 4119.7 4251.5 4259.8 4334.7 4334.8 4345.7 4316.0 4344.6 4400.2 4404.2 4405.0 3891.6 3949.6 4005.5 4024.5 4042.3 4325.6 4419.9 4425.5 4427.6 4430.0 4193.1 4193.7 4255.6 4276.8 4287.8 4179.4 4247.3 4256.1 4288.4 4346.5 4212.5 4218.7 4221.9 4229.0 4232.7 4166.7 4171.4 4199.2 4206.3 4208.3 3053.8 3101.8 3105.8 3110.7 3114.2 2830.4 2845.3 2852.6 2880.9 2881.6 4015.6 4089.8 4128.7 4148.3 4153.4 4246.6 4295.6 4324.9 4352.6 4424.6 3821.2 4036.2 4101.4 4151.4 4154.9 3510.8 3743.3 3743.7 3752.0 3753.3 4304.7 4341.1 4405.8 4486.7 4495.9 4326.4 4329.3 4351.9 4411.1 4411.4 4374.1 4390.0 4479.2 4490.0 4498.6 4131.3 4177.2 4214.1 4301.0 4314.5 4240.0 4244.4 4248.0 4351.3 4362.0 4056.0 4127.0 4203.6 4208.4 4215.5 4104.4 4129.5 4195.0 4204.7 4210.4 3937.7 4025.5 4026.8 4058.3 4059.0 4034.9 4119.9 4216.4 4222.5 4230.7 4059.9 4148.6 4148.8 4149.5 4166.9
14:44:10 INFO - PROCESS | 1404 |
14:44:10 INFO - PROCESS | 1404 | [#1] ext.html Cycles:180 Average:40970.71 Median:32514.35 stddev:74120.22 (228.0%) stddev-sans-first:74266.02
14:44:10 INFO - PROCESS | 1404 | Values: 551.8 555.1 555.8 560.5 561.5 34941.8 35415.9 37141.4 37592.7 37674.2 32191.4 33665.5 33895.2 33973.8 34058.5 7029.3 7114.1 7143.1 8870.3 9115.7 9181.3 9208.3 9285.0 9286.6 9291.8 9294.4 9302.2 9333.3 9340.3 9361.7 9262.6 9264.2 9306.9 9310.4 9324.3 9147.3 9194.2 9209.1 9221.4 9224.0 32251.8 32511.7 32513.5 32515.2 32575.8 2547.1 2660.7 2688.4 2721.3 2769.3 24745.3 25005.7 25164.2 25769.6 25886.0 2652.4 2667.1 2690.0 2691.3 2767.8 205008.0 205286.0 207109.0 207195.0 208342.0 45616.1 45855.8 45856.3 45864.8 45897.5 47039.0 47087.0 47165.8 47178.8 47338.8 10606.5 11096.6 11133.7 11155.2 11245.0 6446.4 6694.3 7959.6 8064.5 8114.2 14590.3 15290.2 15443.7 15446.2 15529.0 6147.6 6287.3 6320.9 6322.0 6338.3 737.0 782.0 800.6 818.2 853.2 22753.8 23129.7 24116.5 24157.8 24280.8 820.4 862.5 863.3 925.5 984.9 13550.1 13813.9 14063.5 14233.4 14377.7 296033.0 322266.0 330387.0 331872.0 451352.0 41823.6 41882.8 42337.6 42427.2 42482.6 1046.6 1057.5 1065.8 1067.0 1067.1 24077.2 24327.9 24949.3 24967.4 24999.5 36038.0 36069.5 36462.5 36596.6 36607.6 259739.0 267733.0 270861.0 271089.6 271210.0 20247.5 20643.6 20720.6 20776.5 21670.8 35443.6 35655.8 35779.1 35965.0 36058.6 29822.3 30778.7 30808.1 30957.2 31299.8 30322.4 30467.5 30549.2 30952.8 31914.2 29573.0 29892.3 30051.0 30174.5 30528.4 27396.2 28090.6 28108.4 28253.9 28305.0 21491.0 22242.3 22377.7 22377.8 22388.8
14:44:10 INFO - PROCESS | 1404 |
14:44:10 INFO - PROCESS | 1404 | [#2] jquery.html Cycles:180 Average:19329.87 Median:4252.42 stddev:44788.67 (1053.3%) stddev-sans-first:44891.51
14:44:10 INFO - PROCESS | 1404 | Values: 293.2 300.8 306.2 310.1 315.1 11261.8 11432.0 14833.3 15969.2 15991.3 11769.0 14803.0 15209.0 15223.0 15295.8 4011.4 4250.4 4254.4 4285.0 4309.9 4194.9 4232.2 4262.9 4265.4 4266.1 4066.3 4250.2 4262.0 4266.9 4273.9 4227.9 4280.2 4323.9 4334.1 4338.2 4142.0 4231.7 4233.1 4234.1 4235.4 10035.7 10114.0 10343.9 10349.2 10368.2 1523.4 1797.5 2065.6 2127.9 2139.5 7735.8 7800.8 7872.0 7889.2 7957.6 1499.3 1545.7 1574.4 1601.3 1612.0 58049.4 64319.4 65777.7 65843.7 66271.3 8526.1 8548.2 8666.3 8803.2 8987.2 11615.8 11626.2 11640.0 11669.2 11682.4 5832.1 5865.7 5962.7 6020.7 6038.7 5637.8 5669.6 5745.2 5747.1 5748.0 3670.9 3675.6 3687.0 3809.6 3813.6 1524.8 1532.3 1535.9 1560.1 1579.5 300.8 301.1 725.6 749.3 782.8 8670.7 8672.4 9133.4 15475.5 15989.3 739.1 756.3 760.8 764.7 771.5 8404.4 8613.1 8671.0 8805.2 8937.5 224093.0 270685.0 273695.0 273711.0 274323.0 72429.6 72576.0 74641.0 74680.3 76765.0 806.3 841.2 843.4 844.4 845.4 13993.0 14268.6 14300.4 14508.6 14510.0 36758.1 37893.6 38576.8 39735.2 41188.6 46686.0 47041.5 50837.5 50937.7 53128.2 10101.5 10292.9 10337.6 10386.7 10414.3 10976.1 10993.1 11168.1 11170.2 11980.3 6226.2 6249.3 6311.1 6362.8 6394.3 6623.7 6709.2 6709.6 6734.3 6735.0 6114.2 6352.8 6370.1 6469.2 6486.9 10136.4 10197.5 10474.7 10707.0 10815.9 8597.1 8648.9 8848.6 9008.0 9122.8
14:44:10 INFO - PROCESS | 1404 |
14:44:10 INFO - PROCESS | 1404 | [#3] mootools.html Cycles:180 Average:3594.44 Median:4651.30 stddev:1850.41 (39.8%) stddev-sans-first:1846.27
14:44:10 INFO - PROCESS | 1404 | Values: 1121.2 1141.2 1171.9 1357.5 1425.0 4866.6 5012.6 5318.5 5461.9 5541.9 5277.3 5445.9 5504.3 5511.6 5512.8 1625.6 1667.8 1671.0 1671.7 1674.4 1597.0 1663.1 1672.6 1682.2 1682.8 1640.2 1657.6 1662.9 1665.1 1667.8 1526.6 1554.1 1555.9 1558.0 1558.9 1569.5 1575.3 1594.4 1594.7 1595.1 5350.2 5424.3 5449.6 5451.2 5464.3 3189.2 3268.8 3272.6 3274.8 3284.0 2102.1 2151.9 2167.8 2200.4 2212.0 681.2 704.0 711.6 738.9 744.1 6638.3 6770.3 6772.8 6774.2 6780.9 2815.5 2879.4 2905.6 2937.6 2951.0 6102.6 6103.4 6105.2 6116.1 6121.5 3307.9 3321.0 3329.1 3329.5 3331.3 2986.2 3027.5 3028.6 3035.3 3042.8 2374.7 2453.3 2516.2 2528.4 2636.5 876.2 879.6 884.0 884.6 887.6 725.1 735.9 738.9 750.6 752.8 3791.7 3797.6 3874.4 3891.9 3947.5 694.7 709.6 747.2 747.8 762.9 2645.9 2792.0 2803.6 2808.7 2920.2 6174.9 6260.7 6304.0 6305.5 6316.1 6057.5 6131.7 6147.2 6223.6 6246.5 5063.4 5206.4 5211.9 5220.4 5223.6 3885.7 3971.4 3979.3 4023.4 4073.6 5654.3 5793.3 5838.2 5922.2 5962.6 5849.9 5897.5 5997.7 6000.5 6002.0 4842.6 4957.6 4965.3 4972.8 4975.5 4647.5 4777.0 5260.6 5296.2 5296.7 4655.1 4655.2 4758.0 4796.2 4820.5 4760.2 4786.0 4855.5 4861.4 4882.5 4441.6 4476.8 4480.9 4483.9 4501.2 3321.1 3339.4 3343.4 3362.1 3362.9 3345.9 3368.4 3382.8 3384.3 3466.0
14:44:10 INFO - PROCESS | 1404 |
14:44:10 INFO - PROCESS | 1404 | [#4] prototype.html Cycles:180 Average:3923.99 Median:4557.37 stddev:1211.74 (26.6%) stddev-sans-first:1182.75
14:44:10 INFO - PROCESS | 1404 | Values: 216.4 222.5 225.8 229.3 232.2 4462.2 4504.5 4628.0 4630.7 4646.6 4434.5 4514.3 4523.6 4556.8 4558.0 3340.9 3360.9 3363.7 3372.4 3375.6 3332.8 3370.4 3370.5 3380.3 3381.4 3278.1 3303.4 3307.5 3314.5 3318.1 3234.2 3300.5 3324.2 3344.7 3352.8 2899.7 2902.4 2902.7 2908.7 2908.7 4437.9 4443.2 4448.2 4465.8 4467.5 3911.9 3920.6 3921.4 3921.4 3922.4 4706.6 4713.3 4717.1 4720.8 4727.3 3139.7 3228.3 3231.5 3236.7 3248.6 4916.9 4921.7 4932.3 4936.2 4939.7 3312.0 3313.0 3320.8 3327.7 3329.2 3359.0 3369.5 3371.3 3378.7 3379.5 3893.9 3910.0 3910.6 3911.7 3914.9 4546.9 4765.6 4769.1 4800.8 4801.7 1096.7 1102.5 1106.6 1106.7 1106.7 705.6 725.9 728.3 731.3 732.8 4538.0 4636.5 4644.8 4646.8 4649.8 4973.7 4995.5 5001.7 5001.8 5010.1 4614.9 4618.0 4629.9 4631.9 4656.3 2464.2 2557.9 2576.6 2577.0 2585.8 4949.3 4986.5 4993.3 4994.8 5001.8 4933.4 4966.8 4972.9 4973.9 4993.0 4966.6 4971.1 4998.5 5000.0 5009.8 4696.5 4854.5 4859.2 4881.0 4926.3 4738.3 4760.5 4764.3 4764.3 4771.2 4952.4 4982.3 4991.6 4991.7 5003.2 3138.4 3139.6 3155.8 3158.1 3180.3 4579.5 4776.9 4797.0 4813.0 4821.3 4541.7 4581.8 4617.7 4627.1 4638.8 4605.6 4625.6 4639.0 4642.3 4644.0 4527.2 4529.8 4535.2 4541.6 4556.8 4420.9 4608.3 4673.7 4687.7 4713.8 4549.6 4607.9 4666.0 4728.1 4746.4
14:44:10 INFO - PROCESS | 1404 |
14:44:10 INFO - PROCESS | 1404 | [#5] yui.html Cycles:180 Average:14849.89 Median:488.90 stddev:19416.46 (3971.4%) stddev-sans-first:19441.43
14:44:10 INFO - PROCESS | 1404 | Values: 595.1 606.9 612.6 629.1 639.9 11696.4 12401.0 12408.8 12415.8 12460.4 11588.5 11764.9 12162.6 12173.2 12334.8 606.6 616.0 621.3 623.2 626.0 596.9 627.3 630.7 633.8 635.8 653.6 655.9 655.9 655.9 656.1 648.9 650.1 650.5 650.7 650.7 460.9 473.7 476.9 477.4 478.7 12676.2 12906.4 13016.2 13033.5 13044.3 10839.5 11728.1 11743.9 11769.2 12111.1 11151.3 11314.8 11368.7 11404.9 11497.9 3756.5 3786.1 3787.8 3827.7 3837.1 62369.7 62391.0 62474.0 62688.0 63471.7 8934.6 8961.8 9113.5 9136.8 9355.1 15459.6 15735.8 16022.0 16772.0 16826.4 6239.2 6265.6 6266.5 6366.0 6481.3 3285.3 3347.7 3363.7 3375.4 3508.3 2276.0 2280.2 2361.8 2363.1 2363.7 384.3 386.8 387.5 388.8 389.5 510.5 521.8 542.3 563.3 585.5 6136.9 6145.8 6679.3 6722.7 6786.0 405.9 440.8 499.1 529.1 553.5 3236.4 3376.3 3403.3 3413.2 3429.5 64148.0 66433.7 67342.7 68035.7 68049.7 58427.0 59464.0 60192.0 60334.4 60809.0 55123.4 55174.2 55782.7 56832.4 57513.0 6607.8 7073.8 7110.1 7593.5 7891.2 37364.3 39088.8 39580.2 39675.6 39820.6 50767.0 52140.9 52351.7 52800.7 53237.7 9669.5 10037.8 10761.5 11562.5 11706.5 12688.7 12948.0 13016.2 13045.6 13068.3 10095.3 10205.4 10285.1 10373.6 10541.2 10736.6 10739.1 10846.8 11584.4 11801.1 9542.0 9964.7 10355.2 10530.2 10603.6 9361.9 9541.5 9667.7 10233.0 10272.0 8834.4 9024.4 9146.2 9261.0 9684.2
14:44:10 INFO - PROCESS | 1404 | -------- Summary: end --------
14:44:10 INFO - PROCESS | 1404 |
14:44:11 INFO - TEST-INFO | 1404: exit 0
14:44:11 INFO - TEST-OK | dromaeo_css | took 1122913ms
14:44:11 INFO - TEST-START | kraken
14:44:11 INFO - operating with platform_type : w7_
14:44:11 INFO - Initialising browser for kraken test...
14:44:11 INFO - TEST-INFO | started process 2800 (C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld\appdata\local\temp\tmppqajeg\profile http://localhost:49897/getInfo.html)
14:44:18 INFO - PROCESS | 2800 | __metrics Screen width/height:1600/1200
14:44:18 INFO - PROCESS | 2800 | colorDepth:24
14:44:18 INFO - PROCESS | 2800 | Browser inner width/height: 1010/674
14:44:18 INFO - PROCESS | 2800 | __metrics
14:44:19 ERROR - PROCESS | 2800 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3220: TypeError: this.tabs is undefined
14:44:19 INFO - PROCESS | 2800 | [Child 2144] WARNING: pipe error: 109: file c:/builds/moz2_slave/m-cen-w32-00000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
14:44:19 INFO - PROCESS | 2800 | [Child 2144] WARNING: pipe error: 109: file c:/builds/moz2_slave/m-cen-w32-00000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
14:44:19 INFO - PROCESS | 2800 | console.error:
14:44:19 INFO - PROCESS | 2800 | Message: Error: Connection closed before committing the transaction.
14:44:19 INFO - PROCESS | 2800 | Stack:
14:44:19 INFO - PROCESS | 2800 | ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:932:23
14:44:19 INFO - PROCESS | 2800 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7
14:44:19 INFO - PROCESS | 2800 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11
14:44:19 INFO - PROCESS | 2800 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7
14:44:19 INFO - PROCESS | 2800 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7
14:44:19 INFO - PROCESS | 2800 | TaskImpl_run@resource://gre/modules/Task.jsm:324:15
14:44:19 INFO - PROCESS | 2800 | Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:550:9
14:44:19 INFO - PROCESS | 2800 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15
14:44:19 INFO - PROCESS | 2800 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:386:5
14:44:19 INFO - PROCESS | 2800 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29
14:44:19 INFO - PROCESS | 2800 | Barrier/this.client.addBlocker/promise13.5%
14:45:21 INFO - TinderboxPrint: I/O read bytes / time
74,490,368 / 1,177,870
14:45:21 INFO - TinderboxPrint: I/O write bytes / time
544,771,584 / 3,633,380
14:45:21 INFO - TinderboxPrint: CPU idle
8,295.0 (86.5%)
14:45:21 INFO - TinderboxPrint: CPU user
1,247.9 (13.0%)
14:45:21 INFO - install - Wall time: 3s; CPU: 11.0%; Read bytes: 0; Write bytes: 42217472; Read time: 0; Write time: 65200
14:45:21 INFO - run-tests - Wall time: 1197s; CPU: 14.0%; Read bytes: 74490368; Write bytes: 471652864; Read time: 1177870; Write time: 3530470
14:45:21 INFO - Running post-run listener: _upload_blobber_files
14:45:21 INFO - Blob upload gear active.
14:45:21 INFO - Preparing to upload files from C:\slave\test\build\blobber_upload_dir.
14:45:21 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
14:45:21 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', 'Firefox-Non-PGO', '-d', 'C:\\slave\\test\\build\\blobber_upload_dir', '--output-manifest', 'C:\\slave\\test\\build\\uploaded_files.json']
14:45:21 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 Firefox-Non-PGO -d C:\slave\test\build\blobber_upload_dir --output-manifest C:\slave\test\build\uploaded_files.json
14:45:22 INFO - (blobuploader) - INFO - Open directory for files ...
14:45:22 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs-e10s_errorsummary.log ...
14:45:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
14:45:22 INFO - (blobuploader) - INFO - Uploading, attempt #1.
14:45:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded
14:45:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
14:45:23 INFO - (blobuploader) - INFO - Done attempting.
14:45:23 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\dromaeojs-e10s_raw.log ...
14:45:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
14:45:23 INFO - (blobuploader) - INFO - Uploading, attempt #1.
14:45:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded
14:45:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
14:45:24 INFO - (blobuploader) - INFO - Done attempting.
14:45:24 INFO - (blobuploader) - INFO - Uploading C:\slave\test\build\blobber_upload_dir\resource-usage.json ...
14:45:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
14:45:24 INFO - (blobuploader) - INFO - Uploading, attempt #1.
14:45:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded
14:45:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
14:45:31 INFO - (blobuploader) - INFO - Done attempting.
14:45:31 INFO - (blobuploader) - INFO - Iteration through files over.
14:45:31 INFO - Return code: 0
14:45:31 INFO - rmtree: C:\slave\test\build\uploaded_files.json
14:45:31 INFO - Using _rmtree_windows ...
14:45:31 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build\\uploaded_files.json',), kwargs: {}, attempt #1
14:45:31 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1b3777a6105261071d90ad1705e079ffdbbbe28fad7624a211ec083faa73fbb969bd68a32a5e138550b732bd8827da8854dd279a5e14fefaeb6ccf343da595c7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/83aa7f58e7a4d495834bd3b61e8a5f269979b238d17278720adb02cf849b0a666335e179e66b069387878d39117026788cbf5e55a6cdfcd696a4d763a7b3a435", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7387058fcc60cfe2ed802f584f814bf81a41902df588dc1d123b838caa08aa410c66200a6971b4376e2a815545d591283b8bd6d4cfcb83627f1b7b09ed389259"}
14:45:31 INFO - Writing buildbot properties ['blobber_files'] to C:\slave\test\properties\blobber_files
14:45:31 INFO - Writing to file C:\slave\test\properties\blobber_files
14:45:31 INFO - Contents:
14:45:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1b3777a6105261071d90ad1705e079ffdbbbe28fad7624a211ec083faa73fbb969bd68a32a5e138550b732bd8827da8854dd279a5e14fefaeb6ccf343da595c7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/83aa7f58e7a4d495834bd3b61e8a5f269979b238d17278720adb02cf849b0a666335e179e66b069387878d39117026788cbf5e55a6cdfcd696a4d763a7b3a435", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7387058fcc60cfe2ed802f584f814bf81a41902df588dc1d123b838caa08aa410c66200a6971b4376e2a815545d591283b8bd6d4cfcb83627f1b7b09ed389259"}
14:45:31 INFO - Running post-run listener: copy_logs_to_upload_dir
14:45:31 INFO - Copying logs to upload dir...
14:45:31 INFO - mkdir: C:\slave\test\build\upload\logs
14:45:31 INFO - Copying logs to upload dir...
14:45:31 INFO - Using _rmtree_windows ...
14:45:31 INFO - Using _rmtree_windows ...
14:45:31 INFO - Using _rmtree_windows ...
14:45:31 INFO - Using _rmtree_windows ...
14:45:31 INFO - Using _rmtree_windows ...
14:45:31 INFO - Using _rmtree_windows ...
14:45:31 INFO - Using _rmtree_windows ...
program finished with exit code 0
elapsedTime=1471.203000
========= master_lag: 0.02 =========
========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 24 mins, 31 secs) (at 2016-12-02 14:45:31.900764) =========
========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-02 14:45:31.901612) =========
'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-010
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-010
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-010
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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1b3777a6105261071d90ad1705e079ffdbbbe28fad7624a211ec083faa73fbb969bd68a32a5e138550b732bd8827da8854dd279a5e14fefaeb6ccf343da595c7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/83aa7f58e7a4d495834bd3b61e8a5f269979b238d17278720adb02cf849b0a666335e179e66b069387878d39117026788cbf5e55a6cdfcd696a4d763a7b3a435", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7387058fcc60cfe2ed802f584f814bf81a41902df588dc1d123b838caa08aa410c66200a6971b4376e2a815545d591283b8bd6d4cfcb83627f1b7b09ed389259"}
build_url:https://queue.taskcluster.net/v1/task/UUZzPjZcQeGRz3KpQ_4tlA/artifacts/public/build/firefox-53.0a1.en-US.win32.zip
program finished with exit code 0
elapsedTime=0.101000
build_url: 'https://queue.taskcluster.net/v1/task/UUZzPjZcQeGRz3KpQ_4tlA/artifacts/public/build/firefox-53.0a1.en-US.win32.zip'
blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1b3777a6105261071d90ad1705e079ffdbbbe28fad7624a211ec083faa73fbb969bd68a32a5e138550b732bd8827da8854dd279a5e14fefaeb6ccf343da595c7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/83aa7f58e7a4d495834bd3b61e8a5f269979b238d17278720adb02cf849b0a666335e179e66b069387878d39117026788cbf5e55a6cdfcd696a4d763a7b3a435", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7387058fcc60cfe2ed802f584f814bf81a41902df588dc1d123b838caa08aa410c66200a6971b4376e2a815545d591283b8bd6d4cfcb83627f1b7b09ed389259"}'
========= master_lag: 0.02 =========
========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-02 14:45:32.020552) =========
========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 14:45:32.020924) =========
'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-010
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-010
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-010
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-12-02 14:45:32.135046) =========
========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-12-02 14:45:32.135822) =========
========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-12-02 14:45:32.641792) =========
========= Total master_lag: 3.42 =========