builder: mozilla-central_win7-ix_test-dromaeojs-pgo
slave: t-w732-ix-195
starttime: 1445785669.6
results: success (0)
buildid: 20151025030428
builduid: 9673d31b75584b23861ee40fc1b552eb
revision: d53a52b39a95dced722cca90ac74529b66dd5253
========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-25 08:07:49.603184) =========
master: http://buildbot-master119.bb.releng.scl3.mozilla.com:8201/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-25 08:07:49.604178) =========
========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-25 08:07:49.604499) =========
'cd'
in dir C:\\slave\test-pgo\. (timeout 1200 secs)
watching logfiles {}
argv: ['cd']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld\AppData\Roaming
COMMONPROGRAMFILES=C:\Program Files\Common Files
COMPUTERNAME=T-W732-IX-195
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-195
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-pgo
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-195
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
C:\slave\test-pgo
program finished with exit code 0
elapsedTime=0.567000
basedir: 'C:\\slave\\test-pgo'
========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-25 08:07:50.210806) =========
========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-25 08:07:50.211117) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-25 08:07:50.292387) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-25 08:07:50.292719) =========
'rm' '-rf' 'properties'
in dir C:\\slave\test-pgo\. (timeout 1200 secs)
watching logfiles {}
argv: ['rm', '-rf', 'properties']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld\AppData\Roaming
COMMONPROGRAMFILES=C:\Program Files\Common Files
COMPUTERNAME=T-W732-IX-195
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-195
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-pgo
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-195
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.501000
========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-25 08:07:50.810253) =========
========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-25 08:07:50.810606) =========
script_repo_url: https://hg.mozilla.org/build/mozharness
========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-25 08:07:50.811093) =========
========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-25 08:07:50.811506) =========
'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-pgo\. (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-195
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-195
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-pgo
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-195
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
--08:07:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py
=> `archiver_client.py'
Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25
Connecting to hg.mozilla.org|63.245.215.102|:443... connected.
HTTP request sent, awaiting response... 200 Script output follows
Length: 12,141 (12K) [text/x-python]
0K .......... . 100% 2.27 GB/s
08:07:51 (2.27 GB/s) - `archiver_client.py' saved [12141/12141]
program finished with exit code 0
elapsedTime=0.876000
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-25 08:07:51.709043) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 5 secs) (at 2015-10-25 08:07:51.709458) =========
'rm' '-rf' 'scripts'
in dir C:\\slave\test-pgo\. (timeout 1200 secs)
watching logfiles {}
argv: ['rm', '-rf', 'scripts']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld\AppData\Roaming
COMMONPROGRAMFILES=C:\Program Files\Common Files
COMPUTERNAME=T-W732-IX-195
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-195
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-pgo
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-195
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=5.301000
========= Finished 'rm -rf ...' (results: 0, elapsed: 5 secs) (at 2015-10-25 08:07:57.027363) =========
========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-10-25 08:07:57.027988) =========
'bash' '-c' u'python archiver_client.py mozharness --repo mozilla-central --rev d53a52b39a95dced722cca90ac74529b66dd5253 --destination scripts --debug'
in dir C:\\slave\test-pgo\. (timeout 1200 secs)
watching logfiles {}
argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev d53a52b39a95dced722cca90ac74529b66dd5253 --destination scripts --debug']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld\AppData\Roaming
COMMONPROGRAMFILES=C:\Program Files\Common Files
COMPUTERNAME=T-W732-IX-195
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-195
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-pgo
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-195
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
2015-10-25 08:07:57,223 truncating revision to first 12 chars
2015-10-25 08:07:57,223 Setting DEBUG logging.
2015-10-25 08:07:57,223 attempt 1/10
2015-10-25 08:07:57,223 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d53a52b39a95?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2015-10-25 08:07:58,516 unpacking tar archive at: mozilla-central-d53a52b39a95/testing/mozharness/
program finished with exit code 0
elapsedTime=1.880000
========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-10-25 08:07:58.952052) =========
========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-25 08:07:58.952452) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-25 08:07:58.968846) =========
========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-25 08:07:58.969254) =========
TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production
========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-25 08:07:58.969745) =========
========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 14 secs) (at 2015-10-25 08:07:58.970083) =========
'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'dromaeojs' '--add-option' '--webServer,localhost' '--branch-name' 'Firefox' '--system-bits' '32' '--cfg' 'talos/windows_config.py' '--download-symbols' 'ondemand' '--use-talos-json' '--blob-upload-branch' 'Firefox'
in dir C:\\slave\test-pgo\. (timeout 3600 secs) (maxTime 7200 secs)
watching logfiles {}
argv: ['c:/mozilla-build/python27/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '32', '--cfg', 'talos/windows_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld\AppData\Roaming
COMMONPROGRAMFILES=C:\Program Files\Common Files
COMPUTERNAME=T-W732-IX-195
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-195
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-pgo/buildprops.json
PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\
PUBLIC=C:\Users\Public
PWD=C:\slave\test-pgo
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-195
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
08:07:59 INFO - MultiFileLogger online at 20151025 08:07:59 in C:\slave\test-pgo
08:07:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 32 --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox
08:07:59 INFO - Dumping config to C:\slave\test-pgo\logs\localconfig.json.
08:07:59 INFO - {'append_to_log': False,
08:07:59 INFO - 'base_work_dir': 'C:\\slave\\test-pgo',
08:07:59 INFO - 'blob_upload_branch': 'Firefox',
08:07:59 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test-pgo\\oauth.txt',
08:07:59 INFO - 'branch': 'Firefox',
08:07:59 INFO - 'buildbot_json_path': 'buildprops.json',
08:07:59 INFO - 'config_files': ('talos/windows_config.py',),
08:07:59 INFO - 'default_actions': ('clobber',
08:07:59 INFO - 'read-buildbot-config',
08:07:59 INFO - 'download-and-extract',
08:07:59 INFO - 'populate-webroot',
08:07:59 INFO - 'create-virtualenv',
08:07:59 INFO - 'install',
08:07:59 INFO - 'run-tests'),
08:07:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',),
08:07:59 INFO - 'download_minidump_stackwalk': True,
08:07:59 INFO - 'download_symbols': 'ondemand',
08:07:59 INFO - 'exes': {'easy_install': ('C:\\slave\\test-pgo\\build/venv/scripts/python',
08:07:59 INFO - 'C:\\slave\\test-pgo\\build/venv/scripts/easy_install-2.7-script.py'),
08:07:59 INFO - 'hg': 'c:/mozilla-build/hg/hg',
08:07:59 INFO - 'mozinstall': ('C:\\slave\\test-pgo\\build/venv/scripts/python',
08:07:59 INFO - 'C:\\slave\\test-pgo\\build/venv/scripts/mozinstall-script.py'),
08:07:59 INFO - 'python': 'c:/mozilla-build/python27/python.exe',
08:07:59 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe',
08:07:59 INFO - 'C:/mozilla-build/tooltool.py'),
08:07:59 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe',
08:07:59 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')},
08:07:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub',
08:07:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'),
08:07:59 INFO - 'installer_path': 'installer.exe',
08:07:59 INFO - 'log_level': 'info',
08:07:59 INFO - 'log_name': 'talos',
08:07:59 INFO - 'log_to_console': True,
08:07:59 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe',
08:07:59 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe',
08:07:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest',
08:07:59 INFO - 'opt_config_files': (),
08:07:59 INFO - 'pip_index': False,
08:07:59 INFO - 'sps_profile': False,
08:07:59 INFO - 'sps_profile_interval': 0,
08:07:59 INFO - 'suite': 'dromaeojs',
08:07:59 INFO - 'system_bits': '32',
08:07:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'),
08:07:59 INFO - 'title': 'T-W732-IX-195',
08:07:59 INFO - 'use_talos_json': True,
08:07:59 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'),
08:07:59 INFO - 'virtualenv_path': 'C:\\slave\\test-pgo\\build/venv',
08:07:59 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll',
08:07:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
08:07:59 INFO - 'work_dir': 'build'}
08:07:59 INFO - #####
08:07:59 INFO - ##### Running clobber step.
08:07:59 INFO - #####
08:07:59 INFO - Running pre-action listener: _resource_record_pre_action
08:07:59 INFO - Running main action method: clobber
08:07:59 INFO - rmtree: C:\slave\test-pgo\build
08:07:59 INFO - Using _rmtree_windows ...
08:07:59 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test-pgo\\build',), kwargs: {}, attempt #1
08:09:06 INFO - Running post-action listener: _resource_record_post_action
08:09:06 INFO - #####
08:09:06 INFO - ##### Running read-buildbot-config step.
08:09:06 INFO - #####
08:09:06 INFO - Running pre-action listener: _resource_record_pre_action
08:09:06 INFO - Running main action method: read_buildbot_config
08:09:06 INFO - Using buildbot properties:
08:09:06 INFO - {
08:09:06 INFO - "properties": {
08:09:06 INFO - "buildnumber": 150,
08:09:06 INFO - "product": "firefox",
08:09:06 INFO - "script_repo_revision": "production",
08:09:06 INFO - "builddir": "mozilla-central_win7-ix_test-dromaeojs",
08:09:06 INFO - "repository": "",
08:09:06 INFO - "buildername": "Windows 7 32-bit mozilla-central pgo talos dromaeojs",
08:09:06 INFO - "buildid": "20151025030428",
08:09:06 INFO - "slavename": "t-w732-ix-195",
08:09:06 INFO - "stage_platform": "win32-pgo",
08:09:06 INFO - "basedir": "C:\\slave\\test-pgo",
08:09:06 INFO - "nightly_build": "True",
08:09:06 INFO - "project": "",
08:09:06 INFO - "platform": "win7-ix",
08:09:06 INFO - "master": "http://buildbot-master119.bb.releng.scl3.mozilla.com:8201/",
08:09:06 INFO - "slavebuilddir": "test",
08:09:06 INFO - "scheduler": "tests-mozilla-central-win32-pgo-talos",
08:09:06 INFO - "branch": "mozilla-central",
08:09:06 INFO - "repo_path": "mozilla-central",
08:09:06 INFO - "pgo_build": "True",
08:09:06 INFO - "builduid": "9673d31b75584b23861ee40fc1b552eb",
08:09:06 INFO - "revision": "d53a52b39a95dced722cca90ac74529b66dd5253"
08:09:06 INFO - },
08:09:06 INFO - "sourcestamp": {
08:09:06 INFO - "repository": "",
08:09:06 INFO - "hasPatch": false,
08:09:06 INFO - "project": "",
08:09:06 INFO - "branch": "mozilla-central-win32-pgo-talos",
08:09:06 INFO - "changes": [
08:09:06 INFO - {
08:09:06 INFO - "category": null,
08:09:06 INFO - "files": [
08:09:06 INFO - {
08:09:06 INFO - "url": null,
08:09:06 INFO - "name": "https://queue.taskcluster.net/v1/task/8tw4SnSMTiSzxXLLxutVDg/artifacts/public/build/firefox-44.0a1.en-US.win32.zip"
08:09:06 INFO - }
08:09:06 INFO - ],
08:09:06 INFO - "repository": "",
08:09:06 INFO - "rev": "d53a52b39a95dced722cca90ac74529b66dd5253",
08:09:06 INFO - "who": "sendchange",
08:09:06 INFO - "when": 1445785626,
08:09:06 INFO - "number": 6571363,
08:09:06 INFO - "comments": "",
08:09:06 INFO - "project": "",
08:09:06 INFO - "at": "Sun 25 Oct 2015 08:07:06",
08:09:06 INFO - "branch": "mozilla-central-win32-pgo-talos",
08:09:06 INFO - "revlink": "",
08:09:06 INFO - "properties": [
08:09:06 INFO - [
08:09:06 INFO - "buildid",
08:09:06 INFO - "20151025030428",
08:09:06 INFO - "Change"
08:09:06 INFO - ],
08:09:06 INFO - [
08:09:06 INFO - "builduid",
08:09:06 INFO - "9673d31b75584b23861ee40fc1b552eb",
08:09:06 INFO - "Change"
08:09:06 INFO - ],
08:09:06 INFO - [
08:09:06 INFO - "nightly_build",
08:09:06 INFO - "True",
08:09:06 INFO - "Change"
08:09:06 INFO - ],
08:09:06 INFO - [
08:09:06 INFO - "pgo_build",
08:09:06 INFO - "True",
08:09:06 INFO - "Change"
08:09:06 INFO - ]
08:09:06 INFO - ],
08:09:06 INFO - "revision": "d53a52b39a95dced722cca90ac74529b66dd5253"
08:09:06 INFO - }
08:09:06 INFO - ],
08:09:06 INFO - "revision": "d53a52b39a95dced722cca90ac74529b66dd5253"
08:09:06 INFO - }
08:09:06 INFO - }
08:09:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/8tw4SnSMTiSzxXLLxutVDg/artifacts/public/build/firefox-44.0a1.en-US.win32.zip.
08:09:06 INFO - Running post-action listener: _resource_record_post_action
08:09:06 INFO - #####
08:09:06 INFO - ##### Running download-and-extract step.
08:09:06 INFO - #####
08:09:06 INFO - Running pre-action listener: _resource_record_pre_action
08:09:06 INFO - Running main action method: download_and_extract
08:09:06 INFO - mkdir: C:\slave\test-pgo\build\tests
08:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
08:09:06 INFO - https://queue.taskcluster.net/v1/task/8tw4SnSMTiSzxXLLxutVDg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net
08:09:06 INFO - trying https://queue.taskcluster.net/v1/task/8tw4SnSMTiSzxXLLxutVDg/artifacts/public/build/test_packages.json
08:09:06 INFO - Downloading https://queue.taskcluster.net/v1/task/8tw4SnSMTiSzxXLLxutVDg/artifacts/public/build/test_packages.json to C:\slave\test-pgo\build\test_packages.json
08:09:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/8tw4SnSMTiSzxXLLxutVDg/artifacts/public/build/test_packages.json', 'file_name': 'C:\\slave\\test-pgo\\build\\test_packages.json'}, attempt #1
08:09:07 INFO - Downloaded 1221 bytes.
08:09:07 INFO - Reading from file C:\slave\test-pgo\build\test_packages.json
08:09:07 INFO - Using the following test package requirements:
08:09:07 INFO - {u'common': [u'firefox-44.0a1.en-US.win32.common.tests.zip'],
08:09:07 INFO - u'cppunittest': [u'firefox-44.0a1.en-US.win32.common.tests.zip',
08:09:07 INFO - u'firefox-44.0a1.en-US.win32.cppunittest.tests.zip'],
08:09:07 INFO - u'jittest': [u'firefox-44.0a1.en-US.win32.common.tests.zip',
08:09:07 INFO - u'jsshell-win32.zip'],
08:09:07 INFO - u'mochitest': [u'firefox-44.0a1.en-US.win32.common.tests.zip',
08:09:07 INFO - u'firefox-44.0a1.en-US.win32.mochitest.tests.zip'],
08:09:07 INFO - u'mozbase': [u'firefox-44.0a1.en-US.win32.common.tests.zip'],
08:09:07 INFO - u'reftest': [u'firefox-44.0a1.en-US.win32.common.tests.zip',
08:09:07 INFO - u'firefox-44.0a1.en-US.win32.reftest.tests.zip'],
08:09:07 INFO - u'talos': [u'firefox-44.0a1.en-US.win32.common.tests.zip',
08:09:07 INFO - u'firefox-44.0a1.en-US.win32.talos.tests.zip'],
08:09:07 INFO - u'web-platform': [u'firefox-44.0a1.en-US.win32.common.tests.zip',
08:09:07 INFO - u'firefox-44.0a1.en-US.win32.web-platform.tests.zip'],
08:09:07 INFO - u'webapprt': [u'firefox-44.0a1.en-US.win32.common.tests.zip'],
08:09:07 INFO - u'xpcshell': [u'firefox-44.0a1.en-US.win32.common.tests.zip',
08:09:07 INFO - u'firefox-44.0a1.en-US.win32.xpcshell.tests.zip']}
08:09:07 INFO - Downloading packages: [u'firefox-44.0a1.en-US.win32.common.tests.zip'] for test suite category: common
08:09:07 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
08:09:07 INFO - https://queue.taskcluster.net/v1/task/8tw4SnSMTiSzxXLLxutVDg/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip matches https://queue.taskcluster.net
08:09:07 INFO - trying https://queue.taskcluster.net/v1/task/8tw4SnSMTiSzxXLLxutVDg/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip
08:09:07 INFO - Downloading https://queue.taskcluster.net/v1/task/8tw4SnSMTiSzxXLLxutVDg/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip to C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.common.tests.zip
08:09:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/8tw4SnSMTiSzxXLLxutVDg/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip', 'file_name': u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win32.common.tests.zip'}, attempt #1
08:09:09 INFO - Downloaded 18011075 bytes.
08:09:09 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win32.common.tests.zip'] in C:\slave\test-pgo\build\tests
08:09:09 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.common.tests.zip
08:09:09 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win32.common.tests.zip'] with output_timeout 1760
08:09:36 INFO - Return code: 0
08:09:36 INFO - Downloading packages: [u'firefox-44.0a1.en-US.win32.common.tests.zip', u'firefox-44.0a1.en-US.win32.talos.tests.zip'] for test suite category: talos
08:09:36 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
08:09:36 INFO - https://queue.taskcluster.net/v1/task/8tw4SnSMTiSzxXLLxutVDg/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip matches https://queue.taskcluster.net
08:09:36 INFO - trying https://queue.taskcluster.net/v1/task/8tw4SnSMTiSzxXLLxutVDg/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip
08:09:36 INFO - Downloading https://queue.taskcluster.net/v1/task/8tw4SnSMTiSzxXLLxutVDg/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip to C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.common.tests.zip
08:09:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/8tw4SnSMTiSzxXLLxutVDg/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip', 'file_name': u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win32.common.tests.zip'}, attempt #1
08:09:37 INFO - Downloaded 18011075 bytes.
08:09:37 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win32.common.tests.zip'] in C:\slave\test-pgo\build\tests
08:09:37 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.common.tests.zip
08:09:37 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win32.common.tests.zip'] with output_timeout 1760
08:10:00 INFO - Return code: 0
08:10:00 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
08:10:00 INFO - https://queue.taskcluster.net/v1/task/8tw4SnSMTiSzxXLLxutVDg/artifacts/public/build/firefox-44.0a1.en-US.win32.talos.tests.zip matches https://queue.taskcluster.net
08:10:00 INFO - trying https://queue.taskcluster.net/v1/task/8tw4SnSMTiSzxXLLxutVDg/artifacts/public/build/firefox-44.0a1.en-US.win32.talos.tests.zip
08:10:00 INFO - Downloading https://queue.taskcluster.net/v1/task/8tw4SnSMTiSzxXLLxutVDg/artifacts/public/build/firefox-44.0a1.en-US.win32.talos.tests.zip to C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.talos.tests.zip
08:10:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/8tw4SnSMTiSzxXLLxutVDg/artifacts/public/build/firefox-44.0a1.en-US.win32.talos.tests.zip', 'file_name': u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win32.talos.tests.zip'}, attempt #1
08:10:02 INFO - Downloaded 11131307 bytes.
08:10:02 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win32.talos.tests.zip'] in C:\slave\test-pgo\build\tests
08:10:02 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.talos.tests.zip
08:10:02 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win32.talos.tests.zip'] with output_timeout 1760
08:10:05 INFO - Return code: 0
08:10:05 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
08:10:05 INFO - https://queue.taskcluster.net/v1/task/8tw4SnSMTiSzxXLLxutVDg/artifacts/public/build/firefox-44.0a1.en-US.win32.zip matches https://queue.taskcluster.net
08:10:05 INFO - trying https://queue.taskcluster.net/v1/task/8tw4SnSMTiSzxXLLxutVDg/artifacts/public/build/firefox-44.0a1.en-US.win32.zip
08:10:05 INFO - Downloading https://queue.taskcluster.net/v1/task/8tw4SnSMTiSzxXLLxutVDg/artifacts/public/build/firefox-44.0a1.en-US.win32.zip to C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.zip
08:10:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/8tw4SnSMTiSzxXLLxutVDg/artifacts/public/build/firefox-44.0a1.en-US.win32.zip', 'file_name': 'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win32.zip'}, attempt #1
08:10:08 INFO - Downloaded 53385619 bytes.
08:10:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/8tw4SnSMTiSzxXLLxutVDg/artifacts/public/build/firefox-44.0a1.en-US.win32.zip
08:10:08 INFO - mkdir: C:\slave\test-pgo\properties
08:10:08 INFO - Writing buildbot properties ['build_url'] to C:\slave\test-pgo\properties\build_url
08:10:08 INFO - Writing to file C:\slave\test-pgo\properties\build_url
08:10:08 INFO - Contents:
08:10:08 INFO - build_url:https://queue.taskcluster.net/v1/task/8tw4SnSMTiSzxXLLxutVDg/artifacts/public/build/firefox-44.0a1.en-US.win32.zip
08:10:08 INFO - Running post-action listener: _resource_record_post_action
08:10:08 INFO - Running post-action listener: set_extra_try_arguments
08:10:08 INFO - #####
08:10:08 INFO - ##### Running populate-webroot step.
08:10:08 INFO - #####
08:10:08 INFO - Running pre-action listener: _resource_record_pre_action
08:10:08 INFO - Running main action method: populate_webroot
08:10:08 INFO - Guessing talos json url...
08:10:08 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
08:10:08 INFO - https://queue.taskcluster.net/v1/task/8tw4SnSMTiSzxXLLxutVDg/artifacts/public/build/firefox-44.0a1.en-US.win32.txt matches https://queue.taskcluster.net
08:10:08 INFO - trying https://queue.taskcluster.net/v1/task/8tw4SnSMTiSzxXLLxutVDg/artifacts/public/build/firefox-44.0a1.en-US.win32.txt
08:10:08 INFO - Downloading https://queue.taskcluster.net/v1/task/8tw4SnSMTiSzxXLLxutVDg/artifacts/public/build/firefox-44.0a1.en-US.win32.txt to C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.txt
08:10:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/8tw4SnSMTiSzxXLLxutVDg/artifacts/public/build/firefox-44.0a1.en-US.win32.txt', 'file_name': 'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win32.txt'}, attempt #1
08:10:09 INFO - Downloaded 99 bytes.
08:10:09 INFO - Reading from file C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.txt
08:10:09 INFO - Contents:
08:10:09 INFO - 20151025030428
08:10:09 INFO - https://hg.mozilla.org/mozilla-central/rev/d53a52b39a95dced722cca90ac74529b66dd5253
08:10:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
08:10:09 INFO - trying https://hg.mozilla.org/mozilla-central/raw-file/d53a52b39a/testing/talos/talos.json
08:10:09 INFO - Downloading https://hg.mozilla.org/mozilla-central/raw-file/d53a52b39a/testing/talos/talos.json to C:\slave\test-pgo\build\talos.json
08:10:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/mozilla-central/raw-file/d53a52b39a/testing/talos/talos.json', 'file_name': 'C:\\slave\\test-pgo\\build\\talos.json'}, attempt #1
08:10:09 INFO - Downloaded 4264 bytes.
08:10:09 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']},
08:10:09 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']},
08:10:09 INFO - u'remote-trobocheck2': {u'talos_options': [u'--fennecIDs',
08:10:09 INFO - u'../fennec_ids.txt'],
08:10:09 INFO - u'tests': [u'tcheck2']},
08:10:09 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome',
08:10:09 INFO - u'--tppagecycles',
08:10:09 INFO - u'7'],
08:10:09 INFO - u'tests': [u'tsvgm']}},
08:10:09 INFO - u'suites': {u'chromez': {u'tests': [u'tresize', u'tcanvasmark']},
08:10:09 INFO - u'chromez-e10s': {u'talos_options': [u'--e10s'],
08:10:09 INFO - u'tests': [u'tresize', u'tcanvasmark']},
08:10:09 INFO - u'dromaeojs': {u'tests': [u'dromaeo_css', u'kraken', u'v8_7']},
08:10:09 INFO - u'dromaeojs-e10s': {u'talos_options': [u'--e10s'],
08:10:09 INFO - u'tests': [u'dromaeo_css',
08:10:09 INFO - u'kraken',
08:10:09 INFO - u'v8_7']},
08:10:09 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
08:10:09 INFO - u'tests': [u'tp5o_scroll', u'glterrain']},
08:10:09 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
08:10:09 INFO - u'talos_options': [u'--e10s'],
08:10:09 INFO - u'tests': [u'tp5o_scroll', u'glterrain']},
08:10:09 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
08:10:09 INFO - u'tests': [u'damp', u'tps']},
08:10:09 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
08:10:09 INFO - u'talos_options': [u'--e10s'],
08:10:09 INFO - u'tests': [u'damp', u'tps']},
08:10:09 INFO - u'g3': {u'tests': [u'dromaeo_dom']},
08:10:09 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']},
08:10:09 INFO - u'other': {u'tests': [u'a11yr',
08:10:09 INFO - u'ts_paint',
08:10:09 INFO - u'tpaint',
08:10:09 INFO - u'sessionrestore',
08:10:09 INFO - u'sessionrestore_no_auto_restore']},
08:10:09 INFO - u'other-e10s': {u'talos_options': [u'--e10s'],
08:10:09 INFO - u'tests': [u'a11yr',
08:10:09 INFO - u'ts_paint',
08:10:09 INFO - u'tpaint',
08:10:09 INFO - u'sessionrestore',
08:10:09 INFO - u'sessionrestore_no_auto_restore']},
08:10:09 INFO - u'other-e10s_l64': {u'talos_options': [u'--e10s'],
08:10:09 INFO - u'tests': [u'a11yr',
08:10:09 INFO - u'ts_paint',
08:10:09 INFO - u'tpaint',
08:10:09 INFO - u'sessionrestore',
08:10:09 INFO - u'sessionrestore_no_auto_restore']},
08:10:09 INFO - u'other-e10s_nol64': {u'talos_options': [u'--e10s'],
08:10:09 INFO - u'tests': [u'a11yr',
08:10:09 INFO - u'ts_paint',
08:10:09 INFO - u'tpaint',
08:10:09 INFO - u'sessionrestore',
08:10:09 INFO - u'sessionrestore_no_auto_restore']},
08:10:09 INFO - u'other_l64': {u'tests': [u'a11yr',
08:10:09 INFO - u'ts_paint',
08:10:09 INFO - u'tpaint',
08:10:09 INFO - u'sessionrestore',
08:10:09 INFO - u'sessionrestore_no_auto_restore']},
08:10:09 INFO - u'other_nol64': {u'tests': [u'a11yr',
08:10:09 INFO - u'ts_paint',
08:10:09 INFO - u'tpaint',
08:10:09 INFO - u'sessionrestore',
08:10:09 INFO - u'sessionrestore_no_auto_restore']},
08:10:09 INFO - u'svgr': {u'tests': [u'tsvgx',
08:10:09 INFO - u'tsvgr_opacity',
08:10:09 INFO - u'tart',
08:10:09 INFO - u'tscrollx',
08:10:09 INFO - u'cart']},
08:10:09 INFO - u'svgr-e10s': {u'talos_options': [u'--e10s'],
08:10:09 INFO - u'tests': [u'tsvgx',
08:10:09 INFO - u'tsvgr_opacity',
08:10:09 INFO - u'tart',
08:10:09 INFO - u'tscrollx',
08:10:09 INFO - u'cart']},
08:10:09 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
08:10:09 INFO - u'tests': [u'tp5o']},
08:10:09 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
08:10:09 INFO - u'talos_options': [u'--e10s'],
08:10:09 INFO - u'tests': [u'tp5o']},
08:10:09 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
08:10:09 INFO - u'talos_options': [u'--xperf_path',
08:10:09 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
08:10:09 INFO - u'tests': [u'tp5n']},
08:10:09 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
08:10:09 INFO - u'talos_options': [u'--e10s',
08:10:09 INFO - u'--xperf_path',
08:10:09 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"',
08:10:09 INFO - u'C:/slave/talos-data/talos/xperf.config'],
08:10:09 INFO - u'tests': [u'tp5n']}},
08:10:09 INFO - u'talos.zip': {u'path': u'',
08:10:09 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}}
08:10:09 INFO - Running post-action listener: _resource_record_post_action
08:10:09 INFO - #####
08:10:09 INFO - ##### Running create-virtualenv step.
08:10:09 INFO - #####
08:10:09 INFO - Running pre-action listener: _resource_record_pre_action
08:10:09 INFO - Running main action method: create_virtualenv
08:10:09 INFO - Creating virtualenv C:\slave\test-pgo\build/venv
08:10:09 INFO - mkdir: C:\slave\test-pgo\build\venv\Scripts
08:10:09 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test-pgo\build\venv\Scripts\python27.dll
08:10:09 WARNING - Can't copy c:/mozilla-build/python27/python27.dll to C:\slave\test-pgo\build\venv\Scripts\python27.dll: [Errno 2] No such file or directory: 'c:/mozilla-build/python27/python27.dll'!
08:10:09 INFO - Running command: ['c:/mozilla-build/python27/python.exe', 'c:/mozilla-build/buildbotve/virtualenv.py', '--no-site-packages', '--distribute', 'C:\\slave\\test-pgo\\build/venv'] in C:\slave\test-pgo\build
08:10:09 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test-pgo\build/venv
08:10:13 INFO - New python executable in C:\slave\test-pgo\build/venv\Scripts\python.exe
08:10:16 INFO - Installing distribute......................................................................................................................................................................................done.
08:10:18 INFO - Return code: 0
08:10:18 INFO - Installing pip>=1.5 into virtualenv C:\slave\test-pgo\build/venv
08:10:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
08:10:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
08:10:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
08:10:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
08:10:18 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--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 0x018FCB10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01955EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0181AE58>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01318B48>, '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 0x0133A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01E5F660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-195', 'USERDOMAIN': 'T-W732-IX-195', '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-195', '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-pgo', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
08:10:18 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--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-pgo\build
08:10:18 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --download-cache C:\slave\test-pgo\build/venv\cache --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
08:10:18 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
08:10:18 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
08:10:18 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
08:10:18 INFO - 'COMPUTERNAME': 'T-W732-IX-195',
08:10:18 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
08:10:18 INFO - 'CYGWINBASE': 'C:\\cygwin',
08:10:18 INFO - 'DCLOCATION': 'SCL3',
08:10:18 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
08:10:18 INFO - 'FP_NO_HOST_CHECK': 'NO',
08:10:18 INFO - 'HOMEDRIVE': 'C:',
08:10:18 INFO - 'HOMEPATH': '\\Users\\cltbld',
08:10:18 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
08:10:18 INFO - 'KTS_VERSION': '1.19c',
08:10:18 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
08:10:18 INFO - 'LOGONSERVER': '\\\\T-W732-IX-195',
08:10:18 INFO - 'MONDIR': 'C:\\Monitor_config\\',
08:10:18 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
08:10:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
08:10:18 INFO - 'MOZ_NO_REMOTE': '1',
08:10:18 INFO - 'NO_EM_RESTART': '1',
08:10:18 INFO - 'NUMBER_OF_PROCESSORS': '8',
08:10:18 INFO - 'OS': 'Windows_NT',
08:10:18 INFO - 'OURDRIVE': 'C:',
08:10:18 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;',
08:10:18 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
08:10:18 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
08:10:18 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
08:10:18 INFO - 'PROCESSOR_LEVEL': '6',
08:10:18 INFO - 'PROCESSOR_REVISION': '1e05',
08:10:18 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
08:10:18 INFO - 'PROGRAMFILES': 'C:\\Program Files',
08:10:18 INFO - 'PROMPT': '$P$G',
08:10:18 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json',
08:10:18 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
08:10:18 INFO - 'PUBLIC': 'C:\\Users\\Public',
08:10:18 INFO - 'PWD': 'C:\\slave\\test-pgo',
08:10:18 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
08:10:18 INFO - 'SLAVEDIR': 'C:\\slave\\',
08:10:18 INFO - 'SYSTEMDRIVE': 'C:',
08:10:18 INFO - 'SYSTEMROOT': 'C:\\windows',
08:10:18 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
08:10:18 INFO - 'TEST1': 'testie',
08:10:18 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
08:10:18 INFO - 'USERDOMAIN': 'T-W732-IX-195',
08:10:18 INFO - 'USERNAME': 'cltbld',
08:10:18 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
08:10:18 INFO - 'WINDIR': 'C:\\windows',
08:10:18 INFO - 'WINDOWS_TRACING_FLAGS': '3',
08:10:18 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
08:10:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
08:10:19 INFO - Ignoring indexes: http://pypi.python.org/simple/
08:10:19 INFO - Downloading/unpacking pip>=1.5
08:10:19 INFO - Creating supposed download cache at C:\slave\test-pgo\build/venv\cache
08:10:23 INFO - Storing download in cache at c:\slave\test-pgo\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fpip-1.5.5.tar.gz
08:10:23 INFO - Running setup.py egg_info for package pip
08:10:23 INFO - warning: no files found matching 'pip\cacert.pem'
08:10:23 INFO - warning: no files found matching '*.html' under directory 'docs'
08:10:23 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build'
08:10:23 INFO - no previously-included directories found matching 'docs\_build\_sources'
08:10:23 INFO - Installing collected packages: pip
08:10:23 INFO - Found existing installation: pip 0.8.2
08:10:23 INFO - Uninstalling pip:
08:10:23 INFO - Successfully uninstalled pip
08:10:23 INFO - Running setup.py install for pip
08:10:23 INFO - warning: no files found matching 'pip\cacert.pem'
08:10:23 INFO - warning: no files found matching '*.html' under directory 'docs'
08:10:23 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build'
08:10:23 INFO - no previously-included directories found matching 'docs\_build\_sources'
08:10:23 INFO - Installing pip-script.py script to C:\slave\test-pgo\build\venv\Scripts
08:10:23 INFO - Installing pip.exe script to C:\slave\test-pgo\build\venv\Scripts
08:10:23 INFO - Installing pip2.7-script.py script to C:\slave\test-pgo\build\venv\Scripts
08:10:23 INFO - Installing pip2.7.exe script to C:\slave\test-pgo\build\venv\Scripts
08:10:23 INFO - Installing pip2-script.py script to C:\slave\test-pgo\build\venv\Scripts
08:10:23 INFO - Installing pip2.exe script to C:\slave\test-pgo\build\venv\Scripts
08:10:23 INFO - Successfully installed pip
08:10:23 INFO - Cleaning up...
08:10:23 INFO - Return code: 0
08:10:23 INFO - Installing psutil>=0.7.1 into virtualenv C:\slave\test-pgo\build/venv
08:10:23 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
08:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
08:10:23 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
08:10:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
08:10:23 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x018FCB10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01955EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0181AE58>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01318B48>, '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 0x0133A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01E5F660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-195', 'USERDOMAIN': 'T-W732-IX-195', '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-195', '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-pgo', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
08:10:23 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in C:\slave\test-pgo\build
08:10:23 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --download-cache C:\slave\test-pgo\build/venv\cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1
08:10:23 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
08:10:23 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
08:10:23 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
08:10:23 INFO - 'COMPUTERNAME': 'T-W732-IX-195',
08:10:23 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
08:10:23 INFO - 'CYGWINBASE': 'C:\\cygwin',
08:10:23 INFO - 'DCLOCATION': 'SCL3',
08:10:23 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
08:10:23 INFO - 'FP_NO_HOST_CHECK': 'NO',
08:10:23 INFO - 'HOMEDRIVE': 'C:',
08:10:23 INFO - 'HOMEPATH': '\\Users\\cltbld',
08:10:23 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
08:10:23 INFO - 'KTS_VERSION': '1.19c',
08:10:23 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
08:10:23 INFO - 'LOGONSERVER': '\\\\T-W732-IX-195',
08:10:23 INFO - 'MONDIR': 'C:\\Monitor_config\\',
08:10:23 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
08:10:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
08:10:23 INFO - 'MOZ_NO_REMOTE': '1',
08:10:23 INFO - 'NO_EM_RESTART': '1',
08:10:23 INFO - 'NUMBER_OF_PROCESSORS': '8',
08:10:23 INFO - 'OS': 'Windows_NT',
08:10:23 INFO - 'OURDRIVE': 'C:',
08:10:23 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;',
08:10:23 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
08:10:23 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
08:10:23 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
08:10:23 INFO - 'PROCESSOR_LEVEL': '6',
08:10:23 INFO - 'PROCESSOR_REVISION': '1e05',
08:10:23 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
08:10:23 INFO - 'PROGRAMFILES': 'C:\\Program Files',
08:10:23 INFO - 'PROMPT': '$P$G',
08:10:23 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json',
08:10:23 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
08:10:23 INFO - 'PUBLIC': 'C:\\Users\\Public',
08:10:23 INFO - 'PWD': 'C:\\slave\\test-pgo',
08:10:23 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
08:10:23 INFO - 'SLAVEDIR': 'C:\\slave\\',
08:10:23 INFO - 'SYSTEMDRIVE': 'C:',
08:10:23 INFO - 'SYSTEMROOT': 'C:\\windows',
08:10:23 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
08:10:23 INFO - 'TEST1': 'testie',
08:10:23 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
08:10:23 INFO - 'USERDOMAIN': 'T-W732-IX-195',
08:10:23 INFO - 'USERNAME': 'cltbld',
08:10:23 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
08:10:23 INFO - 'WINDIR': 'C:\\windows',
08:10:23 INFO - 'WINDOWS_TRACING_FLAGS': '3',
08:10:23 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
08:10:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
08:10:24 INFO - Ignoring indexes: https://pypi.python.org/simple/
08:10:24 INFO - Downloading/unpacking psutil>=0.7.1
08:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
08:10:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
08:10:25 INFO - Storing download in cache at c:\slave\test-pgo\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fpsutil-3.1.1-cp27-none-win32.whl
08:10:25 INFO - Installing collected packages: psutil
08:10:25 INFO - Successfully installed psutil
08:10:25 INFO - Cleaning up...
08:10:25 INFO - Return code: 0
08:10:25 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv C:\slave\test-pgo\build/venv
08:10:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
08:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
08:10:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
08:10:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
08:10:25 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x018FCB10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01955EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0181AE58>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01318B48>, '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 0x0133A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01E5F660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-195', 'USERDOMAIN': 'T-W732-IX-195', '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-195', '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-pgo', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
08:10:26 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in C:\slave\test-pgo\build
08:10:26 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --download-cache C:\slave\test-pgo\build/venv\cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0
08:10:26 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
08:10:26 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
08:10:26 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
08:10:26 INFO - 'COMPUTERNAME': 'T-W732-IX-195',
08:10:26 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
08:10:26 INFO - 'CYGWINBASE': 'C:\\cygwin',
08:10:26 INFO - 'DCLOCATION': 'SCL3',
08:10:26 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
08:10:26 INFO - 'FP_NO_HOST_CHECK': 'NO',
08:10:26 INFO - 'HOMEDRIVE': 'C:',
08:10:26 INFO - 'HOMEPATH': '\\Users\\cltbld',
08:10:26 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
08:10:26 INFO - 'KTS_VERSION': '1.19c',
08:10:26 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
08:10:26 INFO - 'LOGONSERVER': '\\\\T-W732-IX-195',
08:10:26 INFO - 'MONDIR': 'C:\\Monitor_config\\',
08:10:26 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
08:10:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
08:10:26 INFO - 'MOZ_NO_REMOTE': '1',
08:10:26 INFO - 'NO_EM_RESTART': '1',
08:10:26 INFO - 'NUMBER_OF_PROCESSORS': '8',
08:10:26 INFO - 'OS': 'Windows_NT',
08:10:26 INFO - 'OURDRIVE': 'C:',
08:10:26 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;',
08:10:26 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
08:10:26 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
08:10:26 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
08:10:26 INFO - 'PROCESSOR_LEVEL': '6',
08:10:26 INFO - 'PROCESSOR_REVISION': '1e05',
08:10:26 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
08:10:26 INFO - 'PROGRAMFILES': 'C:\\Program Files',
08:10:26 INFO - 'PROMPT': '$P$G',
08:10:26 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json',
08:10:26 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
08:10:26 INFO - 'PUBLIC': 'C:\\Users\\Public',
08:10:26 INFO - 'PWD': 'C:\\slave\\test-pgo',
08:10:26 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
08:10:26 INFO - 'SLAVEDIR': 'C:\\slave\\',
08:10:26 INFO - 'SYSTEMDRIVE': 'C:',
08:10:26 INFO - 'SYSTEMROOT': 'C:\\windows',
08:10:26 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
08:10:26 INFO - 'TEST1': 'testie',
08:10:26 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
08:10:26 INFO - 'USERDOMAIN': 'T-W732-IX-195',
08:10:26 INFO - 'USERNAME': 'cltbld',
08:10:26 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
08:10:26 INFO - 'WINDIR': 'C:\\windows',
08:10:26 INFO - 'WINDOWS_TRACING_FLAGS': '3',
08:10:26 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
08:10:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
08:10:26 INFO - Ignoring indexes: https://pypi.python.org/simple/
08:10:26 INFO - Downloading/unpacking mozsystemmonitor==0.0.0
08:10:26 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
08:10:26 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
08:10:27 INFO - Downloading mozsystemmonitor-0.0.tar.gz
08:10:27 INFO - Storing download in cache at c:\slave\test-pgo\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fmozsystemmonitor-0.0.tar.gz
08:10:27 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor
08:10:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in c:\slave\test-pgo\build\venv\lib\site-packages (from mozsystemmonitor==0.0.0)
08:10:27 INFO - Installing collected packages: mozsystemmonitor
08:10:27 INFO - Running setup.py install for mozsystemmonitor
08:10:27 INFO - Successfully installed mozsystemmonitor
08:10:27 INFO - Cleaning up...
08:10:27 INFO - Return code: 0
08:10:27 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test-pgo\build/venv
08:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
08:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
08:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
08:10:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
08:10:27 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--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 0x018FCB10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01955EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0181AE58>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01318B48>, '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 0x0133A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01E5F660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-195', 'USERDOMAIN': 'T-W732-IX-195', '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-195', '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-pgo', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
08:10:27 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--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-pgo\build
08:10:27 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --download-cache C:\slave\test-pgo\build/venv\cache --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
08:10:27 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
08:10:27 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
08:10:27 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
08:10:27 INFO - 'COMPUTERNAME': 'T-W732-IX-195',
08:10:27 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
08:10:27 INFO - 'CYGWINBASE': 'C:\\cygwin',
08:10:27 INFO - 'DCLOCATION': 'SCL3',
08:10:27 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
08:10:27 INFO - 'FP_NO_HOST_CHECK': 'NO',
08:10:27 INFO - 'HOMEDRIVE': 'C:',
08:10:27 INFO - 'HOMEPATH': '\\Users\\cltbld',
08:10:27 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
08:10:27 INFO - 'KTS_VERSION': '1.19c',
08:10:27 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
08:10:27 INFO - 'LOGONSERVER': '\\\\T-W732-IX-195',
08:10:27 INFO - 'MONDIR': 'C:\\Monitor_config\\',
08:10:27 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
08:10:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
08:10:27 INFO - 'MOZ_NO_REMOTE': '1',
08:10:27 INFO - 'NO_EM_RESTART': '1',
08:10:27 INFO - 'NUMBER_OF_PROCESSORS': '8',
08:10:27 INFO - 'OS': 'Windows_NT',
08:10:27 INFO - 'OURDRIVE': 'C:',
08:10: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;',
08:10:27 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
08:10:27 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
08:10:27 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
08:10:27 INFO - 'PROCESSOR_LEVEL': '6',
08:10:27 INFO - 'PROCESSOR_REVISION': '1e05',
08:10:27 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
08:10:27 INFO - 'PROGRAMFILES': 'C:\\Program Files',
08:10:27 INFO - 'PROMPT': '$P$G',
08:10:27 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json',
08:10:27 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
08:10:27 INFO - 'PUBLIC': 'C:\\Users\\Public',
08:10:27 INFO - 'PWD': 'C:\\slave\\test-pgo',
08:10:27 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
08:10:27 INFO - 'SLAVEDIR': 'C:\\slave\\',
08:10:27 INFO - 'SYSTEMDRIVE': 'C:',
08:10:27 INFO - 'SYSTEMROOT': 'C:\\windows',
08:10:27 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
08:10:27 INFO - 'TEST1': 'testie',
08:10:27 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
08:10:27 INFO - 'USERDOMAIN': 'T-W732-IX-195',
08:10:27 INFO - 'USERNAME': 'cltbld',
08:10:27 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
08:10:27 INFO - 'WINDIR': 'C:\\windows',
08:10:27 INFO - 'WINDOWS_TRACING_FLAGS': '3',
08:10:27 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
08:10:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
08:10:28 INFO - Ignoring indexes: https://pypi.python.org/simple/
08:10:28 INFO - Downloading/unpacking blobuploader==1.2.4
08:10:28 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
08:10:28 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
08:10:28 INFO - Downloading blobuploader-1.2.4.tar.gz
08:10:28 INFO - Storing download in cache at c:\slave\test-pgo\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fblobuploader-1.2.4.tar.gz
08:10:28 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader
08:10:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4)
08:10:29 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
08:10:29 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
08:10:29 INFO - Storing download in cache at c:\slave\test-pgo\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2frequests-1.2.3.tar.gz
08:10:29 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\requests\setup.py) egg_info for package requests
08:10:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4)
08:10:29 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
08:10:29 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
08:10:29 INFO - Downloading docopt-0.6.1.tar.gz
08:10:29 INFO - Storing download in cache at c:\slave\test-pgo\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fdocopt-0.6.1.tar.gz
08:10:29 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\docopt\setup.py) egg_info for package docopt
08:10:29 INFO - Installing collected packages: blobuploader, requests, docopt
08:10:29 INFO - Running setup.py install for blobuploader
08:10:30 INFO - Running setup.py install for requests
08:10:30 INFO - Running setup.py install for docopt
08:10:30 INFO - Successfully installed blobuploader requests docopt
08:10:30 INFO - Cleaning up...
08:10:31 INFO - Return code: 0
08:10:31 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv
08:10:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
08:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
08:10:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
08:10:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
08:10:31 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--no-deps', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test-pgo\\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 0x018FCB10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01955EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0181AE58>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01318B48>, '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 0x0133A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01E5F660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-195', 'USERDOMAIN': 'T-W732-IX-195', '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-195', '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-pgo', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
08:10:32 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--no-deps', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test-pgo\\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-pgo\build\tests\config
08:10:32 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --no-deps --download-cache C:\slave\test-pgo\build/venv\cache --timeout 120 -r C:\slave\test-pgo\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
08:10:32 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
08:10:32 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
08:10:32 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
08:10:32 INFO - 'COMPUTERNAME': 'T-W732-IX-195',
08:10:32 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
08:10:32 INFO - 'CYGWINBASE': 'C:\\cygwin',
08:10:32 INFO - 'DCLOCATION': 'SCL3',
08:10:32 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
08:10:32 INFO - 'FP_NO_HOST_CHECK': 'NO',
08:10:32 INFO - 'HOMEDRIVE': 'C:',
08:10:32 INFO - 'HOMEPATH': '\\Users\\cltbld',
08:10:32 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
08:10:32 INFO - 'KTS_VERSION': '1.19c',
08:10:32 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
08:10:32 INFO - 'LOGONSERVER': '\\\\T-W732-IX-195',
08:10:32 INFO - 'MONDIR': 'C:\\Monitor_config\\',
08:10:32 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
08:10:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
08:10:32 INFO - 'MOZ_NO_REMOTE': '1',
08:10:32 INFO - 'NO_EM_RESTART': '1',
08:10:32 INFO - 'NUMBER_OF_PROCESSORS': '8',
08:10:32 INFO - 'OS': 'Windows_NT',
08:10:32 INFO - 'OURDRIVE': 'C:',
08:10:32 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;',
08:10:32 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
08:10:32 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
08:10:32 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
08:10:32 INFO - 'PROCESSOR_LEVEL': '6',
08:10:32 INFO - 'PROCESSOR_REVISION': '1e05',
08:10:32 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
08:10:32 INFO - 'PROGRAMFILES': 'C:\\Program Files',
08:10:32 INFO - 'PROMPT': '$P$G',
08:10:32 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json',
08:10:32 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
08:10:32 INFO - 'PUBLIC': 'C:\\Users\\Public',
08:10:32 INFO - 'PWD': 'C:\\slave\\test-pgo',
08:10:32 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
08:10:32 INFO - 'SLAVEDIR': 'C:\\slave\\',
08:10:32 INFO - 'SYSTEMDRIVE': 'C:',
08:10:32 INFO - 'SYSTEMROOT': 'C:\\windows',
08:10:32 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
08:10:32 INFO - 'TEST1': 'testie',
08:10:32 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
08:10:32 INFO - 'USERDOMAIN': 'T-W732-IX-195',
08:10:32 INFO - 'USERNAME': 'cltbld',
08:10:32 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
08:10:32 INFO - 'WINDIR': 'C:\\windows',
08:10:32 INFO - 'WINDOWS_TRACING_FLAGS': '3',
08:10:32 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
08:10:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
08:10:32 INFO - Ignoring indexes: https://pypi.python.org/simple/
08:10:32 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\manifestparser
08:10:32 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-e07u1w-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/manifestparser
08:10:32 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozcrash
08:10:32 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-xaz_el-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozcrash
08:10:32 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdebug
08:10:32 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-x2nokt-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdebug
08:10:32 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdevice
08:10:32 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-p3071g-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdevice
08:10:32 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozfile
08:10:32 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-vzelme-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozfile
08:10:33 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozhttpd
08:10:33 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-trsmmq-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozhttpd
08:10:33 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinfo
08:10:33 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-t2sjey-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinfo
08:10:33 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinstall
08:10:33 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-qtibxh-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinstall
08:10:33 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozleak
08:10:33 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-x21fee-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozleak
08:10:33 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozlog
08:10:33 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-mfap7b-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozlog
08:10:33 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moznetwork
08:10:33 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-d2miei-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moznetwork
08:10:34 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprocess
08:10:34 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-trjp1s-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprocess
08:10:34 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprofile
08:10:34 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-u7cwbt-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprofile
08:10:34 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozrunner
08:10:34 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-xnaimy-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozrunner
08:10:34 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozscreenshot
08:10:34 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-9jk3ef-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozscreenshot
08:10:34 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moztest
08:10:34 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-sbzq6x-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moztest
08:10:34 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozversion
08:10:34 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-gkvmex-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozversion
08:10:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion
08:10:34 INFO - Running setup.py install for manifestparser
08:10:35 INFO - Installing manifestparser-script.py script to C:\slave\test-pgo\build\venv\Scripts
08:10:35 INFO - Installing manifestparser.exe script to C:\slave\test-pgo\build\venv\Scripts
08:10:35 INFO - Running setup.py install for mozcrash
08:10:35 INFO - Running setup.py install for mozdebug
08:10:36 INFO - Running setup.py install for mozdevice
08:10:36 INFO - Installing sutini-script.py script to C:\slave\test-pgo\build\venv\Scripts
08:10:36 INFO - Installing sutini.exe script to C:\slave\test-pgo\build\venv\Scripts
08:10:36 INFO - Installing dm-script.py script to C:\slave\test-pgo\build\venv\Scripts
08:10:36 INFO - Installing dm.exe script to C:\slave\test-pgo\build\venv\Scripts
08:10:36 INFO - Running setup.py install for mozfile
08:10:37 INFO - Running setup.py install for mozhttpd
08:10:37 INFO - Installing mozhttpd-script.py script to C:\slave\test-pgo\build\venv\Scripts
08:10:37 INFO - Installing mozhttpd.exe script to C:\slave\test-pgo\build\venv\Scripts
08:10:37 INFO - Running setup.py install for mozinfo
08:10:37 INFO - Installing mozinfo-script.py script to C:\slave\test-pgo\build\venv\Scripts
08:10:37 INFO - Installing mozinfo.exe script to C:\slave\test-pgo\build\venv\Scripts
08:10:38 INFO - Running setup.py install for mozInstall
08:10:38 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test-pgo\build\venv\Scripts
08:10:38 INFO - Installing moz_remove_from_system.exe script to C:\slave\test-pgo\build\venv\Scripts
08:10:38 INFO - Installing mozuninstall-script.py script to C:\slave\test-pgo\build\venv\Scripts
08:10:38 INFO - Installing mozuninstall.exe script to C:\slave\test-pgo\build\venv\Scripts
08:10:38 INFO - Installing mozinstall-script.py script to C:\slave\test-pgo\build\venv\Scripts
08:10:38 INFO - Installing mozinstall.exe script to C:\slave\test-pgo\build\venv\Scripts
08:10:38 INFO - Installing moz_add_to_system-script.py script to C:\slave\test-pgo\build\venv\Scripts
08:10:38 INFO - Installing moz_add_to_system.exe script to C:\slave\test-pgo\build\venv\Scripts
08:10:38 INFO - Running setup.py install for mozleak
08:10:38 INFO - Running setup.py install for mozlog
08:10:39 INFO - Installing structlog-script.py script to C:\slave\test-pgo\build\venv\Scripts
08:10:39 INFO - Installing structlog.exe script to C:\slave\test-pgo\build\venv\Scripts
08:10:39 INFO - Running setup.py install for moznetwork
08:10:39 INFO - Installing moznetwork-script.py script to C:\slave\test-pgo\build\venv\Scripts
08:10:39 INFO - Installing moznetwork.exe script to C:\slave\test-pgo\build\venv\Scripts
08:10:40 INFO - Running setup.py install for mozprocess
08:10:40 INFO - Running setup.py install for mozprofile
08:10:40 INFO - Installing mozprofile-script.py script to C:\slave\test-pgo\build\venv\Scripts
08:10:40 INFO - Installing mozprofile.exe script to C:\slave\test-pgo\build\venv\Scripts
08:10:40 INFO - Installing diff-profiles-script.py script to C:\slave\test-pgo\build\venv\Scripts
08:10:40 INFO - Installing diff-profiles.exe script to C:\slave\test-pgo\build\venv\Scripts
08:10:40 INFO - Installing view-profile-script.py script to C:\slave\test-pgo\build\venv\Scripts
08:10:40 INFO - Installing view-profile.exe script to C:\slave\test-pgo\build\venv\Scripts
08:10:41 INFO - Running setup.py install for mozrunner
08:10:41 INFO - Installing mozrunner-script.py script to C:\slave\test-pgo\build\venv\Scripts
08:10:41 INFO - Installing mozrunner.exe script to C:\slave\test-pgo\build\venv\Scripts
08:10:41 INFO - Running setup.py install for mozscreenshot
08:10:42 INFO - Running setup.py install for moztest
08:10:42 INFO - Running setup.py install for mozversion
08:10:42 INFO - Installing mozversion-script.py script to C:\slave\test-pgo\build\venv\Scripts
08:10:42 INFO - Installing mozversion.exe script to C:\slave\test-pgo\build\venv\Scripts
08:10:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion
08:10:42 INFO - Cleaning up...
08:10:42 INFO - Return code: 0
08:10:42 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv
08:10:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
08:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
08:10:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
08:10:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
08:10:42 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test-pgo\\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 0x018FCB10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01955EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0181AE58>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01318B48>, '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 0x0133A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01E5F660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-195', 'USERDOMAIN': 'T-W732-IX-195', '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-195', '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-pgo', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
08:10:42 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test-pgo\\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-pgo\build\tests\config
08:10:42 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --download-cache C:\slave\test-pgo\build/venv\cache --timeout 120 -r C:\slave\test-pgo\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
08:10:42 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
08:10:42 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
08:10:42 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
08:10:42 INFO - 'COMPUTERNAME': 'T-W732-IX-195',
08:10:42 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
08:10:42 INFO - 'CYGWINBASE': 'C:\\cygwin',
08:10:42 INFO - 'DCLOCATION': 'SCL3',
08:10:42 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
08:10:42 INFO - 'FP_NO_HOST_CHECK': 'NO',
08:10:42 INFO - 'HOMEDRIVE': 'C:',
08:10:43 INFO - 'HOMEPATH': '\\Users\\cltbld',
08:10:43 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
08:10:43 INFO - 'KTS_VERSION': '1.19c',
08:10:43 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
08:10:43 INFO - 'LOGONSERVER': '\\\\T-W732-IX-195',
08:10:43 INFO - 'MONDIR': 'C:\\Monitor_config\\',
08:10:43 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
08:10:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
08:10:43 INFO - 'MOZ_NO_REMOTE': '1',
08:10:43 INFO - 'NO_EM_RESTART': '1',
08:10:43 INFO - 'NUMBER_OF_PROCESSORS': '8',
08:10:43 INFO - 'OS': 'Windows_NT',
08:10:43 INFO - 'OURDRIVE': 'C:',
08:10:43 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;',
08:10:43 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
08:10:43 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
08:10:43 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
08:10:43 INFO - 'PROCESSOR_LEVEL': '6',
08:10:43 INFO - 'PROCESSOR_REVISION': '1e05',
08:10:43 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
08:10:43 INFO - 'PROGRAMFILES': 'C:\\Program Files',
08:10:43 INFO - 'PROMPT': '$P$G',
08:10:43 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json',
08:10:43 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
08:10:43 INFO - 'PUBLIC': 'C:\\Users\\Public',
08:10:43 INFO - 'PWD': 'C:\\slave\\test-pgo',
08:10:43 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
08:10:43 INFO - 'SLAVEDIR': 'C:\\slave\\',
08:10:43 INFO - 'SYSTEMDRIVE': 'C:',
08:10:43 INFO - 'SYSTEMROOT': 'C:\\windows',
08:10:43 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
08:10:43 INFO - 'TEST1': 'testie',
08:10:43 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
08:10:43 INFO - 'USERDOMAIN': 'T-W732-IX-195',
08:10:43 INFO - 'USERNAME': 'cltbld',
08:10:43 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
08:10:43 INFO - 'WINDIR': 'C:\\windows',
08:10:43 INFO - 'WINDOWS_TRACING_FLAGS': '3',
08:10:43 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
08:10:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
08:10:43 INFO - Ignoring indexes: https://pypi.python.org/simple/
08:10:43 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\manifestparser
08:10:43 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-4h4zt4-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/manifestparser
08:10:43 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///C:/slave/test-pgo/build/tests/mozbase/manifestparser in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 1))
08:10:43 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozcrash
08:10:43 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-hv4uxi-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozcrash
08:10:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///C:/slave/test-pgo/build/tests/mozbase/mozcrash in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 2))
08:10:43 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdebug
08:10:43 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-w0wmt0-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdebug
08:10:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///C:/slave/test-pgo/build/tests/mozbase/mozdebug in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 3))
08:10:43 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdevice
08:10:43 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-nmokou-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdevice
08:10:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 from file:///C:/slave/test-pgo/build/tests/mozbase/mozdevice in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 4))
08:10:43 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozfile
08:10:43 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-uglymd-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozfile
08:10:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///C:/slave/test-pgo/build/tests/mozbase/mozfile in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 5))
08:10:44 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozhttpd
08:10:44 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-sbd2ce-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozhttpd
08:10:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///C:/slave/test-pgo/build/tests/mozbase/mozhttpd in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 6))
08:10:44 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinfo
08:10:44 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-yetaia-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinfo
08:10:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 from file:///C:/slave/test-pgo/build/tests/mozbase/mozinfo in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 7))
08:10:44 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinstall
08:10:44 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-1vq3_r-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinstall
08:10:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///C:/slave/test-pgo/build/tests/mozbase/mozinstall in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 8))
08:10:44 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozleak
08:10:44 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-0c0rrz-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozleak
08:10:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///C:/slave/test-pgo/build/tests/mozbase/mozleak in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 9))
08:10:44 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozlog
08:10:44 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-wo4ebs-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozlog
08:10:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///C:/slave/test-pgo/build/tests/mozbase/mozlog in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 10))
08:10:44 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moznetwork
08:10:44 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-nibxhk-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moznetwork
08:10:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///C:/slave/test-pgo/build/tests/mozbase/moznetwork in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 11))
08:10:44 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprocess
08:10:44 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-tsqdnp-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprocess
08:10:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///C:/slave/test-pgo/build/tests/mozbase/mozprocess in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 12))
08:10:45 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprofile
08:10:45 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-u7z0tm-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprofile
08:10:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///C:/slave/test-pgo/build/tests/mozbase/mozprofile in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 13))
08:10:45 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozrunner
08:10:45 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-swnxqg-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozrunner
08:10:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///C:/slave/test-pgo/build/tests/mozbase/mozrunner in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 14))
08:10:45 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozscreenshot
08:10:45 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-t72hg3-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozscreenshot
08:10:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///C:/slave/test-pgo/build/tests/mozbase/mozscreenshot in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 15))
08:10:45 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moztest
08:10:45 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-dr9nhh-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moztest
08:10:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///C:/slave/test-pgo/build/tests/mozbase/moztest in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 16))
08:10:45 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozversion
08:10:45 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-vtkyxy-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozversion
08:10:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///C:/slave/test-pgo/build/tests/mozbase/mozversion in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 17))
08:10:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in c:\slave\test-pgo\build\venv\lib\site-packages (from mozcrash==0.16->-r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 2))
08:10:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in c:\slave\test-pgo\build\venv\lib\site-packages (from mozcrash==0.16->-r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 2))
08:10:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in c:\slave\test-pgo\build\venv\lib\site-packages (from mozdebug==0.1->-r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 3))
08:10:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test-pgo\build\venv\lib\site-packages (from mozdevice==0.46->-r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 4))
08:10:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in c:\slave\test-pgo\build\venv\lib\site-packages (from mozdevice==0.46->-r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 4))
08:10:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 10))
08:10:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
08:10:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
08:10:46 INFO - Downloading blessings-1.5.1.tar.gz
08:10:46 INFO - Storing download in cache at c:\slave\test-pgo\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fblessings-1.5.1.tar.gz
08:10:46 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\blessings\setup.py) egg_info for package blessings
08:10:47 INFO - Installing collected packages: blessings
08:10:47 INFO - Running setup.py install for blessings
08:10:47 INFO - Successfully installed blessings
08:10:47 INFO - Cleaning up...
08:10:50 INFO - Return code: 0
08:10:50 INFO - Done creating virtualenv C:\slave\test-pgo\build/venv.
08:10:50 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'freeze']
08:10:50 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip freeze
08:10:50 INFO - Reading from file tmpfile_stdout
08:10:50 INFO - Using _rmtree_windows ...
08:10:50 INFO - Using _rmtree_windows ...
08:10:50 INFO - Current package versions:
08:10:50 INFO - blessings == 1.5.1
08:10:50 INFO - blobuploader == 1.2.4
08:10:50 INFO - docopt == 0.6.1
08:10:50 INFO - manifestparser == 1.1
08:10:50 INFO - mozInstall == 1.12
08:10:50 INFO - mozcrash == 0.16
08:10:50 INFO - mozdebug == 0.1
08:10:50 INFO - mozdevice == 0.46
08:10:50 INFO - mozfile == 1.2
08:10:50 INFO - mozhttpd == 0.7
08:10:50 INFO - mozinfo == 0.8
08:10:50 INFO - mozleak == 0.1
08:10:50 INFO - mozlog == 3.0
08:10:50 INFO - moznetwork == 0.27
08:10:50 INFO - mozprocess == 0.22
08:10:50 INFO - mozprofile == 0.27
08:10:50 INFO - mozrunner == 6.11
08:10:50 INFO - mozscreenshot == 0.1
08:10:50 INFO - mozsystemmonitor == 0.0
08:10:50 INFO - moztest == 0.7
08:10:50 INFO - mozversion == 1.4
08:10:50 INFO - psutil == 3.1.1
08:10:50 INFO - requests == 1.2.3
08:10:50 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv
08:10:50 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
08:10:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
08:10:50 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
08:10:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
08:10:50 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test-pgo\\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 0x018FCB10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01955EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0181AE58>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01318B48>, '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 0x0133A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01E5F660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build\\tests\\talos', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-195', 'USERDOMAIN': 'T-W732-IX-195', '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-195', '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-pgo', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
08:10:50 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test-pgo\\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-pgo\build\tests\talos
08:10:50 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --download-cache C:\slave\test-pgo\build/venv\cache --timeout 120 -r C:\slave\test-pgo\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
08:10:50 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
08:10:50 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
08:10:50 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
08:10:50 INFO - 'COMPUTERNAME': 'T-W732-IX-195',
08:10:50 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
08:10:50 INFO - 'CYGWINBASE': 'C:\\cygwin',
08:10:50 INFO - 'DCLOCATION': 'SCL3',
08:10:50 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
08:10:50 INFO - 'FP_NO_HOST_CHECK': 'NO',
08:10:50 INFO - 'HOMEDRIVE': 'C:',
08:10:50 INFO - 'HOMEPATH': '\\Users\\cltbld',
08:10:50 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
08:10:50 INFO - 'KTS_VERSION': '1.19c',
08:10:50 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
08:10:50 INFO - 'LOGONSERVER': '\\\\T-W732-IX-195',
08:10:50 INFO - 'MONDIR': 'C:\\Monitor_config\\',
08:10:50 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
08:10:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
08:10:50 INFO - 'MOZ_NO_REMOTE': '1',
08:10:50 INFO - 'NO_EM_RESTART': '1',
08:10:50 INFO - 'NUMBER_OF_PROCESSORS': '8',
08:10:50 INFO - 'OS': 'Windows_NT',
08:10:50 INFO - 'OURDRIVE': 'C:',
08:10:50 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;',
08:10:50 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
08:10:50 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
08:10:50 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
08:10:50 INFO - 'PROCESSOR_LEVEL': '6',
08:10:50 INFO - 'PROCESSOR_REVISION': '1e05',
08:10:50 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
08:10:50 INFO - 'PROGRAMFILES': 'C:\\Program Files',
08:10:50 INFO - 'PROMPT': '$P$G',
08:10:50 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json',
08:10:50 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
08:10:50 INFO - 'PUBLIC': 'C:\\Users\\Public',
08:10:50 INFO - 'PWD': 'C:\\slave\\test-pgo',
08:10:50 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
08:10:50 INFO - 'SLAVEDIR': 'C:\\slave\\',
08:10:50 INFO - 'SYSTEMDRIVE': 'C:',
08:10:50 INFO - 'SYSTEMROOT': 'C:\\windows',
08:10:50 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
08:10:50 INFO - 'TEST1': 'testie',
08:10:50 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
08:10:50 INFO - 'USERDOMAIN': 'T-W732-IX-195',
08:10:50 INFO - 'USERNAME': 'cltbld',
08:10:50 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
08:10:50 INFO - 'WINDIR': 'C:\\windows',
08:10:50 INFO - 'WINDOWS_TRACING_FLAGS': '3',
08:10:50 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
08:10:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
08:10:50 INFO - Ignoring indexes: https://pypi.python.org/simple/
08:10:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 1))
08:10:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 2))
08:10:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 3))
08:10:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 4))
08:10:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 5))
08:10:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 6))
08:10:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 7))
08:10:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 8))
08:10:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in c:\slave\test-pgo\build\venv\lib\site-packages (from mozcrash>=0.15->-r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 1))
08:10:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test-pgo\build\venv\lib\site-packages (from mozhttpd>=0.7->-r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 3))
08:10:50 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in c:\slave\test-pgo\build\venv\lib\site-packages (from mozlog>=3.0->mozcrash>=0.15->-r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 1))
08:10:50 INFO - Cleaning up...
08:10:50 INFO - Return code: 0
08:10:50 INFO - Running post-action listener: _resource_record_post_action
08:10:50 INFO - Running post-action listener: _start_resource_monitoring
08:10:50 INFO - Starting resource monitoring.
08:10:50 INFO - #####
08:10:50 INFO - ##### Running install step.
08:10:50 INFO - #####
08:10:50 INFO - Running pre-action listener: _resource_record_pre_action
08:10:50 INFO - Running main action method: install
08:10:50 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'freeze']
08:10:50 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip freeze
08:10:51 INFO - Reading from file tmpfile_stdout
08:10:51 INFO - Using _rmtree_windows ...
08:10:51 INFO - Using _rmtree_windows ...
08:10:51 INFO - Detecting whether we're running mozinstall >=1.0...
08:10:51 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build/venv/scripts/python', 'C:\\slave\\test-pgo\\build/venv/scripts/mozinstall-script.py', '-h']
08:10:51 INFO - Copy/paste: C:\slave\test-pgo\build/venv/scripts/python C:\slave\test-pgo\build/venv/scripts/mozinstall-script.py -h
08:10:51 INFO - Reading from file tmpfile_stdout
08:10:51 INFO - Output received:
08:10:51 INFO - Usage: mozinstall-script.py [options] installer
08:10:51 INFO - Options:
08:10:51 INFO - -h, --help show this help message and exit
08:10:51 INFO - -d DEST, --destination=DEST
08:10:51 INFO - Directory to install application into. [default:
08:10:51 INFO - "C:\slave\test-pgo"]
08:10:51 INFO - --app=APP Application being installed. [default: firefox]
08:10:51 INFO - Using _rmtree_windows ...
08:10:51 INFO - Using _rmtree_windows ...
08:10:51 INFO - mkdir: C:\slave\test-pgo\build\application
08:10:51 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build/venv/scripts/python', 'C:\\slave\\test-pgo\\build/venv/scripts/mozinstall-script.py', 'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win32.zip', '--destination', 'C:\\slave\\test-pgo\\build\\application']
08:10:51 INFO - Copy/paste: C:\slave\test-pgo\build/venv/scripts/python C:\slave\test-pgo\build/venv/scripts/mozinstall-script.py C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.zip --destination C:\slave\test-pgo\build\application
08:10:52 INFO - Reading from file tmpfile_stdout
08:10:52 INFO - Output received:
08:10:52 INFO - C:\slave\test-pgo\build\application\firefox\firefox.exe
08:10:52 INFO - Using _rmtree_windows ...
08:10:52 INFO - Using _rmtree_windows ...
08:10:52 INFO - Running post-action listener: _resource_record_post_action
08:10:52 INFO - #####
08:10:52 INFO - ##### Running run-tests step.
08:10:52 INFO - #####
08:10:52 INFO - Running pre-action listener: _resource_record_pre_action
08:10:52 INFO - Running main action method: run_tests
08:10:52 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\python', '--version']
08:10:52 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\python --version
08:10:52 INFO - Python 2.7.3
08:10:52 INFO - Return code: 0
08:10:52 INFO - grabbing minidump binary from tooltool
08:10:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
08:10:52 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-pgo\\build\\tests\\config/tooltool-manifests/win32/releng.manifest', '-o'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01318B48>, '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 0x0133A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01E5F660>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'privileged': False}, attempt #1
08:10:52 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-pgo\\build\\tests\\config/tooltool-manifests/win32/releng.manifest', '-o'] in C:\slave\test-pgo\build
08:10:52 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-pgo\build\tests\config/tooltool-manifests/win32/releng.manifest -o
08:10:52 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'...
08:10:53 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test-pgo\build\tmpehs8rs
08:10:53 INFO - INFO - File integrity verified, renaming tmpehs8rs to win32-minidump_stackwalk.exe
08:10:53 INFO - Return code: 0
08:10:53 INFO - Chmoding C:\slave\test-pgo\build\win32-minidump_stackwalk.exe to 0755
08:10:53 INFO - mkdir: C:\slave\test-pgo\build\blobber_upload_dir
08:10:53 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test-pgo\build\blobber_upload_dir
08:10:53 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test-pgo\build\win32-minidump_stackwalk.exe
08:10:53 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test-pgo\build\blobber_upload_dir
08:10:53 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\python', 'C:\\slave\\test-pgo\\build\\tests\\talos\\talos\\run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test-pgo\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/8tw4SnSMTiSzxXLLxutVDg/artifacts/public/build/firefox-44.0a1.en-US.win32.crashreporter-symbols.zip', '--title', 'T-W732-IX-195', '--webServer', 'localhost'] in C:\slave\test-pgo\build
08:10:53 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\python C:\slave\test-pgo\build\tests\talos\talos\run_tests.py --debug --branchName Firefox --suite dromaeojs --executablePath C:\slave\test-pgo\build\application\firefox\firefox --symbolsPath https://queue.taskcluster.net/v1/task/8tw4SnSMTiSzxXLLxutVDg/artifacts/public/build/firefox-44.0a1.en-US.win32.crashreporter-symbols.zip --title T-W732-IX-195 --webServer localhost
08:10:53 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
08:10:53 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
08:10:53 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
08:10:53 INFO - 'COMPUTERNAME': 'T-W732-IX-195',
08:10:53 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
08:10:53 INFO - 'CYGWINBASE': 'C:\\cygwin',
08:10:53 INFO - 'DCLOCATION': 'SCL3',
08:10:53 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
08:10:53 INFO - 'FP_NO_HOST_CHECK': 'NO',
08:10:53 INFO - 'HOMEDRIVE': 'C:',
08:10:53 INFO - 'HOMEPATH': '\\Users\\cltbld',
08:10:53 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
08:10:53 INFO - 'KTS_VERSION': '1.19c',
08:10:53 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
08:10:53 INFO - 'LOGONSERVER': '\\\\T-W732-IX-195',
08:10:53 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test-pgo\\build\\blobber_upload_dir',
08:10:53 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test-pgo\\build\\win32-minidump_stackwalk.exe',
08:10:53 INFO - 'MONDIR': 'C:\\Monitor_config\\',
08:10:53 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
08:10:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
08:10:53 INFO - 'MOZ_NO_REMOTE': '1',
08:10:53 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test-pgo\\build\\blobber_upload_dir',
08:10:53 INFO - 'NO_EM_RESTART': '1',
08:10:53 INFO - 'NUMBER_OF_PROCESSORS': '8',
08:10:53 INFO - 'OS': 'Windows_NT',
08:10:53 INFO - 'OURDRIVE': 'C:',
08:10:53 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;',
08:10:53 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
08:10:53 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
08:10:53 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
08:10:53 INFO - 'PROCESSOR_LEVEL': '6',
08:10:53 INFO - 'PROCESSOR_REVISION': '1e05',
08:10:53 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
08:10:53 INFO - 'PROGRAMFILES': 'C:\\Program Files',
08:10:53 INFO - 'PROMPT': '$P$G',
08:10:53 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json',
08:10:53 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
08:10:53 INFO - 'PUBLIC': 'C:\\Users\\Public',
08:10:53 INFO - 'PWD': 'C:\\slave\\test-pgo',
08:10:53 INFO - 'PYTHONPATH': 'C:\\slave\\test-pgo\\build\\tests\\talos',
08:10:53 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
08:10:53 INFO - 'SLAVEDIR': 'C:\\slave\\',
08:10:53 INFO - 'SYSTEMDRIVE': 'C:',
08:10:53 INFO - 'SYSTEMROOT': 'C:\\windows',
08:10:53 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
08:10:53 INFO - 'TEST1': 'testie',
08:10:53 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
08:10:53 INFO - 'USERDOMAIN': 'T-W732-IX-195',
08:10:53 INFO - 'USERNAME': 'cltbld',
08:10:53 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
08:10:53 INFO - 'WINDIR': 'C:\\windows',
08:10:53 INFO - 'WINDOWS_TRACING_FLAGS': '3',
08:10:53 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
08:10:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
08:10:53 INFO - Calling ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\python', 'C:\\slave\\test-pgo\\build\\tests\\talos\\talos\\run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test-pgo\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/8tw4SnSMTiSzxXLLxutVDg/artifacts/public/build/firefox-44.0a1.en-US.win32.crashreporter-symbols.zip', '--title', 'T-W732-IX-195', '--webServer', 'localhost'] with output_timeout 3600
08:10:54 INFO - mozversion INFO | application_buildid: 20151025030428
08:10:54 INFO - mozversion INFO | application_changeset: d53a52b39a95dced722cca90ac74529b66dd5253
08:10:54 INFO - mozversion INFO | application_display_name: Nightly
08:10:54 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384}
08:10:54 INFO - mozversion INFO | application_name: Firefox
08:10:54 INFO - mozversion INFO | application_remotingname: firefox
08:10:54 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central
08:10:54 INFO - mozversion INFO | application_vendor: Mozilla
08:10:54 INFO - mozversion INFO | application_version: 44.0a1
08:10:54 INFO - mozversion INFO | platform_buildid: 20151025030428
08:10:54 INFO - mozversion INFO | platform_changeset: d53a52b39a95dced722cca90ac74529b66dd5253
08:10:54 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central
08:10:54 INFO - mozversion INFO | platform_version: 44.0a1
08:10:54 INFO - 2015-10-25 08:10:54,736 DEBUG : using testdate: 1445785854
08:10:54 INFO - 2015-10-25 08:10:54,736 DEBUG : actual date: 1445785854
08:10:54 INFO - 2015-10-25 08:10:54,815 INFO : starting webserver on 'localhost:50103'
08:10:54 INFO - 2015-10-25 08:10:54,818 INFO : Starting test suite T-W732-IX-195
08:10:54 INFO - 2015-10-25 08:10:54,818 INFO : Starting test dromaeo_css
08:10:54 INFO - 2015-10-25 08:10:54,818 DEBUG : operating with platform_type : w7_
08:10:54 INFO - 2015-10-25 08:10:54,819 INFO : Initialising browser for dromaeo_css test...
08:10:54 INFO - 2015-10-25 08:10:54,954 DEBUG : command line: C:\slave\test-pgo\build\application\firefox\firefox -profile c:\users\cltbld\appdata\local\temp\tmppae3s1\profile http://localhost:50103/getInfo.html
08:11:02 INFO - 2015-10-25 08:11:02,674 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200
08:11:02 INFO - 2015-10-25 08:11:02,674 DEBUG : BROWSER_OUTPUT: colorDepth:24
08:11:02 INFO - 2015-10-25 08:11:02,674 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674
08:11:02 INFO - 2015-10-25 08:11:02,674 DEBUG : BROWSER_OUTPUT: __metrics
08:11:02 INFO - 2015-10-25 08:11:02,753 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver]
08:11:03 INFO - 2015-10-25 08:11:03,469 DEBUG : BROWSER_OUTPUT: console.error:
08:11:03 INFO - 2015-10-25 08:11:03,469 DEBUG : BROWSER_OUTPUT: Message: [Exception... "Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [mozIStorageAsyncStatement.executeAsync]" nsresult: "0x80040111 (NS_ERROR_NOT_AVAILABLE)" location: "JS frame :: resource://gre/modules/Sqlite.jsm :: ConnectionData.prototype<._executeStatement :: line 758" data: no]
08:11:03 INFO - 2015-10-25 08:11:03,469 DEBUG : BROWSER_OUTPUT: Stack:
08:11:03 INFO - 2015-10-25 08:11:03,469 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<._executeStatement@resource://gre/modules/Sqlite.jsm:758:19
08:11:03 INFO - 2015-10-25 08:11:03,469 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached/<@resource://gre/modules/Sqlite.jsm:493:9
08:11:03 INFO - 2015-10-25 08:11:03,469 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached@resource://gre/modules/Sqlite.jsm:491:1
08:11:03 INFO - 2015-10-25 08:11:03,469 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeBeforeShutdown/loggedDb<.executeCached.value<@resource://gre/modules/Sqlite.jsm:368:51
08:11:03 INFO - 2015-10-25 08:11:03,469 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40
08:11:03 INFO - 2015-10-25 08:11:03,469 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3
08:11:03 INFO - 2015-10-25 08:11:03,469 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14
08:11:03 INFO - 2015-10-25 08:11:03,469 DEBUG : BROWSER_OUTPUT: transaction@resource://gre/modules/Bookmarks.jsm:783:15
08:11:03 INFO - 2015-10-25 08:11:03,470 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40
08:11:03 INFO - 2015-10-25 08:11:03,470 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3
08:11:03 INFO - 2015-10-25 08:11:03,470 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14
08:11:03 INFO - 2015-10-25 08:11:03,470 DEBUG : BROWSER_OUTPUT: Task_spawn@resource://gre/modules/Task.jsm:164:12
08:11:03 INFO - 2015-10-25 08:11:03,470 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23
08:30:36 INFO - 2015-10-25 08:30:36,907 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7
08:30:36 INFO - 2015-10-25 08:30:36,907 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11
08:30:36 INFO - 2015-10-25 08:30:36,907 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7
08:30:36 INFO - 2015-10-25 08:30:36,907 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7
08:30:36 INFO - 2015-10-25 08:30:36,907 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13
08:30:36 INFO - 2015-10-25 08:30:36,907 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9
08:30:36 INFO - 2015-10-25 08:30:36,907 DEBUG : BROWSER_OUTPUT:
08:30:37 INFO - 2015-10-25 08:30:37,505 INFO : Browser initialized.
08:30:37 INFO - 2015-10-25 08:30:37,505 INFO : Running cycle 1/1 for v8_7 test...
08:30:37 INFO - 2015-10-25 08:30:37,505 DEBUG : command line: C:\slave\test-pgo\build\application\firefox\firefox -profile c:\users\cltbld\appdata\local\temp\tmpnsf124\profile -tp file:\C:\slave\test-pgo\build\tests\talos\talos\tests\v8_7\v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1
08:30:48 INFO - 2015-10-25 08:30:48,907 DEBUG : BROWSER_OUTPUT: RSS: Main: 127549440
08:30:48 INFO - 2015-10-25 08:30:48,907 DEBUG : BROWSER_OUTPUT:
08:31:10 INFO - 2015-10-25 08:31:10,423 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50103/tests/v8_7/run.html (next: http://localhost:50103/tests/v8_7/run.html)
08:31:10 INFO - 2015-10-25 08:31:10,670 DEBUG : BROWSER_OUTPUT: RSS: Main: 481517568
08:31:10 INFO - 2015-10-25 08:31:10,670 DEBUG : BROWSER_OUTPUT:
08:31:10 INFO - 2015-10-25 08:31:10,670 DEBUG : BROWSER_OUTPUT: __start_tp_report
08:31:10 INFO - 2015-10-25 08:31:10,670 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load
08:31:10 INFO - 2015-10-25 08:31:10,670 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details
08:31:10 INFO - 2015-10-25 08:31:10,670 DEBUG : BROWSER_OUTPUT: |i|pagename|runs|
08:31:10 INFO - 2015-10-25 08:31:10,670 DEBUG : BROWSER_OUTPUT: |0;Richards;155.83606046439147
08:31:10 INFO - 2015-10-25 08:31:10,670 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;202.5111381125962
08:31:10 INFO - 2015-10-25 08:31:10,670 DEBUG : BROWSER_OUTPUT: |2;Encrypt;293.9447383891828
08:31:10 INFO - 2015-10-25 08:31:10,670 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5397.8494623655915
08:31:10 INFO - 2015-10-25 08:31:10,670 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1402.5245441795232
08:31:10 INFO - 2015-10-25 08:31:10,670 DEBUG : BROWSER_OUTPUT: |5;Earley;645.1612903225806
08:31:10 INFO - 2015-10-25 08:31:10,671 DEBUG : BROWSER_OUTPUT: |6;Boyer;10437.5
08:31:10 INFO - 2015-10-25 08:31:10,671 DEBUG : BROWSER_OUTPUT: |7;RegExp;30029.41176470588
08:31:10 INFO - 2015-10-25 08:31:10,671 DEBUG : BROWSER_OUTPUT: |8;Splay;615.7635467980296
08:31:10 INFO - 2015-10-25 08:31:10,671 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;5128.205128205128
08:31:10 INFO - 2015-10-25 08:31:10,671 DEBUG : BROWSER_OUTPUT: __end_tp_report
08:31:10 INFO - 2015-10-25 08:31:10,671 DEBUG : BROWSER_OUTPUT: __startTimestamp1445787070667__endTimestamp
08:31:10 INFO - 2015-10-25 08:31:10,671 DEBUG : BROWSER_OUTPUT:
08:31:10 INFO - 2015-10-25 08:31:10,671 DEBUG : BROWSER_OUTPUT: ------- Summary: start -------
08:31:10 INFO - 2015-10-25 08:31:10,671 DEBUG : BROWSER_OUTPUT: Number of tests: 10
08:31:10 INFO - 2015-10-25 08:31:10,671 DEBUG : BROWSER_OUTPUT:
08:31:10 INFO - 2015-10-25 08:31:10,671 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:155.84 Median:155.84 stddev:0.00 (0.0%)
08:31:10 INFO - 2015-10-25 08:31:10,671 DEBUG : BROWSER_OUTPUT: Values: 155.8
08:31:10 INFO - 2015-10-25 08:31:10,671 DEBUG : BROWSER_OUTPUT:
08:31:10 INFO - 2015-10-25 08:31:10,671 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:202.51 Median:202.51 stddev:0.00 (0.0%)
08:31:10 INFO - 2015-10-25 08:31:10,671 DEBUG : BROWSER_OUTPUT: Values: 202.5
08:31:10 INFO - 2015-10-25 08:31:10,671 DEBUG : BROWSER_OUTPUT:
08:31:10 INFO - 2015-10-25 08:31:10,671 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:293.94 Median:293.94 stddev:0.00 (0.0%)
08:31:10 INFO - 2015-10-25 08:31:10,671 DEBUG : BROWSER_OUTPUT: Values: 293.9
08:31:10 INFO - 2015-10-25 08:31:10,671 DEBUG : BROWSER_OUTPUT:
08:31:10 INFO - 2015-10-25 08:31:10,671 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5397.85 Median:5397.85 stddev:0.00 (0.0%)
08:31:10 INFO - 2015-10-25 08:31:10,671 DEBUG : BROWSER_OUTPUT: Values: 5397.8
08:31:10 INFO - 2015-10-25 08:31:10,671 DEBUG : BROWSER_OUTPUT:
08:31:10 INFO - 2015-10-25 08:31:10,671 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1402.52 Median:1402.52 stddev:0.00 (0.0%)
08:31:10 INFO - 2015-10-25 08:31:10,671 DEBUG : BROWSER_OUTPUT: Values: 1402.5
08:31:10 INFO - 2015-10-25 08:31:10,671 DEBUG : BROWSER_OUTPUT:
08:31:10 INFO - 2015-10-25 08:31:10,671 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:645.16 Median:645.16 stddev:0.00 (0.0%)
08:31:10 INFO - 2015-10-25 08:31:10,671 DEBUG : BROWSER_OUTPUT: Values: 645.2
08:31:10 INFO - 2015-10-25 08:31:10,673 DEBUG : BROWSER_OUTPUT:
08:31:10 INFO - 2015-10-25 08:31:10,673 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10437.50 Median:10437.50 stddev:0.00 (0.0%)
08:31:10 INFO - 2015-10-25 08:31:10,673 DEBUG : BROWSER_OUTPUT: Values: 10437.5
08:31:10 INFO - 2015-10-25 08:31:10,673 DEBUG : BROWSER_OUTPUT:
08:31:10 INFO - 2015-10-25 08:31:10,673 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:30029.41 Median:30029.41 stddev:0.00 (0.0%)
08:31:10 INFO - 2015-10-25 08:31:10,673 DEBUG : BROWSER_OUTPUT: Values: 30029.4
08:31:10 INFO - 2015-10-25 08:31:10,673 DEBUG : BROWSER_OUTPUT:
08:31:10 INFO - 2015-10-25 08:31:10,673 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:615.76 Median:615.76 stddev:0.00 (0.0%)
08:31:10 INFO - 2015-10-25 08:31:10,673 DEBUG : BROWSER_OUTPUT: Values: 615.8
08:31:10 INFO - 2015-10-25 08:31:10,673 DEBUG : BROWSER_OUTPUT:
08:31:10 INFO - 2015-10-25 08:31:10,673 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:5128.21 Median:5128.21 stddev:0.00 (0.0%)
08:31:10 INFO - 2015-10-25 08:31:10,673 DEBUG : BROWSER_OUTPUT: Values: 5128.2
08:31:10 INFO - 2015-10-25 08:31:10,673 DEBUG : BROWSER_OUTPUT: -------- Summary: end --------
08:31:10 INFO - 2015-10-25 08:31:10,673 DEBUG : BROWSER_OUTPUT:
08:31:11 INFO - 2015-10-25 08:31:11,292 INFO : Browser exited with error code: 0
08:31:11 INFO - 2015-10-25 08:31:11,951 INFO : Completed test v8_7 (00:00:40)
08:31:12 INFO - 2015-10-25 08:31:12,072 INFO : Completed test suite (00:20:17)
08:31:12 INFO - 2015-10-25 08:31:12,072 DEBUG : Working with test: dromaeo_css
08:31:12 INFO - 2015-10-25 08:31:12,072 DEBUG : Generating results file: dromaeo_css
08:31:12 INFO - 2015-10-25 08:31:12,072 DEBUG : Working with test: kraken
08:31:12 INFO - 2015-10-25 08:31:12,072 DEBUG : Generating results file: kraken
08:31:12 INFO - 2015-10-25 08:31:12,072 INFO : javascript benchmark
08:31:12 INFO - 2015-10-25 08:31:12,072 DEBUG : Working with test: v8_7
08:31:12 INFO - 2015-10-25 08:31:12,072 DEBUG : Generating results file: v8_7
08:31:12 INFO - 2015-10-25 08:31:12,072 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0
08:31:12 INFO - 2015-10-25 08:31:12,216 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,25]]
08:31:12 INFO - 2015-10-25 08:31:12,216 DEBUG : process_Request line: dromaeo_css 6484.61 graph.html#tests=[[72,1,25]]
08:31:12 INFO - 2015-10-25 08:31:12,216 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0
08:31:12 INFO - 2015-10-25 08:31:12,313 DEBUG : process_Request line: kraken 1589.30 graph.html#tests=[[232,1,25]]
08:31:12 INFO - 2015-10-25 08:31:12,313 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0
08:31:12 INFO - 2015-10-25 08:31:12,414 DEBUG : process_Request line: v8_7 20624.71 graph.html#tests=[[230,1,25]]
08:31:12 INFO - 2015-10-25 08:31:12,415 INFO : javascript benchmark
08:31:12 INFO - 2015-10-25 08:31:12,418 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [318.8294262569525, 325.6157733874029, 327.3061110445855, 333.70300432614977, 337.4516410832398, 12940.676483087927, 16658.0, 17130.657386852272, 17221.397251096216, 18745.250189992385, 16680.249388777505, 16716.331346746145, 16979.745303820422, 17457.12714364283, 17460.912695436506, 5400.594955378352, 5556.555475561945, 5559.8888022239535, 5564.276644036269, 5566.888662226753, 5299.125644268691, 5445.1832225166145, 5513.558915286768, 5515.641483303592, 5521.834344969638, 4479.619232365253, 4577.725336479805, 5444.754986025619, 5470.890582188354, 5474.972625136888, 5755.769769209227, 6052.092186172065, 6089.238845144357, 6110.327863934964, 6113.144159817652, 3876.554196267437, 5348.786048558092, 5376.973115134439, 5391.622586418952, 5406.432324605938, 13160.0, 13226.404811783494, 13440.596782096552, 13461.0, 13506.662333441644, 2041.8264447521979, 2095.612311722321, 2100.117950460795, 2142.7107340508987, 2156.7519735230494, 9206.355555111079, 9421.528923553795, 9463.810723785486, 9564.808703825955, 9747.853782193273, 1520.7718842173651, 1528.9464868729542, 1547.1413365582098, 1577.2113943028485, 1584.5642448326687, 73541.63229183873, 73873.0, 75501.24498754997, 77620.0, 78558.21441785566, 6201.10084037812, 6267.122602835607, 6267.1539342189135, 6366.267879193952, 6443.162388889415, 7267.273272672691, 7322.524035937647, 7328.487005909536, 7340.192578816326, 7361.079865016873, 5136.743162841843, 5194.97402512985, 5228.503292187236, 5261.815836445706, 5318.973405133027, 5662.5753068520025, 5672.943270567242, 5744.4829965303325, 5776.249087618583, 5819.970900145472, 2727.0046433051793, 2778.902738404146, 2807.5507918732906, 2809.410023894964, 2832.9008484702936, 1003.8092762375126, 1017.7838031819415, 1020.6427750287488, 1026.1482969135748, 1048.9318194317498, 393.79325853926343, 408.03092654944504, 417.4031135476237, 448.27379644974695, 450.82192533948904, 10493.895061049292, 11522.884771152349, 11792.823107653392, 11864.22882512634, 11891.405429728478, 443.15136513576783, 458.44986016779995, 471.1472235254201, 477.14352736836764, 481.74467532207984, 5234.528892399702, 6034.064719968412, 6078.325536763809, 6331.303556608861, 6480.773172938924, 445189.0, 445987.0, 446009.2394456343, 447278.0, 447305.0, 86251.0, 87088.69366959501, 87413.56293218493, 88538.0, 88784.0, 483.69527197865824, 485.4102265747134, 488.2456604545985, 495.47974626642605, 501.4884817486144, 11135.220534562503, 11152.944235278772, 11278.0, 11318.94340528292, 11360.886391136313, 41898.0, 42157.0, 42183.578164217965, 42390.0, 42653.0, 55661.721691391285, 59207.703961479914, 59765.70117149386, 59838.0, 59857.70071149617, 6046.848828779316, 6143.54258296667, 6154.907676384947, 6190.81427557174, 6199.0, 11924.642260732191, 12323.568675096329, 12341.568045118378, 12344.963081091519, 12350.0, 10497.790044199226, 10529.684109476728, 10680.465976700978, 10693.465326733476, 10693.572257109628, 9946.801063978824, 10395.220358473296, 10439.37363758177, 10590.8940910593, 10638.042576168182, 10529.26295159362, 10677.359358438518, 10876.45617719095, 10997.230193886671, 11015.83476247873, 6271.153394291895, 6297.4017468340435, 6301.0, 6301.149344838388, 6301.369863013662, 10308.639197628047, 10336.793264134525, 10697.732556686145, 10715.839262411226, 10726.249162558546], "dojo.html": [2755.132133377986, 2791.1486996466097, 2815.197668664431, 2820.633317668704, 2826.4629720353123, 5218.982298451803, 5276.604254680905, 5363.249145119687, 5403.540699040582, 5408.945910540893, 5280.735963201843, 5314.840554783353, 5328.973355133228, 5409.972950135244, 5411.107167317397, 4473.0, 4575.977120114395, 4585.954140458586, 4662.044280922402, 4663.370444989925, 4534.569215924482, 4541.682082254227, 4582.404287442628, 4612.492625811158, 4625.884352891171, 4614.584687378136, 4617.861464156081, 4689.788959496831, 4701.976490117545, 4721.527847215269, 4304.97847510762, 4380.649548036149, 4485.461744590637, 4540.523245059254, 4665.206914824471, 4523.84166554169, 4541.818327266906, 4550.0, 4596.47140578831, 4603.0, 5211.7133557654315, 5229.058769421503, 5289.365276166846, 5294.841154765363, 5307.814226502054, 5417.485338892799, 5531.889362212773, 5585.273914391144, 5605.299337582802, 5629.268195134648, 5474.2609747683955, 5489.917651235235, 5493.725313734337, 5501.504864562168, 5544.0575102232715, 5175.689458632494, 5179.507946745053, 5208.9739551302, 5288.418273989858, 5294.57643388528, 5515.503604675519, 5574.108142697149, 5713.914291285634, 5742.08126699726, 5868.559858010666, 5457.454254574511, 5476.835694929158, 5484.643498172606, 5532.087205611029, 5595.356533998643, 5460.918086228709, 5464.672119672832, 5510.862228444241, 5608.747606357723, 5615.775368985276, 5447.455254474521, 5549.694766787866, 5551.167324901297, 5565.443455654402, 5579.832605021856, 5527.585431092684, 5533.335999680065, 5598.300212473441, 5621.297337832771, 5639.984802735547, 3436.862525499002, 3457.3258214647904, 3521.841517131735, 3528.5412896323314, 3528.647135286451, 3055.312554675225, 3104.192909843457, 3201.599800024997, 3204.5673834032573, 3204.9679503205134, 5249.186376111708, 5263.526282634504, 5345.091334473149, 5351.197320401893, 5352.946470535323, 5589.832305030855, 5594.384617692051, 5599.132134519156, 5612.719364031782, 5689.2319536862, 5021.748912554358, 5168.3797944246935, 5190.039842629126, 5232.241325007929, 5423.29497165366, 4248.468941382327, 4444.622207112367, 4452.799624016927, 4453.22068637987, 4458.621017213508, 5704.4295570443455, 5767.625104368202, 5883.323417807007, 5974.522038236931, 5990.820275391745, 5486.753096110605, 5565.998120338378, 5592.217089607377, 5607.80372686954, 5742.052561327501, 5900.380460051804, 5900.881982360243, 5916.142159386951, 5965.970170149121, 6014.0678194879865, 5511.090670039559, 5534.529564987021, 5632.098864181711, 5636.830895073154, 5667.943320566907, 5511.476409741068, 5610.607257491936, 5648.096304591246, 5660.660360378391, 5669.262995810518, 5533.114701647878, 5547.1679248111495, 5554.888902221852, 5621.297337832771, 5627.0, 5453.0, 5479.726013699379, 5587.3015873015875, 5595.132754423071, 5601.663900166003, 5226.686398816083, 5317.7341132943975, 5333.893322133458, 5352.625316227826, 5459.945400545944, 5467.9453205467435, 5554.111342185231, 5557.055300598827, 5613.663180209201, 5661.915071273852, 5302.39022512416, 5379.596530260168, 5511.614187007031, 5526.0, 5530.198121272312], "mootools.html": [1206.1737709668882, 1323.8014297855318, 1376.4356613788348, 1442.6826098258382, 1573.8347473515273, 7827.099883513398, 8671.262942649875, 8762.0, 8859.379843410963, 8885.689000884962, 8503.343562268223, 8547.615357308921, 8594.828103437927, 8648.091950345217, 8673.30613550916, 1965.3023176772253, 1977.3573588583695, 2156.212982261471, 2187.628103222456, 2198.7251593550805, 2231.475603233247, 2232.687423760675, 2234.1733558583346, 2241.2491815241915, 2242.0807468937737, 2189.485470914342, 2225.810806081485, 2232.810211132056, 2234.955300893981, 2235.3740952533317, 1986.2650819196917, 2017.767956684978, 2130.1160018592263, 2180.2151225558787, 2218.9778102218934, 2209.7348318201757, 2221.3447033125267, 2236.1279101150562, 2244.236959433784, 2244.2369594338, 8772.12278772124, 8780.956095219546, 8784.0, 8818.11818818113, 8857.247133993618, 5035.0685123252315, 5056.342675452204, 5085.262636917626, 5101.668391554537, 5105.106606343912, 3434.1929646533044, 3490.267043920754, 3498.807565583892, 3500.824958752052, 3518.313928783888, 1023.6519583341625, 1034.875814902209, 1052.3265110329319, 1071.8499410082595, 1079.3685693869097, 12760.936195318964, 12773.872261277362, 12788.296643684595, 12798.48806047757, 12808.295543745091, 4486.68593198473, 4568.908621827545, 4576.336431217454, 4592.334111553806, 4630.097131059411, 10430.634927777492, 10433.426161561187, 10448.268621196596, 10459.633912813015, 10466.633667821741, 4973.50264973507, 4979.0788704089855, 5006.274090256965, 5014.423341315723, 5017.322661440732, 4442.68901176921, 4519.322101684708, 4519.480259770103, 4563.612092972068, 4569.086182763461, 3591.892243232707, 3596.946045809315, 3603.801790901473, 3673.3020726061964, 3674.7243956703355, 1128.6726849213635, 1153.5270539078938, 1154.2093665838759, 1161.1175506615034, 1161.6456980620824, 843.6836186430089, 1142.2289954280827, 1146.564305563897, 1168.462507246659, 1168.655246702225, 7101.360877520945, 7140.178879428932, 7712.768616941501, 8234.629441675139, 8245.628946697412, 591.6686655472948, 603.6589327030214, 615.8306465721872, 645.7287939065603, 648.8021153548119, 5912.852178695567, 5945.554083443759, 5948.315943666447, 5963.105534169822, 5980.491658209014, 10355.94822025885, 10837.078848297826, 10864.185186111074, 11045.944770276097, 11060.778784424267, 10798.190135739695, 10801.243912926177, 10958.671239862657, 10966.342019478856, 10999.670009899715, 7857.921420785833, 7968.362530997506, 7972.202779722097, 7983.281504664608, 7985.760427187193, 7140.7143714252925, 7152.749653762094, 7310.561366318038, 7368.521046131984, 7384.076990376203, 9252.0, 9479.28905332089, 9529.999350068143, 9594.232461403211, 9645.517724113626, 9653.420794752337, 9771.951140244253, 9781.119699227103, 9897.0, 9903.306768526134, 7503.699852005859, 7526.5860377679755, 7576.24237576238, 7582.128055273714, 7587.810304742426, 8390.958045209734, 8478.152184781473, 8478.915210847812, 8506.234438900528, 8550.700725474579, 7862.253085956825, 7889.447738658469, 7989.360851132012, 8034.437589368922, 8060.879086813819, 6816.556923799937, 6865.794026179223, 7782.49413788102, 7825.686972521263, 7862.371010319046, 7451.813704657427, 7512.5492470451945, 7519.624018798929, 7531.096268447822, 7560.773176804704, 6640.269570347355, 6642.6014439133805, 6654.334566543307, 6658.467322614276, 6669.899951500634, 6751.29111443311, 6759.594424334556, 6771.3905748482875, 6773.085633439423, 6792.218894827158], "ext.html": [463.6800607580769, 487.8512053823582, 492.9162042452783, 518.9750243269543, 527.7809708970777, 30886.845565772168, 31818.36363272736, 31956.36087278256, 36961.44557831635, 37724.43413348802, 39779.60220397795, 39918.20163596726, 39965.80017099911, 40103.39844902329, 40125.598744012554, 7743.9158517807555, 8042.7185048523315, 8118.553479558622, 8170.918290817075, 8201.466904651208, 7734.458587898849, 9944.900550994469, 10149.543270552806, 10168.33905796121, 10174.643887463903, 9894.90105098947, 9917.454540000297, 9958.20334373252, 9968.750781230454, 9986.950065249664, 7802.882956755681, 7950.403719720986, 9899.703008909744, 9956.900430995669, 10008.549615267331, 9726.36778609388, 9822.0, 9839.212862970946, 9842.50787460624, 9857.063578960058, 36053.639463605294, 36185.457218141746, 36205.81897090524, 36270.662861084464, 36316.636833631586, 3048.588440560518, 3092.0, 3118.844057797101, 3126.390353880994, 3212.550242965963, 28985.0, 29018.984335548153, 29124.27189320263, 29760.404791904257, 29894.85052574723, 2732.4065813018146, 2775.2368098772795, 2790.8744106515255, 2821.478026565092, 2827.6606807183066, 311362.0, 317240.0, 320899.0, 321157.0, 321380.0, 44551.0, 51235.0, 51248.48751512512, 51423.0, 51482.22776658353, 43852.0, 55981.160282595796, 56796.716016419654, 56800.43199568034, 57017.14474282889, 13168.60494185176, 13857.0, 13995.23026233567, 13999.090059146123, 14017.299135043208, 10037.548310326052, 10643.0, 10663.626773062906, 10671.35971841692, 10691.144708423308, 15827.366905323657, 16133.919330403272, 16620.833791661928, 16725.247363868653, 16733.58166045834, 7413.777586672409, 7481.381516469192, 7549.471536992358, 7630.8092297693, 7660.080790305087, 891.9296843787481, 910.535626830308, 920.1074957291416, 920.3465539467053, 969.8254314223508, 27928.860355698092, 28326.15021549357, 28364.71635283662, 28596.571051434246, 28638.420197475316, 972.7811242470387, 981.1807141037314, 1041.2971244410144, 1090.487470888681, 1113.2708076210095, 14671.633209169857, 14797.778033329509, 14849.98575576893, 14850.926512512015, 14891.180985045927, 393262.0, 394153.0, 394181.0, 394524.0, 396278.0, 46558.301625475644, 46757.532424676, 47626.5237347629, 47901.28148077782, 47933.52066479361, 1198.233130796291, 1201.285235285004, 1202.89652696044, 1204.0969273045216, 1209.667341481082, 27586.0, 27777.0, 27912.44175116527, 28364.0, 28497.0, 41785.046635543076, 42517.57482425136, 42772.35841462318, 43114.56885431105, 43167.99999999874, 374609.0, 383625.0, 385010.0, 385263.0, 388760.0, 23872.0, 24221.51556968886, 26939.730602693722, 27456.588151177348, 27642.585361219197, 37586.436203456426, 38137.0, 38923.80538097292, 39325.80337098296, 39358.803205983786, 30463.0, 31985.051113463403, 32490.35019299648, 33228.0, 33475.0, 33759.0, 34051.829740851135, 34232.14419639529, 34679.0, 34687.306253875286, 34478.82760586181, 34818.30363392769, 34952.300953980266, 34956.0, 35041.474377883846, 23289.44432046405, 29736.702632973393, 32239.516407253443, 32276.35447291088, 33095.0, 23955.760442395353, 24146.275611731675, 24262.575783217464, 24319.0, 24455.266342009767], "prototype.html": [314.42774151045097, 314.49680511182095, 319.1049107254151, 320.4312345586582, 323.6084337951079, 5789.39211382805, 5794.971025144879, 5798.942010579893, 5811.12833075039, 5832.737526811293, 5607.467290607396, 5672.517835983936, 5703.4011428799895, 5743.0, 5778.0, 4226.281532139536, 4254.383114448403, 4258.105797782469, 4266.829326826939, 4270.060586670943, 4146.543880173179, 4242.300020496615, 4253.851115210969, 4264.978675106636, 4272.508661503935, 4144.171165766844, 4211.452511173543, 4228.682848786338, 4243.172581346638, 4247.447831781864, 4225.514065882432, 4226.535081141072, 4227.725197862129, 4231.788410579458, 4233.1322078973735, 3719.3491139050557, 3719.9442008369897, 3725.0873535983587, 3727.4408838674144, 3727.720420968411, 5316.494932981361, 5444.237806707064, 5520.530754885799, 5625.718714064321, 5628.352739434936, 4994.525520075587, 5005.399352077774, 5008.62435317349, 5020.0, 5027.09512287788, 5787.189793428924, 5982.641041537521, 6026.397360263983, 6039.78860739872, 6039.909401358983, 4173.749575025508, 4204.0, 4207.0, 4213.599708027732, 4223.873283801491, 6310.6213627182515, 6336.809895703136, 6342.587731797418, 6352.841178970517, 6358.268799088118, 4059.715819892638, 4154.335306351029, 4327.415798867176, 4328.329108988049, 4333.0, 4157.97921010393, 4274.380214868889, 4408.382826404306, 4409.40473036136, 4410.779461026936, 4849.151398505247, 5050.747462626854, 5053.519915608012, 5058.241263810458, 5061.848144555669, 5939.940600594025, 6030.909536356959, 6044.969775151184, 6074.392560743979, 6075.422834830772, 1559.6178936160486, 1570.4738912464225, 1577.290219401274, 1577.4321244352025, 1590.4194968836523, 952.0336858089045, 1050.3382868792612, 1055.3298655353751, 1061.135174832509, 1076.5962763963514, 5845.795397161079, 5858.50202732764, 5892.764289428461, 5898.056310990221, 5900.43945825146, 6231.844203894848, 6252.0, 6259.436650701367, 6265.310815810257, 6268.780592679325, 5768.74040668171, 5856.590038697335, 5882.382349853289, 5882.588218824641, 5886.499647529922, 3346.347462244839, 3353.782004169721, 3371.7471189660873, 3397.21863971288, 3399.813010284409, 6168.907466388007, 6456.257530383972, 6513.967430162819, 6521.47828173745, 6569.37590928861, 6219.595726277777, 6319.115323854664, 6319.6208227506495, 6320.115183874262, 6321.051842223703, 6536.901946470807, 6538.673066346663, 6553.541252112402, 6560.704768285439, 6564.409203171642, 6115.0, 6126.356732543197, 6295.653739044214, 6300.71646775887, 6303.180586523723, 5902.881942361215, 6177.9691101546005, 6179.104029915727, 6190.442860142609, 6195.504359651127, 6550.181227346582, 6599.274079851309, 6624.966875165594, 6630.403263706289, 6631.668416579055, 4278.358246262961, 4313.051128751669, 4319.416878721332, 4327.891802704958, 4332.111917057059, 6166.352532984151, 6266.091416744638, 6286.497080233479, 6288.779892703734, 6310.7791227306825, 5835.620684655484, 6104.17593624855, 6108.389161083856, 6112.2970858351855, 6123.08153776937, 5757.366689664217, 5972.850678733066, 6064.545159112996, 6069.332373439007, 6074.11702372266, 5484.725763711878, 5823.679697616672, 5935.525157987437, 5937.673427961504, 5939.851503712442, 6153.4154255345675, 6162.476189523762, 6170.5372097092, 6176.69116544162, 6189.442950134509, 6021.217241758543, 6024.759009639565, 6043.7884674036195, 6044.879102417839, 6048.243969503812], "yui.html": [711.651290867475, 723.1647447198484, 732.7105793211681, 739.323518980133, 765.5253742679539, 11842.230255033417, 12052.758944821098, 12091.03271738261, 12229.0, 12802.743945121116, 11206.495707693153, 11809.881901180986, 11912.702182445442, 12009.219400738946, 12016.218945768518, 505.646047766563, 509.9949000510003, 589.7640943622564, 593.4540222994833, 599.7780821096201, 584.2142318581501, 592.919955805965, 593.8396632909112, 596.3142386255797, 601.5458328961628, 618.4773866083175, 623.2178615837119, 625.3590070178059, 627.4290395739878, 627.8838414893237, 522.4096770649161, 527.8020742221667, 621.5617989317543, 624.9812505624839, 626.3986572890032, 453.16843592008706, 453.5532500487018, 454.4955099839176, 455.3102050393656, 455.7607256190493, 11136.164787640959, 11181.888181118165, 11266.66200014001, 11370.545178192946, 11469.713257168638, 10766.192535559787, 11003.559857605685, 11051.856568631414, 11365.829512557319, 11369.545218191262, 10239.948800256025, 10426.947865260625, 10502.9474852626, 10601.469926503643, 10662.893371066268, 3092.1496588438135, 3117.953230701541, 3158.478850989584, 3224.0972527692284, 3299.983500082484, 42367.576324236674, 42422.57577424217, 42970.57029429697, 43094.0, 43401.0, 6620.488807105276, 6764.425023872927, 6773.356531129535, 6776.525643205027, 7142.821429464305, 10321.74195645115, 10327.0, 10371.688849334381, 10382.221333400024, 10399.48002599882, 6244.1570387997035, 6286.339934306832, 6382.234131904202, 6403.615783053032, 6450.41946224842, 3908.6482216600643, 4068.2270368629866, 4084.244414783275, 4091.734037287567, 4178.477690288714, 2504.1110405805675, 2550.2094350751327, 2564.1153801938303, 2569.614557816305, 2571.5756900111273, 426.2157629960887, 437.90803931174173, 439.71198864743644, 440.7047278323531, 441.2300535565459, 610.4993904997859, 628.7799270255374, 631.3560168627973, 685.9142607174103, 688.5627626457235, 8959.686410975584, 9094.681686140953, 9104.271658267322, 9140.634374625073, 9298.90701092994, 661.206552137437, 695.0026711668771, 698.7100353353403, 711.7615598774365, 712.5190496414899, 4206.663466922639, 4355.216061108968, 4356.847510337123, 4419.292913133948, 4569.680122391467, 56331.43668563344, 59093.113603295984, 59199.704001480575, 59470.0, 59569.40430595725, 50018.0, 50524.74737626289, 51441.485585144415, 52307.0, 52442.73778631083, 42012.36981445281, 42710.78644606757, 42720.572794272906, 42847.35728964068, 43214.0, 8747.781305467413, 8805.691800787197, 8818.0, 8916.73249802507, 9174.220191283815, 29462.0, 29503.85248073746, 30082.3983520324, 30283.848580756956, 30321.24196895095, 41691.7915410421, 41807.1638567233, 42390.0, 43599.34600981051, 44255.33616995812, 7844.333231675371, 8028.3577313813585, 8131.227533384319, 8166.591670416574, 8347.457415267989, 11570.363630000431, 12071.275723456622, 12104.515819367127, 12256.816147757969, 12532.937335313265, 11314.321140731583, 11424.200305978502, 11513.481893314653, 11583.942080289882, 11983.520659173535, 11082.16883733707, 11214.55141794319, 11297.26567773092, 11307.14950874213, 11643.243189192675, 11443.0, 11556.42217889119, 11566.190366674253, 11658.76682466329, 12510.249385036926, 9787.265955053543, 10491.422971736627, 10499.0, 10528.263021588415, 10555.841662374916, 9388.389754665925, 9538.85691714611, 10207.129407181328, 10243.282970192313, 10274.0]}, "summary": {"suite": 6484.612126933476, "subtests": {"jquery.html": {"filtered": 6981.654951811503, "value": 6981.654951811503}, "dojo.html": {"filtered": 5055.681296533187, "value": 5055.681296533187}, "mootools.html": {"filtered": 4666.141869936451, "value": 4666.141869936451}, "ext.html": {"filtered": 17668.705622639027, "value": 17668.705622639027}, "prototype.html": {"filtered": 4559.0391383423985, "value": 4559.0391383423985}, "yui.html": {"filtered": 5603.937586904687, "value": 5603.937586904687}}}, "test_machine": {"platform": "x86", "osversion": "6.1.7601", "os": "win", "name": "T-W732-IX-195"}, "testrun": {"date": 1445785854, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a1", "id": "20151025030428", "branch": "Firefox", "revision": "d53a52b39a95dced722cca90ac74529b66dd5253"}}, {"talos_counters": {}, "results": {"audio-dft": [152.0, 153.0, 154.0, 152.0, 159.0, 152.0, 161.0, 161.0, 159.0, 162.0], "ai-astar": [95.0, 86.0, 95.0, 96.0, 92.0, 97.0, 96.0, 95.0, 96.0, 102.0], "imaging-gaussian-blur": [116.0, 120.0, 118.0, 116.0, 120.0, 119.0, 120.0, 119.0, 119.0, 129.0], "audio-beat-detection": [130.0, 130.0, 143.0, 150.0, 130.0, 132.0, 143.0, 136.0, 153.0, 128.0], "json-stringify-tinderbox": [78.0, 76.0, 76.0, 76.0, 78.0, 78.0, 78.0, 75.0, 76.0, 76.0], "stanford-crypto-pbkdf2": [185.0, 195.0, 200.0, 195.0, 199.0, 185.0, 197.0, 192.0, 195.0, 189.0], "json-parse-financial": [80.0, 84.0, 83.0, 83.0, 83.0, 81.0, 82.0, 80.0, 80.0, 94.0], "stanford-crypto-sha256-iterative": [86.0, 87.0, 85.0, 87.0, 89.0, 85.0, 87.0, 85.0, 86.0, 85.0], "audio-fft": [77.0, 76.0, 80.0, 112.0, 93.0, 90.0, 78.0, 77.0, 97.0, 78.0], "imaging-darkroom": [139.0, 140.0, 141.0, 141.0, 139.0, 139.0, 139.0, 140.0, 139.0, 144.0], "stanford-crypto-ccm": [120.0, 119.0, 125.0, 119.0, 128.0, 123.0, 120.0, 121.0, 127.0, 126.0], "audio-oscillator": [96.0, 96.0, 111.0, 95.0, 97.0, 96.0, 117.0, 96.0, 95.0, 117.0], "stanford-crypto-aes": [97.0, 100.0, 99.0, 97.0, 98.0, 99.0, 99.0, 102.0, 97.0, 103.0], "imaging-desaturate": [92.0, 91.0, 91.0, 91.0, 91.0, 92.0, 94.0, 95.0, 92.0, 93.0]}, "summary": {"suite": 1589.3, "subtests": {"audio-fft": {"filtered": 85.8, "value": 85.8}, "stanford-crypto-pbkdf2": {"filtered": 193.2, "value": 193.2}, "audio-beat-detection": {"filtered": 137.5, "value": 137.5}, "stanford-crypto-ccm": {"filtered": 122.8, "value": 122.8}, "imaging-darkroom": {"filtered": 140.1, "value": 140.1}, "json-parse-financial": {"filtered": 83.0, "value": 83.0}, "audio-oscillator": {"filtered": 101.6, "value": 101.6}, "ai-astar": {"filtered": 95.0, "value": 95.0}, "audio-dft": {"filtered": 156.5, "value": 156.5}, "stanford-crypto-sha256-iterative": {"filtered": 86.2, "value": 86.2}, "json-stringify-tinderbox": {"filtered": 76.7, "value": 76.7}, "imaging-gaussian-blur": {"filtered": 119.6, "value": 119.6}, "stanford-crypto-aes": {"filtered": 99.1, "value": 99.1}, "imaging-desaturate": {"filtered": 92.2, "value": 92.2}}}, "test_machine": {"platform": "x86", "osversion": "6.1.7601", "os": "win", "name": "T-W732-IX-195"}, "testrun": {"date": 1445785854, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a1", "id": "20151025030428", "branch": "Firefox", "revision": "d53a52b39a95dced722cca90ac74529b66dd5253"}}, {"talos_counters": {}, "results": {"DeltaBlue": [202.5111381125962], "Encrypt": [293.9447383891828], "NavierStokes": [5128.205128205128], "Decrypt": [5397.8494623655915], "Splay": [615.7635467980296], "Richards": [155.83606046439147], "RegExp": [30029.41176470588], "Earley": [645.1612903225806], "Boyer": [10437.5], "RayTrace": [1402.5245441795232]}, "summary": {"suite": 20624.70530048459, "subtests": {"DeltaBlue": {"filtered": 326.4906839999999, "value": 326.4906839999999}, "Encrypt": {"filtered": 905.5477619999999, "value": 905.5477619999999}, "NavierStokes": {"filtered": 289.3799999999998, "value": 289.3799999999998}, "Decrypt": {"filtered": 49.31241633466134, "value": 49.31241633466134}, "Splay": {"filtered": 132.34138400000003, "value": 132.34138400000003}, "RegExp": {"filtered": 30.336425073457388, "value": 30.336425073457388}, "Richards": {"filtered": 226.53293399999995, "value": 226.53293399999995}, "Earley": {"filtered": 1033.0176500000005, "value": 1033.0176500000005}, "Boyer": {"filtered": 63.85274251497008, "value": 63.85274251497008}, "RayTrace": {"filtered": 527.6121569999998, "value": 527.6121569999998}}}, "test_machine": {"platform": "x86", "osversion": "6.1.7601", "os": "win", "name": "T-W732-IX-195"}, "testrun": {"date": 1445785854, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a1", "id": "20151025030428", "branch": "Firefox", "revision": "d53a52b39a95dced722cca90ac74529b66dd5253"}}]
08:31:12 INFO - RETURN: dromaeo_css: 6484.61
08:31:12 INFO - RETURN: kraken: 1589.30
08:31:12 INFO - RETURN: v8_7: 20624.71
08:31:12 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,25]]", "result": "20624.71"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,25]]", "result": "1589.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,25]]", "result": "6484.61"}}}
08:31:12 INFO - Return code: 0
08:31:12 INFO - # TBPL SUCCESS #
08:31:12 INFO - Running post-action listener: _resource_record_post_action
08:31:12 INFO - Running post-run listener: _resource_record_post_run
08:31:13 INFO - Total resource usage - Wall time: 1220s; CPU: 13.0%; Read bytes: 71890944; Write bytes: 414980608; Read time: 882220; Write time: 4057470
08:31:13 INFO - install - Wall time: 2s; CPU: 14.0%; Read bytes: 0; Write bytes: 613888; Read time: 0; Write time: 3180
08:31:13 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 71890944; Write bytes: 391937024; Read time: 882220; Write time: 4038390
08:31:13 INFO - Running post-run listener: _upload_blobber_files
08:31:13 INFO - Blob upload gear active.
08:31:13 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ...
08:31:13 INFO - Copying logs to upload dir...
08:31:13 INFO - mkdir: C:\slave\test-pgo\build\upload\logs
program finished with exit code 0
elapsedTime=1394.718000
========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 14 secs) (at 2015-10-25 08:31:13.660038) =========
========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-25 08:31:13.664021) =========
'cmd' '/C' 'for' '%f' 'in' '(*)' 'do' '@type' '%f'
in dir C:\\slave\test-pgo\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-195
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-195
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-pgo\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-195
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
build_url:https://queue.taskcluster.net/v1/task/8tw4SnSMTiSzxXLLxutVDg/artifacts/public/build/firefox-44.0a1.en-US.win32.zip
program finished with exit code 0
elapsedTime=0.101000
build_url: 'https://queue.taskcluster.net/v1/task/8tw4SnSMTiSzxXLLxutVDg/artifacts/public/build/firefox-44.0a1.en-US.win32.zip'
========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-25 08:31:13.788768) =========
========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-25 08:31:13.789172) =========
'rm' '-f' 'oauth.txt'
in dir C:\\slave\test-pgo\. (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-195
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-195
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-pgo
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-195
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
========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-25 08:31:13.904765) =========
========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2015-10-25 08:31:13.905104) =========
========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2015-10-25 08:31:14.361676) =========