builder: fx-team_win8_64_test-dromaeojs slave: t-w864-ix-118 starttime: 1445884310.54 results: success (0) buildid: 20151026104938 builduid: 9f42765b126440598b647377741c42dc revision: b842ef4420f1b247ab9706ce8d5028c8bca52ecd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-26 11:31:50.544058) ========= master: http://buildbot-master112.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-26 11:31:50.546528) ========= ========= Started set props: basedir (results: 0, elapsed: 3 secs) (at 2015-10-26 11:31:50.546831) ========= 'cd' in dir C:\slave\test\. (timeout 1200 secs) watching logfiles {} argv: ['cd'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-118\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-118 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-118 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-118\AppData\Local LOGONSERVER=\\T-W864-IX-118 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-118 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-118 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-118 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False C:\slave\test program finished with exit code 0 elapsedTime=0.683000 basedir: 'C:\\slave\\test' ========= Finished set props: basedir (results: 0, elapsed: 3 secs) (at 2015-10-26 11:31:53.576873) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 5 secs) (at 2015-10-26 11:31:53.577198) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 5 secs) (at 2015-10-26 11:31:59.108481) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 11 secs) (at 2015-10-26 11:31:59.108784) ========= '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-118\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-118 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-118 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-118\AppData\Local LOGONSERVER=\\T-W864-IX-118 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-118 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-118 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-118 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=0.201000 ========= Finished 'rm -rf ...' (results: 0, elapsed: 11 secs) (at 2015-10-26 11:32:10.590987) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-26 11:32:10.591317) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-26 11:32:10.591914) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-10-26 11:32:10.592210) ========= '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-118\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-118 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-118 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-118\AppData\Local LOGONSERVER=\\T-W864-IX-118 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-118 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-118 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-118 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False --11:32: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% 1.96 GB/s 11:32:12 (1.96 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=1.052000 ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-10-26 11:32:13.523941) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 12 secs) (at 2015-10-26 11:32:13.524335) ========= '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-118\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-118 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-118 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-118\AppData\Local LOGONSERVER=\\T-W864-IX-118 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-118 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-118 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-118 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=2.610000 ========= Finished 'rm -rf ...' (results: 0, elapsed: 12 secs) (at 2015-10-26 11:32:26.480535) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-10-26 11:32:26.480938) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo integration/fx-team --rev b842ef4420f1b247ab9706ce8d5028c8bca52ecd --destination scripts --debug' in dir C:\slave\test\. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev b842ef4420f1b247ab9706ce8d5028c8bca52ecd --destination scripts --debug'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-118\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-118 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-118 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-118\AppData\Local LOGONSERVER=\\T-W864-IX-118 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-118 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-118 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-118 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 2015-10-26 11:32:26,931 truncating revision to first 12 chars 2015-10-26 11:32:26,931 Setting DEBUG logging. 2015-10-26 11:32:26,931 attempt 1/10 2015-10-26 11:32:26,931 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b842ef4420f1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-10-26 11:32:28,000 unpacking tar archive at: fx-team-b842ef4420f1/testing/mozharness/ program finished with exit code 0 elapsedTime=2.097000 ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-10-26 11:32:28.778908) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-26 11:32:28.779288) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-26 11:32:29.111773) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-26 11:32:29.112369) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-26 11:32:29.113153) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 24 mins, 15 secs) (at 2015-10-26 11:32:29.113738) ========= 'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'dromaeojs' '--add-option' '--webServer,localhost' '--branch-name' 'Fx-Team-Non-PGO' '--system-bits' '64' '--cfg' 'talos/windows_config.py' '--download-symbols' 'ondemand' '--use-talos-json' '--blob-upload-branch' 'Fx-Team-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', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/windows_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-118\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-118 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-118 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-118\AppData\Local LOGONSERVER=\\T-W864-IX-118 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-118 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-118 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-118 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 11:32:29 INFO - MultiFileLogger online at 20151026 11:32:29 in C:\slave\test 11:32:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 11:32:29 INFO - Dumping config to C:\slave\test\logs\localconfig.json. 11:32:29 INFO - {'append_to_log': False, 11:32:29 INFO - 'base_work_dir': 'C:\\slave\\test', 11:32:29 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:32:29 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt', 11:32:29 INFO - 'branch': 'Fx-Team-Non-PGO', 11:32:29 INFO - 'buildbot_json_path': 'buildprops.json', 11:32:29 INFO - 'config_files': ('talos/windows_config.py',), 11:32:29 INFO - 'default_actions': ('clobber', 11:32:29 INFO - 'read-buildbot-config', 11:32:29 INFO - 'download-and-extract', 11:32:29 INFO - 'populate-webroot', 11:32:29 INFO - 'create-virtualenv', 11:32:29 INFO - 'install', 11:32:29 INFO - 'run-tests'), 11:32:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:32:29 INFO - 'download_minidump_stackwalk': True, 11:32:29 INFO - 'download_symbols': 'ondemand', 11:32:29 INFO - 'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python', 11:32:29 INFO - 'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'), 11:32:29 INFO - 'hg': 'c:/mozilla-build/hg/hg', 11:32:29 INFO - 'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python', 11:32:29 INFO - 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'), 11:32:29 INFO - 'python': 'c:/mozilla-build/python27/python.exe', 11:32:29 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe', 11:32:29 INFO - 'C:/mozilla-build/tooltool.py'), 11:32:29 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe', 11:32:29 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 11:32:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:32:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:32:29 INFO - 'installer_path': 'installer.exe', 11:32:29 INFO - 'log_level': 'info', 11:32:29 INFO - 'log_name': 'talos', 11:32:29 INFO - 'log_to_console': True, 11:32:29 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe', 11:32:29 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe', 11:32:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest', 11:32:29 INFO - 'opt_config_files': (), 11:32:29 INFO - 'pip_index': False, 11:32:29 INFO - 'sps_profile': False, 11:32:29 INFO - 'sps_profile_interval': 0, 11:32:29 INFO - 'suite': 'dromaeojs', 11:32:29 INFO - 'system_bits': '64', 11:32:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:32:29 INFO - 'title': 'T-W864-IX-118', 11:32:29 INFO - 'use_talos_json': True, 11:32:29 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'), 11:32:29 INFO - 'virtualenv_path': 'C:\\slave\\test\\build/venv', 11:32:29 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll', 11:32:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:32:29 INFO - 'work_dir': 'build'} 11:32:29 INFO - ##### 11:32:29 INFO - ##### Running clobber step. 11:32:29 INFO - ##### 11:32:29 INFO - Running pre-action listener: _resource_record_pre_action 11:32:29 INFO - Running main action method: clobber 11:32:29 INFO - rmtree: C:\slave\test\build 11:32:29 INFO - Using _rmtree_windows ... 11:32:29 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1 11:33:30 INFO - Running post-action listener: _resource_record_post_action 11:33:30 INFO - ##### 11:33:30 INFO - ##### Running read-buildbot-config step. 11:33:30 INFO - ##### 11:33:30 INFO - Running pre-action listener: _resource_record_pre_action 11:33:30 INFO - Running main action method: read_buildbot_config 11:33:30 INFO - Using buildbot properties: 11:33:30 INFO - { 11:33:30 INFO - "properties": { 11:33:30 INFO - "buildnumber": 712, 11:33:30 INFO - "product": "firefox", 11:33:30 INFO - "script_repo_revision": "production", 11:33:30 INFO - "builddir": "fx-team_win8_64_test-dromaeojs", 11:33:30 INFO - "repository": "", 11:33:30 INFO - "buildername": "Windows 8 64-bit fx-team talos dromaeojs", 11:33:30 INFO - "buildid": "20151026104938", 11:33:30 INFO - "slavename": "t-w864-ix-118", 11:33:30 INFO - "pgo_build": "False", 11:33:30 INFO - "basedir": "C:\\slave\\test", 11:33:30 INFO - "project": "", 11:33:30 INFO - "platform": "win8_64", 11:33:30 INFO - "master": "http://buildbot-master112.bb.releng.scl3.mozilla.com:8201/", 11:33:30 INFO - "slavebuilddir": "test", 11:33:30 INFO - "scheduler": "tests-fx-team-win64-talos", 11:33:30 INFO - "branch": "fx-team", 11:33:30 INFO - "repo_path": "integration/fx-team", 11:33:30 INFO - "stage_platform": "win64", 11:33:30 INFO - "builduid": "9f42765b126440598b647377741c42dc", 11:33:30 INFO - "revision": "b842ef4420f1b247ab9706ce8d5028c8bca52ecd" 11:33:30 INFO - }, 11:33:30 INFO - "sourcestamp": { 11:33:30 INFO - "repository": "", 11:33:30 INFO - "hasPatch": false, 11:33:30 INFO - "project": "", 11:33:30 INFO - "branch": "fx-team-win64-talos", 11:33:30 INFO - "changes": [ 11:33:30 INFO - { 11:33:30 INFO - "category": null, 11:33:30 INFO - "files": [ 11:33:30 INFO - { 11:33:30 INFO - "url": null, 11:33:30 INFO - "name": "https://queue.taskcluster.net/v1/task/crWsHE58SGiCcfL51i81JQ/artifacts/public/build/firefox-44.0a1.en-US.win64.zip" 11:33:30 INFO - } 11:33:30 INFO - ], 11:33:30 INFO - "repository": "", 11:33:30 INFO - "rev": "b842ef4420f1b247ab9706ce8d5028c8bca52ecd", 11:33:30 INFO - "who": "apoirot@mozilla.com", 11:33:30 INFO - "when": 1445884100, 11:33:30 INFO - "number": 6575079, 11:33:30 INFO - "comments": "Bug 1213011 - Use stable file name for simulator xpi in TC. r=garndt", 11:33:30 INFO - "project": "", 11:33:30 INFO - "at": "Mon 26 Oct 2015 11:28:20", 11:33:30 INFO - "branch": "fx-team-win64-talos", 11:33:30 INFO - "revlink": "", 11:33:30 INFO - "properties": [ 11:33:30 INFO - [ 11:33:30 INFO - "buildid", 11:33:30 INFO - "20151026104938", 11:33:30 INFO - "Change" 11:33:30 INFO - ], 11:33:30 INFO - [ 11:33:30 INFO - "builduid", 11:33:30 INFO - "9f42765b126440598b647377741c42dc", 11:33:30 INFO - "Change" 11:33:30 INFO - ], 11:33:30 INFO - [ 11:33:30 INFO - "pgo_build", 11:33:30 INFO - "False", 11:33:30 INFO - "Change" 11:33:30 INFO - ] 11:33:30 INFO - ], 11:33:30 INFO - "revision": "b842ef4420f1b247ab9706ce8d5028c8bca52ecd" 11:33:30 INFO - } 11:33:30 INFO - ], 11:33:30 INFO - "revision": "b842ef4420f1b247ab9706ce8d5028c8bca52ecd" 11:33:30 INFO - } 11:33:30 INFO - } 11:33:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/crWsHE58SGiCcfL51i81JQ/artifacts/public/build/firefox-44.0a1.en-US.win64.zip. 11:33:30 INFO - Running post-action listener: _resource_record_post_action 11:33:30 INFO - ##### 11:33:30 INFO - ##### Running download-and-extract step. 11:33:30 INFO - ##### 11:33:30 INFO - Running pre-action listener: _resource_record_pre_action 11:33:30 INFO - Running main action method: download_and_extract 11:33:30 INFO - mkdir: C:\slave\test\build\tests 11:33:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:33:30 INFO - https://queue.taskcluster.net/v1/task/crWsHE58SGiCcfL51i81JQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:33:30 INFO - trying https://queue.taskcluster.net/v1/task/crWsHE58SGiCcfL51i81JQ/artifacts/public/build/test_packages.json 11:33:30 INFO - Downloading https://queue.taskcluster.net/v1/task/crWsHE58SGiCcfL51i81JQ/artifacts/public/build/test_packages.json to C:\slave\test\build\test_packages.json 11:33:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/crWsHE58SGiCcfL51i81JQ/artifacts/public/build/test_packages.json', 'file_name': 'C:\\slave\\test\\build\\test_packages.json'}, attempt #1 11:33:32 INFO - Downloaded 1221 bytes. 11:33:32 INFO - Reading from file C:\slave\test\build\test_packages.json 11:33:32 INFO - Using the following test package requirements: 11:33:32 INFO - {u'common': [u'firefox-44.0a1.en-US.win64.common.tests.zip'], 11:33:32 INFO - u'cppunittest': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 11:33:32 INFO - u'firefox-44.0a1.en-US.win64.cppunittest.tests.zip'], 11:33:32 INFO - u'jittest': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 11:33:32 INFO - u'jsshell-win64.zip'], 11:33:32 INFO - u'mochitest': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 11:33:32 INFO - u'firefox-44.0a1.en-US.win64.mochitest.tests.zip'], 11:33:32 INFO - u'mozbase': [u'firefox-44.0a1.en-US.win64.common.tests.zip'], 11:33:32 INFO - u'reftest': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 11:33:32 INFO - u'firefox-44.0a1.en-US.win64.reftest.tests.zip'], 11:33:32 INFO - u'talos': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 11:33:32 INFO - u'firefox-44.0a1.en-US.win64.talos.tests.zip'], 11:33:32 INFO - u'web-platform': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 11:33:32 INFO - u'firefox-44.0a1.en-US.win64.web-platform.tests.zip'], 11:33:32 INFO - u'webapprt': [u'firefox-44.0a1.en-US.win64.common.tests.zip'], 11:33:32 INFO - u'xpcshell': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 11:33:32 INFO - u'firefox-44.0a1.en-US.win64.xpcshell.tests.zip']} 11:33:32 INFO - Downloading packages: [u'firefox-44.0a1.en-US.win64.common.tests.zip'] for test suite category: common 11:33: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')]} 11:33:32 INFO - https://queue.taskcluster.net/v1/task/crWsHE58SGiCcfL51i81JQ/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip matches https://queue.taskcluster.net 11:33:32 INFO - trying https://queue.taskcluster.net/v1/task/crWsHE58SGiCcfL51i81JQ/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip 11:33:32 INFO - Downloading https://queue.taskcluster.net/v1/task/crWsHE58SGiCcfL51i81JQ/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 11:33:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/crWsHE58SGiCcfL51i81JQ/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 11:33:38 INFO - Downloaded 18108073 bytes. 11:33:38 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 11:33:38 INFO - Copy/paste: unzip -q -o C:\slave\test\build\firefox-44.0a1.en-US.win64.common.tests.zip 11:33:38 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 11:34:15 INFO - Return code: 0 11:34:15 INFO - Downloading packages: [u'firefox-44.0a1.en-US.win64.common.tests.zip', u'firefox-44.0a1.en-US.win64.talos.tests.zip'] for test suite category: talos 11:34:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:34:15 INFO - https://queue.taskcluster.net/v1/task/crWsHE58SGiCcfL51i81JQ/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip matches https://queue.taskcluster.net 11:34:15 INFO - trying https://queue.taskcluster.net/v1/task/crWsHE58SGiCcfL51i81JQ/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip 11:34:15 INFO - Downloading https://queue.taskcluster.net/v1/task/crWsHE58SGiCcfL51i81JQ/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 11:34:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/crWsHE58SGiCcfL51i81JQ/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 11:34:23 INFO - Downloaded 18108073 bytes. 11:34:23 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 11:34:23 INFO - Copy/paste: unzip -q -o C:\slave\test\build\firefox-44.0a1.en-US.win64.common.tests.zip 11:34:23 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 11:34:45 INFO - Return code: 0 11:34:45 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')]} 11:34:45 INFO - https://queue.taskcluster.net/v1/task/crWsHE58SGiCcfL51i81JQ/artifacts/public/build/firefox-44.0a1.en-US.win64.talos.tests.zip matches https://queue.taskcluster.net 11:34:45 INFO - trying https://queue.taskcluster.net/v1/task/crWsHE58SGiCcfL51i81JQ/artifacts/public/build/firefox-44.0a1.en-US.win64.talos.tests.zip 11:34:45 INFO - Downloading https://queue.taskcluster.net/v1/task/crWsHE58SGiCcfL51i81JQ/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 11:34:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/crWsHE58SGiCcfL51i81JQ/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 11:34:59 INFO - Downloaded 11131307 bytes. 11:34:59 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 11:34:59 INFO - Copy/paste: unzip -q -o C:\slave\test\build\firefox-44.0a1.en-US.win64.talos.tests.zip 11:34:59 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 11:35:00 INFO - Return code: 0 11:35:00 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')]} 11:35:00 INFO - https://queue.taskcluster.net/v1/task/crWsHE58SGiCcfL51i81JQ/artifacts/public/build/firefox-44.0a1.en-US.win64.zip matches https://queue.taskcluster.net 11:35:00 INFO - trying https://queue.taskcluster.net/v1/task/crWsHE58SGiCcfL51i81JQ/artifacts/public/build/firefox-44.0a1.en-US.win64.zip 11:35:00 INFO - Downloading https://queue.taskcluster.net/v1/task/crWsHE58SGiCcfL51i81JQ/artifacts/public/build/firefox-44.0a1.en-US.win64.zip to C:\slave\test\build\firefox-44.0a1.en-US.win64.zip 11:35:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/crWsHE58SGiCcfL51i81JQ/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 11:35:14 INFO - Downloaded 54738314 bytes. 11:35:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/crWsHE58SGiCcfL51i81JQ/artifacts/public/build/firefox-44.0a1.en-US.win64.zip 11:35:14 INFO - mkdir: C:\slave\test\properties 11:35:14 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url 11:35:14 INFO - Writing to file C:\slave\test\properties\build_url 11:35:14 INFO - Contents: 11:35:14 INFO - build_url:https://queue.taskcluster.net/v1/task/crWsHE58SGiCcfL51i81JQ/artifacts/public/build/firefox-44.0a1.en-US.win64.zip 11:35:14 INFO - Running post-action listener: _resource_record_post_action 11:35:14 INFO - Running post-action listener: set_extra_try_arguments 11:35:14 INFO - ##### 11:35:14 INFO - ##### Running populate-webroot step. 11:35:14 INFO - ##### 11:35:14 INFO - Running pre-action listener: _resource_record_pre_action 11:35:14 INFO - Running main action method: populate_webroot 11:35:14 INFO - Guessing talos json url... 11:35:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:35:14 INFO - https://queue.taskcluster.net/v1/task/crWsHE58SGiCcfL51i81JQ/artifacts/public/build/firefox-44.0a1.en-US.win64.txt matches https://queue.taskcluster.net 11:35:14 INFO - trying https://queue.taskcluster.net/v1/task/crWsHE58SGiCcfL51i81JQ/artifacts/public/build/firefox-44.0a1.en-US.win64.txt 11:35:14 INFO - Downloading https://queue.taskcluster.net/v1/task/crWsHE58SGiCcfL51i81JQ/artifacts/public/build/firefox-44.0a1.en-US.win64.txt to C:\slave\test\build\firefox-44.0a1.en-US.win64.txt 11:35:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/crWsHE58SGiCcfL51i81JQ/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 11:35:16 INFO - Downloaded 103 bytes. 11:35:16 INFO - Reading from file C:\slave\test\build\firefox-44.0a1.en-US.win64.txt 11:35:16 INFO - Contents: 11:35:16 INFO - 20151026104938 11:35:16 INFO - https://hg.mozilla.org/integration/fx-team/rev/b842ef4420f1b247ab9706ce8d5028c8bca52ecd 11:35:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:35:16 INFO - trying https://hg.mozilla.org/integration/fx-team/raw-file/b842ef4420/testing/talos/talos.json 11:35:16 INFO - Downloading https://hg.mozilla.org/integration/fx-team/raw-file/b842ef4420/testing/talos/talos.json to C:\slave\test\build\talos.json 11:35:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/fx-team/raw-file/b842ef4420/testing/talos/talos.json', 'file_name': 'C:\\slave\\test\\build\\talos.json'}, attempt #1 11:35:17 INFO - Downloaded 4264 bytes. 11:35:17 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']}, 11:35:17 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']}, 11:35:17 INFO - u'remote-trobocheck2': {u'talos_options': [u'--fennecIDs', 11:35:17 INFO - u'../fennec_ids.txt'], 11:35:17 INFO - u'tests': [u'tcheck2']}, 11:35:17 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome', 11:35:17 INFO - u'--tppagecycles', 11:35:17 INFO - u'7'], 11:35:17 INFO - u'tests': [u'tsvgm']}}, 11:35:17 INFO - u'suites': {u'chromez': {u'tests': [u'tresize', u'tcanvasmark']}, 11:35:17 INFO - u'chromez-e10s': {u'talos_options': [u'--e10s'], 11:35:17 INFO - u'tests': [u'tresize', u'tcanvasmark']}, 11:35:17 INFO - u'dromaeojs': {u'tests': [u'dromaeo_css', u'kraken', u'v8_7']}, 11:35:17 INFO - u'dromaeojs-e10s': {u'talos_options': [u'--e10s'], 11:35:17 INFO - u'tests': [u'dromaeo_css', 11:35:17 INFO - u'kraken', 11:35:17 INFO - u'v8_7']}, 11:35:17 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:35:17 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 11:35:17 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:35:17 INFO - u'talos_options': [u'--e10s'], 11:35:17 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 11:35:17 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:35:17 INFO - u'tests': [u'damp', u'tps']}, 11:35:17 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:35:17 INFO - u'talos_options': [u'--e10s'], 11:35:17 INFO - u'tests': [u'damp', u'tps']}, 11:35:17 INFO - u'g3': {u'tests': [u'dromaeo_dom']}, 11:35:17 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']}, 11:35:17 INFO - u'other': {u'tests': [u'a11yr', 11:35:17 INFO - u'ts_paint', 11:35:17 INFO - u'tpaint', 11:35:17 INFO - u'sessionrestore', 11:35:17 INFO - u'sessionrestore_no_auto_restore']}, 11:35:17 INFO - u'other-e10s': {u'talos_options': [u'--e10s'], 11:35:17 INFO - u'tests': [u'a11yr', 11:35:17 INFO - u'ts_paint', 11:35:17 INFO - u'tpaint', 11:35:17 INFO - u'sessionrestore', 11:35:17 INFO - u'sessionrestore_no_auto_restore']}, 11:35:17 INFO - u'other-e10s_l64': {u'talos_options': [u'--e10s'], 11:35:17 INFO - u'tests': [u'a11yr', 11:35:17 INFO - u'ts_paint', 11:35:17 INFO - u'tpaint', 11:35:17 INFO - u'sessionrestore', 11:35:17 INFO - u'sessionrestore_no_auto_restore']}, 11:35:17 INFO - u'other-e10s_nol64': {u'talos_options': [u'--e10s'], 11:35:17 INFO - u'tests': [u'a11yr', 11:35:17 INFO - u'ts_paint', 11:35:17 INFO - u'tpaint', 11:35:17 INFO - u'sessionrestore', 11:35:17 INFO - u'sessionrestore_no_auto_restore']}, 11:35:17 INFO - u'other_l64': {u'tests': [u'a11yr', 11:35:17 INFO - u'ts_paint', 11:35:17 INFO - u'tpaint', 11:35:17 INFO - u'sessionrestore', 11:35:17 INFO - u'sessionrestore_no_auto_restore']}, 11:35:17 INFO - u'other_nol64': {u'tests': [u'a11yr', 11:35:17 INFO - u'ts_paint', 11:35:17 INFO - u'tpaint', 11:35:17 INFO - u'sessionrestore', 11:35:17 INFO - u'sessionrestore_no_auto_restore']}, 11:35:17 INFO - u'svgr': {u'tests': [u'tsvgx', 11:35:17 INFO - u'tsvgr_opacity', 11:35:17 INFO - u'tart', 11:35:17 INFO - u'tscrollx', 11:35:17 INFO - u'cart']}, 11:35:17 INFO - u'svgr-e10s': {u'talos_options': [u'--e10s'], 11:35:17 INFO - u'tests': [u'tsvgx', 11:35:17 INFO - u'tsvgr_opacity', 11:35:17 INFO - u'tart', 11:35:17 INFO - u'tscrollx', 11:35:17 INFO - u'cart']}, 11:35:17 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:35:17 INFO - u'tests': [u'tp5o']}, 11:35:17 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:35:17 INFO - u'talos_options': [u'--e10s'], 11:35:17 INFO - u'tests': [u'tp5o']}, 11:35:17 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:35:17 INFO - u'talos_options': [u'--xperf_path', 11:35:17 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:35:17 INFO - u'tests': [u'tp5n']}, 11:35:17 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:35:17 INFO - u'talos_options': [u'--e10s', 11:35:17 INFO - u'--xperf_path', 11:35:17 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 11:35:17 INFO - u'C:/slave/talos-data/talos/xperf.config'], 11:35:17 INFO - u'tests': [u'tp5n']}}, 11:35:17 INFO - u'talos.zip': {u'path': u'', 11:35:17 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:35:17 INFO - Running post-action listener: _resource_record_post_action 11:35:17 INFO - ##### 11:35:17 INFO - ##### Running create-virtualenv step. 11:35:17 INFO - ##### 11:35:17 INFO - Running pre-action listener: _resource_record_pre_action 11:35:17 INFO - Running main action method: create_virtualenv 11:35:17 INFO - Creating virtualenv C:\slave\test\build/venv 11:35:17 INFO - mkdir: C:\slave\test\build\venv\Scripts 11:35:17 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll 11:35:17 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'! 11:35:17 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 11:35:17 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build/venv 11:35:19 INFO - New python executable in C:\slave\test\build/venv\Scripts\python.exe 11:35:21 INFO - Installing distribute......................................................................................................................................................................................done. 11:35:23 INFO - Return code: 0 11:35:23 INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv 11:35:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:35:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:35:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:35:23 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 0x023CFB10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02391EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02469A90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01DB8B48>, '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 0x01DDA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0244A660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-118', 'USERDOMAIN': 'T-W864-IX-118', '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-118', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-118\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-118', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-118', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-118', '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-118\\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 11:35:23 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 11:35:23 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 11:35:23 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 11:35:23 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-118\\AppData\\Roaming', 11:35:23 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 11:35:23 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 11:35:23 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 11:35:23 INFO - 'COMPUTERNAME': 'T-W864-IX-118', 11:35:23 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 11:35:23 INFO - 'DCLOCATION': 'SCL3', 11:35:23 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 11:35:23 INFO - 'FP_NO_HOST_CHECK': 'NO', 11:35:23 INFO - 'HOMEDRIVE': 'C:', 11:35:23 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-118', 11:35:23 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 11:35:23 INFO - 'KTS_VERSION': '1.19c', 11:35:23 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-118\\AppData\\Local', 11:35:23 INFO - 'LOGONSERVER': '\\\\T-W864-IX-118', 11:35:23 INFO - 'MONDIR': 'C:\\Monitor_config\\', 11:35:23 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 11:35:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:23 INFO - 'MOZ_NO_REMOTE': '1', 11:35:23 INFO - 'NO_EM_RESTART': '1', 11:35:23 INFO - 'NUMBER_OF_PROCESSORS': '8', 11:35:23 INFO - 'OS': 'Windows_NT', 11:35:23 INFO - 'OURDRIVE': 'C:', 11:35:23 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', 11:35:23 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 11:35:23 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 11:35:23 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 11:35:23 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 11:35:23 INFO - 'PROCESSOR_LEVEL': '6', 11:35:23 INFO - 'PROCESSOR_REVISION': '1e05', 11:35:23 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 11:35:23 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 11:35:23 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 11:35:23 INFO - 'PROGRAMW6432': 'C:\\Program Files', 11:35:23 INFO - 'PROMPT': '$P$G', 11:35:23 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 11:35:23 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 11:35:23 INFO - 'PUBLIC': 'C:\\Users\\Public', 11:35:23 INFO - 'PWD': 'C:\\slave\\test', 11:35:23 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 11:35:23 INFO - 'SLAVEDIR': 'C:\\slave\\', 11:35:23 INFO - 'SYSTEMDRIVE': 'C:', 11:35:23 INFO - 'SYSTEMROOT': 'C:\\windows', 11:35:23 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:35:23 INFO - 'TEST1': 'testie', 11:35:23 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:35:23 INFO - 'USERDOMAIN': 'T-W864-IX-118', 11:35:23 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-118', 11:35:23 INFO - 'USERNAME': 'cltbld', 11:35:23 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-118', 11:35:23 INFO - 'WINDIR': 'C:\\windows', 11:35:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 11:35:25 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:35:25 INFO - Downloading/unpacking pip>=1.5 11:35:25 INFO - Creating supposed download cache at C:\slave\test\build/venv\cache 11:35:34 INFO - Storing download in cache at c:\slave\test\build\venv\cache\http%3a%2f%2fpypi.pub.build.mozilla.org%2fpub%2fpip-1.5.5.tar.gz 11:35:34 INFO - Running setup.py egg_info for package pip 11:35:34 INFO - warning: no files found matching 'pip\cacert.pem' 11:35:34 INFO - warning: no files found matching '*.html' under directory 'docs' 11:35:34 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 11:35:34 INFO - no previously-included directories found matching 'docs\_build\_sources' 11:35:34 INFO - Installing collected packages: pip 11:35:34 INFO - Found existing installation: pip 0.8.2 11:35:34 INFO - Uninstalling pip: 11:35:34 INFO - Successfully uninstalled pip 11:35:34 INFO - Running setup.py install for pip 11:35:34 INFO - warning: no files found matching 'pip\cacert.pem' 11:35:34 INFO - warning: no files found matching '*.html' under directory 'docs' 11:35:34 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 11:35:34 INFO - no previously-included directories found matching 'docs\_build\_sources' 11:35:34 INFO - Installing pip-script.py script to C:\slave\test\build\venv\Scripts 11:35:34 INFO - Installing pip.exe script to C:\slave\test\build\venv\Scripts 11:35:34 INFO - Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts 11:35:34 INFO - Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts 11:35:34 INFO - Installing pip2-script.py script to C:\slave\test\build\venv\Scripts 11:35:34 INFO - Installing pip2.exe script to C:\slave\test\build\venv\Scripts 11:35:34 INFO - Successfully installed pip 11:35:34 INFO - Cleaning up... 11:35:34 INFO - Return code: 0 11:35:34 INFO - Installing psutil>=0.7.1 into virtualenv C:\slave\test\build/venv 11:35:34 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')]} 11:35:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:35:34 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')]} 11:35:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:35:34 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 0x023CFB10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02391EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02469A90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01DB8B48>, '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 0x01DDA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0244A660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-118', 'USERDOMAIN': 'T-W864-IX-118', '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-118', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-118\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-118', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-118', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-118', '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-118\\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 11:35:34 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 11:35:34 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 11:35:34 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 11:35:34 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-118\\AppData\\Roaming', 11:35:34 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 11:35:34 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 11:35:34 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 11:35:34 INFO - 'COMPUTERNAME': 'T-W864-IX-118', 11:35:34 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 11:35:34 INFO - 'DCLOCATION': 'SCL3', 11:35:34 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 11:35:34 INFO - 'FP_NO_HOST_CHECK': 'NO', 11:35:34 INFO - 'HOMEDRIVE': 'C:', 11:35:34 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-118', 11:35:34 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 11:35:34 INFO - 'KTS_VERSION': '1.19c', 11:35:34 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-118\\AppData\\Local', 11:35:34 INFO - 'LOGONSERVER': '\\\\T-W864-IX-118', 11:35:34 INFO - 'MONDIR': 'C:\\Monitor_config\\', 11:35:34 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 11:35:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:34 INFO - 'MOZ_NO_REMOTE': '1', 11:35:34 INFO - 'NO_EM_RESTART': '1', 11:35:34 INFO - 'NUMBER_OF_PROCESSORS': '8', 11:35:34 INFO - 'OS': 'Windows_NT', 11:35:34 INFO - 'OURDRIVE': 'C:', 11:35:34 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 11:35:34 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 11:35:34 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 11:35:34 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 11:35:34 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 11:35:34 INFO - 'PROCESSOR_LEVEL': '6', 11:35:34 INFO - 'PROCESSOR_REVISION': '1e05', 11:35:34 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 11:35:34 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 11:35:34 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 11:35:34 INFO - 'PROGRAMW6432': 'C:\\Program Files', 11:35:34 INFO - 'PROMPT': '$P$G', 11:35:34 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 11:35:34 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 11:35:34 INFO - 'PUBLIC': 'C:\\Users\\Public', 11:35:34 INFO - 'PWD': 'C:\\slave\\test', 11:35:34 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 11:35:34 INFO - 'SLAVEDIR': 'C:\\slave\\', 11:35:34 INFO - 'SYSTEMDRIVE': 'C:', 11:35:34 INFO - 'SYSTEMROOT': 'C:\\windows', 11:35:34 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:35:34 INFO - 'TEST1': 'testie', 11:35:34 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:35:34 INFO - 'USERDOMAIN': 'T-W864-IX-118', 11:35:34 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-118', 11:35:34 INFO - 'USERNAME': 'cltbld', 11:35:34 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-118', 11:35:34 INFO - 'WINDIR': 'C:\\windows', 11:35:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 11:35:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:35:36 INFO - Downloading/unpacking psutil>=0.7.1 11:35:36 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 11:35:36 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 11:35:37 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 11:35:37 INFO - Installing collected packages: psutil 11:35:37 INFO - Successfully installed psutil 11:35:37 INFO - Cleaning up... 11:35:37 INFO - Return code: 0 11:35:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv C:\slave\test\build/venv 11:35: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')]} 11:35:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:35: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')]} 11:35:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:35: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', '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 0x023CFB10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02391EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02469A90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01DB8B48>, '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 0x01DDA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0244A660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-118', 'USERDOMAIN': 'T-W864-IX-118', '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-118', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-118\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-118', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-118', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-118', '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-118\\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 11:35: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', 'mozsystemmonitor==0.0.0'] in C:\slave\test\build 11:35: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 mozsystemmonitor==0.0.0 11:35:37 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 11:35:37 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-118\\AppData\\Roaming', 11:35:37 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 11:35:37 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 11:35:37 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 11:35:37 INFO - 'COMPUTERNAME': 'T-W864-IX-118', 11:35:37 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 11:35:37 INFO - 'DCLOCATION': 'SCL3', 11:35:37 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 11:35:37 INFO - 'FP_NO_HOST_CHECK': 'NO', 11:35:37 INFO - 'HOMEDRIVE': 'C:', 11:35:37 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-118', 11:35:37 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 11:35:37 INFO - 'KTS_VERSION': '1.19c', 11:35:37 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-118\\AppData\\Local', 11:35:37 INFO - 'LOGONSERVER': '\\\\T-W864-IX-118', 11:35:37 INFO - 'MONDIR': 'C:\\Monitor_config\\', 11:35:37 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 11:35:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:37 INFO - 'MOZ_NO_REMOTE': '1', 11:35:37 INFO - 'NO_EM_RESTART': '1', 11:35:37 INFO - 'NUMBER_OF_PROCESSORS': '8', 11:35:37 INFO - 'OS': 'Windows_NT', 11:35:37 INFO - 'OURDRIVE': 'C:', 11:35: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', 11:35:37 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 11:35:37 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 11:35:37 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 11:35:37 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 11:35:37 INFO - 'PROCESSOR_LEVEL': '6', 11:35:37 INFO - 'PROCESSOR_REVISION': '1e05', 11:35:37 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 11:35:37 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 11:35:37 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 11:35:37 INFO - 'PROGRAMW6432': 'C:\\Program Files', 11:35:37 INFO - 'PROMPT': '$P$G', 11:35:37 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 11:35:37 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 11:35:37 INFO - 'PUBLIC': 'C:\\Users\\Public', 11:35:37 INFO - 'PWD': 'C:\\slave\\test', 11:35:37 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 11:35:37 INFO - 'SLAVEDIR': 'C:\\slave\\', 11:35:37 INFO - 'SYSTEMDRIVE': 'C:', 11:35:37 INFO - 'SYSTEMROOT': 'C:\\windows', 11:35:37 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:35:37 INFO - 'TEST1': 'testie', 11:35:37 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:35:37 INFO - 'USERDOMAIN': 'T-W864-IX-118', 11:35:37 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-118', 11:35:37 INFO - 'USERNAME': 'cltbld', 11:35:37 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-118', 11:35:37 INFO - 'WINDIR': 'C:\\windows', 11:35:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 11:35:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:35:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:35:37 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 11:35:37 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 11:35:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:35:40 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 11:35:40 INFO - Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor 11:35:41 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) 11:35:41 INFO - Installing collected packages: mozsystemmonitor 11:35:41 INFO - Running setup.py install for mozsystemmonitor 11:35:41 INFO - Successfully installed mozsystemmonitor 11:35:41 INFO - Cleaning up... 11:35:41 INFO - Return code: 0 11:35:41 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv 11:35: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')]} 11:35:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:35: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')]} 11:35:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:35: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', '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 0x023CFB10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02391EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02469A90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01DB8B48>, '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 0x01DDA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0244A660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-118', 'USERDOMAIN': 'T-W864-IX-118', '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-118', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-118\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-118', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-118', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-118', '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-118\\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 11:35: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', 'blobuploader==1.2.4'] in C:\slave\test\build 11:35: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 blobuploader==1.2.4 11:35:41 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 11:35:41 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-118\\AppData\\Roaming', 11:35:41 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 11:35:41 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 11:35:41 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 11:35:41 INFO - 'COMPUTERNAME': 'T-W864-IX-118', 11:35:41 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 11:35:41 INFO - 'DCLOCATION': 'SCL3', 11:35:41 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 11:35:41 INFO - 'FP_NO_HOST_CHECK': 'NO', 11:35:41 INFO - 'HOMEDRIVE': 'C:', 11:35:41 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-118', 11:35:41 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 11:35:41 INFO - 'KTS_VERSION': '1.19c', 11:35:41 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-118\\AppData\\Local', 11:35:41 INFO - 'LOGONSERVER': '\\\\T-W864-IX-118', 11:35:41 INFO - 'MONDIR': 'C:\\Monitor_config\\', 11:35:41 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 11:35:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:41 INFO - 'MOZ_NO_REMOTE': '1', 11:35:41 INFO - 'NO_EM_RESTART': '1', 11:35:41 INFO - 'NUMBER_OF_PROCESSORS': '8', 11:35:41 INFO - 'OS': 'Windows_NT', 11:35:41 INFO - 'OURDRIVE': 'C:', 11:35: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', 11:35:41 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 11:35:41 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 11:35:41 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 11:35:41 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 11:35:41 INFO - 'PROCESSOR_LEVEL': '6', 11:35:41 INFO - 'PROCESSOR_REVISION': '1e05', 11:35:41 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 11:35:41 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 11:35:41 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 11:35:41 INFO - 'PROGRAMW6432': 'C:\\Program Files', 11:35:41 INFO - 'PROMPT': '$P$G', 11:35:41 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 11:35:41 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 11:35:41 INFO - 'PUBLIC': 'C:\\Users\\Public', 11:35:41 INFO - 'PWD': 'C:\\slave\\test', 11:35:41 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 11:35:41 INFO - 'SLAVEDIR': 'C:\\slave\\', 11:35:41 INFO - 'SYSTEMDRIVE': 'C:', 11:35:41 INFO - 'SYSTEMROOT': 'C:\\windows', 11:35:41 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:35:41 INFO - 'TEST1': 'testie', 11:35:41 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:35:41 INFO - 'USERDOMAIN': 'T-W864-IX-118', 11:35:41 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-118', 11:35:41 INFO - 'USERNAME': 'cltbld', 11:35:41 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-118', 11:35:41 INFO - 'WINDIR': 'C:\\windows', 11:35:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 11:35:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:35:41 INFO - Downloading/unpacking blobuploader==1.2.4 11:35: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 11:35: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 11:35:42 INFO - Downloading blobuploader-1.2.4.tar.gz 11:35:42 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 11:35:42 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader 11:35:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:35:42 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 11:35:42 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 11:35:42 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 11:35:42 INFO - Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests 11:35:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:35: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 11:35: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 11:35:43 INFO - Downloading docopt-0.6.1.tar.gz 11:35:43 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 11:35:43 INFO - Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt 11:35:43 INFO - Installing collected packages: blobuploader, requests, docopt 11:35:43 INFO - Running setup.py install for blobuploader 11:35:43 INFO - Running setup.py install for requests 11:35:44 INFO - Running setup.py install for docopt 11:35:44 INFO - Successfully installed blobuploader requests docopt 11:35:44 INFO - Cleaning up... 11:35:45 INFO - Return code: 0 11:35:45 INFO - Installing None into virtualenv C:\slave\test\build/venv 11:35:45 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')]} 11:35:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:35:45 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')]} 11:35:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:35:45 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 0x023CFB10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02391EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02469A90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01DB8B48>, '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 0x01DDA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0244A660>, '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-118', 'USERDOMAIN': 'T-W864-IX-118', '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-118', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-118\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-118', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-118', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-118', '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-118\\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 11:35:45 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 11:35:45 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 11:35:45 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 11:35:45 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-118\\AppData\\Roaming', 11:35:45 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 11:35:45 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 11:35:45 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 11:35:45 INFO - 'COMPUTERNAME': 'T-W864-IX-118', 11:35:45 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 11:35:45 INFO - 'DCLOCATION': 'SCL3', 11:35:45 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 11:35:45 INFO - 'FP_NO_HOST_CHECK': 'NO', 11:35:45 INFO - 'HOMEDRIVE': 'C:', 11:35:45 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-118', 11:35:45 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 11:35:45 INFO - 'KTS_VERSION': '1.19c', 11:35:45 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-118\\AppData\\Local', 11:35:45 INFO - 'LOGONSERVER': '\\\\T-W864-IX-118', 11:35:45 INFO - 'MONDIR': 'C:\\Monitor_config\\', 11:35:45 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 11:35:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:45 INFO - 'MOZ_NO_REMOTE': '1', 11:35:45 INFO - 'NO_EM_RESTART': '1', 11:35:45 INFO - 'NUMBER_OF_PROCESSORS': '8', 11:35:45 INFO - 'OS': 'Windows_NT', 11:35:45 INFO - 'OURDRIVE': 'C:', 11:35:45 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', 11:35:45 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 11:35:45 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 11:35:45 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 11:35:45 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 11:35:45 INFO - 'PROCESSOR_LEVEL': '6', 11:35:45 INFO - 'PROCESSOR_REVISION': '1e05', 11:35:45 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 11:35:45 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 11:35:45 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 11:35:45 INFO - 'PROGRAMW6432': 'C:\\Program Files', 11:35:45 INFO - 'PROMPT': '$P$G', 11:35:45 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 11:35:45 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 11:35:45 INFO - 'PUBLIC': 'C:\\Users\\Public', 11:35:45 INFO - 'PWD': 'C:\\slave\\test', 11:35:45 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 11:35:45 INFO - 'SLAVEDIR': 'C:\\slave\\', 11:35:45 INFO - 'SYSTEMDRIVE': 'C:', 11:35:45 INFO - 'SYSTEMROOT': 'C:\\windows', 11:35:45 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:35:45 INFO - 'TEST1': 'testie', 11:35:45 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:35:45 INFO - 'USERDOMAIN': 'T-W864-IX-118', 11:35:45 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-118', 11:35:45 INFO - 'USERNAME': 'cltbld', 11:35:45 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-118', 11:35:45 INFO - 'WINDIR': 'C:\\windows', 11:35:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 11:35:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:35:45 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 11:35:45 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-2susdu-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 11:35:45 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 11:35:45 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-r_wsvh-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 11:35:45 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 11:35:45 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-fo2g7d-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 11:35:46 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 11:35:46 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-t2kmpe-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 11:35:46 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 11:35:46 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-aluqsg-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 11:35:46 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 11:35:46 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-zc_i2k-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 11:35:46 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 11:35:46 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-zs8eey-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 11:35:46 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 11:35:46 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-kfbjku-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 11:35:46 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 11:35:46 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-pdpemo-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 11:35:46 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 11:35:46 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-crv8he-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 11:35:46 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 11:35:46 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-4euarp-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 11:35:46 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 11:35:46 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-thdhcp-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 11:35:47 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 11:35:47 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-3j56y4-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 11:35:47 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 11:35:47 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jqmmww-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 11:35:47 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 11:35:47 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qydf9h-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 11:35:47 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 11:35:47 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-_znujv-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 11:35:47 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 11:35:47 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-3yvqzk-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 11:35:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:35:47 INFO - Running setup.py install for manifestparser 11:35:48 INFO - Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts 11:35:48 INFO - Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts 11:35:48 INFO - Running setup.py install for mozcrash 11:35:48 INFO - Running setup.py install for mozdebug 11:35:49 INFO - Running setup.py install for mozdevice 11:35:49 INFO - Installing sutini-script.py script to C:\slave\test\build\venv\Scripts 11:35:49 INFO - Installing sutini.exe script to C:\slave\test\build\venv\Scripts 11:35:49 INFO - Installing dm-script.py script to C:\slave\test\build\venv\Scripts 11:35:49 INFO - Installing dm.exe script to C:\slave\test\build\venv\Scripts 11:35:49 INFO - Running setup.py install for mozfile 11:35:50 INFO - Running setup.py install for mozhttpd 11:35:50 INFO - Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts 11:35:50 INFO - Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts 11:35:50 INFO - Running setup.py install for mozinfo 11:35:50 INFO - Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts 11:35:50 INFO - Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts 11:35:50 INFO - Running setup.py install for mozInstall 11:35:51 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts 11:35:51 INFO - Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts 11:35:51 INFO - Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts 11:35:51 INFO - Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts 11:35:51 INFO - Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts 11:35:51 INFO - Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts 11:35:51 INFO - Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts 11:35:51 INFO - Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts 11:35:51 INFO - Running setup.py install for mozleak 11:35:51 INFO - Running setup.py install for mozlog 11:35:51 INFO - Installing structlog-script.py script to C:\slave\test\build\venv\Scripts 11:35:51 INFO - Installing structlog.exe script to C:\slave\test\build\venv\Scripts 11:35:52 INFO - Running setup.py install for moznetwork 11:35:52 INFO - Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts 11:35:52 INFO - Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts 11:35:52 INFO - Running setup.py install for mozprocess 11:35:53 INFO - Running setup.py install for mozprofile 11:35:53 INFO - Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts 11:35:53 INFO - Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts 11:35:53 INFO - Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts 11:35:53 INFO - Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts 11:35:53 INFO - Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts 11:35:53 INFO - Installing view-profile.exe script to C:\slave\test\build\venv\Scripts 11:35:54 INFO - Running setup.py install for mozrunner 11:35:54 INFO - Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts 11:35:54 INFO - Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts 11:35:54 INFO - Running setup.py install for mozscreenshot 11:35:55 INFO - Running setup.py install for moztest 11:35:55 INFO - Running setup.py install for mozversion 11:35:55 INFO - Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts 11:35:55 INFO - Installing mozversion.exe script to C:\slave\test\build\venv\Scripts 11:35:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:35:55 INFO - Cleaning up... 11:35:55 INFO - Return code: 0 11:35:55 INFO - Installing None into virtualenv C:\slave\test\build/venv 11:35: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')]} 11:35:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:35: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')]} 11:35:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:35:55 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 0x023CFB10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02391EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02469A90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01DB8B48>, '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 0x01DDA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0244A660>, '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-118', 'USERDOMAIN': 'T-W864-IX-118', '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-118', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-118\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-118', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-118', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-118', '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-118\\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 11:35:55 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 11:35:55 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 11:35:55 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 11:35:55 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-118\\AppData\\Roaming', 11:35:55 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 11:35:55 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 11:35:55 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 11:35:55 INFO - 'COMPUTERNAME': 'T-W864-IX-118', 11:35:55 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 11:35:55 INFO - 'DCLOCATION': 'SCL3', 11:35:55 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 11:35:55 INFO - 'FP_NO_HOST_CHECK': 'NO', 11:35:55 INFO - 'HOMEDRIVE': 'C:', 11:35:55 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-118', 11:35:55 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 11:35:55 INFO - 'KTS_VERSION': '1.19c', 11:35:55 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-118\\AppData\\Local', 11:35:55 INFO - 'LOGONSERVER': '\\\\T-W864-IX-118', 11:35:55 INFO - 'MONDIR': 'C:\\Monitor_config\\', 11:35:55 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 11:35:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:55 INFO - 'MOZ_NO_REMOTE': '1', 11:35:55 INFO - 'NO_EM_RESTART': '1', 11:35:55 INFO - 'NUMBER_OF_PROCESSORS': '8', 11:35:55 INFO - 'OS': 'Windows_NT', 11:35:55 INFO - 'OURDRIVE': 'C:', 11:35:55 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', 11:35:55 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 11:35:55 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 11:35:55 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 11:35:55 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 11:35:55 INFO - 'PROCESSOR_LEVEL': '6', 11:35:55 INFO - 'PROCESSOR_REVISION': '1e05', 11:35:55 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 11:35:55 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 11:35:55 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 11:35:55 INFO - 'PROGRAMW6432': 'C:\\Program Files', 11:35:55 INFO - 'PROMPT': '$P$G', 11:35:55 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 11:35:55 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 11:35:55 INFO - 'PUBLIC': 'C:\\Users\\Public', 11:35:55 INFO - 'PWD': 'C:\\slave\\test', 11:35:55 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 11:35:55 INFO - 'SLAVEDIR': 'C:\\slave\\', 11:35:55 INFO - 'SYSTEMDRIVE': 'C:', 11:35:55 INFO - 'SYSTEMROOT': 'C:\\windows', 11:35:55 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:35:55 INFO - 'TEST1': 'testie', 11:35:55 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:35:55 INFO - 'USERDOMAIN': 'T-W864-IX-118', 11:35:55 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-118', 11:35:55 INFO - 'USERNAME': 'cltbld', 11:35:55 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-118', 11:35:55 INFO - 'WINDIR': 'C:\\windows', 11:35:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 11:35:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:35:56 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 11:35:56 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-u_dfpb-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 11:35:56 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)) 11:35:56 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 11:35:56 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ufioh9-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 11:35:56 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)) 11:35:56 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 11:35:56 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-0kweb5-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 11:35:56 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)) 11:35:56 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 11:35:56 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-fwisox-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 11:35:56 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)) 11:35:56 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 11:35:56 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ilv7bp-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 11:35:56 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)) 11:35:56 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 11:35:56 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-4hbpcw-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 11:35:56 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)) 11:35:56 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 11:35:56 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-87iaw7-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 11:35:56 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)) 11:35:56 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 11:35:56 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-irkrgo-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 11:35:57 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)) 11:35:57 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 11:35:57 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-orwvc1-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 11:35:57 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)) 11:35:57 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 11:35:57 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-r5tdot-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 11:35:57 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)) 11:35:57 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 11:35:57 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-q8qpm8-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 11:35:57 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)) 11:35:57 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 11:35:57 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-yicdch-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 11:35:57 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)) 11:35:57 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 11:35:57 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ggfk9q-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 11:35:57 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)) 11:35:57 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 11:35:57 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-oky8nw-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 11:35:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///C:/slave/test/build/tests/mozbase/mozrunner in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 14)) 11:35:57 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 11:35:57 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ev72nw-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 11:35:57 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)) 11:35:57 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 11:35:57 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jukhtm-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 11:35:57 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)) 11:35:57 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 11:35:57 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ya19ln-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 11:35:58 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)) 11:35:58 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)) 11:35:58 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)) 11:35:58 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)) 11:35:58 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)) 11:35:58 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)) 11:35:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10)) 11:35:58 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 11:35:58 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 11:35:59 INFO - Downloading blessings-1.5.1.tar.gz 11:36:00 INFO - Storing download in cache at c:\slave\test\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fblessings-1.5.1.tar.gz 11:36:00 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings 11:36:00 INFO - Installing collected packages: blessings 11:36:00 INFO - Running setup.py install for blessings 11:36:00 INFO - Successfully installed blessings 11:36:00 INFO - Cleaning up... 11:36:03 INFO - Return code: 0 11:36:03 INFO - Done creating virtualenv C:\slave\test\build/venv. 11:36:03 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 11:36:03 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 11:36:03 INFO - Reading from file tmpfile_stdout 11:36:03 INFO - Using _rmtree_windows ... 11:36:03 INFO - Using _rmtree_windows ... 11:36:03 INFO - Current package versions: 11:36:03 INFO - blessings == 1.5.1 11:36:03 INFO - blobuploader == 1.2.4 11:36:03 INFO - docopt == 0.6.1 11:36:03 INFO - manifestparser == 1.1 11:36:03 INFO - mozInstall == 1.12 11:36:03 INFO - mozcrash == 0.16 11:36:03 INFO - mozdebug == 0.1 11:36:03 INFO - mozdevice == 0.46 11:36:03 INFO - mozfile == 1.2 11:36:03 INFO - mozhttpd == 0.7 11:36:03 INFO - mozinfo == 0.8 11:36:03 INFO - mozleak == 0.1 11:36:03 INFO - mozlog == 3.0 11:36:03 INFO - moznetwork == 0.27 11:36:03 INFO - mozprocess == 0.22 11:36:03 INFO - mozprofile == 0.27 11:36:03 INFO - mozrunner == 6.11 11:36:03 INFO - mozscreenshot == 0.1 11:36:03 INFO - mozsystemmonitor == 0.0 11:36:03 INFO - moztest == 0.7 11:36:03 INFO - mozversion == 1.4 11:36:03 INFO - psutil == 3.1.1 11:36:03 INFO - requests == 1.2.3 11:36:03 INFO - Installing None into virtualenv C:\slave\test\build/venv 11:36:03 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')]} 11:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:03 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')]} 11:36:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:03 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 0x023CFB10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02391EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02469A90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01DB8B48>, '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 0x01DDA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0244A660>, '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-118', 'USERDOMAIN': 'T-W864-IX-118', '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-118', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-118\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-118', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-118', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-118', '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-118\\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 11:36:03 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 11:36:03 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 11:36:03 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 11:36:03 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-118\\AppData\\Roaming', 11:36:03 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 11:36:03 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 11:36:03 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 11:36:03 INFO - 'COMPUTERNAME': 'T-W864-IX-118', 11:36:03 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 11:36:03 INFO - 'DCLOCATION': 'SCL3', 11:36:03 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 11:36:03 INFO - 'FP_NO_HOST_CHECK': 'NO', 11:36:03 INFO - 'HOMEDRIVE': 'C:', 11:36:03 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-118', 11:36:03 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 11:36:03 INFO - 'KTS_VERSION': '1.19c', 11:36:03 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-118\\AppData\\Local', 11:36:03 INFO - 'LOGONSERVER': '\\\\T-W864-IX-118', 11:36:03 INFO - 'MONDIR': 'C:\\Monitor_config\\', 11:36:03 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 11:36:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:03 INFO - 'MOZ_NO_REMOTE': '1', 11:36:03 INFO - 'NO_EM_RESTART': '1', 11:36:03 INFO - 'NUMBER_OF_PROCESSORS': '8', 11:36:03 INFO - 'OS': 'Windows_NT', 11:36:03 INFO - 'OURDRIVE': 'C:', 11:36:03 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', 11:36:03 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 11:36:03 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 11:36:03 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 11:36:03 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 11:36:03 INFO - 'PROCESSOR_LEVEL': '6', 11:36:03 INFO - 'PROCESSOR_REVISION': '1e05', 11:36:03 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 11:36:03 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 11:36:03 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 11:36:03 INFO - 'PROGRAMW6432': 'C:\\Program Files', 11:36:03 INFO - 'PROMPT': '$P$G', 11:36:03 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 11:36:03 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 11:36:03 INFO - 'PUBLIC': 'C:\\Users\\Public', 11:36:03 INFO - 'PWD': 'C:\\slave\\test', 11:36:03 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 11:36:03 INFO - 'SLAVEDIR': 'C:\\slave\\', 11:36:03 INFO - 'SYSTEMDRIVE': 'C:', 11:36:03 INFO - 'SYSTEMROOT': 'C:\\windows', 11:36:03 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:36:03 INFO - 'TEST1': 'testie', 11:36:03 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:36:03 INFO - 'USERDOMAIN': 'T-W864-IX-118', 11:36:03 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-118', 11:36:03 INFO - 'USERNAME': 'cltbld', 11:36:03 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-118', 11:36:03 INFO - 'WINDIR': 'C:\\windows', 11:36:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 11:36:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 1)) 11:36:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 2)) 11:36:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 3)) 11:36:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 4)) 11:36:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 5)) 11:36:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 6)) 11:36:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 7)) 11:36:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 8)) 11:36:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash>=0.15->-r C:\slave\test\build\tests\talos\requirements.txt (line 1)) 11:36:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test\build\venv\lib\site-packages (from mozhttpd>=0.7->-r C:\slave\test\build\tests\talos\requirements.txt (line 3)) 11:36:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in c:\slave\test\build\venv\lib\site-packages (from mozlog>=3.0->mozcrash>=0.15->-r C:\slave\test\build\tests\talos\requirements.txt (line 1)) 11:36:04 INFO - Cleaning up... 11:36:04 INFO - Return code: 0 11:36:04 INFO - Running post-action listener: _resource_record_post_action 11:36:04 INFO - Running post-action listener: _start_resource_monitoring 11:36:04 INFO - Starting resource monitoring. 11:36:04 INFO - ##### 11:36:04 INFO - ##### Running install step. 11:36:04 INFO - ##### 11:36:04 INFO - Running pre-action listener: _resource_record_pre_action 11:36:04 INFO - Running main action method: install 11:36:04 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 11:36:04 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 11:36:04 INFO - Reading from file tmpfile_stdout 11:36:04 INFO - Using _rmtree_windows ... 11:36:04 INFO - Using _rmtree_windows ... 11:36:04 INFO - Detecting whether we're running mozinstall >=1.0... 11:36:04 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h'] 11:36:04 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h 11:36:04 INFO - Reading from file tmpfile_stdout 11:36:04 INFO - Output received: 11:36:04 INFO - Usage: mozinstall-script.py [options] installer 11:36:04 INFO - Options: 11:36:04 INFO - -h, --help show this help message and exit 11:36:04 INFO - -d DEST, --destination=DEST 11:36:04 INFO - Directory to install application into. [default: 11:36:04 INFO - "C:\slave\test"] 11:36:04 INFO - --app=APP Application being installed. [default: firefox] 11:36:04 INFO - Using _rmtree_windows ... 11:36:04 INFO - Using _rmtree_windows ... 11:36:04 INFO - mkdir: C:\slave\test\build\application 11:36:04 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'] 11:36:04 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 11:36:06 INFO - Reading from file tmpfile_stdout 11:36:06 INFO - Output received: 11:36:06 INFO - C:\slave\test\build\application\firefox\firefox.exe 11:36:06 INFO - Using _rmtree_windows ... 11:36:06 INFO - Using _rmtree_windows ... 11:36:06 INFO - Running post-action listener: _resource_record_post_action 11:36:06 INFO - ##### 11:36:06 INFO - ##### Running run-tests step. 11:36:06 INFO - ##### 11:36:06 INFO - Running pre-action listener: _resource_record_pre_action 11:36:06 INFO - Running main action method: run_tests 11:36:06 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version'] 11:36:06 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version 11:36:06 INFO - Python 2.7.3 11:36:06 INFO - Return code: 0 11:36:06 INFO - grabbing minidump binary from tooltool 11:36:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:06 INFO - retry: Calling run_command with args: (['c:/mozilla-build/python27/python.exe', 'C:/mozilla-build/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', 'c:\\builds\\relengapi.tok', 'fetch', '-m', 'C:\\slave\\test\\build\\tests\\config/tooltool-manifests/win32/releng.manifest', '-o'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01DB8B48>, '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 0x01DDA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0244A660>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1 11:36:06 INFO - Running command: ['c:/mozilla-build/python27/python.exe', 'C:/mozilla-build/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', 'c:\\builds\\relengapi.tok', 'fetch', '-m', 'C:\\slave\\test\\build\\tests\\config/tooltool-manifests/win32/releng.manifest', '-o'] in C:\slave\test\build 11:36:06 INFO - Copy/paste: c:/mozilla-build/python27/python.exe C:/mozilla-build/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file c:\builds\relengapi.tok fetch -m C:\slave\test\build\tests\config/tooltool-manifests/win32/releng.manifest -o 11:36:06 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 11:36:08 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmpbgclsw 11:36:08 INFO - INFO - File integrity verified, renaming tmpbgclsw to win32-minidump_stackwalk.exe 11:36:08 INFO - Return code: 0 11:36:08 INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755 11:36:08 INFO - mkdir: C:\slave\test\build\blobber_upload_dir 11:36:08 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir 11:36:08 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe 11:36:08 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir 11:36:08 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/crWsHE58SGiCcfL51i81JQ/artifacts/public/build/firefox-44.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-118', '--webServer', 'localhost'] in C:\slave\test\build 11:36:08 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\tests\talos\talos\run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath C:\slave\test\build\application\firefox\firefox --symbolsPath https://queue.taskcluster.net/v1/task/crWsHE58SGiCcfL51i81JQ/artifacts/public/build/firefox-44.0a1.en-US.win64.crashreporter-symbols.zip --title T-W864-IX-118 --webServer localhost 11:36:08 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 11:36:08 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-118\\AppData\\Roaming', 11:36:08 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 11:36:08 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 11:36:08 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 11:36:08 INFO - 'COMPUTERNAME': 'T-W864-IX-118', 11:36:08 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 11:36:08 INFO - 'DCLOCATION': 'SCL3', 11:36:08 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 11:36:08 INFO - 'FP_NO_HOST_CHECK': 'NO', 11:36:08 INFO - 'HOMEDRIVE': 'C:', 11:36:08 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-118', 11:36:08 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 11:36:08 INFO - 'KTS_VERSION': '1.19c', 11:36:08 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-118\\AppData\\Local', 11:36:08 INFO - 'LOGONSERVER': '\\\\T-W864-IX-118', 11:36:08 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir', 11:36:08 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe', 11:36:08 INFO - 'MONDIR': 'C:\\Monitor_config\\', 11:36:08 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 11:36:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:08 INFO - 'MOZ_NO_REMOTE': '1', 11:36:08 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir', 11:36:08 INFO - 'NO_EM_RESTART': '1', 11:36:08 INFO - 'NUMBER_OF_PROCESSORS': '8', 11:36:08 INFO - 'OS': 'Windows_NT', 11:36:08 INFO - 'OURDRIVE': 'C:', 11:36:08 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 11:36:08 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 11:36:08 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 11:36:08 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 11:36:08 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 11:36:08 INFO - 'PROCESSOR_LEVEL': '6', 11:36:08 INFO - 'PROCESSOR_REVISION': '1e05', 11:36:08 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 11:36:08 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 11:36:08 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 11:36:08 INFO - 'PROGRAMW6432': 'C:\\Program Files', 11:36:08 INFO - 'PROMPT': '$P$G', 11:36:08 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 11:36:08 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 11:36:08 INFO - 'PUBLIC': 'C:\\Users\\Public', 11:36:08 INFO - 'PWD': 'C:\\slave\\test', 11:36:08 INFO - 'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos', 11:36:08 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 11:36:08 INFO - 'SLAVEDIR': 'C:\\slave\\', 11:36:08 INFO - 'SYSTEMDRIVE': 'C:', 11:36:08 INFO - 'SYSTEMROOT': 'C:\\windows', 11:36:08 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:36:08 INFO - 'TEST1': 'testie', 11:36:08 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:36:08 INFO - 'USERDOMAIN': 'T-W864-IX-118', 11:36:08 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-118', 11:36:08 INFO - 'USERNAME': 'cltbld', 11:36:08 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-118', 11:36:08 INFO - 'WINDIR': 'C:\\windows', 11:36:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 11:36:08 INFO - Calling ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/crWsHE58SGiCcfL51i81JQ/artifacts/public/build/firefox-44.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-118', '--webServer', 'localhost'] with output_timeout 3600 ProcessManager NOT managing child processes ProcessManager UNABLE to use job objects to manage child processes 11:36:09 INFO - mozversion INFO | application_buildid: 20151026104938 11:36:09 INFO - mozversion INFO | application_changeset: b842ef4420f1b247ab9706ce8d5028c8bca52ecd 11:36:09 INFO - mozversion INFO | application_display_name: Nightly 11:36:09 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:36:09 INFO - mozversion INFO | application_name: Firefox 11:36:09 INFO - mozversion INFO | application_remotingname: firefox 11:36:09 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 11:36:09 INFO - mozversion INFO | application_vendor: Mozilla 11:36:09 INFO - mozversion INFO | application_version: 44.0a1 11:36:09 INFO - mozversion INFO | platform_buildid: 20151026104938 11:36:09 INFO - mozversion INFO | platform_changeset: b842ef4420f1b247ab9706ce8d5028c8bca52ecd 11:36:09 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 11:36:09 INFO - mozversion INFO | platform_version: 44.0a1 11:36:09 INFO - 2015-10-26 11:36:09,647 DEBUG : using testdate: 1445884569 11:36:09 INFO - 2015-10-26 11:36:09,647 DEBUG : actual date: 1445884569 11:36:09 INFO - 2015-10-26 11:36:09,979 INFO : starting webserver on 'localhost:49281' 11:36:09 INFO - 2015-10-26 11:36:09,980 INFO : Starting test suite T-W864-IX-118 11:36:09 INFO - 2015-10-26 11:36:09,980 INFO : Starting test dromaeo_css 11:36:09 INFO - 2015-10-26 11:36:09,980 DEBUG : operating with platform_type : w8_ 11:36:09 INFO - 2015-10-26 11:36:09,980 INFO : Initialising browser for dromaeo_css test... 11:36:10 INFO - 2015-10-26 11:36:10,065 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmp9r7muc\profile http://localhost:49281/getInfo.html 11:36:18 INFO - 2015-10-26 11:36:18,700 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:36:18 INFO - 2015-10-26 11:36:18,700 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:36:18 INFO - 2015-10-26 11:36:18,700 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674 11:36:18 INFO - 2015-10-26 11:36:18,700 DEBUG : BROWSER_OUTPUT: __metrics 11:36:18 INFO - 2015-10-26 11:36:18,822 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:36:19 INFO - 2015-10-26 11:36:19,559 DEBUG : BROWSER_OUTPUT: console.error: 11:36:19 INFO - 2015-10-26 11:36:19,563 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] 11:36:19 INFO - 2015-10-26 11:36:19,563 DEBUG : BROWSER_OUTPUT: Stack: 11:36:19 INFO - 2015-10-26 11:36:19,563 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<._executeStatement@resource://gre/modules/Sqlite.jsm:758:19 11:36:19 INFO - 2015-10-26 11:36:19,563 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached/<@resource://gre/modules/Sqlite.jsm:493:9 11:36:19 INFO - 2015-10-26 11:36:19,563 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached@resource://gre/modules/Sqlite.jsm:491:1 11:36:19 INFO - 2015-10-26 11:36:19,563 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeBeforeShutdown/loggedDb<.executeCached.value<@resource://gre/modules/Sqlite.jsm:368:51 11:36:19 INFO - 2015-10-26 11:36:19,563 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 11:36:19 INFO - 2015-10-26 11:36:19,563 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 11:36:19 INFO - 2015-10-26 11:36:19,563 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 11:36:19 INFO - 2015-10-26 11:36:19,563 DEBUG : BROWSER_OUTPUT: setAncestorsLastModified<@resource://gre/modules/Bookmarks.jsm:1347:9 11:36:19 INFO - 2015-10-26 11:36:19,563 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 11:36:19 INFO - 2015-10-26 11:36:19,563 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 11:36:19 INFO - 2015-10-26 11:36:19,563 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 11:36:19 INFO - 2015-10-26 11:36:19,565 DEBUG : BROWSER_OUTPUT: transaction@resource://gre/modules/Bookmarks.jsm:808:13 11:36:19 INFO - 2015-10-26 11:36:19,565 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 11:36:19 INFO - 2015-10-26 11:36:19,565 DEBUG : BROWSER_OUTPUT: Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:934:23 11:36:19 INFO - 2015-10-26 11:36:19,565 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 11:36:19 INFO - 2015-10-26 11:36:19,565 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 11:36:19 INFO - 2015-10-26 11:36:19,565 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 11:36:19 INFO - 2015-10-26 11:36:19,565 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 11:36:19 INFO - 2015-10-26 11:36:19,565 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 11:36:19 INFO - 2015-10-26 11:36:19,565 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 11:36:19 INFO - 2015-10-26 11:36:19,565 DEBUG : BROWSER_OUTPUT: 11:36:20 INFO - 2015-10-26 11:36:20,358 INFO : Browser initialized. 11:36:20 INFO - 2015-10-26 11:36:20,358 INFO : Running cycle 1/1 for dromaeo_css test... 11:36:20 INFO - 2015-10-26 11:36:20,358 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmp9r7muc\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:36:31 INFO - 2015-10-26 11:36:31,938 DEBUG : BROWSER_OUTPUT: RSS: Main: 177201152 11:36:31 INFO - 2015-10-26 11:36:31,938 DEBUG : BROWSER_OUTPUT: 11:37:23 INFO - 2015-10-26 11:37:23,240 DEBUG : BROWSER_OUTPUT: 1445884643237 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] 11:39:32 INFO - 2015-10-26 11:39:32,525 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49281/tests/dromaeo/cssquery-ext.html) 11:39:33 INFO - 2015-10-26 11:39:33,653 DEBUG : BROWSER_OUTPUT: RSS: Main: 251125760 11:39:33 INFO - 2015-10-26 11:39:33,653 DEBUG : BROWSER_OUTPUT: 11:42:36 INFO - 2015-10-26 11:42:36,838 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-ext.html (next: http://localhost:49281/tests/dromaeo/cssquery-jquery.html) 11:42:37 INFO - 2015-10-26 11:42:37,401 DEBUG : BROWSER_OUTPUT: RSS: Main: 224751616 11:42:37 INFO - 2015-10-26 11:42:37,401 DEBUG : BROWSER_OUTPUT: 11:45:39 INFO - 2015-10-26 11:45:39,782 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49281/tests/dromaeo/cssquery-mootools.html) 11:45:40 INFO - 2015-10-26 11:45:40,345 DEBUG : BROWSER_OUTPUT: RSS: Main: 171978752 11:45:40 INFO - 2015-10-26 11:45:40,345 DEBUG : BROWSER_OUTPUT: 11:48:42 INFO - 2015-10-26 11:48:42,555 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49281/tests/dromaeo/cssquery-prototype.html) 11:48:43 INFO - 2015-10-26 11:48:43,125 DEBUG : BROWSER_OUTPUT: RSS: Main: 165376000 11:48:43 INFO - 2015-10-26 11:48:43,125 DEBUG : BROWSER_OUTPUT: 11:51:46 INFO - 2015-10-26 11:51:46,108 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49281/tests/dromaeo/cssquery-yui.html) 11:51:46 INFO - 2015-10-26 11:51:46,693 DEBUG : BROWSER_OUTPUT: RSS: Main: 167563264 11:51:46 INFO - 2015-10-26 11:51:46,693 DEBUG : BROWSER_OUTPUT: 11:54:49 INFO - 2015-10-26 11:54:49,742 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-yui.html (next: http://localhost:49281/tests/dromaeo/cssquery-dojo.html) 11:54:49 INFO - 2015-10-26 11:54:49,993 DEBUG : BROWSER_OUTPUT: RSS: Main: 235593728 11:54:49 INFO - 2015-10-26 11:54:49,993 DEBUG : BROWSER_OUTPUT: 11:54:49 INFO - 2015-10-26 11:54:49,994 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:54:49 INFO - 2015-10-26 11:54:49,994 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:54:49 INFO - 2015-10-26 11:54:49,994 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:54:50 INFO - 2015-10-26 11:54:49,994 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:54:50 INFO - 2015-10-26 11:54:49,994 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2547.5032368688107;2574.8712564371776;2601.2716439396963;2610.2169349195237;2618.437036037252;4865.635077369198;4870.196417591093;4871.318015477836;4885.462599114095;4929.457759646445;4882.951170488294;4885.60915126789;4888.657793954425;4889.731064791435;4953.876153096166;4198.790060496963;4342.066455712022;4409.118176364724;4441.600255976961;4490.326451032355;4341.153475072362;4356.976110614003;4361.9345709814215;4362.17118747437;4362.760048197348;4266.509351424579;4278.122984788111;4296.462942132233;4354.499232588246;4393;4359.782010899442;4382.364557139229;4401;4407.735535867826;4459.241928872099;3935.153941902476;4297.656187504992;4360.21516127097;4376.934345984812;4433.445819272591;4622.422197225347;4706.694064885772;4708.223143181371;4713.976430117862;4756.357891684613;5021.246812978083;5038.949610503884;5052.797888084472;5061.949380506185;5117.1556693145585;4795.640326975491;4959.876003099916;5070.264811602334;5081.872953176163;5085.288059671649;4497.775111244458;4630.930536041962;4632.814687412466;4634.467036290802;4687.1797435449;5132.849039705473;5164.122099243138;5184.766685499086;5188.63679542436;5236.502532259429;4732.077244937204;4860.80556777732;4974.8756281093265;4982.975085124624;4986.301917731521;4888.120138375127;4912.484189160086;4921.655484116149;4993.076280888047;4996.625253106032;4989.80040798364;5013.5989120870245;5015.172496538104;5016.0971025215085;5071.847844564669;4733.148033354029;4893.339399181136;4966.975165124223;4967.950320496821;5025.422076461181;3287.589051368579;3334.4664853623303;3337.365900478901;3369.612494563157;3377.966220337765;3068.2022674104446;3069.754419646423;3072.5391191321482;3106;3109.2693217093965;4459.420275364182;4643.674942753974;4670.78981445829;4683.601893838993;4727.57451829337;4945.455999840015;5021.5229553192385;5025.7989680412375;5026.773795179226;5062.215356619729;4654.138984287918;4680.3447517347595;4690;4694.81220751173;4715.504871988461;4069;4142.565030671796;4215.0305429750715;4223.894402639959;4250.017373348318;4912.091263116335;4933.679310844784;4944.554990050912;4964.1809101498575;4972.0801651694555;4841.322214889848;5034.496550345083;5045.7981680732355;5087.186050231945;5116.360454943132;4839.370881785486;4961.231009193581;5052.545270925634;5054.898902022012;5083.771230294719;4868.683535570177;4912.729799861042;4916.975415122902;4934.210526315772;4991.775370108427;5063.569596584184;5067.5185857343495;5095.082885080721;5098.413682426569;5160.767765450489;4713.57577817998;4781.258904869751;4943.752812359439;4984.825531106394;4993.575546078624;4746.335513028248;4782.473927868002;4888.291197776373;4890.119778439773;4923.704577725348;4858.854234372974;4874.488178741323;4897.5193086795;4901.6323775716255;4908.9754551227015;4628.699134556243;4832.492588278321;4971.403431588233;4976.850694479172;5031.446540880574;4762.238041913277;4821.132196204717;4825.855224343275;4862.246351815475;4865.829695960624 11:54:50 INFO - 2015-10-26 11:54:49,994 DEBUG : BROWSER_OUTPUT: |1;ext.html;554.8529639645493;557.3673880146033;565.8726786473044;567.9801206957754;581.9272590926134;30012.249693757665;30698.693013069864;30717.232069198282;36964.630353696455;37209.62790372095;39233.803830980876;39765.40351894724;40088.79955600218;40119.59880401195;40159.79920100395;8262.339012878956;8434.0722520523;8561.116554358032;8566.828663426728;8584.8712269316;7654.272844079804;7905.367570594367;10346.068853803155;10601.522931468102;10602.098821600173;10350.637727679532;10480.528376223088;10496.632617858377;10509.369437833717;10524.31591946521;7773.5335879846825;8004.599770011534;10133.290669653128;10265.230107741912;10265.435401052939;10359.94820025895;10606.098481629071;10615.57537698491;10626.203034772423;10627.734306642318;38173.80913095445;38686.419703704465;38689.41965870514;38766.80616596899;38775.418368724495;2918.8832446702318;2933.6186295781413;2967.688392718755;2980.985095074511;3605.693516051139;28785.56821647677;29058.854705726335;29144.854275728696;29314;29594.70405295941;2491.302435318114;2499.52509023285;2508.3603681061395;2537.708163561177;2566.6021766626204;226111;230039;230844;231236.84381578153;231407.8429607858;50207.49792502028;52157.478425216024;53302.46697533053;54115.45884541104;54228;49675.75162124166;49783.502164978614;49793.75103124534;49841.50158498441;50148.74925625422;12596.433160507799;12939.09426340166;12971.805422918664;13001.414936327888;13003.414846331938;9647.71056868295;9656.22750179984;9733.075357840993;9736.123748862636;9767.902320976842;17740.645187096186;17868.46394608164;17872.106394680213;17913.552161196076;17915.193816278297;7536.359409450149;7824.9608751955875;7828.138904720477;7885.526868387915;7913.841723165505;796.4862663581957;797.9361651067901;804.8511025460308;922.7508572685338;934.756963189562;26257;26406.6039009415;26427;26457.735422645528;26808.32979175497;871.7036207689289;880.1374652840252;899.5142622983516;900.7432881628836;924.5885580916562;13859.653508662162;13895.529017222208;13950.790738138936;14077.225752583501;14130.293485325692;271020;275466;277736;278495;279371;47039.5296047042;47347.76326118416;47530.76234618874;47610;47611.285830712564;1033.204432586919;1172.1033409441613;1249.7937840256257;1274.6558429224058;1288.1884412819863;25528.61707074358;26444.603330949667;26653.604114703805;26676.59985100186;26847.731522684524;42186.78906605447;42589.787051064544;42728.78635606802;43031;43064.78467607642;218420;219870;288148;289461;298033;27837.582436263066;27958.3010424741;28036.299092522033;28526.85736571304;29336.853315733286;35337.64662353344;35565.28869422649;35821.91027525379;36226;36363.636363636026;29806.25484362908;30681;32179.356412871144;34460.48309275413;36786.63213367832;32926.83536582302;33268.334633307684;33581.664183357854;33621.83189084137;33879.153021174665;32210.516842247853;33280.334393312485;33440.33119337551;33561;33562.49656255207;29021.419571608873;30419.695803041686;30516.542251865794;30556.694433056273;30559.388812223187;23580;23723.970389841015;23760;24013.879930600237;24049.278521644377 11:54:50 INFO - 2015-10-26 11:54:50,000 DEBUG : BROWSER_OUTPUT: |2;jquery.html;344.8875636725059;347.9582450105988;349.86005597760874;355.16890476285505;356.4866592107364;12643.810342844841;13074;14982.550523484299;15342.616434589141;16604.667906641876;12553.937230313859;14887.92556037221;15151.090934543936;15183.848161518381;15653;5087.236914462823;5218.32161818963;5231.241469986869;5237.423883372826;5241.685498870061;3872.593377695344;3982.2234664240486;5185.196294574347;5213.061648903196;5566.304211973504;5643.548516118701;5662.462066103713;5681.914771278434;5686.118651609007;5686.459786320293;5535.363433205172;5652.886942261152;5653.689047102408;5667.886642267132;5674.319081710221;4853.587445067174;4883.19427294496;4915.361003069614;4925.926111108336;4936.037472692827;17643.911780441143;18703.34538291167;18777.779444336073;19122.80877191224;19347;1841.162271166616;1930.5077205312555;1959.177145598852;2021.2925476083253;2102.8948552572465;8229.300509456703;8459.619317130744;8527.74416767498;8565.357598180162;8644.394892357537;1542.8842836787173;1610.1063909530205;1625.4798464491369;1627.8616317613016;1628.7556866470006;45602;45604;45881.08237835224;46252.84367890796;46264.768676156404;5698.62958907678;5725.799597014167;5755.309362876398;5767.657213562895;5794.62334948227;6765.594064356154;6839.332660262502;6840.760573379908;6847.726090956406;6860.485463590251;4436.735530373828;4447.533009034069;4531.456225252925;4532.5694059064335;4532.5694059064335;4607.677462577654;4615.100055489214;4615.376924115269;4617.884552886205;4620.722756634613;2616.7252438494065;2636.5517861963513;2687.7715394191323;2688.8655567221563;2692.0443242648576;966.9129778319985;990.8365119755304;1026.1329176845554;1036.5957276662107;1048.4705223862054;388.2642392665882;400.56138528311453;403.17550609004655;410.386472224027;416.1012213618569;9975.451350175665;10299.12457441111;10324.587016519255;10358.741031474123;10487.857296367893;381.8167279705701;394.35129212445366;407.74719673802434;416.24036134055467;421.4668444417814;5297.973510132501;5502.614816962854;5516.255305533782;5536.446355364431;5582.720863956786;381482;392421.45471271814;392849;407358;411559;51142.23286650703;53710.7314463433;54363.45636543663;54481.45518544764;55184.896302073736;461.3011287898836;465.32527834639234;470.1912710138556;470.935685351109;472.1077164159741;7332.816679583053;8726.30189584819;9234.769130771785;9458.479783611692;9478.194353480032;26912.596311054956;27014.32464188411;27293.72706272912;28057;28269.858650706614;35343.82328088343;35694.10764730902;35869.1032724184;35887.46168807522;36049.70856702921;5615.747291371817;5656.123300888369;5694.658768480197;5717.056685646821;5741.856453588526;2485.2668462803153;8419.36854735885;10476.109530689977;10676.46617669098;10746.140308775122;9119.726408207764;9370.906290937277;9396.812063758549;9401.739113161617;9429.15137637616;8904.332175086765;9117.863232051392;9317.44095354281;9439.386439881386;9605.615775368908;9474.95262523683;9492.145706886413;9811.460369679451;9822.361546499455;9828.754281143028;5624.831255062355;5639.069553523623;5702.429757024264;5710.914336285042;5731.684757338387;9117.726468205965;9128.315376346933;9238.95380523093;9399.53002349866;9426 11:54:50 INFO - 2015-10-26 11:54:50,002 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1337.6722702937782;1424.1383962702569;1652.206940668479;1654.2721202670823;1834.972475412868;7690.615469226537;8205.958970205149;8317.792055198623;8358.080611132771;8365.749027529177;8409.495430274188;8464.576771161448;8472.618732157052;8489.575521223946;8509.91490085099;1859.302761464451;1873.2600622754003;2093.9895300523513;2118.353902059871;2186.180182431588;2217.168561789329;2228.019671344611;2230.7657695941934;2231.542533780571;2232.6427771556555;2092.1213090502024;2173.0438607012943;2174;2187.599936040935;2196.099599164343;1904.980950190501;1930.9324173653924;2145.570885822826;2161.3515945216373;2176.465591757807;2127.3830589129134;2180.160638154306;2208.6907832903407;2210.690503329535;2225.3991422316044;8492.575371231414;8536.146385361477;8568.785780355478;8631.827363452758;8634.956825215897;4970.900581988376;5068.341115654941;5069.391672999227;5070.619703522214;5071.797128114871;2865.2550336912345;2962.4371369439737;2965.777566682486;2994.296340360014;2995.1912983494335;788.5150632361114;790.4427378698005;795.3637090327715;796.665400531778;813.3168138763467;12379.814302785466;12513.436895339732;12522.686932826753;12526.185797923197;12538.749225015448;4250.468691413574;4276.5723427656985;4323.437953066082;4335.111302183045;4340.348947657877;9877.901220987698;9883.357581757164;9896.10935015852;9912.950435247922;9955.55200016001;4816.277558366203;4890.168671325883;4896.975515122402;4904.558589726942;4904.901901961941;4407.42703448556;4471.910561788746;4474.753888536162;4479.865604031885;4481.551844815557;3461.4461686130603;3472.8958131256104;3481.1993241554583;3494.930101397958;3520.7359448041498;1021.065724861758;1026.8767747870154;1030.0729343590679;1048.3605000949415;1048.743057950807;1301.4078594239597;1305.11252348404;1324.8145259663654;1331.17467170355;1340.061956630343;8071.717489887826;8096.595170241464;8230.62962166704;8236.135205803424;8277.213664701843;435.72331569453627;442.80073966715105;446.2102079319586;446.3995925480224;446.4999200895018;6128.448439640454;6188.783392581238;6214.782482613087;6221.5333849961435;6233.719482623293;10057.295989280827;10623.787524249472;10631.627893023708;10648;10675.466226688635;9943.850842237372;10490.527926243338;10495.317804342692;10557.841632375521;10573.788524229472;7558.357539609085;7587.506812057199;7662.310392064629;7681.615919204018;7699.884501732478;7595.658195381332;7660.961695191489;7679.155292917663;7711.228877112244;7719.845603087794;8734.344924130588;8958.776030599287;8966.955165224132;8984.86522702173;9015.549222538715;9175.954120229622;9247.352685312233;9253.53732313395;9262.768430789285;9445.574949127444;6925.27284635106;7005.579665220103;7015.824604384727;7018.5788852669;7025.964870175617;8190.253380387727;8252;8393.034800997963;8415.368847336353;8418.747437576883;6256;7854.764357069297;7880.763577092696;7937.166597507409;7942.08666003417;7537.2462753724185;7569.3566046886635;7581;7682.769516914502;7721.575313357819;7548.471606987678;7574.96212518956;7608.695652173851;7620.80947976305;7626.54240745557;6926.238113807376;6976.232614412512;6980.197277313174;7002.229754727078;7134.892976605459;7228.241034691282;7331.340179383881;7333.816654583678;7334.486585938933;7347.008153899369 11:54:50 INFO - 2015-10-26 11:54:50,003 DEBUG : BROWSER_OUTPUT: |4;prototype.html;317.3906100287448;325.3980136747018;326.663536557346;332.44979558830136;332.9117783787297;5031.74841257937;5073.492650734925;5087.66930149541;5098.209777484487;5101.7194054327;4828.034393121372;4905.926411103827;4943.752812359386;5029.220470827018;5045.243213517974;3880.1269714314335;3926.5877082906313;3933.606639336058;3941.054147004727;3945.881623551291;3874.883753487386;3948.3287841066945;3948.7038472114564;3954.110325176841;3967.3453880109746;3902.2195560887935;3902.570717221103;3966.2464131814863;3968.9801550992206;3969.2458432897656;3947.624975627311;3958.2479328927698;3962.7424217425773;3969.622885825842;3987.202559488114;3474.322507111114;3491.773034752733;3521.1725244567506;3521.876734314312;3525.2773181497732;4882.3408839806525;4883.511648835123;4888.5111488850835;4892.046051020053;4903.068417000758;4311.137772445523;4407.559244075599;4408.448943882015;4431.0251744616135;4452.465704115527;5085.974570127126;5148.742562871841;5155.922661160085;5161.045206636784;5171.276021357013;3668.3396988542054;3669.486271921933;3677.613850545681;3679.7976111314133;3689.5756987946193;5312.681239125626;5380.139177731544;5384.6769193848495;5385;5387.649802762847;3654.744167908274;3682.6685598295744;3683.4106542953;3776.9433458498142;3778;3732.1789206374556;3766.7363284569815;3840.231953609289;3848.7883166426113;3858.0354911272184;4351.5430879757805;4358.21552120615;4374.431323927933;4381;4391.934120988188;5103.923441148386;5126.564242039469;5145.639805213674;5153.1497302945345;5153.819616313486;1367.7401293754156;1377.7657798174334;1378.0284899146077;1382.4332023870165;1388.7500249955106;939.3893968920256;941.6045260990401;966.3573723473952;966.840471322238;970.8592254123254;4883.267509873547;4913.533214344631;4952.08386448501;4957.975210123926;4958.950410495849;5414.40441551429;5420.214068959979;5421.186821976735;5421.2681288025615;5424.403315635277;4948.529889660476;4949;4962.801487940442;4965.379327584052;4974.850754477371;2869.827810331387;2949.277427030391;2980.448617005861;2987.1038688393396;2987.6116104906223;5346.064438723208;5398.379186393615;5416.0792665247;5417.404085550586;5421.810236641778;5468.316460442445;5503.449655034545;5515.448455154453;5536.667799932017;5539.806106786243;5339.759710813023;5376.220448035091;5389.191621256843;5402.810901618424;5414.025475414305;5256.342957130359;5373.194020896896;5401.432849550741;5404.83785486436;5417.972910135424;5206.921896171636;5269.736513174403;5290.074237008431;5290.497402746733;5291.894162116659;5390.407055224001;5399.136138217867;5399.487048730364;5407.378151512627;5410;3833.769973801581;3838.0404898775305;3846.4038074098557;3846.846126155034;3848.5958974307296;5240.08298547745;5248.08158572256;5253.317068781187;5339.599530035185;5380.892382152413;5222.55608273301;5234.712090835041;5234.947650523446;5236.947630523646;5241.475852414728;5185.377754669313;5208.453112423293;5232.529072383504;5238.842834714965;5241.030409374278;5025.7989680412375;5130.179171332569;5162.561182299396;5162.716050617102;5163.948360516347;5187.221916712523;5207.401148867929;5249.89500209986;5251.133562962221;5257.4216836147225;5174.870628234325;5176.792928282826;5179.145441002343;5185.455527169593;5188.455212202664 11:54:50 INFO - 2015-10-26 11:54:50,003 DEBUG : BROWSER_OUTPUT: |5;yui.html;714.014659769518;811.9878201826974;816.8611336072867;827.2389401750389;834.3575446905883;11408.600698975528;11561.364124973123;11581.478833452495;11586.826197607032;11610.477528511215;10967.232293739442;11080.778384432306;11137.72155696108;11185.944070279636;11195.664130076111;668.9632070236136;680.1022650101868;812.7968007998;820.7127505373131;824.389951435936;817.2562967699395;818.100089901107;818.5988865455913;822.7778499805049;823.3989187892842;703.9788806335819;857.7212405968054;861.0915484164204;862.3532350736947;866.8569686001803;702.459106488004;847.7838151271417;852.6802449081595;855.670566831768;855.9529225892574;625.5183508698323;636.3382082634055;636.3699937062321;636.462189449914;636.8185067255856;11167.944160279229;11262.099032077414;11305.943470282678;11319.377434241114;11328;8399.790005249917;8583.656653733844;8664.046954834963;10232.795344093076;10933.726656833564;8127.431079824415;8163.877541836877;8272.462289951194;8274.503529788231;8327.8334433311;2851.0716284691102;2861.141657502741;2865.28367908023;2910.621619189513;2920.985395073032;31415;31581.8420907894;31807.681923180702;31888.362232755448;32015.359692806247;6019.939800602026;6076.270847498328;6142.877142457126;6180.289266734383;6302.369763023661;9439.339246252697;9446.622135114518;9457.054294570487;9463.391223492023;9464.19554337889;5111.105556527593;5226.686398816083;5251.264822924793;5450.591205659592;5505.697186654773;3344.1639590102473;3356.7314614830757;3410.6759857813468;3473.6999850142465;3474.0147887781113;2326.3718795925006;2342.4026873147577;2349.9647505287435;2351.059576169546;2351.2005917987967;363.28614272953774;369.2541067044555;373.4230613701783;373.9046543131484;374.6328597974001;481.37661728062244;483.9540243676845;489.83590497183843;622.7011034703368;649.8440374310226;7617.428692848059;7659;7745;7811.101723301893;7844.882326765103;559.9916001259984;645.8159424563977;669.7521916890685;669.7588868007514;671.1040760584674;3374.5444365010408;3427.537282466885;3519.753617246768;3563.376409128392;3889.9805500972316;39914.201715965515;39933.40099898504;40163.39754903679;40166.799166003984;40202;34761.65238347584;35039.82480087583;35181.19510280775;35248;35256.29487410237;29359.853200733858;29491.85254073716;29528.409431811244;29719.959801406847;29901.25246868802;7150;7283.817904552428;7304.817379565553;7539.509931854412;7547.584882831277;21431.785682142978;21641.242556510446;21699.674504882754;21782.346529604136;22111.557768844854;28092.85953570219;28111.71888281173;28148;28235.57646635261;28340.291492712848;6552.6068435894;6580;6645.734170633314;6763.526553141233;6764.492663050192;10357.948210259203;10403.58385664565;10477.633282835064;10564.313319634199;10674.092702120097;10018.1985441166;10036.046575575308;10171.694849154537;10466.319689220176;10550.208734344802;10226;10330.535125919201;10518.947405262925;10649.787004259717;10669.46652667348;10187.439690817077;10241.283110182514;10291.639792607222;10406.115480183966;10413.166946644098;8639.345489012547;8724.258438032839;8748.69379571712;8792.868106978272;9009;7994;8296.502209867185;8500.829983400421;8557.48655080697;8691.826163476822 11:54:50 INFO - 2015-10-26 11:54:50,005 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:54:50 INFO - 2015-10-26 11:54:50,005 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:54:50 INFO - 2015-10-26 11:54:50,006 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,896 11:54:50 INFO - 2015-10-26 11:54:50,006 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:54:50 INFO - 2015-10-26 11:54:50,006 DEBUG : BROWSER_OUTPUT: __startTimestamp1445885689993__endTimestamp 11:54:50 INFO - 2015-10-26 11:54:50,006 DEBUG : BROWSER_OUTPUT: 11:54:50 INFO - 2015-10-26 11:54:50,006 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:54:50 INFO - 2015-10-26 11:54:50,006 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:54:50 INFO - 2015-10-26 11:54:50,006 DEBUG : BROWSER_OUTPUT: 11:54:50 INFO - 2015-10-26 11:54:50,006 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4628.03 Median:4865.64 stddev:586.86 (12.1%) stddev-sans-first:565.51 11:54:50 INFO - 2015-10-26 11:54:50,006 DEBUG : BROWSER_OUTPUT: Values: 2547.5 2574.9 2601.3 2610.2 2618.4 4865.6 4870.2 4871.3 4885.5 4929.5 4883.0 4885.6 4888.7 4889.7 4953.9 4198.8 4342.1 4409.1 4441.6 4490.3 4341.2 4357.0 4361.9 4362.2 4362.8 4266.5 4278.1 4296.5 4354.5 4393.0 4359.8 4382.4 4401.0 4407.7 4459.2 3935.2 4297.7 4360.2 4376.9 4433.4 4622.4 4706.7 4708.2 4714.0 4756.4 5021.2 5038.9 5052.8 5061.9 5117.2 4795.6 4959.9 5070.3 5081.9 5085.3 4497.8 4630.9 4632.8 4634.5 4687.2 5132.8 5164.1 5184.8 5188.6 5236.5 4732.1 4860.8 4974.9 4983.0 4986.3 4888.1 4912.5 4921.7 4993.1 4996.6 4989.8 5013.6 5015.2 5016.1 5071.8 4733.1 4893.3 4967.0 4968.0 5025.4 3287.6 3334.5 3337.4 3369.6 3378.0 3068.2 3069.8 3072.5 3106.0 3109.3 4459.4 4643.7 4670.8 4683.6 4727.6 4945.5 5021.5 5025.8 5026.8 5062.2 4654.1 4680.3 4690.0 4694.8 4715.5 4069.0 4142.6 4215.0 4223.9 4250.0 4912.1 4933.7 4944.6 4964.2 4972.1 4841.3 5034.5 5045.8 5087.2 5116.4 4839.4 4961.2 5052.5 5054.9 5083.8 4868.7 4912.7 4917.0 4934.2 4991.8 5063.6 5067.5 5095.1 5098.4 5160.8 4713.6 4781.3 4943.8 4984.8 4993.6 4746.3 4782.5 4888.3 4890.1 4923.7 4858.9 4874.5 4897.5 4901.6 4909.0 4628.7 4832.5 4971.4 4976.9 5031.4 4762.2 4821.1 4825.9 4862.2 4865.8 11:54:50 INFO - 2015-10-26 11:54:50,006 DEBUG : BROWSER_OUTPUT: 11:54:50 INFO - 2015-10-26 11:54:50,006 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41469.95 Median:30558.04 stddev:67207.75 (219.9%) stddev-sans-first:67326.07 11:54:50 INFO - 2015-10-26 11:54:50,006 DEBUG : BROWSER_OUTPUT: Values: 554.9 557.4 565.9 568.0 581.9 30012.2 30698.7 30717.2 36964.6 37209.6 39233.8 39765.4 40088.8 40119.6 40159.8 8262.3 8434.1 8561.1 8566.8 8584.9 7654.3 7905.4 10346.1 10601.5 10602.1 10350.6 10480.5 10496.6 10509.4 10524.3 7773.5 8004.6 10133.3 10265.2 10265.4 10359.9 10606.1 10615.6 10626.2 10627.7 38173.8 38686.4 38689.4 38766.8 38775.4 2918.9 2933.6 2967.7 2981.0 3605.7 28785.6 29058.9 29144.9 29314.0 29594.7 2491.3 2499.5 2508.4 2537.7 2566.6 226111.0 230039.0 230844.0 231236.8 231407.8 50207.5 52157.5 53302.5 54115.5 54228.0 49675.8 49783.5 49793.8 49841.5 50148.7 12596.4 12939.1 12971.8 13001.4 13003.4 9647.7 9656.2 9733.1 9736.1 9767.9 17740.6 17868.5 17872.1 17913.6 17915.2 7536.4 7825.0 7828.1 7885.5 7913.8 796.5 797.9 804.9 922.8 934.8 26257.0 26406.6 26427.0 26457.7 26808.3 871.7 880.1 899.5 900.7 924.6 13859.7 13895.5 13950.8 14077.2 14130.3 271020.0 275466.0 277736.0 278495.0 279371.0 47039.5 47347.8 47530.8 47610.0 47611.3 1033.2 1172.1 1249.8 1274.7 1288.2 25528.6 26444.6 26653.6 26676.6 26847.7 42186.8 42589.8 42728.8 43031.0 43064.8 218420.0 219870.0 288148.0 289461.0 298033.0 27837.6 27958.3 28036.3 28526.9 29336.9 35337.6 35565.3 35821.9 36226.0 36363.6 29806.3 30681.0 32179.4 34460.5 36786.6 32926.8 33268.3 33581.7 33621.8 33879.2 32210.5 33280.3 33440.3 33561.0 33562.5 29021.4 30419.7 30516.5 30556.7 30559.4 23580.0 23724.0 23760.0 24013.9 24049.3 11:54:50 INFO - 2015-10-26 11:54:50,006 DEBUG : BROWSER_OUTPUT: 11:54:50 INFO - 2015-10-26 11:54:50,006 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:20983.35 Median:470.56 stddev:64916.55 (13795.5%) stddev-sans-first:65080.16 11:54:50 INFO - 2015-10-26 11:54:50,006 DEBUG : BROWSER_OUTPUT: Values: 344.9 348.0 349.9 355.2 356.5 12643.8 13074.0 14982.6 15342.6 16604.7 12553.9 14887.9 15151.1 15183.8 15653.0 5087.2 5218.3 5231.2 5237.4 5241.7 3872.6 3982.2 5185.2 5213.1 5566.3 5643.5 5662.5 5681.9 5686.1 5686.5 5535.4 5652.9 5653.7 5667.9 5674.3 4853.6 4883.2 4915.4 4925.9 4936.0 17643.9 18703.3 18777.8 19122.8 19347.0 1841.2 1930.5 1959.2 2021.3 2102.9 8229.3 8459.6 8527.7 8565.4 8644.4 1542.9 1610.1 1625.5 1627.9 1628.8 45602.0 45604.0 45881.1 46252.8 46264.8 5698.6 5725.8 5755.3 5767.7 5794.6 6765.6 6839.3 6840.8 6847.7 6860.5 4436.7 4447.5 4531.5 4532.6 4532.6 4607.7 4615.1 4615.4 4617.9 4620.7 2616.7 2636.6 2687.8 2688.9 2692.0 966.9 990.8 1026.1 1036.6 1048.5 388.3 400.6 403.2 410.4 416.1 9975.5 10299.1 10324.6 10358.7 10487.9 381.8 394.4 407.7 416.2 421.5 5298.0 5502.6 5516.3 5536.4 5582.7 381482.0 392421.5 392849.0 407358.0 411559.0 51142.2 53710.7 54363.5 54481.5 55184.9 461.3 465.3 470.2 470.9 472.1 7332.8 8726.3 9234.8 9458.5 9478.2 26912.6 27014.3 27293.7 28057.0 28269.9 35343.8 35694.1 35869.1 35887.5 36049.7 5615.7 5656.1 5694.7 5717.1 5741.9 2485.3 8419.4 10476.1 10676.5 10746.1 9119.7 9370.9 9396.8 9401.7 9429.2 8904.3 9117.9 9317.4 9439.4 9605.6 9475.0 9492.1 9811.5 9822.4 9828.8 5624.8 5639.1 5702.4 5710.9 5731.7 9117.7 9128.3 9239.0 9399.5 9426.0 11:54:50 INFO - 2015-10-26 11:54:50,009 DEBUG : BROWSER_OUTPUT: 11:54:50 INFO - 2015-10-26 11:54:50,009 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5830.67 Median:6201.78 stddev:3270.01 (52.7%) stddev-sans-first:3261.75 11:54:50 INFO - 2015-10-26 11:54:50,009 DEBUG : BROWSER_OUTPUT: Values: 1337.7 1424.1 1652.2 1654.3 1835.0 7690.6 8206.0 8317.8 8358.1 8365.7 8409.5 8464.6 8472.6 8489.6 8509.9 1859.3 1873.3 2094.0 2118.4 2186.2 2217.2 2228.0 2230.8 2231.5 2232.6 2092.1 2173.0 2174.0 2187.6 2196.1 1905.0 1930.9 2145.6 2161.4 2176.5 2127.4 2180.2 2208.7 2210.7 2225.4 8492.6 8536.1 8568.8 8631.8 8635.0 4970.9 5068.3 5069.4 5070.6 5071.8 2865.3 2962.4 2965.8 2994.3 2995.2 788.5 790.4 795.4 796.7 813.3 12379.8 12513.4 12522.7 12526.2 12538.7 4250.5 4276.6 4323.4 4335.1 4340.3 9877.9 9883.4 9896.1 9913.0 9955.6 4816.3 4890.2 4897.0 4904.6 4904.9 4407.4 4471.9 4474.8 4479.9 4481.6 3461.4 3472.9 3481.2 3494.9 3520.7 1021.1 1026.9 1030.1 1048.4 1048.7 1301.4 1305.1 1324.8 1331.2 1340.1 8071.7 8096.6 8230.6 8236.1 8277.2 435.7 442.8 446.2 446.4 446.5 6128.4 6188.8 6214.8 6221.5 6233.7 10057.3 10623.8 10631.6 10648.0 10675.5 9943.9 10490.5 10495.3 10557.8 10573.8 7558.4 7587.5 7662.3 7681.6 7699.9 7595.7 7661.0 7679.2 7711.2 7719.8 8734.3 8958.8 8967.0 8984.9 9015.5 9176.0 9247.4 9253.5 9262.8 9445.6 6925.3 7005.6 7015.8 7018.6 7026.0 8190.3 8252.0 8393.0 8415.4 8418.7 6256.0 7854.8 7880.8 7937.2 7942.1 7537.2 7569.4 7581.0 7682.8 7721.6 7548.5 7575.0 7608.7 7620.8 7626.5 6926.2 6976.2 6980.2 7002.2 7134.9 7228.2 7331.3 7333.8 7334.5 7347.0 11:54:50 INFO - 2015-10-26 11:54:50,009 DEBUG : BROWSER_OUTPUT: 11:54:50 INFO - 2015-10-26 11:54:50,010 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4395.12 Median:5038.50 stddev:1268.11 (25.2%) stddev-sans-first:1234.18 11:54:50 INFO - 2015-10-26 11:54:50,010 DEBUG : BROWSER_OUTPUT: Values: 317.4 325.4 326.7 332.4 332.9 5031.7 5073.5 5087.7 5098.2 5101.7 4828.0 4905.9 4943.8 5029.2 5045.2 3880.1 3926.6 3933.6 3941.1 3945.9 3874.9 3948.3 3948.7 3954.1 3967.3 3902.2 3902.6 3966.2 3969.0 3969.2 3947.6 3958.2 3962.7 3969.6 3987.2 3474.3 3491.8 3521.2 3521.9 3525.3 4882.3 4883.5 4888.5 4892.0 4903.1 4311.1 4407.6 4408.4 4431.0 4452.5 5086.0 5148.7 5155.9 5161.0 5171.3 3668.3 3669.5 3677.6 3679.8 3689.6 5312.7 5380.1 5384.7 5385.0 5387.6 3654.7 3682.7 3683.4 3776.9 3778.0 3732.2 3766.7 3840.2 3848.8 3858.0 4351.5 4358.2 4374.4 4381.0 4391.9 5103.9 5126.6 5145.6 5153.1 5153.8 1367.7 1377.8 1378.0 1382.4 1388.8 939.4 941.6 966.4 966.8 970.9 4883.3 4913.5 4952.1 4958.0 4959.0 5414.4 5420.2 5421.2 5421.3 5424.4 4948.5 4949.0 4962.8 4965.4 4974.9 2869.8 2949.3 2980.4 2987.1 2987.6 5346.1 5398.4 5416.1 5417.4 5421.8 5468.3 5503.4 5515.4 5536.7 5539.8 5339.8 5376.2 5389.2 5402.8 5414.0 5256.3 5373.2 5401.4 5404.8 5418.0 5206.9 5269.7 5290.1 5290.5 5291.9 5390.4 5399.1 5399.5 5407.4 5410.0 3833.8 3838.0 3846.4 3846.8 3848.6 5240.1 5248.1 5253.3 5339.6 5380.9 5222.6 5234.7 5234.9 5236.9 5241.5 5185.4 5208.5 5232.5 5238.8 5241.0 5025.8 5130.2 5162.6 5162.7 5163.9 5187.2 5207.4 5249.9 5251.1 5257.4 5174.9 5176.8 5179.1 5185.5 5188.5 11:54:50 INFO - 2015-10-26 11:54:50,012 DEBUG : BROWSER_OUTPUT: 11:54:50 INFO - 2015-10-26 11:54:50,012 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:9938.45 Median:40184.40 stddev:10449.54 (26.0%) stddev-sans-first:10455.89 11:54:50 INFO - 2015-10-26 11:54:50,012 DEBUG : BROWSER_OUTPUT: Values: 714.0 812.0 816.9 827.2 834.4 11408.6 11561.4 11581.5 11586.8 11610.5 10967.2 11080.8 11137.7 11185.9 11195.7 669.0 680.1 812.8 820.7 824.4 817.3 818.1 818.6 822.8 823.4 704.0 857.7 861.1 862.4 866.9 702.5 847.8 852.7 855.7 856.0 625.5 636.3 636.4 636.5 636.8 11167.9 11262.1 11305.9 11319.4 11328.0 8399.8 8583.7 8664.0 10232.8 10933.7 8127.4 8163.9 8272.5 8274.5 8327.8 2851.1 2861.1 2865.3 2910.6 2921.0 31415.0 31581.8 31807.7 31888.4 32015.4 6019.9 6076.3 6142.9 6180.3 6302.4 9439.3 9446.6 9457.1 9463.4 9464.2 5111.1 5226.7 5251.3 5450.6 5505.7 3344.2 3356.7 3410.7 3473.7 3474.0 2326.4 2342.4 2350.0 2351.1 2351.2 363.3 369.3 373.4 373.9 374.6 481.4 484.0 489.8 622.7 649.8 7617.4 7659.0 7745.0 7811.1 7844.9 560.0 645.8 669.8 669.8 671.1 3374.5 3427.5 3519.8 3563.4 3890.0 39914.2 39933.4 40163.4 40166.8 40202.0 34761.7 35039.8 35181.2 35248.0 35256.3 29359.9 29491.9 29528.4 29720.0 29901.3 7150.0 7283.8 7304.8 7539.5 7547.6 21431.8 21641.2 21699.7 21782.3 22111.6 28092.9 28111.7 28148.0 28235.6 28340.3 6552.6 6580.0 6645.7 6763.5 6764.5 10357.9 10403.6 10477.6 10564.3 10674.1 10018.2 10036.0 10171.7 10466.3 10550.2 10226.0 10330.5 10518.9 10649.8 10669.5 10187.4 10241.3 10291.6 10406.1 10413.2 8639.3 8724.3 8748.7 8792.9 9009.0 7994.0 8296.5 8500.8 8557.5 8691.8 11:54:50 INFO - 2015-10-26 11:54:50,013 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:54:50 INFO - 2015-10-26 11:54:50,013 DEBUG : BROWSER_OUTPUT: 11:54:50 INFO - 2015-10-26 11:54:50,650 INFO : Browser exited with error code: 0 11:54:51 INFO - 2015-10-26 11:54:51,384 INFO : Completed test dromaeo_css (00:18:41) 11:54:51 INFO - 2015-10-26 11:54:51,384 INFO : Starting test kraken 11:54:51 INFO - 2015-10-26 11:54:51,384 DEBUG : operating with platform_type : w8_ 11:54:51 INFO - 2015-10-26 11:54:51,384 INFO : Initialising browser for kraken test... 11:54:51 INFO - 2015-10-26 11:54:51,404 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmp3qd6vq\profile http://localhost:49281/getInfo.html 11:54:57 INFO - 2015-10-26 11:54:57,690 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:54:57 INFO - 2015-10-26 11:54:57,690 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:54:57 INFO - 2015-10-26 11:54:57,690 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674 11:54:57 INFO - 2015-10-26 11:54:57,690 DEBUG : BROWSER_OUTPUT: __metrics 11:54:57 INFO - 2015-10-26 11:54:57,851 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:54:58 INFO - 2015-10-26 11:54:58,098 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 11:54:58 INFO - 2015-10-26 11:54:58,309 DEBUG : BROWSER_OUTPUT: console.error: 11:54:58 INFO - 2015-10-26 11:54:58,309 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] 11:54:58 INFO - 2015-10-26 11:54:58,309 DEBUG : BROWSER_OUTPUT: Stack: 11:54:58 INFO - 2015-10-26 11:54:58,309 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<._executeStatement@resource://gre/modules/Sqlite.jsm:758:19 11:54:58 INFO - 2015-10-26 11:54:58,309 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached/<@resource://gre/modules/Sqlite.jsm:493:9 11:54:58 INFO - 2015-10-26 11:54:58,309 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached@resource://gre/modules/Sqlite.jsm:491:1 11:54:58 INFO - 2015-10-26 11:54:58,309 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeBeforeShutdown/loggedDb<.executeCached.value<@resource://gre/modules/Sqlite.jsm:368:51 11:54:58 INFO - 2015-10-26 11:54:58,309 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 11:54:58 INFO - 2015-10-26 11:54:58,309 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 11:54:58 INFO - 2015-10-26 11:54:58,309 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 11:54:58 INFO - 2015-10-26 11:54:58,309 DEBUG : BROWSER_OUTPUT: setAncestorsLastModified<@resource://gre/modules/Bookmarks.jsm:1347:9 11:54:58 INFO - 2015-10-26 11:54:58,309 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 11:54:58 INFO - 2015-10-26 11:54:58,309 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 11:54:58 INFO - 2015-10-26 11:54:58,309 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 11:54:58 INFO - 2015-10-26 11:54:58,309 DEBUG : BROWSER_OUTPUT: transaction@resource://gre/modules/Bookmarks.jsm:808:13 11:54:58 INFO - 2015-10-26 11:54:58,309 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 11:54:58 INFO - 2015-10-26 11:54:58,309 DEBUG : BROWSER_OUTPUT: Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:934:23 11:54:58 INFO - 2015-10-26 11:54:58,309 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 11:54:58 INFO - 2015-10-26 11:54:58,309 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 11:54:58 INFO - 2015-10-26 11:54:58,309 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 11:54:58 INFO - 2015-10-26 11:54:58,309 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 11:54:58 INFO - 2015-10-26 11:54:58,309 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 11:54:58 INFO - 2015-10-26 11:54:58,309 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 11:54:58 INFO - 2015-10-26 11:54:58,309 DEBUG : BROWSER_OUTPUT: 11:54:59 INFO - 2015-10-26 11:54:59,026 INFO : Browser initialized. 11:54:59 INFO - 2015-10-26 11:54:59,026 INFO : Running cycle 1/1 for kraken test... 11:54:59 INFO - 2015-10-26 11:54:59,026 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmp3qd6vq\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\kraken\kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:55:10 INFO - 2015-10-26 11:55:10,608 DEBUG : BROWSER_OUTPUT: RSS: Main: 183635968 11:55:10 INFO - 2015-10-26 11:55:10,608 DEBUG : BROWSER_OUTPUT: 11:55:13 INFO - 2015-10-26 11:55:13,319 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-beat-detection) 11:55:13 INFO - 2015-10-26 11:55:13,901 DEBUG : BROWSER_OUTPUT: RSS: Main: 220704768 11:55:13 INFO - 2015-10-26 11:55:13,901 DEBUG : BROWSER_OUTPUT: 11:55:16 INFO - 2015-10-26 11:55:16,619 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-dft) 11:55:17 INFO - 2015-10-26 11:55:17,194 DEBUG : BROWSER_OUTPUT: RSS: Main: 219611136 11:55:17 INFO - 2015-10-26 11:55:17,194 DEBUG : BROWSER_OUTPUT: 11:55:19 INFO - 2015-10-26 11:55:19,901 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-fft) 11:55:20 INFO - 2015-10-26 11:55:20,477 DEBUG : BROWSER_OUTPUT: RSS: Main: 205242368 11:55:20 INFO - 2015-10-26 11:55:20,477 DEBUG : BROWSER_OUTPUT: 11:55:22 INFO - 2015-10-26 11:55:22,467 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-oscillator) 11:55:23 INFO - 2015-10-26 11:55:23,051 DEBUG : BROWSER_OUTPUT: RSS: Main: 200921088 11:55:23 INFO - 2015-10-26 11:55:23,051 DEBUG : BROWSER_OUTPUT: 11:55:25 INFO - 2015-10-26 11:55:25,243 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49281/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:55:25 INFO - 2015-10-26 11:55:25,805 DEBUG : BROWSER_OUTPUT: RSS: Main: 204660736 11:55:25 INFO - 2015-10-26 11:55:25,805 DEBUG : BROWSER_OUTPUT: 11:55:28 INFO - 2015-10-26 11:55:28,888 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49281/tests/kraken/driver.html?testName=imaging-darkroom) 11:55:29 INFO - 2015-10-26 11:55:29,463 DEBUG : BROWSER_OUTPUT: RSS: Main: 198504448 11:55:29 INFO - 2015-10-26 11:55:29,463 DEBUG : BROWSER_OUTPUT: 11:55:32 INFO - 2015-10-26 11:55:32,834 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49281/tests/kraken/driver.html?testName=imaging-desaturate) 11:55:33 INFO - 2015-10-26 11:55:33,411 DEBUG : BROWSER_OUTPUT: RSS: Main: 193376256 11:55:33 INFO - 2015-10-26 11:55:33,411 DEBUG : BROWSER_OUTPUT: 11:55:36 INFO - 2015-10-26 11:55:36,303 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49281/tests/kraken/driver.html?testName=json-parse-financial) 11:55:36 INFO - 2015-10-26 11:55:36,880 DEBUG : BROWSER_OUTPUT: RSS: Main: 193228800 11:55:36 INFO - 2015-10-26 11:55:36,880 DEBUG : BROWSER_OUTPUT: 11:55:38 INFO - 2015-10-26 11:55:38,664 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49281/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:55:39 INFO - 2015-10-26 11:55:39,227 DEBUG : BROWSER_OUTPUT: RSS: Main: 222535680 11:55:39 INFO - 2015-10-26 11:55:39,227 DEBUG : BROWSER_OUTPUT: 11:55:41 INFO - 2015-10-26 11:55:41,150 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:55:41 INFO - 2015-10-26 11:55:41,723 DEBUG : BROWSER_OUTPUT: RSS: Main: 227528704 11:55:41 INFO - 2015-10-26 11:55:41,723 DEBUG : BROWSER_OUTPUT: 11:55:44 INFO - 2015-10-26 11:55:44,019 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:55:44 INFO - 2015-10-26 11:55:44,601 DEBUG : BROWSER_OUTPUT: RSS: Main: 233357312 11:55:44 INFO - 2015-10-26 11:55:44,601 DEBUG : BROWSER_OUTPUT: 11:55:47 INFO - 2015-10-26 11:55:47,170 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:55:47 INFO - 2015-10-26 11:55:47,756 DEBUG : BROWSER_OUTPUT: RSS: Main: 235704320 11:55:47 INFO - 2015-10-26 11:55:47,756 DEBUG : BROWSER_OUTPUT: 11:55:50 INFO - 2015-10-26 11:55:50,549 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:55:51 INFO - 2015-10-26 11:55:51,131 DEBUG : BROWSER_OUTPUT: RSS: Main: 236474368 11:55:51 INFO - 2015-10-26 11:55:51,131 DEBUG : BROWSER_OUTPUT: 11:55:52 INFO - 2015-10-26 11:55:52,948 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49281/tests/kraken/driver.html?testName=ai-astar) 11:55:53 INFO - 2015-10-26 11:55:53,198 DEBUG : BROWSER_OUTPUT: RSS: Main: 291373056 11:55:53 INFO - 2015-10-26 11:55:53,200 DEBUG : BROWSER_OUTPUT: 11:55:53 INFO - 2015-10-26 11:55:53,200 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:55:53 INFO - 2015-10-26 11:55:53,200 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:55:53 INFO - 2015-10-26 11:55:53,200 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:55:53 INFO - 2015-10-26 11:55:53,200 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:55:53 INFO - 2015-10-26 11:55:53,200 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;112;106;111;112;113;111;112;106;112 11:55:53 INFO - 2015-10-26 11:55:53,200 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;139;132;149;159;132;135;137;135;166;134 11:55:53 INFO - 2015-10-26 11:55:53,200 DEBUG : BROWSER_OUTPUT: |2;audio-dft;142;143;141;149;140;141;140;143;140;140 11:55:53 INFO - 2015-10-26 11:55:53,200 DEBUG : BROWSER_OUTPUT: |3;audio-fft;69;73;70;95;68;70;69;71;101;67 11:55:53 INFO - 2015-10-26 11:55:53,200 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;91;112;91;91;91;117;91;91;118 11:55:53 INFO - 2015-10-26 11:55:53,200 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;111;110;110;111;111;110;110;110;110 11:55:53 INFO - 2015-10-26 11:55:53,200 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;131;131;133;132;131;132;131;131;132;131 11:55:53 INFO - 2015-10-26 11:55:53,200 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;96;96;96;96;107;97;96;97;98 11:55:53 INFO - 2015-10-26 11:55:53,200 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;73;73;72;72;72;73;84;73;71 11:55:53 INFO - 2015-10-26 11:55:53,200 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;68;69;69;68;68;69;68;68;69 11:55:53 INFO - 2015-10-26 11:55:53,200 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;90;91;91;91;92;92;92;93;93;93 11:55:53 INFO - 2015-10-26 11:55:53,201 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;125;128;125;134;131;125;131;133;125 11:55:53 INFO - 2015-10-26 11:55:53,201 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;163;153;164;162;163;156;163;164;162;163 11:55:53 INFO - 2015-10-26 11:55:53,201 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;74;75;76;76;75;74;75;75;75;75 11:55:53 INFO - 2015-10-26 11:55:53,201 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:55:53 INFO - 2015-10-26 11:55:53,201 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:55:53 INFO - 2015-10-26 11:55:53,201 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,968 11:55:53 INFO - 2015-10-26 11:55:53,201 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:55:53 INFO - 2015-10-26 11:55:53,201 DEBUG : BROWSER_OUTPUT: __startTimestamp1445885753199__endTimestamp 11:55:53 INFO - 2015-10-26 11:55:53,201 DEBUG : BROWSER_OUTPUT: 11:55:53 INFO - 2015-10-26 11:55:53,203 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:55:53 INFO - 2015-10-26 11:55:53,203 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:55:53 INFO - 2015-10-26 11:55:53,203 DEBUG : BROWSER_OUTPUT: 11:55:53 INFO - 2015-10-26 11:55:53,203 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.90 Median:112.00 stddev:2.73 (2.4%) stddev-sans-first:2.65 11:55:53 INFO - 2015-10-26 11:55:53,203 DEBUG : BROWSER_OUTPUT: Values: 114.0 112.0 106.0 111.0 112.0 113.0 111.0 112.0 106.0 112.0 11:55:53 INFO - 2015-10-26 11:55:53,203 DEBUG : BROWSER_OUTPUT: 11:55:53 INFO - 2015-10-26 11:55:53,203 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.80 Median:138.00 stddev:12.06 (8.7%) stddev-sans-first:12.75 11:55:53 INFO - 2015-10-26 11:55:53,203 DEBUG : BROWSER_OUTPUT: Values: 139.0 132.0 149.0 159.0 132.0 135.0 137.0 135.0 166.0 134.0 11:55:53 INFO - 2015-10-26 11:55:53,203 DEBUG : BROWSER_OUTPUT: 11:55:53 INFO - 2015-10-26 11:55:53,203 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:141.90 Median:141.50 stddev:2.77 (2.0%) stddev-sans-first:2.93 11:55:53 INFO - 2015-10-26 11:55:53,203 DEBUG : BROWSER_OUTPUT: Values: 142.0 143.0 141.0 149.0 140.0 141.0 140.0 143.0 140.0 140.0 11:55:53 INFO - 2015-10-26 11:55:53,203 DEBUG : BROWSER_OUTPUT: 11:55:53 INFO - 2015-10-26 11:55:53,203 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:75.30 Median:70.00 stddev:12.16 (17.4%) stddev-sans-first:12.68 11:55:53 INFO - 2015-10-26 11:55:53,203 DEBUG : BROWSER_OUTPUT: Values: 69.0 73.0 70.0 95.0 68.0 70.0 69.0 71.0 101.0 67.0 11:55:53 INFO - 2015-10-26 11:55:53,203 DEBUG : BROWSER_OUTPUT: 11:55:53 INFO - 2015-10-26 11:55:53,204 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:98.50 Median:91.00 stddev:11.95 (13.1%) stddev-sans-first:12.44 11:55:53 INFO - 2015-10-26 11:55:53,204 DEBUG : BROWSER_OUTPUT: Values: 92.0 91.0 112.0 91.0 91.0 91.0 117.0 91.0 91.0 118.0 11:55:53 INFO - 2015-10-26 11:55:53,207 DEBUG : BROWSER_OUTPUT: 11:55:53 INFO - 2015-10-26 11:55:53,207 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.30 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 11:55:53 INFO - 2015-10-26 11:55:53,207 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 110.0 110.0 111.0 111.0 110.0 110.0 110.0 110.0 11:55:53 INFO - 2015-10-26 11:55:53,207 DEBUG : BROWSER_OUTPUT: 11:55:53 INFO - 2015-10-26 11:55:53,207 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:131.50 Median:131.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 11:55:53 INFO - 2015-10-26 11:55:53,207 DEBUG : BROWSER_OUTPUT: Values: 131.0 131.0 133.0 132.0 131.0 132.0 131.0 131.0 132.0 131.0 11:55:53 INFO - 2015-10-26 11:55:53,207 DEBUG : BROWSER_OUTPUT: 11:55:53 INFO - 2015-10-26 11:55:53,209 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:97.60 Median:96.50 stddev:3.37 (3.5%) stddev-sans-first:3.57 11:55:53 INFO - 2015-10-26 11:55:53,209 DEBUG : BROWSER_OUTPUT: Values: 97.0 96.0 96.0 96.0 96.0 107.0 97.0 96.0 97.0 98.0 11:55:53 INFO - 2015-10-26 11:55:53,209 DEBUG : BROWSER_OUTPUT: 11:55:53 INFO - 2015-10-26 11:55:53,209 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.40 Median:73.00 stddev:3.81 (5.2%) stddev-sans-first:3.94 11:55:53 INFO - 2015-10-26 11:55:53,210 DEBUG : BROWSER_OUTPUT: Values: 71.0 73.0 73.0 72.0 72.0 72.0 73.0 84.0 73.0 71.0 11:55:53 INFO - 2015-10-26 11:55:53,210 DEBUG : BROWSER_OUTPUT: 11:55:53 INFO - 2015-10-26 11:55:53,210 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:69.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 11:55:53 INFO - 2015-10-26 11:55:53,210 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 69.0 69.0 68.0 68.0 69.0 68.0 68.0 69.0 11:55:53 INFO - 2015-10-26 11:55:53,210 DEBUG : BROWSER_OUTPUT: 11:55:53 INFO - 2015-10-26 11:55:53,210 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:91.80 Median:92.00 stddev:1.03 (1.1%) stddev-sans-first:0.87 11:55:53 INFO - 2015-10-26 11:55:53,210 DEBUG : BROWSER_OUTPUT: Values: 90.0 91.0 91.0 91.0 92.0 92.0 92.0 93.0 93.0 93.0 11:55:53 INFO - 2015-10-26 11:55:53,211 DEBUG : BROWSER_OUTPUT: 11:55:53 INFO - 2015-10-26 11:55:53,211 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:129.50 stddev:3.57 (2.8%) stddev-sans-first:3.75 11:55:53 INFO - 2015-10-26 11:55:53,211 DEBUG : BROWSER_OUTPUT: Values: 127.0 125.0 128.0 125.0 134.0 131.0 125.0 131.0 133.0 125.0 11:55:53 INFO - 2015-10-26 11:55:53,211 DEBUG : BROWSER_OUTPUT: 11:55:53 INFO - 2015-10-26 11:55:53,213 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.30 Median:163.00 stddev:3.71 (2.3%) stddev-sans-first:3.89 11:55:53 INFO - 2015-10-26 11:55:53,213 DEBUG : BROWSER_OUTPUT: Values: 163.0 153.0 164.0 162.0 163.0 156.0 163.0 164.0 162.0 163.0 11:55:53 INFO - 2015-10-26 11:55:53,213 DEBUG : BROWSER_OUTPUT: 11:55:53 INFO - 2015-10-26 11:55:53,213 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.00 Median:75.00 stddev:0.67 (0.9%) stddev-sans-first:0.60 11:55:53 INFO - 2015-10-26 11:55:53,213 DEBUG : BROWSER_OUTPUT: Values: 74.0 75.0 76.0 76.0 75.0 74.0 75.0 75.0 75.0 75.0 11:55:53 INFO - 2015-10-26 11:55:53,213 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:55:53 INFO - 2015-10-26 11:55:53,213 DEBUG : BROWSER_OUTPUT: 11:55:53 INFO - 2015-10-26 11:55:53,989 INFO : Browser exited with error code: 0 11:55:54 INFO - 2015-10-26 11:55:54,917 INFO : Completed test kraken (00:01:03) 11:55:54 INFO - 2015-10-26 11:55:54,917 INFO : Starting test v8_7 11:55:54 INFO - 2015-10-26 11:55:54,917 DEBUG : operating with platform_type : w8_ 11:55:54 INFO - 2015-10-26 11:55:54,917 INFO : Initialising browser for v8_7 test... 11:55:54 INFO - 2015-10-26 11:55:54,937 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmp0bvy1t\profile http://localhost:49281/getInfo.html 11:56:00 INFO - 2015-10-26 11:56:00,335 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:56:00 INFO - 2015-10-26 11:56:00,335 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:56:00 INFO - 2015-10-26 11:56:00,335 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674 11:56:00 INFO - 2015-10-26 11:56:00,335 DEBUG : BROWSER_OUTPUT: __metrics 11:56:00 INFO - 2015-10-26 11:56:00,576 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:56:01 INFO - 2015-10-26 11:56:01,615 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 11:56:01 INFO - 2015-10-26 11:56:01,956 DEBUG : BROWSER_OUTPUT: console.error: 11:56:01 INFO - 2015-10-26 11:56:01,956 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] 11:56:01 INFO - 2015-10-26 11:56:01,956 DEBUG : BROWSER_OUTPUT: Stack: 11:56:01 INFO - 2015-10-26 11:56:01,956 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<._executeStatement@resource://gre/modules/Sqlite.jsm:758:19 11:56:01 INFO - 2015-10-26 11:56:01,956 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached/<@resource://gre/modules/Sqlite.jsm:493:9 11:56:01 INFO - 2015-10-26 11:56:01,956 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached@resource://gre/modules/Sqlite.jsm:491:1 11:56:01 INFO - 2015-10-26 11:56:01,956 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeBeforeShutdown/loggedDb<.executeCached.value<@resource://gre/modules/Sqlite.jsm:368:51 11:56:01 INFO - 2015-10-26 11:56:01,956 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 11:56:01 INFO - 2015-10-26 11:56:01,956 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 11:56:01 INFO - 2015-10-26 11:56:01,956 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 11:56:01 INFO - 2015-10-26 11:56:01,956 DEBUG : BROWSER_OUTPUT: transaction@resource://gre/modules/Bookmarks.jsm:783:15 11:56:01 INFO - 2015-10-26 11:56:01,956 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 11:56:01 INFO - 2015-10-26 11:56:01,957 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 11:56:01 INFO - 2015-10-26 11:56:01,957 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 11:56:01 INFO - 2015-10-26 11:56:01,957 DEBUG : BROWSER_OUTPUT: Task_spawn@resource://gre/modules/Task.jsm:164:12 11:56:01 INFO - 2015-10-26 11:56:01,957 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promisedromaeo_css: 5940.84 11:56:38 INFO - RETURN: kraken: 1506.20 11:56:38 INFO - RETURN: v8_7: 20026.95 11:56:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,31]]", "result": "20026.95"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,31]]", "result": "1506.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,31]]", "result": "5940.84"}}} 11:56:38 INFO - Return code: 0 11:56:38 INFO - # TBPL SUCCESS # 11:56:38 INFO - Running post-action listener: _resource_record_post_action 11:56:38 INFO - Running post-run listener: _resource_record_post_run 11:56:40 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 135530496; Write bytes: 389737984; Read time: 1295920; Write time: 4456110 11:56:40 INFO - install - Wall time: 2s; CPU: 13.0%; Read bytes: 0; Write bytes: 738816; Read time: 0; Write time: 720 11:56:40 INFO - run-tests - Wall time: 1233s; CPU: 13.0%; Read bytes: 135530496; Write bytes: 348436480; Read time: 1295920; Write time: 4392360 11:56:40 INFO - Running post-run listener: _upload_blobber_files 11:56:40 INFO - Blob upload gear active. 11:56:40 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:56:40 INFO - Copying logs to upload dir... 11:56:40 INFO - mkdir: C:\slave\test\build\upload\logs program finished with exit code 0 elapsedTime=1450.922000 ========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 24 mins, 15 secs) (at 2015-10-26 11:56:44.857067) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-26 11:56:44.857874) ========= '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-118\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-118 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-118 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-118\AppData\Local LOGONSERVER=\\T-W864-IX-118 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-118 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-118 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-118 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False build_url:https://queue.taskcluster.net/v1/task/crWsHE58SGiCcfL51i81JQ/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/crWsHE58SGiCcfL51i81JQ/artifacts/public/build/firefox-44.0a1.en-US.win64.zip' ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-26 11:56:45.096125) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-26 11:56:45.096771) ========= '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-118\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-118 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-118 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-118\AppData\Local LOGONSERVER=\\T-W864-IX-118 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-118 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-118 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-118 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-26 11:56:45.312807) ========= ========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2015-10-26 11:56:45.313192) ========= ========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2015-10-26 11:56:45.738389) =========