builder: b2g-inbound_win8_64_test-dromaeojs-pgo
slave: t-w864-ix-123
starttime: 1445854374.18
results: success (0)
buildid: 20151026023015
builduid: 123146fa571745e2ac9482c1b1447113
revision: 8631cff3e8183a5cc08e7c5b3478c8c21b7d4a55
========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-26 03:12:54.183120) =========
master: http://buildbot-master112.bb.releng.scl3.mozilla.com:8201/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-26 03:12:54.185600) =========
========= Started set props: basedir (results: 0, elapsed: 22 secs) (at 2015-10-26 03:12:54.185940) =========
'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-123\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-123
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-123
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-123\AppData\Local
LOGONSERVER=\\T-W864-IX-123
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-123
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-123
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-123
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
C:\slave\test-pgo
program finished with exit code 0
elapsedTime=0.603000
basedir: 'C:\\slave\\test-pgo'
========= Finished set props: basedir (results: 0, elapsed: 22 secs) (at 2015-10-26 03:13:16.997297) =========
========= Started downloading to buildprops.json (results: 0, elapsed: 42 secs) (at 2015-10-26 03:13:16.997641) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 42 secs) (at 2015-10-26 03:13:59.223816) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-26 03:13:59.224250) =========
'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-123\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-123
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-123
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-123\AppData\Local
LOGONSERVER=\\T-W864-IX-123
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-123
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-123
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-123
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
program finished with exit code 0
elapsedTime=0.201000
========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-26 03:14:00.022443) =========
========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-26 03:14:00.022773) =========
script_repo_url: https://hg.mozilla.org/build/mozharness
========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-26 03:14:00.023523) =========
========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-10-26 03:14:00.023828) =========
'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-123\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-123
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-123
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-123\AppData\Local
LOGONSERVER=\\T-W864-IX-123
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-123
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-123
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-123
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
--03:14:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py
=> `archiver_client.py'
Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102
Connecting to hg.mozilla.org|63.245.215.25|:443... connected.
HTTP request sent, awaiting response... 200 Script output follows
Length: 12,141 (12K) [text/x-python]
0K .......... . 100% 2.27 GB/s
03:14:01 (2.27 GB/s) - `archiver_client.py' saved [12141/12141]
program finished with exit code 0
elapsedTime=0.540000
========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-10-26 03:14:01.838217) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2015-10-26 03:14:01.838529) =========
'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-123\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-123
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-123
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-123\AppData\Local
LOGONSERVER=\\T-W864-IX-123
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-123
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-123
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-123
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
program finished with exit code 0
elapsedTime=2.307000
========= Finished 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2015-10-26 03:14:05.659255) =========
========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-10-26 03:14:05.659583) =========
'bash' '-c' u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 8631cff3e8183a5cc08e7c5b3478c8c21b7d4a55 --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 8631cff3e8183a5cc08e7c5b3478c8c21b7d4a55 --destination scripts --debug']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld.T-W864-IX-123\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-123
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-123
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-123\AppData\Local
LOGONSERVER=\\T-W864-IX-123
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-123
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-123
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-123
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
2015-10-26 03:14:06,400 truncating revision to first 12 chars
2015-10-26 03:14:06,401 Setting DEBUG logging.
2015-10-26 03:14:06,401 attempt 1/10
2015-10-26 03:14:06,401 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/8631cff3e818?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2015-10-26 03:14:06,927 unpacking tar archive at: b2g-inbound-8631cff3e818/testing/mozharness/
program finished with exit code 0
elapsedTime=1.185000
========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-10-26 03:14:08.189469) =========
========= Started downloading to oauth.txt (results: 0, elapsed: 26 secs) (at 2015-10-26 03:14:08.189786) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 26 secs) (at 2015-10-26 03:14:34.823225) =========
========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-26 03:14:34.823488) =========
TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production
========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-26 03:14:34.824285) =========
========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 10 secs) (at 2015-10-26 03:14:34.824584) =========
'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'dromaeojs' '--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', 'dromaeojs', '--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-123\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-123
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-123
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-123\AppData\Local
LOGONSERVER=\\T-W864-IX-123
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-123
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-123
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-123
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
03:14:35 INFO - MultiFileLogger online at 20151026 03:14:35 in C:\slave\test-pgo
03:14:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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
03:14:35 INFO - Dumping config to C:\slave\test-pgo\logs\localconfig.json.
03:14:35 INFO - {'append_to_log': False,
03:14:35 INFO - 'base_work_dir': 'C:\\slave\\test-pgo',
03:14:35 INFO - 'blob_upload_branch': 'B2G-Inbound',
03:14:35 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test-pgo\\oauth.txt',
03:14:35 INFO - 'branch': 'B2G-Inbound',
03:14:35 INFO - 'buildbot_json_path': 'buildprops.json',
03:14:35 INFO - 'config_files': ('talos/windows_config.py',),
03:14:35 INFO - 'default_actions': ('clobber',
03:14:35 INFO - 'read-buildbot-config',
03:14:35 INFO - 'download-and-extract',
03:14:35 INFO - 'populate-webroot',
03:14:35 INFO - 'create-virtualenv',
03:14:35 INFO - 'install',
03:14:35 INFO - 'run-tests'),
03:14:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',),
03:14:35 INFO - 'download_minidump_stackwalk': True,
03:14:35 INFO - 'download_symbols': 'ondemand',
03:14:35 INFO - 'exes': {'easy_install': ('C:\\slave\\test-pgo\\build/venv/scripts/python',
03:14:35 INFO - 'C:\\slave\\test-pgo\\build/venv/scripts/easy_install-2.7-script.py'),
03:14:35 INFO - 'hg': 'c:/mozilla-build/hg/hg',
03:14:35 INFO - 'mozinstall': ('C:\\slave\\test-pgo\\build/venv/scripts/python',
03:14:35 INFO - 'C:\\slave\\test-pgo\\build/venv/scripts/mozinstall-script.py'),
03:14:35 INFO - 'python': 'c:/mozilla-build/python27/python.exe',
03:14:35 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe',
03:14:35 INFO - 'C:/mozilla-build/tooltool.py'),
03:14:35 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe',
03:14:35 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')},
03:14:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub',
03:14:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'),
03:14:35 INFO - 'installer_path': 'installer.exe',
03:14:35 INFO - 'log_level': 'info',
03:14:35 INFO - 'log_name': 'talos',
03:14:35 INFO - 'log_to_console': True,
03:14:35 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe',
03:14:35 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe',
03:14:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest',
03:14:35 INFO - 'opt_config_files': (),
03:14:35 INFO - 'pip_index': False,
03:14:35 INFO - 'sps_profile': False,
03:14:35 INFO - 'sps_profile_interval': 0,
03:14:35 INFO - 'suite': 'dromaeojs',
03:14:35 INFO - 'system_bits': '64',
03:14:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'),
03:14:35 INFO - 'title': 'T-W864-IX-123',
03:14:35 INFO - 'use_talos_json': True,
03:14:35 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'),
03:14:35 INFO - 'virtualenv_path': 'C:\\slave\\test-pgo\\build/venv',
03:14:35 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll',
03:14:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
03:14:35 INFO - 'work_dir': 'build'}
03:14:35 INFO - #####
03:14:35 INFO - ##### Running clobber step.
03:14:35 INFO - #####
03:14:35 INFO - Running pre-action listener: _resource_record_pre_action
03:14:35 INFO - Running main action method: clobber
03:14:35 INFO - rmtree: C:\slave\test-pgo\build
03:14:35 INFO - Using _rmtree_windows ...
03:14:35 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test-pgo\\build',), kwargs: {}, attempt #1
03:15:31 INFO - Running post-action listener: _resource_record_post_action
03:15:31 INFO - #####
03:15:31 INFO - ##### Running read-buildbot-config step.
03:15:31 INFO - #####
03:15:31 INFO - Running pre-action listener: _resource_record_pre_action
03:15:31 INFO - Running main action method: read_buildbot_config
03:15:31 INFO - Using buildbot properties:
03:15:31 INFO - {
03:15:31 INFO - "properties": {
03:15:31 INFO - "buildnumber": 304,
03:15:31 INFO - "product": "firefox",
03:15:31 INFO - "script_repo_revision": "production",
03:15:31 INFO - "builddir": "b2g-inbound_win8_64_test-dromaeojs",
03:15:31 INFO - "repository": "",
03:15:31 INFO - "buildername": "Windows 8 64-bit b2g-inbound pgo talos dromaeojs",
03:15:31 INFO - "buildid": "20151026023015",
03:15:31 INFO - "slavename": "t-w864-ix-123",
03:15:31 INFO - "pgo_build": "True",
03:15:31 INFO - "basedir": "C:\\slave\\test-pgo",
03:15:31 INFO - "project": "",
03:15:31 INFO - "platform": "win8_64",
03:15:31 INFO - "master": "http://buildbot-master112.bb.releng.scl3.mozilla.com:8201/",
03:15:31 INFO - "slavebuilddir": "test",
03:15:31 INFO - "scheduler": "tests-b2g-inbound-win64-pgo-talos",
03:15:31 INFO - "branch": "b2g-inbound",
03:15:31 INFO - "repo_path": "integration/b2g-inbound",
03:15:31 INFO - "stage_platform": "win64-pgo",
03:15:31 INFO - "builduid": "123146fa571745e2ac9482c1b1447113",
03:15:31 INFO - "revision": "8631cff3e8183a5cc08e7c5b3478c8c21b7d4a55"
03:15:31 INFO - },
03:15:31 INFO - "sourcestamp": {
03:15:31 INFO - "repository": "",
03:15:31 INFO - "hasPatch": false,
03:15:31 INFO - "project": "",
03:15:31 INFO - "branch": "b2g-inbound-win64-pgo-talos",
03:15:31 INFO - "changes": [
03:15:31 INFO - {
03:15:31 INFO - "category": null,
03:15:31 INFO - "files": [
03:15:31 INFO - {
03:15:31 INFO - "url": null,
03:15:31 INFO - "name": "https://queue.taskcluster.net/v1/task/a5JHnii2T5--agh9aAnbWg/artifacts/public/build/firefox-44.0a1.en-US.win64.zip"
03:15:31 INFO - }
03:15:31 INFO - ],
03:15:31 INFO - "repository": "",
03:15:31 INFO - "rev": "8631cff3e8183a5cc08e7c5b3478c8c21b7d4a55",
03:15:31 INFO - "who": "sendchange",
03:15:31 INFO - "when": 1445854295,
03:15:31 INFO - "number": 6572617,
03:15:31 INFO - "comments": "",
03:15:31 INFO - "project": "",
03:15:31 INFO - "at": "Mon 26 Oct 2015 03:11:35",
03:15:31 INFO - "branch": "b2g-inbound-win64-pgo-talos",
03:15:31 INFO - "revlink": "",
03:15:31 INFO - "properties": [
03:15:31 INFO - [
03:15:31 INFO - "buildid",
03:15:31 INFO - "20151026023015",
03:15:31 INFO - "Change"
03:15:31 INFO - ],
03:15:31 INFO - [
03:15:31 INFO - "builduid",
03:15:31 INFO - "123146fa571745e2ac9482c1b1447113",
03:15:31 INFO - "Change"
03:15:31 INFO - ],
03:15:31 INFO - [
03:15:31 INFO - "pgo_build",
03:15:31 INFO - "True",
03:15:31 INFO - "Change"
03:15:31 INFO - ]
03:15:31 INFO - ],
03:15:31 INFO - "revision": "8631cff3e8183a5cc08e7c5b3478c8c21b7d4a55"
03:15:31 INFO - }
03:15:31 INFO - ],
03:15:31 INFO - "revision": "8631cff3e8183a5cc08e7c5b3478c8c21b7d4a55"
03:15:31 INFO - }
03:15:31 INFO - }
03:15:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/a5JHnii2T5--agh9aAnbWg/artifacts/public/build/firefox-44.0a1.en-US.win64.zip.
03:15:31 INFO - Running post-action listener: _resource_record_post_action
03:15:31 INFO - #####
03:15:31 INFO - ##### Running download-and-extract step.
03:15:31 INFO - #####
03:15:31 INFO - Running pre-action listener: _resource_record_pre_action
03:15:31 INFO - Running main action method: download_and_extract
03:15:31 INFO - mkdir: C:\slave\test-pgo\build\tests
03:15: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')]}
03:15:31 INFO - https://queue.taskcluster.net/v1/task/a5JHnii2T5--agh9aAnbWg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net
03:15:31 INFO - trying https://queue.taskcluster.net/v1/task/a5JHnii2T5--agh9aAnbWg/artifacts/public/build/test_packages.json
03:15:31 INFO - Downloading https://queue.taskcluster.net/v1/task/a5JHnii2T5--agh9aAnbWg/artifacts/public/build/test_packages.json to C:\slave\test-pgo\build\test_packages.json
03:15:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a5JHnii2T5--agh9aAnbWg/artifacts/public/build/test_packages.json', 'file_name': 'C:\\slave\\test-pgo\\build\\test_packages.json'}, attempt #1
03:15:32 INFO - Downloaded 1221 bytes.
03:15:32 INFO - Reading from file C:\slave\test-pgo\build\test_packages.json
03:15:32 INFO - Using the following test package requirements:
03:15:32 INFO - {u'common': [u'firefox-44.0a1.en-US.win64.common.tests.zip'],
03:15:32 INFO - u'cppunittest': [u'firefox-44.0a1.en-US.win64.common.tests.zip',
03:15:32 INFO - u'firefox-44.0a1.en-US.win64.cppunittest.tests.zip'],
03:15:32 INFO - u'jittest': [u'firefox-44.0a1.en-US.win64.common.tests.zip',
03:15:32 INFO - u'jsshell-win64.zip'],
03:15:32 INFO - u'mochitest': [u'firefox-44.0a1.en-US.win64.common.tests.zip',
03:15:32 INFO - u'firefox-44.0a1.en-US.win64.mochitest.tests.zip'],
03:15:32 INFO - u'mozbase': [u'firefox-44.0a1.en-US.win64.common.tests.zip'],
03:15:32 INFO - u'reftest': [u'firefox-44.0a1.en-US.win64.common.tests.zip',
03:15:32 INFO - u'firefox-44.0a1.en-US.win64.reftest.tests.zip'],
03:15:32 INFO - u'talos': [u'firefox-44.0a1.en-US.win64.common.tests.zip',
03:15:32 INFO - u'firefox-44.0a1.en-US.win64.talos.tests.zip'],
03:15:32 INFO - u'web-platform': [u'firefox-44.0a1.en-US.win64.common.tests.zip',
03:15:32 INFO - u'firefox-44.0a1.en-US.win64.web-platform.tests.zip'],
03:15:32 INFO - u'webapprt': [u'firefox-44.0a1.en-US.win64.common.tests.zip'],
03:15:32 INFO - u'xpcshell': [u'firefox-44.0a1.en-US.win64.common.tests.zip',
03:15:32 INFO - u'firefox-44.0a1.en-US.win64.xpcshell.tests.zip']}
03:15:32 INFO - Downloading packages: [u'firefox-44.0a1.en-US.win64.common.tests.zip'] for test suite category: common
03:15:32 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')]}
03:15:32 INFO - https://queue.taskcluster.net/v1/task/a5JHnii2T5--agh9aAnbWg/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip matches https://queue.taskcluster.net
03:15:32 INFO - trying https://queue.taskcluster.net/v1/task/a5JHnii2T5--agh9aAnbWg/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip
03:15:32 INFO - Downloading https://queue.taskcluster.net/v1/task/a5JHnii2T5--agh9aAnbWg/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip to C:\slave\test-pgo\build\firefox-44.0a1.en-US.win64.common.tests.zip
03:15:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a5JHnii2T5--agh9aAnbWg/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip', 'file_name': u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win64.common.tests.zip'}, attempt #1
ProcessManager NOT managing child processes
03:15:33 INFO - Downloaded 18100928 bytes.
03:15:33 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win64.common.tests.zip'] in C:\slave\test-pgo\build\tests
03:15:33 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-44.0a1.en-US.win64.common.tests.zip
03:15:33 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win64.common.tests.zip'] with output_timeout 1760
ProcessManager UNABLE to use job objects to manage child processes
03:16:02 INFO - Return code: 0
03:16:02 INFO - Downloading packages: [u'firefox-44.0a1.en-US.win64.common.tests.zip', u'firefox-44.0a1.en-US.win64.talos.tests.zip'] for test suite category: talos
03:16:02 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')]}
03:16:02 INFO - https://queue.taskcluster.net/v1/task/a5JHnii2T5--agh9aAnbWg/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip matches https://queue.taskcluster.net
03:16:02 INFO - trying https://queue.taskcluster.net/v1/task/a5JHnii2T5--agh9aAnbWg/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip
03:16:02 INFO - Downloading https://queue.taskcluster.net/v1/task/a5JHnii2T5--agh9aAnbWg/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip to C:\slave\test-pgo\build\firefox-44.0a1.en-US.win64.common.tests.zip
03:16:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a5JHnii2T5--agh9aAnbWg/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip', 'file_name': u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win64.common.tests.zip'}, attempt #1
ProcessManager NOT managing child processes
03:16:03 INFO - Downloaded 18100928 bytes.
03:16:03 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win64.common.tests.zip'] in C:\slave\test-pgo\build\tests
03:16:03 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-44.0a1.en-US.win64.common.tests.zip
03:16:03 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win64.common.tests.zip'] with output_timeout 1760
ProcessManager UNABLE to use job objects to manage child processes
03:16:24 INFO - Return code: 0
03:16: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')]}
03:16:24 INFO - https://queue.taskcluster.net/v1/task/a5JHnii2T5--agh9aAnbWg/artifacts/public/build/firefox-44.0a1.en-US.win64.talos.tests.zip matches https://queue.taskcluster.net
03:16:24 INFO - trying https://queue.taskcluster.net/v1/task/a5JHnii2T5--agh9aAnbWg/artifacts/public/build/firefox-44.0a1.en-US.win64.talos.tests.zip
03:16:24 INFO - Downloading https://queue.taskcluster.net/v1/task/a5JHnii2T5--agh9aAnbWg/artifacts/public/build/firefox-44.0a1.en-US.win64.talos.tests.zip to C:\slave\test-pgo\build\firefox-44.0a1.en-US.win64.talos.tests.zip
03:16:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a5JHnii2T5--agh9aAnbWg/artifacts/public/build/firefox-44.0a1.en-US.win64.talos.tests.zip', 'file_name': u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win64.talos.tests.zip'}, attempt #1
ProcessManager NOT managing child processes
03:16:27 INFO - Downloaded 11131307 bytes.
03:16:27 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win64.talos.tests.zip'] in C:\slave\test-pgo\build\tests
03:16:27 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-44.0a1.en-US.win64.talos.tests.zip
03:16:27 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win64.talos.tests.zip'] with output_timeout 1760
ProcessManager UNABLE to use job objects to manage child processes
03:16:28 INFO - Return code: 0
03:16:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]}
03:16:28 INFO - https://queue.taskcluster.net/v1/task/a5JHnii2T5--agh9aAnbWg/artifacts/public/build/firefox-44.0a1.en-US.win64.zip matches https://queue.taskcluster.net
03:16:28 INFO - trying https://queue.taskcluster.net/v1/task/a5JHnii2T5--agh9aAnbWg/artifacts/public/build/firefox-44.0a1.en-US.win64.zip
03:16:28 INFO - Downloading https://queue.taskcluster.net/v1/task/a5JHnii2T5--agh9aAnbWg/artifacts/public/build/firefox-44.0a1.en-US.win64.zip to C:\slave\test-pgo\build\firefox-44.0a1.en-US.win64.zip
03:16:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a5JHnii2T5--agh9aAnbWg/artifacts/public/build/firefox-44.0a1.en-US.win64.zip', 'file_name': 'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win64.zip'}, attempt #1
03:16:30 INFO - Downloaded 55517105 bytes.
03:16:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a5JHnii2T5--agh9aAnbWg/artifacts/public/build/firefox-44.0a1.en-US.win64.zip
03:16:30 INFO - mkdir: C:\slave\test-pgo\properties
03:16:30 INFO - Writing buildbot properties ['build_url'] to C:\slave\test-pgo\properties\build_url
03:16:30 INFO - Writing to file C:\slave\test-pgo\properties\build_url
03:16:30 INFO - Contents:
03:16:30 INFO - build_url:https://queue.taskcluster.net/v1/task/a5JHnii2T5--agh9aAnbWg/artifacts/public/build/firefox-44.0a1.en-US.win64.zip
03:16:30 INFO - Running post-action listener: _resource_record_post_action
03:16:30 INFO - Running post-action listener: set_extra_try_arguments
03:16:30 INFO - #####
03:16:30 INFO - ##### Running populate-webroot step.
03:16:30 INFO - #####
03:16:30 INFO - Running pre-action listener: _resource_record_pre_action
03:16:30 INFO - Running main action method: populate_webroot
03:16:30 INFO - Guessing talos json url...
03: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')]}
03:16:30 INFO - https://queue.taskcluster.net/v1/task/a5JHnii2T5--agh9aAnbWg/artifacts/public/build/firefox-44.0a1.en-US.win64.txt matches https://queue.taskcluster.net
03:16:30 INFO - trying https://queue.taskcluster.net/v1/task/a5JHnii2T5--agh9aAnbWg/artifacts/public/build/firefox-44.0a1.en-US.win64.txt
03:16:30 INFO - Downloading https://queue.taskcluster.net/v1/task/a5JHnii2T5--agh9aAnbWg/artifacts/public/build/firefox-44.0a1.en-US.win64.txt to C:\slave\test-pgo\build\firefox-44.0a1.en-US.win64.txt
03:16:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a5JHnii2T5--agh9aAnbWg/artifacts/public/build/firefox-44.0a1.en-US.win64.txt', 'file_name': 'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win64.txt'}, attempt #1
03:16:30 INFO - Downloaded 107 bytes.
03:16:30 INFO - Reading from file C:\slave\test-pgo\build\firefox-44.0a1.en-US.win64.txt
03:16:30 INFO - Contents:
03:16:30 INFO - 20151026023015
03:16:30 INFO - https://hg.mozilla.org/integration/b2g-inbound/rev/8631cff3e8183a5cc08e7c5b3478c8c21b7d4a55
03: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')]}
03:16:30 INFO - trying https://hg.mozilla.org/integration/b2g-inbound/raw-file/8631cff3e8/testing/talos/talos.json
03:16:30 INFO - Downloading https://hg.mozilla.org/integration/b2g-inbound/raw-file/8631cff3e8/testing/talos/talos.json to C:\slave\test-pgo\build\talos.json
03:16:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/b2g-inbound/raw-file/8631cff3e8/testing/talos/talos.json', 'file_name': 'C:\\slave\\test-pgo\\build\\talos.json'}, attempt #1
03:16:31 INFO - Downloaded 4264 bytes.
03:16:31 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']},
03:16:31 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']},
03:16:31 INFO - u'remote-trobocheck2': {u'talos_options': [u'--fennecIDs',
03:16:31 INFO - u'../fennec_ids.txt'],
03:16:31 INFO - u'tests': [u'tcheck2']},
03:16:31 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome',
03:16:31 INFO - u'--tppagecycles',
03:16:31 INFO - u'7'],
03:16:31 INFO - u'tests': [u'tsvgm']}},
03:16:31 INFO - u'suites': {u'chromez': {u'tests': [u'tresize', u'tcanvasmark']},
03:16:31 INFO - u'chromez-e10s': {u'talos_options': [u'--e10s'],
03:16:31 INFO - u'tests': [u'tresize', u'tcanvasmark']},
03:16:31 INFO - u'dromaeojs': {u'tests': [u'dromaeo_css', u'kraken', u'v8_7']},
03:16:31 INFO - u'dromaeojs-e10s': {u'talos_options': [u'--e10s'],
03:16:31 INFO - u'tests': [u'dromaeo_css',
03:16:31 INFO - u'kraken',
03:16:31 INFO - u'v8_7']},
03:16:31 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
03:16:31 INFO - u'tests': [u'tp5o_scroll', u'glterrain']},
03:16:31 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
03:16:31 INFO - u'talos_options': [u'--e10s'],
03:16:31 INFO - u'tests': [u'tp5o_scroll', u'glterrain']},
03:16:31 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
03:16:31 INFO - u'tests': [u'damp', u'tps']},
03:16:31 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
03:16:31 INFO - u'talos_options': [u'--e10s'],
03:16:31 INFO - u'tests': [u'damp', u'tps']},
03:16:31 INFO - u'g3': {u'tests': [u'dromaeo_dom']},
03:16:31 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']},
03:16:31 INFO - u'other': {u'tests': [u'a11yr',
03:16:31 INFO - u'ts_paint',
03:16:31 INFO - u'tpaint',
03:16:31 INFO - u'sessionrestore',
03:16:31 INFO - u'sessionrestore_no_auto_restore']},
03:16:31 INFO - u'other-e10s': {u'talos_options': [u'--e10s'],
03:16:31 INFO - u'tests': [u'a11yr',
03:16:31 INFO - u'ts_paint',
03:16:31 INFO - u'tpaint',
03:16:31 INFO - u'sessionrestore',
03:16:31 INFO - u'sessionrestore_no_auto_restore']},
03:16:31 INFO - u'other-e10s_l64': {u'talos_options': [u'--e10s'],
03:16:31 INFO - u'tests': [u'a11yr',
03:16:31 INFO - u'ts_paint',
03:16:31 INFO - u'tpaint',
03:16:31 INFO - u'sessionrestore',
03:16:31 INFO - u'sessionrestore_no_auto_restore']},
03:16:31 INFO - u'other-e10s_nol64': {u'talos_options': [u'--e10s'],
03:16:31 INFO - u'tests': [u'a11yr',
03:16:31 INFO - u'ts_paint',
03:16:31 INFO - u'tpaint',
03:16:31 INFO - u'sessionrestore',
03:16:31 INFO - u'sessionrestore_no_auto_restore']},
03:16:31 INFO - u'other_l64': {u'tests': [u'a11yr',
03:16:31 INFO - u'ts_paint',
03:16:31 INFO - u'tpaint',
03:16:31 INFO - u'sessionrestore',
03:16:31 INFO - u'sessionrestore_no_auto_restore']},
03:16:31 INFO - u'other_nol64': {u'tests': [u'a11yr',
03:16:31 INFO - u'ts_paint',
03:16:31 INFO - u'tpaint',
03:16:31 INFO - u'sessionrestore',
03:16:31 INFO - u'sessionrestore_no_auto_restore']},
03:16:31 INFO - u'svgr': {u'tests': [u'tsvgx',
03:16:31 INFO - u'tsvgr_opacity',
03:16:31 INFO - u'tart',
03:16:31 INFO - u'tscrollx',
03:16:31 INFO - u'cart']},
03:16:31 INFO - u'svgr-e10s': {u'talos_options': [u'--e10s'],
03:16:31 INFO - u'tests': [u'tsvgx',
03:16:31 INFO - u'tsvgr_opacity',
03:16:31 INFO - u'tart',
03:16:31 INFO - u'tscrollx',
03:16:31 INFO - u'cart']},
03:16:31 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
03:16:31 INFO - u'tests': [u'tp5o']},
03:16:31 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
03:16:31 INFO - u'talos_options': [u'--e10s'],
03:16:31 INFO - u'tests': [u'tp5o']},
03:16:31 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
03:16:31 INFO - u'talos_options': [u'--xperf_path',
03:16:31 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
03:16:31 INFO - u'tests': [u'tp5n']},
03:16:31 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
03:16:31 INFO - u'talos_options': [u'--e10s',
03:16:31 INFO - u'--xperf_path',
03:16:31 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"',
03:16:31 INFO - u'C:/slave/talos-data/talos/xperf.config'],
03:16:31 INFO - u'tests': [u'tp5n']}},
03:16:31 INFO - u'talos.zip': {u'path': u'',
03:16:31 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}}
03:16:31 INFO - Running post-action listener: _resource_record_post_action
03:16:31 INFO - #####
03:16:31 INFO - ##### Running create-virtualenv step.
03:16:31 INFO - #####
03:16:31 INFO - Running pre-action listener: _resource_record_pre_action
03:16:31 INFO - Running main action method: create_virtualenv
03:16:31 INFO - Creating virtualenv C:\slave\test-pgo\build/venv
03:16:31 INFO - mkdir: C:\slave\test-pgo\build\venv\Scripts
03:16:31 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test-pgo\build\venv\Scripts\python27.dll
03:16:31 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'!
03:16:31 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
03:16:31 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
03:16:37 INFO - New python executable in C:\slave\test-pgo\build/venv\Scripts\python.exe
03:16:40 INFO - Installing distribute......................................................................................................................................................................................done.
03:16:41 INFO - Return code: 0
03:16:41 INFO - Installing pip>=1.5 into virtualenv C:\slave\test-pgo\build/venv
03:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
03:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
03:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
03:16:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
03:16:41 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 0x0233DB10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022F9EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x023D3A28>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00498B48>, '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 0x004BA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023A7660>, '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-123', 'USERDOMAIN': 'T-W864-IX-123', '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-123', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-123\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-123', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-123', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-123', '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-123\\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
03:16:42 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
03:16:42 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
03:16:42 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
03:16:42 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-123\\AppData\\Roaming',
03:16:42 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
03:16:42 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
03:16:42 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
03:16:42 INFO - 'COMPUTERNAME': 'T-W864-IX-123',
03:16:42 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
03:16:42 INFO - 'DCLOCATION': 'SCL3',
03:16:42 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
03:16:42 INFO - 'FP_NO_HOST_CHECK': 'NO',
03:16:42 INFO - 'HOMEDRIVE': 'C:',
03:16:42 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-123',
03:16:42 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
03:16:42 INFO - 'KTS_VERSION': '1.19c',
03:16:42 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-123\\AppData\\Local',
03:16:42 INFO - 'LOGONSERVER': '\\\\T-W864-IX-123',
03:16:42 INFO - 'MONDIR': 'C:\\Monitor_config\\',
03:16:42 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
03:16:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
03:16:42 INFO - 'MOZ_NO_REMOTE': '1',
03:16:42 INFO - 'NO_EM_RESTART': '1',
03:16:42 INFO - 'NUMBER_OF_PROCESSORS': '8',
03:16:42 INFO - 'OS': 'Windows_NT',
03:16:42 INFO - 'OURDRIVE': 'C:',
03:16:42 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',
03:16:42 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
03:16:42 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
03:16:42 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
03:16:42 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
03:16:42 INFO - 'PROCESSOR_LEVEL': '6',
03:16:42 INFO - 'PROCESSOR_REVISION': '1e05',
03:16:42 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
03:16:42 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
03:16:42 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
03:16:42 INFO - 'PROGRAMW6432': 'C:\\Program Files',
03:16:42 INFO - 'PROMPT': '$P$G',
03:16:42 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json',
03:16:42 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
03:16:42 INFO - 'PUBLIC': 'C:\\Users\\Public',
03:16:42 INFO - 'PWD': 'C:\\slave\\test-pgo',
03:16:42 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
03:16:42 INFO - 'SLAVEDIR': 'C:\\slave\\',
03:16:42 INFO - 'SYSTEMDRIVE': 'C:',
03:16:42 INFO - 'SYSTEMROOT': 'C:\\windows',
03:16:42 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
03:16:42 INFO - 'TEST1': 'testie',
03:16:42 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
03:16:42 INFO - 'USERDOMAIN': 'T-W864-IX-123',
03:16:42 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-123',
03:16:42 INFO - 'USERNAME': 'cltbld',
03:16:42 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-123',
03:16:42 INFO - 'WINDIR': 'C:\\windows',
03:16:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
03:16:42 INFO - Ignoring indexes: http://pypi.python.org/simple/
03:16:42 INFO - Downloading/unpacking pip>=1.5
03:16:42 INFO - Creating supposed download cache at C:\slave\test-pgo\build/venv\cache
03:16:47 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
03:16:47 INFO - Running setup.py egg_info for package pip
03:16:47 INFO - warning: no files found matching 'pip\cacert.pem'
03:16:47 INFO - warning: no files found matching '*.html' under directory 'docs'
03:16:47 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build'
03:16:47 INFO - no previously-included directories found matching 'docs\_build\_sources'
03:16:47 INFO - Installing collected packages: pip
03:16:47 INFO - Found existing installation: pip 0.8.2
03:16:47 INFO - Uninstalling pip:
03:16:47 INFO - Successfully uninstalled pip
03:16:47 INFO - Running setup.py install for pip
03:16:47 INFO - warning: no files found matching 'pip\cacert.pem'
03:16:47 INFO - warning: no files found matching '*.html' under directory 'docs'
03:16:47 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build'
03:16:47 INFO - no previously-included directories found matching 'docs\_build\_sources'
03:16:47 INFO - Installing pip-script.py script to C:\slave\test-pgo\build\venv\Scripts
03:16:47 INFO - Installing pip.exe script to C:\slave\test-pgo\build\venv\Scripts
03:16:47 INFO - Installing pip2.7-script.py script to C:\slave\test-pgo\build\venv\Scripts
03:16:47 INFO - Installing pip2.7.exe script to C:\slave\test-pgo\build\venv\Scripts
03:16:47 INFO - Installing pip2-script.py script to C:\slave\test-pgo\build\venv\Scripts
03:16:47 INFO - Installing pip2.exe script to C:\slave\test-pgo\build\venv\Scripts
03:16:47 INFO - Successfully installed pip
03:16:47 INFO - Cleaning up...
03:16:47 INFO - Return code: 0
03:16:47 INFO - Installing psutil>=0.7.1 into virtualenv C:\slave\test-pgo\build/venv
03:16:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]}
03:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
03:16:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]}
03:16:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
03:16:47 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 0x0233DB10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022F9EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x023D3A28>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00498B48>, '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 0x004BA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023A7660>, '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-123', 'USERDOMAIN': 'T-W864-IX-123', '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-123', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-123\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-123', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-123', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-123', '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-123\\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
03:16:47 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
03:16:47 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
03:16:47 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
03:16:47 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-123\\AppData\\Roaming',
03:16:47 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
03:16:47 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
03:16:47 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
03:16:47 INFO - 'COMPUTERNAME': 'T-W864-IX-123',
03:16:47 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
03:16:47 INFO - 'DCLOCATION': 'SCL3',
03:16:47 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
03:16:47 INFO - 'FP_NO_HOST_CHECK': 'NO',
03:16:47 INFO - 'HOMEDRIVE': 'C:',
03:16:47 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-123',
03:16:47 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
03:16:47 INFO - 'KTS_VERSION': '1.19c',
03:16:47 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-123\\AppData\\Local',
03:16:47 INFO - 'LOGONSERVER': '\\\\T-W864-IX-123',
03:16:47 INFO - 'MONDIR': 'C:\\Monitor_config\\',
03:16:47 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
03:16:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
03:16:47 INFO - 'MOZ_NO_REMOTE': '1',
03:16:47 INFO - 'NO_EM_RESTART': '1',
03:16:47 INFO - 'NUMBER_OF_PROCESSORS': '8',
03:16:47 INFO - 'OS': 'Windows_NT',
03:16:47 INFO - 'OURDRIVE': 'C:',
03:16:47 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',
03:16:47 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
03:16:47 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
03:16:47 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
03:16:47 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
03:16:47 INFO - 'PROCESSOR_LEVEL': '6',
03:16:47 INFO - 'PROCESSOR_REVISION': '1e05',
03:16:47 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
03:16:47 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
03:16:47 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
03:16:47 INFO - 'PROGRAMW6432': 'C:\\Program Files',
03:16:47 INFO - 'PROMPT': '$P$G',
03:16:47 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json',
03:16:47 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
03:16:47 INFO - 'PUBLIC': 'C:\\Users\\Public',
03:16:47 INFO - 'PWD': 'C:\\slave\\test-pgo',
03:16:47 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
03:16:47 INFO - 'SLAVEDIR': 'C:\\slave\\',
03:16:47 INFO - 'SYSTEMDRIVE': 'C:',
03:16:47 INFO - 'SYSTEMROOT': 'C:\\windows',
03:16:47 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
03:16:47 INFO - 'TEST1': 'testie',
03:16:47 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
03:16:47 INFO - 'USERDOMAIN': 'T-W864-IX-123',
03:16:47 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-123',
03:16:47 INFO - 'USERNAME': 'cltbld',
03:16:47 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-123',
03:16:47 INFO - 'WINDIR': 'C:\\windows',
03:16:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
03:16:49 INFO - Ignoring indexes: https://pypi.python.org/simple/
03:16:49 INFO - Downloading/unpacking psutil>=0.7.1
03:16:49 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
03:16:49 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
03:16:50 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
03:16:50 INFO - Installing collected packages: psutil
03:16:50 INFO - Successfully installed psutil
03:16:50 INFO - Cleaning up...
03:16:51 INFO - Return code: 0
03:16:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv C:\slave\test-pgo\build/venv
03:16:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
03:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
03:16:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
03:16:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
03:16:51 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 0x0233DB10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022F9EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x023D3A28>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00498B48>, '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 0x004BA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023A7660>, '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-123', 'USERDOMAIN': 'T-W864-IX-123', '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-123', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-123\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-123', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-123', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-123', '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-123\\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
03:16:51 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
03:16:51 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
03:16:51 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
03:16:51 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-123\\AppData\\Roaming',
03:16:51 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
03:16:51 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
03:16:51 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
03:16:51 INFO - 'COMPUTERNAME': 'T-W864-IX-123',
03:16:51 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
03:16:51 INFO - 'DCLOCATION': 'SCL3',
03:16:51 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
03:16:51 INFO - 'FP_NO_HOST_CHECK': 'NO',
03:16:51 INFO - 'HOMEDRIVE': 'C:',
03:16:51 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-123',
03:16:51 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
03:16:51 INFO - 'KTS_VERSION': '1.19c',
03:16:51 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-123\\AppData\\Local',
03:16:51 INFO - 'LOGONSERVER': '\\\\T-W864-IX-123',
03:16:51 INFO - 'MONDIR': 'C:\\Monitor_config\\',
03:16:51 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
03:16:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
03:16:51 INFO - 'MOZ_NO_REMOTE': '1',
03:16:51 INFO - 'NO_EM_RESTART': '1',
03:16:51 INFO - 'NUMBER_OF_PROCESSORS': '8',
03:16:51 INFO - 'OS': 'Windows_NT',
03:16:51 INFO - 'OURDRIVE': 'C:',
03:16:51 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',
03:16:51 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
03:16:51 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
03:16:51 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
03:16:51 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
03:16:51 INFO - 'PROCESSOR_LEVEL': '6',
03:16:51 INFO - 'PROCESSOR_REVISION': '1e05',
03:16:51 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
03:16:51 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
03:16:51 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
03:16:51 INFO - 'PROGRAMW6432': 'C:\\Program Files',
03:16:51 INFO - 'PROMPT': '$P$G',
03:16:51 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json',
03:16:51 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
03:16:51 INFO - 'PUBLIC': 'C:\\Users\\Public',
03:16:51 INFO - 'PWD': 'C:\\slave\\test-pgo',
03:16:51 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
03:16:51 INFO - 'SLAVEDIR': 'C:\\slave\\',
03:16:51 INFO - 'SYSTEMDRIVE': 'C:',
03:16:51 INFO - 'SYSTEMROOT': 'C:\\windows',
03:16:51 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
03:16:51 INFO - 'TEST1': 'testie',
03:16:51 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
03:16:51 INFO - 'USERDOMAIN': 'T-W864-IX-123',
03:16:51 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-123',
03:16:51 INFO - 'USERNAME': 'cltbld',
03:16:51 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-123',
03:16:51 INFO - 'WINDIR': 'C:\\windows',
03:16:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
03:16:51 INFO - Ignoring indexes: https://pypi.python.org/simple/
03:16:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0
03:16: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
03:16: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
03:16:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz
03:16:52 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
03:16:52 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor
03:16:52 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)
03:16:52 INFO - Installing collected packages: mozsystemmonitor
03:16:52 INFO - Running setup.py install for mozsystemmonitor
03:16:52 INFO - Successfully installed mozsystemmonitor
03:16:52 INFO - Cleaning up...
03:16:52 INFO - Return code: 0
03:16:52 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test-pgo\build/venv
03:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
03:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
03:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
03:16:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
03:16:52 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 0x0233DB10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022F9EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x023D3A28>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00498B48>, '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 0x004BA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023A7660>, '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-123', 'USERDOMAIN': 'T-W864-IX-123', '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-123', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-123\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-123', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-123', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-123', '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-123\\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
03:16:52 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
03:16:52 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
03:16:52 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
03:16:52 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-123\\AppData\\Roaming',
03:16:52 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
03:16:52 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
03:16:52 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
03:16:52 INFO - 'COMPUTERNAME': 'T-W864-IX-123',
03:16:52 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
03:16:52 INFO - 'DCLOCATION': 'SCL3',
03:16:52 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
03:16:52 INFO - 'FP_NO_HOST_CHECK': 'NO',
03:16:52 INFO - 'HOMEDRIVE': 'C:',
03:16:52 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-123',
03:16:52 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
03:16:52 INFO - 'KTS_VERSION': '1.19c',
03:16:52 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-123\\AppData\\Local',
03:16:52 INFO - 'LOGONSERVER': '\\\\T-W864-IX-123',
03:16:52 INFO - 'MONDIR': 'C:\\Monitor_config\\',
03:16:52 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
03:16:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
03:16:52 INFO - 'MOZ_NO_REMOTE': '1',
03:16:52 INFO - 'NO_EM_RESTART': '1',
03:16:52 INFO - 'NUMBER_OF_PROCESSORS': '8',
03:16:52 INFO - 'OS': 'Windows_NT',
03:16:52 INFO - 'OURDRIVE': 'C:',
03:16:52 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',
03:16:52 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
03:16:52 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
03:16:52 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
03:16:52 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
03:16:52 INFO - 'PROCESSOR_LEVEL': '6',
03:16:52 INFO - 'PROCESSOR_REVISION': '1e05',
03:16:52 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
03:16:52 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
03:16:52 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
03:16:52 INFO - 'PROGRAMW6432': 'C:\\Program Files',
03:16:52 INFO - 'PROMPT': '$P$G',
03:16:52 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json',
03:16:52 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
03:16:52 INFO - 'PUBLIC': 'C:\\Users\\Public',
03:16:52 INFO - 'PWD': 'C:\\slave\\test-pgo',
03:16:52 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
03:16:52 INFO - 'SLAVEDIR': 'C:\\slave\\',
03:16:52 INFO - 'SYSTEMDRIVE': 'C:',
03:16:52 INFO - 'SYSTEMROOT': 'C:\\windows',
03:16:52 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
03:16:52 INFO - 'TEST1': 'testie',
03:16:52 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
03:16:52 INFO - 'USERDOMAIN': 'T-W864-IX-123',
03:16:52 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-123',
03:16:52 INFO - 'USERNAME': 'cltbld',
03:16:52 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-123',
03:16:52 INFO - 'WINDIR': 'C:\\windows',
03:16:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
03:16:53 INFO - Ignoring indexes: https://pypi.python.org/simple/
03:16:53 INFO - Downloading/unpacking blobuploader==1.2.4
03:16:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
03:16:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
03:16:53 INFO - Downloading blobuploader-1.2.4.tar.gz
03:16:53 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
03:16:53 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader
03:16:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4)
03:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
03:16:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
03:16:54 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
03:16:54 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\requests\setup.py) egg_info for package requests
03:16:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4)
03:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
03:16:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
03:16:54 INFO - Downloading docopt-0.6.1.tar.gz
03:16:54 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
03:16:54 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\docopt\setup.py) egg_info for package docopt
03:16:54 INFO - Installing collected packages: blobuploader, requests, docopt
03:16:54 INFO - Running setup.py install for blobuploader
03:16:54 INFO - Running setup.py install for requests
03:16:55 INFO - Running setup.py install for docopt
03:16:55 INFO - Successfully installed blobuploader requests docopt
03:16:55 INFO - Cleaning up...
03:16:57 INFO - Return code: 0
03:16:57 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv
03:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]}
03:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
03:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]}
03:16:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
03:16:57 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 0x0233DB10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022F9EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x023D3A28>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00498B48>, '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 0x004BA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023A7660>, '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-123', 'USERDOMAIN': 'T-W864-IX-123', '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-123', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-123\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-123', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-123', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-123', '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-123\\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
03:16:57 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
03:16:57 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
03:16:57 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
03:16:57 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-123\\AppData\\Roaming',
03:16:57 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
03:16:57 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
03:16:57 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
03:16:57 INFO - 'COMPUTERNAME': 'T-W864-IX-123',
03:16:57 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
03:16:57 INFO - 'DCLOCATION': 'SCL3',
03:16:57 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
03:16:57 INFO - 'FP_NO_HOST_CHECK': 'NO',
03:16:57 INFO - 'HOMEDRIVE': 'C:',
03:16:57 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-123',
03:16:57 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
03:16:57 INFO - 'KTS_VERSION': '1.19c',
03:16:57 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-123\\AppData\\Local',
03:16:57 INFO - 'LOGONSERVER': '\\\\T-W864-IX-123',
03:16:57 INFO - 'MONDIR': 'C:\\Monitor_config\\',
03:16:57 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
03:16:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
03:16:57 INFO - 'MOZ_NO_REMOTE': '1',
03:16:57 INFO - 'NO_EM_RESTART': '1',
03:16:57 INFO - 'NUMBER_OF_PROCESSORS': '8',
03:16:57 INFO - 'OS': 'Windows_NT',
03:16:57 INFO - 'OURDRIVE': 'C:',
03:16:57 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',
03:16:57 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
03:16:57 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
03:16:57 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
03:16:57 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
03:16:57 INFO - 'PROCESSOR_LEVEL': '6',
03:16:57 INFO - 'PROCESSOR_REVISION': '1e05',
03:16:57 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
03:16:57 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
03:16:57 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
03:16:57 INFO - 'PROGRAMW6432': 'C:\\Program Files',
03:16:57 INFO - 'PROMPT': '$P$G',
03:16:57 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json',
03:16:57 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
03:16:57 INFO - 'PUBLIC': 'C:\\Users\\Public',
03:16:57 INFO - 'PWD': 'C:\\slave\\test-pgo',
03:16:57 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
03:16:57 INFO - 'SLAVEDIR': 'C:\\slave\\',
03:16:57 INFO - 'SYSTEMDRIVE': 'C:',
03:16:57 INFO - 'SYSTEMROOT': 'C:\\windows',
03:16:57 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
03:16:57 INFO - 'TEST1': 'testie',
03:16:57 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
03:16:57 INFO - 'USERDOMAIN': 'T-W864-IX-123',
03:16:57 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-123',
03:16:57 INFO - 'USERNAME': 'cltbld',
03:16:57 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-123',
03:16:57 INFO - 'WINDIR': 'C:\\windows',
03:16:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
03:16:57 INFO - Ignoring indexes: https://pypi.python.org/simple/
03:16:57 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\manifestparser
03:16:57 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rj_gbj-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/manifestparser
03:16:57 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozcrash
03:16:57 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-oy0o7z-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozcrash
03:16:57 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdebug
03:16:57 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-hcxzx5-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdebug
03:16:57 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdevice
03:16:57 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-pixiow-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdevice
03:16:58 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozfile
03:16:58 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-3lzpau-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozfile
03:16:58 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozhttpd
03:16:58 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-1g82uf-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozhttpd
03:16:58 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinfo
03:16:58 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-nv7dr7-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinfo
03:16:58 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinstall
03:16:58 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-nargpz-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinstall
03:16:58 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozleak
03:16:58 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jzsjyx-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozleak
03:16:58 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozlog
03:16:58 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-kp_3n1-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozlog
03:16:58 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moznetwork
03:16:58 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-raq218-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moznetwork
03:16:58 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprocess
03:16:58 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-hvohn6-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprocess
03:16:58 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprofile
03:16:58 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-woduks-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprofile
03:16:58 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozrunner
03:16:58 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-4zmsay-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozrunner
03:16:59 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozscreenshot
03:16:59 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ld2_it-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozscreenshot
03:16:59 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moztest
03:16:59 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jmmlju-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moztest
03:16:59 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozversion
03:16:59 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-nmj1q2-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozversion
03:16:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion
03:16:59 INFO - Running setup.py install for manifestparser
03:16:59 INFO - Installing manifestparser-script.py script to C:\slave\test-pgo\build\venv\Scripts
03:16:59 INFO - Installing manifestparser.exe script to C:\slave\test-pgo\build\venv\Scripts
03:17:00 INFO - Running setup.py install for mozcrash
03:17:00 INFO - Running setup.py install for mozdebug
03:17:00 INFO - Running setup.py install for mozdevice
03:17:01 INFO - Installing sutini-script.py script to C:\slave\test-pgo\build\venv\Scripts
03:17:01 INFO - Installing sutini.exe script to C:\slave\test-pgo\build\venv\Scripts
03:17:01 INFO - Installing dm-script.py script to C:\slave\test-pgo\build\venv\Scripts
03:17:01 INFO - Installing dm.exe script to C:\slave\test-pgo\build\venv\Scripts
03:17:01 INFO - Running setup.py install for mozfile
03:17:02 INFO - Running setup.py install for mozhttpd
03:17:02 INFO - Installing mozhttpd-script.py script to C:\slave\test-pgo\build\venv\Scripts
03:17:02 INFO - Installing mozhttpd.exe script to C:\slave\test-pgo\build\venv\Scripts
03:17:02 INFO - Running setup.py install for mozinfo
03:17:03 INFO - Installing mozinfo-script.py script to C:\slave\test-pgo\build\venv\Scripts
03:17:03 INFO - Installing mozinfo.exe script to C:\slave\test-pgo\build\venv\Scripts
03:17:03 INFO - Running setup.py install for mozInstall
03:17:03 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test-pgo\build\venv\Scripts
03:17:03 INFO - Installing moz_remove_from_system.exe script to C:\slave\test-pgo\build\venv\Scripts
03:17:03 INFO - Installing mozuninstall-script.py script to C:\slave\test-pgo\build\venv\Scripts
03:17:03 INFO - Installing mozuninstall.exe script to C:\slave\test-pgo\build\venv\Scripts
03:17:03 INFO - Installing mozinstall-script.py script to C:\slave\test-pgo\build\venv\Scripts
03:17:03 INFO - Installing mozinstall.exe script to C:\slave\test-pgo\build\venv\Scripts
03:17:03 INFO - Installing moz_add_to_system-script.py script to C:\slave\test-pgo\build\venv\Scripts
03:17:03 INFO - Installing moz_add_to_system.exe script to C:\slave\test-pgo\build\venv\Scripts
03:17:03 INFO - Running setup.py install for mozleak
03:17:04 INFO - Running setup.py install for mozlog
03:17:04 INFO - Installing structlog-script.py script to C:\slave\test-pgo\build\venv\Scripts
03:17:04 INFO - Installing structlog.exe script to C:\slave\test-pgo\build\venv\Scripts
03:17:04 INFO - Running setup.py install for moznetwork
03:17:05 INFO - Installing moznetwork-script.py script to C:\slave\test-pgo\build\venv\Scripts
03:17:05 INFO - Installing moznetwork.exe script to C:\slave\test-pgo\build\venv\Scripts
03:17:05 INFO - Running setup.py install for mozprocess
03:17:05 INFO - Running setup.py install for mozprofile
03:17:05 INFO - Installing mozprofile-script.py script to C:\slave\test-pgo\build\venv\Scripts
03:17:05 INFO - Installing mozprofile.exe script to C:\slave\test-pgo\build\venv\Scripts
03:17:05 INFO - Installing diff-profiles-script.py script to C:\slave\test-pgo\build\venv\Scripts
03:17:05 INFO - Installing diff-profiles.exe script to C:\slave\test-pgo\build\venv\Scripts
03:17:05 INFO - Installing view-profile-script.py script to C:\slave\test-pgo\build\venv\Scripts
03:17:05 INFO - Installing view-profile.exe script to C:\slave\test-pgo\build\venv\Scripts
03:17:06 INFO - Running setup.py install for mozrunner
03:17:06 INFO - Installing mozrunner-script.py script to C:\slave\test-pgo\build\venv\Scripts
03:17:06 INFO - Installing mozrunner.exe script to C:\slave\test-pgo\build\venv\Scripts
03:17:07 INFO - Running setup.py install for mozscreenshot
03:17:07 INFO - Running setup.py install for moztest
03:17:07 INFO - Running setup.py install for mozversion
03:17:07 INFO - Installing mozversion-script.py script to C:\slave\test-pgo\build\venv\Scripts
03:17:07 INFO - Installing mozversion.exe script to C:\slave\test-pgo\build\venv\Scripts
03:17:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion
03:17:08 INFO - Cleaning up...
03:17:08 INFO - Return code: 0
03:17:08 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv
03:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
03:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
03:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
03:17:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
03:17:08 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 0x0233DB10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022F9EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x023D3A28>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00498B48>, '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 0x004BA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023A7660>, '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-123', 'USERDOMAIN': 'T-W864-IX-123', '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-123', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-123\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-123', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-123', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-123', '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-123\\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
03:17:08 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
03:17:08 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
03:17:08 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
03:17:08 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-123\\AppData\\Roaming',
03:17:08 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
03:17:08 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
03:17:08 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
03:17:08 INFO - 'COMPUTERNAME': 'T-W864-IX-123',
03:17:08 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
03:17:08 INFO - 'DCLOCATION': 'SCL3',
03:17:08 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
03:17:08 INFO - 'FP_NO_HOST_CHECK': 'NO',
03:17:08 INFO - 'HOMEDRIVE': 'C:',
03:17:08 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-123',
03:17:08 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
03:17:08 INFO - 'KTS_VERSION': '1.19c',
03:17:08 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-123\\AppData\\Local',
03:17:08 INFO - 'LOGONSERVER': '\\\\T-W864-IX-123',
03:17:08 INFO - 'MONDIR': 'C:\\Monitor_config\\',
03:17:08 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
03:17:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
03:17:08 INFO - 'MOZ_NO_REMOTE': '1',
03:17:08 INFO - 'NO_EM_RESTART': '1',
03:17:08 INFO - 'NUMBER_OF_PROCESSORS': '8',
03:17:08 INFO - 'OS': 'Windows_NT',
03:17:08 INFO - 'OURDRIVE': 'C:',
03:17:08 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',
03:17:08 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
03:17:08 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
03:17:08 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
03:17:08 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
03:17:08 INFO - 'PROCESSOR_LEVEL': '6',
03:17:08 INFO - 'PROCESSOR_REVISION': '1e05',
03:17:08 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
03:17:08 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
03:17:08 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
03:17:08 INFO - 'PROGRAMW6432': 'C:\\Program Files',
03:17:08 INFO - 'PROMPT': '$P$G',
03:17:08 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json',
03:17:08 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
03:17:08 INFO - 'PUBLIC': 'C:\\Users\\Public',
03:17:08 INFO - 'PWD': 'C:\\slave\\test-pgo',
03:17:08 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
03:17:08 INFO - 'SLAVEDIR': 'C:\\slave\\',
03:17:08 INFO - 'SYSTEMDRIVE': 'C:',
03:17:08 INFO - 'SYSTEMROOT': 'C:\\windows',
03:17:08 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
03:17:08 INFO - 'TEST1': 'testie',
03:17:08 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
03:17:08 INFO - 'USERDOMAIN': 'T-W864-IX-123',
03:17:08 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-123',
03:17:08 INFO - 'USERNAME': 'cltbld',
03:17:08 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-123',
03:17:08 INFO - 'WINDIR': 'C:\\windows',
03:17:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
03:17:08 INFO - Ignoring indexes: https://pypi.python.org/simple/
03:17:08 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\manifestparser
03:17:08 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-d3gxpc-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/manifestparser
03:17:08 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))
03:17:08 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozcrash
03:17:08 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qp_fmu-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozcrash
03:17:09 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))
03:17:09 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdebug
03:17:09 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-vyiozq-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdebug
03:17:09 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))
03:17:09 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdevice
03:17:09 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-vwcuzy-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdevice
03:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 from file:///C:/slave/test-pgo/build/tests/mozbase/mozdevice in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 4))
03:17:09 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozfile
03:17:09 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-hk1ity-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozfile
03:17:09 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))
03:17:09 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozhttpd
03:17:09 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-inpdgq-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozhttpd
03:17:09 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))
03:17:09 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinfo
03:17:09 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ibn1ew-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinfo
03:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 from file:///C:/slave/test-pgo/build/tests/mozbase/mozinfo in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 7))
03:17:09 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinstall
03:17:09 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-7anct5-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinstall
03:17:09 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))
03:17:09 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozleak
03:17:09 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rtkcmz-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozleak
03:17:09 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))
03:17:09 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozlog
03:17:09 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-acqxna-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozlog
03:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///C:/slave/test-pgo/build/tests/mozbase/mozlog in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 10))
03:17:09 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moznetwork
03:17:10 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-kgm18x-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moznetwork
03:17:10 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))
03:17:10 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprocess
03:17:10 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-kmsjns-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprocess
03:17:10 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))
03:17:10 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprofile
03:17:10 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-vucpnf-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprofile
03:17:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///C:/slave/test-pgo/build/tests/mozbase/mozprofile in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 13))
03:17:10 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozrunner
03:17:10 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-afxxbq-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozrunner
03:17:10 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))
03:17:10 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozscreenshot
03:17:10 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-hvppyd-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozscreenshot
03:17:10 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))
03:17:10 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moztest
03:17:10 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-uktgs3-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moztest
03:17:10 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))
03:17:10 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozversion
03:17:10 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-vvey3n-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozversion
03:17:10 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))
03:17:10 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))
03:17:10 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))
03:17:10 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))
03:17:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test-pgo\build\venv\lib\site-packages (from mozdevice==0.46->-r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 4))
03:17:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in c:\slave\test-pgo\build\venv\lib\site-packages (from mozdevice==0.46->-r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 4))
03:17:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 10))
03:17:10 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
03:17:10 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
03:17:11 INFO - Downloading blessings-1.5.1.tar.gz
03:17:11 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
03:17:11 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\blessings\setup.py) egg_info for package blessings
03:17:12 INFO - Installing collected packages: blessings
03:17:12 INFO - Running setup.py install for blessings
03:17:12 INFO - Successfully installed blessings
03:17:12 INFO - Cleaning up...
03:17:15 INFO - Return code: 0
03:17:15 INFO - Done creating virtualenv C:\slave\test-pgo\build/venv.
03:17:15 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'freeze']
03:17:15 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip freeze
03:17:15 INFO - Reading from file tmpfile_stdout
03:17:15 INFO - Using _rmtree_windows ...
03:17:15 INFO - Using _rmtree_windows ...
03:17:15 INFO - Current package versions:
03:17:15 INFO - blessings == 1.5.1
03:17:15 INFO - blobuploader == 1.2.4
03:17:15 INFO - docopt == 0.6.1
03:17:15 INFO - manifestparser == 1.1
03:17:15 INFO - mozInstall == 1.12
03:17:15 INFO - mozcrash == 0.16
03:17:15 INFO - mozdebug == 0.1
03:17:15 INFO - mozdevice == 0.46
03:17:15 INFO - mozfile == 1.2
03:17:15 INFO - mozhttpd == 0.7
03:17:15 INFO - mozinfo == 0.8
03:17:15 INFO - mozleak == 0.1
03:17:15 INFO - mozlog == 3.0
03:17:15 INFO - moznetwork == 0.27
03:17:15 INFO - mozprocess == 0.22
03:17:15 INFO - mozprofile == 0.27
03:17:15 INFO - mozrunner == 6.11
03:17:15 INFO - mozscreenshot == 0.1
03:17:15 INFO - mozsystemmonitor == 0.0
03:17:15 INFO - moztest == 0.7
03:17:15 INFO - mozversion == 1.4
03:17:15 INFO - psutil == 3.1.1
03:17:15 INFO - requests == 1.2.3
03:17:15 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv
03:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]}
03:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
03:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]}
03:17:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
03:17:15 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 0x0233DB10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022F9EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x023D3A28>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00498B48>, '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 0x004BA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023A7660>, '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-123', 'USERDOMAIN': 'T-W864-IX-123', '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-123', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-123\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-123', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-123', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-123', '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-123\\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
03:17:15 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
03:17:15 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
03:17:15 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
03:17:15 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-123\\AppData\\Roaming',
03:17:15 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
03:17:15 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
03:17:15 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
03:17:15 INFO - 'COMPUTERNAME': 'T-W864-IX-123',
03:17:15 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
03:17:15 INFO - 'DCLOCATION': 'SCL3',
03:17:15 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
03:17:15 INFO - 'FP_NO_HOST_CHECK': 'NO',
03:17:15 INFO - 'HOMEDRIVE': 'C:',
03:17:15 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-123',
03:17:15 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
03:17:15 INFO - 'KTS_VERSION': '1.19c',
03:17:15 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-123\\AppData\\Local',
03:17:15 INFO - 'LOGONSERVER': '\\\\T-W864-IX-123',
03:17:15 INFO - 'MONDIR': 'C:\\Monitor_config\\',
03:17:15 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
03:17:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
03:17:15 INFO - 'MOZ_NO_REMOTE': '1',
03:17:15 INFO - 'NO_EM_RESTART': '1',
03:17:15 INFO - 'NUMBER_OF_PROCESSORS': '8',
03:17:15 INFO - 'OS': 'Windows_NT',
03:17:15 INFO - 'OURDRIVE': 'C:',
03:17:15 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',
03:17:15 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
03:17:15 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
03:17:15 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
03:17:15 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
03:17:15 INFO - 'PROCESSOR_LEVEL': '6',
03:17:15 INFO - 'PROCESSOR_REVISION': '1e05',
03:17:15 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
03:17:15 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
03:17:15 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
03:17:15 INFO - 'PROGRAMW6432': 'C:\\Program Files',
03:17:15 INFO - 'PROMPT': '$P$G',
03:17:15 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json',
03:17:15 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
03:17:15 INFO - 'PUBLIC': 'C:\\Users\\Public',
03:17:15 INFO - 'PWD': 'C:\\slave\\test-pgo',
03:17:15 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
03:17:15 INFO - 'SLAVEDIR': 'C:\\slave\\',
03:17:15 INFO - 'SYSTEMDRIVE': 'C:',
03:17:15 INFO - 'SYSTEMROOT': 'C:\\windows',
03:17:15 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
03:17:15 INFO - 'TEST1': 'testie',
03:17:15 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
03:17:15 INFO - 'USERDOMAIN': 'T-W864-IX-123',
03:17:15 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-123',
03:17:15 INFO - 'USERNAME': 'cltbld',
03:17:15 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-123',
03:17:15 INFO - 'WINDIR': 'C:\\windows',
03:17:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
03:17:15 INFO - Ignoring indexes: https://pypi.python.org/simple/
03:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 1))
03:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 2))
03:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 3))
03:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 4))
03:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 5))
03:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 6))
03:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 7))
03:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 8))
03:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in c:\slave\test-pgo\build\venv\lib\site-packages (from mozcrash>=0.15->-r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 1))
03:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test-pgo\build\venv\lib\site-packages (from mozhttpd>=0.7->-r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 3))
03:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in c:\slave\test-pgo\build\venv\lib\site-packages (from mozlog>=3.0->mozcrash>=0.15->-r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 1))
03:17:15 INFO - Cleaning up...
03:17:15 INFO - Return code: 0
03:17:15 INFO - Running post-action listener: _resource_record_post_action
03:17:15 INFO - Running post-action listener: _start_resource_monitoring
03:17:15 INFO - Starting resource monitoring.
03:17:16 INFO - #####
03:17:16 INFO - ##### Running install step.
03:17:16 INFO - #####
03:17:16 INFO - Running pre-action listener: _resource_record_pre_action
03:17:16 INFO - Running main action method: install
03:17:16 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'freeze']
03:17:16 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip freeze
03:17:16 INFO - Reading from file tmpfile_stdout
03:17:16 INFO - Using _rmtree_windows ...
03:17:16 INFO - Using _rmtree_windows ...
03:17:16 INFO - Detecting whether we're running mozinstall >=1.0...
03:17:16 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build/venv/scripts/python', 'C:\\slave\\test-pgo\\build/venv/scripts/mozinstall-script.py', '-h']
03:17:16 INFO - Copy/paste: C:\slave\test-pgo\build/venv/scripts/python C:\slave\test-pgo\build/venv/scripts/mozinstall-script.py -h
03:17:16 INFO - Reading from file tmpfile_stdout
03:17:16 INFO - Output received:
03:17:16 INFO - Usage: mozinstall-script.py [options] installer
03:17:16 INFO - Options:
03:17:16 INFO - -h, --help show this help message and exit
03:17:16 INFO - -d DEST, --destination=DEST
03:17:16 INFO - Directory to install application into. [default:
03:17:16 INFO - "C:\slave\test-pgo"]
03:17:16 INFO - --app=APP Application being installed. [default: firefox]
03:17:16 INFO - Using _rmtree_windows ...
03:17:16 INFO - Using _rmtree_windows ...
03:17:16 INFO - mkdir: C:\slave\test-pgo\build\application
03:17:16 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build/venv/scripts/python', 'C:\\slave\\test-pgo\\build/venv/scripts/mozinstall-script.py', 'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win64.zip', '--destination', 'C:\\slave\\test-pgo\\build\\application']
03:17:16 INFO - Copy/paste: C:\slave\test-pgo\build/venv/scripts/python C:\slave\test-pgo\build/venv/scripts/mozinstall-script.py C:\slave\test-pgo\build\firefox-44.0a1.en-US.win64.zip --destination C:\slave\test-pgo\build\application
03:17:17 INFO - Reading from file tmpfile_stdout
03:17:17 INFO - Output received:
03:17:17 INFO - C:\slave\test-pgo\build\application\firefox\firefox.exe
03:17:17 INFO - Using _rmtree_windows ...
03:17:17 INFO - Using _rmtree_windows ...
03:17:17 INFO - Running post-action listener: _resource_record_post_action
03:17:17 INFO - #####
03:17:17 INFO - ##### Running run-tests step.
03:17:17 INFO - #####
03:17:17 INFO - Running pre-action listener: _resource_record_pre_action
03:17:17 INFO - Running main action method: run_tests
03:17:17 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\python', '--version']
03:17:17 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\python --version
03:17:17 INFO - Python 2.7.3
03:17:17 INFO - Return code: 0
03:17:17 INFO - grabbing minidump binary from tooltool
03:17:17 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')]}
03:17:17 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 0x00498B48>, '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 0x004BA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023A7660>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'privileged': False}, attempt #1
03:17:17 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
03:17:17 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
03:17:17 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'...
03:17:18 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test-pgo\build\tmpcnvgih
03:17:18 INFO - INFO - File integrity verified, renaming tmpcnvgih to win32-minidump_stackwalk.exe
03:17:18 INFO - Return code: 0
03:17:18 INFO - Chmoding C:\slave\test-pgo\build\win32-minidump_stackwalk.exe to 0755
03:17:18 INFO - mkdir: C:\slave\test-pgo\build\blobber_upload_dir
03:17:18 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test-pgo\build\blobber_upload_dir
03:17:18 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test-pgo\build\win32-minidump_stackwalk.exe
03:17:18 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test-pgo\build\blobber_upload_dir
03:17:18 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\python', 'C:\\slave\\test-pgo\\build\\tests\\talos\\talos\\run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test-pgo\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a5JHnii2T5--agh9aAnbWg/artifacts/public/build/firefox-44.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-123', '--webServer', 'localhost'] in C:\slave\test-pgo\build
03:17:18 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\python C:\slave\test-pgo\build\tests\talos\talos\run_tests.py --debug --branchName B2G-Inbound --suite dromaeojs --executablePath C:\slave\test-pgo\build\application\firefox\firefox --symbolsPath https://queue.taskcluster.net/v1/task/a5JHnii2T5--agh9aAnbWg/artifacts/public/build/firefox-44.0a1.en-US.win64.crashreporter-symbols.zip --title T-W864-IX-123 --webServer localhost
03:17:18 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
03:17:18 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-123\\AppData\\Roaming',
03:17:18 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
03:17:18 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
03:17:18 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
03:17:18 INFO - 'COMPUTERNAME': 'T-W864-IX-123',
03:17:18 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
03:17:18 INFO - 'DCLOCATION': 'SCL3',
03:17:18 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
03:17:18 INFO - 'FP_NO_HOST_CHECK': 'NO',
03:17:18 INFO - 'HOMEDRIVE': 'C:',
03:17:18 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-123',
03:17:18 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
03:17:18 INFO - 'KTS_VERSION': '1.19c',
03:17:18 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-123\\AppData\\Local',
03:17:18 INFO - 'LOGONSERVER': '\\\\T-W864-IX-123',
03:17:18 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test-pgo\\build\\blobber_upload_dir',
03:17:18 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test-pgo\\build\\win32-minidump_stackwalk.exe',
03:17:18 INFO - 'MONDIR': 'C:\\Monitor_config\\',
03:17:18 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
03:17:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
03:17:18 INFO - 'MOZ_NO_REMOTE': '1',
03:17:18 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test-pgo\\build\\blobber_upload_dir',
03:17:18 INFO - 'NO_EM_RESTART': '1',
03:17:18 INFO - 'NUMBER_OF_PROCESSORS': '8',
03:17:18 INFO - 'OS': 'Windows_NT',
03:17:18 INFO - 'OURDRIVE': 'C:',
03:17:18 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',
03:17:18 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
03:17:18 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
03:17:18 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
03:17:18 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
03:17:18 INFO - 'PROCESSOR_LEVEL': '6',
03:17:18 INFO - 'PROCESSOR_REVISION': '1e05',
03:17:18 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
03:17:18 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
03:17:18 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
03:17:18 INFO - 'PROGRAMW6432': 'C:\\Program Files',
03:17:18 INFO - 'PROMPT': '$P$G',
03:17:18 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json',
03:17:18 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
03:17:18 INFO - 'PUBLIC': 'C:\\Users\\Public',
03:17:18 INFO - 'PWD': 'C:\\slave\\test-pgo',
03:17:18 INFO - 'PYTHONPATH': 'C:\\slave\\test-pgo\\build\\tests\\talos',
03:17:18 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
03:17:18 INFO - 'SLAVEDIR': 'C:\\slave\\',
03:17:18 INFO - 'SYSTEMDRIVE': 'C:',
03:17:18 INFO - 'SYSTEMROOT': 'C:\\windows',
03:17:18 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
03:17:18 INFO - 'TEST1': 'testie',
03:17:18 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
03:17:18 INFO - 'USERDOMAIN': 'T-W864-IX-123',
03:17:18 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-123',
03:17:18 INFO - 'USERNAME': 'cltbld',
03:17:18 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-123',
03:17:18 INFO - 'WINDIR': 'C:\\windows',
03:17:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
03:17:18 INFO - Calling ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\python', 'C:\\slave\\test-pgo\\build\\tests\\talos\\talos\\run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test-pgo\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a5JHnii2T5--agh9aAnbWg/artifacts/public/build/firefox-44.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-123', '--webServer', 'localhost'] with output_timeout 3600
ProcessManager NOT managing child processes
ProcessManager UNABLE to use job objects to manage child processes
03:17:19 INFO - mozversion INFO | application_buildid: 20151026023015
03:17:19 INFO - mozversion INFO | application_changeset: 8631cff3e8183a5cc08e7c5b3478c8c21b7d4a55
03:17:19 INFO - mozversion INFO | application_display_name: Nightly
03:17:19 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384}
03:17:19 INFO - mozversion INFO | application_name: Firefox
03:17:19 INFO - mozversion INFO | application_remotingname: firefox
03:17:19 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound
03:17:19 INFO - mozversion INFO | application_vendor: Mozilla
03:17:19 INFO - mozversion INFO | application_version: 44.0a1
03:17:19 INFO - mozversion INFO | platform_buildid: 20151026023015
03:17:19 INFO - mozversion INFO | platform_changeset: 8631cff3e8183a5cc08e7c5b3478c8c21b7d4a55
03:17:19 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound
03:17:19 INFO - mozversion INFO | platform_version: 44.0a1
03:17:19 INFO - 2015-10-26 03:17:19,161 DEBUG : using testdate: 1445854639
03:17:19 INFO - 2015-10-26 03:17:19,161 DEBUG : actual date: 1445854639
03:17:19 INFO - 2015-10-26 03:17:19,256 INFO : starting webserver on 'localhost:49278'
03:17:19 INFO - 2015-10-26 03:17:19,257 INFO : Starting test suite T-W864-IX-123
03:17:19 INFO - 2015-10-26 03:17:19,257 INFO : Starting test dromaeo_css
03:17:19 INFO - 2015-10-26 03:17:19,257 DEBUG : operating with platform_type : w8_
03:17:19 INFO - 2015-10-26 03:17:19,259 INFO : Initialising browser for dromaeo_css test...
03:17:19 INFO - 2015-10-26 03:17:19,355 DEBUG : command line: C:\slave\test-pgo\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpjdqffe\profile http://localhost:49278/getInfo.html
03:17:27 INFO - 2015-10-26 03:17:27,788 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200
03:17:27 INFO - 2015-10-26 03:17:27,788 DEBUG : BROWSER_OUTPUT: colorDepth:24
03:17:27 INFO - 2015-10-26 03:17:27,788 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674
03:17:27 INFO - 2015-10-26 03:17:27,788 DEBUG : BROWSER_OUTPUT: __metrics
03:17:27 INFO - 2015-10-26 03:17:27,930 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver]
03:17:29 INFO - 2015-10-26 03:17:29,144 DEBUG : BROWSER_OUTPUT: console.error:
03:17:29 INFO - 2015-10-26 03:17:29,144 DEBUG : BROWSER_OUTPUT: Message: [Exception... "Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [mozIStorageAsyncStatement.executeAsync]" nsresult: "0x80040111 (NS_ERROR_NOT_AVAILABLE)" location: "JS frame :: resource://gre/modules/Sqlite.jsm :: ConnectionData.prototype<._executeStatement :: line 758" data: no]
03:17:29 INFO - 2015-10-26 03:17:29,144 DEBUG : BROWSER_OUTPUT: Stack:
03:17:29 INFO - 2015-10-26 03:17:29,144 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<._executeStatement@resource://gre/modules/Sqlite.jsm:758:19
03:17:29 INFO - 2015-10-26 03:17:29,144 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached/<@resource://gre/modules/Sqlite.jsm:493:9
03:17:29 INFO - 2015-10-26 03:17:29,144 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached@resource://gre/modules/Sqlite.jsm:491:1
03:17:29 INFO - 2015-10-26 03:17:29,144 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeBeforeShutdown/loggedDb<.executeCached.value<@resource://gre/modules/Sqlite.jsm:368:51
03:17:29 INFO - 2015-10-26 03:17:29,144 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40
03:17:29 INFO - 2015-10-26 03:17:29,144 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3
03:17:29 INFO - 2015-10-26 03:17:29,144 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14
03:17:29 INFO - 2015-10-26 03:17:29,144 DEBUG : BROWSER_OUTPUT: transaction@resource://gre/modules/Bookmarks.jsm:783:15
03:17:29 INFO - 2015-10-26 03:17:29,144 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40
03:17:29 INFO - 2015-10-26 03:17:29,144 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3
03:17:29 INFO - 2015-10-26 03:17:29,144 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14
03:17:29 INFO - 2015-10-26 03:17:29,144 DEBUG : BROWSER_OUTPUT: Task_spawn@resource://gre/modules/Task.jsm:164:12
03:17:29 INFO - 2015-10-26 03:17:29,144 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23
03:36:04 INFO - 2015-10-26 03:36:04,651 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7
03:36:04 INFO - 2015-10-26 03:36:04,651 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11
03:36:04 INFO - 2015-10-26 03:36:04,651 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7
03:36:04 INFO - 2015-10-26 03:36:04,651 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7
03:36:04 INFO - 2015-10-26 03:36:04,651 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13
03:36:04 INFO - 2015-10-26 03:36:04,651 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9
03:36:04 INFO - 2015-10-26 03:36:04,651 DEBUG : BROWSER_OUTPUT:
03:36:05 INFO - 2015-10-26 03:36:05,359 INFO : Browser initialized.
03:36:05 INFO - 2015-10-26 03:36:05,359 INFO : Running cycle 1/1 for kraken test...
03:36:05 INFO - 2015-10-26 03:36:05,359 DEBUG : command line: C:\slave\test-pgo\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpq0i7q3\profile -tp file:\C:\slave\test-pgo\build\tests\talos\talos\tests\kraken\kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1
03:36:16 INFO - 2015-10-26 03:36:16,720 DEBUG : BROWSER_OUTPUT: RSS: Main: 188542976
03:36:16 INFO - 2015-10-26 03:36:16,720 DEBUG : BROWSER_OUTPUT:
03:36:19 INFO - 2015-10-26 03:36:19,288 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection)
03:36:19 INFO - 2015-10-26 03:36:19,874 DEBUG : BROWSER_OUTPUT: RSS: Main: 225857536
03:36:19 INFO - 2015-10-26 03:36:19,874 DEBUG : BROWSER_OUTPUT:
03:36:22 INFO - 2015-10-26 03:36:22,354 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft)
03:36:22 INFO - 2015-10-26 03:36:22,921 DEBUG : BROWSER_OUTPUT: RSS: Main: 226074624
03:36:22 INFO - 2015-10-26 03:36:22,921 DEBUG : BROWSER_OUTPUT:
03:36:25 INFO - 2015-10-26 03:36:25,522 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft)
03:36:26 INFO - 2015-10-26 03:36:26,092 DEBUG : BROWSER_OUTPUT: RSS: Main: 213438464
03:36:26 INFO - 2015-10-26 03:36:26,092 DEBUG : BROWSER_OUTPUT:
03:36:28 INFO - 2015-10-26 03:36:28,006 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator)
03:36:28 INFO - 2015-10-26 03:36:28,572 DEBUG : BROWSER_OUTPUT: RSS: Main: 214487040
03:36:28 INFO - 2015-10-26 03:36:28,572 DEBUG : BROWSER_OUTPUT:
03:36:30 INFO - 2015-10-26 03:36:30,638 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur)
03:36:31 INFO - 2015-10-26 03:36:31,200 DEBUG : BROWSER_OUTPUT: RSS: Main: 211177472
03:36:31 INFO - 2015-10-26 03:36:31,200 DEBUG : BROWSER_OUTPUT:
03:36:34 INFO - 2015-10-26 03:36:34,177 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom)
03:36:34 INFO - 2015-10-26 03:36:34,750 DEBUG : BROWSER_OUTPUT: RSS: Main: 203317248
03:36:34 INFO - 2015-10-26 03:36:34,750 DEBUG : BROWSER_OUTPUT:
03:36:38 INFO - 2015-10-26 03:36:38,220 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate)
03:36:38 INFO - 2015-10-26 03:36:38,796 DEBUG : BROWSER_OUTPUT: RSS: Main: 203288576
03:36:38 INFO - 2015-10-26 03:36:38,796 DEBUG : BROWSER_OUTPUT:
03:36:41 INFO - 2015-10-26 03:36:41,573 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial)
03:36:42 INFO - 2015-10-26 03:36:42,148 DEBUG : BROWSER_OUTPUT: RSS: Main: 202674176
03:36:42 INFO - 2015-10-26 03:36:42,148 DEBUG : BROWSER_OUTPUT:
03:36:43 INFO - 2015-10-26 03:36:43,872 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox)
03:36:44 INFO - 2015-10-26 03:36:44,434 DEBUG : BROWSER_OUTPUT: RSS: Main: 228130816
03:36:44 INFO - 2015-10-26 03:36:44,434 DEBUG : BROWSER_OUTPUT:
03:36:46 INFO - 2015-10-26 03:36:46,171 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes)
03:36:46 INFO - 2015-10-26 03:36:46,746 DEBUG : BROWSER_OUTPUT: RSS: Main: 232865792
03:36:46 INFO - 2015-10-26 03:36:46,746 DEBUG : BROWSER_OUTPUT:
03:36:48 INFO - 2015-10-26 03:36:48,869 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm)
03:36:49 INFO - 2015-10-26 03:36:49,446 DEBUG : BROWSER_OUTPUT: RSS: Main: 220155904
03:36:49 INFO - 2015-10-26 03:36:49,447 DEBUG : BROWSER_OUTPUT:
03:36:51 INFO - 2015-10-26 03:36:51,809 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2)
03:36:52 INFO - 2015-10-26 03:36:52,390 DEBUG : BROWSER_OUTPUT: RSS: Main: 223404032
03:36:52 INFO - 2015-10-26 03:36:52,390 DEBUG : BROWSER_OUTPUT:
03:36:54 INFO - 2015-10-26 03:36:54,990 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative)
03:36:55 INFO - 2015-10-26 03:36:55,562 DEBUG : BROWSER_OUTPUT: RSS: Main: 223903744
03:36:55 INFO - 2015-10-26 03:36:55,562 DEBUG : BROWSER_OUTPUT:
03:36:57 INFO - 2015-10-26 03:36:57,236 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar)
03:36:57 INFO - 2015-10-26 03:36:57,487 DEBUG : BROWSER_OUTPUT: RSS: Main: 278818816
03:36:57 INFO - 2015-10-26 03:36:57,487 DEBUG : BROWSER_OUTPUT:
03:36:57 INFO - 2015-10-26 03:36:57,487 DEBUG : BROWSER_OUTPUT: __start_tp_report
03:36:57 INFO - 2015-10-26 03:36:57,487 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load
03:36:57 INFO - 2015-10-26 03:36:57,487 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details
03:36:57 INFO - 2015-10-26 03:36:57,487 DEBUG : BROWSER_OUTPUT: |i|pagename|runs|
03:36:57 INFO - 2015-10-26 03:36:57,487 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;110;104;110;109;109;111;110;103;109
03:36:57 INFO - 2015-10-26 03:36:57,487 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;129;120;137;153;123;125;127;125;145;122
03:36:57 INFO - 2015-10-26 03:36:57,487 DEBUG : BROWSER_OUTPUT: |2;audio-dft;140;140;141;150;141;141;140;142;140;140
03:36:57 INFO - 2015-10-26 03:36:57,487 DEBUG : BROWSER_OUTPUT: |3;audio-fft;69;70;70;94;76;67;70;71;102;66
03:36:57 INFO - 2015-10-26 03:36:57,487 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;86;86;106;86;86;86;113;87;86;112
03:36:57 INFO - 2015-10-26 03:36:57,487 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;112;109;111;109;111;110;111;110;110
03:36:57 INFO - 2015-10-26 03:36:57,487 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;131;132;131;132;131;131;132;133;132;132
03:36:57 INFO - 2015-10-26 03:36:57,489 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;96;96;99;96;100;97
03:36:57 INFO - 2015-10-26 03:36:57,489 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;81;73;73;74;74;74;72;83;74;71
03:36:57 INFO - 2015-10-26 03:36:57,489 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;64;63;63;63;63;63;63;63;63
03:36:57 INFO - 2015-10-26 03:36:57,489 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;86;87;88;88;87;87;86;88;88
03:36:57 INFO - 2015-10-26 03:36:57,489 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;115;120;115;111;120;122;114;118;119;114
03:36:57 INFO - 2015-10-26 03:36:57,489 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;153;147;153;153;154;144;155;155;154;145
03:36:57 INFO - 2015-10-26 03:36:57,489 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;68;68;70;67;69;68;68;67;67
03:36:57 INFO - 2015-10-26 03:36:57,489 DEBUG : BROWSER_OUTPUT: __end_tp_report
03:36:57 INFO - 2015-10-26 03:36:57,489 DEBUG : BROWSER_OUTPUT: __start_cc_report
03:36:57 INFO - 2015-10-26 03:36:57,489 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,929
03:36:57 INFO - 2015-10-26 03:36:57,490 DEBUG : BROWSER_OUTPUT: __end_cc_report
03:36:57 INFO - 2015-10-26 03:36:57,490 DEBUG : BROWSER_OUTPUT: __startTimestamp1445855817486__endTimestamp
03:36:57 INFO - 2015-10-26 03:36:57,490 DEBUG : BROWSER_OUTPUT:
03:36:57 INFO - 2015-10-26 03:36:57,490 DEBUG : BROWSER_OUTPUT: ------- Summary: start -------
03:36:57 INFO - 2015-10-26 03:36:57,490 DEBUG : BROWSER_OUTPUT: Number of tests: 14
03:36:57 INFO - 2015-10-26 03:36:57,490 DEBUG : BROWSER_OUTPUT:
03:36:57 INFO - 2015-10-26 03:36:57,490 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.40 Median:109.50 stddev:2.67 (2.4%) stddev-sans-first:2.83
03:36:57 INFO - 2015-10-26 03:36:57,490 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 104.0 110.0 109.0 109.0 111.0 110.0 103.0 109.0
03:36:57 INFO - 2015-10-26 03:36:57,492 DEBUG : BROWSER_OUTPUT:
03:36:57 INFO - 2015-10-26 03:36:57,492 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:130.60 Median:128.00 stddev:10.92 (8.5%) stddev-sans-first:11.56
03:36:57 INFO - 2015-10-26 03:36:57,492 DEBUG : BROWSER_OUTPUT: Values: 129.0 120.0 137.0 153.0 123.0 125.0 127.0 125.0 145.0 122.0
03:36:57 INFO - 2015-10-26 03:36:57,492 DEBUG : BROWSER_OUTPUT:
03:36:57 INFO - 2015-10-26 03:36:57,492 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:141.50 Median:141.00 stddev:3.06 (2.2%) stddev-sans-first:3.20
03:36:57 INFO - 2015-10-26 03:36:57,492 DEBUG : BROWSER_OUTPUT: Values: 140.0 140.0 141.0 150.0 141.0 141.0 140.0 142.0 140.0 140.0
03:36:57 INFO - 2015-10-26 03:36:57,492 DEBUG : BROWSER_OUTPUT:
03:36:57 INFO - 2015-10-26 03:36:57,493 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:75.50 Median:70.00 stddev:12.29 (17.6%) stddev-sans-first:12.81
03:36:57 INFO - 2015-10-26 03:36:57,493 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 70.0 94.0 76.0 67.0 70.0 71.0 102.0 66.0
03:36:57 INFO - 2015-10-26 03:36:57,493 DEBUG : BROWSER_OUTPUT:
03:36:57 INFO - 2015-10-26 03:36:57,493 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:93.40 Median:86.00 stddev:11.82 (13.7%) stddev-sans-first:12.23
03:36:57 INFO - 2015-10-26 03:36:57,493 DEBUG : BROWSER_OUTPUT: Values: 86.0 86.0 106.0 86.0 86.0 86.0 113.0 87.0 86.0 112.0
03:36:57 INFO - 2015-10-26 03:36:57,493 DEBUG : BROWSER_OUTPUT:
03:36:57 INFO - 2015-10-26 03:36:57,493 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.30 Median:110.50 stddev:0.95 (0.9%) stddev-sans-first:1.00
03:36:57 INFO - 2015-10-26 03:36:57,493 DEBUG : BROWSER_OUTPUT: Values: 110.0 112.0 109.0 111.0 109.0 111.0 110.0 111.0 110.0 110.0
03:36:57 INFO - 2015-10-26 03:36:57,493 DEBUG : BROWSER_OUTPUT:
03:36:57 INFO - 2015-10-26 03:36:57,493 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:131.70 Median:132.00 stddev:0.67 (0.5%) stddev-sans-first:0.67
03:36:57 INFO - 2015-10-26 03:36:57,493 DEBUG : BROWSER_OUTPUT: Values: 131.0 132.0 131.0 132.0 131.0 131.0 132.0 133.0 132.0 132.0
03:36:57 INFO - 2015-10-26 03:36:57,493 DEBUG : BROWSER_OUTPUT:
03:36:57 INFO - 2015-10-26 03:36:57,493 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.80 Median:96.00 stddev:1.48 (1.5%) stddev-sans-first:1.54
03:36:57 INFO - 2015-10-26 03:36:57,493 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 96.0 96.0 99.0 96.0 100.0 97.0
03:36:57 INFO - 2015-10-26 03:36:57,493 DEBUG : BROWSER_OUTPUT:
03:36:57 INFO - 2015-10-26 03:36:57,493 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.90 Median:74.00 stddev:3.90 (5.3%) stddev-sans-first:3.46
03:36:57 INFO - 2015-10-26 03:36:57,494 DEBUG : BROWSER_OUTPUT: Values: 81.0 73.0 73.0 74.0 74.0 74.0 72.0 83.0 74.0 71.0
03:36:57 INFO - 2015-10-26 03:36:57,494 DEBUG : BROWSER_OUTPUT:
03:36:57 INFO - 2015-10-26 03:36:57,494 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.10 Median:63.00 stddev:0.32 (0.5%) stddev-sans-first:0.33
03:36:57 INFO - 2015-10-26 03:36:57,494 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 63.0 63.0 63.0 63.0 63.0 63.0 63.0 63.0
03:36:57 INFO - 2015-10-26 03:36:57,494 DEBUG : BROWSER_OUTPUT:
03:36:57 INFO - 2015-10-26 03:36:57,496 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:87.50 stddev:0.88 (1.0%) stddev-sans-first:0.83
03:36:57 INFO - 2015-10-26 03:36:57,496 DEBUG : BROWSER_OUTPUT: Values: 86.0 86.0 87.0 88.0 88.0 87.0 87.0 86.0 88.0 88.0
03:36:57 INFO - 2015-10-26 03:36:57,496 DEBUG : BROWSER_OUTPUT:
03:36:57 INFO - 2015-10-26 03:36:57,496 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:116.80 Median:118.50 stddev:3.49 (2.9%) stddev-sans-first:3.64
03:36:57 INFO - 2015-10-26 03:36:57,496 DEBUG : BROWSER_OUTPUT: Values: 115.0 120.0 115.0 111.0 120.0 122.0 114.0 118.0 119.0 114.0
03:36:57 INFO - 2015-10-26 03:36:57,496 DEBUG : BROWSER_OUTPUT:
03:36:57 INFO - 2015-10-26 03:36:57,496 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.30 Median:153.50 stddev:4.24 (2.8%) stddev-sans-first:4.46
03:36:57 INFO - 2015-10-26 03:36:57,497 DEBUG : BROWSER_OUTPUT: Values: 153.0 147.0 153.0 153.0 154.0 144.0 155.0 155.0 154.0 145.0
03:36:57 INFO - 2015-10-26 03:36:57,497 DEBUG : BROWSER_OUTPUT:
03:36:57 INFO - 2015-10-26 03:36:57,497 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:0.99 (1.5%) stddev-sans-first:1.00
03:36:57 INFO - 2015-10-26 03:36:57,499 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 68.0 70.0 67.0 69.0 68.0 68.0 67.0 67.0
03:36:57 INFO - 2015-10-26 03:36:57,499 DEBUG : BROWSER_OUTPUT: -------- Summary: end --------
03:36:57 INFO - 2015-10-26 03:36:57,499 DEBUG : BROWSER_OUTPUT:
03:36:58 INFO - 2015-10-26 03:36:58,151 INFO : Browser exited with error code: 0
03:36:59 INFO - 2015-10-26 03:36:59,092 INFO : Completed test kraken (00:01:00)
03:36:59 INFO - 2015-10-26 03:36:59,092 INFO : Starting test v8_7
03:36:59 INFO - 2015-10-26 03:36:59,092 DEBUG : operating with platform_type : w8_
03:36:59 INFO - 2015-10-26 03:36:59,092 INFO : Initialising browser for v8_7 test...
03:36:59 INFO - 2015-10-26 03:36:59,114 DEBUG : command line: C:\slave\test-pgo\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmp3dbqmb\profile http://localhost:49278/getInfo.html
03:37:04 INFO - 2015-10-26 03:37:04,207 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200
03:37:04 INFO - 2015-10-26 03:37:04,207 DEBUG : BROWSER_OUTPUT: colorDepth:24
03:37:04 INFO - 2015-10-26 03:37:04,207 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674
03:37:04 INFO - 2015-10-26 03:37:04,207 DEBUG : BROWSER_OUTPUT: __metrics
03:37:04 INFO - 2015-10-26 03:37:04,448 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver]
03:37:05 INFO - 2015-10-26 03:37:05,334 DEBUG : BROWSER_OUTPUT: console.error:
03:37:05 INFO - 2015-10-26 03:37:05,335 DEBUG : BROWSER_OUTPUT: Message: [Exception... "Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [mozIStorageAsyncStatement.executeAsync]" nsresult: "0x80040111 (NS_ERROR_NOT_AVAILABLE)" location: "JS frame :: resource://gre/modules/Sqlite.jsm :: ConnectionData.prototype<._executeStatement :: line 758" data: no]
03:37:05 INFO - 2015-10-26 03:37:05,335 DEBUG : BROWSER_OUTPUT: Stack:
03:37:05 INFO - 2015-10-26 03:37:05,335 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<._executeStatement@resource://gre/modules/Sqlite.jsm:758:19
03:37:05 INFO - 2015-10-26 03:37:05,335 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached/<@resource://gre/modules/Sqlite.jsm:493:9
03:37:05 INFO - 2015-10-26 03:37:05,335 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached@resource://gre/modules/Sqlite.jsm:491:1
03:37:05 INFO - 2015-10-26 03:37:05,335 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeBeforeShutdown/loggedDb<.executeCached.value<@resource://gre/modules/Sqlite.jsm:368:51
03:37:05 INFO - 2015-10-26 03:37:05,335 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40
03:37:05 INFO - 2015-10-26 03:37:05,335 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3
03:37:05 INFO - 2015-10-26 03:37:05,335 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14
03:37:05 INFO - 2015-10-26 03:37:05,335 DEBUG : BROWSER_OUTPUT: setAncestorsLastModified<@resource://gre/modules/Bookmarks.jsm:1347:9
03:37:05 INFO - 2015-10-26 03:37:05,335 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40
03:37:05 INFO - 2015-10-26 03:37:05,335 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3
03:37:05 INFO - 2015-10-26 03:37:05,335 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14
03:37:05 INFO - 2015-10-26 03:37:05,336 DEBUG : BROWSER_OUTPUT: transaction@resource://gre/modules/Bookmarks.jsm:808:13
03:37:05 INFO - 2015-10-26 03:37:05,336 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40
03:37:05 INFO - 2015-10-26 03:37:05,336 DEBUG : BROWSER_OUTPUT: Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:934:23
03:37:05 INFO - 2015-10-26 03:37:05,336 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7
03:37:05 INFO - 2015-10-26 03:37:05,336 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11
03:37:05 INFO - 2015-10-26 03:37:05,336 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7
03:37:05 INFO - 2015-10-26 03:37:05,336 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7
03:37:05 INFO - 2015-10-26 03:37:05,336 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13
03:37:05 INFO - 2015-10-26 03:37:05,336 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9
03:37:05 INFO - 2015-10-26 03:37:05,336 DEBUG : BROWSER_OUTPUT:
03:37:06 INFO - 2015-10-26 03:37:06,036 INFO : Browser initialized.
03:37:06 INFO - 2015-10-26 03:37:06,036 INFO : Running cycle 1/1 for v8_7 test...
03:37:06 INFO - 2015-10-26 03:37:06,036 DEBUG : command line: C:\slave\test-pgo\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmp3dbqmb\profile -tp file:\C:\slave\test-pgo\build\tests\talos\talos\tests\v8_7\v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1
03:37:17 INFO - 2015-10-26 03:37:17,394 DEBUG : BROWSER_OUTPUT: RSS: Main: 190672896
03:37:17 INFO - 2015-10-26 03:37:17,394 DEBUG : BROWSER_OUTPUT:
03:37:39 INFO - 2015-10-26 03:37:39,167 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/v8_7/run.html (next: http://localhost:49278/tests/v8_7/run.html)
03:37:39 INFO - 2015-10-26 03:37:39,417 DEBUG : BROWSER_OUTPUT: RSS: Main: 683274240
03:37:39 INFO - 2015-10-26 03:37:39,417 DEBUG : BROWSER_OUTPUT:
03:37:39 INFO - 2015-10-26 03:37:39,417 DEBUG : BROWSER_OUTPUT: __start_tp_report
03:37:39 INFO - 2015-10-26 03:37:39,417 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load
03:37:39 INFO - 2015-10-26 03:37:39,417 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details
03:37:39 INFO - 2015-10-26 03:37:39,417 DEBUG : BROWSER_OUTPUT: |i|pagename|runs|
03:37:39 INFO - 2015-10-26 03:37:39,417 DEBUG : BROWSER_OUTPUT: |0;Richards;167.7570877369569
03:37:39 INFO - 2015-10-26 03:37:39,417 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;175.53098121818502
03:37:39 INFO - 2015-10-26 03:37:39,417 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.08744710860367
03:37:39 INFO - 2015-10-26 03:37:39,417 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5122.448979591837
03:37:39 INFO - 2015-10-26 03:37:39,417 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1564.0625
03:37:39 INFO - 2015-10-26 03:37:39,417 DEBUG : BROWSER_OUTPUT: |5;Earley;666.2225183211193
03:37:39 INFO - 2015-10-26 03:37:39,417 DEBUG : BROWSER_OUTPUT: |6;Boyer;12575
03:37:39 INFO - 2015-10-26 03:37:39,418 DEBUG : BROWSER_OUTPUT: |7;RegExp;30058.823529411766
03:37:39 INFO - 2015-10-26 03:37:39,418 DEBUG : BROWSER_OUTPUT: |8;Splay;791.1617961511048
03:37:39 INFO - 2015-10-26 03:37:39,418 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4887.804878048781
03:37:39 INFO - 2015-10-26 03:37:39,418 DEBUG : BROWSER_OUTPUT: __end_tp_report
03:37:39 INFO - 2015-10-26 03:37:39,418 DEBUG : BROWSER_OUTPUT: __startTimestamp1445855859414__endTimestamp
03:37:39 INFO - 2015-10-26 03:37:39,418 DEBUG : BROWSER_OUTPUT:
03:37:39 INFO - 2015-10-26 03:37:39,418 DEBUG : BROWSER_OUTPUT: ------- Summary: start -------
03:37:39 INFO - 2015-10-26 03:37:39,418 DEBUG : BROWSER_OUTPUT: Number of tests: 10
03:37:39 INFO - 2015-10-26 03:37:39,418 DEBUG : BROWSER_OUTPUT:
03:37:39 INFO - 2015-10-26 03:37:39,418 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.76 Median:167.76 stddev:0.00 (0.0%)
03:37:39 INFO - 2015-10-26 03:37:39,418 DEBUG : BROWSER_OUTPUT: Values: 167.8
03:37:39 INFO - 2015-10-26 03:37:39,418 DEBUG : BROWSER_OUTPUT:
03:37:39 INFO - 2015-10-26 03:37:39,418 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:175.53 Median:175.53 stddev:0.00 (0.0%)
03:37:39 INFO - 2015-10-26 03:37:39,418 DEBUG : BROWSER_OUTPUT: Values: 175.5
03:37:39 INFO - 2015-10-26 03:37:39,418 DEBUG : BROWSER_OUTPUT:
03:37:39 INFO - 2015-10-26 03:37:39,420 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.09 Median:282.09 stddev:0.00 (0.0%)
03:37:39 INFO - 2015-10-26 03:37:39,420 DEBUG : BROWSER_OUTPUT: Values: 282.1
03:37:39 INFO - 2015-10-26 03:37:39,420 DEBUG : BROWSER_OUTPUT:
03:37:39 INFO - 2015-10-26 03:37:39,420 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5122.45 Median:5122.45 stddev:0.00 (0.0%)
03:37:39 INFO - 2015-10-26 03:37:39,420 DEBUG : BROWSER_OUTPUT: Values: 5122.4
03:37:39 INFO - 2015-10-26 03:37:39,420 DEBUG : BROWSER_OUTPUT:
03:37:39 INFO - 2015-10-26 03:37:39,420 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1564.06 Median:1564.06 stddev:0.00 (0.0%)
03:37:39 INFO - 2015-10-26 03:37:39,420 DEBUG : BROWSER_OUTPUT: Values: 1564.1
03:37:39 INFO - 2015-10-26 03:37:39,420 DEBUG : BROWSER_OUTPUT:
03:37:39 INFO - 2015-10-26 03:37:39,420 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:666.22 Median:666.22 stddev:0.00 (0.0%)
03:37:39 INFO - 2015-10-26 03:37:39,420 DEBUG : BROWSER_OUTPUT: Values: 666.2
03:37:39 INFO - 2015-10-26 03:37:39,420 DEBUG : BROWSER_OUTPUT:
03:37:39 INFO - 2015-10-26 03:37:39,420 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12575.00 Median:12575.00 stddev:0.00 (0.0%)
03:37:39 INFO - 2015-10-26 03:37:39,420 DEBUG : BROWSER_OUTPUT: Values: 12575.0
03:37:39 INFO - 2015-10-26 03:37:39,420 DEBUG : BROWSER_OUTPUT:
03:37:39 INFO - 2015-10-26 03:37:39,421 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:30058.82 Median:30058.82 stddev:0.00 (0.0%)
03:37:39 INFO - 2015-10-26 03:37:39,421 DEBUG : BROWSER_OUTPUT: Values: 30058.8
03:37:39 INFO - 2015-10-26 03:37:39,421 DEBUG : BROWSER_OUTPUT:
03:37:39 INFO - 2015-10-26 03:37:39,421 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:791.16 Median:791.16 stddev:0.00 (0.0%)
03:37:39 INFO - 2015-10-26 03:37:39,421 DEBUG : BROWSER_OUTPUT: Values: 791.2
03:37:39 INFO - 2015-10-26 03:37:39,421 DEBUG : BROWSER_OUTPUT:
03:37:39 INFO - 2015-10-26 03:37:39,421 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4887.80 Median:4887.80 stddev:0.00 (0.0%)
03:37:39 INFO - 2015-10-26 03:37:39,421 DEBUG : BROWSER_OUTPUT: Values: 4887.8
03:37:39 INFO - 2015-10-26 03:37:39,421 DEBUG : BROWSER_OUTPUT: -------- Summary: end --------
03:37:39 INFO - 2015-10-26 03:37:39,421 DEBUG : BROWSER_OUTPUT:
03:37:40 INFO - 2015-10-26 03:37:40,098 INFO : Browser exited with error code: 0
03:37:40 INFO - 2015-10-26 03:37:40,836 INFO : Completed test v8_7 (00:00:41)
03:37:41 INFO - 2015-10-26 03:37:41,177 INFO : Completed test suite (00:20:21)
03:37:41 INFO - 2015-10-26 03:37:41,177 DEBUG : Working with test: dromaeo_css
03:37:41 INFO - 2015-10-26 03:37:41,177 DEBUG : Generating results file: dromaeo_css
03:37:41 INFO - 2015-10-26 03:37:41,178 DEBUG : Working with test: kraken
03:37:41 INFO - 2015-10-26 03:37:41,178 DEBUG : Generating results file: kraken
03:37:41 INFO - 2015-10-26 03:37:41,178 INFO : javascript benchmark
03:37:41 INFO - 2015-10-26 03:37:41,178 DEBUG : Working with test: v8_7
03:37:41 INFO - 2015-10-26 03:37:41,178 DEBUG : Generating results file: v8_7
03:37:41 INFO - 2015-10-26 03:37:41,178 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0
03:37:41 INFO - 2015-10-26 03:37:41,315 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,201,31]]
03:37:41 INFO - 2015-10-26 03:37:41,315 DEBUG : process_Request line: dromaeo_css 6890.40 graph.html#tests=[[72,201,31]]
03:37:41 INFO - 2015-10-26 03:37:41,315 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0
03:37:41 INFO - 2015-10-26 03:37:41,348 DEBUG : process_Request line: kraken 1449.30 graph.html#tests=[[232,201,31]]
03:37:41 INFO - 2015-10-26 03:37:41,348 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0
03:37:41 INFO - 2015-10-26 03:37:41,454 DEBUG : process_Request line: v8_7 19883.97 graph.html#tests=[[230,201,31]]
03:37:41 INFO - 2015-10-26 03:37:41,456 INFO : javascript benchmark
03:37:41 INFO - 2015-10-26 03:37:41,457 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [378.8030224283371, 386.54194779186673, 389.4061556126908, 389.89083056744124, 391.358172596941, 14352.011086021337, 15077.849221507782, 16366.918165409172, 18117.094145292747, 18190.181441835117, 17266.568335791613, 17449.563760905985, 17491.300347986064, 17596.472105836812, 17779.64440711185, 5376.059189641806, 5465.72671366432, 5479.424660410639, 5487.42382049885, 5498.5876059295515, 4155.480564929384, 4352.825886964533, 5408.026555220059, 6160.260768707762, 6242.0, 6063.757449702029, 6241.534593835432, 6250.281217659959, 6272.184615999914, 6287.497000239992, 6246.469050130744, 6274.592151510137, 6302.369763023661, 6311.053341998691, 6311.715972781213, 5416.889537644774, 5530.142827861688, 5544.63959842613, 5561.610687251894, 5621.128725047624, 22171.778282217132, 22567.77432225673, 22636.434089147737, 22995.42511437211, 23173.188938387077, 1954.7263383126374, 2000.0599718132455, 2062.9484262893397, 2254.9098036078703, 2419.7822196002267, 9794.118529332394, 9835.409875407428, 9900.405975641484, 10123.139533139618, 10213.79572408555, 1584.5642448326687, 1732.3850033238145, 1734.1762662735225, 1736.713442282022, 1776.5292197567655, 67132.6643366785, 69051.30948690549, 69350.65324673394, 69823.0, 69863.65068174677, 6795.7961261162245, 6848.075509806212, 6860.1081859358965, 6902.620355880475, 6950.443964482829, 8003.599820008976, 8103.635336409876, 8227.8354432911, 8238.217369349903, 8243.546604936786, 5627.493525582635, 5640.576956728261, 5647.491725744702, 5661.745221465044, 5690.374058853523, 6011.789587364421, 6056.394360563909, 6067.513459202523, 6109.969450152721, 6213.751449941951, 3202.1034110449114, 3220.7423406127455, 3231.6929891660257, 3233.757468189895, 3264.8857289995212, 1117.2570240789946, 1150.2121047082608, 1185.6502331812137, 1192.9105317101078, 1221.9327936963375, 460.59697764456104, 475.6028716022091, 479.27868557820955, 490.7668857292757, 502.8541722900318, 10101.292909496266, 11572.42137893102, 11698.415079246173, 11760.529578816751, 12008.819867701992, 508.8778693113626, 513.0508559165588, 516.3700285651499, 532.6191772882407, 534.1107056750544, 6353.841153971188, 6432.935670643327, 6445.291017988017, 6470.09418681385, 6579.83550411234, 524314.0, 553668.0, 559663.0, 586318.0, 612452.0, 45825.54174458213, 82181.0, 83023.48703242025, 84000.0, 86628.0, 567.5941701683316, 567.7984315567913, 572.8367415286623, 573.3435216676965, 574.3423779772138, 11016.50425730828, 11090.223684342342, 11156.274842135235, 11223.214374993671, 11228.326300421673, 35871.0, 35890.4616430759, 36002.27995440129, 36418.45372319364, 36558.26883462263, 48691.5130848687, 49689.503104968484, 49706.289650898114, 49821.50178498169, 50863.49136508587, 6704.899426508704, 6747.561408508432, 6765.864682706417, 6767.323267673391, 6783.321667833177, 12042.75914481723, 12341.668405209712, 12413.255204687748, 12478.937605311916, 12586.937065314614, 10806.945965270123, 10913.18151138652, 11157.44212789341, 11176.10591152722, 11207.495662695035, 10565.63020294286, 10734.14126869833, 10763.138948883914, 10776.784464310513, 10976.890231097907, 10767.784644306914, 10944.507497162806, 11185.217034807485, 11256.606018789304, 11280.435978201222, 6594.571352862049, 6636.900446493403, 6667.899981500378, 6676.132102826601, 6690.19717633887, 10753.354798712102, 10958.671324826808, 11100.5559777608, 11122.555097795997, 11212.383318917538], "dojo.html": [2871.0669032564415, 2880.135959212236, 2919.5766613840988, 2922.8684709188083, 2932.7947043706936, 5397.244385785988, 5458.344998600169, 5463.863403414916, 5479.04116779563, 5480.205370221315, 5408.648437851537, 5499.532539734118, 5505.174223866422, 5515.751791169397, 5533.889322213563, 4802.567768900798, 4890.5109489051165, 4896.094222568836, 4911.877203069934, 4971.05549945511, 4813.350197723297, 4844.249141383091, 4912.312276281324, 4917.065757506062, 4934.087193869128, 4834.492378300263, 4868.0, 4870.293807397925, 4875.098106850226, 4914.11545921734, 4835.637327200457, 4850.272459131159, 4851.466338702739, 4854.12625727369, 4899.853004409873, 4739.73931433771, 4797.472278049412, 4836.153673107192, 4842.975785121052, 4904.60763138948, 5079.5428411443145, 5331.093714068617, 5365.731713414352, 5372.91940620891, 5380.112281473552, 5688.0, 5713.0, 5716.3426205986425, 5721.485066344049, 5762.423757624246, 5618.0, 5630.690312032836, 5722.885542289131, 5747.109198074263, 5764.8847023059725, 5281.70950597717, 5359.249705041298, 5362.410134885159, 5367.946320536784, 5374.059539580597, 5911.0, 5911.940880591225, 5917.911231331534, 5928.851778705567, 5933.931892259348, 5493.121100623961, 5537.833864984057, 5624.85937851557, 5643.858903527444, 5648.915266271009, 5738.08190689496, 5752.395998420189, 5755.769769209185, 5770.13447982806, 5795.82612521625, 5690.687012214368, 5691.630044047124, 5694.487496125285, 5694.487496125369, 5731.971340143356, 5552.69460179694, 5611.466910643482, 5630.211770352154, 5653.858653533613, 5660.462256085665, 3632.2553876455263, 3667.339878821838, 3669.3945498992903, 3708.9072773180887, 3709.4435834625024, 3334.433146365075, 3338.5659864217496, 3344.247544302561, 3376.071580315433, 3377.8986630401128, 5416.864578385572, 5466.180072989084, 5561.77752889888, 5579.609427340048, 5590.832275031756, 5743.483086522149, 5784.1034639630925, 5811.970940145272, 5815.9709201453725, 5817.7963771267805, 5530.723463826793, 5534.335879694462, 5539.390667026624, 5541.5289700375115, 5548.5838562108, 4567.223571992769, 4588.541145885385, 4592.678512504092, 4656.301554766745, 4662.673612847136, 6018.668973206516, 6027.0, 6041.214642096499, 6043.758249669964, 6063.696815159225, 5728.112142617901, 5780.190773291826, 5802.361740208658, 5809.360970293349, 5815.982203114522, 5878.794242201502, 5903.2325797646035, 5934.881302374015, 5935.851603709942, 5939.851503712442, 5694.544436445157, 5723.8569035774435, 5742.59801813869, 5746.310442746897, 5754.0, 5765.94234057654, 5790.652560846363, 5805.970970145122, 5842.415758424124, 5843.503302219359, 5610.158476228598, 5624.803131890364, 5638.943610564006, 5723.31320241557, 5740.339860916049, 5584.972075139598, 5670.0, 5671.602987790815, 5684.459976302244, 5690.231818704422, 5577.581681373832, 5613.635113717595, 5618.831435056954, 5620.4098569649595, 5627.324721033502, 5484.2596249505805, 5605.131204663284, 5641.4922656959425, 5667.744951477276, 5676.772929082956, 5571.041713249392, 5593.888122237451, 5599.468050535193, 5605.327360716577, 5620.4660557247], "mootools.html": [1430.0633085329107, 1554.8756099512036, 1582.707199168154, 1699.2098674116532, 1735.6615459985308, 8494.150584941503, 8664.39349245553, 9247.398919070256, 9552.856707149389, 9609.126220387026, 9304.674336398228, 9611.66359177429, 9620.27847911406, 9632.903670963287, 9634.855477167848, 2338.228384633067, 2362.515684284726, 2364.2316247219637, 2367.562001029806, 2372.6559648850907, 2101.464126647703, 2134.8185404240658, 2332.9650055249185, 2364.858108513486, 2422.63660450932, 2335.32275640065, 2354.2466410748566, 2356.4108972756812, 2357.54027964547, 2360.6695062691238, 2117.6717608770664, 2344.871032093234, 2353.5645905507536, 2362.161432691387, 2365.44412063165, 2090.9790902090936, 2325.9767402326097, 2326.5230627721276, 2370.1467471710343, 2370.3363058343693, 9286.72139835806, 9352.485613291266, 9360.672376466859, 9364.531773411301, 9374.85937710935, 5348.037353276409, 5389.676619402849, 5406.216098665711, 5417.133258678593, 5422.620416570841, 3603.621619729917, 3639.5632524097277, 3672.2839046385966, 3681.6193927277272, 3707.9814600926825, 1099.3349023840542, 1118.6084870295413, 1130.9264897781618, 1132.8074227381364, 1167.130487786596, 14549.490767823076, 14771.778423323658, 14794.852051479455, 14795.40818367264, 14823.629409264855, 4624.421947256593, 4701.576858082789, 4718.787654555554, 4735.100330937111, 4768.3085952537385, 11821.285913542488, 11849.229800062969, 11874.940625296991, 11878.40607969598, 11916.106292028133, 5314.681119132864, 5365.141577347606, 5372.7313634318125, 5387.649802762808, 5395.62230643859, 4846.466888642247, 4852.951470485321, 4857.344258525124, 4897.191963326082, 4909.239067944402, 4000.2799496090984, 4052.169305292408, 4059.167870586523, 4085.4893138357706, 4089.3048181809163, 1237.4307818403636, 1238.6407941696987, 1245.1719606461784, 1248.581725122076, 1265.5507294910358, 1245.6636708088947, 1261.987380126187, 1277.9488820447264, 1279.4882047181202, 1308.4112149532748, 8372.916270837335, 8427.283680887193, 8431.536265505456, 8572.156986247863, 8865.468071915706, 470.97409642469995, 487.15964960442955, 495.3659316075429, 497.45031739927583, 500.0748615062106, 6228.439440450381, 6473.579217350952, 6507.414332710079, 6706.228783689938, 6732.158480189976, 11432.714182145346, 11496.0, 11626.76746465066, 11731.824022639667, 11791.469383877746, 11602.477888495037, 11641.825372619418, 11655.30068195911, 11685.88314116865, 11726.482055383522, 8382.83234335322, 8665.306775457948, 8672.479651220821, 8682.999999999874, 8685.305175585938, 8806.031336553102, 8818.5590720465, 8900.42147260426, 8945.73162805117, 8956.68651597191, 10473.633422830164, 10601.522931467947, 10613.0, 10662.8933710665, 10691.679249622524, 10856.0, 11041.282316649393, 11171.72070698239, 11215.158863085464, 11240.943795280971, 8274.917250827655, 8285.668573257002, 8295.875561866698, 8329.625166867385, 8577.699780507652, 9462.195713364166, 9538.713838584854, 9567.043295670377, 9567.521623918916, 9572.856407153758, 8383.790405239917, 8397.160283971554, 8450.408471406943, 8659.82680346377, 8691.087435819149, 8204.138565450541, 8278.0, 8293.626786794488, 8321.6671333146, 8485.236328730198, 8165.632546535301, 8201.056878459054, 8217.876731849146, 8231.135730748185, 8257.256846883809, 7397.852042959218, 7420.220876807857, 7424.331810137113, 7485.88771168422, 7525.88711169322, 6844.589324640538, 7062.752803651848, 7389.224131466119, 7431.665575049244, 7457.6271186441545], "ext.html": [563.9323281206256, 602.4487593851625, 607.9118527813467, 610.2067312493757, 626.6991843914918, 31057.0, 31479.68520314796, 31510.10939343641, 31606.36787264256, 39538.0, 42151.78924105375, 42426.0, 42533.36199957003, 42636.3604545932, 42877.57122428775, 8647.437916535437, 8652.567371631425, 8694.782630434227, 8781.42920710155, 8783.077776833436, 7901.288884000439, 8000.839983200332, 8745.912540874606, 10685.41230232337, 10839.295445796037, 10635.415052172128, 10766.0, 10769.515371808287, 10769.62306319279, 10809.567617295299, 7746.535207887545, 10479.580816767359, 10546.314489558154, 10556.894431055707, 10605.84091238632, 7695.499792513525, 10677.466126693635, 10746.838797418044, 10823.83764243537, 10835.566577336896, 39222.80388598067, 39806.60193398087, 39815.40276895849, 40106.59893401058, 40219.59780402217, 3367.44437167867, 3458.8097654628987, 3729.869454569104, 3952.486176797027, 3971.324874771296, 31094.378112437626, 31788.0, 31879.840600796848, 31942.361152777048, 31984.20039499008, 3207.23026473647, 3235.110344655215, 3298.5876765404323, 3305.5702758641464, 3338.7996720196866, 308618.0, 309091.0, 311682.0, 311849.99999999773, 313428.0, 47216.0, 57238.7138064307, 57910.0, 58060.70969645209, 58093.0, 46526.0, 58156.41843581595, 59259.0, 59290.40709592935, 60155.39844601498, 15336.539903802905, 15410.53599908007, 15473.613159671098, 15482.22588870552, 15499.845001550066, 11607.709807254718, 11644.592439264585, 11745.17783755146, 11751.353675547927, 11781.941090294666, 18554.474649816493, 18556.81443185578, 18630.293094485973, 18690.81309186918, 18716.53208669767, 7796.727114550963, 7942.046954365514, 7995.520268783892, 8005.519668819889, 8014.879776803353, 967.4678926590348, 967.8755132484271, 975.0054943957266, 986.40815510693, 1132.0999805154922, 28557.57163642547, 29195.56206656902, 29343.706562934523, 30016.0, 30194.698053019627, 1037.662759603132, 1039.4646756920192, 1072.7639919217759, 1142.8742240511747, 1206.6500714792787, 14979.325930333162, 15832.28754706041, 15862.365505379656, 15880.285387157606, 16158.192090395669, 434652.0, 435981.0, 440062.0, 441149.0, 441222.0, 52203.47796522062, 52481.7375913118, 52526.21210681843, 53088.73455632697, 53096.0, 1298.266479439114, 1301.7136230029378, 1310.233513394675, 1317.4203350525738, 1414.731201071793, 29839.403211936075, 30076.0, 30186.84906575453, 30291.545626815176, 30525.694743053173, 45699.77150114361, 45905.31142032806, 46138.0, 46361.76819115883, 46390.30414543717, 319441.0, 376938.0, 377089.0, 378158.0, 378445.0, 26898.731012690405, 31456.842715786275, 31547.211319716273, 31892.202694932814, 31973.20066998344, 40112.1977560453, 40634.0, 41320.586794131676, 43044.13911721811, 43529.78235108931, 36694.753465871, 37139.81430092832, 37215.255694886495, 37314.8134259327, 37533.81233093817, 28286.0, 36208.108509479105, 38376.0, 38933.0, 39497.407538886364, 36306.474266378056, 36910.0, 36923.63076369202, 36975.63024369722, 36985.63014369822, 31580.0, 33405.66594334123, 33832.323353533284, 33904.491432628034, 33938.49092263568, 25353.366165846, 25538.361540961625, 25556.0, 25670.358241044123, 25905.74094259033], "prototype.html": [357.5637721979185, 362.6319285924787, 364.6754388594152, 370.9054191181248, 373.8168297534209, 5881.647101173927, 5919.73361198746, 5921.20063791388, 5939.910901336478, 5943.524518038557, 5741.569382296334, 5796.07262837946, 5830.0380437227805, 5831.504322132613, 5890.911636325459, 4498.190325741365, 4498.482674492426, 4543.727376357429, 4553.430821147356, 4562.771861406933, 4504.684672072956, 4568.406107206059, 4571.7942692578745, 4573.885652858688, 4578.336141259515, 4393.670474714393, 4442.97778511107, 4484.730916145042, 4494.325851122341, 4534.047849951514, 4469.687121901468, 4505.121501307246, 4526.230540808054, 4526.6831321807485, 4536.342230376594, 3988.3618621020496, 4044.090079732066, 4044.1911617676583, 4048.7773172475504, 4052.918941621151, 5686.800961966353, 5687.971560142214, 5690.118031705092, 5695.1741997410145, 5698.544116470673, 5106.106431374495, 5167.199084141964, 5174.120399532088, 5183.170692689189, 5188.688678679291, 6072.210612620331, 6080.543959203077, 6086.969565152191, 6090.33006369299, 6090.48230900374, 4287.356896465555, 4309.5690430956965, 4313.784310784448, 4314.050908800059, 4314.460692413449, 6247.0, 6315.810525684236, 6372.553921225516, 6396.200474940632, 6410.61536307823, 4395.956040439619, 4409.867703968886, 4434.224010798098, 4435.290353543418, 4435.401220835146, 4450.755208463565, 4513.210188217049, 4513.932291015637, 4515.751633660115, 4524.7511386873375, 5072.365954255718, 5087.592992560586, 5121.001404726043, 5124.436312005751, 5128.205128205134, 5974.701264936823, 6105.603135796159, 6111.236095488064, 6122.816315510542, 6196.969015154896, 1627.4385337058695, 1644.4162322375623, 1647.6457561624309, 1650.9009459432473, 1651.7026935151548, 1107.0534692837507, 1114.409363037575, 1117.3519358771894, 1123.7977164110375, 1125.3641692443744, 5989.041753319448, 6022.156898034279, 6051.485623721945, 6060.696965151725, 6070.119832624245, 6355.650439225887, 6390.137331460286, 6399.55203135776, 6408.871822563616, 6410.455111315498, 5912.586118971631, 5987.5808693391045, 5988.760449582055, 6062.9090563641585, 6066.059760737093, 3493.94759078614, 3511.877084302037, 3521.7710848794745, 3529.3647143514413, 3530.064532898784, 6662.001399580204, 6663.333666633298, 6664.600123992576, 6669.399754022064, 6683.699233534406, 6309.716062777186, 6433.292337842833, 6441.420272175433, 6464.353564643498, 6467.256265529524, 6643.368879956396, 6731.562448440835, 6731.596104233664, 6737.595744255164, 6738.393544581011, 6412.102305677302, 6426.485881129405, 6430.228372595318, 6434.967825160844, 6438.3883531064475, 6211.09939058843, 6282.685865706605, 6286.654234017173, 6301.6219026858535, 6315.621062736251, 6667.399934005963, 6673.265940746611, 6684.465242780663, 6688.598684078971, 6691.5650482718465, 4478.596926276651, 4479.731216127043, 4508.346289787897, 4509.143262780192, 4520.728756274634, 6293.150424692791, 6332.620042797447, 6364.809055728336, 6382.170317858649, 6391.840203994751, 6224.533160013108, 6227.252729672468, 6253.78111766086, 6261.217347831521, 6267.843303917439, 6187.0, 6194.690265486617, 6195.411435913581, 6196.1015652731, 6196.597221180609, 6011.699415029144, 6120.816375508742, 6121.32665406796, 6127.417895299939, 6128.111423843607, 6228.719707613078, 6229.719662615284, 6230.096635987847, 6231.065340199007, 6236.438720515175, 6179.443850053517, 6190.81427557174, 6220.066989951543, 6229.875402491834, 6232.594881332699], "yui.html": [753.4462170304824, 759.255929189394, 761.8171638806684, 762.5958242131669, 811.3995643224013, 14812.407503699838, 14965.700685986274, 14995.400183992655, 14995.850041499569, 15052.548423547298, 12590.181638193511, 12710.300933448656, 12773.169743966635, 12787.552435664753, 12793.232406055644, 600.4865839707053, 606.457220787395, 743.7731491894983, 750.680960591749, 755.101429299135, 737.634870738985, 746.4700062955309, 749.052448652455, 749.2170681637674, 749.7713197474768, 766.390719378093, 772.1043589436255, 775.1899265267781, 776.7553220735479, 776.8019155115437, 624.8437890527368, 631.7630888416844, 767.8349154931716, 769.926856948589, 774.8915151878741, 562.5696342298145, 562.8874225154985, 564.4017341617898, 566.0518631292609, 569.3793764796351, 13077.869221307761, 13144.145630533985, 13163.73672526544, 13170.736585268336, 13183.0, 9921.85117223235, 9936.70189894297, 9985.151262142726, 10075.748106297327, 10254.333468324536, 9787.510624468749, 9830.803383932353, 10132.692384092841, 10236.692899213036, 10356.119729822974, 3217.3082787200865, 3241.7406607471344, 3250.0, 3261.6086069671555, 3307.933841323184, 41437.0, 42133.15733685309, 45397.0, 45784.0, 45870.31194532085, 7191.568505889663, 7237.674304656303, 7272.0, 7340.302671246223, 7401.888971665429, 10666.73333166677, 10681.359118452763, 10733.0, 10735.83896241557, 10747.978942000498, 6711.0, 6724.798256052326, 6823.69293381799, 6836.658167091725, 6850.212225594021, 4296.892577685583, 4362.065361298897, 4373.1488659629895, 4387.583179597933, 4394.846180383671, 2774.667039955178, 2792.6090347350982, 2832.730890565393, 2833.688294287627, 2840.7585355244623, 466.9859904202879, 490.4947903659237, 491.67058071091736, 549.5795716277051, 564.3453593831136, 741.695904679079, 771.8340556780207, 782.6165179062332, 792.809725665836, 793.6150966781106, 9128.863067053999, 9206.76983075415, 9342.906570934203, 9369.812603747887, 9438.197753191056, 537.1995726367684, 703.2967032967033, 752.9134149572869, 802.9116797152309, 816.2286639126088, 4059.414338673743, 4108.157827645386, 4891.3396691446915, 4949.82675606352, 4959.181735013754, 53662.463375366526, 54532.72733636307, 54668.72665636726, 54702.45297547053, 54761.1785823213, 48757.0, 48810.755946220044, 48822.511774881794, 49638.75180624146, 49701.751491243034, 41816.0, 41833.63389094233, 42022.15955680869, 42362.15275694469, 42616.14767704691, 9442.622295108118, 9446.433214007182, 9450.291228157777, 9452.243820494206, 9592.136707696342, 28994.855025724737, 29891.55162672605, 30186.396272074875, 30409.543856842607, 30716.53925191079, 41594.0, 41650.75047748572, 41829.37255941102, 41945.0, 42175.57824421839, 9042.68350607752, 9045.27637788962, 9095.772605684911, 9145.176934075966, 9250.0, 12879.034072444792, 12981.221126732426, 13032.0, 13138.0, 13180.736385272432, 12266.0, 12327.506899724269, 12455.564055258385, 12468.5012599495, 12471.376431178587, 12100.45547950362, 12111.091668124749, 12129.090318225992, 12265.816012759637, 12468.0, 11896.464659090534, 11964.102692297938, 12022.75954480888, 12033.699157521132, 12156.209846359958, 10097.596096156072, 10446.0, 10550.577976881146, 10802.89197108019, 10842.186835987175, 10525.631602893862, 10658.0, 10760.461976900968, 10817.1346292298, 10817.459127043774]}, "summary": {"suite": 6890.397111199467, "subtests": {"jquery.html": {"filtered": 7421.786789913237, "value": 7421.786789913237}, "dojo.html": {"filtered": 5234.4974163577945, "value": 5234.4974163577945}, "mootools.html": {"filtered": 5061.991461843488, "value": 5061.991461843488}, "ext.html": {"filtered": 19099.36324555769, "value": 19099.36324555769}, "prototype.html": {"filtered": 4729.098584979022, "value": 4729.098584979022}, "yui.html": {"filtered": 6024.591826066624, "value": 6024.591826066624}}}, "test_machine": {"platform": "x86_64", "osversion": "6.2.9200", "os": "win", "name": "T-W864-IX-123"}, "testrun": {"date": 1445854639, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a1", "id": "20151026023015", "branch": "B2G-Inbound", "revision": "8631cff3e8183a5cc08e7c5b3478c8c21b7d4a55"}}, {"talos_counters": {}, "results": {"audio-dft": [140.0, 140.0, 141.0, 150.0, 141.0, 141.0, 140.0, 142.0, 140.0, 140.0], "ai-astar": [109.0, 110.0, 104.0, 110.0, 109.0, 109.0, 111.0, 110.0, 103.0, 109.0], "imaging-gaussian-blur": [110.0, 112.0, 109.0, 111.0, 109.0, 111.0, 110.0, 111.0, 110.0, 110.0], "audio-beat-detection": [129.0, 120.0, 137.0, 153.0, 123.0, 125.0, 127.0, 125.0, 145.0, 122.0], "json-stringify-tinderbox": [63.0, 64.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0], "stanford-crypto-pbkdf2": [153.0, 147.0, 153.0, 153.0, 154.0, 144.0, 155.0, 155.0, 154.0, 145.0], "json-parse-financial": [81.0, 73.0, 73.0, 74.0, 74.0, 74.0, 72.0, 83.0, 74.0, 71.0], "stanford-crypto-sha256-iterative": [67.0, 68.0, 68.0, 70.0, 67.0, 69.0, 68.0, 68.0, 67.0, 67.0], "audio-fft": [69.0, 70.0, 70.0, 94.0, 76.0, 67.0, 70.0, 71.0, 102.0, 66.0], "imaging-darkroom": [131.0, 132.0, 131.0, 132.0, 131.0, 131.0, 132.0, 133.0, 132.0, 132.0], "stanford-crypto-ccm": [115.0, 120.0, 115.0, 111.0, 120.0, 122.0, 114.0, 118.0, 119.0, 114.0], "audio-oscillator": [86.0, 86.0, 106.0, 86.0, 86.0, 86.0, 113.0, 87.0, 86.0, 112.0], "stanford-crypto-aes": [86.0, 86.0, 87.0, 88.0, 88.0, 87.0, 87.0, 86.0, 88.0, 88.0], "imaging-desaturate": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 99.0, 96.0, 100.0, 97.0]}, "summary": {"suite": 1449.2999999999997, "subtests": {"audio-fft": {"filtered": 75.5, "value": 75.5}, "stanford-crypto-pbkdf2": {"filtered": 151.3, "value": 151.3}, "audio-beat-detection": {"filtered": 130.6, "value": 130.6}, "stanford-crypto-ccm": {"filtered": 116.8, "value": 116.8}, "imaging-darkroom": {"filtered": 131.7, "value": 131.7}, "json-parse-financial": {"filtered": 74.9, "value": 74.9}, "audio-oscillator": {"filtered": 93.4, "value": 93.4}, "ai-astar": {"filtered": 108.4, "value": 108.4}, "audio-dft": {"filtered": 141.5, "value": 141.5}, "stanford-crypto-sha256-iterative": {"filtered": 67.9, "value": 67.9}, "json-stringify-tinderbox": {"filtered": 63.1, "value": 63.1}, "imaging-gaussian-blur": {"filtered": 110.3, "value": 110.3}, "stanford-crypto-aes": {"filtered": 87.1, "value": 87.1}, "imaging-desaturate": {"filtered": 96.8, "value": 96.8}}}, "test_machine": {"platform": "x86_64", "osversion": "6.2.9200", "os": "win", "name": "T-W864-IX-123"}, "testrun": {"date": 1445854639, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a1", "id": "20151026023015", "branch": "B2G-Inbound", "revision": "8631cff3e8183a5cc08e7c5b3478c8c21b7d4a55"}}, {"talos_counters": {}, "results": {"DeltaBlue": [175.53098121818502], "Encrypt": [282.08744710860367], "NavierStokes": [4887.804878048781], "Decrypt": [5122.448979591837], "Splay": [791.1617961511048], "Richards": [167.7570877369569], "RegExp": [30058.823529411766], "Earley": [666.2225183211193], "Boyer": [12575.0], "RayTrace": [1564.0625]}, "summary": {"suite": 19883.96642792118, "subtests": {"DeltaBlue": {"filtered": 376.6742459999999, "value": 376.6742459999999}, "Encrypt": {"filtered": 943.6116450000002, "value": 943.6116450000002}, "NavierStokes": {"filtered": 303.61277445109783, "value": 303.61277445109783}, "Decrypt": {"filtered": 51.96362151394425, "value": 51.96362151394425}, "Splay": {"filtered": 103.00168738738736, "value": 103.00168738738736}, "RegExp": {"filtered": 30.306741682974582, "value": 30.306741682974582}, "Richards": {"filtered": 210.43522200000004, "value": 210.43522200000004}, "Earley": {"filtered": 1000.3609630000004, "value": 1000.3609630000004}, "Boyer": {"filtered": 52.99904572564615, "value": 52.99904572564615}, "RayTrace": {"filtered": 473.11984015984024, "value": 473.11984015984024}}}, "test_machine": {"platform": "x86_64", "osversion": "6.2.9200", "os": "win", "name": "T-W864-IX-123"}, "testrun": {"date": 1445854639, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a1", "id": "20151026023015", "branch": "B2G-Inbound", "revision": "8631cff3e8183a5cc08e7c5b3478c8c21b7d4a55"}}]
03:37:41 INFO - RETURN: dromaeo_css: 6890.40
03:37:41 INFO - RETURN: kraken: 1449.30
03:37:41 INFO - RETURN: v8_7: 19883.97
03:37:41 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,31]]", "result": "19883.97"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,31]]", "result": "1449.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,31]]", "result": "6890.40"}}}
03:37:41 INFO - Return code: 0
03:37:41 INFO - # TBPL SUCCESS #
03:37:41 INFO - Running post-action listener: _resource_record_post_action
03:37:41 INFO - Running post-run listener: _resource_record_post_run
03:37:42 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 117805568; Write bytes: 383319552; Read time: 1299840; Write time: 4245630
03:37:42 INFO - install - Wall time: 2s; CPU: 13.0%; Read bytes: 0; Write bytes: 102400; Read time: 0; Write time: 150
03:37:42 INFO - run-tests - Wall time: 1224s; CPU: 13.0%; Read bytes: 117805568; Write bytes: 345775616; Read time: 1299840; Write time: 4166160
03:37:42 INFO - Running post-run listener: _upload_blobber_files
03:37:42 INFO - Blob upload gear active.
03:37:42 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ...
03:37:42 INFO - Copying logs to upload dir...
03:37:42 INFO - mkdir: C:\slave\test-pgo\build\upload\logs
program finished with exit code 0
elapsedTime=1387.838000
========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 10 secs) (at 2015-10-26 03:37:44.984383) =========
========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-26 03:37:44.987284) =========
'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-123\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-123
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-123
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-123\AppData\Local
LOGONSERVER=\\T-W864-IX-123
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-123
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-123
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-123
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
build_url:https://queue.taskcluster.net/v1/task/a5JHnii2T5--agh9aAnbWg/artifacts/public/build/firefox-44.0a1.en-US.win64.zip
program finished with exit code 0
elapsedTime=0.102000
build_url: 'https://queue.taskcluster.net/v1/task/a5JHnii2T5--agh9aAnbWg/artifacts/public/build/firefox-44.0a1.en-US.win64.zip'
========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-26 03:37:45.151933) =========
========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-26 03:37:45.152294) =========
'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-123\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-123
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-123
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-123\AppData\Local
LOGONSERVER=\\T-W864-IX-123
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-123
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-123
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-123
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
program finished with exit code 0
elapsedTime=0.100000
========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-26 03:37:45.270213) =========
========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2015-10-26 03:37:45.270606) =========
========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2015-10-26 03:37:45.716718) =========