builder: mozilla-inbound_win7-ix_test-dromaeojs-pgo slave: t-w732-ix-028 starttime: 1445951472.82 results: success (0) buildid: 20151027013036 builduid: b6afc3d232bf4a17bf41d9570a877a77 revision: f1966d9bbf475e1ed4a3aeaaac0be37fdb61c1ab ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-27 06:11:12.818790) ========= master: http://buildbot-master109.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-27 06:11:12.819958) ========= ========= Started set props: basedir (results: 0, elapsed: 41 secs) (at 2015-10-27 06:11:12.820260) ========= '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-028 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-028 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-028 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.561000 basedir: 'C:\\slave\\test-pgo' ========= Finished set props: basedir (results: 0, elapsed: 41 secs) (at 2015-10-27 06:11:54.053678) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 2 mins, 16 secs) (at 2015-10-27 06:11:54.053966) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 2 mins, 16 secs) (at 2015-10-27 06:14:10.428684) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 37 secs) (at 2015-10-27 06:14:10.429075) ========= '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-028 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-028 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-028 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.501000 ========= Finished 'rm -rf ...' (results: 0, elapsed: 37 secs) (at 2015-10-27 06:14:48.400496) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-27 06:14:48.400819) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-27 06:14:48.401523) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 27 secs) (at 2015-10-27 06:14:48.401851) ========= '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-028 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-028 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-028 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 --06:14:58-- 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% 12.53 MB/s 06:14:59 (12.53 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.711000 ========= Finished 'bash -c ...' (results: 0, elapsed: 27 secs) (at 2015-10-27 06:15:16.351574) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 29 secs) (at 2015-10-27 06:15:16.351916) ========= '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-028 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-028 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-028 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=8.701000 ========= Finished 'rm -rf ...' (results: 0, elapsed: 29 secs) (at 2015-10-27 06:15:45.842771) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 30 secs) (at 2015-10-27 06:15:45.843140) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev f1966d9bbf475e1ed4a3aeaaac0be37fdb61c1ab --destination scripts --debug' in dir C:\slave\test-pgo\. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev f1966d9bbf475e1ed4a3aeaaac0be37fdb61c1ab --destination scripts --debug'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files\Common Files COMPUTERNAME=T-W732-IX-028 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-028 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-028 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-27 06:16:12,125 truncating revision to first 12 chars 2015-10-27 06:16:12,125 Setting DEBUG logging. 2015-10-27 06:16:12,125 attempt 1/10 2015-10-27 06:16:12,125 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/f1966d9bbf47?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-10-27 06:16:13,424 unpacking tar archive at: mozilla-inbound-f1966d9bbf47/testing/mozharness/ program finished with exit code 0 elapsedTime=1.974000 ========= Finished 'bash -c ...' (results: 0, elapsed: 30 secs) (at 2015-10-27 06:16:16.085040) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 54 secs) (at 2015-10-27 06:16:16.085406) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 54 secs) (at 2015-10-27 06:17:10.230654) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-27 06:17:10.230911) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-27 06:17:10.231278) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 25 mins, 31 secs) (at 2015-10-27 06:17:10.231579) ========= 'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'dromaeojs' '--add-option' '--webServer,localhost' '--branch-name' 'Mozilla-Inbound' '--system-bits' '32' '--cfg' 'talos/windows_config.py' '--download-symbols' 'ondemand' '--use-talos-json' '--blob-upload-branch' 'Mozilla-Inbound' in dir C:\slave\test-pgo\. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['c:/mozilla-build/python27/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '32', '--cfg', 'talos/windows_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files\Common Files COMPUTERNAME=T-W732-IX-028 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-028 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-028 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 06:17:10 INFO - MultiFileLogger online at 20151027 06:17:10 in C:\slave\test-pgo 06:17:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 32 --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 06:17:10 INFO - Dumping config to C:\slave\test-pgo\logs\localconfig.json. 06:17:10 INFO - {'append_to_log': False, 06:17:10 INFO - 'base_work_dir': 'C:\\slave\\test-pgo', 06:17:10 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 06:17:10 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test-pgo\\oauth.txt', 06:17:10 INFO - 'branch': 'Mozilla-Inbound', 06:17:10 INFO - 'buildbot_json_path': 'buildprops.json', 06:17:10 INFO - 'config_files': ('talos/windows_config.py',), 06:17:10 INFO - 'default_actions': ('clobber', 06:17:10 INFO - 'read-buildbot-config', 06:17:10 INFO - 'download-and-extract', 06:17:10 INFO - 'populate-webroot', 06:17:10 INFO - 'create-virtualenv', 06:17:10 INFO - 'install', 06:17:10 INFO - 'run-tests'), 06:17:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:17:10 INFO - 'download_minidump_stackwalk': True, 06:17:10 INFO - 'download_symbols': 'ondemand', 06:17:10 INFO - 'exes': {'easy_install': ('C:\\slave\\test-pgo\\build/venv/scripts/python', 06:17:10 INFO - 'C:\\slave\\test-pgo\\build/venv/scripts/easy_install-2.7-script.py'), 06:17:10 INFO - 'hg': 'c:/mozilla-build/hg/hg', 06:17:10 INFO - 'mozinstall': ('C:\\slave\\test-pgo\\build/venv/scripts/python', 06:17:10 INFO - 'C:\\slave\\test-pgo\\build/venv/scripts/mozinstall-script.py'), 06:17:10 INFO - 'python': 'c:/mozilla-build/python27/python.exe', 06:17:10 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe', 06:17:10 INFO - 'C:/mozilla-build/tooltool.py'), 06:17:10 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe', 06:17:10 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 06:17:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:17:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:17:10 INFO - 'installer_path': 'installer.exe', 06:17:10 INFO - 'log_level': 'info', 06:17:10 INFO - 'log_name': 'talos', 06:17:10 INFO - 'log_to_console': True, 06:17:10 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe', 06:17:10 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe', 06:17:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest', 06:17:10 INFO - 'opt_config_files': (), 06:17:10 INFO - 'pip_index': False, 06:17:10 INFO - 'sps_profile': False, 06:17:10 INFO - 'sps_profile_interval': 0, 06:17:10 INFO - 'suite': 'dromaeojs', 06:17:10 INFO - 'system_bits': '32', 06:17:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:17:10 INFO - 'title': 'T-W732-IX-028', 06:17:10 INFO - 'use_talos_json': True, 06:17:10 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'), 06:17:10 INFO - 'virtualenv_path': 'C:\\slave\\test-pgo\\build/venv', 06:17:10 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll', 06:17:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:17:10 INFO - 'work_dir': 'build'} 06:17:10 INFO - ##### 06:17:10 INFO - ##### Running clobber step. 06:17:10 INFO - ##### 06:17:10 INFO - Running pre-action listener: _resource_record_pre_action 06:17:10 INFO - Running main action method: clobber 06:17:10 INFO - rmtree: C:\slave\test-pgo\build 06:17:10 INFO - Using _rmtree_windows ... 06:17:10 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test-pgo\\build',), kwargs: {}, attempt #1 06:19:52 INFO - Running post-action listener: _resource_record_post_action 06:19:52 INFO - ##### 06:19:52 INFO - ##### Running read-buildbot-config step. 06:19:52 INFO - ##### 06:19:52 INFO - Running pre-action listener: _resource_record_pre_action 06:19:52 INFO - Running main action method: read_buildbot_config 06:19:52 INFO - Using buildbot properties: 06:19:52 INFO - { 06:19:52 INFO - "properties": { 06:19:52 INFO - "buildnumber": 365, 06:19:52 INFO - "product": "firefox", 06:19:52 INFO - "script_repo_revision": "production", 06:19:52 INFO - "builddir": "mozilla-inbound_win7-ix_test-dromaeojs", 06:19:52 INFO - "repository": "", 06:19:52 INFO - "buildername": "Windows 7 32-bit mozilla-inbound pgo talos dromaeojs", 06:19:52 INFO - "buildid": "20151027013036", 06:19:52 INFO - "slavename": "t-w732-ix-028", 06:19:52 INFO - "pgo_build": "True", 06:19:52 INFO - "basedir": "C:\\slave\\test-pgo", 06:19:52 INFO - "project": "", 06:19:52 INFO - "platform": "win7-ix", 06:19:52 INFO - "master": "http://buildbot-master109.bb.releng.scl3.mozilla.com:8201/", 06:19:52 INFO - "slavebuilddir": "test", 06:19:52 INFO - "scheduler": "tests-mozilla-inbound-win32-pgo-talos", 06:19:52 INFO - "branch": "mozilla-inbound", 06:19:52 INFO - "repo_path": "integration/mozilla-inbound", 06:19:52 INFO - "stage_platform": "win32-pgo", 06:19:52 INFO - "builduid": "b6afc3d232bf4a17bf41d9570a877a77", 06:19:52 INFO - "revision": "f1966d9bbf475e1ed4a3aeaaac0be37fdb61c1ab" 06:19:52 INFO - }, 06:19:52 INFO - "sourcestamp": { 06:19:52 INFO - "repository": "", 06:19:52 INFO - "hasPatch": false, 06:19:52 INFO - "project": "", 06:19:52 INFO - "branch": "mozilla-inbound-win32-pgo-talos", 06:19:52 INFO - "changes": [ 06:19:52 INFO - { 06:19:52 INFO - "category": null, 06:19:52 INFO - "files": [ 06:19:52 INFO - { 06:19:52 INFO - "url": null, 06:19:52 INFO - "name": "https://queue.taskcluster.net/v1/task/Du_rld6bSpy-eFpAA-elIA/artifacts/public/build/firefox-44.0a1.en-US.win32.zip" 06:19:52 INFO - } 06:19:52 INFO - ], 06:19:52 INFO - "repository": "", 06:19:52 INFO - "rev": "f1966d9bbf475e1ed4a3aeaaac0be37fdb61c1ab", 06:19:52 INFO - "who": "sendchange", 06:19:52 INFO - "when": 1445950550, 06:19:52 INFO - "number": 6579874, 06:19:52 INFO - "comments": "", 06:19:52 INFO - "project": "", 06:19:52 INFO - "at": "Tue 27 Oct 2015 05:55:50", 06:19:52 INFO - "branch": "mozilla-inbound-win32-pgo-talos", 06:19:52 INFO - "revlink": "", 06:19:52 INFO - "properties": [ 06:19:52 INFO - [ 06:19:52 INFO - "buildid", 06:19:52 INFO - "20151027013036", 06:19:52 INFO - "Change" 06:19:52 INFO - ], 06:19:52 INFO - [ 06:19:52 INFO - "builduid", 06:19:52 INFO - "b6afc3d232bf4a17bf41d9570a877a77", 06:19:52 INFO - "Change" 06:19:52 INFO - ], 06:19:52 INFO - [ 06:19:52 INFO - "pgo_build", 06:19:52 INFO - "True", 06:19:52 INFO - "Change" 06:19:52 INFO - ] 06:19:52 INFO - ], 06:19:52 INFO - "revision": "f1966d9bbf475e1ed4a3aeaaac0be37fdb61c1ab" 06:19:52 INFO - } 06:19:52 INFO - ], 06:19:52 INFO - "revision": "f1966d9bbf475e1ed4a3aeaaac0be37fdb61c1ab" 06:19:52 INFO - } 06:19:52 INFO - } 06:19:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/Du_rld6bSpy-eFpAA-elIA/artifacts/public/build/firefox-44.0a1.en-US.win32.zip. 06:19:52 INFO - Running post-action listener: _resource_record_post_action 06:19:52 INFO - ##### 06:19:52 INFO - ##### Running download-and-extract step. 06:19:52 INFO - ##### 06:19:52 INFO - Running pre-action listener: _resource_record_pre_action 06:19:52 INFO - Running main action method: download_and_extract 06:19:52 INFO - mkdir: C:\slave\test-pgo\build\tests 06:19: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')]} 06:19:52 INFO - https://queue.taskcluster.net/v1/task/Du_rld6bSpy-eFpAA-elIA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:19:52 INFO - trying https://queue.taskcluster.net/v1/task/Du_rld6bSpy-eFpAA-elIA/artifacts/public/build/test_packages.json 06:19:52 INFO - Downloading https://queue.taskcluster.net/v1/task/Du_rld6bSpy-eFpAA-elIA/artifacts/public/build/test_packages.json to C:\slave\test-pgo\build\test_packages.json 06:19:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Du_rld6bSpy-eFpAA-elIA/artifacts/public/build/test_packages.json', 'file_name': 'C:\\slave\\test-pgo\\build\\test_packages.json'}, attempt #1 06:19:53 INFO - Downloaded 1221 bytes. 06:19:53 INFO - Reading from file C:\slave\test-pgo\build\test_packages.json 06:19:53 INFO - Using the following test package requirements: 06:19:53 INFO - {u'common': [u'firefox-44.0a1.en-US.win32.common.tests.zip'], 06:19:53 INFO - u'cppunittest': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 06:19:53 INFO - u'firefox-44.0a1.en-US.win32.cppunittest.tests.zip'], 06:19:53 INFO - u'jittest': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 06:19:53 INFO - u'jsshell-win32.zip'], 06:19:53 INFO - u'mochitest': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 06:19:53 INFO - u'firefox-44.0a1.en-US.win32.mochitest.tests.zip'], 06:19:53 INFO - u'mozbase': [u'firefox-44.0a1.en-US.win32.common.tests.zip'], 06:19:53 INFO - u'reftest': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 06:19:53 INFO - u'firefox-44.0a1.en-US.win32.reftest.tests.zip'], 06:19:53 INFO - u'talos': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 06:19:53 INFO - u'firefox-44.0a1.en-US.win32.talos.tests.zip'], 06:19:53 INFO - u'web-platform': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 06:19:53 INFO - u'firefox-44.0a1.en-US.win32.web-platform.tests.zip'], 06:19:53 INFO - u'webapprt': [u'firefox-44.0a1.en-US.win32.common.tests.zip'], 06:19:53 INFO - u'xpcshell': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 06:19:53 INFO - u'firefox-44.0a1.en-US.win32.xpcshell.tests.zip']} 06:19:53 INFO - Downloading packages: [u'firefox-44.0a1.en-US.win32.common.tests.zip'] for test suite category: common 06:19:53 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')]} 06:19:53 INFO - https://queue.taskcluster.net/v1/task/Du_rld6bSpy-eFpAA-elIA/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip matches https://queue.taskcluster.net 06:19:53 INFO - trying https://queue.taskcluster.net/v1/task/Du_rld6bSpy-eFpAA-elIA/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip 06:19:53 INFO - Downloading https://queue.taskcluster.net/v1/task/Du_rld6bSpy-eFpAA-elIA/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 06:19:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Du_rld6bSpy-eFpAA-elIA/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 06:19:55 INFO - Downloaded 17994013 bytes. 06:19:55 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 06:19:55 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.common.tests.zip 06:19:55 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win32.common.tests.zip'] with output_timeout 1760 06:20:27 INFO - Return code: 0 06:20:27 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 06:20:27 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')]} 06:20:27 INFO - https://queue.taskcluster.net/v1/task/Du_rld6bSpy-eFpAA-elIA/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip matches https://queue.taskcluster.net 06:20:27 INFO - trying https://queue.taskcluster.net/v1/task/Du_rld6bSpy-eFpAA-elIA/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip 06:20:27 INFO - Downloading https://queue.taskcluster.net/v1/task/Du_rld6bSpy-eFpAA-elIA/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 06:20:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Du_rld6bSpy-eFpAA-elIA/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 06:20:28 INFO - Downloaded 17994013 bytes. 06:20:28 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 06:20:28 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.common.tests.zip 06:20:28 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win32.common.tests.zip'] with output_timeout 1760 06:20:53 INFO - Return code: 0 06:20:53 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')]} 06:20:53 INFO - https://queue.taskcluster.net/v1/task/Du_rld6bSpy-eFpAA-elIA/artifacts/public/build/firefox-44.0a1.en-US.win32.talos.tests.zip matches https://queue.taskcluster.net 06:20:53 INFO - trying https://queue.taskcluster.net/v1/task/Du_rld6bSpy-eFpAA-elIA/artifacts/public/build/firefox-44.0a1.en-US.win32.talos.tests.zip 06:20:53 INFO - Downloading https://queue.taskcluster.net/v1/task/Du_rld6bSpy-eFpAA-elIA/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 06:20:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Du_rld6bSpy-eFpAA-elIA/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 06:20:55 INFO - Downloaded 11131307 bytes. 06:20:55 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 06:20:55 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.talos.tests.zip 06:20:55 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win32.talos.tests.zip'] with output_timeout 1760 06:21:00 INFO - Return code: 0 06:21: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')]} 06:21:00 INFO - https://queue.taskcluster.net/v1/task/Du_rld6bSpy-eFpAA-elIA/artifacts/public/build/firefox-44.0a1.en-US.win32.zip matches https://queue.taskcluster.net 06:21:00 INFO - trying https://queue.taskcluster.net/v1/task/Du_rld6bSpy-eFpAA-elIA/artifacts/public/build/firefox-44.0a1.en-US.win32.zip 06:21:00 INFO - Downloading https://queue.taskcluster.net/v1/task/Du_rld6bSpy-eFpAA-elIA/artifacts/public/build/firefox-44.0a1.en-US.win32.zip to C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.zip 06:21:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Du_rld6bSpy-eFpAA-elIA/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 06:21:04 INFO - Downloaded 53208725 bytes. 06:21:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Du_rld6bSpy-eFpAA-elIA/artifacts/public/build/firefox-44.0a1.en-US.win32.zip 06:21:04 INFO - mkdir: C:\slave\test-pgo\properties 06:21:04 INFO - Writing buildbot properties ['build_url'] to C:\slave\test-pgo\properties\build_url 06:21:04 INFO - Writing to file C:\slave\test-pgo\properties\build_url 06:21:04 INFO - Contents: 06:21:04 INFO - build_url:https://queue.taskcluster.net/v1/task/Du_rld6bSpy-eFpAA-elIA/artifacts/public/build/firefox-44.0a1.en-US.win32.zip 06:21:04 INFO - Running post-action listener: _resource_record_post_action 06:21:04 INFO - Running post-action listener: set_extra_try_arguments 06:21:04 INFO - ##### 06:21:04 INFO - ##### Running populate-webroot step. 06:21:04 INFO - ##### 06:21:04 INFO - Running pre-action listener: _resource_record_pre_action 06:21:04 INFO - Running main action method: populate_webroot 06:21:04 INFO - Guessing talos json url... 06:21:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:04 INFO - https://queue.taskcluster.net/v1/task/Du_rld6bSpy-eFpAA-elIA/artifacts/public/build/firefox-44.0a1.en-US.win32.txt matches https://queue.taskcluster.net 06:21:04 INFO - trying https://queue.taskcluster.net/v1/task/Du_rld6bSpy-eFpAA-elIA/artifacts/public/build/firefox-44.0a1.en-US.win32.txt 06:21:04 INFO - Downloading https://queue.taskcluster.net/v1/task/Du_rld6bSpy-eFpAA-elIA/artifacts/public/build/firefox-44.0a1.en-US.win32.txt to C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.txt 06:21:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Du_rld6bSpy-eFpAA-elIA/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 06:21:04 INFO - Downloaded 111 bytes. 06:21:04 INFO - Reading from file C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.txt 06:21:04 INFO - Contents: 06:21:04 INFO - 20151027013036 06:21:04 INFO - https://hg.mozilla.org/integration/mozilla-inbound/rev/f1966d9bbf475e1ed4a3aeaaac0be37fdb61c1ab 06:21:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:04 INFO - trying https://hg.mozilla.org/integration/mozilla-inbound/raw-file/f1966d9bbf/testing/talos/talos.json 06:21:04 INFO - Downloading https://hg.mozilla.org/integration/mozilla-inbound/raw-file/f1966d9bbf/testing/talos/talos.json to C:\slave\test-pgo\build\talos.json 06:21:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/mozilla-inbound/raw-file/f1966d9bbf/testing/talos/talos.json', 'file_name': 'C:\\slave\\test-pgo\\build\\talos.json'}, attempt #1 06:21:05 INFO - Downloaded 4264 bytes. 06:21:05 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']}, 06:21:05 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']}, 06:21:05 INFO - u'remote-trobocheck2': {u'talos_options': [u'--fennecIDs', 06:21:05 INFO - u'../fennec_ids.txt'], 06:21:05 INFO - u'tests': [u'tcheck2']}, 06:21:05 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome', 06:21:05 INFO - u'--tppagecycles', 06:21:05 INFO - u'7'], 06:21:05 INFO - u'tests': [u'tsvgm']}}, 06:21:05 INFO - u'suites': {u'chromez': {u'tests': [u'tresize', u'tcanvasmark']}, 06:21:05 INFO - u'chromez-e10s': {u'talos_options': [u'--e10s'], 06:21:05 INFO - u'tests': [u'tresize', u'tcanvasmark']}, 06:21:05 INFO - u'dromaeojs': {u'tests': [u'dromaeo_css', u'kraken', u'v8_7']}, 06:21:05 INFO - u'dromaeojs-e10s': {u'talos_options': [u'--e10s'], 06:21:05 INFO - u'tests': [u'dromaeo_css', 06:21:05 INFO - u'kraken', 06:21:05 INFO - u'v8_7']}, 06:21:05 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:05 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 06:21:05 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:05 INFO - u'talos_options': [u'--e10s'], 06:21:05 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 06:21:05 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:05 INFO - u'tests': [u'damp', u'tps']}, 06:21:05 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:05 INFO - u'talos_options': [u'--e10s'], 06:21:05 INFO - u'tests': [u'damp', u'tps']}, 06:21:05 INFO - u'g3': {u'tests': [u'dromaeo_dom']}, 06:21:05 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']}, 06:21:05 INFO - u'other': {u'tests': [u'a11yr', 06:21:05 INFO - u'ts_paint', 06:21:05 INFO - u'tpaint', 06:21:05 INFO - u'sessionrestore', 06:21:05 INFO - u'sessionrestore_no_auto_restore']}, 06:21:05 INFO - u'other-e10s': {u'talos_options': [u'--e10s'], 06:21:05 INFO - u'tests': [u'a11yr', 06:21:05 INFO - u'ts_paint', 06:21:05 INFO - u'tpaint', 06:21:05 INFO - u'sessionrestore', 06:21:05 INFO - u'sessionrestore_no_auto_restore']}, 06:21:05 INFO - u'other-e10s_l64': {u'talos_options': [u'--e10s'], 06:21:05 INFO - u'tests': [u'a11yr', 06:21:05 INFO - u'ts_paint', 06:21:05 INFO - u'tpaint', 06:21:05 INFO - u'sessionrestore', 06:21:05 INFO - u'sessionrestore_no_auto_restore']}, 06:21:05 INFO - u'other-e10s_nol64': {u'talos_options': [u'--e10s'], 06:21:05 INFO - u'tests': [u'a11yr', 06:21:05 INFO - u'ts_paint', 06:21:05 INFO - u'tpaint', 06:21:05 INFO - u'sessionrestore', 06:21:05 INFO - u'sessionrestore_no_auto_restore']}, 06:21:05 INFO - u'other_l64': {u'tests': [u'a11yr', 06:21:05 INFO - u'ts_paint', 06:21:05 INFO - u'tpaint', 06:21:05 INFO - u'sessionrestore', 06:21:05 INFO - u'sessionrestore_no_auto_restore']}, 06:21:05 INFO - u'other_nol64': {u'tests': [u'a11yr', 06:21:05 INFO - u'ts_paint', 06:21:05 INFO - u'tpaint', 06:21:05 INFO - u'sessionrestore', 06:21:05 INFO - u'sessionrestore_no_auto_restore']}, 06:21:05 INFO - u'svgr': {u'tests': [u'tsvgx', 06:21:05 INFO - u'tsvgr_opacity', 06:21:05 INFO - u'tart', 06:21:05 INFO - u'tscrollx', 06:21:05 INFO - u'cart']}, 06:21:05 INFO - u'svgr-e10s': {u'talos_options': [u'--e10s'], 06:21:05 INFO - u'tests': [u'tsvgx', 06:21:05 INFO - u'tsvgr_opacity', 06:21:05 INFO - u'tart', 06:21:05 INFO - u'tscrollx', 06:21:05 INFO - u'cart']}, 06:21:05 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:05 INFO - u'tests': [u'tp5o']}, 06:21:05 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:05 INFO - u'talos_options': [u'--e10s'], 06:21:05 INFO - u'tests': [u'tp5o']}, 06:21:05 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:05 INFO - u'talos_options': [u'--xperf_path', 06:21:05 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:21:05 INFO - u'tests': [u'tp5n']}, 06:21:05 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:21:05 INFO - u'talos_options': [u'--e10s', 06:21:05 INFO - u'--xperf_path', 06:21:05 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 06:21:05 INFO - u'C:/slave/talos-data/talos/xperf.config'], 06:21:05 INFO - u'tests': [u'tp5n']}}, 06:21:05 INFO - u'talos.zip': {u'path': u'', 06:21:05 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:21:05 INFO - Running post-action listener: _resource_record_post_action 06:21:05 INFO - ##### 06:21:05 INFO - ##### Running create-virtualenv step. 06:21:05 INFO - ##### 06:21:05 INFO - Running pre-action listener: _resource_record_pre_action 06:21:05 INFO - Running main action method: create_virtualenv 06:21:05 INFO - Creating virtualenv C:\slave\test-pgo\build/venv 06:21:05 INFO - mkdir: C:\slave\test-pgo\build\venv\Scripts 06:21:05 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test-pgo\build\venv\Scripts\python27.dll 06:21:05 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'! 06:21:05 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 06:21:05 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 06:21:07 INFO - New python executable in C:\slave\test-pgo\build/venv\Scripts\python.exe 06:21:10 INFO - Installing distribute......................................................................................................................................................................................done. 06:21:11 INFO - Return code: 0 06:21:11 INFO - Installing pip>=1.5 into virtualenv C:\slave\test-pgo\build/venv 06:21:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:11 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x018B8B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01878EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x012FE8C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01218B48>, '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 0x0123A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0193D660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-028', 'USERDOMAIN': 'T-W732-IX-028', '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-028', '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 06:21:11 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in C:\slave\test-pgo\build 06:21:11 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --download-cache C:\slave\test-pgo\build/venv\cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:21:11 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 06:21:11 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 06:21:11 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 06:21:11 INFO - 'COMPUTERNAME': 'T-W732-IX-028', 06:21:11 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 06:21:11 INFO - 'CYGWINBASE': 'C:\\cygwin', 06:21:11 INFO - 'DCLOCATION': 'SCL3', 06:21:11 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 06:21:11 INFO - 'FP_NO_HOST_CHECK': 'NO', 06:21:11 INFO - 'HOMEDRIVE': 'C:', 06:21:11 INFO - 'HOMEPATH': '\\Users\\cltbld', 06:21:11 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 06:21:11 INFO - 'KTS_VERSION': '1.19c', 06:21:11 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 06:21:11 INFO - 'LOGONSERVER': '\\\\T-W732-IX-028', 06:21:11 INFO - 'MONDIR': 'C:\\Monitor_config\\', 06:21:11 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 06:21:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:11 INFO - 'MOZ_NO_REMOTE': '1', 06:21:11 INFO - 'NO_EM_RESTART': '1', 06:21:11 INFO - 'NUMBER_OF_PROCESSORS': '8', 06:21:11 INFO - 'OS': 'Windows_NT', 06:21:11 INFO - 'OURDRIVE': 'C:', 06:21:11 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;', 06:21:11 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 06:21:11 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 06:21:11 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 06:21:11 INFO - 'PROCESSOR_LEVEL': '6', 06:21:11 INFO - 'PROCESSOR_REVISION': '1e05', 06:21:11 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 06:21:11 INFO - 'PROGRAMFILES': 'C:\\Program Files', 06:21:11 INFO - 'PROMPT': '$P$G', 06:21:11 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 06:21:11 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 06:21:11 INFO - 'PUBLIC': 'C:\\Users\\Public', 06:21:11 INFO - 'PWD': 'C:\\slave\\test-pgo', 06:21:11 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 06:21:11 INFO - 'SLAVEDIR': 'C:\\slave\\', 06:21:11 INFO - 'SYSTEMDRIVE': 'C:', 06:21:11 INFO - 'SYSTEMROOT': 'C:\\windows', 06:21:11 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 06:21:11 INFO - 'TEST1': 'testie', 06:21:11 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 06:21:11 INFO - 'USERDOMAIN': 'T-W732-IX-028', 06:21:11 INFO - 'USERNAME': 'cltbld', 06:21:11 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 06:21:11 INFO - 'WINDIR': 'C:\\windows', 06:21:11 INFO - 'WINDOWS_TRACING_FLAGS': '3', 06:21:11 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 06:21:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 06:21:13 INFO - Ignoring indexes: http://pypi.python.org/simple/ 06:21:13 INFO - Downloading/unpacking pip>=1.5 06:21:13 INFO - Creating supposed download cache at C:\slave\test-pgo\build/venv\cache 06:21:17 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 06:21:17 INFO - Running setup.py egg_info for package pip 06:21:17 INFO - warning: no files found matching 'pip\cacert.pem' 06:21:17 INFO - warning: no files found matching '*.html' under directory 'docs' 06:21:17 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 06:21:17 INFO - no previously-included directories found matching 'docs\_build\_sources' 06:21:17 INFO - Installing collected packages: pip 06:21:17 INFO - Found existing installation: pip 0.8.2 06:21:17 INFO - Uninstalling pip: 06:21:17 INFO - Successfully uninstalled pip 06:21:17 INFO - Running setup.py install for pip 06:21:17 INFO - warning: no files found matching 'pip\cacert.pem' 06:21:17 INFO - warning: no files found matching '*.html' under directory 'docs' 06:21:17 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 06:21:17 INFO - no previously-included directories found matching 'docs\_build\_sources' 06:21:17 INFO - Installing pip-script.py script to C:\slave\test-pgo\build\venv\Scripts 06:21:17 INFO - Installing pip.exe script to C:\slave\test-pgo\build\venv\Scripts 06:21:17 INFO - Installing pip2.7-script.py script to C:\slave\test-pgo\build\venv\Scripts 06:21:17 INFO - Installing pip2.7.exe script to C:\slave\test-pgo\build\venv\Scripts 06:21:17 INFO - Installing pip2-script.py script to C:\slave\test-pgo\build\venv\Scripts 06:21:17 INFO - Installing pip2.exe script to C:\slave\test-pgo\build\venv\Scripts 06:21:17 INFO - Successfully installed pip 06:21:17 INFO - Cleaning up... 06:21:17 INFO - Return code: 0 06:21:17 INFO - Installing psutil>=0.7.1 into virtualenv C:\slave\test-pgo\build/venv 06:21:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:17 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 0x018B8B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01878EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x012FE8C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01218B48>, '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 0x0123A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0193D660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-028', 'USERDOMAIN': 'T-W732-IX-028', '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-028', '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 06:21:17 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 06:21:17 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 06:21:17 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 06:21:17 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 06:21:17 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 06:21:17 INFO - 'COMPUTERNAME': 'T-W732-IX-028', 06:21:17 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 06:21:17 INFO - 'CYGWINBASE': 'C:\\cygwin', 06:21:17 INFO - 'DCLOCATION': 'SCL3', 06:21:17 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 06:21:17 INFO - 'FP_NO_HOST_CHECK': 'NO', 06:21:17 INFO - 'HOMEDRIVE': 'C:', 06:21:17 INFO - 'HOMEPATH': '\\Users\\cltbld', 06:21:17 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 06:21:17 INFO - 'KTS_VERSION': '1.19c', 06:21:17 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 06:21:17 INFO - 'LOGONSERVER': '\\\\T-W732-IX-028', 06:21:17 INFO - 'MONDIR': 'C:\\Monitor_config\\', 06:21:17 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 06:21:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:17 INFO - 'MOZ_NO_REMOTE': '1', 06:21:17 INFO - 'NO_EM_RESTART': '1', 06:21:17 INFO - 'NUMBER_OF_PROCESSORS': '8', 06:21:17 INFO - 'OS': 'Windows_NT', 06:21:17 INFO - 'OURDRIVE': 'C:', 06:21:17 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;', 06:21:17 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 06:21:17 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 06:21:17 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 06:21:17 INFO - 'PROCESSOR_LEVEL': '6', 06:21:17 INFO - 'PROCESSOR_REVISION': '1e05', 06:21:17 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 06:21:17 INFO - 'PROGRAMFILES': 'C:\\Program Files', 06:21:17 INFO - 'PROMPT': '$P$G', 06:21:17 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 06:21:17 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 06:21:17 INFO - 'PUBLIC': 'C:\\Users\\Public', 06:21:17 INFO - 'PWD': 'C:\\slave\\test-pgo', 06:21:17 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 06:21:17 INFO - 'SLAVEDIR': 'C:\\slave\\', 06:21:17 INFO - 'SYSTEMDRIVE': 'C:', 06:21:17 INFO - 'SYSTEMROOT': 'C:\\windows', 06:21:17 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 06:21:17 INFO - 'TEST1': 'testie', 06:21:17 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 06:21:17 INFO - 'USERDOMAIN': 'T-W732-IX-028', 06:21:17 INFO - 'USERNAME': 'cltbld', 06:21:17 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 06:21:17 INFO - 'WINDIR': 'C:\\windows', 06:21:17 INFO - 'WINDOWS_TRACING_FLAGS': '3', 06:21:17 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 06:21:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 06:21:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:19 INFO - Downloading/unpacking psutil>=0.7.1 06:21:19 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 06:21:19 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 06:21:20 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 06:21:20 INFO - Installing collected packages: psutil 06:21:20 INFO - Successfully installed psutil 06:21:20 INFO - Cleaning up... 06:21:20 INFO - Return code: 0 06:21:20 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv C:\slave\test-pgo\build/venv 06:21:20 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')]} 06:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:20 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')]} 06:21:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:20 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 0x018B8B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01878EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x012FE8C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01218B48>, '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 0x0123A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0193D660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-028', 'USERDOMAIN': 'T-W732-IX-028', '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-028', '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 06:21:20 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 06:21:20 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 06:21:20 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 06:21:20 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 06:21:20 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 06:21:20 INFO - 'COMPUTERNAME': 'T-W732-IX-028', 06:21:20 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 06:21:20 INFO - 'CYGWINBASE': 'C:\\cygwin', 06:21:20 INFO - 'DCLOCATION': 'SCL3', 06:21:20 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 06:21:20 INFO - 'FP_NO_HOST_CHECK': 'NO', 06:21:20 INFO - 'HOMEDRIVE': 'C:', 06:21:20 INFO - 'HOMEPATH': '\\Users\\cltbld', 06:21:20 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 06:21:20 INFO - 'KTS_VERSION': '1.19c', 06:21:20 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 06:21:20 INFO - 'LOGONSERVER': '\\\\T-W732-IX-028', 06:21:20 INFO - 'MONDIR': 'C:\\Monitor_config\\', 06:21:20 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 06:21:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:20 INFO - 'MOZ_NO_REMOTE': '1', 06:21:20 INFO - 'NO_EM_RESTART': '1', 06:21:20 INFO - 'NUMBER_OF_PROCESSORS': '8', 06:21:20 INFO - 'OS': 'Windows_NT', 06:21:20 INFO - 'OURDRIVE': 'C:', 06:21:20 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;', 06:21:20 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 06:21:20 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 06:21:20 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 06:21:20 INFO - 'PROCESSOR_LEVEL': '6', 06:21:20 INFO - 'PROCESSOR_REVISION': '1e05', 06:21:20 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 06:21:20 INFO - 'PROGRAMFILES': 'C:\\Program Files', 06:21:20 INFO - 'PROMPT': '$P$G', 06:21:20 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 06:21:20 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 06:21:20 INFO - 'PUBLIC': 'C:\\Users\\Public', 06:21:20 INFO - 'PWD': 'C:\\slave\\test-pgo', 06:21:20 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 06:21:20 INFO - 'SLAVEDIR': 'C:\\slave\\', 06:21:20 INFO - 'SYSTEMDRIVE': 'C:', 06:21:20 INFO - 'SYSTEMROOT': 'C:\\windows', 06:21:20 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 06:21:20 INFO - 'TEST1': 'testie', 06:21:20 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 06:21:20 INFO - 'USERDOMAIN': 'T-W732-IX-028', 06:21:20 INFO - 'USERNAME': 'cltbld', 06:21:20 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 06:21:20 INFO - 'WINDIR': 'C:\\windows', 06:21:20 INFO - 'WINDOWS_TRACING_FLAGS': '3', 06:21:20 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 06:21:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 06:21:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:20 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:21:20 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 06:21:20 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 06:21:21 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:21:21 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 06:21:21 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor 06:21:21 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) 06:21:21 INFO - Installing collected packages: mozsystemmonitor 06:21:21 INFO - Running setup.py install for mozsystemmonitor 06:21:22 INFO - Successfully installed mozsystemmonitor 06:21:22 INFO - Cleaning up... 06:21:22 INFO - Return code: 0 06:21:22 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test-pgo\build/venv 06:21:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:22 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x018B8B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01878EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x012FE8C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01218B48>, '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 0x0123A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0193D660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-028', 'USERDOMAIN': 'T-W732-IX-028', '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-028', '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 06:21:22 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in C:\slave\test-pgo\build 06:21:22 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --download-cache C:\slave\test-pgo\build/venv\cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:21:22 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 06:21:22 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 06:21:22 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 06:21:22 INFO - 'COMPUTERNAME': 'T-W732-IX-028', 06:21:22 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 06:21:22 INFO - 'CYGWINBASE': 'C:\\cygwin', 06:21:22 INFO - 'DCLOCATION': 'SCL3', 06:21:22 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 06:21:22 INFO - 'FP_NO_HOST_CHECK': 'NO', 06:21:22 INFO - 'HOMEDRIVE': 'C:', 06:21:22 INFO - 'HOMEPATH': '\\Users\\cltbld', 06:21:22 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 06:21:22 INFO - 'KTS_VERSION': '1.19c', 06:21:22 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 06:21:22 INFO - 'LOGONSERVER': '\\\\T-W732-IX-028', 06:21:22 INFO - 'MONDIR': 'C:\\Monitor_config\\', 06:21:22 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 06:21:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:22 INFO - 'MOZ_NO_REMOTE': '1', 06:21:22 INFO - 'NO_EM_RESTART': '1', 06:21:22 INFO - 'NUMBER_OF_PROCESSORS': '8', 06:21:22 INFO - 'OS': 'Windows_NT', 06:21:22 INFO - 'OURDRIVE': 'C:', 06:21:22 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;', 06:21:22 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 06:21:22 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 06:21:22 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 06:21:22 INFO - 'PROCESSOR_LEVEL': '6', 06:21:22 INFO - 'PROCESSOR_REVISION': '1e05', 06:21:22 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 06:21:22 INFO - 'PROGRAMFILES': 'C:\\Program Files', 06:21:22 INFO - 'PROMPT': '$P$G', 06:21:22 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 06:21:22 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 06:21:22 INFO - 'PUBLIC': 'C:\\Users\\Public', 06:21:22 INFO - 'PWD': 'C:\\slave\\test-pgo', 06:21:22 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 06:21:22 INFO - 'SLAVEDIR': 'C:\\slave\\', 06:21:22 INFO - 'SYSTEMDRIVE': 'C:', 06:21:22 INFO - 'SYSTEMROOT': 'C:\\windows', 06:21:22 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 06:21:22 INFO - 'TEST1': 'testie', 06:21:22 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 06:21:22 INFO - 'USERDOMAIN': 'T-W732-IX-028', 06:21:22 INFO - 'USERNAME': 'cltbld', 06:21:22 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 06:21:22 INFO - 'WINDIR': 'C:\\windows', 06:21:22 INFO - 'WINDOWS_TRACING_FLAGS': '3', 06:21:22 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 06:21:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 06:21:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:22 INFO - Downloading/unpacking blobuploader==1.2.4 06:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:23 INFO - Downloading blobuploader-1.2.4.tar.gz 06:21:23 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 06:21:23 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader 06:21:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:21:23 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 06:21:23 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 06:21:23 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 06:21:23 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\requests\setup.py) egg_info for package requests 06:21:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:24 INFO - Downloading docopt-0.6.1.tar.gz 06:21:24 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 06:21:24 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\docopt\setup.py) egg_info for package docopt 06:21:24 INFO - Installing collected packages: blobuploader, requests, docopt 06:21:24 INFO - Running setup.py install for blobuploader 06:21:24 INFO - Running setup.py install for requests 06:21:25 INFO - Running setup.py install for docopt 06:21:25 INFO - Successfully installed blobuploader requests docopt 06:21:25 INFO - Cleaning up... 06:21:26 INFO - Return code: 0 06:21:26 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv 06:21: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')]} 06:21:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21: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')]} 06:21:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:26 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 0x018B8B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01878EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x012FE8C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01218B48>, '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 0x0123A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0193D660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-028', 'USERDOMAIN': 'T-W732-IX-028', '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-028', '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 06:21:26 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 06:21:26 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 06:21:26 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 06:21:26 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 06:21:26 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 06:21:26 INFO - 'COMPUTERNAME': 'T-W732-IX-028', 06:21:26 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 06:21:26 INFO - 'CYGWINBASE': 'C:\\cygwin', 06:21:26 INFO - 'DCLOCATION': 'SCL3', 06:21:26 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 06:21:26 INFO - 'FP_NO_HOST_CHECK': 'NO', 06:21:26 INFO - 'HOMEDRIVE': 'C:', 06:21:26 INFO - 'HOMEPATH': '\\Users\\cltbld', 06:21:26 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 06:21:26 INFO - 'KTS_VERSION': '1.19c', 06:21:26 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 06:21:26 INFO - 'LOGONSERVER': '\\\\T-W732-IX-028', 06:21:26 INFO - 'MONDIR': 'C:\\Monitor_config\\', 06:21:26 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 06:21:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:26 INFO - 'MOZ_NO_REMOTE': '1', 06:21:26 INFO - 'NO_EM_RESTART': '1', 06:21:26 INFO - 'NUMBER_OF_PROCESSORS': '8', 06:21:26 INFO - 'OS': 'Windows_NT', 06:21:26 INFO - 'OURDRIVE': 'C:', 06:21: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;', 06:21:26 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 06:21:26 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 06:21:26 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 06:21:26 INFO - 'PROCESSOR_LEVEL': '6', 06:21:26 INFO - 'PROCESSOR_REVISION': '1e05', 06:21:26 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 06:21:26 INFO - 'PROGRAMFILES': 'C:\\Program Files', 06:21:26 INFO - 'PROMPT': '$P$G', 06:21:26 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 06:21:26 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 06:21:26 INFO - 'PUBLIC': 'C:\\Users\\Public', 06:21:26 INFO - 'PWD': 'C:\\slave\\test-pgo', 06:21:26 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 06:21:26 INFO - 'SLAVEDIR': 'C:\\slave\\', 06:21:26 INFO - 'SYSTEMDRIVE': 'C:', 06:21:26 INFO - 'SYSTEMROOT': 'C:\\windows', 06:21:26 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 06:21:26 INFO - 'TEST1': 'testie', 06:21:26 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 06:21:26 INFO - 'USERDOMAIN': 'T-W732-IX-028', 06:21:26 INFO - 'USERNAME': 'cltbld', 06:21:26 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 06:21:26 INFO - 'WINDIR': 'C:\\windows', 06:21:26 INFO - 'WINDOWS_TRACING_FLAGS': '3', 06:21:26 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 06:21:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 06:21:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:26 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\manifestparser 06:21:27 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-hco7yk-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/manifestparser 06:21:27 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozcrash 06:21:27 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-o3zs1y-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozcrash 06:21:27 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdebug 06:21:27 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-3qsn3z-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdebug 06:21:27 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdevice 06:21:27 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-m3rit6-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdevice 06:21:27 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozfile 06:21:27 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-6shmk5-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozfile 06:21:27 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozhttpd 06:21:27 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-yq2nbb-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozhttpd 06:21:27 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinfo 06:21:27 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-dl66o_-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinfo 06:21:28 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinstall 06:21:28 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-7ywodr-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinstall 06:21:28 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozleak 06:21:28 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-3_yn6e-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozleak 06:21:29 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozlog 06:21:29 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-y8gg9n-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozlog 06:21:29 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moznetwork 06:21:29 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-ioteat-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moznetwork 06:21:29 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprocess 06:21:29 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-pxh54x-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprocess 06:21:29 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprofile 06:21:29 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-2yc65e-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprofile 06:21:29 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozrunner 06:21:29 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-2izhen-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozrunner 06:21:29 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozscreenshot 06:21:29 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-e3sk5v-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:21:29 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moztest 06:21:29 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-i_cuso-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moztest 06:21:29 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozversion 06:21:30 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-819s6b-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozversion 06:21:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:21:30 INFO - Running setup.py install for manifestparser 06:21:30 INFO - Installing manifestparser-script.py script to C:\slave\test-pgo\build\venv\Scripts 06:21:30 INFO - Installing manifestparser.exe script to C:\slave\test-pgo\build\venv\Scripts 06:21:30 INFO - Running setup.py install for mozcrash 06:21:31 INFO - Running setup.py install for mozdebug 06:21:31 INFO - Running setup.py install for mozdevice 06:21:31 INFO - Installing sutini-script.py script to C:\slave\test-pgo\build\venv\Scripts 06:21:31 INFO - Installing sutini.exe script to C:\slave\test-pgo\build\venv\Scripts 06:21:31 INFO - Installing dm-script.py script to C:\slave\test-pgo\build\venv\Scripts 06:21:31 INFO - Installing dm.exe script to C:\slave\test-pgo\build\venv\Scripts 06:21:32 INFO - Running setup.py install for mozfile 06:21:32 INFO - Running setup.py install for mozhttpd 06:21:32 INFO - Installing mozhttpd-script.py script to C:\slave\test-pgo\build\venv\Scripts 06:21:32 INFO - Installing mozhttpd.exe script to C:\slave\test-pgo\build\venv\Scripts 06:21:32 INFO - Running setup.py install for mozinfo 06:21:33 INFO - Installing mozinfo-script.py script to C:\slave\test-pgo\build\venv\Scripts 06:21:33 INFO - Installing mozinfo.exe script to C:\slave\test-pgo\build\venv\Scripts 06:21:33 INFO - Running setup.py install for mozInstall 06:21:33 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test-pgo\build\venv\Scripts 06:21:33 INFO - Installing moz_remove_from_system.exe script to C:\slave\test-pgo\build\venv\Scripts 06:21:33 INFO - Installing mozuninstall-script.py script to C:\slave\test-pgo\build\venv\Scripts 06:21:33 INFO - Installing mozuninstall.exe script to C:\slave\test-pgo\build\venv\Scripts 06:21:33 INFO - Installing mozinstall-script.py script to C:\slave\test-pgo\build\venv\Scripts 06:21:33 INFO - Installing mozinstall.exe script to C:\slave\test-pgo\build\venv\Scripts 06:21:33 INFO - Installing moz_add_to_system-script.py script to C:\slave\test-pgo\build\venv\Scripts 06:21:33 INFO - Installing moz_add_to_system.exe script to C:\slave\test-pgo\build\venv\Scripts 06:21:33 INFO - Running setup.py install for mozleak 06:21:34 INFO - Running setup.py install for mozlog 06:21:34 INFO - Installing structlog-script.py script to C:\slave\test-pgo\build\venv\Scripts 06:21:34 INFO - Installing structlog.exe script to C:\slave\test-pgo\build\venv\Scripts 06:21:35 INFO - Running setup.py install for moznetwork 06:21:35 INFO - Installing moznetwork-script.py script to C:\slave\test-pgo\build\venv\Scripts 06:21:35 INFO - Installing moznetwork.exe script to C:\slave\test-pgo\build\venv\Scripts 06:21:35 INFO - Running setup.py install for mozprocess 06:21:36 INFO - Running setup.py install for mozprofile 06:21:36 INFO - Installing mozprofile-script.py script to C:\slave\test-pgo\build\venv\Scripts 06:21:36 INFO - Installing mozprofile.exe script to C:\slave\test-pgo\build\venv\Scripts 06:21:36 INFO - Installing diff-profiles-script.py script to C:\slave\test-pgo\build\venv\Scripts 06:21:36 INFO - Installing diff-profiles.exe script to C:\slave\test-pgo\build\venv\Scripts 06:21:36 INFO - Installing view-profile-script.py script to C:\slave\test-pgo\build\venv\Scripts 06:21:36 INFO - Installing view-profile.exe script to C:\slave\test-pgo\build\venv\Scripts 06:21:36 INFO - Running setup.py install for mozrunner 06:21:36 INFO - Installing mozrunner-script.py script to C:\slave\test-pgo\build\venv\Scripts 06:21:36 INFO - Installing mozrunner.exe script to C:\slave\test-pgo\build\venv\Scripts 06:21:37 INFO - Running setup.py install for mozscreenshot 06:21:37 INFO - Running setup.py install for moztest 06:21:38 INFO - Running setup.py install for mozversion 06:21:38 INFO - Installing mozversion-script.py script to C:\slave\test-pgo\build\venv\Scripts 06:21:38 INFO - Installing mozversion.exe script to C:\slave\test-pgo\build\venv\Scripts 06:21:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:21:38 INFO - Cleaning up... 06:21:38 INFO - Return code: 0 06:21:38 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv 06:21:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:38 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 0x018B8B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01878EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x012FE8C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01218B48>, '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 0x0123A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0193D660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-028', 'USERDOMAIN': 'T-W732-IX-028', '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-028', '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 06:21:38 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 06:21:38 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 06:21:38 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 06:21:38 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 06:21:38 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 06:21:38 INFO - 'COMPUTERNAME': 'T-W732-IX-028', 06:21:38 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 06:21:38 INFO - 'CYGWINBASE': 'C:\\cygwin', 06:21:38 INFO - 'DCLOCATION': 'SCL3', 06:21:38 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 06:21:38 INFO - 'FP_NO_HOST_CHECK': 'NO', 06:21:38 INFO - 'HOMEDRIVE': 'C:', 06:21:38 INFO - 'HOMEPATH': '\\Users\\cltbld', 06:21:38 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 06:21:38 INFO - 'KTS_VERSION': '1.19c', 06:21:38 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 06:21:38 INFO - 'LOGONSERVER': '\\\\T-W732-IX-028', 06:21:38 INFO - 'MONDIR': 'C:\\Monitor_config\\', 06:21:38 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 06:21:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:38 INFO - 'MOZ_NO_REMOTE': '1', 06:21:38 INFO - 'NO_EM_RESTART': '1', 06:21:38 INFO - 'NUMBER_OF_PROCESSORS': '8', 06:21:38 INFO - 'OS': 'Windows_NT', 06:21:38 INFO - 'OURDRIVE': 'C:', 06:21:38 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 06:21:38 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 06:21:38 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 06:21:38 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 06:21:38 INFO - 'PROCESSOR_LEVEL': '6', 06:21:38 INFO - 'PROCESSOR_REVISION': '1e05', 06:21:38 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 06:21:38 INFO - 'PROGRAMFILES': 'C:\\Program Files', 06:21:38 INFO - 'PROMPT': '$P$G', 06:21:38 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 06:21:38 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 06:21:38 INFO - 'PUBLIC': 'C:\\Users\\Public', 06:21:38 INFO - 'PWD': 'C:\\slave\\test-pgo', 06:21:38 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 06:21:38 INFO - 'SLAVEDIR': 'C:\\slave\\', 06:21:38 INFO - 'SYSTEMDRIVE': 'C:', 06:21:38 INFO - 'SYSTEMROOT': 'C:\\windows', 06:21:38 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 06:21:38 INFO - 'TEST1': 'testie', 06:21:38 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 06:21:38 INFO - 'USERDOMAIN': 'T-W732-IX-028', 06:21:38 INFO - 'USERNAME': 'cltbld', 06:21:38 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 06:21:38 INFO - 'WINDIR': 'C:\\windows', 06:21:38 INFO - 'WINDOWS_TRACING_FLAGS': '3', 06:21:38 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 06:21:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 06:21:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:38 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\manifestparser 06:21:38 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-spjs6z-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/manifestparser 06:21:39 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///C:/slave/test-pgo/build/tests/mozbase/manifestparser in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 1)) 06:21:39 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozcrash 06:21:39 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-ahu3fo-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozcrash 06:21:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///C:/slave/test-pgo/build/tests/mozbase/mozcrash in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 2)) 06:21:39 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdebug 06:21:39 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-9qj6wm-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdebug 06:21:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///C:/slave/test-pgo/build/tests/mozbase/mozdebug in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 3)) 06:21:39 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdevice 06:21:39 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-rld2r5-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdevice 06:21:39 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)) 06:21:39 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozfile 06:21:39 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-dnw0w4-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozfile 06:21:39 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)) 06:21:39 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozhttpd 06:21:39 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-nlzkpr-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozhttpd 06:21:39 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)) 06:21:39 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinfo 06:21:39 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-1e_hdw-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinfo 06:21:39 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)) 06:21:39 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinstall 06:21:39 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-k9ugkm-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinstall 06:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///C:/slave/test-pgo/build/tests/mozbase/mozinstall in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 8)) 06:21:40 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozleak 06:21:40 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-eayb2d-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozleak 06:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///C:/slave/test-pgo/build/tests/mozbase/mozleak in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 9)) 06:21:40 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozlog 06:21:40 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-2kmhqa-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozlog 06:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///C:/slave/test-pgo/build/tests/mozbase/mozlog in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 10)) 06:21:40 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moznetwork 06:21:40 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-a1xzea-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moznetwork 06:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///C:/slave/test-pgo/build/tests/mozbase/moznetwork in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 11)) 06:21:40 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprocess 06:21:40 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-lmfhwj-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprocess 06:21:40 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)) 06:21:40 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprofile 06:21:40 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-bnxlg5-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprofile 06:21:40 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)) 06:21:40 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozrunner 06:21:40 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-3fkdzq-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozrunner 06:21:40 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)) 06:21:40 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozscreenshot 06:21:40 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-5uoork-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:21:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///C:/slave/test-pgo/build/tests/mozbase/mozscreenshot in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 15)) 06:21:41 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moztest 06:21:41 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-ky280y-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moztest 06:21:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///C:/slave/test-pgo/build/tests/mozbase/moztest in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 16)) 06:21:41 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozversion 06:21:41 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-5mgs4q-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozversion 06:21:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///C:/slave/test-pgo/build/tests/mozbase/mozversion in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 17)) 06:21:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in c:\slave\test-pgo\build\venv\lib\site-packages (from mozcrash==0.16->-r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 2)) 06:21:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in c:\slave\test-pgo\build\venv\lib\site-packages (from mozcrash==0.16->-r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 2)) 06:21:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in c:\slave\test-pgo\build\venv\lib\site-packages (from mozdebug==0.1->-r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 3)) 06:21:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test-pgo\build\venv\lib\site-packages (from mozdevice==0.46->-r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 4)) 06:21:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in c:\slave\test-pgo\build\venv\lib\site-packages (from mozdevice==0.46->-r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 4)) 06:21:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 10)) 06:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:42 INFO - Downloading blessings-1.5.1.tar.gz 06:21:42 INFO - Storing download in cache at c:\slave\test-pgo\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fblessings-1.5.1.tar.gz 06:21:42 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\blessings\setup.py) egg_info for package blessings 06:21:42 INFO - Installing collected packages: blessings 06:21:42 INFO - Running setup.py install for blessings 06:21:42 INFO - Successfully installed blessings 06:21:42 INFO - Cleaning up... 06:21:45 INFO - Return code: 0 06:21:45 INFO - Done creating virtualenv C:\slave\test-pgo\build/venv. 06:21:45 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'freeze'] 06:21:45 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip freeze 06:21:46 INFO - Reading from file tmpfile_stdout 06:21:46 INFO - Using _rmtree_windows ... 06:21:46 INFO - Using _rmtree_windows ... 06:21:46 INFO - Current package versions: 06:21:46 INFO - blessings == 1.5.1 06:21:46 INFO - blobuploader == 1.2.4 06:21:46 INFO - docopt == 0.6.1 06:21:46 INFO - manifestparser == 1.1 06:21:46 INFO - mozInstall == 1.12 06:21:46 INFO - mozcrash == 0.16 06:21:46 INFO - mozdebug == 0.1 06:21:46 INFO - mozdevice == 0.46 06:21:46 INFO - mozfile == 1.2 06:21:46 INFO - mozhttpd == 0.7 06:21:46 INFO - mozinfo == 0.8 06:21:46 INFO - mozleak == 0.1 06:21:46 INFO - mozlog == 3.0 06:21:46 INFO - moznetwork == 0.27 06:21:46 INFO - mozprocess == 0.22 06:21:46 INFO - mozprofile == 0.27 06:21:46 INFO - mozrunner == 6.11 06:21:46 INFO - mozscreenshot == 0.1 06:21:46 INFO - mozsystemmonitor == 0.0 06:21:46 INFO - moztest == 0.7 06:21:46 INFO - mozversion == 1.4 06:21:46 INFO - psutil == 3.1.1 06:21:46 INFO - requests == 1.2.3 06:21:46 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv 06:21:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:46 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test-pgo\\build\\tests\\talos\\requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x018B8B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01878EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x012FE8C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01218B48>, '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 0x0123A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0193D660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build\\tests\\talos', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-028', 'USERDOMAIN': 'T-W732-IX-028', '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-028', '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 06:21:46 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test-pgo\\build\\tests\\talos\\requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in C:\slave\test-pgo\build\tests\talos 06:21:46 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --download-cache C:\slave\test-pgo\build/venv\cache --timeout 120 -r C:\slave\test-pgo\build\tests\talos\requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:21:46 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 06:21:46 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 06:21:46 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 06:21:46 INFO - 'COMPUTERNAME': 'T-W732-IX-028', 06:21:46 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 06:21:46 INFO - 'CYGWINBASE': 'C:\\cygwin', 06:21:46 INFO - 'DCLOCATION': 'SCL3', 06:21:46 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 06:21:46 INFO - 'FP_NO_HOST_CHECK': 'NO', 06:21:46 INFO - 'HOMEDRIVE': 'C:', 06:21:46 INFO - 'HOMEPATH': '\\Users\\cltbld', 06:21:46 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 06:21:46 INFO - 'KTS_VERSION': '1.19c', 06:21:46 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 06:21:46 INFO - 'LOGONSERVER': '\\\\T-W732-IX-028', 06:21:46 INFO - 'MONDIR': 'C:\\Monitor_config\\', 06:21:46 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 06:21:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:46 INFO - 'MOZ_NO_REMOTE': '1', 06:21:46 INFO - 'NO_EM_RESTART': '1', 06:21:46 INFO - 'NUMBER_OF_PROCESSORS': '8', 06:21:46 INFO - 'OS': 'Windows_NT', 06:21:46 INFO - 'OURDRIVE': 'C:', 06:21:46 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;', 06:21:46 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 06:21:46 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 06:21:46 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 06:21:46 INFO - 'PROCESSOR_LEVEL': '6', 06:21:46 INFO - 'PROCESSOR_REVISION': '1e05', 06:21:46 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 06:21:46 INFO - 'PROGRAMFILES': 'C:\\Program Files', 06:21:46 INFO - 'PROMPT': '$P$G', 06:21:46 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 06:21:46 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 06:21:46 INFO - 'PUBLIC': 'C:\\Users\\Public', 06:21:46 INFO - 'PWD': 'C:\\slave\\test-pgo', 06:21:46 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 06:21:46 INFO - 'SLAVEDIR': 'C:\\slave\\', 06:21:46 INFO - 'SYSTEMDRIVE': 'C:', 06:21:46 INFO - 'SYSTEMROOT': 'C:\\windows', 06:21:46 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 06:21:46 INFO - 'TEST1': 'testie', 06:21:46 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 06:21:46 INFO - 'USERDOMAIN': 'T-W732-IX-028', 06:21:46 INFO - 'USERNAME': 'cltbld', 06:21:46 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 06:21:46 INFO - 'WINDIR': 'C:\\windows', 06:21:46 INFO - 'WINDOWS_TRACING_FLAGS': '3', 06:21:46 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 06:21:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 06:21:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 1)) 06:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 2)) 06:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 3)) 06:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 4)) 06:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 5)) 06:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 6)) 06:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 7)) 06:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 8)) 06:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in c:\slave\test-pgo\build\venv\lib\site-packages (from mozcrash>=0.15->-r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 1)) 06:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test-pgo\build\venv\lib\site-packages (from mozhttpd>=0.7->-r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 3)) 06:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in c:\slave\test-pgo\build\venv\lib\site-packages (from mozlog>=3.0->mozcrash>=0.15->-r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 1)) 06:21:46 INFO - Cleaning up... 06:21:46 INFO - Return code: 0 06:21:46 INFO - Running post-action listener: _resource_record_post_action 06:21:46 INFO - Running post-action listener: _start_resource_monitoring 06:21:46 INFO - Starting resource monitoring. 06:21:46 INFO - ##### 06:21:46 INFO - ##### Running install step. 06:21:46 INFO - ##### 06:21:46 INFO - Running pre-action listener: _resource_record_pre_action 06:21:46 INFO - Running main action method: install 06:21:46 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'freeze'] 06:21:46 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip freeze 06:21:46 INFO - Reading from file tmpfile_stdout 06:21:46 INFO - Using _rmtree_windows ... 06:21:46 INFO - Using _rmtree_windows ... 06:21:46 INFO - Detecting whether we're running mozinstall >=1.0... 06:21:46 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build/venv/scripts/python', 'C:\\slave\\test-pgo\\build/venv/scripts/mozinstall-script.py', '-h'] 06:21:46 INFO - Copy/paste: C:\slave\test-pgo\build/venv/scripts/python C:\slave\test-pgo\build/venv/scripts/mozinstall-script.py -h 06:21:47 INFO - Reading from file tmpfile_stdout 06:21:47 INFO - Output received: 06:21:47 INFO - Usage: mozinstall-script.py [options] installer 06:21:47 INFO - Options: 06:21:47 INFO - -h, --help show this help message and exit 06:21:47 INFO - -d DEST, --destination=DEST 06:21:47 INFO - Directory to install application into. [default: 06:21:47 INFO - "C:\slave\test-pgo"] 06:21:47 INFO - --app=APP Application being installed. [default: firefox] 06:21:47 INFO - Using _rmtree_windows ... 06:21:47 INFO - Using _rmtree_windows ... 06:21:47 INFO - mkdir: C:\slave\test-pgo\build\application 06:21:47 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build/venv/scripts/python', 'C:\\slave\\test-pgo\\build/venv/scripts/mozinstall-script.py', 'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win32.zip', '--destination', 'C:\\slave\\test-pgo\\build\\application'] 06:21:47 INFO - Copy/paste: C:\slave\test-pgo\build/venv/scripts/python C:\slave\test-pgo\build/venv/scripts/mozinstall-script.py C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.zip --destination C:\slave\test-pgo\build\application 06:21:48 INFO - Reading from file tmpfile_stdout 06:21:48 INFO - Output received: 06:21:48 INFO - C:\slave\test-pgo\build\application\firefox\firefox.exe 06:21:48 INFO - Using _rmtree_windows ... 06:21:48 INFO - Using _rmtree_windows ... 06:21:48 INFO - Running post-action listener: _resource_record_post_action 06:21:48 INFO - ##### 06:21:48 INFO - ##### Running run-tests step. 06:21:48 INFO - ##### 06:21:48 INFO - Running pre-action listener: _resource_record_pre_action 06:21:48 INFO - Running main action method: run_tests 06:21:48 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\python', '--version'] 06:21:48 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\python --version 06:21:48 INFO - Python 2.7.3 06:21:48 INFO - Return code: 0 06:21:48 INFO - grabbing minidump binary from tooltool 06:21:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:21:48 INFO - retry: Calling run_command with args: (['c:/mozilla-build/python27/python.exe', 'C:/mozilla-build/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', 'c:\\builds\\relengapi.tok', 'fetch', '-m', 'C:\\slave\\test-pgo\\build\\tests\\config/tooltool-manifests/win32/releng.manifest', '-o'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01218B48>, '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 0x0123A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x0193D660>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'privileged': False}, attempt #1 06:21:48 INFO - Running command: ['c:/mozilla-build/python27/python.exe', 'C:/mozilla-build/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', 'c:\\builds\\relengapi.tok', 'fetch', '-m', 'C:\\slave\\test-pgo\\build\\tests\\config/tooltool-manifests/win32/releng.manifest', '-o'] in C:\slave\test-pgo\build 06:21:48 INFO - Copy/paste: c:/mozilla-build/python27/python.exe C:/mozilla-build/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file c:\builds\relengapi.tok fetch -m C:\slave\test-pgo\build\tests\config/tooltool-manifests/win32/releng.manifest -o 06:21:48 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 06:21:49 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test-pgo\build\tmptt7afc 06:21:49 INFO - INFO - File integrity verified, renaming tmptt7afc to win32-minidump_stackwalk.exe 06:21:49 INFO - Return code: 0 06:21:49 INFO - Chmoding C:\slave\test-pgo\build\win32-minidump_stackwalk.exe to 0755 06:21:49 INFO - mkdir: C:\slave\test-pgo\build\blobber_upload_dir 06:21:49 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test-pgo\build\blobber_upload_dir 06:21:49 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test-pgo\build\win32-minidump_stackwalk.exe 06:21:49 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test-pgo\build\blobber_upload_dir 06:21:49 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\python', 'C:\\slave\\test-pgo\\build\\tests\\talos\\talos\\run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test-pgo\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Du_rld6bSpy-eFpAA-elIA/artifacts/public/build/firefox-44.0a1.en-US.win32.crashreporter-symbols.zip', '--title', 'T-W732-IX-028', '--webServer', 'localhost'] in C:\slave\test-pgo\build 06:21:49 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\python C:\slave\test-pgo\build\tests\talos\talos\run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs --executablePath C:\slave\test-pgo\build\application\firefox\firefox --symbolsPath https://queue.taskcluster.net/v1/task/Du_rld6bSpy-eFpAA-elIA/artifacts/public/build/firefox-44.0a1.en-US.win32.crashreporter-symbols.zip --title T-W732-IX-028 --webServer localhost 06:21:49 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 06:21:49 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 06:21:49 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 06:21:49 INFO - 'COMPUTERNAME': 'T-W732-IX-028', 06:21:49 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 06:21:49 INFO - 'CYGWINBASE': 'C:\\cygwin', 06:21:49 INFO - 'DCLOCATION': 'SCL3', 06:21:49 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 06:21:49 INFO - 'FP_NO_HOST_CHECK': 'NO', 06:21:49 INFO - 'HOMEDRIVE': 'C:', 06:21:49 INFO - 'HOMEPATH': '\\Users\\cltbld', 06:21:49 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 06:21:49 INFO - 'KTS_VERSION': '1.19c', 06:21:49 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 06:21:49 INFO - 'LOGONSERVER': '\\\\T-W732-IX-028', 06:21:49 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test-pgo\\build\\blobber_upload_dir', 06:21:49 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test-pgo\\build\\win32-minidump_stackwalk.exe', 06:21:49 INFO - 'MONDIR': 'C:\\Monitor_config\\', 06:21:49 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 06:21:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:49 INFO - 'MOZ_NO_REMOTE': '1', 06:21:49 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test-pgo\\build\\blobber_upload_dir', 06:21:49 INFO - 'NO_EM_RESTART': '1', 06:21:49 INFO - 'NUMBER_OF_PROCESSORS': '8', 06:21:49 INFO - 'OS': 'Windows_NT', 06:21:49 INFO - 'OURDRIVE': 'C:', 06:21:49 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;', 06:21:49 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 06:21:49 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 06:21:49 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 06:21:49 INFO - 'PROCESSOR_LEVEL': '6', 06:21:49 INFO - 'PROCESSOR_REVISION': '1e05', 06:21:49 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 06:21:49 INFO - 'PROGRAMFILES': 'C:\\Program Files', 06:21:49 INFO - 'PROMPT': '$P$G', 06:21:49 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 06:21:49 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 06:21:49 INFO - 'PUBLIC': 'C:\\Users\\Public', 06:21:49 INFO - 'PWD': 'C:\\slave\\test-pgo', 06:21:49 INFO - 'PYTHONPATH': 'C:\\slave\\test-pgo\\build\\tests\\talos', 06:21:49 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 06:21:49 INFO - 'SLAVEDIR': 'C:\\slave\\', 06:21:49 INFO - 'SYSTEMDRIVE': 'C:', 06:21:49 INFO - 'SYSTEMROOT': 'C:\\windows', 06:21:49 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 06:21:49 INFO - 'TEST1': 'testie', 06:21:49 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 06:21:49 INFO - 'USERDOMAIN': 'T-W732-IX-028', 06:21:49 INFO - 'USERNAME': 'cltbld', 06:21:49 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 06:21:49 INFO - 'WINDIR': 'C:\\windows', 06:21:49 INFO - 'WINDOWS_TRACING_FLAGS': '3', 06:21:49 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 06:21:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 06:21:49 INFO - Calling ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\python', 'C:\\slave\\test-pgo\\build\\tests\\talos\\talos\\run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test-pgo\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Du_rld6bSpy-eFpAA-elIA/artifacts/public/build/firefox-44.0a1.en-US.win32.crashreporter-symbols.zip', '--title', 'T-W732-IX-028', '--webServer', 'localhost'] with output_timeout 3600 06:21:51 INFO - mozversion INFO | application_buildid: 20151027013036 06:21:51 INFO - mozversion INFO | application_changeset: f1966d9bbf475e1ed4a3aeaaac0be37fdb61c1ab 06:21:51 INFO - mozversion INFO | application_display_name: Nightly 06:21:51 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:21:51 INFO - mozversion INFO | application_name: Firefox 06:21:51 INFO - mozversion INFO | application_remotingname: firefox 06:21:51 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 06:21:51 INFO - mozversion INFO | application_vendor: Mozilla 06:21:51 INFO - mozversion INFO | application_version: 44.0a1 06:21:51 INFO - mozversion INFO | platform_buildid: 20151027013036 06:21:51 INFO - mozversion INFO | platform_changeset: f1966d9bbf475e1ed4a3aeaaac0be37fdb61c1ab 06:21:51 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 06:21:51 INFO - mozversion INFO | platform_version: 44.0a1 06:21:51 INFO - 2015-10-27 06:21:51,098 DEBUG : using testdate: 1445952111 06:21:51 INFO - 2015-10-27 06:21:51,098 DEBUG : actual date: 1445952111 06:21:51 INFO - 2015-10-27 06:21:51,109 INFO : starting webserver on 'localhost:49894' 06:21:51 INFO - 2015-10-27 06:21:51,111 INFO : Starting test suite T-W732-IX-028 06:21:51 INFO - 2015-10-27 06:21:51,111 INFO : Starting test dromaeo_css 06:21:51 INFO - 2015-10-27 06:21:51,111 DEBUG : operating with platform_type : w7_ 06:21:51 INFO - 2015-10-27 06:21:51,111 INFO : Initialising browser for dromaeo_css test... 06:21:51 INFO - 2015-10-27 06:21:51,204 DEBUG : command line: C:\slave\test-pgo\build\application\firefox\firefox -profile c:\users\cltbld\appdata\local\temp\tmpk4i_f6\profile http://localhost:49894/getInfo.html 06:21:58 INFO - 2015-10-27 06:21:58,427 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:21:58 INFO - 2015-10-27 06:21:58,427 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:21:58 INFO - 2015-10-27 06:21:58,427 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674 06:21:58 INFO - 2015-10-27 06:21:58,427 DEBUG : BROWSER_OUTPUT: __metrics 06:21:58 INFO - 2015-10-27 06:21:58,573 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:22:00 INFO - 2015-10-27 06:21:59,993 DEBUG : BROWSER_OUTPUT: console.error: 06:22:00 INFO - 2015-10-27 06:21:59,993 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] 06:22:00 INFO - 2015-10-27 06:21:59,993 DEBUG : BROWSER_OUTPUT: Stack: 06:22:00 INFO - 2015-10-27 06:21:59,993 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<._executeStatement@resource://gre/modules/Sqlite.jsm:758:19 06:22:00 INFO - 2015-10-27 06:21:59,993 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached/<@resource://gre/modules/Sqlite.jsm:493:9 06:22:00 INFO - 2015-10-27 06:21:59,993 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached@resource://gre/modules/Sqlite.jsm:491:1 06:22:00 INFO - 2015-10-27 06:21:59,993 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeBeforeShutdown/loggedDb<.executeCached.value<@resource://gre/modules/Sqlite.jsm:368:51 06:22:00 INFO - 2015-10-27 06:21:59,993 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 06:22:00 INFO - 2015-10-27 06:21:59,993 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 06:22:00 INFO - 2015-10-27 06:21:59,993 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 06:22:00 INFO - 2015-10-27 06:21:59,993 DEBUG : BROWSER_OUTPUT: transaction@resource://gre/modules/Bookmarks.jsm:783:15 06:22:00 INFO - 2015-10-27 06:21:59,993 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 06:22:00 INFO - 2015-10-27 06:21:59,993 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 06:22:00 INFO - 2015-10-27 06:21:59,993 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 06:22:00 INFO - 2015-10-27 06:21:59,993 DEBUG : BROWSER_OUTPUT: Task_spawn@resource://gre/modules/Task.jsm:164:12 06:22:00 INFO - 2015-10-27 06:21:59,993 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 06:41:35 INFO - 2015-10-27 06:41:35,832 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 06:41:35 INFO - 2015-10-27 06:41:35,832 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 06:41:35 INFO - 2015-10-27 06:41:35,832 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 06:41:35 INFO - 2015-10-27 06:41:35,832 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 06:41:35 INFO - 2015-10-27 06:41:35,832 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 06:41:35 INFO - 2015-10-27 06:41:35,832 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 06:41:35 INFO - 2015-10-27 06:41:35,832 DEBUG : BROWSER_OUTPUT: 06:41:36 INFO - 2015-10-27 06:41:36,407 INFO : Browser initialized. 06:41:36 INFO - 2015-10-27 06:41:36,407 INFO : Running cycle 1/1 for v8_7 test... 06:41:36 INFO - 2015-10-27 06:41:36,407 DEBUG : command line: C:\slave\test-pgo\build\application\firefox\firefox -profile c:\users\cltbld\appdata\local\temp\tmp_1qvbj\profile -tp file:\C:\slave\test-pgo\build\tests\talos\talos\tests\v8_7\v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:41:47 INFO - 2015-10-27 06:41:47,818 DEBUG : BROWSER_OUTPUT: RSS: Main: 147128320 06:41:47 INFO - 2015-10-27 06:41:47,818 DEBUG : BROWSER_OUTPUT: 06:42:09 INFO - 2015-10-27 06:42:09,338 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49894/tests/v8_7/run.html (next: http://localhost:49894/tests/v8_7/run.html) 06:42:09 INFO - 2015-10-27 06:42:09,592 DEBUG : BROWSER_OUTPUT: RSS: Main: 503250944 06:42:09 INFO - 2015-10-27 06:42:09,592 DEBUG : BROWSER_OUTPUT: 06:42:09 INFO - 2015-10-27 06:42:09,592 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:42:09 INFO - 2015-10-27 06:42:09,592 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:42:09 INFO - 2015-10-27 06:42:09,592 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:42:09 INFO - 2015-10-27 06:42:09,592 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:42:09 INFO - 2015-10-27 06:42:09,592 DEBUG : BROWSER_OUTPUT: |0;Richards;151.37753557372085 06:42:09 INFO - 2015-10-27 06:42:09,592 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;202.42914979757086 06:42:09 INFO - 2015-10-27 06:42:09,592 DEBUG : BROWSER_OUTPUT: |2;Encrypt;293.68575624082234 06:42:09 INFO - 2015-10-27 06:42:09,592 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5775.862068965517 06:42:09 INFO - 2015-10-27 06:42:09,592 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1412.4293785310736 06:42:09 INFO - 2015-10-27 06:42:09,592 DEBUG : BROWSER_OUTPUT: |5;Earley;675.6756756756756 06:42:09 INFO - 2015-10-27 06:42:09,592 DEBUG : BROWSER_OUTPUT: |6;Boyer;10416.666666666666 06:42:09 INFO - 2015-10-27 06:42:09,594 DEBUG : BROWSER_OUTPUT: |7;RegExp;30636.363636363636 06:42:09 INFO - 2015-10-27 06:42:09,594 DEBUG : BROWSER_OUTPUT: |8;Splay;580.046403712297 06:42:09 INFO - 2015-10-27 06:42:09,594 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;5427.027027027027 06:42:09 INFO - 2015-10-27 06:42:09,594 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:42:09 INFO - 2015-10-27 06:42:09,594 DEBUG : BROWSER_OUTPUT: __startTimestamp1445953329589__endTimestamp 06:42:09 INFO - 2015-10-27 06:42:09,594 DEBUG : BROWSER_OUTPUT: 06:42:09 INFO - 2015-10-27 06:42:09,594 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:42:09 INFO - 2015-10-27 06:42:09,594 DEBUG : BROWSER_OUTPUT: Number of tests: 10 06:42:09 INFO - 2015-10-27 06:42:09,594 DEBUG : BROWSER_OUTPUT: 06:42:09 INFO - 2015-10-27 06:42:09,594 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:151.38 Median:151.38 stddev:0.00 (0.0%) 06:42:09 INFO - 2015-10-27 06:42:09,594 DEBUG : BROWSER_OUTPUT: Values: 151.4 06:42:09 INFO - 2015-10-27 06:42:09,594 DEBUG : BROWSER_OUTPUT: 06:42:09 INFO - 2015-10-27 06:42:09,594 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:202.43 Median:202.43 stddev:0.00 (0.0%) 06:42:09 INFO - 2015-10-27 06:42:09,594 DEBUG : BROWSER_OUTPUT: Values: 202.4 06:42:09 INFO - 2015-10-27 06:42:09,594 DEBUG : BROWSER_OUTPUT: 06:42:09 INFO - 2015-10-27 06:42:09,595 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:293.69 Median:293.69 stddev:0.00 (0.0%) 06:42:09 INFO - 2015-10-27 06:42:09,595 DEBUG : BROWSER_OUTPUT: Values: 293.7 06:42:09 INFO - 2015-10-27 06:42:09,595 DEBUG : BROWSER_OUTPUT: 06:42:09 INFO - 2015-10-27 06:42:09,595 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5775.86 Median:5775.86 stddev:0.00 (0.0%) 06:42:09 INFO - 2015-10-27 06:42:09,595 DEBUG : BROWSER_OUTPUT: Values: 5775.9 06:42:09 INFO - 2015-10-27 06:42:09,595 DEBUG : BROWSER_OUTPUT: 06:42:09 INFO - 2015-10-27 06:42:09,595 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1412.43 Median:1412.43 stddev:0.00 (0.0%) 06:42:09 INFO - 2015-10-27 06:42:09,595 DEBUG : BROWSER_OUTPUT: Values: 1412.4 06:42:09 INFO - 2015-10-27 06:42:09,595 DEBUG : BROWSER_OUTPUT: 06:42:09 INFO - 2015-10-27 06:42:09,595 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:675.68 Median:675.68 stddev:0.00 (0.0%) 06:42:09 INFO - 2015-10-27 06:42:09,595 DEBUG : BROWSER_OUTPUT: Values: 675.7 06:42:09 INFO - 2015-10-27 06:42:09,595 DEBUG : BROWSER_OUTPUT: 06:42:09 INFO - 2015-10-27 06:42:09,595 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10416.67 Median:10416.67 stddev:0.00 (0.0%) 06:42:09 INFO - 2015-10-27 06:42:09,595 DEBUG : BROWSER_OUTPUT: Values: 10416.7 06:42:09 INFO - 2015-10-27 06:42:09,595 DEBUG : BROWSER_OUTPUT: 06:42:09 INFO - 2015-10-27 06:42:09,595 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:30636.36 Median:30636.36 stddev:0.00 (0.0%) 06:42:09 INFO - 2015-10-27 06:42:09,595 DEBUG : BROWSER_OUTPUT: Values: 30636.4 06:42:09 INFO - 2015-10-27 06:42:09,595 DEBUG : BROWSER_OUTPUT: 06:42:09 INFO - 2015-10-27 06:42:09,595 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:580.05 Median:580.05 stddev:0.00 (0.0%) 06:42:09 INFO - 2015-10-27 06:42:09,595 DEBUG : BROWSER_OUTPUT: Values: 580.0 06:42:09 INFO - 2015-10-27 06:42:09,595 DEBUG : BROWSER_OUTPUT: 06:42:09 INFO - 2015-10-27 06:42:09,595 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:5427.03 Median:5427.03 stddev:0.00 (0.0%) 06:42:09 INFO - 2015-10-27 06:42:09,595 DEBUG : BROWSER_OUTPUT: Values: 5427.0 06:42:09 INFO - 2015-10-27 06:42:09,595 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:42:09 INFO - 2015-10-27 06:42:09,595 DEBUG : BROWSER_OUTPUT: 06:42:10 INFO - 2015-10-27 06:42:10,193 INFO : Browser exited with error code: 0 06:42:10 INFO - 2015-10-27 06:42:10,851 INFO : Completed test v8_7 (00:00:40) 06:42:11 INFO - 2015-10-27 06:42:10,997 INFO : Completed test suite (00:20:19) 06:42:11 INFO - 2015-10-27 06:42:10,997 DEBUG : Working with test: dromaeo_css 06:42:11 INFO - 2015-10-27 06:42:10,997 DEBUG : Generating results file: dromaeo_css 06:42:11 INFO - 2015-10-27 06:42:10,999 DEBUG : Working with test: kraken 06:42:11 INFO - 2015-10-27 06:42:10,999 DEBUG : Generating results file: kraken 06:42:11 INFO - 2015-10-27 06:42:10,999 INFO : javascript benchmark 06:42:11 INFO - 2015-10-27 06:42:10,999 DEBUG : Working with test: v8_7 06:42:11 INFO - 2015-10-27 06:42:10,999 DEBUG : Generating results file: v8_7 06:42:11 INFO - 2015-10-27 06:42:10,999 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:42:11 INFO - 2015-10-27 06:42:11,068 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,25]] 06:42:11 INFO - 2015-10-27 06:42:11,068 DEBUG : process_Request line: dromaeo_css 6178.26 graph.html#tests=[[72,63,25]] 06:42:11 INFO - 2015-10-27 06:42:11,068 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:42:11 INFO - 2015-10-27 06:42:11,190 DEBUG : process_Request line: kraken 1631.70 graph.html#tests=[[232,63,25]] 06:42:11 INFO - 2015-10-27 06:42:11,190 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:42:11 INFO - 2015-10-27 06:42:11,220 DEBUG : process_Request line: v8_7 20410.67 graph.html#tests=[[230,63,25]] 06:42:11 INFO - 2015-10-27 06:42:11,220 INFO : javascript benchmark 06:42:11 INFO - 2015-10-27 06:42:11,223 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [275.7325394367463, 277.53097265621096, 286.5987617335731, 289.73778730249126, 292.1119795820705, 16352.345906163739, 16353.264103115358, 17054.48836534903, 17302.913485432586, 17875.553111172227, 12396.93801530991, 15562.187264120277, 15660.608484787886, 15832.44586439475, 16994.235259413326, 5271.446498117691, 5376.032314183445, 5381.569474442055, 5384.461553844623, 5396.163594642817, 4347.934780978288, 4690.97654511727, 4703.035877645075, 4708.670393072486, 5313.468653134694, 3580.982095089521, 3638.108663377476, 4693.249080147177, 4805.135075686392, 4809.711417314972, 4682.859514214579, 4749.667523273355, 4777.402824646936, 4791.233402655594, 4796.808127674906, 3968.3849003404516, 4026.134381108076, 4038.353863381845, 4039.414284928698, 4045.5347635022054, 13048.217106973612, 13081.345932703422, 13211.40548675312, 13214.207147571176, 13276.867231327757, 1196.7427003194268, 1934.0619799397282, 1968.1635304995464, 2082.1994417508577, 2082.8437867160023, 9777.755556111155, 10015.298929074968, 10144.492775361203, 10180.23648226386, 10193.796124077477, 1602.6073611965026, 1633.3058450158635, 1655.9420420285232, 1693.7459381092935, 1699.17589968865, 69153.30846691519, 71913.28086719118, 71990.0, 72363.0, 73127.26872731258, 6015.669138197353, 6196.411340922605, 6245.28179259391, 6298.212723409574, 6341.143945567382, 6855.0, 7232.240614735482, 7262.20115787263, 7269.854602908018, 7274.636268186569, 5216.9739151304, 5237.188235823453, 5246.658967167122, 5246.973765131226, 5262.0, 5141.740273632984, 5270.7101109439345, 5588.9720551397795, 5591.41290164535, 5634.830955071355, 2677.290518012728, 2680.879360428746, 2725.4957832800997, 2827.067067867599, 2844.7155284471387, 940.3605548227271, 956.5121787888227, 982.4498280962683, 982.6364245229167, 1045.9958439897632, 392.1764294980518, 405.2502869691048, 405.7869618450278, 424.60511724096267, 450.5809597074752, 11143.275687080313, 11166.720831979266, 11211.495482703298, 11260.831087533694, 11627.59303424376, 435.1905455852112, 439.949405818335, 449.85379751580865, 454.4115370595087, 462.3319303606324, 6109.20580324555, 6156.846078848064, 6185.41238582334, 6319.33646967071, 6331.335209802996, 307473.0, 310299.0, 420514.0, 424842.0, 425835.0, 75877.24122758812, 77122.6143869277, 77312.61343693358, 78838.0, 79219.60390198012, 452.1093445911549, 471.7429001194357, 475.09731510130337, 479.2715073088955, 479.3983550643989, 10387.844182337421, 10887.673369798918, 10949.124070074535, 10993.725156871142, 11081.0, 38183.0, 39395.80302098471, 39680.801595991834, 40215.79892100521, 40610.18779624332, 53258.20112698235, 53808.46191538034, 54424.0, 54489.45510544844, 54794.17808732952, 5651.265335506358, 5965.164876917148, 5991.161237426851, 6037.939620603914, 6062.393760623902, 11849.763004739685, 12190.205735165326, 12318.260904345409, 12322.137450378388, 12335.629931102081, 10110.39337639744, 10326.432046237529, 10399.63601273982, 10423.68728938133, 10434.165266778487, 9446.574904129468, 9631.855522167314, 10158.6444474446, 10237.9488102559, 10270.127039201752, 10217.540210690686, 10866.0, 10871.945640271748, 10893.237473376788, 10908.61819836302, 6050.969745151246, 6076.756929722762, 6091.299500557316, 6094.939050609437, 6294.748210071546, 10586.735331616772, 10638.255322127377, 10818.0, 10847.45762711877, 10897.727556811144], "dojo.html": [2611.0208671748096, 2667.333166708322, 2700.257429206969, 2705.296622878051, 2713.0, 5025.170846810276, 5056.342675452186, 5065.670731402456, 5155.3040339554145, 5162.096633089203, 5098.286239926413, 5099.388073431193, 5166.095933211683, 5195.246689230059, 5203.167493201088, 4379.146066517031, 4418.734875907456, 4495.213337665912, 4515.232410490208, 4516.412866327381, 4391.187630288391, 4392.209402307583, 4413.668974826885, 4415.646748260131, 4427.180971520263, 4458.866234012985, 4475.910481790363, 4481.686281960264, 4495.3931219285305, 4499.550044995507, 4296.5273819879785, 4400.779961001953, 4479.484859241196, 4482.865514034552, 4492.573205545468, 4263.424437700902, 4354.085642015149, 4438.3564383164585, 4458.0415210729525, 4466.0, 4789.736564488951, 4827.8551643450755, 5095.464976177522, 5220.138677118271, 5228.189630607262, 4970.527799859007, 5103.974480127576, 5149.742512874379, 5195.0, 5199.896002079937, 5154.948450515484, 5313.840584782462, 5380.973095134538, 5392.0294347017525, 5504.064309067428, 5018.673786203922, 5023.472535383805, 5041.344625198737, 5054.545090941796, 5127.7948882044675, 5238.004779091961, 5343.278657381282, 5452.100403433389, 5543.8891222176135, 5634.098544232903, 5027.899442011212, 5171.741412929414, 5250.921236181384, 5410.810621628303, 5422.295101636762, 5370.167624018283, 5370.248165256867, 5430.864228394322, 5440.483154100354, 5463.453654634584, 5105.5149760772665, 5114.488551144856, 5179.533841954242, 5406.891862162814, 5453.64551304164, 5249.816256431007, 5336.573074154058, 5348.812791552277, 5387.461253874581, 5469.753861076261, 3212.8072315661134, 3390.0507857799857, 3439.9852043647184, 3440.208751987057, 3441.2257242120822, 2979.6275465566805, 3000.2799328161086, 3001.474741920199, 3006.2334104803135, 3142.0, 4757.0, 4843.4430040545785, 4858.514148585114, 4865.051314993613, 4945.604351651859, 5055.595552355802, 5064.164412871909, 5140.665856719302, 5446.183072539151, 5459.0, 5118.616103792156, 5216.739163041832, 5308.708021058879, 5314.441983591744, 5319.0957537218765, 3863.942040869389, 4089.795510224477, 4250.383694364362, 4307.569243075667, 4418.734875907456, 5223.921641175461, 5255.5532779713385, 5336.733163341817, 5350.384705758887, 5416.945830541802, 5169.689818610896, 5264.552513036435, 5387.353517577916, 5525.585581081516, 5528.336599608073, 5237.869053273698, 5511.53151982086, 5619.213310136666, 5624.943750562442, 5708.885822283614, 5238.0833354162105, 5287.0, 5359.919601206063, 5367.946320536901, 5371.785128594969, 5208.713520756395, 5238.68567885928, 5351.411344752152, 5441.83674489766, 5560.443955604407, 5212.582993360598, 5263.947360526346, 5296.841094767009, 5309.973450132725, 5405.189221616789, 5216.504432078947, 5221.321228240305, 5295.338082739658, 5311.867203319948, 5323.680579165262, 5185.118529849859, 5188.481151884781, 5301.072312345401, 5308.946910531, 5309.628326017141, 5214.608904332114, 5285.497877701612, 5289.153735402471, 5334.11987022137, 5421.0, 5207.635465517377, 5282.630215885005, 5285.048691235615, 5330.067238233371, 5373.086575282133], "mootools.html": [1092.9617463388784, 1099.373357186404, 1138.9886101138989, 1362.6116556781312, 1469.8456662050492, 5848.5321174305955, 6002.159697642333, 6686.799396018115, 6694.665266736662, 6808.6255255960905, 6388.361163883609, 6559.3112723164095, 6562.934370656292, 6944.930550694491, 6964.408025317842, 1916.3675986924281, 1920.4526709887684, 2037.8064083912004, 2040.6632905570564, 2040.928567500138, 1755.7103077992117, 1782.0376996421917, 2010.909509072088, 2033.613613413454, 2051.866628669139, 2026.0, 2041.3773798991301, 2044.4684382060623, 2045.1819272291127, 2045.642012647788, 1851.7037274036156, 1872.9438116856516, 1924.9711254331196, 1957.6280506703752, 1966.3117908731972, 1988.2146552111979, 1993.3123072540095, 1998.400479856052, 2017.243533674872, 2019.151956178394, 6358.87282254357, 6818.2159051708695, 6827.965860170717, 6832.6925288362145, 6839.316068393171, 4112.0, 4216.072464057902, 4226.830926762926, 4229.830806767725, 4238.618524332794, 2854.0, 2907.752841008517, 2917.1102813641833, 2926.4878646236825, 2938.0598208573265, 746.664001199457, 778.1479280188184, 851.2466467176531, 888.0320450708693, 889.4174315823146, 8328.458650187778, 8493.702720404817, 8564.357673174474, 8602.956985215096, 9015.233705135071, 3602.9279414411567, 3675.9264814703556, 3702.4631428443263, 3729.086373838427, 3733.663970242637, 7500.662470188855, 7855.7250496232355, 7989.800254993672, 7991.800204994805, 8006.039275286887, 4104.4664193654635, 4167.645750111214, 4329.502107257643, 4331.805068771912, 4331.935020974688, 3998.0404702871683, 4002.9799851000557, 4005.2590270799997, 4005.439238506611, 4010.218007488512, 2848.7151284871347, 2852.9286767830554, 2981.016264632666, 2992.6408830940427, 3025.2588115911744, 924.7318277699526, 943.3726571829657, 958.6644674364056, 961.7739831139677, 982.2142286171035, 1017.8778546574458, 1056.6196169379018, 1059.5920570580229, 1062.9742298681808, 1111.6831702964616, 6301.6534090625455, 6353.936460635427, 6359.618422894641, 6361.459275961595, 6362.840928976812, 371.1815446939492, 393.7243929249537, 397.35826639976233, 397.64609497547207, 402.50089888538, 4717.787699553528, 4870.0746858096845, 4897.681650692693, 4975.577075948585, 5011.198208286657, 7720.845583088307, 7756.146823849372, 7980.521168729895, 8037.196280371916, 8182.427230093956, 7966.800829979181, 8126.065502467174, 8127.674893004332, 8145.551994640233, 8146.389020823462, 5827.475527202572, 6045.969770151209, 6279.246490421087, 6462.676866156768, 6506.446952009038, 5523.972380138073, 5796.9420305798085, 5947.1079338099635, 6084.60450070744, 6162.476189523762, 6741.1910570731825, 6750.628715420503, 7189.604571748604, 7212.927870721225, 7215.567065976058, 6948.965255173692, 7271.127464704269, 7329.303716146957, 7347.853042939005, 7444.069491313586, 6293.811185664437, 6352.968235158794, 6354.809355719336, 6358.332375100733, 6361.586496877688, 6102.603330783485, 6413.134226879498, 6660.866782664417, 6733.192016957996, 6743.460523158234, 5932.940670593239, 5967.910481342697, 5995.430434108753, 6156.630602163885, 6351.0, 5471.206675032177, 5790.305163380422, 6122.204113465221, 6156.076588511759, 6260.843478913063, 5874.118882167709, 5924.437178468039, 6193.349698281616, 6281.560290779602, 6287.434130928055, 5263.394709608444, 5263.447338029605, 5527.8894422112135, 5578.60949733531, 5594.440555944373, 5672.347680016851, 5678.432156784289, 5687.317521897398, 5693.718913244486, 5703.0], "ext.html": [460.7673125071838, 475.5862399712251, 494.4709161197518, 501.78674063523016, 502.54770706364246, 29621.185987331195, 29733.10800675978, 29734.0, 37254.0, 38864.0, 39155.21689566214, 40879.79560102196, 41074.0, 41094.794526027326, 41113.58886411142, 8138.430309878311, 8431.747047588551, 8580.957095214515, 8593.656253749843, 8609.096044915288, 7528.51064680794, 7706.0, 10264.846027309597, 10643.467826608678, 10708.089812365959, 10512.0, 10621.84067238992, 10653.147748180127, 10661.78676426471, 10665.040146386824, 7578.583177925212, 7722.691092356299, 10637.468126593678, 10729.517171727291, 10766.623168189075, 10386.636467723594, 10554.841677374845, 10642.680719578426, 10648.893511064867, 10650.840237396445, 37904.620953790385, 37911.81044094789, 38226.80886595577, 38351.23297534034, 38352.80823595864, 3118.501039833616, 3202.8558714857886, 3231.579894613709, 3253.6258330292085, 3509.718682856164, 29015.709842901513, 29942.401151977057, 30191.0, 30487.23781905448, 31142.22144446407, 2535.492901419705, 2650.1387049208893, 2694.9326266843486, 2748.862556872168, 2772.7365900239447, 310293.0, 310972.0, 311897.0, 312190.43904780556, 312424.43787780916, 45202.0, 45933.77033114813, 53452.19821702677, 53720.462795372325, 53800.46199538033, 58184.0, 59104.408955909894, 59303.70348148232, 59325.40674593285, 59325.703371482865, 12762.872371276355, 13685.31573421345, 13712.794308085387, 13753.312334383241, 13791.793123103162, 10347.223958203165, 10358.067773900386, 10361.4301213434, 10372.740681483023, 10400.843987340197, 16495.670086598202, 16918.238679259463, 17312.134393280285, 17470.47588572345, 17476.650466990843, 7209.0, 7218.314260145278, 7408.481406301507, 7566.497933729423, 7656.540607563564, 826.8428998490267, 857.0957639690187, 890.7550423633553, 942.9434233945985, 981.455292312759, 26911.461770764865, 27042.864785675945, 27529.31176720598, 27538.724612754017, 28196.577051344248, 913.6345461815195, 978.1441238915949, 983.4246965525248, 988.3180605382263, 1072.3512275073624, 13976.720465590632, 14224.0, 14249.216293103771, 14272.000959932913, 14568.927155364367, 348279.0, 355158.0, 355631.0, 355835.0, 356451.0, 47303.5269647306, 47561.0, 48000.0, 48046.27930581044, 48083.519164807905, 1104.812181929074, 1120.260627985542, 1157.3692337675986, 1174.788538063157, 1183.7336599265268, 23014.884925575934, 26711.599326010513, 27050.323741905824, 27198.864005680636, 29240.0, 42469.575304247795, 44630.55369446264, 44893.55106448894, 45122.77438612786, 45213.32180017368, 295227.0, 295728.0, 300490.0, 313247.0, 371395.0, 22910.73990930448, 25374.372713277575, 27428.86285568639, 27672.861635691694, 27695.44609107766, 37059.0, 37388.439173411876, 37651.246975060894, 39301.0, 39405.605943941344, 31181.53227701632, 31208.21979450441, 31520.369592608477, 32280.414102686318, 34065.31869362549, 31094.53358199674, 31916.6808331923, 32804.67195328016, 32984.83507582447, 33783.0, 35103.82448087743, 35577.1105722359, 35639.28721425609, 35832.28335433329, 35843.82078089593, 28545.28636784097, 29880.402391952473, 30259.0, 30774.230644234074, 31204.843975779975, 23879.41808728635, 24436.26691199267, 24718.0, 24993.75006249914, 25389.0], "prototype.html": [274.872184434238, 278.1932396051451, 278.97489225969656, 281.24485755745826, 290.60187543065996, 5650.63270887392, 5658.91511627326, 5667.5749318801045, 5677.772889084432, 5681.488666020057, 5583.441655834415, 5590.105583106703, 5600.719964001804, 5603.943960560393, 5610.102383618621, 3804.1250512382167, 3822.311983842907, 3838.769673819566, 3839.7921195312597, 3852.287326844543, 3782.8486860525545, 3792.639699228569, 3856.402257650069, 3857.4599556062176, 3985.6612187964056, 3849.1724279279947, 3885.844566217362, 4042.130941847502, 4042.959570404302, 4058.6144316289906, 4068.7965601720093, 4070.043539768152, 4072.9185416291803, 4074.0425999890003, 4079.0, 3258.4460641690735, 3548.3790336690977, 3551.058969373118, 3554.2180720241504, 3561.8397172127316, 4994.750262486861, 5117.46266642001, 5133.640645154841, 5501.477359650827, 5528.5024347808485, 4811.975940120312, 4813.735244561548, 4814.422269327703, 4814.831480898187, 4817.855464336076, 5618.0, 5711.428857114297, 5822.563307751893, 5823.2138661280605, 5826.747249341412, 3976.681865450757, 3980.7014473914282, 3981.402789581557, 3981.5620281768984, 3985.1631157456677, 6024.939750602525, 6055.152278680988, 6077.361877002895, 6086.147939288503, 6115.143879856868, 3995.5604883462797, 4008.318585840414, 4010.1378203685763, 4012.378081397388, 4014.578469260686, 4043.4541336919137, 4058.411530328086, 4065.6137666921595, 4067.5322337930925, 4069.064115253449, 4459.977700111479, 4469.262571675637, 4477.440319960005, 4697.295405689174, 4766.928496072562, 5850.9414905851245, 5867.2959244890035, 5872.442117998783, 5874.412558744177, 5874.618149820248, 1368.4868174434587, 1410.0200360749182, 1463.817022872141, 1466.5013895275658, 1480.060161797245, 970.2771435280761, 998.8751406074241, 1010.3533738407425, 1014.4369874719454, 1016.6340117557673, 5215.6609820361555, 5362.115250983544, 5536.086545719992, 5680.573956953162, 5681.2330335404195, 5942.168096466498, 5978.760849566055, 6011.579189456696, 6012.158297838306, 6018.428249316308, 5543.334799824047, 5668.546516278688, 5672.5745569081655, 5679.346875109332, 5686.857828554319, 3157.1372889995014, 3272.5745653065424, 3315.8839440619463, 3352.2122301259183, 3353.782004169721, 6379.744810207632, 6394.392532709385, 6446.484281257488, 6451.612903225821, 6451.999940009306, 6090.994985827378, 6149.754009839557, 6194.876102478015, 6232.688365581703, 6233.3143354231, 5995.760169593254, 6223.533235007302, 6293.811185664437, 6424.164858568356, 6428.292887782433, 5865.090910908816, 6174.845628859314, 6201.875962480815, 6206.658633775186, 6212.534059945432, 6048.848778780566, 6076.210092687922, 6090.756369745161, 6095.238095238095, 6099.84750381244, 5962.582619216613, 6189.50483961273, 6458.838529036811, 6495.480361571157, 6502.057201705632, 3734.4958430612605, 3761.9623803762706, 3764.8705388383923, 3766.0, 3866.052817059838, 6148.815535533941, 6158.846028849314, 6169.413905678954, 6173.506119510339, 6176.845578860564, 5628.0, 5660.15097735343, 5882.352941176553, 6003.939960600338, 6005.969970150296, 5852.4147585241135, 5921.171036055042, 5945.881082378415, 5952.702364881825, 6014.308354539284, 5789.1895134680335, 5800.8259752207505, 5812.244408226903, 5813.040848260159, 5817.0983497557945, 5979.940200597938, 5981.491573216152, 5987.700614969147, 5988.041913293852, 5991.670458124845, 5848.678322692293, 5862.824115276549, 5877.324107727666, 5888.116782482662, 5896.14505896634], "yui.html": [634.4892361648871, 662.5958165519032, 674.861653361061, 744.7430636430431, 767.3055884424596, 13535.729285414285, 14029.579112626612, 14117.576472705823, 14180.290985450712, 14241.786373204397, 12213.389330533482, 12536.310502922335, 12600.180988235757, 12641.55754548591, 12766.489340426371, 470.67288234676914, 473.96919200252046, 563.8393057978467, 569.5870493891916, 597.2325561653277, 568.3038278109325, 596.2219303808528, 601.2724603230097, 606.1877084706492, 606.3481757111101, 592.602956019468, 606.8452544601121, 615.6398506873485, 629.8456878064881, 630.2940706408806, 511.69809812210974, 517.420489052262, 613.1691557939017, 622.9719662615194, 628.1770880147, 440.38346315158714, 449.7526360501744, 450.7115446114457, 450.79038247214874, 451.82830524400845, 12834.550790722373, 12860.871391286155, 12901.935490322583, 12945.417456214493, 12945.805812912813, 9817.0, 9825.656102036395, 10253.897461025368, 10481.056704896597, 10743.247972641919, 10089.243306751949, 10217.702208803385, 10306.175505959505, 10509.474526273656, 10897.891021089847, 3175.2061984503875, 3265.5264986576813, 3266.591676040495, 3321.2693207494312, 3372.2243883906594, 55237.44762552363, 56014.43985560133, 56839.93741658464, 56876.0, 57023.714881425745, 6994.755183568551, 7021.29787021304, 7039.472039597051, 7052.294770522906, 7193.89209161863, 10637.734056648645, 10640.78718425627, 10664.0, 10696.679099627023, 10753.892461075446, 6641.169853768279, 6700.765473208512, 6769.881911378578, 6795.762148324884, 6941.618210998343, 4010.1177740896956, 4156.189543039079, 4171.97914010428, 4193.412922190896, 4257.169851878916, 2606.244189185115, 2642.2337522118755, 2648.1658277642864, 2651.3901802585515, 2655.2034389683017, 429.27024059099654, 430.5715812766318, 431.24962565137065, 435.505701029334, 437.0777659139214, 568.9061304884731, 616.7255571270741, 660.8082959306633, 675.2976904019863, 703.0614130136223, 8819.691310804219, 9118.772030699285, 9237.168654821098, 9345.20565751905, 9431.811363772686, 567.3560508822516, 586.4370204603629, 623.7975286113832, 634.9777757778455, 669.9196096468455, 4298.41971333866, 4675.18184317743, 4794.760261986887, 4925.0, 4925.21196608541, 71684.2831571688, 72029.6398518004, 73108.0, 73934.0, 74150.21422750533, 63241.05138422927, 63449.68275158595, 63696.0, 63890.36109638937, 64249.35750642527, 53753.0, 55511.16733249005, 56181.43818561844, 57022.0, 57382.42617573855, 9453.33826632129, 9511.524423778921, 9826.472061456581, 9982.850257246002, 10059.748506287402, 39623.40564891587, 39966.40050399304, 40088.59911400849, 41925.79037104795, 42008.63930885461, 53206.137785177336, 53242.73378633082, 54551.18173227484, 55099.72450137723, 56204.43795561992, 8176.959115204386, 8218.301444377295, 8702.91297087021, 8774.473531588124, 8992.194103316315, 13089.345532723517, 13168.341582921008, 13322.400491978078, 13580.86419135796, 13992.860071399564, 12593.055520835791, 13210.867891320964, 13360.866391335961, 13414.195148291134, 13654.453821847412, 12948.805767913676, 12968.740625187633, 13155.802662960255, 13288.734225315246, 13371.866281337063, 12961.287129207984, 13081.411336489691, 13278.601641950758, 13656.795148072588, 13886.305684715522, 10058.597656093967, 10948.835767463335, 11008.39453830015, 11226.326420414802, 11965.0, 9775.657851975147, 10230.948845256024, 10427.63914012467, 10845.891541084487, 11162.152487769943]}, "summary": {"suite": 6178.256515399027, "subtests": {"jquery.html": {"filtered": 6617.396803845887, "value": 6617.396803845887}, "dojo.html": {"filtered": 4837.858069546202, "value": 4837.858069546202}, "mootools.html": {"filtered": 3773.058224953821, "value": 3773.058224953821}, "ext.html": {"filtered": 17567.707163642976, "value": 17567.707163642976}, "prototype.html": {"filtered": 4351.806380266667, "value": 4351.806380266667}, "yui.html": {"filtered": 6021.875834900571, "value": 6021.875834900571}}}, "test_machine": {"platform": "x86", "osversion": "6.1.7601", "os": "win", "name": "T-W732-IX-028"}, "testrun": {"date": 1445952111, "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": "20151027013036", "branch": "Mozilla-Inbound", "revision": "f1966d9bbf475e1ed4a3aeaaac0be37fdb61c1ab"}}, {"talos_counters": {}, "results": {"audio-dft": [156.0, 163.0, 152.0, 152.0, 154.0, 154.0, 156.0, 153.0, 161.0, 161.0], "ai-astar": [90.0, 97.0, 100.0, 92.0, 94.0, 94.0, 101.0, 101.0, 95.0, 96.0], "imaging-gaussian-blur": [116.0, 117.0, 124.0, 124.0, 123.0, 124.0, 123.0, 124.0, 123.0, 117.0], "audio-beat-detection": [135.0, 140.0, 144.0, 152.0, 128.0, 134.0, 140.0, 130.0, 150.0, 146.0], "json-stringify-tinderbox": [81.0, 82.0, 79.0, 83.0, 78.0, 78.0, 83.0, 78.0, 80.0, 82.0], "stanford-crypto-pbkdf2": [197.0, 206.0, 206.0, 204.0, 204.0, 198.0, 204.0, 196.0, 209.0, 208.0], "json-parse-financial": [79.0, 80.0, 79.0, 82.0, 84.0, 79.0, 81.0, 80.0, 80.0, 94.0], "stanford-crypto-sha256-iterative": [85.0, 85.0, 91.0, 85.0, 85.0, 86.0, 88.0, 86.0, 87.0, 85.0], "audio-fft": [107.0, 89.0, 77.0, 103.0, 80.0, 83.0, 90.0, 83.0, 103.0, 74.0], "imaging-darkroom": [149.0, 158.0, 148.0, 158.0, 157.0, 156.0, 159.0, 158.0, 158.0, 147.0], "stanford-crypto-ccm": [122.0, 119.0, 123.0, 124.0, 130.0, 122.0, 126.0, 124.0, 120.0, 124.0], "audio-oscillator": [97.0, 95.0, 111.0, 100.0, 102.0, 102.0, 123.0, 101.0, 101.0, 118.0], "stanford-crypto-aes": [96.0, 97.0, 97.0, 102.0, 102.0, 102.0, 103.0, 102.0, 99.0, 98.0], "imaging-desaturate": [90.0, 91.0, 90.0, 97.0, 97.0, 91.0, 97.0, 98.0, 97.0, 97.0]}, "summary": {"suite": 1631.7, "subtests": {"audio-fft": {"filtered": 88.9, "value": 88.9}, "stanford-crypto-pbkdf2": {"filtered": 203.2, "value": 203.2}, "audio-beat-detection": {"filtered": 139.9, "value": 139.9}, "stanford-crypto-ccm": {"filtered": 123.4, "value": 123.4}, "imaging-darkroom": {"filtered": 154.8, "value": 154.8}, "json-parse-financial": {"filtered": 81.8, "value": 81.8}, "audio-oscillator": {"filtered": 105.0, "value": 105.0}, "ai-astar": {"filtered": 96.0, "value": 96.0}, "audio-dft": {"filtered": 156.2, "value": 156.2}, "stanford-crypto-sha256-iterative": {"filtered": 86.3, "value": 86.3}, "json-stringify-tinderbox": {"filtered": 80.4, "value": 80.4}, "imaging-gaussian-blur": {"filtered": 121.5, "value": 121.5}, "stanford-crypto-aes": {"filtered": 99.8, "value": 99.8}, "imaging-desaturate": {"filtered": 94.5, "value": 94.5}}}, "test_machine": {"platform": "x86", "osversion": "6.1.7601", "os": "win", "name": "T-W732-IX-028"}, "testrun": {"date": 1445952111, "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": "20151027013036", "branch": "Mozilla-Inbound", "revision": "f1966d9bbf475e1ed4a3aeaaac0be37fdb61c1ab"}}, {"talos_counters": {}, "results": {"DeltaBlue": [202.42914979757086], "Encrypt": [293.68575624082234], "NavierStokes": [5427.027027027027], "Decrypt": [5775.862068965517], "Splay": [580.046403712297], "Richards": [151.37753557372085], "RegExp": [30636.363636363636], "Earley": [675.6756756756756], "Boyer": [10416.666666666666], "RayTrace": [1412.4293785310736]}, "summary": {"suite": 20410.66551140022, "subtests": {"DeltaBlue": {"filtered": 326.62292, "value": 326.62292}, "Encrypt": {"filtered": 906.3463049999999, "value": 906.3463049999999}, "NavierStokes": {"filtered": 273.4462151394421, "value": 273.4462151394421}, "Decrypt": {"filtered": 46.08506865671644, "value": 46.08506865671644}, "Splay": {"filtered": 140.490484, "value": 140.490484}, "RegExp": {"filtered": 29.735415430267068, "value": 29.735415430267068}, "Richards": {"filtered": 233.2050120000001, "value": 233.2050120000001}, "Earley": {"filtered": 986.3652400000001, "value": 986.3652400000001}, "Boyer": {"filtered": 63.980448000000024, "value": 63.980448000000024}, "RayTrace": {"filtered": 523.912212, "value": 523.912212}}}, "test_machine": {"platform": "x86", "osversion": "6.1.7601", "os": "win", "name": "T-W732-IX-028"}, "testrun": {"date": 1445952111, "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": "20151027013036", "branch": "Mozilla-Inbound", "revision": "f1966d9bbf475e1ed4a3aeaaac0be37fdb61c1ab"}}] 06:42:11 INFO - RETURN: dromaeo_css: 6178.26 06:42:11 INFO - RETURN: kraken: 1631.70 06:42:11 INFO - RETURN: v8_7: 20410.67 06:42:11 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,25]]", "result": "20410.67"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,25]]", "result": "1631.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,25]]", "result": "6178.26"}}} 06:42:11 INFO - Return code: 0 06:42:11 INFO - # TBPL SUCCESS # 06:42:11 INFO - Running post-action listener: _resource_record_post_action 06:42:11 INFO - Running post-run listener: _resource_record_post_run 06:42:12 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 84369920; Write bytes: 436580352; Read time: 1004510; Write time: 4529250 06:42:12 INFO - install - Wall time: 2s; CPU: 9.0%; Read bytes: 16384; Write bytes: 23588352; Read time: 23360; Write time: 379800 06:42:12 INFO - run-tests - Wall time: 1222s; CPU: 13.0%; Read bytes: 84346368; Write bytes: 411869696; Read time: 980200; Write time: 4148610 06:42:12 INFO - Running post-run listener: _upload_blobber_files 06:42:12 INFO - Blob upload gear active. 06:42:12 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 06:42:12 INFO - Copying logs to upload dir... 06:42:12 INFO - mkdir: C:\slave\test-pgo\build\upload\logs program finished with exit code 0 elapsedTime=1501.850000 ========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 25 mins, 31 secs) (at 2015-10-27 06:42:41.317006) ========= ========= Started set props: build_url (results: 0, elapsed: 1 secs) (at 2015-10-27 06:42:41.317669) ========= '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-028 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-028 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-028 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/Du_rld6bSpy-eFpAA-elIA/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/Du_rld6bSpy-eFpAA-elIA/artifacts/public/build/firefox-44.0a1.en-US.win32.zip' ========= Finished set props: build_url (results: 0, elapsed: 1 secs) (at 2015-10-27 06:42:42.871722) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-27 06:42:42.872066) ========= '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-028 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-028 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-028 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-27 06:42:43.782303) ========= ========= Started reboot slave lost (results: 0, elapsed: 10 secs) (at 2015-10-27 06:42:43.782625) ========= ========= Finished reboot slave lost (results: 0, elapsed: 10 secs) (at 2015-10-27 06:42:54.351704) =========