builder: b2g-inbound_win8_64_test-dromaeojs-pgo slave: t-w864-ix-018 starttime: 1445968921.83 results: success (0) buildid: 20151027053027 builduid: e6d4a91fb0204b35b17c4495983f6e48 revision: 47e4f94c33259fbcb8e5962360ac68030fc15bce ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-27 11:02:01.830406) ========= master: http://buildbot-master109.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-27 11:02:01.831577) ========= ========= Started set props: basedir (results: 0, elapsed: 2 secs) (at 2015-10-27 11:02:01.831886) ========= '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-018\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-018 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-018 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-018\AppData\Local LOGONSERVER=\\T-W864-IX-018 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-018 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-018 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-018 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False C:\slave\test-pgo program finished with exit code 0 elapsedTime=0.700000 basedir: 'C:\\slave\\test-pgo' ========= Finished set props: basedir (results: 0, elapsed: 2 secs) (at 2015-10-27 11:02:03.980594) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 46 secs) (at 2015-10-27 11:02:03.980889) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 46 secs) (at 2015-10-27 11:02:50.287941) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 2 mins, 20 secs) (at 2015-10-27 11:02:50.288220) ========= '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-018\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-018 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-018 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-018\AppData\Local LOGONSERVER=\\T-W864-IX-018 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-018 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-018 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-018 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: 2 mins, 20 secs) (at 2015-10-27 11:05:11.086430) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-27 11:05:11.086729) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-27 11:05:11.103389) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-10-27 11:05:11.103718) ========= '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-018\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-018 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-018 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-018\AppData\Local LOGONSERVER=\\T-W864-IX-018 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-018 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-018 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-018 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False --11:05:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py => `archiver_client.py' Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12,141 (12K) [text/x-python] 0K .......... . 100% 14.48 MB/s 11:05:12 (14.48 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.467000 ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-10-27 11:05:12.755709) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 2 mins, 28 secs) (at 2015-10-27 11:05:12.756006) ========= '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-018\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-018 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-018 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-018\AppData\Local LOGONSERVER=\\T-W864-IX-018 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-018 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-018 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-018 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=2.402000 ========= Finished 'rm -rf ...' (results: 0, elapsed: 2 mins, 28 secs) (at 2015-10-27 11:07:41.145887) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2015-10-27 11:07:41.146208) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 47e4f94c33259fbcb8e5962360ac68030fc15bce --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 47e4f94c33259fbcb8e5962360ac68030fc15bce --destination scripts --debug'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-018\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-018 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-018 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-018\AppData\Local LOGONSERVER=\\T-W864-IX-018 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-018 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-018 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-018 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 2015-10-27 11:07:43,582 truncating revision to first 12 chars 2015-10-27 11:07:43,582 Setting DEBUG logging. 2015-10-27 11:07:43,582 attempt 1/10 2015-10-27 11:07:43,582 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/47e4f94c3325?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-10-27 11:07:43,970 unpacking tar archive at: b2g-inbound-47e4f94c3325/testing/mozharness/ program finished with exit code 0 elapsedTime=0.984000 ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2015-10-27 11:07:45.682918) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 1 mins, 14 secs) (at 2015-10-27 11:07:45.683197) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 1 mins, 14 secs) (at 2015-10-27 11:09:00.218198) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-27 11:09:00.218517) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-27 11:09:00.218970) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 16 secs) (at 2015-10-27 11:09:00.219262) ========= '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-018\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-018 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-018 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-018\AppData\Local LOGONSERVER=\\T-W864-IX-018 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-018 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-018 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-018 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 11:09:10 INFO - MultiFileLogger online at 20151027 11:09:10 in C:\slave\test-pgo 11:09:10 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 11:09:10 INFO - Dumping config to C:\slave\test-pgo\logs\localconfig.json. 11:09:10 INFO - {'append_to_log': False, 11:09:10 INFO - 'base_work_dir': 'C:\\slave\\test-pgo', 11:09:10 INFO - 'blob_upload_branch': 'B2G-Inbound', 11:09:10 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test-pgo\\oauth.txt', 11:09:10 INFO - 'branch': 'B2G-Inbound', 11:09:10 INFO - 'buildbot_json_path': 'buildprops.json', 11:09:10 INFO - 'config_files': ('talos/windows_config.py',), 11:09:10 INFO - 'default_actions': ('clobber', 11:09:10 INFO - 'read-buildbot-config', 11:09:10 INFO - 'download-and-extract', 11:09:10 INFO - 'populate-webroot', 11:09:10 INFO - 'create-virtualenv', 11:09:10 INFO - 'install', 11:09:10 INFO - 'run-tests'), 11:09:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:09:10 INFO - 'download_minidump_stackwalk': True, 11:09:10 INFO - 'download_symbols': 'ondemand', 11:09:10 INFO - 'exes': {'easy_install': ('C:\\slave\\test-pgo\\build/venv/scripts/python', 11:09:10 INFO - 'C:\\slave\\test-pgo\\build/venv/scripts/easy_install-2.7-script.py'), 11:09:10 INFO - 'hg': 'c:/mozilla-build/hg/hg', 11:09:10 INFO - 'mozinstall': ('C:\\slave\\test-pgo\\build/venv/scripts/python', 11:09:10 INFO - 'C:\\slave\\test-pgo\\build/venv/scripts/mozinstall-script.py'), 11:09:10 INFO - 'python': 'c:/mozilla-build/python27/python.exe', 11:09:10 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe', 11:09:10 INFO - 'C:/mozilla-build/tooltool.py'), 11:09:10 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe', 11:09:10 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 11:09:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:09:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:09:10 INFO - 'installer_path': 'installer.exe', 11:09:10 INFO - 'log_level': 'info', 11:09:10 INFO - 'log_name': 'talos', 11:09:10 INFO - 'log_to_console': True, 11:09:10 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe', 11:09:10 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe', 11:09:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest', 11:09:10 INFO - 'opt_config_files': (), 11:09:10 INFO - 'pip_index': False, 11:09:10 INFO - 'sps_profile': False, 11:09:10 INFO - 'sps_profile_interval': 0, 11:09:10 INFO - 'suite': 'dromaeojs', 11:09:10 INFO - 'system_bits': '64', 11:09:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:09:10 INFO - 'title': 'T-W864-IX-018', 11:09:10 INFO - 'use_talos_json': True, 11:09:10 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'), 11:09:10 INFO - 'virtualenv_path': 'C:\\slave\\test-pgo\\build/venv', 11:09:10 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll', 11:09:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:09:10 INFO - 'work_dir': 'build'} 11:09:10 INFO - ##### 11:09:10 INFO - ##### Running clobber step. 11:09:10 INFO - ##### 11:09:10 INFO - Running pre-action listener: _resource_record_pre_action 11:09:10 INFO - Running main action method: clobber 11:09:10 INFO - rmtree: C:\slave\test-pgo\build 11:09:10 INFO - Using _rmtree_windows ... 11:09:10 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test-pgo\\build',), kwargs: {}, attempt #1 11:10:05 INFO - Running post-action listener: _resource_record_post_action 11:10:05 INFO - ##### 11:10:05 INFO - ##### Running read-buildbot-config step. 11:10:05 INFO - ##### 11:10:05 INFO - Running pre-action listener: _resource_record_pre_action 11:10:05 INFO - Running main action method: read_buildbot_config 11:10:05 INFO - Using buildbot properties: 11:10:05 INFO - { 11:10:05 INFO - "properties": { 11:10:05 INFO - "buildnumber": 297, 11:10:05 INFO - "product": "firefox", 11:10:05 INFO - "script_repo_revision": "production", 11:10:05 INFO - "builddir": "b2g-inbound_win8_64_test-dromaeojs", 11:10:05 INFO - "repository": "", 11:10:05 INFO - "buildername": "Windows 8 64-bit b2g-inbound pgo talos dromaeojs", 11:10:05 INFO - "buildid": "20151027053027", 11:10:05 INFO - "slavename": "t-w864-ix-018", 11:10:05 INFO - "pgo_build": "True", 11:10:05 INFO - "basedir": "C:\\slave\\test-pgo", 11:10:05 INFO - "project": "", 11:10:05 INFO - "platform": "win8_64", 11:10:05 INFO - "master": "http://buildbot-master109.bb.releng.scl3.mozilla.com:8201/", 11:10:05 INFO - "slavebuilddir": "test", 11:10:05 INFO - "scheduler": "tests-b2g-inbound-win64-pgo-talos", 11:10:05 INFO - "branch": "b2g-inbound", 11:10:05 INFO - "repo_path": "integration/b2g-inbound", 11:10:05 INFO - "stage_platform": "win64-pgo", 11:10:05 INFO - "builduid": "e6d4a91fb0204b35b17c4495983f6e48", 11:10:05 INFO - "revision": "47e4f94c33259fbcb8e5962360ac68030fc15bce" 11:10:05 INFO - }, 11:10:05 INFO - "sourcestamp": { 11:10:05 INFO - "repository": "", 11:10:05 INFO - "hasPatch": false, 11:10:05 INFO - "project": "", 11:10:05 INFO - "branch": "b2g-inbound-win64-pgo-talos", 11:10:05 INFO - "changes": [ 11:10:05 INFO - { 11:10:05 INFO - "category": null, 11:10:05 INFO - "files": [ 11:10:05 INFO - { 11:10:05 INFO - "url": null, 11:10:05 INFO - "name": "https://queue.taskcluster.net/v1/task/KrxNkT0ETkm3QjvaZp-Auw/artifacts/public/build/firefox-44.0a1.en-US.win64.zip" 11:10:05 INFO - } 11:10:05 INFO - ], 11:10:05 INFO - "repository": "", 11:10:05 INFO - "rev": "47e4f94c33259fbcb8e5962360ac68030fc15bce", 11:10:05 INFO - "who": "sendchange", 11:10:05 INFO - "when": 1445967866, 11:10:05 INFO - "number": 6581034, 11:10:05 INFO - "comments": "", 11:10:05 INFO - "project": "", 11:10:05 INFO - "at": "Tue 27 Oct 2015 10:44:26", 11:10:05 INFO - "branch": "b2g-inbound-win64-pgo-talos", 11:10:05 INFO - "revlink": "", 11:10:05 INFO - "properties": [ 11:10:05 INFO - [ 11:10:05 INFO - "buildid", 11:10:05 INFO - "20151027053027", 11:10:05 INFO - "Change" 11:10:05 INFO - ], 11:10:05 INFO - [ 11:10:05 INFO - "builduid", 11:10:05 INFO - "e6d4a91fb0204b35b17c4495983f6e48", 11:10:05 INFO - "Change" 11:10:05 INFO - ], 11:10:05 INFO - [ 11:10:05 INFO - "pgo_build", 11:10:05 INFO - "True", 11:10:05 INFO - "Change" 11:10:05 INFO - ] 11:10:05 INFO - ], 11:10:05 INFO - "revision": "47e4f94c33259fbcb8e5962360ac68030fc15bce" 11:10:05 INFO - } 11:10:05 INFO - ], 11:10:05 INFO - "revision": "47e4f94c33259fbcb8e5962360ac68030fc15bce" 11:10:05 INFO - } 11:10:05 INFO - } 11:10:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/KrxNkT0ETkm3QjvaZp-Auw/artifacts/public/build/firefox-44.0a1.en-US.win64.zip. 11:10:05 INFO - Running post-action listener: _resource_record_post_action 11:10:05 INFO - ##### 11:10:05 INFO - ##### Running download-and-extract step. 11:10:05 INFO - ##### 11:10:05 INFO - Running pre-action listener: _resource_record_pre_action 11:10:05 INFO - Running main action method: download_and_extract 11:10:05 INFO - mkdir: C:\slave\test-pgo\build\tests 11:10:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:10:05 INFO - https://queue.taskcluster.net/v1/task/KrxNkT0ETkm3QjvaZp-Auw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:10:05 INFO - trying https://queue.taskcluster.net/v1/task/KrxNkT0ETkm3QjvaZp-Auw/artifacts/public/build/test_packages.json 11:10:05 INFO - Downloading https://queue.taskcluster.net/v1/task/KrxNkT0ETkm3QjvaZp-Auw/artifacts/public/build/test_packages.json to C:\slave\test-pgo\build\test_packages.json 11:10:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KrxNkT0ETkm3QjvaZp-Auw/artifacts/public/build/test_packages.json', 'file_name': 'C:\\slave\\test-pgo\\build\\test_packages.json'}, attempt #1 11:10:06 INFO - Downloaded 1221 bytes. 11:10:06 INFO - Reading from file C:\slave\test-pgo\build\test_packages.json 11:10:06 INFO - Using the following test package requirements: 11:10:06 INFO - {u'common': [u'firefox-44.0a1.en-US.win64.common.tests.zip'], 11:10:06 INFO - u'cppunittest': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 11:10:06 INFO - u'firefox-44.0a1.en-US.win64.cppunittest.tests.zip'], 11:10:06 INFO - u'jittest': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 11:10:06 INFO - u'jsshell-win64.zip'], 11:10:06 INFO - u'mochitest': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 11:10:06 INFO - u'firefox-44.0a1.en-US.win64.mochitest.tests.zip'], 11:10:06 INFO - u'mozbase': [u'firefox-44.0a1.en-US.win64.common.tests.zip'], 11:10:06 INFO - u'reftest': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 11:10:06 INFO - u'firefox-44.0a1.en-US.win64.reftest.tests.zip'], 11:10:06 INFO - u'talos': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 11:10:06 INFO - u'firefox-44.0a1.en-US.win64.talos.tests.zip'], 11:10:06 INFO - u'web-platform': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 11:10:06 INFO - u'firefox-44.0a1.en-US.win64.web-platform.tests.zip'], 11:10:06 INFO - u'webapprt': [u'firefox-44.0a1.en-US.win64.common.tests.zip'], 11:10:06 INFO - u'xpcshell': [u'firefox-44.0a1.en-US.win64.common.tests.zip', 11:10:06 INFO - u'firefox-44.0a1.en-US.win64.xpcshell.tests.zip']} 11:10:06 INFO - Downloading packages: [u'firefox-44.0a1.en-US.win64.common.tests.zip'] for test suite category: common 11:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:10:06 INFO - https://queue.taskcluster.net/v1/task/KrxNkT0ETkm3QjvaZp-Auw/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip matches https://queue.taskcluster.net 11:10:06 INFO - trying https://queue.taskcluster.net/v1/task/KrxNkT0ETkm3QjvaZp-Auw/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip 11:10:06 INFO - Downloading https://queue.taskcluster.net/v1/task/KrxNkT0ETkm3QjvaZp-Auw/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 11:10:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KrxNkT0ETkm3QjvaZp-Auw/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 11:10:07 INFO - Downloaded 18083875 bytes. 11:10:07 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 11:10:07 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-44.0a1.en-US.win64.common.tests.zip 11:10:07 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 11:10:36 INFO - Return code: 0 11:10:36 INFO - Downloading packages: [u'firefox-44.0a1.en-US.win64.common.tests.zip', u'firefox-44.0a1.en-US.win64.talos.tests.zip'] for test suite category: talos 11:10: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')]} 11:10:36 INFO - https://queue.taskcluster.net/v1/task/KrxNkT0ETkm3QjvaZp-Auw/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip matches https://queue.taskcluster.net 11:10:36 INFO - trying https://queue.taskcluster.net/v1/task/KrxNkT0ETkm3QjvaZp-Auw/artifacts/public/build/firefox-44.0a1.en-US.win64.common.tests.zip 11:10:36 INFO - Downloading https://queue.taskcluster.net/v1/task/KrxNkT0ETkm3QjvaZp-Auw/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 11:10:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KrxNkT0ETkm3QjvaZp-Auw/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 11:10:37 INFO - Downloaded 18083875 bytes. 11:10:37 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 11:10:37 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-44.0a1.en-US.win64.common.tests.zip 11:10:37 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 11:10:59 INFO - Return code: 0 11:10:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:10:59 INFO - https://queue.taskcluster.net/v1/task/KrxNkT0ETkm3QjvaZp-Auw/artifacts/public/build/firefox-44.0a1.en-US.win64.talos.tests.zip matches https://queue.taskcluster.net 11:10:59 INFO - trying https://queue.taskcluster.net/v1/task/KrxNkT0ETkm3QjvaZp-Auw/artifacts/public/build/firefox-44.0a1.en-US.win64.talos.tests.zip 11:10:59 INFO - Downloading https://queue.taskcluster.net/v1/task/KrxNkT0ETkm3QjvaZp-Auw/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 11:10:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KrxNkT0ETkm3QjvaZp-Auw/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 11:11:00 INFO - Downloaded 11131307 bytes. 11:11:00 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 11:11:00 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-44.0a1.en-US.win64.talos.tests.zip 11:11:00 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 11:11:01 INFO - Return code: 0 11:11:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:01 INFO - https://queue.taskcluster.net/v1/task/KrxNkT0ETkm3QjvaZp-Auw/artifacts/public/build/firefox-44.0a1.en-US.win64.zip matches https://queue.taskcluster.net 11:11:01 INFO - trying https://queue.taskcluster.net/v1/task/KrxNkT0ETkm3QjvaZp-Auw/artifacts/public/build/firefox-44.0a1.en-US.win64.zip 11:11:01 INFO - Downloading https://queue.taskcluster.net/v1/task/KrxNkT0ETkm3QjvaZp-Auw/artifacts/public/build/firefox-44.0a1.en-US.win64.zip to C:\slave\test-pgo\build\firefox-44.0a1.en-US.win64.zip 11:11:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KrxNkT0ETkm3QjvaZp-Auw/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 11:11:05 INFO - Downloaded 55588953 bytes. 11:11:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KrxNkT0ETkm3QjvaZp-Auw/artifacts/public/build/firefox-44.0a1.en-US.win64.zip 11:11:05 INFO - mkdir: C:\slave\test-pgo\properties 11:11:05 INFO - Writing buildbot properties ['build_url'] to C:\slave\test-pgo\properties\build_url 11:11:05 INFO - Writing to file C:\slave\test-pgo\properties\build_url 11:11:05 INFO - Contents: 11:11:05 INFO - build_url:https://queue.taskcluster.net/v1/task/KrxNkT0ETkm3QjvaZp-Auw/artifacts/public/build/firefox-44.0a1.en-US.win64.zip 11:11:05 INFO - Running post-action listener: _resource_record_post_action 11:11:05 INFO - Running post-action listener: set_extra_try_arguments 11:11:05 INFO - ##### 11:11:05 INFO - ##### Running populate-webroot step. 11:11:05 INFO - ##### 11:11:05 INFO - Running pre-action listener: _resource_record_pre_action 11:11:05 INFO - Running main action method: populate_webroot 11:11:05 INFO - Guessing talos json url... 11:11:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:05 INFO - https://queue.taskcluster.net/v1/task/KrxNkT0ETkm3QjvaZp-Auw/artifacts/public/build/firefox-44.0a1.en-US.win64.txt matches https://queue.taskcluster.net 11:11:05 INFO - trying https://queue.taskcluster.net/v1/task/KrxNkT0ETkm3QjvaZp-Auw/artifacts/public/build/firefox-44.0a1.en-US.win64.txt 11:11:05 INFO - Downloading https://queue.taskcluster.net/v1/task/KrxNkT0ETkm3QjvaZp-Auw/artifacts/public/build/firefox-44.0a1.en-US.win64.txt to C:\slave\test-pgo\build\firefox-44.0a1.en-US.win64.txt 11:11:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KrxNkT0ETkm3QjvaZp-Auw/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 11:11:06 INFO - Downloaded 107 bytes. 11:11:06 INFO - Reading from file C:\slave\test-pgo\build\firefox-44.0a1.en-US.win64.txt 11:11:06 INFO - Contents: 11:11:06 INFO - 20151027053027 11:11:06 INFO - https://hg.mozilla.org/integration/b2g-inbound/rev/47e4f94c33259fbcb8e5962360ac68030fc15bce 11:11:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:06 INFO - trying https://hg.mozilla.org/integration/b2g-inbound/raw-file/47e4f94c33/testing/talos/talos.json 11:11:06 INFO - Downloading https://hg.mozilla.org/integration/b2g-inbound/raw-file/47e4f94c33/testing/talos/talos.json to C:\slave\test-pgo\build\talos.json 11:11:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/b2g-inbound/raw-file/47e4f94c33/testing/talos/talos.json', 'file_name': 'C:\\slave\\test-pgo\\build\\talos.json'}, attempt #1 11:11:07 INFO - Downloaded 4264 bytes. 11:11:07 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']}, 11:11:07 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']}, 11:11:07 INFO - u'remote-trobocheck2': {u'talos_options': [u'--fennecIDs', 11:11:07 INFO - u'../fennec_ids.txt'], 11:11:07 INFO - u'tests': [u'tcheck2']}, 11:11:07 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome', 11:11:07 INFO - u'--tppagecycles', 11:11:07 INFO - u'7'], 11:11:07 INFO - u'tests': [u'tsvgm']}}, 11:11:07 INFO - u'suites': {u'chromez': {u'tests': [u'tresize', u'tcanvasmark']}, 11:11:07 INFO - u'chromez-e10s': {u'talos_options': [u'--e10s'], 11:11:07 INFO - u'tests': [u'tresize', u'tcanvasmark']}, 11:11:07 INFO - u'dromaeojs': {u'tests': [u'dromaeo_css', u'kraken', u'v8_7']}, 11:11:07 INFO - u'dromaeojs-e10s': {u'talos_options': [u'--e10s'], 11:11:07 INFO - u'tests': [u'dromaeo_css', 11:11:07 INFO - u'kraken', 11:11:07 INFO - u'v8_7']}, 11:11:07 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:07 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 11:11:07 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:07 INFO - u'talos_options': [u'--e10s'], 11:11:07 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 11:11:07 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:07 INFO - u'tests': [u'damp', u'tps']}, 11:11:07 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:07 INFO - u'talos_options': [u'--e10s'], 11:11:07 INFO - u'tests': [u'damp', u'tps']}, 11:11:07 INFO - u'g3': {u'tests': [u'dromaeo_dom']}, 11:11:07 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']}, 11:11:07 INFO - u'other': {u'tests': [u'a11yr', 11:11:07 INFO - u'ts_paint', 11:11:07 INFO - u'tpaint', 11:11:07 INFO - u'sessionrestore', 11:11:07 INFO - u'sessionrestore_no_auto_restore']}, 11:11:07 INFO - u'other-e10s': {u'talos_options': [u'--e10s'], 11:11:07 INFO - u'tests': [u'a11yr', 11:11:07 INFO - u'ts_paint', 11:11:07 INFO - u'tpaint', 11:11:07 INFO - u'sessionrestore', 11:11:07 INFO - u'sessionrestore_no_auto_restore']}, 11:11:07 INFO - u'other-e10s_l64': {u'talos_options': [u'--e10s'], 11:11:07 INFO - u'tests': [u'a11yr', 11:11:07 INFO - u'ts_paint', 11:11:07 INFO - u'tpaint', 11:11:07 INFO - u'sessionrestore', 11:11:07 INFO - u'sessionrestore_no_auto_restore']}, 11:11:07 INFO - u'other-e10s_nol64': {u'talos_options': [u'--e10s'], 11:11:07 INFO - u'tests': [u'a11yr', 11:11:07 INFO - u'ts_paint', 11:11:07 INFO - u'tpaint', 11:11:07 INFO - u'sessionrestore', 11:11:07 INFO - u'sessionrestore_no_auto_restore']}, 11:11:07 INFO - u'other_l64': {u'tests': [u'a11yr', 11:11:07 INFO - u'ts_paint', 11:11:07 INFO - u'tpaint', 11:11:07 INFO - u'sessionrestore', 11:11:07 INFO - u'sessionrestore_no_auto_restore']}, 11:11:07 INFO - u'other_nol64': {u'tests': [u'a11yr', 11:11:07 INFO - u'ts_paint', 11:11:07 INFO - u'tpaint', 11:11:07 INFO - u'sessionrestore', 11:11:07 INFO - u'sessionrestore_no_auto_restore']}, 11:11:07 INFO - u'svgr': {u'tests': [u'tsvgx', 11:11:07 INFO - u'tsvgr_opacity', 11:11:07 INFO - u'tart', 11:11:07 INFO - u'tscrollx', 11:11:07 INFO - u'cart']}, 11:11:07 INFO - u'svgr-e10s': {u'talos_options': [u'--e10s'], 11:11:07 INFO - u'tests': [u'tsvgx', 11:11:07 INFO - u'tsvgr_opacity', 11:11:07 INFO - u'tart', 11:11:07 INFO - u'tscrollx', 11:11:07 INFO - u'cart']}, 11:11:07 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:07 INFO - u'tests': [u'tp5o']}, 11:11:07 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:07 INFO - u'talos_options': [u'--e10s'], 11:11:07 INFO - u'tests': [u'tp5o']}, 11:11:07 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:07 INFO - u'talos_options': [u'--xperf_path', 11:11:07 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:11:07 INFO - u'tests': [u'tp5n']}, 11:11:07 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:11:07 INFO - u'talos_options': [u'--e10s', 11:11:07 INFO - u'--xperf_path', 11:11:07 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 11:11:07 INFO - u'C:/slave/talos-data/talos/xperf.config'], 11:11:07 INFO - u'tests': [u'tp5n']}}, 11:11:07 INFO - u'talos.zip': {u'path': u'', 11:11:07 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:11:07 INFO - Running post-action listener: _resource_record_post_action 11:11:07 INFO - ##### 11:11:07 INFO - ##### Running create-virtualenv step. 11:11:07 INFO - ##### 11:11:07 INFO - Running pre-action listener: _resource_record_pre_action 11:11:07 INFO - Running main action method: create_virtualenv 11:11:07 INFO - Creating virtualenv C:\slave\test-pgo\build/venv 11:11:07 INFO - mkdir: C:\slave\test-pgo\build\venv\Scripts 11:11:07 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test-pgo\build\venv\Scripts\python27.dll 11:11:07 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'! 11:11:07 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 11:11:07 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 11:11:09 INFO - New python executable in C:\slave\test-pgo\build/venv\Scripts\python.exe 11:11:12 INFO - Installing distribute......................................................................................................................................................................................done. 11:11:14 INFO - Return code: 0 11:11:14 INFO - Installing pip>=1.5 into virtualenv C:\slave\test-pgo\build/venv 11:11:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:14 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 0x02384B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0233EEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02446980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01CF8B48>, '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 0x01D1A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02824660>, '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-018', 'USERDOMAIN': 'T-W864-IX-018', '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-018', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-018\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-018', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-018', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-018', '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-018\\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 11:11:14 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 11:11:14 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 11:11:14 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 11:11:14 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-018\\AppData\\Roaming', 11:11:14 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 11:11:14 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 11:11:14 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 11:11:14 INFO - 'COMPUTERNAME': 'T-W864-IX-018', 11:11:14 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 11:11:14 INFO - 'DCLOCATION': 'SCL3', 11:11:14 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 11:11:14 INFO - 'FP_NO_HOST_CHECK': 'NO', 11:11:14 INFO - 'HOMEDRIVE': 'C:', 11:11:14 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-018', 11:11:14 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 11:11:14 INFO - 'KTS_VERSION': '1.19c', 11:11:14 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-018\\AppData\\Local', 11:11:14 INFO - 'LOGONSERVER': '\\\\T-W864-IX-018', 11:11:14 INFO - 'MONDIR': 'C:\\Monitor_config\\', 11:11:14 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 11:11:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:14 INFO - 'MOZ_NO_REMOTE': '1', 11:11:14 INFO - 'NO_EM_RESTART': '1', 11:11:14 INFO - 'NUMBER_OF_PROCESSORS': '8', 11:11:14 INFO - 'OS': 'Windows_NT', 11:11:14 INFO - 'OURDRIVE': 'C:', 11:11:14 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 11:11:14 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 11:11:14 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 11:11:14 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 11:11:14 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 11:11:14 INFO - 'PROCESSOR_LEVEL': '6', 11:11:14 INFO - 'PROCESSOR_REVISION': '1e05', 11:11:14 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 11:11:14 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 11:11:14 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 11:11:14 INFO - 'PROGRAMW6432': 'C:\\Program Files', 11:11:14 INFO - 'PROMPT': '$P$G', 11:11:14 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 11:11:14 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 11:11:14 INFO - 'PUBLIC': 'C:\\Users\\Public', 11:11:14 INFO - 'PWD': 'C:\\slave\\test-pgo', 11:11:14 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 11:11:14 INFO - 'SLAVEDIR': 'C:\\slave\\', 11:11:14 INFO - 'SYSTEMDRIVE': 'C:', 11:11:14 INFO - 'SYSTEMROOT': 'C:\\windows', 11:11:14 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:11:14 INFO - 'TEST1': 'testie', 11:11:14 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:11:14 INFO - 'USERDOMAIN': 'T-W864-IX-018', 11:11:14 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-018', 11:11:14 INFO - 'USERNAME': 'cltbld', 11:11:14 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-018', 11:11:14 INFO - 'WINDIR': 'C:\\windows', 11:11:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 11:11:15 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:11:15 INFO - Downloading/unpacking pip>=1.5 11:11:15 INFO - Creating supposed download cache at C:\slave\test-pgo\build/venv\cache 11:11:19 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 11:11:19 INFO - Running setup.py egg_info for package pip 11:11:19 INFO - warning: no files found matching 'pip\cacert.pem' 11:11:19 INFO - warning: no files found matching '*.html' under directory 'docs' 11:11:19 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 11:11:19 INFO - no previously-included directories found matching 'docs\_build\_sources' 11:11:19 INFO - Installing collected packages: pip 11:11:19 INFO - Found existing installation: pip 0.8.2 11:11:19 INFO - Uninstalling pip: 11:11:19 INFO - Successfully uninstalled pip 11:11:19 INFO - Running setup.py install for pip 11:11:19 INFO - warning: no files found matching 'pip\cacert.pem' 11:11:19 INFO - warning: no files found matching '*.html' under directory 'docs' 11:11:19 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 11:11:19 INFO - no previously-included directories found matching 'docs\_build\_sources' 11:11:19 INFO - Installing pip-script.py script to C:\slave\test-pgo\build\venv\Scripts 11:11:19 INFO - Installing pip.exe script to C:\slave\test-pgo\build\venv\Scripts 11:11:19 INFO - Installing pip2.7-script.py script to C:\slave\test-pgo\build\venv\Scripts 11:11:19 INFO - Installing pip2.7.exe script to C:\slave\test-pgo\build\venv\Scripts 11:11:19 INFO - Installing pip2-script.py script to C:\slave\test-pgo\build\venv\Scripts 11:11:19 INFO - Installing pip2.exe script to C:\slave\test-pgo\build\venv\Scripts 11:11:19 INFO - Successfully installed pip 11:11:19 INFO - Cleaning up... 11:11:19 INFO - Return code: 0 11:11:19 INFO - Installing psutil>=0.7.1 into virtualenv C:\slave\test-pgo\build/venv 11:11:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:19 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 0x02384B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0233EEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02446980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01CF8B48>, '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 0x01D1A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02824660>, '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-018', 'USERDOMAIN': 'T-W864-IX-018', '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-018', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-018\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-018', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-018', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-018', '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-018\\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 11:11:19 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 11:11:19 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 11:11:19 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 11:11:19 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-018\\AppData\\Roaming', 11:11:19 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 11:11:19 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 11:11:19 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 11:11:19 INFO - 'COMPUTERNAME': 'T-W864-IX-018', 11:11:19 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 11:11:19 INFO - 'DCLOCATION': 'SCL3', 11:11:19 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 11:11:19 INFO - 'FP_NO_HOST_CHECK': 'NO', 11:11:19 INFO - 'HOMEDRIVE': 'C:', 11:11:19 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-018', 11:11:19 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 11:11:19 INFO - 'KTS_VERSION': '1.19c', 11:11:19 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-018\\AppData\\Local', 11:11:19 INFO - 'LOGONSERVER': '\\\\T-W864-IX-018', 11:11:19 INFO - 'MONDIR': 'C:\\Monitor_config\\', 11:11:19 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 11:11:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:19 INFO - 'MOZ_NO_REMOTE': '1', 11:11:19 INFO - 'NO_EM_RESTART': '1', 11:11:19 INFO - 'NUMBER_OF_PROCESSORS': '8', 11:11:19 INFO - 'OS': 'Windows_NT', 11:11:19 INFO - 'OURDRIVE': 'C:', 11:11:19 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 11:11:19 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 11:11:19 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 11:11:19 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 11:11:19 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 11:11:19 INFO - 'PROCESSOR_LEVEL': '6', 11:11:19 INFO - 'PROCESSOR_REVISION': '1e05', 11:11:19 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 11:11:19 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 11:11:19 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 11:11:19 INFO - 'PROGRAMW6432': 'C:\\Program Files', 11:11:19 INFO - 'PROMPT': '$P$G', 11:11:19 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 11:11:19 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 11:11:19 INFO - 'PUBLIC': 'C:\\Users\\Public', 11:11:19 INFO - 'PWD': 'C:\\slave\\test-pgo', 11:11:19 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 11:11:19 INFO - 'SLAVEDIR': 'C:\\slave\\', 11:11:19 INFO - 'SYSTEMDRIVE': 'C:', 11:11:19 INFO - 'SYSTEMROOT': 'C:\\windows', 11:11:19 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:11:19 INFO - 'TEST1': 'testie', 11:11:19 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:11:19 INFO - 'USERDOMAIN': 'T-W864-IX-018', 11:11:19 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-018', 11:11:19 INFO - 'USERNAME': 'cltbld', 11:11:19 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-018', 11:11:19 INFO - 'WINDIR': 'C:\\windows', 11:11:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 11:11:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:21 INFO - Downloading/unpacking psutil>=0.7.1 11:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:21 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 11:11:21 INFO - Installing collected packages: psutil 11:11:22 INFO - Successfully installed psutil 11:11:22 INFO - Cleaning up... 11:11:22 INFO - Return code: 0 11:11:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv C:\slave\test-pgo\build/venv 11:11: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')]} 11:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11: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')]} 11:11:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:22 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x02384B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0233EEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02446980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01CF8B48>, '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 0x01D1A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02824660>, '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-018', 'USERDOMAIN': 'T-W864-IX-018', '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-018', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-018\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-018', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-018', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-018', '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-018\\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 11:11:22 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in C:\slave\test-pgo\build 11:11:22 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --download-cache C:\slave\test-pgo\build/venv\cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 11:11:22 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 11:11:22 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-018\\AppData\\Roaming', 11:11:22 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 11:11:22 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 11:11:22 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 11:11:22 INFO - 'COMPUTERNAME': 'T-W864-IX-018', 11:11:22 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 11:11:22 INFO - 'DCLOCATION': 'SCL3', 11:11:22 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 11:11:22 INFO - 'FP_NO_HOST_CHECK': 'NO', 11:11:22 INFO - 'HOMEDRIVE': 'C:', 11:11:22 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-018', 11:11:22 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 11:11:22 INFO - 'KTS_VERSION': '1.19c', 11:11:22 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-018\\AppData\\Local', 11:11:22 INFO - 'LOGONSERVER': '\\\\T-W864-IX-018', 11:11:22 INFO - 'MONDIR': 'C:\\Monitor_config\\', 11:11:22 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 11:11:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:22 INFO - 'MOZ_NO_REMOTE': '1', 11:11:22 INFO - 'NO_EM_RESTART': '1', 11:11:22 INFO - 'NUMBER_OF_PROCESSORS': '8', 11:11:22 INFO - 'OS': 'Windows_NT', 11:11:22 INFO - 'OURDRIVE': 'C:', 11:11:22 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 11:11:22 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 11:11:22 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 11:11:22 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 11:11:22 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 11:11:22 INFO - 'PROCESSOR_LEVEL': '6', 11:11:22 INFO - 'PROCESSOR_REVISION': '1e05', 11:11:22 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 11:11:22 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 11:11:22 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 11:11:22 INFO - 'PROGRAMW6432': 'C:\\Program Files', 11:11:22 INFO - 'PROMPT': '$P$G', 11:11:22 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 11:11:22 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 11:11:22 INFO - 'PUBLIC': 'C:\\Users\\Public', 11:11:22 INFO - 'PWD': 'C:\\slave\\test-pgo', 11:11:22 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 11:11:22 INFO - 'SLAVEDIR': 'C:\\slave\\', 11:11:22 INFO - 'SYSTEMDRIVE': 'C:', 11:11:22 INFO - 'SYSTEMROOT': 'C:\\windows', 11:11:22 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:11:22 INFO - 'TEST1': 'testie', 11:11:22 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:11:22 INFO - 'USERDOMAIN': 'T-W864-IX-018', 11:11:22 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-018', 11:11:22 INFO - 'USERNAME': 'cltbld', 11:11:22 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-018', 11:11:22 INFO - 'WINDIR': 'C:\\windows', 11:11:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 11:11:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:11:23 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 11:11:23 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor 11:11:23 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) 11:11:23 INFO - Installing collected packages: mozsystemmonitor 11:11:23 INFO - Running setup.py install for mozsystemmonitor 11:11:23 INFO - Successfully installed mozsystemmonitor 11:11:23 INFO - Cleaning up... 11:11:24 INFO - Return code: 0 11:11:24 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test-pgo\build/venv 11:11:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:24 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 0x02384B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0233EEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02446980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01CF8B48>, '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 0x01D1A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02824660>, '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-018', 'USERDOMAIN': 'T-W864-IX-018', '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-018', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-018\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-018', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-018', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-018', '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-018\\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 11:11:24 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 11:11:24 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 11:11:24 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 11:11:24 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-018\\AppData\\Roaming', 11:11:24 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 11:11:24 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 11:11:24 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 11:11:24 INFO - 'COMPUTERNAME': 'T-W864-IX-018', 11:11:24 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 11:11:24 INFO - 'DCLOCATION': 'SCL3', 11:11:24 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 11:11:24 INFO - 'FP_NO_HOST_CHECK': 'NO', 11:11:24 INFO - 'HOMEDRIVE': 'C:', 11:11:24 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-018', 11:11:24 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 11:11:24 INFO - 'KTS_VERSION': '1.19c', 11:11:24 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-018\\AppData\\Local', 11:11:24 INFO - 'LOGONSERVER': '\\\\T-W864-IX-018', 11:11:24 INFO - 'MONDIR': 'C:\\Monitor_config\\', 11:11:24 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 11:11:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:24 INFO - 'MOZ_NO_REMOTE': '1', 11:11:24 INFO - 'NO_EM_RESTART': '1', 11:11:24 INFO - 'NUMBER_OF_PROCESSORS': '8', 11:11:24 INFO - 'OS': 'Windows_NT', 11:11:24 INFO - 'OURDRIVE': 'C:', 11:11:24 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 11:11:24 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 11:11:24 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 11:11:24 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 11:11:24 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 11:11:24 INFO - 'PROCESSOR_LEVEL': '6', 11:11:24 INFO - 'PROCESSOR_REVISION': '1e05', 11:11:24 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 11:11:24 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 11:11:24 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 11:11:24 INFO - 'PROGRAMW6432': 'C:\\Program Files', 11:11:24 INFO - 'PROMPT': '$P$G', 11:11:24 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 11:11:24 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 11:11:24 INFO - 'PUBLIC': 'C:\\Users\\Public', 11:11:24 INFO - 'PWD': 'C:\\slave\\test-pgo', 11:11:24 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 11:11:24 INFO - 'SLAVEDIR': 'C:\\slave\\', 11:11:24 INFO - 'SYSTEMDRIVE': 'C:', 11:11:24 INFO - 'SYSTEMROOT': 'C:\\windows', 11:11:24 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:11:24 INFO - 'TEST1': 'testie', 11:11:24 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:11:24 INFO - 'USERDOMAIN': 'T-W864-IX-018', 11:11:24 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-018', 11:11:24 INFO - 'USERNAME': 'cltbld', 11:11:24 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-018', 11:11:24 INFO - 'WINDIR': 'C:\\windows', 11:11:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 11:11:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:24 INFO - Downloading/unpacking blobuploader==1.2.4 11:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:25 INFO - Downloading blobuploader-1.2.4.tar.gz 11:11:25 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 11:11:25 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader 11:11:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:25 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 11:11:25 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\requests\setup.py) egg_info for package requests 11:11:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:26 INFO - Downloading docopt-0.6.1.tar.gz 11:11:26 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 11:11:26 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\docopt\setup.py) egg_info for package docopt 11:11:26 INFO - Installing collected packages: blobuploader, requests, docopt 11:11:26 INFO - Running setup.py install for blobuploader 11:11:26 INFO - Running setup.py install for requests 11:11:27 INFO - Running setup.py install for docopt 11:11:27 INFO - Successfully installed blobuploader requests docopt 11:11:27 INFO - Cleaning up... 11:11:28 INFO - Return code: 0 11:11:28 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv 11:11:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:28 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 0x02384B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0233EEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02446980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01CF8B48>, '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 0x01D1A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02824660>, '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-018', 'USERDOMAIN': 'T-W864-IX-018', '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-018', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-018\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-018', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-018', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-018', '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-018\\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 11:11:28 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 11:11:28 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 11:11:28 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 11:11:28 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-018\\AppData\\Roaming', 11:11:28 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 11:11:28 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 11:11:28 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 11:11:28 INFO - 'COMPUTERNAME': 'T-W864-IX-018', 11:11:28 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 11:11:28 INFO - 'DCLOCATION': 'SCL3', 11:11:28 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 11:11:28 INFO - 'FP_NO_HOST_CHECK': 'NO', 11:11:28 INFO - 'HOMEDRIVE': 'C:', 11:11:28 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-018', 11:11:28 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 11:11:28 INFO - 'KTS_VERSION': '1.19c', 11:11:28 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-018\\AppData\\Local', 11:11:28 INFO - 'LOGONSERVER': '\\\\T-W864-IX-018', 11:11:28 INFO - 'MONDIR': 'C:\\Monitor_config\\', 11:11:28 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 11:11:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:28 INFO - 'MOZ_NO_REMOTE': '1', 11:11:28 INFO - 'NO_EM_RESTART': '1', 11:11:28 INFO - 'NUMBER_OF_PROCESSORS': '8', 11:11:28 INFO - 'OS': 'Windows_NT', 11:11:28 INFO - 'OURDRIVE': 'C:', 11:11:28 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 11:11:28 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 11:11:28 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 11:11:28 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 11:11:28 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 11:11:28 INFO - 'PROCESSOR_LEVEL': '6', 11:11:28 INFO - 'PROCESSOR_REVISION': '1e05', 11:11:28 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 11:11:28 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 11:11:28 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 11:11:28 INFO - 'PROGRAMW6432': 'C:\\Program Files', 11:11:28 INFO - 'PROMPT': '$P$G', 11:11:28 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 11:11:28 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 11:11:28 INFO - 'PUBLIC': 'C:\\Users\\Public', 11:11:28 INFO - 'PWD': 'C:\\slave\\test-pgo', 11:11:28 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 11:11:28 INFO - 'SLAVEDIR': 'C:\\slave\\', 11:11:28 INFO - 'SYSTEMDRIVE': 'C:', 11:11:28 INFO - 'SYSTEMROOT': 'C:\\windows', 11:11:28 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:11:28 INFO - 'TEST1': 'testie', 11:11:28 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:11:28 INFO - 'USERDOMAIN': 'T-W864-IX-018', 11:11:28 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-018', 11:11:28 INFO - 'USERNAME': 'cltbld', 11:11:28 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-018', 11:11:28 INFO - 'WINDIR': 'C:\\windows', 11:11:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 11:11:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:28 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\manifestparser 11:11:28 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-fzneqp-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/manifestparser 11:11:29 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozcrash 11:11:29 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-viazn6-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozcrash 11:11:29 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdebug 11:11:29 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-nza8aa-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdebug 11:11:29 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdevice 11:11:29 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-paghxv-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdevice 11:11:29 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozfile 11:11:29 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-uun0wz-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozfile 11:11:29 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozhttpd 11:11:29 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-lhtido-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozhttpd 11:11:29 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinfo 11:11:29 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jsalcv-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinfo 11:11:29 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinstall 11:11:29 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-bvsisb-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinstall 11:11:29 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozleak 11:11:29 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-psscmv-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozleak 11:11:29 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozlog 11:11:29 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jkgxpv-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozlog 11:11:30 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moznetwork 11:11:30 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-zfu10c-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moznetwork 11:11:30 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprocess 11:11:30 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-vt0r25-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprocess 11:11:30 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprofile 11:11:30 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-wsirun-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprofile 11:11:30 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozrunner 11:11:30 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xraaep-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozrunner 11:11:30 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozscreenshot 11:11:30 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-jtdklv-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:11:30 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moztest 11:11:30 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-e1vcea-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moztest 11:11:30 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozversion 11:11:30 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-s0iwnb-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozversion 11:11:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:11:30 INFO - Running setup.py install for manifestparser 11:11:30 INFO - Installing manifestparser-script.py script to C:\slave\test-pgo\build\venv\Scripts 11:11:30 INFO - Installing manifestparser.exe script to C:\slave\test-pgo\build\venv\Scripts 11:11:31 INFO - Running setup.py install for mozcrash 11:11:31 INFO - Running setup.py install for mozdebug 11:11:32 INFO - Running setup.py install for mozdevice 11:11:32 INFO - Installing sutini-script.py script to C:\slave\test-pgo\build\venv\Scripts 11:11:32 INFO - Installing sutini.exe script to C:\slave\test-pgo\build\venv\Scripts 11:11:32 INFO - Installing dm-script.py script to C:\slave\test-pgo\build\venv\Scripts 11:11:32 INFO - Installing dm.exe script to C:\slave\test-pgo\build\venv\Scripts 11:11:32 INFO - Running setup.py install for mozfile 11:11:33 INFO - Running setup.py install for mozhttpd 11:11:33 INFO - Installing mozhttpd-script.py script to C:\slave\test-pgo\build\venv\Scripts 11:11:33 INFO - Installing mozhttpd.exe script to C:\slave\test-pgo\build\venv\Scripts 11:11:33 INFO - Running setup.py install for mozinfo 11:11:33 INFO - Installing mozinfo-script.py script to C:\slave\test-pgo\build\venv\Scripts 11:11:33 INFO - Installing mozinfo.exe script to C:\slave\test-pgo\build\venv\Scripts 11:11:33 INFO - Running setup.py install for mozInstall 11:11:33 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test-pgo\build\venv\Scripts 11:11:33 INFO - Installing moz_remove_from_system.exe script to C:\slave\test-pgo\build\venv\Scripts 11:11:33 INFO - Installing mozuninstall-script.py script to C:\slave\test-pgo\build\venv\Scripts 11:11:33 INFO - Installing mozuninstall.exe script to C:\slave\test-pgo\build\venv\Scripts 11:11:33 INFO - Installing mozinstall-script.py script to C:\slave\test-pgo\build\venv\Scripts 11:11:33 INFO - Installing mozinstall.exe script to C:\slave\test-pgo\build\venv\Scripts 11:11:33 INFO - Installing moz_add_to_system-script.py script to C:\slave\test-pgo\build\venv\Scripts 11:11:33 INFO - Installing moz_add_to_system.exe script to C:\slave\test-pgo\build\venv\Scripts 11:11:34 INFO - Running setup.py install for mozleak 11:11:34 INFO - Running setup.py install for mozlog 11:11:34 INFO - Installing structlog-script.py script to C:\slave\test-pgo\build\venv\Scripts 11:11:34 INFO - Installing structlog.exe script to C:\slave\test-pgo\build\venv\Scripts 11:11:35 INFO - Running setup.py install for moznetwork 11:11:35 INFO - Installing moznetwork-script.py script to C:\slave\test-pgo\build\venv\Scripts 11:11:35 INFO - Installing moznetwork.exe script to C:\slave\test-pgo\build\venv\Scripts 11:11:35 INFO - Running setup.py install for mozprocess 11:11:36 INFO - Running setup.py install for mozprofile 11:11:36 INFO - Installing mozprofile-script.py script to C:\slave\test-pgo\build\venv\Scripts 11:11:36 INFO - Installing mozprofile.exe script to C:\slave\test-pgo\build\venv\Scripts 11:11:36 INFO - Installing diff-profiles-script.py script to C:\slave\test-pgo\build\venv\Scripts 11:11:36 INFO - Installing diff-profiles.exe script to C:\slave\test-pgo\build\venv\Scripts 11:11:36 INFO - Installing view-profile-script.py script to C:\slave\test-pgo\build\venv\Scripts 11:11:36 INFO - Installing view-profile.exe script to C:\slave\test-pgo\build\venv\Scripts 11:11:37 INFO - Running setup.py install for mozrunner 11:11:37 INFO - Installing mozrunner-script.py script to C:\slave\test-pgo\build\venv\Scripts 11:11:37 INFO - Installing mozrunner.exe script to C:\slave\test-pgo\build\venv\Scripts 11:11:37 INFO - Running setup.py install for mozscreenshot 11:11:38 INFO - Running setup.py install for moztest 11:11:38 INFO - Running setup.py install for mozversion 11:11:38 INFO - Installing mozversion-script.py script to C:\slave\test-pgo\build\venv\Scripts 11:11:38 INFO - Installing mozversion.exe script to C:\slave\test-pgo\build\venv\Scripts 11:11:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:11:39 INFO - Cleaning up... 11:11:39 INFO - Return code: 0 11:11:39 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv 11:11:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:39 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 0x02384B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0233EEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02446980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01CF8B48>, '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 0x01D1A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02824660>, '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-018', 'USERDOMAIN': 'T-W864-IX-018', '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-018', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-018\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-018', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-018', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-018', '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-018\\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 11:11:39 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 11:11:39 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 11:11:39 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 11:11:39 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-018\\AppData\\Roaming', 11:11:39 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 11:11:39 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 11:11:39 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 11:11:39 INFO - 'COMPUTERNAME': 'T-W864-IX-018', 11:11:39 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 11:11:39 INFO - 'DCLOCATION': 'SCL3', 11:11:39 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 11:11:39 INFO - 'FP_NO_HOST_CHECK': 'NO', 11:11:39 INFO - 'HOMEDRIVE': 'C:', 11:11:39 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-018', 11:11:39 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 11:11:39 INFO - 'KTS_VERSION': '1.19c', 11:11:39 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-018\\AppData\\Local', 11:11:39 INFO - 'LOGONSERVER': '\\\\T-W864-IX-018', 11:11:39 INFO - 'MONDIR': 'C:\\Monitor_config\\', 11:11:39 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 11:11:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:39 INFO - 'MOZ_NO_REMOTE': '1', 11:11:39 INFO - 'NO_EM_RESTART': '1', 11:11:39 INFO - 'NUMBER_OF_PROCESSORS': '8', 11:11:39 INFO - 'OS': 'Windows_NT', 11:11:39 INFO - 'OURDRIVE': 'C:', 11:11:39 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 11:11:39 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 11:11:39 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 11:11:39 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 11:11:39 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 11:11:39 INFO - 'PROCESSOR_LEVEL': '6', 11:11:39 INFO - 'PROCESSOR_REVISION': '1e05', 11:11:39 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 11:11:39 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 11:11:39 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 11:11:39 INFO - 'PROGRAMW6432': 'C:\\Program Files', 11:11:39 INFO - 'PROMPT': '$P$G', 11:11:39 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 11:11:39 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 11:11:39 INFO - 'PUBLIC': 'C:\\Users\\Public', 11:11:39 INFO - 'PWD': 'C:\\slave\\test-pgo', 11:11:39 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 11:11:39 INFO - 'SLAVEDIR': 'C:\\slave\\', 11:11:39 INFO - 'SYSTEMDRIVE': 'C:', 11:11:39 INFO - 'SYSTEMROOT': 'C:\\windows', 11:11:39 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:11:39 INFO - 'TEST1': 'testie', 11:11:39 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:11:39 INFO - 'USERDOMAIN': 'T-W864-IX-018', 11:11:39 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-018', 11:11:39 INFO - 'USERNAME': 'cltbld', 11:11:39 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-018', 11:11:39 INFO - 'WINDIR': 'C:\\windows', 11:11:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 11:11:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:39 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\manifestparser 11:11:39 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-i9ygtw-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/manifestparser 11:11:39 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)) 11:11:39 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozcrash 11:11:39 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-d4ys8c-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozcrash 11:11:39 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)) 11:11:39 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdebug 11:11:39 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-htihei-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdebug 11:11:39 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)) 11:11:39 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdevice 11:11:39 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-m5vbus-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdevice 11:11:40 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)) 11:11:40 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozfile 11:11:40 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rpltia-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozfile 11:11:40 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)) 11:11:40 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozhttpd 11:11:40 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-4iihma-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozhttpd 11:11:40 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)) 11:11:40 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinfo 11:11:40 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-e0uqet-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinfo 11:11:40 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)) 11:11:40 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinstall 11:11:40 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ut_ubn-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinstall 11:11:40 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)) 11:11:40 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozleak 11:11:40 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ry2rj6-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozleak 11:11:40 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)) 11:11:40 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozlog 11:11:40 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rfam2_-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozlog 11:11:40 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)) 11:11:40 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moznetwork 11:11:40 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-k6xziq-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moznetwork 11:11:40 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)) 11:11:40 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprocess 11:11:40 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-puatcb-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprocess 11:11:41 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)) 11:11:41 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprofile 11:11:41 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-iyqwep-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprofile 11:11:41 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)) 11:11:41 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozrunner 11:11:41 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-zwirte-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozrunner 11:11:41 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)) 11:11:41 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozscreenshot 11:11:41 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-psq08w-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:11:41 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)) 11:11:41 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moztest 11:11:41 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-hepln9-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moztest 11:11:41 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)) 11:11:41 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozversion 11:11:41 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-cik02q-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozversion 11:11:41 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)) 11:11:41 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)) 11:11:41 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)) 11:11:41 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)) 11:11:41 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)) 11:11:41 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)) 11:11:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 10)) 11:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:11:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:11:42 INFO - Downloading blessings-1.5.1.tar.gz 11:11:42 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 11:11:42 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\blessings\setup.py) egg_info for package blessings 11:11:42 INFO - Installing collected packages: blessings 11:11:42 INFO - Running setup.py install for blessings 11:11:43 INFO - Successfully installed blessings 11:11:43 INFO - Cleaning up... 11:11:45 INFO - Return code: 0 11:11:45 INFO - Done creating virtualenv C:\slave\test-pgo\build/venv. 11:11:45 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'freeze'] 11:11:45 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip freeze 11:11:46 INFO - Reading from file tmpfile_stdout 11:11:46 INFO - Using _rmtree_windows ... 11:11:46 INFO - Using _rmtree_windows ... 11:11:46 INFO - Current package versions: 11:11:46 INFO - blessings == 1.5.1 11:11:46 INFO - blobuploader == 1.2.4 11:11:46 INFO - docopt == 0.6.1 11:11:46 INFO - manifestparser == 1.1 11:11:46 INFO - mozInstall == 1.12 11:11:46 INFO - mozcrash == 0.16 11:11:46 INFO - mozdebug == 0.1 11:11:46 INFO - mozdevice == 0.46 11:11:46 INFO - mozfile == 1.2 11:11:46 INFO - mozhttpd == 0.7 11:11:46 INFO - mozinfo == 0.8 11:11:46 INFO - mozleak == 0.1 11:11:46 INFO - mozlog == 3.0 11:11:46 INFO - moznetwork == 0.27 11:11:46 INFO - mozprocess == 0.22 11:11:46 INFO - mozprofile == 0.27 11:11:46 INFO - mozrunner == 6.11 11:11:46 INFO - mozscreenshot == 0.1 11:11:46 INFO - mozsystemmonitor == 0.0 11:11:46 INFO - moztest == 0.7 11:11:46 INFO - mozversion == 1.4 11:11:46 INFO - psutil == 3.1.1 11:11:46 INFO - requests == 1.2.3 11:11:46 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv 11:11:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:46 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 0x02384B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x0233EEA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02446980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01CF8B48>, '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 0x01D1A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02824660>, '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-018', 'USERDOMAIN': 'T-W864-IX-018', '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-018', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-018\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-018', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-018', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-018', '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-018\\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 11:11:46 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 11:11:46 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 11:11:46 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 11:11:46 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-018\\AppData\\Roaming', 11:11:46 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 11:11:46 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 11:11:46 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 11:11:46 INFO - 'COMPUTERNAME': 'T-W864-IX-018', 11:11:46 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 11:11:46 INFO - 'DCLOCATION': 'SCL3', 11:11:46 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 11:11:46 INFO - 'FP_NO_HOST_CHECK': 'NO', 11:11:46 INFO - 'HOMEDRIVE': 'C:', 11:11:46 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-018', 11:11:46 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 11:11:46 INFO - 'KTS_VERSION': '1.19c', 11:11:46 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-018\\AppData\\Local', 11:11:46 INFO - 'LOGONSERVER': '\\\\T-W864-IX-018', 11:11:46 INFO - 'MONDIR': 'C:\\Monitor_config\\', 11:11:46 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 11:11:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:46 INFO - 'MOZ_NO_REMOTE': '1', 11:11:46 INFO - 'NO_EM_RESTART': '1', 11:11:46 INFO - 'NUMBER_OF_PROCESSORS': '8', 11:11:46 INFO - 'OS': 'Windows_NT', 11:11:46 INFO - 'OURDRIVE': 'C:', 11:11:46 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 11:11:46 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 11:11:46 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 11:11:46 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 11:11:46 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 11:11:46 INFO - 'PROCESSOR_LEVEL': '6', 11:11:46 INFO - 'PROCESSOR_REVISION': '1e05', 11:11:46 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 11:11:46 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 11:11:46 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 11:11:46 INFO - 'PROGRAMW6432': 'C:\\Program Files', 11:11:46 INFO - 'PROMPT': '$P$G', 11:11:46 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 11:11:46 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 11:11:46 INFO - 'PUBLIC': 'C:\\Users\\Public', 11:11:46 INFO - 'PWD': 'C:\\slave\\test-pgo', 11:11:46 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 11:11:46 INFO - 'SLAVEDIR': 'C:\\slave\\', 11:11:46 INFO - 'SYSTEMDRIVE': 'C:', 11:11:46 INFO - 'SYSTEMROOT': 'C:\\windows', 11:11:46 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:11:46 INFO - 'TEST1': 'testie', 11:11:46 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:11:46 INFO - 'USERDOMAIN': 'T-W864-IX-018', 11:11:46 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-018', 11:11:46 INFO - 'USERNAME': 'cltbld', 11:11:46 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-018', 11:11:46 INFO - 'WINDIR': 'C:\\windows', 11:11:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 11:11:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:11:46 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)) 11:11:46 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)) 11:11:46 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)) 11:11:46 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)) 11:11:46 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)) 11:11:46 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)) 11:11:46 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)) 11:11:46 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)) 11:11:46 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)) 11:11:46 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)) 11:11:46 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)) 11:11:46 INFO - Cleaning up... 11:11:46 INFO - Return code: 0 11:11:46 INFO - Running post-action listener: _resource_record_post_action 11:11:46 INFO - Running post-action listener: _start_resource_monitoring 11:11:46 INFO - Starting resource monitoring. 11:11:46 INFO - ##### 11:11:46 INFO - ##### Running install step. 11:11:46 INFO - ##### 11:11:46 INFO - Running pre-action listener: _resource_record_pre_action 11:11:46 INFO - Running main action method: install 11:11:46 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'freeze'] 11:11:46 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip freeze 11:11:47 INFO - Reading from file tmpfile_stdout 11:11:47 INFO - Using _rmtree_windows ... 11:11:47 INFO - Using _rmtree_windows ... 11:11:47 INFO - Detecting whether we're running mozinstall >=1.0... 11:11:47 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build/venv/scripts/python', 'C:\\slave\\test-pgo\\build/venv/scripts/mozinstall-script.py', '-h'] 11:11:47 INFO - Copy/paste: C:\slave\test-pgo\build/venv/scripts/python C:\slave\test-pgo\build/venv/scripts/mozinstall-script.py -h 11:11:47 INFO - Reading from file tmpfile_stdout 11:11:47 INFO - Output received: 11:11:47 INFO - Usage: mozinstall-script.py [options] installer 11:11:47 INFO - Options: 11:11:47 INFO - -h, --help show this help message and exit 11:11:47 INFO - -d DEST, --destination=DEST 11:11:47 INFO - Directory to install application into. [default: 11:11:47 INFO - "C:\slave\test-pgo"] 11:11:47 INFO - --app=APP Application being installed. [default: firefox] 11:11:47 INFO - Using _rmtree_windows ... 11:11:47 INFO - Using _rmtree_windows ... 11:11:47 INFO - mkdir: C:\slave\test-pgo\build\application 11:11:47 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'] 11:11:47 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 11:11:48 INFO - Reading from file tmpfile_stdout 11:11:48 INFO - Output received: 11:11:48 INFO - C:\slave\test-pgo\build\application\firefox\firefox.exe 11:11:48 INFO - Using _rmtree_windows ... 11:11:48 INFO - Using _rmtree_windows ... 11:11:48 INFO - Running post-action listener: _resource_record_post_action 11:11:48 INFO - ##### 11:11:48 INFO - ##### Running run-tests step. 11:11:48 INFO - ##### 11:11:48 INFO - Running pre-action listener: _resource_record_pre_action 11:11:48 INFO - Running main action method: run_tests 11:11:48 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\python', '--version'] 11:11:48 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\python --version 11:11:48 INFO - Python 2.7.3 11:11:48 INFO - Return code: 0 11:11:48 INFO - grabbing minidump binary from tooltool 11:11:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:11:48 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 0x01CF8B48>, '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 0x01D1A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x02824660>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'privileged': False}, attempt #1 11:11:48 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 11:11:48 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 11:11:48 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 11:11:51 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test-pgo\build\tmptcigrh 11:11:51 INFO - INFO - File integrity verified, renaming tmptcigrh to win32-minidump_stackwalk.exe 11:11:51 INFO - Return code: 0 11:11:51 INFO - Chmoding C:\slave\test-pgo\build\win32-minidump_stackwalk.exe to 0755 11:11:51 INFO - mkdir: C:\slave\test-pgo\build\blobber_upload_dir 11:11:51 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test-pgo\build\blobber_upload_dir 11:11:51 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test-pgo\build\win32-minidump_stackwalk.exe 11:11:51 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test-pgo\build\blobber_upload_dir 11:11:51 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/KrxNkT0ETkm3QjvaZp-Auw/artifacts/public/build/firefox-44.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-018', '--webServer', 'localhost'] in C:\slave\test-pgo\build 11:11:51 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/KrxNkT0ETkm3QjvaZp-Auw/artifacts/public/build/firefox-44.0a1.en-US.win64.crashreporter-symbols.zip --title T-W864-IX-018 --webServer localhost 11:11:51 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 11:11:51 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-018\\AppData\\Roaming', 11:11:51 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 11:11:51 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 11:11:51 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 11:11:51 INFO - 'COMPUTERNAME': 'T-W864-IX-018', 11:11:51 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 11:11:51 INFO - 'DCLOCATION': 'SCL3', 11:11:51 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 11:11:51 INFO - 'FP_NO_HOST_CHECK': 'NO', 11:11:51 INFO - 'HOMEDRIVE': 'C:', 11:11:51 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-018', 11:11:51 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 11:11:51 INFO - 'KTS_VERSION': '1.19c', 11:11:51 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-018\\AppData\\Local', 11:11:51 INFO - 'LOGONSERVER': '\\\\T-W864-IX-018', 11:11:51 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test-pgo\\build\\blobber_upload_dir', 11:11:51 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test-pgo\\build\\win32-minidump_stackwalk.exe', 11:11:51 INFO - 'MONDIR': 'C:\\Monitor_config\\', 11:11:51 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 11:11:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:51 INFO - 'MOZ_NO_REMOTE': '1', 11:11:51 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test-pgo\\build\\blobber_upload_dir', 11:11:51 INFO - 'NO_EM_RESTART': '1', 11:11:51 INFO - 'NUMBER_OF_PROCESSORS': '8', 11:11:51 INFO - 'OS': 'Windows_NT', 11:11:51 INFO - 'OURDRIVE': 'C:', 11:11:51 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 11:11:51 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 11:11:51 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 11:11:51 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 11:11:51 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 11:11:51 INFO - 'PROCESSOR_LEVEL': '6', 11:11:51 INFO - 'PROCESSOR_REVISION': '1e05', 11:11:51 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 11:11:51 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 11:11:51 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 11:11:51 INFO - 'PROGRAMW6432': 'C:\\Program Files', 11:11:51 INFO - 'PROMPT': '$P$G', 11:11:51 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 11:11:51 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 11:11:51 INFO - 'PUBLIC': 'C:\\Users\\Public', 11:11:51 INFO - 'PWD': 'C:\\slave\\test-pgo', 11:11:51 INFO - 'PYTHONPATH': 'C:\\slave\\test-pgo\\build\\tests\\talos', 11:11:51 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 11:11:51 INFO - 'SLAVEDIR': 'C:\\slave\\', 11:11:51 INFO - 'SYSTEMDRIVE': 'C:', 11:11:51 INFO - 'SYSTEMROOT': 'C:\\windows', 11:11:51 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:11:51 INFO - 'TEST1': 'testie', 11:11:51 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 11:11:51 INFO - 'USERDOMAIN': 'T-W864-IX-018', 11:11:51 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-018', 11:11:51 INFO - 'USERNAME': 'cltbld', 11:11:51 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-018', 11:11:51 INFO - 'WINDIR': 'C:\\windows', 11:11:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 11:11:51 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/KrxNkT0ETkm3QjvaZp-Auw/artifacts/public/build/firefox-44.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-018', '--webServer', 'localhost'] with output_timeout 3600 ProcessManager NOT managing child processes ProcessManager UNABLE to use job objects to manage child processes 11:11:52 INFO - mozversion INFO | application_buildid: 20151027053027 11:11:52 INFO - mozversion INFO | application_changeset: 47e4f94c33259fbcb8e5962360ac68030fc15bce 11:11:52 INFO - mozversion INFO | application_display_name: Nightly 11:11:52 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:11:52 INFO - mozversion INFO | application_name: Firefox 11:11:52 INFO - mozversion INFO | application_remotingname: firefox 11:11:52 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 11:11:52 INFO - mozversion INFO | application_vendor: Mozilla 11:11:52 INFO - mozversion INFO | application_version: 44.0a1 11:11:52 INFO - mozversion INFO | platform_buildid: 20151027053027 11:11:52 INFO - mozversion INFO | platform_changeset: 47e4f94c33259fbcb8e5962360ac68030fc15bce 11:11:52 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 11:11:52 INFO - mozversion INFO | platform_version: 44.0a1 11:11:52 INFO - 2015-10-27 11:11:52,006 DEBUG : using testdate: 1445969512 11:11:52 INFO - 2015-10-27 11:11:52,006 DEBUG : actual date: 1445969512 11:11:52 INFO - 2015-10-27 11:11:52,016 INFO : starting webserver on 'localhost:49268' 11:11:52 INFO - 2015-10-27 11:11:52,016 INFO : Starting test suite T-W864-IX-018 11:11:52 INFO - 2015-10-27 11:11:52,016 INFO : Starting test dromaeo_css 11:11:52 INFO - 2015-10-27 11:11:52,016 DEBUG : operating with platform_type : w8_ 11:11:52 INFO - 2015-10-27 11:11:52,017 INFO : Initialising browser for dromaeo_css test... 11:11:52 INFO - 2015-10-27 11:11:52,188 DEBUG : command line: C:\slave\test-pgo\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpdmssty\profile http://localhost:49268/getInfo.html 11:12:00 INFO - 2015-10-27 11:12:00,795 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:12:00 INFO - 2015-10-27 11:12:00,795 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:12:00 INFO - 2015-10-27 11:12:00,795 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674 11:12:00 INFO - 2015-10-27 11:12:00,795 DEBUG : BROWSER_OUTPUT: __metrics 11:12:00 INFO - 2015-10-27 11:12:00,921 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:12:02 INFO - 2015-10-27 11:12:02,038 DEBUG : BROWSER_OUTPUT: console.error: 11:12:02 INFO - 2015-10-27 11:12:02,038 DEBUG : BROWSER_OUTPUT: Message: [Exception... "Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [mozIStorageAsyncStatement.executeAsync]" nsresult: "0x80040111 (NS_ERROR_NOT_AVAILABLE)" location: "JS frame :: resource://gre/modules/Sqlite.jsm :: ConnectionData.prototype<._executeStatement :: line 758" data: no] 11:12:02 INFO - 2015-10-27 11:12:02,039 DEBUG : BROWSER_OUTPUT: Stack: 11:12:02 INFO - 2015-10-27 11:12:02,039 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<._executeStatement@resource://gre/modules/Sqlite.jsm:758:19 11:12:02 INFO - 2015-10-27 11:12:02,039 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached/<@resource://gre/modules/Sqlite.jsm:493:9 11:12:02 INFO - 2015-10-27 11:12:02,039 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached@resource://gre/modules/Sqlite.jsm:491:1 11:12:02 INFO - 2015-10-27 11:12:02,039 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeBeforeShutdown/loggedDb<.executeCached.value<@resource://gre/modules/Sqlite.jsm:368:51 11:12:02 INFO - 2015-10-27 11:12:02,039 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 11:12:02 INFO - 2015-10-27 11:12:02,039 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 11:12:02 INFO - 2015-10-27 11:12:02,039 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 11:12:02 INFO - 2015-10-27 11:12:02,039 DEBUG : BROWSER_OUTPUT: transaction@resource://gre/modules/Bookmarks.jsm:783:15 11:12:02 INFO - 2015-10-27 11:12:02,039 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 11:12:02 INFO - 2015-10-27 11:12:02,039 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 11:12:02 INFO - 2015-10-27 11:12:02,039 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 11:12:02 INFO - 2015-10-27 11:12:02,039 DEBUG : BROWSER_OUTPUT: Task_spawn@resource://gre/modules/Task.jsm:164:12 11:12:02 INFO - 2015-10-27 11:12:02,039 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 11:30:37 INFO - 2015-10-27 11:30:37,684 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 11:30:37 INFO - 2015-10-27 11:30:37,684 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 11:30:37 INFO - 2015-10-27 11:30:37,684 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 11:30:37 INFO - 2015-10-27 11:30:37,684 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 11:30:37 INFO - 2015-10-27 11:30:37,684 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 11:30:37 INFO - 2015-10-27 11:30:37,684 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 11:30:37 INFO - 2015-10-27 11:30:37,684 DEBUG : BROWSER_OUTPUT: 11:30:38 INFO - 2015-10-27 11:30:38,447 INFO : Browser initialized. 11:30:38 INFO - 2015-10-27 11:30:38,447 INFO : Running cycle 1/1 for kraken test... 11:30:38 INFO - 2015-10-27 11:30:38,447 DEBUG : command line: C:\slave\test-pgo\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmpak1qrr\profile -tp file:\C:\slave\test-pgo\build\tests\talos\talos\tests\kraken\kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:30:49 INFO - 2015-10-27 11:30:49,812 DEBUG : BROWSER_OUTPUT: RSS: Main: 191168512 11:30:49 INFO - 2015-10-27 11:30:49,812 DEBUG : BROWSER_OUTPUT: 11:30:52 INFO - 2015-10-27 11:30:52,382 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection) 11:30:52 INFO - 2015-10-27 11:30:52,966 DEBUG : BROWSER_OUTPUT: RSS: Main: 228413440 11:30:52 INFO - 2015-10-27 11:30:52,966 DEBUG : BROWSER_OUTPUT: 11:30:55 INFO - 2015-10-27 11:30:55,483 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-dft) 11:30:56 INFO - 2015-10-27 11:30:56,059 DEBUG : BROWSER_OUTPUT: RSS: Main: 226062336 11:30:56 INFO - 2015-10-27 11:30:56,059 DEBUG : BROWSER_OUTPUT: 11:30:58 INFO - 2015-10-27 11:30:58,654 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-fft) 11:30:59 INFO - 2015-10-27 11:30:59,237 DEBUG : BROWSER_OUTPUT: RSS: Main: 212221952 11:30:59 INFO - 2015-10-27 11:30:59,237 DEBUG : BROWSER_OUTPUT: 11:31:01 INFO - 2015-10-27 11:31:01,119 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator) 11:31:01 INFO - 2015-10-27 11:31:01,686 DEBUG : BROWSER_OUTPUT: RSS: Main: 207335424 11:31:01 INFO - 2015-10-27 11:31:01,686 DEBUG : BROWSER_OUTPUT: 11:31:03 INFO - 2015-10-27 11:31:03,742 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:31:04 INFO - 2015-10-27 11:31:04,296 DEBUG : BROWSER_OUTPUT: RSS: Main: 211320832 11:31:04 INFO - 2015-10-27 11:31:04,296 DEBUG : BROWSER_OUTPUT: 11:31:07 INFO - 2015-10-27 11:31:07,282 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom) 11:31:07 INFO - 2015-10-27 11:31:07,865 DEBUG : BROWSER_OUTPUT: RSS: Main: 205824000 11:31:07 INFO - 2015-10-27 11:31:07,865 DEBUG : BROWSER_OUTPUT: 11:31:11 INFO - 2015-10-27 11:31:11,134 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate) 11:31:11 INFO - 2015-10-27 11:31:11,710 DEBUG : BROWSER_OUTPUT: RSS: Main: 202842112 11:31:11 INFO - 2015-10-27 11:31:11,711 DEBUG : BROWSER_OUTPUT: 11:31:14 INFO - 2015-10-27 11:31:14,515 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial) 11:31:15 INFO - 2015-10-27 11:31:15,099 DEBUG : BROWSER_OUTPUT: RSS: Main: 201121792 11:31:15 INFO - 2015-10-27 11:31:15,099 DEBUG : BROWSER_OUTPUT: 11:31:16 INFO - 2015-10-27 11:31:16,798 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:31:17 INFO - 2015-10-27 11:31:17,364 DEBUG : BROWSER_OUTPUT: RSS: Main: 229539840 11:31:17 INFO - 2015-10-27 11:31:17,364 DEBUG : BROWSER_OUTPUT: 11:31:19 INFO - 2015-10-27 11:31:19,115 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:31:19 INFO - 2015-10-27 11:31:19,690 DEBUG : BROWSER_OUTPUT: RSS: Main: 234156032 11:31:19 INFO - 2015-10-27 11:31:19,690 DEBUG : BROWSER_OUTPUT: 11:31:21 INFO - 2015-10-27 11:31:21,832 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:31:22 INFO - 2015-10-27 11:31:22,414 DEBUG : BROWSER_OUTPUT: RSS: Main: 219619328 11:31:22 INFO - 2015-10-27 11:31:22,414 DEBUG : BROWSER_OUTPUT: 11:31:24 INFO - 2015-10-27 11:31:24,773 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:31:25 INFO - 2015-10-27 11:31:25,358 DEBUG : BROWSER_OUTPUT: RSS: Main: 221790208 11:31:25 INFO - 2015-10-27 11:31:25,358 DEBUG : BROWSER_OUTPUT: 11:31:27 INFO - 2015-10-27 11:31:27,957 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:31:28 INFO - 2015-10-27 11:31:28,538 DEBUG : BROWSER_OUTPUT: RSS: Main: 223338496 11:31:28 INFO - 2015-10-27 11:31:28,538 DEBUG : BROWSER_OUTPUT: 11:31:30 INFO - 2015-10-27 11:31:30,216 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49268/tests/kraken/driver.html?testName=ai-astar) 11:31:30 INFO - 2015-10-27 11:31:30,467 DEBUG : BROWSER_OUTPUT: RSS: Main: 278851584 11:31:30 INFO - 2015-10-27 11:31:30,467 DEBUG : BROWSER_OUTPUT: 11:31:30 INFO - 2015-10-27 11:31:30,470 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:31:30 INFO - 2015-10-27 11:31:30,470 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:31:30 INFO - 2015-10-27 11:31:30,470 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:31:30 INFO - 2015-10-27 11:31:30,470 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:31:30 INFO - 2015-10-27 11:31:30,470 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;110;104;109;108;108;108;108;101;108 11:31:30 INFO - 2015-10-27 11:31:30,470 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;127;122;141;151;123;131;130;123;151;125 11:31:30 INFO - 2015-10-27 11:31:30,470 DEBUG : BROWSER_OUTPUT: |2;audio-dft;141;140;142;151;140;140;140;143;139;139 11:31:30 INFO - 2015-10-27 11:31:30,470 DEBUG : BROWSER_OUTPUT: |3;audio-fft;68;69;71;91;70;69;69;69;98;66 11:31:30 INFO - 2015-10-27 11:31:30,470 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;86;86;107;86;86;88;114;87;86;116 11:31:30 INFO - 2015-10-27 11:31:30,470 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;113;110;110;111;110;110;111;110;111 11:31:30 INFO - 2015-10-27 11:31:30,470 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;131;132;132;133;131;132;132;135;132;131 11:31:30 INFO - 2015-10-27 11:31:30,470 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;96;96;98;98;105;98;96;97;95 11:31:30 INFO - 2015-10-27 11:31:30,470 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;73;73;72;71;72;72;85;72;72 11:31:30 INFO - 2015-10-27 11:31:30,470 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;65;65;65;65;65;65;65;65;64 11:31:30 INFO - 2015-10-27 11:31:30,470 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;89;87;88;87;89;89;90;89;90;89 11:31:30 INFO - 2015-10-27 11:31:30,470 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;115;113;114;115;115;123;122;121;115;120 11:31:30 INFO - 2015-10-27 11:31:30,470 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;161;145;152;154;154;152;155;156;152;144 11:31:30 INFO - 2015-10-27 11:31:30,470 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;68;68;68;67;69;67;67;69;68 11:31:30 INFO - 2015-10-27 11:31:30,470 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:31:30 INFO - 2015-10-27 11:31:30,470 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:31:30 INFO - 2015-10-27 11:31:30,470 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,957 11:31:30 INFO - 2015-10-27 11:31:30,470 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:31:30 INFO - 2015-10-27 11:31:30,470 DEBUG : BROWSER_OUTPUT: __startTimestamp1445970690469__endTimestamp 11:31:30 INFO - 2015-10-27 11:31:30,471 DEBUG : BROWSER_OUTPUT: 11:31:30 INFO - 2015-10-27 11:31:30,471 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:31:30 INFO - 2015-10-27 11:31:30,471 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:31:30 INFO - 2015-10-27 11:31:30,471 DEBUG : BROWSER_OUTPUT: 11:31:30 INFO - 2015-10-27 11:31:30,471 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.40 Median:108.00 stddev:2.80 (2.6%) stddev-sans-first:2.80 11:31:30 INFO - 2015-10-27 11:31:30,473 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 104.0 109.0 108.0 108.0 108.0 108.0 101.0 108.0 11:31:30 INFO - 2015-10-27 11:31:30,473 DEBUG : BROWSER_OUTPUT: 11:31:30 INFO - 2015-10-27 11:31:30,473 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:132.40 Median:130.50 stddev:11.27 (8.6%) stddev-sans-first:11.78 11:31:30 INFO - 2015-10-27 11:31:30,473 DEBUG : BROWSER_OUTPUT: Values: 127.0 122.0 141.0 151.0 123.0 131.0 130.0 123.0 151.0 125.0 11:31:30 INFO - 2015-10-27 11:31:30,473 DEBUG : BROWSER_OUTPUT: 11:31:30 INFO - 2015-10-27 11:31:30,473 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:141.50 Median:140.50 stddev:3.57 (2.5%) stddev-sans-first:3.78 11:31:30 INFO - 2015-10-27 11:31:30,473 DEBUG : BROWSER_OUTPUT: Values: 141.0 140.0 142.0 151.0 140.0 140.0 140.0 143.0 139.0 139.0 11:31:30 INFO - 2015-10-27 11:31:30,473 DEBUG : BROWSER_OUTPUT: 11:31:30 INFO - 2015-10-27 11:31:30,474 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:74.00 Median:69.50 stddev:11.01 (15.8%) stddev-sans-first:11.46 11:31:30 INFO - 2015-10-27 11:31:30,474 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 71.0 91.0 70.0 69.0 69.0 69.0 98.0 66.0 11:31:30 INFO - 2015-10-27 11:31:30,474 DEBUG : BROWSER_OUTPUT: 11:31:30 INFO - 2015-10-27 11:31:30,474 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:94.20 Median:86.00 stddev:12.73 (14.8%) stddev-sans-first:13.15 11:31:30 INFO - 2015-10-27 11:31:30,474 DEBUG : BROWSER_OUTPUT: Values: 86.0 86.0 107.0 86.0 86.0 88.0 114.0 87.0 86.0 116.0 11:31:30 INFO - 2015-10-27 11:31:30,476 DEBUG : BROWSER_OUTPUT: 11:31:30 INFO - 2015-10-27 11:31:30,476 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.70 Median:111.00 stddev:0.95 (0.9%) stddev-sans-first:1.00 11:31:30 INFO - 2015-10-27 11:31:30,476 DEBUG : BROWSER_OUTPUT: Values: 111.0 113.0 110.0 110.0 111.0 110.0 110.0 111.0 110.0 111.0 11:31:30 INFO - 2015-10-27 11:31:30,477 DEBUG : BROWSER_OUTPUT: 11:31:30 INFO - 2015-10-27 11:31:30,477 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:132.10 Median:132.00 stddev:1.20 (0.9%) stddev-sans-first:1.20 11:31:30 INFO - 2015-10-27 11:31:30,477 DEBUG : BROWSER_OUTPUT: Values: 131.0 132.0 132.0 133.0 131.0 132.0 132.0 135.0 132.0 131.0 11:31:30 INFO - 2015-10-27 11:31:30,477 DEBUG : BROWSER_OUTPUT: 11:31:30 INFO - 2015-10-27 11:31:30,479 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:97.60 Median:97.00 stddev:2.80 (2.9%) stddev-sans-first:2.96 11:31:30 INFO - 2015-10-27 11:31:30,479 DEBUG : BROWSER_OUTPUT: Values: 97.0 96.0 96.0 98.0 98.0 105.0 98.0 96.0 97.0 95.0 11:31:30 INFO - 2015-10-27 11:31:30,479 DEBUG : BROWSER_OUTPUT: 11:31:30 INFO - 2015-10-27 11:31:30,479 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.50 Median:72.50 stddev:4.09 (5.6%) stddev-sans-first:4.33 11:31:30 INFO - 2015-10-27 11:31:30,480 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 73.0 72.0 71.0 72.0 72.0 85.0 72.0 72.0 11:31:30 INFO - 2015-10-27 11:31:30,480 DEBUG : BROWSER_OUTPUT: 11:31:30 INFO - 2015-10-27 11:31:30,480 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 11:31:30 INFO - 2015-10-27 11:31:30,480 DEBUG : BROWSER_OUTPUT: Values: 65.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 64.0 11:31:30 INFO - 2015-10-27 11:31:30,480 DEBUG : BROWSER_OUTPUT: 11:31:30 INFO - 2015-10-27 11:31:30,480 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:88.70 Median:89.00 stddev:1.06 (1.2%) stddev-sans-first:1.12 11:31:30 INFO - 2015-10-27 11:31:30,480 DEBUG : BROWSER_OUTPUT: Values: 89.0 87.0 88.0 87.0 89.0 89.0 90.0 89.0 90.0 89.0 11:31:30 INFO - 2015-10-27 11:31:30,480 DEBUG : BROWSER_OUTPUT: 11:31:30 INFO - 2015-10-27 11:31:30,482 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:117.30 Median:117.50 stddev:3.74 (3.2%) stddev-sans-first:3.88 11:31:30 INFO - 2015-10-27 11:31:30,482 DEBUG : BROWSER_OUTPUT: Values: 115.0 113.0 114.0 115.0 115.0 123.0 122.0 121.0 115.0 120.0 11:31:30 INFO - 2015-10-27 11:31:30,482 DEBUG : BROWSER_OUTPUT: 11:31:30 INFO - 2015-10-27 11:31:30,482 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.50 Median:154.00 stddev:4.99 (3.2%) stddev-sans-first:4.25 11:31:30 INFO - 2015-10-27 11:31:30,483 DEBUG : BROWSER_OUTPUT: Values: 161.0 145.0 152.0 154.0 154.0 152.0 155.0 156.0 152.0 144.0 11:31:30 INFO - 2015-10-27 11:31:30,483 DEBUG : BROWSER_OUTPUT: 11:31:30 INFO - 2015-10-27 11:31:30,483 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 11:31:30 INFO - 2015-10-27 11:31:30,483 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 68.0 68.0 67.0 69.0 67.0 67.0 69.0 68.0 11:31:30 INFO - 2015-10-27 11:31:30,483 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:31:30 INFO - 2015-10-27 11:31:30,483 DEBUG : BROWSER_OUTPUT: 11:31:31 INFO - 2015-10-27 11:31:31,137 INFO : Browser exited with error code: 0 11:31:32 INFO - 2015-10-27 11:31:31,992 INFO : Completed test kraken (00:01:00) 11:31:32 INFO - 2015-10-27 11:31:31,992 INFO : Starting test v8_7 11:31:32 INFO - 2015-10-27 11:31:31,992 DEBUG : operating with platform_type : w8_ 11:31:32 INFO - 2015-10-27 11:31:31,992 INFO : Initialising browser for v8_7 test... 11:31:32 INFO - 2015-10-27 11:31:32,013 DEBUG : command line: C:\slave\test-pgo\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmp_lq_jv\profile http://localhost:49268/getInfo.html 11:31:37 INFO - 2015-10-27 11:31:37,736 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:31:37 INFO - 2015-10-27 11:31:37,736 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:31:37 INFO - 2015-10-27 11:31:37,736 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674 11:31:37 INFO - 2015-10-27 11:31:37,736 DEBUG : BROWSER_OUTPUT: __metrics 11:31:37 INFO - 2015-10-27 11:31:37,903 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:31:38 INFO - 2015-10-27 11:31:38,124 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 11:31:38 INFO - 2015-10-27 11:31:38,325 DEBUG : BROWSER_OUTPUT: console.error: 11:31:38 INFO - 2015-10-27 11:31:38,325 DEBUG : BROWSER_OUTPUT: Message: [Exception... "Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [mozIStorageAsyncStatement.executeAsync]" nsresult: "0x80040111 (NS_ERROR_NOT_AVAILABLE)" location: "JS frame :: resource://gre/modules/Sqlite.jsm :: ConnectionData.prototype<._executeStatement :: line 758" data: no] 11:31:38 INFO - 2015-10-27 11:31:38,325 DEBUG : BROWSER_OUTPUT: Stack: 11:31:38 INFO - 2015-10-27 11:31:38,325 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<._executeStatement@resource://gre/modules/Sqlite.jsm:758:19 11:31:38 INFO - 2015-10-27 11:31:38,325 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached/<@resource://gre/modules/Sqlite.jsm:493:9 11:31:38 INFO - 2015-10-27 11:31:38,325 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached@resource://gre/modules/Sqlite.jsm:491:1 11:31:38 INFO - 2015-10-27 11:31:38,325 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeBeforeShutdown/loggedDb<.executeCached.value<@resource://gre/modules/Sqlite.jsm:368:51 11:31:38 INFO - 2015-10-27 11:31:38,325 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 11:31:38 INFO - 2015-10-27 11:31:38,325 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 11:31:38 INFO - 2015-10-27 11:31:38,325 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 11:31:38 INFO - 2015-10-27 11:31:38,325 DEBUG : BROWSER_OUTPUT: transaction@resource://gre/modules/Bookmarks.jsm:798:13 11:31:38 INFO - 2015-10-27 11:31:38,325 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 11:31:38 INFO - 2015-10-27 11:31:38,325 DEBUG : BROWSER_OUTPUT: Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:934:23 11:31:38 INFO - 2015-10-27 11:31:38,325 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 11:31:38 INFO - 2015-10-27 11:31:38,325 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 11:31:38 INFO - 2015-10-27 11:31:38,325 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 11:31:38 INFO - 2015-10-27 11:31:38,325 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 11:31:38 INFO - 2015-10-27 11:31:38,325 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 11:31:38 INFO - 2015-10-27 11:31:38,325 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 11:31:38 INFO - 2015-10-27 11:31:38,325 DEBUG : BROWSER_OUTPUT: 11:31:38 INFO - 2015-10-27 11:31:38,990 INFO : Browser initialized. 11:31:38 INFO - 2015-10-27 11:31:38,990 INFO : Running cycle 1/1 for v8_7 test... 11:31:38 INFO - 2015-10-27 11:31:38,990 DEBUG : command line: C:\slave\test-pgo\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmp_lq_jv\profile -tp file:\C:\slave\test-pgo\build\tests\talos\talos\tests\v8_7\v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:31:50 INFO - 2015-10-27 11:31:50,338 DEBUG : BROWSER_OUTPUT: RSS: Main: 167632896 11:31:50 INFO - 2015-10-27 11:31:50,338 DEBUG : BROWSER_OUTPUT: 11:32:12 INFO - 2015-10-27 11:32:12,157 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/v8_7/run.html (next: http://localhost:49268/tests/v8_7/run.html) 11:32:12 INFO - 2015-10-27 11:32:12,407 DEBUG : BROWSER_OUTPUT: RSS: Main: 625795072 11:32:12 INFO - 2015-10-27 11:32:12,407 DEBUG : BROWSER_OUTPUT: 11:32:12 INFO - 2015-10-27 11:32:12,408 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:32:12 INFO - 2015-10-27 11:32:12,408 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:32:12 INFO - 2015-10-27 11:32:12,408 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:32:12 INFO - 2015-10-27 11:32:12,410 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:32:12 INFO - 2015-10-27 11:32:12,410 DEBUG : BROWSER_OUTPUT: |0;Richards;165.371258475277 11:32:12 INFO - 2015-10-27 11:32:12,410 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;180.635838150289 11:32:12 INFO - 2015-10-27 11:32:12,410 DEBUG : BROWSER_OUTPUT: |2;Encrypt;285.6326763781777 11:32:12 INFO - 2015-10-27 11:32:12,410 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5070.707070707071 11:32:12 INFO - 2015-10-27 11:32:12,410 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1592.3566878980891 11:32:12 INFO - 2015-10-27 11:32:12,410 DEBUG : BROWSER_OUTPUT: |5;Earley;667.1114076050701 11:32:12 INFO - 2015-10-27 11:32:12,411 DEBUG : BROWSER_OUTPUT: |6;Boyer;12675 11:32:12 INFO - 2015-10-27 11:32:12,411 DEBUG : BROWSER_OUTPUT: |7;RegExp;27432.432432432433 11:32:12 INFO - 2015-10-27 11:32:12,411 DEBUG : BROWSER_OUTPUT: |8;Splay;706.2146892655368 11:32:12 INFO - 2015-10-27 11:32:12,411 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4864.077669902913 11:32:12 INFO - 2015-10-27 11:32:12,411 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:32:12 INFO - 2015-10-27 11:32:12,411 DEBUG : BROWSER_OUTPUT: __startTimestamp1445970732407__endTimestamp 11:32:12 INFO - 2015-10-27 11:32:12,411 DEBUG : BROWSER_OUTPUT: 11:32:12 INFO - 2015-10-27 11:32:12,411 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:32:12 INFO - 2015-10-27 11:32:12,411 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:32:12 INFO - 2015-10-27 11:32:12,411 DEBUG : BROWSER_OUTPUT: 11:32:12 INFO - 2015-10-27 11:32:12,411 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.37 Median:165.37 stddev:0.00 (0.0%) 11:32:12 INFO - 2015-10-27 11:32:12,411 DEBUG : BROWSER_OUTPUT: Values: 165.4 11:32:12 INFO - 2015-10-27 11:32:12,411 DEBUG : BROWSER_OUTPUT: 11:32:12 INFO - 2015-10-27 11:32:12,411 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:180.64 Median:180.64 stddev:0.00 (0.0%) 11:32:12 INFO - 2015-10-27 11:32:12,411 DEBUG : BROWSER_OUTPUT: Values: 180.6 11:32:12 INFO - 2015-10-27 11:32:12,411 DEBUG : BROWSER_OUTPUT: 11:32:12 INFO - 2015-10-27 11:32:12,411 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:285.63 Median:285.63 stddev:0.00 (0.0%) 11:32:12 INFO - 2015-10-27 11:32:12,411 DEBUG : BROWSER_OUTPUT: Values: 285.6 11:32:12 INFO - 2015-10-27 11:32:12,411 DEBUG : BROWSER_OUTPUT: 11:32:12 INFO - 2015-10-27 11:32:12,411 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5070.71 Median:5070.71 stddev:0.00 (0.0%) 11:32:12 INFO - 2015-10-27 11:32:12,411 DEBUG : BROWSER_OUTPUT: Values: 5070.7 11:32:12 INFO - 2015-10-27 11:32:12,411 DEBUG : BROWSER_OUTPUT: 11:32:12 INFO - 2015-10-27 11:32:12,411 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1592.36 Median:1592.36 stddev:0.00 (0.0%) 11:32:12 INFO - 2015-10-27 11:32:12,411 DEBUG : BROWSER_OUTPUT: Values: 1592.4 11:32:12 INFO - 2015-10-27 11:32:12,411 DEBUG : BROWSER_OUTPUT: 11:32:12 INFO - 2015-10-27 11:32:12,411 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:667.11 Median:667.11 stddev:0.00 (0.0%) 11:32:12 INFO - 2015-10-27 11:32:12,411 DEBUG : BROWSER_OUTPUT: Values: 667.1 11:32:12 INFO - 2015-10-27 11:32:12,411 DEBUG : BROWSER_OUTPUT: 11:32:12 INFO - 2015-10-27 11:32:12,413 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12675.00 Median:12675.00 stddev:0.00 (0.0%) 11:32:12 INFO - 2015-10-27 11:32:12,413 DEBUG : BROWSER_OUTPUT: Values: 12675.0 11:32:12 INFO - 2015-10-27 11:32:12,413 DEBUG : BROWSER_OUTPUT: 11:32:12 INFO - 2015-10-27 11:32:12,413 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27432.43 Median:27432.43 stddev:0.00 (0.0%) 11:32:12 INFO - 2015-10-27 11:32:12,413 DEBUG : BROWSER_OUTPUT: Values: 27432.4 11:32:12 INFO - 2015-10-27 11:32:12,413 DEBUG : BROWSER_OUTPUT: 11:32:12 INFO - 2015-10-27 11:32:12,413 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:706.21 Median:706.21 stddev:0.00 (0.0%) 11:32:12 INFO - 2015-10-27 11:32:12,413 DEBUG : BROWSER_OUTPUT: Values: 706.2 11:32:12 INFO - 2015-10-27 11:32:12,413 DEBUG : BROWSER_OUTPUT: 11:32:12 INFO - 2015-10-27 11:32:12,413 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4864.08 Median:4864.08 stddev:0.00 (0.0%) 11:32:12 INFO - 2015-10-27 11:32:12,413 DEBUG : BROWSER_OUTPUT: Values: 4864.1 11:32:12 INFO - 2015-10-27 11:32:12,413 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:32:12 INFO - 2015-10-27 11:32:12,413 DEBUG : BROWSER_OUTPUT: 11:32:13 INFO - 2015-10-27 11:32:13,055 INFO : Browser exited with error code: 0 11:32:13 INFO - 2015-10-27 11:32:13,742 INFO : Completed test v8_7 (00:00:41) 11:32:14 INFO - 2015-10-27 11:32:14,203 INFO : Completed test suite (00:20:22) 11:32:14 INFO - 2015-10-27 11:32:14,203 DEBUG : Working with test: dromaeo_css 11:32:14 INFO - 2015-10-27 11:32:14,203 DEBUG : Generating results file: dromaeo_css 11:32:14 INFO - 2015-10-27 11:32:14,203 DEBUG : Working with test: kraken 11:32:14 INFO - 2015-10-27 11:32:14,203 DEBUG : Generating results file: kraken 11:32:14 INFO - 2015-10-27 11:32:14,203 INFO : javascript benchmark 11:32:14 INFO - 2015-10-27 11:32:14,203 DEBUG : Working with test: v8_7 11:32:14 INFO - 2015-10-27 11:32:14,203 DEBUG : Generating results file: v8_7 11:32:14 INFO - 2015-10-27 11:32:14,203 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:32:14 INFO - 2015-10-27 11:32:14,339 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,201,31]] 11:32:14 INFO - 2015-10-27 11:32:14,339 DEBUG : process_Request line: dromaeo_css 6763.49 graph.html#tests=[[72,201,31]] 11:32:14 INFO - 2015-10-27 11:32:14,339 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:32:14 INFO - 2015-10-27 11:32:14,385 DEBUG : process_Request line: kraken 1454.60 graph.html#tests=[[232,201,31]] 11:32:14 INFO - 2015-10-27 11:32:14,385 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:32:14 INFO - 2015-10-27 11:32:14,415 DEBUG : process_Request line: v8_7 20210.73 graph.html#tests=[[230,201,31]] 11:32:14 INFO - 2015-10-27 11:32:14,417 INFO : javascript benchmark 11:32:14 INFO - 2015-10-27 11:32:14,418 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [338.56325340311, 338.87969770731377, 340.5844869259503, 344.7035549427493, 346.5148791691631, 14883.851161488381, 15275.770863437057, 17338.0, 17419.825801741994, 18200.453986380413, 11733.941330293337, 12045.397730113504, 16872.156392180405, 18460.44618661439, 18606.627867442643, 4534.591886730193, 4626.537346265363, 4636.235021221494, 4643.721376717391, 4658.90682186356, 3656.6708996190337, 3704.907377315562, 4612.907741845178, 4665.253559430492, 4937.185364414885, 4969.478204788499, 5040.823571175009, 5050.747462626872, 5059.696418214919, 5074.441811400743, 4930.556249937505, 4973.776180071905, 4983.352164218629, 5007.349044624212, 5052.166392545244, 4281.892952676208, 4284.0, 4285.849995250152, 4288.52826189119, 4293.334533147336, 13404.262765547892, 13813.447462101503, 13973.510927117604, 14015.089019213718, 14075.788863167061, 2087.5824835033054, 2096.5073207796154, 2110.0, 2123.150739704115, 2124.6812978053263, 9915.702528924145, 9993.100620944077, 10067.798644027152, 10093.192544596415, 10381.584736610526, 1689.6451745133536, 1719.8280171982701, 1759.1292310306353, 1784.8661350398772, 1789.391606853676, 70078.64960675164, 70820.04578580656, 71199.0, 71845.04712751305, 72300.6384968077, 6773.559718618274, 6797.830054248683, 6834.2482326944, 6844.452443804484, 6904.033435319059, 8034.919650803534, 8043.919560804434, 8046.114927357986, 8048.839023219502, 8072.233137851895, 5433.375161856437, 5468.26178465902, 5546.55627549795, 5572.86067848307, 5589.385167631557, 5792.623479473821, 5878.353381128072, 5897.756234071329, 5921.437463440966, 5945.583809133319, 3110.5489703992794, 3126.359096385281, 3132.420502207099, 3134.4044631519937, 3151.8108913465267, 1064.99467502662, 1075.451519724946, 1096.6819622309602, 1136.4090672850073, 1144.1361771862357, 427.3674961057652, 461.89607338349276, 462.782492228652, 488.9608831293488, 499.11407252127765, 11672.474738636782, 11951.701207469883, 11994.520219191134, 12024.639260822189, 12086.214396064228, 412.4534991136756, 489.87997940504806, 491.36368402917594, 491.5109466081272, 502.2792293059471, 6370.0, 6509.414152726277, 6548.869022619521, 6564.179477565304, 6615.933840661628, 127018.0, 128698.0, 660645.9934110914, 667216.0, 680326.0, 88792.78450508403, 90460.54769726109, 94739.52630236805, 96265.0, 97884.51057744808, 426.69064927927, 437.9934300985488, 438.6162108155364, 438.931965545341, 438.9978050109793, 9819.459929703935, 9853.704388868346, 9886.50567471609, 9902.0, 10013.299069065388, 38056.0, 38733.0, 38745.4188187183, 39470.80264598659, 39593.406098907966, 52768.0, 53841.19238211351, 53971.73014134904, 54012.189817151986, 54211.0, 7588.975488309007, 7596.620168991418, 7823.530588164728, 7892.526448413114, 7945.920540794518, 11370.20408571392, 11604.30374177552, 11634.36011019402, 11663.76672466563, 11742.236754610924, 10252.743681408025, 10367.533460994122, 10371.91094935021, 10375.221858360503, 10444.216683748597, 9895.901040989498, 10101.242406819665, 10122.392656440637, 10195.490225488547, 10241.487925603838, 10482.423466709099, 10491.475426228506, 10589.258751887603, 10642.574297028032, 10864.130869530261, 7788.299053085249, 7918.802029949297, 8002.83994320122, 8044.31623312025, 8071.07182674, 10684.0, 10831.729206769895, 10968.616098436516, 10982.560697572328, 10988.0], "dojo.html": [2902.317955280509, 2938.1038783171125, 2975.672676005639, 2988.9837455265206, 2995.490766569683, 5394.244805727201, 5451.509364157225, 5455.318085239345, 5465.207544905991, 5472.972635136829, 5477.616566840323, 5482.835514934558, 5488.067028605136, 5491.039068163075, 5491.313585801775, 4772.642051846108, 4843.975780121094, 4880.682755620874, 4882.41411030675, 4932.358793356877, 4821.059893320804, 4829.203181475053, 4853.587445067174, 4856.3686720726255, 4859.101066302727, 4697.812087516495, 4791.664583479141, 4804.44748853881, 4818.927716084261, 4835.443923948738, 4821.517848215186, 4832.879178020543, 4843.273508973647, 4848.151573474628, 4852.56326930578, 4791.257355109963, 4825.686330388514, 4825.879353016203, 4827.396575428072, 4829.637777166727, 5229.189475631245, 5311.681299122065, 5316.548093412064, 5318.095923692981, 5320.17537281722, 5588.385277619459, 5597.580181486404, 5660.405657405995, 5687.886242275132, 5697.77208911643, 5704.686242256675, 5779.508741756956, 5783.277090363705, 5785.103308987072, 5793.073108302693, 4902.28916807061, 5289.444608316148, 5291.206319052135, 5305.204219367087, 5315.787368505294, 5795.623284486579, 5825.533957283407, 5831.067029275296, 5994.880102397928, 6011.9699401503585, 5559.444055594408, 5584.776608935678, 5596.132599447093, 5645.830625081254, 5650.74571644277, 5616.803411880564, 5636.464535869086, 5685.118806584986, 5691.800786972436, 5697.686627235542, 5556.833295001156, 5598.776048957996, 5623.128415095667, 5683.857903552444, 5688.919105369966, 5534.944650553443, 5620.100783874561, 5660.745266463019, 5661.575381846378, 5669.177969194444, 3624.4200927851944, 3655.8354874030733, 3683.447482877536, 3683.90790230241, 3722.5160729105583, 3301.570795796579, 3335.782439409598, 3341.231516751161, 3346.2136397946465, 3372.1232479555492, 5515.090010148361, 5520.378619706686, 5531.806386776524, 5536.667799931936, 5582.106862901997, 5590.049691552445, 5725.255716756795, 5737.311522617312, 5768.3366412862215, 5780.16187652788, 5463.262459567907, 5499.862503437446, 5511.448855114457, 5537.307836520435, 5545.473180047889, 4631.258998560214, 4641.721496710208, 4654.325122857167, 4655.743934083658, 4721.881952951204, 5869.207656966255, 5902.085176797603, 5973.432523910308, 6021.879562408727, 6023.216981792339, 5683.65898046102, 5712.34308054579, 5717.971410142923, 5725.227094342377, 5766.308043034863, 6019.277686677451, 6080.726367313393, 6087.421694938974, 6088.878222435438, 6101.145839582373, 5492.588055895744, 5696.743646535999, 5703.429657034263, 5707.686077265625, 5725.427457254241, 5679.716014199191, 5695.2311437957005, 5703.486686198262, 5728.0, 5818.301803783573, 5605.271314729059, 5645.802396916089, 5683.857903552444, 5694.971525142348, 5698.487136157766, 5503.504684578407, 5650.491455768836, 5667.603267771216, 5670.432956704297, 5670.773169073191, 5460.180972854104, 5496.615236933376, 5498.202760599771, 5504.669719816824, 5539.58453116026, 5581.665100094007, 5594.384617692132, 5602.747876345493, 5615.943840561542, 5623.297087864017, 5372.919406208988, 5475.863103422446, 5514.393416724238, 5553.278073850373, 5556.472135147154], "mootools.html": [1315.9736805263894, 1355.6000979710984, 1460.4085345435103, 1756.1921516102593, 1772.4062439082907, 7002.194747604027, 7124.287571242873, 7748.728794492194, 8150.3072238859695, 8156.469829461088, 7745.225477452252, 7767.611619419021, 7873.330766884822, 7909.525428474296, 7932.325752311046, 2125.4261349435606, 2144.828413726906, 2146.9785302146934, 2147.076756994492, 2147.226998280618, 1922.8461723062192, 1941.9126139323694, 2125.203048856679, 2125.2667829598763, 2133.8719676819364, 2075.9896200518974, 2093.173196587347, 2096.287262330807, 2102.096098677568, 2102.6951092091635, 1910.1595298068805, 2051.066764622093, 2059.7940205979357, 2063.597598468299, 2063.6698128299477, 1927.2098439639822, 2085.4682056075753, 2095.9266425675028, 2112.0706888968803, 2127.0959842067214, 7797.532148071134, 7946.880796788053, 7948.085970113453, 7971.561564113971, 7984.481008734414, 4591.655625828076, 4629.120467111238, 4666.766661666903, 4669.41632295963, 4682.929756053628, 3202.96797032029, 3210.983945080283, 3238.0933338665213, 3265.053134590966, 3265.706086452231, 1039.3192458939407, 1043.3374806997535, 1046.4296958157822, 1074.8495210670512, 1080.4333716111669, 11115.277506962022, 11117.833232501518, 11225.719357016058, 11253.0, 11271.661850144426, 4197.97901010493, 4229.598188172119, 4240.215560121325, 4272.46594175728, 4280.571942805695, 9392.67125650599, 9425.764355891157, 9524.285678574135, 9540.236781057498, 9544.52277386128, 4769.379980602499, 4788.23388257884, 4788.592969597623, 4792.520747925249, 4801.855944321676, 4299.161663475592, 4358.891027724332, 4363.869083927487, 4383.320585309282, 4396.142752163361, 3592.191756854739, 3604.062943634674, 3610.4764809102535, 3620.6560376764164, 3633.454981752758, 1139.2651739627893, 1158.4902642837126, 1169.6607983684805, 1174.213277104342, 1178.6169494914186, 1217.3365515793914, 1238.8017917133216, 1257.2456526084277, 1301.2517802263735, 1302.4985380628527, 7511.586862722494, 7541.962290188514, 7550.35821955129, 7556.2443755624, 7556.282153195438, 445.1941985007147, 445.5588966922723, 446.5735222862159, 447.7112262590611, 451.3365352931186, 5485.61600687948, 5540.722963851791, 5556.194351818964, 5798.680527788833, 5832.912506312408, 9358.672446464341, 9482.431054136774, 9514.524273786283, 9515.857262141073, 9520.23838092951, 9220.124088211609, 9279.628814847465, 9385.249180065579, 9410.670626528039, 9416.670416535388, 7124.5725256484775, 7183.784486465414, 7245.9275407246305, 7246.746363877239, 7259.528130671595, 7319.926800731924, 7408.518446300973, 7427.8143046424275, 7439.851202976019, 7445.143808462096, 8449.28181104613, 8537.87193192115, 8663.0, 8694.695905585151, 8724.171203735636, 8619.91380086191, 8819.38264321517, 8901.065388134411, 8923.643054277756, 8948.821023579621, 7206.495545311987, 7222.313880181375, 7277.708891644275, 7298.051253337032, 7328.633568321456, 7896.644650990834, 7919.84160316802, 7921.287084162453, 7928.960355198187, 7932.6430310637315, 7345.485815992829, 7411.4811963162065, 7412.4070074394995, 7506.24937506245, 7519.323260906544, 7203.171635262012, 7291.30732580404, 7317.195108538163, 7340.449466289942, 7418.072740907387, 7056.0, 7216.7834964951135, 7225.5664660120565, 7226.349628533457, 7261.128664560287, 6480.25477070143, 6517.348265173634, 6520.576162549419, 6529.0, 6529.347065293433, 6531.342448229007, 6616.206055273398, 6719.731210751515, 6725.562838415487, 6734.427573656294], "ext.html": [556.393065418336, 588.05910543131, 594.3580932592799, 595.9493443057337, 597.1371368372703, 33380.499292510634, 33753.0, 41493.79253103734, 42265.0, 42333.15333693325, 44579.77710111453, 45073.77463112688, 45174.0, 45197.54802451975, 45343.54656453443, 8230.588470576477, 8934.329925255615, 9080.318976076787, 9084.0, 9090.2273306769, 8281.751547453587, 10868.0, 11231.943840280828, 11241.213115081948, 11286.774264514705, 11031.83452248217, 11099.500522476468, 11111.83332250017, 11142.108631309517, 11157.7210569736, 8502.957485212597, 8649.264812490946, 10883.074938630227, 10989.835152472719, 11044.447777611127, 10901.236913416064, 11139.275947063416, 11182.720431989184, 11276.43617819114, 11279.492422840993, 40872.0, 41390.0, 41567.168656627, 41675.58324416778, 41710.57762490857, 3361.092505023654, 3618.4391419330045, 3698.3527882620433, 3752.2870654575545, 4105.97947010266, 33700.15749606255, 34547.827260863785, 34978.12554686128, 35256.29487410237, 35642.64357356445, 3193.7125658690597, 3242.513622956552, 3261.673832616719, 3290.654481279479, 3300.042987533612, 294784.0, 296345.0, 300785.0, 301333.0, 301658.0, 50308.74845625748, 51360.74319628378, 58572.707136464895, 60216.698916505135, 61593.38406615966, 67735.66132169307, 67907.3209267901, 68105.65947170233, 68140.31859681339, 68235.65882170557, 15700.450484232997, 16099.356025759073, 16144.596385090466, 16226.432074877323, 16229.725339264785, 12002.63992080239, 12098.0, 12100.515979360904, 12140.0, 12232.694182645328, 20765.58468830615, 20817.375478735663, 20842.79157208439, 20922.372328829853, 20974.895125524275, 9171.954140229256, 9408.012158723235, 9423.811523769486, 9508.381955172892, 9521.952390238004, 908.1644886704248, 977.9559919803626, 979.9461029643438, 1053.0, 1056.7358160459885, 34127.82936085304, 34242.48636270458, 34280.657193427745, 34374.31251375008, 34501.99442161795, 1036.1503567075076, 1076.7146706122883, 1083.7507373304184, 1134.359087115777, 1175.330061864746, 15066.698666026618, 15263.3894644213, 15379.92371029919, 15426.537203883901, 15565.29956151976, 453706.0, 458896.0, 458993.0, 461998.0, 464210.0, 52897.735511322964, 53427.0, 53456.46543534593, 53527.46472535225, 53589.46410535845, 1270.6759776256995, 1339.370495866941, 1351.0205101301478, 1351.034010682367, 1361.3261435589448, 29092.854535727187, 29159.85420072886, 29180.562291566068, 29697.5545366824, 29756.553651695674, 46299.0, 46351.450670212114, 46728.29907551457, 46738.766306168254, 46953.76523117499, 349858.0, 351697.0, 351855.0, 352030.0, 352510.0, 28326.575101373084, 29181.0, 32565.837170813993, 32941.835290824354, 33188.83405582957, 39774.204515910096, 41478.792606036775, 42918.5708142927, 43094.56905431031, 43862.34206486841, 36696.0, 37648.0, 40141.59858401379, 41432.1713565733, 42321.788391057846, 32549.349013019135, 35867.82066089653, 38335.61664383432, 39009.0, 42056.789716052444, 39141.608583913796, 39501.20997579975, 39559.60440395559, 39589.60410395859, 40026.19947600974, 30486.695133049274, 33397.83301083479, 34798.82600586981, 35315.47026794651, 35447.291054178255, 26887.0, 27897.93824143299, 28433.715662843108, 28758.568621471113, 28813.56779648265], "prototype.html": [303.1662926950885, 312.14005415081454, 314.57846485709143, 320.1021135714323, 321.8422972743355, 5851.502622277107, 5959.940400595998, 5964.314103878044, 5966.820995370141, 5976.163337132805, 5803.448672376117, 5841.269841269841, 5843.912341314884, 5855.268091488564, 5882.088276317167, 4248.766317852517, 4309.482862056542, 4347.956520434786, 4385.122975404932, 4386.517483076859, 4342.804573794187, 4354.8911277218, 4384.298512238042, 4397.956020439803, 4400.009997750512, 4353.368761529577, 4356.259435895905, 4357.150355680644, 4358.6730995175485, 4368.497622773374, 4231.978840105795, 4279.614834664895, 4293.549177336397, 4339.002029533193, 4341.804618792162, 3708.5178926739623, 3723.3484140275614, 3752.287065457582, 3757.530308711411, 3762.191128907298, 5572.804951826707, 5615.820677657697, 5619.7471113799975, 5625.6905870177125, 5627.380988091307, 4864.075825593126, 4880.633952453544, 4929.334539837112, 4936.160852655057, 4947.084789313988, 5872.647641141545, 5957.493613042897, 5963.910541341883, 5970.014947533652, 5983.760649574056, 4073.6130067643526, 4076.0, 4076.9184616307803, 4081.1429599784083, 4091.9795401023102, 6189.16446279751, 6228.813135605939, 6261.843453913643, 6274.686265686743, 6279.403456671609, 4112.077751355191, 4171.374293855946, 4185.895352616209, 4187.6440502557625, 4195.412642230091, 4299.398084268205, 4299.591538803808, 4302.935455968163, 4304.78476076195, 4306.987857853402, 4977.626677999165, 4982.0, 4983.825566105169, 4984.40187177541, 4995.9500404996215, 5936.020556608111, 5949.583529153005, 6043.576949613484, 6048.848778780566, 6054.212952316171, 1495.162708883029, 1506.3221550302408, 1527.3585094260438, 1528.396283468024, 1528.4039224702376, 1003.5584342889106, 1006.2453160129902, 1013.5287091502339, 1015.2892974917587, 1015.735908663738, 5945.821625351246, 5951.4941229995065, 5979.372165922602, 5981.491573216325, 5989.970050149721, 6174.135621013062, 6183.072539119168, 6187.319394866561, 6191.318954914956, 6209.037599172136, 5960.731767070492, 5970.701464926823, 5974.163617093611, 5975.671338076448, 5977.970110149508, 3307.6692330767214, 3347.4811404232382, 3449.896503104911, 3453.8791142309897, 3454.9309013820084, 6537.182852143482, 6540.313267106981, 6556.246031706415, 6559.868802623921, 6566.080748695186, 6361.809145725636, 6362.427381535684, 6363.268224154189, 6368.713407896656, 6370.522210834113, 6529.54293199481, 6534.738610455529, 6546.803595892131, 6550.115734375989, 6613.3056029117215, 6246.3441338660605, 6268.279147897868, 6286.088517164894, 6289.968550157403, 6319.083732858618, 6103.786367477117, 6130.846728831815, 6133.417325354084, 6133.53998450127, 6134.938650613615, 6601.405873471411, 6602.306757790555, 6603.306652801579, 6606.8348291293105, 6610.768623098168, 4105.876823695175, 4115.9588404115575, 4152.045029643259, 4156.625903668684, 4160.563140870165, 6222.688865556795, 6287.371262873676, 6297.181366422519, 6299.0, 6299.244090709144, 6133.0, 6137.140800287874, 6137.202163718688, 6139.386061393825, 6143.477804386677, 6021.2473440819895, 6079.817605471843, 6085.90453718335, 6095.116208149882, 6099.11562823397, 5931.169636251015, 5984.730687119177, 6006.969965150146, 6007.309159446545, 6044.24446944132, 6084.69576521181, 6094.908576371269, 6095.3904609538695, 6103.7558497661375, 6105.45050945417, 5962.135490353961, 6027.246594175728, 6036.486898613667, 6043.456088952015, 6046.1535385045245], "yui.html": [774.7908064822498, 791.7149826062616, 811.2333844516934, 842.296682270304, 876.4828751036887, 14783.630409239775, 15063.0, 15078.0, 15091.471798487055, 15098.169600671972, 13763.518276860312, 13869.583912482642, 13873.167609943384, 13878.722425551483, 13878.930605346985, 656.7668477690399, 665.3579295979379, 797.9241972012665, 812.2080971053206, 812.2486699802688, 813.9621981973003, 818.7625588579305, 819.3404309530855, 821.195228675895, 826.1738261738262, 862.7153039496951, 864.7492227254089, 865.1089377940731, 870.0646804684957, 871.1245198575423, 690.1752405874981, 697.3096634332026, 841.5119230846094, 849.4733265375506, 867.2195024477988, 627.3318915355133, 629.5184184099168, 630.2311180359953, 630.9022101574218, 632.1402892066785, 13417.731645367037, 13523.59429217125, 13538.729225415535, 13548.187108773505, 13620.455181792717, 11846.822297665542, 12226.327551984637, 12286.13997020209, 12383.690407739788, 12419.689507762288, 11052.557897684082, 11124.944375278154, 11458.885411145866, 11556.324332971672, 11817.881821181763, 3445.3798316303055, 3495.0912762681633, 3527.400341941876, 3542.4332106863035, 3570.785752854837, 47950.28074578884, 48609.0, 49030.509694902954, 49207.0, 49814.50185498098, 7891.210878912063, 7897.486663366978, 8100.959495202486, 8190.262876341158, 8209.671613135528, 12296.323702196465, 12312.199707019015, 12313.13808033447, 12330.50677972889, 12385.442655080544, 7078.575285482888, 7168.462365322622, 7234.131904171533, 7354.6690398931105, 7396.223396543393, 4387.6270517006415, 4393.560643935645, 4408.845690400821, 4424.0709451015, 4439.911201775946, 3018.3963207358615, 3055.434744572261, 3056.0678992906933, 3056.816591004547, 3058.2201538607515, 484.36306257271576, 497.524863755113, 499.59532778449574, 558.974846131925, 574.6293640601789, 713.4221280762599, 764.3312101910828, 810.4731924249285, 815.1237419773648, 822.6668199379142, 9728.416295022322, 9844.261680374, 9933.950330248446, 9977.301588888708, 9987.900120998842, 595.7229888101966, 610.9694515274218, 692.3906961873519, 756.8410633766861, 765.7243392378739, 4621.976890115528, 4669.41632295963, 4799.328094066834, 4812.494688057774, 4829.830955916526, 68440.0, 69114.65442672755, 69353.3064669357, 69437.3056269441, 69538.30461695419, 57650.711746441, 57977.42022579804, 58348.70825645845, 58453.0, 58929.0, 51795.74102129465, 52523.737381313615, 52639.0, 53039.46960530345, 53151.090358253954, 9992.650992116261, 10112.949435253071, 10172.338797978107, 10221.795564088528, 10341.9482902585, 37081.44377834281, 37751.81124094362, 37803.810980944916, 38313.0, 38806.80596596999, 43498.13003739844, 43803.342949856415, 44339.77830110829, 44466.555334447534, 45005.32492012557, 9304.604309353652, 9317.208037316905, 9356.345055846026, 9439.0, 9480.241580673392, 14138.151710897379, 14202.78695819543, 14436.566902992927, 14861.554153375417, 14906.403743850558, 13343.66640833987, 13580.86419135796, 13660.795088073886, 13858.237796921267, 14016.229107399191, 12876.35618219104, 13146.553879073103, 13279.66800829987, 13647.044706870423, 13700.725985480434, 8619.612117454604, 12341.62975110748, 12500.749985000431, 13211.227166972085, 13240.271785051915, 10362.0, 10807.891921081004, 10961.56153753841, 11006.724831879266, 11266.605668801552, 10803.351798891777, 11185.384803835866, 11272.549098036316, 11288.604898828502, 11360.03439707634]}, "summary": {"suite": 6763.488345722805, "subtests": {"jquery.html": {"filtered": 6990.12076156748, "value": 6990.12076156748}, "dojo.html": {"filtered": 5209.485489566202, "value": 5209.485489566202}, "mootools.html": {"filtered": 4403.828326149171, "value": 4403.828326149171}, "ext.html": {"filtered": 19940.360944851836, "value": 19940.360944851836}, "prototype.html": {"filtered": 4567.111816525979, "value": 4567.111816525979}, "yui.html": {"filtered": 6553.871998715644, "value": 6553.871998715644}}}, "test_machine": {"platform": "x86_64", "osversion": "6.2.9200", "os": "win", "name": "T-W864-IX-018"}, "testrun": {"date": 1445969512, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a1", "id": "20151027053027", "branch": "B2G-Inbound", "revision": "47e4f94c33259fbcb8e5962360ac68030fc15bce"}}, {"talos_counters": {}, "results": {"audio-dft": [141.0, 140.0, 142.0, 151.0, 140.0, 140.0, 140.0, 143.0, 139.0, 139.0], "ai-astar": [110.0, 110.0, 104.0, 109.0, 108.0, 108.0, 108.0, 108.0, 101.0, 108.0], "imaging-gaussian-blur": [111.0, 113.0, 110.0, 110.0, 111.0, 110.0, 110.0, 111.0, 110.0, 111.0], "audio-beat-detection": [127.0, 122.0, 141.0, 151.0, 123.0, 131.0, 130.0, 123.0, 151.0, 125.0], "json-stringify-tinderbox": [65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 64.0], "stanford-crypto-pbkdf2": [161.0, 145.0, 152.0, 154.0, 154.0, 152.0, 155.0, 156.0, 152.0, 144.0], "json-parse-financial": [73.0, 73.0, 73.0, 72.0, 71.0, 72.0, 72.0, 85.0, 72.0, 72.0], "stanford-crypto-sha256-iterative": [67.0, 68.0, 68.0, 68.0, 67.0, 69.0, 67.0, 67.0, 69.0, 68.0], "audio-fft": [68.0, 69.0, 71.0, 91.0, 70.0, 69.0, 69.0, 69.0, 98.0, 66.0], "imaging-darkroom": [131.0, 132.0, 132.0, 133.0, 131.0, 132.0, 132.0, 135.0, 132.0, 131.0], "stanford-crypto-ccm": [115.0, 113.0, 114.0, 115.0, 115.0, 123.0, 122.0, 121.0, 115.0, 120.0], "audio-oscillator": [86.0, 86.0, 107.0, 86.0, 86.0, 88.0, 114.0, 87.0, 86.0, 116.0], "stanford-crypto-aes": [89.0, 87.0, 88.0, 87.0, 89.0, 89.0, 90.0, 89.0, 90.0, 89.0], "imaging-desaturate": [97.0, 96.0, 96.0, 98.0, 98.0, 105.0, 98.0, 96.0, 97.0, 95.0]}, "summary": {"suite": 1454.6000000000001, "subtests": {"audio-fft": {"filtered": 74.0, "value": 74.0}, "stanford-crypto-pbkdf2": {"filtered": 152.5, "value": 152.5}, "audio-beat-detection": {"filtered": 132.4, "value": 132.4}, "stanford-crypto-ccm": {"filtered": 117.3, "value": 117.3}, "imaging-darkroom": {"filtered": 132.1, "value": 132.1}, "json-parse-financial": {"filtered": 73.5, "value": 73.5}, "audio-oscillator": {"filtered": 94.2, "value": 94.2}, "ai-astar": {"filtered": 107.4, "value": 107.4}, "audio-dft": {"filtered": 141.5, "value": 141.5}, "stanford-crypto-sha256-iterative": {"filtered": 67.8, "value": 67.8}, "json-stringify-tinderbox": {"filtered": 64.9, "value": 64.9}, "imaging-gaussian-blur": {"filtered": 110.7, "value": 110.7}, "stanford-crypto-aes": {"filtered": 88.7, "value": 88.7}, "imaging-desaturate": {"filtered": 97.6, "value": 97.6}}}, "test_machine": {"platform": "x86_64", "osversion": "6.2.9200", "os": "win", "name": "T-W864-IX-018"}, "testrun": {"date": 1445969512, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a1", "id": "20151027053027", "branch": "B2G-Inbound", "revision": "47e4f94c33259fbcb8e5962360ac68030fc15bce"}}, {"talos_counters": {}, "results": {"DeltaBlue": [180.635838150289], "Encrypt": [285.6326763781777], "NavierStokes": [4864.077669902913], "Decrypt": [5070.707070707071], "Splay": [706.2146892655368], "Richards": [165.371258475277], "RegExp": [27432.432432432433], "Earley": [667.1114076050701], "Boyer": [12675.0], "RayTrace": [1592.3566878980891]}, "summary": {"suite": 20210.732602986507, "subtests": {"DeltaBlue": {"filtered": 366.029248, "value": 366.029248}, "Encrypt": {"filtered": 931.8996810000001, "value": 931.8996810000001}, "NavierStokes": {"filtered": 305.0938123752493, "value": 305.0938123752493}, "Decrypt": {"filtered": 52.493862549800795, "value": 52.493862549800795}, "Splay": {"filtered": 115.39125599999998, "value": 115.39125599999998}, "RegExp": {"filtered": 33.208320197044344, "value": 33.208320197044344}, "Richards": {"filtered": 213.47119400000008, "value": 213.47119400000008}, "Earley": {"filtered": 999.0280369999997, "value": 999.0280369999997}, "Boyer": {"filtered": 52.58090729783038, "value": 52.58090729783038}, "RayTrace": {"filtered": 464.713092, "value": 464.713092}}}, "test_machine": {"platform": "x86_64", "osversion": "6.2.9200", "os": "win", "name": "T-W864-IX-018"}, "testrun": {"date": 1445969512, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a1", "id": "20151027053027", "branch": "B2G-Inbound", "revision": "47e4f94c33259fbcb8e5962360ac68030fc15bce"}}] 11:32:14 INFO - RETURN: dromaeo_css: 6763.49 11:32:14 INFO - RETURN: kraken: 1454.60 11:32:14 INFO - RETURN: v8_7: 20210.73 11:32:14 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,31]]", "result": "20210.73"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,31]]", "result": "1454.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,31]]", "result": "6763.49"}}} 11:32:14 INFO - Return code: 0 11:32:14 INFO - # TBPL SUCCESS # 11:32:14 INFO - Running post-action listener: _resource_record_post_action 11:32:14 INFO - Running post-run listener: _resource_record_post_run 11:32:15 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 95630336; Write bytes: 381867008; Read time: 1095360; Write time: 4569030 11:32:15 INFO - install - Wall time: 2s; CPU: 13.0%; Read bytes: 0; Write bytes: 1031680; Read time: 0; Write time: 2790 11:32:15 INFO - run-tests - Wall time: 1226s; CPU: 13.0%; Read bytes: 95630336; Write bytes: 345148416; Read time: 1095360; Write time: 4370060 11:32:15 INFO - Running post-run listener: _upload_blobber_files 11:32:15 INFO - Blob upload gear active. 11:32:15 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:32:15 INFO - Copying logs to upload dir... 11:32:15 INFO - mkdir: C:\slave\test-pgo\build\upload\logs program finished with exit code 0 elapsedTime=1385.965000 ========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 16 secs) (at 2015-10-27 11:32:16.775889) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-27 11:32:16.776579) ========= '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-018\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-018 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-018 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-018\AppData\Local LOGONSERVER=\\T-W864-IX-018 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-018 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-018 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-018 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False build_url:https://queue.taskcluster.net/v1/task/KrxNkT0ETkm3QjvaZp-Auw/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/KrxNkT0ETkm3QjvaZp-Auw/artifacts/public/build/firefox-44.0a1.en-US.win64.zip' ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-27 11:32:16.922172) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 11:32:16.922530) ========= '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-018\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-018 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-018 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-018\AppData\Local LOGONSERVER=\\T-W864-IX-018 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-018 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-018 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-018 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-27 11:32:17.036760) ========= ========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2015-10-27 11:32:17.037076) ========= ========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2015-10-27 11:32:17.418581) =========