builder: fx-team_win8_64_test-dromaeojs-pgo slave: t-w864-ix-008 starttime: 1445705032.95 results: success (0) buildid: 20151024053005 builduid: 6ec99a43b91244a7bd589849f3993bf8 revision: f95c614295a0971529da8c0c93d28718e7c4c5bd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-24 09:43:52.950597) ========= master: http://buildbot-master110.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-24 09:43:52.952253) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-24 09:43:52.952602) ========= 'cd' in dir C:\slave\test-pgo\. (timeout 1200 secs) watching logfiles {} argv: ['cd'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-008\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-008 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-008 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-008\AppData\Local LOGONSERVER=\\T-W864-IX-008 MONDIR=C:\Monitor_config\ MOZBUILDDIR=C:\mozilla-build\ MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 NUMBER_OF_PROCESSORS=8 OS=Windows_NT OURDRIVE=C: PATH=C:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;C:\mozilla-build\hg PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_ARCHITEW6432=AMD64 PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=C:\Program Files (x86) PROGRAMFILES(X86)=C:\Program Files (x86) PROGRAMW6432=C:\Program Files PROMPT=$P$G PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\ PUBLIC=C:\Users\Public PWD=C:\slave\test-pgo 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-008 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-008 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-008 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False C:\slave\test-pgo program finished with exit code 0 elapsedTime=0.597000 basedir: 'C:\\slave\\test-pgo' ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-24 09:43:53.678909) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-24 09:43:53.679325) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-24 09:43:53.788188) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-24 09:43:53.788703) ========= 'rm' '-rf' 'properties' in dir C:\slave\test-pgo\. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-008\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-008 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-008 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-008\AppData\Local LOGONSERVER=\\T-W864-IX-008 MONDIR=C:\Monitor_config\ MOZBUILDDIR=C:\mozilla-build\ MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 NUMBER_OF_PROCESSORS=8 OS=Windows_NT OURDRIVE=C: PATH=C:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;C:\mozilla-build\hg PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_ARCHITEW6432=AMD64 PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=C:\Program Files (x86) PROGRAMFILES(X86)=C:\Program Files (x86) PROGRAMW6432=C:\Program Files PROMPT=$P$G PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\ PUBLIC=C:\Users\Public PWD=C:\slave\test-pgo 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-008 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-008 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-008 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=0.202000 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-24 09:43:54.004414) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-24 09:43:54.004828) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-24 09:43:54.005317) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-24 09:43:54.005665) ========= '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-pgo\. (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-008\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-008 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-008 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-008\AppData\Local LOGONSERVER=\\T-W864-IX-008 MONDIR=C:\Monitor_config\ MOZBUILDDIR=C:\mozilla-build\ MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 NUMBER_OF_PROCESSORS=8 OS=Windows_NT OURDRIVE=C: PATH=C:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;C:\mozilla-build\hg PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_ARCHITEW6432=AMD64 PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=C:\Program Files (x86) PROGRAMFILES(X86)=C:\Program Files (x86) PROGRAMW6432=C:\Program Files PROMPT=$P$G PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\ PUBLIC=C:\Users\Public PWD=C:\slave\test-pgo 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-008 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-008 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-008 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False --09:43:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py => `archiver_client.py' Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12,141 (12K) [text/x-python] 0K .......... . 100% 8.89 MB/s 09:43:54 (8.89 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.538000 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-24 09:43:54.559891) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2015-10-24 09:43:54.560317) ========= 'rm' '-rf' 'scripts' in dir C:\slave\test-pgo\. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-008\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-008 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-008 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-008\AppData\Local LOGONSERVER=\\T-W864-IX-008 MONDIR=C:\Monitor_config\ MOZBUILDDIR=C:\mozilla-build\ MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 NUMBER_OF_PROCESSORS=8 OS=Windows_NT OURDRIVE=C: PATH=C:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;C:\mozilla-build\hg PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_ARCHITEW6432=AMD64 PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=C:\Program Files (x86) PROGRAMFILES(X86)=C:\Program Files (x86) PROGRAMW6432=C:\Program Files PROMPT=$P$G PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\ PUBLIC=C:\Users\Public PWD=C:\slave\test-pgo 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-008 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-008 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-008 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=2.408000 ========= Finished 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2015-10-24 09:43:56.983985) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-10-24 09:43:56.984470) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo integration/fx-team --rev f95c614295a0971529da8c0c93d28718e7c4c5bd --destination scripts --debug' in dir C:\slave\test-pgo\. (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-008\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-008 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-008 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-008\AppData\Local LOGONSERVER=\\T-W864-IX-008 MONDIR=C:\Monitor_config\ MOZBUILDDIR=C:\mozilla-build\ MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 NUMBER_OF_PROCESSORS=8 OS=Windows_NT OURDRIVE=C: PATH=C:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;C:\mozilla-build\hg PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_ARCHITEW6432=AMD64 PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=C:\Program Files (x86) PROGRAMFILES(X86)=C:\Program Files (x86) PROGRAMW6432=C:\Program Files PROMPT=$P$G PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\ PUBLIC=C:\Users\Public PWD=C:\slave\test-pgo 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-008 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-008 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-008 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 2015-10-24 09:43:57,296 truncating revision to first 12 chars 2015-10-24 09:43:57,296 Setting DEBUG logging. 2015-10-24 09:43:57,296 attempt 1/10 2015-10-24 09:43:57,296 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 09:43:58,397 unpacking tar archive at: fx-team-f95c614295a0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.697000 ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-10-24 09:43:58.711483) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-24 09:43:58.712459) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-24 09:43:58.732573) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-24 09:43:58.732891) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-24 09:43:58.733416) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 21 secs) (at 2015-10-24 09:43:58.733795) ========= 'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'dromaeojs' '--add-option' '--webServer,localhost' '--branch-name' 'Fx-Team' '--system-bits' '64' '--cfg' 'talos/windows_config.py' '--download-symbols' 'ondemand' '--use-talos-json' '--blob-upload-branch' 'Fx-Team' in dir C:\slave\test-pgo\. (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', '--system-bits', '64', '--cfg', 'talos/windows_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-008\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-008 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-008 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-008\AppData\Local LOGONSERVER=\\T-W864-IX-008 MONDIR=C:\Monitor_config\ MOZBUILDDIR=C:\mozilla-build\ MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 NUMBER_OF_PROCESSORS=8 OS=Windows_NT OURDRIVE=C: PATH=C:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;C:\mozilla-build\hg PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_ARCHITEW6432=AMD64 PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=C:\Program Files (x86) PROGRAMFILES(X86)=C:\Program Files (x86) PROGRAMW6432=C:\Program Files PROMPT=$P$G PROPERTIES_FILE=C:\slave\test-pgo/buildprops.json PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\ PUBLIC=C:\Users\Public PWD=C:\slave\test-pgo 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-008 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-008 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-008 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 09:43:59 INFO - MultiFileLogger online at 20151024 09:43:59 in C:\slave\test-pgo 09:43:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 09:43:59 INFO - Dumping config to C:\slave\test-pgo\logs\localconfig.json. 09:43:59 INFO - {'append_to_log': False, 09:43:59 INFO - 'base_work_dir': 'C:\\slave\\test-pgo', 09:43:59 INFO - 'blob_upload_branch': 'Fx-Team', 09:43:59 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test-pgo\\oauth.txt', 09:43:59 INFO - 'branch': 'Fx-Team', 09:43:59 INFO - 'buildbot_json_path': 'buildprops.json', 09:43:59 INFO - 'config_files': ('talos/windows_config.py',), 09:43:59 INFO - 'default_actions': ('clobber', 09:43:59 INFO - 'read-buildbot-config', 09:43:59 INFO - 'download-and-extract', 09:43:59 INFO - 'populate-webroot', 09:43:59 INFO - 'create-virtualenv', 09:43:59 INFO - 'install', 09:43:59 INFO - 'run-tests'), 09:43:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:43:59 INFO - 'download_minidump_stackwalk': True, 09:43:59 INFO - 'download_symbols': 'ondemand', 09:43:59 INFO - 'exes': {'easy_install': ('C:\\slave\\test-pgo\\build/venv/scripts/python', 09:43:59 INFO - 'C:\\slave\\test-pgo\\build/venv/scripts/easy_install-2.7-script.py'), 09:43:59 INFO - 'hg': 'c:/mozilla-build/hg/hg', 09:43:59 INFO - 'mozinstall': ('C:\\slave\\test-pgo\\build/venv/scripts/python', 09:43:59 INFO - 'C:\\slave\\test-pgo\\build/venv/scripts/mozinstall-script.py'), 09:43:59 INFO - 'python': 'c:/mozilla-build/python27/python.exe', 09:43:59 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe', 09:43:59 INFO - 'C:/mozilla-build/tooltool.py'), 09:43:59 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe', 09:43:59 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 09:43:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:43:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:43:59 INFO - 'installer_path': 'installer.exe', 09:43:59 INFO - 'log_level': 'info', 09:43:59 INFO - 'log_name': 'talos', 09:43:59 INFO - 'log_to_console': True, 09:43:59 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe', 09:43:59 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe', 09:43:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest', 09:43:59 INFO - 'opt_config_files': (), 09:43:59 INFO - 'pip_index': False, 09:43:59 INFO - 'sps_profile': False, 09:43:59 INFO - 'sps_profile_interval': 0, 09:43:59 INFO - 'suite': 'dromaeojs', 09:43:59 INFO - 'system_bits': '64', 09:43:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:43:59 INFO - 'title': 'T-W864-IX-008', 09:43:59 INFO - 'use_talos_json': True, 09:43:59 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'), 09:43:59 INFO - 'virtualenv_path': 'C:\\slave\\test-pgo\\build/venv', 09:43:59 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll', 09:43:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:43:59 INFO - 'work_dir': 'build'} 09:43:59 INFO - ##### 09:43:59 INFO - ##### Running clobber step. 09:43:59 INFO - ##### 09:43:59 INFO - Running pre-action listener: _resource_record_pre_action 09:43:59 INFO - Running main action method: clobber 09:43:59 INFO - rmtree: C:\slave\test-pgo\build 09:43:59 INFO - Using _rmtree_windows ... 09:43:59 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test-pgo\\build',), kwargs: {}, attempt #1 09:45:04 INFO - Running post-action listener: _resource_record_post_action 09:45:04 INFO - ##### 09:45:04 INFO - ##### Running read-buildbot-config step. 09:45:04 INFO - ##### 09:45:04 INFO - Running pre-action listener: _resource_record_pre_action 09:45:04 INFO - Running main action method: read_buildbot_config 09:45:04 INFO - Using buildbot properties: 09:45:04 INFO - { 09:45:04 INFO - "properties": { 09:45:04 INFO - "buildnumber": 310, 09:45:04 INFO - "product": "firefox", 09:45:04 INFO - "script_repo_revision": "production", 09:45:04 INFO - "builddir": "fx-team_win8_64_test-dromaeojs", 09:45:04 INFO - "repository": "", 09:45:04 INFO - "buildername": "Windows 8 64-bit fx-team pgo talos dromaeojs", 09:45:04 INFO - "buildid": "20151024053005", 09:45:04 INFO - "slavename": "t-w864-ix-008", 09:45:04 INFO - "pgo_build": "True", 09:45:04 INFO - "basedir": "C:\\slave\\test-pgo", 09:45:04 INFO - "project": "", 09:45:04 INFO - "platform": "win8_64", 09:45:04 INFO - "master": "http://buildbot-master110.bb.releng.scl3.mozilla.com:8201/", 09:45:04 INFO - "slavebuilddir": "test", 09:45:04 INFO - "scheduler": "tests-fx-team-win64-pgo-talos", 09:45:04 INFO - "branch": "fx-team", 09:45:04 INFO - "repo_path": "integration/fx-team", 09:45:04 INFO - "stage_platform": "win64-pgo", 09:45:04 INFO - "builduid": "6ec99a43b91244a7bd589849f3993bf8", 09:45:04 INFO - "revision": "f95c614295a0971529da8c0c93d28718e7c4c5bd" 09:45:04 INFO - }, 09:45:04 INFO - "sourcestamp": { 09:45:04 INFO - "repository": "", 09:45:04 INFO - "hasPatch": false, 09:45:04 INFO - "project": "", 09:45:04 INFO - "branch": "fx-team-win64-pgo-talos", 09:45:04 INFO - "changes": [ 09:45:04 INFO - { 09:45:04 INFO - "category": null, 09:45:04 INFO - "files": [ 09:45:04 INFO - { 09:45:04 INFO - "url": null, 09:45:04 INFO - "name": "https://queue.taskcluster.net/v1/task/t_w4rQ1sTkOMFcIKwKqAAA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip" 09:45:04 INFO - } 09:45:04 INFO - ], 09:45:04 INFO - "repository": "", 09:45:04 INFO - "rev": "f95c614295a0971529da8c0c93d28718e7c4c5bd", 09:45:04 INFO - "who": "sendchange", 09:45:04 INFO - "when": 1445705005, 09:45:04 INFO - "number": 6570457, 09:45:04 INFO - "comments": "", 09:45:04 INFO - "project": "", 09:45:04 INFO - "at": "Sat 24 Oct 2015 09:43:25", 09:45:04 INFO - "branch": "fx-team-win64-pgo-talos", 09:45:04 INFO - "revlink": "", 09:45:04 INFO - "properties": [ 09:45:04 INFO - [ 09:45:04 INFO - "buildid", 09:45:04 INFO - "20151024053005", 09:45:04 INFO - "Change" 09:45:04 INFO - ], 09:45:04 INFO - [ 09:45:04 INFO - "builduid", 09:45:04 INFO - "6ec99a43b91244a7bd589849f3993bf8", 09:45:04 INFO - "Change" 09:45:04 INFO - ], 09:45:04 INFO - [ 09:45:04 INFO - "pgo_build", 09:45:04 INFO - "True", 09:45:04 INFO - "Change" 09:45:04 INFO - ] 09:45:04 INFO - ], 09:45:04 INFO - "revision": "f95c614295a0971529da8c0c93d28718e7c4c5bd" 09:45:04 INFO - } 09:45:04 INFO - ], 09:45:04 INFO - "revision": "f95c614295a0971529da8c0c93d28718e7c4c5bd" 09:45:04 INFO - } 09:45:04 INFO - } 09:45:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/t_w4rQ1sTkOMFcIKwKqAAA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip. 09:45:04 INFO - Running post-action listener: _resource_record_post_action 09:45:04 INFO - ##### 09:45:04 INFO - ##### Running download-and-extract step. 09:45:04 INFO - ##### 09:45:04 INFO - Running pre-action listener: _resource_record_pre_action 09:45:04 INFO - Running main action method: download_and_extract 09:45:04 INFO - mkdir: C:\slave\test-pgo\build\tests 09:45: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')]} 09:45:04 INFO - https://queue.taskcluster.net/v1/task/t_w4rQ1sTkOMFcIKwKqAAA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:45:04 INFO - trying https://queue.taskcluster.net/v1/task/t_w4rQ1sTkOMFcIKwKqAAA/artifacts/public/build/test_packages.json 09:45:04 INFO - Downloading https://queue.taskcluster.net/v1/task/t_w4rQ1sTkOMFcIKwKqAAA/artifacts/public/build/test_packages.json to C:\slave\test-pgo\build\test_packages.json 09:45:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/t_w4rQ1sTkOMFcIKwKqAAA/artifacts/public/build/test_packages.json', 'file_name': 'C:\\slave\\test-pgo\\build\\test_packages.json'}, attempt #1 09:45:04 INFO - Downloaded 1221 bytes. 09:45:04 INFO - Reading from file C:\slave\test-pgo\build\test_packages.json 09:45:04 INFO - Using the following test package requirements: 09:45:04 INFO - {u'common': [u'firefox-44.0a1.en-US.win64.common.tests.zip'], 09:45:04 INFO - u'cppunittest': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 09:45:04 INFO - u'firefox-44.0a1.en-US.win64.cppunittest.tests.zip'], 09:45:04 INFO - u'jittest': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 09:45:04 INFO - u'jsshell-win64.zip'], 09:45:04 INFO - u'mochitest': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 09:45:04 INFO - u'firefox-44.0a1.en-US.win64.mochitest.tests.zip'], 09:45:04 INFO - u'mozbase': [u'firefox-44.0a1.en-US.win64.common.tests.zip'], 09:45:04 INFO - u'reftest': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 09:45:04 INFO - u'firefox-44.0a1.en-US.win64.reftest.tests.zip'], 09:45:04 INFO - u'talos': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 09:45:04 INFO - u'firefox-44.0a1.en-US.win64.talos.tests.zip'], 09:45:04 INFO - u'web-platform': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 09:45:04 INFO - u'firefox-44.0a1.en-US.win64.web-platform.tests.zip'], 09:45:04 INFO - u'webapprt': [u'firefox-44.0a1.en-US.win64.common.tests.zip'], 09:45:04 INFO - u'xpcshell': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 09:45:04 INFO - u'firefox-44.0a1.en-US.win64.xpcshell.tests.zip']} 09:45:04 INFO - Downloading packages: [u'firefox-44.0a1.en-US.win64.common.tests.zip'] for test suite category: common 09:45: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')]} 09:45:04 INFO - https://queue.taskcluster.net/v1/task/t_w4rQ1sTkOMFcIKwKqAAA/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip matches https://queue.taskcluster.net 09:45:04 INFO - trying https://queue.taskcluster.net/v1/task/t_w4rQ1sTkOMFcIKwKqAAA/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip 09:45:04 INFO - Downloading https://queue.taskcluster.net/v1/task/t_w4rQ1sTkOMFcIKwKqAAA/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip to C:\slave\test-pgo\build\firefox-44.0a1.en-US.win64.common.tests.zip 09:45:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/t_w4rQ1sTkOMFcIKwKqAAA/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip', 'file_name': u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win64.common.tests.zip'}, attempt #1 ProcessManager NOT managing child processes 09:45:06 INFO - Downloaded 18100949 bytes. 09:45:06 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win64.common.tests.zip'] in C:\slave\test-pgo\build\tests 09:45:06 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-44.0a1.en-US.win64.common.tests.zip 09:45:06 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win64.common.tests.zip'] with output_timeout 1760 ProcessManager UNABLE to use job objects to manage child processes 09:45:37 INFO - Return code: 0 09:45: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 09:45: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')]} 09:45:37 INFO - https://queue.taskcluster.net/v1/task/t_w4rQ1sTkOMFcIKwKqAAA/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip matches https://queue.taskcluster.net 09:45:37 INFO - trying https://queue.taskcluster.net/v1/task/t_w4rQ1sTkOMFcIKwKqAAA/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip 09:45:37 INFO - Downloading https://queue.taskcluster.net/v1/task/t_w4rQ1sTkOMFcIKwKqAAA/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip to C:\slave\test-pgo\build\firefox-44.0a1.en-US.win64.common.tests.zip 09:45:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/t_w4rQ1sTkOMFcIKwKqAAA/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip', 'file_name': u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win64.common.tests.zip'}, attempt #1 ProcessManager NOT managing child processes 09:45:38 INFO - Downloaded 18100949 bytes. 09:45:38 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win64.common.tests.zip'] in C:\slave\test-pgo\build\tests 09:45:38 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-44.0a1.en-US.win64.common.tests.zip 09:45:38 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win64.common.tests.zip'] with output_timeout 1760 ProcessManager UNABLE to use job objects to manage child processes 09:46:00 INFO - Return code: 0 09:46: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')]} 09:46:00 INFO - https://queue.taskcluster.net/v1/task/t_w4rQ1sTkOMFcIKwKqAAA/artifacts/public/build/firefox-44.0a1.en-US.win64.talos.tests.zip matches https://queue.taskcluster.net 09:46:00 INFO - trying https://queue.taskcluster.net/v1/task/t_w4rQ1sTkOMFcIKwKqAAA/artifacts/public/build/firefox-44.0a1.en-US.win64.talos.tests.zip 09:46:00 INFO - Downloading https://queue.taskcluster.net/v1/task/t_w4rQ1sTkOMFcIKwKqAAA/artifacts/public/build/firefox-44.0a1.en-US.win64.talos.tests.zip to C:\slave\test-pgo\build\firefox-44.0a1.en-US.win64.talos.tests.zip 09:46:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/t_w4rQ1sTkOMFcIKwKqAAA/artifacts/public/build/firefox-44.0a1.en-US.win64.talos.tests.zip', 'file_name': u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win64.talos.tests.zip'}, attempt #1 ProcessManager NOT managing child processes 09:46:02 INFO - Downloaded 11131307 bytes. 09:46:02 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win64.talos.tests.zip'] in C:\slave\test-pgo\build\tests 09:46:02 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-44.0a1.en-US.win64.talos.tests.zip 09:46:02 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win64.talos.tests.zip'] with output_timeout 1760 ProcessManager UNABLE to use job objects to manage child processes 09:46:03 INFO - Return code: 0 09:46:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:03 INFO - https://queue.taskcluster.net/v1/task/t_w4rQ1sTkOMFcIKwKqAAA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip matches https://queue.taskcluster.net 09:46:04 INFO - trying https://queue.taskcluster.net/v1/task/t_w4rQ1sTkOMFcIKwKqAAA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip 09:46:04 INFO - Downloading https://queue.taskcluster.net/v1/task/t_w4rQ1sTkOMFcIKwKqAAA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip to C:\slave\test-pgo\build\firefox-44.0a1.en-US.win64.zip 09:46:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/t_w4rQ1sTkOMFcIKwKqAAA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip', 'file_name': 'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win64.zip'}, attempt #1 09:46:05 INFO - Downloaded 55664876 bytes. 09:46:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/t_w4rQ1sTkOMFcIKwKqAAA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip 09:46:05 INFO - mkdir: C:\slave\test-pgo\properties 09:46:05 INFO - Writing buildbot properties ['build_url'] to C:\slave\test-pgo\properties\build_url 09:46:05 INFO - Writing to file C:\slave\test-pgo\properties\build_url 09:46:05 INFO - Contents: 09:46:05 INFO - build_url:https://queue.taskcluster.net/v1/task/t_w4rQ1sTkOMFcIKwKqAAA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip 09:46:05 INFO - Running post-action listener: _resource_record_post_action 09:46:05 INFO - Running post-action listener: set_extra_try_arguments 09:46:05 INFO - ##### 09:46:05 INFO - ##### Running populate-webroot step. 09:46:05 INFO - ##### 09:46:05 INFO - Running pre-action listener: _resource_record_pre_action 09:46:05 INFO - Running main action method: populate_webroot 09:46:05 INFO - Guessing talos json url... 09:46:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:05 INFO - https://queue.taskcluster.net/v1/task/t_w4rQ1sTkOMFcIKwKqAAA/artifacts/public/build/firefox-44.0a1.en-US.win64.txt matches https://queue.taskcluster.net 09:46:05 INFO - trying https://queue.taskcluster.net/v1/task/t_w4rQ1sTkOMFcIKwKqAAA/artifacts/public/build/firefox-44.0a1.en-US.win64.txt 09:46:05 INFO - Downloading https://queue.taskcluster.net/v1/task/t_w4rQ1sTkOMFcIKwKqAAA/artifacts/public/build/firefox-44.0a1.en-US.win64.txt to C:\slave\test-pgo\build\firefox-44.0a1.en-US.win64.txt 09:46:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/t_w4rQ1sTkOMFcIKwKqAAA/artifacts/public/build/firefox-44.0a1.en-US.win64.txt', 'file_name': 'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win64.txt'}, attempt #1 09:46:06 INFO - Downloaded 103 bytes. 09:46:06 INFO - Reading from file C:\slave\test-pgo\build\firefox-44.0a1.en-US.win64.txt 09:46:06 INFO - Contents: 09:46:06 INFO - 20151024053005 09:46:06 INFO - https://hg.mozilla.org/integration/fx-team/rev/f95c614295a0971529da8c0c93d28718e7c4c5bd 09:46:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:06 INFO - trying https://hg.mozilla.org/integration/fx-team/raw-file/f95c614295/testing/talos/talos.json 09:46:06 INFO - Downloading https://hg.mozilla.org/integration/fx-team/raw-file/f95c614295/testing/talos/talos.json to C:\slave\test-pgo\build\talos.json 09:46:06 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-pgo\\build\\talos.json'}, attempt #1 09:46:06 INFO - Downloaded 4264 bytes. 09:46:06 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']}, 09:46:06 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']}, 09:46:06 INFO - u'remote-trobocheck2': {u'talos_options': [u'--fennecIDs', 09:46:06 INFO - u'../fennec_ids.txt'], 09:46:06 INFO - u'tests': [u'tcheck2']}, 09:46:06 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome', 09:46:06 INFO - u'--tppagecycles', 09:46:06 INFO - u'7'], 09:46:06 INFO - u'tests': [u'tsvgm']}}, 09:46:06 INFO - u'suites': {u'chromez': {u'tests': [u'tresize', u'tcanvasmark']}, 09:46:06 INFO - u'chromez-e10s': {u'talos_options': [u'--e10s'], 09:46:06 INFO - u'tests': [u'tresize', u'tcanvasmark']}, 09:46:06 INFO - u'dromaeojs': {u'tests': [u'dromaeo_css', u'kraken', u'v8_7']}, 09:46:06 INFO - u'dromaeojs-e10s': {u'talos_options': [u'--e10s'], 09:46:06 INFO - u'tests': [u'dromaeo_css', 09:46:06 INFO - u'kraken', 09:46:06 INFO - u'v8_7']}, 09:46:06 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:06 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 09:46:06 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:06 INFO - u'talos_options': [u'--e10s'], 09:46:06 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 09:46:06 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:06 INFO - u'tests': [u'damp', u'tps']}, 09:46:06 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:06 INFO - u'talos_options': [u'--e10s'], 09:46:06 INFO - u'tests': [u'damp', u'tps']}, 09:46:06 INFO - u'g3': {u'tests': [u'dromaeo_dom']}, 09:46:06 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']}, 09:46:06 INFO - u'other': {u'tests': [u'a11yr', 09:46:06 INFO - u'ts_paint', 09:46:06 INFO - u'tpaint', 09:46:06 INFO - u'sessionrestore', 09:46:06 INFO - u'sessionrestore_no_auto_restore']}, 09:46:06 INFO - u'other-e10s': {u'talos_options': [u'--e10s'], 09:46:06 INFO - u'tests': [u'a11yr', 09:46:06 INFO - u'ts_paint', 09:46:06 INFO - u'tpaint', 09:46:06 INFO - u'sessionrestore', 09:46:06 INFO - u'sessionrestore_no_auto_restore']}, 09:46:06 INFO - u'other-e10s_l64': {u'talos_options': [u'--e10s'], 09:46:06 INFO - u'tests': [u'a11yr', 09:46:06 INFO - u'ts_paint', 09:46:06 INFO - u'tpaint', 09:46:06 INFO - u'sessionrestore', 09:46:06 INFO - u'sessionrestore_no_auto_restore']}, 09:46:06 INFO - u'other-e10s_nol64': {u'talos_options': [u'--e10s'], 09:46:06 INFO - u'tests': [u'a11yr', 09:46:06 INFO - u'ts_paint', 09:46:06 INFO - u'tpaint', 09:46:06 INFO - u'sessionrestore', 09:46:06 INFO - u'sessionrestore_no_auto_restore']}, 09:46:06 INFO - u'other_l64': {u'tests': [u'a11yr', 09:46:06 INFO - u'ts_paint', 09:46:06 INFO - u'tpaint', 09:46:06 INFO - u'sessionrestore', 09:46:06 INFO - u'sessionrestore_no_auto_restore']}, 09:46:06 INFO - u'other_nol64': {u'tests': [u'a11yr', 09:46:06 INFO - u'ts_paint', 09:46:06 INFO - u'tpaint', 09:46:06 INFO - u'sessionrestore', 09:46:06 INFO - u'sessionrestore_no_auto_restore']}, 09:46:06 INFO - u'svgr': {u'tests': [u'tsvgx', 09:46:06 INFO - u'tsvgr_opacity', 09:46:06 INFO - u'tart', 09:46:06 INFO - u'tscrollx', 09:46:06 INFO - u'cart']}, 09:46:06 INFO - u'svgr-e10s': {u'talos_options': [u'--e10s'], 09:46:06 INFO - u'tests': [u'tsvgx', 09:46:06 INFO - u'tsvgr_opacity', 09:46:06 INFO - u'tart', 09:46:06 INFO - u'tscrollx', 09:46:06 INFO - u'cart']}, 09:46:06 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:06 INFO - u'tests': [u'tp5o']}, 09:46:06 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:06 INFO - u'talos_options': [u'--e10s'], 09:46:06 INFO - u'tests': [u'tp5o']}, 09:46:06 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:06 INFO - u'talos_options': [u'--xperf_path', 09:46:06 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:46:06 INFO - u'tests': [u'tp5n']}, 09:46:06 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:06 INFO - u'talos_options': [u'--e10s', 09:46:06 INFO - u'--xperf_path', 09:46:06 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 09:46:06 INFO - u'C:/slave/talos-data/talos/xperf.config'], 09:46:06 INFO - u'tests': [u'tp5n']}}, 09:46:06 INFO - u'talos.zip': {u'path': u'', 09:46:06 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:46:06 INFO - Running post-action listener: _resource_record_post_action 09:46:06 INFO - ##### 09:46:06 INFO - ##### Running create-virtualenv step. 09:46:06 INFO - ##### 09:46:06 INFO - Running pre-action listener: _resource_record_pre_action 09:46:06 INFO - Running main action method: create_virtualenv 09:46:06 INFO - Creating virtualenv C:\slave\test-pgo\build/venv 09:46:06 INFO - mkdir: C:\slave\test-pgo\build\venv\Scripts 09:46:06 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test-pgo\build\venv\Scripts\python27.dll 09:46:06 WARNING - Can't copy c:/mozilla-build/python27/python27.dll to C:\slave\test-pgo\build\venv\Scripts\python27.dll: [Errno 2] No such file or directory: 'c:/mozilla-build/python27/python27.dll'! 09:46:06 INFO - Running command: ['c:/mozilla-build/python27/python.exe', 'c:/mozilla-build/buildbotve/virtualenv.py', '--no-site-packages', '--distribute', 'C:\\slave\\test-pgo\\build/venv'] in C:\slave\test-pgo\build 09:46:06 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test-pgo\build/venv 09:46:13 INFO - New python executable in C:\slave\test-pgo\build/venv\Scripts\python.exe 09:46:16 INFO - Installing distribute......................................................................................................................................................................................done. 09:46:17 INFO - Return code: 0 09:46:17 INFO - Installing pip>=1.5 into virtualenv C:\slave\test-pgo\build/venv 09:46:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:17 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\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 0x0229EB10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022FFEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x023AA398>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00738B48>, '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 0x0075A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0278B660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-008', 'USERDOMAIN': 'T-W864-IX-008', '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-008', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-008\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-008', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-008', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-008', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-008\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test-pgo', '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 09:46:17 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\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-pgo\build 09:46:17 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --download-cache C:\slave\test-pgo\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 09:46:17 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 09:46:17 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-008\\AppData\\Roaming', 09:46:17 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 09:46:17 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 09:46:17 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 09:46:17 INFO - 'COMPUTERNAME': 'T-W864-IX-008', 09:46:17 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 09:46:17 INFO - 'DCLOCATION': 'SCL3', 09:46:17 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 09:46:17 INFO - 'FP_NO_HOST_CHECK': 'NO', 09:46:17 INFO - 'HOMEDRIVE': 'C:', 09:46:17 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-008', 09:46:17 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 09:46:17 INFO - 'KTS_VERSION': '1.19c', 09:46:17 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-008\\AppData\\Local', 09:46:17 INFO - 'LOGONSERVER': '\\\\T-W864-IX-008', 09:46:17 INFO - 'MONDIR': 'C:\\Monitor_config\\', 09:46:17 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 09:46:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:17 INFO - 'MOZ_NO_REMOTE': '1', 09:46:17 INFO - 'NO_EM_RESTART': '1', 09:46:17 INFO - 'NUMBER_OF_PROCESSORS': '8', 09:46:17 INFO - 'OS': 'Windows_NT', 09:46:17 INFO - 'OURDRIVE': 'C:', 09:46:17 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 09:46:17 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 09:46:17 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 09:46:17 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 09:46:17 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 09:46:17 INFO - 'PROCESSOR_LEVEL': '6', 09:46:17 INFO - 'PROCESSOR_REVISION': '1e05', 09:46:17 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 09:46:17 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 09:46:17 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 09:46:17 INFO - 'PROGRAMW6432': 'C:\\Program Files', 09:46:17 INFO - 'PROMPT': '$P$G', 09:46:17 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 09:46:17 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 09:46:17 INFO - 'PUBLIC': 'C:\\Users\\Public', 09:46:17 INFO - 'PWD': 'C:\\slave\\test-pgo', 09:46:17 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 09:46:17 INFO - 'SLAVEDIR': 'C:\\slave\\', 09:46:17 INFO - 'SYSTEMDRIVE': 'C:', 09:46:17 INFO - 'SYSTEMROOT': 'C:\\windows', 09:46:17 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:46:17 INFO - 'TEST1': 'testie', 09:46:17 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:46:17 INFO - 'USERDOMAIN': 'T-W864-IX-008', 09:46:17 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-008', 09:46:17 INFO - 'USERNAME': 'cltbld', 09:46:17 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-008', 09:46:17 INFO - 'WINDIR': 'C:\\windows', 09:46:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 09:46:18 INFO - Ignoring indexes: http://pypi.python.org/simple/ 09:46:18 INFO - Downloading/unpacking pip>=1.5 09:46:18 INFO - Creating supposed download cache at C:\slave\test-pgo\build/venv\cache 09:46:22 INFO - Storing download in cache at c:\slave\test-pgo\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fpip-1.5.5.tar.gz 09:46:22 INFO - Running setup.py egg_info for package pip 09:46:22 INFO - warning: no files found matching 'pip\cacert.pem' 09:46:22 INFO - warning: no files found matching '*.html' under directory 'docs' 09:46:22 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 09:46:22 INFO - no previously-included directories found matching 'docs\_build\_sources' 09:46:22 INFO - Installing collected packages: pip 09:46:22 INFO - Found existing installation: pip 0.8.2 09:46:22 INFO - Uninstalling pip: 09:46:22 INFO - Successfully uninstalled pip 09:46:22 INFO - Running setup.py install for pip 09:46:22 INFO - warning: no files found matching 'pip\cacert.pem' 09:46:22 INFO - warning: no files found matching '*.html' under directory 'docs' 09:46:22 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 09:46:22 INFO - no previously-included directories found matching 'docs\_build\_sources' 09:46:22 INFO - Installing pip-script.py script to C:\slave\test-pgo\build\venv\Scripts 09:46:22 INFO - Installing pip.exe script to C:\slave\test-pgo\build\venv\Scripts 09:46:22 INFO - Installing pip2.7-script.py script to C:\slave\test-pgo\build\venv\Scripts 09:46:22 INFO - Installing pip2.7.exe script to C:\slave\test-pgo\build\venv\Scripts 09:46:22 INFO - Installing pip2-script.py script to C:\slave\test-pgo\build\venv\Scripts 09:46:22 INFO - Installing pip2.exe script to C:\slave\test-pgo\build\venv\Scripts 09:46:22 INFO - Successfully installed pip 09:46:22 INFO - Cleaning up... 09:46:22 INFO - Return code: 0 09:46:22 INFO - Installing psutil>=0.7.1 into virtualenv C:\slave\test-pgo\build/venv 09:46:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:22 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\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 0x0229EB10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022FFEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x023AA398>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00738B48>, '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 0x0075A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0278B660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-008', 'USERDOMAIN': 'T-W864-IX-008', '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-008', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-008\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-008', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-008', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-008', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-008\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test-pgo', '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 09:46:22 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\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-pgo\build 09:46:22 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --download-cache C:\slave\test-pgo\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 09:46:22 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 09:46:22 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-008\\AppData\\Roaming', 09:46:22 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 09:46:22 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 09:46:22 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 09:46:22 INFO - 'COMPUTERNAME': 'T-W864-IX-008', 09:46:22 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 09:46:22 INFO - 'DCLOCATION': 'SCL3', 09:46:22 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 09:46:22 INFO - 'FP_NO_HOST_CHECK': 'NO', 09:46:22 INFO - 'HOMEDRIVE': 'C:', 09:46:22 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-008', 09:46:22 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 09:46:22 INFO - 'KTS_VERSION': '1.19c', 09:46:22 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-008\\AppData\\Local', 09:46:22 INFO - 'LOGONSERVER': '\\\\T-W864-IX-008', 09:46:22 INFO - 'MONDIR': 'C:\\Monitor_config\\', 09:46:22 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 09:46:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:22 INFO - 'MOZ_NO_REMOTE': '1', 09:46:22 INFO - 'NO_EM_RESTART': '1', 09:46:22 INFO - 'NUMBER_OF_PROCESSORS': '8', 09:46:22 INFO - 'OS': 'Windows_NT', 09:46:22 INFO - 'OURDRIVE': 'C:', 09:46:22 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 09:46:22 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 09:46:22 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 09:46:22 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 09:46:22 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 09:46:22 INFO - 'PROCESSOR_LEVEL': '6', 09:46:22 INFO - 'PROCESSOR_REVISION': '1e05', 09:46:22 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 09:46:22 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 09:46:22 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 09:46:22 INFO - 'PROGRAMW6432': 'C:\\Program Files', 09:46:22 INFO - 'PROMPT': '$P$G', 09:46:22 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 09:46:22 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 09:46:22 INFO - 'PUBLIC': 'C:\\Users\\Public', 09:46:22 INFO - 'PWD': 'C:\\slave\\test-pgo', 09:46:22 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 09:46:22 INFO - 'SLAVEDIR': 'C:\\slave\\', 09:46:22 INFO - 'SYSTEMDRIVE': 'C:', 09:46:22 INFO - 'SYSTEMROOT': 'C:\\windows', 09:46:22 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:46:22 INFO - 'TEST1': 'testie', 09:46:22 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:46:22 INFO - 'USERDOMAIN': 'T-W864-IX-008', 09:46:22 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-008', 09:46:22 INFO - 'USERNAME': 'cltbld', 09:46:22 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-008', 09:46:22 INFO - 'WINDIR': 'C:\\windows', 09:46:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 09:46:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:24 INFO - Downloading/unpacking psutil>=0.7.1 09:46:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:25 INFO - Storing download in cache at c:\slave\test-pgo\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fpsutil-3.1.1-cp27-none-win32.whl 09:46:25 INFO - Installing collected packages: psutil 09:46:25 INFO - Successfully installed psutil 09:46:25 INFO - Cleaning up... 09:46:25 INFO - Return code: 0 09:46:25 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv C:\slave\test-pgo\build/venv 09:46:25 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')]} 09:46:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:25 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')]} 09:46:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:25 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\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 0x0229EB10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022FFEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x023AA398>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00738B48>, '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 0x0075A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0278B660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-008', 'USERDOMAIN': 'T-W864-IX-008', '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-008', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-008\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-008', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-008', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-008', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-008\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test-pgo', '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 09:46:25 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\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-pgo\build 09:46:25 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --download-cache C:\slave\test-pgo\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 09:46:25 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 09:46:25 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-008\\AppData\\Roaming', 09:46:25 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 09:46:25 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 09:46:25 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 09:46:25 INFO - 'COMPUTERNAME': 'T-W864-IX-008', 09:46:25 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 09:46:25 INFO - 'DCLOCATION': 'SCL3', 09:46:25 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 09:46:25 INFO - 'FP_NO_HOST_CHECK': 'NO', 09:46:25 INFO - 'HOMEDRIVE': 'C:', 09:46:25 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-008', 09:46:25 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 09:46:25 INFO - 'KTS_VERSION': '1.19c', 09:46:25 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-008\\AppData\\Local', 09:46:25 INFO - 'LOGONSERVER': '\\\\T-W864-IX-008', 09:46:25 INFO - 'MONDIR': 'C:\\Monitor_config\\', 09:46:25 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 09:46:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:25 INFO - 'MOZ_NO_REMOTE': '1', 09:46:25 INFO - 'NO_EM_RESTART': '1', 09:46:25 INFO - 'NUMBER_OF_PROCESSORS': '8', 09:46:25 INFO - 'OS': 'Windows_NT', 09:46:25 INFO - 'OURDRIVE': 'C:', 09:46:25 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 09:46:25 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 09:46:25 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 09:46:25 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 09:46:25 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 09:46:25 INFO - 'PROCESSOR_LEVEL': '6', 09:46:25 INFO - 'PROCESSOR_REVISION': '1e05', 09:46:25 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 09:46:25 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 09:46:25 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 09:46:25 INFO - 'PROGRAMW6432': 'C:\\Program Files', 09:46:25 INFO - 'PROMPT': '$P$G', 09:46:25 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 09:46:25 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 09:46:25 INFO - 'PUBLIC': 'C:\\Users\\Public', 09:46:25 INFO - 'PWD': 'C:\\slave\\test-pgo', 09:46:25 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 09:46:25 INFO - 'SLAVEDIR': 'C:\\slave\\', 09:46:25 INFO - 'SYSTEMDRIVE': 'C:', 09:46:25 INFO - 'SYSTEMROOT': 'C:\\windows', 09:46:25 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:46:25 INFO - 'TEST1': 'testie', 09:46:25 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:46:25 INFO - 'USERDOMAIN': 'T-W864-IX-008', 09:46:25 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-008', 09:46:25 INFO - 'USERNAME': 'cltbld', 09:46:25 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-008', 09:46:25 INFO - 'WINDIR': 'C:\\windows', 09:46:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 09:46:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:26 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:27 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:46:27 INFO - Storing download in cache at c:\slave\test-pgo\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fmozsystemmonitor-0.0.tar.gz 09:46:27 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor 09:46:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in c:\slave\test-pgo\build\venv\lib\site-packages (from mozsystemmonitor==0.0.0) 09:46:27 INFO - Installing collected packages: mozsystemmonitor 09:46:27 INFO - Running setup.py install for mozsystemmonitor 09:46:27 INFO - Successfully installed mozsystemmonitor 09:46:27 INFO - Cleaning up... 09:46:28 INFO - Return code: 0 09:46:28 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test-pgo\build/venv 09:46:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:28 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\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 0x0229EB10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022FFEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x023AA398>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00738B48>, '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 0x0075A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0278B660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-008', 'USERDOMAIN': 'T-W864-IX-008', '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-008', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-008\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-008', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-008', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-008', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-008\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test-pgo', '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 09:46:28 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\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-pgo\build 09:46:28 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --download-cache C:\slave\test-pgo\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 09:46:28 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 09:46:28 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-008\\AppData\\Roaming', 09:46:28 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 09:46:28 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 09:46:28 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 09:46:28 INFO - 'COMPUTERNAME': 'T-W864-IX-008', 09:46:28 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 09:46:28 INFO - 'DCLOCATION': 'SCL3', 09:46:28 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 09:46:28 INFO - 'FP_NO_HOST_CHECK': 'NO', 09:46:28 INFO - 'HOMEDRIVE': 'C:', 09:46:28 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-008', 09:46:28 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 09:46:28 INFO - 'KTS_VERSION': '1.19c', 09:46:28 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-008\\AppData\\Local', 09:46:28 INFO - 'LOGONSERVER': '\\\\T-W864-IX-008', 09:46:28 INFO - 'MONDIR': 'C:\\Monitor_config\\', 09:46:28 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 09:46:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:28 INFO - 'MOZ_NO_REMOTE': '1', 09:46:28 INFO - 'NO_EM_RESTART': '1', 09:46:28 INFO - 'NUMBER_OF_PROCESSORS': '8', 09:46:28 INFO - 'OS': 'Windows_NT', 09:46:28 INFO - 'OURDRIVE': 'C:', 09:46:28 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 09:46:28 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 09:46:28 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 09:46:28 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 09:46:28 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 09:46:28 INFO - 'PROCESSOR_LEVEL': '6', 09:46:28 INFO - 'PROCESSOR_REVISION': '1e05', 09:46:28 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 09:46:28 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 09:46:28 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 09:46:28 INFO - 'PROGRAMW6432': 'C:\\Program Files', 09:46:28 INFO - 'PROMPT': '$P$G', 09:46:28 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 09:46:28 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 09:46:28 INFO - 'PUBLIC': 'C:\\Users\\Public', 09:46:28 INFO - 'PWD': 'C:\\slave\\test-pgo', 09:46:28 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 09:46:28 INFO - 'SLAVEDIR': 'C:\\slave\\', 09:46:28 INFO - 'SYSTEMDRIVE': 'C:', 09:46:28 INFO - 'SYSTEMROOT': 'C:\\windows', 09:46:28 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:46:28 INFO - 'TEST1': 'testie', 09:46:28 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:46:28 INFO - 'USERDOMAIN': 'T-W864-IX-008', 09:46:28 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-008', 09:46:28 INFO - 'USERNAME': 'cltbld', 09:46:28 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-008', 09:46:28 INFO - 'WINDIR': 'C:\\windows', 09:46:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 09:46:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:28 INFO - Downloading/unpacking blobuploader==1.2.4 09:46: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 09:46: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 09:46:29 INFO - Downloading blobuploader-1.2.4.tar.gz 09:46:29 INFO - Storing download in cache at c:\slave\test-pgo\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fblobuploader-1.2.4.tar.gz 09:46:29 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader 09:46:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:46: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 09:46: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 09:46:29 INFO - Storing download in cache at c:\slave\test-pgo\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2frequests-1.2.3.tar.gz 09:46:29 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\requests\setup.py) egg_info for package requests 09:46:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:46: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 09:46: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 09:46:29 INFO - Downloading docopt-0.6.1.tar.gz 09:46:29 INFO - Storing download in cache at c:\slave\test-pgo\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fdocopt-0.6.1.tar.gz 09:46:29 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\docopt\setup.py) egg_info for package docopt 09:46:29 INFO - Installing collected packages: blobuploader, requests, docopt 09:46:29 INFO - Running setup.py install for blobuploader 09:46:30 INFO - Running setup.py install for requests 09:46:30 INFO - Running setup.py install for docopt 09:46:30 INFO - Successfully installed blobuploader requests docopt 09:46:30 INFO - Cleaning up... 09:46:32 INFO - Return code: 0 09:46:32 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv 09:46:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:32 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--no-deps', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test-pgo\\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 0x0229EB10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022FFEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x023AA398>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00738B48>, '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 0x0075A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0278B660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-008', 'USERDOMAIN': 'T-W864-IX-008', '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-008', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-008\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-008', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-008', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-008', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-008\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test-pgo', '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 09:46:32 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--no-deps', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test-pgo\\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-pgo\build\tests\config 09:46:32 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --no-deps --download-cache C:\slave\test-pgo\build/venv\cache --timeout 120 -r C:\slave\test-pgo\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 09:46:32 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 09:46:32 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-008\\AppData\\Roaming', 09:46:32 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 09:46:32 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 09:46:32 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 09:46:32 INFO - 'COMPUTERNAME': 'T-W864-IX-008', 09:46:32 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 09:46:32 INFO - 'DCLOCATION': 'SCL3', 09:46:32 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 09:46:32 INFO - 'FP_NO_HOST_CHECK': 'NO', 09:46:32 INFO - 'HOMEDRIVE': 'C:', 09:46:32 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-008', 09:46:32 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 09:46:32 INFO - 'KTS_VERSION': '1.19c', 09:46:32 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-008\\AppData\\Local', 09:46:32 INFO - 'LOGONSERVER': '\\\\T-W864-IX-008', 09:46:32 INFO - 'MONDIR': 'C:\\Monitor_config\\', 09:46:32 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 09:46:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:32 INFO - 'MOZ_NO_REMOTE': '1', 09:46:32 INFO - 'NO_EM_RESTART': '1', 09:46:32 INFO - 'NUMBER_OF_PROCESSORS': '8', 09:46:32 INFO - 'OS': 'Windows_NT', 09:46:32 INFO - 'OURDRIVE': 'C:', 09:46:32 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 09:46:32 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 09:46:32 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 09:46:32 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 09:46:32 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 09:46:32 INFO - 'PROCESSOR_LEVEL': '6', 09:46:32 INFO - 'PROCESSOR_REVISION': '1e05', 09:46:32 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 09:46:32 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 09:46:32 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 09:46:32 INFO - 'PROGRAMW6432': 'C:\\Program Files', 09:46:32 INFO - 'PROMPT': '$P$G', 09:46:32 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 09:46:32 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 09:46:32 INFO - 'PUBLIC': 'C:\\Users\\Public', 09:46:32 INFO - 'PWD': 'C:\\slave\\test-pgo', 09:46:32 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 09:46:32 INFO - 'SLAVEDIR': 'C:\\slave\\', 09:46:32 INFO - 'SYSTEMDRIVE': 'C:', 09:46:32 INFO - 'SYSTEMROOT': 'C:\\windows', 09:46:32 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:46:32 INFO - 'TEST1': 'testie', 09:46:32 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:46:32 INFO - 'USERDOMAIN': 'T-W864-IX-008', 09:46:32 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-008', 09:46:32 INFO - 'USERNAME': 'cltbld', 09:46:32 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-008', 09:46:32 INFO - 'WINDIR': 'C:\\windows', 09:46:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 09:46:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:32 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\manifestparser 09:46:32 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-92czb_-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/manifestparser 09:46:32 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozcrash 09:46:32 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-7yci4w-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozcrash 09:46:32 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdebug 09:46:32 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-gyvt3j-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdebug 09:46:32 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdevice 09:46:32 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ny6pyj-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdevice 09:46:32 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozfile 09:46:33 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-z2buyr-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozfile 09:46:33 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozhttpd 09:46:33 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jcvjlc-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozhttpd 09:46:33 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinfo 09:46:33 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-gcnivw-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinfo 09:46:33 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinstall 09:46:33 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-hwek2h-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinstall 09:46:33 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozleak 09:46:33 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-5t1a_o-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozleak 09:46:34 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozlog 09:46:34 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-w04rkx-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozlog 09:46:34 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moznetwork 09:46:34 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-mcgsbr-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moznetwork 09:46:34 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprocess 09:46:34 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-eeypao-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprocess 09:46:34 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprofile 09:46:34 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-mrvnuf-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprofile 09:46:34 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozrunner 09:46:34 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-d1obm_-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozrunner 09:46:34 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozscreenshot 09:46:34 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-uilzyw-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:46:34 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moztest 09:46:34 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-kf_r6j-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moztest 09:46:34 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozversion 09:46:34 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xrfj2e-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozversion 09:46:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:46:34 INFO - Running setup.py install for manifestparser 09:46:35 INFO - Installing manifestparser-script.py script to C:\slave\test-pgo\build\venv\Scripts 09:46:35 INFO - Installing manifestparser.exe script to C:\slave\test-pgo\build\venv\Scripts 09:46:35 INFO - Running setup.py install for mozcrash 09:46:35 INFO - Running setup.py install for mozdebug 09:46:36 INFO - Running setup.py install for mozdevice 09:46:36 INFO - Installing sutini-script.py script to C:\slave\test-pgo\build\venv\Scripts 09:46:36 INFO - Installing sutini.exe script to C:\slave\test-pgo\build\venv\Scripts 09:46:36 INFO - Installing dm-script.py script to C:\slave\test-pgo\build\venv\Scripts 09:46:36 INFO - Installing dm.exe script to C:\slave\test-pgo\build\venv\Scripts 09:46:36 INFO - Running setup.py install for mozfile 09:46:37 INFO - Running setup.py install for mozhttpd 09:46:37 INFO - Installing mozhttpd-script.py script to C:\slave\test-pgo\build\venv\Scripts 09:46:37 INFO - Installing mozhttpd.exe script to C:\slave\test-pgo\build\venv\Scripts 09:46:37 INFO - Running setup.py install for mozinfo 09:46:37 INFO - Installing mozinfo-script.py script to C:\slave\test-pgo\build\venv\Scripts 09:46:37 INFO - Installing mozinfo.exe script to C:\slave\test-pgo\build\venv\Scripts 09:46:37 INFO - Running setup.py install for mozInstall 09:46:37 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test-pgo\build\venv\Scripts 09:46:37 INFO - Installing moz_remove_from_system.exe script to C:\slave\test-pgo\build\venv\Scripts 09:46:37 INFO - Installing mozuninstall-script.py script to C:\slave\test-pgo\build\venv\Scripts 09:46:37 INFO - Installing mozuninstall.exe script to C:\slave\test-pgo\build\venv\Scripts 09:46:37 INFO - Installing mozinstall-script.py script to C:\slave\test-pgo\build\venv\Scripts 09:46:37 INFO - Installing mozinstall.exe script to C:\slave\test-pgo\build\venv\Scripts 09:46:37 INFO - Installing moz_add_to_system-script.py script to C:\slave\test-pgo\build\venv\Scripts 09:46:37 INFO - Installing moz_add_to_system.exe script to C:\slave\test-pgo\build\venv\Scripts 09:46:38 INFO - Running setup.py install for mozleak 09:46:38 INFO - Running setup.py install for mozlog 09:46:38 INFO - Installing structlog-script.py script to C:\slave\test-pgo\build\venv\Scripts 09:46:38 INFO - Installing structlog.exe script to C:\slave\test-pgo\build\venv\Scripts 09:46:39 INFO - Running setup.py install for moznetwork 09:46:39 INFO - Installing moznetwork-script.py script to C:\slave\test-pgo\build\venv\Scripts 09:46:39 INFO - Installing moznetwork.exe script to C:\slave\test-pgo\build\venv\Scripts 09:46:39 INFO - Running setup.py install for mozprocess 09:46:40 INFO - Running setup.py install for mozprofile 09:46:40 INFO - Installing mozprofile-script.py script to C:\slave\test-pgo\build\venv\Scripts 09:46:40 INFO - Installing mozprofile.exe script to C:\slave\test-pgo\build\venv\Scripts 09:46:40 INFO - Installing diff-profiles-script.py script to C:\slave\test-pgo\build\venv\Scripts 09:46:40 INFO - Installing diff-profiles.exe script to C:\slave\test-pgo\build\venv\Scripts 09:46:40 INFO - Installing view-profile-script.py script to C:\slave\test-pgo\build\venv\Scripts 09:46:40 INFO - Installing view-profile.exe script to C:\slave\test-pgo\build\venv\Scripts 09:46:41 INFO - Running setup.py install for mozrunner 09:46:41 INFO - Installing mozrunner-script.py script to C:\slave\test-pgo\build\venv\Scripts 09:46:41 INFO - Installing mozrunner.exe script to C:\slave\test-pgo\build\venv\Scripts 09:46:41 INFO - Running setup.py install for mozscreenshot 09:46:42 INFO - Running setup.py install for moztest 09:46:42 INFO - Running setup.py install for mozversion 09:46:42 INFO - Installing mozversion-script.py script to C:\slave\test-pgo\build\venv\Scripts 09:46:42 INFO - Installing mozversion.exe script to C:\slave\test-pgo\build\venv\Scripts 09:46:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:46:42 INFO - Cleaning up... 09:46:42 INFO - Return code: 0 09:46:42 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv 09:46:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:42 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test-pgo\\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 0x0229EB10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022FFEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x023AA398>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00738B48>, '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 0x0075A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0278B660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-008', 'USERDOMAIN': 'T-W864-IX-008', '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-008', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-008\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-008', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-008', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-008', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-008\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test-pgo', '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 09:46:42 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test-pgo\\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-pgo\build\tests\config 09:46:42 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --download-cache C:\slave\test-pgo\build/venv\cache --timeout 120 -r C:\slave\test-pgo\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 09:46:42 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 09:46:42 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-008\\AppData\\Roaming', 09:46:42 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 09:46:42 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 09:46:42 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 09:46:42 INFO - 'COMPUTERNAME': 'T-W864-IX-008', 09:46:42 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 09:46:42 INFO - 'DCLOCATION': 'SCL3', 09:46:42 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 09:46:42 INFO - 'FP_NO_HOST_CHECK': 'NO', 09:46:42 INFO - 'HOMEDRIVE': 'C:', 09:46:42 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-008', 09:46:42 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 09:46:42 INFO - 'KTS_VERSION': '1.19c', 09:46:42 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-008\\AppData\\Local', 09:46:42 INFO - 'LOGONSERVER': '\\\\T-W864-IX-008', 09:46:42 INFO - 'MONDIR': 'C:\\Monitor_config\\', 09:46:42 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 09:46:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:42 INFO - 'MOZ_NO_REMOTE': '1', 09:46:42 INFO - 'NO_EM_RESTART': '1', 09:46:42 INFO - 'NUMBER_OF_PROCESSORS': '8', 09:46:42 INFO - 'OS': 'Windows_NT', 09:46:42 INFO - 'OURDRIVE': 'C:', 09:46:42 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 09:46:42 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 09:46:42 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 09:46:42 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 09:46:42 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 09:46:42 INFO - 'PROCESSOR_LEVEL': '6', 09:46:42 INFO - 'PROCESSOR_REVISION': '1e05', 09:46:42 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 09:46:42 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 09:46:42 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 09:46:42 INFO - 'PROGRAMW6432': 'C:\\Program Files', 09:46:42 INFO - 'PROMPT': '$P$G', 09:46:42 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 09:46:42 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 09:46:42 INFO - 'PUBLIC': 'C:\\Users\\Public', 09:46:42 INFO - 'PWD': 'C:\\slave\\test-pgo', 09:46:42 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 09:46:42 INFO - 'SLAVEDIR': 'C:\\slave\\', 09:46:42 INFO - 'SYSTEMDRIVE': 'C:', 09:46:42 INFO - 'SYSTEMROOT': 'C:\\windows', 09:46:42 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:46:42 INFO - 'TEST1': 'testie', 09:46:42 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:46:42 INFO - 'USERDOMAIN': 'T-W864-IX-008', 09:46:42 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-008', 09:46:42 INFO - 'USERNAME': 'cltbld', 09:46:42 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-008', 09:46:42 INFO - 'WINDIR': 'C:\\windows', 09:46:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 09:46:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:43 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\manifestparser 09:46:43 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-t1gktx-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/manifestparser 09:46:43 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///C:/slave/test-pgo/build/tests/mozbase/manifestparser in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 1)) 09:46:43 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozcrash 09:46:43 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-nisd8r-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozcrash 09:46:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///C:/slave/test-pgo/build/tests/mozbase/mozcrash in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 2)) 09:46:43 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdebug 09:46:43 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ifvr7w-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdebug 09:46:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///C:/slave/test-pgo/build/tests/mozbase/mozdebug in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 3)) 09:46:43 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdevice 09:46:43 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xentyo-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdevice 09:46:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 from file:///C:/slave/test-pgo/build/tests/mozbase/mozdevice in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 4)) 09:46:43 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozfile 09:46:43 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ms9au3-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozfile 09:46:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///C:/slave/test-pgo/build/tests/mozbase/mozfile in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 5)) 09:46:43 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozhttpd 09:46:43 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-aafwdk-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozhttpd 09:46:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///C:/slave/test-pgo/build/tests/mozbase/mozhttpd in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 6)) 09:46:43 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinfo 09:46:43 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-zlxdyq-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinfo 09:46:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 from file:///C:/slave/test-pgo/build/tests/mozbase/mozinfo in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 7)) 09:46:43 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinstall 09:46:43 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-vf7rsm-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinstall 09:46:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///C:/slave/test-pgo/build/tests/mozbase/mozinstall in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 8)) 09:46:44 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozleak 09:46:44 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ceh59k-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozleak 09:46:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///C:/slave/test-pgo/build/tests/mozbase/mozleak in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 9)) 09:46:44 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozlog 09:46:44 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ogd05x-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozlog 09:46:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///C:/slave/test-pgo/build/tests/mozbase/mozlog in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 10)) 09:46:44 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moznetwork 09:46:44 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-9ezld9-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moznetwork 09:46:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///C:/slave/test-pgo/build/tests/mozbase/moznetwork in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 11)) 09:46:44 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprocess 09:46:44 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-dufrn3-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprocess 09:46:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///C:/slave/test-pgo/build/tests/mozbase/mozprocess in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 12)) 09:46:44 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprofile 09:46:44 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qctage-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprofile 09:46:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///C:/slave/test-pgo/build/tests/mozbase/mozprofile in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 13)) 09:46:44 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozrunner 09:46:44 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-otwfkd-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozrunner 09:46:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///C:/slave/test-pgo/build/tests/mozbase/mozrunner in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 14)) 09:46:44 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozscreenshot 09:46:44 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qrr5ft-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:46:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///C:/slave/test-pgo/build/tests/mozbase/mozscreenshot in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 15)) 09:46:44 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moztest 09:46:44 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rxzlix-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moztest 09:46:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///C:/slave/test-pgo/build/tests/mozbase/moztest in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 16)) 09:46:45 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozversion 09:46:45 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-tvrf6l-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozversion 09:46:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///C:/slave/test-pgo/build/tests/mozbase/mozversion in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 17)) 09:46:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in c:\slave\test-pgo\build\venv\lib\site-packages (from mozcrash==0.16->-r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 2)) 09:46:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in c:\slave\test-pgo\build\venv\lib\site-packages (from mozcrash==0.16->-r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 2)) 09:46:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in c:\slave\test-pgo\build\venv\lib\site-packages (from mozdebug==0.1->-r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 3)) 09:46:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test-pgo\build\venv\lib\site-packages (from mozdevice==0.46->-r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 4)) 09:46:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in c:\slave\test-pgo\build\venv\lib\site-packages (from mozdevice==0.46->-r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 4)) 09:46:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 10)) 09:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:46 INFO - Downloading blessings-1.5.1.tar.gz 09:46:46 INFO - Storing download in cache at c:\slave\test-pgo\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fblessings-1.5.1.tar.gz 09:46:46 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\blessings\setup.py) egg_info for package blessings 09:46:46 INFO - Installing collected packages: blessings 09:46:46 INFO - Running setup.py install for blessings 09:46:46 INFO - Successfully installed blessings 09:46:46 INFO - Cleaning up... 09:46:49 INFO - Return code: 0 09:46:49 INFO - Done creating virtualenv C:\slave\test-pgo\build/venv. 09:46:49 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'freeze'] 09:46:49 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip freeze 09:46:49 INFO - Reading from file tmpfile_stdout 09:46:49 INFO - Using _rmtree_windows ... 09:46:49 INFO - Using _rmtree_windows ... 09:46:49 INFO - Current package versions: 09:46:49 INFO - blessings == 1.5.1 09:46:49 INFO - blobuploader == 1.2.4 09:46:49 INFO - docopt == 0.6.1 09:46:49 INFO - manifestparser == 1.1 09:46:49 INFO - mozInstall == 1.12 09:46:49 INFO - mozcrash == 0.16 09:46:49 INFO - mozdebug == 0.1 09:46:49 INFO - mozdevice == 0.46 09:46:49 INFO - mozfile == 1.2 09:46:49 INFO - mozhttpd == 0.7 09:46:49 INFO - mozinfo == 0.8 09:46:49 INFO - mozleak == 0.1 09:46:49 INFO - mozlog == 3.0 09:46:49 INFO - moznetwork == 0.27 09:46:49 INFO - mozprocess == 0.22 09:46:49 INFO - mozprofile == 0.27 09:46:49 INFO - mozrunner == 6.11 09:46:49 INFO - mozscreenshot == 0.1 09:46:49 INFO - mozsystemmonitor == 0.0 09:46:49 INFO - moztest == 0.7 09:46:49 INFO - mozversion == 1.4 09:46:49 INFO - psutil == 3.1.1 09:46:49 INFO - requests == 1.2.3 09:46:49 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv 09:46:49 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')]} 09:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:49 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')]} 09:46:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:49 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test-pgo\\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 0x0229EB10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022FFEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x023AA398>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00738B48>, '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 0x0075A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0278B660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build\\tests\\talos', 'env': {'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W864-IX-008', 'USERDOMAIN': 'T-W864-IX-008', '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-008', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-008\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-008', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-008', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-008', 'MOZ_NO_REMOTE': '1', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'PROGRAMDATA': 'C:\\ProgramData', 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-008\\AppData\\Roaming', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'PWD': 'C:\\slave\\test-pgo', '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 09:46:49 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test-pgo\\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-pgo\build\tests\talos 09:46:49 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --download-cache C:\slave\test-pgo\build/venv\cache --timeout 120 -r C:\slave\test-pgo\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 09:46:49 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 09:46:49 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-008\\AppData\\Roaming', 09:46:49 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 09:46:49 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 09:46:49 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 09:46:49 INFO - 'COMPUTERNAME': 'T-W864-IX-008', 09:46:49 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 09:46:49 INFO - 'DCLOCATION': 'SCL3', 09:46:49 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 09:46:49 INFO - 'FP_NO_HOST_CHECK': 'NO', 09:46:49 INFO - 'HOMEDRIVE': 'C:', 09:46:49 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-008', 09:46:49 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 09:46:49 INFO - 'KTS_VERSION': '1.19c', 09:46:49 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-008\\AppData\\Local', 09:46:49 INFO - 'LOGONSERVER': '\\\\T-W864-IX-008', 09:46:49 INFO - 'MONDIR': 'C:\\Monitor_config\\', 09:46:49 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 09:46:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:49 INFO - 'MOZ_NO_REMOTE': '1', 09:46:49 INFO - 'NO_EM_RESTART': '1', 09:46:49 INFO - 'NUMBER_OF_PROCESSORS': '8', 09:46:49 INFO - 'OS': 'Windows_NT', 09:46:49 INFO - 'OURDRIVE': 'C:', 09:46:49 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 09:46:49 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 09:46:49 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 09:46:49 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 09:46:49 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 09:46:49 INFO - 'PROCESSOR_LEVEL': '6', 09:46:49 INFO - 'PROCESSOR_REVISION': '1e05', 09:46:49 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 09:46:49 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 09:46:49 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 09:46:49 INFO - 'PROGRAMW6432': 'C:\\Program Files', 09:46:49 INFO - 'PROMPT': '$P$G', 09:46:49 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 09:46:49 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 09:46:49 INFO - 'PUBLIC': 'C:\\Users\\Public', 09:46:49 INFO - 'PWD': 'C:\\slave\\test-pgo', 09:46:49 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 09:46:49 INFO - 'SLAVEDIR': 'C:\\slave\\', 09:46:49 INFO - 'SYSTEMDRIVE': 'C:', 09:46:49 INFO - 'SYSTEMROOT': 'C:\\windows', 09:46:49 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:46:49 INFO - 'TEST1': 'testie', 09:46:49 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:46:49 INFO - 'USERDOMAIN': 'T-W864-IX-008', 09:46:49 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-008', 09:46:49 INFO - 'USERNAME': 'cltbld', 09:46:49 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-008', 09:46:49 INFO - 'WINDIR': 'C:\\windows', 09:46:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 09:46:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 1)) 09:46:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 2)) 09:46:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 3)) 09:46:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 4)) 09:46:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 5)) 09:46:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 6)) 09:46:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 7)) 09:46:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 8)) 09:46:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in c:\slave\test-pgo\build\venv\lib\site-packages (from mozcrash>=0.15->-r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 1)) 09:46:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test-pgo\build\venv\lib\site-packages (from mozhttpd>=0.7->-r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 3)) 09:46:49 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in c:\slave\test-pgo\build\venv\lib\site-packages (from mozlog>=3.0->mozcrash>=0.15->-r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 1)) 09:46:49 INFO - Cleaning up... 09:46:49 INFO - Return code: 0 09:46:49 INFO - Running post-action listener: _resource_record_post_action 09:46:49 INFO - Running post-action listener: _start_resource_monitoring 09:46:49 INFO - Starting resource monitoring. 09:46:50 INFO - ##### 09:46:50 INFO - ##### Running install step. 09:46:50 INFO - ##### 09:46:50 INFO - Running pre-action listener: _resource_record_pre_action 09:46:50 INFO - Running main action method: install 09:46:50 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'freeze'] 09:46:50 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip freeze 09:46:50 INFO - Reading from file tmpfile_stdout 09:46:50 INFO - Using _rmtree_windows ... 09:46:50 INFO - Using _rmtree_windows ... 09:46:50 INFO - Detecting whether we're running mozinstall >=1.0... 09:46:50 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build/venv/scripts/python', 'C:\\slave\\test-pgo\\build/venv/scripts/mozinstall-script.py', '-h'] 09:46:50 INFO - Copy/paste: C:\slave\test-pgo\build/venv/scripts/python C:\slave\test-pgo\build/venv/scripts/mozinstall-script.py -h 09:46:50 INFO - Reading from file tmpfile_stdout 09:46:50 INFO - Output received: 09:46:50 INFO - Usage: mozinstall-script.py [options] installer 09:46:50 INFO - Options: 09:46:50 INFO - -h, --help show this help message and exit 09:46:50 INFO - -d DEST, --destination=DEST 09:46:50 INFO - Directory to install application into. [default: 09:46:50 INFO - "C:\slave\test-pgo"] 09:46:50 INFO - --app=APP Application being installed. [default: firefox] 09:46:50 INFO - Using _rmtree_windows ... 09:46:50 INFO - Using _rmtree_windows ... 09:46:50 INFO - mkdir: C:\slave\test-pgo\build\application 09:46:50 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build/venv/scripts/python', 'C:\\slave\\test-pgo\\build/venv/scripts/mozinstall-script.py', 'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win64.zip', '--destination', 'C:\\slave\\test-pgo\\build\\application'] 09:46:50 INFO - Copy/paste: C:\slave\test-pgo\build/venv/scripts/python C:\slave\test-pgo\build/venv/scripts/mozinstall-script.py C:\slave\test-pgo\build\firefox-44.0a1.en-US.win64.zip --destination C:\slave\test-pgo\build\application 09:46:52 INFO - Reading from file tmpfile_stdout 09:46:52 INFO - Output received: 09:46:52 INFO - C:\slave\test-pgo\build\application\firefox\firefox.exe 09:46:52 INFO - Using _rmtree_windows ... 09:46:52 INFO - Using _rmtree_windows ... 09:46:52 INFO - Running post-action listener: _resource_record_post_action 09:46:52 INFO - ##### 09:46:52 INFO - ##### Running run-tests step. 09:46:52 INFO - ##### 09:46:52 INFO - Running pre-action listener: _resource_record_pre_action 09:46:52 INFO - Running main action method: run_tests 09:46:52 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\python', '--version'] 09:46:52 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\python --version 09:46:52 INFO - Python 2.7.3 09:46:52 INFO - Return code: 0 09:46:52 INFO - grabbing minidump binary from tooltool 09:46: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')]} 09:46:52 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-pgo\\build\\tests\\config/tooltool-manifests/win32/releng.manifest', '-o'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x00738B48>, '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 0x0075A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0278B660>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'privileged': False}, attempt #1 09:46:52 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-pgo\\build\\tests\\config/tooltool-manifests/win32/releng.manifest', '-o'] in C:\slave\test-pgo\build 09:46:52 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-pgo\build\tests\config/tooltool-manifests/win32/releng.manifest -o 09:46:52 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 09:46:54 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test-pgo\build\tmpaedj5q 09:46:54 INFO - INFO - File integrity verified, renaming tmpaedj5q to win32-minidump_stackwalk.exe 09:46:54 INFO - Return code: 0 09:46:54 INFO - Chmoding C:\slave\test-pgo\build\win32-minidump_stackwalk.exe to 0755 09:46:54 INFO - mkdir: C:\slave\test-pgo\build\blobber_upload_dir 09:46:54 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test-pgo\build\blobber_upload_dir 09:46:54 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test-pgo\build\win32-minidump_stackwalk.exe 09:46:54 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test-pgo\build\blobber_upload_dir 09:46:54 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\python', 'C:\\slave\\test-pgo\\build\\tests\\talos\\talos\\run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test-pgo\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/t_w4rQ1sTkOMFcIKwKqAAA/artifacts/public/build/firefox-44.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-008', '--webServer', 'localhost'] in C:\slave\test-pgo\build 09:46:54 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\python C:\slave\test-pgo\build\tests\talos\talos\run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath C:\slave\test-pgo\build\application\firefox\firefox --symbolsPath https://queue.taskcluster.net/v1/task/t_w4rQ1sTkOMFcIKwKqAAA/artifacts/public/build/firefox-44.0a1.en-US.win64.crashreporter-symbols.zip --title T-W864-IX-008 --webServer localhost 09:46:54 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 09:46:54 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-008\\AppData\\Roaming', 09:46:54 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 09:46:54 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 09:46:54 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 09:46:54 INFO - 'COMPUTERNAME': 'T-W864-IX-008', 09:46:54 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 09:46:54 INFO - 'DCLOCATION': 'SCL3', 09:46:54 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 09:46:54 INFO - 'FP_NO_HOST_CHECK': 'NO', 09:46:54 INFO - 'HOMEDRIVE': 'C:', 09:46:54 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-008', 09:46:54 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 09:46:54 INFO - 'KTS_VERSION': '1.19c', 09:46:54 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-008\\AppData\\Local', 09:46:54 INFO - 'LOGONSERVER': '\\\\T-W864-IX-008', 09:46:54 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test-pgo\\build\\blobber_upload_dir', 09:46:54 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test-pgo\\build\\win32-minidump_stackwalk.exe', 09:46:54 INFO - 'MONDIR': 'C:\\Monitor_config\\', 09:46:54 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 09:46:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:54 INFO - 'MOZ_NO_REMOTE': '1', 09:46:54 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test-pgo\\build\\blobber_upload_dir', 09:46:54 INFO - 'NO_EM_RESTART': '1', 09:46:54 INFO - 'NUMBER_OF_PROCESSORS': '8', 09:46:54 INFO - 'OS': 'Windows_NT', 09:46:54 INFO - 'OURDRIVE': 'C:', 09:46:54 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 09:46:54 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 09:46:54 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 09:46:54 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 09:46:54 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 09:46:54 INFO - 'PROCESSOR_LEVEL': '6', 09:46:54 INFO - 'PROCESSOR_REVISION': '1e05', 09:46:54 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 09:46:54 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 09:46:54 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 09:46:54 INFO - 'PROGRAMW6432': 'C:\\Program Files', 09:46:54 INFO - 'PROMPT': '$P$G', 09:46:54 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 09:46:54 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 09:46:54 INFO - 'PUBLIC': 'C:\\Users\\Public', 09:46:54 INFO - 'PWD': 'C:\\slave\\test-pgo', 09:46:54 INFO - 'PYTHONPATH': 'C:\\slave\\test-pgo\\build\\tests\\talos', 09:46:54 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 09:46:54 INFO - 'SLAVEDIR': 'C:\\slave\\', 09:46:54 INFO - 'SYSTEMDRIVE': 'C:', 09:46:54 INFO - 'SYSTEMROOT': 'C:\\windows', 09:46:54 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:46:54 INFO - 'TEST1': 'testie', 09:46:54 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 09:46:54 INFO - 'USERDOMAIN': 'T-W864-IX-008', 09:46:54 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-008', 09:46:54 INFO - 'USERNAME': 'cltbld', 09:46:54 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-008', 09:46:54 INFO - 'WINDIR': 'C:\\windows', 09:46:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 09:46:54 INFO - Calling ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\python', 'C:\\slave\\test-pgo\\build\\tests\\talos\\talos\\run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test-pgo\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/t_w4rQ1sTkOMFcIKwKqAAA/artifacts/public/build/firefox-44.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-008', '--webServer', 'localhost'] with output_timeout 3600 ProcessManager NOT managing child processes ProcessManager UNABLE to use job objects to manage child processes 09:46:55 INFO - mozversion INFO | application_buildid: 20151024053005 09:46:55 INFO - mozversion INFO | application_changeset: f95c614295a0971529da8c0c93d28718e7c4c5bd 09:46:55 INFO - mozversion INFO | application_display_name: Nightly 09:46:55 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:46:55 INFO - mozversion INFO | application_name: Firefox 09:46:55 INFO - mozversion INFO | application_remotingname: firefox 09:46:55 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 09:46:55 INFO - mozversion INFO | application_vendor: Mozilla 09:46:55 INFO - mozversion INFO | application_version: 44.0a1 09:46:55 INFO - mozversion INFO | platform_buildid: 20151024053005 09:46:55 INFO - mozversion INFO | platform_changeset: f95c614295a0971529da8c0c93d28718e7c4c5bd 09:46:55 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 09:46:55 INFO - mozversion INFO | platform_version: 44.0a1 09:46:55 INFO - 2015-10-24 09:46:55,177 DEBUG : using testdate: 1445705215 09:46:55 INFO - 2015-10-24 09:46:55,177 DEBUG : actual date: 1445705215 09:46:55 INFO - 2015-10-24 09:46:55,187 INFO : starting webserver on 'localhost:49281' 09:46:55 INFO - 2015-10-24 09:46:55,187 INFO : Starting test suite T-W864-IX-008 09:46:55 INFO - 2015-10-24 09:46:55,187 INFO : Starting test dromaeo_css 09:46:55 INFO - 2015-10-24 09:46:55,188 DEBUG : operating with platform_type : w8_ 09:46:55 INFO - 2015-10-24 09:46:55,188 INFO : Initialising browser for dromaeo_css test... 09:46:55 INFO - 2015-10-24 09:46:55,308 DEBUG : command line: C:\slave\test-pgo\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpwhxaqm\profile http://localhost:49281/getInfo.html 09:47:03 INFO - 2015-10-24 09:47:03,805 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:47:03 INFO - 2015-10-24 09:47:03,805 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:47:03 INFO - 2015-10-24 09:47:03,805 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674 09:47:03 INFO - 2015-10-24 09:47:03,805 DEBUG : BROWSER_OUTPUT: __metrics 09:47:03 INFO - 2015-10-24 09:47:03,944 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:47:05 INFO - 2015-10-24 09:47:05,582 DEBUG : BROWSER_OUTPUT: console.error: 09:47:05 INFO - 2015-10-24 09:47:05,582 DEBUG : BROWSER_OUTPUT: Message: Error: Transaction canceled due to a closed connection. 09:47:05 INFO - 2015-10-24 09:47:05,582 DEBUG : BROWSER_OUTPUT: Stack: 09:47:05 INFO - 2015-10-24 09:47:05,582 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise<@resource://gre/modules/Sqlite.jsm:562:1 09:47:05 INFO - 2015-10-24 09:47:05,582 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 09:47:05 INFO - 2015-10-24 09:47:05,582 DEBUG : BROWSER_OUTPUT: 09:47:06 INFO - 2015-10-24 09:47:06,325 INFO : Browser initialized. 09:47:06 INFO - 2015-10-24 09:47:06,325 INFO : Running cycle 1/1 for dromaeo_css test... 09:47:06 INFO - 2015-10-24 09:47:06,325 DEBUG : command line: C:\slave\test-pgo\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpwhxaqm\profile -tp file:\C:\slave\test-pgo\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:47:17 INFO - 2015-10-24 09:47:17,680 DEBUG : BROWSER_OUTPUT: RSS: Main: 167284736 09:47:17 INFO - 2015-10-24 09:47:17,680 DEBUG : BROWSER_OUTPUT: 09:48:08 INFO - 2015-10-24 09:48:08,782 DEBUG : BROWSER_OUTPUT: 1445705288782 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] 09:50:17 INFO - 2015-10-24 09:50:17,342 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49281/tests/dromaeo/cssquery-ext.html) 09:50:18 INFO - 2015-10-24 09:50:18,335 DEBUG : BROWSER_OUTPUT: RSS: Main: 214306816 09:50:18 INFO - 2015-10-24 09:50:18,335 DEBUG : BROWSER_OUTPUT: 09:53:21 INFO - 2015-10-24 09:53:21,075 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-ext.html (next: http://localhost:49281/tests/dromaeo/cssquery-jquery.html) 09:53:21 INFO - 2015-10-24 09:53:21,638 DEBUG : BROWSER_OUTPUT: RSS: Main: 226058240 09:53:21 INFO - 2015-10-24 09:53:21,638 DEBUG : BROWSER_OUTPUT: 09:56:23 INFO - 2015-10-24 09:56:23,726 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49281/tests/dromaeo/cssquery-mootools.html) 09:56:24 INFO - 2015-10-24 09:56:24,289 DEBUG : BROWSER_OUTPUT: RSS: Main: 200273920 09:56:24 INFO - 2015-10-24 09:56:24,289 DEBUG : BROWSER_OUTPUT: 09:59:26 INFO - 2015-10-24 09:59:26,391 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49281/tests/dromaeo/cssquery-prototype.html) 09:59:26 INFO - 2015-10-24 09:59:26,953 DEBUG : BROWSER_OUTPUT: RSS: Main: 162201600 09:59:26 INFO - 2015-10-24 09:59:26,953 DEBUG : BROWSER_OUTPUT: 10:02:29 INFO - 2015-10-24 10:02:29,759 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49281/tests/dromaeo/cssquery-yui.html) 10:02:30 INFO - 2015-10-24 10:02:30,348 DEBUG : BROWSER_OUTPUT: RSS: Main: 163012608 10:02:30 INFO - 2015-10-24 10:02:30,348 DEBUG : BROWSER_OUTPUT: 10:05:32 INFO - 2015-10-24 10:05:32,759 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-yui.html (next: http://localhost:49281/tests/dromaeo/cssquery-dojo.html) 10:05:33 INFO - 2015-10-24 10:05:33,013 DEBUG : BROWSER_OUTPUT: RSS: Main: 281833472 10:05:33 INFO - 2015-10-24 10:05:33,013 DEBUG : BROWSER_OUTPUT: 10:05:33 INFO - 2015-10-24 10:05:33,013 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:05:33 INFO - 2015-10-24 10:05:33,013 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:05:33 INFO - 2015-10-24 10:05:33,013 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:05:33 INFO - 2015-10-24 10:05:33,013 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:05:33 INFO - 2015-10-24 10:05:33,013 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2886.870090845912;2901.8984335548234;2932.794704370695;2935.0461100142447;2939.573761804538;5229.660072095321;5312.07038768215;5340.626156169064;5348.411674715788;5383.273258110159;5356.062689029423;5370.597205209606;5372.758225879835;5387.703676297802;5445.782168713246;4665.346851440801;4732.597729193023;4777.976110119462;4780.115678599453;4784.97607511962;4675.88310292242;4685.0629874025335;4744.122337367581;4783.449903261135;4793.880152996168;4738;4761.59526440253;4776.97611511942;4788.353572267734;4841.7337046462435;4672.275797251432;4753.239481682948;4772.355731976173;4774.952250477486;4823.517648235148;4635.860924172281;4685.742284174403;4713.952860471386;4741.265103908865;4759.381280433521;5147.202183661501;5173.948260517384;5205.7917683293;5216.26972223889;5223.973880130575;5379.435159308295;5454.836354909359;5462.262594549725;5466.371367292772;5511.834644960658;5508.3114610673665;5553.527950124244;5599.664020158803;5608.158776183564;5628.183913332544;5168.09558327295;5173.456787037307;5183.2743415921805;5183.559397451221;5186.818461353834;5491.478309560585;5629.352624448159;5677.205191273225;5742.712864356766;5748.971255143698;5390.083685773349;5429.728513574306;5429.782808687687;5441;5487.890242195213;5572.331320241597;5578.3584887738425;5583.804566840141;5584.609077364546;5595.608307418523;5339.733013349317;5429.185622156708;5505.614606977553;5511.807086751945;5608.018596745554;5382.165764306539;5392.622516423891;5402.270693456412;5471.890562188813;5494.670319780826;3387.271736576648;3388.525606415104;3391.423458012144;3426.7429942754393;3427.417339052367;3098.6746391628553;3123.0630810756684;3152.7477801775804;3165.09794708507;3172.254520187754;5186.222066690027;5234.293370395024;5244.5279924806955;5257.185136303802;5261.5264626183825;5569.582281328917;5588.524975377139;5594.216809646653;5594.356648985337;5597.720113994365;5212.661177023557;5250.369955605352;5252.422233554306;5263.289455923478;5270.130428479335;4378.2994720845145;4381.890452738707;4401.801918913657;4410.757408342572;4427.46870375557;5966.8961242170335;5999.280086389661;6001.159837622737;6009.098635204754;6010.66941318223;5462.562994960473;5555.50000499957;5577.721113944368;5602.439756024365;5672.602917795714;5924.674142922181;5952.285725712942;5958.821235362946;5981.7607295707685;6011.729472173675;5545.417731138173;5562.137868630369;5562.499375056264;5564.081926482085;5580.916286255629;5369.543588794996;5471.124620060771;5625.887482250414;5653.152027195953;5655.264815573949;5425.403205647297;5428.782848686166;5434.782608695766;5459.454054594509;5504.53211477029;5382.569394448513;5385.138377859524;5430.8099216527235;5432.375276843213;5443.510084092451;5271.578273738169;5344.9732751336;5361.597880159082;5374.811881584125;5379.1393377059485;5417.674939503642;5424.159255315432;5463.235147079492;5495.560355171497;5516.034693928626;5417.593680473901;5423.538999185113;5429.728513574384;5439.075357189208;5491.862703432446 10:05:33 INFO - 2015-10-24 10:05:33,013 DEBUG : BROWSER_OUTPUT: |1;ext.html;599.5743022454058;600.672633414789;610.060506819498;612.2194202391947;617.3702823120415;32340.046889918664;39754.8012259939;40090.39864402033;40296.59703402965;40355.77153827694;41123.38314925278;41488.79255603725;41509.16981660365;41548.79225603875;41563.376549351786;8471.15288471154;8508.404411691185;8728.738137855858;8901.554922253861;8906.287497000225;10543.894561054369;10871.29336593119;10917;10923.071538919201;10934.835977460345;10689.198310126732;10795.08241799448;10805.5677772889;10806.297590656583;10810.29733067352;8656.567171641393;8796.076411976714;10551.419671918042;10680;10802.837957430645;10520.94739526305;10559.683209503728;10594;10702.678919632346;10717.839232411443;37903;38208.61791382078;38350.80824595887;38374.80812595919;38423.231535369414;3397.949030764516;3415.4023045966856;3435.261418794971;3556.4487504436597;3633.5276414066266;29349.853250733824;30045.849770751225;30218.79124835004;30411.239719006982;30671.539926901114;2918.8983931569237;3070.9539356909663;3094.3192497650707;3099.7210251077286;3275.4922986937063;299111;305196;305242;305908;308049;51605;51708.22437663438;52323;52411.66236726861;52536;50291.245631315556;50715.74642126766;50784.74607627012;50787.492125079014;50964.11984382061;14735.852641473663;15093.54719358421;15118.924405377902;15127.697446051017;15144.924275378773;11622.593209237637;11638.709032274091;11724.70688232801;11756.118291128028;11759.412029398496;16599.91700041492;16612.50162495127;16634;16659.500214993328;16727.163641818104;7641.732539361207;7751.302382785577;7793.298603125746;7797.532148071134;7848.489848159851;938.2962777916563;956.153803883568;1021.646571962909;1045.911097556701;1047.6490375724065;27991.72008279932;28193.43613127726;28213.858930705213;28235.57646635302;28656.426871462452;1004.467632154959;1026.7535791410157;1028.6039874648313;1052.9052385285208;1058.6030238660503;13694.794578081337;13788.172709637252;13812.585622431343;13823.654408639864;13834.169949803045;376020;379569;380448;380960;381217;47584.52415475801;47591;47775.5222447778;47989.76005119952;48022.75988620104;1290.4322098276728;1292.5088466382715;1301.804729290595;1313.5599574142768;1314.612189404128;26903.192904212905;27042.32394190161;27155.1853444397;27493.45013099767;27597.172084837486;42239.366409503265;42243.7887810559;42678;42839.14321713611;43038;349623.51129466156;350030;353990;354169;359284;27567.31081722893;27939.44121117607;29376.85311573514;29954.850225749604;30847.691523084482;36235.37646235355;37974.43038354372;40677;41679.79160104301;41760.16479670451;34398.484022739176;35114;35421.291574168885;35589;35857.46213806743;27563.310917226427;30394.240143996576;32542.674573253964;33924.49113263352;35062;32831.83584082064;33063.50404743979;33448.33103337871;33482.33035339231;35020.47469288014;31411.214719632193;31475.84262078675;31520.684793152694;31803.681963180996;31823.68176318207;24356;24725.50548989046;24920;25044.749552504243;25227.243182704548 10:05:33 INFO - 2015-10-24 10:05:33,015 DEBUG : BROWSER_OUTPUT: |2;jquery.html;370.2447008103467;372.114367804625;374.99875332861257;376.39212671535466;379.5729803970533;15043.623909402271;16288.674226515463;16515.926464779783;18371.173297201625;18781.812181878176;17089.57276068099;17240.741388879145;17337;17371.73942390865;17492.650146997083;4501.3022981437925;5549.722513874321;5587.078132108198;5666.660000399968;5668.886622267552;3678.2643471305714;6169.29053158888;6216.160818289518;6328.778492752732;6336.5247606429475;6118.204633397652;6129.896618608649;6134.9386506134815;6160.907586386208;6263.655498947556;6156.692165391735;6208.50331973441;6209.6895155242055;6212.751489940397;6221.502279817626;5457.126859702428;5520.530754885839;5525;5531.032069387841;5549;20621.278255260993;20685.8965705172;21274.680879786814;21592.352229432985;21601.891990540105;2063.102550390585;2111.831053515715;2175.2060497918146;2426.7694569015916;2549.6048112542585;8739.737807865775;9072.54637268134;9723.076307750753;9841.114299712988;9886.851697224547;1771.2649250561;1776.200709680649;1776.289484206315;1785.4732853808157;1800.0819582013137;62439.75120497565;63053.684731576504;63687;63970.04044939376;64381.356186438476;6729.528932974645;6750.594964302158;6754.898676519856;6778.186617605918;6822.283660215705;7988.724622904581;7991.880121798177;7993.240642138988;7998.5600791957;8020.43856930021;5308.203769434615;5343.091674415358;5405.945940540623;5412.783488660488;5457.345118585795;5509.696966666792;5515.227868098469;5544.279243698374;5557.110862262019;5560.916586251209;2882.2218001139577;2965.0511836212204;3129.3115514586752;3134.3887941851576;3147.905562833119;1110.972225694348;1126.1047467263545;1128.6501184632791;1139.2993309114834;1179.7050737315672;418.18871389504267;426.59686596166944;435.4970009638872;451.03703592829544;455.22384334709244;9498.952505237568;10656.840147397796;10665.893341066645;11038.889611103947;11853.111016673784;444.99332510012374;449.0412968312676;451.7334772484184;452.4886877828099;455.9635229181657;6147.692615369214;6210.50315974721;6362.618242905441;6383.71273292703;6386.808395748135;475975;515029;577137;601994;607114;78755;79964.20035799568;81305.59347203345;82260.58869705613;83503.58248208721;492.64529538732774;499.86253780210006;500.17970528333564;501.94227663818396;501.9422766381913;10965.671029869116;10977.451127443435;11057.557697692002;11151.72120696989;11183.496742646437;34390.31219375649;34644.48033279453;34790.65209347874;37226.48536506155;37319;48208.276875847594;48953.755231223615;49520.50479495159;49573;49633.75183124061;6387.680615969276;6420.390062944013;6428.742850286123;6586.308437614173;6621.569597976116;9925.255605829447;9947.167785768464;10103.393796372242;12121.696957575778;12157.635270941531;10225.897741022793;10447.582096716047;10474.633387831389;10511.211659125443;10517.789644207227;10243.641472548723;10290.845637315297;10537.9473102634;10569.947150264199;10677.412742299248;10534.841977370192;10896.073833724222;10946.781064378509;11006.284591501526;11011.61459348919;6429.9678501607195;6462.3537646235;6629.900551491635;6632.60204387719;6634.706232284658;9829.066238707312;9830.311878168459;10165.237607179342;10547.78904421892;10992.945035275092 10:05:33 INFO - 2015-10-24 10:05:33,016 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1373.2104040176898;1528.6102043978783;1566.9579729479897;1693.8390852868972;1694.6949549081169;8179.4274400791965;8447.324214062875;9194.816103677922;9472.952635236832;9491.383060101089;9071.365004449692;9100.772480687987;9247.537623118835;9260.861087083698;9271.351005429622;2357.5049239659647;2415.190911044793;2436.8659723715186;2440.6461063145834;2443.4135807406183;2186.868787872733;2226.009425805509;2435.9512809743796;2448.7796098351146;2492.72580016199;2361.138184562631;2383.451806084593;2387.3912152401113;2391.366287933699;2398.112698301622;2139.764625891151;2415.7221919479307;2470.962935555968;2474.6288056791445;2474.7030356357263;2143.174877672092;2298.2990187992655;2309.595820731365;2346.77705617966;2347.3662111229874;9213;9291.72124836256;9300.488473133975;9315.161635452774;9347.953260233724;5362.91955620666;5407.810726624549;5411.21537377082;5414.160805075219;5432.619716619838;3542.8759993400363;3556;3563.6614521620404;3633.1643721943838;3643.7267204959735;1127.261643623428;1153.054495313843;1156.8611766587978;1163.482250398573;1170.894619484242;14044.929775351058;14175.929120354436;14199.71600567983;14372.35324410404;14468.565943021726;4700.694454860423;4762.714237145782;4805.303231031481;4845.442774080955;4883.389576302962;11466.681331646967;11485.712857178638;11488.19582629208;11508.079353651689;11517.827232591519;5328.120860058125;5333.466653334635;5339.0389729849;5340.973295133499;5342.706151161723;4721.787519561628;4780.378550788375;4789.114013907439;4789.832355867528;4795.712257264575;3902.297586434469;3914.5693973662874;3934.1344904121047;3956.140613911457;4024.3963405488826;1217.4217246807873;1221.62740364188;1233.531258121908;1234.0744441668749;1235.1415766042694;1054.177741361739;1054.3041592549034;1102.795982743195;1193.1230545549015;1293.6959814443599;8529.872051919227;8601.225889669835;8709.651613935499;8714.564271786512;8715.302775777922;1116.748731535398;1122.1135303110452;1131.971700707489;1138.2942575603013;1150.8446359741495;6028.969855150696;6139.2325959255095;6265.780697675559;6742.696578653972;6887.690053947585;11830.290182589073;11914.285142891455;11989.760204795855;12269.607426551915;12283.69290767738;12103.152779305365;12146.271223726604;12156;12158.817617735742;12165.20926139798;8048.879266811003;8104.554249516334;8204.343652507785;8242.17578242171;8245.010598728071;8541.188587084218;8598.957005215185;8609.440386374865;8658.696945606873;8659.696910608098;10469.68590942273;10554.2084343673;10586.206034547286;10602.363858168535;10610.522526486173;10670.146388289073;10762.157029336986;10863.523672424748;10916.181286403393;10941.23411361197;8007.919920800718;8049.27556519916;8069;8412.284955778827;8430;8942.597583108905;8996.190342869173;8998.775030624287;9017.188453038996;9018.639254430012;8448.704295349879;8547.658093676184;8665.39342246062;8668.609912553824;8677.305815534868;8306.667733290842;8407.28538074246;8428.199321064489;8434.578271086299;8568.52873091986;8482.660693572188;8506.276966457921;8509.446885952393;8531.95734021326;8560.272376848037;7457.366123879531;7472.327490525879;7525.285097915689;7551.131619863786;7570.356519695888;6219.222597175353;6326.905096423466;7429;7484.738034168778;7488 10:05:33 INFO - 2015-10-24 10:05:33,088 DEBUG : BROWSER_OUTPUT: |4;prototype.html;349.3188282848446;354.9882833923319;357.50664083564675;361.5318162978942;362.6464197407528;5845.0647896336595;5858.73635686394;5862.589618726685;5864.76540938363;5865.560082993777;5620.325560932683;5737.19679244905;5749.993751093562;5752.309722833255;5814.534837213024;4447.08834688888;4463.553644635543;4467.30756732707;4471.53048929861;4471.843485478009;4458.1306645204195;4468.039371535119;4469.910601787962;4474.97762511187;4489.7979590918485;4294.0767734937135;4349.064951035527;4376.715513491613;4398.7580683062415;4430.756308403036;4283.700140990132;4304.935425968613;4364.498082720496;4422.204003279425;4431.8670439886855;3857.189990102082;3915.138669492707;3921.784301863396;3923.215356928597;3938.6258305460933;5604.607677462579;5612.971935140298;5613.07384281593;5618.410066942994;5619.269494965669;5011.974940125312;5119.3088932994315;5122.103631864409;5122.487751224885;5142.074426603247;6019.879602407927;6025.126356678301;6028.96985515074;6032.306284777263;6035.034394496904;4218.641415479658;4244.660427165819;4270.679699022586;4273.465816772903;4278.593533614302;6207.037909124093;6225;6352.174217351715;6356.269029061671;6357.11000459936;4355.867474456601;4388.253996820548;4388.319810429389;4398.516163222043;4404.229259879572;4413.7351758894565;4430.401895744098;4444.73331600105;4466.196084704719;4477.2164871147415;5008.398992120896;5044.8234311798915;5053.823116190915;5054.039732450896;5057.291979122926;5880.294364676266;5949.286085669661;5959.702014899324;5962.910556341659;5990.580659353891;1583.5407731757662;1605.7109720250467;1622.9594260143356;1624.4395683489176;1626.0406360247512;1087.8912108789216;1099.4722533184117;1114.7603265298;1121.7532142928542;1128.565502281611;5886.61736987103;5926.525877929756;5932.673702946379;5934.13954976526;5937.079752638348;6293.590916590407;6298.464630506367;6300.779472718433;6303.747850086037;6306.148669929593;5773.1051686988585;5827.79602713903;5863.648181109147;5877.764889404376;5903.3801450847905;3416.4021296273054;3431.296584200233;3475.3223121491574;3475.8957231283102;3477.982610086933;6686.966565167143;6748.696308666122;6763.289854565298;6769.796906092825;6776.119104516381;6334.936650633527;6382.712777925005;6385.106085148083;6441.355864413521;6443.742250309935;6776.119104516381;6800.387965083068;6803.863922721617;6813.148356455443;6820.590764554143;6228.128062071223;6240.875182496416;6306.905396419149;6322.968385158045;6327;6075.574709770273;6149.569530132848;6151.784687535915;6157.599756015845;6163.7842675506145;6807.761728339485;6819.761308354184;6824.692888820115;6826.317368263134;6837.794866154023;4341.001569639064;4384.714993525411;4390.890227744332;4392.824287028483;4401.2737898247715;6219.968900155471;6254.030625253093;6268.341824108586;6301.4328710416285;6304.84237894038;6160.291566469913;6165.290991535851;6170.290416601969;6173.444390004921;6179.104029915727;6068.605540639845;6073.453389194994;6103.877922441615;6107.114468401968;6107.144999699956;5994.28068631767;6030;6033.758649653964;6058;6061.1514387984835;6140.723667434887;6144.201253836973;6148.231471066117;6150.077488376779;6154.107654389999;6038.305594856648;6052.576319657582;6066.848328791815;6067;6067.726952287246 10:05:33 INFO - 2015-10-24 10:05:33,088 DEBUG : BROWSER_OUTPUT: |5;yui.html;746.3916907720211;748.782852972638;750.7222327738735;757.3865169212938;777.8055486128468;13796.586102416919;14018.439262429516;14054.156750594946;14085.57743267701;14102;12579.622611321653;12712.173708708951;12778.55275065373;12862.742745145091;12874.163179393356;621.7388696747377;627.347558539121;722.2163952111952;730.817295676081;731.641495667122;722.4292808681136;729.4091785653611;733.5048842031634;733.5745267744695;735.672625681572;750.0699133074975;753.4725692015584;754.2005474197368;754.6868049759344;755.3994574313434;646.6281887914445;652.3704625036838;742.361569050616;751.0986815821009;759.1725019728467;545.866262765621;546.7402983582806;551.5477308606944;551.969641669708;554.3181886279898;12443.875561244362;12538;12615.936920315431;12626.494940202381;12732.427040783186;9764.755881102958;9772.755681107958;9793;9853.50732463374;10372.844407333896;9794.75513112178;9849.458279794608;9860.408375497493;9881.308308418413;10000.94999525005;3205.102571280045;3251.1872031992;3283.7865538739907;3305.0415379539904;3335.7498187635783;42796.78601607003;42917.785411073055;42926.356104658145;43293.78353108246;43602;6927.826804329932;7112.431005519649;7193.244709305448;7203.099612548432;7245.601491917995;10513.421761803022;10620;10624.78750424987;10631.20265980039;10631.362118272928;6580.5722628029025;6624.436922861514;6631.469482441393;6706.664666766642;6747.257801641816;3905.9609403906165;3943.152222272225;3963.147923196527;3965.7422267552515;3992.9800350998057;2558.1174494799266;2617.070939816376;2620.344913771557;2621.501914636213;2622.7508386703234;442.3939203291511;448.44169009583277;451.41316288825055;451.9920577113056;452.0664827131962;587.3891153200624;662.9668516574152;711.8006958051753;723.442948929332;748.4526705028586;8506;8684.088170742107;8694.347923905732;8774.919662356908;8823.529411764726;538.7306346826587;642.7011439680571;676.7935779587175;746.7685017644548;768.8846672999094;3844.9231015379537;3900.473436086149;4005.5193376794386;4036.2129384769687;4238.237117318912;49956.25065624018;50134.49865501298;50164.749176253885;50280;53882.73058634682;46029.76985115053;46442.76778616085;46582.534174658496;46710.76644616755;46915.76542117336;38907.61092389096;39590.802045989585;39809.40285895714;39942;40548;8782;9015.14356136166;9039.231665308522;9069.302598474558;9202.769930751518;26542.469150617264;26993.595096073183;26998.730012699623;27026.864865675547;27032.32419189536;35732.4640130393;35793.642063580075;35952.4607130888;36730.63269367379;37008.62991370052;7570.129435115033;7773.339266162439;7782.49413788102;8091.190880911861;8426.5786710663;11791.174617776673;12619.49522019109;12795.61613151607;12920.676983075498;13151.802722958972;11541.711457213301;11597.594084207012;11943.104267179822;12020.63938081859;12099.57651482194;11888.227265227733;11896.167268291136;11946.761064778482;12070.155089143676;12358.887700107034;11938.940305298765;12217;12518.049594539947;12555.811662824883;12655.240685558896;10483.161347092368;10577.682669519927;10615;10909.945450272699;10965.725856853642;9318;9361.953190234006;9496.572654230715;9674.661386851427;9871 10:05:33 INFO - 2015-10-24 10:05:33,089 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:05:33 INFO - 2015-10-24 10:05:33,089 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:05:33 INFO - 2015-10-24 10:05:33,089 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,761 10:05:33 INFO - 2015-10-24 10:05:33,089 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:05:33 INFO - 2015-10-24 10:05:33,089 DEBUG : BROWSER_OUTPUT: __startTimestamp1445706333011__endTimestamp 10:05:33 INFO - 2015-10-24 10:05:33,089 DEBUG : BROWSER_OUTPUT: 10:05:33 INFO - 2015-10-24 10:05:33,089 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:05:33 INFO - 2015-10-24 10:05:33,091 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:05:33 INFO - 2015-10-24 10:05:33,091 DEBUG : BROWSER_OUTPUT: 10:05:33 INFO - 2015-10-24 10:05:33,091 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5125.62 Median:5383.27 stddev:720.96 (13.4%) stddev-sans-first:701.46 10:05:33 INFO - 2015-10-24 10:05:33,091 DEBUG : BROWSER_OUTPUT: Values: 2886.9 2901.9 2932.8 2935.0 2939.6 5229.7 5312.1 5340.6 5348.4 5383.3 5356.1 5370.6 5372.8 5387.7 5445.8 4665.3 4732.6 4778.0 4780.1 4785.0 4675.9 4685.1 4744.1 4783.4 4793.9 4738.0 4761.6 4777.0 4788.4 4841.7 4672.3 4753.2 4772.4 4775.0 4823.5 4635.9 4685.7 4714.0 4741.3 4759.4 5147.2 5173.9 5205.8 5216.3 5224.0 5379.4 5454.8 5462.3 5466.4 5511.8 5508.3 5553.5 5599.7 5608.2 5628.2 5168.1 5173.5 5183.3 5183.6 5186.8 5491.5 5629.4 5677.2 5742.7 5749.0 5390.1 5429.7 5429.8 5441.0 5487.9 5572.3 5578.4 5583.8 5584.6 5595.6 5339.7 5429.2 5505.6 5511.8 5608.0 5382.2 5392.6 5402.3 5471.9 5494.7 3387.3 3388.5 3391.4 3426.7 3427.4 3098.7 3123.1 3152.7 3165.1 3172.3 5186.2 5234.3 5244.5 5257.2 5261.5 5569.6 5588.5 5594.2 5594.4 5597.7 5212.7 5250.4 5252.4 5263.3 5270.1 4378.3 4381.9 4401.8 4410.8 4427.5 5966.9 5999.3 6001.2 6009.1 6010.7 5462.6 5555.5 5577.7 5602.4 5672.6 5924.7 5952.3 5958.8 5981.8 6011.7 5545.4 5562.1 5562.5 5564.1 5580.9 5369.5 5471.1 5625.9 5653.2 5655.3 5425.4 5428.8 5434.8 5459.5 5504.5 5382.6 5385.1 5430.8 5432.4 5443.5 5271.6 5345.0 5361.6 5374.8 5379.1 5417.7 5424.2 5463.2 5495.6 5516.0 5417.6 5423.5 5429.7 5439.1 5491.9 10:05:33 INFO - 2015-10-24 10:05:33,091 DEBUG : BROWSER_OUTPUT: 10:05:33 INFO - 2015-10-24 10:05:33,091 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:49644.78 Median:31813.68 stddev:91323.40 (287.1%) stddev-sans-first:91505.34 10:05:33 INFO - 2015-10-24 10:05:33,091 DEBUG : BROWSER_OUTPUT: Values: 599.6 600.7 610.1 612.2 617.4 32340.0 39754.8 40090.4 40296.6 40355.8 41123.4 41488.8 41509.2 41548.8 41563.4 8471.2 8508.4 8728.7 8901.6 8906.3 10543.9 10871.3 10917.0 10923.1 10934.8 10689.2 10795.1 10805.6 10806.3 10810.3 8656.6 8796.1 10551.4 10680.0 10802.8 10520.9 10559.7 10594.0 10702.7 10717.8 37903.0 38208.6 38350.8 38374.8 38423.2 3397.9 3415.4 3435.3 3556.4 3633.5 29349.9 30045.8 30218.8 30411.2 30671.5 2918.9 3071.0 3094.3 3099.7 3275.5 299111.0 305196.0 305242.0 305908.0 308049.0 51605.0 51708.2 52323.0 52411.7 52536.0 50291.2 50715.7 50784.7 50787.5 50964.1 14735.9 15093.5 15118.9 15127.7 15144.9 11622.6 11638.7 11724.7 11756.1 11759.4 16599.9 16612.5 16634.0 16659.5 16727.2 7641.7 7751.3 7793.3 7797.5 7848.5 938.3 956.2 1021.6 1045.9 1047.6 27991.7 28193.4 28213.9 28235.6 28656.4 1004.5 1026.8 1028.6 1052.9 1058.6 13694.8 13788.2 13812.6 13823.7 13834.2 376020.0 379569.0 380448.0 380960.0 381217.0 47584.5 47591.0 47775.5 47989.8 48022.8 1290.4 1292.5 1301.8 1313.6 1314.6 26903.2 27042.3 27155.2 27493.5 27597.2 42239.4 42243.8 42678.0 42839.1 43038.0 349623.5 350030.0 353990.0 354169.0 359284.0 27567.3 27939.4 29376.9 29954.9 30847.7 36235.4 37974.4 40677.0 41679.8 41760.2 34398.5 35114.0 35421.3 35589.0 35857.5 27563.3 30394.2 32542.7 33924.5 35062.0 32831.8 33063.5 33448.3 33482.3 35020.5 31411.2 31475.8 31520.7 31803.7 31823.7 24356.0 24725.5 24920.0 25044.7 25227.2 10:05:33 INFO - 2015-10-24 10:05:33,091 DEBUG : BROWSER_OUTPUT: 10:05:33 INFO - 2015-10-24 10:05:33,091 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28017.92 Median:25006.58 stddev:91487.31 (365.9%) stddev-sans-first:91720.40 10:05:33 INFO - 2015-10-24 10:05:33,092 DEBUG : BROWSER_OUTPUT: Values: 370.2 372.1 375.0 376.4 379.6 15043.6 16288.7 16515.9 18371.2 18781.8 17089.6 17240.7 17337.0 17371.7 17492.7 4501.3 5549.7 5587.1 5666.7 5668.9 3678.3 6169.3 6216.2 6328.8 6336.5 6118.2 6129.9 6134.9 6160.9 6263.7 6156.7 6208.5 6209.7 6212.8 6221.5 5457.1 5520.5 5525.0 5531.0 5549.0 20621.3 20685.9 21274.7 21592.4 21601.9 2063.1 2111.8 2175.2 2426.8 2549.6 8739.7 9072.5 9723.1 9841.1 9886.9 1771.3 1776.2 1776.3 1785.5 1800.1 62439.8 63053.7 63687.0 63970.0 64381.4 6729.5 6750.6 6754.9 6778.2 6822.3 7988.7 7991.9 7993.2 7998.6 8020.4 5308.2 5343.1 5405.9 5412.8 5457.3 5509.7 5515.2 5544.3 5557.1 5560.9 2882.2 2965.1 3129.3 3134.4 3147.9 1111.0 1126.1 1128.7 1139.3 1179.7 418.2 426.6 435.5 451.0 455.2 9499.0 10656.8 10665.9 11038.9 11853.1 445.0 449.0 451.7 452.5 456.0 6147.7 6210.5 6362.6 6383.7 6386.8 475975.0 515029.0 577137.0 601994.0 607114.0 78755.0 79964.2 81305.6 82260.6 83503.6 492.6 499.9 500.2 501.9 501.9 10965.7 10977.5 11057.6 11151.7 11183.5 34390.3 34644.5 34790.7 37226.5 37319.0 48208.3 48953.8 49520.5 49573.0 49633.8 6387.7 6420.4 6428.7 6586.3 6621.6 9925.3 9947.2 10103.4 12121.7 12157.6 10225.9 10447.6 10474.6 10511.2 10517.8 10243.6 10290.8 10537.9 10569.9 10677.4 10534.8 10896.1 10946.8 11006.3 11011.6 6430.0 6462.4 6629.9 6632.6 6634.7 9829.1 9830.3 10165.2 10547.8 10992.9 10:05:33 INFO - 2015-10-24 10:05:33,094 DEBUG : BROWSER_OUTPUT: 10:05:33 INFO - 2015-10-24 10:05:33,094 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:6494.44 Median:4711.24 stddev:3686.58 (78.3%) stddev-sans-first:3676.83 10:05:33 INFO - 2015-10-24 10:05:33,094 DEBUG : BROWSER_OUTPUT: Values: 1373.2 1528.6 1567.0 1693.8 1694.7 8179.4 8447.3 9194.8 9473.0 9491.4 9071.4 9100.8 9247.5 9260.9 9271.4 2357.5 2415.2 2436.9 2440.6 2443.4 2186.9 2226.0 2436.0 2448.8 2492.7 2361.1 2383.5 2387.4 2391.4 2398.1 2139.8 2415.7 2471.0 2474.6 2474.7 2143.2 2298.3 2309.6 2346.8 2347.4 9213.0 9291.7 9300.5 9315.2 9348.0 5362.9 5407.8 5411.2 5414.2 5432.6 3542.9 3556.0 3563.7 3633.2 3643.7 1127.3 1153.1 1156.9 1163.5 1170.9 14044.9 14175.9 14199.7 14372.4 14468.6 4700.7 4762.7 4805.3 4845.4 4883.4 11466.7 11485.7 11488.2 11508.1 11517.8 5328.1 5333.5 5339.0 5341.0 5342.7 4721.8 4780.4 4789.1 4789.8 4795.7 3902.3 3914.6 3934.1 3956.1 4024.4 1217.4 1221.6 1233.5 1234.1 1235.1 1054.2 1054.3 1102.8 1193.1 1293.7 8529.9 8601.2 8709.7 8714.6 8715.3 1116.7 1122.1 1132.0 1138.3 1150.8 6029.0 6139.2 6265.8 6742.7 6887.7 11830.3 11914.3 11989.8 12269.6 12283.7 12103.2 12146.3 12156.0 12158.8 12165.2 8048.9 8104.6 8204.3 8242.2 8245.0 8541.2 8599.0 8609.4 8658.7 8659.7 10469.7 10554.2 10586.2 10602.4 10610.5 10670.1 10762.2 10863.5 10916.2 10941.2 8007.9 8049.3 8069.0 8412.3 8430.0 8942.6 8996.2 8998.8 9017.2 9018.6 8448.7 8547.7 8665.4 8668.6 8677.3 8306.7 8407.3 8428.2 8434.6 8568.5 8482.7 8506.3 8509.4 8532.0 8560.3 7457.4 7472.3 7525.3 7551.1 7570.4 6219.2 6326.9 7429.0 7484.7 7488.0 10:05:33 INFO - 2015-10-24 10:05:33,095 DEBUG : BROWSER_OUTPUT: 10:05:33 INFO - 2015-10-24 10:05:33,095 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5146.17 Median:5864.21 stddev:1538.86 (26.2%) stddev-sans-first:1500.47 10:05:33 INFO - 2015-10-24 10:05:33,095 DEBUG : BROWSER_OUTPUT: Values: 349.3 355.0 357.5 361.5 362.6 5845.1 5858.7 5862.6 5864.8 5865.6 5620.3 5737.2 5750.0 5752.3 5814.5 4447.1 4463.6 4467.3 4471.5 4471.8 4458.1 4468.0 4469.9 4475.0 4489.8 4294.1 4349.1 4376.7 4398.8 4430.8 4283.7 4304.9 4364.5 4422.2 4431.9 3857.2 3915.1 3921.8 3923.2 3938.6 5604.6 5613.0 5613.1 5618.4 5619.3 5012.0 5119.3 5122.1 5122.5 5142.1 6019.9 6025.1 6029.0 6032.3 6035.0 4218.6 4244.7 4270.7 4273.5 4278.6 6207.0 6225.0 6352.2 6356.3 6357.1 4355.9 4388.3 4388.3 4398.5 4404.2 4413.7 4430.4 4444.7 4466.2 4477.2 5008.4 5044.8 5053.8 5054.0 5057.3 5880.3 5949.3 5959.7 5962.9 5990.6 1583.5 1605.7 1623.0 1624.4 1626.0 1087.9 1099.5 1114.8 1121.8 1128.6 5886.6 5926.5 5932.7 5934.1 5937.1 6293.6 6298.5 6300.8 6303.7 6306.1 5773.1 5827.8 5863.6 5877.8 5903.4 3416.4 3431.3 3475.3 3475.9 3478.0 6687.0 6748.7 6763.3 6769.8 6776.1 6334.9 6382.7 6385.1 6441.4 6443.7 6776.1 6800.4 6803.9 6813.1 6820.6 6228.1 6240.9 6306.9 6323.0 6327.0 6075.6 6149.6 6151.8 6157.6 6163.8 6807.8 6819.8 6824.7 6826.3 6837.8 4341.0 4384.7 4390.9 4392.8 4401.3 6220.0 6254.0 6268.3 6301.4 6304.8 6160.3 6165.3 6170.3 6173.4 6179.1 6068.6 6073.5 6103.9 6107.1 6107.1 5994.3 6030.0 6033.8 6058.0 6061.2 6140.7 6144.2 6148.2 6150.1 6154.1 6038.3 6052.6 6066.8 6067.0 6067.7 10:05:33 INFO - 2015-10-24 10:05:33,095 DEBUG : BROWSER_OUTPUT: 10:05:33 INFO - 2015-10-24 10:05:33,095 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12268.06 Median:452.03 stddev:13798.38 (3052.5%) stddev-sans-first:13809.96 10:05:33 INFO - 2015-10-24 10:05:33,095 DEBUG : BROWSER_OUTPUT: Values: 746.4 748.8 750.7 757.4 777.8 13796.6 14018.4 14054.2 14085.6 14102.0 12579.6 12712.2 12778.6 12862.7 12874.2 621.7 627.3 722.2 730.8 731.6 722.4 729.4 733.5 733.6 735.7 750.1 753.5 754.2 754.7 755.4 646.6 652.4 742.4 751.1 759.2 545.9 546.7 551.5 552.0 554.3 12443.9 12538.0 12615.9 12626.5 12732.4 9764.8 9772.8 9793.0 9853.5 10372.8 9794.8 9849.5 9860.4 9881.3 10000.9 3205.1 3251.2 3283.8 3305.0 3335.7 42796.8 42917.8 42926.4 43293.8 43602.0 6927.8 7112.4 7193.2 7203.1 7245.6 10513.4 10620.0 10624.8 10631.2 10631.4 6580.6 6624.4 6631.5 6706.7 6747.3 3906.0 3943.2 3963.1 3965.7 3993.0 2558.1 2617.1 2620.3 2621.5 2622.8 442.4 448.4 451.4 452.0 452.1 587.4 663.0 711.8 723.4 748.5 8506.0 8684.1 8694.3 8774.9 8823.5 538.7 642.7 676.8 746.8 768.9 3844.9 3900.5 4005.5 4036.2 4238.2 49956.3 50134.5 50164.7 50280.0 53882.7 46029.8 46442.8 46582.5 46710.8 46915.8 38907.6 39590.8 39809.4 39942.0 40548.0 8782.0 9015.1 9039.2 9069.3 9202.8 26542.5 26993.6 26998.7 27026.9 27032.3 35732.5 35793.6 35952.5 36730.6 37008.6 7570.1 7773.3 7782.5 8091.2 8426.6 11791.2 12619.5 12795.6 12920.7 13151.8 11541.7 11597.6 11943.1 12020.6 12099.6 11888.2 11896.2 11946.8 12070.2 12358.9 11938.9 12217.0 12518.0 12555.8 12655.2 10483.2 10577.7 10615.0 10909.9 10965.7 9318.0 9362.0 9496.6 9674.7 9871.0 10:05:33 INFO - 2015-10-24 10:05:33,096 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:05:33 INFO - 2015-10-24 10:05:33,098 DEBUG : BROWSER_OUTPUT: 10:05:33 INFO - 2015-10-24 10:05:33,638 INFO : Browser exited with error code: 0 10:05:34 INFO - 2015-10-24 10:05:34,410 INFO : Completed test dromaeo_css (00:18:39) 10:05:34 INFO - 2015-10-24 10:05:34,410 INFO : Starting test kraken 10:05:34 INFO - 2015-10-24 10:05:34,410 DEBUG : operating with platform_type : w8_ 10:05:34 INFO - 2015-10-24 10:05:34,410 INFO : Initialising browser for kraken test... 10:05:34 INFO - 2015-10-24 10:05:34,430 DEBUG : command line: C:\slave\test-pgo\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmp3783lu\profile http://localhost:49281/getInfo.html 10:05:40 INFO - 2015-10-24 10:05:40,263 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:05:40 INFO - 2015-10-24 10:05:40,263 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:05:40 INFO - 2015-10-24 10:05:40,263 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674 10:05:40 INFO - 2015-10-24 10:05:40,263 DEBUG : BROWSER_OUTPUT: __metrics 10:05:40 INFO - 2015-10-24 10:05:40,368 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:05:41 INFO - 2015-10-24 10:05:41,467 INFO : Browser initialized. 10:05:41 INFO - 2015-10-24 10:05:41,467 INFO : Running cycle 1/1 for kraken test... 10:05:41 INFO - 2015-10-24 10:05:41,467 DEBUG : command line: C:\slave\test-pgo\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmp3783lu\profile -tp file:\C:\slave\test-pgo\build\tests\talos\talos\tests\kraken\kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:05:52 INFO - 2015-10-24 10:05:52,828 DEBUG : BROWSER_OUTPUT: RSS: Main: 190758912 10:05:52 INFO - 2015-10-24 10:05:52,828 DEBUG : BROWSER_OUTPUT: 10:05:55 INFO - 2015-10-24 10:05:55,427 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-beat-detection) 10:05:56 INFO - 2015-10-24 10:05:56,009 DEBUG : BROWSER_OUTPUT: RSS: Main: 228257792 10:05:56 INFO - 2015-10-24 10:05:56,010 DEBUG : BROWSER_OUTPUT: 10:05:58 INFO - 2015-10-24 10:05:58,513 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-dft) 10:05:59 INFO - 2015-10-24 10:05:59,078 DEBUG : BROWSER_OUTPUT: RSS: Main: 229040128 10:05:59 INFO - 2015-10-24 10:05:59,078 DEBUG : BROWSER_OUTPUT: 10:06:01 INFO - 2015-10-24 10:06:01,680 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-fft) 10:06:02 INFO - 2015-10-24 10:06:02,247 DEBUG : BROWSER_OUTPUT: RSS: Main: 213364736 10:06:02 INFO - 2015-10-24 10:06:02,247 DEBUG : BROWSER_OUTPUT: 10:06:04 INFO - 2015-10-24 10:06:04,144 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-oscillator) 10:06:04 INFO - 2015-10-24 10:06:04,713 DEBUG : BROWSER_OUTPUT: RSS: Main: 216657920 10:06:04 INFO - 2015-10-24 10:06:04,713 DEBUG : BROWSER_OUTPUT: 10:06:06 INFO - 2015-10-24 10:06:06,795 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49281/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:06:07 INFO - 2015-10-24 10:06:07,361 DEBUG : BROWSER_OUTPUT: RSS: Main: 214790144 10:06:07 INFO - 2015-10-24 10:06:07,361 DEBUG : BROWSER_OUTPUT: 10:06:10 INFO - 2015-10-24 10:06:10,332 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49281/tests/kraken/driver.html?testName=imaging-darkroom) 10:06:10 INFO - 2015-10-24 10:06:10,914 DEBUG : BROWSER_OUTPUT: RSS: Main: 208031744 10:06:10 INFO - 2015-10-24 10:06:10,914 DEBUG : BROWSER_OUTPUT: 10:06:14 INFO - 2015-10-24 10:06:14,194 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49281/tests/kraken/driver.html?testName=imaging-desaturate) 10:06:14 INFO - 2015-10-24 10:06:14,772 DEBUG : BROWSER_OUTPUT: RSS: Main: 205225984 10:06:14 INFO - 2015-10-24 10:06:14,772 DEBUG : BROWSER_OUTPUT: 10:06:17 INFO - 2015-10-24 10:06:17,582 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49281/tests/kraken/driver.html?testName=json-parse-financial) 10:06:18 INFO - 2015-10-24 10:06:18,151 DEBUG : BROWSER_OUTPUT: RSS: Main: 202887168 10:06:18 INFO - 2015-10-24 10:06:18,151 DEBUG : BROWSER_OUTPUT: 10:06:19 INFO - 2015-10-24 10:06:19,901 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49281/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:06:20 INFO - 2015-10-24 10:06:20,467 DEBUG : BROWSER_OUTPUT: RSS: Main: 232669184 10:06:20 INFO - 2015-10-24 10:06:20,467 DEBUG : BROWSER_OUTPUT: 10:06:22 INFO - 2015-10-24 10:06:22,243 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:06:22 INFO - 2015-10-24 10:06:22,811 DEBUG : BROWSER_OUTPUT: RSS: Main: 236994560 10:06:22 INFO - 2015-10-24 10:06:22,811 DEBUG : BROWSER_OUTPUT: 10:06:24 INFO - 2015-10-24 10:06:24,944 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:06:25 INFO - 2015-10-24 10:06:25,520 DEBUG : BROWSER_OUTPUT: RSS: Main: 222871552 10:06:25 INFO - 2015-10-24 10:06:25,520 DEBUG : BROWSER_OUTPUT: 10:06:27 INFO - 2015-10-24 10:06:27,891 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:06:28 INFO - 2015-10-24 10:06:28,477 DEBUG : BROWSER_OUTPUT: RSS: Main: 227381248 10:06:28 INFO - 2015-10-24 10:06:28,477 DEBUG : BROWSER_OUTPUT: 10:06:31 INFO - 2015-10-24 10:06:31,065 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:06:31 INFO - 2015-10-24 10:06:31,640 DEBUG : BROWSER_OUTPUT: RSS: Main: 226484224 10:06:31 INFO - 2015-10-24 10:06:31,640 DEBUG : BROWSER_OUTPUT: 10:06:33 INFO - 2015-10-24 10:06:33,299 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49281/tests/kraken/driver.html?testName=ai-astar) 10:06:33 INFO - 2015-10-24 10:06:33,552 DEBUG : BROWSER_OUTPUT: RSS: Main: 281870336 10:06:33 INFO - 2015-10-24 10:06:33,552 DEBUG : BROWSER_OUTPUT: 10:06:33 INFO - 2015-10-24 10:06:33,552 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:06:33 INFO - 2015-10-24 10:06:33,552 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:06:33 INFO - 2015-10-24 10:06:33,552 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:06:33 INFO - 2015-10-24 10:06:33,552 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:06:33 INFO - 2015-10-24 10:06:33,552 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;108;105;109;109;109;109;109;105;110 10:06:33 INFO - 2015-10-24 10:06:33,552 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;131;121;138;149;121;127;127;121;146;122 10:06:33 INFO - 2015-10-24 10:06:33,552 DEBUG : BROWSER_OUTPUT: |2;audio-dft;141;140;141;141;144;139;142;142;140;139 10:06:33 INFO - 2015-10-24 10:06:33,552 DEBUG : BROWSER_OUTPUT: |3;audio-fft;67;69;71;97;71;70;68;71;98;67 10:06:33 INFO - 2015-10-24 10:06:33,552 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;87;86;108;87;86;90;114;86;86;115 10:06:33 INFO - 2015-10-24 10:06:33,552 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;116;112;110;110;110;113 10:06:33 INFO - 2015-10-24 10:06:33,552 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;131;132;132;132;131;132;132;131;132;131 10:06:33 INFO - 2015-10-24 10:06:33,552 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;98;96;96;96;97;97;96;97;96 10:06:33 INFO - 2015-10-24 10:06:33,552 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;75;75;75;75;75;75;75;98;75;73 10:06:33 INFO - 2015-10-24 10:06:33,552 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;64;65;65;65;64;65;65;65;64 10:06:33 INFO - 2015-10-24 10:06:33,552 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;87;88;88;87;86;88;89;87;89;90 10:06:33 INFO - 2015-10-24 10:06:33,552 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;117;114;119;118;116;119;126;115;115;122 10:06:33 INFO - 2015-10-24 10:06:33,552 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;152;154;155;155;152;152;152;152;143 10:06:33 INFO - 2015-10-24 10:06:33,552 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;66;68;66;66;67;67;67;67;69 10:06:33 INFO - 2015-10-24 10:06:33,552 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:06:33 INFO - 2015-10-24 10:06:33,552 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:06:33 INFO - 2015-10-24 10:06:33,552 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,934 10:06:33 INFO - 2015-10-24 10:06:33,552 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:06:33 INFO - 2015-10-24 10:06:33,552 DEBUG : BROWSER_OUTPUT: __startTimestamp1445706393551__endTimestamp 10:06:33 INFO - 2015-10-24 10:06:33,552 DEBUG : BROWSER_OUTPUT: 10:06:33 INFO - 2015-10-24 10:06:33,555 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:06:33 INFO - 2015-10-24 10:06:33,555 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:06:33 INFO - 2015-10-24 10:06:33,555 DEBUG : BROWSER_OUTPUT: 10:06:33 INFO - 2015-10-24 10:06:33,555 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.20 Median:109.00 stddev:1.75 (1.6%) stddev-sans-first:1.83 10:06:33 INFO - 2015-10-24 10:06:33,555 DEBUG : BROWSER_OUTPUT: Values: 109.0 108.0 105.0 109.0 109.0 109.0 109.0 109.0 105.0 110.0 10:06:33 INFO - 2015-10-24 10:06:33,555 DEBUG : BROWSER_OUTPUT: 10:06:33 INFO - 2015-10-24 10:06:33,556 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:130.30 Median:129.00 stddev:10.57 (8.2%) stddev-sans-first:11.21 10:06:33 INFO - 2015-10-24 10:06:33,556 DEBUG : BROWSER_OUTPUT: Values: 131.0 121.0 138.0 149.0 121.0 127.0 127.0 121.0 146.0 122.0 10:06:33 INFO - 2015-10-24 10:06:33,556 DEBUG : BROWSER_OUTPUT: 10:06:33 INFO - 2015-10-24 10:06:33,556 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:140.90 Median:141.00 stddev:1.52 (1.1%) stddev-sans-first:1.62 10:06:33 INFO - 2015-10-24 10:06:33,556 DEBUG : BROWSER_OUTPUT: Values: 141.0 140.0 141.0 141.0 144.0 139.0 142.0 142.0 140.0 139.0 10:06:33 INFO - 2015-10-24 10:06:33,556 DEBUG : BROWSER_OUTPUT: 10:06:33 INFO - 2015-10-24 10:06:33,556 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:74.90 Median:71.00 stddev:12.01 (16.9%) stddev-sans-first:12.40 10:06:33 INFO - 2015-10-24 10:06:33,556 DEBUG : BROWSER_OUTPUT: Values: 67.0 69.0 71.0 97.0 71.0 70.0 68.0 71.0 98.0 67.0 10:06:33 INFO - 2015-10-24 10:06:33,556 DEBUG : BROWSER_OUTPUT: 10:06:33 INFO - 2015-10-24 10:06:33,556 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:94.50 Median:86.00 stddev:12.49 (14.5%) stddev-sans-first:12.95 10:06:33 INFO - 2015-10-24 10:06:33,556 DEBUG : BROWSER_OUTPUT: Values: 87.0 86.0 108.0 87.0 86.0 90.0 114.0 86.0 86.0 115.0 10:06:33 INFO - 2015-10-24 10:06:33,561 DEBUG : BROWSER_OUTPUT: 10:06:33 INFO - 2015-10-24 10:06:33,561 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:111.10 Median:110.00 stddev:2.02 (1.8%) stddev-sans-first:2.11 10:06:33 INFO - 2015-10-24 10:06:33,561 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 116.0 112.0 110.0 110.0 110.0 113.0 10:06:33 INFO - 2015-10-24 10:06:33,562 DEBUG : BROWSER_OUTPUT: 10:06:33 INFO - 2015-10-24 10:06:33,562 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:131.60 Median:132.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 10:06:33 INFO - 2015-10-24 10:06:33,562 DEBUG : BROWSER_OUTPUT: Values: 131.0 132.0 132.0 132.0 131.0 132.0 132.0 131.0 132.0 131.0 10:06:33 INFO - 2015-10-24 10:06:33,562 DEBUG : BROWSER_OUTPUT: 10:06:33 INFO - 2015-10-24 10:06:33,562 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 10:06:33 INFO - 2015-10-24 10:06:33,562 DEBUG : BROWSER_OUTPUT: Values: 96.0 98.0 96.0 96.0 96.0 97.0 97.0 96.0 97.0 96.0 10:06:33 INFO - 2015-10-24 10:06:33,562 DEBUG : BROWSER_OUTPUT: 10:06:33 INFO - 2015-10-24 10:06:33,562 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:77.10 Median:75.00 stddev:7.37 (9.8%) stddev-sans-first:7.78 10:06:33 INFO - 2015-10-24 10:06:33,563 DEBUG : BROWSER_OUTPUT: Values: 75.0 75.0 75.0 75.0 75.0 75.0 75.0 98.0 75.0 73.0 10:06:33 INFO - 2015-10-24 10:06:33,563 DEBUG : BROWSER_OUTPUT: 10:06:33 INFO - 2015-10-24 10:06:33,563 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 10:06:33 INFO - 2015-10-24 10:06:33,563 DEBUG : BROWSER_OUTPUT: Values: 65.0 64.0 65.0 65.0 65.0 64.0 65.0 65.0 65.0 64.0 10:06:33 INFO - 2015-10-24 10:06:33,563 DEBUG : BROWSER_OUTPUT: 10:06:33 INFO - 2015-10-24 10:06:33,565 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.90 Median:88.00 stddev:1.20 (1.4%) stddev-sans-first:1.22 10:06:33 INFO - 2015-10-24 10:06:33,565 DEBUG : BROWSER_OUTPUT: Values: 87.0 88.0 88.0 87.0 86.0 88.0 89.0 87.0 89.0 90.0 10:06:33 INFO - 2015-10-24 10:06:33,565 DEBUG : BROWSER_OUTPUT: 10:06:33 INFO - 2015-10-24 10:06:33,565 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.10 Median:118.50 stddev:3.67 (3.1%) stddev-sans-first:3.87 10:06:33 INFO - 2015-10-24 10:06:33,565 DEBUG : BROWSER_OUTPUT: Values: 117.0 114.0 119.0 118.0 116.0 119.0 126.0 115.0 115.0 122.0 10:06:33 INFO - 2015-10-24 10:06:33,565 DEBUG : BROWSER_OUTPUT: 10:06:33 INFO - 2015-10-24 10:06:33,565 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.00 Median:152.00 stddev:4.40 (2.9%) stddev-sans-first:3.59 10:06:33 INFO - 2015-10-24 10:06:33,566 DEBUG : BROWSER_OUTPUT: Values: 143.0 152.0 154.0 155.0 155.0 152.0 152.0 152.0 152.0 143.0 10:06:33 INFO - 2015-10-24 10:06:33,566 DEBUG : BROWSER_OUTPUT: 10:06:33 INFO - 2015-10-24 10:06:33,566 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:0.99 (1.5%) stddev-sans-first:1.00 10:06:33 INFO - 2015-10-24 10:06:33,568 DEBUG : BROWSER_OUTPUT: Values: 66.0 66.0 68.0 66.0 66.0 67.0 67.0 67.0 67.0 69.0 10:06:33 INFO - 2015-10-24 10:06:33,568 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:06:33 INFO - 2015-10-24 10:06:33,568 DEBUG : BROWSER_OUTPUT: 10:06:34 INFO - 2015-10-24 10:06:34,246 INFO : Browser exited with error code: 0 10:06:35 INFO - 2015-10-24 10:06:35,124 INFO : Completed test kraken (00:01:00) 10:06:35 INFO - 2015-10-24 10:06:35,124 INFO : Starting test v8_7 10:06:35 INFO - 2015-10-24 10:06:35,124 DEBUG : operating with platform_type : w8_ 10:06:35 INFO - 2015-10-24 10:06:35,124 INFO : Initialising browser for v8_7 test... 10:06:35 INFO - 2015-10-24 10:06:35,144 DEBUG : command line: C:\slave\test-pgo\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpousezd\profile http://localhost:49281/getInfo.html 10:06:40 INFO - 2015-10-24 10:06:40,303 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:06:40 INFO - 2015-10-24 10:06:40,303 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:06:40 INFO - 2015-10-24 10:06:40,303 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674 10:06:40 INFO - 2015-10-24 10:06:40,303 DEBUG : BROWSER_OUTPUT: __metrics 10:06:40 INFO - 2015-10-24 10:06:40,523 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:06:41 INFO - 2015-10-24 10:06:41,255 DEBUG : BROWSER_OUTPUT: console.error: 10:06:41 INFO - 2015-10-24 10:06:41,255 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] 10:06:41 INFO - 2015-10-24 10:06:41,255 DEBUG : BROWSER_OUTPUT: Stack: 10:06:41 INFO - 2015-10-24 10:06:41,255 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<._executeStatement@resource://gre/modules/Sqlite.jsm:758:19 10:06:41 INFO - 2015-10-24 10:06:41,255 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached/<@resource://gre/modules/Sqlite.jsm:493:9 10:06:41 INFO - 2015-10-24 10:06:41,255 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached@resource://gre/modules/Sqlite.jsm:491:1 10:06:41 INFO - 2015-10-24 10:06:41,255 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeBeforeShutdown/loggedDb<.executeCached.value<@resource://gre/modules/Sqlite.jsm:368:51 10:06:41 INFO - 2015-10-24 10:06:41,255 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 10:06:41 INFO - 2015-10-24 10:06:41,255 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 10:06:41 INFO - 2015-10-24 10:06:41,255 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 10:06:41 INFO - 2015-10-24 10:06:41,255 DEBUG : BROWSER_OUTPUT: transaction@resource://gre/modules/Bookmarks.jsm:783:15 10:06:41 INFO - 2015-10-24 10:06:41,256 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 10:06:41 INFO - 2015-10-24 10:06:41,256 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 10:06:41 INFO - 2015-10-24 10:06:41,256 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 10:06:41 INFO - 2015-10-24 10:06:41,256 DEBUG : BROWSER_OUTPUT: Task_spawn@resource://gre/modules/Task.jsm:164:12 10:06:41 INFO - 2015-10-24 10:06:41,256 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promisedromaeo_css: 6716.70 10:07:17 INFO - RETURN: kraken: 1453.70 10:07:17 INFO - RETURN: v8_7: 20009.75 10:07:17 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,31]]", "result": "20009.75"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,31]]", "result": "1453.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,31]]", "result": "6716.70"}}} 10:07:17 INFO - Return code: 0 10:07:17 INFO - # TBPL SUCCESS # 10:07:17 INFO - Running post-action listener: _resource_record_post_action 10:07:17 INFO - Running post-run listener: _resource_record_post_run 10:07:18 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 96358912; Write bytes: 390405632; Read time: 1194540; Write time: 4182210 10:07:18 INFO - install - Wall time: 2s; CPU: 12.0%; Read bytes: 0; Write bytes: 834560; Read time: 0; Write time: 5910 10:07:18 INFO - run-tests - Wall time: 1225s; CPU: 13.0%; Read bytes: 96358912; Write bytes: 350077440; Read time: 1194540; Write time: 4022320 10:07:18 INFO - Running post-run listener: _upload_blobber_files 10:07:18 INFO - Blob upload gear active. 10:07:18 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:07:18 INFO - Copying logs to upload dir... 10:07:18 INFO - mkdir: C:\slave\test-pgo\build\upload\logs program finished with exit code 0 elapsedTime=1399.889000 ========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 21 secs) (at 2015-10-24 10:07:20.362750) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-24 10:07:20.366436) ========= 'cmd' '/C' 'for' '%f' 'in' '(*)' 'do' '@type' '%f' in dir C:\slave\test-pgo\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-008\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-008 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-008 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-008\AppData\Local LOGONSERVER=\\T-W864-IX-008 MONDIR=C:\Monitor_config\ MOZBUILDDIR=C:\mozilla-build\ MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 NUMBER_OF_PROCESSORS=8 OS=Windows_NT OURDRIVE=C: PATH=C:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;C:\mozilla-build\hg PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_ARCHITEW6432=AMD64 PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=C:\Program Files (x86) PROGRAMFILES(X86)=C:\Program Files (x86) PROGRAMW6432=C:\Program Files PROMPT=$P$G PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\ PUBLIC=C:\Users\Public PWD=C:\slave\test-pgo\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-008 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-008 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-008 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False build_url:https://queue.taskcluster.net/v1/task/t_w4rQ1sTkOMFcIKwKqAAA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip program finished with exit code 0 elapsedTime=0.101000 build_url: 'https://queue.taskcluster.net/v1/task/t_w4rQ1sTkOMFcIKwKqAAA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip' ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-24 10:07:20.904232) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-24 10:07:20.904556) ========= 'rm' '-f' 'oauth.txt' in dir C:\slave\test-pgo\. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-008\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-008 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-008 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-008\AppData\Local LOGONSERVER=\\T-W864-IX-008 MONDIR=C:\Monitor_config\ MOZBUILDDIR=C:\mozilla-build\ MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 NUMBER_OF_PROCESSORS=8 OS=Windows_NT OURDRIVE=C: PATH=C:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;C:\windows\system32;C:\windows;C:\windows\System32\Wbem;C:\windows\System32\WindowsPowerShell\v1.0\;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\msys\bin;C:\mozilla-build\vim\vim72;C:\mozilla-build\wget;C:\mozilla-build\info-zip;C:\CoreUtils\bin;C:\mozilla-build\buildbotve\scripts;C:\mozilla-build\hg PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_ARCHITEW6432=AMD64 PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=C:\Program Files (x86) PROGRAMFILES(X86)=C:\Program Files (x86) PROGRAMW6432=C:\Program Files PROMPT=$P$G PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\ PUBLIC=C:\Users\Public PWD=C:\slave\test-pgo 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-008 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-008 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-008 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=0.101000 ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-24 10:07:21.636480) ========= ========= Started reboot slave lost (results: 0, elapsed: 11 secs) (at 2015-10-24 10:07:21.636781) ========= ========= Finished reboot slave lost (results: 0, elapsed: 11 secs) (at 2015-10-24 10:07:32.748695) =========