builder: mozilla-inbound_win8_64_test-dromaeojs
slave: t-w864-ix-062
starttime: 1445906689.46
results: success (0)
buildid: 20151026160202
builduid: 0454fec0cf684397aef6f637db4838d3
revision: f9cd7aa25d6f212d0cf6c48318ff47f2c4ebab88
========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-26 17:44:49.465437) =========
master: http://buildbot-master110.bb.releng.scl3.mozilla.com:8201/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-26 17:44:49.466831) =========
========= Started set props: basedir (results: 0, elapsed: 40 secs) (at 2015-10-26 17:44:49.467176) =========
'cd'
in dir C:\slave\test\. (timeout 1200 secs)
watching logfiles {}
argv: ['cd']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld.T-W864-IX-062\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-062
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-062
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-062\AppData\Local
LOGONSERVER=\\T-W864-IX-062
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
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
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-062
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-062
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-062
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
C:\slave\test
program finished with exit code 0
elapsedTime=0.668000
basedir: 'C:\\slave\\test'
========= Finished set props: basedir (results: 0, elapsed: 40 secs) (at 2015-10-26 17:45:29.952339) =========
========= Started downloading to buildprops.json (results: 0, elapsed: 8 secs) (at 2015-10-26 17:45:29.952748) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 8 secs) (at 2015-10-26 17:45:38.471619) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 11 secs) (at 2015-10-26 17:45:38.471976) =========
'rm' '-rf' 'properties'
in dir C:\slave\test\. (timeout 1200 secs)
watching logfiles {}
argv: ['rm', '-rf', 'properties']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld.T-W864-IX-062\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-062
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-062
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-062\AppData\Local
LOGONSERVER=\\T-W864-IX-062
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
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
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-062
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-062
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-062
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
program finished with exit code 0
elapsedTime=0.203000
========= Finished 'rm -rf ...' (results: 0, elapsed: 11 secs) (at 2015-10-26 17:45:49.503420) =========
========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-26 17:45:49.503715) =========
script_repo_url: https://hg.mozilla.org/build/mozharness
========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-26 17:45:49.504422) =========
========= Started 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2015-10-26 17:45:49.504908) =========
'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\. (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-062\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-062
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-062
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-062\AppData\Local
LOGONSERVER=\\T-W864-IX-062
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
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
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-062
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-062
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-062
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
--17:45:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py
=> `archiver_client.py'
Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25
Connecting to hg.mozilla.org|63.245.215.102|:443... connected.
HTTP request sent, awaiting response... 200 Script output follows
Length: 12,141 (12K) [text/x-python]
0K .......... . 100% 1.13 GB/s
17:45:51 (1.13 GB/s) - `archiver_client.py' saved [12141/12141]
program finished with exit code 0
elapsedTime=0.844000
========= Finished 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2015-10-26 17:46:01.375232) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 6 secs) (at 2015-10-26 17:46:01.375555) =========
'rm' '-rf' 'scripts'
in dir C:\slave\test\. (timeout 1200 secs)
watching logfiles {}
argv: ['rm', '-rf', 'scripts']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld.T-W864-IX-062\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-062
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-062
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-062\AppData\Local
LOGONSERVER=\\T-W864-IX-062
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
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
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-062
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-062
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-062
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
program finished with exit code 0
elapsedTime=3.211000
========= Finished 'rm -rf ...' (results: 0, elapsed: 6 secs) (at 2015-10-26 17:46:07.396214) =========
========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2015-10-26 17:46:07.396611) =========
'bash' '-c' u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev f9cd7aa25d6f212d0cf6c48318ff47f2c4ebab88 --destination scripts --debug'
in dir C:\slave\test\. (timeout 1200 secs)
watching logfiles {}
argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev f9cd7aa25d6f212d0cf6c48318ff47f2c4ebab88 --destination scripts --debug']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld.T-W864-IX-062\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-062
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-062
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-062\AppData\Local
LOGONSERVER=\\T-W864-IX-062
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
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
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-062
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-062
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-062
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
2015-10-26 17:46:08,459 truncating revision to first 12 chars
2015-10-26 17:46:08,459 Setting DEBUG logging.
2015-10-26 17:46:08,459 attempt 1/10
2015-10-26 17:46:08,459 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/f9cd7aa25d6f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2015-10-26 17:46:10,309 unpacking tar archive at: mozilla-inbound-f9cd7aa25d6f/testing/mozharness/
program finished with exit code 0
elapsedTime=2.882000
========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2015-10-26 17:46:11.485580) =========
========= Started downloading to oauth.txt (results: 0, elapsed: 1 mins, 17 secs) (at 2015-10-26 17:46:11.485945) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 1 mins, 17 secs) (at 2015-10-26 17:47:29.083811) =========
========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-26 17:47:29.090274) =========
TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production
========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-26 17:47:29.091214) =========
========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 28 secs) (at 2015-10-26 17:47:29.091546) =========
'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'dromaeojs' '--add-option' '--webServer,localhost' '--branch-name' 'Mozilla-Inbound-Non-PGO' '--system-bits' '64' '--cfg' 'talos/windows_config.py' '--download-symbols' 'ondemand' '--use-talos-json' '--blob-upload-branch' 'Mozilla-Inbound-Non-PGO'
in dir C:\slave\test\. (timeout 3600 secs) (maxTime 7200 secs)
watching logfiles {}
argv: ['c:/mozilla-build/python27/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound-Non-PGO', '--system-bits', '64', '--cfg', 'talos/windows_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound-Non-PGO']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld.T-W864-IX-062\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-062
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-062
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-062\AppData\Local
LOGONSERVER=\\T-W864-IX-062
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
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/buildprops.json
PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\
PUBLIC=C:\Users\Public
PWD=C:\slave\test
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-062
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-062
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-062
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
17:47:29 INFO - MultiFileLogger online at 20151026 17:47:29 in C:\slave\test
17:47:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound-Non-PGO --system-bits 64 --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound-Non-PGO
17:47:29 INFO - Dumping config to C:\slave\test\logs\localconfig.json.
17:47:29 INFO - {'append_to_log': False,
17:47:29 INFO - 'base_work_dir': 'C:\\slave\\test',
17:47:29 INFO - 'blob_upload_branch': 'Mozilla-Inbound-Non-PGO',
17:47:29 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt',
17:47:29 INFO - 'branch': 'Mozilla-Inbound-Non-PGO',
17:47:29 INFO - 'buildbot_json_path': 'buildprops.json',
17:47:29 INFO - 'config_files': ('talos/windows_config.py',),
17:47:29 INFO - 'default_actions': ('clobber',
17:47:29 INFO - 'read-buildbot-config',
17:47:29 INFO - 'download-and-extract',
17:47:29 INFO - 'populate-webroot',
17:47:29 INFO - 'create-virtualenv',
17:47:29 INFO - 'install',
17:47:29 INFO - 'run-tests'),
17:47:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',),
17:47:29 INFO - 'download_minidump_stackwalk': True,
17:47:29 INFO - 'download_symbols': 'ondemand',
17:47:29 INFO - 'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python',
17:47:29 INFO - 'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'),
17:47:29 INFO - 'hg': 'c:/mozilla-build/hg/hg',
17:47:29 INFO - 'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python',
17:47:29 INFO - 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'),
17:47:29 INFO - 'python': 'c:/mozilla-build/python27/python.exe',
17:47:29 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe',
17:47:29 INFO - 'C:/mozilla-build/tooltool.py'),
17:47:29 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe',
17:47:29 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')},
17:47:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub',
17:47:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'),
17:47:29 INFO - 'installer_path': 'installer.exe',
17:47:29 INFO - 'log_level': 'info',
17:47:29 INFO - 'log_name': 'talos',
17:47:29 INFO - 'log_to_console': True,
17:47:29 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe',
17:47:29 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe',
17:47:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest',
17:47:29 INFO - 'opt_config_files': (),
17:47:29 INFO - 'pip_index': False,
17:47:29 INFO - 'sps_profile': False,
17:47:29 INFO - 'sps_profile_interval': 0,
17:47:29 INFO - 'suite': 'dromaeojs',
17:47:29 INFO - 'system_bits': '64',
17:47:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'),
17:47:29 INFO - 'title': 'T-W864-IX-062',
17:47:29 INFO - 'use_talos_json': True,
17:47:29 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'),
17:47:29 INFO - 'virtualenv_path': 'C:\\slave\\test\\build/venv',
17:47:29 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll',
17:47:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
17:47:29 INFO - 'work_dir': 'build'}
17:47:29 INFO - #####
17:47:29 INFO - ##### Running clobber step.
17:47:29 INFO - #####
17:47:29 INFO - Running pre-action listener: _resource_record_pre_action
17:47:29 INFO - Running main action method: clobber
17:47:29 INFO - rmtree: C:\slave\test\build
17:47:29 INFO - Using _rmtree_windows ...
17:47:29 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1
17:48:21 INFO - Running post-action listener: _resource_record_post_action
17:48:21 INFO - #####
17:48:21 INFO - ##### Running read-buildbot-config step.
17:48:21 INFO - #####
17:48:21 INFO - Running pre-action listener: _resource_record_pre_action
17:48:21 INFO - Running main action method: read_buildbot_config
17:48:21 INFO - Using buildbot properties:
17:48:21 INFO - {
17:48:21 INFO - "properties": {
17:48:21 INFO - "buildnumber": 2135,
17:48:21 INFO - "product": "firefox",
17:48:21 INFO - "script_repo_revision": "production",
17:48:21 INFO - "builddir": "mozilla-inbound_win8_64_test-dromaeojs",
17:48:21 INFO - "repository": "",
17:48:21 INFO - "buildername": "Windows 8 64-bit mozilla-inbound talos dromaeojs",
17:48:21 INFO - "buildid": "20151026160202",
17:48:21 INFO - "slavename": "t-w864-ix-062",
17:48:21 INFO - "pgo_build": "False",
17:48:21 INFO - "basedir": "C:\\slave\\test",
17:48:21 INFO - "project": "",
17:48:21 INFO - "platform": "win8_64",
17:48:21 INFO - "master": "http://buildbot-master110.bb.releng.scl3.mozilla.com:8201/",
17:48:21 INFO - "slavebuilddir": "test",
17:48:21 INFO - "scheduler": "tests-mozilla-inbound-win64-talos",
17:48:21 INFO - "branch": "mozilla-inbound",
17:48:21 INFO - "repo_path": "integration/mozilla-inbound",
17:48:21 INFO - "stage_platform": "win64",
17:48:21 INFO - "builduid": "0454fec0cf684397aef6f637db4838d3",
17:48:21 INFO - "revision": "f9cd7aa25d6f212d0cf6c48318ff47f2c4ebab88"
17:48:21 INFO - },
17:48:21 INFO - "sourcestamp": {
17:48:21 INFO - "repository": "",
17:48:21 INFO - "hasPatch": false,
17:48:21 INFO - "project": "",
17:48:21 INFO - "branch": "mozilla-inbound-win64-talos",
17:48:21 INFO - "changes": [
17:48:21 INFO - {
17:48:21 INFO - "category": null,
17:48:21 INFO - "files": [
17:48:21 INFO - {
17:48:21 INFO - "url": null,
17:48:21 INFO - "name": "https://queue.taskcluster.net/v1/task/psRrk3pCQsyAuHn-YdcjIA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip"
17:48:21 INFO - }
17:48:21 INFO - ],
17:48:21 INFO - "repository": "",
17:48:21 INFO - "rev": "f9cd7aa25d6f212d0cf6c48318ff47f2c4ebab88",
17:48:21 INFO - "who": "sfink@mozilla.com",
17:48:21 INFO - "when": 1445906115,
17:48:21 INFO - "number": 6577299,
17:48:21 INFO - "comments": "Bug 1211402 - dump hazards.txt into log file, r=me",
17:48:21 INFO - "project": "",
17:48:21 INFO - "at": "Mon 26 Oct 2015 17:35:15",
17:48:21 INFO - "branch": "mozilla-inbound-win64-talos",
17:48:21 INFO - "revlink": "",
17:48:21 INFO - "properties": [
17:48:21 INFO - [
17:48:21 INFO - "buildid",
17:48:21 INFO - "20151026160202",
17:48:21 INFO - "Change"
17:48:21 INFO - ],
17:48:21 INFO - [
17:48:21 INFO - "builduid",
17:48:21 INFO - "0454fec0cf684397aef6f637db4838d3",
17:48:21 INFO - "Change"
17:48:21 INFO - ],
17:48:21 INFO - [
17:48:21 INFO - "pgo_build",
17:48:21 INFO - "False",
17:48:21 INFO - "Change"
17:48:21 INFO - ]
17:48:21 INFO - ],
17:48:21 INFO - "revision": "f9cd7aa25d6f212d0cf6c48318ff47f2c4ebab88"
17:48:21 INFO - }
17:48:21 INFO - ],
17:48:21 INFO - "revision": "f9cd7aa25d6f212d0cf6c48318ff47f2c4ebab88"
17:48:21 INFO - }
17:48:21 INFO - }
17:48:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/psRrk3pCQsyAuHn-YdcjIA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip.
17:48:21 INFO - Running post-action listener: _resource_record_post_action
17:48:21 INFO - #####
17:48:21 INFO - ##### Running download-and-extract step.
17:48:21 INFO - #####
17:48:21 INFO - Running pre-action listener: _resource_record_pre_action
17:48:21 INFO - Running main action method: download_and_extract
17:48:21 INFO - mkdir: C:\slave\test\build\tests
17:48:21 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')]}
17:48:21 INFO - https://queue.taskcluster.net/v1/task/psRrk3pCQsyAuHn-YdcjIA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net
17:48:21 INFO - trying https://queue.taskcluster.net/v1/task/psRrk3pCQsyAuHn-YdcjIA/artifacts/public/build/test_packages.json
17:48:21 INFO - Downloading https://queue.taskcluster.net/v1/task/psRrk3pCQsyAuHn-YdcjIA/artifacts/public/build/test_packages.json to C:\slave\test\build\test_packages.json
17:48:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/psRrk3pCQsyAuHn-YdcjIA/artifacts/public/build/test_packages.json', 'file_name': 'C:\\slave\\test\\build\\test_packages.json'}, attempt #1
17:48:22 INFO - Downloaded 1221 bytes.
17:48:22 INFO - Reading from file C:\slave\test\build\test_packages.json
17:48:22 INFO - Using the following test package requirements:
17:48:22 INFO - {u'common': [u'firefox-44.0a1.en-US.win64.common.tests.zip'],
17:48:22 INFO - u'cppunittest': [u'firefox-44.0a1.en-US.win64.common.tests.zip',
17:48:22 INFO - u'firefox-44.0a1.en-US.win64.cppunittest.tests.zip'],
17:48:22 INFO - u'jittest': [u'firefox-44.0a1.en-US.win64.common.tests.zip',
17:48:22 INFO - u'jsshell-win64.zip'],
17:48:22 INFO - u'mochitest': [u'firefox-44.0a1.en-US.win64.common.tests.zip',
17:48:22 INFO - u'firefox-44.0a1.en-US.win64.mochitest.tests.zip'],
17:48:22 INFO - u'mozbase': [u'firefox-44.0a1.en-US.win64.common.tests.zip'],
17:48:22 INFO - u'reftest': [u'firefox-44.0a1.en-US.win64.common.tests.zip',
17:48:22 INFO - u'firefox-44.0a1.en-US.win64.reftest.tests.zip'],
17:48:22 INFO - u'talos': [u'firefox-44.0a1.en-US.win64.common.tests.zip',
17:48:22 INFO - u'firefox-44.0a1.en-US.win64.talos.tests.zip'],
17:48:22 INFO - u'web-platform': [u'firefox-44.0a1.en-US.win64.common.tests.zip',
17:48:22 INFO - u'firefox-44.0a1.en-US.win64.web-platform.tests.zip'],
17:48:22 INFO - u'webapprt': [u'firefox-44.0a1.en-US.win64.common.tests.zip'],
17:48:22 INFO - u'xpcshell': [u'firefox-44.0a1.en-US.win64.common.tests.zip',
17:48:22 INFO - u'firefox-44.0a1.en-US.win64.xpcshell.tests.zip']}
17:48:22 INFO - Downloading packages: [u'firefox-44.0a1.en-US.win64.common.tests.zip'] for test suite category: common
17:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
17:48:22 INFO - https://queue.taskcluster.net/v1/task/psRrk3pCQsyAuHn-YdcjIA/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip matches https://queue.taskcluster.net
17:48:22 INFO - trying https://queue.taskcluster.net/v1/task/psRrk3pCQsyAuHn-YdcjIA/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip
17:48:22 INFO - Downloading https://queue.taskcluster.net/v1/task/psRrk3pCQsyAuHn-YdcjIA/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip to C:\slave\test\build\firefox-44.0a1.en-US.win64.common.tests.zip
17:48:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/psRrk3pCQsyAuHn-YdcjIA/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip', 'file_name': u'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win64.common.tests.zip'}, attempt #1
ProcessManager NOT managing child processes
17:48:28 INFO - Downloaded 18085393 bytes.
17:48:28 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win64.common.tests.zip'] in C:\slave\test\build\tests
17:48:28 INFO - Copy/paste: unzip -q -o C:\slave\test\build\firefox-44.0a1.en-US.win64.common.tests.zip
17:48:28 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win64.common.tests.zip'] with output_timeout 1760
ProcessManager UNABLE to use job objects to manage child processes
17:48:54 INFO - Return code: 0
17:48:54 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
17:48: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')]}
17:48:54 INFO - https://queue.taskcluster.net/v1/task/psRrk3pCQsyAuHn-YdcjIA/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip matches https://queue.taskcluster.net
17:48:54 INFO - trying https://queue.taskcluster.net/v1/task/psRrk3pCQsyAuHn-YdcjIA/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip
17:48:54 INFO - Downloading https://queue.taskcluster.net/v1/task/psRrk3pCQsyAuHn-YdcjIA/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip to C:\slave\test\build\firefox-44.0a1.en-US.win64.common.tests.zip
17:48:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/psRrk3pCQsyAuHn-YdcjIA/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip', 'file_name': u'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win64.common.tests.zip'}, attempt #1
ProcessManager NOT managing child processes
17:48:56 INFO - Downloaded 18085393 bytes.
17:48:56 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win64.common.tests.zip'] in C:\slave\test\build\tests
17:48:56 INFO - Copy/paste: unzip -q -o C:\slave\test\build\firefox-44.0a1.en-US.win64.common.tests.zip
17:48:56 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win64.common.tests.zip'] with output_timeout 1760
ProcessManager UNABLE to use job objects to manage child processes
17:49:17 INFO - Return code: 0
17:49:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
17:49:17 INFO - https://queue.taskcluster.net/v1/task/psRrk3pCQsyAuHn-YdcjIA/artifacts/public/build/firefox-44.0a1.en-US.win64.talos.tests.zip matches https://queue.taskcluster.net
17:49:17 INFO - trying https://queue.taskcluster.net/v1/task/psRrk3pCQsyAuHn-YdcjIA/artifacts/public/build/firefox-44.0a1.en-US.win64.talos.tests.zip
17:49:17 INFO - Downloading https://queue.taskcluster.net/v1/task/psRrk3pCQsyAuHn-YdcjIA/artifacts/public/build/firefox-44.0a1.en-US.win64.talos.tests.zip to C:\slave\test\build\firefox-44.0a1.en-US.win64.talos.tests.zip
17:49:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/psRrk3pCQsyAuHn-YdcjIA/artifacts/public/build/firefox-44.0a1.en-US.win64.talos.tests.zip', 'file_name': u'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win64.talos.tests.zip'}, attempt #1
ProcessManager NOT managing child processes
17:49:19 INFO - Downloaded 11131307 bytes.
17:49:19 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win64.talos.tests.zip'] in C:\slave\test\build\tests
17:49:19 INFO - Copy/paste: unzip -q -o C:\slave\test\build\firefox-44.0a1.en-US.win64.talos.tests.zip
17:49:19 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win64.talos.tests.zip'] with output_timeout 1760
ProcessManager UNABLE to use job objects to manage child processes
17:49:21 INFO - Return code: 0
17:49:21 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')]}
17:49:21 INFO - https://queue.taskcluster.net/v1/task/psRrk3pCQsyAuHn-YdcjIA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip matches https://queue.taskcluster.net
17:49:21 INFO - trying https://queue.taskcluster.net/v1/task/psRrk3pCQsyAuHn-YdcjIA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip
17:49:21 INFO - Downloading https://queue.taskcluster.net/v1/task/psRrk3pCQsyAuHn-YdcjIA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip to C:\slave\test\build\firefox-44.0a1.en-US.win64.zip
17:49:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/psRrk3pCQsyAuHn-YdcjIA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip', 'file_name': 'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win64.zip'}, attempt #1
17:49:23 INFO - Downloaded 54814610 bytes.
17:49:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/psRrk3pCQsyAuHn-YdcjIA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip
17:49:23 INFO - mkdir: C:\slave\test\properties
17:49:23 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url
17:49:23 INFO - Writing to file C:\slave\test\properties\build_url
17:49:23 INFO - Contents:
17:49:23 INFO - build_url:https://queue.taskcluster.net/v1/task/psRrk3pCQsyAuHn-YdcjIA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip
17:49:23 INFO - Running post-action listener: _resource_record_post_action
17:49:23 INFO - Running post-action listener: set_extra_try_arguments
17:49:23 INFO - #####
17:49:23 INFO - ##### Running populate-webroot step.
17:49:23 INFO - #####
17:49:23 INFO - Running pre-action listener: _resource_record_pre_action
17:49:23 INFO - Running main action method: populate_webroot
17:49:23 INFO - Guessing talos json url...
17:49:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
17:49:23 INFO - https://queue.taskcluster.net/v1/task/psRrk3pCQsyAuHn-YdcjIA/artifacts/public/build/firefox-44.0a1.en-US.win64.txt matches https://queue.taskcluster.net
17:49:23 INFO - trying https://queue.taskcluster.net/v1/task/psRrk3pCQsyAuHn-YdcjIA/artifacts/public/build/firefox-44.0a1.en-US.win64.txt
17:49:23 INFO - Downloading https://queue.taskcluster.net/v1/task/psRrk3pCQsyAuHn-YdcjIA/artifacts/public/build/firefox-44.0a1.en-US.win64.txt to C:\slave\test\build\firefox-44.0a1.en-US.win64.txt
17:49:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/psRrk3pCQsyAuHn-YdcjIA/artifacts/public/build/firefox-44.0a1.en-US.win64.txt', 'file_name': 'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win64.txt'}, attempt #1
17:49:24 INFO - Downloaded 111 bytes.
17:49:24 INFO - Reading from file C:\slave\test\build\firefox-44.0a1.en-US.win64.txt
17:49:24 INFO - Contents:
17:49:24 INFO - 20151026160202
17:49:24 INFO - https://hg.mozilla.org/integration/mozilla-inbound/rev/f9cd7aa25d6f212d0cf6c48318ff47f2c4ebab88
17:49:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
17:49:24 INFO - trying https://hg.mozilla.org/integration/mozilla-inbound/raw-file/f9cd7aa25d/testing/talos/talos.json
17:49:24 INFO - Downloading https://hg.mozilla.org/integration/mozilla-inbound/raw-file/f9cd7aa25d/testing/talos/talos.json to C:\slave\test\build\talos.json
17:49:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/mozilla-inbound/raw-file/f9cd7aa25d/testing/talos/talos.json', 'file_name': 'C:\\slave\\test\\build\\talos.json'}, attempt #1
17:49:25 INFO - Downloaded 4264 bytes.
17:49:25 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']},
17:49:25 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']},
17:49:25 INFO - u'remote-trobocheck2': {u'talos_options': [u'--fennecIDs',
17:49:25 INFO - u'../fennec_ids.txt'],
17:49:25 INFO - u'tests': [u'tcheck2']},
17:49:25 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome',
17:49:25 INFO - u'--tppagecycles',
17:49:25 INFO - u'7'],
17:49:25 INFO - u'tests': [u'tsvgm']}},
17:49:25 INFO - u'suites': {u'chromez': {u'tests': [u'tresize', u'tcanvasmark']},
17:49:25 INFO - u'chromez-e10s': {u'talos_options': [u'--e10s'],
17:49:25 INFO - u'tests': [u'tresize', u'tcanvasmark']},
17:49:25 INFO - u'dromaeojs': {u'tests': [u'dromaeo_css', u'kraken', u'v8_7']},
17:49:25 INFO - u'dromaeojs-e10s': {u'talos_options': [u'--e10s'],
17:49:25 INFO - u'tests': [u'dromaeo_css',
17:49:25 INFO - u'kraken',
17:49:25 INFO - u'v8_7']},
17:49:25 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
17:49:25 INFO - u'tests': [u'tp5o_scroll', u'glterrain']},
17:49:25 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
17:49:25 INFO - u'talos_options': [u'--e10s'],
17:49:25 INFO - u'tests': [u'tp5o_scroll', u'glterrain']},
17:49:25 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
17:49:25 INFO - u'tests': [u'damp', u'tps']},
17:49:25 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
17:49:25 INFO - u'talos_options': [u'--e10s'],
17:49:25 INFO - u'tests': [u'damp', u'tps']},
17:49:25 INFO - u'g3': {u'tests': [u'dromaeo_dom']},
17:49:25 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']},
17:49:25 INFO - u'other': {u'tests': [u'a11yr',
17:49:25 INFO - u'ts_paint',
17:49:25 INFO - u'tpaint',
17:49:25 INFO - u'sessionrestore',
17:49:25 INFO - u'sessionrestore_no_auto_restore']},
17:49:25 INFO - u'other-e10s': {u'talos_options': [u'--e10s'],
17:49:25 INFO - u'tests': [u'a11yr',
17:49:25 INFO - u'ts_paint',
17:49:25 INFO - u'tpaint',
17:49:25 INFO - u'sessionrestore',
17:49:25 INFO - u'sessionrestore_no_auto_restore']},
17:49:25 INFO - u'other-e10s_l64': {u'talos_options': [u'--e10s'],
17:49:25 INFO - u'tests': [u'a11yr',
17:49:25 INFO - u'ts_paint',
17:49:25 INFO - u'tpaint',
17:49:25 INFO - u'sessionrestore',
17:49:25 INFO - u'sessionrestore_no_auto_restore']},
17:49:25 INFO - u'other-e10s_nol64': {u'talos_options': [u'--e10s'],
17:49:25 INFO - u'tests': [u'a11yr',
17:49:25 INFO - u'ts_paint',
17:49:25 INFO - u'tpaint',
17:49:25 INFO - u'sessionrestore',
17:49:25 INFO - u'sessionrestore_no_auto_restore']},
17:49:25 INFO - u'other_l64': {u'tests': [u'a11yr',
17:49:25 INFO - u'ts_paint',
17:49:25 INFO - u'tpaint',
17:49:25 INFO - u'sessionrestore',
17:49:25 INFO - u'sessionrestore_no_auto_restore']},
17:49:25 INFO - u'other_nol64': {u'tests': [u'a11yr',
17:49:25 INFO - u'ts_paint',
17:49:25 INFO - u'tpaint',
17:49:25 INFO - u'sessionrestore',
17:49:25 INFO - u'sessionrestore_no_auto_restore']},
17:49:25 INFO - u'svgr': {u'tests': [u'tsvgx',
17:49:25 INFO - u'tsvgr_opacity',
17:49:25 INFO - u'tart',
17:49:25 INFO - u'tscrollx',
17:49:25 INFO - u'cart']},
17:49:25 INFO - u'svgr-e10s': {u'talos_options': [u'--e10s'],
17:49:25 INFO - u'tests': [u'tsvgx',
17:49:25 INFO - u'tsvgr_opacity',
17:49:25 INFO - u'tart',
17:49:25 INFO - u'tscrollx',
17:49:25 INFO - u'cart']},
17:49:25 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
17:49:25 INFO - u'tests': [u'tp5o']},
17:49:25 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
17:49:25 INFO - u'talos_options': [u'--e10s'],
17:49:25 INFO - u'tests': [u'tp5o']},
17:49:25 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
17:49:25 INFO - u'talos_options': [u'--xperf_path',
17:49:25 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
17:49:25 INFO - u'tests': [u'tp5n']},
17:49:25 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
17:49:25 INFO - u'talos_options': [u'--e10s',
17:49:25 INFO - u'--xperf_path',
17:49:25 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"',
17:49:25 INFO - u'C:/slave/talos-data/talos/xperf.config'],
17:49:25 INFO - u'tests': [u'tp5n']}},
17:49:25 INFO - u'talos.zip': {u'path': u'',
17:49:25 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}}
17:49:25 INFO - Running post-action listener: _resource_record_post_action
17:49:25 INFO - #####
17:49:25 INFO - ##### Running create-virtualenv step.
17:49:25 INFO - #####
17:49:25 INFO - Running pre-action listener: _resource_record_pre_action
17:49:25 INFO - Running main action method: create_virtualenv
17:49:25 INFO - Creating virtualenv C:\slave\test\build/venv
17:49:25 INFO - mkdir: C:\slave\test\build\venv\Scripts
17:49:25 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll
17:49:25 WARNING - Can't copy c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll: [Errno 2] No such file or directory: 'c:/mozilla-build/python27/python27.dll'!
17:49:25 INFO - Running command: ['c:/mozilla-build/python27/python.exe', 'c:/mozilla-build/buildbotve/virtualenv.py', '--no-site-packages', '--distribute', 'C:\\slave\\test\\build/venv'] in C:\slave\test\build
17:49:25 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build/venv
17:49:28 INFO - New python executable in C:\slave\test\build/venv\Scripts\python.exe
17:49:30 INFO - Installing distribute......................................................................................................................................................................................done.
17:49:32 INFO - Return code: 0
17:49:32 INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv
17:49:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
17:49:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
17:49:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
17:49:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
17:49:32 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\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 0x02284B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022DDEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0238E930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x006E8B48>, '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 0x0070A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02769660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-062', 'USERDOMAIN': 'T-W864-IX-062', '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-062', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-062\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-062', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-062', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-062', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/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', '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-062\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', '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
17:49:32 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\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\build
17:49:32 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --download-cache C:\slave\test\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
17:49:32 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
17:49:32 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-062\\AppData\\Roaming',
17:49:32 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
17:49:32 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
17:49:32 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
17:49:32 INFO - 'COMPUTERNAME': 'T-W864-IX-062',
17:49:32 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
17:49:32 INFO - 'DCLOCATION': 'SCL3',
17:49:32 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
17:49:32 INFO - 'FP_NO_HOST_CHECK': 'NO',
17:49:32 INFO - 'HOMEDRIVE': 'C:',
17:49:32 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-062',
17:49:32 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
17:49:32 INFO - 'KTS_VERSION': '1.19c',
17:49:32 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-062\\AppData\\Local',
17:49:32 INFO - 'LOGONSERVER': '\\\\T-W864-IX-062',
17:49:32 INFO - 'MONDIR': 'C:\\Monitor_config\\',
17:49:32 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
17:49:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
17:49:32 INFO - 'MOZ_NO_REMOTE': '1',
17:49:32 INFO - 'NO_EM_RESTART': '1',
17:49:32 INFO - 'NUMBER_OF_PROCESSORS': '8',
17:49:32 INFO - 'OS': 'Windows_NT',
17:49:32 INFO - 'OURDRIVE': 'C:',
17:49:32 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',
17:49:32 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
17:49:32 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
17:49:32 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
17:49:32 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
17:49:32 INFO - 'PROCESSOR_LEVEL': '6',
17:49:32 INFO - 'PROCESSOR_REVISION': '1e05',
17:49:32 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
17:49:32 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
17:49:32 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
17:49:32 INFO - 'PROGRAMW6432': 'C:\\Program Files',
17:49:32 INFO - 'PROMPT': '$P$G',
17:49:32 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
17:49:32 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
17:49:32 INFO - 'PUBLIC': 'C:\\Users\\Public',
17:49:32 INFO - 'PWD': 'C:\\slave\\test',
17:49:32 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
17:49:32 INFO - 'SLAVEDIR': 'C:\\slave\\',
17:49:32 INFO - 'SYSTEMDRIVE': 'C:',
17:49:32 INFO - 'SYSTEMROOT': 'C:\\windows',
17:49:32 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
17:49:32 INFO - 'TEST1': 'testie',
17:49:32 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
17:49:32 INFO - 'USERDOMAIN': 'T-W864-IX-062',
17:49:32 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-062',
17:49:32 INFO - 'USERNAME': 'cltbld',
17:49:32 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-062',
17:49:32 INFO - 'WINDIR': 'C:\\windows',
17:49:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
17:49:33 INFO - Ignoring indexes: http://pypi.python.org/simple/
17:49:33 INFO - Downloading/unpacking pip>=1.5
17:49:33 INFO - Creating supposed download cache at C:\slave\test\build/venv\cache
17:49:37 INFO - Storing download in cache at c:\slave\test\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fpip-1.5.5.tar.gz
17:49:37 INFO - Running setup.py egg_info for package pip
17:49:37 INFO - warning: no files found matching 'pip\cacert.pem'
17:49:37 INFO - warning: no files found matching '*.html' under directory 'docs'
17:49:37 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build'
17:49:37 INFO - no previously-included directories found matching 'docs\_build\_sources'
17:49:37 INFO - Installing collected packages: pip
17:49:37 INFO - Found existing installation: pip 0.8.2
17:49:37 INFO - Uninstalling pip:
17:49:37 INFO - Successfully uninstalled pip
17:49:37 INFO - Running setup.py install for pip
17:49:37 INFO - warning: no files found matching 'pip\cacert.pem'
17:49:37 INFO - warning: no files found matching '*.html' under directory 'docs'
17:49:37 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build'
17:49:37 INFO - no previously-included directories found matching 'docs\_build\_sources'
17:49:37 INFO - Installing pip-script.py script to C:\slave\test\build\venv\Scripts
17:49:37 INFO - Installing pip.exe script to C:\slave\test\build\venv\Scripts
17:49:37 INFO - Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts
17:49:37 INFO - Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts
17:49:37 INFO - Installing pip2-script.py script to C:\slave\test\build\venv\Scripts
17:49:37 INFO - Installing pip2.exe script to C:\slave\test\build\venv\Scripts
17:49:37 INFO - Successfully installed pip
17:49:37 INFO - Cleaning up...
17:49:37 INFO - Return code: 0
17:49:37 INFO - Installing psutil>=0.7.1 into virtualenv C:\slave\test\build/venv
17:49:37 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')]}
17:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
17:49:37 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')]}
17:49:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
17:49:37 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\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 0x02284B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022DDEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0238E930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x006E8B48>, '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 0x0070A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02769660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-062', 'USERDOMAIN': 'T-W864-IX-062', '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-062', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-062\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-062', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-062', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-062', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/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', '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-062\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', '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
17:49:37 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\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\build
17:49:37 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --download-cache C:\slave\test\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
17:49:37 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
17:49:37 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-062\\AppData\\Roaming',
17:49:37 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
17:49:37 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
17:49:37 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
17:49:37 INFO - 'COMPUTERNAME': 'T-W864-IX-062',
17:49:37 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
17:49:37 INFO - 'DCLOCATION': 'SCL3',
17:49:37 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
17:49:37 INFO - 'FP_NO_HOST_CHECK': 'NO',
17:49:37 INFO - 'HOMEDRIVE': 'C:',
17:49:37 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-062',
17:49:37 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
17:49:37 INFO - 'KTS_VERSION': '1.19c',
17:49:37 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-062\\AppData\\Local',
17:49:37 INFO - 'LOGONSERVER': '\\\\T-W864-IX-062',
17:49:37 INFO - 'MONDIR': 'C:\\Monitor_config\\',
17:49:37 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
17:49:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
17:49:37 INFO - 'MOZ_NO_REMOTE': '1',
17:49:37 INFO - 'NO_EM_RESTART': '1',
17:49:37 INFO - 'NUMBER_OF_PROCESSORS': '8',
17:49:37 INFO - 'OS': 'Windows_NT',
17:49:37 INFO - 'OURDRIVE': 'C:',
17:49:37 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',
17:49:37 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
17:49:37 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
17:49:37 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
17:49:37 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
17:49:37 INFO - 'PROCESSOR_LEVEL': '6',
17:49:37 INFO - 'PROCESSOR_REVISION': '1e05',
17:49:37 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
17:49:37 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
17:49:37 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
17:49:37 INFO - 'PROGRAMW6432': 'C:\\Program Files',
17:49:37 INFO - 'PROMPT': '$P$G',
17:49:37 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
17:49:37 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
17:49:37 INFO - 'PUBLIC': 'C:\\Users\\Public',
17:49:37 INFO - 'PWD': 'C:\\slave\\test',
17:49:37 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
17:49:37 INFO - 'SLAVEDIR': 'C:\\slave\\',
17:49:37 INFO - 'SYSTEMDRIVE': 'C:',
17:49:37 INFO - 'SYSTEMROOT': 'C:\\windows',
17:49:37 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
17:49:37 INFO - 'TEST1': 'testie',
17:49:37 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
17:49:37 INFO - 'USERDOMAIN': 'T-W864-IX-062',
17:49:37 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-062',
17:49:37 INFO - 'USERNAME': 'cltbld',
17:49:37 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-062',
17:49:37 INFO - 'WINDIR': 'C:\\windows',
17:49:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
17:49:39 INFO - Ignoring indexes: https://pypi.python.org/simple/
17:49:39 INFO - Downloading/unpacking psutil>=0.7.1
17:49:39 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
17:49:39 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
17:49:40 INFO - Storing download in cache at c:\slave\test\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fpsutil-3.1.1-cp27-none-win32.whl
17:49:40 INFO - Installing collected packages: psutil
17:49:40 INFO - Successfully installed psutil
17:49:40 INFO - Cleaning up...
17:49:40 INFO - Return code: 0
17:49:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv C:\slave\test\build/venv
17:49:40 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')]}
17:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
17:49:40 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')]}
17:49:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
17:49:40 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\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 0x02284B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022DDEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0238E930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x006E8B48>, '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 0x0070A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02769660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-062', 'USERDOMAIN': 'T-W864-IX-062', '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-062', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-062\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-062', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-062', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-062', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/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', '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-062\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', '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
17:49:40 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\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\build
17:49:40 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --download-cache C:\slave\test\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
17:49:40 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
17:49:40 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-062\\AppData\\Roaming',
17:49:40 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
17:49:40 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
17:49:40 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
17:49:40 INFO - 'COMPUTERNAME': 'T-W864-IX-062',
17:49:40 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
17:49:40 INFO - 'DCLOCATION': 'SCL3',
17:49:40 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
17:49:40 INFO - 'FP_NO_HOST_CHECK': 'NO',
17:49:40 INFO - 'HOMEDRIVE': 'C:',
17:49:40 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-062',
17:49:40 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
17:49:40 INFO - 'KTS_VERSION': '1.19c',
17:49:40 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-062\\AppData\\Local',
17:49:40 INFO - 'LOGONSERVER': '\\\\T-W864-IX-062',
17:49:40 INFO - 'MONDIR': 'C:\\Monitor_config\\',
17:49:40 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
17:49:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
17:49:40 INFO - 'MOZ_NO_REMOTE': '1',
17:49:40 INFO - 'NO_EM_RESTART': '1',
17:49:40 INFO - 'NUMBER_OF_PROCESSORS': '8',
17:49:40 INFO - 'OS': 'Windows_NT',
17:49:40 INFO - 'OURDRIVE': 'C:',
17:49:40 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts',
17:49:40 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
17:49:40 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
17:49:40 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
17:49:40 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
17:49:40 INFO - 'PROCESSOR_LEVEL': '6',
17:49:40 INFO - 'PROCESSOR_REVISION': '1e05',
17:49:40 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
17:49:40 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
17:49:40 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
17:49:40 INFO - 'PROGRAMW6432': 'C:\\Program Files',
17:49:40 INFO - 'PROMPT': '$P$G',
17:49:40 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
17:49:40 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
17:49:40 INFO - 'PUBLIC': 'C:\\Users\\Public',
17:49:40 INFO - 'PWD': 'C:\\slave\\test',
17:49:40 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
17:49:40 INFO - 'SLAVEDIR': 'C:\\slave\\',
17:49:40 INFO - 'SYSTEMDRIVE': 'C:',
17:49:40 INFO - 'SYSTEMROOT': 'C:\\windows',
17:49:40 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
17:49:40 INFO - 'TEST1': 'testie',
17:49:40 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
17:49:40 INFO - 'USERDOMAIN': 'T-W864-IX-062',
17:49:40 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-062',
17:49:40 INFO - 'USERNAME': 'cltbld',
17:49:40 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-062',
17:49:40 INFO - 'WINDIR': 'C:\\windows',
17:49:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
17:49:41 INFO - Ignoring indexes: https://pypi.python.org/simple/
17:49:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0
17:49:41 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
17:49:41 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
17:49:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz
17:49:42 INFO - Storing download in cache at c:\slave\test\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fmozsystemmonitor-0.0.tar.gz
17:49:42 INFO - Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor
17:49:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in c:\slave\test\build\venv\lib\site-packages (from mozsystemmonitor==0.0.0)
17:49:42 INFO - Installing collected packages: mozsystemmonitor
17:49:42 INFO - Running setup.py install for mozsystemmonitor
17:49:42 INFO - Successfully installed mozsystemmonitor
17:49:42 INFO - Cleaning up...
17:49:42 INFO - Return code: 0
17:49:42 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv
17:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
17:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
17:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
17:49:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
17:49:42 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\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 0x02284B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022DDEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0238E930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x006E8B48>, '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 0x0070A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02769660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-062', 'USERDOMAIN': 'T-W864-IX-062', '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-062', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-062\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-062', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-062', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-062', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/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', '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-062\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', '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
17:49:42 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\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\build
17:49:42 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --download-cache C:\slave\test\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
17:49:42 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
17:49:42 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-062\\AppData\\Roaming',
17:49:42 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
17:49:42 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
17:49:42 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
17:49:42 INFO - 'COMPUTERNAME': 'T-W864-IX-062',
17:49:42 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
17:49:42 INFO - 'DCLOCATION': 'SCL3',
17:49:42 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
17:49:42 INFO - 'FP_NO_HOST_CHECK': 'NO',
17:49:42 INFO - 'HOMEDRIVE': 'C:',
17:49:42 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-062',
17:49:42 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
17:49:42 INFO - 'KTS_VERSION': '1.19c',
17:49:42 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-062\\AppData\\Local',
17:49:42 INFO - 'LOGONSERVER': '\\\\T-W864-IX-062',
17:49:42 INFO - 'MONDIR': 'C:\\Monitor_config\\',
17:49:42 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
17:49:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
17:49:42 INFO - 'MOZ_NO_REMOTE': '1',
17:49:42 INFO - 'NO_EM_RESTART': '1',
17:49:42 INFO - 'NUMBER_OF_PROCESSORS': '8',
17:49:42 INFO - 'OS': 'Windows_NT',
17:49:42 INFO - 'OURDRIVE': 'C:',
17:49:42 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts',
17:49:42 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
17:49:42 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
17:49:42 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
17:49:42 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
17:49:42 INFO - 'PROCESSOR_LEVEL': '6',
17:49:42 INFO - 'PROCESSOR_REVISION': '1e05',
17:49:42 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
17:49:42 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
17:49:42 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
17:49:42 INFO - 'PROGRAMW6432': 'C:\\Program Files',
17:49:42 INFO - 'PROMPT': '$P$G',
17:49:42 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
17:49:42 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
17:49:42 INFO - 'PUBLIC': 'C:\\Users\\Public',
17:49:42 INFO - 'PWD': 'C:\\slave\\test',
17:49:42 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
17:49:42 INFO - 'SLAVEDIR': 'C:\\slave\\',
17:49:42 INFO - 'SYSTEMDRIVE': 'C:',
17:49:42 INFO - 'SYSTEMROOT': 'C:\\windows',
17:49:42 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
17:49:42 INFO - 'TEST1': 'testie',
17:49:42 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
17:49:42 INFO - 'USERDOMAIN': 'T-W864-IX-062',
17:49:42 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-062',
17:49:42 INFO - 'USERNAME': 'cltbld',
17:49:42 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-062',
17:49:42 INFO - 'WINDIR': 'C:\\windows',
17:49:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
17:49:43 INFO - Ignoring indexes: https://pypi.python.org/simple/
17:49:43 INFO - Downloading/unpacking blobuploader==1.2.4
17:49:43 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
17:49:43 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
17:49:44 INFO - Downloading blobuploader-1.2.4.tar.gz
17:49:44 INFO - Storing download in cache at c:\slave\test\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fblobuploader-1.2.4.tar.gz
17:49:44 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader
17:49:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4)
17:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
17:49:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
17:49:44 INFO - Storing download in cache at c:\slave\test\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2frequests-1.2.3.tar.gz
17:49:44 INFO - Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests
17:49:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4)
17:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
17:49:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
17:49:44 INFO - Downloading docopt-0.6.1.tar.gz
17:49:44 INFO - Storing download in cache at c:\slave\test\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fdocopt-0.6.1.tar.gz
17:49:44 INFO - Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt
17:49:44 INFO - Installing collected packages: blobuploader, requests, docopt
17:49:44 INFO - Running setup.py install for blobuploader
17:49:45 INFO - Running setup.py install for requests
17:49:45 INFO - Running setup.py install for docopt
17:49:45 INFO - Successfully installed blobuploader requests docopt
17:49:45 INFO - Cleaning up...
17:49:47 INFO - Return code: 0
17:49:47 INFO - Installing None into virtualenv C:\slave\test\build/venv
17:49:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
17:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
17:49:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
17:49:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
17:49:47 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--no-deps', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test\\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 0x02284B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022DDEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0238E930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x006E8B48>, '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 0x0070A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02769660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-062', 'USERDOMAIN': 'T-W864-IX-062', '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-062', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-062\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-062', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-062', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-062', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/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', '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-062\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', '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
17:49:47 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--no-deps', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test\\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\build\tests\config
17:49:47 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --no-deps --download-cache C:\slave\test\build/venv\cache --timeout 120 -r C:\slave\test\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
17:49:47 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
17:49:47 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-062\\AppData\\Roaming',
17:49:47 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
17:49:47 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
17:49:47 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
17:49:47 INFO - 'COMPUTERNAME': 'T-W864-IX-062',
17:49:47 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
17:49:47 INFO - 'DCLOCATION': 'SCL3',
17:49:47 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
17:49:47 INFO - 'FP_NO_HOST_CHECK': 'NO',
17:49:47 INFO - 'HOMEDRIVE': 'C:',
17:49:47 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-062',
17:49:47 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
17:49:47 INFO - 'KTS_VERSION': '1.19c',
17:49:47 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-062\\AppData\\Local',
17:49:47 INFO - 'LOGONSERVER': '\\\\T-W864-IX-062',
17:49:47 INFO - 'MONDIR': 'C:\\Monitor_config\\',
17:49:47 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
17:49:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
17:49:47 INFO - 'MOZ_NO_REMOTE': '1',
17:49:47 INFO - 'NO_EM_RESTART': '1',
17:49:47 INFO - 'NUMBER_OF_PROCESSORS': '8',
17:49:47 INFO - 'OS': 'Windows_NT',
17:49:47 INFO - 'OURDRIVE': 'C:',
17:49:47 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts',
17:49:47 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
17:49:47 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
17:49:47 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
17:49:47 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
17:49:47 INFO - 'PROCESSOR_LEVEL': '6',
17:49:47 INFO - 'PROCESSOR_REVISION': '1e05',
17:49:47 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
17:49:47 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
17:49:47 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
17:49:47 INFO - 'PROGRAMW6432': 'C:\\Program Files',
17:49:47 INFO - 'PROMPT': '$P$G',
17:49:47 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
17:49:47 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
17:49:47 INFO - 'PUBLIC': 'C:\\Users\\Public',
17:49:47 INFO - 'PWD': 'C:\\slave\\test',
17:49:47 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
17:49:47 INFO - 'SLAVEDIR': 'C:\\slave\\',
17:49:47 INFO - 'SYSTEMDRIVE': 'C:',
17:49:47 INFO - 'SYSTEMROOT': 'C:\\windows',
17:49:47 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
17:49:47 INFO - 'TEST1': 'testie',
17:49:47 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
17:49:47 INFO - 'USERDOMAIN': 'T-W864-IX-062',
17:49:47 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-062',
17:49:47 INFO - 'USERNAME': 'cltbld',
17:49:47 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-062',
17:49:47 INFO - 'WINDIR': 'C:\\windows',
17:49:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
17:49:47 INFO - Ignoring indexes: https://pypi.python.org/simple/
17:49:47 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser
17:49:47 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-mf4z_s-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser
17:49:47 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash
17:49:47 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-yenzw3-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash
17:49:47 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug
17:49:47 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rk7p1w-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug
17:49:47 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice
17:49:47 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-7m79hy-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice
17:49:47 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile
17:49:47 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-7nsxku-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile
17:49:48 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd
17:49:48 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-8dlf8h-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd
17:49:48 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo
17:49:48 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xtahdi-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo
17:49:48 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall
17:49:48 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-5nnysr-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall
17:49:48 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak
17:49:48 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-mfrovd-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak
17:49:48 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog
17:49:48 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-uzyxjq-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog
17:49:48 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork
17:49:48 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ux_ic4-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork
17:49:48 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess
17:49:48 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ket8ip-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess
17:49:48 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile
17:49:48 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-injtah-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile
17:49:48 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner
17:49:48 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-yn_17s-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner
17:49:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot
17:49:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ebwynp-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot
17:49:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest
17:49:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-al7lfa-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest
17:49:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion
17:49:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-pkzd88-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion
17:49:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion
17:49:49 INFO - Running setup.py install for manifestparser
17:49:49 INFO - Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts
17:49:49 INFO - Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts
17:49:49 INFO - Running setup.py install for mozcrash
17:49:50 INFO - Running setup.py install for mozdebug
17:49:50 INFO - Running setup.py install for mozdevice
17:49:50 INFO - Installing sutini-script.py script to C:\slave\test\build\venv\Scripts
17:49:50 INFO - Installing sutini.exe script to C:\slave\test\build\venv\Scripts
17:49:50 INFO - Installing dm-script.py script to C:\slave\test\build\venv\Scripts
17:49:50 INFO - Installing dm.exe script to C:\slave\test\build\venv\Scripts
17:49:51 INFO - Running setup.py install for mozfile
17:49:51 INFO - Running setup.py install for mozhttpd
17:49:51 INFO - Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts
17:49:51 INFO - Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts
17:49:52 INFO - Running setup.py install for mozinfo
17:49:52 INFO - Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts
17:49:52 INFO - Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts
17:49:52 INFO - Running setup.py install for mozInstall
17:49:52 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts
17:49:52 INFO - Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts
17:49:52 INFO - Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts
17:49:52 INFO - Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts
17:49:52 INFO - Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts
17:49:52 INFO - Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts
17:49:52 INFO - Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts
17:49:52 INFO - Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts
17:49:52 INFO - Running setup.py install for mozleak
17:49:53 INFO - Running setup.py install for mozlog
17:49:53 INFO - Installing structlog-script.py script to C:\slave\test\build\venv\Scripts
17:49:53 INFO - Installing structlog.exe script to C:\slave\test\build\venv\Scripts
17:49:54 INFO - Running setup.py install for moznetwork
17:49:54 INFO - Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts
17:49:54 INFO - Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts
17:49:54 INFO - Running setup.py install for mozprocess
17:49:55 INFO - Running setup.py install for mozprofile
17:49:55 INFO - Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts
17:49:55 INFO - Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts
17:49:55 INFO - Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts
17:49:55 INFO - Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts
17:49:55 INFO - Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts
17:49:55 INFO - Installing view-profile.exe script to C:\slave\test\build\venv\Scripts
17:49:55 INFO - Running setup.py install for mozrunner
17:49:55 INFO - Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts
17:49:55 INFO - Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts
17:49:56 INFO - Running setup.py install for mozscreenshot
17:49:56 INFO - Running setup.py install for moztest
17:49:57 INFO - Running setup.py install for mozversion
17:49:57 INFO - Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts
17:49:57 INFO - Installing mozversion.exe script to C:\slave\test\build\venv\Scripts
17:49:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion
17:49:57 INFO - Cleaning up...
17:49:57 INFO - Return code: 0
17:49:57 INFO - Installing None into virtualenv C:\slave\test\build/venv
17:49: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')]}
17:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
17:49: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')]}
17:49:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
17:49:57 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test\\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 0x02284B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022DDEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0238E930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x006E8B48>, '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 0x0070A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02769660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-062', 'USERDOMAIN': 'T-W864-IX-062', '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-062', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-062\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-062', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-062', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-062', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/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', '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-062\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', '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
17:49:57 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test\\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\build\tests\config
17:49:57 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --download-cache C:\slave\test\build/venv\cache --timeout 120 -r C:\slave\test\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
17:49:57 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
17:49:57 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-062\\AppData\\Roaming',
17:49:57 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
17:49:57 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
17:49:57 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
17:49:57 INFO - 'COMPUTERNAME': 'T-W864-IX-062',
17:49:57 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
17:49:57 INFO - 'DCLOCATION': 'SCL3',
17:49:57 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
17:49:57 INFO - 'FP_NO_HOST_CHECK': 'NO',
17:49:57 INFO - 'HOMEDRIVE': 'C:',
17:49:57 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-062',
17:49:57 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
17:49:57 INFO - 'KTS_VERSION': '1.19c',
17:49:57 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-062\\AppData\\Local',
17:49:57 INFO - 'LOGONSERVER': '\\\\T-W864-IX-062',
17:49:57 INFO - 'MONDIR': 'C:\\Monitor_config\\',
17:49:57 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
17:49:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
17:49:57 INFO - 'MOZ_NO_REMOTE': '1',
17:49:57 INFO - 'NO_EM_RESTART': '1',
17:49:57 INFO - 'NUMBER_OF_PROCESSORS': '8',
17:49:57 INFO - 'OS': 'Windows_NT',
17:49:57 INFO - 'OURDRIVE': 'C:',
17:49:57 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts',
17:49:57 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
17:49:57 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
17:49:57 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
17:49:57 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
17:49:57 INFO - 'PROCESSOR_LEVEL': '6',
17:49:57 INFO - 'PROCESSOR_REVISION': '1e05',
17:49:57 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
17:49:57 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
17:49:57 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
17:49:57 INFO - 'PROGRAMW6432': 'C:\\Program Files',
17:49:57 INFO - 'PROMPT': '$P$G',
17:49:57 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
17:49:57 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
17:49:57 INFO - 'PUBLIC': 'C:\\Users\\Public',
17:49:57 INFO - 'PWD': 'C:\\slave\\test',
17:49:57 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
17:49:57 INFO - 'SLAVEDIR': 'C:\\slave\\',
17:49:57 INFO - 'SYSTEMDRIVE': 'C:',
17:49:57 INFO - 'SYSTEMROOT': 'C:\\windows',
17:49:57 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
17:49:57 INFO - 'TEST1': 'testie',
17:49:57 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
17:49:57 INFO - 'USERDOMAIN': 'T-W864-IX-062',
17:49:57 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-062',
17:49:57 INFO - 'USERNAME': 'cltbld',
17:49:57 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-062',
17:49:57 INFO - 'WINDIR': 'C:\\windows',
17:49:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
17:49:57 INFO - Ignoring indexes: https://pypi.python.org/simple/
17:49:57 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser
17:49:57 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-50vhtn-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser
17:49:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///C:/slave/test/build/tests/mozbase/manifestparser in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 1))
17:49:57 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash
17:49:57 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-eciqxj-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash
17:49:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///C:/slave/test/build/tests/mozbase/mozcrash in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2))
17:49:58 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug
17:49:58 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-7zwz0v-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug
17:49:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///C:/slave/test/build/tests/mozbase/mozdebug in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 3))
17:49:58 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice
17:49:58 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-tl50n1-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice
17:49:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 from file:///C:/slave/test/build/tests/mozbase/mozdevice in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4))
17:49:58 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile
17:49:58 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qanka9-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile
17:49:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///C:/slave/test/build/tests/mozbase/mozfile in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 5))
17:49:58 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd
17:49:58 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-s9m_fp-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd
17:49:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///C:/slave/test/build/tests/mozbase/mozhttpd in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 6))
17:49:58 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo
17:49:58 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ko1amy-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo
17:49:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 from file:///C:/slave/test/build/tests/mozbase/mozinfo in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 7))
17:49:58 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall
17:49:58 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-bbsiwc-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall
17:49:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///C:/slave/test/build/tests/mozbase/mozinstall in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 8))
17:49:58 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak
17:49:58 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-5_kxmc-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak
17:49:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///C:/slave/test/build/tests/mozbase/mozleak in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 9))
17:49:58 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog
17:49:58 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-s9r2x2-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog
17:49:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///C:/slave/test/build/tests/mozbase/mozlog in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10))
17:49:58 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork
17:49:58 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-edx_ra-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork
17:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///C:/slave/test/build/tests/mozbase/moznetwork in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 11))
17:49:59 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess
17:49:59 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-_lqz7i-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess
17:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///C:/slave/test/build/tests/mozbase/mozprocess in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 12))
17:49:59 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile
17:49:59 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-hyabcu-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile
17:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///C:/slave/test/build/tests/mozbase/mozprofile in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 13))
17:49:59 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner
17:49:59 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-lsarak-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner
17:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///C:/slave/test/build/tests/mozbase/mozrunner in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 14))
17:49:59 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot
17:49:59 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ixdnwy-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot
17:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///C:/slave/test/build/tests/mozbase/mozscreenshot in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 15))
17:49:59 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest
17:49:59 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-wsxl4e-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest
17:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///C:/slave/test/build/tests/mozbase/moztest in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 16))
17:49:59 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion
17:49:59 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-tcxqgn-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion
17:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///C:/slave/test/build/tests/mozbase/mozversion in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 17))
17:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==0.16->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2))
17:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==0.16->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2))
17:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in c:\slave\test\build\venv\lib\site-packages (from mozdebug==0.1->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 3))
17:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test\build\venv\lib\site-packages (from mozdevice==0.46->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4))
17:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in c:\slave\test\build\venv\lib\site-packages (from mozdevice==0.46->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4))
17:49:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10))
17:49:59 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
17:49:59 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
17:50:00 INFO - Downloading blessings-1.5.1.tar.gz
17:50:00 INFO - Storing download in cache at c:\slave\test\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fblessings-1.5.1.tar.gz
17:50:00 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings
17:50:01 INFO - Installing collected packages: blessings
17:50:01 INFO - Running setup.py install for blessings
17:50:01 INFO - Successfully installed blessings
17:50:01 INFO - Cleaning up...
17:50:04 INFO - Return code: 0
17:50:04 INFO - Done creating virtualenv C:\slave\test\build/venv.
17:50:04 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze']
17:50:04 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze
17:50:04 INFO - Reading from file tmpfile_stdout
17:50:04 INFO - Using _rmtree_windows ...
17:50:04 INFO - Using _rmtree_windows ...
17:50:04 INFO - Current package versions:
17:50:04 INFO - blessings == 1.5.1
17:50:04 INFO - blobuploader == 1.2.4
17:50:04 INFO - docopt == 0.6.1
17:50:04 INFO - manifestparser == 1.1
17:50:04 INFO - mozInstall == 1.12
17:50:04 INFO - mozcrash == 0.16
17:50:04 INFO - mozdebug == 0.1
17:50:04 INFO - mozdevice == 0.46
17:50:04 INFO - mozfile == 1.2
17:50:04 INFO - mozhttpd == 0.7
17:50:04 INFO - mozinfo == 0.8
17:50:04 INFO - mozleak == 0.1
17:50:04 INFO - mozlog == 3.0
17:50:04 INFO - moznetwork == 0.27
17:50:04 INFO - mozprocess == 0.22
17:50:04 INFO - mozprofile == 0.27
17:50:04 INFO - mozrunner == 6.11
17:50:04 INFO - mozscreenshot == 0.1
17:50:04 INFO - mozsystemmonitor == 0.0
17:50:04 INFO - moztest == 0.7
17:50:04 INFO - mozversion == 1.4
17:50:04 INFO - psutil == 3.1.1
17:50:04 INFO - requests == 1.2.3
17:50:04 INFO - Installing None into virtualenv C:\slave\test\build/venv
17:50: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')]}
17:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
17:50: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')]}
17:50:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
17:50:04 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test\\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 0x02284B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022DDEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0238E930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x006E8B48>, '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 0x0070A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02769660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build\\tests\\talos', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-062', 'USERDOMAIN': 'T-W864-IX-062', '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-062', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-062\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-062', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-062', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-062', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test/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', '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-062\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test', '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
17:50:04 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test\\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\build\tests\talos
17:50:04 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --download-cache C:\slave\test\build/venv\cache --timeout 120 -r C:\slave\test\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
17:50:04 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
17:50:04 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-062\\AppData\\Roaming',
17:50:04 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
17:50:04 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
17:50:04 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
17:50:04 INFO - 'COMPUTERNAME': 'T-W864-IX-062',
17:50:04 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
17:50:04 INFO - 'DCLOCATION': 'SCL3',
17:50:04 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
17:50:04 INFO - 'FP_NO_HOST_CHECK': 'NO',
17:50:04 INFO - 'HOMEDRIVE': 'C:',
17:50:04 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-062',
17:50:04 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
17:50:04 INFO - 'KTS_VERSION': '1.19c',
17:50:04 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-062\\AppData\\Local',
17:50:04 INFO - 'LOGONSERVER': '\\\\T-W864-IX-062',
17:50:04 INFO - 'MONDIR': 'C:\\Monitor_config\\',
17:50:04 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
17:50:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
17:50:04 INFO - 'MOZ_NO_REMOTE': '1',
17:50:04 INFO - 'NO_EM_RESTART': '1',
17:50:04 INFO - 'NUMBER_OF_PROCESSORS': '8',
17:50:04 INFO - 'OS': 'Windows_NT',
17:50:04 INFO - 'OURDRIVE': 'C:',
17:50: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',
17:50:04 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
17:50:04 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
17:50:04 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
17:50:04 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
17:50:04 INFO - 'PROCESSOR_LEVEL': '6',
17:50:04 INFO - 'PROCESSOR_REVISION': '1e05',
17:50:04 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
17:50:04 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
17:50:04 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
17:50:04 INFO - 'PROGRAMW6432': 'C:\\Program Files',
17:50:04 INFO - 'PROMPT': '$P$G',
17:50:04 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
17:50:04 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
17:50:04 INFO - 'PUBLIC': 'C:\\Users\\Public',
17:50:04 INFO - 'PWD': 'C:\\slave\\test',
17:50:04 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
17:50:04 INFO - 'SLAVEDIR': 'C:\\slave\\',
17:50:04 INFO - 'SYSTEMDRIVE': 'C:',
17:50:04 INFO - 'SYSTEMROOT': 'C:\\windows',
17:50:04 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
17:50:04 INFO - 'TEST1': 'testie',
17:50:04 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
17:50:04 INFO - 'USERDOMAIN': 'T-W864-IX-062',
17:50:04 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-062',
17:50:04 INFO - 'USERNAME': 'cltbld',
17:50:04 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-062',
17:50:04 INFO - 'WINDIR': 'C:\\windows',
17:50:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
17:50:04 INFO - Ignoring indexes: https://pypi.python.org/simple/
17:50:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 1))
17:50:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 2))
17:50:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 3))
17:50:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 4))
17:50:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 5))
17:50:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 6))
17:50:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 7))
17:50:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 8))
17:50:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash>=0.15->-r C:\slave\test\build\tests\talos\requirements.txt (line 1))
17:50:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test\build\venv\lib\site-packages (from mozhttpd>=0.7->-r C:\slave\test\build\tests\talos\requirements.txt (line 3))
17:50:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in c:\slave\test\build\venv\lib\site-packages (from mozlog>=3.0->mozcrash>=0.15->-r C:\slave\test\build\tests\talos\requirements.txt (line 1))
17:50:04 INFO - Cleaning up...
17:50:04 INFO - Return code: 0
17:50:04 INFO - Running post-action listener: _resource_record_post_action
17:50:04 INFO - Running post-action listener: _start_resource_monitoring
17:50:04 INFO - Starting resource monitoring.
17:50:05 INFO - #####
17:50:05 INFO - ##### Running install step.
17:50:05 INFO - #####
17:50:05 INFO - Running pre-action listener: _resource_record_pre_action
17:50:05 INFO - Running main action method: install
17:50:05 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze']
17:50:05 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze
17:50:05 INFO - Reading from file tmpfile_stdout
17:50:05 INFO - Using _rmtree_windows ...
17:50:05 INFO - Using _rmtree_windows ...
17:50:05 INFO - Detecting whether we're running mozinstall >=1.0...
17:50:05 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h']
17:50:05 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h
17:50:05 INFO - Reading from file tmpfile_stdout
17:50:05 INFO - Output received:
17:50:05 INFO - Usage: mozinstall-script.py [options] installer
17:50:05 INFO - Options:
17:50:05 INFO - -h, --help show this help message and exit
17:50:05 INFO - -d DEST, --destination=DEST
17:50:05 INFO - Directory to install application into. [default:
17:50:05 INFO - "C:\slave\test"]
17:50:05 INFO - --app=APP Application being installed. [default: firefox]
17:50:05 INFO - Using _rmtree_windows ...
17:50:05 INFO - Using _rmtree_windows ...
17:50:05 INFO - mkdir: C:\slave\test\build\application
17:50:05 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', 'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win64.zip', '--destination', 'C:\\slave\\test\\build\\application']
17:50:05 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py C:\slave\test\build\firefox-44.0a1.en-US.win64.zip --destination C:\slave\test\build\application
17:50:06 INFO - Reading from file tmpfile_stdout
17:50:06 INFO - Output received:
17:50:06 INFO - C:\slave\test\build\application\firefox\firefox.exe
17:50:06 INFO - Using _rmtree_windows ...
17:50:06 INFO - Using _rmtree_windows ...
17:50:06 INFO - Running post-action listener: _resource_record_post_action
17:50:06 INFO - #####
17:50:06 INFO - ##### Running run-tests step.
17:50:06 INFO - #####
17:50:06 INFO - Running pre-action listener: _resource_record_pre_action
17:50:06 INFO - Running main action method: run_tests
17:50:06 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version']
17:50:06 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version
17:50:06 INFO - Python 2.7.3
17:50:06 INFO - Return code: 0
17:50:06 INFO - grabbing minidump binary from tooltool
17:50:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
17:50:06 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\\build\\tests\\config/tooltool-manifests/win32/releng.manifest', '-o'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x006E8B48>, '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 0x0070A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02769660>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1
17:50:06 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\\build\\tests\\config/tooltool-manifests/win32/releng.manifest', '-o'] in C:\slave\test\build
17:50:06 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\build\tests\config/tooltool-manifests/win32/releng.manifest -o
17:50:06 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'...
17:50:07 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmp7n2exl
17:50:08 INFO - INFO - File integrity verified, renaming tmp7n2exl to win32-minidump_stackwalk.exe
17:50:08 INFO - Return code: 0
17:50:08 INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755
17:50:08 INFO - mkdir: C:\slave\test\build\blobber_upload_dir
17:50:08 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir
17:50:08 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe
17:50:08 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir
17:50:08 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/psRrk3pCQsyAuHn-YdcjIA/artifacts/public/build/firefox-44.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-062', '--webServer', 'localhost'] in C:\slave\test\build
17:50:08 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\tests\talos\talos\run_tests.py --debug --branchName Mozilla-Inbound-Non-PGO --suite dromaeojs --executablePath C:\slave\test\build\application\firefox\firefox --symbolsPath https://queue.taskcluster.net/v1/task/psRrk3pCQsyAuHn-YdcjIA/artifacts/public/build/firefox-44.0a1.en-US.win64.crashreporter-symbols.zip --title T-W864-IX-062 --webServer localhost
17:50:08 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData',
17:50:08 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-062\\AppData\\Roaming',
17:50:08 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files',
17:50:08 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files',
17:50:08 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files',
17:50:08 INFO - 'COMPUTERNAME': 'T-W864-IX-062',
17:50:08 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe',
17:50:08 INFO - 'DCLOCATION': 'SCL3',
17:50:08 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com',
17:50:08 INFO - 'FP_NO_HOST_CHECK': 'NO',
17:50:08 INFO - 'HOMEDRIVE': 'C:',
17:50:08 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-062',
17:50:08 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS',
17:50:08 INFO - 'KTS_VERSION': '1.19c',
17:50:08 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-062\\AppData\\Local',
17:50:08 INFO - 'LOGONSERVER': '\\\\T-W864-IX-062',
17:50:08 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir',
17:50:08 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe',
17:50:08 INFO - 'MONDIR': 'C:\\Monitor_config\\',
17:50:08 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\',
17:50:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
17:50:08 INFO - 'MOZ_NO_REMOTE': '1',
17:50:08 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir',
17:50:08 INFO - 'NO_EM_RESTART': '1',
17:50:08 INFO - 'NUMBER_OF_PROCESSORS': '8',
17:50:08 INFO - 'OS': 'Windows_NT',
17:50:08 INFO - 'OURDRIVE': 'C:',
17:50:08 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts',
17:50:08 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC',
17:50:08 INFO - 'PROCESSOR_ARCHITECTURE': 'x86',
17:50:08 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64',
17:50:08 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel',
17:50:08 INFO - 'PROCESSOR_LEVEL': '6',
17:50:08 INFO - 'PROCESSOR_REVISION': '1e05',
17:50:08 INFO - 'PROGRAMDATA': 'C:\\ProgramData',
17:50:08 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)',
17:50:08 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)',
17:50:08 INFO - 'PROGRAMW6432': 'C:\\Program Files',
17:50:08 INFO - 'PROMPT': '$P$G',
17:50:08 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json',
17:50:08 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\',
17:50:08 INFO - 'PUBLIC': 'C:\\Users\\Public',
17:50:08 INFO - 'PWD': 'C:\\slave\\test',
17:50:08 INFO - 'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos',
17:50:08 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log',
17:50:08 INFO - 'SLAVEDIR': 'C:\\slave\\',
17:50:08 INFO - 'SYSTEMDRIVE': 'C:',
17:50:08 INFO - 'SYSTEMROOT': 'C:\\windows',
17:50:08 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
17:50:08 INFO - 'TEST1': 'testie',
17:50:08 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp',
17:50:08 INFO - 'USERDOMAIN': 'T-W864-IX-062',
17:50:08 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-062',
17:50:08 INFO - 'USERNAME': 'cltbld',
17:50:08 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-062',
17:50:08 INFO - 'WINDIR': 'C:\\windows',
17:50:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn'}
17:50:08 INFO - Calling ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/psRrk3pCQsyAuHn-YdcjIA/artifacts/public/build/firefox-44.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-062', '--webServer', 'localhost'] with output_timeout 3600
ProcessManager NOT managing child processes
ProcessManager UNABLE to use job objects to manage child processes
17:50:08 INFO - mozversion INFO | application_buildid: 20151026160202
17:50:08 INFO - mozversion INFO | application_changeset: f9cd7aa25d6f212d0cf6c48318ff47f2c4ebab88
17:50:08 INFO - mozversion INFO | application_display_name: Nightly
17:50:08 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384}
17:50:08 INFO - mozversion INFO | application_name: Firefox
17:50:08 INFO - mozversion INFO | application_remotingname: firefox
17:50:08 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound
17:50:08 INFO - mozversion INFO | application_vendor: Mozilla
17:50:08 INFO - mozversion INFO | application_version: 44.0a1
17:50:08 INFO - mozversion INFO | platform_buildid: 20151026160202
17:50:08 INFO - mozversion INFO | platform_changeset: f9cd7aa25d6f212d0cf6c48318ff47f2c4ebab88
17:50:08 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound
17:50:08 INFO - mozversion INFO | platform_version: 44.0a1
17:50:08 INFO - 2015-10-26 17:50:08,937 DEBUG : using testdate: 1445907008
17:50:08 INFO - 2015-10-26 17:50:08,937 DEBUG : actual date: 1445907008
17:50:10 INFO - 2015-10-26 17:50:10,318 INFO : starting webserver on 'localhost:49267'
17:50:10 INFO - 2015-10-26 17:50:10,319 INFO : Starting test suite T-W864-IX-062
17:50:10 INFO - 2015-10-26 17:50:10,319 INFO : Starting test dromaeo_css
17:50:10 INFO - 2015-10-26 17:50:10,319 DEBUG : operating with platform_type : w8_
17:50:10 INFO - 2015-10-26 17:50:10,319 INFO : Initialising browser for dromaeo_css test...
17:50:10 INFO - 2015-10-26 17:50:10,536 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmp4ctnlb\profile http://localhost:49267/getInfo.html
17:50:18 INFO - 2015-10-26 17:50:18,548 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200
17:50:18 INFO - 2015-10-26 17:50:18,548 DEBUG : BROWSER_OUTPUT: colorDepth:24
17:50:18 INFO - 2015-10-26 17:50:18,548 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674
17:50:18 INFO - 2015-10-26 17:50:18,548 DEBUG : BROWSER_OUTPUT: __metrics
17:50:18 INFO - 2015-10-26 17:50:18,749 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:50:19 INFO - 2015-10-26 17:50:19,325 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code.
17:50:19 INFO - 2015-10-26 17:50:19,536 DEBUG : BROWSER_OUTPUT: console.error:
17:50:19 INFO - 2015-10-26 17:50:19,536 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:50:19 INFO - 2015-10-26 17:50:19,536 DEBUG : BROWSER_OUTPUT: Stack:
17:50:19 INFO - 2015-10-26 17:50:19,536 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<._executeStatement@resource://gre/modules/Sqlite.jsm:758:19
17:50:19 INFO - 2015-10-26 17:50:19,536 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached/<@resource://gre/modules/Sqlite.jsm:493:9
17:50:19 INFO - 2015-10-26 17:50:19,536 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached@resource://gre/modules/Sqlite.jsm:491:1
17:50:19 INFO - 2015-10-26 17:50:19,536 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeBeforeShutdown/loggedDb<.executeCached.value<@resource://gre/modules/Sqlite.jsm:368:51
17:50:19 INFO - 2015-10-26 17:50:19,536 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40
17:50:19 INFO - 2015-10-26 17:50:19,536 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3
17:50:19 INFO - 2015-10-26 17:50:19,536 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14
17:50:19 INFO - 2015-10-26 17:50:19,536 DEBUG : BROWSER_OUTPUT: transaction@resource://gre/modules/Bookmarks.jsm:783:15
17:50:19 INFO - 2015-10-26 17:50:19,536 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40
17:50:19 INFO - 2015-10-26 17:50:19,536 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3
17:50:19 INFO - 2015-10-26 17:50:19,536 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14
17:50:19 INFO - 2015-10-26 17:50:19,536 DEBUG : BROWSER_OUTPUT: Task_spawn@resource://gre/modules/Task.jsm:164:12
17:50:19 INFO - 2015-10-26 17:50:19,536 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23
18:08:57 INFO - 2015-10-26 18:08:57,286 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7
18:08:57 INFO - 2015-10-26 18:08:57,286 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11
18:08:57 INFO - 2015-10-26 18:08:57,286 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7
18:08:57 INFO - 2015-10-26 18:08:57,286 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7
18:08:57 INFO - 2015-10-26 18:08:57,286 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13
18:08:57 INFO - 2015-10-26 18:08:57,286 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9
18:08:57 INFO - 2015-10-26 18:08:57,286 DEBUG : BROWSER_OUTPUT:
18:08:57 INFO - 2015-10-26 18:08:57,987 INFO : Browser initialized.
18:08:57 INFO - 2015-10-26 18:08:57,987 INFO : Running cycle 1/1 for kraken test...
18:08:57 INFO - 2015-10-26 18:08:57,987 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpbn9_26\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\kraken\kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1
18:09:09 INFO - 2015-10-26 18:09:09,563 DEBUG : BROWSER_OUTPUT: RSS: Main: 181321728
18:09:09 INFO - 2015-10-26 18:09:09,563 DEBUG : BROWSER_OUTPUT:
18:09:12 INFO - 2015-10-26 18:09:12,305 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection)
18:09:12 INFO - 2015-10-26 18:09:12,894 DEBUG : BROWSER_OUTPUT: RSS: Main: 217800704
18:09:12 INFO - 2015-10-26 18:09:12,894 DEBUG : BROWSER_OUTPUT:
18:09:15 INFO - 2015-10-26 18:09:15,605 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft)
18:09:16 INFO - 2015-10-26 18:09:16,187 DEBUG : BROWSER_OUTPUT: RSS: Main: 217731072
18:09:16 INFO - 2015-10-26 18:09:16,187 DEBUG : BROWSER_OUTPUT:
18:09:18 INFO - 2015-10-26 18:09:18,888 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft)
18:09:19 INFO - 2015-10-26 18:09:19,469 DEBUG : BROWSER_OUTPUT: RSS: Main: 202113024
18:09:19 INFO - 2015-10-26 18:09:19,469 DEBUG : BROWSER_OUTPUT:
18:09:21 INFO - 2015-10-26 18:09:21,476 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator)
18:09:22 INFO - 2015-10-26 18:09:22,053 DEBUG : BROWSER_OUTPUT: RSS: Main: 204427264
18:09:22 INFO - 2015-10-26 18:09:22,055 DEBUG : BROWSER_OUTPUT:
18:09:24 INFO - 2015-10-26 18:09:24,263 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur)
18:09:24 INFO - 2015-10-26 18:09:24,825 DEBUG : BROWSER_OUTPUT: RSS: Main: 202727424
18:09:24 INFO - 2015-10-26 18:09:24,826 DEBUG : BROWSER_OUTPUT:
18:09:27 INFO - 2015-10-26 18:09:27,877 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom)
18:09:28 INFO - 2015-10-26 18:09:28,453 DEBUG : BROWSER_OUTPUT: RSS: Main: 196177920
18:09:28 INFO - 2015-10-26 18:09:28,453 DEBUG : BROWSER_OUTPUT:
18:09:31 INFO - 2015-10-26 18:09:31,953 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate)
18:09:32 INFO - 2015-10-26 18:09:32,536 DEBUG : BROWSER_OUTPUT: RSS: Main: 188973056
18:09:32 INFO - 2015-10-26 18:09:32,538 DEBUG : BROWSER_OUTPUT:
18:09:35 INFO - 2015-10-26 18:09:35,460 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial)
18:09:36 INFO - 2015-10-26 18:09:36,029 DEBUG : BROWSER_OUTPUT: RSS: Main: 187080704
18:09:36 INFO - 2015-10-26 18:09:36,029 DEBUG : BROWSER_OUTPUT:
18:09:37 INFO - 2015-10-26 18:09:37,809 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox)
18:09:38 INFO - 2015-10-26 18:09:38,375 DEBUG : BROWSER_OUTPUT: RSS: Main: 218570752
18:09:38 INFO - 2015-10-26 18:09:38,375 DEBUG : BROWSER_OUTPUT:
18:09:40 INFO - 2015-10-26 18:09:40,272 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes)
18:09:40 INFO - 2015-10-26 18:09:40,848 DEBUG : BROWSER_OUTPUT: RSS: Main: 222892032
18:09:40 INFO - 2015-10-26 18:09:40,848 DEBUG : BROWSER_OUTPUT:
18:09:43 INFO - 2015-10-26 18:09:43,154 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm)
18:09:43 INFO - 2015-10-26 18:09:43,736 DEBUG : BROWSER_OUTPUT: RSS: Main: 227655680
18:09:43 INFO - 2015-10-26 18:09:43,736 DEBUG : BROWSER_OUTPUT:
18:09:46 INFO - 2015-10-26 18:09:46,358 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2)
18:09:46 INFO - 2015-10-26 18:09:46,944 DEBUG : BROWSER_OUTPUT: RSS: Main: 230727680
18:09:46 INFO - 2015-10-26 18:09:46,944 DEBUG : BROWSER_OUTPUT:
18:09:49 INFO - 2015-10-26 18:09:49,773 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative)
18:09:50 INFO - 2015-10-26 18:09:50,355 DEBUG : BROWSER_OUTPUT: RSS: Main: 231215104
18:09:50 INFO - 2015-10-26 18:09:50,355 DEBUG : BROWSER_OUTPUT:
18:09:52 INFO - 2015-10-26 18:09:52,210 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar)
18:09:52 INFO - 2015-10-26 18:09:52,457 DEBUG : BROWSER_OUTPUT: RSS: Main: 286277632
18:09:52 INFO - 2015-10-26 18:09:52,457 DEBUG : BROWSER_OUTPUT:
18:09:52 INFO - 2015-10-26 18:09:52,459 DEBUG : BROWSER_OUTPUT: __start_tp_report
18:09:52 INFO - 2015-10-26 18:09:52,459 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load
18:09:52 INFO - 2015-10-26 18:09:52,459 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details
18:09:52 INFO - 2015-10-26 18:09:52,459 DEBUG : BROWSER_OUTPUT: |i|pagename|runs|
18:09:52 INFO - 2015-10-26 18:09:52,459 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;112;108;112;113;113;114;113;109;113
18:09:52 INFO - 2015-10-26 18:09:52,459 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;134;130;150;161;134;134;145;129;162;134
18:09:52 INFO - 2015-10-26 18:09:52,459 DEBUG : BROWSER_OUTPUT: |2;audio-dft;142;141;139;140;140;141;162;143;140;140
18:09:52 INFO - 2015-10-26 18:09:52,459 DEBUG : BROWSER_OUTPUT: |3;audio-fft;69;71;71;99;74;70;69;70;100;68
18:09:52 INFO - 2015-10-26 18:09:52,459 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;90;111;91;91;91;118;91;91;120
18:09:52 INFO - 2015-10-26 18:09:52,459 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;112;110;111;110;111;111;110;111;110
18:09:52 INFO - 2015-10-26 18:09:52,459 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;131;133;133;133;132;133;132;136;132;132
18:09:52 INFO - 2015-10-26 18:09:52,459 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;96;98;96;98;106;100;99;96;96
18:09:52 INFO - 2015-10-26 18:09:52,459 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;70;71;70;70;71;71;85;71;69
18:09:52 INFO - 2015-10-26 18:09:52,459 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;70;69;69;69;69;70;69;69;69;68
18:09:52 INFO - 2015-10-26 18:09:52,460 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;94;92;92;94;95;96;94;93;94;93
18:09:52 INFO - 2015-10-26 18:09:52,460 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;137;131;129;131;125;129;136;133;128;134
18:09:52 INFO - 2015-10-26 18:09:52,460 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;169;158;170;168;164;156;172;164;170;168
18:09:52 INFO - 2015-10-26 18:09:52,460 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;76;76;77;76;77;75;75;77;75;76
18:09:52 INFO - 2015-10-26 18:09:52,460 DEBUG : BROWSER_OUTPUT: __end_tp_report
18:09:52 INFO - 2015-10-26 18:09:52,460 DEBUG : BROWSER_OUTPUT: __start_cc_report
18:09:52 INFO - 2015-10-26 18:09:52,460 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,966
18:09:52 INFO - 2015-10-26 18:09:52,460 DEBUG : BROWSER_OUTPUT: __end_cc_report
18:09:52 INFO - 2015-10-26 18:09:52,460 DEBUG : BROWSER_OUTPUT: __startTimestamp1445908192457__endTimestamp
18:09:52 INFO - 2015-10-26 18:09:52,460 DEBUG : BROWSER_OUTPUT:
18:09:52 INFO - 2015-10-26 18:09:52,461 DEBUG : BROWSER_OUTPUT: ------- Summary: start -------
18:09:52 INFO - 2015-10-26 18:09:52,461 DEBUG : BROWSER_OUTPUT: Number of tests: 14
18:09:52 INFO - 2015-10-26 18:09:52,463 DEBUG : BROWSER_OUTPUT:
18:09:52 INFO - 2015-10-26 18:09:52,463 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.10 Median:113.00 stddev:2.02 (1.8%) stddev-sans-first:2.03
18:09:52 INFO - 2015-10-26 18:09:52,463 DEBUG : BROWSER_OUTPUT: Values: 114.0 112.0 108.0 112.0 113.0 113.0 114.0 113.0 109.0 113.0
18:09:52 INFO - 2015-10-26 18:09:52,463 DEBUG : BROWSER_OUTPUT:
18:09:52 INFO - 2015-10-26 18:09:52,463 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.30 Median:139.50 stddev:12.46 (8.9%) stddev-sans-first:12.94
18:09:52 INFO - 2015-10-26 18:09:52,463 DEBUG : BROWSER_OUTPUT: Values: 134.0 130.0 150.0 161.0 134.0 134.0 145.0 129.0 162.0 134.0
18:09:52 INFO - 2015-10-26 18:09:52,463 DEBUG : BROWSER_OUTPUT:
18:09:52 INFO - 2015-10-26 18:09:52,463 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:142.80 Median:141.00 stddev:6.84 (4.9%) stddev-sans-first:7.25
18:09:52 INFO - 2015-10-26 18:09:52,464 DEBUG : BROWSER_OUTPUT: Values: 142.0 141.0 139.0 140.0 140.0 141.0 162.0 143.0 140.0 140.0
18:09:52 INFO - 2015-10-26 18:09:52,464 DEBUG : BROWSER_OUTPUT:
18:09:52 INFO - 2015-10-26 18:09:52,464 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:76.10 Median:70.50 stddev:12.44 (17.6%) stddev-sans-first:12.93
18:09:52 INFO - 2015-10-26 18:09:52,464 DEBUG : BROWSER_OUTPUT: Values: 69.0 71.0 71.0 99.0 74.0 70.0 69.0 70.0 100.0 68.0
18:09:52 INFO - 2015-10-26 18:09:52,464 DEBUG : BROWSER_OUTPUT:
18:09:52 INFO - 2015-10-26 18:09:52,464 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:98.50 Median:91.00 stddev:12.51 (13.7%) stddev-sans-first:12.97
18:09:52 INFO - 2015-10-26 18:09:52,464 DEBUG : BROWSER_OUTPUT: Values: 91.0 90.0 111.0 91.0 91.0 91.0 118.0 91.0 91.0 120.0
18:09:52 INFO - 2015-10-26 18:09:52,466 DEBUG : BROWSER_OUTPUT:
18:09:52 INFO - 2015-10-26 18:09:52,466 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.60 Median:111.00 stddev:0.70 (0.6%) stddev-sans-first:0.71
18:09:52 INFO - 2015-10-26 18:09:52,466 DEBUG : BROWSER_OUTPUT: Values: 110.0 112.0 110.0 111.0 110.0 111.0 111.0 110.0 111.0 110.0
18:09:52 INFO - 2015-10-26 18:09:52,466 DEBUG : BROWSER_OUTPUT:
18:09:52 INFO - 2015-10-26 18:09:52,466 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:132.70 Median:133.00 stddev:1.34 (1.0%) stddev-sans-first:1.27
18:09:52 INFO - 2015-10-26 18:09:52,466 DEBUG : BROWSER_OUTPUT: Values: 131.0 133.0 133.0 133.0 132.0 133.0 132.0 136.0 132.0 132.0
18:09:52 INFO - 2015-10-26 18:09:52,466 DEBUG : BROWSER_OUTPUT:
18:09:52 INFO - 2015-10-26 18:09:52,466 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:98.20 Median:96.50 stddev:3.08 (3.2%) stddev-sans-first:3.24
18:09:52 INFO - 2015-10-26 18:09:52,466 DEBUG : BROWSER_OUTPUT: Values: 97.0 96.0 98.0 96.0 98.0 106.0 100.0 99.0 96.0 96.0
18:09:52 INFO - 2015-10-26 18:09:52,466 DEBUG : BROWSER_OUTPUT:
18:09:52 INFO - 2015-10-26 18:09:52,466 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.90 Median:71.00 stddev:4.65 (6.6%) stddev-sans-first:4.92
18:09:52 INFO - 2015-10-26 18:09:52,466 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 71.0 70.0 70.0 71.0 71.0 85.0 71.0 69.0
18:09:52 INFO - 2015-10-26 18:09:52,466 DEBUG : BROWSER_OUTPUT:
18:09:52 INFO - 2015-10-26 18:09:52,466 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.00 stddev:0.57 (0.8%) stddev-sans-first:0.50
18:09:52 INFO - 2015-10-26 18:09:52,467 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 69.0 69.0 69.0 70.0 69.0 69.0 69.0 68.0
18:09:52 INFO - 2015-10-26 18:09:52,467 DEBUG : BROWSER_OUTPUT:
18:09:52 INFO - 2015-10-26 18:09:52,467 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:93.70 Median:94.00 stddev:1.25 (1.3%) stddev-sans-first:1.32
18:09:52 INFO - 2015-10-26 18:09:52,467 DEBUG : BROWSER_OUTPUT: Values: 94.0 92.0 92.0 94.0 95.0 96.0 94.0 93.0 94.0 93.0
18:09:52 INFO - 2015-10-26 18:09:52,467 DEBUG : BROWSER_OUTPUT:
18:09:52 INFO - 2015-10-26 18:09:52,467 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:131.30 Median:132.00 stddev:3.74 (2.8%) stddev-sans-first:3.35
18:09:52 INFO - 2015-10-26 18:09:52,467 DEBUG : BROWSER_OUTPUT: Values: 137.0 131.0 129.0 131.0 125.0 129.0 136.0 133.0 128.0 134.0
18:09:52 INFO - 2015-10-26 18:09:52,467 DEBUG : BROWSER_OUTPUT:
18:09:52 INFO - 2015-10-26 18:09:52,467 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.90 Median:168.50 stddev:5.34 (3.2%) stddev-sans-first:5.55
18:09:52 INFO - 2015-10-26 18:09:52,469 DEBUG : BROWSER_OUTPUT: Values: 169.0 158.0 170.0 168.0 164.0 156.0 172.0 164.0 170.0 168.0
18:09:52 INFO - 2015-10-26 18:09:52,469 DEBUG : BROWSER_OUTPUT:
18:09:52 INFO - 2015-10-26 18:09:52,469 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.00 Median:76.00 stddev:0.82 (1.1%) stddev-sans-first:0.87
18:09:52 INFO - 2015-10-26 18:09:52,470 DEBUG : BROWSER_OUTPUT: Values: 76.0 76.0 77.0 76.0 77.0 75.0 75.0 77.0 75.0 76.0
18:09:52 INFO - 2015-10-26 18:09:52,470 DEBUG : BROWSER_OUTPUT: -------- Summary: end --------
18:09:52 INFO - 2015-10-26 18:09:52,470 DEBUG : BROWSER_OUTPUT:
18:09:53 INFO - 2015-10-26 18:09:53,220 INFO : Browser exited with error code: 0
18:09:54 INFO - 2015-10-26 18:09:54,219 INFO : Completed test kraken (00:01:03)
18:09:54 INFO - 2015-10-26 18:09:54,219 INFO : Starting test v8_7
18:09:54 INFO - 2015-10-26 18:09:54,219 DEBUG : operating with platform_type : w8_
18:09:54 INFO - 2015-10-26 18:09:54,219 INFO : Initialising browser for v8_7 test...
18:09:54 INFO - 2015-10-26 18:09:54,240 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpf2wiqe\profile http://localhost:49267/getInfo.html
18:10:00 INFO - 2015-10-26 18:10:00,091 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200
18:10:00 INFO - 2015-10-26 18:10:00,091 DEBUG : BROWSER_OUTPUT: colorDepth:24
18:10:00 INFO - 2015-10-26 18:10:00,091 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674
18:10:00 INFO - 2015-10-26 18:10:00,091 DEBUG : BROWSER_OUTPUT: __metrics
18:10:00 INFO - 2015-10-26 18:10:00,240 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver]
18:10:01 INFO - 2015-10-26 18:10:01,187 DEBUG : BROWSER_OUTPUT: console.error:
18:10:01 INFO - 2015-10-26 18:10:01,188 DEBUG : BROWSER_OUTPUT: Message: Error: Transaction canceled due to a closed connection.
18:10:01 INFO - 2015-10-26 18:10:01,188 DEBUG : BROWSER_OUTPUT: Stack:
18:10:01 INFO - 2015-10-26 18:10:01,188 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise<@resource://gre/modules/Sqlite.jsm:562:1
18:10:01 INFO - 2015-10-26 18:10:01,188 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9
18:10:01 INFO - 2015-10-26 18:10:01,188 DEBUG : BROWSER_OUTPUT:
18:10:01 INFO - 2015-10-26 18:10:01,914 INFO : Browser initialized.
18:10:01 INFO - 2015-10-26 18:10:01,914 INFO : Running cycle 1/1 for v8_7 test...
18:10:01 INFO - 2015-10-26 18:10:01,914 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpf2wiqe\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\v8_7\v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1
18:10:13 INFO - 2015-10-26 18:10:13,469 DEBUG : BROWSER_OUTPUT: RSS: Main: 177975296
18:10:13 INFO - 2015-10-26 18:10:13,469 DEBUG : BROWSER_OUTPUT:
18:10:35 INFO - 2015-10-26 18:10:35,184 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/v8_7/run.html (next: http://localhost:49267/tests/v8_7/run.html)
18:10:35 INFO - 2015-10-26 18:10:35,434 DEBUG : BROWSER_OUTPUT: RSS: Main: 598822912
18:10:35 INFO - 2015-10-26 18:10:35,434 DEBUG : BROWSER_OUTPUT:
18:10:35 INFO - 2015-10-26 18:10:35,434 DEBUG : BROWSER_OUTPUT: __start_tp_report
18:10:35 INFO - 2015-10-26 18:10:35,434 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load
18:10:35 INFO - 2015-10-26 18:10:35,434 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details
18:10:35 INFO - 2015-10-26 18:10:35,434 DEBUG : BROWSER_OUTPUT: |i|pagename|runs|
18:10:35 INFO - 2015-10-26 18:10:35,434 DEBUG : BROWSER_OUTPUT: |0;Richards;166.25103906899417
18:10:35 INFO - 2015-10-26 18:10:35,434 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;175.99436818021823
18:10:35 INFO - 2015-10-26 18:10:35,436 DEBUG : BROWSER_OUTPUT: |2;Encrypt;284.8191398461977
18:10:35 INFO - 2015-10-26 18:10:35,436 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5055.555555555556
18:10:35 INFO - 2015-10-26 18:10:35,436 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1587.3015873015872
18:10:35 INFO - 2015-10-26 18:10:35,436 DEBUG : BROWSER_OUTPUT: |5;Earley;661.3756613756614
18:10:35 INFO - 2015-10-26 18:10:35,437 DEBUG : BROWSER_OUTPUT: |6;Boyer;12575
18:10:35 INFO - 2015-10-26 18:10:35,437 DEBUG : BROWSER_OUTPUT: |7;RegExp;31437.5
18:10:35 INFO - 2015-10-26 18:10:35,437 DEBUG : BROWSER_OUTPUT: |8;Splay;724.6376811594203
18:10:35 INFO - 2015-10-26 18:10:35,437 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4868.9320388349515
18:10:35 INFO - 2015-10-26 18:10:35,437 DEBUG : BROWSER_OUTPUT: __end_tp_report
18:10:35 INFO - 2015-10-26 18:10:35,437 DEBUG : BROWSER_OUTPUT: __startTimestamp1445908235434__endTimestamp
18:10:35 INFO - 2015-10-26 18:10:35,437 DEBUG : BROWSER_OUTPUT:
18:10:35 INFO - 2015-10-26 18:10:35,437 DEBUG : BROWSER_OUTPUT: ------- Summary: start -------
18:10:35 INFO - 2015-10-26 18:10:35,437 DEBUG : BROWSER_OUTPUT: Number of tests: 10
18:10:35 INFO - 2015-10-26 18:10:35,437 DEBUG : BROWSER_OUTPUT:
18:10:35 INFO - 2015-10-26 18:10:35,437 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.25 Median:166.25 stddev:0.00 (0.0%)
18:10:35 INFO - 2015-10-26 18:10:35,437 DEBUG : BROWSER_OUTPUT: Values: 166.3
18:10:35 INFO - 2015-10-26 18:10:35,437 DEBUG : BROWSER_OUTPUT:
18:10:35 INFO - 2015-10-26 18:10:35,437 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:175.99 Median:175.99 stddev:0.00 (0.0%)
18:10:35 INFO - 2015-10-26 18:10:35,437 DEBUG : BROWSER_OUTPUT: Values: 176.0
18:10:35 INFO - 2015-10-26 18:10:35,437 DEBUG : BROWSER_OUTPUT:
18:10:35 INFO - 2015-10-26 18:10:35,437 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:284.82 Median:284.82 stddev:0.00 (0.0%)
18:10:35 INFO - 2015-10-26 18:10:35,437 DEBUG : BROWSER_OUTPUT: Values: 284.8
18:10:35 INFO - 2015-10-26 18:10:35,437 DEBUG : BROWSER_OUTPUT:
18:10:35 INFO - 2015-10-26 18:10:35,437 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5055.56 Median:5055.56 stddev:0.00 (0.0%)
18:10:35 INFO - 2015-10-26 18:10:35,438 DEBUG : BROWSER_OUTPUT: Values: 5055.6
18:10:35 INFO - 2015-10-26 18:10:35,438 DEBUG : BROWSER_OUTPUT:
18:10:35 INFO - 2015-10-26 18:10:35,438 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1587.30 Median:1587.30 stddev:0.00 (0.0%)
18:10:35 INFO - 2015-10-26 18:10:35,438 DEBUG : BROWSER_OUTPUT: Values: 1587.3
18:10:35 INFO - 2015-10-26 18:10:35,438 DEBUG : BROWSER_OUTPUT:
18:10:35 INFO - 2015-10-26 18:10:35,438 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:661.38 Median:661.38 stddev:0.00 (0.0%)
18:10:35 INFO - 2015-10-26 18:10:35,438 DEBUG : BROWSER_OUTPUT: Values: 661.4
18:10:35 INFO - 2015-10-26 18:10:35,438 DEBUG : BROWSER_OUTPUT:
18:10:35 INFO - 2015-10-26 18:10:35,438 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12575.00 Median:12575.00 stddev:0.00 (0.0%)
18:10:35 INFO - 2015-10-26 18:10:35,438 DEBUG : BROWSER_OUTPUT: Values: 12575.0
18:10:35 INFO - 2015-10-26 18:10:35,438 DEBUG : BROWSER_OUTPUT:
18:10:35 INFO - 2015-10-26 18:10:35,438 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:31437.50 Median:31437.50 stddev:0.00 (0.0%)
18:10:35 INFO - 2015-10-26 18:10:35,438 DEBUG : BROWSER_OUTPUT: Values: 31437.5
18:10:35 INFO - 2015-10-26 18:10:35,438 DEBUG : BROWSER_OUTPUT:
18:10:35 INFO - 2015-10-26 18:10:35,438 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:724.64 Median:724.64 stddev:0.00 (0.0%)
18:10:35 INFO - 2015-10-26 18:10:35,440 DEBUG : BROWSER_OUTPUT: Values: 724.6
18:10:35 INFO - 2015-10-26 18:10:35,440 DEBUG : BROWSER_OUTPUT:
18:10:35 INFO - 2015-10-26 18:10:35,440 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4868.93 Median:4868.93 stddev:0.00 (0.0%)
18:10:35 INFO - 2015-10-26 18:10:35,440 DEBUG : BROWSER_OUTPUT: Values: 4868.9
18:10:35 INFO - 2015-10-26 18:10:35,440 DEBUG : BROWSER_OUTPUT: -------- Summary: end --------
18:10:35 INFO - 2015-10-26 18:10:35,440 DEBUG : BROWSER_OUTPUT:
18:10:36 INFO - 2015-10-26 18:10:36,164 INFO : Browser exited with error code: 0
18:10:36 INFO - 2015-10-26 18:10:36,885 INFO : Completed test v8_7 (00:00:42)
18:10:37 INFO - 2015-10-26 18:10:37,338 INFO : Completed test suite (00:20:27)
18:10:37 INFO - 2015-10-26 18:10:37,338 DEBUG : Working with test: dromaeo_css
18:10:37 INFO - 2015-10-26 18:10:37,338 DEBUG : Generating results file: dromaeo_css
18:10:37 INFO - 2015-10-26 18:10:37,338 DEBUG : Working with test: kraken
18:10:37 INFO - 2015-10-26 18:10:37,338 DEBUG : Generating results file: kraken
18:10:37 INFO - 2015-10-26 18:10:37,338 INFO : javascript benchmark
18:10:37 INFO - 2015-10-26 18:10:37,338 DEBUG : Working with test: v8_7
18:10:37 INFO - 2015-10-26 18:10:37,338 DEBUG : Generating results file: v8_7
18:10:37 INFO - 2015-10-26 18:10:37,338 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0
18:10:37 INFO - 2015-10-26 18:10:37,555 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,131,31]]
18:10:37 INFO - 2015-10-26 18:10:37,555 DEBUG : process_Request line: dromaeo_css 5864.21 graph.html#tests=[[72,131,31]]
18:10:37 INFO - 2015-10-26 18:10:37,555 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0
18:10:37 INFO - 2015-10-26 18:10:37,585 DEBUG : process_Request line: kraken 1520.20 graph.html#tests=[[232,131,31]]
18:10:37 INFO - 2015-10-26 18:10:37,585 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0
18:10:37 INFO - 2015-10-26 18:10:37,621 DEBUG : process_Request line: v8_7 19983.52 graph.html#tests=[[230,131,31]]
18:10:37 INFO - 2015-10-26 18:10:37,621 INFO : javascript benchmark
18:10:37 INFO - 2015-10-26 18:10:37,624 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [327.77874934419265, 328.769861097232, 328.79031742047266, 331.64679616208736, 332.29553346904567, 13129.146605470638, 13478.46086156555, 14836.258187090643, 15177.39290428383, 15757.684846303082, 14873.0, 15008.0, 15071.397144114222, 15188.696226075472, 15216.467423640175, 4666.8366607168755, 4674.3222232776225, 4681.672282940179, 4782.354382158399, 4924.926126108102, 3665.450182472637, 3748.8125593720342, 4976.0, 5450.890982180354, 5611.7474713637985, 5515.862103447426, 5527.419620939803, 5530.198121272413, 5530.889382212354, 5562.471565201319, 5424.620276580641, 5466.289382380305, 5521.1442226454965, 5522.116461366202, 5539.864327812788, 4716.669833111683, 4739.4075740532435, 4752.049590081963, 4779.091972525209, 4793.664443488957, 18697.15862786178, 18853.905730471397, 19203.903980480147, 19207.807921920743, 19259.51851203717, 513.3736841053908, 1782.58109344304, 1867.5526466988058, 1872.6348362069402, 2046.7339245897938, 11926.224795388358, 11946.761064778655, 11953.94023029888, 12181.0, 12263.93868030654, 1701.5065630967006, 1745.9825401746075, 1759.1380223690428, 1784.5717027913208, 1787.1332403784154, 51566.226506602434, 51782.48217517814, 51786.741066294424, 52249.73875130638, 52793.47206527924, 8314.210150035737, 8314.376421768391, 8429.4942303462, 8446.957765211135, 8622.870656940151, 10621.150307975344, 10754.623588174376, 10759.085477734323, 10763.892361076445, 10776.892231077589, 6601.062527175361, 6612.933870661232, 6617.4706023518, 6620.966895165493, 6661.500387470959, 6496.22045354551, 6506.902396464056, 6521.152250207443, 6560.44236239925, 6565.080888675494, 5166.767495462638, 5228.0, 5230.241614965885, 5240.659357141773, 5246.895062098737, 1505.7515509940738, 1530.3572499550216, 1557.1435710359258, 1585.1044160049535, 1635.934562617482, 370.16897066086807, 873.7815546113471, 919.3518569408551, 925.6991477769752, 1010.7321559786662, 8942.552872356357, 9113.81772364549, 9403.247740180768, 9454.43273403598, 9502.714918552454, 366.27843148996436, 401.68267069015735, 404.8036702199431, 406.1633035945961, 408.07367276283264, 5191.402988656353, 5211.1922651989, 5262.657927234717, 5282.0, 5291.312129423227, 412639.0, 415506.0, 424751.0, 425773.0, 430067.0, 63355.366446335865, 63378.0, 63607.0, 63842.68078659577, 64590.35409645937, 388.31462468742694, 394.23715111259804, 417.96238338549676, 420.4807063276851, 421.13666982685373, 8627.95686021566, 8754.29965602763, 8832.249258813074, 8904.510251936206, 8973.102689730975, 27074.72925270722, 27295.72704272932, 27796.305092372044, 27887.16338509848, 27904.860475697493, 29609.555856661736, 33016.50475242922, 35644.46533301951, 36031.81984090063, 38643.227135457695, 5683.573731970201, 5765.164051212634, 5809.651420914759, 5823.82528524145, 5839.299284085937, 10273.383596984206, 10739.892601073889, 10771.407572583583, 10824.621138260123, 10871.29336593119, 9609.279304052085, 9621.374610650286, 9695.563699633674, 9793.51032448389, 9987.700368988943, 9430.62277508892, 9604.08761167688, 9673.129418352382, 9783.36408133469, 9842.507874606097, 9957.800843983225, 10126.13927816144, 10168.0, 10172.389656620626, 10249.795004099728, 5533.418991005887, 5541.722913854211, 5598.692071936082, 5609.0, 5636.070048441961, 9419.623215071595, 9635.951820240854, 9811.067948544876, 9864.161546268648, 9879.851802222829], "dojo.html": [2534.860582667953, 2555.6933168019827, 2589.067935543203, 2613.647157633719, 2619.436821083467, 4608.193566125927, 4622.884427889305, 4629.305604159369, 4641.9767901160485, 4676.321933319667, 4610.930836037453, 4626.421697287839, 4638.768061596924, 4647.256438969765, 4690.061987602476, 4016.8594099206534, 4103.425520427142, 4234.87295381139, 4243.511996120455, 4289.764062976535, 4023.4166045923325, 4122.587741225869, 4126.9793651031705, 4167.124903770212, 4220.683448741342, 4176.937345939813, 4192.643625291854, 4234.703570750049, 4279.550647182048, 4284.721493102954, 4078.3678529827926, 4222.796502996631, 4228.534861165269, 4232.957670423287, 4260.339647354665, 4037.0, 4128.277551428518, 4197.958020419818, 4201.831926722927, 4211.410402543646, 4525.977370113162, 4528.230200865828, 4529.09418116378, 4534.161180181677, 4560.338750881104, 4567.977160114211, 4723.00816828463, 4747.691400058985, 4753.928691069636, 4816.4220293564995, 4711.363965864599, 4721.457032441279, 4733.621310295168, 4800.903981920377, 4882.316475693406, 4399.252127138362, 4465.977670111629, 4467.86596402102, 4471.396361491157, 4503.909921801545, 4794.616430685537, 4894.755262236874, 4895.510448955076, 4897.4857639948, 4934.580560652313, 4612.077584483117, 4670.5329467053025, 4686.297055441711, 4709.835155769531, 4713.9057218856115, 4792.0, 4803.495632958559, 4809.567138957511, 4814.903701925942, 4843.709377437365, 4577.702449340783, 4752.42970843501, 4761.262004389325, 4764.618830493552, 4814.6870453420415, 4624.560666736655, 4689.50760170184, 4689.742064186503, 4720.787564559603, 4753.619710423227, 3220.420324341594, 3224.27453822888, 3233.4341490239585, 3239.5788547489146, 3271.656476070026, 2881.4381195667065, 2975.7173068558454, 2978.285211549256, 3006.9398612027635, 3020.652624948159, 4363.105563359503, 4381.036172042146, 4400.185965596311, 4413.558644135561, 4429.313456414261, 4809.2305231162845, 4814.7833347499445, 4857.53853383928, 4873.6832105913, 4912.778924948386, 4277.593628605277, 4480.596746292849, 4482.058767658828, 4487.6634252431195, 4537.705049171794, 3945.4870866787132, 3979.303621866162, 4004.2592120457807, 4057.594240575919, 4100.323446631332, 4754.5007774183905, 4834.105690447279, 4847.587955023792, 4854.902901942012, 4891.144049791273, 4648.093621743863, 4770.522947705202, 4833.105875412919, 4834.057358815138, 4893.045856058035, 4717.669763116549, 4724.858254252378, 4750.453697824656, 4759.0, 4839.467658557485, 4740.762961851825, 4770.332153498583, 4770.332153498583, 4774.427068751633, 4824.975875120602, 4631.305304204397, 4805.13507568641, 4812.398450193726, 4814.494478079751, 4866.683665561727, 4579.969506861063, 4596.057808149389, 4623.352730617649, 4630.699004564693, 4671.486136525047, 4674.158651442773, 4679.438467383799, 4690.507496712796, 4691.085238378483, 4748.145333839942, 4480.0, 4558.0, 4626.560476754703, 4635.559621835921, 4682.836100736458, 4582.587567118842, 4640.930386044144, 4659.998100408428, 4669.673122881366, 4726.3146843708155, 4615.838445654386, 4621.214393553171, 4640.535946405333, 4651.883702907319, 4696.4599071105895], "mootools.html": [1333.333333333333, 1489.0172486159133, 1492.4030387844862, 1707.3085400412822, 1725.7929048514172, 6346.397092276226, 6444.516661250414, 6837.384635382815, 7177.964110179449, 7214.314640109188, 6854.0, 6855.622940738257, 6855.725770969155, 7012.333828286318, 7029.367356937874, 1933.8936358500348, 1945.6497830390524, 1976.2984140630085, 1981.5937732764821, 1983.990080049605, 1679.8992060476348, 1747.8951262924202, 1884.3498992847447, 1947.6104779044176, 1981.7225588417632, 1878.0515839501033, 1898.1268616436455, 1904.4667493101954, 1909.1695112625982, 1913.770347558295, 1846.8153184681491, 1911.130435651775, 1912.235105957628, 1912.531429799701, 1921.0298799106502, 1926.0273561851316, 1940.2045161483866, 1958.9804101958941, 1966.5968476462433, 1972.723818665388, 6850.931490685129, 6890.724371025153, 6897.931020689829, 6899.517033807636, 6915.446764258898, 3978.9403158952637, 4010.8796736097966, 4022.6982976276604, 4040.4949381327333, 4049.1091959769096, 2421.9515609687883, 2440.01179522292, 2467.8395904266167, 2470.0613766768693, 2513.74862513749, 752.6763491698567, 766.4175226827596, 775.0428221146935, 778.5523324088672, 788.1015642167933, 9256.166944974917, 9273.350865439423, 9387.812243755156, 9394.087832771931, 9394.718158455258, 3371.224618337747, 3465.3242617689307, 3643.599204087548, 3687.9078023049638, 3699.667029967316, 8088.0, 8125.674973001132, 8192.795180120545, 8245.752627421187, 8260.669573217125, 3938.1336106057192, 3948.230095131422, 3978.7214894957074, 3985.442038114666, 4042.3330150524835, 3564.091156755063, 3582.6417358263966, 3590.3716849551224, 3597.1546686528645, 3598.5321908152296, 3059.3422414180613, 3063.601731774855, 3104.7516198704047, 3111.0511294055077, 3115.205622566231, 1008.6973907827622, 1018.0, 1018.0277834667875, 1021.6271061062807, 1033.850091736709, 1174.3599738142732, 1179.5163982767024, 1211.3640338822013, 1242.1491278474275, 1267.3979859566816, 6438.0, 6507.0, 6524.608523488511, 6528.771492997722, 6537.934620653828, 634.4733870887153, 647.8833809914166, 653.9542232043711, 655.8688262347454, 656.3764423797317, 5015.949840501621, 5119.10415677255, 5146.073706732749, 5146.922796158061, 5158.690478571298, 8003.799905002422, 8127.862099306102, 8164.28525021114, 8168.673253069811, 8169.0, 7966.482178658484, 8098.35213182944, 8107.716229931924, 8147.918520814835, 8152.8777068344025, 6337.207849018872, 6363.745450182034, 6396.42432181106, 6398.29618741938, 6399.168108145911, 5875.970620146872, 5998.610090344114, 6004.1480296858645, 6012.428819262163, 6041.214642096676, 7095.184053833876, 7247.565146091251, 7263.382612477999, 7288.271172882882, 7311.086114235721, 7403.629818509161, 7486.213947535648, 7488.663010164664, 7496.137944136494, 7520.774376768706, 5484.232207490874, 5609.775608975595, 5974.761009559569, 6036.788712395045, 6111.174991376285, 6580.177477815273, 6658.0, 6732.360425759545, 6744.156980377453, 6762.661866906733, 6130.417610327012, 6176.073588961512, 6193.907091393723, 6242.687865606792, 6403.51973601991, 6034.879302414015, 6070.575059745775, 6148.047052706837, 6210.596311239755, 6241.625502469867, 5935.198748168942, 5964.970175149097, 6013.398660133952, 6016.2780466342565, 6017.247844019497, 5395.892082158413, 5441.891162176814, 5461.535769459481, 5481.177823326533, 5508.55931525485, 5561.860953476195, 5604.495595396271, 5614.129809879475, 5756.740946657326, 5765.91351129725], "ext.html": [553.0846449126695, 554.3154204557371, 561.2563353556538, 563.0484481226727, 563.729409883256, 28810.13569592913, 29160.0, 36380.0, 36853.0, 37174.8141259294, 39550.60449395505, 39823.40264896029, 40080.59919400805, 40104.59895401045, 40150.19699606006, 7375.151857536398, 8205.507669539831, 8348.165183481633, 8374.581270936429, 8396.370272229577, 7504.324610785028, 9861.704148875546, 10010.599576016986, 10030.849537256947, 10054.09513143817, 10128.0, 10150.796984060315, 10205.0, 10242.692719218398, 10263.0, 7656.617169141577, 7849.843003139905, 9783.608655653765, 10024.147947424477, 10154.593816247341, 9570.425774453555, 9577.425354478684, 9690.176335011533, 9694.660686875995, 9703.12671859536, 36472.088197795005, 36636.81681591575, 36731.4490282646, 37038.4444233334, 37074.62925370739, 3004.1888690053565, 3024.9243768905735, 3064.0960916529675, 3076.0, 3100.069979006289, 27764.861175694194, 27779.305517362027, 27808.721912780817, 27837.86081069602, 27844.443111137665, 2644.510765508387, 2661.188337557044, 2676.491466621336, 2738.438620082878, 2780.6107144999714, 226356.99999999834, 230588.0, 232982.0, 232995.0, 233386.0, 50897.0, 52112.739436302574, 53077.2038419424, 53752.0, 54303.45696542984, 51173.0, 51193.0, 51330.0, 51523.742381287855, 51523.742381287855, 13794.172349658851, 13993.580192594238, 14000.929995350161, 14007.509737159151, 14028.158310501403, 10538.051575358102, 10548.419836909045, 10615.150787936947, 10619.734506637396, 10623.415712135753, 17274.568135796453, 17289.82710172907, 18080.547986300448, 18234.17946192398, 18260.726089108673, 7789.298963093235, 7970.40221983342, 8043.235892590194, 8054.758357249292, 8069.556174410346, 856.3149480415642, 880.4849163239448, 914.2822884036133, 1012.9898701013043, 1032.3754128752148, 25742.74257257441, 26122.0, 26177.214683559523, 26351.0, 26551.33621659474, 959.8944116147218, 971.708487453761, 1009.2027298434155, 1012.2610494339174, 1111.6387174168428, 13759.931200343934, 13806.723865522634, 13841.238731869642, 13862.316450255346, 13928.37322320498, 331470.0, 331768.0, 335349.16270932264, 336727.0, 338166.0, 48917.0, 49478.75260623674, 49568.75215623899, 49586.75206623944, 49656.25515617269, 1264.2856785915928, 1267.3473161321926, 1287.8132670762686, 1292.883640472362, 1304.5173285884093, 25775.742242577333, 26355.736442635327, 26545.33636659099, 26630.135890488255, 26681.0, 40364.3945340826, 40652.39021414622, 40670.38994415145, 40747.38878916878, 40799.0, 244367.0, 245839.0, 246240.0, 246818.0, 246894.0, 24833.130840420497, 25336.11323603665, 28600.57099143556, 29236.853815730785, 29474.0, 34660.82669586636, 34788.478172827934, 34878.12804679802, 35538.64461355354, 35773.821130894175, 32910.50634240536, 33006.669933300356, 33271.66728332686, 33379.0, 33430.66569334276, 24726.0, 27709.0, 29108.272293191993, 32462.35075298528, 32535.674643254213, 32355.0, 33113.66886331202, 33180.33639327248, 33359.83320083384, 33377.0, 28333.0, 29692.554611681273, 30141.0, 30251.523137239343, 30368.392632147676, 22710.75090869952, 22715.432114197276, 22834.429139270986, 22925.65611515795, 23093.422664433525], "prototype.html": [284.49076153684905, 289.78555868657196, 293.3341315214463, 303.4734735234368, 303.70692281947913, 4849.806007759686, 4901.975490122549, 4938.703677779331, 4999.875003124924, 5011.0, 4797.136515427222, 4845.030993801245, 4873.171560834658, 4931.137051016067, 4943.159662857314, 3838.5777564467885, 3846.192299617084, 3847.0959324558708, 3857.32496813058, 3870.264649716559, 3743.9438408423894, 3797.4303854421782, 3806.0865392305923, 3854.5181852268465, 3857.228554289153, 3828.674562662163, 3833.3291673957087, 3838.673712734421, 3842.0010797192654, 3855.15186658936, 3814.370628846237, 3816.2749077675153, 3825.923481530354, 3833.118382771964, 3834.194819087995, 3365.125067482448, 3373.780704254216, 3376.1222082258546, 3379.96620033799, 3381.763276570641, 4773.546513081252, 4784.971231185312, 4790.832320868788, 4791.065742180276, 4794.424669039738, 4170.4995400552125, 4205.91588168238, 4224.85213017546, 4268.829246830123, 4279.978600107011, 4994.026164897847, 5034.320366750479, 5058.772355243986, 5065.974670126662, 5080.644354895159, 3534.8586056557706, 3540.7344449166417, 3548.769329993542, 3556.4487504436597, 3570.767900086486, 5222.97388513055, 5239.030779305803, 5281.577473802086, 5287.339082614673, 5299.708516031616, 3588.9592018314397, 3638.7634803737674, 3646.6535679110443, 3652.6895213907114, 3692.0585250760882, 3752.849886004584, 3755.530558680165, 3764.7176461765475, 3765.171662234304, 3784.7729136251364, 4215.536291007987, 4253.085586598896, 4275.46556680415, 4278.379634952977, 4287.2711639021445, 5068.847934561969, 5071.492850714899, 5072.771725272371, 5076.695398276115, 5077.746112694351, 1362.9454821807215, 1365.6312795545346, 1376.9655758606116, 1381.785823197406, 1382.1361648969394, 923.1507013547553, 934.0705997532499, 948.9051094890456, 953.1897886796306, 955.9665411710557, 4865.878353041202, 4876.317315575822, 4879.682820616648, 4886.560209581155, 4889.633277504201, 5263.763130659129, 5289.709066001406, 5308.23030660552, 5315.840524784263, 5331.44019877915, 4730.95269047312, 4743.573078422958, 4803.423589169322, 4809.422869255712, 4866.513348665105, 2898.1595337351932, 2903.114550062209, 2936.530155175162, 2938.3388737533883, 2942.867570959312, 5340.91988620171, 5352.91970620441, 5355.437679043722, 5361.490658387447, 5369.463053694677, 5467.398586155519, 5473.534749546254, 5474.42518535556, 5485.780568777204, 5487.204355368529, 5231.633785635046, 5289.550388216968, 5290.8941821164135, 5320.600954928318, 5321.0, 5295.894082118259, 5304.681719096867, 5312.654677445954, 5314.096603577324, 5328.3605967284175, 5195.896082078261, 5198.766055527586, 5203.245529398292, 5207.947920520898, 5210.218467229794, 5171.120909445479, 5230.921536177037, 5299.125644268653, 5303.363596368306, 5306.628536002443, 3521.964780352164, 3598.208394153282, 3599.640035996484, 3630.1650620357996, 3637.018005138545, 5268.420473747961, 5332.360116786011, 5337.359516857847, 5345.786168553214, 5351.518363347317, 5192.662476938987, 5194.117000110066, 5203.375594928632, 5205.167173252413, 5206.73966301691, 5072.315237442898, 5190.247414124855, 5200.115980283436, 5201.089809283285, 5219.060569097447, 5106.846794596168, 5123.436421993503, 5132.5124113209185, 5139.743012849417, 5151.948480515297, 5160.690358578498, 5210.609204309616, 5211.244369566468, 5223.138182199895, 5230.320058392384, 5092.134337162765, 5154.484551544815, 5158.484151584811, 5161.870953226049, 5162.741862906914], "yui.html": [652.9640869752164, 669.3641041011041, 695.3811108113783, 789.7472808701216, 809.3444310108812, 11443.485043173056, 11681.182317237797, 11719.121065920048, 11748.060155187597, 12687.809682854764, 11598.420078996058, 11616.24494407863, 11617.0, 11640.068794496441, 11642.243254188472, 654.460070441885, 666.6899891550453, 777.6656037903686, 789.5065584009993, 811.4887620798888, 791.5567282321889, 800.7998000499875, 800.8038030682462, 805.0420000199773, 808.7533302342783, 692.0968136581758, 832.1719888710711, 843.9367047471465, 844.957752112395, 847.3052097280232, 695.3151146121066, 815.6941147069849, 815.7185770909057, 819.319964429528, 826.4710585225461, 597.3727586034646, 602.3434456442455, 602.3494625804165, 603.6891001134419, 605.5942518512608, 10500.317479363817, 10551.10315623173, 10628.893711062869, 10632.521536530874, 10648.78702425947, 8125.593720313961, 8372.204640559137, 8572.69995550159, 8650.956745216234, 8861.069587693328, 8723.0, 8737.388382813206, 8954.686585969524, 9056.683016094405, 9181.081891810765, 2909.4472050310374, 2923.4007028559095, 3014.291641464254, 3044.208505788511, 3049.237690577356, 37134.81432592847, 37390.0, 37581.872543824, 37613.81193094017, 37627.43558846619, 6456.257530383972, 6538.836529086716, 6593.472253342276, 6697.263301036882, 6708.71445367762, 9505.144536991704, 9509.144177024102, 9517.048295170427, 9525.618975240914, 9563.0, 5529.972350138223, 5590.944090559124, 5657.349404818417, 5694.430556944272, 5715.314162300468, 3399.6260411354733, 3457.723382129474, 3470.305938812248, 3628.983884512341, 3642.1987162824134, 2341.8829058547344, 2349.729781075164, 2376.560336337783, 2380.202632118225, 2383.273101703997, 436.7204988807166, 446.22134375514287, 457.3459952268222, 459.129948747129, 459.68970944612255, 420.50800563340965, 586.61576667283, 593.1577160432197, 609.3145211636909, 618.8298217989999, 6986.825329366705, 7116.573005619679, 7200.963995179991, 7281.817954551178, 7321.341079302888, 489.5887454538134, 612.2652816620074, 616.5345164400849, 637.5473413876107, 664.8038828545591, 3207.5028370602595, 3343.2310568569364, 3482.1120614243205, 3520.207953210507, 3555.484454754098, 51564.0, 51959.0, 52023.0, 52192.21711674328, 52274.477255226964, 44451.0, 44511.77744111259, 44586.77706611511, 44876.3268550972, 44889.77555112204, 39851.0, 40310.0, 40857.59142408538, 40996.59003409987, 41366.586334136875, 6564.874087727677, 6641.634710090992, 6716.6977486012265, 6719.865602688016, 6725.327467253235, 29990.25024374408, 30229.848850755607, 30427.0, 30556.236094097825, 31038.534421983237, 37677.434838477995, 38383.42424863573, 40376.281471336435, 41388.755598209485, 41663.79168104261, 6793.830154246183, 6812.284710105368, 6918.238993710788, 6960.025596416607, 7072.0, 10580.0, 10725.678229653124, 10828.13374929988, 10833.0, 11282.830757538479, 9287.210587100171, 9661.13049825519, 9795.853062204214, 9820.950895245478, 9824.459654718774, 9609.327347085637, 9767.989156608537, 9814.312998090065, 9826.459544724823, 9838.409695418297, 9301.534923253945, 9568.856467152858, 9656.613735450503, 9688.41869487833, 9699.127078562964, 8180.228782656382, 8276.131006244257, 8302.667893284442, 8379.371547133867, 8492.660293588187, 7843.960780196063, 8364.749057528285, 8411.83176336482, 8487.108853570286, 8644.0]}, "summary": {"suite": 5864.2133891689, "subtests": {"jquery.html": {"filtered": 6845.950342098332, "value": 6845.950342098332}, "dojo.html": {"filtered": 4389.31849258277, "value": 4389.31849258277}, "mootools.html": {"filtered": 3850.8671836206754, "value": 3850.8671836206754}, "ext.html": {"filtered": 17087.380624664405, "value": 17087.380624664405}, "prototype.html": {"filtered": 3916.574545181054, "value": 3916.574545181054}, "yui.html": {"filtered": 5250.945575374791, "value": 5250.945575374791}}}, "test_machine": {"platform": "x86_64", "osversion": "6.2.9200", "os": "win", "name": "T-W864-IX-062"}, "testrun": {"date": 1445907008, "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": "20151026160202", "branch": "Mozilla-Inbound-Non-PGO", "revision": "f9cd7aa25d6f212d0cf6c48318ff47f2c4ebab88"}}, {"talos_counters": {}, "results": {"audio-dft": [142.0, 141.0, 139.0, 140.0, 140.0, 141.0, 162.0, 143.0, 140.0, 140.0], "ai-astar": [114.0, 112.0, 108.0, 112.0, 113.0, 113.0, 114.0, 113.0, 109.0, 113.0], "imaging-gaussian-blur": [110.0, 112.0, 110.0, 111.0, 110.0, 111.0, 111.0, 110.0, 111.0, 110.0], "audio-beat-detection": [134.0, 130.0, 150.0, 161.0, 134.0, 134.0, 145.0, 129.0, 162.0, 134.0], "json-stringify-tinderbox": [70.0, 69.0, 69.0, 69.0, 69.0, 70.0, 69.0, 69.0, 69.0, 68.0], "stanford-crypto-pbkdf2": [169.0, 158.0, 170.0, 168.0, 164.0, 156.0, 172.0, 164.0, 170.0, 168.0], "json-parse-financial": [71.0, 70.0, 71.0, 70.0, 70.0, 71.0, 71.0, 85.0, 71.0, 69.0], "stanford-crypto-sha256-iterative": [76.0, 76.0, 77.0, 76.0, 77.0, 75.0, 75.0, 77.0, 75.0, 76.0], "audio-fft": [69.0, 71.0, 71.0, 99.0, 74.0, 70.0, 69.0, 70.0, 100.0, 68.0], "imaging-darkroom": [131.0, 133.0, 133.0, 133.0, 132.0, 133.0, 132.0, 136.0, 132.0, 132.0], "stanford-crypto-ccm": [137.0, 131.0, 129.0, 131.0, 125.0, 129.0, 136.0, 133.0, 128.0, 134.0], "audio-oscillator": [91.0, 90.0, 111.0, 91.0, 91.0, 91.0, 118.0, 91.0, 91.0, 120.0], "stanford-crypto-aes": [94.0, 92.0, 92.0, 94.0, 95.0, 96.0, 94.0, 93.0, 94.0, 93.0], "imaging-desaturate": [97.0, 96.0, 98.0, 96.0, 98.0, 106.0, 100.0, 99.0, 96.0, 96.0]}, "summary": {"suite": 1520.2000000000003, "subtests": {"audio-fft": {"filtered": 76.1, "value": 76.1}, "stanford-crypto-pbkdf2": {"filtered": 165.9, "value": 165.9}, "audio-beat-detection": {"filtered": 141.3, "value": 141.3}, "stanford-crypto-ccm": {"filtered": 131.3, "value": 131.3}, "imaging-darkroom": {"filtered": 132.7, "value": 132.7}, "json-parse-financial": {"filtered": 71.9, "value": 71.9}, "audio-oscillator": {"filtered": 98.5, "value": 98.5}, "ai-astar": {"filtered": 112.1, "value": 112.1}, "audio-dft": {"filtered": 142.8, "value": 142.8}, "stanford-crypto-sha256-iterative": {"filtered": 76.0, "value": 76.0}, "json-stringify-tinderbox": {"filtered": 69.1, "value": 69.1}, "imaging-gaussian-blur": {"filtered": 110.6, "value": 110.6}, "stanford-crypto-aes": {"filtered": 93.7, "value": 93.7}, "imaging-desaturate": {"filtered": 98.2, "value": 98.2}}}, "test_machine": {"platform": "x86_64", "osversion": "6.2.9200", "os": "win", "name": "T-W864-IX-062"}, "testrun": {"date": 1445907008, "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": "20151026160202", "branch": "Mozilla-Inbound-Non-PGO", "revision": "f9cd7aa25d6f212d0cf6c48318ff47f2c4ebab88"}}, {"talos_counters": {}, "results": {"DeltaBlue": [175.99436818021823], "Encrypt": [284.8191398461977], "NavierStokes": [4868.9320388349515], "Decrypt": [5055.555555555556], "Splay": [724.6376811594203], "Richards": [166.25103906899417], "RegExp": [31437.5], "Earley": [661.3756613756614], "Boyer": [12575.0], "RayTrace": [1587.3015873015872]}, "summary": {"suite": 19983.51608785775, "subtests": {"DeltaBlue": {"filtered": 375.682476, "value": 375.682476}, "Encrypt": {"filtered": 934.5614910000002, "value": 934.5614910000002}, "NavierStokes": {"filtered": 304.7896311066801, "value": 304.7896311066801}, "Decrypt": {"filtered": 52.65118681318681, "value": 52.65118681318681}, "Splay": {"filtered": 112.45758000000004, "value": 112.45758000000004}, "RegExp": {"filtered": 28.97765407554673, "value": 28.97765407554673}, "Richards": {"filtered": 212.3415300000001, "value": 212.3415300000001}, "Earley": {"filtered": 1007.692056, "value": 1007.692056}, "Boyer": {"filtered": 52.99904572564615, "value": 52.99904572564615}, "RayTrace": {"filtered": 466.19307000000015, "value": 466.19307000000015}}}, "test_machine": {"platform": "x86_64", "osversion": "6.2.9200", "os": "win", "name": "T-W864-IX-062"}, "testrun": {"date": 1445907008, "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": "20151026160202", "branch": "Mozilla-Inbound-Non-PGO", "revision": "f9cd7aa25d6f212d0cf6c48318ff47f2c4ebab88"}}]
18:10:37 INFO - RETURN: dromaeo_css: 5864.21
18:10:37 INFO - RETURN: kraken: 1520.20
18:10:37 INFO - RETURN: v8_7: 19983.52
18:10:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,131,31]]", "result": "19983.52"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,131,31]]", "result": "1520.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,131,31]]", "result": "5864.21"}}}
18:10:37 INFO - Return code: 0
18:10:37 INFO - # TBPL SUCCESS #
18:10:37 INFO - Running post-action listener: _resource_record_post_action
18:10:37 INFO - Running post-run listener: _resource_record_post_run
18:10:38 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 150236672; Write bytes: 398815744; Read time: 1239020; Write time: 4440590
18:10:38 INFO - install - Wall time: 2s; CPU: 12.0%; Read bytes: 0; Write bytes: 1575424; Read time: 0; Write time: 3960
18:10:38 INFO - run-tests - Wall time: 1231s; CPU: 13.0%; Read bytes: 150236672; Write bytes: 362024960; Read time: 1239020; Write time: 4362830
18:10:38 INFO - Running post-run listener: _upload_blobber_files
18:10:38 INFO - Blob upload gear active.
18:10:38 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ...
18:10:38 INFO - Copying logs to upload dir...
18:10:38 INFO - mkdir: C:\slave\test\build\upload\logs
program finished with exit code 0
elapsedTime=1389.430000
========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 28 secs) (at 2015-10-26 18:10:57.901772) =========
========= Started set props: build_url (results: 0, elapsed: 25 secs) (at 2015-10-26 18:10:57.906281) =========
'cmd' '/C' 'for' '%f' 'in' '(*)' 'do' '@type' '%f'
in dir C:\slave\test\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-062\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-062
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-062
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-062\AppData\Local
LOGONSERVER=\\T-W864-IX-062
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
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\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-062
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-062
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-062
WINDIR=C:\windows
XPCOM_DEBUG_BREAK=warn
using PTY: False
build_url:https://queue.taskcluster.net/v1/task/psRrk3pCQsyAuHn-YdcjIA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip
program finished with exit code 0
elapsedTime=0.102000
build_url: 'https://queue.taskcluster.net/v1/task/psRrk3pCQsyAuHn-YdcjIA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip'
========= Finished set props: build_url (results: 0, elapsed: 25 secs) (at 2015-10-26 18:11:23.553104) =========
========= Started 'rm -f ...' (results: 0, elapsed: 45 secs) (at 2015-10-26 18:11:23.553423) =========
'rm' '-f' 'oauth.txt'
in dir C:\slave\test\. (timeout 1200 secs)
watching logfiles {}
argv: ['rm', '-f', 'oauth.txt']
environment:
ALLUSERSPROFILE=C:\ProgramData
APPDATA=C:\Users\cltbld.T-W864-IX-062\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-062
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-062
KTS_HOME=C:\Program Files\KTS
KTS_VERSION=1.19c
LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-062\AppData\Local
LOGONSERVER=\\T-W864-IX-062
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
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
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-062
USERDOMAIN_ROAMINGPROFILE=T-W864-IX-062
USERNAME=cltbld
USERPROFILE=C:\Users\cltbld.T-W864-IX-062
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: 45 secs) (at 2015-10-26 18:12:08.681852) =========
========= Started reboot slave lost (results: 0, elapsed: 10 secs) (at 2015-10-26 18:12:08.682380) =========
========= Finished reboot slave lost (results: 0, elapsed: 10 secs) (at 2015-10-26 18:12:19.299780) =========