builder: b2g-inbound_win8_64_test-dromaeojs-pgo slave: t-w864-ix-005 starttime: 1445665087.05 results: success (0) buildid: 20151023173022 builduid: d8fa9d0210a64891878988ac64d7b170 revision: cc7bd8e4c0fb1a3a13d8716266ff7241f4c803af ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-23 22:38:07.050217) ========= master: http://buildbot-master109.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-23 22:38:07.052899) ========= ========= Started set props: basedir (results: 0, elapsed: 16 secs) (at 2015-10-23 22:38:07.053383) ========= '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-005\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-005 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-005 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-005\AppData\Local LOGONSERVER=\\T-W864-IX-005 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-005 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-005 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-005 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False C:\slave\test-pgo program finished with exit code 0 elapsedTime=0.695000 basedir: 'C:\\slave\\test-pgo' ========= Finished set props: basedir (results: 0, elapsed: 16 secs) (at 2015-10-23 22:38:23.264675) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 30 secs) (at 2015-10-23 22:38:23.264953) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 30 secs) (at 2015-10-23 22:38:53.453635) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 15 secs) (at 2015-10-23 22:38:53.454077) ========= '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-005\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-005 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-005 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-005\AppData\Local LOGONSERVER=\\T-W864-IX-005 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-005 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-005 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-005 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=0.201000 ========= Finished 'rm -rf ...' (results: 0, elapsed: 15 secs) (at 2015-10-23 22:39:09.445798) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-23 22:39:09.446072) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-23 22:39:09.446428) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 16 secs) (at 2015-10-23 22:39:09.446709) ========= '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-005\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-005 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-005 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-005\AppData\Local LOGONSERVER=\\T-W864-IX-005 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-005 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-005 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-005 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False --22:39:09-- 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% 2.45 GB/s 22:39:09 (2.45 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.649000 ========= Finished 'bash -c ...' (results: 0, elapsed: 16 secs) (at 2015-10-23 22:39:25.878641) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 10 secs) (at 2015-10-23 22:39:25.878928) ========= '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-005\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-005 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-005 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-005\AppData\Local LOGONSERVER=\\T-W864-IX-005 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-005 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-005 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-005 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=2.308000 ========= Finished 'rm -rf ...' (results: 0, elapsed: 10 secs) (at 2015-10-23 22:39:36.370724) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-10-23 22:39:36.371068) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev cc7bd8e4c0fb1a3a13d8716266ff7241f4c803af --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/b2g-inbound --rev cc7bd8e4c0fb1a3a13d8716266ff7241f4c803af --destination scripts --debug'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-005\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-005 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-005 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-005\AppData\Local LOGONSERVER=\\T-W864-IX-005 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-005 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-005 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-005 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 2015-10-23 22:39:36,648 truncating revision to first 12 chars 2015-10-23 22:39:36,648 Setting DEBUG logging. 2015-10-23 22:39:36,648 attempt 1/10 2015-10-23 22:39:36,650 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/cc7bd8e4c0fb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-10-23 22:39:37,153 unpacking tar archive at: b2g-inbound-cc7bd8e4c0fb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.289000 ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-10-23 22:39:38.587684) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-23 22:39:38.587956) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-23 22:39:38.820496) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-23 22:39:38.820749) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-23 22:39:38.821110) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 24 mins, 35 secs) (at 2015-10-23 22:39:38.821401) ========= 'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'dromaeojs' '--add-option' '--webServer,localhost' '--branch-name' 'B2G-Inbound' '--system-bits' '64' '--cfg' 'talos/windows_config.py' '--download-symbols' 'ondemand' '--use-talos-json' '--blob-upload-branch' 'B2G-Inbound' 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', 'B2G-Inbound', '--system-bits', '64', '--cfg', 'talos/windows_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-005\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-005 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-005 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-005\AppData\Local LOGONSERVER=\\T-W864-IX-005 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-005 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-005 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-005 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 22:39:38 INFO - MultiFileLogger online at 20151023 22:39:38 in C:\slave\test-pgo 22:39:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 22:39:38 INFO - Dumping config to C:\slave\test-pgo\logs\localconfig.json. 22:39:38 INFO - {'append_to_log': False, 22:39:38 INFO - 'base_work_dir': 'C:\\slave\\test-pgo', 22:39:38 INFO - 'blob_upload_branch': 'B2G-Inbound', 22:39:38 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test-pgo\\oauth.txt', 22:39:38 INFO - 'branch': 'B2G-Inbound', 22:39:38 INFO - 'buildbot_json_path': 'buildprops.json', 22:39:38 INFO - 'config_files': ('talos/windows_config.py',), 22:39:38 INFO - 'default_actions': ('clobber', 22:39:38 INFO - 'read-buildbot-config', 22:39:38 INFO - 'download-and-extract', 22:39:38 INFO - 'populate-webroot', 22:39:38 INFO - 'create-virtualenv', 22:39:38 INFO - 'install', 22:39:38 INFO - 'run-tests'), 22:39:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:39:38 INFO - 'download_minidump_stackwalk': True, 22:39:38 INFO - 'download_symbols': 'ondemand', 22:39:38 INFO - 'exes': {'easy_install': ('C:\\slave\\test-pgo\\build/venv/scripts/python', 22:39:38 INFO - 'C:\\slave\\test-pgo\\build/venv/scripts/easy_install-2.7-script.py'), 22:39:38 INFO - 'hg': 'c:/mozilla-build/hg/hg', 22:39:38 INFO - 'mozinstall': ('C:\\slave\\test-pgo\\build/venv/scripts/python', 22:39:38 INFO - 'C:\\slave\\test-pgo\\build/venv/scripts/mozinstall-script.py'), 22:39:38 INFO - 'python': 'c:/mozilla-build/python27/python.exe', 22:39:38 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe', 22:39:38 INFO - 'C:/mozilla-build/tooltool.py'), 22:39:38 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe', 22:39:38 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 22:39:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:39:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:39:38 INFO - 'installer_path': 'installer.exe', 22:39:38 INFO - 'log_level': 'info', 22:39:38 INFO - 'log_name': 'talos', 22:39:38 INFO - 'log_to_console': True, 22:39:38 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe', 22:39:38 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe', 22:39:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest', 22:39:38 INFO - 'opt_config_files': (), 22:39:38 INFO - 'pip_index': False, 22:39:38 INFO - 'sps_profile': False, 22:39:38 INFO - 'sps_profile_interval': 0, 22:39:38 INFO - 'suite': 'dromaeojs', 22:39:38 INFO - 'system_bits': '64', 22:39:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:39:38 INFO - 'title': 'T-W864-IX-005', 22:39:38 INFO - 'use_talos_json': True, 22:39:38 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'), 22:39:38 INFO - 'virtualenv_path': 'C:\\slave\\test-pgo\\build/venv', 22:39:38 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll', 22:39:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:39:38 INFO - 'work_dir': 'build'} 22:39:38 INFO - ##### 22:39:38 INFO - ##### Running clobber step. 22:39:38 INFO - ##### 22:39:38 INFO - Running pre-action listener: _resource_record_pre_action 22:39:38 INFO - Running main action method: clobber 22:39:38 INFO - rmtree: C:\slave\test-pgo\build 22:39:38 INFO - Using _rmtree_windows ... 22:39:38 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test-pgo\\build',), kwargs: {}, attempt #1 22:41:40 INFO - Running post-action listener: _resource_record_post_action 22:41:40 INFO - ##### 22:41:40 INFO - ##### Running read-buildbot-config step. 22:41:40 INFO - ##### 22:41:40 INFO - Running pre-action listener: _resource_record_pre_action 22:41:40 INFO - Running main action method: read_buildbot_config 22:41:40 INFO - Using buildbot properties: 22:41:40 INFO - { 22:41:40 INFO - "properties": { 22:41:40 INFO - "buildnumber": 294, 22:41:40 INFO - "product": "firefox", 22:41:40 INFO - "script_repo_revision": "production", 22:41:40 INFO - "builddir": "b2g-inbound_win8_64_test-dromaeojs", 22:41:40 INFO - "repository": "", 22:41:40 INFO - "buildername": "Windows 8 64-bit b2g-inbound pgo talos dromaeojs", 22:41:40 INFO - "buildid": "20151023173022", 22:41:40 INFO - "slavename": "t-w864-ix-005", 22:41:40 INFO - "pgo_build": "True", 22:41:40 INFO - "basedir": "C:\\slave\\test-pgo", 22:41:40 INFO - "project": "", 22:41:40 INFO - "platform": "win8_64", 22:41:40 INFO - "master": "http://buildbot-master109.bb.releng.scl3.mozilla.com:8201/", 22:41:40 INFO - "slavebuilddir": "test", 22:41:40 INFO - "scheduler": "tests-b2g-inbound-win64-pgo-talos", 22:41:40 INFO - "branch": "b2g-inbound", 22:41:40 INFO - "repo_path": "integration/b2g-inbound", 22:41:40 INFO - "stage_platform": "win64-pgo", 22:41:40 INFO - "builduid": "d8fa9d0210a64891878988ac64d7b170", 22:41:40 INFO - "revision": "cc7bd8e4c0fb1a3a13d8716266ff7241f4c803af" 22:41:40 INFO - }, 22:41:40 INFO - "sourcestamp": { 22:41:40 INFO - "repository": "", 22:41:40 INFO - "hasPatch": false, 22:41:40 INFO - "project": "", 22:41:40 INFO - "branch": "b2g-inbound-win64-pgo-talos", 22:41:40 INFO - "changes": [ 22:41:40 INFO - { 22:41:40 INFO - "category": null, 22:41:40 INFO - "files": [ 22:41:40 INFO - { 22:41:40 INFO - "url": null, 22:41:40 INFO - "name": "https://queue.taskcluster.net/v1/task/YCOqGKfKRFWQDA1J84xKgA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip" 22:41:40 INFO - } 22:41:40 INFO - ], 22:41:40 INFO - "repository": "", 22:41:40 INFO - "rev": "cc7bd8e4c0fb1a3a13d8716266ff7241f4c803af", 22:41:40 INFO - "who": "sendchange", 22:41:40 INFO - "when": 1445664345, 22:41:40 INFO - "number": 6569575, 22:41:40 INFO - "comments": "", 22:41:40 INFO - "project": "", 22:41:40 INFO - "at": "Fri 23 Oct 2015 22:25:45", 22:41:40 INFO - "branch": "b2g-inbound-win64-pgo-talos", 22:41:40 INFO - "revlink": "", 22:41:40 INFO - "properties": [ 22:41:40 INFO - [ 22:41:40 INFO - "buildid", 22:41:40 INFO - "20151023173022", 22:41:40 INFO - "Change" 22:41:40 INFO - ], 22:41:40 INFO - [ 22:41:40 INFO - "builduid", 22:41:40 INFO - "d8fa9d0210a64891878988ac64d7b170", 22:41:40 INFO - "Change" 22:41:40 INFO - ], 22:41:40 INFO - [ 22:41:40 INFO - "pgo_build", 22:41:40 INFO - "True", 22:41:40 INFO - "Change" 22:41:40 INFO - ] 22:41:40 INFO - ], 22:41:40 INFO - "revision": "cc7bd8e4c0fb1a3a13d8716266ff7241f4c803af" 22:41:40 INFO - } 22:41:40 INFO - ], 22:41:40 INFO - "revision": "cc7bd8e4c0fb1a3a13d8716266ff7241f4c803af" 22:41:40 INFO - } 22:41:40 INFO - } 22:41:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/YCOqGKfKRFWQDA1J84xKgA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip. 22:41:40 INFO - Running post-action listener: _resource_record_post_action 22:41:40 INFO - ##### 22:41:40 INFO - ##### Running download-and-extract step. 22:41:40 INFO - ##### 22:41:40 INFO - Running pre-action listener: _resource_record_pre_action 22:41:40 INFO - Running main action method: download_and_extract 22:41:40 INFO - mkdir: C:\slave\test-pgo\build\tests 22:41:40 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')]} 22:41:40 INFO - https://queue.taskcluster.net/v1/task/YCOqGKfKRFWQDA1J84xKgA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:41:40 INFO - trying https://queue.taskcluster.net/v1/task/YCOqGKfKRFWQDA1J84xKgA/artifacts/public/build/test_packages.json 22:41:40 INFO - Downloading https://queue.taskcluster.net/v1/task/YCOqGKfKRFWQDA1J84xKgA/artifacts/public/build/test_packages.json to C:\slave\test-pgo\build\test_packages.json 22:41:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YCOqGKfKRFWQDA1J84xKgA/artifacts/public/build/test_packages.json', 'file_name': 'C:\\slave\\test-pgo\\build\\test_packages.json'}, attempt #1 22:41:41 INFO - Downloaded 1221 bytes. 22:41:41 INFO - Reading from file C:\slave\test-pgo\build\test_packages.json 22:41:41 INFO - Using the following test package requirements: 22:41:41 INFO - {u'common': [u'firefox-44.0a1.en-US.win64.common.tests.zip'], 22:41:41 INFO - u'cppunittest': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 22:41:41 INFO - u'firefox-44.0a1.en-US.win64.cppunittest.tests.zip'], 22:41:41 INFO - u'jittest': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 22:41:41 INFO - u'jsshell-win64.zip'], 22:41:41 INFO - u'mochitest': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 22:41:41 INFO - u'firefox-44.0a1.en-US.win64.mochitest.tests.zip'], 22:41:41 INFO - u'mozbase': [u'firefox-44.0a1.en-US.win64.common.tests.zip'], 22:41:41 INFO - u'reftest': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 22:41:41 INFO - u'firefox-44.0a1.en-US.win64.reftest.tests.zip'], 22:41:41 INFO - u'talos': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 22:41:41 INFO - u'firefox-44.0a1.en-US.win64.talos.tests.zip'], 22:41:41 INFO - u'web-platform': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 22:41:41 INFO - u'firefox-44.0a1.en-US.win64.web-platform.tests.zip'], 22:41:41 INFO - u'webapprt': [u'firefox-44.0a1.en-US.win64.common.tests.zip'], 22:41:41 INFO - u'xpcshell': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 22:41:41 INFO - u'firefox-44.0a1.en-US.win64.xpcshell.tests.zip']} 22:41:41 INFO - Downloading packages: [u'firefox-44.0a1.en-US.win64.common.tests.zip'] for test suite category: common 22:41:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:41 INFO - https://queue.taskcluster.net/v1/task/YCOqGKfKRFWQDA1J84xKgA/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip matches https://queue.taskcluster.net 22:41:41 INFO - trying https://queue.taskcluster.net/v1/task/YCOqGKfKRFWQDA1J84xKgA/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip 22:41:41 INFO - Downloading https://queue.taskcluster.net/v1/task/YCOqGKfKRFWQDA1J84xKgA/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 22:41:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YCOqGKfKRFWQDA1J84xKgA/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 22:41:42 INFO - Downloaded 18100928 bytes. 22:41:42 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 22:41:42 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-44.0a1.en-US.win64.common.tests.zip 22:41:42 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 22:42:22 INFO - Return code: 0 22:42:22 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 22:42: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')]} 22:42:22 INFO - https://queue.taskcluster.net/v1/task/YCOqGKfKRFWQDA1J84xKgA/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip matches https://queue.taskcluster.net 22:42:22 INFO - trying https://queue.taskcluster.net/v1/task/YCOqGKfKRFWQDA1J84xKgA/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip 22:42:22 INFO - Downloading https://queue.taskcluster.net/v1/task/YCOqGKfKRFWQDA1J84xKgA/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 22:42:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YCOqGKfKRFWQDA1J84xKgA/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 22:42:23 INFO - Downloaded 18100928 bytes. 22:42:23 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 22:42:23 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-44.0a1.en-US.win64.common.tests.zip 22:42:23 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 22:42:47 INFO - Return code: 0 22:42:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:42:47 INFO - https://queue.taskcluster.net/v1/task/YCOqGKfKRFWQDA1J84xKgA/artifacts/public/build/firefox-44.0a1.en-US.win64.talos.tests.zip matches https://queue.taskcluster.net 22:42:47 INFO - trying https://queue.taskcluster.net/v1/task/YCOqGKfKRFWQDA1J84xKgA/artifacts/public/build/firefox-44.0a1.en-US.win64.talos.tests.zip 22:42:47 INFO - Downloading https://queue.taskcluster.net/v1/task/YCOqGKfKRFWQDA1J84xKgA/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 22:42:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YCOqGKfKRFWQDA1J84xKgA/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 22:42:48 INFO - Downloaded 11131307 bytes. 22:42:48 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 22:42:48 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-44.0a1.en-US.win64.talos.tests.zip 22:42:48 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 22:42:52 INFO - Return code: 0 22:42: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')]} 22:42:52 INFO - https://queue.taskcluster.net/v1/task/YCOqGKfKRFWQDA1J84xKgA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip matches https://queue.taskcluster.net 22:42:52 INFO - trying https://queue.taskcluster.net/v1/task/YCOqGKfKRFWQDA1J84xKgA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip 22:42:52 INFO - Downloading https://queue.taskcluster.net/v1/task/YCOqGKfKRFWQDA1J84xKgA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip to C:\slave\test-pgo\build\firefox-44.0a1.en-US.win64.zip 22:42:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YCOqGKfKRFWQDA1J84xKgA/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 22:42:54 INFO - Downloaded 55517070 bytes. 22:42:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YCOqGKfKRFWQDA1J84xKgA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip 22:42:54 INFO - mkdir: C:\slave\test-pgo\properties 22:42:54 INFO - Writing buildbot properties ['build_url'] to C:\slave\test-pgo\properties\build_url 22:42:54 INFO - Writing to file C:\slave\test-pgo\properties\build_url 22:42:54 INFO - Contents: 22:42:54 INFO - build_url:https://queue.taskcluster.net/v1/task/YCOqGKfKRFWQDA1J84xKgA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip 22:42:54 INFO - Running post-action listener: _resource_record_post_action 22:42:54 INFO - Running post-action listener: set_extra_try_arguments 22:42:54 INFO - ##### 22:42:54 INFO - ##### Running populate-webroot step. 22:42:54 INFO - ##### 22:42:54 INFO - Running pre-action listener: _resource_record_pre_action 22:42:54 INFO - Running main action method: populate_webroot 22:42:54 INFO - Guessing talos json url... 22:42:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:42:54 INFO - https://queue.taskcluster.net/v1/task/YCOqGKfKRFWQDA1J84xKgA/artifacts/public/build/firefox-44.0a1.en-US.win64.txt matches https://queue.taskcluster.net 22:42:54 INFO - trying https://queue.taskcluster.net/v1/task/YCOqGKfKRFWQDA1J84xKgA/artifacts/public/build/firefox-44.0a1.en-US.win64.txt 22:42:54 INFO - Downloading https://queue.taskcluster.net/v1/task/YCOqGKfKRFWQDA1J84xKgA/artifacts/public/build/firefox-44.0a1.en-US.win64.txt to C:\slave\test-pgo\build\firefox-44.0a1.en-US.win64.txt 22:42:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YCOqGKfKRFWQDA1J84xKgA/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 22:42:55 INFO - Downloaded 107 bytes. 22:42:55 INFO - Reading from file C:\slave\test-pgo\build\firefox-44.0a1.en-US.win64.txt 22:42:55 INFO - Contents: 22:42:55 INFO - 20151023173022 22:42:55 INFO - https://hg.mozilla.org/integration/b2g-inbound/rev/cc7bd8e4c0fb1a3a13d8716266ff7241f4c803af 22:42:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:42:55 INFO - trying https://hg.mozilla.org/integration/b2g-inbound/raw-file/cc7bd8e4c0/testing/talos/talos.json 22:42:55 INFO - Downloading https://hg.mozilla.org/integration/b2g-inbound/raw-file/cc7bd8e4c0/testing/talos/talos.json to C:\slave\test-pgo\build\talos.json 22:42:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/b2g-inbound/raw-file/cc7bd8e4c0/testing/talos/talos.json', 'file_name': 'C:\\slave\\test-pgo\\build\\talos.json'}, attempt #1 22:42:55 INFO - Downloaded 4264 bytes. 22:42:55 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']}, 22:42:55 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']}, 22:42:55 INFO - u'remote-trobocheck2': {u'talos_options': [u'--fennecIDs', 22:42:55 INFO - u'../fennec_ids.txt'], 22:42:55 INFO - u'tests': [u'tcheck2']}, 22:42:55 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome', 22:42:55 INFO - u'--tppagecycles', 22:42:55 INFO - u'7'], 22:42:55 INFO - u'tests': [u'tsvgm']}}, 22:42:55 INFO - u'suites': {u'chromez': {u'tests': [u'tresize', u'tcanvasmark']}, 22:42:55 INFO - u'chromez-e10s': {u'talos_options': [u'--e10s'], 22:42:55 INFO - u'tests': [u'tresize', u'tcanvasmark']}, 22:42:55 INFO - u'dromaeojs': {u'tests': [u'dromaeo_css', u'kraken', u'v8_7']}, 22:42:55 INFO - u'dromaeojs-e10s': {u'talos_options': [u'--e10s'], 22:42:55 INFO - u'tests': [u'dromaeo_css', 22:42:55 INFO - u'kraken', 22:42:55 INFO - u'v8_7']}, 22:42:55 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:42:55 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 22:42:55 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:42:55 INFO - u'talos_options': [u'--e10s'], 22:42:55 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 22:42:55 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:42:55 INFO - u'tests': [u'damp', u'tps']}, 22:42:55 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:42:55 INFO - u'talos_options': [u'--e10s'], 22:42:55 INFO - u'tests': [u'damp', u'tps']}, 22:42:55 INFO - u'g3': {u'tests': [u'dromaeo_dom']}, 22:42:55 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']}, 22:42:55 INFO - u'other': {u'tests': [u'a11yr', 22:42:55 INFO - u'ts_paint', 22:42:55 INFO - u'tpaint', 22:42:55 INFO - u'sessionrestore', 22:42:55 INFO - u'sessionrestore_no_auto_restore']}, 22:42:55 INFO - u'other-e10s': {u'talos_options': [u'--e10s'], 22:42:55 INFO - u'tests': [u'a11yr', 22:42:55 INFO - u'ts_paint', 22:42:55 INFO - u'tpaint', 22:42:55 INFO - u'sessionrestore', 22:42:55 INFO - u'sessionrestore_no_auto_restore']}, 22:42:55 INFO - u'other-e10s_l64': {u'talos_options': [u'--e10s'], 22:42:55 INFO - u'tests': [u'a11yr', 22:42:55 INFO - u'ts_paint', 22:42:55 INFO - u'tpaint', 22:42:55 INFO - u'sessionrestore', 22:42:55 INFO - u'sessionrestore_no_auto_restore']}, 22:42:55 INFO - u'other-e10s_nol64': {u'talos_options': [u'--e10s'], 22:42:55 INFO - u'tests': [u'a11yr', 22:42:55 INFO - u'ts_paint', 22:42:55 INFO - u'tpaint', 22:42:55 INFO - u'sessionrestore', 22:42:55 INFO - u'sessionrestore_no_auto_restore']}, 22:42:55 INFO - u'other_l64': {u'tests': [u'a11yr', 22:42:55 INFO - u'ts_paint', 22:42:55 INFO - u'tpaint', 22:42:55 INFO - u'sessionrestore', 22:42:55 INFO - u'sessionrestore_no_auto_restore']}, 22:42:55 INFO - u'other_nol64': {u'tests': [u'a11yr', 22:42:55 INFO - u'ts_paint', 22:42:55 INFO - u'tpaint', 22:42:55 INFO - u'sessionrestore', 22:42:55 INFO - u'sessionrestore_no_auto_restore']}, 22:42:55 INFO - u'svgr': {u'tests': [u'tsvgx', 22:42:55 INFO - u'tsvgr_opacity', 22:42:55 INFO - u'tart', 22:42:55 INFO - u'tscrollx', 22:42:55 INFO - u'cart']}, 22:42:55 INFO - u'svgr-e10s': {u'talos_options': [u'--e10s'], 22:42:55 INFO - u'tests': [u'tsvgx', 22:42:55 INFO - u'tsvgr_opacity', 22:42:55 INFO - u'tart', 22:42:55 INFO - u'tscrollx', 22:42:55 INFO - u'cart']}, 22:42:55 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:42:55 INFO - u'tests': [u'tp5o']}, 22:42:55 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:42:55 INFO - u'talos_options': [u'--e10s'], 22:42:55 INFO - u'tests': [u'tp5o']}, 22:42:55 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:42:55 INFO - u'talos_options': [u'--xperf_path', 22:42:55 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:42:55 INFO - u'tests': [u'tp5n']}, 22:42:55 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:42:55 INFO - u'talos_options': [u'--e10s', 22:42:55 INFO - u'--xperf_path', 22:42:55 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 22:42:55 INFO - u'C:/slave/talos-data/talos/xperf.config'], 22:42:55 INFO - u'tests': [u'tp5n']}}, 22:42:55 INFO - u'talos.zip': {u'path': u'', 22:42:55 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:42:55 INFO - Running post-action listener: _resource_record_post_action 22:42:55 INFO - ##### 22:42:55 INFO - ##### Running create-virtualenv step. 22:42:55 INFO - ##### 22:42:55 INFO - Running pre-action listener: _resource_record_pre_action 22:42:55 INFO - Running main action method: create_virtualenv 22:42:55 INFO - Creating virtualenv C:\slave\test-pgo\build/venv 22:42:55 INFO - mkdir: C:\slave\test-pgo\build\venv\Scripts 22:42:55 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test-pgo\build\venv\Scripts\python27.dll 22:42:55 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'! 22:42:55 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 22:42:55 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 22:42:58 INFO - New python executable in C:\slave\test-pgo\build/venv\Scripts\python.exe 22:43:01 INFO - Installing distribute......................................................................................................................................................................................done. 22:43:03 INFO - Return code: 0 22:43:03 INFO - Installing pip>=1.5 into virtualenv C:\slave\test-pgo\build/venv 22:43: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')]} 22:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:43: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')]} 22:43:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:43:03 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 0x022E6B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022A9EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0239CC98>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01CD8B48>, '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 0x01CFA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02786660>, '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-005', 'USERDOMAIN': 'T-W864-IX-005', '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-005', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-005\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-005', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-005', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-005', '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-005\\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 22:43:03 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 22:43:03 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 22:43:03 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 22:43:03 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-005\\AppData\\Roaming', 22:43:03 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 22:43:03 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 22:43:03 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 22:43:03 INFO - 'COMPUTERNAME': 'T-W864-IX-005', 22:43:03 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 22:43:03 INFO - 'DCLOCATION': 'SCL3', 22:43:03 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 22:43:03 INFO - 'FP_NO_HOST_CHECK': 'NO', 22:43:03 INFO - 'HOMEDRIVE': 'C:', 22:43:03 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-005', 22:43:03 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 22:43:03 INFO - 'KTS_VERSION': '1.19c', 22:43:03 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-005\\AppData\\Local', 22:43:03 INFO - 'LOGONSERVER': '\\\\T-W864-IX-005', 22:43:03 INFO - 'MONDIR': 'C:\\Monitor_config\\', 22:43:03 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 22:43:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:43:03 INFO - 'MOZ_NO_REMOTE': '1', 22:43:03 INFO - 'NO_EM_RESTART': '1', 22:43:03 INFO - 'NUMBER_OF_PROCESSORS': '8', 22:43:03 INFO - 'OS': 'Windows_NT', 22:43:03 INFO - 'OURDRIVE': 'C:', 22:43:03 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 22:43:03 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 22:43:03 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 22:43:03 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 22:43:03 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 22:43:03 INFO - 'PROCESSOR_LEVEL': '6', 22:43:03 INFO - 'PROCESSOR_REVISION': '1e05', 22:43:03 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 22:43:03 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 22:43:03 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 22:43:03 INFO - 'PROGRAMW6432': 'C:\\Program Files', 22:43:03 INFO - 'PROMPT': '$P$G', 22:43:03 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 22:43:03 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 22:43:03 INFO - 'PUBLIC': 'C:\\Users\\Public', 22:43:03 INFO - 'PWD': 'C:\\slave\\test-pgo', 22:43:03 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 22:43:03 INFO - 'SLAVEDIR': 'C:\\slave\\', 22:43:03 INFO - 'SYSTEMDRIVE': 'C:', 22:43:03 INFO - 'SYSTEMROOT': 'C:\\windows', 22:43:03 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 22:43:03 INFO - 'TEST1': 'testie', 22:43:03 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 22:43:03 INFO - 'USERDOMAIN': 'T-W864-IX-005', 22:43:03 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-005', 22:43:03 INFO - 'USERNAME': 'cltbld', 22:43:03 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-005', 22:43:03 INFO - 'WINDIR': 'C:\\windows', 22:43:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 22:43:04 INFO - Ignoring indexes: http://pypi.python.org/simple/ 22:43:04 INFO - Downloading/unpacking pip>=1.5 22:43:04 INFO - Creating supposed download cache at C:\slave\test-pgo\build/venv\cache 22:43:08 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 22:43:08 INFO - Running setup.py egg_info for package pip 22:43:08 INFO - warning: no files found matching 'pip\cacert.pem' 22:43:08 INFO - warning: no files found matching '*.html' under directory 'docs' 22:43:08 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 22:43:08 INFO - no previously-included directories found matching 'docs\_build\_sources' 22:43:08 INFO - Installing collected packages: pip 22:43:08 INFO - Found existing installation: pip 0.8.2 22:43:08 INFO - Uninstalling pip: 22:43:08 INFO - Successfully uninstalled pip 22:43:08 INFO - Running setup.py install for pip 22:43:08 INFO - warning: no files found matching 'pip\cacert.pem' 22:43:08 INFO - warning: no files found matching '*.html' under directory 'docs' 22:43:08 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 22:43:08 INFO - no previously-included directories found matching 'docs\_build\_sources' 22:43:08 INFO - Installing pip-script.py script to C:\slave\test-pgo\build\venv\Scripts 22:43:08 INFO - Installing pip.exe script to C:\slave\test-pgo\build\venv\Scripts 22:43:08 INFO - Installing pip2.7-script.py script to C:\slave\test-pgo\build\venv\Scripts 22:43:08 INFO - Installing pip2.7.exe script to C:\slave\test-pgo\build\venv\Scripts 22:43:08 INFO - Installing pip2-script.py script to C:\slave\test-pgo\build\venv\Scripts 22:43:08 INFO - Installing pip2.exe script to C:\slave\test-pgo\build\venv\Scripts 22:43:08 INFO - Successfully installed pip 22:43:08 INFO - Cleaning up... 22:43:08 INFO - Return code: 0 22:43:08 INFO - Installing psutil>=0.7.1 into virtualenv C:\slave\test-pgo\build/venv 22:43:08 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')]} 22:43:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:43:08 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')]} 22:43:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:43:08 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 0x022E6B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022A9EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0239CC98>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01CD8B48>, '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 0x01CFA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02786660>, '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-005', 'USERDOMAIN': 'T-W864-IX-005', '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-005', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-005\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-005', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-005', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-005', '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-005\\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 22:43:08 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 22:43:08 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 22:43:08 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 22:43:08 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-005\\AppData\\Roaming', 22:43:08 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 22:43:08 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 22:43:08 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 22:43:08 INFO - 'COMPUTERNAME': 'T-W864-IX-005', 22:43:08 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 22:43:08 INFO - 'DCLOCATION': 'SCL3', 22:43:08 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 22:43:08 INFO - 'FP_NO_HOST_CHECK': 'NO', 22:43:08 INFO - 'HOMEDRIVE': 'C:', 22:43:08 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-005', 22:43:08 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 22:43:08 INFO - 'KTS_VERSION': '1.19c', 22:43:08 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-005\\AppData\\Local', 22:43:08 INFO - 'LOGONSERVER': '\\\\T-W864-IX-005', 22:43:08 INFO - 'MONDIR': 'C:\\Monitor_config\\', 22:43:08 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 22:43:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:43:08 INFO - 'MOZ_NO_REMOTE': '1', 22:43:08 INFO - 'NO_EM_RESTART': '1', 22:43:08 INFO - 'NUMBER_OF_PROCESSORS': '8', 22:43:08 INFO - 'OS': 'Windows_NT', 22:43:08 INFO - 'OURDRIVE': 'C:', 22:43:08 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 22:43:08 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 22:43:08 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 22:43:08 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 22:43:08 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 22:43:08 INFO - 'PROCESSOR_LEVEL': '6', 22:43:08 INFO - 'PROCESSOR_REVISION': '1e05', 22:43:08 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 22:43:08 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 22:43:08 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 22:43:08 INFO - 'PROGRAMW6432': 'C:\\Program Files', 22:43:08 INFO - 'PROMPT': '$P$G', 22:43:08 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 22:43:08 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 22:43:08 INFO - 'PUBLIC': 'C:\\Users\\Public', 22:43:08 INFO - 'PWD': 'C:\\slave\\test-pgo', 22:43:08 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 22:43:08 INFO - 'SLAVEDIR': 'C:\\slave\\', 22:43:08 INFO - 'SYSTEMDRIVE': 'C:', 22:43:08 INFO - 'SYSTEMROOT': 'C:\\windows', 22:43:08 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 22:43:08 INFO - 'TEST1': 'testie', 22:43:08 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 22:43:08 INFO - 'USERDOMAIN': 'T-W864-IX-005', 22:43:08 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-005', 22:43:08 INFO - 'USERNAME': 'cltbld', 22:43:08 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-005', 22:43:08 INFO - 'WINDIR': 'C:\\windows', 22:43:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 22:43:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:43:10 INFO - Downloading/unpacking psutil>=0.7.1 22:43:10 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 22:43:10 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 22:43:11 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 22:43:11 INFO - Installing collected packages: psutil 22:43:11 INFO - Successfully installed psutil 22:43:11 INFO - Cleaning up... 22:43:11 INFO - Return code: 0 22:43:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv C:\slave\test-pgo\build/venv 22:43:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:43:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:43:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:43:11 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 0x022E6B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022A9EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0239CC98>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01CD8B48>, '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 0x01CFA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02786660>, '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-005', 'USERDOMAIN': 'T-W864-IX-005', '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-005', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-005\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-005', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-005', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-005', '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-005\\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 22:43:11 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 22:43:11 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 22:43:11 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 22:43:11 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-005\\AppData\\Roaming', 22:43:11 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 22:43:11 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 22:43:11 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 22:43:11 INFO - 'COMPUTERNAME': 'T-W864-IX-005', 22:43:11 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 22:43:11 INFO - 'DCLOCATION': 'SCL3', 22:43:11 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 22:43:11 INFO - 'FP_NO_HOST_CHECK': 'NO', 22:43:11 INFO - 'HOMEDRIVE': 'C:', 22:43:11 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-005', 22:43:11 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 22:43:11 INFO - 'KTS_VERSION': '1.19c', 22:43:11 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-005\\AppData\\Local', 22:43:11 INFO - 'LOGONSERVER': '\\\\T-W864-IX-005', 22:43:11 INFO - 'MONDIR': 'C:\\Monitor_config\\', 22:43:11 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 22:43:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:43:11 INFO - 'MOZ_NO_REMOTE': '1', 22:43:11 INFO - 'NO_EM_RESTART': '1', 22:43:11 INFO - 'NUMBER_OF_PROCESSORS': '8', 22:43:11 INFO - 'OS': 'Windows_NT', 22:43:11 INFO - 'OURDRIVE': 'C:', 22:43:11 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 22:43:11 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 22:43:11 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 22:43:11 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 22:43:11 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 22:43:11 INFO - 'PROCESSOR_LEVEL': '6', 22:43:11 INFO - 'PROCESSOR_REVISION': '1e05', 22:43:11 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 22:43:11 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 22:43:11 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 22:43:11 INFO - 'PROGRAMW6432': 'C:\\Program Files', 22:43:11 INFO - 'PROMPT': '$P$G', 22:43:11 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 22:43:11 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 22:43:11 INFO - 'PUBLIC': 'C:\\Users\\Public', 22:43:11 INFO - 'PWD': 'C:\\slave\\test-pgo', 22:43:11 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 22:43:11 INFO - 'SLAVEDIR': 'C:\\slave\\', 22:43:11 INFO - 'SYSTEMDRIVE': 'C:', 22:43:11 INFO - 'SYSTEMROOT': 'C:\\windows', 22:43:11 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 22:43:11 INFO - 'TEST1': 'testie', 22:43:11 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 22:43:11 INFO - 'USERDOMAIN': 'T-W864-IX-005', 22:43:11 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-005', 22:43:11 INFO - 'USERNAME': 'cltbld', 22:43:11 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-005', 22:43:11 INFO - 'WINDIR': 'C:\\windows', 22:43:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 22:43:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:43:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:43:12 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 22:43:12 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 22:43:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:43:12 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 22:43:12 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor 22:43:13 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) 22:43:13 INFO - Installing collected packages: mozsystemmonitor 22:43:13 INFO - Running setup.py install for mozsystemmonitor 22:43:13 INFO - Successfully installed mozsystemmonitor 22:43:13 INFO - Cleaning up... 22:43:13 INFO - Return code: 0 22:43:13 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test-pgo\build/venv 22:43:13 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')]} 22:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:43:13 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')]} 22:43:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:43:13 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 0x022E6B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022A9EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0239CC98>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01CD8B48>, '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 0x01CFA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02786660>, '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-005', 'USERDOMAIN': 'T-W864-IX-005', '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-005', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-005\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-005', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-005', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-005', '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-005\\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 22:43:13 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 22:43:13 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 22:43:13 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 22:43:13 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-005\\AppData\\Roaming', 22:43:13 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 22:43:13 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 22:43:13 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 22:43:13 INFO - 'COMPUTERNAME': 'T-W864-IX-005', 22:43:13 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 22:43:13 INFO - 'DCLOCATION': 'SCL3', 22:43:13 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 22:43:13 INFO - 'FP_NO_HOST_CHECK': 'NO', 22:43:13 INFO - 'HOMEDRIVE': 'C:', 22:43:13 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-005', 22:43:13 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 22:43:13 INFO - 'KTS_VERSION': '1.19c', 22:43:13 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-005\\AppData\\Local', 22:43:13 INFO - 'LOGONSERVER': '\\\\T-W864-IX-005', 22:43:13 INFO - 'MONDIR': 'C:\\Monitor_config\\', 22:43:13 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 22:43:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:43:13 INFO - 'MOZ_NO_REMOTE': '1', 22:43:13 INFO - 'NO_EM_RESTART': '1', 22:43:13 INFO - 'NUMBER_OF_PROCESSORS': '8', 22:43:13 INFO - 'OS': 'Windows_NT', 22:43:13 INFO - 'OURDRIVE': 'C:', 22:43:13 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', 22:43:13 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 22:43:13 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 22:43:13 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 22:43:13 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 22:43:13 INFO - 'PROCESSOR_LEVEL': '6', 22:43:13 INFO - 'PROCESSOR_REVISION': '1e05', 22:43:13 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 22:43:13 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 22:43:13 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 22:43:13 INFO - 'PROGRAMW6432': 'C:\\Program Files', 22:43:13 INFO - 'PROMPT': '$P$G', 22:43:13 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 22:43:13 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 22:43:13 INFO - 'PUBLIC': 'C:\\Users\\Public', 22:43:13 INFO - 'PWD': 'C:\\slave\\test-pgo', 22:43:13 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 22:43:13 INFO - 'SLAVEDIR': 'C:\\slave\\', 22:43:13 INFO - 'SYSTEMDRIVE': 'C:', 22:43:13 INFO - 'SYSTEMROOT': 'C:\\windows', 22:43:13 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 22:43:13 INFO - 'TEST1': 'testie', 22:43:13 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 22:43:13 INFO - 'USERDOMAIN': 'T-W864-IX-005', 22:43:13 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-005', 22:43:13 INFO - 'USERNAME': 'cltbld', 22:43:13 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-005', 22:43:13 INFO - 'WINDIR': 'C:\\windows', 22:43:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 22:43:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:43:13 INFO - Downloading/unpacking blobuploader==1.2.4 22:43:13 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 22:43:13 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 22:43:14 INFO - Downloading blobuploader-1.2.4.tar.gz 22:43:14 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 22:43:14 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader 22:43:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:43:14 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 22:43:14 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 22:43:15 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 22:43:15 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\requests\setup.py) egg_info for package requests 22:43:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:43:15 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 22:43:15 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 22:43:15 INFO - Downloading docopt-0.6.1.tar.gz 22:43:15 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 22:43:15 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\docopt\setup.py) egg_info for package docopt 22:43:15 INFO - Installing collected packages: blobuploader, requests, docopt 22:43:15 INFO - Running setup.py install for blobuploader 22:43:15 INFO - Running setup.py install for requests 22:43:16 INFO - Running setup.py install for docopt 22:43:16 INFO - Successfully installed blobuploader requests docopt 22:43:16 INFO - Cleaning up... 22:43:18 INFO - Return code: 0 22:43:18 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv 22:43:18 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')]} 22:43:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:43:18 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')]} 22:43:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:43:18 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 0x022E6B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022A9EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0239CC98>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01CD8B48>, '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 0x01CFA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02786660>, '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-005', 'USERDOMAIN': 'T-W864-IX-005', '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-005', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-005\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-005', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-005', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-005', '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-005\\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 22:43:18 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 22:43:18 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 22:43:18 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 22:43:18 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-005\\AppData\\Roaming', 22:43:18 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 22:43:18 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 22:43:18 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 22:43:18 INFO - 'COMPUTERNAME': 'T-W864-IX-005', 22:43:18 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 22:43:18 INFO - 'DCLOCATION': 'SCL3', 22:43:18 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 22:43:18 INFO - 'FP_NO_HOST_CHECK': 'NO', 22:43:18 INFO - 'HOMEDRIVE': 'C:', 22:43:18 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-005', 22:43:18 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 22:43:18 INFO - 'KTS_VERSION': '1.19c', 22:43:18 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-005\\AppData\\Local', 22:43:18 INFO - 'LOGONSERVER': '\\\\T-W864-IX-005', 22:43:18 INFO - 'MONDIR': 'C:\\Monitor_config\\', 22:43:18 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 22:43:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:43:18 INFO - 'MOZ_NO_REMOTE': '1', 22:43:18 INFO - 'NO_EM_RESTART': '1', 22:43:18 INFO - 'NUMBER_OF_PROCESSORS': '8', 22:43:18 INFO - 'OS': 'Windows_NT', 22:43:18 INFO - 'OURDRIVE': 'C:', 22:43:18 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', 22:43:18 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 22:43:18 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 22:43:18 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 22:43:18 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 22:43:18 INFO - 'PROCESSOR_LEVEL': '6', 22:43:18 INFO - 'PROCESSOR_REVISION': '1e05', 22:43:18 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 22:43:18 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 22:43:18 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 22:43:18 INFO - 'PROGRAMW6432': 'C:\\Program Files', 22:43:18 INFO - 'PROMPT': '$P$G', 22:43:18 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 22:43:18 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 22:43:18 INFO - 'PUBLIC': 'C:\\Users\\Public', 22:43:18 INFO - 'PWD': 'C:\\slave\\test-pgo', 22:43:18 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 22:43:18 INFO - 'SLAVEDIR': 'C:\\slave\\', 22:43:18 INFO - 'SYSTEMDRIVE': 'C:', 22:43:18 INFO - 'SYSTEMROOT': 'C:\\windows', 22:43:18 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 22:43:18 INFO - 'TEST1': 'testie', 22:43:18 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 22:43:18 INFO - 'USERDOMAIN': 'T-W864-IX-005', 22:43:18 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-005', 22:43:18 INFO - 'USERNAME': 'cltbld', 22:43:18 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-005', 22:43:18 INFO - 'WINDIR': 'C:\\windows', 22:43:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 22:43:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:43:18 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\manifestparser 22:43:18 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-4rap7h-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/manifestparser 22:43:18 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozcrash 22:43:18 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-z41kkf-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozcrash 22:43:18 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdebug 22:43:18 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-c7rreq-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdebug 22:43:19 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdevice 22:43:19 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-kw0x3z-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdevice 22:43:19 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozfile 22:43:19 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ogla7r-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozfile 22:43:19 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozhttpd 22:43:19 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-br5en1-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozhttpd 22:43:19 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinfo 22:43:19 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-cox2k5-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinfo 22:43:19 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinstall 22:43:19 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-m2ybbl-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinstall 22:43:19 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozleak 22:43:19 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jfmser-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozleak 22:43:19 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozlog 22:43:19 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-0vu9u9-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozlog 22:43:19 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moznetwork 22:43:19 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-b3a_ln-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moznetwork 22:43:19 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprocess 22:43:19 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-zbcplf-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprocess 22:43:20 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprofile 22:43:20 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-umcyex-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprofile 22:43:20 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozrunner 22:43:20 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-5axidq-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozrunner 22:43:20 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozscreenshot 22:43:20 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-c08w_f-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:43:20 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moztest 22:43:20 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-j1x_iz-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moztest 22:43:20 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozversion 22:43:20 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ogdgz0-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozversion 22:43:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:43:20 INFO - Running setup.py install for manifestparser 22:43:20 INFO - Installing manifestparser-script.py script to C:\slave\test-pgo\build\venv\Scripts 22:43:20 INFO - Installing manifestparser.exe script to C:\slave\test-pgo\build\venv\Scripts 22:43:21 INFO - Running setup.py install for mozcrash 22:43:21 INFO - Running setup.py install for mozdebug 22:43:21 INFO - Running setup.py install for mozdevice 22:43:22 INFO - Installing sutini-script.py script to C:\slave\test-pgo\build\venv\Scripts 22:43:22 INFO - Installing sutini.exe script to C:\slave\test-pgo\build\venv\Scripts 22:43:22 INFO - Installing dm-script.py script to C:\slave\test-pgo\build\venv\Scripts 22:43:22 INFO - Installing dm.exe script to C:\slave\test-pgo\build\venv\Scripts 22:43:22 INFO - Running setup.py install for mozfile 22:43:22 INFO - Running setup.py install for mozhttpd 22:43:23 INFO - Installing mozhttpd-script.py script to C:\slave\test-pgo\build\venv\Scripts 22:43:23 INFO - Installing mozhttpd.exe script to C:\slave\test-pgo\build\venv\Scripts 22:43:23 INFO - Running setup.py install for mozinfo 22:43:23 INFO - Installing mozinfo-script.py script to C:\slave\test-pgo\build\venv\Scripts 22:43:23 INFO - Installing mozinfo.exe script to C:\slave\test-pgo\build\venv\Scripts 22:43:23 INFO - Running setup.py install for mozInstall 22:43:23 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test-pgo\build\venv\Scripts 22:43:23 INFO - Installing moz_remove_from_system.exe script to C:\slave\test-pgo\build\venv\Scripts 22:43:23 INFO - Installing mozuninstall-script.py script to C:\slave\test-pgo\build\venv\Scripts 22:43:23 INFO - Installing mozuninstall.exe script to C:\slave\test-pgo\build\venv\Scripts 22:43:23 INFO - Installing mozinstall-script.py script to C:\slave\test-pgo\build\venv\Scripts 22:43:23 INFO - Installing mozinstall.exe script to C:\slave\test-pgo\build\venv\Scripts 22:43:23 INFO - Installing moz_add_to_system-script.py script to C:\slave\test-pgo\build\venv\Scripts 22:43:23 INFO - Installing moz_add_to_system.exe script to C:\slave\test-pgo\build\venv\Scripts 22:43:24 INFO - Running setup.py install for mozleak 22:43:24 INFO - Running setup.py install for mozlog 22:43:24 INFO - Installing structlog-script.py script to C:\slave\test-pgo\build\venv\Scripts 22:43:24 INFO - Installing structlog.exe script to C:\slave\test-pgo\build\venv\Scripts 22:43:25 INFO - Running setup.py install for moznetwork 22:43:25 INFO - Installing moznetwork-script.py script to C:\slave\test-pgo\build\venv\Scripts 22:43:25 INFO - Installing moznetwork.exe script to C:\slave\test-pgo\build\venv\Scripts 22:43:25 INFO - Running setup.py install for mozprocess 22:43:26 INFO - Running setup.py install for mozprofile 22:43:26 INFO - Installing mozprofile-script.py script to C:\slave\test-pgo\build\venv\Scripts 22:43:26 INFO - Installing mozprofile.exe script to C:\slave\test-pgo\build\venv\Scripts 22:43:26 INFO - Installing diff-profiles-script.py script to C:\slave\test-pgo\build\venv\Scripts 22:43:26 INFO - Installing diff-profiles.exe script to C:\slave\test-pgo\build\venv\Scripts 22:43:26 INFO - Installing view-profile-script.py script to C:\slave\test-pgo\build\venv\Scripts 22:43:26 INFO - Installing view-profile.exe script to C:\slave\test-pgo\build\venv\Scripts 22:43:26 INFO - Running setup.py install for mozrunner 22:43:27 INFO - Installing mozrunner-script.py script to C:\slave\test-pgo\build\venv\Scripts 22:43:27 INFO - Installing mozrunner.exe script to C:\slave\test-pgo\build\venv\Scripts 22:43:27 INFO - Running setup.py install for mozscreenshot 22:43:27 INFO - Running setup.py install for moztest 22:43:28 INFO - Running setup.py install for mozversion 22:43:28 INFO - Installing mozversion-script.py script to C:\slave\test-pgo\build\venv\Scripts 22:43:28 INFO - Installing mozversion.exe script to C:\slave\test-pgo\build\venv\Scripts 22:43:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:43:29 INFO - Cleaning up... 22:43:29 INFO - Return code: 0 22:43:29 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv 22:43:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:43:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:43:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:43:29 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 0x022E6B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022A9EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0239CC98>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01CD8B48>, '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 0x01CFA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02786660>, '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-005', 'USERDOMAIN': 'T-W864-IX-005', '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-005', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-005\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-005', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-005', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-005', '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-005\\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 22:43:29 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 22:43:29 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 22:43:29 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 22:43:29 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-005\\AppData\\Roaming', 22:43:29 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 22:43:29 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 22:43:29 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 22:43:29 INFO - 'COMPUTERNAME': 'T-W864-IX-005', 22:43:29 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 22:43:29 INFO - 'DCLOCATION': 'SCL3', 22:43:29 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 22:43:29 INFO - 'FP_NO_HOST_CHECK': 'NO', 22:43:29 INFO - 'HOMEDRIVE': 'C:', 22:43:29 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-005', 22:43:29 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 22:43:29 INFO - 'KTS_VERSION': '1.19c', 22:43:29 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-005\\AppData\\Local', 22:43:29 INFO - 'LOGONSERVER': '\\\\T-W864-IX-005', 22:43:29 INFO - 'MONDIR': 'C:\\Monitor_config\\', 22:43:29 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 22:43:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:43:29 INFO - 'MOZ_NO_REMOTE': '1', 22:43:29 INFO - 'NO_EM_RESTART': '1', 22:43:29 INFO - 'NUMBER_OF_PROCESSORS': '8', 22:43:29 INFO - 'OS': 'Windows_NT', 22:43:29 INFO - 'OURDRIVE': 'C:', 22:43:29 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 22:43:29 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 22:43:29 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 22:43:29 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 22:43:29 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 22:43:29 INFO - 'PROCESSOR_LEVEL': '6', 22:43:29 INFO - 'PROCESSOR_REVISION': '1e05', 22:43:29 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 22:43:29 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 22:43:29 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 22:43:29 INFO - 'PROGRAMW6432': 'C:\\Program Files', 22:43:29 INFO - 'PROMPT': '$P$G', 22:43:29 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 22:43:29 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 22:43:29 INFO - 'PUBLIC': 'C:\\Users\\Public', 22:43:29 INFO - 'PWD': 'C:\\slave\\test-pgo', 22:43:29 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 22:43:29 INFO - 'SLAVEDIR': 'C:\\slave\\', 22:43:29 INFO - 'SYSTEMDRIVE': 'C:', 22:43:29 INFO - 'SYSTEMROOT': 'C:\\windows', 22:43:29 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 22:43:29 INFO - 'TEST1': 'testie', 22:43:29 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 22:43:29 INFO - 'USERDOMAIN': 'T-W864-IX-005', 22:43:29 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-005', 22:43:29 INFO - 'USERNAME': 'cltbld', 22:43:29 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-005', 22:43:29 INFO - 'WINDIR': 'C:\\windows', 22:43:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 22:43:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:43:29 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\manifestparser 22:43:29 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ycdleg-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/manifestparser 22:43:29 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)) 22:43:29 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozcrash 22:43:29 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-vvckuy-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozcrash 22:43:29 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)) 22:43:29 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdebug 22:43:29 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-pdduxs-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdebug 22:43:29 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)) 22:43:29 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdevice 22:43:29 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-k4bovc-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdevice 22:43:29 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)) 22:43:29 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozfile 22:43:29 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ftvoxd-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozfile 22:43:30 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)) 22:43:30 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozhttpd 22:43:30 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ygkcbk-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozhttpd 22:43:30 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)) 22:43:30 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinfo 22:43:30 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-fpdpni-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinfo 22:43:30 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)) 22:43:30 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinstall 22:43:30 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-6r5bpt-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinstall 22:43:30 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)) 22:43:30 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozleak 22:43:30 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-z1_zv0-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozleak 22:43:30 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)) 22:43:30 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozlog 22:43:30 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-hlwhqf-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozlog 22:43:30 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)) 22:43:30 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moznetwork 22:43:30 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-5wjzg6-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moznetwork 22:43:30 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)) 22:43:30 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprocess 22:43:30 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-x1y_3c-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprocess 22:43:30 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)) 22:43:30 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprofile 22:43:30 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-wkhud5-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprofile 22:43:31 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)) 22:43:31 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozrunner 22:43:31 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-2lc1ls-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozrunner 22:43:31 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)) 22:43:31 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozscreenshot 22:43:31 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-4btzxp-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:43:31 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)) 22:43:31 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moztest 22:43:31 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-zwsfhh-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moztest 22:43:31 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)) 22:43:31 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozversion 22:43:31 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xfgyne-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozversion 22:43:31 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)) 22:43:31 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)) 22:43:31 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)) 22:43:31 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)) 22:43:31 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)) 22:43:31 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)) 22:43:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 10)) 22:43:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:43:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:43:32 INFO - Downloading blessings-1.5.1.tar.gz 22:43:32 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 22:43:32 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\blessings\setup.py) egg_info for package blessings 22:43:32 INFO - Installing collected packages: blessings 22:43:32 INFO - Running setup.py install for blessings 22:43:32 INFO - Successfully installed blessings 22:43:32 INFO - Cleaning up... 22:43:35 INFO - Return code: 0 22:43:35 INFO - Done creating virtualenv C:\slave\test-pgo\build/venv. 22:43:35 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'freeze'] 22:43:35 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip freeze 22:43:36 INFO - Reading from file tmpfile_stdout 22:43:36 INFO - Using _rmtree_windows ... 22:43:36 INFO - Using _rmtree_windows ... 22:43:36 INFO - Current package versions: 22:43:36 INFO - blessings == 1.5.1 22:43:36 INFO - blobuploader == 1.2.4 22:43:36 INFO - docopt == 0.6.1 22:43:36 INFO - manifestparser == 1.1 22:43:36 INFO - mozInstall == 1.12 22:43:36 INFO - mozcrash == 0.16 22:43:36 INFO - mozdebug == 0.1 22:43:36 INFO - mozdevice == 0.46 22:43:36 INFO - mozfile == 1.2 22:43:36 INFO - mozhttpd == 0.7 22:43:36 INFO - mozinfo == 0.8 22:43:36 INFO - mozleak == 0.1 22:43:36 INFO - mozlog == 3.0 22:43:36 INFO - moznetwork == 0.27 22:43:36 INFO - mozprocess == 0.22 22:43:36 INFO - mozprofile == 0.27 22:43:36 INFO - mozrunner == 6.11 22:43:36 INFO - mozscreenshot == 0.1 22:43:36 INFO - mozsystemmonitor == 0.0 22:43:36 INFO - moztest == 0.7 22:43:36 INFO - mozversion == 1.4 22:43:36 INFO - psutil == 3.1.1 22:43:36 INFO - requests == 1.2.3 22:43:36 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv 22:43:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:43:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:43:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:43:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:43:36 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 0x022E6B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x022A9EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0239CC98>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01CD8B48>, '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 0x01CFA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02786660>, '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-005', 'USERDOMAIN': 'T-W864-IX-005', '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-005', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-005\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-005', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-005', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-005', '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-005\\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 22:43:36 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 22:43:36 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 22:43:36 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 22:43:36 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-005\\AppData\\Roaming', 22:43:36 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 22:43:36 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 22:43:36 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 22:43:36 INFO - 'COMPUTERNAME': 'T-W864-IX-005', 22:43:36 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 22:43:36 INFO - 'DCLOCATION': 'SCL3', 22:43:36 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 22:43:36 INFO - 'FP_NO_HOST_CHECK': 'NO', 22:43:36 INFO - 'HOMEDRIVE': 'C:', 22:43:36 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-005', 22:43:36 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 22:43:36 INFO - 'KTS_VERSION': '1.19c', 22:43:36 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-005\\AppData\\Local', 22:43:36 INFO - 'LOGONSERVER': '\\\\T-W864-IX-005', 22:43:36 INFO - 'MONDIR': 'C:\\Monitor_config\\', 22:43:36 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 22:43:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:43:36 INFO - 'MOZ_NO_REMOTE': '1', 22:43:36 INFO - 'NO_EM_RESTART': '1', 22:43:36 INFO - 'NUMBER_OF_PROCESSORS': '8', 22:43:36 INFO - 'OS': 'Windows_NT', 22:43:36 INFO - 'OURDRIVE': 'C:', 22:43:36 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', 22:43:36 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 22:43:36 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 22:43:36 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 22:43:36 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 22:43:36 INFO - 'PROCESSOR_LEVEL': '6', 22:43:36 INFO - 'PROCESSOR_REVISION': '1e05', 22:43:36 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 22:43:36 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 22:43:36 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 22:43:36 INFO - 'PROGRAMW6432': 'C:\\Program Files', 22:43:36 INFO - 'PROMPT': '$P$G', 22:43:36 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 22:43:36 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 22:43:36 INFO - 'PUBLIC': 'C:\\Users\\Public', 22:43:36 INFO - 'PWD': 'C:\\slave\\test-pgo', 22:43:36 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 22:43:36 INFO - 'SLAVEDIR': 'C:\\slave\\', 22:43:36 INFO - 'SYSTEMDRIVE': 'C:', 22:43:36 INFO - 'SYSTEMROOT': 'C:\\windows', 22:43:36 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 22:43:36 INFO - 'TEST1': 'testie', 22:43:36 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 22:43:36 INFO - 'USERDOMAIN': 'T-W864-IX-005', 22:43:36 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-005', 22:43:36 INFO - 'USERNAME': 'cltbld', 22:43:36 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-005', 22:43:36 INFO - 'WINDIR': 'C:\\windows', 22:43:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 22:43:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:43:36 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)) 22:43:36 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)) 22:43:36 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)) 22:43:36 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)) 22:43:36 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)) 22:43:36 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)) 22:43:36 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)) 22:43:36 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)) 22:43:36 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)) 22:43:36 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)) 22:43:36 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)) 22:43:36 INFO - Cleaning up... 22:43:36 INFO - Return code: 0 22:43:36 INFO - Running post-action listener: _resource_record_post_action 22:43:36 INFO - Running post-action listener: _start_resource_monitoring 22:43:36 INFO - Starting resource monitoring. 22:43:36 INFO - ##### 22:43:36 INFO - ##### Running install step. 22:43:36 INFO - ##### 22:43:36 INFO - Running pre-action listener: _resource_record_pre_action 22:43:36 INFO - Running main action method: install 22:43:36 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'freeze'] 22:43:36 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip freeze 22:43:37 INFO - Reading from file tmpfile_stdout 22:43:37 INFO - Using _rmtree_windows ... 22:43:37 INFO - Using _rmtree_windows ... 22:43:37 INFO - Detecting whether we're running mozinstall >=1.0... 22:43:37 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build/venv/scripts/python', 'C:\\slave\\test-pgo\\build/venv/scripts/mozinstall-script.py', '-h'] 22:43:37 INFO - Copy/paste: C:\slave\test-pgo\build/venv/scripts/python C:\slave\test-pgo\build/venv/scripts/mozinstall-script.py -h 22:43:37 INFO - Reading from file tmpfile_stdout 22:43:37 INFO - Output received: 22:43:37 INFO - Usage: mozinstall-script.py [options] installer 22:43:37 INFO - Options: 22:43:37 INFO - -h, --help show this help message and exit 22:43:37 INFO - -d DEST, --destination=DEST 22:43:37 INFO - Directory to install application into. [default: 22:43:37 INFO - "C:\slave\test-pgo"] 22:43:37 INFO - --app=APP Application being installed. [default: firefox] 22:43:37 INFO - Using _rmtree_windows ... 22:43:37 INFO - Using _rmtree_windows ... 22:43:37 INFO - mkdir: C:\slave\test-pgo\build\application 22:43:37 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'] 22:43:37 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 22:43:38 INFO - Reading from file tmpfile_stdout 22:43:38 INFO - Output received: 22:43:38 INFO - C:\slave\test-pgo\build\application\firefox\firefox.exe 22:43:38 INFO - Using _rmtree_windows ... 22:43:38 INFO - Using _rmtree_windows ... 22:43:38 INFO - Running post-action listener: _resource_record_post_action 22:43:38 INFO - ##### 22:43:38 INFO - ##### Running run-tests step. 22:43:38 INFO - ##### 22:43:38 INFO - Running pre-action listener: _resource_record_pre_action 22:43:38 INFO - Running main action method: run_tests 22:43:38 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\python', '--version'] 22:43:38 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\python --version 22:43:38 INFO - Python 2.7.3 22:43:38 INFO - Return code: 0 22:43:38 INFO - grabbing minidump binary from tooltool 22:43:38 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')]} 22:43:38 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 0x01CD8B48>, '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 0x01CFA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02786660>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'privileged': False}, attempt #1 22:43:38 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 22:43:38 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 22:43:38 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 22:43:40 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test-pgo\build\tmpqs48zh 22:43:40 INFO - INFO - File integrity verified, renaming tmpqs48zh to win32-minidump_stackwalk.exe 22:43:40 INFO - Return code: 0 22:43:40 INFO - Chmoding C:\slave\test-pgo\build\win32-minidump_stackwalk.exe to 0755 22:43:40 INFO - mkdir: C:\slave\test-pgo\build\blobber_upload_dir 22:43:40 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test-pgo\build\blobber_upload_dir 22:43:40 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test-pgo\build\win32-minidump_stackwalk.exe 22:43:40 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test-pgo\build\blobber_upload_dir 22:43:40 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\python', 'C:\\slave\\test-pgo\\build\\tests\\talos\\talos\\run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test-pgo\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YCOqGKfKRFWQDA1J84xKgA/artifacts/public/build/firefox-44.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-005', '--webServer', 'localhost'] in C:\slave\test-pgo\build 22:43:40 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\python C:\slave\test-pgo\build\tests\talos\talos\run_tests.py --debug --branchName B2G-Inbound --suite dromaeojs --executablePath C:\slave\test-pgo\build\application\firefox\firefox --symbolsPath https://queue.taskcluster.net/v1/task/YCOqGKfKRFWQDA1J84xKgA/artifacts/public/build/firefox-44.0a1.en-US.win64.crashreporter-symbols.zip --title T-W864-IX-005 --webServer localhost 22:43:40 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 22:43:40 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-005\\AppData\\Roaming', 22:43:40 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 22:43:40 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 22:43:40 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 22:43:40 INFO - 'COMPUTERNAME': 'T-W864-IX-005', 22:43:40 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 22:43:40 INFO - 'DCLOCATION': 'SCL3', 22:43:40 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 22:43:40 INFO - 'FP_NO_HOST_CHECK': 'NO', 22:43:40 INFO - 'HOMEDRIVE': 'C:', 22:43:40 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-005', 22:43:40 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 22:43:40 INFO - 'KTS_VERSION': '1.19c', 22:43:40 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-005\\AppData\\Local', 22:43:40 INFO - 'LOGONSERVER': '\\\\T-W864-IX-005', 22:43:40 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test-pgo\\build\\blobber_upload_dir', 22:43:40 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test-pgo\\build\\win32-minidump_stackwalk.exe', 22:43:40 INFO - 'MONDIR': 'C:\\Monitor_config\\', 22:43:40 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 22:43:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:43:40 INFO - 'MOZ_NO_REMOTE': '1', 22:43:40 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test-pgo\\build\\blobber_upload_dir', 22:43:40 INFO - 'NO_EM_RESTART': '1', 22:43:40 INFO - 'NUMBER_OF_PROCESSORS': '8', 22:43:40 INFO - 'OS': 'Windows_NT', 22:43:40 INFO - 'OURDRIVE': 'C:', 22:43:40 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', 22:43:40 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 22:43:40 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 22:43:40 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 22:43:40 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 22:43:40 INFO - 'PROCESSOR_LEVEL': '6', 22:43:40 INFO - 'PROCESSOR_REVISION': '1e05', 22:43:40 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 22:43:40 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 22:43:40 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 22:43:40 INFO - 'PROGRAMW6432': 'C:\\Program Files', 22:43:40 INFO - 'PROMPT': '$P$G', 22:43:40 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 22:43:40 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 22:43:40 INFO - 'PUBLIC': 'C:\\Users\\Public', 22:43:40 INFO - 'PWD': 'C:\\slave\\test-pgo', 22:43:40 INFO - 'PYTHONPATH': 'C:\\slave\\test-pgo\\build\\tests\\talos', 22:43:40 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 22:43:40 INFO - 'SLAVEDIR': 'C:\\slave\\', 22:43:40 INFO - 'SYSTEMDRIVE': 'C:', 22:43:40 INFO - 'SYSTEMROOT': 'C:\\windows', 22:43:40 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 22:43:40 INFO - 'TEST1': 'testie', 22:43:40 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 22:43:40 INFO - 'USERDOMAIN': 'T-W864-IX-005', 22:43:40 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-005', 22:43:40 INFO - 'USERNAME': 'cltbld', 22:43:40 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-005', 22:43:40 INFO - 'WINDIR': 'C:\\windows', 22:43:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 22:43:40 INFO - Calling ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\python', 'C:\\slave\\test-pgo\\build\\tests\\talos\\talos\\run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test-pgo\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YCOqGKfKRFWQDA1J84xKgA/artifacts/public/build/firefox-44.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-005', '--webServer', 'localhost'] with output_timeout 3600 ProcessManager NOT managing child processes ProcessManager UNABLE to use job objects to manage child processes 22:43:41 INFO - mozversion INFO | application_buildid: 20151023173022 22:43:41 INFO - mozversion INFO | application_changeset: cc7bd8e4c0fb1a3a13d8716266ff7241f4c803af 22:43:41 INFO - mozversion INFO | application_display_name: Nightly 22:43:41 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:43:41 INFO - mozversion INFO | application_name: Firefox 22:43:41 INFO - mozversion INFO | application_remotingname: firefox 22:43:41 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 22:43:41 INFO - mozversion INFO | application_vendor: Mozilla 22:43:41 INFO - mozversion INFO | application_version: 44.0a1 22:43:41 INFO - mozversion INFO | platform_buildid: 20151023173022 22:43:41 INFO - mozversion INFO | platform_changeset: cc7bd8e4c0fb1a3a13d8716266ff7241f4c803af 22:43:41 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 22:43:41 INFO - mozversion INFO | platform_version: 44.0a1 22:43:41 INFO - 2015-10-23 22:43:41,365 DEBUG : using testdate: 1445665421 22:43:41 INFO - 2015-10-23 22:43:41,365 DEBUG : actual date: 1445665421 22:43:41 INFO - 2015-10-23 22:43:41,377 INFO : starting webserver on 'localhost:49276' 22:43:41 INFO - 2015-10-23 22:43:41,378 INFO : Starting test suite T-W864-IX-005 22:43:41 INFO - 2015-10-23 22:43:41,378 INFO : Starting test dromaeo_css 22:43:41 INFO - 2015-10-23 22:43:41,378 DEBUG : operating with platform_type : w8_ 22:43:41 INFO - 2015-10-23 22:43:41,378 INFO : Initialising browser for dromaeo_css test... 22:43:41 INFO - 2015-10-23 22:43:41,474 DEBUG : command line: C:\slave\test-pgo\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpci2_nz\profile http://localhost:49276/getInfo.html 22:43:49 INFO - 2015-10-23 22:43:49,747 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:43:49 INFO - 2015-10-23 22:43:49,747 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:43:49 INFO - 2015-10-23 22:43:49,747 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674 22:43:49 INFO - 2015-10-23 22:43:49,747 DEBUG : BROWSER_OUTPUT: __metrics 22:43:49 INFO - 2015-10-23 22:43:49,891 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:43:51 INFO - 2015-10-23 22:43:51,028 DEBUG : BROWSER_OUTPUT: console.error: 22:43:51 INFO - 2015-10-23 22:43:51,028 DEBUG : BROWSER_OUTPUT: Message: Error: Transaction canceled due to a closed connection. 22:43:51 INFO - 2015-10-23 22:43:51,028 DEBUG : BROWSER_OUTPUT: Stack: 22:43:51 INFO - 2015-10-23 22:43:51,028 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise<@resource://gre/modules/Sqlite.jsm:562:1 22:43:51 INFO - 2015-10-23 22:43:51,028 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 22:43:51 INFO - 2015-10-23 22:43:51,028 DEBUG : BROWSER_OUTPUT: 22:43:51 INFO - 2015-10-23 22:43:51,756 INFO : Browser initialized. 22:43:51 INFO - 2015-10-23 22:43:51,756 INFO : Running cycle 1/1 for dromaeo_css test... 22:43:51 INFO - 2015-10-23 22:43:51,756 DEBUG : command line: C:\slave\test-pgo\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpci2_nz\profile -tp file:\C:\slave\test-pgo\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:44:03 INFO - 2015-10-23 22:44:03,131 DEBUG : BROWSER_OUTPUT: RSS: Main: 165580800 22:44:03 INFO - 2015-10-23 22:44:03,131 DEBUG : BROWSER_OUTPUT: 22:44:54 INFO - 2015-10-23 22:44:54,203 DEBUG : BROWSER_OUTPUT: 1445665494202 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] 22:47:03 INFO - 2015-10-23 22:47:03,553 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 22:47:04 INFO - 2015-10-23 22:47:04,621 DEBUG : BROWSER_OUTPUT: RSS: Main: 246026240 22:47:04 INFO - 2015-10-23 22:47:04,621 DEBUG : BROWSER_OUTPUT: 22:50:08 INFO - 2015-10-23 22:50:08,444 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 22:50:09 INFO - 2015-10-23 22:50:09,000 DEBUG : BROWSER_OUTPUT: RSS: Main: 219815936 22:50:09 INFO - 2015-10-23 22:50:09,000 DEBUG : BROWSER_OUTPUT: 22:53:11 INFO - 2015-10-23 22:53:11,082 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 22:53:11 INFO - 2015-10-23 22:53:11,644 DEBUG : BROWSER_OUTPUT: RSS: Main: 192634880 22:53:11 INFO - 2015-10-23 22:53:11,644 DEBUG : BROWSER_OUTPUT: 22:56:13 INFO - 2015-10-23 22:56:13,743 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 22:56:14 INFO - 2015-10-23 22:56:14,315 DEBUG : BROWSER_OUTPUT: RSS: Main: 163024896 22:56:14 INFO - 2015-10-23 22:56:14,315 DEBUG : BROWSER_OUTPUT: 22:59:17 INFO - 2015-10-23 22:59:17,196 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 22:59:17 INFO - 2015-10-23 22:59:17,760 DEBUG : BROWSER_OUTPUT: RSS: Main: 159948800 22:59:17 INFO - 2015-10-23 22:59:17,760 DEBUG : BROWSER_OUTPUT: 23:02:20 INFO - 2015-10-23 23:02:20,312 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 23:02:20 INFO - 2015-10-23 23:02:20,562 DEBUG : BROWSER_OUTPUT: RSS: Main: 231776256 23:02:20 INFO - 2015-10-23 23:02:20,562 DEBUG : BROWSER_OUTPUT: 23:02:20 INFO - 2015-10-23 23:02:20,565 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:02:20 INFO - 2015-10-23 23:02:20,565 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:02:20 INFO - 2015-10-23 23:02:20,565 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:02:20 INFO - 2015-10-23 23:02:20,565 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:02:20 INFO - 2015-10-23 23:02:20,565 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2871.2678267041906;2942.264433891527;2944.705529447057;2976.4344774492843;3003.039027511197;5653.632513886594;5655.406182350851;5663.490285874271;5686.431356864311;5724.7996320128805;5700.600957932947;5706.858628274341;5708.1437784332375;5708.286464191976;5713.742881570319;5006.54941055305;5061.822836200734;5064.442911279756;5096.261042148886;5106.872328191787;5055.848324550251;5070.29015937769;5082.313887625179;5096.031753966753;5100.617453690969;4969.105560999019;5010.323606313137;5072.061668591304;5080.618953578478;5097.974510127444;4970.826021089245;4998.200287953946;5016.021875734234;5105.387353517602;5133.050385678643;5000.174971129759;5000.549950504435;5011.974940125276;5042.319286896295;5049;5324.227986941872;5426.077566813612;5510.118381059011;5516.613837031409;5517.944820551824;5795.391483894215;5837.562182836262;5840.445157710011;5894.027485464893;5916.645001299936;5980.521558275327;5985.670788106652;5991.550633702446;6024.638521688713;6044.607100538451;5350.0904846176245;5471.5896307777075;5479.232907392969;5485.396606373336;5500.339959204881;5991.64050156992;6051.394860513913;6071.878562428815;6074.331823499411;6075.2405949256345;5784.21913041734;5791.362950075489;5855.882882342329;5858.414158584107;5877.853053673693;5850.678212698343;5942.465178133989;5966.134910438049;5975.4024597540765;5983.866636163828;5816.970915145397;5835.737391817378;5883.0881213411985;5898.64608123514;5950;5930.258717660293;5933.643981361132;5935.73289201987;5936.198613187251;5945.346011938684;3541.5041894134843;3685;3744.26986737589;3766.152615661509;3804.8097595120134;3328.5839270091237;3368.663133686661;3376.29097889446;3408.4546472564766;3439.1574064353895;5663.348714897757;5720.056190728566;5735.684537350402;5736.942630573724;5801.245838041112;5769.365369809318;5921.467067963904;5936.406359364029;6044.395560444008;6058.606190597685;5596.300462442195;5611.7755289788765;5647.322321321468;5649.322081350264;5654.095344744821;4807.086653535817;4807.471178170398;4811.49479304675;4818.301346304766;4880.072786170687;6098.359672234352;6148.446639802529;6151.9384806151365;6240.968795155995;6299;5966.224390829165;6024.638521688713;6033.42682445167;6035.275766907999;6045.486133678686;6241.469475094486;6252.343503932022;6312.7159277833525;6318.8736225274315;6319.652419116993;5717.456841600041;5836.066229403275;5839.532837372915;5856.016836420693;5877.206577112035;5855.912161317498;5861.9413805861395;5883.558733094949;5885.911711324419;5933.614315069507;5800.24596802413;5844.6785426801935;5924.348321684697;5938.435848594377;5944.910826337695;5694.117411801178;5722.628029178257;5796.884062318814;5822.679752613478;5843.795467158629;5689.061304884648;5691.971540142273;5697.857553561028;5717.7141142941855;5760.33756118035;5853.678047707247;5886.676232807236;5890.764369425175;5892.499137573354;5903.380145084876;5607.747651355618;5631.943680563142;5674.319081710221;5779.075347944308;5801.82594522165 23:02:20 INFO - 2015-10-23 23:02:20,565 DEBUG : BROWSER_OUTPUT: |1;ext.html;555.8665920179155;592.5141384065067;598.3388355866767;603.8369640197144;607.3228350389312;28937.710622893766;29029.854850725744;38456.423153652715;39092.80453597735;39245.41131883017;42184.57815421845;42324;42357;42377.36433953493;42566.787166064205;7804.492707973964;8563.44337618056;8710.825783484326;8713.302935765123;8719.60761765719;7770.067591888981;10569.6300629478;10796.298240614335;10882.61910833117;10882.61910833121;10839.18706097042;10857.67426977188;10970.890291097106;10977.780444391108;10997.780044399107;7986.560739159344;8101.95949020257;10677.41274229921;10724.302920310154;10737.463126843626;10726.088282495919;10833.891661083368;10923.781524369548;10944.945275273652;10949.562017519289;38509.80745096285;38982.80508597467;39494.40758388626;39504;39554.40668389977;3291.983540082308;3369.882054128094;3378.2567835076243;3462.9307413851584;3775.0751065988734;30612.54081188762;30782;30801.845990769903;30824.691753082407;31630.683693163235;3216.7748257621743;3235.5308480270464;3242.2542815152647;3246.8863589774246;3277.705006549398;310061;310425;311263;312286.4898099935;315706;49679.75160124248;50100.49899501031;53438.7328063365;54632;55125.1731224032;51344.48655513472;51572.22641660378;51629;51649;51744.741276293375;15071.698566028837;15149.318280677397;15171.544853654408;15246.390144394321;15285.159316237492;11325.773484530264;11543.71140721472;11553.13351498641;11561.537538498535;11612.12909031826;16914.577135571464;17380.21789019497;17865.196066177054;18006.279748810164;18092.819071809376;7927;8112.107668156498;8143.592820358958;8218.383621228431;8228.547429891414;891.80826122384;928.6610387208756;952.7570469530225;984.9264301910952;1008.3949630221955;26010.869945650527;26884.731152688615;28260;28311.858440707663;28750.856245719056;1069.8716154061406;1087.2715280761909;1149.844770955927;1157.0974639780984;1164.5109054197258;14606.926965365317;14718.33767480466;14964.476243331432;15025.398984040516;15083;451725;453173;454063;454895;462990;50916.74541627342;51216.487835121174;51325;51363.22955155675;51422;1275.4706796679275;1307.9738405231842;1316.1050485669455;1322.4115268705718;1323.4970711129902;23388.298351049496;27654;28087.71912280851;28124.062631232053;28159.71840281571;36662.26675466529;41670.37494437647;42072.1585568293;42078;42124.57875421329;250901;251134;253037;254066;254358;26490.86754566215;26822.329441764112;29618.259543511584;30084.84957575198;30326.84836575803;39092.804535977135;39162;39865.202695945336;39932.40101398539;39941.40087898626;33169.83415083006;33993.66006339905;34084;34344.48483272703;34409.139771505914;35194;35833.46249806307;36140.27719445544;36147.096322592144;36154.8192259037;36445.45331820078;36737.632623673424;37166.814165929;37213.6278637221;37241.6275837249;32217;32563.674363256065;32919.67080329166;32997.83501082479;33010;26775.598366024915;26890.193294201206;26955;26959.730402696507;26992.460150797266 23:02:20 INFO - 2015-10-23 23:02:20,569 DEBUG : BROWSER_OUTPUT: |2;jquery.html;379.54454654414707;384.8287512057134;389.57341710826654;389.84016553213183;392.3310755162448;14040;15067.547973560784;16739.246733896973;18550.62898742026;18707;17075.316987320522;17291.827081729178;17319.91340043298;17983.19075641596;18030.5492362691;5380.408155102946;5430.429804870491;5500.50495455409;5503.889922201553;5513.2005859150395;4267.338562522814;4363.607275345218;5589.273394458735;6086.087086936951;6267.153934218891;6166.4450199482035;6294.181756371689;6296.937030629704;6316.62100273985;6317.399847014526;6190.938090619104;6227.750889964396;6234.158388617524;6237.407446292595;6241.251049873998;5386.245925570423;5484.533814625762;5499.3675727291475;5514.724263786835;5522.088855338864;22365.32904012882;22568.210112646142;22792.430189245235;22899.656505152438;23037.19369822065;2080.448681099495;2169.642009068502;2444.5914160827847;2526.84838909666;2679.968212238283;13860;14088.929555352157;14122;14215.218163001031;14542.636434089127;1557.89873658213;1574.55125289292;1686.9915650421792;1690.475952454743;1715.6139868529606;61789.691051544454;63370.36629633737;64806;66627;67811;6840.11078559794;6883.795335816212;6913.723451062002;6946.6179360134665;6974.197967233732;8157.2250636189465;8170.305524030405;8184.754457366289;8195.95902020498;8197.95901020503;5620.297462817148;5671.262735844314;5717.256756621696;5740.225069615549;5740.885182296331;6207.410296021961;6235;6236.314005459396;6286.339934306923;6303.401176888188;3223.9194020149685;3224.451843186664;3232.369687910882;3235.126515840757;3274.8035117893;1164.7845148647527;1171.5079666540073;1183.1422218891407;1201.8978386837216;1229.8216758569956;467.2593938607345;477.01734427079634;487.1401975513222;502.99497005030213;520.5809323494548;11742.17804753659;12034.699132521757;12081.87918120825;12122.090843186796;12145.696357590954;500.7721486723532;513.2327170879558;518.5125981577305;533.1549494051893;542.8507160530806;6468.094466774655;6728.192616886005;6736.629485378253;6767.120274364301;6805.149356330458;683138;685223;691553;692351;701491;80563.59718201488;80833.59583202047;82187.17812821915;82727.586362069;85548.14451855526;526.3762441506826;533.751805410486;569.4277251362272;572.7021948586795;577.0882006429831;10895.673129806119;11029.172812038969;11126.61056863006;11186.608468703556;11304.095672346357;34016.51636639935;34895.47656785201;34903.650963491054;34988.950331490094;37075.258494830494;37056.77659340448;43174.78412607917;48795;50812.49187508078;51662.483375165764;6699.598024118569;6784.96607516979;6808.38724514796;6809.250982392032;6814.761483348059;12404.751904962031;12555.497780088694;12664.113512054437;12796.61610151697;12828.935855320664;10867.782644346911;10908.072813810597;11051.557937682403;11256.043236325004;11365.261258018203;10908.236423450282;10929.125669946226;10955.945220273848;10982.176336774934;11184.049355804847;11178.776424471302;11287.322760634388;11392.544298227978;11473.196876218584;11488.82766758516;6670.798636450057;6736.292689267752;6741.966290168518;6748.763793267212;6754.527183097136;10792.704875415;10891.618793342512;10997.61508347204;11199.720006999563;11221.158413118885 23:02:20 INFO - 2015-10-23 23:02:20,571 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1337.9930104842736;1403.6140061483088;1592.2198122919772;1632.0207875274834;1769.0889192066081;8315.293200077993;9336.673216437417;9430.339876208669;9536.094071063255;9579.425234485936;9107.180353768159;9172.312076594266;9188.127127922853;9197.402168859036;9201.401908875936;2054.4042227753935;2068.4105030066435;2326.523062772136;2329.650552417134;2347.084636991575;2348.6829278047417;2358.1039205102124;2364.7398786133513;2369.95260094798;2372.2764556810166;2315.4442933695877;2350.4006478347997;2359.9056037758555;2360.858348499087;2361.197192954395;2046.1201683276186;2081.469225347534;2313.560423519534;2346.4133966508375;2356.8821558921986;2299.379167624732;2328.3946173994714;2347.647852822073;2350.9647355289685;2352.7294361148342;9390.62437502499;9396.530173491297;9452.43285402878;9454.669086581936;9473.28950328728;5327.627066105374;5392.433794451605;5399.244105825148;5400.837974860721;5425.511703946624;3604.7656902301264;3680.7975561344115;3695.3533131701843;3699.5190625218547;3713.3316003119426;1135.5798354608764;1137.3517095255709;1137.7895089408487;1159.7970355187892;1160.1125139268465;14559.272036398137;14738.778918316233;14761.114333140045;14765.409383624643;14778.704425911528;4614.884627884263;4639.675222734376;4657.324687920301;4660.46404663468;4731.668783185144;11846.703832404086;11860.406979650983;11870.703232419259;11880.584179553674;11889;5325.600579956519;5326.6005049621435;5332.693490094952;5336.279602253724;5342.3856256531;4778.665493415428;4831.227003679394;4833.879153021203;4841.104395686809;4843.07981483517;3965.3655415134017;4058.411530328086;4076.9388459173138;4102.651274641629;4105.507339119325;1197.8981786548068;1198.2211562484456;1225.5159212111166;1227.9623717958311;1231.735176936963;958.4680502321279;991.9057689519484;1270.4156088199531;1274.3691872522975;1300.2718477652545;8801.559922003875;8802.163794439519;8819.955900220459;8837.513936733412;8888.377813552988;689.4897775645986;697.9755708550176;703.6516924122592;706.9787906362817;718.482692461427;6346.428821406003;6367.076773867763;6370.649614271259;6378.2346118466085;6387.712552935129;11880.584179553674;12131.514739410324;12361.752764944651;12372.319522426173;12442.626721198378;11999.760004799855;12140.696482588006;12166.574169904188;12275.693107672201;12331.136820422484;8666.523341216294;8738.563071846382;8764.474131552128;8771;8773.473591584525;8763.211310982042;8763.824723505622;8827.293816494794;8829.69096081634;8829.69096081634;10364.896351036394;10441.164706823587;10567;10571.207159462918;10585.364878107339;10598.2581219317;10693.51879165455;10910.781784364426;10940.179486538382;10976.670699878698;8516.233538981522;8519.74440766778;8542.487450752975;8636.050034496326;8653.740387788377;9134.086591340812;9431.538111592714;9511.857322140311;9585.370487017084;9596.376235544667;8589.184027517376;8657.307415406878;8696.347773917108;8784.78038049054;8954.641814327353;8307.08622051586;8416.3266938646;8616.827663446822;8632.482051076955;8712.607932642919;7820.960895195488;7939.166387529457;8030.8393832121865;8058.073321568095;8173.346132309282;7387.1135463744695;7387.150477694919;7392.112946446461;7400.444966627632;7464.92535074664;7291.8177045572165;7492.100947886289;7546.509476883985;7546.6981320748755;7554.924450755422 23:02:20 INFO - 2015-10-23 23:02:20,630 DEBUG : BROWSER_OUTPUT: |4;prototype.html;363.2208911884009;363.4856677800912;366.77993204077575;373.0952440332194;375.2045663194027;5985.970070149649;5990.940090599092;6000.33996260411;6008.819735407945;6024.1566180734735;5880.8235752927485;5932.851678708034;5940;5951.940480595193;5952.077427998667;4520.457545094577;4565.675953973344;4570.565796249368;4584.312353147038;4588.977055114737;4572.291294849287;4573.5197804230575;4574.130915126116;4578.839740609079;4580.770961451931;4428.269335559645;4457.576530229623;4543.750093744843;4544.681872268942;4547.408836851205;4508.188526065307;4537.727736335797;4554.134714404253;4557.270836666117;4557.814968108282;4011.197760447893;4014.3577027675724;4016.0763024504527;4018.095928416112;4040.7877636709163;5669.319681638189;5733.799317023926;5735.799247026376;5789.45000224978;5816.41835816415;5206.787115475908;5231.555317797992;5232.450592687789;5233.371995360581;5244.344456942882;6167;6171.13604095427;6211.937880621181;6212.099245609361;6216.44052035319;4260.446142001551;4297.033167537279;4348.891032786651;4352.086061926999;4384.539623339535;6419.743210271584;6443.645599492026;6458.838529036811;6525.902111468332;6530.902036469457;4471.8658440246845;4522.412086428743;4527.162474942146;4527.253003254492;4552.863414097583;4597.287420449836;4598.977005114953;4600.700954438018;4602.516735742765;4611.239145540948;5136.075506408883;5138.126518491866;5216.60875434344;5237.109691352479;5241.816536421284;6110.114033465123;6111.93041217794;6174.104754810527;6201.81394558164;6206.937930620636;1647.6457561624309;1658.5356100291938;1659.6016955930731;1665.3088968078112;1667.1830802906732;1095.1731442760665;1116.771061932302;1117.5641499815079;1118.1948996722347;1141.3380239461092;6028.156058151862;6067.575269731076;6073.544484163705;6074.75700971965;6085.36103709113;6301.4328710416285;6325.177726895567;6345.302016778151;6397.360263973565;6418.967905160444;5951.69351466519;6063;6064.514838812973;6068.241469816273;6070.2412198475195;3554.111472131967;3582.462630605378;3586.605473397924;3595.6224596417524;3601.1717305019993;6659.067730517731;6711.127553418024;6728.024436456686;6728.3271672832325;6810.216825065082;6521;6526.216853977553;6536.444402225769;6589.011648252705;6605.174353205849;6823.590584564942;6823.624700641512;6826.522143449911;6830.897536536956;6832.521723479408;6377.202849643794;6487.091807146909;6487.772927947499;6499.5775274607;6501.382368674968;6279.30927597973;6307.684615769102;6329.272133704683;6330.968345158245;6332.905006425;6791.5585486945165;6794.864102717819;6795.354441328066;6797.116374871235;6798.898016529855;4376.824927002885;4533;4535.523770004102;4547.1815073287125;4591.47198072226;6554.508411869034;6557.639329836905;6560.278369379269;6560.639164845788;6565.44193743518;6354.90467642995;6402.583832050902;6413.16628838248;6413.2945376007665;6415.0377443382;6148.108524263867;6288.371162883675;6312.526560508072;6346.904796427965;6349.238091429058;6140.078988151813;6215.06773983906;6240.843978900564;6241.31345551998;6242.469390101711;6298.464630506458;6324.083007963912;6341.175647166024;6344.968275158594;6347.333529979285;6157.722902469489;6172.2901866284155;6247.468965138014;6260.780872669617;6265.185525881606 23:02:20 INFO - 2015-10-23 23:02:20,631 DEBUG : BROWSER_OUTPUT: |5;yui.html;752.9209433009534;766.9731559395423;771.2172145272548;835.9791005224869;843.4559708987703;11440.71398215044;11710.824337634942;11724.237924534898;11811.40942952851;11818.881811181885;12272.32502212378;12501.937490312535;12515.249085054904;12518.499260029588;12529.436175372108;598.9940100599003;601.2364297342373;715.2739968931538;736.5691070723633;736.929991650795;741.232824027132;745.8172747676826;745.8545583611198;753.2730914667372;754.0498971296179;784.7175016993878;788.8540619985292;789.317240586894;790.9802254943614;794.566961006253;629.9622022678631;635.9872802543946;775.4726785785635;781.5271760584878;783.2676447521585;565.059176471175;568.6445971267957;574.0327548081495;577.4773829684143;579.1602176843594;11975.98204152648;12159;12210.877891221064;12379.566715164927;12418.81371779424;11446.313221206754;11611.303321800719;11967.94016029923;11969.845427823075;12623.810642840364;9695.61217551304;9764.707058788248;9770.755731106708;9793.118619324223;9831;3527.8236088195745;3532.5760908691122;3539.3983022886173;3568.839402226906;3581.928361432783;38259;38558.80720596379;38739.41890871639;43078;43135.137297254194;7423.703051877865;7438;7447.702091916371;7482.476226664081;7563.810904727316;10665;10736.141108711285;10775.407352595526;10782.029617334478;10793.568257269779;6695.866082678319;6758.864822703518;6903.413209877217;6974.407175390047;7047.048648432396;4386.71486353386;4428.645708343325;4433.202023635777;4488.618467430239;4500.257457519538;2772.5286701260834;2789.707080756532;2807.494650962846;2812.1422965995566;2824;476.454459643706;485.48538549138027;490.0908814149772;490.8601048701103;497.6466708636908;725.4232884856551;741.9406447484188;745.4707157917939;785.7681983814788;802.5786462107441;8942.46345219289;9190.586423610954;9229.861552076723;9310.348275620641;9427.481488518197;696.251529605676;778.4589710151504;797.784598158494;815.8490679224362;852.5992783391796;4153.813078411479;4432.711873728197;4442.511323754385;4525.977370113194;4579.7252164870215;52441.2133817993;52530.474695253324;52721.7363913178;52753.35076413899;52818.207726884124;48899;49746;49811.25283120756;50188.24717629238;50215;40642;41703.374449383286;42688.57311426846;42693.35959960541;43212.78393608075;8765.824683506167;8832.116788321116;8920.197182253629;8968.506732129796;9074.092590741137;29323.266918327212;29985.700142998292;30323.393532129674;30571.847140765043;30780.23049423782;38182;38241.80879095587;38327.616723832405;38731.22537549177;42177.78911105425;11893.616386893063;12090.153689241668;12140.696482587653;12311.50753969867;12611.74776504483;12935.741285174432;13062.738745225231;13113.868861311264;13143.737125257632;13761.105528140639;12042.337671427806;12290.832370924747;12674;12814.03894707882;12882.098253122567;11736.70658233551;11803.645890623295;11811.704707382385;12256.264624122581;12622.99016078693;11515.481803319039;12132.454039568418;12207.816882746944;12422;12643.93678031604;10047.849282260919;10129.290949633454;10365.9481702591;10443.321184123008;10525.789484210427;9526.85709714341;10446.477676116012;10537.315074520131;10556.947215263874;10597.4701264938 23:02:20 INFO - 2015-10-23 23:02:20,631 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:02:20 INFO - 2015-10-23 23:02:20,631 DEBUG : BROWSER_OUTPUT: __start_cc_report 23:02:20 INFO - 2015-10-23 23:02:20,631 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,809 23:02:20 INFO - 2015-10-23 23:02:20,631 DEBUG : BROWSER_OUTPUT: __end_cc_report 23:02:20 INFO - 2015-10-23 23:02:20,632 DEBUG : BROWSER_OUTPUT: __startTimestamp1445666540564__endTimestamp 23:02:20 INFO - 2015-10-23 23:02:20,632 DEBUG : BROWSER_OUTPUT: 23:02:20 INFO - 2015-10-23 23:02:20,632 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:02:20 INFO - 2015-10-23 23:02:20,632 DEBUG : BROWSER_OUTPUT: Number of tests: 6 23:02:20 INFO - 2015-10-23 23:02:20,632 DEBUG : BROWSER_OUTPUT: 23:02:20 INFO - 2015-10-23 23:02:20,632 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5466.96 Median:5735.68 stddev:770.33 (13.4%) stddev-sans-first:745.29 23:02:20 INFO - 2015-10-23 23:02:20,632 DEBUG : BROWSER_OUTPUT: Values: 2871.3 2942.3 2944.7 2976.4 3003.0 5653.6 5655.4 5663.5 5686.4 5724.8 5700.6 5706.9 5708.1 5708.3 5713.7 5006.5 5061.8 5064.4 5096.3 5106.9 5055.8 5070.3 5082.3 5096.0 5100.6 4969.1 5010.3 5072.1 5080.6 5098.0 4970.8 4998.2 5016.0 5105.4 5133.1 5000.2 5000.5 5012.0 5042.3 5049.0 5324.2 5426.1 5510.1 5516.6 5517.9 5795.4 5837.6 5840.4 5894.0 5916.6 5980.5 5985.7 5991.6 6024.6 6044.6 5350.1 5471.6 5479.2 5485.4 5500.3 5991.6 6051.4 6071.9 6074.3 6075.2 5784.2 5791.4 5855.9 5858.4 5877.9 5850.7 5942.5 5966.1 5975.4 5983.9 5817.0 5835.7 5883.1 5898.6 5950.0 5930.3 5933.6 5935.7 5936.2 5945.3 3541.5 3685.0 3744.3 3766.2 3804.8 3328.6 3368.7 3376.3 3408.5 3439.2 5663.3 5720.1 5735.7 5736.9 5801.2 5769.4 5921.5 5936.4 6044.4 6058.6 5596.3 5611.8 5647.3 5649.3 5654.1 4807.1 4807.5 4811.5 4818.3 4880.1 6098.4 6148.4 6151.9 6241.0 6299.0 5966.2 6024.6 6033.4 6035.3 6045.5 6241.5 6252.3 6312.7 6318.9 6319.7 5717.5 5836.1 5839.5 5856.0 5877.2 5855.9 5861.9 5883.6 5885.9 5933.6 5800.2 5844.7 5924.3 5938.4 5944.9 5694.1 5722.6 5796.9 5822.7 5843.8 5689.1 5692.0 5697.9 5717.7 5760.3 5853.7 5886.7 5890.8 5892.5 5903.4 5607.7 5631.9 5674.3 5779.1 5801.8 23:02:20 INFO - 2015-10-23 23:02:20,632 DEBUG : BROWSER_OUTPUT: 23:02:20 INFO - 2015-10-23 23:02:20,632 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:49486.17 Median:17920.69 stddev:92553.22 (516.5%) stddev-sans-first:92739.95 23:02:20 INFO - 2015-10-23 23:02:20,632 DEBUG : BROWSER_OUTPUT: Values: 555.9 592.5 598.3 603.8 607.3 28937.7 29029.9 38456.4 39092.8 39245.4 42184.6 42324.0 42357.0 42377.4 42566.8 7804.5 8563.4 8710.8 8713.3 8719.6 7770.1 10569.6 10796.3 10882.6 10882.6 10839.2 10857.7 10970.9 10977.8 10997.8 7986.6 8102.0 10677.4 10724.3 10737.5 10726.1 10833.9 10923.8 10944.9 10949.6 38509.8 38982.8 39494.4 39504.0 39554.4 3292.0 3369.9 3378.3 3462.9 3775.1 30612.5 30782.0 30801.8 30824.7 31630.7 3216.8 3235.5 3242.3 3246.9 3277.7 310061.0 310425.0 311263.0 312286.5 315706.0 49679.8 50100.5 53438.7 54632.0 55125.2 51344.5 51572.2 51629.0 51649.0 51744.7 15071.7 15149.3 15171.5 15246.4 15285.2 11325.8 11543.7 11553.1 11561.5 11612.1 16914.6 17380.2 17865.2 18006.3 18092.8 7927.0 8112.1 8143.6 8218.4 8228.5 891.8 928.7 952.8 984.9 1008.4 26010.9 26884.7 28260.0 28311.9 28750.9 1069.9 1087.3 1149.8 1157.1 1164.5 14606.9 14718.3 14964.5 15025.4 15083.0 451725.0 453173.0 454063.0 454895.0 462990.0 50916.7 51216.5 51325.0 51363.2 51422.0 1275.5 1308.0 1316.1 1322.4 1323.5 23388.3 27654.0 28087.7 28124.1 28159.7 36662.3 41670.4 42072.2 42078.0 42124.6 250901.0 251134.0 253037.0 254066.0 254358.0 26490.9 26822.3 29618.3 30084.8 30326.8 39092.8 39162.0 39865.2 39932.4 39941.4 33169.8 33993.7 34084.0 34344.5 34409.1 35194.0 35833.5 36140.3 36147.1 36154.8 36445.5 36737.6 37166.8 37213.6 37241.6 32217.0 32563.7 32919.7 32997.8 33010.0 26775.6 26890.2 26955.0 26959.7 26992.5 23:02:20 INFO - 2015-10-23 23:02:20,634 DEBUG : BROWSER_OUTPUT: 23:02:20 INFO - 2015-10-23 23:02:20,634 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:32145.14 Median:482.08 stddev:113000.31 (23440.2%) stddev-sans-first:113292.13 23:02:20 INFO - 2015-10-23 23:02:20,634 DEBUG : BROWSER_OUTPUT: Values: 379.5 384.8 389.6 389.8 392.3 14040.0 15067.5 16739.2 18550.6 18707.0 17075.3 17291.8 17319.9 17983.2 18030.5 5380.4 5430.4 5500.5 5503.9 5513.2 4267.3 4363.6 5589.3 6086.1 6267.2 6166.4 6294.2 6296.9 6316.6 6317.4 6190.9 6227.8 6234.2 6237.4 6241.3 5386.2 5484.5 5499.4 5514.7 5522.1 22365.3 22568.2 22792.4 22899.7 23037.2 2080.4 2169.6 2444.6 2526.8 2680.0 13860.0 14088.9 14122.0 14215.2 14542.6 1557.9 1574.6 1687.0 1690.5 1715.6 61789.7 63370.4 64806.0 66627.0 67811.0 6840.1 6883.8 6913.7 6946.6 6974.2 8157.2 8170.3 8184.8 8196.0 8198.0 5620.3 5671.3 5717.3 5740.2 5740.9 6207.4 6235.0 6236.3 6286.3 6303.4 3223.9 3224.5 3232.4 3235.1 3274.8 1164.8 1171.5 1183.1 1201.9 1229.8 467.3 477.0 487.1 503.0 520.6 11742.2 12034.7 12081.9 12122.1 12145.7 500.8 513.2 518.5 533.2 542.9 6468.1 6728.2 6736.6 6767.1 6805.1 683138.0 685223.0 691553.0 692351.0 701491.0 80563.6 80833.6 82187.2 82727.6 85548.1 526.4 533.8 569.4 572.7 577.1 10895.7 11029.2 11126.6 11186.6 11304.1 34016.5 34895.5 34903.7 34989.0 37075.3 37056.8 43174.8 48795.0 50812.5 51662.5 6699.6 6785.0 6808.4 6809.3 6814.8 12404.8 12555.5 12664.1 12796.6 12828.9 10867.8 10908.1 11051.6 11256.0 11365.3 10908.2 10929.1 10955.9 10982.2 11184.0 11178.8 11287.3 11392.5 11473.2 11488.8 6670.8 6736.3 6742.0 6748.8 6754.5 10792.7 10891.6 10997.6 11199.7 11221.2 23:02:20 INFO - 2015-10-23 23:02:20,635 DEBUG : BROWSER_OUTPUT: 23:02:20 INFO - 2015-10-23 23:02:20,635 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:6565.32 Median:4837.49 stddev:3796.90 (78.5%) stddev-sans-first:3787.23 23:02:20 INFO - 2015-10-23 23:02:20,637 DEBUG : BROWSER_OUTPUT: Values: 1338.0 1403.6 1592.2 1632.0 1769.1 8315.3 9336.7 9430.3 9536.1 9579.4 9107.2 9172.3 9188.1 9197.4 9201.4 2054.4 2068.4 2326.5 2329.7 2347.1 2348.7 2358.1 2364.7 2370.0 2372.3 2315.4 2350.4 2359.9 2360.9 2361.2 2046.1 2081.5 2313.6 2346.4 2356.9 2299.4 2328.4 2347.6 2351.0 2352.7 9390.6 9396.5 9452.4 9454.7 9473.3 5327.6 5392.4 5399.2 5400.8 5425.5 3604.8 3680.8 3695.4 3699.5 3713.3 1135.6 1137.4 1137.8 1159.8 1160.1 14559.3 14738.8 14761.1 14765.4 14778.7 4614.9 4639.7 4657.3 4660.5 4731.7 11846.7 11860.4 11870.7 11880.6 11889.0 5325.6 5326.6 5332.7 5336.3 5342.4 4778.7 4831.2 4833.9 4841.1 4843.1 3965.4 4058.4 4076.9 4102.7 4105.5 1197.9 1198.2 1225.5 1228.0 1231.7 958.5 991.9 1270.4 1274.4 1300.3 8801.6 8802.2 8820.0 8837.5 8888.4 689.5 698.0 703.7 707.0 718.5 6346.4 6367.1 6370.6 6378.2 6387.7 11880.6 12131.5 12361.8 12372.3 12442.6 11999.8 12140.7 12166.6 12275.7 12331.1 8666.5 8738.6 8764.5 8771.0 8773.5 8763.2 8763.8 8827.3 8829.7 8829.7 10364.9 10441.2 10567.0 10571.2 10585.4 10598.3 10693.5 10910.8 10940.2 10976.7 8516.2 8519.7 8542.5 8636.1 8653.7 9134.1 9431.5 9511.9 9585.4 9596.4 8589.2 8657.3 8696.3 8784.8 8954.6 8307.1 8416.3 8616.8 8632.5 8712.6 7821.0 7939.2 8030.8 8058.1 8173.3 7387.1 7387.2 7392.1 7400.4 7464.9 7291.8 7492.1 7546.5 7546.7 7554.9 23:02:20 INFO - 2015-10-23 23:02:20,637 DEBUG : BROWSER_OUTPUT: 23:02:20 INFO - 2015-10-23 23:02:20,638 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5278.38 Median:6026.16 stddev:1567.82 (26.0%) stddev-sans-first:1528.20 23:02:20 INFO - 2015-10-23 23:02:20,638 DEBUG : BROWSER_OUTPUT: Values: 363.2 363.5 366.8 373.1 375.2 5986.0 5990.9 6000.3 6008.8 6024.2 5880.8 5932.9 5940.0 5951.9 5952.1 4520.5 4565.7 4570.6 4584.3 4589.0 4572.3 4573.5 4574.1 4578.8 4580.8 4428.3 4457.6 4543.8 4544.7 4547.4 4508.2 4537.7 4554.1 4557.3 4557.8 4011.2 4014.4 4016.1 4018.1 4040.8 5669.3 5733.8 5735.8 5789.5 5816.4 5206.8 5231.6 5232.5 5233.4 5244.3 6167.0 6171.1 6211.9 6212.1 6216.4 4260.4 4297.0 4348.9 4352.1 4384.5 6419.7 6443.6 6458.8 6525.9 6530.9 4471.9 4522.4 4527.2 4527.3 4552.9 4597.3 4599.0 4600.7 4602.5 4611.2 5136.1 5138.1 5216.6 5237.1 5241.8 6110.1 6111.9 6174.1 6201.8 6206.9 1647.6 1658.5 1659.6 1665.3 1667.2 1095.2 1116.8 1117.6 1118.2 1141.3 6028.2 6067.6 6073.5 6074.8 6085.4 6301.4 6325.2 6345.3 6397.4 6419.0 5951.7 6063.0 6064.5 6068.2 6070.2 3554.1 3582.5 3586.6 3595.6 3601.2 6659.1 6711.1 6728.0 6728.3 6810.2 6521.0 6526.2 6536.4 6589.0 6605.2 6823.6 6823.6 6826.5 6830.9 6832.5 6377.2 6487.1 6487.8 6499.6 6501.4 6279.3 6307.7 6329.3 6331.0 6332.9 6791.6 6794.9 6795.4 6797.1 6798.9 4376.8 4533.0 4535.5 4547.2 4591.5 6554.5 6557.6 6560.3 6560.6 6565.4 6354.9 6402.6 6413.2 6413.3 6415.0 6148.1 6288.4 6312.5 6346.9 6349.2 6140.1 6215.1 6240.8 6241.3 6242.5 6298.5 6324.1 6341.2 6345.0 6347.3 6157.7 6172.3 6247.5 6260.8 6265.2 23:02:20 INFO - 2015-10-23 23:02:20,638 DEBUG : BROWSER_OUTPUT: 23:02:20 INFO - 2015-10-23 23:02:20,638 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12777.89 Median:4407.68 stddev:14325.77 (325.0%) stddev-sans-first:14337.49 23:02:20 INFO - 2015-10-23 23:02:20,638 DEBUG : BROWSER_OUTPUT: Values: 752.9 767.0 771.2 836.0 843.5 11440.7 11710.8 11724.2 11811.4 11818.9 12272.3 12501.9 12515.2 12518.5 12529.4 599.0 601.2 715.3 736.6 736.9 741.2 745.8 745.9 753.3 754.0 784.7 788.9 789.3 791.0 794.6 630.0 636.0 775.5 781.5 783.3 565.1 568.6 574.0 577.5 579.2 11976.0 12159.0 12210.9 12379.6 12418.8 11446.3 11611.3 11967.9 11969.8 12623.8 9695.6 9764.7 9770.8 9793.1 9831.0 3527.8 3532.6 3539.4 3568.8 3581.9 38259.0 38558.8 38739.4 43078.0 43135.1 7423.7 7438.0 7447.7 7482.5 7563.8 10665.0 10736.1 10775.4 10782.0 10793.6 6695.9 6758.9 6903.4 6974.4 7047.0 4386.7 4428.6 4433.2 4488.6 4500.3 2772.5 2789.7 2807.5 2812.1 2824.0 476.5 485.5 490.1 490.9 497.6 725.4 741.9 745.5 785.8 802.6 8942.5 9190.6 9229.9 9310.3 9427.5 696.3 778.5 797.8 815.8 852.6 4153.8 4432.7 4442.5 4526.0 4579.7 52441.2 52530.5 52721.7 52753.4 52818.2 48899.0 49746.0 49811.3 50188.2 50215.0 40642.0 41703.4 42688.6 42693.4 43212.8 8765.8 8832.1 8920.2 8968.5 9074.1 29323.3 29985.7 30323.4 30571.8 30780.2 38182.0 38241.8 38327.6 38731.2 42177.8 11893.6 12090.2 12140.7 12311.5 12611.7 12935.7 13062.7 13113.9 13143.7 13761.1 12042.3 12290.8 12674.0 12814.0 12882.1 11736.7 11803.6 11811.7 12256.3 12623.0 11515.5 12132.5 12207.8 12422.0 12643.9 10047.8 10129.3 10365.9 10443.3 10525.8 9526.9 10446.5 10537.3 10556.9 10597.5 23:02:20 INFO - 2015-10-23 23:02:20,640 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:02:20 INFO - 2015-10-23 23:02:20,640 DEBUG : BROWSER_OUTPUT: 23:02:21 INFO - 2015-10-23 23:02:21,161 INFO : Browser exited with error code: 0 23:02:21 INFO - 2015-10-23 23:02:21,930 INFO : Completed test dromaeo_css (00:18:40) 23:02:21 INFO - 2015-10-23 23:02:21,930 INFO : Starting test kraken 23:02:21 INFO - 2015-10-23 23:02:21,930 DEBUG : operating with platform_type : w8_ 23:02:21 INFO - 2015-10-23 23:02:21,930 INFO : Initialising browser for kraken test... 23:02:21 INFO - 2015-10-23 23:02:21,951 DEBUG : command line: C:\slave\test-pgo\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpmgpijk\profile http://localhost:49276/getInfo.html 23:02:27 INFO - 2015-10-23 23:02:27,211 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 23:02:27 INFO - 2015-10-23 23:02:27,211 DEBUG : BROWSER_OUTPUT: colorDepth:24 23:02:27 INFO - 2015-10-23 23:02:27,211 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674 23:02:27 INFO - 2015-10-23 23:02:27,211 DEBUG : BROWSER_OUTPUT: __metrics 23:02:27 INFO - 2015-10-23 23:02:27,453 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:02:28 INFO - 2015-10-23 23:02:28,828 INFO : Browser initialized. 23:02:28 INFO - 2015-10-23 23:02:28,828 INFO : Running cycle 1/1 for kraken test... 23:02:28 INFO - 2015-10-23 23:02:28,828 DEBUG : command line: C:\slave\test-pgo\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpmgpijk\profile -tp file:\C:\slave\test-pgo\build\tests\talos\talos\tests\kraken\kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 23:02:40 INFO - 2015-10-23 23:02:40,190 DEBUG : BROWSER_OUTPUT: RSS: Main: 188248064 23:02:40 INFO - 2015-10-23 23:02:40,190 DEBUG : BROWSER_OUTPUT: 23:02:42 INFO - 2015-10-23 23:02:42,766 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 23:02:43 INFO - 2015-10-23 23:02:43,351 DEBUG : BROWSER_OUTPUT: RSS: Main: 225648640 23:02:43 INFO - 2015-10-23 23:02:43,351 DEBUG : BROWSER_OUTPUT: 23:02:45 INFO - 2015-10-23 23:02:45,826 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 23:02:46 INFO - 2015-10-23 23:02:46,400 DEBUG : BROWSER_OUTPUT: RSS: Main: 227336192 23:02:46 INFO - 2015-10-23 23:02:46,400 DEBUG : BROWSER_OUTPUT: 23:02:48 INFO - 2015-10-23 23:02:48,977 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 23:02:49 INFO - 2015-10-23 23:02:49,551 DEBUG : BROWSER_OUTPUT: RSS: Main: 212418560 23:02:49 INFO - 2015-10-23 23:02:49,551 DEBUG : BROWSER_OUTPUT: 23:02:51 INFO - 2015-10-23 23:02:51,444 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 23:02:52 INFO - 2015-10-23 23:02:52,016 DEBUG : BROWSER_OUTPUT: RSS: Main: 213127168 23:02:52 INFO - 2015-10-23 23:02:52,016 DEBUG : BROWSER_OUTPUT: 23:02:54 INFO - 2015-10-23 23:02:54,088 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:02:54 INFO - 2015-10-23 23:02:54,654 DEBUG : BROWSER_OUTPUT: RSS: Main: 208650240 23:02:54 INFO - 2015-10-23 23:02:54,654 DEBUG : BROWSER_OUTPUT: 23:02:57 INFO - 2015-10-23 23:02:57,615 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 23:02:58 INFO - 2015-10-23 23:02:58,196 DEBUG : BROWSER_OUTPUT: RSS: Main: 204529664 23:02:58 INFO - 2015-10-23 23:02:58,196 DEBUG : BROWSER_OUTPUT: 23:03:01 INFO - 2015-10-23 23:03:01,496 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 23:03:02 INFO - 2015-10-23 23:03:02,076 DEBUG : BROWSER_OUTPUT: RSS: Main: 201834496 23:03:02 INFO - 2015-10-23 23:03:02,076 DEBUG : BROWSER_OUTPUT: 23:03:04 INFO - 2015-10-23 23:03:04,874 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 23:03:05 INFO - 2015-10-23 23:03:05,450 DEBUG : BROWSER_OUTPUT: RSS: Main: 199757824 23:03:05 INFO - 2015-10-23 23:03:05,450 DEBUG : BROWSER_OUTPUT: 23:03:07 INFO - 2015-10-23 23:03:07,158 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:03:07 INFO - 2015-10-23 23:03:07,723 DEBUG : BROWSER_OUTPUT: RSS: Main: 229912576 23:03:07 INFO - 2015-10-23 23:03:07,723 DEBUG : BROWSER_OUTPUT: 23:03:09 INFO - 2015-10-23 23:03:09,490 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:03:10 INFO - 2015-10-23 23:03:10,072 DEBUG : BROWSER_OUTPUT: RSS: Main: 233906176 23:03:10 INFO - 2015-10-23 23:03:10,072 DEBUG : BROWSER_OUTPUT: 23:03:12 INFO - 2015-10-23 23:03:12,187 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:03:12 INFO - 2015-10-23 23:03:12,760 DEBUG : BROWSER_OUTPUT: RSS: Main: 220573696 23:03:12 INFO - 2015-10-23 23:03:12,760 DEBUG : BROWSER_OUTPUT: 23:03:15 INFO - 2015-10-23 23:03:15,142 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:03:15 INFO - 2015-10-23 23:03:15,726 DEBUG : BROWSER_OUTPUT: RSS: Main: 224686080 23:03:15 INFO - 2015-10-23 23:03:15,726 DEBUG : BROWSER_OUTPUT: 23:03:18 INFO - 2015-10-23 23:03:18,342 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:03:18 INFO - 2015-10-23 23:03:18,911 DEBUG : BROWSER_OUTPUT: RSS: Main: 224591872 23:03:18 INFO - 2015-10-23 23:03:18,911 DEBUG : BROWSER_OUTPUT: 23:03:20 INFO - 2015-10-23 23:03:20,586 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 23:03:20 INFO - 2015-10-23 23:03:20,838 DEBUG : BROWSER_OUTPUT: RSS: Main: 280150016 23:03:20 INFO - 2015-10-23 23:03:20,838 DEBUG : BROWSER_OUTPUT: 23:03:20 INFO - 2015-10-23 23:03:20,838 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:03:20 INFO - 2015-10-23 23:03:20,838 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:03:20 INFO - 2015-10-23 23:03:20,838 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:03:20 INFO - 2015-10-23 23:03:20,838 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:03:20 INFO - 2015-10-23 23:03:20,838 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;111;104;108;110;109;100;110;110;109 23:03:20 INFO - 2015-10-23 23:03:20,838 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;130;122;137;150;119;126;129;124;148;122 23:03:20 INFO - 2015-10-23 23:03:20,838 DEBUG : BROWSER_OUTPUT: |2;audio-dft;140;140;140;140;140;139;140;142;140;140 23:03:20 INFO - 2015-10-23 23:03:20,838 DEBUG : BROWSER_OUTPUT: |3;audio-fft;68;68;68;94;65;69;69;70;98;66 23:03:20 INFO - 2015-10-23 23:03:20,838 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;87;89;106;86;87;86;116;86;86;111 23:03:20 INFO - 2015-10-23 23:03:20,838 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;112;110;110;110;111;110;110;111;110;110 23:03:20 INFO - 2015-10-23 23:03:20,839 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;132;133;133;133;131;132;133;132;132;134 23:03:20 INFO - 2015-10-23 23:03:20,839 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;97;96;96;98;96;97;97;98 23:03:20 INFO - 2015-10-23 23:03:20,839 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;73;74;72;72;72;72;84;72;70 23:03:20 INFO - 2015-10-23 23:03:20,839 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;63;64;63;64;64;64;64;64;64 23:03:20 INFO - 2015-10-23 23:03:20,839 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;86;86;86;88;86;86;86;86;87 23:03:20 INFO - 2015-10-23 23:03:20,839 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;117;118;121;116;120;113;119;113;123;113 23:03:20 INFO - 2015-10-23 23:03:20,839 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;152;154;155;152;154;154;153;153;155;147 23:03:20 INFO - 2015-10-23 23:03:20,839 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;68;68;68;69;68;68;68;67;68 23:03:20 INFO - 2015-10-23 23:03:20,839 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:03:20 INFO - 2015-10-23 23:03:20,839 DEBUG : BROWSER_OUTPUT: __start_cc_report 23:03:20 INFO - 2015-10-23 23:03:20,839 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,938 23:03:20 INFO - 2015-10-23 23:03:20,839 DEBUG : BROWSER_OUTPUT: __end_cc_report 23:03:20 INFO - 2015-10-23 23:03:20,839 DEBUG : BROWSER_OUTPUT: __startTimestamp1445666600839__endTimestamp 23:03:20 INFO - 2015-10-23 23:03:20,839 DEBUG : BROWSER_OUTPUT: 23:03:20 INFO - 2015-10-23 23:03:20,842 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:03:20 INFO - 2015-10-23 23:03:20,842 DEBUG : BROWSER_OUTPUT: Number of tests: 14 23:03:20 INFO - 2015-10-23 23:03:20,842 DEBUG : BROWSER_OUTPUT: 23:03:20 INFO - 2015-10-23 23:03:20,842 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.10 Median:110.00 stddev:3.45 (3.1%) stddev-sans-first:3.59 23:03:20 INFO - 2015-10-23 23:03:20,842 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 104.0 108.0 110.0 109.0 100.0 110.0 110.0 109.0 23:03:20 INFO - 2015-10-23 23:03:20,842 DEBUG : BROWSER_OUTPUT: 23:03:20 INFO - 2015-10-23 23:03:20,842 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:130.70 Median:129.50 stddev:10.90 (8.4%) stddev-sans-first:11.56 23:03:20 INFO - 2015-10-23 23:03:20,842 DEBUG : BROWSER_OUTPUT: Values: 130.0 122.0 137.0 150.0 119.0 126.0 129.0 124.0 148.0 122.0 23:03:20 INFO - 2015-10-23 23:03:20,842 DEBUG : BROWSER_OUTPUT: 23:03:20 INFO - 2015-10-23 23:03:20,842 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:140.10 Median:140.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 23:03:20 INFO - 2015-10-23 23:03:20,842 DEBUG : BROWSER_OUTPUT: Values: 140.0 140.0 140.0 140.0 140.0 139.0 140.0 142.0 140.0 140.0 23:03:20 INFO - 2015-10-23 23:03:20,842 DEBUG : BROWSER_OUTPUT: 23:03:20 INFO - 2015-10-23 23:03:20,842 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:73.50 Median:69.00 stddev:11.98 (17.4%) stddev-sans-first:12.54 23:03:20 INFO - 2015-10-23 23:03:20,842 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 94.0 65.0 69.0 69.0 70.0 98.0 66.0 23:03:20 INFO - 2015-10-23 23:03:20,844 DEBUG : BROWSER_OUTPUT: 23:03:20 INFO - 2015-10-23 23:03:20,844 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:94.00 Median:86.00 stddev:12.00 (14.0%) stddev-sans-first:12.46 23:03:20 INFO - 2015-10-23 23:03:20,844 DEBUG : BROWSER_OUTPUT: Values: 87.0 89.0 106.0 86.0 87.0 86.0 116.0 86.0 86.0 111.0 23:03:20 INFO - 2015-10-23 23:03:20,845 DEBUG : BROWSER_OUTPUT: 23:03:20 INFO - 2015-10-23 23:03:20,845 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.40 Median:110.00 stddev:0.70 (0.6%) stddev-sans-first:0.44 23:03:20 INFO - 2015-10-23 23:03:20,845 DEBUG : BROWSER_OUTPUT: Values: 112.0 110.0 110.0 110.0 111.0 110.0 110.0 111.0 110.0 110.0 23:03:20 INFO - 2015-10-23 23:03:20,845 DEBUG : BROWSER_OUTPUT: 23:03:20 INFO - 2015-10-23 23:03:20,845 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:132.50 Median:133.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 23:03:20 INFO - 2015-10-23 23:03:20,845 DEBUG : BROWSER_OUTPUT: Values: 132.0 133.0 133.0 133.0 131.0 132.0 133.0 132.0 132.0 134.0 23:03:20 INFO - 2015-10-23 23:03:20,846 DEBUG : BROWSER_OUTPUT: 23:03:20 INFO - 2015-10-23 23:03:20,846 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.80 Median:97.00 stddev:0.79 (0.8%) stddev-sans-first:0.78 23:03:20 INFO - 2015-10-23 23:03:20,846 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 97.0 96.0 96.0 98.0 96.0 97.0 97.0 98.0 23:03:20 INFO - 2015-10-23 23:03:20,846 DEBUG : BROWSER_OUTPUT: 23:03:20 INFO - 2015-10-23 23:03:20,846 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.40 Median:72.50 stddev:3.86 (5.3%) stddev-sans-first:4.10 23:03:20 INFO - 2015-10-23 23:03:20,848 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 74.0 72.0 72.0 72.0 72.0 84.0 72.0 70.0 23:03:20 INFO - 2015-10-23 23:03:20,848 DEBUG : BROWSER_OUTPUT: 23:03:20 INFO - 2015-10-23 23:03:20,848 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.80 Median:64.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 23:03:20 INFO - 2015-10-23 23:03:20,848 DEBUG : BROWSER_OUTPUT: Values: 64.0 63.0 64.0 63.0 64.0 64.0 64.0 64.0 64.0 64.0 23:03:20 INFO - 2015-10-23 23:03:20,848 DEBUG : BROWSER_OUTPUT: 23:03:20 INFO - 2015-10-23 23:03:20,848 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:86.00 stddev:0.79 (0.9%) stddev-sans-first:0.71 23:03:20 INFO - 2015-10-23 23:03:20,848 DEBUG : BROWSER_OUTPUT: Values: 85.0 86.0 86.0 86.0 88.0 86.0 86.0 86.0 86.0 87.0 23:03:20 INFO - 2015-10-23 23:03:20,849 DEBUG : BROWSER_OUTPUT: 23:03:20 INFO - 2015-10-23 23:03:20,849 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:117.30 Median:118.50 stddev:3.56 (3.0%) stddev-sans-first:3.77 23:03:20 INFO - 2015-10-23 23:03:20,849 DEBUG : BROWSER_OUTPUT: Values: 117.0 118.0 121.0 116.0 120.0 113.0 119.0 113.0 123.0 113.0 23:03:20 INFO - 2015-10-23 23:03:20,849 DEBUG : BROWSER_OUTPUT: 23:03:20 INFO - 2015-10-23 23:03:20,851 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.90 Median:154.00 stddev:2.33 (1.5%) stddev-sans-first:2.45 23:03:20 INFO - 2015-10-23 23:03:20,851 DEBUG : BROWSER_OUTPUT: Values: 152.0 154.0 155.0 152.0 154.0 154.0 153.0 153.0 155.0 147.0 23:03:20 INFO - 2015-10-23 23:03:20,851 DEBUG : BROWSER_OUTPUT: 23:03:20 INFO - 2015-10-23 23:03:20,851 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 23:03:20 INFO - 2015-10-23 23:03:20,851 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 68.0 69.0 68.0 68.0 68.0 67.0 68.0 23:03:20 INFO - 2015-10-23 23:03:20,851 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:03:20 INFO - 2015-10-23 23:03:20,851 DEBUG : BROWSER_OUTPUT: 23:03:21 INFO - 2015-10-23 23:03:21,582 INFO : Browser exited with error code: 0 23:03:22 INFO - 2015-10-23 23:03:22,490 INFO : Completed test kraken (00:01:00) 23:03:22 INFO - 2015-10-23 23:03:22,490 INFO : Starting test v8_7 23:03:22 INFO - 2015-10-23 23:03:22,490 DEBUG : operating with platform_type : w8_ 23:03:22 INFO - 2015-10-23 23:03:22,490 INFO : Initialising browser for v8_7 test... 23:03:22 INFO - 2015-10-23 23:03:22,510 DEBUG : command line: C:\slave\test-pgo\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpivemim\profile http://localhost:49276/getInfo.html 23:03:28 INFO - 2015-10-23 23:03:28,049 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 23:03:28 INFO - 2015-10-23 23:03:28,049 DEBUG : BROWSER_OUTPUT: colorDepth:24 23:03:28 INFO - 2015-10-23 23:03:28,049 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674 23:03:28 INFO - 2015-10-23 23:03:28,049 DEBUG : BROWSER_OUTPUT: __metrics 23:03:28 INFO - 2015-10-23 23:03:28,207 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:03:29 INFO - 2015-10-23 23:03:29,092 DEBUG : BROWSER_OUTPUT: console.error: 23:03:29 INFO - 2015-10-23 23:03:29,096 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] 23:03:29 INFO - 2015-10-23 23:03:29,096 DEBUG : BROWSER_OUTPUT: Stack: 23:03:29 INFO - 2015-10-23 23:03:29,096 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<._executeStatement@resource://gre/modules/Sqlite.jsm:758:19 23:03:29 INFO - 2015-10-23 23:03:29,096 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached/<@resource://gre/modules/Sqlite.jsm:493:9 23:03:29 INFO - 2015-10-23 23:03:29,096 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached@resource://gre/modules/Sqlite.jsm:491:1 23:03:29 INFO - 2015-10-23 23:03:29,096 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeBeforeShutdown/loggedDb<.executeCached.value<@resource://gre/modules/Sqlite.jsm:368:51 23:03:29 INFO - 2015-10-23 23:03:29,096 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 23:03:29 INFO - 2015-10-23 23:03:29,096 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 23:03:29 INFO - 2015-10-23 23:03:29,096 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 23:03:29 INFO - 2015-10-23 23:03:29,096 DEBUG : BROWSER_OUTPUT: transaction@resource://gre/modules/Bookmarks.jsm:783:15 23:03:29 INFO - 2015-10-23 23:03:29,096 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 23:03:29 INFO - 2015-10-23 23:03:29,098 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 23:03:29 INFO - 2015-10-23 23:03:29,098 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 23:03:29 INFO - 2015-10-23 23:03:29,098 DEBUG : BROWSER_OUTPUT: Task_spawn@resource://gre/modules/Task.jsm:164:12 23:03:29 INFO - 2015-10-23 23:03:29,098 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promisedromaeo_css: 6937.33 23:04:05 INFO - RETURN: kraken: 1447.70 23:04:05 INFO - RETURN: v8_7: 19982.39 23:04:05 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,31]]", "result": "19982.39"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,31]]", "result": "1447.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,31]]", "result": "6937.33"}}} 23:04:05 INFO - Return code: 0 23:04:05 INFO - # TBPL SUCCESS # 23:04:05 INFO - Running post-action listener: _resource_record_post_action 23:04:05 INFO - Running post-run listener: _resource_record_post_run 23:04:06 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 159822848; Write bytes: 391856128; Read time: 1405370; Write time: 5680440 23:04:06 INFO - install - Wall time: 2s; CPU: 13.0%; Read bytes: 0; Write bytes: 912896; Read time: 0; Write time: 3760 23:04:06 INFO - run-tests - Wall time: 1227s; CPU: 13.0%; Read bytes: 159822848; Write bytes: 354547712; Read time: 1405370; Write time: 5538980 23:04:06 INFO - Running post-run listener: _upload_blobber_files 23:04:06 INFO - Blob upload gear active. 23:04:06 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 23:04:06 INFO - Copying logs to upload dir... 23:04:06 INFO - mkdir: C:\slave\test-pgo\build\upload\logs program finished with exit code 0 elapsedTime=1467.920000 ========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 24 mins, 35 secs) (at 2015-10-23 23:04:14.222773) ========= ========= Started set props: build_url (results: 0, elapsed: 3 secs) (at 2015-10-23 23:04:14.230487) ========= '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-005\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-005 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-005 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-005\AppData\Local LOGONSERVER=\\T-W864-IX-005 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-005 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-005 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-005 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False build_url:https://queue.taskcluster.net/v1/task/YCOqGKfKRFWQDA1J84xKgA/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/YCOqGKfKRFWQDA1J84xKgA/artifacts/public/build/firefox-44.0a1.en-US.win64.zip' ========= Finished set props: build_url (results: 0, elapsed: 3 secs) (at 2015-10-23 23:04:17.425429) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-23 23:04:17.425718) ========= '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-005\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-005 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-005 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-005\AppData\Local LOGONSERVER=\\T-W864-IX-005 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-005 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-005 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-005 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=0.100000 ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-23 23:04:18.167834) ========= ========= Started reboot slave lost (results: 0, elapsed: 28 secs) (at 2015-10-23 23:04:18.168258) ========= ========= Finished reboot slave lost (results: 0, elapsed: 28 secs) (at 2015-10-23 23:04:46.453740) =========