builder: b2g-inbound_win8_64_test-svgr-pgo
slave: t-w864-ix-087
starttime: 1450772026.72
results: success (0)
buildid: 20151221203114
builduid: b59ed20c6ab442beb62ad49f1fedcfdd
revision: 0db21edafc584d96b7ce682145d99d7df0b643de
========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 00:13:46.722320) =========
master: http://buildbot-master119.bb.releng.scl3.mozilla.com:8201/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 00:13:46.722781) =========
========= Started set props: basedir (results: 0, elapsed: 1 secs) (at 2015-12-22 00:13:46.723084) =========
'cd'
in dir C:\slave\test-pgo\. (timeout 1200 secs)
watching logfiles {}
argv: ['cd']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld.T-W864-IX-087\AppData\Roaming
COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files
COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files
COMMONPROGRAMW6432=C:\Program Files\Common Files
COMPUTERNAME=T-W864-IX-087
COMSPEC=C:\windows\system32\cmd.exe
DCLOCATION=SCL3
DNSSUFFIX=wintest.releng.scl3.mozilla.com
FP_NO_HOST_CHECK=NO
HOMEDRIVE=C:
HOMEPATH=\Users\cltbld.T-W864-IX-087
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-087\AppData\Local
LOGONSERVER=\\T-W864-IX-087
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:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;C:\mozilla-build\hg
PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
PROCESSOR_ARCHITECTURE=x86
PROCESSOR_ARCHITEW6432=AMD64
PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel
PROCESSOR_LEVEL=6
PROCESSOR_REVISION=1e05
PROGRAMDATA=C:\ProgramData
PROGRAMFILES=C:\Program Files (x86)
PROGRAMFILES(X86)=C:\Program Files (x86)
PROGRAMW6432=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~1.T-W\AppData\Local\Temp
TEST1=testie
TMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp
USERDOMAIN=T-W864-IX-087
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-087
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-087
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
C:\slave\test-pgo
program finished with exit code 0
elapsedTime=1.828000
basedir: 'C:\\slave\\test-pgo'
========= master_lag: 0.08 =========
========= Finished set props: basedir (results: 0, elapsed: 1 secs) (at 2015-12-22 00:13:48.635776) =========
========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 00:13:48.636115) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 00:13:48.822406) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 00:13:48.822784) =========
'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.T-W864-IX-087\AppData\Roaming
COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files
COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files
COMMONPROGRAMW6432=C:\Program Files\Common Files
COMPUTERNAME=T-W864-IX-087
COMSPEC=C:\windows\system32\cmd.exe
DCLOCATION=SCL3
DNSSUFFIX=wintest.releng.scl3.mozilla.com
FP_NO_HOST_CHECK=NO
HOMEDRIVE=C:
HOMEPATH=\Users\cltbld.T-W864-IX-087
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-087\AppData\Local
LOGONSERVER=\\T-W864-IX-087
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:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;C:\mozilla-build\hg
PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
PROCESSOR_ARCHITECTURE=x86
PROCESSOR_ARCHITEW6432=AMD64
PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel
PROCESSOR_LEVEL=6
PROCESSOR_REVISION=1e05
PROGRAMDATA=C:\ProgramData
PROGRAMFILES=C:\Program Files (x86)
PROGRAMFILES(X86)=C:\Program Files (x86)
PROGRAMW6432=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~1.T-W\AppData\Local\Temp
TEST1=testie
TMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp
USERDOMAIN=T-W864-IX-087
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-087
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-087
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
program finished with exit code 0
elapsedTime=0.301000
========= master_lag: 0.02 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 00:13:49.141267) =========
========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 00:13:49.141568) =========
script_repo_url: https://hg.mozilla.org/build/mozharness
========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 00:13:49.141931) =========
========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-22 00:13:49.142205) =========
'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.T-W864-IX-087\AppData\Roaming
COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files
COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files
COMMONPROGRAMW6432=C:\Program Files\Common Files
COMPUTERNAME=T-W864-IX-087
COMSPEC=C:\windows\system32\cmd.exe
DCLOCATION=SCL3
DNSSUFFIX=wintest.releng.scl3.mozilla.com
FP_NO_HOST_CHECK=NO
HOMEDRIVE=C:
HOMEPATH=\Users\cltbld.T-W864-IX-087
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-087\AppData\Local
LOGONSERVER=\\T-W864-IX-087
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:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;C:\mozilla-build\hg
PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
PROCESSOR_ARCHITECTURE=x86
PROCESSOR_ARCHITEW6432=AMD64
PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel
PROCESSOR_LEVEL=6
PROCESSOR_REVISION=1e05
PROGRAMDATA=C:\ProgramData
PROGRAMFILES=C:\Program Files (x86)
PROGRAMFILES(X86)=C:\Program Files (x86)
PROGRAMW6432=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~1.T-W\AppData\Local\Temp
TEST1=testie
TMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp
USERDOMAIN=T-W864-IX-087
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-087
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-087
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
--00:13:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py
=> `archiver_client.py'
Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25
Connecting to hg.mozilla.org|63.245.215.102|:443... connected.
HTTP request sent, awaiting response... 200 Script output follows
Length: 12,141 (12K) [text/x-python]
0K .......... . 100% 1.73 GB/s
00:13:50 (1.73 GB/s) - `archiver_client.py' saved [12141/12141]
program finished with exit code 0
elapsedTime=1.610000
========= master_lag: 0.02 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-22 00:13:50.770098) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 5 secs) (at 2015-12-22 00:13:50.770498) =========
'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.T-W864-IX-087\AppData\Roaming
COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files
COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files
COMMONPROGRAMW6432=C:\Program Files\Common Files
COMPUTERNAME=T-W864-IX-087
COMSPEC=C:\windows\system32\cmd.exe
DCLOCATION=SCL3
DNSSUFFIX=wintest.releng.scl3.mozilla.com
FP_NO_HOST_CHECK=NO
HOMEDRIVE=C:
HOMEPATH=\Users\cltbld.T-W864-IX-087
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-087\AppData\Local
LOGONSERVER=\\T-W864-IX-087
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:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;C:\mozilla-build\hg
PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
PROCESSOR_ARCHITECTURE=x86
PROCESSOR_ARCHITEW6432=AMD64
PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel
PROCESSOR_LEVEL=6
PROCESSOR_REVISION=1e05
PROGRAMDATA=C:\ProgramData
PROGRAMFILES=C:\Program Files (x86)
PROGRAMFILES(X86)=C:\Program Files (x86)
PROGRAMW6432=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~1.T-W\AppData\Local\Temp
TEST1=testie
TMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp
USERDOMAIN=T-W864-IX-087
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-087
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-087
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
program finished with exit code 0
elapsedTime=5.415000
========= master_lag: 0.02 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 5 secs) (at 2015-12-22 00:13:56.205003) =========
========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-12-22 00:13:56.205368) =========
'bash' '-c' u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 0db21edafc584d96b7ce682145d99d7df0b643de --destination scripts --debug'
in dir C:\slave\test-pgo\. (timeout 1200 secs)
watching logfiles {}
argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 0db21edafc584d96b7ce682145d99d7df0b643de --destination scripts --debug']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld.T-W864-IX-087\AppData\Roaming
COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files
COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files
COMMONPROGRAMW6432=C:\Program Files\Common Files
COMPUTERNAME=T-W864-IX-087
COMSPEC=C:\windows\system32\cmd.exe
DCLOCATION=SCL3
DNSSUFFIX=wintest.releng.scl3.mozilla.com
FP_NO_HOST_CHECK=NO
HOMEDRIVE=C:
HOMEPATH=\Users\cltbld.T-W864-IX-087
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-087\AppData\Local
LOGONSERVER=\\T-W864-IX-087
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:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;C:\mozilla-build\hg
PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
PROCESSOR_ARCHITECTURE=x86
PROCESSOR_ARCHITEW6432=AMD64
PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel
PROCESSOR_LEVEL=6
PROCESSOR_REVISION=1e05
PROGRAMDATA=C:\ProgramData
PROGRAMFILES=C:\Program Files (x86)
PROGRAMFILES(X86)=C:\Program Files (x86)
PROGRAMW6432=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~1.T-W\AppData\Local\Temp
TEST1=testie
TMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp
USERDOMAIN=T-W864-IX-087
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-087
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-087
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
2015-12-22 00:13:57,025 truncating revision to first 12 chars
2015-12-22 00:13:57,025 Setting DEBUG logging.
2015-12-22 00:13:57,026 attempt 1/10
2015-12-22 00:13:57,026 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/0db21edafc58?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2015-12-22 00:13:57,493 unpacking tar archive at: b2g-inbound-0db21edafc58/testing/mozharness/
program finished with exit code 0
elapsedTime=1.687000
========= master_lag: 0.39 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-12-22 00:13:58.282395) =========
========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 00:13:58.282708) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 00:13:58.319619) =========
========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 00:13:58.319954) =========
TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production
========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 00:13:58.320342) =========
========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2015-12-22 00:13:58.320644) =========
'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'svgr' '--add-option' '--webServer,localhost' '--branch-name' 'B2G-Inbound' '--system-bits' '64' '--cfg' 'talos/windows_config.py' '--download-symbols' 'ondemand' '--use-talos-json' '--blob-upload-branch' 'B2G-Inbound'
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', 'svgr', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--system-bits', '64', '--cfg', 'talos/windows_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld.T-W864-IX-087\AppData\Roaming
COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files
COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files
COMMONPROGRAMW6432=C:\Program Files\Common Files
COMPUTERNAME=T-W864-IX-087
COMSPEC=C:\windows\system32\cmd.exe
DCLOCATION=SCL3
DNSSUFFIX=wintest.releng.scl3.mozilla.com
FP_NO_HOST_CHECK=NO
HOMEDRIVE=C:
HOMEPATH=\Users\cltbld.T-W864-IX-087
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-087\AppData\Local
LOGONSERVER=\\T-W864-IX-087
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:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;C:\mozilla-build\hg
PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
PROCESSOR_ARCHITECTURE=x86
PROCESSOR_ARCHITEW6432=AMD64
PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel
PROCESSOR_LEVEL=6
PROCESSOR_REVISION=1e05
PROGRAMDATA=C:\ProgramData
PROGRAMFILES=C:\Program Files (x86)
PROGRAMFILES(X86)=C:\Program Files (x86)
PROGRAMW6432=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~1.T-W\AppData\Local\Temp
TEST1=testie
TMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp
USERDOMAIN=T-W864-IX-087
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-087
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-087
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
00:13:59 INFO - MultiFileLogger online at 20151222 00:13:59 in C:\slave\test-pgo
00:13:59 INFO - Run as scripts/scripts/talos_script.py --suite svgr --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound
00:13:59 INFO - Dumping config to C:\slave\test-pgo\logs\localconfig.json.
00:13:59 INFO - {'append_to_log': False,
00:13:59 INFO - 'base_work_dir': 'C:\\slave\\test-pgo',
00:13:59 INFO - 'blob_upload_branch': 'B2G-Inbound',
00:13:59 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test-pgo\\oauth.txt',
00:13:59 INFO - 'branch': 'B2G-Inbound',
00:13:59 INFO - 'buildbot_json_path': 'buildprops.json',
00:13:59 INFO - 'config_files': ('talos/windows_config.py',),
00:13:59 INFO - 'default_actions': ('clobber',
00:13:59 INFO - 'read-buildbot-config',
00:13:59 INFO - 'download-and-extract',
00:13:59 INFO - 'populate-webroot',
00:13:59 INFO - 'create-virtualenv',
00:13:59 INFO - 'install',
00:13:59 INFO - 'run-tests'),
00:13:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',),
00:13:59 INFO - 'download_minidump_stackwalk': True,
00:13:59 INFO - 'download_symbols': 'ondemand',
00:13:59 INFO - 'exes': {'easy_install': ('C:\\slave\\test-pgo\\build/venv/scripts/python',
00:13:59 INFO - 'C:\\slave\\test-pgo\\build/venv/scripts/easy_install-2.7-script.py'),
00:13:59 INFO - 'hg': 'c:/mozilla-build/hg/hg',
00:13:59 INFO - 'mozinstall': ('C:\\slave\\test-pgo\\build/venv/scripts/python',
00:13:59 INFO - 'C:\\slave\\test-pgo\\build/venv/scripts/mozinstall-script.py'),
00:13:59 INFO - 'python': 'c:/mozilla-build/python27/python.exe',
00:13:59 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe',
00:13:59 INFO - 'C:/mozilla-build/tooltool.py'),
00:13:59 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe',
00:13:59 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')},
00:13:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub',
00:13:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'),
00:13:59 INFO - 'installer_path': 'installer.exe',
00:13:59 INFO - 'log_level': 'info',
00:13:59 INFO - 'log_name': 'talos',
00:13:59 INFO - 'log_to_console': True,
00:13:59 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe',
00:13:59 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe',
00:13:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest',
00:13:59 INFO - 'opt_config_files': (),
00:13:59 INFO - 'pip_index': False,
00:13:59 INFO - 'sps_profile': False,
00:13:59 INFO - 'sps_profile_interval': 0,
00:13:59 INFO - 'suite': 'svgr',
00:13:59 INFO - 'system_bits': '64',
00:13:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'),
00:13:59 INFO - 'title': 'T-W864-IX-087',
00:13:59 INFO - 'use_talos_json': True,
00:13:59 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'),
00:13:59 INFO - 'virtualenv_path': 'C:\\slave\\test-pgo\\build/venv',
00:13:59 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll',
00:13:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
00:13:59 INFO - 'work_dir': 'build'}
00:13:59 INFO - #####
00:13:59 INFO - ##### Running clobber step.
00:13:59 INFO - #####
00:13:59 INFO - Running pre-action listener: _resource_record_pre_action
00:13:59 INFO - Running main action method: clobber
00:13:59 INFO - rmtree: C:\slave\test-pgo\build
00:13:59 INFO - Using _rmtree_windows ...
00:13:59 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test-pgo\\build',), kwargs: {}, attempt #1
00:16:30 INFO - Running post-action listener: _resource_record_post_action
00:16:30 INFO - #####
00:16:30 INFO - ##### Running read-buildbot-config step.
00:16:30 INFO - #####
00:16:30 INFO - Running pre-action listener: _resource_record_pre_action
00:16:30 INFO - Running main action method: read_buildbot_config
00:16:30 INFO - Using buildbot properties:
00:16:30 INFO - {
00:16:30 INFO - "project": "",
00:16:30 INFO - "product": "firefox",
00:16:30 INFO - "script_repo_revision": "production",
00:16:30 INFO - "builddir": "b2g-inbound_win8_64_test-svgr",
00:16:30 INFO - "repository": "",
00:16:30 INFO - "buildername": "Windows 8 64-bit b2g-inbound pgo talos svgr",
00:16:30 INFO - "buildid": "20151221203114",
00:16:30 INFO - "pgo_build": "True",
00:16:30 INFO - "basedir": "C:\\slave\\test-pgo",
00:16:30 INFO - "buildnumber": 331,
00:16:30 INFO - "slavename": "t-w864-ix-087",
00:16:30 INFO - "master": "http://buildbot-master119.bb.releng.scl3.mozilla.com:8201/",
00:16:30 INFO - "platform": "win8_64",
00:16:30 INFO - "scheduler": "tests-b2g-inbound-win64-pgo-talos",
00:16:30 INFO - "branch": "b2g-inbound",
00:16:30 INFO - "repo_path": "integration/b2g-inbound",
00:16:30 INFO - "revision": "0db21edafc584d96b7ce682145d99d7df0b643de",
00:16:30 INFO - "stage_platform": "win64-pgo",
00:16:30 INFO - "builduid": "b59ed20c6ab442beb62ad49f1fedcfdd",
00:16:30 INFO - "slavebuilddir": "test"
00:16:30 INFO - }
00:16:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/xFsdWicSSM6vBbqUTU2P-g/artifacts/public/build/firefox-46.0a1.en-US.win64.zip.
00:16:30 INFO - Running post-action listener: _resource_record_post_action
00:16:30 INFO - #####
00:16:30 INFO - ##### Running download-and-extract step.
00:16:30 INFO - #####
00:16:30 INFO - Running pre-action listener: _resource_record_pre_action
00:16:30 INFO - Running main action method: download_and_extract
00:16:30 INFO - mkdir: C:\slave\test-pgo\build\tests
00:16:30 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')]}
00:16:30 INFO - https://queue.taskcluster.net/v1/task/xFsdWicSSM6vBbqUTU2P-g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net
00:16:30 INFO - trying https://queue.taskcluster.net/v1/task/xFsdWicSSM6vBbqUTU2P-g/artifacts/public/build/test_packages.json
00:16:30 INFO - Downloading https://queue.taskcluster.net/v1/task/xFsdWicSSM6vBbqUTU2P-g/artifacts/public/build/test_packages.json to C:\slave\test-pgo\build\test_packages.json
00:16:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/xFsdWicSSM6vBbqUTU2P-g/artifacts/public/build/test_packages.json', 'file_name': 'C:\\slave\\test-pgo\\build\\test_packages.json'}, attempt #1
00:16:31 INFO - Downloaded 1221 bytes.
00:16:31 INFO - Reading from file C:\slave\test-pgo\build\test_packages.json
00:16:31 INFO - Using the following test package requirements:
00:16:31 INFO - {u'common': [u'firefox-46.0a1.en-US.win64.common.tests.zip'],
00:16:31 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.win64.common.tests.zip',
00:16:31 INFO - u'firefox-46.0a1.en-US.win64.cppunittest.tests.zip'],
00:16:31 INFO - u'jittest': [u'firefox-46.0a1.en-US.win64.common.tests.zip',
00:16:31 INFO - u'jsshell-win64.zip'],
00:16:31 INFO - u'mochitest': [u'firefox-46.0a1.en-US.win64.common.tests.zip',
00:16:31 INFO - u'firefox-46.0a1.en-US.win64.mochitest.tests.zip'],
00:16:31 INFO - u'mozbase': [u'firefox-46.0a1.en-US.win64.common.tests.zip'],
00:16:31 INFO - u'reftest': [u'firefox-46.0a1.en-US.win64.common.tests.zip',
00:16:31 INFO - u'firefox-46.0a1.en-US.win64.reftest.tests.zip'],
00:16:31 INFO - u'talos': [u'firefox-46.0a1.en-US.win64.common.tests.zip',
00:16:31 INFO - u'firefox-46.0a1.en-US.win64.talos.tests.zip'],
00:16:31 INFO - u'web-platform': [u'firefox-46.0a1.en-US.win64.common.tests.zip',
00:16:31 INFO - u'firefox-46.0a1.en-US.win64.web-platform.tests.zip'],
00:16:31 INFO - u'webapprt': [u'firefox-46.0a1.en-US.win64.common.tests.zip'],
00:16:31 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.win64.common.tests.zip',
00:16:31 INFO - u'firefox-46.0a1.en-US.win64.xpcshell.tests.zip']}
00:16:31 INFO - Downloading packages: [u'firefox-46.0a1.en-US.win64.common.tests.zip'] for test suite category: common
00:16:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
00:16:31 INFO - https://queue.taskcluster.net/v1/task/xFsdWicSSM6vBbqUTU2P-g/artifacts/public/build/firefox-46.0a1.en-US.win64.common.tests.zip matches https://queue.taskcluster.net
00:16:31 INFO - trying https://queue.taskcluster.net/v1/task/xFsdWicSSM6vBbqUTU2P-g/artifacts/public/build/firefox-46.0a1.en-US.win64.common.tests.zip
00:16:31 INFO - Downloading https://queue.taskcluster.net/v1/task/xFsdWicSSM6vBbqUTU2P-g/artifacts/public/build/firefox-46.0a1.en-US.win64.common.tests.zip to C:\slave\test-pgo\build\firefox-46.0a1.en-US.win64.common.tests.zip
00:16:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/xFsdWicSSM6vBbqUTU2P-g/artifacts/public/build/firefox-46.0a1.en-US.win64.common.tests.zip', 'file_name': u'C:\\slave\\test-pgo\\build\\firefox-46.0a1.en-US.win64.common.tests.zip'}, attempt #1
ProcessManager NOT managing child processes
00:16:32 INFO - Downloaded 18707307 bytes.
00:16:32 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-46.0a1.en-US.win64.common.tests.zip'] in C:\slave\test-pgo\build\tests
00:16:32 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-46.0a1.en-US.win64.common.tests.zip
00:16:32 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-46.0a1.en-US.win64.common.tests.zip'] with output_timeout 1760
ProcessManager UNABLE to use job objects to manage child processes
00:17:00 INFO - Return code: 0
00:17:00 INFO - Downloading packages: [u'firefox-46.0a1.en-US.win64.common.tests.zip', u'firefox-46.0a1.en-US.win64.talos.tests.zip'] for test suite category: talos
00:17:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
00:17:00 INFO - https://queue.taskcluster.net/v1/task/xFsdWicSSM6vBbqUTU2P-g/artifacts/public/build/firefox-46.0a1.en-US.win64.common.tests.zip matches https://queue.taskcluster.net
00:17:00 INFO - trying https://queue.taskcluster.net/v1/task/xFsdWicSSM6vBbqUTU2P-g/artifacts/public/build/firefox-46.0a1.en-US.win64.common.tests.zip
00:17:00 INFO - Downloading https://queue.taskcluster.net/v1/task/xFsdWicSSM6vBbqUTU2P-g/artifacts/public/build/firefox-46.0a1.en-US.win64.common.tests.zip to C:\slave\test-pgo\build\firefox-46.0a1.en-US.win64.common.tests.zip
00:17:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/xFsdWicSSM6vBbqUTU2P-g/artifacts/public/build/firefox-46.0a1.en-US.win64.common.tests.zip', 'file_name': u'C:\\slave\\test-pgo\\build\\firefox-46.0a1.en-US.win64.common.tests.zip'}, attempt #1
ProcessManager NOT managing child processes
00:17:01 INFO - Downloaded 18707307 bytes.
00:17:01 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-46.0a1.en-US.win64.common.tests.zip'] in C:\slave\test-pgo\build\tests
00:17:01 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-46.0a1.en-US.win64.common.tests.zip
00:17:01 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-46.0a1.en-US.win64.common.tests.zip'] with output_timeout 1760
ProcessManager UNABLE to use job objects to manage child processes
00:17:25 INFO - Return code: 0
00:17:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
00:17:25 INFO - https://queue.taskcluster.net/v1/task/xFsdWicSSM6vBbqUTU2P-g/artifacts/public/build/firefox-46.0a1.en-US.win64.talos.tests.zip matches https://queue.taskcluster.net
00:17:25 INFO - trying https://queue.taskcluster.net/v1/task/xFsdWicSSM6vBbqUTU2P-g/artifacts/public/build/firefox-46.0a1.en-US.win64.talos.tests.zip
00:17:25 INFO - Downloading https://queue.taskcluster.net/v1/task/xFsdWicSSM6vBbqUTU2P-g/artifacts/public/build/firefox-46.0a1.en-US.win64.talos.tests.zip to C:\slave\test-pgo\build\firefox-46.0a1.en-US.win64.talos.tests.zip
00:17:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/xFsdWicSSM6vBbqUTU2P-g/artifacts/public/build/firefox-46.0a1.en-US.win64.talos.tests.zip', 'file_name': u'C:\\slave\\test-pgo\\build\\firefox-46.0a1.en-US.win64.talos.tests.zip'}, attempt #1
ProcessManager NOT managing child processes
00:17:25 INFO - Downloaded 11132277 bytes.
00:17:25 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-46.0a1.en-US.win64.talos.tests.zip'] in C:\slave\test-pgo\build\tests
00:17:25 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-46.0a1.en-US.win64.talos.tests.zip
00:17:25 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-46.0a1.en-US.win64.talos.tests.zip'] with output_timeout 1760
ProcessManager UNABLE to use job objects to manage child processes
00:17:26 INFO - Return code: 0
00:17:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]}
00:17:26 INFO - https://queue.taskcluster.net/v1/task/xFsdWicSSM6vBbqUTU2P-g/artifacts/public/build/firefox-46.0a1.en-US.win64.zip matches https://queue.taskcluster.net
00:17:26 INFO - trying https://queue.taskcluster.net/v1/task/xFsdWicSSM6vBbqUTU2P-g/artifacts/public/build/firefox-46.0a1.en-US.win64.zip
00:17:26 INFO - Downloading https://queue.taskcluster.net/v1/task/xFsdWicSSM6vBbqUTU2P-g/artifacts/public/build/firefox-46.0a1.en-US.win64.zip to C:\slave\test-pgo\build\firefox-46.0a1.en-US.win64.zip
00:17:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/xFsdWicSSM6vBbqUTU2P-g/artifacts/public/build/firefox-46.0a1.en-US.win64.zip', 'file_name': 'C:\\slave\\test-pgo\\build\\firefox-46.0a1.en-US.win64.zip'}, attempt #1
00:17:28 INFO - Downloaded 55707834 bytes.
00:17:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/xFsdWicSSM6vBbqUTU2P-g/artifacts/public/build/firefox-46.0a1.en-US.win64.zip
00:17:28 INFO - mkdir: C:\slave\test-pgo\properties
00:17:28 INFO - Writing buildbot properties ['build_url'] to C:\slave\test-pgo\properties\build_url
00:17:28 INFO - Writing to file C:\slave\test-pgo\properties\build_url
00:17:28 INFO - Contents:
00:17:28 INFO - build_url:https://queue.taskcluster.net/v1/task/xFsdWicSSM6vBbqUTU2P-g/artifacts/public/build/firefox-46.0a1.en-US.win64.zip
00:17:28 INFO - Running post-action listener: _resource_record_post_action
00:17:28 INFO - Running post-action listener: set_extra_try_arguments
00:17:28 INFO - #####
00:17:28 INFO - ##### Running populate-webroot step.
00:17:28 INFO - #####
00:17:28 INFO - Running pre-action listener: _resource_record_pre_action
00:17:28 INFO - Running main action method: populate_webroot
00:17:28 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']},
00:17:28 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']},
00:17:28 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome',
00:17:28 INFO - u'--tppagecycles',
00:17:28 INFO - u'7'],
00:17:28 INFO - u'tests': [u'tsvgm']}},
00:17:28 INFO - u'suites': {u'chromez': {u'tests': [u'tresize', u'tcanvasmark']},
00:17:28 INFO - u'chromez-e10s': {u'talos_options': [u'--e10s'],
00:17:28 INFO - u'tests': [u'tresize', u'tcanvasmark']},
00:17:28 INFO - u'dromaeojs': {u'tests': [u'dromaeo_css', u'kraken', u'v8_7']},
00:17:28 INFO - u'dromaeojs-e10s': {u'talos_options': [u'--e10s'],
00:17:28 INFO - u'tests': [u'dromaeo_css',
00:17:28 INFO - u'kraken',
00:17:28 INFO - u'v8_7']},
00:17:28 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
00:17:28 INFO - u'tests': [u'tp5o_scroll', u'glterrain']},
00:17:28 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
00:17:28 INFO - u'talos_options': [u'--e10s'],
00:17:28 INFO - u'tests': [u'tp5o_scroll', u'glterrain']},
00:17:28 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
00:17:28 INFO - u'tests': [u'damp', u'tps']},
00:17:28 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
00:17:28 INFO - u'talos_options': [u'--e10s'],
00:17:28 INFO - u'tests': [u'damp', u'tps']},
00:17:28 INFO - u'g3': {u'tests': [u'dromaeo_dom']},
00:17:28 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']},
00:17:28 INFO - u'other': {u'tests': [u'a11yr',
00:17:28 INFO - u'ts_paint',
00:17:28 INFO - u'tpaint',
00:17:28 INFO - u'sessionrestore',
00:17:28 INFO - u'sessionrestore_no_auto_restore']},
00:17:28 INFO - u'other-e10s': {u'talos_options': [u'--e10s'],
00:17:28 INFO - u'tests': [u'a11yr',
00:17:28 INFO - u'ts_paint',
00:17:28 INFO - u'tpaint',
00:17:28 INFO - u'sessionrestore',
00:17:28 INFO - u'sessionrestore_no_auto_restore']},
00:17:28 INFO - u'other-e10s_l64': {u'talos_options': [u'--e10s'],
00:17:28 INFO - u'tests': [u'a11yr',
00:17:28 INFO - u'ts_paint',
00:17:28 INFO - u'tpaint',
00:17:28 INFO - u'sessionrestore',
00:17:28 INFO - u'sessionrestore_no_auto_restore']},
00:17:28 INFO - u'other-e10s_nol64': {u'talos_options': [u'--e10s'],
00:17:28 INFO - u'tests': [u'a11yr',
00:17:28 INFO - u'ts_paint',
00:17:28 INFO - u'tpaint',
00:17:28 INFO - u'sessionrestore',
00:17:28 INFO - u'sessionrestore_no_auto_restore']},
00:17:28 INFO - u'other_l64': {u'tests': [u'a11yr',
00:17:28 INFO - u'ts_paint',
00:17:28 INFO - u'tpaint',
00:17:28 INFO - u'sessionrestore',
00:17:28 INFO - u'sessionrestore_no_auto_restore']},
00:17:28 INFO - u'other_nol64': {u'tests': [u'a11yr',
00:17:28 INFO - u'ts_paint',
00:17:28 INFO - u'tpaint',
00:17:28 INFO - u'sessionrestore',
00:17:28 INFO - u'sessionrestore_no_auto_restore']},
00:17:28 INFO - u'svgr': {u'tests': [u'tsvgx',
00:17:28 INFO - u'tsvgr_opacity',
00:17:28 INFO - u'tart',
00:17:28 INFO - u'tscrollx',
00:17:28 INFO - u'cart']},
00:17:28 INFO - u'svgr-e10s': {u'talos_options': [u'--e10s'],
00:17:28 INFO - u'tests': [u'tsvgx',
00:17:28 INFO - u'tsvgr_opacity',
00:17:28 INFO - u'tart',
00:17:28 INFO - u'tscrollx',
00:17:28 INFO - u'cart']},
00:17:28 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
00:17:28 INFO - u'tests': [u'tp5o']},
00:17:28 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
00:17:28 INFO - u'talos_options': [u'--e10s'],
00:17:28 INFO - u'tests': [u'tp5o']},
00:17:28 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
00:17:28 INFO - u'talos_options': [u'--xperf_path',
00:17:28 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
00:17:28 INFO - u'tests': [u'tp5n']},
00:17:28 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
00:17:28 INFO - u'talos_options': [u'--e10s',
00:17:28 INFO - u'--xperf_path',
00:17:28 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
00:17:28 INFO - u'tests': [u'tp5n']}},
00:17:28 INFO - u'talos.zip': {u'path': u'',
00:17:28 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}}
00:17:28 INFO - Running post-action listener: _resource_record_post_action
00:17:28 INFO - #####
00:17:28 INFO - ##### Running create-virtualenv step.
00:17:28 INFO - #####
00:17:28 INFO - Running pre-action listener: _resource_record_pre_action
00:17:28 INFO - Running main action method: create_virtualenv
00:17:28 INFO - Creating virtualenv C:\slave\test-pgo\build/venv
00:17:28 INFO - mkdir: C:\slave\test-pgo\build\venv\Scripts
00:17:28 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test-pgo\build\venv\Scripts\python27.dll
00:17:28 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'!
00:17:28 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
00:17:28 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
00:17:35 INFO - New python executable in C:\slave\test-pgo\build/venv\Scripts\python.exe
00:17:38 INFO - Installing distribute......................................................................................................................................................................................done.
00:17:39 INFO - Return code: 0
00:17:39 INFO - Installing pip>=1.5 into virtualenv C:\slave\test-pgo\build/venv
00:17:39 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')]}
00:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
00:17:39 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')]}
00:17:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
00:17:39 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022186B0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022C2EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x007F4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00738BF0>, '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 0x0075A9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027A15C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-087', 'USERDOMAIN': 'T-W864-IX-087', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-087', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-087\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-087', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-087', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-087', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-087\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test-pgo', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
00:17:40 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in C:\slave\test-pgo\build
00:17:40 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --download-cache C:\slave\test-pgo\build/venv\cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5
00:17:40 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
00:17:40 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-087\\AppData\\Roaming',
00:17:40 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
00:17:40 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
00:17:40 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
00:17:40 INFO - 'COMPUTERNAME': 'T-W864-IX-087',
00:17:40 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
00:17:40 INFO - 'DCLOCATION': 'SCL3',
00:17:40 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
00:17:40 INFO - 'FP_NO_HOST_CHECK': 'NO',
00:17:40 INFO - 'HOMEDRIVE': 'C:',
00:17:40 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-087',
00:17:40 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
00:17:40 INFO - 'KTS_VERSION': '1.19c',
00:17:40 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-087\\AppData\\Local',
00:17:40 INFO - 'LOGONSERVER': '\\\\T-W864-IX-087',
00:17:40 INFO - 'MONDIR': 'C:\\Monitor_config\\',
00:17:40 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
00:17:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
00:17:40 INFO - 'MOZ_NO_REMOTE': '1',
00:17:40 INFO - 'NO_EM_RESTART': '1',
00:17:40 INFO - 'NUMBER_OF_PROCESSORS': '8',
00:17:40 INFO - 'OS': 'Windows_NT',
00:17:40 INFO - 'OURDRIVE': 'C:',
00:17:40 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
00:17:40 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
00:17:40 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
00:17:40 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
00:17:40 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
00:17:40 INFO - 'PROCESSOR_LEVEL': '6',
00:17:40 INFO - 'PROCESSOR_REVISION': '1e05',
00:17:40 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
00:17:40 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
00:17:40 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
00:17:40 INFO - 'PROGRAMW6432': 'C:\\Program Files',
00:17:40 INFO - 'PROMPT': '$P$G',
00:17:40 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json',
00:17:40 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
00:17:40 INFO - 'PUBLIC': 'C:\\Users\\Public',
00:17:40 INFO - 'PWD': 'C:\\slave\\test-pgo',
00:17:40 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
00:17:40 INFO - 'SLAVEDIR': 'C:\\slave\\',
00:17:40 INFO - 'SYSTEMDRIVE': 'C:',
00:17:40 INFO - 'SYSTEMROOT': 'C:\\windows',
00:17:40 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
00:17:40 INFO - 'TEST1': 'testie',
00:17:40 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
00:17:40 INFO - 'USERDOMAIN': 'T-W864-IX-087',
00:17:40 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-087',
00:17:40 INFO - 'USERNAME': 'cltbld',
00:17:40 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-087',
00:17:40 INFO - 'WINDIR': 'C:\\windows',
00:17:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
00:17:41 INFO - Ignoring indexes: http://pypi.python.org/simple/
00:17:41 INFO - Downloading/unpacking pip>=1.5
00:17:41 INFO - Creating supposed download cache at C:\slave\test-pgo\build/venv\cache
00:17:45 INFO - Storing download in cache at c:\slave\test-pgo\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fpip-1.5.5.tar.gz
00:17:45 INFO - Running setup.py egg_info for package pip
00:17:45 INFO - warning: no files found matching 'pip\cacert.pem'
00:17:45 INFO - warning: no files found matching '*.html' under directory 'docs'
00:17:45 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build'
00:17:45 INFO - no previously-included directories found matching 'docs\_build\_sources'
00:17:45 INFO - Installing collected packages: pip
00:17:45 INFO - Found existing installation: pip 0.8.2
00:17:45 INFO - Uninstalling pip:
00:17:45 INFO - Successfully uninstalled pip
00:17:45 INFO - Running setup.py install for pip
00:17:45 INFO - warning: no files found matching 'pip\cacert.pem'
00:17:45 INFO - warning: no files found matching '*.html' under directory 'docs'
00:17:45 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build'
00:17:45 INFO - no previously-included directories found matching 'docs\_build\_sources'
00:17:45 INFO - Installing pip-script.py script to C:\slave\test-pgo\build\venv\Scripts
00:17:45 INFO - Installing pip.exe script to C:\slave\test-pgo\build\venv\Scripts
00:17:45 INFO - Installing pip2.7-script.py script to C:\slave\test-pgo\build\venv\Scripts
00:17:45 INFO - Installing pip2.7.exe script to C:\slave\test-pgo\build\venv\Scripts
00:17:45 INFO - Installing pip2-script.py script to C:\slave\test-pgo\build\venv\Scripts
00:17:45 INFO - Installing pip2.exe script to C:\slave\test-pgo\build\venv\Scripts
00:17:45 INFO - Successfully installed pip
00:17:45 INFO - Cleaning up...
00:17:45 INFO - Return code: 0
00:17:45 INFO - Installing psutil>=0.7.1 into virtualenv C:\slave\test-pgo\build/venv
00:17:45 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')]}
00:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
00:17:45 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')]}
00:17:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
00:17:45 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022186B0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022C2EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x007F4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00738BF0>, '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 0x0075A9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027A15C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-087', 'USERDOMAIN': 'T-W864-IX-087', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-087', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-087\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-087', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-087', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-087', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-087\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test-pgo', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
00:17:45 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in C:\slave\test-pgo\build
00:17:45 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --download-cache C:\slave\test-pgo\build/venv\cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1
00:17:45 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
00:17:45 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-087\\AppData\\Roaming',
00:17:45 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
00:17:45 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
00:17:45 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
00:17:45 INFO - 'COMPUTERNAME': 'T-W864-IX-087',
00:17:45 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
00:17:45 INFO - 'DCLOCATION': 'SCL3',
00:17:45 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
00:17:45 INFO - 'FP_NO_HOST_CHECK': 'NO',
00:17:45 INFO - 'HOMEDRIVE': 'C:',
00:17:45 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-087',
00:17:45 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
00:17:45 INFO - 'KTS_VERSION': '1.19c',
00:17:45 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-087\\AppData\\Local',
00:17:45 INFO - 'LOGONSERVER': '\\\\T-W864-IX-087',
00:17:45 INFO - 'MONDIR': 'C:\\Monitor_config\\',
00:17:45 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
00:17:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
00:17:45 INFO - 'MOZ_NO_REMOTE': '1',
00:17:45 INFO - 'NO_EM_RESTART': '1',
00:17:45 INFO - 'NUMBER_OF_PROCESSORS': '8',
00:17:45 INFO - 'OS': 'Windows_NT',
00:17:45 INFO - 'OURDRIVE': 'C:',
00:17:45 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
00:17:45 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
00:17:45 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
00:17:45 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
00:17:45 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
00:17:45 INFO - 'PROCESSOR_LEVEL': '6',
00:17:45 INFO - 'PROCESSOR_REVISION': '1e05',
00:17:45 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
00:17:45 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
00:17:45 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
00:17:45 INFO - 'PROGRAMW6432': 'C:\\Program Files',
00:17:45 INFO - 'PROMPT': '$P$G',
00:17:45 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json',
00:17:45 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
00:17:45 INFO - 'PUBLIC': 'C:\\Users\\Public',
00:17:45 INFO - 'PWD': 'C:\\slave\\test-pgo',
00:17:45 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
00:17:45 INFO - 'SLAVEDIR': 'C:\\slave\\',
00:17:45 INFO - 'SYSTEMDRIVE': 'C:',
00:17:45 INFO - 'SYSTEMROOT': 'C:\\windows',
00:17:45 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
00:17:45 INFO - 'TEST1': 'testie',
00:17:45 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
00:17:45 INFO - 'USERDOMAIN': 'T-W864-IX-087',
00:17:45 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-087',
00:17:45 INFO - 'USERNAME': 'cltbld',
00:17:45 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-087',
00:17:45 INFO - 'WINDIR': 'C:\\windows',
00:17:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
00:17:47 INFO - Ignoring indexes: https://pypi.python.org/simple/
00:17:47 INFO - Downloading/unpacking psutil>=0.7.1
00:17:47 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
00:17:47 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
00:17:48 INFO - Storing download in cache at c:\slave\test-pgo\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fpsutil-3.1.1-cp27-none-win32.whl
00:17:48 INFO - Installing collected packages: psutil
00:17:48 INFO - Successfully installed psutil
00:17:48 INFO - Cleaning up...
00:17:48 INFO - Return code: 0
00:17:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv C:\slave\test-pgo\build/venv
00:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]}
00:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
00:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]}
00:17:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
00:17:48 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022186B0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022C2EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x007F4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00738BF0>, '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 0x0075A9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027A15C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-087', 'USERDOMAIN': 'T-W864-IX-087', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-087', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-087\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-087', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-087', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-087', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-087\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test-pgo', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
00:17:48 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in C:\slave\test-pgo\build
00:17:48 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --download-cache C:\slave\test-pgo\build/venv\cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0
00:17:48 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
00:17:48 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-087\\AppData\\Roaming',
00:17:48 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
00:17:48 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
00:17:48 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
00:17:48 INFO - 'COMPUTERNAME': 'T-W864-IX-087',
00:17:48 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
00:17:48 INFO - 'DCLOCATION': 'SCL3',
00:17:48 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
00:17:48 INFO - 'FP_NO_HOST_CHECK': 'NO',
00:17:48 INFO - 'HOMEDRIVE': 'C:',
00:17:48 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-087',
00:17:48 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
00:17:48 INFO - 'KTS_VERSION': '1.19c',
00:17:48 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-087\\AppData\\Local',
00:17:48 INFO - 'LOGONSERVER': '\\\\T-W864-IX-087',
00:17:48 INFO - 'MONDIR': 'C:\\Monitor_config\\',
00:17:48 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
00:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
00:17:48 INFO - 'MOZ_NO_REMOTE': '1',
00:17:48 INFO - 'NO_EM_RESTART': '1',
00:17:48 INFO - 'NUMBER_OF_PROCESSORS': '8',
00:17:48 INFO - 'OS': 'Windows_NT',
00:17:48 INFO - 'OURDRIVE': 'C:',
00:17:48 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
00:17:48 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
00:17:48 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
00:17:48 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
00:17:48 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
00:17:48 INFO - 'PROCESSOR_LEVEL': '6',
00:17:48 INFO - 'PROCESSOR_REVISION': '1e05',
00:17:48 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
00:17:48 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
00:17:48 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
00:17:48 INFO - 'PROGRAMW6432': 'C:\\Program Files',
00:17:48 INFO - 'PROMPT': '$P$G',
00:17:48 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json',
00:17:48 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
00:17:48 INFO - 'PUBLIC': 'C:\\Users\\Public',
00:17:48 INFO - 'PWD': 'C:\\slave\\test-pgo',
00:17:48 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
00:17:48 INFO - 'SLAVEDIR': 'C:\\slave\\',
00:17:48 INFO - 'SYSTEMDRIVE': 'C:',
00:17:48 INFO - 'SYSTEMROOT': 'C:\\windows',
00:17:48 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
00:17:48 INFO - 'TEST1': 'testie',
00:17:48 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
00:17:48 INFO - 'USERDOMAIN': 'T-W864-IX-087',
00:17:48 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-087',
00:17:48 INFO - 'USERNAME': 'cltbld',
00:17:48 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-087',
00:17:48 INFO - 'WINDIR': 'C:\\windows',
00:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
00:17:48 INFO - Ignoring indexes: https://pypi.python.org/simple/
00:17:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0
00:17:48 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
00:17:48 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
00:17:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz
00:17:49 INFO - Storing download in cache at c:\slave\test-pgo\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fmozsystemmonitor-0.0.tar.gz
00:17:49 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor
00:17:49 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)
00:17:49 INFO - Installing collected packages: mozsystemmonitor
00:17:49 INFO - Running setup.py install for mozsystemmonitor
00:17:50 INFO - Successfully installed mozsystemmonitor
00:17:50 INFO - Cleaning up...
00:17:50 INFO - Return code: 0
00:17:50 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test-pgo\build/venv
00:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
00:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
00:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
00:17:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
00:17:50 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--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 0x022186B0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022C2EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x007F4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00738BF0>, '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 0x0075A9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027A15C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-087', 'USERDOMAIN': 'T-W864-IX-087', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-087', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-087\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-087', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-087', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-087', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-087\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test-pgo', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
00:17:50 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in C:\slave\test-pgo\build
00:17:50 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --download-cache C:\slave\test-pgo\build/venv\cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4
00:17:50 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
00:17:50 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-087\\AppData\\Roaming',
00:17:50 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
00:17:50 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
00:17:50 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
00:17:50 INFO - 'COMPUTERNAME': 'T-W864-IX-087',
00:17:50 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
00:17:50 INFO - 'DCLOCATION': 'SCL3',
00:17:50 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
00:17:50 INFO - 'FP_NO_HOST_CHECK': 'NO',
00:17:50 INFO - 'HOMEDRIVE': 'C:',
00:17:50 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-087',
00:17:50 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
00:17:50 INFO - 'KTS_VERSION': '1.19c',
00:17:50 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-087\\AppData\\Local',
00:17:50 INFO - 'LOGONSERVER': '\\\\T-W864-IX-087',
00:17:50 INFO - 'MONDIR': 'C:\\Monitor_config\\',
00:17:50 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
00:17:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
00:17:50 INFO - 'MOZ_NO_REMOTE': '1',
00:17:50 INFO - 'NO_EM_RESTART': '1',
00:17:50 INFO - 'NUMBER_OF_PROCESSORS': '8',
00:17:50 INFO - 'OS': 'Windows_NT',
00:17:50 INFO - 'OURDRIVE': 'C:',
00:17:50 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
00:17:50 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
00:17:50 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
00:17:50 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
00:17:50 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
00:17:50 INFO - 'PROCESSOR_LEVEL': '6',
00:17:50 INFO - 'PROCESSOR_REVISION': '1e05',
00:17:50 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
00:17:50 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
00:17:50 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
00:17:50 INFO - 'PROGRAMW6432': 'C:\\Program Files',
00:17:50 INFO - 'PROMPT': '$P$G',
00:17:50 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json',
00:17:50 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
00:17:50 INFO - 'PUBLIC': 'C:\\Users\\Public',
00:17:50 INFO - 'PWD': 'C:\\slave\\test-pgo',
00:17:50 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
00:17:50 INFO - 'SLAVEDIR': 'C:\\slave\\',
00:17:50 INFO - 'SYSTEMDRIVE': 'C:',
00:17:50 INFO - 'SYSTEMROOT': 'C:\\windows',
00:17:50 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
00:17:50 INFO - 'TEST1': 'testie',
00:17:50 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
00:17:50 INFO - 'USERDOMAIN': 'T-W864-IX-087',
00:17:50 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-087',
00:17:50 INFO - 'USERNAME': 'cltbld',
00:17:50 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-087',
00:17:50 INFO - 'WINDIR': 'C:\\windows',
00:17:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
00:17:50 INFO - Ignoring indexes: https://pypi.python.org/simple/
00:17:50 INFO - Downloading/unpacking blobuploader==1.2.4
00:17: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
00:17: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
00:17:51 INFO - Downloading blobuploader-1.2.4.tar.gz
00:17:51 INFO - Storing download in cache at c:\slave\test-pgo\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fblobuploader-1.2.4.tar.gz
00:17:51 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader
00:17:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4)
00:17: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
00:17: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
00:17:51 INFO - Storing download in cache at c:\slave\test-pgo\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2frequests-1.2.3.tar.gz
00:17:51 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\requests\setup.py) egg_info for package requests
00:17:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4)
00:17: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
00:17: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
00:17:52 INFO - Downloading docopt-0.6.1.tar.gz
00:17:52 INFO - Storing download in cache at c:\slave\test-pgo\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fdocopt-0.6.1.tar.gz
00:17:52 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\docopt\setup.py) egg_info for package docopt
00:17:52 INFO - Installing collected packages: blobuploader, requests, docopt
00:17:52 INFO - Running setup.py install for blobuploader
00:17:52 INFO - Running setup.py install for requests
00:17:53 INFO - Running setup.py install for docopt
00:17:53 INFO - Successfully installed blobuploader requests docopt
00:17:53 INFO - Cleaning up...
00:17:54 INFO - Return code: 0
00:17:54 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv
00:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]}
00:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
00:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]}
00:17:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
00:17:54 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--no-deps', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test-pgo\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022186B0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022C2EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x007F4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00738BF0>, '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 0x0075A9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027A15C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-087', 'USERDOMAIN': 'T-W864-IX-087', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-087', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-087\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-087', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-087', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-087', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-087\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test-pgo', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
00:17:54 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--no-deps', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test-pgo\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in C:\slave\test-pgo\build\tests\config
00:17:54 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --no-deps --download-cache C:\slave\test-pgo\build/venv\cache --timeout 120 -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub
00:17:54 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
00:17:54 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-087\\AppData\\Roaming',
00:17:54 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
00:17:54 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
00:17:54 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
00:17:54 INFO - 'COMPUTERNAME': 'T-W864-IX-087',
00:17:54 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
00:17:54 INFO - 'DCLOCATION': 'SCL3',
00:17:54 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
00:17:54 INFO - 'FP_NO_HOST_CHECK': 'NO',
00:17:54 INFO - 'HOMEDRIVE': 'C:',
00:17:54 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-087',
00:17:54 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
00:17:54 INFO - 'KTS_VERSION': '1.19c',
00:17:54 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-087\\AppData\\Local',
00:17:54 INFO - 'LOGONSERVER': '\\\\T-W864-IX-087',
00:17:54 INFO - 'MONDIR': 'C:\\Monitor_config\\',
00:17:54 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
00:17:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
00:17:54 INFO - 'MOZ_NO_REMOTE': '1',
00:17:54 INFO - 'NO_EM_RESTART': '1',
00:17:54 INFO - 'NUMBER_OF_PROCESSORS': '8',
00:17:54 INFO - 'OS': 'Windows_NT',
00:17:54 INFO - 'OURDRIVE': 'C:',
00:17:54 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
00:17:54 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
00:17:54 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
00:17:54 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
00:17:54 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
00:17:54 INFO - 'PROCESSOR_LEVEL': '6',
00:17:54 INFO - 'PROCESSOR_REVISION': '1e05',
00:17:54 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
00:17:54 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
00:17:54 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
00:17:54 INFO - 'PROGRAMW6432': 'C:\\Program Files',
00:17:54 INFO - 'PROMPT': '$P$G',
00:17:54 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json',
00:17:54 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
00:17:54 INFO - 'PUBLIC': 'C:\\Users\\Public',
00:17:54 INFO - 'PWD': 'C:\\slave\\test-pgo',
00:17:54 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
00:17:54 INFO - 'SLAVEDIR': 'C:\\slave\\',
00:17:54 INFO - 'SYSTEMDRIVE': 'C:',
00:17:54 INFO - 'SYSTEMROOT': 'C:\\windows',
00:17:54 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
00:17:54 INFO - 'TEST1': 'testie',
00:17:54 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
00:17:54 INFO - 'USERDOMAIN': 'T-W864-IX-087',
00:17:54 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-087',
00:17:54 INFO - 'USERNAME': 'cltbld',
00:17:54 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-087',
00:17:54 INFO - 'WINDIR': 'C:\\windows',
00:17:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
00:17:54 INFO - Ignoring indexes: https://pypi.python.org/simple/
00:17:54 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\manifestparser
00:17:54 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-4iusnq-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/manifestparser
00:17:55 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozcrash
00:17:55 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-4gun73-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozcrash
00:17:55 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdebug
00:17:55 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-at3eju-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdebug
00:17:55 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdevice
00:17:55 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-93nrak-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdevice
00:17:55 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozfile
00:17:55 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ujji7x-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozfile
00:17:55 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozhttpd
00:17:55 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-mkxuwk-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozhttpd
00:17:55 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinfo
00:17:55 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ped8a4-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinfo
00:17:55 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinstall
00:17:55 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ztrezl-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinstall
00:17:55 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozleak
00:17:55 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-eupssy-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozleak
00:17:55 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozlog
00:17:55 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-7bck6e-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozlog
00:17:56 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moznetwork
00:17:56 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-uwetmf-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moznetwork
00:17:56 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprocess
00:17:56 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-gzbyyb-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprocess
00:17:56 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprofile
00:17:56 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-682lis-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprofile
00:17:56 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozrunner
00:17:56 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ulhyug-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozrunner
00:17:56 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozscreenshot
00:17:56 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-gxg68t-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozscreenshot
00:17:56 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moztest
00:17:56 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-2fxcos-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moztest
00:17:56 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozversion
00:17:56 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-6zped7-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozversion
00:17:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion
00:17:56 INFO - Running setup.py install for manifestparser
00:17:56 INFO - Installing manifestparser-script.py script to C:\slave\test-pgo\build\venv\Scripts
00:17:56 INFO - Installing manifestparser.exe script to C:\slave\test-pgo\build\venv\Scripts
00:17:57 INFO - Running setup.py install for mozcrash
00:17:57 INFO - Running setup.py install for mozdebug
00:17:58 INFO - Running setup.py install for mozdevice
00:17:58 INFO - Installing sutini-script.py script to C:\slave\test-pgo\build\venv\Scripts
00:17:58 INFO - Installing sutini.exe script to C:\slave\test-pgo\build\venv\Scripts
00:17:58 INFO - Installing dm-script.py script to C:\slave\test-pgo\build\venv\Scripts
00:17:58 INFO - Installing dm.exe script to C:\slave\test-pgo\build\venv\Scripts
00:17:58 INFO - Running setup.py install for mozfile
00:17:59 INFO - Running setup.py install for mozhttpd
00:17:59 INFO - Installing mozhttpd-script.py script to C:\slave\test-pgo\build\venv\Scripts
00:17:59 INFO - Installing mozhttpd.exe script to C:\slave\test-pgo\build\venv\Scripts
00:17:59 INFO - Running setup.py install for mozinfo
00:17:59 INFO - Installing mozinfo-script.py script to C:\slave\test-pgo\build\venv\Scripts
00:17:59 INFO - Installing mozinfo.exe script to C:\slave\test-pgo\build\venv\Scripts
00:18:00 INFO - Running setup.py install for mozInstall
00:18:00 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test-pgo\build\venv\Scripts
00:18:00 INFO - Installing moz_remove_from_system.exe script to C:\slave\test-pgo\build\venv\Scripts
00:18:00 INFO - Installing mozuninstall-script.py script to C:\slave\test-pgo\build\venv\Scripts
00:18:00 INFO - Installing mozuninstall.exe script to C:\slave\test-pgo\build\venv\Scripts
00:18:00 INFO - Installing mozinstall-script.py script to C:\slave\test-pgo\build\venv\Scripts
00:18:00 INFO - Installing mozinstall.exe script to C:\slave\test-pgo\build\venv\Scripts
00:18:00 INFO - Installing moz_add_to_system-script.py script to C:\slave\test-pgo\build\venv\Scripts
00:18:00 INFO - Installing moz_add_to_system.exe script to C:\slave\test-pgo\build\venv\Scripts
00:18:00 INFO - Running setup.py install for mozleak
00:18:00 INFO - Running setup.py install for mozlog
00:18:00 INFO - Installing structlog-script.py script to C:\slave\test-pgo\build\venv\Scripts
00:18:00 INFO - Installing structlog.exe script to C:\slave\test-pgo\build\venv\Scripts
00:18:01 INFO - Running setup.py install for moznetwork
00:18:01 INFO - Installing moznetwork-script.py script to C:\slave\test-pgo\build\venv\Scripts
00:18:01 INFO - Installing moznetwork.exe script to C:\slave\test-pgo\build\venv\Scripts
00:18:01 INFO - Running setup.py install for mozprocess
00:18:02 INFO - Running setup.py install for mozprofile
00:18:02 INFO - Installing mozprofile-script.py script to C:\slave\test-pgo\build\venv\Scripts
00:18:02 INFO - Installing mozprofile.exe script to C:\slave\test-pgo\build\venv\Scripts
00:18:02 INFO - Installing diff-profiles-script.py script to C:\slave\test-pgo\build\venv\Scripts
00:18:02 INFO - Installing diff-profiles.exe script to C:\slave\test-pgo\build\venv\Scripts
00:18:02 INFO - Installing view-profile-script.py script to C:\slave\test-pgo\build\venv\Scripts
00:18:02 INFO - Installing view-profile.exe script to C:\slave\test-pgo\build\venv\Scripts
00:18:03 INFO - Running setup.py install for mozrunner
00:18:03 INFO - Installing mozrunner-script.py script to C:\slave\test-pgo\build\venv\Scripts
00:18:03 INFO - Installing mozrunner.exe script to C:\slave\test-pgo\build\venv\Scripts
00:18:03 INFO - Running setup.py install for mozscreenshot
00:18:04 INFO - Running setup.py install for moztest
00:18:04 INFO - Running setup.py install for mozversion
00:18:04 INFO - Installing mozversion-script.py script to C:\slave\test-pgo\build\venv\Scripts
00:18:04 INFO - Installing mozversion.exe script to C:\slave\test-pgo\build\venv\Scripts
00:18:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion
00:18:04 INFO - Cleaning up...
00:18:04 INFO - Return code: 0
00:18:04 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv
00:18:04 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')]}
00:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
00:18:04 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')]}
00:18:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
00:18:04 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test-pgo\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022186B0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022C2EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x007F4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00738BF0>, '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 0x0075A9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027A15C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-087', 'USERDOMAIN': 'T-W864-IX-087', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-087', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-087\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-087', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-087', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-087', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-087\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test-pgo', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
00:18:04 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test-pgo\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in C:\slave\test-pgo\build\tests\config
00:18:04 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --download-cache C:\slave\test-pgo\build/venv\cache --timeout 120 -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub
00:18:04 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
00:18:04 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-087\\AppData\\Roaming',
00:18:04 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
00:18:04 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
00:18:04 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
00:18:04 INFO - 'COMPUTERNAME': 'T-W864-IX-087',
00:18:04 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
00:18:04 INFO - 'DCLOCATION': 'SCL3',
00:18:04 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
00:18:04 INFO - 'FP_NO_HOST_CHECK': 'NO',
00:18:04 INFO - 'HOMEDRIVE': 'C:',
00:18:04 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-087',
00:18:04 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
00:18:04 INFO - 'KTS_VERSION': '1.19c',
00:18:04 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-087\\AppData\\Local',
00:18:04 INFO - 'LOGONSERVER': '\\\\T-W864-IX-087',
00:18:04 INFO - 'MONDIR': 'C:\\Monitor_config\\',
00:18:04 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
00:18:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
00:18:04 INFO - 'MOZ_NO_REMOTE': '1',
00:18:04 INFO - 'NO_EM_RESTART': '1',
00:18:04 INFO - 'NUMBER_OF_PROCESSORS': '8',
00:18:04 INFO - 'OS': 'Windows_NT',
00:18:04 INFO - 'OURDRIVE': 'C:',
00:18:04 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
00:18:04 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
00:18:04 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
00:18:04 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
00:18:04 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
00:18:04 INFO - 'PROCESSOR_LEVEL': '6',
00:18:04 INFO - 'PROCESSOR_REVISION': '1e05',
00:18:04 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
00:18:04 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
00:18:04 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
00:18:04 INFO - 'PROGRAMW6432': 'C:\\Program Files',
00:18:04 INFO - 'PROMPT': '$P$G',
00:18:04 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json',
00:18:04 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
00:18:04 INFO - 'PUBLIC': 'C:\\Users\\Public',
00:18:04 INFO - 'PWD': 'C:\\slave\\test-pgo',
00:18:04 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
00:18:04 INFO - 'SLAVEDIR': 'C:\\slave\\',
00:18:04 INFO - 'SYSTEMDRIVE': 'C:',
00:18:04 INFO - 'SYSTEMROOT': 'C:\\windows',
00:18:04 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
00:18:04 INFO - 'TEST1': 'testie',
00:18:04 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
00:18:04 INFO - 'USERDOMAIN': 'T-W864-IX-087',
00:18:04 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-087',
00:18:04 INFO - 'USERNAME': 'cltbld',
00:18:04 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-087',
00:18:04 INFO - 'WINDIR': 'C:\\windows',
00:18:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
00:18:05 INFO - Ignoring indexes: https://pypi.python.org/simple/
00:18:05 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\manifestparser
00:18:05 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-pipj7p-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/manifestparser
00:18:05 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))
00:18:05 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozcrash
00:18:05 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-bhi60k-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozcrash
00:18:05 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))
00:18:05 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdebug
00:18:05 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ijizk1-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdebug
00:18:05 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))
00:18:05 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdevice
00:18:05 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-idxeov-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdevice
00:18:05 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))
00:18:05 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozfile
00:18:05 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-u5wukj-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozfile
00:18:05 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))
00:18:05 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozhttpd
00:18:05 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-g_jf9_-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozhttpd
00:18:05 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))
00:18:05 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinfo
00:18:05 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-py4xml-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinfo
00:18:06 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))
00:18:06 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinstall
00:18:06 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xzz4r2-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinstall
00:18:06 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))
00:18:06 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozleak
00:18:06 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-uwv2vq-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozleak
00:18:06 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))
00:18:06 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozlog
00:18:06 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xiiwfr-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozlog
00:18:06 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))
00:18:06 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moznetwork
00:18:06 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-opgag5-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moznetwork
00:18:06 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))
00:18:06 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprocess
00:18:06 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-mxbkki-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprocess
00:18:06 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))
00:18:06 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprofile
00:18:06 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rqexiy-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprofile
00:18:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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))
00:18:06 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozrunner
00:18:06 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-5hpeit-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozrunner
00:18:06 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))
00:18:06 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozscreenshot
00:18:06 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-vvr1kl-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozscreenshot
00:18:07 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))
00:18:07 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moztest
00:18:07 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-znz40e-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moztest
00:18:07 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))
00:18:07 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozversion
00:18:07 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-gwnm6y-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozversion
00:18:07 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))
00:18:07 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))
00:18:07 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))
00:18:07 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))
00:18:07 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))
00:18:07 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))
00:18:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 10))
00:18:07 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
00:18:07 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
00:18:08 INFO - Downloading blessings-1.5.1.tar.gz
00:18:08 INFO - Storing download in cache at c:\slave\test-pgo\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fblessings-1.5.1.tar.gz
00:18:08 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\blessings\setup.py) egg_info for package blessings
00:18:08 INFO - Installing collected packages: blessings
00:18:08 INFO - Running setup.py install for blessings
00:18:08 INFO - Successfully installed blessings
00:18:08 INFO - Cleaning up...
00:18:11 INFO - Return code: 0
00:18:11 INFO - Done creating virtualenv C:\slave\test-pgo\build/venv.
00:18:11 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'freeze']
00:18:11 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip freeze
00:18:11 INFO - Reading from file tmpfile_stdout
00:18:11 INFO - Using _rmtree_windows ...
00:18:11 INFO - Using _rmtree_windows ...
00:18:11 INFO - Current package versions:
00:18:11 INFO - blessings == 1.5.1
00:18:11 INFO - blobuploader == 1.2.4
00:18:11 INFO - docopt == 0.6.1
00:18:11 INFO - manifestparser == 1.1
00:18:11 INFO - mozInstall == 1.12
00:18:11 INFO - mozcrash == 0.16
00:18:11 INFO - mozdebug == 0.1
00:18:11 INFO - mozdevice == 0.47
00:18:11 INFO - mozfile == 1.2
00:18:11 INFO - mozhttpd == 0.7
00:18:11 INFO - mozinfo == 0.9
00:18:11 INFO - mozleak == 0.1
00:18:11 INFO - mozlog == 3.1
00:18:11 INFO - moznetwork == 0.27
00:18:11 INFO - mozprocess == 0.22
00:18:11 INFO - mozprofile == 0.28
00:18:11 INFO - mozrunner == 6.11
00:18:11 INFO - mozscreenshot == 0.1
00:18:11 INFO - mozsystemmonitor == 0.0
00:18:11 INFO - moztest == 0.7
00:18:11 INFO - mozversion == 1.4
00:18:11 INFO - psutil == 3.1.1
00:18:11 INFO - requests == 1.2.3
00:18:11 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv
00:18:11 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')]}
00:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
00:18:11 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')]}
00:18:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
00:18:11 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test-pgo\\build\\tests\\talos\\requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022186B0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022C2EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x007F4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00738BF0>, '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 0x0075A9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027A15C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build\\tests\\talos', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-087', 'USERDOMAIN': 'T-W864-IX-087', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-087', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-087\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-087', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-087', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-087', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-087\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test-pgo', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
00:18:11 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test-pgo\\build\\tests\\talos\\requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in C:\slave\test-pgo\build\tests\talos
00:18:11 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --download-cache C:\slave\test-pgo\build/venv\cache --timeout 120 -r C:\slave\test-pgo\build\tests\talos\requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub
00:18:11 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
00:18:11 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-087\\AppData\\Roaming',
00:18:11 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
00:18:11 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
00:18:11 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
00:18:11 INFO - 'COMPUTERNAME': 'T-W864-IX-087',
00:18:11 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
00:18:11 INFO - 'DCLOCATION': 'SCL3',
00:18:11 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
00:18:11 INFO - 'FP_NO_HOST_CHECK': 'NO',
00:18:11 INFO - 'HOMEDRIVE': 'C:',
00:18:11 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-087',
00:18:11 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
00:18:11 INFO - 'KTS_VERSION': '1.19c',
00:18:11 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-087\\AppData\\Local',
00:18:11 INFO - 'LOGONSERVER': '\\\\T-W864-IX-087',
00:18:11 INFO - 'MONDIR': 'C:\\Monitor_config\\',
00:18:11 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
00:18:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
00:18:11 INFO - 'MOZ_NO_REMOTE': '1',
00:18:11 INFO - 'NO_EM_RESTART': '1',
00:18:11 INFO - 'NUMBER_OF_PROCESSORS': '8',
00:18:11 INFO - 'OS': 'Windows_NT',
00:18:11 INFO - 'OURDRIVE': 'C:',
00:18:11 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
00:18:11 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
00:18:11 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
00:18:11 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
00:18:11 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
00:18:11 INFO - 'PROCESSOR_LEVEL': '6',
00:18:11 INFO - 'PROCESSOR_REVISION': '1e05',
00:18:11 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
00:18:11 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
00:18:11 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
00:18:11 INFO - 'PROGRAMW6432': 'C:\\Program Files',
00:18:11 INFO - 'PROMPT': '$P$G',
00:18:11 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json',
00:18:11 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
00:18:11 INFO - 'PUBLIC': 'C:\\Users\\Public',
00:18:11 INFO - 'PWD': 'C:\\slave\\test-pgo',
00:18:11 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
00:18:11 INFO - 'SLAVEDIR': 'C:\\slave\\',
00:18:11 INFO - 'SYSTEMDRIVE': 'C:',
00:18:11 INFO - 'SYSTEMROOT': 'C:\\windows',
00:18:11 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
00:18:11 INFO - 'TEST1': 'testie',
00:18:11 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
00:18:11 INFO - 'USERDOMAIN': 'T-W864-IX-087',
00:18:11 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-087',
00:18:11 INFO - 'USERNAME': 'cltbld',
00:18:11 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-087',
00:18:11 INFO - 'WINDIR': 'C:\\windows',
00:18:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
00:18:12 INFO - Ignoring indexes: https://pypi.python.org/simple/
00:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 1))
00:18:12 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 2))
00:18:12 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 3))
00:18:12 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 4))
00:18:12 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 5))
00:18:12 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 6))
00:18:12 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 7))
00:18:12 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 8))
00:18:12 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 9))
00:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in c:\slave\test-pgo\build\venv\lib\site-packages (from mozlog>=3.1->-r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 1))
00:18:12 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 4))
00:18:12 INFO - Cleaning up...
00:18:12 INFO - Return code: 0
00:18:12 INFO - Installing jsonschema into virtualenv C:\slave\test-pgo\build/venv
00:18:12 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')]}
00:18:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
00:18:12 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')]}
00:18:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
00:18:12 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022186B0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022C2EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x007F4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00738BF0>, '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 0x0075A9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027A15C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-087', 'USERDOMAIN': 'T-W864-IX-087', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-087', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-087\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-087', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-087', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-087', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-087\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test-pgo', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
00:18:12 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in C:\slave\test-pgo\build
00:18:12 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --download-cache C:\slave\test-pgo\build/venv\cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema
00:18:12 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
00:18:12 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-087\\AppData\\Roaming',
00:18:12 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
00:18:12 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
00:18:12 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
00:18:12 INFO - 'COMPUTERNAME': 'T-W864-IX-087',
00:18:12 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
00:18:12 INFO - 'DCLOCATION': 'SCL3',
00:18:12 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
00:18:12 INFO - 'FP_NO_HOST_CHECK': 'NO',
00:18:12 INFO - 'HOMEDRIVE': 'C:',
00:18:12 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-087',
00:18:12 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
00:18:12 INFO - 'KTS_VERSION': '1.19c',
00:18:12 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-087\\AppData\\Local',
00:18:12 INFO - 'LOGONSERVER': '\\\\T-W864-IX-087',
00:18:12 INFO - 'MONDIR': 'C:\\Monitor_config\\',
00:18:12 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
00:18:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
00:18:12 INFO - 'MOZ_NO_REMOTE': '1',
00:18:12 INFO - 'NO_EM_RESTART': '1',
00:18:12 INFO - 'NUMBER_OF_PROCESSORS': '8',
00:18:12 INFO - 'OS': 'Windows_NT',
00:18:12 INFO - 'OURDRIVE': 'C:',
00:18:12 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
00:18:12 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
00:18:12 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
00:18:12 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
00:18:12 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
00:18:12 INFO - 'PROCESSOR_LEVEL': '6',
00:18:12 INFO - 'PROCESSOR_REVISION': '1e05',
00:18:12 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
00:18:12 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
00:18:12 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
00:18:12 INFO - 'PROGRAMW6432': 'C:\\Program Files',
00:18:12 INFO - 'PROMPT': '$P$G',
00:18:12 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json',
00:18:12 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
00:18:12 INFO - 'PUBLIC': 'C:\\Users\\Public',
00:18:12 INFO - 'PWD': 'C:\\slave\\test-pgo',
00:18:12 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
00:18:12 INFO - 'SLAVEDIR': 'C:\\slave\\',
00:18:12 INFO - 'SYSTEMDRIVE': 'C:',
00:18:12 INFO - 'SYSTEMROOT': 'C:\\windows',
00:18:12 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
00:18:12 INFO - 'TEST1': 'testie',
00:18:12 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
00:18:12 INFO - 'USERDOMAIN': 'T-W864-IX-087',
00:18:12 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-087',
00:18:12 INFO - 'USERNAME': 'cltbld',
00:18:12 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-087',
00:18:12 INFO - 'WINDIR': 'C:\\windows',
00:18:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
00:18:12 INFO - Ignoring indexes: https://pypi.python.org/simple/
00:18:12 INFO - Downloading/unpacking jsonschema
00:18:12 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
00:18:12 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
00:18:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl
00:18:13 INFO - Storing download in cache at c:\slave\test-pgo\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fjsonschema-2.5.1-py2.py3-none-any.whl
00:18:13 INFO - Downloading/unpacking functools32 (from jsonschema)
00:18:13 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
00:18:13 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
00:18:13 INFO - Downloading functools32-3.2.3-2.tar.gz
00:18:13 INFO - Storing download in cache at c:\slave\test-pgo\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2ffunctools32-3.2.3-2.tar.gz
00:18:13 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\functools32\setup.py) egg_info for package functools32
00:18:13 INFO - warning: no files found matching '*.txt'
00:18:13 INFO - no previously-included directories found matching 'build'
00:18:13 INFO - no previously-included directories found matching 'dist'
00:18:13 INFO - no previously-included directories found matching '.git*'
00:18:13 INFO - Installing collected packages: jsonschema, functools32
00:18:13 INFO - Running setup.py install for functools32
00:18:13 INFO - warning: no files found matching '*.txt'
00:18:14 INFO - no previously-included directories found matching 'build'
00:18:14 INFO - no previously-included directories found matching 'dist'
00:18:14 INFO - no previously-included directories found matching '.git*'
00:18:14 INFO - Successfully installed jsonschema functools32
00:18:14 INFO - Cleaning up...
00:18:14 INFO - Return code: 0
00:18:14 INFO - Installing flake8 into virtualenv C:\slave\test-pgo\build/venv
00:18: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')]}
00:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
00:18: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')]}
00:18:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
00:18:14 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022186B0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022C2EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x007F4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00738BF0>, '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 0x0075A9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027A15C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-087', 'USERDOMAIN': 'T-W864-IX-087', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files (x86)', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'OURDRIVE': 'C:', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-087', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-087\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-087', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-087', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-087', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-087\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test-pgo', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROCESSOR_ARCHITEW6432': 'AMD64', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1
00:18:14 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in C:\slave\test-pgo\build
00:18:14 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --download-cache C:\slave\test-pgo\build/venv\cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8
00:18:14 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
00:18:14 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-087\\AppData\\Roaming',
00:18:14 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
00:18:14 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
00:18:14 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
00:18:14 INFO - 'COMPUTERNAME': 'T-W864-IX-087',
00:18:14 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
00:18:14 INFO - 'DCLOCATION': 'SCL3',
00:18:14 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
00:18:14 INFO - 'FP_NO_HOST_CHECK': 'NO',
00:18:14 INFO - 'HOMEDRIVE': 'C:',
00:18:14 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-087',
00:18:14 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
00:18:14 INFO - 'KTS_VERSION': '1.19c',
00:18:14 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-087\\AppData\\Local',
00:18:14 INFO - 'LOGONSERVER': '\\\\T-W864-IX-087',
00:18:14 INFO - 'MONDIR': 'C:\\Monitor_config\\',
00:18:14 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
00:18:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
00:18:14 INFO - 'MOZ_NO_REMOTE': '1',
00:18:14 INFO - 'NO_EM_RESTART': '1',
00:18:14 INFO - 'NUMBER_OF_PROCESSORS': '8',
00:18:14 INFO - 'OS': 'Windows_NT',
00:18:14 INFO - 'OURDRIVE': 'C:',
00:18:14 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
00:18:14 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
00:18:14 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
00:18:14 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
00:18:14 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
00:18:14 INFO - 'PROCESSOR_LEVEL': '6',
00:18:14 INFO - 'PROCESSOR_REVISION': '1e05',
00:18:14 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
00:18:14 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
00:18:14 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
00:18:14 INFO - 'PROGRAMW6432': 'C:\\Program Files',
00:18:14 INFO - 'PROMPT': '$P$G',
00:18:14 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json',
00:18:14 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
00:18:14 INFO - 'PUBLIC': 'C:\\Users\\Public',
00:18:14 INFO - 'PWD': 'C:\\slave\\test-pgo',
00:18:14 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
00:18:14 INFO - 'SLAVEDIR': 'C:\\slave\\',
00:18:14 INFO - 'SYSTEMDRIVE': 'C:',
00:18:14 INFO - 'SYSTEMROOT': 'C:\\windows',
00:18:14 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
00:18:14 INFO - 'TEST1': 'testie',
00:18:14 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
00:18:14 INFO - 'USERDOMAIN': 'T-W864-IX-087',
00:18:14 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-087',
00:18:14 INFO - 'USERNAME': 'cltbld',
00:18:14 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-087',
00:18:14 INFO - 'WINDIR': 'C:\\windows',
00:18:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
00:18:14 INFO - Ignoring indexes: https://pypi.python.org/simple/
00:18:14 INFO - Downloading/unpacking flake8
00:18:14 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
00:18:14 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
00:18:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl
00:18:15 INFO - Storing download in cache at c:\slave\test-pgo\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fflake8-2.5.0-py2.py3-none-any.whl
00:18:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8)
00:18:15 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
00:18:15 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
00:18:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl
00:18:15 INFO - Storing download in cache at c:\slave\test-pgo\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fmccabe-0.3.1-py2.py3-none-any.whl
00:18:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8)
00:18:15 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
00:18:15 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
00:18:16 INFO - Storing download in cache at c:\slave\test-pgo\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fpyflakes-1.0.0-py2.py3-none-any.whl
00:18:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8)
00:18:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
00:18:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
00:18:16 INFO - Storing download in cache at c:\slave\test-pgo\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fpep8-1.5.7.tar.gz
00:18:16 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\pep8\setup.py) egg_info for package pep8
00:18:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs'
00:18:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs'
00:18:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite'
00:18:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite'
00:18:16 INFO - no previously-included directories found matching 'docs\_build'
00:18:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8
00:18:16 INFO - Running setup.py install for pep8
00:18:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs'
00:18:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs'
00:18:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite'
00:18:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite'
00:18:16 INFO - no previously-included directories found matching 'docs\_build'
00:18:16 INFO - Installing pep8-script.py script to C:\slave\test-pgo\build\venv\Scripts
00:18:16 INFO - Installing pep8.exe script to C:\slave\test-pgo\build\venv\Scripts
00:18:16 INFO - Successfully installed flake8 mccabe pyflakes pep8
00:18:16 INFO - Cleaning up...
00:18:17 INFO - Return code: 0
00:18:17 INFO - Running post-action listener: _resource_record_post_action
00:18:17 INFO - Running post-action listener: _start_resource_monitoring
00:18:17 INFO - Starting resource monitoring.
00:18:17 INFO - #####
00:18:17 INFO - ##### Running install step.
00:18:17 INFO - #####
00:18:17 INFO - Running pre-action listener: _resource_record_pre_action
00:18:17 INFO - Running main action method: install
00:18:17 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'freeze']
00:18:17 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip freeze
00:18:18 INFO - Reading from file tmpfile_stdout
00:18:18 INFO - Using _rmtree_windows ...
00:18:18 INFO - Using _rmtree_windows ...
00:18:18 INFO - Detecting whether we're running mozinstall >=1.0...
00:18:18 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build/venv/scripts/python', 'C:\\slave\\test-pgo\\build/venv/scripts/mozinstall-script.py', '-h']
00:18:18 INFO - Copy/paste: C:\slave\test-pgo\build/venv/scripts/python C:\slave\test-pgo\build/venv/scripts/mozinstall-script.py -h
00:18:18 INFO - Reading from file tmpfile_stdout
00:18:18 INFO - Output received:
00:18:18 INFO - Usage: mozinstall-script.py [options] installer
00:18:18 INFO - Options:
00:18:18 INFO - -h, --help show this help message and exit
00:18:18 INFO - -d DEST, --destination=DEST
00:18:18 INFO - Directory to install application into. [default:
00:18:18 INFO - "C:\slave\test-pgo"]
00:18:18 INFO - --app=APP Application being installed. [default: firefox]
00:18:18 INFO - Using _rmtree_windows ...
00:18:18 INFO - Using _rmtree_windows ...
00:18:18 INFO - mkdir: C:\slave\test-pgo\build\application
00:18:18 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-46.0a1.en-US.win64.zip', '--destination', 'C:\\slave\\test-pgo\\build\\application']
00:18:18 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-46.0a1.en-US.win64.zip --destination C:\slave\test-pgo\build\application
00:18:24 INFO - Reading from file tmpfile_stdout
00:18:24 INFO - Output received:
00:18:24 INFO - C:\slave\test-pgo\build\application\firefox\firefox.exe
00:18:24 INFO - Using _rmtree_windows ...
00:18:24 INFO - Using _rmtree_windows ...
00:18:24 INFO - Running post-action listener: _resource_record_post_action
00:18:24 INFO - #####
00:18:24 INFO - ##### Running run-tests step.
00:18:24 INFO - #####
00:18:24 INFO - Running pre-action listener: _resource_record_pre_action
00:18:24 INFO - Running main action method: run_tests
00:18:24 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\python', '--version']
00:18:24 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\python --version
00:18:24 INFO - Python 2.7.3
00:18:24 INFO - Return code: 0
00:18:24 INFO - grabbing minidump binary from tooltool
00:18: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')]}
00:18:24 INFO - retry: Calling run_command with args: (['c:/mozilla-build/python27/python.exe', 'C:/mozilla-build/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', 'c:\\builds\\relengapi.tok', 'fetch', '-m', 'C:\\slave\\test-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 0x00738BF0>, '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 0x0075A9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027A15C0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'privileged': False}, attempt #1
00:18:24 INFO - Running command: ['c:/mozilla-build/python27/python.exe', 'C:/mozilla-build/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', 'c:\\builds\\relengapi.tok', 'fetch', '-m', 'C:\\slave\\test-pgo\\build\\tests\\config/tooltool-manifests/win32/releng.manifest', '-o'] in C:\slave\test-pgo\build
00:18:24 INFO - Copy/paste: c:/mozilla-build/python27/python.exe C:/mozilla-build/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file c:\builds\relengapi.tok fetch -m C:\slave\test-pgo\build\tests\config/tooltool-manifests/win32/releng.manifest -o
00:18:24 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'...
00:18:25 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test-pgo\build\tmp8thkri
00:18:25 INFO - INFO - File integrity verified, renaming tmp8thkri to win32-minidump_stackwalk.exe
00:18:25 INFO - Return code: 0
00:18:25 INFO - Chmoding C:\slave\test-pgo\build\win32-minidump_stackwalk.exe to 0755
00:18:25 INFO - mkdir: C:\slave\test-pgo\build\blobber_upload_dir
00:18:25 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test-pgo\build\blobber_upload_dir
00:18:25 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test-pgo\build\win32-minidump_stackwalk.exe
00:18:25 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test-pgo\build\blobber_upload_dir
00:18:25 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\flake8', 'C:\\slave\\test-pgo\\build\\tests\\talos\\talos']
00:18:25 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\flake8 C:\slave\test-pgo\build\tests\talos\talos
00:18:27 INFO - Return code: 0
00:18:27 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\python', 'C:\\slave\\test-pgo\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'svgr', '--executablePath', 'C:\\slave\\test-pgo\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/xFsdWicSSM6vBbqUTU2P-g/artifacts/public/build/firefox-46.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-087', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=C:\\slave\\test-pgo\\build\\blobber_upload_dir\\svgr_errorsummary.log', '--log-raw=C:\\slave\\test-pgo\\build\\blobber_upload_dir\\svgr_raw.log'] in C:\slave\test-pgo\build
00:18:27 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\python C:\slave\test-pgo\build\tests\talos\talos\run_tests.py --branchName B2G-Inbound --suite svgr --executablePath C:\slave\test-pgo\build\application\firefox\firefox --symbolsPath https://queue.taskcluster.net/v1/task/xFsdWicSSM6vBbqUTU2P-g/artifacts/public/build/firefox-46.0a1.en-US.win64.crashreporter-symbols.zip --title T-W864-IX-087 --webServer localhost --log-tbpl-level=debug --log-errorsummary=C:\slave\test-pgo\build\blobber_upload_dir\svgr_errorsummary.log --log-raw=C:\slave\test-pgo\build\blobber_upload_dir\svgr_raw.log
00:18:27 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
00:18:27 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-087\\AppData\\Roaming',
00:18:27 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
00:18:27 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
00:18:27 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
00:18:27 INFO - 'COMPUTERNAME': 'T-W864-IX-087',
00:18:27 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
00:18:27 INFO - 'DCLOCATION': 'SCL3',
00:18:27 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
00:18:27 INFO - 'FP_NO_HOST_CHECK': 'NO',
00:18:27 INFO - 'HOMEDRIVE': 'C:',
00:18:27 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-087',
00:18:27 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
00:18:27 INFO - 'KTS_VERSION': '1.19c',
00:18:27 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-087\\AppData\\Local',
00:18:27 INFO - 'LOGONSERVER': '\\\\T-W864-IX-087',
00:18:27 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test-pgo\\build\\blobber_upload_dir',
00:18:27 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test-pgo\\build\\win32-minidump_stackwalk.exe',
00:18:27 INFO - 'MONDIR': 'C:\\Monitor_config\\',
00:18:27 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
00:18:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
00:18:27 INFO - 'MOZ_NO_REMOTE': '1',
00:18:27 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test-pgo\\build\\blobber_upload_dir',
00:18:27 INFO - 'NO_EM_RESTART': '1',
00:18:27 INFO - 'NUMBER_OF_PROCESSORS': '8',
00:18:27 INFO - 'OS': 'Windows_NT',
00:18:27 INFO - 'OURDRIVE': 'C:',
00:18:27 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
00:18:27 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
00:18:27 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
00:18:27 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
00:18:27 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
00:18:27 INFO - 'PROCESSOR_LEVEL': '6',
00:18:27 INFO - 'PROCESSOR_REVISION': '1e05',
00:18:27 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
00:18:27 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
00:18:27 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
00:18:27 INFO - 'PROGRAMW6432': 'C:\\Program Files',
00:18:27 INFO - 'PROMPT': '$P$G',
00:18:27 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json',
00:18:27 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
00:18:27 INFO - 'PUBLIC': 'C:\\Users\\Public',
00:18:27 INFO - 'PWD': 'C:\\slave\\test-pgo',
00:18:27 INFO - 'PYTHONPATH': 'C:\\slave\\test-pgo\\build\\tests\\talos',
00:18:27 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
00:18:27 INFO - 'SLAVEDIR': 'C:\\slave\\',
00:18:27 INFO - 'SYSTEMDRIVE': 'C:',
00:18:27 INFO - 'SYSTEMROOT': 'C:\\windows',
00:18:27 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
00:18:27 INFO - 'TEST1': 'testie',
00:18:27 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
00:18:27 INFO - 'USERDOMAIN': 'T-W864-IX-087',
00:18:27 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-087',
00:18:27 INFO - 'USERNAME': 'cltbld',
00:18:27 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-087',
00:18:27 INFO - 'WINDIR': 'C:\\windows',
00:18:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
00:18:27 INFO - Calling ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\python', 'C:\\slave\\test-pgo\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'svgr', '--executablePath', 'C:\\slave\\test-pgo\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/xFsdWicSSM6vBbqUTU2P-g/artifacts/public/build/firefox-46.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-087', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=C:\\slave\\test-pgo\\build\\blobber_upload_dir\\svgr_errorsummary.log', '--log-raw=C:\\slave\\test-pgo\\build\\blobber_upload_dir\\svgr_raw.log'] with output_timeout 3600
ProcessManager NOT managing child processes
ProcessManager UNABLE to use job objects to manage child processes
00:18:28 INFO - mozversion application_buildid: 20151221203114
00:18:28 INFO - mozversion application_changeset: 0db21edafc584d96b7ce682145d99d7df0b643de
00:18:28 INFO - mozversion application_display_name: Nightly
00:18:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384}
00:18:28 INFO - mozversion application_name: Firefox
00:18:28 INFO - mozversion application_remotingname: firefox
00:18:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound
00:18:28 INFO - mozversion application_vendor: Mozilla
00:18:28 INFO - mozversion application_version: 46.0a1
00:18:28 INFO - mozversion platform_buildid: 20151221203114
00:18:28 INFO - mozversion platform_changeset: 0db21edafc584d96b7ce682145d99d7df0b643de
00:18:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound
00:18:28 INFO - mozversion platform_version: 46.0a1
00:18:28 INFO - using testdate: 1450772308
00:18:28 INFO - actual date: 1450772308
00:18:28 INFO - starting webserver on 'localhost:49275'
00:18:28 INFO - SUITE-START | Running 5 tests
00:18:28 INFO - TEST-START | tsvgx
00:18:28 INFO - operating with platform_type : w8_
00:18:28 INFO - Initialising browser for tsvgx test...
00:18:28 INFO - TEST-INFO | started process 2940 (C:\slave\test-pgo\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmporhxiv\profile http://localhost:49275/getInfo.html)
00:18:45 INFO - PROCESS | 2940 | __metrics Screen width/height:1600/1200
00:18:45 INFO - PROCESS | 2940 | colorDepth:24
00:18:45 INFO - PROCESS | 2940 | Browser inner width/height: 1010/672
00:18:45 INFO - PROCESS | 2940 | __metrics
00:18:45 INFO - PROCESS | 2940 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank]
00:18:45 INFO - PROCESS | 2940 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver]
00:18:46 INFO - PROCESS | 2940 | *************************
00:18:46 INFO - PROCESS | 2940 | A coding exception was thrown and uncaught in a Task.
00:18:46 INFO - PROCESS | 2940 |
00:18:46 ERROR - PROCESS | 2940 | Full message: TypeError: connection.database is undefined
00:18:46 INFO - PROCESS | 2940 | Full stack: wrapStorageConnection@resource://gre/modules/Sqlite.jsm:1057:5
00:18:46 INFO - PROCESS | 2940 | @resource://gre/modules/PlacesUtils.jsm:2100:9
00:18:46 INFO - PROCESS | 2940 | XPCU_defineLazyGetter/<.get@resource://gre/modules/XPCOMUtils.jsm:198:21
00:18:46 INFO - PROCESS | 2940 | this.PlacesUtils.withConnectionWrapper/<@resource://gre/modules/PlacesUtils.jsm:1424:11
00:18:46 INFO - PROCESS | 2940 | TaskImpl_run@resource://gre/modules/Task.jsm:315:40
00:18:46 INFO - PROCESS | 2940 | TaskImpl@resource://gre/modules/Task.jsm:276:3
00:18:46 INFO - PROCESS | 2940 | createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:250:14
00:18:46 INFO - PROCESS | 2940 | Task_spawn@resource://gre/modules/Task.jsm:164:12
00:18:46 INFO - PROCESS | 2940 | this.PlacesUtils.withConnectionWrapper@resource://gre/modules/PlacesUtils.jsm:1423:1
00:18:46 INFO - PROCESS | 2940 | @resource://gre/modules/PlacesUtils.jsm:2293:1
00:18:46 INFO - PROCESS | 2940 | XPCU_defineLazyGetter/<.get@resource://gre/modules/XPCOMUtils.jsm:198:21
00:18:46 INFO - PROCESS | 2940 | PU_observe@resource://gre/modules/PlacesUtils.jsm:389:9
00:18:46 INFO - PROCESS | 2940 | PlacesCategoriesStarter/notify@resource://gre/components/PlacesCategoriesStarter.js:51:7
00:18:46 INFO - PROCESS | 2940 | walkTreeForImport@resource://gre/modules/BookmarkHTMLUtils.jsm:935:5
00:18:46 INFO - PROCESS | 2940 | BookmarkImporter.prototype.importFromURLtsvgx: 126.21
00:34:26 INFO - RETURN: tsvgr_opacity: 333.42
00:34:26 INFO - RETURN: tart: 4.25
00:34:26 INFO - RETURN: tscrollx: 2.67
00:34:26 INFO - RETURN: cart: 23.12
00:34:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [155.0, 108.0, 102.0, 100.0, 104.0, 105.0, 102.0, 105.0, 102.0, 102.0, 101.0, 102.0, 99.0, 104.0, 100.0, 100.0, 102.0, 103.0, 101.0, 103.0, 102.0, 105.0, 102.0, 103.0, 101.0], "unit": "ms", "name": "gearflowers.svg", "value": 102.0}, {"lowerIsBetter": true, "replicates": [77.0, 36.0, 35.0, 36.0, 37.0, 36.0, 37.0, 34.0, 36.0, 36.0, 36.0, 103.0, 40.0, 35.0, 36.0, 38.0, 36.0, 37.0, 39.0, 36.0, 37.0, 35.0, 35.0, 37.0, 35.0], "unit": "ms", "name": "composite-scale.svg", "value": 36.0}, {"lowerIsBetter": true, "replicates": [51.0, 41.0, 38.0, 39.0, 40.0, 37.0, 39.0, 38.0, 37.0, 39.0, 37.0, 39.0, 40.0, 37.0, 40.0, 40.0, 37.0, 40.0, 38.0, 37.0, 38.0, 37.0, 38.0, 41.0, 38.0], "unit": "ms", "name": "composite-scale-opacity.svg", "value": 38.0}, {"lowerIsBetter": true, "replicates": [49.0, 41.0, 40.0, 39.0, 37.0, 38.0, 39.0, 36.0, 36.0, 38.0, 36.0, 42.0, 39.0, 38.0, 38.0, 37.0, 37.0, 38.0, 38.0, 39.0, 39.0, 38.0, 40.0, 38.0, 39.0], "unit": "ms", "name": "composite-scale-rotate.svg", "value": 38.0}, {"lowerIsBetter": true, "replicates": [112.0, 44.0, 40.0, 40.0, 41.0, 40.0, 40.0, 42.0, 40.0, 73.0, 42.0, 40.0, 42.0, 43.0, 41.0, 41.0, 40.0, 40.0, 41.0, 41.0, 40.0, 43.0, 41.0, 40.0, 41.0], "unit": "ms", "name": "composite-scale-rotate-opacity.svg", "value": 41.0}, {"lowerIsBetter": true, "replicates": [486.0, 370.0, 373.0, 371.0, 458.0, 380.0, 394.0, 398.0, 373.0, 370.0, 366.0, 367.0, 361.0, 371.0, 365.0, 362.0, 366.0, 361.0, 361.0, 359.0, 370.0, 362.0, 361.0, 369.0, 363.0], "unit": "ms", "name": "hixie-001.xml", "value": 366.0}, {"lowerIsBetter": true, "replicates": [365.0, 372.0, 362.0, 362.0, 366.0, 364.0, 362.0, 363.0, 370.0, 366.0, 358.0, 363.0, 358.0, 358.0, 369.0, 362.0, 367.0, 364.0, 363.0, 369.0, 371.0, 359.0, 364.0, 359.0, 370.0], "unit": "ms", "name": "hixie-002.xml", "value": 363.5}, {"lowerIsBetter": true, "replicates": [505.0, 193.0, 192.0, 197.0, 193.0, 194.0, 195.0, 195.0, 198.0, 195.0, 196.0, 196.0, 198.0, 193.0, 195.0, 195.0, 194.0, 194.0, 196.0, 196.0, 193.0, 202.0, 198.0, 195.0, 194.0], "unit": "ms", "name": "hixie-003.xml", "value": 195.0}, {"lowerIsBetter": true, "replicates": [324.0, 299.0, 300.0, 309.0, 308.0, 299.0, 297.0, 302.0, 308.0, 307.0, 304.0, 301.0, 304.0, 305.0, 304.0, 311.0, 312.0, 302.0, 302.0, 302.0, 301.0, 298.0, 306.0, 305.0, 303.0], "unit": "ms", "name": "hixie-004.xml", "value": 303.5}, {"lowerIsBetter": true, "replicates": [216.0, 212.0, 213.0, 210.0, 223.0, 207.0, 210.0, 209.0, 215.0, 208.0, 216.0, 210.0, 216.0, 210.0, 214.0, 210.0, 214.0, 209.0, 215.0, 211.0, 214.0, 210.0, 213.0, 209.0, 215.0], "unit": "ms", "name": "hixie-005.xml", "value": 210.5}, {"lowerIsBetter": true, "replicates": [218.0, 216.0, 208.0, 218.0, 212.0, 214.0, 212.0, 214.0, 210.0, 211.0, 208.0, 217.0, 211.0, 215.0, 210.0, 216.0, 212.0, 213.0, 212.0, 217.0, 208.0, 217.0, 208.0, 215.0, 209.0], "unit": "ms", "name": "hixie-006.xml", "value": 212.0}, {"lowerIsBetter": true, "replicates": [290.0, 199.0, 204.0, 201.0, 222.0, 202.0, 202.0, 201.0, 201.0, 203.0, 203.0, 200.0, 205.0, 203.0, 204.0, 207.0, 207.0, 204.0, 205.0, 205.0, 205.0, 204.0, 204.0, 208.0, 213.0], "unit": "ms", "name": "hixie-007.xml", "value": 204.0}], "name": "tsvgx", "value": 126.20544098784511}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [438.0, 224.0, 226.0, 224.0, 225.0, 231.0, 222.0, 222.0, 222.0, 223.0, 220.0, 223.0, 221.0, 219.0, 221.0, 223.0, 221.0, 219.0, 222.0, 222.0, 220.0, 222.0, 221.0, 222.0, 221.0], "unit": "ms", "name": "big-optimizable-group-opacity-2500.svg", "value": 222.0}, {"lowerIsBetter": true, "replicates": [518.0, 536.0, 498.0, 505.0, 503.0, 502.0, 504.0, 495.0, 538.0, 497.0, 501.0, 497.0, 500.0, 503.0, 502.0, 533.0, 503.0, 493.0, 501.0, 496.0, 498.0, 492.0, 535.0, 495.0, 497.0], "unit": "ms", "name": "small-group-opacity-2500.svg", "value": 500.5}], "name": "tsvgr_opacity", "value": 333.4166562837444}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [1.8931848885583096, 1.960094219547207, 1.900078013295033, 1.9506569151150979, 1.9221395711104075, 1.9498173200477988, 1.946869190533956, 1.9483475963274637, 1.961213665493464, 1.978220331466804, 1.9599575329635104, 1.9578097311116882, 1.960901262396473, 1.9575884584653176, 1.9090610977079048, 1.983812235552689, 1.9471251944700876, 1.9452755868434906, 1.9458707869052887, 1.9540348093388444, 1.9378963808218639, 1.938862786690394, 1.9389587799708048, 1.9416275799274445, 1.9550826771784637], "unit": "ms", "name": "simple-open-DPI1.half.TART", "value": 1.9490824581876312}, {"lowerIsBetter": true, "replicates": [2.1731656234143144, 2.265252010864124, 2.2157418573724814, 2.2351427482522053, 2.358446641401811, 2.234571746121282, 2.2308886849361915, 2.2428895349087923, 2.251828823173255, 2.286997604159127, 2.262718946264501, 2.2538532551966215, 2.2546616855420565, 2.2644739046431424, 2.187847164961008, 2.2921052064214433, 2.2456545160527814, 2.237396652802177, 2.255267986080103, 2.236381558749987, 2.2536275690062, 2.2379776581473974, 2.235710388681163, 2.239537041083626, 2.250703769817687], "unit": "ms", "name": "simple-open-DPI1.all.TART", "value": 2.2481791429352342}, {"lowerIsBetter": true, "replicates": [26.9950000000008, 28.79500000000189, 27.540000000000873, 27.349999999998545, 29.834999999999127, 27.610000000000582, 27.06500000000233, 28.39999999999418, 27.26500000001397, 28.779999999998836, 28.54000000000815, 27.480000000010477, 27.619999999995343, 28.589999999996508, 26.47500000000582, 27.164999999979045, 26.630000000004657, 28.00999999998021, 27.474999999976717, 27.880000000004657, 27.394999999989523, 27.835000000020955, 27.525000000023283, 28.149999999965075, 27.24500000005355], "unit": "ms", "name": "simple-open-DPI1.error.TART", "value": 27.575000000000728}, {"lowerIsBetter": true, "replicates": [1.4433326795697212, 1.407202224905898, 1.6433790496417455, 1.4001810995929211, 1.374675689708619, 1.4020640835704574, 1.4062328542151101, 1.4047624163511323, 1.4206971651242104, 1.4011387853737336, 1.4219866461224027, 1.4090004665095632, 1.4146106184982672, 1.4111218350689585, 1.3920523071863564, 1.4108268066150387, 1.4118149077020041, 1.423176563816306, 1.4104006697491902, 1.4136927694809147, 1.40869607721887, 1.4030484629840385, 1.4039663250853376, 1.403104658533887, 1.4179776499911052], "unit": "ms", "name": "simple-close-DPI1.half.TART", "value": 1.4088482718642166}, {"lowerIsBetter": true, "replicates": [1.4933213344434413, 1.530291649865808, 1.6274063855606988, 1.50418136675665, 1.581940403292256, 1.4956487439027646, 1.5071921194989257, 1.5119849605324827, 1.5107950340082617, 1.5040989104955473, 1.507056952258687, 1.5139452535429119, 1.5161591805057761, 1.5024074330651687, 1.4976085511649526, 1.4942532341654708, 1.5085360665380219, 1.513096657064226, 1.504760901620783, 1.5140211045006176, 1.5065159995131698, 1.508244510786033, 1.5041907959920497, 1.5127363668547735, 1.5138362219304213], "unit": "ms", "name": "simple-close-DPI1.all.TART", "value": 1.5083902886620275}, {"lowerIsBetter": true, "replicates": [17.514999999999418, 19.110000000000582, 18.584999999999127, 17.794999999998254, 17.9800000000032, 18.05999999999767, 18.460000000006403, 18.05999999999767, 17.344999999986612, 18.014999999999418, 17.145000000018626, 17.960000000020955, 18.554999999993015, 17.554999999993015, 18.369999999995343, 17.86500000001979, 17.154999999998836, 17.929999999993015, 17.870000000024447, 17.98499999998603, 18.30999999999767, 17.125, 17.789999999979045, 17.895000000018626, 17.929999999993015], "unit": "ms", "name": "simple-close-DPI1.error.TART", "value": 17.945000000006985}, {"lowerIsBetter": true, "replicates": [1.8814099200310246, 1.9435411949952444, 1.9552388837782002, 1.937313985824585, 2.0192155377906666, 1.9480211893717447, 1.9303827742735544, 1.971074019448232, 1.94361159602801, 1.9401171902815502, 1.9411475896835326, 1.9360787789026896, 1.978304941775435, 1.9634981519084866, 1.999662195814067, 1.9280211667219798, 1.9845537625510117, 1.9343315800031027, 1.960379606485367, 1.9356435775756835, 1.9373011787732441, 1.9241107781728108, 1.9570772051811218, 1.9363539834817252, 1.9266515711943308], "unit": "ms", "name": "icon-open-DPI1.half.TART", "value": 1.9423443923393884}, {"lowerIsBetter": true, "replicates": [2.274777553777779, 2.4115438063939414, 2.395760676375142, 2.3501801523295316, 2.5790580093860624, 2.360626560832382, 2.357535498792475, 2.3764184293923556, 2.348689539866014, 2.390722449179049, 2.354288962754336, 2.3878566733113042, 2.37948485798792, 2.371008682688442, 2.4453145109604453, 2.3495866840535946, 2.369511403075052, 2.37869924470919, 2.3659638232047406, 2.352588871392337, 2.3776141755077815, 2.3335215308449486, 2.3430726484818893, 2.371966904456462, 2.344095498865301], "unit": "ms", "name": "icon-open-DPI1.all.TART", "value": 2.370260042881747}, {"lowerIsBetter": true, "replicates": [27.835000000000946, 30.99499999999898, 29.325000000004366, 30.12000000000262, 28.360000000000582, 28.99000000000524, 31.005000000004657, 28.414999999993597, 30.039999999993597, 28.80999999999767, 30.795000000012806, 28.419999999983702, 30.889999999984866, 29.954999999987194, 33.51999999998952, 30.125, 29.849999999976717, 29.75, 29.45999999999185, 30.635000000009313, 29.485000000015134, 28.455000000016298, 29.60500000003958, 30.365000000048894, 29.789999999979045], "unit": "ms", "name": "icon-open-DPI1.error.TART", "value": 29.81999999997788}, {"lowerIsBetter": true, "replicates": [1.3374555055485216, 1.3865560207022243, 1.4113232013655872, 1.4056240770874955, 1.4069727557461436, 1.4039709887853482, 1.4101524687394864, 1.4114964706141775, 1.4054086513635589, 1.430908724113747, 1.4111358828660918, 1.4109813512825384, 1.407174130765403, 1.41650251935168, 1.4191577420002077, 1.420246786541409, 1.4321887331244387, 1.413444574286298, 1.4221857521269057, 1.4200334548950195, 1.4306669411835846, 1.4223422003381045, 1.414980568536898, 1.4232666463027766, 1.4170925689906608], "unit": "ms", "name": "icon-close-DPI1.half.TART", "value": 1.414212571411598}, {"lowerIsBetter": true, "replicates": [1.4555000877944675, 1.5372543722391128, 1.5381927751004696, 1.533800768852234, 1.5274724664155, 1.5291468060534934, 1.5389655724167823, 1.5342279732227326, 1.5486735840263606, 1.5567035675048828, 1.538615170866251, 1.5510162272543278, 1.5478331405411727, 1.5327447652816772, 1.516915327972836, 1.5585482241232185, 1.5674627032249597, 1.5384735740721225, 1.5462488340881635, 1.5480432495381098, 1.5604901019530961, 1.5574693724794209, 1.561829244788689, 1.5529169099135969, 1.5536414347354721], "unit": "ms", "name": "icon-close-DPI1.all.TART", "value": 1.5470409873146682}, {"lowerIsBetter": true, "replicates": [19.80999999999949, 19.469999999997526, 19.19999999999709, 18.419999999998254, 19.275000000001455, 19.35000000000582, 19.125, 18.519999999989523, 19.279999999998836, 18.985000000000582, 19.089999999996508, 19.635000000009313, 18.85000000000582, 18.160000000003492, 20.035000000003492, 19.25, 19.404999999998836, 19.125, 18.81500000000233, 19.050000000017462, 19.605000000010477, 20.51999999996042, 19.669999999983702, 19.89000000001397, 19.959999999962747], "unit": "ms", "name": "icon-close-DPI1.error.TART", "value": 19.262500000000728}, {"lowerIsBetter": true, "replicates": [1.7954854121574988, 1.8691157121812143, 1.87812114338721, 1.8877270436677775, 1.888753140558962, 1.9000905947607072, 1.8948782701961329, 1.8963072456297327, 1.917774776617686, 1.8924924272005674, 1.8997632519143526, 1.9079216894556263, 1.8979250876629938, 1.8916803676573957, 1.8866248957572445, 1.8853915695284234, 1.8969430591239305, 1.8873241651253623, 1.889571502560475, 1.8848659376944266, 1.8892378748440353, 1.8889608930368893, 1.883862574254313, 1.8816205013182856, 1.88943302045103], "unit": "ms", "name": "icon-open-DPI2.half.TART", "value": 1.8893354476475326}, {"lowerIsBetter": true, "replicates": [2.1987407015541853, 2.2707512617111205, 2.2873238346218008, 2.275664478276683, 2.315032080880233, 2.330266606700313, 2.3092309268457547, 2.3161395160215243, 2.3278484408919877, 2.3055897961769785, 2.3099699256656407, 2.322233725238491, 2.3333524508519217, 2.2944091379115013, 2.2994834929704666, 2.3082469307950566, 2.2872864429929614, 2.282916321163684, 2.2980758257671794, 2.303186787968188, 2.279453513896571, 2.309659508722169, 2.2979886340243474, 2.2743493740537524, 2.308469801076821], "unit": "ms", "name": "icon-open-DPI2.all.TART", "value": 2.3043882920725833}, {"lowerIsBetter": true, "replicates": [30.719999999997526, 32.650000000001455, 29.025000000001455, 29.139999999999418, 29.764999999999418, 29.29999999998836, 29.264999999999418, 31.085000000006403, 28.895000000004075, 28.755000000004657, 26.95000000001164, 28.369999999995343, 29.279999999998836, 30.97500000000582, 28.06500000000233, 28.945000000006985, 28.864999999990687, 29.760000000009313, 30.29000000000815, 30.60000000000582, 28.129999999975553, 29.119999999995343, 27.85999999998603, 27.67499999998836, 30.335000000020955], "unit": "ms", "name": "icon-open-DPI2.error.TART", "value": 29.12999999999738}, {"lowerIsBetter": true, "replicates": [1.2486908282003095, 1.300095893024059, 1.326655153570504, 1.330278880294712, 1.333611299251688, 1.3378752289816391, 1.345367708871531, 1.3420679763306018, 1.3464527310327041, 1.3484084495278292, 1.355218700801625, 1.3457383125327353, 1.3429833304050356, 1.3386700222658556, 1.3112522526220842, 1.3242099120699127, 1.3293166708672184, 1.3303053598294312, 1.3636938207289753, 1.338875412940979, 1.3395139283912127, 1.337221788263869, 1.3371026118596394, 1.327696802972377, 1.3356857834191158], "unit": "ms", "name": "icon-close-DPI2.half.TART", "value": 1.337548508622754}, {"lowerIsBetter": true, "replicates": [1.340338606100816, 1.4025526081008473, 1.4162872170293055, 1.4253067644529565, 1.4254608050335285, 1.4385874467737534, 1.4321927210863898, 1.4375099918421577, 1.4299096761391177, 1.4384654739323783, 1.4341917739194983, 1.4352760146645938, 1.4316320656335841, 1.4184773612854094, 1.4069663410241893, 1.422647781843363, 1.4232974537583285, 1.4273919768111651, 1.44924929297182, 1.4399856588419746, 1.4289710054620666, 1.4281715733266016, 1.4367071571405867, 1.4359355863402872, 1.4210305081473456], "unit": "ms", "name": "icon-close-DPI2.all.TART", "value": 1.4294403408005922}, {"lowerIsBetter": true, "replicates": [17.414999999997235, 17.729999999999563, 17.135000000002037, 18.69999999999709, 18.714999999996508, 18.125, 17.319999999992433, 17.930000000007567, 18.164999999993597, 18.145000000004075, 17.39999999999418, 17.60000000000582, 18.464999999996508, 17.580000000016298, 16.880000000004657, 18.32500000001164, 18.505000000004657, 19.199999999982538, 18.630000000004657, 18.44000000000233, 18.089999999996508, 17.81500000000233, 19.25, 17.945000000006985, 16.630000000004657], "unit": "ms", "name": "icon-close-DPI2.error.TART", "value": 18.107499999998254}, {"lowerIsBetter": true, "replicates": [1.1695100442327635, 1.258982850805573, 1.2907746579911974, 1.3274584570150265, 1.2940683793485834, 1.2850231806437173, 1.2865250455008612, 1.343929928402568, 1.2828770478566487, 1.2895885149637858, 1.2777634138589378, 1.2894263863563538, 1.296143707264675, 1.2903607898288303, 1.2667033567533388, 1.29610056689616, 1.2877453194724189, 1.2470928866376159, 1.2831458489100138, 1.29217858528823, 1.2804322441418965, 1.2811661084493002, 1.2900877171092564, 1.2970886083131425, 1.2748813039653903], "unit": "ms", "name": "iconFade-close-DPI2.half.TART", "value": 1.2885858529143863}, {"lowerIsBetter": true, "replicates": [1.1987344235489048, 1.806751593600872, 1.307074779874823, 1.3210551698099484, 1.308826506807563, 1.2994659113484388, 1.299474491087418, 1.3311472334180559, 1.3008453093427519, 1.3078255131003562, 1.298873822116319, 1.306119089046221, 1.3087013839335924, 1.3017248654498734, 1.292939986785253, 1.3090594986851296, 1.3006436525110425, 1.252809541199797, 1.3013237035474299, 1.3049368898520308, 1.2982581347726576, 1.2976317185929367, 1.3071998987305031, 1.3127129380985842, 1.295849859714508], "unit": "ms", "name": "iconFade-close-DPI2.all.TART", "value": 1.3033308776509522}, {"lowerIsBetter": true, "replicates": [2.5450000000018917, 3.0900000000001455, 2.6699999999982538, 2.470000000001164, 2.9499999999970896, 2.6450000000040745, 2.695000000006985, 2.929999999993015, 2.845000000001164, 2.7850000000034925, 2.6849999999976717, 2.5, 2.9799999999813735, 3.10999999998603, 2.8099999999976717, 2.945000000006985, 2.8699999999953434, 3.1199999999953434, 2.9949999999953434, 2.179999999993015, 2.3850000000093132, 2.220000000030268, 2.7149999999674037, 2.525000000023283, 3.1849999999976717], "unit": "ms", "name": "iconFade-close-DPI2.error.TART", "value": 2.797500000000582}, {"lowerIsBetter": true, "replicates": [1.7631436189015706, 1.9234131634235383, 1.9150162563949336, 1.8864050751826802, 1.9023694249450183, 1.9012174313185646, 1.901160767821015, 1.8944124296063283, 1.9040816865983556, 1.930216372013092, 1.9145567260804723, 1.8976418131687602, 1.9003298165368252, 1.891799967797076, 1.866712624026883, 1.8952056130424875, 1.9052903456766097, 1.8995051696652272, 1.8935499953441932, 1.9134676573706455, 1.898749750168597, 1.8661985628066524, 1.889810724336593, 1.986784932942226, 1.8948719716462932], "unit": "ms", "name": "iconFade-open-DPI2.half.TART", "value": 1.899917493101026}, {"lowerIsBetter": true, "replicates": [1.737197714065438, 1.8385394520646945, 1.8328822522651491, 1.8251418638974428, 1.8390111435116745, 1.8554380971287925, 1.8335625684167456, 1.8379044955171, 1.8325163914462712, 1.8561268515057034, 1.838079873971113, 1.8389385703980454, 1.8348204000728336, 1.8190788635984063, 1.819942869246006, 1.8279048735275865, 1.839138134258, 1.832900403991459, 1.827145867049694, 1.8533535192883204, 1.8351318282405222, 1.8252078723162413, 1.8180198594927788, 1.8742563743745126, 1.8324317322002621], "unit": "ms", "name": "iconFade-open-DPI2.all.TART", "value": 1.8341914842447897}, {"lowerIsBetter": true, "replicates": [2.8849999999983993, 3.7399999999979627, 2.7999999999956344, 3.790000000000873, 3.6499999999941792, 3.834999999991851, 2.9499999999970896, 3.4649999999965075, 2.789999999993597, 4.080000000001746, 3.51500000001397, 3.570000000006985, 3.279999999998836, 2.834999999991851, 2.9149999999790452, 4.059999999997672, 3.6049999999813735, 2.7149999999965075, 4.0200000000186265, 3.6149999999906868, 3.1350000000093132, 3.669999999983702, 2.7199999999720603, 2.4500000000116415, 2.7149999999674037], "unit": "ms", "name": "iconFade-open-DPI2.error.TART", "value": 3.4900000000052387}, {"lowerIsBetter": true, "replicates": [30.964350938796997, 2.159084878585957, 2.1305109782652423, 2.0746238444532668, 2.133776413069831, 2.10118032802235, 2.086500412651471, 2.099035307765007, 2.0828524295772826, 2.068239831498691, 2.103924205086448, 2.0914787224360873, 2.124157513271679, 2.091594277728688, 4.870452945431073, 2.111317953196439, 2.0761872849294116, 2.0822146939379826, 2.0927061438560486, 2.0675541098628725, 2.091211282781192, 2.0624112486839294, 2.0659015497991016, 2.087021570120539, 2.078333556652069], "unit": "ms", "name": "newtab-open-preload-no.half.TART", "value": 2.09134500260864}, {"lowerIsBetter": true, "replicates": [17.50777769833803, 3.168747826320369, 3.1439517358454263, 3.1335727522172125, 3.153626649844937, 3.1903274221184814, 3.171298040284051, 3.1671556539651826, 3.125781725688153, 3.1090475981494032, 3.1177963636007653, 3.187971278473183, 3.1912802899325334, 3.159948590325146, 8.401841798136312, 3.1477964026171987, 3.1240791771785323, 3.0941178669412452, 3.141853746844501, 3.083427159559159, 3.147819814158649, 3.06329912231082, 3.094512885525113, 3.162678747642331, 3.1374283694639438], "unit": "ms", "name": "newtab-open-preload-no.all.TART", "value": 3.1458740692313123}, {"lowerIsBetter": true, "replicates": [55.17000000000189, 30.31000000000131, 28.724999999998545, 30.724999999998545, 29.08499999999185, 29.00999999999476, 27.42500000000291, 30.029999999998836, 30.020000000004075, 28.794999999998254, 29.229999999981374, 28.85000000000582, 28.855000000010477, 29.59000000002561, 31.169999999983702, 28.830000000016298, 29.769999999989523, 27.295000000012806, 28.48499999998603, 29.60000000000582, 28.71500000002561, 27.914999999979045, 30.29500000004191, 29.695000000006985, 28.0], "unit": "ms", "name": "newtab-open-preload-no.error.TART", "value": 29.047499999993306}, {"lowerIsBetter": true, "replicates": [2.264179257785573, 2.09366090297699, 2.1267407807436856, 2.101641134782271, 2.126698916608637, 2.091622708099229, 2.135369300842285, 2.0976684895428743, 2.114124614542181, 2.144514196448856, 2.1189421025189485, 2.1054183027961035, 2.1003494956276634, 2.1300075120396085, 2.270308211737988, 2.114878682656722, 2.1157583843577994, 2.141136414474911, 2.155031535360548, 2.118572055209767, 2.1095934347672896, 2.1195634560151535, 2.11515793800354, 2.1096562710675326, 2.1259099570187656], "unit": "ms", "name": "newtab-open-preload-yes.half.TART", "value": 2.117165219783783}, {"lowerIsBetter": true, "replicates": [2.440518191227546, 2.353694838506204, 2.3823850845622125, 2.358210410232897, 2.37724235904551, 2.3663313068725444, 2.4057878289582595, 2.38133717808768, 2.374145221487384, 2.3853135565731014, 2.3881702255979875, 2.3828372843911714, 2.366698484554469, 2.3914638881413444, 2.464402675628662, 2.40113272869362, 2.3997198916831106, 2.395441529885778, 2.411496866317022, 2.402085468454181, 2.370653355233023, 2.386659329182634, 2.4355572473435174, 2.3831243904951576, 2.391672890877055], "unit": "ms", "name": "newtab-open-preload-yes.all.TART", "value": 2.3859864428778677}, {"lowerIsBetter": true, "replicates": [33.544999999998254, 33.70499999999447, 35.125, 34.849999999998545, 34.78500000000349, 35.830000000001746, 35.27499999999418, 35.16000000000349, 34.38000000000466, 35.729999999995925, 35.72500000000582, 35.235000000015134, 33.73499999998603, 33.81500000000233, 33.54000000000815, 34.845000000001164, 34.73000000001048, 34.43499999999767, 33.345000000001164, 34.93000000002212, 34.10999999998603, 35.61000000004424, 35.86499999999069, 35.26499999995576, 36.1699999999837], "unit": "ms", "name": "newtab-open-preload-yes.error.TART", "value": 34.89000000001033}], "name": "tart", "value": 4.249499974449169}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [2.8350276243093924, 2.056546961325967, 2.0680386740331493, 2.0625966850828727, 2.0514088397790053, 2.0579834254143647, 2.058950276243094, 2.075801104972376, 2.0559392265193366, 2.0657734806629833, 2.053867403314917, 2.364585635359116, 2.0582872928176794, 2.054558011049724, 2.0668232044198893, 2.062458563535911, 2.0578453038674036, 2.0528453038674033, 2.0469060773480665, 2.056298342541437, 2.0650276243093924, 2.057707182320442, 2.065745856353591, 2.059337016574586, 2.054889502762431], "unit": "ms", "name": "tiled.html", "value": 2.0581353591160223}, {"lowerIsBetter": true, "replicates": [2.8149447513812156, 2.794806629834254, 2.8092541436464087, 2.7938397790055247, 2.812127071823204, 2.8053314917127072, 2.8018784530386744, 2.7987016574585635, 2.8085911602209945, 2.8122651933701657, 2.802403314917127, 2.805911602209945, 2.8001104972375686, 3.120193370165746, 2.8102486187845304, 2.801574585635359, 2.7938950276243095, 2.8053038674033153, 2.806077348066298, 2.8119337016574586, 2.811381215469613, 2.80828729281768, 2.8001381215469614, 2.8045856353591163, 2.8159944751381216], "unit": "ms", "name": "tiled-fixed.html", "value": 2.8056215469613264}, {"lowerIsBetter": true, "replicates": [2.436878453038674, 2.43378453038674, 2.4335082872928178, 2.434723756906078, 2.428756906077348, 2.4360220994475137, 2.437486187845304, 2.4373756906077344, 2.428591160220994, 2.429198895027624, 2.4289779005524856, 2.4335082872928178, 2.4300552486187845, 2.432265193370166, 2.4243093922651933, 2.424447513812155, 2.4264364640883977, 2.4639779005524862, 2.4377624309392263, 2.440082872928177, 2.4340055248618784, 2.4341988950276243, 2.429171270718232, 2.4247237569060776, 2.429337016574586], "unit": "ms", "name": "tiled-downscale.html", "value": 2.4311602209944754}, {"lowerIsBetter": true, "replicates": [3.3446132596685088, 3.348618784530387, 3.3393922651933705, 3.3463535911602214, 3.3502762430939224, 3.3362430939226515, 3.3494198895027623, 3.3382596685082873, 3.8556629834254146, 3.354834254143646, 3.345220994475139, 3.3333425414364637, 3.3453038674033158, 3.352403314917127, 3.3382872928176797, 3.3403591160220993, 3.3449447513812154, 3.338729281767956, 3.3450276243093926, 3.3398618784530387, 3.3390883977900554, 3.3600276243093923, 3.352265193370166, 3.3446961325966855, 3.34853591160221], "unit": "ms", "name": "tiled-fixed-downscale.html", "value": 3.344986187845304}, {"lowerIsBetter": true, "replicates": [2.819934210526316, 2.8631578947368417, 2.84125, 2.8318421052631577, 2.8371710526315783, 2.8523026315789473, 2.8450657894736846, 2.789605263157894, 2.778684210526316, 2.812434210526316, 2.8134210526315795, 2.802302631578948, 2.7886184210526315, 2.782763157894737, 2.8136842105263153, 2.7969736842105264, 2.772631578947368, 2.764605263157895, 2.7882894736842103, 2.782631578947368, 2.781710526315789, 2.7921052631578944, 2.7930263157894735, 2.796381578947369, 2.794934210526316], "unit": "ms", "name": "iframe.svg", "value": 2.792565789473684}, {"lowerIsBetter": true, "replicates": [2.716764705882353, 2.7138480392156867, 2.7102450980392154, 2.7178921568627454, 2.7375490196078434, 2.71561274509804, 2.7095833333333332, 2.716421568627451, 2.7186274509803923, 2.710759803921569, 2.7145343137254905, 2.738137254901961, 2.7167401960784314, 2.716470588235294, 2.711053921568628, 2.7181372549019613, 2.7177941176470592, 2.7119607843137254, 2.713382352941177, 2.7247058823529415, 2.7151715686274507, 2.713308823529412, 2.711764705882353, 2.71343137254902, 2.7129411764705886], "unit": "ms", "name": "reader.htm", "value": 2.7148529411764706}], "name": "tscrollx", "value": 2.6702676985605454}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [5.30534942150116, 5.0421555757522585, 5.107627701759339, 5.22144535779953, 5.054040384292603, 5.074680364131927, 5.110949218273163, 5.09967885017395, 5.082091617584228, 5.124427652359008, 5.179819703102112, 5.42486959695816, 5.407895814804804, 5.037297904491425, 5.096433973312378, 5.142379641532898, 5.246367013454437, 5.117707633972168, 5.164344525337219, 5.073182773590088, 5.173502898216247, 5.187288522720337, 5.146066093444825, 5.26310932636261, 5.117861294746399], "unit": "ms", "name": "1-customize-enter.half.TART", "value": 5.121144473552704}, {"lowerIsBetter": true, "replicates": [10.809955898596316, 9.105667725853298, 9.43549558851454, 9.365684313244289, 9.315900749630398, 9.365044249428642, 9.261637279722425, 9.568827238949863, 9.474066420034928, 9.468384916132147, 9.328188800811768, 9.761639080264352, 9.342055511474609, 9.596562499349767, 9.612437464974143, 9.537548574534329, 9.517467287453739, 9.383843262990316, 9.50442000952634, 9.598342949693853, 9.535759557377208, 9.72391697417858, 9.454168243841691, 9.649868835102428, 9.539765498854898], "unit": "ms", "name": "1-customize-enter.all.TART", "value": 9.489243214780634}, {"lowerIsBetter": true, "replicates": [373.08500000000095, 228.33499999999913, 234.00499999999738, 231.5, 228.62000000000262, 230.6949999999997, 225.88499999999476, 230.37000000000262, 226.06500000000233, 225.8199999999997, 229.10000000000582, 241.06500000000233, 229.6600000000035, 231.50999999999476, 232.25999999999476, 228.81500000000233, 228.1350000000093, 231.68499999999767, 227.44500000000698, 231.61999999999534, 228.84500000000116, 227.2899999999936, 225.3350000000064, 233.75, 229.04499999999825], "unit": "ms", "name": "1-customize-enter.error.TART", "value": 229.07250000000204}, {"lowerIsBetter": true, "replicates": [9.232457419236502, 8.905641078948975, 9.187849342823029, 9.156265258789062, 9.111433426539103, 9.092713356018066, 9.369539607654918, 9.286246624859897, 9.120265384515127, 9.097513178984324, 8.97088917096456, 8.99559336900711, 9.499297163703226, 9.157897313435873, 9.394290338863026, 9.112617313861847, 9.192809263865152, 9.295986218885941, 9.134147470647639, 9.102217177549997, 9.11248936255773, 9.239305317401886, 9.096489409605661, 9.130729476610819, 9.369435050270774], "unit": "ms", "name": "2-customize-exit.half.TART", "value": 9.132438473629229}, {"lowerIsBetter": true, "replicates": [9.885049267819053, 9.719423558260944, 10.136396066562549, 9.781561098600688, 9.632043512243973, 9.957067902023727, 10.234855800061613, 9.795809639127631, 9.601152010453053, 9.872878448383227, 9.473506310047247, 10.285919931199816, 10.016069115819159, 9.636548922612118, 9.794304144688141, 9.867045763376597, 9.505230616300533, 9.859682639439901, 10.11550897359848, 9.507505123431866, 9.859604493991748, 9.782510995864868, 9.564140228124765, 9.619259131260407, 9.772898655671339], "unit": "ms", "name": "2-customize-exit.all.TART", "value": 9.788407570276505}, {"lowerIsBetter": true, "replicates": [199.4300000000003, 181.33000000000175, 196.42499999999927, 192.91999999999825, 191.56500000000233, 190.02999999999884, 203.77500000000146, 194.48999999999796, 196.35000000000582, 186.5699999999997, 190.5899999999965, 191.3550000000032, 191.72999999999593, 197.19000000000233, 203.4100000000035, 186.63499999999476, 192.63000000000466, 205.39499999998952, 185.1600000000035, 191.77999999999884, 185.9149999999936, 192.61500000000524, 194.43499999999767, 196.26499999999942, 202.27999999999884], "unit": "ms", "name": "2-customize-exit.error.TART", "value": 192.62250000000495}, {"lowerIsBetter": true, "replicates": [9.12346514788541, 8.053315309377817, 8.277128366323618, 8.595560749371847, 7.862880670107328, 7.968244552612305, 7.999643839322603, 8.17530943797185, 8.041381762577938, 8.030127598689152, 8.058927646050087, 8.51901662349701, 8.169519754556509, 8.2444884960468, 8.13729322873629, 8.015565138596754, 8.203754938565767, 8.019700490511381, 8.015181101285494, 8.31538068331205, 8.045192315028263, 7.973443214709942, 7.930139761704665, 8.022920205042912, 8.009893747476431], "unit": "ms", "name": "3-customize-enter-css.half.TART", "value": 8.0432870388031}, {"lowerIsBetter": true, "replicates": [12.512216351249002, 11.937370072240414, 11.84339023673016, 12.462156707590276, 11.356059590975443, 11.54893990357717, 11.705934731856637, 11.94112669903299, 12.091120636981467, 12.127733976944633, 11.989443903384002, 11.982565195664115, 11.796324937239937, 12.098366426384967, 12.047828757244607, 11.638667782147726, 11.51042777299881, 11.56141972541809, 11.479947666327158, 11.691376188526982, 11.86674742076708, 11.713731558426566, 11.817829090615977, 11.535515944163004, 11.470171729723612], "unit": "ms", "name": "3-customize-enter-css.all.TART", "value": 11.807077013927957}, {"lowerIsBetter": true, "replicates": [75.09999999999854, 74.42499999999927, 72.33500000000276, 74.05500000000029, 72.41500000000087, 77.08499999999913, 69.25, 74.48500000000058, 77.9600000000064, 78.77500000000146, 75.65000000000146, 76.19499999999971, 71.09500000000116, 78.23500000000058, 76.95500000000175, 75.625, 76.1649999999936, 77.29499999999825, 75.31999999999243, 68.68499999999767, 72.83000000000175, 69.36000000000058, 71.91500000000815, 76.73500000000058, 75.17999999999302], "unit": "ms", "name": "3-customize-enter-css.error.TART", "value": 75.24999999999272}], "name": "cart", "value": 23.118081501391526}]}
00:34:26 INFO - TinderboxPrint: TalosResult: {"graphserver": {"tscrollx": {"url": "http://graphs.mozilla.org/graph.html#tests=[[287,201,31]]", "result": "2.67"}, "tsvgr_opacity": {"url": "http://graphs.mozilla.org/graph.html#tests=[[225,201,31]]", "result": "333.42"}, "tart": {"url": "http://graphs.mozilla.org/graph.html#tests=[[293,201,31]]", "result": "4.25"}, "cart": {"url": "http://graphs.mozilla.org/graph.html#tests=[[309,201,31]]", "result": "23.12"}, "tsvgx": {"url": "http://graphs.mozilla.org/graph.html#tests=[[281,201,31]]", "result": "126.21"}}}
00:34:26 INFO - Return code: 0
00:34:26 INFO - Validating PERFHERDER_DATA against C:\slave\test-pgo\build\tests\talos\treeherder-schemas\performance-artifact.json
00:34:26 ERROR - # TBPL SUCCESS #
00:34:26 INFO - Running post-action listener: _resource_record_post_action
00:34:26 INFO - Running post-run listener: _resource_record_post_run
00:34:27 INFO - Total resource usage - Wall time: 968s; CPU: 8.0%; Read bytes: 294885888; Write bytes: 587429376; Read time: 7734200; Write time: 11069730
00:34:27 INFO - install - Wall time: 6s; CPU: 6.0%; Read bytes: 46014464; Write bytes: 80694272; Read time: 834290; Write time: 469320
00:34:28 INFO - run-tests - Wall time: 963s; CPU: 8.0%; Read bytes: 243048960; Write bytes: 488550912; Read time: 6623890; Write time: 10319100
00:34:28 INFO - Running post-run listener: _upload_blobber_files
00:34:28 INFO - Blob upload gear active.
00:34:28 INFO - Preparing to upload files from C:\slave\test-pgo\build\blobber_upload_dir.
00:34:28 INFO - Files from C:\slave\test-pgo\build\blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com
00:34:28 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\python', 'C:\\slave\\test-pgo\\build\\venv\\Scripts\\blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', 'C:\\slave\\test-pgo\\oauth.txt', '-b', 'B2G-Inbound', '-d', 'C:\\slave\\test-pgo\\build\\blobber_upload_dir', '--output-manifest', 'C:\\slave\\test-pgo\\build\\uploaded_files.json']
00:34:28 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\python C:\slave\test-pgo\build\venv\Scripts\blobberc.py -u https://blobupload.elasticbeanstalk.com -a C:\slave\test-pgo\oauth.txt -b B2G-Inbound -d C:\slave\test-pgo\build\blobber_upload_dir --output-manifest C:\slave\test-pgo\build\uploaded_files.json
00:34:28 INFO - (blobuploader) - INFO - Open directory for files ...
00:34:28 INFO - (blobuploader) - INFO - Uploading C:\slave\test-pgo\build\blobber_upload_dir\svgr_errorsummary.log ...
00:34:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
00:34:28 INFO - (blobuploader) - INFO - Uploading, attempt #1.
00:34:29 INFO - (blobuploader) - INFO - TinderboxPrint: svgr_errorsummary.log: uploaded
00:34:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
00:34:29 INFO - (blobuploader) - INFO - Done attempting.
00:34:29 INFO - (blobuploader) - INFO - Uploading C:\slave\test-pgo\build\blobber_upload_dir\svgr_raw.log ...
00:34:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
00:34:29 INFO - (blobuploader) - INFO - Uploading, attempt #1.
00:34:30 INFO - (blobuploader) - INFO - TinderboxPrint: svgr_raw.log: uploaded
00:34:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
00:34:30 INFO - (blobuploader) - INFO - Done attempting.
00:34:30 INFO - (blobuploader) - INFO - Iteration through files over.
00:34:30 INFO - Return code: 0
00:34:30 INFO - rmtree: C:\slave\test-pgo\build\uploaded_files.json
00:34:30 INFO - Using _rmtree_windows ...
00:34:30 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test-pgo\\build\\uploaded_files.json',), kwargs: {}, attempt #1
00:34:30 INFO - Setting buildbot property blobber_files to {"svgr_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/209f3dea33cb64e3b973a17a0e75d666b56c758a18bd763964b54c5f2a0289e766063717875f19e53c909366fbeb7d4ff26c2b6007e8e0b1dfeda2c0054aa40a", "svgr_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/1e97cb327a8f7cdaf46cf6287050b18d521e3808637609cdcc14ebc52cdcfad7c9d37036e6e42d271456aef0011b9b93c4aee369c9cf06bd4ce0ff6d27977452"}
00:34:30 INFO - Writing buildbot properties ['blobber_files'] to C:\slave\test-pgo\properties\blobber_files
00:34:30 INFO - Writing to file C:\slave\test-pgo\properties\blobber_files
00:34:30 INFO - Contents:
00:34:30 INFO - blobber_files:{"svgr_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/209f3dea33cb64e3b973a17a0e75d666b56c758a18bd763964b54c5f2a0289e766063717875f19e53c909366fbeb7d4ff26c2b6007e8e0b1dfeda2c0054aa40a", "svgr_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/1e97cb327a8f7cdaf46cf6287050b18d521e3808637609cdcc14ebc52cdcfad7c9d37036e6e42d271456aef0011b9b93c4aee369c9cf06bd4ce0ff6d27977452"}
00:34:30 INFO - Copying logs to upload dir...
00:34:30 INFO - mkdir: C:\slave\test-pgo\build\upload\logs
program finished with exit code 0
elapsedTime=1232.608000
========= master_lag: 0.07 =========
========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2015-12-22 00:34:30.995586) =========
========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 00:34:31.001321) =========
'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.T-W864-IX-087\AppData\Roaming
COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files
COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files
COMMONPROGRAMW6432=C:\Program Files\Common Files
COMPUTERNAME=T-W864-IX-087
COMSPEC=C:\windows\system32\cmd.exe
DCLOCATION=SCL3
DNSSUFFIX=wintest.releng.scl3.mozilla.com
FP_NO_HOST_CHECK=NO
HOMEDRIVE=C:
HOMEPATH=\Users\cltbld.T-W864-IX-087
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-087\AppData\Local
LOGONSERVER=\\T-W864-IX-087
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:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;C:\mozilla-build\hg
PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
PROCESSOR_ARCHITECTURE=x86
PROCESSOR_ARCHITEW6432=AMD64
PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel
PROCESSOR_LEVEL=6
PROCESSOR_REVISION=1e05
PROGRAMDATA=C:\ProgramData
PROGRAMFILES=C:\Program Files (x86)
PROGRAMFILES(X86)=C:\Program Files (x86)
PROGRAMW6432=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~1.T-W\AppData\Local\Temp
TEST1=testie
TMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp
USERDOMAIN=T-W864-IX-087
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-087
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-087
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
blobber_files:{"svgr_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/209f3dea33cb64e3b973a17a0e75d666b56c758a18bd763964b54c5f2a0289e766063717875f19e53c909366fbeb7d4ff26c2b6007e8e0b1dfeda2c0054aa40a", "svgr_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/1e97cb327a8f7cdaf46cf6287050b18d521e3808637609cdcc14ebc52cdcfad7c9d37036e6e42d271456aef0011b9b93c4aee369c9cf06bd4ce0ff6d27977452"}
build_url:https://queue.taskcluster.net/v1/task/xFsdWicSSM6vBbqUTU2P-g/artifacts/public/build/firefox-46.0a1.en-US.win64.zip
program finished with exit code 0
elapsedTime=0.101000
build_url: 'https://queue.taskcluster.net/v1/task/xFsdWicSSM6vBbqUTU2P-g/artifacts/public/build/firefox-46.0a1.en-US.win64.zip'
blobber_files: '{"svgr_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/209f3dea33cb64e3b973a17a0e75d666b56c758a18bd763964b54c5f2a0289e766063717875f19e53c909366fbeb7d4ff26c2b6007e8e0b1dfeda2c0054aa40a", "svgr_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/1e97cb327a8f7cdaf46cf6287050b18d521e3808637609cdcc14ebc52cdcfad7c9d37036e6e42d271456aef0011b9b93c4aee369c9cf06bd4ce0ff6d27977452"}'
========= master_lag: 0.25 =========
========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 00:34:31.354651) =========
========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 00:34:31.355019) =========
'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.T-W864-IX-087\AppData\Roaming
COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files
COMMONPROGRAMFILES(X86)=C:\Program Files (x86)\Common Files
COMMONPROGRAMW6432=C:\Program Files\Common Files
COMPUTERNAME=T-W864-IX-087
COMSPEC=C:\windows\system32\cmd.exe
DCLOCATION=SCL3
DNSSUFFIX=wintest.releng.scl3.mozilla.com
FP_NO_HOST_CHECK=NO
HOMEDRIVE=C:
HOMEPATH=\Users\cltbld.T-W864-IX-087
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-087\AppData\Local
LOGONSERVER=\\T-W864-IX-087
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:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;C:\mozilla-build\hg
PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC
PROCESSOR_ARCHITECTURE=x86
PROCESSOR_ARCHITEW6432=AMD64
PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel
PROCESSOR_LEVEL=6
PROCESSOR_REVISION=1e05
PROGRAMDATA=C:\ProgramData
PROGRAMFILES=C:\Program Files (x86)
PROGRAMFILES(X86)=C:\Program Files (x86)
PROGRAMW6432=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~1.T-W\AppData\Local\Temp
TEST1=testie
TMP=C:\Users\CLTBLD~1.T-W\AppData\Local\Temp
USERDOMAIN=T-W864-IX-087
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-087
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-087
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
program finished with exit code 0
elapsedTime=0.101000
========= master_lag: 0.02 =========
========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 00:34:31.474304) =========
========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2015-12-22 00:34:31.474799) =========
========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2015-12-22 00:34:31.865765) =========
========= Total master_lag: 0.87 =========