builder: mozilla-inbound_win8_64_test-dromaeojs slave: t-w864-ix-054 starttime: 1445480047.99 results: success (0) buildid: 20151021172720 builduid: 5a1f76d56b714cc28a930f252e173218 revision: 7e37f3445ffea580864bfde8e5c0efbc6cf2274b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-21 19:14:07.991924) ========= master: http://buildbot-master111.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-21 19:14:07.993537) ========= ========= Started set props: basedir (results: 0, elapsed: 1 secs) (at 2015-10-21 19:14:07.994227) ========= 'cd' in dir C:\slave\test\. (timeout 1200 secs) watching logfiles {} argv: ['cd'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-054\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-054 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-054 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-054\AppData\Local LOGONSERVER=\\T-W864-IX-054 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-054 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-054 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-054 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False C:\slave\test program finished with exit code 0 elapsedTime=1.398000 basedir: 'C:\\slave\\test' ========= Finished set props: basedir (results: 0, elapsed: 1 secs) (at 2015-10-21 19:14:09.454967) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-21 19:14:09.455290) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-21 19:14:09.633235) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-21 19:14:09.633610) ========= '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-054\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-054 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-054 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-054\AppData\Local LOGONSERVER=\\T-W864-IX-054 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-054 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-054 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-054 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=0.401000 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-21 19:14:10.050340) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-21 19:14:10.050661) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-21 19:14:10.051362) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-10-21 19:14:10.051642) ========= '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-054\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-054 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-054 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-054\AppData\Local LOGONSERVER=\\T-W864-IX-054 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-054 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-054 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-054 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False --19:14:11-- 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 19:14:12 (2.10 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=1.384000 ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-10-21 19:14:11.452556) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 11 secs) (at 2015-10-21 19:14:11.452895) ========= '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-054\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-054 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-054 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-054\AppData\Local LOGONSERVER=\\T-W864-IX-054 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-054 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-054 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-054 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=5.111000 ========= Finished 'rm -rf ...' (results: 0, elapsed: 11 secs) (at 2015-10-21 19:14:22.650173) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-10-21 19:14:22.650556) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 7e37f3445ffea580864bfde8e5c0efbc6cf2274b --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 7e37f3445ffea580864bfde8e5c0efbc6cf2274b --destination scripts --debug'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-054\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-054 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-054 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-054\AppData\Local LOGONSERVER=\\T-W864-IX-054 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-054 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-054 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-054 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 2015-10-21 19:14:23,796 truncating revision to first 12 chars 2015-10-21 19:14:23,796 Setting DEBUG logging. 2015-10-21 19:14:23,796 attempt 1/10 2015-10-21 19:14:23,796 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/7e37f3445ffe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-10-21 19:14:24,601 unpacking tar archive at: mozilla-inbound-7e37f3445ffe/testing/mozharness/ program finished with exit code 0 elapsedTime=2.184000 ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-10-21 19:14:24.917612) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-21 19:14:24.917919) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-21 19:14:24.931528) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-21 19:14:24.931783) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-21 19:14:24.932162) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 16 secs) (at 2015-10-21 19:14:24.932462) ========= '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-054\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-054 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-054 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-054\AppData\Local LOGONSERVER=\\T-W864-IX-054 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-054 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-054 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-054 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 19:14:26 INFO - MultiFileLogger online at 20151021 19:14:26 in C:\slave\test 19:14:26 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 19:14:26 INFO - Dumping config to C:\slave\test\logs\localconfig.json. 19:14:26 INFO - {'append_to_log': False, 19:14:26 INFO - 'base_work_dir': 'C:\\slave\\test', 19:14:26 INFO - 'blob_upload_branch': 'Mozilla-Inbound-Non-PGO', 19:14:26 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt', 19:14:26 INFO - 'branch': 'Mozilla-Inbound-Non-PGO', 19:14:26 INFO - 'buildbot_json_path': 'buildprops.json', 19:14:26 INFO - 'config_files': ('talos/windows_config.py',), 19:14:26 INFO - 'default_actions': ('clobber', 19:14:26 INFO - 'read-buildbot-config', 19:14:26 INFO - 'download-and-extract', 19:14:26 INFO - 'populate-webroot', 19:14:26 INFO - 'create-virtualenv', 19:14:26 INFO - 'install', 19:14:26 INFO - 'run-tests'), 19:14:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:14:26 INFO - 'download_minidump_stackwalk': True, 19:14:26 INFO - 'download_symbols': 'ondemand', 19:14:26 INFO - 'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python', 19:14:26 INFO - 'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'), 19:14:26 INFO - 'hg': 'c:/mozilla-build/hg/hg', 19:14:26 INFO - 'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python', 19:14:26 INFO - 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'), 19:14:26 INFO - 'python': 'c:/mozilla-build/python27/python.exe', 19:14:26 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe', 19:14:26 INFO - 'C:/mozilla-build/tooltool.py'), 19:14:26 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe', 19:14:26 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 19:14:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:14:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:14:26 INFO - 'installer_path': 'installer.exe', 19:14:26 INFO - 'log_level': 'info', 19:14:26 INFO - 'log_name': 'talos', 19:14:26 INFO - 'log_to_console': True, 19:14:26 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe', 19:14:26 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe', 19:14:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest', 19:14:26 INFO - 'opt_config_files': (), 19:14:26 INFO - 'pip_index': False, 19:14:26 INFO - 'sps_profile': False, 19:14:26 INFO - 'sps_profile_interval': 0, 19:14:26 INFO - 'suite': 'dromaeojs', 19:14:26 INFO - 'system_bits': '64', 19:14:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:14:26 INFO - 'title': 'T-W864-IX-054', 19:14:26 INFO - 'use_talos_json': True, 19:14:26 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'), 19:14:26 INFO - 'virtualenv_path': 'C:\\slave\\test\\build/venv', 19:14:26 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll', 19:14:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:14:26 INFO - 'work_dir': 'build'} 19:14:26 INFO - ##### 19:14:26 INFO - ##### Running clobber step. 19:14:26 INFO - ##### 19:14:26 INFO - Running pre-action listener: _resource_record_pre_action 19:14:26 INFO - Running main action method: clobber 19:14:26 INFO - rmtree: C:\slave\test\build 19:14:26 INFO - Using _rmtree_windows ... 19:14:26 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1 19:15:27 INFO - Running post-action listener: _resource_record_post_action 19:15:27 INFO - ##### 19:15:27 INFO - ##### Running read-buildbot-config step. 19:15:27 INFO - ##### 19:15:27 INFO - Running pre-action listener: _resource_record_pre_action 19:15:27 INFO - Running main action method: read_buildbot_config 19:15:27 INFO - Using buildbot properties: 19:15:27 INFO - { 19:15:27 INFO - "properties": { 19:15:27 INFO - "buildnumber": 2035, 19:15:27 INFO - "product": "firefox", 19:15:27 INFO - "script_repo_revision": "production", 19:15:27 INFO - "builddir": "mozilla-inbound_win8_64_test-dromaeojs", 19:15:27 INFO - "repository": "", 19:15:27 INFO - "buildername": "Windows 8 64-bit mozilla-inbound talos dromaeojs", 19:15:27 INFO - "buildid": "20151021172720", 19:15:27 INFO - "slavename": "t-w864-ix-054", 19:15:27 INFO - "pgo_build": "False", 19:15:27 INFO - "basedir": "C:\\slave\\test", 19:15:27 INFO - "project": "", 19:15:27 INFO - "platform": "win8_64", 19:15:27 INFO - "master": "http://buildbot-master111.bb.releng.scl3.mozilla.com:8201/", 19:15:27 INFO - "slavebuilddir": "test", 19:15:27 INFO - "scheduler": "tests-mozilla-inbound-win64-talos", 19:15:27 INFO - "branch": "mozilla-inbound", 19:15:27 INFO - "repo_path": "integration/mozilla-inbound", 19:15:27 INFO - "stage_platform": "win64", 19:15:27 INFO - "builduid": "5a1f76d56b714cc28a930f252e173218", 19:15:27 INFO - "revision": "7e37f3445ffea580864bfde8e5c0efbc6cf2274b" 19:15:27 INFO - }, 19:15:27 INFO - "sourcestamp": { 19:15:27 INFO - "repository": "", 19:15:27 INFO - "hasPatch": false, 19:15:27 INFO - "project": "", 19:15:27 INFO - "branch": "mozilla-inbound-win64-talos", 19:15:27 INFO - "changes": [ 19:15:27 INFO - { 19:15:27 INFO - "category": null, 19:15:27 INFO - "files": [ 19:15:27 INFO - { 19:15:27 INFO - "url": null, 19:15:27 INFO - "name": "https://queue.taskcluster.net/v1/task/jvkkCaW2Q8GIXNm_UhSdSg/artifacts/public/build/firefox-44.0a1.en-US.win64.zip" 19:15:27 INFO - } 19:15:27 INFO - ], 19:15:27 INFO - "repository": "", 19:15:27 INFO - "rev": "44904f46bc865b5a6272842e520252171ea4e404", 19:15:27 INFO - "who": "nnethercote@mozilla.com", 19:15:27 INFO - "when": 1445478493, 19:15:27 INFO - "number": 6556851, 19:15:27 INFO - "comments": "Bug 1186814 - Replace nsBaseHashtable::EnumerateRead() calls in extensions/spellcheck/ with iterators. r=ehsan.", 19:15:27 INFO - "project": "", 19:15:27 INFO - "at": "Wed 21 Oct 2015 18:48:13", 19:15:27 INFO - "branch": "mozilla-inbound-win64-talos", 19:15:27 INFO - "revlink": "", 19:15:27 INFO - "properties": [ 19:15:27 INFO - [ 19:15:27 INFO - "buildid", 19:15:27 INFO - "20151021171420", 19:15:27 INFO - "Change" 19:15:27 INFO - ], 19:15:27 INFO - [ 19:15:27 INFO - "builduid", 19:15:27 INFO - "a8d656e8e600418896f1df8f2b64bf2c", 19:15:27 INFO - "Change" 19:15:27 INFO - ], 19:15:27 INFO - [ 19:15:27 INFO - "pgo_build", 19:15:27 INFO - "False", 19:15:27 INFO - "Change" 19:15:27 INFO - ] 19:15:27 INFO - ], 19:15:27 INFO - "revision": "44904f46bc865b5a6272842e520252171ea4e404" 19:15:27 INFO - }, 19:15:27 INFO - { 19:15:27 INFO - "category": null, 19:15:27 INFO - "files": [ 19:15:27 INFO - { 19:15:27 INFO - "url": null, 19:15:27 INFO - "name": "https://queue.taskcluster.net/v1/task/ptQOacrHTjuhznXXfxhkrQ/artifacts/public/build/firefox-44.0a1.en-US.win64.zip" 19:15:27 INFO - } 19:15:27 INFO - ], 19:15:27 INFO - "repository": "", 19:15:27 INFO - "rev": "0136029e390e363e61540205b9902dcb9f3cb3ec", 19:15:27 INFO - "who": "xquan@mozilla.com", 19:15:27 INFO - "when": 1445478903, 19:15:27 INFO - "number": 6556881, 19:15:27 INFO - "comments": "Bug 1203089 - Add test for fullscreen element in parent with perspective property. r=dholbert", 19:15:27 INFO - "project": "", 19:15:27 INFO - "at": "Wed 21 Oct 2015 18:55:03", 19:15:27 INFO - "branch": "mozilla-inbound-win64-talos", 19:15:27 INFO - "revlink": "", 19:15:27 INFO - "properties": [ 19:15:27 INFO - [ 19:15:27 INFO - "buildid", 19:15:27 INFO - "20151021171425", 19:15:27 INFO - "Change" 19:15:27 INFO - ], 19:15:27 INFO - [ 19:15:27 INFO - "builduid", 19:15:27 INFO - "5ff81d2eafb14c29867ad6a2015065b0", 19:15:27 INFO - "Change" 19:15:27 INFO - ], 19:15:27 INFO - [ 19:15:27 INFO - "pgo_build", 19:15:27 INFO - "False", 19:15:27 INFO - "Change" 19:15:27 INFO - ] 19:15:27 INFO - ], 19:15:27 INFO - "revision": "0136029e390e363e61540205b9902dcb9f3cb3ec" 19:15:27 INFO - }, 19:15:27 INFO - { 19:15:27 INFO - "category": null, 19:15:27 INFO - "files": [ 19:15:27 INFO - { 19:15:27 INFO - "url": null, 19:15:27 INFO - "name": "https://queue.taskcluster.net/v1/task/dQuddg34Qh2Midi_iuzHqA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip" 19:15:27 INFO - } 19:15:27 INFO - ], 19:15:27 INFO - "repository": "", 19:15:27 INFO - "rev": "7e37f3445ffea580864bfde8e5c0efbc6cf2274b", 19:15:27 INFO - "who": "ryanvm@gmail.com", 19:15:27 INFO - "when": 1445479277, 19:15:27 INFO - "number": 6556902, 19:15:27 INFO - "comments": "Bug 1213267 - Fix view-source address. r=bz", 19:15:27 INFO - "project": "", 19:15:27 INFO - "at": "Wed 21 Oct 2015 19:01:17", 19:15:27 INFO - "branch": "mozilla-inbound-win64-talos", 19:15:27 INFO - "revlink": "", 19:15:27 INFO - "properties": [ 19:15:27 INFO - [ 19:15:27 INFO - "buildid", 19:15:27 INFO - "20151021172720", 19:15:27 INFO - "Change" 19:15:27 INFO - ], 19:15:27 INFO - [ 19:15:27 INFO - "builduid", 19:15:27 INFO - "5a1f76d56b714cc28a930f252e173218", 19:15:27 INFO - "Change" 19:15:27 INFO - ], 19:15:27 INFO - [ 19:15:27 INFO - "pgo_build", 19:15:27 INFO - "False", 19:15:27 INFO - "Change" 19:15:27 INFO - ] 19:15:27 INFO - ], 19:15:27 INFO - "revision": "7e37f3445ffea580864bfde8e5c0efbc6cf2274b" 19:15:27 INFO - } 19:15:27 INFO - ], 19:15:27 INFO - "revision": "7e37f3445ffea580864bfde8e5c0efbc6cf2274b" 19:15:27 INFO - } 19:15:27 INFO - } 19:15:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/dQuddg34Qh2Midi_iuzHqA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip. 19:15:27 INFO - Running post-action listener: _resource_record_post_action 19:15:27 INFO - ##### 19:15:27 INFO - ##### Running download-and-extract step. 19:15:27 INFO - ##### 19:15:27 INFO - Running pre-action listener: _resource_record_pre_action 19:15:27 INFO - Running main action method: download_and_extract 19:15:27 INFO - mkdir: C:\slave\test\build\tests 19:15: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')]} 19:15:27 INFO - https://queue.taskcluster.net/v1/task/dQuddg34Qh2Midi_iuzHqA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:15:27 INFO - trying https://queue.taskcluster.net/v1/task/dQuddg34Qh2Midi_iuzHqA/artifacts/public/build/test_packages.json 19:15:27 INFO - Downloading https://queue.taskcluster.net/v1/task/dQuddg34Qh2Midi_iuzHqA/artifacts/public/build/test_packages.json to C:\slave\test\build\test_packages.json 19:15:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dQuddg34Qh2Midi_iuzHqA/artifacts/public/build/test_packages.json', 'file_name': 'C:\\slave\\test\\build\\test_packages.json'}, attempt #1 19:15:28 INFO - Downloaded 1221 bytes. 19:15:28 INFO - Reading from file C:\slave\test\build\test_packages.json 19:15:28 INFO - Using the following test package requirements: 19:15:28 INFO - {u'common': [u'firefox-44.0a1.en-US.win64.common.tests.zip'], 19:15:28 INFO - u'cppunittest': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 19:15:28 INFO - u'firefox-44.0a1.en-US.win64.cppunittest.tests.zip'], 19:15:28 INFO - u'jittest': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 19:15:28 INFO - u'jsshell-win64.zip'], 19:15:28 INFO - u'mochitest': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 19:15:28 INFO - u'firefox-44.0a1.en-US.win64.mochitest.tests.zip'], 19:15:28 INFO - u'mozbase': [u'firefox-44.0a1.en-US.win64.common.tests.zip'], 19:15:28 INFO - u'reftest': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 19:15:28 INFO - u'firefox-44.0a1.en-US.win64.reftest.tests.zip'], 19:15:28 INFO - u'talos': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 19:15:28 INFO - u'firefox-44.0a1.en-US.win64.talos.tests.zip'], 19:15:28 INFO - u'web-platform': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 19:15:28 INFO - u'firefox-44.0a1.en-US.win64.web-platform.tests.zip'], 19:15:28 INFO - u'webapprt': [u'firefox-44.0a1.en-US.win64.common.tests.zip'], 19:15:28 INFO - u'xpcshell': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 19:15:28 INFO - u'firefox-44.0a1.en-US.win64.xpcshell.tests.zip']} 19:15:28 INFO - Downloading packages: [u'firefox-44.0a1.en-US.win64.common.tests.zip'] for test suite category: common 19:15:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:15:28 INFO - https://queue.taskcluster.net/v1/task/dQuddg34Qh2Midi_iuzHqA/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip matches https://queue.taskcluster.net 19:15:28 INFO - trying https://queue.taskcluster.net/v1/task/dQuddg34Qh2Midi_iuzHqA/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip 19:15:28 INFO - Downloading https://queue.taskcluster.net/v1/task/dQuddg34Qh2Midi_iuzHqA/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 19:15:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dQuddg34Qh2Midi_iuzHqA/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 19:15:29 INFO - Downloaded 18097096 bytes. 19:15:29 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 19:15:29 INFO - Copy/paste: unzip -q -o C:\slave\test\build\firefox-44.0a1.en-US.win64.common.tests.zip 19:15:29 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 19:15:55 INFO - Return code: 0 19:15:55 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 19:15:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:15:55 INFO - https://queue.taskcluster.net/v1/task/dQuddg34Qh2Midi_iuzHqA/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip matches https://queue.taskcluster.net 19:15:55 INFO - trying https://queue.taskcluster.net/v1/task/dQuddg34Qh2Midi_iuzHqA/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip 19:15:55 INFO - Downloading https://queue.taskcluster.net/v1/task/dQuddg34Qh2Midi_iuzHqA/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 19:15:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dQuddg34Qh2Midi_iuzHqA/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 19:15:56 INFO - Downloaded 18097096 bytes. 19:15:56 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win64.common.tests.zip'] in C:\slave\test\build\tests 19:15:56 INFO - Copy/paste: unzip -q -o C:\slave\test\build\firefox-44.0a1.en-US.win64.common.tests.zip 19:15:56 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win64.common.tests.zip'] with output_timeout 1760 ProcessManager UNABLE to use job objects to manage child processes 19:16:17 INFO - Return code: 0 19:16:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:16:17 INFO - https://queue.taskcluster.net/v1/task/dQuddg34Qh2Midi_iuzHqA/artifacts/public/build/firefox-44.0a1.en-US.win64.talos.tests.zip matches https://queue.taskcluster.net 19:16:17 INFO - trying https://queue.taskcluster.net/v1/task/dQuddg34Qh2Midi_iuzHqA/artifacts/public/build/firefox-44.0a1.en-US.win64.talos.tests.zip 19:16:17 INFO - Downloading https://queue.taskcluster.net/v1/task/dQuddg34Qh2Midi_iuzHqA/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 19:16:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dQuddg34Qh2Midi_iuzHqA/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 19:16:19 INFO - Downloaded 11128611 bytes. 19:16:19 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win64.talos.tests.zip'] in C:\slave\test\build\tests 19:16:19 INFO - Copy/paste: unzip -q -o C:\slave\test\build\firefox-44.0a1.en-US.win64.talos.tests.zip 19:16:19 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win64.talos.tests.zip'] with output_timeout 1760 ProcessManager UNABLE to use job objects to manage child processes 19:16:19 INFO - Return code: 0 19:16:19 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')]} 19:16:19 INFO - https://queue.taskcluster.net/v1/task/dQuddg34Qh2Midi_iuzHqA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip matches https://queue.taskcluster.net 19:16:19 INFO - trying https://queue.taskcluster.net/v1/task/dQuddg34Qh2Midi_iuzHqA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip 19:16:19 INFO - Downloading https://queue.taskcluster.net/v1/task/dQuddg34Qh2Midi_iuzHqA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip to C:\slave\test\build\firefox-44.0a1.en-US.win64.zip 19:16:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dQuddg34Qh2Midi_iuzHqA/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 19:16:21 INFO - Downloaded 54741379 bytes. 19:16:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dQuddg34Qh2Midi_iuzHqA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip 19:16:21 INFO - mkdir: C:\slave\test\properties 19:16:21 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url 19:16:21 INFO - Writing to file C:\slave\test\properties\build_url 19:16:21 INFO - Contents: 19:16:21 INFO - build_url:https://queue.taskcluster.net/v1/task/dQuddg34Qh2Midi_iuzHqA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip 19:16:21 INFO - Running post-action listener: _resource_record_post_action 19:16:21 INFO - Running post-action listener: set_extra_try_arguments 19:16:21 INFO - ##### 19:16:21 INFO - ##### Running populate-webroot step. 19:16:21 INFO - ##### 19:16:21 INFO - Running pre-action listener: _resource_record_pre_action 19:16:21 INFO - Running main action method: populate_webroot 19:16:21 INFO - Guessing talos json url... 19:16:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:16:21 INFO - https://queue.taskcluster.net/v1/task/dQuddg34Qh2Midi_iuzHqA/artifacts/public/build/firefox-44.0a1.en-US.win64.txt matches https://queue.taskcluster.net 19:16:21 INFO - trying https://queue.taskcluster.net/v1/task/dQuddg34Qh2Midi_iuzHqA/artifacts/public/build/firefox-44.0a1.en-US.win64.txt 19:16:21 INFO - Downloading https://queue.taskcluster.net/v1/task/dQuddg34Qh2Midi_iuzHqA/artifacts/public/build/firefox-44.0a1.en-US.win64.txt to C:\slave\test\build\firefox-44.0a1.en-US.win64.txt 19:16:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dQuddg34Qh2Midi_iuzHqA/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 19:16:21 INFO - Downloaded 111 bytes. 19:16:21 INFO - Reading from file C:\slave\test\build\firefox-44.0a1.en-US.win64.txt 19:16:21 INFO - Contents: 19:16:21 INFO - 20151021172720 19:16:21 INFO - https://hg.mozilla.org/integration/mozilla-inbound/rev/7e37f3445ffea580864bfde8e5c0efbc6cf2274b 19:16:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:16:21 INFO - trying https://hg.mozilla.org/integration/mozilla-inbound/raw-file/7e37f3445f/testing/talos/talos.json 19:16:21 INFO - Downloading https://hg.mozilla.org/integration/mozilla-inbound/raw-file/7e37f3445f/testing/talos/talos.json to C:\slave\test\build\talos.json 19:16:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/mozilla-inbound/raw-file/7e37f3445f/testing/talos/talos.json', 'file_name': 'C:\\slave\\test\\build\\talos.json'}, attempt #1 19:16:22 INFO - Downloaded 4264 bytes. 19:16:22 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']}, 19:16:22 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']}, 19:16:22 INFO - u'remote-trobocheck2': {u'talos_options': [u'--fennecIDs', 19:16:22 INFO - u'../fennec_ids.txt'], 19:16:22 INFO - u'tests': [u'tcheck2']}, 19:16:22 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome', 19:16:22 INFO - u'--tppagecycles', 19:16:22 INFO - u'7'], 19:16:22 INFO - u'tests': [u'tsvgm']}}, 19:16:22 INFO - u'suites': {u'chromez': {u'tests': [u'tresize', u'tcanvasmark']}, 19:16:22 INFO - u'chromez-e10s': {u'talos_options': [u'--e10s'], 19:16:22 INFO - u'tests': [u'tresize', u'tcanvasmark']}, 19:16:22 INFO - u'dromaeojs': {u'tests': [u'dromaeo_css', u'kraken', u'v8_7']}, 19:16:22 INFO - u'dromaeojs-e10s': {u'talos_options': [u'--e10s'], 19:16:22 INFO - u'tests': [u'dromaeo_css', 19:16:22 INFO - u'kraken', 19:16:22 INFO - u'v8_7']}, 19:16:22 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:16:22 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 19:16:22 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:16:22 INFO - u'talos_options': [u'--e10s'], 19:16:22 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 19:16:22 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:16:22 INFO - u'tests': [u'damp', u'tps']}, 19:16:22 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:16:22 INFO - u'talos_options': [u'--e10s'], 19:16:22 INFO - u'tests': [u'damp', u'tps']}, 19:16:22 INFO - u'g3': {u'tests': [u'dromaeo_dom']}, 19:16:22 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']}, 19:16:22 INFO - u'other': {u'tests': [u'a11yr', 19:16:22 INFO - u'ts_paint', 19:16:22 INFO - u'tpaint', 19:16:22 INFO - u'sessionrestore', 19:16:22 INFO - u'sessionrestore_no_auto_restore']}, 19:16:22 INFO - u'other-e10s': {u'talos_options': [u'--e10s'], 19:16:22 INFO - u'tests': [u'a11yr', 19:16:22 INFO - u'ts_paint', 19:16:22 INFO - u'tpaint', 19:16:22 INFO - u'sessionrestore', 19:16:22 INFO - u'sessionrestore_no_auto_restore']}, 19:16:22 INFO - u'other-e10s_l64': {u'talos_options': [u'--e10s'], 19:16:22 INFO - u'tests': [u'a11yr', 19:16:22 INFO - u'ts_paint', 19:16:22 INFO - u'tpaint', 19:16:22 INFO - u'sessionrestore', 19:16:22 INFO - u'sessionrestore_no_auto_restore']}, 19:16:22 INFO - u'other-e10s_nol64': {u'talos_options': [u'--e10s'], 19:16:22 INFO - u'tests': [u'a11yr', 19:16:22 INFO - u'ts_paint', 19:16:22 INFO - u'tpaint', 19:16:22 INFO - u'sessionrestore', 19:16:22 INFO - u'sessionrestore_no_auto_restore']}, 19:16:22 INFO - u'other_l64': {u'tests': [u'a11yr', 19:16:22 INFO - u'ts_paint', 19:16:22 INFO - u'tpaint', 19:16:22 INFO - u'sessionrestore', 19:16:22 INFO - u'sessionrestore_no_auto_restore']}, 19:16:22 INFO - u'other_nol64': {u'tests': [u'a11yr', 19:16:22 INFO - u'ts_paint', 19:16:22 INFO - u'tpaint', 19:16:22 INFO - u'sessionrestore', 19:16:22 INFO - u'sessionrestore_no_auto_restore']}, 19:16:22 INFO - u'svgr': {u'tests': [u'tsvgx', 19:16:22 INFO - u'tsvgr_opacity', 19:16:22 INFO - u'tart', 19:16:22 INFO - u'tscrollx', 19:16:22 INFO - u'cart']}, 19:16:22 INFO - u'svgr-e10s': {u'talos_options': [u'--e10s'], 19:16:22 INFO - u'tests': [u'tsvgx', 19:16:22 INFO - u'tsvgr_opacity', 19:16:22 INFO - u'tart', 19:16:22 INFO - u'tscrollx', 19:16:22 INFO - u'cart']}, 19:16:22 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:16:22 INFO - u'tests': [u'tp5o']}, 19:16:22 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:16:22 INFO - u'talos_options': [u'--e10s'], 19:16:22 INFO - u'tests': [u'tp5o']}, 19:16:22 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:16:22 INFO - u'talos_options': [u'--xperf_path', 19:16:22 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:16:22 INFO - u'tests': [u'tp5n']}, 19:16:22 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:16:22 INFO - u'talos_options': [u'--e10s', 19:16:22 INFO - u'--xperf_path', 19:16:22 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 19:16:22 INFO - u'C:/slave/talos-data/talos/xperf.config'], 19:16:22 INFO - u'tests': [u'tp5n']}}, 19:16:22 INFO - u'talos.zip': {u'path': u'', 19:16:22 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:16:22 INFO - Running post-action listener: _resource_record_post_action 19:16:22 INFO - ##### 19:16:22 INFO - ##### Running create-virtualenv step. 19:16:22 INFO - ##### 19:16:22 INFO - Running pre-action listener: _resource_record_pre_action 19:16:22 INFO - Running main action method: create_virtualenv 19:16:22 INFO - Creating virtualenv C:\slave\test\build/venv 19:16:22 INFO - mkdir: C:\slave\test\build\venv\Scripts 19:16:22 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll 19:16:22 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'! 19:16:22 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 19:16:22 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build/venv 19:16:28 INFO - New python executable in C:\slave\test\build/venv\Scripts\python.exe 19:16:31 INFO - Installing distribute......................................................................................................................................................................................done. 19:16:32 INFO - Return code: 0 19:16:32 INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv 19:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:16:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:16:32 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02322B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022DDEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x023F9D08>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00768B48>, '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 0x0078A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027C3660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-054', 'USERDOMAIN': 'T-W864-IX-054', '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-054', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-054\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-054', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-054', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-054', '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-054\\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 19:16:32 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in C:\slave\test\build 19:16:32 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --download-cache C:\slave\test\build/venv\cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:16:32 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 19:16:32 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-054\\AppData\\Roaming', 19:16:32 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 19:16:32 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 19:16:32 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 19:16:32 INFO - 'COMPUTERNAME': 'T-W864-IX-054', 19:16:32 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 19:16:32 INFO - 'DCLOCATION': 'SCL3', 19:16:32 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 19:16:32 INFO - 'FP_NO_HOST_CHECK': 'NO', 19:16:32 INFO - 'HOMEDRIVE': 'C:', 19:16:32 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-054', 19:16:32 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 19:16:32 INFO - 'KTS_VERSION': '1.19c', 19:16:32 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-054\\AppData\\Local', 19:16:32 INFO - 'LOGONSERVER': '\\\\T-W864-IX-054', 19:16:32 INFO - 'MONDIR': 'C:\\Monitor_config\\', 19:16:32 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 19:16:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:16:32 INFO - 'MOZ_NO_REMOTE': '1', 19:16:32 INFO - 'NO_EM_RESTART': '1', 19:16:32 INFO - 'NUMBER_OF_PROCESSORS': '8', 19:16:32 INFO - 'OS': 'Windows_NT', 19:16:32 INFO - 'OURDRIVE': 'C:', 19:16:32 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 19:16:32 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 19:16:32 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 19:16:32 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 19:16:32 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 19:16:32 INFO - 'PROCESSOR_LEVEL': '6', 19:16:32 INFO - 'PROCESSOR_REVISION': '1e05', 19:16:32 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 19:16:32 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 19:16:32 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 19:16:32 INFO - 'PROGRAMW6432': 'C:\\Program Files', 19:16:32 INFO - 'PROMPT': '$P$G', 19:16:32 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 19:16:32 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 19:16:32 INFO - 'PUBLIC': 'C:\\Users\\Public', 19:16:32 INFO - 'PWD': 'C:\\slave\\test', 19:16:32 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 19:16:32 INFO - 'SLAVEDIR': 'C:\\slave\\', 19:16:32 INFO - 'SYSTEMDRIVE': 'C:', 19:16:32 INFO - 'SYSTEMROOT': 'C:\\windows', 19:16:32 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:16:32 INFO - 'TEST1': 'testie', 19:16:32 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:16:32 INFO - 'USERDOMAIN': 'T-W864-IX-054', 19:16:32 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-054', 19:16:32 INFO - 'USERNAME': 'cltbld', 19:16:32 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-054', 19:16:32 INFO - 'WINDIR': 'C:\\windows', 19:16:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 19:16:33 INFO - Ignoring indexes: http://pypi.python.org/simple/ 19:16:33 INFO - Downloading/unpacking pip>=1.5 19:16:33 INFO - Creating supposed download cache at C:\slave\test\build/venv\cache 19:16:37 INFO - Storing download in cache at c:\slave\test\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fpip-1.5.5.tar.gz 19:16:37 INFO - Running setup.py egg_info for package pip 19:16:37 INFO - warning: no files found matching 'pip\cacert.pem' 19:16:37 INFO - warning: no files found matching '*.html' under directory 'docs' 19:16:37 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 19:16:37 INFO - no previously-included directories found matching 'docs\_build\_sources' 19:16:37 INFO - Installing collected packages: pip 19:16:37 INFO - Found existing installation: pip 0.8.2 19:16:37 INFO - Uninstalling pip: 19:16:37 INFO - Successfully uninstalled pip 19:16:37 INFO - Running setup.py install for pip 19:16:37 INFO - warning: no files found matching 'pip\cacert.pem' 19:16:37 INFO - warning: no files found matching '*.html' under directory 'docs' 19:16:37 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 19:16:37 INFO - no previously-included directories found matching 'docs\_build\_sources' 19:16:37 INFO - Installing pip-script.py script to C:\slave\test\build\venv\Scripts 19:16:37 INFO - Installing pip.exe script to C:\slave\test\build\venv\Scripts 19:16:37 INFO - Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts 19:16:37 INFO - Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts 19:16:37 INFO - Installing pip2-script.py script to C:\slave\test\build\venv\Scripts 19:16:37 INFO - Installing pip2.exe script to C:\slave\test\build\venv\Scripts 19:16:37 INFO - Successfully installed pip 19:16:37 INFO - Cleaning up... 19:16:37 INFO - Return code: 0 19:16:37 INFO - Installing psutil>=0.7.1 into virtualenv C:\slave\test\build/venv 19:16: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')]} 19:16:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:16: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')]} 19:16:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:16:37 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02322B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022DDEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x023F9D08>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00768B48>, '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 0x0078A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027C3660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-054', 'USERDOMAIN': 'T-W864-IX-054', '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-054', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-054\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-054', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-054', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-054', '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-054\\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 19:16:37 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in C:\slave\test\build 19:16:37 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --download-cache C:\slave\test\build/venv\cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:16:37 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 19:16:37 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-054\\AppData\\Roaming', 19:16:37 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 19:16:37 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 19:16:37 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 19:16:37 INFO - 'COMPUTERNAME': 'T-W864-IX-054', 19:16:37 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 19:16:37 INFO - 'DCLOCATION': 'SCL3', 19:16:37 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 19:16:37 INFO - 'FP_NO_HOST_CHECK': 'NO', 19:16:37 INFO - 'HOMEDRIVE': 'C:', 19:16:37 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-054', 19:16:37 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 19:16:37 INFO - 'KTS_VERSION': '1.19c', 19:16:37 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-054\\AppData\\Local', 19:16:37 INFO - 'LOGONSERVER': '\\\\T-W864-IX-054', 19:16:37 INFO - 'MONDIR': 'C:\\Monitor_config\\', 19:16:37 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 19:16:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:16:37 INFO - 'MOZ_NO_REMOTE': '1', 19:16:37 INFO - 'NO_EM_RESTART': '1', 19:16:37 INFO - 'NUMBER_OF_PROCESSORS': '8', 19:16:37 INFO - 'OS': 'Windows_NT', 19:16:37 INFO - 'OURDRIVE': 'C:', 19:16:37 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 19:16:37 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 19:16:37 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 19:16:37 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 19:16:37 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 19:16:37 INFO - 'PROCESSOR_LEVEL': '6', 19:16:37 INFO - 'PROCESSOR_REVISION': '1e05', 19:16:37 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 19:16:37 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 19:16:37 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 19:16:37 INFO - 'PROGRAMW6432': 'C:\\Program Files', 19:16:37 INFO - 'PROMPT': '$P$G', 19:16:37 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 19:16:37 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 19:16:37 INFO - 'PUBLIC': 'C:\\Users\\Public', 19:16:37 INFO - 'PWD': 'C:\\slave\\test', 19:16:37 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 19:16:37 INFO - 'SLAVEDIR': 'C:\\slave\\', 19:16:37 INFO - 'SYSTEMDRIVE': 'C:', 19:16:37 INFO - 'SYSTEMROOT': 'C:\\windows', 19:16:37 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:16:37 INFO - 'TEST1': 'testie', 19:16:37 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:16:37 INFO - 'USERDOMAIN': 'T-W864-IX-054', 19:16:37 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-054', 19:16:37 INFO - 'USERNAME': 'cltbld', 19:16:37 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-054', 19:16:37 INFO - 'WINDIR': 'C:\\windows', 19:16:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 19:16:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:16:39 INFO - Downloading/unpacking psutil>=0.7.1 19:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:16:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:16:40 INFO - Storing download in cache at c:\slave\test\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fpsutil-3.1.1-cp27-none-win32.whl 19:16:40 INFO - Installing collected packages: psutil 19:16:41 INFO - Successfully installed psutil 19:16:41 INFO - Cleaning up... 19:16:41 INFO - Return code: 0 19:16:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv C:\slave\test\build/venv 19:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:16:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:16:41 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 0x02322B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022DDEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x023F9D08>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00768B48>, '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 0x0078A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027C3660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-054', 'USERDOMAIN': 'T-W864-IX-054', '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-054', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-054\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-054', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-054', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-054', '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-054\\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 19:16:41 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 19:16:41 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 19:16:41 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 19:16:41 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-054\\AppData\\Roaming', 19:16:41 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 19:16:41 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 19:16:41 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 19:16:41 INFO - 'COMPUTERNAME': 'T-W864-IX-054', 19:16:41 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 19:16:41 INFO - 'DCLOCATION': 'SCL3', 19:16:41 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 19:16:41 INFO - 'FP_NO_HOST_CHECK': 'NO', 19:16:41 INFO - 'HOMEDRIVE': 'C:', 19:16:41 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-054', 19:16:41 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 19:16:41 INFO - 'KTS_VERSION': '1.19c', 19:16:41 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-054\\AppData\\Local', 19:16:41 INFO - 'LOGONSERVER': '\\\\T-W864-IX-054', 19:16:41 INFO - 'MONDIR': 'C:\\Monitor_config\\', 19:16:41 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 19:16:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:16:41 INFO - 'MOZ_NO_REMOTE': '1', 19:16:41 INFO - 'NO_EM_RESTART': '1', 19:16:41 INFO - 'NUMBER_OF_PROCESSORS': '8', 19:16:41 INFO - 'OS': 'Windows_NT', 19:16:41 INFO - 'OURDRIVE': 'C:', 19:16:41 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', 19:16:41 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 19:16:41 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 19:16:41 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 19:16:41 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 19:16:41 INFO - 'PROCESSOR_LEVEL': '6', 19:16:41 INFO - 'PROCESSOR_REVISION': '1e05', 19:16:41 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 19:16:41 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 19:16:41 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 19:16:41 INFO - 'PROGRAMW6432': 'C:\\Program Files', 19:16:41 INFO - 'PROMPT': '$P$G', 19:16:41 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 19:16:41 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 19:16:41 INFO - 'PUBLIC': 'C:\\Users\\Public', 19:16:41 INFO - 'PWD': 'C:\\slave\\test', 19:16:41 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 19:16:41 INFO - 'SLAVEDIR': 'C:\\slave\\', 19:16:41 INFO - 'SYSTEMDRIVE': 'C:', 19:16:41 INFO - 'SYSTEMROOT': 'C:\\windows', 19:16:41 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:16:41 INFO - 'TEST1': 'testie', 19:16:41 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:16:41 INFO - 'USERDOMAIN': 'T-W864-IX-054', 19:16:41 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-054', 19:16:41 INFO - 'USERNAME': 'cltbld', 19:16:41 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-054', 19:16:41 INFO - 'WINDIR': 'C:\\windows', 19:16:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 19:16:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:16:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:16:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:16:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:16:42 INFO - Storing download in cache at c:\slave\test\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fmozsystemmonitor-0.0.tar.gz 19:16:42 INFO - Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor 19:16:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in c:\slave\test\build\venv\lib\site-packages (from mozsystemmonitor==0.0.0) 19:16:42 INFO - Installing collected packages: mozsystemmonitor 19:16:42 INFO - Running setup.py install for mozsystemmonitor 19:16:42 INFO - Successfully installed mozsystemmonitor 19:16:42 INFO - Cleaning up... 19:16:43 INFO - Return code: 0 19:16:43 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv 19:16:43 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')]} 19:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:16:43 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')]} 19:16:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:16:43 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 0x02322B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022DDEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x023F9D08>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00768B48>, '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 0x0078A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027C3660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-054', 'USERDOMAIN': 'T-W864-IX-054', '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-054', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-054\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-054', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-054', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-054', '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-054\\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 19:16:43 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 19:16:43 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 19:16:43 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 19:16:43 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-054\\AppData\\Roaming', 19:16:43 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 19:16:43 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 19:16:43 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 19:16:43 INFO - 'COMPUTERNAME': 'T-W864-IX-054', 19:16:43 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 19:16:43 INFO - 'DCLOCATION': 'SCL3', 19:16:43 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 19:16:43 INFO - 'FP_NO_HOST_CHECK': 'NO', 19:16:43 INFO - 'HOMEDRIVE': 'C:', 19:16:43 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-054', 19:16:43 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 19:16:43 INFO - 'KTS_VERSION': '1.19c', 19:16:43 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-054\\AppData\\Local', 19:16:43 INFO - 'LOGONSERVER': '\\\\T-W864-IX-054', 19:16:43 INFO - 'MONDIR': 'C:\\Monitor_config\\', 19:16:43 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 19:16:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:16:43 INFO - 'MOZ_NO_REMOTE': '1', 19:16:43 INFO - 'NO_EM_RESTART': '1', 19:16:43 INFO - 'NUMBER_OF_PROCESSORS': '8', 19:16:43 INFO - 'OS': 'Windows_NT', 19:16:43 INFO - 'OURDRIVE': 'C:', 19:16:43 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', 19:16:43 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 19:16:43 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 19:16:43 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 19:16:43 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 19:16:43 INFO - 'PROCESSOR_LEVEL': '6', 19:16:43 INFO - 'PROCESSOR_REVISION': '1e05', 19:16:43 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 19:16:43 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 19:16:43 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 19:16:43 INFO - 'PROGRAMW6432': 'C:\\Program Files', 19:16:43 INFO - 'PROMPT': '$P$G', 19:16:43 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 19:16:43 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 19:16:43 INFO - 'PUBLIC': 'C:\\Users\\Public', 19:16:43 INFO - 'PWD': 'C:\\slave\\test', 19:16:43 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 19:16:43 INFO - 'SLAVEDIR': 'C:\\slave\\', 19:16:43 INFO - 'SYSTEMDRIVE': 'C:', 19:16:43 INFO - 'SYSTEMROOT': 'C:\\windows', 19:16:43 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:16:43 INFO - 'TEST1': 'testie', 19:16:43 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:16:43 INFO - 'USERDOMAIN': 'T-W864-IX-054', 19:16:43 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-054', 19:16:43 INFO - 'USERNAME': 'cltbld', 19:16:43 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-054', 19:16:43 INFO - 'WINDIR': 'C:\\windows', 19:16:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 19:16:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:16:43 INFO - Downloading/unpacking blobuploader==1.2.4 19:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:16:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:16:44 INFO - Downloading blobuploader-1.2.4.tar.gz 19:16:44 INFO - Storing download in cache at c:\slave\test\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fblobuploader-1.2.4.tar.gz 19:16:44 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader 19:16:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:16:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:16:45 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 19:16:45 INFO - Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests 19:16:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:16:45 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 19:16:45 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 19:16:45 INFO - Downloading docopt-0.6.1.tar.gz 19:16:45 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 19:16:45 INFO - Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt 19:16:45 INFO - Installing collected packages: blobuploader, requests, docopt 19:16:45 INFO - Running setup.py install for blobuploader 19:16:45 INFO - Running setup.py install for requests 19:16:46 INFO - Running setup.py install for docopt 19:16:46 INFO - Successfully installed blobuploader requests docopt 19:16:46 INFO - Cleaning up... 19:16:47 INFO - Return code: 0 19:16:47 INFO - Installing None into virtualenv C:\slave\test\build/venv 19:16:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:16:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:16:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:16:47 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--no-deps', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02322B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022DDEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x023F9D08>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00768B48>, '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 0x0078A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027C3660>, '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-054', 'USERDOMAIN': 'T-W864-IX-054', '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-054', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-054\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-054', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-054', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-054', '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-054\\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 19:16:47 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--no-deps', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in C:\slave\test\build\tests\config 19:16:47 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --no-deps --download-cache C:\slave\test\build/venv\cache --timeout 120 -r C:\slave\test\build\tests\config\mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:16:47 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 19:16:47 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-054\\AppData\\Roaming', 19:16:47 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 19:16:47 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 19:16:47 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 19:16:47 INFO - 'COMPUTERNAME': 'T-W864-IX-054', 19:16:47 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 19:16:47 INFO - 'DCLOCATION': 'SCL3', 19:16:47 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 19:16:47 INFO - 'FP_NO_HOST_CHECK': 'NO', 19:16:47 INFO - 'HOMEDRIVE': 'C:', 19:16:47 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-054', 19:16:47 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 19:16:47 INFO - 'KTS_VERSION': '1.19c', 19:16:47 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-054\\AppData\\Local', 19:16:47 INFO - 'LOGONSERVER': '\\\\T-W864-IX-054', 19:16:47 INFO - 'MONDIR': 'C:\\Monitor_config\\', 19:16:47 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 19:16:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:16:47 INFO - 'MOZ_NO_REMOTE': '1', 19:16:47 INFO - 'NO_EM_RESTART': '1', 19:16:47 INFO - 'NUMBER_OF_PROCESSORS': '8', 19:16:47 INFO - 'OS': 'Windows_NT', 19:16:47 INFO - 'OURDRIVE': 'C:', 19:16:47 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 19:16:47 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 19:16:47 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 19:16:47 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 19:16:47 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 19:16:47 INFO - 'PROCESSOR_LEVEL': '6', 19:16:47 INFO - 'PROCESSOR_REVISION': '1e05', 19:16:47 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 19:16:47 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 19:16:47 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 19:16:47 INFO - 'PROGRAMW6432': 'C:\\Program Files', 19:16:47 INFO - 'PROMPT': '$P$G', 19:16:47 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 19:16:47 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 19:16:47 INFO - 'PUBLIC': 'C:\\Users\\Public', 19:16:47 INFO - 'PWD': 'C:\\slave\\test', 19:16:47 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 19:16:47 INFO - 'SLAVEDIR': 'C:\\slave\\', 19:16:47 INFO - 'SYSTEMDRIVE': 'C:', 19:16:47 INFO - 'SYSTEMROOT': 'C:\\windows', 19:16:47 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:16:47 INFO - 'TEST1': 'testie', 19:16:47 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:16:47 INFO - 'USERDOMAIN': 'T-W864-IX-054', 19:16:47 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-054', 19:16:47 INFO - 'USERNAME': 'cltbld', 19:16:47 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-054', 19:16:47 INFO - 'WINDIR': 'C:\\windows', 19:16:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 19:16:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:16:47 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 19:16:47 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-3kiax3-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 19:16:47 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 19:16:47 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-bfz388-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 19:16:48 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 19:16:48 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-gnyup0-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 19:16:48 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 19:16:48 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ucooz7-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 19:16:48 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 19:16:48 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-tos5uz-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 19:16:48 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 19:16:48 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-bauwy7-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 19:16:48 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 19:16:48 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-j0971z-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 19:16:48 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 19:16:48 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-kxamqz-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 19:16:48 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 19:16:48 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-9gfckb-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 19:16:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 19:16:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-egablc-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 19:16:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 19:16:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-m9spy5-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 19:16:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 19:16:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-furwen-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 19:16:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 19:16:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-tq0v00-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 19:16:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 19:16:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-7gq9zf-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 19:16:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 19:16:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-zvn3to-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 19:16:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 19:16:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-e1pjhk-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 19:16:49 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 19:16:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-90bly8-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 19:16:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:16:49 INFO - Running setup.py install for manifestparser 19:16:50 INFO - Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts 19:16:50 INFO - Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts 19:16:50 INFO - Running setup.py install for mozcrash 19:16:50 INFO - Running setup.py install for mozdebug 19:16:51 INFO - Running setup.py install for mozdevice 19:16:51 INFO - Installing sutini-script.py script to C:\slave\test\build\venv\Scripts 19:16:51 INFO - Installing sutini.exe script to C:\slave\test\build\venv\Scripts 19:16:51 INFO - Installing dm-script.py script to C:\slave\test\build\venv\Scripts 19:16:51 INFO - Installing dm.exe script to C:\slave\test\build\venv\Scripts 19:16:51 INFO - Running setup.py install for mozfile 19:16:52 INFO - Running setup.py install for mozhttpd 19:16:52 INFO - Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts 19:16:52 INFO - Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts 19:16:52 INFO - Running setup.py install for mozinfo 19:16:52 INFO - Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts 19:16:52 INFO - Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts 19:16:52 INFO - Running setup.py install for mozInstall 19:16:53 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts 19:16:53 INFO - Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts 19:16:53 INFO - Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts 19:16:53 INFO - Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts 19:16:53 INFO - Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts 19:16:53 INFO - Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts 19:16:53 INFO - Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts 19:16:53 INFO - Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts 19:16:53 INFO - Running setup.py install for mozleak 19:16:53 INFO - Running setup.py install for mozlog 19:16:53 INFO - Installing structlog-script.py script to C:\slave\test\build\venv\Scripts 19:16:53 INFO - Installing structlog.exe script to C:\slave\test\build\venv\Scripts 19:16:54 INFO - Running setup.py install for moznetwork 19:16:54 INFO - Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts 19:16:54 INFO - Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts 19:16:54 INFO - Running setup.py install for mozprocess 19:16:55 INFO - Running setup.py install for mozprofile 19:16:55 INFO - Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts 19:16:55 INFO - Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts 19:16:55 INFO - Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts 19:16:55 INFO - Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts 19:16:55 INFO - Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts 19:16:55 INFO - Installing view-profile.exe script to C:\slave\test\build\venv\Scripts 19:16:56 INFO - Running setup.py install for mozrunner 19:16:56 INFO - Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts 19:16:56 INFO - Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts 19:16:56 INFO - Running setup.py install for mozscreenshot 19:16:57 INFO - Running setup.py install for moztest 19:16:57 INFO - Running setup.py install for mozversion 19:16:57 INFO - Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts 19:16:57 INFO - Installing mozversion.exe script to C:\slave\test\build\venv\Scripts 19:16:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:16:57 INFO - Cleaning up... 19:16:57 INFO - Return code: 0 19:16:57 INFO - Installing None into virtualenv C:\slave\test\build/venv 19:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:16:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:16:57 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02322B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022DDEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x023F9D08>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00768B48>, '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 0x0078A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027C3660>, '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-054', 'USERDOMAIN': 'T-W864-IX-054', '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-054', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-054\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-054', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-054', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-054', '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-054\\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 19:16:57 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in C:\slave\test\build\tests\config 19:16:57 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --download-cache C:\slave\test\build/venv\cache --timeout 120 -r C:\slave\test\build\tests\config\mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:16:57 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 19:16:57 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-054\\AppData\\Roaming', 19:16:57 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 19:16:57 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 19:16:57 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 19:16:57 INFO - 'COMPUTERNAME': 'T-W864-IX-054', 19:16:57 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 19:16:57 INFO - 'DCLOCATION': 'SCL3', 19:16:57 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 19:16:57 INFO - 'FP_NO_HOST_CHECK': 'NO', 19:16:57 INFO - 'HOMEDRIVE': 'C:', 19:16:57 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-054', 19:16:57 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 19:16:57 INFO - 'KTS_VERSION': '1.19c', 19:16:57 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-054\\AppData\\Local', 19:16:57 INFO - 'LOGONSERVER': '\\\\T-W864-IX-054', 19:16:57 INFO - 'MONDIR': 'C:\\Monitor_config\\', 19:16:57 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 19:16:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:16:57 INFO - 'MOZ_NO_REMOTE': '1', 19:16:57 INFO - 'NO_EM_RESTART': '1', 19:16:57 INFO - 'NUMBER_OF_PROCESSORS': '8', 19:16:57 INFO - 'OS': 'Windows_NT', 19:16:57 INFO - 'OURDRIVE': 'C:', 19:16:57 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 19:16:57 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 19:16:57 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 19:16:57 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 19:16:57 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 19:16:57 INFO - 'PROCESSOR_LEVEL': '6', 19:16:57 INFO - 'PROCESSOR_REVISION': '1e05', 19:16:57 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 19:16:57 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 19:16:57 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 19:16:57 INFO - 'PROGRAMW6432': 'C:\\Program Files', 19:16:57 INFO - 'PROMPT': '$P$G', 19:16:57 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 19:16:57 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 19:16:57 INFO - 'PUBLIC': 'C:\\Users\\Public', 19:16:57 INFO - 'PWD': 'C:\\slave\\test', 19:16:57 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 19:16:57 INFO - 'SLAVEDIR': 'C:\\slave\\', 19:16:57 INFO - 'SYSTEMDRIVE': 'C:', 19:16:57 INFO - 'SYSTEMROOT': 'C:\\windows', 19:16:57 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:16:57 INFO - 'TEST1': 'testie', 19:16:57 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:16:57 INFO - 'USERDOMAIN': 'T-W864-IX-054', 19:16:57 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-054', 19:16:57 INFO - 'USERNAME': 'cltbld', 19:16:57 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-054', 19:16:57 INFO - 'WINDIR': 'C:\\windows', 19:16:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 19:16:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:16:58 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 19:16:58 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-v4zzip-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 19:16:58 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)) 19:16:58 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 19:16:58 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ljekqi-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 19:16:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///C:/slave/test/build/tests/mozbase/mozcrash in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2)) 19:16:58 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 19:16:58 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-yd6tar-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 19:16:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///C:/slave/test/build/tests/mozbase/mozdebug in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 3)) 19:16:58 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 19:16:58 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-6getmw-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 19:16:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 from file:///C:/slave/test/build/tests/mozbase/mozdevice in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4)) 19:16:58 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 19:16:58 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-fqmlbc-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 19:16:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///C:/slave/test/build/tests/mozbase/mozfile in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 5)) 19:16:58 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 19:16:58 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-hrgmpi-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 19:16:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///C:/slave/test/build/tests/mozbase/mozhttpd in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 6)) 19:16:58 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 19:16:58 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-7grbho-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 19:16:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 from file:///C:/slave/test/build/tests/mozbase/mozinfo in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 7)) 19:16:58 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 19:16:58 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-odvxvc-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 19:16:59 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)) 19:16:59 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 19:16:59 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rm2okz-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 19:16:59 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)) 19:16:59 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 19:16:59 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-baglgl-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 19:16:59 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)) 19:16:59 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 19:16:59 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-nyshi9-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 19:16:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///C:/slave/test/build/tests/mozbase/moznetwork in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 11)) 19:16:59 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 19:16:59 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ko6vjo-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 19:16:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///C:/slave/test/build/tests/mozbase/mozprocess in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 12)) 19:16:59 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 19:16:59 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-oygxtf-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 19:16:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///C:/slave/test/build/tests/mozbase/mozprofile in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 13)) 19:16:59 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 19:16:59 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-yix2m6-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 19:16:59 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)) 19:16:59 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 19:16:59 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ufo_ts-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 19:16:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///C:/slave/test/build/tests/mozbase/mozscreenshot in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 15)) 19:16:59 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 19:16:59 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-vmyb42-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 19:17:00 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)) 19:17:00 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 19:17:00 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-y10fuz-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 19:17:00 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)) 19:17:00 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)) 19:17:00 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)) 19:17:00 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)) 19:17:00 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)) 19:17:00 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)) 19:17:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10)) 19:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:01 INFO - Downloading blessings-1.5.1.tar.gz 19:17:01 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 19:17:01 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings 19:17:01 INFO - Installing collected packages: blessings 19:17:01 INFO - Running setup.py install for blessings 19:17:02 INFO - Successfully installed blessings 19:17:02 INFO - Cleaning up... 19:17:05 INFO - Return code: 0 19:17:05 INFO - Done creating virtualenv C:\slave\test\build/venv. 19:17:05 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 19:17:05 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 19:17:05 INFO - Reading from file tmpfile_stdout 19:17:05 INFO - Using _rmtree_windows ... 19:17:05 INFO - Using _rmtree_windows ... 19:17:05 INFO - Current package versions: 19:17:05 INFO - blessings == 1.5.1 19:17:05 INFO - blobuploader == 1.2.4 19:17:05 INFO - docopt == 0.6.1 19:17:05 INFO - manifestparser == 1.1 19:17:05 INFO - mozInstall == 1.12 19:17:05 INFO - mozcrash == 0.16 19:17:05 INFO - mozdebug == 0.1 19:17:05 INFO - mozdevice == 0.46 19:17:05 INFO - mozfile == 1.2 19:17:05 INFO - mozhttpd == 0.7 19:17:05 INFO - mozinfo == 0.8 19:17:05 INFO - mozleak == 0.1 19:17:05 INFO - mozlog == 3.0 19:17:05 INFO - moznetwork == 0.27 19:17:05 INFO - mozprocess == 0.22 19:17:05 INFO - mozprofile == 0.27 19:17:05 INFO - mozrunner == 6.10 19:17:05 INFO - mozscreenshot == 0.1 19:17:05 INFO - mozsystemmonitor == 0.0 19:17:05 INFO - moztest == 0.7 19:17:05 INFO - mozversion == 1.4 19:17:05 INFO - psutil == 3.1.1 19:17:05 INFO - requests == 1.2.3 19:17:05 INFO - Installing None into virtualenv C:\slave\test\build/venv 19:17: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')]} 19:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17: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')]} 19:17:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17: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', '-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 0x02322B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022DDEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x023F9D08>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00768B48>, '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 0x0078A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027C3660>, '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-054', 'USERDOMAIN': 'T-W864-IX-054', '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-054', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-054\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-054', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-054', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-054', '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-054\\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 19:17:05 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 19:17:05 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 19:17:05 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 19:17:05 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-054\\AppData\\Roaming', 19:17:05 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 19:17:05 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 19:17:05 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 19:17:05 INFO - 'COMPUTERNAME': 'T-W864-IX-054', 19:17:05 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 19:17:05 INFO - 'DCLOCATION': 'SCL3', 19:17:05 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 19:17:05 INFO - 'FP_NO_HOST_CHECK': 'NO', 19:17:05 INFO - 'HOMEDRIVE': 'C:', 19:17:05 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-054', 19:17:05 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 19:17:05 INFO - 'KTS_VERSION': '1.19c', 19:17:05 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-054\\AppData\\Local', 19:17:05 INFO - 'LOGONSERVER': '\\\\T-W864-IX-054', 19:17:05 INFO - 'MONDIR': 'C:\\Monitor_config\\', 19:17:05 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 19:17:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:05 INFO - 'MOZ_NO_REMOTE': '1', 19:17:05 INFO - 'NO_EM_RESTART': '1', 19:17:05 INFO - 'NUMBER_OF_PROCESSORS': '8', 19:17:05 INFO - 'OS': 'Windows_NT', 19:17:05 INFO - 'OURDRIVE': 'C:', 19:17: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', 19:17:05 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 19:17:05 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 19:17:05 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 19:17:05 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 19:17:05 INFO - 'PROCESSOR_LEVEL': '6', 19:17:05 INFO - 'PROCESSOR_REVISION': '1e05', 19:17:05 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 19:17:05 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 19:17:05 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 19:17:05 INFO - 'PROGRAMW6432': 'C:\\Program Files', 19:17:05 INFO - 'PROMPT': '$P$G', 19:17:05 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 19:17:05 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 19:17:05 INFO - 'PUBLIC': 'C:\\Users\\Public', 19:17:05 INFO - 'PWD': 'C:\\slave\\test', 19:17:05 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 19:17:05 INFO - 'SLAVEDIR': 'C:\\slave\\', 19:17:05 INFO - 'SYSTEMDRIVE': 'C:', 19:17:05 INFO - 'SYSTEMROOT': 'C:\\windows', 19:17:05 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:17:05 INFO - 'TEST1': 'testie', 19:17:05 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:17:05 INFO - 'USERDOMAIN': 'T-W864-IX-054', 19:17:05 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-054', 19:17:05 INFO - 'USERNAME': 'cltbld', 19:17:05 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-054', 19:17:05 INFO - 'WINDIR': 'C:\\windows', 19:17:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 19:17:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:05 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)) 19:17:05 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)) 19:17:05 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)) 19:17:05 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)) 19:17:05 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)) 19:17:05 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)) 19:17:05 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)) 19:17:05 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)) 19:17:05 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)) 19:17:05 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)) 19:17:05 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)) 19:17:05 INFO - Cleaning up... 19:17:05 INFO - Return code: 0 19:17:05 INFO - Running post-action listener: _resource_record_post_action 19:17:05 INFO - Running post-action listener: _start_resource_monitoring 19:17:05 INFO - Starting resource monitoring. 19:17:05 INFO - ##### 19:17:05 INFO - ##### Running install step. 19:17:05 INFO - ##### 19:17:05 INFO - Running pre-action listener: _resource_record_pre_action 19:17:05 INFO - Running main action method: install 19:17:05 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 19:17:05 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 19:17:06 INFO - Reading from file tmpfile_stdout 19:17:06 INFO - Using _rmtree_windows ... 19:17:06 INFO - Using _rmtree_windows ... 19:17:06 INFO - Detecting whether we're running mozinstall >=1.0... 19:17:06 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h'] 19:17:06 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h 19:17:06 INFO - Reading from file tmpfile_stdout 19:17:06 INFO - Output received: 19:17:06 INFO - Usage: mozinstall-script.py [options] installer 19:17:06 INFO - Options: 19:17:06 INFO - -h, --help show this help message and exit 19:17:06 INFO - -d DEST, --destination=DEST 19:17:06 INFO - Directory to install application into. [default: 19:17:06 INFO - "C:\slave\test"] 19:17:06 INFO - --app=APP Application being installed. [default: firefox] 19:17:06 INFO - Using _rmtree_windows ... 19:17:06 INFO - Using _rmtree_windows ... 19:17:06 INFO - mkdir: C:\slave\test\build\application 19:17:06 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'] 19:17:06 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 19:17:07 INFO - Reading from file tmpfile_stdout 19:17:07 INFO - Output received: 19:17:07 INFO - C:\slave\test\build\application\firefox\firefox.exe 19:17:07 INFO - Using _rmtree_windows ... 19:17:07 INFO - Using _rmtree_windows ... 19:17:07 INFO - Running post-action listener: _resource_record_post_action 19:17:07 INFO - ##### 19:17:07 INFO - ##### Running run-tests step. 19:17:07 INFO - ##### 19:17:07 INFO - Running pre-action listener: _resource_record_pre_action 19:17:07 INFO - Running main action method: run_tests 19:17:07 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version'] 19:17:07 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version 19:17:07 INFO - Python 2.7.3 19:17:07 INFO - Return code: 0 19:17:07 INFO - grabbing minidump binary from tooltool 19:17:07 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')]} 19:17:07 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 0x00768B48>, '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 0x0078A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x027C3660>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1 19:17:07 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 19:17:07 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 19:17:08 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 19:17:11 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmpx1e8d9 19:17:11 INFO - INFO - File integrity verified, renaming tmpx1e8d9 to win32-minidump_stackwalk.exe 19:17:11 INFO - Return code: 0 19:17:11 INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755 19:17:11 INFO - mkdir: C:\slave\test\build\blobber_upload_dir 19:17:11 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir 19:17:11 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe 19:17:11 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir 19:17:11 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/dQuddg34Qh2Midi_iuzHqA/artifacts/public/build/firefox-44.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-054', '--webServer', 'localhost'] in C:\slave\test\build 19:17:11 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/dQuddg34Qh2Midi_iuzHqA/artifacts/public/build/firefox-44.0a1.en-US.win64.crashreporter-symbols.zip --title T-W864-IX-054 --webServer localhost 19:17:11 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 19:17:11 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-054\\AppData\\Roaming', 19:17:11 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 19:17:11 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 19:17:11 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 19:17:11 INFO - 'COMPUTERNAME': 'T-W864-IX-054', 19:17:11 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 19:17:11 INFO - 'DCLOCATION': 'SCL3', 19:17:11 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 19:17:11 INFO - 'FP_NO_HOST_CHECK': 'NO', 19:17:11 INFO - 'HOMEDRIVE': 'C:', 19:17:11 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-054', 19:17:11 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 19:17:11 INFO - 'KTS_VERSION': '1.19c', 19:17:11 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-054\\AppData\\Local', 19:17:11 INFO - 'LOGONSERVER': '\\\\T-W864-IX-054', 19:17:11 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir', 19:17:11 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe', 19:17:11 INFO - 'MONDIR': 'C:\\Monitor_config\\', 19:17:11 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 19:17:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:11 INFO - 'MOZ_NO_REMOTE': '1', 19:17:11 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir', 19:17:11 INFO - 'NO_EM_RESTART': '1', 19:17:11 INFO - 'NUMBER_OF_PROCESSORS': '8', 19:17:11 INFO - 'OS': 'Windows_NT', 19:17:11 INFO - 'OURDRIVE': 'C:', 19:17:11 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', 19:17:11 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 19:17:11 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 19:17:11 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 19:17:11 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 19:17:11 INFO - 'PROCESSOR_LEVEL': '6', 19:17:11 INFO - 'PROCESSOR_REVISION': '1e05', 19:17:11 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 19:17:11 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 19:17:11 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 19:17:11 INFO - 'PROGRAMW6432': 'C:\\Program Files', 19:17:11 INFO - 'PROMPT': '$P$G', 19:17:11 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 19:17:11 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 19:17:11 INFO - 'PUBLIC': 'C:\\Users\\Public', 19:17:11 INFO - 'PWD': 'C:\\slave\\test', 19:17:11 INFO - 'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos', 19:17:11 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 19:17:11 INFO - 'SLAVEDIR': 'C:\\slave\\', 19:17:11 INFO - 'SYSTEMDRIVE': 'C:', 19:17:11 INFO - 'SYSTEMROOT': 'C:\\windows', 19:17:11 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:17:11 INFO - 'TEST1': 'testie', 19:17:11 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 19:17:11 INFO - 'USERDOMAIN': 'T-W864-IX-054', 19:17:11 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-054', 19:17:11 INFO - 'USERNAME': 'cltbld', 19:17:11 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-054', 19:17:11 INFO - 'WINDIR': 'C:\\windows', 19:17:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 19:17:11 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/dQuddg34Qh2Midi_iuzHqA/artifacts/public/build/firefox-44.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-054', '--webServer', 'localhost'] with output_timeout 3600 ProcessManager NOT managing child processes ProcessManager UNABLE to use job objects to manage child processes 19:17:12 INFO - mozversion INFO | application_buildid: 20151021172720 19:17:12 INFO - mozversion INFO | application_changeset: 7e37f3445ffea580864bfde8e5c0efbc6cf2274b 19:17:12 INFO - mozversion INFO | application_display_name: Nightly 19:17:12 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:17:12 INFO - mozversion INFO | application_name: Firefox 19:17:12 INFO - mozversion INFO | application_remotingname: firefox 19:17:12 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:17:12 INFO - mozversion INFO | application_vendor: Mozilla 19:17:12 INFO - mozversion INFO | application_version: 44.0a1 19:17:12 INFO - mozversion INFO | platform_buildid: 20151021172720 19:17:12 INFO - mozversion INFO | platform_changeset: 7e37f3445ffea580864bfde8e5c0efbc6cf2274b 19:17:12 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:17:12 INFO - mozversion INFO | platform_version: 44.0a1 19:17:12 INFO - 2015-10-21 19:17:12,346 DEBUG : using testdate: 1445480232 19:17:12 INFO - 2015-10-21 19:17:12,346 DEBUG : actual date: 1445480232 19:17:12 INFO - 2015-10-21 19:17:12,395 INFO : starting webserver on 'localhost:49278' 19:17:12 INFO - 2015-10-21 19:17:12,398 INFO : Starting test suite T-W864-IX-054 19:17:12 INFO - 2015-10-21 19:17:12,398 INFO : Starting test dromaeo_css 19:17:12 INFO - 2015-10-21 19:17:12,398 DEBUG : operating with platform_type : w8_ 19:17:12 INFO - 2015-10-21 19:17:12,398 INFO : Initialising browser for dromaeo_css test... 19:17:12 INFO - 2015-10-21 19:17:12,507 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmp0ipujd\profile http://localhost:49278/getInfo.html 19:17:21 INFO - 2015-10-21 19:17:21,381 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:17:21 INFO - 2015-10-21 19:17:21,381 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:17:21 INFO - 2015-10-21 19:17:21,381 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674 19:17:21 INFO - 2015-10-21 19:17:21,381 DEBUG : BROWSER_OUTPUT: __metrics 19:17:21 INFO - 2015-10-21 19:17:21,522 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:17:22 INFO - 2015-10-21 19:17:22,173 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 121: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 19:17:23 INFO - 2015-10-21 19:17:23,328 INFO : Browser initialized. 19:17:23 INFO - 2015-10-21 19:17:23,328 INFO : Running cycle 1/1 for dromaeo_css test... 19:17:23 INFO - 2015-10-21 19:17:23,328 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmp0ipujd\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:17:34 INFO - 2015-10-21 19:17:34,861 DEBUG : BROWSER_OUTPUT: RSS: Main: 177385472 19:17:34 INFO - 2015-10-21 19:17:34,861 DEBUG : BROWSER_OUTPUT: 19:18:25 INFO - 2015-10-21 19:18:25,970 DEBUG : BROWSER_OUTPUT: 1445480305963 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:20:35 INFO - 2015-10-21 19:20:35,065 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 19:20:36 INFO - 2015-10-21 19:20:36,017 DEBUG : BROWSER_OUTPUT: RSS: Main: 221130752 19:20:36 INFO - 2015-10-21 19:20:36,017 DEBUG : BROWSER_OUTPUT: 19:23:38 INFO - 2015-10-21 19:23:38,872 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 19:23:39 INFO - 2015-10-21 19:23:39,437 DEBUG : BROWSER_OUTPUT: RSS: Main: 232484864 19:23:39 INFO - 2015-10-21 19:23:39,437 DEBUG : BROWSER_OUTPUT: 19:26:41 INFO - 2015-10-21 19:26:41,694 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 19:26:42 INFO - 2015-10-21 19:26:42,256 DEBUG : BROWSER_OUTPUT: RSS: Main: 182542336 19:26:42 INFO - 2015-10-21 19:26:42,256 DEBUG : BROWSER_OUTPUT: 19:29:44 INFO - 2015-10-21 19:29:44,572 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 19:29:45 INFO - 2015-10-21 19:29:45,135 DEBUG : BROWSER_OUTPUT: RSS: Main: 169537536 19:29:45 INFO - 2015-10-21 19:29:45,135 DEBUG : BROWSER_OUTPUT: 19:32:48 INFO - 2015-10-21 19:32:48,046 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 19:32:48 INFO - 2015-10-21 19:32:48,628 DEBUG : BROWSER_OUTPUT: RSS: Main: 169021440 19:32:48 INFO - 2015-10-21 19:32:48,628 DEBUG : BROWSER_OUTPUT: 19:35:51 INFO - 2015-10-21 19:35:51,411 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 19:35:51 INFO - 2015-10-21 19:35:51,661 DEBUG : BROWSER_OUTPUT: RSS: Main: 212774912 19:35:51 INFO - 2015-10-21 19:35:51,661 DEBUG : BROWSER_OUTPUT: 19:35:51 INFO - 2015-10-21 19:35:51,663 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:35:51 INFO - 2015-10-21 19:35:51,663 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:35:51 INFO - 2015-10-21 19:35:51,663 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:35:51 INFO - 2015-10-21 19:35:51,663 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:35:51 INFO - 2015-10-21 19:35:51,664 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2624.4357463145425;2685.8119931604797;2688.973110268898;2690.6502154719888;2707.296103013216;4808.831690890819;4818.445878723948;4875.975620121894;4886.315915771795;4943.159662857314;4848.636352273585;4876.951455437081;4880.46314905361;4901.166801643721;4954.554090131887;4230.746155230696;4357.7385356878685;4408.228560001995;4423.159599676067;4429.6899217054815;4309.332053531708;4333.414988976495;4370.73775573465;4389.253826849427;4437.445319335083;4406.383106365111;4432.335149727551;4444.422225110731;4445.5776701213335;4485.372047913294;4245.066085461193;4320.762358070305;4446.644268458548;4448.510663826976;4495.280755079204;4327.437433133704;4350.521442641307;4350.58669426404;4438.245498265271;4438.556144385568;4765.1660959331975;4789.664723469358;4794.304825800275;4798.736069516175;4849.9272510912015;4828.203346447832;5092.185250359962;5093.24262859175;5095.184770436749;5121.103806833827;4968.354113965198;5016.799328026875;5050.166722490784;5052.797888084472;5059.772310246048;4682.016776476944;4723.622110231173;4724.881877953045;4745.762711864393;4781.282807578857;4912.017596480719;5182.97408512955;5192.662476938987;5199.740012999335;5207.557357624644;4959.2065269557415;4971.130052240844;5037.471065538139;5049.974750126225;5118.513741194581;5070.771815268322;5107.387113546324;5114.769835357418;5126.948730512721;5167.793288268503;4821.63837712173;4946.505349465025;5057.6459647824295;5059.114654935372;5067.797288108508;4876.780544875489;4896.4124305083615;4929.457759646436;4929.728864912464;4997.475265097185;3357.345317663081;3362.9663703363144;3363.64681708422;3394.8302584870657;3402.7788193767324;2983.9552406713915;3080.5225190095125;3100.116466806949;3119.2201949512623;3125.4686703260045;4628.051249493846;4669.486356500782;4713.434387873409;4715.056988602293;4770;5146.562542183881;5153.020926024044;5165.638405311667;5177.068127737043;5227.006868694936;4506.864794056183;4674.485806561275;4727.054589082198;4727.64542659302;4794.832180873723;4097.590240975938;4161.687873409446;4169.124483858423;4208.38978348144;4223.092035212444;5124.1032819257225;5132.461091585405;5138.049460849755;5142.280080788692;5145.253938178943;4767.070421267819;4908.631852610997;5092.694438333712;5110.565601923878;5128.12821820284;5042.294078828893;5093.516115968977;5164.586833053422;5178.585713143015;5227.18978558324;4969.35398398206;5055.090083784807;5059.367579052619;5075.77159027852;5118.692878427306;4918.901621967612;4988.251762235694;5118;5119.129747942933;5119.92320115206;4861;4889.413270407574;4910.2880082388565;4951.777170027285;4983.4518202996915;4919.139150648693;4919.606431485544;4950.2079667253065;5006.199008158677;5044.319016932667;4733.928991065068;4825.879353016203;4934.136526107845;4936.086823937583;4988.351514303117;4951.480094590161;4957.380327459067;5044.066847633199;5055.266986286894;5078.771455284447;4867.318575399518;4919.680220785637;4929.950700492949;4933.654644174873;4988.276699878425 19:35:51 INFO - 2015-10-21 19:35:51,664 DEBUG : BROWSER_OUTPUT: |1;ext.html;565.5136582539016;568.0797108683931;574.0786038408355;580.9041508151158;586.126671259823;30125.54811677824;37264.62735372646;37638.247235055314;37997.81001094994;38102.618973810255;40262.19475610493;40340.79829600855;40676;40813.59186408135;40927.38608920869;7338.229485903983;7375.85674220494;8184.263416292532;8363.20549547792;8371.58142092896;10157.441340726295;10323.174146068333;10388.584456621726;10408.115310198642;10410.720623003768;10085.949570252138;10114.34256773311;10176.592936282539;10186.59253629854;10205.183585313158;7514.0607424071995;7687.231276872324;10061.295709300315;10228.59085636581;10507.684769456928;9979.351342162809;10112.191024718006;10113.24150688694;10138.239632027628;10147;37713.24573508515;38135.237295254214;38138.61405938297;38232.42651360232;38244;2893.985530072357;2946.3076177098364;2971.5542668599883;2972.925676858096;3015.4873671475902;27595;27822.443551128865;28001.57997630037;28506.144815655563;28611.427771444454;2658.6012098185233;2689.260453375318;2716.3209197700576;2734;2817.2534278416238;225838;227833.99999999834;228115;228458.99999999834;230192;48147.27779083316;48812.75593622009;54817.72591137019;54854.72572637191;55251;55669.72165139148;56511;56878.17461904598;56899.43100569024;56928.43071569231;14832.18422986746;14950.62623434401;14957.027793193407;15049.473268435551;15055.849441505663;11525.366104864313;11536.826947595793;11549.422528873523;11582.305061696325;11638;18485.44543663692;18522.907385463255;18560.164792584364;18574.628507429778;18629.7205541917;8100.594970251464;8437.789055273668;8438.873416898752;8444.831103377897;8449.32405407566;924.861270809384;927.2674587076134;939.5490164720835;963.9951800241095;1089.9891001090045;26734.5989810153;26806.5979010315;27136;27236.863815680794;31131.377372452425;954.627695198873;1008.3848852200152;1016.755978565139;1033.452270296744;1078.8489611454402;14058.929705351407;14586.781198282035;15214.40925627715;15284.159371234466;15525.301361438536;305381;308800;309616.0383961631;310531;310644;50958.74520627373;51920.22119668208;51942.740286299086;51968.48031519712;52009.219861702106;1309.6333026752525;1317.0648839323997;1322.4313545175282;1333.4132981488308;1334.2728213123871;28151.57772633371;28514.57228141538;28785.424291513635;29072.27319317034;29086.7091329084;49596.50403495919;50947.2357914639;51011.74494127506;51237.48762512476;51339.743301283255;247117;248758;249155;250700;251029;36299.01777011343;36937.07202479111;39302.80348598239;39401.80299098486;39657.40513892236;35695.46456803202;38005.42991855069;41016.58983410128;41780.791096044326;42301.36547951722;33934.96040438904;35078.298434030665;35080.298394032485;35485.82257088698;35570;30254.243643908198;32944.505832412055;35055.47416788699;38038.831848508205;40255.59744402519;33953.83023084869;34464.310713786086;34497.65502344944;34693.47959780656;35022.64977350194;30148.84925575358;31363.84318078395;31381.372372552876;31395.84302078475;31612.683873160975;23778.40553986164;23868.52262954766;24161.63757543603;24242.87878560596;24636.260912172664 19:35:51 INFO - 2015-10-21 19:35:51,673 DEBUG : BROWSER_OUTPUT: |2;jquery.html;358.4265175718849;361.8841970569419;365.2202547560957;367.783008025265;370.35188420264535;13070.803937940915;13383.799243011363;15040.623984400381;15332.61668458289;16029.118398488094;13948.372323245452;15429.45996890109;15622;15638.921805390986;16533.42133025341;5223.582113430926;5348.331458567679;5353.652012619187;5355.410904800468;5362.731863406833;3881.10734531058;3988.561258261589;5238.8690282742855;5291.947080529184;5748.310202775652;5859.4140585941495;5883.38224486427;5892.941070589303;5961.940380596204;5969.074793407007;5814.360420353758;5992.79025234119;5998.070299103646;6009.579329446962;6014.96992515039;5234.371875374942;5242.711650859202;5243.711595862226;5249.47505249472;5250.894982100374;11420.942895285554;11452.484638191301;11722.70693232676;11818.349990750505;11818.645440636794;1614.9596260093474;1638.8852780305383;1651.8678505719513;1705.4542546385162;1740.321274702867;8504.914950850474;8676.566171691391;8727.912720872773;8816.338774591932;8901.688440904538;1634.6730653869274;1641.3844808196927;1643.3426629348237;1643.3649759701286;1652.1904266909128;44891;46235.30647040297;52594.47405525934;53074.46925530734;53364;6122.969385153135;6191.876162476815;6213.5339849510565;6290.779822706183;6327.430531252209;7335.303146201102;7360.33756961876;7360.521566098187;7371.078615173104;7406.962965185247;4989.476105008995;5050.3081467708;5052.5705315048635;5088.542031217208;5092.108880945893;5299.549538289289;5338.199270109515;5371.140617501181;5395.622306438511;5412.810551630752;2846.9145925622265;2858.371158345161;2868.928276793055;2883.452144092658;2885.7835662324987;938.2962777916563;980.1325826643472;1021.1269364693229;1034.912032477248;1106.391484683421;391.0848614242686;408.05738743502013;418.5166133116256;431.3400497239229;445.1830890316306;8513.446625969293;9844.409335439754;10684.679459616224;10897.346159230472;11363.034142098015;423.40934396516684;438.2527790117841;439.9780010999437;442.25480066088744;446.2881703682621;5961.880762384728;6084.665343406155;6105.297890742532;6147.323794382614;6152.230971128609;412777;413029;417257.5484902971;417845;420130;63403.68298158572;65801;66417;67242.66378668076;68385.29036774121;440.8853698038533;441.23886296139545;446.51553064924923;448.8092560661706;451.71316214204217;9421.419860452985;9972.900270997197;10013.349132306377;10054.497275136067;10114.94942525312;29487.852560737058;30592.84703576468;30812.69187308098;30822;30839.2290192747;39052;39485.210295794495;39485.40771888482;40011.59988400195;40037;5969.492593129633;6024.5481588881885;6105.84735381619;6115.327313995546;6122.571420000735;10686.0916822071;10689.625863094754;10923.945380273048;10948.781024379308;10964.671059868217;9198.175519054912;9303.255739540957;9325.440473571607;9401.482918439551;9594.280428967995;9462;9492.430454172772;9528.380655257386;9679.08048735369;9789.951050244703;9173.495457749621;9418.340716150078;9584.808303834025;9686.854697179408;9729.70810875675;5751.33859606134;5811.186433899342;5834.329052159056;5898.9115163273445;5989.251343582052;9392.953035235054;9407.717768466957;9426.57580408897;9508.762280942756;9801.411915285105 19:35:51 INFO - 2015-10-21 19:35:51,674 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1288.7164823738774;1402.8176337076181;1583.8336974617664;1589.8251192368837;1799.5501124718821;7349.412047036238;8184.877226841602;8469.491830490175;8491.065982741893;8493.830123397536;8004.679812807495;8111.675532978688;8120.634571444284;8132.26809587137;8143.552104634243;1922.826945574898;1952.384998725404;2101.2120454829437;2172.7392712874475;2196.099599164343;2189.912403503858;2200.427888748921;2204.6252137136726;2206.680031395447;2208.083645287204;2094.3716884934533;2156.3746513511064;2180.4984853483707;2180.5093853882827;2183.29043061005;1917.9451301784034;1959.2848610257224;2118.205672872673;2175.7824217578273;2186.9125234990584;2146.4097373222335;2184.7815218478186;2186.30038387716;2190.59473997311;2200.5818894410013;8199.79500512486;8372.83254334916;8373.16268373164;8374.706885258987;8375.790605234857;4775.355327030841;4853.733044682541;4856.878578035542;4856.902861942776;4860.222364421711;2794.9441011179865;2860.9284767880763;2886.8556572171306;2895.666998295202;2900.274931267183;841.4194205997842;843.0726201178654;860.2902605350611;861.1259571534897;871.5467956662563;11782.528698852035;11811.763764724657;11884.465199066062;11889.643310700692;11914.880851191463;4144.5233798113;4280.5505421930875;4298.183345164409;4332.0469496710675;4344.804483798237;9766.804663906682;9770.706878793648;9774.657886973922;9794.902050979541;9820.067093626238;4714.717116972924;4727.598154156866;4737.170995075917;4738;4757.072370887644;4259.97870010648;4261.446012018479;4264.786760661955;4291.291936830388;4291.570842915684;3686.768641118423;3693.0951916780023;3707.2214834884435;3710.962890371116;3726.7018638508853;1197.9700507487382;1219.1405059433077;1222.608765195129;1228.748106638137;1231.7043909461665;980.7253968888723;1033.204432586904;1218.5917717564714;1293.8059291106222;1311.9803202951964;7110.857782844418;8040;8278.8344233115;8293.460925039853;8298.502089874626;600.4805842945821;608.622653954551;1211.497228650118;1228.2384921348641;1244.6701624069628;5988.371221021817;6172;6184.196054512884;6194.287656919422;6194.628322300677;9658.661946831968;10130.341527800669;10130.898691012995;10157.644482443227;10168.186545076376;10010.399376037461;10073.546690398949;10160.441175735405;10162.898371016196;10187.643432479828;7599.430042746816;7642.617869106633;7734.806629834299;7738.961305193438;7739.18738532446;7511.173770885308;7578.772636820904;7587.203343649058;7590.924090759022;7606.885896711443;8677.088905664814;8833.955830220808;8863.734087977113;8874.645014199617;8880;8854.468731876108;9024.232940199894;9038.502882341534;9047.819043619222;9128.954355228447;7234.855302894018;7309.342159205697;7314.195438501867;7325.304096110861;7331.74338898136;7974.202579741979;8011.278984891388;8017.917581126707;8233;8234.629441675019;7325.6337183141695;7340.669669864762;7368.300011498899;7473.580019796222;7678;7280.708771649075;7308.342249197598;7485.026946496921;7525.962370188114;7564.886526702214;7397.593132377771;7524.473286869867;7559.659815308434;7560.3573696236435;7578.3179513841815;6830.453563714792;6833.897491537531;6869;6906.689198985957;6915.308469153045;6815.148106486689;6854.3145685433055;6863.588184708933;6899.793006209822;6986.54587451814 19:35:51 INFO - 2015-10-21 19:35:51,697 DEBUG : BROWSER_OUTPUT: |4;prototype.html;302.8712797061251;306.5218259515156;309.2747507095861;311.2266018942928;323.0679489672295;5105.617078719097;5106.565941894939;5163.432022477525;5164.896702065957;5170.586353091753;5042.495750424956;5090.618203634733;5101.897962040757;5103.413107492639;5106.336176297076;3886.4947556817574;3944.7830369329677;4056.594340565942;4069.613386728256;4071.5724848890886;3931.547871994714;3962.9207415851665;3968.7817170055637;3986.7807270600106;3993.9800300998454;3960.821763020671;3964.0288129408336;3967.1272320089533;3967.1867267210296;3968.8412463501427;3849.961500384988;3918.1380096378753;3918.3142949983926;3964.8017599120217;3965.8810235692977;3475.6350583188655;3476.478528220787;3484.1289677580603;3512.701420379271;3529.1000794797164;4942.1351263529095;4943.258511223309;4945.67853089548;4953.083679519301;4955.033768415161;4431.113777244564;4466.642668586505;4474.709143905636;4475.261581838992;4488.663350248745;5209.426963034101;5265.815696450606;5307.495787900143;5324.653897496651;5338.786448542053;3789.8484060637543;3790.8673196437994;3792.810359482015;3800.524934383202;3803.6386543278622;5497.532709719679;5568.136938774496;5572.3870374258795;5580.302462192226;5591.329040515164;3865.7873816939777;3913.471681323042;3918.74528155669;3920.137569734654;3924;3882.786446745456;3968.4840970673627;3969.1466334737593;3970.642642162219;3973.4039894016128;4486.416765820488;4489.438820147481;4490.393796837385;4504.572065653758;4530.524294949048;5308.30991971049;5326.9467305327225;5331.040412725747;5335.626506144533;5346.893062138735;1436.1670231265841;1458.3801884199172;1460.7224627320775;1460.8685218330402;1461.992690036543;993.4982833668951;999.3753903810118;1017.8218811707922;1020.8570800087994;1021.1881554164457;5021.84934451967;5057.6459647824295;5061.645684802103;5062.772175252123;5068.82259120929;5481.588880833953;5501.14732216507;5524.861878453071;5525.254090697785;5526.778928842801;5043.520865517843;5046.899062018739;5048.29323894655;5049.166887463601;5073.213651883964;2968.807027543203;3009.3680327131547;3035.5446682997285;3050.984745076305;3051.67957364478;5520.558355331564;5530;5534.806281780199;5536.501714845684;5539.113741801292;5625;5629.887402251932;5631.690257035821;5632.690202038927;5633.464820842013;5514.641548299348;5528.226048353154;5528.668279903219;5532.17017447378;5533.418991005967;5354.330708661418;5501.752421140978;5568.443155684399;5570.91643625354;5593.944060559343;5413.485718856702;5434.83695489136;5448.645838020516;5450.182472628979;5451.727413629382;5540.972295138498;5585.525230355465;5588.580856435865;5588.608797384144;5595.496405323541;3724.832382542738;3783.659470647655;3828.444875492982;3831.5785263620423;3855.0747820523434;5543.584231182758;5552.888942221052;5558.610897237155;5559.16612508127;5566.304211973504;5354.277172581652;5365.275687782256;5373.892522149457;5385.219143224289;5399.919001215064;5351.010063138332;5391.029614669397;5398.028354896156;5407.026735187546;5413.24214609947;5188.455212202664;5232.110541207928;5338.973305133605;5341.599380046434;5346.679199248058;5184.533391994739;5272.024675435056;5393.83818485446;5412.269343638558;5437.592180586393;5092.541671249605;5267;5275.868103297448;5281.049411106038;5284.709340986283 19:35:51 INFO - 2015-10-21 19:35:51,697 DEBUG : BROWSER_OUTPUT: |5;yui.html;619.6375120554476;637.8979363301872;796.756989118319;829.5354601423203;847.4660963592937;10690.204977233087;10855.620053298137;10869.6739097827;10874.075703565186;10877.945610271947;11948.984336331423;12182.329971851545;12189.329586872718;12207.816882746765;12277.324747138926;672.0322735261208;673.2997682410287;801.1387758159987;808.7250334886138;809.134226377776;815.4251252866715;817.6933649881295;818.0633175014605;822.1203312455675;826.1944604011101;803.4496369986549;838.5681374092317;843.7595285343679;844.8183640517287;848.5799529233008;704.7216349541928;705.2594775485719;840.9495430274142;844.4342290665269;844.8310337932377;616.8951278282702;619.7768803230833;619.894617914951;620.1627802466679;620.407510827159;10442.582296708122;10534.420606866619;10568.894311056945;10576.206784491194;10580.206484513692;8247.257746802756;8366.372522060808;8500.957495212484;8552.486850788973;8597.828043439096;8371.288440482565;8402.327813774884;8724.694635687783;8803.515806630632;8811.383203175781;2975.0628552006265;2985.626796650419;2987.775916806248;3041.0876736978817;3053.587765651631;31199.84400078008;31293.374132517223;31413.685863141305;31500.684993150233;31554.842225788954;6082.635041897501;6206.410391012847;6215.254169499689;6255.593386429959;6363.61818290904;9753.561089750978;9754.268429867789;9763.072508111718;9763.707088787347;9788.902110978941;5481.616286859881;5671.376148623648;5797.681127538026;5964.701764911737;6093.086037094383;3744.082699738527;3755.4930084438797;3851.788151651686;3865.8646947356706;3868.4390763339156;2224.977750222477;2248.2018883296523;2248.685184074231;2249.38142010945;2258.4241018540497;377.38109500419336;384.0456465682776;384.11461581055374;384.2411237805312;387.2584001636834;435.6253621885176;452.76682508508145;456.7670488051118;482.53676470587925;490.3177139681021;6339.461145802658;6496.902546461807;6742.224644165984;6860.3139686032;6903.240643529208;522.7830450363057;594.304663543655;611.1321922869536;645.4965127200791;645.6965226343611;3299.158714527828;3300.0924745694647;3313.93372132556;3395.6668424876425;3407.8296085195643;39945.201095977915;40285.59714402819;40484;40582;40592.797036015225;33643.495347569806;33925.49111763276;34229.144271392914;34256;34265.48601770975;29124.126276211322;29236.853815730785;29725.256868578457;29754.25614359615;29783.851080744458;6521.380468855451;6538.476921846336;6581.539292249497;6596.670166491752;6695.029220763059;21458.180447846942;21763.12947482083;21834.672479912497;21884.89057554702;22122;27783.30541736473;28140.155795326173;28167.859160704065;28168.577471337536;28200.29499262535;5658.547316214611;5723.427657234243;5885.73514191871;5931.673757943355;6048.576599637983;9103.90896091057;9394.342396032485;9556.95221523888;9701.805963880543;9764.414135151914;8351.29014033814;8387.454815436977;8481.87277190855;8574.91425085766;8641.611127499404;8248.13394593559;8264.793380165303;8325.053548158412;8457.36569757283;8550;7879.763607091567;8503.532305723245;8951.060138685345;9002.234810040958;9060.139286767746;8070.677172913018;8203.958980205061;8396.87404688918;8404.327653787805;8687.565621719015;7743.186965368555;7815.882761758692;8032.799180020313;8149.266566009088;8303.584820759059 19:35:51 INFO - 2015-10-21 19:35:51,698 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:35:51 INFO - 2015-10-21 19:35:51,698 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:35:51 INFO - 2015-10-21 19:35:51,698 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,693 19:35:51 INFO - 2015-10-21 19:35:51,698 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:35:51 INFO - 2015-10-21 19:35:51,698 DEBUG : BROWSER_OUTPUT: __startTimestamp1445481351661__endTimestamp 19:35:51 INFO - 2015-10-21 19:35:51,698 DEBUG : BROWSER_OUTPUT: 19:35:51 INFO - 2015-10-21 19:35:51,700 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:35:51 INFO - 2015-10-21 19:35:51,700 DEBUG : BROWSER_OUTPUT: Number of tests: 6 19:35:51 INFO - 2015-10-21 19:35:51,700 DEBUG : BROWSER_OUTPUT: 19:35:51 INFO - 2015-10-21 19:35:51,700 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4681.55 Median:4901.17 stddev:592.37 (12.1%) stddev-sans-first:571.78 19:35:51 INFO - 2015-10-21 19:35:51,700 DEBUG : BROWSER_OUTPUT: Values: 2624.4 2685.8 2689.0 2690.7 2707.3 4808.8 4818.4 4876.0 4886.3 4943.2 4848.6 4877.0 4880.5 4901.2 4954.6 4230.7 4357.7 4408.2 4423.2 4429.7 4309.3 4333.4 4370.7 4389.3 4437.4 4406.4 4432.3 4444.4 4445.6 4485.4 4245.1 4320.8 4446.6 4448.5 4495.3 4327.4 4350.5 4350.6 4438.2 4438.6 4765.2 4789.7 4794.3 4798.7 4849.9 4828.2 5092.2 5093.2 5095.2 5121.1 4968.4 5016.8 5050.2 5052.8 5059.8 4682.0 4723.6 4724.9 4745.8 4781.3 4912.0 5183.0 5192.7 5199.7 5207.6 4959.2 4971.1 5037.5 5050.0 5118.5 5070.8 5107.4 5114.8 5126.9 5167.8 4821.6 4946.5 5057.6 5059.1 5067.8 4876.8 4896.4 4929.5 4929.7 4997.5 3357.3 3363.0 3363.6 3394.8 3402.8 2984.0 3080.5 3100.1 3119.2 3125.5 4628.1 4669.5 4713.4 4715.1 4770.0 5146.6 5153.0 5165.6 5177.1 5227.0 4506.9 4674.5 4727.1 4727.6 4794.8 4097.6 4161.7 4169.1 4208.4 4223.1 5124.1 5132.5 5138.0 5142.3 5145.3 4767.1 4908.6 5092.7 5110.6 5128.1 5042.3 5093.5 5164.6 5178.6 5227.2 4969.4 5055.1 5059.4 5075.8 5118.7 4918.9 4988.3 5118.0 5119.1 5119.9 4861.0 4889.4 4910.3 4951.8 4983.5 4919.1 4919.6 4950.2 5006.2 5044.3 4733.9 4825.9 4934.1 4936.1 4988.4 4951.5 4957.4 5044.1 5055.3 5078.8 4867.3 4919.7 4930.0 4933.7 4988.3 19:35:51 INFO - 2015-10-21 19:35:51,700 DEBUG : BROWSER_OUTPUT: 19:35:51 INFO - 2015-10-21 19:35:51,700 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43374.49 Median:309208.02 stddev:68860.77 (22.3%) stddev-sans-first:68978.93 19:35:51 INFO - 2015-10-21 19:35:51,700 DEBUG : BROWSER_OUTPUT: Values: 565.5 568.1 574.1 580.9 586.1 30125.5 37264.6 37638.2 37997.8 38102.6 40262.2 40340.8 40676.0 40813.6 40927.4 7338.2 7375.9 8184.3 8363.2 8371.6 10157.4 10323.2 10388.6 10408.1 10410.7 10085.9 10114.3 10176.6 10186.6 10205.2 7514.1 7687.2 10061.3 10228.6 10507.7 9979.4 10112.2 10113.2 10138.2 10147.0 37713.2 38135.2 38138.6 38232.4 38244.0 2894.0 2946.3 2971.6 2972.9 3015.5 27595.0 27822.4 28001.6 28506.1 28611.4 2658.6 2689.3 2716.3 2734.0 2817.3 225838.0 227834.0 228115.0 228459.0 230192.0 48147.3 48812.8 54817.7 54854.7 55251.0 55669.7 56511.0 56878.2 56899.4 56928.4 14832.2 14950.6 14957.0 15049.5 15055.8 11525.4 11536.8 11549.4 11582.3 11638.0 18485.4 18522.9 18560.2 18574.6 18629.7 8100.6 8437.8 8438.9 8444.8 8449.3 924.9 927.3 939.5 964.0 1090.0 26734.6 26806.6 27136.0 27236.9 31131.4 954.6 1008.4 1016.8 1033.5 1078.8 14058.9 14586.8 15214.4 15284.2 15525.3 305381.0 308800.0 309616.0 310531.0 310644.0 50958.7 51920.2 51942.7 51968.5 52009.2 1309.6 1317.1 1322.4 1333.4 1334.3 28151.6 28514.6 28785.4 29072.3 29086.7 49596.5 50947.2 51011.7 51237.5 51339.7 247117.0 248758.0 249155.0 250700.0 251029.0 36299.0 36937.1 39302.8 39401.8 39657.4 35695.5 38005.4 41016.6 41780.8 42301.4 33935.0 35078.3 35080.3 35485.8 35570.0 30254.2 32944.5 35055.5 38038.8 40255.6 33953.8 34464.3 34497.7 34693.5 35022.6 30148.8 31363.8 31381.4 31395.8 31612.7 23778.4 23868.5 24161.6 24242.9 24636.3 19:35:51 INFO - 2015-10-21 19:35:51,700 DEBUG : BROWSER_OUTPUT: 19:35:51 INFO - 2015-10-21 19:35:51,700 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:22226.91 Median:5240.79 stddev:68223.63 (1301.8%) stddev-sans-first:68395.25 19:35:51 INFO - 2015-10-21 19:35:51,700 DEBUG : BROWSER_OUTPUT: Values: 358.4 361.9 365.2 367.8 370.4 13070.8 13383.8 15040.6 15332.6 16029.1 13948.4 15429.5 15622.0 15638.9 16533.4 5223.6 5348.3 5353.7 5355.4 5362.7 3881.1 3988.6 5238.9 5291.9 5748.3 5859.4 5883.4 5892.9 5961.9 5969.1 5814.4 5992.8 5998.1 6009.6 6015.0 5234.4 5242.7 5243.7 5249.5 5250.9 11420.9 11452.5 11722.7 11818.3 11818.6 1615.0 1638.9 1651.9 1705.5 1740.3 8504.9 8676.6 8727.9 8816.3 8901.7 1634.7 1641.4 1643.3 1643.4 1652.2 44891.0 46235.3 52594.5 53074.5 53364.0 6123.0 6191.9 6213.5 6290.8 6327.4 7335.3 7360.3 7360.5 7371.1 7407.0 4989.5 5050.3 5052.6 5088.5 5092.1 5299.5 5338.2 5371.1 5395.6 5412.8 2846.9 2858.4 2868.9 2883.5 2885.8 938.3 980.1 1021.1 1034.9 1106.4 391.1 408.1 418.5 431.3 445.2 8513.4 9844.4 10684.7 10897.3 11363.0 423.4 438.3 440.0 442.3 446.3 5961.9 6084.7 6105.3 6147.3 6152.2 412777.0 413029.0 417257.5 417845.0 420130.0 63403.7 65801.0 66417.0 67242.7 68385.3 440.9 441.2 446.5 448.8 451.7 9421.4 9972.9 10013.3 10054.5 10114.9 29487.9 30592.8 30812.7 30822.0 30839.2 39052.0 39485.2 39485.4 40011.6 40037.0 5969.5 6024.5 6105.8 6115.3 6122.6 10686.1 10689.6 10923.9 10948.8 10964.7 9198.2 9303.3 9325.4 9401.5 9594.3 9462.0 9492.4 9528.4 9679.1 9790.0 9173.5 9418.3 9584.8 9686.9 9729.7 5751.3 5811.2 5834.3 5898.9 5989.3 9393.0 9407.7 9426.6 9508.8 9801.4 19:35:51 INFO - 2015-10-21 19:35:51,703 DEBUG : BROWSER_OUTPUT: 19:35:51 INFO - 2015-10-21 19:35:51,703 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5733.29 Median:6189.24 stddev:3134.98 (50.7%) stddev-sans-first:3125.97 19:35:51 INFO - 2015-10-21 19:35:51,703 DEBUG : BROWSER_OUTPUT: Values: 1288.7 1402.8 1583.8 1589.8 1799.6 7349.4 8184.9 8469.5 8491.1 8493.8 8004.7 8111.7 8120.6 8132.3 8143.6 1922.8 1952.4 2101.2 2172.7 2196.1 2189.9 2200.4 2204.6 2206.7 2208.1 2094.4 2156.4 2180.5 2180.5 2183.3 1917.9 1959.3 2118.2 2175.8 2186.9 2146.4 2184.8 2186.3 2190.6 2200.6 8199.8 8372.8 8373.2 8374.7 8375.8 4775.4 4853.7 4856.9 4856.9 4860.2 2794.9 2860.9 2886.9 2895.7 2900.3 841.4 843.1 860.3 861.1 871.5 11782.5 11811.8 11884.5 11889.6 11914.9 4144.5 4280.6 4298.2 4332.0 4344.8 9766.8 9770.7 9774.7 9794.9 9820.1 4714.7 4727.6 4737.2 4738.0 4757.1 4260.0 4261.4 4264.8 4291.3 4291.6 3686.8 3693.1 3707.2 3711.0 3726.7 1198.0 1219.1 1222.6 1228.7 1231.7 980.7 1033.2 1218.6 1293.8 1312.0 7110.9 8040.0 8278.8 8293.5 8298.5 600.5 608.6 1211.5 1228.2 1244.7 5988.4 6172.0 6184.2 6194.3 6194.6 9658.7 10130.3 10130.9 10157.6 10168.2 10010.4 10073.5 10160.4 10162.9 10187.6 7599.4 7642.6 7734.8 7739.0 7739.2 7511.2 7578.8 7587.2 7590.9 7606.9 8677.1 8834.0 8863.7 8874.6 8880.0 8854.5 9024.2 9038.5 9047.8 9129.0 7234.9 7309.3 7314.2 7325.3 7331.7 7974.2 8011.3 8017.9 8233.0 8234.6 7325.6 7340.7 7368.3 7473.6 7678.0 7280.7 7308.3 7485.0 7526.0 7564.9 7397.6 7524.5 7559.7 7560.4 7578.3 6830.5 6833.9 6869.0 6906.7 6915.3 6815.1 6854.3 6863.6 6899.8 6986.5 19:35:51 INFO - 2015-10-21 19:35:51,703 DEBUG : BROWSER_OUTPUT: 19:35:51 INFO - 2015-10-21 19:35:51,703 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4499.68 Median:5097.22 stddev:1306.22 (25.6%) stddev-sans-first:1271.34 19:35:51 INFO - 2015-10-21 19:35:51,703 DEBUG : BROWSER_OUTPUT: Values: 302.9 306.5 309.3 311.2 323.1 5105.6 5106.6 5163.4 5164.9 5170.6 5042.5 5090.6 5101.9 5103.4 5106.3 3886.5 3944.8 4056.6 4069.6 4071.6 3931.5 3962.9 3968.8 3986.8 3994.0 3960.8 3964.0 3967.1 3967.2 3968.8 3850.0 3918.1 3918.3 3964.8 3965.9 3475.6 3476.5 3484.1 3512.7 3529.1 4942.1 4943.3 4945.7 4953.1 4955.0 4431.1 4466.6 4474.7 4475.3 4488.7 5209.4 5265.8 5307.5 5324.7 5338.8 3789.8 3790.9 3792.8 3800.5 3803.6 5497.5 5568.1 5572.4 5580.3 5591.3 3865.8 3913.5 3918.7 3920.1 3924.0 3882.8 3968.5 3969.1 3970.6 3973.4 4486.4 4489.4 4490.4 4504.6 4530.5 5308.3 5326.9 5331.0 5335.6 5346.9 1436.2 1458.4 1460.7 1460.9 1462.0 993.5 999.4 1017.8 1020.9 1021.2 5021.8 5057.6 5061.6 5062.8 5068.8 5481.6 5501.1 5524.9 5525.3 5526.8 5043.5 5046.9 5048.3 5049.2 5073.2 2968.8 3009.4 3035.5 3051.0 3051.7 5520.6 5530.0 5534.8 5536.5 5539.1 5625.0 5629.9 5631.7 5632.7 5633.5 5514.6 5528.2 5528.7 5532.2 5533.4 5354.3 5501.8 5568.4 5570.9 5593.9 5413.5 5434.8 5448.6 5450.2 5451.7 5541.0 5585.5 5588.6 5588.6 5595.5 3724.8 3783.7 3828.4 3831.6 3855.1 5543.6 5552.9 5558.6 5559.2 5566.3 5354.3 5365.3 5373.9 5385.2 5399.9 5351.0 5391.0 5398.0 5407.0 5413.2 5188.5 5232.1 5339.0 5341.6 5346.7 5184.5 5272.0 5393.8 5412.3 5437.6 5092.5 5267.0 5275.9 5281.0 5284.7 19:35:51 INFO - 2015-10-21 19:35:51,704 DEBUG : BROWSER_OUTPUT: 19:35:51 INFO - 2015-10-21 19:35:51,706 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:9627.79 Median:619.71 stddev:10403.16 (1678.7%) stddev-sans-first:10410.35 19:35:51 INFO - 2015-10-21 19:35:51,706 DEBUG : BROWSER_OUTPUT: Values: 619.6 637.9 796.8 829.5 847.5 10690.2 10855.6 10869.7 10874.1 10877.9 11949.0 12182.3 12189.3 12207.8 12277.3 672.0 673.3 801.1 808.7 809.1 815.4 817.7 818.1 822.1 826.2 803.4 838.6 843.8 844.8 848.6 704.7 705.3 840.9 844.4 844.8 616.9 619.8 619.9 620.2 620.4 10442.6 10534.4 10568.9 10576.2 10580.2 8247.3 8366.4 8501.0 8552.5 8597.8 8371.3 8402.3 8724.7 8803.5 8811.4 2975.1 2985.6 2987.8 3041.1 3053.6 31199.8 31293.4 31413.7 31500.7 31554.8 6082.6 6206.4 6215.3 6255.6 6363.6 9753.6 9754.3 9763.1 9763.7 9788.9 5481.6 5671.4 5797.7 5964.7 6093.1 3744.1 3755.5 3851.8 3865.9 3868.4 2225.0 2248.2 2248.7 2249.4 2258.4 377.4 384.0 384.1 384.2 387.3 435.6 452.8 456.8 482.5 490.3 6339.5 6496.9 6742.2 6860.3 6903.2 522.8 594.3 611.1 645.5 645.7 3299.2 3300.1 3313.9 3395.7 3407.8 39945.2 40285.6 40484.0 40582.0 40592.8 33643.5 33925.5 34229.1 34256.0 34265.5 29124.1 29236.9 29725.3 29754.3 29783.9 6521.4 6538.5 6581.5 6596.7 6695.0 21458.2 21763.1 21834.7 21884.9 22122.0 27783.3 28140.2 28167.9 28168.6 28200.3 5658.5 5723.4 5885.7 5931.7 6048.6 9103.9 9394.3 9557.0 9701.8 9764.4 8351.3 8387.5 8481.9 8574.9 8641.6 8248.1 8264.8 8325.1 8457.4 8550.0 7879.8 8503.5 8951.1 9002.2 9060.1 8070.7 8204.0 8396.9 8404.3 8687.6 7743.2 7815.9 8032.8 8149.3 8303.6 19:35:51 INFO - 2015-10-21 19:35:51,707 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:35:51 INFO - 2015-10-21 19:35:51,707 DEBUG : BROWSER_OUTPUT: 19:35:52 INFO - 2015-10-21 19:35:52,265 INFO : Browser exited with error code: 0 19:35:53 INFO - 2015-10-21 19:35:53,121 INFO : Completed test dromaeo_css (00:18:40) 19:35:53 INFO - 2015-10-21 19:35:53,121 INFO : Starting test kraken 19:35:53 INFO - 2015-10-21 19:35:53,121 DEBUG : operating with platform_type : w8_ 19:35:53 INFO - 2015-10-21 19:35:53,121 INFO : Initialising browser for kraken test... 19:35:53 INFO - 2015-10-21 19:35:53,141 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpsz794l\profile http://localhost:49278/getInfo.html 19:35:59 INFO - 2015-10-21 19:35:59,311 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:35:59 INFO - 2015-10-21 19:35:59,311 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:35:59 INFO - 2015-10-21 19:35:59,311 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674 19:35:59 INFO - 2015-10-21 19:35:59,311 DEBUG : BROWSER_OUTPUT: __metrics 19:35:59 INFO - 2015-10-21 19:35:59,410 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:36:00 INFO - 2015-10-21 19:36:00,279 DEBUG : BROWSER_OUTPUT: console.error: 19:36:00 INFO - 2015-10-21 19:36:00,282 DEBUG : BROWSER_OUTPUT: Message: Error: Transaction canceled due to a closed connection. 19:36:00 INFO - 2015-10-21 19:36:00,282 DEBUG : BROWSER_OUTPUT: Stack: 19:36:00 INFO - 2015-10-21 19:36:00,282 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise<@resource://gre/modules/Sqlite.jsm:562:1 19:36:00 INFO - 2015-10-21 19:36:00,282 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 19:36:00 INFO - 2015-10-21 19:36:00,282 DEBUG : BROWSER_OUTPUT: 19:36:01 INFO - 2015-10-21 19:36:01,015 INFO : Browser initialized. 19:36:01 INFO - 2015-10-21 19:36:01,015 INFO : Running cycle 1/1 for kraken test... 19:36:01 INFO - 2015-10-21 19:36:01,015 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpsz794l\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\kraken\kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:36:12 INFO - 2015-10-21 19:36:12,575 DEBUG : BROWSER_OUTPUT: RSS: Main: 179171328 19:36:12 INFO - 2015-10-21 19:36:12,575 DEBUG : BROWSER_OUTPUT: 19:36:15 INFO - 2015-10-21 19:36:15,292 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) 19:36:15 INFO - 2015-10-21 19:36:15,884 DEBUG : BROWSER_OUTPUT: RSS: Main: 215764992 19:36:15 INFO - 2015-10-21 19:36:15,884 DEBUG : BROWSER_OUTPUT: 19:36:18 INFO - 2015-10-21 19:36:18,565 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) 19:36:19 INFO - 2015-10-21 19:36:19,137 DEBUG : BROWSER_OUTPUT: RSS: Main: 217063424 19:36:19 INFO - 2015-10-21 19:36:19,137 DEBUG : BROWSER_OUTPUT: 19:36:21 INFO - 2015-10-21 19:36:21,865 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) 19:36:22 INFO - 2015-10-21 19:36:22,440 DEBUG : BROWSER_OUTPUT: RSS: Main: 201760768 19:36:22 INFO - 2015-10-21 19:36:22,440 DEBUG : BROWSER_OUTPUT: 19:36:24 INFO - 2015-10-21 19:36:24,453 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) 19:36:25 INFO - 2015-10-21 19:36:25,022 DEBUG : BROWSER_OUTPUT: RSS: Main: 202457088 19:36:25 INFO - 2015-10-21 19:36:25,022 DEBUG : BROWSER_OUTPUT: 19:36:27 INFO - 2015-10-21 19:36:27,236 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) 19:36:27 INFO - 2015-10-21 19:36:27,799 DEBUG : BROWSER_OUTPUT: RSS: Main: 199176192 19:36:27 INFO - 2015-10-21 19:36:27,799 DEBUG : BROWSER_OUTPUT: 19:36:30 INFO - 2015-10-21 19:36:30,849 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) 19:36:31 INFO - 2015-10-21 19:36:31,424 DEBUG : BROWSER_OUTPUT: RSS: Main: 193630208 19:36:31 INFO - 2015-10-21 19:36:31,424 DEBUG : BROWSER_OUTPUT: 19:36:34 INFO - 2015-10-21 19:36:34,934 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) 19:36:35 INFO - 2015-10-21 19:36:35,528 DEBUG : BROWSER_OUTPUT: RSS: Main: 187437056 19:36:35 INFO - 2015-10-21 19:36:35,528 DEBUG : BROWSER_OUTPUT: 19:36:38 INFO - 2015-10-21 19:36:38,405 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) 19:36:38 INFO - 2015-10-21 19:36:38,976 DEBUG : BROWSER_OUTPUT: RSS: Main: 188317696 19:36:38 INFO - 2015-10-21 19:36:38,976 DEBUG : BROWSER_OUTPUT: 19:36:40 INFO - 2015-10-21 19:36:40,749 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) 19:36:41 INFO - 2015-10-21 19:36:41,312 DEBUG : BROWSER_OUTPUT: RSS: Main: 218542080 19:36:41 INFO - 2015-10-21 19:36:41,312 DEBUG : BROWSER_OUTPUT: 19:36:43 INFO - 2015-10-21 19:36:43,184 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) 19:36:43 INFO - 2015-10-21 19:36:43,756 DEBUG : BROWSER_OUTPUT: RSS: Main: 223535104 19:36:43 INFO - 2015-10-21 19:36:43,756 DEBUG : BROWSER_OUTPUT: 19:36:46 INFO - 2015-10-21 19:36:46,082 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) 19:36:46 INFO - 2015-10-21 19:36:46,664 DEBUG : BROWSER_OUTPUT: RSS: Main: 227201024 19:36:46 INFO - 2015-10-21 19:36:46,664 DEBUG : BROWSER_OUTPUT: 19:36:49 INFO - 2015-10-21 19:36:49,230 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) 19:36:49 INFO - 2015-10-21 19:36:49,813 DEBUG : BROWSER_OUTPUT: RSS: Main: 231215104 19:36:49 INFO - 2015-10-21 19:36:49,813 DEBUG : BROWSER_OUTPUT: 19:36:52 INFO - 2015-10-21 19:36:52,611 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) 19:36:53 INFO - 2015-10-21 19:36:53,194 DEBUG : BROWSER_OUTPUT: RSS: Main: 232243200 19:36:53 INFO - 2015-10-21 19:36:53,194 DEBUG : BROWSER_OUTPUT: 19:36:55 INFO - 2015-10-21 19:36:55,012 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) 19:36:55 INFO - 2015-10-21 19:36:55,263 DEBUG : BROWSER_OUTPUT: RSS: Main: 287072256 19:36:55 INFO - 2015-10-21 19:36:55,263 DEBUG : BROWSER_OUTPUT: 19:36:55 INFO - 2015-10-21 19:36:55,265 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:36:55 INFO - 2015-10-21 19:36:55,265 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:36:55 INFO - 2015-10-21 19:36:55,265 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:36:55 INFO - 2015-10-21 19:36:55,265 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:36:55 INFO - 2015-10-21 19:36:55,265 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;113;106;113;113;113;104;112;113;114 19:36:55 INFO - 2015-10-21 19:36:55,265 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;139;130;151;161;130;134;135;134;159;134 19:36:55 INFO - 2015-10-21 19:36:55,265 DEBUG : BROWSER_OUTPUT: |2;audio-dft;142;140;144;162;141;139;140;142;145;139 19:36:55 INFO - 2015-10-21 19:36:55,265 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;71;70;100;69;75;70;70;101;69 19:36:55 INFO - 2015-10-21 19:36:55,265 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;91;111;91;90;90;121;90;90;116 19:36:55 INFO - 2015-10-21 19:36:55,265 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;111;110;110;111;111;111;110;110 19:36:55 INFO - 2015-10-21 19:36:55,265 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;131;131;134;131;132;132;131;132;132;132 19:36:55 INFO - 2015-10-21 19:36:55,265 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;96;96;96;100;98;96;96;96;97 19:36:55 INFO - 2015-10-21 19:36:55,265 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;69;71;70;70;71;70;74;82;69;69 19:36:55 INFO - 2015-10-21 19:36:55,265 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;69;68;69;68;68;68;69;69;69 19:36:55 INFO - 2015-10-21 19:36:55,266 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;91;91;92;91;93;93;91;91;90;91 19:36:55 INFO - 2015-10-21 19:36:55,266 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;125;133;124;123;132;132;121;128;133 19:36:55 INFO - 2015-10-21 19:36:55,266 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;162;154;168;162;164;151;164;167;163;163 19:36:55 INFO - 2015-10-21 19:36:55,266 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;74;74;77;75;74;76;75;74;74;75 19:36:55 INFO - 2015-10-21 19:36:55,266 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:36:55 INFO - 2015-10-21 19:36:55,266 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:36:55 INFO - 2015-10-21 19:36:55,266 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,977 19:36:55 INFO - 2015-10-21 19:36:55,266 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:36:55 INFO - 2015-10-21 19:36:55,266 DEBUG : BROWSER_OUTPUT: __startTimestamp1445481415264__endTimestamp 19:36:55 INFO - 2015-10-21 19:36:55,266 DEBUG : BROWSER_OUTPUT: 19:36:55 INFO - 2015-10-21 19:36:55,267 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:36:55 INFO - 2015-10-21 19:36:55,267 DEBUG : BROWSER_OUTPUT: Number of tests: 14 19:36:55 INFO - 2015-10-21 19:36:55,269 DEBUG : BROWSER_OUTPUT: 19:36:55 INFO - 2015-10-21 19:36:55,269 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.20 Median:113.00 stddev:3.39 (3.0%) stddev-sans-first:3.60 19:36:55 INFO - 2015-10-21 19:36:55,269 DEBUG : BROWSER_OUTPUT: Values: 111.0 113.0 106.0 113.0 113.0 113.0 104.0 112.0 113.0 114.0 19:36:55 INFO - 2015-10-21 19:36:55,269 DEBUG : BROWSER_OUTPUT: 19:36:55 INFO - 2015-10-21 19:36:55,269 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:140.70 Median:137.00 stddev:11.80 (8.6%) stddev-sans-first:12.49 19:36:55 INFO - 2015-10-21 19:36:55,269 DEBUG : BROWSER_OUTPUT: Values: 139.0 130.0 151.0 161.0 130.0 134.0 135.0 134.0 159.0 134.0 19:36:55 INFO - 2015-10-21 19:36:55,269 DEBUG : BROWSER_OUTPUT: 19:36:55 INFO - 2015-10-21 19:36:55,269 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:143.40 Median:142.00 stddev:6.83 (4.8%) stddev-sans-first:7.23 19:36:55 INFO - 2015-10-21 19:36:55,269 DEBUG : BROWSER_OUTPUT: Values: 142.0 140.0 144.0 162.0 141.0 139.0 140.0 142.0 145.0 139.0 19:36:55 INFO - 2015-10-21 19:36:55,270 DEBUG : BROWSER_OUTPUT: 19:36:55 INFO - 2015-10-21 19:36:55,270 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:76.60 Median:70.00 stddev:12.71 (18.2%) stddev-sans-first:13.32 19:36:55 INFO - 2015-10-21 19:36:55,270 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 70.0 100.0 69.0 75.0 70.0 70.0 101.0 69.0 19:36:55 INFO - 2015-10-21 19:36:55,270 DEBUG : BROWSER_OUTPUT: 19:36:55 INFO - 2015-10-21 19:36:55,270 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:98.00 Median:90.00 stddev:12.65 (14.1%) stddev-sans-first:13.08 19:36:55 INFO - 2015-10-21 19:36:55,270 DEBUG : BROWSER_OUTPUT: Values: 90.0 91.0 111.0 91.0 90.0 90.0 121.0 90.0 90.0 116.0 19:36:55 INFO - 2015-10-21 19:36:55,270 DEBUG : BROWSER_OUTPUT: 19:36:55 INFO - 2015-10-21 19:36:55,270 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.40 Median:110.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 19:36:55 INFO - 2015-10-21 19:36:55,270 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 111.0 110.0 110.0 111.0 111.0 111.0 110.0 110.0 19:36:55 INFO - 2015-10-21 19:36:55,272 DEBUG : BROWSER_OUTPUT: 19:36:55 INFO - 2015-10-21 19:36:55,272 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:131.80 Median:132.00 stddev:0.92 (0.7%) stddev-sans-first:0.93 19:36:55 INFO - 2015-10-21 19:36:55,272 DEBUG : BROWSER_OUTPUT: Values: 131.0 131.0 134.0 131.0 132.0 132.0 131.0 132.0 132.0 132.0 19:36:55 INFO - 2015-10-21 19:36:55,272 DEBUG : BROWSER_OUTPUT: 19:36:55 INFO - 2015-10-21 19:36:55,273 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.80 Median:96.00 stddev:1.32 (1.4%) stddev-sans-first:1.39 19:36:55 INFO - 2015-10-21 19:36:55,273 DEBUG : BROWSER_OUTPUT: Values: 97.0 96.0 96.0 96.0 100.0 98.0 96.0 96.0 96.0 97.0 19:36:55 INFO - 2015-10-21 19:36:55,273 DEBUG : BROWSER_OUTPUT: 19:36:55 INFO - 2015-10-21 19:36:55,273 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.50 Median:70.50 stddev:3.98 (5.6%) stddev-sans-first:4.12 19:36:55 INFO - 2015-10-21 19:36:55,273 DEBUG : BROWSER_OUTPUT: Values: 69.0 71.0 70.0 70.0 71.0 70.0 74.0 82.0 69.0 69.0 19:36:55 INFO - 2015-10-21 19:36:55,273 DEBUG : BROWSER_OUTPUT: 19:36:55 INFO - 2015-10-21 19:36:55,273 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:69.00 stddev:0.70 (1.0%) stddev-sans-first:0.53 19:36:55 INFO - 2015-10-21 19:36:55,273 DEBUG : BROWSER_OUTPUT: Values: 67.0 69.0 68.0 69.0 68.0 68.0 68.0 69.0 69.0 69.0 19:36:55 INFO - 2015-10-21 19:36:55,275 DEBUG : BROWSER_OUTPUT: 19:36:55 INFO - 2015-10-21 19:36:55,275 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:91.40 Median:91.00 stddev:0.97 (1.1%) stddev-sans-first:1.01 19:36:55 INFO - 2015-10-21 19:36:55,275 DEBUG : BROWSER_OUTPUT: Values: 91.0 91.0 92.0 91.0 93.0 93.0 91.0 91.0 90.0 91.0 19:36:55 INFO - 2015-10-21 19:36:55,275 DEBUG : BROWSER_OUTPUT: 19:36:55 INFO - 2015-10-21 19:36:55,276 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.40 Median:130.00 stddev:4.74 (3.6%) stddev-sans-first:4.76 19:36:55 INFO - 2015-10-21 19:36:55,276 DEBUG : BROWSER_OUTPUT: Values: 123.0 125.0 133.0 124.0 123.0 132.0 132.0 121.0 128.0 133.0 19:36:55 INFO - 2015-10-21 19:36:55,276 DEBUG : BROWSER_OUTPUT: 19:36:55 INFO - 2015-10-21 19:36:55,276 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.80 Median:163.50 stddev:5.33 (3.3%) stddev-sans-first:5.65 19:36:55 INFO - 2015-10-21 19:36:55,276 DEBUG : BROWSER_OUTPUT: Values: 162.0 154.0 168.0 162.0 164.0 151.0 164.0 167.0 163.0 163.0 19:36:55 INFO - 2015-10-21 19:36:55,276 DEBUG : BROWSER_OUTPUT: 19:36:55 INFO - 2015-10-21 19:36:55,276 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.80 Median:75.00 stddev:1.03 (1.4%) stddev-sans-first:1.05 19:36:55 INFO - 2015-10-21 19:36:55,278 DEBUG : BROWSER_OUTPUT: Values: 74.0 74.0 77.0 75.0 74.0 76.0 75.0 74.0 74.0 75.0 19:36:55 INFO - 2015-10-21 19:36:55,278 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:36:55 INFO - 2015-10-21 19:36:55,278 DEBUG : BROWSER_OUTPUT: 19:36:56 INFO - 2015-10-21 19:36:56,002 INFO : Browser exited with error code: 0 19:36:56 INFO - 2015-10-21 19:36:56,868 INFO : Completed test kraken (00:01:03) 19:36:56 INFO - 2015-10-21 19:36:56,868 INFO : Starting test v8_7 19:36:56 INFO - 2015-10-21 19:36:56,868 DEBUG : operating with platform_type : w8_ 19:36:56 INFO - 2015-10-21 19:36:56,868 INFO : Initialising browser for v8_7 test... 19:36:56 INFO - 2015-10-21 19:36:56,888 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmp5osv_z\profile http://localhost:49278/getInfo.html 19:37:02 INFO - 2015-10-21 19:37:02,339 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:37:02 INFO - 2015-10-21 19:37:02,339 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:37:02 INFO - 2015-10-21 19:37:02,339 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674 19:37:02 INFO - 2015-10-21 19:37:02,339 DEBUG : BROWSER_OUTPUT: __metrics 19:37:02 INFO - 2015-10-21 19:37:02,528 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:37:03 INFO - 2015-10-21 19:37:03,338 DEBUG : BROWSER_OUTPUT: console.error: 19:37:03 INFO - 2015-10-21 19:37:03,338 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] 19:37:03 INFO - 2015-10-21 19:37:03,338 DEBUG : BROWSER_OUTPUT: Stack: 19:37:03 INFO - 2015-10-21 19:37:03,338 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<._executeStatement@resource://gre/modules/Sqlite.jsm:758:19 19:37:03 INFO - 2015-10-21 19:37:03,338 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached/<@resource://gre/modules/Sqlite.jsm:493:9 19:37:03 INFO - 2015-10-21 19:37:03,338 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached@resource://gre/modules/Sqlite.jsm:491:1 19:37:03 INFO - 2015-10-21 19:37:03,338 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeBeforeShutdown/loggedDb<.executeCached.value<@resource://gre/modules/Sqlite.jsm:368:51 19:37:03 INFO - 2015-10-21 19:37:03,338 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 19:37:03 INFO - 2015-10-21 19:37:03,338 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 19:37:03 INFO - 2015-10-21 19:37:03,338 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 19:37:03 INFO - 2015-10-21 19:37:03,338 DEBUG : BROWSER_OUTPUT: transaction@resource://gre/modules/Bookmarks.jsm:783:15 19:37:03 INFO - 2015-10-21 19:37:03,338 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 19:37:03 INFO - 2015-10-21 19:37:03,339 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 19:37:03 INFO - 2015-10-21 19:37:03,339 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 19:37:03 INFO - 2015-10-21 19:37:03,339 DEBUG : BROWSER_OUTPUT: Task_spawn@resource://gre/modules/Task.jsm:164:12 19:37:03 INFO - 2015-10-21 19:37:03,339 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promisedromaeo_css: 6041.32 19:37:39 INFO - RETURN: kraken: 1504.20 19:37:39 INFO - RETURN: v8_7: 20161.98 19:37:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,131,31]]", "result": "20161.98"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,131,31]]", "result": "1504.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,131,31]]", "result": "6041.32"}}} 19:37:39 INFO - Return code: 0 19:37:39 INFO - # TBPL SUCCESS # 19:37:39 INFO - Running post-action listener: _resource_record_post_action 19:37:39 INFO - Running post-run listener: _resource_record_post_run 19:37:40 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 242217984; Write bytes: 391627776; Read time: 2508960; Write time: 4527660 19:37:40 INFO - install - Wall time: 2s; CPU: 14.0%; Read bytes: 0; Write bytes: 1115648; Read time: 0; Write time: 2670 19:37:40 INFO - run-tests - Wall time: 1232s; CPU: 13.0%; Read bytes: 242217984; Write bytes: 351034880; Read time: 2508960; Write time: 4368310 19:37:40 INFO - Running post-run listener: _upload_blobber_files 19:37:40 INFO - Blob upload gear active. 19:37:40 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 19:37:40 INFO - Copying logs to upload dir... 19:37:40 INFO - mkdir: C:\slave\test\build\upload\logs program finished with exit code 0 elapsedTime=1395.070000 ========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 16 secs) (at 2015-10-21 19:37:41.175528) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-21 19:37:41.178815) ========= '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-054\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-054 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-054 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-054\AppData\Local LOGONSERVER=\\T-W864-IX-054 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-054 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-054 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-054 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False build_url:https://queue.taskcluster.net/v1/task/dQuddg34Qh2Midi_iuzHqA/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/dQuddg34Qh2Midi_iuzHqA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip' ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-21 19:37:41.307349) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-21 19:37:41.307672) ========= '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-054\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-054 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-054 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-054\AppData\Local LOGONSERVER=\\T-W864-IX-054 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-054 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-054 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-054 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-21 19:37:41.422522) ========= ========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2015-10-21 19:37:41.422824) ========= ========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2015-10-21 19:37:41.846714) =========