builder: mozilla-beta_win7-ix_test-dromaeojs-pgo
slave: t-w732-ix-157
starttime: 1455872558.26
results: success (0)
buildid: 20160218134825
builduid: be9334a6f66b4e22a3c9762b5a61bcef
revision: 32608d640a8c
========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-19 01:02:38.256772) =========
master: http://buildbot-master119.bb.releng.scl3.mozilla.com:8201/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-19 01:02:38.257467) =========
========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-19 01:02:38.257870) =========
'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-157
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-157
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-157
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.586000
basedir: 'C:\\slave\\test-pgo'
========= master_lag: 0.03 =========
========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-19 01:02:38.875970) =========
========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-19 01:02:38.876287) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-19 01:02:39.044502) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 01:02:39.044904) =========
'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-157
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-157
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-157
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.701000
========= master_lag: 0.02 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 01:02:39.762436) =========
========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-19 01:02:39.762751) =========
script_repo_url: https://hg.mozilla.org/build/mozharness
========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-19 01:02:39.763117) =========
========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 01:02:39.763395) =========
'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-157
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-157
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-157
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
--01:02:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py
=> `archiver_client.py'
Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102
Connecting to hg.mozilla.org|63.245.215.25|:443... connected.
HTTP request sent, awaiting response... 200 Script output follows
Length: 12,141 (12K) [text/x-python]
0K .......... . 100% 27.95 MB/s
01:02:40 (27.95 MB/s) - `archiver_client.py' saved [12141/12141]
program finished with exit code 0
elapsedTime=0.590000
========= master_lag: 0.02 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 01:02:40.375678) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 1 mins, 5 secs) (at 2016-02-19 01:02:40.375992) =========
'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-157
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-157
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-157
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=13.901000
========= master_lag: 52.07 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 1 mins, 5 secs) (at 2016-02-19 01:03:46.351933) =========
========= Started 'bash -c ...' (results: 0, elapsed: 15 secs) (at 2016-02-19 01:03:46.352246) =========
'bash' '-c' u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 32608d640a8c --destination scripts --debug'
in dir C:\slave\test-pgo\. (timeout 1200 secs)
watching logfiles {}
argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 32608d640a8c --destination scripts --debug']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld\AppData\Roaming
COMMONPROGRAMFILES=C:\Program Files\Common Files
COMPUTERNAME=T-W732-IX-157
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-157
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-157
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld
WINDIR=C:\windows
WINDOWS_TRACING_FLAGS=3
WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log
XPCOM_DEBUG_BREAK=warn
using PTY: False
2016-02-19 01:03:46,697 Setting DEBUG logging.
2016-02-19 01:03:46,697 attempt 1/10
2016-02-19 01:03:46,697 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/32608d640a8c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2016-02-19 01:03:47,256 unpacking tar archive at: mozilla-beta-32608d640a8c/testing/mozharness/
program finished with exit code 0
elapsedTime=1.314000
========= master_lag: 14.53 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 15 secs) (at 2016-02-19 01:04:02.201197) =========
========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-19 01:04:02.201491) =========
'echo' u'32608d640a8c'
in dir C:\slave\test-pgo\. (timeout 1200 secs)
watching logfiles {}
argv: ['echo', u'32608d640a8c']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld\AppData\Roaming
COMMONPROGRAMFILES=C:\Program Files\Common Files
COMPUTERNAME=T-W732-IX-157
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-157
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-157
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
32608d640a8c
program finished with exit code 0
elapsedTime=0.101000
script_repo_revision: '32608d640a8c'
========= master_lag: 0.82 =========
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-19 01:04:03.121717) =========
========= Started downloading to oauth.txt (results: 0, elapsed: 22 secs) (at 2016-02-19 01:04:03.121992) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 22 secs) (at 2016-02-19 01:04:25.843865) =========
========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 26 mins, 6 secs) (at 2016-02-19 01:04:25.844148) =========
'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'dromaeojs' '--add-option' '--webServer,localhost' '--branch-name' 'Mozilla-Beta' '--cfg' 'talos/windows_config.py' '--download-symbols' 'ondemand' '--use-talos-json' '--blob-upload-branch' 'Mozilla-Beta'
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', 'Mozilla-Beta', '--cfg', 'talos/windows_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld\AppData\Roaming
COMMONPROGRAMFILES=C:\Program Files\Common Files
COMPUTERNAME=T-W732-IX-157
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-157
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-157
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
01:04:26 INFO - MultiFileLogger online at 20160219 01:04:26 in C:\slave\test-pgo
01:04:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta
01:04:26 INFO - Dumping config to C:\slave\test-pgo\logs\localconfig.json.
01:04:26 INFO - {'append_to_log': False,
01:04:26 INFO - 'base_work_dir': 'C:\\slave\\test-pgo',
01:04:26 INFO - 'blob_upload_branch': 'Mozilla-Beta',
01:04:26 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test-pgo\\oauth.txt',
01:04:26 INFO - 'branch': 'Mozilla-Beta',
01:04:26 INFO - 'buildbot_json_path': 'buildprops.json',
01:04:26 INFO - 'config_files': ('talos/windows_config.py',),
01:04:26 INFO - 'default_actions': ('clobber',
01:04:26 INFO - 'read-buildbot-config',
01:04:26 INFO - 'download-and-extract',
01:04:26 INFO - 'populate-webroot',
01:04:26 INFO - 'create-virtualenv',
01:04:26 INFO - 'install',
01:04:26 INFO - 'run-tests'),
01:04:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',),
01:04:26 INFO - 'download_minidump_stackwalk': True,
01:04:26 INFO - 'download_symbols': 'ondemand',
01:04:26 INFO - 'exes': {'easy_install': ('C:\\slave\\test-pgo\\build/venv/scripts/python',
01:04:26 INFO - 'C:\\slave\\test-pgo\\build/venv/scripts/easy_install-2.7-script.py'),
01:04:26 INFO - 'hg': 'c:/mozilla-build/hg/hg',
01:04:26 INFO - 'mozinstall': ('C:\\slave\\test-pgo\\build/venv/scripts/python',
01:04:26 INFO - 'C:\\slave\\test-pgo\\build/venv/scripts/mozinstall-script.py'),
01:04:26 INFO - 'python': 'c:/mozilla-build/python27/python.exe',
01:04:26 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe',
01:04:26 INFO - 'C:/mozilla-build/tooltool.py'),
01:04:26 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe',
01:04:26 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')},
01:04:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub',
01:04:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'),
01:04:26 INFO - 'installer_path': 'installer.exe',
01:04:26 INFO - 'log_level': 'info',
01:04:26 INFO - 'log_name': 'talos',
01:04:26 INFO - 'log_to_console': True,
01:04:26 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe',
01:04:26 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe',
01:04:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest',
01:04:26 INFO - 'opt_config_files': (),
01:04:26 INFO - 'pip_index': False,
01:04:26 INFO - 'sps_profile': False,
01:04:26 INFO - 'sps_profile_interval': 0,
01:04:26 INFO - 'suite': 'dromaeojs',
01:04:26 INFO - 'system_bits': '32',
01:04:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'),
01:04:26 INFO - 'title': 'T-W732-IX-157',
01:04:26 INFO - 'use_talos_json': True,
01:04:26 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'),
01:04:26 INFO - 'virtualenv_path': 'C:\\slave\\test-pgo\\build/venv',
01:04:26 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll',
01:04:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
01:04:26 INFO - 'work_dir': 'build'}
01:04:26 INFO - #####
01:04:26 INFO - ##### Running clobber step.
01:04:26 INFO - #####
01:04:26 INFO - Running pre-action listener: _resource_record_pre_action
01:04:26 INFO - Running main action method: clobber
01:04:26 INFO - rmtree: C:\slave\test-pgo\build
01:04:26 INFO - Using _rmtree_windows ...
01:04:26 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test-pgo\\build',), kwargs: {}, attempt #1
01:07:46 INFO - Running post-action listener: _resource_record_post_action
01:07:46 INFO - #####
01:07:46 INFO - ##### Running read-buildbot-config step.
01:07:46 INFO - #####
01:07:46 INFO - Running pre-action listener: _resource_record_pre_action
01:07:46 INFO - Running main action method: read_buildbot_config
01:07:46 INFO - Using buildbot properties:
01:07:46 INFO - {
01:07:46 INFO - "properties": {
01:07:46 INFO - "buildnumber": 191,
01:07:46 INFO - "product": "firefox",
01:07:46 INFO - "script_repo_revision": "production",
01:07:46 INFO - "builddir": "mozilla-beta_win7-ix_test-dromaeojs",
01:07:46 INFO - "repository": "",
01:07:46 INFO - "buildername": "Windows 7 32-bit mozilla-beta pgo talos dromaeojs",
01:07:46 INFO - "buildid": "20160218134825",
01:07:46 INFO - "slavename": "t-w732-ix-157",
01:07:46 INFO - "pgo_build": "True",
01:07:46 INFO - "basedir": "C:\\slave\\test-pgo",
01:07:46 INFO - "project": "",
01:07:46 INFO - "platform": "win7-ix",
01:07:46 INFO - "master": "http://buildbot-master119.bb.releng.scl3.mozilla.com:8201/",
01:07:46 INFO - "slavebuilddir": "test",
01:07:46 INFO - "scheduler": "tests-mozilla-beta-win32-pgo-talos",
01:07:46 INFO - "branch": "mozilla-beta",
01:07:46 INFO - "repo_path": "releases/mozilla-beta",
01:07:46 INFO - "stage_platform": "win32-pgo",
01:07:46 INFO - "builduid": "be9334a6f66b4e22a3c9762b5a61bcef",
01:07:46 INFO - "revision": "32608d640a8c"
01:07:46 INFO - },
01:07:46 INFO - "sourcestamp": {
01:07:46 INFO - "repository": "",
01:07:46 INFO - "hasPatch": false,
01:07:46 INFO - "project": "",
01:07:46 INFO - "branch": "mozilla-beta-win32-pgo-talos",
01:07:46 INFO - "changes": [
01:07:46 INFO - {
01:07:46 INFO - "category": null,
01:07:46 INFO - "files": [
01:07:46 INFO - {
01:07:46 INFO - "url": null,
01:07:46 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-win32/1455832105/firefox-45.0.en-US.win32.zip"
01:07:46 INFO - }
01:07:46 INFO - ],
01:07:46 INFO - "repository": "",
01:07:46 INFO - "rev": "32608d640a8c",
01:07:46 INFO - "who": "sendchange",
01:07:46 INFO - "when": 1455872105,
01:07:46 INFO - "number": 7626454,
01:07:46 INFO - "comments": "Bug 1244650 - Failure to clear Forms and Search Data on exit. r=yoric a=sylvestre",
01:07:46 INFO - "project": "",
01:07:46 INFO - "at": "Fri 19 Feb 2016 00:55:05",
01:07:46 INFO - "branch": "mozilla-beta-win32-pgo-talos",
01:07:46 INFO - "revlink": "",
01:07:46 INFO - "properties": [
01:07:46 INFO - [
01:07:46 INFO - "buildid",
01:07:46 INFO - "20160218134825",
01:07:46 INFO - "Change"
01:07:46 INFO - ],
01:07:46 INFO - [
01:07:46 INFO - "builduid",
01:07:46 INFO - "be9334a6f66b4e22a3c9762b5a61bcef",
01:07:46 INFO - "Change"
01:07:46 INFO - ],
01:07:46 INFO - [
01:07:46 INFO - "pgo_build",
01:07:46 INFO - "True",
01:07:46 INFO - "Change"
01:07:46 INFO - ]
01:07:46 INFO - ],
01:07:46 INFO - "revision": "32608d640a8c"
01:07:46 INFO - }
01:07:46 INFO - ],
01:07:46 INFO - "revision": "32608d640a8c"
01:07:46 INFO - }
01:07:46 INFO - }
01:07:46 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-win32/1455832105/firefox-45.0.en-US.win32.zip.
01:07:46 INFO - Running post-action listener: _resource_record_post_action
01:07:46 INFO - #####
01:07:46 INFO - ##### Running download-and-extract step.
01:07:46 INFO - #####
01:07:46 INFO - Running pre-action listener: _resource_record_pre_action
01:07:46 INFO - Running main action method: download_and_extract
01:07:46 INFO - mkdir: C:\slave\test-pgo\build\tests
01:07:46 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')]}
01:07:46 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-win32/1455832105/test_packages.json
01:07:46 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-win32/1455832105/test_packages.json to C:\slave\test-pgo\build\test_packages.json
01:07:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-win32/1455832105/test_packages.json', 'file_name': 'C:\\slave\\test-pgo\\build\\test_packages.json'}, attempt #1
01:07:46 INFO - Downloaded 1189 bytes.
01:07:46 INFO - Reading from file C:\slave\test-pgo\build\test_packages.json
01:07:46 INFO - Using the following test package requirements:
01:07:46 INFO - {u'common': [u'firefox-45.0.en-US.win32.common.tests.zip'],
01:07:46 INFO - u'cppunittest': [u'firefox-45.0.en-US.win32.common.tests.zip',
01:07:46 INFO - u'firefox-45.0.en-US.win32.cppunittest.tests.zip'],
01:07:46 INFO - u'jittest': [u'firefox-45.0.en-US.win32.common.tests.zip',
01:07:46 INFO - u'jsshell-win32.zip'],
01:07:46 INFO - u'mochitest': [u'firefox-45.0.en-US.win32.common.tests.zip',
01:07:46 INFO - u'firefox-45.0.en-US.win32.mochitest.tests.zip'],
01:07:46 INFO - u'mozbase': [u'firefox-45.0.en-US.win32.common.tests.zip'],
01:07:46 INFO - u'reftest': [u'firefox-45.0.en-US.win32.common.tests.zip',
01:07:46 INFO - u'firefox-45.0.en-US.win32.reftest.tests.zip'],
01:07:46 INFO - u'talos': [u'firefox-45.0.en-US.win32.common.tests.zip',
01:07:46 INFO - u'firefox-45.0.en-US.win32.talos.tests.zip'],
01:07:46 INFO - u'web-platform': [u'firefox-45.0.en-US.win32.common.tests.zip',
01:07:46 INFO - u'firefox-45.0.en-US.win32.web-platform.tests.zip'],
01:07:46 INFO - u'webapprt': [u'firefox-45.0.en-US.win32.common.tests.zip'],
01:07:46 INFO - u'xpcshell': [u'firefox-45.0.en-US.win32.common.tests.zip',
01:07:46 INFO - u'firefox-45.0.en-US.win32.xpcshell.tests.zip']}
01:07:46 INFO - Downloading packages: [u'firefox-45.0.en-US.win32.common.tests.zip'] for test suite category: common
01:07:46 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')]}
01:07:46 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-win32/1455832105/firefox-45.0.en-US.win32.common.tests.zip
01:07:46 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-win32/1455832105/firefox-45.0.en-US.win32.common.tests.zip to C:\slave\test-pgo\build\firefox-45.0.en-US.win32.common.tests.zip
01:07:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-win32/1455832105/firefox-45.0.en-US.win32.common.tests.zip', 'file_name': u'C:\\slave\\test-pgo\\build\\firefox-45.0.en-US.win32.common.tests.zip'}, attempt #1
01:07:47 INFO - Downloaded 17779146 bytes.
01:07:47 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-45.0.en-US.win32.common.tests.zip'] in C:\slave\test-pgo\build\tests
01:07:47 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-45.0.en-US.win32.common.tests.zip
01:07:47 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-45.0.en-US.win32.common.tests.zip'] with output_timeout 1760
01:08:27 INFO - Return code: 0
01:08:27 INFO - Downloading packages: [u'firefox-45.0.en-US.win32.common.tests.zip', u'firefox-45.0.en-US.win32.talos.tests.zip'] for test suite category: talos
01:08: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')]}
01:08:27 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-win32/1455832105/firefox-45.0.en-US.win32.common.tests.zip
01:08:27 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-win32/1455832105/firefox-45.0.en-US.win32.common.tests.zip to C:\slave\test-pgo\build\firefox-45.0.en-US.win32.common.tests.zip
01:08:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-win32/1455832105/firefox-45.0.en-US.win32.common.tests.zip', 'file_name': u'C:\\slave\\test-pgo\\build\\firefox-45.0.en-US.win32.common.tests.zip'}, attempt #1
01:08:28 INFO - Downloaded 17779146 bytes.
01:08:28 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-45.0.en-US.win32.common.tests.zip'] in C:\slave\test-pgo\build\tests
01:08:28 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-45.0.en-US.win32.common.tests.zip
01:08:28 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-45.0.en-US.win32.common.tests.zip'] with output_timeout 1760
01:08:51 INFO - Return code: 0
01:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]}
01:08:51 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-win32/1455832105/firefox-45.0.en-US.win32.talos.tests.zip
01:08:51 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-win32/1455832105/firefox-45.0.en-US.win32.talos.tests.zip to C:\slave\test-pgo\build\firefox-45.0.en-US.win32.talos.tests.zip
01:08:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-win32/1455832105/firefox-45.0.en-US.win32.talos.tests.zip', 'file_name': u'C:\\slave\\test-pgo\\build\\firefox-45.0.en-US.win32.talos.tests.zip'}, attempt #1
01:08:53 INFO - Downloaded 11132038 bytes.
01:08:53 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-45.0.en-US.win32.talos.tests.zip'] in C:\slave\test-pgo\build\tests
01:08:53 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-45.0.en-US.win32.talos.tests.zip
01:08:53 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-45.0.en-US.win32.talos.tests.zip'] with output_timeout 1760
01:08:59 INFO - Return code: 0
01:08:59 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')]}
01:08:59 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-win32/1455832105/firefox-45.0.en-US.win32.zip
01:08:59 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-win32/1455832105/firefox-45.0.en-US.win32.zip to C:\slave\test-pgo\build\firefox-45.0.en-US.win32.zip
01:08:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-win32/1455832105/firefox-45.0.en-US.win32.zip', 'file_name': 'C:\\slave\\test-pgo\\build\\firefox-45.0.en-US.win32.zip'}, attempt #1
01:09:02 INFO - Downloaded 54310344 bytes.
01:09:02 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-win32/1455832105/firefox-45.0.en-US.win32.zip
01:09:02 INFO - mkdir: C:\slave\test-pgo\properties
01:09:02 INFO - Writing buildbot properties ['build_url'] to C:\slave\test-pgo\properties\build_url
01:09:02 INFO - Writing to file C:\slave\test-pgo\properties\build_url
01:09:02 INFO - Contents:
01:09:02 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-win32/1455832105/firefox-45.0.en-US.win32.zip
01:09:02 INFO - Running post-action listener: _resource_record_post_action
01:09:02 INFO - Running post-action listener: set_extra_try_arguments
01:09:02 INFO - #####
01:09:02 INFO - ##### Running populate-webroot step.
01:09:02 INFO - #####
01:09:02 INFO - Running pre-action listener: _resource_record_pre_action
01:09:02 INFO - Running main action method: populate_webroot
01:09:02 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']},
01:09:02 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']},
01:09:02 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome',
01:09:02 INFO - u'--tppagecycles',
01:09:02 INFO - u'7'],
01:09:02 INFO - u'tests': [u'tsvgm']}},
01:09:02 INFO - u'suites': {u'chromez': {u'tests': [u'tresize', u'tcanvasmark']},
01:09:02 INFO - u'chromez-e10s': {u'talos_options': [u'--e10s'],
01:09:02 INFO - u'tests': [u'tresize', u'tcanvasmark']},
01:09:02 INFO - u'dromaeojs': {u'tests': [u'dromaeo_css', u'kraken', u'v8_7']},
01:09:02 INFO - u'dromaeojs-e10s': {u'talos_options': [u'--e10s'],
01:09:02 INFO - u'tests': [u'dromaeo_css',
01:09:02 INFO - u'kraken',
01:09:02 INFO - u'v8_7']},
01:09:02 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
01:09:02 INFO - u'tests': [u'tp5o_scroll', u'glterrain']},
01:09:02 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
01:09:02 INFO - u'talos_options': [u'--e10s'],
01:09:02 INFO - u'tests': [u'tp5o_scroll', u'glterrain']},
01:09:02 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
01:09:02 INFO - u'tests': [u'damp', u'tps']},
01:09:02 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
01:09:02 INFO - u'talos_options': [u'--e10s'],
01:09:02 INFO - u'tests': [u'damp', u'tps']},
01:09:02 INFO - u'g3': {u'tests': [u'dromaeo_dom']},
01:09:02 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']},
01:09:02 INFO - u'other': {u'tests': [u'a11yr',
01:09:02 INFO - u'ts_paint',
01:09:02 INFO - u'tpaint',
01:09:02 INFO - u'sessionrestore',
01:09:02 INFO - u'sessionrestore_no_auto_restore']},
01:09:02 INFO - u'other-e10s': {u'talos_options': [u'--e10s'],
01:09:02 INFO - u'tests': [u'a11yr',
01:09:02 INFO - u'ts_paint',
01:09:02 INFO - u'tpaint',
01:09:02 INFO - u'sessionrestore',
01:09:02 INFO - u'sessionrestore_no_auto_restore']},
01:09:02 INFO - u'other-e10s_l64': {u'talos_options': [u'--e10s'],
01:09:02 INFO - u'tests': [u'a11yr',
01:09:02 INFO - u'ts_paint',
01:09:02 INFO - u'tpaint',
01:09:02 INFO - u'sessionrestore',
01:09:02 INFO - u'sessionrestore_no_auto_restore']},
01:09:02 INFO - u'other-e10s_nol64': {u'talos_options': [u'--e10s'],
01:09:02 INFO - u'tests': [u'a11yr',
01:09:02 INFO - u'ts_paint',
01:09:02 INFO - u'tpaint',
01:09:02 INFO - u'sessionrestore',
01:09:02 INFO - u'sessionrestore_no_auto_restore']},
01:09:02 INFO - u'other_l64': {u'tests': [u'a11yr',
01:09:02 INFO - u'ts_paint',
01:09:02 INFO - u'tpaint',
01:09:02 INFO - u'sessionrestore',
01:09:02 INFO - u'sessionrestore_no_auto_restore']},
01:09:02 INFO - u'other_nol64': {u'tests': [u'a11yr',
01:09:02 INFO - u'ts_paint',
01:09:02 INFO - u'tpaint',
01:09:02 INFO - u'sessionrestore',
01:09:02 INFO - u'sessionrestore_no_auto_restore']},
01:09:02 INFO - u'svgr': {u'tests': [u'tsvgx',
01:09:02 INFO - u'tsvgr_opacity',
01:09:02 INFO - u'tart',
01:09:02 INFO - u'tscrollx',
01:09:02 INFO - u'cart']},
01:09:02 INFO - u'svgr-e10s': {u'talos_options': [u'--e10s'],
01:09:02 INFO - u'tests': [u'tsvgx',
01:09:02 INFO - u'tsvgr_opacity',
01:09:02 INFO - u'tart',
01:09:02 INFO - u'tscrollx',
01:09:02 INFO - u'cart']},
01:09:02 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
01:09:02 INFO - u'tests': [u'tp5o']},
01:09:02 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
01:09:02 INFO - u'talos_options': [u'--e10s'],
01:09:02 INFO - u'tests': [u'tp5o']},
01:09:02 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
01:09:02 INFO - u'talos_options': [u'--xperf_path',
01:09:02 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
01:09:02 INFO - u'tests': [u'tp5n']},
01:09:02 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
01:09:02 INFO - u'talos_options': [u'--e10s',
01:09:02 INFO - u'--xperf_path',
01:09:02 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
01:09:02 INFO - u'tests': [u'tp5n']}},
01:09:02 INFO - u'talos.zip': {u'path': u'',
01:09:02 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}}
01:09:02 INFO - Running post-action listener: _resource_record_post_action
01:09:02 INFO - #####
01:09:02 INFO - ##### Running create-virtualenv step.
01:09:02 INFO - #####
01:09:02 INFO - Running pre-action listener: _resource_record_pre_action
01:09:02 INFO - Running main action method: create_virtualenv
01:09:02 INFO - Creating virtualenv C:\slave\test-pgo\build/venv
01:09:02 INFO - mkdir: C:\slave\test-pgo\build\venv\Scripts
01:09:02 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test-pgo\build\venv\Scripts\python27.dll
01:09:02 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'!
01:09:02 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
01:09:02 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
01:09:10 INFO - New python executable in C:\slave\test-pgo\build/venv\Scripts\python.exe
01:09:12 INFO - Installing distribute......................................................................................................................................................................................done.
01:09:14 INFO - Return code: 0
01:09:14 INFO - Installing pip>=1.5 into virtualenv C:\slave\test-pgo\build/venv
01:09:14 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')]}
01:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
01:09:14 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')]}
01:09:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
01:09:14 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0180B6B0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018B2EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x017BAF58>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012B8C98>, '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 0x012DA860>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0197D5C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-157', 'USERDOMAIN': 'T-W732-IX-157', '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-157', '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
01:09:14 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in C:\slave\test-pgo\build
01:09:14 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5
01:09:14 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
01:09:14 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
01:09:14 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
01:09:14 INFO - 'COMPUTERNAME': 'T-W732-IX-157',
01:09:14 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
01:09:14 INFO - 'CYGWINBASE': 'C:\\cygwin',
01:09:14 INFO - 'DCLOCATION': 'SCL3',
01:09:14 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
01:09:14 INFO - 'FP_NO_HOST_CHECK': 'NO',
01:09:14 INFO - 'HOMEDRIVE': 'C:',
01:09:14 INFO - 'HOMEPATH': '\\Users\\cltbld',
01:09:14 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
01:09:14 INFO - 'KTS_VERSION': '1.19c',
01:09:14 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
01:09:14 INFO - 'LOGONSERVER': '\\\\T-W732-IX-157',
01:09:14 INFO - 'MONDIR': 'C:\\Monitor_config\\',
01:09:14 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
01:09:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
01:09:14 INFO - 'MOZ_NO_REMOTE': '1',
01:09:14 INFO - 'NO_EM_RESTART': '1',
01:09:14 INFO - 'NUMBER_OF_PROCESSORS': '8',
01:09:14 INFO - 'OS': 'Windows_NT',
01:09:14 INFO - 'OURDRIVE': 'C:',
01:09:14 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;',
01:09:14 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
01:09:14 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
01:09:14 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
01:09:14 INFO - 'PROCESSOR_LEVEL': '6',
01:09:14 INFO - 'PROCESSOR_REVISION': '1e05',
01:09:14 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
01:09:14 INFO - 'PROGRAMFILES': 'C:\\Program Files',
01:09:14 INFO - 'PROMPT': '$P$G',
01:09:14 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json',
01:09:14 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
01:09:14 INFO - 'PUBLIC': 'C:\\Users\\Public',
01:09:14 INFO - 'PWD': 'C:\\slave\\test-pgo',
01:09:14 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
01:09:14 INFO - 'SLAVEDIR': 'C:\\slave\\',
01:09:14 INFO - 'SYSTEMDRIVE': 'C:',
01:09:14 INFO - 'SYSTEMROOT': 'C:\\windows',
01:09:14 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
01:09:14 INFO - 'TEST1': 'testie',
01:09:14 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
01:09:14 INFO - 'USERDOMAIN': 'T-W732-IX-157',
01:09:14 INFO - 'USERNAME': 'cltbld',
01:09:14 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
01:09:14 INFO - 'WINDIR': 'C:\\windows',
01:09:14 INFO - 'WINDOWS_TRACING_FLAGS': '3',
01:09:14 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
01:09:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
01:09:15 INFO - Ignoring indexes: http://pypi.python.org/simple/
01:09:15 INFO - Downloading/unpacking pip>=1.5
01:09:19 INFO - Running setup.py egg_info for package pip
01:09:19 INFO - warning: no files found matching 'pip\cacert.pem'
01:09:19 INFO - warning: no files found matching '*.html' under directory 'docs'
01:09:19 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build'
01:09:19 INFO - no previously-included directories found matching 'docs\_build\_sources'
01:09:19 INFO - Installing collected packages: pip
01:09:19 INFO - Found existing installation: pip 0.8.2
01:09:19 INFO - Uninstalling pip:
01:09:19 INFO - Successfully uninstalled pip
01:09:19 INFO - Running setup.py install for pip
01:09:19 INFO - warning: no files found matching 'pip\cacert.pem'
01:09:19 INFO - warning: no files found matching '*.html' under directory 'docs'
01:09:19 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build'
01:09:19 INFO - no previously-included directories found matching 'docs\_build\_sources'
01:09:19 INFO - Installing pip-script.py script to C:\slave\test-pgo\build\venv\Scripts
01:09:19 INFO - Installing pip.exe script to C:\slave\test-pgo\build\venv\Scripts
01:09:19 INFO - Installing pip2.7-script.py script to C:\slave\test-pgo\build\venv\Scripts
01:09:19 INFO - Installing pip2.7.exe script to C:\slave\test-pgo\build\venv\Scripts
01:09:19 INFO - Installing pip2-script.py script to C:\slave\test-pgo\build\venv\Scripts
01:09:19 INFO - Installing pip2.exe script to C:\slave\test-pgo\build\venv\Scripts
01:09:19 INFO - Successfully installed pip
01:09:19 INFO - Cleaning up...
01:09:19 INFO - Return code: 0
01:09:19 INFO - Installing psutil>=0.7.1 into virtualenv C:\slave\test-pgo\build/venv
01:09:19 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')]}
01:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
01:09:19 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')]}
01:09:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
01:09:19 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0180B6B0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018B2EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x017BAF58>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012B8C98>, '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 0x012DA860>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0197D5C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-157', 'USERDOMAIN': 'T-W732-IX-157', '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-157', '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
01:09:19 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in C:\slave\test-pgo\build
01:09:19 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1
01:09:19 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
01:09:19 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
01:09:19 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
01:09:19 INFO - 'COMPUTERNAME': 'T-W732-IX-157',
01:09:19 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
01:09:19 INFO - 'CYGWINBASE': 'C:\\cygwin',
01:09:19 INFO - 'DCLOCATION': 'SCL3',
01:09:19 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
01:09:19 INFO - 'FP_NO_HOST_CHECK': 'NO',
01:09:19 INFO - 'HOMEDRIVE': 'C:',
01:09:19 INFO - 'HOMEPATH': '\\Users\\cltbld',
01:09:19 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
01:09:19 INFO - 'KTS_VERSION': '1.19c',
01:09:19 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
01:09:19 INFO - 'LOGONSERVER': '\\\\T-W732-IX-157',
01:09:19 INFO - 'MONDIR': 'C:\\Monitor_config\\',
01:09:19 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
01:09:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
01:09:19 INFO - 'MOZ_NO_REMOTE': '1',
01:09:19 INFO - 'NO_EM_RESTART': '1',
01:09:19 INFO - 'NUMBER_OF_PROCESSORS': '8',
01:09:19 INFO - 'OS': 'Windows_NT',
01:09:19 INFO - 'OURDRIVE': 'C:',
01:09:19 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;',
01:09:19 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
01:09:19 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
01:09:19 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
01:09:19 INFO - 'PROCESSOR_LEVEL': '6',
01:09:19 INFO - 'PROCESSOR_REVISION': '1e05',
01:09:19 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
01:09:19 INFO - 'PROGRAMFILES': 'C:\\Program Files',
01:09:19 INFO - 'PROMPT': '$P$G',
01:09:19 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json',
01:09:19 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
01:09:19 INFO - 'PUBLIC': 'C:\\Users\\Public',
01:09:19 INFO - 'PWD': 'C:\\slave\\test-pgo',
01:09:19 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
01:09:19 INFO - 'SLAVEDIR': 'C:\\slave\\',
01:09:19 INFO - 'SYSTEMDRIVE': 'C:',
01:09:19 INFO - 'SYSTEMROOT': 'C:\\windows',
01:09:19 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
01:09:19 INFO - 'TEST1': 'testie',
01:09:19 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
01:09:19 INFO - 'USERDOMAIN': 'T-W732-IX-157',
01:09:19 INFO - 'USERNAME': 'cltbld',
01:09:19 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
01:09:19 INFO - 'WINDIR': 'C:\\windows',
01:09:19 INFO - 'WINDOWS_TRACING_FLAGS': '3',
01:09:19 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
01:09:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
01:09:21 INFO - Ignoring indexes: https://pypi.python.org/simple/
01:09:21 INFO - Downloading/unpacking psutil>=0.7.1
01:09:21 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
01:09:21 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
01:09:22 INFO - Installing collected packages: psutil
01:09:22 INFO - Successfully installed psutil
01:09:22 INFO - Cleaning up...
01:09:22 INFO - Return code: 0
01:09:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv C:\slave\test-pgo\build/venv
01:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]}
01:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
01:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]}
01:09:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
01:09:22 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0180B6B0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018B2EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x017BAF58>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012B8C98>, '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 0x012DA860>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0197D5C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-157', 'USERDOMAIN': 'T-W732-IX-157', '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-157', '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
01:09:22 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in C:\slave\test-pgo\build
01:09:22 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0
01:09:22 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
01:09:22 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
01:09:22 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
01:09:22 INFO - 'COMPUTERNAME': 'T-W732-IX-157',
01:09:22 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
01:09:22 INFO - 'CYGWINBASE': 'C:\\cygwin',
01:09:22 INFO - 'DCLOCATION': 'SCL3',
01:09:22 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
01:09:22 INFO - 'FP_NO_HOST_CHECK': 'NO',
01:09:22 INFO - 'HOMEDRIVE': 'C:',
01:09:22 INFO - 'HOMEPATH': '\\Users\\cltbld',
01:09:22 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
01:09:22 INFO - 'KTS_VERSION': '1.19c',
01:09:22 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
01:09:22 INFO - 'LOGONSERVER': '\\\\T-W732-IX-157',
01:09:22 INFO - 'MONDIR': 'C:\\Monitor_config\\',
01:09:22 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
01:09:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
01:09:22 INFO - 'MOZ_NO_REMOTE': '1',
01:09:22 INFO - 'NO_EM_RESTART': '1',
01:09:22 INFO - 'NUMBER_OF_PROCESSORS': '8',
01:09:22 INFO - 'OS': 'Windows_NT',
01:09:22 INFO - 'OURDRIVE': 'C:',
01:09:22 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;',
01:09:22 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
01:09:22 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
01:09:22 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
01:09:22 INFO - 'PROCESSOR_LEVEL': '6',
01:09:22 INFO - 'PROCESSOR_REVISION': '1e05',
01:09:22 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
01:09:22 INFO - 'PROGRAMFILES': 'C:\\Program Files',
01:09:22 INFO - 'PROMPT': '$P$G',
01:09:22 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json',
01:09:22 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
01:09:22 INFO - 'PUBLIC': 'C:\\Users\\Public',
01:09:22 INFO - 'PWD': 'C:\\slave\\test-pgo',
01:09:22 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
01:09:22 INFO - 'SLAVEDIR': 'C:\\slave\\',
01:09:22 INFO - 'SYSTEMDRIVE': 'C:',
01:09:22 INFO - 'SYSTEMROOT': 'C:\\windows',
01:09:22 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
01:09:22 INFO - 'TEST1': 'testie',
01:09:22 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
01:09:22 INFO - 'USERDOMAIN': 'T-W732-IX-157',
01:09:22 INFO - 'USERNAME': 'cltbld',
01:09:22 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
01:09:22 INFO - 'WINDIR': 'C:\\windows',
01:09:22 INFO - 'WINDOWS_TRACING_FLAGS': '3',
01:09:22 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
01:09:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
01:09:22 INFO - Ignoring indexes: https://pypi.python.org/simple/
01:09:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0
01:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
01:09:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
01:09:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz
01:09:23 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor
01:09:24 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)
01:09:24 INFO - Installing collected packages: mozsystemmonitor
01:09:24 INFO - Running setup.py install for mozsystemmonitor
01:09:24 INFO - Successfully installed mozsystemmonitor
01:09:24 INFO - Cleaning up...
01:09:24 INFO - Return code: 0
01:09:24 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test-pgo\build/venv
01:09:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]}
01:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
01:09:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]}
01:09:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
01:09:24 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0180B6B0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018B2EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x017BAF58>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012B8C98>, '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 0x012DA860>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0197D5C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-157', 'USERDOMAIN': 'T-W732-IX-157', '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-157', '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
01:09:24 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in C:\slave\test-pgo\build
01:09:24 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4
01:09:24 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
01:09:24 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
01:09:24 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
01:09:24 INFO - 'COMPUTERNAME': 'T-W732-IX-157',
01:09:24 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
01:09:24 INFO - 'CYGWINBASE': 'C:\\cygwin',
01:09:24 INFO - 'DCLOCATION': 'SCL3',
01:09:24 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
01:09:24 INFO - 'FP_NO_HOST_CHECK': 'NO',
01:09:24 INFO - 'HOMEDRIVE': 'C:',
01:09:24 INFO - 'HOMEPATH': '\\Users\\cltbld',
01:09:24 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
01:09:24 INFO - 'KTS_VERSION': '1.19c',
01:09:24 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
01:09:24 INFO - 'LOGONSERVER': '\\\\T-W732-IX-157',
01:09:24 INFO - 'MONDIR': 'C:\\Monitor_config\\',
01:09:24 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
01:09:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
01:09:24 INFO - 'MOZ_NO_REMOTE': '1',
01:09:24 INFO - 'NO_EM_RESTART': '1',
01:09:24 INFO - 'NUMBER_OF_PROCESSORS': '8',
01:09:24 INFO - 'OS': 'Windows_NT',
01:09:24 INFO - 'OURDRIVE': 'C:',
01:09:24 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;',
01:09:24 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
01:09:24 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
01:09:24 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
01:09:24 INFO - 'PROCESSOR_LEVEL': '6',
01:09:24 INFO - 'PROCESSOR_REVISION': '1e05',
01:09:24 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
01:09:24 INFO - 'PROGRAMFILES': 'C:\\Program Files',
01:09:24 INFO - 'PROMPT': '$P$G',
01:09:24 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json',
01:09:24 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
01:09:24 INFO - 'PUBLIC': 'C:\\Users\\Public',
01:09:24 INFO - 'PWD': 'C:\\slave\\test-pgo',
01:09:24 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
01:09:24 INFO - 'SLAVEDIR': 'C:\\slave\\',
01:09:24 INFO - 'SYSTEMDRIVE': 'C:',
01:09:24 INFO - 'SYSTEMROOT': 'C:\\windows',
01:09:24 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
01:09:24 INFO - 'TEST1': 'testie',
01:09:24 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
01:09:24 INFO - 'USERDOMAIN': 'T-W732-IX-157',
01:09:24 INFO - 'USERNAME': 'cltbld',
01:09:24 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
01:09:24 INFO - 'WINDIR': 'C:\\windows',
01:09:24 INFO - 'WINDOWS_TRACING_FLAGS': '3',
01:09:24 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
01:09:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
01:09:24 INFO - Ignoring indexes: https://pypi.python.org/simple/
01:09:24 INFO - Downloading/unpacking blobuploader==1.2.4
01:09: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
01:09: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
01:09:25 INFO - Downloading blobuploader-1.2.4.tar.gz
01:09:25 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader
01:09:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4)
01:09:25 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
01:09:25 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
01:09:26 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\requests\setup.py) egg_info for package requests
01:09:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4)
01:09: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
01:09: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
01:09:26 INFO - Downloading docopt-0.6.1.tar.gz
01:09:26 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\docopt\setup.py) egg_info for package docopt
01:09:26 INFO - Installing collected packages: blobuploader, requests, docopt
01:09:26 INFO - Running setup.py install for blobuploader
01:09:26 INFO - Running setup.py install for requests
01:09:27 INFO - Running setup.py install for docopt
01:09:27 INFO - Successfully installed blobuploader requests docopt
01:09:27 INFO - Cleaning up...
01:09:29 INFO - Return code: 0
01:09:29 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv
01:09:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]}
01:09:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
01:09:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]}
01:09:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
01:09:29 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--no-deps', '--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 0x0180B6B0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018B2EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x017BAF58>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012B8C98>, '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 0x012DA860>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0197D5C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-157', 'USERDOMAIN': 'T-W732-IX-157', '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-157', '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
01:09:29 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--no-deps', '--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
01:09:29 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --no-deps --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
01:09:29 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
01:09:29 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
01:09:29 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
01:09:29 INFO - 'COMPUTERNAME': 'T-W732-IX-157',
01:09:29 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
01:09:29 INFO - 'CYGWINBASE': 'C:\\cygwin',
01:09:29 INFO - 'DCLOCATION': 'SCL3',
01:09:29 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
01:09:29 INFO - 'FP_NO_HOST_CHECK': 'NO',
01:09:29 INFO - 'HOMEDRIVE': 'C:',
01:09:29 INFO - 'HOMEPATH': '\\Users\\cltbld',
01:09:29 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
01:09:29 INFO - 'KTS_VERSION': '1.19c',
01:09:29 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
01:09:29 INFO - 'LOGONSERVER': '\\\\T-W732-IX-157',
01:09:29 INFO - 'MONDIR': 'C:\\Monitor_config\\',
01:09:29 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
01:09:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
01:09:29 INFO - 'MOZ_NO_REMOTE': '1',
01:09:29 INFO - 'NO_EM_RESTART': '1',
01:09:29 INFO - 'NUMBER_OF_PROCESSORS': '8',
01:09:29 INFO - 'OS': 'Windows_NT',
01:09:29 INFO - 'OURDRIVE': 'C:',
01:09:29 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;',
01:09:29 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
01:09:29 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
01:09:29 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
01:09:29 INFO - 'PROCESSOR_LEVEL': '6',
01:09:29 INFO - 'PROCESSOR_REVISION': '1e05',
01:09:29 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
01:09:29 INFO - 'PROGRAMFILES': 'C:\\Program Files',
01:09:29 INFO - 'PROMPT': '$P$G',
01:09:29 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json',
01:09:29 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
01:09:29 INFO - 'PUBLIC': 'C:\\Users\\Public',
01:09:29 INFO - 'PWD': 'C:\\slave\\test-pgo',
01:09:29 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
01:09:29 INFO - 'SLAVEDIR': 'C:\\slave\\',
01:09:29 INFO - 'SYSTEMDRIVE': 'C:',
01:09:29 INFO - 'SYSTEMROOT': 'C:\\windows',
01:09:29 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
01:09:29 INFO - 'TEST1': 'testie',
01:09:29 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
01:09:29 INFO - 'USERDOMAIN': 'T-W732-IX-157',
01:09:29 INFO - 'USERNAME': 'cltbld',
01:09:29 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
01:09:29 INFO - 'WINDIR': 'C:\\windows',
01:09:29 INFO - 'WINDOWS_TRACING_FLAGS': '3',
01:09:29 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
01:09:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
01:09:29 INFO - Ignoring indexes: https://pypi.python.org/simple/
01:09:29 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\manifestparser
01:09:30 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-ds7n7n-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/manifestparser
01:09:30 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozcrash
01:09:30 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-ncluvn-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozcrash
01:09:30 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdebug
01:09:30 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-nby_i6-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdebug
01:09:30 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdevice
01:09:30 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-aa_sa7-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdevice
01:09:31 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozfile
01:09:31 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-ladogo-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozfile
01:09:31 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozhttpd
01:09:31 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-mswtog-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozhttpd
01:09:31 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinfo
01:09:31 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-pjsypi-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinfo
01:09:31 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinstall
01:09:31 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-hdzg3z-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinstall
01:09:31 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozleak
01:09:31 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-s1omr4-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozleak
01:09:31 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozlog
01:09:31 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-o0qiee-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozlog
01:09:31 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moznetwork
01:09:31 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-awdfgp-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moznetwork
01:09:31 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprocess
01:09:31 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-aidzkg-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprocess
01:09:32 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprofile
01:09:32 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-i7a8ya-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprofile
01:09:32 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozrunner
01:09:32 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-a_bfip-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozrunner
01:09:32 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozscreenshot
01:09:32 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-c4egf0-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozscreenshot
01:09:32 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moztest
01:09:32 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-q4s5fz-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moztest
01:09:32 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozversion
01:09:32 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-eiitbb-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozversion
01:09:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion
01:09:32 INFO - Running setup.py install for manifestparser
01:09:32 INFO - Installing manifestparser-script.py script to C:\slave\test-pgo\build\venv\Scripts
01:09:32 INFO - Installing manifestparser.exe script to C:\slave\test-pgo\build\venv\Scripts
01:09:33 INFO - Running setup.py install for mozcrash
01:09:33 INFO - Running setup.py install for mozdebug
01:09:34 INFO - Running setup.py install for mozdevice
01:09:34 INFO - Installing sutini-script.py script to C:\slave\test-pgo\build\venv\Scripts
01:09:34 INFO - Installing sutini.exe script to C:\slave\test-pgo\build\venv\Scripts
01:09:34 INFO - Installing dm-script.py script to C:\slave\test-pgo\build\venv\Scripts
01:09:34 INFO - Installing dm.exe script to C:\slave\test-pgo\build\venv\Scripts
01:09:35 INFO - Running setup.py install for mozfile
01:09:35 INFO - Running setup.py install for mozhttpd
01:09:36 INFO - Installing mozhttpd-script.py script to C:\slave\test-pgo\build\venv\Scripts
01:09:36 INFO - Installing mozhttpd.exe script to C:\slave\test-pgo\build\venv\Scripts
01:09:36 INFO - Running setup.py install for mozinfo
01:09:36 INFO - Installing mozinfo-script.py script to C:\slave\test-pgo\build\venv\Scripts
01:09:36 INFO - Installing mozinfo.exe script to C:\slave\test-pgo\build\venv\Scripts
01:09:36 INFO - Running setup.py install for mozInstall
01:09:37 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test-pgo\build\venv\Scripts
01:09:37 INFO - Installing moz_remove_from_system.exe script to C:\slave\test-pgo\build\venv\Scripts
01:09:37 INFO - Installing mozuninstall-script.py script to C:\slave\test-pgo\build\venv\Scripts
01:09:37 INFO - Installing mozuninstall.exe script to C:\slave\test-pgo\build\venv\Scripts
01:09:37 INFO - Installing mozinstall-script.py script to C:\slave\test-pgo\build\venv\Scripts
01:09:37 INFO - Installing mozinstall.exe script to C:\slave\test-pgo\build\venv\Scripts
01:09:37 INFO - Installing moz_add_to_system-script.py script to C:\slave\test-pgo\build\venv\Scripts
01:09:37 INFO - Installing moz_add_to_system.exe script to C:\slave\test-pgo\build\venv\Scripts
01:09:37 INFO - Running setup.py install for mozleak
01:09:37 INFO - Running setup.py install for mozlog
01:09:37 INFO - Installing structlog-script.py script to C:\slave\test-pgo\build\venv\Scripts
01:09:37 INFO - Installing structlog.exe script to C:\slave\test-pgo\build\venv\Scripts
01:09:38 INFO - Running setup.py install for moznetwork
01:09:38 INFO - Installing moznetwork-script.py script to C:\slave\test-pgo\build\venv\Scripts
01:09:38 INFO - Installing moznetwork.exe script to C:\slave\test-pgo\build\venv\Scripts
01:09:38 INFO - Running setup.py install for mozprocess
01:09:39 INFO - Running setup.py install for mozprofile
01:09:39 INFO - Installing mozprofile-script.py script to C:\slave\test-pgo\build\venv\Scripts
01:09:39 INFO - Installing mozprofile.exe script to C:\slave\test-pgo\build\venv\Scripts
01:09:39 INFO - Installing diff-profiles-script.py script to C:\slave\test-pgo\build\venv\Scripts
01:09:39 INFO - Installing diff-profiles.exe script to C:\slave\test-pgo\build\venv\Scripts
01:09:39 INFO - Installing view-profile-script.py script to C:\slave\test-pgo\build\venv\Scripts
01:09:39 INFO - Installing view-profile.exe script to C:\slave\test-pgo\build\venv\Scripts
01:09:39 INFO - Running setup.py install for mozrunner
01:09:40 INFO - Installing mozrunner-script.py script to C:\slave\test-pgo\build\venv\Scripts
01:09:40 INFO - Installing mozrunner.exe script to C:\slave\test-pgo\build\venv\Scripts
01:09:40 INFO - Running setup.py install for mozscreenshot
01:09:40 INFO - Running setup.py install for moztest
01:09:41 INFO - Running setup.py install for mozversion
01:09:41 INFO - Installing mozversion-script.py script to C:\slave\test-pgo\build\venv\Scripts
01:09:41 INFO - Installing mozversion.exe script to C:\slave\test-pgo\build\venv\Scripts
01:09:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion
01:09:41 INFO - Cleaning up...
01:09:41 INFO - Return code: 0
01:09:41 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv
01:09:41 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')]}
01:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
01:09:41 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')]}
01:09:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
01:09:41 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--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 0x0180B6B0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018B2EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x017BAF58>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012B8C98>, '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 0x012DA860>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0197D5C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-157', 'USERDOMAIN': 'T-W732-IX-157', '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-157', '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
01:09:41 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--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
01:09:41 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --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
01:09:41 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
01:09:41 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
01:09:41 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
01:09:41 INFO - 'COMPUTERNAME': 'T-W732-IX-157',
01:09:41 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
01:09:41 INFO - 'CYGWINBASE': 'C:\\cygwin',
01:09:41 INFO - 'DCLOCATION': 'SCL3',
01:09:41 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
01:09:41 INFO - 'FP_NO_HOST_CHECK': 'NO',
01:09:41 INFO - 'HOMEDRIVE': 'C:',
01:09:41 INFO - 'HOMEPATH': '\\Users\\cltbld',
01:09:41 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
01:09:41 INFO - 'KTS_VERSION': '1.19c',
01:09:41 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
01:09:41 INFO - 'LOGONSERVER': '\\\\T-W732-IX-157',
01:09:41 INFO - 'MONDIR': 'C:\\Monitor_config\\',
01:09:41 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
01:09:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
01:09:41 INFO - 'MOZ_NO_REMOTE': '1',
01:09:41 INFO - 'NO_EM_RESTART': '1',
01:09:41 INFO - 'NUMBER_OF_PROCESSORS': '8',
01:09:41 INFO - 'OS': 'Windows_NT',
01:09:41 INFO - 'OURDRIVE': 'C:',
01:09:41 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;',
01:09:41 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
01:09:41 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
01:09:41 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
01:09:41 INFO - 'PROCESSOR_LEVEL': '6',
01:09:41 INFO - 'PROCESSOR_REVISION': '1e05',
01:09:41 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
01:09:41 INFO - 'PROGRAMFILES': 'C:\\Program Files',
01:09:41 INFO - 'PROMPT': '$P$G',
01:09:41 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json',
01:09:41 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
01:09:41 INFO - 'PUBLIC': 'C:\\Users\\Public',
01:09:41 INFO - 'PWD': 'C:\\slave\\test-pgo',
01:09:41 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
01:09:41 INFO - 'SLAVEDIR': 'C:\\slave\\',
01:09:41 INFO - 'SYSTEMDRIVE': 'C:',
01:09:41 INFO - 'SYSTEMROOT': 'C:\\windows',
01:09:41 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
01:09:41 INFO - 'TEST1': 'testie',
01:09:41 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
01:09:41 INFO - 'USERDOMAIN': 'T-W732-IX-157',
01:09:41 INFO - 'USERNAME': 'cltbld',
01:09:41 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
01:09:41 INFO - 'WINDIR': 'C:\\windows',
01:09:41 INFO - 'WINDOWS_TRACING_FLAGS': '3',
01:09:41 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
01:09:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
01:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/
01:09:42 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\manifestparser
01:09:42 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-np1gpx-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/manifestparser
01:09:42 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))
01:09:42 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozcrash
01:09:42 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-yeg9ii-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozcrash
01:09:42 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))
01:09:42 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdebug
01:09:42 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-xzdjz4-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdebug
01:09:42 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))
01:09:42 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdevice
01:09:42 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-nafa6h-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdevice
01:09:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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))
01:09:42 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozfile
01:09:42 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-pwfsal-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozfile
01:09:42 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))
01:09:42 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozhttpd
01:09:42 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-1ulegy-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozhttpd
01:09:43 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))
01:09:43 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinfo
01:09:43 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-bxvigq-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinfo
01:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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))
01:09:43 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinstall
01:09:43 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-g10sfw-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinstall
01:09:43 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))
01:09:43 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozleak
01:09:43 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-d4jefl-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozleak
01:09:43 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))
01:09:43 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozlog
01:09:43 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-ybkc62-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozlog
01:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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))
01:09:43 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moznetwork
01:09:43 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-itthib-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moznetwork
01:09:43 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))
01:09:43 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprocess
01:09:43 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-q6gzpq-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprocess
01:09:44 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))
01:09:44 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprofile
01:09:44 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-3db5im-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprofile
01:09:44 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))
01:09:44 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozrunner
01:09:44 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-5vi_py-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozrunner
01:09:44 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))
01:09:44 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozscreenshot
01:09:44 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-lmmppb-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozscreenshot
01:09:44 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))
01:09:44 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moztest
01:09:44 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-myivz2-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moztest
01:09:44 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))
01:09:44 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozversion
01:09:44 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-awg7cw-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozversion
01:09:44 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))
01:09:44 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))
01:09:44 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))
01:09:44 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))
01:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test-pgo\build\venv\lib\site-packages (from mozdevice==0.47->-r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 4))
01:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in c:\slave\test-pgo\build\venv\lib\site-packages (from mozdevice==0.47->-r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 4))
01:09:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 10))
01:09:44 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
01:09:44 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
01:09:45 INFO - Downloading blessings-1.6.tar.gz
01:09:45 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\blessings\setup.py) egg_info for package blessings
01:09:46 INFO - Installing collected packages: blessings
01:09:46 INFO - Running setup.py install for blessings
01:09:46 INFO - Successfully installed blessings
01:09:46 INFO - Cleaning up...
01:09:49 INFO - Return code: 0
01:09:49 INFO - Done creating virtualenv C:\slave\test-pgo\build/venv.
01:09:49 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'freeze']
01:09:49 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip freeze
01:09:49 INFO - Reading from file tmpfile_stdout
01:09:49 INFO - Using _rmtree_windows ...
01:09:49 INFO - Using _rmtree_windows ...
01:09:49 INFO - Current package versions:
01:09:49 INFO - blessings == 1.6
01:09:49 INFO - blobuploader == 1.2.4
01:09:49 INFO - docopt == 0.6.1
01:09:49 INFO - manifestparser == 1.1
01:09:49 INFO - mozInstall == 1.12
01:09:49 INFO - mozcrash == 0.16
01:09:49 INFO - mozdebug == 0.1
01:09:49 INFO - mozdevice == 0.47
01:09:49 INFO - mozfile == 1.2
01:09:49 INFO - mozhttpd == 0.7
01:09:49 INFO - mozinfo == 0.9
01:09:49 INFO - mozleak == 0.1
01:09:49 INFO - mozlog == 3.1
01:09:49 INFO - moznetwork == 0.27
01:09:49 INFO - mozprocess == 0.22
01:09:49 INFO - mozprofile == 0.27
01:09:49 INFO - mozrunner == 6.11
01:09:49 INFO - mozscreenshot == 0.1
01:09:49 INFO - mozsystemmonitor == 0.0
01:09:49 INFO - moztest == 0.7
01:09:49 INFO - mozversion == 1.4
01:09:49 INFO - psutil == 3.1.1
01:09:49 INFO - requests == 1.2.3
01:09:49 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv
01:09:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]}
01:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
01:09:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]}
01:09:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
01:09:49 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--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 0x0180B6B0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018B2EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x017BAF58>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012B8C98>, '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 0x012DA860>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0197D5C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build\\tests\\talos', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-157', 'USERDOMAIN': 'T-W732-IX-157', '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-157', '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
01:09:49 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--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
01:09:49 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --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
01:09:49 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
01:09:49 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
01:09:49 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
01:09:49 INFO - 'COMPUTERNAME': 'T-W732-IX-157',
01:09:49 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
01:09:49 INFO - 'CYGWINBASE': 'C:\\cygwin',
01:09:49 INFO - 'DCLOCATION': 'SCL3',
01:09:49 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
01:09:49 INFO - 'FP_NO_HOST_CHECK': 'NO',
01:09:49 INFO - 'HOMEDRIVE': 'C:',
01:09:49 INFO - 'HOMEPATH': '\\Users\\cltbld',
01:09:49 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
01:09:49 INFO - 'KTS_VERSION': '1.19c',
01:09:49 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
01:09:49 INFO - 'LOGONSERVER': '\\\\T-W732-IX-157',
01:09:49 INFO - 'MONDIR': 'C:\\Monitor_config\\',
01:09:49 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
01:09:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
01:09:49 INFO - 'MOZ_NO_REMOTE': '1',
01:09:49 INFO - 'NO_EM_RESTART': '1',
01:09:49 INFO - 'NUMBER_OF_PROCESSORS': '8',
01:09:49 INFO - 'OS': 'Windows_NT',
01:09:49 INFO - 'OURDRIVE': 'C:',
01:09:49 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;',
01:09:49 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
01:09:49 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
01:09:49 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
01:09:49 INFO - 'PROCESSOR_LEVEL': '6',
01:09:49 INFO - 'PROCESSOR_REVISION': '1e05',
01:09:49 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
01:09:49 INFO - 'PROGRAMFILES': 'C:\\Program Files',
01:09:49 INFO - 'PROMPT': '$P$G',
01:09:49 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json',
01:09:49 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
01:09:49 INFO - 'PUBLIC': 'C:\\Users\\Public',
01:09:49 INFO - 'PWD': 'C:\\slave\\test-pgo',
01:09:49 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
01:09:49 INFO - 'SLAVEDIR': 'C:\\slave\\',
01:09:49 INFO - 'SYSTEMDRIVE': 'C:',
01:09:49 INFO - 'SYSTEMROOT': 'C:\\windows',
01:09:49 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
01:09:49 INFO - 'TEST1': 'testie',
01:09:49 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
01:09:49 INFO - 'USERDOMAIN': 'T-W732-IX-157',
01:09:49 INFO - 'USERNAME': 'cltbld',
01:09:49 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
01:09:49 INFO - 'WINDIR': 'C:\\windows',
01:09:49 INFO - 'WINDOWS_TRACING_FLAGS': '3',
01:09:49 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
01:09:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
01:09:49 INFO - Ignoring indexes: https://pypi.python.org/simple/
01:09:49 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))
01:09:49 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))
01:09:49 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))
01:09:49 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))
01:09:49 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))
01:09:49 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))
01:09:49 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))
01:09:49 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))
01:09:49 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))
01:09:49 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))
01:09:49 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))
01:09:49 INFO - Cleaning up...
01:09:49 INFO - Return code: 0
01:09:49 INFO - Installing jsonschema into virtualenv C:\slave\test-pgo\build/venv
01:09:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]}
01:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
01:09:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]}
01:09:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
01:09:49 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0180B6B0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018B2EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x017BAF58>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012B8C98>, '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 0x012DA860>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0197D5C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-157', 'USERDOMAIN': 'T-W732-IX-157', '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-157', '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
01:09:49 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in C:\slave\test-pgo\build
01:09:49 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema
01:09:49 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
01:09:49 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
01:09:49 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
01:09:49 INFO - 'COMPUTERNAME': 'T-W732-IX-157',
01:09:49 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
01:09:49 INFO - 'CYGWINBASE': 'C:\\cygwin',
01:09:49 INFO - 'DCLOCATION': 'SCL3',
01:09:49 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
01:09:49 INFO - 'FP_NO_HOST_CHECK': 'NO',
01:09:49 INFO - 'HOMEDRIVE': 'C:',
01:09:49 INFO - 'HOMEPATH': '\\Users\\cltbld',
01:09:49 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
01:09:49 INFO - 'KTS_VERSION': '1.19c',
01:09:49 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
01:09:49 INFO - 'LOGONSERVER': '\\\\T-W732-IX-157',
01:09:49 INFO - 'MONDIR': 'C:\\Monitor_config\\',
01:09:49 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
01:09:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
01:09:49 INFO - 'MOZ_NO_REMOTE': '1',
01:09:49 INFO - 'NO_EM_RESTART': '1',
01:09:49 INFO - 'NUMBER_OF_PROCESSORS': '8',
01:09:49 INFO - 'OS': 'Windows_NT',
01:09:49 INFO - 'OURDRIVE': 'C:',
01:09:49 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;',
01:09:49 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
01:09:49 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
01:09:49 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
01:09:49 INFO - 'PROCESSOR_LEVEL': '6',
01:09:49 INFO - 'PROCESSOR_REVISION': '1e05',
01:09:49 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
01:09:49 INFO - 'PROGRAMFILES': 'C:\\Program Files',
01:09:49 INFO - 'PROMPT': '$P$G',
01:09:49 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json',
01:09:49 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
01:09:49 INFO - 'PUBLIC': 'C:\\Users\\Public',
01:09:49 INFO - 'PWD': 'C:\\slave\\test-pgo',
01:09:49 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
01:09:49 INFO - 'SLAVEDIR': 'C:\\slave\\',
01:09:49 INFO - 'SYSTEMDRIVE': 'C:',
01:09:49 INFO - 'SYSTEMROOT': 'C:\\windows',
01:09:49 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
01:09:49 INFO - 'TEST1': 'testie',
01:09:49 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
01:09:49 INFO - 'USERDOMAIN': 'T-W732-IX-157',
01:09:49 INFO - 'USERNAME': 'cltbld',
01:09:49 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
01:09:49 INFO - 'WINDIR': 'C:\\windows',
01:09:49 INFO - 'WINDOWS_TRACING_FLAGS': '3',
01:09:49 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
01:09:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
01:09:50 INFO - Ignoring indexes: https://pypi.python.org/simple/
01:09:50 INFO - Downloading/unpacking jsonschema
01:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
01:09:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
01:09:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl
01:09:51 INFO - Downloading/unpacking functools32 (from jsonschema)
01:09:51 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
01:09:51 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
01:09:51 INFO - Downloading functools32-3.2.3-2.tar.gz
01:09:51 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\functools32\setup.py) egg_info for package functools32
01:09:51 INFO - warning: no files found matching '*.txt'
01:09:51 INFO - no previously-included directories found matching 'build'
01:09:51 INFO - no previously-included directories found matching 'dist'
01:09:51 INFO - no previously-included directories found matching '.git*'
01:09:51 INFO - Installing collected packages: jsonschema, functools32
01:09:51 INFO - Running setup.py install for functools32
01:09:51 INFO - warning: no files found matching '*.txt'
01:09:51 INFO - no previously-included directories found matching 'build'
01:09:51 INFO - no previously-included directories found matching 'dist'
01:09:51 INFO - no previously-included directories found matching '.git*'
01:09:51 INFO - Successfully installed jsonschema functools32
01:09:51 INFO - Cleaning up...
01:09:52 INFO - Return code: 0
01:09:52 INFO - Installing flake8 into virtualenv C:\slave\test-pgo\build/venv
01:09: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')]}
01:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
01:09: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')]}
01:09:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
01:09:52 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0180B6B0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018B2EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x017BAF58>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012B8C98>, '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 0x012DA860>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0197D5C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-157', 'USERDOMAIN': 'T-W732-IX-157', '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-157', '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
01:09:52 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in C:\slave\test-pgo\build
01:09:52 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8
01:09:52 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
01:09:52 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
01:09:52 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
01:09:52 INFO - 'COMPUTERNAME': 'T-W732-IX-157',
01:09:52 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
01:09:52 INFO - 'CYGWINBASE': 'C:\\cygwin',
01:09:52 INFO - 'DCLOCATION': 'SCL3',
01:09:52 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
01:09:52 INFO - 'FP_NO_HOST_CHECK': 'NO',
01:09:52 INFO - 'HOMEDRIVE': 'C:',
01:09:52 INFO - 'HOMEPATH': '\\Users\\cltbld',
01:09:52 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
01:09:52 INFO - 'KTS_VERSION': '1.19c',
01:09:52 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
01:09:52 INFO - 'LOGONSERVER': '\\\\T-W732-IX-157',
01:09:52 INFO - 'MONDIR': 'C:\\Monitor_config\\',
01:09:52 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
01:09:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
01:09:52 INFO - 'MOZ_NO_REMOTE': '1',
01:09:52 INFO - 'NO_EM_RESTART': '1',
01:09:52 INFO - 'NUMBER_OF_PROCESSORS': '8',
01:09:52 INFO - 'OS': 'Windows_NT',
01:09:52 INFO - 'OURDRIVE': 'C:',
01:09:52 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;',
01:09:52 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
01:09:52 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
01:09:52 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
01:09:52 INFO - 'PROCESSOR_LEVEL': '6',
01:09:52 INFO - 'PROCESSOR_REVISION': '1e05',
01:09:52 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
01:09:52 INFO - 'PROGRAMFILES': 'C:\\Program Files',
01:09:52 INFO - 'PROMPT': '$P$G',
01:09:52 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json',
01:09:52 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
01:09:52 INFO - 'PUBLIC': 'C:\\Users\\Public',
01:09:52 INFO - 'PWD': 'C:\\slave\\test-pgo',
01:09:52 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
01:09:52 INFO - 'SLAVEDIR': 'C:\\slave\\',
01:09:52 INFO - 'SYSTEMDRIVE': 'C:',
01:09:52 INFO - 'SYSTEMROOT': 'C:\\windows',
01:09:52 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
01:09:52 INFO - 'TEST1': 'testie',
01:09:52 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
01:09:52 INFO - 'USERDOMAIN': 'T-W732-IX-157',
01:09:52 INFO - 'USERNAME': 'cltbld',
01:09:52 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
01:09:52 INFO - 'WINDIR': 'C:\\windows',
01:09:52 INFO - 'WINDOWS_TRACING_FLAGS': '3',
01:09:52 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
01:09:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
01:09:52 INFO - Ignoring indexes: https://pypi.python.org/simple/
01:09:52 INFO - Downloading/unpacking flake8
01:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
01:09:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
01:09:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl
01:09:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8)
01:09:53 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
01:09:53 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
01:09:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl
01:09:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8)
01:09:53 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
01:09:53 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
01:09:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8)
01:09:53 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
01:09:53 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
01:09:54 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\pep8\setup.py) egg_info for package pep8
01:09:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs'
01:09:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs'
01:09:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite'
01:09:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite'
01:09:54 INFO - no previously-included directories found matching 'docs\_build'
01:09:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8
01:09:54 INFO - Running setup.py install for pep8
01:09:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs'
01:09:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs'
01:09:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite'
01:09:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite'
01:09:54 INFO - no previously-included directories found matching 'docs\_build'
01:09:54 INFO - Installing pep8-script.py script to C:\slave\test-pgo\build\venv\Scripts
01:09:54 INFO - Installing pep8.exe script to C:\slave\test-pgo\build\venv\Scripts
01:09:54 INFO - Successfully installed flake8 mccabe pyflakes pep8
01:09:54 INFO - Cleaning up...
01:09:55 INFO - Return code: 0
01:09:55 INFO - Running post-action listener: _resource_record_post_action
01:09:55 INFO - Running post-action listener: _start_resource_monitoring
01:09:55 INFO - Starting resource monitoring.
01:09:55 INFO - #####
01:09:55 INFO - ##### Running install step.
01:09:55 INFO - #####
01:09:55 INFO - Running pre-action listener: _resource_record_pre_action
01:09:55 INFO - Running main action method: install
01:09:55 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'freeze']
01:09:55 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip freeze
01:09:55 INFO - Reading from file tmpfile_stdout
01:09:55 INFO - Using _rmtree_windows ...
01:09:55 INFO - Using _rmtree_windows ...
01:09:55 INFO - Detecting whether we're running mozinstall >=1.0...
01:09:55 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build/venv/scripts/python', 'C:\\slave\\test-pgo\\build/venv/scripts/mozinstall-script.py', '-h']
01:09:55 INFO - Copy/paste: C:\slave\test-pgo\build/venv/scripts/python C:\slave\test-pgo\build/venv/scripts/mozinstall-script.py -h
01:09:55 INFO - Reading from file tmpfile_stdout
01:09:55 INFO - Output received:
01:09:55 INFO - Usage: mozinstall-script.py [options] installer
01:09:55 INFO - Options:
01:09:55 INFO - -h, --help show this help message and exit
01:09:55 INFO - -d DEST, --destination=DEST
01:09:55 INFO - Directory to install application into. [default:
01:09:55 INFO - "C:\slave\test-pgo"]
01:09:55 INFO - --app=APP Application being installed. [default: firefox]
01:09:55 INFO - Using _rmtree_windows ...
01:09:55 INFO - Using _rmtree_windows ...
01:09:55 INFO - mkdir: C:\slave\test-pgo\build\application
01:09:55 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-45.0.en-US.win32.zip', '--destination', 'C:\\slave\\test-pgo\\build\\application']
01:09:55 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-45.0.en-US.win32.zip --destination C:\slave\test-pgo\build\application
01:09:59 INFO - Reading from file tmpfile_stdout
01:09:59 INFO - Output received:
01:09:59 INFO - C:\slave\test-pgo\build\application\firefox\firefox.exe
01:09:59 INFO - Using _rmtree_windows ...
01:09:59 INFO - Using _rmtree_windows ...
01:09:59 INFO - Running post-action listener: _resource_record_post_action
01:09:59 INFO - #####
01:09:59 INFO - ##### Running run-tests step.
01:09:59 INFO - #####
01:09:59 INFO - Running pre-action listener: _resource_record_pre_action
01:09:59 INFO - Running main action method: run_tests
01:09:59 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\python', '--version']
01:09:59 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\python --version
01:09:59 INFO - Python 2.7.3
01:09:59 INFO - Return code: 0
01:09:59 INFO - grabbing minidump binary from tooltool
01:09:59 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')]}
01:09:59 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 0x012B8C98>, '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 0x012DA860>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0197D5C0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'privileged': False}, attempt #1
01:09:59 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
01:09:59 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
01:09:59 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'...
01:10:01 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test-pgo\build\tmpuamiv6
01:10:01 INFO - INFO - File integrity verified, renaming tmpuamiv6 to win32-minidump_stackwalk.exe
01:10:01 INFO - Return code: 0
01:10:01 INFO - Chmoding C:\slave\test-pgo\build\win32-minidump_stackwalk.exe to 0755
01:10:01 INFO - mkdir: C:\slave\test-pgo\build\blobber_upload_dir
01:10:01 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test-pgo\build\blobber_upload_dir
01:10:01 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test-pgo\build\win32-minidump_stackwalk.exe
01:10:01 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test-pgo\build\blobber_upload_dir
01:10:01 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\flake8', 'C:\\slave\\test-pgo\\build\\tests\\talos\\talos']
01:10:01 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\flake8 C:\slave\test-pgo\build\tests\talos\talos
01:10:02 INFO - Return code: 0
01:10:02 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\python', 'C:\\slave\\test-pgo\\build\\tests\\talos\\talos\\run_tests.py', '--debug', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test-pgo\\build\\application\\firefox\\firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-win32/1455832105/firefox-45.0.en-US.win32.crashreporter-symbols.zip', '--title', 'T-W732-IX-157', '--webServer', 'localhost'] in C:\slave\test-pgo\build
01:10:02 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\python C:\slave\test-pgo\build\tests\talos\talos\run_tests.py --debug --branchName Mozilla-Beta --suite dromaeojs --executablePath C:\slave\test-pgo\build\application\firefox\firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-win32/1455832105/firefox-45.0.en-US.win32.crashreporter-symbols.zip --title T-W732-IX-157 --webServer localhost
01:10:02 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
01:10:02 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming',
01:10:02 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files',
01:10:02 INFO - 'COMPUTERNAME': 'T-W732-IX-157',
01:10:02 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
01:10:02 INFO - 'CYGWINBASE': 'C:\\cygwin',
01:10:02 INFO - 'DCLOCATION': 'SCL3',
01:10:02 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
01:10:02 INFO - 'FP_NO_HOST_CHECK': 'NO',
01:10:02 INFO - 'HOMEDRIVE': 'C:',
01:10:02 INFO - 'HOMEPATH': '\\Users\\cltbld',
01:10:02 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
01:10:02 INFO - 'KTS_VERSION': '1.19c',
01:10:02 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local',
01:10:02 INFO - 'LOGONSERVER': '\\\\T-W732-IX-157',
01:10:02 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test-pgo\\build\\blobber_upload_dir',
01:10:02 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test-pgo\\build\\win32-minidump_stackwalk.exe',
01:10:02 INFO - 'MONDIR': 'C:\\Monitor_config\\',
01:10:02 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
01:10:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
01:10:02 INFO - 'MOZ_NO_REMOTE': '1',
01:10:02 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test-pgo\\build\\blobber_upload_dir',
01:10:02 INFO - 'NO_EM_RESTART': '1',
01:10:02 INFO - 'NUMBER_OF_PROCESSORS': '8',
01:10:02 INFO - 'OS': 'Windows_NT',
01:10:02 INFO - 'OURDRIVE': 'C:',
01:10:02 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;',
01:10:02 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
01:10:02 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
01:10:02 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel',
01:10:02 INFO - 'PROCESSOR_LEVEL': '6',
01:10:02 INFO - 'PROCESSOR_REVISION': '1e05',
01:10:02 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
01:10:02 INFO - 'PROGRAMFILES': 'C:\\Program Files',
01:10:02 INFO - 'PROMPT': '$P$G',
01:10:02 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json',
01:10:02 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
01:10:02 INFO - 'PUBLIC': 'C:\\Users\\Public',
01:10:02 INFO - 'PWD': 'C:\\slave\\test-pgo',
01:10:02 INFO - 'PYTHONPATH': 'C:\\slave\\test-pgo\\build\\tests\\talos',
01:10:02 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
01:10:02 INFO - 'SLAVEDIR': 'C:\\slave\\',
01:10:02 INFO - 'SYSTEMDRIVE': 'C:',
01:10:02 INFO - 'SYSTEMROOT': 'C:\\windows',
01:10:02 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
01:10:02 INFO - 'TEST1': 'testie',
01:10:02 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp',
01:10:02 INFO - 'USERDOMAIN': 'T-W732-IX-157',
01:10:02 INFO - 'USERNAME': 'cltbld',
01:10:02 INFO - 'USERPROFILE': 'C:\\Users\\cltbld',
01:10:02 INFO - 'WINDIR': 'C:\\windows',
01:10:02 INFO - 'WINDOWS_TRACING_FLAGS': '3',
01:10:02 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log',
01:10:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
01:10:02 INFO - Calling ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\python', 'C:\\slave\\test-pgo\\build\\tests\\talos\\talos\\run_tests.py', '--debug', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test-pgo\\build\\application\\firefox\\firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-win32/1455832105/firefox-45.0.en-US.win32.crashreporter-symbols.zip', '--title', 'T-W732-IX-157', '--webServer', 'localhost'] with output_timeout 3600
01:10:04 INFO - mozversion INFO | application_buildid: 20160218134825
01:10:04 INFO - mozversion INFO | application_changeset: 32608d640a8c72afc6f16c1883e08846aa80905d
01:10:04 INFO - mozversion INFO | application_display_name: Nightly
01:10:04 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384}
01:10:04 INFO - mozversion INFO | application_name: Firefox
01:10:04 INFO - mozversion INFO | application_remotingname: firefox
01:10:04 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta
01:10:04 INFO - mozversion INFO | application_vendor: Mozilla
01:10:04 INFO - mozversion INFO | application_version: 45.0
01:10:04 INFO - mozversion INFO | platform_buildid: 20160218134825
01:10:04 INFO - mozversion INFO | platform_changeset: 32608d640a8c72afc6f16c1883e08846aa80905d
01:10:04 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta
01:10:04 INFO - mozversion INFO | platform_version: 45.0
01:10:04 INFO - 2016-02-19 01:10:04,091 DEBUG : using testdate: 1455873004
01:10:04 INFO - 2016-02-19 01:10:04,091 DEBUG : actual date: 1455873004
01:10:04 INFO - 2016-02-19 01:10:04,141 INFO : starting webserver on 'localhost:49817'
01:10:04 INFO - 2016-02-19 01:10:04,141 INFO : Starting test suite T-W732-IX-157
01:10:04 INFO - 2016-02-19 01:10:04,141 INFO : Starting test dromaeo_css
01:10:04 INFO - 2016-02-19 01:10:04,141 DEBUG : operating with platform_type : w7_
01:10:04 INFO - 2016-02-19 01:10:04,142 INFO : Initialising browser for dromaeo_css test...
01:10:04 INFO - 2016-02-19 01:10:04,296 DEBUG : command line: C:\slave\test-pgo\build\application\firefox\firefox -profile c:\users\cltbld\appdata\local\temp\tmpgn2i87\profile http://localhost:49817/getInfo.html
01:10:13 INFO - 2016-02-19 01:10:13,986 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200
01:10:13 INFO - 2016-02-19 01:10:13,986 DEBUG : BROWSER_OUTPUT: colorDepth:24
01:10:13 INFO - 2016-02-19 01:10:13,986 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674
01:10:13 INFO - 2016-02-19 01:10:13,986 DEBUG : BROWSER_OUTPUT: __metrics
01:10:14 INFO - 2016-02-19 01:10:14,105 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver]
01:10:15 INFO - 2016-02-19 01:10:15,440 INFO : Browser initialized.
01:10:15 INFO - 2016-02-19 01:10:15,440 INFO : Running cycle 1/1 for dromaeo_css test...
01:10:15 INFO - 2016-02-19 01:10:15,440 DEBUG : command line: C:\slave\test-pgo\build\application\firefox\firefox -profile c:\users\cltbld\appdata\local\temp\tmpgn2i87\profile -tp file:\C:\slave\test-pgo\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1
01:10:16 INFO - 2016-02-19 01:10:16,023 DEBUG : BROWSER_OUTPUT: [GFX1-]: Invalid size in UpdateRenderTarget Size(116,0), 0
01:10:26 INFO - 2016-02-19 01:10:26,898 DEBUG : BROWSER_OUTPUT: RSS: Main: 107794432
01:10:26 INFO - 2016-02-19 01:10:26,898 DEBUG : BROWSER_OUTPUT:
01:11:18 INFO - 2016-02-19 01:11:18,309 DEBUG : BROWSER_OUTPUT: 1455873078320 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no]
01:13:27 INFO - 2016-02-19 01:13:27,063 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49817/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49817/tests/dromaeo/cssquery-ext.html)
01:13:28 INFO - 2016-02-19 01:13:28,104 DEBUG : BROWSER_OUTPUT: RSS: Main: 172109824
01:13:28 INFO - 2016-02-19 01:13:28,105 DEBUG : BROWSER_OUTPUT:
01:16:30 INFO - 2016-02-19 01:16:30,088 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49817/tests/dromaeo/cssquery-ext.html (next: http://localhost:49817/tests/dromaeo/cssquery-jquery.html)
01:16:30 INFO - 2016-02-19 01:16:30,648 DEBUG : BROWSER_OUTPUT: RSS: Main: 180740096
01:16:30 INFO - 2016-02-19 01:16:30,648 DEBUG : BROWSER_OUTPUT:
01:19:32 INFO - 2016-02-19 01:19:32,403 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49817/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49817/tests/dromaeo/cssquery-mootools.html)
01:19:32 INFO - 2016-02-19 01:19:32,963 DEBUG : BROWSER_OUTPUT: RSS: Main: 152977408
01:19:32 INFO - 2016-02-19 01:19:32,963 DEBUG : BROWSER_OUTPUT:
01:22:34 INFO - 2016-02-19 01:22:34,703 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49817/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49817/tests/dromaeo/cssquery-prototype.html)
01:22:35 INFO - 2016-02-19 01:22:35,257 DEBUG : BROWSER_OUTPUT: RSS: Main: 123092992
01:22:35 INFO - 2016-02-19 01:22:35,257 DEBUG : BROWSER_OUTPUT:
01:25:37 INFO - 2016-02-19 01:25:37,818 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49817/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49817/tests/dromaeo/cssquery-yui.html)
01:25:38 INFO - 2016-02-19 01:25:38,378 DEBUG : BROWSER_OUTPUT: RSS: Main: 148307968
01:25:38 INFO - 2016-02-19 01:25:38,378 DEBUG : BROWSER_OUTPUT:
01:28:40 INFO - 2016-02-19 01:28:40,392 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49817/tests/dromaeo/cssquery-yui.html (next: http://localhost:49817/tests/dromaeo/cssquery-dojo.html)
01:28:40 INFO - 2016-02-19 01:28:40,648 DEBUG : BROWSER_OUTPUT: RSS: Main: 166662144
01:28:40 INFO - 2016-02-19 01:28:40,648 DEBUG : BROWSER_OUTPUT:
01:28:40 INFO - 2016-02-19 01:28:40,648 DEBUG : BROWSER_OUTPUT: __start_tp_report
01:28:40 INFO - 2016-02-19 01:28:40,648 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load
01:28:40 INFO - 2016-02-19 01:28:40,648 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details
01:28:40 INFO - 2016-02-19 01:28:40,648 DEBUG : BROWSER_OUTPUT: |i|pagename|runs|
01:28:40 INFO - 2016-02-19 01:28:40,648 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2939.2504911247634;2970.539566367214;2977.478941185295;3018.9245268868276;3030.287882347648;5308.442613525582;5325.786968521259;5362.678239305639;5382.67703937764;5399.514043736063;5168.664036837603;5413.350397952251;5427.402985671582;5493.093639549469;5495.395506494282;4509.413776209105;4523.253663145577;4593.563611456906;4726.716397016182;4775.068861571995;4461.107778444308;4571.885702857422;4588.885277868047;4690.366800481926;4699.859004229878;4489.46126464823;4675.8831029224375;4696.9530304696855;4737.620990320784;4753.263244197137;4341.39220509129;4414.271645178542;4420.734755914623;4458.152950939328;4487.349334346534;4607.792649330788;4629.328747331618;4661.3241080043545;4684.0397718467975;4700.224462963607;4858.708477491362;4885.340479035321;4926.704397736112;5120.359955005624;5158.97420512895;5143.3570803649545;5270.472952704698;5422.810201642924;5495.780168793243;5496.422875598085;4759.190937540627;5291.523762861361;5573.693446860421;5575.470330318653;5630.521405680522;4695.694779839299;4891.3396691446915;4955.231939049453;4977.800887964477;5037.4458809530925;5356.303680521507;5656.886862262814;5737.770489180386;5806.88386232273;5814.186013958049;5130.127878260705;5146.716930568779;5237.423883372826;5297.708626025528;5486.91769623456;5172.405173405106;5177.663451875616;5185.67765219874;5186;5196;5540.529055030287;5589.0219211637805;5634.97182514093;5658.405867383948;5663.377028526858;5578.41426650204;5582.637128586629;5589.888202236014;5641.464060914206;5660.603757737002;3512.051746028558;3555.9644403555635;3563.376409128444;3568.0901370150445;3604.4052731299043;3041.2092855857636;3102.953455698166;3271.9509207361907;3274.476083826576;3283.589551306087;4941.827036053721;4980.551750342486;5013.5989120870245;5031.949680503149;5349.037173308841;5217.321748172713;5324.787008519694;5616.073347897633;5679.744411501492;5687.829365119053;4920.114379411669;5125.718085505333;5215.217717342429;5221.791128354899;5300.9734951325;4020.9143531246987;4408.955910440919;4454.930816603992;4512.300593408027;4532.252178390529;5666.631668941505;5861.238039054981;5862.384449632727;5942.732577034044;5975.7609695612555;5133.820316288912;5193.246979188072;5237.921431178612;5267.183586544092;5570.637908535932;5419.268398766116;5460.26286451324;5487.917681234864;5513.558915286848;5550.666959982253;5137.17805151174;5160.690358578498;5179.352580927384;5228.9738551307;5245.895082098413;5567.220589117445;5648.71756412186;5683.5737319700365;5687.459691329317;5755.251817263729;5554;5555.0834112371;5618.157276408571;5630.493255607015;5641.379448260606;5162.664426812245;5252.818115924039;5279.812042290608;5326.813561525328;5345.4654534546235;4924.8768780780765;4963.156263435297;4974.925376119433;5183.5593974512585;5403.675779453245;5486.231927530069;5533.335999680065;5575.163725441216;5591.04952158126;5628.183913332626;5413.566914646897;5431.592630552804;5526.861828454321;5529.142982837667;5530.115181570929
01:28:40 INFO - 2016-02-19 01:28:40,648 DEBUG : BROWSER_OUTPUT: |1;ext.html;481.6820898207184;504.77032950007737;506.8530126263383;517.5342192027175;528.4636094364223;32234.516482252784;32750.853720119772;32778.67221327786;38494.80752596233;40294.59705402945;38988.415173772344;40166;41661.375079373836;41709;41880.581194188046;8060.193980601952;8121.512709237465;8190.058143313506;8195.71315003975;8205.220504052106;7732.381409487228;7853;10444.216683748711;10489.423081730502;10659.733506662356;9899;9949.552270147824;10065.64770233042;10537;10565.313254638462;7989.760307190793;8147.185281471865;9994.350367226107;10360.896391036069;10399.428031458267;10030.49847507629;10418.479076046167;10658.946705266502;10664.200184986157;10664.573417063308;37548.81225593882;38894.80552597247;39193.60806391928;39285.80357098196;39323.41014884779;3060.1125673554643;3578.1949061461223;3804.8478060877533;3809.5428548574073;3850.3454412749898;31131.533027004614;31191;31409.371812563622;31417.84291078553;31756.364872702416;3607.3867442534834;3649.799261040642;3750.306193354238;3765.6987441004926;3855.20968201518;294875.57686634717;295019.1724117238;314674;314810.99999999773;314911;49692.50307496879;51562;56566.7171664139;56983;56995.43004569984;48480.75759621179;48819.511804882204;56727.43272567304;60081.399186007584;60917.08624370638;14818.481353152589;15008.399664013317;15029.549113526611;15075.39698412073;15087.24563771829;11358.375289358999;11382.544698212145;11507.88492115085;11511.15821468561;11533.653990380302;18367.632647347247;18370.448886533424;18728.50171986238;18807.905960470383;19416.22335106608;7220.855582888313;7599.4680372373405;7677.884831727529;7763.417743669247;7771.417143714244;861.8017855893054;970.7815741458256;998.7902540466438;1043.113353649392;1043.4626167523732;28790.280242993675;29080.709192908223;29111.85444072766;29514.262143446587;29537.852310738308;1017.5268500147318;1040.47976011994;1042.8852826189113;1052.410650035967;1093.0763504838399;14858.702825943421;15023.924880375747;15130;15212.653216292398;15397.769033464507;360333;364752;374375;400844;520453;49700.751496243014;50113.498865011614;50224;50234.246486302734;50341.24488132681;1204.1691233049169;1204.753025629744;1207.6075275535661;1213.2356615332285;1213.9878601213875;25194.874025629753;27684.44631107407;30373;30891.69108308888;31515.369692606477;47065.29402058903;47478.76260618675;47536.7623161882;47571.28643070426;47679;326034;328026;328471;330210;330234;26849.597256040783;27178.592321115593;27292;27329.86335068312;27335.86332068327;42386.636273399396;43191.97656164038;43303.78348108239;43374;43387;35734.64265357417;35743.46384804178;36641.70224679792;36676.26647467089;37109.628903711695;28551.0021447745;35645;36067;36594.45108323324;37677.434838477995;27980.44039119247;32584.185395365304;34575.65424345724;34662.13344666403;34759.47860782141;29758;31093.533596996516;31269.530957035207;31542.842285788425;32605;24704.382390440383;25811.870940645178;25885.09402170915;26224.8688756555;26291
01:28:40 INFO - 2016-02-19 01:28:40,651 DEBUG : BROWSER_OUTPUT: |2;jquery.html;285.3422860306992;298.58347605090887;298.86551052026584;299.71077909817024;304.403369395984;12686.619401417973;15543.84456155438;15610.219489025532;15731.52805415838;16254;10098.29311948164;10292.382457052581;16953.660926781457;17075.74386384202;17104.914475427635;4627.3984382030285;4711.081339138852;4711.481737008943;4720.055988802236;4720.90558188836;4036.535798383194;4126.298529250034;4129.814158362866;4701.388819453483;5281.287026251464;5361.356637203541;5379.435159308256;5384.1923711443405;5384.40771515135;5392.838214853541;4967.155583550769;5183;5351.57187425005;5363.08827499328;5367.275417818603;4938.654294199408;4939.357883475125;4953.90092198154;4956.529129732669;4958.380202474691;11589.6523104307;11647.068234541217;11971.521139154424;11999.580014699444;12000.97991670709;1782.082227652747;1843.603625220584;1904.419152158591;1916.9424917252504;1929.8842069475736;8645.827083458358;8731.083236260165;8807.867881981776;9170.266378689688;9332.206762425201;1685.8819882608223;1765.682177208102;1768.142450911307;1771.3003363671278;1792.6414717056641;62229;63308;70804.64597676978;71486.28513714849;74276.25723742748;9328.020557841464;9435.952820235854;9464.384814987141;9683.176929960891;9720.31957762964;11645.825312620318;11657;11697.649070527897;11701.765964680659;11710.824337634942;7378.704851805975;7537.2462753724185;7719.729809456642;7736.845263094707;7824.295813376823;7667.888156217317;8064.919350806535;8066.23370779775;8108.716194933149;8157.306628936488;3870.1098747288283;3930.272899513599;3935.763854168759;3937.1928754605237;3942.2312649033165;1490.2548725637182;1511.727888979994;1573.3156077106496;1614.467225815478;1616.183827167273;378.5230609432135;378.73110091835105;399.6922369775315;402.54110314241785;844.4553263145237;9542.666006689871;9740.75648108803;10344.586216551405;10367.896321036693;10445.582176712998;389.96880249580533;407.1754696739127;412.34848938676816;428.5007965719901;428.66992415839627;5527.115661494222;5537.612367134262;5556.97221513898;5559.944400555943;5736.340320863071;441915;443056;444043;444264;445147;80554;81610.59194703988;82800.10199643104;82924;85096.57451712702;432.2047432723803;436.4391756592763;437.7220465004745;438.63812354807413;438.90124721937946;9231.953840230755;9384.733061036673;9691.224702023681;9861.260405469475;9963.452010139223;36700.26599468049;37062.814685926394;38230.20705237867;38303.61696383112;38530.422043668805;49274;49650.255246172055;49801.750991244815;50525.74737126291;53021.73489132529;8672.392932494664;8781.912180878366;8899.73300800977;8904.332175087024;8925.661150827427;10678.519466623866;10716.249862509549;10719.678409647722;10745.409002504937;10783.838242426527;9601.807963840824;12025.218360806519;12135.393230338272;12981.675458113623;15193.392264309305;14376.784348234994;14700.117992920459;14704.926475367554;14818.851811481747;15001.924990374979;15293.694126117638;15333.310035994193;15604.297806598503;15760.92119539395;15808.446704365291;7622.504537205064;7640.044994375703;8408;8485.236328730443;8501.234888860032;14758.48345307909;14919.92540037293;15020.248987550798;15087.698246035237;15137.924310378377
01:28:40 INFO - 2016-02-19 01:28:40,653 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1428.9142651440914;1448.0804689022475;1459.3141223624893;1477.0915886729665;1487.3084015932588;6631.834204144899;7239.529430587008;7321.3410793028615;7329.267073292668;7331.193568707451;7424.665890034948;7442.851142977151;7466.664000119994;7476.514026588268;7478.588677622729;2090.7491101067894;2102.211670623516;2115.904784284703;2117.4071260047135;2118.1739121742535;2093.41384412364;2109.072008316336;2146.334636262756;2154.0737482882355;2155.062547791708;1883.6797744383418;1937.4962509747497;1941.2041063164106;2109.0614676468977;2125.362391282617;1860.8604354673387;1938.7964263752315;1960.549073713054;2096.5282811367474;2097.6119417907735;2063.0613071052635;2081.5004398944143;2089;2095.497080700636;2096.622607930572;6203.720832562545;6336.651484168369;7308.926910730877;7318;7356.1540422850985;4160.543809666623;4212.726172798758;4337.414449049401;4393.51671316155;4409;3088.644805847334;3136.0591822453403;3188.617365916082;3193.2016995751064;3195.6165260168696;967.8451447768323;968.5109019944882;972.547765289144;998.9450580218086;1007.1388962437084;9514.524273786283;9741.269404794597;9814.656487022992;9836.835896102917;9862.30963832532;3947.940780888289;4060.6954478414236;4124.587541245912;4133.586641335903;4147.460830092069;8487.236148746519;8526.488410695378;8534;8544.871826922601;8573.27127194183;4556.3393307970155;4566.429196350457;4570.108828778356;4571.085782843445;4576.222042252825;4192.937105943413;4209.158168366339;4211;4214.978925105416;4219.493660760667;3164.8575814087962;3169.508726147451;3201.3597280543986;3243.626982896997;3257.397381484433;952.2429668413628;963.3882484622316;969.030969030969;970.8592254123254;1030.4590090202553;1115.682030621269;1135.8693750218831;1136.6817291158488;1136.732867776072;1138.1009002887793;6614.173228346457;6760.898586521206;6834.692438840264;6985.057017302599;6988;397.18180548071064;416.30684909625137;418.15323968963094;419.40653974625565;422.4719101123595;4827.975860120747;5422.945770542323;5424.457554244623;5508.531774799107;5512.889742205133;7212.7114915403845;8024.277814996678;8101.756947291591;8553.144685531397;8613.526256055851;8547.95726021366;8595.742127736177;8603.827923441497;8608.225259726654;8627.309815214769;6917.827054323581;7005.859882802315;7006.0892084029765;7007.509474336849;7013.789586312419;6422.903656445251;6648.335166483506;6809.080774095433;6811.863762724619;6825.795226143224;8027.638756255866;8128.471649342774;8188.672453102047;8190.631421585924;8202.097769245498;8344.123866993878;8405.95797021011;8419.957900210704;8423.620937057725;8426.578671066545;6281.842953926189;6287.465565426807;6332.30344662096;6362.077498762561;6660.866782664222;6626.171728533934;6790.117284752951;7084.149902011792;7185.748498802517;7203.8919416207755;5974.402559744165;6671;6705.497087718343;6847.726090956306;6855.828604284933;6359.87280254383;6393.744250230125;6498.480121590167;6526.543141980016;6782;5980.641161530148;6613.875641141114;6669.966650166718;6679.632620205935;6683.231428385798;6113.816585502442;6158.630482171084;6172.506199504119;6173.41352571505;6174.6912654368;6175.197224360984;6214.130021796862;6230.096635987847;6273;6274.278457977209
01:28:40 INFO - 2016-02-19 01:28:40,740 DEBUG : BROWSER_OUTPUT: |4;prototype.html;291.9912402627922;292.09741897536617;298.6386472368434;298.9790714649974;301.6561120322831;6085.452309292163;6106.389361063892;6109.083637454384;6136.447719705226;6176.197094377724;5632.831015069544;5893.322267939177;6007.158997740309;6078.817635470932;6114.541409394302;4375.453068366454;4379.496357918848;4385.407969924051;4388.319810429381;4392.901774556361;4137.345061975204;4404.911901761963;4406.140802543506;4409.735415875058;4415.80128894199;4043.939340909889;4057.5536690963972;4130.545639979599;4192.2244384788755;4374.365716971038;4071.8598792338194;4199.076203235283;4366.126774645084;4371.125774845028;4378.605925466723;3784.791836448994;3797.4493698413576;3798;3798.620137986207;3800.6009369016133;5929.673867937262;5938.5546084043435;5946.762129514815;5948.13752005961;5949.226600541945;5158.587313014988;5167.638265321429;5171.612129090333;5175.81884634036;5176.948230517722;6097.237845269341;6281.120643109923;6281.811545653592;6284.057391391282;6284.591501552384;4113.382992551112;4118.938215926763;4121.113960498477;4121.732087414309;4124.608162224584;6156.3843615638525;6182.474489668383;6588.571742836748;6590.604563726191;6599.043138744903;4258.084511829971;4263.211305908417;4266.31738921771;4275.102228532043;4275.978620106879;4057.594240575919;4087.2438598859308;4141.088960428701;4171.124063946605;4290.905819016193;5047.974760126176;5073.11220536412;5087.923681144785;5091.287219789232;5098.133317336062;6214.192155019909;6305.4009869062365;6308.905366419507;6325.810225693236;6334.081558174131;1409.1052181864384;1426.7788492783636;1427.7435856446261;1428.6714055767025;1464.2971373740452;914.9085091490798;936.5832204668857;947.1759569174862;984.2863923655293;991.7322322972757;5865.853353666107;6106.908396374058;6113.205283313141;6115.235595550556;6119.877602448015;6526.510511711641;6541.803745887631;6554.8361290968105;6554.934450655528;6562.967185164043;6094.908576371358;6098.32918378978;6103.481204097613;6111.877762444815;6113.052476866093;3333.2500187458113;3439.466882633196;3494.759360427063;3502.3345564342694;3508.245727168671;6536.248331441945;6554;6573.5069869759;6936.93063069373;6943.618101004493;6285.59143655661;6363.872722545523;6599.373059559334;6637.601743895381;6669.266380698119;6904.585724856524;6905.343992320722;6916.6541672916155;6930.237673855871;6933.168019837652;6471.967640161769;6564.671766411756;6568.211814582281;6575.5725877819705;6592.17597800275;6496.707648155939;6498.545101842826;6516.022596610546;6518.804435866931;6521.543491955517;6621.50338724588;6941.47938904574;6961.234264231032;6961.8955715665315;6982.825429364103;4229.154169166118;4253.276942919773;4253.744775313491;4254.425652536868;4255.0426154115075;6449.129367535323;6645.9366501359555;6650.667466626746;6653.833654158491;6666.200055993312;6459.838504037437;6475.838104047248;6479.546431749733;6480.092787009917;6480.25477070143;6186.783462578788;6391.616503009835;6405.775797847053;6413.42279194856;6418.358164183544;5933.821985340447;5963.821085367446;6057.667313191091;6263;6280.623162610258;5895.882082358415;6064;6090.878182436415;6243.406876346739;6447.774327898501;5750.137479378127;5871.442212989759;5985.371535988658;6019.969900150471;6305.306416294296
01:28:40 INFO - 2016-02-19 01:28:40,740 DEBUG : BROWSER_OUTPUT: |5;yui.html;755.6372940988329;775.7982924439648;777.1451403456199;788.3220430429833;793.7975816166877;12142.210756300834;13443.395047222873;13662.111962722416;13878.444862205499;14033.578992630237;11963.1625786195;12054.216475929059;12222.877771222285;12297.569585064524;13060.346982650854;514.8455463360996;518.6550943622486;519.0553193188399;622.7758007117434;623.6632218601961;514.6603241860373;626.8871603111438;636.7293900092442;637.611057255074;640.9487241020707;610.3133974278936;627.1533429869685;659.3472462262349;663.9269680335159;664.2427632498955;546.6282927609224;571.1204744693167;659.7789740436959;661.3485716569176;661.9768308109241;393.14490982114074;401.47206423552933;450.58095970747195;483.0291114859123;483.46335567520026;12137.696557586043;12161;12182.025437964941;12190.634280971584;12253.754924901452;12012;12018.4591693374;12246.203996740272;12765.106442549026;13012.609621711365;10879.945600272027;11012.834807477895;11267.661970140909;11329.150313726503;11364.204505684605;3583.498310236569;3597.6402359764074;3639.253952939641;3675.1363429594026;3684.7604905681046;52132.73933630346;52187.739061304834;52384.47615523834;54125.1881221782;54655.453445465435;9945.950270248602;10057.59769609222;10175.433384334401;10217.18262538995;10482.161427085815;17285.56786080333;17512.38706645261;17801.109944502983;17815.910920445574;17818.732719009226;7374;7613.390928725688;7682.0397450318715;7706.306432420997;7747.2640099190485;4183.247015537232;4315.719478233905;4373.912521749611;4421.4915284742665;4462.977685111554;3121.781475296753;3140;3154.1326135312975;3155.3689262147204;3168.8098714077228;581.314049421678;588.326366310572;608.8721368512662;611.2634275697774;616.5838059310038;718.7017387784116;736.1975446763054;757.6969212315119;767.5931756169239;770.0720631638861;9561.90438095624;9940.850887236697;10067.647632332833;10323;10418.843717344245;598.979035733756;737.5906371963505;743.7025189923966;755.9886601700979;763.4083585221498;4616.446026476844;4716.127516409475;4733.952660473351;4768.928466073012;4816.349792778;63698;64307;64387.67806160939;64521.354786451535;64869;52982;55097.724511377986;56787.14819277714;57436.13845792317;57660.423395766345;55230.72384638051;55792.72103639537;56274.718626406604;57900.31495275742;58200.417995820346;10060.798784024131;10068.848967265643;10232.897671023195;10268.64059757905;10481.842772358268;41489.58510414857;41679.58320416757;41968.370474443516;42263;42376.78811606046;48324.758376207894;50380;51469.48530514647;53600.19599706086;55012;11663.88336116628;11837.644870653894;11859.466324015613;12250.693732656755;12266.938665306616;14630;14749.483768068067;14825.777613336024;14953.252337383305;15276.61808454753;13103.803442948172;13182.868171318163;13205.735885282433;13251.204927704368;14087.08433951831;12582.622521324374;12673.873261267268;13052.673683157996;13297.734045319234;13436.529721460092;11247.437628118398;12400.56598019065;13223.801642975171;13450.529231476852;13542.322883855964;11659.825102623638;11966.46150923193;11998.160128790902;12166;12602.306873122066;11468.655940321803;11570.826437603275;11751.778726873956;11799.233049851731;11805.645830625095
01:28:40 INFO - 2016-02-19 01:28:40,742 DEBUG : BROWSER_OUTPUT: __end_tp_report
01:28:40 INFO - 2016-02-19 01:28:40,742 DEBUG : BROWSER_OUTPUT: __start_cc_report
01:28:40 INFO - 2016-02-19 01:28:40,742 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,702
01:28:40 INFO - 2016-02-19 01:28:40,742 DEBUG : BROWSER_OUTPUT: __end_cc_report
01:28:40 INFO - 2016-02-19 01:28:40,742 DEBUG : BROWSER_OUTPUT: __startTimestamp1455874120669__endTimestamp
01:28:40 INFO - 2016-02-19 01:28:40,742 DEBUG : BROWSER_OUTPUT:
01:28:40 INFO - 2016-02-19 01:28:40,742 DEBUG : BROWSER_OUTPUT: ------- Summary: start -------
01:28:40 INFO - 2016-02-19 01:28:40,742 DEBUG : BROWSER_OUTPUT: Number of tests: 6
01:28:40 INFO - 2016-02-19 01:28:40,742 DEBUG : BROWSER_OUTPUT:
01:28:40 INFO - 2016-02-19 01:28:40,743 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5032.36 Median:5217.32 stddev:692.56 (13.3%) stddev-sans-first:674.94
01:28:40 INFO - 2016-02-19 01:28:40,743 DEBUG : BROWSER_OUTPUT: Values: 2939.3 2970.5 2977.5 3018.9 3030.3 5308.4 5325.8 5362.7 5382.7 5399.5 5168.7 5413.4 5427.4 5493.1 5495.4 4509.4 4523.3 4593.6 4726.7 4775.1 4461.1 4571.9 4588.9 4690.4 4699.9 4489.5 4675.9 4697.0 4737.6 4753.3 4341.4 4414.3 4420.7 4458.2 4487.3 4607.8 4629.3 4661.3 4684.0 4700.2 4858.7 4885.3 4926.7 5120.4 5159.0 5143.4 5270.5 5422.8 5495.8 5496.4 4759.2 5291.5 5573.7 5575.5 5630.5 4695.7 4891.3 4955.2 4977.8 5037.4 5356.3 5656.9 5737.8 5806.9 5814.2 5130.1 5146.7 5237.4 5297.7 5486.9 5172.4 5177.7 5185.7 5186.0 5196.0 5540.5 5589.0 5635.0 5658.4 5663.4 5578.4 5582.6 5589.9 5641.5 5660.6 3512.1 3556.0 3563.4 3568.1 3604.4 3041.2 3103.0 3272.0 3274.5 3283.6 4941.8 4980.6 5013.6 5031.9 5349.0 5217.3 5324.8 5616.1 5679.7 5687.8 4920.1 5125.7 5215.2 5221.8 5301.0 4020.9 4409.0 4454.9 4512.3 4532.3 5666.6 5861.2 5862.4 5942.7 5975.8 5133.8 5193.2 5237.9 5267.2 5570.6 5419.3 5460.3 5487.9 5513.6 5550.7 5137.2 5160.7 5179.4 5229.0 5245.9 5567.2 5648.7 5683.6 5687.5 5755.3 5554.0 5555.1 5618.2 5630.5 5641.4 5162.7 5252.8 5279.8 5326.8 5345.5 4924.9 4963.2 4974.9 5183.6 5403.7 5486.2 5533.3 5575.2 5591.0 5628.2 5413.6 5431.6 5526.9 5529.1 5530.1
01:28:40 INFO - 2016-02-19 01:28:40,743 DEBUG : BROWSER_OUTPUT:
01:28:40 INFO - 2016-02-19 01:28:40,743 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:50265.84 Median:330222.00 stddev:92374.10 (28.0%) stddev-sans-first:92557.61
01:28:40 INFO - 2016-02-19 01:28:40,743 DEBUG : BROWSER_OUTPUT: Values: 481.7 504.8 506.9 517.5 528.5 32234.5 32750.9 32778.7 38494.8 40294.6 38988.4 40166.0 41661.4 41709.0 41880.6 8060.2 8121.5 8190.1 8195.7 8205.2 7732.4 7853.0 10444.2 10489.4 10659.7 9899.0 9949.6 10065.6 10537.0 10565.3 7989.8 8147.2 9994.4 10360.9 10399.4 10030.5 10418.5 10658.9 10664.2 10664.6 37548.8 38894.8 39193.6 39285.8 39323.4 3060.1 3578.2 3804.8 3809.5 3850.3 31131.5 31191.0 31409.4 31417.8 31756.4 3607.4 3649.8 3750.3 3765.7 3855.2 294875.6 295019.2 314674.0 314811.0 314911.0 49692.5 51562.0 56566.7 56983.0 56995.4 48480.8 48819.5 56727.4 60081.4 60917.1 14818.5 15008.4 15029.5 15075.4 15087.2 11358.4 11382.5 11507.9 11511.2 11533.7 18367.6 18370.4 18728.5 18807.9 19416.2 7220.9 7599.5 7677.9 7763.4 7771.4 861.8 970.8 998.8 1043.1 1043.5 28790.3 29080.7 29111.9 29514.3 29537.9 1017.5 1040.5 1042.9 1052.4 1093.1 14858.7 15023.9 15130.0 15212.7 15397.8 360333.0 364752.0 374375.0 400844.0 520453.0 49700.8 50113.5 50224.0 50234.2 50341.2 1204.2 1204.8 1207.6 1213.2 1214.0 25194.9 27684.4 30373.0 30891.7 31515.4 47065.3 47478.8 47536.8 47571.3 47679.0 326034.0 328026.0 328471.0 330210.0 330234.0 26849.6 27178.6 27292.0 27329.9 27335.9 42386.6 43192.0 43303.8 43374.0 43387.0 35734.6 35743.5 36641.7 36676.3 37109.6 28551.0 35645.0 36067.0 36594.5 37677.4 27980.4 32584.2 34575.7 34662.1 34759.5 29758.0 31093.5 31269.5 31542.8 32605.0 24704.4 25811.9 25885.1 26224.9 26291.0
01:28:40 INFO - 2016-02-19 01:28:40,743 DEBUG : BROWSER_OUTPUT:
01:28:40 INFO - 2016-02-19 01:28:40,743 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25448.79 Median:437.08 stddev:73145.01 (16734.9%) stddev-sans-first:73325.80
01:28:40 INFO - 2016-02-19 01:28:40,743 DEBUG : BROWSER_OUTPUT: Values: 285.3 298.6 298.9 299.7 304.4 12686.6 15543.8 15610.2 15731.5 16254.0 10098.3 10292.4 16953.7 17075.7 17104.9 4627.4 4711.1 4711.5 4720.1 4720.9 4036.5 4126.3 4129.8 4701.4 5281.3 5361.4 5379.4 5384.2 5384.4 5392.8 4967.2 5183.0 5351.6 5363.1 5367.3 4938.7 4939.4 4953.9 4956.5 4958.4 11589.7 11647.1 11971.5 11999.6 12001.0 1782.1 1843.6 1904.4 1916.9 1929.9 8645.8 8731.1 8807.9 9170.3 9332.2 1685.9 1765.7 1768.1 1771.3 1792.6 62229.0 63308.0 70804.6 71486.3 74276.3 9328.0 9436.0 9464.4 9683.2 9720.3 11645.8 11657.0 11697.6 11701.8 11710.8 7378.7 7537.2 7719.7 7736.8 7824.3 7667.9 8064.9 8066.2 8108.7 8157.3 3870.1 3930.3 3935.8 3937.2 3942.2 1490.3 1511.7 1573.3 1614.5 1616.2 378.5 378.7 399.7 402.5 844.5 9542.7 9740.8 10344.6 10367.9 10445.6 390.0 407.2 412.3 428.5 428.7 5527.1 5537.6 5557.0 5559.9 5736.3 441915.0 443056.0 444043.0 444264.0 445147.0 80554.0 81610.6 82800.1 82924.0 85096.6 432.2 436.4 437.7 438.6 438.9 9232.0 9384.7 9691.2 9861.3 9963.5 36700.3 37062.8 38230.2 38303.6 38530.4 49274.0 49650.3 49801.8 50525.7 53021.7 8672.4 8781.9 8899.7 8904.3 8925.7 10678.5 10716.2 10719.7 10745.4 10783.8 9601.8 12025.2 12135.4 12981.7 15193.4 14376.8 14700.1 14704.9 14818.9 15001.9 15293.7 15333.3 15604.3 15760.9 15808.4 7622.5 7640.0 8408.0 8485.2 8501.2 14758.5 14919.9 15020.2 15087.7 15137.9
01:28:40 INFO - 2016-02-19 01:28:40,746 DEBUG : BROWSER_OUTPUT:
01:28:40 INFO - 2016-02-19 01:28:40,746 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5087.69 Median:6284.65 stddev:2659.68 (42.3%) stddev-sans-first:2652.93
01:28:40 INFO - 2016-02-19 01:28:40,746 DEBUG : BROWSER_OUTPUT: Values: 1428.9 1448.1 1459.3 1477.1 1487.3 6631.8 7239.5 7321.3 7329.3 7331.2 7424.7 7442.9 7466.7 7476.5 7478.6 2090.7 2102.2 2115.9 2117.4 2118.2 2093.4 2109.1 2146.3 2154.1 2155.1 1883.7 1937.5 1941.2 2109.1 2125.4 1860.9 1938.8 1960.5 2096.5 2097.6 2063.1 2081.5 2089.0 2095.5 2096.6 6203.7 6336.7 7308.9 7318.0 7356.2 4160.5 4212.7 4337.4 4393.5 4409.0 3088.6 3136.1 3188.6 3193.2 3195.6 967.8 968.5 972.5 998.9 1007.1 9514.5 9741.3 9814.7 9836.8 9862.3 3947.9 4060.7 4124.6 4133.6 4147.5 8487.2 8526.5 8534.0 8544.9 8573.3 4556.3 4566.4 4570.1 4571.1 4576.2 4192.9 4209.2 4211.0 4215.0 4219.5 3164.9 3169.5 3201.4 3243.6 3257.4 952.2 963.4 969.0 970.9 1030.5 1115.7 1135.9 1136.7 1136.7 1138.1 6614.2 6760.9 6834.7 6985.1 6988.0 397.2 416.3 418.2 419.4 422.5 4828.0 5422.9 5424.5 5508.5 5512.9 7212.7 8024.3 8101.8 8553.1 8613.5 8548.0 8595.7 8603.8 8608.2 8627.3 6917.8 7005.9 7006.1 7007.5 7013.8 6422.9 6648.3 6809.1 6811.9 6825.8 8027.6 8128.5 8188.7 8190.6 8202.1 8344.1 8406.0 8420.0 8423.6 8426.6 6281.8 6287.5 6332.3 6362.1 6660.9 6626.2 6790.1 7084.1 7185.7 7203.9 5974.4 6671.0 6705.5 6847.7 6855.8 6359.9 6393.7 6498.5 6526.5 6782.0 5980.6 6613.9 6670.0 6679.6 6683.2 6113.8 6158.6 6172.5 6173.4 6174.7 6175.2 6214.1 6230.1 6273.0 6274.3
01:28:40 INFO - 2016-02-19 01:28:40,746 DEBUG : BROWSER_OUTPUT:
01:28:40 INFO - 2016-02-19 01:28:40,746 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5211.77 Median:6092.89 stddev:1661.14 (27.3%) stddev-sans-first:1624.24
01:28:40 INFO - 2016-02-19 01:28:40,746 DEBUG : BROWSER_OUTPUT: Values: 292.0 292.1 298.6 299.0 301.7 6085.5 6106.4 6109.1 6136.4 6176.2 5632.8 5893.3 6007.2 6078.8 6114.5 4375.5 4379.5 4385.4 4388.3 4392.9 4137.3 4404.9 4406.1 4409.7 4415.8 4043.9 4057.6 4130.5 4192.2 4374.4 4071.9 4199.1 4366.1 4371.1 4378.6 3784.8 3797.4 3798.0 3798.6 3800.6 5929.7 5938.6 5946.8 5948.1 5949.2 5158.6 5167.6 5171.6 5175.8 5176.9 6097.2 6281.1 6281.8 6284.1 6284.6 4113.4 4118.9 4121.1 4121.7 4124.6 6156.4 6182.5 6588.6 6590.6 6599.0 4258.1 4263.2 4266.3 4275.1 4276.0 4057.6 4087.2 4141.1 4171.1 4290.9 5048.0 5073.1 5087.9 5091.3 5098.1 6214.2 6305.4 6308.9 6325.8 6334.1 1409.1 1426.8 1427.7 1428.7 1464.3 914.9 936.6 947.2 984.3 991.7 5865.9 6106.9 6113.2 6115.2 6119.9 6526.5 6541.8 6554.8 6554.9 6563.0 6094.9 6098.3 6103.5 6111.9 6113.1 3333.3 3439.5 3494.8 3502.3 3508.2 6536.2 6554.0 6573.5 6936.9 6943.6 6285.6 6363.9 6599.4 6637.6 6669.3 6904.6 6905.3 6916.7 6930.2 6933.2 6472.0 6564.7 6568.2 6575.6 6592.2 6496.7 6498.5 6516.0 6518.8 6521.5 6621.5 6941.5 6961.2 6961.9 6982.8 4229.2 4253.3 4253.7 4254.4 4255.0 6449.1 6645.9 6650.7 6653.8 6666.2 6459.8 6475.8 6479.5 6480.1 6480.3 6186.8 6391.6 6405.8 6413.4 6418.4 5933.8 5963.8 6057.7 6263.0 6280.6 5895.9 6064.0 6090.9 6243.4 6447.8 5750.1 5871.4 5985.4 6020.0 6305.3
01:28:40 INFO - 2016-02-19 01:28:40,747 DEBUG : BROWSER_OUTPUT:
01:28:40 INFO - 2016-02-19 01:28:40,747 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:15345.88 Median:22931.42 stddev:18269.10 (79.7%) stddev-sans-first:18287.49
01:28:40 INFO - 2016-02-19 01:28:40,747 DEBUG : BROWSER_OUTPUT: Values: 755.6 775.8 777.1 788.3 793.8 12142.2 13443.4 13662.1 13878.4 14033.6 11963.2 12054.2 12222.9 12297.6 13060.3 514.8 518.7 519.1 622.8 623.7 514.7 626.9 636.7 637.6 640.9 610.3 627.2 659.3 663.9 664.2 546.6 571.1 659.8 661.3 662.0 393.1 401.5 450.6 483.0 483.5 12137.7 12161.0 12182.0 12190.6 12253.8 12012.0 12018.5 12246.2 12765.1 13012.6 10879.9 11012.8 11267.7 11329.2 11364.2 3583.5 3597.6 3639.3 3675.1 3684.8 52132.7 52187.7 52384.5 54125.2 54655.5 9946.0 10057.6 10175.4 10217.2 10482.2 17285.6 17512.4 17801.1 17815.9 17818.7 7374.0 7613.4 7682.0 7706.3 7747.3 4183.2 4315.7 4373.9 4421.5 4463.0 3121.8 3140.0 3154.1 3155.4 3168.8 581.3 588.3 608.9 611.3 616.6 718.7 736.2 757.7 767.6 770.1 9561.9 9940.9 10067.6 10323.0 10418.8 599.0 737.6 743.7 756.0 763.4 4616.4 4716.1 4734.0 4768.9 4816.3 63698.0 64307.0 64387.7 64521.4 64869.0 52982.0 55097.7 56787.1 57436.1 57660.4 55230.7 55792.7 56274.7 57900.3 58200.4 10060.8 10068.8 10232.9 10268.6 10481.8 41489.6 41679.6 41968.4 42263.0 42376.8 48324.8 50380.0 51469.5 53600.2 55012.0 11663.9 11837.6 11859.5 12250.7 12266.9 14630.0 14749.5 14825.8 14953.3 15276.6 13103.8 13182.9 13205.7 13251.2 14087.1 12582.6 12673.9 13052.7 13297.7 13436.5 11247.4 12400.6 13223.8 13450.5 13542.3 11659.8 11966.5 11998.2 12166.0 12602.3 11468.7 11570.8 11751.8 11799.2 11805.6
01:28:40 INFO - 2016-02-19 01:28:40,749 DEBUG : BROWSER_OUTPUT: -------- Summary: end --------
01:28:40 INFO - 2016-02-19 01:28:40,749 DEBUG : BROWSER_OUTPUT:
01:28:41 INFO - 2016-02-19 01:28:41,217 INFO : Browser exited with error code: 0
01:28:41 INFO - 2016-02-19 01:28:41,901 INFO : Completed test dromaeo_css (00:18:37)
01:28:41 INFO - 2016-02-19 01:28:41,901 INFO : Starting test kraken
01:28:41 INFO - 2016-02-19 01:28:41,901 DEBUG : operating with platform_type : w7_
01:28:41 INFO - 2016-02-19 01:28:41,901 INFO : Initialising browser for kraken test...
01:28:41 INFO - 2016-02-19 01:28:41,927 DEBUG : command line: C:\slave\test-pgo\build\application\firefox\firefox -profile c:\users\cltbld\appdata\local\temp\tmpv_kw28\profile http://localhost:49817/getInfo.html
01:28:46 INFO - 2016-02-19 01:28:46,822 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200
01:28:46 INFO - 2016-02-19 01:28:46,822 DEBUG : BROWSER_OUTPUT: colorDepth:24
01:28:46 INFO - 2016-02-19 01:28:46,822 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674
01:28:46 INFO - 2016-02-19 01:28:46,822 DEBUG : BROWSER_OUTPUT: __metrics
01:28:46 INFO - 2016-02-19 01:28:46,983 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver]
01:28:47 INFO - 2016-02-19 01:28:47,565 DEBUG : BROWSER_OUTPUT: console.error:
01:28:47 INFO - 2016-02-19 01:28:47,566 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction.
01:28:47 INFO - 2016-02-19 01:28:47,566 DEBUG : BROWSER_OUTPUT: Stack:
01:28:47 INFO - 2016-02-19 01:28:47,566 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:933:23
01:28:47 INFO - 2016-02-19 01:28:47,566 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:812:7
01:28:47 INFO - 2016-02-19 01:28:47,566 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.scheduleWalkerLoop/<@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:746:1
01:28:47 INFO - 2016-02-19 01:28:47,566 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:529:9
01:28:47 INFO - 2016-02-19 01:28:47,566 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15
01:28:47 INFO - 2016-02-19 01:28:47,566 DEBUG : BROWSER_OUTPUT: Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:384:5
01:28:47 INFO - 2016-02-19 01:28:47,566 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29
01:28:47 INFO - 2016-02-19 01:28:47,566 DEBUG : BROWSER_OUTPUT: Barrier/this.client.addBlocker/promisedromaeo_css: 6622.36
01:30:22 INFO - RETURN: kraken: 1569.00
01:30:22 INFO - RETURN: v8_7: 22343.07
01:30:22 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,25]]", "result": "22343.07"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,25]]", "result": "1569.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,25]]", "result": "6622.36"}}}
01:30:23 INFO - Return code: 0
01:30:23 INFO - Validating PERFHERDER_DATA against C:\slave\test-pgo\build\tests\talos\treeherder-schemas\performance-artifact.json
01:30:23 INFO - # TBPL SUCCESS #
01:30:23 INFO - Running post-action listener: _resource_record_post_action
01:30:23 INFO - Running post-run listener: _resource_record_post_run
01:30:24 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 283730944; Write bytes: 557746688; Read time: 3759530; Write time: 6394010
01:30:24 INFO - install - Wall time: 4s; CPU: 5.0%; Read bytes: 18680832; Write bytes: 44487168; Read time: 246440; Write time: 612430
01:30:24 INFO - run-tests - Wall time: 1223s; CPU: 13.0%; Read bytes: 250927104; Write bytes: 483859456; Read time: 3422050; Write time: 5744030
01:30:24 INFO - Running post-run listener: _upload_blobber_files
01:30:24 INFO - Blob upload gear active.
01:30:24 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ...
01:30:24 INFO - Copying logs to upload dir...
01:30:24 INFO - mkdir: C:\slave\test-pgo\build\upload\logs
program finished with exit code 0
elapsedTime=1558.398000
========= master_lag: 8.02 =========
========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 26 mins, 6 secs) (at 2016-02-19 01:30:32.265028) =========
========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-19 01:30:32.270885) =========
'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-157
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-157
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-157
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:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-win32/1455832105/firefox-45.0.en-US.win32.zip
program finished with exit code 0
elapsedTime=0.101000
build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-win32/1455832105/firefox-45.0.en-US.win32.zip'
========= master_lag: 0.54 =========
========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-19 01:30:32.915328) =========
========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 01:30:32.915653) =========
'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-157
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-157
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-157
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld
WINDIR=C:\windows
WINDOWS_TRACING_FLAGS=3
WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log
XPCOM_DEBUG_BREAK=warn
using PTY: False
program finished with exit code 0
elapsedTime=0.101000
========= master_lag: 0.15 =========
========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 01:30:33.167880) =========
========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-02-19 01:30:33.168159) =========
========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-02-19 01:30:33.595960) =========
========= Total master_lag: 76.22 =========