builder: mozilla-inbound_win8_64_test-dromaeojs slave: t-w864-ix-053 starttime: 1445528482.72 results: success (0) buildid: 20151022070509 builduid: 6abd0b0a536544679af5cef2dbdeaa92 revision: 2f56d15bb8d69c17a249c2de9c5f95ac4ca766c6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-22 08:41:22.718910) ========= master: http://buildbot-master109.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-22 08:41:22.719758) ========= ========= Started set props: basedir (results: 0, elapsed: 12 secs) (at 2015-10-22 08:41:22.720454) ========= 'cd' in dir C:\slave\test\. (timeout 1200 secs) watching logfiles {} argv: ['cd'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-053\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-053 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-053 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-053\AppData\Local LOGONSERVER=\\T-W864-IX-053 MONDIR=C:\Monitor_config\ MOZBUILDDIR=C:\mozilla-build\ MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 NUMBER_OF_PROCESSORS=8 OS=Windows_NT OURDRIVE=C: PATH=C:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;C:\mozilla-build\hg PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_ARCHITEW6432=AMD64 PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=C:\Program Files (x86) PROGRAMFILES(X86)=C:\Program Files (x86) PROGRAMW6432=C:\Program Files PROMPT=$P$G PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\ PUBLIC=C:\Users\Public PWD=C:\slave\test 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-053 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-053 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-053 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False C:\slave\test program finished with exit code 0 elapsedTime=0.774000 basedir: 'C:\\slave\\test' ========= Finished set props: basedir (results: 0, elapsed: 12 secs) (at 2015-10-22 08:41:35.113912) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 4 secs) (at 2015-10-22 08:41:35.114250) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 4 secs) (at 2015-10-22 08:41:39.585961) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-22 08:41:39.586279) ========= '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-053\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-053 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-053 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-053\AppData\Local LOGONSERVER=\\T-W864-IX-053 MONDIR=C:\Monitor_config\ MOZBUILDDIR=C:\mozilla-build\ MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 NUMBER_OF_PROCESSORS=8 OS=Windows_NT OURDRIVE=C: PATH=C:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;C:\mozilla-build\hg PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_ARCHITEW6432=AMD64 PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=C:\Program Files (x86) PROGRAMFILES(X86)=C:\Program Files (x86) PROGRAMW6432=C:\Program Files PROMPT=$P$G PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\ PUBLIC=C:\Users\Public PWD=C:\slave\test 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-053 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-053 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-053 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=0.101000 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-22 08:41:39.949803) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-22 08:41:39.950146) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-22 08:41:39.950590) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2015-10-22 08:41:39.951410) ========= '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-053\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-053 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-053 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-053\AppData\Local LOGONSERVER=\\T-W864-IX-053 MONDIR=C:\Monitor_config\ MOZBUILDDIR=C:\mozilla-build\ MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 NUMBER_OF_PROCESSORS=8 OS=Windows_NT OURDRIVE=C: PATH=C:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;C:\mozilla-build\hg PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_ARCHITEW6432=AMD64 PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=C:\Program Files (x86) PROGRAMFILES(X86)=C:\Program Files (x86) PROGRAMW6432=C:\Program Files PROMPT=$P$G PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\ PUBLIC=C:\Users\Public PWD=C:\slave\test 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-053 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-053 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-053 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False --08:41:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py => `archiver_client.py' Resolving hg.mozilla.org... 63.245.215.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% 2.27 GB/s 08:41:40 (2.27 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.592000 ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2015-10-22 08:41:44.934106) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2015-10-22 08:41:44.934465) ========= '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-053\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-053 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-053 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-053\AppData\Local LOGONSERVER=\\T-W864-IX-053 MONDIR=C:\Monitor_config\ MOZBUILDDIR=C:\mozilla-build\ MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 NUMBER_OF_PROCESSORS=8 OS=Windows_NT OURDRIVE=C: PATH=C:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;C:\mozilla-build\hg PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_ARCHITEW6432=AMD64 PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=C:\Program Files (x86) PROGRAMFILES(X86)=C:\Program Files (x86) PROGRAMW6432=C:\Program Files PROMPT=$P$G PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\ PUBLIC=C:\Users\Public PWD=C:\slave\test 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-053 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-053 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-053 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=2.709000 ========= Finished 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2015-10-22 08:41:47.876163) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-10-22 08:41:47.877051) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 2f56d15bb8d69c17a249c2de9c5f95ac4ca766c6 --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 2f56d15bb8d69c17a249c2de9c5f95ac4ca766c6 --destination scripts --debug'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-053\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-053 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-053 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-053\AppData\Local LOGONSERVER=\\T-W864-IX-053 MONDIR=C:\Monitor_config\ MOZBUILDDIR=C:\mozilla-build\ MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 NUMBER_OF_PROCESSORS=8 OS=Windows_NT OURDRIVE=C: PATH=C:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;C:\mozilla-build\hg PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_ARCHITEW6432=AMD64 PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=C:\Program Files (x86) PROGRAMFILES(X86)=C:\Program Files (x86) PROGRAMW6432=C:\Program Files PROMPT=$P$G PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\ PUBLIC=C:\Users\Public PWD=C:\slave\test 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-053 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-053 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-053 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 2015-10-22 08:41:47,867 truncating revision to first 12 chars 2015-10-22 08:41:47,867 Setting DEBUG logging. 2015-10-22 08:41:47,867 attempt 1/10 2015-10-22 08:41:47,867 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/2f56d15bb8d6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-10-22 08:41:48,895 unpacking tar archive at: mozilla-inbound-2f56d15bb8d6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.879000 ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-10-22 08:41:49.825230) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-22 08:41:49.825729) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-22 08:41:49.840291) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-22 08:41:49.840611) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-22 08:41:49.841460) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 19 secs) (at 2015-10-22 08:41:49.841801) ========= '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-053\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-053 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-053 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-053\AppData\Local LOGONSERVER=\\T-W864-IX-053 MONDIR=C:\Monitor_config\ MOZBUILDDIR=C:\mozilla-build\ MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 NUMBER_OF_PROCESSORS=8 OS=Windows_NT OURDRIVE=C: PATH=C:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;C:\mozilla-build\hg PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_ARCHITEW6432=AMD64 PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=C:\Program Files (x86) PROGRAMFILES(X86)=C:\Program Files (x86) PROGRAMW6432=C:\Program Files PROMPT=$P$G PROPERTIES_FILE=C:\slave\test/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-053 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-053 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-053 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 08:41:50 INFO - MultiFileLogger online at 20151022 08:41:50 in C:\slave\test 08:41:50 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 08:41:50 INFO - Dumping config to C:\slave\test\logs\localconfig.json. 08:41:50 INFO - {'append_to_log': False, 08:41:50 INFO - 'base_work_dir': 'C:\\slave\\test', 08:41:50 INFO - 'blob_upload_branch': 'Mozilla-Inbound-Non-PGO', 08:41:50 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt', 08:41:50 INFO - 'branch': 'Mozilla-Inbound-Non-PGO', 08:41:50 INFO - 'buildbot_json_path': 'buildprops.json', 08:41:50 INFO - 'config_files': ('talos/windows_config.py',), 08:41:50 INFO - 'default_actions': ('clobber', 08:41:50 INFO - 'read-buildbot-config', 08:41:50 INFO - 'download-and-extract', 08:41:50 INFO - 'populate-webroot', 08:41:50 INFO - 'create-virtualenv', 08:41:50 INFO - 'install', 08:41:50 INFO - 'run-tests'), 08:41:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:41:50 INFO - 'download_minidump_stackwalk': True, 08:41:50 INFO - 'download_symbols': 'ondemand', 08:41:50 INFO - 'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python', 08:41:50 INFO - 'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'), 08:41:50 INFO - 'hg': 'c:/mozilla-build/hg/hg', 08:41:50 INFO - 'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python', 08:41:50 INFO - 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'), 08:41:50 INFO - 'python': 'c:/mozilla-build/python27/python.exe', 08:41:50 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe', 08:41:50 INFO - 'C:/mozilla-build/tooltool.py'), 08:41:50 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe', 08:41:50 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 08:41:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:41:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:41:50 INFO - 'installer_path': 'installer.exe', 08:41:50 INFO - 'log_level': 'info', 08:41:50 INFO - 'log_name': 'talos', 08:41:50 INFO - 'log_to_console': True, 08:41:50 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe', 08:41:50 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe', 08:41:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest', 08:41:50 INFO - 'opt_config_files': (), 08:41:50 INFO - 'pip_index': False, 08:41:50 INFO - 'sps_profile': False, 08:41:50 INFO - 'sps_profile_interval': 0, 08:41:50 INFO - 'suite': 'dromaeojs', 08:41:50 INFO - 'system_bits': '64', 08:41:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:41:50 INFO - 'title': 'T-W864-IX-053', 08:41:50 INFO - 'use_talos_json': True, 08:41:50 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'), 08:41:50 INFO - 'virtualenv_path': 'C:\\slave\\test\\build/venv', 08:41:50 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll', 08:41:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:41:50 INFO - 'work_dir': 'build'} 08:41:50 INFO - ##### 08:41:50 INFO - ##### Running clobber step. 08:41:50 INFO - ##### 08:41:50 INFO - Running pre-action listener: _resource_record_pre_action 08:41:50 INFO - Running main action method: clobber 08:41:50 INFO - rmtree: C:\slave\test\build 08:41:50 INFO - Using _rmtree_windows ... 08:41:50 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1 08:42:49 INFO - Running post-action listener: _resource_record_post_action 08:42:49 INFO - ##### 08:42:49 INFO - ##### Running read-buildbot-config step. 08:42:49 INFO - ##### 08:42:49 INFO - Running pre-action listener: _resource_record_pre_action 08:42:49 INFO - Running main action method: read_buildbot_config 08:42:49 INFO - Using buildbot properties: 08:42:49 INFO - { 08:42:49 INFO - "properties": { 08:42:49 INFO - "buildnumber": 1881, 08:42:49 INFO - "product": "firefox", 08:42:49 INFO - "script_repo_revision": "production", 08:42:49 INFO - "builddir": "mozilla-inbound_win8_64_test-dromaeojs", 08:42:49 INFO - "repository": "", 08:42:49 INFO - "buildername": "Windows 8 64-bit mozilla-inbound talos dromaeojs", 08:42:49 INFO - "buildid": "20151022070509", 08:42:49 INFO - "slavename": "t-w864-ix-053", 08:42:49 INFO - "pgo_build": "False", 08:42:49 INFO - "basedir": "C:\\slave\\test", 08:42:49 INFO - "project": "", 08:42:49 INFO - "platform": "win8_64", 08:42:49 INFO - "master": "http://buildbot-master109.bb.releng.scl3.mozilla.com:8201/", 08:42:49 INFO - "slavebuilddir": "test", 08:42:49 INFO - "scheduler": "tests-mozilla-inbound-win64-talos", 08:42:49 INFO - "branch": "mozilla-inbound", 08:42:49 INFO - "repo_path": "integration/mozilla-inbound", 08:42:49 INFO - "stage_platform": "win64", 08:42:49 INFO - "builduid": "6abd0b0a536544679af5cef2dbdeaa92", 08:42:49 INFO - "revision": "2f56d15bb8d69c17a249c2de9c5f95ac4ca766c6" 08:42:49 INFO - }, 08:42:49 INFO - "sourcestamp": { 08:42:49 INFO - "repository": "", 08:42:49 INFO - "hasPatch": false, 08:42:49 INFO - "project": "", 08:42:49 INFO - "branch": "mozilla-inbound-win64-talos", 08:42:49 INFO - "changes": [ 08:42:49 INFO - { 08:42:49 INFO - "category": null, 08:42:49 INFO - "files": [ 08:42:49 INFO - { 08:42:49 INFO - "url": null, 08:42:49 INFO - "name": "https://queue.taskcluster.net/v1/task/3FYRVDn5QXW5KtvNRNW8LA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip" 08:42:49 INFO - } 08:42:49 INFO - ], 08:42:49 INFO - "repository": "", 08:42:49 INFO - "rev": "8fa7f0e6243bd00915c3b2b025d54f7a39a32709", 08:42:49 INFO - "who": "eakhgari@mozilla.com", 08:42:49 INFO - "when": 1445527647, 08:42:49 INFO - "number": 6560225, 08:42:49 INFO - "comments": "Bug 1216858 - Enable as much of the WPT service worker CSP tests as we can; r=bkelly\n", 08:42:49 INFO - "project": "", 08:42:49 INFO - "at": "Thu 22 Oct 2015 08:27:27", 08:42:49 INFO - "branch": "mozilla-inbound-win64-talos", 08:42:49 INFO - "revlink": "", 08:42:49 INFO - "properties": [ 08:42:49 INFO - [ 08:42:49 INFO - "buildid", 08:42:49 INFO - "20151022064839", 08:42:49 INFO - "Change" 08:42:49 INFO - ], 08:42:49 INFO - [ 08:42:49 INFO - "builduid", 08:42:49 INFO - "db76f7ee139941db838f2c1a43175578", 08:42:49 INFO - "Change" 08:42:49 INFO - ], 08:42:49 INFO - [ 08:42:49 INFO - "pgo_build", 08:42:49 INFO - "False", 08:42:49 INFO - "Change" 08:42:49 INFO - ] 08:42:49 INFO - ], 08:42:49 INFO - "revision": "8fa7f0e6243bd00915c3b2b025d54f7a39a32709" 08:42:49 INFO - }, 08:42:49 INFO - { 08:42:49 INFO - "category": null, 08:42:49 INFO - "files": [ 08:42:49 INFO - { 08:42:49 INFO - "url": null, 08:42:49 INFO - "name": "https://queue.taskcluster.net/v1/task/IaBnchbXQQ27ne5ObcmwUA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip" 08:42:49 INFO - } 08:42:49 INFO - ], 08:42:49 INFO - "repository": "", 08:42:49 INFO - "rev": "2f56d15bb8d69c17a249c2de9c5f95ac4ca766c6", 08:42:49 INFO - "who": "dmitchell@mozilla.com", 08:42:49 INFO - "when": 1445527884, 08:42:49 INFO - "number": 6560247, 08:42:49 INFO - "comments": "Bug 1216670: use correct parent image for desktop-test; r=ahal", 08:42:49 INFO - "project": "", 08:42:49 INFO - "at": "Thu 22 Oct 2015 08:31:24", 08:42:49 INFO - "branch": "mozilla-inbound-win64-talos", 08:42:49 INFO - "revlink": "", 08:42:49 INFO - "properties": [ 08:42:49 INFO - [ 08:42:49 INFO - "buildid", 08:42:49 INFO - "20151022070509", 08:42:49 INFO - "Change" 08:42:49 INFO - ], 08:42:49 INFO - [ 08:42:49 INFO - "builduid", 08:42:49 INFO - "6abd0b0a536544679af5cef2dbdeaa92", 08:42:49 INFO - "Change" 08:42:49 INFO - ], 08:42:49 INFO - [ 08:42:49 INFO - "pgo_build", 08:42:49 INFO - "False", 08:42:49 INFO - "Change" 08:42:49 INFO - ] 08:42:49 INFO - ], 08:42:49 INFO - "revision": "2f56d15bb8d69c17a249c2de9c5f95ac4ca766c6" 08:42:49 INFO - } 08:42:49 INFO - ], 08:42:49 INFO - "revision": "2f56d15bb8d69c17a249c2de9c5f95ac4ca766c6" 08:42:49 INFO - } 08:42:49 INFO - } 08:42:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/IaBnchbXQQ27ne5ObcmwUA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip. 08:42:49 INFO - Running post-action listener: _resource_record_post_action 08:42:49 INFO - ##### 08:42:49 INFO - ##### Running download-and-extract step. 08:42:49 INFO - ##### 08:42:49 INFO - Running pre-action listener: _resource_record_pre_action 08:42:49 INFO - Running main action method: download_and_extract 08:42:49 INFO - mkdir: C:\slave\test\build\tests 08:42:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:49 INFO - https://queue.taskcluster.net/v1/task/IaBnchbXQQ27ne5ObcmwUA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:42:49 INFO - trying https://queue.taskcluster.net/v1/task/IaBnchbXQQ27ne5ObcmwUA/artifacts/public/build/test_packages.json 08:42:49 INFO - Downloading https://queue.taskcluster.net/v1/task/IaBnchbXQQ27ne5ObcmwUA/artifacts/public/build/test_packages.json to C:\slave\test\build\test_packages.json 08:42:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IaBnchbXQQ27ne5ObcmwUA/artifacts/public/build/test_packages.json', 'file_name': 'C:\\slave\\test\\build\\test_packages.json'}, attempt #1 08:42:50 INFO - Downloaded 1221 bytes. 08:42:50 INFO - Reading from file C:\slave\test\build\test_packages.json 08:42:50 INFO - Using the following test package requirements: 08:42:50 INFO - {u'common': [u'firefox-44.0a1.en-US.win64.common.tests.zip'], 08:42:50 INFO - u'cppunittest': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 08:42:50 INFO - u'firefox-44.0a1.en-US.win64.cppunittest.tests.zip'], 08:42:50 INFO - u'jittest': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 08:42:50 INFO - u'jsshell-win64.zip'], 08:42:50 INFO - u'mochitest': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 08:42:50 INFO - u'firefox-44.0a1.en-US.win64.mochitest.tests.zip'], 08:42:50 INFO - u'mozbase': [u'firefox-44.0a1.en-US.win64.common.tests.zip'], 08:42:50 INFO - u'reftest': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 08:42:50 INFO - u'firefox-44.0a1.en-US.win64.reftest.tests.zip'], 08:42:50 INFO - u'talos': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 08:42:50 INFO - u'firefox-44.0a1.en-US.win64.talos.tests.zip'], 08:42:50 INFO - u'web-platform': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 08:42:50 INFO - u'firefox-44.0a1.en-US.win64.web-platform.tests.zip'], 08:42:50 INFO - u'webapprt': [u'firefox-44.0a1.en-US.win64.common.tests.zip'], 08:42:50 INFO - u'xpcshell': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 08:42:50 INFO - u'firefox-44.0a1.en-US.win64.xpcshell.tests.zip']} 08:42:50 INFO - Downloading packages: [u'firefox-44.0a1.en-US.win64.common.tests.zip'] for test suite category: common 08:42:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:50 INFO - https://queue.taskcluster.net/v1/task/IaBnchbXQQ27ne5ObcmwUA/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip matches https://queue.taskcluster.net 08:42:50 INFO - trying https://queue.taskcluster.net/v1/task/IaBnchbXQQ27ne5ObcmwUA/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip 08:42:50 INFO - Downloading https://queue.taskcluster.net/v1/task/IaBnchbXQQ27ne5ObcmwUA/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 08:42:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IaBnchbXQQ27ne5ObcmwUA/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 08:42:51 INFO - Downloaded 18100686 bytes. 08:42:51 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 08:42:51 INFO - Copy/paste: unzip -q -o C:\slave\test\build\firefox-44.0a1.en-US.win64.common.tests.zip 08:42:51 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 08:43:15 INFO - Return code: 0 08:43:15 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 08:43:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:15 INFO - https://queue.taskcluster.net/v1/task/IaBnchbXQQ27ne5ObcmwUA/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip matches https://queue.taskcluster.net 08:43:15 INFO - trying https://queue.taskcluster.net/v1/task/IaBnchbXQQ27ne5ObcmwUA/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip 08:43:15 INFO - Downloading https://queue.taskcluster.net/v1/task/IaBnchbXQQ27ne5ObcmwUA/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 08:43:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IaBnchbXQQ27ne5ObcmwUA/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 08:43:16 INFO - Downloaded 18100686 bytes. 08:43:16 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 08:43:16 INFO - Copy/paste: unzip -q -o C:\slave\test\build\firefox-44.0a1.en-US.win64.common.tests.zip 08:43:16 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 08:43:37 INFO - Return code: 0 08:43: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')]} 08:43:37 INFO - https://queue.taskcluster.net/v1/task/IaBnchbXQQ27ne5ObcmwUA/artifacts/public/build/firefox-44.0a1.en-US.win64.talos.tests.zip matches https://queue.taskcluster.net 08:43:37 INFO - trying https://queue.taskcluster.net/v1/task/IaBnchbXQQ27ne5ObcmwUA/artifacts/public/build/firefox-44.0a1.en-US.win64.talos.tests.zip 08:43:37 INFO - Downloading https://queue.taskcluster.net/v1/task/IaBnchbXQQ27ne5ObcmwUA/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 08:43:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IaBnchbXQQ27ne5ObcmwUA/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 08:43:38 INFO - Downloaded 11131307 bytes. 08:43:38 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 08:43:38 INFO - Copy/paste: unzip -q -o C:\slave\test\build\firefox-44.0a1.en-US.win64.talos.tests.zip 08:43:38 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 08:43:39 INFO - Return code: 0 08:43:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:39 INFO - https://queue.taskcluster.net/v1/task/IaBnchbXQQ27ne5ObcmwUA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip matches https://queue.taskcluster.net 08:43:39 INFO - trying https://queue.taskcluster.net/v1/task/IaBnchbXQQ27ne5ObcmwUA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip 08:43:39 INFO - Downloading https://queue.taskcluster.net/v1/task/IaBnchbXQQ27ne5ObcmwUA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip to C:\slave\test\build\firefox-44.0a1.en-US.win64.zip 08:43:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IaBnchbXQQ27ne5ObcmwUA/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 08:43:40 INFO - Downloaded 54761845 bytes. 08:43:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IaBnchbXQQ27ne5ObcmwUA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip 08:43:40 INFO - mkdir: C:\slave\test\properties 08:43:40 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url 08:43:40 INFO - Writing to file C:\slave\test\properties\build_url 08:43:40 INFO - Contents: 08:43:40 INFO - build_url:https://queue.taskcluster.net/v1/task/IaBnchbXQQ27ne5ObcmwUA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip 08:43:40 INFO - Running post-action listener: _resource_record_post_action 08:43:40 INFO - Running post-action listener: set_extra_try_arguments 08:43:40 INFO - ##### 08:43:40 INFO - ##### Running populate-webroot step. 08:43:40 INFO - ##### 08:43:40 INFO - Running pre-action listener: _resource_record_pre_action 08:43:40 INFO - Running main action method: populate_webroot 08:43:40 INFO - Guessing talos json url... 08:43: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')]} 08:43:40 INFO - https://queue.taskcluster.net/v1/task/IaBnchbXQQ27ne5ObcmwUA/artifacts/public/build/firefox-44.0a1.en-US.win64.txt matches https://queue.taskcluster.net 08:43:40 INFO - trying https://queue.taskcluster.net/v1/task/IaBnchbXQQ27ne5ObcmwUA/artifacts/public/build/firefox-44.0a1.en-US.win64.txt 08:43:40 INFO - Downloading https://queue.taskcluster.net/v1/task/IaBnchbXQQ27ne5ObcmwUA/artifacts/public/build/firefox-44.0a1.en-US.win64.txt to C:\slave\test\build\firefox-44.0a1.en-US.win64.txt 08:43:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IaBnchbXQQ27ne5ObcmwUA/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 08:43:41 INFO - Downloaded 111 bytes. 08:43:41 INFO - Reading from file C:\slave\test\build\firefox-44.0a1.en-US.win64.txt 08:43:41 INFO - Contents: 08:43:41 INFO - 20151022070509 08:43:41 INFO - https://hg.mozilla.org/integration/mozilla-inbound/rev/2f56d15bb8d69c17a249c2de9c5f95ac4ca766c6 08:43:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:41 INFO - trying https://hg.mozilla.org/integration/mozilla-inbound/raw-file/2f56d15bb8/testing/talos/talos.json 08:43:41 INFO - Downloading https://hg.mozilla.org/integration/mozilla-inbound/raw-file/2f56d15bb8/testing/talos/talos.json to C:\slave\test\build\talos.json 08:43:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/mozilla-inbound/raw-file/2f56d15bb8/testing/talos/talos.json', 'file_name': 'C:\\slave\\test\\build\\talos.json'}, attempt #1 08:43:42 INFO - Downloaded 4264 bytes. 08:43:42 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']}, 08:43:42 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']}, 08:43:42 INFO - u'remote-trobocheck2': {u'talos_options': [u'--fennecIDs', 08:43:42 INFO - u'../fennec_ids.txt'], 08:43:42 INFO - u'tests': [u'tcheck2']}, 08:43:42 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome', 08:43:42 INFO - u'--tppagecycles', 08:43:42 INFO - u'7'], 08:43:42 INFO - u'tests': [u'tsvgm']}}, 08:43:42 INFO - u'suites': {u'chromez': {u'tests': [u'tresize', u'tcanvasmark']}, 08:43:42 INFO - u'chromez-e10s': {u'talos_options': [u'--e10s'], 08:43:42 INFO - u'tests': [u'tresize', u'tcanvasmark']}, 08:43:42 INFO - u'dromaeojs': {u'tests': [u'dromaeo_css', u'kraken', u'v8_7']}, 08:43:42 INFO - u'dromaeojs-e10s': {u'talos_options': [u'--e10s'], 08:43:42 INFO - u'tests': [u'dromaeo_css', 08:43:42 INFO - u'kraken', 08:43:42 INFO - u'v8_7']}, 08:43:42 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:42 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 08:43:42 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:42 INFO - u'talos_options': [u'--e10s'], 08:43:42 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 08:43:42 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:42 INFO - u'tests': [u'damp', u'tps']}, 08:43:42 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:42 INFO - u'talos_options': [u'--e10s'], 08:43:42 INFO - u'tests': [u'damp', u'tps']}, 08:43:42 INFO - u'g3': {u'tests': [u'dromaeo_dom']}, 08:43:42 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']}, 08:43:42 INFO - u'other': {u'tests': [u'a11yr', 08:43:42 INFO - u'ts_paint', 08:43:42 INFO - u'tpaint', 08:43:42 INFO - u'sessionrestore', 08:43:42 INFO - u'sessionrestore_no_auto_restore']}, 08:43:42 INFO - u'other-e10s': {u'talos_options': [u'--e10s'], 08:43:42 INFO - u'tests': [u'a11yr', 08:43:42 INFO - u'ts_paint', 08:43:42 INFO - u'tpaint', 08:43:42 INFO - u'sessionrestore', 08:43:42 INFO - u'sessionrestore_no_auto_restore']}, 08:43:42 INFO - u'other-e10s_l64': {u'talos_options': [u'--e10s'], 08:43:42 INFO - u'tests': [u'a11yr', 08:43:42 INFO - u'ts_paint', 08:43:42 INFO - u'tpaint', 08:43:42 INFO - u'sessionrestore', 08:43:42 INFO - u'sessionrestore_no_auto_restore']}, 08:43:42 INFO - u'other-e10s_nol64': {u'talos_options': [u'--e10s'], 08:43:42 INFO - u'tests': [u'a11yr', 08:43:42 INFO - u'ts_paint', 08:43:42 INFO - u'tpaint', 08:43:42 INFO - u'sessionrestore', 08:43:42 INFO - u'sessionrestore_no_auto_restore']}, 08:43:42 INFO - u'other_l64': {u'tests': [u'a11yr', 08:43:42 INFO - u'ts_paint', 08:43:42 INFO - u'tpaint', 08:43:42 INFO - u'sessionrestore', 08:43:42 INFO - u'sessionrestore_no_auto_restore']}, 08:43:42 INFO - u'other_nol64': {u'tests': [u'a11yr', 08:43:42 INFO - u'ts_paint', 08:43:42 INFO - u'tpaint', 08:43:42 INFO - u'sessionrestore', 08:43:42 INFO - u'sessionrestore_no_auto_restore']}, 08:43:42 INFO - u'svgr': {u'tests': [u'tsvgx', 08:43:42 INFO - u'tsvgr_opacity', 08:43:42 INFO - u'tart', 08:43:42 INFO - u'tscrollx', 08:43:42 INFO - u'cart']}, 08:43:42 INFO - u'svgr-e10s': {u'talos_options': [u'--e10s'], 08:43:42 INFO - u'tests': [u'tsvgx', 08:43:42 INFO - u'tsvgr_opacity', 08:43:42 INFO - u'tart', 08:43:42 INFO - u'tscrollx', 08:43:42 INFO - u'cart']}, 08:43:42 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:42 INFO - u'tests': [u'tp5o']}, 08:43:42 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:42 INFO - u'talos_options': [u'--e10s'], 08:43:42 INFO - u'tests': [u'tp5o']}, 08:43:42 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:42 INFO - u'talos_options': [u'--xperf_path', 08:43:42 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:43:42 INFO - u'tests': [u'tp5n']}, 08:43:42 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:42 INFO - u'talos_options': [u'--e10s', 08:43:42 INFO - u'--xperf_path', 08:43:42 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 08:43:42 INFO - u'C:/slave/talos-data/talos/xperf.config'], 08:43:42 INFO - u'tests': [u'tp5n']}}, 08:43:42 INFO - u'talos.zip': {u'path': u'', 08:43:42 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:43:42 INFO - Running post-action listener: _resource_record_post_action 08:43:42 INFO - ##### 08:43:42 INFO - ##### Running create-virtualenv step. 08:43:42 INFO - ##### 08:43:42 INFO - Running pre-action listener: _resource_record_pre_action 08:43:42 INFO - Running main action method: create_virtualenv 08:43:42 INFO - Creating virtualenv C:\slave\test\build/venv 08:43:42 INFO - mkdir: C:\slave\test\build\venv\Scripts 08:43:42 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll 08:43:42 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'! 08:43:42 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 08:43:42 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build/venv 08:43:47 INFO - New python executable in C:\slave\test\build/venv\Scripts\python.exe 08:43:50 INFO - Installing distribute......................................................................................................................................................................................done. 08:43:52 INFO - Return code: 0 08:43:52 INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv 08:43:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:52 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 0x02414B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023D4EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0245C358>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01D78B48>, '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 0x01D9A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028B3660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-053', 'USERDOMAIN': 'T-W864-IX-053', '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-053', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-053\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-053', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-053', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-053', '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;C:\\mozilla-build\\hg', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-053\\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 08:43:52 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 08:43:52 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 08:43:52 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 08:43:52 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-053\\AppData\\Roaming', 08:43:52 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 08:43:52 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 08:43:52 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 08:43:52 INFO - 'COMPUTERNAME': 'T-W864-IX-053', 08:43:52 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 08:43:52 INFO - 'DCLOCATION': 'SCL3', 08:43:52 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 08:43:52 INFO - 'FP_NO_HOST_CHECK': 'NO', 08:43:52 INFO - 'HOMEDRIVE': 'C:', 08:43:52 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-053', 08:43:52 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 08:43:52 INFO - 'KTS_VERSION': '1.19c', 08:43:52 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-053\\AppData\\Local', 08:43:52 INFO - 'LOGONSERVER': '\\\\T-W864-IX-053', 08:43:52 INFO - 'MONDIR': 'C:\\Monitor_config\\', 08:43:52 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 08:43:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:52 INFO - 'MOZ_NO_REMOTE': '1', 08:43:52 INFO - 'NO_EM_RESTART': '1', 08:43:52 INFO - 'NUMBER_OF_PROCESSORS': '8', 08:43:52 INFO - 'OS': 'Windows_NT', 08:43:52 INFO - 'OURDRIVE': 'C:', 08:43:52 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 08:43:52 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 08:43:52 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 08:43:52 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 08:43:52 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 08:43:52 INFO - 'PROCESSOR_LEVEL': '6', 08:43:52 INFO - 'PROCESSOR_REVISION': '1e05', 08:43:52 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 08:43:52 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 08:43:52 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 08:43:52 INFO - 'PROGRAMW6432': 'C:\\Program Files', 08:43:52 INFO - 'PROMPT': '$P$G', 08:43:52 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 08:43:52 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 08:43:52 INFO - 'PUBLIC': 'C:\\Users\\Public', 08:43:52 INFO - 'PWD': 'C:\\slave\\test', 08:43:52 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 08:43:52 INFO - 'SLAVEDIR': 'C:\\slave\\', 08:43:52 INFO - 'SYSTEMDRIVE': 'C:', 08:43:52 INFO - 'SYSTEMROOT': 'C:\\windows', 08:43:52 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:43:52 INFO - 'TEST1': 'testie', 08:43:52 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:43:52 INFO - 'USERDOMAIN': 'T-W864-IX-053', 08:43:52 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-053', 08:43:52 INFO - 'USERNAME': 'cltbld', 08:43:52 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-053', 08:43:52 INFO - 'WINDIR': 'C:\\windows', 08:43:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 08:43:53 INFO - Ignoring indexes: http://pypi.python.org/simple/ 08:43:53 INFO - Downloading/unpacking pip>=1.5 08:43:53 INFO - Creating supposed download cache at C:\slave\test\build/venv\cache 08:43:58 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 08:43:58 INFO - Running setup.py egg_info for package pip 08:43:58 INFO - warning: no files found matching 'pip\cacert.pem' 08:43:58 INFO - warning: no files found matching '*.html' under directory 'docs' 08:43:58 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 08:43:58 INFO - no previously-included directories found matching 'docs\_build\_sources' 08:43:58 INFO - Installing collected packages: pip 08:43:58 INFO - Found existing installation: pip 0.8.2 08:43:58 INFO - Uninstalling pip: 08:43:58 INFO - Successfully uninstalled pip 08:43:58 INFO - Running setup.py install for pip 08:43:58 INFO - warning: no files found matching 'pip\cacert.pem' 08:43:58 INFO - warning: no files found matching '*.html' under directory 'docs' 08:43:58 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 08:43:58 INFO - no previously-included directories found matching 'docs\_build\_sources' 08:43:58 INFO - Installing pip-script.py script to C:\slave\test\build\venv\Scripts 08:43:58 INFO - Installing pip.exe script to C:\slave\test\build\venv\Scripts 08:43:58 INFO - Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts 08:43:58 INFO - Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts 08:43:58 INFO - Installing pip2-script.py script to C:\slave\test\build\venv\Scripts 08:43:58 INFO - Installing pip2.exe script to C:\slave\test\build\venv\Scripts 08:43:58 INFO - Successfully installed pip 08:43:58 INFO - Cleaning up... 08:43:58 INFO - Return code: 0 08:43:58 INFO - Installing psutil>=0.7.1 into virtualenv C:\slave\test\build/venv 08:43:58 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')]} 08:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:58 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')]} 08:43:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:58 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 0x02414B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023D4EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0245C358>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01D78B48>, '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 0x01D9A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028B3660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-053', 'USERDOMAIN': 'T-W864-IX-053', '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-053', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-053\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-053', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-053', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-053', '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;C:\\mozilla-build\\hg', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-053\\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 08:43:58 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 08:43:58 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 08:43:58 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 08:43:58 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-053\\AppData\\Roaming', 08:43:58 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 08:43:58 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 08:43:58 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 08:43:58 INFO - 'COMPUTERNAME': 'T-W864-IX-053', 08:43:58 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 08:43:58 INFO - 'DCLOCATION': 'SCL3', 08:43:58 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 08:43:58 INFO - 'FP_NO_HOST_CHECK': 'NO', 08:43:58 INFO - 'HOMEDRIVE': 'C:', 08:43:58 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-053', 08:43:58 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 08:43:58 INFO - 'KTS_VERSION': '1.19c', 08:43:58 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-053\\AppData\\Local', 08:43:58 INFO - 'LOGONSERVER': '\\\\T-W864-IX-053', 08:43:58 INFO - 'MONDIR': 'C:\\Monitor_config\\', 08:43:58 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 08:43:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:58 INFO - 'MOZ_NO_REMOTE': '1', 08:43:58 INFO - 'NO_EM_RESTART': '1', 08:43:58 INFO - 'NUMBER_OF_PROCESSORS': '8', 08:43:58 INFO - 'OS': 'Windows_NT', 08:43:58 INFO - 'OURDRIVE': 'C:', 08:43:58 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 08:43:58 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 08:43:58 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 08:43:58 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 08:43:58 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 08:43:58 INFO - 'PROCESSOR_LEVEL': '6', 08:43:58 INFO - 'PROCESSOR_REVISION': '1e05', 08:43:58 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 08:43:58 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 08:43:58 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 08:43:58 INFO - 'PROGRAMW6432': 'C:\\Program Files', 08:43:58 INFO - 'PROMPT': '$P$G', 08:43:58 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 08:43:58 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 08:43:58 INFO - 'PUBLIC': 'C:\\Users\\Public', 08:43:58 INFO - 'PWD': 'C:\\slave\\test', 08:43:58 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 08:43:58 INFO - 'SLAVEDIR': 'C:\\slave\\', 08:43:58 INFO - 'SYSTEMDRIVE': 'C:', 08:43:58 INFO - 'SYSTEMROOT': 'C:\\windows', 08:43:58 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:43:58 INFO - 'TEST1': 'testie', 08:43:58 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:43:58 INFO - 'USERDOMAIN': 'T-W864-IX-053', 08:43:58 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-053', 08:43:58 INFO - 'USERNAME': 'cltbld', 08:43:58 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-053', 08:43:58 INFO - 'WINDIR': 'C:\\windows', 08:43:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 08:44:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:00 INFO - Downloading/unpacking psutil>=0.7.1 08:44:00 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 08:44:00 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 08:44:01 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 08:44:01 INFO - Installing collected packages: psutil 08:44:01 INFO - Successfully installed psutil 08:44:01 INFO - Cleaning up... 08:44:01 INFO - Return code: 0 08:44:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv C:\slave\test\build/venv 08:44:01 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')]} 08:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:01 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')]} 08:44:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:01 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 0x02414B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023D4EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0245C358>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01D78B48>, '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 0x01D9A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028B3660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-053', 'USERDOMAIN': 'T-W864-IX-053', '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-053', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-053\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-053', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-053', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-053', '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;C:\\mozilla-build\\hg', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-053\\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 08:44:01 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 08:44:01 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 08:44:01 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 08:44:01 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-053\\AppData\\Roaming', 08:44:01 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 08:44:01 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 08:44:01 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 08:44:01 INFO - 'COMPUTERNAME': 'T-W864-IX-053', 08:44:01 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 08:44:01 INFO - 'DCLOCATION': 'SCL3', 08:44:01 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 08:44:01 INFO - 'FP_NO_HOST_CHECK': 'NO', 08:44:01 INFO - 'HOMEDRIVE': 'C:', 08:44:01 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-053', 08:44:01 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 08:44:01 INFO - 'KTS_VERSION': '1.19c', 08:44:01 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-053\\AppData\\Local', 08:44:01 INFO - 'LOGONSERVER': '\\\\T-W864-IX-053', 08:44:01 INFO - 'MONDIR': 'C:\\Monitor_config\\', 08:44:01 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 08:44:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:01 INFO - 'MOZ_NO_REMOTE': '1', 08:44:01 INFO - 'NO_EM_RESTART': '1', 08:44:01 INFO - 'NUMBER_OF_PROCESSORS': '8', 08:44:01 INFO - 'OS': 'Windows_NT', 08:44:01 INFO - 'OURDRIVE': 'C:', 08:44:01 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 08:44:01 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 08:44:01 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 08:44:01 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 08:44:01 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 08:44:01 INFO - 'PROCESSOR_LEVEL': '6', 08:44:01 INFO - 'PROCESSOR_REVISION': '1e05', 08:44:01 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 08:44:01 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 08:44:01 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 08:44:01 INFO - 'PROGRAMW6432': 'C:\\Program Files', 08:44:01 INFO - 'PROMPT': '$P$G', 08:44:01 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 08:44:01 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 08:44:01 INFO - 'PUBLIC': 'C:\\Users\\Public', 08:44:01 INFO - 'PWD': 'C:\\slave\\test', 08:44:01 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 08:44:01 INFO - 'SLAVEDIR': 'C:\\slave\\', 08:44:01 INFO - 'SYSTEMDRIVE': 'C:', 08:44:01 INFO - 'SYSTEMROOT': 'C:\\windows', 08:44:01 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:44:01 INFO - 'TEST1': 'testie', 08:44:01 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:44:01 INFO - 'USERDOMAIN': 'T-W864-IX-053', 08:44:01 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-053', 08:44:01 INFO - 'USERNAME': 'cltbld', 08:44:01 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-053', 08:44:01 INFO - 'WINDIR': 'C:\\windows', 08:44:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 08:44:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:44:02 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 08:44:02 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 08:44:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:44:03 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 08:44:03 INFO - Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor 08:44:03 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) 08:44:03 INFO - Installing collected packages: mozsystemmonitor 08:44:03 INFO - Running setup.py install for mozsystemmonitor 08:44:03 INFO - Successfully installed mozsystemmonitor 08:44:03 INFO - Cleaning up... 08:44:04 INFO - Return code: 0 08:44:04 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv 08:44: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')]} 08:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44: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')]} 08:44:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44: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', '--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 0x02414B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023D4EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0245C358>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01D78B48>, '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 0x01D9A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028B3660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-053', 'USERDOMAIN': 'T-W864-IX-053', '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-053', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-053\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-053', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-053', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-053', '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;C:\\mozilla-build\\hg', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-053\\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 08:44:04 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 08:44:04 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 08:44:04 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 08:44:04 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-053\\AppData\\Roaming', 08:44:04 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 08:44:04 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 08:44:04 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 08:44:04 INFO - 'COMPUTERNAME': 'T-W864-IX-053', 08:44:04 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 08:44:04 INFO - 'DCLOCATION': 'SCL3', 08:44:04 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 08:44:04 INFO - 'FP_NO_HOST_CHECK': 'NO', 08:44:04 INFO - 'HOMEDRIVE': 'C:', 08:44:04 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-053', 08:44:04 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 08:44:04 INFO - 'KTS_VERSION': '1.19c', 08:44:04 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-053\\AppData\\Local', 08:44:04 INFO - 'LOGONSERVER': '\\\\T-W864-IX-053', 08:44:04 INFO - 'MONDIR': 'C:\\Monitor_config\\', 08:44:04 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 08:44:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:04 INFO - 'MOZ_NO_REMOTE': '1', 08:44:04 INFO - 'NO_EM_RESTART': '1', 08:44:04 INFO - 'NUMBER_OF_PROCESSORS': '8', 08:44:04 INFO - 'OS': 'Windows_NT', 08:44:04 INFO - 'OURDRIVE': 'C:', 08:44:04 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 08:44:04 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 08:44:04 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 08:44:04 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 08:44:04 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 08:44:04 INFO - 'PROCESSOR_LEVEL': '6', 08:44:04 INFO - 'PROCESSOR_REVISION': '1e05', 08:44:04 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 08:44:04 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 08:44:04 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 08:44:04 INFO - 'PROGRAMW6432': 'C:\\Program Files', 08:44:04 INFO - 'PROMPT': '$P$G', 08:44:04 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 08:44:04 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 08:44:04 INFO - 'PUBLIC': 'C:\\Users\\Public', 08:44:04 INFO - 'PWD': 'C:\\slave\\test', 08:44:04 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 08:44:04 INFO - 'SLAVEDIR': 'C:\\slave\\', 08:44:04 INFO - 'SYSTEMDRIVE': 'C:', 08:44:04 INFO - 'SYSTEMROOT': 'C:\\windows', 08:44:04 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:44:04 INFO - 'TEST1': 'testie', 08:44:04 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:44:04 INFO - 'USERDOMAIN': 'T-W864-IX-053', 08:44:04 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-053', 08:44:04 INFO - 'USERNAME': 'cltbld', 08:44:04 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-053', 08:44:04 INFO - 'WINDIR': 'C:\\windows', 08:44:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 08:44:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:04 INFO - Downloading/unpacking blobuploader==1.2.4 08:44:04 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 08:44:04 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 08:44:05 INFO - Downloading blobuploader-1.2.4.tar.gz 08:44:05 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 08:44:05 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader 08:44:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:44:05 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 08:44:05 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 08:44:05 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 08:44:05 INFO - Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests 08:44:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:44:05 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 08:44:05 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 08:44:06 INFO - Downloading docopt-0.6.1.tar.gz 08:44:06 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 08:44:06 INFO - Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt 08:44:06 INFO - Installing collected packages: blobuploader, requests, docopt 08:44:06 INFO - Running setup.py install for blobuploader 08:44:06 INFO - Running setup.py install for requests 08:44:07 INFO - Running setup.py install for docopt 08:44:07 INFO - Successfully installed blobuploader requests docopt 08:44:07 INFO - Cleaning up... 08:44:09 INFO - Return code: 0 08:44:09 INFO - Installing None into virtualenv C:\slave\test\build/venv 08:44:09 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')]} 08:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:09 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')]} 08:44:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:09 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 0x02414B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023D4EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0245C358>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01D78B48>, '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 0x01D9A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028B3660>, '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-053', 'USERDOMAIN': 'T-W864-IX-053', '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-053', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-053\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-053', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-053', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-053', '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;C:\\mozilla-build\\hg', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-053\\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 08:44:09 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 08:44:09 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 08:44:09 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 08:44:09 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-053\\AppData\\Roaming', 08:44:09 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 08:44:09 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 08:44:09 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 08:44:09 INFO - 'COMPUTERNAME': 'T-W864-IX-053', 08:44:09 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 08:44:09 INFO - 'DCLOCATION': 'SCL3', 08:44:09 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 08:44:09 INFO - 'FP_NO_HOST_CHECK': 'NO', 08:44:09 INFO - 'HOMEDRIVE': 'C:', 08:44:09 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-053', 08:44:09 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 08:44:09 INFO - 'KTS_VERSION': '1.19c', 08:44:09 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-053\\AppData\\Local', 08:44:09 INFO - 'LOGONSERVER': '\\\\T-W864-IX-053', 08:44:09 INFO - 'MONDIR': 'C:\\Monitor_config\\', 08:44:09 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 08:44:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:09 INFO - 'MOZ_NO_REMOTE': '1', 08:44:09 INFO - 'NO_EM_RESTART': '1', 08:44:09 INFO - 'NUMBER_OF_PROCESSORS': '8', 08:44:09 INFO - 'OS': 'Windows_NT', 08:44:09 INFO - 'OURDRIVE': 'C:', 08:44:09 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 08:44:09 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 08:44:09 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 08:44:09 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 08:44:09 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 08:44:09 INFO - 'PROCESSOR_LEVEL': '6', 08:44:09 INFO - 'PROCESSOR_REVISION': '1e05', 08:44:09 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 08:44:09 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 08:44:09 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 08:44:09 INFO - 'PROGRAMW6432': 'C:\\Program Files', 08:44:09 INFO - 'PROMPT': '$P$G', 08:44:09 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 08:44:09 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 08:44:09 INFO - 'PUBLIC': 'C:\\Users\\Public', 08:44:09 INFO - 'PWD': 'C:\\slave\\test', 08:44:09 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 08:44:09 INFO - 'SLAVEDIR': 'C:\\slave\\', 08:44:09 INFO - 'SYSTEMDRIVE': 'C:', 08:44:09 INFO - 'SYSTEMROOT': 'C:\\windows', 08:44:09 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:44:09 INFO - 'TEST1': 'testie', 08:44:09 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:44:09 INFO - 'USERDOMAIN': 'T-W864-IX-053', 08:44:09 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-053', 08:44:09 INFO - 'USERNAME': 'cltbld', 08:44:09 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-053', 08:44:09 INFO - 'WINDIR': 'C:\\windows', 08:44:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 08:44:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:09 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 08:44:09 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-lify9y-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 08:44:09 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 08:44:09 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-0t8pjg-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 08:44:09 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 08:44:09 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-r4wzm3-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 08:44:09 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 08:44:09 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xgqrn8-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 08:44:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 08:44:10 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-vzk_em-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 08:44:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 08:44:10 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-gw6m_w-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 08:44:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 08:44:10 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-x_vo35-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 08:44:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 08:44:10 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-f6xel1-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 08:44:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 08:44:10 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-vgxfrx-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 08:44:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 08:44:10 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-bgknho-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 08:44:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 08:44:10 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xopjja-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 08:44:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 08:44:10 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-cdd8rj-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 08:44:10 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 08:44:11 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ylrejx-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 08:44:11 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 08:44:11 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-iee662-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 08:44:11 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 08:44:11 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-zafaxf-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 08:44:11 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 08:44:11 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-cddsfx-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 08:44:11 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 08:44:11 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ski3nt-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 08:44:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:44:11 INFO - Running setup.py install for manifestparser 08:44:11 INFO - Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts 08:44:11 INFO - Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts 08:44:12 INFO - Running setup.py install for mozcrash 08:44:12 INFO - Running setup.py install for mozdebug 08:44:13 INFO - Running setup.py install for mozdevice 08:44:13 INFO - Installing sutini-script.py script to C:\slave\test\build\venv\Scripts 08:44:13 INFO - Installing sutini.exe script to C:\slave\test\build\venv\Scripts 08:44:13 INFO - Installing dm-script.py script to C:\slave\test\build\venv\Scripts 08:44:13 INFO - Installing dm.exe script to C:\slave\test\build\venv\Scripts 08:44:13 INFO - Running setup.py install for mozfile 08:44:14 INFO - Running setup.py install for mozhttpd 08:44:14 INFO - Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts 08:44:14 INFO - Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts 08:44:15 INFO - Running setup.py install for mozinfo 08:44:15 INFO - Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts 08:44:15 INFO - Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts 08:44:15 INFO - Running setup.py install for mozInstall 08:44:15 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts 08:44:15 INFO - Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts 08:44:15 INFO - Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts 08:44:15 INFO - Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts 08:44:15 INFO - Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts 08:44:15 INFO - Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts 08:44:15 INFO - Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts 08:44:15 INFO - Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts 08:44:15 INFO - Running setup.py install for mozleak 08:44:16 INFO - Running setup.py install for mozlog 08:44:16 INFO - Installing structlog-script.py script to C:\slave\test\build\venv\Scripts 08:44:16 INFO - Installing structlog.exe script to C:\slave\test\build\venv\Scripts 08:44:17 INFO - Running setup.py install for moznetwork 08:44:17 INFO - Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts 08:44:17 INFO - Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts 08:44:17 INFO - Running setup.py install for mozprocess 08:44:18 INFO - Running setup.py install for mozprofile 08:44:18 INFO - Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts 08:44:18 INFO - Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts 08:44:18 INFO - Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts 08:44:18 INFO - Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts 08:44:18 INFO - Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts 08:44:18 INFO - Installing view-profile.exe script to C:\slave\test\build\venv\Scripts 08:44:19 INFO - Running setup.py install for mozrunner 08:44:19 INFO - Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts 08:44:19 INFO - Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts 08:44:20 INFO - Running setup.py install for mozscreenshot 08:44:20 INFO - Running setup.py install for moztest 08:44:20 INFO - Running setup.py install for mozversion 08:44:20 INFO - Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts 08:44:20 INFO - Installing mozversion.exe script to C:\slave\test\build\venv\Scripts 08:44:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:44:21 INFO - Cleaning up... 08:44:21 INFO - Return code: 0 08:44:21 INFO - Installing None into virtualenv C:\slave\test\build/venv 08:44: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')]} 08:44:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44: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')]} 08:44:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:21 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 0x02414B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023D4EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0245C358>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01D78B48>, '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 0x01D9A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028B3660>, '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-053', 'USERDOMAIN': 'T-W864-IX-053', '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-053', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-053\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-053', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-053', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-053', '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;C:\\mozilla-build\\hg', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-053\\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 08:44:21 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 08:44:21 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 08:44:21 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 08:44:21 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-053\\AppData\\Roaming', 08:44:21 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 08:44:21 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 08:44:21 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 08:44:21 INFO - 'COMPUTERNAME': 'T-W864-IX-053', 08:44:21 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 08:44:21 INFO - 'DCLOCATION': 'SCL3', 08:44:21 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 08:44:21 INFO - 'FP_NO_HOST_CHECK': 'NO', 08:44:21 INFO - 'HOMEDRIVE': 'C:', 08:44:21 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-053', 08:44:21 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 08:44:21 INFO - 'KTS_VERSION': '1.19c', 08:44:21 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-053\\AppData\\Local', 08:44:21 INFO - 'LOGONSERVER': '\\\\T-W864-IX-053', 08:44:21 INFO - 'MONDIR': 'C:\\Monitor_config\\', 08:44:21 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 08:44:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:21 INFO - 'MOZ_NO_REMOTE': '1', 08:44:21 INFO - 'NO_EM_RESTART': '1', 08:44:21 INFO - 'NUMBER_OF_PROCESSORS': '8', 08:44:21 INFO - 'OS': 'Windows_NT', 08:44:21 INFO - 'OURDRIVE': 'C:', 08:44:21 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 08:44:21 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 08:44:21 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 08:44:21 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 08:44:21 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 08:44:21 INFO - 'PROCESSOR_LEVEL': '6', 08:44:21 INFO - 'PROCESSOR_REVISION': '1e05', 08:44:21 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 08:44:21 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 08:44:21 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 08:44:21 INFO - 'PROGRAMW6432': 'C:\\Program Files', 08:44:21 INFO - 'PROMPT': '$P$G', 08:44:21 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 08:44:21 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 08:44:21 INFO - 'PUBLIC': 'C:\\Users\\Public', 08:44:21 INFO - 'PWD': 'C:\\slave\\test', 08:44:21 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 08:44:21 INFO - 'SLAVEDIR': 'C:\\slave\\', 08:44:21 INFO - 'SYSTEMDRIVE': 'C:', 08:44:21 INFO - 'SYSTEMROOT': 'C:\\windows', 08:44:21 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:44:21 INFO - 'TEST1': 'testie', 08:44:21 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:44:21 INFO - 'USERDOMAIN': 'T-W864-IX-053', 08:44:21 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-053', 08:44:21 INFO - 'USERNAME': 'cltbld', 08:44:21 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-053', 08:44:21 INFO - 'WINDIR': 'C:\\windows', 08:44:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 08:44:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:21 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 08:44:21 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xh1a5z-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 08:44:21 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)) 08:44:21 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 08:44:21 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-onf6xo-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 08:44:21 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)) 08:44:21 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 08:44:21 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jflku7-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 08:44:21 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)) 08:44:21 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 08:44:21 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-gy6wys-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 08:44:22 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)) 08:44:22 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 08:44:22 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-lvemoq-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 08:44:22 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)) 08:44:22 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 08:44:22 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-vftyu9-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 08:44:22 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)) 08:44:22 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 08:44:22 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-t7vgob-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 08:44:22 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)) 08:44:22 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 08:44:22 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-dtf5_l-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 08:44:22 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)) 08:44:22 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 08:44:22 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-cl_k5t-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 08:44:22 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)) 08:44:22 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 08:44:22 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-4bykkv-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 08:44:22 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)) 08:44:22 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 08:44:22 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qbecup-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 08:44:22 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)) 08:44:22 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 08:44:22 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-esldxi-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 08:44:22 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)) 08:44:22 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 08:44:23 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-vbqs16-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 08:44:23 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)) 08:44:23 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 08:44:23 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-efki81-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 08:44:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.10 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)) 08:44:23 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 08:44:23 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-edt_eq-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 08:44:23 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)) 08:44:23 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 08:44:23 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-yrqrzu-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 08:44:23 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)) 08:44:23 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 08:44:23 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-yh_bch-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 08:44:23 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)) 08:44:23 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)) 08:44:23 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)) 08:44:23 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)) 08:44:23 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)) 08:44:23 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)) 08:44:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10)) 08:44:23 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 08:44:23 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 08:44:24 INFO - Downloading blessings-1.5.1.tar.gz 08:44:24 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 08:44:24 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings 08:44:24 INFO - Installing collected packages: blessings 08:44:24 INFO - Running setup.py install for blessings 08:44:25 INFO - Successfully installed blessings 08:44:25 INFO - Cleaning up... 08:44:27 INFO - Return code: 0 08:44:27 INFO - Done creating virtualenv C:\slave\test\build/venv. 08:44:27 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 08:44:27 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 08:44:28 INFO - Reading from file tmpfile_stdout 08:44:28 INFO - Using _rmtree_windows ... 08:44:28 INFO - Using _rmtree_windows ... 08:44:28 INFO - Current package versions: 08:44:28 INFO - blessings == 1.5.1 08:44:28 INFO - blobuploader == 1.2.4 08:44:28 INFO - docopt == 0.6.1 08:44:28 INFO - manifestparser == 1.1 08:44:28 INFO - mozInstall == 1.12 08:44:28 INFO - mozcrash == 0.16 08:44:28 INFO - mozdebug == 0.1 08:44:28 INFO - mozdevice == 0.46 08:44:28 INFO - mozfile == 1.2 08:44:28 INFO - mozhttpd == 0.7 08:44:28 INFO - mozinfo == 0.8 08:44:28 INFO - mozleak == 0.1 08:44:28 INFO - mozlog == 3.0 08:44:28 INFO - moznetwork == 0.27 08:44:28 INFO - mozprocess == 0.22 08:44:28 INFO - mozprofile == 0.27 08:44:28 INFO - mozrunner == 6.10 08:44:28 INFO - mozscreenshot == 0.1 08:44:28 INFO - mozsystemmonitor == 0.0 08:44:28 INFO - moztest == 0.7 08:44:28 INFO - mozversion == 1.4 08:44:28 INFO - psutil == 3.1.1 08:44:28 INFO - requests == 1.2.3 08:44:28 INFO - Installing None into virtualenv C:\slave\test\build/venv 08:44:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:44:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:44:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:28 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 0x02414B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023D4EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0245C358>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01D78B48>, '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 0x01D9A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028B3660>, '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-053', 'USERDOMAIN': 'T-W864-IX-053', '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-053', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-053\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-053', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-053', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-053', '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;C:\\mozilla-build\\hg', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-053\\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 08:44:28 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 08:44:28 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 08:44:28 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 08:44:28 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-053\\AppData\\Roaming', 08:44:28 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 08:44:28 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 08:44:28 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 08:44:28 INFO - 'COMPUTERNAME': 'T-W864-IX-053', 08:44:28 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 08:44:28 INFO - 'DCLOCATION': 'SCL3', 08:44:28 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 08:44:28 INFO - 'FP_NO_HOST_CHECK': 'NO', 08:44:28 INFO - 'HOMEDRIVE': 'C:', 08:44:28 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-053', 08:44:28 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 08:44:28 INFO - 'KTS_VERSION': '1.19c', 08:44:28 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-053\\AppData\\Local', 08:44:28 INFO - 'LOGONSERVER': '\\\\T-W864-IX-053', 08:44:28 INFO - 'MONDIR': 'C:\\Monitor_config\\', 08:44:28 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 08:44:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:28 INFO - 'MOZ_NO_REMOTE': '1', 08:44:28 INFO - 'NO_EM_RESTART': '1', 08:44:28 INFO - 'NUMBER_OF_PROCESSORS': '8', 08:44:28 INFO - 'OS': 'Windows_NT', 08:44:28 INFO - 'OURDRIVE': 'C:', 08:44:28 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 08:44:28 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 08:44:28 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 08:44:28 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 08:44:28 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 08:44:28 INFO - 'PROCESSOR_LEVEL': '6', 08:44:28 INFO - 'PROCESSOR_REVISION': '1e05', 08:44:28 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 08:44:28 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 08:44:28 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 08:44:28 INFO - 'PROGRAMW6432': 'C:\\Program Files', 08:44:28 INFO - 'PROMPT': '$P$G', 08:44:28 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 08:44:28 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 08:44:28 INFO - 'PUBLIC': 'C:\\Users\\Public', 08:44:28 INFO - 'PWD': 'C:\\slave\\test', 08:44:28 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 08:44:28 INFO - 'SLAVEDIR': 'C:\\slave\\', 08:44:28 INFO - 'SYSTEMDRIVE': 'C:', 08:44:28 INFO - 'SYSTEMROOT': 'C:\\windows', 08:44:28 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:44:28 INFO - 'TEST1': 'testie', 08:44:28 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:44:28 INFO - 'USERDOMAIN': 'T-W864-IX-053', 08:44:28 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-053', 08:44:28 INFO - 'USERNAME': 'cltbld', 08:44:28 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-053', 08:44:28 INFO - 'WINDIR': 'C:\\windows', 08:44:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 08:44:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:28 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)) 08:44:28 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)) 08:44:28 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)) 08:44:28 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)) 08:44:28 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)) 08:44:28 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)) 08:44:28 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)) 08:44:28 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)) 08:44:28 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)) 08:44:28 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)) 08:44:28 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)) 08:44:28 INFO - Cleaning up... 08:44:28 INFO - Return code: 0 08:44:28 INFO - Running post-action listener: _resource_record_post_action 08:44:28 INFO - Running post-action listener: _start_resource_monitoring 08:44:28 INFO - Starting resource monitoring. 08:44:28 INFO - ##### 08:44:28 INFO - ##### Running install step. 08:44:28 INFO - ##### 08:44:28 INFO - Running pre-action listener: _resource_record_pre_action 08:44:28 INFO - Running main action method: install 08:44:28 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 08:44:28 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 08:44:29 INFO - Reading from file tmpfile_stdout 08:44:29 INFO - Using _rmtree_windows ... 08:44:29 INFO - Using _rmtree_windows ... 08:44:29 INFO - Detecting whether we're running mozinstall >=1.0... 08:44:29 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h'] 08:44:29 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h 08:44:29 INFO - Reading from file tmpfile_stdout 08:44:29 INFO - Output received: 08:44:29 INFO - Usage: mozinstall-script.py [options] installer 08:44:29 INFO - Options: 08:44:29 INFO - -h, --help show this help message and exit 08:44:29 INFO - -d DEST, --destination=DEST 08:44:29 INFO - Directory to install application into. [default: 08:44:29 INFO - "C:\slave\test"] 08:44:29 INFO - --app=APP Application being installed. [default: firefox] 08:44:29 INFO - Using _rmtree_windows ... 08:44:29 INFO - Using _rmtree_windows ... 08:44:29 INFO - mkdir: C:\slave\test\build\application 08:44:29 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'] 08:44:29 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 08:44:30 INFO - Reading from file tmpfile_stdout 08:44:30 INFO - Output received: 08:44:30 INFO - C:\slave\test\build\application\firefox\firefox.exe 08:44:30 INFO - Using _rmtree_windows ... 08:44:30 INFO - Using _rmtree_windows ... 08:44:30 INFO - Running post-action listener: _resource_record_post_action 08:44:30 INFO - ##### 08:44:30 INFO - ##### Running run-tests step. 08:44:30 INFO - ##### 08:44:30 INFO - Running pre-action listener: _resource_record_pre_action 08:44:30 INFO - Running main action method: run_tests 08:44:30 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version'] 08:44:30 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version 08:44:30 INFO - Python 2.7.3 08:44:30 INFO - Return code: 0 08:44:30 INFO - grabbing minidump binary from tooltool 08:44:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:44:30 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 0x01D78B48>, '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 0x01D9A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028B3660>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1 08:44:30 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 08:44:30 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 08:44:30 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 08:44:31 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmpg7ccft 08:44:31 INFO - INFO - File integrity verified, renaming tmpg7ccft to win32-minidump_stackwalk.exe 08:44:31 INFO - Return code: 0 08:44:31 INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755 08:44:31 INFO - mkdir: C:\slave\test\build\blobber_upload_dir 08:44:31 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir 08:44:31 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe 08:44:31 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir 08:44:31 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/IaBnchbXQQ27ne5ObcmwUA/artifacts/public/build/firefox-44.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-053', '--webServer', 'localhost'] in C:\slave\test\build 08:44:31 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/IaBnchbXQQ27ne5ObcmwUA/artifacts/public/build/firefox-44.0a1.en-US.win64.crashreporter-symbols.zip --title T-W864-IX-053 --webServer localhost 08:44:31 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 08:44:31 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-053\\AppData\\Roaming', 08:44:31 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 08:44:31 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 08:44:31 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 08:44:31 INFO - 'COMPUTERNAME': 'T-W864-IX-053', 08:44:31 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 08:44:31 INFO - 'DCLOCATION': 'SCL3', 08:44:31 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 08:44:31 INFO - 'FP_NO_HOST_CHECK': 'NO', 08:44:31 INFO - 'HOMEDRIVE': 'C:', 08:44:31 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-053', 08:44:31 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 08:44:31 INFO - 'KTS_VERSION': '1.19c', 08:44:31 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-053\\AppData\\Local', 08:44:31 INFO - 'LOGONSERVER': '\\\\T-W864-IX-053', 08:44:31 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir', 08:44:31 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe', 08:44:31 INFO - 'MONDIR': 'C:\\Monitor_config\\', 08:44:31 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 08:44:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:31 INFO - 'MOZ_NO_REMOTE': '1', 08:44:31 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir', 08:44:31 INFO - 'NO_EM_RESTART': '1', 08:44:31 INFO - 'NUMBER_OF_PROCESSORS': '8', 08:44:31 INFO - 'OS': 'Windows_NT', 08:44:31 INFO - 'OURDRIVE': 'C:', 08:44:31 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 08:44:31 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 08:44:31 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 08:44:31 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 08:44:31 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 08:44:31 INFO - 'PROCESSOR_LEVEL': '6', 08:44:31 INFO - 'PROCESSOR_REVISION': '1e05', 08:44:31 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 08:44:31 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 08:44:31 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 08:44:31 INFO - 'PROGRAMW6432': 'C:\\Program Files', 08:44:31 INFO - 'PROMPT': '$P$G', 08:44:31 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 08:44:31 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 08:44:31 INFO - 'PUBLIC': 'C:\\Users\\Public', 08:44:31 INFO - 'PWD': 'C:\\slave\\test', 08:44:31 INFO - 'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos', 08:44:31 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 08:44:31 INFO - 'SLAVEDIR': 'C:\\slave\\', 08:44:31 INFO - 'SYSTEMDRIVE': 'C:', 08:44:31 INFO - 'SYSTEMROOT': 'C:\\windows', 08:44:31 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:44:31 INFO - 'TEST1': 'testie', 08:44:31 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:44:31 INFO - 'USERDOMAIN': 'T-W864-IX-053', 08:44:31 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-053', 08:44:31 INFO - 'USERNAME': 'cltbld', 08:44:31 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-053', 08:44:31 INFO - 'WINDIR': 'C:\\windows', 08:44:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 08:44:31 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/IaBnchbXQQ27ne5ObcmwUA/artifacts/public/build/firefox-44.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-053', '--webServer', 'localhost'] with output_timeout 3600 ProcessManager NOT managing child processes ProcessManager UNABLE to use job objects to manage child processes 08:44:32 INFO - mozversion INFO | application_buildid: 20151022070509 08:44:32 INFO - mozversion INFO | application_changeset: 2f56d15bb8d69c17a249c2de9c5f95ac4ca766c6 08:44:32 INFO - mozversion INFO | application_display_name: Nightly 08:44:32 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:44:32 INFO - mozversion INFO | application_name: Firefox 08:44:32 INFO - mozversion INFO | application_remotingname: firefox 08:44:32 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 08:44:32 INFO - mozversion INFO | application_vendor: Mozilla 08:44:32 INFO - mozversion INFO | application_version: 44.0a1 08:44:32 INFO - mozversion INFO | platform_buildid: 20151022070509 08:44:32 INFO - mozversion INFO | platform_changeset: 2f56d15bb8d69c17a249c2de9c5f95ac4ca766c6 08:44:32 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 08:44:32 INFO - mozversion INFO | platform_version: 44.0a1 08:44:32 INFO - 2015-10-22 08:44:32,407 DEBUG : using testdate: 1445528672 08:44:32 INFO - 2015-10-22 08:44:32,407 DEBUG : actual date: 1445528672 08:44:32 INFO - 2015-10-22 08:44:32,424 INFO : starting webserver on 'localhost:49277' 08:44:32 INFO - 2015-10-22 08:44:32,426 INFO : Starting test suite T-W864-IX-053 08:44:32 INFO - 2015-10-22 08:44:32,426 INFO : Starting test dromaeo_css 08:44:32 INFO - 2015-10-22 08:44:32,426 DEBUG : operating with platform_type : w8_ 08:44:32 INFO - 2015-10-22 08:44:32,427 INFO : Initialising browser for dromaeo_css test... 08:44:32 INFO - 2015-10-22 08:44:32,542 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpmb6oux\profile http://localhost:49277/getInfo.html 08:44:41 INFO - 2015-10-22 08:44:41,082 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:44:41 INFO - 2015-10-22 08:44:41,082 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:44:41 INFO - 2015-10-22 08:44:41,082 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674 08:44:41 INFO - 2015-10-22 08:44:41,082 DEBUG : BROWSER_OUTPUT: __metrics 08:44:41 INFO - 2015-10-22 08:44:41,221 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:44:43 INFO - 2015-10-22 08:44:43,329 INFO : Browser initialized. 08:44:43 INFO - 2015-10-22 08:44:43,329 INFO : Running cycle 1/1 for dromaeo_css test... 08:44:43 INFO - 2015-10-22 08:44:43,329 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpmb6oux\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:44:54 INFO - 2015-10-22 08:44:54,915 DEBUG : BROWSER_OUTPUT: RSS: Main: 177807360 08:44:54 INFO - 2015-10-22 08:44:54,915 DEBUG : BROWSER_OUTPUT: 08:45:46 INFO - 2015-10-22 08:45:46,115 DEBUG : BROWSER_OUTPUT: 1445528746114 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:47:55 INFO - 2015-10-22 08:47:55,437 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 08:47:56 INFO - 2015-10-22 08:47:56,469 DEBUG : BROWSER_OUTPUT: RSS: Main: 238870528 08:47:56 INFO - 2015-10-22 08:47:56,469 DEBUG : BROWSER_OUTPUT: 08:50:59 INFO - 2015-10-22 08:50:59,697 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 08:51:00 INFO - 2015-10-22 08:51:00,260 DEBUG : BROWSER_OUTPUT: RSS: Main: 219320320 08:51:00 INFO - 2015-10-22 08:51:00,260 DEBUG : BROWSER_OUTPUT: 08:54:02 INFO - 2015-10-22 08:54:02,500 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 08:54:03 INFO - 2015-10-22 08:54:03,075 DEBUG : BROWSER_OUTPUT: RSS: Main: 185954304 08:54:03 INFO - 2015-10-22 08:54:03,076 DEBUG : BROWSER_OUTPUT: 08:57:05 INFO - 2015-10-22 08:57:05,434 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 08:57:06 INFO - 2015-10-22 08:57:05,996 DEBUG : BROWSER_OUTPUT: RSS: Main: 163479552 08:57:06 INFO - 2015-10-22 08:57:05,996 DEBUG : BROWSER_OUTPUT: 09:00:09 INFO - 2015-10-22 09:00:09,086 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 09:00:09 INFO - 2015-10-22 09:00:09,670 DEBUG : BROWSER_OUTPUT: RSS: Main: 169660416 09:00:09 INFO - 2015-10-22 09:00:09,670 DEBUG : BROWSER_OUTPUT: 09:03:12 INFO - 2015-10-22 09:03:12,411 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 09:03:12 INFO - 2015-10-22 09:03:12,663 DEBUG : BROWSER_OUTPUT: RSS: Main: 224858112 09:03:12 INFO - 2015-10-22 09:03:12,663 DEBUG : BROWSER_OUTPUT: 09:03:12 INFO - 2015-10-22 09:03:12,663 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:03:12 INFO - 2015-10-22 09:03:12,663 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:03:12 INFO - 2015-10-22 09:03:12,663 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:03:12 INFO - 2015-10-22 09:03:12,664 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:03:12 INFO - 2015-10-22 09:03:12,664 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2585.3665851866294;2658.9468210635787;2663.60045993101;2671.9599206011903;2678.343805767587;4776.068666610013;4799.232122860339;4821.903561928763;4823.155947709154;4897.412310522734;4839.080574690806;4859.878503037417;4863.537963893434;4870.415550133989;4921.852344429664;4150.3566947123245;4358.2808836541935;4408.603225709693;4422.579854913778;4483.708558943658;4331.566843315659;4351.216780979423;4365.563443655625;4371.388005679208;4377.649788016951;4218.535961044283;4322.546132656073;4335.609795118438;4337.414449049369;4385.758783266919;4252.255855225323;4320.870373888788;4321.416608757841;4377.387165796791;4406.317020861756;4356.738595684269;4361.956380436219;4363.192809330252;4367.301231802928;4376.7811609419405;4244.193603215379;4534.31985202219;4661.603763680091;4667.276572131325;4784.40194975628;4848.17581011229;4873.805047798084;4922.360093187863;4940.40715114185;4949.579285760715;5017.874553136165;5044.2937988681615;5053.519915608012;5053.646244762868;5111.7699703513435;4500.572445617661;4606.539346065367;4610.377599024122;4663.650226233046;4667.789949452283;4980.352554168007;4986.276989836453;4989.725565093882;5063.443021267658;5087.31321271631;4856.538628830255;4906.092372911023;4910.975445122752;4917.336159618406;4978.551930326288;4858;4915.655904086751;4998.925016124761;5014.473480284591;5041.294218809369;4812.855614331575;4868.513148685103;4886.389201349832;4905.87735306613;4931.309616653672;4962.106820772296;4969.801207951714;5004.9499505005215;5006.4492905780335;5058.190689489664;3234.773565850415;3285.78642388244;3332.3002169544184;3335.499675048762;3371.140359208386;2941.602883610728;3033.330669011256;3040.969590304113;3085.4908940025093;3100.689931006881;4607.493175750732;4610.2854057621125;4659.2312268476;4675;4704.917868890175;4847.80608775645;4984.725840078758;4987.925181122286;5024.995000999815;5048.368953880765;4518.186726389282;4547.8635640930825;4582.88542786433;4586.128635559233;4635.513271106485;4063.654589359878;4108.404281379183;4110.876673699794;4115.238680844053;4165.042040330681;4848.539388758062;4948.282499037619;4986.825461108844;4988.451270360258;5007.123753343223;4897.534734200245;4936.062148191832;4968.726720030433;4971.154903666313;4979.751012449291;5043.646944713835;5065.265536497113;5072.67027643202;5074.746262686925;5142.280080788767;4745.217039188633;4868.829590964299;4894.314795928644;4939.456659767495;4972.5027497249985;4936.75316234194;5022.045811295842;5035.395752509722;5052.444231134646;5066.189409694432;4845.836999120256;4892.3884514435695;4901.656884018084;4908.092002979461;4966.925496117633;4688.34363189147;4852.951470485391;4860.343853579721;4908.803647854046;4972.229304457815;4678.742669153229;4690.671652984395;4748.881277968078;4769.689970151929;4803.1114243864995;4815.109204797123;4935.605151587936;4937.987712518853;4940.357753492023;4942.061008408391;4692.366530518473;4782.282657601388;4810.831620893252;4860.295257187618;4891.730954797378 09:03:12 INFO - 2015-10-22 09:03:12,664 DEBUG : BROWSER_OUTPUT: |1;ext.html;501.0730149223934;506.5668853130576;538.0879409401066;542.2354480182943;543.2286153661801;29355;37113.61852531385;37361.3847030708;37725.81137094318;37897;38983.22033559327;39819.601803981954;39921;39925.60074399255;39965.60034399662;7520.210377910295;7661.540307581563;8215.835683286346;8519.914800852006;8525.104863989285;10179.389236645788;10374.792504149913;10391.84412233817;10394.948025259862;10421.739456513573;10346.793064138712;10462.110720588758;10468.110210632105;10470.319429237075;10478.109360704311;7814.570198639101;8004.799880002988;9963.103320701099;10180.796384072351;10198.643047493339;9796.118349348593;10015.298929074896;10029.899701002969;10063.29556931015;10072.899271007343;30945.69054309473;34594.827025864965;35060.29879402398;35094.47358289628;35111.824440877885;2655.229983304839;3147.653758086609;3201.233155984278;3731.738778285521;3911.941320880189;27797.305067373276;28052;28225;28507.857460712563;28702.282442938886;2497.900083996638;2540.6570113034873;2547.159437385677;2585.133980116663;2686.1807148819603;196704;196968.01515992472;198212;200354;201700;54482;54610.45389546133;54797;54936.725316373166;55027;58952.05239737996;59057.40942590519;59125.70437147873;59343.70328148418;59415;15096.39614415433;15613.609659758597;15686.68626627461;15686.9215653921;15695.607609809846;10749;10855.348679079281;10855.782884342427;10868.45657717111;10884.510197041152;18237.72632961672;18661.90669046673;18776.71834922477;18788.53028674267;18972.905135474233;7352.963235183897;7565.773026809205;7616.0860696715645;7628.122765881883;7693.4614576979075;959.9424034557949;973.7176218896583;975.6000039983572;1091.0398849012818;1115.1580556679655;26293.21120366392;26680;26807.195784126507;26934.461310774066;27072.187834365002;847.9872801907976;905.6830109461768;964.4647220792527;1024.6055268721448;1066.8933106689424;12334.259944403364;13244.801327980089;13679.658008549866;14003.159810411407;14047.929760351133;272947;274363;277317;278718;278986;41846.163076738296;41903.58096419058;42788.78605606952;43494.78252608717;43980;1246.95012199511;1264.134068163311;1265.2471779291307;1272.8090786382118;1273.1279073834453;23822;26439.33901652474;26897.193084207505;31097;31277;42725.1454970905;43299.35050974301;43431.34852977144;43491.56508434875;43495;226627.54428759974;231299;231800.04998750312;231865;232573;39467.605323946394;40188;41212.1757564841;41216.38175427431;41248.1750364997;38784.6121538781;39909.60090399059;40213;43163.784181078896;44056.559434406525;36212.4568131473;36860.63139368572;36975.63024369722;37529.81235093807;38140;29161.576129602894;37232.44151337786;39026.414603780395;39840.2031959365;40152.39771403373;36347.81826090853;36921.415500915755;37029.81485092557;37062.25875482529;40574.639101051755;31335.529967050057;31461;31675.841620791747;31880.202994925312;31972.52041219337;25929;26766.464670706868;26805.979103134687;26898.731012689623;27228.183154505397 09:03:12 INFO - 2015-10-22 09:03:12,665 DEBUG : BROWSER_OUTPUT: |2;jquery.html;341.51675379338224;342.0081762887624;343.09080935520865;343.94324936385493;346.3713360251144;12919.806202906964;13508.662283442894;15782.210889455524;16099.792515561336;16731.665366692672;15041;15433.84566154338;16082.276297566637;16090.436834710787;16103.677926441493;5060.569851562622;5205.60957928155;5254.106801843676;5255.054090263751;5258.237555554442;3909.491766070407;4053.8378464861516;5177.404598471167;5728.598998070137;5947.88104237915;5867.061270196769;5883.088121341178;5887;5894.322152952401;5896.351401345849;5731.455511726379;5853.385394533577;5877.118432235156;5890.293164820207;5897.675627840467;5171;5255;5255.710935898524;5261.316028916254;5272.288241087443;18162.364317248834;18453.1696073677;18845.90577047106;18970.905145474186;19032.143553540125;2029.9695504567444;2055.7738648748627;2075.823554997827;2080.1159507209527;2142.7214462119823;7772.494787838772;11221.65340159186;12562.560310389092;12930.159539629987;13456.730865382637;1885.0951543259175;1906.8855868647925;1932.1884808380514;1935.94192174235;1970.1922211893198;54976;55874.16188757172;56220;56392.71803640996;56711.71644141794;14326.283685815875;14334.354954027094;14480;14499.855001450062;14536.27318634064;21236.575268494544;21282.89358553228;21381.358559243246;21390.358289251348;21671.965924770546;8391.328693704489;8404.629592611807;8419.410641255176;8447.070822209553;8480.703175388955;7035.683394247271;7162.820929476805;7168.283171682894;7168.354848063699;7250.528715633467;7092.716291348392;7114.181869085121;7139.428845692332;7186.425085993108;7215.783526494213;2641.471705658876;3082.2756652186717;3108.8445577721022;3118.4075025745037;3137.0432018234656;434.49164477560697;438.88808353870195;438.99341509877377;440.41644820612817;451.15183455104193;10874.347539147677;10886.891131088587;10908.127349811995;11037.558497660004;11065.225434219688;448.15299084729884;452.74872445792244;455.85640523235077;479.0443066083186;481.17718701021647;5884.735186916599;5906.350301466835;6164.4143806338325;6289.119523266746;6363.5227357947415;398662;405367;423947;425580;434985;59160.70419647874;59905.70047149737;60973.08540371898;62140;62626.686866565375;484.8666616680441;488.90955173293054;491.3219756735682;491.6976059723316;493.0557981465453;7950.522968621901;9903.257255705706;9969.40183588958;10067.798644026932;10390.22073344487;26741.19776406711;27235;27524.862375687993;28650.713492864805;29418.26454338573;38463.230735385696;39057.609423906535;39170.216595667356;39190;39242.80378598203;5653.802116926053;5740.368559458373;6069;6096.847578810565;6110.7861224856915;10911.181661375269;10974.231803773979;11099.44502774842;11168.21822472419;11292.604758833402;9615.711528654152;9649.565769540528;9662.758431039;9672.661456849259;9717.514124293899;9375.390599611004;9395;9436.056394360508;9572.712818615453;9810.117089461983;9511.571979261089;9543.856842147234;9727.124558789743;9786.85319720219;9969.003099689973;5906.320773111147;5950.910736338872;6027.698615069141;6041.18444010053;6073.240844894388;9321.161095501437;9625.229981601595;9625.51872406391;9648.179904708179;9708.708738737849 09:03:12 INFO - 2015-10-22 09:03:12,667 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1284.094713227175;1373.23785299159;1563.5700182449825;1573.2920185916337;1755.631317423342;7291.307325804047;7734.22657734227;7871.370290376771;7883.724069657563;7884.881726774103;7913.920860791391;8006.999125109362;8203.95898020509;8226.588670566478;8229.382796290272;1958.079702539804;1975.259277770836;2143.9142434302607;2154.041451554063;2185.2024011235862;2177.096504950444;2225;2230.3309007297826;2235.966460503094;2238.1159442020394;2170.2838063439026;2193.0679461228992;2200.7579166291694;2211.3918672365066;2214.8560343577697;1935.8838469691793;1962.460323411052;2164.7077644518104;2205.2502149269326;2205.746339171;2159.88120653364;2172.4677454023868;2196.835237357189;2196.9890150549304;2236.6980457638338;8130.3495720342235;8133.511989280603;8221.383396245246;8225.341972642174;8238.09380968093;4678.719276843366;4707.129181101473;4748.501407352247;4771.832985845514;4802.855914322576;2733.166384252802;2800.8879644814388;2824.8587570621385;2851.572264160372;2869.182283049321;804.7625950344603;821.1788211788212;821.6959724901765;857.1257317536079;864.3171894203572;11421.714457138554;11498.137639676974;11564.595239166589;11596.478158482889;11663.708407289801;4232.238197124547;4252.447181866338;4308.870733877989;4309.482862056573;4350.477942646839;9947.065615643403;9959.10368066863;9967.601295948081;9983.400995940267;10027.448490333101;4703.2004559225015;4716.575508204278;4744.1934871072;4751.049790041936;4754.310624959361;4174;4177.3316269396755;4225.9577404226175;4237.555056719062;4242.5121111072;3594.9101272468397;3604.6575575320826;3624.3113808376324;3627.9818600907356;3663.0476076220375;1105.303658695017;1130.5195292000867;1132.28665940457;1134.4781400555837;1143.2397455692037;954.6801821389912;969.1519920069939;974.848898420746;1083.3012706804068;1264.4120483974996;6706.798796036127;7847.254510821463;8117.188281171953;8118.75643730689;8130.146334634778;611.9051547010221;621.1583304622172;1196.4376742930808;1199.412287978884;1225.4301749686438;5932;5985.072313791369;5988.820335389945;5991.58058935879;6004.519638428916;9632.75918102039;9960.103590676874;9977.451240181714;9982.650607228858;9983.500824958723;9805.950970245103;9816.803663926681;9852.802943941224;9859.852102218472;9869.605215791431;7215.49491535598;7416.258374162649;7443.478956473104;7461.776146715607;7488.700451981859;7356.264373562601;7415.629218538944;7422.66598003102;7445.143808462096;7484.438667100098;8509.319254459504;8616.78458038554;8664.696735614476;8665.046844847187;8683.782905427415;8586.699465518677;8950.641974321215;8955.820883582423;8955.910440895508;8957.910420895969;7671.616419178907;7795.142534321107;7796.610169491616;7819.218078192363;7834.6866125354345;7587.520433515411;7952.6421311039985;7996;7996.160403157584;8064.6370913307865;7424.146223184187;7434.516756410816;7481.7755467336065;7537.9623101884135;7601.277878601524;7300.63496825146;7334.669939852826;7341.375983041501;7396.889046664197;7438.674737177367;6810.9318906810295;6828.829279268058;7521.924780752342;7643.197464266172;7644.617769111634;6595.472362211108;6634.535582509371;6671.532992690659;6698.22970358415;6706.128203333536;6680.899786503303;6685.930251159791;6691.0967019451755;6724.293949135466;6821.420179284618 09:03:12 INFO - 2015-10-22 09:03:12,698 DEBUG : BROWSER_OUTPUT: |4;prototype.html;305.520333077069;314.66802523337884;316.05342000707884;327.62977835046394;328.9440795064839;5100.260462232974;5103.030424219401;5105.3873535175835;5107.336046313979;5119.1297479428495;4986.002799440117;5013.323201367814;5027.09512287788;5035.144025515662;5039.571636410909;3988.760674359548;3989.40158976153;3991.2017596480673;3996.6003399660094;3997.060690737674;3863.7102217333672;3937.960620393788;3977.781222032787;3995.6403923646867;4000.9399859002137;3876.8061596920184;3890.7860067696265;3941.17235380569;3944.4083387491964;3947.3092208863336;3914.588968158345;3920.4511368408444;3935.0359162005493;3939.980300098481;3942.7831469269177;3451.7238620910516;3485.4597537381746;3487.0646791030968;3491.476278558211;3526.2594855080465;4863.951360486385;4911.705297682151;4937.358143441365;4947.604191664658;4948.529889660513;4499.055198408339;4508.2561377372695;4508.549145085498;4513.50351461339;4514;5009;5012;5101.362329708786;5102.821401250939;5197.766100525486;3683.8158092095555;3720.1257704439436;3733.757305775143;3735.1035751419463;3735.3276410246417;5396.541293990015;5412.891742165174;5417.322834645669;5420.051490989061;5422.376426710939;3790.981045094757;3854.768713877176;3856.787876666754;3856.7878766668105;3860.0542866997766;3697.4084146536425;3808.21931504041;3815.21788033458;3823.1206822430995;3953.367461206193;4328.26419508678;4351.5430879757805;4354.281543545279;4362.498312694017;4367.58507941745;5179.404368497596;5185.896282074337;5188.195829646411;5188.558972487305;5194.584433245332;1354.4852955876902;1379.1104737444493;1382.2466755618211;1387.5629176809273;1387.9028468007346;918.963241470347;937.8124375125002;948.3977674176947;951.995644594959;954.7279025477844;4926.064047830901;4951.777170027357;4966.329545511309;4971.776270067856;4977.9751101244265;5417.052015897202;5438.891222175614;5441.59188060897;5448.645838020516;5454.563634909197;4908.631852611068;4924.729139897268;4967.279744437109;4969.726665033386;4969.875753106129;2905.447964886665;2945.0870230228697;2949.7935144539674;2981.9861247176063;2988;5435.510804027656;5439.3200849893765;5461.6996065216;5462.7268636568015;5479.123340265538;5503.642263252876;5542.39033706292;5554.750036248379;5565.41563135873;5566.55467562594;5414.458554144554;5463.836084917459;5464.754086066137;5467.480589344006;5468.152436372368;5058.089543882136;5184.844454666366;5345.492178243061;5385.784568617211;5439.37447193562;5282.392524859691;5300.337457817773;5300.575953923754;5301.575873929999;5309.65487243328;5417.51242388187;5422.430644782241;5424.457554244544;5430.104032834538;5449.04641687711;3750.5311836020496;3751.34351488483;3754.8685795997008;3759.8308076137187;3761.8683346082757;5304.124819404755;5387.919181212206;5407.513323800877;5436.972815136057;5463.644863083887;5248.291480650063;5249.396319423316;5279;5283.8679033022945;5287.841364759063;5271.314729085195;5274.8945021100135;5277.340332458442;5283;5289.021531016774;5090.567301779391;5199.7140157291715;5209.531142197069;5215.713135777569;5220.399654039682;5108.029474399852;5147.716875571879;5180.274761533313;5216.113260745607;5219.895602088013;5269.604779641466;5282.76227569768;5284.735763211747;5287.206918962186;5304.098303288373 09:03:12 INFO - 2015-10-22 09:03:12,700 DEBUG : BROWSER_OUTPUT: |5;yui.html;742.9405647548197;776.3827756933238;831.123165060861;833.3291700181359;857.7169534053759;11756.235844670091;11948.223365481259;11974.04207663387;11999.280043197403;12007.819882701755;10971.890281097187;11090.778184436327;11105.444727763599;11107;11123.944380278088;665.4709505942762;674.5514233035026;817.4318848400364;821.9671213151466;833.8665813469846;819.5656302159865;822.4448497264352;828.1925123005082;832.4381042796118;832.8958880139983;861.3496809908511;868.6178081644057;871.7515508080198;871.860502319629;872.733816186063;699.8040548646362;705.4920457270782;858.7295002074327;863.2791618998144;871.8169184471269;644.2848438233557;645.7836624730721;647.6891092275735;648.7599588152414;650.6486497291457;11654.359010254433;11676.766464670744;11716;11807.232529885616;11812.468438920183;10328.483575821254;10657.200709946785;10662.253642245047;10712.892871071268;10926.68879734429;8310.168983101701;8357.080721120672;8385.454945428528;8424.578771061484;8476.915230847675;3248.561444205049;3306.057773534531;3317.336532693471;3330.933381332384;3393.270446853938;30267;30602;30670.84664576685;30673.386532269455;30703.385932281228;8297.087320394752;8310.958445207856;8326.916730832614;8333.6666533338;8387.62255698495;14879.553613391616;15054.849451505565;15082.095074295577;15085.24573771307;15086.17026063577;6220.440160385587;6392.776252831129;6422.068800023971;6502.349765023459;6541.509386795914;3585.15748799032;3649.3066317399607;3666.358387282215;3670.743047986669;3674.926501469956;2472.3929445860335;2490.439651078529;2496.251124662594;2498.1381423408893;2512.4095837478176;413.2025191380664;414.8942019784935;418.5856002557507;418.9266878296286;419.3081415664179;440.9823607055746;455.6423207781942;462.18655166906484;488.90466359060355;592.3217915486744;6948.888177891513;7221.977846203072;7298.416126709851;7308.415326773846;7510.474266801271;494.41658842565397;601.8074216250758;603.7192705392014;618.8855061813579;629.6379581740426;3568.6431356864105;3768.1333293342686;3892.8832135035996;3900.3369427197445;3957.8021098944937;35736.821315893256;36048.81975590105;36108;36205.275894481965;36207.094822629646;30495.542566861513;31086.37827243488;31124.221894452367;31324.68675313263;31340.843295783376;26385.47229055408;26467.470650587267;26604.068857589893;26613.86693066561;28457.57313640297;7343.302386273295;7661.310482056641;7690.846183076195;7731.342835859015;7890.132085470479;20519.17923283052;20798.168073277506;21044;21209.575808484053;21253.149874005485;26300.293425176456;26958.460830783668;27152.592711108955;27196.184114476597;27205.455890881676;6631.568948018364;6667.599944003376;6711.161104861892;6901.930980690329;6968.686409111703;10110.140638045848;10436.530356134144;10671.46642667879;10894.074003709773;10945.56217751313;9821.85267220978;9973.50132493387;10166.74583135398;10328.741781455223;10439.686809395731;9481.431114133175;9698.854517182106;10129.64546240878;10180.338278011906;10243.641472548425;9307.813843723223;9586.328956973224;9725.902740972782;9914.652987145415;10029.749256268651;8595.613197406006;8646.308295336485;8815;8866.689665861664;9046.050164732871;7755.7673269802;8521.318294536299;8559.443636163629;8664.090270521756;8679.305655547667 09:03:12 INFO - 2015-10-22 09:03:12,700 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:03:12 INFO - 2015-10-22 09:03:12,700 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:03:12 INFO - 2015-10-22 09:03:12,700 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,795 09:03:12 INFO - 2015-10-22 09:03:12,700 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:03:12 INFO - 2015-10-22 09:03:12,700 DEBUG : BROWSER_OUTPUT: __startTimestamp1445529792659__endTimestamp 09:03:12 INFO - 2015-10-22 09:03:12,700 DEBUG : BROWSER_OUTPUT: 09:03:12 INFO - 2015-10-22 09:03:12,700 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:03:12 INFO - 2015-10-22 09:03:12,700 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:03:12 INFO - 2015-10-22 09:03:12,701 DEBUG : BROWSER_OUTPUT: 09:03:12 INFO - 2015-10-22 09:03:12,701 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4600.19 Median:4845.84 stddev:574.95 (11.9%) stddev-sans-first:554.57 09:03:12 INFO - 2015-10-22 09:03:12,701 DEBUG : BROWSER_OUTPUT: Values: 2585.4 2658.9 2663.6 2672.0 2678.3 4776.1 4799.2 4821.9 4823.2 4897.4 4839.1 4859.9 4863.5 4870.4 4921.9 4150.4 4358.3 4408.6 4422.6 4483.7 4331.6 4351.2 4365.6 4371.4 4377.6 4218.5 4322.5 4335.6 4337.4 4385.8 4252.3 4320.9 4321.4 4377.4 4406.3 4356.7 4362.0 4363.2 4367.3 4376.8 4244.2 4534.3 4661.6 4667.3 4784.4 4848.2 4873.8 4922.4 4940.4 4949.6 5017.9 5044.3 5053.5 5053.6 5111.8 4500.6 4606.5 4610.4 4663.7 4667.8 4980.4 4986.3 4989.7 5063.4 5087.3 4856.5 4906.1 4911.0 4917.3 4978.6 4858.0 4915.7 4998.9 5014.5 5041.3 4812.9 4868.5 4886.4 4905.9 4931.3 4962.1 4969.8 5004.9 5006.4 5058.2 3234.8 3285.8 3332.3 3335.5 3371.1 2941.6 3033.3 3041.0 3085.5 3100.7 4607.5 4610.3 4659.2 4675.0 4704.9 4847.8 4984.7 4987.9 5025.0 5048.4 4518.2 4547.9 4582.9 4586.1 4635.5 4063.7 4108.4 4110.9 4115.2 4165.0 4848.5 4948.3 4986.8 4988.5 5007.1 4897.5 4936.1 4968.7 4971.2 4979.8 5043.6 5065.3 5072.7 5074.7 5142.3 4745.2 4868.8 4894.3 4939.5 4972.5 4936.8 5022.0 5035.4 5052.4 5066.2 4845.8 4892.4 4901.7 4908.1 4966.9 4688.3 4853.0 4860.3 4908.8 4972.2 4678.7 4690.7 4748.9 4769.7 4803.1 4815.1 4935.6 4938.0 4940.4 4942.1 4692.4 4782.3 4810.8 4860.3 4891.7 09:03:12 INFO - 2015-10-22 09:03:12,701 DEBUG : BROWSER_OUTPUT: 09:03:12 INFO - 2015-10-22 09:03:12,701 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40967.48 Median:17304.33 stddev:61654.33 (356.3%) stddev-sans-first:61752.41 09:03:12 INFO - 2015-10-22 09:03:12,701 DEBUG : BROWSER_OUTPUT: Values: 501.1 506.6 538.1 542.2 543.2 29355.0 37113.6 37361.4 37725.8 37897.0 38983.2 39819.6 39921.0 39925.6 39965.6 7520.2 7661.5 8215.8 8519.9 8525.1 10179.4 10374.8 10391.8 10394.9 10421.7 10346.8 10462.1 10468.1 10470.3 10478.1 7814.6 8004.8 9963.1 10180.8 10198.6 9796.1 10015.3 10029.9 10063.3 10072.9 30945.7 34594.8 35060.3 35094.5 35111.8 2655.2 3147.7 3201.2 3731.7 3911.9 27797.3 28052.0 28225.0 28507.9 28702.3 2497.9 2540.7 2547.2 2585.1 2686.2 196704.0 196968.0 198212.0 200354.0 201700.0 54482.0 54610.5 54797.0 54936.7 55027.0 58952.1 59057.4 59125.7 59343.7 59415.0 15096.4 15613.6 15686.7 15686.9 15695.6 10749.0 10855.3 10855.8 10868.5 10884.5 18237.7 18661.9 18776.7 18788.5 18972.9 7353.0 7565.8 7616.1 7628.1 7693.5 959.9 973.7 975.6 1091.0 1115.2 26293.2 26680.0 26807.2 26934.5 27072.2 848.0 905.7 964.5 1024.6 1066.9 12334.3 13244.8 13679.7 14003.2 14047.9 272947.0 274363.0 277317.0 278718.0 278986.0 41846.2 41903.6 42788.8 43494.8 43980.0 1247.0 1264.1 1265.2 1272.8 1273.1 23822.0 26439.3 26897.2 31097.0 31277.0 42725.1 43299.4 43431.3 43491.6 43495.0 226627.5 231299.0 231800.0 231865.0 232573.0 39467.6 40188.0 41212.2 41216.4 41248.2 38784.6 39909.6 40213.0 43163.8 44056.6 36212.5 36860.6 36975.6 37529.8 38140.0 29161.6 37232.4 39026.4 39840.2 40152.4 36347.8 36921.4 37029.8 37062.3 40574.6 31335.5 31461.0 31675.8 31880.2 31972.5 25929.0 26766.5 26806.0 26898.7 27228.2 09:03:12 INFO - 2015-10-22 09:03:12,701 DEBUG : BROWSER_OUTPUT: 09:03:12 INFO - 2015-10-22 09:03:12,701 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23482.89 Median:491.51 stddev:68249.93 (13885.8%) stddev-sans-first:68419.27 09:03:12 INFO - 2015-10-22 09:03:12,703 DEBUG : BROWSER_OUTPUT: Values: 341.5 342.0 343.1 343.9 346.4 12919.8 13508.7 15782.2 16099.8 16731.7 15041.0 15433.8 16082.3 16090.4 16103.7 5060.6 5205.6 5254.1 5255.1 5258.2 3909.5 4053.8 5177.4 5728.6 5947.9 5867.1 5883.1 5887.0 5894.3 5896.4 5731.5 5853.4 5877.1 5890.3 5897.7 5171.0 5255.0 5255.7 5261.3 5272.3 18162.4 18453.2 18845.9 18970.9 19032.1 2030.0 2055.8 2075.8 2080.1 2142.7 7772.5 11221.7 12562.6 12930.2 13456.7 1885.1 1906.9 1932.2 1935.9 1970.2 54976.0 55874.2 56220.0 56392.7 56711.7 14326.3 14334.4 14480.0 14499.9 14536.3 21236.6 21282.9 21381.4 21390.4 21672.0 8391.3 8404.6 8419.4 8447.1 8480.7 7035.7 7162.8 7168.3 7168.4 7250.5 7092.7 7114.2 7139.4 7186.4 7215.8 2641.5 3082.3 3108.8 3118.4 3137.0 434.5 438.9 439.0 440.4 451.2 10874.3 10886.9 10908.1 11037.6 11065.2 448.2 452.7 455.9 479.0 481.2 5884.7 5906.4 6164.4 6289.1 6363.5 398662.0 405367.0 423947.0 425580.0 434985.0 59160.7 59905.7 60973.1 62140.0 62626.7 484.9 488.9 491.3 491.7 493.1 7950.5 9903.3 9969.4 10067.8 10390.2 26741.2 27235.0 27524.9 28650.7 29418.3 38463.2 39057.6 39170.2 39190.0 39242.8 5653.8 5740.4 6069.0 6096.8 6110.8 10911.2 10974.2 11099.4 11168.2 11292.6 9615.7 9649.6 9662.8 9672.7 9717.5 9375.4 9395.0 9436.1 9572.7 9810.1 9511.6 9543.9 9727.1 9786.9 9969.0 5906.3 5950.9 6027.7 6041.2 6073.2 9321.2 9625.2 9625.5 9648.2 9708.7 09:03:12 INFO - 2015-10-22 09:03:12,704 DEBUG : BROWSER_OUTPUT: 09:03:12 INFO - 2015-10-22 09:03:12,704 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5648.61 Median:6706.46 stddev:3084.09 (46.0%) stddev-sans-first:3075.29 09:03:12 INFO - 2015-10-22 09:03:12,704 DEBUG : BROWSER_OUTPUT: Values: 1284.1 1373.2 1563.6 1573.3 1755.6 7291.3 7734.2 7871.4 7883.7 7884.9 7913.9 8007.0 8204.0 8226.6 8229.4 1958.1 1975.3 2143.9 2154.0 2185.2 2177.1 2225.0 2230.3 2236.0 2238.1 2170.3 2193.1 2200.8 2211.4 2214.9 1935.9 1962.5 2164.7 2205.3 2205.7 2159.9 2172.5 2196.8 2197.0 2236.7 8130.3 8133.5 8221.4 8225.3 8238.1 4678.7 4707.1 4748.5 4771.8 4802.9 2733.2 2800.9 2824.9 2851.6 2869.2 804.8 821.2 821.7 857.1 864.3 11421.7 11498.1 11564.6 11596.5 11663.7 4232.2 4252.4 4308.9 4309.5 4350.5 9947.1 9959.1 9967.6 9983.4 10027.4 4703.2 4716.6 4744.2 4751.0 4754.3 4174.0 4177.3 4226.0 4237.6 4242.5 3594.9 3604.7 3624.3 3628.0 3663.0 1105.3 1130.5 1132.3 1134.5 1143.2 954.7 969.2 974.8 1083.3 1264.4 6706.8 7847.3 8117.2 8118.8 8130.1 611.9 621.2 1196.4 1199.4 1225.4 5932.0 5985.1 5988.8 5991.6 6004.5 9632.8 9960.1 9977.5 9982.7 9983.5 9806.0 9816.8 9852.8 9859.9 9869.6 7215.5 7416.3 7443.5 7461.8 7488.7 7356.3 7415.6 7422.7 7445.1 7484.4 8509.3 8616.8 8664.7 8665.0 8683.8 8586.7 8950.6 8955.8 8955.9 8957.9 7671.6 7795.1 7796.6 7819.2 7834.7 7587.5 7952.6 7996.0 7996.2 8064.6 7424.1 7434.5 7481.8 7538.0 7601.3 7300.6 7334.7 7341.4 7396.9 7438.7 6810.9 6828.8 7521.9 7643.2 7644.6 6595.5 6634.5 6671.5 6698.2 6706.1 6680.9 6685.9 6691.1 6724.3 6821.4 09:03:12 INFO - 2015-10-22 09:03:12,706 DEBUG : BROWSER_OUTPUT: 09:03:12 INFO - 2015-10-22 09:03:12,706 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4417.46 Median:5037.36 stddev:1280.98 (25.4%) stddev-sans-first:1246.84 09:03:12 INFO - 2015-10-22 09:03:12,706 DEBUG : BROWSER_OUTPUT: Values: 305.5 314.7 316.1 327.6 328.9 5100.3 5103.0 5105.4 5107.3 5119.1 4986.0 5013.3 5027.1 5035.1 5039.6 3988.8 3989.4 3991.2 3996.6 3997.1 3863.7 3938.0 3977.8 3995.6 4000.9 3876.8 3890.8 3941.2 3944.4 3947.3 3914.6 3920.5 3935.0 3940.0 3942.8 3451.7 3485.5 3487.1 3491.5 3526.3 4864.0 4911.7 4937.4 4947.6 4948.5 4499.1 4508.3 4508.5 4513.5 4514.0 5009.0 5012.0 5101.4 5102.8 5197.8 3683.8 3720.1 3733.8 3735.1 3735.3 5396.5 5412.9 5417.3 5420.1 5422.4 3791.0 3854.8 3856.8 3856.8 3860.1 3697.4 3808.2 3815.2 3823.1 3953.4 4328.3 4351.5 4354.3 4362.5 4367.6 5179.4 5185.9 5188.2 5188.6 5194.6 1354.5 1379.1 1382.2 1387.6 1387.9 919.0 937.8 948.4 952.0 954.7 4926.1 4951.8 4966.3 4971.8 4978.0 5417.1 5438.9 5441.6 5448.6 5454.6 4908.6 4924.7 4967.3 4969.7 4969.9 2905.4 2945.1 2949.8 2982.0 2988.0 5435.5 5439.3 5461.7 5462.7 5479.1 5503.6 5542.4 5554.8 5565.4 5566.6 5414.5 5463.8 5464.8 5467.5 5468.2 5058.1 5184.8 5345.5 5385.8 5439.4 5282.4 5300.3 5300.6 5301.6 5309.7 5417.5 5422.4 5424.5 5430.1 5449.0 3750.5 3751.3 3754.9 3759.8 3761.9 5304.1 5387.9 5407.5 5437.0 5463.6 5248.3 5249.4 5279.0 5283.9 5287.8 5271.3 5274.9 5277.3 5283.0 5289.0 5090.6 5199.7 5209.5 5215.7 5220.4 5108.0 5147.7 5180.3 5216.1 5219.9 5269.6 5282.8 5284.7 5287.2 5304.1 09:03:12 INFO - 2015-10-22 09:03:12,707 DEBUG : BROWSER_OUTPUT: 09:03:12 INFO - 2015-10-22 09:03:12,707 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:9860.25 Median:419.12 stddev:9573.57 (2284.2%) stddev-sans-first:9575.94 09:03:12 INFO - 2015-10-22 09:03:12,707 DEBUG : BROWSER_OUTPUT: Values: 742.9 776.4 831.1 833.3 857.7 11756.2 11948.2 11974.0 11999.3 12007.8 10971.9 11090.8 11105.4 11107.0 11123.9 665.5 674.6 817.4 822.0 833.9 819.6 822.4 828.2 832.4 832.9 861.3 868.6 871.8 871.9 872.7 699.8 705.5 858.7 863.3 871.8 644.3 645.8 647.7 648.8 650.6 11654.4 11676.8 11716.0 11807.2 11812.5 10328.5 10657.2 10662.3 10712.9 10926.7 8310.2 8357.1 8385.5 8424.6 8476.9 3248.6 3306.1 3317.3 3330.9 3393.3 30267.0 30602.0 30670.8 30673.4 30703.4 8297.1 8311.0 8326.9 8333.7 8387.6 14879.6 15054.8 15082.1 15085.2 15086.2 6220.4 6392.8 6422.1 6502.3 6541.5 3585.2 3649.3 3666.4 3670.7 3674.9 2472.4 2490.4 2496.3 2498.1 2512.4 413.2 414.9 418.6 418.9 419.3 441.0 455.6 462.2 488.9 592.3 6948.9 7222.0 7298.4 7308.4 7510.5 494.4 601.8 603.7 618.9 629.6 3568.6 3768.1 3892.9 3900.3 3957.8 35736.8 36048.8 36108.0 36205.3 36207.1 30495.5 31086.4 31124.2 31324.7 31340.8 26385.5 26467.5 26604.1 26613.9 28457.6 7343.3 7661.3 7690.8 7731.3 7890.1 20519.2 20798.2 21044.0 21209.6 21253.1 26300.3 26958.5 27152.6 27196.2 27205.5 6631.6 6667.6 6711.2 6901.9 6968.7 10110.1 10436.5 10671.5 10894.1 10945.6 9821.9 9973.5 10166.7 10328.7 10439.7 9481.4 9698.9 10129.6 10180.3 10243.6 9307.8 9586.3 9725.9 9914.7 10029.7 8595.6 8646.3 8815.0 8866.7 9046.1 7755.8 8521.3 8559.4 8664.1 8679.3 09:03:12 INFO - 2015-10-22 09:03:12,707 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:03:12 INFO - 2015-10-22 09:03:12,707 DEBUG : BROWSER_OUTPUT: 09:03:13 INFO - 2015-10-22 09:03:13,226 INFO : Browser exited with error code: 0 09:03:13 INFO - 2015-10-22 09:03:13,964 INFO : Completed test dromaeo_css (00:18:41) 09:03:13 INFO - 2015-10-22 09:03:13,964 INFO : Starting test kraken 09:03:13 INFO - 2015-10-22 09:03:13,964 DEBUG : operating with platform_type : w8_ 09:03:13 INFO - 2015-10-22 09:03:13,964 INFO : Initialising browser for kraken test... 09:03:13 INFO - 2015-10-22 09:03:13,984 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpijqydn\profile http://localhost:49277/getInfo.html 09:03:20 INFO - 2015-10-22 09:03:20,107 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:03:20 INFO - 2015-10-22 09:03:20,107 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:03:20 INFO - 2015-10-22 09:03:20,107 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674 09:03:20 INFO - 2015-10-22 09:03:20,107 DEBUG : BROWSER_OUTPUT: __metrics 09:03:20 INFO - 2015-10-22 09:03:20,234 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:03:20 INFO - 2015-10-22 09:03:20,526 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 121: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 09:03:20 INFO - 2015-10-22 09:03:20,766 DEBUG : BROWSER_OUTPUT: console.error: 09:03:20 INFO - 2015-10-22 09:03:20,769 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] 09:03:20 INFO - 2015-10-22 09:03:20,769 DEBUG : BROWSER_OUTPUT: Stack: 09:03:20 INFO - 2015-10-22 09:03:20,770 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<._executeStatement@resource://gre/modules/Sqlite.jsm:758:19 09:03:20 INFO - 2015-10-22 09:03:20,770 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached/<@resource://gre/modules/Sqlite.jsm:493:9 09:03:20 INFO - 2015-10-22 09:03:20,770 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached@resource://gre/modules/Sqlite.jsm:491:1 09:03:20 INFO - 2015-10-22 09:03:20,770 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeBeforeShutdown/loggedDb<.executeCached.value<@resource://gre/modules/Sqlite.jsm:368:51 09:03:20 INFO - 2015-10-22 09:03:20,772 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 09:03:20 INFO - 2015-10-22 09:03:20,772 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 09:03:20 INFO - 2015-10-22 09:03:20,772 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 09:03:20 INFO - 2015-10-22 09:03:20,772 DEBUG : BROWSER_OUTPUT: transaction@resource://gre/modules/Bookmarks.jsm:798:13 09:03:20 INFO - 2015-10-22 09:03:20,772 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 09:03:20 INFO - 2015-10-22 09:03:20,772 DEBUG : BROWSER_OUTPUT: Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:934:23 09:03:20 INFO - 2015-10-22 09:03:20,772 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 09:03:20 INFO - 2015-10-22 09:03:20,772 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 09:03:20 INFO - 2015-10-22 09:03:20,773 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 09:03:20 INFO - 2015-10-22 09:03:20,773 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 09:03:20 INFO - 2015-10-22 09:03:20,773 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 09:03:20 INFO - 2015-10-22 09:03:20,773 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 09:03:20 INFO - 2015-10-22 09:03:20,773 DEBUG : BROWSER_OUTPUT: 09:03:21 INFO - 2015-10-22 09:03:21,506 INFO : Browser initialized. 09:03:21 INFO - 2015-10-22 09:03:21,506 INFO : Running cycle 1/1 for kraken test... 09:03:21 INFO - 2015-10-22 09:03:21,506 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpijqydn\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\kraken\kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:03:33 INFO - 2015-10-22 09:03:33,078 DEBUG : BROWSER_OUTPUT: RSS: Main: 182947840 09:03:33 INFO - 2015-10-22 09:03:33,078 DEBUG : BROWSER_OUTPUT: 09:03:35 INFO - 2015-10-22 09:03:35,868 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 09:03:36 INFO - 2015-10-22 09:03:36,453 DEBUG : BROWSER_OUTPUT: RSS: Main: 220110848 09:03:36 INFO - 2015-10-22 09:03:36,453 DEBUG : BROWSER_OUTPUT: 09:03:39 INFO - 2015-10-22 09:03:39,165 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 09:03:39 INFO - 2015-10-22 09:03:39,749 DEBUG : BROWSER_OUTPUT: RSS: Main: 218660864 09:03:39 INFO - 2015-10-22 09:03:39,749 DEBUG : BROWSER_OUTPUT: 09:03:42 INFO - 2015-10-22 09:03:42,457 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 09:03:43 INFO - 2015-10-22 09:03:43,028 DEBUG : BROWSER_OUTPUT: RSS: Main: 203661312 09:03:43 INFO - 2015-10-22 09:03:43,028 DEBUG : BROWSER_OUTPUT: 09:03:45 INFO - 2015-10-22 09:03:45,033 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 09:03:45 INFO - 2015-10-22 09:03:45,607 DEBUG : BROWSER_OUTPUT: RSS: Main: 207110144 09:03:45 INFO - 2015-10-22 09:03:45,608 DEBUG : BROWSER_OUTPUT: 09:03:47 INFO - 2015-10-22 09:03:47,822 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:03:48 INFO - 2015-10-22 09:03:48,385 DEBUG : BROWSER_OUTPUT: RSS: Main: 204533760 09:03:48 INFO - 2015-10-22 09:03:48,385 DEBUG : BROWSER_OUTPUT: 09:03:51 INFO - 2015-10-22 09:03:51,448 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 09:03:52 INFO - 2015-10-22 09:03:52,032 DEBUG : BROWSER_OUTPUT: RSS: Main: 198012928 09:03:52 INFO - 2015-10-22 09:03:52,032 DEBUG : BROWSER_OUTPUT: 09:03:55 INFO - 2015-10-22 09:03:55,411 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 09:03:55 INFO - 2015-10-22 09:03:55,993 DEBUG : BROWSER_OUTPUT: RSS: Main: 195366912 09:03:55 INFO - 2015-10-22 09:03:55,993 DEBUG : BROWSER_OUTPUT: 09:03:58 INFO - 2015-10-22 09:03:58,895 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 09:03:59 INFO - 2015-10-22 09:03:59,471 DEBUG : BROWSER_OUTPUT: RSS: Main: 193634304 09:03:59 INFO - 2015-10-22 09:03:59,471 DEBUG : BROWSER_OUTPUT: 09:04:01 INFO - 2015-10-22 09:04:01,263 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:04:01 INFO - 2015-10-22 09:04:01,828 DEBUG : BROWSER_OUTPUT: RSS: Main: 221974528 09:04:01 INFO - 2015-10-22 09:04:01,828 DEBUG : BROWSER_OUTPUT: 09:04:03 INFO - 2015-10-22 09:04:03,732 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:04:04 INFO - 2015-10-22 09:04:04,306 DEBUG : BROWSER_OUTPUT: RSS: Main: 225783808 09:04:04 INFO - 2015-10-22 09:04:04,306 DEBUG : BROWSER_OUTPUT: 09:04:06 INFO - 2015-10-22 09:04:06,585 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:04:07 INFO - 2015-10-22 09:04:07,167 DEBUG : BROWSER_OUTPUT: RSS: Main: 230137856 09:04:07 INFO - 2015-10-22 09:04:07,167 DEBUG : BROWSER_OUTPUT: 09:04:09 INFO - 2015-10-22 09:04:09,729 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:04:10 INFO - 2015-10-22 09:04:10,312 DEBUG : BROWSER_OUTPUT: RSS: Main: 232886272 09:04:10 INFO - 2015-10-22 09:04:10,313 DEBUG : BROWSER_OUTPUT: 09:04:13 INFO - 2015-10-22 09:04:13,072 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:04:13 INFO - 2015-10-22 09:04:13,642 DEBUG : BROWSER_OUTPUT: RSS: Main: 234070016 09:04:13 INFO - 2015-10-22 09:04:13,642 DEBUG : BROWSER_OUTPUT: 09:04:15 INFO - 2015-10-22 09:04:15,480 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 09:04:15 INFO - 2015-10-22 09:04:15,732 DEBUG : BROWSER_OUTPUT: RSS: Main: 288804864 09:04:15 INFO - 2015-10-22 09:04:15,732 DEBUG : BROWSER_OUTPUT: 09:04:15 INFO - 2015-10-22 09:04:15,732 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:04:15 INFO - 2015-10-22 09:04:15,732 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:04:15 INFO - 2015-10-22 09:04:15,732 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:04:15 INFO - 2015-10-22 09:04:15,732 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:04:15 INFO - 2015-10-22 09:04:15,732 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;112;108;112;113;113;113;114;108;113 09:04:15 INFO - 2015-10-22 09:04:15,732 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;138;131;148;160;135;136;138;132;161;136 09:04:15 INFO - 2015-10-22 09:04:15,732 DEBUG : BROWSER_OUTPUT: |2;audio-dft;142;140;147;165;141;139;140;142;141;139 09:04:15 INFO - 2015-10-22 09:04:15,732 DEBUG : BROWSER_OUTPUT: |3;audio-fft;69;72;70;102;75;70;70;72;101;67 09:04:15 INFO - 2015-10-22 09:04:15,732 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;91;112;92;91;91;117;92;92;118 09:04:15 INFO - 2015-10-22 09:04:15,732 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;110;110;111;111;110;111;111;110;110 09:04:15 INFO - 2015-10-22 09:04:15,732 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;131;133;131;131;131;132;131;132;131;131 09:04:15 INFO - 2015-10-22 09:04:15,733 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;97;96;96;97;100;97 09:04:15 INFO - 2015-10-22 09:04:15,733 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;72;73;71;71;72;71;84;72;71 09:04:15 INFO - 2015-10-22 09:04:15,733 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;69;69;69;70;69;69;68;70 09:04:15 INFO - 2015-10-22 09:04:15,733 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;90;91;92;90;91;93;92;92;93;91 09:04:15 INFO - 2015-10-22 09:04:15,733 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;133;125;126;131;126;125;126;124;132;134 09:04:15 INFO - 2015-10-22 09:04:15,733 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;160;158;162;157;161;151;160;161;164;156 09:04:15 INFO - 2015-10-22 09:04:15,733 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;75;74;76;75;76;74;76;74;75;74 09:04:15 INFO - 2015-10-22 09:04:15,733 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:04:15 INFO - 2015-10-22 09:04:15,733 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:04:15 INFO - 2015-10-22 09:04:15,733 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,967 09:04:15 INFO - 2015-10-22 09:04:15,733 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:04:15 INFO - 2015-10-22 09:04:15,733 DEBUG : BROWSER_OUTPUT: __startTimestamp1445529855730__endTimestamp 09:04:15 INFO - 2015-10-22 09:04:15,733 DEBUG : BROWSER_OUTPUT: 09:04:15 INFO - 2015-10-22 09:04:15,734 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:04:15 INFO - 2015-10-22 09:04:15,734 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:04:15 INFO - 2015-10-22 09:04:15,734 DEBUG : BROWSER_OUTPUT: 09:04:15 INFO - 2015-10-22 09:04:15,734 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:2.13 (1.9%) stddev-sans-first:2.22 09:04:15 INFO - 2015-10-22 09:04:15,734 DEBUG : BROWSER_OUTPUT: Values: 113.0 112.0 108.0 112.0 113.0 113.0 113.0 114.0 108.0 113.0 09:04:15 INFO - 2015-10-22 09:04:15,734 DEBUG : BROWSER_OUTPUT: 09:04:15 INFO - 2015-10-22 09:04:15,736 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.50 Median:138.00 stddev:11.02 (8.0%) stddev-sans-first:11.61 09:04:15 INFO - 2015-10-22 09:04:15,736 DEBUG : BROWSER_OUTPUT: Values: 138.0 131.0 148.0 160.0 135.0 136.0 138.0 132.0 161.0 136.0 09:04:15 INFO - 2015-10-22 09:04:15,736 DEBUG : BROWSER_OUTPUT: 09:04:15 INFO - 2015-10-22 09:04:15,736 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:143.60 Median:141.50 stddev:7.86 (5.6%) stddev-sans-first:8.32 09:04:15 INFO - 2015-10-22 09:04:15,736 DEBUG : BROWSER_OUTPUT: Values: 142.0 140.0 147.0 165.0 141.0 139.0 140.0 142.0 141.0 139.0 09:04:15 INFO - 2015-10-22 09:04:15,736 DEBUG : BROWSER_OUTPUT: 09:04:15 INFO - 2015-10-22 09:04:15,736 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:76.80 Median:70.00 stddev:13.19 (18.8%) stddev-sans-first:13.68 09:04:15 INFO - 2015-10-22 09:04:15,736 DEBUG : BROWSER_OUTPUT: Values: 69.0 72.0 70.0 102.0 75.0 70.0 70.0 72.0 101.0 67.0 09:04:15 INFO - 2015-10-22 09:04:15,736 DEBUG : BROWSER_OUTPUT: 09:04:15 INFO - 2015-10-22 09:04:15,736 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:98.80 Median:91.50 stddev:11.75 (12.8%) stddev-sans-first:12.20 09:04:15 INFO - 2015-10-22 09:04:15,736 DEBUG : BROWSER_OUTPUT: Values: 92.0 91.0 112.0 92.0 91.0 91.0 117.0 92.0 92.0 118.0 09:04:15 INFO - 2015-10-22 09:04:15,736 DEBUG : BROWSER_OUTPUT: 09:04:15 INFO - 2015-10-22 09:04:15,736 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.50 Median:111.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 09:04:15 INFO - 2015-10-22 09:04:15,736 DEBUG : BROWSER_OUTPUT: Values: 111.0 110.0 110.0 111.0 111.0 110.0 111.0 111.0 110.0 110.0 09:04:15 INFO - 2015-10-22 09:04:15,736 DEBUG : BROWSER_OUTPUT: 09:04:15 INFO - 2015-10-22 09:04:15,737 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:131.40 Median:131.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 09:04:15 INFO - 2015-10-22 09:04:15,737 DEBUG : BROWSER_OUTPUT: Values: 131.0 133.0 131.0 131.0 131.0 132.0 131.0 132.0 131.0 131.0 09:04:15 INFO - 2015-10-22 09:04:15,737 DEBUG : BROWSER_OUTPUT: 09:04:15 INFO - 2015-10-22 09:04:15,737 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.70 Median:96.00 stddev:1.25 (1.3%) stddev-sans-first:1.30 09:04:15 INFO - 2015-10-22 09:04:15,737 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 97.0 96.0 96.0 97.0 100.0 97.0 09:04:15 INFO - 2015-10-22 09:04:15,737 DEBUG : BROWSER_OUTPUT: 09:04:15 INFO - 2015-10-22 09:04:15,737 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.80 Median:72.00 stddev:3.99 (5.5%) stddev-sans-first:4.18 09:04:15 INFO - 2015-10-22 09:04:15,737 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 73.0 71.0 71.0 72.0 71.0 84.0 72.0 71.0 09:04:15 INFO - 2015-10-22 09:04:15,737 DEBUG : BROWSER_OUTPUT: 09:04:15 INFO - 2015-10-22 09:04:15,737 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 09:04:15 INFO - 2015-10-22 09:04:15,737 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 69.0 69.0 70.0 69.0 69.0 68.0 70.0 09:04:15 INFO - 2015-10-22 09:04:15,737 DEBUG : BROWSER_OUTPUT: 09:04:15 INFO - 2015-10-22 09:04:15,737 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:91.50 Median:92.00 stddev:1.08 (1.2%) stddev-sans-first:1.00 09:04:15 INFO - 2015-10-22 09:04:15,739 DEBUG : BROWSER_OUTPUT: Values: 90.0 91.0 92.0 90.0 91.0 93.0 92.0 92.0 93.0 91.0 09:04:15 INFO - 2015-10-22 09:04:15,739 DEBUG : BROWSER_OUTPUT: 09:04:15 INFO - 2015-10-22 09:04:15,739 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:128.20 Median:128.50 stddev:3.82 (3.0%) stddev-sans-first:3.64 09:04:15 INFO - 2015-10-22 09:04:15,739 DEBUG : BROWSER_OUTPUT: Values: 133.0 125.0 126.0 131.0 126.0 125.0 126.0 124.0 132.0 134.0 09:04:15 INFO - 2015-10-22 09:04:15,739 DEBUG : BROWSER_OUTPUT: 09:04:15 INFO - 2015-10-22 09:04:15,739 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.00 Median:160.50 stddev:3.68 (2.3%) stddev-sans-first:3.89 09:04:15 INFO - 2015-10-22 09:04:15,739 DEBUG : BROWSER_OUTPUT: Values: 160.0 158.0 162.0 157.0 161.0 151.0 160.0 161.0 164.0 156.0 09:04:15 INFO - 2015-10-22 09:04:15,739 DEBUG : BROWSER_OUTPUT: 09:04:15 INFO - 2015-10-22 09:04:15,739 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.90 Median:75.00 stddev:0.88 (1.2%) stddev-sans-first:0.93 09:04:15 INFO - 2015-10-22 09:04:15,740 DEBUG : BROWSER_OUTPUT: Values: 75.0 74.0 76.0 75.0 76.0 74.0 76.0 74.0 75.0 74.0 09:04:15 INFO - 2015-10-22 09:04:15,740 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:04:15 INFO - 2015-10-22 09:04:15,740 DEBUG : BROWSER_OUTPUT: 09:04:16 INFO - 2015-10-22 09:04:16,526 INFO : Browser exited with error code: 0 09:04:17 INFO - 2015-10-22 09:04:17,341 INFO : Completed test kraken (00:01:03) 09:04:17 INFO - 2015-10-22 09:04:17,341 INFO : Starting test v8_7 09:04:17 INFO - 2015-10-22 09:04:17,341 DEBUG : operating with platform_type : w8_ 09:04:17 INFO - 2015-10-22 09:04:17,341 INFO : Initialising browser for v8_7 test... 09:04:17 INFO - 2015-10-22 09:04:17,361 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmp5oha8k\profile http://localhost:49277/getInfo.html 09:04:22 INFO - 2015-10-22 09:04:22,789 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:04:22 INFO - 2015-10-22 09:04:22,789 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:04:22 INFO - 2015-10-22 09:04:22,789 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674 09:04:22 INFO - 2015-10-22 09:04:22,789 DEBUG : BROWSER_OUTPUT: __metrics 09:04:22 INFO - 2015-10-22 09:04:22,973 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:04:23 INFO - 2015-10-22 09:04:23,707 DEBUG : BROWSER_OUTPUT: console.error: 09:04:23 INFO - 2015-10-22 09:04:23,707 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] 09:04:23 INFO - 2015-10-22 09:04:23,707 DEBUG : BROWSER_OUTPUT: Stack: 09:04:23 INFO - 2015-10-22 09:04:23,707 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<._executeStatement@resource://gre/modules/Sqlite.jsm:758:19 09:04:23 INFO - 2015-10-22 09:04:23,707 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached/<@resource://gre/modules/Sqlite.jsm:493:9 09:04:23 INFO - 2015-10-22 09:04:23,707 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached@resource://gre/modules/Sqlite.jsm:491:1 09:04:23 INFO - 2015-10-22 09:04:23,707 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeBeforeShutdown/loggedDb<.executeCached.value<@resource://gre/modules/Sqlite.jsm:368:51 09:04:23 INFO - 2015-10-22 09:04:23,707 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 09:04:23 INFO - 2015-10-22 09:04:23,707 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 09:04:23 INFO - 2015-10-22 09:04:23,707 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 09:04:23 INFO - 2015-10-22 09:04:23,707 DEBUG : BROWSER_OUTPUT: transaction@resource://gre/modules/Bookmarks.jsm:783:15 09:04:23 INFO - 2015-10-22 09:04:23,707 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 09:04:23 INFO - 2015-10-22 09:04:23,707 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 09:04:23 INFO - 2015-10-22 09:04:23,707 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 09:04:23 INFO - 2015-10-22 09:04:23,707 DEBUG : BROWSER_OUTPUT: Task_spawn@resource://gre/modules/Task.jsm:164:12 09:04:23 INFO - 2015-10-22 09:04:23,707 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promisedromaeo_css: 6209.90 09:04:59 INFO - RETURN: kraken: 1506.70 09:04:59 INFO - RETURN: v8_7: 19981.46 09:04:59 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,131,31]]", "result": "19981.46"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,131,31]]", "result": "1506.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,131,31]]", "result": "6209.90"}}} 09:04:59 INFO - Return code: 0 09:04:59 INFO - # TBPL SUCCESS # 09:04:59 INFO - Running post-action listener: _resource_record_post_action 09:04:59 INFO - Running post-run listener: _resource_record_post_run 09:05:01 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 155704320; Write bytes: 397443584; Read time: 1707140; Write time: 4377710 09:05:01 INFO - install - Wall time: 2s; CPU: 13.0%; Read bytes: 0; Write bytes: 300544; Read time: 0; Write time: 630 09:05:01 INFO - run-tests - Wall time: 1229s; CPU: 13.0%; Read bytes: 155704320; Write bytes: 357041152; Read time: 1707140; Write time: 4325480 09:05:01 INFO - Running post-run listener: _upload_blobber_files 09:05:01 INFO - Blob upload gear active. 09:05:01 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:05:01 INFO - Copying logs to upload dir... 09:05:01 INFO - mkdir: C:\slave\test\build\upload\logs program finished with exit code 0 elapsedTime=1391.568000 ========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 19 secs) (at 2015-10-22 09:05:09.702653) ========= ========= Started set props: build_url (results: 0, elapsed: 1 secs) (at 2015-10-22 09:05:09.705774) ========= '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-053\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-053 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-053 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-053\AppData\Local LOGONSERVER=\\T-W864-IX-053 MONDIR=C:\Monitor_config\ MOZBUILDDIR=C:\mozilla-build\ MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 NUMBER_OF_PROCESSORS=8 OS=Windows_NT OURDRIVE=C: PATH=C:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;C:\mozilla-build\hg PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_ARCHITEW6432=AMD64 PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=C:\Program Files (x86) PROGRAMFILES(X86)=C:\Program Files (x86) PROGRAMW6432=C:\Program Files PROMPT=$P$G PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\ PUBLIC=C:\Users\Public PWD=C:\slave\test\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-053 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-053 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-053 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False build_url:https://queue.taskcluster.net/v1/task/IaBnchbXQQ27ne5ObcmwUA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip program finished with exit code 0 elapsedTime=0.101000 build_url: 'https://queue.taskcluster.net/v1/task/IaBnchbXQQ27ne5ObcmwUA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip' ========= Finished set props: build_url (results: 0, elapsed: 1 secs) (at 2015-10-22 09:05:10.794031) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 28 secs) (at 2015-10-22 09:05:10.794384) ========= '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-053\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-053 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-053 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-053\AppData\Local LOGONSERVER=\\T-W864-IX-053 MONDIR=C:\Monitor_config\ MOZBUILDDIR=C:\mozilla-build\ MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 NUMBER_OF_PROCESSORS=8 OS=Windows_NT OURDRIVE=C: PATH=C:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;C:\mozilla-build\hg PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_ARCHITEW6432=AMD64 PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=C:\Program Files (x86) PROGRAMFILES(X86)=C:\Program Files (x86) PROGRAMW6432=C:\Program Files PROMPT=$P$G PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\ PUBLIC=C:\Users\Public PWD=C:\slave\test 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-053 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-053 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-053 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=0.102000 ========= Finished 'rm -f ...' (results: 0, elapsed: 28 secs) (at 2015-10-22 09:05:38.892842) ========= ========= Started reboot slave lost (results: 0, elapsed: 10 secs) (at 2015-10-22 09:05:38.893195) ========= ========= Finished reboot slave lost (results: 0, elapsed: 10 secs) (at 2015-10-22 09:05:49.106072) =========