builder: mozilla-inbound_win8_64_test-dromaeojs slave: t-w864-ix-084 starttime: 1445527615.87 results: success (0) buildid: 20151022064307 builduid: 0d583757ab1d481d81f5e656e35e3faa revision: d43d4d4e26fbb3f9a2217a53bb61cfab1828f6dc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-22 08:26:55.871558) ========= master: http://buildbot-master111.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-22 08:26:55.873220) ========= ========= Started set props: basedir (results: 0, elapsed: 16 secs) (at 2015-10-22 08:26:55.873514) ========= 'cd' in dir C:\slave\test\. (timeout 1200 secs) watching logfiles {} argv: ['cd'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-084\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-084 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-084 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-084\AppData\Local LOGONSERVER=\\T-W864-IX-084 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-084 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-084 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-084 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False C:\slave\test program finished with exit code 0 elapsedTime=1.117000 basedir: 'C:\\slave\\test' ========= Finished set props: basedir (results: 0, elapsed: 16 secs) (at 2015-10-22 08:27:12.386636) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 3 secs) (at 2015-10-22 08:27:12.387013) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 3 secs) (at 2015-10-22 08:27:16.078881) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-22 08:27:16.079129) ========= '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-084\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-084 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-084 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-084\AppData\Local LOGONSERVER=\\T-W864-IX-084 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-084 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-084 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-084 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=0.303000 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-22 08:27:16.409795) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-22 08:27:16.410124) ========= 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:27:16.410836) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-10-22 08:27:16.411109) ========= '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-084\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-084 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-084 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-084\AppData\Local LOGONSERVER=\\T-W864-IX-084 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-084 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-084 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-084 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False --08:27:16-- 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.10 GB/s 08:27:17 (2.10 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=1.000000 ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-10-22 08:27:17.551815) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 7 secs) (at 2015-10-22 08:27:17.552138) ========= '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-084\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-084 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-084 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-084\AppData\Local LOGONSERVER=\\T-W864-IX-084 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-084 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-084 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-084 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=4.112000 ========= Finished 'rm -rf ...' (results: 0, elapsed: 7 secs) (at 2015-10-22 08:27:25.491917) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-10-22 08:27:25.492235) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d43d4d4e26fbb3f9a2217a53bb61cfab1828f6dc --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 d43d4d4e26fbb3f9a2217a53bb61cfab1828f6dc --destination scripts --debug'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-084\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-084 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-084 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-084\AppData\Local LOGONSERVER=\\T-W864-IX-084 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-084 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-084 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-084 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 2015-10-22 08:27:25,993 truncating revision to first 12 chars 2015-10-22 08:27:25,994 Setting DEBUG logging. 2015-10-22 08:27:25,994 attempt 1/10 2015-10-22 08:27:25,994 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/d43d4d4e26fb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-10-22 08:27:26,786 unpacking tar archive at: mozilla-inbound-d43d4d4e26fb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.983000 ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-10-22 08:27:27.574500) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-22 08:27:27.574805) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-22 08:27:27.688186) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-22 08:27:27.688590) ========= 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:27:27.689329) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 24 mins, 40 secs) (at 2015-10-22 08:27:27.689624) ========= '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-084\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-084 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-084 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-084\AppData\Local LOGONSERVER=\\T-W864-IX-084 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-084 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-084 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-084 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 08:27:28 INFO - MultiFileLogger online at 20151022 08:27:28 in C:\slave\test 08:27:28 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:27:28 INFO - Dumping config to C:\slave\test\logs\localconfig.json. 08:27:28 INFO - {'append_to_log': False, 08:27:28 INFO - 'base_work_dir': 'C:\\slave\\test', 08:27:28 INFO - 'blob_upload_branch': 'Mozilla-Inbound-Non-PGO', 08:27:28 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt', 08:27:28 INFO - 'branch': 'Mozilla-Inbound-Non-PGO', 08:27:28 INFO - 'buildbot_json_path': 'buildprops.json', 08:27:28 INFO - 'config_files': ('talos/windows_config.py',), 08:27:28 INFO - 'default_actions': ('clobber', 08:27:28 INFO - 'read-buildbot-config', 08:27:28 INFO - 'download-and-extract', 08:27:28 INFO - 'populate-webroot', 08:27:28 INFO - 'create-virtualenv', 08:27:28 INFO - 'install', 08:27:28 INFO - 'run-tests'), 08:27:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:27:28 INFO - 'download_minidump_stackwalk': True, 08:27:28 INFO - 'download_symbols': 'ondemand', 08:27:28 INFO - 'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python', 08:27:28 INFO - 'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'), 08:27:28 INFO - 'hg': 'c:/mozilla-build/hg/hg', 08:27:28 INFO - 'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python', 08:27:28 INFO - 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'), 08:27:28 INFO - 'python': 'c:/mozilla-build/python27/python.exe', 08:27:28 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe', 08:27:28 INFO - 'C:/mozilla-build/tooltool.py'), 08:27:28 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe', 08:27:28 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 08:27:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:27:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:27:28 INFO - 'installer_path': 'installer.exe', 08:27:28 INFO - 'log_level': 'info', 08:27:28 INFO - 'log_name': 'talos', 08:27:28 INFO - 'log_to_console': True, 08:27:28 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe', 08:27:28 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe', 08:27:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest', 08:27:28 INFO - 'opt_config_files': (), 08:27:28 INFO - 'pip_index': False, 08:27:28 INFO - 'sps_profile': False, 08:27:28 INFO - 'sps_profile_interval': 0, 08:27:28 INFO - 'suite': 'dromaeojs', 08:27:28 INFO - 'system_bits': '64', 08:27:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:27:28 INFO - 'title': 'T-W864-IX-084', 08:27:28 INFO - 'use_talos_json': True, 08:27:28 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'), 08:27:28 INFO - 'virtualenv_path': 'C:\\slave\\test\\build/venv', 08:27:28 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll', 08:27:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:27:28 INFO - 'work_dir': 'build'} 08:27:28 INFO - ##### 08:27:28 INFO - ##### Running clobber step. 08:27:28 INFO - ##### 08:27:28 INFO - Running pre-action listener: _resource_record_pre_action 08:27:28 INFO - Running main action method: clobber 08:27:28 INFO - rmtree: C:\slave\test\build 08:27:28 INFO - Using _rmtree_windows ... 08:27:28 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1 08:29:36 INFO - Running post-action listener: _resource_record_post_action 08:29:36 INFO - ##### 08:29:36 INFO - ##### Running read-buildbot-config step. 08:29:36 INFO - ##### 08:29:36 INFO - Running pre-action listener: _resource_record_pre_action 08:29:36 INFO - Running main action method: read_buildbot_config 08:29:36 INFO - Using buildbot properties: 08:29:36 INFO - { 08:29:36 INFO - "properties": { 08:29:36 INFO - "buildnumber": 2051, 08:29:36 INFO - "product": "firefox", 08:29:36 INFO - "script_repo_revision": "production", 08:29:36 INFO - "builddir": "mozilla-inbound_win8_64_test-dromaeojs", 08:29:36 INFO - "repository": "", 08:29:36 INFO - "buildername": "Windows 8 64-bit mozilla-inbound talos dromaeojs", 08:29:36 INFO - "buildid": "20151022064307", 08:29:36 INFO - "slavename": "t-w864-ix-084", 08:29:36 INFO - "pgo_build": "False", 08:29:36 INFO - "basedir": "C:\\slave\\test", 08:29:36 INFO - "project": "", 08:29:36 INFO - "platform": "win8_64", 08:29:36 INFO - "master": "http://buildbot-master111.bb.releng.scl3.mozilla.com:8201/", 08:29:36 INFO - "slavebuilddir": "test", 08:29:36 INFO - "scheduler": "tests-mozilla-inbound-win64-talos", 08:29:36 INFO - "branch": "mozilla-inbound", 08:29:36 INFO - "repo_path": "integration/mozilla-inbound", 08:29:36 INFO - "stage_platform": "win64", 08:29:36 INFO - "builduid": "0d583757ab1d481d81f5e656e35e3faa", 08:29:36 INFO - "revision": "d43d4d4e26fbb3f9a2217a53bb61cfab1828f6dc" 08:29:36 INFO - }, 08:29:36 INFO - "sourcestamp": { 08:29:36 INFO - "repository": "", 08:29:36 INFO - "hasPatch": false, 08:29:36 INFO - "project": "", 08:29:36 INFO - "branch": "mozilla-inbound-win64-talos", 08:29:36 INFO - "changes": [ 08:29:36 INFO - { 08:29:36 INFO - "category": null, 08:29:36 INFO - "files": [ 08:29:36 INFO - { 08:29:36 INFO - "url": null, 08:29:36 INFO - "name": "https://queue.taskcluster.net/v1/task/so8Tf66mTB2gjrLUJ4Ji5w/artifacts/public/build/firefox-44.0a1.en-US.win64.zip" 08:29:36 INFO - } 08:29:36 INFO - ], 08:29:36 INFO - "repository": "", 08:29:36 INFO - "rev": "01c1f46069567aa2477b4fe70b24fbf14c6f3459", 08:29:36 INFO - "who": "josh@joshmatthews.net", 08:29:36 INFO - "when": 1445526805, 08:29:36 INFO - "number": 6560183, 08:29:36 INFO - "comments": "Bug 1173811 - Part 2: Propagate the response URL to intercepted channels when necessary (e10s). r=mayhemer,bkelly", 08:29:36 INFO - "project": "", 08:29:36 INFO - "at": "Thu 22 Oct 2015 08:13:25", 08:29:36 INFO - "branch": "mozilla-inbound-win64-talos", 08:29:36 INFO - "revlink": "", 08:29:36 INFO - "properties": [ 08:29:36 INFO - [ 08:29:36 INFO - "buildid", 08:29:36 INFO - "20151022062458", 08:29:36 INFO - "Change" 08:29:36 INFO - ], 08:29:36 INFO - [ 08:29:36 INFO - "builduid", 08:29:36 INFO - "1533e9543f3340eb9f028ce5c77cc169", 08:29:36 INFO - "Change" 08:29:36 INFO - ], 08:29:36 INFO - [ 08:29:36 INFO - "pgo_build", 08:29:36 INFO - "False", 08:29:37 INFO - "Change" 08:29:37 INFO - ] 08:29:37 INFO - ], 08:29:37 INFO - "revision": "01c1f46069567aa2477b4fe70b24fbf14c6f3459" 08:29:37 INFO - }, 08:29:37 INFO - { 08:29:37 INFO - "category": null, 08:29:37 INFO - "files": [ 08:29:37 INFO - { 08:29:37 INFO - "url": null, 08:29:37 INFO - "name": "https://queue.taskcluster.net/v1/task/HtB_sZClS8uOWjcyyeoKSg/artifacts/public/build/firefox-44.0a1.en-US.win64.zip" 08:29:37 INFO - } 08:29:37 INFO - ], 08:29:37 INFO - "repository": "", 08:29:37 INFO - "rev": "d43d4d4e26fbb3f9a2217a53bb61cfab1828f6dc", 08:29:37 INFO - "who": "dmitchell@mozilla.com", 08:29:37 INFO - "when": 1445526773, 08:29:37 INFO - "number": 6560179, 08:29:37 INFO - "comments": "Bug 1214809: use 'sudo' instead of 'su' to drop root privs; r=ted", 08:29:37 INFO - "project": "", 08:29:37 INFO - "at": "Thu 22 Oct 2015 08:12:53", 08:29:37 INFO - "branch": "mozilla-inbound-win64-talos", 08:29:37 INFO - "revlink": "", 08:29:37 INFO - "properties": [ 08:29:37 INFO - [ 08:29:37 INFO - "buildid", 08:29:37 INFO - "20151022064307", 08:29:37 INFO - "Change" 08:29:37 INFO - ], 08:29:37 INFO - [ 08:29:37 INFO - "builduid", 08:29:37 INFO - "0d583757ab1d481d81f5e656e35e3faa", 08:29:37 INFO - "Change" 08:29:37 INFO - ], 08:29:37 INFO - [ 08:29:37 INFO - "pgo_build", 08:29:37 INFO - "False", 08:29:37 INFO - "Change" 08:29:37 INFO - ] 08:29:37 INFO - ], 08:29:37 INFO - "revision": "d43d4d4e26fbb3f9a2217a53bb61cfab1828f6dc" 08:29:37 INFO - } 08:29:37 INFO - ], 08:29:37 INFO - "revision": "d43d4d4e26fbb3f9a2217a53bb61cfab1828f6dc" 08:29:37 INFO - } 08:29:37 INFO - } 08:29:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/HtB_sZClS8uOWjcyyeoKSg/artifacts/public/build/firefox-44.0a1.en-US.win64.zip. 08:29:37 INFO - Running post-action listener: _resource_record_post_action 08:29:37 INFO - ##### 08:29:37 INFO - ##### Running download-and-extract step. 08:29:37 INFO - ##### 08:29:37 INFO - Running pre-action listener: _resource_record_pre_action 08:29:37 INFO - Running main action method: download_and_extract 08:29:37 INFO - mkdir: C:\slave\test\build\tests 08:29: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:29:37 INFO - https://queue.taskcluster.net/v1/task/HtB_sZClS8uOWjcyyeoKSg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:29:37 INFO - trying https://queue.taskcluster.net/v1/task/HtB_sZClS8uOWjcyyeoKSg/artifacts/public/build/test_packages.json 08:29:37 INFO - Downloading https://queue.taskcluster.net/v1/task/HtB_sZClS8uOWjcyyeoKSg/artifacts/public/build/test_packages.json to C:\slave\test\build\test_packages.json 08:29:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HtB_sZClS8uOWjcyyeoKSg/artifacts/public/build/test_packages.json', 'file_name': 'C:\\slave\\test\\build\\test_packages.json'}, attempt #1 08:29:37 INFO - Downloaded 1221 bytes. 08:29:37 INFO - Reading from file C:\slave\test\build\test_packages.json 08:29:37 INFO - Using the following test package requirements: 08:29:37 INFO - {u'common': [u'firefox-44.0a1.en-US.win64.common.tests.zip'], 08:29:37 INFO - u'cppunittest': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 08:29:37 INFO - u'firefox-44.0a1.en-US.win64.cppunittest.tests.zip'], 08:29:37 INFO - u'jittest': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 08:29:37 INFO - u'jsshell-win64.zip'], 08:29:37 INFO - u'mochitest': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 08:29:37 INFO - u'firefox-44.0a1.en-US.win64.mochitest.tests.zip'], 08:29:37 INFO - u'mozbase': [u'firefox-44.0a1.en-US.win64.common.tests.zip'], 08:29:37 INFO - u'reftest': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 08:29:37 INFO - u'firefox-44.0a1.en-US.win64.reftest.tests.zip'], 08:29:37 INFO - u'talos': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 08:29:37 INFO - u'firefox-44.0a1.en-US.win64.talos.tests.zip'], 08:29:37 INFO - u'web-platform': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 08:29:37 INFO - u'firefox-44.0a1.en-US.win64.web-platform.tests.zip'], 08:29:37 INFO - u'webapprt': [u'firefox-44.0a1.en-US.win64.common.tests.zip'], 08:29:37 INFO - u'xpcshell': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 08:29:37 INFO - u'firefox-44.0a1.en-US.win64.xpcshell.tests.zip']} 08:29:37 INFO - Downloading packages: [u'firefox-44.0a1.en-US.win64.common.tests.zip'] for test suite category: common 08:29: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:29:37 INFO - https://queue.taskcluster.net/v1/task/HtB_sZClS8uOWjcyyeoKSg/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip matches https://queue.taskcluster.net 08:29:37 INFO - trying https://queue.taskcluster.net/v1/task/HtB_sZClS8uOWjcyyeoKSg/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip 08:29:37 INFO - Downloading https://queue.taskcluster.net/v1/task/HtB_sZClS8uOWjcyyeoKSg/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:29:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HtB_sZClS8uOWjcyyeoKSg/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:29:39 INFO - Downloaded 18100684 bytes. 08:29:39 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:29:39 INFO - Copy/paste: unzip -q -o C:\slave\test\build\firefox-44.0a1.en-US.win64.common.tests.zip 08:29:39 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:30:11 INFO - Return code: 0 08:30:11 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:30:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:30:11 INFO - https://queue.taskcluster.net/v1/task/HtB_sZClS8uOWjcyyeoKSg/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip matches https://queue.taskcluster.net 08:30:11 INFO - trying https://queue.taskcluster.net/v1/task/HtB_sZClS8uOWjcyyeoKSg/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip 08:30:11 INFO - Downloading https://queue.taskcluster.net/v1/task/HtB_sZClS8uOWjcyyeoKSg/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:30:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HtB_sZClS8uOWjcyyeoKSg/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:30:13 INFO - Downloaded 18100684 bytes. 08:30:13 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:30:13 INFO - Copy/paste: unzip -q -o C:\slave\test\build\firefox-44.0a1.en-US.win64.common.tests.zip 08:30:13 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:30:36 INFO - Return code: 0 08:30:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:30:36 INFO - https://queue.taskcluster.net/v1/task/HtB_sZClS8uOWjcyyeoKSg/artifacts/public/build/firefox-44.0a1.en-US.win64.talos.tests.zip matches https://queue.taskcluster.net 08:30:36 INFO - trying https://queue.taskcluster.net/v1/task/HtB_sZClS8uOWjcyyeoKSg/artifacts/public/build/firefox-44.0a1.en-US.win64.talos.tests.zip 08:30:36 INFO - Downloading https://queue.taskcluster.net/v1/task/HtB_sZClS8uOWjcyyeoKSg/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:30:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HtB_sZClS8uOWjcyyeoKSg/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:30:37 INFO - Downloaded 11131307 bytes. 08:30:37 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:30:37 INFO - Copy/paste: unzip -q -o C:\slave\test\build\firefox-44.0a1.en-US.win64.talos.tests.zip 08:30:37 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:30:37 INFO - Return code: 0 08:30: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:30:37 INFO - https://queue.taskcluster.net/v1/task/HtB_sZClS8uOWjcyyeoKSg/artifacts/public/build/firefox-44.0a1.en-US.win64.zip matches https://queue.taskcluster.net 08:30:37 INFO - trying https://queue.taskcluster.net/v1/task/HtB_sZClS8uOWjcyyeoKSg/artifacts/public/build/firefox-44.0a1.en-US.win64.zip 08:30:37 INFO - Downloading https://queue.taskcluster.net/v1/task/HtB_sZClS8uOWjcyyeoKSg/artifacts/public/build/firefox-44.0a1.en-US.win64.zip to C:\slave\test\build\firefox-44.0a1.en-US.win64.zip 08:30:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HtB_sZClS8uOWjcyyeoKSg/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:30:41 INFO - Downloaded 54763021 bytes. 08:30:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HtB_sZClS8uOWjcyyeoKSg/artifacts/public/build/firefox-44.0a1.en-US.win64.zip 08:30:41 INFO - mkdir: C:\slave\test\properties 08:30:41 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url 08:30:41 INFO - Writing to file C:\slave\test\properties\build_url 08:30:41 INFO - Contents: 08:30:41 INFO - build_url:https://queue.taskcluster.net/v1/task/HtB_sZClS8uOWjcyyeoKSg/artifacts/public/build/firefox-44.0a1.en-US.win64.zip 08:30:41 INFO - Running post-action listener: _resource_record_post_action 08:30:41 INFO - Running post-action listener: set_extra_try_arguments 08:30:41 INFO - ##### 08:30:41 INFO - ##### Running populate-webroot step. 08:30:41 INFO - ##### 08:30:41 INFO - Running pre-action listener: _resource_record_pre_action 08:30:41 INFO - Running main action method: populate_webroot 08:30:41 INFO - Guessing talos json url... 08:30: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:30:41 INFO - https://queue.taskcluster.net/v1/task/HtB_sZClS8uOWjcyyeoKSg/artifacts/public/build/firefox-44.0a1.en-US.win64.txt matches https://queue.taskcluster.net 08:30:41 INFO - trying https://queue.taskcluster.net/v1/task/HtB_sZClS8uOWjcyyeoKSg/artifacts/public/build/firefox-44.0a1.en-US.win64.txt 08:30:41 INFO - Downloading https://queue.taskcluster.net/v1/task/HtB_sZClS8uOWjcyyeoKSg/artifacts/public/build/firefox-44.0a1.en-US.win64.txt to C:\slave\test\build\firefox-44.0a1.en-US.win64.txt 08:30:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HtB_sZClS8uOWjcyyeoKSg/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:30:42 INFO - Downloaded 111 bytes. 08:30:42 INFO - Reading from file C:\slave\test\build\firefox-44.0a1.en-US.win64.txt 08:30:42 INFO - Contents: 08:30:42 INFO - 20151022064307 08:30:42 INFO - https://hg.mozilla.org/integration/mozilla-inbound/rev/d43d4d4e26fbb3f9a2217a53bb61cfab1828f6dc 08:30:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:30:42 INFO - trying https://hg.mozilla.org/integration/mozilla-inbound/raw-file/d43d4d4e26/testing/talos/talos.json 08:30:42 INFO - Downloading https://hg.mozilla.org/integration/mozilla-inbound/raw-file/d43d4d4e26/testing/talos/talos.json to C:\slave\test\build\talos.json 08:30:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/mozilla-inbound/raw-file/d43d4d4e26/testing/talos/talos.json', 'file_name': 'C:\\slave\\test\\build\\talos.json'}, attempt #1 08:30:43 INFO - Downloaded 4264 bytes. 08:30:43 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']}, 08:30:43 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']}, 08:30:43 INFO - u'remote-trobocheck2': {u'talos_options': [u'--fennecIDs', 08:30:43 INFO - u'../fennec_ids.txt'], 08:30:43 INFO - u'tests': [u'tcheck2']}, 08:30:43 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome', 08:30:43 INFO - u'--tppagecycles', 08:30:43 INFO - u'7'], 08:30:43 INFO - u'tests': [u'tsvgm']}}, 08:30:43 INFO - u'suites': {u'chromez': {u'tests': [u'tresize', u'tcanvasmark']}, 08:30:43 INFO - u'chromez-e10s': {u'talos_options': [u'--e10s'], 08:30:43 INFO - u'tests': [u'tresize', u'tcanvasmark']}, 08:30:43 INFO - u'dromaeojs': {u'tests': [u'dromaeo_css', u'kraken', u'v8_7']}, 08:30:43 INFO - u'dromaeojs-e10s': {u'talos_options': [u'--e10s'], 08:30:43 INFO - u'tests': [u'dromaeo_css', 08:30:43 INFO - u'kraken', 08:30:43 INFO - u'v8_7']}, 08:30:43 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:30:43 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 08:30:43 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:30:43 INFO - u'talos_options': [u'--e10s'], 08:30:43 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 08:30:43 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:30:43 INFO - u'tests': [u'damp', u'tps']}, 08:30:43 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:30:43 INFO - u'talos_options': [u'--e10s'], 08:30:43 INFO - u'tests': [u'damp', u'tps']}, 08:30:43 INFO - u'g3': {u'tests': [u'dromaeo_dom']}, 08:30:43 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']}, 08:30:43 INFO - u'other': {u'tests': [u'a11yr', 08:30:43 INFO - u'ts_paint', 08:30:43 INFO - u'tpaint', 08:30:43 INFO - u'sessionrestore', 08:30:43 INFO - u'sessionrestore_no_auto_restore']}, 08:30:43 INFO - u'other-e10s': {u'talos_options': [u'--e10s'], 08:30:43 INFO - u'tests': [u'a11yr', 08:30:43 INFO - u'ts_paint', 08:30:43 INFO - u'tpaint', 08:30:43 INFO - u'sessionrestore', 08:30:43 INFO - u'sessionrestore_no_auto_restore']}, 08:30:43 INFO - u'other-e10s_l64': {u'talos_options': [u'--e10s'], 08:30:43 INFO - u'tests': [u'a11yr', 08:30:43 INFO - u'ts_paint', 08:30:43 INFO - u'tpaint', 08:30:43 INFO - u'sessionrestore', 08:30:43 INFO - u'sessionrestore_no_auto_restore']}, 08:30:43 INFO - u'other-e10s_nol64': {u'talos_options': [u'--e10s'], 08:30:43 INFO - u'tests': [u'a11yr', 08:30:43 INFO - u'ts_paint', 08:30:43 INFO - u'tpaint', 08:30:43 INFO - u'sessionrestore', 08:30:43 INFO - u'sessionrestore_no_auto_restore']}, 08:30:43 INFO - u'other_l64': {u'tests': [u'a11yr', 08:30:43 INFO - u'ts_paint', 08:30:43 INFO - u'tpaint', 08:30:43 INFO - u'sessionrestore', 08:30:43 INFO - u'sessionrestore_no_auto_restore']}, 08:30:43 INFO - u'other_nol64': {u'tests': [u'a11yr', 08:30:43 INFO - u'ts_paint', 08:30:43 INFO - u'tpaint', 08:30:43 INFO - u'sessionrestore', 08:30:43 INFO - u'sessionrestore_no_auto_restore']}, 08:30:43 INFO - u'svgr': {u'tests': [u'tsvgx', 08:30:43 INFO - u'tsvgr_opacity', 08:30:43 INFO - u'tart', 08:30:43 INFO - u'tscrollx', 08:30:43 INFO - u'cart']}, 08:30:43 INFO - u'svgr-e10s': {u'talos_options': [u'--e10s'], 08:30:43 INFO - u'tests': [u'tsvgx', 08:30:43 INFO - u'tsvgr_opacity', 08:30:43 INFO - u'tart', 08:30:43 INFO - u'tscrollx', 08:30:43 INFO - u'cart']}, 08:30:43 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:30:43 INFO - u'tests': [u'tp5o']}, 08:30:43 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:30:43 INFO - u'talos_options': [u'--e10s'], 08:30:43 INFO - u'tests': [u'tp5o']}, 08:30:43 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:30:43 INFO - u'talos_options': [u'--xperf_path', 08:30:43 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:30:43 INFO - u'tests': [u'tp5n']}, 08:30:43 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:30:43 INFO - u'talos_options': [u'--e10s', 08:30:43 INFO - u'--xperf_path', 08:30:43 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 08:30:43 INFO - u'C:/slave/talos-data/talos/xperf.config'], 08:30:43 INFO - u'tests': [u'tp5n']}}, 08:30:43 INFO - u'talos.zip': {u'path': u'', 08:30:43 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:30:43 INFO - Running post-action listener: _resource_record_post_action 08:30:43 INFO - ##### 08:30:43 INFO - ##### Running create-virtualenv step. 08:30:43 INFO - ##### 08:30:43 INFO - Running pre-action listener: _resource_record_pre_action 08:30:43 INFO - Running main action method: create_virtualenv 08:30:43 INFO - Creating virtualenv C:\slave\test\build/venv 08:30:43 INFO - mkdir: C:\slave\test\build\venv\Scripts 08:30:43 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll 08:30:43 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:30:43 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:30:43 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:30:50 INFO - New python executable in C:\slave\test\build/venv\Scripts\python.exe 08:30:55 INFO - Installing distribute......................................................................................................................................................................................done. 08:30:57 INFO - Return code: 0 08:30:57 INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv 08:30:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:30:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:57 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '--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 0x02372B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0232DEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02449060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01D68B48>, '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 0x01D8A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02813660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-084', 'USERDOMAIN': 'T-W864-IX-084', '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-084', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-084', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-084', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-084', '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-084\\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:30:57 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:30:57 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:30:57 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 08:30:57 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Roaming', 08:30:57 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 08:30:57 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 08:30:57 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 08:30:57 INFO - 'COMPUTERNAME': 'T-W864-IX-084', 08:30:57 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 08:30:57 INFO - 'DCLOCATION': 'SCL3', 08:30:57 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 08:30:57 INFO - 'FP_NO_HOST_CHECK': 'NO', 08:30:57 INFO - 'HOMEDRIVE': 'C:', 08:30:57 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-084', 08:30:57 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 08:30:57 INFO - 'KTS_VERSION': '1.19c', 08:30:57 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Local', 08:30:57 INFO - 'LOGONSERVER': '\\\\T-W864-IX-084', 08:30:57 INFO - 'MONDIR': 'C:\\Monitor_config\\', 08:30:57 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 08:30:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:57 INFO - 'MOZ_NO_REMOTE': '1', 08:30:57 INFO - 'NO_EM_RESTART': '1', 08:30:57 INFO - 'NUMBER_OF_PROCESSORS': '8', 08:30:57 INFO - 'OS': 'Windows_NT', 08:30:57 INFO - 'OURDRIVE': 'C:', 08:30:57 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 08:30:57 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 08:30:57 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 08:30:57 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 08:30:57 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 08:30:57 INFO - 'PROCESSOR_LEVEL': '6', 08:30:57 INFO - 'PROCESSOR_REVISION': '1e05', 08:30:57 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 08:30:57 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 08:30:57 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 08:30:57 INFO - 'PROGRAMW6432': 'C:\\Program Files', 08:30:57 INFO - 'PROMPT': '$P$G', 08:30:57 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 08:30:57 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 08:30:57 INFO - 'PUBLIC': 'C:\\Users\\Public', 08:30:57 INFO - 'PWD': 'C:\\slave\\test', 08:30:57 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 08:30:57 INFO - 'SLAVEDIR': 'C:\\slave\\', 08:30:57 INFO - 'SYSTEMDRIVE': 'C:', 08:30:57 INFO - 'SYSTEMROOT': 'C:\\windows', 08:30:57 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:30:57 INFO - 'TEST1': 'testie', 08:30:57 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:30:57 INFO - 'USERDOMAIN': 'T-W864-IX-084', 08:30:57 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-084', 08:30:57 INFO - 'USERNAME': 'cltbld', 08:30:57 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-084', 08:30:57 INFO - 'WINDIR': 'C:\\windows', 08:30:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 08:30:59 INFO - Ignoring indexes: http://pypi.python.org/simple/ 08:30:59 INFO - Downloading/unpacking pip>=1.5 08:30:59 INFO - Creating supposed download cache at C:\slave\test\build/venv\cache 08:31:05 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:31:05 INFO - Running setup.py egg_info for package pip 08:31:05 INFO - warning: no files found matching 'pip\cacert.pem' 08:31:05 INFO - warning: no files found matching '*.html' under directory 'docs' 08:31:05 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 08:31:05 INFO - no previously-included directories found matching 'docs\_build\_sources' 08:31:05 INFO - Installing collected packages: pip 08:31:05 INFO - Found existing installation: pip 0.8.2 08:31:05 INFO - Uninstalling pip: 08:31:05 INFO - Successfully uninstalled pip 08:31:05 INFO - Running setup.py install for pip 08:31:05 INFO - warning: no files found matching 'pip\cacert.pem' 08:31:05 INFO - warning: no files found matching '*.html' under directory 'docs' 08:31:05 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 08:31:05 INFO - no previously-included directories found matching 'docs\_build\_sources' 08:31:05 INFO - Installing pip-script.py script to C:\slave\test\build\venv\Scripts 08:31:05 INFO - Installing pip.exe script to C:\slave\test\build\venv\Scripts 08:31:05 INFO - Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts 08:31:05 INFO - Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts 08:31:05 INFO - Installing pip2-script.py script to C:\slave\test\build\venv\Scripts 08:31:05 INFO - Installing pip2.exe script to C:\slave\test\build\venv\Scripts 08:31:05 INFO - Successfully installed pip 08:31:05 INFO - Cleaning up... 08:31:05 INFO - Return code: 0 08:31:05 INFO - Installing psutil>=0.7.1 into virtualenv C:\slave\test\build/venv 08:31:05 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:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:05 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:31:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:05 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 0x02372B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0232DEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02449060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01D68B48>, '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 0x01D8A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02813660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-084', 'USERDOMAIN': 'T-W864-IX-084', '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-084', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-084', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-084', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-084', '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-084\\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:31:05 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:31:05 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:31:05 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 08:31:05 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Roaming', 08:31:05 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 08:31:05 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 08:31:05 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 08:31:05 INFO - 'COMPUTERNAME': 'T-W864-IX-084', 08:31:05 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 08:31:05 INFO - 'DCLOCATION': 'SCL3', 08:31:05 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 08:31:05 INFO - 'FP_NO_HOST_CHECK': 'NO', 08:31:05 INFO - 'HOMEDRIVE': 'C:', 08:31:05 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-084', 08:31:05 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 08:31:05 INFO - 'KTS_VERSION': '1.19c', 08:31:05 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Local', 08:31:05 INFO - 'LOGONSERVER': '\\\\T-W864-IX-084', 08:31:05 INFO - 'MONDIR': 'C:\\Monitor_config\\', 08:31:05 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 08:31:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:05 INFO - 'MOZ_NO_REMOTE': '1', 08:31:05 INFO - 'NO_EM_RESTART': '1', 08:31:05 INFO - 'NUMBER_OF_PROCESSORS': '8', 08:31:05 INFO - 'OS': 'Windows_NT', 08:31:05 INFO - 'OURDRIVE': 'C:', 08:31:05 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:31:05 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 08:31:05 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 08:31:05 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 08:31:05 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 08:31:05 INFO - 'PROCESSOR_LEVEL': '6', 08:31:05 INFO - 'PROCESSOR_REVISION': '1e05', 08:31:05 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 08:31:05 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 08:31:05 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 08:31:05 INFO - 'PROGRAMW6432': 'C:\\Program Files', 08:31:05 INFO - 'PROMPT': '$P$G', 08:31:05 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 08:31:05 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 08:31:05 INFO - 'PUBLIC': 'C:\\Users\\Public', 08:31:05 INFO - 'PWD': 'C:\\slave\\test', 08:31:05 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 08:31:05 INFO - 'SLAVEDIR': 'C:\\slave\\', 08:31:05 INFO - 'SYSTEMDRIVE': 'C:', 08:31:05 INFO - 'SYSTEMROOT': 'C:\\windows', 08:31:05 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:31:05 INFO - 'TEST1': 'testie', 08:31:05 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:31:05 INFO - 'USERDOMAIN': 'T-W864-IX-084', 08:31:05 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-084', 08:31:05 INFO - 'USERNAME': 'cltbld', 08:31:05 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-084', 08:31:05 INFO - 'WINDIR': 'C:\\windows', 08:31:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 08:31:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:08 INFO - Downloading/unpacking psutil>=0.7.1 08:31:08 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:31:08 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:31:09 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:31:09 INFO - Installing collected packages: psutil 08:31:09 INFO - Successfully installed psutil 08:31:09 INFO - Cleaning up... 08:31:09 INFO - Return code: 0 08:31:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv C:\slave\test\build/venv 08:31: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:31:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31: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:31:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:09 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 0x02372B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0232DEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02449060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01D68B48>, '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 0x01D8A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02813660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-084', 'USERDOMAIN': 'T-W864-IX-084', '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-084', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-084', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-084', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-084', '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-084\\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:31:09 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:31:09 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:31:09 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 08:31:09 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Roaming', 08:31:09 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 08:31:09 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 08:31:09 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 08:31:09 INFO - 'COMPUTERNAME': 'T-W864-IX-084', 08:31:09 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 08:31:09 INFO - 'DCLOCATION': 'SCL3', 08:31:09 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 08:31:09 INFO - 'FP_NO_HOST_CHECK': 'NO', 08:31:09 INFO - 'HOMEDRIVE': 'C:', 08:31:09 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-084', 08:31:09 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 08:31:09 INFO - 'KTS_VERSION': '1.19c', 08:31:09 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Local', 08:31:09 INFO - 'LOGONSERVER': '\\\\T-W864-IX-084', 08:31:09 INFO - 'MONDIR': 'C:\\Monitor_config\\', 08:31:09 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 08:31:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:09 INFO - 'MOZ_NO_REMOTE': '1', 08:31:09 INFO - 'NO_EM_RESTART': '1', 08:31:09 INFO - 'NUMBER_OF_PROCESSORS': '8', 08:31:09 INFO - 'OS': 'Windows_NT', 08:31:09 INFO - 'OURDRIVE': 'C:', 08:31: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:31:09 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 08:31:09 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 08:31:09 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 08:31:09 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 08:31:09 INFO - 'PROCESSOR_LEVEL': '6', 08:31:09 INFO - 'PROCESSOR_REVISION': '1e05', 08:31:09 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 08:31:09 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 08:31:09 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 08:31:09 INFO - 'PROGRAMW6432': 'C:\\Program Files', 08:31:09 INFO - 'PROMPT': '$P$G', 08:31:09 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 08:31:09 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 08:31:09 INFO - 'PUBLIC': 'C:\\Users\\Public', 08:31:09 INFO - 'PWD': 'C:\\slave\\test', 08:31:09 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 08:31:09 INFO - 'SLAVEDIR': 'C:\\slave\\', 08:31:09 INFO - 'SYSTEMDRIVE': 'C:', 08:31:09 INFO - 'SYSTEMROOT': 'C:\\windows', 08:31:09 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:31:09 INFO - 'TEST1': 'testie', 08:31:09 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:31:09 INFO - 'USERDOMAIN': 'T-W864-IX-084', 08:31:09 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-084', 08:31:09 INFO - 'USERNAME': 'cltbld', 08:31:09 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-084', 08:31:09 INFO - 'WINDIR': 'C:\\windows', 08:31:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 08:31:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:31:11 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:31:11 INFO - Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor 08:31:11 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:31:11 INFO - Installing collected packages: mozsystemmonitor 08:31:11 INFO - Running setup.py install for mozsystemmonitor 08:31:11 INFO - Successfully installed mozsystemmonitor 08:31:11 INFO - Cleaning up... 08:31:11 INFO - Return code: 0 08:31:11 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv 08:31:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:31:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:31:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:11 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 0x02372B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0232DEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02449060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01D68B48>, '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 0x01D8A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02813660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-084', 'USERDOMAIN': 'T-W864-IX-084', '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-084', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-084', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-084', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-084', '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-084\\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:31:12 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:31:12 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:31:12 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 08:31:12 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Roaming', 08:31:12 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 08:31:12 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 08:31:12 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 08:31:12 INFO - 'COMPUTERNAME': 'T-W864-IX-084', 08:31:12 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 08:31:12 INFO - 'DCLOCATION': 'SCL3', 08:31:12 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 08:31:12 INFO - 'FP_NO_HOST_CHECK': 'NO', 08:31:12 INFO - 'HOMEDRIVE': 'C:', 08:31:12 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-084', 08:31:12 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 08:31:12 INFO - 'KTS_VERSION': '1.19c', 08:31:12 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Local', 08:31:12 INFO - 'LOGONSERVER': '\\\\T-W864-IX-084', 08:31:12 INFO - 'MONDIR': 'C:\\Monitor_config\\', 08:31:12 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 08:31:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:12 INFO - 'MOZ_NO_REMOTE': '1', 08:31:12 INFO - 'NO_EM_RESTART': '1', 08:31:12 INFO - 'NUMBER_OF_PROCESSORS': '8', 08:31:12 INFO - 'OS': 'Windows_NT', 08:31:12 INFO - 'OURDRIVE': 'C:', 08:31:12 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 08:31:12 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 08:31:12 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 08:31:12 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 08:31:12 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 08:31:12 INFO - 'PROCESSOR_LEVEL': '6', 08:31:12 INFO - 'PROCESSOR_REVISION': '1e05', 08:31:12 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 08:31:12 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 08:31:12 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 08:31:12 INFO - 'PROGRAMW6432': 'C:\\Program Files', 08:31:12 INFO - 'PROMPT': '$P$G', 08:31:12 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 08:31:12 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 08:31:12 INFO - 'PUBLIC': 'C:\\Users\\Public', 08:31:12 INFO - 'PWD': 'C:\\slave\\test', 08:31:12 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 08:31:12 INFO - 'SLAVEDIR': 'C:\\slave\\', 08:31:12 INFO - 'SYSTEMDRIVE': 'C:', 08:31:12 INFO - 'SYSTEMROOT': 'C:\\windows', 08:31:12 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:31:12 INFO - 'TEST1': 'testie', 08:31:12 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:31:12 INFO - 'USERDOMAIN': 'T-W864-IX-084', 08:31:12 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-084', 08:31:12 INFO - 'USERNAME': 'cltbld', 08:31:12 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-084', 08:31:12 INFO - 'WINDIR': 'C:\\windows', 08:31:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 08:31:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:12 INFO - Downloading/unpacking blobuploader==1.2.4 08:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:13 INFO - Downloading blobuploader-1.2.4.tar.gz 08:31:13 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:31:13 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader 08:31:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:31:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:13 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:31:13 INFO - Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests 08:31:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:14 INFO - Downloading docopt-0.6.1.tar.gz 08:31:14 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:31:14 INFO - Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt 08:31:14 INFO - Installing collected packages: blobuploader, requests, docopt 08:31:14 INFO - Running setup.py install for blobuploader 08:31:14 INFO - Running setup.py install for requests 08:31:15 INFO - Running setup.py install for docopt 08:31:15 INFO - Successfully installed blobuploader requests docopt 08:31:15 INFO - Cleaning up... 08:31:16 INFO - Return code: 0 08:31:16 INFO - Installing None into virtualenv C:\slave\test\build/venv 08:31:16 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:31:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:16 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:31:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:16 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 0x02372B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0232DEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02449060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01D68B48>, '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 0x01D8A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02813660>, '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-084', 'USERDOMAIN': 'T-W864-IX-084', '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-084', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-084', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-084', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-084', '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-084\\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:31:16 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:31:16 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:31:16 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 08:31:16 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Roaming', 08:31:16 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 08:31:16 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 08:31:16 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 08:31:16 INFO - 'COMPUTERNAME': 'T-W864-IX-084', 08:31:16 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 08:31:16 INFO - 'DCLOCATION': 'SCL3', 08:31:16 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 08:31:16 INFO - 'FP_NO_HOST_CHECK': 'NO', 08:31:16 INFO - 'HOMEDRIVE': 'C:', 08:31:16 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-084', 08:31:16 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 08:31:16 INFO - 'KTS_VERSION': '1.19c', 08:31:16 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Local', 08:31:16 INFO - 'LOGONSERVER': '\\\\T-W864-IX-084', 08:31:16 INFO - 'MONDIR': 'C:\\Monitor_config\\', 08:31:16 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 08:31:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:16 INFO - 'MOZ_NO_REMOTE': '1', 08:31:16 INFO - 'NO_EM_RESTART': '1', 08:31:16 INFO - 'NUMBER_OF_PROCESSORS': '8', 08:31:16 INFO - 'OS': 'Windows_NT', 08:31:16 INFO - 'OURDRIVE': 'C:', 08:31:16 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:31:16 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 08:31:16 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 08:31:16 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 08:31:16 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 08:31:16 INFO - 'PROCESSOR_LEVEL': '6', 08:31:16 INFO - 'PROCESSOR_REVISION': '1e05', 08:31:16 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 08:31:16 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 08:31:16 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 08:31:16 INFO - 'PROGRAMW6432': 'C:\\Program Files', 08:31:16 INFO - 'PROMPT': '$P$G', 08:31:16 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 08:31:16 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 08:31:16 INFO - 'PUBLIC': 'C:\\Users\\Public', 08:31:16 INFO - 'PWD': 'C:\\slave\\test', 08:31:16 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 08:31:16 INFO - 'SLAVEDIR': 'C:\\slave\\', 08:31:16 INFO - 'SYSTEMDRIVE': 'C:', 08:31:16 INFO - 'SYSTEMROOT': 'C:\\windows', 08:31:16 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:31:16 INFO - 'TEST1': 'testie', 08:31:16 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:31:16 INFO - 'USERDOMAIN': 'T-W864-IX-084', 08:31:16 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-084', 08:31:16 INFO - 'USERNAME': 'cltbld', 08:31:16 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-084', 08:31:16 INFO - 'WINDIR': 'C:\\windows', 08:31:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 08:31:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:16 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 08:31:16 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-lrxplq-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 08:31:16 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 08:31:16 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-kb6x25-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 08:31:16 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 08:31:16 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-88ognr-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 08:31:17 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 08:31:17 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-wsb1hd-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 08:31:17 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 08:31:17 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-hqmlks-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 08:31:17 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 08:31:17 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-gnf5vm-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 08:31:17 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 08:31:17 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-44jqb0-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 08:31:17 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 08:31:17 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ttvhza-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 08:31:17 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 08:31:17 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-1c3a7z-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 08:31:17 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 08:31:17 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-sdltzh-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 08:31:17 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 08:31:17 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-00dlsb-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 08:31:17 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 08:31:18 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-pmapyg-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 08:31:18 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 08:31:18 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-yca6pr-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 08:31:18 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 08:31:18 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-iuduby-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 08:31:18 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 08:31:18 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-c7pzvy-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 08:31:18 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 08:31:18 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-kfrmlp-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 08:31:18 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 08:31:18 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-gd1oxb-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 08:31:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:31:18 INFO - Running setup.py install for manifestparser 08:31:18 INFO - Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts 08:31:18 INFO - Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts 08:31:19 INFO - Running setup.py install for mozcrash 08:31:19 INFO - Running setup.py install for mozdebug 08:31:19 INFO - Running setup.py install for mozdevice 08:31:20 INFO - Installing sutini-script.py script to C:\slave\test\build\venv\Scripts 08:31:20 INFO - Installing sutini.exe script to C:\slave\test\build\venv\Scripts 08:31:20 INFO - Installing dm-script.py script to C:\slave\test\build\venv\Scripts 08:31:20 INFO - Installing dm.exe script to C:\slave\test\build\venv\Scripts 08:31:20 INFO - Running setup.py install for mozfile 08:31:21 INFO - Running setup.py install for mozhttpd 08:31:21 INFO - Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts 08:31:21 INFO - Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts 08:31:21 INFO - Running setup.py install for mozinfo 08:31:21 INFO - Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts 08:31:21 INFO - Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts 08:31:21 INFO - Running setup.py install for mozInstall 08:31:21 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts 08:31:21 INFO - Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts 08:31:21 INFO - Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts 08:31:21 INFO - Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts 08:31:21 INFO - Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts 08:31:21 INFO - Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts 08:31:21 INFO - Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts 08:31:21 INFO - Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts 08:31:22 INFO - Running setup.py install for mozleak 08:31:22 INFO - Running setup.py install for mozlog 08:31:22 INFO - Installing structlog-script.py script to C:\slave\test\build\venv\Scripts 08:31:22 INFO - Installing structlog.exe script to C:\slave\test\build\venv\Scripts 08:31:23 INFO - Running setup.py install for moznetwork 08:31:23 INFO - Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts 08:31:23 INFO - Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts 08:31:23 INFO - Running setup.py install for mozprocess 08:31:24 INFO - Running setup.py install for mozprofile 08:31:24 INFO - Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts 08:31:24 INFO - Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts 08:31:24 INFO - Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts 08:31:24 INFO - Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts 08:31:24 INFO - Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts 08:31:24 INFO - Installing view-profile.exe script to C:\slave\test\build\venv\Scripts 08:31:25 INFO - Running setup.py install for mozrunner 08:31:25 INFO - Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts 08:31:25 INFO - Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts 08:31:25 INFO - Running setup.py install for mozscreenshot 08:31:26 INFO - Running setup.py install for moztest 08:31:26 INFO - Running setup.py install for mozversion 08:31:26 INFO - Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts 08:31:26 INFO - Installing mozversion.exe script to C:\slave\test\build\venv\Scripts 08:31:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:31:27 INFO - Cleaning up... 08:31:27 INFO - Return code: 0 08:31:27 INFO - Installing None into virtualenv C:\slave\test\build/venv 08:31:27 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:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:27 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:31:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:27 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 0x02372B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0232DEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02449060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01D68B48>, '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 0x01D8A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02813660>, '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-084', 'USERDOMAIN': 'T-W864-IX-084', '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-084', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-084', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-084', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-084', '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-084\\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:31:27 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:31:27 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:31:27 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 08:31:27 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Roaming', 08:31:27 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 08:31:27 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 08:31:27 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 08:31:27 INFO - 'COMPUTERNAME': 'T-W864-IX-084', 08:31:27 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 08:31:27 INFO - 'DCLOCATION': 'SCL3', 08:31:27 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 08:31:27 INFO - 'FP_NO_HOST_CHECK': 'NO', 08:31:27 INFO - 'HOMEDRIVE': 'C:', 08:31:27 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-084', 08:31:27 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 08:31:27 INFO - 'KTS_VERSION': '1.19c', 08:31:27 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Local', 08:31:27 INFO - 'LOGONSERVER': '\\\\T-W864-IX-084', 08:31:27 INFO - 'MONDIR': 'C:\\Monitor_config\\', 08:31:27 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 08:31:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:27 INFO - 'MOZ_NO_REMOTE': '1', 08:31:27 INFO - 'NO_EM_RESTART': '1', 08:31:27 INFO - 'NUMBER_OF_PROCESSORS': '8', 08:31:27 INFO - 'OS': 'Windows_NT', 08:31:27 INFO - 'OURDRIVE': 'C:', 08:31:27 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 08:31:27 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 08:31:27 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 08:31:27 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 08:31:27 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 08:31:27 INFO - 'PROCESSOR_LEVEL': '6', 08:31:27 INFO - 'PROCESSOR_REVISION': '1e05', 08:31:27 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 08:31:27 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 08:31:27 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 08:31:27 INFO - 'PROGRAMW6432': 'C:\\Program Files', 08:31:27 INFO - 'PROMPT': '$P$G', 08:31:27 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 08:31:27 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 08:31:27 INFO - 'PUBLIC': 'C:\\Users\\Public', 08:31:27 INFO - 'PWD': 'C:\\slave\\test', 08:31:27 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 08:31:27 INFO - 'SLAVEDIR': 'C:\\slave\\', 08:31:27 INFO - 'SYSTEMDRIVE': 'C:', 08:31:27 INFO - 'SYSTEMROOT': 'C:\\windows', 08:31:27 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:31:27 INFO - 'TEST1': 'testie', 08:31:27 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:31:27 INFO - 'USERDOMAIN': 'T-W864-IX-084', 08:31:27 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-084', 08:31:27 INFO - 'USERNAME': 'cltbld', 08:31:27 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-084', 08:31:27 INFO - 'WINDIR': 'C:\\windows', 08:31:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 08:31:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:27 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 08:31:27 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-4lhh1k-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 08:31:27 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:31:27 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 08:31:27 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-7zmmaa-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 08:31:27 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:31:27 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 08:31:27 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-j8riue-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 08:31:27 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:31:27 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 08:31:27 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-2rzlch-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 08:31:27 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:31:27 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 08:31:27 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-tyeac4-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 08:31:27 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:31:27 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 08:31:27 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xvxgcl-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 08:31:28 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:31:28 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 08:31:28 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-p6ai3i-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 08:31:28 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:31:28 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 08:31:28 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-aldq1w-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 08:31:28 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:31:28 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 08:31:28 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-dxzcrn-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 08:31:28 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:31:28 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 08:31:28 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-e_o_wm-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 08:31:28 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:31:28 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 08:31:28 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-kuetz9-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 08:31:28 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:31:28 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 08:31:28 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-f_rbtf-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 08:31:28 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:31:28 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 08:31:28 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-nerhwc-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 08:31:28 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:31:28 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 08:31:28 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-k4aeg1-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 08:31:29 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:31:29 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 08:31:29 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-4scnnk-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 08:31:29 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:31:29 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 08:31:29 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-j3n5de-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 08:31:29 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:31:29 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 08:31:29 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-iycddn-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 08:31:29 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:31:29 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:31:29 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:31:29 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:31:29 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:31:29 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:31:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10)) 08:31:29 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:31:29 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:31:30 INFO - Downloading blessings-1.5.1.tar.gz 08:31:30 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:31:30 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings 08:31:30 INFO - Installing collected packages: blessings 08:31:30 INFO - Running setup.py install for blessings 08:31:30 INFO - Successfully installed blessings 08:31:30 INFO - Cleaning up... 08:31:33 INFO - Return code: 0 08:31:33 INFO - Done creating virtualenv C:\slave\test\build/venv. 08:31:33 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 08:31:33 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 08:31:33 INFO - Reading from file tmpfile_stdout 08:31:33 INFO - Using _rmtree_windows ... 08:31:33 INFO - Using _rmtree_windows ... 08:31:33 INFO - Current package versions: 08:31:33 INFO - blessings == 1.5.1 08:31:33 INFO - blobuploader == 1.2.4 08:31:33 INFO - docopt == 0.6.1 08:31:33 INFO - manifestparser == 1.1 08:31:33 INFO - mozInstall == 1.12 08:31:33 INFO - mozcrash == 0.16 08:31:33 INFO - mozdebug == 0.1 08:31:33 INFO - mozdevice == 0.46 08:31:33 INFO - mozfile == 1.2 08:31:33 INFO - mozhttpd == 0.7 08:31:33 INFO - mozinfo == 0.8 08:31:33 INFO - mozleak == 0.1 08:31:33 INFO - mozlog == 3.0 08:31:33 INFO - moznetwork == 0.27 08:31:33 INFO - mozprocess == 0.22 08:31:33 INFO - mozprofile == 0.27 08:31:33 INFO - mozrunner == 6.10 08:31:33 INFO - mozscreenshot == 0.1 08:31:33 INFO - mozsystemmonitor == 0.0 08:31:33 INFO - moztest == 0.7 08:31:33 INFO - mozversion == 1.4 08:31:33 INFO - psutil == 3.1.1 08:31:33 INFO - requests == 1.2.3 08:31:33 INFO - Installing None into virtualenv C:\slave\test\build/venv 08:31:33 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:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:33 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:31:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:33 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 0x02372B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0232DEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02449060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01D68B48>, '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 0x01D8A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02813660>, '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-084', 'USERDOMAIN': 'T-W864-IX-084', '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-084', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-084', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-084', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-084', '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-084\\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:31:34 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:31:34 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:31:34 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 08:31:34 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Roaming', 08:31:34 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 08:31:34 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 08:31:34 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 08:31:34 INFO - 'COMPUTERNAME': 'T-W864-IX-084', 08:31:34 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 08:31:34 INFO - 'DCLOCATION': 'SCL3', 08:31:34 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 08:31:34 INFO - 'FP_NO_HOST_CHECK': 'NO', 08:31:34 INFO - 'HOMEDRIVE': 'C:', 08:31:34 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-084', 08:31:34 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 08:31:34 INFO - 'KTS_VERSION': '1.19c', 08:31:34 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Local', 08:31:34 INFO - 'LOGONSERVER': '\\\\T-W864-IX-084', 08:31:34 INFO - 'MONDIR': 'C:\\Monitor_config\\', 08:31:34 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 08:31:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:34 INFO - 'MOZ_NO_REMOTE': '1', 08:31:34 INFO - 'NO_EM_RESTART': '1', 08:31:34 INFO - 'NUMBER_OF_PROCESSORS': '8', 08:31:34 INFO - 'OS': 'Windows_NT', 08:31:34 INFO - 'OURDRIVE': 'C:', 08:31:34 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:31:34 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 08:31:34 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 08:31:34 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 08:31:34 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 08:31:34 INFO - 'PROCESSOR_LEVEL': '6', 08:31:34 INFO - 'PROCESSOR_REVISION': '1e05', 08:31:34 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 08:31:34 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 08:31:34 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 08:31:34 INFO - 'PROGRAMW6432': 'C:\\Program Files', 08:31:34 INFO - 'PROMPT': '$P$G', 08:31:34 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 08:31:34 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 08:31:34 INFO - 'PUBLIC': 'C:\\Users\\Public', 08:31:34 INFO - 'PWD': 'C:\\slave\\test', 08:31:34 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 08:31:34 INFO - 'SLAVEDIR': 'C:\\slave\\', 08:31:34 INFO - 'SYSTEMDRIVE': 'C:', 08:31:34 INFO - 'SYSTEMROOT': 'C:\\windows', 08:31:34 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:31:34 INFO - 'TEST1': 'testie', 08:31:34 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:31:34 INFO - 'USERDOMAIN': 'T-W864-IX-084', 08:31:34 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-084', 08:31:34 INFO - 'USERNAME': 'cltbld', 08:31:34 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-084', 08:31:34 INFO - 'WINDIR': 'C:\\windows', 08:31:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 08:31:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:34 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:31:34 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:31:34 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:31:34 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:31:34 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:31:34 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:31:34 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:31:34 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:31:34 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:31:34 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:31:34 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:31:34 INFO - Cleaning up... 08:31:34 INFO - Return code: 0 08:31:34 INFO - Running post-action listener: _resource_record_post_action 08:31:34 INFO - Running post-action listener: _start_resource_monitoring 08:31:34 INFO - Starting resource monitoring. 08:31:34 INFO - ##### 08:31:34 INFO - ##### Running install step. 08:31:34 INFO - ##### 08:31:34 INFO - Running pre-action listener: _resource_record_pre_action 08:31:34 INFO - Running main action method: install 08:31:34 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 08:31:34 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 08:31:34 INFO - Reading from file tmpfile_stdout 08:31:34 INFO - Using _rmtree_windows ... 08:31:34 INFO - Using _rmtree_windows ... 08:31:34 INFO - Detecting whether we're running mozinstall >=1.0... 08:31:34 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h'] 08:31:34 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h 08:31:34 INFO - Reading from file tmpfile_stdout 08:31:34 INFO - Output received: 08:31:34 INFO - Usage: mozinstall-script.py [options] installer 08:31:34 INFO - Options: 08:31:34 INFO - -h, --help show this help message and exit 08:31:34 INFO - -d DEST, --destination=DEST 08:31:34 INFO - Directory to install application into. [default: 08:31:34 INFO - "C:\slave\test"] 08:31:34 INFO - --app=APP Application being installed. [default: firefox] 08:31:34 INFO - Using _rmtree_windows ... 08:31:34 INFO - Using _rmtree_windows ... 08:31:34 INFO - mkdir: C:\slave\test\build\application 08:31:34 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:31:34 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:31:36 INFO - Reading from file tmpfile_stdout 08:31:36 INFO - Output received: 08:31:36 INFO - C:\slave\test\build\application\firefox\firefox.exe 08:31:36 INFO - Using _rmtree_windows ... 08:31:36 INFO - Using _rmtree_windows ... 08:31:36 INFO - Running post-action listener: _resource_record_post_action 08:31:36 INFO - ##### 08:31:36 INFO - ##### Running run-tests step. 08:31:36 INFO - ##### 08:31:36 INFO - Running pre-action listener: _resource_record_pre_action 08:31:36 INFO - Running main action method: run_tests 08:31:36 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version'] 08:31:36 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version 08:31:36 INFO - Python 2.7.3 08:31:36 INFO - Return code: 0 08:31:36 INFO - grabbing minidump binary from tooltool 08:31:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:31:36 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 0x01D68B48>, '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 0x01D8A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02813660>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1 08:31:36 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:31:36 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:31:36 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 08:31:36 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmpx89wv3 08:31:36 INFO - INFO - File integrity verified, renaming tmpx89wv3 to win32-minidump_stackwalk.exe 08:31:36 INFO - Return code: 0 08:31:36 INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755 08:31:36 INFO - mkdir: C:\slave\test\build\blobber_upload_dir 08:31:36 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir 08:31:36 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe 08:31:36 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir 08:31:36 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/HtB_sZClS8uOWjcyyeoKSg/artifacts/public/build/firefox-44.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-084', '--webServer', 'localhost'] in C:\slave\test\build 08:31:36 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/HtB_sZClS8uOWjcyyeoKSg/artifacts/public/build/firefox-44.0a1.en-US.win64.crashreporter-symbols.zip --title T-W864-IX-084 --webServer localhost 08:31:36 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 08:31:36 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Roaming', 08:31:36 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 08:31:36 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 08:31:36 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 08:31:36 INFO - 'COMPUTERNAME': 'T-W864-IX-084', 08:31:36 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 08:31:36 INFO - 'DCLOCATION': 'SCL3', 08:31:36 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 08:31:36 INFO - 'FP_NO_HOST_CHECK': 'NO', 08:31:36 INFO - 'HOMEDRIVE': 'C:', 08:31:36 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-084', 08:31:36 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 08:31:36 INFO - 'KTS_VERSION': '1.19c', 08:31:36 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-084\\AppData\\Local', 08:31:36 INFO - 'LOGONSERVER': '\\\\T-W864-IX-084', 08:31:36 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir', 08:31:36 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe', 08:31:36 INFO - 'MONDIR': 'C:\\Monitor_config\\', 08:31:36 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 08:31:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:36 INFO - 'MOZ_NO_REMOTE': '1', 08:31:36 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir', 08:31:36 INFO - 'NO_EM_RESTART': '1', 08:31:36 INFO - 'NUMBER_OF_PROCESSORS': '8', 08:31:36 INFO - 'OS': 'Windows_NT', 08:31:36 INFO - 'OURDRIVE': 'C:', 08:31:36 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 08:31:36 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 08:31:36 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 08:31:36 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 08:31:36 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 08:31:36 INFO - 'PROCESSOR_LEVEL': '6', 08:31:36 INFO - 'PROCESSOR_REVISION': '1e05', 08:31:36 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 08:31:36 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 08:31:36 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 08:31:36 INFO - 'PROGRAMW6432': 'C:\\Program Files', 08:31:36 INFO - 'PROMPT': '$P$G', 08:31:36 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 08:31:36 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 08:31:36 INFO - 'PUBLIC': 'C:\\Users\\Public', 08:31:36 INFO - 'PWD': 'C:\\slave\\test', 08:31:36 INFO - 'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos', 08:31:36 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 08:31:36 INFO - 'SLAVEDIR': 'C:\\slave\\', 08:31:36 INFO - 'SYSTEMDRIVE': 'C:', 08:31:36 INFO - 'SYSTEMROOT': 'C:\\windows', 08:31:36 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:31:36 INFO - 'TEST1': 'testie', 08:31:36 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 08:31:36 INFO - 'USERDOMAIN': 'T-W864-IX-084', 08:31:36 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-084', 08:31:36 INFO - 'USERNAME': 'cltbld', 08:31:36 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-084', 08:31:36 INFO - 'WINDIR': 'C:\\windows', 08:31:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 08:31:36 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/HtB_sZClS8uOWjcyyeoKSg/artifacts/public/build/firefox-44.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-084', '--webServer', 'localhost'] with output_timeout 3600 ProcessManager NOT managing child processes ProcessManager UNABLE to use job objects to manage child processes 08:31:37 INFO - mozversion INFO | application_buildid: 20151022064307 08:31:37 INFO - mozversion INFO | application_changeset: d43d4d4e26fbb3f9a2217a53bb61cfab1828f6dc 08:31:37 INFO - mozversion INFO | application_display_name: Nightly 08:31:37 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:31:37 INFO - mozversion INFO | application_name: Firefox 08:31:37 INFO - mozversion INFO | application_remotingname: firefox 08:31:37 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 08:31:37 INFO - mozversion INFO | application_vendor: Mozilla 08:31:37 INFO - mozversion INFO | application_version: 44.0a1 08:31:37 INFO - mozversion INFO | platform_buildid: 20151022064307 08:31:37 INFO - mozversion INFO | platform_changeset: d43d4d4e26fbb3f9a2217a53bb61cfab1828f6dc 08:31:37 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 08:31:37 INFO - mozversion INFO | platform_version: 44.0a1 08:31:37 INFO - 2015-10-22 08:31:37,799 DEBUG : using testdate: 1445527897 08:31:37 INFO - 2015-10-22 08:31:37,799 DEBUG : actual date: 1445527897 08:31:37 INFO - 2015-10-22 08:31:37,894 INFO : starting webserver on 'localhost:49278' 08:31:37 INFO - 2015-10-22 08:31:37,897 INFO : Starting test suite T-W864-IX-084 08:31:37 INFO - 2015-10-22 08:31:37,897 INFO : Starting test dromaeo_css 08:31:37 INFO - 2015-10-22 08:31:37,897 DEBUG : operating with platform_type : w8_ 08:31:37 INFO - 2015-10-22 08:31:37,897 INFO : Initialising browser for dromaeo_css test... 08:31:37 INFO - 2015-10-22 08:31:37,990 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpit7hom\profile http://localhost:49278/getInfo.html 08:31:46 INFO - 2015-10-22 08:31:46,920 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:31:46 INFO - 2015-10-22 08:31:46,920 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:31:46 INFO - 2015-10-22 08:31:46,920 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674 08:31:46 INFO - 2015-10-22 08:31:46,920 DEBUG : BROWSER_OUTPUT: __metrics 08:31:47 INFO - 2015-10-22 08:31:47,065 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:31:48 INFO - 2015-10-22 08:31:48,582 DEBUG : BROWSER_OUTPUT: console.error: 08:31:48 INFO - 2015-10-22 08:31:48,584 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] 08:31:48 INFO - 2015-10-22 08:31:48,584 DEBUG : BROWSER_OUTPUT: Stack: 08:31:48 INFO - 2015-10-22 08:31:48,584 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<._executeStatement@resource://gre/modules/Sqlite.jsm:758:19 08:31:48 INFO - 2015-10-22 08:31:48,584 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached/<@resource://gre/modules/Sqlite.jsm:493:9 08:31:48 INFO - 2015-10-22 08:31:48,584 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached@resource://gre/modules/Sqlite.jsm:491:1 08:31:48 INFO - 2015-10-22 08:31:48,584 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeBeforeShutdown/loggedDb<.executeCached.value<@resource://gre/modules/Sqlite.jsm:368:51 08:31:48 INFO - 2015-10-22 08:31:48,584 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 08:31:48 INFO - 2015-10-22 08:31:48,584 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 08:31:48 INFO - 2015-10-22 08:31:48,584 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 08:31:48 INFO - 2015-10-22 08:31:48,584 DEBUG : BROWSER_OUTPUT: transaction@resource://gre/modules/Bookmarks.jsm:783:15 08:31:48 INFO - 2015-10-22 08:31:48,584 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 08:31:48 INFO - 2015-10-22 08:31:48,584 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 08:31:48 INFO - 2015-10-22 08:31:48,584 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 08:31:48 INFO - 2015-10-22 08:31:48,585 DEBUG : BROWSER_OUTPUT: Task_spawn@resource://gre/modules/Task.jsm:164:12 08:31:48 INFO - 2015-10-22 08:31:48,585 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 08:50:27 INFO - 2015-10-22 08:50:27,101 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 08:50:27 INFO - 2015-10-22 08:50:27,101 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 08:50:27 INFO - 2015-10-22 08:50:27,101 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 08:50:27 INFO - 2015-10-22 08:50:27,101 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 08:50:27 INFO - 2015-10-22 08:50:27,101 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 08:50:27 INFO - 2015-10-22 08:50:27,101 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 08:50:27 INFO - 2015-10-22 08:50:27,101 DEBUG : BROWSER_OUTPUT: 08:50:27 INFO - 2015-10-22 08:50:27,799 INFO : Browser initialized. 08:50:27 INFO - 2015-10-22 08:50:27,799 INFO : Running cycle 1/1 for kraken test... 08:50:27 INFO - 2015-10-22 08:50:27,799 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpqo23rs\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\kraken\kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:50:39 INFO - 2015-10-22 08:50:39,377 DEBUG : BROWSER_OUTPUT: RSS: Main: 183181312 08:50:39 INFO - 2015-10-22 08:50:39,377 DEBUG : BROWSER_OUTPUT: 08:50:42 INFO - 2015-10-22 08:50:42,084 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 08:50:42 INFO - 2015-10-22 08:50:42,670 DEBUG : BROWSER_OUTPUT: RSS: Main: 219893760 08:50:42 INFO - 2015-10-22 08:50:42,670 DEBUG : BROWSER_OUTPUT: 08:50:45 INFO - 2015-10-22 08:50:45,371 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 08:50:45 INFO - 2015-10-22 08:50:45,953 DEBUG : BROWSER_OUTPUT: RSS: Main: 219066368 08:50:45 INFO - 2015-10-22 08:50:45,953 DEBUG : BROWSER_OUTPUT: 08:50:48 INFO - 2015-10-22 08:50:48,654 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 08:50:49 INFO - 2015-10-22 08:50:49,236 DEBUG : BROWSER_OUTPUT: RSS: Main: 204488704 08:50:49 INFO - 2015-10-22 08:50:49,236 DEBUG : BROWSER_OUTPUT: 08:50:51 INFO - 2015-10-22 08:50:51,246 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 08:50:51 INFO - 2015-10-22 08:50:51,815 DEBUG : BROWSER_OUTPUT: RSS: Main: 207257600 08:50:51 INFO - 2015-10-22 08:50:51,815 DEBUG : BROWSER_OUTPUT: 08:50:54 INFO - 2015-10-22 08:50:54,036 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:50:54 INFO - 2015-10-22 08:50:54,599 DEBUG : BROWSER_OUTPUT: RSS: Main: 204787712 08:50:54 INFO - 2015-10-22 08:50:54,599 DEBUG : BROWSER_OUTPUT: 08:50:57 INFO - 2015-10-22 08:50:57,641 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 08:50:58 INFO - 2015-10-22 08:50:58,223 DEBUG : BROWSER_OUTPUT: RSS: Main: 200773632 08:50:58 INFO - 2015-10-22 08:50:58,223 DEBUG : BROWSER_OUTPUT: 08:51:01 INFO - 2015-10-22 08:51:01,591 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 08:51:02 INFO - 2015-10-22 08:51:02,165 DEBUG : BROWSER_OUTPUT: RSS: Main: 196743168 08:51:02 INFO - 2015-10-22 08:51:02,165 DEBUG : BROWSER_OUTPUT: 08:51:05 INFO - 2015-10-22 08:51:05,053 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 08:51:05 INFO - 2015-10-22 08:51:05,638 DEBUG : BROWSER_OUTPUT: RSS: Main: 195436544 08:51:05 INFO - 2015-10-22 08:51:05,638 DEBUG : BROWSER_OUTPUT: 08:51:07 INFO - 2015-10-22 08:51:07,427 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:51:07 INFO - 2015-10-22 08:51:07,990 DEBUG : BROWSER_OUTPUT: RSS: Main: 224522240 08:51:07 INFO - 2015-10-22 08:51:07,990 DEBUG : BROWSER_OUTPUT: 08:51:09 INFO - 2015-10-22 08:51:09,872 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:51:10 INFO - 2015-10-22 08:51:10,447 DEBUG : BROWSER_OUTPUT: RSS: Main: 227172352 08:51:10 INFO - 2015-10-22 08:51:10,447 DEBUG : BROWSER_OUTPUT: 08:51:12 INFO - 2015-10-22 08:51:12,740 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:51:13 INFO - 2015-10-22 08:51:13,322 DEBUG : BROWSER_OUTPUT: RSS: Main: 233164800 08:51:13 INFO - 2015-10-22 08:51:13,322 DEBUG : BROWSER_OUTPUT: 08:51:15 INFO - 2015-10-22 08:51:15,903 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:51:16 INFO - 2015-10-22 08:51:16,492 DEBUG : BROWSER_OUTPUT: RSS: Main: 235040768 08:51:16 INFO - 2015-10-22 08:51:16,492 DEBUG : BROWSER_OUTPUT: 08:51:19 INFO - 2015-10-22 08:51:19,255 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:51:19 INFO - 2015-10-22 08:51:19,838 DEBUG : BROWSER_OUTPUT: RSS: Main: 236380160 08:51:19 INFO - 2015-10-22 08:51:19,838 DEBUG : BROWSER_OUTPUT: 08:51:21 INFO - 2015-10-22 08:51:21,671 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 08:51:21 INFO - 2015-10-22 08:51:21,921 DEBUG : BROWSER_OUTPUT: RSS: Main: 291344384 08:51:21 INFO - 2015-10-22 08:51:21,921 DEBUG : BROWSER_OUTPUT: 08:51:21 INFO - 2015-10-22 08:51:21,921 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:51:21 INFO - 2015-10-22 08:51:21,923 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:51:21 INFO - 2015-10-22 08:51:21,923 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:51:21 INFO - 2015-10-22 08:51:21,923 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:51:21 INFO - 2015-10-22 08:51:21,923 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;112;107;112;113;112;113;111;106;111 08:51:21 INFO - 2015-10-22 08:51:21,923 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;138;135;151;169;130;139;138;134;159;134 08:51:21 INFO - 2015-10-22 08:51:21,923 DEBUG : BROWSER_OUTPUT: |2;audio-dft;144;143;140;148;142;140;141;143;140;139 08:51:21 INFO - 2015-10-22 08:51:21,923 DEBUG : BROWSER_OUTPUT: |3;audio-fft;69;72;72;92;68;71;69;72;97;68 08:51:21 INFO - 2015-10-22 08:51:21,923 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;90;112;91;91;91;119;91;92;120 08:51:21 INFO - 2015-10-22 08:51:21,923 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;111;112;110;111;111;111;110;111;110 08:51:21 INFO - 2015-10-22 08:51:21,923 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;131;131;131;132;131;133;132;132;131;131 08:51:21 INFO - 2015-10-22 08:51:21,923 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;98;96;96;97;96;107;97;99;97;97 08:51:21 INFO - 2015-10-22 08:51:21,924 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;74;73;72;72;78;74;88;72;71 08:51:21 INFO - 2015-10-22 08:51:21,924 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;69;70;69;69;69;69;68;69 08:51:21 INFO - 2015-10-22 08:51:21,924 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;89;91;91;91;91;91;95;92;91;90 08:51:21 INFO - 2015-10-22 08:51:21,924 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;124;125;131;139;130;132;124;134;134 08:51:21 INFO - 2015-10-22 08:51:21,924 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;150;152;161;161;160;151;161;161;164;162 08:51:21 INFO - 2015-10-22 08:51:21,924 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;76;75;77;76;76;75;76;77;76;75 08:51:21 INFO - 2015-10-22 08:51:21,924 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:51:21 INFO - 2015-10-22 08:51:21,924 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:51:21 INFO - 2015-10-22 08:51:21,924 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,966 08:51:21 INFO - 2015-10-22 08:51:21,924 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:51:21 INFO - 2015-10-22 08:51:21,924 DEBUG : BROWSER_OUTPUT: __startTimestamp1445529081922__endTimestamp 08:51:21 INFO - 2015-10-22 08:51:21,924 DEBUG : BROWSER_OUTPUT: 08:51:21 INFO - 2015-10-22 08:51:21,928 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:51:21 INFO - 2015-10-22 08:51:21,928 DEBUG : BROWSER_OUTPUT: Number of tests: 14 08:51:21 INFO - 2015-10-22 08:51:21,928 DEBUG : BROWSER_OUTPUT: 08:51:21 INFO - 2015-10-22 08:51:21,928 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:2.49 (2.2%) stddev-sans-first:2.54 08:51:21 INFO - 2015-10-22 08:51:21,928 DEBUG : BROWSER_OUTPUT: Values: 113.0 112.0 107.0 112.0 113.0 112.0 113.0 111.0 106.0 111.0 08:51:21 INFO - 2015-10-22 08:51:21,928 DEBUG : BROWSER_OUTPUT: 08:51:21 INFO - 2015-10-22 08:51:21,928 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.70 Median:138.50 stddev:12.72 (9.2%) stddev-sans-first:13.38 08:51:21 INFO - 2015-10-22 08:51:21,928 DEBUG : BROWSER_OUTPUT: Values: 138.0 135.0 151.0 169.0 130.0 139.0 138.0 134.0 159.0 134.0 08:51:21 INFO - 2015-10-22 08:51:21,928 DEBUG : BROWSER_OUTPUT: 08:51:21 INFO - 2015-10-22 08:51:21,928 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:142.00 Median:142.50 stddev:2.67 (1.9%) stddev-sans-first:2.73 08:51:21 INFO - 2015-10-22 08:51:21,928 DEBUG : BROWSER_OUTPUT: Values: 144.0 143.0 140.0 148.0 142.0 140.0 141.0 143.0 140.0 139.0 08:51:21 INFO - 2015-10-22 08:51:21,928 DEBUG : BROWSER_OUTPUT: 08:51:21 INFO - 2015-10-22 08:51:21,928 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:75.00 Median:72.00 stddev:10.47 (14.5%) stddev-sans-first:10.87 08:51:21 INFO - 2015-10-22 08:51:21,930 DEBUG : BROWSER_OUTPUT: Values: 69.0 72.0 72.0 92.0 68.0 71.0 69.0 72.0 97.0 68.0 08:51:21 INFO - 2015-10-22 08:51:21,930 DEBUG : BROWSER_OUTPUT: 08:51:21 INFO - 2015-10-22 08:51:21,930 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:98.80 Median:91.00 stddev:12.73 (14.0%) stddev-sans-first:13.19 08:51:21 INFO - 2015-10-22 08:51:21,930 DEBUG : BROWSER_OUTPUT: Values: 91.0 90.0 112.0 91.0 91.0 91.0 119.0 91.0 92.0 120.0 08:51:21 INFO - 2015-10-22 08:51:21,930 DEBUG : BROWSER_OUTPUT: 08:51:21 INFO - 2015-10-22 08:51:21,930 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.70 Median:111.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 08:51:21 INFO - 2015-10-22 08:51:21,930 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 112.0 110.0 111.0 111.0 111.0 110.0 111.0 110.0 08:51:21 INFO - 2015-10-22 08:51:21,930 DEBUG : BROWSER_OUTPUT: 08:51:21 INFO - 2015-10-22 08:51:21,930 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:131.50 Median:131.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 08:51:21 INFO - 2015-10-22 08:51:21,930 DEBUG : BROWSER_OUTPUT: Values: 131.0 131.0 131.0 132.0 131.0 133.0 132.0 132.0 131.0 131.0 08:51:21 INFO - 2015-10-22 08:51:21,930 DEBUG : BROWSER_OUTPUT: 08:51:21 INFO - 2015-10-22 08:51:21,930 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:98.00 Median:97.00 stddev:3.30 (3.4%) stddev-sans-first:3.50 08:51:21 INFO - 2015-10-22 08:51:21,930 DEBUG : BROWSER_OUTPUT: Values: 98.0 96.0 96.0 97.0 96.0 107.0 97.0 99.0 97.0 97.0 08:51:21 INFO - 2015-10-22 08:51:21,930 DEBUG : BROWSER_OUTPUT: 08:51:21 INFO - 2015-10-22 08:51:21,930 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.60 Median:73.50 stddev:5.10 (6.9%) stddev-sans-first:5.33 08:51:21 INFO - 2015-10-22 08:51:21,930 DEBUG : BROWSER_OUTPUT: Values: 72.0 74.0 73.0 72.0 72.0 78.0 74.0 88.0 72.0 71.0 08:51:21 INFO - 2015-10-22 08:51:21,930 DEBUG : BROWSER_OUTPUT: 08:51:21 INFO - 2015-10-22 08:51:21,930 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 08:51:21 INFO - 2015-10-22 08:51:21,930 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 70.0 69.0 69.0 69.0 69.0 68.0 69.0 08:51:21 INFO - 2015-10-22 08:51:21,930 DEBUG : BROWSER_OUTPUT: 08:51:21 INFO - 2015-10-22 08:51:21,931 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:91.20 Median:91.00 stddev:1.55 (1.7%) stddev-sans-first:1.42 08:51:21 INFO - 2015-10-22 08:51:21,931 DEBUG : BROWSER_OUTPUT: Values: 89.0 91.0 91.0 91.0 91.0 91.0 95.0 92.0 91.0 90.0 08:51:22 INFO - 2015-10-22 08:51:21,931 DEBUG : BROWSER_OUTPUT: 08:51:22 INFO - 2015-10-22 08:51:21,931 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:129.60 Median:131.50 stddev:5.40 (4.1%) stddev-sans-first:5.17 08:51:22 INFO - 2015-10-22 08:51:21,933 DEBUG : BROWSER_OUTPUT: Values: 123.0 124.0 125.0 131.0 139.0 130.0 132.0 124.0 134.0 134.0 08:51:22 INFO - 2015-10-22 08:51:21,933 DEBUG : BROWSER_OUTPUT: 08:51:22 INFO - 2015-10-22 08:51:21,933 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.30 Median:161.00 stddev:5.17 (3.2%) stddev-sans-first:4.52 08:51:22 INFO - 2015-10-22 08:51:21,934 DEBUG : BROWSER_OUTPUT: Values: 150.0 152.0 161.0 161.0 160.0 151.0 161.0 161.0 164.0 162.0 08:51:22 INFO - 2015-10-22 08:51:21,934 DEBUG : BROWSER_OUTPUT: 08:51:22 INFO - 2015-10-22 08:51:21,934 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.90 Median:76.00 stddev:0.74 (1.0%) stddev-sans-first:0.78 08:51:22 INFO - 2015-10-22 08:51:21,934 DEBUG : BROWSER_OUTPUT: Values: 76.0 75.0 77.0 76.0 76.0 75.0 76.0 77.0 76.0 75.0 08:51:22 INFO - 2015-10-22 08:51:21,934 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:51:22 INFO - 2015-10-22 08:51:21,934 DEBUG : BROWSER_OUTPUT: 08:51:22 INFO - 2015-10-22 08:51:22,670 INFO : Browser exited with error code: 0 08:51:23 INFO - 2015-10-22 08:51:23,546 INFO : Completed test kraken (00:01:03) 08:51:23 INFO - 2015-10-22 08:51:23,546 INFO : Starting test v8_7 08:51:23 INFO - 2015-10-22 08:51:23,546 DEBUG : operating with platform_type : w8_ 08:51:23 INFO - 2015-10-22 08:51:23,546 INFO : Initialising browser for v8_7 test... 08:51:23 INFO - 2015-10-22 08:51:23,568 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpbc8tva\profile http://localhost:49278/getInfo.html 08:51:29 INFO - 2015-10-22 08:51:29,049 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:51:29 INFO - 2015-10-22 08:51:29,049 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:51:29 INFO - 2015-10-22 08:51:29,049 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674 08:51:29 INFO - 2015-10-22 08:51:29,049 DEBUG : BROWSER_OUTPUT: __metrics 08:51:29 INFO - 2015-10-22 08:51:29,181 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:51:30 INFO - 2015-10-22 08:51:30,230 DEBUG : BROWSER_OUTPUT: console.error: 08:51:30 INFO - 2015-10-22 08:51:30,230 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] 08:51:30 INFO - 2015-10-22 08:51:30,230 DEBUG : BROWSER_OUTPUT: Stack: 08:51:30 INFO - 2015-10-22 08:51:30,230 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<._executeStatement@resource://gre/modules/Sqlite.jsm:758:19 08:51:30 INFO - 2015-10-22 08:51:30,230 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached/<@resource://gre/modules/Sqlite.jsm:493:9 08:51:30 INFO - 2015-10-22 08:51:30,230 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached@resource://gre/modules/Sqlite.jsm:491:1 08:51:30 INFO - 2015-10-22 08:51:30,230 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeBeforeShutdown/loggedDb<.executeCached.value<@resource://gre/modules/Sqlite.jsm:368:51 08:51:30 INFO - 2015-10-22 08:51:30,230 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 08:51:30 INFO - 2015-10-22 08:51:30,230 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 08:51:30 INFO - 2015-10-22 08:51:30,230 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 08:51:30 INFO - 2015-10-22 08:51:30,230 DEBUG : BROWSER_OUTPUT: setAncestorsLastModified<@resource://gre/modules/Bookmarks.jsm:1347:9 08:51:30 INFO - 2015-10-22 08:51:30,230 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 08:51:30 INFO - 2015-10-22 08:51:30,230 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 08:51:30 INFO - 2015-10-22 08:51:30,230 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 08:51:30 INFO - 2015-10-22 08:51:30,230 DEBUG : BROWSER_OUTPUT: transaction@resource://gre/modules/Bookmarks.jsm:808:13 08:51:30 INFO - 2015-10-22 08:51:30,230 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 08:51:30 INFO - 2015-10-22 08:51:30,230 DEBUG : BROWSER_OUTPUT: Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:934:23 08:51:30 INFO - 2015-10-22 08:51:30,230 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 08:51:30 INFO - 2015-10-22 08:51:30,230 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 08:51:30 INFO - 2015-10-22 08:51:30,230 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 08:51:30 INFO - 2015-10-22 08:51:30,230 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 08:51:30 INFO - 2015-10-22 08:51:30,230 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 08:51:30 INFO - 2015-10-22 08:51:30,230 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 08:51:30 INFO - 2015-10-22 08:51:30,230 DEBUG : BROWSER_OUTPUT: 08:51:30 INFO - 2015-10-22 08:51:30,941 INFO : Browser initialized. 08:51:30 INFO - 2015-10-22 08:51:30,941 INFO : Running cycle 1/1 for v8_7 test... 08:51:30 INFO - 2015-10-22 08:51:30,941 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpbc8tva\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\v8_7\v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:51:42 INFO - 2015-10-22 08:51:42,519 DEBUG : BROWSER_OUTPUT: RSS: Main: 203096064 08:51:42 INFO - 2015-10-22 08:51:42,519 DEBUG : BROWSER_OUTPUT: 08:52:04 INFO - 2015-10-22 08:52:04,272 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/v8_7/run.html (next: http://localhost:49278/tests/v8_7/run.html) 08:52:04 INFO - 2015-10-22 08:52:04,525 DEBUG : BROWSER_OUTPUT: RSS: Main: 710012928 08:52:04 INFO - 2015-10-22 08:52:04,525 DEBUG : BROWSER_OUTPUT: 08:52:04 INFO - 2015-10-22 08:52:04,525 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:52:04 INFO - 2015-10-22 08:52:04,525 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:52:04 INFO - 2015-10-22 08:52:04,525 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:52:04 INFO - 2015-10-22 08:52:04,525 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:52:04 INFO - 2015-10-22 08:52:04,525 DEBUG : BROWSER_OUTPUT: |0;Richards;172.62213015708613 08:52:04 INFO - 2015-10-22 08:52:04,525 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;175.62346329469617 08:52:04 INFO - 2015-10-22 08:52:04,525 DEBUG : BROWSER_OUTPUT: |2;Encrypt;287.35632183908046 08:52:04 INFO - 2015-10-22 08:52:04,525 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5159.79381443299 08:52:04 INFO - 2015-10-22 08:52:04,525 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1576.3779527559054 08:52:04 INFO - 2015-10-22 08:52:04,525 DEBUG : BROWSER_OUTPUT: |5;Earley;668.8963210702341 08:52:04 INFO - 2015-10-22 08:52:04,525 DEBUG : BROWSER_OUTPUT: |6;Boyer;12612.5 08:52:04 INFO - 2015-10-22 08:52:04,526 DEBUG : BROWSER_OUTPUT: |7;RegExp;29000 08:52:04 INFO - 2015-10-22 08:52:04,526 DEBUG : BROWSER_OUTPUT: |8;Splay;726.7441860465116 08:52:04 INFO - 2015-10-22 08:52:04,526 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4882.926829268293 08:52:04 INFO - 2015-10-22 08:52:04,526 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:52:04 INFO - 2015-10-22 08:52:04,526 DEBUG : BROWSER_OUTPUT: __startTimestamp1445529124523__endTimestamp 08:52:04 INFO - 2015-10-22 08:52:04,526 DEBUG : BROWSER_OUTPUT: 08:52:04 INFO - 2015-10-22 08:52:04,526 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:52:04 INFO - 2015-10-22 08:52:04,526 DEBUG : BROWSER_OUTPUT: Number of tests: 10 08:52:04 INFO - 2015-10-22 08:52:04,526 DEBUG : BROWSER_OUTPUT: 08:52:04 INFO - 2015-10-22 08:52:04,526 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:172.62 Median:172.62 stddev:0.00 (0.0%) 08:52:04 INFO - 2015-10-22 08:52:04,526 DEBUG : BROWSER_OUTPUT: Values: 172.6 08:52:04 INFO - 2015-10-22 08:52:04,526 DEBUG : BROWSER_OUTPUT: 08:52:04 INFO - 2015-10-22 08:52:04,526 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:175.62 Median:175.62 stddev:0.00 (0.0%) 08:52:04 INFO - 2015-10-22 08:52:04,526 DEBUG : BROWSER_OUTPUT: Values: 175.6 08:52:04 INFO - 2015-10-22 08:52:04,526 DEBUG : BROWSER_OUTPUT: 08:52:04 INFO - 2015-10-22 08:52:04,526 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:287.36 Median:287.36 stddev:0.00 (0.0%) 08:52:04 INFO - 2015-10-22 08:52:04,526 DEBUG : BROWSER_OUTPUT: Values: 287.4 08:52:04 INFO - 2015-10-22 08:52:04,526 DEBUG : BROWSER_OUTPUT: 08:52:04 INFO - 2015-10-22 08:52:04,526 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5159.79 Median:5159.79 stddev:0.00 (0.0%) 08:52:04 INFO - 2015-10-22 08:52:04,526 DEBUG : BROWSER_OUTPUT: Values: 5159.8 08:52:04 INFO - 2015-10-22 08:52:04,526 DEBUG : BROWSER_OUTPUT: 08:52:04 INFO - 2015-10-22 08:52:04,526 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1576.38 Median:1576.38 stddev:0.00 (0.0%) 08:52:04 INFO - 2015-10-22 08:52:04,526 DEBUG : BROWSER_OUTPUT: Values: 1576.4 08:52:04 INFO - 2015-10-22 08:52:04,526 DEBUG : BROWSER_OUTPUT: 08:52:04 INFO - 2015-10-22 08:52:04,526 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:668.90 Median:668.90 stddev:0.00 (0.0%) 08:52:04 INFO - 2015-10-22 08:52:04,526 DEBUG : BROWSER_OUTPUT: Values: 668.9 08:52:04 INFO - 2015-10-22 08:52:04,526 DEBUG : BROWSER_OUTPUT: 08:52:04 INFO - 2015-10-22 08:52:04,526 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12612.50 Median:12612.50 stddev:0.00 (0.0%) 08:52:04 INFO - 2015-10-22 08:52:04,526 DEBUG : BROWSER_OUTPUT: Values: 12612.5 08:52:04 INFO - 2015-10-22 08:52:04,526 DEBUG : BROWSER_OUTPUT: 08:52:04 INFO - 2015-10-22 08:52:04,526 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:29000.00 Median:29000.00 stddev:0.00 (0.0%) 08:52:04 INFO - 2015-10-22 08:52:04,528 DEBUG : BROWSER_OUTPUT: Values: 29000.0 08:52:04 INFO - 2015-10-22 08:52:04,528 DEBUG : BROWSER_OUTPUT: 08:52:04 INFO - 2015-10-22 08:52:04,528 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:726.74 Median:726.74 stddev:0.00 (0.0%) 08:52:04 INFO - 2015-10-22 08:52:04,528 DEBUG : BROWSER_OUTPUT: Values: 726.7 08:52:04 INFO - 2015-10-22 08:52:04,528 DEBUG : BROWSER_OUTPUT: 08:52:04 INFO - 2015-10-22 08:52:04,528 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4882.93 Median:4882.93 stddev:0.00 (0.0%) 08:52:04 INFO - 2015-10-22 08:52:04,528 DEBUG : BROWSER_OUTPUT: Values: 4882.9 08:52:04 INFO - 2015-10-22 08:52:04,528 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:52:04 INFO - 2015-10-22 08:52:04,528 DEBUG : BROWSER_OUTPUT: 08:52:05 INFO - 2015-10-22 08:52:05,292 INFO : Browser exited with error code: 0 08:52:05 INFO - 2015-10-22 08:52:05,980 INFO : Completed test v8_7 (00:00:42) 08:52:06 INFO - 2015-10-22 08:52:06,361 INFO : Completed test suite (00:20:28) 08:52:06 INFO - 2015-10-22 08:52:06,361 DEBUG : Working with test: dromaeo_css 08:52:06 INFO - 2015-10-22 08:52:06,361 DEBUG : Generating results file: dromaeo_css 08:52:06 INFO - 2015-10-22 08:52:06,361 DEBUG : Working with test: kraken 08:52:06 INFO - 2015-10-22 08:52:06,361 DEBUG : Generating results file: kraken 08:52:06 INFO - 2015-10-22 08:52:06,362 INFO : javascript benchmark 08:52:06 INFO - 2015-10-22 08:52:06,362 DEBUG : Working with test: v8_7 08:52:06 INFO - 2015-10-22 08:52:06,362 DEBUG : Generating results file: v8_7 08:52:06 INFO - 2015-10-22 08:52:06,362 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:52:06 INFO - 2015-10-22 08:52:06,444 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,131,31]] 08:52:06 INFO - 2015-10-22 08:52:06,444 DEBUG : process_Request line: dromaeo_css 6205.82 graph.html#tests=[[72,131,31]] 08:52:06 INFO - 2015-10-22 08:52:06,444 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:52:06 INFO - 2015-10-22 08:52:06,506 DEBUG : process_Request line: kraken 1508.30 graph.html#tests=[[232,131,31]] 08:52:06 INFO - 2015-10-22 08:52:06,506 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:52:06 INFO - 2015-10-22 08:52:06,575 DEBUG : process_Request line: v8_7 19985.21 graph.html#tests=[[230,131,31]] 08:52:06 INFO - 2015-10-22 08:52:06,575 INFO : javascript benchmark 08:52:06 INFO - 2015-10-22 08:52:06,578 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [354.27904214922637, 355.28587539046526, 358.9748717589769, 360.922401683638, 361.5318162978942, 13711.931440342785, 14190.503332383369, 14826.481073162427, 15261.542153735392, 15943.123128227957, 14039.578812635636, 15980.167238957783, 16069.758953615705, 16614.50156495304, 16662.333506659717, 5224.320838291026, 5375.623706340538, 5376.677399356051, 5377.11277639189, 5377.892442151155, 3877.476540667002, 3989.760614363133, 5235.476452354753, 5267.47325267474, 5745.080787074069, 5980.491658209057, 5996.9205543002245, 6039.063945088518, 6048.969755151218, 6054.273487181523, 5828.41715828418, 5841.795537156179, 5901.704914754288, 5957.672328021957, 6000.0, 5091.185410334366, 5140.074786538422, 5160.92258616121, 5180.689158650455, 5183.792648294064, 18900.62198756031, 19059.142338594796, 19133.0, 19165.233390664358, 19603.607927841364, 1861.6555937151534, 1873.6908410112314, 1959.0009095361327, 2042.7855075217185, 2563.102913980092, 12210.877891221151, 12223.449944752418, 12337.629871103882, 12402.75194496105, 12527.0, 1718.2611477064856, 1756.1043867627602, 1778.4042345814169, 1807.0, 1813.1206364913007, 51334.743326283504, 52474.21288680673, 53098.0, 53264.0, 54702.0, 8287.62705678246, 8309.916900830915, 8315.41792074561, 8480.957595211985, 8490.787730306793, 10460.0, 10654.786904261871, 10655.094316982988, 10667.573297068186, 10737.302075365076, 6669.633170175687, 6678.23200331968, 6680.331966803378, 6728.629925354153, 6734.292899245509, 6656.267810540837, 6668.466522678174, 6731.091302674175, 6740.123783908159, 6757.932420675828, 5215.25901855042, 5221.190715439113, 5259.289995850588, 5299.364076310867, 5383.919241211385, 1652.0996057148882, 1710.5125039363722, 1715.4596302164778, 1716.262007336832, 1813.310941842118, 856.2850020233051, 911.462237280008, 971.4656938683696, 1007.5012868630075, 1008.4604736465956, 15901.761473577906, 16233.756493652605, 16308.347666093461, 16360.67278654444, 16511.17444127813, 883.8983516895511, 902.120432578231, 919.1497864475333, 925.1026504290827, 975.11264749078, 9539.47532885698, 9580.461177787893, 9606.27952903535, 9637.807243855084, 9767.072128147815, 417731.0, 418298.0, 428602.0, 429804.0, 430790.0, 41780.0, 56002.43997560054, 56245.0, 56633.433665662815, 58108.41891581115, 469.666536758905, 474.5871092149783, 477.99859294777383, 480.7668280883769, 482.5946205187659, 7864.2922137007945, 9694.321397502106, 9733.707988760349, 9882.407055576688, 9945.353552019096, 29940.251493712833, 30298.69701302959, 30376.544351834298, 30523.542146868258, 31358.216044598154, 38587.807060964515, 38644.0, 39533.0, 39790.80104599459, 40024.1995160101, 6079.696015199134, 6099.359567245376, 6113.755449782137, 6143.539234557336, 6157.507399407947, 9296.39573427725, 10413.47932603382, 10816.513256903301, 11225.494852731483, 11306.660800176009, 8241.546714930737, 9303.395279307095, 9410.24718022543, 9825.950870245602, 9845.113939745457, 9218.21645160169, 9271.490068046322, 9305.674301399418, 9345.626174952926, 9528.571214295234, 9604.94345621995, 9756.707298780764, 9901.801963960825, 9934.45360505179, 10015.24885633595, 6003.199040287984, 6088.573799833969, 6130.662813545119, 6135.723892424762, 6150.0, 9220.907790922005, 9808.950955245178, 9817.754556136153, 9962.651307204504, 10160.542775575264], "dojo.html": [2586.327554835743, 2622.226443199256, 2653.0449038346196, 2657.561502352112, 2663.7336266373377, 4728.763561821908, 4744.596709279711, 4745.288206768978, 4746.5490778376, 4797.856064318067, 4824.879378015551, 4830.033993201365, 4840.298156767267, 4841.951580484194, 4897.632677549181, 4225.0, 4360.236958532244, 4382.97808510957, 4397.032652816391, 4449.688521803459, 4345.587169218919, 4350.97824510877, 4360.847370342039, 4362.345648152786, 4363.236433624119, 4338.0, 4352.434183556134, 4355.259605867011, 4355.912881742363, 4364.454443194601, 4326.697131200817, 4344.522102568715, 4344.913101737963, 4359.346098085281, 4372.497162826284, 4203.789810509462, 4228.175505776375, 4281.785910704483, 4286.828526858922, 4322.675799315032, 4662.696924699883, 4666.440027196724, 4672.813087476497, 4686.133065382915, 4726.7163970161555, 4773.594244489223, 4878.853634390974, 4899.142650036265, 4969.428515720666, 4975.527324904128, 4767.165745994437, 4958.677685950402, 4961.677490963076, 4965.875853103666, 4973.676711013773, 4507.301368287921, 4566.223741963874, 4573.474050484204, 4574.977125114353, 4618.399608050965, 5032.999193684898, 5105.285260063594, 5113.463086375951, 5114.846554603368, 5160.303359046481, 4780.091782561302, 4866.586340161126, 4907.631927605373, 4918.286848407032, 4923.0, 4812.109759694467, 4858.441279252931, 4870.464248932614, 4873.951260487421, 4922.852314430573, 4937.506249375034, 4965.826196083192, 4969.0, 4969.82605608802, 5020.196768517019, 4745.572898439157, 4862.5380588844, 4958.876028099255, 4968.8757781055765, 4985.52637499437, 3262.5269335946155, 3277.9836100819343, 3323.883664071794, 3340.0, 3353.84907679155, 3055.1140169351083, 3061.142879993605, 3071.232191952012, 3099.891503797356, 3109.564660947424, 4465.933011004838, 4597.7241365518175, 4600.976995115003, 4604.700694454849, 4653.627709783209, 4949.307097006422, 4960.057589058068, 4972.975135124301, 5052.797888084436, 5059.595232381401, 4585.839495617704, 4591.0, 4603.286490593963, 4609.216433206363, 4652.883677908079, 3982.7411218270718, 4087.8160482777753, 4121.443605113332, 4147.170565886835, 4190.099128687347, 4965.776540055706, 4982.800687972513, 4999.400071991385, 5049.924251136309, 5092.261622064854, 4980.477049909852, 5027.296178534935, 5037.773300201573, 5042.168042272984, 5087.186050231945, 4808.3989501312335, 4937.5556199942175, 5060.671056381323, 5061.0, 5062.265971434195, 4779.330893674819, 4842.346283251716, 4852.902941941071, 4898.461169271306, 4905.583025442877, 4902.093112774006, 5025.798968041384, 5035.647504674637, 5040.647154699136, 5085.796568137233, 4691.554302341272, 4779.330893674819, 4850.975745121252, 4915.508449155056, 4957.281194226889, 4754.619630429626, 4780.737059461763, 4840.903181936412, 4849.369581954324, 4892.31507588945, 4818.204996175592, 4836.95163048365, 4843.733594652328, 4853.247746599282, 4908.018396320679, 4664.463586687574, 4833.830815921426, 4917.6311776616185, 4924.655274130777, 4983.775730092082, 4768.523147685342, 4820.25286080658, 4824.517548245148, 4838.854834354975, 4839.0], "mootools.html": [1315.4738104758098, 1531.9080855148693, 1586.9603259918501, 1787.0885848217422, 1809.068329810148, 7181.138263408386, 7313.341799238067, 8298.75103746887, 8469.534175620338, 8472.788180295496, 8163.551004694739, 8381.317978246963, 8463.19599638035, 8476.830463390728, 8496.660133594649, 2144.895378879874, 2169.837262205333, 2174.0, 2175.7824217578273, 2176.34709587124, 1914.3778272061636, 1950.1419375474816, 2166.9241576544746, 2187.84685072045, 2226.8441209115367, 2130.9680354794614, 2132.968005479919, 2149.0, 2158.7625361210253, 2162.9567408651897, 1895.8767680100887, 2162.4485756132162, 2176.3144609447972, 2180.1279488204846, 2180.3894909425385, 1901.9714704279447, 2145.452909508081, 2191.495955930145, 2202.7797220278003, 2204.1844517528457, 8465.53439560824, 8556.61495232716, 8559.914400855974, 8560.443571167916, 8567.143285671384, 4667.88330291742, 4746.857594272177, 4748.95251047492, 4750.358701575312, 4754.976225118852, 2719.646445962032, 2765.723427657218, 2834.6881842997254, 2841.3891013432212, 2843.786715996288, 800.5516910530122, 803.7186984555417, 808.0142226483681, 816.302061737218, 840.8192238668654, 12608.36958152098, 12621.242725436503, 12633.0, 12680.492780288869, 12696.984241260678, 4186.6859985501205, 4318.719283246579, 4399.890002749893, 4443.6667249955735, 4455.710378825366, 10524.0, 10539.94730026345, 10540.262181647364, 10572.365658060387, 10618.442821654831, 4641.0, 4692.671512994126, 4696.788644511005, 4697.4832768395445, 4697.95302046982, 4241.703080784316, 4254.106637606075, 4256.765877876746, 4257.19113368459, 4259.8083086261195, 3779.5464544254864, 3792.1088544192094, 3811.542614886176, 3871.5934826842777, 3878.864239751595, 1154.8614166300097, 1159.1422347462817, 1162.0006794157018, 1167.3054532553117, 1168.2464810197375, 1142.5258517715222, 1146.2721172055637, 1181.6927598824195, 1185.5554167187304, 1210.9333986630643, 7712.190220026816, 7772.0, 7836.764897053097, 7864.41016923733, 7894.0, 471.0155774431386, 474.9002709430989, 485.06866815713914, 491.99016019680124, 492.1706923833352, 5721.485066344049, 5864.618799778001, 5989.940100599026, 6105.0, 6232.594881332699, 9958.950205249072, 10093.444860532594, 10094.848577271347, 10108.898911010796, 10115.898841011644, 9750.366226195274, 9780.266480014028, 9879.209663226924, 9881.604735810488, 9927.056929591678, 7383.889241661272, 7402.333789958821, 7488.101427828696, 7489.325960663457, 7491.66287517063, 7768.184340644377, 7854.253845884632, 7867.370610351272, 7874.251946065115, 7899.526028438312, 8788.296936245213, 8998.190162885372, 9023.90976090257, 9025.729228123168, 9037.0, 9136.908630913606, 9289.674861379819, 9397.718068457958, 9424.198943089914, 9465.526723663927, 7231.842905135153, 7406.4074874008875, 7418.740344087931, 7427.5914824683, 7431.145418276968, 8046.994125734283, 8120.715774947848, 8136.593170341577, 8139.023317201973, 8158.755237342889, 7402.888956665762, 7577.0, 7635.885461717968, 7688.577128258, 7723.922760772545, 7280.381167600814, 7371.447141464304, 7514.774556763306, 7560.470767046254, 7581.848363032819, 7611.64039147866, 7661.731839385595, 7672.884906726292, 7704.961475192588, 7740.574268415291, 6216.347283535164, 6269.592476489013, 6289.528285378707, 6651.334866513504, 6852.794416167523, 6773.62745049027, 7169.5698258104685, 7176.246494118252, 7201.279872012757, 7231.2768723127265], "ext.html": [576.1099101887584, 577.566824881339, 579.5711173731437, 584.4739734239182, 595.0152497616447, 28995.27511812206, 29699.25751856202, 35281.0, 36554.8172259139, 36805.63194368056, 38978.0, 39038.804805976004, 39471.0, 39685.801570992175, 39712.00719982002, 7367.0, 8395.160483951617, 8567.657293708244, 8573.699920502784, 8590.0, 7589.013428254347, 10283.948580257125, 10481.947590262076, 10566.418846963414, 10585.100266477359, 10166.542505587266, 10368.53341599626, 10371.71822199115, 10371.844422333672, 10372.688819335432, 7657.885131723028, 7859.135495095535, 10062.698119056404, 10120.190384769237, 10349.637762678345, 10026.89973100267, 10184.74088291747, 10189.59241630334, 10195.847062294071, 10200.041987823523, 36615.26769464596, 36673.0, 37035.62964370376, 37499.25001499982, 37642.623573764184, 2786.511926888946, 2789.246903336088, 2880.4095160492047, 3551.289742051574, 3579.176789338441, 27259.591106133423, 27630.72369276322, 27775.722242777516, 27814.721852781415, 28002.299942501395, 2549.6303036059853, 2620.4235068284947, 2623.081921327539, 2635.920922372332, 2666.266776636421, 237273.0, 238581.0, 238729.0, 238835.0, 240488.0, 50008.749956250715, 50468.49531504711, 51173.232401514004, 53033.332666813236, 53498.73250633722, 49157.0, 49228.0, 49242.0, 49272.50727492679, 49566.50433495619, 13870.861291387158, 13903.0, 14023.158610483404, 14039.578812635636, 14156.646083847987, 10698.839517407245, 10932.508037138348, 10984.725381865517, 11020.393878336768, 11042.944785276182, 16553.337866485206, 16659.583510412092, 16689.83310166907, 16781.24484398205, 16813.243404046847, 7428.777136685908, 7489.101307842985, 7598.20218877021, 7614.390848732088, 7646.617669116522, 847.766864112374, 947.7251597036782, 963.4845357733719, 978.2320878110648, 1082.1937656445841, 26397.47205055888, 26719.46561068768, 27020.59469107965, 27060.0, 27183.320416989733, 1000.9799804004025, 1015.9644412445529, 1019.5106348952544, 1039.3763741754888, 1094.96167634134, 13840.584782456543, 14145.717085658434, 14219.0, 14221.0, 14245.78631320531, 277679.0, 281648.0, 281667.0, 281760.0, 281931.0, 48923.755381222865, 49256.0, 49535.752321238884, 49919.50080499221, 49955.0, 1206.5113628980278, 1289.1105137455313, 1294.9805752913715, 1296.6110166949877, 1310.8361454818148, 25674.486510270064, 26127.869360653076, 26258.474830502902, 26298.0, 26385.208443746717, 39280.410793837545, 39474.210515790095, 39600.40599391069, 39601.009974750865, 39636.60363396329, 208346.0, 208643.0, 210115.0, 210469.0, 210669.0, 24150.154744584557, 27614.44771104607, 28473.857630711715, 28613.28466788347, 28802.42395152043, 34097.14757131092, 38648.42027369648, 39737.2052558953, 39744.801275993435, 39859.0, 30261.243468913453, 30796.692033079384, 33192.83403582966, 34081.0, 35863.46204806878, 33092.33815323728, 33664.15839604029, 33772.831135844164, 33822.66177338293, 33826.83086584551, 33683.3263334727, 34051.65948340485, 34114.0, 34196.82901585476, 34328.313433730684, 28764.712352876202, 29904.70095299019, 30390.392192156476, 30487.695123048485, 30626.387472250877, 18006.639867202844, 22119.225827095976, 23010.19464318741, 23108.191213307455, 23732.88133559321], "prototype.html": [316.1385225261164, 323.6439916092297, 324.50188959946473, 324.71425145871643, 332.7737138745652, 5167.689938603687, 5228.346456692913, 5245.134552798783, 5256.658317209379, 5258.52673259407, 5123.769430375642, 5195.506426889439, 5202.089634313998, 5210.791568337271, 5236.528712415882, 4061.1877624475073, 4085.754854708712, 4095.1400205956784, 4095.508538975312, 4097.774622395767, 3927.1360300733936, 3979.3235150024566, 4005.0, 4019.296623090962, 4076.6738660907204, 4033.475648165734, 4042.7170098093147, 4049.2913740095514, 4053.837846486137, 4054.898627534306, 3945.940810887839, 4033.5764744701823, 4048.9595104048876, 4051.4530538377235, 4052.675785937133, 3546.85812567497, 3562.8040457774814, 3579.677828995377, 3580.856765729368, 3585.7848529088337, 4982.402111746577, 5034.270030845507, 5039.294498770175, 5047.141985862412, 5047.570956468705, 4514.751688657123, 4516.1193567254395, 4534.546545345472, 4574.908501829945, 4586.312053192048, 5325.866853328698, 5347.465253474621, 5391.649542779746, 5400.810971616014, 5417.052015897202, 3618.0, 3680.871169509054, 3744.6255374462608, 3795.9430608540893, 3798.126430920876, 5528.170774383834, 5539.2522009529, 5587.329520457531, 5588.580856435743, 5595.608307418483, 3876.341022026262, 3885.805709714503, 3929.410588411704, 3934.252492026506, 3935.665468435158, 3987.940180897289, 3988.581198974124, 3989.3816458448987, 3989.960100399017, 3990.8204130814183, 4417.271150260235, 4543.273076307775, 4546.181687296318, 4572.634189264917, 4584.701994370355, 5445.945540544544, 5447.155690867922, 5447.237386765856, 5449.5640348772, 5451.836444906659, 1402.2568038939175, 1445.5013020507909, 1446.4214314274375, 1448.1383576771805, 1448.6885319656114, 941.5292353823088, 951.4671783801093, 955.1690029674089, 983.9852402213972, 985.014985014985, 5085.771140298695, 5087.618428617869, 5088.771005304696, 5089.134847076006, 5090.720010399389, 5559.833205003856, 5591.944080559142, 5618.410066942994, 5618.988582055269, 5626.381098079208, 5078.035173317058, 5080.923786143211, 5085.64400491962, 5087.0, 5092.745362731923, 3043.284828065403, 3088.9034392790686, 3100.767442441781, 3113.610798650169, 3120.2043478912733, 5575.972120139373, 5647.491725744702, 5647.548196144298, 5648.181013752983, 5677.858053548694, 5734.16854556087, 5734.96770581291, 5740.56945729072, 5744.770209191669, 5745.68398738065, 5630.042892708249, 5651.886962260732, 5656.377798442086, 5657.6039677223025, 5665.49010589049, 5477.4796394342475, 5595.608307418604, 5621.775128994795, 5624.85937851557, 5650.689212093374, 5344.118220493575, 5429.158480435539, 5460.0, 5483.588730845282, 5490.0941344677685, 5559.16612508127, 5635.577331700057, 5640.407757185437, 5641.26663533738, 5648.774049037993, 3880.8253628586217, 3901.1027463682944, 3910.9804450977563, 3916.0797212654434, 3918.314294998421, 5578.832635020955, 5599.972000139973, 5602.4957753802355, 5603.719814009365, 5608.242887210175, 5284.497972692588, 5441.945580544144, 5478.287822583039, 5543.307086614173, 5547.195656629847, 5518.255035570307, 5532.695701736282, 5537.003339398947, 5537.889242215053, 5541.639793413416, 5397.730113494388, 5445.1832225166545, 5446.346438427414, 5452.26394436746, 5457.481539253765, 5398.838034858961, 5507.779688812403, 5551.750171242223, 5553.722313884209, 5554.250176226158, 5352.866178345573, 5423.050966080999, 5431.212474191299, 5433.429489903503, 5436.021516126977], "yui.html": [821.0909635098396, 822.8313195794863, 835.7367429259783, 849.5072857742506, 852.7527017165022, 11659.766804663901, 11832.23090499117, 11850.822237666442, 11851.170418070727, 11884.643460696183, 11089.500972456239, 11186.664400068012, 11195.104391648669, 11208.887911120886, 11219.15856310776, 658.38112174556, 666.7766298290079, 797.9481333713319, 817.8527864984301, 821.6959724901794, 810.7040930060544, 811.6469335838899, 817.8568750468673, 818.4475479051646, 820.1921107708931, 712.8182313510074, 852.3436953545767, 859.2524503681806, 859.2953777902122, 859.4886042804521, 714.0075295339482, 845.3237410071948, 851.5657014922373, 858.2233079063458, 860.6686425726078, 635.1711017122653, 637.2321352769901, 637.3180696654581, 637.4613451633362, 637.9968100159516, 11415.771684566345, 11496.597619083375, 11496.712582185428, 11564.942175289154, 11571.884281157165, 9911.553980070914, 10211.79576408475, 10308.536115874804, 10729.9463502682, 10735.40955247461, 8093.919060809375, 8614.612342444605, 9095.727128186165, 9411.90588094117, 9512.63117753977, 3388.7119594834467, 3415.777974431679, 3440.0195944155794, 3441.5353927219753, 3454.792712437262, 32033.679663203537, 32538.511922320948, 32663.51004734907, 32702.182445438815, 32824.6717532824, 8729.083446238054, 8742.431741936754, 8789.604467798836, 8811.23815486753, 8832.0, 15067.773983390258, 15280.617984550476, 15284.770728439082, 15290.0, 15298.770518442232, 6339.397757213057, 6379.776707815297, 6395.328490508523, 6427.775027874002, 6573.835654108686, 3497.213127046445, 3546.91132721684, 3657.0, 3772.1512659651908, 3801.581825999138, 2665.2537289558954, 2741.7121202273875, 2742.437800250944, 2743.0947787230166, 2751.435955629091, 449.8717865408343, 459.46701825881814, 460.41067433684935, 460.5095573214516, 463.81215607678945, 434.44608124640706, 448.63884572919113, 461.55229427455316, 463.35130816856673, 467.5978658353881, 6975.267596902354, 7027.89458158128, 7246.637668116573, 7353.926460735431, 7398.926010739931, 470.04815249120804, 590.7902694543461, 594.5303210463685, 628.613402757301, 635.259922190652, 3081.4453398388505, 3242.4001559711055, 3289.1777055736065, 3363.344147891187, 3364.8149351785396, 40279.0, 40444.0, 40718.18563628711, 40765.59234407677, 40820.38769418461, 34207.4868876967, 34476.82761586226, 34959.12602184965, 35351.64648353535, 35354.0, 30089.548656770166, 30595.2351191222, 30596.23509412238, 30750.53874191889, 30787.538186927213, 6956.443484521327, 6980.930190698028, 7118.893216601651, 7145.928540714526, 7484.550926944401, 20827.583448330646, 21129.154833806475, 21362.57274854463, 21395.786042140004, 21443.142274309477, 27074.1877743668, 27378.726212737616, 27487.312817178932, 28724.281892952007, 30246.09261722152, 6721.092652492047, 6783.59298442095, 6810.62541560219, 6853.000933501858, 6966.303369662993, 10547.841782373118, 10625.362478251329, 10875.401852898167, 11029.61396351124, 11115.888841111486, 9228.261739060994, 9369.859452108087, 9381.530923453936, 9551.331406801457, 9983.500824958868, 9604.375715578464, 9634.518274086407, 9658.855117173107, 9676.9032309676, 10034.69895903124, 8770.736877893672, 8857.557122143739, 8878.378513503993, 8988.505632190292, 9033.50315732641, 8324.583770811556, 8612.48325100496, 8861.33539984491, 8890.33322500802, 8916.242119419921, 7813.531188128731, 7991.4006449515355, 8067.717629882926, 8090.757277281691, 8528.573571321533]}, "summary": {"suite": 6205.8173680511145, "subtests": {"jquery.html": {"filtered": 7534.217788992585, "value": 7534.217788992585}, "dojo.html": {"filtered": 4548.587975475403, "value": 4548.587975475403}, "mootools.html": {"filtered": 4507.272880483093, "value": 4507.272880483093}, "ext.html": {"filtered": 17074.783728830873, "value": 17074.783728830873}, "prototype.html": {"filtered": 4146.7365295082345, "value": 4146.7365295082345}, "yui.html": {"filtered": 5222.28738057913, "value": 5222.28738057913}}}, "test_machine": {"platform": "x86_64", "osversion": "6.2.9200", "os": "win", "name": "T-W864-IX-084"}, "testrun": {"date": 1445527897, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a1", "id": "20151022064307", "branch": "Mozilla-Inbound-Non-PGO", "revision": "d43d4d4e26fbb3f9a2217a53bb61cfab1828f6dc"}}, {"talos_counters": {}, "results": {"audio-dft": [144.0, 143.0, 140.0, 148.0, 142.0, 140.0, 141.0, 143.0, 140.0, 139.0], "ai-astar": [113.0, 112.0, 107.0, 112.0, 113.0, 112.0, 113.0, 111.0, 106.0, 111.0], "imaging-gaussian-blur": [110.0, 111.0, 112.0, 110.0, 111.0, 111.0, 111.0, 110.0, 111.0, 110.0], "audio-beat-detection": [138.0, 135.0, 151.0, 169.0, 130.0, 139.0, 138.0, 134.0, 159.0, 134.0], "json-stringify-tinderbox": [69.0, 69.0, 69.0, 70.0, 69.0, 69.0, 69.0, 69.0, 68.0, 69.0], "stanford-crypto-pbkdf2": [150.0, 152.0, 161.0, 161.0, 160.0, 151.0, 161.0, 161.0, 164.0, 162.0], "json-parse-financial": [72.0, 74.0, 73.0, 72.0, 72.0, 78.0, 74.0, 88.0, 72.0, 71.0], "stanford-crypto-sha256-iterative": [76.0, 75.0, 77.0, 76.0, 76.0, 75.0, 76.0, 77.0, 76.0, 75.0], "audio-fft": [69.0, 72.0, 72.0, 92.0, 68.0, 71.0, 69.0, 72.0, 97.0, 68.0], "imaging-darkroom": [131.0, 131.0, 131.0, 132.0, 131.0, 133.0, 132.0, 132.0, 131.0, 131.0], "stanford-crypto-ccm": [123.0, 124.0, 125.0, 131.0, 139.0, 130.0, 132.0, 124.0, 134.0, 134.0], "audio-oscillator": [91.0, 90.0, 112.0, 91.0, 91.0, 91.0, 119.0, 91.0, 92.0, 120.0], "stanford-crypto-aes": [89.0, 91.0, 91.0, 91.0, 91.0, 91.0, 95.0, 92.0, 91.0, 90.0], "imaging-desaturate": [98.0, 96.0, 96.0, 97.0, 96.0, 107.0, 97.0, 99.0, 97.0, 97.0]}, "summary": {"suite": 1508.3000000000002, "subtests": {"audio-fft": {"filtered": 75.0, "value": 75.0}, "stanford-crypto-pbkdf2": {"filtered": 158.3, "value": 158.3}, "audio-beat-detection": {"filtered": 142.7, "value": 142.7}, "stanford-crypto-ccm": {"filtered": 129.6, "value": 129.6}, "imaging-darkroom": {"filtered": 131.5, "value": 131.5}, "json-parse-financial": {"filtered": 74.6, "value": 74.6}, "audio-oscillator": {"filtered": 98.8, "value": 98.8}, "ai-astar": {"filtered": 111.0, "value": 111.0}, "audio-dft": {"filtered": 142.0, "value": 142.0}, "stanford-crypto-sha256-iterative": {"filtered": 75.9, "value": 75.9}, "json-stringify-tinderbox": {"filtered": 69.0, "value": 69.0}, "imaging-gaussian-blur": {"filtered": 110.7, "value": 110.7}, "stanford-crypto-aes": {"filtered": 91.2, "value": 91.2}, "imaging-desaturate": {"filtered": 98.0, "value": 98.0}}}, "test_machine": {"platform": "x86_64", "osversion": "6.2.9200", "os": "win", "name": "T-W864-IX-084"}, "testrun": {"date": 1445527897, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a1", "id": "20151022064307", "branch": "Mozilla-Inbound-Non-PGO", "revision": "d43d4d4e26fbb3f9a2217a53bb61cfab1828f6dc"}}, {"talos_counters": {}, "results": {"DeltaBlue": [175.62346329469617], "Encrypt": [287.35632183908046], "NavierStokes": [4882.926829268293], "Decrypt": [5159.79381443299], "Splay": [726.7441860465116], "Richards": [172.62213015708613], "RegExp": [29000.0], "Earley": [668.8963210702341], "Boyer": [12612.5], "RayTrace": [1576.3779527559054]}, "summary": {"suite": 19985.212369906505, "subtests": {"DeltaBlue": {"filtered": 376.47589199999993, "value": 376.47589199999993}, "Encrypt": {"filtered": 926.3098800000001, "value": 926.3098800000001}, "NavierStokes": {"filtered": 303.91608391608383, "value": 303.91608391608383}, "Decrypt": {"filtered": 51.587526473526495, "value": 51.587526473526495}, "Splay": {"filtered": 112.13161600000004, "value": 112.13161600000004}, "RegExp": {"filtered": 31.413275862068968, "value": 31.413275862068968}, "Richards": {"filtered": 204.50448600000007, "value": 204.50448600000007}, "Earley": {"filtered": 996.3621850000001, "value": 996.3621850000001}, "Boyer": {"filtered": 52.84146679881068, "value": 52.84146679881068}, "RayTrace": {"filtered": 469.42359140859156, "value": 469.42359140859156}}}, "test_machine": {"platform": "x86_64", "osversion": "6.2.9200", "os": "win", "name": "T-W864-IX-084"}, "testrun": {"date": 1445527897, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a1", "id": "20151022064307", "branch": "Mozilla-Inbound-Non-PGO", "revision": "d43d4d4e26fbb3f9a2217a53bb61cfab1828f6dc"}}] 08:52:06 INFO - RETURN: dromaeo_css: 6205.82 08:52:06 INFO - RETURN: kraken: 1508.30 08:52:06 INFO - RETURN: v8_7: 19985.21 08:52:06 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,131,31]]", "result": "19985.21"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,131,31]]", "result": "1508.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,131,31]]", "result": "6205.82"}}} 08:52:06 INFO - Return code: 0 08:52:06 INFO - # TBPL SUCCESS # 08:52:06 INFO - Running post-action listener: _resource_record_post_action 08:52:06 INFO - Running post-run listener: _resource_record_post_run 08:52:07 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 95586816; Write bytes: 385838592; Read time: 1275950; Write time: 4230280 08:52:07 INFO - install - Wall time: 2s; CPU: 12.0%; Read bytes: 0; Write bytes: 3930112; Read time: 0; Write time: 26270 08:52:07 INFO - run-tests - Wall time: 1230s; CPU: 13.0%; Read bytes: 95586816; Write bytes: 348784128; Read time: 1275950; Write time: 4171330 08:52:07 INFO - Running post-run listener: _upload_blobber_files 08:52:07 INFO - Blob upload gear active. 08:52:07 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 08:52:07 INFO - Copying logs to upload dir... 08:52:07 INFO - mkdir: C:\slave\test\build\upload\logs program finished with exit code 0 elapsedTime=1480.107000 ========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 24 mins, 40 secs) (at 2015-10-22 08:52:07.830583) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-22 08:52:07.834258) ========= '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-084\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-084 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-084 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-084\AppData\Local LOGONSERVER=\\T-W864-IX-084 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-084 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-084 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-084 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False build_url:https://queue.taskcluster.net/v1/task/HtB_sZClS8uOWjcyyeoKSg/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/HtB_sZClS8uOWjcyyeoKSg/artifacts/public/build/firefox-44.0a1.en-US.win64.zip' ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-22 08:52:07.982490) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-22 08:52:07.982861) ========= '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-084\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-084 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-084 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-084\AppData\Local LOGONSERVER=\\T-W864-IX-084 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-084 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-084 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-084 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=0.101000 ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-22 08:52:08.123204) ========= ========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2015-10-22 08:52:08.123521) ========= ========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2015-10-22 08:52:08.571807) =========