builder: fx-team_win7-ix_test-dromaeojs-pgo slave: t-w732-ix-076 starttime: 1445470527.32 results: success (0) buildid: 20151021113233 builduid: be232ffc0c5d4b8c8826df82dda1c26a revision: 4babd5d32cc121f287363f63217c19029f848577 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-21 16:35:27.320867) ========= master: http://buildbot-master111.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-21 16:35:27.322131) ========= ========= Started set props: basedir (results: 0, elapsed: 1 secs) (at 2015-10-21 16:35:27.322439) ========= '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-076 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-076 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-076 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.660000 basedir: 'C:\\slave\\test-pgo' ========= Finished set props: basedir (results: 0, elapsed: 1 secs) (at 2015-10-21 16:35:28.661335) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2015-10-21 16:35:28.661655) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2015-10-21 16:35:31.623602) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 6 secs) (at 2015-10-21 16:35:31.623930) ========= '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-076 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-076 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-076 USERNAME=cltbld USERPROFILE=C:\Users\cltbld WINDIR=C:\windows WINDOWS_TRACING_FLAGS=3 WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=0.501000 ========= Finished 'rm -rf ...' (results: 0, elapsed: 6 secs) (at 2015-10-21 16:35:38.376240) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-21 16:35:38.376530) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-21 16:35:38.376887) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-10-21 16:35:38.377172) ========= '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-076 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-076 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-076 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 --16:35:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py => `archiver_client.py' Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12,141 (12K) [text/x-python] 0K .......... . 100% 2.27 GB/s 16:35:39 (2.27 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.698000 ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-10-21 16:35:39.742280) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 13 secs) (at 2015-10-21 16:35:39.742613) ========= '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-076 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-076 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-076 USERNAME=cltbld USERPROFILE=C:\Users\cltbld WINDIR=C:\windows WINDOWS_TRACING_FLAGS=3 WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log XPCOM_DEBUG_BREAK=warn using PTY: False program finished with exit code 0 elapsedTime=12.701000 ========= Finished 'rm -rf ...' (results: 0, elapsed: 13 secs) (at 2015-10-21 16:35:53.189930) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 7 secs) (at 2015-10-21 16:35:53.190277) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo integration/fx-team --rev 4babd5d32cc121f287363f63217c19029f848577 --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 4babd5d32cc121f287363f63217c19029f848577 --destination scripts --debug'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files\Common Files COMPUTERNAME=T-W732-IX-076 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-076 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-076 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 16:35:53,700 truncating revision to first 12 chars 2015-10-21 16:35:53,700 Setting DEBUG logging. 2015-10-21 16:35:53,700 attempt 1/10 2015-10-21 16:35:53,700 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4babd5d32cc1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-10-21 16:35:54,948 unpacking tar archive at: fx-team-4babd5d32cc1/testing/mozharness/ program finished with exit code 0 elapsedTime=2.093000 ========= Finished 'bash -c ...' (results: 0, elapsed: 7 secs) (at 2015-10-21 16:36:00.934435) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-21 16:36:00.934762) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-21 16:36:01.407806) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-21 16:36:01.408178) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-21 16:36:01.408635) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 25 mins, 34 secs) (at 2015-10-21 16:36:01.408930) ========= '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-076 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-076 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-076 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 16:36:01 INFO - MultiFileLogger online at 20151021 16:36:01 in C:\slave\test-pgo 16:36:01 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 16:36:01 INFO - Dumping config to C:\slave\test-pgo\logs\localconfig.json. 16:36:01 INFO - {'append_to_log': False, 16:36:01 INFO - 'base_work_dir': 'C:\\slave\\test-pgo', 16:36:01 INFO - 'blob_upload_branch': 'Fx-Team', 16:36:01 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test-pgo\\oauth.txt', 16:36:01 INFO - 'branch': 'Fx-Team', 16:36:01 INFO - 'buildbot_json_path': 'buildprops.json', 16:36:01 INFO - 'config_files': ('talos/windows_config.py',), 16:36:01 INFO - 'default_actions': ('clobber', 16:36:01 INFO - 'read-buildbot-config', 16:36:01 INFO - 'download-and-extract', 16:36:01 INFO - 'populate-webroot', 16:36:01 INFO - 'create-virtualenv', 16:36:01 INFO - 'install', 16:36:01 INFO - 'run-tests'), 16:36:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:36:01 INFO - 'download_minidump_stackwalk': True, 16:36:01 INFO - 'download_symbols': 'ondemand', 16:36:01 INFO - 'exes': {'easy_install': ('C:\\slave\\test-pgo\\build/venv/scripts/python', 16:36:01 INFO - 'C:\\slave\\test-pgo\\build/venv/scripts/easy_install-2.7-script.py'), 16:36:01 INFO - 'hg': 'c:/mozilla-build/hg/hg', 16:36:01 INFO - 'mozinstall': ('C:\\slave\\test-pgo\\build/venv/scripts/python', 16:36:01 INFO - 'C:\\slave\\test-pgo\\build/venv/scripts/mozinstall-script.py'), 16:36:01 INFO - 'python': 'c:/mozilla-build/python27/python.exe', 16:36:01 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe', 16:36:01 INFO - 'C:/mozilla-build/tooltool.py'), 16:36:01 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe', 16:36:01 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 16:36:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:36:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:36:01 INFO - 'installer_path': 'installer.exe', 16:36:01 INFO - 'log_level': 'info', 16:36:01 INFO - 'log_name': 'talos', 16:36:01 INFO - 'log_to_console': True, 16:36:01 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe', 16:36:01 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe', 16:36:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest', 16:36:01 INFO - 'opt_config_files': (), 16:36:01 INFO - 'pip_index': False, 16:36:01 INFO - 'sps_profile': False, 16:36:01 INFO - 'sps_profile_interval': 0, 16:36:01 INFO - 'suite': 'dromaeojs', 16:36:01 INFO - 'system_bits': '32', 16:36:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:36:01 INFO - 'title': 'T-W732-IX-076', 16:36:01 INFO - 'use_talos_json': True, 16:36:01 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'), 16:36:01 INFO - 'virtualenv_path': 'C:\\slave\\test-pgo\\build/venv', 16:36:01 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll', 16:36:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:36:01 INFO - 'work_dir': 'build'} 16:36:01 INFO - ##### 16:36:01 INFO - ##### Running clobber step. 16:36:01 INFO - ##### 16:36:01 INFO - Running pre-action listener: _resource_record_pre_action 16:36:01 INFO - Running main action method: clobber 16:36:01 INFO - rmtree: C:\slave\test-pgo\build 16:36:01 INFO - Using _rmtree_windows ... 16:36:01 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test-pgo\\build',), kwargs: {}, attempt #1 16:38:39 INFO - Running post-action listener: _resource_record_post_action 16:38:39 INFO - ##### 16:38:39 INFO - ##### Running read-buildbot-config step. 16:38:39 INFO - ##### 16:38:39 INFO - Running pre-action listener: _resource_record_pre_action 16:38:39 INFO - Running main action method: read_buildbot_config 16:38:39 INFO - Using buildbot properties: 16:38:39 INFO - { 16:38:39 INFO - "properties": { 16:38:39 INFO - "buildnumber": 63, 16:38:39 INFO - "product": "firefox", 16:38:39 INFO - "script_repo_revision": "production", 16:38:39 INFO - "builddir": "fx-team_win7-ix_test-dromaeojs", 16:38:39 INFO - "repository": "", 16:38:39 INFO - "buildername": "Windows 7 32-bit fx-team pgo talos dromaeojs", 16:38:39 INFO - "buildid": "20151021113233", 16:38:39 INFO - "slavename": "t-w732-ix-076", 16:38:39 INFO - "pgo_build": "True", 16:38:39 INFO - "basedir": "C:\\slave\\test-pgo", 16:38:39 INFO - "project": "", 16:38:39 INFO - "platform": "win7-ix", 16:38:39 INFO - "master": "http://buildbot-master111.bb.releng.scl3.mozilla.com:8201/", 16:38:39 INFO - "slavebuilddir": "test", 16:38:39 INFO - "scheduler": "tests-fx-team-win32-pgo-talos", 16:38:39 INFO - "branch": "fx-team", 16:38:39 INFO - "repo_path": "integration/fx-team", 16:38:39 INFO - "stage_platform": "win32-pgo", 16:38:39 INFO - "builduid": "be232ffc0c5d4b8c8826df82dda1c26a", 16:38:39 INFO - "revision": "4babd5d32cc121f287363f63217c19029f848577" 16:38:39 INFO - }, 16:38:39 INFO - "sourcestamp": { 16:38:39 INFO - "repository": "", 16:38:39 INFO - "hasPatch": false, 16:38:39 INFO - "project": "", 16:38:39 INFO - "branch": "fx-team-win32-pgo-talos", 16:38:39 INFO - "changes": [ 16:38:39 INFO - { 16:38:39 INFO - "category": null, 16:38:39 INFO - "files": [ 16:38:39 INFO - { 16:38:39 INFO - "url": null, 16:38:39 INFO - "name": "https://queue.taskcluster.net/v1/task/x-xhZbI1RrKYkKYgXsUrcw/artifacts/public/build/firefox-44.0a1.en-US.win32.zip" 16:38:39 INFO - } 16:38:39 INFO - ], 16:38:39 INFO - "repository": "", 16:38:39 INFO - "rev": "4babd5d32cc121f287363f63217c19029f848577", 16:38:39 INFO - "who": "sendchange", 16:38:39 INFO - "when": 1445470445, 16:38:39 INFO - "number": 6556237, 16:38:39 INFO - "comments": "", 16:38:39 INFO - "project": "", 16:38:39 INFO - "at": "Wed 21 Oct 2015 16:34:05", 16:38:39 INFO - "branch": "fx-team-win32-pgo-talos", 16:38:39 INFO - "revlink": "", 16:38:39 INFO - "properties": [ 16:38:39 INFO - [ 16:38:39 INFO - "buildid", 16:38:39 INFO - "20151021113233", 16:38:39 INFO - "Change" 16:38:39 INFO - ], 16:38:39 INFO - [ 16:38:39 INFO - "builduid", 16:38:39 INFO - "be232ffc0c5d4b8c8826df82dda1c26a", 16:38:39 INFO - "Change" 16:38:39 INFO - ], 16:38:39 INFO - [ 16:38:39 INFO - "pgo_build", 16:38:39 INFO - "True", 16:38:39 INFO - "Change" 16:38:39 INFO - ] 16:38:39 INFO - ], 16:38:39 INFO - "revision": "4babd5d32cc121f287363f63217c19029f848577" 16:38:39 INFO - } 16:38:39 INFO - ], 16:38:39 INFO - "revision": "4babd5d32cc121f287363f63217c19029f848577" 16:38:39 INFO - } 16:38:39 INFO - } 16:38:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/x-xhZbI1RrKYkKYgXsUrcw/artifacts/public/build/firefox-44.0a1.en-US.win32.zip. 16:38:39 INFO - Running post-action listener: _resource_record_post_action 16:38:39 INFO - ##### 16:38:39 INFO - ##### Running download-and-extract step. 16:38:39 INFO - ##### 16:38:39 INFO - Running pre-action listener: _resource_record_pre_action 16:38:39 INFO - Running main action method: download_and_extract 16:38:39 INFO - mkdir: C:\slave\test-pgo\build\tests 16:38:39 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')]} 16:38:39 INFO - https://queue.taskcluster.net/v1/task/x-xhZbI1RrKYkKYgXsUrcw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:38:39 INFO - trying https://queue.taskcluster.net/v1/task/x-xhZbI1RrKYkKYgXsUrcw/artifacts/public/build/test_packages.json 16:38:39 INFO - Downloading https://queue.taskcluster.net/v1/task/x-xhZbI1RrKYkKYgXsUrcw/artifacts/public/build/test_packages.json to C:\slave\test-pgo\build\test_packages.json 16:38:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/x-xhZbI1RrKYkKYgXsUrcw/artifacts/public/build/test_packages.json', 'file_name': 'C:\\slave\\test-pgo\\build\\test_packages.json'}, attempt #1 16:38:41 INFO - Downloaded 1221 bytes. 16:38:41 INFO - Reading from file C:\slave\test-pgo\build\test_packages.json 16:38:41 INFO - Using the following test package requirements: 16:38:41 INFO - {u'common': [u'firefox-44.0a1.en-US.win32.common.tests.zip'], 16:38:41 INFO - u'cppunittest': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 16:38:41 INFO - u'firefox-44.0a1.en-US.win32.cppunittest.tests.zip'], 16:38:41 INFO - u'jittest': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 16:38:41 INFO - u'jsshell-win32.zip'], 16:38:41 INFO - u'mochitest': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 16:38:41 INFO - u'firefox-44.0a1.en-US.win32.mochitest.tests.zip'], 16:38:41 INFO - u'mozbase': [u'firefox-44.0a1.en-US.win32.common.tests.zip'], 16:38:41 INFO - u'reftest': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 16:38:41 INFO - u'firefox-44.0a1.en-US.win32.reftest.tests.zip'], 16:38:41 INFO - u'talos': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 16:38:41 INFO - u'firefox-44.0a1.en-US.win32.talos.tests.zip'], 16:38:41 INFO - u'web-platform': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 16:38:41 INFO - u'firefox-44.0a1.en-US.win32.web-platform.tests.zip'], 16:38:41 INFO - u'webapprt': [u'firefox-44.0a1.en-US.win32.common.tests.zip'], 16:38:41 INFO - u'xpcshell': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 16:38:41 INFO - u'firefox-44.0a1.en-US.win32.xpcshell.tests.zip']} 16:38:41 INFO - Downloading packages: [u'firefox-44.0a1.en-US.win32.common.tests.zip'] for test suite category: common 16:38:41 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')]} 16:38:41 INFO - https://queue.taskcluster.net/v1/task/x-xhZbI1RrKYkKYgXsUrcw/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip matches https://queue.taskcluster.net 16:38:41 INFO - trying https://queue.taskcluster.net/v1/task/x-xhZbI1RrKYkKYgXsUrcw/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip 16:38:41 INFO - Downloading https://queue.taskcluster.net/v1/task/x-xhZbI1RrKYkKYgXsUrcw/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 16:38:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/x-xhZbI1RrKYkKYgXsUrcw/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 16:38:49 INFO - Downloaded 18001541 bytes. 16:38:49 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 16:38:49 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.common.tests.zip 16:38:49 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win32.common.tests.zip'] with output_timeout 1760 16:39:20 INFO - Return code: 0 16:39:20 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 16:39: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')]} 16:39:20 INFO - https://queue.taskcluster.net/v1/task/x-xhZbI1RrKYkKYgXsUrcw/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip matches https://queue.taskcluster.net 16:39:20 INFO - trying https://queue.taskcluster.net/v1/task/x-xhZbI1RrKYkKYgXsUrcw/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip 16:39:20 INFO - Downloading https://queue.taskcluster.net/v1/task/x-xhZbI1RrKYkKYgXsUrcw/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 16:39:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/x-xhZbI1RrKYkKYgXsUrcw/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 16:39:35 INFO - Downloaded 18001541 bytes. 16:39:35 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 16:39:35 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.common.tests.zip 16:39:35 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win32.common.tests.zip'] with output_timeout 1760 16:39:58 INFO - Return code: 0 16:39: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')]} 16:39:58 INFO - https://queue.taskcluster.net/v1/task/x-xhZbI1RrKYkKYgXsUrcw/artifacts/public/build/firefox-44.0a1.en-US.win32.talos.tests.zip matches https://queue.taskcluster.net 16:39:58 INFO - trying https://queue.taskcluster.net/v1/task/x-xhZbI1RrKYkKYgXsUrcw/artifacts/public/build/firefox-44.0a1.en-US.win32.talos.tests.zip 16:39:58 INFO - Downloading https://queue.taskcluster.net/v1/task/x-xhZbI1RrKYkKYgXsUrcw/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 16:39:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/x-xhZbI1RrKYkKYgXsUrcw/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 16:40:08 INFO - Downloaded 11128541 bytes. 16:40:08 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 16:40:08 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.talos.tests.zip 16:40:08 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win32.talos.tests.zip'] with output_timeout 1760 16:40:09 INFO - Return code: 0 16:40:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:40:09 INFO - https://queue.taskcluster.net/v1/task/x-xhZbI1RrKYkKYgXsUrcw/artifacts/public/build/firefox-44.0a1.en-US.win32.zip matches https://queue.taskcluster.net 16:40:09 INFO - trying https://queue.taskcluster.net/v1/task/x-xhZbI1RrKYkKYgXsUrcw/artifacts/public/build/firefox-44.0a1.en-US.win32.zip 16:40:09 INFO - Downloading https://queue.taskcluster.net/v1/task/x-xhZbI1RrKYkKYgXsUrcw/artifacts/public/build/firefox-44.0a1.en-US.win32.zip to C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.zip 16:40:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/x-xhZbI1RrKYkKYgXsUrcw/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 16:40:24 INFO - Downloaded 55466915 bytes. 16:40:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/x-xhZbI1RrKYkKYgXsUrcw/artifacts/public/build/firefox-44.0a1.en-US.win32.zip 16:40:24 INFO - mkdir: C:\slave\test-pgo\properties 16:40:24 INFO - Writing buildbot properties ['build_url'] to C:\slave\test-pgo\properties\build_url 16:40:24 INFO - Writing to file C:\slave\test-pgo\properties\build_url 16:40:24 INFO - Contents: 16:40:24 INFO - build_url:https://queue.taskcluster.net/v1/task/x-xhZbI1RrKYkKYgXsUrcw/artifacts/public/build/firefox-44.0a1.en-US.win32.zip 16:40:24 INFO - Running post-action listener: _resource_record_post_action 16:40:24 INFO - Running post-action listener: set_extra_try_arguments 16:40:24 INFO - ##### 16:40:24 INFO - ##### Running populate-webroot step. 16:40:24 INFO - ##### 16:40:24 INFO - Running pre-action listener: _resource_record_pre_action 16:40:24 INFO - Running main action method: populate_webroot 16:40:24 INFO - Guessing talos json url... 16:40: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')]} 16:40:24 INFO - https://queue.taskcluster.net/v1/task/x-xhZbI1RrKYkKYgXsUrcw/artifacts/public/build/firefox-44.0a1.en-US.win32.txt matches https://queue.taskcluster.net 16:40:24 INFO - trying https://queue.taskcluster.net/v1/task/x-xhZbI1RrKYkKYgXsUrcw/artifacts/public/build/firefox-44.0a1.en-US.win32.txt 16:40:24 INFO - Downloading https://queue.taskcluster.net/v1/task/x-xhZbI1RrKYkKYgXsUrcw/artifacts/public/build/firefox-44.0a1.en-US.win32.txt to C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.txt 16:40:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/x-xhZbI1RrKYkKYgXsUrcw/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 16:40:25 INFO - Downloaded 103 bytes. 16:40:25 INFO - Reading from file C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.txt 16:40:25 INFO - Contents: 16:40:25 INFO - 20151021113233 16:40:25 INFO - https://hg.mozilla.org/integration/fx-team/rev/4babd5d32cc121f287363f63217c19029f848577 16:40: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')]} 16:40:25 INFO - trying https://hg.mozilla.org/integration/fx-team/raw-file/4babd5d32c/testing/talos/talos.json 16:40:25 INFO - Downloading https://hg.mozilla.org/integration/fx-team/raw-file/4babd5d32c/testing/talos/talos.json to C:\slave\test-pgo\build\talos.json 16:40:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/fx-team/raw-file/4babd5d32c/testing/talos/talos.json', 'file_name': 'C:\\slave\\test-pgo\\build\\talos.json'}, attempt #1 16:40:26 INFO - Downloaded 4264 bytes. 16:40:26 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']}, 16:40:26 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']}, 16:40:26 INFO - u'remote-trobocheck2': {u'talos_options': [u'--fennecIDs', 16:40:26 INFO - u'../fennec_ids.txt'], 16:40:26 INFO - u'tests': [u'tcheck2']}, 16:40:26 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome', 16:40:26 INFO - u'--tppagecycles', 16:40:26 INFO - u'7'], 16:40:26 INFO - u'tests': [u'tsvgm']}}, 16:40:26 INFO - u'suites': {u'chromez': {u'tests': [u'tresize', u'tcanvasmark']}, 16:40:26 INFO - u'chromez-e10s': {u'talos_options': [u'--e10s'], 16:40:26 INFO - u'tests': [u'tresize', u'tcanvasmark']}, 16:40:26 INFO - u'dromaeojs': {u'tests': [u'dromaeo_css', u'kraken', u'v8_7']}, 16:40:26 INFO - u'dromaeojs-e10s': {u'talos_options': [u'--e10s'], 16:40:26 INFO - u'tests': [u'dromaeo_css', 16:40:26 INFO - u'kraken', 16:40:26 INFO - u'v8_7']}, 16:40:26 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:40:26 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 16:40:26 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:40:26 INFO - u'talos_options': [u'--e10s'], 16:40:26 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 16:40:26 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:40:26 INFO - u'tests': [u'damp', u'tps']}, 16:40:26 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:40:26 INFO - u'talos_options': [u'--e10s'], 16:40:26 INFO - u'tests': [u'damp', u'tps']}, 16:40:26 INFO - u'g3': {u'tests': [u'dromaeo_dom']}, 16:40:26 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']}, 16:40:26 INFO - u'other': {u'tests': [u'a11yr', 16:40:26 INFO - u'ts_paint', 16:40:26 INFO - u'tpaint', 16:40:26 INFO - u'sessionrestore', 16:40:26 INFO - u'sessionrestore_no_auto_restore']}, 16:40:26 INFO - u'other-e10s': {u'talos_options': [u'--e10s'], 16:40:26 INFO - u'tests': [u'a11yr', 16:40:26 INFO - u'ts_paint', 16:40:26 INFO - u'tpaint', 16:40:26 INFO - u'sessionrestore', 16:40:26 INFO - u'sessionrestore_no_auto_restore']}, 16:40:26 INFO - u'other-e10s_l64': {u'talos_options': [u'--e10s'], 16:40:26 INFO - u'tests': [u'a11yr', 16:40:26 INFO - u'ts_paint', 16:40:26 INFO - u'tpaint', 16:40:26 INFO - u'sessionrestore', 16:40:26 INFO - u'sessionrestore_no_auto_restore']}, 16:40:26 INFO - u'other-e10s_nol64': {u'talos_options': [u'--e10s'], 16:40:26 INFO - u'tests': [u'a11yr', 16:40:26 INFO - u'ts_paint', 16:40:26 INFO - u'tpaint', 16:40:26 INFO - u'sessionrestore', 16:40:26 INFO - u'sessionrestore_no_auto_restore']}, 16:40:26 INFO - u'other_l64': {u'tests': [u'a11yr', 16:40:26 INFO - u'ts_paint', 16:40:26 INFO - u'tpaint', 16:40:26 INFO - u'sessionrestore', 16:40:26 INFO - u'sessionrestore_no_auto_restore']}, 16:40:26 INFO - u'other_nol64': {u'tests': [u'a11yr', 16:40:26 INFO - u'ts_paint', 16:40:26 INFO - u'tpaint', 16:40:26 INFO - u'sessionrestore', 16:40:26 INFO - u'sessionrestore_no_auto_restore']}, 16:40:26 INFO - u'svgr': {u'tests': [u'tsvgx', 16:40:26 INFO - u'tsvgr_opacity', 16:40:26 INFO - u'tart', 16:40:26 INFO - u'tscrollx', 16:40:26 INFO - u'cart']}, 16:40:26 INFO - u'svgr-e10s': {u'talos_options': [u'--e10s'], 16:40:26 INFO - u'tests': [u'tsvgx', 16:40:26 INFO - u'tsvgr_opacity', 16:40:26 INFO - u'tart', 16:40:26 INFO - u'tscrollx', 16:40:26 INFO - u'cart']}, 16:40:26 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:40:26 INFO - u'tests': [u'tp5o']}, 16:40:26 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:40:26 INFO - u'talos_options': [u'--e10s'], 16:40:26 INFO - u'tests': [u'tp5o']}, 16:40:26 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:40:26 INFO - u'talos_options': [u'--xperf_path', 16:40:26 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:40:26 INFO - u'tests': [u'tp5n']}, 16:40:26 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:40:26 INFO - u'talos_options': [u'--e10s', 16:40:26 INFO - u'--xperf_path', 16:40:26 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 16:40:26 INFO - u'C:/slave/talos-data/talos/xperf.config'], 16:40:26 INFO - u'tests': [u'tp5n']}}, 16:40:26 INFO - u'talos.zip': {u'path': u'', 16:40:26 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:40:26 INFO - Running post-action listener: _resource_record_post_action 16:40:26 INFO - ##### 16:40:26 INFO - ##### Running create-virtualenv step. 16:40:26 INFO - ##### 16:40:26 INFO - Running pre-action listener: _resource_record_pre_action 16:40:26 INFO - Running main action method: create_virtualenv 16:40:26 INFO - Creating virtualenv C:\slave\test-pgo\build/venv 16:40:26 INFO - mkdir: C:\slave\test-pgo\build\venv\Scripts 16:40:26 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test-pgo\build\venv\Scripts\python27.dll 16:40:26 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'! 16:40:26 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 16:40:26 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 16:40:27 INFO - New python executable in C:\slave\test-pgo\build/venv\Scripts\python.exe 16:40:30 INFO - Installing distribute......................................................................................................................................................................................done. 16:40:31 INFO - Return code: 0 16:40:31 INFO - Installing pip>=1.5 into virtualenv C:\slave\test-pgo\build/venv 16:40: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')]} 16:40:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:40: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')]} 16:40:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:40:31 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x019A8B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01968EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0134E8C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01268B48>, '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 0x0128A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01A29660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-076', 'USERDOMAIN': 'T-W732-IX-076', '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-076', '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 16:40:31 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 16:40:31 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 16:40:31 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 16:40:31 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 16:40:31 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 16:40:31 INFO - 'COMPUTERNAME': 'T-W732-IX-076', 16:40:31 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 16:40:31 INFO - 'CYGWINBASE': 'C:\\cygwin', 16:40:31 INFO - 'DCLOCATION': 'SCL3', 16:40:31 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 16:40:31 INFO - 'FP_NO_HOST_CHECK': 'NO', 16:40:31 INFO - 'HOMEDRIVE': 'C:', 16:40:31 INFO - 'HOMEPATH': '\\Users\\cltbld', 16:40:31 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 16:40:31 INFO - 'KTS_VERSION': '1.19c', 16:40:31 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 16:40:31 INFO - 'LOGONSERVER': '\\\\T-W732-IX-076', 16:40:31 INFO - 'MONDIR': 'C:\\Monitor_config\\', 16:40:31 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 16:40:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:31 INFO - 'MOZ_NO_REMOTE': '1', 16:40:31 INFO - 'NO_EM_RESTART': '1', 16:40:31 INFO - 'NUMBER_OF_PROCESSORS': '8', 16:40:31 INFO - 'OS': 'Windows_NT', 16:40:31 INFO - 'OURDRIVE': 'C:', 16:40:31 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;', 16:40:31 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 16:40:31 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 16:40:31 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 16:40:31 INFO - 'PROCESSOR_LEVEL': '6', 16:40:31 INFO - 'PROCESSOR_REVISION': '1e05', 16:40:31 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 16:40:31 INFO - 'PROGRAMFILES': 'C:\\Program Files', 16:40:31 INFO - 'PROMPT': '$P$G', 16:40:31 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 16:40:31 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 16:40:31 INFO - 'PUBLIC': 'C:\\Users\\Public', 16:40:31 INFO - 'PWD': 'C:\\slave\\test-pgo', 16:40:31 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 16:40:31 INFO - 'SLAVEDIR': 'C:\\slave\\', 16:40:31 INFO - 'SYSTEMDRIVE': 'C:', 16:40:31 INFO - 'SYSTEMROOT': 'C:\\windows', 16:40:31 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 16:40:31 INFO - 'TEST1': 'testie', 16:40:31 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 16:40:31 INFO - 'USERDOMAIN': 'T-W732-IX-076', 16:40:31 INFO - 'USERNAME': 'cltbld', 16:40:31 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 16:40:31 INFO - 'WINDIR': 'C:\\windows', 16:40:31 INFO - 'WINDOWS_TRACING_FLAGS': '3', 16:40:31 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 16:40:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 16:40:33 INFO - Ignoring indexes: http://pypi.python.org/simple/ 16:40:33 INFO - Downloading/unpacking pip>=1.5 16:40:33 INFO - Creating supposed download cache at C:\slave\test-pgo\build/venv\cache 16:40:37 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 16:40:37 INFO - Running setup.py egg_info for package pip 16:40:37 INFO - warning: no files found matching 'pip\cacert.pem' 16:40:37 INFO - warning: no files found matching '*.html' under directory 'docs' 16:40:37 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 16:40:37 INFO - no previously-included directories found matching 'docs\_build\_sources' 16:40:37 INFO - Installing collected packages: pip 16:40:37 INFO - Found existing installation: pip 0.8.2 16:40:37 INFO - Uninstalling pip: 16:40:37 INFO - Successfully uninstalled pip 16:40:37 INFO - Running setup.py install for pip 16:40:37 INFO - warning: no files found matching 'pip\cacert.pem' 16:40:37 INFO - warning: no files found matching '*.html' under directory 'docs' 16:40:37 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 16:40:37 INFO - no previously-included directories found matching 'docs\_build\_sources' 16:40:37 INFO - Installing pip-script.py script to C:\slave\test-pgo\build\venv\Scripts 16:40:37 INFO - Installing pip.exe script to C:\slave\test-pgo\build\venv\Scripts 16:40:37 INFO - Installing pip2.7-script.py script to C:\slave\test-pgo\build\venv\Scripts 16:40:37 INFO - Installing pip2.7.exe script to C:\slave\test-pgo\build\venv\Scripts 16:40:37 INFO - Installing pip2-script.py script to C:\slave\test-pgo\build\venv\Scripts 16:40:37 INFO - Installing pip2.exe script to C:\slave\test-pgo\build\venv\Scripts 16:40:37 INFO - Successfully installed pip 16:40:37 INFO - Cleaning up... 16:40:37 INFO - Return code: 0 16:40:37 INFO - Installing psutil>=0.7.1 into virtualenv C:\slave\test-pgo\build/venv 16:40:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:40:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:40:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:40:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:40:37 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x019A8B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01968EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0134E8C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01268B48>, '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 0x0128A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01A29660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-076', 'USERDOMAIN': 'T-W732-IX-076', '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-076', '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 16:40:37 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 16:40:37 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 16:40:37 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 16:40:37 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 16:40:37 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 16:40:37 INFO - 'COMPUTERNAME': 'T-W732-IX-076', 16:40:37 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 16:40:37 INFO - 'CYGWINBASE': 'C:\\cygwin', 16:40:37 INFO - 'DCLOCATION': 'SCL3', 16:40:37 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 16:40:37 INFO - 'FP_NO_HOST_CHECK': 'NO', 16:40:37 INFO - 'HOMEDRIVE': 'C:', 16:40:37 INFO - 'HOMEPATH': '\\Users\\cltbld', 16:40:37 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 16:40:37 INFO - 'KTS_VERSION': '1.19c', 16:40:37 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 16:40:37 INFO - 'LOGONSERVER': '\\\\T-W732-IX-076', 16:40:37 INFO - 'MONDIR': 'C:\\Monitor_config\\', 16:40:37 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 16:40:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:37 INFO - 'MOZ_NO_REMOTE': '1', 16:40:37 INFO - 'NO_EM_RESTART': '1', 16:40:37 INFO - 'NUMBER_OF_PROCESSORS': '8', 16:40:37 INFO - 'OS': 'Windows_NT', 16:40:37 INFO - 'OURDRIVE': 'C:', 16:40:37 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 16:40:37 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 16:40:37 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 16:40:37 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 16:40:37 INFO - 'PROCESSOR_LEVEL': '6', 16:40:37 INFO - 'PROCESSOR_REVISION': '1e05', 16:40:37 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 16:40:37 INFO - 'PROGRAMFILES': 'C:\\Program Files', 16:40:37 INFO - 'PROMPT': '$P$G', 16:40:37 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 16:40:37 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 16:40:37 INFO - 'PUBLIC': 'C:\\Users\\Public', 16:40:37 INFO - 'PWD': 'C:\\slave\\test-pgo', 16:40:37 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 16:40:37 INFO - 'SLAVEDIR': 'C:\\slave\\', 16:40:37 INFO - 'SYSTEMDRIVE': 'C:', 16:40:37 INFO - 'SYSTEMROOT': 'C:\\windows', 16:40:37 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 16:40:37 INFO - 'TEST1': 'testie', 16:40:37 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 16:40:37 INFO - 'USERDOMAIN': 'T-W732-IX-076', 16:40:37 INFO - 'USERNAME': 'cltbld', 16:40:37 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 16:40:37 INFO - 'WINDIR': 'C:\\windows', 16:40:37 INFO - 'WINDOWS_TRACING_FLAGS': '3', 16:40:37 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 16:40:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 16:40:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:40:39 INFO - Downloading/unpacking psutil>=0.7.1 16:40:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:40:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:40:41 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 16:40:41 INFO - Installing collected packages: psutil 16:40:41 INFO - Successfully installed psutil 16:40:41 INFO - Cleaning up... 16:40:41 INFO - Return code: 0 16:40:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv C:\slave\test-pgo\build/venv 16:40:41 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')]} 16:40:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:40:41 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')]} 16:40:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:40:41 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x019A8B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01968EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0134E8C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01268B48>, '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 0x0128A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01A29660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-076', 'USERDOMAIN': 'T-W732-IX-076', '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-076', '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 16:40:41 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 16:40:41 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 16:40:41 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 16:40:41 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 16:40:41 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 16:40:41 INFO - 'COMPUTERNAME': 'T-W732-IX-076', 16:40:41 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 16:40:41 INFO - 'CYGWINBASE': 'C:\\cygwin', 16:40:41 INFO - 'DCLOCATION': 'SCL3', 16:40:41 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 16:40:41 INFO - 'FP_NO_HOST_CHECK': 'NO', 16:40:41 INFO - 'HOMEDRIVE': 'C:', 16:40:41 INFO - 'HOMEPATH': '\\Users\\cltbld', 16:40:41 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 16:40:41 INFO - 'KTS_VERSION': '1.19c', 16:40:41 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 16:40:41 INFO - 'LOGONSERVER': '\\\\T-W732-IX-076', 16:40:41 INFO - 'MONDIR': 'C:\\Monitor_config\\', 16:40:41 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 16:40:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:41 INFO - 'MOZ_NO_REMOTE': '1', 16:40:41 INFO - 'NO_EM_RESTART': '1', 16:40:41 INFO - 'NUMBER_OF_PROCESSORS': '8', 16:40:41 INFO - 'OS': 'Windows_NT', 16:40:41 INFO - 'OURDRIVE': 'C:', 16:40:41 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;', 16:40:41 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 16:40:41 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 16:40:41 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 16:40:41 INFO - 'PROCESSOR_LEVEL': '6', 16:40:41 INFO - 'PROCESSOR_REVISION': '1e05', 16:40:41 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 16:40:41 INFO - 'PROGRAMFILES': 'C:\\Program Files', 16:40:41 INFO - 'PROMPT': '$P$G', 16:40:41 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 16:40:41 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 16:40:41 INFO - 'PUBLIC': 'C:\\Users\\Public', 16:40:41 INFO - 'PWD': 'C:\\slave\\test-pgo', 16:40:41 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 16:40:41 INFO - 'SLAVEDIR': 'C:\\slave\\', 16:40:41 INFO - 'SYSTEMDRIVE': 'C:', 16:40:41 INFO - 'SYSTEMROOT': 'C:\\windows', 16:40:41 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 16:40:41 INFO - 'TEST1': 'testie', 16:40:41 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 16:40:41 INFO - 'USERDOMAIN': 'T-W732-IX-076', 16:40:41 INFO - 'USERNAME': 'cltbld', 16:40:41 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 16:40:41 INFO - 'WINDIR': 'C:\\windows', 16:40:41 INFO - 'WINDOWS_TRACING_FLAGS': '3', 16:40:41 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 16:40:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 16:40:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:40:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:40:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:40:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:40:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:40:43 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 16:40:43 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor 16:40:43 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) 16:40:43 INFO - Installing collected packages: mozsystemmonitor 16:40:43 INFO - Running setup.py install for mozsystemmonitor 16:40:43 INFO - Successfully installed mozsystemmonitor 16:40:43 INFO - Cleaning up... 16:40:43 INFO - Return code: 0 16:40:43 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test-pgo\build/venv 16:40:43 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')]} 16:40:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:40:43 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')]} 16:40:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:40:43 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x019A8B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01968EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0134E8C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01268B48>, '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 0x0128A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01A29660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-076', 'USERDOMAIN': 'T-W732-IX-076', '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-076', '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 16:40:43 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 16:40:43 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 16:40:43 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 16:40:43 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 16:40:43 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 16:40:43 INFO - 'COMPUTERNAME': 'T-W732-IX-076', 16:40:43 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 16:40:43 INFO - 'CYGWINBASE': 'C:\\cygwin', 16:40:43 INFO - 'DCLOCATION': 'SCL3', 16:40:43 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 16:40:43 INFO - 'FP_NO_HOST_CHECK': 'NO', 16:40:43 INFO - 'HOMEDRIVE': 'C:', 16:40:43 INFO - 'HOMEPATH': '\\Users\\cltbld', 16:40:43 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 16:40:43 INFO - 'KTS_VERSION': '1.19c', 16:40:43 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 16:40:43 INFO - 'LOGONSERVER': '\\\\T-W732-IX-076', 16:40:43 INFO - 'MONDIR': 'C:\\Monitor_config\\', 16:40:43 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 16:40:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:43 INFO - 'MOZ_NO_REMOTE': '1', 16:40:43 INFO - 'NO_EM_RESTART': '1', 16:40:43 INFO - 'NUMBER_OF_PROCESSORS': '8', 16:40:43 INFO - 'OS': 'Windows_NT', 16:40:43 INFO - 'OURDRIVE': 'C:', 16:40:43 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;', 16:40:43 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 16:40:43 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 16:40:43 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 16:40:43 INFO - 'PROCESSOR_LEVEL': '6', 16:40:43 INFO - 'PROCESSOR_REVISION': '1e05', 16:40:43 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 16:40:43 INFO - 'PROGRAMFILES': 'C:\\Program Files', 16:40:43 INFO - 'PROMPT': '$P$G', 16:40:43 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 16:40:43 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 16:40:43 INFO - 'PUBLIC': 'C:\\Users\\Public', 16:40:43 INFO - 'PWD': 'C:\\slave\\test-pgo', 16:40:43 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 16:40:43 INFO - 'SLAVEDIR': 'C:\\slave\\', 16:40:43 INFO - 'SYSTEMDRIVE': 'C:', 16:40:43 INFO - 'SYSTEMROOT': 'C:\\windows', 16:40:43 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 16:40:43 INFO - 'TEST1': 'testie', 16:40:43 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 16:40:43 INFO - 'USERDOMAIN': 'T-W732-IX-076', 16:40:43 INFO - 'USERNAME': 'cltbld', 16:40:43 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 16:40:43 INFO - 'WINDIR': 'C:\\windows', 16:40:43 INFO - 'WINDOWS_TRACING_FLAGS': '3', 16:40:43 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 16:40:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 16:40:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:40:43 INFO - Downloading/unpacking blobuploader==1.2.4 16:40:43 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 16:40:43 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 16:40:45 INFO - Downloading blobuploader-1.2.4.tar.gz 16:40:45 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 16:40:45 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader 16:40:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:40:45 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 16:40:45 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 16:40:46 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 16:40:46 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\requests\setup.py) egg_info for package requests 16:40:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:40:46 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 16:40:46 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 16:40:46 INFO - Downloading docopt-0.6.1.tar.gz 16:40:46 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 16:40:47 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\docopt\setup.py) egg_info for package docopt 16:40:47 INFO - Installing collected packages: blobuploader, requests, docopt 16:40:47 INFO - Running setup.py install for blobuploader 16:40:47 INFO - Running setup.py install for requests 16:40:47 INFO - Running setup.py install for docopt 16:40:48 INFO - Successfully installed blobuploader requests docopt 16:40:48 INFO - Cleaning up... 16:40:49 INFO - Return code: 0 16:40:49 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv 16:40:49 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')]} 16:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:40:49 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')]} 16:40:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:40:49 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--no-deps', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test-pgo\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x019A8B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01968EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0134E8C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01268B48>, '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 0x0128A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01A29660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-076', 'USERDOMAIN': 'T-W732-IX-076', '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-076', '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 16:40:49 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 16:40:49 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 16:40:49 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 16:40:49 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 16:40:49 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 16:40:49 INFO - 'COMPUTERNAME': 'T-W732-IX-076', 16:40:49 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 16:40:49 INFO - 'CYGWINBASE': 'C:\\cygwin', 16:40:49 INFO - 'DCLOCATION': 'SCL3', 16:40:49 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 16:40:49 INFO - 'FP_NO_HOST_CHECK': 'NO', 16:40:49 INFO - 'HOMEDRIVE': 'C:', 16:40:49 INFO - 'HOMEPATH': '\\Users\\cltbld', 16:40:49 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 16:40:49 INFO - 'KTS_VERSION': '1.19c', 16:40:49 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 16:40:49 INFO - 'LOGONSERVER': '\\\\T-W732-IX-076', 16:40:49 INFO - 'MONDIR': 'C:\\Monitor_config\\', 16:40:49 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 16:40:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:49 INFO - 'MOZ_NO_REMOTE': '1', 16:40:49 INFO - 'NO_EM_RESTART': '1', 16:40:49 INFO - 'NUMBER_OF_PROCESSORS': '8', 16:40:49 INFO - 'OS': 'Windows_NT', 16:40:49 INFO - 'OURDRIVE': 'C:', 16:40:49 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 16:40:49 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 16:40:49 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 16:40:49 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 16:40:49 INFO - 'PROCESSOR_LEVEL': '6', 16:40:49 INFO - 'PROCESSOR_REVISION': '1e05', 16:40:49 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 16:40:49 INFO - 'PROGRAMFILES': 'C:\\Program Files', 16:40:49 INFO - 'PROMPT': '$P$G', 16:40:49 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 16:40:49 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 16:40:49 INFO - 'PUBLIC': 'C:\\Users\\Public', 16:40:49 INFO - 'PWD': 'C:\\slave\\test-pgo', 16:40:49 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 16:40:49 INFO - 'SLAVEDIR': 'C:\\slave\\', 16:40:49 INFO - 'SYSTEMDRIVE': 'C:', 16:40:49 INFO - 'SYSTEMROOT': 'C:\\windows', 16:40:49 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 16:40:49 INFO - 'TEST1': 'testie', 16:40:49 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 16:40:49 INFO - 'USERDOMAIN': 'T-W732-IX-076', 16:40:49 INFO - 'USERNAME': 'cltbld', 16:40:49 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 16:40:49 INFO - 'WINDIR': 'C:\\windows', 16:40:49 INFO - 'WINDOWS_TRACING_FLAGS': '3', 16:40:49 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 16:40:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 16:40:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:40:49 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\manifestparser 16:40:49 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-h__ju3-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/manifestparser 16:40:49 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozcrash 16:40:49 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-yl8t7w-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozcrash 16:40:49 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdebug 16:40:49 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-phb2p9-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdebug 16:40:50 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdevice 16:40:50 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-bfzque-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdevice 16:40:50 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozfile 16:40:50 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-lf4tc_-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozfile 16:40:50 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozhttpd 16:40:50 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-9xq6sz-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozhttpd 16:40:50 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinfo 16:40:50 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-hk_64b-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinfo 16:40:50 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinstall 16:40:50 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-g6dvwt-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinstall 16:40:51 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozleak 16:40:51 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-se9wcp-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozleak 16:40:51 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozlog 16:40:51 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-ayqbr8-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozlog 16:40:51 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moznetwork 16:40:51 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-2jf0ti-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moznetwork 16:40:51 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprocess 16:40:51 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-evqvm9-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprocess 16:40:51 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprofile 16:40:51 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-a_idr1-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprofile 16:40:51 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozrunner 16:40:51 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-qxyrzl-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozrunner 16:40:51 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozscreenshot 16:40:51 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-msqjch-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:40:52 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moztest 16:40:52 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-bv43iw-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moztest 16:40:52 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozversion 16:40:52 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-jqq2h_-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozversion 16:40:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:40:52 INFO - Running setup.py install for manifestparser 16:40:52 INFO - Installing manifestparser-script.py script to C:\slave\test-pgo\build\venv\Scripts 16:40:52 INFO - Installing manifestparser.exe script to C:\slave\test-pgo\build\venv\Scripts 16:40:53 INFO - Running setup.py install for mozcrash 16:40:53 INFO - Running setup.py install for mozdebug 16:40:53 INFO - Running setup.py install for mozdevice 16:40:53 INFO - Installing sutini-script.py script to C:\slave\test-pgo\build\venv\Scripts 16:40:53 INFO - Installing sutini.exe script to C:\slave\test-pgo\build\venv\Scripts 16:40:53 INFO - Installing dm-script.py script to C:\slave\test-pgo\build\venv\Scripts 16:40:53 INFO - Installing dm.exe script to C:\slave\test-pgo\build\venv\Scripts 16:40:54 INFO - Running setup.py install for mozfile 16:40:54 INFO - Running setup.py install for mozhttpd 16:40:54 INFO - Installing mozhttpd-script.py script to C:\slave\test-pgo\build\venv\Scripts 16:40:54 INFO - Installing mozhttpd.exe script to C:\slave\test-pgo\build\venv\Scripts 16:40:55 INFO - Running setup.py install for mozinfo 16:40:55 INFO - Installing mozinfo-script.py script to C:\slave\test-pgo\build\venv\Scripts 16:40:55 INFO - Installing mozinfo.exe script to C:\slave\test-pgo\build\venv\Scripts 16:40:55 INFO - Running setup.py install for mozInstall 16:40:55 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test-pgo\build\venv\Scripts 16:40:55 INFO - Installing moz_remove_from_system.exe script to C:\slave\test-pgo\build\venv\Scripts 16:40:55 INFO - Installing mozuninstall-script.py script to C:\slave\test-pgo\build\venv\Scripts 16:40:55 INFO - Installing mozuninstall.exe script to C:\slave\test-pgo\build\venv\Scripts 16:40:55 INFO - Installing mozinstall-script.py script to C:\slave\test-pgo\build\venv\Scripts 16:40:55 INFO - Installing mozinstall.exe script to C:\slave\test-pgo\build\venv\Scripts 16:40:55 INFO - Installing moz_add_to_system-script.py script to C:\slave\test-pgo\build\venv\Scripts 16:40:55 INFO - Installing moz_add_to_system.exe script to C:\slave\test-pgo\build\venv\Scripts 16:40:55 INFO - Running setup.py install for mozleak 16:40:56 INFO - Running setup.py install for mozlog 16:40:56 INFO - Installing structlog-script.py script to C:\slave\test-pgo\build\venv\Scripts 16:40:56 INFO - Installing structlog.exe script to C:\slave\test-pgo\build\venv\Scripts 16:40:57 INFO - Running setup.py install for moznetwork 16:40:57 INFO - Installing moznetwork-script.py script to C:\slave\test-pgo\build\venv\Scripts 16:40:57 INFO - Installing moznetwork.exe script to C:\slave\test-pgo\build\venv\Scripts 16:40:57 INFO - Running setup.py install for mozprocess 16:40:57 INFO - Running setup.py install for mozprofile 16:40:58 INFO - Installing mozprofile-script.py script to C:\slave\test-pgo\build\venv\Scripts 16:40:58 INFO - Installing mozprofile.exe script to C:\slave\test-pgo\build\venv\Scripts 16:40:58 INFO - Installing diff-profiles-script.py script to C:\slave\test-pgo\build\venv\Scripts 16:40:58 INFO - Installing diff-profiles.exe script to C:\slave\test-pgo\build\venv\Scripts 16:40:58 INFO - Installing view-profile-script.py script to C:\slave\test-pgo\build\venv\Scripts 16:40:58 INFO - Installing view-profile.exe script to C:\slave\test-pgo\build\venv\Scripts 16:40:58 INFO - Running setup.py install for mozrunner 16:40:58 INFO - Installing mozrunner-script.py script to C:\slave\test-pgo\build\venv\Scripts 16:40:58 INFO - Installing mozrunner.exe script to C:\slave\test-pgo\build\venv\Scripts 16:40:59 INFO - Running setup.py install for mozscreenshot 16:40:59 INFO - Running setup.py install for moztest 16:40:59 INFO - Running setup.py install for mozversion 16:41:00 INFO - Installing mozversion-script.py script to C:\slave\test-pgo\build\venv\Scripts 16:41:00 INFO - Installing mozversion.exe script to C:\slave\test-pgo\build\venv\Scripts 16:41:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:41:00 INFO - Cleaning up... 16:41:00 INFO - Return code: 0 16:41:00 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv 16:41:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:41:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:41:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:41:00 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test-pgo\\build\\tests\\config\\mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x019A8B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01968EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0134E8C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01268B48>, '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 0x0128A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01A29660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-076', 'USERDOMAIN': 'T-W732-IX-076', '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-076', '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 16:41:00 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 16:41:00 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 16:41:00 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 16:41:00 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 16:41:00 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 16:41:00 INFO - 'COMPUTERNAME': 'T-W732-IX-076', 16:41:00 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 16:41:00 INFO - 'CYGWINBASE': 'C:\\cygwin', 16:41:00 INFO - 'DCLOCATION': 'SCL3', 16:41:00 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 16:41:00 INFO - 'FP_NO_HOST_CHECK': 'NO', 16:41:00 INFO - 'HOMEDRIVE': 'C:', 16:41:00 INFO - 'HOMEPATH': '\\Users\\cltbld', 16:41:00 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 16:41:00 INFO - 'KTS_VERSION': '1.19c', 16:41:00 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 16:41:00 INFO - 'LOGONSERVER': '\\\\T-W732-IX-076', 16:41:00 INFO - 'MONDIR': 'C:\\Monitor_config\\', 16:41:00 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 16:41:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:41:00 INFO - 'MOZ_NO_REMOTE': '1', 16:41:00 INFO - 'NO_EM_RESTART': '1', 16:41:00 INFO - 'NUMBER_OF_PROCESSORS': '8', 16:41:00 INFO - 'OS': 'Windows_NT', 16:41:00 INFO - 'OURDRIVE': 'C:', 16:41:00 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 16:41:00 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 16:41:00 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 16:41:00 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 16:41:00 INFO - 'PROCESSOR_LEVEL': '6', 16:41:00 INFO - 'PROCESSOR_REVISION': '1e05', 16:41:00 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 16:41:00 INFO - 'PROGRAMFILES': 'C:\\Program Files', 16:41:00 INFO - 'PROMPT': '$P$G', 16:41:00 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 16:41:00 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 16:41:00 INFO - 'PUBLIC': 'C:\\Users\\Public', 16:41:00 INFO - 'PWD': 'C:\\slave\\test-pgo', 16:41:00 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 16:41:00 INFO - 'SLAVEDIR': 'C:\\slave\\', 16:41:00 INFO - 'SYSTEMDRIVE': 'C:', 16:41:00 INFO - 'SYSTEMROOT': 'C:\\windows', 16:41:00 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 16:41:00 INFO - 'TEST1': 'testie', 16:41:00 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 16:41:00 INFO - 'USERDOMAIN': 'T-W732-IX-076', 16:41:00 INFO - 'USERNAME': 'cltbld', 16:41:00 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 16:41:00 INFO - 'WINDIR': 'C:\\windows', 16:41:00 INFO - 'WINDOWS_TRACING_FLAGS': '3', 16:41:00 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 16:41:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 16:41:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:41:00 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\manifestparser 16:41:00 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-m1lwz5-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/manifestparser 16:41:00 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)) 16:41:00 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozcrash 16:41:00 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-1gkijt-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozcrash 16:41:01 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)) 16:41:01 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdebug 16:41:01 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-9qgoll-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdebug 16:41:01 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)) 16:41:01 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdevice 16:41:01 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-57vfpw-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdevice 16:41:01 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)) 16:41:01 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozfile 16:41:01 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-uvm22x-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozfile 16:41:01 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)) 16:41:01 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozhttpd 16:41:01 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-oida8e-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozhttpd 16:41:01 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)) 16:41:01 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinfo 16:41:01 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-lint6k-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinfo 16:41:01 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)) 16:41:01 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinstall 16:41:01 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-h45usp-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinstall 16:41:01 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)) 16:41:01 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozleak 16:41:01 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-zyeevk-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozleak 16:41:02 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)) 16:41:02 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozlog 16:41:02 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-lf6g9o-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozlog 16:41:02 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)) 16:41:02 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moznetwork 16:41:02 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-4rysrt-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moznetwork 16:41:02 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)) 16:41:02 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprocess 16:41:02 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-obyfin-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprocess 16:41:02 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)) 16:41:02 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprofile 16:41:02 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-u5dhlh-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprofile 16:41:02 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)) 16:41:02 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozrunner 16:41:02 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-33buky-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozrunner 16:41:02 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)) 16:41:02 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozscreenshot 16:41:02 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-8hqamq-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:41:02 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)) 16:41:02 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moztest 16:41:03 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-fmkupn-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moztest 16:41:03 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)) 16:41:03 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozversion 16:41:03 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-h5175h-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozversion 16:41:03 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)) 16:41:03 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)) 16:41:03 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)) 16:41:03 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)) 16:41:03 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)) 16:41:03 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)) 16:41:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 10)) 16:41:03 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 16:41:03 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 16:41:04 INFO - Downloading blessings-1.5.1.tar.gz 16:41:04 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 16:41:04 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\blessings\setup.py) egg_info for package blessings 16:41:04 INFO - Installing collected packages: blessings 16:41:04 INFO - Running setup.py install for blessings 16:41:04 INFO - Successfully installed blessings 16:41:04 INFO - Cleaning up... 16:41:07 INFO - Return code: 0 16:41:07 INFO - Done creating virtualenv C:\slave\test-pgo\build/venv. 16:41:07 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'freeze'] 16:41:07 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip freeze 16:41:07 INFO - Reading from file tmpfile_stdout 16:41:07 INFO - Using _rmtree_windows ... 16:41:07 INFO - Using _rmtree_windows ... 16:41:07 INFO - Current package versions: 16:41:07 INFO - blessings == 1.5.1 16:41:07 INFO - blobuploader == 1.2.4 16:41:07 INFO - docopt == 0.6.1 16:41:07 INFO - manifestparser == 1.1 16:41:07 INFO - mozInstall == 1.12 16:41:07 INFO - mozcrash == 0.16 16:41:07 INFO - mozdebug == 0.1 16:41:07 INFO - mozdevice == 0.46 16:41:07 INFO - mozfile == 1.2 16:41:07 INFO - mozhttpd == 0.7 16:41:07 INFO - mozinfo == 0.8 16:41:07 INFO - mozleak == 0.1 16:41:07 INFO - mozlog == 3.0 16:41:07 INFO - moznetwork == 0.27 16:41:07 INFO - mozprocess == 0.22 16:41:07 INFO - mozprofile == 0.27 16:41:07 INFO - mozrunner == 6.10 16:41:07 INFO - mozscreenshot == 0.1 16:41:07 INFO - mozsystemmonitor == 0.0 16:41:07 INFO - moztest == 0.7 16:41:07 INFO - mozversion == 1.4 16:41:07 INFO - psutil == 3.1.1 16:41:07 INFO - requests == 1.2.3 16:41:07 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv 16:41:07 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')]} 16:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:41:07 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')]} 16:41:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:41:07 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test-pgo\\build\\tests\\talos\\requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x019A8B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01968EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x0134E8C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01268B48>, '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 0x0128A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01A29660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build\\tests\\talos', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-076', 'USERDOMAIN': 'T-W732-IX-076', '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-076', '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 16:41:07 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 16:41:07 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 16:41:07 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 16:41:07 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 16:41:07 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 16:41:07 INFO - 'COMPUTERNAME': 'T-W732-IX-076', 16:41:07 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 16:41:07 INFO - 'CYGWINBASE': 'C:\\cygwin', 16:41:07 INFO - 'DCLOCATION': 'SCL3', 16:41:07 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 16:41:07 INFO - 'FP_NO_HOST_CHECK': 'NO', 16:41:07 INFO - 'HOMEDRIVE': 'C:', 16:41:07 INFO - 'HOMEPATH': '\\Users\\cltbld', 16:41:07 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 16:41:07 INFO - 'KTS_VERSION': '1.19c', 16:41:07 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 16:41:07 INFO - 'LOGONSERVER': '\\\\T-W732-IX-076', 16:41:07 INFO - 'MONDIR': 'C:\\Monitor_config\\', 16:41:07 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 16:41:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:41:07 INFO - 'MOZ_NO_REMOTE': '1', 16:41:07 INFO - 'NO_EM_RESTART': '1', 16:41:07 INFO - 'NUMBER_OF_PROCESSORS': '8', 16:41:07 INFO - 'OS': 'Windows_NT', 16:41:07 INFO - 'OURDRIVE': 'C:', 16:41:07 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 16:41:07 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 16:41:07 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 16:41:07 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 16:41:07 INFO - 'PROCESSOR_LEVEL': '6', 16:41:07 INFO - 'PROCESSOR_REVISION': '1e05', 16:41:07 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 16:41:07 INFO - 'PROGRAMFILES': 'C:\\Program Files', 16:41:07 INFO - 'PROMPT': '$P$G', 16:41:07 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 16:41:07 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 16:41:07 INFO - 'PUBLIC': 'C:\\Users\\Public', 16:41:07 INFO - 'PWD': 'C:\\slave\\test-pgo', 16:41:07 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 16:41:07 INFO - 'SLAVEDIR': 'C:\\slave\\', 16:41:07 INFO - 'SYSTEMDRIVE': 'C:', 16:41:07 INFO - 'SYSTEMROOT': 'C:\\windows', 16:41:07 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 16:41:07 INFO - 'TEST1': 'testie', 16:41:07 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 16:41:07 INFO - 'USERDOMAIN': 'T-W732-IX-076', 16:41:07 INFO - 'USERNAME': 'cltbld', 16:41:07 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 16:41:07 INFO - 'WINDIR': 'C:\\windows', 16:41:07 INFO - 'WINDOWS_TRACING_FLAGS': '3', 16:41:07 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 16:41:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 16:41:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:41:08 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)) 16:41:08 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)) 16:41:08 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)) 16:41:08 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)) 16:41:08 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)) 16:41:08 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)) 16:41:08 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)) 16:41:08 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)) 16:41:08 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)) 16:41:08 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)) 16:41:08 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)) 16:41:08 INFO - Cleaning up... 16:41:08 INFO - Return code: 0 16:41:08 INFO - Running post-action listener: _resource_record_post_action 16:41:08 INFO - Running post-action listener: _start_resource_monitoring 16:41:08 INFO - Starting resource monitoring. 16:41:08 INFO - ##### 16:41:08 INFO - ##### Running install step. 16:41:08 INFO - ##### 16:41:08 INFO - Running pre-action listener: _resource_record_pre_action 16:41:08 INFO - Running main action method: install 16:41:08 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'freeze'] 16:41:08 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip freeze 16:41:08 INFO - Reading from file tmpfile_stdout 16:41:08 INFO - Using _rmtree_windows ... 16:41:08 INFO - Using _rmtree_windows ... 16:41:08 INFO - Detecting whether we're running mozinstall >=1.0... 16:41:08 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build/venv/scripts/python', 'C:\\slave\\test-pgo\\build/venv/scripts/mozinstall-script.py', '-h'] 16:41:08 INFO - Copy/paste: C:\slave\test-pgo\build/venv/scripts/python C:\slave\test-pgo\build/venv/scripts/mozinstall-script.py -h 16:41:08 INFO - Reading from file tmpfile_stdout 16:41:08 INFO - Output received: 16:41:08 INFO - Usage: mozinstall-script.py [options] installer 16:41:08 INFO - Options: 16:41:08 INFO - -h, --help show this help message and exit 16:41:08 INFO - -d DEST, --destination=DEST 16:41:08 INFO - Directory to install application into. [default: 16:41:08 INFO - "C:\slave\test-pgo"] 16:41:08 INFO - --app=APP Application being installed. [default: firefox] 16:41:08 INFO - Using _rmtree_windows ... 16:41:08 INFO - Using _rmtree_windows ... 16:41:08 INFO - mkdir: C:\slave\test-pgo\build\application 16:41:08 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'] 16:41:08 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 16:41:11 INFO - Reading from file tmpfile_stdout 16:41:11 INFO - Output received: 16:41:11 INFO - C:\slave\test-pgo\build\application\firefox\firefox.exe 16:41:11 INFO - Using _rmtree_windows ... 16:41:11 INFO - Using _rmtree_windows ... 16:41:11 INFO - Running post-action listener: _resource_record_post_action 16:41:11 INFO - ##### 16:41:11 INFO - ##### Running run-tests step. 16:41:11 INFO - ##### 16:41:11 INFO - Running pre-action listener: _resource_record_pre_action 16:41:11 INFO - Running main action method: run_tests 16:41:11 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\python', '--version'] 16:41:11 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\python --version 16:41:11 INFO - Python 2.7.3 16:41:11 INFO - Return code: 0 16:41:11 INFO - grabbing minidump binary from tooltool 16:41:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:41:11 INFO - retry: Calling run_command with args: (['c:/mozilla-build/python27/python.exe', 'C:/mozilla-build/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', 'c:\\builds\\relengapi.tok', 'fetch', '-m', 'C:\\slave\\test-pgo\\build\\tests\\config/tooltool-manifests/win32/releng.manifest', '-o'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01268B48>, '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 0x0128A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01A29660>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'privileged': False}, attempt #1 16:41:11 INFO - Running command: ['c:/mozilla-build/python27/python.exe', 'C:/mozilla-build/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', 'c:\\builds\\relengapi.tok', 'fetch', '-m', 'C:\\slave\\test-pgo\\build\\tests\\config/tooltool-manifests/win32/releng.manifest', '-o'] in C:\slave\test-pgo\build 16:41:11 INFO - Copy/paste: c:/mozilla-build/python27/python.exe C:/mozilla-build/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file c:\builds\relengapi.tok fetch -m C:\slave\test-pgo\build\tests\config/tooltool-manifests/win32/releng.manifest -o 16:41:11 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 16:41:11 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test-pgo\build\tmpqfr_oe 16:41:11 INFO - INFO - File integrity verified, renaming tmpqfr_oe to win32-minidump_stackwalk.exe 16:41:11 INFO - Return code: 0 16:41:11 INFO - Chmoding C:\slave\test-pgo\build\win32-minidump_stackwalk.exe to 0755 16:41:11 INFO - mkdir: C:\slave\test-pgo\build\blobber_upload_dir 16:41:11 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test-pgo\build\blobber_upload_dir 16:41:11 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test-pgo\build\win32-minidump_stackwalk.exe 16:41:11 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test-pgo\build\blobber_upload_dir 16:41:11 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/x-xhZbI1RrKYkKYgXsUrcw/artifacts/public/build/firefox-44.0a1.en-US.win32.crashreporter-symbols.zip', '--title', 'T-W732-IX-076', '--webServer', 'localhost'] in C:\slave\test-pgo\build 16:41:11 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/x-xhZbI1RrKYkKYgXsUrcw/artifacts/public/build/firefox-44.0a1.en-US.win32.crashreporter-symbols.zip --title T-W732-IX-076 --webServer localhost 16:41:11 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 16:41:11 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 16:41:11 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 16:41:11 INFO - 'COMPUTERNAME': 'T-W732-IX-076', 16:41:11 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 16:41:11 INFO - 'CYGWINBASE': 'C:\\cygwin', 16:41:11 INFO - 'DCLOCATION': 'SCL3', 16:41:11 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 16:41:11 INFO - 'FP_NO_HOST_CHECK': 'NO', 16:41:11 INFO - 'HOMEDRIVE': 'C:', 16:41:11 INFO - 'HOMEPATH': '\\Users\\cltbld', 16:41:11 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 16:41:11 INFO - 'KTS_VERSION': '1.19c', 16:41:11 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 16:41:11 INFO - 'LOGONSERVER': '\\\\T-W732-IX-076', 16:41:11 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test-pgo\\build\\blobber_upload_dir', 16:41:11 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test-pgo\\build\\win32-minidump_stackwalk.exe', 16:41:11 INFO - 'MONDIR': 'C:\\Monitor_config\\', 16:41:11 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 16:41:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:41:11 INFO - 'MOZ_NO_REMOTE': '1', 16:41:11 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test-pgo\\build\\blobber_upload_dir', 16:41:11 INFO - 'NO_EM_RESTART': '1', 16:41:11 INFO - 'NUMBER_OF_PROCESSORS': '8', 16:41:11 INFO - 'OS': 'Windows_NT', 16:41:11 INFO - 'OURDRIVE': 'C:', 16:41:11 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 16:41:11 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 16:41:11 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 16:41:11 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 16:41:11 INFO - 'PROCESSOR_LEVEL': '6', 16:41:11 INFO - 'PROCESSOR_REVISION': '1e05', 16:41:11 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 16:41:11 INFO - 'PROGRAMFILES': 'C:\\Program Files', 16:41:11 INFO - 'PROMPT': '$P$G', 16:41:11 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 16:41:11 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 16:41:11 INFO - 'PUBLIC': 'C:\\Users\\Public', 16:41:11 INFO - 'PWD': 'C:\\slave\\test-pgo', 16:41:11 INFO - 'PYTHONPATH': 'C:\\slave\\test-pgo\\build\\tests\\talos', 16:41:11 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 16:41:11 INFO - 'SLAVEDIR': 'C:\\slave\\', 16:41:11 INFO - 'SYSTEMDRIVE': 'C:', 16:41:11 INFO - 'SYSTEMROOT': 'C:\\windows', 16:41:11 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 16:41:11 INFO - 'TEST1': 'testie', 16:41:11 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 16:41:11 INFO - 'USERDOMAIN': 'T-W732-IX-076', 16:41:11 INFO - 'USERNAME': 'cltbld', 16:41:11 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 16:41:11 INFO - 'WINDIR': 'C:\\windows', 16:41:11 INFO - 'WINDOWS_TRACING_FLAGS': '3', 16:41:11 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 16:41:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 16:41:11 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/x-xhZbI1RrKYkKYgXsUrcw/artifacts/public/build/firefox-44.0a1.en-US.win32.crashreporter-symbols.zip', '--title', 'T-W732-IX-076', '--webServer', 'localhost'] with output_timeout 3600 16:41:12 INFO - mozversion INFO | application_buildid: 20151021113233 16:41:12 INFO - mozversion INFO | application_changeset: 4babd5d32cc121f287363f63217c19029f848577 16:41:12 INFO - mozversion INFO | application_display_name: Nightly 16:41:12 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:41:12 INFO - mozversion INFO | application_name: Firefox 16:41:12 INFO - mozversion INFO | application_remotingname: firefox 16:41:12 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 16:41:12 INFO - mozversion INFO | application_vendor: Mozilla 16:41:12 INFO - mozversion INFO | application_version: 44.0a1 16:41:12 INFO - mozversion INFO | platform_buildid: 20151021113233 16:41:12 INFO - mozversion INFO | platform_changeset: 4babd5d32cc121f287363f63217c19029f848577 16:41:12 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 16:41:12 INFO - mozversion INFO | platform_version: 44.0a1 16:41:12 INFO - 2015-10-21 16:41:12,618 DEBUG : using testdate: 1445470872 16:41:12 INFO - 2015-10-21 16:41:12,618 DEBUG : actual date: 1445470872 16:41:12 INFO - 2015-10-21 16:41:12,670 INFO : starting webserver on 'localhost:49744' 16:41:12 INFO - 2015-10-21 16:41:12,671 INFO : Starting test suite T-W732-IX-076 16:41:12 INFO - 2015-10-21 16:41:12,671 INFO : Starting test dromaeo_css 16:41:12 INFO - 2015-10-21 16:41:12,671 DEBUG : operating with platform_type : w7_ 16:41:12 INFO - 2015-10-21 16:41:12,673 INFO : Initialising browser for dromaeo_css test... 16:41:12 INFO - 2015-10-21 16:41:12,769 DEBUG : command line: C:\slave\test-pgo\build\application\firefox\firefox -profile c:\users\cltbld\appdata\local\temp\tmpvis7g4\profile http://localhost:49744/getInfo.html 16:41:20 INFO - 2015-10-21 16:41:20,651 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:41:20 INFO - 2015-10-21 16:41:20,651 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:41:20 INFO - 2015-10-21 16:41:20,651 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674 16:41:20 INFO - 2015-10-21 16:41:20,651 DEBUG : BROWSER_OUTPUT: __metrics 16:41:20 INFO - 2015-10-21 16:41:20,719 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:41:21 INFO - 2015-10-21 16:41:21,838 DEBUG : BROWSER_OUTPUT: console.error: 16:41:21 INFO - 2015-10-21 16:41:21,838 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] 16:41:21 INFO - 2015-10-21 16:41:21,838 DEBUG : BROWSER_OUTPUT: Stack: 16:41:21 INFO - 2015-10-21 16:41:21,838 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<._executeStatement@resource://gre/modules/Sqlite.jsm:758:19 16:41:21 INFO - 2015-10-21 16:41:21,838 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached/<@resource://gre/modules/Sqlite.jsm:493:9 16:41:21 INFO - 2015-10-21 16:41:21,838 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached@resource://gre/modules/Sqlite.jsm:491:1 16:41:21 INFO - 2015-10-21 16:41:21,838 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeBeforeShutdown/loggedDb<.executeCached.value<@resource://gre/modules/Sqlite.jsm:368:51 16:41:21 INFO - 2015-10-21 16:41:21,838 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 16:41:21 INFO - 2015-10-21 16:41:21,838 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 16:41:21 INFO - 2015-10-21 16:41:21,838 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 16:41:21 INFO - 2015-10-21 16:41:21,838 DEBUG : BROWSER_OUTPUT: transaction@resource://gre/modules/Bookmarks.jsm:783:15 16:41:21 INFO - 2015-10-21 16:41:21,838 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 16:41:21 INFO - 2015-10-21 16:41:21,838 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 16:41:21 INFO - 2015-10-21 16:41:21,838 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 16:41:21 INFO - 2015-10-21 16:41:21,838 DEBUG : BROWSER_OUTPUT: Task_spawn@resource://gre/modules/Task.jsm:164:12 16:41:21 INFO - 2015-10-21 16:41:21,838 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 16:59:55 INFO - 2015-10-21 16:59:55,605 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 16:59:55 INFO - 2015-10-21 16:59:55,605 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 16:59:55 INFO - 2015-10-21 16:59:55,605 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 16:59:55 INFO - 2015-10-21 16:59:55,605 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 16:59:55 INFO - 2015-10-21 16:59:55,605 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 16:59:55 INFO - 2015-10-21 16:59:55,605 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 16:59:55 INFO - 2015-10-21 16:59:55,605 DEBUG : BROWSER_OUTPUT: 16:59:56 INFO - 2015-10-21 16:59:56,226 INFO : Browser initialized. 16:59:56 INFO - 2015-10-21 16:59:56,226 INFO : Running cycle 1/1 for kraken test... 16:59:56 INFO - 2015-10-21 16:59:56,226 DEBUG : command line: C:\slave\test-pgo\build\application\firefox\firefox -profile c:\users\cltbld\appdata\local\temp\tmporntzw\profile -tp file:\C:\slave\test-pgo\build\tests\talos\talos\tests\kraken\kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:00:07 INFO - 2015-10-21 17:00:07,621 DEBUG : BROWSER_OUTPUT: RSS: Main: 127336448 17:00:07 INFO - 2015-10-21 17:00:07,621 DEBUG : BROWSER_OUTPUT: 17:00:09 INFO - 2015-10-21 17:00:09,969 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49744/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49744/tests/kraken/driver.html?testName=audio-beat-detection) 17:00:10 INFO - 2015-10-21 17:00:10,543 DEBUG : BROWSER_OUTPUT: RSS: Main: 162091008 17:00:10 INFO - 2015-10-21 17:00:10,543 DEBUG : BROWSER_OUTPUT: 17:00:13 INFO - 2015-10-21 17:00:13,098 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49744/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49744/tests/kraken/driver.html?testName=audio-dft) 17:00:13 INFO - 2015-10-21 17:00:13,657 DEBUG : BROWSER_OUTPUT: RSS: Main: 165142528 17:00:13 INFO - 2015-10-21 17:00:13,657 DEBUG : BROWSER_OUTPUT: 17:00:16 INFO - 2015-10-21 17:00:16,413 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49744/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49744/tests/kraken/driver.html?testName=audio-fft) 17:00:16 INFO - 2015-10-21 17:00:16,987 DEBUG : BROWSER_OUTPUT: RSS: Main: 161087488 17:00:16 INFO - 2015-10-21 17:00:16,987 DEBUG : BROWSER_OUTPUT: 17:00:18 INFO - 2015-10-21 17:00:18,994 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49744/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49744/tests/kraken/driver.html?testName=audio-oscillator) 17:00:19 INFO - 2015-10-21 17:00:19,555 DEBUG : BROWSER_OUTPUT: RSS: Main: 155328512 17:00:19 INFO - 2015-10-21 17:00:19,555 DEBUG : BROWSER_OUTPUT: 17:00:21 INFO - 2015-10-21 17:00:21,677 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49744/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49744/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:00:22 INFO - 2015-10-21 17:00:22,233 DEBUG : BROWSER_OUTPUT: RSS: Main: 152838144 17:00:22 INFO - 2015-10-21 17:00:22,233 DEBUG : BROWSER_OUTPUT: 17:00:25 INFO - 2015-10-21 17:00:25,328 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49744/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49744/tests/kraken/driver.html?testName=imaging-darkroom) 17:00:25 INFO - 2015-10-21 17:00:25,895 DEBUG : BROWSER_OUTPUT: RSS: Main: 149852160 17:00:25 INFO - 2015-10-21 17:00:25,895 DEBUG : BROWSER_OUTPUT: 17:00:29 INFO - 2015-10-21 17:00:29,196 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49744/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49744/tests/kraken/driver.html?testName=imaging-desaturate) 17:00:29 INFO - 2015-10-21 17:00:29,763 DEBUG : BROWSER_OUTPUT: RSS: Main: 150425600 17:00:29 INFO - 2015-10-21 17:00:29,763 DEBUG : BROWSER_OUTPUT: 17:00:32 INFO - 2015-10-21 17:00:32,543 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49744/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49744/tests/kraken/driver.html?testName=json-parse-financial) 17:00:33 INFO - 2015-10-21 17:00:33,111 DEBUG : BROWSER_OUTPUT: RSS: Main: 150306816 17:00:33 INFO - 2015-10-21 17:00:33,111 DEBUG : BROWSER_OUTPUT: 17:00:34 INFO - 2015-10-21 17:00:34,907 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49744/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49744/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:00:35 INFO - 2015-10-21 17:00:35,461 DEBUG : BROWSER_OUTPUT: RSS: Main: 181485568 17:00:35 INFO - 2015-10-21 17:00:35,461 DEBUG : BROWSER_OUTPUT: 17:00:37 INFO - 2015-10-21 17:00:37,345 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49744/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49744/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:00:37 INFO - 2015-10-21 17:00:37,920 DEBUG : BROWSER_OUTPUT: RSS: Main: 186404864 17:00:37 INFO - 2015-10-21 17:00:37,920 DEBUG : BROWSER_OUTPUT: 17:00:40 INFO - 2015-10-21 17:00:40,167 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49744/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49744/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:00:40 INFO - 2015-10-21 17:00:40,730 DEBUG : BROWSER_OUTPUT: RSS: Main: 191352832 17:00:40 INFO - 2015-10-21 17:00:40,730 DEBUG : BROWSER_OUTPUT: 17:00:43 INFO - 2015-10-21 17:00:43,131 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49744/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49744/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:00:43 INFO - 2015-10-21 17:00:43,690 DEBUG : BROWSER_OUTPUT: RSS: Main: 192118784 17:00:43 INFO - 2015-10-21 17:00:43,691 DEBUG : BROWSER_OUTPUT: 17:00:46 INFO - 2015-10-21 17:00:46,719 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49744/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49744/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:00:47 INFO - 2015-10-21 17:00:47,282 DEBUG : BROWSER_OUTPUT: RSS: Main: 193417216 17:00:47 INFO - 2015-10-21 17:00:47,282 DEBUG : BROWSER_OUTPUT: 17:00:49 INFO - 2015-10-21 17:00:49,108 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49744/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49744/tests/kraken/driver.html?testName=ai-astar) 17:00:49 INFO - 2015-10-21 17:00:49,364 DEBUG : BROWSER_OUTPUT: RSS: Main: 239808512 17:00:49 INFO - 2015-10-21 17:00:49,364 DEBUG : BROWSER_OUTPUT: 17:00:49 INFO - 2015-10-21 17:00:49,364 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:00:49 INFO - 2015-10-21 17:00:49,364 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:00:49 INFO - 2015-10-21 17:00:49,364 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:00:49 INFO - 2015-10-21 17:00:49,364 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:00:49 INFO - 2015-10-21 17:00:49,364 DEBUG : BROWSER_OUTPUT: |0;ai-astar;95;88;97;96;93;97;96;98;104;102 17:00:49 INFO - 2015-10-21 17:00:49,364 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;132;131;145;155;130;132;139;133;157;134 17:00:49 INFO - 2015-10-21 17:00:49,364 DEBUG : BROWSER_OUTPUT: |2;audio-dft;158;163;155;156;153;156;153;153;156;154 17:00:49 INFO - 2015-10-21 17:00:49,364 DEBUG : BROWSER_OUTPUT: |3;audio-fft;96;99;81;99;86;76;77;83;102;78 17:00:49 INFO - 2015-10-21 17:00:49,364 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;96;95;113;95;95;95;118;95;95;119 17:00:49 INFO - 2015-10-21 17:00:49,364 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;117;116;117;119;116;116;116;118;117;117 17:00:49 INFO - 2015-10-21 17:00:49,364 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;139;139;139;139;139;139;139;139;139;138 17:00:49 INFO - 2015-10-21 17:00:49,364 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;91;91;92;91;93;91;92;92;90;92 17:00:49 INFO - 2015-10-21 17:00:49,365 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;80;82;81;81;81;81;81;84;81;92 17:00:49 INFO - 2015-10-21 17:00:49,365 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;78;79;79;79;78;78;79;78;78;78 17:00:49 INFO - 2015-10-21 17:00:49,365 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;97;97;96;97;98;100;96;98;97;97 17:00:49 INFO - 2015-10-21 17:00:49,365 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;118;120;118;120;123;119;122;122;121 17:00:49 INFO - 2015-10-21 17:00:49,365 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;185;202;193;192;192;191;194;196;195;187 17:00:49 INFO - 2015-10-21 17:00:49,365 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;85;85;83;84;84;84;84;84;85;84 17:00:49 INFO - 2015-10-21 17:00:49,365 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:00:49 INFO - 2015-10-21 17:00:49,365 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:00:49 INFO - 2015-10-21 17:00:49,365 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,807 17:00:49 INFO - 2015-10-21 17:00:49,365 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:00:49 INFO - 2015-10-21 17:00:49,365 DEBUG : BROWSER_OUTPUT: __startTimestamp1445472049364__endTimestamp 17:00:49 INFO - 2015-10-21 17:00:49,365 DEBUG : BROWSER_OUTPUT: 17:00:49 INFO - 2015-10-21 17:00:49,365 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:00:49 INFO - 2015-10-21 17:00:49,365 DEBUG : BROWSER_OUTPUT: Number of tests: 14 17:00:49 INFO - 2015-10-21 17:00:49,365 DEBUG : BROWSER_OUTPUT: 17:00:49 INFO - 2015-10-21 17:00:49,365 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:96.60 Median:96.00 stddev:4.43 (4.6%) stddev-sans-first:4.66 17:00:49 INFO - 2015-10-21 17:00:49,365 DEBUG : BROWSER_OUTPUT: Values: 95.0 88.0 97.0 96.0 93.0 97.0 96.0 98.0 104.0 102.0 17:00:49 INFO - 2015-10-21 17:00:49,365 DEBUG : BROWSER_OUTPUT: 17:00:49 INFO - 2015-10-21 17:00:49,365 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:138.80 Median:136.50 stddev:10.11 (7.4%) stddev-sans-first:10.42 17:00:49 INFO - 2015-10-21 17:00:49,365 DEBUG : BROWSER_OUTPUT: Values: 132.0 131.0 145.0 155.0 130.0 132.0 139.0 133.0 157.0 134.0 17:00:49 INFO - 2015-10-21 17:00:49,365 DEBUG : BROWSER_OUTPUT: 17:00:49 INFO - 2015-10-21 17:00:49,365 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:155.70 Median:156.00 stddev:3.06 (2.0%) stddev-sans-first:3.13 17:00:49 INFO - 2015-10-21 17:00:49,365 DEBUG : BROWSER_OUTPUT: Values: 158.0 163.0 155.0 156.0 153.0 156.0 153.0 153.0 156.0 154.0 17:00:49 INFO - 2015-10-21 17:00:49,365 DEBUG : BROWSER_OUTPUT: 17:00:49 INFO - 2015-10-21 17:00:49,365 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.70 Median:84.50 stddev:10.24 (12.1%) stddev-sans-first:10.41 17:00:49 INFO - 2015-10-21 17:00:49,365 DEBUG : BROWSER_OUTPUT: Values: 96.0 99.0 81.0 99.0 86.0 76.0 77.0 83.0 102.0 78.0 17:00:49 INFO - 2015-10-21 17:00:49,365 DEBUG : BROWSER_OUTPUT: 17:00:49 INFO - 2015-10-21 17:00:49,365 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:101.60 Median:95.00 stddev:10.51 (11.1%) stddev-sans-first:10.95 17:00:49 INFO - 2015-10-21 17:00:49,365 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 113.0 95.0 95.0 95.0 118.0 95.0 95.0 119.0 17:00:49 INFO - 2015-10-21 17:00:49,367 DEBUG : BROWSER_OUTPUT: 17:00:49 INFO - 2015-10-21 17:00:49,371 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.99 (0.8%) stddev-sans-first:1.05 17:00:49 INFO - 2015-10-21 17:00:49,371 DEBUG : BROWSER_OUTPUT: Values: 117.0 116.0 117.0 119.0 116.0 116.0 116.0 118.0 117.0 117.0 17:00:49 INFO - 2015-10-21 17:00:49,371 DEBUG : BROWSER_OUTPUT: 17:00:49 INFO - 2015-10-21 17:00:49,371 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:138.90 Median:139.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 17:00:49 INFO - 2015-10-21 17:00:49,371 DEBUG : BROWSER_OUTPUT: Values: 139.0 139.0 139.0 139.0 139.0 139.0 139.0 139.0 139.0 138.0 17:00:49 INFO - 2015-10-21 17:00:49,372 DEBUG : BROWSER_OUTPUT: 17:00:49 INFO - 2015-10-21 17:00:49,372 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:91.50 Median:92.00 stddev:0.85 (0.9%) stddev-sans-first:0.88 17:00:49 INFO - 2015-10-21 17:00:49,372 DEBUG : BROWSER_OUTPUT: Values: 91.0 91.0 92.0 91.0 93.0 91.0 92.0 92.0 90.0 92.0 17:00:49 INFO - 2015-10-21 17:00:49,372 DEBUG : BROWSER_OUTPUT: 17:00:49 INFO - 2015-10-21 17:00:49,372 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:82.40 Median:81.00 stddev:3.53 (4.4%) stddev-sans-first:3.64 17:00:49 INFO - 2015-10-21 17:00:49,374 DEBUG : BROWSER_OUTPUT: Values: 80.0 82.0 81.0 81.0 81.0 81.0 81.0 84.0 81.0 92.0 17:00:49 INFO - 2015-10-21 17:00:49,374 DEBUG : BROWSER_OUTPUT: 17:00:49 INFO - 2015-10-21 17:00:49,374 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:78.40 Median:78.50 stddev:0.52 (0.7%) stddev-sans-first:0.53 17:00:49 INFO - 2015-10-21 17:00:49,374 DEBUG : BROWSER_OUTPUT: Values: 78.0 79.0 79.0 79.0 78.0 78.0 79.0 78.0 78.0 78.0 17:00:49 INFO - 2015-10-21 17:00:49,375 DEBUG : BROWSER_OUTPUT: 17:00:49 INFO - 2015-10-21 17:00:49,375 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:97.30 Median:97.00 stddev:1.16 (1.2%) stddev-sans-first:1.22 17:00:49 INFO - 2015-10-21 17:00:49,375 DEBUG : BROWSER_OUTPUT: Values: 97.0 97.0 96.0 97.0 98.0 100.0 96.0 98.0 97.0 97.0 17:00:49 INFO - 2015-10-21 17:00:49,375 DEBUG : BROWSER_OUTPUT: 17:00:49 INFO - 2015-10-21 17:00:49,375 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.30 Median:120.50 stddev:1.70 (1.4%) stddev-sans-first:1.80 17:00:49 INFO - 2015-10-21 17:00:49,375 DEBUG : BROWSER_OUTPUT: Values: 120.0 118.0 120.0 118.0 120.0 123.0 119.0 122.0 122.0 121.0 17:00:49 INFO - 2015-10-21 17:00:49,378 DEBUG : BROWSER_OUTPUT: 17:00:49 INFO - 2015-10-21 17:00:49,378 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.70 Median:193.50 stddev:4.72 (2.4%) stddev-sans-first:4.10 17:00:49 INFO - 2015-10-21 17:00:49,378 DEBUG : BROWSER_OUTPUT: Values: 185.0 202.0 193.0 192.0 192.0 191.0 194.0 196.0 195.0 187.0 17:00:49 INFO - 2015-10-21 17:00:49,378 DEBUG : BROWSER_OUTPUT: 17:00:49 INFO - 2015-10-21 17:00:49,378 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:84.20 Median:84.00 stddev:0.63 (0.8%) stddev-sans-first:0.60 17:00:49 INFO - 2015-10-21 17:00:49,378 DEBUG : BROWSER_OUTPUT: Values: 85.0 85.0 83.0 84.0 84.0 84.0 84.0 84.0 85.0 84.0 17:00:49 INFO - 2015-10-21 17:00:49,378 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:00:49 INFO - 2015-10-21 17:00:49,378 DEBUG : BROWSER_OUTPUT: 17:00:49 INFO - 2015-10-21 17:00:49,960 INFO : Browser exited with error code: 0 17:00:50 INFO - 2015-10-21 17:00:50,848 INFO : Completed test kraken (00:01:00) 17:00:50 INFO - 2015-10-21 17:00:50,848 INFO : Starting test v8_7 17:00:50 INFO - 2015-10-21 17:00:50,848 DEBUG : operating with platform_type : w7_ 17:00:50 INFO - 2015-10-21 17:00:50,848 INFO : Initialising browser for v8_7 test... 17:00:50 INFO - 2015-10-21 17:00:50,875 DEBUG : command line: C:\slave\test-pgo\build\application\firefox\firefox -profile c:\users\cltbld\appdata\local\temp\tmpeyqrnj\profile http://localhost:49744/getInfo.html 17:00:55 INFO - 2015-10-21 17:00:55,542 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:00:55 INFO - 2015-10-21 17:00:55,542 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:00:55 INFO - 2015-10-21 17:00:55,542 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674 17:00:55 INFO - 2015-10-21 17:00:55,542 DEBUG : BROWSER_OUTPUT: __metrics 17:00:55 INFO - 2015-10-21 17:00:55,624 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:00:55 INFO - 2015-10-21 17:00:55,811 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 121: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 17:00:56 INFO - 2015-10-21 17:00:56,595 INFO : Browser initialized. 17:00:56 INFO - 2015-10-21 17:00:56,595 INFO : Running cycle 1/1 for v8_7 test... 17:00:56 INFO - 2015-10-21 17:00:56,595 DEBUG : command line: C:\slave\test-pgo\build\application\firefox\firefox -profile c:\users\cltbld\appdata\local\temp\tmpeyqrnj\profile -tp file:\C:\slave\test-pgo\build\tests\talos\talos\tests\v8_7\v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:01:07 INFO - 2015-10-21 17:01:07,990 DEBUG : BROWSER_OUTPUT: RSS: Main: 130134016 17:01:07 INFO - 2015-10-21 17:01:07,990 DEBUG : BROWSER_OUTPUT: 17:01:29 INFO - 2015-10-21 17:01:29,538 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49744/tests/v8_7/run.html (next: http://localhost:49744/tests/v8_7/run.html) 17:01:29 INFO - 2015-10-21 17:01:29,792 DEBUG : BROWSER_OUTPUT: RSS: Main: 491638784 17:01:29 INFO - 2015-10-21 17:01:29,792 DEBUG : BROWSER_OUTPUT: 17:01:29 INFO - 2015-10-21 17:01:29,792 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:01:29 INFO - 2015-10-21 17:01:29,792 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:01:29 INFO - 2015-10-21 17:01:29,792 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:01:29 INFO - 2015-10-21 17:01:29,792 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:01:29 INFO - 2015-10-21 17:01:29,792 DEBUG : BROWSER_OUTPUT: |0;Richards;154.27337241592102 17:01:29 INFO - 2015-10-21 17:01:29,792 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;207.08221163802028 17:01:29 INFO - 2015-10-21 17:01:29,792 DEBUG : BROWSER_OUTPUT: |2;Encrypt;302.6634382566586 17:01:29 INFO - 2015-10-21 17:01:29,792 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5324.468085106383 17:01:29 INFO - 2015-10-21 17:01:29,792 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1373.6263736263736 17:01:29 INFO - 2015-10-21 17:01:29,792 DEBUG : BROWSER_OUTPUT: |5;Earley;630.119722747322 17:01:29 INFO - 2015-10-21 17:01:29,793 DEBUG : BROWSER_OUTPUT: |6;Boyer;10680.851063829787 17:01:29 INFO - 2015-10-21 17:01:29,793 DEBUG : BROWSER_OUTPUT: |7;RegExp;29371.428571428572 17:01:29 INFO - 2015-10-21 17:01:29,793 DEBUG : BROWSER_OUTPUT: |8;Splay;649.0663232453317 17:01:29 INFO - 2015-10-21 17:01:29,793 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;5107.142857142857 17:01:29 INFO - 2015-10-21 17:01:29,793 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:01:29 INFO - 2015-10-21 17:01:29,793 DEBUG : BROWSER_OUTPUT: __startTimestamp1445472089791__endTimestamp 17:01:29 INFO - 2015-10-21 17:01:29,793 DEBUG : BROWSER_OUTPUT: 17:01:29 INFO - 2015-10-21 17:01:29,793 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:01:29 INFO - 2015-10-21 17:01:29,793 DEBUG : BROWSER_OUTPUT: Number of tests: 10 17:01:29 INFO - 2015-10-21 17:01:29,793 DEBUG : BROWSER_OUTPUT: 17:01:29 INFO - 2015-10-21 17:01:29,793 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:154.27 Median:154.27 stddev:0.00 (0.0%) 17:01:29 INFO - 2015-10-21 17:01:29,793 DEBUG : BROWSER_OUTPUT: Values: 154.3 17:01:29 INFO - 2015-10-21 17:01:29,793 DEBUG : BROWSER_OUTPUT: 17:01:29 INFO - 2015-10-21 17:01:29,795 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:207.08 Median:207.08 stddev:0.00 (0.0%) 17:01:29 INFO - 2015-10-21 17:01:29,795 DEBUG : BROWSER_OUTPUT: Values: 207.1 17:01:29 INFO - 2015-10-21 17:01:29,795 DEBUG : BROWSER_OUTPUT: 17:01:29 INFO - 2015-10-21 17:01:29,795 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:302.66 Median:302.66 stddev:0.00 (0.0%) 17:01:29 INFO - 2015-10-21 17:01:29,795 DEBUG : BROWSER_OUTPUT: Values: 302.7 17:01:29 INFO - 2015-10-21 17:01:29,795 DEBUG : BROWSER_OUTPUT: 17:01:29 INFO - 2015-10-21 17:01:29,795 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5324.47 Median:5324.47 stddev:0.00 (0.0%) 17:01:29 INFO - 2015-10-21 17:01:29,795 DEBUG : BROWSER_OUTPUT: Values: 5324.5 17:01:29 INFO - 2015-10-21 17:01:29,795 DEBUG : BROWSER_OUTPUT: 17:01:29 INFO - 2015-10-21 17:01:29,795 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1373.63 Median:1373.63 stddev:0.00 (0.0%) 17:01:29 INFO - 2015-10-21 17:01:29,795 DEBUG : BROWSER_OUTPUT: Values: 1373.6 17:01:29 INFO - 2015-10-21 17:01:29,795 DEBUG : BROWSER_OUTPUT: 17:01:29 INFO - 2015-10-21 17:01:29,795 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:630.12 Median:630.12 stddev:0.00 (0.0%) 17:01:29 INFO - 2015-10-21 17:01:29,795 DEBUG : BROWSER_OUTPUT: Values: 630.1 17:01:29 INFO - 2015-10-21 17:01:29,796 DEBUG : BROWSER_OUTPUT: 17:01:29 INFO - 2015-10-21 17:01:29,796 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10680.85 Median:10680.85 stddev:0.00 (0.0%) 17:01:29 INFO - 2015-10-21 17:01:29,796 DEBUG : BROWSER_OUTPUT: Values: 10680.9 17:01:29 INFO - 2015-10-21 17:01:29,796 DEBUG : BROWSER_OUTPUT: 17:01:29 INFO - 2015-10-21 17:01:29,796 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:29371.43 Median:29371.43 stddev:0.00 (0.0%) 17:01:29 INFO - 2015-10-21 17:01:29,796 DEBUG : BROWSER_OUTPUT: Values: 29371.4 17:01:29 INFO - 2015-10-21 17:01:29,796 DEBUG : BROWSER_OUTPUT: 17:01:29 INFO - 2015-10-21 17:01:29,796 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:649.07 Median:649.07 stddev:0.00 (0.0%) 17:01:29 INFO - 2015-10-21 17:01:29,796 DEBUG : BROWSER_OUTPUT: Values: 649.1 17:01:29 INFO - 2015-10-21 17:01:29,796 DEBUG : BROWSER_OUTPUT: 17:01:29 INFO - 2015-10-21 17:01:29,796 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:5107.14 Median:5107.14 stddev:0.00 (0.0%) 17:01:29 INFO - 2015-10-21 17:01:29,796 DEBUG : BROWSER_OUTPUT: Values: 5107.1 17:01:29 INFO - 2015-10-21 17:01:29,796 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:01:29 INFO - 2015-10-21 17:01:29,796 DEBUG : BROWSER_OUTPUT: 17:01:30 INFO - 2015-10-21 17:01:30,380 INFO : Browser exited with error code: 0 17:01:31 INFO - 2015-10-21 17:01:31,039 INFO : Completed test v8_7 (00:00:40) 17:01:31 INFO - 2015-10-21 17:01:31,167 INFO : Completed test suite (00:20:18) 17:01:31 INFO - 2015-10-21 17:01:31,167 DEBUG : Working with test: dromaeo_css 17:01:31 INFO - 2015-10-21 17:01:31,167 DEBUG : Generating results file: dromaeo_css 17:01:31 INFO - 2015-10-21 17:01:31,167 DEBUG : Working with test: kraken 17:01:31 INFO - 2015-10-21 17:01:31,167 DEBUG : Generating results file: kraken 17:01:31 INFO - 2015-10-21 17:01:31,167 INFO : javascript benchmark 17:01:31 INFO - 2015-10-21 17:01:31,167 DEBUG : Working with test: v8_7 17:01:31 INFO - 2015-10-21 17:01:31,167 DEBUG : Generating results file: v8_7 17:01:31 INFO - 2015-10-21 17:01:31,167 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:01:31 INFO - 2015-10-21 17:01:31,604 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,25]] 17:01:31 INFO - 2015-10-21 17:01:31,604 DEBUG : process_Request line: dromaeo_css 6535.07 graph.html#tests=[[72,64,25]] 17:01:31 INFO - 2015-10-21 17:01:31,604 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:01:31 INFO - 2015-10-21 17:01:31,632 DEBUG : process_Request line: kraken 1583.00 graph.html#tests=[[232,64,25]] 17:01:31 INFO - 2015-10-21 17:01:31,632 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:01:32 INFO - 2015-10-21 17:01:32,114 DEBUG : process_Request line: v8_7 20556.33 graph.html#tests=[[230,64,25]] 17:01:32 INFO - 2015-10-21 17:01:32,114 INFO : javascript benchmark 17:01:32 INFO - 2015-10-21 17:01:32,117 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [313.5672771575226, 325.3671608721037, 328.52036027400004, 332.6473937626115, 335.05347393613044, 13483.865161348383, 17477.213525391355, 17560.82439175608, 17896.373626923043, 17985.37051203208, 16241.944273622235, 16309.429169979054, 16356.0, 16366.672666546692, 16476.09381484018, 4308.590683885026, 4436.44544431946, 4565.33802598623, 5430.289458820469, 5573.749181286852, 6072.908906366408, 6092.66490343031, 6098.4511393974535, 6099.176611157503, 6099.237595300588, 4601.6548758843055, 6045.153678485016, 6047.667378294192, 6049.818505444844, 6054.122152287916, 4682.29765535169, 4690.390249267591, 4703.082898834728, 4706.670533062687, 4708.434987801468, 3895.7272990890647, 4001.15975645112, 4004.799760011988, 4007.8998025049314, 4013.097053163044, 12962.092653514257, 13137.0, 13218.0, 13431.597052088453, 13446.86553134466, 1928.5853541488648, 1931.1502938706924, 1961.7645882494048, 2038.4699978005676, 2060.76301225358, 9431.764205894839, 9604.375715578464, 9740.707778766577, 9819.968903265197, 9825.508724563742, 1472.4919902633574, 1476.0, 1527.5951872753728, 1545.0961187705207, 1587.6427803744066, 74511.0, 75609.24390756077, 75937.24062759412, 76510.23489765087, 76828.61585692092, 6038.094285857156, 6257.405546473078, 6410.647414392253, 6411.839704007437, 6457.354264573505, 7357.264273572707, 7528.322450979329, 7563.886541701879, 7577.280158384945, 7585.848283034308, 5284.867878302996, 5301.893962120736, 5303.0, 5350.438203988525, 5426.511613954763, 5664.348599911063, 5763.510101641324, 5773.88452230953, 5794.841031793658, 5798.072308430631, 2855.229088146189, 2863.7565806906227, 2897.5074237379695, 2904.8111872728205, 2908.7091290870744, 1051.6529545250048, 1060.1995493402433, 1064.1965316186229, 1069.9358038517714, 1088.0207812968392, 412.6801728660312, 428.40665678036146, 429.23167530121356, 458.19696518893056, 463.58972309505657, 11735.4132293385, 12005.39973001364, 12020.33888136161, 12103.636890893287, 12156.452959616838, 456.74650568933896, 463.3027293922625, 468.5712572995671, 471.0320291800383, 482.60667555941797, 5546.389897111315, 6381.776637817747, 6389.936100639027, 6591.538592298493, 6618.238902526175, 466551.0, 470891.0, 474112.0, 474675.0, 478826.0, 77658.0, 79294.0400263913, 79366.20633793704, 81278.0, 82020.58989705132, 492.7437732379143, 494.883702329945, 500.417014178478, 501.503511523589, 502.5401757391945, 10750.784984300426, 10823.621173258898, 10925.890741092806, 11227.989480946753, 11381.772364552828, 32683.673163268064, 34241.0, 38643.613563865125, 38886.222275553766, 39463.0, 55001.0, 57037.42962570321, 57039.0, 57062.714686426305, 57096.0, 6323.652199129092, 6364.93635063662, 6390.424861762278, 6390.7443702251385, 6395.5203359747275, 12056.698582535506, 12264.32546209967, 12363.505459781509, 12374.62876113718, 12500.687482813002, 10227.744306392102, 10517.474126293808, 10550.419726915094, 10685.679429617125, 10836.241463097824, 10229.948850255701, 10259.127974122282, 10484.161267098767, 10540.57837686484, 10699.411532365795, 10554.0, 10746.355218686904, 10816.08063314627, 10872.456377181268, 10902.291351062155, 6208.286047104641, 6251.874962500816, 6264.68676566179, 6294.937050629435, 6348.428641422294, 10570.41862697559, 10589.735256618646, 10683.30558513694, 10702.73243168927, 10756.247062705535], "dojo.html": [2695.9326016849577, 2709.322669332667, 2750.4774092922344, 2756.131818477181, 2790.455861107084, 5185.611079169068, 5231.293775340333, 5291.603129765269, 5325.3077099977, 5340.652857564256, 5210.2445145453885, 5264.8157314494, 5324.600654950875, 5344.144936810111, 5355.357357117151, 4364.061726728753, 4476.440444944382, 4547.431571053618, 4625.190591646465, 4629.79165937532, 4478.216312145378, 4502.864914052568, 4508.61676757476, 4537.500874903758, 4550.8862278442975, 4537.069900670354, 4558.293464512989, 4573.131105090039, 4600.677952543323, 4617.053504031683, 4464.866054018352, 4514.729116253003, 4620.699654522479, 4626.30605409188, 4630.398048253723, 4421.425214722098, 4476.9552304476865, 4513.887152821206, 4521.660875434322, 4546.772661366951, 5104.132297509395, 5165.096108181091, 5165.896682066375, 5260.815871444481, 5267.736613169326, 5407.080796264644, 5441.5102640762125, 5447.428020057877, 5535.03136951036, 5540.750666220029, 5465.863353416156, 5495.230667706524, 5569.136783798518, 5578.497935185812, 5580.135079062711, 4982.202847544412, 4993.475685053054, 5051.545360917498, 5085.79656813727, 5089.898202035939, 5489.917651235235, 5602.411746766612, 5720.141978703145, 5726.685032323179, 5751.0, 5298.602604804655, 5302.488790694633, 5383.946160538345, 5405.972970135203, 5409.377921539073, 5496.258005169331, 5497.642653227527, 5534.363548192009, 5608.411116832755, 5619.213310136584, 5358.651687640291, 5418.2685337479725, 5452.945470545244, 5530.640508366943, 5581.051221292309, 5381.4349493303425, 5405.567554595623, 5477.370102438271, 5493.066178749622, 5558.416366281563, 3376.2572234108457, 3426.194844211608, 3439.243366459375, 3439.3121375724954, 3513.4729790531114, 3123.7969531980348, 3152.448321543721, 3174.333389988128, 3208.197950512372, 3225.8064516129107, 5097.541221290102, 5132.486751324837, 5202.895942081137, 5229.424763276036, 5353.1167357386375, 5476.3702174250475, 5510.118381059011, 5523.558115350762, 5600.243967064475, 5647.29408823897, 4982.10322142018, 5202.92195617066, 5261.921071183935, 5356.5179133877355, 5387.838364849061, 4353.542877997828, 4445.533219012022, 4455.04216593434, 4463.352813841975, 4472.597466228055, 5782.10377391505, 5792.913106303409, 5794.072948328248, 5881.676507792027, 5923.644581325048, 5342.118550439134, 5426.810061647823, 5482.862928426821, 5490.478404551562, 5630.0991841305195, 5701.7149142541875, 5798.420157984167, 5833.358330583547, 5891.823245302648, 5944.5838791284195, 5348.465153484621, 5357.330333708286, 5518.586106041983, 5539.584531160099, 5568.638038527482, 5476.04169270384, 5476.808311709071, 5542.11326187808, 5554.0, 5598.356189038313, 5196.168613021899, 5313.468653134656, 5397.109476936262, 5480.1231802912935, 5508.724563771715, 5025.597952163891, 5247.606429517725, 5321.36143662763, 5384.9730751346, 5464.398916119303, 5032.823851165192, 5041.495850414929, 5126.820561280338, 5195.948040519697, 5245.239440281061, 5372.274742909657, 5469.535089517435, 5545.556355491471, 5550.47270509301, 5555.694436805853, 5133.7689803958165, 5252.868678283074, 5445.537129343892, 5454.699991500505, 5459.017376872202], "mootools.html": [1219.9878001219988, 1284.5696691608312, 1396.6159306190796, 1574.0319703382422, 1582.778411022457, 7709.229077092288, 7809.0, 8425.620847061882, 8743.038265790767, 8795.736127916156, 8336.791580210498, 8345.165483451652, 8370.53962032088, 8427.494350338984, 8530.616122274498, 2091.2262462888675, 2115.9682604760865, 2128.17001369466, 2162.059504115715, 2171.6525355943054, 1969.9212031518794, 1993.8205561499462, 2152.0638522242875, 2190.9233176838816, 2206.911723531057, 2123.543438160795, 2146.570685862826, 2150.32264836576, 2150.881541598368, 2153.773853745358, 1946.7177259297323, 2117.640001199792, 2158.84888057836, 2159.8272138228904, 2164.383150802014, 1958.6572349838864, 2097.265956915083, 2159.967600485994, 2186.8797216153107, 2189.518305972699, 8292.0, 8336.0, 8361.581920903931, 8414.78963025923, 8589.184027517376, 4762.333273341735, 4814.542618451242, 4818.494058123917, 4823.348847905523, 4823.62526679898, 3191.266008817962, 3216.96783032169, 3225.4355487789544, 3233.321002589459, 3244.383567122239, 1020.9285350025501, 1029.2075102171361, 1054.3305001324138, 1054.641421916552, 1064.5741703318733, 12258.26450412978, 12276.938615306866, 12281.0, 12281.385930703429, 12320.383980800923, 4080.2451546464, 4159.83360665576, 4209.452771139732, 4217.746935183899, 4222.978885105555, 9143.177114059767, 10083.949580252198, 10104.494775261208, 10106.292559520763, 10131.392116473035, 4619.759416682906, 4661.976690116596, 4738.2418812990445, 4746.501617330199, 4764.523547645277, 4209.2633789086785, 4314.158739045919, 4317.525072242051, 4341.435613370241, 4352.129574085196, 3374.5444365010408, 3456.6197718250974, 3483.4774783782636, 3502.2470168913806, 3551.964480355215, 1048.7430579507916, 1067.9305845120043, 1070.5075665193942, 1075.3977772447454, 1078.8112080385902, 1133.2237417369129, 1151.9020883225019, 1152.8097863852538, 1175.9416525127453, 1177.9751616094054, 7542.0, 7657.923420765833, 7669.693212271558, 7684.0, 7691.538507689556, 439.29712460063644, 449.36190609334824, 457.14285714285717, 458.1707110130608, 458.3193956973891, 5389.51494365509, 5491.862703432366, 5615.0, 5664.405237450091, 6166.876662466726, 10502.212334074975, 10575.576976920836, 10580.191131192765, 10596.788064238672, 10600.416977066181, 10306.639267625747, 10403.739906502398, 10423.166146708245, 10428.478576071166, 10435.478226088666, 7671.884921726179, 7732.226777322223, 7751.108622508484, 7784.84430311402, 7803.180666030099, 7271.963640181765, 7319.194888562148, 7506.549607023596, 7728.497647653109, 7781.922180778346, 8895.377323587545, 9248.445093294424, 9320.440773553608, 9330.813383732424, 9340.112689294507, 9394.859077113711, 9616.51917404141, 9635.614575417185, 9638.662646807608, 9718.659846905324, 7539.359154471931, 7556.433267504849, 7573.318401343906, 7656.770296891103, 7677.30904218623, 8189.22202390772, 8211.384146189179, 8243.629036693243, 8253.587320633824, 8265.876011859948, 7564.092308922744, 7588.0, 7779.416543759354, 7861.2531809478005, 7930.325922296439, 7477.40180785525, 7500.024996750388, 7602.961985190039, 7750.0, 7754.147043825287, 7659.4255430841795, 7671.424643151674, 7710.228977102245, 7713.344365728976, 7716.92283077162, 6348.111264423077, 6377.426031657174, 6394.7442102317245, 6408.166938297992, 6429.0, 6488.286288508355, 6782.559133656297, 6845.110135682528, 6860.2453730088655, 6863.0], "ext.html": [496.9279454479103, 510.257575228043, 515.1474310016922, 518.5851318944843, 519.4934938435026, 26911.192664220056, 27362.726372736266, 39066.41400378996, 39103.41344879829, 39620.40569391462, 37262.62737372625, 40420.59579404205, 40869.38695919564, 40991.18017639653, 41527.37708934368, 7666.233376662317, 7811.140774514827, 8275.255227029566, 8408.915910840875, 8649.870251946195, 10306.536205870754, 10525.6316028939, 10545.0, 10617.57529698811, 10821.83767243492, 10497.895021049768, 10612.628558000471, 10613.204009699264, 10750.462476876164, 10755.085817705505, 10055.497225138713, 10502.527386267637, 10591.311564748345, 10599.947000265027, 10607.045365917065, 10400.271980961335, 10434.113100386476, 10564.524596393181, 10579.629712960086, 10596.894031059668, 37944.241115177545, 38212.42681359782, 38269.61730382688, 38272.0, 38311.23377532434, 3184.8885289015006, 3260.8206548639814, 3295.8187299698507, 3680.8895733128047, 3776.6978641708597, 29555.852220738972, 29932.70067299321, 30197.0, 30402.239944001354, 30642.080737577908, 2701.7028126906025, 2791.860406979643, 2825.3642930340716, 2839.403725217707, 2890.609767681357, 502374.4881275607, 506118.0, 507891.0, 512988.0, 514888.7022259571, 53594.19608705873, 54062.72968635132, 54112.45887541153, 54234.18648720272, 54324.72837635787, 53509.73245133827, 53881.46118538843, 55851.720741396035, 57601.0, 57792.0, 14081.436742530388, 14267.286635668175, 14288.714225715428, 14321.6419589509, 14341.78487322691, 10728.356298622108, 10730.892691073146, 10777.676669699922, 10779.67660970172, 10798.352098873935, 18105.54736131581, 18125.54686132831, 18134.818651813577, 18142.274309027493, 18170.094719216308, 7679.232076792276, 7892.28969392746, 7943.4836735612, 7945.48354356965, 7980.967232451747, 798.5847359373093, 939.4410325856105, 1011.544804837826, 1019.3527110284874, 1022.483645758887, 27421.862890685417, 28710.0, 31422.842885785423, 31432.842835785676, 32093.0, 951.9762005949907, 994.5623925472769, 995.3082607587658, 999.3354419311077, 1065.7442213868617, 14526.491572794901, 14825.0, 14944.178070206026, 15104.773428398583, 15164.696706066037, 489618.0, 494996.0, 495158.0, 495775.0, 495872.0, 48676.75661621669, 49160.75419622879, 49228.26157607639, 49278.26082608764, 49501.257481137814, 1153.9423028848523, 1162.459456352783, 1176.6587689569928, 1177.1818586082761, 1179.151011271883, 28321.43357132887, 28565.714342856307, 28743.0, 29206.561901571917, 29308.267293317836, 42715.78642106769, 42928.14143717046, 43263.35104973365, 43399.0, 43403.34894976641, 387993.0, 390412.0, 390672.0, 391427.0, 392959.2464263851, 27952.30119246954, 39508.40737388999, 41961.58038419577, 41977.1604567913, 41985.16029679451, 42434.0, 43659.0, 43739.56260437355, 43764.781176093915, 43778.34332484951, 34492.48261276033, 35592.46611300884, 36131.81934090313, 36856.63143368532, 37023.0, 35686.464703028956, 36077.27845443129, 36619.450708238866, 38741.418878717406, 39612.207755845295, 36411.635883640825, 36842.263154737295, 37148.44277335896, 37338.43992340171, 37475.25049499049, 35684.64315356917, 36822.0, 37761.0, 38143.0, 39263.803680981415, 30054.549181761853, 30443.847780760956, 30461.238469037566, 31191.064268071088, 31368.529472058395], "prototype.html": [317.1816712880767, 320.15319479975466, 324.7402078337331, 326.2203334031665, 326.80718376158063, 5685.573581981353, 5723.084306510959, 5728.828135155947, 5729.5702822288395, 5729.6848673323, 5443.8094666686575, 5453.836384908449, 5523.530499907502, 5639.6334238274485, 5667.943320566793, 4064.4919385076864, 4187.0, 4190.622843944045, 4191.979040104795, 4199.2651286024975, 4113.856015039474, 4126.855560055399, 4200.285951388271, 4203.516595591515, 4204.810783514734, 4010.258102251093, 4126.09225970286, 4141.585841415865, 4164.604362585565, 4172.687048471377, 4137.627613514768, 4177.456930599018, 4182.1008483176265, 4183.100633363826, 4186.832526698929, 3589.300086483137, 3653.561572611277, 3711.9072023199365, 3714.0343510687417, 3715.925681486382, 5436.782528698847, 5443.047466693313, 5467.097928841776, 5469.179623056533, 5479.424660410639, 4927.802887884516, 4952.33143525623, 4954.628402869799, 4960.404751429815, 4962.60299176065, 5804.506616937565, 5833.7374818133285, 5847.736851841677, 5894.823155305347, 5927.229460170193, 4077.55146933837, 4110.34234522475, 4111.48606424197, 4120.7321524101135, 4123.134141830219, 6114.113453549299, 6130.17242672238, 6193.3496982816605, 6196.225471816023, 6199.969000155015, 3985.083430810872, 4142.46148000764, 4204.096119334357, 4235.152969406131, 4236.173946080547, 4229.7250678706405, 4299.333603291495, 4327.307630779061, 4329.177456283359, 4336.154449882306, 4882.0, 4946.777395017233, 4950.45544990058, 4951.0, 4967.503249675004, 5839.357670656224, 5849.064149736107, 5865.325487568899, 5980.312264089598, 5980.581359304807, 1447.167878469863, 1536.5620798072496, 1541.0060510970586, 1541.083055581927, 1542.5295284937977, 1018.4144117132678, 1031.504877658728, 1040.2926010312908, 1052.1687866585312, 1056.2817284246632, 5851.941480585139, 5863.70681465925, 5871.383504732027, 5874.471297583238, 5879.029960056629, 6022.247219097613, 6068.180795592627, 6183.598066125777, 6186.969065154735, 6189.257289125334, 5836.153757705109, 5853.0, 5855.209546711139, 5861.6189947653265, 5864.091065884794, 3255.674432556725, 3307.255867429809, 3350.195952971318, 3352.7653064285755, 3388.8305584720665, 6501.0898474213645, 6521.934780652133, 6525.934740652628, 6528.60828350291, 6535.8692826143215, 6254.499640028786, 6311.33730958252, 6313.589616674902, 6315.084312774714, 6322.399372059647, 6371.585846919843, 6397.200349956255, 6412.39082287182, 6525.2169739631545, 6526.706298216592, 5874.0, 6028.728707208098, 6085.361037091218, 6114.724837382418, 6155.599886007395, 6018.067199584071, 6042.939570604238, 6101.359357267601, 6149.046897730859, 6158.907616385847, 6462.773802916875, 6526.869462610626, 6602.834929126618, 6604.438622716931, 6609.603423794588, 4185.707000509935, 4228.2600544905135, 4233.576642335742, 4234.830606775695, 4235.78821058952, 6124.601900876429, 6139.693015349304, 6156.78451254204, 6165.630062196283, 6280.309165991828, 6002.129691194839, 6051.4553690168095, 6053.303870055, 6060.757569697163, 6159.6612186330185, 5931.3178984417345, 5995.760169593167, 6031.457168854824, 6068.241469816273, 6085.361037091042, 5882.735276912635, 5921.171036055042, 5929.229200203946, 5932.199153114274, 5938.495227905676, 5945.435183657545, 6117.938820611737, 6123.7244324006415, 6125.877482450415, 6138.140660307471, 5892.7642894283745, 5983.850403739942, 6020.638761674313, 6022.969885150722, 6023.0], "yui.html": [739.971439698819, 745.6634822682408, 751.530293566521, 759.1270039454628, 767.0478631881864, 12169.269843809367, 12198.20711653743, 12465.127441079128, 12474.688132796684, 12538.310392928386, 11783.882161178386, 11883.34641594714, 12165.437960764713, 12197.51209951603, 12217.755644887096, 521.5749164430996, 529.4652401074923, 617.1606615003592, 618.5422787137509, 627.5262177056316, 595.6753569304718, 608.7017361492859, 610.5024405109843, 621.3879328861068, 623.3859648246473, 642.1395330257454, 646.9741210351581, 651.3746803069035, 654.7250154934915, 657.57914934442, 539.940606533281, 544.6078823247276, 631.192074145095, 650.7071817682062, 651.6057785040053, 459.84135473262006, 463.58277550204747, 466.86460926331324, 469.5539237724176, 471.6439088488204, 12418.379081046001, 12664.746705065847, 12666.809997849947, 12682.74634507314, 12687.746245075046, 9896.604135834557, 10192.337498062601, 11503.309801411859, 11939.462724177432, 11969.700757481045, 9909.355891867006, 10003.39979601219, 10130.696079117639, 10175.0, 10322.0, 2987.4771914914804, 3129.342838004022, 3206.118317462693, 3251.5935508061493, 3291.753118516121, 48959.51040489585, 49514.75242623764, 50040.0, 50065.749671251775, 50107.24839127416, 7249.275072492708, 7488.700451981968, 7491.66287517063, 7593.05086864142, 7607.810420515261, 11417.714557135972, 11481.598144064918, 11713.238639488405, 11714.94142529299, 11733.589324373606, 6409.615423074631, 6431.970884658433, 6476.643784591893, 6531.5427920046095, 6591.83520411984, 4144.046869220097, 4202.579742025834, 4218.78906054696, 4235.0, 4390.209762242827, 2619.8428094314404, 2626.8949242030103, 2642.3394151462135, 2644.140654287364, 2672.4766882876575, 446.183484223876, 453.8729155836305, 455.61728148354877, 456.06506661344775, 457.9381783459257, 564.2805423085516, 573.4437595532327, 574.1674571870805, 577.0219477984775, 588.5997521685296, 8860.689875854314, 9187.494687792236, 9271.165595096474, 9301.162895339452, 9427.15155635996, 469.5351601914149, 520.5991386632272, 654.3848782144769, 695.384584642595, 739.8483310921356, 4005.218982298482, 4397.846075387346, 4504.189245935763, 4509.444241736595, 4638.930416043762, 58042.0, 58233.41766582365, 59879.401205987386, 59922.0, 59998.70000649969, 53595.464045359826, 54117.45882541203, 54206.0, 55596.722016389656, 55703.0, 44657.330140047925, 44853.0, 45144.32283515816, 45904.540954590695, 46410.76794616006, 8805.559722013746, 8841.734747957571, 9026.819463610822, 9073.773155670897, 9193.494357810385, 31469.213269668442, 31878.36243275075, 31969.040928772174, 32444.0, 32532.83733581317, 43590.12819743524, 45466.31800522929, 45621.0, 46524.0, 46732.766336168104, 7883.6846526138315, 8557.0, 8591.355648326526, 8652.437591556529, 8778.51718155482, 13276.867231327564, 13303.800442993557, 13330.933345333211, 13595.592132236048, 13776.173429594257, 12093.213941093802, 12376.133670642968, 12472.126951113334, 12818.871811281768, 13473.258970756311, 12373.443195056425, 12482.875171248534, 12637.494500219887, 12880.677983050498, 13151.21092734439, 12388.504459821506, 12618.87381126177, 12623.81064284018, 13022.348882556023, 13293.20240785556, 9557.522123893916, 9578.56896439648, 9694.5152742364, 10205.540750666387, 10207.948960255151, 9560.808783824423, 10382.0, 10463.372197668165, 10503.422311772925, 10606.325615795513]}, "summary": {"suite": 6535.073056386148, "subtests": {"jquery.html": {"filtered": 6903.984343539, "value": 6903.984343539}, "dojo.html": {"filtered": 4983.415657378445, "value": 4983.415657378445}, "mootools.html": {"filtered": 4508.2406059243785, "value": 4508.2406059243785}, "ext.html": {"filtered": 19191.57867482108, "value": 19191.57867482108}, "prototype.html": {"filtered": 4507.0028447875275, "value": 4507.0028447875275}, "yui.html": {"filtered": 5805.354091572321, "value": 5805.354091572321}}}, "test_machine": {"platform": "x86", "osversion": "6.1.7601", "os": "win", "name": "T-W732-IX-076"}, "testrun": {"date": 1445470872, "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": "20151021113233", "branch": "Fx-Team", "revision": "4babd5d32cc121f287363f63217c19029f848577"}}, {"talos_counters": {}, "results": {"audio-dft": [158.0, 163.0, 155.0, 156.0, 153.0, 156.0, 153.0, 153.0, 156.0, 154.0], "ai-astar": [95.0, 88.0, 97.0, 96.0, 93.0, 97.0, 96.0, 98.0, 104.0, 102.0], "imaging-gaussian-blur": [117.0, 116.0, 117.0, 119.0, 116.0, 116.0, 116.0, 118.0, 117.0, 117.0], "audio-beat-detection": [132.0, 131.0, 145.0, 155.0, 130.0, 132.0, 139.0, 133.0, 157.0, 134.0], "json-stringify-tinderbox": [78.0, 79.0, 79.0, 79.0, 78.0, 78.0, 79.0, 78.0, 78.0, 78.0], "stanford-crypto-pbkdf2": [185.0, 202.0, 193.0, 192.0, 192.0, 191.0, 194.0, 196.0, 195.0, 187.0], "json-parse-financial": [80.0, 82.0, 81.0, 81.0, 81.0, 81.0, 81.0, 84.0, 81.0, 92.0], "stanford-crypto-sha256-iterative": [85.0, 85.0, 83.0, 84.0, 84.0, 84.0, 84.0, 84.0, 85.0, 84.0], "audio-fft": [96.0, 99.0, 81.0, 99.0, 86.0, 76.0, 77.0, 83.0, 102.0, 78.0], "imaging-darkroom": [139.0, 139.0, 139.0, 139.0, 139.0, 139.0, 139.0, 139.0, 139.0, 138.0], "stanford-crypto-ccm": [120.0, 118.0, 120.0, 118.0, 120.0, 123.0, 119.0, 122.0, 122.0, 121.0], "audio-oscillator": [96.0, 95.0, 113.0, 95.0, 95.0, 95.0, 118.0, 95.0, 95.0, 119.0], "stanford-crypto-aes": [97.0, 97.0, 96.0, 97.0, 98.0, 100.0, 96.0, 98.0, 97.0, 97.0], "imaging-desaturate": [91.0, 91.0, 92.0, 91.0, 93.0, 91.0, 92.0, 92.0, 90.0, 92.0]}, "summary": {"suite": 1583.0, "subtests": {"audio-fft": {"filtered": 87.7, "value": 87.7}, "stanford-crypto-pbkdf2": {"filtered": 192.7, "value": 192.7}, "audio-beat-detection": {"filtered": 138.8, "value": 138.8}, "stanford-crypto-ccm": {"filtered": 120.3, "value": 120.3}, "imaging-darkroom": {"filtered": 138.9, "value": 138.9}, "json-parse-financial": {"filtered": 82.4, "value": 82.4}, "audio-oscillator": {"filtered": 101.6, "value": 101.6}, "ai-astar": {"filtered": 96.6, "value": 96.6}, "audio-dft": {"filtered": 155.7, "value": 155.7}, "stanford-crypto-sha256-iterative": {"filtered": 84.2, "value": 84.2}, "json-stringify-tinderbox": {"filtered": 78.4, "value": 78.4}, "imaging-gaussian-blur": {"filtered": 116.9, "value": 116.9}, "stanford-crypto-aes": {"filtered": 97.3, "value": 97.3}, "imaging-desaturate": {"filtered": 91.5, "value": 91.5}}}, "test_machine": {"platform": "x86", "osversion": "6.1.7601", "os": "win", "name": "T-W732-IX-076"}, "testrun": {"date": 1445470872, "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": "20151021113233", "branch": "Fx-Team", "revision": "4babd5d32cc121f287363f63217c19029f848577"}}, {"talos_counters": {}, "results": {"DeltaBlue": [207.08221163802028], "Encrypt": [302.6634382566586], "NavierStokes": [5107.142857142857], "Decrypt": [5324.468085106383], "Splay": [649.0663232453317], "Richards": [154.27337241592102], "RegExp": [29371.428571428572], "Earley": [630.119722747322], "Boyer": [10680.851063829787], "RayTrace": [1373.6263736263736]}, "summary": {"suite": 20556.331631494464, "subtests": {"DeltaBlue": {"filtered": 319.28382200000004, "value": 319.28382200000004}, "Encrypt": {"filtered": 879.4620239999998, "value": 879.4620239999998}, "NavierStokes": {"filtered": 290.5734265734265, "value": 290.5734265734265}, "Decrypt": {"filtered": 49.99203596403597, "value": 49.99203596403597}, "Splay": {"filtered": 125.55111408730158, "value": 125.55111408730158}, "RegExp": {"filtered": 31.016026264591456, "value": 31.016026264591456}, "Richards": {"filtered": 228.827564, "value": 228.827564}, "Earley": {"filtered": 1057.6767810000001, "value": 1057.6767810000001}, "Boyer": {"filtered": 62.397930278884424, "value": 62.397930278884424}, "RayTrace": {"filtered": 538.7119920000001, "value": 538.7119920000001}}}, "test_machine": {"platform": "x86", "osversion": "6.1.7601", "os": "win", "name": "T-W732-IX-076"}, "testrun": {"date": 1445470872, "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": "20151021113233", "branch": "Fx-Team", "revision": "4babd5d32cc121f287363f63217c19029f848577"}}] 17:01:32 INFO - RETURN: dromaeo_css: 6535.07 17:01:32 INFO - RETURN: kraken: 1583.00 17:01:32 INFO - RETURN: v8_7: 20556.33 17:01:32 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,25]]", "result": "20556.33"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,25]]", "result": "1583.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,25]]", "result": "6535.07"}}} 17:01:32 INFO - Return code: 0 17:01:32 INFO - # TBPL SUCCESS # 17:01:32 INFO - Running post-action listener: _resource_record_post_action 17:01:32 INFO - Running post-run listener: _resource_record_post_run 17:01:33 INFO - Total resource usage - Wall time: 1223s; CPU: 13.0%; Read bytes: 132902912; Write bytes: 461083136; Read time: 1491090; Write time: 4786170 17:01:33 INFO - install - Wall time: 3s; CPU: 9.0%; Read bytes: 0; Write bytes: 7468032; Read time: 0; Write time: 474580 17:01:33 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 132811776; Write bytes: 431890944; Read time: 1480180; Write time: 4239210 17:01:33 INFO - Running post-run listener: _upload_blobber_files 17:01:33 INFO - Blob upload gear active. 17:01:33 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 17:01:33 INFO - Copying logs to upload dir... 17:01:33 INFO - mkdir: C:\slave\test-pgo\build\upload\logs program finished with exit code 0 elapsedTime=1531.909000 ========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 25 mins, 34 secs) (at 2015-10-21 17:01:36.043138) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-21 17:01:36.046635) ========= '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-076 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-076 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-076 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/x-xhZbI1RrKYkKYgXsUrcw/artifacts/public/build/firefox-44.0a1.en-US.win32.zip program finished with exit code 0 elapsedTime=0.102000 build_url: 'https://queue.taskcluster.net/v1/task/x-xhZbI1RrKYkKYgXsUrcw/artifacts/public/build/firefox-44.0a1.en-US.win32.zip' ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-10-21 17:01:36.311346) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-10-21 17:01:36.311668) ========= '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-076 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-076 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-076 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 17:01:36.558134) ========= ========= Started reboot slave lost (results: 0, elapsed: 0 secs) (at 2015-10-21 17:01:36.558458) ========= ========= Finished reboot slave lost (results: 0, elapsed: 0 secs) (at 2015-10-21 17:01:37.160146) =========