builder: fx-team_win8_64_test-dromaeojs-pgo
slave: t-w864-ix-071
starttime: 1445471066.01
results: success (0)
buildid: 20151021113233
builduid: be232ffc0c5d4b8c8826df82dda1c26a
revision: 4babd5d32cc121f287363f63217c19029f848577
========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-21 16:44:26.011249) =========
master: http://buildbot-master119.bb.releng.scl3.mozilla.com:8201/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-21 16:44:26.017948) =========
========= Started set props: basedir (results: 0, elapsed: 2 secs) (at 2015-10-21 16:44:26.018251) =========
'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-071\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-071
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-071
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-071\AppData\Local
LOGONSERVER=\\T-W864-IX-071
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-071
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-071
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-071
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
C:\slave\test-pgo
program finished with exit code 0
elapsedTime=1.277000
basedir: 'C:\\slave\\test-pgo'
========= Finished set props: basedir (results: 0, elapsed: 2 secs) (at 2015-10-21 16:44:28.068005) =========
========= Started downloading to buildprops.json (results: 0, elapsed: 5 secs) (at 2015-10-21 16:44:28.068294) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 5 secs) (at 2015-10-21 16:44:33.537587) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 7 secs) (at 2015-10-21 16:44:33.537846) =========
'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-071\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-071
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-071
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-071\AppData\Local
LOGONSERVER=\\T-W864-IX-071
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-071
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-071
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-071
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
program finished with exit code 0
elapsedTime=0.303000
========= Finished 'rm -rf ...' (results: 0, elapsed: 7 secs) (at 2015-10-21 16:44:41.057802) =========
========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-21 16:44:41.058129) =========
script_repo_url: https://hg.mozilla.org/build/mozharness
========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-21 16:44:41.058478) =========
========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-21 16:44:41.058784) =========
'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-071\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-071
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-071
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-071\AppData\Local
LOGONSERVER=\\T-W864-IX-071
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-071
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-071
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-071
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
--16:44:41-- 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.45 GB/s
16:44:41 (2.45 GB/s) - `archiver_client.py' saved [12141/12141]
program finished with exit code 0
elapsedTime=0.650000
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-21 16:44:42.029959) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 7 secs) (at 2015-10-21 16:44:42.030257) =========
'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-071\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-071
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-071
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-071\AppData\Local
LOGONSERVER=\\T-W864-IX-071
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-071
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-071
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-071
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
program finished with exit code 0
elapsedTime=2.611000
========= Finished 'rm -rf ...' (results: 0, elapsed: 7 secs) (at 2015-10-21 16:44:49.690270) =========
========= Started 'bash -c ...' (results: 0, elapsed: 8 secs) (at 2015-10-21 16:44:49.690597) =========
'bash' '-c' u'python archiver_client.py mozharness --repo integration/fx-team --rev 4babd5d32cc121f287363f63217c19029f848577 --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/fx-team --rev 4babd5d32cc121f287363f63217c19029f848577 --destination scripts --debug']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld.T-W864-IX-071\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-071
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-071
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-071\AppData\Local
LOGONSERVER=\\T-W864-IX-071
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-071
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-071
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-071
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
2015-10-21 16:44:50,013 truncating revision to first 12 chars
2015-10-21 16:44:50,013 Setting DEBUG logging.
2015-10-21 16:44:50,013 attempt 1/10
2015-10-21 16:44:50,013 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4babd5d32cc1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2015-10-21 16:44:50,392 unpacking tar archive at: fx-team-4babd5d32cc1/testing/mozharness/
program finished with exit code 0
elapsedTime=0.995000
========= Finished 'bash -c ...' (results: 0, elapsed: 8 secs) (at 2015-10-21 16:44:58.457814) =========
========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-21 16:44:58.458093) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-21 16:44:58.512253) =========
========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-21 16:44:58.512510) =========
TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production
========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-21 16:44:58.512892) =========
========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 24 secs) (at 2015-10-21 16:44:58.513180) =========
'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'dromaeojs' '--add-option' '--webServer,localhost' '--branch-name' 'Fx-Team' '--system-bits' '64' '--cfg' 'talos/windows_config.py' '--download-symbols' 'ondemand' '--use-talos-json' '--blob-upload-branch' 'Fx-Team'
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', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/windows_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld.T-W864-IX-071\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-071
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-071
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-071\AppData\Local
LOGONSERVER=\\T-W864-IX-071
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-071
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-071
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-071
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
16:44:58 INFO - MultiFileLogger online at 20151021 16:44:58 in C:\slave\test-pgo
16:44:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team
16:44:58 INFO - Dumping config to C:\slave\test-pgo\logs\localconfig.json.
16:44:58 INFO - {'append_to_log': False,
16:44:58 INFO - 'base_work_dir': 'C:\\slave\\test-pgo',
16:44:58 INFO - 'blob_upload_branch': 'Fx-Team',
16:44:58 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test-pgo\\oauth.txt',
16:44:58 INFO - 'branch': 'Fx-Team',
16:44:58 INFO - 'buildbot_json_path': 'buildprops.json',
16:44:58 INFO - 'config_files': ('talos/windows_config.py',),
16:44:58 INFO - 'default_actions': ('clobber',
16:44:58 INFO - 'read-buildbot-config',
16:44:58 INFO - 'download-and-extract',
16:44:58 INFO - 'populate-webroot',
16:44:58 INFO - 'create-virtualenv',
16:44:58 INFO - 'install',
16:44:58 INFO - 'run-tests'),
16:44:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',),
16:44:58 INFO - 'download_minidump_stackwalk': True,
16:44:58 INFO - 'download_symbols': 'ondemand',
16:44:58 INFO - 'exes': {'easy_install': ('C:\\slave\\test-pgo\\build/venv/scripts/python',
16:44:58 INFO - 'C:\\slave\\test-pgo\\build/venv/scripts/easy_install-2.7-script.py'),
16:44:58 INFO - 'hg': 'c:/mozilla-build/hg/hg',
16:44:58 INFO - 'mozinstall': ('C:\\slave\\test-pgo\\build/venv/scripts/python',
16:44:58 INFO - 'C:\\slave\\test-pgo\\build/venv/scripts/mozinstall-script.py'),
16:44:58 INFO - 'python': 'c:/mozilla-build/python27/python.exe',
16:44:58 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe',
16:44:58 INFO - 'C:/mozilla-build/tooltool.py'),
16:44:58 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe',
16:44:58 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')},
16:44:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub',
16:44:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'),
16:44:58 INFO - 'installer_path': 'installer.exe',
16:44:58 INFO - 'log_level': 'info',
16:44:58 INFO - 'log_name': 'talos',
16:44:58 INFO - 'log_to_console': True,
16:44:58 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe',
16:44:58 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe',
16:44:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest',
16:44:58 INFO - 'opt_config_files': (),
16:44:58 INFO - 'pip_index': False,
16:44:58 INFO - 'sps_profile': False,
16:44:58 INFO - 'sps_profile_interval': 0,
16:44:58 INFO - 'suite': 'dromaeojs',
16:44:58 INFO - 'system_bits': '64',
16:44:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'),
16:44:58 INFO - 'title': 'T-W864-IX-071',
16:44:58 INFO - 'use_talos_json': True,
16:44:58 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'),
16:44:58 INFO - 'virtualenv_path': 'C:\\slave\\test-pgo\\build/venv',
16:44:58 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll',
16:44:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
16:44:58 INFO - 'work_dir': 'build'}
16:44:58 INFO - #####
16:44:58 INFO - ##### Running clobber step.
16:44:58 INFO - #####
16:44:58 INFO - Running pre-action listener: _resource_record_pre_action
16:44:58 INFO - Running main action method: clobber
16:44:58 INFO - rmtree: C:\slave\test-pgo\build
16:44:58 INFO - Using _rmtree_windows ...
16:44:58 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test-pgo\\build',), kwargs: {}, attempt #1
16:45:56 INFO - Running post-action listener: _resource_record_post_action
16:45:56 INFO - #####
16:45:56 INFO - ##### Running read-buildbot-config step.
16:45:56 INFO - #####
16:45:56 INFO - Running pre-action listener: _resource_record_pre_action
16:45:56 INFO - Running main action method: read_buildbot_config
16:45:56 INFO - Using buildbot properties:
16:45:56 INFO - {
16:45:56 INFO - "properties": {
16:45:56 INFO - "buildnumber": 275,
16:45:56 INFO - "product": "firefox",
16:45:56 INFO - "script_repo_revision": "production",
16:45:56 INFO - "builddir": "fx-team_win8_64_test-dromaeojs",
16:45:56 INFO - "repository": "",
16:45:56 INFO - "buildername": "Windows 8 64-bit fx-team pgo talos dromaeojs",
16:45:56 INFO - "buildid": "20151021113233",
16:45:56 INFO - "slavename": "t-w864-ix-071",
16:45:56 INFO - "pgo_build": "True",
16:45:56 INFO - "basedir": "C:\\slave\\test-pgo",
16:45:56 INFO - "project": "",
16:45:56 INFO - "platform": "win8_64",
16:45:56 INFO - "master": "http://buildbot-master119.bb.releng.scl3.mozilla.com:8201/",
16:45:56 INFO - "slavebuilddir": "test",
16:45:56 INFO - "scheduler": "tests-fx-team-win64-pgo-talos",
16:45:56 INFO - "branch": "fx-team",
16:45:56 INFO - "repo_path": "integration/fx-team",
16:45:56 INFO - "stage_platform": "win64-pgo",
16:45:56 INFO - "builduid": "be232ffc0c5d4b8c8826df82dda1c26a",
16:45:56 INFO - "revision": "4babd5d32cc121f287363f63217c19029f848577"
16:45:56 INFO - },
16:45:56 INFO - "sourcestamp": {
16:45:56 INFO - "repository": "",
16:45:56 INFO - "hasPatch": false,
16:45:56 INFO - "project": "",
16:45:56 INFO - "branch": "fx-team-win64-pgo-talos",
16:45:56 INFO - "changes": [
16:45:56 INFO - {
16:45:56 INFO - "category": null,
16:45:56 INFO - "files": [
16:45:56 INFO - {
16:45:56 INFO - "url": null,
16:45:56 INFO - "name": "https://queue.taskcluster.net/v1/task/mSRAtEX0Si2W37R1CiMUxw/artifacts/public/build/firefox-44.0a1.en-US.win64.zip"
16:45:56 INFO - }
16:45:56 INFO - ],
16:45:56 INFO - "repository": "",
16:45:56 INFO - "rev": "4babd5d32cc121f287363f63217c19029f848577",
16:45:56 INFO - "who": "sendchange",
16:45:56 INFO - "when": 1445470759,
16:45:56 INFO - "number": 6556247,
16:45:56 INFO - "comments": "",
16:45:56 INFO - "project": "",
16:45:56 INFO - "at": "Wed 21 Oct 2015 16:39:19",
16:45:56 INFO - "branch": "fx-team-win64-pgo-talos",
16:45:56 INFO - "revlink": "",
16:45:56 INFO - "properties": [
16:45:56 INFO - [
16:45:56 INFO - "buildid",
16:45:56 INFO - "20151021113233",
16:45:56 INFO - "Change"
16:45:56 INFO - ],
16:45:56 INFO - [
16:45:56 INFO - "builduid",
16:45:56 INFO - "be232ffc0c5d4b8c8826df82dda1c26a",
16:45:56 INFO - "Change"
16:45:56 INFO - ],
16:45:56 INFO - [
16:45:56 INFO - "pgo_build",
16:45:56 INFO - "True",
16:45:56 INFO - "Change"
16:45:56 INFO - ]
16:45:56 INFO - ],
16:45:56 INFO - "revision": "4babd5d32cc121f287363f63217c19029f848577"
16:45:56 INFO - }
16:45:56 INFO - ],
16:45:56 INFO - "revision": "4babd5d32cc121f287363f63217c19029f848577"
16:45:56 INFO - }
16:45:56 INFO - }
16:45:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/mSRAtEX0Si2W37R1CiMUxw/artifacts/public/build/firefox-44.0a1.en-US.win64.zip.
16:45:56 INFO - Running post-action listener: _resource_record_post_action
16:45:56 INFO - #####
16:45:56 INFO - ##### Running download-and-extract step.
16:45:56 INFO - #####
16:45:56 INFO - Running pre-action listener: _resource_record_pre_action
16:45:56 INFO - Running main action method: download_and_extract
16:45:56 INFO - mkdir: C:\slave\test-pgo\build\tests
16:45:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]}
16:45:56 INFO - https://queue.taskcluster.net/v1/task/mSRAtEX0Si2W37R1CiMUxw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net
16:45:56 INFO - trying https://queue.taskcluster.net/v1/task/mSRAtEX0Si2W37R1CiMUxw/artifacts/public/build/test_packages.json
16:45:56 INFO - Downloading https://queue.taskcluster.net/v1/task/mSRAtEX0Si2W37R1CiMUxw/artifacts/public/build/test_packages.json to C:\slave\test-pgo\build\test_packages.json
16:45:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/mSRAtEX0Si2W37R1CiMUxw/artifacts/public/build/test_packages.json', 'file_name': 'C:\\slave\\test-pgo\\build\\test_packages.json'}, attempt #1
16:45:57 INFO - Downloaded 1221 bytes.
16:45:57 INFO - Reading from file C:\slave\test-pgo\build\test_packages.json
16:45:57 INFO - Using the following test package requirements:
16:45:57 INFO - {u'common': [u'firefox-44.0a1.en-US.win64.common.tests.zip'],
16:45:57 INFO - u'cppunittest': [u'firefox-44.0a1.en-US.win64.common.tests.zip',
16:45:57 INFO - u'firefox-44.0a1.en-US.win64.cppunittest.tests.zip'],
16:45:57 INFO - u'jittest': [u'firefox-44.0a1.en-US.win64.common.tests.zip',
16:45:57 INFO - u'jsshell-win64.zip'],
16:45:57 INFO - u'mochitest': [u'firefox-44.0a1.en-US.win64.common.tests.zip',
16:45:57 INFO - u'firefox-44.0a1.en-US.win64.mochitest.tests.zip'],
16:45:57 INFO - u'mozbase': [u'firefox-44.0a1.en-US.win64.common.tests.zip'],
16:45:57 INFO - u'reftest': [u'firefox-44.0a1.en-US.win64.common.tests.zip',
16:45:57 INFO - u'firefox-44.0a1.en-US.win64.reftest.tests.zip'],
16:45:57 INFO - u'talos': [u'firefox-44.0a1.en-US.win64.common.tests.zip',
16:45:57 INFO - u'firefox-44.0a1.en-US.win64.talos.tests.zip'],
16:45:57 INFO - u'web-platform': [u'firefox-44.0a1.en-US.win64.common.tests.zip',
16:45:57 INFO - u'firefox-44.0a1.en-US.win64.web-platform.tests.zip'],
16:45:57 INFO - u'webapprt': [u'firefox-44.0a1.en-US.win64.common.tests.zip'],
16:45:57 INFO - u'xpcshell': [u'firefox-44.0a1.en-US.win64.common.tests.zip',
16:45:57 INFO - u'firefox-44.0a1.en-US.win64.xpcshell.tests.zip']}
16:45:57 INFO - Downloading packages: [u'firefox-44.0a1.en-US.win64.common.tests.zip'] for test suite category: common
16:45: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')]}
16:45:57 INFO - https://queue.taskcluster.net/v1/task/mSRAtEX0Si2W37R1CiMUxw/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip matches https://queue.taskcluster.net
16:45:57 INFO - trying https://queue.taskcluster.net/v1/task/mSRAtEX0Si2W37R1CiMUxw/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip
16:45:57 INFO - Downloading https://queue.taskcluster.net/v1/task/mSRAtEX0Si2W37R1CiMUxw/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
16:45:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/mSRAtEX0Si2W37R1CiMUxw/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
16:45:59 INFO - Downloaded 18091389 bytes.
16:45:59 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
16:45:59 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-44.0a1.en-US.win64.common.tests.zip
16:45:59 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
16:46:26 INFO - Return code: 0
16:46:26 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
16:46:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
16:46:26 INFO - https://queue.taskcluster.net/v1/task/mSRAtEX0Si2W37R1CiMUxw/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip matches https://queue.taskcluster.net
16:46:26 INFO - trying https://queue.taskcluster.net/v1/task/mSRAtEX0Si2W37R1CiMUxw/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip
16:46:26 INFO - Downloading https://queue.taskcluster.net/v1/task/mSRAtEX0Si2W37R1CiMUxw/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
16:46:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/mSRAtEX0Si2W37R1CiMUxw/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
16:46:28 INFO - Downloaded 18091389 bytes.
16:46:28 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
16:46:28 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-44.0a1.en-US.win64.common.tests.zip
16:46:28 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
16:46:49 INFO - Return code: 0
16:46:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
16:46:49 INFO - https://queue.taskcluster.net/v1/task/mSRAtEX0Si2W37R1CiMUxw/artifacts/public/build/firefox-44.0a1.en-US.win64.talos.tests.zip matches https://queue.taskcluster.net
16:46:49 INFO - trying https://queue.taskcluster.net/v1/task/mSRAtEX0Si2W37R1CiMUxw/artifacts/public/build/firefox-44.0a1.en-US.win64.talos.tests.zip
16:46:49 INFO - Downloading https://queue.taskcluster.net/v1/task/mSRAtEX0Si2W37R1CiMUxw/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
16:46:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/mSRAtEX0Si2W37R1CiMUxw/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
16:46:51 INFO - Downloaded 11128541 bytes.
16:46:51 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
16:46:51 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-44.0a1.en-US.win64.talos.tests.zip
16:46:51 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
16:46:52 INFO - Return code: 0
16:46: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')]}
16:46:52 INFO - https://queue.taskcluster.net/v1/task/mSRAtEX0Si2W37R1CiMUxw/artifacts/public/build/firefox-44.0a1.en-US.win64.zip matches https://queue.taskcluster.net
16:46:52 INFO - trying https://queue.taskcluster.net/v1/task/mSRAtEX0Si2W37R1CiMUxw/artifacts/public/build/firefox-44.0a1.en-US.win64.zip
16:46:52 INFO - Downloading https://queue.taskcluster.net/v1/task/mSRAtEX0Si2W37R1CiMUxw/artifacts/public/build/firefox-44.0a1.en-US.win64.zip to C:\slave\test-pgo\build\firefox-44.0a1.en-US.win64.zip
16:46:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/mSRAtEX0Si2W37R1CiMUxw/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
16:46:54 INFO - Downloaded 57411526 bytes.
16:46:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/mSRAtEX0Si2W37R1CiMUxw/artifacts/public/build/firefox-44.0a1.en-US.win64.zip
16:46:54 INFO - mkdir: C:\slave\test-pgo\properties
16:46:54 INFO - Writing buildbot properties ['build_url'] to C:\slave\test-pgo\properties\build_url
16:46:54 INFO - Writing to file C:\slave\test-pgo\properties\build_url
16:46:54 INFO - Contents:
16:46:54 INFO - build_url:https://queue.taskcluster.net/v1/task/mSRAtEX0Si2W37R1CiMUxw/artifacts/public/build/firefox-44.0a1.en-US.win64.zip
16:46:54 INFO - Running post-action listener: _resource_record_post_action
16:46:54 INFO - Running post-action listener: set_extra_try_arguments
16:46:54 INFO - #####
16:46:54 INFO - ##### Running populate-webroot step.
16:46:54 INFO - #####
16:46:54 INFO - Running pre-action listener: _resource_record_pre_action
16:46:54 INFO - Running main action method: populate_webroot
16:46:54 INFO - Guessing talos json url...
16:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
16:46:54 INFO - https://queue.taskcluster.net/v1/task/mSRAtEX0Si2W37R1CiMUxw/artifacts/public/build/firefox-44.0a1.en-US.win64.txt matches https://queue.taskcluster.net
16:46:54 INFO - trying https://queue.taskcluster.net/v1/task/mSRAtEX0Si2W37R1CiMUxw/artifacts/public/build/firefox-44.0a1.en-US.win64.txt
16:46:54 INFO - Downloading https://queue.taskcluster.net/v1/task/mSRAtEX0Si2W37R1CiMUxw/artifacts/public/build/firefox-44.0a1.en-US.win64.txt to C:\slave\test-pgo\build\firefox-44.0a1.en-US.win64.txt
16:46:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/mSRAtEX0Si2W37R1CiMUxw/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
16:46:55 INFO - Downloaded 103 bytes.
16:46:55 INFO - Reading from file C:\slave\test-pgo\build\firefox-44.0a1.en-US.win64.txt
16:46:55 INFO - Contents:
16:46:55 INFO - 20151021113233
16:46:55 INFO - https://hg.mozilla.org/integration/fx-team/rev/4babd5d32cc121f287363f63217c19029f848577
16:46:55 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')]}
16:46:55 INFO - trying https://hg.mozilla.org/integration/fx-team/raw-file/4babd5d32c/testing/talos/talos.json
16:46:55 INFO - Downloading https://hg.mozilla.org/integration/fx-team/raw-file/4babd5d32c/testing/talos/talos.json to C:\slave\test-pgo\build\talos.json
16:46:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/fx-team/raw-file/4babd5d32c/testing/talos/talos.json', 'file_name': 'C:\\slave\\test-pgo\\build\\talos.json'}, attempt #1
16:46:56 INFO - Downloaded 4264 bytes.
16:46:56 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']},
16:46:56 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']},
16:46:56 INFO - u'remote-trobocheck2': {u'talos_options': [u'--fennecIDs',
16:46:56 INFO - u'../fennec_ids.txt'],
16:46:56 INFO - u'tests': [u'tcheck2']},
16:46:56 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome',
16:46:56 INFO - u'--tppagecycles',
16:46:56 INFO - u'7'],
16:46:56 INFO - u'tests': [u'tsvgm']}},
16:46:56 INFO - u'suites': {u'chromez': {u'tests': [u'tresize', u'tcanvasmark']},
16:46:56 INFO - u'chromez-e10s': {u'talos_options': [u'--e10s'],
16:46:56 INFO - u'tests': [u'tresize', u'tcanvasmark']},
16:46:56 INFO - u'dromaeojs': {u'tests': [u'dromaeo_css', u'kraken', u'v8_7']},
16:46:56 INFO - u'dromaeojs-e10s': {u'talos_options': [u'--e10s'],
16:46:56 INFO - u'tests': [u'dromaeo_css',
16:46:56 INFO - u'kraken',
16:46:56 INFO - u'v8_7']},
16:46:56 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
16:46:56 INFO - u'tests': [u'tp5o_scroll', u'glterrain']},
16:46:56 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
16:46:56 INFO - u'talos_options': [u'--e10s'],
16:46:56 INFO - u'tests': [u'tp5o_scroll', u'glterrain']},
16:46:56 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
16:46:56 INFO - u'tests': [u'damp', u'tps']},
16:46:56 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
16:46:56 INFO - u'talos_options': [u'--e10s'],
16:46:56 INFO - u'tests': [u'damp', u'tps']},
16:46:56 INFO - u'g3': {u'tests': [u'dromaeo_dom']},
16:46:56 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']},
16:46:56 INFO - u'other': {u'tests': [u'a11yr',
16:46:56 INFO - u'ts_paint',
16:46:56 INFO - u'tpaint',
16:46:56 INFO - u'sessionrestore',
16:46:56 INFO - u'sessionrestore_no_auto_restore']},
16:46:56 INFO - u'other-e10s': {u'talos_options': [u'--e10s'],
16:46:56 INFO - u'tests': [u'a11yr',
16:46:56 INFO - u'ts_paint',
16:46:56 INFO - u'tpaint',
16:46:56 INFO - u'sessionrestore',
16:46:56 INFO - u'sessionrestore_no_auto_restore']},
16:46:56 INFO - u'other-e10s_l64': {u'talos_options': [u'--e10s'],
16:46:56 INFO - u'tests': [u'a11yr',
16:46:56 INFO - u'ts_paint',
16:46:56 INFO - u'tpaint',
16:46:56 INFO - u'sessionrestore',
16:46:56 INFO - u'sessionrestore_no_auto_restore']},
16:46:56 INFO - u'other-e10s_nol64': {u'talos_options': [u'--e10s'],
16:46:56 INFO - u'tests': [u'a11yr',
16:46:56 INFO - u'ts_paint',
16:46:56 INFO - u'tpaint',
16:46:56 INFO - u'sessionrestore',
16:46:56 INFO - u'sessionrestore_no_auto_restore']},
16:46:56 INFO - u'other_l64': {u'tests': [u'a11yr',
16:46:56 INFO - u'ts_paint',
16:46:56 INFO - u'tpaint',
16:46:56 INFO - u'sessionrestore',
16:46:56 INFO - u'sessionrestore_no_auto_restore']},
16:46:56 INFO - u'other_nol64': {u'tests': [u'a11yr',
16:46:56 INFO - u'ts_paint',
16:46:56 INFO - u'tpaint',
16:46:56 INFO - u'sessionrestore',
16:46:56 INFO - u'sessionrestore_no_auto_restore']},
16:46:56 INFO - u'svgr': {u'tests': [u'tsvgx',
16:46:56 INFO - u'tsvgr_opacity',
16:46:56 INFO - u'tart',
16:46:56 INFO - u'tscrollx',
16:46:56 INFO - u'cart']},
16:46:56 INFO - u'svgr-e10s': {u'talos_options': [u'--e10s'],
16:46:56 INFO - u'tests': [u'tsvgx',
16:46:56 INFO - u'tsvgr_opacity',
16:46:56 INFO - u'tart',
16:46:56 INFO - u'tscrollx',
16:46:56 INFO - u'cart']},
16:46:56 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
16:46:56 INFO - u'tests': [u'tp5o']},
16:46:56 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
16:46:56 INFO - u'talos_options': [u'--e10s'],
16:46:56 INFO - u'tests': [u'tp5o']},
16:46:56 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
16:46:56 INFO - u'talos_options': [u'--xperf_path',
16:46:56 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
16:46:56 INFO - u'tests': [u'tp5n']},
16:46:56 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
16:46:56 INFO - u'talos_options': [u'--e10s',
16:46:56 INFO - u'--xperf_path',
16:46:56 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"',
16:46:56 INFO - u'C:/slave/talos-data/talos/xperf.config'],
16:46:56 INFO - u'tests': [u'tp5n']}},
16:46:56 INFO - u'talos.zip': {u'path': u'',
16:46:56 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}}
16:46:56 INFO - Running post-action listener: _resource_record_post_action
16:46:56 INFO - #####
16:46:56 INFO - ##### Running create-virtualenv step.
16:46:56 INFO - #####
16:46:56 INFO - Running pre-action listener: _resource_record_pre_action
16:46:56 INFO - Running main action method: create_virtualenv
16:46:56 INFO - Creating virtualenv C:\slave\test-pgo\build/venv
16:46:56 INFO - mkdir: C:\slave\test-pgo\build\venv\Scripts
16:46:56 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test-pgo\build\venv\Scripts\python27.dll
16:46:56 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'!
16:46:56 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
16:46:56 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
16:47:00 INFO - New python executable in C:\slave\test-pgo\build/venv\Scripts\python.exe
16:47:02 INFO - Installing distribute......................................................................................................................................................................................done.
16:47:04 INFO - Return code: 0
16:47:04 INFO - Installing pip>=1.5 into virtualenv C:\slave\test-pgo\build/venv
16:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
16:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
16:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
16:47:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
16:47:04 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--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 0x022BBB10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0231DEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x023CA398>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00718B48>, '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 0x0073A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027A9660>, '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-071', 'USERDOMAIN': 'T-W864-IX-071', '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-071', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-071\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-071', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-071', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-071', '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-071\\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
16:47:04 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
16:47:04 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
16:47:04 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
16:47:04 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-071\\AppData\\Roaming',
16:47:04 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
16:47:04 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
16:47:04 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
16:47:04 INFO - 'COMPUTERNAME': 'T-W864-IX-071',
16:47:04 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
16:47:04 INFO - 'DCLOCATION': 'SCL3',
16:47:04 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
16:47:04 INFO - 'FP_NO_HOST_CHECK': 'NO',
16:47:04 INFO - 'HOMEDRIVE': 'C:',
16:47:04 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-071',
16:47:04 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
16:47:04 INFO - 'KTS_VERSION': '1.19c',
16:47:04 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-071\\AppData\\Local',
16:47:04 INFO - 'LOGONSERVER': '\\\\T-W864-IX-071',
16:47:04 INFO - 'MONDIR': 'C:\\Monitor_config\\',
16:47:04 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
16:47:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
16:47:04 INFO - 'MOZ_NO_REMOTE': '1',
16:47:04 INFO - 'NO_EM_RESTART': '1',
16:47:04 INFO - 'NUMBER_OF_PROCESSORS': '8',
16:47:04 INFO - 'OS': 'Windows_NT',
16:47:04 INFO - 'OURDRIVE': 'C:',
16:47:04 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
16:47:04 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
16:47:04 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
16:47:04 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
16:47:04 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
16:47:04 INFO - 'PROCESSOR_LEVEL': '6',
16:47:04 INFO - 'PROCESSOR_REVISION': '1e05',
16:47:04 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
16:47:04 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
16:47:04 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
16:47:04 INFO - 'PROGRAMW6432': 'C:\\Program Files',
16:47:04 INFO - 'PROMPT': '$P$G',
16:47:04 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json',
16:47:04 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
16:47:04 INFO - 'PUBLIC': 'C:\\Users\\Public',
16:47:04 INFO - 'PWD': 'C:\\slave\\test-pgo',
16:47:04 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
16:47:04 INFO - 'SLAVEDIR': 'C:\\slave\\',
16:47:04 INFO - 'SYSTEMDRIVE': 'C:',
16:47:04 INFO - 'SYSTEMROOT': 'C:\\windows',
16:47:04 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
16:47:04 INFO - 'TEST1': 'testie',
16:47:04 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
16:47:04 INFO - 'USERDOMAIN': 'T-W864-IX-071',
16:47:04 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-071',
16:47:04 INFO - 'USERNAME': 'cltbld',
16:47:04 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-071',
16:47:04 INFO - 'WINDIR': 'C:\\windows',
16:47:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
16:47:05 INFO - Ignoring indexes: http://pypi.python.org/simple/
16:47:05 INFO - Downloading/unpacking pip>=1.5
16:47:05 INFO - Creating supposed download cache at C:\slave\test-pgo\build/venv\cache
16:47:10 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
16:47:10 INFO - Running setup.py egg_info for package pip
16:47:10 INFO - warning: no files found matching 'pip\cacert.pem'
16:47:10 INFO - warning: no files found matching '*.html' under directory 'docs'
16:47:10 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build'
16:47:10 INFO - no previously-included directories found matching 'docs\_build\_sources'
16:47:10 INFO - Installing collected packages: pip
16:47:10 INFO - Found existing installation: pip 0.8.2
16:47:10 INFO - Uninstalling pip:
16:47:10 INFO - Successfully uninstalled pip
16:47:10 INFO - Running setup.py install for pip
16:47:10 INFO - warning: no files found matching 'pip\cacert.pem'
16:47:10 INFO - warning: no files found matching '*.html' under directory 'docs'
16:47:10 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build'
16:47:10 INFO - no previously-included directories found matching 'docs\_build\_sources'
16:47:10 INFO - Installing pip-script.py script to C:\slave\test-pgo\build\venv\Scripts
16:47:10 INFO - Installing pip.exe script to C:\slave\test-pgo\build\venv\Scripts
16:47:10 INFO - Installing pip2.7-script.py script to C:\slave\test-pgo\build\venv\Scripts
16:47:10 INFO - Installing pip2.7.exe script to C:\slave\test-pgo\build\venv\Scripts
16:47:10 INFO - Installing pip2-script.py script to C:\slave\test-pgo\build\venv\Scripts
16:47:10 INFO - Installing pip2.exe script to C:\slave\test-pgo\build\venv\Scripts
16:47:10 INFO - Successfully installed pip
16:47:10 INFO - Cleaning up...
16:47:10 INFO - Return code: 0
16:47:10 INFO - Installing psutil>=0.7.1 into virtualenv C:\slave\test-pgo\build/venv
16:47:10 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')]}
16:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
16:47:10 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')]}
16:47:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
16:47:10 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 0x022BBB10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0231DEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x023CA398>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00718B48>, '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 0x0073A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027A9660>, '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-071', 'USERDOMAIN': 'T-W864-IX-071', '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-071', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-071\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-071', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-071', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-071', '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-071\\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
16:47:10 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
16:47:10 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
16:47:10 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
16:47:10 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-071\\AppData\\Roaming',
16:47:10 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
16:47:10 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
16:47:10 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
16:47:10 INFO - 'COMPUTERNAME': 'T-W864-IX-071',
16:47:10 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
16:47:10 INFO - 'DCLOCATION': 'SCL3',
16:47:10 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
16:47:10 INFO - 'FP_NO_HOST_CHECK': 'NO',
16:47:10 INFO - 'HOMEDRIVE': 'C:',
16:47:10 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-071',
16:47:10 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
16:47:10 INFO - 'KTS_VERSION': '1.19c',
16:47:10 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-071\\AppData\\Local',
16:47:10 INFO - 'LOGONSERVER': '\\\\T-W864-IX-071',
16:47:10 INFO - 'MONDIR': 'C:\\Monitor_config\\',
16:47:10 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
16:47:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
16:47:10 INFO - 'MOZ_NO_REMOTE': '1',
16:47:10 INFO - 'NO_EM_RESTART': '1',
16:47:10 INFO - 'NUMBER_OF_PROCESSORS': '8',
16:47:10 INFO - 'OS': 'Windows_NT',
16:47:10 INFO - 'OURDRIVE': 'C:',
16:47:10 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',
16:47:10 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
16:47:10 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
16:47:10 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
16:47:10 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
16:47:10 INFO - 'PROCESSOR_LEVEL': '6',
16:47:10 INFO - 'PROCESSOR_REVISION': '1e05',
16:47:10 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
16:47:10 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
16:47:10 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
16:47:10 INFO - 'PROGRAMW6432': 'C:\\Program Files',
16:47:10 INFO - 'PROMPT': '$P$G',
16:47:10 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json',
16:47:10 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
16:47:10 INFO - 'PUBLIC': 'C:\\Users\\Public',
16:47:10 INFO - 'PWD': 'C:\\slave\\test-pgo',
16:47:10 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
16:47:10 INFO - 'SLAVEDIR': 'C:\\slave\\',
16:47:10 INFO - 'SYSTEMDRIVE': 'C:',
16:47:10 INFO - 'SYSTEMROOT': 'C:\\windows',
16:47:10 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
16:47:10 INFO - 'TEST1': 'testie',
16:47:10 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
16:47:10 INFO - 'USERDOMAIN': 'T-W864-IX-071',
16:47:10 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-071',
16:47:10 INFO - 'USERNAME': 'cltbld',
16:47:10 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-071',
16:47:10 INFO - 'WINDIR': 'C:\\windows',
16:47:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
16:47:11 INFO - Ignoring indexes: https://pypi.python.org/simple/
16:47:11 INFO - Downloading/unpacking psutil>=0.7.1
16:47:11 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
16:47:11 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
16:47:12 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
16:47:12 INFO - Installing collected packages: psutil
16:47:12 INFO - Successfully installed psutil
16:47:12 INFO - Cleaning up...
16:47:13 INFO - Return code: 0
16:47:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv C:\slave\test-pgo\build/venv
16:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]}
16:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
16:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]}
16:47:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
16:47:13 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 0x022BBB10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0231DEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x023CA398>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00718B48>, '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 0x0073A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027A9660>, '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-071', 'USERDOMAIN': 'T-W864-IX-071', '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-071', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-071\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-071', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-071', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-071', '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-071\\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
16:47:13 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
16:47:13 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
16:47:13 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
16:47:13 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-071\\AppData\\Roaming',
16:47:13 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
16:47:13 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
16:47:13 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
16:47:13 INFO - 'COMPUTERNAME': 'T-W864-IX-071',
16:47:13 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
16:47:13 INFO - 'DCLOCATION': 'SCL3',
16:47:13 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
16:47:13 INFO - 'FP_NO_HOST_CHECK': 'NO',
16:47:13 INFO - 'HOMEDRIVE': 'C:',
16:47:13 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-071',
16:47:13 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
16:47:13 INFO - 'KTS_VERSION': '1.19c',
16:47:13 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-071\\AppData\\Local',
16:47:13 INFO - 'LOGONSERVER': '\\\\T-W864-IX-071',
16:47:13 INFO - 'MONDIR': 'C:\\Monitor_config\\',
16:47:13 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
16:47:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
16:47:13 INFO - 'MOZ_NO_REMOTE': '1',
16:47:13 INFO - 'NO_EM_RESTART': '1',
16:47:13 INFO - 'NUMBER_OF_PROCESSORS': '8',
16:47:13 INFO - 'OS': 'Windows_NT',
16:47:13 INFO - 'OURDRIVE': 'C:',
16:47:13 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',
16:47:13 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
16:47:13 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
16:47:13 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
16:47:13 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
16:47:13 INFO - 'PROCESSOR_LEVEL': '6',
16:47:13 INFO - 'PROCESSOR_REVISION': '1e05',
16:47:13 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
16:47:13 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
16:47:13 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
16:47:13 INFO - 'PROGRAMW6432': 'C:\\Program Files',
16:47:13 INFO - 'PROMPT': '$P$G',
16:47:13 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json',
16:47:13 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
16:47:13 INFO - 'PUBLIC': 'C:\\Users\\Public',
16:47:13 INFO - 'PWD': 'C:\\slave\\test-pgo',
16:47:13 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
16:47:13 INFO - 'SLAVEDIR': 'C:\\slave\\',
16:47:13 INFO - 'SYSTEMDRIVE': 'C:',
16:47:13 INFO - 'SYSTEMROOT': 'C:\\windows',
16:47:13 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
16:47:13 INFO - 'TEST1': 'testie',
16:47:13 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
16:47:13 INFO - 'USERDOMAIN': 'T-W864-IX-071',
16:47:13 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-071',
16:47:13 INFO - 'USERNAME': 'cltbld',
16:47:13 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-071',
16:47:13 INFO - 'WINDIR': 'C:\\windows',
16:47:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
16:47:13 INFO - Ignoring indexes: https://pypi.python.org/simple/
16:47:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0
16:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
16:47:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
16:47:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz
16:47:14 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
16:47:14 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor
16:47:14 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)
16:47:14 INFO - Installing collected packages: mozsystemmonitor
16:47:14 INFO - Running setup.py install for mozsystemmonitor
16:47:14 INFO - Successfully installed mozsystemmonitor
16:47:14 INFO - Cleaning up...
16:47:14 INFO - Return code: 0
16:47:14 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test-pgo\build/venv
16:47:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
16:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
16:47:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
16:47:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
16:47:14 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x022BBB10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0231DEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x023CA398>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00718B48>, '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 0x0073A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027A9660>, '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-071', 'USERDOMAIN': 'T-W864-IX-071', '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-071', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-071\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-071', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-071', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-071', '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-071\\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
16:47:14 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in C:\slave\test-pgo\build
16:47:14 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --download-cache C:\slave\test-pgo\build/venv\cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4
16:47:14 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
16:47:14 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-071\\AppData\\Roaming',
16:47:14 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
16:47:14 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
16:47:14 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
16:47:14 INFO - 'COMPUTERNAME': 'T-W864-IX-071',
16:47:14 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
16:47:14 INFO - 'DCLOCATION': 'SCL3',
16:47:14 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
16:47:14 INFO - 'FP_NO_HOST_CHECK': 'NO',
16:47:14 INFO - 'HOMEDRIVE': 'C:',
16:47:14 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-071',
16:47:14 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
16:47:14 INFO - 'KTS_VERSION': '1.19c',
16:47:14 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-071\\AppData\\Local',
16:47:14 INFO - 'LOGONSERVER': '\\\\T-W864-IX-071',
16:47:14 INFO - 'MONDIR': 'C:\\Monitor_config\\',
16:47:14 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
16:47:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
16:47:14 INFO - 'MOZ_NO_REMOTE': '1',
16:47:14 INFO - 'NO_EM_RESTART': '1',
16:47:14 INFO - 'NUMBER_OF_PROCESSORS': '8',
16:47:14 INFO - 'OS': 'Windows_NT',
16:47:14 INFO - 'OURDRIVE': 'C:',
16:47:14 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg',
16:47:14 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
16:47:14 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
16:47:14 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
16:47:14 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
16:47:14 INFO - 'PROCESSOR_LEVEL': '6',
16:47:14 INFO - 'PROCESSOR_REVISION': '1e05',
16:47:14 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
16:47:14 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
16:47:14 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
16:47:14 INFO - 'PROGRAMW6432': 'C:\\Program Files',
16:47:14 INFO - 'PROMPT': '$P$G',
16:47:14 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json',
16:47:14 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
16:47:14 INFO - 'PUBLIC': 'C:\\Users\\Public',
16:47:14 INFO - 'PWD': 'C:\\slave\\test-pgo',
16:47:14 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
16:47:14 INFO - 'SLAVEDIR': 'C:\\slave\\',
16:47:14 INFO - 'SYSTEMDRIVE': 'C:',
16:47:14 INFO - 'SYSTEMROOT': 'C:\\windows',
16:47:14 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
16:47:14 INFO - 'TEST1': 'testie',
16:47:14 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
16:47:14 INFO - 'USERDOMAIN': 'T-W864-IX-071',
16:47:14 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-071',
16:47:14 INFO - 'USERNAME': 'cltbld',
16:47:14 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-071',
16:47:14 INFO - 'WINDIR': 'C:\\windows',
16:47:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
16:47:14 INFO - Ignoring indexes: https://pypi.python.org/simple/
16:47:14 INFO - Downloading/unpacking blobuploader==1.2.4
16:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
16:47:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
16:47:15 INFO - Downloading blobuploader-1.2.4.tar.gz
16:47:15 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
16:47:15 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader
16:47:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4)
16:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
16:47:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
16:47:16 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
16:47:16 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\requests\setup.py) egg_info for package requests
16:47:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4)
16:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
16:47:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
16:47:16 INFO - Downloading docopt-0.6.1.tar.gz
16:47:16 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
16:47:16 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\docopt\setup.py) egg_info for package docopt
16:47:16 INFO - Installing collected packages: blobuploader, requests, docopt
16:47:16 INFO - Running setup.py install for blobuploader
16:47:16 INFO - Running setup.py install for requests
16:47:17 INFO - Running setup.py install for docopt
16:47:17 INFO - Successfully installed blobuploader requests docopt
16:47:17 INFO - Cleaning up...
16:47:18 INFO - Return code: 0
16:47:18 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv
16:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
16:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
16:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
16:47:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
16:47:18 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 0x022BBB10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0231DEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x023CA398>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00718B48>, '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 0x0073A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027A9660>, '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-071', 'USERDOMAIN': 'T-W864-IX-071', '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-071', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-071\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-071', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-071', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-071', '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-071\\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
16:47:18 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
16:47:18 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
16:47:18 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
16:47:18 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-071\\AppData\\Roaming',
16:47:18 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
16:47:18 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
16:47:18 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
16:47:18 INFO - 'COMPUTERNAME': 'T-W864-IX-071',
16:47:18 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
16:47:18 INFO - 'DCLOCATION': 'SCL3',
16:47:18 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
16:47:18 INFO - 'FP_NO_HOST_CHECK': 'NO',
16:47:18 INFO - 'HOMEDRIVE': 'C:',
16:47:18 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-071',
16:47:18 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
16:47:18 INFO - 'KTS_VERSION': '1.19c',
16:47:18 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-071\\AppData\\Local',
16:47:18 INFO - 'LOGONSERVER': '\\\\T-W864-IX-071',
16:47:18 INFO - 'MONDIR': 'C:\\Monitor_config\\',
16:47:18 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
16:47:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
16:47:18 INFO - 'MOZ_NO_REMOTE': '1',
16:47:18 INFO - 'NO_EM_RESTART': '1',
16:47:18 INFO - 'NUMBER_OF_PROCESSORS': '8',
16:47:18 INFO - 'OS': 'Windows_NT',
16:47:18 INFO - 'OURDRIVE': 'C:',
16:47: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',
16:47:18 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
16:47:18 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
16:47:18 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
16:47:18 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
16:47:18 INFO - 'PROCESSOR_LEVEL': '6',
16:47:18 INFO - 'PROCESSOR_REVISION': '1e05',
16:47:18 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
16:47:18 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
16:47:18 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
16:47:18 INFO - 'PROGRAMW6432': 'C:\\Program Files',
16:47:18 INFO - 'PROMPT': '$P$G',
16:47:18 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json',
16:47:18 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
16:47:18 INFO - 'PUBLIC': 'C:\\Users\\Public',
16:47:18 INFO - 'PWD': 'C:\\slave\\test-pgo',
16:47:18 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
16:47:18 INFO - 'SLAVEDIR': 'C:\\slave\\',
16:47:18 INFO - 'SYSTEMDRIVE': 'C:',
16:47:18 INFO - 'SYSTEMROOT': 'C:\\windows',
16:47:18 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
16:47:18 INFO - 'TEST1': 'testie',
16:47:18 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
16:47:18 INFO - 'USERDOMAIN': 'T-W864-IX-071',
16:47:18 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-071',
16:47:18 INFO - 'USERNAME': 'cltbld',
16:47:18 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-071',
16:47:18 INFO - 'WINDIR': 'C:\\windows',
16:47:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
16:47:19 INFO - Ignoring indexes: https://pypi.python.org/simple/
16:47:19 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\manifestparser
16:47:19 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-cejt9x-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/manifestparser
16:47:19 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozcrash
16:47:19 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ee9mhs-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozcrash
16:47:19 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdebug
16:47:19 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-n3zew5-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdebug
16:47:19 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdevice
16:47:19 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-_cqf3v-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdevice
16:47:19 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozfile
16:47:19 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-p6uwmn-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozfile
16:47:19 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozhttpd
16:47:19 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-wppnsw-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozhttpd
16:47:19 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinfo
16:47:19 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rxgj9k-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinfo
16:47:19 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinstall
16:47:19 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-wbtqpa-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinstall
16:47:19 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozleak
16:47:19 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-fp1lnx-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozleak
16:47:20 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozlog
16:47:20 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-dr8stk-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozlog
16:47:20 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moznetwork
16:47:20 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-vk_med-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moznetwork
16:47:20 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprocess
16:47:20 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-nti0ff-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprocess
16:47:20 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprofile
16:47:20 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-upt_o2-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprofile
16:47:20 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozrunner
16:47:20 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-6wshd5-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozrunner
16:47:20 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozscreenshot
16:47:20 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-5rkvai-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozscreenshot
16:47:20 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moztest
16:47:20 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ck7n40-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moztest
16:47:20 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozversion
16:47:20 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-be6xbr-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozversion
16:47:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion
16:47:20 INFO - Running setup.py install for manifestparser
16:47:21 INFO - Installing manifestparser-script.py script to C:\slave\test-pgo\build\venv\Scripts
16:47:21 INFO - Installing manifestparser.exe script to C:\slave\test-pgo\build\venv\Scripts
16:47:21 INFO - Running setup.py install for mozcrash
16:47:21 INFO - Running setup.py install for mozdebug
16:47:22 INFO - Running setup.py install for mozdevice
16:47:22 INFO - Installing sutini-script.py script to C:\slave\test-pgo\build\venv\Scripts
16:47:22 INFO - Installing sutini.exe script to C:\slave\test-pgo\build\venv\Scripts
16:47:22 INFO - Installing dm-script.py script to C:\slave\test-pgo\build\venv\Scripts
16:47:22 INFO - Installing dm.exe script to C:\slave\test-pgo\build\venv\Scripts
16:47:22 INFO - Running setup.py install for mozfile
16:47:23 INFO - Running setup.py install for mozhttpd
16:47:23 INFO - Installing mozhttpd-script.py script to C:\slave\test-pgo\build\venv\Scripts
16:47:23 INFO - Installing mozhttpd.exe script to C:\slave\test-pgo\build\venv\Scripts
16:47:24 INFO - Running setup.py install for mozinfo
16:47:24 INFO - Installing mozinfo-script.py script to C:\slave\test-pgo\build\venv\Scripts
16:47:24 INFO - Installing mozinfo.exe script to C:\slave\test-pgo\build\venv\Scripts
16:47:24 INFO - Running setup.py install for mozInstall
16:47:24 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test-pgo\build\venv\Scripts
16:47:24 INFO - Installing moz_remove_from_system.exe script to C:\slave\test-pgo\build\venv\Scripts
16:47:24 INFO - Installing mozuninstall-script.py script to C:\slave\test-pgo\build\venv\Scripts
16:47:24 INFO - Installing mozuninstall.exe script to C:\slave\test-pgo\build\venv\Scripts
16:47:24 INFO - Installing mozinstall-script.py script to C:\slave\test-pgo\build\venv\Scripts
16:47:24 INFO - Installing mozinstall.exe script to C:\slave\test-pgo\build\venv\Scripts
16:47:24 INFO - Installing moz_add_to_system-script.py script to C:\slave\test-pgo\build\venv\Scripts
16:47:24 INFO - Installing moz_add_to_system.exe script to C:\slave\test-pgo\build\venv\Scripts
16:47:24 INFO - Running setup.py install for mozleak
16:47:25 INFO - Running setup.py install for mozlog
16:47:25 INFO - Installing structlog-script.py script to C:\slave\test-pgo\build\venv\Scripts
16:47:25 INFO - Installing structlog.exe script to C:\slave\test-pgo\build\venv\Scripts
16:47:26 INFO - Running setup.py install for moznetwork
16:47:26 INFO - Installing moznetwork-script.py script to C:\slave\test-pgo\build\venv\Scripts
16:47:26 INFO - Installing moznetwork.exe script to C:\slave\test-pgo\build\venv\Scripts
16:47:26 INFO - Running setup.py install for mozprocess
16:47:26 INFO - Running setup.py install for mozprofile
16:47:27 INFO - Installing mozprofile-script.py script to C:\slave\test-pgo\build\venv\Scripts
16:47:27 INFO - Installing mozprofile.exe script to C:\slave\test-pgo\build\venv\Scripts
16:47:27 INFO - Installing diff-profiles-script.py script to C:\slave\test-pgo\build\venv\Scripts
16:47:27 INFO - Installing diff-profiles.exe script to C:\slave\test-pgo\build\venv\Scripts
16:47:27 INFO - Installing view-profile-script.py script to C:\slave\test-pgo\build\venv\Scripts
16:47:27 INFO - Installing view-profile.exe script to C:\slave\test-pgo\build\venv\Scripts
16:47:27 INFO - Running setup.py install for mozrunner
16:47:27 INFO - Installing mozrunner-script.py script to C:\slave\test-pgo\build\venv\Scripts
16:47:27 INFO - Installing mozrunner.exe script to C:\slave\test-pgo\build\venv\Scripts
16:47:28 INFO - Running setup.py install for mozscreenshot
16:47:28 INFO - Running setup.py install for moztest
16:47:28 INFO - Running setup.py install for mozversion
16:47:29 INFO - Installing mozversion-script.py script to C:\slave\test-pgo\build\venv\Scripts
16:47:29 INFO - Installing mozversion.exe script to C:\slave\test-pgo\build\venv\Scripts
16:47:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion
16:47:29 INFO - Cleaning up...
16:47:29 INFO - Return code: 0
16:47:29 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv
16:47:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
16:47:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
16:47:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
16:47:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
16:47:29 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 0x022BBB10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0231DEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x023CA398>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00718B48>, '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 0x0073A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027A9660>, '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-071', 'USERDOMAIN': 'T-W864-IX-071', '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-071', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-071\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-071', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-071', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-071', '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-071\\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
16:47:29 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
16:47:29 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
16:47:29 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
16:47:29 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-071\\AppData\\Roaming',
16:47:29 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
16:47:29 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
16:47:29 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
16:47:29 INFO - 'COMPUTERNAME': 'T-W864-IX-071',
16:47:29 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
16:47:29 INFO - 'DCLOCATION': 'SCL3',
16:47:29 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
16:47:29 INFO - 'FP_NO_HOST_CHECK': 'NO',
16:47:29 INFO - 'HOMEDRIVE': 'C:',
16:47:29 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-071',
16:47:29 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
16:47:29 INFO - 'KTS_VERSION': '1.19c',
16:47:29 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-071\\AppData\\Local',
16:47:29 INFO - 'LOGONSERVER': '\\\\T-W864-IX-071',
16:47:29 INFO - 'MONDIR': 'C:\\Monitor_config\\',
16:47:29 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
16:47:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
16:47:29 INFO - 'MOZ_NO_REMOTE': '1',
16:47:29 INFO - 'NO_EM_RESTART': '1',
16:47:29 INFO - 'NUMBER_OF_PROCESSORS': '8',
16:47:29 INFO - 'OS': 'Windows_NT',
16:47:29 INFO - 'OURDRIVE': 'C:',
16:47:29 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',
16:47:29 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
16:47:29 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
16:47:29 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
16:47:29 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
16:47:29 INFO - 'PROCESSOR_LEVEL': '6',
16:47:29 INFO - 'PROCESSOR_REVISION': '1e05',
16:47:29 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
16:47:29 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
16:47:29 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
16:47:29 INFO - 'PROGRAMW6432': 'C:\\Program Files',
16:47:29 INFO - 'PROMPT': '$P$G',
16:47:29 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json',
16:47:29 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
16:47:29 INFO - 'PUBLIC': 'C:\\Users\\Public',
16:47:29 INFO - 'PWD': 'C:\\slave\\test-pgo',
16:47:29 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
16:47:29 INFO - 'SLAVEDIR': 'C:\\slave\\',
16:47:29 INFO - 'SYSTEMDRIVE': 'C:',
16:47:29 INFO - 'SYSTEMROOT': 'C:\\windows',
16:47:29 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
16:47:29 INFO - 'TEST1': 'testie',
16:47:29 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
16:47:29 INFO - 'USERDOMAIN': 'T-W864-IX-071',
16:47:29 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-071',
16:47:29 INFO - 'USERNAME': 'cltbld',
16:47:29 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-071',
16:47:29 INFO - 'WINDIR': 'C:\\windows',
16:47:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
16:47:29 INFO - Ignoring indexes: https://pypi.python.org/simple/
16:47:29 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\manifestparser
16:47:29 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-dobivc-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/manifestparser
16:47:29 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))
16:47:29 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozcrash
16:47:29 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qix3co-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozcrash
16:47:29 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))
16:47:29 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdebug
16:47:29 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-1dbbbx-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdebug
16:47:30 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))
16:47:30 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdevice
16:47:30 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-8np1et-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdevice
16:47:30 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))
16:47:30 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozfile
16:47:30 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-t90vxw-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozfile
16:47:30 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))
16:47:30 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozhttpd
16:47:30 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-35zl8e-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozhttpd
16:47:30 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))
16:47:30 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinfo
16:47:30 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-gr3wqs-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinfo
16:47:30 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))
16:47:30 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinstall
16:47:30 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xjjx1u-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinstall
16:47:30 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))
16:47:30 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozleak
16:47:30 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-c8_y31-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozleak
16:47:30 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))
16:47:30 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozlog
16:47:30 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-bvuhqt-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozlog
16:47:30 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))
16:47:30 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moznetwork
16:47:30 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-fqdq4s-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moznetwork
16:47:30 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))
16:47:30 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprocess
16:47:31 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-lrx7rg-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprocess
16:47:31 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))
16:47:31 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprofile
16:47:31 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-4tkels-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprofile
16:47:31 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))
16:47:31 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozrunner
16:47:31 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-bqs9zl-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozrunner
16:47:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.10 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))
16:47:31 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozscreenshot
16:47:31 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-dppx94-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozscreenshot
16:47:31 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))
16:47:31 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moztest
16:47:31 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-oi2aqo-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moztest
16:47:31 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))
16:47:31 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozversion
16:47:31 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-tdkozk-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozversion
16:47:31 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))
16:47:31 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))
16:47:31 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))
16:47:31 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))
16:47:31 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))
16:47:31 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))
16:47:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 10))
16:47:31 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
16:47:31 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
16:47:32 INFO - Downloading blessings-1.5.1.tar.gz
16:47:32 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
16:47:32 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\blessings\setup.py) egg_info for package blessings
16:47:33 INFO - Installing collected packages: blessings
16:47:33 INFO - Running setup.py install for blessings
16:47:33 INFO - Successfully installed blessings
16:47:33 INFO - Cleaning up...
16:47:36 INFO - Return code: 0
16:47:36 INFO - Done creating virtualenv C:\slave\test-pgo\build/venv.
16:47:36 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'freeze']
16:47:36 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip freeze
16:47:36 INFO - Reading from file tmpfile_stdout
16:47:36 INFO - Using _rmtree_windows ...
16:47:36 INFO - Using _rmtree_windows ...
16:47:36 INFO - Current package versions:
16:47:36 INFO - blessings == 1.5.1
16:47:36 INFO - blobuploader == 1.2.4
16:47:36 INFO - docopt == 0.6.1
16:47:36 INFO - manifestparser == 1.1
16:47:36 INFO - mozInstall == 1.12
16:47:36 INFO - mozcrash == 0.16
16:47:36 INFO - mozdebug == 0.1
16:47:36 INFO - mozdevice == 0.46
16:47:36 INFO - mozfile == 1.2
16:47:36 INFO - mozhttpd == 0.7
16:47:36 INFO - mozinfo == 0.8
16:47:36 INFO - mozleak == 0.1
16:47:36 INFO - mozlog == 3.0
16:47:36 INFO - moznetwork == 0.27
16:47:36 INFO - mozprocess == 0.22
16:47:36 INFO - mozprofile == 0.27
16:47:36 INFO - mozrunner == 6.10
16:47:36 INFO - mozscreenshot == 0.1
16:47:36 INFO - mozsystemmonitor == 0.0
16:47:36 INFO - moztest == 0.7
16:47:36 INFO - mozversion == 1.4
16:47:36 INFO - psutil == 3.1.1
16:47:36 INFO - requests == 1.2.3
16:47:36 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv
16:47:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
16:47:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
16:47:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
16:47:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
16:47:36 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 0x022BBB10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0231DEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x023CA398>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00718B48>, '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 0x0073A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027A9660>, '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-071', 'USERDOMAIN': 'T-W864-IX-071', '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-071', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-071\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-071', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-071', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-071', '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-071\\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
16:47:36 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
16:47:36 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
16:47:36 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
16:47:36 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-071\\AppData\\Roaming',
16:47:36 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
16:47:36 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
16:47:36 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
16:47:36 INFO - 'COMPUTERNAME': 'T-W864-IX-071',
16:47:36 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
16:47:36 INFO - 'DCLOCATION': 'SCL3',
16:47:36 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
16:47:36 INFO - 'FP_NO_HOST_CHECK': 'NO',
16:47:36 INFO - 'HOMEDRIVE': 'C:',
16:47:36 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-071',
16:47:36 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
16:47:36 INFO - 'KTS_VERSION': '1.19c',
16:47:36 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-071\\AppData\\Local',
16:47:36 INFO - 'LOGONSERVER': '\\\\T-W864-IX-071',
16:47:36 INFO - 'MONDIR': 'C:\\Monitor_config\\',
16:47:36 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
16:47:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
16:47:36 INFO - 'MOZ_NO_REMOTE': '1',
16:47:36 INFO - 'NO_EM_RESTART': '1',
16:47:36 INFO - 'NUMBER_OF_PROCESSORS': '8',
16:47:36 INFO - 'OS': 'Windows_NT',
16:47:36 INFO - 'OURDRIVE': 'C:',
16:47:36 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',
16:47:36 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
16:47:36 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
16:47:36 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
16:47:36 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
16:47:36 INFO - 'PROCESSOR_LEVEL': '6',
16:47:36 INFO - 'PROCESSOR_REVISION': '1e05',
16:47:36 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
16:47:36 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
16:47:36 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
16:47:36 INFO - 'PROGRAMW6432': 'C:\\Program Files',
16:47:36 INFO - 'PROMPT': '$P$G',
16:47:36 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json',
16:47:36 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
16:47:36 INFO - 'PUBLIC': 'C:\\Users\\Public',
16:47:36 INFO - 'PWD': 'C:\\slave\\test-pgo',
16:47:36 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
16:47:36 INFO - 'SLAVEDIR': 'C:\\slave\\',
16:47:36 INFO - 'SYSTEMDRIVE': 'C:',
16:47:36 INFO - 'SYSTEMROOT': 'C:\\windows',
16:47:36 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
16:47:36 INFO - 'TEST1': 'testie',
16:47:36 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
16:47:36 INFO - 'USERDOMAIN': 'T-W864-IX-071',
16:47:36 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-071',
16:47:36 INFO - 'USERNAME': 'cltbld',
16:47:36 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-071',
16:47:36 INFO - 'WINDIR': 'C:\\windows',
16:47:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
16:47:36 INFO - Ignoring indexes: https://pypi.python.org/simple/
16:47:36 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))
16:47:36 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))
16:47:36 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))
16:47:36 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))
16:47:36 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))
16:47:36 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))
16:47:36 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))
16:47:36 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))
16:47:36 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))
16:47:36 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))
16:47:36 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))
16:47:36 INFO - Cleaning up...
16:47:36 INFO - Return code: 0
16:47:36 INFO - Running post-action listener: _resource_record_post_action
16:47:36 INFO - Running post-action listener: _start_resource_monitoring
16:47:36 INFO - Starting resource monitoring.
16:47:36 INFO - #####
16:47:36 INFO - ##### Running install step.
16:47:36 INFO - #####
16:47:36 INFO - Running pre-action listener: _resource_record_pre_action
16:47:36 INFO - Running main action method: install
16:47:36 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'freeze']
16:47:36 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip freeze
16:47:37 INFO - Reading from file tmpfile_stdout
16:47:37 INFO - Using _rmtree_windows ...
16:47:37 INFO - Using _rmtree_windows ...
16:47:37 INFO - Detecting whether we're running mozinstall >=1.0...
16:47:37 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build/venv/scripts/python', 'C:\\slave\\test-pgo\\build/venv/scripts/mozinstall-script.py', '-h']
16:47:37 INFO - Copy/paste: C:\slave\test-pgo\build/venv/scripts/python C:\slave\test-pgo\build/venv/scripts/mozinstall-script.py -h
16:47:37 INFO - Reading from file tmpfile_stdout
16:47:37 INFO - Output received:
16:47:37 INFO - Usage: mozinstall-script.py [options] installer
16:47:37 INFO - Options:
16:47:37 INFO - -h, --help show this help message and exit
16:47:37 INFO - -d DEST, --destination=DEST
16:47:37 INFO - Directory to install application into. [default:
16:47:37 INFO - "C:\slave\test-pgo"]
16:47:37 INFO - --app=APP Application being installed. [default: firefox]
16:47:37 INFO - Using _rmtree_windows ...
16:47:37 INFO - Using _rmtree_windows ...
16:47:37 INFO - mkdir: C:\slave\test-pgo\build\application
16:47:37 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']
16:47:37 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
16:47:39 INFO - Reading from file tmpfile_stdout
16:47:39 INFO - Output received:
16:47:39 INFO - C:\slave\test-pgo\build\application\firefox\firefox.exe
16:47:39 INFO - Using _rmtree_windows ...
16:47:39 INFO - Using _rmtree_windows ...
16:47:39 INFO - Running post-action listener: _resource_record_post_action
16:47:39 INFO - #####
16:47:39 INFO - ##### Running run-tests step.
16:47:39 INFO - #####
16:47:39 INFO - Running pre-action listener: _resource_record_pre_action
16:47:39 INFO - Running main action method: run_tests
16:47:39 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\python', '--version']
16:47:39 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\python --version
16:47:39 INFO - Python 2.7.3
16:47:39 INFO - Return code: 0
16:47:39 INFO - grabbing minidump binary from tooltool
16:47:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
16:47:39 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 0x00718B48>, '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 0x0073A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027A9660>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'privileged': False}, attempt #1
16:47:39 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
16:47:39 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
16:47:39 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'...
16:47:39 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test-pgo\build\tmpcrg280
16:47:39 INFO - INFO - File integrity verified, renaming tmpcrg280 to win32-minidump_stackwalk.exe
16:47:39 INFO - Return code: 0
16:47:39 INFO - Chmoding C:\slave\test-pgo\build\win32-minidump_stackwalk.exe to 0755
16:47:39 INFO - mkdir: C:\slave\test-pgo\build\blobber_upload_dir
16:47:39 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test-pgo\build\blobber_upload_dir
16:47:39 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test-pgo\build\win32-minidump_stackwalk.exe
16:47:39 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test-pgo\build\blobber_upload_dir
16:47:39 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\python', 'C:\\slave\\test-pgo\\build\\tests\\talos\\talos\\run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test-pgo\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/mSRAtEX0Si2W37R1CiMUxw/artifacts/public/build/firefox-44.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-071', '--webServer', 'localhost'] in C:\slave\test-pgo\build
16:47:39 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\python C:\slave\test-pgo\build\tests\talos\talos\run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath C:\slave\test-pgo\build\application\firefox\firefox --symbolsPath https://queue.taskcluster.net/v1/task/mSRAtEX0Si2W37R1CiMUxw/artifacts/public/build/firefox-44.0a1.en-US.win64.crashreporter-symbols.zip --title T-W864-IX-071 --webServer localhost
16:47:39 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
16:47:39 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-071\\AppData\\Roaming',
16:47:39 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
16:47:39 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
16:47:39 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
16:47:39 INFO - 'COMPUTERNAME': 'T-W864-IX-071',
16:47:39 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
16:47:39 INFO - 'DCLOCATION': 'SCL3',
16:47:39 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
16:47:39 INFO - 'FP_NO_HOST_CHECK': 'NO',
16:47:39 INFO - 'HOMEDRIVE': 'C:',
16:47:39 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-071',
16:47:39 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
16:47:39 INFO - 'KTS_VERSION': '1.19c',
16:47:39 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-071\\AppData\\Local',
16:47:39 INFO - 'LOGONSERVER': '\\\\T-W864-IX-071',
16:47:39 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test-pgo\\build\\blobber_upload_dir',
16:47:39 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test-pgo\\build\\win32-minidump_stackwalk.exe',
16:47:39 INFO - 'MONDIR': 'C:\\Monitor_config\\',
16:47:39 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
16:47:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
16:47:39 INFO - 'MOZ_NO_REMOTE': '1',
16:47:39 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test-pgo\\build\\blobber_upload_dir',
16:47:39 INFO - 'NO_EM_RESTART': '1',
16:47:39 INFO - 'NUMBER_OF_PROCESSORS': '8',
16:47:39 INFO - 'OS': 'Windows_NT',
16:47:39 INFO - 'OURDRIVE': 'C:',
16:47:39 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',
16:47:39 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
16:47:39 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
16:47:39 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
16:47:39 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
16:47:39 INFO - 'PROCESSOR_LEVEL': '6',
16:47:39 INFO - 'PROCESSOR_REVISION': '1e05',
16:47:39 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
16:47:39 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
16:47:39 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
16:47:39 INFO - 'PROGRAMW6432': 'C:\\Program Files',
16:47:39 INFO - 'PROMPT': '$P$G',
16:47:39 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json',
16:47:39 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
16:47:39 INFO - 'PUBLIC': 'C:\\Users\\Public',
16:47:39 INFO - 'PWD': 'C:\\slave\\test-pgo',
16:47:39 INFO - 'PYTHONPATH': 'C:\\slave\\test-pgo\\build\\tests\\talos',
16:47:39 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
16:47:39 INFO - 'SLAVEDIR': 'C:\\slave\\',
16:47:39 INFO - 'SYSTEMDRIVE': 'C:',
16:47:39 INFO - 'SYSTEMROOT': 'C:\\windows',
16:47:39 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
16:47:39 INFO - 'TEST1': 'testie',
16:47:39 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
16:47:39 INFO - 'USERDOMAIN': 'T-W864-IX-071',
16:47:39 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-071',
16:47:39 INFO - 'USERNAME': 'cltbld',
16:47:39 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-071',
16:47:39 INFO - 'WINDIR': 'C:\\windows',
16:47:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
16:47:39 INFO - Calling ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\python', 'C:\\slave\\test-pgo\\build\\tests\\talos\\talos\\run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test-pgo\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/mSRAtEX0Si2W37R1CiMUxw/artifacts/public/build/firefox-44.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-071', '--webServer', 'localhost'] with output_timeout 3600
ProcessManager UNABLE to use job objects to manage child processes
ProcessManager NOT managing child processes
16:47:40 INFO - mozversion INFO | application_buildid: 20151021113233
16:47:40 INFO - mozversion INFO | application_changeset: 4babd5d32cc121f287363f63217c19029f848577
16:47:40 INFO - mozversion INFO | application_display_name: Nightly
16:47:40 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384}
16:47:40 INFO - mozversion INFO | application_name: Firefox
16:47:40 INFO - mozversion INFO | application_remotingname: firefox
16:47:40 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team
16:47:40 INFO - mozversion INFO | application_vendor: Mozilla
16:47:40 INFO - mozversion INFO | application_version: 44.0a1
16:47:40 INFO - mozversion INFO | platform_buildid: 20151021113233
16:47:40 INFO - mozversion INFO | platform_changeset: 4babd5d32cc121f287363f63217c19029f848577
16:47:40 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team
16:47:40 INFO - mozversion INFO | platform_version: 44.0a1
16:47:40 INFO - 2015-10-21 16:47:40,293 DEBUG : using testdate: 1445471260
16:47:40 INFO - 2015-10-21 16:47:40,293 DEBUG : actual date: 1445471260
16:47:40 INFO - 2015-10-21 16:47:40,316 INFO : starting webserver on 'localhost:49263'
16:47:40 INFO - 2015-10-21 16:47:40,318 INFO : Starting test suite T-W864-IX-071
16:47:40 INFO - 2015-10-21 16:47:40,318 INFO : Starting test dromaeo_css
16:47:40 INFO - 2015-10-21 16:47:40,318 DEBUG : operating with platform_type : w8_
16:47:40 INFO - 2015-10-21 16:47:40,319 INFO : Initialising browser for dromaeo_css test...
16:47:40 INFO - 2015-10-21 16:47:40,401 DEBUG : command line: C:\slave\test-pgo\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpncf7gt\profile http://localhost:49263/getInfo.html
16:47:49 INFO - 2015-10-21 16:47:49,776 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200
16:47:49 INFO - 2015-10-21 16:47:49,776 DEBUG : BROWSER_OUTPUT: colorDepth:24
16:47:49 INFO - 2015-10-21 16:47:49,776 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674
16:47:49 INFO - 2015-10-21 16:47:49,776 DEBUG : BROWSER_OUTPUT: __metrics
16:47:49 INFO - 2015-10-21 16:47:49,957 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver]
16:47:50 INFO - 2015-10-21 16:47:50,918 DEBUG : BROWSER_OUTPUT: console.error:
16:47:50 INFO - 2015-10-21 16:47:50,918 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]
16:47:50 INFO - 2015-10-21 16:47:50,918 DEBUG : BROWSER_OUTPUT: Stack:
16:47:50 INFO - 2015-10-21 16:47:50,918 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<._executeStatement@resource://gre/modules/Sqlite.jsm:758:19
16:47:50 INFO - 2015-10-21 16:47:50,918 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached/<@resource://gre/modules/Sqlite.jsm:493:9
16:47:50 INFO - 2015-10-21 16:47:50,918 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached@resource://gre/modules/Sqlite.jsm:491:1
16:47:50 INFO - 2015-10-21 16:47:50,918 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeBeforeShutdown/loggedDb<.executeCached.value<@resource://gre/modules/Sqlite.jsm:368:51
16:47:50 INFO - 2015-10-21 16:47:50,918 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40
16:47:50 INFO - 2015-10-21 16:47:50,918 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3
16:47:50 INFO - 2015-10-21 16:47:50,918 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14
16:47:50 INFO - 2015-10-21 16:47:50,918 DEBUG : BROWSER_OUTPUT: transaction@resource://gre/modules/Bookmarks.jsm:783:15
16:47:50 INFO - 2015-10-21 16:47:50,918 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40
16:47:50 INFO - 2015-10-21 16:47:50,920 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3
16:47:50 INFO - 2015-10-21 16:47:50,920 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14
16:47:50 INFO - 2015-10-21 16:47:50,920 DEBUG : BROWSER_OUTPUT: Task_spawn@resource://gre/modules/Task.jsm:164:12
16:47:50 INFO - 2015-10-21 16:47:50,920 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23
17:06:26 INFO - 2015-10-21 17:06:26,250 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7
17:06:26 INFO - 2015-10-21 17:06:26,250 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11
17:06:26 INFO - 2015-10-21 17:06:26,250 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7
17:06:26 INFO - 2015-10-21 17:06:26,250 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7
17:06:26 INFO - 2015-10-21 17:06:26,250 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13
17:06:26 INFO - 2015-10-21 17:06:26,250 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9
17:06:26 INFO - 2015-10-21 17:06:26,250 DEBUG : BROWSER_OUTPUT:
17:06:26 INFO - 2015-10-21 17:06:26,924 INFO : Browser initialized.
17:06:26 INFO - 2015-10-21 17:06:26,924 INFO : Running cycle 1/1 for kraken test...
17:06:26 INFO - 2015-10-21 17:06:26,924 DEBUG : command line: C:\slave\test-pgo\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpix1kcw\profile -tp file:\C:\slave\test-pgo\build\tests\talos\talos\tests\kraken\kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1
17:06:38 INFO - 2015-10-21 17:06:38,322 DEBUG : BROWSER_OUTPUT: RSS: Main: 188801024
17:06:38 INFO - 2015-10-21 17:06:38,322 DEBUG : BROWSER_OUTPUT:
17:06:40 INFO - 2015-10-21 17:06:40,938 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49263/tests/kraken/driver.html?testName=audio-beat-detection)
17:06:41 INFO - 2015-10-21 17:06:41,523 DEBUG : BROWSER_OUTPUT: RSS: Main: 225841152
17:06:41 INFO - 2015-10-21 17:06:41,523 DEBUG : BROWSER_OUTPUT:
17:06:44 INFO - 2015-10-21 17:06:44,029 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49263/tests/kraken/driver.html?testName=audio-dft)
17:06:44 INFO - 2015-10-21 17:06:44,602 DEBUG : BROWSER_OUTPUT: RSS: Main: 224362496
17:06:44 INFO - 2015-10-21 17:06:44,602 DEBUG : BROWSER_OUTPUT:
17:06:47 INFO - 2015-10-21 17:06:47,223 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49263/tests/kraken/driver.html?testName=audio-fft)
17:06:47 INFO - 2015-10-21 17:06:47,798 DEBUG : BROWSER_OUTPUT: RSS: Main: 210690048
17:06:47 INFO - 2015-10-21 17:06:47,798 DEBUG : BROWSER_OUTPUT:
17:06:49 INFO - 2015-10-21 17:06:49,690 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49263/tests/kraken/driver.html?testName=audio-oscillator)
17:06:50 INFO - 2015-10-21 17:06:50,257 DEBUG : BROWSER_OUTPUT: RSS: Main: 205271040
17:06:50 INFO - 2015-10-21 17:06:50,257 DEBUG : BROWSER_OUTPUT:
17:06:52 INFO - 2015-10-21 17:06:52,355 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49263/tests/kraken/driver.html?testName=imaging-gaussian-blur)
17:06:52 INFO - 2015-10-21 17:06:52,920 DEBUG : BROWSER_OUTPUT: RSS: Main: 209641472
17:06:52 INFO - 2015-10-21 17:06:52,920 DEBUG : BROWSER_OUTPUT:
17:06:55 INFO - 2015-10-21 17:06:55,928 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49263/tests/kraken/driver.html?testName=imaging-darkroom)
17:06:56 INFO - 2015-10-21 17:06:56,513 DEBUG : BROWSER_OUTPUT: RSS: Main: 204263424
17:06:56 INFO - 2015-10-21 17:06:56,513 DEBUG : BROWSER_OUTPUT:
17:06:59 INFO - 2015-10-21 17:06:59,775 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49263/tests/kraken/driver.html?testName=imaging-desaturate)
17:07:00 INFO - 2015-10-21 17:07:00,345 DEBUG : BROWSER_OUTPUT: RSS: Main: 203837440
17:07:00 INFO - 2015-10-21 17:07:00,345 DEBUG : BROWSER_OUTPUT:
17:07:03 INFO - 2015-10-21 17:07:03,194 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49263/tests/kraken/driver.html?testName=json-parse-financial)
17:07:03 INFO - 2015-10-21 17:07:03,776 DEBUG : BROWSER_OUTPUT: RSS: Main: 201494528
17:07:03 INFO - 2015-10-21 17:07:03,776 DEBUG : BROWSER_OUTPUT:
17:07:05 INFO - 2015-10-21 17:07:05,494 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49263/tests/kraken/driver.html?testName=json-stringify-tinderbox)
17:07:06 INFO - 2015-10-21 17:07:06,059 DEBUG : BROWSER_OUTPUT: RSS: Main: 231014400
17:07:06 INFO - 2015-10-21 17:07:06,059 DEBUG : BROWSER_OUTPUT:
17:07:07 INFO - 2015-10-21 17:07:07,811 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-aes)
17:07:08 INFO - 2015-10-21 17:07:08,384 DEBUG : BROWSER_OUTPUT: RSS: Main: 236232704
17:07:08 INFO - 2015-10-21 17:07:08,384 DEBUG : BROWSER_OUTPUT:
17:07:10 INFO - 2015-10-21 17:07:10,510 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-ccm)
17:07:11 INFO - 2015-10-21 17:07:11,085 DEBUG : BROWSER_OUTPUT: RSS: Main: 225161216
17:07:11 INFO - 2015-10-21 17:07:11,085 DEBUG : BROWSER_OUTPUT:
17:07:13 INFO - 2015-10-21 17:07:13,484 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2)
17:07:14 INFO - 2015-10-21 17:07:14,062 DEBUG : BROWSER_OUTPUT: RSS: Main: 226689024
17:07:14 INFO - 2015-10-21 17:07:14,062 DEBUG : BROWSER_OUTPUT:
17:07:16 INFO - 2015-10-21 17:07:16,680 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative)
17:07:17 INFO - 2015-10-21 17:07:17,256 DEBUG : BROWSER_OUTPUT: RSS: Main: 225562624
17:07:17 INFO - 2015-10-21 17:07:17,256 DEBUG : BROWSER_OUTPUT:
17:07:18 INFO - 2015-10-21 17:07:18,930 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49263/tests/kraken/driver.html?testName=ai-astar)
17:07:19 INFO - 2015-10-21 17:07:19,177 DEBUG : BROWSER_OUTPUT: RSS: Main: 280473600
17:07:19 INFO - 2015-10-21 17:07:19,177 DEBUG : BROWSER_OUTPUT:
17:07:19 INFO - 2015-10-21 17:07:19,178 DEBUG : BROWSER_OUTPUT: __start_tp_report
17:07:19 INFO - 2015-10-21 17:07:19,178 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load
17:07:19 INFO - 2015-10-21 17:07:19,178 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details
17:07:19 INFO - 2015-10-21 17:07:19,178 DEBUG : BROWSER_OUTPUT: |i|pagename|runs|
17:07:19 INFO - 2015-10-21 17:07:19,178 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;109;106;110;110;110;109;110;105;110
17:07:19 INFO - 2015-10-21 17:07:19,178 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;132;120;138;153;124;127;128;125;148;125
17:07:19 INFO - 2015-10-21 17:07:19,178 DEBUG : BROWSER_OUTPUT: |2;audio-dft;141;141;141;144;151;141;139;142;139;139
17:07:19 INFO - 2015-10-21 17:07:19,178 DEBUG : BROWSER_OUTPUT: |3;audio-fft;68;71;69;91;67;68;69;69;100;67
17:07:19 INFO - 2015-10-21 17:07:19,178 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;88;87;107;87;87;87;112;87;88;113
17:07:19 INFO - 2015-10-21 17:07:19,178 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;113;111;111;110;110;111;110;112;110
17:07:19 INFO - 2015-10-21 17:07:19,178 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;132;132;132;132;132;132;132;132;132;132
17:07:19 INFO - 2015-10-21 17:07:19,178 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;96;98;96;100;97;97;98;96
17:07:19 INFO - 2015-10-21 17:07:19,178 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;73;71;71;71;72;72;85;71;70
17:07:19 INFO - 2015-10-21 17:07:19,178 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;65;65;65;64;63;64;64;64;64
17:07:19 INFO - 2015-10-21 17:07:19,180 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;88;87;87;88;88;89;88;88;88;89
17:07:19 INFO - 2015-10-21 17:07:19,180 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;119;120;116;117;113;122;119;115;113
17:07:19 INFO - 2015-10-21 17:07:19,180 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;154;146;156;154;154;146;155;158;155;157
17:07:19 INFO - 2015-10-21 17:07:19,180 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;68;67;68;69;67;68;67;68;68
17:07:19 INFO - 2015-10-21 17:07:19,180 DEBUG : BROWSER_OUTPUT: __end_tp_report
17:07:19 INFO - 2015-10-21 17:07:19,180 DEBUG : BROWSER_OUTPUT: __start_cc_report
17:07:19 INFO - 2015-10-21 17:07:19,180 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,930
17:07:19 INFO - 2015-10-21 17:07:19,180 DEBUG : BROWSER_OUTPUT: __end_cc_report
17:07:19 INFO - 2015-10-21 17:07:19,180 DEBUG : BROWSER_OUTPUT: __startTimestamp1445472439178__endTimestamp
17:07:19 INFO - 2015-10-21 17:07:19,180 DEBUG : BROWSER_OUTPUT:
17:07:19 INFO - 2015-10-21 17:07:19,180 DEBUG : BROWSER_OUTPUT: ------- Summary: start -------
17:07:19 INFO - 2015-10-21 17:07:19,181 DEBUG : BROWSER_OUTPUT: Number of tests: 14
17:07:19 INFO - 2015-10-21 17:07:19,181 DEBUG : BROWSER_OUTPUT:
17:07:19 INFO - 2015-10-21 17:07:19,181 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.10 Median:110.00 stddev:2.08 (1.9%) stddev-sans-first:1.92
17:07:19 INFO - 2015-10-21 17:07:19,181 DEBUG : BROWSER_OUTPUT: Values: 112.0 109.0 106.0 110.0 110.0 110.0 109.0 110.0 105.0 110.0
17:07:19 INFO - 2015-10-21 17:07:19,181 DEBUG : BROWSER_OUTPUT:
17:07:19 INFO - 2015-10-21 17:07:19,181 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:132.00 Median:130.00 stddev:10.95 (8.4%) stddev-sans-first:11.62
17:07:19 INFO - 2015-10-21 17:07:19,181 DEBUG : BROWSER_OUTPUT: Values: 132.0 120.0 138.0 153.0 124.0 127.0 128.0 125.0 148.0 125.0
17:07:19 INFO - 2015-10-21 17:07:19,183 DEBUG : BROWSER_OUTPUT:
17:07:19 INFO - 2015-10-21 17:07:19,183 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:141.80 Median:141.00 stddev:3.58 (2.5%) stddev-sans-first:3.79
17:07:19 INFO - 2015-10-21 17:07:19,183 DEBUG : BROWSER_OUTPUT: Values: 141.0 141.0 141.0 144.0 151.0 141.0 139.0 142.0 139.0 139.0
17:07:19 INFO - 2015-10-21 17:07:19,183 DEBUG : BROWSER_OUTPUT:
17:07:19 INFO - 2015-10-21 17:07:19,183 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:73.90 Median:69.00 stddev:11.64 (16.9%) stddev-sans-first:12.15
17:07:19 INFO - 2015-10-21 17:07:19,183 DEBUG : BROWSER_OUTPUT: Values: 68.0 71.0 69.0 91.0 67.0 68.0 69.0 69.0 100.0 67.0
17:07:19 INFO - 2015-10-21 17:07:19,184 DEBUG : BROWSER_OUTPUT:
17:07:19 INFO - 2015-10-21 17:07:19,184 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:94.30 Median:87.00 stddev:11.40 (13.1%) stddev-sans-first:11.86
17:07:19 INFO - 2015-10-21 17:07:19,184 DEBUG : BROWSER_OUTPUT: Values: 88.0 87.0 107.0 87.0 87.0 87.0 112.0 87.0 88.0 113.0
17:07:19 INFO - 2015-10-21 17:07:19,187 DEBUG : BROWSER_OUTPUT:
17:07:19 INFO - 2015-10-21 17:07:19,187 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.80 Median:111.00 stddev:1.03 (0.9%) stddev-sans-first:1.05
17:07:19 INFO - 2015-10-21 17:07:19,187 DEBUG : BROWSER_OUTPUT: Values: 110.0 113.0 111.0 111.0 110.0 110.0 111.0 110.0 112.0 110.0
17:07:19 INFO - 2015-10-21 17:07:19,188 DEBUG : BROWSER_OUTPUT:
17:07:19 INFO - 2015-10-21 17:07:19,188 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:132.00 Median:132.00 stddev:0.00 (0.0%) stddev-sans-first:0.00
17:07:19 INFO - 2015-10-21 17:07:19,188 DEBUG : BROWSER_OUTPUT: Values: 132.0 132.0 132.0 132.0 132.0 132.0 132.0 132.0 132.0 132.0
17:07:19 INFO - 2015-10-21 17:07:19,188 DEBUG : BROWSER_OUTPUT:
17:07:19 INFO - 2015-10-21 17:07:19,190 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:97.10 Median:97.00 stddev:1.29 (1.3%) stddev-sans-first:1.30
17:07:19 INFO - 2015-10-21 17:07:19,190 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 96.0 98.0 96.0 100.0 97.0 97.0 98.0 96.0
17:07:19 INFO - 2015-10-21 17:07:19,190 DEBUG : BROWSER_OUTPUT:
17:07:19 INFO - 2015-10-21 17:07:19,190 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.80 Median:72.00 stddev:4.37 (6.1%) stddev-sans-first:4.62
17:07:19 INFO - 2015-10-21 17:07:19,190 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 71.0 71.0 71.0 72.0 72.0 85.0 71.0 70.0
17:07:19 INFO - 2015-10-21 17:07:19,190 DEBUG : BROWSER_OUTPUT:
17:07:19 INFO - 2015-10-21 17:07:19,190 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:0.63 (1.0%) stddev-sans-first:0.67
17:07:19 INFO - 2015-10-21 17:07:19,191 DEBUG : BROWSER_OUTPUT: Values: 64.0 65.0 65.0 65.0 64.0 63.0 64.0 64.0 64.0 64.0
17:07:19 INFO - 2015-10-21 17:07:19,191 DEBUG : BROWSER_OUTPUT:
17:07:19 INFO - 2015-10-21 17:07:19,191 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:88.00 Median:88.00 stddev:0.67 (0.8%) stddev-sans-first:0.71
17:07:19 INFO - 2015-10-21 17:07:19,191 DEBUG : BROWSER_OUTPUT: Values: 88.0 87.0 87.0 88.0 88.0 89.0 88.0 88.0 88.0 89.0
17:07:19 INFO - 2015-10-21 17:07:19,193 DEBUG : BROWSER_OUTPUT:
17:07:19 INFO - 2015-10-21 17:07:19,193 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:117.30 Median:119.00 stddev:3.02 (2.5%) stddev-sans-first:3.14
17:07:19 INFO - 2015-10-21 17:07:19,193 DEBUG : BROWSER_OUTPUT: Values: 119.0 119.0 120.0 116.0 117.0 113.0 122.0 119.0 115.0 113.0
17:07:19 INFO - 2015-10-21 17:07:19,194 DEBUG : BROWSER_OUTPUT:
17:07:19 INFO - 2015-10-21 17:07:19,194 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.50 Median:155.00 stddev:4.17 (2.7%) stddev-sans-first:4.42
17:07:19 INFO - 2015-10-21 17:07:19,194 DEBUG : BROWSER_OUTPUT: Values: 154.0 146.0 156.0 154.0 154.0 146.0 155.0 158.0 155.0 157.0
17:07:19 INFO - 2015-10-21 17:07:19,194 DEBUG : BROWSER_OUTPUT:
17:07:19 INFO - 2015-10-21 17:07:19,194 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.67
17:07:19 INFO - 2015-10-21 17:07:19,194 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 67.0 68.0 69.0 67.0 68.0 67.0 68.0 68.0
17:07:19 INFO - 2015-10-21 17:07:19,194 DEBUG : BROWSER_OUTPUT: -------- Summary: end --------
17:07:19 INFO - 2015-10-21 17:07:19,194 DEBUG : BROWSER_OUTPUT:
17:07:19 INFO - 2015-10-21 17:07:19,854 INFO : Browser exited with error code: 0
17:07:20 INFO - 2015-10-21 17:07:20,703 INFO : Completed test kraken (00:01:00)
17:07:20 INFO - 2015-10-21 17:07:20,703 INFO : Starting test v8_7
17:07:20 INFO - 2015-10-21 17:07:20,703 DEBUG : operating with platform_type : w8_
17:07:20 INFO - 2015-10-21 17:07:20,703 INFO : Initialising browser for v8_7 test...
17:07:20 INFO - 2015-10-21 17:07:20,726 DEBUG : command line: C:\slave\test-pgo\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpcnz2uj\profile http://localhost:49263/getInfo.html
17:07:25 INFO - 2015-10-21 17:07:25,678 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200
17:07:25 INFO - 2015-10-21 17:07:25,678 DEBUG : BROWSER_OUTPUT: colorDepth:24
17:07:25 INFO - 2015-10-21 17:07:25,678 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674
17:07:25 INFO - 2015-10-21 17:07:25,678 DEBUG : BROWSER_OUTPUT: __metrics
17:07:25 INFO - 2015-10-21 17:07:25,888 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver]
17:07:26 INFO - 2015-10-21 17:07:26,835 DEBUG : BROWSER_OUTPUT: console.error:
17:07:26 INFO - 2015-10-21 17:07:26,838 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]
17:07:26 INFO - 2015-10-21 17:07:26,838 DEBUG : BROWSER_OUTPUT: Stack:
17:07:26 INFO - 2015-10-21 17:07:26,838 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<._executeStatement@resource://gre/modules/Sqlite.jsm:758:19
17:07:26 INFO - 2015-10-21 17:07:26,838 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached/<@resource://gre/modules/Sqlite.jsm:493:9
17:07:26 INFO - 2015-10-21 17:07:26,838 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached@resource://gre/modules/Sqlite.jsm:491:1
17:07:26 INFO - 2015-10-21 17:07:26,838 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeBeforeShutdown/loggedDb<.executeCached.value<@resource://gre/modules/Sqlite.jsm:368:51
17:07:26 INFO - 2015-10-21 17:07:26,838 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40
17:07:26 INFO - 2015-10-21 17:07:26,838 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3
17:07:26 INFO - 2015-10-21 17:07:26,838 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14
17:07:26 INFO - 2015-10-21 17:07:26,838 DEBUG : BROWSER_OUTPUT: setAncestorsLastModified<@resource://gre/modules/Bookmarks.jsm:1347:9
17:07:26 INFO - 2015-10-21 17:07:26,838 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40
17:07:26 INFO - 2015-10-21 17:07:26,838 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3
17:07:26 INFO - 2015-10-21 17:07:26,838 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14
17:07:26 INFO - 2015-10-21 17:07:26,838 DEBUG : BROWSER_OUTPUT: transaction@resource://gre/modules/Bookmarks.jsm:808:13
17:07:26 INFO - 2015-10-21 17:07:26,838 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40
17:07:26 INFO - 2015-10-21 17:07:26,838 DEBUG : BROWSER_OUTPUT: Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:934:23
17:07:26 INFO - 2015-10-21 17:07:26,838 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7
17:07:26 INFO - 2015-10-21 17:07:26,838 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11
17:07:26 INFO - 2015-10-21 17:07:26,838 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7
17:07:26 INFO - 2015-10-21 17:07:26,838 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7
17:07:26 INFO - 2015-10-21 17:07:26,838 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13
17:07:26 INFO - 2015-10-21 17:07:26,838 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9
17:07:26 INFO - 2015-10-21 17:07:26,838 DEBUG : BROWSER_OUTPUT:
17:07:27 INFO - 2015-10-21 17:07:27,546 INFO : Browser initialized.
17:07:27 INFO - 2015-10-21 17:07:27,546 INFO : Running cycle 1/1 for v8_7 test...
17:07:27 INFO - 2015-10-21 17:07:27,546 DEBUG : command line: C:\slave\test-pgo\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpcnz2uj\profile -tp file:\C:\slave\test-pgo\build\tests\talos\talos\tests\v8_7\v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1
17:07:38 INFO - 2015-10-21 17:07:38,915 DEBUG : BROWSER_OUTPUT: RSS: Main: 188850176
17:07:38 INFO - 2015-10-21 17:07:38,915 DEBUG : BROWSER_OUTPUT:
17:08:00 INFO - 2015-10-21 17:08:00,809 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/v8_7/run.html (next: http://localhost:49263/tests/v8_7/run.html)
17:08:01 INFO - 2015-10-21 17:08:01,055 DEBUG : BROWSER_OUTPUT: RSS: Main: 688295936
17:08:01 INFO - 2015-10-21 17:08:01,055 DEBUG : BROWSER_OUTPUT:
17:08:01 INFO - 2015-10-21 17:08:01,056 DEBUG : BROWSER_OUTPUT: __start_tp_report
17:08:01 INFO - 2015-10-21 17:08:01,056 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load
17:08:01 INFO - 2015-10-21 17:08:01,058 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details
17:08:01 INFO - 2015-10-21 17:08:01,058 DEBUG : BROWSER_OUTPUT: |i|pagename|runs|
17:08:01 INFO - 2015-10-21 17:08:01,058 DEBUG : BROWSER_OUTPUT: |0;Richards;163.45210853220007
17:08:01 INFO - 2015-10-21 17:08:01,058 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;174.24638438752396
17:08:01 INFO - 2015-10-21 17:08:01,058 DEBUG : BROWSER_OUTPUT: |2;Encrypt;286.4508736751647
17:08:01 INFO - 2015-10-21 17:08:01,058 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5040.201005025126
17:08:01 INFO - 2015-10-21 17:08:01,058 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1569.8587127158555
17:08:01 INFO - 2015-10-21 17:08:01,059 DEBUG : BROWSER_OUTPUT: |5;Earley;671.1409395973154
17:08:01 INFO - 2015-10-21 17:08:01,059 DEBUG : BROWSER_OUTPUT: |6;Boyer;12537.5
17:08:01 INFO - 2015-10-21 17:08:01,059 DEBUG : BROWSER_OUTPUT: |7;RegExp;27324.324324324323
17:08:01 INFO - 2015-10-21 17:08:01,059 DEBUG : BROWSER_OUTPUT: |8;Splay;805.0964187327824
17:08:01 INFO - 2015-10-21 17:08:01,059 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4854.368932038835
17:08:01 INFO - 2015-10-21 17:08:01,059 DEBUG : BROWSER_OUTPUT: __end_tp_report
17:08:01 INFO - 2015-10-21 17:08:01,059 DEBUG : BROWSER_OUTPUT: __startTimestamp1445472481056__endTimestamp
17:08:01 INFO - 2015-10-21 17:08:01,059 DEBUG : BROWSER_OUTPUT:
17:08:01 INFO - 2015-10-21 17:08:01,059 DEBUG : BROWSER_OUTPUT: ------- Summary: start -------
17:08:01 INFO - 2015-10-21 17:08:01,059 DEBUG : BROWSER_OUTPUT: Number of tests: 10
17:08:01 INFO - 2015-10-21 17:08:01,059 DEBUG : BROWSER_OUTPUT:
17:08:01 INFO - 2015-10-21 17:08:01,059 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.45 Median:163.45 stddev:0.00 (0.0%)
17:08:01 INFO - 2015-10-21 17:08:01,059 DEBUG : BROWSER_OUTPUT: Values: 163.5
17:08:01 INFO - 2015-10-21 17:08:01,059 DEBUG : BROWSER_OUTPUT:
17:08:01 INFO - 2015-10-21 17:08:01,059 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:174.25 Median:174.25 stddev:0.00 (0.0%)
17:08:01 INFO - 2015-10-21 17:08:01,059 DEBUG : BROWSER_OUTPUT: Values: 174.2
17:08:01 INFO - 2015-10-21 17:08:01,059 DEBUG : BROWSER_OUTPUT:
17:08:01 INFO - 2015-10-21 17:08:01,059 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:286.45 Median:286.45 stddev:0.00 (0.0%)
17:08:01 INFO - 2015-10-21 17:08:01,059 DEBUG : BROWSER_OUTPUT: Values: 286.5
17:08:01 INFO - 2015-10-21 17:08:01,059 DEBUG : BROWSER_OUTPUT:
17:08:01 INFO - 2015-10-21 17:08:01,059 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5040.20 Median:5040.20 stddev:0.00 (0.0%)
17:08:01 INFO - 2015-10-21 17:08:01,059 DEBUG : BROWSER_OUTPUT: Values: 5040.2
17:08:01 INFO - 2015-10-21 17:08:01,059 DEBUG : BROWSER_OUTPUT:
17:08:01 INFO - 2015-10-21 17:08:01,059 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1569.86 Median:1569.86 stddev:0.00 (0.0%)
17:08:01 INFO - 2015-10-21 17:08:01,059 DEBUG : BROWSER_OUTPUT: Values: 1569.9
17:08:01 INFO - 2015-10-21 17:08:01,061 DEBUG : BROWSER_OUTPUT:
17:08:01 INFO - 2015-10-21 17:08:01,061 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:671.14 Median:671.14 stddev:0.00 (0.0%)
17:08:01 INFO - 2015-10-21 17:08:01,061 DEBUG : BROWSER_OUTPUT: Values: 671.1
17:08:01 INFO - 2015-10-21 17:08:01,061 DEBUG : BROWSER_OUTPUT:
17:08:01 INFO - 2015-10-21 17:08:01,061 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12537.50 Median:12537.50 stddev:0.00 (0.0%)
17:08:01 INFO - 2015-10-21 17:08:01,061 DEBUG : BROWSER_OUTPUT: Values: 12537.5
17:08:01 INFO - 2015-10-21 17:08:01,061 DEBUG : BROWSER_OUTPUT:
17:08:01 INFO - 2015-10-21 17:08:01,061 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27324.32 Median:27324.32 stddev:0.00 (0.0%)
17:08:01 INFO - 2015-10-21 17:08:01,061 DEBUG : BROWSER_OUTPUT: Values: 27324.3
17:08:01 INFO - 2015-10-21 17:08:01,061 DEBUG : BROWSER_OUTPUT:
17:08:01 INFO - 2015-10-21 17:08:01,061 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:805.10 Median:805.10 stddev:0.00 (0.0%)
17:08:01 INFO - 2015-10-21 17:08:01,061 DEBUG : BROWSER_OUTPUT: Values: 805.1
17:08:01 INFO - 2015-10-21 17:08:01,061 DEBUG : BROWSER_OUTPUT:
17:08:01 INFO - 2015-10-21 17:08:01,061 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%)
17:08:01 INFO - 2015-10-21 17:08:01,062 DEBUG : BROWSER_OUTPUT: Values: 4854.4
17:08:01 INFO - 2015-10-21 17:08:01,062 DEBUG : BROWSER_OUTPUT: -------- Summary: end --------
17:08:01 INFO - 2015-10-21 17:08:01,062 DEBUG : BROWSER_OUTPUT:
17:08:01 INFO - 2015-10-21 17:08:01,704 INFO : Browser exited with error code: 0
17:08:02 INFO - 2015-10-21 17:08:02,400 INFO : Completed test v8_7 (00:00:41)
17:08:02 INFO - 2015-10-21 17:08:02,746 INFO : Completed test suite (00:20:22)
17:08:02 INFO - 2015-10-21 17:08:02,746 DEBUG : Working with test: dromaeo_css
17:08:02 INFO - 2015-10-21 17:08:02,746 DEBUG : Generating results file: dromaeo_css
17:08:02 INFO - 2015-10-21 17:08:02,747 DEBUG : Working with test: kraken
17:08:02 INFO - 2015-10-21 17:08:02,747 DEBUG : Generating results file: kraken
17:08:02 INFO - 2015-10-21 17:08:02,747 INFO : javascript benchmark
17:08:02 INFO - 2015-10-21 17:08:02,747 DEBUG : Working with test: v8_7
17:08:02 INFO - 2015-10-21 17:08:02,747 DEBUG : Generating results file: v8_7
17:08:02 INFO - 2015-10-21 17:08:02,747 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0
17:08:03 INFO - 2015-10-21 17:08:03,032 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,31]]
17:08:03 INFO - 2015-10-21 17:08:03,032 DEBUG : process_Request line: dromaeo_css 6795.27 graph.html#tests=[[72,64,31]]
17:08:03 INFO - 2015-10-21 17:08:03,032 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0
17:08:03 INFO - 2015-10-21 17:08:03,197 DEBUG : process_Request line: kraken 1454.50 graph.html#tests=[[232,64,31]]
17:08:03 INFO - 2015-10-21 17:08:03,197 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0
17:08:03 INFO - 2015-10-21 17:08:03,365 DEBUG : process_Request line: v8_7 20100.28 graph.html#tests=[[230,64,31]]
17:08:03 INFO - 2015-10-21 17:08:03,367 INFO : javascript benchmark
17:08:03 INFO - 2015-10-21 17:08:03,368 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [351.82232972348976, 358.20478537646426, 360.13387802335376, 361.38203671721357, 363.433044450657, 15252.771208431855, 15889.841101588981, 17360.91319543402, 18546.62906741866, 19539.41381758548, 17010.659786804288, 17142.314307427718, 17291.30834766611, 17888.37390691326, 17967.460976170703, 5304.734763261841, 5414.10667239905, 5428.267183930158, 5436.945630543683, 5459.352214176121, 4171.749695018293, 4257.063446041881, 5387.703676297802, 6029.427204415573, 6206.131141640174, 6214.5960512566535, 6233.657148856811, 6265.498760099181, 6280.968595157041, 6316.778912738055, 4734.881627959311, 4886.755662216893, 4894.388201474816, 4896.583790377822, 4904.411470623512, 4222.303319952204, 4235.174141042498, 4240.257954857888, 4243.936340954888, 4243.9814444533395, 13367.732645347136, 13733.969952253521, 13968.720625587534, 14114.294285285694, 14114.435422583085, 2076.7404074490687, 2119.607872543569, 2139.828813694901, 2161.2651698422455, 2217.4899773052125, 9939.0, 9970.202383809277, 9974.750631234205, 10119.949400253025, 10261.743456413575, 1735.9844490972796, 1751.0106789663798, 1784.9018303993275, 1804.215166402606, 1815.0380298441846, 68496.6575167126, 69367.0, 69415.0, 69673.0, 70217.64891175562, 6745.3591908768585, 6792.354726301092, 6802.0, 6804.897926531106, 6887.931120688729, 7977.880331795028, 8056.355491560661, 8058.556779377073, 8060.637271322805, 8061.1938806118915, 5549.528290095306, 5552.3892371839065, 5598.496135347838, 5601.383847776741, 5619.241402410622, 5814.069748840166, 5840.3575606683235, 5866.7066646668345, 5882.3529411764675, 5917.142014407887, 3112.299732560201, 3130.733887619532, 3143.0885043337635, 3151.889683861054, 3165.287810242677, 1115.0243536905207, 1129.4578602270956, 1135.2167004766684, 1159.8782127876452, 1192.379962419537, 457.90612924350427, 463.57351236862166, 468.49168652012264, 473.62820186153704, 475.05701183151416, 11194.832077518844, 11325.433728313716, 11443.313401195956, 11549.711257218469, 11618.593349232737, 478.7701903086538, 483.84033269021137, 490.2278910715637, 498.7830293822199, 499.2286916713686, 6360.727854429133, 6571.704273307617, 6654.334566543307, 6685.431738302202, 6688.097106890507, 519561.0, 582483.0, 624004.0, 635707.0, 638956.0, 86904.0, 86994.56502717445, 87121.0, 87866.12133878707, 87987.0, 517.0073458958808, 522.2140678279166, 531.404826594217, 543.1933578635723, 552.1717423864284, 10911.0, 11297.887021130013, 11406.201565890307, 11423.543058277575, 11452.656420307405, 34947.92758789335, 35626.0, 35898.641013590575, 36043.27913441769, 36664.450033250054, 49622.25566616432, 49758.0, 50187.0, 50510.242346364095, 50645.0, 6597.241317248578, 6634.83412914681, 6641.26946035926, 6646.003099535108, 6654.234763002317, 12180.817287740514, 12368.4434200463, 12397.62807115788, 12420.875791241971, 12461.563845265373, 10710.357378557312, 10829.945850270698, 10906.836397453886, 11059.61291354831, 11066.778664426827, 10573.52419141125, 10610.098141658045, 10690.465476725976, 10714.0, 10974.122070234522, 10928.78142437131, 11089.889101108885, 11111.444427778417, 11183.776324473301, 11217.373480845396, 6462.030695395728, 6551.770688025897, 6570.638614876228, 6571.277159512354, 6587.868242635216, 10725.785484290427, 10839.295445795999, 10858.457077145953, 10878.347299162075, 10979.780404392028], "dojo.html": [2909.4666971392235, 2912.6941671124528, 2955.2611847038243, 2983.06033599416, 3003.1441039303804, 5241.7379131043435, 5405.594580406466, 5412.675239485634, 5454.290942177511, 5511.696856672881, 5511.311086114236, 5515.917261241085, 5517.972410137953, 5518.613697041209, 5529.585281103923, 4765.666403351766, 4852.781624826891, 4892.951070489303, 4902.58328042115, 4955.207166853304, 4813.66304358695, 4818.807247710088, 4826.396700412449, 4854.56308932196, 4875.731834749087, 4865.34317867087, 4900.852974410755, 4901.950980490185, 4906.141425250585, 4960.603151747851, 4729.196036673774, 4886.462489126193, 4890.388701412341, 4896.877578060541, 4970.627202959757, 4785.425748910153, 4798.0, 4828.927566086476, 4872.829450969234, 4899.902001959941, 5329.147336426153, 5348.545373643245, 5352.009878172512, 5357.0, 5368.248445217672, 5600.5799565032785, 5713.918468642169, 5715.857103572403, 5716.79991200306, 5793.0, 5649.717514124319, 5700.087985922232, 5734.655920644775, 5746.683932383718, 5756.136579513107, 5314.9468505314835, 5318.946810531884, 5319.175527793198, 5320.574354051667, 5328.600354973354, 5783.248177736868, 5922.703864806743, 5923.141144534018, 5927.436893495197, 5937.584369094122, 5569.832905012856, 5593.356763972195, 5655.406182350876, 5675.801346952837, 5683.744231509592, 5690.487856092972, 5692.715364231854, 5701.743421545957, 5729.341125770507, 5761.711914404263, 5587.804426845041, 5589.9938011157565, 5617.41017193197, 5627.296587926509, 5632.239647647597, 5621.184928185472, 5654.180143879114, 5660.29246344207, 5677.460641239076, 5722.54219662426, 3536.2397084626414, 3549.5208146899836, 3559.839807208682, 3567.94648080279, 3590.7127429805555, 3176.4917613182242, 3248.6101667800017, 3249.8862539810993, 3285.5400243965864, 3287.6054873414864, 5446.972765136149, 5579.13523403873, 5580.302462192226, 5596.2165296858475, 5621.988042152452, 5756.5682573807135, 5779.913301300484, 5793.652380857162, 5825.475707186373, 5825.7378417971295, 5422.213779002022, 5591.161325801162, 5601.159826026129, 5601.551875849922, 5602.775888964396, 4467.5755803198645, 4511.639068874482, 4518.254488009507, 4521.480029796549, 4547.727136371828, 6108.572399932051, 6117.418845209698, 6120.8775824484155, 6132.294786099566, 6135.141080248769, 5669.659820410789, 5816.767329306949, 5818.50542703858, 5819.854503637443, 5825.0679891217205, 6073.878522429438, 6083.66539840313, 6094.4521043914465, 6118.816435506942, 6134.26388833325, 5713.428657134254, 5716.256886604715, 5719.513841323368, 5737.110747834093, 5749.798757043651, 5737.74180161902, 5808.82573522795, 5818.0981947798155, 5819.5635327351465, 5826.82519524415, 5648.830535083954, 5677.261955945701, 5724.885502290014, 5726.055200891973, 5768.1636162757, 5429.728513574384, 5585.245991791056, 5590.5527557796095, 5608.355039170548, 5623.8594035149445, 5381.623286370073, 5509.807156749494, 5523.972380138073, 5526.778928842962, 5537.0, 5588.273524441959, 5595.580331475075, 5645.802396916089, 5653.2085508028085, 5692.48767610917, 5527.281453411031, 5561.610687251854, 5576.442355764391, 5588.469095435927, 5617.803376881953], "mootools.html": [1270.5553056430256, 1366.419271809481, 1555.8521940415656, 1593.9442119525816, 1735.8090610032887, 8270.462419942707, 8683.696070637521, 8771.429857059287, 8810.911890881089, 8824.647014119428, 8711.215990560848, 8864.202221800037, 8884.156005179497, 9075.547912334012, 9090.409123406975, 2048.1500177426424, 2072.9792702072937, 2270.5231901300745, 2294.724633044029, 2310.9653355199603, 2267.85258958168, 2269.3645779181857, 2271.068861766676, 2277.1233075265977, 2279.851809632377, 2210.5910406574753, 2249.1228420915854, 2258.604744169772, 2261.0616594113503, 2261.819054475638, 2054.4144918698175, 2071.8031786980214, 2234.687143799853, 2239.0819763896725, 2248.078287901969, 2269.841111122222, 2301.4591570980806, 2302.4704318006784, 2322.1059891941554, 2324.953500929989, 9047.050059743699, 9097.681581144629, 9113.453192808453, 9119.49842758648, 9121.5439228039, 5120.743962801882, 5190.870228244286, 5193.169092945111, 5196.662216955886, 5198.896022079575, 3608.404613238839, 3633.3459977204093, 3657.158853463718, 3675.1730860556163, 3695.5565332160045, 1179.8997085247763, 1188.2217147768226, 1200.4417945655312, 1233.3956361382857, 1237.1958227152334, 13661.521846735317, 13685.452581896712, 13688.247146406944, 13696.589102326947, 13718.519851805138, 4404.207242696281, 4489.169503641837, 4507.684462087623, 4533.070720502289, 4544.386507821402, 10864.511097000654, 10880.836787448194, 11027.503762330714, 11045.834312485158, 11046.558137674563, 5010.549050585465, 5035.521625445577, 5037.5214354636255, 5039.0, 5040.7731652075745, 4485.573870482299, 4546.863594092182, 4550.431196100488, 4558.72647641136, 4570.428696412949, 3806.695464362844, 3809.2952803730846, 3862.1310205204168, 3870.787106709102, 3901.3757798752063, 1193.2124797633521, 1201.39329638532, 1206.6440400081997, 1209.0508950473836, 1227.1348699167065, 1027.1628622672497, 1048.1981284317503, 1048.313354752623, 1156.3524426321287, 1264.0709078827056, 8369.83260334802, 8379.49723016621, 8405.495670259805, 8412.200840920103, 8504.53225072627, 1119.205364191433, 1128.6444769897455, 1130.6947124276564, 1135.3131355529952, 1140.777548378075, 6071.362506936796, 6120.265568131764, 6152.2924863640355, 6168.321484636686, 6181.443670069715, 11011.889881101246, 11325.32048077118, 11325.338545441815, 11409.543618255177, 11433.256838305484, 11160.888391115985, 11187.272827266203, 11221.382823944761, 11286.830697539543, 11315.15136364776, 8210.58947052657, 8217.917820821714, 8256.25693687571, 8287.62705678246, 8339.749807505785, 8020.398470114881, 8030.156833532395, 8053.879191812245, 8098.87851682237, 8105.513669179868, 9757.073078057572, 9834.655787047419, 9857.30998830075, 10042.397456152363, 10206.081452669296, 10101.14140298083, 10149.64476243328, 10162.288639795144, 10318.729879426513, 10375.688729338131, 7633.427492938163, 7710.730124445618, 7797.298243158143, 7805.024371953506, 7857.2928436441, 8891.866622000545, 8896.911030889609, 8903.0, 8944.195022448012, 8948.68679596211, 8189.877151842608, 8307.08622051586, 8353.707620233263, 8414.53720045379, 8435.0, 6976.825579360354, 7900.2889739923685, 7900.920990790249, 7977.6011199438635, 8002.399820013406, 7941.920580794118, 7946.841063178819, 7977.321927636216, 7980.201979802206, 8118.350531957311, 7121.67952442131, 7174.067371241706, 7190.856182876418, 7227.651013420555, 7363.337299643058, 7314.378277846443, 7317.5609463432365, 7318.121825380988, 7349.926500734924, 7451.143118541437], "ext.html": [552.2206620993809, 580.8199458167968, 584.3105135939591, 587.667967598307, 594.2631137389639, 31771.84114079429, 32037.51943720843, 32289.192770180758, 39764.60235397645, 40257.194856102935, 41140.79429602855, 41335.0, 41465.378019329655, 41870.16259674804, 41993.7900310498, 8748.56257187143, 8898.955505222464, 8907.955460222689, 8913.910860891372, 8917.73246802597, 8075.959620201891, 8215.219554142346, 10428.374297542134, 10669.719633643974, 10730.302530335503, 10769.0, 10778.29941053829, 10779.514921828537, 10818.783624327509, 10832.241743077988, 7987.400944929153, 10534.736631584195, 10683.0, 10693.304935179227, 10697.0, 8014.078380986145, 10709.464526773709, 10751.623693170779, 10886.346819190874, 10892.183086268562, 39426.0, 39558.60441395578, 39646.20707585861, 39742.60257397418, 39807.40288895669, 3262.4453842846538, 3354.7819391739704, 3421.2131209821882, 3565.0, 3940.468036815022, 29853.74533894478, 30792.384152317052, 31007.22481937947, 31132.688673113207, 31374.52938205929, 3221.32352206037, 3229.024493138461, 3258.804471731704, 3279.9344013119844, 3404.131946353664, 330189.0, 334556.0, 334880.99999999756, 335837.0, 338602.0, 50816.0, 51028.67082533628, 57449.0, 57734.133987990215, 57898.71050644804, 55533.72233138889, 56220.0, 56409.7179514108, 56429.199824049334, 56482.43517564854, 14524.240394325256, 14664.560063198121, 14674.11955282665, 14699.55901322962, 14760.0, 11912.642620721392, 12040.096992725581, 12081.335526546125, 12086.214396064404, 12120.212186207867, 18509.444716658254, 18547.258109675462, 18578.535536611693, 18638.906805465886, 18661.0, 7806.765797025984, 8134.918650813534, 8162.26539611426, 8170.591470426455, 8216.21945915137, 941.1153515695224, 1047.69093117529, 1075.9932725466947, 1083.864516935383, 1123.719070232442, 29483.705162948525, 29730.40539189204, 29771.255718607208, 29968.700312997025, 30226.54660180099, 1030.5723124903232, 1046.7226185060965, 1052.7315534538798, 1116.2353787655481, 1176.4294317256124, 14191.968413424253, 14242.430302787772, 14329.928350358181, 14462.783058254134, 14638.121712697272, 424159.0, 424475.0, 428977.0, 431805.0, 432044.0, 51078.489215108115, 51449.0, 51455.0, 51536.22695659568, 51903.0, 1293.734784369221, 1300.9089363744447, 1323.371398585664, 1328.2760895312078, 1328.4420543371614, 27968.58047129254, 28137.859310703316, 28548.714512855437, 28723.0, 28754.71245287604, 44054.0, 44359.55640443554, 44420.77789611031, 44439.0, 44605.77697111494, 363685.0, 365439.0, 365778.0, 365994.0, 366889.0, 30206.54690179605, 30834.537481938238, 31107.688923111386, 31162.22094447657, 31180.844095780285, 43379.0, 43608.56391436045, 43832.56167438285, 44325.78371081369, 44856.775716122516, 37054.44418333673, 37536.249275014896, 37782.055448614, 37887.43168852414, 38331.425028624035, 28898.0, 31666.208344791565, 37008.444873326385, 37376.846984399235, 37428.251434971695, 34012.82993585016, 35347.46978795371, 35359.46960795538, 35555.11112222215, 35610.28779424449, 29758.85120574383, 32442.72710458818, 33553.30402596012, 34063.829680851435, 35776.64223357837, 22231.267932845294, 25909.6113558293, 25992.740072599034, 26541.469170616867, 26737.465250694488], "prototype.html": [325.04599001929336, 328.0175873259588, 331.6733017977293, 336.15457125329795, 340.99659003409977, 5700.315962084551, 5757.42425757424, 5764.423557644244, 5774.480296773295, 5777.1623114648355, 5549.805756798502, 5611.3546942101675, 5658.78336157726, 5723.456271654197, 5728.598998070137, 4347.934780978288, 4386.56134386562, 4402.713823601463, 4404.625606823424, 4407.471103467572, 4234.957650423487, 4381.780910954455, 4403.361512580674, 4406.86779396617, 4420.07178492517, 4242.639375653058, 4323.459567554056, 4340.392345071693, 4367.606915377615, 4373.475182978047, 4293.699441039113, 4361.389405483251, 4365.978170109129, 4381.627561657263, 4383.079553293812, 3826.655600995896, 3838.1556057667267, 3857.903552411184, 3874.1864208516245, 3876.6511014008593, 5497.862553436156, 5536.4186760390385, 5537.916931246034, 5540.252065971083, 5540.806071787509, 4871.36672232611, 4959.876003099916, 4977.701337919736, 5033.094043072246, 5037.798488060474, 5896.174535565025, 5903.468687818117, 5907.822765317004, 5915.792947246869, 5920.200772895647, 4116.650084742801, 4146.606072423115, 4161.791910404468, 4162.729422587522, 4168.2080404723, 6002.339742628307, 6128.754849806002, 6176.289726681399, 6201.596896201732, 6282.528810339197, 4309.353596960481, 4328.935065974013, 4338.327559228324, 4339.370791235253, 4342.565743425632, 4408.206522825923, 4411.272140096912, 4417.160739459492, 4417.580329868657, 4419.558044195554, 4973.055119527278, 5025.246213068069, 5025.472325405853, 5032.974835125801, 5043.394792624908, 5846.123081537803, 5912.526997840162, 5953.732082056318, 5972.820815375459, 5991.520678345809, 1566.216891554223, 1581.7390130628316, 1581.8259991400937, 1582.454053351592, 1582.9445969391015, 1049.338916482611, 1056.9588954879437, 1076.2735153771173, 1078.5685725709623, 1080.4381721504774, 5944.791932282349, 5962.493188078975, 5973.671448070311, 5981.551383646244, 5984.551158663031, 6144.938550614526, 6161.229846269216, 6190.0405437157315, 6192.318844927055, 6205.193324867739, 5777.826665199967, 5835.2122463466885, 5902.940970590325, 5953.553483488756, 5982.880342393128, 3368.2589830237307, 3389.6101948276264, 3391.542141810873, 3412.5563676721868, 3425.811580363054, 6526.216853977553, 6550.246721626979, 6552.082708420825, 6556.27880933097, 6580.341965803477, 6233.407826256589, 6256.249250090018, 6298.716557754912, 6305.716242769086, 6328.0, 6485.70814313357, 6490.350964903472, 6550.475961922939, 6566.9343306566325, 6577.0, 6207.534434917309, 6214.098955651496, 6215.658138802229, 6215.844603884758, 6222.657753823583, 5920.555958303231, 5997.940020599913, 6069.514438844793, 6080.787172448943, 6095.329513753395, 6615.272320044695, 6630.602163870183, 6632.535722499379, 6633.635150066792, 6634.9004764927595, 4332.0, 4339.067100573392, 4375.453068366454, 4382.342648602735, 4385.627221686193, 6131.478824299985, 6228.408301211378, 6277.435030847246, 6286.874262514815, 6291.433770960635, 6080.087986802015, 6082.847928801815, 6083.6349819011, 6089.786857459968, 6090.634561926298, 6020.217371741645, 6030.577859549965, 6039.0, 6040.063790112539, 6042.365551617193, 5842.357340692435, 5944.970275148597, 5947.988841896801, 5949.851253718692, 5961.8807623846415, 6038.305594856648, 6044.274687037584, 6045.183900173421, 6045.425684559959, 6048.304444988883, 5929.110633405024, 5972.0, 5972.163897054503, 5976.61152025117, 5980.700964951822], "yui.html": [792.8017995501125, 852.3735054734769, 856.3320609924261, 861.5606040919133, 861.9310455163586, 11959.402029898503, 12218.144729868902, 12225.816612750816, 12257.958073563736, 12262.632121036371, 12538.874611253885, 12576.748465030694, 12589.937050314735, 12621.62135135945, 12640.49438022478, 637.1144109687526, 643.2120652201063, 744.8361360500709, 762.9923700763004, 763.385474692872, 756.3911051603457, 757.4508481351031, 762.5158024654329, 765.0742601452249, 769.7036640893241, 673.2594146438927, 798.2017982017982, 808.1312588966855, 809.1786836361098, 810.7648781853285, 681.7170874087248, 800.2117913854848, 808.7735434078468, 809.4172196018857, 810.068421315486, 595.4313630482878, 595.9046552551571, 595.9582829201958, 598.1356939222825, 598.6707310978944, 12228.938855305667, 12245.816312755316, 12366.505339786398, 12366.938165309206, 12382.133250672456, 11415.372154531497, 11483.655490335303, 11569.826452603218, 11816.46825892837, 12123.878761212363, 9686.660966866197, 9706.902930970671, 9850.50747462631, 9927.106560409526, 10148.492575371201, 3711.6823527647834, 3714.164313029574, 3752.2683076800035, 3764.9247015059545, 3790.298794722985, 43983.560164398266, 44109.33835992463, 44158.33762493565, 44349.3347599783, 45561.088778224585, 9546.474943878015, 9727.854082188773, 9816.263780216512, 9864.704058878246, 9966.651167209258, 17398.739018914726, 17433.21550530229, 17445.30218791234, 17447.12764361777, 17451.0, 7294.96352518234, 7539.698412063566, 7646.350060244941, 7683.001209842796, 7711.460197786101, 4269.060806622538, 4270.252705776476, 4273.166732487197, 4357.477102747691, 4415.845445409395, 3095.520194369876, 3114.9065528034193, 3120.547520609499, 3121.266502371941, 3126.6873312669004, 499.6677209655611, 521.4368482039388, 526.3236740788069, 533.6797921247221, 538.9678765164743, 579.4234736437272, 590.4213870407025, 642.2742301199614, 654.607235658601, 794.2613369566243, 8925.018247992715, 8926.330525210635, 8952.373333866697, 8980.236679882284, 9048.0, 640.6732566391174, 743.382992116542, 778.2878666020641, 781.5467029123095, 793.123598423745, 4196.601322874322, 4273.9358909616385, 4319.719218250866, 4392.341148827638, 4450.154470650566, 54915.45084549103, 55711.164332535045, 57066.0, 57362.0, 57732.0, 48603.513964860605, 49090.50909490859, 49357.0, 49404.0, 49469.257961130614, 40778.18443631111, 40874.38688419676, 41083.58916410858, 41851.7907410461, 42228.57771422308, 8331.583420828812, 8343.165683431609, 8410.411271210956, 8421.4947103174, 8439.620217090369, 29454.0, 29780.255493612833, 29863.85068074646, 30109.849450752605, 30358.84820575883, 37892.62107379001, 39622.0, 39745.0, 40375.1924961505, 40464.39303410392, 8239.670413183645, 8329.416940814084, 8348.415610907421, 8380.994280686113, 8414.87377689323, 11979.341136237243, 11995.340256285639, 12324.445399956845, 12339.321337326533, 12371.257724536557, 10969.83545246806, 11334.94332528332, 11338.886611134112, 11355.886441135483, 11376.829347559627, 11110.888891110986, 11485.712857178638, 11556.537738490366, 11939.820902686293, 11964.401779911144, 10195.919055147559, 10479.0, 11660.941695291469, 11669.00924070681, 12037.217580857216, 9469.526523673927, 9656.806863862825, 9733.318667693193, 9831.950840245752, 10235.334703244265, 8816.42693224964, 8888.911110889067, 8939.508327042075, 9094.668453647348, 9401.294902882175]}, "summary": {"suite": 6795.273371360807, "subtests": {"jquery.html": {"filtered": 7192.414071896057, "value": 7192.414071896057}, "dojo.html": {"filtered": 5225.33675800302, "value": 5225.33675800302}, "mootools.html": {"filtered": 4952.766673326418, "value": 4952.766673326418}, "ext.html": {"filtered": 19000.980190984697, "value": 19000.980190984697}, "prototype.html": {"filtered": 4584.080109613965, "value": 4584.080109613965}, "yui.html": {"filtered": 6072.111444389463, "value": 6072.111444389463}}}, "test_machine": {"platform": "x86_64", "osversion": "6.2.9200", "os": "win", "name": "T-W864-IX-071"}, "testrun": {"date": 1445471260, "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": "20151021113233", "branch": "Fx-Team", "revision": "4babd5d32cc121f287363f63217c19029f848577"}}, {"talos_counters": {}, "results": {"audio-dft": [141.0, 141.0, 141.0, 144.0, 151.0, 141.0, 139.0, 142.0, 139.0, 139.0], "ai-astar": [112.0, 109.0, 106.0, 110.0, 110.0, 110.0, 109.0, 110.0, 105.0, 110.0], "imaging-gaussian-blur": [110.0, 113.0, 111.0, 111.0, 110.0, 110.0, 111.0, 110.0, 112.0, 110.0], "audio-beat-detection": [132.0, 120.0, 138.0, 153.0, 124.0, 127.0, 128.0, 125.0, 148.0, 125.0], "json-stringify-tinderbox": [64.0, 65.0, 65.0, 65.0, 64.0, 63.0, 64.0, 64.0, 64.0, 64.0], "stanford-crypto-pbkdf2": [154.0, 146.0, 156.0, 154.0, 154.0, 146.0, 155.0, 158.0, 155.0, 157.0], "json-parse-financial": [72.0, 73.0, 71.0, 71.0, 71.0, 72.0, 72.0, 85.0, 71.0, 70.0], "stanford-crypto-sha256-iterative": [67.0, 68.0, 67.0, 68.0, 69.0, 67.0, 68.0, 67.0, 68.0, 68.0], "audio-fft": [68.0, 71.0, 69.0, 91.0, 67.0, 68.0, 69.0, 69.0, 100.0, 67.0], "imaging-darkroom": [132.0, 132.0, 132.0, 132.0, 132.0, 132.0, 132.0, 132.0, 132.0, 132.0], "stanford-crypto-ccm": [119.0, 119.0, 120.0, 116.0, 117.0, 113.0, 122.0, 119.0, 115.0, 113.0], "audio-oscillator": [88.0, 87.0, 107.0, 87.0, 87.0, 87.0, 112.0, 87.0, 88.0, 113.0], "stanford-crypto-aes": [88.0, 87.0, 87.0, 88.0, 88.0, 89.0, 88.0, 88.0, 88.0, 89.0], "imaging-desaturate": [96.0, 97.0, 96.0, 98.0, 96.0, 100.0, 97.0, 97.0, 98.0, 96.0]}, "summary": {"suite": 1454.4999999999998, "subtests": {"audio-fft": {"filtered": 73.9, "value": 73.9}, "stanford-crypto-pbkdf2": {"filtered": 153.5, "value": 153.5}, "audio-beat-detection": {"filtered": 132.0, "value": 132.0}, "stanford-crypto-ccm": {"filtered": 117.3, "value": 117.3}, "imaging-darkroom": {"filtered": 132.0, "value": 132.0}, "json-parse-financial": {"filtered": 72.8, "value": 72.8}, "audio-oscillator": {"filtered": 94.3, "value": 94.3}, "ai-astar": {"filtered": 109.1, "value": 109.1}, "audio-dft": {"filtered": 141.8, "value": 141.8}, "stanford-crypto-sha256-iterative": {"filtered": 67.7, "value": 67.7}, "json-stringify-tinderbox": {"filtered": 64.2, "value": 64.2}, "imaging-gaussian-blur": {"filtered": 110.8, "value": 110.8}, "stanford-crypto-aes": {"filtered": 88.0, "value": 88.0}, "imaging-desaturate": {"filtered": 97.1, "value": 97.1}}}, "test_machine": {"platform": "x86_64", "osversion": "6.2.9200", "os": "win", "name": "T-W864-IX-071"}, "testrun": {"date": 1445471260, "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": "20151021113233", "branch": "Fx-Team", "revision": "4babd5d32cc121f287363f63217c19029f848577"}}, {"talos_counters": {}, "results": {"DeltaBlue": [174.24638438752396], "Encrypt": [286.4508736751647], "NavierStokes": [4854.368932038835], "Decrypt": [5040.201005025126], "Splay": [805.0964187327824], "Richards": [163.45210853220007], "RegExp": [27324.324324324323], "Earley": [671.1409395973154], "Boyer": [12537.5], "RayTrace": [1569.8587127158555]}, "summary": {"suite": 20100.283994764057, "subtests": {"DeltaBlue": {"filtered": 379.451202, "value": 379.451202}, "Encrypt": {"filtered": 929.2378710000004, "value": 929.2378710000004}, "NavierStokes": {"filtered": 305.7040000000001, "value": 305.7040000000001}, "Decrypt": {"filtered": 52.81158424725827, "value": 52.81158424725827}, "Splay": {"filtered": 101.21893242087259, "value": 101.21893242087259}, "RegExp": {"filtered": 33.33970820969339, "value": 33.33970820969339}, "Richards": {"filtered": 215.97763600000008, "value": 215.97763600000008}, "Earley": {"filtered": 993.0298700000002, "value": 993.0298700000002}, "Boyer": {"filtered": 53.15756729810566, "value": 53.15756729810566}, "RayTrace": {"filtered": 471.3729929999999, "value": 471.3729929999999}}}, "test_machine": {"platform": "x86_64", "osversion": "6.2.9200", "os": "win", "name": "T-W864-IX-071"}, "testrun": {"date": 1445471260, "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": "20151021113233", "branch": "Fx-Team", "revision": "4babd5d32cc121f287363f63217c19029f848577"}}]
17:08:03 INFO - RETURN: dromaeo_css: 6795.27
17:08:03 INFO - RETURN: kraken: 1454.50
17:08:03 INFO - RETURN: v8_7: 20100.28
17:08:03 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,31]]", "result": "20100.28"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,31]]", "result": "1454.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,31]]", "result": "6795.27"}}}
17:08:03 INFO - Return code: 0
17:08:03 INFO - # TBPL SUCCESS #
17:08:03 INFO - Running post-action listener: _resource_record_post_action
17:08:03 INFO - Running post-run listener: _resource_record_post_run
17:08:04 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 285919744; Write bytes: 396823040; Read time: 2872420; Write time: 4759560
17:08:04 INFO - install - Wall time: 2s; CPU: 13.0%; Read bytes: 0; Write bytes: 2551808; Read time: 0; Write time: 74970
17:08:04 INFO - run-tests - Wall time: 1224s; CPU: 13.0%; Read bytes: 285919744; Write bytes: 358876160; Read time: 2872420; Write time: 4576940
17:08:04 INFO - Running post-run listener: _upload_blobber_files
17:08:04 INFO - Blob upload gear active.
17:08:04 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ...
17:08:04 INFO - Copying logs to upload dir...
17:08:04 INFO - mkdir: C:\slave\test-pgo\build\upload\logs
program finished with exit code 0
elapsedTime=1386.104000
========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 24 secs) (at 2015-10-21 17:08:22.950079) =========
========= Started set props: build_url (results: 0, elapsed: 15 secs) (at 2015-10-21 17:08:22.953965) =========
'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-071\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-071
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-071
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-071\AppData\Local
LOGONSERVER=\\T-W864-IX-071
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-071
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-071
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-071
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
build_url:https://queue.taskcluster.net/v1/task/mSRAtEX0Si2W37R1CiMUxw/artifacts/public/build/firefox-44.0a1.en-US.win64.zip
program finished with exit code 0
elapsedTime=0.101000
build_url: 'https://queue.taskcluster.net/v1/task/mSRAtEX0Si2W37R1CiMUxw/artifacts/public/build/firefox-44.0a1.en-US.win64.zip'
========= Finished set props: build_url (results: 0, elapsed: 15 secs) (at 2015-10-21 17:08:37.961399) =========
========= Started 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2015-10-21 17:08:37.961765) =========
'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-071\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-071
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-071
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-071\AppData\Local
LOGONSERVER=\\T-W864-IX-071
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-071
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-071
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-071
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
program finished with exit code 0
elapsedTime=0.101000
========= Finished 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2015-10-21 17:08:40.081621) =========
========= Started reboot slave lost (results: 0, elapsed: 1 secs) (at 2015-10-21 17:08:40.081962) =========
========= Finished reboot slave lost (results: 0, elapsed: 1 secs) (at 2015-10-21 17:08:41.194639) =========