builder: b2g-inbound_win7-ix_test-dromaeojs-pgo slave: t-w732-ix-088 starttime: 1445696815.29 results: success (0) buildid: 20151024023017 builduid: 245949bcd72d4f25ad38e190dca56a36 revision: e76e31d7414b027b54603f9cf6b793b7c32e2dfe ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-24 07:26:55.288340) ========= master: http://buildbot-master109.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-24 07:26:55.288857) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-24 07:26:55.289192) ========= '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-088 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-088 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-088 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.566000 basedir: 'C:\\slave\\test-pgo' ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-24 07:26:56.097257) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-24 07:26:56.097636) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-24 07:26:56.511933) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-24 07:26:56.512307) ========= '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-088 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-088 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-088 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.500000 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-24 07:26:57.209619) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-24 07:26:57.210395) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-24 07:26:57.210782) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-24 07:26:57.211119) ========= '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-088 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-088 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-088 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 --07:26:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py => `archiver_client.py' Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12,141 (12K) [text/x-python] 0K .......... . 100% 2.27 GB/s 07:26:57 (2.27 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.774000 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-24 07:26:58.091803) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 10 secs) (at 2015-10-24 07:26:58.092127) ========= '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-088 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-088 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-088 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=10.302000 ========= Finished 'rm -rf ...' (results: 0, elapsed: 10 secs) (at 2015-10-24 07:27:08.558337) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-10-24 07:27:08.558757) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev e76e31d7414b027b54603f9cf6b793b7c32e2dfe --destination scripts --debug' in dir C:\slave\test-pgo\. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev e76e31d7414b027b54603f9cf6b793b7c32e2dfe --destination scripts --debug'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files\Common Files COMPUTERNAME=T-W732-IX-088 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-088 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-088 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 2015-10-24 07:27:08,854 truncating revision to first 12 chars 2015-10-24 07:27:08,854 Setting DEBUG logging. 2015-10-24 07:27:08,854 attempt 1/10 2015-10-24 07:27:08,854 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/e76e31d7414b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-10-24 07:27:09,782 unpacking tar archive at: b2g-inbound-e76e31d7414b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.583000 ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-10-24 07:27:10.195100) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-24 07:27:10.195502) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-24 07:27:10.214140) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-24 07:27:10.214480) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-24 07:27:10.214947) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 24 mins, 47 secs) (at 2015-10-24 07:27:10.215293) ========= 'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'dromaeojs' '--add-option' '--webServer,localhost' '--branch-name' 'B2G-Inbound' '--system-bits' '32' '--cfg' 'talos/windows_config.py' '--download-symbols' 'ondemand' '--use-talos-json' '--blob-upload-branch' 'B2G-Inbound' in dir C:\slave\test-pgo\. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['c:/mozilla-build/python27/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--system-bits', '32', '--cfg', 'talos/windows_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files\Common Files COMPUTERNAME=T-W732-IX-088 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-088 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-088 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 07:27:10 INFO - MultiFileLogger online at 20151024 07:27:10 in C:\slave\test-pgo 07:27:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 32 --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 07:27:10 INFO - Dumping config to C:\slave\test-pgo\logs\localconfig.json. 07:27:10 INFO - {'append_to_log': False, 07:27:10 INFO - 'base_work_dir': 'C:\\slave\\test-pgo', 07:27:10 INFO - 'blob_upload_branch': 'B2G-Inbound', 07:27:10 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test-pgo\\oauth.txt', 07:27:10 INFO - 'branch': 'B2G-Inbound', 07:27:10 INFO - 'buildbot_json_path': 'buildprops.json', 07:27:10 INFO - 'config_files': ('talos/windows_config.py',), 07:27:10 INFO - 'default_actions': ('clobber', 07:27:10 INFO - 'read-buildbot-config', 07:27:10 INFO - 'download-and-extract', 07:27:10 INFO - 'populate-webroot', 07:27:10 INFO - 'create-virtualenv', 07:27:10 INFO - 'install', 07:27:10 INFO - 'run-tests'), 07:27:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:27:10 INFO - 'download_minidump_stackwalk': True, 07:27:10 INFO - 'download_symbols': 'ondemand', 07:27:10 INFO - 'exes': {'easy_install': ('C:\\slave\\test-pgo\\build/venv/scripts/python', 07:27:10 INFO - 'C:\\slave\\test-pgo\\build/venv/scripts/easy_install-2.7-script.py'), 07:27:10 INFO - 'hg': 'c:/mozilla-build/hg/hg', 07:27:10 INFO - 'mozinstall': ('C:\\slave\\test-pgo\\build/venv/scripts/python', 07:27:10 INFO - 'C:\\slave\\test-pgo\\build/venv/scripts/mozinstall-script.py'), 07:27:10 INFO - 'python': 'c:/mozilla-build/python27/python.exe', 07:27:10 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe', 07:27:10 INFO - 'C:/mozilla-build/tooltool.py'), 07:27:10 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe', 07:27:10 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 07:27:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:27:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:27:10 INFO - 'installer_path': 'installer.exe', 07:27:10 INFO - 'log_level': 'info', 07:27:10 INFO - 'log_name': 'talos', 07:27:10 INFO - 'log_to_console': True, 07:27:10 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe', 07:27:10 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe', 07:27:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest', 07:27:10 INFO - 'opt_config_files': (), 07:27:10 INFO - 'pip_index': False, 07:27:10 INFO - 'sps_profile': False, 07:27:10 INFO - 'sps_profile_interval': 0, 07:27:10 INFO - 'suite': 'dromaeojs', 07:27:10 INFO - 'system_bits': '32', 07:27:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:27:10 INFO - 'title': 'T-W732-IX-088', 07:27:10 INFO - 'use_talos_json': True, 07:27:10 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'), 07:27:10 INFO - 'virtualenv_path': 'C:\\slave\\test-pgo\\build/venv', 07:27:10 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll', 07:27:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:27:10 INFO - 'work_dir': 'build'} 07:27:10 INFO - ##### 07:27:10 INFO - ##### Running clobber step. 07:27:10 INFO - ##### 07:27:10 INFO - Running pre-action listener: _resource_record_pre_action 07:27:10 INFO - Running main action method: clobber 07:27:10 INFO - rmtree: C:\slave\test-pgo\build 07:27:10 INFO - Using _rmtree_windows ... 07:27:10 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test-pgo\\build',), kwargs: {}, attempt #1 07:29:43 INFO - Running post-action listener: _resource_record_post_action 07:29:43 INFO - ##### 07:29:43 INFO - ##### Running read-buildbot-config step. 07:29:43 INFO - ##### 07:29:43 INFO - Running pre-action listener: _resource_record_pre_action 07:29:43 INFO - Running main action method: read_buildbot_config 07:29:43 INFO - Using buildbot properties: 07:29:43 INFO - { 07:29:44 INFO - "properties": { 07:29:44 INFO - "buildnumber": 303, 07:29:44 INFO - "product": "firefox", 07:29:44 INFO - "script_repo_revision": "production", 07:29:44 INFO - "builddir": "b2g-inbound_win7-ix_test-dromaeojs", 07:29:44 INFO - "repository": "", 07:29:44 INFO - "buildername": "Windows 7 32-bit b2g-inbound pgo talos dromaeojs", 07:29:44 INFO - "buildid": "20151024023017", 07:29:44 INFO - "slavename": "t-w732-ix-088", 07:29:44 INFO - "pgo_build": "True", 07:29:44 INFO - "basedir": "C:\\slave\\test-pgo", 07:29:44 INFO - "project": "", 07:29:44 INFO - "platform": "win7-ix", 07:29:44 INFO - "master": "http://buildbot-master109.bb.releng.scl3.mozilla.com:8201/", 07:29:44 INFO - "slavebuilddir": "test", 07:29:44 INFO - "scheduler": "tests-b2g-inbound-win32-pgo-talos", 07:29:44 INFO - "branch": "b2g-inbound", 07:29:44 INFO - "repo_path": "integration/b2g-inbound", 07:29:44 INFO - "stage_platform": "win32-pgo", 07:29:44 INFO - "builduid": "245949bcd72d4f25ad38e190dca56a36", 07:29:44 INFO - "revision": "e76e31d7414b027b54603f9cf6b793b7c32e2dfe" 07:29:44 INFO - }, 07:29:44 INFO - "sourcestamp": { 07:29:44 INFO - "repository": "", 07:29:44 INFO - "hasPatch": false, 07:29:44 INFO - "project": "", 07:29:44 INFO - "branch": "b2g-inbound-win32-pgo-talos", 07:29:44 INFO - "changes": [ 07:29:44 INFO - { 07:29:44 INFO - "category": null, 07:29:44 INFO - "files": [ 07:29:44 INFO - { 07:29:44 INFO - "url": null, 07:29:44 INFO - "name": "https://queue.taskcluster.net/v1/task/kOaQf_hKTbu_Wh4SWoY5NA/artifacts/public/build/firefox-44.0a1.en-US.win32.zip" 07:29:44 INFO - } 07:29:44 INFO - ], 07:29:44 INFO - "repository": "", 07:29:44 INFO - "rev": "e76e31d7414b027b54603f9cf6b793b7c32e2dfe", 07:29:44 INFO - "who": "sendchange", 07:29:44 INFO - "when": 1445696760, 07:29:44 INFO - "number": 6570215, 07:29:44 INFO - "comments": "", 07:29:44 INFO - "project": "", 07:29:44 INFO - "at": "Sat 24 Oct 2015 07:26:00", 07:29:44 INFO - "branch": "b2g-inbound-win32-pgo-talos", 07:29:44 INFO - "revlink": "", 07:29:44 INFO - "properties": [ 07:29:44 INFO - [ 07:29:44 INFO - "buildid", 07:29:44 INFO - "20151024023017", 07:29:44 INFO - "Change" 07:29:44 INFO - ], 07:29:44 INFO - [ 07:29:44 INFO - "builduid", 07:29:44 INFO - "245949bcd72d4f25ad38e190dca56a36", 07:29:44 INFO - "Change" 07:29:44 INFO - ], 07:29:44 INFO - [ 07:29:44 INFO - "pgo_build", 07:29:44 INFO - "True", 07:29:44 INFO - "Change" 07:29:44 INFO - ] 07:29:44 INFO - ], 07:29:44 INFO - "revision": "e76e31d7414b027b54603f9cf6b793b7c32e2dfe" 07:29:44 INFO - } 07:29:44 INFO - ], 07:29:44 INFO - "revision": "e76e31d7414b027b54603f9cf6b793b7c32e2dfe" 07:29:44 INFO - } 07:29:44 INFO - } 07:29:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/kOaQf_hKTbu_Wh4SWoY5NA/artifacts/public/build/firefox-44.0a1.en-US.win32.zip. 07:29:44 INFO - Running post-action listener: _resource_record_post_action 07:29:44 INFO - ##### 07:29:44 INFO - ##### Running download-and-extract step. 07:29:44 INFO - ##### 07:29:44 INFO - Running pre-action listener: _resource_record_pre_action 07:29:44 INFO - Running main action method: download_and_extract 07:29:44 INFO - mkdir: C:\slave\test-pgo\build\tests 07:29:44 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')]} 07:29:44 INFO - https://queue.taskcluster.net/v1/task/kOaQf_hKTbu_Wh4SWoY5NA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:29:44 INFO - trying https://queue.taskcluster.net/v1/task/kOaQf_hKTbu_Wh4SWoY5NA/artifacts/public/build/test_packages.json 07:29:44 INFO - Downloading https://queue.taskcluster.net/v1/task/kOaQf_hKTbu_Wh4SWoY5NA/artifacts/public/build/test_packages.json to C:\slave\test-pgo\build\test_packages.json 07:29:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/kOaQf_hKTbu_Wh4SWoY5NA/artifacts/public/build/test_packages.json', 'file_name': 'C:\\slave\\test-pgo\\build\\test_packages.json'}, attempt #1 07:29:45 INFO - Downloaded 1221 bytes. 07:29:45 INFO - Reading from file C:\slave\test-pgo\build\test_packages.json 07:29:45 INFO - Using the following test package requirements: 07:29:45 INFO - {u'common': [u'firefox-44.0a1.en-US.win32.common.tests.zip'], 07:29:45 INFO - u'cppunittest': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 07:29:45 INFO - u'firefox-44.0a1.en-US.win32.cppunittest.tests.zip'], 07:29:45 INFO - u'jittest': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 07:29:45 INFO - u'jsshell-win32.zip'], 07:29:45 INFO - u'mochitest': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 07:29:45 INFO - u'firefox-44.0a1.en-US.win32.mochitest.tests.zip'], 07:29:45 INFO - u'mozbase': [u'firefox-44.0a1.en-US.win32.common.tests.zip'], 07:29:45 INFO - u'reftest': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 07:29:45 INFO - u'firefox-44.0a1.en-US.win32.reftest.tests.zip'], 07:29:45 INFO - u'talos': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 07:29:45 INFO - u'firefox-44.0a1.en-US.win32.talos.tests.zip'], 07:29:45 INFO - u'web-platform': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 07:29:45 INFO - u'firefox-44.0a1.en-US.win32.web-platform.tests.zip'], 07:29:45 INFO - u'webapprt': [u'firefox-44.0a1.en-US.win32.common.tests.zip'], 07:29:45 INFO - u'xpcshell': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 07:29:45 INFO - u'firefox-44.0a1.en-US.win32.xpcshell.tests.zip']} 07:29:45 INFO - Downloading packages: [u'firefox-44.0a1.en-US.win32.common.tests.zip'] for test suite category: common 07: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')]} 07:29:45 INFO - https://queue.taskcluster.net/v1/task/kOaQf_hKTbu_Wh4SWoY5NA/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip matches https://queue.taskcluster.net 07:29:45 INFO - trying https://queue.taskcluster.net/v1/task/kOaQf_hKTbu_Wh4SWoY5NA/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip 07:29:45 INFO - Downloading https://queue.taskcluster.net/v1/task/kOaQf_hKTbu_Wh4SWoY5NA/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip to C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.common.tests.zip 07:29:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/kOaQf_hKTbu_Wh4SWoY5NA/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip', 'file_name': u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win32.common.tests.zip'}, attempt #1 07:29:47 INFO - Downloaded 18011067 bytes. 07:29:47 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win32.common.tests.zip'] in C:\slave\test-pgo\build\tests 07:29:47 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.common.tests.zip 07:29:47 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win32.common.tests.zip'] with output_timeout 1760 07:30:16 INFO - Return code: 0 07:30:16 INFO - Downloading packages: [u'firefox-44.0a1.en-US.win32.common.tests.zip', u'firefox-44.0a1.en-US.win32.talos.tests.zip'] for test suite category: talos 07:30:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:30:16 INFO - https://queue.taskcluster.net/v1/task/kOaQf_hKTbu_Wh4SWoY5NA/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip matches https://queue.taskcluster.net 07:30:16 INFO - trying https://queue.taskcluster.net/v1/task/kOaQf_hKTbu_Wh4SWoY5NA/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip 07:30:16 INFO - Downloading https://queue.taskcluster.net/v1/task/kOaQf_hKTbu_Wh4SWoY5NA/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip to C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.common.tests.zip 07:30:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/kOaQf_hKTbu_Wh4SWoY5NA/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip', 'file_name': u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win32.common.tests.zip'}, attempt #1 07:30:18 INFO - Downloaded 18011067 bytes. 07:30:18 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win32.common.tests.zip'] in C:\slave\test-pgo\build\tests 07:30:18 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.common.tests.zip 07:30:18 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win32.common.tests.zip'] with output_timeout 1760 07:30:40 INFO - Return code: 0 07: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')]} 07:30:40 INFO - https://queue.taskcluster.net/v1/task/kOaQf_hKTbu_Wh4SWoY5NA/artifacts/public/build/firefox-44.0a1.en-US.win32.talos.tests.zip matches https://queue.taskcluster.net 07:30:40 INFO - trying https://queue.taskcluster.net/v1/task/kOaQf_hKTbu_Wh4SWoY5NA/artifacts/public/build/firefox-44.0a1.en-US.win32.talos.tests.zip 07:30:40 INFO - Downloading https://queue.taskcluster.net/v1/task/kOaQf_hKTbu_Wh4SWoY5NA/artifacts/public/build/firefox-44.0a1.en-US.win32.talos.tests.zip to C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.talos.tests.zip 07:30:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/kOaQf_hKTbu_Wh4SWoY5NA/artifacts/public/build/firefox-44.0a1.en-US.win32.talos.tests.zip', 'file_name': u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win32.talos.tests.zip'}, attempt #1 07:30:43 INFO - Downloaded 11131307 bytes. 07:30:43 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win32.talos.tests.zip'] in C:\slave\test-pgo\build\tests 07:30:43 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.talos.tests.zip 07:30:43 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win32.talos.tests.zip'] with output_timeout 1760 07:30:47 INFO - Return code: 0 07:30:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:30:47 INFO - https://queue.taskcluster.net/v1/task/kOaQf_hKTbu_Wh4SWoY5NA/artifacts/public/build/firefox-44.0a1.en-US.win32.zip matches https://queue.taskcluster.net 07:30:47 INFO - trying https://queue.taskcluster.net/v1/task/kOaQf_hKTbu_Wh4SWoY5NA/artifacts/public/build/firefox-44.0a1.en-US.win32.zip 07:30:47 INFO - Downloading https://queue.taskcluster.net/v1/task/kOaQf_hKTbu_Wh4SWoY5NA/artifacts/public/build/firefox-44.0a1.en-US.win32.zip to C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.zip 07:30:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/kOaQf_hKTbu_Wh4SWoY5NA/artifacts/public/build/firefox-44.0a1.en-US.win32.zip', 'file_name': 'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win32.zip'}, attempt #1 07:30:51 INFO - Downloaded 53273577 bytes. 07:30:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/kOaQf_hKTbu_Wh4SWoY5NA/artifacts/public/build/firefox-44.0a1.en-US.win32.zip 07:30:51 INFO - mkdir: C:\slave\test-pgo\properties 07:30:51 INFO - Writing buildbot properties ['build_url'] to C:\slave\test-pgo\properties\build_url 07:30:51 INFO - Writing to file C:\slave\test-pgo\properties\build_url 07:30:51 INFO - Contents: 07:30:51 INFO - build_url:https://queue.taskcluster.net/v1/task/kOaQf_hKTbu_Wh4SWoY5NA/artifacts/public/build/firefox-44.0a1.en-US.win32.zip 07:30:51 INFO - Running post-action listener: _resource_record_post_action 07:30:51 INFO - Running post-action listener: set_extra_try_arguments 07:30:51 INFO - ##### 07:30:51 INFO - ##### Running populate-webroot step. 07:30:51 INFO - ##### 07:30:51 INFO - Running pre-action listener: _resource_record_pre_action 07:30:51 INFO - Running main action method: populate_webroot 07:30:51 INFO - Guessing talos json url... 07:30:51 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')]} 07:30:51 INFO - https://queue.taskcluster.net/v1/task/kOaQf_hKTbu_Wh4SWoY5NA/artifacts/public/build/firefox-44.0a1.en-US.win32.txt matches https://queue.taskcluster.net 07:30:51 INFO - trying https://queue.taskcluster.net/v1/task/kOaQf_hKTbu_Wh4SWoY5NA/artifacts/public/build/firefox-44.0a1.en-US.win32.txt 07:30:51 INFO - Downloading https://queue.taskcluster.net/v1/task/kOaQf_hKTbu_Wh4SWoY5NA/artifacts/public/build/firefox-44.0a1.en-US.win32.txt to C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.txt 07:30:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/kOaQf_hKTbu_Wh4SWoY5NA/artifacts/public/build/firefox-44.0a1.en-US.win32.txt', 'file_name': 'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win32.txt'}, attempt #1 07:30:52 INFO - Downloaded 107 bytes. 07:30:52 INFO - Reading from file C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.txt 07:30:52 INFO - Contents: 07:30:52 INFO - 20151024023017 07:30:52 INFO - https://hg.mozilla.org/integration/b2g-inbound/rev/e76e31d7414b027b54603f9cf6b793b7c32e2dfe 07:30:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:30:52 INFO - trying https://hg.mozilla.org/integration/b2g-inbound/raw-file/e76e31d741/testing/talos/talos.json 07:30:52 INFO - Downloading https://hg.mozilla.org/integration/b2g-inbound/raw-file/e76e31d741/testing/talos/talos.json to C:\slave\test-pgo\build\talos.json 07:30:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/b2g-inbound/raw-file/e76e31d741/testing/talos/talos.json', 'file_name': 'C:\\slave\\test-pgo\\build\\talos.json'}, attempt #1 07:30:53 INFO - Downloaded 4264 bytes. 07:30:53 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']}, 07:30:53 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']}, 07:30:53 INFO - u'remote-trobocheck2': {u'talos_options': [u'--fennecIDs', 07:30:53 INFO - u'../fennec_ids.txt'], 07:30:53 INFO - u'tests': [u'tcheck2']}, 07:30:53 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome', 07:30:53 INFO - u'--tppagecycles', 07:30:53 INFO - u'7'], 07:30:53 INFO - u'tests': [u'tsvgm']}}, 07:30:53 INFO - u'suites': {u'chromez': {u'tests': [u'tresize', u'tcanvasmark']}, 07:30:53 INFO - u'chromez-e10s': {u'talos_options': [u'--e10s'], 07:30:53 INFO - u'tests': [u'tresize', u'tcanvasmark']}, 07:30:53 INFO - u'dromaeojs': {u'tests': [u'dromaeo_css', u'kraken', u'v8_7']}, 07:30:53 INFO - u'dromaeojs-e10s': {u'talos_options': [u'--e10s'], 07:30:53 INFO - u'tests': [u'dromaeo_css', 07:30:53 INFO - u'kraken', 07:30:53 INFO - u'v8_7']}, 07:30:53 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:53 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 07:30:53 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:53 INFO - u'talos_options': [u'--e10s'], 07:30:53 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 07:30:53 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:53 INFO - u'tests': [u'damp', u'tps']}, 07:30:53 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:53 INFO - u'talos_options': [u'--e10s'], 07:30:53 INFO - u'tests': [u'damp', u'tps']}, 07:30:53 INFO - u'g3': {u'tests': [u'dromaeo_dom']}, 07:30:53 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']}, 07:30:53 INFO - u'other': {u'tests': [u'a11yr', 07:30:53 INFO - u'ts_paint', 07:30:53 INFO - u'tpaint', 07:30:53 INFO - u'sessionrestore', 07:30:53 INFO - u'sessionrestore_no_auto_restore']}, 07:30:53 INFO - u'other-e10s': {u'talos_options': [u'--e10s'], 07:30:53 INFO - u'tests': [u'a11yr', 07:30:53 INFO - u'ts_paint', 07:30:53 INFO - u'tpaint', 07:30:53 INFO - u'sessionrestore', 07:30:53 INFO - u'sessionrestore_no_auto_restore']}, 07:30:53 INFO - u'other-e10s_l64': {u'talos_options': [u'--e10s'], 07:30:53 INFO - u'tests': [u'a11yr', 07:30:53 INFO - u'ts_paint', 07:30:53 INFO - u'tpaint', 07:30:53 INFO - u'sessionrestore', 07:30:53 INFO - u'sessionrestore_no_auto_restore']}, 07:30:53 INFO - u'other-e10s_nol64': {u'talos_options': [u'--e10s'], 07:30:53 INFO - u'tests': [u'a11yr', 07:30:53 INFO - u'ts_paint', 07:30:53 INFO - u'tpaint', 07:30:53 INFO - u'sessionrestore', 07:30:53 INFO - u'sessionrestore_no_auto_restore']}, 07:30:53 INFO - u'other_l64': {u'tests': [u'a11yr', 07:30:53 INFO - u'ts_paint', 07:30:53 INFO - u'tpaint', 07:30:53 INFO - u'sessionrestore', 07:30:53 INFO - u'sessionrestore_no_auto_restore']}, 07:30:53 INFO - u'other_nol64': {u'tests': [u'a11yr', 07:30:53 INFO - u'ts_paint', 07:30:53 INFO - u'tpaint', 07:30:53 INFO - u'sessionrestore', 07:30:53 INFO - u'sessionrestore_no_auto_restore']}, 07:30:53 INFO - u'svgr': {u'tests': [u'tsvgx', 07:30:53 INFO - u'tsvgr_opacity', 07:30:53 INFO - u'tart', 07:30:53 INFO - u'tscrollx', 07:30:53 INFO - u'cart']}, 07:30:53 INFO - u'svgr-e10s': {u'talos_options': [u'--e10s'], 07:30:53 INFO - u'tests': [u'tsvgx', 07:30:53 INFO - u'tsvgr_opacity', 07:30:53 INFO - u'tart', 07:30:53 INFO - u'tscrollx', 07:30:53 INFO - u'cart']}, 07:30:53 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:53 INFO - u'tests': [u'tp5o']}, 07:30:53 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:53 INFO - u'talos_options': [u'--e10s'], 07:30:53 INFO - u'tests': [u'tp5o']}, 07:30:53 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:53 INFO - u'talos_options': [u'--xperf_path', 07:30:53 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:30:53 INFO - u'tests': [u'tp5n']}, 07:30:53 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:53 INFO - u'talos_options': [u'--e10s', 07:30:53 INFO - u'--xperf_path', 07:30:53 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 07:30:53 INFO - u'C:/slave/talos-data/talos/xperf.config'], 07:30:53 INFO - u'tests': [u'tp5n']}}, 07:30:53 INFO - u'talos.zip': {u'path': u'', 07:30:53 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:30:53 INFO - Running post-action listener: _resource_record_post_action 07:30:53 INFO - ##### 07:30:53 INFO - ##### Running create-virtualenv step. 07:30:53 INFO - ##### 07:30:53 INFO - Running pre-action listener: _resource_record_pre_action 07:30:53 INFO - Running main action method: create_virtualenv 07:30:53 INFO - Creating virtualenv C:\slave\test-pgo\build/venv 07:30:53 INFO - mkdir: C:\slave\test-pgo\build\venv\Scripts 07:30:53 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test-pgo\build\venv\Scripts\python27.dll 07:30:53 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'! 07:30:53 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 07:30:53 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 07:30:56 INFO - New python executable in C:\slave\test-pgo\build/venv\Scripts\python.exe 07:30:59 INFO - Installing distribute......................................................................................................................................................................................done. 07:31:00 INFO - Return code: 0 07:31:00 INFO - Installing pip>=1.5 into virtualenv C:\slave\test-pgo\build/venv 07:31:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:31:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:00 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x019A8B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01968EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0137E8C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01298B48>, '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 0x012BA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01A29660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-088', 'USERDOMAIN': 'T-W732-IX-088', '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-088', '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 07:31:00 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in C:\slave\test-pgo\build 07:31:00 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --download-cache C:\slave\test-pgo\build/venv\cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:31:00 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 07:31:00 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 07:31:00 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 07:31:00 INFO - 'COMPUTERNAME': 'T-W732-IX-088', 07:31:00 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 07:31:00 INFO - 'CYGWINBASE': 'C:\\cygwin', 07:31:00 INFO - 'DCLOCATION': 'SCL3', 07:31:00 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 07:31:00 INFO - 'FP_NO_HOST_CHECK': 'NO', 07:31:00 INFO - 'HOMEDRIVE': 'C:', 07:31:00 INFO - 'HOMEPATH': '\\Users\\cltbld', 07:31:00 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 07:31:00 INFO - 'KTS_VERSION': '1.19c', 07:31:00 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 07:31:00 INFO - 'LOGONSERVER': '\\\\T-W732-IX-088', 07:31:00 INFO - 'MONDIR': 'C:\\Monitor_config\\', 07:31:00 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 07:31:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:00 INFO - 'MOZ_NO_REMOTE': '1', 07:31:00 INFO - 'NO_EM_RESTART': '1', 07:31:00 INFO - 'NUMBER_OF_PROCESSORS': '8', 07:31:00 INFO - 'OS': 'Windows_NT', 07:31:00 INFO - 'OURDRIVE': 'C:', 07:31:00 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;', 07:31:00 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 07:31:00 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 07:31:00 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 07:31:00 INFO - 'PROCESSOR_LEVEL': '6', 07:31:00 INFO - 'PROCESSOR_REVISION': '1e05', 07:31:00 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 07:31:00 INFO - 'PROGRAMFILES': 'C:\\Program Files', 07:31:00 INFO - 'PROMPT': '$P$G', 07:31:00 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 07:31:00 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 07:31:00 INFO - 'PUBLIC': 'C:\\Users\\Public', 07:31:00 INFO - 'PWD': 'C:\\slave\\test-pgo', 07:31:00 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 07:31:00 INFO - 'SLAVEDIR': 'C:\\slave\\', 07:31:00 INFO - 'SYSTEMDRIVE': 'C:', 07:31:00 INFO - 'SYSTEMROOT': 'C:\\windows', 07:31:00 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 07:31:00 INFO - 'TEST1': 'testie', 07:31:00 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 07:31:00 INFO - 'USERDOMAIN': 'T-W732-IX-088', 07:31:00 INFO - 'USERNAME': 'cltbld', 07:31:00 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 07:31:00 INFO - 'WINDIR': 'C:\\windows', 07:31:00 INFO - 'WINDOWS_TRACING_FLAGS': '3', 07:31:00 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 07:31:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 07:31:01 INFO - Ignoring indexes: http://pypi.python.org/simple/ 07:31:01 INFO - Downloading/unpacking pip>=1.5 07:31:01 INFO - Creating supposed download cache at C:\slave\test-pgo\build/venv\cache 07:31:05 INFO - Storing download in cache at c:\slave\test-pgo\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fpip-1.5.5.tar.gz 07:31:05 INFO - Running setup.py egg_info for package pip 07:31:05 INFO - warning: no files found matching 'pip\cacert.pem' 07:31:05 INFO - warning: no files found matching '*.html' under directory 'docs' 07:31:05 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 07:31:05 INFO - no previously-included directories found matching 'docs\_build\_sources' 07:31:05 INFO - Installing collected packages: pip 07:31:05 INFO - Found existing installation: pip 0.8.2 07:31:05 INFO - Uninstalling pip: 07:31:05 INFO - Successfully uninstalled pip 07:31:05 INFO - Running setup.py install for pip 07:31:05 INFO - warning: no files found matching 'pip\cacert.pem' 07:31:05 INFO - warning: no files found matching '*.html' under directory 'docs' 07:31:05 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 07:31:05 INFO - no previously-included directories found matching 'docs\_build\_sources' 07:31:05 INFO - Installing pip-script.py script to C:\slave\test-pgo\build\venv\Scripts 07:31:05 INFO - Installing pip.exe script to C:\slave\test-pgo\build\venv\Scripts 07:31:05 INFO - Installing pip2.7-script.py script to C:\slave\test-pgo\build\venv\Scripts 07:31:05 INFO - Installing pip2.7.exe script to C:\slave\test-pgo\build\venv\Scripts 07:31:05 INFO - Installing pip2-script.py script to C:\slave\test-pgo\build\venv\Scripts 07:31:05 INFO - Installing pip2.exe script to C:\slave\test-pgo\build\venv\Scripts 07:31:05 INFO - Successfully installed pip 07:31:05 INFO - Cleaning up... 07:31:05 INFO - Return code: 0 07:31:05 INFO - Installing psutil>=0.7.1 into virtualenv C:\slave\test-pgo\build/venv 07:31:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:31:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:05 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x019A8B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01968EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0137E8C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01298B48>, '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 0x012BA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01A29660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-088', 'USERDOMAIN': 'T-W732-IX-088', '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-088', '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 07:31:05 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in C:\slave\test-pgo\build 07:31:05 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --download-cache C:\slave\test-pgo\build/venv\cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:31:05 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 07:31:05 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 07:31:05 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 07:31:05 INFO - 'COMPUTERNAME': 'T-W732-IX-088', 07:31:05 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 07:31:05 INFO - 'CYGWINBASE': 'C:\\cygwin', 07:31:05 INFO - 'DCLOCATION': 'SCL3', 07:31:05 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 07:31:05 INFO - 'FP_NO_HOST_CHECK': 'NO', 07:31:05 INFO - 'HOMEDRIVE': 'C:', 07:31:05 INFO - 'HOMEPATH': '\\Users\\cltbld', 07:31:05 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 07:31:05 INFO - 'KTS_VERSION': '1.19c', 07:31:05 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 07:31:05 INFO - 'LOGONSERVER': '\\\\T-W732-IX-088', 07:31:05 INFO - 'MONDIR': 'C:\\Monitor_config\\', 07:31:05 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 07:31:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:05 INFO - 'MOZ_NO_REMOTE': '1', 07:31:05 INFO - 'NO_EM_RESTART': '1', 07:31:05 INFO - 'NUMBER_OF_PROCESSORS': '8', 07:31:05 INFO - 'OS': 'Windows_NT', 07:31:05 INFO - 'OURDRIVE': 'C:', 07:31:05 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;', 07:31:05 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 07:31:05 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 07:31:05 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 07:31:05 INFO - 'PROCESSOR_LEVEL': '6', 07:31:05 INFO - 'PROCESSOR_REVISION': '1e05', 07:31:05 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 07:31:05 INFO - 'PROGRAMFILES': 'C:\\Program Files', 07:31:05 INFO - 'PROMPT': '$P$G', 07:31:05 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 07:31:05 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 07:31:05 INFO - 'PUBLIC': 'C:\\Users\\Public', 07:31:05 INFO - 'PWD': 'C:\\slave\\test-pgo', 07:31:05 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 07:31:05 INFO - 'SLAVEDIR': 'C:\\slave\\', 07:31:05 INFO - 'SYSTEMDRIVE': 'C:', 07:31:05 INFO - 'SYSTEMROOT': 'C:\\windows', 07:31:05 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 07:31:05 INFO - 'TEST1': 'testie', 07:31:05 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 07:31:05 INFO - 'USERDOMAIN': 'T-W732-IX-088', 07:31:05 INFO - 'USERNAME': 'cltbld', 07:31:05 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 07:31:05 INFO - 'WINDIR': 'C:\\windows', 07:31:05 INFO - 'WINDOWS_TRACING_FLAGS': '3', 07:31:05 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 07:31:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 07:31:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:07 INFO - Downloading/unpacking psutil>=0.7.1 07: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 07: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 07:31:08 INFO - Storing download in cache at c:\slave\test-pgo\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fpsutil-3.1.1-cp27-none-win32.whl 07:31:08 INFO - Installing collected packages: psutil 07:31:08 INFO - Successfully installed psutil 07:31:08 INFO - Cleaning up... 07:31:08 INFO - Return code: 0 07:31:08 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv C:\slave\test-pgo\build/venv 07:31:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:31:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:08 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x019A8B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01968EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0137E8C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01298B48>, '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 0x012BA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01A29660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-088', 'USERDOMAIN': 'T-W732-IX-088', '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-088', '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 07:31:08 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in C:\slave\test-pgo\build 07:31:08 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --download-cache C:\slave\test-pgo\build/venv\cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:31:08 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 07:31:08 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 07:31:08 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 07:31:08 INFO - 'COMPUTERNAME': 'T-W732-IX-088', 07:31:08 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 07:31:08 INFO - 'CYGWINBASE': 'C:\\cygwin', 07:31:08 INFO - 'DCLOCATION': 'SCL3', 07:31:08 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 07:31:08 INFO - 'FP_NO_HOST_CHECK': 'NO', 07:31:08 INFO - 'HOMEDRIVE': 'C:', 07:31:08 INFO - 'HOMEPATH': '\\Users\\cltbld', 07:31:08 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 07:31:08 INFO - 'KTS_VERSION': '1.19c', 07:31:08 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 07:31:08 INFO - 'LOGONSERVER': '\\\\T-W732-IX-088', 07:31:08 INFO - 'MONDIR': 'C:\\Monitor_config\\', 07:31:08 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 07:31:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:08 INFO - 'MOZ_NO_REMOTE': '1', 07:31:08 INFO - 'NO_EM_RESTART': '1', 07:31:08 INFO - 'NUMBER_OF_PROCESSORS': '8', 07:31:08 INFO - 'OS': 'Windows_NT', 07:31:08 INFO - 'OURDRIVE': 'C:', 07:31:08 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;', 07:31:08 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 07:31:08 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 07:31:08 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 07:31:08 INFO - 'PROCESSOR_LEVEL': '6', 07:31:08 INFO - 'PROCESSOR_REVISION': '1e05', 07:31:08 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 07:31:08 INFO - 'PROGRAMFILES': 'C:\\Program Files', 07:31:08 INFO - 'PROMPT': '$P$G', 07:31:08 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 07:31:08 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 07:31:08 INFO - 'PUBLIC': 'C:\\Users\\Public', 07:31:08 INFO - 'PWD': 'C:\\slave\\test-pgo', 07:31:08 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 07:31:08 INFO - 'SLAVEDIR': 'C:\\slave\\', 07:31:08 INFO - 'SYSTEMDRIVE': 'C:', 07:31:08 INFO - 'SYSTEMROOT': 'C:\\windows', 07:31:08 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 07:31:08 INFO - 'TEST1': 'testie', 07:31:08 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 07:31:08 INFO - 'USERDOMAIN': 'T-W732-IX-088', 07:31:08 INFO - 'USERNAME': 'cltbld', 07:31:08 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 07:31:08 INFO - 'WINDIR': 'C:\\windows', 07:31:08 INFO - 'WINDOWS_TRACING_FLAGS': '3', 07:31:08 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 07:31:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 07:31:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:08 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07: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 07: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 07:31:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:31:09 INFO - Storing download in cache at c:\slave\test-pgo\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fmozsystemmonitor-0.0.tar.gz 07:31:09 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor 07:31:09 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) 07:31:09 INFO - Installing collected packages: mozsystemmonitor 07:31:09 INFO - Running setup.py install for mozsystemmonitor 07:31:10 INFO - Successfully installed mozsystemmonitor 07:31:10 INFO - Cleaning up... 07:31:10 INFO - Return code: 0 07:31:10 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test-pgo\build/venv 07:31:10 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')]} 07:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:10 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')]} 07:31:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:10 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x019A8B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01968EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0137E8C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01298B48>, '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 0x012BA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01A29660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-088', 'USERDOMAIN': 'T-W732-IX-088', '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-088', '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 07:31:10 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in C:\slave\test-pgo\build 07:31:10 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --download-cache C:\slave\test-pgo\build/venv\cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:31:10 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 07:31:10 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 07:31:10 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 07:31:10 INFO - 'COMPUTERNAME': 'T-W732-IX-088', 07:31:10 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 07:31:10 INFO - 'CYGWINBASE': 'C:\\cygwin', 07:31:10 INFO - 'DCLOCATION': 'SCL3', 07:31:10 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 07:31:10 INFO - 'FP_NO_HOST_CHECK': 'NO', 07:31:10 INFO - 'HOMEDRIVE': 'C:', 07:31:10 INFO - 'HOMEPATH': '\\Users\\cltbld', 07:31:10 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 07:31:10 INFO - 'KTS_VERSION': '1.19c', 07:31:10 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 07:31:10 INFO - 'LOGONSERVER': '\\\\T-W732-IX-088', 07:31:10 INFO - 'MONDIR': 'C:\\Monitor_config\\', 07:31:10 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 07:31:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:10 INFO - 'MOZ_NO_REMOTE': '1', 07:31:10 INFO - 'NO_EM_RESTART': '1', 07:31:10 INFO - 'NUMBER_OF_PROCESSORS': '8', 07:31:10 INFO - 'OS': 'Windows_NT', 07:31:10 INFO - 'OURDRIVE': 'C:', 07:31:10 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;', 07:31:10 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 07:31:10 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 07:31:10 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 07:31:10 INFO - 'PROCESSOR_LEVEL': '6', 07:31:10 INFO - 'PROCESSOR_REVISION': '1e05', 07:31:10 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 07:31:10 INFO - 'PROGRAMFILES': 'C:\\Program Files', 07:31:10 INFO - 'PROMPT': '$P$G', 07:31:10 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 07:31:10 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 07:31:10 INFO - 'PUBLIC': 'C:\\Users\\Public', 07:31:10 INFO - 'PWD': 'C:\\slave\\test-pgo', 07:31:10 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 07:31:10 INFO - 'SLAVEDIR': 'C:\\slave\\', 07:31:10 INFO - 'SYSTEMDRIVE': 'C:', 07:31:10 INFO - 'SYSTEMROOT': 'C:\\windows', 07:31:10 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 07:31:10 INFO - 'TEST1': 'testie', 07:31:10 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 07:31:10 INFO - 'USERDOMAIN': 'T-W732-IX-088', 07:31:10 INFO - 'USERNAME': 'cltbld', 07:31:10 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 07:31:10 INFO - 'WINDIR': 'C:\\windows', 07:31:10 INFO - 'WINDOWS_TRACING_FLAGS': '3', 07:31:10 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 07:31:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 07:31:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:10 INFO - Downloading/unpacking blobuploader==1.2.4 07:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:11 INFO - Downloading blobuploader-1.2.4.tar.gz 07:31:11 INFO - Storing download in cache at c:\slave\test-pgo\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fblobuploader-1.2.4.tar.gz 07:31:11 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader 07:31:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:31:11 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 07:31:11 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 07:31:11 INFO - Storing download in cache at c:\slave\test-pgo\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2frequests-1.2.3.tar.gz 07:31:11 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\requests\setup.py) egg_info for package requests 07:31:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:12 INFO - Downloading docopt-0.6.1.tar.gz 07:31:12 INFO - Storing download in cache at c:\slave\test-pgo\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fdocopt-0.6.1.tar.gz 07:31:12 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\docopt\setup.py) egg_info for package docopt 07:31:12 INFO - Installing collected packages: blobuploader, requests, docopt 07:31:12 INFO - Running setup.py install for blobuploader 07:31:12 INFO - Running setup.py install for requests 07:31:13 INFO - Running setup.py install for docopt 07:31:13 INFO - Successfully installed blobuploader requests docopt 07:31:13 INFO - Cleaning up... 07:31:14 INFO - Return code: 0 07:31:14 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv 07:31:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:31:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:14 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--no-deps', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test-pgo\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x019A8B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01968EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0137E8C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01298B48>, '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 0x012BA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01A29660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-088', 'USERDOMAIN': 'T-W732-IX-088', '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-088', '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 07:31:14 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--no-deps', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test-pgo\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in C:\slave\test-pgo\build\tests\config 07:31:14 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --no-deps --download-cache C:\slave\test-pgo\build/venv\cache --timeout 120 -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:31:14 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 07:31:14 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 07:31:14 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 07:31:14 INFO - 'COMPUTERNAME': 'T-W732-IX-088', 07:31:14 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 07:31:14 INFO - 'CYGWINBASE': 'C:\\cygwin', 07:31:14 INFO - 'DCLOCATION': 'SCL3', 07:31:14 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 07:31:14 INFO - 'FP_NO_HOST_CHECK': 'NO', 07:31:14 INFO - 'HOMEDRIVE': 'C:', 07:31:14 INFO - 'HOMEPATH': '\\Users\\cltbld', 07:31:14 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 07:31:14 INFO - 'KTS_VERSION': '1.19c', 07:31:14 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 07:31:14 INFO - 'LOGONSERVER': '\\\\T-W732-IX-088', 07:31:14 INFO - 'MONDIR': 'C:\\Monitor_config\\', 07:31:14 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 07:31:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:14 INFO - 'MOZ_NO_REMOTE': '1', 07:31:14 INFO - 'NO_EM_RESTART': '1', 07:31:14 INFO - 'NUMBER_OF_PROCESSORS': '8', 07:31:14 INFO - 'OS': 'Windows_NT', 07:31:14 INFO - 'OURDRIVE': 'C:', 07: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;', 07:31:14 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 07:31:14 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 07:31:14 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 07:31:14 INFO - 'PROCESSOR_LEVEL': '6', 07:31:14 INFO - 'PROCESSOR_REVISION': '1e05', 07:31:14 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 07:31:14 INFO - 'PROGRAMFILES': 'C:\\Program Files', 07:31:14 INFO - 'PROMPT': '$P$G', 07:31:14 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 07:31:14 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 07:31:14 INFO - 'PUBLIC': 'C:\\Users\\Public', 07:31:14 INFO - 'PWD': 'C:\\slave\\test-pgo', 07:31:14 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 07:31:14 INFO - 'SLAVEDIR': 'C:\\slave\\', 07:31:14 INFO - 'SYSTEMDRIVE': 'C:', 07:31:14 INFO - 'SYSTEMROOT': 'C:\\windows', 07:31:14 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 07:31:14 INFO - 'TEST1': 'testie', 07:31:14 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 07:31:14 INFO - 'USERDOMAIN': 'T-W732-IX-088', 07:31:14 INFO - 'USERNAME': 'cltbld', 07:31:14 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 07:31:14 INFO - 'WINDIR': 'C:\\windows', 07:31:14 INFO - 'WINDOWS_TRACING_FLAGS': '3', 07:31:14 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 07:31:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 07:31:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:14 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\manifestparser 07:31:14 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-p1yjpm-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/manifestparser 07:31:14 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozcrash 07:31:14 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-pytj2d-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozcrash 07:31:15 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdebug 07:31:15 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-ys1a2s-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdebug 07:31:15 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdevice 07:31:15 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-l5vmee-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdevice 07:31:15 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozfile 07:31:15 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-etcunf-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozfile 07:31:16 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozhttpd 07:31:16 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-urdhmj-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozhttpd 07:31:16 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinfo 07:31:16 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-nlsuen-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinfo 07:31:16 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinstall 07:31:16 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-mr9d8n-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinstall 07:31:16 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozleak 07:31:16 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-hqyoxq-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozleak 07:31:16 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozlog 07:31:16 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-wgg0gl-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozlog 07:31:16 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moznetwork 07:31:16 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-abih7m-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moznetwork 07:31:16 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprocess 07:31:16 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-vdh2m8-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprocess 07:31:16 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprofile 07:31:16 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-yk4avj-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprofile 07:31:17 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozrunner 07:31:17 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-iwnhwv-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozrunner 07:31:17 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozscreenshot 07:31:17 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-2ursrg-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:31:17 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moztest 07:31:17 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-l5ntnn-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moztest 07:31:17 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozversion 07:31:17 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-b204sz-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozversion 07:31:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:31:17 INFO - Running setup.py install for manifestparser 07:31:18 INFO - Installing manifestparser-script.py script to C:\slave\test-pgo\build\venv\Scripts 07:31:18 INFO - Installing manifestparser.exe script to C:\slave\test-pgo\build\venv\Scripts 07:31:18 INFO - Running setup.py install for mozcrash 07:31:18 INFO - Running setup.py install for mozdebug 07:31:19 INFO - Running setup.py install for mozdevice 07:31:19 INFO - Installing sutini-script.py script to C:\slave\test-pgo\build\venv\Scripts 07:31:19 INFO - Installing sutini.exe script to C:\slave\test-pgo\build\venv\Scripts 07:31:19 INFO - Installing dm-script.py script to C:\slave\test-pgo\build\venv\Scripts 07:31:19 INFO - Installing dm.exe script to C:\slave\test-pgo\build\venv\Scripts 07:31:19 INFO - Running setup.py install for mozfile 07:31:20 INFO - Running setup.py install for mozhttpd 07:31:20 INFO - Installing mozhttpd-script.py script to C:\slave\test-pgo\build\venv\Scripts 07:31:20 INFO - Installing mozhttpd.exe script to C:\slave\test-pgo\build\venv\Scripts 07:31:20 INFO - Running setup.py install for mozinfo 07:31:20 INFO - Installing mozinfo-script.py script to C:\slave\test-pgo\build\venv\Scripts 07:31:20 INFO - Installing mozinfo.exe script to C:\slave\test-pgo\build\venv\Scripts 07:31:21 INFO - Running setup.py install for mozInstall 07:31:21 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test-pgo\build\venv\Scripts 07:31:21 INFO - Installing moz_remove_from_system.exe script to C:\slave\test-pgo\build\venv\Scripts 07:31:21 INFO - Installing mozuninstall-script.py script to C:\slave\test-pgo\build\venv\Scripts 07:31:21 INFO - Installing mozuninstall.exe script to C:\slave\test-pgo\build\venv\Scripts 07:31:21 INFO - Installing mozinstall-script.py script to C:\slave\test-pgo\build\venv\Scripts 07:31:21 INFO - Installing mozinstall.exe script to C:\slave\test-pgo\build\venv\Scripts 07:31:21 INFO - Installing moz_add_to_system-script.py script to C:\slave\test-pgo\build\venv\Scripts 07:31:21 INFO - Installing moz_add_to_system.exe script to C:\slave\test-pgo\build\venv\Scripts 07:31:21 INFO - Running setup.py install for mozleak 07:31:22 INFO - Running setup.py install for mozlog 07:31:22 INFO - Installing structlog-script.py script to C:\slave\test-pgo\build\venv\Scripts 07:31:22 INFO - Installing structlog.exe script to C:\slave\test-pgo\build\venv\Scripts 07:31:22 INFO - Running setup.py install for moznetwork 07:31:23 INFO - Installing moznetwork-script.py script to C:\slave\test-pgo\build\venv\Scripts 07:31:23 INFO - Installing moznetwork.exe script to C:\slave\test-pgo\build\venv\Scripts 07:31:23 INFO - Running setup.py install for mozprocess 07:31:23 INFO - Running setup.py install for mozprofile 07:31:24 INFO - Installing mozprofile-script.py script to C:\slave\test-pgo\build\venv\Scripts 07:31:24 INFO - Installing mozprofile.exe script to C:\slave\test-pgo\build\venv\Scripts 07:31:24 INFO - Installing diff-profiles-script.py script to C:\slave\test-pgo\build\venv\Scripts 07:31:24 INFO - Installing diff-profiles.exe script to C:\slave\test-pgo\build\venv\Scripts 07:31:24 INFO - Installing view-profile-script.py script to C:\slave\test-pgo\build\venv\Scripts 07:31:24 INFO - Installing view-profile.exe script to C:\slave\test-pgo\build\venv\Scripts 07:31:24 INFO - Running setup.py install for mozrunner 07:31:24 INFO - Installing mozrunner-script.py script to C:\slave\test-pgo\build\venv\Scripts 07:31:24 INFO - Installing mozrunner.exe script to C:\slave\test-pgo\build\venv\Scripts 07:31:25 INFO - Running setup.py install for mozscreenshot 07:31:25 INFO - Running setup.py install for moztest 07:31:25 INFO - Running setup.py install for mozversion 07:31:26 INFO - Installing mozversion-script.py script to C:\slave\test-pgo\build\venv\Scripts 07:31:26 INFO - Installing mozversion.exe script to C:\slave\test-pgo\build\venv\Scripts 07:31:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:31:26 INFO - Cleaning up... 07:31:26 INFO - Return code: 0 07:31:26 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv 07:31:26 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')]} 07:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:26 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')]} 07:31:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:26 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test-pgo\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x019A8B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01968EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0137E8C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01298B48>, '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 0x012BA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01A29660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-088', 'USERDOMAIN': 'T-W732-IX-088', '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-088', '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 07:31:26 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test-pgo\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in C:\slave\test-pgo\build\tests\config 07:31:26 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --download-cache C:\slave\test-pgo\build/venv\cache --timeout 120 -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:31:26 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 07:31:26 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 07:31:26 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 07:31:26 INFO - 'COMPUTERNAME': 'T-W732-IX-088', 07:31:26 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 07:31:26 INFO - 'CYGWINBASE': 'C:\\cygwin', 07:31:26 INFO - 'DCLOCATION': 'SCL3', 07:31:26 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 07:31:26 INFO - 'FP_NO_HOST_CHECK': 'NO', 07:31:26 INFO - 'HOMEDRIVE': 'C:', 07:31:26 INFO - 'HOMEPATH': '\\Users\\cltbld', 07:31:26 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 07:31:26 INFO - 'KTS_VERSION': '1.19c', 07:31:26 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 07:31:26 INFO - 'LOGONSERVER': '\\\\T-W732-IX-088', 07:31:26 INFO - 'MONDIR': 'C:\\Monitor_config\\', 07:31:26 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 07:31:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:26 INFO - 'MOZ_NO_REMOTE': '1', 07:31:26 INFO - 'NO_EM_RESTART': '1', 07:31:26 INFO - 'NUMBER_OF_PROCESSORS': '8', 07:31:26 INFO - 'OS': 'Windows_NT', 07:31:26 INFO - 'OURDRIVE': 'C:', 07:31:26 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;', 07:31:26 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 07:31:26 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 07:31:26 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 07:31:26 INFO - 'PROCESSOR_LEVEL': '6', 07:31:26 INFO - 'PROCESSOR_REVISION': '1e05', 07:31:26 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 07:31:26 INFO - 'PROGRAMFILES': 'C:\\Program Files', 07:31:26 INFO - 'PROMPT': '$P$G', 07:31:26 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 07:31:26 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 07:31:26 INFO - 'PUBLIC': 'C:\\Users\\Public', 07:31:26 INFO - 'PWD': 'C:\\slave\\test-pgo', 07:31:26 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 07:31:26 INFO - 'SLAVEDIR': 'C:\\slave\\', 07:31:26 INFO - 'SYSTEMDRIVE': 'C:', 07:31:26 INFO - 'SYSTEMROOT': 'C:\\windows', 07:31:26 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 07:31:26 INFO - 'TEST1': 'testie', 07:31:26 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 07:31:26 INFO - 'USERDOMAIN': 'T-W732-IX-088', 07:31:26 INFO - 'USERNAME': 'cltbld', 07:31:26 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 07:31:26 INFO - 'WINDIR': 'C:\\windows', 07:31:26 INFO - 'WINDOWS_TRACING_FLAGS': '3', 07:31:26 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 07:31:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 07:31:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:26 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\manifestparser 07:31:26 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-ejo9di-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/manifestparser 07:31:26 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)) 07:31:26 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozcrash 07:31:26 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-mja6jr-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozcrash 07:31:26 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)) 07:31:26 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdebug 07:31:26 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-inksnl-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdebug 07:31:27 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)) 07:31:27 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdevice 07:31:27 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-oe2l1f-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdevice 07:31:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 from file:///C:/slave/test-pgo/build/tests/mozbase/mozdevice in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 4)) 07:31:27 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozfile 07:31:27 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-ytvgnq-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozfile 07:31:27 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)) 07:31:27 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozhttpd 07:31:27 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-2siuxc-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozhttpd 07:31:27 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)) 07:31:27 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinfo 07:31:27 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-7ju3uo-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinfo 07:31:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 from file:///C:/slave/test-pgo/build/tests/mozbase/mozinfo in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 7)) 07:31:27 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinstall 07:31:27 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-qxmznz-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinstall 07:31:27 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)) 07:31:27 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozleak 07:31:27 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-xu5rxn-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozleak 07:31:27 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)) 07:31:27 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozlog 07:31:27 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-xgiphu-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozlog 07:31:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///C:/slave/test-pgo/build/tests/mozbase/mozlog in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 10)) 07:31:28 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moznetwork 07:31:28 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-gxun1v-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moznetwork 07:31:28 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)) 07:31:28 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprocess 07:31:28 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-n1jpji-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprocess 07:31:28 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)) 07:31:28 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprofile 07:31:28 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-i4pvug-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprofile 07:31:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///C:/slave/test-pgo/build/tests/mozbase/mozprofile in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 13)) 07:31:28 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozrunner 07:31:28 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-behe_h-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozrunner 07:31:28 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)) 07:31:28 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozscreenshot 07:31:28 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-gbm0j9-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:31:28 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)) 07:31:28 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moztest 07:31:28 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-ktlr10-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moztest 07:31:28 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)) 07:31:28 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozversion 07:31:28 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-cdje6m-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozversion 07:31:29 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)) 07:31:29 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)) 07:31:29 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)) 07:31:29 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)) 07:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test-pgo\build\venv\lib\site-packages (from mozdevice==0.46->-r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 4)) 07:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in c:\slave\test-pgo\build\venv\lib\site-packages (from mozdevice==0.46->-r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 4)) 07:31:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 10)) 07:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:30 INFO - Downloading blessings-1.5.1.tar.gz 07:31:30 INFO - Storing download in cache at c:\slave\test-pgo\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fblessings-1.5.1.tar.gz 07:31:30 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\blessings\setup.py) egg_info for package blessings 07:31:30 INFO - Installing collected packages: blessings 07:31:30 INFO - Running setup.py install for blessings 07:31:30 INFO - Successfully installed blessings 07:31:30 INFO - Cleaning up... 07:31:33 INFO - Return code: 0 07:31:33 INFO - Done creating virtualenv C:\slave\test-pgo\build/venv. 07:31:33 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'freeze'] 07:31:33 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip freeze 07:31:33 INFO - Reading from file tmpfile_stdout 07:31:33 INFO - Using _rmtree_windows ... 07:31:33 INFO - Using _rmtree_windows ... 07:31:33 INFO - Current package versions: 07:31:33 INFO - blessings == 1.5.1 07:31:33 INFO - blobuploader == 1.2.4 07:31:33 INFO - docopt == 0.6.1 07:31:33 INFO - manifestparser == 1.1 07:31:33 INFO - mozInstall == 1.12 07:31:33 INFO - mozcrash == 0.16 07:31:33 INFO - mozdebug == 0.1 07:31:33 INFO - mozdevice == 0.46 07:31:33 INFO - mozfile == 1.2 07:31:33 INFO - mozhttpd == 0.7 07:31:33 INFO - mozinfo == 0.8 07:31:33 INFO - mozleak == 0.1 07:31:33 INFO - mozlog == 3.0 07:31:33 INFO - moznetwork == 0.27 07:31:33 INFO - mozprocess == 0.22 07:31:33 INFO - mozprofile == 0.27 07:31:33 INFO - mozrunner == 6.11 07:31:33 INFO - mozscreenshot == 0.1 07:31:33 INFO - mozsystemmonitor == 0.0 07:31:33 INFO - moztest == 0.7 07:31:33 INFO - mozversion == 1.4 07:31:33 INFO - psutil == 3.1.1 07:31:33 INFO - requests == 1.2.3 07:31:33 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv 07:31:33 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')]} 07:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:33 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')]} 07:31:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:33 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test-pgo\\build\\tests\\talos\\requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x019A8B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01968EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0137E8C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01298B48>, '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 0x012BA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01A29660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build\\tests\\talos', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-088', 'USERDOMAIN': 'T-W732-IX-088', '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-088', '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 07:31:33 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test-pgo\\build\\tests\\talos\\requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in C:\slave\test-pgo\build\tests\talos 07:31:33 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --download-cache C:\slave\test-pgo\build/venv\cache --timeout 120 -r C:\slave\test-pgo\build\tests\talos\requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:31:33 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 07:31:33 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 07:31:33 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 07:31:33 INFO - 'COMPUTERNAME': 'T-W732-IX-088', 07:31:33 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 07:31:33 INFO - 'CYGWINBASE': 'C:\\cygwin', 07:31:33 INFO - 'DCLOCATION': 'SCL3', 07:31:33 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 07:31:33 INFO - 'FP_NO_HOST_CHECK': 'NO', 07:31:33 INFO - 'HOMEDRIVE': 'C:', 07:31:33 INFO - 'HOMEPATH': '\\Users\\cltbld', 07:31:33 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 07:31:33 INFO - 'KTS_VERSION': '1.19c', 07:31:33 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 07:31:33 INFO - 'LOGONSERVER': '\\\\T-W732-IX-088', 07:31:33 INFO - 'MONDIR': 'C:\\Monitor_config\\', 07:31:33 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 07:31:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:33 INFO - 'MOZ_NO_REMOTE': '1', 07:31:33 INFO - 'NO_EM_RESTART': '1', 07:31:33 INFO - 'NUMBER_OF_PROCESSORS': '8', 07:31:33 INFO - 'OS': 'Windows_NT', 07:31:33 INFO - 'OURDRIVE': 'C:', 07:31:33 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;', 07:31:33 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 07:31:33 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 07:31:33 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 07:31:33 INFO - 'PROCESSOR_LEVEL': '6', 07:31:33 INFO - 'PROCESSOR_REVISION': '1e05', 07:31:33 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 07:31:33 INFO - 'PROGRAMFILES': 'C:\\Program Files', 07:31:33 INFO - 'PROMPT': '$P$G', 07:31:33 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 07:31:33 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 07:31:33 INFO - 'PUBLIC': 'C:\\Users\\Public', 07:31:33 INFO - 'PWD': 'C:\\slave\\test-pgo', 07:31:33 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 07:31:33 INFO - 'SLAVEDIR': 'C:\\slave\\', 07:31:33 INFO - 'SYSTEMDRIVE': 'C:', 07:31:33 INFO - 'SYSTEMROOT': 'C:\\windows', 07:31:33 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 07:31:33 INFO - 'TEST1': 'testie', 07:31:33 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 07:31:33 INFO - 'USERDOMAIN': 'T-W732-IX-088', 07:31:33 INFO - 'USERNAME': 'cltbld', 07:31:33 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 07:31:33 INFO - 'WINDIR': 'C:\\windows', 07:31:33 INFO - 'WINDOWS_TRACING_FLAGS': '3', 07:31:33 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 07:31:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 07:31:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 1)) 07:31:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 2)) 07:31:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 3)) 07:31:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 4)) 07:31:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 5)) 07:31:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 6)) 07:31:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 7)) 07:31:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 8)) 07:31:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in c:\slave\test-pgo\build\venv\lib\site-packages (from mozcrash>=0.15->-r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 1)) 07:31:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test-pgo\build\venv\lib\site-packages (from mozhttpd>=0.7->-r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 3)) 07:31:34 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in c:\slave\test-pgo\build\venv\lib\site-packages (from mozlog>=3.0->mozcrash>=0.15->-r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 1)) 07:31:34 INFO - Cleaning up... 07:31:34 INFO - Return code: 0 07:31:34 INFO - Running post-action listener: _resource_record_post_action 07:31:34 INFO - Running post-action listener: _start_resource_monitoring 07:31:34 INFO - Starting resource monitoring. 07:31:34 INFO - ##### 07:31:34 INFO - ##### Running install step. 07:31:34 INFO - ##### 07:31:34 INFO - Running pre-action listener: _resource_record_pre_action 07:31:34 INFO - Running main action method: install 07:31:34 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'freeze'] 07:31:34 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip freeze 07:31:34 INFO - Reading from file tmpfile_stdout 07:31:34 INFO - Using _rmtree_windows ... 07:31:34 INFO - Using _rmtree_windows ... 07:31:34 INFO - Detecting whether we're running mozinstall >=1.0... 07:31:34 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build/venv/scripts/python', 'C:\\slave\\test-pgo\\build/venv/scripts/mozinstall-script.py', '-h'] 07:31:34 INFO - Copy/paste: C:\slave\test-pgo\build/venv/scripts/python C:\slave\test-pgo\build/venv/scripts/mozinstall-script.py -h 07:31:34 INFO - Reading from file tmpfile_stdout 07:31:34 INFO - Output received: 07:31:34 INFO - Usage: mozinstall-script.py [options] installer 07:31:34 INFO - Options: 07:31:34 INFO - -h, --help show this help message and exit 07:31:34 INFO - -d DEST, --destination=DEST 07:31:34 INFO - Directory to install application into. [default: 07:31:34 INFO - "C:\slave\test-pgo"] 07:31:34 INFO - --app=APP Application being installed. [default: firefox] 07:31:34 INFO - Using _rmtree_windows ... 07:31:34 INFO - Using _rmtree_windows ... 07:31:34 INFO - mkdir: C:\slave\test-pgo\build\application 07:31:34 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build/venv/scripts/python', 'C:\\slave\\test-pgo\\build/venv/scripts/mozinstall-script.py', 'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win32.zip', '--destination', 'C:\\slave\\test-pgo\\build\\application'] 07:31:34 INFO - Copy/paste: C:\slave\test-pgo\build/venv/scripts/python C:\slave\test-pgo\build/venv/scripts/mozinstall-script.py C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.zip --destination C:\slave\test-pgo\build\application 07:31:35 INFO - Reading from file tmpfile_stdout 07:31:35 INFO - Output received: 07:31:35 INFO - C:\slave\test-pgo\build\application\firefox\firefox.exe 07:31:35 INFO - Using _rmtree_windows ... 07:31:35 INFO - Using _rmtree_windows ... 07:31:35 INFO - Running post-action listener: _resource_record_post_action 07:31:35 INFO - ##### 07:31:35 INFO - ##### Running run-tests step. 07:31:35 INFO - ##### 07:31:35 INFO - Running pre-action listener: _resource_record_pre_action 07:31:35 INFO - Running main action method: run_tests 07:31:35 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\python', '--version'] 07:31:35 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\python --version 07:31:35 INFO - Python 2.7.3 07:31:35 INFO - Return code: 0 07:31:35 INFO - grabbing minidump binary from tooltool 07:31: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')]} 07:31:35 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 0x01298B48>, '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 0x012BA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01A29660>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'privileged': False}, attempt #1 07:31:35 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 07:31:35 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 07:31:36 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 07:31:36 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test-pgo\build\tmpax40gp 07:31:36 INFO - INFO - File integrity verified, renaming tmpax40gp to win32-minidump_stackwalk.exe 07:31:36 INFO - Return code: 0 07:31:36 INFO - Chmoding C:\slave\test-pgo\build\win32-minidump_stackwalk.exe to 0755 07:31:36 INFO - mkdir: C:\slave\test-pgo\build\blobber_upload_dir 07:31:36 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test-pgo\build\blobber_upload_dir 07:31:36 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test-pgo\build\win32-minidump_stackwalk.exe 07:31:36 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test-pgo\build\blobber_upload_dir 07:31:36 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\python', 'C:\\slave\\test-pgo\\build\\tests\\talos\\talos\\run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test-pgo\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/kOaQf_hKTbu_Wh4SWoY5NA/artifacts/public/build/firefox-44.0a1.en-US.win32.crashreporter-symbols.zip', '--title', 'T-W732-IX-088', '--webServer', 'localhost'] in C:\slave\test-pgo\build 07:31:36 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\python C:\slave\test-pgo\build\tests\talos\talos\run_tests.py --debug --branchName B2G-Inbound --suite dromaeojs --executablePath C:\slave\test-pgo\build\application\firefox\firefox --symbolsPath https://queue.taskcluster.net/v1/task/kOaQf_hKTbu_Wh4SWoY5NA/artifacts/public/build/firefox-44.0a1.en-US.win32.crashreporter-symbols.zip --title T-W732-IX-088 --webServer localhost 07:31:36 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 07:31:36 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 07:31:36 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 07:31:36 INFO - 'COMPUTERNAME': 'T-W732-IX-088', 07:31:36 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 07:31:36 INFO - 'CYGWINBASE': 'C:\\cygwin', 07:31:36 INFO - 'DCLOCATION': 'SCL3', 07:31:36 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 07:31:36 INFO - 'FP_NO_HOST_CHECK': 'NO', 07:31:36 INFO - 'HOMEDRIVE': 'C:', 07:31:36 INFO - 'HOMEPATH': '\\Users\\cltbld', 07:31:36 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 07:31:36 INFO - 'KTS_VERSION': '1.19c', 07:31:36 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 07:31:36 INFO - 'LOGONSERVER': '\\\\T-W732-IX-088', 07:31:36 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test-pgo\\build\\blobber_upload_dir', 07:31:36 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test-pgo\\build\\win32-minidump_stackwalk.exe', 07:31:36 INFO - 'MONDIR': 'C:\\Monitor_config\\', 07:31:36 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 07:31:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:36 INFO - 'MOZ_NO_REMOTE': '1', 07:31:36 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test-pgo\\build\\blobber_upload_dir', 07:31:36 INFO - 'NO_EM_RESTART': '1', 07:31:36 INFO - 'NUMBER_OF_PROCESSORS': '8', 07:31:36 INFO - 'OS': 'Windows_NT', 07:31:36 INFO - 'OURDRIVE': 'C:', 07:31:36 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;', 07:31:36 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 07:31:36 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 07:31:36 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 07:31:36 INFO - 'PROCESSOR_LEVEL': '6', 07:31:36 INFO - 'PROCESSOR_REVISION': '1e05', 07:31:36 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 07:31:36 INFO - 'PROGRAMFILES': 'C:\\Program Files', 07:31:36 INFO - 'PROMPT': '$P$G', 07:31:36 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 07:31:36 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 07:31:36 INFO - 'PUBLIC': 'C:\\Users\\Public', 07:31:36 INFO - 'PWD': 'C:\\slave\\test-pgo', 07:31:36 INFO - 'PYTHONPATH': 'C:\\slave\\test-pgo\\build\\tests\\talos', 07:31:36 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 07:31:36 INFO - 'SLAVEDIR': 'C:\\slave\\', 07:31:36 INFO - 'SYSTEMDRIVE': 'C:', 07:31:36 INFO - 'SYSTEMROOT': 'C:\\windows', 07:31:36 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 07:31:36 INFO - 'TEST1': 'testie', 07:31:36 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 07:31:36 INFO - 'USERDOMAIN': 'T-W732-IX-088', 07:31:36 INFO - 'USERNAME': 'cltbld', 07:31:36 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 07:31:36 INFO - 'WINDIR': 'C:\\windows', 07:31:36 INFO - 'WINDOWS_TRACING_FLAGS': '3', 07:31:36 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 07:31:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 07:31:36 INFO - Calling ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\python', 'C:\\slave\\test-pgo\\build\\tests\\talos\\talos\\run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test-pgo\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/kOaQf_hKTbu_Wh4SWoY5NA/artifacts/public/build/firefox-44.0a1.en-US.win32.crashreporter-symbols.zip', '--title', 'T-W732-IX-088', '--webServer', 'localhost'] with output_timeout 3600 07:31:37 INFO - mozversion INFO | application_buildid: 20151024023017 07:31:37 INFO - mozversion INFO | application_changeset: e76e31d7414b027b54603f9cf6b793b7c32e2dfe 07:31:37 INFO - mozversion INFO | application_display_name: Nightly 07:31:37 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:31:37 INFO - mozversion INFO | application_name: Firefox 07:31:37 INFO - mozversion INFO | application_remotingname: firefox 07:31:37 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 07:31:37 INFO - mozversion INFO | application_vendor: Mozilla 07:31:37 INFO - mozversion INFO | application_version: 44.0a1 07:31:37 INFO - mozversion INFO | platform_buildid: 20151024023017 07:31:37 INFO - mozversion INFO | platform_changeset: e76e31d7414b027b54603f9cf6b793b7c32e2dfe 07:31:37 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 07:31:37 INFO - mozversion INFO | platform_version: 44.0a1 07:31:37 INFO - 2015-10-24 07:31:37,732 DEBUG : using testdate: 1445697097 07:31:37 INFO - 2015-10-24 07:31:37,732 DEBUG : actual date: 1445697097 07:31:37 INFO - 2015-10-24 07:31:37,743 INFO : starting webserver on 'localhost:49894' 07:31:37 INFO - 2015-10-24 07:31:37,743 INFO : Starting test suite T-W732-IX-088 07:31:37 INFO - 2015-10-24 07:31:37,743 INFO : Starting test dromaeo_css 07:31:37 INFO - 2015-10-24 07:31:37,743 DEBUG : operating with platform_type : w7_ 07:31:37 INFO - 2015-10-24 07:31:37,744 INFO : Initialising browser for dromaeo_css test... 07:31:37 INFO - 2015-10-24 07:31:37,845 DEBUG : command line: C:\slave\test-pgo\build\application\firefox\firefox -profile c:\users\cltbld\appdata\local\temp\tmpgix_qx\profile http://localhost:49894/getInfo.html 07:31:45 INFO - 2015-10-24 07:31:45,526 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:31:45 INFO - 2015-10-24 07:31:45,526 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:31:45 INFO - 2015-10-24 07:31:45,526 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674 07:31:45 INFO - 2015-10-24 07:31:45,526 DEBUG : BROWSER_OUTPUT: __metrics 07:31:45 INFO - 2015-10-24 07:31:45,588 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:31:46 INFO - 2015-10-24 07:31:46,463 DEBUG : BROWSER_OUTPUT: console.error: 07:31:46 INFO - 2015-10-24 07:31:46,463 DEBUG : BROWSER_OUTPUT: Message: [Exception... "Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [mozIStorageAsyncStatement.executeAsync]" nsresult: "0x80040111 (NS_ERROR_NOT_AVAILABLE)" location: "JS frame :: resource://gre/modules/Sqlite.jsm :: ConnectionData.prototype<._executeStatement :: line 758" data: no] 07:31:46 INFO - 2015-10-24 07:31:46,463 DEBUG : BROWSER_OUTPUT: Stack: 07:31:46 INFO - 2015-10-24 07:31:46,464 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<._executeStatement@resource://gre/modules/Sqlite.jsm:758:19 07:31:46 INFO - 2015-10-24 07:31:46,464 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached/<@resource://gre/modules/Sqlite.jsm:493:9 07:31:46 INFO - 2015-10-24 07:31:46,464 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached@resource://gre/modules/Sqlite.jsm:491:1 07:31:46 INFO - 2015-10-24 07:31:46,464 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeBeforeShutdown/loggedDb<.executeCached.value<@resource://gre/modules/Sqlite.jsm:368:51 07:31:46 INFO - 2015-10-24 07:31:46,464 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 07:31:46 INFO - 2015-10-24 07:31:46,464 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 07:31:46 INFO - 2015-10-24 07:31:46,464 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 07:31:46 INFO - 2015-10-24 07:31:46,464 DEBUG : BROWSER_OUTPUT: transaction@resource://gre/modules/Bookmarks.jsm:783:15 07:31:46 INFO - 2015-10-24 07:31:46,464 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 07:31:46 INFO - 2015-10-24 07:31:46,464 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 07:31:46 INFO - 2015-10-24 07:31:46,464 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 07:31:46 INFO - 2015-10-24 07:31:46,464 DEBUG : BROWSER_OUTPUT: Task_spawn@resource://gre/modules/Task.jsm:164:12 07:31:46 INFO - 2015-10-24 07:31:46,464 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 07:51:20 INFO - 2015-10-24 07:51:20,819 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 07:51:20 INFO - 2015-10-24 07:51:20,819 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 07:51:20 INFO - 2015-10-24 07:51:20,819 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 07:51:20 INFO - 2015-10-24 07:51:20,819 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 07:51:20 INFO - 2015-10-24 07:51:20,819 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 07:51:20 INFO - 2015-10-24 07:51:20,819 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 07:51:20 INFO - 2015-10-24 07:51:20,819 DEBUG : BROWSER_OUTPUT: 07:51:21 INFO - 2015-10-24 07:51:21,430 INFO : Browser initialized. 07:51:21 INFO - 2015-10-24 07:51:21,430 INFO : Running cycle 1/1 for v8_7 test... 07:51:21 INFO - 2015-10-24 07:51:21,430 DEBUG : command line: C:\slave\test-pgo\build\application\firefox\firefox -profile c:\users\cltbld\appdata\local\temp\tmp77kp0e\profile -tp file:\C:\slave\test-pgo\build\tests\talos\talos\tests\v8_7\v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:51:32 INFO - 2015-10-24 07:51:32,832 DEBUG : BROWSER_OUTPUT: RSS: Main: 127246336 07:51:32 INFO - 2015-10-24 07:51:32,832 DEBUG : BROWSER_OUTPUT: 07:51:54 INFO - 2015-10-24 07:51:54,312 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49894/tests/v8_7/run.html (next: http://localhost:49894/tests/v8_7/run.html) 07:51:54 INFO - 2015-10-24 07:51:54,566 DEBUG : BROWSER_OUTPUT: RSS: Main: 488816640 07:51:54 INFO - 2015-10-24 07:51:54,566 DEBUG : BROWSER_OUTPUT: 07:51:54 INFO - 2015-10-24 07:51:54,566 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:51:54 INFO - 2015-10-24 07:51:54,566 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:51:54 INFO - 2015-10-24 07:51:54,566 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:51:54 INFO - 2015-10-24 07:51:54,566 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:51:54 INFO - 2015-10-24 07:51:54,566 DEBUG : BROWSER_OUTPUT: |0;Richards;155.37600994406463 07:51:54 INFO - 2015-10-24 07:51:54,566 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;202.26537216828478 07:51:54 INFO - 2015-10-24 07:51:54,566 DEBUG : BROWSER_OUTPUT: |2;Encrypt;302.11480362537765 07:51:54 INFO - 2015-10-24 07:51:54,566 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5381.720430107527 07:51:54 INFO - 2015-10-24 07:51:54,566 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1392.21140472879 07:51:54 INFO - 2015-10-24 07:51:54,566 DEBUG : BROWSER_OUTPUT: |5;Earley;628.930817610063 07:51:54 INFO - 2015-10-24 07:51:54,566 DEBUG : BROWSER_OUTPUT: |6;Boyer;10536.842105263158 07:51:54 INFO - 2015-10-24 07:51:54,568 DEBUG : BROWSER_OUTPUT: |7;RegExp;29558.823529411766 07:51:54 INFO - 2015-10-24 07:51:54,568 DEBUG : BROWSER_OUTPUT: |8;Splay;638.1620931716656 07:51:54 INFO - 2015-10-24 07:51:54,568 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;5112.244897959184 07:51:54 INFO - 2015-10-24 07:51:54,568 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:51:54 INFO - 2015-10-24 07:51:54,568 DEBUG : BROWSER_OUTPUT: __startTimestamp1445698314561__endTimestamp 07:51:54 INFO - 2015-10-24 07:51:54,568 DEBUG : BROWSER_OUTPUT: 07:51:54 INFO - 2015-10-24 07:51:54,568 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:51:54 INFO - 2015-10-24 07:51:54,568 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:51:54 INFO - 2015-10-24 07:51:54,568 DEBUG : BROWSER_OUTPUT: 07:51:54 INFO - 2015-10-24 07:51:54,568 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:155.38 Median:155.38 stddev:0.00 (0.0%) 07:51:54 INFO - 2015-10-24 07:51:54,568 DEBUG : BROWSER_OUTPUT: Values: 155.4 07:51:54 INFO - 2015-10-24 07:51:54,568 DEBUG : BROWSER_OUTPUT: 07:51:54 INFO - 2015-10-24 07:51:54,568 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:202.27 Median:202.27 stddev:0.00 (0.0%) 07:51:54 INFO - 2015-10-24 07:51:54,568 DEBUG : BROWSER_OUTPUT: Values: 202.3 07:51:54 INFO - 2015-10-24 07:51:54,569 DEBUG : BROWSER_OUTPUT: 07:51:54 INFO - 2015-10-24 07:51:54,569 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:302.11 Median:302.11 stddev:0.00 (0.0%) 07:51:54 INFO - 2015-10-24 07:51:54,569 DEBUG : BROWSER_OUTPUT: Values: 302.1 07:51:54 INFO - 2015-10-24 07:51:54,569 DEBUG : BROWSER_OUTPUT: 07:51:54 INFO - 2015-10-24 07:51:54,569 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5381.72 Median:5381.72 stddev:0.00 (0.0%) 07:51:54 INFO - 2015-10-24 07:51:54,569 DEBUG : BROWSER_OUTPUT: Values: 5381.7 07:51:54 INFO - 2015-10-24 07:51:54,569 DEBUG : BROWSER_OUTPUT: 07:51:54 INFO - 2015-10-24 07:51:54,569 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1392.21 Median:1392.21 stddev:0.00 (0.0%) 07:51:54 INFO - 2015-10-24 07:51:54,569 DEBUG : BROWSER_OUTPUT: Values: 1392.2 07:51:54 INFO - 2015-10-24 07:51:54,569 DEBUG : BROWSER_OUTPUT: 07:51:54 INFO - 2015-10-24 07:51:54,569 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:628.93 Median:628.93 stddev:0.00 (0.0%) 07:51:54 INFO - 2015-10-24 07:51:54,569 DEBUG : BROWSER_OUTPUT: Values: 628.9 07:51:54 INFO - 2015-10-24 07:51:54,569 DEBUG : BROWSER_OUTPUT: 07:51:54 INFO - 2015-10-24 07:51:54,569 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10536.84 Median:10536.84 stddev:0.00 (0.0%) 07:51:54 INFO - 2015-10-24 07:51:54,569 DEBUG : BROWSER_OUTPUT: Values: 10536.8 07:51:54 INFO - 2015-10-24 07:51:54,569 DEBUG : BROWSER_OUTPUT: 07:51:54 INFO - 2015-10-24 07:51:54,569 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:29558.82 Median:29558.82 stddev:0.00 (0.0%) 07:51:54 INFO - 2015-10-24 07:51:54,569 DEBUG : BROWSER_OUTPUT: Values: 29558.8 07:51:54 INFO - 2015-10-24 07:51:54,569 DEBUG : BROWSER_OUTPUT: 07:51:54 INFO - 2015-10-24 07:51:54,569 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:638.16 Median:638.16 stddev:0.00 (0.0%) 07:51:54 INFO - 2015-10-24 07:51:54,569 DEBUG : BROWSER_OUTPUT: Values: 638.2 07:51:54 INFO - 2015-10-24 07:51:54,569 DEBUG : BROWSER_OUTPUT: 07:51:54 INFO - 2015-10-24 07:51:54,569 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:5112.24 Median:5112.24 stddev:0.00 (0.0%) 07:51:54 INFO - 2015-10-24 07:51:54,569 DEBUG : BROWSER_OUTPUT: Values: 5112.2 07:51:54 INFO - 2015-10-24 07:51:54,569 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:51:54 INFO - 2015-10-24 07:51:54,569 DEBUG : BROWSER_OUTPUT: 07:51:55 INFO - 2015-10-24 07:51:55,167 INFO : Browser exited with error code: 0 07:51:55 INFO - 2015-10-24 07:51:55,828 INFO : Completed test v8_7 (00:00:40) 07:51:55 INFO - 2015-10-24 07:51:55,987 INFO : Completed test suite (00:20:18) 07:51:55 INFO - 2015-10-24 07:51:55,987 DEBUG : Working with test: dromaeo_css 07:51:55 INFO - 2015-10-24 07:51:55,987 DEBUG : Generating results file: dromaeo_css 07:51:55 INFO - 2015-10-24 07:51:55,989 DEBUG : Working with test: kraken 07:51:55 INFO - 2015-10-24 07:51:55,989 DEBUG : Generating results file: kraken 07:51:55 INFO - 2015-10-24 07:51:55,989 INFO : javascript benchmark 07:51:55 INFO - 2015-10-24 07:51:55,989 DEBUG : Working with test: v8_7 07:51:55 INFO - 2015-10-24 07:51:55,989 DEBUG : Generating results file: v8_7 07:51:55 INFO - 2015-10-24 07:51:55,989 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:51:56 INFO - 2015-10-24 07:51:56,153 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,201,25]] 07:51:56 INFO - 2015-10-24 07:51:56,153 DEBUG : process_Request line: dromaeo_css 6499.16 graph.html#tests=[[72,201,25]] 07:51:56 INFO - 2015-10-24 07:51:56,153 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:51:56 INFO - 2015-10-24 07:51:56,283 DEBUG : process_Request line: kraken 1588.30 graph.html#tests=[[232,201,25]] 07:51:56 INFO - 2015-10-24 07:51:56,283 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:51:56 INFO - 2015-10-24 07:51:56,413 DEBUG : process_Request line: v8_7 20596.01 graph.html#tests=[[230,201,25]] 07:51:56 INFO - 2015-10-24 07:51:56,414 INFO : javascript benchmark 07:51:56 INFO - 2015-10-24 07:51:56,415 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [318.91389324882294, 324.6445142568888, 330.3063566510328, 330.5636559741143, 335.9932801343973, 16281.267342969566, 16919.915400422997, 17264.309427622913, 17289.827101728995, 17559.0, 12715.745685086316, 16165.757513637305, 16306.0, 16994.83005169948, 17025.318987240527, 5230.163173892178, 5360.6413178201665, 5369.221462887879, 5369.731513424333, 5374.973125134378, 4661.0, 4742.33607294979, 4744.525547445245, 4748.691335063227, 4753.500882407332, 4653.813847446098, 4684.672072954894, 4685.60172385346, 4688.2264426369775, 4689.038747056845, 4674.766261686919, 4675.971286317005, 4679.649026323023, 4681.83613573525, 4685.742284174369, 3290.3748287825238, 3351.4302568563403, 3988.880333589968, 4015.9196816063513, 4094.0992981544014, 13368.13107148042, 13402.0, 13493.797593036112, 13500.594982150551, 13703.862961370358, 1977.831884289837, 1992.5815578728484, 2016.3850025742142, 2031.4718173274907, 2177.7495588007264, 9581.760455988657, 9625.181859541948, 9719.271054670928, 9736.805263894683, 9808.21534277256, 1555.3778488604535, 1596.1141566430626, 1599.5521254048886, 1635.1824087956022, 1648.8928219665684, 71628.64185679039, 74177.0, 74435.0, 74938.25061749422, 76148.0, 6285.779997700059, 6337.493000560036, 6345.777897773556, 6372.58578192416, 6446.935530644633, 7405.259474052552, 7410.333070023724, 7429.962850185822, 7430.405567554582, 7435.925640743523, 5301.284326615858, 5313.707746073926, 5323.760430780624, 5326.840194794162, 5344.4922732340365, 5680.289963754531, 5695.886082278331, 5700.771969121189, 5735.569832262514, 5739.827805165852, 2832.504311745436, 2867.283179205199, 2879.1938257287993, 2883.625128733251, 2885.6970018148213, 1012.3116280928891, 1026.471367245869, 1028.6142696488816, 1032.8554002439664, 1077.3751224289892, 403.6387433247286, 407.11452590615886, 412.82042311593955, 415.128230715495, 439.85484790019217, 10786.0, 11020.393878336768, 11141.888581114246, 11171.16216283782, 11541.422928853692, 421.42054674822117, 451.65674087692935, 454.8089802282983, 469.67592361270613, 479.85844175967475, 5411.78352865881, 6277.905831412441, 6438.54930154894, 6575.80272591823, 6634.96682516594, 430408.0, 437699.0, 438366.0, 438459.0, 438596.0, 76282.23717762751, 76551.61724191344, 76920.0, 77258.61370693111, 79546.0, 470.1161815786368, 494.2536769478114, 509.0252167100036, 509.27428414509177, 510.58132331487826, 10657.14742820588, 10838.187135964992, 10932.234743567873, 11133.83299250528, 11287.887121128684, 42906.0, 42978.570214297455, 43073.78463107665, 43358.56641433545, 43855.34216986811, 57812.132818008606, 58576.4142358588, 59003.704981476534, 59244.815103698544, 59368.406315936285, 6175.62946223228, 6334.841628959313, 6373.681315934092, 6377.808665740035, 6381.840453988688, 12741.872581274069, 12818.935905320413, 12827.230366178059, 12838.229706217657, 12873.163244389085, 10657.680269591925, 10751.0, 10794.190435717195, 10984.450777461256, 10985.39580323058, 10661.680149595524, 10697.946510267398, 10709.357438553712, 10760.515776789907, 10963.232573719763, 9701.223902087957, 9905.158061564847, 10646.627368042082, 10954.233203675667, 11233.943830280796, 5828.242328497268, 6000.849978750566, 6024.728887199999, 6029.78895738647, 6331.841703957438, 9995.450250236016, 10105.24210684187, 10213.131883789962, 10219.437930913871, 10231.641892533726], "dojo.html": [2713.5251331017075, 2754.7658449031833, 2778.5971034200043, 2792.636957195563, 2798.734120258576, 5329.546988505972, 5340.1722732976405, 5420.186971954204, 5427.348718153822, 5442.374126975399, 5354.14333706607, 5360.061989151893, 5462.399136095027, 5472.042392581302, 5472.50747432731, 4527.230370836949, 4632.420947381577, 4693.014466961942, 4705.976470117645, 4707.952920470802, 4585.1746685596745, 4616.838410655628, 4635.374224479702, 4635.791389387486, 4655.604273636745, 4589.196890544158, 4607.58531732144, 4645.210314246569, 4686.929696054562, 4697.389339385875, 4441.933370999438, 4550.795214215352, 4674.626029917598, 4688.789004494806, 4699.201135806921, 4492.0, 4532.093581283723, 4553.066621342617, 4564.383808185886, 4573.679842411033, 5203.635745497817, 5274.103402421598, 5284.947150528484, 5338.973305133488, 5401.675899446007, 5560.944390556083, 5575.749091290861, 5646.887062258732, 5661.433856614347, 5685.459881311269, 5373.328333958255, 5502.58730595203, 5544.667319960775, 5611.66330020196, 5703.885922281531, 5183.974080129613, 5208.348956380452, 5275.261463395128, 5321.760520776575, 5326.600504962104, 5750.6837123958585, 5757.539396848242, 5765.221695071195, 5854.824355269348, 5866.882662346815, 5287.286216360819, 5326.067938110815, 5416.512513873691, 5467.043267428184, 5505.981393442226, 5504.311961004874, 5604.85987850307, 5708.828735137952, 5709.314882214161, 5714.3999880012, 5435.619506634498, 5549.445055494499, 5557.360903496069, 5655.632383895034, 5665.348484924287, 5422.1053526168525, 5544.140658197905, 5558.499735023867, 5586.217929489874, 5637.295338082739, 3480.843362048714, 3485.4771784232566, 3556.3598552260323, 3560.4659301105044, 3563.483294922222, 3141.7800753947004, 3194.6326172490462, 3245.4807230842953, 3253.4631785755087, 3255.3326568053494, 5181.274621552986, 5280.260763493114, 5311.628186027018, 5314.123169677037, 5342.332208473941, 5636.126400407943, 5673.1490276458035, 5697.173909783059, 5744.080947048452, 5753.194552762617, 5222.895542089137, 5316.069687804618, 5339.46605339463, 5441.211024401518, 5444.237806707064, 4135.58644135584, 4342.848000320037, 4401.823927042882, 4454.977725111354, 4458.710183838105, 5927.614705044159, 5930.8813823723285, 6022.066579680157, 6035.517158627387, 6049.879002419927, 5447.046766815871, 5602.775888964559, 5636.818050563039, 5773.162891380643, 5773.624714393551, 5754.798582049608, 5928.021876390348, 5950.940490595039, 6001.609895356788, 6026.638401695912, 5546.805861794818, 5549.500544950813, 5620.409856965123, 5644.774209031592, 5670.574706897081, 5537.197106419466, 5557.527610153183, 5634.126710359901, 5653.236813030353, 5787.247657804459, 5301.125314323093, 5436.429174936575, 5505.366882808368, 5550.55595552363, 5579.358373787067, 5309.415964243853, 5490.615656903979, 5529.391766905717, 5587.916181257203, 5617.129344951539, 5160.896782064263, 5230.607704422259, 5325.0, 5495.368032676293, 5498.0653288940175, 5433.239346491573, 5481.766602514562, 5530.778768849362, 5554.222408862844, 5641.323041235078, 5233.371995360581, 5239.633225674166, 5384.111621582551, 5454.836354909359, 5457.317835270591], "mootools.html": [1258.7797135501287, 1334.2261488336765, 1454.6872422429178, 1549.6048507630553, 1579.1630435868979, 8008.799780005488, 8186.304164146055, 8796.516191609458, 9023.187913087813, 9028.368014239006, 8442.282405995498, 8857.95571022144, 8885.289176865852, 8894.332925030632, 8927.37508374414, 2213.1147540983575, 2233.184887516053, 2240.596692595332, 2241.4396400899777, 2241.697370854938, 1938.7188857615638, 2011.0347033423966, 2195.769444208351, 2267.841251112423, 2288.7482376938524, 2128.382768996989, 2136.797004284598, 2226.877521736304, 2233.687283780272, 2235.832312576555, 1985.7517810273716, 2206.6359050756605, 2212.778722127782, 2219.87790671513, 2222.1333679864865, 1986.02684684505, 2109.89450527473, 2221.555688862234, 2228.0753487302914, 2230.3866436730027, 8755.080716524737, 8829.60266787996, 8854.114588541159, 8858.734237972807, 8859.379843410963, 5092.3125378073855, 5113.386393632751, 5133.537981581639, 5162.354705661793, 5165.74171291434, 3466.445368740989, 3531.5055892175114, 3542.1498840278405, 3543.8405271762576, 3551.6803487686234, 1005.9446730429823, 1030.3354336453021, 1052.542144167282, 1059.6503153959175, 1061.2359101446946, 12627.179233349894, 12674.176178548365, 12761.553345632858, 12816.935915320364, 12883.613491595268, 4393.912121757547, 4427.955720442818, 4543.704659197141, 4563.292689633112, 4600.401947746838, 10424.68725938223, 10482.213833962483, 10524.736881577868, 10529.36823790575, 10536.209784266211, 5091.490850914879, 5097.745112744348, 5098.388193416814, 5105.361829771278, 5121.4878512149235, 4584.97707511467, 4646.4888862225125, 4654.86035418938, 4654.906901861944, 4656.16189085961, 3680.35593771089, 3715.8142092895246, 3729.4405839123806, 3739.6447337502896, 3741.8877433677035, 1091.1870656360902, 1130.8416821644976, 1162.9709257268466, 1163.8894305041008, 1172.9941350293193, 1118.669992352258, 1135.6706555098929, 1150.3328069719544, 1153.5212886652114, 1156.4680247086435, 7939.404544659174, 7940.761777146695, 7946.682132714626, 7947.0, 7990.121086680577, 442.087090158821, 446.8458381858319, 450.1402321565794, 455.0330547586379, 464.2525533890434, 5404.0, 5485.753141108659, 6016.548758843017, 6048.0, 6319.715612797435, 10854.67435976922, 10921.399323037309, 10936.890631093745, 10955.671329860117, 10978.505967231495, 9548.474833884064, 10504.317219380715, 10704.19718521114, 10709.143268538499, 10738.624148154933, 7827.373810095179, 7843.098043724931, 7901.486403383762, 7915.762527124196, 7935.1830100313555, 7723.1118421380015, 7879.881801773093, 7902.4863383879865, 7912.406569507425, 7913.089994650689, 9382.483963381806, 9601.135897768954, 9655.9034409655, 9697.951510242403, 9707.757306067404, 9773.560189791335, 9824.607015719292, 9923.950380248052, 10034.548445320124, 10078.596856125967, 7751.496152750054, 7865.41009424284, 7898.170692077479, 7921.920780792118, 7942.761717148494, 8712.0, 8720.084391138838, 8720.956395217983, 8747.956260218658, 8754.25588824957, 7862.449628525948, 7924.286814186751, 8010.158933312151, 8087.716929907425, 8107.716229931924, 7739.380849532136, 7811.1017233016655, 7883.251091146332, 7916.0, 7947.761567152995, 7312.19565847767, 7376.151742549676, 7522.210167932289, 7604.961975190088, 7684.615769211406, 6407.679616019273, 6484.643344616092, 6552.0, 6641.0, 6649.368310010541, 6219.004959206505, 6264.342244064308, 6302.905456418066, 6325.462335701517, 6368.331325210971], "ext.html": [480.50507976783905, 506.5441103007292, 511.1667981190659, 513.0406140517233, 515.0574448758772, 31423.371532569334, 31716.365672686534, 31716.84141579292, 36726.81636591813, 36907.815460922655, 38904.0, 38967.610323896755, 39198.41202381966, 39371.40942885852, 39404.21191576174, 7791.844163116734, 8055.838883222332, 8160.102388737234, 8226.054003789552, 8243.711470098548, 7759.728409505668, 9795.167410770093, 10191.59233630654, 10194.388336699822, 10203.489825508696, 9995.400275983464, 10072.244581656369, 10087.142592879614, 10092.091711745941, 10107.898921010807, 7876.330511906466, 8014.238647328494, 9902.306838521306, 9959.452230127341, 10002.699919002442, 9643.421394716339, 9719.951400242953, 9754.658586949423, 9767.560459779326, 9776.217902567849, 34734.0, 35015.299694005975, 35068.82465587656, 35101.297974040375, 35101.29797404063, 3179.459491886385, 3220.372027454647, 3281.196106953788, 3349.464085746269, 3793.7534060285993, 29044.41911161786, 29551.11346659582, 29616.407671846442, 29775.851120744475, 30532.0, 2718.877650505732, 2782.5130602144545, 2797.930051748702, 2813.0295048208336, 2891.840948747818, 289781.0, 294254.0, 297144.0, 298722.0, 298803.5059824709, 45078.0, 45899.311510327374, 51387.743061285204, 51521.7423912878, 51633.0, 54883.0, 54983.0, 55896.16155757667, 56005.719971399885, 56122.0, 13653.658658533615, 13804.378802953892, 13929.233892135828, 13932.93033534826, 14013.719725605635, 10531.262811603268, 10598.04617584421, 10674.946625266824, 10675.946620267005, 10689.091427228617, 16881.662366752596, 16904.239309231114, 16989.830101699074, 17029.914850425917, 17056.2324695389, 7342.669579868919, 7443.8883416748795, 7548.358389536951, 7592.620368981528, 7601.315881570686, 852.6205838401976, 911.7994041310901, 923.4505469245788, 925.3383830561181, 1025.4565080507343, 27295.86352068227, 28076.57885131725, 28356.43287134246, 28383.43233135326, 28402.573961390597, 1044.9791004179874, 1051.138066785244, 1053.4311471805293, 1067.6636859389268, 1135.9488823002985, 14736.410543578351, 14757.852421475862, 14815.185164815823, 14963.177025263498, 15002.92498537522, 348364.0, 360193.0, 360262.0, 360291.0, 360334.7096284041, 45548.3167752484, 46107.0, 46160.53839461562, 46161.076778464914, 46181.30728039082, 1184.6919800851667, 1194.5580135349976, 1201.1171788735273, 1210.7396909664465, 1212.3877441891789, 27542.0, 27759.861200693867, 28138.577921330787, 28242.85878570676, 28324.716752832206, 40351.59648403478, 41310.79344603258, 41365.58634413617, 41482.37776433416, 41551.168976619694, 345779.0, 348371.0, 348871.413645015, 348914.1737322016, 349092.0, 24105.0, 24368.51262974766, 26660.733392665825, 26819.597706034816, 27366.5895011571, 37350.81324593468, 37680.594298968696, 38788.0, 38856.41715374215, 38910.221795564496, 30690.386192276477, 31994.840025799724, 34275.4858677125, 34571.30857382889, 34845.477317839745, 33664.699750103224, 33764.493532597524, 33886.152846179044, 34011.48982765211, 35024.47463288002, 34321.31357372888, 34997.65002349944, 35010.474842877884, 35022.29955400827, 35125.0, 25220.0, 28653.120391892397, 29236.853815730785, 30098.946536871103, 31613.0, 23037.65443518315, 24817.379565510284, 24840.00639974381, 24948.875255623607, 24980.250592482254], "prototype.html": [318.0791608293989, 321.36530352553694, 332.6374252065248, 335.14370782650326, 335.93953088444084, 5778.162166485857, 5796.565257605681, 5796.652200867946, 5811.506021988125, 5812.0, 5610.24261724667, 5732.369439361667, 5750.654960702351, 5755.223044888939, 5768.077107662775, 4171.228322760291, 4194.853180138696, 4270.658347332222, 4273.0, 4273.038566322583, 4233.216854881842, 4255.404243405926, 4277.850275240367, 4278.72188307759, 4282.614564689177, 4112.897177570555, 4229.936550951738, 4236.703430759848, 4236.83052677894, 4237.4915010198665, 4051.0885050863612, 4099.159672267193, 4135.58644135584, 4198.895027624319, 4200.390943313233, 3653.1232504199065, 3663.688586470153, 3675.7794532328144, 3683.1528748387755, 3687.2809802088605, 5509.586780991402, 5592.0, 5609.326880774333, 5633.267675202197, 5645.266115405012, 4915.238138088602, 4978.054169707744, 5000.67495612784, 5007.649464537484, 5017.448080711119, 6001.2498437695285, 6004.8498787530225, 6007.7596896124105, 6008.309044459899, 6011.57918945674, 4108.958910410917, 4148.149629326011, 4151.91696166078, 4153.252414565377, 4153.937690934638, 6159.445649891486, 6204.162438070848, 6290.056491526262, 6292.433680968735, 6299.9370006299805, 4050.4531888194715, 4110.0, 4134.896627584334, 4179.582041795857, 4250.53244143144, 4170.833166673299, 4260.339647354665, 4308.719933204332, 4309.569043095728, 4310.956890431055, 4947.35684361038, 4975.4527002029745, 4978.228374601942, 4984.875378115504, 4986.152354099811, 6011.789587364421, 6030.577859549877, 6031.849203769853, 6034.939650603438, 6039.184710064173, 1528.3733669195576, 1549.4576898085804, 1557.4860296102258, 1557.9532614021598, 1558.4701201591513, 991.7718924647371, 1026.2662196529368, 1036.6112707734599, 1038.5430410619304, 1044.5612842606124, 5827.4172582741385, 5854.268216472941, 5854.297484301911, 5857.355690874, 5883.441073098049, 6054.636721796706, 6209.099680546386, 6245.594036387621, 6246.281677607042, 6249.531285153632, 5806.44838740319, 5867.70661466925, 5871.882562348815, 5877.500412464903, 5888.4700376966275, 3380.0704806178005, 3444.586649602064, 3459.6713312235297, 3466.046837119812, 3468.809215493172, 6588.077669126326, 6613.933860661428, 6629.86740265192, 6634.369734875179, 6640.269570347258, 6174.845628859314, 6348.3969022943675, 6351.364863513611, 6358.046293056079, 6372.904406433907, 6605.768798092044, 6616.106825578581, 6626.204855417381, 6632.104665870046, 6633.568818026909, 6077.24034495688, 6256.405641464054, 6260.530460215411, 6265.0, 6270.7805226816845, 5869.295684517885, 6142.78500252489, 6171.290301615371, 6178.752849886134, 6183.783567575293, 6530.7387704493185, 6629.370209830058, 6631.933680663132, 6637.634930078699, 6641.966790166019, 4284.764337961442, 4296.248156572525, 4301.0537681709975, 4306.849260275875, 4308.978455107705, 5875.471207591338, 5966.791162309299, 6269.871423143878, 6289.874202516015, 6293.118963345227, 6053.818385448443, 6154.907676384768, 6155.169052177898, 6162.630242185483, 6164.291106522807, 6049.546284028627, 6090.23872015998, 6105.236845394325, 6108.0, 6108.373399438285, 5960.612560183574, 5965.970170149121, 5968.074948383008, 5976.7908123215475, 5977.372375900468, 6021.668808215591, 6122.2959359674205, 6122.693865306628, 6125.958587040125, 6132.47873930703, 5976.850578735566, 5986.970065149821, 6008.639481631116, 6018.51851851842, 6022.698865056817], "yui.html": [688.3254410677536, 699.7061234281601, 733.4828945593357, 742.8440027594205, 778.6768491076203, 13065.67335816605, 13312.467501299936, 13341.7331653367, 13517.256550889697, 13576.796348054788, 12577.685557861058, 12632.431540580674, 12645.304508252042, 12665.746685066293, 12667.809982850242, 504.56607317706744, 511.0698528677808, 569.6838254768602, 588.2117961931011, 591.9260092488439, 587.9294484661847, 591.2579712460877, 593.8040446652594, 594.343250707968, 596.31126049413, 590.4951266667002, 610.4414460768392, 618.9535784816135, 620.7268801727225, 620.9906851397233, 517.1208944793847, 535.0769921884756, 613.3682307223567, 621.9160413344185, 625.2434554189414, 445.19642046106765, 449.3237677295649, 449.4651364875787, 450.1537110232741, 450.3784777007708, 12689.619311420673, 12777.552785652457, 12783.23300601967, 12831.807522887164, 12844.422001009976, 11596.94201528987, 11788.882111178864, 12069.0, 12402.627921162379, 12433.079108718373, 10282.7429314267, 10311.587536498606, 10360.533775980099, 10487.423191724452, 10671.146308295318, 3491.1970246843366, 3538.628444013393, 3568.125809176768, 3631.382664946965, 3728.366177749762, 43829.0, 47970.0, 48023.27965080561, 48187.0, 48264.27603585949, 9050.094990500897, 9490.857637135448, 9585.472798996123, 9743.220542356594, 9784.706458806248, 17186.828131718772, 17246.396376127028, 17256.568585785455, 17275.3953611623, 17285.481435556954, 7429.7996118317005, 7532.17146113927, 7544.849103017909, 7564.167941526538, 7704.30661240491, 4213.662906967435, 4221.894452638647, 4265.1043280910735, 4282.785860707015, 4429.313456414261, 2822.407294468144, 2840.5739139129296, 2874.3101655602923, 2890.2774306423394, 2893.7106289370895, 463.1755475254053, 466.79227743653746, 469.139129697003, 475.9690620109682, 477.75156918402234, 615.2862679292, 710.4884483172108, 711.7651175112201, 713.1762813949896, 714.5855403865745, 8994.86507702385, 9012.684556040507, 9221.677241296657, 9278.675246366345, 9461.38500997433, 529.370049640926, 648.9837754056092, 668.8996650502463, 695.7286658203304, 735.4447392218841, 4201.516825565099, 4385.96054328928, 4414.867553973386, 4466.863077701411, 4559.566841150086, 52668.473315266354, 53590.464095359326, 53670.0, 53825.461745382825, 54012.0, 47955.520444795104, 48187.518124819006, 49018.0, 50175.0, 50182.49817501778, 41786.373204401956, 41833.37249941253, 42093.36859947042, 42310.0, 42410.15179696389, 8543.914560854311, 8722.897105193533, 8745.956270218609, 8862.42394244372, 8894.243989260727, 29004.12987610375, 29540.556891646214, 29799.106026818365, 29835.70164298329, 29948.550771738875, 38732.0, 39101.80449097736, 40602.1879562413, 41033.0, 41138.588614113476, 7853.37173026168, 7892.84214315699, 8138.796530086558, 8170.836583268182, 8385.287250583524, 12226.00489756929, 12280.324582148067, 12413.0, 12636.684082898, 12648.43082061328, 10970.890291096986, 11160.553577856796, 11389.43052847371, 11745.530178792753, 11887.702807429883, 11253.549858005588, 11504.424778761197, 11534.826977595176, 11590.768184636428, 11649.184557080924, 11384.943075284571, 11600.245984011011, 11743.941280293544, 11840.467178977138, 11958.820617690568, 9659.227261819178, 9748.805023899624, 9874.555644996137, 9982.800343993225, 10084.193264538673, 9351.0, 9594.520273986413, 9770.56032478526, 9891.950540247253, 9928.751781205528]}, "summary": {"suite": 6499.159418191476, "subtests": {"jquery.html": {"filtered": 6803.508220199301, "value": 6803.508220199301}, "dojo.html": {"filtered": 5078.736574211663, "value": 5078.736574211663}, "mootools.html": {"filtered": 4662.559823561159, "value": 4662.559823561159}, "ext.html": {"filtered": 17562.941582837855, "value": 17562.941582837855}, "prototype.html": {"filtered": 4556.232270806535, "value": 4556.232270806535}, "yui.html": {"filtered": 5845.088873620651, "value": 5845.088873620651}}}, "test_machine": {"platform": "x86", "osversion": "6.1.7601", "os": "win", "name": "T-W732-IX-088"}, "testrun": {"date": 1445697097, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a1", "id": "20151024023017", "branch": "B2G-Inbound", "revision": "e76e31d7414b027b54603f9cf6b793b7c32e2dfe"}}, {"talos_counters": {}, "results": {"audio-dft": [162.0, 163.0, 159.0, 161.0, 164.0, 158.0, 161.0, 158.0, 160.0, 163.0], "ai-astar": [95.0, 85.0, 96.0, 96.0, 93.0, 95.0, 95.0, 96.0, 99.0, 104.0], "imaging-gaussian-blur": [117.0, 116.0, 116.0, 119.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0], "audio-beat-detection": [132.0, 130.0, 141.0, 153.0, 133.0, 130.0, 139.0, 134.0, 157.0, 128.0], "json-stringify-tinderbox": [77.0, 77.0, 78.0, 77.0, 77.0, 77.0, 77.0, 79.0, 77.0, 77.0], "stanford-crypto-pbkdf2": [186.0, 194.0, 197.0, 192.0, 194.0, 186.0, 194.0, 193.0, 193.0, 186.0], "json-parse-financial": [82.0, 82.0, 82.0, 81.0, 81.0, 81.0, 82.0, 81.0, 82.0, 93.0], "stanford-crypto-sha256-iterative": [85.0, 85.0, 85.0, 83.0, 88.0, 86.0, 85.0, 84.0, 89.0, 86.0], "audio-fft": [89.0, 98.0, 92.0, 101.0, 74.0, 76.0, 77.0, 78.0, 101.0, 77.0], "imaging-darkroom": [139.0, 139.0, 139.0, 139.0, 139.0, 139.0, 139.0, 144.0, 139.0, 141.0], "stanford-crypto-ccm": [120.0, 119.0, 123.0, 120.0, 124.0, 122.0, 120.0, 118.0, 123.0, 124.0], "audio-oscillator": [96.0, 96.0, 113.0, 99.0, 103.0, 97.0, 120.0, 95.0, 95.0, 118.0], "stanford-crypto-aes": [95.0, 96.0, 99.0, 96.0, 95.0, 95.0, 97.0, 95.0, 95.0, 97.0], "imaging-desaturate": [94.0, 93.0, 97.0, 93.0, 94.0, 94.0, 93.0, 97.0, 93.0, 92.0]}, "summary": {"suite": 1588.3, "subtests": {"audio-fft": {"filtered": 86.3, "value": 86.3}, "stanford-crypto-pbkdf2": {"filtered": 191.5, "value": 191.5}, "audio-beat-detection": {"filtered": 137.7, "value": 137.7}, "stanford-crypto-ccm": {"filtered": 121.3, "value": 121.3}, "imaging-darkroom": {"filtered": 139.7, "value": 139.7}, "json-parse-financial": {"filtered": 82.7, "value": 82.7}, "audio-oscillator": {"filtered": 103.2, "value": 103.2}, "ai-astar": {"filtered": 95.4, "value": 95.4}, "audio-dft": {"filtered": 160.9, "value": 160.9}, "stanford-crypto-sha256-iterative": {"filtered": 85.6, "value": 85.6}, "json-stringify-tinderbox": {"filtered": 77.3, "value": 77.3}, "imaging-gaussian-blur": {"filtered": 116.7, "value": 116.7}, "stanford-crypto-aes": {"filtered": 96.0, "value": 96.0}, "imaging-desaturate": {"filtered": 94.0, "value": 94.0}}}, "test_machine": {"platform": "x86", "osversion": "6.1.7601", "os": "win", "name": "T-W732-IX-088"}, "testrun": {"date": 1445697097, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a1", "id": "20151024023017", "branch": "B2G-Inbound", "revision": "e76e31d7414b027b54603f9cf6b793b7c32e2dfe"}}, {"talos_counters": {}, "results": {"DeltaBlue": [202.26537216828478], "Encrypt": [302.11480362537765], "NavierStokes": [5112.244897959184], "Decrypt": [5381.720430107527], "Splay": [638.1620931716656], "Richards": [155.37600994406463], "RegExp": [29558.823529411766], "Earley": [628.930817610063], "Boyer": [10536.842105263158], "RayTrace": [1392.21140472879]}, "summary": {"suite": 20596.00598320895, "subtests": {"DeltaBlue": {"filtered": 326.88739199999986, "value": 326.88739199999986}, "Encrypt": {"filtered": 881.0591099999997, "value": 881.0591099999997}, "NavierStokes": {"filtered": 290.28343313373273, "value": 290.28343313373273}, "Decrypt": {"filtered": 49.46020579420577, "value": 49.46020579420577}, "Splay": {"filtered": 127.69639699999996, "value": 127.69639699999996}, "RegExp": {"filtered": 30.819393034825872, "value": 30.819393034825872}, "Richards": {"filtered": 227.203672, "value": 227.203672}, "Earley": {"filtered": 1059.67617, "value": 1059.67617}, "Boyer": {"filtered": 63.25073426573423, "value": 63.25073426573423}, "RayTrace": {"filtered": 531.5205704295705, "value": 531.5205704295705}}}, "test_machine": {"platform": "x86", "osversion": "6.1.7601", "os": "win", "name": "T-W732-IX-088"}, "testrun": {"date": 1445697097, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a1", "id": "20151024023017", "branch": "B2G-Inbound", "revision": "e76e31d7414b027b54603f9cf6b793b7c32e2dfe"}}] 07:51:56 INFO - RETURN: dromaeo_css: 6499.16 07:51:56 INFO - RETURN: kraken: 1588.30 07:51:56 INFO - RETURN: v8_7: 20596.01 07:51:56 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,25]]", "result": "20596.01"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,25]]", "result": "1588.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,25]]", "result": "6499.16"}}} 07:51:56 INFO - Return code: 0 07:51:56 INFO - # TBPL SUCCESS # 07:51:56 INFO - Running post-action listener: _resource_record_post_action 07:51:56 INFO - Running post-run listener: _resource_record_post_run 07:51:57 INFO - Total resource usage - Wall time: 1221s; CPU: 13.0%; Read bytes: 72980992; Write bytes: 426446848; Read time: 1032040; Write time: 4389540 07:51:57 INFO - install - Wall time: 2s; CPU: 13.0%; Read bytes: 0; Write bytes: 1268224; Read time: 0; Write time: 16630 07:51:57 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 72980992; Write bytes: 402736640; Read time: 1032040; Write time: 4354790 07:51:57 INFO - Running post-run listener: _upload_blobber_files 07:51:57 INFO - Blob upload gear active. 07:51:57 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:51:57 INFO - Copying logs to upload dir... 07:51:57 INFO - mkdir: C:\slave\test-pgo\build\upload\logs program finished with exit code 0 elapsedTime=1487.443000 ========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 24 mins, 47 secs) (at 2015-10-24 07:51:57.777015) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-24 07:51:57.780376) ========= '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-088 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-088 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-088 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 build_url:https://queue.taskcluster.net/v1/task/kOaQf_hKTbu_Wh4SWoY5NA/artifacts/public/build/firefox-44.0a1.en-US.win32.zip program finished with exit code 0 elapsedTime=0.102000 build_url: 'https://queue.taskcluster.net/v1/task/kOaQf_hKTbu_Wh4SWoY5NA/artifacts/public/build/firefox-44.0a1.en-US.win32.zip' ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-24 07:51:57.899044) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-24 07:51:57.899414) ========= '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-088 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-088 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-088 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 ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-24 07:51:58.013883) ========= ========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2015-10-24 07:51:58.014202) ========= ========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2015-10-24 07:51:58.497224) =========