builder: fx-team_win7-ix_test-dromaeojs-pgo slave: t-w732-ix-110 starttime: 1445480187.31 results: success (0) buildid: 20151021143020 builduid: dc0bb898cb9d4f48a796b24f17bb1e3a revision: 8c36f375d03b0fcd7a8b3f4c1d92a6b4e4f26e0e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-21 19:16:27.309415) ========= master: http://buildbot-master111.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-21 19:16:27.309831) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-21 19:16:27.310115) ========= '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-110 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-110 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-110 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.581000 basedir: 'C:\\slave\\test-pgo' ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-21 19:16:27.919830) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-21 19:16:27.920142) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-21 19:16:28.062158) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-21 19:16:28.062488) ========= '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-110 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-110 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-110 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.601000 ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-21 19:16:28.678211) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-21 19:16:28.678530) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-21 19:16:28.678927) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-21 19:16:28.679216) ========= '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-110 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-110 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-110 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 --19:16:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py => `archiver_client.py' Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12,141 (12K) [text/x-python] 0K .......... . 100% 7.95 MB/s 19:16:30 (7.95 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.739000 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-21 19:16:29.435133) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 16 secs) (at 2015-10-21 19:16:29.435459) ========= '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-110 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-110 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-110 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=13.801000 ========= Finished 'rm -rf ...' (results: 0, elapsed: 16 secs) (at 2015-10-21 19:16:46.290882) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-10-21 19:16:46.291261) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo integration/fx-team --rev 8c36f375d03b0fcd7a8b3f4c1d92a6b4e4f26e0e --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/fx-team --rev 8c36f375d03b0fcd7a8b3f4c1d92a6b4e4f26e0e --destination scripts --debug'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files\Common Files COMPUTERNAME=T-W732-IX-110 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-110 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-110 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 19:16:47,410 truncating revision to first 12 chars 2015-10-21 19:16:47,411 Setting DEBUG logging. 2015-10-21 19:16:47,411 attempt 1/10 2015-10-21 19:16:47,411 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8c36f375d03b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-10-21 19:16:48,463 unpacking tar archive at: fx-team-8c36f375d03b/testing/mozharness/ program finished with exit code 0 elapsedTime=2.093000 ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-10-21 19:16:48.470840) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-21 19:16:48.471182) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-21 19:16:48.487595) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-21 19:16:48.487849) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-21 19:16:48.488236) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 24 mins, 2 secs) (at 2015-10-21 19:16:48.488523) ========= 'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'dromaeojs' '--add-option' '--webServer,localhost' '--branch-name' 'Fx-Team' '--system-bits' '32' '--cfg' 'talos/windows_config.py' '--download-symbols' 'ondemand' '--use-talos-json' '--blob-upload-branch' 'Fx-Team' 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', 'Fx-Team', '--system-bits', '32', '--cfg', 'talos/windows_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files\Common Files COMPUTERNAME=T-W732-IX-110 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-110 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-110 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 19:16:49 INFO - MultiFileLogger online at 20151021 19:16:49 in C:\slave\test-pgo 19:16:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 32 --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 19:16:49 INFO - Dumping config to C:\slave\test-pgo\logs\localconfig.json. 19:16:49 INFO - {'append_to_log': False, 19:16:49 INFO - 'base_work_dir': 'C:\\slave\\test-pgo', 19:16:49 INFO - 'blob_upload_branch': 'Fx-Team', 19:16:49 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test-pgo\\oauth.txt', 19:16:49 INFO - 'branch': 'Fx-Team', 19:16:49 INFO - 'buildbot_json_path': 'buildprops.json', 19:16:49 INFO - 'config_files': ('talos/windows_config.py',), 19:16:49 INFO - 'default_actions': ('clobber', 19:16:49 INFO - 'read-buildbot-config', 19:16:49 INFO - 'download-and-extract', 19:16:49 INFO - 'populate-webroot', 19:16:49 INFO - 'create-virtualenv', 19:16:49 INFO - 'install', 19:16:49 INFO - 'run-tests'), 19:16:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:16:49 INFO - 'download_minidump_stackwalk': True, 19:16:49 INFO - 'download_symbols': 'ondemand', 19:16:49 INFO - 'exes': {'easy_install': ('C:\\slave\\test-pgo\\build/venv/scripts/python', 19:16:49 INFO - 'C:\\slave\\test-pgo\\build/venv/scripts/easy_install-2.7-script.py'), 19:16:49 INFO - 'hg': 'c:/mozilla-build/hg/hg', 19:16:49 INFO - 'mozinstall': ('C:\\slave\\test-pgo\\build/venv/scripts/python', 19:16:49 INFO - 'C:\\slave\\test-pgo\\build/venv/scripts/mozinstall-script.py'), 19:16:49 INFO - 'python': 'c:/mozilla-build/python27/python.exe', 19:16:49 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe', 19:16:49 INFO - 'C:/mozilla-build/tooltool.py'), 19:16:49 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe', 19:16:49 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 19:16:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:16:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:16:49 INFO - 'installer_path': 'installer.exe', 19:16:49 INFO - 'log_level': 'info', 19:16:49 INFO - 'log_name': 'talos', 19:16:49 INFO - 'log_to_console': True, 19:16:49 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe', 19:16:49 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe', 19:16:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest', 19:16:49 INFO - 'opt_config_files': (), 19:16:49 INFO - 'pip_index': False, 19:16:49 INFO - 'sps_profile': False, 19:16:49 INFO - 'sps_profile_interval': 0, 19:16:49 INFO - 'suite': 'dromaeojs', 19:16:49 INFO - 'system_bits': '32', 19:16:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:16:49 INFO - 'title': 'T-W732-IX-110', 19:16:49 INFO - 'use_talos_json': True, 19:16:49 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'), 19:16:49 INFO - 'virtualenv_path': 'C:\\slave\\test-pgo\\build/venv', 19:16:49 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll', 19:16:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:16:49 INFO - 'work_dir': 'build'} 19:16:49 INFO - ##### 19:16:49 INFO - ##### Running clobber step. 19:16:49 INFO - ##### 19:16:49 INFO - Running pre-action listener: _resource_record_pre_action 19:16:49 INFO - Running main action method: clobber 19:16:49 INFO - rmtree: C:\slave\test-pgo\build 19:16:49 INFO - Using _rmtree_windows ... 19:16:49 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test-pgo\\build',), kwargs: {}, attempt #1 19:18:20 INFO - Running post-action listener: _resource_record_post_action 19:18:20 INFO - ##### 19:18:20 INFO - ##### Running read-buildbot-config step. 19:18:20 INFO - ##### 19:18:20 INFO - Running pre-action listener: _resource_record_pre_action 19:18:20 INFO - Running main action method: read_buildbot_config 19:18:20 INFO - Using buildbot properties: 19:18:20 INFO - { 19:18:20 INFO - "properties": { 19:18:20 INFO - "buildnumber": 64, 19:18:20 INFO - "product": "firefox", 19:18:20 INFO - "script_repo_revision": "production", 19:18:20 INFO - "builddir": "fx-team_win7-ix_test-dromaeojs", 19:18:20 INFO - "repository": "", 19:18:20 INFO - "buildername": "Windows 7 32-bit fx-team pgo talos dromaeojs", 19:18:20 INFO - "buildid": "20151021143020", 19:18:20 INFO - "slavename": "t-w732-ix-110", 19:18:20 INFO - "pgo_build": "True", 19:18:20 INFO - "basedir": "C:\\slave\\test-pgo", 19:18:20 INFO - "project": "", 19:18:20 INFO - "platform": "win7-ix", 19:18:20 INFO - "master": "http://buildbot-master111.bb.releng.scl3.mozilla.com:8201/", 19:18:20 INFO - "slavebuilddir": "test", 19:18:20 INFO - "scheduler": "tests-fx-team-win32-pgo-talos", 19:18:20 INFO - "branch": "fx-team", 19:18:20 INFO - "repo_path": "integration/fx-team", 19:18:20 INFO - "stage_platform": "win32-pgo", 19:18:20 INFO - "builduid": "dc0bb898cb9d4f48a796b24f17bb1e3a", 19:18:20 INFO - "revision": "8c36f375d03b0fcd7a8b3f4c1d92a6b4e4f26e0e" 19:18:20 INFO - }, 19:18:20 INFO - "sourcestamp": { 19:18:20 INFO - "repository": "", 19:18:20 INFO - "hasPatch": false, 19:18:20 INFO - "project": "", 19:18:20 INFO - "branch": "fx-team-win32-pgo-talos", 19:18:20 INFO - "changes": [ 19:18:20 INFO - { 19:18:20 INFO - "category": null, 19:18:20 INFO - "files": [ 19:18:20 INFO - { 19:18:20 INFO - "url": null, 19:18:20 INFO - "name": "https://queue.taskcluster.net/v1/task/iqb9Y5auR7eNRES2UQLg3A/artifacts/public/build/firefox-44.0a1.en-US.win32.zip" 19:18:20 INFO - } 19:18:20 INFO - ], 19:18:20 INFO - "repository": "", 19:18:20 INFO - "rev": "8c36f375d03b0fcd7a8b3f4c1d92a6b4e4f26e0e", 19:18:20 INFO - "who": "sendchange", 19:18:20 INFO - "when": 1445479014, 19:18:20 INFO - "number": 6556887, 19:18:20 INFO - "comments": "", 19:18:20 INFO - "project": "", 19:18:20 INFO - "at": "Wed 21 Oct 2015 18:56:54", 19:18:20 INFO - "branch": "fx-team-win32-pgo-talos", 19:18:20 INFO - "revlink": "", 19:18:20 INFO - "properties": [ 19:18:20 INFO - [ 19:18:20 INFO - "buildid", 19:18:20 INFO - "20151021143020", 19:18:20 INFO - "Change" 19:18:20 INFO - ], 19:18:20 INFO - [ 19:18:20 INFO - "builduid", 19:18:20 INFO - "dc0bb898cb9d4f48a796b24f17bb1e3a", 19:18:20 INFO - "Change" 19:18:20 INFO - ], 19:18:20 INFO - [ 19:18:20 INFO - "pgo_build", 19:18:20 INFO - "True", 19:18:20 INFO - "Change" 19:18:20 INFO - ] 19:18:20 INFO - ], 19:18:20 INFO - "revision": "8c36f375d03b0fcd7a8b3f4c1d92a6b4e4f26e0e" 19:18:20 INFO - } 19:18:20 INFO - ], 19:18:20 INFO - "revision": "8c36f375d03b0fcd7a8b3f4c1d92a6b4e4f26e0e" 19:18:20 INFO - } 19:18:20 INFO - } 19:18:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/iqb9Y5auR7eNRES2UQLg3A/artifacts/public/build/firefox-44.0a1.en-US.win32.zip. 19:18:20 INFO - Running post-action listener: _resource_record_post_action 19:18:20 INFO - ##### 19:18:20 INFO - ##### Running download-and-extract step. 19:18:20 INFO - ##### 19:18:20 INFO - Running pre-action listener: _resource_record_pre_action 19:18:20 INFO - Running main action method: download_and_extract 19:18:20 INFO - mkdir: C:\slave\test-pgo\build\tests 19:18: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')]} 19:18:20 INFO - https://queue.taskcluster.net/v1/task/iqb9Y5auR7eNRES2UQLg3A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:18:20 INFO - trying https://queue.taskcluster.net/v1/task/iqb9Y5auR7eNRES2UQLg3A/artifacts/public/build/test_packages.json 19:18:20 INFO - Downloading https://queue.taskcluster.net/v1/task/iqb9Y5auR7eNRES2UQLg3A/artifacts/public/build/test_packages.json to C:\slave\test-pgo\build\test_packages.json 19:18:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/iqb9Y5auR7eNRES2UQLg3A/artifacts/public/build/test_packages.json', 'file_name': 'C:\\slave\\test-pgo\\build\\test_packages.json'}, attempt #1 19:18:22 INFO - Downloaded 1221 bytes. 19:18:22 INFO - Reading from file C:\slave\test-pgo\build\test_packages.json 19:18:22 INFO - Using the following test package requirements: 19:18:22 INFO - {u'common': [u'firefox-44.0a1.en-US.win32.common.tests.zip'], 19:18:22 INFO - u'cppunittest': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 19:18:22 INFO - u'firefox-44.0a1.en-US.win32.cppunittest.tests.zip'], 19:18:22 INFO - u'jittest': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 19:18:22 INFO - u'jsshell-win32.zip'], 19:18:22 INFO - u'mochitest': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 19:18:22 INFO - u'firefox-44.0a1.en-US.win32.mochitest.tests.zip'], 19:18:22 INFO - u'mozbase': [u'firefox-44.0a1.en-US.win32.common.tests.zip'], 19:18:22 INFO - u'reftest': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 19:18:22 INFO - u'firefox-44.0a1.en-US.win32.reftest.tests.zip'], 19:18:22 INFO - u'talos': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 19:18:22 INFO - u'firefox-44.0a1.en-US.win32.talos.tests.zip'], 19:18:22 INFO - u'web-platform': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 19:18:22 INFO - u'firefox-44.0a1.en-US.win32.web-platform.tests.zip'], 19:18:22 INFO - u'webapprt': [u'firefox-44.0a1.en-US.win32.common.tests.zip'], 19:18:22 INFO - u'xpcshell': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 19:18:22 INFO - u'firefox-44.0a1.en-US.win32.xpcshell.tests.zip']} 19:18:22 INFO - Downloading packages: [u'firefox-44.0a1.en-US.win32.common.tests.zip'] for test suite category: common 19:18:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:18:22 INFO - https://queue.taskcluster.net/v1/task/iqb9Y5auR7eNRES2UQLg3A/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip matches https://queue.taskcluster.net 19:18:22 INFO - trying https://queue.taskcluster.net/v1/task/iqb9Y5auR7eNRES2UQLg3A/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip 19:18:22 INFO - Downloading https://queue.taskcluster.net/v1/task/iqb9Y5auR7eNRES2UQLg3A/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 19:18:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/iqb9Y5auR7eNRES2UQLg3A/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 19:18:23 INFO - Downloaded 18001510 bytes. 19:18:23 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 19:18:23 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.common.tests.zip 19:18:23 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win32.common.tests.zip'] with output_timeout 1760 19:18:58 INFO - Return code: 0 19:18:58 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 19:18:58 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')]} 19:18:58 INFO - https://queue.taskcluster.net/v1/task/iqb9Y5auR7eNRES2UQLg3A/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip matches https://queue.taskcluster.net 19:18:58 INFO - trying https://queue.taskcluster.net/v1/task/iqb9Y5auR7eNRES2UQLg3A/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip 19:18:58 INFO - Downloading https://queue.taskcluster.net/v1/task/iqb9Y5auR7eNRES2UQLg3A/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 19:18:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/iqb9Y5auR7eNRES2UQLg3A/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 19:19:00 INFO - Downloaded 18001510 bytes. 19:19:00 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 19:19:00 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.common.tests.zip 19:19:00 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win32.common.tests.zip'] with output_timeout 1760 19:19:24 INFO - Return code: 0 19:19:24 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')]} 19:19:24 INFO - https://queue.taskcluster.net/v1/task/iqb9Y5auR7eNRES2UQLg3A/artifacts/public/build/firefox-44.0a1.en-US.win32.talos.tests.zip matches https://queue.taskcluster.net 19:19:24 INFO - trying https://queue.taskcluster.net/v1/task/iqb9Y5auR7eNRES2UQLg3A/artifacts/public/build/firefox-44.0a1.en-US.win32.talos.tests.zip 19:19:24 INFO - Downloading https://queue.taskcluster.net/v1/task/iqb9Y5auR7eNRES2UQLg3A/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 19:19:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/iqb9Y5auR7eNRES2UQLg3A/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 19:19:26 INFO - Downloaded 11128529 bytes. 19:19:26 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 19:19:26 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.talos.tests.zip 19:19:26 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win32.talos.tests.zip'] with output_timeout 1760 19:19:29 INFO - Return code: 0 19:19:29 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')]} 19:19:29 INFO - https://queue.taskcluster.net/v1/task/iqb9Y5auR7eNRES2UQLg3A/artifacts/public/build/firefox-44.0a1.en-US.win32.zip matches https://queue.taskcluster.net 19:19:29 INFO - trying https://queue.taskcluster.net/v1/task/iqb9Y5auR7eNRES2UQLg3A/artifacts/public/build/firefox-44.0a1.en-US.win32.zip 19:19:29 INFO - Downloading https://queue.taskcluster.net/v1/task/iqb9Y5auR7eNRES2UQLg3A/artifacts/public/build/firefox-44.0a1.en-US.win32.zip to C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.zip 19:19:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/iqb9Y5auR7eNRES2UQLg3A/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 19:19:31 INFO - Downloaded 53728261 bytes. 19:19:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/iqb9Y5auR7eNRES2UQLg3A/artifacts/public/build/firefox-44.0a1.en-US.win32.zip 19:19:31 INFO - mkdir: C:\slave\test-pgo\properties 19:19:31 INFO - Writing buildbot properties ['build_url'] to C:\slave\test-pgo\properties\build_url 19:19:31 INFO - Writing to file C:\slave\test-pgo\properties\build_url 19:19:31 INFO - Contents: 19:19:31 INFO - build_url:https://queue.taskcluster.net/v1/task/iqb9Y5auR7eNRES2UQLg3A/artifacts/public/build/firefox-44.0a1.en-US.win32.zip 19:19:31 INFO - Running post-action listener: _resource_record_post_action 19:19:31 INFO - Running post-action listener: set_extra_try_arguments 19:19:31 INFO - ##### 19:19:31 INFO - ##### Running populate-webroot step. 19:19:31 INFO - ##### 19:19:31 INFO - Running pre-action listener: _resource_record_pre_action 19:19:31 INFO - Running main action method: populate_webroot 19:19:31 INFO - Guessing talos json url... 19:19:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:19:31 INFO - https://queue.taskcluster.net/v1/task/iqb9Y5auR7eNRES2UQLg3A/artifacts/public/build/firefox-44.0a1.en-US.win32.txt matches https://queue.taskcluster.net 19:19:31 INFO - trying https://queue.taskcluster.net/v1/task/iqb9Y5auR7eNRES2UQLg3A/artifacts/public/build/firefox-44.0a1.en-US.win32.txt 19:19:31 INFO - Downloading https://queue.taskcluster.net/v1/task/iqb9Y5auR7eNRES2UQLg3A/artifacts/public/build/firefox-44.0a1.en-US.win32.txt to C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.txt 19:19:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/iqb9Y5auR7eNRES2UQLg3A/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 19:19:32 INFO - Downloaded 103 bytes. 19:19:32 INFO - Reading from file C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.txt 19:19:32 INFO - Contents: 19:19:32 INFO - 20151021143020 19:19:32 INFO - https://hg.mozilla.org/integration/fx-team/rev/8c36f375d03b0fcd7a8b3f4c1d92a6b4e4f26e0e 19:19:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:19:32 INFO - trying https://hg.mozilla.org/integration/fx-team/raw-file/8c36f375d0/testing/talos/talos.json 19:19:32 INFO - Downloading https://hg.mozilla.org/integration/fx-team/raw-file/8c36f375d0/testing/talos/talos.json to C:\slave\test-pgo\build\talos.json 19:19:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/fx-team/raw-file/8c36f375d0/testing/talos/talos.json', 'file_name': 'C:\\slave\\test-pgo\\build\\talos.json'}, attempt #1 19:19:32 INFO - Downloaded 4264 bytes. 19:19:32 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']}, 19:19:32 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']}, 19:19:32 INFO - u'remote-trobocheck2': {u'talos_options': [u'--fennecIDs', 19:19:32 INFO - u'../fennec_ids.txt'], 19:19:32 INFO - u'tests': [u'tcheck2']}, 19:19:32 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome', 19:19:32 INFO - u'--tppagecycles', 19:19:32 INFO - u'7'], 19:19:32 INFO - u'tests': [u'tsvgm']}}, 19:19:32 INFO - u'suites': {u'chromez': {u'tests': [u'tresize', u'tcanvasmark']}, 19:19:32 INFO - u'chromez-e10s': {u'talos_options': [u'--e10s'], 19:19:32 INFO - u'tests': [u'tresize', u'tcanvasmark']}, 19:19:32 INFO - u'dromaeojs': {u'tests': [u'dromaeo_css', u'kraken', u'v8_7']}, 19:19:32 INFO - u'dromaeojs-e10s': {u'talos_options': [u'--e10s'], 19:19:32 INFO - u'tests': [u'dromaeo_css', 19:19:32 INFO - u'kraken', 19:19:32 INFO - u'v8_7']}, 19:19:32 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:19:32 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 19:19:32 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:19:32 INFO - u'talos_options': [u'--e10s'], 19:19:32 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 19:19:32 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:19:32 INFO - u'tests': [u'damp', u'tps']}, 19:19:32 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:19:32 INFO - u'talos_options': [u'--e10s'], 19:19:32 INFO - u'tests': [u'damp', u'tps']}, 19:19:32 INFO - u'g3': {u'tests': [u'dromaeo_dom']}, 19:19:32 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']}, 19:19:32 INFO - u'other': {u'tests': [u'a11yr', 19:19:32 INFO - u'ts_paint', 19:19:32 INFO - u'tpaint', 19:19:32 INFO - u'sessionrestore', 19:19:32 INFO - u'sessionrestore_no_auto_restore']}, 19:19:32 INFO - u'other-e10s': {u'talos_options': [u'--e10s'], 19:19:32 INFO - u'tests': [u'a11yr', 19:19:32 INFO - u'ts_paint', 19:19:32 INFO - u'tpaint', 19:19:32 INFO - u'sessionrestore', 19:19:32 INFO - u'sessionrestore_no_auto_restore']}, 19:19:32 INFO - u'other-e10s_l64': {u'talos_options': [u'--e10s'], 19:19:32 INFO - u'tests': [u'a11yr', 19:19:32 INFO - u'ts_paint', 19:19:32 INFO - u'tpaint', 19:19:32 INFO - u'sessionrestore', 19:19:32 INFO - u'sessionrestore_no_auto_restore']}, 19:19:32 INFO - u'other-e10s_nol64': {u'talos_options': [u'--e10s'], 19:19:32 INFO - u'tests': [u'a11yr', 19:19:32 INFO - u'ts_paint', 19:19:32 INFO - u'tpaint', 19:19:32 INFO - u'sessionrestore', 19:19:32 INFO - u'sessionrestore_no_auto_restore']}, 19:19:32 INFO - u'other_l64': {u'tests': [u'a11yr', 19:19:32 INFO - u'ts_paint', 19:19:32 INFO - u'tpaint', 19:19:32 INFO - u'sessionrestore', 19:19:32 INFO - u'sessionrestore_no_auto_restore']}, 19:19:32 INFO - u'other_nol64': {u'tests': [u'a11yr', 19:19:32 INFO - u'ts_paint', 19:19:32 INFO - u'tpaint', 19:19:32 INFO - u'sessionrestore', 19:19:32 INFO - u'sessionrestore_no_auto_restore']}, 19:19:32 INFO - u'svgr': {u'tests': [u'tsvgx', 19:19:32 INFO - u'tsvgr_opacity', 19:19:32 INFO - u'tart', 19:19:32 INFO - u'tscrollx', 19:19:32 INFO - u'cart']}, 19:19:32 INFO - u'svgr-e10s': {u'talos_options': [u'--e10s'], 19:19:32 INFO - u'tests': [u'tsvgx', 19:19:32 INFO - u'tsvgr_opacity', 19:19:32 INFO - u'tart', 19:19:32 INFO - u'tscrollx', 19:19:32 INFO - u'cart']}, 19:19:32 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:19:32 INFO - u'tests': [u'tp5o']}, 19:19:32 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:19:32 INFO - u'talos_options': [u'--e10s'], 19:19:32 INFO - u'tests': [u'tp5o']}, 19:19:32 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:19:32 INFO - u'talos_options': [u'--xperf_path', 19:19:32 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:19:32 INFO - u'tests': [u'tp5n']}, 19:19:32 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:19:32 INFO - u'talos_options': [u'--e10s', 19:19:32 INFO - u'--xperf_path', 19:19:32 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 19:19:32 INFO - u'C:/slave/talos-data/talos/xperf.config'], 19:19:32 INFO - u'tests': [u'tp5n']}}, 19:19:32 INFO - u'talos.zip': {u'path': u'', 19:19:32 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:19:32 INFO - Running post-action listener: _resource_record_post_action 19:19:32 INFO - ##### 19:19:32 INFO - ##### Running create-virtualenv step. 19:19:32 INFO - ##### 19:19:32 INFO - Running pre-action listener: _resource_record_pre_action 19:19:32 INFO - Running main action method: create_virtualenv 19:19:32 INFO - Creating virtualenv C:\slave\test-pgo\build/venv 19:19:32 INFO - mkdir: C:\slave\test-pgo\build\venv\Scripts 19:19:32 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test-pgo\build\venv\Scripts\python27.dll 19:19:32 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'! 19:19:32 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 19:19:32 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 19:19:42 INFO - New python executable in C:\slave\test-pgo\build/venv\Scripts\python.exe 19:19:46 INFO - Installing distribute......................................................................................................................................................................................done. 19:19:48 INFO - Return code: 0 19:19:48 INFO - Installing pip>=1.5 into virtualenv C:\slave\test-pgo\build/venv 19:19:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:19:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:19:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:48 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 0x01908B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018C8EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0136E8C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01288B48>, '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 0x012AA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01989660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-110', 'USERDOMAIN': 'T-W732-IX-110', '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-110', '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 19:19:48 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 19:19:48 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 19:19:48 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 19:19:48 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 19:19:48 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 19:19:48 INFO - 'COMPUTERNAME': 'T-W732-IX-110', 19:19:48 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 19:19:48 INFO - 'CYGWINBASE': 'C:\\cygwin', 19:19:48 INFO - 'DCLOCATION': 'SCL3', 19:19:48 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 19:19:48 INFO - 'FP_NO_HOST_CHECK': 'NO', 19:19:48 INFO - 'HOMEDRIVE': 'C:', 19:19:48 INFO - 'HOMEPATH': '\\Users\\cltbld', 19:19:48 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 19:19:48 INFO - 'KTS_VERSION': '1.19c', 19:19:48 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 19:19:48 INFO - 'LOGONSERVER': '\\\\T-W732-IX-110', 19:19:48 INFO - 'MONDIR': 'C:\\Monitor_config\\', 19:19:48 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 19:19:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:48 INFO - 'MOZ_NO_REMOTE': '1', 19:19:48 INFO - 'NO_EM_RESTART': '1', 19:19:48 INFO - 'NUMBER_OF_PROCESSORS': '8', 19:19:48 INFO - 'OS': 'Windows_NT', 19:19:48 INFO - 'OURDRIVE': 'C:', 19:19:48 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;', 19:19:48 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 19:19:48 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 19:19:48 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 19:19:48 INFO - 'PROCESSOR_LEVEL': '6', 19:19:48 INFO - 'PROCESSOR_REVISION': '1e05', 19:19:48 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 19:19:48 INFO - 'PROGRAMFILES': 'C:\\Program Files', 19:19:48 INFO - 'PROMPT': '$P$G', 19:19:48 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 19:19:48 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 19:19:48 INFO - 'PUBLIC': 'C:\\Users\\Public', 19:19:48 INFO - 'PWD': 'C:\\slave\\test-pgo', 19:19:48 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 19:19:48 INFO - 'SLAVEDIR': 'C:\\slave\\', 19:19:48 INFO - 'SYSTEMDRIVE': 'C:', 19:19:48 INFO - 'SYSTEMROOT': 'C:\\windows', 19:19:48 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 19:19:48 INFO - 'TEST1': 'testie', 19:19:48 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 19:19:48 INFO - 'USERDOMAIN': 'T-W732-IX-110', 19:19:48 INFO - 'USERNAME': 'cltbld', 19:19:48 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 19:19:48 INFO - 'WINDIR': 'C:\\windows', 19:19:48 INFO - 'WINDOWS_TRACING_FLAGS': '3', 19:19:48 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 19:19:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 19:19:49 INFO - Ignoring indexes: http://pypi.python.org/simple/ 19:19:49 INFO - Downloading/unpacking pip>=1.5 19:19:49 INFO - Creating supposed download cache at C:\slave\test-pgo\build/venv\cache 19:19:53 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 19:19:53 INFO - Running setup.py egg_info for package pip 19:19:53 INFO - warning: no files found matching 'pip\cacert.pem' 19:19:53 INFO - warning: no files found matching '*.html' under directory 'docs' 19:19:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 19:19:53 INFO - no previously-included directories found matching 'docs\_build\_sources' 19:19:53 INFO - Installing collected packages: pip 19:19:53 INFO - Found existing installation: pip 0.8.2 19:19:53 INFO - Uninstalling pip: 19:19:53 INFO - Successfully uninstalled pip 19:19:53 INFO - Running setup.py install for pip 19:19:53 INFO - warning: no files found matching 'pip\cacert.pem' 19:19:53 INFO - warning: no files found matching '*.html' under directory 'docs' 19:19:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 19:19:53 INFO - no previously-included directories found matching 'docs\_build\_sources' 19:19:53 INFO - Installing pip-script.py script to C:\slave\test-pgo\build\venv\Scripts 19:19:53 INFO - Installing pip.exe script to C:\slave\test-pgo\build\venv\Scripts 19:19:53 INFO - Installing pip2.7-script.py script to C:\slave\test-pgo\build\venv\Scripts 19:19:53 INFO - Installing pip2.7.exe script to C:\slave\test-pgo\build\venv\Scripts 19:19:53 INFO - Installing pip2-script.py script to C:\slave\test-pgo\build\venv\Scripts 19:19:53 INFO - Installing pip2.exe script to C:\slave\test-pgo\build\venv\Scripts 19:19:53 INFO - Successfully installed pip 19:19:53 INFO - Cleaning up... 19:19:53 INFO - Return code: 0 19:19:53 INFO - Installing psutil>=0.7.1 into virtualenv C:\slave\test-pgo\build/venv 19:19:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:19:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:19:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:53 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 0x01908B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018C8EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0136E8C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01288B48>, '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 0x012AA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01989660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-110', 'USERDOMAIN': 'T-W732-IX-110', '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-110', '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 19:19:53 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 19:19:53 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 19:19:53 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 19:19:53 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 19:19:53 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 19:19:53 INFO - 'COMPUTERNAME': 'T-W732-IX-110', 19:19:53 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 19:19:53 INFO - 'CYGWINBASE': 'C:\\cygwin', 19:19:53 INFO - 'DCLOCATION': 'SCL3', 19:19:53 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 19:19:53 INFO - 'FP_NO_HOST_CHECK': 'NO', 19:19:53 INFO - 'HOMEDRIVE': 'C:', 19:19:53 INFO - 'HOMEPATH': '\\Users\\cltbld', 19:19:53 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 19:19:53 INFO - 'KTS_VERSION': '1.19c', 19:19:53 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 19:19:53 INFO - 'LOGONSERVER': '\\\\T-W732-IX-110', 19:19:53 INFO - 'MONDIR': 'C:\\Monitor_config\\', 19:19:53 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 19:19:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:53 INFO - 'MOZ_NO_REMOTE': '1', 19:19:53 INFO - 'NO_EM_RESTART': '1', 19:19:53 INFO - 'NUMBER_OF_PROCESSORS': '8', 19:19:53 INFO - 'OS': 'Windows_NT', 19:19:53 INFO - 'OURDRIVE': 'C:', 19:19:53 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;', 19:19:53 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 19:19:53 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 19:19:53 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 19:19:53 INFO - 'PROCESSOR_LEVEL': '6', 19:19:53 INFO - 'PROCESSOR_REVISION': '1e05', 19:19:53 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 19:19:53 INFO - 'PROGRAMFILES': 'C:\\Program Files', 19:19:53 INFO - 'PROMPT': '$P$G', 19:19:53 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 19:19:53 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 19:19:53 INFO - 'PUBLIC': 'C:\\Users\\Public', 19:19:53 INFO - 'PWD': 'C:\\slave\\test-pgo', 19:19:53 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 19:19:53 INFO - 'SLAVEDIR': 'C:\\slave\\', 19:19:53 INFO - 'SYSTEMDRIVE': 'C:', 19:19:53 INFO - 'SYSTEMROOT': 'C:\\windows', 19:19:53 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 19:19:53 INFO - 'TEST1': 'testie', 19:19:53 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 19:19:53 INFO - 'USERDOMAIN': 'T-W732-IX-110', 19:19:53 INFO - 'USERNAME': 'cltbld', 19:19:53 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 19:19:53 INFO - 'WINDIR': 'C:\\windows', 19:19:53 INFO - 'WINDOWS_TRACING_FLAGS': '3', 19:19:53 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 19:19:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 19:19:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:55 INFO - Downloading/unpacking psutil>=0.7.1 19:19:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:19:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:19:56 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 19:19:56 INFO - Installing collected packages: psutil 19:19:56 INFO - Successfully installed psutil 19:19:56 INFO - Cleaning up... 19:19:57 INFO - Return code: 0 19:19:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv C:\slave\test-pgo\build/venv 19:19:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:19:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:57 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x01908B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018C8EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0136E8C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01288B48>, '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 0x012AA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01989660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-110', 'USERDOMAIN': 'T-W732-IX-110', '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-110', '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 19:19:57 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in C:\slave\test-pgo\build 19:19:57 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --download-cache C:\slave\test-pgo\build/venv\cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 19:19:57 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 19:19:57 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 19:19:57 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 19:19:57 INFO - 'COMPUTERNAME': 'T-W732-IX-110', 19:19:57 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 19:19:57 INFO - 'CYGWINBASE': 'C:\\cygwin', 19:19:57 INFO - 'DCLOCATION': 'SCL3', 19:19:57 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 19:19:57 INFO - 'FP_NO_HOST_CHECK': 'NO', 19:19:57 INFO - 'HOMEDRIVE': 'C:', 19:19:57 INFO - 'HOMEPATH': '\\Users\\cltbld', 19:19:57 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 19:19:57 INFO - 'KTS_VERSION': '1.19c', 19:19:57 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 19:19:57 INFO - 'LOGONSERVER': '\\\\T-W732-IX-110', 19:19:57 INFO - 'MONDIR': 'C:\\Monitor_config\\', 19:19:57 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 19:19:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:57 INFO - 'MOZ_NO_REMOTE': '1', 19:19:57 INFO - 'NO_EM_RESTART': '1', 19:19:57 INFO - 'NUMBER_OF_PROCESSORS': '8', 19:19:57 INFO - 'OS': 'Windows_NT', 19:19:57 INFO - 'OURDRIVE': 'C:', 19:19:57 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;', 19:19:57 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 19:19:57 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 19:19:57 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 19:19:57 INFO - 'PROCESSOR_LEVEL': '6', 19:19:57 INFO - 'PROCESSOR_REVISION': '1e05', 19:19:57 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 19:19:57 INFO - 'PROGRAMFILES': 'C:\\Program Files', 19:19:57 INFO - 'PROMPT': '$P$G', 19:19:57 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 19:19:57 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 19:19:57 INFO - 'PUBLIC': 'C:\\Users\\Public', 19:19:57 INFO - 'PWD': 'C:\\slave\\test-pgo', 19:19:57 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 19:19:57 INFO - 'SLAVEDIR': 'C:\\slave\\', 19:19:57 INFO - 'SYSTEMDRIVE': 'C:', 19:19:57 INFO - 'SYSTEMROOT': 'C:\\windows', 19:19:57 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 19:19:57 INFO - 'TEST1': 'testie', 19:19:57 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 19:19:57 INFO - 'USERDOMAIN': 'T-W732-IX-110', 19:19:57 INFO - 'USERNAME': 'cltbld', 19:19:57 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 19:19:57 INFO - 'WINDIR': 'C:\\windows', 19:19:57 INFO - 'WINDOWS_TRACING_FLAGS': '3', 19:19:57 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 19:19:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 19:19:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:19:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:19:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:19:58 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 19:19:58 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor 19:19:58 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) 19:19:58 INFO - Installing collected packages: mozsystemmonitor 19:19:58 INFO - Running setup.py install for mozsystemmonitor 19:19:58 INFO - Successfully installed mozsystemmonitor 19:19:58 INFO - Cleaning up... 19:19:59 INFO - Return code: 0 19:19:59 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test-pgo\build/venv 19:19:59 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')]} 19:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:59 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')]} 19:19:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:59 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 0x01908B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018C8EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0136E8C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01288B48>, '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 0x012AA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01989660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-110', 'USERDOMAIN': 'T-W732-IX-110', '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-110', '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 19:19:59 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 19:19:59 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 19:19:59 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 19:19:59 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 19:19:59 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 19:19:59 INFO - 'COMPUTERNAME': 'T-W732-IX-110', 19:19:59 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 19:19:59 INFO - 'CYGWINBASE': 'C:\\cygwin', 19:19:59 INFO - 'DCLOCATION': 'SCL3', 19:19:59 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 19:19:59 INFO - 'FP_NO_HOST_CHECK': 'NO', 19:19:59 INFO - 'HOMEDRIVE': 'C:', 19:19:59 INFO - 'HOMEPATH': '\\Users\\cltbld', 19:19:59 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 19:19:59 INFO - 'KTS_VERSION': '1.19c', 19:19:59 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 19:19:59 INFO - 'LOGONSERVER': '\\\\T-W732-IX-110', 19:19:59 INFO - 'MONDIR': 'C:\\Monitor_config\\', 19:19:59 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 19:19:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:59 INFO - 'MOZ_NO_REMOTE': '1', 19:19:59 INFO - 'NO_EM_RESTART': '1', 19:19:59 INFO - 'NUMBER_OF_PROCESSORS': '8', 19:19:59 INFO - 'OS': 'Windows_NT', 19:19:59 INFO - 'OURDRIVE': 'C:', 19:19:59 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;', 19:19:59 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 19:19:59 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 19:19:59 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 19:19:59 INFO - 'PROCESSOR_LEVEL': '6', 19:19:59 INFO - 'PROCESSOR_REVISION': '1e05', 19:19:59 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 19:19:59 INFO - 'PROGRAMFILES': 'C:\\Program Files', 19:19:59 INFO - 'PROMPT': '$P$G', 19:19:59 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 19:19:59 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 19:19:59 INFO - 'PUBLIC': 'C:\\Users\\Public', 19:19:59 INFO - 'PWD': 'C:\\slave\\test-pgo', 19:19:59 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 19:19:59 INFO - 'SLAVEDIR': 'C:\\slave\\', 19:19:59 INFO - 'SYSTEMDRIVE': 'C:', 19:19:59 INFO - 'SYSTEMROOT': 'C:\\windows', 19:19:59 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 19:19:59 INFO - 'TEST1': 'testie', 19:19:59 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 19:19:59 INFO - 'USERDOMAIN': 'T-W732-IX-110', 19:19:59 INFO - 'USERNAME': 'cltbld', 19:19:59 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 19:19:59 INFO - 'WINDIR': 'C:\\windows', 19:19:59 INFO - 'WINDOWS_TRACING_FLAGS': '3', 19:19:59 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 19:19:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 19:19:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:59 INFO - Downloading/unpacking blobuploader==1.2.4 19:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:19:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:20:00 INFO - Downloading blobuploader-1.2.4.tar.gz 19:20:00 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 19:20:00 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader 19:20:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:20:01 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 19:20:01 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 19:20:01 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 19:20:01 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\requests\setup.py) egg_info for package requests 19:20:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:20:01 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 19:20:01 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 19:20:01 INFO - Downloading docopt-0.6.1.tar.gz 19:20:01 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 19:20:01 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\docopt\setup.py) egg_info for package docopt 19:20:01 INFO - Installing collected packages: blobuploader, requests, docopt 19:20:01 INFO - Running setup.py install for blobuploader 19:20:02 INFO - Running setup.py install for requests 19:20:02 INFO - Running setup.py install for docopt 19:20:02 INFO - Successfully installed blobuploader requests docopt 19:20:02 INFO - Cleaning up... 19:20:03 INFO - Return code: 0 19:20:03 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv 19:20: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')]} 19:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:20: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')]} 19:20:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:20:03 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 0x01908B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018C8EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0136E8C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01288B48>, '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 0x012AA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01989660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-110', 'USERDOMAIN': 'T-W732-IX-110', '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-110', '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 19:20:04 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 19:20:04 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 19:20:04 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 19:20:04 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 19:20:04 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 19:20:04 INFO - 'COMPUTERNAME': 'T-W732-IX-110', 19:20:04 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 19:20:04 INFO - 'CYGWINBASE': 'C:\\cygwin', 19:20:04 INFO - 'DCLOCATION': 'SCL3', 19:20:04 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 19:20:04 INFO - 'FP_NO_HOST_CHECK': 'NO', 19:20:04 INFO - 'HOMEDRIVE': 'C:', 19:20:04 INFO - 'HOMEPATH': '\\Users\\cltbld', 19:20:04 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 19:20:04 INFO - 'KTS_VERSION': '1.19c', 19:20:04 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 19:20:04 INFO - 'LOGONSERVER': '\\\\T-W732-IX-110', 19:20:04 INFO - 'MONDIR': 'C:\\Monitor_config\\', 19:20:04 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 19:20:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:20:04 INFO - 'MOZ_NO_REMOTE': '1', 19:20:04 INFO - 'NO_EM_RESTART': '1', 19:20:04 INFO - 'NUMBER_OF_PROCESSORS': '8', 19:20:04 INFO - 'OS': 'Windows_NT', 19:20:04 INFO - 'OURDRIVE': 'C:', 19:20:04 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 19:20:04 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 19:20:04 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 19:20:04 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 19:20:04 INFO - 'PROCESSOR_LEVEL': '6', 19:20:04 INFO - 'PROCESSOR_REVISION': '1e05', 19:20:04 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 19:20:04 INFO - 'PROGRAMFILES': 'C:\\Program Files', 19:20:04 INFO - 'PROMPT': '$P$G', 19:20:04 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 19:20:04 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 19:20:04 INFO - 'PUBLIC': 'C:\\Users\\Public', 19:20:04 INFO - 'PWD': 'C:\\slave\\test-pgo', 19:20:04 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 19:20:04 INFO - 'SLAVEDIR': 'C:\\slave\\', 19:20:04 INFO - 'SYSTEMDRIVE': 'C:', 19:20:04 INFO - 'SYSTEMROOT': 'C:\\windows', 19:20:04 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 19:20:04 INFO - 'TEST1': 'testie', 19:20:04 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 19:20:04 INFO - 'USERDOMAIN': 'T-W732-IX-110', 19:20:04 INFO - 'USERNAME': 'cltbld', 19:20:04 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 19:20:04 INFO - 'WINDIR': 'C:\\windows', 19:20:04 INFO - 'WINDOWS_TRACING_FLAGS': '3', 19:20:04 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 19:20:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 19:20:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:20:04 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\manifestparser 19:20:04 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-l9yeqc-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/manifestparser 19:20:04 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozcrash 19:20:04 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-jyoxdn-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozcrash 19:20:04 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdebug 19:20:04 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-mo9_pd-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdebug 19:20:04 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdevice 19:20:04 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-rv3jtt-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdevice 19:20:04 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozfile 19:20:05 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-yzxzw7-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozfile 19:20:05 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozhttpd 19:20:05 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-vaviyj-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozhttpd 19:20:05 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinfo 19:20:05 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-j0iqhp-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinfo 19:20:05 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinstall 19:20:05 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-gbdfsj-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinstall 19:20:05 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozleak 19:20:05 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-kacar2-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozleak 19:20:05 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozlog 19:20:05 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-9tdm8s-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozlog 19:20:05 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moznetwork 19:20:05 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-bfz51z-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moznetwork 19:20:05 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprocess 19:20:05 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-ctboob-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprocess 19:20:06 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprofile 19:20:06 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-8swm3s-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprofile 19:20:06 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozrunner 19:20:06 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-gt6lst-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozrunner 19:20:06 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozscreenshot 19:20:06 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-vxbjsi-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:20:06 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moztest 19:20:06 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-kqii_k-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moztest 19:20:07 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozversion 19:20:07 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-971l5z-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozversion 19:20:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:20:07 INFO - Running setup.py install for manifestparser 19:20:07 INFO - Installing manifestparser-script.py script to C:\slave\test-pgo\build\venv\Scripts 19:20:07 INFO - Installing manifestparser.exe script to C:\slave\test-pgo\build\venv\Scripts 19:20:07 INFO - Running setup.py install for mozcrash 19:20:08 INFO - Running setup.py install for mozdebug 19:20:08 INFO - Running setup.py install for mozdevice 19:20:08 INFO - Installing sutini-script.py script to C:\slave\test-pgo\build\venv\Scripts 19:20:08 INFO - Installing sutini.exe script to C:\slave\test-pgo\build\venv\Scripts 19:20:08 INFO - Installing dm-script.py script to C:\slave\test-pgo\build\venv\Scripts 19:20:08 INFO - Installing dm.exe script to C:\slave\test-pgo\build\venv\Scripts 19:20:09 INFO - Running setup.py install for mozfile 19:20:09 INFO - Running setup.py install for mozhttpd 19:20:09 INFO - Installing mozhttpd-script.py script to C:\slave\test-pgo\build\venv\Scripts 19:20:09 INFO - Installing mozhttpd.exe script to C:\slave\test-pgo\build\venv\Scripts 19:20:09 INFO - Running setup.py install for mozinfo 19:20:10 INFO - Installing mozinfo-script.py script to C:\slave\test-pgo\build\venv\Scripts 19:20:10 INFO - Installing mozinfo.exe script to C:\slave\test-pgo\build\venv\Scripts 19:20:10 INFO - Running setup.py install for mozInstall 19:20:10 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test-pgo\build\venv\Scripts 19:20:10 INFO - Installing moz_remove_from_system.exe script to C:\slave\test-pgo\build\venv\Scripts 19:20:10 INFO - Installing mozuninstall-script.py script to C:\slave\test-pgo\build\venv\Scripts 19:20:10 INFO - Installing mozuninstall.exe script to C:\slave\test-pgo\build\venv\Scripts 19:20:10 INFO - Installing mozinstall-script.py script to C:\slave\test-pgo\build\venv\Scripts 19:20:10 INFO - Installing mozinstall.exe script to C:\slave\test-pgo\build\venv\Scripts 19:20:10 INFO - Installing moz_add_to_system-script.py script to C:\slave\test-pgo\build\venv\Scripts 19:20:10 INFO - Installing moz_add_to_system.exe script to C:\slave\test-pgo\build\venv\Scripts 19:20:10 INFO - Running setup.py install for mozleak 19:20:10 INFO - Running setup.py install for mozlog 19:20:11 INFO - Installing structlog-script.py script to C:\slave\test-pgo\build\venv\Scripts 19:20:11 INFO - Installing structlog.exe script to C:\slave\test-pgo\build\venv\Scripts 19:20:11 INFO - Running setup.py install for moznetwork 19:20:11 INFO - Installing moznetwork-script.py script to C:\slave\test-pgo\build\venv\Scripts 19:20:11 INFO - Installing moznetwork.exe script to C:\slave\test-pgo\build\venv\Scripts 19:20:12 INFO - Running setup.py install for mozprocess 19:20:12 INFO - Running setup.py install for mozprofile 19:20:12 INFO - Installing mozprofile-script.py script to C:\slave\test-pgo\build\venv\Scripts 19:20:12 INFO - Installing mozprofile.exe script to C:\slave\test-pgo\build\venv\Scripts 19:20:12 INFO - Installing diff-profiles-script.py script to C:\slave\test-pgo\build\venv\Scripts 19:20:12 INFO - Installing diff-profiles.exe script to C:\slave\test-pgo\build\venv\Scripts 19:20:12 INFO - Installing view-profile-script.py script to C:\slave\test-pgo\build\venv\Scripts 19:20:12 INFO - Installing view-profile.exe script to C:\slave\test-pgo\build\venv\Scripts 19:20:13 INFO - Running setup.py install for mozrunner 19:20:13 INFO - Installing mozrunner-script.py script to C:\slave\test-pgo\build\venv\Scripts 19:20:13 INFO - Installing mozrunner.exe script to C:\slave\test-pgo\build\venv\Scripts 19:20:13 INFO - Running setup.py install for mozscreenshot 19:20:14 INFO - Running setup.py install for moztest 19:20:14 INFO - Running setup.py install for mozversion 19:20:14 INFO - Installing mozversion-script.py script to C:\slave\test-pgo\build\venv\Scripts 19:20:14 INFO - Installing mozversion.exe script to C:\slave\test-pgo\build\venv\Scripts 19:20:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:20:15 INFO - Cleaning up... 19:20:15 INFO - Return code: 0 19:20:15 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv 19:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:20:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:20:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:20:15 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 0x01908B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018C8EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0136E8C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01288B48>, '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 0x012AA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01989660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-110', 'USERDOMAIN': 'T-W732-IX-110', '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-110', '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 19:20:15 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 19:20:15 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 19:20:15 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 19:20:15 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 19:20:15 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 19:20:15 INFO - 'COMPUTERNAME': 'T-W732-IX-110', 19:20:15 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 19:20:15 INFO - 'CYGWINBASE': 'C:\\cygwin', 19:20:15 INFO - 'DCLOCATION': 'SCL3', 19:20:15 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 19:20:15 INFO - 'FP_NO_HOST_CHECK': 'NO', 19:20:15 INFO - 'HOMEDRIVE': 'C:', 19:20:15 INFO - 'HOMEPATH': '\\Users\\cltbld', 19:20:15 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 19:20:15 INFO - 'KTS_VERSION': '1.19c', 19:20:15 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 19:20:15 INFO - 'LOGONSERVER': '\\\\T-W732-IX-110', 19:20:15 INFO - 'MONDIR': 'C:\\Monitor_config\\', 19:20:15 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 19:20:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:20:15 INFO - 'MOZ_NO_REMOTE': '1', 19:20:15 INFO - 'NO_EM_RESTART': '1', 19:20:15 INFO - 'NUMBER_OF_PROCESSORS': '8', 19:20:15 INFO - 'OS': 'Windows_NT', 19:20:15 INFO - 'OURDRIVE': 'C:', 19:20:15 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;', 19:20:15 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 19:20:15 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 19:20:15 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 19:20:15 INFO - 'PROCESSOR_LEVEL': '6', 19:20:15 INFO - 'PROCESSOR_REVISION': '1e05', 19:20:15 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 19:20:15 INFO - 'PROGRAMFILES': 'C:\\Program Files', 19:20:15 INFO - 'PROMPT': '$P$G', 19:20:15 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 19:20:15 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 19:20:15 INFO - 'PUBLIC': 'C:\\Users\\Public', 19:20:15 INFO - 'PWD': 'C:\\slave\\test-pgo', 19:20:15 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 19:20:15 INFO - 'SLAVEDIR': 'C:\\slave\\', 19:20:15 INFO - 'SYSTEMDRIVE': 'C:', 19:20:15 INFO - 'SYSTEMROOT': 'C:\\windows', 19:20:15 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 19:20:15 INFO - 'TEST1': 'testie', 19:20:15 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 19:20:15 INFO - 'USERDOMAIN': 'T-W732-IX-110', 19:20:15 INFO - 'USERNAME': 'cltbld', 19:20:15 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 19:20:15 INFO - 'WINDIR': 'C:\\windows', 19:20:15 INFO - 'WINDOWS_TRACING_FLAGS': '3', 19:20:15 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 19:20:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 19:20:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:20:15 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\manifestparser 19:20:15 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-u4u5of-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/manifestparser 19:20:15 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)) 19:20:15 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozcrash 19:20:15 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-6qpme5-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozcrash 19:20:15 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)) 19:20:15 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdebug 19:20:15 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-nwj5au-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdebug 19:20:15 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)) 19:20:15 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdevice 19:20:16 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-9fvfcr-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdevice 19:20:16 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)) 19:20:16 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozfile 19:20:16 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-23temb-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozfile 19:20:16 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)) 19:20:16 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozhttpd 19:20:16 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-i8_kdt-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozhttpd 19:20:16 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)) 19:20:16 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinfo 19:20:16 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-gdiocf-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinfo 19:20:16 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)) 19:20:16 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinstall 19:20:16 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-uiwz1x-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinstall 19:20:16 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)) 19:20:16 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozleak 19:20:16 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-znykrj-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozleak 19:20:17 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)) 19:20:17 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozlog 19:20:17 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-pp2aqo-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozlog 19:20:17 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)) 19:20:17 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moznetwork 19:20:17 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-jwdf4s-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moznetwork 19:20:17 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)) 19:20:17 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprocess 19:20:17 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-1b2p5z-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprocess 19:20:17 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)) 19:20:17 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprofile 19:20:17 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-rotdne-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprofile 19:20:17 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)) 19:20:17 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozrunner 19:20:17 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-iyqfkt-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozrunner 19:20:17 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)) 19:20:17 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozscreenshot 19:20:17 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-zj_01e-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:20:17 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)) 19:20:17 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moztest 19:20:17 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-vqbfyg-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moztest 19:20:18 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)) 19:20:18 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozversion 19:20:18 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-stw8mm-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozversion 19:20:18 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)) 19:20:18 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)) 19:20:18 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)) 19:20:18 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)) 19:20:18 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)) 19:20:18 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)) 19:20:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 10)) 19:20: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 19:20: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 19:20:19 INFO - Downloading blessings-1.5.1.tar.gz 19:20:19 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 19:20:19 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\blessings\setup.py) egg_info for package blessings 19:20:19 INFO - Installing collected packages: blessings 19:20:19 INFO - Running setup.py install for blessings 19:20:19 INFO - Successfully installed blessings 19:20:19 INFO - Cleaning up... 19:20:22 INFO - Return code: 0 19:20:22 INFO - Done creating virtualenv C:\slave\test-pgo\build/venv. 19:20:22 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'freeze'] 19:20:22 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip freeze 19:20:22 INFO - Reading from file tmpfile_stdout 19:20:22 INFO - Using _rmtree_windows ... 19:20:22 INFO - Using _rmtree_windows ... 19:20:22 INFO - Current package versions: 19:20:22 INFO - blessings == 1.5.1 19:20:22 INFO - blobuploader == 1.2.4 19:20:22 INFO - docopt == 0.6.1 19:20:22 INFO - manifestparser == 1.1 19:20:22 INFO - mozInstall == 1.12 19:20:22 INFO - mozcrash == 0.16 19:20:22 INFO - mozdebug == 0.1 19:20:22 INFO - mozdevice == 0.46 19:20:22 INFO - mozfile == 1.2 19:20:22 INFO - mozhttpd == 0.7 19:20:22 INFO - mozinfo == 0.8 19:20:22 INFO - mozleak == 0.1 19:20:22 INFO - mozlog == 3.0 19:20:22 INFO - moznetwork == 0.27 19:20:22 INFO - mozprocess == 0.22 19:20:22 INFO - mozprofile == 0.27 19:20:22 INFO - mozrunner == 6.10 19:20:22 INFO - mozscreenshot == 0.1 19:20:22 INFO - mozsystemmonitor == 0.0 19:20:22 INFO - moztest == 0.7 19:20:22 INFO - mozversion == 1.4 19:20:22 INFO - psutil == 3.1.1 19:20:22 INFO - requests == 1.2.3 19:20:22 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv 19:20:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:20:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:20:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:20:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:20:22 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '-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 0x01908B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x018C8EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0136E8C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01288B48>, '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 0x012AA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01989660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build\\tests\\talos', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-110', 'USERDOMAIN': 'T-W732-IX-110', '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-110', '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 19:20:22 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 19:20:22 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 19:20:22 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 19:20:22 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 19:20:22 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 19:20:22 INFO - 'COMPUTERNAME': 'T-W732-IX-110', 19:20:22 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 19:20:22 INFO - 'CYGWINBASE': 'C:\\cygwin', 19:20:22 INFO - 'DCLOCATION': 'SCL3', 19:20:22 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 19:20:22 INFO - 'FP_NO_HOST_CHECK': 'NO', 19:20:22 INFO - 'HOMEDRIVE': 'C:', 19:20:22 INFO - 'HOMEPATH': '\\Users\\cltbld', 19:20:22 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 19:20:22 INFO - 'KTS_VERSION': '1.19c', 19:20:22 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 19:20:22 INFO - 'LOGONSERVER': '\\\\T-W732-IX-110', 19:20:22 INFO - 'MONDIR': 'C:\\Monitor_config\\', 19:20:22 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 19:20:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:20:22 INFO - 'MOZ_NO_REMOTE': '1', 19:20:22 INFO - 'NO_EM_RESTART': '1', 19:20:22 INFO - 'NUMBER_OF_PROCESSORS': '8', 19:20:22 INFO - 'OS': 'Windows_NT', 19:20:22 INFO - 'OURDRIVE': 'C:', 19:20:22 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 19:20:22 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 19:20:22 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 19:20:22 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 19:20:22 INFO - 'PROCESSOR_LEVEL': '6', 19:20:22 INFO - 'PROCESSOR_REVISION': '1e05', 19:20:22 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 19:20:22 INFO - 'PROGRAMFILES': 'C:\\Program Files', 19:20:22 INFO - 'PROMPT': '$P$G', 19:20:22 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 19:20:22 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 19:20:22 INFO - 'PUBLIC': 'C:\\Users\\Public', 19:20:22 INFO - 'PWD': 'C:\\slave\\test-pgo', 19:20:22 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 19:20:22 INFO - 'SLAVEDIR': 'C:\\slave\\', 19:20:22 INFO - 'SYSTEMDRIVE': 'C:', 19:20:22 INFO - 'SYSTEMROOT': 'C:\\windows', 19:20:22 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 19:20:22 INFO - 'TEST1': 'testie', 19:20:22 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 19:20:22 INFO - 'USERDOMAIN': 'T-W732-IX-110', 19:20:22 INFO - 'USERNAME': 'cltbld', 19:20:22 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 19:20:22 INFO - 'WINDIR': 'C:\\windows', 19:20:22 INFO - 'WINDOWS_TRACING_FLAGS': '3', 19:20:22 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 19:20:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 19:20:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:20:23 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)) 19:20:23 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)) 19:20:23 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)) 19:20:23 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)) 19:20:23 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)) 19:20:23 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)) 19:20:23 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)) 19:20:23 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)) 19:20:23 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)) 19:20:23 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)) 19:20:23 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)) 19:20:23 INFO - Cleaning up... 19:20:23 INFO - Return code: 0 19:20:23 INFO - Running post-action listener: _resource_record_post_action 19:20:23 INFO - Running post-action listener: _start_resource_monitoring 19:20:23 INFO - Starting resource monitoring. 19:20:23 INFO - ##### 19:20:23 INFO - ##### Running install step. 19:20:23 INFO - ##### 19:20:23 INFO - Running pre-action listener: _resource_record_pre_action 19:20:23 INFO - Running main action method: install 19:20:23 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'freeze'] 19:20:23 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip freeze 19:20:23 INFO - Reading from file tmpfile_stdout 19:20:23 INFO - Using _rmtree_windows ... 19:20:23 INFO - Using _rmtree_windows ... 19:20:23 INFO - Detecting whether we're running mozinstall >=1.0... 19:20:23 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build/venv/scripts/python', 'C:\\slave\\test-pgo\\build/venv/scripts/mozinstall-script.py', '-h'] 19:20:23 INFO - Copy/paste: C:\slave\test-pgo\build/venv/scripts/python C:\slave\test-pgo\build/venv/scripts/mozinstall-script.py -h 19:20:23 INFO - Reading from file tmpfile_stdout 19:20:23 INFO - Output received: 19:20:23 INFO - Usage: mozinstall-script.py [options] installer 19:20:23 INFO - Options: 19:20:23 INFO - -h, --help show this help message and exit 19:20:23 INFO - -d DEST, --destination=DEST 19:20:23 INFO - Directory to install application into. [default: 19:20:23 INFO - "C:\slave\test-pgo"] 19:20:23 INFO - --app=APP Application being installed. [default: firefox] 19:20:23 INFO - Using _rmtree_windows ... 19:20:23 INFO - Using _rmtree_windows ... 19:20:23 INFO - mkdir: C:\slave\test-pgo\build\application 19:20:23 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'] 19:20:23 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 19:20:25 INFO - Reading from file tmpfile_stdout 19:20:25 INFO - Output received: 19:20:25 INFO - C:\slave\test-pgo\build\application\firefox\firefox.exe 19:20:25 INFO - Using _rmtree_windows ... 19:20:25 INFO - Using _rmtree_windows ... 19:20:25 INFO - Running post-action listener: _resource_record_post_action 19:20:25 INFO - ##### 19:20:25 INFO - ##### Running run-tests step. 19:20:25 INFO - ##### 19:20:25 INFO - Running pre-action listener: _resource_record_pre_action 19:20:25 INFO - Running main action method: run_tests 19:20:25 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\python', '--version'] 19:20:25 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\python --version 19:20:25 INFO - Python 2.7.3 19:20:25 INFO - Return code: 0 19:20:25 INFO - grabbing minidump binary from tooltool 19:20: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')]} 19:20:25 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 0x01288B48>, '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 0x012AA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01989660>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'privileged': False}, attempt #1 19:20:25 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 19:20:25 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 19:20:25 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 19:20:27 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test-pgo\build\tmp_7zdbb 19:20:27 INFO - INFO - File integrity verified, renaming tmp_7zdbb to win32-minidump_stackwalk.exe 19:20:27 INFO - Return code: 0 19:20:27 INFO - Chmoding C:\slave\test-pgo\build\win32-minidump_stackwalk.exe to 0755 19:20:27 INFO - mkdir: C:\slave\test-pgo\build\blobber_upload_dir 19:20:27 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test-pgo\build\blobber_upload_dir 19:20:27 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test-pgo\build\win32-minidump_stackwalk.exe 19:20:27 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test-pgo\build\blobber_upload_dir 19:20:27 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\python', 'C:\\slave\\test-pgo\\build\\tests\\talos\\talos\\run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test-pgo\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/iqb9Y5auR7eNRES2UQLg3A/artifacts/public/build/firefox-44.0a1.en-US.win32.crashreporter-symbols.zip', '--title', 'T-W732-IX-110', '--webServer', 'localhost'] in C:\slave\test-pgo\build 19:20:27 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\python C:\slave\test-pgo\build\tests\talos\talos\run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath C:\slave\test-pgo\build\application\firefox\firefox --symbolsPath https://queue.taskcluster.net/v1/task/iqb9Y5auR7eNRES2UQLg3A/artifacts/public/build/firefox-44.0a1.en-US.win32.crashreporter-symbols.zip --title T-W732-IX-110 --webServer localhost 19:20:27 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 19:20:27 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 19:20:27 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 19:20:27 INFO - 'COMPUTERNAME': 'T-W732-IX-110', 19:20:27 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 19:20:27 INFO - 'CYGWINBASE': 'C:\\cygwin', 19:20:27 INFO - 'DCLOCATION': 'SCL3', 19:20:27 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 19:20:27 INFO - 'FP_NO_HOST_CHECK': 'NO', 19:20:27 INFO - 'HOMEDRIVE': 'C:', 19:20:27 INFO - 'HOMEPATH': '\\Users\\cltbld', 19:20:27 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 19:20:27 INFO - 'KTS_VERSION': '1.19c', 19:20:27 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 19:20:27 INFO - 'LOGONSERVER': '\\\\T-W732-IX-110', 19:20:27 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test-pgo\\build\\blobber_upload_dir', 19:20:27 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test-pgo\\build\\win32-minidump_stackwalk.exe', 19:20:27 INFO - 'MONDIR': 'C:\\Monitor_config\\', 19:20:27 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 19:20:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:20:27 INFO - 'MOZ_NO_REMOTE': '1', 19:20:27 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test-pgo\\build\\blobber_upload_dir', 19:20:27 INFO - 'NO_EM_RESTART': '1', 19:20:27 INFO - 'NUMBER_OF_PROCESSORS': '8', 19:20:27 INFO - 'OS': 'Windows_NT', 19:20:27 INFO - 'OURDRIVE': 'C:', 19:20:27 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;', 19:20:27 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 19:20:27 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 19:20:27 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 19:20:27 INFO - 'PROCESSOR_LEVEL': '6', 19:20:27 INFO - 'PROCESSOR_REVISION': '1e05', 19:20:27 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 19:20:27 INFO - 'PROGRAMFILES': 'C:\\Program Files', 19:20:27 INFO - 'PROMPT': '$P$G', 19:20:27 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 19:20:27 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 19:20:27 INFO - 'PUBLIC': 'C:\\Users\\Public', 19:20:27 INFO - 'PWD': 'C:\\slave\\test-pgo', 19:20:27 INFO - 'PYTHONPATH': 'C:\\slave\\test-pgo\\build\\tests\\talos', 19:20:27 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 19:20:27 INFO - 'SLAVEDIR': 'C:\\slave\\', 19:20:27 INFO - 'SYSTEMDRIVE': 'C:', 19:20:27 INFO - 'SYSTEMROOT': 'C:\\windows', 19:20:27 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 19:20:27 INFO - 'TEST1': 'testie', 19:20:27 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 19:20:27 INFO - 'USERDOMAIN': 'T-W732-IX-110', 19:20:27 INFO - 'USERNAME': 'cltbld', 19:20:27 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 19:20:27 INFO - 'WINDIR': 'C:\\windows', 19:20:27 INFO - 'WINDOWS_TRACING_FLAGS': '3', 19:20:27 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 19:20:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 19:20:27 INFO - Calling ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\python', 'C:\\slave\\test-pgo\\build\\tests\\talos\\talos\\run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test-pgo\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/iqb9Y5auR7eNRES2UQLg3A/artifacts/public/build/firefox-44.0a1.en-US.win32.crashreporter-symbols.zip', '--title', 'T-W732-IX-110', '--webServer', 'localhost'] with output_timeout 3600 19:20:28 INFO - mozversion INFO | application_buildid: 20151021143020 19:20:28 INFO - mozversion INFO | application_changeset: 8c36f375d03b0fcd7a8b3f4c1d92a6b4e4f26e0e 19:20:28 INFO - mozversion INFO | application_display_name: Nightly 19:20:28 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:20:28 INFO - mozversion INFO | application_name: Firefox 19:20:28 INFO - mozversion INFO | application_remotingname: firefox 19:20:28 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 19:20:28 INFO - mozversion INFO | application_vendor: Mozilla 19:20:28 INFO - mozversion INFO | application_version: 44.0a1 19:20:28 INFO - mozversion INFO | platform_buildid: 20151021143020 19:20:28 INFO - mozversion INFO | platform_changeset: 8c36f375d03b0fcd7a8b3f4c1d92a6b4e4f26e0e 19:20:28 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 19:20:28 INFO - mozversion INFO | platform_version: 44.0a1 19:20:28 INFO - 2015-10-21 19:20:28,884 DEBUG : using testdate: 1445480428 19:20:28 INFO - 2015-10-21 19:20:28,884 DEBUG : actual date: 1445480428 19:20:28 INFO - 2015-10-21 19:20:28,959 INFO : starting webserver on 'localhost:49610' 19:20:28 INFO - 2015-10-21 19:20:28,960 INFO : Starting test suite T-W732-IX-110 19:20:28 INFO - 2015-10-21 19:20:28,960 INFO : Starting test dromaeo_css 19:20:28 INFO - 2015-10-21 19:20:28,960 DEBUG : operating with platform_type : w7_ 19:20:28 INFO - 2015-10-21 19:20:28,961 INFO : Initialising browser for dromaeo_css test... 19:20:29 INFO - 2015-10-21 19:20:29,072 DEBUG : command line: C:\slave\test-pgo\build\application\firefox\firefox -profile c:\users\cltbld\appdata\local\temp\tmplvutr3\profile http://localhost:49610/getInfo.html 19:20:37 INFO - 2015-10-21 19:20:37,423 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:20:37 INFO - 2015-10-21 19:20:37,423 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:20:37 INFO - 2015-10-21 19:20:37,423 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674 19:20:37 INFO - 2015-10-21 19:20:37,423 DEBUG : BROWSER_OUTPUT: __metrics 19:20:37 INFO - 2015-10-21 19:20:37,503 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:20:39 INFO - 2015-10-21 19:20:39,490 DEBUG : BROWSER_OUTPUT: console.error: 19:20:39 INFO - 2015-10-21 19:20:39,490 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] 19:20:39 INFO - 2015-10-21 19:20:39,490 DEBUG : BROWSER_OUTPUT: Stack: 19:20:39 INFO - 2015-10-21 19:20:39,490 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<._executeStatement@resource://gre/modules/Sqlite.jsm:758:19 19:20:39 INFO - 2015-10-21 19:20:39,490 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached/<@resource://gre/modules/Sqlite.jsm:493:9 19:20:39 INFO - 2015-10-21 19:20:39,490 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached@resource://gre/modules/Sqlite.jsm:491:1 19:20:39 INFO - 2015-10-21 19:20:39,490 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeBeforeShutdown/loggedDb<.executeCached.value<@resource://gre/modules/Sqlite.jsm:368:51 19:20:39 INFO - 2015-10-21 19:20:39,490 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 19:20:39 INFO - 2015-10-21 19:20:39,490 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 19:20:39 INFO - 2015-10-21 19:20:39,490 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 19:20:39 INFO - 2015-10-21 19:20:39,490 DEBUG : BROWSER_OUTPUT: transaction@resource://gre/modules/Bookmarks.jsm:783:15 19:20:39 INFO - 2015-10-21 19:20:39,490 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 19:20:39 INFO - 2015-10-21 19:20:39,490 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 19:20:39 INFO - 2015-10-21 19:20:39,490 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 19:20:39 INFO - 2015-10-21 19:20:39,490 DEBUG : BROWSER_OUTPUT: Task_spawn@resource://gre/modules/Task.jsm:164:12 19:20:39 INFO - 2015-10-21 19:20:39,490 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 19:40:14 INFO - 2015-10-21 19:40:14,036 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 19:40:14 INFO - 2015-10-21 19:40:14,036 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 19:40:14 INFO - 2015-10-21 19:40:14,036 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 19:40:14 INFO - 2015-10-21 19:40:14,036 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 19:40:14 INFO - 2015-10-21 19:40:14,036 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 19:40:14 INFO - 2015-10-21 19:40:14,036 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 19:40:14 INFO - 2015-10-21 19:40:14,036 DEBUG : BROWSER_OUTPUT: 19:40:14 INFO - 2015-10-21 19:40:14,628 INFO : Browser initialized. 19:40:14 INFO - 2015-10-21 19:40:14,628 INFO : Running cycle 1/1 for v8_7 test... 19:40:14 INFO - 2015-10-21 19:40:14,628 DEBUG : command line: C:\slave\test-pgo\build\application\firefox\firefox -profile c:\users\cltbld\appdata\local\temp\tmpxjakoi\profile -tp file:\C:\slave\test-pgo\build\tests\talos\talos\tests\v8_7\v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:40:26 INFO - 2015-10-21 19:40:26,032 DEBUG : BROWSER_OUTPUT: RSS: Main: 127684608 19:40:26 INFO - 2015-10-21 19:40:26,032 DEBUG : BROWSER_OUTPUT: 19:40:47 INFO - 2015-10-21 19:40:47,513 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49610/tests/v8_7/run.html (next: http://localhost:49610/tests/v8_7/run.html) 19:40:47 INFO - 2015-10-21 19:40:47,767 DEBUG : BROWSER_OUTPUT: RSS: Main: 485150720 19:40:47 INFO - 2015-10-21 19:40:47,767 DEBUG : BROWSER_OUTPUT: 19:40:47 INFO - 2015-10-21 19:40:47,767 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:40:47 INFO - 2015-10-21 19:40:47,767 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:40:47 INFO - 2015-10-21 19:40:47,767 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:40:47 INFO - 2015-10-21 19:40:47,767 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:40:47 INFO - 2015-10-21 19:40:47,767 DEBUG : BROWSER_OUTPUT: |0;Richards;150.98897780462028 19:40:47 INFO - 2015-10-21 19:40:47,767 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;202.22446916076845 19:40:47 INFO - 2015-10-21 19:40:47,767 DEBUG : BROWSER_OUTPUT: |2;Encrypt;293.5995302407516 19:40:47 INFO - 2015-10-21 19:40:47,767 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5640.449438202248 19:40:47 INFO - 2015-10-21 19:40:47,767 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1398.6013986013986 19:40:47 INFO - 2015-10-21 19:40:47,767 DEBUG : BROWSER_OUTPUT: |5;Earley;631.3131313131313 19:40:47 INFO - 2015-10-21 19:40:47,767 DEBUG : BROWSER_OUTPUT: |6;Boyer;10547.368421052632 19:40:47 INFO - 2015-10-21 19:40:47,767 DEBUG : BROWSER_OUTPUT: |7;RegExp;28571.428571428572 19:40:47 INFO - 2015-10-21 19:40:47,769 DEBUG : BROWSER_OUTPUT: |8;Splay;637.7551020408164 19:40:47 INFO - 2015-10-21 19:40:47,769 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;5122.448979591837 19:40:47 INFO - 2015-10-21 19:40:47,769 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:40:47 INFO - 2015-10-21 19:40:47,769 DEBUG : BROWSER_OUTPUT: __startTimestamp1445481647767__endTimestamp 19:40:47 INFO - 2015-10-21 19:40:47,769 DEBUG : BROWSER_OUTPUT: 19:40:47 INFO - 2015-10-21 19:40:47,769 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:40:47 INFO - 2015-10-21 19:40:47,769 DEBUG : BROWSER_OUTPUT: Number of tests: 10 19:40:47 INFO - 2015-10-21 19:40:47,769 DEBUG : BROWSER_OUTPUT: 19:40:47 INFO - 2015-10-21 19:40:47,769 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:150.99 Median:150.99 stddev:0.00 (0.0%) 19:40:47 INFO - 2015-10-21 19:40:47,769 DEBUG : BROWSER_OUTPUT: Values: 151.0 19:40:47 INFO - 2015-10-21 19:40:47,769 DEBUG : BROWSER_OUTPUT: 19:40:47 INFO - 2015-10-21 19:40:47,769 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:202.22 Median:202.22 stddev:0.00 (0.0%) 19:40:47 INFO - 2015-10-21 19:40:47,769 DEBUG : BROWSER_OUTPUT: Values: 202.2 19:40:47 INFO - 2015-10-21 19:40:47,769 DEBUG : BROWSER_OUTPUT: 19:40:47 INFO - 2015-10-21 19:40:47,769 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:293.60 Median:293.60 stddev:0.00 (0.0%) 19:40:47 INFO - 2015-10-21 19:40:47,769 DEBUG : BROWSER_OUTPUT: Values: 293.6 19:40:47 INFO - 2015-10-21 19:40:47,769 DEBUG : BROWSER_OUTPUT: 19:40:47 INFO - 2015-10-21 19:40:47,769 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5640.45 Median:5640.45 stddev:0.00 (0.0%) 19:40:47 INFO - 2015-10-21 19:40:47,769 DEBUG : BROWSER_OUTPUT: Values: 5640.4 19:40:47 INFO - 2015-10-21 19:40:47,769 DEBUG : BROWSER_OUTPUT: 19:40:47 INFO - 2015-10-21 19:40:47,769 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1398.60 Median:1398.60 stddev:0.00 (0.0%) 19:40:47 INFO - 2015-10-21 19:40:47,769 DEBUG : BROWSER_OUTPUT: Values: 1398.6 19:40:47 INFO - 2015-10-21 19:40:47,769 DEBUG : BROWSER_OUTPUT: 19:40:47 INFO - 2015-10-21 19:40:47,769 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:631.31 Median:631.31 stddev:0.00 (0.0%) 19:40:47 INFO - 2015-10-21 19:40:47,769 DEBUG : BROWSER_OUTPUT: Values: 631.3 19:40:47 INFO - 2015-10-21 19:40:47,769 DEBUG : BROWSER_OUTPUT: 19:40:47 INFO - 2015-10-21 19:40:47,769 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10547.37 Median:10547.37 stddev:0.00 (0.0%) 19:40:47 INFO - 2015-10-21 19:40:47,770 DEBUG : BROWSER_OUTPUT: Values: 10547.4 19:40:47 INFO - 2015-10-21 19:40:47,770 DEBUG : BROWSER_OUTPUT: 19:40:47 INFO - 2015-10-21 19:40:47,770 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:28571.43 Median:28571.43 stddev:0.00 (0.0%) 19:40:47 INFO - 2015-10-21 19:40:47,770 DEBUG : BROWSER_OUTPUT: Values: 28571.4 19:40:47 INFO - 2015-10-21 19:40:47,770 DEBUG : BROWSER_OUTPUT: 19:40:47 INFO - 2015-10-21 19:40:47,770 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:637.76 Median:637.76 stddev:0.00 (0.0%) 19:40:47 INFO - 2015-10-21 19:40:47,770 DEBUG : BROWSER_OUTPUT: Values: 637.8 19:40:47 INFO - 2015-10-21 19:40:47,770 DEBUG : BROWSER_OUTPUT: 19:40:47 INFO - 2015-10-21 19:40:47,770 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:5122.45 Median:5122.45 stddev:0.00 (0.0%) 19:40:47 INFO - 2015-10-21 19:40:47,770 DEBUG : BROWSER_OUTPUT: Values: 5122.4 19:40:47 INFO - 2015-10-21 19:40:47,770 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:40:47 INFO - 2015-10-21 19:40:47,770 DEBUG : BROWSER_OUTPUT: 19:40:48 INFO - 2015-10-21 19:40:48,362 INFO : Browser exited with error code: 0 19:40:49 INFO - 2015-10-21 19:40:49,026 INFO : Completed test v8_7 (00:00:40) 19:40:49 INFO - 2015-10-21 19:40:49,188 INFO : Completed test suite (00:20:20) 19:40:49 INFO - 2015-10-21 19:40:49,188 DEBUG : Working with test: dromaeo_css 19:40:49 INFO - 2015-10-21 19:40:49,188 DEBUG : Generating results file: dromaeo_css 19:40:49 INFO - 2015-10-21 19:40:49,190 DEBUG : Working with test: kraken 19:40:49 INFO - 2015-10-21 19:40:49,190 DEBUG : Generating results file: kraken 19:40:49 INFO - 2015-10-21 19:40:49,190 INFO : javascript benchmark 19:40:49 INFO - 2015-10-21 19:40:49,190 DEBUG : Working with test: v8_7 19:40:49 INFO - 2015-10-21 19:40:49,190 DEBUG : Generating results file: v8_7 19:40:49 INFO - 2015-10-21 19:40:49,190 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:40:49 INFO - 2015-10-21 19:40:49,325 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,25]] 19:40:49 INFO - 2015-10-21 19:40:49,325 DEBUG : process_Request line: dromaeo_css 6576.59 graph.html#tests=[[72,64,25]] 19:40:49 INFO - 2015-10-21 19:40:49,325 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:40:49 INFO - 2015-10-21 19:40:49,436 DEBUG : process_Request line: kraken 1570.60 graph.html#tests=[[232,64,25]] 19:40:49 INFO - 2015-10-21 19:40:49,436 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:40:49 INFO - 2015-10-21 19:40:49,467 DEBUG : process_Request line: v8_7 20665.48 graph.html#tests=[[230,64,25]] 19:40:49 INFO - 2015-10-21 19:40:49,469 INFO : javascript benchmark 19:40:49 INFO - 2015-10-21 19:40:49,470 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [330.48939388644544, 332.7620751162918, 335.5771727623194, 335.8438326178325, 344.2959148541234, 9978.251631127658, 10628.30915990462, 16979.490615281546, 17525.216678496097, 17537.824621753778, 11289.548418063268, 11306.830397544023, 11520.366379849105, 11581.015613672827, 11737.823932641017, 4510.706804057734, 4571.1771881061395, 4588.4723256825555, 4602.56275653814, 4603.8158473661015, 3783.886483405502, 3861.7876016819064, 4581.450225972888, 4756.262779269219, 5034.521720436553, 4946.530079642428, 4961.131801934647, 4977.50224977503, 4984.127777638917, 4987.376577927759, 4723.126221648989, 4861.683990540603, 4890.902181956341, 4928.97535512322, 4963.875903102416, 4176.665866730685, 4182.393552934838, 4184.958150418487, 4190.20386126638, 4190.329547272452, 12718.300493472856, 13165.210087394691, 14170.220637864913, 14253.073550219202, 14295.213763243017, 2023.3626407681534, 2039.826614737749, 2048.3035767839006, 2113.577284543082, 2126.436494329004, 9365.438073715599, 9367.758525318073, 9634.373765705206, 9752.658656947044, 9838.852417213748, 1469.3202151148519, 1516.317657054319, 1542.7145977994107, 1555.2923419843944, 1620.2708781048575, 72633.27366726317, 76428.23571764267, 77546.61226693887, 77748.0, 78721.0, 6362.713677884506, 6492.253390860017, 6510.251321098134, 6522.706478208492, 6536.607803531803, 7477.214892436215, 7522.028798624513, 7524.586147761816, 7535.434842386843, 7542.132654744665, 4817.975910120427, 4843.564079232816, 4948.90102197954, 5118.232265160182, 5147.0992576298995, 5273.0, 5319.627626066215, 5329.147336426231, 5335.146376579729, 5341.904909493544, 2867.899623513167, 2881.1212580162833, 2905.2010697058477, 2920.094770621114, 2923.31302143996, 976.6142373762324, 990.9149481317945, 1017.4963393120453, 1055.883852776194, 1085.7177133945231, 398.24455385713003, 442.2746695419515, 446.95530446955695, 468.48232702863527, 477.2507163752944, 11583.362915039585, 11677.0, 11960.760784784256, 12094.879051209551, 12373.75252494945, 464.498341790865, 475.08546048855817, 480.86295405809176, 487.10859127796755, 510.50481033397546, 5411.350637923474, 6555.704993275314, 6575.145231119924, 6578.407943285031, 6652.201735791639, 457513.0, 458422.0, 459521.0, 464155.0, 465241.0, 85873.57063214769, 86406.0, 87871.56064219637, 88939.0, 92661.5366923161, 492.3255140457596, 495.2917328220679, 504.6517902647235, 506.2456939160624, 507.0442216422071, 11280.153988450735, 11383.260088094248, 11422.25755325901, 11559.826602600799, 11656.650300491, 42717.0, 43801.78099109484, 44622.77688611536, 44742.55257447384, 45517.77241113773, 58222.4177758217, 58411.70794146172, 58424.70787646034, 58852.41147588641, 59163.40836591751, 6150.569460137747, 6157.96921015392, 6246.094316324198, 6448.0, 6458.257300410325, 12470.812937805758, 12535.122541422013, 12560.560380387009, 12566.937165314115, 12571.434285456993, 10070.546825392728, 10139.340942838691, 10403.687889363331, 10460.110890574082, 10753.784924301626, 2565.166320945663, 6363.649999250086, 10497.107745841384, 10559.676871088348, 10573.735656608646, 10386.688399348031, 10726.839097413702, 10738.302010369302, 10802.135829133493, 10802.513886874953, 5914.172015917689, 5952.642841429528, 6407.199100112486, 6438.130852334875, 6447.613143211234, 10378.117859981987, 10609.098226650822, 10630.946845265724, 10749.301295415773, 10759.784804303714], "dojo.html": [2781.2768680143163, 2797.790165737568, 2825.6467941507312, 2835.8440285784286, 2854.6717127530333, 5208.401033881105, 5221.0863098957625, 5283.392409872866, 5328.733563321833, 5340.839774806762, 5209.843704688856, 5211.088059589566, 5247.553957913582, 5344.706041167734, 5351.143816989283, 4422.867313980586, 4457.108578284348, 4509.706869053517, 4587.977060114711, 4599.0, 4500.212462818994, 4515.05183911379, 4533.909321813562, 4595.563421474954, 4614.907701845961, 4399.208142534342, 4601.907961840761, 4646.047560250141, 4680.742559159245, 4682.836100736475, 4476.37330773692, 4514.8194072237075, 4580.581290541827, 4601.44782626087, 4658.0, 4417.933730994037, 4471.262241730111, 4500.189965806187, 4526.977365113186, 4538.478075021349, 5186.273921650972, 5210.088234558937, 5275.709835959021, 5280.841574752763, 5286.6035047371215, 5355.598330125217, 5445.83662490126, 5492.5605951523785, 5583.637063590853, 5600.0, 5309.362876454811, 5503.284573005523, 5522.282103326542, 5551.444855514456, 5570.275864137677, 4801.135795556834, 4911.091448082117, 5082.974585127051, 5176.275321454999, 5195.480451954774, 5525.613207075547, 5560.999020176407, 5606.439356064361, 5630.244252520449, 5675.57433192504, 5346.7861285548925, 5351.598630102758, 5399.082156033483, 5462.6995515247045, 5470.507654311052, 5428.348598168166, 5442.83671489848, 5529.640573362719, 5559.583031272671, 5561.304836895388, 5237.764300606482, 5345.091334473149, 5357.598180136505, 5513.145462453326, 5526.889462210814, 5248.212768084742, 5360.678359298455, 5462.071447853875, 5462.754176062087, 5468.960897429476, 3384.5769278840144, 3389.5593572835373, 3422.5892892853017, 3456.585209774843, 3457.2221250219004, 3106.2389714520086, 3110.828904410279, 3156.3213909009673, 3185.124090875028, 3192.8563214655396, 4983.227599722049, 5298.09932311508, 5363.919541206885, 5375.650582712111, 5406.162044883049, 5412.107002344648, 5448.782048718007, 5577.107662773937, 5593.496585307342, 5661.122526008476, 5243.9213411798855, 5276.419593844674, 5292.179712144623, 5300.416954135042, 5406.459354064562, 4151.211269858717, 4255.914881702349, 4348.608625223745, 4376.978115109468, 4415.977920110379, 5821.476067153976, 5826.41735826414, 5835.912461312999, 5901.409859014064, 5952.821415357633, 5374.086405311028, 5506.229127922014, 5549.500544950974, 5550.306211723535, 5572.0, 5746.367899530965, 5813.069908814569, 5820.272465941757, 5919.970400147971, 5950.19672344228, 5456.236126942311, 5466.453354664502, 5540.307461567304, 5581.246531718166, 5591.860203494783, 5186.870328241824, 5459.535939445192, 5525.977694126599, 5547.805826796042, 5559.8888022240135, 5290.338707661543, 5406.972675191701, 5491.258680078138, 5508.944910550843, 5512.145617429305, 5323.0, 5347.786088556414, 5355.368648861253, 5445.7549410277425, 5491.945080549143, 5191.351081114861, 5199.688018718889, 5264.473552644705, 5280.60395470349, 5354.491323324278, 5260.158374660036, 5384.407715151408, 5466.207399927068, 5560.193771903132, 5568.053430916835, 5179.093658609653, 5244.7936974495315, 5328.547073498796, 5472.781088756565, 5474.91787623178], "mootools.html": [1198.4726720243098, 1222.5843213307476, 1291.6512541613765, 1442.4807069454994, 1630.5108467459759, 8258.215469530393, 8670.956645216773, 8897.510636914967, 8930.419522731017, 8959.059298773633, 9000.144986226314, 9043.005269420359, 9048.185663290302, 9050.50141835471, 9235.076492350761, 2020.444377796103, 2033.5424529480897, 2117.5341424886537, 2163.0698799516204, 2226.7327920649464, 2276.3284830974903, 2278.5556816420803, 2279.9316020519327, 2280.954380912389, 2281.977180228201, 2210.3921421609025, 2249.1228420915854, 2253.9774602253933, 2254.6054440472853, 2264.909403623853, 1999.490130016851, 2011.4267433781374, 2112.281824179771, 2245.202952951695, 2255.2557655973487, 2143.249862548111, 2251.3583628665915, 2263.7283525976823, 2273.954520909589, 2300.7584203658707, 9009.189172974464, 9051.094890510962, 9156.0, 9239.722808315693, 9246.398984066082, 5033.270175824521, 5074.13739664258, 5079.415867175285, 5139.61452891031, 5151.896962060775, 3367.8316084195935, 3369.9047809461777, 3407.488876668495, 3429.176997520602, 3441.0881116504147, 1061.6178175856762, 1065.664315740547, 1066.1204506282347, 1072.2119242356862, 1115.6039605939857, 13165.407556659973, 13261.07172497916, 13306.86693133066, 13313.26777027263, 13318.733625327439, 4321.135772845443, 4355.651547876162, 4397.780110994438, 4408.647308215335, 4426.247537918562, 10897.618583349546, 10922.563097476172, 10930.890691093146, 10945.343279403261, 10975.695104028084, 4974.726390048582, 4975.0547395994645, 4983.426905905795, 4988.451270360258, 5010.398752149693, 4534.387857639243, 4562.498125206224, 4562.8631141065825, 4571.1543364477675, 4595.6783025187915, 3696.464012718141, 3763.7365384423374, 3764.4541541476333, 3779.8677046303246, 3795.69634429245, 1123.2698745815285, 1142.1490989212923, 1145.5761368293618, 1150.5800382860195, 1158.9710257243637, 852.2287329966266, 931.064280398209, 943.217129782279, 944.2776276148752, 945.7446489447948, 7418.295261950106, 8046.879296810553, 8070.636821343053, 8364.58177091143, 8468.661253549912, 592.0408937521244, 593.92575928009, 610.7495926670044, 615.7352338494491, 623.3579413204407, 6138.877222455526, 6209.658468784261, 6224.906626400608, 6228.626282423069, 6230.190075290183, 11177.105831533458, 11201.103911687045, 11258.099352051817, 11280.435978201058, 11356.0, 11483.13876459269, 11544.249623774427, 11653.009494192918, 11667.299962002307, 11699.824502632468, 8318.459300145592, 8387.580620969049, 8388.664453421794, 8398.118197589287, 8400.369972252105, 8149.429539932148, 8205.79485512867, 8223.09545949957, 8238.134995825352, 8249.422540422353, 9675.661351852652, 9817.509124543887, 10041.04610062043, 10113.393196408239, 10122.089011988955, 10390.740231494274, 10417.218708596734, 10459.738506537398, 10466.110380617733, 10494.947525262325, 8515.91484085176, 8675.0, 8705.47767133974, 8760.036395996563, 8764.298856091369, 8922.197002269826, 8989.41568798026, 8992.68525601627, 9019.0, 9029.63881444735, 7946.205379462008, 8093.19068093186, 8194.50832950025, 8320.0847906729, 8405.53769542681, 7921.603919804102, 7966.880496792437, 8050.718224862336, 8150.877736834071, 8171.509709417454, 7302.233265507045, 7497.212792656693, 8006.59967001636, 8052.114267430461, 8072.071711753224, 7023.473239506955, 7144.678489467882, 7172.175199852084, 7187.496875218684, 7191.101112360955, 7168.2831716827895, 7215.567065976058, 7219.494635375473, 7219.963900180465, 7230.602316872622], "ext.html": [485.3302442629169, 499.0991260774302, 510.6782726882064, 523.1263789471582, 527.5832092646809, 31641.0, 32551.51172732411, 32649.836750816274, 38921.61078389215, 39638.0, 39778.40332395009, 41051.17897642045, 41639.167216655645, 41670.58329416705, 41707.15613940375, 8385.999999999985, 8548.0, 8560.400771945966, 8560.48637081774, 8578.485290882536, 7467.029286192815, 7801.804954876116, 10530.15758739299, 10775.946120269387, 10799.730006749855, 10427.426491542961, 10623.57505699771, 10675.145988320915, 10715.892841071607, 10724.892751072468, 7834.451588388815, 8074.6770129194765, 10486.947565262162, 10519.947400262989, 10650.893491065068, 10374.688759337232, 10672.893271067345, 10683.198760093024, 10693.144548436107, 10698.572057117706, 36955.81522092399, 38447.92593555357, 38502.0, 38621.42067868984, 38628.22743545113, 3011.8192908425344, 3028.606281183454, 3279.3769183854993, 3484.3379757846183, 3594.0, 29405.558916616268, 30595.694043059506, 30653.51245451994, 31192.532112018336, 31659.525107123412, 2708.2281549758422, 2801.229661842989, 2827.39211069619, 2862.184277480929, 2924.415116976592, 323538.0, 330782.0, 330986.9999999976, 331248.0, 332748.0, 56667.43332566704, 57620.71189644025, 57767.71116144393, 57830.7108464455, 57840.0, 52678.0, 55756.0, 60003.49903776409, 60409.69795150996, 61399.69300153471, 12587.118901676795, 13116.409761560753, 13279.800802987962, 13285.269310188032, 13292.667683307802, 9763.707088787347, 9866.950665246628, 9917.801643967225, 9929.404235745878, 9935.05616966387, 17422.0, 18494.0, 18875.3393631225, 19151.329703460313, 19194.808051919583, 8394.286485648667, 8703.47779133254, 8716.0, 8719.564021798884, 8746.0, 830.3647709502236, 884.5090974509209, 904.4573256046319, 1014.031599822168, 1038.11760003996, 28049.71950280471, 28119.0, 28398.148055558366, 28885.0, 28906.421871562452, 961.1541843178098, 963.5086106085806, 974.2303580171726, 977.0669011094387, 991.5339790298548, 13715.245661488714, 14452.855471445362, 14707.705845883022, 14760.457490202274, 14830.0, 484929.0, 493930.0, 494906.0, 495276.0, 495594.0, 47275.52724472711, 48476.27285590719, 48623.5137648619, 48635.27047094297, 49002.50997490051, 1115.5036008975928, 1122.2985633978763, 1171.988280117188, 1174.618249069056, 1179.6814859987755, 26206.08278710236, 27101.59347609748, 27572.448551028465, 27997.580036299063, 28003.299917502227, 40494.392584111854, 41267.587324126376, 41407.37888931729, 41447.58552414558, 41656.791716041225, 330662.34668826504, 331153.0, 347751.0, 348684.0, 350851.0, 25018.37454063663, 25314.367140821625, 28181.0, 28341.291467713472, 28773.136805895858, 39859.60140398675, 40235.79882100571, 40483.79758101191, 40495.0, 40840.0, 32156.356872862878, 33398.12228623401, 33594.664053359156, 34243.31513369769, 34999.0, 26603.733962660124, 32303.676963231006, 33426.66573334236, 35147.82426087853, 35518.822405887804, 33391.66608333885, 33496.66503334935, 33527.32945341129, 33745.3250934975, 33815.661843381255, 31993.6800632, 32879.0, 32928.1767955803, 34508.48237276493, 34534.48198277078, 22209.47630922693, 23131.537369252183, 23286.883565582062, 23359.41601459909, 23465.648015279443], "prototype.html": [330.84284964641785, 330.84284964641796, 340.42298304374094, 340.52666793157516, 340.7699802633223, 5748.798792042279, 5753.2520772299595, 5778.451047150525, 5784.6239994400385, 5798.884022319557, 5686.658800471974, 5692.203091567174, 5696.743646535905, 5702.401247868966, 5703.77184912603, 4065.247929133105, 4234.724742891703, 4243.766592837393, 4246.447961764966, 4247.575242475758, 4218.831246750126, 4250.851220207293, 4255.361695745632, 4258.701890867641, 4260.062786187033, 4011.7392369496033, 4022.7184097113213, 4091.0, 4226.239276930151, 4226.788660566959, 3923.2153569286256, 4084.346504559286, 4117.402976568381, 4226.4716910386205, 4238.618524332794, 3691.7046636269033, 3729.589745128034, 3738.327101121797, 3755.830987605564, 3758.39865621502, 5424.105022671254, 5501.037318469292, 5539.667619942817, 5548.223248745138, 5550.69471179085, 4924.384451943507, 4935.383077115361, 4988.326575912241, 5020.648554601179, 5046.495350464961, 5911.172435858984, 5917.6449413034925, 5932.851678708023, 5932.881342373128, 5949.25634295713, 4165.083681590046, 4198.874033778991, 4200.852970146061, 4208.537060923296, 4209.3054645983375, 6213.378662133796, 6217.316095229521, 6219.222597175353, 6226.688665566703, 6230.844228894269, 4013.4581831452965, 4202.348635961431, 4226.1336426032585, 4282.207791558571, 4337.631301339358, 4376.584224498668, 4387.122575484916, 4423.248047831877, 4428.535003824552, 4439.7336159829865, 5018.673786203885, 5022.698638081727, 5024.120778863684, 5026.522480364432, 5033.622478314068, 5643.492085712305, 5843.590948633555, 5933.792317268875, 5942.019566771434, 5959.165716799652, 1586.6509367939034, 1594.234767311697, 1596.146061856901, 1601.9519414417587, 1603.4708546179734, 1084.1543595995136, 1102.3551222534907, 1116.3023110555903, 1118.697951553076, 1119.8208286674094, 5570.582206334541, 5734.799282025109, 5761.366249712528, 5853.970730146322, 5913.349531551526, 6033.5474839387225, 6199.938000620026, 6208.379162083846, 6214.906776398358, 6225.782097626561, 5798.855028624318, 5902.173695682608, 5909.084091965667, 5909.468147866627, 5913.0, 3330.0842268375904, 3403.8808641697424, 3412.7099196568074, 3423.1955490459723, 3428.400029994741, 6489.935100649028, 6532.804015879531, 6538.280789113193, 6545.083688283644, 6550.181227346582, 6074.878502429927, 6321.209848768904, 6324.936750632435, 6325.746970121236, 6325.810225693236, 6399.424051835264, 6526.184226971724, 6527.281998980204, 6535.954247320406, 6544.083828264047, 5971.850703732442, 6035.909461358171, 6134.110553969738, 6182.196314479089, 6223.190985171898, 6038.426349496791, 6055.636661800306, 6077.4226448487325, 6097.664628445301, 6106.816795496142, 6519.641419721771, 6528.412442880163, 6533.803985880431, 6544.869102617826, 6545.37818907203, 4403.207422663823, 4408.493023302233, 4410.845620403271, 4411.889702757328, 4413.82344706221, 5962.344142144274, 6073.240844894388, 6269.122322874892, 6312.053192021233, 6317.241930968313, 6143.0, 6154.969225153845, 6160.476359509492, 6173.81478555644, 6181.783637572664, 6071.605345652519, 6094.9085763714465, 6100.176476175659, 6103.145559621567, 6105.725242364016, 5722.341930678025, 5887.764489420375, 5906.911396329145, 5961.612495187799, 5976.372480889444, 6028.57799953999, 6120.785772497941, 6124.6325220486915, 6134.539909506716, 6136.693165341804, 5643.238162847963, 5707.6290041147195, 5937.732802023833, 5990.430909063632, 6017.638941663514], "yui.html": [709.850931304426, 734.214390602056, 743.2270438743706, 768.4428789127886, 769.7960040589245, 12107.15249932504, 12526.060545459093, 12961.222326660407, 13583.864161358384, 13689.494155642871, 12048.879511204885, 12484.18852774569, 12510.687232819184, 12599.0, 12605.873941260585, 530.7425898439254, 535.6946540471932, 617.6047329708979, 619.179587047162, 622.8380621038517, 616.038979192459, 622.3838399984029, 623.9188905442286, 624.5628060357745, 627.3976982097192, 639.2456900856987, 647.1263793878273, 654.4404534123328, 655.3413819111786, 655.397034728049, 539.3581637850964, 553.7923278770461, 638.409471239102, 639.6194264412713, 652.3802387731674, 453.29738904697587, 466.3401287178638, 468.8148181468301, 473.03028790978357, 474.88127968007996, 11691.88308116925, 11702.122340824471, 11789.410529473578, 11802.0, 11857.525698972117, 12182.867998100297, 12434.62696119118, 12466.937665311616, 12487.250764954131, 12549.385072200123, 10327.122194613466, 10695.679129626124, 10716.35701857891, 10851.620193293196, 10909.23635345526, 3407.2844702612483, 3434.6050204226335, 3531.170175008871, 3633.1462106404974, 3774.6602805747616, 50748.253076484674, 51800.74099629478, 52186.0, 52231.47768522304, 52516.47483525154, 9434.0, 9552.0, 9621.711348659552, 9815.165710914509, 9904.15814655748, 17796.37712680076, 17797.377091801984, 17799.377021804175, 17873.19570619325, 18040.909795450938, 7253.746118885813, 7336.37640800538, 7549.0, 7627.656755446018, 7735.9226407735205, 4049.271131196354, 4159.875203743893, 4165.875023749292, 4224.176285624335, 4293.2272191005295, 2790.121111849761, 2896.797224194286, 2912.504874171396, 2973.8661760220843, 2983.8508074596184, 495.7546014722735, 496.5580633236423, 499.74263254424, 502.791341593242, 509.8495943696618, 610.109968601658, 612.9059628562993, 639.1754636518839, 696.2028477393357, 698.3915077186704, 9036.45781253127, 9159.313051521163, 9205.953970230106, 9233.722988310361, 9276.907230927603, 569.9623844755017, 595.2024287454831, 700.8247938015496, 706.2196273118233, 739.1705528816244, 4164.479440069991, 4652.604528615106, 4749.905001899942, 4760.833370832004, 4804.927926081112, 61038.38961610327, 62227.377726223065, 64414.35585644084, 64579.35420645827, 64862.0, 55583.444165558634, 55951.720241398536, 56035.0, 56079.15881261785, 56423.0, 45125.77437112793, 46788.7660561695, 46823.76588117037, 46973.76513117413, 47344.289835651805, 9163.312751543528, 9164.633414663338, 9280.396774209656, 9281.257499400166, 9602.559616057648, 32808.83595582102, 33337.499937501445, 33420.83289583537, 33495.49756753699, 33747.66252337445, 45077.77461112673, 45197.0, 45320.0, 45673.54326456693, 46982.29526557036, 8145.389095817956, 8382.455140415854, 8446.662133514836, 8478.491290522588, 8518.574071296534, 12130.029597631992, 12407.362061297163, 12524.937375313066, 12713.491460341484, 12815.0, 11883.762324753283, 12187.695307617027, 12327.198732082386, 12497.937675297339, 12763.489460421479, 11476.196666233283, 11681.299122052704, 11745.88254117482, 11806.46870890829, 11902.464389102339, 11213.775724485628, 12228.266304021787, 12568.74862502763, 12689.619311420673, 12721.80917286223, 10116.342437741523, 10190.28667993263, 10306.845397319195, 10373.0, 10622.415767132572, 10374.0, 10447.738806529898, 10720.764150146446, 10748.946255268673, 10754.462276886281]}, "summary": {"suite": 6576.5871951551635, "subtests": {"jquery.html": {"filtered": 6736.628362395988, "value": 6736.628362395988}, "dojo.html": {"filtered": 4989.750238265266, "value": 4989.750238265266}, "mootools.html": {"filtered": 4794.7009874819, "value": 4794.7009874819}, "ext.html": {"filtered": 18126.758443227955, "value": 18126.758443227955}, "prototype.html": {"filtered": 4556.966587856106, "value": 4556.966587856106}, "yui.html": {"filtered": 6076.982645954743, "value": 6076.982645954743}}}, "test_machine": {"platform": "x86", "osversion": "6.1.7601", "os": "win", "name": "T-W732-IX-110"}, "testrun": {"date": 1445480428, "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": "20151021143020", "branch": "Fx-Team", "revision": "8c36f375d03b0fcd7a8b3f4c1d92a6b4e4f26e0e"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 156.0, 161.0, 151.0, 150.0, 150.0, 153.0, 151.0, 151.0, 158.0], "ai-astar": [94.0, 86.0, 94.0, 95.0, 93.0, 95.0, 95.0, 94.0, 95.0, 101.0], "imaging-gaussian-blur": [117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 116.0, 116.0, 116.0, 116.0], "audio-beat-detection": [131.0, 131.0, 143.0, 155.0, 134.0, 135.0, 141.0, 138.0, 149.0, 135.0], "json-stringify-tinderbox": [78.0, 79.0, 79.0, 79.0, 79.0, 78.0, 80.0, 78.0, 79.0, 78.0], "stanford-crypto-pbkdf2": [190.0, 190.0, 190.0, 192.0, 189.0, 185.0, 189.0, 190.0, 192.0, 183.0], "json-parse-financial": [79.0, 82.0, 80.0, 82.0, 79.0, 80.0, 83.0, 81.0, 80.0, 90.0], "stanford-crypto-sha256-iterative": [84.0, 84.0, 84.0, 84.0, 85.0, 83.0, 85.0, 84.0, 86.0, 83.0], "audio-fft": [93.0, 92.0, 98.0, 100.0, 76.0, 76.0, 77.0, 76.0, 97.0, 76.0], "imaging-darkroom": [140.0, 140.0, 138.0, 139.0, 139.0, 139.0, 156.0, 139.0, 138.0, 141.0], "stanford-crypto-ccm": [119.0, 118.0, 119.0, 118.0, 124.0, 120.0, 119.0, 116.0, 122.0, 120.0], "audio-oscillator": [95.0, 96.0, 112.0, 101.0, 96.0, 95.0, 118.0, 95.0, 95.0, 119.0], "stanford-crypto-aes": [98.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 98.0, 94.0], "imaging-desaturate": [88.0, 90.0, 89.0, 89.0, 89.0, 89.0, 89.0, 89.0, 88.0, 94.0]}, "summary": {"suite": 1570.6, "subtests": {"audio-fft": {"filtered": 86.1, "value": 86.1}, "stanford-crypto-pbkdf2": {"filtered": 189.0, "value": 189.0}, "audio-beat-detection": {"filtered": 139.2, "value": 139.2}, "stanford-crypto-ccm": {"filtered": 119.5, "value": 119.5}, "imaging-darkroom": {"filtered": 140.9, "value": 140.9}, "json-parse-financial": {"filtered": 81.6, "value": 81.6}, "audio-oscillator": {"filtered": 102.2, "value": 102.2}, "ai-astar": {"filtered": 94.2, "value": 94.2}, "audio-dft": {"filtered": 154.2, "value": 154.2}, "stanford-crypto-sha256-iterative": {"filtered": 84.2, "value": 84.2}, "json-stringify-tinderbox": {"filtered": 78.7, "value": 78.7}, "imaging-gaussian-blur": {"filtered": 116.3, "value": 116.3}, "stanford-crypto-aes": {"filtered": 95.1, "value": 95.1}, "imaging-desaturate": {"filtered": 89.4, "value": 89.4}}}, "test_machine": {"platform": "x86", "osversion": "6.1.7601", "os": "win", "name": "T-W732-IX-110"}, "testrun": {"date": 1445480428, "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": "20151021143020", "branch": "Fx-Team", "revision": "8c36f375d03b0fcd7a8b3f4c1d92a6b4e4f26e0e"}}, {"talos_counters": {}, "results": {"DeltaBlue": [202.22446916076845], "Encrypt": [293.5995302407516], "NavierStokes": [5122.448979591837], "Decrypt": [5640.449438202248], "Splay": [637.7551020408164], "Richards": [150.98897780462028], "RegExp": [28571.428571428572], "Earley": [631.3131313131313], "Boyer": [10547.368421052632], "RayTrace": [1398.6013986013986]}, "summary": {"suite": 20665.48280027773, "subtests": {"DeltaBlue": {"filtered": 326.95350999999994, "value": 326.95350999999994}, "Encrypt": {"filtered": 906.6124860000003, "value": 906.6124860000003}, "NavierStokes": {"filtered": 289.70517928286864, "value": 289.70517928286864}, "Decrypt": {"filtered": 47.19145219123505, "value": 47.19145219123505}, "Splay": {"filtered": 127.77788800000003, "value": 127.77788800000003}, "RegExp": {"filtered": 31.88447499999999, "value": 31.88447499999999}, "Richards": {"filtered": 233.80514599999992, "value": 233.80514599999992}, "Earley": {"filtered": 1055.6773919999998, "value": 1055.6773919999998}, "Boyer": {"filtered": 63.187609780439146, "value": 63.187609780439146}, "RayTrace": {"filtered": 529.0921350000001, "value": 529.0921350000001}}}, "test_machine": {"platform": "x86", "osversion": "6.1.7601", "os": "win", "name": "T-W732-IX-110"}, "testrun": {"date": 1445480428, "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": "20151021143020", "branch": "Fx-Team", "revision": "8c36f375d03b0fcd7a8b3f4c1d92a6b4e4f26e0e"}}] 19:40:49 INFO - RETURN: dromaeo_css: 6576.59 19:40:49 INFO - RETURN: kraken: 1570.60 19:40:49 INFO - RETURN: v8_7: 20665.48 19:40:49 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,25]]", "result": "20665.48"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,25]]", "result": "1570.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,25]]", "result": "6576.59"}}} 19:40:49 INFO - Return code: 0 19:40:49 INFO - # TBPL SUCCESS # 19:40:49 INFO - Running post-action listener: _resource_record_post_action 19:40:49 INFO - Running post-run listener: _resource_record_post_run 19:40:50 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 268502016; Write bytes: 449186816; Read time: 2923140; Write time: 4613050 19:40:50 INFO - install - Wall time: 2s; CPU: 12.0%; Read bytes: 0; Write bytes: 2245632; Read time: 0; Write time: 91100 19:40:50 INFO - run-tests - Wall time: 1224s; CPU: 13.0%; Read bytes: 268502016; Write bytes: 422262784; Read time: 2923140; Write time: 4464820 19:40:50 INFO - Running post-run listener: _upload_blobber_files 19:40:50 INFO - Blob upload gear active. 19:40:50 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 19:40:50 INFO - Copying logs to upload dir... 19:40:50 INFO - mkdir: C:\slave\test-pgo\build\upload\logs program finished with exit code 0 elapsedTime=1441.442000 ========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 24 mins, 2 secs) (at 2015-10-21 19:40:50.654114) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-21 19:40:50.658293) ========= '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-110 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-110 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-110 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/iqb9Y5auR7eNRES2UQLg3A/artifacts/public/build/firefox-44.0a1.en-US.win32.zip program finished with exit code 0 elapsedTime=0.101000 build_url: 'https://queue.taskcluster.net/v1/task/iqb9Y5auR7eNRES2UQLg3A/artifacts/public/build/firefox-44.0a1.en-US.win32.zip' ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-21 19:40:50.774752) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-21 19:40:50.775073) ========= '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-110 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-110 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-110 USERNAME=cltbld USERPROFILE=C:\Users\cltbld WINDIR=C:\windows WINDOWS_TRACING_FLAGS=3 WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=0.101000 ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-21 19:40:50.890661) ========= ========= Started reboot slave lost (results: 0, elapsed: 7 secs) (at 2015-10-21 19:40:50.890974) ========= ========= Finished reboot slave lost (results: 0, elapsed: 7 secs) (at 2015-10-21 19:40:58.382250) =========