builder: mozilla-aurora_win7-ix_test-dromaeojs-pgo slave: t-w732-ix-227 starttime: 1457119573.12 results: success (0) buildid: 20160304073420 builduid: 91289db578374c82912f00bc39fd5727 revision: 38bc572c312206a89c09b6c280840970ff12fc5f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-04 11:26:13.122778) ========= master: http://buildbot-master109.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-04 11:26:13.123322) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-04 11:26:13.123645) ========= 'cd' in dir C:\\slave\test-pgo\. (timeout 1200 secs) watching logfiles {} argv: ['cd'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files\Common Files COMPUTERNAME=T-W732-IX-227 COMSPEC=C:\windows\system32\cmd.exe CYGWINBASE=C:\cygwin DCLOCATION=SCL3 DNSSUFFIX=wintest.releng.scl3.mozilla.com FP_NO_HOST_CHECK=NO HOMEDRIVE=C: HOMEPATH=\Users\cltbld KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld\AppData\Local LOGONSERVER=\\T-W732-IX-227 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:\Python24;C:\Python24\Scripts;C:\cygwin\bin;C:\WINDOWS\System32;C:\program files\gnuwin32\bin;C:\WINDOWS;C:\mozilla-build\msys\bin;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\info-zip;C:\mozilla-build\wget;C:\Program Files (x86)\GnuWin32\bin; PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_IDENTIFIER=x86 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=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\AppData\Local\Temp TEST1=testie TMP=C:\Users\cltbld\AppData\Local\Temp USERDOMAIN=T-W732-IX-227 USERNAME=cltbld USERPROFILE=C:\Users\cltbld WINDIR=C:\windows WINDOWS_TRACING_FLAGS=3 WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log XPCOM_DEBUG_BREAK=warn using PTY: False C:\slave\test-pgo program finished with exit code 0 elapsedTime=0.633000 basedir: 'C:\\slave\\test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-04 11:26:13.806071) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-04 11:26:13.806632) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-04 11:26:13.934353) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 11:26:13.934961) ========= '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\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files\Common Files COMPUTERNAME=T-W732-IX-227 COMSPEC=C:\windows\system32\cmd.exe CYGWINBASE=C:\cygwin DCLOCATION=SCL3 DNSSUFFIX=wintest.releng.scl3.mozilla.com FP_NO_HOST_CHECK=NO HOMEDRIVE=C: HOMEPATH=\Users\cltbld KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld\AppData\Local LOGONSERVER=\\T-W732-IX-227 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:\Python24;C:\Python24\Scripts;C:\cygwin\bin;C:\WINDOWS\System32;C:\program files\gnuwin32\bin;C:\WINDOWS;C:\mozilla-build\msys\bin;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\info-zip;C:\mozilla-build\wget;C:\Program Files (x86)\GnuWin32\bin; PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_IDENTIFIER=x86 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=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\AppData\Local\Temp TEST1=testie TMP=C:\Users\cltbld\AppData\Local\Temp USERDOMAIN=T-W732-IX-227 USERNAME=cltbld USERPROFILE=C:\Users\cltbld WINDIR=C:\windows WINDOWS_TRACING_FLAGS=3 WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=0.802000 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 11:26:14.752712) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-04 11:26:14.753046) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-04 11:26:14.753438) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 11:26:14.753762) ========= '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\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files\Common Files COMPUTERNAME=T-W732-IX-227 COMSPEC=C:\windows\system32\cmd.exe CYGWINBASE=C:\cygwin DCLOCATION=SCL3 DNSSUFFIX=wintest.releng.scl3.mozilla.com FP_NO_HOST_CHECK=NO HOMEDRIVE=C: HOMEPATH=\Users\cltbld KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld\AppData\Local LOGONSERVER=\\T-W732-IX-227 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:\Python24;C:\Python24\Scripts;C:\cygwin\bin;C:\WINDOWS\System32;C:\program files\gnuwin32\bin;C:\WINDOWS;C:\mozilla-build\msys\bin;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\info-zip;C:\mozilla-build\wget;C:\Program Files (x86)\GnuWin32\bin; PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_IDENTIFIER=x86 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=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\AppData\Local\Temp TEST1=testie TMP=C:\Users\cltbld\AppData\Local\Temp USERDOMAIN=T-W732-IX-227 USERNAME=cltbld USERPROFILE=C:\Users\cltbld WINDIR=C:\windows WINDOWS_TRACING_FLAGS=3 WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log XPCOM_DEBUG_BREAK=warn using PTY: False --11:26:14-- 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.10 MB/s 11:26:15 (8.10 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.899000 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 11:26:15.669787) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 12 secs) (at 2016-03-04 11:26:15.670129) ========= '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\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files\Common Files COMPUTERNAME=T-W732-IX-227 COMSPEC=C:\windows\system32\cmd.exe CYGWINBASE=C:\cygwin DCLOCATION=SCL3 DNSSUFFIX=wintest.releng.scl3.mozilla.com FP_NO_HOST_CHECK=NO HOMEDRIVE=C: HOMEPATH=\Users\cltbld KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld\AppData\Local LOGONSERVER=\\T-W732-IX-227 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:\Python24;C:\Python24\Scripts;C:\cygwin\bin;C:\WINDOWS\System32;C:\program files\gnuwin32\bin;C:\WINDOWS;C:\mozilla-build\msys\bin;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\info-zip;C:\mozilla-build\wget;C:\Program Files (x86)\GnuWin32\bin; PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_IDENTIFIER=x86 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=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\AppData\Local\Temp TEST1=testie TMP=C:\Users\cltbld\AppData\Local\Temp USERDOMAIN=T-W732-IX-227 USERNAME=cltbld USERPROFILE=C:\Users\cltbld WINDIR=C:\windows WINDOWS_TRACING_FLAGS=3 WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=12.001000 ========= master_lag: 0.00 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 12 secs) (at 2016-03-04 11:26:27.673039) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-04 11:26:27.673407) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 38bc572c312206a89c09b6c280840970ff12fc5f --destination scripts --debug' in dir C:\\slave\test-pgo\. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 38bc572c312206a89c09b6c280840970ff12fc5f --destination scripts --debug'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files\Common Files COMPUTERNAME=T-W732-IX-227 COMSPEC=C:\windows\system32\cmd.exe CYGWINBASE=C:\cygwin DCLOCATION=SCL3 DNSSUFFIX=wintest.releng.scl3.mozilla.com FP_NO_HOST_CHECK=NO HOMEDRIVE=C: HOMEPATH=\Users\cltbld KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld\AppData\Local LOGONSERVER=\\T-W732-IX-227 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:\Python24;C:\Python24\Scripts;C:\cygwin\bin;C:\WINDOWS\System32;C:\program files\gnuwin32\bin;C:\WINDOWS;C:\mozilla-build\msys\bin;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\info-zip;C:\mozilla-build\wget;C:\Program Files (x86)\GnuWin32\bin; PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_IDENTIFIER=x86 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=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\AppData\Local\Temp TEST1=testie TMP=C:\Users\cltbld\AppData\Local\Temp USERDOMAIN=T-W732-IX-227 USERNAME=cltbld USERPROFILE=C:\Users\cltbld WINDIR=C:\windows WINDOWS_TRACING_FLAGS=3 WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log XPCOM_DEBUG_BREAK=warn using PTY: False 2016-03-04 11:26:27,601 truncating revision to first 12 chars 2016-03-04 11:26:27,601 Setting DEBUG logging. 2016-03-04 11:26:27,601 attempt 1/10 2016-03-04 11:26:27,601 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/38bc572c3122?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-04 11:26:28,789 unpacking tar archive at: mozilla-aurora-38bc572c3122/testing/mozharness/ program finished with exit code 0 elapsedTime=1.977000 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-04 11:26:29.758071) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-04 11:26:29.758446) ========= 'echo' u'38bc572c312206a89c09b6c280840970ff12fc5f' in dir C:\\slave\test-pgo\. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'38bc572c312206a89c09b6c280840970ff12fc5f'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files\Common Files COMPUTERNAME=T-W732-IX-227 COMSPEC=C:\windows\system32\cmd.exe CYGWINBASE=C:\cygwin DCLOCATION=SCL3 DNSSUFFIX=wintest.releng.scl3.mozilla.com FP_NO_HOST_CHECK=NO HOMEDRIVE=C: HOMEPATH=\Users\cltbld KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld\AppData\Local LOGONSERVER=\\T-W732-IX-227 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:\Python24;C:\Python24\Scripts;C:\cygwin\bin;C:\WINDOWS\System32;C:\program files\gnuwin32\bin;C:\WINDOWS;C:\mozilla-build\msys\bin;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\info-zip;C:\mozilla-build\wget;C:\Program Files (x86)\GnuWin32\bin; PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_IDENTIFIER=x86 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=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\AppData\Local\Temp TEST1=testie TMP=C:\Users\cltbld\AppData\Local\Temp USERDOMAIN=T-W732-IX-227 USERNAME=cltbld USERPROFILE=C:\Users\cltbld WINDIR=C:\windows WINDOWS_TRACING_FLAGS=3 WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log XPCOM_DEBUG_BREAK=warn using PTY: False 38bc572c312206a89c09b6c280840970ff12fc5f program finished with exit code 0 elapsedTime=0.101000 script_repo_revision: '38bc572c312206a89c09b6c280840970ff12fc5f' ========= master_lag: 0.02 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-04 11:26:29.877669) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-04 11:26:29.878018) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-04 11:26:29.894253) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 25 mins, 13 secs) (at 2016-03-04 11:26:29.894552) ========= 'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'dromaeojs' '--add-option' '--webServer,localhost' '--branch-name' 'Mozilla-Aurora' '--cfg' 'talos/windows_config.py' '--download-symbols' 'ondemand' '--use-talos-json' '--blob-upload-branch' 'Mozilla-Aurora' in dir C:\\slave\test-pgo\. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['c:/mozilla-build/python27/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/windows_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files\Common Files COMPUTERNAME=T-W732-IX-227 COMSPEC=C:\windows\system32\cmd.exe CYGWINBASE=C:\cygwin DCLOCATION=SCL3 DNSSUFFIX=wintest.releng.scl3.mozilla.com FP_NO_HOST_CHECK=NO HOMEDRIVE=C: HOMEPATH=\Users\cltbld KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld\AppData\Local LOGONSERVER=\\T-W732-IX-227 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:\Python24;C:\Python24\Scripts;C:\cygwin\bin;C:\WINDOWS\System32;C:\program files\gnuwin32\bin;C:\WINDOWS;C:\mozilla-build\msys\bin;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\info-zip;C:\mozilla-build\wget;C:\Program Files (x86)\GnuWin32\bin; PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_IDENTIFIER=x86 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=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\AppData\Local\Temp TEST1=testie TMP=C:\Users\cltbld\AppData\Local\Temp USERDOMAIN=T-W732-IX-227 USERNAME=cltbld USERPROFILE=C:\Users\cltbld WINDIR=C:\windows WINDOWS_TRACING_FLAGS=3 WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log XPCOM_DEBUG_BREAK=warn using PTY: False 11:26:29 INFO - MultiFileLogger online at 20160304 11:26:29 in C:\slave\test-pgo 11:26:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 11:26:29 INFO - Dumping config to C:\slave\test-pgo\logs\localconfig.json. 11:26:29 INFO - {'append_to_log': False, 11:26:29 INFO - 'base_work_dir': 'C:\\slave\\test-pgo', 11:26:29 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:26:29 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test-pgo\\oauth.txt', 11:26:29 INFO - 'branch': 'Mozilla-Aurora', 11:26:29 INFO - 'buildbot_json_path': 'buildprops.json', 11:26:29 INFO - 'config_files': ('talos/windows_config.py',), 11:26:29 INFO - 'default_actions': ('clobber', 11:26:29 INFO - 'read-buildbot-config', 11:26:29 INFO - 'download-and-extract', 11:26:29 INFO - 'populate-webroot', 11:26:29 INFO - 'create-virtualenv', 11:26:29 INFO - 'install', 11:26:29 INFO - 'run-tests'), 11:26:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:26:29 INFO - 'download_minidump_stackwalk': True, 11:26:29 INFO - 'download_symbols': 'ondemand', 11:26:29 INFO - 'exes': {'easy_install': ('C:\\slave\\test-pgo\\build/venv/scripts/python', 11:26:29 INFO - 'C:\\slave\\test-pgo\\build/venv/scripts/easy_install-2.7-script.py'), 11:26:29 INFO - 'hg': 'c:/mozilla-build/hg/hg', 11:26:29 INFO - 'mozinstall': ('C:\\slave\\test-pgo\\build/venv/scripts/python', 11:26:29 INFO - 'C:\\slave\\test-pgo\\build/venv/scripts/mozinstall-script.py'), 11:26:29 INFO - 'python': 'c:/mozilla-build/python27/python.exe', 11:26:29 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe', 11:26:29 INFO - 'C:/mozilla-build/tooltool.py'), 11:26:29 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe', 11:26:29 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 11:26:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:26:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:26:29 INFO - 'installer_path': 'installer.exe', 11:26:29 INFO - 'log_level': 'info', 11:26:29 INFO - 'log_name': 'talos', 11:26:29 INFO - 'log_to_console': True, 11:26:29 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe', 11:26:29 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe', 11:26:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest', 11:26:29 INFO - 'opt_config_files': (), 11:26:29 INFO - 'pip_index': False, 11:26:29 INFO - 'sps_profile': False, 11:26:29 INFO - 'sps_profile_interval': 0, 11:26:29 INFO - 'suite': 'dromaeojs', 11:26:29 INFO - 'system_bits': '32', 11:26:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:26:29 INFO - 'title': 'T-W732-IX-227', 11:26:29 INFO - 'use_talos_json': True, 11:26:29 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'), 11:26:29 INFO - 'virtualenv_path': 'C:\\slave\\test-pgo\\build/venv', 11:26:29 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll', 11:26:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:26:29 INFO - 'work_dir': 'build'} 11:26:29 INFO - ##### 11:26:29 INFO - ##### Running clobber step. 11:26:29 INFO - ##### 11:26:29 INFO - Running pre-action listener: _resource_record_pre_action 11:26:29 INFO - Running main action method: clobber 11:26:29 INFO - rmtree: C:\slave\test-pgo\build 11:26:29 INFO - Using _rmtree_windows ... 11:26:29 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test-pgo\\build',), kwargs: {}, attempt #1 11:29:12 INFO - Running post-action listener: _resource_record_post_action 11:29:12 INFO - ##### 11:29:12 INFO - ##### Running read-buildbot-config step. 11:29:12 INFO - ##### 11:29:12 INFO - Running pre-action listener: _resource_record_pre_action 11:29:12 INFO - Running main action method: read_buildbot_config 11:29:12 INFO - Using buildbot properties: 11:29:12 INFO - { 11:29:12 INFO - "project": "", 11:29:12 INFO - "product": "firefox", 11:29:12 INFO - "script_repo_revision": "production", 11:29:12 INFO - "builddir": "mozilla-aurora_win7-ix_test-dromaeojs", 11:29:12 INFO - "repository": "", 11:29:12 INFO - "buildername": "Windows 7 32-bit mozilla-aurora pgo talos dromaeojs", 11:29:12 INFO - "buildid": "20160304073420", 11:29:12 INFO - "pgo_build": "True", 11:29:12 INFO - "basedir": "C:\\slave\\test-pgo", 11:29:12 INFO - "buildnumber": 250, 11:29:12 INFO - "slavename": "t-w732-ix-227", 11:29:12 INFO - "master": "http://buildbot-master109.bb.releng.scl3.mozilla.com:8201/", 11:29:12 INFO - "platform": "win7-ix", 11:29:12 INFO - "scheduler": "tests-mozilla-aurora-win32-pgo-talos", 11:29:12 INFO - "branch": "mozilla-aurora", 11:29:12 INFO - "repo_path": "releases/mozilla-aurora", 11:29:12 INFO - "revision": "38bc572c312206a89c09b6c280840970ff12fc5f", 11:29:12 INFO - "stage_platform": "win32-pgo", 11:29:12 INFO - "builduid": "91289db578374c82912f00bc39fd5727", 11:29:12 INFO - "slavebuilddir": "test" 11:29:12 INFO - } 11:29:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/fG94VsYRRR6S08JOLOkocQ/artifacts/public/build/firefox-46.0a2.en-US.win32.zip. 11:29:12 INFO - Running post-action listener: _resource_record_post_action 11:29:12 INFO - ##### 11:29:12 INFO - ##### Running download-and-extract step. 11:29:12 INFO - ##### 11:29:12 INFO - Running pre-action listener: _resource_record_pre_action 11:29:12 INFO - Running main action method: download_and_extract 11:29:12 INFO - mkdir: C:\slave\test-pgo\build\tests 11:29:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:29:12 INFO - https://queue.taskcluster.net/v1/task/fG94VsYRRR6S08JOLOkocQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:29:12 INFO - trying https://queue.taskcluster.net/v1/task/fG94VsYRRR6S08JOLOkocQ/artifacts/public/build/test_packages.json 11:29:12 INFO - Downloading https://queue.taskcluster.net/v1/task/fG94VsYRRR6S08JOLOkocQ/artifacts/public/build/test_packages.json to C:\slave\test-pgo\build\test_packages.json 11:29:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fG94VsYRRR6S08JOLOkocQ/artifacts/public/build/test_packages.json', 'file_name': 'C:\\slave\\test-pgo\\build\\test_packages.json'}, attempt #1 11:29:13 INFO - Downloaded 1301 bytes. 11:29:13 INFO - Reading from file C:\slave\test-pgo\build\test_packages.json 11:29:13 INFO - Using the following test package requirements: 11:29:13 INFO - {u'common': [u'firefox-46.0a2.en-US.win32.common.tests.zip'], 11:29:13 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.win32.common.tests.zip', 11:29:13 INFO - u'firefox-46.0a2.en-US.win32.cppunittest.tests.zip'], 11:29:13 INFO - u'gtest': [u'firefox-46.0a2.en-US.win32.common.tests.zip'], 11:29:13 INFO - u'jittest': [u'firefox-46.0a2.en-US.win32.common.tests.zip', 11:29:13 INFO - u'jsshell-win32.zip'], 11:29:13 INFO - u'mochitest': [u'firefox-46.0a2.en-US.win32.common.tests.zip', 11:29:13 INFO - u'firefox-46.0a2.en-US.win32.mochitest.tests.zip'], 11:29:13 INFO - u'mozbase': [u'firefox-46.0a2.en-US.win32.common.tests.zip'], 11:29:13 INFO - u'reftest': [u'firefox-46.0a2.en-US.win32.common.tests.zip', 11:29:13 INFO - u'firefox-46.0a2.en-US.win32.reftest.tests.zip'], 11:29:13 INFO - u'talos': [u'firefox-46.0a2.en-US.win32.common.tests.zip', 11:29:13 INFO - u'firefox-46.0a2.en-US.win32.talos.tests.zip'], 11:29:13 INFO - u'web-platform': [u'firefox-46.0a2.en-US.win32.common.tests.zip', 11:29:13 INFO - u'firefox-46.0a2.en-US.win32.web-platform.tests.zip'], 11:29:13 INFO - u'webapprt': [u'firefox-46.0a2.en-US.win32.common.tests.zip'], 11:29:13 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.win32.common.tests.zip', 11:29:13 INFO - u'firefox-46.0a2.en-US.win32.xpcshell.tests.zip']} 11:29:13 INFO - Downloading packages: [u'firefox-46.0a2.en-US.win32.common.tests.zip'] for test suite category: common 11:29: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')]} 11:29:13 INFO - https://queue.taskcluster.net/v1/task/fG94VsYRRR6S08JOLOkocQ/artifacts/public/build/firefox-46.0a2.en-US.win32.common.tests.zip matches https://queue.taskcluster.net 11:29:13 INFO - trying https://queue.taskcluster.net/v1/task/fG94VsYRRR6S08JOLOkocQ/artifacts/public/build/firefox-46.0a2.en-US.win32.common.tests.zip 11:29:13 INFO - Downloading https://queue.taskcluster.net/v1/task/fG94VsYRRR6S08JOLOkocQ/artifacts/public/build/firefox-46.0a2.en-US.win32.common.tests.zip to C:\slave\test-pgo\build\firefox-46.0a2.en-US.win32.common.tests.zip 11:29:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fG94VsYRRR6S08JOLOkocQ/artifacts/public/build/firefox-46.0a2.en-US.win32.common.tests.zip', 'file_name': u'C:\\slave\\test-pgo\\build\\firefox-46.0a2.en-US.win32.common.tests.zip'}, attempt #1 11:29:15 INFO - Downloaded 17895513 bytes. 11:29:15 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-46.0a2.en-US.win32.common.tests.zip', '-d', 'C:\\slave\\test-pgo\\build\\tests'] 11:29:15 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-46.0a2.en-US.win32.common.tests.zip -d C:\slave\test-pgo\build\tests 11:29:45 INFO - Return code: 0 11:29:45 INFO - Downloading packages: [u'firefox-46.0a2.en-US.win32.common.tests.zip', u'firefox-46.0a2.en-US.win32.talos.tests.zip'] for test suite category: talos 11:29: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')]} 11:29:45 INFO - https://queue.taskcluster.net/v1/task/fG94VsYRRR6S08JOLOkocQ/artifacts/public/build/firefox-46.0a2.en-US.win32.common.tests.zip matches https://queue.taskcluster.net 11:29:45 INFO - trying https://queue.taskcluster.net/v1/task/fG94VsYRRR6S08JOLOkocQ/artifacts/public/build/firefox-46.0a2.en-US.win32.common.tests.zip 11:29:45 INFO - Downloading https://queue.taskcluster.net/v1/task/fG94VsYRRR6S08JOLOkocQ/artifacts/public/build/firefox-46.0a2.en-US.win32.common.tests.zip to C:\slave\test-pgo\build\firefox-46.0a2.en-US.win32.common.tests.zip 11:29:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fG94VsYRRR6S08JOLOkocQ/artifacts/public/build/firefox-46.0a2.en-US.win32.common.tests.zip', 'file_name': u'C:\\slave\\test-pgo\\build\\firefox-46.0a2.en-US.win32.common.tests.zip'}, attempt #1 11:29:47 INFO - Downloaded 17895513 bytes. 11:29:47 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-46.0a2.en-US.win32.common.tests.zip', '-d', 'C:\\slave\\test-pgo\\build\\tests'] 11:29:47 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-46.0a2.en-US.win32.common.tests.zip -d C:\slave\test-pgo\build\tests 11:30:09 INFO - Return code: 0 11:30:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:09 INFO - https://queue.taskcluster.net/v1/task/fG94VsYRRR6S08JOLOkocQ/artifacts/public/build/firefox-46.0a2.en-US.win32.talos.tests.zip matches https://queue.taskcluster.net 11:30:09 INFO - trying https://queue.taskcluster.net/v1/task/fG94VsYRRR6S08JOLOkocQ/artifacts/public/build/firefox-46.0a2.en-US.win32.talos.tests.zip 11:30:09 INFO - Downloading https://queue.taskcluster.net/v1/task/fG94VsYRRR6S08JOLOkocQ/artifacts/public/build/firefox-46.0a2.en-US.win32.talos.tests.zip to C:\slave\test-pgo\build\firefox-46.0a2.en-US.win32.talos.tests.zip 11:30:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fG94VsYRRR6S08JOLOkocQ/artifacts/public/build/firefox-46.0a2.en-US.win32.talos.tests.zip', 'file_name': u'C:\\slave\\test-pgo\\build\\firefox-46.0a2.en-US.win32.talos.tests.zip'}, attempt #1 11:30:12 INFO - Downloaded 10801536 bytes. 11:30:12 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-46.0a2.en-US.win32.talos.tests.zip', '-d', 'C:\\slave\\test-pgo\\build\\tests'] 11:30:12 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-46.0a2.en-US.win32.talos.tests.zip -d C:\slave\test-pgo\build\tests 11:30:15 INFO - Return code: 0 11:30:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:15 INFO - https://queue.taskcluster.net/v1/task/fG94VsYRRR6S08JOLOkocQ/artifacts/public/build/firefox-46.0a2.en-US.win32.zip matches https://queue.taskcluster.net 11:30:15 INFO - trying https://queue.taskcluster.net/v1/task/fG94VsYRRR6S08JOLOkocQ/artifacts/public/build/firefox-46.0a2.en-US.win32.zip 11:30:15 INFO - Downloading https://queue.taskcluster.net/v1/task/fG94VsYRRR6S08JOLOkocQ/artifacts/public/build/firefox-46.0a2.en-US.win32.zip to C:\slave\test-pgo\build\firefox-46.0a2.en-US.win32.zip 11:30:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fG94VsYRRR6S08JOLOkocQ/artifacts/public/build/firefox-46.0a2.en-US.win32.zip', 'file_name': 'C:\\slave\\test-pgo\\build\\firefox-46.0a2.en-US.win32.zip'}, attempt #1 11:30:19 INFO - Downloaded 55314858 bytes. 11:30:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fG94VsYRRR6S08JOLOkocQ/artifacts/public/build/firefox-46.0a2.en-US.win32.zip 11:30:19 INFO - mkdir: C:\slave\test-pgo\properties 11:30:19 INFO - Writing buildbot properties ['build_url'] to C:\slave\test-pgo\properties\build_url 11:30:19 INFO - Writing to file C:\slave\test-pgo\properties\build_url 11:30:19 INFO - Contents: 11:30:19 INFO - build_url:https://queue.taskcluster.net/v1/task/fG94VsYRRR6S08JOLOkocQ/artifacts/public/build/firefox-46.0a2.en-US.win32.zip 11:30:19 INFO - Running post-action listener: _resource_record_post_action 11:30:19 INFO - Running post-action listener: set_extra_try_arguments 11:30:19 INFO - ##### 11:30:19 INFO - ##### Running populate-webroot step. 11:30:19 INFO - ##### 11:30:19 INFO - Running pre-action listener: _resource_record_pre_action 11:30:19 INFO - Running main action method: populate_webroot 11:30:19 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']}, 11:30:19 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']}, 11:30:19 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome', 11:30:19 INFO - u'--tppagecycles', 11:30:19 INFO - u'7'], 11:30:19 INFO - u'tests': [u'tsvgm']}}, 11:30:19 INFO - u'suites': {u'chromez': {u'tests': [u'tresize', u'tcanvasmark']}, 11:30:19 INFO - u'chromez-e10s': {u'talos_options': [u'--e10s'], 11:30:19 INFO - u'tests': [u'tresize', u'tcanvasmark']}, 11:30:19 INFO - u'dromaeojs': {u'tests': [u'dromaeo_css', u'kraken', u'v8_7']}, 11:30:19 INFO - u'dromaeojs-e10s': {u'talos_options': [u'--e10s'], 11:30:19 INFO - u'tests': [u'dromaeo_css', 11:30:19 INFO - u'kraken', 11:30:19 INFO - u'v8_7']}, 11:30:19 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:19 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 11:30:19 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:19 INFO - u'talos_options': [u'--e10s'], 11:30:19 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 11:30:19 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:19 INFO - u'tests': [u'damp', u'tps']}, 11:30:19 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:19 INFO - u'talos_options': [u'--e10s'], 11:30:19 INFO - u'tests': [u'damp', u'tps']}, 11:30:19 INFO - u'g3': {u'tests': [u'dromaeo_dom']}, 11:30:19 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']}, 11:30:19 INFO - u'other': {u'tests': [u'a11yr', 11:30:19 INFO - u'ts_paint', 11:30:19 INFO - u'tpaint', 11:30:19 INFO - u'sessionrestore', 11:30:19 INFO - u'sessionrestore_no_auto_restore']}, 11:30:19 INFO - u'other-e10s': {u'talos_options': [u'--e10s'], 11:30:19 INFO - u'tests': [u'a11yr', 11:30:19 INFO - u'ts_paint', 11:30:19 INFO - u'tpaint', 11:30:19 INFO - u'sessionrestore', 11:30:19 INFO - u'sessionrestore_no_auto_restore']}, 11:30:19 INFO - u'other-e10s_l64': {u'talos_options': [u'--e10s'], 11:30:19 INFO - u'tests': [u'a11yr', 11:30:19 INFO - u'ts_paint', 11:30:19 INFO - u'tpaint', 11:30:19 INFO - u'sessionrestore', 11:30:19 INFO - u'sessionrestore_no_auto_restore']}, 11:30:19 INFO - u'other-e10s_nol64': {u'talos_options': [u'--e10s'], 11:30:19 INFO - u'tests': [u'a11yr', 11:30:19 INFO - u'ts_paint', 11:30:19 INFO - u'tpaint', 11:30:19 INFO - u'sessionrestore', 11:30:19 INFO - u'sessionrestore_no_auto_restore']}, 11:30:19 INFO - u'other_l64': {u'tests': [u'a11yr', 11:30:19 INFO - u'ts_paint', 11:30:19 INFO - u'tpaint', 11:30:19 INFO - u'sessionrestore', 11:30:19 INFO - u'sessionrestore_no_auto_restore']}, 11:30:19 INFO - u'other_nol64': {u'tests': [u'a11yr', 11:30:19 INFO - u'ts_paint', 11:30:19 INFO - u'tpaint', 11:30:19 INFO - u'sessionrestore', 11:30:19 INFO - u'sessionrestore_no_auto_restore']}, 11:30:19 INFO - u'svgr': {u'tests': [u'tsvgx', 11:30:19 INFO - u'tsvgr_opacity', 11:30:19 INFO - u'tart', 11:30:19 INFO - u'tscrollx', 11:30:19 INFO - u'cart']}, 11:30:19 INFO - u'svgr-e10s': {u'talos_options': [u'--e10s'], 11:30:19 INFO - u'tests': [u'tsvgx', 11:30:19 INFO - u'tsvgr_opacity', 11:30:19 INFO - u'tart', 11:30:19 INFO - u'tscrollx', 11:30:19 INFO - u'cart']}, 11:30:19 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:19 INFO - u'tests': [u'tp5o']}, 11:30:19 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:19 INFO - u'talos_options': [u'--e10s'], 11:30:19 INFO - u'tests': [u'tp5o']}, 11:30:19 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:19 INFO - u'talos_options': [u'--xperf_path', 11:30:19 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:30:19 INFO - u'tests': [u'tp5n']}, 11:30:19 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:19 INFO - u'talos_options': [u'--e10s', 11:30:19 INFO - u'--xperf_path', 11:30:19 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:30:19 INFO - u'tests': [u'tp5n']}}, 11:30:19 INFO - u'talos.zip': {u'path': u'', 11:30:19 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:30:19 INFO - Running post-action listener: _resource_record_post_action 11:30:19 INFO - ##### 11:30:19 INFO - ##### Running create-virtualenv step. 11:30:19 INFO - ##### 11:30:19 INFO - Running pre-action listener: _resource_record_pre_action 11:30:19 INFO - Running main action method: create_virtualenv 11:30:19 INFO - Creating virtualenv C:\slave\test-pgo\build/venv 11:30:19 INFO - mkdir: C:\slave\test-pgo\build\venv\Scripts 11:30:19 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test-pgo\build\venv\Scripts\python27.dll 11:30:19 WARNING - Can't copy c:/mozilla-build/python27/python27.dll to C:\slave\test-pgo\build\venv\Scripts\python27.dll: [Errno 2] No such file or directory: 'c:/mozilla-build/python27/python27.dll'! 11:30:19 INFO - Running command: ['c:/mozilla-build/python27/python.exe', 'c:/mozilla-build/buildbotve/virtualenv.py', '--no-site-packages', '--distribute', 'C:\\slave\\test-pgo\\build/venv'] in C:\slave\test-pgo\build 11:30:19 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test-pgo\build/venv 11:30:25 INFO - New python executable in C:\slave\test-pgo\build/venv\Scripts\python.exe 11:30:28 INFO - Installing distribute......................................................................................................................................................................................done. 11:30:30 INFO - Return code: 0 11:30:30 INFO - Installing pip>=1.5 into virtualenv C:\slave\test-pgo\build/venv 11:30:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:30 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--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 0x019756B0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x019B3EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x013DC288>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012F8BF0>, '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 0x0131A9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01A385C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-227', 'USERDOMAIN': 'T-W732-IX-227', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'OURDRIVE': 'C:', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W732-IX-227', 'MOZ_NO_REMOTE': '1', 'WINDOWS_TRACING_FLAGS': '3', 'CYGWINBASE': 'C:\\cygwin', 'PROGRAMDATA': 'C:\\ProgramData', 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'PWD': 'C:\\slave\\test-pgo', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 11:30:30 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in C:\slave\test-pgo\build 11:30:30 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:30:30 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 11:30:30 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 11:30:30 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 11:30:30 INFO - 'COMPUTERNAME': 'T-W732-IX-227', 11:30:30 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 11:30:30 INFO - 'CYGWINBASE': 'C:\\cygwin', 11:30:30 INFO - 'DCLOCATION': 'SCL3', 11:30:30 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 11:30:30 INFO - 'FP_NO_HOST_CHECK': 'NO', 11:30:30 INFO - 'HOMEDRIVE': 'C:', 11:30:30 INFO - 'HOMEPATH': '\\Users\\cltbld', 11:30:30 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 11:30:30 INFO - 'KTS_VERSION': '1.19c', 11:30:30 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 11:30:30 INFO - 'LOGONSERVER': '\\\\T-W732-IX-227', 11:30:30 INFO - 'MONDIR': 'C:\\Monitor_config\\', 11:30:30 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 11:30:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:30 INFO - 'MOZ_NO_REMOTE': '1', 11:30:30 INFO - 'NO_EM_RESTART': '1', 11:30:30 INFO - 'NUMBER_OF_PROCESSORS': '8', 11:30:30 INFO - 'OS': 'Windows_NT', 11:30:30 INFO - 'OURDRIVE': 'C:', 11:30:30 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 11:30:30 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 11:30:30 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 11:30:30 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 11:30:30 INFO - 'PROCESSOR_LEVEL': '6', 11:30:30 INFO - 'PROCESSOR_REVISION': '1e05', 11:30:30 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 11:30:30 INFO - 'PROGRAMFILES': 'C:\\Program Files', 11:30:30 INFO - 'PROMPT': '$P$G', 11:30:30 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 11:30:30 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 11:30:30 INFO - 'PUBLIC': 'C:\\Users\\Public', 11:30:30 INFO - 'PWD': 'C:\\slave\\test-pgo', 11:30:30 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 11:30:30 INFO - 'SLAVEDIR': 'C:\\slave\\', 11:30:30 INFO - 'SYSTEMDRIVE': 'C:', 11:30:30 INFO - 'SYSTEMROOT': 'C:\\windows', 11:30:30 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 11:30:30 INFO - 'TEST1': 'testie', 11:30:30 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 11:30:30 INFO - 'USERDOMAIN': 'T-W732-IX-227', 11:30:30 INFO - 'USERNAME': 'cltbld', 11:30:30 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 11:30:30 INFO - 'WINDIR': 'C:\\windows', 11:30:30 INFO - 'WINDOWS_TRACING_FLAGS': '3', 11:30:30 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 11:30:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 11:30:31 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:30:31 INFO - Downloading/unpacking pip>=1.5 11:30:35 INFO - Running setup.py egg_info for package pip 11:30:35 INFO - warning: no files found matching 'pip\cacert.pem' 11:30:35 INFO - warning: no files found matching '*.html' under directory 'docs' 11:30:35 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 11:30:35 INFO - no previously-included directories found matching 'docs\_build\_sources' 11:30:35 INFO - Installing collected packages: pip 11:30:35 INFO - Found existing installation: pip 0.8.2 11:30:35 INFO - Uninstalling pip: 11:30:35 INFO - Successfully uninstalled pip 11:30:35 INFO - Running setup.py install for pip 11:30:35 INFO - warning: no files found matching 'pip\cacert.pem' 11:30:35 INFO - warning: no files found matching '*.html' under directory 'docs' 11:30:35 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 11:30:35 INFO - no previously-included directories found matching 'docs\_build\_sources' 11:30:35 INFO - Installing pip-script.py script to C:\slave\test-pgo\build\venv\Scripts 11:30:35 INFO - Installing pip.exe script to C:\slave\test-pgo\build\venv\Scripts 11:30:35 INFO - Installing pip2.7-script.py script to C:\slave\test-pgo\build\venv\Scripts 11:30:35 INFO - Installing pip2.7.exe script to C:\slave\test-pgo\build\venv\Scripts 11:30:35 INFO - Installing pip2-script.py script to C:\slave\test-pgo\build\venv\Scripts 11:30:35 INFO - Installing pip2.exe script to C:\slave\test-pgo\build\venv\Scripts 11:30:35 INFO - Successfully installed pip 11:30:35 INFO - Cleaning up... 11:30:35 INFO - Return code: 0 11:30:35 INFO - Installing psutil>=0.7.1 into virtualenv C:\slave\test-pgo\build/venv 11:30:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:35 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--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 0x019756B0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x019B3EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x013DC288>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012F8BF0>, '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 0x0131A9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01A385C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-227', 'USERDOMAIN': 'T-W732-IX-227', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'OURDRIVE': 'C:', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W732-IX-227', 'MOZ_NO_REMOTE': '1', 'WINDOWS_TRACING_FLAGS': '3', 'CYGWINBASE': 'C:\\cygwin', 'PROGRAMDATA': 'C:\\ProgramData', 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'PWD': 'C:\\slave\\test-pgo', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 11:30:35 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in C:\slave\test-pgo\build 11:30:35 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 11:30:35 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 11:30:35 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 11:30:35 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 11:30:35 INFO - 'COMPUTERNAME': 'T-W732-IX-227', 11:30:35 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 11:30:35 INFO - 'CYGWINBASE': 'C:\\cygwin', 11:30:35 INFO - 'DCLOCATION': 'SCL3', 11:30:35 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 11:30:35 INFO - 'FP_NO_HOST_CHECK': 'NO', 11:30:35 INFO - 'HOMEDRIVE': 'C:', 11:30:35 INFO - 'HOMEPATH': '\\Users\\cltbld', 11:30:35 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 11:30:35 INFO - 'KTS_VERSION': '1.19c', 11:30:35 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 11:30:35 INFO - 'LOGONSERVER': '\\\\T-W732-IX-227', 11:30:35 INFO - 'MONDIR': 'C:\\Monitor_config\\', 11:30:35 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 11:30:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:35 INFO - 'MOZ_NO_REMOTE': '1', 11:30:35 INFO - 'NO_EM_RESTART': '1', 11:30:35 INFO - 'NUMBER_OF_PROCESSORS': '8', 11:30:35 INFO - 'OS': 'Windows_NT', 11:30:35 INFO - 'OURDRIVE': 'C:', 11:30:35 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 11:30:35 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 11:30:35 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 11:30:35 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 11:30:35 INFO - 'PROCESSOR_LEVEL': '6', 11:30:35 INFO - 'PROCESSOR_REVISION': '1e05', 11:30:35 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 11:30:35 INFO - 'PROGRAMFILES': 'C:\\Program Files', 11:30:35 INFO - 'PROMPT': '$P$G', 11:30:35 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 11:30:35 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 11:30:35 INFO - 'PUBLIC': 'C:\\Users\\Public', 11:30:35 INFO - 'PWD': 'C:\\slave\\test-pgo', 11:30:35 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 11:30:35 INFO - 'SLAVEDIR': 'C:\\slave\\', 11:30:35 INFO - 'SYSTEMDRIVE': 'C:', 11:30:35 INFO - 'SYSTEMROOT': 'C:\\windows', 11:30:35 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 11:30:35 INFO - 'TEST1': 'testie', 11:30:35 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 11:30:35 INFO - 'USERDOMAIN': 'T-W732-IX-227', 11:30:35 INFO - 'USERNAME': 'cltbld', 11:30:35 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 11:30:35 INFO - 'WINDIR': 'C:\\windows', 11:30:35 INFO - 'WINDOWS_TRACING_FLAGS': '3', 11:30:35 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 11:30:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 11:30:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:37 INFO - Downloading/unpacking psutil>=0.7.1 11:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:38 INFO - Installing collected packages: psutil 11:30:38 INFO - Successfully installed psutil 11:30:38 INFO - Cleaning up... 11:30:38 INFO - Return code: 0 11:30:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv C:\slave\test-pgo\build/venv 11:30:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:38 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--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 0x019756B0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x019B3EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x013DC288>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012F8BF0>, '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 0x0131A9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01A385C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-227', 'USERDOMAIN': 'T-W732-IX-227', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'OURDRIVE': 'C:', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W732-IX-227', 'MOZ_NO_REMOTE': '1', 'WINDOWS_TRACING_FLAGS': '3', 'CYGWINBASE': 'C:\\cygwin', 'PROGRAMDATA': 'C:\\ProgramData', 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'PWD': 'C:\\slave\\test-pgo', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 11:30:38 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in C:\slave\test-pgo\build 11:30:38 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 11:30:38 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 11:30:38 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 11:30:38 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 11:30:38 INFO - 'COMPUTERNAME': 'T-W732-IX-227', 11:30:38 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 11:30:38 INFO - 'CYGWINBASE': 'C:\\cygwin', 11:30:38 INFO - 'DCLOCATION': 'SCL3', 11:30:38 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 11:30:38 INFO - 'FP_NO_HOST_CHECK': 'NO', 11:30:38 INFO - 'HOMEDRIVE': 'C:', 11:30:38 INFO - 'HOMEPATH': '\\Users\\cltbld', 11:30:38 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 11:30:38 INFO - 'KTS_VERSION': '1.19c', 11:30:38 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 11:30:38 INFO - 'LOGONSERVER': '\\\\T-W732-IX-227', 11:30:38 INFO - 'MONDIR': 'C:\\Monitor_config\\', 11:30:38 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 11:30:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:38 INFO - 'MOZ_NO_REMOTE': '1', 11:30:38 INFO - 'NO_EM_RESTART': '1', 11:30:38 INFO - 'NUMBER_OF_PROCESSORS': '8', 11:30:38 INFO - 'OS': 'Windows_NT', 11:30:38 INFO - 'OURDRIVE': 'C:', 11:30:38 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 11:30:38 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 11:30:38 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 11:30:38 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 11:30:38 INFO - 'PROCESSOR_LEVEL': '6', 11:30:38 INFO - 'PROCESSOR_REVISION': '1e05', 11:30:38 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 11:30:38 INFO - 'PROGRAMFILES': 'C:\\Program Files', 11:30:38 INFO - 'PROMPT': '$P$G', 11:30:38 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 11:30:38 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 11:30:38 INFO - 'PUBLIC': 'C:\\Users\\Public', 11:30:38 INFO - 'PWD': 'C:\\slave\\test-pgo', 11:30:38 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 11:30:38 INFO - 'SLAVEDIR': 'C:\\slave\\', 11:30:38 INFO - 'SYSTEMDRIVE': 'C:', 11:30:38 INFO - 'SYSTEMROOT': 'C:\\windows', 11:30:38 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 11:30:38 INFO - 'TEST1': 'testie', 11:30:38 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 11:30:38 INFO - 'USERDOMAIN': 'T-W732-IX-227', 11:30:38 INFO - 'USERNAME': 'cltbld', 11:30:38 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 11:30:38 INFO - 'WINDIR': 'C:\\windows', 11:30:38 INFO - 'WINDOWS_TRACING_FLAGS': '3', 11:30:38 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 11:30:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 11:30:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:39 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:30:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:30:40 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor 11:30:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in c:\slave\test-pgo\build\venv\lib\site-packages (from mozsystemmonitor==0.0.0) 11:30:40 INFO - Installing collected packages: mozsystemmonitor 11:30:40 INFO - Running setup.py install for mozsystemmonitor 11:30:40 INFO - Successfully installed mozsystemmonitor 11:30:40 INFO - Cleaning up... 11:30:40 INFO - Return code: 0 11:30:40 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test-pgo\build/venv 11:30:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:40 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--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 0x019756B0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x019B3EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x013DC288>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012F8BF0>, '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 0x0131A9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01A385C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-227', 'USERDOMAIN': 'T-W732-IX-227', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'OURDRIVE': 'C:', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W732-IX-227', 'MOZ_NO_REMOTE': '1', 'WINDOWS_TRACING_FLAGS': '3', 'CYGWINBASE': 'C:\\cygwin', 'PROGRAMDATA': 'C:\\ProgramData', 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'PWD': 'C:\\slave\\test-pgo', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 11:30:40 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in C:\slave\test-pgo\build 11:30:40 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:30:40 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 11:30:40 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 11:30:40 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 11:30:40 INFO - 'COMPUTERNAME': 'T-W732-IX-227', 11:30:40 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 11:30:40 INFO - 'CYGWINBASE': 'C:\\cygwin', 11:30:40 INFO - 'DCLOCATION': 'SCL3', 11:30:40 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 11:30:40 INFO - 'FP_NO_HOST_CHECK': 'NO', 11:30:40 INFO - 'HOMEDRIVE': 'C:', 11:30:40 INFO - 'HOMEPATH': '\\Users\\cltbld', 11:30:40 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 11:30:40 INFO - 'KTS_VERSION': '1.19c', 11:30:40 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 11:30:40 INFO - 'LOGONSERVER': '\\\\T-W732-IX-227', 11:30:40 INFO - 'MONDIR': 'C:\\Monitor_config\\', 11:30:40 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 11:30:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:40 INFO - 'MOZ_NO_REMOTE': '1', 11:30:40 INFO - 'NO_EM_RESTART': '1', 11:30:40 INFO - 'NUMBER_OF_PROCESSORS': '8', 11:30:40 INFO - 'OS': 'Windows_NT', 11:30:40 INFO - 'OURDRIVE': 'C:', 11:30:40 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 11:30:40 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 11:30:40 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 11:30:40 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 11:30:40 INFO - 'PROCESSOR_LEVEL': '6', 11:30:40 INFO - 'PROCESSOR_REVISION': '1e05', 11:30:40 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 11:30:40 INFO - 'PROGRAMFILES': 'C:\\Program Files', 11:30:40 INFO - 'PROMPT': '$P$G', 11:30:40 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 11:30:40 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 11:30:40 INFO - 'PUBLIC': 'C:\\Users\\Public', 11:30:40 INFO - 'PWD': 'C:\\slave\\test-pgo', 11:30:40 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 11:30:40 INFO - 'SLAVEDIR': 'C:\\slave\\', 11:30:40 INFO - 'SYSTEMDRIVE': 'C:', 11:30:40 INFO - 'SYSTEMROOT': 'C:\\windows', 11:30:40 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 11:30:40 INFO - 'TEST1': 'testie', 11:30:40 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 11:30:40 INFO - 'USERDOMAIN': 'T-W732-IX-227', 11:30:40 INFO - 'USERNAME': 'cltbld', 11:30:40 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 11:30:40 INFO - 'WINDIR': 'C:\\windows', 11:30:40 INFO - 'WINDOWS_TRACING_FLAGS': '3', 11:30:40 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 11:30:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 11:30:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:40 INFO - Downloading/unpacking blobuploader==1.2.4 11:30:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:41 INFO - Downloading blobuploader-1.2.4.tar.gz 11:30:41 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader 11:30:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:30:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:42 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\requests\setup.py) egg_info for package requests 11:30:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:30:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:42 INFO - Downloading docopt-0.6.1.tar.gz 11:30:42 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\docopt\setup.py) egg_info for package docopt 11:30:42 INFO - Installing collected packages: blobuploader, requests, docopt 11:30:42 INFO - Running setup.py install for blobuploader 11:30:42 INFO - Running setup.py install for requests 11:30:43 INFO - Running setup.py install for docopt 11:30:43 INFO - Successfully installed blobuploader requests docopt 11:30:43 INFO - Cleaning up... 11:30:45 INFO - Return code: 0 11:30:45 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv 11:30: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')]} 11:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30: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')]} 11:30:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:45 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--no-deps', '--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 0x019756B0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x019B3EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x013DC288>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012F8BF0>, '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 0x0131A9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01A385C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-227', 'USERDOMAIN': 'T-W732-IX-227', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'OURDRIVE': 'C:', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W732-IX-227', 'MOZ_NO_REMOTE': '1', 'WINDOWS_TRACING_FLAGS': '3', 'CYGWINBASE': 'C:\\cygwin', 'PROGRAMDATA': 'C:\\ProgramData', 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'PWD': 'C:\\slave\\test-pgo', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 11:30:45 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--no-deps', '--timeout', '120', '-r', 'C:\\slave\\test-pgo\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in C:\slave\test-pgo\build\tests\config 11:30:45 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --no-deps --timeout 120 -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:30:45 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 11:30:45 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 11:30:45 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 11:30:45 INFO - 'COMPUTERNAME': 'T-W732-IX-227', 11:30:45 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 11:30:45 INFO - 'CYGWINBASE': 'C:\\cygwin', 11:30:45 INFO - 'DCLOCATION': 'SCL3', 11:30:45 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 11:30:45 INFO - 'FP_NO_HOST_CHECK': 'NO', 11:30:45 INFO - 'HOMEDRIVE': 'C:', 11:30:45 INFO - 'HOMEPATH': '\\Users\\cltbld', 11:30:45 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 11:30:45 INFO - 'KTS_VERSION': '1.19c', 11:30:45 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 11:30:45 INFO - 'LOGONSERVER': '\\\\T-W732-IX-227', 11:30:45 INFO - 'MONDIR': 'C:\\Monitor_config\\', 11:30:45 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 11:30:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:45 INFO - 'MOZ_NO_REMOTE': '1', 11:30:45 INFO - 'NO_EM_RESTART': '1', 11:30:45 INFO - 'NUMBER_OF_PROCESSORS': '8', 11:30:45 INFO - 'OS': 'Windows_NT', 11:30:45 INFO - 'OURDRIVE': 'C:', 11:30:45 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 11:30:45 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 11:30:45 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 11:30:45 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 11:30:45 INFO - 'PROCESSOR_LEVEL': '6', 11:30:45 INFO - 'PROCESSOR_REVISION': '1e05', 11:30:45 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 11:30:45 INFO - 'PROGRAMFILES': 'C:\\Program Files', 11:30:45 INFO - 'PROMPT': '$P$G', 11:30:45 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 11:30:45 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 11:30:45 INFO - 'PUBLIC': 'C:\\Users\\Public', 11:30:45 INFO - 'PWD': 'C:\\slave\\test-pgo', 11:30:45 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 11:30:45 INFO - 'SLAVEDIR': 'C:\\slave\\', 11:30:45 INFO - 'SYSTEMDRIVE': 'C:', 11:30:45 INFO - 'SYSTEMROOT': 'C:\\windows', 11:30:45 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 11:30:45 INFO - 'TEST1': 'testie', 11:30:45 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 11:30:45 INFO - 'USERDOMAIN': 'T-W732-IX-227', 11:30:45 INFO - 'USERNAME': 'cltbld', 11:30:45 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 11:30:45 INFO - 'WINDIR': 'C:\\windows', 11:30:45 INFO - 'WINDOWS_TRACING_FLAGS': '3', 11:30:45 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 11:30:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 11:30:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:45 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\manifestparser 11:30:45 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-qodrjx-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/manifestparser 11:30:45 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozcrash 11:30:45 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-vpwpnu-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozcrash 11:30:45 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdebug 11:30:45 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-yr8ytv-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdebug 11:30:46 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdevice 11:30:46 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-fsgffw-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdevice 11:30:46 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozfile 11:30:46 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-7ljcr5-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozfile 11:30:46 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozhttpd 11:30:46 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-p5idbu-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozhttpd 11:30:46 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinfo 11:30:46 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-6cew5b-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinfo 11:30:46 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinstall 11:30:46 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-vzglul-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinstall 11:30:46 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozleak 11:30:46 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-31oqpn-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozleak 11:30:46 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozlog 11:30:46 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-vv3xpq-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozlog 11:30:47 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moznetwork 11:30:47 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-6nvcob-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moznetwork 11:30:47 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprocess 11:30:47 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-hjh7ju-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprocess 11:30:47 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprofile 11:30:47 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-9lygfx-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprofile 11:30:47 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozrunner 11:30:47 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-foozmj-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozrunner 11:30:47 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozscreenshot 11:30:47 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-vaflqf-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:30:47 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moztest 11:30:47 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-0xpr9g-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moztest 11:30:47 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozversion 11:30:47 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-tnzxhk-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozversion 11:30:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:30:47 INFO - Running setup.py install for manifestparser 11:30:48 INFO - Installing manifestparser-script.py script to C:\slave\test-pgo\build\venv\Scripts 11:30:48 INFO - Installing manifestparser.exe script to C:\slave\test-pgo\build\venv\Scripts 11:30:48 INFO - Running setup.py install for mozcrash 11:30:48 INFO - Running setup.py install for mozdebug 11:30:49 INFO - Running setup.py install for mozdevice 11:30:49 INFO - Installing sutini-script.py script to C:\slave\test-pgo\build\venv\Scripts 11:30:49 INFO - Installing sutini.exe script to C:\slave\test-pgo\build\venv\Scripts 11:30:49 INFO - Installing dm-script.py script to C:\slave\test-pgo\build\venv\Scripts 11:30:49 INFO - Installing dm.exe script to C:\slave\test-pgo\build\venv\Scripts 11:30:49 INFO - Running setup.py install for mozfile 11:30:50 INFO - Running setup.py install for mozhttpd 11:30:50 INFO - Installing mozhttpd-script.py script to C:\slave\test-pgo\build\venv\Scripts 11:30:50 INFO - Installing mozhttpd.exe script to C:\slave\test-pgo\build\venv\Scripts 11:30:50 INFO - Running setup.py install for mozinfo 11:30:50 INFO - Installing mozinfo-script.py script to C:\slave\test-pgo\build\venv\Scripts 11:30:50 INFO - Installing mozinfo.exe script to C:\slave\test-pgo\build\venv\Scripts 11:30:51 INFO - Running setup.py install for mozInstall 11:30:51 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test-pgo\build\venv\Scripts 11:30:51 INFO - Installing moz_remove_from_system.exe script to C:\slave\test-pgo\build\venv\Scripts 11:30:51 INFO - Installing mozuninstall-script.py script to C:\slave\test-pgo\build\venv\Scripts 11:30:51 INFO - Installing mozuninstall.exe script to C:\slave\test-pgo\build\venv\Scripts 11:30:51 INFO - Installing mozinstall-script.py script to C:\slave\test-pgo\build\venv\Scripts 11:30:51 INFO - Installing mozinstall.exe script to C:\slave\test-pgo\build\venv\Scripts 11:30:51 INFO - Installing moz_add_to_system-script.py script to C:\slave\test-pgo\build\venv\Scripts 11:30:51 INFO - Installing moz_add_to_system.exe script to C:\slave\test-pgo\build\venv\Scripts 11:30:51 INFO - Running setup.py install for mozleak 11:30:51 INFO - Running setup.py install for mozlog 11:30:52 INFO - Installing structlog-script.py script to C:\slave\test-pgo\build\venv\Scripts 11:30:52 INFO - Installing structlog.exe script to C:\slave\test-pgo\build\venv\Scripts 11:30:52 INFO - Running setup.py install for moznetwork 11:30:52 INFO - Installing moznetwork-script.py script to C:\slave\test-pgo\build\venv\Scripts 11:30:52 INFO - Installing moznetwork.exe script to C:\slave\test-pgo\build\venv\Scripts 11:30:53 INFO - Running setup.py install for mozprocess 11:30:53 INFO - Running setup.py install for mozprofile 11:30:53 INFO - Installing mozprofile-script.py script to C:\slave\test-pgo\build\venv\Scripts 11:30:53 INFO - Installing mozprofile.exe script to C:\slave\test-pgo\build\venv\Scripts 11:30:53 INFO - Installing diff-profiles-script.py script to C:\slave\test-pgo\build\venv\Scripts 11:30:53 INFO - Installing diff-profiles.exe script to C:\slave\test-pgo\build\venv\Scripts 11:30:53 INFO - Installing view-profile-script.py script to C:\slave\test-pgo\build\venv\Scripts 11:30:53 INFO - Installing view-profile.exe script to C:\slave\test-pgo\build\venv\Scripts 11:30:54 INFO - Running setup.py install for mozrunner 11:30:54 INFO - Installing mozrunner-script.py script to C:\slave\test-pgo\build\venv\Scripts 11:30:54 INFO - Installing mozrunner.exe script to C:\slave\test-pgo\build\venv\Scripts 11:30:54 INFO - Running setup.py install for mozscreenshot 11:30:55 INFO - Running setup.py install for moztest 11:30:55 INFO - Running setup.py install for mozversion 11:30:55 INFO - Installing mozversion-script.py script to C:\slave\test-pgo\build\venv\Scripts 11:30:55 INFO - Installing mozversion.exe script to C:\slave\test-pgo\build\venv\Scripts 11:30:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:30:56 INFO - Cleaning up... 11:30:56 INFO - Return code: 0 11:30:56 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv 11:30:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:56 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--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 0x019756B0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x019B3EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x013DC288>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012F8BF0>, '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 0x0131A9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01A385C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-227', 'USERDOMAIN': 'T-W732-IX-227', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'OURDRIVE': 'C:', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W732-IX-227', 'MOZ_NO_REMOTE': '1', 'WINDOWS_TRACING_FLAGS': '3', 'CYGWINBASE': 'C:\\cygwin', 'PROGRAMDATA': 'C:\\ProgramData', 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'PWD': 'C:\\slave\\test-pgo', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 11:30:56 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '-r', 'C:\\slave\\test-pgo\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in C:\slave\test-pgo\build\tests\config 11:30:56 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --timeout 120 -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:30:56 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 11:30:56 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 11:30:56 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 11:30:56 INFO - 'COMPUTERNAME': 'T-W732-IX-227', 11:30:56 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 11:30:56 INFO - 'CYGWINBASE': 'C:\\cygwin', 11:30:56 INFO - 'DCLOCATION': 'SCL3', 11:30:56 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 11:30:56 INFO - 'FP_NO_HOST_CHECK': 'NO', 11:30:56 INFO - 'HOMEDRIVE': 'C:', 11:30:56 INFO - 'HOMEPATH': '\\Users\\cltbld', 11:30:56 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 11:30:56 INFO - 'KTS_VERSION': '1.19c', 11:30:56 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 11:30:56 INFO - 'LOGONSERVER': '\\\\T-W732-IX-227', 11:30:56 INFO - 'MONDIR': 'C:\\Monitor_config\\', 11:30:56 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 11:30:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:56 INFO - 'MOZ_NO_REMOTE': '1', 11:30:56 INFO - 'NO_EM_RESTART': '1', 11:30:56 INFO - 'NUMBER_OF_PROCESSORS': '8', 11:30:56 INFO - 'OS': 'Windows_NT', 11:30:56 INFO - 'OURDRIVE': 'C:', 11:30:56 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 11:30:56 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 11:30:56 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 11:30:56 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 11:30:56 INFO - 'PROCESSOR_LEVEL': '6', 11:30:56 INFO - 'PROCESSOR_REVISION': '1e05', 11:30:56 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 11:30:56 INFO - 'PROGRAMFILES': 'C:\\Program Files', 11:30:56 INFO - 'PROMPT': '$P$G', 11:30:56 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 11:30:56 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 11:30:56 INFO - 'PUBLIC': 'C:\\Users\\Public', 11:30:56 INFO - 'PWD': 'C:\\slave\\test-pgo', 11:30:56 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 11:30:56 INFO - 'SLAVEDIR': 'C:\\slave\\', 11:30:56 INFO - 'SYSTEMDRIVE': 'C:', 11:30:56 INFO - 'SYSTEMROOT': 'C:\\windows', 11:30:56 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 11:30:56 INFO - 'TEST1': 'testie', 11:30:56 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 11:30:56 INFO - 'USERDOMAIN': 'T-W732-IX-227', 11:30:56 INFO - 'USERNAME': 'cltbld', 11:30:56 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 11:30:56 INFO - 'WINDIR': 'C:\\windows', 11:30:56 INFO - 'WINDOWS_TRACING_FLAGS': '3', 11:30:56 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 11:30:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 11:30:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:56 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\manifestparser 11:30:56 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-jjej50-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/manifestparser 11:30:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///C:/slave/test-pgo/build/tests/mozbase/manifestparser in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 1)) 11:30:56 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozcrash 11:30:56 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-w_znpl-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozcrash 11:30:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///C:/slave/test-pgo/build/tests/mozbase/mozcrash in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 2)) 11:30:56 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdebug 11:30:56 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-pyhyut-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdebug 11:30:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///C:/slave/test-pgo/build/tests/mozbase/mozdebug in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 3)) 11:30:56 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdevice 11:30:56 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-1kbldu-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdevice 11:30:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///C:/slave/test-pgo/build/tests/mozbase/mozdevice in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 4)) 11:30:57 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozfile 11:30:57 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-le_s0s-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozfile 11:30:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///C:/slave/test-pgo/build/tests/mozbase/mozfile in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 5)) 11:30:57 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozhttpd 11:30:57 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-swldcv-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozhttpd 11:30:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///C:/slave/test-pgo/build/tests/mozbase/mozhttpd in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 6)) 11:30:57 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinfo 11:30:57 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-kf_tuj-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinfo 11:30:57 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)) 11:30:57 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinstall 11:30:57 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-u3_n3o-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinstall 11:30:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///C:/slave/test-pgo/build/tests/mozbase/mozinstall in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 8)) 11:30:57 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozleak 11:30:57 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-xh3r8i-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozleak 11:30:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///C:/slave/test-pgo/build/tests/mozbase/mozleak in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 9)) 11:30:57 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozlog 11:30:57 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-a8ftbo-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozlog 11:30:57 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)) 11:30:57 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moznetwork 11:30:57 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-e174t0-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moznetwork 11:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///C:/slave/test-pgo/build/tests/mozbase/moznetwork in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 11)) 11:30:58 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprocess 11:30:58 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-5d21tz-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprocess 11:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///C:/slave/test-pgo/build/tests/mozbase/mozprocess in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 12)) 11:30:58 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprofile 11:30:58 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-szlopt-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprofile 11:30:58 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)) 11:30:58 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozrunner 11:30:58 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-fjjxvs-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozrunner 11:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///C:/slave/test-pgo/build/tests/mozbase/mozrunner in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 14)) 11:30:58 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozscreenshot 11:30:58 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-opkox4-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///C:/slave/test-pgo/build/tests/mozbase/mozscreenshot in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 15)) 11:30:58 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moztest 11:30:58 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-ojcfmr-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moztest 11:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///C:/slave/test-pgo/build/tests/mozbase/moztest in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 16)) 11:30:59 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozversion 11:30:59 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-ep6nu_-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozversion 11:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///C:/slave/test-pgo/build/tests/mozbase/mozversion in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 17)) 11:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in c:\slave\test-pgo\build\venv\lib\site-packages (from mozcrash==0.16->-r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 2)) 11:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in c:\slave\test-pgo\build\venv\lib\site-packages (from mozcrash==0.16->-r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 2)) 11:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in c:\slave\test-pgo\build\venv\lib\site-packages (from mozdebug==0.1->-r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 3)) 11:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test-pgo\build\venv\lib\site-packages (from mozdevice==0.48->-r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 4)) 11:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in c:\slave\test-pgo\build\venv\lib\site-packages (from mozdevice==0.48->-r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 4)) 11:30:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 10)) 11:30: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 11:30: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 11:31:00 INFO - Downloading blessings-1.6.tar.gz 11:31:00 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\blessings\setup.py) egg_info for package blessings 11:31:00 INFO - Installing collected packages: blessings 11:31:00 INFO - Running setup.py install for blessings 11:31:00 INFO - Successfully installed blessings 11:31:00 INFO - Cleaning up... 11:31:03 INFO - Return code: 0 11:31:03 INFO - Done creating virtualenv C:\slave\test-pgo\build/venv. 11:31:03 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'freeze'] 11:31:03 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip freeze 11:31:04 INFO - Reading from file tmpfile_stdout 11:31:04 INFO - Using _rmtree_windows ... 11:31:04 INFO - Using _rmtree_windows ... 11:31:04 INFO - Current package versions: 11:31:04 INFO - blessings == 1.6 11:31:04 INFO - blobuploader == 1.2.4 11:31:04 INFO - docopt == 0.6.1 11:31:04 INFO - manifestparser == 1.1 11:31:04 INFO - mozInstall == 1.12 11:31:04 INFO - mozcrash == 0.16 11:31:04 INFO - mozdebug == 0.1 11:31:04 INFO - mozdevice == 0.48 11:31:04 INFO - mozfile == 1.2 11:31:04 INFO - mozhttpd == 0.7 11:31:04 INFO - mozinfo == 0.9 11:31:04 INFO - mozleak == 0.1 11:31:04 INFO - mozlog == 3.1 11:31:04 INFO - moznetwork == 0.27 11:31:04 INFO - mozprocess == 0.22 11:31:04 INFO - mozprofile == 0.28 11:31:04 INFO - mozrunner == 6.11 11:31:04 INFO - mozscreenshot == 0.1 11:31:04 INFO - mozsystemmonitor == 0.0 11:31:04 INFO - moztest == 0.7 11:31:04 INFO - mozversion == 1.4 11:31:04 INFO - psutil == 3.1.1 11:31:04 INFO - requests == 1.2.3 11:31:04 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv 11:31:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:04 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--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 0x019756B0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x019B3EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x013DC288>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012F8BF0>, '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 0x0131A9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01A385C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build\\tests\\talos', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-227', 'USERDOMAIN': 'T-W732-IX-227', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'OURDRIVE': 'C:', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W732-IX-227', 'MOZ_NO_REMOTE': '1', 'WINDOWS_TRACING_FLAGS': '3', 'CYGWINBASE': 'C:\\cygwin', 'PROGRAMDATA': 'C:\\ProgramData', 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'PWD': 'C:\\slave\\test-pgo', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 11:31:04 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--timeout', '120', '-r', 'C:\\slave\\test-pgo\\build\\tests\\talos\\requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in C:\slave\test-pgo\build\tests\talos 11:31:04 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --timeout 120 -r C:\slave\test-pgo\build\tests\talos\requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:31:04 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 11:31:04 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 11:31:04 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 11:31:04 INFO - 'COMPUTERNAME': 'T-W732-IX-227', 11:31:04 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 11:31:04 INFO - 'CYGWINBASE': 'C:\\cygwin', 11:31:04 INFO - 'DCLOCATION': 'SCL3', 11:31:04 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 11:31:04 INFO - 'FP_NO_HOST_CHECK': 'NO', 11:31:04 INFO - 'HOMEDRIVE': 'C:', 11:31:04 INFO - 'HOMEPATH': '\\Users\\cltbld', 11:31:04 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 11:31:04 INFO - 'KTS_VERSION': '1.19c', 11:31:04 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 11:31:04 INFO - 'LOGONSERVER': '\\\\T-W732-IX-227', 11:31:04 INFO - 'MONDIR': 'C:\\Monitor_config\\', 11:31:04 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 11:31:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:04 INFO - 'MOZ_NO_REMOTE': '1', 11:31:04 INFO - 'NO_EM_RESTART': '1', 11:31:04 INFO - 'NUMBER_OF_PROCESSORS': '8', 11:31:04 INFO - 'OS': 'Windows_NT', 11:31:04 INFO - 'OURDRIVE': 'C:', 11:31:04 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 11:31:04 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 11:31:04 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 11:31:04 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 11:31:04 INFO - 'PROCESSOR_LEVEL': '6', 11:31:04 INFO - 'PROCESSOR_REVISION': '1e05', 11:31:04 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 11:31:04 INFO - 'PROGRAMFILES': 'C:\\Program Files', 11:31:04 INFO - 'PROMPT': '$P$G', 11:31:04 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 11:31:04 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 11:31:04 INFO - 'PUBLIC': 'C:\\Users\\Public', 11:31:04 INFO - 'PWD': 'C:\\slave\\test-pgo', 11:31:04 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 11:31:04 INFO - 'SLAVEDIR': 'C:\\slave\\', 11:31:04 INFO - 'SYSTEMDRIVE': 'C:', 11:31:04 INFO - 'SYSTEMROOT': 'C:\\windows', 11:31:04 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 11:31:04 INFO - 'TEST1': 'testie', 11:31:04 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 11:31:04 INFO - 'USERDOMAIN': 'T-W732-IX-227', 11:31:04 INFO - 'USERNAME': 'cltbld', 11:31:04 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 11:31:04 INFO - 'WINDIR': 'C:\\windows', 11:31:04 INFO - 'WINDOWS_TRACING_FLAGS': '3', 11:31:04 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 11:31:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 11:31:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:04 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)) 11:31:04 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)) 11:31:04 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)) 11:31:04 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)) 11:31:04 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)) 11:31:04 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)) 11:31:04 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)) 11:31:04 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)) 11:31:04 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)) 11:31:04 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)) 11:31:04 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)) 11:31:04 INFO - Cleaning up... 11:31:04 INFO - Return code: 0 11:31:04 INFO - Installing jsonschema into virtualenv C:\slave\test-pgo\build/venv 11:31:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:04 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--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 0x019756B0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x019B3EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x013DC288>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012F8BF0>, '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 0x0131A9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01A385C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-227', 'USERDOMAIN': 'T-W732-IX-227', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'OURDRIVE': 'C:', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W732-IX-227', 'MOZ_NO_REMOTE': '1', 'WINDOWS_TRACING_FLAGS': '3', 'CYGWINBASE': 'C:\\cygwin', 'PROGRAMDATA': 'C:\\ProgramData', 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'PWD': 'C:\\slave\\test-pgo', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 11:31:04 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--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 11:31:04 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:31:04 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 11:31:04 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 11:31:04 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 11:31:04 INFO - 'COMPUTERNAME': 'T-W732-IX-227', 11:31:04 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 11:31:04 INFO - 'CYGWINBASE': 'C:\\cygwin', 11:31:04 INFO - 'DCLOCATION': 'SCL3', 11:31:04 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 11:31:04 INFO - 'FP_NO_HOST_CHECK': 'NO', 11:31:04 INFO - 'HOMEDRIVE': 'C:', 11:31:04 INFO - 'HOMEPATH': '\\Users\\cltbld', 11:31:04 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 11:31:04 INFO - 'KTS_VERSION': '1.19c', 11:31:04 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 11:31:04 INFO - 'LOGONSERVER': '\\\\T-W732-IX-227', 11:31:04 INFO - 'MONDIR': 'C:\\Monitor_config\\', 11:31:04 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 11:31:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:04 INFO - 'MOZ_NO_REMOTE': '1', 11:31:04 INFO - 'NO_EM_RESTART': '1', 11:31:04 INFO - 'NUMBER_OF_PROCESSORS': '8', 11:31:04 INFO - 'OS': 'Windows_NT', 11:31:04 INFO - 'OURDRIVE': 'C:', 11:31:04 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 11:31:04 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 11:31:04 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 11:31:04 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 11:31:04 INFO - 'PROCESSOR_LEVEL': '6', 11:31:04 INFO - 'PROCESSOR_REVISION': '1e05', 11:31:04 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 11:31:04 INFO - 'PROGRAMFILES': 'C:\\Program Files', 11:31:04 INFO - 'PROMPT': '$P$G', 11:31:04 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 11:31:04 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 11:31:04 INFO - 'PUBLIC': 'C:\\Users\\Public', 11:31:04 INFO - 'PWD': 'C:\\slave\\test-pgo', 11:31:04 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 11:31:04 INFO - 'SLAVEDIR': 'C:\\slave\\', 11:31:04 INFO - 'SYSTEMDRIVE': 'C:', 11:31:04 INFO - 'SYSTEMROOT': 'C:\\windows', 11:31:04 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 11:31:04 INFO - 'TEST1': 'testie', 11:31:04 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 11:31:04 INFO - 'USERDOMAIN': 'T-W732-IX-227', 11:31:04 INFO - 'USERNAME': 'cltbld', 11:31:04 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 11:31:04 INFO - 'WINDIR': 'C:\\windows', 11:31:04 INFO - 'WINDOWS_TRACING_FLAGS': '3', 11:31:04 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 11:31:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 11:31:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:04 INFO - Downloading/unpacking jsonschema 11:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:31:05 INFO - Downloading/unpacking functools32 (from jsonschema) 11:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:05 INFO - Downloading functools32-3.2.3-2.tar.gz 11:31:05 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\functools32\setup.py) egg_info for package functools32 11:31:06 INFO - warning: no files found matching '*.txt' 11:31:06 INFO - no previously-included directories found matching 'build' 11:31:06 INFO - no previously-included directories found matching 'dist' 11:31:06 INFO - no previously-included directories found matching '.git*' 11:31:06 INFO - Installing collected packages: jsonschema, functools32 11:31:06 INFO - Running setup.py install for functools32 11:31:06 INFO - warning: no files found matching '*.txt' 11:31:06 INFO - no previously-included directories found matching 'build' 11:31:06 INFO - no previously-included directories found matching 'dist' 11:31:06 INFO - no previously-included directories found matching '.git*' 11:31:06 INFO - Successfully installed jsonschema functools32 11:31:06 INFO - Cleaning up... 11:31:06 INFO - Return code: 0 11:31:06 INFO - Installing flake8 into virtualenv C:\slave\test-pgo\build/venv 11:31:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:06 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--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 0x019756B0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x019B3EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x013DC288>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012F8BF0>, '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 0x0131A9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01A385C0>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-227', 'USERDOMAIN': 'T-W732-IX-227', 'KTS_VERSION': '1.19c', 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files', 'PROCESSOR_REVISION': '1e05', 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 'SYSTEMROOT': 'C:\\windows', 'NO_EM_RESTART': '1', 'OURDRIVE': 'C:', 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 'XPCOM_DEBUG_BREAK': 'warn', 'MONDIR': 'C:\\Monitor_config\\', 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 'PROCESSOR_ARCHITECTURE': 'x86', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 'HOMEPATH': '\\Users\\cltbld', 'MOZBUILDDIR': 'C:\\mozilla-build\\', 'USERNAME': 'cltbld', 'LOGONSERVER': '\\\\T-W732-IX-227', 'MOZ_NO_REMOTE': '1', 'WINDOWS_TRACING_FLAGS': '3', 'CYGWINBASE': 'C:\\cygwin', 'PROGRAMDATA': 'C:\\ProgramData', 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 'PROMPT': '$P$G', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'FP_NO_HOST_CHECK': 'NO', 'DCLOCATION': 'SCL3', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'HOMEDRIVE': 'C:', 'SYSTEMDRIVE': 'C:', 'SLAVEDIR': 'C:\\slave\\', 'NUMBER_OF_PROCESSORS': '8', 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 'PWD': 'C:\\slave\\test-pgo', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 11:31:07 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--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 11:31:07 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:31:07 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 11:31:07 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 11:31:07 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 11:31:07 INFO - 'COMPUTERNAME': 'T-W732-IX-227', 11:31:07 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 11:31:07 INFO - 'CYGWINBASE': 'C:\\cygwin', 11:31:07 INFO - 'DCLOCATION': 'SCL3', 11:31:07 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 11:31:07 INFO - 'FP_NO_HOST_CHECK': 'NO', 11:31:07 INFO - 'HOMEDRIVE': 'C:', 11:31:07 INFO - 'HOMEPATH': '\\Users\\cltbld', 11:31:07 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 11:31:07 INFO - 'KTS_VERSION': '1.19c', 11:31:07 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 11:31:07 INFO - 'LOGONSERVER': '\\\\T-W732-IX-227', 11:31:07 INFO - 'MONDIR': 'C:\\Monitor_config\\', 11:31:07 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 11:31:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:07 INFO - 'MOZ_NO_REMOTE': '1', 11:31:07 INFO - 'NO_EM_RESTART': '1', 11:31:07 INFO - 'NUMBER_OF_PROCESSORS': '8', 11:31:07 INFO - 'OS': 'Windows_NT', 11:31:07 INFO - 'OURDRIVE': 'C:', 11:31:07 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 11:31:07 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 11:31:07 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 11:31:07 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 11:31:07 INFO - 'PROCESSOR_LEVEL': '6', 11:31:07 INFO - 'PROCESSOR_REVISION': '1e05', 11:31:07 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 11:31:07 INFO - 'PROGRAMFILES': 'C:\\Program Files', 11:31:07 INFO - 'PROMPT': '$P$G', 11:31:07 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 11:31:07 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 11:31:07 INFO - 'PUBLIC': 'C:\\Users\\Public', 11:31:07 INFO - 'PWD': 'C:\\slave\\test-pgo', 11:31:07 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 11:31:07 INFO - 'SLAVEDIR': 'C:\\slave\\', 11:31:07 INFO - 'SYSTEMDRIVE': 'C:', 11:31:07 INFO - 'SYSTEMROOT': 'C:\\windows', 11:31:07 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 11:31:07 INFO - 'TEST1': 'testie', 11:31:07 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 11:31:07 INFO - 'USERDOMAIN': 'T-W732-IX-227', 11:31:07 INFO - 'USERNAME': 'cltbld', 11:31:07 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 11:31:07 INFO - 'WINDIR': 'C:\\windows', 11:31:07 INFO - 'WINDOWS_TRACING_FLAGS': '3', 11:31:07 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 11:31:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 11:31:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:07 INFO - Downloading/unpacking flake8 11:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:31:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:31:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:08 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\pep8\setup.py) egg_info for package pep8 11:31:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:31:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:31:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:31:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:31:08 INFO - no previously-included directories found matching 'docs\_build' 11:31:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:31:09 INFO - Running setup.py install for pep8 11:31:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:31:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:31:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:31:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:31:09 INFO - no previously-included directories found matching 'docs\_build' 11:31:09 INFO - Installing pep8-script.py script to C:\slave\test-pgo\build\venv\Scripts 11:31:09 INFO - Installing pep8.exe script to C:\slave\test-pgo\build\venv\Scripts 11:31:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:31:09 INFO - Cleaning up... 11:31:10 INFO - Return code: 0 11:31:10 INFO - Running post-action listener: _resource_record_post_action 11:31:10 INFO - Running post-action listener: _start_resource_monitoring 11:31:10 INFO - Starting resource monitoring. 11:31:10 INFO - ##### 11:31:10 INFO - ##### Running install step. 11:31:10 INFO - ##### 11:31:10 INFO - Running pre-action listener: _resource_record_pre_action 11:31:10 INFO - Running main action method: install 11:31:10 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'freeze'] 11:31:10 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip freeze 11:31:10 INFO - Reading from file tmpfile_stdout 11:31:10 INFO - Using _rmtree_windows ... 11:31:10 INFO - Using _rmtree_windows ... 11:31:10 INFO - Detecting whether we're running mozinstall >=1.0... 11:31:10 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build/venv/scripts/python', 'C:\\slave\\test-pgo\\build/venv/scripts/mozinstall-script.py', '-h'] 11:31:10 INFO - Copy/paste: C:\slave\test-pgo\build/venv/scripts/python C:\slave\test-pgo\build/venv/scripts/mozinstall-script.py -h 11:31:10 INFO - Reading from file tmpfile_stdout 11:31:10 INFO - Output received: 11:31:10 INFO - Usage: mozinstall-script.py [options] installer 11:31:10 INFO - Options: 11:31:10 INFO - -h, --help show this help message and exit 11:31:10 INFO - -d DEST, --destination=DEST 11:31:10 INFO - Directory to install application into. [default: 11:31:10 INFO - "C:\slave\test-pgo"] 11:31:10 INFO - --app=APP Application being installed. [default: firefox] 11:31:10 INFO - Using _rmtree_windows ... 11:31:10 INFO - Using _rmtree_windows ... 11:31:10 INFO - mkdir: C:\slave\test-pgo\build\application 11:31:10 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.0a2.en-US.win32.zip', '--destination', 'C:\\slave\\test-pgo\\build\\application'] 11:31:10 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.0a2.en-US.win32.zip --destination C:\slave\test-pgo\build\application 11:31:11 INFO - Reading from file tmpfile_stdout 11:31:11 INFO - Output received: 11:31:11 INFO - C:\slave\test-pgo\build\application\firefox\firefox.exe 11:31:11 INFO - Using _rmtree_windows ... 11:31:11 INFO - Using _rmtree_windows ... 11:31:11 INFO - Running post-action listener: _resource_record_post_action 11:31:11 INFO - ##### 11:31:11 INFO - ##### Running run-tests step. 11:31:11 INFO - ##### 11:31:11 INFO - Running pre-action listener: _resource_record_pre_action 11:31:11 INFO - Running main action method: run_tests 11:31:11 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\python', '--version'] 11:31:11 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\python --version 11:31:11 INFO - Python 2.7.3 11:31:11 INFO - Return code: 0 11:31:11 INFO - grabbing minidump binary from tooltool 11:31:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:11 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 0x012F8BF0>, '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 0x0131A9C0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01A385C0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'privileged': False}, attempt #1 11:31:11 INFO - Running command: ['c:/mozilla-build/python27/python.exe', 'C:/mozilla-build/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', 'c:\\builds\\relengapi.tok', 'fetch', '-m', 'C:\\slave\\test-pgo\\build\\tests\\config/tooltool-manifests/win32/releng.manifest', '-o'] in C:\slave\test-pgo\build 11:31:11 INFO - Copy/paste: c:/mozilla-build/python27/python.exe C:/mozilla-build/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file c:\builds\relengapi.tok fetch -m C:\slave\test-pgo\build\tests\config/tooltool-manifests/win32/releng.manifest -o 11:31:12 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 11:31:12 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test-pgo\build\tmpctuqcl 11:31:12 INFO - INFO - File integrity verified, renaming tmpctuqcl to win32-minidump_stackwalk.exe 11:31:12 INFO - Return code: 0 11:31:12 INFO - Chmoding C:\slave\test-pgo\build\win32-minidump_stackwalk.exe to 0755 11:31:12 INFO - mkdir: C:\slave\test-pgo\build\blobber_upload_dir 11:31:12 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test-pgo\build\blobber_upload_dir 11:31:12 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test-pgo\build\win32-minidump_stackwalk.exe 11:31:12 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test-pgo\build\blobber_upload_dir 11:31:12 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\flake8', 'C:\\slave\\test-pgo\\build\\tests\\talos\\talos'] 11:31:12 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\flake8 C:\slave\test-pgo\build\tests\talos\talos 11:31:14 INFO - Return code: 0 11:31:14 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\python', 'C:\\slave\\test-pgo\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test-pgo\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fG94VsYRRR6S08JOLOkocQ/artifacts/public/build/firefox-46.0a2.en-US.win32.crashreporter-symbols.zip', '--title', 'T-W732-IX-227', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=C:\\slave\\test-pgo\\build\\blobber_upload_dir\\dromaeojs_errorsummary.log', '--log-raw=C:\\slave\\test-pgo\\build\\blobber_upload_dir\\dromaeojs_raw.log'] in C:\slave\test-pgo\build 11:31:14 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\python C:\slave\test-pgo\build\tests\talos\talos\run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath C:\slave\test-pgo\build\application\firefox\firefox --symbolsPath https://queue.taskcluster.net/v1/task/fG94VsYRRR6S08JOLOkocQ/artifacts/public/build/firefox-46.0a2.en-US.win32.crashreporter-symbols.zip --title T-W732-IX-227 --webServer localhost --log-tbpl-level=debug --log-errorsummary=C:\slave\test-pgo\build\blobber_upload_dir\dromaeojs_errorsummary.log --log-raw=C:\slave\test-pgo\build\blobber_upload_dir\dromaeojs_raw.log 11:31:14 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 11:31:14 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 11:31:14 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 11:31:14 INFO - 'COMPUTERNAME': 'T-W732-IX-227', 11:31:14 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 11:31:14 INFO - 'CYGWINBASE': 'C:\\cygwin', 11:31:14 INFO - 'DCLOCATION': 'SCL3', 11:31:14 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 11:31:14 INFO - 'FP_NO_HOST_CHECK': 'NO', 11:31:14 INFO - 'HOMEDRIVE': 'C:', 11:31:14 INFO - 'HOMEPATH': '\\Users\\cltbld', 11:31:14 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 11:31:14 INFO - 'KTS_VERSION': '1.19c', 11:31:14 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 11:31:14 INFO - 'LOGONSERVER': '\\\\T-W732-IX-227', 11:31:14 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test-pgo\\build\\blobber_upload_dir', 11:31:14 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test-pgo\\build\\win32-minidump_stackwalk.exe', 11:31:14 INFO - 'MONDIR': 'C:\\Monitor_config\\', 11:31:14 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 11:31:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:14 INFO - 'MOZ_NO_REMOTE': '1', 11:31:14 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test-pgo\\build\\blobber_upload_dir', 11:31:14 INFO - 'NO_EM_RESTART': '1', 11:31:14 INFO - 'NUMBER_OF_PROCESSORS': '8', 11:31:14 INFO - 'OS': 'Windows_NT', 11:31:14 INFO - 'OURDRIVE': 'C:', 11:31:14 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 11:31:14 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 11:31:14 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 11:31:14 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 11:31:14 INFO - 'PROCESSOR_LEVEL': '6', 11:31:14 INFO - 'PROCESSOR_REVISION': '1e05', 11:31:14 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 11:31:14 INFO - 'PROGRAMFILES': 'C:\\Program Files', 11:31:14 INFO - 'PROMPT': '$P$G', 11:31:14 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 11:31:14 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 11:31:14 INFO - 'PUBLIC': 'C:\\Users\\Public', 11:31:14 INFO - 'PWD': 'C:\\slave\\test-pgo', 11:31:14 INFO - 'PYTHONPATH': 'C:\\slave\\test-pgo\\build\\tests\\talos', 11:31:14 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 11:31:14 INFO - 'SLAVEDIR': 'C:\\slave\\', 11:31:14 INFO - 'SYSTEMDRIVE': 'C:', 11:31:14 INFO - 'SYSTEMROOT': 'C:\\windows', 11:31:14 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 11:31:14 INFO - 'TEST1': 'testie', 11:31:14 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 11:31:14 INFO - 'USERDOMAIN': 'T-W732-IX-227', 11:31:14 INFO - 'USERNAME': 'cltbld', 11:31:14 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 11:31:14 INFO - 'WINDIR': 'C:\\windows', 11:31:14 INFO - 'WINDOWS_TRACING_FLAGS': '3', 11:31:14 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 11:31:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 11:31:14 INFO - Calling ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\python', 'C:\\slave\\test-pgo\\build\\tests\\talos\\talos\\run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test-pgo\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fG94VsYRRR6S08JOLOkocQ/artifacts/public/build/firefox-46.0a2.en-US.win32.crashreporter-symbols.zip', '--title', 'T-W732-IX-227', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=C:\\slave\\test-pgo\\build\\blobber_upload_dir\\dromaeojs_errorsummary.log', '--log-raw=C:\\slave\\test-pgo\\build\\blobber_upload_dir\\dromaeojs_raw.log'] with output_timeout 3600 11:31:15 INFO - mozversion application_buildid: 20160304073420 11:31:15 INFO - mozversion application_changeset: 38bc572c312206a89c09b6c280840970ff12fc5f 11:31:15 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:31:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:31:15 INFO - mozversion application_name: Firefox 11:31:15 INFO - mozversion application_remotingname: firefox-dev 11:31:15 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:31:15 INFO - mozversion application_vendor: Mozilla 11:31:15 INFO - mozversion application_version: 46.0a2 11:31:15 INFO - mozversion platform_buildid: 20160304073420 11:31:15 INFO - mozversion platform_changeset: 38bc572c312206a89c09b6c280840970ff12fc5f 11:31:15 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:31:15 INFO - mozversion platform_version: 46.0a2 11:31:15 INFO - using testdate: 1457119875 11:31:15 INFO - actual date: 1457119875 11:31:15 INFO - starting webserver on 'localhost:49656' 11:31:15 INFO - SUITE-START | Running 3 tests 11:31:15 INFO - TEST-START | dromaeo_css 11:31:15 INFO - operating with platform_type : w7_ 11:31:15 INFO - Initialising browser for dromaeo_css test... 11:31:15 INFO - TEST-INFO | started process 4036 (C:\slave\test-pgo\build\application\firefox\firefox -profile c:\users\cltbld\appdata\local\temp\tmpx1h_gl\profile http://localhost:49656/getInfo.html) 11:31:26 INFO - PROCESS | 4036 | __metrics Screen width/height:1600/1200 11:31:26 INFO - PROCESS | 4036 | colorDepth:24 11:31:26 INFO - PROCESS | 4036 | Browser inner width/height: 1010/674 11:31:26 INFO - PROCESS | 4036 | __metrics 11:31:26 INFO - PROCESS | 4036 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:31:26 INFO - PROCESS | 4036 | console.error: 11:31:26 INFO - PROCESS | 4036 | Message: Error: Connection closed before committing the transaction. 11:31:26 INFO - PROCESS | 4036 | Stack: 11:31:26 INFO - PROCESS | 4036 | ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:933:23 11:31:26 INFO - PROCESS | 4036 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:812:7 11:31:26 INFO - PROCESS | 4036 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:743:11 11:31:26 INFO - PROCESS | 4036 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:775:7 11:31:26 INFO - PROCESS | 4036 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:710:7 11:31:26 INFO - PROCESS | 4036 | TaskImpl_run@resource://gre/modules/Task.jsm:320:13 11:31:26 INFO - PROCESS | 4036 | Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:529:9 11:31:26 INFO - PROCESS | 4036 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15 11:31:26 INFO - PROCESS | 4036 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:384:5 11:31:26 INFO - PROCESS | 4036 | nsAsyncShutdownClient.prototype.addBlocker/moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29 11:31:26 INFO - PROCESS | 4036 | Barrier/this.client.addBlocker/promisedromaeo_css: 6580.48 11:51:39 INFO - RETURN: kraken: 1623.60 11:51:39 INFO - RETURN: v8_7: 20405.04 11:51:39 INFO - javascript benchmark 11:51:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2952.1586347890857, 2968.035388498737, 2989.461896858566, 3001.189678786729, 3003.6245469316336, 5153.716545589996, 5227.764750586223, 5267.315249017632, 5328.120860058096, 5336.706481143536, 5118.9506151239, 5207.921881171786, 5254.842354729355, 5297.8940421191555, 5356.758945847437, 4443.178012067778, 4551.908961820778, 4607.700499467541, 4658.860234192971, 4668.719876807386, 4604.930926036112, 4641.93037104442, 4644.489106198333, 4646.6282697384295, 4650.046740418223, 4621.168189725848, 4639.860804175863, 4644.117617652652, 4658.208104622206, 4659.068186362724, 4546.454425468948, 4622.075584883003, 4631.490536041033, 4632.953670463319, 4668.439787225538, 4623.260278355447, 4686.7656617169005, 4688.343631891538, 4689.648276379251, 4703.482616912137, 4868.294097355899, 4945.802167913315, 4954.975225123887, 5082.898342033139, 5133.6919784813035, 5143.948560514385, 5236.21456781482, 5248.606354523426, 5265.736713164327, 5446.2647542582035, 5201.193814958688, 5260.710660913648, 5266.0, 5284.709340986283, 5288.312519372495, 4830.927536086997, 5125.82059627915, 5157.974210128926, 5204.505571970657, 5237.973810130963, 5382.273393091882, 5397.109476936262, 5447.945520544744, 5463.0, 5640.633358831663, 5071.554606937005, 5139.486051394831, 5154.871128221825, 5184.066867963727, 5225.451327610622, 5200.843974680765, 5290.365156181283, 5316.202569614511, 5354.973225133927, 5458.563314934796, 5160.638755287094, 5181.248718935809, 5183.974080129575, 5240.868978275497, 5255.868603284948, 5132.589392848563, 5188.273641690166, 5192.9740351298005, 5202.817901373433, 5297.152455607162, 3358.6809253121405, 3366.293078453552, 3564.7326450516316, 3600.3159399713973, 3602.7117830573493, 3058.892938747133, 3106.720395164446, 3149.4331020416544, 3178.7298079663487, 3306.6528014558608, 4961.578265847371, 5037.622178336639, 5056.0, 5057.418396884405, 5285.68285902847, 5261.500157485033, 5274.92087618686, 5309.840704778863, 5498.615096943176, 5611.326640803048, 5016.598672106223, 5018.222175562793, 5267.762950667229, 5340.572754179656, 5351.063563876306, 4183.6653067754505, 4189.162167566499, 4228.281192197333, 4349.673774466864, 4434.5122036576595, 5415.593830462731, 5570.749316280777, 5836.299644042742, 5923.348431672513, 5930.406959304035, 5324.414314425333, 5339.946600533945, 5517.200005999188, 5683.687397193194, 5695.0603150481365, 5531.391546929754, 5531.640443371168, 5539.642787517084, 5540.418256083053, 5696.316442026983, 5153.871153221199, 5217.191335343028, 5251.26482292487, 5260.868478288074, 5367.812126575551, 5213.6350455467755, 5349.0, 5356.410794812489, 5357.383900851452, 5391.622586418913, 5105.183170692671, 5201.895962080662, 5453.427390124139, 5454.154606036071, 5584.720763961867, 4895.216765317532, 5054.721990290569, 5062.544371006627, 5065.6322792844985, 5342.0, 4978.701277923336, 4981.178105612534, 5021.799128034838, 5080.517350851663, 5272.894542109213, 5073.695578265316, 5077.492250774893, 5086.872828179326, 5095.235714642833, 5375.489328513785, 5075.213341932006, 5088.643794934319, 5109.386873575195, 5115.130427827204, 5336.706481143419], "unit": "score", "name": "dojo.html", "value": 4903.7693395434835}, {"lowerIsBetter": false, "replicates": [485.26724645784867, 485.55329097230566, 495.7744226376999, 498.3670738162536, 501.641326451587, 25500.87249563752, 34341.65658343419, 36488.08779780507, 36491.0, 36545.269094618125, 36870.26259474809, 37048.0, 38966.415503767465, 39080.80459597698, 39386.80306598463, 7764.340031097364, 7872.606369681493, 7905.486143400689, 7913.0899946506315, 8218.63016164274, 7869.606519674022, 8005.959970200141, 8041.477303975252, 8477.872831907527, 8633.525156116411, 8239.340852731797, 8239.711610093647, 8285.62714677841, 8666.436681615707, 8721.912780872206, 8046.235607617267, 8137.291168854518, 8153.22544358285, 8175.63209655561, 8185.8362832743605, 8052.19478052196, 8181.936348274746, 8581.828363432696, 8700.390972631918, 8712.738617841474, 37033.444498332545, 38351.42472862909, 38431.61568384308, 38517.80741096305, 38651.8067409664, 2495.538325409787, 2839.346950201465, 3262.1029216965526, 3281.2289112058647, 3441.9483707744403, 27368.0, 27473.31316717078, 28049.29876753077, 28513.287167820763, 29295.707042929513, 3264.853081611333, 3463.515107884898, 3536.504889315498, 3578.3380074686265, 3696.8336424860677, 204843.0, 208185.0, 280904.19095808984, 285449.0, 305201.0, 44828.3275750864, 46265.0, 47426.0, 48325.275120873215, 48946.0, 48283.75858120757, 48301.033979320215, 48826.26760598594, 51271.48728512742, 51355.22967155496, 13138.27739474319, 13291.867081329063, 14189.85810141906, 14877.0, 15034.473793417177, 10779.299345542515, 10810.135189184846, 10836.729081773019, 10843.67468975932, 10871.782564348669, 16347.264373103239, 16572.0, 16866.578335541464, 17427.47717568475, 17458.56353591145, 6906.758263460755, 7367.557946523226, 7499.21258267885, 7630.236976302436, 7742.30319271257, 960.3565611040619, 990.3612170150212, 1006.2955930848435, 1026.9332493387906, 1033.8604288420968, 28329.71670283271, 28429.71570284312, 28493.57259641107, 28785.136445906657, 29230.853845730635, 1004.42747633848, 1021.6475316015963, 1045.8169820281573, 1097.7036200225893, 1172.513406936112, 13460.798088028687, 14836.293826209909, 14853.48012819546, 15020.849791502163, 15124.243787810565, 382692.0, 458202.0, 458582.0, 460699.0, 466277.0, 44663.33005004928, 44783.55216447859, 45013.32480012802, 45095.333793255224, 47431.76284118558, 1093.6117678224116, 1125.6679279612533, 1165.3648761425043, 1198.0, 1265.6519457149172, 27171.86414067917, 27270.590941135502, 27604.309892252855, 28584.285392865346, 28640.422361987523, 40260.0, 40394.59605403908, 42708.5729142717, 43142.78428607837, 43176.56823431725, 304897.0347816954, 308533.0, 319365.0, 334260.0, 339876.0, 28875.278118047216, 29085.127446176648, 29161.125166245045, 29288.26779330534, 29292.04557384811, 40488.79755601203, 40605.0, 40828.79585602053, 41188.38217426681, 41792.0, 33744.3251134971, 34849.30301393907, 35316.64683353133, 36629.0, 37486.0, 33273.66726332706, 33411.83294083514, 33833.98498045062, 33956.0, 34112.97661070172, 30984.915527956415, 31449.742010319333, 31600.73597056092, 31673.683263167994, 32099.0, 27922.72077279201, 29447.85276073606, 29636.407271854012, 30275.0, 31007.224819379695, 23918.402039949142, 24965.87517062403, 25357.87321063383, 25772.8711356442, 26582.86708566445], "unit": "score", "name": "ext.html", "value": 17381.39449424077}, {"lowerIsBetter": false, "replicates": [299.7901468971718, 299.8380874327863, 300.4966680809644, 303.49922627664364, 303.63715360144624, 12670.556530521433, 12908.354582270873, 15587.454439094634, 16175.272112754925, 16820.158992050394, 16019.679606407864, 16412.26144823483, 16702.0, 16863.325466981307, 17108.0, 5725.766950889157, 5760.222369980052, 5926.407359264061, 5969.820905372835, 5973.611715238496, 4250.9149817003645, 4403.361512580674, 5688.947544704222, 6345.333739957307, 6580.868382632369, 6378.872422551546, 6519.706613202417, 6561.147050883378, 6588.967055164718, 6925.342092501204, 6287.528435367343, 7023.7541686040995, 7031.0508081409125, 7031.964840175818, 7049.0, 4809.278608208761, 4850.951490485085, 5062.443131255559, 6607.438367738748, 6634.369734875179, 10642.893571064345, 10929.726756831064, 11250.15623828208, 11416.71458213543, 17053.317867285296, 1930.4112245765036, 1971.211515393854, 2093.8010888965523, 2236.798688118061, 2330.5804955108074, 8801.603927823264, 9008.1892629663, 9296.8605470918, 9316.301277404222, 11326.697429795515, 1704.7528108424333, 1734.1849330814498, 1738.1309345327336, 1783.8939857288435, 1806.8193180681958, 65635.3436465634, 66607.66696166489, 67596.0, 67887.0, 68879.65560172217, 8932.46405215689, 8974.37179397449, 9170.358074934691, 9201.0, 9320.161185493202, 11463.31220126795, 11497.195196336175, 11508.964193222482, 11531.76936461266, 11534.077273818075, 7177.066981292399, 7434.962825185839, 7527.360174385239, 7821.983142191592, 7834.764957051298, 7655.732049378245, 7791.259830316111, 8047.195280471906, 8116.715914943066, 8235.29999949999, 3502.2995400919917, 3660.3411385950253, 3725.8882233533036, 3744.475773391727, 3766.303233901737, 1482.7331080405631, 1528.8547587979124, 1531.2802982598162, 1586.3892401425303, 1590.514892957659, 360.43591778865994, 371.1722858026616, 373.3075145604918, 396.42320423783326, 874.2961915657829, 9118.726438206864, 9323.347365684336, 9363.204127649225, 9772.267079969031, 9987.500624968723, 395.7447446397058, 398.1698159337813, 398.42626617670464, 405.3575083492697, 414.22539850479194, 4979.850604481871, 5029.1953287473825, 5231.110711179109, 5377.0, 5417.945820541744, 319142.0, 324253.0, 325383.0, 325397.0, 326090.0, 50514.242286365734, 50617.74691126521, 68392.3160768386, 73062.63468682622, 75878.0, 1056.0284538224698, 1071.255477443185, 1078.428432930548, 1120.6581992492368, 1146.908247340211, 9113.726588202364, 9375.156235938799, 15262.923685381946, 15455.222649395013, 16174.67650646957, 39261.80369098136, 39834.0, 40983.18033639251, 41245.0, 43309.56690433181, 54490.0, 54674.453255466935, 54947.0, 54954.725226373615, 56597.0, 9833.655822046194, 10213.234007449322, 10387.324823886423, 10506.632267870587, 10929.289596176222, 6569.0, 7924.6433910473015, 7934.365250780039, 7950.443468957117, 8041.839163216586, 7080.716771329296, 7138.678759455941, 7205.819854503679, 7341.596212208166, 7417.03578534787, 6618.139641846529, 7047.541909775849, 7246.565206087652, 7326.791851372174, 7438.59087750179, 7081.645917704197, 7388.6675099621725, 7548.433867459853, 7554.924450755642, 7677.61611919413, 9733.0, 9958.55186516623, 9986.400815951067, 10411.479426028516, 10453.738656533647, 6921.48088893325, 7110.85778284421, 8122.0352524092, 10035.598576057168, 10235.948820255851], "unit": "score", "name": "jquery.html", "value": 7274.974204756465}, {"lowerIsBetter": false, "replicates": [1059.6873922192951, 1265.2218885385485, 1269.2701696524498, 1302.6092172348292, 1516.590520559449, 6487.610743355402, 6810.353016463434, 6851.0, 6917.896231556518, 6922.480813938956, 6816.863662726755, 7360.558366498014, 7378.151512576042, 7392.852142957137, 7393.223711510282, 1762.1013283225584, 1861.0973677766272, 1872.1201035513286, 2020.1818263603227, 2162.221600223926, 1688.5103320037235, 1959.519917620185, 1999.1004048178306, 2001.5296405344732, 2010.4672261850621, 1968.4488343263909, 1968.6062787442497, 1968.6259610673926, 1969.0, 2007.5884443689008, 1974.042589344167, 2004.859659823813, 2095.5180308529125, 2139.037433155079, 2143.3569929021232, 1930.2182616040527, 1934.0813113770987, 2103.7054812326287, 2105.463106907744, 2123.0870725587993, 7421.888671669929, 7431.256874312526, 7446.106467223968, 7461.253874612549, 7470.252974702541, 4479.977600111979, 4490.730556166641, 4510.0979804039325, 4670.252759558488, 4767.070421267854, 3091.8299493527848, 3114.9221269468217, 3138.7489000879873, 3177.3645270945904, 3333.583302087239, 1006.1447769396028, 1102.0, 1128.8476055732535, 1137.1528211482498, 1137.6302701622005, 9448.433094014312, 9872.90127098727, 10111.494425278706, 10126.139278161365, 10163.796724065478, 3944.7435916665327, 4123.195976784558, 4182.790860456965, 4202.138561594866, 4211.957880421157, 7819.218078192135, 8356.916430835736, 8611.39720219591, 8631.352648551383, 8632.136786321318, 4433.445819272591, 4721.173794585934, 4721.622270218374, 4730.550597693214, 4733.455652599926, 4089.0, 4115.0, 4261.339492378686, 4369.584889435562, 4390.121975604892, 3281.704646581819, 3322.983385083059, 3356.2112903467664, 3390.6100798408006, 3465.3069386122875, 938.2587755673078, 998.610541888664, 1004.1665417703434, 1026.2251999740297, 1079.8866119057543, 918.150710592699, 954.6706386296717, 980.2305190425624, 1000.0949141027381, 1002.7443002034435, 6128.724207410677, 6182.196314479179, 6524.347565243438, 6597.439217666456, 6608.933910660832, 988.357567581078, 999.48526508848, 1003.6437064841876, 1029.9691009269734, 1037.159900480613, 4962.181240095416, 5035.697858128524, 5065.138926382524, 5069.44236134025, 5102.132637451642, 8370.372222083368, 8562.143785621389, 8668.78328041804, 8675.913240867636, 9124.406913550598, 8460.661573537112, 8521.10528394522, 8526.701565445179, 8542.743717688354, 8592.398532102818, 6665.500087493458, 6715.764948226789, 6771.390574848188, 6787.2534021257625, 6879.449644028566, 6637.103990961352, 6682.9331706682315, 6693.732250709917, 6703.3296670332575, 6710.060591517094, 7940.444168908121, 8070.6368213431715, 8084.83830323402, 8090.555019473985, 8109.635066421907, 8275.668973241243, 8306.377021723274, 8312.002559692875, 8319.251267385964, 8331.95834020826, 6693.799186024427, 6810.182778066465, 6852.074969879002, 6852.931470685229, 6878.7248510059035, 7118.572885626879, 7197.496175267681, 7203.387712044535, 7208.207097219197, 7210.495265331377, 6622.569532980341, 6784.7964561063245, 6814.727410903508, 6848.7260509579055, 6899.896501552581, 5649.350324712711, 6240.968795155995, 6431.453326467115, 6587.374199451045, 6592.17597800275, 5765.625234359753, 5788.710564471844, 5794.971025144847, 6370.872582548416, 6451.0, 5688.203651488712, 5761.135829625589, 5940.524758019435, 5942.0, 5950.375210602824, 5667.688277144796, 5922.3485416605, 5952.404759524013, 6022.5784195105925, 6048.788292409745], "unit": "score", "name": "mootools.html", "value": 4146.359615742003}, {"lowerIsBetter": false, "replicates": [273.939733258683, 279.1207695758361, 279.6518334673331, 293.70335960679705, 299.0385909301595, 5864.0, 5896.675682837442, 6246.469050130744, 6279.309275979645, 6280.466160376368, 5651.5761317901115, 5751.338596061454, 5803.274590676166, 5841.62721760387, 5979.222701048858, 4235.131797981407, 4259.893502662435, 4262.87211383659, 4265.7440553566885, 4270.359446083097, 4310.159518893801, 4362.345648152786, 4406.096750166224, 4454.844080457185, 4523.163214805255, 4110.938335924963, 4358.3462480628, 4377.890552736191, 4387.956120438803, 4433.31283651033, 4204.306289462235, 4215.515215750197, 4242.278812601865, 4458.97770511147, 4483.282674772054, 3635.254772771602, 3646.5441819772527, 3653.3241350350004, 3654.104744337628, 3654.4335627977707, 5667.319921609392, 5678.886422271531, 5935.338105330471, 6057.545684073668, 6065.302490213638, 5317.069512835238, 5334.4398838122215, 5340.172273297645, 5345.4654534546235, 5348.224507446398, 6423.164988551505, 6544.9345506544805, 6545.67271636421, 6553.279139294674, 6564.868702625969, 4089.407035979766, 4093.5497095319492, 4105.67154627629, 4112.712110152261, 4318.568143185687, 6498.252700939358, 6521.771737989195, 6540.771073012469, 6765.255821859591, 6900.2064762551945, 4253.553376895444, 4403.471583410012, 4494.393256910341, 4496.820127194876, 4499.6400287976885, 4189.2040512302565, 4276.0, 4297.355396690521, 4301.698881078357, 4303.1608836277255, 4980.12847751642, 5001.949590586018, 5003.77483013258, 5007.574356179765, 5031.849044528597, 6172.814815555541, 6185.350538193425, 6187.3503282155625, 6218.595791273553, 6316.399942005502, 1522.9314680839389, 1524.0855486707887, 1593.0760159107922, 1605.9919700401424, 1614.4268784581304, 985.049427302642, 994.4033579852031, 996.566493575297, 1002.1982414068716, 1009.1976878381704, 5984.491318237911, 6335.524835637346, 6353.4599559038, 6363.459105976044, 6364.49084073273, 6388.169537960035, 6416.807495775134, 6778.7288508459105, 6785.694643741043, 6796.0, 5966.642001479925, 5974.970125149346, 5976.432238937294, 6002.609830361012, 6006.159137720722, 3270.5257737628385, 3341.365140623274, 3417.0773891049275, 3417.2482053948092, 3421.777584457052, 6552.115464412243, 7071.0, 7171.103612048494, 7181.640917954186, 7194.64026798658, 6908.896366554506, 6954.65226738661, 6962.895556566656, 6977.232504424509, 6978.616176110261, 6747.291534388818, 6761.492888033417, 6762.748891455097, 6794.524383293221, 7183.712651493882, 6413.679316034087, 6418.679066046772, 6422.839429014312, 6433.774817881352, 6520.18497687789, 6274.6548939808745, 6274.968625157027, 6276.309605943434, 6278.121063051268, 6281.309056003927, 6726.529142959946, 6732.461403087839, 6901.309869013058, 7167.964160179165, 7182.35358817688, 4345.196138714348, 4394.494633117232, 4507.977460112678, 4534.795934182904, 4546.636269098398, 6698.83252918681, 6849.623270720158, 6850.4862135341045, 6851.2121106071445, 6864.553804002724, 6274.592151510137, 6287.371262873859, 6557.311482294481, 6693.832654183684, 6699.095622090956, 6597.934020659732, 6616.569922954993, 6618.073469714148, 6628.734850606114, 6640.83397915056, 6090.390960903874, 6134.9079763804475, 6456.967715161394, 6458.580192287486, 6465.062565928009, 6177.382261773787, 6197.194364732556, 6197.907031394623, 6199.3490683477585, 6306.243250809932, 5978.163057172086, 5998.95018371792, 6079.604825686316, 6204.100405441276, 6403.29563747978], "unit": "score", "name": "prototype.html", "value": 4710.4005865147465}, {"lowerIsBetter": false, "replicates": [732.8973943647889, 768.047620950022, 782.9530228186309, 797.6809276289487, 798.484977189713, 14274.928625356884, 14416.423343066277, 14459.493917712882, 14468.348924298405, 14495.130292182477, 13052.825245727907, 13066.216027038385, 13098.541551045715, 13109.0, 13125.803112953314, 502.13632552010483, 505.9645824792266, 581.2995340614549, 620.3331418724878, 625.915501407311, 583.667309633509, 621.1304174156172, 624.8594066335061, 626.4643729611186, 627.6798832595387, 656.2027137028509, 656.7012009535674, 656.8620589676174, 657.4838751580011, 658.1575583253443, 524.1325606121856, 529.1375058654388, 640.4204195203348, 644.9806505804834, 648.6302807399784, 442.09370789880614, 452.2741000693872, 468.8898108944429, 469.3312030356728, 469.7416420968454, 12378.257304561756, 13138.080334376502, 13199.934000329937, 13208.207507549578, 13232.27222502762, 12275.93862030693, 13445.86554134456, 13572.796408053888, 13670.17978921268, 13833.930830345884, 11230.270032447865, 11963.820542691867, 12017.218880772809, 12103.818442723277, 12268.38658067102, 3602.621724718893, 3812.923741525182, 3866.1107945172766, 3912.628300311466, 3914.2367238388524, 55766.0, 56049.71975140139, 58792.94224702115, 59345.7032714838, 61347.69326153341, 9849.753756156153, 10371.51083739912, 10541.736456588647, 10543.261971662063, 10681.305715128492, 16858.494245172664, 17569.0, 17580.912095439697, 17589.472315830546, 17616.383426580007, 7911.643976021093, 8059.274665280153, 8062.879056814152, 8100.594970251582, 8349.29031032357, 4705.0, 4717.840485422876, 4725.078609671081, 4787.281907713871, 4838.854834354975, 3107.8290694011594, 3145.0564830550743, 3152.3537674776617, 3173.6826317368077, 3173.8889138880027, 561.3264083100296, 570.1049352516509, 579.715939189794, 608.5223099866583, 614.9877002459925, 636.1412093673596, 655.2857385449882, 662.4336192555392, 685.3934268172603, 804.8028233082932, 10852.806191318949, 11232.10143188543, 11425.885741142649, 11571.363575003455, 11625.302481851117, 685.5098604497808, 765.9846803063907, 784.4195295481303, 808.4906508899355, 808.8099296665279, 4603.677742558056, 4764.547368000034, 4777.4267087949665, 4829.6860704054125, 4981.626378021663, 68112.0, 68596.99552578278, 68644.0, 71976.64011680013, 72868.0, 59989.700051499465, 61684.0, 61708.38291617027, 61838.69080654568, 61997.0, 50123.49876501261, 50245.74877125591, 50873.98252034939, 54503.0, 57174.0, 10029.247806414694, 10071.395716257048, 10210.489475526343, 10333.638322658671, 10443.895561044292, 40327.59672403356, 41897.58102418937, 43644.34533482064, 44932.550674492835, 45809.77095114503, 52841.94316113733, 53157.0, 54333.0, 54631.0, 55862.0, 12344.3827808611, 12480.75038499243, 12505.874941250471, 12902.741945160857, 13019.0, 14775.482858099915, 14999.400023999355, 15247.31387087606, 15257.771133432785, 15510.534683959499, 12849.678758031125, 13233.80149297742, 13489.392977315849, 13725.656858578215, 13733.313334333043, 13037.934810325887, 13114.934425328194, 13556.59330220095, 13707.520236791665, 14171.0, 12958.157719748186, 13391.263480508665, 13958.930205348908, 14128.646783830487, 14355.641108971942, 10933.890661093288, 11049.558017679203, 11190.94404527972, 11249.71875703114, 12111.939440302742, 11575.0, 11607.013403860767, 11918.404079795802, 11961.760764784829, 12130.150889437655], "unit": "score", "name": "yui.html", "value": 6704.037415987911}], "name": "dromaeo_css", "value": 6580.482216409036}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [96.0, 88.0, 101.0, 97.0, 98.0, 103.0, 104.0, 103.0, 102.0, 111.0], "unit": "score", "name": "ai-astar", "value": 100.3}, {"lowerIsBetter": true, "replicates": [138.0, 140.0, 160.0, 162.0, 137.0, 136.0, 171.0, 136.0, 164.0, 143.0], "unit": "score", "name": "audio-beat-detection", "value": 148.7}, {"lowerIsBetter": true, "replicates": [176.0, 178.0, 176.0, 178.0, 161.0, 157.0, 154.0, 163.0, 156.0, 167.0], "unit": "score", "name": "audio-dft", "value": 166.6}, {"lowerIsBetter": true, "replicates": [111.0, 85.0, 80.0, 111.0, 84.0, 84.0, 83.0, 80.0, 130.0, 79.0], "unit": "score", "name": "audio-fft", "value": 92.7}, {"lowerIsBetter": true, "replicates": [103.0, 99.0, 136.0, 93.0, 99.0, 100.0, 145.0, 92.0, 98.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 110.2}, {"lowerIsBetter": true, "replicates": [116.0, 116.0, 116.0, 117.0, 117.0, 123.0, 116.0, 117.0, 116.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.1}, {"lowerIsBetter": true, "replicates": [139.0, 141.0, 139.0, 139.0, 139.0, 139.0, 139.0, 139.0, 139.0, 139.0], "unit": "score", "name": "imaging-darkroom", "value": 139.2}, {"lowerIsBetter": true, "replicates": [108.0, 103.0, 107.0, 103.0, 109.0, 104.0, 101.0, 102.0, 107.0, 109.0], "unit": "score", "name": "imaging-desaturate", "value": 105.3}, {"lowerIsBetter": true, "replicates": [80.0, 80.0, 80.0, 82.0, 81.0, 80.0, 81.0, 75.0, 79.0, 90.0], "unit": "score", "name": "json-parse-financial", "value": 80.8}, {"lowerIsBetter": true, "replicates": [86.0, 86.0, 86.0, 84.0, 88.0, 87.0, 86.0, 88.0, 88.0, 88.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 86.7}, {"lowerIsBetter": true, "replicates": [89.0, 91.0, 96.0, 92.0, 90.0, 93.0, 90.0, 91.0, 91.0, 96.0], "unit": "score", "name": "stanford-crypto-aes", "value": 91.9}, {"lowerIsBetter": true, "replicates": [115.0, 117.0, 117.0, 122.0, 120.0, 112.0, 115.0, 114.0, 115.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.2}, {"lowerIsBetter": true, "replicates": [179.0, 189.0, 189.0, 179.0, 178.0, 178.0, 186.0, 179.0, 179.0, 196.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 183.2}, {"lowerIsBetter": true, "replicates": [82.0, 88.0, 88.0, 83.0, 82.0, 81.0, 83.0, 88.0, 88.0, 84.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 84.7}], "name": "kraken", "value": 1623.6000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [152.7417137620284], "unit": "score", "name": "Richards", "value": 231.12219399999995}, {"lowerIsBetter": false, "replicates": [192.10879141926833], "unit": "score", "name": "DeltaBlue", "value": 344.16956929212364}, {"lowerIsBetter": false, "replicates": [306.09121518212424], "unit": "score", "name": "Encrypt", "value": 869.6133270000004}, {"lowerIsBetter": false, "replicates": [6103.658536585366], "unit": "score", "name": "Decrypt", "value": 43.61007392607391}, {"lowerIsBetter": false, "replicates": [984.2519685039371], "unit": "score", "name": "RayTrace", "value": 751.8288240000002}, {"lowerIsBetter": false, "replicates": [622.2775357809583], "unit": "score", "name": "Earley", "value": 1071.0060409999996}, {"lowerIsBetter": false, "replicates": [10020.0], "unit": "score", "name": "Boyer", "value": 66.51327345309382}, {"lowerIsBetter": false, "replicates": [45377.77777777778], "unit": "score", "name": "RegExp", "value": 20.075575416258577}, {"lowerIsBetter": false, "replicates": [610.0362756952842], "unit": "score", "name": "Splay", "value": 133.58385926660063}, {"lowerIsBetter": false, "replicates": [5451.086956521739], "unit": "score", "name": "NavierStokes", "value": 272.23928215353936}], "name": "v8_7", "value": 20405.037188888065}]} 11:51:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,25]]", "result": "20405.04"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,25]]", "result": "1623.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,25]]", "result": "6580.48"}}} 11:51:39 INFO - Return code: 0 11:51:40 INFO - Validating PERFHERDER_DATA against C:\slave\test-pgo\build\tests\talos\treeherder-schemas\performance-artifact.json 11:51:40 INFO - # TBPL SUCCESS # 11:51:40 INFO - Running post-action listener: _resource_record_post_action 11:51:40 INFO - Running post-run listener: _resource_record_post_run 11:51:41 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 106386432; Write bytes: 414065664; Read time: 2645260; Write time: 4422390 11:51:41 INFO - install - Wall time: 2s; CPU: 13.0%; Read bytes: 2498560; Write bytes: 20480; Read time: 38610; Write time: 90 11:51:41 INFO - run-tests - Wall time: 1228s; CPU: 13.0%; Read bytes: 103887872; Write bytes: 388973568; Read time: 2606650; Write time: 4371500 11:51:41 INFO - Running post-run listener: _upload_blobber_files 11:51:41 INFO - Blob upload gear active. 11:51:41 INFO - Preparing to upload files from C:\slave\test-pgo\build\blobber_upload_dir. 11:51:41 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 11:51:41 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-Aurora', '-d', 'C:\\slave\\test-pgo\\build\\blobber_upload_dir', '--output-manifest', 'C:\\slave\\test-pgo\\build\\uploaded_files.json'] 11:51:41 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-Aurora -d C:\slave\test-pgo\build\blobber_upload_dir --output-manifest C:\slave\test-pgo\build\uploaded_files.json 11:51:41 INFO - (blobuploader) - INFO - Open directory for files ... 11:51:41 INFO - (blobuploader) - INFO - Uploading C:\slave\test-pgo\build\blobber_upload_dir\dromaeojs_errorsummary.log ... 11:51:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:51:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:51:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:51:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:51:42 INFO - (blobuploader) - INFO - Done attempting. 11:51:42 INFO - (blobuploader) - INFO - Uploading C:\slave\test-pgo\build\blobber_upload_dir\dromaeojs_raw.log ... 11:51:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:51:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:51:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:51:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:51:43 INFO - (blobuploader) - INFO - Done attempting. 11:51:43 INFO - (blobuploader) - INFO - Iteration through files over. 11:51:43 INFO - Return code: 0 11:51:43 INFO - rmtree: C:\slave\test-pgo\build\uploaded_files.json 11:51:43 INFO - Using _rmtree_windows ... 11:51:43 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test-pgo\\build\\uploaded_files.json',), kwargs: {}, attempt #1 11:51:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3ce184ca5f0790f6cc9bdb490417bb311f6962e70e6e68c1a792659b95342e349261e6fb1c98782a1020df5d824bcfef8d4e5e6c7e3e8396b45a286dd11719f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d71d46d2a951d89cd77c5d3577b067734cf7221fd4db48f3f7f1779c444463be4724d34723d525de46fcf707386282f572b8e46ae67f1b505a9dc52615319188"} 11:51:43 INFO - Writing buildbot properties ['blobber_files'] to C:\slave\test-pgo\properties\blobber_files 11:51:43 INFO - Writing to file C:\slave\test-pgo\properties\blobber_files 11:51:43 INFO - Contents: 11:51:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3ce184ca5f0790f6cc9bdb490417bb311f6962e70e6e68c1a792659b95342e349261e6fb1c98782a1020df5d824bcfef8d4e5e6c7e3e8396b45a286dd11719f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d71d46d2a951d89cd77c5d3577b067734cf7221fd4db48f3f7f1779c444463be4724d34723d525de46fcf707386282f572b8e46ae67f1b505a9dc52615319188"} 11:51:43 INFO - Running post-run listener: copy_logs_to_upload_dir 11:51:43 INFO - Copying logs to upload dir... 11:51:43 INFO - mkdir: C:\slave\test-pgo\build\upload\logs 11:51:43 INFO - Copying logs to upload dir... 11:51:43 INFO - Using _rmtree_windows ... 11:51:43 INFO - Using _rmtree_windows ... 11:51:43 INFO - Using _rmtree_windows ... 11:51:43 INFO - Using _rmtree_windows ... 11:51:43 INFO - Using _rmtree_windows ... 11:51:43 INFO - Using _rmtree_windows ... 11:51:43 INFO - Using _rmtree_windows ... program finished with exit code 0 elapsedTime=1514.143000 ========= master_lag: -0.47 ========= ========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 25 mins, 13 secs) (at 2016-03-04 11:51:43.566990) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-04 11:51:43.567836) ========= '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\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files\Common Files COMPUTERNAME=T-W732-IX-227 COMSPEC=C:\windows\system32\cmd.exe CYGWINBASE=C:\cygwin DCLOCATION=SCL3 DNSSUFFIX=wintest.releng.scl3.mozilla.com FP_NO_HOST_CHECK=NO HOMEDRIVE=C: HOMEPATH=\Users\cltbld KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld\AppData\Local LOGONSERVER=\\T-W732-IX-227 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:\Python24;C:\Python24\Scripts;C:\cygwin\bin;C:\WINDOWS\System32;C:\program files\gnuwin32\bin;C:\WINDOWS;C:\mozilla-build\msys\bin;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\info-zip;C:\mozilla-build\wget;C:\Program Files (x86)\GnuWin32\bin; PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_IDENTIFIER=x86 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=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\AppData\Local\Temp TEST1=testie TMP=C:\Users\cltbld\AppData\Local\Temp USERDOMAIN=T-W732-IX-227 USERNAME=cltbld USERPROFILE=C:\Users\cltbld WINDIR=C:\windows WINDOWS_TRACING_FLAGS=3 WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log XPCOM_DEBUG_BREAK=warn using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3ce184ca5f0790f6cc9bdb490417bb311f6962e70e6e68c1a792659b95342e349261e6fb1c98782a1020df5d824bcfef8d4e5e6c7e3e8396b45a286dd11719f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d71d46d2a951d89cd77c5d3577b067734cf7221fd4db48f3f7f1779c444463be4724d34723d525de46fcf707386282f572b8e46ae67f1b505a9dc52615319188"} build_url:https://queue.taskcluster.net/v1/task/fG94VsYRRR6S08JOLOkocQ/artifacts/public/build/firefox-46.0a2.en-US.win32.zip program finished with exit code 0 elapsedTime=0.101000 build_url: 'https://queue.taskcluster.net/v1/task/fG94VsYRRR6S08JOLOkocQ/artifacts/public/build/firefox-46.0a2.en-US.win32.zip' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3ce184ca5f0790f6cc9bdb490417bb311f6962e70e6e68c1a792659b95342e349261e6fb1c98782a1020df5d824bcfef8d4e5e6c7e3e8396b45a286dd11719f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d71d46d2a951d89cd77c5d3577b067734cf7221fd4db48f3f7f1779c444463be4724d34723d525de46fcf707386282f572b8e46ae67f1b505a9dc52615319188"}' ========= master_lag: 0.80 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-04 11:51:44.472298) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 11:51:44.472682) ========= '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\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files\Common Files COMPUTERNAME=T-W732-IX-227 COMSPEC=C:\windows\system32\cmd.exe CYGWINBASE=C:\cygwin DCLOCATION=SCL3 DNSSUFFIX=wintest.releng.scl3.mozilla.com FP_NO_HOST_CHECK=NO HOMEDRIVE=C: HOMEPATH=\Users\cltbld KTS_HOME=C:\Program Files\KTS KTS_VERSION=1.19c LOCALAPPDATA=C:\Users\cltbld\AppData\Local LOGONSERVER=\\T-W732-IX-227 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:\Python24;C:\Python24\Scripts;C:\cygwin\bin;C:\WINDOWS\System32;C:\program files\gnuwin32\bin;C:\WINDOWS;C:\mozilla-build\msys\bin;C:\mozilla-build\python27;C:\mozilla-build\python27\Scripts;C:\mozilla-build\info-zip;C:\mozilla-build\wget;C:\Program Files (x86)\GnuWin32\bin; PATHEXT=.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE=x86 PROCESSOR_IDENTIFIER=x86 Family 6 Model 30 Stepping 5, GenuineIntel PROCESSOR_LEVEL=6 PROCESSOR_REVISION=1e05 PROGRAMDATA=C:\ProgramData PROGRAMFILES=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\AppData\Local\Temp TEST1=testie TMP=C:\Users\cltbld\AppData\Local\Temp USERDOMAIN=T-W732-IX-227 USERNAME=cltbld USERPROFILE=C:\Users\cltbld WINDIR=C:\windows WINDOWS_TRACING_FLAGS=3 WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=0.101000 ========= master_lag: 0.03 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 11:51:44.601949) ========= ========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-03-04 11:51:44.602573) ========= ========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2016-03-04 11:51:45.272615) ========= ========= Total master_lag: 0.57 =========