builder: b2g-inbound_win7-ix_test-dromaeojs-pgo slave: t-w732-ix-070 starttime: 1445459340.93 results: success (0) buildid: 20151021083202 builduid: 5a06b08a8e9c46d9adfe2f9a32702413 revision: a934f66fc9dbe80aeffc1c25fe178d5c63b97c7a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-21 13:29:00.934775) ========= master: http://buildbot-master112.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-21 13:29:00.935591) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-21 13:29:00.935903) ========= '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-070 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-070 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-070 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.628000 basedir: 'C:\\slave\\test-pgo' ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-21 13:29:01.776885) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 9 secs) (at 2015-10-21 13:29:01.777187) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 9 secs) (at 2015-10-21 13:29:11.163510) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-21 13:29:11.163782) ========= '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-070 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-070 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-070 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: 0 secs) (at 2015-10-21 13:29:12.013477) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-21 13:29:12.016084) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-21 13:29:12.016519) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 8 secs) (at 2015-10-21 13:29:12.016819) ========= '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-070 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-070 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-070 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 --13:29:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py => `archiver_client.py' Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12,141 (12K) [text/x-python] 0K .......... . 100% 2.10 GB/s 13:29:20 (2.10 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.706000 ========= Finished 'bash -c ...' (results: 0, elapsed: 8 secs) (at 2015-10-21 13:29:20.377217) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 13 secs) (at 2015-10-21 13:29:20.377541) ========= '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-070 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-070 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-070 USERNAME=cltbld USERPROFILE=C:\Users\cltbld WINDIR=C:\windows WINDOWS_TRACING_FLAGS=3 WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=12.801000 ========= Finished 'rm -rf ...' (results: 0, elapsed: 13 secs) (at 2015-10-21 13:29:33.408612) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-10-21 13:29:33.408974) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev a934f66fc9dbe80aeffc1c25fe178d5c63b97c7a --destination scripts --debug' in dir C:\slave\test-pgo\. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev a934f66fc9dbe80aeffc1c25fe178d5c63b97c7a --destination scripts --debug'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files\Common Files COMPUTERNAME=T-W732-IX-070 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-070 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-070 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-21 13:29:33,773 truncating revision to first 12 chars 2015-10-21 13:29:33,773 Setting DEBUG logging. 2015-10-21 13:29:33,773 attempt 1/10 2015-10-21 13:29:33,773 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/a934f66fc9db?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-10-21 13:29:34,265 unpacking tar archive at: b2g-inbound-a934f66fc9db/testing/mozharness/ program finished with exit code 0 elapsedTime=1.184000 ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-10-21 13:29:34.675240) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-21 13:29:34.675598) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-21 13:29:34.688946) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-21 13:29:34.689223) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-21 13:29:34.689645) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 29 mins, 25 secs) (at 2015-10-21 13:29:34.689938) ========= 'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'dromaeojs' '--add-option' '--webServer,localhost' '--branch-name' 'B2G-Inbound' '--system-bits' '32' '--cfg' 'talos/windows_config.py' '--download-symbols' 'ondemand' '--use-talos-json' '--blob-upload-branch' 'B2G-Inbound' in dir C:\slave\test-pgo\. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['c:/mozilla-build/python27/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--system-bits', '32', '--cfg', 'talos/windows_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files\Common Files COMPUTERNAME=T-W732-IX-070 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-070 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-070 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 13:29:35 INFO - MultiFileLogger online at 20151021 13:29:35 in C:\slave\test-pgo 13:29:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 32 --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 13:29:35 INFO - Dumping config to C:\slave\test-pgo\logs\localconfig.json. 13:29:35 INFO - {'append_to_log': False, 13:29:35 INFO - 'base_work_dir': 'C:\\slave\\test-pgo', 13:29:35 INFO - 'blob_upload_branch': 'B2G-Inbound', 13:29:35 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test-pgo\\oauth.txt', 13:29:35 INFO - 'branch': 'B2G-Inbound', 13:29:35 INFO - 'buildbot_json_path': 'buildprops.json', 13:29:35 INFO - 'config_files': ('talos/windows_config.py',), 13:29:35 INFO - 'default_actions': ('clobber', 13:29:35 INFO - 'read-buildbot-config', 13:29:35 INFO - 'download-and-extract', 13:29:35 INFO - 'populate-webroot', 13:29:35 INFO - 'create-virtualenv', 13:29:35 INFO - 'install', 13:29:35 INFO - 'run-tests'), 13:29:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:29:35 INFO - 'download_minidump_stackwalk': True, 13:29:35 INFO - 'download_symbols': 'ondemand', 13:29:35 INFO - 'exes': {'easy_install': ('C:\\slave\\test-pgo\\build/venv/scripts/python', 13:29:35 INFO - 'C:\\slave\\test-pgo\\build/venv/scripts/easy_install-2.7-script.py'), 13:29:35 INFO - 'hg': 'c:/mozilla-build/hg/hg', 13:29:35 INFO - 'mozinstall': ('C:\\slave\\test-pgo\\build/venv/scripts/python', 13:29:35 INFO - 'C:\\slave\\test-pgo\\build/venv/scripts/mozinstall-script.py'), 13:29:35 INFO - 'python': 'c:/mozilla-build/python27/python.exe', 13:29:35 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe', 13:29:35 INFO - 'C:/mozilla-build/tooltool.py'), 13:29:35 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe', 13:29:35 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 13:29:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:29:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:29:35 INFO - 'installer_path': 'installer.exe', 13:29:35 INFO - 'log_level': 'info', 13:29:35 INFO - 'log_name': 'talos', 13:29:35 INFO - 'log_to_console': True, 13:29:35 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe', 13:29:35 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe', 13:29:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest', 13:29:35 INFO - 'opt_config_files': (), 13:29:35 INFO - 'pip_index': False, 13:29:35 INFO - 'sps_profile': False, 13:29:35 INFO - 'sps_profile_interval': 0, 13:29:35 INFO - 'suite': 'dromaeojs', 13:29:35 INFO - 'system_bits': '32', 13:29:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:29:35 INFO - 'title': 'T-W732-IX-070', 13:29:35 INFO - 'use_talos_json': True, 13:29:35 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'), 13:29:35 INFO - 'virtualenv_path': 'C:\\slave\\test-pgo\\build/venv', 13:29:35 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll', 13:29:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:29:35 INFO - 'work_dir': 'build'} 13:29:35 INFO - ##### 13:29:35 INFO - ##### Running clobber step. 13:29:35 INFO - ##### 13:29:35 INFO - Running pre-action listener: _resource_record_pre_action 13:29:35 INFO - Running main action method: clobber 13:29:35 INFO - rmtree: C:\slave\test-pgo\build 13:29:35 INFO - Using _rmtree_windows ... 13:29:35 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test-pgo\\build',), kwargs: {}, attempt #1 13:32:16 INFO - Running post-action listener: _resource_record_post_action 13:32:16 INFO - ##### 13:32:16 INFO - ##### Running read-buildbot-config step. 13:32:16 INFO - ##### 13:32:16 INFO - Running pre-action listener: _resource_record_pre_action 13:32:16 INFO - Running main action method: read_buildbot_config 13:32:16 INFO - Using buildbot properties: 13:32:16 INFO - { 13:32:16 INFO - "properties": { 13:32:16 INFO - "buildnumber": 62, 13:32:16 INFO - "product": "firefox", 13:32:16 INFO - "script_repo_revision": "production", 13:32:16 INFO - "builddir": "b2g-inbound_win7-ix_test-dromaeojs", 13:32:16 INFO - "repository": "", 13:32:16 INFO - "buildername": "Windows 7 32-bit b2g-inbound pgo talos dromaeojs", 13:32:16 INFO - "buildid": "20151021083202", 13:32:16 INFO - "slavename": "t-w732-ix-070", 13:32:16 INFO - "pgo_build": "True", 13:32:16 INFO - "basedir": "C:\\slave\\test-pgo", 13:32:16 INFO - "project": "", 13:32:16 INFO - "platform": "win7-ix", 13:32:16 INFO - "master": "http://buildbot-master112.bb.releng.scl3.mozilla.com:8201/", 13:32:16 INFO - "slavebuilddir": "test", 13:32:16 INFO - "scheduler": "tests-b2g-inbound-win32-pgo-talos", 13:32:16 INFO - "branch": "b2g-inbound", 13:32:16 INFO - "repo_path": "integration/b2g-inbound", 13:32:16 INFO - "stage_platform": "win32-pgo", 13:32:16 INFO - "builduid": "5a06b08a8e9c46d9adfe2f9a32702413", 13:32:16 INFO - "revision": "a934f66fc9dbe80aeffc1c25fe178d5c63b97c7a" 13:32:16 INFO - }, 13:32:16 INFO - "sourcestamp": { 13:32:16 INFO - "repository": "", 13:32:16 INFO - "hasPatch": false, 13:32:16 INFO - "project": "", 13:32:16 INFO - "branch": "b2g-inbound-win32-pgo-talos", 13:32:16 INFO - "changes": [ 13:32:16 INFO - { 13:32:16 INFO - "category": null, 13:32:16 INFO - "files": [ 13:32:16 INFO - { 13:32:16 INFO - "url": null, 13:32:16 INFO - "name": "https://queue.taskcluster.net/v1/task/3H3nkCKnR_m_MMoChUGYag/artifacts/public/build/firefox-44.0a1.en-US.win32.zip" 13:32:16 INFO - } 13:32:16 INFO - ], 13:32:16 INFO - "repository": "", 13:32:16 INFO - "rev": "a934f66fc9dbe80aeffc1c25fe178d5c63b97c7a", 13:32:16 INFO - "who": "sendchange", 13:32:16 INFO - "when": 1445459182, 13:32:16 INFO - "number": 6555463, 13:32:16 INFO - "comments": "", 13:32:16 INFO - "project": "", 13:32:16 INFO - "at": "Wed 21 Oct 2015 13:26:22", 13:32:16 INFO - "branch": "b2g-inbound-win32-pgo-talos", 13:32:16 INFO - "revlink": "", 13:32:16 INFO - "properties": [ 13:32:16 INFO - [ 13:32:16 INFO - "buildid", 13:32:16 INFO - "20151021083202", 13:32:16 INFO - "Change" 13:32:16 INFO - ], 13:32:16 INFO - [ 13:32:16 INFO - "builduid", 13:32:16 INFO - "5a06b08a8e9c46d9adfe2f9a32702413", 13:32:16 INFO - "Change" 13:32:16 INFO - ], 13:32:16 INFO - [ 13:32:16 INFO - "pgo_build", 13:32:16 INFO - "True", 13:32:16 INFO - "Change" 13:32:16 INFO - ] 13:32:16 INFO - ], 13:32:16 INFO - "revision": "a934f66fc9dbe80aeffc1c25fe178d5c63b97c7a" 13:32:16 INFO - } 13:32:16 INFO - ], 13:32:16 INFO - "revision": "a934f66fc9dbe80aeffc1c25fe178d5c63b97c7a" 13:32:16 INFO - } 13:32:16 INFO - } 13:32:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/3H3nkCKnR_m_MMoChUGYag/artifacts/public/build/firefox-44.0a1.en-US.win32.zip. 13:32:16 INFO - Running post-action listener: _resource_record_post_action 13:32:16 INFO - ##### 13:32:16 INFO - ##### Running download-and-extract step. 13:32:16 INFO - ##### 13:32:16 INFO - Running pre-action listener: _resource_record_pre_action 13:32:16 INFO - Running main action method: download_and_extract 13:32:16 INFO - mkdir: C:\slave\test-pgo\build\tests 13:32:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:16 INFO - https://queue.taskcluster.net/v1/task/3H3nkCKnR_m_MMoChUGYag/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:32:16 INFO - trying https://queue.taskcluster.net/v1/task/3H3nkCKnR_m_MMoChUGYag/artifacts/public/build/test_packages.json 13:32:16 INFO - Downloading https://queue.taskcluster.net/v1/task/3H3nkCKnR_m_MMoChUGYag/artifacts/public/build/test_packages.json to C:\slave\test-pgo\build\test_packages.json 13:32:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/3H3nkCKnR_m_MMoChUGYag/artifacts/public/build/test_packages.json', 'file_name': 'C:\\slave\\test-pgo\\build\\test_packages.json'}, attempt #1 13:32:17 INFO - Downloaded 1221 bytes. 13:32:17 INFO - Reading from file C:\slave\test-pgo\build\test_packages.json 13:32:17 INFO - Using the following test package requirements: 13:32:17 INFO - {u'common': [u'firefox-44.0a1.en-US.win32.common.tests.zip'], 13:32:17 INFO - u'cppunittest': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 13:32:17 INFO - u'firefox-44.0a1.en-US.win32.cppunittest.tests.zip'], 13:32:17 INFO - u'jittest': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 13:32:17 INFO - u'jsshell-win32.zip'], 13:32:17 INFO - u'mochitest': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 13:32:17 INFO - u'firefox-44.0a1.en-US.win32.mochitest.tests.zip'], 13:32:17 INFO - u'mozbase': [u'firefox-44.0a1.en-US.win32.common.tests.zip'], 13:32:17 INFO - u'reftest': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 13:32:17 INFO - u'firefox-44.0a1.en-US.win32.reftest.tests.zip'], 13:32:17 INFO - u'talos': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 13:32:17 INFO - u'firefox-44.0a1.en-US.win32.talos.tests.zip'], 13:32:17 INFO - u'web-platform': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 13:32:17 INFO - u'firefox-44.0a1.en-US.win32.web-platform.tests.zip'], 13:32:17 INFO - u'webapprt': [u'firefox-44.0a1.en-US.win32.common.tests.zip'], 13:32:17 INFO - u'xpcshell': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 13:32:17 INFO - u'firefox-44.0a1.en-US.win32.xpcshell.tests.zip']} 13:32:17 INFO - Downloading packages: [u'firefox-44.0a1.en-US.win32.common.tests.zip'] for test suite category: common 13:32: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')]} 13:32:17 INFO - https://queue.taskcluster.net/v1/task/3H3nkCKnR_m_MMoChUGYag/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip matches https://queue.taskcluster.net 13:32:17 INFO - trying https://queue.taskcluster.net/v1/task/3H3nkCKnR_m_MMoChUGYag/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip 13:32:17 INFO - Downloading https://queue.taskcluster.net/v1/task/3H3nkCKnR_m_MMoChUGYag/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 13:32:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/3H3nkCKnR_m_MMoChUGYag/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 13:32:36 INFO - Downloaded 18002693 bytes. 13:32:36 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 13:32:36 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.common.tests.zip 13:32:36 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win32.common.tests.zip'] with output_timeout 1760 13:33:10 INFO - Return code: 0 13:33:10 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 13:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:33:10 INFO - https://queue.taskcluster.net/v1/task/3H3nkCKnR_m_MMoChUGYag/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip matches https://queue.taskcluster.net 13:33:10 INFO - trying https://queue.taskcluster.net/v1/task/3H3nkCKnR_m_MMoChUGYag/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip 13:33:10 INFO - Downloading https://queue.taskcluster.net/v1/task/3H3nkCKnR_m_MMoChUGYag/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 13:33:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/3H3nkCKnR_m_MMoChUGYag/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 13:33:24 INFO - Downloaded 18002693 bytes. 13:33:24 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 13:33:24 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.common.tests.zip 13:33:24 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win32.common.tests.zip'] with output_timeout 1760 13:33:50 INFO - Return code: 0 13:33:50 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')]} 13:33:50 INFO - https://queue.taskcluster.net/v1/task/3H3nkCKnR_m_MMoChUGYag/artifacts/public/build/firefox-44.0a1.en-US.win32.talos.tests.zip matches https://queue.taskcluster.net 13:33:50 INFO - trying https://queue.taskcluster.net/v1/task/3H3nkCKnR_m_MMoChUGYag/artifacts/public/build/firefox-44.0a1.en-US.win32.talos.tests.zip 13:33:50 INFO - Downloading https://queue.taskcluster.net/v1/task/3H3nkCKnR_m_MMoChUGYag/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 13:33:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/3H3nkCKnR_m_MMoChUGYag/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 13:33:52 INFO - Downloaded 11128541 bytes. 13:33:52 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 13:33:52 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.talos.tests.zip 13:33:52 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win32.talos.tests.zip'] with output_timeout 1760 13:33:55 INFO - Return code: 0 13:33:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:33:55 INFO - https://queue.taskcluster.net/v1/task/3H3nkCKnR_m_MMoChUGYag/artifacts/public/build/firefox-44.0a1.en-US.win32.zip matches https://queue.taskcluster.net 13:33:55 INFO - trying https://queue.taskcluster.net/v1/task/3H3nkCKnR_m_MMoChUGYag/artifacts/public/build/firefox-44.0a1.en-US.win32.zip 13:33:55 INFO - Downloading https://queue.taskcluster.net/v1/task/3H3nkCKnR_m_MMoChUGYag/artifacts/public/build/firefox-44.0a1.en-US.win32.zip to C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.zip 13:33:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/3H3nkCKnR_m_MMoChUGYag/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 13:34:03 INFO - Downloaded 55018773 bytes. 13:34:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/3H3nkCKnR_m_MMoChUGYag/artifacts/public/build/firefox-44.0a1.en-US.win32.zip 13:34:03 INFO - mkdir: C:\slave\test-pgo\properties 13:34:03 INFO - Writing buildbot properties ['build_url'] to C:\slave\test-pgo\properties\build_url 13:34:03 INFO - Writing to file C:\slave\test-pgo\properties\build_url 13:34:03 INFO - Contents: 13:34:03 INFO - build_url:https://queue.taskcluster.net/v1/task/3H3nkCKnR_m_MMoChUGYag/artifacts/public/build/firefox-44.0a1.en-US.win32.zip 13:34:03 INFO - Running post-action listener: _resource_record_post_action 13:34:03 INFO - Running post-action listener: set_extra_try_arguments 13:34:03 INFO - ##### 13:34:03 INFO - ##### Running populate-webroot step. 13:34:03 INFO - ##### 13:34:03 INFO - Running pre-action listener: _resource_record_pre_action 13:34:03 INFO - Running main action method: populate_webroot 13:34:03 INFO - Guessing talos json url... 13:34:03 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')]} 13:34:03 INFO - https://queue.taskcluster.net/v1/task/3H3nkCKnR_m_MMoChUGYag/artifacts/public/build/firefox-44.0a1.en-US.win32.txt matches https://queue.taskcluster.net 13:34:03 INFO - trying https://queue.taskcluster.net/v1/task/3H3nkCKnR_m_MMoChUGYag/artifacts/public/build/firefox-44.0a1.en-US.win32.txt 13:34:03 INFO - Downloading https://queue.taskcluster.net/v1/task/3H3nkCKnR_m_MMoChUGYag/artifacts/public/build/firefox-44.0a1.en-US.win32.txt to C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.txt 13:34:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/3H3nkCKnR_m_MMoChUGYag/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 13:34:03 INFO - Downloaded 107 bytes. 13:34:03 INFO - Reading from file C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.txt 13:34:03 INFO - Contents: 13:34:03 INFO - 20151021083202 13:34:03 INFO - https://hg.mozilla.org/integration/b2g-inbound/rev/a934f66fc9dbe80aeffc1c25fe178d5c63b97c7a 13:34:03 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')]} 13:34:03 INFO - trying https://hg.mozilla.org/integration/b2g-inbound/raw-file/a934f66fc9/testing/talos/talos.json 13:34:03 INFO - Downloading https://hg.mozilla.org/integration/b2g-inbound/raw-file/a934f66fc9/testing/talos/talos.json to C:\slave\test-pgo\build\talos.json 13:34:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/b2g-inbound/raw-file/a934f66fc9/testing/talos/talos.json', 'file_name': 'C:\\slave\\test-pgo\\build\\talos.json'}, attempt #1 13:34:04 INFO - Downloaded 4264 bytes. 13:34:04 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']}, 13:34:04 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']}, 13:34:04 INFO - u'remote-trobocheck2': {u'talos_options': [u'--fennecIDs', 13:34:04 INFO - u'../fennec_ids.txt'], 13:34:04 INFO - u'tests': [u'tcheck2']}, 13:34:04 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome', 13:34:04 INFO - u'--tppagecycles', 13:34:04 INFO - u'7'], 13:34:04 INFO - u'tests': [u'tsvgm']}}, 13:34:04 INFO - u'suites': {u'chromez': {u'tests': [u'tresize', u'tcanvasmark']}, 13:34:04 INFO - u'chromez-e10s': {u'talos_options': [u'--e10s'], 13:34:04 INFO - u'tests': [u'tresize', u'tcanvasmark']}, 13:34:04 INFO - u'dromaeojs': {u'tests': [u'dromaeo_css', u'kraken', u'v8_7']}, 13:34:04 INFO - u'dromaeojs-e10s': {u'talos_options': [u'--e10s'], 13:34:04 INFO - u'tests': [u'dromaeo_css', 13:34:04 INFO - u'kraken', 13:34:04 INFO - u'v8_7']}, 13:34:04 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:34:04 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 13:34:04 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:34:04 INFO - u'talos_options': [u'--e10s'], 13:34:04 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 13:34:04 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:34:04 INFO - u'tests': [u'damp', u'tps']}, 13:34:04 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:34:04 INFO - u'talos_options': [u'--e10s'], 13:34:04 INFO - u'tests': [u'damp', u'tps']}, 13:34:04 INFO - u'g3': {u'tests': [u'dromaeo_dom']}, 13:34:04 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']}, 13:34:04 INFO - u'other': {u'tests': [u'a11yr', 13:34:04 INFO - u'ts_paint', 13:34:04 INFO - u'tpaint', 13:34:04 INFO - u'sessionrestore', 13:34:04 INFO - u'sessionrestore_no_auto_restore']}, 13:34:04 INFO - u'other-e10s': {u'talos_options': [u'--e10s'], 13:34:04 INFO - u'tests': [u'a11yr', 13:34:04 INFO - u'ts_paint', 13:34:04 INFO - u'tpaint', 13:34:04 INFO - u'sessionrestore', 13:34:04 INFO - u'sessionrestore_no_auto_restore']}, 13:34:04 INFO - u'other-e10s_l64': {u'talos_options': [u'--e10s'], 13:34:04 INFO - u'tests': [u'a11yr', 13:34:04 INFO - u'ts_paint', 13:34:04 INFO - u'tpaint', 13:34:04 INFO - u'sessionrestore', 13:34:04 INFO - u'sessionrestore_no_auto_restore']}, 13:34:04 INFO - u'other-e10s_nol64': {u'talos_options': [u'--e10s'], 13:34:04 INFO - u'tests': [u'a11yr', 13:34:04 INFO - u'ts_paint', 13:34:04 INFO - u'tpaint', 13:34:04 INFO - u'sessionrestore', 13:34:04 INFO - u'sessionrestore_no_auto_restore']}, 13:34:04 INFO - u'other_l64': {u'tests': [u'a11yr', 13:34:04 INFO - u'ts_paint', 13:34:04 INFO - u'tpaint', 13:34:04 INFO - u'sessionrestore', 13:34:04 INFO - u'sessionrestore_no_auto_restore']}, 13:34:04 INFO - u'other_nol64': {u'tests': [u'a11yr', 13:34:04 INFO - u'ts_paint', 13:34:04 INFO - u'tpaint', 13:34:04 INFO - u'sessionrestore', 13:34:04 INFO - u'sessionrestore_no_auto_restore']}, 13:34:04 INFO - u'svgr': {u'tests': [u'tsvgx', 13:34:04 INFO - u'tsvgr_opacity', 13:34:04 INFO - u'tart', 13:34:04 INFO - u'tscrollx', 13:34:04 INFO - u'cart']}, 13:34:04 INFO - u'svgr-e10s': {u'talos_options': [u'--e10s'], 13:34:04 INFO - u'tests': [u'tsvgx', 13:34:04 INFO - u'tsvgr_opacity', 13:34:04 INFO - u'tart', 13:34:04 INFO - u'tscrollx', 13:34:04 INFO - u'cart']}, 13:34:04 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:34:04 INFO - u'tests': [u'tp5o']}, 13:34:04 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:34:04 INFO - u'talos_options': [u'--e10s'], 13:34:04 INFO - u'tests': [u'tp5o']}, 13:34:04 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:34:04 INFO - u'talos_options': [u'--xperf_path', 13:34:04 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:34:04 INFO - u'tests': [u'tp5n']}, 13:34:04 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:34:04 INFO - u'talos_options': [u'--e10s', 13:34:04 INFO - u'--xperf_path', 13:34:04 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 13:34:04 INFO - u'C:/slave/talos-data/talos/xperf.config'], 13:34:04 INFO - u'tests': [u'tp5n']}}, 13:34:04 INFO - u'talos.zip': {u'path': u'', 13:34:04 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:34:04 INFO - Running post-action listener: _resource_record_post_action 13:34:04 INFO - ##### 13:34:04 INFO - ##### Running create-virtualenv step. 13:34:04 INFO - ##### 13:34:04 INFO - Running pre-action listener: _resource_record_pre_action 13:34:04 INFO - Running main action method: create_virtualenv 13:34:04 INFO - Creating virtualenv C:\slave\test-pgo\build/venv 13:34:04 INFO - mkdir: C:\slave\test-pgo\build\venv\Scripts 13:34:04 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test-pgo\build\venv\Scripts\python27.dll 13:34:04 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'! 13:34:04 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 13:34:04 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 13:34:06 INFO - New python executable in C:\slave\test-pgo\build/venv\Scripts\python.exe 13:34:09 INFO - Installing distribute......................................................................................................................................................................................done. 13:34:11 INFO - Return code: 0 13:34:11 INFO - Installing pip>=1.5 into virtualenv C:\slave\test-pgo\build/venv 13:34: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')]} 13:34:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:34: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')]} 13:34:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:34: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 0x01938B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018F8EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x013DE8C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012F8B48>, '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 0x0131A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x019B9660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-070', 'USERDOMAIN': 'T-W732-IX-070', '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-070', '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 13:34: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 13:34: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 13:34:11 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 13:34:11 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 13:34:11 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 13:34:11 INFO - 'COMPUTERNAME': 'T-W732-IX-070', 13:34:11 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 13:34:11 INFO - 'CYGWINBASE': 'C:\\cygwin', 13:34:11 INFO - 'DCLOCATION': 'SCL3', 13:34:11 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 13:34:11 INFO - 'FP_NO_HOST_CHECK': 'NO', 13:34:11 INFO - 'HOMEDRIVE': 'C:', 13:34:11 INFO - 'HOMEPATH': '\\Users\\cltbld', 13:34:11 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 13:34:11 INFO - 'KTS_VERSION': '1.19c', 13:34:11 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 13:34:11 INFO - 'LOGONSERVER': '\\\\T-W732-IX-070', 13:34:11 INFO - 'MONDIR': 'C:\\Monitor_config\\', 13:34:11 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 13:34:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:11 INFO - 'MOZ_NO_REMOTE': '1', 13:34:11 INFO - 'NO_EM_RESTART': '1', 13:34:11 INFO - 'NUMBER_OF_PROCESSORS': '8', 13:34:11 INFO - 'OS': 'Windows_NT', 13:34:11 INFO - 'OURDRIVE': 'C:', 13:34: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;', 13:34:11 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 13:34:11 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 13:34:11 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 13:34:11 INFO - 'PROCESSOR_LEVEL': '6', 13:34:11 INFO - 'PROCESSOR_REVISION': '1e05', 13:34:11 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 13:34:11 INFO - 'PROGRAMFILES': 'C:\\Program Files', 13:34:11 INFO - 'PROMPT': '$P$G', 13:34:11 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 13:34:11 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 13:34:11 INFO - 'PUBLIC': 'C:\\Users\\Public', 13:34:11 INFO - 'PWD': 'C:\\slave\\test-pgo', 13:34:11 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 13:34:11 INFO - 'SLAVEDIR': 'C:\\slave\\', 13:34:11 INFO - 'SYSTEMDRIVE': 'C:', 13:34:11 INFO - 'SYSTEMROOT': 'C:\\windows', 13:34:11 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 13:34:11 INFO - 'TEST1': 'testie', 13:34:11 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 13:34:11 INFO - 'USERDOMAIN': 'T-W732-IX-070', 13:34:11 INFO - 'USERNAME': 'cltbld', 13:34:11 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 13:34:11 INFO - 'WINDIR': 'C:\\windows', 13:34:11 INFO - 'WINDOWS_TRACING_FLAGS': '3', 13:34:11 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 13:34:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 13:34:12 INFO - Ignoring indexes: http://pypi.python.org/simple/ 13:34:12 INFO - Downloading/unpacking pip>=1.5 13:34:12 INFO - Creating supposed download cache at C:\slave\test-pgo\build/venv\cache 13:34:16 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 13:34:16 INFO - Running setup.py egg_info for package pip 13:34:16 INFO - warning: no files found matching 'pip\cacert.pem' 13:34:16 INFO - warning: no files found matching '*.html' under directory 'docs' 13:34:16 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 13:34:16 INFO - no previously-included directories found matching 'docs\_build\_sources' 13:34:16 INFO - Installing collected packages: pip 13:34:16 INFO - Found existing installation: pip 0.8.2 13:34:16 INFO - Uninstalling pip: 13:34:16 INFO - Successfully uninstalled pip 13:34:16 INFO - Running setup.py install for pip 13:34:16 INFO - warning: no files found matching 'pip\cacert.pem' 13:34:16 INFO - warning: no files found matching '*.html' under directory 'docs' 13:34:16 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 13:34:16 INFO - no previously-included directories found matching 'docs\_build\_sources' 13:34:16 INFO - Installing pip-script.py script to C:\slave\test-pgo\build\venv\Scripts 13:34:16 INFO - Installing pip.exe script to C:\slave\test-pgo\build\venv\Scripts 13:34:16 INFO - Installing pip2.7-script.py script to C:\slave\test-pgo\build\venv\Scripts 13:34:16 INFO - Installing pip2.7.exe script to C:\slave\test-pgo\build\venv\Scripts 13:34:16 INFO - Installing pip2-script.py script to C:\slave\test-pgo\build\venv\Scripts 13:34:16 INFO - Installing pip2.exe script to C:\slave\test-pgo\build\venv\Scripts 13:34:16 INFO - Successfully installed pip 13:34:16 INFO - Cleaning up... 13:34:16 INFO - Return code: 0 13:34:16 INFO - Installing psutil>=0.7.1 into virtualenv C:\slave\test-pgo\build/venv 13:34:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:34:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:34:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:34:16 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 0x01938B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018F8EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x013DE8C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012F8B48>, '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 0x0131A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x019B9660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-070', 'USERDOMAIN': 'T-W732-IX-070', '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-070', '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 13:34:16 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 13:34:16 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 13:34:16 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 13:34:16 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 13:34:16 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 13:34:16 INFO - 'COMPUTERNAME': 'T-W732-IX-070', 13:34:16 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 13:34:16 INFO - 'CYGWINBASE': 'C:\\cygwin', 13:34:16 INFO - 'DCLOCATION': 'SCL3', 13:34:16 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 13:34:16 INFO - 'FP_NO_HOST_CHECK': 'NO', 13:34:16 INFO - 'HOMEDRIVE': 'C:', 13:34:16 INFO - 'HOMEPATH': '\\Users\\cltbld', 13:34:16 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 13:34:16 INFO - 'KTS_VERSION': '1.19c', 13:34:16 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 13:34:16 INFO - 'LOGONSERVER': '\\\\T-W732-IX-070', 13:34:16 INFO - 'MONDIR': 'C:\\Monitor_config\\', 13:34:16 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 13:34:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:16 INFO - 'MOZ_NO_REMOTE': '1', 13:34:16 INFO - 'NO_EM_RESTART': '1', 13:34:16 INFO - 'NUMBER_OF_PROCESSORS': '8', 13:34:16 INFO - 'OS': 'Windows_NT', 13:34:16 INFO - 'OURDRIVE': 'C:', 13:34:16 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;', 13:34:16 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 13:34:16 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 13:34:16 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 13:34:16 INFO - 'PROCESSOR_LEVEL': '6', 13:34:16 INFO - 'PROCESSOR_REVISION': '1e05', 13:34:16 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 13:34:16 INFO - 'PROGRAMFILES': 'C:\\Program Files', 13:34:16 INFO - 'PROMPT': '$P$G', 13:34:16 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 13:34:16 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 13:34:16 INFO - 'PUBLIC': 'C:\\Users\\Public', 13:34:16 INFO - 'PWD': 'C:\\slave\\test-pgo', 13:34:16 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 13:34:16 INFO - 'SLAVEDIR': 'C:\\slave\\', 13:34:16 INFO - 'SYSTEMDRIVE': 'C:', 13:34:16 INFO - 'SYSTEMROOT': 'C:\\windows', 13:34:16 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 13:34:16 INFO - 'TEST1': 'testie', 13:34:16 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 13:34:16 INFO - 'USERDOMAIN': 'T-W732-IX-070', 13:34:16 INFO - 'USERNAME': 'cltbld', 13:34:16 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 13:34:16 INFO - 'WINDIR': 'C:\\windows', 13:34:16 INFO - 'WINDOWS_TRACING_FLAGS': '3', 13:34:16 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 13:34:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 13:34:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:34:18 INFO - Downloading/unpacking psutil>=0.7.1 13:34:18 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 13:34:18 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 13:34:18 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 13:34:19 INFO - Installing collected packages: psutil 13:34:19 INFO - Successfully installed psutil 13:34:19 INFO - Cleaning up... 13:34:19 INFO - Return code: 0 13:34:19 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv C:\slave\test-pgo\build/venv 13:34:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:34:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:34:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:34:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:34:19 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x01938B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018F8EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x013DE8C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012F8B48>, '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 0x0131A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x019B9660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-070', 'USERDOMAIN': 'T-W732-IX-070', '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-070', '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 13:34:19 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in C:\slave\test-pgo\build 13:34:19 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --download-cache C:\slave\test-pgo\build/venv\cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 13:34:19 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 13:34:19 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 13:34:19 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 13:34:19 INFO - 'COMPUTERNAME': 'T-W732-IX-070', 13:34:19 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 13:34:19 INFO - 'CYGWINBASE': 'C:\\cygwin', 13:34:19 INFO - 'DCLOCATION': 'SCL3', 13:34:19 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 13:34:19 INFO - 'FP_NO_HOST_CHECK': 'NO', 13:34:19 INFO - 'HOMEDRIVE': 'C:', 13:34:19 INFO - 'HOMEPATH': '\\Users\\cltbld', 13:34:19 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 13:34:19 INFO - 'KTS_VERSION': '1.19c', 13:34:19 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 13:34:19 INFO - 'LOGONSERVER': '\\\\T-W732-IX-070', 13:34:19 INFO - 'MONDIR': 'C:\\Monitor_config\\', 13:34:19 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 13:34:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:19 INFO - 'MOZ_NO_REMOTE': '1', 13:34:19 INFO - 'NO_EM_RESTART': '1', 13:34:19 INFO - 'NUMBER_OF_PROCESSORS': '8', 13:34:19 INFO - 'OS': 'Windows_NT', 13:34:19 INFO - 'OURDRIVE': 'C:', 13:34:19 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;', 13:34:19 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 13:34:19 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 13:34:19 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 13:34:19 INFO - 'PROCESSOR_LEVEL': '6', 13:34:19 INFO - 'PROCESSOR_REVISION': '1e05', 13:34:19 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 13:34:19 INFO - 'PROGRAMFILES': 'C:\\Program Files', 13:34:19 INFO - 'PROMPT': '$P$G', 13:34:19 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 13:34:19 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 13:34:19 INFO - 'PUBLIC': 'C:\\Users\\Public', 13:34:19 INFO - 'PWD': 'C:\\slave\\test-pgo', 13:34:19 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 13:34:19 INFO - 'SLAVEDIR': 'C:\\slave\\', 13:34:19 INFO - 'SYSTEMDRIVE': 'C:', 13:34:19 INFO - 'SYSTEMROOT': 'C:\\windows', 13:34:19 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 13:34:19 INFO - 'TEST1': 'testie', 13:34:19 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 13:34:19 INFO - 'USERDOMAIN': 'T-W732-IX-070', 13:34:19 INFO - 'USERNAME': 'cltbld', 13:34:19 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 13:34:19 INFO - 'WINDIR': 'C:\\windows', 13:34:19 INFO - 'WINDOWS_TRACING_FLAGS': '3', 13:34:19 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 13:34:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 13:34:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:34:19 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:34: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 13:34: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 13:34:20 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:34:20 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 13:34:20 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor 13:34:20 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) 13:34:20 INFO - Installing collected packages: mozsystemmonitor 13:34:20 INFO - Running setup.py install for mozsystemmonitor 13:34:20 INFO - Successfully installed mozsystemmonitor 13:34:20 INFO - Cleaning up... 13:34:20 INFO - Return code: 0 13:34:20 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test-pgo\build/venv 13:34: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')]} 13:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:34: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')]} 13:34:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:34: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', '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 0x01938B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018F8EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x013DE8C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012F8B48>, '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 0x0131A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x019B9660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-070', 'USERDOMAIN': 'T-W732-IX-070', '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-070', '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 13:34:21 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 13:34:21 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 13:34:21 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 13:34:21 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 13:34:21 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 13:34:21 INFO - 'COMPUTERNAME': 'T-W732-IX-070', 13:34:21 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 13:34:21 INFO - 'CYGWINBASE': 'C:\\cygwin', 13:34:21 INFO - 'DCLOCATION': 'SCL3', 13:34:21 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 13:34:21 INFO - 'FP_NO_HOST_CHECK': 'NO', 13:34:21 INFO - 'HOMEDRIVE': 'C:', 13:34:21 INFO - 'HOMEPATH': '\\Users\\cltbld', 13:34:21 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 13:34:21 INFO - 'KTS_VERSION': '1.19c', 13:34:21 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 13:34:21 INFO - 'LOGONSERVER': '\\\\T-W732-IX-070', 13:34:21 INFO - 'MONDIR': 'C:\\Monitor_config\\', 13:34:21 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 13:34:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:21 INFO - 'MOZ_NO_REMOTE': '1', 13:34:21 INFO - 'NO_EM_RESTART': '1', 13:34:21 INFO - 'NUMBER_OF_PROCESSORS': '8', 13:34:21 INFO - 'OS': 'Windows_NT', 13:34:21 INFO - 'OURDRIVE': 'C:', 13:34:21 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;', 13:34:21 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 13:34:21 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 13:34:21 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 13:34:21 INFO - 'PROCESSOR_LEVEL': '6', 13:34:21 INFO - 'PROCESSOR_REVISION': '1e05', 13:34:21 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 13:34:21 INFO - 'PROGRAMFILES': 'C:\\Program Files', 13:34:21 INFO - 'PROMPT': '$P$G', 13:34:21 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 13:34:21 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 13:34:21 INFO - 'PUBLIC': 'C:\\Users\\Public', 13:34:21 INFO - 'PWD': 'C:\\slave\\test-pgo', 13:34:21 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 13:34:21 INFO - 'SLAVEDIR': 'C:\\slave\\', 13:34:21 INFO - 'SYSTEMDRIVE': 'C:', 13:34:21 INFO - 'SYSTEMROOT': 'C:\\windows', 13:34:21 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 13:34:21 INFO - 'TEST1': 'testie', 13:34:21 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 13:34:21 INFO - 'USERDOMAIN': 'T-W732-IX-070', 13:34:21 INFO - 'USERNAME': 'cltbld', 13:34:21 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 13:34:21 INFO - 'WINDIR': 'C:\\windows', 13:34:21 INFO - 'WINDOWS_TRACING_FLAGS': '3', 13:34:21 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 13:34:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 13:34:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:34:21 INFO - Downloading/unpacking blobuploader==1.2.4 13:34:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:34:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:34:22 INFO - Downloading blobuploader-1.2.4.tar.gz 13:34:22 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 13:34:22 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader 13:34:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:34: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 13:34: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 13:34:22 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 13:34:22 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\requests\setup.py) egg_info for package requests 13:34:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:34: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 13:34: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 13:34:22 INFO - Downloading docopt-0.6.1.tar.gz 13:34:22 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 13:34:22 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\docopt\setup.py) egg_info for package docopt 13:34:23 INFO - Installing collected packages: blobuploader, requests, docopt 13:34:23 INFO - Running setup.py install for blobuploader 13:34:23 INFO - Running setup.py install for requests 13:34:23 INFO - Running setup.py install for docopt 13:34:24 INFO - Successfully installed blobuploader requests docopt 13:34:24 INFO - Cleaning up... 13:34:25 INFO - Return code: 0 13:34:25 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv 13:34:25 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')]} 13:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:34:25 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')]} 13:34:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:34:25 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 0x01938B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018F8EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x013DE8C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012F8B48>, '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 0x0131A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x019B9660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-070', 'USERDOMAIN': 'T-W732-IX-070', '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-070', '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 13:34:25 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 13:34:25 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 13:34:25 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 13:34:25 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 13:34:25 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 13:34:25 INFO - 'COMPUTERNAME': 'T-W732-IX-070', 13:34:25 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 13:34:25 INFO - 'CYGWINBASE': 'C:\\cygwin', 13:34:25 INFO - 'DCLOCATION': 'SCL3', 13:34:25 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 13:34:25 INFO - 'FP_NO_HOST_CHECK': 'NO', 13:34:25 INFO - 'HOMEDRIVE': 'C:', 13:34:25 INFO - 'HOMEPATH': '\\Users\\cltbld', 13:34:25 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 13:34:25 INFO - 'KTS_VERSION': '1.19c', 13:34:25 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 13:34:25 INFO - 'LOGONSERVER': '\\\\T-W732-IX-070', 13:34:25 INFO - 'MONDIR': 'C:\\Monitor_config\\', 13:34:25 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 13:34:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:25 INFO - 'MOZ_NO_REMOTE': '1', 13:34:25 INFO - 'NO_EM_RESTART': '1', 13:34:25 INFO - 'NUMBER_OF_PROCESSORS': '8', 13:34:25 INFO - 'OS': 'Windows_NT', 13:34:25 INFO - 'OURDRIVE': 'C:', 13:34:25 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;', 13:34:25 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 13:34:25 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 13:34:25 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 13:34:25 INFO - 'PROCESSOR_LEVEL': '6', 13:34:25 INFO - 'PROCESSOR_REVISION': '1e05', 13:34:25 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 13:34:25 INFO - 'PROGRAMFILES': 'C:\\Program Files', 13:34:25 INFO - 'PROMPT': '$P$G', 13:34:25 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 13:34:25 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 13:34:25 INFO - 'PUBLIC': 'C:\\Users\\Public', 13:34:25 INFO - 'PWD': 'C:\\slave\\test-pgo', 13:34:25 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 13:34:25 INFO - 'SLAVEDIR': 'C:\\slave\\', 13:34:25 INFO - 'SYSTEMDRIVE': 'C:', 13:34:25 INFO - 'SYSTEMROOT': 'C:\\windows', 13:34:25 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 13:34:25 INFO - 'TEST1': 'testie', 13:34:25 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 13:34:25 INFO - 'USERDOMAIN': 'T-W732-IX-070', 13:34:25 INFO - 'USERNAME': 'cltbld', 13:34:25 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 13:34:25 INFO - 'WINDIR': 'C:\\windows', 13:34:25 INFO - 'WINDOWS_TRACING_FLAGS': '3', 13:34:25 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 13:34:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 13:34:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:34:25 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\manifestparser 13:34:25 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-0jqlpd-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/manifestparser 13:34:26 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozcrash 13:34:26 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-w319md-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozcrash 13:34:26 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdebug 13:34:26 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-xfhmyk-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdebug 13:34:26 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdevice 13:34:26 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-_syxlm-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdevice 13:34:26 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozfile 13:34:26 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-nxfxhv-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozfile 13:34:26 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozhttpd 13:34:26 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-zmms5p-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozhttpd 13:34:26 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinfo 13:34:26 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-nvcguc-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinfo 13:34:27 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinstall 13:34:27 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-98bgeg-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinstall 13:34:27 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozleak 13:34:27 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-bpi7zb-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozleak 13:34:27 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozlog 13:34:27 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-hqwk1b-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozlog 13:34:27 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moznetwork 13:34:27 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-g3cq_v-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moznetwork 13:34:27 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprocess 13:34:27 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-qpdu7p-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprocess 13:34:27 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprofile 13:34:27 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-1pqpxt-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprofile 13:34:27 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozrunner 13:34:27 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-zw_4mz-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozrunner 13:34:28 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozscreenshot 13:34:28 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-dyvezo-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:34:28 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moztest 13:34:28 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-rph6xe-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moztest 13:34:28 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozversion 13:34:28 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-xnxhej-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozversion 13:34:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:34:28 INFO - Running setup.py install for manifestparser 13:34:28 INFO - Installing manifestparser-script.py script to C:\slave\test-pgo\build\venv\Scripts 13:34:28 INFO - Installing manifestparser.exe script to C:\slave\test-pgo\build\venv\Scripts 13:34:29 INFO - Running setup.py install for mozcrash 13:34:29 INFO - Running setup.py install for mozdebug 13:34:29 INFO - Running setup.py install for mozdevice 13:34:30 INFO - Installing sutini-script.py script to C:\slave\test-pgo\build\venv\Scripts 13:34:30 INFO - Installing sutini.exe script to C:\slave\test-pgo\build\venv\Scripts 13:34:30 INFO - Installing dm-script.py script to C:\slave\test-pgo\build\venv\Scripts 13:34:30 INFO - Installing dm.exe script to C:\slave\test-pgo\build\venv\Scripts 13:34:31 INFO - Running setup.py install for mozfile 13:34:31 INFO - Running setup.py install for mozhttpd 13:34:31 INFO - Installing mozhttpd-script.py script to C:\slave\test-pgo\build\venv\Scripts 13:34:31 INFO - Installing mozhttpd.exe script to C:\slave\test-pgo\build\venv\Scripts 13:34:31 INFO - Running setup.py install for mozinfo 13:34:32 INFO - Installing mozinfo-script.py script to C:\slave\test-pgo\build\venv\Scripts 13:34:32 INFO - Installing mozinfo.exe script to C:\slave\test-pgo\build\venv\Scripts 13:34:32 INFO - Running setup.py install for mozInstall 13:34:32 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test-pgo\build\venv\Scripts 13:34:32 INFO - Installing moz_remove_from_system.exe script to C:\slave\test-pgo\build\venv\Scripts 13:34:32 INFO - Installing mozuninstall-script.py script to C:\slave\test-pgo\build\venv\Scripts 13:34:32 INFO - Installing mozuninstall.exe script to C:\slave\test-pgo\build\venv\Scripts 13:34:32 INFO - Installing mozinstall-script.py script to C:\slave\test-pgo\build\venv\Scripts 13:34:32 INFO - Installing mozinstall.exe script to C:\slave\test-pgo\build\venv\Scripts 13:34:32 INFO - Installing moz_add_to_system-script.py script to C:\slave\test-pgo\build\venv\Scripts 13:34:32 INFO - Installing moz_add_to_system.exe script to C:\slave\test-pgo\build\venv\Scripts 13:34:32 INFO - Running setup.py install for mozleak 13:34:32 INFO - Running setup.py install for mozlog 13:34:33 INFO - Installing structlog-script.py script to C:\slave\test-pgo\build\venv\Scripts 13:34:33 INFO - Installing structlog.exe script to C:\slave\test-pgo\build\venv\Scripts 13:34:33 INFO - Running setup.py install for moznetwork 13:34:34 INFO - Installing moznetwork-script.py script to C:\slave\test-pgo\build\venv\Scripts 13:34:34 INFO - Installing moznetwork.exe script to C:\slave\test-pgo\build\venv\Scripts 13:34:34 INFO - Running setup.py install for mozprocess 13:34:34 INFO - Running setup.py install for mozprofile 13:34:34 INFO - Installing mozprofile-script.py script to C:\slave\test-pgo\build\venv\Scripts 13:34:34 INFO - Installing mozprofile.exe script to C:\slave\test-pgo\build\venv\Scripts 13:34:34 INFO - Installing diff-profiles-script.py script to C:\slave\test-pgo\build\venv\Scripts 13:34:34 INFO - Installing diff-profiles.exe script to C:\slave\test-pgo\build\venv\Scripts 13:34:34 INFO - Installing view-profile-script.py script to C:\slave\test-pgo\build\venv\Scripts 13:34:34 INFO - Installing view-profile.exe script to C:\slave\test-pgo\build\venv\Scripts 13:34:35 INFO - Running setup.py install for mozrunner 13:34:35 INFO - Installing mozrunner-script.py script to C:\slave\test-pgo\build\venv\Scripts 13:34:35 INFO - Installing mozrunner.exe script to C:\slave\test-pgo\build\venv\Scripts 13:34:36 INFO - Running setup.py install for mozscreenshot 13:34:36 INFO - Running setup.py install for moztest 13:34:36 INFO - Running setup.py install for mozversion 13:34:36 INFO - Installing mozversion-script.py script to C:\slave\test-pgo\build\venv\Scripts 13:34:36 INFO - Installing mozversion.exe script to C:\slave\test-pgo\build\venv\Scripts 13:34:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:34:37 INFO - Cleaning up... 13:34:37 INFO - Return code: 0 13:34:37 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv 13:34:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:34:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:34:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:34:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:34:37 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 0x01938B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018F8EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x013DE8C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012F8B48>, '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 0x0131A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x019B9660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-070', 'USERDOMAIN': 'T-W732-IX-070', '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-070', '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 13:34:37 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 13:34:37 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 13:34:37 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 13:34:37 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 13:34:37 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 13:34:37 INFO - 'COMPUTERNAME': 'T-W732-IX-070', 13:34:37 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 13:34:37 INFO - 'CYGWINBASE': 'C:\\cygwin', 13:34:37 INFO - 'DCLOCATION': 'SCL3', 13:34:37 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 13:34:37 INFO - 'FP_NO_HOST_CHECK': 'NO', 13:34:37 INFO - 'HOMEDRIVE': 'C:', 13:34:37 INFO - 'HOMEPATH': '\\Users\\cltbld', 13:34:37 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 13:34:37 INFO - 'KTS_VERSION': '1.19c', 13:34:37 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 13:34:37 INFO - 'LOGONSERVER': '\\\\T-W732-IX-070', 13:34:37 INFO - 'MONDIR': 'C:\\Monitor_config\\', 13:34:37 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 13:34:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:37 INFO - 'MOZ_NO_REMOTE': '1', 13:34:37 INFO - 'NO_EM_RESTART': '1', 13:34:37 INFO - 'NUMBER_OF_PROCESSORS': '8', 13:34:37 INFO - 'OS': 'Windows_NT', 13:34:37 INFO - 'OURDRIVE': 'C:', 13:34:37 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;', 13:34:37 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 13:34:37 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 13:34:37 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 13:34:37 INFO - 'PROCESSOR_LEVEL': '6', 13:34:37 INFO - 'PROCESSOR_REVISION': '1e05', 13:34:37 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 13:34:37 INFO - 'PROGRAMFILES': 'C:\\Program Files', 13:34:37 INFO - 'PROMPT': '$P$G', 13:34:37 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 13:34:37 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 13:34:37 INFO - 'PUBLIC': 'C:\\Users\\Public', 13:34:37 INFO - 'PWD': 'C:\\slave\\test-pgo', 13:34:37 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 13:34:37 INFO - 'SLAVEDIR': 'C:\\slave\\', 13:34:37 INFO - 'SYSTEMDRIVE': 'C:', 13:34:37 INFO - 'SYSTEMROOT': 'C:\\windows', 13:34:37 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 13:34:37 INFO - 'TEST1': 'testie', 13:34:37 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 13:34:37 INFO - 'USERDOMAIN': 'T-W732-IX-070', 13:34:37 INFO - 'USERNAME': 'cltbld', 13:34:37 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 13:34:37 INFO - 'WINDIR': 'C:\\windows', 13:34:37 INFO - 'WINDOWS_TRACING_FLAGS': '3', 13:34:37 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 13:34:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 13:34:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:34:37 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\manifestparser 13:34:37 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-xlfblg-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/manifestparser 13:34:37 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)) 13:34:37 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozcrash 13:34:37 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-ik4xkh-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozcrash 13:34:37 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)) 13:34:37 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdebug 13:34:37 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-k16krs-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdebug 13:34:37 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)) 13:34:37 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdevice 13:34:38 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-wgkczb-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdevice 13:34:38 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)) 13:34:38 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozfile 13:34:38 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-fdt8lw-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozfile 13:34:38 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)) 13:34:38 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozhttpd 13:34:38 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-0h3hyt-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozhttpd 13:34:38 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)) 13:34:38 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinfo 13:34:38 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-col4ig-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinfo 13:34:38 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)) 13:34:38 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinstall 13:34:38 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-7vybi8-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinstall 13:34:39 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)) 13:34:39 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozleak 13:34:39 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-tpkgd9-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozleak 13:34:39 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)) 13:34:39 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozlog 13:34:39 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-xs7bn8-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozlog 13:34:39 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)) 13:34:39 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moznetwork 13:34:39 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-xhc_da-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moznetwork 13:34:39 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)) 13:34:39 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprocess 13:34:39 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-vnlwpn-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprocess 13:34:39 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)) 13:34:39 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprofile 13:34:39 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-yvzxvm-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprofile 13:34:39 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)) 13:34:39 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozrunner 13:34:39 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-vrhpsk-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozrunner 13:34:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.10 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)) 13:34:39 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozscreenshot 13:34:39 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-w3p5sv-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:34:40 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)) 13:34:40 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moztest 13:34:40 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-j9xkhy-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moztest 13:34:40 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)) 13:34:40 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozversion 13:34:40 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-9dljyy-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozversion 13:34:40 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)) 13:34:40 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)) 13:34:40 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)) 13:34:40 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)) 13:34:40 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)) 13:34:40 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)) 13:34:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 10)) 13:34:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:34:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:34:41 INFO - Downloading blessings-1.5.1.tar.gz 13:34:41 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 13:34:41 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\blessings\setup.py) egg_info for package blessings 13:34:41 INFO - Installing collected packages: blessings 13:34:41 INFO - Running setup.py install for blessings 13:34:41 INFO - Successfully installed blessings 13:34:41 INFO - Cleaning up... 13:34:44 INFO - Return code: 0 13:34:44 INFO - Done creating virtualenv C:\slave\test-pgo\build/venv. 13:34:44 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'freeze'] 13:34:44 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip freeze 13:34:44 INFO - Reading from file tmpfile_stdout 13:34:44 INFO - Using _rmtree_windows ... 13:34:44 INFO - Using _rmtree_windows ... 13:34:44 INFO - Current package versions: 13:34:44 INFO - blessings == 1.5.1 13:34:44 INFO - blobuploader == 1.2.4 13:34:44 INFO - docopt == 0.6.1 13:34:44 INFO - manifestparser == 1.1 13:34:44 INFO - mozInstall == 1.12 13:34:44 INFO - mozcrash == 0.16 13:34:44 INFO - mozdebug == 0.1 13:34:44 INFO - mozdevice == 0.46 13:34:44 INFO - mozfile == 1.2 13:34:44 INFO - mozhttpd == 0.7 13:34:44 INFO - mozinfo == 0.8 13:34:44 INFO - mozleak == 0.1 13:34:44 INFO - mozlog == 3.0 13:34:44 INFO - moznetwork == 0.27 13:34:44 INFO - mozprocess == 0.22 13:34:44 INFO - mozprofile == 0.27 13:34:44 INFO - mozrunner == 6.10 13:34:44 INFO - mozscreenshot == 0.1 13:34:44 INFO - mozsystemmonitor == 0.0 13:34:44 INFO - moztest == 0.7 13:34:44 INFO - mozversion == 1.4 13:34:44 INFO - psutil == 3.1.1 13:34:44 INFO - requests == 1.2.3 13:34:44 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv 13:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:34:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:34:44 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 0x01938B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018F8EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x013DE8C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012F8B48>, '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 0x0131A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x019B9660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build\\tests\\talos', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-070', 'USERDOMAIN': 'T-W732-IX-070', '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-070', '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 13:34:45 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 13:34:45 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 13:34:45 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 13:34:45 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 13:34:45 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 13:34:45 INFO - 'COMPUTERNAME': 'T-W732-IX-070', 13:34:45 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 13:34:45 INFO - 'CYGWINBASE': 'C:\\cygwin', 13:34:45 INFO - 'DCLOCATION': 'SCL3', 13:34:45 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 13:34:45 INFO - 'FP_NO_HOST_CHECK': 'NO', 13:34:45 INFO - 'HOMEDRIVE': 'C:', 13:34:45 INFO - 'HOMEPATH': '\\Users\\cltbld', 13:34:45 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 13:34:45 INFO - 'KTS_VERSION': '1.19c', 13:34:45 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 13:34:45 INFO - 'LOGONSERVER': '\\\\T-W732-IX-070', 13:34:45 INFO - 'MONDIR': 'C:\\Monitor_config\\', 13:34:45 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 13:34:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:45 INFO - 'MOZ_NO_REMOTE': '1', 13:34:45 INFO - 'NO_EM_RESTART': '1', 13:34:45 INFO - 'NUMBER_OF_PROCESSORS': '8', 13:34:45 INFO - 'OS': 'Windows_NT', 13:34:45 INFO - 'OURDRIVE': 'C:', 13:34:45 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 13:34:45 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 13:34:45 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 13:34:45 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 13:34:45 INFO - 'PROCESSOR_LEVEL': '6', 13:34:45 INFO - 'PROCESSOR_REVISION': '1e05', 13:34:45 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 13:34:45 INFO - 'PROGRAMFILES': 'C:\\Program Files', 13:34:45 INFO - 'PROMPT': '$P$G', 13:34:45 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 13:34:45 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 13:34:45 INFO - 'PUBLIC': 'C:\\Users\\Public', 13:34:45 INFO - 'PWD': 'C:\\slave\\test-pgo', 13:34:45 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 13:34:45 INFO - 'SLAVEDIR': 'C:\\slave\\', 13:34:45 INFO - 'SYSTEMDRIVE': 'C:', 13:34:45 INFO - 'SYSTEMROOT': 'C:\\windows', 13:34:45 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 13:34:45 INFO - 'TEST1': 'testie', 13:34:45 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 13:34:45 INFO - 'USERDOMAIN': 'T-W732-IX-070', 13:34:45 INFO - 'USERNAME': 'cltbld', 13:34:45 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 13:34:45 INFO - 'WINDIR': 'C:\\windows', 13:34:45 INFO - 'WINDOWS_TRACING_FLAGS': '3', 13:34:45 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 13:34:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 13:34:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:34:45 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)) 13:34:45 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)) 13:34:45 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)) 13:34:45 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)) 13:34:45 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)) 13:34:45 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)) 13:34:45 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)) 13:34:45 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)) 13:34:45 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)) 13:34:45 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)) 13:34:45 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)) 13:34:45 INFO - Cleaning up... 13:34:45 INFO - Return code: 0 13:34:45 INFO - Running post-action listener: _resource_record_post_action 13:34:45 INFO - Running post-action listener: _start_resource_monitoring 13:34:45 INFO - Starting resource monitoring. 13:34:45 INFO - ##### 13:34:45 INFO - ##### Running install step. 13:34:45 INFO - ##### 13:34:45 INFO - Running pre-action listener: _resource_record_pre_action 13:34:45 INFO - Running main action method: install 13:34:45 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'freeze'] 13:34:45 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip freeze 13:34:45 INFO - Reading from file tmpfile_stdout 13:34:45 INFO - Using _rmtree_windows ... 13:34:45 INFO - Using _rmtree_windows ... 13:34:45 INFO - Detecting whether we're running mozinstall >=1.0... 13:34:45 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build/venv/scripts/python', 'C:\\slave\\test-pgo\\build/venv/scripts/mozinstall-script.py', '-h'] 13:34:45 INFO - Copy/paste: C:\slave\test-pgo\build/venv/scripts/python C:\slave\test-pgo\build/venv/scripts/mozinstall-script.py -h 13:34:46 INFO - Reading from file tmpfile_stdout 13:34:46 INFO - Output received: 13:34:46 INFO - Usage: mozinstall-script.py [options] installer 13:34:46 INFO - Options: 13:34:46 INFO - -h, --help show this help message and exit 13:34:46 INFO - -d DEST, --destination=DEST 13:34:46 INFO - Directory to install application into. [default: 13:34:46 INFO - "C:\slave\test-pgo"] 13:34:46 INFO - --app=APP Application being installed. [default: firefox] 13:34:46 INFO - Using _rmtree_windows ... 13:34:46 INFO - Using _rmtree_windows ... 13:34:46 INFO - mkdir: C:\slave\test-pgo\build\application 13:34:46 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'] 13:34:46 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 13:34:47 INFO - Reading from file tmpfile_stdout 13:34:47 INFO - Output received: 13:34:47 INFO - C:\slave\test-pgo\build\application\firefox\firefox.exe 13:34:47 INFO - Using _rmtree_windows ... 13:34:47 INFO - Using _rmtree_windows ... 13:34:47 INFO - Running post-action listener: _resource_record_post_action 13:34:47 INFO - ##### 13:34:47 INFO - ##### Running run-tests step. 13:34:47 INFO - ##### 13:34:47 INFO - Running pre-action listener: _resource_record_pre_action 13:34:47 INFO - Running main action method: run_tests 13:34:47 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\python', '--version'] 13:34:47 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\python --version 13:34:47 INFO - Python 2.7.3 13:34:47 INFO - Return code: 0 13:34:47 INFO - grabbing minidump binary from tooltool 13:34:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:34:47 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 0x012F8B48>, '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 0x0131A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x019B9660>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'privileged': False}, attempt #1 13:34:47 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 13:34:47 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 13:34:47 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 13:34:49 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test-pgo\build\tmpoiyg22 13:34:49 INFO - INFO - File integrity verified, renaming tmpoiyg22 to win32-minidump_stackwalk.exe 13:34:49 INFO - Return code: 0 13:34:49 INFO - Chmoding C:\slave\test-pgo\build\win32-minidump_stackwalk.exe to 0755 13:34:49 INFO - mkdir: C:\slave\test-pgo\build\blobber_upload_dir 13:34:49 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test-pgo\build\blobber_upload_dir 13:34:49 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test-pgo\build\win32-minidump_stackwalk.exe 13:34:49 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test-pgo\build\blobber_upload_dir 13:34: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', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test-pgo\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/3H3nkCKnR_m_MMoChUGYag/artifacts/public/build/firefox-44.0a1.en-US.win32.crashreporter-symbols.zip', '--title', 'T-W732-IX-070', '--webServer', 'localhost'] in C:\slave\test-pgo\build 13:34: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 B2G-Inbound --suite dromaeojs --executablePath C:\slave\test-pgo\build\application\firefox\firefox --symbolsPath https://queue.taskcluster.net/v1/task/3H3nkCKnR_m_MMoChUGYag/artifacts/public/build/firefox-44.0a1.en-US.win32.crashreporter-symbols.zip --title T-W732-IX-070 --webServer localhost 13:34:49 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 13:34:49 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 13:34:49 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 13:34:49 INFO - 'COMPUTERNAME': 'T-W732-IX-070', 13:34:49 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 13:34:49 INFO - 'CYGWINBASE': 'C:\\cygwin', 13:34:49 INFO - 'DCLOCATION': 'SCL3', 13:34:49 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 13:34:49 INFO - 'FP_NO_HOST_CHECK': 'NO', 13:34:49 INFO - 'HOMEDRIVE': 'C:', 13:34:49 INFO - 'HOMEPATH': '\\Users\\cltbld', 13:34:49 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 13:34:49 INFO - 'KTS_VERSION': '1.19c', 13:34:49 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 13:34:49 INFO - 'LOGONSERVER': '\\\\T-W732-IX-070', 13:34:49 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test-pgo\\build\\blobber_upload_dir', 13:34:49 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test-pgo\\build\\win32-minidump_stackwalk.exe', 13:34:49 INFO - 'MONDIR': 'C:\\Monitor_config\\', 13:34:49 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 13:34:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:49 INFO - 'MOZ_NO_REMOTE': '1', 13:34:49 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test-pgo\\build\\blobber_upload_dir', 13:34:49 INFO - 'NO_EM_RESTART': '1', 13:34:49 INFO - 'NUMBER_OF_PROCESSORS': '8', 13:34:49 INFO - 'OS': 'Windows_NT', 13:34:49 INFO - 'OURDRIVE': 'C:', 13:34: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;', 13:34:49 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 13:34:49 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 13:34:49 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 13:34:49 INFO - 'PROCESSOR_LEVEL': '6', 13:34:49 INFO - 'PROCESSOR_REVISION': '1e05', 13:34:49 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 13:34:49 INFO - 'PROGRAMFILES': 'C:\\Program Files', 13:34:49 INFO - 'PROMPT': '$P$G', 13:34:49 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 13:34:49 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 13:34:49 INFO - 'PUBLIC': 'C:\\Users\\Public', 13:34:49 INFO - 'PWD': 'C:\\slave\\test-pgo', 13:34:49 INFO - 'PYTHONPATH': 'C:\\slave\\test-pgo\\build\\tests\\talos', 13:34:49 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 13:34:49 INFO - 'SLAVEDIR': 'C:\\slave\\', 13:34:49 INFO - 'SYSTEMDRIVE': 'C:', 13:34:49 INFO - 'SYSTEMROOT': 'C:\\windows', 13:34:49 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 13:34:49 INFO - 'TEST1': 'testie', 13:34:49 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 13:34:49 INFO - 'USERDOMAIN': 'T-W732-IX-070', 13:34:49 INFO - 'USERNAME': 'cltbld', 13:34:49 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 13:34:49 INFO - 'WINDIR': 'C:\\windows', 13:34:49 INFO - 'WINDOWS_TRACING_FLAGS': '3', 13:34:49 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 13:34:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 13:34:49 INFO - Calling ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\python', 'C:\\slave\\test-pgo\\build\\tests\\talos\\talos\\run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test-pgo\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/3H3nkCKnR_m_MMoChUGYag/artifacts/public/build/firefox-44.0a1.en-US.win32.crashreporter-symbols.zip', '--title', 'T-W732-IX-070', '--webServer', 'localhost'] with output_timeout 3600 13:34:50 INFO - mozversion INFO | application_buildid: 20151021083202 13:34:50 INFO - mozversion INFO | application_changeset: a934f66fc9dbe80aeffc1c25fe178d5c63b97c7a 13:34:50 INFO - mozversion INFO | application_display_name: Nightly 13:34:50 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:34:50 INFO - mozversion INFO | application_name: Firefox 13:34:50 INFO - mozversion INFO | application_remotingname: firefox 13:34:50 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 13:34:50 INFO - mozversion INFO | application_vendor: Mozilla 13:34:50 INFO - mozversion INFO | application_version: 44.0a1 13:34:50 INFO - mozversion INFO | platform_buildid: 20151021083202 13:34:50 INFO - mozversion INFO | platform_changeset: a934f66fc9dbe80aeffc1c25fe178d5c63b97c7a 13:34:50 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 13:34:50 INFO - mozversion INFO | platform_version: 44.0a1 13:34:50 INFO - 2015-10-21 13:34:50,892 DEBUG : using testdate: 1445459690 13:34:50 INFO - 2015-10-21 13:34:50,892 DEBUG : actual date: 1445459690 13:34:50 INFO - 2015-10-21 13:34:50,924 INFO : starting webserver on 'localhost:49794' 13:34:50 INFO - 2015-10-21 13:34:50,926 INFO : Starting test suite T-W732-IX-070 13:34:50 INFO - 2015-10-21 13:34:50,926 INFO : Starting test dromaeo_css 13:34:50 INFO - 2015-10-21 13:34:50,926 DEBUG : operating with platform_type : w7_ 13:34:50 INFO - 2015-10-21 13:34:50,927 INFO : Initialising browser for dromaeo_css test... 13:34:51 INFO - 2015-10-21 13:34:51,022 DEBUG : command line: C:\slave\test-pgo\build\application\firefox\firefox -profile c:\users\cltbld\appdata\local\temp\tmpf5jmpw\profile http://localhost:49794/getInfo.html 13:35:00 INFO - 2015-10-21 13:35:00,263 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:35:00 INFO - 2015-10-21 13:35:00,263 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:35:00 INFO - 2015-10-21 13:35:00,263 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674 13:35:00 INFO - 2015-10-21 13:35:00,263 DEBUG : BROWSER_OUTPUT: __metrics 13:35:00 INFO - 2015-10-21 13:35:00,345 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:35:01 INFO - 2015-10-21 13:35:01,361 DEBUG : BROWSER_OUTPUT: console.error: 13:35:01 INFO - 2015-10-21 13:35:01,361 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] 13:35:01 INFO - 2015-10-21 13:35:01,361 DEBUG : BROWSER_OUTPUT: Stack: 13:35:01 INFO - 2015-10-21 13:35:01,361 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<._executeStatement@resource://gre/modules/Sqlite.jsm:758:19 13:35:01 INFO - 2015-10-21 13:35:01,361 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached/<@resource://gre/modules/Sqlite.jsm:493:9 13:35:01 INFO - 2015-10-21 13:35:01,361 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached@resource://gre/modules/Sqlite.jsm:491:1 13:35:01 INFO - 2015-10-21 13:35:01,361 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeBeforeShutdown/loggedDb<.executeCached.value<@resource://gre/modules/Sqlite.jsm:368:51 13:35:01 INFO - 2015-10-21 13:35:01,361 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 13:35:01 INFO - 2015-10-21 13:35:01,361 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 13:35:01 INFO - 2015-10-21 13:35:01,361 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 13:35:01 INFO - 2015-10-21 13:35:01,361 DEBUG : BROWSER_OUTPUT: transaction@resource://gre/modules/Bookmarks.jsm:783:15 13:35:01 INFO - 2015-10-21 13:35:01,361 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 13:35:01 INFO - 2015-10-21 13:35:01,361 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 13:35:01 INFO - 2015-10-21 13:35:01,361 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 13:35:01 INFO - 2015-10-21 13:35:01,361 DEBUG : BROWSER_OUTPUT: Task_spawn@resource://gre/modules/Task.jsm:164:12 13:35:01 INFO - 2015-10-21 13:35:01,361 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 13:54:44 INFO - 2015-10-21 13:54:44,009 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 13:54:44 INFO - 2015-10-21 13:54:44,009 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 13:54:44 INFO - 2015-10-21 13:54:44,009 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 13:54:44 INFO - 2015-10-21 13:54:44,009 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 13:54:44 INFO - 2015-10-21 13:54:44,009 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 13:54:44 INFO - 2015-10-21 13:54:44,009 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 13:54:44 INFO - 2015-10-21 13:54:44,009 DEBUG : BROWSER_OUTPUT: 13:54:44 INFO - 2015-10-21 13:54:44,655 INFO : Browser initialized. 13:54:44 INFO - 2015-10-21 13:54:44,655 INFO : Running cycle 1/1 for v8_7 test... 13:54:44 INFO - 2015-10-21 13:54:44,655 DEBUG : command line: C:\slave\test-pgo\build\application\firefox\firefox -profile c:\users\cltbld\appdata\local\temp\tmp9j45do\profile -tp file:\C:\slave\test-pgo\build\tests\talos\talos\tests\v8_7\v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:54:56 INFO - 2015-10-21 13:54:56,091 DEBUG : BROWSER_OUTPUT: RSS: Main: 146898944 13:54:56 INFO - 2015-10-21 13:54:56,091 DEBUG : BROWSER_OUTPUT: 13:55:17 INFO - 2015-10-21 13:55:17,645 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49794/tests/v8_7/run.html (next: http://localhost:49794/tests/v8_7/run.html) 13:55:17 INFO - 2015-10-21 13:55:17,901 DEBUG : BROWSER_OUTPUT: RSS: Main: 472313856 13:55:17 INFO - 2015-10-21 13:55:17,901 DEBUG : BROWSER_OUTPUT: 13:55:17 INFO - 2015-10-21 13:55:17,901 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:55:17 INFO - 2015-10-21 13:55:17,901 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:55:17 INFO - 2015-10-21 13:55:17,901 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:55:17 INFO - 2015-10-21 13:55:17,901 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:55:17 INFO - 2015-10-21 13:55:17,901 DEBUG : BROWSER_OUTPUT: |0;Richards;156.47003598810826 13:55:17 INFO - 2015-10-21 13:55:17,901 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;202.7986209693774 13:55:17 INFO - 2015-10-21 13:55:17,901 DEBUG : BROWSER_OUTPUT: |2;Encrypt;311.2356053532524 13:55:17 INFO - 2015-10-21 13:55:17,901 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5312.169312169312 13:55:17 INFO - 2015-10-21 13:55:17,901 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1410.4372355430182 13:55:17 INFO - 2015-10-21 13:55:17,901 DEBUG : BROWSER_OUTPUT: |5;Earley;637.7551020408164 13:55:17 INFO - 2015-10-21 13:55:17,901 DEBUG : BROWSER_OUTPUT: |6;Boyer;10578.947368421053 13:55:17 INFO - 2015-10-21 13:55:17,901 DEBUG : BROWSER_OUTPUT: |7;RegExp;28388.88888888889 13:55:17 INFO - 2015-10-21 13:55:17,901 DEBUG : BROWSER_OUTPUT: |8;Splay;1086.9565217391305 13:55:17 INFO - 2015-10-21 13:55:17,901 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;5218.75 13:55:17 INFO - 2015-10-21 13:55:17,901 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:55:17 INFO - 2015-10-21 13:55:17,901 DEBUG : BROWSER_OUTPUT: __startTimestamp1445460917899__endTimestamp 13:55:17 INFO - 2015-10-21 13:55:17,901 DEBUG : BROWSER_OUTPUT: 13:55:17 INFO - 2015-10-21 13:55:17,901 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:55:17 INFO - 2015-10-21 13:55:17,901 DEBUG : BROWSER_OUTPUT: Number of tests: 10 13:55:17 INFO - 2015-10-21 13:55:17,901 DEBUG : BROWSER_OUTPUT: 13:55:17 INFO - 2015-10-21 13:55:17,901 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:156.47 Median:156.47 stddev:0.00 (0.0%) 13:55:17 INFO - 2015-10-21 13:55:17,901 DEBUG : BROWSER_OUTPUT: Values: 156.5 13:55:17 INFO - 2015-10-21 13:55:17,901 DEBUG : BROWSER_OUTPUT: 13:55:17 INFO - 2015-10-21 13:55:17,901 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:202.80 Median:202.80 stddev:0.00 (0.0%) 13:55:17 INFO - 2015-10-21 13:55:17,901 DEBUG : BROWSER_OUTPUT: Values: 202.8 13:55:17 INFO - 2015-10-21 13:55:17,903 DEBUG : BROWSER_OUTPUT: 13:55:17 INFO - 2015-10-21 13:55:17,903 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:311.24 Median:311.24 stddev:0.00 (0.0%) 13:55:17 INFO - 2015-10-21 13:55:17,903 DEBUG : BROWSER_OUTPUT: Values: 311.2 13:55:17 INFO - 2015-10-21 13:55:17,903 DEBUG : BROWSER_OUTPUT: 13:55:17 INFO - 2015-10-21 13:55:17,903 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5312.17 Median:5312.17 stddev:0.00 (0.0%) 13:55:17 INFO - 2015-10-21 13:55:17,903 DEBUG : BROWSER_OUTPUT: Values: 5312.2 13:55:17 INFO - 2015-10-21 13:55:17,903 DEBUG : BROWSER_OUTPUT: 13:55:17 INFO - 2015-10-21 13:55:17,903 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1410.44 Median:1410.44 stddev:0.00 (0.0%) 13:55:17 INFO - 2015-10-21 13:55:17,903 DEBUG : BROWSER_OUTPUT: Values: 1410.4 13:55:17 INFO - 2015-10-21 13:55:17,903 DEBUG : BROWSER_OUTPUT: 13:55:17 INFO - 2015-10-21 13:55:17,903 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:637.76 Median:637.76 stddev:0.00 (0.0%) 13:55:17 INFO - 2015-10-21 13:55:17,903 DEBUG : BROWSER_OUTPUT: Values: 637.8 13:55:17 INFO - 2015-10-21 13:55:17,903 DEBUG : BROWSER_OUTPUT: 13:55:17 INFO - 2015-10-21 13:55:17,903 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10578.95 Median:10578.95 stddev:0.00 (0.0%) 13:55:17 INFO - 2015-10-21 13:55:17,904 DEBUG : BROWSER_OUTPUT: Values: 10578.9 13:55:17 INFO - 2015-10-21 13:55:17,904 DEBUG : BROWSER_OUTPUT: 13:55:17 INFO - 2015-10-21 13:55:17,904 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:28388.89 Median:28388.89 stddev:0.00 (0.0%) 13:55:17 INFO - 2015-10-21 13:55:17,904 DEBUG : BROWSER_OUTPUT: Values: 28388.9 13:55:17 INFO - 2015-10-21 13:55:17,904 DEBUG : BROWSER_OUTPUT: 13:55:17 INFO - 2015-10-21 13:55:17,904 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:1086.96 Median:1086.96 stddev:0.00 (0.0%) 13:55:17 INFO - 2015-10-21 13:55:17,904 DEBUG : BROWSER_OUTPUT: Values: 1087.0 13:55:17 INFO - 2015-10-21 13:55:17,904 DEBUG : BROWSER_OUTPUT: 13:55:17 INFO - 2015-10-21 13:55:17,904 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:5218.75 Median:5218.75 stddev:0.00 (0.0%) 13:55:17 INFO - 2015-10-21 13:55:17,904 DEBUG : BROWSER_OUTPUT: Values: 5218.8 13:55:17 INFO - 2015-10-21 13:55:17,904 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:55:17 INFO - 2015-10-21 13:55:17,904 DEBUG : BROWSER_OUTPUT: 13:55:18 INFO - 2015-10-21 13:55:18,539 INFO : Browser exited with error code: 0 13:55:19 INFO - 2015-10-21 13:55:19,204 INFO : Completed test v8_7 (00:00:42) 13:55:19 INFO - 2015-10-21 13:55:19,446 INFO : Completed test suite (00:20:28) 13:55:19 INFO - 2015-10-21 13:55:19,446 DEBUG : Working with test: dromaeo_css 13:55:19 INFO - 2015-10-21 13:55:19,446 DEBUG : Generating results file: dromaeo_css 13:55:19 INFO - 2015-10-21 13:55:19,447 DEBUG : Working with test: kraken 13:55:19 INFO - 2015-10-21 13:55:19,447 DEBUG : Generating results file: kraken 13:55:19 INFO - 2015-10-21 13:55:19,447 INFO : javascript benchmark 13:55:19 INFO - 2015-10-21 13:55:19,447 DEBUG : Working with test: v8_7 13:55:19 INFO - 2015-10-21 13:55:19,447 DEBUG : Generating results file: v8_7 13:55:19 INFO - 2015-10-21 13:55:19,447 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:55:19 INFO - 2015-10-21 13:55:19,657 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,201,25]] 13:55:19 INFO - 2015-10-21 13:55:19,657 DEBUG : process_Request line: dromaeo_css 6405.14 graph.html#tests=[[72,201,25]] 13:55:19 INFO - 2015-10-21 13:55:19,657 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:55:19 INFO - 2015-10-21 13:55:19,696 DEBUG : process_Request line: kraken 1635.60 graph.html#tests=[[232,201,25]] 13:55:19 INFO - 2015-10-21 13:55:19,696 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:55:19 INFO - 2015-10-21 13:55:19,831 DEBUG : process_Request line: v8_7 19457.35 graph.html#tests=[[230,201,25]] 13:55:19 INFO - 2015-10-21 13:55:19,832 INFO : javascript benchmark 13:55:19 INFO - 2015-10-21 13:55:19,834 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [306.8297095112213, 306.9447499450099, 306.9570260163576, 312.07781007123964, 313.0935940452391, 11151.163662725308, 11962.581309654164, 17022.233999470023, 17836.554086147837, 17942.0, 10452.320599161048, 10665.626703065394, 16717.164141792924, 17032.744508832377, 17132.486025419224, 4067.2678917794783, 4130.091379896418, 4134.6692264618905, 4165.66674666026, 4170.291050521419, 4115.629593336599, 4165.541790403053, 4170.270202714528, 4172.415861779338, 4177.832886684529, 3587.264610754789, 3591.4792355108493, 3934.075492259317, 4053.27041132596, 4130.958690413103, 4473.507914129443, 4547.18150732868, 4560.863174104782, 4574.542545745432, 4586.908261834745, 3678.797666128362, 3730.6269373062746, 3761.962380376189, 3820.789856557888, 3823.5220597425323, 11782.941085294604, 11912.642620721392, 12289.93855030728, 12304.26174429537, 12358.938205308916, 1987.175322241268, 2031.2687432524278, 2036.9592608147902, 2094.486850721583, 2101.432613194444, 9344.159025687653, 9499.620015199383, 9546.61813527465, 9605.37565058276, 9640.71077867665, 1443.4659176104803, 1468.757654986926, 1501.3544176004314, 1506.9773953390597, 1577.9211039447982, 75139.24860751377, 76334.61832690856, 76870.61564692197, 76966.23033769647, 77428.61285693591, 5519.751611177507, 5529.834104976857, 5798.420157984167, 5907.940920590739, 5909.936211481889, 6630.1049358336, 6676.198856137295, 6678.766243181465, 6680.398764111156, 6694.196696396463, 4830.082284365959, 5022.84931452057, 5046.26829109777, 5057.797688092435, 5066.214736715815, 5555.666660000413, 5558.555315574744, 5564.360098588633, 5570.3315602127195, 5598.97200514003, 2550.7959363251266, 2591.3651155467032, 2604.9449972761063, 2623.580227163645, 2625.2911713837157, 915.3866909170871, 923.353652443279, 924.0528458330131, 928.062656716721, 987.012987012987, 358.9982050089785, 384.6230693919918, 398.5158032989931, 401.54023642928684, 416.2839915345601, 10701.357918524913, 10949.233553651327, 11122.110231181487, 11168.720781980515, 11275.436228188557, 423.3945457995097, 433.2699401508468, 434.1512343368707, 438.56143856143854, 444.09404814179356, 6051.57638965277, 6118.938810611926, 6161.353057928853, 6164.075388691732, 6180.938190618036, 467200.0, 472312.0, 472475.0, 472894.0, 473073.0, 73342.26657733461, 86533.0, 87727.0, 90029.24488214536, 90032.5498372504, 445.3564599154256, 449.19145538031415, 452.54745254745256, 454.2890376560738, 454.94313210848645, 9935.0, 10154.796904062025, 10170.89829101729, 10185.134263587677, 10276.743081423025, 23809.64285535753, 31213.063608091794, 40280.0, 41035.7948210257, 41122.1775564493, 58193.0, 59636.0, 59669.701651493204, 59999.40000599938, 60490.39509604847, 5665.830025099253, 5678.3753787084215, 5698.430156984268, 5700.401457847032, 5702.600817942704, 11452.0, 11814.232074915102, 11903.226290291102, 11915.82126268124, 11924.523019079139, 9850.556724947251, 9996.500174991366, 9999.250056245664, 10053.597856085675, 10169.084782369622, 9220.677276295297, 9813.558389872616, 9826.852597210904, 9853.753656158653, 10145.137663298703, 10307.278490505592, 10343.275970682282, 10367.27429079957, 10400.959904009842, 10711.732206694895, 5425.511703946664, 5581.832545023656, 5737.08206686928, 5772.39389864075, 5790.507806836297, 9775.657851975431, 9950.154236889946, 9958.601655933971, 10017.54921028541, 10144.0], "dojo.html": [2705.9323516912063, 2769.335359513717, 2831.7309855563726, 2833.2350265428336, 2838.7728981681466, 5178.585713142954, 5211.50490703383, 5212.270282160501, 5233.816816411421, 5311.920321195185, 5216.921746173811, 5236.554892834114, 5311.2298716686055, 5348.010618035666, 5350.250964864922, 4429.822807087713, 4551.089782043588, 4598.402207713009, 4602.2636378179495, 4635.814567417307, 4357.825686972517, 4480.686351955364, 4567.520410356915, 4604.355390245369, 4618.1687296286655, 4437.267850804614, 4496.4829044659955, 4510.25580779171, 4538.909221815562, 4542.068875880436, 4423.424954755893, 4549.31760235964, 4598.816047358102, 4614.261718125117, 4624.445066591997, 4436.201483732927, 4491.797869095899, 4521.027978984501, 4534.229181039232, 4535.659825513099, 5128.820491282824, 5141.5886729061585, 5143.562797162245, 5175.818846340398, 5229.058769421503, 5448.863778405532, 5479.232907392969, 5482.314710661168, 5576.9163462548095, 5609.074502707049, 5452.291202143736, 5465.152901300305, 5523.6685798851795, 5651.406602306781, 5658.91511627326, 5008.474110218447, 5068.2961897914965, 5166.225066240019, 5182.948170518284, 5183.300254465675, 5617.747201375948, 5627.971860140673, 5659.745311460994, 5768.451997060272, 5769.0192667246665, 5224.190250511177, 5302.2311764793885, 5317.122674758699, 5499.450054994549, 5509.917351239735, 5358.169483730028, 5467.617266791286, 5567.610267281251, 5610.410906854803, 5611.0741727615305, 5456.836294911159, 5482.342118945752, 5491.121420572689, 5582.804601838916, 5589.469000444951, 5000.2749601307605, 5418.593605479605, 5437.864053398696, 5586.748596313176, 5590.832275031756, 3357.462805951036, 3432.3821712092063, 3488.843002064913, 3492.877749278763, 3496.021114088059, 3210.4702724050735, 3230.0, 3254.8047117173046, 3263.2494526259093, 3264.5919260092487, 5119.744012799345, 5237.083510385667, 5240.978009288152, 5253.001929633358, 5385.488378604026, 5331.840044798662, 5458.617896747269, 5560.582956278215, 5604.607677462538, 5607.803726869622, 5136.5890728741615, 5238.764255608507, 5394.352677678704, 5395.433479484597, 5397.136458166753, 4237.851675191354, 4303.278688524615, 4318.460192475941, 4327.480702315742, 4415.845445409395, 5654.208410822406, 5674.744636491368, 5741.799037033684, 5755.884882302415, 5768.596198266165, 5340.679559226459, 5429.484199001088, 5497.367802702581, 5615.326160860723, 5633.915491267716, 5328.706921119376, 5594.13290939905, 5702.401247868914, 5705.828825135252, 5819.388964158702, 5447.428020057837, 5465.918011229755, 5538.9169162461785, 5567.749451274622, 5572.219889215432, 5537.031019571639, 5540.667559946416, 5556.277683901067, 5638.351589567088, 5687.146927960674, 5290.603204759582, 5369.248305237348, 5447.428020057995, 5474.069408200536, 5571.526420254324, 5349.411564727955, 5364.141737322166, 5431.619786614899, 5455.427180146186, 5458.972705136449, 5119.385673719177, 5217.373915130209, 5231.633785634969, 5373.086575282133, 5377.2740680009265, 5259.579233661221, 5382.219578161066, 5386.48828361305, 5393.298871146726, 5495.53287970511, 5045.192769156917, 5167.793288268577, 5363.651362661414, 5396.271503346998, 5441.319835020622], "mootools.html": [1190.089581470176, 1244.8319476870622, 1314.513629956916, 1451.8040064591278, 1566.4830605900054, 7670.079590449147, 8233.83532329353, 8611.784705382368, 8629.223369896708, 8636.95681521593, 8336.208060234283, 8365.91634083659, 8378.91621083789, 8465.746027619165, 8475.152484751537, 2055.650539408304, 2080.3862860456125, 2243.540074284768, 2273.6930514380556, 2299.8735069571167, 2246.3148739634403, 2324.0936034946385, 2325.697659304288, 2336.5677349690363, 2337.544178885118, 2284.5316710074394, 2323.61660326046, 2324.895379707909, 2326.8720220387872, 2328.1269523928527, 2085.3743876836966, 2115.122224276931, 2138.828893688501, 2230.4200907763934, 2317.3511416803153, 2274.2722328854775, 2298.276043046435, 2307.200383700699, 2326.1974618756503, 2345.9178928737583, 8285.0, 8512.106228846005, 8555.315574754068, 8565.48607083577, 8595.828083438297, 4965.428975667773, 4999.275105109775, 5039.168537191359, 5068.163752980754, 5114.846554603368, 3284.2282063715006, 3424.5376874121926, 3431.107911942913, 3432.70821980132, 3435.1068722132427, 1048.5438834107113, 1060.294903888913, 1067.834485654717, 1096.8519249901321, 1099.7580532282884, 12178.147529672926, 12198.14612977092, 12238.632841014694, 12260.75478490434, 12282.07884408664, 4305.870823875289, 4372.868813935524, 4415.094905544356, 4429.645628349789, 4444.888877778081, 10048.14590759779, 10062.295639305179, 10076.445795481171, 10086.596536138619, 10089.192864570818, 4804.975975120102, 4982.626303027288, 4988.80044798204, 4993.975030124826, 4996.625253106032, 4453.1761624099645, 4539.591436770706, 4544.795484203219, 4549.226631472658, 4550.158220729176, 3531.52324436203, 3585.4263317869018, 3605.8737944171826, 3607.909802254912, 3621.728370372233, 1117.5697356517637, 1122.971925701864, 1127.9887201128047, 1135.40391294571, 1137.175547727907, 810.2707563193173, 1028.3367228137959, 1068.3376306689747, 1084.4957094950728, 1084.7125511739396, 6945.617991010543, 7627.313541781266, 7730.884036739453, 7770.45606807518, 7772.455928085093, 567.9744411501492, 570.823044856096, 594.432317137133, 598.6797063571056, 602.8553147244629, 5673.149027645886, 5687.459691329317, 5688.260526131577, 5694.572907031989, 5708.286464191976, 10554.366737995744, 10673.199510036779, 10675.092617127475, 10694.572217111385, 10700.357978521313, 10373.429461379546, 10611.946940265248, 10649.574017039387, 10656.147508199481, 10677.78644427107, 7502.17476077631, 7823.0, 7872.567008814455, 7887.053553573493, 7889.763307100911, 7428.665710042953, 7524.097108347033, 7567.886481702669, 7574.924250757422, 7606.31543161096, 9421.952890235505, 9473.57368918414, 9520.571574279036, 9521.238300935769, 9535.332526723063, 9517.619295228113, 9722.611095556382, 9820.754481138028, 9836.803263934824, 9837.262205334771, 7680.731174408869, 7713.228677132466, 7754.728584499516, 7759.456838021284, 7761.495502792526, 8002.159773223728, 8304.169583041648, 8325.791855203668, 8325.875111873447, 8352.123027082069, 7727.4204434668745, 7758.689652414066, 7760.68957241704, 7836.451448398558, 7932.405069619686, 7597.278258565428, 7700.768976930701, 7753.224677532202, 7789.688412463438, 7804.0, 6976.267491913276, 7152.392046676091, 7306.561606303639, 7417.03578534787, 7436.9256307436235, 6540.444062254762, 6611.0, 6620.304867988792, 6636.402723754885, 6641.833954150991, 6675.7997260082275, 6680.766173183915, 6691.799246022627, 6697.933020669731, 6713.664316784044], "ext.html": [510.099674075257, 511.182108626198, 513.8792383789806, 514.4418306137841, 521.6244304101051, 31872.68127318726, 37457.81271093641, 38100.80949595252, 38167.2749087637, 38206.23587528248, 39314.795283344254, 39985.80007099968, 40308.19383612333, 40351.39472907909, 40364.79817600908, 7599.164091949881, 7735.0, 7910.0, 8205.138460461656, 8257.876131858027, 9888.604455821758, 10059.295849290553, 10081.09270165685, 10082.395056296646, 10099.495025248745, 10023.398596084258, 10126.0, 10137.695869123938, 10139.847902281472, 10140.847887281696, 7897.289243968042, 7970.402219833536, 10111.090001899827, 10182.54178561959, 10356.378617282988, 9749.268804839594, 9843.704688859274, 9923.950380248125, 9926.503674816231, 9934.354266972623, 30950.380992380025, 37086.258274834625, 37331.81334093312, 37419.438708419395, 37428.0, 2797.356607980156, 3028.364043550857, 3039.7568194544383, 3060.7551395888277, 3126.421612001787, 29424.70575294241, 29750.851245743634, 29963.700362996307, 30121.698783012107, 30868.53697194544, 2585.108137692493, 2626.093997570835, 2629.0404002538935, 2631.5000149971443, 2668.346255167477, 302735.0, 304207.0, 305077.0, 305559.0, 305744.9999999978, 45910.540894590624, 46481.5351846484, 52164.73917630463, 52559.47440525546, 52563.47436525586, 54535.0, 54934.72532637391, 55079.724601376736, 55157.724211378685, 55212.72393638086, 13800.102993305403, 13857.307134643228, 13956.581302560939, 14014.859851401356, 14068.709043741757, 10728.141748660088, 10746.677599672023, 10753.924607539184, 10765.83851242232, 10773.353598784099, 16718.582035448966, 17226.655466890592, 17306.22122004513, 17349.913250433667, 17423.564410889576, 7039.296070392919, 7227.385672217921, 7243.818904527324, 7289.198188199294, 7293.635318234067, 820.827626198493, 939.7039932421266, 955.2167222877313, 979.9755006124904, 1058.047757018674, 27489.66337861304, 27913.44173116526, 28021.0, 28345.433091338058, 28561.428771424456, 966.9951650241704, 995.348047029197, 1001.9348742331725, 1006.9395836249848, 1050.6532844161409, 14547.3453694584, 14677.706445871023, 14715.19066451334, 14776.408943642135, 15053.849461505464, 412173.0, 414020.0, 416115.0, 419168.0, 420521.0, 49059.0, 49077.509224908004, 49188.0, 49344.75327623339, 49435.258471122965, 1163.7497937943383, 1174.7180676637545, 1180.6694125644833, 1181.2853223799477, 1183.041736193686, 22450.88774556117, 27012.86493567598, 27831.860840695666, 27931.301717457227, 29089.563656545593, 41424.58575414207, 42019.0, 43441.0, 43518.782406089034, 43644.34533482064, 345351.0, 347915.0, 348492.0, 348607.0, 348848.0, 24582.0, 27374.5893811589, 27864.0, 27894.581581275892, 28065.158045257856, 38512.09844702056, 39174.41238381484, 39376.0, 39969.0, 40313.79843100766, 34546.22709890255, 35073.64926350704, 35132.473012905335, 35386.46920296249, 36255.63744362522, 32903.34193316072, 33260.667393325755, 33472.832635837636, 34453.310933781686, 34461.0, 35332.47001295034, 36243.81878090592, 36303.63696363002, 36342.454863177605, 38941.41587876241, 34736.478952815225, 35082.64917350896, 36363.27273454569, 38879.41680874846, 39162.0, 28946.276343090747, 29574.40851183007, 29990.855532402584, 30283.848580756956, 30513.18585176853], "prototype.html": [303.4416673321089, 309.25315363397397, 313.35605331044695, 313.9183812208826, 316.9540416639587, 5757.568182386317, 5868.090445980874, 5871.530277577795, 5902.173695682603, 5918.4377484138995, 5824.854378640536, 5829.504492118175, 5830.329512106109, 5832.358440571534, 5836.941630583693, 4205.537390887015, 4211.515675697288, 4211.810468528908, 4212.515560710512, 4220.451341325624, 4040.8383664653525, 4095.856645017425, 4196.181744559812, 4199.664026877857, 4211.031462763551, 3940.290747665419, 4109.157622687342, 4139.172165566883, 4146.543880173179, 4149.5228048774325, 3961.881143565683, 4068.572799856002, 4069.0641152534786, 4109.876703698894, 4134.297169481196, 3428.0915557377316, 3527.1358517163458, 3561.71506279497, 3562.1985053363046, 3567.3222087803492, 5356.143017117242, 5482.122860342326, 5493.285872836545, 5642.463965923231, 5669.319681638189, 4758.238681810928, 4823.541763532458, 4857.73282469464, 4873.049755297683, 4883.365162528884, 6029.60807547508, 6029.638221706711, 6036.215292012011, 6049.546284028672, 6051.515878729691, 3988.4216788565786, 3999.280129576675, 4003.2794097062515, 4005.7997100144876, 4011.9398209026594, 6278.215223097113, 6352.07894855248, 6359.046143078529, 6367.522435817286, 6370.649614271213, 4076.3681629347498, 4092.836286548564, 4096.897577560525, 4103.343465045638, 4119.217348703737, 4020.638142567183, 4095.1195492969155, 4162.396452514368, 4180.686448516312, 4190.141021090669, 4870.634702397334, 4877.512248775094, 4890.462049174588, 4897.41231052276, 4909.140900342497, 5942.64344139353, 6060.515158787286, 6061.575689701766, 6064.48451881595, 6069.575129740964, 1460.5983354577363, 1493.2682985337105, 1496.0126316631188, 1496.244396579742, 1497.8427265137223, 980.132582664333, 989.3569180033036, 1005.005045005454, 1007.9949600252098, 1016.6645007147623, 5939.881202375928, 5942.049272116527, 5952.464278214981, 5956.16613674086, 5964.433378829004, 6313.147725057151, 6314.431701146918, 6317.273513546001, 6321.557490975588, 6323.683815809191, 5939.46544810969, 5943.227380440601, 5944.316403613553, 5947.49446297061, 5951.166836642873, 3355.4295769719206, 3465.237647717498, 3485.3029394121277, 3488.66857648523, 3489.7208223342072, 6269.0909818076125, 6613.86772264552, 6619.86760264792, 6624.701888415033, 6629.900551491732, 6121.755129794848, 6443.323451037667, 6453.515986301046, 6454.419102280817, 6458.354164583504, 6603.735850565923, 6608.207015158212, 6609.768658096944, 6611.173603299588, 6612.23959244693, 5835.854103647443, 6228.844278893064, 6307.337729538516, 6324.715387807468, 6326.051092336186, 5946.821595352147, 6217.875642487215, 6222.595531290633, 6224.657643829632, 6230.190075290365, 6375.808725738235, 6596.340365963365, 6597.868042639217, 6601.405873471411, 6608.372204640744, 4148.274052040821, 4170.103427763045, 4178.582141785919, 4182.435371224846, 4185.18388914171, 5871.588988770916, 6209.565330426827, 6316.273628532777, 6341.8097457076365, 6342.302346741947, 6124.908126378197, 6127.938720612915, 6190.071489276645, 6200.782972596118, 6203.689815509116, 6160.661163636043, 6167.722452489738, 6168.35232300602, 6168.599041062316, 6170.352113028068, 6012.518998480024, 6017.699115044143, 6019.428154325332, 6023.45788879003, 6034.63792172471, 5870.767138900708, 6021.668808215591, 6200.224971878515, 6204.627722336674, 6208.192934918432, 6095.0, 6106.542009349406, 6114.419130182626, 6116.235470566179, 6122.816315510542], "yui.html": [645.2160624840817, 688.2360579756472, 718.2853061204103, 725.4631572636249, 752.4883079505936, 12174.513019479222, 12394.194377365466, 12410.069244806642, 12428.378581070956, 12471.750564988695, 11487.483063262152, 12152.210106343082, 12157.878421215784, 12171.634850954464, 12178.573749918754, 487.63914703119616, 501.35575785116134, 580.060302310258, 587.6914619824594, 595.2797115490262, 584.0713265907207, 585.8564651660349, 591.9023361145428, 592.8458600763811, 593.9316978547479, 615.9938400616004, 618.8174488525873, 620.0760866309212, 620.9348018458064, 621.093203922274, 514.4983640950081, 518.1761000009983, 612.1674522649193, 617.9258488981351, 620.2959640807716, 445.092012294918, 445.21419694239694, 446.5021501026332, 448.42825397617975, 449.35741889098574, 12046.759064818654, 12141.757164856741, 12144.089193310538, 12193.573224937085, 12198.0, 11288.774224515546, 11305.830412543819, 11465.828012579734, 11681.240719353214, 11861.881381186164, 9331.20684741791, 10000.499975001294, 10034.342990635583, 10079.848802267972, 10080.546375413123, 3358.2947581008016, 3432.262063656326, 3481.669241422061, 3481.850406066339, 3488.145404375944, 47509.0, 48368.75815620935, 48413.515864841254, 48573.51426485725, 48810.26784598234, 9018.774530636787, 9094.317926155432, 9136.908630913606, 9210.125038121369, 9374.296927730447, 15552.533423997298, 15753.921230393775, 15759.29083191259, 15778.368865245491, 15780.921095394679, 7237.493375463667, 7241.2396698346965, 7274.272572742683, 7311.89032164518, 7532.924670753332, 3930.155016671429, 4039.1719697462536, 4085.9795701021303, 4159.147374788222, 4327.004788898571, 2714.1586108306487, 2716.809823312349, 2733.685626152978, 2738.3838636306673, 2742.80800343974, 433.70508054522594, 434.9217140914666, 439.30370362975043, 443.48112708131566, 450.2301065178516, 609.430182779103, 634.2990994950605, 642.8983087899173, 652.4128284543948, 669.6183175589867, 8882.111788821067, 8919.866202006975, 8965.417247878868, 9100.135487128713, 9328.253739700807, 555.3474667265947, 578.3955766224306, 588.5909293041381, 637.4486069549806, 680.5236334565824, 4043.696722745747, 4289.399484072233, 4341.39220509129, 4380.382810828508, 4461.955380446154, 53435.46564534383, 55533.0, 55847.72076139593, 56428.717856410454, 56444.71777641086, 45113.77443112829, 45731.5426845734, 48436.27345589819, 48483.5151648479, 48516.7574162134, 41541.79229103835, 42647.36028959568, 42964.0, 43533.12933741308, 43553.34669979953, 8926.776830579287, 9007.909920900707, 9110.117635305523, 9198.448093114435, 9294.874993762056, 29380.706192937796, 29886.551701724056, 30418.695813042472, 30446.238844029078, 30511.08466746001, 40901.1819763609, 41205.0, 41573.37639935464, 42210.57789422067, 43569.128617428105, 7242.746503872339, 7254.709811607477, 7453.329200371993, 7546.207648196861, 7707.0, 12522.87477125217, 12839.665804654938, 12959.416826242654, 13011.869881301065, 13318.267495287851, 12030.007993525713, 12049.578264760692, 12172.8612271828, 12306.630801075982, 12494.937525312314, 11888.108391870472, 11943.581974630846, 11952.402379881145, 12298.385080746106, 12302.938485307874, 12199.451024703732, 12207.816882746944, 12296.877031229573, 12486.375681216085, 12781.233126012468, 10081.69754907354, 10453.216008799218, 10586.04725574702, 10680.62617808373, 10812.783744325227, 10192.847107293544, 10359.32664376813, 10700.678979630624, 10735.785284294427, 10764.569417223536]}, "summary": {"suite": 6405.139835808009, "subtests": {"jquery.html": {"filtered": 6382.53724868049, "value": 6382.53724868049}, "dojo.html": {"filtered": 4988.719941441009, "value": 4988.719941441009}, "mootools.html": {"filtered": 4620.184846946045, "value": 4620.184846946045}, "ext.html": {"filtered": 17975.520196802216, "value": 17975.520196802216}, "prototype.html": {"filtered": 4524.348745565044, "value": 4524.348745565044}, "yui.html": {"filtered": 5771.047514927849, "value": 5771.047514927849}}}, "test_machine": {"platform": "x86", "osversion": "6.1.7601", "os": "win", "name": "T-W732-IX-070"}, "testrun": {"date": 1445459690, "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": "20151021083202", "branch": "B2G-Inbound", "revision": "a934f66fc9dbe80aeffc1c25fe178d5c63b97c7a"}}, {"talos_counters": {}, "results": {"audio-dft": [157.0, 158.0, 156.0, 156.0, 159.0, 161.0, 159.0, 158.0, 157.0, 158.0], "ai-astar": [96.0, 89.0, 100.0, 99.0, 96.0, 100.0, 97.0, 98.0, 98.0, 112.0], "imaging-gaussian-blur": [121.0, 123.0, 118.0, 120.0, 119.0, 116.0, 117.0, 126.0, 118.0, 117.0], "audio-beat-detection": [138.0, 140.0, 168.0, 176.0, 149.0, 142.0, 147.0, 142.0, 158.0, 139.0], "json-stringify-tinderbox": [75.0, 74.0, 75.0, 75.0, 76.0, 75.0, 74.0, 73.0, 73.0, 73.0], "stanford-crypto-pbkdf2": [191.0, 202.0, 203.0, 210.0, 202.0, 193.0, 196.0, 197.0, 200.0, 191.0], "json-parse-financial": [82.0, 82.0, 83.0, 81.0, 81.0, 81.0, 84.0, 84.0, 83.0, 95.0], "stanford-crypto-sha256-iterative": [90.0, 89.0, 88.0, 90.0, 100.0, 93.0, 94.0, 86.0, 92.0, 94.0], "audio-fft": [75.0, 78.0, 78.0, 99.0, 79.0, 84.0, 78.0, 79.0, 106.0, 75.0], "imaging-darkroom": [153.0, 161.0, 151.0, 164.0, 143.0, 140.0, 142.0, 142.0, 141.0, 162.0], "stanford-crypto-ccm": [131.0, 129.0, 128.0, 121.0, 125.0, 117.0, 135.0, 131.0, 127.0, 122.0], "audio-oscillator": [97.0, 96.0, 117.0, 98.0, 98.0, 99.0, 128.0, 103.0, 100.0, 121.0], "stanford-crypto-aes": [95.0, 95.0, 96.0, 95.0, 100.0, 98.0, 100.0, 98.0, 100.0, 100.0], "imaging-desaturate": [91.0, 90.0, 100.0, 100.0, 96.0, 97.0, 95.0, 103.0, 120.0, 96.0]}, "summary": {"suite": 1635.5999999999997, "subtests": {"audio-fft": {"filtered": 83.1, "value": 83.1}, "stanford-crypto-pbkdf2": {"filtered": 198.5, "value": 198.5}, "audio-beat-detection": {"filtered": 149.9, "value": 149.9}, "stanford-crypto-ccm": {"filtered": 126.6, "value": 126.6}, "imaging-darkroom": {"filtered": 149.9, "value": 149.9}, "json-parse-financial": {"filtered": 83.6, "value": 83.6}, "audio-oscillator": {"filtered": 105.7, "value": 105.7}, "ai-astar": {"filtered": 98.5, "value": 98.5}, "audio-dft": {"filtered": 157.9, "value": 157.9}, "stanford-crypto-sha256-iterative": {"filtered": 91.6, "value": 91.6}, "json-stringify-tinderbox": {"filtered": 74.3, "value": 74.3}, "imaging-gaussian-blur": {"filtered": 119.5, "value": 119.5}, "stanford-crypto-aes": {"filtered": 97.7, "value": 97.7}, "imaging-desaturate": {"filtered": 98.8, "value": 98.8}}}, "test_machine": {"platform": "x86", "osversion": "6.1.7601", "os": "win", "name": "T-W732-IX-070"}, "testrun": {"date": 1445459690, "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": "20151021083202", "branch": "B2G-Inbound", "revision": "a934f66fc9dbe80aeffc1c25fe178d5c63b97c7a"}}, {"talos_counters": {}, "results": {"DeltaBlue": [202.7986209693774], "Encrypt": [311.2356053532524], "NavierStokes": [5218.75], "Decrypt": [5312.169312169312], "Splay": [1086.9565217391305], "Richards": [156.47003598810826], "RegExp": [28388.88888888889], "Earley": [637.7551020408164], "Boyer": [10578.947368421053], "RayTrace": [1410.4372355430182]}, "summary": {"suite": 19457.34510808869, "subtests": {"DeltaBlue": {"filtered": 326.02785799999987, "value": 326.02785799999987}, "Encrypt": {"filtered": 855.239553, "value": 855.239553}, "NavierStokes": {"filtered": 284.3592814371255, "value": 284.3592814371255}, "Decrypt": {"filtered": 50.107777888446215, "value": 50.107777888446215}, "Splay": {"filtered": 74.97171999999998, "value": 74.97171999999998}, "RegExp": {"filtered": 32.089491193737786, "value": 32.089491193737786}, "Richards": {"filtered": 225.61508199999997, "value": 225.61508199999997}, "Earley": {"filtered": 1045.0139840000004, "value": 1045.0139840000004}, "Boyer": {"filtered": 62.99899004975127, "value": 62.99899004975127}, "RayTrace": {"filtered": 524.6522010000002, "value": 524.6522010000002}}}, "test_machine": {"platform": "x86", "osversion": "6.1.7601", "os": "win", "name": "T-W732-IX-070"}, "testrun": {"date": 1445459690, "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": "20151021083202", "branch": "B2G-Inbound", "revision": "a934f66fc9dbe80aeffc1c25fe178d5c63b97c7a"}}] 13:55:19 INFO - RETURN: dromaeo_css: 6405.14 13:55:19 INFO - RETURN: kraken: 1635.60 13:55:19 INFO - RETURN: v8_7: 19457.35 13:55:19 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,25]]", "result": "19457.35"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,25]]", "result": "1635.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,25]]", "result": "6405.14"}}} 13:55:19 INFO - Return code: 0 13:55:19 INFO - # TBPL SUCCESS # 13:55:19 INFO - Running post-action listener: _resource_record_post_action 13:55:19 INFO - Running post-run listener: _resource_record_post_run 13:55:21 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 714278400; Write bytes: 886654976; Read time: 8277510; Write time: 6827340 13:55:21 INFO - install - Wall time: 2s; CPU: 13.0%; Read bytes: 0; Write bytes: 493056; Read time: 0; Write time: 7550 13:55:21 INFO - run-tests - Wall time: 1233s; CPU: 13.0%; Read bytes: 714278400; Write bytes: 863605248; Read time: 8277510; Write time: 6801680 13:55:21 INFO - Running post-run listener: _upload_blobber_files 13:55:21 INFO - Blob upload gear active. 13:55:21 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 13:55:21 INFO - Copying logs to upload dir... 13:55:21 INFO - mkdir: C:\slave\test-pgo\build\upload\logs program finished with exit code 0 elapsedTime=1546.407000 ========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 29 mins, 25 secs) (at 2015-10-21 13:59:00.368482) ========= ========= Started set props: build_url (results: 0, elapsed: 42 secs) (at 2015-10-21 13:59:00.371558) ========= '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-070 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-070 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-070 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/3H3nkCKnR_m_MMoChUGYag/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/3H3nkCKnR_m_MMoChUGYag/artifacts/public/build/firefox-44.0a1.en-US.win32.zip' ========= Finished set props: build_url (results: 0, elapsed: 42 secs) (at 2015-10-21 13:59:42.952755) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 29 secs) (at 2015-10-21 13:59:42.953082) ========= '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-070 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-070 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-070 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: 29 secs) (at 2015-10-21 14:00:12.027321) ========= ========= Started reboot slave lost (results: 0, elapsed: 30 secs) (at 2015-10-21 14:00:12.027651) ========= ========= Finished reboot slave lost (results: 0, elapsed: 30 secs) (at 2015-10-21 14:00:42.659450) =========