builder: fx-team_win8_64_test-dromaeojs slave: t-w864-ix-176 starttime: 1445689186.29 results: success (0) buildid: 20151024040710 builduid: 8fe4458cabbd4d65b7489e7eb9e3e45a revision: f95c614295a0971529da8c0c93d28718e7c4c5bd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-24 05:19:46.294897) ========= master: http://buildbot-master119.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-24 05:19:46.296296) ========= ========= Started set props: basedir (results: 0, elapsed: 1 secs) (at 2015-10-24 05:19:46.296666) ========= 'cd' in dir C:\slave\test\. (timeout 1200 secs) watching logfiles {} argv: ['cd'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-176\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-176 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-176 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-176\AppData\Local LOGONSERVER=\\T-W864-IX-176 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 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-176 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-176 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-176 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False C:\slave\test program finished with exit code 0 elapsedTime=0.662000 basedir: 'C:\\slave\\test' ========= Finished set props: basedir (results: 0, elapsed: 1 secs) (at 2015-10-24 05:19:47.416601) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-24 05:19:47.416976) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-24 05:19:47.513858) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-24 05:19:47.514301) ========= '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-176\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-176 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-176 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-176\AppData\Local LOGONSERVER=\\T-W864-IX-176 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 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-176 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-176 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-176 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=0.302000 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-24 05:19:47.933026) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-24 05:19:47.933362) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-24 05:19:47.934023) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-24 05:19:47.934312) ========= '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-176\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-176 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-176 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-176\AppData\Local LOGONSERVER=\\T-W864-IX-176 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 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-176 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-176 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-176 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False --05:19:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py => `archiver_client.py' Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12,141 (12K) [text/x-python] 0K .......... . 100% 1.84 GB/s 05:19:48 (1.84 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.712000 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-24 05:19:48.809985) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2015-10-24 05:19:48.810275) ========= '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-176\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-176 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-176 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-176\AppData\Local LOGONSERVER=\\T-W864-IX-176 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 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-176 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-176 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-176 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=2.715000 ========= Finished 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2015-10-24 05:19:51.537912) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-10-24 05:19:51.538298) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo integration/fx-team --rev f95c614295a0971529da8c0c93d28718e7c4c5bd --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 f95c614295a0971529da8c0c93d28718e7c4c5bd --destination scripts --debug'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-176\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-176 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-176 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-176\AppData\Local LOGONSERVER=\\T-W864-IX-176 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 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-176 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-176 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-176 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 2015-10-24 05:19:51,434 truncating revision to first 12 chars 2015-10-24 05:19:51,434 Setting DEBUG logging. 2015-10-24 05:19:51,434 attempt 1/10 2015-10-24 05:19:51,434 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f95c614295a0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-10-24 05:19:53,266 unpacking tar archive at: fx-team-f95c614295a0/testing/mozharness/ program finished with exit code 0 elapsedTime=2.700000 ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-10-24 05:19:54.297888) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-24 05:19:54.298257) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-24 05:19:54.313593) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-24 05:19:54.313998) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-24 05:19:54.314535) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 24 mins, 47 secs) (at 2015-10-24 05:19:54.314882) ========= '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-176\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-176 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-176 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-176\AppData\Local LOGONSERVER=\\T-W864-IX-176 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 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-176 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-176 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-176 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 05:19:54 INFO - MultiFileLogger online at 20151024 05:19:54 in C:\slave\test 05:19:54 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 05:19:54 INFO - Dumping config to C:\slave\test\logs\localconfig.json. 05:19:54 INFO - {'append_to_log': False, 05:19:54 INFO - 'base_work_dir': 'C:\\slave\\test', 05:19:54 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:19:54 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt', 05:19:54 INFO - 'branch': 'Fx-Team-Non-PGO', 05:19:54 INFO - 'buildbot_json_path': 'buildprops.json', 05:19:54 INFO - 'config_files': ('talos/windows_config.py',), 05:19:54 INFO - 'default_actions': ('clobber', 05:19:54 INFO - 'read-buildbot-config', 05:19:54 INFO - 'download-and-extract', 05:19:54 INFO - 'populate-webroot', 05:19:54 INFO - 'create-virtualenv', 05:19:54 INFO - 'install', 05:19:54 INFO - 'run-tests'), 05:19:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:19:54 INFO - 'download_minidump_stackwalk': True, 05:19:54 INFO - 'download_symbols': 'ondemand', 05:19:54 INFO - 'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python', 05:19:54 INFO - 'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'), 05:19:54 INFO - 'hg': 'c:/mozilla-build/hg/hg', 05:19:54 INFO - 'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python', 05:19:54 INFO - 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'), 05:19:54 INFO - 'python': 'c:/mozilla-build/python27/python.exe', 05:19:54 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe', 05:19:54 INFO - 'C:/mozilla-build/tooltool.py'), 05:19:54 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe', 05:19:54 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 05:19:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:19:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:19:54 INFO - 'installer_path': 'installer.exe', 05:19:54 INFO - 'log_level': 'info', 05:19:54 INFO - 'log_name': 'talos', 05:19:54 INFO - 'log_to_console': True, 05:19:54 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe', 05:19:54 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe', 05:19:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest', 05:19:54 INFO - 'opt_config_files': (), 05:19:54 INFO - 'pip_index': False, 05:19:54 INFO - 'sps_profile': False, 05:19:54 INFO - 'sps_profile_interval': 0, 05:19:54 INFO - 'suite': 'dromaeojs', 05:19:54 INFO - 'system_bits': '64', 05:19:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:19:54 INFO - 'title': 'T-W864-IX-176', 05:19:54 INFO - 'use_talos_json': True, 05:19:54 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'), 05:19:54 INFO - 'virtualenv_path': 'C:\\slave\\test\\build/venv', 05:19:54 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll', 05:19:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:19:54 INFO - 'work_dir': 'build'} 05:19:54 INFO - ##### 05:19:54 INFO - ##### Running clobber step. 05:19:54 INFO - ##### 05:19:54 INFO - Running pre-action listener: _resource_record_pre_action 05:19:54 INFO - Running main action method: clobber 05:19:54 INFO - rmtree: C:\slave\test\build 05:19:54 INFO - Using _rmtree_windows ... 05:19:54 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1 05:21:59 INFO - Running post-action listener: _resource_record_post_action 05:21:59 INFO - ##### 05:21:59 INFO - ##### Running read-buildbot-config step. 05:21:59 INFO - ##### 05:21:59 INFO - Running pre-action listener: _resource_record_pre_action 05:21:59 INFO - Running main action method: read_buildbot_config 05:21:59 INFO - Using buildbot properties: 05:21:59 INFO - { 05:21:59 INFO - "properties": { 05:21:59 INFO - "buildnumber": 796, 05:21:59 INFO - "product": "firefox", 05:21:59 INFO - "script_repo_revision": "production", 05:21:59 INFO - "builddir": "fx-team_win8_64_test-dromaeojs", 05:21:59 INFO - "repository": "", 05:21:59 INFO - "buildername": "Windows 8 64-bit fx-team talos dromaeojs", 05:21:59 INFO - "buildid": "20151024040710", 05:21:59 INFO - "slavename": "t-w864-ix-176", 05:21:59 INFO - "pgo_build": "False", 05:21:59 INFO - "basedir": "C:\\slave\\test", 05:21:59 INFO - "project": "", 05:21:59 INFO - "platform": "win8_64", 05:21:59 INFO - "master": "http://buildbot-master119.bb.releng.scl3.mozilla.com:8201/", 05:21:59 INFO - "slavebuilddir": "test", 05:21:59 INFO - "scheduler": "tests-fx-team-win64-talos", 05:21:59 INFO - "branch": "fx-team", 05:21:59 INFO - "repo_path": "integration/fx-team", 05:21:59 INFO - "stage_platform": "win64", 05:21:59 INFO - "builduid": "8fe4458cabbd4d65b7489e7eb9e3e45a", 05:21:59 INFO - "revision": "f95c614295a0971529da8c0c93d28718e7c4c5bd" 05:21:59 INFO - }, 05:21:59 INFO - "sourcestamp": { 05:21:59 INFO - "repository": "", 05:21:59 INFO - "hasPatch": false, 05:21:59 INFO - "project": "", 05:21:59 INFO - "branch": "fx-team-win64-talos", 05:21:59 INFO - "changes": [ 05:21:59 INFO - { 05:21:59 INFO - "category": null, 05:21:59 INFO - "files": [ 05:21:59 INFO - { 05:21:59 INFO - "url": null, 05:21:59 INFO - "name": "https://queue.taskcluster.net/v1/task/eTRUg5hYSnePh7U5-I5-IA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip" 05:21:59 INFO - } 05:21:59 INFO - ], 05:21:59 INFO - "repository": "", 05:21:59 INFO - "rev": "f95c614295a0971529da8c0c93d28718e7c4c5bd", 05:21:59 INFO - "who": "vporof@mozilla.com", 05:21:59 INFO - "when": 1445689109, 05:21:59 INFO - "number": 6570048, 05:21:59 INFO - "comments": "Bug 1202657 - Add markers for workers' message passing and serialization/deserialization, r=smaug, jsantell, tromey, ejpbruel", 05:21:59 INFO - "project": "", 05:21:59 INFO - "at": "Sat 24 Oct 2015 05:18:29", 05:21:59 INFO - "branch": "fx-team-win64-talos", 05:21:59 INFO - "revlink": "", 05:21:59 INFO - "properties": [ 05:21:59 INFO - [ 05:21:59 INFO - "buildid", 05:21:59 INFO - "20151024040710", 05:21:59 INFO - "Change" 05:21:59 INFO - ], 05:21:59 INFO - [ 05:21:59 INFO - "builduid", 05:21:59 INFO - "8fe4458cabbd4d65b7489e7eb9e3e45a", 05:21:59 INFO - "Change" 05:21:59 INFO - ], 05:21:59 INFO - [ 05:21:59 INFO - "pgo_build", 05:21:59 INFO - "False", 05:21:59 INFO - "Change" 05:21:59 INFO - ] 05:21:59 INFO - ], 05:21:59 INFO - "revision": "f95c614295a0971529da8c0c93d28718e7c4c5bd" 05:21:59 INFO - } 05:21:59 INFO - ], 05:21:59 INFO - "revision": "f95c614295a0971529da8c0c93d28718e7c4c5bd" 05:21:59 INFO - } 05:21:59 INFO - } 05:21:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/eTRUg5hYSnePh7U5-I5-IA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip. 05:21:59 INFO - Running post-action listener: _resource_record_post_action 05:21:59 INFO - ##### 05:21:59 INFO - ##### Running download-and-extract step. 05:21:59 INFO - ##### 05:21:59 INFO - Running pre-action listener: _resource_record_pre_action 05:21:59 INFO - Running main action method: download_and_extract 05:21:59 INFO - mkdir: C:\slave\test\build\tests 05:21:59 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')]} 05:21:59 INFO - https://queue.taskcluster.net/v1/task/eTRUg5hYSnePh7U5-I5-IA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:21:59 INFO - trying https://queue.taskcluster.net/v1/task/eTRUg5hYSnePh7U5-I5-IA/artifacts/public/build/test_packages.json 05:21:59 INFO - Downloading https://queue.taskcluster.net/v1/task/eTRUg5hYSnePh7U5-I5-IA/artifacts/public/build/test_packages.json to C:\slave\test\build\test_packages.json 05:21:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eTRUg5hYSnePh7U5-I5-IA/artifacts/public/build/test_packages.json', 'file_name': 'C:\\slave\\test\\build\\test_packages.json'}, attempt #1 05:22:00 INFO - Downloaded 1221 bytes. 05:22:00 INFO - Reading from file C:\slave\test\build\test_packages.json 05:22:00 INFO - Using the following test package requirements: 05:22:00 INFO - {u'common': [u'firefox-44.0a1.en-US.win64.common.tests.zip'], 05:22:00 INFO - u'cppunittest': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 05:22:00 INFO - u'firefox-44.0a1.en-US.win64.cppunittest.tests.zip'], 05:22:00 INFO - u'jittest': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 05:22:00 INFO - u'jsshell-win64.zip'], 05:22:00 INFO - u'mochitest': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 05:22:00 INFO - u'firefox-44.0a1.en-US.win64.mochitest.tests.zip'], 05:22:00 INFO - u'mozbase': [u'firefox-44.0a1.en-US.win64.common.tests.zip'], 05:22:00 INFO - u'reftest': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 05:22:00 INFO - u'firefox-44.0a1.en-US.win64.reftest.tests.zip'], 05:22:00 INFO - u'talos': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 05:22:00 INFO - u'firefox-44.0a1.en-US.win64.talos.tests.zip'], 05:22:00 INFO - u'web-platform': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 05:22:00 INFO - u'firefox-44.0a1.en-US.win64.web-platform.tests.zip'], 05:22:00 INFO - u'webapprt': [u'firefox-44.0a1.en-US.win64.common.tests.zip'], 05:22:00 INFO - u'xpcshell': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 05:22:00 INFO - u'firefox-44.0a1.en-US.win64.xpcshell.tests.zip']} 05:22:00 INFO - Downloading packages: [u'firefox-44.0a1.en-US.win64.common.tests.zip'] for test suite category: common 05:22:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:00 INFO - https://queue.taskcluster.net/v1/task/eTRUg5hYSnePh7U5-I5-IA/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip matches https://queue.taskcluster.net 05:22:00 INFO - trying https://queue.taskcluster.net/v1/task/eTRUg5hYSnePh7U5-I5-IA/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip 05:22:00 INFO - Downloading https://queue.taskcluster.net/v1/task/eTRUg5hYSnePh7U5-I5-IA/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 05:22:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eTRUg5hYSnePh7U5-I5-IA/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 05:22:02 INFO - Downloaded 18102606 bytes. 05:22:02 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 05:22:02 INFO - Copy/paste: unzip -q -o C:\slave\test\build\firefox-44.0a1.en-US.win64.common.tests.zip 05:22:02 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 05:22:37 INFO - Return code: 0 05:22:37 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 05:22:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:37 INFO - https://queue.taskcluster.net/v1/task/eTRUg5hYSnePh7U5-I5-IA/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip matches https://queue.taskcluster.net 05:22:37 INFO - trying https://queue.taskcluster.net/v1/task/eTRUg5hYSnePh7U5-I5-IA/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip 05:22:37 INFO - Downloading https://queue.taskcluster.net/v1/task/eTRUg5hYSnePh7U5-I5-IA/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 05:22:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eTRUg5hYSnePh7U5-I5-IA/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 05:22:38 INFO - Downloaded 18102606 bytes. 05:22:38 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win64.common.tests.zip'] in C:\slave\test\build\tests 05:22:38 INFO - Copy/paste: unzip -q -o C:\slave\test\build\firefox-44.0a1.en-US.win64.common.tests.zip 05:22:38 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win64.common.tests.zip'] with output_timeout 1760 ProcessManager UNABLE to use job objects to manage child processes 05:23:04 INFO - Return code: 0 05:23:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:04 INFO - https://queue.taskcluster.net/v1/task/eTRUg5hYSnePh7U5-I5-IA/artifacts/public/build/firefox-44.0a1.en-US.win64.talos.tests.zip matches https://queue.taskcluster.net 05:23:04 INFO - trying https://queue.taskcluster.net/v1/task/eTRUg5hYSnePh7U5-I5-IA/artifacts/public/build/firefox-44.0a1.en-US.win64.talos.tests.zip 05:23:04 INFO - Downloading https://queue.taskcluster.net/v1/task/eTRUg5hYSnePh7U5-I5-IA/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 05:23:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eTRUg5hYSnePh7U5-I5-IA/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 05:23:05 INFO - Downloaded 11131307 bytes. 05:23:05 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 05:23:05 INFO - Copy/paste: unzip -q -o C:\slave\test\build\firefox-44.0a1.en-US.win64.talos.tests.zip 05:23:05 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 05:23:10 INFO - Return code: 0 05:23:10 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')]} 05:23:10 INFO - https://queue.taskcluster.net/v1/task/eTRUg5hYSnePh7U5-I5-IA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip matches https://queue.taskcluster.net 05:23:10 INFO - trying https://queue.taskcluster.net/v1/task/eTRUg5hYSnePh7U5-I5-IA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip 05:23:10 INFO - Downloading https://queue.taskcluster.net/v1/task/eTRUg5hYSnePh7U5-I5-IA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip to C:\slave\test\build\firefox-44.0a1.en-US.win64.zip 05:23:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eTRUg5hYSnePh7U5-I5-IA/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 05:23:12 INFO - Downloaded 54764012 bytes. 05:23:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eTRUg5hYSnePh7U5-I5-IA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip 05:23:12 INFO - mkdir: C:\slave\test\properties 05:23:12 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url 05:23:12 INFO - Writing to file C:\slave\test\properties\build_url 05:23:12 INFO - Contents: 05:23:12 INFO - build_url:https://queue.taskcluster.net/v1/task/eTRUg5hYSnePh7U5-I5-IA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip 05:23:12 INFO - Running post-action listener: _resource_record_post_action 05:23:12 INFO - Running post-action listener: set_extra_try_arguments 05:23:12 INFO - ##### 05:23:12 INFO - ##### Running populate-webroot step. 05:23:12 INFO - ##### 05:23:12 INFO - Running pre-action listener: _resource_record_pre_action 05:23:12 INFO - Running main action method: populate_webroot 05:23:12 INFO - Guessing talos json url... 05:23:12 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')]} 05:23:12 INFO - https://queue.taskcluster.net/v1/task/eTRUg5hYSnePh7U5-I5-IA/artifacts/public/build/firefox-44.0a1.en-US.win64.txt matches https://queue.taskcluster.net 05:23:12 INFO - trying https://queue.taskcluster.net/v1/task/eTRUg5hYSnePh7U5-I5-IA/artifacts/public/build/firefox-44.0a1.en-US.win64.txt 05:23:12 INFO - Downloading https://queue.taskcluster.net/v1/task/eTRUg5hYSnePh7U5-I5-IA/artifacts/public/build/firefox-44.0a1.en-US.win64.txt to C:\slave\test\build\firefox-44.0a1.en-US.win64.txt 05:23:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eTRUg5hYSnePh7U5-I5-IA/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 05:23:12 INFO - Downloaded 103 bytes. 05:23:12 INFO - Reading from file C:\slave\test\build\firefox-44.0a1.en-US.win64.txt 05:23:12 INFO - Contents: 05:23:12 INFO - 20151024040710 05:23:12 INFO - https://hg.mozilla.org/integration/fx-team/rev/f95c614295a0971529da8c0c93d28718e7c4c5bd 05:23:12 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')]} 05:23:12 INFO - trying https://hg.mozilla.org/integration/fx-team/raw-file/f95c614295/testing/talos/talos.json 05:23:12 INFO - Downloading https://hg.mozilla.org/integration/fx-team/raw-file/f95c614295/testing/talos/talos.json to C:\slave\test\build\talos.json 05:23:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/fx-team/raw-file/f95c614295/testing/talos/talos.json', 'file_name': 'C:\\slave\\test\\build\\talos.json'}, attempt #1 05:23:13 INFO - Downloaded 4264 bytes. 05:23:13 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']}, 05:23:13 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']}, 05:23:13 INFO - u'remote-trobocheck2': {u'talos_options': [u'--fennecIDs', 05:23:13 INFO - u'../fennec_ids.txt'], 05:23:13 INFO - u'tests': [u'tcheck2']}, 05:23:13 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome', 05:23:13 INFO - u'--tppagecycles', 05:23:13 INFO - u'7'], 05:23:13 INFO - u'tests': [u'tsvgm']}}, 05:23:13 INFO - u'suites': {u'chromez': {u'tests': [u'tresize', u'tcanvasmark']}, 05:23:13 INFO - u'chromez-e10s': {u'talos_options': [u'--e10s'], 05:23:13 INFO - u'tests': [u'tresize', u'tcanvasmark']}, 05:23:13 INFO - u'dromaeojs': {u'tests': [u'dromaeo_css', u'kraken', u'v8_7']}, 05:23:13 INFO - u'dromaeojs-e10s': {u'talos_options': [u'--e10s'], 05:23:13 INFO - u'tests': [u'dromaeo_css', 05:23:13 INFO - u'kraken', 05:23:13 INFO - u'v8_7']}, 05:23:13 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:13 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 05:23:13 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:13 INFO - u'talos_options': [u'--e10s'], 05:23:13 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 05:23:13 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:13 INFO - u'tests': [u'damp', u'tps']}, 05:23:13 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:13 INFO - u'talos_options': [u'--e10s'], 05:23:13 INFO - u'tests': [u'damp', u'tps']}, 05:23:13 INFO - u'g3': {u'tests': [u'dromaeo_dom']}, 05:23:13 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']}, 05:23:13 INFO - u'other': {u'tests': [u'a11yr', 05:23:13 INFO - u'ts_paint', 05:23:13 INFO - u'tpaint', 05:23:13 INFO - u'sessionrestore', 05:23:13 INFO - u'sessionrestore_no_auto_restore']}, 05:23:13 INFO - u'other-e10s': {u'talos_options': [u'--e10s'], 05:23:13 INFO - u'tests': [u'a11yr', 05:23:13 INFO - u'ts_paint', 05:23:13 INFO - u'tpaint', 05:23:13 INFO - u'sessionrestore', 05:23:13 INFO - u'sessionrestore_no_auto_restore']}, 05:23:13 INFO - u'other-e10s_l64': {u'talos_options': [u'--e10s'], 05:23:13 INFO - u'tests': [u'a11yr', 05:23:13 INFO - u'ts_paint', 05:23:13 INFO - u'tpaint', 05:23:13 INFO - u'sessionrestore', 05:23:13 INFO - u'sessionrestore_no_auto_restore']}, 05:23:13 INFO - u'other-e10s_nol64': {u'talos_options': [u'--e10s'], 05:23:13 INFO - u'tests': [u'a11yr', 05:23:13 INFO - u'ts_paint', 05:23:13 INFO - u'tpaint', 05:23:13 INFO - u'sessionrestore', 05:23:13 INFO - u'sessionrestore_no_auto_restore']}, 05:23:13 INFO - u'other_l64': {u'tests': [u'a11yr', 05:23:13 INFO - u'ts_paint', 05:23:13 INFO - u'tpaint', 05:23:13 INFO - u'sessionrestore', 05:23:13 INFO - u'sessionrestore_no_auto_restore']}, 05:23:13 INFO - u'other_nol64': {u'tests': [u'a11yr', 05:23:13 INFO - u'ts_paint', 05:23:13 INFO - u'tpaint', 05:23:13 INFO - u'sessionrestore', 05:23:13 INFO - u'sessionrestore_no_auto_restore']}, 05:23:13 INFO - u'svgr': {u'tests': [u'tsvgx', 05:23:13 INFO - u'tsvgr_opacity', 05:23:13 INFO - u'tart', 05:23:13 INFO - u'tscrollx', 05:23:13 INFO - u'cart']}, 05:23:13 INFO - u'svgr-e10s': {u'talos_options': [u'--e10s'], 05:23:13 INFO - u'tests': [u'tsvgx', 05:23:13 INFO - u'tsvgr_opacity', 05:23:13 INFO - u'tart', 05:23:13 INFO - u'tscrollx', 05:23:13 INFO - u'cart']}, 05:23:13 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:13 INFO - u'tests': [u'tp5o']}, 05:23:13 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:13 INFO - u'talos_options': [u'--e10s'], 05:23:13 INFO - u'tests': [u'tp5o']}, 05:23:13 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:13 INFO - u'talos_options': [u'--xperf_path', 05:23:13 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:23:13 INFO - u'tests': [u'tp5n']}, 05:23:13 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:13 INFO - u'talos_options': [u'--e10s', 05:23:13 INFO - u'--xperf_path', 05:23:13 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 05:23:13 INFO - u'C:/slave/talos-data/talos/xperf.config'], 05:23:13 INFO - u'tests': [u'tp5n']}}, 05:23:13 INFO - u'talos.zip': {u'path': u'', 05:23:13 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:23:13 INFO - Running post-action listener: _resource_record_post_action 05:23:13 INFO - ##### 05:23:13 INFO - ##### Running create-virtualenv step. 05:23:13 INFO - ##### 05:23:13 INFO - Running pre-action listener: _resource_record_pre_action 05:23:13 INFO - Running main action method: create_virtualenv 05:23:13 INFO - Creating virtualenv C:\slave\test\build/venv 05:23:13 INFO - mkdir: C:\slave\test\build\venv\Scripts 05:23:13 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll 05:23:13 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'! 05:23:13 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 05:23:13 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build/venv 05:23:16 INFO - New python executable in C:\slave\test\build/venv\Scripts\python.exe 05:23:19 INFO - Installing distribute......................................................................................................................................................................................done. 05:23:20 INFO - Return code: 0 05:23:20 INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv 05:23:20 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')]} 05:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:20 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')]} 05:23:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:20 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 0x02382B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023DBEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024970C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x007E8B48>, '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 0x0080A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02869660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-176', 'USERDOMAIN': 'T-W864-IX-176', '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-176', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-176\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-176', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-176', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-176', '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', '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-176\\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 05:23:20 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 05:23:20 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 05:23:20 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 05:23:20 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-176\\AppData\\Roaming', 05:23:20 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 05:23:20 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 05:23:20 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 05:23:20 INFO - 'COMPUTERNAME': 'T-W864-IX-176', 05:23:20 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 05:23:20 INFO - 'DCLOCATION': 'SCL3', 05:23:20 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 05:23:20 INFO - 'FP_NO_HOST_CHECK': 'NO', 05:23:20 INFO - 'HOMEDRIVE': 'C:', 05:23:20 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-176', 05:23:20 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 05:23:20 INFO - 'KTS_VERSION': '1.19c', 05:23:20 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-176\\AppData\\Local', 05:23:20 INFO - 'LOGONSERVER': '\\\\T-W864-IX-176', 05:23:20 INFO - 'MONDIR': 'C:\\Monitor_config\\', 05:23:20 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 05:23:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:20 INFO - 'MOZ_NO_REMOTE': '1', 05:23:20 INFO - 'NO_EM_RESTART': '1', 05:23:20 INFO - 'NUMBER_OF_PROCESSORS': '8', 05:23:20 INFO - 'OS': 'Windows_NT', 05:23:20 INFO - 'OURDRIVE': 'C:', 05:23:20 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', 05:23:20 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 05:23:20 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 05:23:20 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 05:23:20 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 05:23:20 INFO - 'PROCESSOR_LEVEL': '6', 05:23:20 INFO - 'PROCESSOR_REVISION': '1e05', 05:23:20 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 05:23:20 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 05:23:20 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 05:23:20 INFO - 'PROGRAMW6432': 'C:\\Program Files', 05:23:20 INFO - 'PROMPT': '$P$G', 05:23:20 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 05:23:20 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 05:23:20 INFO - 'PUBLIC': 'C:\\Users\\Public', 05:23:20 INFO - 'PWD': 'C:\\slave\\test', 05:23:20 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 05:23:20 INFO - 'SLAVEDIR': 'C:\\slave\\', 05:23:20 INFO - 'SYSTEMDRIVE': 'C:', 05:23:20 INFO - 'SYSTEMROOT': 'C:\\windows', 05:23:20 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 05:23:20 INFO - 'TEST1': 'testie', 05:23:20 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 05:23:20 INFO - 'USERDOMAIN': 'T-W864-IX-176', 05:23:20 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-176', 05:23:20 INFO - 'USERNAME': 'cltbld', 05:23:20 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-176', 05:23:20 INFO - 'WINDIR': 'C:\\windows', 05:23:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 05:23:21 INFO - Ignoring indexes: http://pypi.python.org/simple/ 05:23:21 INFO - Downloading/unpacking pip>=1.5 05:23:21 INFO - Creating supposed download cache at C:\slave\test\build/venv\cache 05:23:26 INFO - Storing download in cache at c:\slave\test\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fpip-1.5.5.tar.gz 05:23:26 INFO - Running setup.py egg_info for package pip 05:23:26 INFO - warning: no files found matching 'pip\cacert.pem' 05:23:26 INFO - warning: no files found matching '*.html' under directory 'docs' 05:23:26 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 05:23:26 INFO - no previously-included directories found matching 'docs\_build\_sources' 05:23:26 INFO - Installing collected packages: pip 05:23:26 INFO - Found existing installation: pip 0.8.2 05:23:26 INFO - Uninstalling pip: 05:23:26 INFO - Successfully uninstalled pip 05:23:26 INFO - Running setup.py install for pip 05:23:26 INFO - warning: no files found matching 'pip\cacert.pem' 05:23:26 INFO - warning: no files found matching '*.html' under directory 'docs' 05:23:26 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 05:23:26 INFO - no previously-included directories found matching 'docs\_build\_sources' 05:23:26 INFO - Installing pip-script.py script to C:\slave\test\build\venv\Scripts 05:23:26 INFO - Installing pip.exe script to C:\slave\test\build\venv\Scripts 05:23:26 INFO - Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts 05:23:26 INFO - Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts 05:23:26 INFO - Installing pip2-script.py script to C:\slave\test\build\venv\Scripts 05:23:26 INFO - Installing pip2.exe script to C:\slave\test\build\venv\Scripts 05:23:26 INFO - Successfully installed pip 05:23:26 INFO - Cleaning up... 05:23:26 INFO - Return code: 0 05:23:26 INFO - Installing psutil>=0.7.1 into virtualenv C:\slave\test\build/venv 05:23: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')]} 05:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23: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')]} 05:23:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23: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', '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 0x02382B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023DBEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024970C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x007E8B48>, '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 0x0080A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02869660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-176', 'USERDOMAIN': 'T-W864-IX-176', '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-176', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-176\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-176', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-176', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-176', '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', '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-176\\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 05:23: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', 'psutil>=0.7.1'] in C:\slave\test\build 05:23: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 psutil>=0.7.1 05:23:26 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 05:23:26 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-176\\AppData\\Roaming', 05:23:26 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 05:23:26 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 05:23:26 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 05:23:26 INFO - 'COMPUTERNAME': 'T-W864-IX-176', 05:23:26 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 05:23:26 INFO - 'DCLOCATION': 'SCL3', 05:23:26 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 05:23:26 INFO - 'FP_NO_HOST_CHECK': 'NO', 05:23:26 INFO - 'HOMEDRIVE': 'C:', 05:23:26 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-176', 05:23:26 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 05:23:26 INFO - 'KTS_VERSION': '1.19c', 05:23:26 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-176\\AppData\\Local', 05:23:26 INFO - 'LOGONSERVER': '\\\\T-W864-IX-176', 05:23:26 INFO - 'MONDIR': 'C:\\Monitor_config\\', 05:23:26 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 05:23:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:26 INFO - 'MOZ_NO_REMOTE': '1', 05:23:26 INFO - 'NO_EM_RESTART': '1', 05:23:26 INFO - 'NUMBER_OF_PROCESSORS': '8', 05:23:26 INFO - 'OS': 'Windows_NT', 05:23:26 INFO - 'OURDRIVE': 'C:', 05:23: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', 05:23:26 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 05:23:26 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 05:23:26 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 05:23:26 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 05:23:26 INFO - 'PROCESSOR_LEVEL': '6', 05:23:26 INFO - 'PROCESSOR_REVISION': '1e05', 05:23:26 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 05:23:26 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 05:23:26 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 05:23:26 INFO - 'PROGRAMW6432': 'C:\\Program Files', 05:23:26 INFO - 'PROMPT': '$P$G', 05:23:26 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 05:23:26 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 05:23:26 INFO - 'PUBLIC': 'C:\\Users\\Public', 05:23:26 INFO - 'PWD': 'C:\\slave\\test', 05:23:26 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 05:23:26 INFO - 'SLAVEDIR': 'C:\\slave\\', 05:23:26 INFO - 'SYSTEMDRIVE': 'C:', 05:23:26 INFO - 'SYSTEMROOT': 'C:\\windows', 05:23:26 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 05:23:26 INFO - 'TEST1': 'testie', 05:23:26 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 05:23:26 INFO - 'USERDOMAIN': 'T-W864-IX-176', 05:23:26 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-176', 05:23:26 INFO - 'USERNAME': 'cltbld', 05:23:26 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-176', 05:23:26 INFO - 'WINDIR': 'C:\\windows', 05:23:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 05:23:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:28 INFO - Downloading/unpacking psutil>=0.7.1 05:23:28 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 05:23:28 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 05:23:29 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 05:23:29 INFO - Installing collected packages: psutil 05:23:29 INFO - Successfully installed psutil 05:23:29 INFO - Cleaning up... 05:23:29 INFO - Return code: 0 05:23:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv C:\slave\test\build/venv 05:23:29 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')]} 05:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:29 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')]} 05:23:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:29 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 0x02382B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023DBEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024970C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x007E8B48>, '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 0x0080A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02869660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-176', 'USERDOMAIN': 'T-W864-IX-176', '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-176', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-176\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-176', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-176', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-176', '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', '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-176\\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 05:23:29 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 05:23:29 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 05:23:29 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 05:23:29 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-176\\AppData\\Roaming', 05:23:29 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 05:23:29 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 05:23:29 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 05:23:29 INFO - 'COMPUTERNAME': 'T-W864-IX-176', 05:23:29 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 05:23:29 INFO - 'DCLOCATION': 'SCL3', 05:23:29 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 05:23:29 INFO - 'FP_NO_HOST_CHECK': 'NO', 05:23:29 INFO - 'HOMEDRIVE': 'C:', 05:23:29 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-176', 05:23:29 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 05:23:29 INFO - 'KTS_VERSION': '1.19c', 05:23:29 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-176\\AppData\\Local', 05:23:29 INFO - 'LOGONSERVER': '\\\\T-W864-IX-176', 05:23:29 INFO - 'MONDIR': 'C:\\Monitor_config\\', 05:23:29 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 05:23:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:29 INFO - 'MOZ_NO_REMOTE': '1', 05:23:29 INFO - 'NO_EM_RESTART': '1', 05:23:29 INFO - 'NUMBER_OF_PROCESSORS': '8', 05:23:29 INFO - 'OS': 'Windows_NT', 05:23:29 INFO - 'OURDRIVE': 'C:', 05:23:29 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', 05:23:29 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 05:23:29 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 05:23:29 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 05:23:29 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 05:23:29 INFO - 'PROCESSOR_LEVEL': '6', 05:23:29 INFO - 'PROCESSOR_REVISION': '1e05', 05:23:29 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 05:23:29 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 05:23:29 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 05:23:29 INFO - 'PROGRAMW6432': 'C:\\Program Files', 05:23:29 INFO - 'PROMPT': '$P$G', 05:23:29 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 05:23:29 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 05:23:29 INFO - 'PUBLIC': 'C:\\Users\\Public', 05:23:29 INFO - 'PWD': 'C:\\slave\\test', 05:23:29 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 05:23:29 INFO - 'SLAVEDIR': 'C:\\slave\\', 05:23:29 INFO - 'SYSTEMDRIVE': 'C:', 05:23:29 INFO - 'SYSTEMROOT': 'C:\\windows', 05:23:29 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 05:23:29 INFO - 'TEST1': 'testie', 05:23:29 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 05:23:29 INFO - 'USERDOMAIN': 'T-W864-IX-176', 05:23:29 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-176', 05:23:29 INFO - 'USERNAME': 'cltbld', 05:23:29 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-176', 05:23:29 INFO - 'WINDIR': 'C:\\windows', 05:23:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 05:23:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:30 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:23:30 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 05:23:30 INFO - Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor 05:23:30 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) 05:23:30 INFO - Installing collected packages: mozsystemmonitor 05:23:30 INFO - Running setup.py install for mozsystemmonitor 05:23:30 INFO - Successfully installed mozsystemmonitor 05:23:30 INFO - Cleaning up... 05:23:31 INFO - Return code: 0 05:23:31 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv 05:23:31 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')]} 05:23:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:31 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')]} 05:23:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:31 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 0x02382B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023DBEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024970C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x007E8B48>, '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 0x0080A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02869660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-176', 'USERDOMAIN': 'T-W864-IX-176', '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-176', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-176\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-176', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-176', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-176', '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', '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-176\\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 05:23:31 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 05:23:31 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 05:23:31 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 05:23:31 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-176\\AppData\\Roaming', 05:23:31 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 05:23:31 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 05:23:31 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 05:23:31 INFO - 'COMPUTERNAME': 'T-W864-IX-176', 05:23:31 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 05:23:31 INFO - 'DCLOCATION': 'SCL3', 05:23:31 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 05:23:31 INFO - 'FP_NO_HOST_CHECK': 'NO', 05:23:31 INFO - 'HOMEDRIVE': 'C:', 05:23:31 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-176', 05:23:31 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 05:23:31 INFO - 'KTS_VERSION': '1.19c', 05:23:31 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-176\\AppData\\Local', 05:23:31 INFO - 'LOGONSERVER': '\\\\T-W864-IX-176', 05:23:31 INFO - 'MONDIR': 'C:\\Monitor_config\\', 05:23:31 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 05:23:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:31 INFO - 'MOZ_NO_REMOTE': '1', 05:23:31 INFO - 'NO_EM_RESTART': '1', 05:23:31 INFO - 'NUMBER_OF_PROCESSORS': '8', 05:23:31 INFO - 'OS': 'Windows_NT', 05:23:31 INFO - 'OURDRIVE': 'C:', 05:23:31 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts', 05:23:31 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 05:23:31 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 05:23:31 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 05:23:31 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 05:23:31 INFO - 'PROCESSOR_LEVEL': '6', 05:23:31 INFO - 'PROCESSOR_REVISION': '1e05', 05:23:31 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 05:23:31 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 05:23:31 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 05:23:31 INFO - 'PROGRAMW6432': 'C:\\Program Files', 05:23:31 INFO - 'PROMPT': '$P$G', 05:23:31 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 05:23:31 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 05:23:31 INFO - 'PUBLIC': 'C:\\Users\\Public', 05:23:31 INFO - 'PWD': 'C:\\slave\\test', 05:23:31 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 05:23:31 INFO - 'SLAVEDIR': 'C:\\slave\\', 05:23:31 INFO - 'SYSTEMDRIVE': 'C:', 05:23:31 INFO - 'SYSTEMROOT': 'C:\\windows', 05:23:31 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 05:23:31 INFO - 'TEST1': 'testie', 05:23:31 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 05:23:31 INFO - 'USERDOMAIN': 'T-W864-IX-176', 05:23:31 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-176', 05:23:31 INFO - 'USERNAME': 'cltbld', 05:23:31 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-176', 05:23:31 INFO - 'WINDIR': 'C:\\windows', 05:23:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 05:23:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:31 INFO - Downloading/unpacking blobuploader==1.2.4 05:23: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 05:23: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 05:23:32 INFO - Downloading blobuploader-1.2.4.tar.gz 05:23:32 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 05:23:32 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader 05:23:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:23: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 05:23: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 05:23:32 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 05:23:32 INFO - Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests 05:23:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:23:33 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 05:23:33 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 05:23:33 INFO - Downloading docopt-0.6.1.tar.gz 05:23:33 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 05:23:33 INFO - Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt 05:23:33 INFO - Installing collected packages: blobuploader, requests, docopt 05:23:33 INFO - Running setup.py install for blobuploader 05:23:33 INFO - Running setup.py install for requests 05:23:34 INFO - Running setup.py install for docopt 05:23:34 INFO - Successfully installed blobuploader requests docopt 05:23:34 INFO - Cleaning up... 05:23:35 INFO - Return code: 0 05:23:35 INFO - Installing None into virtualenv C:\slave\test\build/venv 05:23:35 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')]} 05:23:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:35 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')]} 05:23:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:35 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 0x02382B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023DBEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024970C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x007E8B48>, '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 0x0080A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02869660>, '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-176', 'USERDOMAIN': 'T-W864-IX-176', '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-176', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-176\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-176', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-176', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-176', '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', '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-176\\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 05:23:35 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 05:23:35 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 05:23:35 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 05:23:35 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-176\\AppData\\Roaming', 05:23:35 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 05:23:35 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 05:23:35 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 05:23:35 INFO - 'COMPUTERNAME': 'T-W864-IX-176', 05:23:35 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 05:23:35 INFO - 'DCLOCATION': 'SCL3', 05:23:35 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 05:23:35 INFO - 'FP_NO_HOST_CHECK': 'NO', 05:23:35 INFO - 'HOMEDRIVE': 'C:', 05:23:35 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-176', 05:23:35 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 05:23:35 INFO - 'KTS_VERSION': '1.19c', 05:23:35 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-176\\AppData\\Local', 05:23:35 INFO - 'LOGONSERVER': '\\\\T-W864-IX-176', 05:23:35 INFO - 'MONDIR': 'C:\\Monitor_config\\', 05:23:35 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 05:23:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:35 INFO - 'MOZ_NO_REMOTE': '1', 05:23:35 INFO - 'NO_EM_RESTART': '1', 05:23:35 INFO - 'NUMBER_OF_PROCESSORS': '8', 05:23:35 INFO - 'OS': 'Windows_NT', 05:23:35 INFO - 'OURDRIVE': 'C:', 05:23:35 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', 05:23:35 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 05:23:35 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 05:23:35 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 05:23:35 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 05:23:35 INFO - 'PROCESSOR_LEVEL': '6', 05:23:35 INFO - 'PROCESSOR_REVISION': '1e05', 05:23:35 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 05:23:35 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 05:23:35 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 05:23:35 INFO - 'PROGRAMW6432': 'C:\\Program Files', 05:23:35 INFO - 'PROMPT': '$P$G', 05:23:35 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 05:23:35 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 05:23:35 INFO - 'PUBLIC': 'C:\\Users\\Public', 05:23:35 INFO - 'PWD': 'C:\\slave\\test', 05:23:35 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 05:23:35 INFO - 'SLAVEDIR': 'C:\\slave\\', 05:23:35 INFO - 'SYSTEMDRIVE': 'C:', 05:23:35 INFO - 'SYSTEMROOT': 'C:\\windows', 05:23:35 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 05:23:35 INFO - 'TEST1': 'testie', 05:23:35 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 05:23:35 INFO - 'USERDOMAIN': 'T-W864-IX-176', 05:23:35 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-176', 05:23:35 INFO - 'USERNAME': 'cltbld', 05:23:35 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-176', 05:23:35 INFO - 'WINDIR': 'C:\\windows', 05:23:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 05:23:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:35 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 05:23:35 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-l_f04a-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 05:23:35 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 05:23:35 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-zlvkug-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 05:23:36 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 05:23:36 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-bbmgbp-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 05:23:36 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 05:23:36 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-kkjn22-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 05:23:36 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 05:23:36 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-0wbh9j-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 05:23:36 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 05:23:36 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-wnekon-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 05:23:36 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 05:23:36 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-s4a13n-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 05:23:36 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 05:23:36 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-wmlcfr-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 05:23:36 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 05:23:36 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-adwbok-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 05:23:36 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 05:23:36 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-7dxagu-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 05:23:36 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 05:23:36 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-9kst9p-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 05:23:37 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 05:23:37 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-9mgv2m-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 05:23:37 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 05:23:37 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-6q3pgy-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 05:23:37 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 05:23:37 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-pq9cbi-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 05:23:37 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 05:23:37 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-uexexc-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 05:23:37 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 05:23:37 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-nxfhnh-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 05:23:37 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 05:23:37 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ptksqz-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 05:23:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:23:37 INFO - Running setup.py install for manifestparser 05:23:38 INFO - Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts 05:23:38 INFO - Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts 05:23:38 INFO - Running setup.py install for mozcrash 05:23:38 INFO - Running setup.py install for mozdebug 05:23:39 INFO - Running setup.py install for mozdevice 05:23:39 INFO - Installing sutini-script.py script to C:\slave\test\build\venv\Scripts 05:23:39 INFO - Installing sutini.exe script to C:\slave\test\build\venv\Scripts 05:23:39 INFO - Installing dm-script.py script to C:\slave\test\build\venv\Scripts 05:23:39 INFO - Installing dm.exe script to C:\slave\test\build\venv\Scripts 05:23:39 INFO - Running setup.py install for mozfile 05:23:40 INFO - Running setup.py install for mozhttpd 05:23:40 INFO - Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts 05:23:40 INFO - Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts 05:23:40 INFO - Running setup.py install for mozinfo 05:23:40 INFO - Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts 05:23:40 INFO - Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts 05:23:40 INFO - Running setup.py install for mozInstall 05:23:40 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts 05:23:40 INFO - Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts 05:23:40 INFO - Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts 05:23:40 INFO - Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts 05:23:40 INFO - Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts 05:23:40 INFO - Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts 05:23:40 INFO - Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts 05:23:40 INFO - Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts 05:23:41 INFO - Running setup.py install for mozleak 05:23:41 INFO - Running setup.py install for mozlog 05:23:41 INFO - Installing structlog-script.py script to C:\slave\test\build\venv\Scripts 05:23:41 INFO - Installing structlog.exe script to C:\slave\test\build\venv\Scripts 05:23:42 INFO - Running setup.py install for moznetwork 05:23:42 INFO - Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts 05:23:42 INFO - Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts 05:23:42 INFO - Running setup.py install for mozprocess 05:23:43 INFO - Running setup.py install for mozprofile 05:23:43 INFO - Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts 05:23:43 INFO - Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts 05:23:43 INFO - Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts 05:23:43 INFO - Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts 05:23:43 INFO - Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts 05:23:43 INFO - Installing view-profile.exe script to C:\slave\test\build\venv\Scripts 05:23:44 INFO - Running setup.py install for mozrunner 05:23:44 INFO - Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts 05:23:44 INFO - Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts 05:23:44 INFO - Running setup.py install for mozscreenshot 05:23:45 INFO - Running setup.py install for moztest 05:23:45 INFO - Running setup.py install for mozversion 05:23:45 INFO - Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts 05:23:45 INFO - Installing mozversion.exe script to C:\slave\test\build\venv\Scripts 05:23:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:23:45 INFO - Cleaning up... 05:23:45 INFO - Return code: 0 05:23:45 INFO - Installing None into virtualenv C:\slave\test\build/venv 05:23:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:45 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 0x02382B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023DBEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024970C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x007E8B48>, '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 0x0080A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02869660>, '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-176', 'USERDOMAIN': 'T-W864-IX-176', '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-176', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-176\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-176', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-176', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-176', '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', '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-176\\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 05:23: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 05:23: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 05:23:45 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 05:23:45 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-176\\AppData\\Roaming', 05:23:45 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 05:23:45 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 05:23:45 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 05:23:45 INFO - 'COMPUTERNAME': 'T-W864-IX-176', 05:23:45 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 05:23:45 INFO - 'DCLOCATION': 'SCL3', 05:23:45 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 05:23:45 INFO - 'FP_NO_HOST_CHECK': 'NO', 05:23:45 INFO - 'HOMEDRIVE': 'C:', 05:23:45 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-176', 05:23:45 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 05:23:45 INFO - 'KTS_VERSION': '1.19c', 05:23:45 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-176\\AppData\\Local', 05:23:45 INFO - 'LOGONSERVER': '\\\\T-W864-IX-176', 05:23:45 INFO - 'MONDIR': 'C:\\Monitor_config\\', 05:23:45 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 05:23:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:45 INFO - 'MOZ_NO_REMOTE': '1', 05:23:45 INFO - 'NO_EM_RESTART': '1', 05:23:45 INFO - 'NUMBER_OF_PROCESSORS': '8', 05:23:45 INFO - 'OS': 'Windows_NT', 05:23:45 INFO - 'OURDRIVE': 'C:', 05:23: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', 05:23:45 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 05:23:45 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 05:23:45 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 05:23:45 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 05:23:45 INFO - 'PROCESSOR_LEVEL': '6', 05:23:45 INFO - 'PROCESSOR_REVISION': '1e05', 05:23:45 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 05:23:45 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 05:23:45 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 05:23:45 INFO - 'PROGRAMW6432': 'C:\\Program Files', 05:23:45 INFO - 'PROMPT': '$P$G', 05:23:45 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 05:23:45 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 05:23:45 INFO - 'PUBLIC': 'C:\\Users\\Public', 05:23:45 INFO - 'PWD': 'C:\\slave\\test', 05:23:45 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 05:23:45 INFO - 'SLAVEDIR': 'C:\\slave\\', 05:23:45 INFO - 'SYSTEMDRIVE': 'C:', 05:23:45 INFO - 'SYSTEMROOT': 'C:\\windows', 05:23:45 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 05:23:45 INFO - 'TEST1': 'testie', 05:23:45 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 05:23:45 INFO - 'USERDOMAIN': 'T-W864-IX-176', 05:23:45 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-176', 05:23:45 INFO - 'USERNAME': 'cltbld', 05:23:45 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-176', 05:23:45 INFO - 'WINDIR': 'C:\\windows', 05:23:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 05:23:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:46 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 05:23:46 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ggmuxb-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 05:23:46 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)) 05:23:46 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 05:23:46 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-tobnzd-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 05:23:46 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)) 05:23:46 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 05:23:46 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-kustjv-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 05:23:46 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)) 05:23:46 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 05:23:46 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-na4xza-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 05:23:46 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)) 05:23:46 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 05:23:46 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-yqh0v6-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 05:23:46 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)) 05:23:46 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 05:23:46 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-gklq7b-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 05:23: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)) 05:23:46 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 05:23:46 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-kszyih-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 05:23:47 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)) 05:23:47 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 05:23:47 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-yxqfqg-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 05:23:47 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)) 05:23:47 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 05:23:47 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-dpfkfa-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 05:23:47 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)) 05:23:47 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 05:23:47 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-pzzqhi-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 05:23:47 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)) 05:23:47 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 05:23:47 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-l8n1dc-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 05:23:47 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)) 05:23:47 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 05:23:47 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-9l7ziz-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 05:23:47 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)) 05:23:47 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 05:23:47 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-czfg5b-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 05:23:47 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)) 05:23:47 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 05:23:47 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jwoboj-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 05:23:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///C:/slave/test/build/tests/mozbase/mozrunner in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 14)) 05:23:47 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 05:23:47 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-nlzs5x-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 05:23:48 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)) 05:23:48 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 05:23:48 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-0mido7-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 05:23:48 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)) 05:23:48 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 05:23:48 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-u8tdcb-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 05:23:48 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)) 05:23:48 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)) 05:23:48 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)) 05:23:48 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)) 05:23:48 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)) 05:23:48 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)) 05:23:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10)) 05:23:48 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 05:23:48 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 05:23:49 INFO - Downloading blessings-1.5.1.tar.gz 05:23:49 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 05:23:49 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings 05:23:49 INFO - Installing collected packages: blessings 05:23:49 INFO - Running setup.py install for blessings 05:23:49 INFO - Successfully installed blessings 05:23:49 INFO - Cleaning up... 05:23:52 INFO - Return code: 0 05:23:52 INFO - Done creating virtualenv C:\slave\test\build/venv. 05:23:52 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 05:23:52 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 05:23:52 INFO - Reading from file tmpfile_stdout 05:23:52 INFO - Using _rmtree_windows ... 05:23:52 INFO - Using _rmtree_windows ... 05:23:52 INFO - Current package versions: 05:23:52 INFO - blessings == 1.5.1 05:23:52 INFO - blobuploader == 1.2.4 05:23:52 INFO - docopt == 0.6.1 05:23:52 INFO - manifestparser == 1.1 05:23:52 INFO - mozInstall == 1.12 05:23:52 INFO - mozcrash == 0.16 05:23:52 INFO - mozdebug == 0.1 05:23:52 INFO - mozdevice == 0.46 05:23:52 INFO - mozfile == 1.2 05:23:52 INFO - mozhttpd == 0.7 05:23:52 INFO - mozinfo == 0.8 05:23:52 INFO - mozleak == 0.1 05:23:52 INFO - mozlog == 3.0 05:23:52 INFO - moznetwork == 0.27 05:23:52 INFO - mozprocess == 0.22 05:23:52 INFO - mozprofile == 0.27 05:23:52 INFO - mozrunner == 6.11 05:23:52 INFO - mozscreenshot == 0.1 05:23:52 INFO - mozsystemmonitor == 0.0 05:23:52 INFO - moztest == 0.7 05:23:52 INFO - mozversion == 1.4 05:23:52 INFO - psutil == 3.1.1 05:23:52 INFO - requests == 1.2.3 05:23:52 INFO - Installing None into virtualenv C:\slave\test\build/venv 05:23:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:52 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '-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 0x02382B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x023DBEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x024970C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x007E8B48>, '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 0x0080A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02869660>, '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-176', 'USERDOMAIN': 'T-W864-IX-176', '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-176', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-176\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-176', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-176', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-176', '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', '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-176\\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 05:23:52 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 05:23:52 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 05:23:52 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 05:23:52 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-176\\AppData\\Roaming', 05:23:52 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 05:23:52 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 05:23:52 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 05:23:52 INFO - 'COMPUTERNAME': 'T-W864-IX-176', 05:23:52 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 05:23:52 INFO - 'DCLOCATION': 'SCL3', 05:23:52 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 05:23:52 INFO - 'FP_NO_HOST_CHECK': 'NO', 05:23:52 INFO - 'HOMEDRIVE': 'C:', 05:23:52 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-176', 05:23:52 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 05:23:52 INFO - 'KTS_VERSION': '1.19c', 05:23:52 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-176\\AppData\\Local', 05:23:52 INFO - 'LOGONSERVER': '\\\\T-W864-IX-176', 05:23:52 INFO - 'MONDIR': 'C:\\Monitor_config\\', 05:23:52 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 05:23:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:52 INFO - 'MOZ_NO_REMOTE': '1', 05:23:52 INFO - 'NO_EM_RESTART': '1', 05:23:52 INFO - 'NUMBER_OF_PROCESSORS': '8', 05:23:52 INFO - 'OS': 'Windows_NT', 05:23:52 INFO - 'OURDRIVE': 'C:', 05:23:52 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts', 05:23:52 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 05:23:52 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 05:23:52 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 05:23:52 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 05:23:52 INFO - 'PROCESSOR_LEVEL': '6', 05:23:52 INFO - 'PROCESSOR_REVISION': '1e05', 05:23:52 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 05:23:52 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 05:23:52 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 05:23:52 INFO - 'PROGRAMW6432': 'C:\\Program Files', 05:23:52 INFO - 'PROMPT': '$P$G', 05:23:52 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 05:23:52 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 05:23:52 INFO - 'PUBLIC': 'C:\\Users\\Public', 05:23:52 INFO - 'PWD': 'C:\\slave\\test', 05:23:52 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 05:23:52 INFO - 'SLAVEDIR': 'C:\\slave\\', 05:23:52 INFO - 'SYSTEMDRIVE': 'C:', 05:23:52 INFO - 'SYSTEMROOT': 'C:\\windows', 05:23:52 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 05:23:52 INFO - 'TEST1': 'testie', 05:23:52 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 05:23:52 INFO - 'USERDOMAIN': 'T-W864-IX-176', 05:23:52 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-176', 05:23:52 INFO - 'USERNAME': 'cltbld', 05:23:52 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-176', 05:23:52 INFO - 'WINDIR': 'C:\\windows', 05:23:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 05:23:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:53 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)) 05:23:53 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)) 05:23:53 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)) 05:23:53 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)) 05:23:53 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)) 05:23:53 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)) 05:23:53 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)) 05:23:53 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)) 05:23:53 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)) 05:23:53 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)) 05:23:53 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)) 05:23:53 INFO - Cleaning up... 05:23:53 INFO - Return code: 0 05:23:53 INFO - Running post-action listener: _resource_record_post_action 05:23:53 INFO - Running post-action listener: _start_resource_monitoring 05:23:53 INFO - Starting resource monitoring. 05:23:53 INFO - ##### 05:23:53 INFO - ##### Running install step. 05:23:53 INFO - ##### 05:23:53 INFO - Running pre-action listener: _resource_record_pre_action 05:23:53 INFO - Running main action method: install 05:23:53 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 05:23:53 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 05:23:53 INFO - Reading from file tmpfile_stdout 05:23:53 INFO - Using _rmtree_windows ... 05:23:53 INFO - Using _rmtree_windows ... 05:23:53 INFO - Detecting whether we're running mozinstall >=1.0... 05:23:53 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h'] 05:23:53 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h 05:23:53 INFO - Reading from file tmpfile_stdout 05:23:53 INFO - Output received: 05:23:53 INFO - Usage: mozinstall-script.py [options] installer 05:23:53 INFO - Options: 05:23:53 INFO - -h, --help show this help message and exit 05:23:53 INFO - -d DEST, --destination=DEST 05:23:53 INFO - Directory to install application into. [default: 05:23:53 INFO - "C:\slave\test"] 05:23:53 INFO - --app=APP Application being installed. [default: firefox] 05:23:53 INFO - Using _rmtree_windows ... 05:23:53 INFO - Using _rmtree_windows ... 05:23:53 INFO - mkdir: C:\slave\test\build\application 05:23:53 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'] 05:23:53 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 05:23:55 INFO - Reading from file tmpfile_stdout 05:23:55 INFO - Output received: 05:23:55 INFO - C:\slave\test\build\application\firefox\firefox.exe 05:23:55 INFO - Using _rmtree_windows ... 05:23:55 INFO - Using _rmtree_windows ... 05:23:55 INFO - Running post-action listener: _resource_record_post_action 05:23:55 INFO - ##### 05:23:55 INFO - ##### Running run-tests step. 05:23:55 INFO - ##### 05:23:55 INFO - Running pre-action listener: _resource_record_pre_action 05:23:55 INFO - Running main action method: run_tests 05:23:55 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version'] 05:23:55 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version 05:23:55 INFO - Python 2.7.3 05:23:55 INFO - Return code: 0 05:23:55 INFO - grabbing minidump binary from tooltool 05:23:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:55 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 0x007E8B48>, '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 0x0080A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02869660>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1 05:23:55 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 05:23:55 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 05:23:55 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 05:23:55 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmpqxssgn 05:23:55 INFO - INFO - File integrity verified, renaming tmpqxssgn to win32-minidump_stackwalk.exe 05:23:55 INFO - Return code: 0 05:23:55 INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755 05:23:55 INFO - mkdir: C:\slave\test\build\blobber_upload_dir 05:23:55 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir 05:23:55 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe 05:23:55 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir 05:23:55 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/eTRUg5hYSnePh7U5-I5-IA/artifacts/public/build/firefox-44.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-176', '--webServer', 'localhost'] in C:\slave\test\build 05:23:55 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/eTRUg5hYSnePh7U5-I5-IA/artifacts/public/build/firefox-44.0a1.en-US.win64.crashreporter-symbols.zip --title T-W864-IX-176 --webServer localhost 05:23:55 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 05:23:55 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-176\\AppData\\Roaming', 05:23:55 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 05:23:55 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 05:23:55 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 05:23:55 INFO - 'COMPUTERNAME': 'T-W864-IX-176', 05:23:55 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 05:23:55 INFO - 'DCLOCATION': 'SCL3', 05:23:55 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 05:23:55 INFO - 'FP_NO_HOST_CHECK': 'NO', 05:23:55 INFO - 'HOMEDRIVE': 'C:', 05:23:55 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-176', 05:23:55 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 05:23:55 INFO - 'KTS_VERSION': '1.19c', 05:23:55 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-176\\AppData\\Local', 05:23:55 INFO - 'LOGONSERVER': '\\\\T-W864-IX-176', 05:23:55 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir', 05:23:55 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe', 05:23:55 INFO - 'MONDIR': 'C:\\Monitor_config\\', 05:23:55 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 05:23:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:55 INFO - 'MOZ_NO_REMOTE': '1', 05:23:55 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir', 05:23:55 INFO - 'NO_EM_RESTART': '1', 05:23:55 INFO - 'NUMBER_OF_PROCESSORS': '8', 05:23:55 INFO - 'OS': 'Windows_NT', 05:23:55 INFO - 'OURDRIVE': 'C:', 05:23:55 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts', 05:23:55 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 05:23:55 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 05:23:55 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 05:23:55 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 05:23:55 INFO - 'PROCESSOR_LEVEL': '6', 05:23:55 INFO - 'PROCESSOR_REVISION': '1e05', 05:23:55 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 05:23:55 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 05:23:55 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 05:23:55 INFO - 'PROGRAMW6432': 'C:\\Program Files', 05:23:55 INFO - 'PROMPT': '$P$G', 05:23:55 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 05:23:55 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 05:23:55 INFO - 'PUBLIC': 'C:\\Users\\Public', 05:23:55 INFO - 'PWD': 'C:\\slave\\test', 05:23:55 INFO - 'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos', 05:23:55 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 05:23:55 INFO - 'SLAVEDIR': 'C:\\slave\\', 05:23:55 INFO - 'SYSTEMDRIVE': 'C:', 05:23:55 INFO - 'SYSTEMROOT': 'C:\\windows', 05:23:55 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 05:23:55 INFO - 'TEST1': 'testie', 05:23:55 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 05:23:55 INFO - 'USERDOMAIN': 'T-W864-IX-176', 05:23:55 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-176', 05:23:55 INFO - 'USERNAME': 'cltbld', 05:23:55 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-176', 05:23:55 INFO - 'WINDIR': 'C:\\windows', 05:23:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 05:23:55 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/eTRUg5hYSnePh7U5-I5-IA/artifacts/public/build/firefox-44.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-176', '--webServer', 'localhost'] with output_timeout 3600 ProcessManager NOT managing child processes ProcessManager UNABLE to use job objects to manage child processes 05:23:56 INFO - mozversion INFO | application_buildid: 20151024040710 05:23:56 INFO - mozversion INFO | application_changeset: f95c614295a0971529da8c0c93d28718e7c4c5bd 05:23:56 INFO - mozversion INFO | application_display_name: Nightly 05:23:56 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:23:56 INFO - mozversion INFO | application_name: Firefox 05:23:56 INFO - mozversion INFO | application_remotingname: firefox 05:23:56 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 05:23:56 INFO - mozversion INFO | application_vendor: Mozilla 05:23:56 INFO - mozversion INFO | application_version: 44.0a1 05:23:56 INFO - mozversion INFO | platform_buildid: 20151024040710 05:23:56 INFO - mozversion INFO | platform_changeset: f95c614295a0971529da8c0c93d28718e7c4c5bd 05:23:56 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 05:23:56 INFO - mozversion INFO | platform_version: 44.0a1 05:23:56 INFO - 2015-10-24 05:23:56,778 DEBUG : using testdate: 1445689436 05:23:56 INFO - 2015-10-24 05:23:56,778 DEBUG : actual date: 1445689436 05:23:56 INFO - 2015-10-24 05:23:56,789 INFO : starting webserver on 'localhost:49274' 05:23:56 INFO - 2015-10-24 05:23:56,789 INFO : Starting test suite T-W864-IX-176 05:23:56 INFO - 2015-10-24 05:23:56,789 INFO : Starting test dromaeo_css 05:23:56 INFO - 2015-10-24 05:23:56,789 DEBUG : operating with platform_type : w8_ 05:23:56 INFO - 2015-10-24 05:23:56,790 INFO : Initialising browser for dromaeo_css test... 05:23:56 INFO - 2015-10-24 05:23:56,882 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpjnotst\profile http://localhost:49274/getInfo.html 05:24:11 INFO - 2015-10-24 05:24:11,309 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:24:11 INFO - 2015-10-24 05:24:11,309 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:24:11 INFO - 2015-10-24 05:24:11,309 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674 05:24:11 INFO - 2015-10-24 05:24:11,309 DEBUG : BROWSER_OUTPUT: __metrics 05:24:11 INFO - 2015-10-24 05:24:11,516 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:24:14 INFO - 2015-10-24 05:24:14,079 INFO : Browser initialized. 05:24:14 INFO - 2015-10-24 05:24:14,079 INFO : Running cycle 1/1 for dromaeo_css test... 05:24:14 INFO - 2015-10-24 05:24:14,079 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpjnotst\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:24:25 INFO - 2015-10-24 05:24:25,660 DEBUG : BROWSER_OUTPUT: RSS: Main: 176455680 05:24:25 INFO - 2015-10-24 05:24:25,660 DEBUG : BROWSER_OUTPUT: 05:25:16 INFO - 2015-10-24 05:25:16,934 DEBUG : BROWSER_OUTPUT: 1445689516931 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] 05:27:26 INFO - 2015-10-24 05:27:26,063 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 05:27:27 INFO - 2015-10-24 05:27:27,240 DEBUG : BROWSER_OUTPUT: RSS: Main: 260403200 05:27:27 INFO - 2015-10-24 05:27:27,240 DEBUG : BROWSER_OUTPUT: 05:30:30 INFO - 2015-10-24 05:30:30,335 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 05:30:30 INFO - 2015-10-24 05:30:30,898 DEBUG : BROWSER_OUTPUT: RSS: Main: 219811840 05:30:30 INFO - 2015-10-24 05:30:30,898 DEBUG : BROWSER_OUTPUT: 05:33:33 INFO - 2015-10-24 05:33:33,325 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 05:33:33 INFO - 2015-10-24 05:33:33,888 DEBUG : BROWSER_OUTPUT: RSS: Main: 169472000 05:33:33 INFO - 2015-10-24 05:33:33,888 DEBUG : BROWSER_OUTPUT: 05:36:36 INFO - 2015-10-24 05:36:36,155 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 05:36:36 INFO - 2015-10-24 05:36:36,726 DEBUG : BROWSER_OUTPUT: RSS: Main: 163557376 05:36:36 INFO - 2015-10-24 05:36:36,726 DEBUG : BROWSER_OUTPUT: 05:39:39 INFO - 2015-10-24 05:39:39,671 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 05:39:40 INFO - 2015-10-24 05:39:40,256 DEBUG : BROWSER_OUTPUT: RSS: Main: 168054784 05:39:40 INFO - 2015-10-24 05:39:40,256 DEBUG : BROWSER_OUTPUT: 05:42:43 INFO - 2015-10-24 05:42:43,069 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 05:42:43 INFO - 2015-10-24 05:42:43,321 DEBUG : BROWSER_OUTPUT: RSS: Main: 202502144 05:42:43 INFO - 2015-10-24 05:42:43,321 DEBUG : BROWSER_OUTPUT: 05:42:43 INFO - 2015-10-24 05:42:43,321 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:42:43 INFO - 2015-10-24 05:42:43,321 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:42:43 INFO - 2015-10-24 05:42:43,321 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:42:43 INFO - 2015-10-24 05:42:43,322 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:42:43 INFO - 2015-10-24 05:42:43,322 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2616.738326167383;2675.0503571232225;2701.7298270172987;2705.418335057962;2717.4565086982607;4759.71441713497;4814.1334559779225;4820.734859582722;4830.516948305168;4867.4159100907855;4822.083804077223;4823.107725070864;4825.710457372551;4828.541288577589;4879.43886453058;4210.768407737573;4316.805743741539;4382.364557139221;4382.890427739316;4440.178566965105;4215.030542975118;4369.1916995355805;4383.890402739925;4385.144896745136;4403.251447253974;4271.081717430752;4323.351497275403;4324.84863029794;4335.609795118455;4386.188555117297;4369.257226271541;4384.167008268419;4384.276594361926;4390.05613793036;4432.556744325574;4022.275990321741;4234.576542345741;4340.696151269381;4352.695311328208;4421.801018954155;4749.667523273372;4750.714957102585;4754.857354279377;4759.309900064506;4787.61699064074;5036.597072234213;5036.874078148039;5036.949630503721;5039.521245481674;5042.193249080129;4805.447373552016;4922.114019476493;4975.90048199034;4977.701337919736;5126.282320475137;4647.930281045787;4652.55800698933;4658.417697787777;4670.6497012724185;4722.716637001791;5135.435102138762;5145.279660847485;5153.845384638392;5154.175331946945;5157.149070403341;4701.318308845198;4846.103470857903;4860.6111511079025;4863.148948933923;4937.580305674058;4938.975305123451;4953.356063711766;4953.529414705597;4957.652964292465;5035.597152227813;4886.096072226649;4886.511348865085;4892.3884514435695;4903.779329930162;4963.6525443218625;4684.929726054112;4802.903941921142;4817.397825271841;4900.362952816111;4942.604591632661;3311.0397984584683;3323.7008669219886;3333.633300336961;3350.3131857969056;3384.1708781348725;3076.292452735883;3090.644575873758;3096.783225174216;3113.439580875419;3113.4551453496;4442.73343599385;4491.685582009228;4597.172508948422;4608;4667.089917466129;5036.370453693288;5039.97480012605;5067.442581316052;5068.847934561969;5088.542031217208;4664.790084446208;4665.813367465331;4667.323238130452;4713.410823647044;4721.362616046789;4019.577944315863;4062.5531191568903;4132.566080561498;4139.730917490354;4154.979225103855;5046.217836235316;5067.746612669352;5081.136206844845;5091.8981620367385;5092.159793634083;4963;5067.113255180402;5068.011737711258;5068.9239661405845;5125.461826508312;4852.8301509447;4852.956614327936;5000.349954505891;5000.67495612784;5001.299818025406;4981.576565991786;4985.900281994267;4986.825461108844;4999.325091112653;5016.523430274118;5024.346834911438;5040.445550989315;5048.268001139888;5050.898982020412;5105.030044291572;4639.768011599474;4734.692245004064;4767;4814.374131362901;4939.209726443752;4881.438634556929;4893.804247830047;4918.458969513279;4939;4944.986277813112;4861.416630004422;4863.586595139312;4869.123557759637;4883.096627123993;4914.680545764514;4709.5290470954005;4809.879753006063;4875.561199492063;4880.536349046835;5004.049230646166;4809.759512024455;4810.6632535722165;4839.41926968766;4868.513148685103;4875.098106850244 05:42:43 INFO - 2015-10-24 05:42:43,323 DEBUG : BROWSER_OUTPUT: |1;ext.html;546.8824202796397;561.5760101123651;566.2327546174934;568.7611203294616;569.0496870226721;30187.188768673866;30893;30926.381472370565;36512.45231321525;37893;39952.80023599885;40448;40638.18723625533;40664;40784.79607601958;7913.802154946129;8047.114817370114;8054.154313797055;8054.798630034266;8063.556504392256;7593.506422082574;7757.10793258774;10160.6951791446;10516.106130978838;10535.682149927005;10398.064174224319;10419.635312764054;10496.527656255486;10515.789684206311;10531.473426328654;7687.2697093776005;7883.0934442539265;10237.641682541112;10327.638532651321;10349.172066234722;10254.53854576546;10431.269811113225;10531.210159238011;10533.736656583571;10537.84193237102;37870;38296.61703382986;38389.808050959844;38442.231155376736;38504.037399065244;2764.032588593996;2769.6399468069226;2846.60147579337;2874.3101655602504;2908.5637154426795;28190.154295371172;28194.85902570474;28200.576991345148;28425.57361639577;28482.287942801388;2661.9866900665565;2699.6625421822273;2703.7296270373004;2788.247173263228;2802.887884484618;224958;225861;226015;226043;226118;53442.465575344526;54463;56082.43917560854;57228;57235.427645723845;52061;52071;52148;52389.7380513095;52472.21291680628;13143.53997610079;13191.868081319257;13305.800412993813;13354.93322533381;13413.530526431528;9660;9680.128788409076;9789.070038346346;9830.852537211947;9842.704718858446;18650.440486785417;18656.81343186578;18713.345032923782;18721.90639046796;18764.530886727942;7201.459890508233;7409.813455397791;7502.924970750332;7620.314171724572;7744.993150890348;866.7009881590841;922.6309476209569;939.6852054561798;1025.933314334566;1025.9894004405655;26700.866495667397;26711.732882671313;27202.055701923506;27336.179914602595;27493.037743678877;983.2134292565919;1018.1345856022322;1034.095166729112;1090.155129774431;1100.4827730966433;12986.220826750425;13109.475620975245;13315.933420332836;13344.399502022432;13344.866551334362;282470;287355;287805;288483;288744;50870.49129508732;50966.745166274675;50972.235416468044;51035;51144.488555114716;1284.6724085358173;1286.5689993852163;1294.3204817470714;1312.3831799054428;1323.9801402978962;25876.223713288633;26483.73516264813;26503.204903852915;26524.734752652228;26535.734642653326;45245.321320179566;46382;46437.76781116073;46462;46656.7667161662;175583;176979;178285;178411;178872.10563947097;23093.769062309162;23192.652110218696;27268.72731272662;30067;30224.09327720172;36223.818880905426;36276.45585316275;36602;36769.26461470809;36886.815565922;32332;33916.83041584776;34201.31597367989;34368.48447273243;36977.07557311089;26178;28037.00325216156;30788.53817192789;35891.820540898174;37499.625003749614;34159.829200853834;34170;34552.82723586366;34766.30467390689;34898.651013490555;28800.279993000342;30313.696863031088;30626.92805751788;30801;30937.381252374376;23366;23473.54002739474;23781.881090594437;23840.403989899696;23845.761542384353 05:42:43 INFO - 2015-10-24 05:42:43,323 DEBUG : BROWSER_OUTPUT: |2;jquery.html;354.1977421141116;357.5941306616989;357.5994885727984;360.44671429355947;365.46824370540867;13099.345032748372;13443.395047222873;14954.252287385641;15873.206339683013;17158.914205428955;15036.24818759063;15167.241637918087;16152.676946461064;16185.271662775174;16202.513924582252;4602.884927876797;4728.66899317048;4729.550692684206;4734.171519984006;5099.668521546107;3261.739060875136;3324.634290228073;4730.172219861528;6391.712372943229;6601.801945941629;6442.549021568492;6581.868362632745;6591.11020012297;6597.868042639145;6603.768868089618;6524.347565243485;6554.279029306773;6571.047198156289;6573.046908198285;6575.671216439207;5919.6152250103605;6098.512119030467;6114.755409783604;6238.844028899269;6249.2813326467585;21433.892830535904;21611.891940540198;21729.74053891913;22072.117115315366;22106.44733881666;1901.2014953719472;1988.35378501986;2059.794020597928;2074.481379655086;2184.4429670433938;13123.29409651355;13305.53430629933;13473.658996661503;13693.315334233248;13818.516351927734;1790.5523619095227;1815.482587462567;1823.5076529337136;1869.6915009023494;1970.9113089910988;56389.95125609299;56659.433405665826;56744;56941;57763;14416.567502974927;14431.567052988426;14437.35031923566;14472.131672099707;14480.203588802717;7070.257622949619;7084.25615310385;21010.68882422932;21061;21120.78879211188;4765.118453086121;4821.2045012572535;4833.709977401367;4984.90030199394;4990.201567749215;5162.432132465426;5176.3270774799785;5207.817726379634;5232.058229518647;5234.712090834964;2769.1000424862;2910.199695083869;2915;2920.2115428834095;2931.2412552468772;1062.9574817007388;1069.9572017119228;1082.8105081610686;1083.7182332593582;1123.8145705958589;363.60003995604626;410.86441474313403;427.20113387964085;431.8251108301143;434.3918514080313;8426.873596896052;9315.627374904929;9649.276304277208;9835.16401105914;10395.324303920372;402.1936018283323;404.8158088069921;420.8232542332167;421.4016097142066;423.15580417068145;5265.842024739264;5280.498352656491;5287.154055351125;5314.3091398117995;5364.7049412282695;390371;390988;447552;462950;466659;63462.36537634657;65196.674016629615;65808.34191658118;66670;67577;469.71582192773565;471.7829798292824;474.077918448621;474.75312837324395;476.6020372988524;9883.406995580288;9988.950055249677;9993.450360230258;10028.389779679455;10125.898741012496;29385;29539.704602953694;29849.55225671573;30020.399592008474;30201;39756.60243397529;39935.40096898607;39954.60045399509;40470.1905961885;40571;5947.573096641871;6039.4262545058145;6059.182010428536;6069.575129740876;6075.119107729266;8181.509109453452;8602.225799678059;11080.889191107986;11189.272697274651;11310.94344528272;1962.42108577967;4711.976440117777;7943.682252709827;9202.579639629665;9468.905310947079;8316.41785075039;8800.339974502065;8876.245519130945;8903.3322500814;9355.672551460666;8833;9031.187193152648;9128.406653567497;9250;9257.67598134062;6101.389861013863;6137.539684523589;6168.444839964424;6226;6227.844303892439;9850.162736167505;9900.653477128266;9911.603535858485;10023.398596084258;10112.84830727525 05:42:43 INFO - 2015-10-24 05:42:43,323 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1419.205245062765;1666.5000499850046;1685.1995302231442;1822.526143202767;1866.7106598477233;8229.547374894386;8455.32357411407;8477;8488.151184881517;8524.488530688148;8276.83446331073;8309.83380332393;8321;8331.500109993405;8349.41554091214;2120.766715661276;2161.945951351221;2161.956760864786;2179.3788770200495;2186.3331683836423;2230.308604332662;2230.5984922713906;2231.8884055797225;2241.1707668162803;2241.8991145398495;1875.6998880179174;1897.354899334226;2133.5306232628873;2146.1737231165957;2187.2781981946;2145.152664697451;2146.645803442446;2163.242864997254;2166.7833216678364;2167.5231449081257;2049.7027930950076;2111.7360329958756;2129.4037669452578;2136.198925402974;2138.2622995066677;7338.889916651255;7617.923820761777;8182.836343273101;8479.364047696448;8481.151884811532;4700.55344742249;4700.600448961843;4774.069056533977;4775.761211939389;4784.378030855966;2818;2884.567314902781;2885.177724348551;2909.461749576335;2909.563565465176;845.1252953193415;869.7129947117436;873.6068769053951;876.2114097312406;894.4096896048577;12153.696157596043;12210.32843193624;12253.326067066308;12255.325957072268;12274.447649855778;4208.957910420857;4262.9786851066165;4307.461567304087;4313.956860431418;4346.239408103569;10284.845727314096;10302.896971030345;10318.535665895053;10323.174146068297;10327.173826093895;4796.136695394863;4799.856004319876;4801.351817504592;4802.303665968485;4803.759812009385;4315.352697095398;4317.050248945227;4320.870373888788;4333.804978775963;4335.176316499855;3698.7965661888315;3717.312297224968;3735.495708079429;3783.6783873370523;3797.373433383516;1195.6950977500683;1202.9594400843207;1207.9577214797616;1208.8186771984272;1217.3243849663345;1090.4765712457906;1110.9277896936674;1112.8887111288807;1173.2256710570982;1225.7425940552585;7501.737439189602;7635.923640763633;7706.651336016174;7754.961225193838;7760.68957241704;449.22732899412955;459.88732760473897;464.06490920794624;465.9836905708284;466.5008440968131;5524.779008839601;5924.229850119457;5994.7602095916545;6001.099835024694;6013.4888534474185;9770.706878793648;10075.171434854708;10228.07947284733;10255.7436064099;10282.640107596199;10088.445135517617;10110;10135.239857010754;10141.594336226468;10241.180705543538;7722.3049925506975;7761.534307941542;7782.610869456505;7786.844263114593;7789.221077892165;7357.705691772269;7536.5101268417375;7575.6969721210535;7652.540847548942;7687.0391201099865;8741.781455463664;8895.110488951053;8950.552472376225;8973.37186396972;8989.370744047854;8724.607392667473;9148.405353652257;9157.175854173156;9223.58493867791;9228.169464748205;7162.7493037743425;7393.852122957618;7473.140588832354;7508.436867235088;7526.887096693664;7990.480618759762;8096.757097287091;8101.473404228706;8107.878381824159;8111.148329425326;7397.534485492344;7482.700691972478;7605.859121131653;7613.276738709814;7695.422843286664;7394.112706475257;7498.62506874665;7649.732259370895;7681.807954801175;7719.691212351443;7552.320291173821;7600.087989441303;7608.16310205888;7612.619369031416;7622.589820883154;6505.934940650533;6540.771073012422;6544.116544266463;6552.3447655236005;6554.377334153248;6437.356264373712;6614.8346291343105;6615.900761488485;6618.404343609098;6645.9003114954285 05:42:43 INFO - 2015-10-24 05:42:43,391 DEBUG : BROWSER_OUTPUT: |4;prototype.html;317.57603599195073;323.2323232323231;324.5877735276199;331.7230112855766;331.95518604988337;5102.260172275018;5136.972605478901;5142.974285128578;5165.0702873482805;5168.2764412982115;5078.289039534459;5083.466236045218;5084.644074914748;5085.618578606601;5093.388793344804;4033.314336562784;4039.838406463738;4040.252553277653;4044.8988775280704;4048.75707457552;4030.2946984277783;4036.2129384769983;4036.2331157080207;4038.9394159087637;4041.2523683118716;3836.6163383661687;3858.9002134391703;3860.768353898775;3912.7065470089856;3959.742616729903;3974.105826189113;3993.7004724645476;3993.860214892494;3995.3807159890116;3995.8002099895034;3478.3565040467342;3502.859885604573;3503.562054743157;3531.611522732497;3534.9823250883583;4740.454847692525;4820.590249828769;4887.535684110004;4908.852734417973;4975.60195184388;4448.421705178306;4463.620592249663;4466.977665111654;4467.285234362519;4472.552744725534;5269.1832765921345;5271.077561426735;5271.65734227274;5273.156294992821;5274.973625131888;3686.5760437549757;3712.888613341604;3718.5537735471644;3724.0503671563847;3730.5150330457136;5324.41431442541;5397.217403476474;5527.55779537636;5532.446755324436;5534.723263836792;3851.30676478231;3858.324793161242;3859.208862183246;3864.555576108727;3874.9731321199906;3844.615538446189;3850.9037274067814;3851.345271303885;3904.1996390739832;3909.863154789569;4373.322135069069;4440.3117516784305;4443.577860103285;4443.777811109431;4447.2217361962175;5148.382194136728;5213.348331458567;5317.255584218213;5327;5328.094223981932;1392.6031081141825;1436.6767477317728;1436.7342041722316;1441.2721575604462;1441.8486058963867;959.3332633819568;959.5921733263335;971.9805603887883;980.1472718734747;993.3195760903805;4961.3798275215595;5012.548870601663;5043.84868453947;5050.065737838511;5050.4949505049935;5431.049566325956;5434.8913021739345;5460.836174914759;5511.3937466878615;5516.393196748354;4958.082754690394;4997.425296090923;5034.295198672189;5041.59667226621;5043.344365232496;2966.6440027196873;3015.1708280223115;3034.24143964009;3044.939101217963;3046.7105624965593;5506;5506.724663766796;5510.228568000483;5515.972420137874;5516.227728117987;5454.8909021819345;5491.588130890199;5544.473275038865;5622.32532096151;5632.831015069554;5498.1752737088955;5507.284053073075;5516.503514683698;5523.420040895809;5523.475269849358;5463.399026107046;5485.177223416519;5494.478024587658;5495.697736624524;5497.202905578589;5259.763310651107;5333.253344531691;5372.811951581676;5374.220737993047;5388.057090009154;5441.891162176655;5487.094629386106;5489;5504.036793561191;5508.972455137859;3765.794945617376;3850.9614903851725;3880.3597406428753;3902.297586434469;3915.1778126593736;5524.613277070566;5527.309086364205;5530.834074977757;5537.2524709163745;5539.584531160099;5305.363356397257;5392.568594512508;5394.433584473573;5412.296401467784;5413.756380962945;5337.22610221508;5391.4608539145775;5391.649542779864;5396.946030539644;5399.541039011728;5301.840944771663;5316.202569614588;5318.893622127458;5319.095753721799;5326.14781634952;5255.3168088148295;5345.786168553214;5372.677639341652;5381.461853814587;5392.487713667196;5308.787648494172;5320.388155362183;5320.574354051744;5325;5326.946730532645 05:42:43 INFO - 2015-10-24 05:42:43,391 DEBUG : BROWSER_OUTPUT: |5;yui.html;692.1452006771636;702.2801628330964;756.8902509136177;787.8424315136972;812.7642983534776;13060.346982650864;13491.123077000013;13491.52779652711;13499.595012149626;13500.932495337534;12375.44310506027;12412.875871241285;12418.81371779424;12441;12452.501899924015;659.9967000164993;670.778643047793;797.5453991225004;817.2277198047832;829.3531045784267;819.9467034642729;820.8563501387233;828.718235799828;828.7265202483196;829.0217543298905;842.8988521377444;849.7110982266029;850.0437008365589;851.7742798158492;853.4111463090447;681.6727970574127;695.4679670052388;825.69449303758;844.5397258494136;853.0403296291672;617.102116420607;620.9006558950591;622.4149299658307;622.4802290087782;623.0498489803041;11665.24175928562;11779.941100294529;11792.292462452195;11802.232854864493;11809.114316426216;8148.307393871528;8489.363297752694;8596.140385961417;8712.607932643046;9150.542472876396;8519.361047921431;8541.188587084218;8741.912580874174;8760.211580957744;8817.118288171132;2854.6431696037994;2913.1115009921964;2930.106317573139;2940.338423854637;2942.4262268857583;30153.547696784564;30329.848350758326;30377.544336834966;30676;30705;6389.712462939179;6458.709358078898;6481.48148148147;6493.9934310182;6524.7390104396245;10135.695929122137;10138.949305253427;10143.08712215904;10153;10163;5506.091494903296;5566.248556444828;5653.943460565424;5669;5732.054211055212;3639.5632524097277;3661.3043521730788;3701.3892707702926;3713.962860371362;3751.381022131318;2252.4594097416502;2253.842231043844;2275.067222438792;2279.270633397297;2280.395695140756;390.77139873174514;400.27749911410183;400.4433836966619;439.27300317973805;452.1003203624763;580.599386423375;618.5021058048225;623.2801114712514;628.9494763698985;678.7522554267756;7101.786946391617;7172.569645821268;7197.100362454693;7966.5220086793815;8141.470804397695;499.5279460909406;542.8859939412768;546.2134526282141;601.8916595012852;661.22966743743;3446.9827650861585;3478.8608455661997;3559.8042107684328;3564.982175089108;3578.3737845876867;38007.239855202744;38029.42955855664;38040.61959380426;38380.616193838265;38817.805910970266;33106.834465828;33184.50223246653;33204.83397582997;33225.501617475755;33234.66765332364;28250.43499130047;28427;28547.429051418854;28622.856885715853;28690.426191476054;6720.294369091175;6759.560628559325;6786.287439818945;6793.252742198453;6801.9319806801295;20910.68633970461;21174.89412552989;21418.678719819527;21644.35066947994;21739.891300543397;27837.44325113446;27921.86039069873;28554.286142846595;28912.566311505765;29027.12918612445;6547.148870646785;6652.767153149616;6671.8665626686225;6769.763058292936;6816.931830681629;9343.252539796937;9600.519974001412;9695.22438204956;9709.6601618943;9804.950975245078;9515.096065873731;9721.319507634398;9729.367591106555;9834.114929656365;10253.641122560974;9416.246700264099;9416.905830941603;9446.338756286994;9555.9044409555;9801.558929848032;8960.417572857743;9015.2787776979;9334.859977100485;9387.624495020396;9743.415395076318;8315.667373305;8338;8362.540060296742;8377.45546539473;8403.831923361377;8416.4950102994;8557.914420855712;8558.743237702878;8630.439021463584;8747.16901894319 05:42:43 INFO - 2015-10-24 05:42:43,392 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:42:43 INFO - 2015-10-24 05:42:43,392 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:42:43 INFO - 2015-10-24 05:42:43,392 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,945 05:42:43 INFO - 2015-10-24 05:42:43,392 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:42:43 INFO - 2015-10-24 05:42:43,392 DEBUG : BROWSER_OUTPUT: __startTimestamp1445690563320__endTimestamp 05:42:43 INFO - 2015-10-24 05:42:43,394 DEBUG : BROWSER_OUTPUT: 05:42:43 INFO - 2015-10-24 05:42:43,394 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:42:43 INFO - 2015-10-24 05:42:43,394 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:42:43 INFO - 2015-10-24 05:42:43,394 DEBUG : BROWSER_OUTPUT: 05:42:43 INFO - 2015-10-24 05:42:43,394 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4618.12 Median:4823.11 stddev:573.10 (11.9%) stddev-sans-first:552.93 05:42:43 INFO - 2015-10-24 05:42:43,394 DEBUG : BROWSER_OUTPUT: Values: 2616.7 2675.1 2701.7 2705.4 2717.5 4759.7 4814.1 4820.7 4830.5 4867.4 4822.1 4823.1 4825.7 4828.5 4879.4 4210.8 4316.8 4382.4 4382.9 4440.2 4215.0 4369.2 4383.9 4385.1 4403.3 4271.1 4323.4 4324.8 4335.6 4386.2 4369.3 4384.2 4384.3 4390.1 4432.6 4022.3 4234.6 4340.7 4352.7 4421.8 4749.7 4750.7 4754.9 4759.3 4787.6 5036.6 5036.9 5036.9 5039.5 5042.2 4805.4 4922.1 4975.9 4977.7 5126.3 4647.9 4652.6 4658.4 4670.6 4722.7 5135.4 5145.3 5153.8 5154.2 5157.1 4701.3 4846.1 4860.6 4863.1 4937.6 4939.0 4953.4 4953.5 4957.7 5035.6 4886.1 4886.5 4892.4 4903.8 4963.7 4684.9 4802.9 4817.4 4900.4 4942.6 3311.0 3323.7 3333.6 3350.3 3384.2 3076.3 3090.6 3096.8 3113.4 3113.5 4442.7 4491.7 4597.2 4608.0 4667.1 5036.4 5040.0 5067.4 5068.8 5088.5 4664.8 4665.8 4667.3 4713.4 4721.4 4019.6 4062.6 4132.6 4139.7 4155.0 5046.2 5067.7 5081.1 5091.9 5092.2 4963.0 5067.1 5068.0 5068.9 5125.5 4852.8 4853.0 5000.3 5000.7 5001.3 4981.6 4985.9 4986.8 4999.3 5016.5 5024.3 5040.4 5048.3 5050.9 5105.0 4639.8 4734.7 4767.0 4814.4 4939.2 4881.4 4893.8 4918.5 4939.0 4945.0 4861.4 4863.6 4869.1 4883.1 4914.7 4709.5 4809.9 4875.6 4880.5 5004.0 4809.8 4810.7 4839.4 4868.5 4875.1 05:42:43 INFO - 2015-10-24 05:42:43,394 DEBUG : BROWSER_OUTPUT: 05:42:43 INFO - 2015-10-24 05:42:43,394 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39630.08 Median:288613.50 stddev:61100.76 (21.2%) stddev-sans-first:61201.69 05:42:43 INFO - 2015-10-24 05:42:43,394 DEBUG : BROWSER_OUTPUT: Values: 546.9 561.6 566.2 568.8 569.0 30187.2 30893.0 30926.4 36512.5 37893.0 39952.8 40448.0 40638.2 40664.0 40784.8 7913.8 8047.1 8054.2 8054.8 8063.6 7593.5 7757.1 10160.7 10516.1 10535.7 10398.1 10419.6 10496.5 10515.8 10531.5 7687.3 7883.1 10237.6 10327.6 10349.2 10254.5 10431.3 10531.2 10533.7 10537.8 37870.0 38296.6 38389.8 38442.2 38504.0 2764.0 2769.6 2846.6 2874.3 2908.6 28190.2 28194.9 28200.6 28425.6 28482.3 2662.0 2699.7 2703.7 2788.2 2802.9 224958.0 225861.0 226015.0 226043.0 226118.0 53442.5 54463.0 56082.4 57228.0 57235.4 52061.0 52071.0 52148.0 52389.7 52472.2 13143.5 13191.9 13305.8 13354.9 13413.5 9660.0 9680.1 9789.1 9830.9 9842.7 18650.4 18656.8 18713.3 18721.9 18764.5 7201.5 7409.8 7502.9 7620.3 7745.0 866.7 922.6 939.7 1025.9 1026.0 26700.9 26711.7 27202.1 27336.2 27493.0 983.2 1018.1 1034.1 1090.2 1100.5 12986.2 13109.5 13315.9 13344.4 13344.9 282470.0 287355.0 287805.0 288483.0 288744.0 50870.5 50966.7 50972.2 51035.0 51144.5 1284.7 1286.6 1294.3 1312.4 1324.0 25876.2 26483.7 26503.2 26524.7 26535.7 45245.3 46382.0 46437.8 46462.0 46656.8 175583.0 176979.0 178285.0 178411.0 178872.1 23093.8 23192.7 27268.7 30067.0 30224.1 36223.8 36276.5 36602.0 36769.3 36886.8 32332.0 33916.8 34201.3 34368.5 36977.1 26178.0 28037.0 30788.5 35891.8 37499.6 34159.8 34170.0 34552.8 34766.3 34898.7 28800.3 30313.7 30626.9 30801.0 30937.4 23366.0 23473.5 23781.9 23840.4 23845.8 05:42:43 INFO - 2015-10-24 05:42:43,394 DEBUG : BROWSER_OUTPUT: 05:42:43 INFO - 2015-10-24 05:42:43,394 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23619.74 Median:470.75 stddev:70924.52 (15066.3%) stddev-sans-first:71101.96 05:42:43 INFO - 2015-10-24 05:42:43,395 DEBUG : BROWSER_OUTPUT: Values: 354.2 357.6 357.6 360.4 365.5 13099.3 13443.4 14954.3 15873.2 17158.9 15036.2 15167.2 16152.7 16185.3 16202.5 4602.9 4728.7 4729.6 4734.2 5099.7 3261.7 3324.6 4730.2 6391.7 6601.8 6442.5 6581.9 6591.1 6597.9 6603.8 6524.3 6554.3 6571.0 6573.0 6575.7 5919.6 6098.5 6114.8 6238.8 6249.3 21433.9 21611.9 21729.7 22072.1 22106.4 1901.2 1988.4 2059.8 2074.5 2184.4 13123.3 13305.5 13473.7 13693.3 13818.5 1790.6 1815.5 1823.5 1869.7 1970.9 56390.0 56659.4 56744.0 56941.0 57763.0 14416.6 14431.6 14437.4 14472.1 14480.2 7070.3 7084.3 21010.7 21061.0 21120.8 4765.1 4821.2 4833.7 4984.9 4990.2 5162.4 5176.3 5207.8 5232.1 5234.7 2769.1 2910.2 2915.0 2920.2 2931.2 1063.0 1070.0 1082.8 1083.7 1123.8 363.6 410.9 427.2 431.8 434.4 8426.9 9315.6 9649.3 9835.2 10395.3 402.2 404.8 420.8 421.4 423.2 5265.8 5280.5 5287.2 5314.3 5364.7 390371.0 390988.0 447552.0 462950.0 466659.0 63462.4 65196.7 65808.3 66670.0 67577.0 469.7 471.8 474.1 474.8 476.6 9883.4 9989.0 9993.5 10028.4 10125.9 29385.0 29539.7 29849.6 30020.4 30201.0 39756.6 39935.4 39954.6 40470.2 40571.0 5947.6 6039.4 6059.2 6069.6 6075.1 8181.5 8602.2 11080.9 11189.3 11310.9 1962.4 4712.0 7943.7 9202.6 9468.9 8316.4 8800.3 8876.2 8903.3 9355.7 8833.0 9031.2 9128.4 9250.0 9257.7 6101.4 6137.5 6168.4 6226.0 6227.8 9850.2 9900.7 9911.6 10023.4 10112.8 05:42:43 INFO - 2015-10-24 05:42:43,398 DEBUG : BROWSER_OUTPUT: 05:42:43 INFO - 2015-10-24 05:42:43,398 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5742.37 Median:4800.60 stddev:3197.32 (66.6%) stddev-sans-first:3189.78 05:42:43 INFO - 2015-10-24 05:42:43,398 DEBUG : BROWSER_OUTPUT: Values: 1419.2 1666.5 1685.2 1822.5 1866.7 8229.5 8455.3 8477.0 8488.2 8524.5 8276.8 8309.8 8321.0 8331.5 8349.4 2120.8 2161.9 2162.0 2179.4 2186.3 2230.3 2230.6 2231.9 2241.2 2241.9 1875.7 1897.4 2133.5 2146.2 2187.3 2145.2 2146.6 2163.2 2166.8 2167.5 2049.7 2111.7 2129.4 2136.2 2138.3 7338.9 7617.9 8182.8 8479.4 8481.2 4700.6 4700.6 4774.1 4775.8 4784.4 2818.0 2884.6 2885.2 2909.5 2909.6 845.1 869.7 873.6 876.2 894.4 12153.7 12210.3 12253.3 12255.3 12274.4 4209.0 4263.0 4307.5 4314.0 4346.2 10284.8 10302.9 10318.5 10323.2 10327.2 4796.1 4799.9 4801.4 4802.3 4803.8 4315.4 4317.1 4320.9 4333.8 4335.2 3698.8 3717.3 3735.5 3783.7 3797.4 1195.7 1203.0 1208.0 1208.8 1217.3 1090.5 1110.9 1112.9 1173.2 1225.7 7501.7 7635.9 7706.7 7755.0 7760.7 449.2 459.9 464.1 466.0 466.5 5524.8 5924.2 5994.8 6001.1 6013.5 9770.7 10075.2 10228.1 10255.7 10282.6 10088.4 10110.0 10135.2 10141.6 10241.2 7722.3 7761.5 7782.6 7786.8 7789.2 7357.7 7536.5 7575.7 7652.5 7687.0 8741.8 8895.1 8950.6 8973.4 8989.4 8724.6 9148.4 9157.2 9223.6 9228.2 7162.7 7393.9 7473.1 7508.4 7526.9 7990.5 8096.8 8101.5 8107.9 8111.1 7397.5 7482.7 7605.9 7613.3 7695.4 7394.1 7498.6 7649.7 7681.8 7719.7 7552.3 7600.1 7608.2 7612.6 7622.6 6505.9 6540.8 6544.1 6552.3 6554.4 6437.4 6614.8 6615.9 6618.4 6645.9 05:42:43 INFO - 2015-10-24 05:42:43,398 DEBUG : BROWSER_OUTPUT: 05:42:43 INFO - 2015-10-24 05:42:43,398 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4477.89 Median:5119.62 stddev:1298.48 (25.4%) stddev-sans-first:1264.02 05:42:43 INFO - 2015-10-24 05:42:43,398 DEBUG : BROWSER_OUTPUT: Values: 317.6 323.2 324.6 331.7 332.0 5102.3 5137.0 5143.0 5165.1 5168.3 5078.3 5083.5 5084.6 5085.6 5093.4 4033.3 4039.8 4040.3 4044.9 4048.8 4030.3 4036.2 4036.2 4038.9 4041.3 3836.6 3858.9 3860.8 3912.7 3959.7 3974.1 3993.7 3993.9 3995.4 3995.8 3478.4 3502.9 3503.6 3531.6 3535.0 4740.5 4820.6 4887.5 4908.9 4975.6 4448.4 4463.6 4467.0 4467.3 4472.6 5269.2 5271.1 5271.7 5273.2 5275.0 3686.6 3712.9 3718.6 3724.1 3730.5 5324.4 5397.2 5527.6 5532.4 5534.7 3851.3 3858.3 3859.2 3864.6 3875.0 3844.6 3850.9 3851.3 3904.2 3909.9 4373.3 4440.3 4443.6 4443.8 4447.2 5148.4 5213.3 5317.3 5327.0 5328.1 1392.6 1436.7 1436.7 1441.3 1441.8 959.3 959.6 972.0 980.1 993.3 4961.4 5012.5 5043.8 5050.1 5050.5 5431.0 5434.9 5460.8 5511.4 5516.4 4958.1 4997.4 5034.3 5041.6 5043.3 2966.6 3015.2 3034.2 3044.9 3046.7 5506.0 5506.7 5510.2 5516.0 5516.2 5454.9 5491.6 5544.5 5622.3 5632.8 5498.2 5507.3 5516.5 5523.4 5523.5 5463.4 5485.2 5494.5 5495.7 5497.2 5259.8 5333.3 5372.8 5374.2 5388.1 5441.9 5487.1 5489.0 5504.0 5509.0 3765.8 3851.0 3880.4 3902.3 3915.2 5524.6 5527.3 5530.8 5537.3 5539.6 5305.4 5392.6 5394.4 5412.3 5413.8 5337.2 5391.5 5391.6 5396.9 5399.5 5301.8 5316.2 5318.9 5319.1 5326.1 5255.3 5345.8 5372.7 5381.5 5392.5 5308.8 5320.4 5320.6 5325.0 5326.9 05:42:43 INFO - 2015-10-24 05:42:43,400 DEBUG : BROWSER_OUTPUT: 05:42:43 INFO - 2015-10-24 05:42:43,400 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:9781.77 Median:622.77 stddev:10065.88 (1616.3%) stddev-sans-first:10070.96 05:42:43 INFO - 2015-10-24 05:42:43,400 DEBUG : BROWSER_OUTPUT: Values: 692.1 702.3 756.9 787.8 812.8 13060.3 13491.1 13491.5 13499.6 13500.9 12375.4 12412.9 12418.8 12441.0 12452.5 660.0 670.8 797.5 817.2 829.4 819.9 820.9 828.7 828.7 829.0 842.9 849.7 850.0 851.8 853.4 681.7 695.5 825.7 844.5 853.0 617.1 620.9 622.4 622.5 623.0 11665.2 11779.9 11792.3 11802.2 11809.1 8148.3 8489.4 8596.1 8712.6 9150.5 8519.4 8541.2 8741.9 8760.2 8817.1 2854.6 2913.1 2930.1 2940.3 2942.4 30153.5 30329.8 30377.5 30676.0 30705.0 6389.7 6458.7 6481.5 6494.0 6524.7 10135.7 10138.9 10143.1 10153.0 10163.0 5506.1 5566.2 5653.9 5669.0 5732.1 3639.6 3661.3 3701.4 3714.0 3751.4 2252.5 2253.8 2275.1 2279.3 2280.4 390.8 400.3 400.4 439.3 452.1 580.6 618.5 623.3 628.9 678.8 7101.8 7172.6 7197.1 7966.5 8141.5 499.5 542.9 546.2 601.9 661.2 3447.0 3478.9 3559.8 3565.0 3578.4 38007.2 38029.4 38040.6 38380.6 38817.8 33106.8 33184.5 33204.8 33225.5 33234.7 28250.4 28427.0 28547.4 28622.9 28690.4 6720.3 6759.6 6786.3 6793.3 6801.9 20910.7 21174.9 21418.7 21644.4 21739.9 27837.4 27921.9 28554.3 28912.6 29027.1 6547.1 6652.8 6671.9 6769.8 6816.9 9343.3 9600.5 9695.2 9709.7 9805.0 9515.1 9721.3 9729.4 9834.1 10253.6 9416.2 9416.9 9446.3 9555.9 9801.6 8960.4 9015.3 9334.9 9387.6 9743.4 8315.7 8338.0 8362.5 8377.5 8403.8 8416.5 8557.9 8558.7 8630.4 8747.2 05:42:43 INFO - 2015-10-24 05:42:43,401 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:42:43 INFO - 2015-10-24 05:42:43,401 DEBUG : BROWSER_OUTPUT: 05:42:43 INFO - 2015-10-24 05:42:43,996 INFO : Browser exited with error code: 0 05:42:44 INFO - 2015-10-24 05:42:44,776 INFO : Completed test dromaeo_css (00:18:47) 05:42:44 INFO - 2015-10-24 05:42:44,776 INFO : Starting test kraken 05:42:44 INFO - 2015-10-24 05:42:44,776 DEBUG : operating with platform_type : w8_ 05:42:44 INFO - 2015-10-24 05:42:44,776 INFO : Initialising browser for kraken test... 05:42:44 INFO - 2015-10-24 05:42:44,796 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpcdkjlk\profile http://localhost:49274/getInfo.html 05:42:50 INFO - 2015-10-24 05:42:50,846 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:42:50 INFO - 2015-10-24 05:42:50,846 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:42:50 INFO - 2015-10-24 05:42:50,846 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674 05:42:50 INFO - 2015-10-24 05:42:50,846 DEBUG : BROWSER_OUTPUT: __metrics 05:42:51 INFO - 2015-10-24 05:42:51,009 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:42:51 INFO - 2015-10-24 05:42:51,859 DEBUG : BROWSER_OUTPUT: console.error: 05:42:51 INFO - 2015-10-24 05:42:51,861 DEBUG : BROWSER_OUTPUT: Message: Error: Transaction canceled due to a closed connection. 05:42:51 INFO - 2015-10-24 05:42:51,861 DEBUG : BROWSER_OUTPUT: Stack: 05:42:51 INFO - 2015-10-24 05:42:51,861 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise<@resource://gre/modules/Sqlite.jsm:562:1 05:42:51 INFO - 2015-10-24 05:42:51,861 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 05:42:51 INFO - 2015-10-24 05:42:51,861 DEBUG : BROWSER_OUTPUT: 05:42:52 INFO - 2015-10-24 05:42:52,621 INFO : Browser initialized. 05:42:52 INFO - 2015-10-24 05:42:52,621 INFO : Running cycle 1/1 for kraken test... 05:42:52 INFO - 2015-10-24 05:42:52,621 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpcdkjlk\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\kraken\kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:43:04 INFO - 2015-10-24 05:43:04,180 DEBUG : BROWSER_OUTPUT: RSS: Main: 197545984 05:43:04 INFO - 2015-10-24 05:43:04,180 DEBUG : BROWSER_OUTPUT: 05:43:06 INFO - 2015-10-24 05:43:06,911 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 05:43:07 INFO - 2015-10-24 05:43:07,505 DEBUG : BROWSER_OUTPUT: RSS: Main: 234680320 05:43:07 INFO - 2015-10-24 05:43:07,505 DEBUG : BROWSER_OUTPUT: 05:43:10 INFO - 2015-10-24 05:43:10,200 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 05:43:10 INFO - 2015-10-24 05:43:10,782 DEBUG : BROWSER_OUTPUT: RSS: Main: 233918464 05:43:10 INFO - 2015-10-24 05:43:10,782 DEBUG : BROWSER_OUTPUT: 05:43:13 INFO - 2015-10-24 05:43:13,480 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 05:43:14 INFO - 2015-10-24 05:43:14,055 DEBUG : BROWSER_OUTPUT: RSS: Main: 221892608 05:43:14 INFO - 2015-10-24 05:43:14,055 DEBUG : BROWSER_OUTPUT: 05:43:16 INFO - 2015-10-24 05:43:16,076 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 05:43:16 INFO - 2015-10-24 05:43:16,650 DEBUG : BROWSER_OUTPUT: RSS: Main: 219516928 05:43:16 INFO - 2015-10-24 05:43:16,650 DEBUG : BROWSER_OUTPUT: 05:43:18 INFO - 2015-10-24 05:43:18,869 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:43:19 INFO - 2015-10-24 05:43:19,434 DEBUG : BROWSER_OUTPUT: RSS: Main: 215814144 05:43:19 INFO - 2015-10-24 05:43:19,434 DEBUG : BROWSER_OUTPUT: 05:43:22 INFO - 2015-10-24 05:43:22,476 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 05:43:23 INFO - 2015-10-24 05:43:23,062 DEBUG : BROWSER_OUTPUT: RSS: Main: 210767872 05:43:23 INFO - 2015-10-24 05:43:23,062 DEBUG : BROWSER_OUTPUT: 05:43:26 INFO - 2015-10-24 05:43:26,480 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 05:43:27 INFO - 2015-10-24 05:43:27,053 DEBUG : BROWSER_OUTPUT: RSS: Main: 209936384 05:43:27 INFO - 2015-10-24 05:43:27,053 DEBUG : BROWSER_OUTPUT: 05:43:29 INFO - 2015-10-24 05:43:29,930 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 05:43:30 INFO - 2015-10-24 05:43:30,500 DEBUG : BROWSER_OUTPUT: RSS: Main: 210436096 05:43:30 INFO - 2015-10-24 05:43:30,500 DEBUG : BROWSER_OUTPUT: 05:43:32 INFO - 2015-10-24 05:43:32,290 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:43:32 INFO - 2015-10-24 05:43:32,852 DEBUG : BROWSER_OUTPUT: RSS: Main: 239616000 05:43:32 INFO - 2015-10-24 05:43:32,852 DEBUG : BROWSER_OUTPUT: 05:43:34 INFO - 2015-10-24 05:43:34,744 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:43:35 INFO - 2015-10-24 05:43:35,319 DEBUG : BROWSER_OUTPUT: RSS: Main: 244482048 05:43:35 INFO - 2015-10-24 05:43:35,319 DEBUG : BROWSER_OUTPUT: 05:43:37 INFO - 2015-10-24 05:43:37,625 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:43:38 INFO - 2015-10-24 05:43:38,207 DEBUG : BROWSER_OUTPUT: RSS: Main: 229265408 05:43:38 INFO - 2015-10-24 05:43:38,207 DEBUG : BROWSER_OUTPUT: 05:43:40 INFO - 2015-10-24 05:43:40,789 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:43:41 INFO - 2015-10-24 05:43:41,374 DEBUG : BROWSER_OUTPUT: RSS: Main: 233246720 05:43:41 INFO - 2015-10-24 05:43:41,374 DEBUG : BROWSER_OUTPUT: 05:43:44 INFO - 2015-10-24 05:43:44,157 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:43:44 INFO - 2015-10-24 05:43:44,740 DEBUG : BROWSER_OUTPUT: RSS: Main: 232988672 05:43:44 INFO - 2015-10-24 05:43:44,740 DEBUG : BROWSER_OUTPUT: 05:43:46 INFO - 2015-10-24 05:43:46,572 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 05:43:46 INFO - 2015-10-24 05:43:46,823 DEBUG : BROWSER_OUTPUT: RSS: Main: 287670272 05:43:46 INFO - 2015-10-24 05:43:46,823 DEBUG : BROWSER_OUTPUT: 05:43:46 INFO - 2015-10-24 05:43:46,823 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:43:46 INFO - 2015-10-24 05:43:46,823 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:43:46 INFO - 2015-10-24 05:43:46,823 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:43:46 INFO - 2015-10-24 05:43:46,823 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:43:46 INFO - 2015-10-24 05:43:46,823 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;112;106;112;113;113;101;112;112;111 05:43:46 INFO - 2015-10-24 05:43:46,823 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;138;131;148;166;135;139;139;131;157;130 05:43:46 INFO - 2015-10-24 05:43:46,823 DEBUG : BROWSER_OUTPUT: |2;audio-dft;142;140;141;142;143;143;143;143;139;140 05:43:46 INFO - 2015-10-24 05:43:46,825 DEBUG : BROWSER_OUTPUT: |3;audio-fft;70;70;70;97;75;70;70;70;100;69 05:43:46 INFO - 2015-10-24 05:43:46,825 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;91;113;92;91;91;124;92;91;121 05:43:46 INFO - 2015-10-24 05:43:46,825 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;111;112;111;111;112;111 05:43:46 INFO - 2015-10-24 05:43:46,825 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;132;133;133;135;133;132;132;132;132;132 05:43:46 INFO - 2015-10-24 05:43:46,825 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;97;96;97;102;97;99;96;96 05:43:46 INFO - 2015-10-24 05:43:46,825 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;71;71;71;71;72;72;85;71;70 05:43:46 INFO - 2015-10-24 05:43:46,825 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;69;68;68;68;68;70;69 05:43:46 INFO - 2015-10-24 05:43:46,825 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;92;91;97;93;93;94;97;94;94;95 05:43:46 INFO - 2015-10-24 05:43:46,825 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;125;126;132;128;131;126;126;128;128;135 05:43:46 INFO - 2015-10-24 05:43:46,826 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;163;155;165;162;163;162;164;160;162;161 05:43:46 INFO - 2015-10-24 05:43:46,826 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;75;75;78;75;76;75;74;75;75;75 05:43:46 INFO - 2015-10-24 05:43:46,826 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:43:46 INFO - 2015-10-24 05:43:46,826 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:43:46 INFO - 2015-10-24 05:43:46,826 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,974 05:43:46 INFO - 2015-10-24 05:43:46,828 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:43:46 INFO - 2015-10-24 05:43:46,828 DEBUG : BROWSER_OUTPUT: __startTimestamp1445690626821__endTimestamp 05:43:46 INFO - 2015-10-24 05:43:46,828 DEBUG : BROWSER_OUTPUT: 05:43:46 INFO - 2015-10-24 05:43:46,828 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:43:46 INFO - 2015-10-24 05:43:46,828 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:43:46 INFO - 2015-10-24 05:43:46,828 DEBUG : BROWSER_OUTPUT: 05:43:46 INFO - 2015-10-24 05:43:46,828 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.30 Median:112.00 stddev:3.83 (3.4%) stddev-sans-first:4.06 05:43:46 INFO - 2015-10-24 05:43:46,828 DEBUG : BROWSER_OUTPUT: Values: 111.0 112.0 106.0 112.0 113.0 113.0 101.0 112.0 112.0 111.0 05:43:46 INFO - 2015-10-24 05:43:46,828 DEBUG : BROWSER_OUTPUT: 05:43:46 INFO - 2015-10-24 05:43:46,828 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.40 Median:139.00 stddev:12.03 (8.7%) stddev-sans-first:12.70 05:43:46 INFO - 2015-10-24 05:43:46,828 DEBUG : BROWSER_OUTPUT: Values: 138.0 131.0 148.0 166.0 135.0 139.0 139.0 131.0 157.0 130.0 05:43:46 INFO - 2015-10-24 05:43:46,828 DEBUG : BROWSER_OUTPUT: 05:43:46 INFO - 2015-10-24 05:43:46,828 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:141.60 Median:142.50 stddev:1.51 (1.1%) stddev-sans-first:1.59 05:43:46 INFO - 2015-10-24 05:43:46,828 DEBUG : BROWSER_OUTPUT: Values: 142.0 140.0 141.0 142.0 143.0 143.0 143.0 143.0 139.0 140.0 05:43:46 INFO - 2015-10-24 05:43:46,828 DEBUG : BROWSER_OUTPUT: 05:43:46 INFO - 2015-10-24 05:43:46,828 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:76.10 Median:70.00 stddev:11.94 (17.1%) stddev-sans-first:12.46 05:43:46 INFO - 2015-10-24 05:43:46,828 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 70.0 97.0 75.0 70.0 70.0 70.0 100.0 69.0 05:43:46 INFO - 2015-10-24 05:43:46,828 DEBUG : BROWSER_OUTPUT: 05:43:46 INFO - 2015-10-24 05:43:46,828 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:99.70 Median:91.00 stddev:13.82 (15.2%) stddev-sans-first:14.29 05:43:46 INFO - 2015-10-24 05:43:46,828 DEBUG : BROWSER_OUTPUT: Values: 91.0 91.0 113.0 92.0 91.0 91.0 124.0 92.0 91.0 121.0 05:43:46 INFO - 2015-10-24 05:43:46,829 DEBUG : BROWSER_OUTPUT: 05:43:46 INFO - 2015-10-24 05:43:46,829 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.80 Median:111.00 stddev:0.79 (0.7%) stddev-sans-first:0.78 05:43:46 INFO - 2015-10-24 05:43:46,829 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 111.0 112.0 111.0 111.0 112.0 111.0 05:43:46 INFO - 2015-10-24 05:43:46,831 DEBUG : BROWSER_OUTPUT: 05:43:46 INFO - 2015-10-24 05:43:46,831 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:132.60 Median:132.50 stddev:0.97 (0.7%) stddev-sans-first:1.00 05:43:46 INFO - 2015-10-24 05:43:46,831 DEBUG : BROWSER_OUTPUT: Values: 132.0 133.0 133.0 135.0 133.0 132.0 132.0 132.0 132.0 132.0 05:43:46 INFO - 2015-10-24 05:43:46,831 DEBUG : BROWSER_OUTPUT: 05:43:46 INFO - 2015-10-24 05:43:46,832 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:97.30 Median:97.00 stddev:1.89 (1.9%) stddev-sans-first:1.94 05:43:46 INFO - 2015-10-24 05:43:46,832 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 97.0 96.0 97.0 102.0 97.0 99.0 96.0 96.0 05:43:46 INFO - 2015-10-24 05:43:46,832 DEBUG : BROWSER_OUTPUT: 05:43:46 INFO - 2015-10-24 05:43:46,832 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.50 Median:71.00 stddev:4.43 (6.2%) stddev-sans-first:4.66 05:43:46 INFO - 2015-10-24 05:43:46,832 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 71.0 71.0 71.0 72.0 72.0 85.0 71.0 70.0 05:43:46 INFO - 2015-10-24 05:43:46,832 DEBUG : BROWSER_OUTPUT: 05:43:46 INFO - 2015-10-24 05:43:46,832 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 05:43:46 INFO - 2015-10-24 05:43:46,832 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 69.0 68.0 68.0 68.0 68.0 70.0 69.0 05:43:46 INFO - 2015-10-24 05:43:46,832 DEBUG : BROWSER_OUTPUT: 05:43:46 INFO - 2015-10-24 05:43:46,834 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:94.00 Median:94.00 stddev:1.94 (2.1%) stddev-sans-first:1.92 05:43:46 INFO - 2015-10-24 05:43:46,834 DEBUG : BROWSER_OUTPUT: Values: 92.0 91.0 97.0 93.0 93.0 94.0 97.0 94.0 94.0 95.0 05:43:46 INFO - 2015-10-24 05:43:46,834 DEBUG : BROWSER_OUTPUT: 05:43:46 INFO - 2015-10-24 05:43:46,834 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:128.50 Median:128.00 stddev:3.21 (2.5%) stddev-sans-first:3.14 05:43:46 INFO - 2015-10-24 05:43:46,835 DEBUG : BROWSER_OUTPUT: Values: 125.0 126.0 132.0 128.0 131.0 126.0 126.0 128.0 128.0 135.0 05:43:46 INFO - 2015-10-24 05:43:46,835 DEBUG : BROWSER_OUTPUT: 05:43:46 INFO - 2015-10-24 05:43:46,835 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.70 Median:162.50 stddev:2.75 (1.7%) stddev-sans-first:2.88 05:43:46 INFO - 2015-10-24 05:43:46,835 DEBUG : BROWSER_OUTPUT: Values: 163.0 155.0 165.0 162.0 163.0 162.0 164.0 160.0 162.0 161.0 05:43:46 INFO - 2015-10-24 05:43:46,835 DEBUG : BROWSER_OUTPUT: 05:43:46 INFO - 2015-10-24 05:43:46,835 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.30 Median:75.00 stddev:1.06 (1.4%) stddev-sans-first:1.12 05:43:46 INFO - 2015-10-24 05:43:46,836 DEBUG : BROWSER_OUTPUT: Values: 75.0 75.0 78.0 75.0 76.0 75.0 74.0 75.0 75.0 75.0 05:43:46 INFO - 2015-10-24 05:43:46,836 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:43:46 INFO - 2015-10-24 05:43:46,836 DEBUG : BROWSER_OUTPUT: 05:43:47 INFO - 2015-10-24 05:43:47,586 INFO : Browser exited with error code: 0 05:43:48 INFO - 2015-10-24 05:43:48,450 INFO : Completed test kraken (00:01:03) 05:43:48 INFO - 2015-10-24 05:43:48,450 INFO : Starting test v8_7 05:43:48 INFO - 2015-10-24 05:43:48,450 DEBUG : operating with platform_type : w8_ 05:43:48 INFO - 2015-10-24 05:43:48,450 INFO : Initialising browser for v8_7 test... 05:43:48 INFO - 2015-10-24 05:43:48,473 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpfyesnv\profile http://localhost:49274/getInfo.html 05:43:54 INFO - 2015-10-24 05:43:54,081 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:43:54 INFO - 2015-10-24 05:43:54,081 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:43:54 INFO - 2015-10-24 05:43:54,081 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674 05:43:54 INFO - 2015-10-24 05:43:54,081 DEBUG : BROWSER_OUTPUT: __metrics 05:43:54 INFO - 2015-10-24 05:43:54,260 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:43:55 INFO - 2015-10-24 05:43:55,108 DEBUG : BROWSER_OUTPUT: console.error: 05:43:55 INFO - 2015-10-24 05:43:55,108 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] 05:43:55 INFO - 2015-10-24 05:43:55,108 DEBUG : BROWSER_OUTPUT: Stack: 05:43:55 INFO - 2015-10-24 05:43:55,108 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<._executeStatement@resource://gre/modules/Sqlite.jsm:758:19 05:43:55 INFO - 2015-10-24 05:43:55,108 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached/<@resource://gre/modules/Sqlite.jsm:493:9 05:43:55 INFO - 2015-10-24 05:43:55,108 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached@resource://gre/modules/Sqlite.jsm:491:1 05:43:55 INFO - 2015-10-24 05:43:55,108 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeBeforeShutdown/loggedDb<.executeCached.value<@resource://gre/modules/Sqlite.jsm:368:51 05:43:55 INFO - 2015-10-24 05:43:55,108 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 05:43:55 INFO - 2015-10-24 05:43:55,108 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 05:43:55 INFO - 2015-10-24 05:43:55,108 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 05:43:55 INFO - 2015-10-24 05:43:55,108 DEBUG : BROWSER_OUTPUT: transaction@resource://gre/modules/Bookmarks.jsm:783:15 05:43:55 INFO - 2015-10-24 05:43:55,108 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 05:43:55 INFO - 2015-10-24 05:43:55,108 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 05:43:55 INFO - 2015-10-24 05:43:55,108 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 05:43:55 INFO - 2015-10-24 05:43:55,108 DEBUG : BROWSER_OUTPUT: Task_spawn@resource://gre/modules/Task.jsm:164:12 05:43:55 INFO - 2015-10-24 05:43:55,108 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promisedromaeo_css: 6065.61 05:44:31 INFO - RETURN: kraken: 1510.40 05:44:31 INFO - RETURN: v8_7: 20376.14 05:44:31 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,31]]", "result": "20376.14"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,31]]", "result": "1510.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,31]]", "result": "6065.61"}}} 05:44:31 INFO - Return code: 0 05:44:31 INFO - # TBPL SUCCESS # 05:44:31 INFO - Running post-action listener: _resource_record_post_action 05:44:31 INFO - Running post-run listener: _resource_record_post_run 05:44:32 INFO - Total resource usage - Wall time: 1237s; CPU: 13.0%; Read bytes: 203594240; Write bytes: 388978176; Read time: 5772090; Write time: 5085440 05:44:32 INFO - install - Wall time: 2s; CPU: 13.0%; Read bytes: 0; Write bytes: 4574208; Read time: 0; Write time: 52280 05:44:32 INFO - run-tests - Wall time: 1236s; CPU: 13.0%; Read bytes: 203594240; Write bytes: 351328768; Read time: 5772090; Write time: 4991250 05:44:32 INFO - Running post-run listener: _upload_blobber_files 05:44:32 INFO - Blob upload gear active. 05:44:32 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:44:32 INFO - Copying logs to upload dir... 05:44:32 INFO - mkdir: C:\slave\test\build\upload\logs program finished with exit code 0 elapsedTime=1478.634000 ========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 24 mins, 47 secs) (at 2015-10-24 05:44:41.914584) ========= ========= Started set props: build_url (results: 0, elapsed: 1 secs) (at 2015-10-24 05:44:41.921016) ========= '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-176\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-176 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-176 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-176\AppData\Local LOGONSERVER=\\T-W864-IX-176 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 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-176 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-176 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-176 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False build_url:https://queue.taskcluster.net/v1/task/eTRUg5hYSnePh7U5-I5-IA/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/eTRUg5hYSnePh7U5-I5-IA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip' ========= Finished set props: build_url (results: 0, elapsed: 1 secs) (at 2015-10-24 05:44:43.418125) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 8 secs) (at 2015-10-24 05:44:43.418481) ========= '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-176\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-176 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-176 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-176\AppData\Local LOGONSERVER=\\T-W864-IX-176 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 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-176 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-176 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-176 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=0.100000 ========= Finished 'rm -f ...' (results: 0, elapsed: 8 secs) (at 2015-10-24 05:44:52.068679) ========= ========= Started reboot slave lost (results: 0, elapsed: 6 secs) (at 2015-10-24 05:44:52.069016) ========= ========= Finished reboot slave lost (results: 0, elapsed: 6 secs) (at 2015-10-24 05:44:58.931427) =========