builder: mozilla-inbound_win8_64_test-svgr-pgo slave: t-w864-ix-037 starttime: 1450925493.25 results: success (0) buildid: 20151223133015 builduid: fbb692c3ff0043fcbf80bd4bf0420e45 revision: 1cc7f3085826a7bddf4459aa03b1b87cd8cc8a8e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-23 18:51:33.246331) ========= master: http://buildbot-master112.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-23 18:51:33.246780) ========= ========= Started set props: basedir (results: 0, elapsed: 1 secs) (at 2015-12-23 18:51:33.247075) ========= '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-037\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-037 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-037 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-037\AppData\Local LOGONSERVER=\\T-W864-IX-037 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-037 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-037 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-037 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False C:\slave\test-pgo program finished with exit code 0 elapsedTime=1.448000 basedir: 'C:\\slave\\test-pgo' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 1 secs) (at 2015-12-23 18:51:34.761749) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-23 18:51:34.762191) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-23 18:51:34.993424) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 18:51:34.993815) ========= '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-037\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-037 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-037 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-037\AppData\Local LOGONSERVER=\\T-W864-IX-037 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-037 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-037 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-037 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=0.301000 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 18:51:35.308767) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-23 18:51:35.309225) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-23 18:51:35.309739) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-23 18:51:35.310138) ========= '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-037\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-037 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-037 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-037\AppData\Local LOGONSERVER=\\T-W864-IX-037 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-037 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-037 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-037 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False --18:51:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py => `archiver_client.py' Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12,141 (12K) [text/x-python] 0K .......... . 100% 8.45 MB/s 18:51:36 (8.45 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=1.708000 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-23 18:51:37.028198) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 6 secs) (at 2015-12-23 18:51:37.028517) ========= '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-037\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-037 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-037 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-037\AppData\Local LOGONSERVER=\\T-W864-IX-037 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-037 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-037 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-037 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=6.519000 ========= master_lag: -0.00 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 6 secs) (at 2015-12-23 18:51:43.544311) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-12-23 18:51:43.544701) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 1cc7f3085826a7bddf4459aa03b1b87cd8cc8a8e --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/mozilla-inbound --rev 1cc7f3085826a7bddf4459aa03b1b87cd8cc8a8e --destination scripts --debug'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-037\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-037 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-037 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-037\AppData\Local LOGONSERVER=\\T-W864-IX-037 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-037 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-037 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-037 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 2015-12-23 18:51:43,480 truncating revision to first 12 chars 2015-12-23 18:51:43,480 Setting DEBUG logging. 2015-12-23 18:51:43,480 attempt 1/10 2015-12-23 18:51:43,480 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/1cc7f3085826?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-23 18:51:44,233 unpacking tar archive at: mozilla-inbound-1cc7f3085826/testing/mozharness/ program finished with exit code 0 elapsedTime=2.187000 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-12-23 18:51:45.808458) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-23 18:51:45.808781) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-23 18:51:45.824699) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-23 18:51:45.825000) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-23 18:51:45.825380) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2015-12-23 18:51:45.825663) ========= 'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'svgr' '--add-option' '--webServer,localhost' '--branch-name' 'Mozilla-Inbound' '--system-bits' '64' '--cfg' 'talos/windows_config.py' '--download-symbols' 'ondemand' '--use-talos-json' '--blob-upload-branch' 'Mozilla-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', 'svgr', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/windows_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld.T-W864-IX-037\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-037 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-037 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-037\AppData\Local LOGONSERVER=\\T-W864-IX-037 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-037 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-037 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-037 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False 18:51:45 INFO - MultiFileLogger online at 20151223 18:51:45 in C:\slave\test-pgo 18:51:45 INFO - Run as scripts/scripts/talos_script.py --suite svgr --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 18:51:45 INFO - Dumping config to C:\slave\test-pgo\logs\localconfig.json. 18:51:45 INFO - {'append_to_log': False, 18:51:45 INFO - 'base_work_dir': 'C:\\slave\\test-pgo', 18:51:45 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 18:51:45 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test-pgo\\oauth.txt', 18:51:45 INFO - 'branch': 'Mozilla-Inbound', 18:51:45 INFO - 'buildbot_json_path': 'buildprops.json', 18:51:45 INFO - 'config_files': ('talos/windows_config.py',), 18:51:45 INFO - 'default_actions': ('clobber', 18:51:45 INFO - 'read-buildbot-config', 18:51:45 INFO - 'download-and-extract', 18:51:45 INFO - 'populate-webroot', 18:51:45 INFO - 'create-virtualenv', 18:51:45 INFO - 'install', 18:51:45 INFO - 'run-tests'), 18:51:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:51:45 INFO - 'download_minidump_stackwalk': True, 18:51:45 INFO - 'download_symbols': 'ondemand', 18:51:45 INFO - 'exes': {'easy_install': ('C:\\slave\\test-pgo\\build/venv/scripts/python', 18:51:45 INFO - 'C:\\slave\\test-pgo\\build/venv/scripts/easy_install-2.7-script.py'), 18:51:45 INFO - 'hg': 'c:/mozilla-build/hg/hg', 18:51:45 INFO - 'mozinstall': ('C:\\slave\\test-pgo\\build/venv/scripts/python', 18:51:45 INFO - 'C:\\slave\\test-pgo\\build/venv/scripts/mozinstall-script.py'), 18:51:45 INFO - 'python': 'c:/mozilla-build/python27/python.exe', 18:51:45 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe', 18:51:45 INFO - 'C:/mozilla-build/tooltool.py'), 18:51:45 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe', 18:51:45 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 18:51:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:51:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:51:45 INFO - 'installer_path': 'installer.exe', 18:51:45 INFO - 'log_level': 'info', 18:51:45 INFO - 'log_name': 'talos', 18:51:45 INFO - 'log_to_console': True, 18:51:45 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe', 18:51:45 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe', 18:51:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest', 18:51:45 INFO - 'opt_config_files': (), 18:51:45 INFO - 'pip_index': False, 18:51:45 INFO - 'sps_profile': False, 18:51:45 INFO - 'sps_profile_interval': 0, 18:51:45 INFO - 'suite': 'svgr', 18:51:45 INFO - 'system_bits': '64', 18:51:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:51:45 INFO - 'title': 'T-W864-IX-037', 18:51:45 INFO - 'use_talos_json': True, 18:51:45 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'), 18:51:45 INFO - 'virtualenv_path': 'C:\\slave\\test-pgo\\build/venv', 18:51:45 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll', 18:51:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:51:45 INFO - 'work_dir': 'build'} 18:51:45 INFO - ##### 18:51:45 INFO - ##### Running clobber step. 18:51:45 INFO - ##### 18:51:45 INFO - Running pre-action listener: _resource_record_pre_action 18:51:45 INFO - Running main action method: clobber 18:51:45 INFO - rmtree: C:\slave\test-pgo\build 18:51:45 INFO - Using _rmtree_windows ... 18:51:45 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test-pgo\\build',), kwargs: {}, attempt #1 18:54:16 INFO - Running post-action listener: _resource_record_post_action 18:54:16 INFO - ##### 18:54:16 INFO - ##### Running read-buildbot-config step. 18:54:16 INFO - ##### 18:54:16 INFO - Running pre-action listener: _resource_record_pre_action 18:54:16 INFO - Running main action method: read_buildbot_config 18:54:16 INFO - Using buildbot properties: 18:54:16 INFO - { 18:54:16 INFO - "project": "", 18:54:16 INFO - "product": "firefox", 18:54:16 INFO - "script_repo_revision": "production", 18:54:16 INFO - "builddir": "mozilla-inbound_win8_64_test-svgr", 18:54:16 INFO - "repository": "", 18:54:16 INFO - "buildername": "Windows 8 64-bit mozilla-inbound pgo talos svgr", 18:54:16 INFO - "buildid": "20151223133015", 18:54:16 INFO - "pgo_build": "True", 18:54:16 INFO - "basedir": "C:\\slave\\test-pgo", 18:54:16 INFO - "buildnumber": 691, 18:54:16 INFO - "slavename": "t-w864-ix-037", 18:54:16 INFO - "master": "http://buildbot-master112.bb.releng.scl3.mozilla.com:8201/", 18:54:16 INFO - "platform": "win8_64", 18:54:16 INFO - "scheduler": "tests-mozilla-inbound-win64-pgo-talos", 18:54:16 INFO - "branch": "mozilla-inbound", 18:54:16 INFO - "repo_path": "integration/mozilla-inbound", 18:54:16 INFO - "revision": "1cc7f3085826a7bddf4459aa03b1b87cd8cc8a8e", 18:54:16 INFO - "stage_platform": "win64-pgo", 18:54:16 INFO - "builduid": "fbb692c3ff0043fcbf80bd4bf0420e45", 18:54:16 INFO - "slavebuilddir": "test" 18:54:16 INFO - } 18:54:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/B2R6eceDQ565VBbQLF2bfg/artifacts/public/build/firefox-46.0a1.en-US.win64.zip. 18:54:16 INFO - Running post-action listener: _resource_record_post_action 18:54:16 INFO - ##### 18:54:16 INFO - ##### Running download-and-extract step. 18:54:16 INFO - ##### 18:54:16 INFO - Running pre-action listener: _resource_record_pre_action 18:54:16 INFO - Running main action method: download_and_extract 18:54:16 INFO - mkdir: C:\slave\test-pgo\build\tests 18:54:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:54:16 INFO - https://queue.taskcluster.net/v1/task/B2R6eceDQ565VBbQLF2bfg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:54:16 INFO - trying https://queue.taskcluster.net/v1/task/B2R6eceDQ565VBbQLF2bfg/artifacts/public/build/test_packages.json 18:54:16 INFO - Downloading https://queue.taskcluster.net/v1/task/B2R6eceDQ565VBbQLF2bfg/artifacts/public/build/test_packages.json to C:\slave\test-pgo\build\test_packages.json 18:54:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B2R6eceDQ565VBbQLF2bfg/artifacts/public/build/test_packages.json', 'file_name': 'C:\\slave\\test-pgo\\build\\test_packages.json'}, attempt #1 18:54:17 INFO - Downloaded 1221 bytes. 18:54:17 INFO - Reading from file C:\slave\test-pgo\build\test_packages.json 18:54:17 INFO - Using the following test package requirements: 18:54:17 INFO - {u'common': [u'firefox-46.0a1.en-US.win64.common.tests.zip'], 18:54:17 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.win64.common.tests.zip', 18:54:17 INFO - u'firefox-46.0a1.en-US.win64.cppunittest.tests.zip'], 18:54:17 INFO - u'jittest': [u'firefox-46.0a1.en-US.win64.common.tests.zip', 18:54:17 INFO - u'jsshell-win64.zip'], 18:54:17 INFO - u'mochitest': [u'firefox-46.0a1.en-US.win64.common.tests.zip', 18:54:17 INFO - u'firefox-46.0a1.en-US.win64.mochitest.tests.zip'], 18:54:17 INFO - u'mozbase': [u'firefox-46.0a1.en-US.win64.common.tests.zip'], 18:54:17 INFO - u'reftest': [u'firefox-46.0a1.en-US.win64.common.tests.zip', 18:54:17 INFO - u'firefox-46.0a1.en-US.win64.reftest.tests.zip'], 18:54:17 INFO - u'talos': [u'firefox-46.0a1.en-US.win64.common.tests.zip', 18:54:17 INFO - u'firefox-46.0a1.en-US.win64.talos.tests.zip'], 18:54:17 INFO - u'web-platform': [u'firefox-46.0a1.en-US.win64.common.tests.zip', 18:54:17 INFO - u'firefox-46.0a1.en-US.win64.web-platform.tests.zip'], 18:54:17 INFO - u'webapprt': [u'firefox-46.0a1.en-US.win64.common.tests.zip'], 18:54:17 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.win64.common.tests.zip', 18:54:17 INFO - u'firefox-46.0a1.en-US.win64.xpcshell.tests.zip']} 18:54:17 INFO - Downloading packages: [u'firefox-46.0a1.en-US.win64.common.tests.zip'] for test suite category: common 18:54:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:54:17 INFO - https://queue.taskcluster.net/v1/task/B2R6eceDQ565VBbQLF2bfg/artifacts/public/build/firefox-46.0a1.en-US.win64.common.tests.zip matches https://queue.taskcluster.net 18:54:17 INFO - trying https://queue.taskcluster.net/v1/task/B2R6eceDQ565VBbQLF2bfg/artifacts/public/build/firefox-46.0a1.en-US.win64.common.tests.zip 18:54:17 INFO - Downloading https://queue.taskcluster.net/v1/task/B2R6eceDQ565VBbQLF2bfg/artifacts/public/build/firefox-46.0a1.en-US.win64.common.tests.zip to C:\slave\test-pgo\build\firefox-46.0a1.en-US.win64.common.tests.zip 18:54:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B2R6eceDQ565VBbQLF2bfg/artifacts/public/build/firefox-46.0a1.en-US.win64.common.tests.zip', 'file_name': u'C:\\slave\\test-pgo\\build\\firefox-46.0a1.en-US.win64.common.tests.zip'}, attempt #1 ProcessManager NOT managing child processes 18:54:18 INFO - Downloaded 18720093 bytes. 18:54:18 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-46.0a1.en-US.win64.common.tests.zip'] in C:\slave\test-pgo\build\tests 18:54:18 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-46.0a1.en-US.win64.common.tests.zip 18:54:18 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-46.0a1.en-US.win64.common.tests.zip'] with output_timeout 1760 ProcessManager UNABLE to use job objects to manage child processes 18:54:45 INFO - Return code: 0 18:54:45 INFO - Downloading packages: [u'firefox-46.0a1.en-US.win64.common.tests.zip', u'firefox-46.0a1.en-US.win64.talos.tests.zip'] for test suite category: talos 18:54:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:54:45 INFO - https://queue.taskcluster.net/v1/task/B2R6eceDQ565VBbQLF2bfg/artifacts/public/build/firefox-46.0a1.en-US.win64.common.tests.zip matches https://queue.taskcluster.net 18:54:45 INFO - trying https://queue.taskcluster.net/v1/task/B2R6eceDQ565VBbQLF2bfg/artifacts/public/build/firefox-46.0a1.en-US.win64.common.tests.zip 18:54:45 INFO - Downloading https://queue.taskcluster.net/v1/task/B2R6eceDQ565VBbQLF2bfg/artifacts/public/build/firefox-46.0a1.en-US.win64.common.tests.zip to C:\slave\test-pgo\build\firefox-46.0a1.en-US.win64.common.tests.zip 18:54:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B2R6eceDQ565VBbQLF2bfg/artifacts/public/build/firefox-46.0a1.en-US.win64.common.tests.zip', 'file_name': u'C:\\slave\\test-pgo\\build\\firefox-46.0a1.en-US.win64.common.tests.zip'}, attempt #1 ProcessManager NOT managing child processes 18:54:46 INFO - Downloaded 18720093 bytes. 18:54:46 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-46.0a1.en-US.win64.common.tests.zip'] in C:\slave\test-pgo\build\tests 18:54:46 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-46.0a1.en-US.win64.common.tests.zip 18:54:46 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-46.0a1.en-US.win64.common.tests.zip'] with output_timeout 1760 ProcessManager UNABLE to use job objects to manage child processes 18:55:08 INFO - Return code: 0 18:55:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:08 INFO - https://queue.taskcluster.net/v1/task/B2R6eceDQ565VBbQLF2bfg/artifacts/public/build/firefox-46.0a1.en-US.win64.talos.tests.zip matches https://queue.taskcluster.net 18:55:08 INFO - trying https://queue.taskcluster.net/v1/task/B2R6eceDQ565VBbQLF2bfg/artifacts/public/build/firefox-46.0a1.en-US.win64.talos.tests.zip 18:55:08 INFO - Downloading https://queue.taskcluster.net/v1/task/B2R6eceDQ565VBbQLF2bfg/artifacts/public/build/firefox-46.0a1.en-US.win64.talos.tests.zip to C:\slave\test-pgo\build\firefox-46.0a1.en-US.win64.talos.tests.zip 18:55:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B2R6eceDQ565VBbQLF2bfg/artifacts/public/build/firefox-46.0a1.en-US.win64.talos.tests.zip', 'file_name': u'C:\\slave\\test-pgo\\build\\firefox-46.0a1.en-US.win64.talos.tests.zip'}, attempt #1 ProcessManager NOT managing child processes 18:55:09 INFO - Downloaded 11132277 bytes. 18:55:09 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-46.0a1.en-US.win64.talos.tests.zip'] in C:\slave\test-pgo\build\tests 18:55:09 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-46.0a1.en-US.win64.talos.tests.zip 18:55:09 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-46.0a1.en-US.win64.talos.tests.zip'] with output_timeout 1760 ProcessManager UNABLE to use job objects to manage child processes 18:55:13 INFO - Return code: 0 18:55:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:13 INFO - https://queue.taskcluster.net/v1/task/B2R6eceDQ565VBbQLF2bfg/artifacts/public/build/firefox-46.0a1.en-US.win64.zip matches https://queue.taskcluster.net 18:55:13 INFO - trying https://queue.taskcluster.net/v1/task/B2R6eceDQ565VBbQLF2bfg/artifacts/public/build/firefox-46.0a1.en-US.win64.zip 18:55:13 INFO - Downloading https://queue.taskcluster.net/v1/task/B2R6eceDQ565VBbQLF2bfg/artifacts/public/build/firefox-46.0a1.en-US.win64.zip to C:\slave\test-pgo\build\firefox-46.0a1.en-US.win64.zip 18:55:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B2R6eceDQ565VBbQLF2bfg/artifacts/public/build/firefox-46.0a1.en-US.win64.zip', 'file_name': 'C:\\slave\\test-pgo\\build\\firefox-46.0a1.en-US.win64.zip'}, attempt #1 18:55:14 INFO - Downloaded 55922727 bytes. 18:55:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B2R6eceDQ565VBbQLF2bfg/artifacts/public/build/firefox-46.0a1.en-US.win64.zip 18:55:14 INFO - mkdir: C:\slave\test-pgo\properties 18:55:14 INFO - Writing buildbot properties ['build_url'] to C:\slave\test-pgo\properties\build_url 18:55:14 INFO - Writing to file C:\slave\test-pgo\properties\build_url 18:55:14 INFO - Contents: 18:55:14 INFO - build_url:https://queue.taskcluster.net/v1/task/B2R6eceDQ565VBbQLF2bfg/artifacts/public/build/firefox-46.0a1.en-US.win64.zip 18:55:14 INFO - Running post-action listener: _resource_record_post_action 18:55:14 INFO - Running post-action listener: set_extra_try_arguments 18:55:14 INFO - ##### 18:55:14 INFO - ##### Running populate-webroot step. 18:55:14 INFO - ##### 18:55:14 INFO - Running pre-action listener: _resource_record_pre_action 18:55:14 INFO - Running main action method: populate_webroot 18:55:14 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']}, 18:55:14 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']}, 18:55:14 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome', 18:55:14 INFO - u'--tppagecycles', 18:55:14 INFO - u'7'], 18:55:14 INFO - u'tests': [u'tsvgm']}}, 18:55:14 INFO - u'suites': {u'chromez': {u'tests': [u'tresize', u'tcanvasmark']}, 18:55:14 INFO - u'chromez-e10s': {u'talos_options': [u'--e10s'], 18:55:14 INFO - u'tests': [u'tresize', u'tcanvasmark']}, 18:55:14 INFO - u'dromaeojs': {u'tests': [u'dromaeo_css', u'kraken', u'v8_7']}, 18:55:14 INFO - u'dromaeojs-e10s': {u'talos_options': [u'--e10s'], 18:55:14 INFO - u'tests': [u'dromaeo_css', 18:55:14 INFO - u'kraken', 18:55:14 INFO - u'v8_7']}, 18:55:14 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:14 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 18:55:14 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:14 INFO - u'talos_options': [u'--e10s'], 18:55:14 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 18:55:14 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:14 INFO - u'tests': [u'damp', u'tps']}, 18:55:14 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:14 INFO - u'talos_options': [u'--e10s'], 18:55:14 INFO - u'tests': [u'damp', u'tps']}, 18:55:14 INFO - u'g3': {u'tests': [u'dromaeo_dom']}, 18:55:14 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']}, 18:55:14 INFO - u'other': {u'tests': [u'a11yr', 18:55:14 INFO - u'ts_paint', 18:55:14 INFO - u'tpaint', 18:55:14 INFO - u'sessionrestore', 18:55:14 INFO - u'sessionrestore_no_auto_restore']}, 18:55:14 INFO - u'other-e10s': {u'talos_options': [u'--e10s'], 18:55:14 INFO - u'tests': [u'a11yr', 18:55:14 INFO - u'ts_paint', 18:55:14 INFO - u'tpaint', 18:55:14 INFO - u'sessionrestore', 18:55:14 INFO - u'sessionrestore_no_auto_restore']}, 18:55:14 INFO - u'other-e10s_l64': {u'talos_options': [u'--e10s'], 18:55:14 INFO - u'tests': [u'a11yr', 18:55:14 INFO - u'ts_paint', 18:55:14 INFO - u'tpaint', 18:55:14 INFO - u'sessionrestore', 18:55:14 INFO - u'sessionrestore_no_auto_restore']}, 18:55:14 INFO - u'other-e10s_nol64': {u'talos_options': [u'--e10s'], 18:55:14 INFO - u'tests': [u'a11yr', 18:55:14 INFO - u'ts_paint', 18:55:14 INFO - u'tpaint', 18:55:14 INFO - u'sessionrestore', 18:55:14 INFO - u'sessionrestore_no_auto_restore']}, 18:55:14 INFO - u'other_l64': {u'tests': [u'a11yr', 18:55:14 INFO - u'ts_paint', 18:55:14 INFO - u'tpaint', 18:55:14 INFO - u'sessionrestore', 18:55:14 INFO - u'sessionrestore_no_auto_restore']}, 18:55:14 INFO - u'other_nol64': {u'tests': [u'a11yr', 18:55:14 INFO - u'ts_paint', 18:55:14 INFO - u'tpaint', 18:55:14 INFO - u'sessionrestore', 18:55:14 INFO - u'sessionrestore_no_auto_restore']}, 18:55:14 INFO - u'svgr': {u'tests': [u'tsvgx', 18:55:14 INFO - u'tsvgr_opacity', 18:55:14 INFO - u'tart', 18:55:14 INFO - u'tscrollx', 18:55:14 INFO - u'cart']}, 18:55:14 INFO - u'svgr-e10s': {u'talos_options': [u'--e10s'], 18:55:14 INFO - u'tests': [u'tsvgx', 18:55:14 INFO - u'tsvgr_opacity', 18:55:14 INFO - u'tart', 18:55:14 INFO - u'tscrollx', 18:55:14 INFO - u'cart']}, 18:55:14 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:14 INFO - u'tests': [u'tp5o']}, 18:55:14 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:14 INFO - u'talos_options': [u'--e10s'], 18:55:14 INFO - u'tests': [u'tp5o']}, 18:55:14 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:14 INFO - u'talos_options': [u'--xperf_path', 18:55:14 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:55:14 INFO - u'tests': [u'tp5n']}, 18:55:14 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:14 INFO - u'talos_options': [u'--e10s', 18:55:14 INFO - u'--xperf_path', 18:55:14 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:55:14 INFO - u'tests': [u'tp5n']}}, 18:55:14 INFO - u'talos.zip': {u'path': u'', 18:55:14 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:55:14 INFO - Running post-action listener: _resource_record_post_action 18:55:14 INFO - ##### 18:55:14 INFO - ##### Running create-virtualenv step. 18:55:14 INFO - ##### 18:55:14 INFO - Running pre-action listener: _resource_record_pre_action 18:55:14 INFO - Running main action method: create_virtualenv 18:55:14 INFO - Creating virtualenv C:\slave\test-pgo\build/venv 18:55:14 INFO - mkdir: C:\slave\test-pgo\build\venv\Scripts 18:55:14 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test-pgo\build\venv\Scripts\python27.dll 18:55:14 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'! 18:55:14 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 18:55:14 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 18:55:18 INFO - New python executable in C:\slave\test-pgo\build/venv\Scripts\python.exe 18:55:21 INFO - Installing distribute......................................................................................................................................................................................done. 18:55:23 INFO - Return code: 0 18:55:23 INFO - Installing pip>=1.5 into virtualenv C:\slave\test-pgo\build/venv 18:55:23 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')]} 18:55:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:23 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')]} 18:55:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:23 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 0x022886B0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02330EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02443240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01D68BF0>, '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 0x01D8A9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028115C0>, '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-037', 'USERDOMAIN': 'T-W864-IX-037', '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-037', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-037\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-037', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-037', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-037', '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-037\\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 18:55:23 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 18:55:23 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 18:55:23 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 18:55:23 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-037\\AppData\\Roaming', 18:55:23 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 18:55:23 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 18:55:23 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 18:55:23 INFO - 'COMPUTERNAME': 'T-W864-IX-037', 18:55:23 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 18:55:23 INFO - 'DCLOCATION': 'SCL3', 18:55:23 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 18:55:23 INFO - 'FP_NO_HOST_CHECK': 'NO', 18:55:23 INFO - 'HOMEDRIVE': 'C:', 18:55:23 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-037', 18:55:23 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 18:55:23 INFO - 'KTS_VERSION': '1.19c', 18:55:23 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-037\\AppData\\Local', 18:55:23 INFO - 'LOGONSERVER': '\\\\T-W864-IX-037', 18:55:23 INFO - 'MONDIR': 'C:\\Monitor_config\\', 18:55:23 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 18:55:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:23 INFO - 'MOZ_NO_REMOTE': '1', 18:55:23 INFO - 'NO_EM_RESTART': '1', 18:55:23 INFO - 'NUMBER_OF_PROCESSORS': '8', 18:55:23 INFO - 'OS': 'Windows_NT', 18:55:23 INFO - 'OURDRIVE': 'C:', 18:55:23 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', 18:55:23 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 18:55:23 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 18:55:23 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 18:55:23 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 18:55:23 INFO - 'PROCESSOR_LEVEL': '6', 18:55:23 INFO - 'PROCESSOR_REVISION': '1e05', 18:55:23 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 18:55:23 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 18:55:23 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 18:55:23 INFO - 'PROGRAMW6432': 'C:\\Program Files', 18:55:23 INFO - 'PROMPT': '$P$G', 18:55:23 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 18:55:23 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 18:55:23 INFO - 'PUBLIC': 'C:\\Users\\Public', 18:55:23 INFO - 'PWD': 'C:\\slave\\test-pgo', 18:55:23 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 18:55:23 INFO - 'SLAVEDIR': 'C:\\slave\\', 18:55:23 INFO - 'SYSTEMDRIVE': 'C:', 18:55:23 INFO - 'SYSTEMROOT': 'C:\\windows', 18:55:23 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 18:55:23 INFO - 'TEST1': 'testie', 18:55:23 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 18:55:23 INFO - 'USERDOMAIN': 'T-W864-IX-037', 18:55:23 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-037', 18:55:23 INFO - 'USERNAME': 'cltbld', 18:55:23 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-037', 18:55:23 INFO - 'WINDIR': 'C:\\windows', 18:55:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 18:55:24 INFO - Ignoring indexes: http://pypi.python.org/simple/ 18:55:24 INFO - Downloading/unpacking pip>=1.5 18:55:24 INFO - Creating supposed download cache at C:\slave\test-pgo\build/venv\cache 18:55:28 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 18:55:28 INFO - Running setup.py egg_info for package pip 18:55:28 INFO - warning: no files found matching 'pip\cacert.pem' 18:55:28 INFO - warning: no files found matching '*.html' under directory 'docs' 18:55:28 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 18:55:28 INFO - no previously-included directories found matching 'docs\_build\_sources' 18:55:28 INFO - Installing collected packages: pip 18:55:28 INFO - Found existing installation: pip 0.8.2 18:55:28 INFO - Uninstalling pip: 18:55:28 INFO - Successfully uninstalled pip 18:55:28 INFO - Running setup.py install for pip 18:55:28 INFO - warning: no files found matching 'pip\cacert.pem' 18:55:28 INFO - warning: no files found matching '*.html' under directory 'docs' 18:55:28 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 18:55:28 INFO - no previously-included directories found matching 'docs\_build\_sources' 18:55:28 INFO - Installing pip-script.py script to C:\slave\test-pgo\build\venv\Scripts 18:55:28 INFO - Installing pip.exe script to C:\slave\test-pgo\build\venv\Scripts 18:55:28 INFO - Installing pip2.7-script.py script to C:\slave\test-pgo\build\venv\Scripts 18:55:28 INFO - Installing pip2.7.exe script to C:\slave\test-pgo\build\venv\Scripts 18:55:28 INFO - Installing pip2-script.py script to C:\slave\test-pgo\build\venv\Scripts 18:55:28 INFO - Installing pip2.exe script to C:\slave\test-pgo\build\venv\Scripts 18:55:28 INFO - Successfully installed pip 18:55:28 INFO - Cleaning up... 18:55:28 INFO - Return code: 0 18:55:28 INFO - Installing psutil>=0.7.1 into virtualenv C:\slave\test-pgo\build/venv 18:55: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')]} 18:55:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55: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')]} 18:55:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:28 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x022886B0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02330EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02443240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01D68BF0>, '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 0x01D8A9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028115C0>, '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-037', 'USERDOMAIN': 'T-W864-IX-037', '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-037', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-037\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-037', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-037', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-037', '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-037\\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 18:55:28 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in C:\slave\test-pgo\build 18:55:28 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --download-cache C:\slave\test-pgo\build/venv\cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:55:28 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 18:55:28 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-037\\AppData\\Roaming', 18:55:28 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 18:55:28 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 18:55:28 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 18:55:28 INFO - 'COMPUTERNAME': 'T-W864-IX-037', 18:55:28 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 18:55:28 INFO - 'DCLOCATION': 'SCL3', 18:55:28 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 18:55:28 INFO - 'FP_NO_HOST_CHECK': 'NO', 18:55:28 INFO - 'HOMEDRIVE': 'C:', 18:55:28 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-037', 18:55:28 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 18:55:28 INFO - 'KTS_VERSION': '1.19c', 18:55:28 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-037\\AppData\\Local', 18:55:28 INFO - 'LOGONSERVER': '\\\\T-W864-IX-037', 18:55:28 INFO - 'MONDIR': 'C:\\Monitor_config\\', 18:55:28 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 18:55:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:28 INFO - 'MOZ_NO_REMOTE': '1', 18:55:28 INFO - 'NO_EM_RESTART': '1', 18:55:28 INFO - 'NUMBER_OF_PROCESSORS': '8', 18:55:28 INFO - 'OS': 'Windows_NT', 18:55:28 INFO - 'OURDRIVE': 'C:', 18:55: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', 18:55:28 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 18:55:28 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 18:55:28 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 18:55:28 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 18:55:28 INFO - 'PROCESSOR_LEVEL': '6', 18:55:28 INFO - 'PROCESSOR_REVISION': '1e05', 18:55:28 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 18:55:28 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 18:55:28 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 18:55:28 INFO - 'PROGRAMW6432': 'C:\\Program Files', 18:55:28 INFO - 'PROMPT': '$P$G', 18:55:28 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 18:55:28 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 18:55:28 INFO - 'PUBLIC': 'C:\\Users\\Public', 18:55:28 INFO - 'PWD': 'C:\\slave\\test-pgo', 18:55:28 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 18:55:28 INFO - 'SLAVEDIR': 'C:\\slave\\', 18:55:28 INFO - 'SYSTEMDRIVE': 'C:', 18:55:28 INFO - 'SYSTEMROOT': 'C:\\windows', 18:55:28 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 18:55:28 INFO - 'TEST1': 'testie', 18:55:28 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 18:55:28 INFO - 'USERDOMAIN': 'T-W864-IX-037', 18:55:28 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-037', 18:55:28 INFO - 'USERNAME': 'cltbld', 18:55:28 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-037', 18:55:28 INFO - 'WINDIR': 'C:\\windows', 18:55:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 18:55:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:30 INFO - Downloading/unpacking psutil>=0.7.1 18:55:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:55:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:55:30 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 18:55:31 INFO - Installing collected packages: psutil 18:55:31 INFO - Successfully installed psutil 18:55:31 INFO - Cleaning up... 18:55:31 INFO - Return code: 0 18:55:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv C:\slave\test-pgo\build/venv 18:55:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:31 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 0x022886B0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02330EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02443240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01D68BF0>, '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 0x01D8A9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028115C0>, '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-037', 'USERDOMAIN': 'T-W864-IX-037', '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-037', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-037\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-037', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-037', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-037', '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-037\\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 18:55:31 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 18:55:31 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 18:55:31 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 18:55:31 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-037\\AppData\\Roaming', 18:55:31 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 18:55:31 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 18:55:31 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 18:55:31 INFO - 'COMPUTERNAME': 'T-W864-IX-037', 18:55:31 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 18:55:31 INFO - 'DCLOCATION': 'SCL3', 18:55:31 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 18:55:31 INFO - 'FP_NO_HOST_CHECK': 'NO', 18:55:31 INFO - 'HOMEDRIVE': 'C:', 18:55:31 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-037', 18:55:31 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 18:55:31 INFO - 'KTS_VERSION': '1.19c', 18:55:31 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-037\\AppData\\Local', 18:55:31 INFO - 'LOGONSERVER': '\\\\T-W864-IX-037', 18:55:31 INFO - 'MONDIR': 'C:\\Monitor_config\\', 18:55:31 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 18:55:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:31 INFO - 'MOZ_NO_REMOTE': '1', 18:55:31 INFO - 'NO_EM_RESTART': '1', 18:55:31 INFO - 'NUMBER_OF_PROCESSORS': '8', 18:55:31 INFO - 'OS': 'Windows_NT', 18:55:31 INFO - 'OURDRIVE': 'C:', 18:55:31 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 18:55:31 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 18:55:31 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 18:55:31 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 18:55:31 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 18:55:31 INFO - 'PROCESSOR_LEVEL': '6', 18:55:31 INFO - 'PROCESSOR_REVISION': '1e05', 18:55:31 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 18:55:31 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 18:55:31 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 18:55:31 INFO - 'PROGRAMW6432': 'C:\\Program Files', 18:55:31 INFO - 'PROMPT': '$P$G', 18:55:31 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 18:55:31 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 18:55:31 INFO - 'PUBLIC': 'C:\\Users\\Public', 18:55:31 INFO - 'PWD': 'C:\\slave\\test-pgo', 18:55:31 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 18:55:31 INFO - 'SLAVEDIR': 'C:\\slave\\', 18:55:31 INFO - 'SYSTEMDRIVE': 'C:', 18:55:31 INFO - 'SYSTEMROOT': 'C:\\windows', 18:55:31 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 18:55:31 INFO - 'TEST1': 'testie', 18:55:31 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 18:55:31 INFO - 'USERDOMAIN': 'T-W864-IX-037', 18:55:31 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-037', 18:55:31 INFO - 'USERNAME': 'cltbld', 18:55:31 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-037', 18:55:31 INFO - 'WINDIR': 'C:\\windows', 18:55:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 18:55:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:55:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:55:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:55:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:55:32 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 18:55:32 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor 18:55:32 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) 18:55:32 INFO - Installing collected packages: mozsystemmonitor 18:55:32 INFO - Running setup.py install for mozsystemmonitor 18:55:32 INFO - Successfully installed mozsystemmonitor 18:55:32 INFO - Cleaning up... 18:55:32 INFO - Return code: 0 18:55:32 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test-pgo\build/venv 18:55:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:32 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 0x022886B0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02330EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02443240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01D68BF0>, '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 0x01D8A9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028115C0>, '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-037', 'USERDOMAIN': 'T-W864-IX-037', '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-037', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-037\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-037', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-037', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-037', '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-037\\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 18:55:32 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 18:55:32 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 18:55:32 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 18:55:32 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-037\\AppData\\Roaming', 18:55:32 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 18:55:32 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 18:55:32 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 18:55:32 INFO - 'COMPUTERNAME': 'T-W864-IX-037', 18:55:32 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 18:55:32 INFO - 'DCLOCATION': 'SCL3', 18:55:32 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 18:55:32 INFO - 'FP_NO_HOST_CHECK': 'NO', 18:55:32 INFO - 'HOMEDRIVE': 'C:', 18:55:32 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-037', 18:55:32 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 18:55:32 INFO - 'KTS_VERSION': '1.19c', 18:55:32 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-037\\AppData\\Local', 18:55:32 INFO - 'LOGONSERVER': '\\\\T-W864-IX-037', 18:55:32 INFO - 'MONDIR': 'C:\\Monitor_config\\', 18:55:32 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 18:55:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:32 INFO - 'MOZ_NO_REMOTE': '1', 18:55:32 INFO - 'NO_EM_RESTART': '1', 18:55:32 INFO - 'NUMBER_OF_PROCESSORS': '8', 18:55:32 INFO - 'OS': 'Windows_NT', 18:55:32 INFO - 'OURDRIVE': 'C:', 18:55:32 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 18:55:32 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 18:55:32 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 18:55:32 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 18:55:32 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 18:55:32 INFO - 'PROCESSOR_LEVEL': '6', 18:55:32 INFO - 'PROCESSOR_REVISION': '1e05', 18:55:32 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 18:55:32 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 18:55:33 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 18:55:33 INFO - 'PROGRAMW6432': 'C:\\Program Files', 18:55:33 INFO - 'PROMPT': '$P$G', 18:55:33 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 18:55:33 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 18:55:33 INFO - 'PUBLIC': 'C:\\Users\\Public', 18:55:33 INFO - 'PWD': 'C:\\slave\\test-pgo', 18:55:33 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 18:55:33 INFO - 'SLAVEDIR': 'C:\\slave\\', 18:55:33 INFO - 'SYSTEMDRIVE': 'C:', 18:55:33 INFO - 'SYSTEMROOT': 'C:\\windows', 18:55:33 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 18:55:33 INFO - 'TEST1': 'testie', 18:55:33 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 18:55:33 INFO - 'USERDOMAIN': 'T-W864-IX-037', 18:55:33 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-037', 18:55:33 INFO - 'USERNAME': 'cltbld', 18:55:33 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-037', 18:55:33 INFO - 'WINDIR': 'C:\\windows', 18:55:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 18:55:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:33 INFO - Downloading/unpacking blobuploader==1.2.4 18:55:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:55:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:55:34 INFO - Downloading blobuploader-1.2.4.tar.gz 18:55:34 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 18:55:34 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader 18:55:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:55:34 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 18:55:34 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 18:55:34 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 18:55:34 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\requests\setup.py) egg_info for package requests 18:55:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:55:34 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 18:55:34 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 18:55:34 INFO - Downloading docopt-0.6.1.tar.gz 18:55:35 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 18:55:35 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\docopt\setup.py) egg_info for package docopt 18:55:35 INFO - Installing collected packages: blobuploader, requests, docopt 18:55:35 INFO - Running setup.py install for blobuploader 18:55:35 INFO - Running setup.py install for requests 18:55:35 INFO - Running setup.py install for docopt 18:55:35 INFO - Successfully installed blobuploader requests docopt 18:55:35 INFO - Cleaning up... 18:55:37 INFO - Return code: 0 18:55:37 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv 18:55:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:37 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 0x022886B0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02330EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02443240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01D68BF0>, '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 0x01D8A9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028115C0>, '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-037', 'USERDOMAIN': 'T-W864-IX-037', '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-037', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-037\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-037', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-037', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-037', '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-037\\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 18:55:37 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 18:55:37 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 18:55:37 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 18:55:37 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-037\\AppData\\Roaming', 18:55:37 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 18:55:37 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 18:55:37 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 18:55:37 INFO - 'COMPUTERNAME': 'T-W864-IX-037', 18:55:37 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 18:55:37 INFO - 'DCLOCATION': 'SCL3', 18:55:37 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 18:55:37 INFO - 'FP_NO_HOST_CHECK': 'NO', 18:55:37 INFO - 'HOMEDRIVE': 'C:', 18:55:37 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-037', 18:55:37 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 18:55:37 INFO - 'KTS_VERSION': '1.19c', 18:55:37 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-037\\AppData\\Local', 18:55:37 INFO - 'LOGONSERVER': '\\\\T-W864-IX-037', 18:55:37 INFO - 'MONDIR': 'C:\\Monitor_config\\', 18:55:37 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 18:55:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:37 INFO - 'MOZ_NO_REMOTE': '1', 18:55:37 INFO - 'NO_EM_RESTART': '1', 18:55:37 INFO - 'NUMBER_OF_PROCESSORS': '8', 18:55:37 INFO - 'OS': 'Windows_NT', 18:55:37 INFO - 'OURDRIVE': 'C:', 18:55:37 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', 18:55:37 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 18:55:37 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 18:55:37 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 18:55:37 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 18:55:37 INFO - 'PROCESSOR_LEVEL': '6', 18:55:37 INFO - 'PROCESSOR_REVISION': '1e05', 18:55:37 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 18:55:37 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 18:55:37 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 18:55:37 INFO - 'PROGRAMW6432': 'C:\\Program Files', 18:55:37 INFO - 'PROMPT': '$P$G', 18:55:37 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 18:55:37 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 18:55:37 INFO - 'PUBLIC': 'C:\\Users\\Public', 18:55:37 INFO - 'PWD': 'C:\\slave\\test-pgo', 18:55:37 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 18:55:37 INFO - 'SLAVEDIR': 'C:\\slave\\', 18:55:37 INFO - 'SYSTEMDRIVE': 'C:', 18:55:37 INFO - 'SYSTEMROOT': 'C:\\windows', 18:55:37 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 18:55:37 INFO - 'TEST1': 'testie', 18:55:37 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 18:55:37 INFO - 'USERDOMAIN': 'T-W864-IX-037', 18:55:37 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-037', 18:55:37 INFO - 'USERNAME': 'cltbld', 18:55:37 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-037', 18:55:37 INFO - 'WINDIR': 'C:\\windows', 18:55:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 18:55:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:37 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\manifestparser 18:55:37 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-zpadg6-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/manifestparser 18:55:37 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozcrash 18:55:37 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-ogsjh_-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozcrash 18:55:37 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdebug 18:55:37 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-cmri9l-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdebug 18:55:37 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdevice 18:55:37 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-qyo_yx-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdevice 18:55:37 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozfile 18:55:37 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-wanums-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozfile 18:55:37 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozhttpd 18:55:37 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-63mxc7-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozhttpd 18:55:38 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinfo 18:55:38 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-20cmel-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinfo 18:55:38 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinstall 18:55:38 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-xuvdaw-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinstall 18:55:38 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozleak 18:55:38 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-o5ngsv-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozleak 18:55:38 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozlog 18:55:38 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-simwea-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozlog 18:55:38 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moznetwork 18:55:38 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-vacuvt-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moznetwork 18:55:38 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprocess 18:55:38 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-uwn4i2-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprocess 18:55:38 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprofile 18:55:38 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-2qnuu0-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprofile 18:55:38 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozrunner 18:55:38 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-d3jehh-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozrunner 18:55:39 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozscreenshot 18:55:39 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-dhjekb-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:55:39 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moztest 18:55:39 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-l7usx4-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moztest 18:55:39 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozversion 18:55:39 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-9lau4o-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozversion 18:55:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:55:39 INFO - Running setup.py install for manifestparser 18:55:39 INFO - Installing manifestparser-script.py script to C:\slave\test-pgo\build\venv\Scripts 18:55:39 INFO - Installing manifestparser.exe script to C:\slave\test-pgo\build\venv\Scripts 18:55:39 INFO - Running setup.py install for mozcrash 18:55:40 INFO - Running setup.py install for mozdebug 18:55:40 INFO - Running setup.py install for mozdevice 18:55:40 INFO - Installing sutini-script.py script to C:\slave\test-pgo\build\venv\Scripts 18:55:40 INFO - Installing sutini.exe script to C:\slave\test-pgo\build\venv\Scripts 18:55:40 INFO - Installing dm-script.py script to C:\slave\test-pgo\build\venv\Scripts 18:55:40 INFO - Installing dm.exe script to C:\slave\test-pgo\build\venv\Scripts 18:55:41 INFO - Running setup.py install for mozfile 18:55:41 INFO - Running setup.py install for mozhttpd 18:55:41 INFO - Installing mozhttpd-script.py script to C:\slave\test-pgo\build\venv\Scripts 18:55:41 INFO - Installing mozhttpd.exe script to C:\slave\test-pgo\build\venv\Scripts 18:55:41 INFO - Running setup.py install for mozinfo 18:55:42 INFO - Installing mozinfo-script.py script to C:\slave\test-pgo\build\venv\Scripts 18:55:42 INFO - Installing mozinfo.exe script to C:\slave\test-pgo\build\venv\Scripts 18:55:42 INFO - Running setup.py install for mozInstall 18:55:42 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test-pgo\build\venv\Scripts 18:55:42 INFO - Installing moz_remove_from_system.exe script to C:\slave\test-pgo\build\venv\Scripts 18:55:42 INFO - Installing mozuninstall-script.py script to C:\slave\test-pgo\build\venv\Scripts 18:55:42 INFO - Installing mozuninstall.exe script to C:\slave\test-pgo\build\venv\Scripts 18:55:42 INFO - Installing mozinstall-script.py script to C:\slave\test-pgo\build\venv\Scripts 18:55:42 INFO - Installing mozinstall.exe script to C:\slave\test-pgo\build\venv\Scripts 18:55:42 INFO - Installing moz_add_to_system-script.py script to C:\slave\test-pgo\build\venv\Scripts 18:55:42 INFO - Installing moz_add_to_system.exe script to C:\slave\test-pgo\build\venv\Scripts 18:55:42 INFO - Running setup.py install for mozleak 18:55:43 INFO - Running setup.py install for mozlog 18:55:43 INFO - Installing structlog-script.py script to C:\slave\test-pgo\build\venv\Scripts 18:55:43 INFO - Installing structlog.exe script to C:\slave\test-pgo\build\venv\Scripts 18:55:44 INFO - Running setup.py install for moznetwork 18:55:44 INFO - Installing moznetwork-script.py script to C:\slave\test-pgo\build\venv\Scripts 18:55:44 INFO - Installing moznetwork.exe script to C:\slave\test-pgo\build\venv\Scripts 18:55:44 INFO - Running setup.py install for mozprocess 18:55:45 INFO - Running setup.py install for mozprofile 18:55:45 INFO - Installing mozprofile-script.py script to C:\slave\test-pgo\build\venv\Scripts 18:55:45 INFO - Installing mozprofile.exe script to C:\slave\test-pgo\build\venv\Scripts 18:55:45 INFO - Installing diff-profiles-script.py script to C:\slave\test-pgo\build\venv\Scripts 18:55:45 INFO - Installing diff-profiles.exe script to C:\slave\test-pgo\build\venv\Scripts 18:55:45 INFO - Installing view-profile-script.py script to C:\slave\test-pgo\build\venv\Scripts 18:55:45 INFO - Installing view-profile.exe script to C:\slave\test-pgo\build\venv\Scripts 18:55:46 INFO - Running setup.py install for mozrunner 18:55:46 INFO - Installing mozrunner-script.py script to C:\slave\test-pgo\build\venv\Scripts 18:55:46 INFO - Installing mozrunner.exe script to C:\slave\test-pgo\build\venv\Scripts 18:55:46 INFO - Running setup.py install for mozscreenshot 18:55:46 INFO - Running setup.py install for moztest 18:55:47 INFO - Running setup.py install for mozversion 18:55:47 INFO - Installing mozversion-script.py script to C:\slave\test-pgo\build\venv\Scripts 18:55:47 INFO - Installing mozversion.exe script to C:\slave\test-pgo\build\venv\Scripts 18:55:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:55:47 INFO - Cleaning up... 18:55:47 INFO - Return code: 0 18:55:47 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv 18:55:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:47 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 0x022886B0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02330EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02443240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01D68BF0>, '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 0x01D8A9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028115C0>, '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-037', 'USERDOMAIN': 'T-W864-IX-037', '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-037', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-037\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-037', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-037', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-037', '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-037\\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 18:55:47 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 18:55:47 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 18:55:47 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 18:55:47 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-037\\AppData\\Roaming', 18:55:47 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 18:55:47 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 18:55:47 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 18:55:47 INFO - 'COMPUTERNAME': 'T-W864-IX-037', 18:55:47 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 18:55:47 INFO - 'DCLOCATION': 'SCL3', 18:55:47 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 18:55:47 INFO - 'FP_NO_HOST_CHECK': 'NO', 18:55:47 INFO - 'HOMEDRIVE': 'C:', 18:55:47 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-037', 18:55:47 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 18:55:47 INFO - 'KTS_VERSION': '1.19c', 18:55:47 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-037\\AppData\\Local', 18:55:47 INFO - 'LOGONSERVER': '\\\\T-W864-IX-037', 18:55:47 INFO - 'MONDIR': 'C:\\Monitor_config\\', 18:55:47 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 18:55:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:47 INFO - 'MOZ_NO_REMOTE': '1', 18:55:47 INFO - 'NO_EM_RESTART': '1', 18:55:47 INFO - 'NUMBER_OF_PROCESSORS': '8', 18:55:47 INFO - 'OS': 'Windows_NT', 18:55:47 INFO - 'OURDRIVE': 'C:', 18:55:47 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', 18:55:47 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 18:55:47 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 18:55:47 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 18:55:47 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 18:55:47 INFO - 'PROCESSOR_LEVEL': '6', 18:55:47 INFO - 'PROCESSOR_REVISION': '1e05', 18:55:47 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 18:55:47 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 18:55:47 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 18:55:47 INFO - 'PROGRAMW6432': 'C:\\Program Files', 18:55:47 INFO - 'PROMPT': '$P$G', 18:55:47 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 18:55:47 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 18:55:47 INFO - 'PUBLIC': 'C:\\Users\\Public', 18:55:47 INFO - 'PWD': 'C:\\slave\\test-pgo', 18:55:47 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 18:55:47 INFO - 'SLAVEDIR': 'C:\\slave\\', 18:55:47 INFO - 'SYSTEMDRIVE': 'C:', 18:55:47 INFO - 'SYSTEMROOT': 'C:\\windows', 18:55:47 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 18:55:47 INFO - 'TEST1': 'testie', 18:55:47 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 18:55:47 INFO - 'USERDOMAIN': 'T-W864-IX-037', 18:55:47 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-037', 18:55:47 INFO - 'USERNAME': 'cltbld', 18:55:47 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-037', 18:55:47 INFO - 'WINDIR': 'C:\\windows', 18:55:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 18:55:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:48 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\manifestparser 18:55:48 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-t21tdz-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/manifestparser 18:55:48 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)) 18:55:48 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozcrash 18:55:48 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-emcb8b-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozcrash 18:55:48 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)) 18:55:48 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdebug 18:55:48 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-9pdiwn-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdebug 18:55:48 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)) 18:55:48 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdevice 18:55:48 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-fbxl5a-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdevice 18:55:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 18:55:48 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozfile 18:55:48 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rytprh-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozfile 18:55:48 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)) 18:55:48 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozhttpd 18:55:48 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-rgx8c7-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozhttpd 18:55:48 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)) 18:55:48 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinfo 18:55:48 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-l_hark-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinfo 18:55:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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)) 18:55:48 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinstall 18:55:48 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-firv94-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinstall 18:55:49 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)) 18:55:49 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozleak 18:55:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-16sis5-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozleak 18:55:49 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)) 18:55:49 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozlog 18:55:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-1xatni-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozlog 18:55:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 18:55:49 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moznetwork 18:55:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-sidqnd-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moznetwork 18:55:49 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)) 18:55:49 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprocess 18:55:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-lqb73q-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprocess 18:55:49 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)) 18:55:49 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprofile 18:55:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-4tjxfg-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprofile 18:55:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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)) 18:55:49 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozrunner 18:55:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-npqk41-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozrunner 18:55:49 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)) 18:55:49 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozscreenshot 18:55:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-sx0nj_-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:55:49 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)) 18:55:49 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moztest 18:55:49 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-c2pumz-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moztest 18:55:50 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)) 18:55:50 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozversion 18:55:50 INFO - Running setup.py (path:c:\users\cltbld~1.t-w\appdata\local\temp\pip-bl1uc5-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozversion 18:55:50 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)) 18:55:50 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)) 18:55:50 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)) 18:55:50 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)) 18:55:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test-pgo\build\venv\lib\site-packages (from mozdevice==0.47->-r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 4)) 18:55:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in c:\slave\test-pgo\build\venv\lib\site-packages (from mozdevice==0.47->-r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 4)) 18:55:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 10)) 18:55:50 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 18:55:50 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 18:55:51 INFO - Downloading blessings-1.5.1.tar.gz 18:55:51 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 18:55:51 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\blessings\setup.py) egg_info for package blessings 18:55:51 INFO - Installing collected packages: blessings 18:55:51 INFO - Running setup.py install for blessings 18:55:51 INFO - Successfully installed blessings 18:55:51 INFO - Cleaning up... 18:55:54 INFO - Return code: 0 18:55:54 INFO - Done creating virtualenv C:\slave\test-pgo\build/venv. 18:55:54 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'freeze'] 18:55:54 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip freeze 18:55:54 INFO - Reading from file tmpfile_stdout 18:55:54 INFO - Using _rmtree_windows ... 18:55:54 INFO - Using _rmtree_windows ... 18:55:54 INFO - Current package versions: 18:55:54 INFO - blessings == 1.5.1 18:55:54 INFO - blobuploader == 1.2.4 18:55:54 INFO - docopt == 0.6.1 18:55:54 INFO - manifestparser == 1.1 18:55:54 INFO - mozInstall == 1.12 18:55:54 INFO - mozcrash == 0.16 18:55:54 INFO - mozdebug == 0.1 18:55:54 INFO - mozdevice == 0.47 18:55:54 INFO - mozfile == 1.2 18:55:54 INFO - mozhttpd == 0.7 18:55:54 INFO - mozinfo == 0.9 18:55:54 INFO - mozleak == 0.1 18:55:54 INFO - mozlog == 3.1 18:55:54 INFO - moznetwork == 0.27 18:55:54 INFO - mozprocess == 0.22 18:55:54 INFO - mozprofile == 0.28 18:55:54 INFO - mozrunner == 6.11 18:55:54 INFO - mozscreenshot == 0.1 18:55:54 INFO - mozsystemmonitor == 0.0 18:55:54 INFO - moztest == 0.7 18:55:54 INFO - mozversion == 1.4 18:55:54 INFO - psutil == 3.1.1 18:55:54 INFO - requests == 1.2.3 18:55:54 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv 18:55:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:54 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 0x022886B0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02330EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02443240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01D68BF0>, '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 0x01D8A9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028115C0>, '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-037', 'USERDOMAIN': 'T-W864-IX-037', '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-037', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-037\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-037', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-037', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-037', '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-037\\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 18:55:54 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 18:55:54 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 18:55:54 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 18:55:54 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-037\\AppData\\Roaming', 18:55:54 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 18:55:54 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 18:55:54 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 18:55:54 INFO - 'COMPUTERNAME': 'T-W864-IX-037', 18:55:54 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 18:55:54 INFO - 'DCLOCATION': 'SCL3', 18:55:54 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 18:55:54 INFO - 'FP_NO_HOST_CHECK': 'NO', 18:55:54 INFO - 'HOMEDRIVE': 'C:', 18:55:54 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-037', 18:55:54 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 18:55:54 INFO - 'KTS_VERSION': '1.19c', 18:55:54 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-037\\AppData\\Local', 18:55:54 INFO - 'LOGONSERVER': '\\\\T-W864-IX-037', 18:55:54 INFO - 'MONDIR': 'C:\\Monitor_config\\', 18:55:54 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 18:55:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:54 INFO - 'MOZ_NO_REMOTE': '1', 18:55:54 INFO - 'NO_EM_RESTART': '1', 18:55:54 INFO - 'NUMBER_OF_PROCESSORS': '8', 18:55:54 INFO - 'OS': 'Windows_NT', 18:55:54 INFO - 'OURDRIVE': 'C:', 18:55:54 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 18:55:54 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 18:55:54 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 18:55:54 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 18:55:54 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 18:55:54 INFO - 'PROCESSOR_LEVEL': '6', 18:55:54 INFO - 'PROCESSOR_REVISION': '1e05', 18:55:54 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 18:55:54 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 18:55:54 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 18:55:54 INFO - 'PROGRAMW6432': 'C:\\Program Files', 18:55:54 INFO - 'PROMPT': '$P$G', 18:55:54 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 18:55:54 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 18:55:54 INFO - 'PUBLIC': 'C:\\Users\\Public', 18:55:54 INFO - 'PWD': 'C:\\slave\\test-pgo', 18:55:54 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 18:55:54 INFO - 'SLAVEDIR': 'C:\\slave\\', 18:55:54 INFO - 'SYSTEMDRIVE': 'C:', 18:55:54 INFO - 'SYSTEMROOT': 'C:\\windows', 18:55:54 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 18:55:54 INFO - 'TEST1': 'testie', 18:55:54 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 18:55:54 INFO - 'USERDOMAIN': 'T-W864-IX-037', 18:55:54 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-037', 18:55:54 INFO - 'USERNAME': 'cltbld', 18:55:54 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-037', 18:55:54 INFO - 'WINDIR': 'C:\\windows', 18:55:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 18:55:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 1)) 18:55:55 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 2)) 18:55:55 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 3)) 18:55:55 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 4)) 18:55:55 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 5)) 18:55:55 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 6)) 18:55:55 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 7)) 18:55:55 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 8)) 18:55:55 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 9)) 18:55:55 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in c:\slave\test-pgo\build\venv\lib\site-packages (from mozlog>=3.1->-r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 1)) 18:55:55 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 4)) 18:55:55 INFO - Cleaning up... 18:55:55 INFO - Return code: 0 18:55:55 INFO - Installing jsonschema into virtualenv C:\slave\test-pgo\build/venv 18:55:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:55 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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022886B0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02330EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02443240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01D68BF0>, '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 0x01D8A9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028115C0>, '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-037', 'USERDOMAIN': 'T-W864-IX-037', '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-037', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-037\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-037', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-037', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-037', '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-037\\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 18:55:55 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', 'jsonschema'] in C:\slave\test-pgo\build 18:55:55 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 jsonschema 18:55:55 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 18:55:55 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-037\\AppData\\Roaming', 18:55:55 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 18:55:55 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 18:55:55 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 18:55:55 INFO - 'COMPUTERNAME': 'T-W864-IX-037', 18:55:55 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 18:55:55 INFO - 'DCLOCATION': 'SCL3', 18:55:55 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 18:55:55 INFO - 'FP_NO_HOST_CHECK': 'NO', 18:55:55 INFO - 'HOMEDRIVE': 'C:', 18:55:55 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-037', 18:55:55 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 18:55:55 INFO - 'KTS_VERSION': '1.19c', 18:55:55 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-037\\AppData\\Local', 18:55:55 INFO - 'LOGONSERVER': '\\\\T-W864-IX-037', 18:55:55 INFO - 'MONDIR': 'C:\\Monitor_config\\', 18:55:55 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 18:55:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:55 INFO - 'MOZ_NO_REMOTE': '1', 18:55:55 INFO - 'NO_EM_RESTART': '1', 18:55:55 INFO - 'NUMBER_OF_PROCESSORS': '8', 18:55:55 INFO - 'OS': 'Windows_NT', 18:55:55 INFO - 'OURDRIVE': 'C:', 18:55:55 INFO - 'PATH': 'C:\\Program Files (x86)\\NVIDIA Corporation\\PhysX\\Common;C:\\windows\\system32;C:\\windows;C:\\windows\\System32\\Wbem;C:\\windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\vim\\vim72;C:\\mozilla-build\\wget;C:\\mozilla-build\\info-zip;C:\\CoreUtils\\bin;C:\\mozilla-build\\buildbotve\\scripts;C:\\mozilla-build\\hg', 18:55:55 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 18:55:55 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 18:55:55 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 18:55:55 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 18:55:55 INFO - 'PROCESSOR_LEVEL': '6', 18:55:55 INFO - 'PROCESSOR_REVISION': '1e05', 18:55:55 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 18:55:55 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 18:55:55 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 18:55:55 INFO - 'PROGRAMW6432': 'C:\\Program Files', 18:55:55 INFO - 'PROMPT': '$P$G', 18:55:55 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 18:55:55 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 18:55:55 INFO - 'PUBLIC': 'C:\\Users\\Public', 18:55:55 INFO - 'PWD': 'C:\\slave\\test-pgo', 18:55:55 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 18:55:55 INFO - 'SLAVEDIR': 'C:\\slave\\', 18:55:55 INFO - 'SYSTEMDRIVE': 'C:', 18:55:55 INFO - 'SYSTEMROOT': 'C:\\windows', 18:55:55 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 18:55:55 INFO - 'TEST1': 'testie', 18:55:55 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 18:55:55 INFO - 'USERDOMAIN': 'T-W864-IX-037', 18:55:55 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-037', 18:55:55 INFO - 'USERNAME': 'cltbld', 18:55:55 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-037', 18:55:55 INFO - 'WINDIR': 'C:\\windows', 18:55:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 18:55:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:55 INFO - Downloading/unpacking jsonschema 18:55:55 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 18:55:55 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 18:55:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:55:56 INFO - Storing download in cache at c:\slave\test-pgo\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fjsonschema-2.5.1-py2.py3-none-any.whl 18:55:56 INFO - Downloading/unpacking functools32 (from jsonschema) 18:55:56 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 18:55:56 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 18:55:56 INFO - Downloading functools32-3.2.3-2.tar.gz 18:55:56 INFO - Storing download in cache at c:\slave\test-pgo\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2ffunctools32-3.2.3-2.tar.gz 18:55:56 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\functools32\setup.py) egg_info for package functools32 18:55:56 INFO - warning: no files found matching '*.txt' 18:55:56 INFO - no previously-included directories found matching 'build' 18:55:56 INFO - no previously-included directories found matching 'dist' 18:55:56 INFO - no previously-included directories found matching '.git*' 18:55:56 INFO - Installing collected packages: jsonschema, functools32 18:55:56 INFO - Running setup.py install for functools32 18:55:56 INFO - warning: no files found matching '*.txt' 18:55:56 INFO - no previously-included directories found matching 'build' 18:55:56 INFO - no previously-included directories found matching 'dist' 18:55:56 INFO - no previously-included directories found matching '.git*' 18:55:57 INFO - Successfully installed jsonschema functools32 18:55:57 INFO - Cleaning up... 18:55:57 INFO - Return code: 0 18:55:57 INFO - Installing flake8 into virtualenv C:\slave\test-pgo\build/venv 18:55:57 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')]} 18:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:57 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')]} 18:55:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:57 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x022886B0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x02330EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x02443240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01D68BF0>, '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 0x01D8A9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028115C0>, '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-037', 'USERDOMAIN': 'T-W864-IX-037', '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-037', 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-037\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-037', 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-037', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W864-IX-037', '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-037\\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 18:55:57 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', 'flake8'] in C:\slave\test-pgo\build 18:55:57 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 flake8 18:55:57 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 18:55:57 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-037\\AppData\\Roaming', 18:55:57 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 18:55:57 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 18:55:57 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 18:55:57 INFO - 'COMPUTERNAME': 'T-W864-IX-037', 18:55:57 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 18:55:57 INFO - 'DCLOCATION': 'SCL3', 18:55:57 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 18:55:57 INFO - 'FP_NO_HOST_CHECK': 'NO', 18:55:57 INFO - 'HOMEDRIVE': 'C:', 18:55:57 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-037', 18:55:57 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 18:55:57 INFO - 'KTS_VERSION': '1.19c', 18:55:57 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-037\\AppData\\Local', 18:55:57 INFO - 'LOGONSERVER': '\\\\T-W864-IX-037', 18:55:57 INFO - 'MONDIR': 'C:\\Monitor_config\\', 18:55:57 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 18:55:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:57 INFO - 'MOZ_NO_REMOTE': '1', 18:55:57 INFO - 'NO_EM_RESTART': '1', 18:55:57 INFO - 'NUMBER_OF_PROCESSORS': '8', 18:55:57 INFO - 'OS': 'Windows_NT', 18:55:57 INFO - 'OURDRIVE': 'C:', 18:55:57 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', 18:55:57 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 18:55:57 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 18:55:57 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 18:55:57 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 18:55:57 INFO - 'PROCESSOR_LEVEL': '6', 18:55:57 INFO - 'PROCESSOR_REVISION': '1e05', 18:55:57 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 18:55:57 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 18:55:57 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 18:55:57 INFO - 'PROGRAMW6432': 'C:\\Program Files', 18:55:57 INFO - 'PROMPT': '$P$G', 18:55:57 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 18:55:57 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 18:55:57 INFO - 'PUBLIC': 'C:\\Users\\Public', 18:55:57 INFO - 'PWD': 'C:\\slave\\test-pgo', 18:55:57 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 18:55:57 INFO - 'SLAVEDIR': 'C:\\slave\\', 18:55:57 INFO - 'SYSTEMDRIVE': 'C:', 18:55:57 INFO - 'SYSTEMROOT': 'C:\\windows', 18:55:57 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 18:55:57 INFO - 'TEST1': 'testie', 18:55:57 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 18:55:57 INFO - 'USERDOMAIN': 'T-W864-IX-037', 18:55:57 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-037', 18:55:57 INFO - 'USERNAME': 'cltbld', 18:55:57 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-037', 18:55:57 INFO - 'WINDIR': 'C:\\windows', 18:55:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 18:55:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:57 INFO - Downloading/unpacking flake8 18:55:57 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 18:55:57 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 18:55:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:55:58 INFO - Storing download in cache at c:\slave\test-pgo\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fflake8-2.5.0-py2.py3-none-any.whl 18:55:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:55:58 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 18:55:58 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 18:55:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:55:58 INFO - Storing download in cache at c:\slave\test-pgo\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fmccabe-0.3.1-py2.py3-none-any.whl 18:55:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:55:58 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 18:55:58 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 18:55:58 INFO - Storing download in cache at c:\slave\test-pgo\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fpyflakes-1.0.0-py2.py3-none-any.whl 18:55:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:55:59 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 18:55:59 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 18:55:59 INFO - Storing download in cache at c:\slave\test-pgo\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fpep8-1.5.7.tar.gz 18:55:59 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\pep8\setup.py) egg_info for package pep8 18:55:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:55:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:55:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:55:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:55:59 INFO - no previously-included directories found matching 'docs\_build' 18:55:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:55:59 INFO - Running setup.py install for pep8 18:55:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:55:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:55:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:55:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:55:59 INFO - no previously-included directories found matching 'docs\_build' 18:55:59 INFO - Installing pep8-script.py script to C:\slave\test-pgo\build\venv\Scripts 18:55:59 INFO - Installing pep8.exe script to C:\slave\test-pgo\build\venv\Scripts 18:55:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:55:59 INFO - Cleaning up... 18:56:00 INFO - Return code: 0 18:56:00 INFO - Running post-action listener: _resource_record_post_action 18:56:00 INFO - Running post-action listener: _start_resource_monitoring 18:56:00 INFO - Starting resource monitoring. 18:56:00 INFO - ##### 18:56:00 INFO - ##### Running install step. 18:56:00 INFO - ##### 18:56:00 INFO - Running pre-action listener: _resource_record_pre_action 18:56:00 INFO - Running main action method: install 18:56:00 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'freeze'] 18:56:00 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip freeze 18:56:00 INFO - Reading from file tmpfile_stdout 18:56:00 INFO - Using _rmtree_windows ... 18:56:00 INFO - Using _rmtree_windows ... 18:56:00 INFO - Detecting whether we're running mozinstall >=1.0... 18:56:00 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build/venv/scripts/python', 'C:\\slave\\test-pgo\\build/venv/scripts/mozinstall-script.py', '-h'] 18:56:00 INFO - Copy/paste: C:\slave\test-pgo\build/venv/scripts/python C:\slave\test-pgo\build/venv/scripts/mozinstall-script.py -h 18:56:01 INFO - Reading from file tmpfile_stdout 18:56:01 INFO - Output received: 18:56:01 INFO - Usage: mozinstall-script.py [options] installer 18:56:01 INFO - Options: 18:56:01 INFO - -h, --help show this help message and exit 18:56:01 INFO - -d DEST, --destination=DEST 18:56:01 INFO - Directory to install application into. [default: 18:56:01 INFO - "C:\slave\test-pgo"] 18:56:01 INFO - --app=APP Application being installed. [default: firefox] 18:56:01 INFO - Using _rmtree_windows ... 18:56:01 INFO - Using _rmtree_windows ... 18:56:01 INFO - mkdir: C:\slave\test-pgo\build\application 18:56:01 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-46.0a1.en-US.win64.zip', '--destination', 'C:\\slave\\test-pgo\\build\\application'] 18:56:01 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-46.0a1.en-US.win64.zip --destination C:\slave\test-pgo\build\application 18:56:05 INFO - Reading from file tmpfile_stdout 18:56:05 INFO - Output received: 18:56:05 INFO - C:\slave\test-pgo\build\application\firefox\firefox.exe 18:56:05 INFO - Using _rmtree_windows ... 18:56:05 INFO - Using _rmtree_windows ... 18:56:05 INFO - Running post-action listener: _resource_record_post_action 18:56:05 INFO - ##### 18:56:05 INFO - ##### Running run-tests step. 18:56:05 INFO - ##### 18:56:05 INFO - Running pre-action listener: _resource_record_pre_action 18:56:05 INFO - Running main action method: run_tests 18:56:05 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\python', '--version'] 18:56:05 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\python --version 18:56:05 INFO - Python 2.7.3 18:56:05 INFO - Return code: 0 18:56:05 INFO - grabbing minidump binary from tooltool 18:56: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')]} 18:56:05 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 0x01D68BF0>, '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 0x01D8A9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x028115C0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'privileged': False}, attempt #1 18:56:05 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 18:56:05 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 18:56:05 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 18:56:05 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test-pgo\build\tmppgswqd 18:56:05 INFO - INFO - File integrity verified, renaming tmppgswqd to win32-minidump_stackwalk.exe 18:56:05 INFO - Return code: 0 18:56:05 INFO - Chmoding C:\slave\test-pgo\build\win32-minidump_stackwalk.exe to 0755 18:56:05 INFO - mkdir: C:\slave\test-pgo\build\blobber_upload_dir 18:56:05 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test-pgo\build\blobber_upload_dir 18:56:05 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test-pgo\build\win32-minidump_stackwalk.exe 18:56:05 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test-pgo\build\blobber_upload_dir 18:56:05 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\flake8', 'C:\\slave\\test-pgo\\build\\tests\\talos\\talos'] 18:56:05 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\flake8 C:\slave\test-pgo\build\tests\talos\talos 18:56:06 INFO - Return code: 0 18:56:06 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\python', 'C:\\slave\\test-pgo\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'svgr', '--executablePath', 'C:\\slave\\test-pgo\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B2R6eceDQ565VBbQLF2bfg/artifacts/public/build/firefox-46.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=C:\\slave\\test-pgo\\build\\blobber_upload_dir\\svgr_errorsummary.log', '--log-raw=C:\\slave\\test-pgo\\build\\blobber_upload_dir\\svgr_raw.log'] in C:\slave\test-pgo\build 18:56:06 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\python C:\slave\test-pgo\build\tests\talos\talos\run_tests.py --branchName Mozilla-Inbound --suite svgr --executablePath C:\slave\test-pgo\build\application\firefox\firefox --symbolsPath https://queue.taskcluster.net/v1/task/B2R6eceDQ565VBbQLF2bfg/artifacts/public/build/firefox-46.0a1.en-US.win64.crashreporter-symbols.zip --title T-W864-IX-037 --webServer localhost --log-tbpl-level=debug --log-errorsummary=C:\slave\test-pgo\build\blobber_upload_dir\svgr_errorsummary.log --log-raw=C:\slave\test-pgo\build\blobber_upload_dir\svgr_raw.log 18:56:06 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 18:56:06 INFO - 'APPDATA': 'C:\\Users\\cltbld.T-W864-IX-037\\AppData\\Roaming', 18:56:06 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files (x86)\\Common Files', 18:56:06 INFO - 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 18:56:06 INFO - 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 18:56:06 INFO - 'COMPUTERNAME': 'T-W864-IX-037', 18:56:06 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 18:56:06 INFO - 'DCLOCATION': 'SCL3', 18:56:06 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 18:56:06 INFO - 'FP_NO_HOST_CHECK': 'NO', 18:56:06 INFO - 'HOMEDRIVE': 'C:', 18:56:06 INFO - 'HOMEPATH': '\\Users\\cltbld.T-W864-IX-037', 18:56:06 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 18:56:06 INFO - 'KTS_VERSION': '1.19c', 18:56:06 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld.T-W864-IX-037\\AppData\\Local', 18:56:06 INFO - 'LOGONSERVER': '\\\\T-W864-IX-037', 18:56:06 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test-pgo\\build\\blobber_upload_dir', 18:56:06 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test-pgo\\build\\win32-minidump_stackwalk.exe', 18:56:06 INFO - 'MONDIR': 'C:\\Monitor_config\\', 18:56:06 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 18:56:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:06 INFO - 'MOZ_NO_REMOTE': '1', 18:56:06 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test-pgo\\build\\blobber_upload_dir', 18:56:06 INFO - 'NO_EM_RESTART': '1', 18:56:06 INFO - 'NUMBER_OF_PROCESSORS': '8', 18:56:06 INFO - 'OS': 'Windows_NT', 18:56:06 INFO - 'OURDRIVE': 'C:', 18:56:06 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', 18:56:06 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 18:56:06 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 18:56:06 INFO - 'PROCESSOR_ARCHITEW6432': 'AMD64', 18:56:06 INFO - 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 30 Stepping 5, GenuineIntel', 18:56:06 INFO - 'PROCESSOR_LEVEL': '6', 18:56:06 INFO - 'PROCESSOR_REVISION': '1e05', 18:56:06 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 18:56:06 INFO - 'PROGRAMFILES': 'C:\\Program Files (x86)', 18:56:06 INFO - 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 18:56:06 INFO - 'PROGRAMW6432': 'C:\\Program Files', 18:56:06 INFO - 'PROMPT': '$P$G', 18:56:06 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 18:56:06 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 18:56:06 INFO - 'PUBLIC': 'C:\\Users\\Public', 18:56:06 INFO - 'PWD': 'C:\\slave\\test-pgo', 18:56:06 INFO - 'PYTHONPATH': 'C:\\slave\\test-pgo\\build\\tests\\talos', 18:56:06 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 18:56:06 INFO - 'SLAVEDIR': 'C:\\slave\\', 18:56:06 INFO - 'SYSTEMDRIVE': 'C:', 18:56:06 INFO - 'SYSTEMROOT': 'C:\\windows', 18:56:06 INFO - 'TEMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 18:56:06 INFO - 'TEST1': 'testie', 18:56:06 INFO - 'TMP': 'C:\\Users\\CLTBLD~1.T-W\\AppData\\Local\\Temp', 18:56:06 INFO - 'USERDOMAIN': 'T-W864-IX-037', 18:56:06 INFO - 'USERDOMAIN_ROAMINGPROFILE': 'T-W864-IX-037', 18:56:06 INFO - 'USERNAME': 'cltbld', 18:56:06 INFO - 'USERPROFILE': 'C:\\Users\\cltbld.T-W864-IX-037', 18:56:06 INFO - 'WINDIR': 'C:\\windows', 18:56:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 18:56:06 INFO - Calling ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\python', 'C:\\slave\\test-pgo\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'svgr', '--executablePath', 'C:\\slave\\test-pgo\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B2R6eceDQ565VBbQLF2bfg/artifacts/public/build/firefox-46.0a1.en-US.win64.crashreporter-symbols.zip', '--title', 'T-W864-IX-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=C:\\slave\\test-pgo\\build\\blobber_upload_dir\\svgr_errorsummary.log', '--log-raw=C:\\slave\\test-pgo\\build\\blobber_upload_dir\\svgr_raw.log'] with output_timeout 3600 ProcessManager NOT managing child processes ProcessManager UNABLE to use job objects to manage child processes 18:56:09 INFO - mozversion application_buildid: 20151223133015 18:56:09 INFO - mozversion application_changeset: 1cc7f3085826a7bddf4459aa03b1b87cd8cc8a8e 18:56:09 INFO - mozversion application_display_name: Nightly 18:56:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:56:09 INFO - mozversion application_name: Firefox 18:56:09 INFO - mozversion application_remotingname: firefox 18:56:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:56:09 INFO - mozversion application_vendor: Mozilla 18:56:09 INFO - mozversion application_version: 46.0a1 18:56:09 INFO - mozversion platform_buildid: 20151223133015 18:56:09 INFO - mozversion platform_changeset: 1cc7f3085826a7bddf4459aa03b1b87cd8cc8a8e 18:56:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:56:09 INFO - mozversion platform_version: 46.0a1 18:56:09 INFO - using testdate: 1450925769 18:56:09 INFO - actual date: 1450925769 18:56:09 INFO - starting webserver on 'localhost:49270' 18:56:09 INFO - SUITE-START | Running 5 tests 18:56:09 INFO - TEST-START | tsvgx 18:56:09 INFO - operating with platform_type : w8_ 18:56:09 INFO - Initialising browser for tsvgx test... 18:56:09 INFO - TEST-INFO | started process 3632 (C:\slave\test-pgo\build\application\firefox\firefox -profile c:\users\cltbld~1.t-w\appdata\local\temp\tmp5cegtq\profile http://localhost:49270/getInfo.html) 18:56:26 INFO - PROCESS | 3632 | __metrics Screen width/height:1600/1200 18:56:26 INFO - PROCESS | 3632 | colorDepth:24 18:56:26 INFO - PROCESS | 3632 | Browser inner width/height: 1010/672 18:56:26 INFO - PROCESS | 3632 | __metrics 18:56:27 INFO - PROCESS | 3632 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:56:27 INFO - PROCESS | 3632 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:56:29 INFO - PROCESS | 3632 | ************************* 18:56:29 INFO - PROCESS | 3632 | A coding exception was thrown and uncaught in a Task. 18:56:29 INFO - PROCESS | 3632 | 18:56:29 ERROR - PROCESS | 3632 | Full message: TypeError: connection.database is undefined 18:56:29 INFO - PROCESS | 3632 | Full stack: wrapStorageConnection@resource://gre/modules/Sqlite.jsm:1057:5 18:56:29 INFO - PROCESS | 3632 | @resource://gre/modules/PlacesUtils.jsm:2100:9 18:56:29 INFO - PROCESS | 3632 | XPCU_defineLazyGetter/<.get@resource://gre/modules/XPCOMUtils.jsm:198:21 18:56:29 INFO - PROCESS | 3632 | this.PlacesUtils.withConnectionWrapper/<@resource://gre/modules/PlacesUtils.jsm:1424:11 18:56:29 INFO - PROCESS | 3632 | TaskImpl_run@resource://gre/modules/Task.jsm:315:40 18:56:29 INFO - PROCESS | 3632 | TaskImpl@resource://gre/modules/Task.jsm:276:3 18:56:29 INFO - PROCESS | 3632 | createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:250:14 18:56:29 INFO - PROCESS | 3632 | Task_spawn@resource://gre/modules/Task.jsm:164:12 18:56:29 INFO - PROCESS | 3632 | this.PlacesUtils.withConnectionWrapper@resource://gre/modules/PlacesUtils.jsm:1423:1 18:56:29 INFO - PROCESS | 3632 | @resource://gre/modules/PlacesUtils.jsm:2293:1 18:56:29 INFO - PROCESS | 3632 | XPCU_defineLazyGetter/<.get@resource://gre/modules/XPCOMUtils.jsm:198:21 18:56:29 INFO - PROCESS | 3632 | PU_observe@resource://gre/modules/PlacesUtils.jsm:389:9 18:56:29 INFO - PROCESS | 3632 | PlacesCategoriesStarter/notify@resource://gre/components/PlacesCategoriesStarter.js:51:7 18:56:29 INFO - PROCESS | 3632 | walkTreeForImport@resource://gre/modules/BookmarkHTMLUtils.jsm:935:5 18:56:29 INFO - PROCESS | 3632 | BookmarkImporter.prototype.importFromURLtsvgx: 124.90 19:12:13 INFO - RETURN: tsvgr_opacity: 330.33 19:12:13 INFO - RETURN: tart: 4.26 19:12:13 INFO - RETURN: tscrollx: 2.67 19:12:13 INFO - RETURN: cart: 23.19 19:12:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [153.0, 106.0, 100.0, 100.0, 102.0, 103.0, 98.0, 100.0, 103.0, 101.0, 100.0, 102.0, 98.0, 105.0, 102.0, 99.0, 101.0, 103.0, 98.0, 102.0, 102.0, 102.0, 100.0, 100.0, 99.0], "unit": "ms", "name": "gearflowers.svg", "value": 101.0}, {"lowerIsBetter": true, "replicates": [75.0, 37.0, 36.0, 36.0, 37.0, 36.0, 37.0, 36.0, 36.0, 36.0, 39.0, 101.0, 37.0, 36.0, 35.0, 37.0, 36.0, 34.0, 37.0, 36.0, 36.0, 36.0, 36.0, 36.0, 36.0], "unit": "ms", "name": "composite-scale.svg", "value": 36.0}, {"lowerIsBetter": true, "replicates": [52.0, 39.0, 128.0, 37.0, 42.0, 38.0, 38.0, 39.0, 39.0, 40.0, 39.0, 39.0, 39.0, 38.0, 38.0, 40.0, 38.0, 38.0, 40.0, 38.0, 39.0, 40.0, 39.0, 41.0, 39.0], "unit": "ms", "name": "composite-scale-opacity.svg", "value": 39.0}, {"lowerIsBetter": true, "replicates": [47.0, 40.0, 37.0, 38.0, 37.0, 36.0, 40.0, 37.0, 38.0, 38.0, 37.0, 40.0, 39.0, 36.0, 40.0, 37.0, 37.0, 41.0, 36.0, 37.0, 38.0, 38.0, 39.0, 38.0, 37.0], "unit": "ms", "name": "composite-scale-rotate.svg", "value": 38.0}, {"lowerIsBetter": true, "replicates": [89.0, 45.0, 40.0, 40.0, 43.0, 40.0, 43.0, 42.0, 41.0, 43.0, 39.0, 40.0, 42.0, 40.0, 39.0, 43.0, 41.0, 39.0, 42.0, 42.0, 43.0, 41.0, 42.0, 42.0, 40.0], "unit": "ms", "name": "composite-scale-rotate-opacity.svg", "value": 41.5}, {"lowerIsBetter": true, "replicates": [436.0, 365.0, 363.0, 359.0, 488.0, 386.0, 388.0, 389.0, 361.0, 358.0, 368.0, 361.0, 377.0, 362.0, 361.0, 362.0, 362.0, 362.0, 367.0, 371.0, 372.0, 362.0, 364.0, 355.0, 364.0], "unit": "ms", "name": "hixie-001.xml", "value": 363.0}, {"lowerIsBetter": true, "replicates": [366.0, 369.0, 357.0, 363.0, 364.0, 361.0, 360.0, 359.0, 360.0, 368.0, 373.0, 366.0, 364.0, 360.0, 358.0, 371.0, 353.0, 360.0, 361.0, 364.0, 374.0, 359.0, 362.0, 370.0, 367.0], "unit": "ms", "name": "hixie-002.xml", "value": 361.5}, {"lowerIsBetter": true, "replicates": [388.0, 192.0, 188.0, 186.0, 189.0, 185.0, 188.0, 183.0, 185.0, 184.0, 198.0, 183.0, 191.0, 184.0, 182.0, 187.0, 190.0, 187.0, 190.0, 188.0, 193.0, 185.0, 203.0, 185.0, 192.0], "unit": "ms", "name": "hixie-003.xml", "value": 187.0}, {"lowerIsBetter": true, "replicates": [313.0, 300.0, 299.0, 299.0, 306.0, 305.0, 301.0, 305.0, 304.0, 305.0, 299.0, 300.0, 301.0, 303.0, 300.0, 302.0, 302.0, 301.0, 300.0, 313.0, 298.0, 300.0, 312.0, 306.0, 301.0], "unit": "ms", "name": "hixie-004.xml", "value": 301.5}, {"lowerIsBetter": true, "replicates": [207.0, 199.0, 199.0, 198.0, 202.0, 198.0, 201.0, 199.0, 201.0, 198.0, 203.0, 200.0, 202.0, 202.0, 200.0, 201.0, 199.0, 198.0, 198.0, 199.0, 200.0, 197.0, 200.0, 200.0, 200.0], "unit": "ms", "name": "hixie-005.xml", "value": 200.0}, {"lowerIsBetter": true, "replicates": [207.0, 209.0, 201.0, 199.0, 206.0, 204.0, 204.0, 201.0, 212.0, 203.0, 200.0, 203.0, 203.0, 206.0, 205.0, 213.0, 207.0, 204.0, 201.0, 205.0, 202.0, 1418.0, 200.0, 198.0, 202.0], "unit": "ms", "name": "hixie-006.xml", "value": 203.5}, {"lowerIsBetter": true, "replicates": [291.0, 198.0, 206.0, 204.0, 204.0, 204.0, 199.0, 201.0, 202.0, 203.0, 208.0, 205.0, 206.0, 202.0, 206.0, 202.0, 206.0, 203.0, 207.0, 202.0, 207.0, 204.0, 205.0, 205.0, 205.0], "unit": "ms", "name": "hixie-007.xml", "value": 204.5}], "name": "tsvgx", "value": 124.90001163745544}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [438.0, 227.0, 220.0, 226.0, 220.0, 228.0, 220.0, 228.0, 220.0, 221.0, 220.0, 222.0, 220.0, 221.0, 221.0, 218.0, 226.0, 218.0, 219.0, 222.0, 220.0, 222.0, 226.0, 221.0, 215.0], "unit": "ms", "name": "big-optimizable-group-opacity-2500.svg", "value": 221.0}, {"lowerIsBetter": true, "replicates": [531.0, 526.0, 497.0, 486.0, 493.0, 488.0, 490.0, 498.0, 489.0, 501.0, 499.0, 492.0, 499.0, 502.0, 489.0, 492.0, 495.0, 527.0, 495.0, 490.0, 492.0, 491.0, 496.0, 508.0, 490.0], "unit": "ms", "name": "small-group-opacity-2500.svg", "value": 493.5}], "name": "tsvgr_opacity", "value": 330.3291414892448}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [1.8990097632173633, 1.9585667080798392, 1.934256730477015, 1.9896669778330573, 2.112157875841314, 1.9810599715022716, 1.9781051308421764, 1.993871101017656, 2.000948603810935, 1.9969430976900562, 1.9603890928171448, 1.9669756545858867, 1.9581696966947135, 1.959803324634746, 1.983443529441439, 1.9936923405219769, 1.9509517984875178, 1.9556834738133317, 1.9411879261334737, 1.9594193171646634, 1.9722865557266493, 1.9609488087185358, 1.963207240832054, 1.9757360401800124, 1.9809818671921553], "unit": "ms", "name": "simple-open-DPI1.half.TART", "value": 1.969631105156268}, {"lowerIsBetter": true, "replicates": [2.1597068159520125, 2.2591971064868726, 2.2442986107709113, 2.287835100055796, 2.5202602954471813, 2.300311341881752, 2.287087352148124, 2.3036987675087794, 2.3366893703287297, 2.3013913375990733, 2.2793123553284502, 2.286900583621675, 2.289031272440885, 2.302625630583082, 2.2671061513716713, 2.3160705426791766, 2.2657149841910913, 2.2708855229511595, 2.224943244975546, 2.2501798533556756, 2.2835771088051584, 2.2572905797707405, 2.279743906670967, 2.2857009847607235, 2.286598126445196], "unit": "ms", "name": "simple-open-DPI1.all.TART", "value": 2.28614955560296}, {"lowerIsBetter": true, "replicates": [27.475000000000364, 28.12000000000262, 26.485000000000582, 28.87000000000262, 28.095000000001164, 28.239999999990687, 26.864999999990687, 28.460000000006403, 27.694999999992433, 28.195000000006985, 28.18499999999767, 28.839999999996508, 29.15999999997439, 28.394999999989523, 28.994999999995343, 27.54999999998836, 28.72500000000582, 29.375, 26.5, 27.145000000018626, 28.54000000000815, 28.05999999999767, 28.15999999997439, 28.699999999953434, 28.76999999996042], "unit": "ms", "name": "simple-open-DPI1.error.TART", "value": 28.217499999998836}, {"lowerIsBetter": true, "replicates": [1.4409149572253228, 1.4149211194457076, 1.4212864784546841, 1.406304542611285, 1.5393977038065592, 1.410261606297842, 1.4274541757724903, 1.4255104653629256, 1.482528568842472, 1.4201202539750089, 1.474622102884146, 1.426942174817309, 1.4091658068866264, 1.4247851386482333, 1.4043845447098338, 1.4124438500985868, 1.4232965487020988, 1.4759168808276837, 1.461108403869822, 1.4273356552477237, 1.4253398018118777, 1.4650213145002533, 1.4232301741470526, 1.4778270308788006, 1.4597668406329578], "unit": "ms", "name": "simple-close-DPI1.half.TART", "value": 1.4254251335874017}, {"lowerIsBetter": true, "replicates": [1.4939383748101025, 1.5587803887415537, 1.538186827301979, 1.520398646225164, 1.6268753480911256, 1.5083050337838537, 1.5283872155669314, 1.52718512686143, 1.6766602111189333, 1.5144320482052631, 1.671697144639002, 1.5265316111700875, 1.5184573155862313, 1.5142285801746227, 1.5108436971534918, 1.5246354652487712, 1.5199583028414234, 1.6831724210961225, 1.6588204101640351, 1.5241060487926006, 1.5155721206842743, 1.658434201736708, 1.525050469807216, 1.6638724812034036, 1.652915507555008], "unit": "ms", "name": "simple-close-DPI1.all.TART", "value": 1.5268583690157587}, {"lowerIsBetter": true, "replicates": [17.600000000000364, 18.889999999999418, 18.799999999995634, 19.169999999998254, 16.99000000000524, 17.22499999999127, 18.69999999999709, 18.97499999999127, 17.580000000001746, 16.779999999998836, 17.199999999982538, 18.52499999999418, 18.904999999998836, 18.144999999989523, 17.480000000010477, 18.664999999979045, 17.404999999998836, 18.52499999999418, 16.79999999998836, 16.69000000000233, 16.85999999998603, 18.46500000002561, 18.375, 17.53000000002794, 17.550000000046566], "unit": "ms", "name": "simple-close-DPI1.error.TART", "value": 17.862499999995634}, {"lowerIsBetter": true, "replicates": [1.895629304354308, 1.9791985467328863, 1.9529954821376476, 1.9593347169585147, 2.108192211931402, 1.9555467831886422, 1.9730024863097628, 1.950990854683569, 1.961000887014098, 1.938218319416046, 1.9701322559582986, 1.9613913883597165, 1.956405894230988, 1.9803895930112418, 2.0433961111202574, 1.9308647255102793, 1.9645089416180628, 1.9623351117311898, 1.9593542369745545, 1.9366183221340179, 1.9635912301176686, 1.9774152303146104, 1.9444327195485434, 1.9702168662669295, 1.96374745086088], "unit": "ms", "name": "icon-open-DPI1.half.TART", "value": 1.9618632500454531}, {"lowerIsBetter": true, "replicates": [2.3251654489620313, 2.4297120259186933, 2.382269543245298, 2.3799162085996857, 2.614043682512611, 2.4345025341465787, 2.401031587962751, 2.3903720533406294, 2.36427441758847, 2.3730535496265515, 2.3736700683558754, 2.398539161240613, 2.373944846861953, 2.4173379122653853, 2.4565970054212607, 2.3757521034380713, 2.386101833096257, 2.3747304765456314, 2.371898027735019, 2.3789544652361387, 2.379257423068405, 2.377622777168904, 2.388107180595398, 2.395321374690091, 2.3842422796620264], "unit": "ms", "name": "icon-open-DPI1.all.TART", "value": 2.383255911453662}, {"lowerIsBetter": true, "replicates": [28.575000000000728, 30.44499999999971, 31.279999999998836, 31.06999999999971, 29.1449999999968, 28.845000000001164, 31.120000000009895, 29.94999999999709, 29.25, 29.370000000009895, 30.489999999990687, 29.454999999987194, 30.57500000001164, 29.34000000002561, 32.30000000001746, 30.56500000000233, 29.470000000001164, 30.514999999984866, 29.070000000006985, 29.804999999993015, 31.05999999999767, 31.00499999994645, 29.55999999999767, 29.135000000009313, 28.274999999965075], "unit": "ms", "name": "icon-open-DPI1.error.TART", "value": 29.877499999995052}, {"lowerIsBetter": true, "replicates": [1.3604108698227826, 1.4108329211793296, 1.4251833609592768, 1.4303839442170696, 1.4072598625973958, 1.4198784754600053, 1.4232349204428403, 1.4441213563084603, 1.4287436582424022, 1.439978949725628, 1.4302417245911963, 1.4388317584991455, 1.4160777955520443, 1.4222962488362818, 1.4211915455213406, 1.4195478398625443, 1.433797279993693, 1.4219548644089117, 1.436746014489068, 1.4333990532674907, 1.4408909499645233, 1.4433581486344338, 1.4352621649518424, 1.4430749520659447, 1.4508125379681587], "unit": "ms", "name": "icon-close-DPI1.half.TART", "value": 1.430312834404133}, {"lowerIsBetter": true, "replicates": [1.4888701884143323, 1.5212033179976185, 1.5577207366122474, 1.544728585759049, 1.5326946810905977, 1.540073223412037, 1.5496022498832558, 1.5595556829549089, 1.5418473931978334, 1.563417538811889, 1.5580974530570115, 1.5734881322095349, 1.5499838298221804, 1.5508605016852326, 1.5304780378937721, 1.5421541029552244, 1.570655818957432, 1.5644966265823268, 1.5642001244086254, 1.5641417895691305, 1.5819869003234766, 1.5526801377912112, 1.5681048016639272, 1.5679140136500074, 1.5765419854567602], "unit": "ms", "name": "icon-close-DPI1.all.TART", "value": 1.5579090948346295}, {"lowerIsBetter": true, "replicates": [21.5049999999992, 18.5, 19.25, 18.845000000001164, 19.639999999999418, 19.520000000004075, 19.44000000000233, 19.43499999999767, 18.19999999999709, 19.90000000000873, 19.380000000004657, 20.04000000000815, 19.45000000001164, 19.485000000015134, 18.919999999983702, 18.05999999999767, 19.654999999998836, 20.20999999999185, 20.05999999999767, 20.15999999997439, 19.79000000000815, 18.28499999997439, 19.29999999998836, 19.15500000002794, 19.025000000023283], "unit": "ms", "name": "icon-close-DPI1.error.TART", "value": 19.4375}, {"lowerIsBetter": true, "replicates": [1.7972317077219486, 1.895364923555343, 1.8917641366114382, 1.8981913992615997, 1.871613610175348, 1.8859978406155695, 1.9019747405755716, 1.8954341782898199, 1.906318338190923, 1.8897371213944232, 1.8919844666465384, 1.8826566838449048, 1.9121161132562356, 1.9044612939240502, 1.9286567270755768, 1.9025413012895427, 1.892469187251857, 1.898487274764014, 1.9137843085117028, 1.8821550069316741, 1.9175719420115154, 1.896428780477555, 1.8855949698901566, 1.8796899818604993, 1.8983047243024482], "unit": "ms", "name": "icon-open-DPI2.half.TART", "value": 1.8959314793836874}, {"lowerIsBetter": true, "replicates": [2.194440044588962, 2.3207978759191734, 2.3213421713028635, 2.3050530339990343, 2.2713469957050525, 2.3203375956841876, 2.3194873183965683, 2.3189799656739107, 2.356758578257127, 2.301058769226074, 2.312637033207076, 2.3072199055126736, 2.334291492496525, 2.3214073000209674, 2.3261375599079304, 2.322235294290491, 2.301576483462538, 2.345901866392656, 2.334384907473315, 2.3630980610847474, 2.3366300941587568, 2.3259818833153525, 2.2884977412434804, 2.3047140710121763, 2.302790201136044], "unit": "ms", "name": "icon-open-DPI2.all.TART", "value": 2.3205677358016805}, {"lowerIsBetter": true, "replicates": [30.465000000000146, 33.88500000000204, 30.52499999999418, 28.80500000000029, 30.75, 31.610000000000582, 31.40000000000873, 27.910000000003492, 29.70999999999185, 28.22500000000582, 29.574999999982538, 29.085000000020955, 29.574999999982538, 30.445000000006985, 28.800000000017462, 28.23499999998603, 28.304999999993015, 28.464999999996508, 29.55999999999767, 30.535000000003492, 29.75, 28.82500000001164, 30.39499999996042, 32.14000000001397, 28.570000000006985], "unit": "ms", "name": "icon-open-DPI2.error.TART", "value": 29.574999999982538}, {"lowerIsBetter": true, "replicates": [1.245657245318095, 1.333034434537778, 1.3350691904966858, 1.3371922161387302, 1.3393768876097922, 1.2821530242760977, 1.3262945769847125, 1.3504816196685614, 1.3600855981602389, 1.3323061589536995, 1.3471238613128662, 1.3329726347978088, 1.339859119681425, 1.3372937317552238, 1.331639680369147, 1.3380820071974466, 1.3302449179791855, 1.3432749246442042, 1.3774108091990154, 1.3488652595253878, 1.3345042247881835, 1.341234373491864, 1.3248865796231675, 1.3421809811924779, 1.3282410660009274], "unit": "ms", "name": "icon-close-DPI2.half.TART", "value": 1.337242973946977}, {"lowerIsBetter": true, "replicates": [1.3414368780104668, 1.4189451614091562, 1.4395057362668655, 1.4367748169338002, 1.4269219581146686, 1.413095993458191, 1.4358639821671604, 1.4473895772674379, 1.4560987041110085, 1.4275911607240375, 1.4401427275994245, 1.4334185109500996, 1.4400231471428504, 1.4562632746639705, 1.4184316722459571, 1.4271555086325485, 1.428240142370525, 1.4273531130182813, 1.4626495252826257, 1.4571089964537394, 1.4323204100480553, 1.4395328381482293, 1.4328907972190812, 1.4341820248386317, 1.4265402165072703], "unit": "ms", "name": "icon-close-DPI2.all.TART", "value": 1.4338002678943655}, {"lowerIsBetter": true, "replicates": [17.825000000000728, 17.590000000000146, 18.279999999998836, 17.914999999993597, 17.67500000000291, 18.205000000001746, 19.104999999995925, 18.17500000000291, 18.29000000000815, 17.70999999999185, 18.554999999993015, 19.144999999989523, 17.114999999990687, 18.29999999998836, 17.505000000004657, 17.605000000010477, 17.955000000016298, 17.745000000024447, 17.880000000004657, 18.49000000001979, 18.480000000010477, 18.30999999999767, 18.64000000001397, 18.919999999983702, 17.539999999979045], "unit": "ms", "name": "icon-close-DPI2.error.TART", "value": 18.19000000000233}, {"lowerIsBetter": true, "replicates": [1.1825930974921401, 3.039146675304933, 1.2964082273204676, 1.263183074152988, 1.2937072850345226, 1.2891844828923544, 1.2858607583575778, 1.344208140705907, 1.299851278240761, 1.290532746579912, 1.2922436753908793, 1.2854383594459957, 1.2811546272701688, 1.2734647425976429, 1.2796058204438951, 1.2962960513790003, 1.2786761679492153, 1.2796740955776638, 1.3141990453004837, 1.2837871472040812, 1.2865476846694945, 1.28170075946384, 1.2504735316919244, 1.283177024126053, 1.2843759523497686], "unit": "ms", "name": "iconFade-close-DPI2.half.TART", "value": 1.285649558901787}, {"lowerIsBetter": true, "replicates": [1.205718664925333, 1.9388391256332398, 1.3113734219851119, 1.2933679434988234, 1.3112763414222204, 1.3057881727647245, 1.311035074756644, 1.3292132030214583, 1.3200157664038918, 1.3150703152694272, 1.3061959013510287, 1.3109182323632615, 1.3084696973307748, 1.3054839908406977, 1.3025370523250304, 1.314384758809192, 1.3101933812827207, 1.3035817952129427, 1.334095480101449, 1.3328886202403478, 1.312161030742408, 1.3051993144291074, 1.2893833666216603, 1.3092463247561723, 1.3251190321011976], "unit": "ms", "name": "iconFade-close-DPI2.all.TART", "value": 1.3109766535599527}, {"lowerIsBetter": true, "replicates": [2.779999999998836, 2.625, 3.4349999999976717, 2.7549999999973807, 3.3849999999947613, 2.5749999999970896, 2.154999999998836, 2.5749999999970896, 2.3650000000052387, 2.6999999999970896, 2.5350000000034925, 3.3249999999825377, 2.9200000000128057, 2.529999999998836, 3.1300000000046566, 2.6049999999813735, 3.3000000000174623, 3.3649999999906868, 3.4349999999976717, 3.3500000000058208, 2.279999999998836, 3.554999999993015, 3.400000000023283, 3.054999999993015, 3.3650000000488944], "unit": "ms", "name": "iconFade-close-DPI2.error.TART", "value": 2.9875000000029104}, {"lowerIsBetter": true, "replicates": [1.7604864835739136, 1.8741281820881752, 1.8894664283658638, 1.9067589923983714, 1.8878486039208584, 1.8985061625965307, 1.8928216949838106, 1.8908702330511125, 1.8873449993915246, 1.916484893345442, 1.899318235819457, 1.9053111349950071, 1.9023650435150647, 1.907734739975851, 1.8819382306068175, 1.9028497621661327, 1.8780115285227377, 1.8768657176725325, 1.896844261982402, 1.8864636812053743, 1.8940492438488319, 1.893608597458386, 1.8810773280359083, 1.9837480783462524, 1.9042976234779982], "unit": "ms", "name": "iconFade-open-DPI2.half.TART", "value": 1.893828920653609}, {"lowerIsBetter": true, "replicates": [1.7520107514876173, 1.837482999628923, 1.8344956636428833, 1.8482505802124265, 1.8556684851646423, 1.8492410608700343, 1.8644128370285034, 1.8375041672563928, 1.8356899999258087, 1.8541477246889992, 1.8374195155196302, 1.8582350645065309, 1.844517261262924, 1.8453919225268893, 1.8191046686843038, 1.8435999287499323, 1.830725217428733, 1.8367482611513513, 1.8434841140868172, 1.8405308113323422, 1.846787727068341, 1.8352364526958915, 1.8295127378674003, 1.8751779852374908, 1.8499633404943678], "unit": "ms", "name": "iconFade-open-DPI2.all.TART", "value": 1.8435420214183749}, {"lowerIsBetter": true, "replicates": [3.040000000000873, 3.7050000000017462, 3.0349999999962165, 2.9199999999982538, 3.9949999999953434, 3.0050000000046566, 2.9499999999970896, 3.430000000007567, 3.235000000000582, 3.6999999999970896, 3.3699999999953434, 2.305000000022119, 2.4600000000209548, 2.459999999991851, 2.834999999991851, 2.2850000000034925, 2.5799999999871943, 3.35999999998603, 2.419999999983702, 4.019999999989523, 2.8150000000023283, 3.150000000023283, 2.4349999999976717, 2.5899999999674037, 3.0200000000186265], "unit": "ms", "name": "iconFade-open-DPI2.error.TART", "value": 2.977500000000873}, {"lowerIsBetter": true, "replicates": [29.016443073749542, 2.133494268764149, 2.084328755736351, 2.11613750891252, 2.1676203343603344, 2.1134634863246573, 2.1020621776580812, 2.117247618328441, 2.093628163771196, 2.091206444161279, 2.0813184806278775, 2.0864064629588808, 2.1000165115703235, 2.139773251833739, 2.435228859384855, 2.1040729436007415, 2.0929648811166937, 2.079206477318491, 2.084315042410578, 2.11185068433935, 2.0766830635922298, 2.092790337042375, 2.072054481932095, 2.1015734564174307, 2.0998464546033313], "unit": "ms", "name": "newtab-open-preload-no.half.TART", "value": 2.099931483086827}, {"lowerIsBetter": true, "replicates": [17.075018294155598, 3.21170550952723, 3.142647286740745, 3.2778489619870728, 3.2404950514435766, 3.167026582287579, 3.1919224527147083, 3.1960231448397223, 3.1311412475195275, 3.1177613821374366, 3.1198433508355934, 3.1512310882894004, 3.1244605736560134, 3.236184647679329, 3.5303887095249875, 3.1613134087585824, 3.15026641037406, 3.1169702820031038, 3.110770755503551, 3.192230576350365, 3.112320635692183, 3.1386315607162842, 3.111996788576425, 3.1534414378608147, 3.2045233014189165], "unit": "ms", "name": "newtab-open-preload-no.all.TART", "value": 3.1523362630751075}, {"lowerIsBetter": true, "replicates": [48.275000000001455, 30.459999999999127, 28.290000000000873, 29.595000000001164, 29.919999999998254, 30.285000000003492, 29.09999999999127, 29.494999999995343, 30.294999999998254, 29.205000000001746, 29.35999999998603, 29.04000000000815, 30.019999999989523, 29.48499999998603, 31.505000000004657, 29.869999999995343, 28.785000000003492, 29.27499999999418, 28.764999999984866, 29.14000000001397, 28.975000000034925, 31.21999999997206, 29.025000000023283, 29.10999999998603, 30.099999999976717], "unit": "ms", "name": "newtab-open-preload-no.error.TART", "value": 29.42249999998603}, {"lowerIsBetter": true, "replicates": [2.2697232073428584, 2.155268340199082, 2.14328615532981, 2.1510728156125105, 2.129988381156215, 2.129863756353205, 2.125618808919733, 2.1207734129645606, 2.1280275518243963, 2.153206123246087, 2.1173104459589176, 2.116961368647489, 2.1212970560247246, 2.129703927923132, 2.1581199169158936, 2.1063978845422917, 2.151904821395874, 2.1335012559537536, 2.1369146086551525, 2.1013360652056607, 2.1740168580469095, 2.16237947234401, 2.1318728305675365, 2.131986607004095, 2.137199039812441], "unit": "ms", "name": "newtab-open-preload-yes.half.TART", "value": 2.1319297187858157}, {"lowerIsBetter": true, "replicates": [2.440516274708968, 2.38238004468522, 2.4238780589330764, 2.4296380304154894, 2.4031051487292885, 2.3984355814052076, 2.396127957218098, 2.3968923271826976, 2.3868431358967186, 2.4100388794575096, 2.408354358853034, 2.395736707831329, 2.4049708033507726, 2.3961569306985386, 2.4442713455511975, 2.3913551546702876, 2.4215557745524814, 2.4107344049327777, 2.446970413510616, 2.404775193277395, 2.432363653412232, 2.449008578291306, 2.413542967750913, 2.42829585870107, 2.4238304966971986], "unit": "ms", "name": "newtab-open-preload-yes.all.TART", "value": 2.4091966191552716}, {"lowerIsBetter": true, "replicates": [33.830000000001746, 32.66500000000087, 35.16500000000087, 35.450000000004366, 35.19000000000233, 34.88499999999476, 34.57499999999709, 34.81500000000233, 33.904999999998836, 36.10500000001048, 35.960000000020955, 34.76500000001397, 35.67499999998836, 34.88500000000931, 34.09999999997672, 36.76500000001397, 35.00500000000466, 36.25500000000466, 35.07500000001164, 35.73999999999069, 33.960000000020955, 35.40000000002328, 34.26000000000931, 35.70000000001164, 35.179999999993015], "unit": "ms", "name": "newtab-open-preload-yes.error.TART", "value": 35.12000000000626}], "name": "tart", "value": 4.262776866345683}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [2.1237569060773485, 2.0596408839779006, 2.072983425414365, 2.052762430939227, 2.0604143646408835, 2.0580386740331496, 2.0746132596685083, 2.050469613259669, 2.0498342541436463, 2.0595027624309394, 2.0582596685082875, 2.3737016574585637, 2.0499723756906074, 2.059309392265193, 2.0631491712707186, 2.0516298342541437, 2.0626795580110495, 2.0557458563535915, 2.051878453038674, 2.0624033149171273, 2.054585635359116, 2.0549723756906073, 2.055745856353591, 2.0634530386740333, 2.0599447513812152], "unit": "ms", "name": "tiled.html", "value": 2.0581491712707187}, {"lowerIsBetter": true, "replicates": [2.8077900552486192, 2.803591160220994, 2.819281767955801, 2.7966574585635358, 2.8057458563535915, 2.7993093922651933, 2.811270718232044, 2.8003314917127073, 2.809613259668508, 2.806712707182321, 2.8008287292817684, 2.807154696132597, 2.800635359116022, 3.202265193370166, 2.8138950276243095, 2.8199723756906074, 2.809475138121547, 2.8070994475138122, 2.7982596685082872, 2.8071823204419886, 2.804475138121547, 2.8109392265193374, 2.804806629834254, 2.8079005524861884, 2.794033149171271], "unit": "ms", "name": "tiled-fixed.html", "value": 2.8071270718232046}, {"lowerIsBetter": true, "replicates": [2.443839779005525, 2.423922651933702, 2.4448342541436463, 2.4330939226519335, 2.4343646408839783, 2.431436464088398, 2.436906077348066, 2.4278453038674033, 2.4313259668508285, 2.430414364640884, 2.4223204419889504, 2.4298066298342538, 2.4368784530386742, 2.4223756906077347, 2.436988950276243, 2.4289226519337017, 2.4332044198895026, 2.4660497237569063, 2.4264088397790053, 2.43146408839779, 2.431436464088398, 2.4373480662983424, 2.4522099447513814, 2.432596685082873, 2.429116022099447], "unit": "ms", "name": "tiled-downscale.html", "value": 2.431436464088398}, {"lowerIsBetter": true, "replicates": [3.35182320441989, 3.342983425414365, 3.328232044198895, 3.344005524861879, 3.3522099447513813, 3.3477071823204425, 3.350718232044199, 3.3541160220994484, 3.7496685082872925, 3.3519889502762426, 3.352707182320442, 3.352209944751382, 3.3471270718232042, 3.351878453038674, 3.362486187845304, 3.3408287292817684, 3.3411325966850836, 3.3447790055248623, 3.3256353591160224, 3.345497237569061, 3.3492817679558007, 3.340276243093923, 3.346160220994475, 3.3582596685082873, 3.350580110497237], "unit": "ms", "name": "tiled-fixed-downscale.html", "value": 3.349930939226519}, {"lowerIsBetter": true, "replicates": [2.833684210526316, 2.865328947368422, 2.872105263157895, 2.8692105263157894, 2.8571052631578944, 2.8692763157894743, 2.8430921052631586, 2.856315789473684, 2.798355263157895, 2.796907894736842, 2.7905921052631584, 2.7957236842105258, 2.781973684210527, 2.7878947368421043, 2.794671052631579, 2.7734868421052634, 2.7948026315789476, 2.800855263157895, 2.7909868421052635, 2.784736842105264, 2.8049999999999993, 2.7883552631578943, 2.785723684210526, 2.7887500000000007, 2.8055921052631576], "unit": "ms", "name": "iframe.svg", "value": 2.794736842105263}, {"lowerIsBetter": true, "replicates": [2.71453431372549, 2.7160539215686277, 2.7192647058823525, 2.7231372549019612, 2.7213235294117646, 2.714485294117647, 2.7174019607843145, 2.7262500000000003, 2.723995098039216, 2.7304656862745103, 2.7348039215686275, 2.7518382352941178, 2.7333578431372545, 2.7297549019607845, 2.7341666666666664, 2.7340931372549027, 2.728970588235294, 2.735514705882353, 2.7392156862745103, 2.732892156862745, 2.7293382352941182, 2.733406862745098, 2.732696078431373, 2.7323529411764707, 2.737622549019608], "unit": "ms", "name": "reader.htm", "value": 2.7327941176470594}], "name": "tscrollx", "value": 2.674557185807258}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [5.399340271949768, 5.021177625656128, 5.071596693992615, 5.0857279062271115, 5.122150242328644, 5.102854263782501, 5.124051058292389, 5.09486711025238, 5.151814198493957, 5.097977471351624, 5.053951954841613, 5.343615820533351, 5.106003081798553, 5.097939038276673, 5.270393264293671, 5.095270240306855, 5.154771029949188, 5.116371107101441, 5.103929388523102, 5.120825445652008, 5.079967892169952, 5.070790255069733, 5.122246193885803, 5.104908692836761, 5.1684798240661625], "unit": "ms", "name": "1-customize-enter.half.TART", "value": 5.1044190406799315}, {"lowerIsBetter": true, "replicates": [10.738491379484838, 9.315973207685683, 9.354594908820259, 9.526704874905674, 9.364587524202134, 9.385485559039646, 9.545870038596066, 9.793818118960358, 9.435456678602431, 9.6261084838347, 9.466530485586686, 9.96033626794815, 9.63269751180302, 9.666218941861933, 9.590981142087417, 9.68936356089332, 9.582908440719951, 9.612747018987482, 9.693522780440574, 9.842898673789445, 9.664360008456491, 9.597360713915391, 9.43908330069648, 9.792809092721274, 9.54885464364832], "unit": "ms", "name": "1-customize-enter.all.TART", "value": 9.594170928001404}, {"lowerIsBetter": true, "replicates": [381.4449999999997, 228.6900000000005, 230.27500000000146, 229.48500000000058, 230.98999999999796, 231.64500000000407, 229.43499999999767, 230.59500000000116, 234.19000000000233, 232.9649999999965, 226.10000000000582, 247.90000000000146, 234.39500000000407, 234.80999999999767, 231.5399999999936, 235.77000000000407, 231.01499999999942, 232.18499999999767, 226.02999999999884, 232.6600000000035, 234.64500000000407, 231.44499999999243, 234.2850000000035, 230.875, 229.52000000000407], "unit": "ms", "name": "1-customize-enter.error.TART", "value": 231.49249999999302}, {"lowerIsBetter": true, "replicates": [9.334609140049327, 8.999604562918345, 9.129748284816742, 9.221076409022013, 9.283013560555197, 9.18146022160848, 9.079316357771555, 9.358626539056951, 9.185044169425964, 9.20622812708219, 9.116532345612844, 9.016532480716705, 9.32661492174322, 9.200372139612833, 9.261684157631613, 9.24200408657392, 9.144020199775696, 9.324974276802756, 9.144116282463074, 9.192564129829407, 9.103700459003448, 9.20722003777822, 9.143988271554312, 9.034324487050375, 9.168267531828446], "unit": "ms", "name": "2-customize-exit.half.TART", "value": 9.183252195517223}, {"lowerIsBetter": true, "replicates": [10.407645324865976, 9.776273890545493, 9.631819235651117, 9.799445196201926, 10.008334778450632, 9.987287547137287, 9.565102864534428, 9.597870814494598, 9.643300838959522, 10.071321162017616, 9.907550618455216, 10.398226684994167, 9.677063183906752, 9.706133284066853, 9.69947312428401, 9.63493159184089, 9.514345896549713, 10.119632476084941, 9.640563744765062, 9.984869312595677, 9.553090541790693, 9.805447572156003, 9.909927194182938, 9.64583140764481, 9.95174135032453], "unit": "ms", "name": "2-customize-exit.all.TART", "value": 9.741203587306174}, {"lowerIsBetter": true, "replicates": [196.01499999999942, 197.03999999999724, 187.1150000000016, 192.61999999999898, 191.6850000000013, 190.75, 198.625, 196.1999999999971, 201.6449999999968, 197.09999999999854, 187.95500000000175, 195.50999999999476, 198.47000000000116, 194.125, 199.70500000000175, 200.56000000001222, 195.38999999999942, 195.84500000000116, 201.0899999999965, 193.75999999999476, 197.25, 197.0850000000064, 191.09500000000116, 200.9950000000099, 199.1750000000029], "unit": "ms", "name": "2-customize-exit.error.TART", "value": 196.61999999999716}, {"lowerIsBetter": true, "replicates": [8.214812902303843, 8.098431440500113, 8.205596887148344, 9.171252290407816, 8.163032018221342, 8.07373725450956, 8.145043079669659, 8.476501067479452, 8.063192037435678, 9.2318716916171, 8.01767349243164, 8.552213152249655, 8.102537448589619, 8.133670880244328, 7.9780624463008, 8.229522998516376, 8.102330501262959, 8.107647492335392, 8.274834962991568, 8.0885360791133, 8.146579118875357, 8.281864973214956, 9.006644447644552, 8.159457830282358, 8.337077220280966], "unit": "ms", "name": "3-customize-enter-css.half.TART", "value": 8.153018474578857}, {"lowerIsBetter": true, "replicates": [11.540289163589478, 11.698144352954367, 11.960182169209356, 12.536903272975575, 11.786547743755838, 11.820022272027057, 11.864199161529541, 12.407408064061945, 11.789986900661303, 13.35954389118013, 11.916239468947701, 12.480769525874745, 11.919144381647525, 11.955691005872643, 11.864900526793107, 11.990852355957031, 11.818770242773969, 11.822226399960725, 12.124333651169486, 11.774927595387334, 11.875001264655072, 12.014877194943635, 12.991818677811395, 11.900127970654031, 12.312874403866855], "unit": "ms", "name": "3-customize-enter-css.all.TART", "value": 11.917691925297614}, {"lowerIsBetter": true, "replicates": [76.86499999999978, 69.10499999999956, 75.04000000000087, 75.72000000000116, 70.93000000000029, 71.75, 72.81999999999971, 72.83000000000175, 71.11499999999796, 80.40000000000146, 73.54000000000087, 75.40499999999884, 74.00500000000466, 74.89500000000407, 72.93999999998778, 75.75999999999476, 71.84999999999127, 71.80000000000291, 78.77999999999884, 70.76999999998952, 73.0, 76.25500000000466, 72.6700000000128, 73.60499999999593, 70.78499999998894], "unit": "ms", "name": "3-customize-enter-css.error.TART", "value": 72.96999999999389}], "name": "cart", "value": 23.19602044119016}]} 19:12:13 INFO - TinderboxPrint: TalosResult: {"graphserver": {"tscrollx": {"url": "http://graphs.mozilla.org/graph.html#tests=[[287,63,31]]", "result": "2.67"}, "tsvgr_opacity": {"url": "http://graphs.mozilla.org/graph.html#tests=[[225,63,31]]", "result": "330.33"}, "tart": {"url": "http://graphs.mozilla.org/graph.html#tests=[[293,63,31]]", "result": "4.26"}, "cart": {"url": "http://graphs.mozilla.org/graph.html#tests=[[309,63,31]]", "result": "23.19"}, "tsvgx": {"url": "http://graphs.mozilla.org/graph.html#tests=[[281,63,31]]", "result": "124.90"}}} 19:12:13 INFO - Return code: 0 19:12:13 INFO - Validating PERFHERDER_DATA against C:\slave\test-pgo\build\tests\talos\treeherder-schemas\performance-artifact.json 19:12:13 ERROR - # TBPL SUCCESS # 19:12:13 INFO - Running post-action listener: _resource_record_post_action 19:12:13 INFO - Running post-run listener: _resource_record_post_run 19:12:14 INFO - Total resource usage - Wall time: 972s; CPU: 8.0%; Read bytes: 368847872; Write bytes: 594605056; Read time: 8938800; Write time: 12431670 19:12:14 INFO - install - Wall time: 4s; CPU: 7.0%; Read bytes: 38562816; Write bytes: 76942848; Read time: 650980; Write time: 484460 19:12:14 INFO - run-tests - Wall time: 968s; CPU: 8.0%; Read bytes: 323844608; Write bytes: 503936000; Read time: 8067340; Write time: 11906360 19:12:14 INFO - Running post-run listener: _upload_blobber_files 19:12:14 INFO - Blob upload gear active. 19:12:14 INFO - Preparing to upload files from C:\slave\test-pgo\build\blobber_upload_dir. 19:12:14 INFO - Files from C:\slave\test-pgo\build\blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:12:14 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\python', 'C:\\slave\\test-pgo\\build\\venv\\Scripts\\blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', 'C:\\slave\\test-pgo\\oauth.txt', '-b', 'Mozilla-Inbound', '-d', 'C:\\slave\\test-pgo\\build\\blobber_upload_dir', '--output-manifest', 'C:\\slave\\test-pgo\\build\\uploaded_files.json'] 19:12:14 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\python C:\slave\test-pgo\build\venv\Scripts\blobberc.py -u https://blobupload.elasticbeanstalk.com -a C:\slave\test-pgo\oauth.txt -b Mozilla-Inbound -d C:\slave\test-pgo\build\blobber_upload_dir --output-manifest C:\slave\test-pgo\build\uploaded_files.json 19:12:14 INFO - (blobuploader) - INFO - Open directory for files ... 19:12:14 INFO - (blobuploader) - INFO - Uploading C:\slave\test-pgo\build\blobber_upload_dir\svgr_errorsummary.log ... 19:12:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:12:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:12:15 INFO - (blobuploader) - INFO - TinderboxPrint: svgr_errorsummary.log: uploaded 19:12:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:12:15 INFO - (blobuploader) - INFO - Done attempting. 19:12:15 INFO - (blobuploader) - INFO - Uploading C:\slave\test-pgo\build\blobber_upload_dir\svgr_raw.log ... 19:12:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:12:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:12:17 INFO - (blobuploader) - INFO - TinderboxPrint: svgr_raw.log: uploaded 19:12:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:12:17 INFO - (blobuploader) - INFO - Done attempting. 19:12:17 INFO - (blobuploader) - INFO - Iteration through files over. 19:12:17 INFO - Return code: 0 19:12:17 INFO - rmtree: C:\slave\test-pgo\build\uploaded_files.json 19:12:17 INFO - Using _rmtree_windows ... 19:12:17 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test-pgo\\build\\uploaded_files.json',), kwargs: {}, attempt #1 19:12:17 INFO - Setting buildbot property blobber_files to {"svgr_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5378db96cfe9d5d441dcbfb7e3b74cfba38898810479e15942e7912ba3ca6c37bf2a3715d11c7a4b87a7d47138c6fe7519df886e09e194b7d0dc77f98978245e", "svgr_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3026954ffdd4e0be2a1d3173833262440f6c49d6d696312b61c81ab18e71ea5f43427513841c3dbaab2b5be7a95e8ca041a66cefa05c8741e073d479f759d3ca"} 19:12:17 INFO - Writing buildbot properties ['blobber_files'] to C:\slave\test-pgo\properties\blobber_files 19:12:17 INFO - Writing to file C:\slave\test-pgo\properties\blobber_files 19:12:17 INFO - Contents: 19:12:17 INFO - blobber_files:{"svgr_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5378db96cfe9d5d441dcbfb7e3b74cfba38898810479e15942e7912ba3ca6c37bf2a3715d11c7a4b87a7d47138c6fe7519df886e09e194b7d0dc77f98978245e", "svgr_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3026954ffdd4e0be2a1d3173833262440f6c49d6d696312b61c81ab18e71ea5f43427513841c3dbaab2b5be7a95e8ca041a66cefa05c8741e073d479f759d3ca"} 19:12:17 INFO - Copying logs to upload dir... 19:12:17 INFO - mkdir: C:\slave\test-pgo\build\upload\logs program finished with exit code 0 elapsedTime=1232.455000 ========= master_lag: -0.85 ========= ========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2015-12-23 19:12:17.431559) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-23 19:12:17.439912) ========= '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-037\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-037 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-037 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-037\AppData\Local LOGONSERVER=\\T-W864-IX-037 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-037 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-037 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-037 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False blobber_files:{"svgr_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5378db96cfe9d5d441dcbfb7e3b74cfba38898810479e15942e7912ba3ca6c37bf2a3715d11c7a4b87a7d47138c6fe7519df886e09e194b7d0dc77f98978245e", "svgr_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3026954ffdd4e0be2a1d3173833262440f6c49d6d696312b61c81ab18e71ea5f43427513841c3dbaab2b5be7a95e8ca041a66cefa05c8741e073d479f759d3ca"} build_url:https://queue.taskcluster.net/v1/task/B2R6eceDQ565VBbQLF2bfg/artifacts/public/build/firefox-46.0a1.en-US.win64.zip program finished with exit code 0 elapsedTime=0.101000 build_url: 'https://queue.taskcluster.net/v1/task/B2R6eceDQ565VBbQLF2bfg/artifacts/public/build/firefox-46.0a1.en-US.win64.zip' blobber_files: '{"svgr_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5378db96cfe9d5d441dcbfb7e3b74cfba38898810479e15942e7912ba3ca6c37bf2a3715d11c7a4b87a7d47138c6fe7519df886e09e194b7d0dc77f98978245e", "svgr_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3026954ffdd4e0be2a1d3173833262440f6c49d6d696312b61c81ab18e71ea5f43427513841c3dbaab2b5be7a95e8ca041a66cefa05c8741e073d479f759d3ca"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-23 19:12:17.562913) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 19:12:17.563279) ========= '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-037\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-037 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-037 KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld.T-W864-IX-037\AppData\Local LOGONSERVER=\\T-W864-IX-037 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-037 USERDOMAIN_ROAMINGPROFILE=T-W864-IX-037 USERNAME=cltbld USERPROFILE=C:\Users\cltbld.T-W864-IX-037 WINDIR=C:\windows XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=0.101000 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 19:12:17.679082) ========= ========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2015-12-23 19:12:17.679697) ========= ========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2015-12-23 19:12:18.014059) ========= ========= Total master_lag: -0.65 =========