builder: fx-team_win8_64_test-dromaeojs slave: t-w864-ix-155 starttime: 1445524357.43 results: success (0) buildid: 20151022030053 builduid: c9a6f99444de441084afdb289c82560b revision: b84cc63b2aa92b98e987a73b7b339a85788a3ab2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-22 07:32:37.430858) ========= master: http://buildbot-master112.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-22 07:32:37.432327) ========= ========= Started set props: basedir (results: 0, elapsed: 15 secs) (at 2015-10-22 07:32:37.432653) ========= 'cd' in dir C:\slave\test\. (timeout 1200 secs) watching logfiles {} argv: ['cd'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-155\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-155 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-155 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-155\AppData\Local LOGONSERVER=\\T-W864-IX-155 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-155 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-155 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-155 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False C:\slave\test program finished with exit code 0 elapsedTime=0.832000 basedir: 'C:\\slave\\test' ========= Finished set props: basedir (results: 0, elapsed: 15 secs) (at 2015-10-22 07:32:52.611975) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2015-10-22 07:32:52.612320) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2015-10-22 07:32:54.385687) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-22 07:32:54.385992) ========= '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-155\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-155 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-155 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-155\AppData\Local LOGONSERVER=\\T-W864-IX-155 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-155 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-155 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-155 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=0.202000 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-22 07:32:54.603439) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-22 07:32:54.603758) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-22 07:32:54.610876) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-10-22 07:32:54.611255) ========= '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-155\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-155 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-155 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-155\AppData\Local LOGONSERVER=\\T-W864-IX-155 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-155 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-155 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-155 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False --07:32:54-- 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% 10.60 MB/s 07:32:55 (10.60 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.565000 ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-10-22 07:32:56.653890) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2015-10-22 07:32:56.654199) ========= '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-155\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-155 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-155 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-155\AppData\Local LOGONSERVER=\\T-W864-IX-155 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-155 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-155 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-155 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=3.009000 ========= Finished 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2015-10-22 07:33:00.236526) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 9 secs) (at 2015-10-22 07:33:00.236846) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo integration/fx-team --rev b84cc63b2aa92b98e987a73b7b339a85788a3ab2 --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 b84cc63b2aa92b98e987a73b7b339a85788a3ab2 --destination scripts --debug'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-155\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-155 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-155 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-155\AppData\Local LOGONSERVER=\\T-W864-IX-155 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-155 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-155 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-155 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 2015-10-22 07:33:00,595 truncating revision to first 12 chars 2015-10-22 07:33:00,595 Setting DEBUG logging. 2015-10-22 07:33:00,595 attempt 1/10 2015-10-22 07:33:00,595 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b84cc63b2aa9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-10-22 07:33:00,996 unpacking tar archive at: fx-team-b84cc63b2aa9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.997000 ========= Finished 'bash -c ...' (results: 0, elapsed: 9 secs) (at 2015-10-22 07:33:09.298010) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-22 07:33:09.298310) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-22 07:33:10.084813) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-22 07:33:10.085276) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-22 07:33:10.085983) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 24 mins, 25 secs) (at 2015-10-22 07:33:10.086350) ========= '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-155\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-155 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-155 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-155\AppData\Local LOGONSERVER=\\T-W864-IX-155 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-155 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-155 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-155 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 07:33:10 INFO - MultiFileLogger online at 20151022 07:33:10 in C:\slave\test 07:33:10 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 07:33:10 INFO - Dumping config to C:\slave\test\logs\localconfig.json. 07:33:10 INFO - {'append_to_log': False, 07:33:10 INFO - 'base_work_dir': 'C:\\slave\\test', 07:33:10 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:33:10 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt', 07:33:10 INFO - 'branch': 'Fx-Team-Non-PGO', 07:33:10 INFO - 'buildbot_json_path': 'buildprops.json', 07:33:10 INFO - 'config_files': ('talos/windows_config.py',), 07:33:10 INFO - 'default_actions': ('clobber', 07:33:10 INFO - 'read-buildbot-config', 07:33:10 INFO - 'download-and-extract', 07:33:10 INFO - 'populate-webroot', 07:33:10 INFO - 'create-virtualenv', 07:33:10 INFO - 'install', 07:33:10 INFO - 'run-tests'), 07:33:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:33:10 INFO - 'download_minidump_stackwalk': True, 07:33:10 INFO - 'download_symbols': 'ondemand', 07:33:10 INFO - 'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python', 07:33:10 INFO - 'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'), 07:33:10 INFO - 'hg': 'c:/mozilla-build/hg/hg', 07:33:10 INFO - 'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python', 07:33:10 INFO - 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'), 07:33:10 INFO - 'python': 'c:/mozilla-build/python27/python.exe', 07:33:10 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe', 07:33:10 INFO - 'C:/mozilla-build/tooltool.py'), 07:33:10 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe', 07:33:10 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 07:33:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:33:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:33:10 INFO - 'installer_path': 'installer.exe', 07:33:10 INFO - 'log_level': 'info', 07:33:10 INFO - 'log_name': 'talos', 07:33:10 INFO - 'log_to_console': True, 07:33:10 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe', 07:33:10 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe', 07:33:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest', 07:33:10 INFO - 'opt_config_files': (), 07:33:10 INFO - 'pip_index': False, 07:33:10 INFO - 'sps_profile': False, 07:33:10 INFO - 'sps_profile_interval': 0, 07:33:10 INFO - 'suite': 'dromaeojs', 07:33:10 INFO - 'system_bits': '64', 07:33:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:33:10 INFO - 'title': 'T-W864-IX-155', 07:33:10 INFO - 'use_talos_json': True, 07:33:10 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'), 07:33:10 INFO - 'virtualenv_path': 'C:\\slave\\test\\build/venv', 07:33:10 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll', 07:33:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:33:10 INFO - 'work_dir': 'build'} 07:33:10 INFO - ##### 07:33:10 INFO - ##### Running clobber step. 07:33:10 INFO - ##### 07:33:10 INFO - Running pre-action listener: _resource_record_pre_action 07:33:10 INFO - Running main action method: clobber 07:33:10 INFO - rmtree: C:\slave\test\build 07:33:10 INFO - Using _rmtree_windows ... 07:33:10 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1 07:34:15 INFO - Running post-action listener: _resource_record_post_action 07:34:15 INFO - ##### 07:34:15 INFO - ##### Running read-buildbot-config step. 07:34:15 INFO - ##### 07:34:15 INFO - Running pre-action listener: _resource_record_pre_action 07:34:15 INFO - Running main action method: read_buildbot_config 07:34:15 INFO - Using buildbot properties: 07:34:15 INFO - { 07:34:15 INFO - "properties": { 07:34:15 INFO - "buildnumber": 701, 07:34:15 INFO - "product": "firefox", 07:34:15 INFO - "script_repo_revision": "production", 07:34:15 INFO - "builddir": "fx-team_win8_64_test-dromaeojs", 07:34:15 INFO - "repository": "", 07:34:15 INFO - "buildername": "Windows 8 64-bit fx-team talos dromaeojs", 07:34:15 INFO - "buildid": "20151022030053", 07:34:15 INFO - "slavename": "t-w864-ix-155", 07:34:15 INFO - "pgo_build": "False", 07:34:15 INFO - "basedir": "C:\\slave\\test", 07:34:15 INFO - "project": "", 07:34:15 INFO - "platform": "win8_64", 07:34:15 INFO - "master": "http://buildbot-master112.bb.releng.scl3.mozilla.com:8201/", 07:34:15 INFO - "slavebuilddir": "test", 07:34:15 INFO - "scheduler": "tests-fx-team-win64-talos", 07:34:15 INFO - "branch": "fx-team", 07:34:15 INFO - "repo_path": "integration/fx-team", 07:34:15 INFO - "stage_platform": "win64", 07:34:15 INFO - "builduid": "c9a6f99444de441084afdb289c82560b", 07:34:15 INFO - "revision": "b84cc63b2aa92b98e987a73b7b339a85788a3ab2" 07:34:15 INFO - }, 07:34:15 INFO - "sourcestamp": { 07:34:15 INFO - "repository": "", 07:34:15 INFO - "hasPatch": false, 07:34:15 INFO - "project": "", 07:34:15 INFO - "branch": "fx-team-win64-talos", 07:34:15 INFO - "changes": [ 07:34:15 INFO - { 07:34:15 INFO - "category": null, 07:34:15 INFO - "files": [ 07:34:15 INFO - { 07:34:15 INFO - "url": null, 07:34:15 INFO - "name": "https://queue.taskcluster.net/v1/task/9ZIk2BkDSd6gGG8dNDCR4Q/artifacts/public/build/firefox-44.0a1.en-US.win64.zip" 07:34:15 INFO - } 07:34:15 INFO - ], 07:34:15 INFO - "repository": "", 07:34:15 INFO - "rev": "b84cc63b2aa92b98e987a73b7b339a85788a3ab2", 07:34:15 INFO - "who": "cbook@mozilla.com", 07:34:15 INFO - "when": 1445522882, 07:34:15 INFO - "number": 6559823, 07:34:15 INFO - "comments": "Merge m-c to fx-team", 07:34:15 INFO - "project": "", 07:34:15 INFO - "at": "Thu 22 Oct 2015 07:08:02", 07:34:15 INFO - "branch": "fx-team-win64-talos", 07:34:15 INFO - "revlink": "", 07:34:15 INFO - "properties": [ 07:34:15 INFO - [ 07:34:15 INFO - "buildid", 07:34:15 INFO - "20151022030053", 07:34:15 INFO - "Change" 07:34:15 INFO - ], 07:34:15 INFO - [ 07:34:15 INFO - "builduid", 07:34:15 INFO - "c9a6f99444de441084afdb289c82560b", 07:34:15 INFO - "Change" 07:34:15 INFO - ], 07:34:15 INFO - [ 07:34:15 INFO - "pgo_build", 07:34:15 INFO - "False", 07:34:15 INFO - "Change" 07:34:15 INFO - ] 07:34:15 INFO - ], 07:34:15 INFO - "revision": "b84cc63b2aa92b98e987a73b7b339a85788a3ab2" 07:34:15 INFO - } 07:34:15 INFO - ], 07:34:15 INFO - "revision": "b84cc63b2aa92b98e987a73b7b339a85788a3ab2" 07:34:15 INFO - } 07:34:15 INFO - } 07:34:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/9ZIk2BkDSd6gGG8dNDCR4Q/artifacts/public/build/firefox-44.0a1.en-US.win64.zip. 07:34:15 INFO - Running post-action listener: _resource_record_post_action 07:34:15 INFO - ##### 07:34:15 INFO - ##### Running download-and-extract step. 07:34:15 INFO - ##### 07:34:15 INFO - Running pre-action listener: _resource_record_pre_action 07:34:15 INFO - Running main action method: download_and_extract 07:34:15 INFO - mkdir: C:\slave\test\build\tests 07: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')]} 07:34:15 INFO - https://queue.taskcluster.net/v1/task/9ZIk2BkDSd6gGG8dNDCR4Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:34:15 INFO - trying https://queue.taskcluster.net/v1/task/9ZIk2BkDSd6gGG8dNDCR4Q/artifacts/public/build/test_packages.json 07:34:15 INFO - Downloading https://queue.taskcluster.net/v1/task/9ZIk2BkDSd6gGG8dNDCR4Q/artifacts/public/build/test_packages.json to C:\slave\test\build\test_packages.json 07:34:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/9ZIk2BkDSd6gGG8dNDCR4Q/artifacts/public/build/test_packages.json', 'file_name': 'C:\\slave\\test\\build\\test_packages.json'}, attempt #1 07:34:16 INFO - Downloaded 1221 bytes. 07:34:16 INFO - Reading from file C:\slave\test\build\test_packages.json 07:34:16 INFO - Using the following test package requirements: 07:34:16 INFO - {u'common': [u'firefox-44.0a1.en-US.win64.common.tests.zip'], 07:34:16 INFO - u'cppunittest': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 07:34:16 INFO - u'firefox-44.0a1.en-US.win64.cppunittest.tests.zip'], 07:34:16 INFO - u'jittest': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 07:34:16 INFO - u'jsshell-win64.zip'], 07:34:16 INFO - u'mochitest': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 07:34:16 INFO - u'firefox-44.0a1.en-US.win64.mochitest.tests.zip'], 07:34:16 INFO - u'mozbase': [u'firefox-44.0a1.en-US.win64.common.tests.zip'], 07:34:16 INFO - u'reftest': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 07:34:16 INFO - u'firefox-44.0a1.en-US.win64.reftest.tests.zip'], 07:34:16 INFO - u'talos': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 07:34:16 INFO - u'firefox-44.0a1.en-US.win64.talos.tests.zip'], 07:34:16 INFO - u'web-platform': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 07:34:16 INFO - u'firefox-44.0a1.en-US.win64.web-platform.tests.zip'], 07:34:16 INFO - u'webapprt': [u'firefox-44.0a1.en-US.win64.common.tests.zip'], 07:34:16 INFO - u'xpcshell': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 07:34:16 INFO - u'firefox-44.0a1.en-US.win64.xpcshell.tests.zip']} 07:34:16 INFO - Downloading packages: [u'firefox-44.0a1.en-US.win64.common.tests.zip'] for test suite category: common 07:34: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')]} 07:34:16 INFO - https://queue.taskcluster.net/v1/task/9ZIk2BkDSd6gGG8dNDCR4Q/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip matches https://queue.taskcluster.net 07:34:16 INFO - trying https://queue.taskcluster.net/v1/task/9ZIk2BkDSd6gGG8dNDCR4Q/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip 07:34:16 INFO - Downloading https://queue.taskcluster.net/v1/task/9ZIk2BkDSd6gGG8dNDCR4Q/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 07:34:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/9ZIk2BkDSd6gGG8dNDCR4Q/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 07:34:18 INFO - Downloaded 18097285 bytes. 07:34:18 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 07:34:18 INFO - Copy/paste: unzip -q -o C:\slave\test\build\firefox-44.0a1.en-US.win64.common.tests.zip 07:34:18 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 07:35:07 INFO - Return code: 0 07:35:07 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 07:35:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:35:07 INFO - https://queue.taskcluster.net/v1/task/9ZIk2BkDSd6gGG8dNDCR4Q/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip matches https://queue.taskcluster.net 07:35:07 INFO - trying https://queue.taskcluster.net/v1/task/9ZIk2BkDSd6gGG8dNDCR4Q/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip 07:35:07 INFO - Downloading https://queue.taskcluster.net/v1/task/9ZIk2BkDSd6gGG8dNDCR4Q/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 07:35:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/9ZIk2BkDSd6gGG8dNDCR4Q/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 07:35:13 INFO - Downloaded 18097285 bytes. 07:35:13 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win64.common.tests.zip'] in C:\slave\test\build\tests 07:35:13 INFO - Copy/paste: unzip -q -o C:\slave\test\build\firefox-44.0a1.en-US.win64.common.tests.zip 07:35:13 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win64.common.tests.zip'] with output_timeout 1760 ProcessManager UNABLE to use job objects to manage child processes 07:35:36 INFO - Return code: 0 07:35:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:35:36 INFO - https://queue.taskcluster.net/v1/task/9ZIk2BkDSd6gGG8dNDCR4Q/artifacts/public/build/firefox-44.0a1.en-US.win64.talos.tests.zip matches https://queue.taskcluster.net 07:35:36 INFO - trying https://queue.taskcluster.net/v1/task/9ZIk2BkDSd6gGG8dNDCR4Q/artifacts/public/build/firefox-44.0a1.en-US.win64.talos.tests.zip 07:35:36 INFO - Downloading https://queue.taskcluster.net/v1/task/9ZIk2BkDSd6gGG8dNDCR4Q/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 07:35:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/9ZIk2BkDSd6gGG8dNDCR4Q/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 07:35:47 INFO - Downloaded 11131307 bytes. 07:35:47 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 07:35:47 INFO - Copy/paste: unzip -q -o C:\slave\test\build\firefox-44.0a1.en-US.win64.talos.tests.zip 07:35:47 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 07:35:47 INFO - Return code: 0 07:35:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:35:47 INFO - https://queue.taskcluster.net/v1/task/9ZIk2BkDSd6gGG8dNDCR4Q/artifacts/public/build/firefox-44.0a1.en-US.win64.zip matches https://queue.taskcluster.net 07:35:47 INFO - trying https://queue.taskcluster.net/v1/task/9ZIk2BkDSd6gGG8dNDCR4Q/artifacts/public/build/firefox-44.0a1.en-US.win64.zip 07:35:47 INFO - Downloading https://queue.taskcluster.net/v1/task/9ZIk2BkDSd6gGG8dNDCR4Q/artifacts/public/build/firefox-44.0a1.en-US.win64.zip to C:\slave\test\build\firefox-44.0a1.en-US.win64.zip 07:35:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/9ZIk2BkDSd6gGG8dNDCR4Q/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 07:36:03 INFO - Downloaded 54768338 bytes. 07:36:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/9ZIk2BkDSd6gGG8dNDCR4Q/artifacts/public/build/firefox-44.0a1.en-US.win64.zip 07:36:03 INFO - mkdir: C:\slave\test\properties 07:36:03 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url 07:36:03 INFO - Writing to file C:\slave\test\properties\build_url 07:36:03 INFO - Contents: 07:36:03 INFO - build_url:https://queue.taskcluster.net/v1/task/9ZIk2BkDSd6gGG8dNDCR4Q/artifacts/public/build/firefox-44.0a1.en-US.win64.zip 07:36:03 INFO - Running post-action listener: _resource_record_post_action 07:36:03 INFO - Running post-action listener: set_extra_try_arguments 07:36:03 INFO - ##### 07:36:03 INFO - ##### Running populate-webroot step. 07:36:03 INFO - ##### 07:36:03 INFO - Running pre-action listener: _resource_record_pre_action 07:36:03 INFO - Running main action method: populate_webroot 07:36:03 INFO - Guessing talos json url... 07: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')]} 07:36:03 INFO - https://queue.taskcluster.net/v1/task/9ZIk2BkDSd6gGG8dNDCR4Q/artifacts/public/build/firefox-44.0a1.en-US.win64.txt matches https://queue.taskcluster.net 07:36:03 INFO - trying https://queue.taskcluster.net/v1/task/9ZIk2BkDSd6gGG8dNDCR4Q/artifacts/public/build/firefox-44.0a1.en-US.win64.txt 07:36:03 INFO - Downloading https://queue.taskcluster.net/v1/task/9ZIk2BkDSd6gGG8dNDCR4Q/artifacts/public/build/firefox-44.0a1.en-US.win64.txt to C:\slave\test\build\firefox-44.0a1.en-US.win64.txt 07:36:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/9ZIk2BkDSd6gGG8dNDCR4Q/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 07:36:05 INFO - Downloaded 103 bytes. 07:36:05 INFO - Reading from file C:\slave\test\build\firefox-44.0a1.en-US.win64.txt 07:36:05 INFO - Contents: 07:36:05 INFO - 20151022030053 07:36:05 INFO - https://hg.mozilla.org/integration/fx-team/rev/b84cc63b2aa92b98e987a73b7b339a85788a3ab2 07:36:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:05 INFO - trying https://hg.mozilla.org/integration/fx-team/raw-file/b84cc63b2a/testing/talos/talos.json 07:36:05 INFO - Downloading https://hg.mozilla.org/integration/fx-team/raw-file/b84cc63b2a/testing/talos/talos.json to C:\slave\test\build\talos.json 07:36:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/fx-team/raw-file/b84cc63b2a/testing/talos/talos.json', 'file_name': 'C:\\slave\\test\\build\\talos.json'}, attempt #1 07:36:06 INFO - Downloaded 4264 bytes. 07:36:06 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']}, 07:36:06 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']}, 07:36:06 INFO - u'remote-trobocheck2': {u'talos_options': [u'--fennecIDs', 07:36:06 INFO - u'../fennec_ids.txt'], 07:36:06 INFO - u'tests': [u'tcheck2']}, 07:36:06 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome', 07:36:06 INFO - u'--tppagecycles', 07:36:06 INFO - u'7'], 07:36:06 INFO - u'tests': [u'tsvgm']}}, 07:36:06 INFO - u'suites': {u'chromez': {u'tests': [u'tresize', u'tcanvasmark']}, 07:36:06 INFO - u'chromez-e10s': {u'talos_options': [u'--e10s'], 07:36:06 INFO - u'tests': [u'tresize', u'tcanvasmark']}, 07:36:06 INFO - u'dromaeojs': {u'tests': [u'dromaeo_css', u'kraken', u'v8_7']}, 07:36:06 INFO - u'dromaeojs-e10s': {u'talos_options': [u'--e10s'], 07:36:06 INFO - u'tests': [u'dromaeo_css', 07:36:06 INFO - u'kraken', 07:36:06 INFO - u'v8_7']}, 07:36:06 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:06 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 07:36:06 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:06 INFO - u'talos_options': [u'--e10s'], 07:36:06 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 07:36:06 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:06 INFO - u'tests': [u'damp', u'tps']}, 07:36:06 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:06 INFO - u'talos_options': [u'--e10s'], 07:36:06 INFO - u'tests': [u'damp', u'tps']}, 07:36:06 INFO - u'g3': {u'tests': [u'dromaeo_dom']}, 07:36:06 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']}, 07:36:06 INFO - u'other': {u'tests': [u'a11yr', 07:36:06 INFO - u'ts_paint', 07:36:06 INFO - u'tpaint', 07:36:06 INFO - u'sessionrestore', 07:36:06 INFO - u'sessionrestore_no_auto_restore']}, 07:36:06 INFO - u'other-e10s': {u'talos_options': [u'--e10s'], 07:36:06 INFO - u'tests': [u'a11yr', 07:36:06 INFO - u'ts_paint', 07:36:06 INFO - u'tpaint', 07:36:06 INFO - u'sessionrestore', 07:36:06 INFO - u'sessionrestore_no_auto_restore']}, 07:36:06 INFO - u'other-e10s_l64': {u'talos_options': [u'--e10s'], 07:36:06 INFO - u'tests': [u'a11yr', 07:36:06 INFO - u'ts_paint', 07:36:06 INFO - u'tpaint', 07:36:06 INFO - u'sessionrestore', 07:36:06 INFO - u'sessionrestore_no_auto_restore']}, 07:36:06 INFO - u'other-e10s_nol64': {u'talos_options': [u'--e10s'], 07:36:06 INFO - u'tests': [u'a11yr', 07:36:06 INFO - u'ts_paint', 07:36:06 INFO - u'tpaint', 07:36:06 INFO - u'sessionrestore', 07:36:06 INFO - u'sessionrestore_no_auto_restore']}, 07:36:06 INFO - u'other_l64': {u'tests': [u'a11yr', 07:36:06 INFO - u'ts_paint', 07:36:06 INFO - u'tpaint', 07:36:06 INFO - u'sessionrestore', 07:36:06 INFO - u'sessionrestore_no_auto_restore']}, 07:36:06 INFO - u'other_nol64': {u'tests': [u'a11yr', 07:36:06 INFO - u'ts_paint', 07:36:06 INFO - u'tpaint', 07:36:06 INFO - u'sessionrestore', 07:36:06 INFO - u'sessionrestore_no_auto_restore']}, 07:36:06 INFO - u'svgr': {u'tests': [u'tsvgx', 07:36:06 INFO - u'tsvgr_opacity', 07:36:06 INFO - u'tart', 07:36:06 INFO - u'tscrollx', 07:36:06 INFO - u'cart']}, 07:36:06 INFO - u'svgr-e10s': {u'talos_options': [u'--e10s'], 07:36:06 INFO - u'tests': [u'tsvgx', 07:36:06 INFO - u'tsvgr_opacity', 07:36:06 INFO - u'tart', 07:36:06 INFO - u'tscrollx', 07:36:06 INFO - u'cart']}, 07:36:06 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:06 INFO - u'tests': [u'tp5o']}, 07:36:06 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:06 INFO - u'talos_options': [u'--e10s'], 07:36:06 INFO - u'tests': [u'tp5o']}, 07:36:06 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:06 INFO - u'talos_options': [u'--xperf_path', 07:36:06 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:36:06 INFO - u'tests': [u'tp5n']}, 07:36:06 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:06 INFO - u'talos_options': [u'--e10s', 07:36:06 INFO - u'--xperf_path', 07:36:06 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 07:36:06 INFO - u'C:/slave/talos-data/talos/xperf.config'], 07:36:06 INFO - u'tests': [u'tp5n']}}, 07:36:06 INFO - u'talos.zip': {u'path': u'', 07:36:06 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:36:06 INFO - Running post-action listener: _resource_record_post_action 07:36:06 INFO - ##### 07:36:06 INFO - ##### Running create-virtualenv step. 07:36:06 INFO - ##### 07:36:06 INFO - Running pre-action listener: _resource_record_pre_action 07:36:06 INFO - Running main action method: create_virtualenv 07:36:06 INFO - Creating virtualenv C:\slave\test\build/venv 07:36:06 INFO - mkdir: C:\slave\test\build\venv\Scripts 07:36:06 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll 07:36:06 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'! 07:36:06 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 07:36:06 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build/venv 07:36:08 INFO - New python executable in C:\slave\test\build/venv\Scripts\python.exe 07:36:10 INFO - Installing distribute......................................................................................................................................................................................done. 07:36:11 INFO - Return code: 0 07:36:11 INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv 07:36:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:11 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0236FB10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02331EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02409BF8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01D58B48>, '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 0x01D7A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023EA660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-155', 'USERDOMAIN': 'T-W864-IX-155', '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-155', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-155', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-155', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-155', '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-155\\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 07:36:12 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in C:\slave\test\build 07:36:12 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --download-cache C:\slave\test\build/venv\cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:36:12 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 07:36:12 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Roaming', 07:36:12 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 07:36:12 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 07:36:12 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 07:36:12 INFO - 'COMPUTERNAME': 'T-W864-IX-155', 07:36:12 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 07:36:12 INFO - 'DCLOCATION': 'SCL3', 07:36:12 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 07:36:12 INFO - 'FP_NO_HOST_CHECK': 'NO', 07:36:12 INFO - 'HOMEDRIVE': 'C:', 07:36:12 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-155', 07:36:12 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 07:36:12 INFO - 'KTS_VERSION': '1.19c', 07:36:12 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local', 07:36:12 INFO - 'LOGONSERVER': '\\\\T-W864-IX-155', 07:36:12 INFO - 'MONDIR': 'C:\\Monitor_config\\', 07:36:12 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 07:36:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:12 INFO - 'MOZ_NO_REMOTE': '1', 07:36:12 INFO - 'NO_EM_RESTART': '1', 07:36:12 INFO - 'NUMBER_OF_PROCESSORS': '8', 07:36:12 INFO - 'OS': 'Windows_NT', 07:36:12 INFO - 'OURDRIVE': 'C:', 07:36:12 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 07:36:12 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 07:36:12 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 07:36:12 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 07:36:12 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 07:36:12 INFO - 'PROCESSOR_LEVEL': '6', 07:36:12 INFO - 'PROCESSOR_REVISION': '1e05', 07:36:12 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 07:36:12 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 07:36:12 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 07:36:12 INFO - 'PROGRAMW6432': 'C:\\Program Files', 07:36:12 INFO - 'PROMPT': '$P$G', 07:36:12 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 07:36:12 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 07:36:12 INFO - 'PUBLIC': 'C:\\Users\\Public', 07:36:12 INFO - 'PWD': 'C:\\slave\\test', 07:36:12 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 07:36:12 INFO - 'SLAVEDIR': 'C:\\slave\\', 07:36:12 INFO - 'SYSTEMDRIVE': 'C:', 07:36:12 INFO - 'SYSTEMROOT': 'C:\\windows', 07:36:12 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 07:36:12 INFO - 'TEST1': 'testie', 07:36:12 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 07:36:12 INFO - 'USERDOMAIN': 'T-W864-IX-155', 07:36:12 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-155', 07:36:12 INFO - 'USERNAME': 'cltbld', 07:36:12 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-155', 07:36:12 INFO - 'WINDIR': 'C:\\windows', 07:36:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 07:36:14 INFO - Ignoring indexes: http://pypi.python.org/simple/ 07:36:14 INFO - Downloading/unpacking pip>=1.5 07:36:14 INFO - Creating supposed download cache at C:\slave\test\build/venv\cache 07:36:22 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 07:36:22 INFO - Running setup.py egg_info for package pip 07:36:22 INFO - warning: no files found matching 'pip\cacert.pem' 07:36:22 INFO - warning: no files found matching '*.html' under directory 'docs' 07:36:22 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 07:36:22 INFO - no previously-included directories found matching 'docs\_build\_sources' 07:36:22 INFO - Installing collected packages: pip 07:36:22 INFO - Found existing installation: pip 0.8.2 07:36:22 INFO - Uninstalling pip: 07:36:22 INFO - Successfully uninstalled pip 07:36:22 INFO - Running setup.py install for pip 07:36:22 INFO - warning: no files found matching 'pip\cacert.pem' 07:36:22 INFO - warning: no files found matching '*.html' under directory 'docs' 07:36:22 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 07:36:22 INFO - no previously-included directories found matching 'docs\_build\_sources' 07:36:22 INFO - Installing pip-script.py script to C:\slave\test\build\venv\Scripts 07:36:22 INFO - Installing pip.exe script to C:\slave\test\build\venv\Scripts 07:36:22 INFO - Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts 07:36:22 INFO - Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts 07:36:22 INFO - Installing pip2-script.py script to C:\slave\test\build\venv\Scripts 07:36:22 INFO - Installing pip2.exe script to C:\slave\test\build\venv\Scripts 07:36:22 INFO - Successfully installed pip 07:36:22 INFO - Cleaning up... 07:36:22 INFO - Return code: 0 07:36:22 INFO - Installing psutil>=0.7.1 into virtualenv C:\slave\test\build/venv 07:36:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:22 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 0x0236FB10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02331EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02409BF8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01D58B48>, '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 0x01D7A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023EA660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-155', 'USERDOMAIN': 'T-W864-IX-155', '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-155', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-155', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-155', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-155', '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-155\\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 07:36:22 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 07:36:22 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 07:36:22 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 07:36:22 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Roaming', 07:36:22 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 07:36:22 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 07:36:22 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 07:36:22 INFO - 'COMPUTERNAME': 'T-W864-IX-155', 07:36:22 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 07:36:22 INFO - 'DCLOCATION': 'SCL3', 07:36:22 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 07:36:22 INFO - 'FP_NO_HOST_CHECK': 'NO', 07:36:22 INFO - 'HOMEDRIVE': 'C:', 07:36:22 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-155', 07:36:22 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 07:36:22 INFO - 'KTS_VERSION': '1.19c', 07:36:22 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local', 07:36:22 INFO - 'LOGONSERVER': '\\\\T-W864-IX-155', 07:36:22 INFO - 'MONDIR': 'C:\\Monitor_config\\', 07:36:22 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 07:36:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:22 INFO - 'MOZ_NO_REMOTE': '1', 07:36:22 INFO - 'NO_EM_RESTART': '1', 07:36:22 INFO - 'NUMBER_OF_PROCESSORS': '8', 07:36:22 INFO - 'OS': 'Windows_NT', 07:36:22 INFO - 'OURDRIVE': 'C:', 07:36:22 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', 07:36:22 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 07:36:22 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 07:36:22 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 07:36:22 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 07:36:22 INFO - 'PROCESSOR_LEVEL': '6', 07:36:22 INFO - 'PROCESSOR_REVISION': '1e05', 07:36:22 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 07:36:22 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 07:36:22 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 07:36:22 INFO - 'PROGRAMW6432': 'C:\\Program Files', 07:36:22 INFO - 'PROMPT': '$P$G', 07:36:22 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 07:36:22 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 07:36:22 INFO - 'PUBLIC': 'C:\\Users\\Public', 07:36:22 INFO - 'PWD': 'C:\\slave\\test', 07:36:22 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 07:36:22 INFO - 'SLAVEDIR': 'C:\\slave\\', 07:36:22 INFO - 'SYSTEMDRIVE': 'C:', 07:36:22 INFO - 'SYSTEMROOT': 'C:\\windows', 07:36:22 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 07:36:22 INFO - 'TEST1': 'testie', 07:36:22 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 07:36:22 INFO - 'USERDOMAIN': 'T-W864-IX-155', 07:36:22 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-155', 07:36:22 INFO - 'USERNAME': 'cltbld', 07:36:22 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-155', 07:36:22 INFO - 'WINDIR': 'C:\\windows', 07:36:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 07:36:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:24 INFO - Downloading/unpacking psutil>=0.7.1 07:36:24 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 07:36:24 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 07:36:26 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 07:36:26 INFO - Installing collected packages: psutil 07:36:26 INFO - Successfully installed psutil 07:36:26 INFO - Cleaning up... 07:36:26 INFO - Return code: 0 07:36:26 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv C:\slave\test\build/venv 07:36:26 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')]} 07:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:26 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')]} 07:36:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:26 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 0x0236FB10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02331EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02409BF8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01D58B48>, '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 0x01D7A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023EA660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-155', 'USERDOMAIN': 'T-W864-IX-155', '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-155', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-155', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-155', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-155', '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-155\\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 07:36:26 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 07:36:26 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 07:36:26 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 07:36:26 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Roaming', 07:36:26 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 07:36:26 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 07:36:26 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 07:36:26 INFO - 'COMPUTERNAME': 'T-W864-IX-155', 07:36:26 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 07:36:26 INFO - 'DCLOCATION': 'SCL3', 07:36:26 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 07:36:26 INFO - 'FP_NO_HOST_CHECK': 'NO', 07:36:26 INFO - 'HOMEDRIVE': 'C:', 07:36:26 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-155', 07:36:26 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 07:36:26 INFO - 'KTS_VERSION': '1.19c', 07:36:26 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local', 07:36:26 INFO - 'LOGONSERVER': '\\\\T-W864-IX-155', 07:36:26 INFO - 'MONDIR': 'C:\\Monitor_config\\', 07:36:26 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 07:36:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:26 INFO - 'MOZ_NO_REMOTE': '1', 07:36:26 INFO - 'NO_EM_RESTART': '1', 07:36:26 INFO - 'NUMBER_OF_PROCESSORS': '8', 07:36:26 INFO - 'OS': 'Windows_NT', 07:36:26 INFO - 'OURDRIVE': 'C:', 07:36:26 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', 07:36:26 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 07:36:26 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 07:36:26 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 07:36:26 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 07:36:26 INFO - 'PROCESSOR_LEVEL': '6', 07:36:26 INFO - 'PROCESSOR_REVISION': '1e05', 07:36:26 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 07:36:26 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 07:36:26 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 07:36:26 INFO - 'PROGRAMW6432': 'C:\\Program Files', 07:36:26 INFO - 'PROMPT': '$P$G', 07:36:26 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 07:36:26 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 07:36:26 INFO - 'PUBLIC': 'C:\\Users\\Public', 07:36:26 INFO - 'PWD': 'C:\\slave\\test', 07:36:26 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 07:36:26 INFO - 'SLAVEDIR': 'C:\\slave\\', 07:36:26 INFO - 'SYSTEMDRIVE': 'C:', 07:36:26 INFO - 'SYSTEMROOT': 'C:\\windows', 07:36:26 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 07:36:26 INFO - 'TEST1': 'testie', 07:36:26 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 07:36:26 INFO - 'USERDOMAIN': 'T-W864-IX-155', 07:36:26 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-155', 07:36:26 INFO - 'USERNAME': 'cltbld', 07:36:26 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-155', 07:36:26 INFO - 'WINDIR': 'C:\\windows', 07:36:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 07:36:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:26 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:36:26 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 07:36:26 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 07:36:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:36:29 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 07:36:29 INFO - Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor 07:36:29 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) 07:36:29 INFO - Installing collected packages: mozsystemmonitor 07:36:29 INFO - Running setup.py install for mozsystemmonitor 07:36:30 INFO - Successfully installed mozsystemmonitor 07:36:30 INFO - Cleaning up... 07:36:30 INFO - Return code: 0 07:36:30 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv 07:36: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')]} 07:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36: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')]} 07:36:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:30 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 0x0236FB10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02331EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02409BF8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01D58B48>, '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 0x01D7A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023EA660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-155', 'USERDOMAIN': 'T-W864-IX-155', '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-155', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-155', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-155', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-155', '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-155\\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 07:36:30 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 07:36:30 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 07:36:30 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 07:36:30 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Roaming', 07:36:30 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 07:36:30 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 07:36:30 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 07:36:30 INFO - 'COMPUTERNAME': 'T-W864-IX-155', 07:36:30 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 07:36:30 INFO - 'DCLOCATION': 'SCL3', 07:36:30 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 07:36:30 INFO - 'FP_NO_HOST_CHECK': 'NO', 07:36:30 INFO - 'HOMEDRIVE': 'C:', 07:36:30 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-155', 07:36:30 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 07:36:30 INFO - 'KTS_VERSION': '1.19c', 07:36:30 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local', 07:36:30 INFO - 'LOGONSERVER': '\\\\T-W864-IX-155', 07:36:30 INFO - 'MONDIR': 'C:\\Monitor_config\\', 07:36:30 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 07:36:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:30 INFO - 'MOZ_NO_REMOTE': '1', 07:36:30 INFO - 'NO_EM_RESTART': '1', 07:36:30 INFO - 'NUMBER_OF_PROCESSORS': '8', 07:36:30 INFO - 'OS': 'Windows_NT', 07:36:30 INFO - 'OURDRIVE': 'C:', 07:36:30 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', 07:36:30 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 07:36:30 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 07:36:30 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 07:36:30 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 07:36:30 INFO - 'PROCESSOR_LEVEL': '6', 07:36:30 INFO - 'PROCESSOR_REVISION': '1e05', 07:36:30 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 07:36:30 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 07:36:30 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 07:36:30 INFO - 'PROGRAMW6432': 'C:\\Program Files', 07:36:30 INFO - 'PROMPT': '$P$G', 07:36:30 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 07:36:30 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 07:36:30 INFO - 'PUBLIC': 'C:\\Users\\Public', 07:36:30 INFO - 'PWD': 'C:\\slave\\test', 07:36:30 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 07:36:30 INFO - 'SLAVEDIR': 'C:\\slave\\', 07:36:30 INFO - 'SYSTEMDRIVE': 'C:', 07:36:30 INFO - 'SYSTEMROOT': 'C:\\windows', 07:36:30 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 07:36:30 INFO - 'TEST1': 'testie', 07:36:30 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 07:36:30 INFO - 'USERDOMAIN': 'T-W864-IX-155', 07:36:30 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-155', 07:36:30 INFO - 'USERNAME': 'cltbld', 07:36:30 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-155', 07:36:30 INFO - 'WINDIR': 'C:\\windows', 07:36:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 07:36:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:30 INFO - Downloading/unpacking blobuploader==1.2.4 07:36:30 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 07:36:30 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 07:36:31 INFO - Downloading blobuploader-1.2.4.tar.gz 07:36:31 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 07:36:31 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader 07:36:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:36:31 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 07:36:31 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 07:36:31 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 07:36:31 INFO - Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests 07:36:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:36:32 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 07:36:32 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 07:36:32 INFO - Downloading docopt-0.6.1.tar.gz 07:36:32 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 07:36:32 INFO - Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt 07:36:32 INFO - Installing collected packages: blobuploader, requests, docopt 07:36:32 INFO - Running setup.py install for blobuploader 07:36:32 INFO - Running setup.py install for requests 07:36:33 INFO - Running setup.py install for docopt 07:36:33 INFO - Successfully installed blobuploader requests docopt 07:36:33 INFO - Cleaning up... 07:36:34 INFO - Return code: 0 07:36:34 INFO - Installing None into virtualenv C:\slave\test\build/venv 07:36: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')]} 07:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36: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')]} 07:36:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:34 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 0x0236FB10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02331EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02409BF8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01D58B48>, '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 0x01D7A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023EA660>, '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-155', 'USERDOMAIN': 'T-W864-IX-155', '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-155', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-155', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-155', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-155', '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-155\\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 07:36:34 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 07:36:34 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 07:36:34 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 07:36:34 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Roaming', 07:36:34 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 07:36:34 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 07:36:34 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 07:36:34 INFO - 'COMPUTERNAME': 'T-W864-IX-155', 07:36:34 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 07:36:34 INFO - 'DCLOCATION': 'SCL3', 07:36:34 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 07:36:34 INFO - 'FP_NO_HOST_CHECK': 'NO', 07:36:34 INFO - 'HOMEDRIVE': 'C:', 07:36:34 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-155', 07:36:34 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 07:36:34 INFO - 'KTS_VERSION': '1.19c', 07:36:34 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local', 07:36:34 INFO - 'LOGONSERVER': '\\\\T-W864-IX-155', 07:36:34 INFO - 'MONDIR': 'C:\\Monitor_config\\', 07:36:34 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 07:36:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:34 INFO - 'MOZ_NO_REMOTE': '1', 07:36:34 INFO - 'NO_EM_RESTART': '1', 07:36:34 INFO - 'NUMBER_OF_PROCESSORS': '8', 07:36:34 INFO - 'OS': 'Windows_NT', 07:36:34 INFO - 'OURDRIVE': 'C:', 07:36: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', 07:36:34 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 07:36:34 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 07:36:34 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 07:36:34 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 07:36:34 INFO - 'PROCESSOR_LEVEL': '6', 07:36:34 INFO - 'PROCESSOR_REVISION': '1e05', 07:36:34 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 07:36:34 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 07:36:34 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 07:36:34 INFO - 'PROGRAMW6432': 'C:\\Program Files', 07:36:34 INFO - 'PROMPT': '$P$G', 07:36:34 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 07:36:34 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 07:36:34 INFO - 'PUBLIC': 'C:\\Users\\Public', 07:36:34 INFO - 'PWD': 'C:\\slave\\test', 07:36:34 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 07:36:34 INFO - 'SLAVEDIR': 'C:\\slave\\', 07:36:34 INFO - 'SYSTEMDRIVE': 'C:', 07:36:34 INFO - 'SYSTEMROOT': 'C:\\windows', 07:36:34 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 07:36:34 INFO - 'TEST1': 'testie', 07:36:34 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 07:36:34 INFO - 'USERDOMAIN': 'T-W864-IX-155', 07:36:34 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-155', 07:36:34 INFO - 'USERNAME': 'cltbld', 07:36:34 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-155', 07:36:34 INFO - 'WINDIR': 'C:\\windows', 07:36:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 07:36:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:34 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 07:36:34 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-kisisf-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 07:36:34 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 07:36:34 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rvrxuy-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 07:36:35 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 07:36:35 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ubitvj-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 07:36:35 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 07:36:35 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-7rqgcr-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 07:36:35 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 07:36:35 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-eqn5mm-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 07:36:35 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 07:36:35 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ggidbn-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 07:36:35 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 07:36:35 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-shmki8-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 07:36:35 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 07:36:35 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jbwer5-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 07:36:35 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 07:36:35 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-zocygi-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 07:36:35 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 07:36:35 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-kmntfz-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 07:36:36 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 07:36:36 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-caszog-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 07:36:36 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 07:36:36 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-zk7egp-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 07:36:36 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 07:36:36 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-mphzk4-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 07:36:36 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 07:36:36 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-lois7v-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 07:36:36 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 07:36:36 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qu7awi-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 07:36:36 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 07:36:36 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-lzfedp-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 07:36:36 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 07:36:36 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-dubk1g-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 07:36:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:36:36 INFO - Running setup.py install for manifestparser 07:36:36 INFO - Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts 07:36:36 INFO - Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts 07:36:37 INFO - Running setup.py install for mozcrash 07:36:37 INFO - Running setup.py install for mozdebug 07:36:38 INFO - Running setup.py install for mozdevice 07:36:38 INFO - Installing sutini-script.py script to C:\slave\test\build\venv\Scripts 07:36:38 INFO - Installing sutini.exe script to C:\slave\test\build\venv\Scripts 07:36:38 INFO - Installing dm-script.py script to C:\slave\test\build\venv\Scripts 07:36:38 INFO - Installing dm.exe script to C:\slave\test\build\venv\Scripts 07:36:39 INFO - Running setup.py install for mozfile 07:36:39 INFO - Running setup.py install for mozhttpd 07:36:39 INFO - Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts 07:36:39 INFO - Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts 07:36:39 INFO - Running setup.py install for mozinfo 07:36:39 INFO - Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts 07:36:39 INFO - Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts 07:36:40 INFO - Running setup.py install for mozInstall 07:36:40 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts 07:36:40 INFO - Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts 07:36:40 INFO - Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts 07:36:40 INFO - Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts 07:36:40 INFO - Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts 07:36:40 INFO - Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts 07:36:40 INFO - Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts 07:36:40 INFO - Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts 07:36:40 INFO - Running setup.py install for mozleak 07:36:40 INFO - Running setup.py install for mozlog 07:36:40 INFO - Installing structlog-script.py script to C:\slave\test\build\venv\Scripts 07:36:40 INFO - Installing structlog.exe script to C:\slave\test\build\venv\Scripts 07:36:41 INFO - Running setup.py install for moznetwork 07:36:41 INFO - Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts 07:36:41 INFO - Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts 07:36:41 INFO - Running setup.py install for mozprocess 07:36:42 INFO - Running setup.py install for mozprofile 07:36:42 INFO - Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts 07:36:42 INFO - Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts 07:36:42 INFO - Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts 07:36:42 INFO - Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts 07:36:42 INFO - Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts 07:36:42 INFO - Installing view-profile.exe script to C:\slave\test\build\venv\Scripts 07:36:43 INFO - Running setup.py install for mozrunner 07:36:43 INFO - Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts 07:36:43 INFO - Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts 07:36:43 INFO - Running setup.py install for mozscreenshot 07:36:44 INFO - Running setup.py install for moztest 07:36:44 INFO - Running setup.py install for mozversion 07:36:44 INFO - Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts 07:36:44 INFO - Installing mozversion.exe script to C:\slave\test\build\venv\Scripts 07:36:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:36:44 INFO - Cleaning up... 07:36:44 INFO - Return code: 0 07:36:44 INFO - Installing None into virtualenv C:\slave\test\build/venv 07:36:44 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')]} 07:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:44 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')]} 07:36:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:44 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 0x0236FB10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02331EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02409BF8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01D58B48>, '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 0x01D7A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023EA660>, '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-155', 'USERDOMAIN': 'T-W864-IX-155', '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-155', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-155', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-155', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-155', '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-155\\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 07:36:45 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 07:36:45 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 07:36:45 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 07:36:45 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Roaming', 07:36:45 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 07:36:45 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 07:36:45 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 07:36:45 INFO - 'COMPUTERNAME': 'T-W864-IX-155', 07:36:45 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 07:36:45 INFO - 'DCLOCATION': 'SCL3', 07:36:45 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 07:36:45 INFO - 'FP_NO_HOST_CHECK': 'NO', 07:36:45 INFO - 'HOMEDRIVE': 'C:', 07:36:45 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-155', 07:36:45 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 07:36:45 INFO - 'KTS_VERSION': '1.19c', 07:36:45 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local', 07:36:45 INFO - 'LOGONSERVER': '\\\\T-W864-IX-155', 07:36:45 INFO - 'MONDIR': 'C:\\Monitor_config\\', 07:36:45 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 07:36:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:45 INFO - 'MOZ_NO_REMOTE': '1', 07:36:45 INFO - 'NO_EM_RESTART': '1', 07:36:45 INFO - 'NUMBER_OF_PROCESSORS': '8', 07:36:45 INFO - 'OS': 'Windows_NT', 07:36:45 INFO - 'OURDRIVE': 'C:', 07:36: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', 07:36:45 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 07:36:45 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 07:36:45 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 07:36:45 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 07:36:45 INFO - 'PROCESSOR_LEVEL': '6', 07:36:45 INFO - 'PROCESSOR_REVISION': '1e05', 07:36:45 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 07:36:45 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 07:36:45 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 07:36:45 INFO - 'PROGRAMW6432': 'C:\\Program Files', 07:36:45 INFO - 'PROMPT': '$P$G', 07:36:45 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 07:36:45 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 07:36:45 INFO - 'PUBLIC': 'C:\\Users\\Public', 07:36:45 INFO - 'PWD': 'C:\\slave\\test', 07:36:45 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 07:36:45 INFO - 'SLAVEDIR': 'C:\\slave\\', 07:36:45 INFO - 'SYSTEMDRIVE': 'C:', 07:36:45 INFO - 'SYSTEMROOT': 'C:\\windows', 07:36:45 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 07:36:45 INFO - 'TEST1': 'testie', 07:36:45 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 07:36:45 INFO - 'USERDOMAIN': 'T-W864-IX-155', 07:36:45 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-155', 07:36:45 INFO - 'USERNAME': 'cltbld', 07:36:45 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-155', 07:36:45 INFO - 'WINDIR': 'C:\\windows', 07:36:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 07:36:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:45 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 07:36:45 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-b_s9yh-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 07:36:45 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)) 07:36:45 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 07:36:45 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-0jr7tu-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 07:36:45 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)) 07:36:45 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 07:36:45 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-dwodyi-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 07:36:45 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)) 07:36:45 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 07:36:45 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rckxv4-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 07:36:45 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)) 07:36:45 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 07:36:45 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-d63vzd-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 07:36:45 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)) 07:36:45 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 07:36:45 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-gdvj79-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 07:36:46 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)) 07:36:46 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 07:36:46 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-bionha-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 07:36:46 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)) 07:36:46 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 07:36:46 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-111bf8-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 07:36:46 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)) 07:36:46 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 07:36:46 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-izhz3v-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 07:36:46 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)) 07:36:46 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 07:36:46 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-2cfx_p-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 07:36:46 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)) 07:36:46 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 07:36:46 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-pf2bpm-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 07:36:46 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)) 07:36:46 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 07:36:46 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-awqnj1-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 07:36:46 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)) 07:36:46 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 07:36:46 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ixaz_v-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 07:36:46 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)) 07:36:46 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 07:36:46 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jtxgbs-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 07:36:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.10 from file:///C:/slave/test/build/tests/mozbase/mozrunner in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 14)) 07:36:47 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 07:36:47 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-d3kw4z-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 07:36:47 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)) 07:36:47 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 07:36:47 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-4ml8z4-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 07:36:47 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)) 07:36:47 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 07:36:47 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-lskx8c-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 07:36:47 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)) 07:36:47 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)) 07:36:47 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)) 07:36:47 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)) 07:36:47 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)) 07:36:47 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)) 07:36:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10)) 07:36:47 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 07:36:47 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 07:36:50 INFO - Downloading blessings-1.5.1.tar.gz 07:36:50 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 07:36:50 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings 07:36:50 INFO - Installing collected packages: blessings 07:36:50 INFO - Running setup.py install for blessings 07:36:51 INFO - Successfully installed blessings 07:36:51 INFO - Cleaning up... 07:36:54 INFO - Return code: 0 07:36:54 INFO - Done creating virtualenv C:\slave\test\build/venv. 07:36:54 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 07:36:54 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 07:36:54 INFO - Reading from file tmpfile_stdout 07:36:54 INFO - Using _rmtree_windows ... 07:36:54 INFO - Using _rmtree_windows ... 07:36:54 INFO - Current package versions: 07:36:54 INFO - blessings == 1.5.1 07:36:54 INFO - blobuploader == 1.2.4 07:36:54 INFO - docopt == 0.6.1 07:36:54 INFO - manifestparser == 1.1 07:36:54 INFO - mozInstall == 1.12 07:36:54 INFO - mozcrash == 0.16 07:36:54 INFO - mozdebug == 0.1 07:36:54 INFO - mozdevice == 0.46 07:36:54 INFO - mozfile == 1.2 07:36:54 INFO - mozhttpd == 0.7 07:36:54 INFO - mozinfo == 0.8 07:36:54 INFO - mozleak == 0.1 07:36:54 INFO - mozlog == 3.0 07:36:54 INFO - moznetwork == 0.27 07:36:54 INFO - mozprocess == 0.22 07:36:54 INFO - mozprofile == 0.27 07:36:54 INFO - mozrunner == 6.10 07:36:54 INFO - mozscreenshot == 0.1 07:36:54 INFO - mozsystemmonitor == 0.0 07:36:54 INFO - moztest == 0.7 07:36:54 INFO - mozversion == 1.4 07:36:54 INFO - psutil == 3.1.1 07:36:54 INFO - requests == 1.2.3 07:36:54 INFO - Installing None into virtualenv C:\slave\test\build/venv 07:36:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:54 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 0x0236FB10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02331EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02409BF8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01D58B48>, '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 0x01D7A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023EA660>, '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-155', 'USERDOMAIN': 'T-W864-IX-155', '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-155', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-155', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-155', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-155', '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-155\\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 07:36:54 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 07:36:54 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 07:36:54 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 07:36:54 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Roaming', 07:36:54 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 07:36:54 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 07:36:54 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 07:36:54 INFO - 'COMPUTERNAME': 'T-W864-IX-155', 07:36:54 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 07:36:54 INFO - 'DCLOCATION': 'SCL3', 07:36:54 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 07:36:54 INFO - 'FP_NO_HOST_CHECK': 'NO', 07:36:54 INFO - 'HOMEDRIVE': 'C:', 07:36:54 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-155', 07:36:54 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 07:36:54 INFO - 'KTS_VERSION': '1.19c', 07:36:54 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local', 07:36:54 INFO - 'LOGONSERVER': '\\\\T-W864-IX-155', 07:36:54 INFO - 'MONDIR': 'C:\\Monitor_config\\', 07:36:54 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 07:36:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:54 INFO - 'MOZ_NO_REMOTE': '1', 07:36:54 INFO - 'NO_EM_RESTART': '1', 07:36:54 INFO - 'NUMBER_OF_PROCESSORS': '8', 07:36:54 INFO - 'OS': 'Windows_NT', 07:36:54 INFO - 'OURDRIVE': 'C:', 07:36:54 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', 07:36:54 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 07:36:54 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 07:36:54 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 07:36:54 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 07:36:54 INFO - 'PROCESSOR_LEVEL': '6', 07:36:54 INFO - 'PROCESSOR_REVISION': '1e05', 07:36:54 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 07:36:54 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 07:36:54 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 07:36:54 INFO - 'PROGRAMW6432': 'C:\\Program Files', 07:36:54 INFO - 'PROMPT': '$P$G', 07:36:54 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 07:36:54 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 07:36:54 INFO - 'PUBLIC': 'C:\\Users\\Public', 07:36:54 INFO - 'PWD': 'C:\\slave\\test', 07:36:54 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 07:36:54 INFO - 'SLAVEDIR': 'C:\\slave\\', 07:36:54 INFO - 'SYSTEMDRIVE': 'C:', 07:36:54 INFO - 'SYSTEMROOT': 'C:\\windows', 07:36:54 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 07:36:54 INFO - 'TEST1': 'testie', 07:36:54 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 07:36:54 INFO - 'USERDOMAIN': 'T-W864-IX-155', 07:36:54 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-155', 07:36:54 INFO - 'USERNAME': 'cltbld', 07:36:54 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-155', 07:36:54 INFO - 'WINDIR': 'C:\\windows', 07:36:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 07:36:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:54 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)) 07:36:54 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)) 07:36:54 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)) 07:36:54 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)) 07:36:54 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)) 07:36:54 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)) 07:36:54 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)) 07:36:54 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)) 07:36:54 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)) 07:36:54 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)) 07:36:54 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)) 07:36:54 INFO - Cleaning up... 07:36:54 INFO - Return code: 0 07:36:54 INFO - Running post-action listener: _resource_record_post_action 07:36:54 INFO - Running post-action listener: _start_resource_monitoring 07:36:54 INFO - Starting resource monitoring. 07:36:54 INFO - ##### 07:36:54 INFO - ##### Running install step. 07:36:54 INFO - ##### 07:36:54 INFO - Running pre-action listener: _resource_record_pre_action 07:36:54 INFO - Running main action method: install 07:36:54 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 07:36:54 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 07:36:55 INFO - Reading from file tmpfile_stdout 07:36:55 INFO - Using _rmtree_windows ... 07:36:55 INFO - Using _rmtree_windows ... 07:36:55 INFO - Detecting whether we're running mozinstall >=1.0... 07:36:55 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h'] 07:36:55 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h 07:36:55 INFO - Reading from file tmpfile_stdout 07:36:55 INFO - Output received: 07:36:55 INFO - Usage: mozinstall-script.py [options] installer 07:36:55 INFO - Options: 07:36:55 INFO - -h, --help show this help message and exit 07:36:55 INFO - -d DEST, --destination=DEST 07:36:55 INFO - Directory to install application into. [default: 07:36:55 INFO - "C:\slave\test"] 07:36:55 INFO - --app=APP Application being installed. [default: firefox] 07:36:55 INFO - Using _rmtree_windows ... 07:36:55 INFO - Using _rmtree_windows ... 07:36:55 INFO - mkdir: C:\slave\test\build\application 07:36:55 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'] 07:36:55 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 07:36:56 INFO - Reading from file tmpfile_stdout 07:36:56 INFO - Output received: 07:36:56 INFO - C:\slave\test\build\application\firefox\firefox.exe 07:36:56 INFO - Using _rmtree_windows ... 07:36:56 INFO - Using _rmtree_windows ... 07:36:56 INFO - Running post-action listener: _resource_record_post_action 07:36:56 INFO - ##### 07:36:56 INFO - ##### Running run-tests step. 07:36:56 INFO - ##### 07:36:56 INFO - Running pre-action listener: _resource_record_pre_action 07:36:56 INFO - Running main action method: run_tests 07:36:56 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version'] 07:36:56 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version 07:36:56 INFO - Python 2.7.3 07:36:56 INFO - Return code: 0 07:36:56 INFO - grabbing minidump binary from tooltool 07:36:56 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')]} 07:36:56 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 0x01D58B48>, '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 0x01D7A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x023EA660>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1 07:36:56 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 07:36:56 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 07:36:56 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 07:37:01 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmpdmizjz 07:37:01 INFO - INFO - File integrity verified, renaming tmpdmizjz to win32-minidump_stackwalk.exe 07:37:01 INFO - Return code: 0 07:37:01 INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755 07:37:01 INFO - mkdir: C:\slave\test\build\blobber_upload_dir 07:37:01 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir 07:37:01 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe 07:37:01 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir 07:37:01 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/9ZIk2BkDSd6gGG8dNDCR4Q/artifacts/public/build/firefox-44.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-155', '--webServer', 'localhost'] in C:\slave\test\build 07:37:01 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/9ZIk2BkDSd6gGG8dNDCR4Q/artifacts/public/build/firefox-44.0a1.en-US.win64.crashreporter-symbols.zip --title T-W864-IX-155 --webServer localhost 07:37:01 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 07:37:01 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Roaming', 07:37:01 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 07:37:01 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 07:37:01 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 07:37:01 INFO - 'COMPUTERNAME': 'T-W864-IX-155', 07:37:01 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 07:37:01 INFO - 'DCLOCATION': 'SCL3', 07:37:01 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 07:37:01 INFO - 'FP_NO_HOST_CHECK': 'NO', 07:37:01 INFO - 'HOMEDRIVE': 'C:', 07:37:01 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-155', 07:37:01 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 07:37:01 INFO - 'KTS_VERSION': '1.19c', 07:37:01 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-155\\AppData\\Local', 07:37:01 INFO - 'LOGONSERVER': '\\\\T-W864-IX-155', 07:37:01 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir', 07:37:01 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe', 07:37:01 INFO - 'MONDIR': 'C:\\Monitor_config\\', 07:37:01 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 07:37:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:01 INFO - 'MOZ_NO_REMOTE': '1', 07:37:01 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir', 07:37:01 INFO - 'NO_EM_RESTART': '1', 07:37:01 INFO - 'NUMBER_OF_PROCESSORS': '8', 07:37:01 INFO - 'OS': 'Windows_NT', 07:37:01 INFO - 'OURDRIVE': 'C:', 07:37:01 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 07:37:01 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 07:37:01 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 07:37:01 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 07:37:01 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 07:37:01 INFO - 'PROCESSOR_LEVEL': '6', 07:37:01 INFO - 'PROCESSOR_REVISION': '1e05', 07:37:01 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 07:37:01 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 07:37:01 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 07:37:01 INFO - 'PROGRAMW6432': 'C:\\Program Files', 07:37:01 INFO - 'PROMPT': '$P$G', 07:37:01 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 07:37:01 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 07:37:01 INFO - 'PUBLIC': 'C:\\Users\\Public', 07:37:01 INFO - 'PWD': 'C:\\slave\\test', 07:37:01 INFO - 'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos', 07:37:01 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 07:37:01 INFO - 'SLAVEDIR': 'C:\\slave\\', 07:37:01 INFO - 'SYSTEMDRIVE': 'C:', 07:37:01 INFO - 'SYSTEMROOT': 'C:\\windows', 07:37:01 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 07:37:01 INFO - 'TEST1': 'testie', 07:37:01 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 07:37:01 INFO - 'USERDOMAIN': 'T-W864-IX-155', 07:37:01 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-155', 07:37:01 INFO - 'USERNAME': 'cltbld', 07:37:01 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-155', 07:37:01 INFO - 'WINDIR': 'C:\\windows', 07:37:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 07:37:01 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/9ZIk2BkDSd6gGG8dNDCR4Q/artifacts/public/build/firefox-44.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-155', '--webServer', 'localhost'] with output_timeout 3600 ProcessManager NOT managing child processes ProcessManager UNABLE to use job objects to manage child processes 07:37:02 INFO - mozversion INFO | application_buildid: 20151022030053 07:37:02 INFO - mozversion INFO | application_changeset: b84cc63b2aa92b98e987a73b7b339a85788a3ab2 07:37:02 INFO - mozversion INFO | application_display_name: Nightly 07:37:02 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:37:02 INFO - mozversion INFO | application_name: Firefox 07:37:02 INFO - mozversion INFO | application_remotingname: firefox 07:37:02 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 07:37:02 INFO - mozversion INFO | application_vendor: Mozilla 07:37:02 INFO - mozversion INFO | application_version: 44.0a1 07:37:02 INFO - mozversion INFO | platform_buildid: 20151022030053 07:37:02 INFO - mozversion INFO | platform_changeset: b84cc63b2aa92b98e987a73b7b339a85788a3ab2 07:37:02 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 07:37:02 INFO - mozversion INFO | platform_version: 44.0a1 07:37:02 INFO - 2015-10-22 07:37:02,079 DEBUG : using testdate: 1445524622 07:37:02 INFO - 2015-10-22 07:37:02,079 DEBUG : actual date: 1445524622 07:37:02 INFO - 2015-10-22 07:37:02,467 INFO : starting webserver on 'localhost:49237' 07:37:02 INFO - 2015-10-22 07:37:02,470 INFO : Starting test suite T-W864-IX-155 07:37:02 INFO - 2015-10-22 07:37:02,470 INFO : Starting test dromaeo_css 07:37:02 INFO - 2015-10-22 07:37:02,470 DEBUG : operating with platform_type : w8_ 07:37:02 INFO - 2015-10-22 07:37:02,470 INFO : Initialising browser for dromaeo_css test... 07:37:02 INFO - 2015-10-22 07:37:02,588 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpyoapsl\profile http://localhost:49237/getInfo.html 07:37:11 INFO - 2015-10-22 07:37:11,160 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:37:11 INFO - 2015-10-22 07:37:11,160 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:37:11 INFO - 2015-10-22 07:37:11,160 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674 07:37:11 INFO - 2015-10-22 07:37:11,160 DEBUG : BROWSER_OUTPUT: __metrics 07:37:11 INFO - 2015-10-22 07:37:11,341 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:37:12 INFO - 2015-10-22 07:37:12,428 DEBUG : BROWSER_OUTPUT: console.error: 07:37:12 INFO - 2015-10-22 07:37:12,428 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] 07:37:12 INFO - 2015-10-22 07:37:12,428 DEBUG : BROWSER_OUTPUT: Stack: 07:37:12 INFO - 2015-10-22 07:37:12,428 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<._executeStatement@resource://gre/modules/Sqlite.jsm:758:19 07:37:12 INFO - 2015-10-22 07:37:12,428 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached/<@resource://gre/modules/Sqlite.jsm:493:9 07:37:12 INFO - 2015-10-22 07:37:12,428 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached@resource://gre/modules/Sqlite.jsm:491:1 07:37:12 INFO - 2015-10-22 07:37:12,428 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeBeforeShutdown/loggedDb<.executeCached.value<@resource://gre/modules/Sqlite.jsm:368:51 07:37:12 INFO - 2015-10-22 07:37:12,428 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 07:37:12 INFO - 2015-10-22 07:37:12,428 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 07:37:12 INFO - 2015-10-22 07:37:12,428 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 07:37:12 INFO - 2015-10-22 07:37:12,428 DEBUG : BROWSER_OUTPUT: setAncestorsLastModified<@resource://gre/modules/Bookmarks.jsm:1347:9 07:37:12 INFO - 2015-10-22 07:37:12,428 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 07:37:12 INFO - 2015-10-22 07:37:12,428 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 07:37:12 INFO - 2015-10-22 07:37:12,430 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 07:37:12 INFO - 2015-10-22 07:37:12,430 DEBUG : BROWSER_OUTPUT: transaction@resource://gre/modules/Bookmarks.jsm:808:13 07:37:12 INFO - 2015-10-22 07:37:12,430 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 07:37:12 INFO - 2015-10-22 07:37:12,430 DEBUG : BROWSER_OUTPUT: Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:934:23 07:37:12 INFO - 2015-10-22 07:37:12,430 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 07:37:12 INFO - 2015-10-22 07:37:12,430 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 07:37:12 INFO - 2015-10-22 07:37:12,430 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 07:37:12 INFO - 2015-10-22 07:37:12,430 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 07:37:12 INFO - 2015-10-22 07:37:12,430 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 07:37:12 INFO - 2015-10-22 07:37:12,430 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 07:37:12 INFO - 2015-10-22 07:37:12,430 DEBUG : BROWSER_OUTPUT: 07:37:13 INFO - 2015-10-22 07:37:13,253 INFO : Browser initialized. 07:37:13 INFO - 2015-10-22 07:37:13,253 INFO : Running cycle 1/1 for dromaeo_css test... 07:37:13 INFO - 2015-10-22 07:37:13,253 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpyoapsl\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:37:24 INFO - 2015-10-22 07:37:24,829 DEBUG : BROWSER_OUTPUT: RSS: Main: 176967680 07:37:24 INFO - 2015-10-22 07:37:24,829 DEBUG : BROWSER_OUTPUT: 07:38:16 INFO - 2015-10-22 07:38:16,013 DEBUG : BROWSER_OUTPUT: 1445524696012 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] 07:40:25 INFO - 2015-10-22 07:40:25,828 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49237/tests/dromaeo/cssquery-ext.html) 07:40:26 INFO - 2015-10-22 07:40:26,934 DEBUG : BROWSER_OUTPUT: RSS: Main: 238850048 07:40:26 INFO - 2015-10-22 07:40:26,934 DEBUG : BROWSER_OUTPUT: 07:43:30 INFO - 2015-10-22 07:43:30,066 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-ext.html (next: http://localhost:49237/tests/dromaeo/cssquery-jquery.html) 07:43:30 INFO - 2015-10-22 07:43:30,628 DEBUG : BROWSER_OUTPUT: RSS: Main: 230002688 07:43:30 INFO - 2015-10-22 07:43:30,628 DEBUG : BROWSER_OUTPUT: 07:46:32 INFO - 2015-10-22 07:46:32,930 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49237/tests/dromaeo/cssquery-mootools.html) 07:46:33 INFO - 2015-10-22 07:46:33,493 DEBUG : BROWSER_OUTPUT: RSS: Main: 194650112 07:46:33 INFO - 2015-10-22 07:46:33,493 DEBUG : BROWSER_OUTPUT: 07:49:35 INFO - 2015-10-22 07:49:35,766 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49237/tests/dromaeo/cssquery-prototype.html) 07:49:36 INFO - 2015-10-22 07:49:36,328 DEBUG : BROWSER_OUTPUT: RSS: Main: 164933632 07:49:36 INFO - 2015-10-22 07:49:36,329 DEBUG : BROWSER_OUTPUT: 07:52:39 INFO - 2015-10-22 07:52:39,447 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49237/tests/dromaeo/cssquery-yui.html) 07:52:40 INFO - 2015-10-22 07:52:40,038 DEBUG : BROWSER_OUTPUT: RSS: Main: 167514112 07:52:40 INFO - 2015-10-22 07:52:40,038 DEBUG : BROWSER_OUTPUT: 07:55:42 INFO - 2015-10-22 07:55:42,785 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-yui.html (next: http://localhost:49237/tests/dromaeo/cssquery-dojo.html) 07:55:43 INFO - 2015-10-22 07:55:43,036 DEBUG : BROWSER_OUTPUT: RSS: Main: 211075072 07:55:43 INFO - 2015-10-22 07:55:43,036 DEBUG : BROWSER_OUTPUT: 07:55:43 INFO - 2015-10-22 07:55:43,036 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:55:43 INFO - 2015-10-22 07:55:43,036 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:55:43 INFO - 2015-10-22 07:55:43,036 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:55:43 INFO - 2015-10-22 07:55:43,038 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:55:43 INFO - 2015-10-22 07:55:43,038 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2624.5144648240075;2694.312950197699;2706.039356028611;2706.1881435569335;2718.6058021586878;4818.807247710091;4833.057553777015;4838.733869637169;4879.09736698711;4897.926531102027;4790.80836766529;4856.344393506875;4862.683925544837;4879.39007624047;4922.950770492294;4343.174796788616;4411.382406463098;4413.88965275869;4474.97762511187;4477.216487114758;4414.381986521889;4434.97782511087;4442.155990361837;4442.3336499525;4447.288433850585;4353.825846966118;4365.170617582665;4406.515283318832;4436.822527098912;4438.467383913919;4409.757463339515;4465.910681786346;4469.642428605704;4513.684042117069;4540.7502587357685;4439.75581343026;4440.378347031418;4445.110977804452;4486.394336764528;4500.302453119739;4662.650301227388;4769.618430525585;4813.78337974792;4818.156822556039;4823.324734537167;4720.409948756405;5010.574101201402;5014.122528557488;5070.188769796815;5089.134847076006;5141.280220769096;5169.302144210558;5172.250023746573;5179.870503237412;5220.895582088337;4650.906981860344;4755.262934245163;4781.521847815226;4784.40194975628;4784.784684689197;5095.15929871567;5168.664036837594;5192.065428222881;5224.242484839677;5230.110881150214;5014.247862820606;5026.572741317029;5066.189409694432;5067.949320506821;5123.257127716461;4985.551300382983;5130.461301563357;5141.2545180948555;5156.123459011977;5223.712695801692;4963.90072198554;5042.319286896295;5045.394552653632;5058.519440653132;5097.235414687752;5074.720890351066;5077.543021128043;5092.6435149539175;5096.668716533413;5154.407243167084;3272.2473831018997;3378;3385.39062968668;3390.7793194450473;3427.622961474236;2986.716261955111;3057.480228361184;3071.4932036214223;3094.4894092474938;3103.7672174586546;4699.365585645963;4702.459217190067;4711.269753188261;4720.079584481062;4790.089882922233;4999.75001249936;5135.409427915837;5148.485151484896;5165.096108181053;5214.296070030573;4643.814247430065;4714.175019371665;4719.622430205575;4720.103180395714;4756.16767065769;4189.05746207107;4256.29771087767;4279.079997800488;4313.935290970638;4324.962009117789;4976.701397916209;5049.798008079636;5199.818006369759;5225.529702326809;5234.9476505235225;5068.670536415121;5109;5132.897342053064;5139.280500729826;5183.611229157753;5096.999999999852;5110.182370820651;5154.943236636555;5173.4826517347965;5248.8425347239645;4893.657443978887;5004.274380214775;5026.698398096126;5084.211947148198;5084.491550844886;5031.144705400164;5097.949020509747;5099.796008159632;5106.514881086291;5158.664686795496;5029.145045342228;5042.243663450512;5042.546170844642;5055.87360315995;5103.362079740033;4779.593734532604;4849.612031037579;5041.823536176216;5042.39491261051;5051.267566202807;4848.200046992207;4879.365682461257;4912.92630610534;4940.975295123501;4987;5067.822626208213;5069.543741063322;5111.028904508132;5121.975604879113;5131.435542090442;4788.401449818773;4898.265260210855;5002;5007.799688012438;5014.07239660664 07:55:43 INFO - 2015-10-22 07:55:43,038 DEBUG : BROWSER_OUTPUT: |1;ext.html;551.8151419274543;558.4638746803068;560.4199653358775;565.019690836399;572.0589630058554;29411.558826617616;36194.819025904864;37014.62985370145;37119;37268.25463490729;38354.424683629695;38599;38940.80529597348;38959;39117.80441097797;7400.888986665204;7435.7769266921805;8069.47548409353;8225.835483290331;8226.177382261785;10096.545655445523;10224.642137525188;10318.58725650973;10325.225608079387;10328.380297182193;10175.084242418181;10200;10303.793924121514;10317.380957142595;10327.27709060366;7680.731174408897;7854.293113619801;10124.341917775359;10286.125679317267;10662.733431664194;9996.90003099967;10064.094231519199;10203.489825508768;10210.540525676362;10214.33606815562;29926.55110173349;36848;36934.8153259232;37271.25457490862;37294.25411491782;2531.190019193859;3021.244688827793;3551;3715.1269451678836;3887.358585833334;26588.8670556646;27040;27076.729232707814;27745.167644970683;27805.304867378276;2541.7860256569934;2557.386227305452;2587.133310341038;2593.9092131775487;2683.758461738433;198476;200481;200656;201657;201686;49493.50506494889;49824;49934.75163120951;49937.75031124821;50426.24360634593;54055;54246;54266;54294.72852635712;54336.72831635895;11180.273282236629;12596.81104783429;12773.489060437665;12801.231926084465;12900.419481123372;7893.407994400328;9947.701568952943;10052.69841904744;10467.94766026165;10485.423301718327;16690.49928502147;17591.472255832345;17601.823981760273;17616;17660.646787064186;7744.109427415807;8000.599970001476;8006.83986320282;8051.919480805234;8089.352851771844;962.6245764151986;1033.7002269341956;1046.1055797293357;1069.1126365116934;1076.9025195361717;26308.605370919453;26838.06066787653;26888.59667104995;26919.192424227305;27069.1879243623;1005.261133067195;1007.1841808135433;1011.039512463163;1019.8827134879435;1078.2398409121706;12330.81503777444;12468.376581170905;12581.993440524737;12647.683807904876;12703.745925081446;258155;263271;263295;263492;263832;46437.535624644;46821.29768053482;47033.5296647036;47084;47114.29328560075;1294.2752058847075;1304.5238487951829;1317.762802695505;1318.0444177970894;1325.8011298305332;24750;25277.609731464945;25280.747192528575;25281.87359063193;25306.746932530437;36154.4576831353;36544;40245;46931.76534117308;48797.31614761222;219840;220203;221101;221157;221826;24251.51496970086;27613.72386276192;27843.16470505888;28010.43979120447;28087.157385278475;26950.730492694824;36564.817175915014;37045.62954370422;37079.8146009279;37251.44122838214;29497.410051799274;30167.396652067273;30449.39101217919;30567.388652227277;30587;29914.551281730357;30168.54747178838;31548.369032619677;32391.19022024374;32460.51309230316;30058.84970575133;30597.694023059485;30830.84584577063;31072.53391199179;31141.844290779307;28737.856310719148;29745.553816692332;30019.399612008074;30042.24894377658;30133.84933075408;22866.428339290986;23397.53204935858;23449.41376465602;29482.557761633165;30450.390992180477 07:55:43 INFO - 2015-10-22 07:55:43,049 DEBUG : BROWSER_OUTPUT: |2;jquery.html;347.17892184982514;347.3833944748072;347.5568649971287;353.0907912126272;359.4087725691238;12833.679158021054;13145.962375831738;15560.84439155608;15990.360385584578;17085.57286067849;10172.796544069115;12305.692357691063;16214.432494862682;16287;16296.918515407406;4194.916101677964;4270.807813648377;4273.957260427387;4288.871333859989;4292.828286868522;3257.8696852125886;3323.2356557991557;4247.851325203618;4256.382824490447;4628.768561571925;4645.535446455361;4656.185167595674;4685.882852928687;4686.437627484706;4687.109449204657;4355.912881742347;4547.499775024745;4659.6505262105475;4667.206574882278;4667.579917807397;3919.2357490289405;3964.682825373963;3980.542237642679;3986.3422535281643;3998.960010399888;11862.940685296604;12057.638270851889;12090.214136081127;12105;12131.454084566216;1839.9080045997646;1848.7319338695813;1857.8142185781448;1933.7486126803567;1998.4104689116746;8749.693760718408;8814.250788682906;8819.77950551235;8854.690085847029;9101.180893719596;1686.822883597229;1722.7071397862394;1727.1450631937146;1753.2461041752042;1771.4322824300586;48167.90502946609;48584;51025.234621480704;51771.74114129443;51795.482045179444;5978.8206353809455;6011.068284415923;6030.4572588467245;6048.123022161762;6084.90872636902;6905.309469053054;6981;6981.616011119438;6986.336298051677;6995.475339349569;4713.481517033124;4726.550977657117;4745.145873742759;4810.759462026885;4813.735244561512;4955.677880937727;4958.776855041532;4988.5260900214425;4994.600431965434;4998.375203099613;2803.3692419205518;2821.76015038724;2829.066408085327;2839.063109173968;2849.131015040391;1006.9244806639531;1010.6917390196061;1015.3806178231273;1018.23123541727;1073.88187299397;358.8008655196339;381.0758909644102;391.72970650251233;402.1715266550856;418.76549132485906;9869.358491698016;9987.400755954666;10134.543945522322;10230.181585473145;10266.845997310047;362.5069904929294;397.3959581436201;403.1956247286682;413.81378379729244;421.8228344095487;5446.91829622556;5506.311711036121;5614.775408983676;5690.634247780586;5697.487226149667;400715;415622;415822;416061;417901;60075.39924600785;62213.333999950184;63141.36858631355;63210.68394657997;64722.67638661871;462.69693350855243;466.68731949593854;466.98197928516163;467.0518846741121;467.59085799925066;9451.102145296185;9481.383710058824;9532.332736708364;9590.712278631652;9634.470104144339;28494.85752571224;28682.56976145318;28702.71297287084;29363.265918352212;29368.412631747673;35666;35866.28267434689;36561.26877462383;36957.228207885055;37308.440373393874;5626.409227031103;5732.254806875079;5766;5767.5385969121535;5774.776710966392;10683.198760092868;10841.783164336826;10937.015668589866;10966.670999870017;11036.227464077438;7106.253843346581;7349.4487913407775;8910.86633700482;12803.35983200855;12902.935485322889;13489.662758431117;13550.864491355354;13587;13753.243571603658;13976.510822121583;12884.956104552739;12909.870901290868;13077;13256.337183140611;13303.334833258104;12739.235645861278;12741.299228542519;12906.419211135333;12976;13179.352580927383;13051;13321.600351989457;13539.390727417487;13681.247531385869;13683 07:55:43 INFO - 2015-10-22 07:55:43,049 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1293.7089154940145;1397.9999999999998;1573.7482002879542;1603.9037657740532;1746.6244757377153;7248.13022437307;8202.917970820297;8386.87419688705;8394.62224199911;8420.200080992303;8017.599120044004;8090.231428014344;8097.392695547828;8104.270615644591;8119.797005074876;1861.86036047297;1879.3234435603172;2090.237063471833;2110.1137522240697;2113.8414618903566;2116.2275769344155;2126.3089495913814;2131.1688441507827;2131.1794958940764;2131.7761635028332;2043.2337873297513;2076.6573515370023;2101.2855629086107;2113.725215721954;2117.565898990711;1805.8465030472425;1852.397970659541;2085.165933626546;2125.3836387447623;2132.264368792764;2132.0618927671776;2144;2147.119680930811;2169.9240526581493;2172.6849606806923;8372.943875485465;8433.24100830922;8441.889527618096;8449.957750211272;8455.661773529051;4680.251159814414;4762.023785124041;4764.332993380929;4768.356271903318;4769.666123371366;2675.7993150513594;2683.087750164934;2687.6237326774267;2713.9728602713917;2763.765079968205;805.5086397297644;805.8630032894364;806.6934564865372;827.123249355685;830.3979614779237;11969.581064662694;12166.452509637087;12173.634790956285;12196.451159697835;12216.083793715417;4044.838206471708;4133.483314585676;4144.336906095071;4196.223698615705;4213.199492096492;10012.349197302152;10143.34068285559;10154;10157.339772914736;10158.288919775545;4703.929441058387;4712.31671407644;4713.269443236304;4715.976420117946;4720.457147428021;4126.401671757579;4181.790910454465;4188.539260681384;4192.874213773531;4198.055437526532;3446.6208717041104;3483.529723487297;3522.172289511963;3552.342816578941;3561.0919215600375;1131.7057565032985;1172.1853311948114;1181.5702999370685;1192.540871764377;1195.8804119588146;939.6476321379482;1279.8912092472058;1280.0847394113255;1305.7062161013696;1328.5150919914163;6870.484713646497;7415.221401752846;7801.531908085533;7806.804829879185;7820.257075577811;1095.4960718069776;1096.1011970184372;1105.1876870500175;1111.072254667362;1132.8074227381364;5912.142739302863;5976.282846058414;5998.640081595118;6006.519478441714;6006.729697163638;9857.457839818735;10086.798264034678;10130.08829205375;10159.187265018782;10232.948835255776;10069.295149339476;10073.445960472245;10076.798464030679;10087.394756314645;10092.192624590016;7393.149787774367;7617.581033043236;7639.427042971799;7649.273319034683;7652.1582625912215;7785.221477852169;7799.298063174341;7802.492837965514;7890.171531989058;7916.564588947433;8754.299656027375;8814.471131732116;8883.42257753244;8895.243904268209;8940.68707595231;8975.192232699088;9078.182963533314;9168;9174.633014679604;9203.723888283363;7306.4520160989205;7395.297446742551;7402;7405.296496832792;7405.9629701851145;7669.923300766921;7884.566348850868;7890.053193616803;8245.505269683837;8335.124811894664;7129;7188.820279492846;7276.672549735169;7288.817779555554;7347.448941329315;7381.077365329334;7444.627768611656;7461.291177338144;7462.701491940262;7605.581693006717;7511.887321690069;7556.735514256975;7593.278638529331;7636.618169091635;7663.271989161244;6804.76183333581;6816.522843400914;6817.795466136024;6821.1814582250445;6873.896891546731;6661.3338666132995;6716.966415167893;6721.966390168213;6725.058491811053;6781.796546103625 07:55:43 INFO - 2015-10-22 07:55:43,108 DEBUG : BROWSER_OUTPUT: |4;prototype.html;297.19015682265814;301.43781846855615;307.9076277116866;308.9104159793661;315.2151143652305;5146.073706732786;5147.382314122301;5148.588112950964;5156.1234590119675;5156.149235376163;5086;5089.185730283156;5090.287359769626;5096.923546146811;5115.667481613702;3990.5410877748996;4014;4017.4978127734034;4020.256252593265;4024.175044115964;3862.1310205203745;3947.131631041166;4010.6189911958463;4012.8595499157536;4021.517417909855;3864.111254411487;3899.707521935852;3907.5701672815967;3943;3977.2244412339605;3930.8820735377985;3964.1278918638;3972.1459886124335;3973.205358928197;3973.920521589581;3413.7269018478464;3467.6532346765375;3509.4560343146854;3515.771474854152;3520.929581408383;4884.19410797218;4907.411110666707;4956.603471722289;4964;4968.7018778873025;4420.8673739787855;4458.219811532968;4468.240399132155;4475.507694153641;4480.081583275453;5174.9650069986155;5187.740612969336;5259.815906443256;5261.657992230493;5263.736813159327;3636.4545318202217;3737.4206997915367;3740.17716102457;3741.158239396141;3744.812759362021;5397.811076612339;5406;5408.810691625774;5486.725663716838;5490.6431081979545;3812.961870381316;3816.904577385588;3819.1788765415567;3824.617538246209;3825.9148763923727;3692.907677308035;3783.1487915218854;3791.0332865119217;3851.30676478231;3869.690424766012;4368.301071828492;4399.274119770202;4400.163968845909;4401.471823381151;4414;5210.400803907599;5232.712200828915;5239.371275446971;5241.659292145999;5247.790088396498;1380.3098450774612;1404.4592831759642;1405.184992704229;1405.9507917222847;1406.310907655262;934.2759361494896;949.9265829612493;952.8046750416148;962.8748262725801;962.9470379129215;5027.597792176617;5083.2375143727995;5087.338645976073;5089.949100509021;5092.796288148506;5472.589555783332;5503;5507.7246137692955;5513.117901135799;5514.200440936042;5003.674761140514;5071.721055341992;5073.720945347967;5079.1365467870555;5084.237364395371;2965.4069186162856;3001.4147241288174;3026.9243268918453;3031.2876474028585;3045.0712532677303;5507.917381239285;5510.1459273812625;5523.061079616475;5527.060399732055;5527.695976721319;5612.803551875665;5613.550915926716;5613.663180209201;5623.297087864017;5639.577031722637;5490.917636235459;5519.448055194448;5527.972360138254;5538.086215774432;5538.363088244742;5354.544863686475;5530.364008139116;5538.030844602259;5544.861378465571;5546.362168350692;5392.35291764975;5404.135338346003;5411.567074634098;5413.296271484682;5413.431589683027;5501.229827824188;5534.142207957773;5573.5819813513335;5577.107662773937;5579.637323573955;3774.2074164425776;3797.468354430437;3800.638939300762;3809.942850857184;3812.980935095307;5314.97342513285;5365.946340536545;5396.83809485716;5479.479449452296;5485.424030476902;5274.446183150867;5309.123994541012;5311.548518375981;5329.573634109184;5330.866728331823;5316.468353164652;5322.121849894724;5326.813561525328;5330.120530112643;5334.626576139788;5222.2688823565495;5252.579793616578;5269.4730526947;5269.499397557226;5271.314729085195;5196.844094677166;5252.4747525248695;5280.524752772269;5411.161270003156;5415.675059496442;5262.500062494057;5324.627276090791;5330.227117067926;5334.093204155225;5336.439673834191 07:55:43 INFO - 2015-10-22 07:55:43,109 DEBUG : BROWSER_OUTPUT: |5;yui.html;714.2536049827929;720.8666396716604;758.9886151707724;788.0779487999041;806.3750593290202;11108.389038602874;11283.717907052327;11292.378919159453;11306.547738090478;11346.60286889959;10609.78780424391;10913.781724365528;10928.344299342045;10935.28920620161;10941.343519388842;647.6340867409898;657.3196741372681;809.9959500202491;824.3611201318965;825.8926339575846;784.309807369514;791.6477167660394;792.5046845721424;795.8527672380599;797.5015615240475;674.865026994603;780.1262585903796;846.2172490446343;865.7662431143588;869.7912500999778;680.5644387591946;842.6966292134796;856.8414843254018;858.1547176031667;860.1785295043219;631.204682100552;633.6198281031391;635.6821589205397;637.2480473041809;637.4231320654815;11196.440177991068;11221.66335009951;11237.60668376603;11347;11379.14656400765;9875.90124098757;9883.209343252522;10030.498475076218;10136.797264054678;10406.42764647944;8494.575271236414;8604.655813767442;8620.439671421338;8654.697085602036;8675.305975521944;3293.0779381772904;3308.93382132356;3313.950290745641;3314.8839790607453;3339.3154403347257;29677.70322296771;29714.25714357137;29752;29781.553276700866;29814;8130.3495720342235;8170.264676179172;8314.41799074059;8318;8352.916470835335;14257.50098746539;14483.420663173565;14507.637309067357;14514.709705806035;14520.491782787552;6279.905801412982;6478.157839480931;6527.412532872065;6660.067590537328;6693.665316734144;3804.4293355996824;3819.0834199792407;3853.6531712146043;3855.63371479709;3871.845126194977;2528.658631084817;2547.8598677072937;2579.6517470141666;2579.9226023219335;2584;400.42139108987817;406.0802282829394;406.1187223724525;406.49594502816296;407.5761208343349;450.11103071433655;460.8824749688808;550.2159422822542;580.8673087479432;594.7353427724707;6049.727762250709;7077.610731409822;7377.594232317167;7446.73936412223;7635.961820190974;461.5984093838382;481.02112201669433;520.9088409528393;551.4678335406352;643.6685107169811;3093.6906309369333;3235.9352812943607;3267.134209434502;3293.802371857696;3322.318924620447;38814.22371552553;39197.41203881944;39343.60656393457;39514.604853951096;39702.40446393307;33154.668453315644;33949.490757638654;34129.31741365208;34156.48765268523;34209.82895085558;28631.284217894303;28669.85665071703;28947;29104.742480366822;29224.123276301743;6113.449789518964;6224.533160012927;6251;6285.1515045470105;6385.297617262005;21310.467238318546;21440.785592144504;21465;21472.67790983105;21550.461238469165;29280.41439171247;29449.263768405963;29811.254718632208;29976;30034.549481757353;6597.142371491867;6608.867822643424;6638.701258443285;6680.933190668031;6694.531382803157;9665.9033409665;9803.362781419184;9974.301798874008;9995.450250236307;10218.233632477446;9028.413153145024;9067.183953444222;9095.727128186165;9245.58394872219;9440.527973601154;8324.583770811314;8449.324054075536;8541.402101852811;8585.957070214608;8783.385163038525;8512.063672995842;8600.483970961763;8676.479411235347;8677.522736249566;8734.475931444134;7734.419918506022;8018;8288.59525743365;8330.416870818985;8365;7302.707891684273;7325.597092159983;7374;7412.369948554217;7424.814379640552 07:55:43 INFO - 2015-10-22 07:55:43,111 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:55:43 INFO - 2015-10-22 07:55:43,111 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:55:43 INFO - 2015-10-22 07:55:43,111 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,864 07:55:43 INFO - 2015-10-22 07:55:43,111 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:55:43 INFO - 2015-10-22 07:55:43,111 DEBUG : BROWSER_OUTPUT: __startTimestamp1445525743035__endTimestamp 07:55:43 INFO - 2015-10-22 07:55:43,111 DEBUG : BROWSER_OUTPUT: 07:55:43 INFO - 2015-10-22 07:55:43,111 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:55:43 INFO - 2015-10-22 07:55:43,111 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:55:43 INFO - 2015-10-22 07:55:43,111 DEBUG : BROWSER_OUTPUT: 07:55:43 INFO - 2015-10-22 07:55:43,111 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4714.59 Median:4912.93 stddev:599.35 (12.2%) stddev-sans-first:578.32 07:55:43 INFO - 2015-10-22 07:55:43,111 DEBUG : BROWSER_OUTPUT: Values: 2624.5 2694.3 2706.0 2706.2 2718.6 4818.8 4833.1 4838.7 4879.1 4897.9 4790.8 4856.3 4862.7 4879.4 4923.0 4343.2 4411.4 4413.9 4475.0 4477.2 4414.4 4435.0 4442.2 4442.3 4447.3 4353.8 4365.2 4406.5 4436.8 4438.5 4409.8 4465.9 4469.6 4513.7 4540.8 4439.8 4440.4 4445.1 4486.4 4500.3 4662.7 4769.6 4813.8 4818.2 4823.3 4720.4 5010.6 5014.1 5070.2 5089.1 5141.3 5169.3 5172.3 5179.9 5220.9 4650.9 4755.3 4781.5 4784.4 4784.8 5095.2 5168.7 5192.1 5224.2 5230.1 5014.2 5026.6 5066.2 5067.9 5123.3 4985.6 5130.5 5141.3 5156.1 5223.7 4963.9 5042.3 5045.4 5058.5 5097.2 5074.7 5077.5 5092.6 5096.7 5154.4 3272.2 3378.0 3385.4 3390.8 3427.6 2986.7 3057.5 3071.5 3094.5 3103.8 4699.4 4702.5 4711.3 4720.1 4790.1 4999.8 5135.4 5148.5 5165.1 5214.3 4643.8 4714.2 4719.6 4720.1 4756.2 4189.1 4256.3 4279.1 4313.9 4325.0 4976.7 5049.8 5199.8 5225.5 5234.9 5068.7 5109.0 5132.9 5139.3 5183.6 5097.0 5110.2 5154.9 5173.5 5248.8 4893.7 5004.3 5026.7 5084.2 5084.5 5031.1 5097.9 5099.8 5106.5 5158.7 5029.1 5042.2 5042.5 5055.9 5103.4 4779.6 4849.6 5041.8 5042.4 5051.3 4848.2 4879.4 4912.9 4941.0 4987.0 5067.8 5069.5 5111.0 5122.0 5131.4 4788.4 4898.3 5002.0 5007.8 5014.1 07:55:43 INFO - 2015-10-22 07:55:43,111 DEBUG : BROWSER_OUTPUT: 07:55:43 INFO - 2015-10-22 07:55:43,112 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38714.00 Median:27824.23 stddev:59585.88 (214.2%) stddev-sans-first:59684.13 07:55:43 INFO - 2015-10-22 07:55:43,112 DEBUG : BROWSER_OUTPUT: Values: 551.8 558.5 560.4 565.0 572.1 29411.6 36194.8 37014.6 37119.0 37268.3 38354.4 38599.0 38940.8 38959.0 39117.8 7400.9 7435.8 8069.5 8225.8 8226.2 10096.5 10224.6 10318.6 10325.2 10328.4 10175.1 10200.0 10303.8 10317.4 10327.3 7680.7 7854.3 10124.3 10286.1 10662.7 9996.9 10064.1 10203.5 10210.5 10214.3 29926.6 36848.0 36934.8 37271.3 37294.3 2531.2 3021.2 3551.0 3715.1 3887.4 26588.9 27040.0 27076.7 27745.2 27805.3 2541.8 2557.4 2587.1 2593.9 2683.8 198476.0 200481.0 200656.0 201657.0 201686.0 49493.5 49824.0 49934.8 49937.8 50426.2 54055.0 54246.0 54266.0 54294.7 54336.7 11180.3 12596.8 12773.5 12801.2 12900.4 7893.4 9947.7 10052.7 10467.9 10485.4 16690.5 17591.5 17601.8 17616.0 17660.6 7744.1 8000.6 8006.8 8051.9 8089.4 962.6 1033.7 1046.1 1069.1 1076.9 26308.6 26838.1 26888.6 26919.2 27069.2 1005.3 1007.2 1011.0 1019.9 1078.2 12330.8 12468.4 12582.0 12647.7 12703.7 258155.0 263271.0 263295.0 263492.0 263832.0 46437.5 46821.3 47033.5 47084.0 47114.3 1294.3 1304.5 1317.8 1318.0 1325.8 24750.0 25277.6 25280.7 25281.9 25306.7 36154.5 36544.0 40245.0 46931.8 48797.3 219840.0 220203.0 221101.0 221157.0 221826.0 24251.5 27613.7 27843.2 28010.4 28087.2 26950.7 36564.8 37045.6 37079.8 37251.4 29497.4 30167.4 30449.4 30567.4 30587.0 29914.6 30168.5 31548.4 32391.2 32460.5 30058.8 30597.7 30830.8 31072.5 31141.8 28737.9 29745.6 30019.4 30042.2 30133.8 22866.4 23397.5 23449.4 29482.6 30450.4 07:55:43 INFO - 2015-10-22 07:55:43,112 DEBUG : BROWSER_OUTPUT: 07:55:43 INFO - 2015-10-22 07:55:43,112 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:22214.02 Median:3992.65 stddev:67629.71 (1693.9%) stddev-sans-first:67799.50 07:55:43 INFO - 2015-10-22 07:55:43,114 DEBUG : BROWSER_OUTPUT: Values: 347.2 347.4 347.6 353.1 359.4 12833.7 13146.0 15560.8 15990.4 17085.6 10172.8 12305.7 16214.4 16287.0 16296.9 4194.9 4270.8 4274.0 4288.9 4292.8 3257.9 3323.2 4247.9 4256.4 4628.8 4645.5 4656.2 4685.9 4686.4 4687.1 4355.9 4547.5 4659.7 4667.2 4667.6 3919.2 3964.7 3980.5 3986.3 3999.0 11862.9 12057.6 12090.2 12105.0 12131.5 1839.9 1848.7 1857.8 1933.7 1998.4 8749.7 8814.3 8819.8 8854.7 9101.2 1686.8 1722.7 1727.1 1753.2 1771.4 48167.9 48584.0 51025.2 51771.7 51795.5 5978.8 6011.1 6030.5 6048.1 6084.9 6905.3 6981.0 6981.6 6986.3 6995.5 4713.5 4726.6 4745.1 4810.8 4813.7 4955.7 4958.8 4988.5 4994.6 4998.4 2803.4 2821.8 2829.1 2839.1 2849.1 1006.9 1010.7 1015.4 1018.2 1073.9 358.8 381.1 391.7 402.2 418.8 9869.4 9987.4 10134.5 10230.2 10266.8 362.5 397.4 403.2 413.8 421.8 5446.9 5506.3 5614.8 5690.6 5697.5 400715.0 415622.0 415822.0 416061.0 417901.0 60075.4 62213.3 63141.4 63210.7 64722.7 462.7 466.7 467.0 467.1 467.6 9451.1 9481.4 9532.3 9590.7 9634.5 28494.9 28682.6 28702.7 29363.3 29368.4 35666.0 35866.3 36561.3 36957.2 37308.4 5626.4 5732.3 5766.0 5767.5 5774.8 10683.2 10841.8 10937.0 10966.7 11036.2 7106.3 7349.4 8910.9 12803.4 12902.9 13489.7 13550.9 13587.0 13753.2 13976.5 12885.0 12909.9 13077.0 13256.3 13303.3 12739.2 12741.3 12906.4 12976.0 13179.4 13051.0 13321.6 13539.4 13681.2 13683.0 07:55:43 INFO - 2015-10-22 07:55:43,115 DEBUG : BROWSER_OUTPUT: 07:55:43 INFO - 2015-10-22 07:55:43,115 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5708.32 Median:4766.34 stddev:3175.41 (66.6%) stddev-sans-first:3166.98 07:55:43 INFO - 2015-10-22 07:55:43,115 DEBUG : BROWSER_OUTPUT: Values: 1293.7 1398.0 1573.7 1603.9 1746.6 7248.1 8202.9 8386.9 8394.6 8420.2 8017.6 8090.2 8097.4 8104.3 8119.8 1861.9 1879.3 2090.2 2110.1 2113.8 2116.2 2126.3 2131.2 2131.2 2131.8 2043.2 2076.7 2101.3 2113.7 2117.6 1805.8 1852.4 2085.2 2125.4 2132.3 2132.1 2144.0 2147.1 2169.9 2172.7 8372.9 8433.2 8441.9 8450.0 8455.7 4680.3 4762.0 4764.3 4768.4 4769.7 2675.8 2683.1 2687.6 2714.0 2763.8 805.5 805.9 806.7 827.1 830.4 11969.6 12166.5 12173.6 12196.5 12216.1 4044.8 4133.5 4144.3 4196.2 4213.2 10012.3 10143.3 10154.0 10157.3 10158.3 4703.9 4712.3 4713.3 4716.0 4720.5 4126.4 4181.8 4188.5 4192.9 4198.1 3446.6 3483.5 3522.2 3552.3 3561.1 1131.7 1172.2 1181.6 1192.5 1195.9 939.6 1279.9 1280.1 1305.7 1328.5 6870.5 7415.2 7801.5 7806.8 7820.3 1095.5 1096.1 1105.2 1111.1 1132.8 5912.1 5976.3 5998.6 6006.5 6006.7 9857.5 10086.8 10130.1 10159.2 10232.9 10069.3 10073.4 10076.8 10087.4 10092.2 7393.1 7617.6 7639.4 7649.3 7652.2 7785.2 7799.3 7802.5 7890.2 7916.6 8754.3 8814.5 8883.4 8895.2 8940.7 8975.2 9078.2 9168.0 9174.6 9203.7 7306.5 7395.3 7402.0 7405.3 7406.0 7669.9 7884.6 7890.1 8245.5 8335.1 7129.0 7188.8 7276.7 7288.8 7347.4 7381.1 7444.6 7461.3 7462.7 7605.6 7511.9 7556.7 7593.3 7636.6 7663.3 6804.8 6816.5 6817.8 6821.2 6873.9 6661.3 6717.0 6722.0 6725.1 6781.8 07:55:43 INFO - 2015-10-22 07:55:43,117 DEBUG : BROWSER_OUTPUT: 07:55:43 INFO - 2015-10-22 07:55:43,117 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4466.68 Median:5146.73 stddev:1306.91 (25.4%) stddev-sans-first:1272.56 07:55:43 INFO - 2015-10-22 07:55:43,117 DEBUG : BROWSER_OUTPUT: Values: 297.2 301.4 307.9 308.9 315.2 5146.1 5147.4 5148.6 5156.1 5156.1 5086.0 5089.2 5090.3 5096.9 5115.7 3990.5 4014.0 4017.5 4020.3 4024.2 3862.1 3947.1 4010.6 4012.9 4021.5 3864.1 3899.7 3907.6 3943.0 3977.2 3930.9 3964.1 3972.1 3973.2 3973.9 3413.7 3467.7 3509.5 3515.8 3520.9 4884.2 4907.4 4956.6 4964.0 4968.7 4420.9 4458.2 4468.2 4475.5 4480.1 5175.0 5187.7 5259.8 5261.7 5263.7 3636.5 3737.4 3740.2 3741.2 3744.8 5397.8 5406.0 5408.8 5486.7 5490.6 3813.0 3816.9 3819.2 3824.6 3825.9 3692.9 3783.1 3791.0 3851.3 3869.7 4368.3 4399.3 4400.2 4401.5 4414.0 5210.4 5232.7 5239.4 5241.7 5247.8 1380.3 1404.5 1405.2 1406.0 1406.3 934.3 949.9 952.8 962.9 962.9 5027.6 5083.2 5087.3 5089.9 5092.8 5472.6 5503.0 5507.7 5513.1 5514.2 5003.7 5071.7 5073.7 5079.1 5084.2 2965.4 3001.4 3026.9 3031.3 3045.1 5507.9 5510.1 5523.1 5527.1 5527.7 5612.8 5613.6 5613.7 5623.3 5639.6 5490.9 5519.4 5528.0 5538.1 5538.4 5354.5 5530.4 5538.0 5544.9 5546.4 5392.4 5404.1 5411.6 5413.3 5413.4 5501.2 5534.1 5573.6 5577.1 5579.6 3774.2 3797.5 3800.6 3809.9 3813.0 5315.0 5365.9 5396.8 5479.5 5485.4 5274.4 5309.1 5311.5 5329.6 5330.9 5316.5 5322.1 5326.8 5330.1 5334.6 5222.3 5252.6 5269.5 5269.5 5271.3 5196.8 5252.5 5280.5 5411.2 5415.7 5262.5 5324.6 5330.2 5334.1 5336.4 07:55:43 INFO - 2015-10-22 07:55:43,118 DEBUG : BROWSER_OUTPUT: 07:55:43 INFO - 2015-10-22 07:55:43,118 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:9866.32 Median:6237.77 stddev:10242.79 (164.2%) stddev-sans-first:10248.46 07:55:43 INFO - 2015-10-22 07:55:43,118 DEBUG : BROWSER_OUTPUT: Values: 714.3 720.9 759.0 788.1 806.4 11108.4 11283.7 11292.4 11306.5 11346.6 10609.8 10913.8 10928.3 10935.3 10941.3 647.6 657.3 810.0 824.4 825.9 784.3 791.6 792.5 795.9 797.5 674.9 780.1 846.2 865.8 869.8 680.6 842.7 856.8 858.2 860.2 631.2 633.6 635.7 637.2 637.4 11196.4 11221.7 11237.6 11347.0 11379.1 9875.9 9883.2 10030.5 10136.8 10406.4 8494.6 8604.7 8620.4 8654.7 8675.3 3293.1 3308.9 3314.0 3314.9 3339.3 29677.7 29714.3 29752.0 29781.6 29814.0 8130.3 8170.3 8314.4 8318.0 8352.9 14257.5 14483.4 14507.6 14514.7 14520.5 6279.9 6478.2 6527.4 6660.1 6693.7 3804.4 3819.1 3853.7 3855.6 3871.8 2528.7 2547.9 2579.7 2579.9 2584.0 400.4 406.1 406.1 406.5 407.6 450.1 460.9 550.2 580.9 594.7 6049.7 7077.6 7377.6 7446.7 7636.0 461.6 481.0 520.9 551.5 643.7 3093.7 3235.9 3267.1 3293.8 3322.3 38814.2 39197.4 39343.6 39514.6 39702.4 33154.7 33949.5 34129.3 34156.5 34209.8 28631.3 28669.9 28947.0 29104.7 29224.1 6113.4 6224.5 6251.0 6285.2 6385.3 21310.5 21440.8 21465.0 21472.7 21550.5 29280.4 29449.3 29811.3 29976.0 30034.5 6597.1 6608.9 6638.7 6680.9 6694.5 9665.9 9803.4 9974.3 9995.5 10218.2 9028.4 9067.2 9095.7 9245.6 9440.5 8324.6 8449.3 8541.4 8586.0 8783.4 8512.1 8600.5 8676.5 8677.5 8734.5 7734.4 8018.0 8288.6 8330.4 8365.0 7302.7 7325.6 7374.0 7412.4 7424.8 07:55:43 INFO - 2015-10-22 07:55:43,119 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:55:43 INFO - 2015-10-22 07:55:43,119 DEBUG : BROWSER_OUTPUT: 07:55:43 INFO - 2015-10-22 07:55:43,605 INFO : Browser exited with error code: 0 07:55:44 INFO - 2015-10-22 07:55:44,374 INFO : Completed test dromaeo_css (00:18:41) 07:55:44 INFO - 2015-10-22 07:55:44,374 INFO : Starting test kraken 07:55:44 INFO - 2015-10-22 07:55:44,374 DEBUG : operating with platform_type : w8_ 07:55:44 INFO - 2015-10-22 07:55:44,374 INFO : Initialising browser for kraken test... 07:55:44 INFO - 2015-10-22 07:55:44,395 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmprqpj8f\profile http://localhost:49237/getInfo.html 07:55:50 INFO - 2015-10-22 07:55:50,217 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:55:50 INFO - 2015-10-22 07:55:50,217 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:55:50 INFO - 2015-10-22 07:55:50,217 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674 07:55:50 INFO - 2015-10-22 07:55:50,217 DEBUG : BROWSER_OUTPUT: __metrics 07:55:50 INFO - 2015-10-22 07:55:50,427 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:55:51 INFO - 2015-10-22 07:55:51,914 INFO : Browser initialized. 07:55:51 INFO - 2015-10-22 07:55:51,914 INFO : Running cycle 1/1 for kraken test... 07:55:51 INFO - 2015-10-22 07:55:51,914 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmprqpj8f\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\kraken\kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:56:03 INFO - 2015-10-22 07:56:03,482 DEBUG : BROWSER_OUTPUT: RSS: Main: 198877184 07:56:03 INFO - 2015-10-22 07:56:03,482 DEBUG : BROWSER_OUTPUT: 07:56:06 INFO - 2015-10-22 07:56:06,213 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection) 07:56:06 INFO - 2015-10-22 07:56:06,809 DEBUG : BROWSER_OUTPUT: RSS: Main: 235520000 07:56:06 INFO - 2015-10-22 07:56:06,809 DEBUG : BROWSER_OUTPUT: 07:56:09 INFO - 2015-10-22 07:56:09,469 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-dft) 07:56:10 INFO - 2015-10-22 07:56:10,046 DEBUG : BROWSER_OUTPUT: RSS: Main: 236572672 07:56:10 INFO - 2015-10-22 07:56:10,046 DEBUG : BROWSER_OUTPUT: 07:56:12 INFO - 2015-10-22 07:56:12,734 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-fft) 07:56:13 INFO - 2015-10-22 07:56:13,311 DEBUG : BROWSER_OUTPUT: RSS: Main: 222748672 07:56:13 INFO - 2015-10-22 07:56:13,311 DEBUG : BROWSER_OUTPUT: 07:56:15 INFO - 2015-10-22 07:56:15,414 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator) 07:56:15 INFO - 2015-10-22 07:56:15,990 DEBUG : BROWSER_OUTPUT: RSS: Main: 222928896 07:56:15 INFO - 2015-10-22 07:56:15,990 DEBUG : BROWSER_OUTPUT: 07:56:18 INFO - 2015-10-22 07:56:18,226 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:56:18 INFO - 2015-10-22 07:56:18,782 DEBUG : BROWSER_OUTPUT: RSS: Main: 220651520 07:56:18 INFO - 2015-10-22 07:56:18,782 DEBUG : BROWSER_OUTPUT: 07:56:21 INFO - 2015-10-22 07:56:21,842 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom) 07:56:22 INFO - 2015-10-22 07:56:22,426 DEBUG : BROWSER_OUTPUT: RSS: Main: 214683648 07:56:22 INFO - 2015-10-22 07:56:22,426 DEBUG : BROWSER_OUTPUT: 07:56:25 INFO - 2015-10-22 07:56:25,821 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate) 07:56:26 INFO - 2015-10-22 07:56:26,404 DEBUG : BROWSER_OUTPUT: RSS: Main: 212922368 07:56:26 INFO - 2015-10-22 07:56:26,404 DEBUG : BROWSER_OUTPUT: 07:56:29 INFO - 2015-10-22 07:56:29,269 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial) 07:56:29 INFO - 2015-10-22 07:56:29,851 DEBUG : BROWSER_OUTPUT: RSS: Main: 212504576 07:56:29 INFO - 2015-10-22 07:56:29,851 DEBUG : BROWSER_OUTPUT: 07:56:31 INFO - 2015-10-22 07:56:31,634 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:56:32 INFO - 2015-10-22 07:56:32,200 DEBUG : BROWSER_OUTPUT: RSS: Main: 240852992 07:56:32 INFO - 2015-10-22 07:56:32,200 DEBUG : BROWSER_OUTPUT: 07:56:34 INFO - 2015-10-22 07:56:34,216 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:56:34 INFO - 2015-10-22 07:56:34,798 DEBUG : BROWSER_OUTPUT: RSS: Main: 246018048 07:56:34 INFO - 2015-10-22 07:56:34,798 DEBUG : BROWSER_OUTPUT: 07:56:37 INFO - 2015-10-22 07:56:37,082 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:56:37 INFO - 2015-10-22 07:56:37,667 DEBUG : BROWSER_OUTPUT: RSS: Main: 230371328 07:56:37 INFO - 2015-10-22 07:56:37,667 DEBUG : BROWSER_OUTPUT: 07:56:40 INFO - 2015-10-22 07:56:40,226 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:56:40 INFO - 2015-10-22 07:56:40,809 DEBUG : BROWSER_OUTPUT: RSS: Main: 234049536 07:56:40 INFO - 2015-10-22 07:56:40,809 DEBUG : BROWSER_OUTPUT: 07:56:43 INFO - 2015-10-22 07:56:43,551 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:56:44 INFO - 2015-10-22 07:56:44,134 DEBUG : BROWSER_OUTPUT: RSS: Main: 234172416 07:56:44 INFO - 2015-10-22 07:56:44,134 DEBUG : BROWSER_OUTPUT: 07:56:45 INFO - 2015-10-22 07:56:45,969 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49237/tests/kraken/driver.html?testName=ai-astar) 07:56:46 INFO - 2015-10-22 07:56:46,217 DEBUG : BROWSER_OUTPUT: RSS: Main: 288931840 07:56:46 INFO - 2015-10-22 07:56:46,217 DEBUG : BROWSER_OUTPUT: 07:56:46 INFO - 2015-10-22 07:56:46,219 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:56:46 INFO - 2015-10-22 07:56:46,219 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:56:46 INFO - 2015-10-22 07:56:46,219 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:56:46 INFO - 2015-10-22 07:56:46,219 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:56:46 INFO - 2015-10-22 07:56:46,219 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;112;107;112;112;112;101;112;111;111 07:56:46 INFO - 2015-10-22 07:56:46,219 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;135;128;147;161;131;139;139;130;158;132 07:56:46 INFO - 2015-10-22 07:56:46,219 DEBUG : BROWSER_OUTPUT: |2;audio-dft;141;141;142;140;142;139;139;143;140;139 07:56:46 INFO - 2015-10-22 07:56:46,219 DEBUG : BROWSER_OUTPUT: |3;audio-fft;69;71;72;98;68;69;70;70;102;67 07:56:46 INFO - 2015-10-22 07:56:46,219 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;91;112;92;91;92;120;91;91;121 07:56:46 INFO - 2015-10-22 07:56:46,219 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;114;110;114;110;110;110;111;111;112;111 07:56:46 INFO - 2015-10-22 07:56:46,219 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;131;133;135;132;133;132;132;133;133;137 07:56:46 INFO - 2015-10-22 07:56:46,219 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;96;99;96;96;96;96 07:56:46 INFO - 2015-10-22 07:56:46,219 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;70;71;70;70;69;71;70;82;70;70 07:56:46 INFO - 2015-10-22 07:56:46,219 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;68;68;68;68;68;68;68 07:56:46 INFO - 2015-10-22 07:56:46,220 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;91;90;91;91;94;90;91;90;90;91 07:56:46 INFO - 2015-10-22 07:56:46,220 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;124;126;123;124;131;125;133;126;128;132 07:56:46 INFO - 2015-10-22 07:56:46,220 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;158;149;159;160;164;151;162;157;159;161 07:56:46 INFO - 2015-10-22 07:56:46,220 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;75;74;76;75;75;75;76;77;76;75 07:56:46 INFO - 2015-10-22 07:56:46,220 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:56:46 INFO - 2015-10-22 07:56:46,220 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:56:46 INFO - 2015-10-22 07:56:46,220 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,975 07:56:46 INFO - 2015-10-22 07:56:46,220 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:56:46 INFO - 2015-10-22 07:56:46,220 DEBUG : BROWSER_OUTPUT: __startTimestamp1445525806218__endTimestamp 07:56:46 INFO - 2015-10-22 07:56:46,220 DEBUG : BROWSER_OUTPUT: 07:56:46 INFO - 2015-10-22 07:56:46,223 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:56:46 INFO - 2015-10-22 07:56:46,223 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:56:46 INFO - 2015-10-22 07:56:46,223 DEBUG : BROWSER_OUTPUT: 07:56:46 INFO - 2015-10-22 07:56:46,223 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.90 Median:112.00 stddev:3.54 (3.2%) stddev-sans-first:3.74 07:56:46 INFO - 2015-10-22 07:56:46,223 DEBUG : BROWSER_OUTPUT: Values: 109.0 112.0 107.0 112.0 112.0 112.0 101.0 112.0 111.0 111.0 07:56:46 INFO - 2015-10-22 07:56:46,223 DEBUG : BROWSER_OUTPUT: 07:56:46 INFO - 2015-10-22 07:56:46,223 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:140.00 Median:139.00 stddev:11.69 (8.4%) stddev-sans-first:12.26 07:56:46 INFO - 2015-10-22 07:56:46,223 DEBUG : BROWSER_OUTPUT: Values: 135.0 128.0 147.0 161.0 131.0 139.0 139.0 130.0 158.0 132.0 07:56:46 INFO - 2015-10-22 07:56:46,223 DEBUG : BROWSER_OUTPUT: 07:56:46 INFO - 2015-10-22 07:56:46,223 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:140.60 Median:141.00 stddev:1.43 (1.0%) stddev-sans-first:1.51 07:56:46 INFO - 2015-10-22 07:56:46,223 DEBUG : BROWSER_OUTPUT: Values: 141.0 141.0 142.0 140.0 142.0 139.0 139.0 143.0 140.0 139.0 07:56:46 INFO - 2015-10-22 07:56:46,223 DEBUG : BROWSER_OUTPUT: 07:56:46 INFO - 2015-10-22 07:56:46,223 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:75.60 Median:70.00 stddev:12.97 (18.5%) stddev-sans-first:13.54 07:56:46 INFO - 2015-10-22 07:56:46,223 DEBUG : BROWSER_OUTPUT: Values: 69.0 71.0 72.0 98.0 68.0 69.0 70.0 70.0 102.0 67.0 07:56:46 INFO - 2015-10-22 07:56:46,224 DEBUG : BROWSER_OUTPUT: 07:56:46 INFO - 2015-10-22 07:56:46,224 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:99.20 Median:91.00 stddev:12.96 (14.2%) stddev-sans-first:13.40 07:56:46 INFO - 2015-10-22 07:56:46,224 DEBUG : BROWSER_OUTPUT: Values: 91.0 91.0 112.0 92.0 91.0 92.0 120.0 91.0 91.0 121.0 07:56:46 INFO - 2015-10-22 07:56:46,224 DEBUG : BROWSER_OUTPUT: 07:56:46 INFO - 2015-10-22 07:56:46,224 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:111.30 Median:111.00 stddev:1.57 (1.4%) stddev-sans-first:1.32 07:56:46 INFO - 2015-10-22 07:56:46,224 DEBUG : BROWSER_OUTPUT: Values: 114.0 110.0 114.0 110.0 110.0 110.0 111.0 111.0 112.0 111.0 07:56:46 INFO - 2015-10-22 07:56:46,224 DEBUG : BROWSER_OUTPUT: 07:56:46 INFO - 2015-10-22 07:56:46,224 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:133.10 Median:133.00 stddev:1.73 (1.3%) stddev-sans-first:1.66 07:56:46 INFO - 2015-10-22 07:56:46,224 DEBUG : BROWSER_OUTPUT: Values: 131.0 133.0 135.0 132.0 133.0 132.0 132.0 133.0 133.0 137.0 07:56:46 INFO - 2015-10-22 07:56:46,224 DEBUG : BROWSER_OUTPUT: 07:56:46 INFO - 2015-10-22 07:56:46,224 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.95 (1.0%) stddev-sans-first:1.00 07:56:46 INFO - 2015-10-22 07:56:46,224 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 96.0 99.0 96.0 96.0 96.0 96.0 07:56:46 INFO - 2015-10-22 07:56:46,224 DEBUG : BROWSER_OUTPUT: 07:56:46 INFO - 2015-10-22 07:56:46,226 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.30 Median:70.00 stddev:3.80 (5.4%) stddev-sans-first:4.00 07:56:46 INFO - 2015-10-22 07:56:46,226 DEBUG : BROWSER_OUTPUT: Values: 70.0 71.0 70.0 70.0 69.0 71.0 70.0 82.0 70.0 70.0 07:56:46 INFO - 2015-10-22 07:56:46,226 DEBUG : BROWSER_OUTPUT: 07:56:46 INFO - 2015-10-22 07:56:46,226 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 07:56:46 INFO - 2015-10-22 07:56:46,226 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 68.0 68.0 68.0 68.0 68.0 68.0 68.0 07:56:46 INFO - 2015-10-22 07:56:46,226 DEBUG : BROWSER_OUTPUT: 07:56:46 INFO - 2015-10-22 07:56:46,226 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:90.90 Median:91.00 stddev:1.20 (1.3%) stddev-sans-first:1.27 07:56:46 INFO - 2015-10-22 07:56:46,226 DEBUG : BROWSER_OUTPUT: Values: 91.0 90.0 91.0 91.0 94.0 90.0 91.0 90.0 90.0 91.0 07:56:46 INFO - 2015-10-22 07:56:46,226 DEBUG : BROWSER_OUTPUT: 07:56:46 INFO - 2015-10-22 07:56:46,226 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.20 Median:127.00 stddev:3.61 (2.8%) stddev-sans-first:3.64 07:56:46 INFO - 2015-10-22 07:56:46,226 DEBUG : BROWSER_OUTPUT: Values: 124.0 126.0 123.0 124.0 131.0 125.0 133.0 126.0 128.0 132.0 07:56:46 INFO - 2015-10-22 07:56:46,226 DEBUG : BROWSER_OUTPUT: 07:56:46 INFO - 2015-10-22 07:56:46,226 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.00 Median:159.50 stddev:4.69 (2.9%) stddev-sans-first:4.97 07:56:46 INFO - 2015-10-22 07:56:46,227 DEBUG : BROWSER_OUTPUT: Values: 158.0 149.0 159.0 160.0 164.0 151.0 162.0 157.0 159.0 161.0 07:56:46 INFO - 2015-10-22 07:56:46,227 DEBUG : BROWSER_OUTPUT: 07:56:46 INFO - 2015-10-22 07:56:46,227 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.40 Median:75.50 stddev:0.84 (1.1%) stddev-sans-first:0.88 07:56:46 INFO - 2015-10-22 07:56:46,229 DEBUG : BROWSER_OUTPUT: Values: 75.0 74.0 76.0 75.0 75.0 75.0 76.0 77.0 76.0 75.0 07:56:46 INFO - 2015-10-22 07:56:46,229 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:56:46 INFO - 2015-10-22 07:56:46,229 DEBUG : BROWSER_OUTPUT: 07:56:46 INFO - 2015-10-22 07:56:46,973 INFO : Browser exited with error code: 0 07:56:48 INFO - 2015-10-22 07:56:48,184 INFO : Completed test kraken (00:01:03) 07:56:48 INFO - 2015-10-22 07:56:48,184 INFO : Starting test v8_7 07:56:48 INFO - 2015-10-22 07:56:48,184 DEBUG : operating with platform_type : w8_ 07:56:48 INFO - 2015-10-22 07:56:48,184 INFO : Initialising browser for v8_7 test... 07:56:48 INFO - 2015-10-22 07:56:48,207 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmp4bxj68\profile http://localhost:49237/getInfo.html 07:56:54 INFO - 2015-10-22 07:56:54,154 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:56:54 INFO - 2015-10-22 07:56:54,154 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:56:54 INFO - 2015-10-22 07:56:54,154 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674 07:56:54 INFO - 2015-10-22 07:56:54,154 DEBUG : BROWSER_OUTPUT: __metrics 07:56:54 INFO - 2015-10-22 07:56:54,358 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:56:55 INFO - 2015-10-22 07:56:55,181 DEBUG : BROWSER_OUTPUT: console.error: 07:56:55 INFO - 2015-10-22 07:56:55,181 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] 07:56:55 INFO - 2015-10-22 07:56:55,181 DEBUG : BROWSER_OUTPUT: Stack: 07:56:55 INFO - 2015-10-22 07:56:55,181 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<._executeStatement@resource://gre/modules/Sqlite.jsm:758:19 07:56:55 INFO - 2015-10-22 07:56:55,181 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached/<@resource://gre/modules/Sqlite.jsm:493:9 07:56:55 INFO - 2015-10-22 07:56:55,181 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached@resource://gre/modules/Sqlite.jsm:491:1 07:56:55 INFO - 2015-10-22 07:56:55,181 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeBeforeShutdown/loggedDb<.executeCached.value<@resource://gre/modules/Sqlite.jsm:368:51 07:56:55 INFO - 2015-10-22 07:56:55,181 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 07:56:55 INFO - 2015-10-22 07:56:55,181 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 07:56:55 INFO - 2015-10-22 07:56:55,181 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 07:56:55 INFO - 2015-10-22 07:56:55,183 DEBUG : BROWSER_OUTPUT: transaction@resource://gre/modules/Bookmarks.jsm:783:15 07:56:55 INFO - 2015-10-22 07:56:55,183 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 07:56:55 INFO - 2015-10-22 07:56:55,183 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 07:56:55 INFO - 2015-10-22 07:56:55,183 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 07:56:55 INFO - 2015-10-22 07:56:55,183 DEBUG : BROWSER_OUTPUT: Task_spawn@resource://gre/modules/Task.jsm:164:12 07:56:55 INFO - 2015-10-22 07:56:55,183 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promisedromaeo_css: 6000.58 07:57:31 INFO - RETURN: kraken: 1496.90 07:57:31 INFO - RETURN: v8_7: 20275.16 07:57:31 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,31]]", "result": "20275.16"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,31]]", "result": "1496.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,31]]", "result": "6000.58"}}} 07:57:31 INFO - Return code: 0 07:57:31 INFO - # TBPL SUCCESS # 07:57:31 INFO - Running post-action listener: _resource_record_post_action 07:57:31 INFO - Running post-run listener: _resource_record_post_run 07:57:32 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 127360000; Write bytes: 387904000; Read time: 1573450; Write time: 4261120 07:57:32 INFO - install - Wall time: 2s; CPU: 15.0%; Read bytes: 0; Write bytes: 3626496; Read time: 0; Write time: 44970 07:57:32 INFO - run-tests - Wall time: 1235s; CPU: 13.0%; Read bytes: 127322624; Write bytes: 349146112; Read time: 1572410; Write time: 4174370 07:57:32 INFO - Running post-run listener: _upload_blobber_files 07:57:32 INFO - Blob upload gear active. 07:57:32 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:57:32 INFO - Copying logs to upload dir... 07:57:32 INFO - mkdir: C:\slave\test\build\upload\logs program finished with exit code 0 elapsedTime=1462.485000 ========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 24 mins, 25 secs) (at 2015-10-22 07:57:35.909801) ========= ========= Started set props: build_url (results: 0, elapsed: 6 secs) (at 2015-10-22 07:57:35.913649) ========= '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-155\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-155 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-155 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-155\AppData\Local LOGONSERVER=\\T-W864-IX-155 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-155 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-155 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-155 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False build_url:https://queue.taskcluster.net/v1/task/9ZIk2BkDSd6gGG8dNDCR4Q/artifacts/public/build/firefox-44.0a1.en-US.win64.zip program finished with exit code 0 elapsedTime=0.102000 build_url: 'https://queue.taskcluster.net/v1/task/9ZIk2BkDSd6gGG8dNDCR4Q/artifacts/public/build/firefox-44.0a1.en-US.win64.zip' ========= Finished set props: build_url (results: 0, elapsed: 6 secs) (at 2015-10-22 07:57:42.281764) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 mins, 12 secs) (at 2015-10-22 07:57:42.282144) ========= '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-155\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-155 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-155 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-155\AppData\Local LOGONSERVER=\\T-W864-IX-155 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-155 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-155 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-155 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=0.102000 ========= Finished 'rm -f ...' (results: 0, elapsed: 1 mins, 12 secs) (at 2015-10-22 07:58:54.598055) ========= ========= Started reboot slave lost (results: 0, elapsed: 8 secs) (at 2015-10-22 07:58:54.598365) ========= ========= Finished reboot slave lost (results: 0, elapsed: 8 secs) (at 2015-10-22 07:59:02.818489) =========