builder: b2g-inbound_win7-ix_test-dromaeojs-pgo slave: t-w732-ix-129 starttime: 1445673942.07 results: success (0) buildid: 20151023203110 builduid: 0acd7aa5aee5477e8b143a34a63b314b revision: 19211c12647724e21cf63efc01817d28d5ebae52 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-24 01:05:42.070302) ========= master: http://buildbot-master119.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-24 01:05:42.071685) ========= ========= Started set props: basedir (results: 0, elapsed: 8 secs) (at 2015-10-24 01:05:42.072017) ========= '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-129 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-129 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-129 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.549000 basedir: 'C:\\slave\\test-pgo' ========= Finished set props: basedir (results: 0, elapsed: 8 secs) (at 2015-10-24 01:05:50.207262) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-24 01:05:50.207560) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-24 01:05:50.753034) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2015-10-24 01:05:50.753291) ========= '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-129 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-129 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-129 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: 1 secs) (at 2015-10-24 01:05:52.439536) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-24 01:05:52.439901) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-24 01:05:52.440313) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-24 01:05:52.440656) ========= '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-129 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-129 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-129 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 --01:05:52-- 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 01:05:53 (2.27 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.808000 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-24 01:05:53.323089) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 mins, 40 secs) (at 2015-10-24 01:05:53.323408) ========= '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-129 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-129 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-129 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=11.801000 ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 mins, 40 secs) (at 2015-10-24 01:07:33.651952) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-10-24 01:07:33.652412) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 19211c12647724e21cf63efc01817d28d5ebae52 --destination scripts --debug' in dir C:\slave\test-pgo\. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 19211c12647724e21cf63efc01817d28d5ebae52 --destination scripts --debug'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files\Common Files COMPUTERNAME=T-W732-IX-129 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-129 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-129 USERNAME=cltbld USERPROFILE=C:\Users\cltbld WINDIR=C:\windows WINDOWS_TRACING_FLAGS=3 WINDOWS_TRACING_LOGFILE=C:\BVTBin\Tests\installpackage\csilogfile.log XPCOM_DEBUG_BREAK=warn using PTY: False 2015-10-24 01:07:34,608 truncating revision to first 12 chars 2015-10-24 01:07:34,608 Setting DEBUG logging. 2015-10-24 01:07:34,608 attempt 1/10 2015-10-24 01:07:34,608 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/19211c126477?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-10-24 01:07:35,157 unpacking tar archive at: b2g-inbound-19211c126477/testing/mozharness/ program finished with exit code 0 elapsedTime=1.183000 ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-10-24 01:07:36.164996) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 1 mins, 50 secs) (at 2015-10-24 01:07:36.165279) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 1 mins, 50 secs) (at 2015-10-24 01:09:26.468238) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-24 01:09:26.468504) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-24 01:09:26.469000) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 53 secs) (at 2015-10-24 01:09:26.469335) ========= 'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'dromaeojs' '--add-option' '--webServer,localhost' '--branch-name' 'B2G-Inbound' '--system-bits' '32' '--cfg' 'talos/windows_config.py' '--download-symbols' 'ondemand' '--use-talos-json' '--blob-upload-branch' 'B2G-Inbound' in dir C:\slave\test-pgo\. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['c:/mozilla-build/python27/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--system-bits', '32', '--cfg', 'talos/windows_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files\Common Files COMPUTERNAME=T-W732-IX-129 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-129 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-129 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 01:09:27 INFO - MultiFileLogger online at 20151024 01:09:27 in C:\slave\test-pgo 01:09:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 32 --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 01:09:27 INFO - Dumping config to C:\slave\test-pgo\logs\localconfig.json. 01:09:27 INFO - {'append_to_log': False, 01:09:27 INFO - 'base_work_dir': 'C:\\slave\\test-pgo', 01:09:27 INFO - 'blob_upload_branch': 'B2G-Inbound', 01:09:27 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test-pgo\\oauth.txt', 01:09:27 INFO - 'branch': 'B2G-Inbound', 01:09:27 INFO - 'buildbot_json_path': 'buildprops.json', 01:09:27 INFO - 'config_files': ('talos/windows_config.py',), 01:09:27 INFO - 'default_actions': ('clobber', 01:09:27 INFO - 'read-buildbot-config', 01:09:27 INFO - 'download-and-extract', 01:09:27 INFO - 'populate-webroot', 01:09:27 INFO - 'create-virtualenv', 01:09:27 INFO - 'install', 01:09:27 INFO - 'run-tests'), 01:09:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:09:27 INFO - 'download_minidump_stackwalk': True, 01:09:27 INFO - 'download_symbols': 'ondemand', 01:09:27 INFO - 'exes': {'easy_install': ('C:\\slave\\test-pgo\\build/venv/scripts/python', 01:09:27 INFO - 'C:\\slave\\test-pgo\\build/venv/scripts/easy_install-2.7-script.py'), 01:09:27 INFO - 'hg': 'c:/mozilla-build/hg/hg', 01:09:27 INFO - 'mozinstall': ('C:\\slave\\test-pgo\\build/venv/scripts/python', 01:09:27 INFO - 'C:\\slave\\test-pgo\\build/venv/scripts/mozinstall-script.py'), 01:09:27 INFO - 'python': 'c:/mozilla-build/python27/python.exe', 01:09:27 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe', 01:09:27 INFO - 'C:/mozilla-build/tooltool.py'), 01:09:27 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe', 01:09:27 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 01:09:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:09:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:09:27 INFO - 'installer_path': 'installer.exe', 01:09:27 INFO - 'log_level': 'info', 01:09:27 INFO - 'log_name': 'talos', 01:09:27 INFO - 'log_to_console': True, 01:09:27 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe', 01:09:27 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe', 01:09:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest', 01:09:27 INFO - 'opt_config_files': (), 01:09:27 INFO - 'pip_index': False, 01:09:27 INFO - 'sps_profile': False, 01:09:27 INFO - 'sps_profile_interval': 0, 01:09:27 INFO - 'suite': 'dromaeojs', 01:09:27 INFO - 'system_bits': '32', 01:09:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:09:27 INFO - 'title': 'T-W732-IX-129', 01:09:27 INFO - 'use_talos_json': True, 01:09:27 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'), 01:09:27 INFO - 'virtualenv_path': 'C:\\slave\\test-pgo\\build/venv', 01:09:27 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll', 01:09:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:09:27 INFO - 'work_dir': 'build'} 01:09:27 INFO - ##### 01:09:27 INFO - ##### Running clobber step. 01:09:27 INFO - ##### 01:09:27 INFO - Running pre-action listener: _resource_record_pre_action 01:09:27 INFO - Running main action method: clobber 01:09:27 INFO - rmtree: C:\slave\test-pgo\build 01:09:27 INFO - Using _rmtree_windows ... 01:09:27 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test-pgo\\build',), kwargs: {}, attempt #1 01:10:42 INFO - Running post-action listener: _resource_record_post_action 01:10:42 INFO - ##### 01:10:42 INFO - ##### Running read-buildbot-config step. 01:10:42 INFO - ##### 01:10:42 INFO - Running pre-action listener: _resource_record_pre_action 01:10:42 INFO - Running main action method: read_buildbot_config 01:10:42 INFO - Using buildbot properties: 01:10:42 INFO - { 01:10:42 INFO - "properties": { 01:10:42 INFO - "buildnumber": 284, 01:10:42 INFO - "product": "firefox", 01:10:42 INFO - "script_repo_revision": "production", 01:10:42 INFO - "builddir": "b2g-inbound_win7-ix_test-dromaeojs", 01:10:42 INFO - "repository": "", 01:10:42 INFO - "buildername": "Windows 7 32-bit b2g-inbound pgo talos dromaeojs", 01:10:42 INFO - "buildid": "20151023203110", 01:10:42 INFO - "slavename": "t-w732-ix-129", 01:10:42 INFO - "pgo_build": "True", 01:10:42 INFO - "basedir": "C:\\slave\\test-pgo", 01:10:42 INFO - "project": "", 01:10:42 INFO - "platform": "win7-ix", 01:10:42 INFO - "master": "http://buildbot-master119.bb.releng.scl3.mozilla.com:8201/", 01:10:42 INFO - "slavebuilddir": "test", 01:10:42 INFO - "scheduler": "tests-b2g-inbound-win32-pgo-talos", 01:10:42 INFO - "branch": "b2g-inbound", 01:10:42 INFO - "repo_path": "integration/b2g-inbound", 01:10:42 INFO - "stage_platform": "win32-pgo", 01:10:42 INFO - "builduid": "0acd7aa5aee5477e8b143a34a63b314b", 01:10:42 INFO - "revision": "19211c12647724e21cf63efc01817d28d5ebae52" 01:10:42 INFO - }, 01:10:42 INFO - "sourcestamp": { 01:10:42 INFO - "repository": "", 01:10:42 INFO - "hasPatch": false, 01:10:42 INFO - "project": "", 01:10:42 INFO - "branch": "b2g-inbound-win32-pgo-talos", 01:10:42 INFO - "changes": [ 01:10:42 INFO - { 01:10:42 INFO - "category": null, 01:10:42 INFO - "files": [ 01:10:42 INFO - { 01:10:42 INFO - "url": null, 01:10:42 INFO - "name": "https://queue.taskcluster.net/v1/task/jjttMSC1SH2qP1pz_Ue9jA/artifacts/public/build/firefox-44.0a1.en-US.win32.zip" 01:10:42 INFO - } 01:10:42 INFO - ], 01:10:42 INFO - "repository": "", 01:10:42 INFO - "rev": "19211c12647724e21cf63efc01817d28d5ebae52", 01:10:42 INFO - "who": "sendchange", 01:10:42 INFO - "when": 1445673883, 01:10:42 INFO - "number": 6569683, 01:10:42 INFO - "comments": "", 01:10:42 INFO - "project": "", 01:10:42 INFO - "at": "Sat 24 Oct 2015 01:04:43", 01:10:42 INFO - "branch": "b2g-inbound-win32-pgo-talos", 01:10:42 INFO - "revlink": "", 01:10:42 INFO - "properties": [ 01:10:42 INFO - [ 01:10:42 INFO - "buildid", 01:10:42 INFO - "20151023203110", 01:10:42 INFO - "Change" 01:10:42 INFO - ], 01:10:42 INFO - [ 01:10:42 INFO - "builduid", 01:10:42 INFO - "0acd7aa5aee5477e8b143a34a63b314b", 01:10:42 INFO - "Change" 01:10:42 INFO - ], 01:10:42 INFO - [ 01:10:42 INFO - "pgo_build", 01:10:42 INFO - "True", 01:10:42 INFO - "Change" 01:10:42 INFO - ] 01:10:42 INFO - ], 01:10:42 INFO - "revision": "19211c12647724e21cf63efc01817d28d5ebae52" 01:10:42 INFO - } 01:10:42 INFO - ], 01:10:42 INFO - "revision": "19211c12647724e21cf63efc01817d28d5ebae52" 01:10:42 INFO - } 01:10:42 INFO - } 01:10:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/jjttMSC1SH2qP1pz_Ue9jA/artifacts/public/build/firefox-44.0a1.en-US.win32.zip. 01:10:42 INFO - Running post-action listener: _resource_record_post_action 01:10:42 INFO - ##### 01:10:42 INFO - ##### Running download-and-extract step. 01:10:42 INFO - ##### 01:10:42 INFO - Running pre-action listener: _resource_record_pre_action 01:10:42 INFO - Running main action method: download_and_extract 01:10:42 INFO - mkdir: C:\slave\test-pgo\build\tests 01:10:42 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')]} 01:10:42 INFO - https://queue.taskcluster.net/v1/task/jjttMSC1SH2qP1pz_Ue9jA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:10:42 INFO - trying https://queue.taskcluster.net/v1/task/jjttMSC1SH2qP1pz_Ue9jA/artifacts/public/build/test_packages.json 01:10:42 INFO - Downloading https://queue.taskcluster.net/v1/task/jjttMSC1SH2qP1pz_Ue9jA/artifacts/public/build/test_packages.json to C:\slave\test-pgo\build\test_packages.json 01:10:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/jjttMSC1SH2qP1pz_Ue9jA/artifacts/public/build/test_packages.json', 'file_name': 'C:\\slave\\test-pgo\\build\\test_packages.json'}, attempt #1 01:10:43 INFO - Downloaded 1221 bytes. 01:10:43 INFO - Reading from file C:\slave\test-pgo\build\test_packages.json 01:10:43 INFO - Using the following test package requirements: 01:10:43 INFO - {u'common': [u'firefox-44.0a1.en-US.win32.common.tests.zip'], 01:10:43 INFO - u'cppunittest': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 01:10:43 INFO - u'firefox-44.0a1.en-US.win32.cppunittest.tests.zip'], 01:10:43 INFO - u'jittest': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 01:10:43 INFO - u'jsshell-win32.zip'], 01:10:43 INFO - u'mochitest': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 01:10:43 INFO - u'firefox-44.0a1.en-US.win32.mochitest.tests.zip'], 01:10:43 INFO - u'mozbase': [u'firefox-44.0a1.en-US.win32.common.tests.zip'], 01:10:43 INFO - u'reftest': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 01:10:43 INFO - u'firefox-44.0a1.en-US.win32.reftest.tests.zip'], 01:10:43 INFO - u'talos': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 01:10:43 INFO - u'firefox-44.0a1.en-US.win32.talos.tests.zip'], 01:10:43 INFO - u'web-platform': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 01:10:43 INFO - u'firefox-44.0a1.en-US.win32.web-platform.tests.zip'], 01:10:43 INFO - u'webapprt': [u'firefox-44.0a1.en-US.win32.common.tests.zip'], 01:10:43 INFO - u'xpcshell': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 01:10:43 INFO - u'firefox-44.0a1.en-US.win32.xpcshell.tests.zip']} 01:10:43 INFO - Downloading packages: [u'firefox-44.0a1.en-US.win32.common.tests.zip'] for test suite category: common 01:10: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')]} 01:10:43 INFO - https://queue.taskcluster.net/v1/task/jjttMSC1SH2qP1pz_Ue9jA/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip matches https://queue.taskcluster.net 01:10:43 INFO - trying https://queue.taskcluster.net/v1/task/jjttMSC1SH2qP1pz_Ue9jA/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip 01:10:43 INFO - Downloading https://queue.taskcluster.net/v1/task/jjttMSC1SH2qP1pz_Ue9jA/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 01:10:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/jjttMSC1SH2qP1pz_Ue9jA/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 01:10:45 INFO - Downloaded 18011081 bytes. 01:10:45 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 01:10:45 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.common.tests.zip 01:10:45 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win32.common.tests.zip'] with output_timeout 1760 01:11:18 INFO - Return code: 0 01:11:18 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 01:11:18 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')]} 01:11:18 INFO - https://queue.taskcluster.net/v1/task/jjttMSC1SH2qP1pz_Ue9jA/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip matches https://queue.taskcluster.net 01:11:18 INFO - trying https://queue.taskcluster.net/v1/task/jjttMSC1SH2qP1pz_Ue9jA/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip 01:11:18 INFO - Downloading https://queue.taskcluster.net/v1/task/jjttMSC1SH2qP1pz_Ue9jA/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 01:11:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/jjttMSC1SH2qP1pz_Ue9jA/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 01:11:20 INFO - Downloaded 18011081 bytes. 01:11:20 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 01:11:20 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.common.tests.zip 01:11:20 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win32.common.tests.zip'] with output_timeout 1760 01:11:46 INFO - Return code: 0 01:11:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:11:46 INFO - https://queue.taskcluster.net/v1/task/jjttMSC1SH2qP1pz_Ue9jA/artifacts/public/build/firefox-44.0a1.en-US.win32.talos.tests.zip matches https://queue.taskcluster.net 01:11:46 INFO - trying https://queue.taskcluster.net/v1/task/jjttMSC1SH2qP1pz_Ue9jA/artifacts/public/build/firefox-44.0a1.en-US.win32.talos.tests.zip 01:11:46 INFO - Downloading https://queue.taskcluster.net/v1/task/jjttMSC1SH2qP1pz_Ue9jA/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 01:11:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/jjttMSC1SH2qP1pz_Ue9jA/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 01:11:47 INFO - Downloaded 11131307 bytes. 01:11:47 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 01:11:47 INFO - Copy/paste: unzip -q -o C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.talos.tests.zip 01:11:47 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test-pgo\\build\\firefox-44.0a1.en-US.win32.talos.tests.zip'] with output_timeout 1760 01:11:51 INFO - Return code: 0 01:11:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:11:51 INFO - https://queue.taskcluster.net/v1/task/jjttMSC1SH2qP1pz_Ue9jA/artifacts/public/build/firefox-44.0a1.en-US.win32.zip matches https://queue.taskcluster.net 01:11:51 INFO - trying https://queue.taskcluster.net/v1/task/jjttMSC1SH2qP1pz_Ue9jA/artifacts/public/build/firefox-44.0a1.en-US.win32.zip 01:11:51 INFO - Downloading https://queue.taskcluster.net/v1/task/jjttMSC1SH2qP1pz_Ue9jA/artifacts/public/build/firefox-44.0a1.en-US.win32.zip to C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.zip 01:11:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/jjttMSC1SH2qP1pz_Ue9jA/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 01:11:55 INFO - Downloaded 53258610 bytes. 01:11:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/jjttMSC1SH2qP1pz_Ue9jA/artifacts/public/build/firefox-44.0a1.en-US.win32.zip 01:11:55 INFO - mkdir: C:\slave\test-pgo\properties 01:11:55 INFO - Writing buildbot properties ['build_url'] to C:\slave\test-pgo\properties\build_url 01:11:55 INFO - Writing to file C:\slave\test-pgo\properties\build_url 01:11:55 INFO - Contents: 01:11:55 INFO - build_url:https://queue.taskcluster.net/v1/task/jjttMSC1SH2qP1pz_Ue9jA/artifacts/public/build/firefox-44.0a1.en-US.win32.zip 01:11:55 INFO - Running post-action listener: _resource_record_post_action 01:11:55 INFO - Running post-action listener: set_extra_try_arguments 01:11:55 INFO - ##### 01:11:55 INFO - ##### Running populate-webroot step. 01:11:55 INFO - ##### 01:11:55 INFO - Running pre-action listener: _resource_record_pre_action 01:11:55 INFO - Running main action method: populate_webroot 01:11:55 INFO - Guessing talos json url... 01:11:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:11:55 INFO - https://queue.taskcluster.net/v1/task/jjttMSC1SH2qP1pz_Ue9jA/artifacts/public/build/firefox-44.0a1.en-US.win32.txt matches https://queue.taskcluster.net 01:11:55 INFO - trying https://queue.taskcluster.net/v1/task/jjttMSC1SH2qP1pz_Ue9jA/artifacts/public/build/firefox-44.0a1.en-US.win32.txt 01:11:55 INFO - Downloading https://queue.taskcluster.net/v1/task/jjttMSC1SH2qP1pz_Ue9jA/artifacts/public/build/firefox-44.0a1.en-US.win32.txt to C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.txt 01:11:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/jjttMSC1SH2qP1pz_Ue9jA/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 01:11:55 INFO - Downloaded 107 bytes. 01:11:55 INFO - Reading from file C:\slave\test-pgo\build\firefox-44.0a1.en-US.win32.txt 01:11:55 INFO - Contents: 01:11:55 INFO - 20151023203110 01:11:55 INFO - https://hg.mozilla.org/integration/b2g-inbound/rev/19211c12647724e21cf63efc01817d28d5ebae52 01:11:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:11:55 INFO - trying https://hg.mozilla.org/integration/b2g-inbound/raw-file/19211c1264/testing/talos/talos.json 01:11:55 INFO - Downloading https://hg.mozilla.org/integration/b2g-inbound/raw-file/19211c1264/testing/talos/talos.json to C:\slave\test-pgo\build\talos.json 01:11:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/b2g-inbound/raw-file/19211c1264/testing/talos/talos.json', 'file_name': 'C:\\slave\\test-pgo\\build\\talos.json'}, attempt #1 01:11:56 INFO - Downloaded 4264 bytes. 01:11:56 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']}, 01:11:56 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']}, 01:11:56 INFO - u'remote-trobocheck2': {u'talos_options': [u'--fennecIDs', 01:11:56 INFO - u'../fennec_ids.txt'], 01:11:56 INFO - u'tests': [u'tcheck2']}, 01:11:56 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome', 01:11:56 INFO - u'--tppagecycles', 01:11:56 INFO - u'7'], 01:11:56 INFO - u'tests': [u'tsvgm']}}, 01:11:56 INFO - u'suites': {u'chromez': {u'tests': [u'tresize', u'tcanvasmark']}, 01:11:56 INFO - u'chromez-e10s': {u'talos_options': [u'--e10s'], 01:11:56 INFO - u'tests': [u'tresize', u'tcanvasmark']}, 01:11:56 INFO - u'dromaeojs': {u'tests': [u'dromaeo_css', u'kraken', u'v8_7']}, 01:11:56 INFO - u'dromaeojs-e10s': {u'talos_options': [u'--e10s'], 01:11:56 INFO - u'tests': [u'dromaeo_css', 01:11:56 INFO - u'kraken', 01:11:56 INFO - u'v8_7']}, 01:11:56 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:11:56 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 01:11:56 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:11:56 INFO - u'talos_options': [u'--e10s'], 01:11:56 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 01:11:56 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:11:56 INFO - u'tests': [u'damp', u'tps']}, 01:11:56 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:11:56 INFO - u'talos_options': [u'--e10s'], 01:11:56 INFO - u'tests': [u'damp', u'tps']}, 01:11:56 INFO - u'g3': {u'tests': [u'dromaeo_dom']}, 01:11:56 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']}, 01:11:56 INFO - u'other': {u'tests': [u'a11yr', 01:11:56 INFO - u'ts_paint', 01:11:56 INFO - u'tpaint', 01:11:56 INFO - u'sessionrestore', 01:11:56 INFO - u'sessionrestore_no_auto_restore']}, 01:11:56 INFO - u'other-e10s': {u'talos_options': [u'--e10s'], 01:11:56 INFO - u'tests': [u'a11yr', 01:11:56 INFO - u'ts_paint', 01:11:56 INFO - u'tpaint', 01:11:56 INFO - u'sessionrestore', 01:11:56 INFO - u'sessionrestore_no_auto_restore']}, 01:11:56 INFO - u'other-e10s_l64': {u'talos_options': [u'--e10s'], 01:11:56 INFO - u'tests': [u'a11yr', 01:11:56 INFO - u'ts_paint', 01:11:56 INFO - u'tpaint', 01:11:56 INFO - u'sessionrestore', 01:11:56 INFO - u'sessionrestore_no_auto_restore']}, 01:11:56 INFO - u'other-e10s_nol64': {u'talos_options': [u'--e10s'], 01:11:56 INFO - u'tests': [u'a11yr', 01:11:56 INFO - u'ts_paint', 01:11:56 INFO - u'tpaint', 01:11:56 INFO - u'sessionrestore', 01:11:56 INFO - u'sessionrestore_no_auto_restore']}, 01:11:56 INFO - u'other_l64': {u'tests': [u'a11yr', 01:11:56 INFO - u'ts_paint', 01:11:56 INFO - u'tpaint', 01:11:56 INFO - u'sessionrestore', 01:11:56 INFO - u'sessionrestore_no_auto_restore']}, 01:11:56 INFO - u'other_nol64': {u'tests': [u'a11yr', 01:11:56 INFO - u'ts_paint', 01:11:56 INFO - u'tpaint', 01:11:56 INFO - u'sessionrestore', 01:11:56 INFO - u'sessionrestore_no_auto_restore']}, 01:11:56 INFO - u'svgr': {u'tests': [u'tsvgx', 01:11:56 INFO - u'tsvgr_opacity', 01:11:56 INFO - u'tart', 01:11:56 INFO - u'tscrollx', 01:11:56 INFO - u'cart']}, 01:11:56 INFO - u'svgr-e10s': {u'talos_options': [u'--e10s'], 01:11:56 INFO - u'tests': [u'tsvgx', 01:11:56 INFO - u'tsvgr_opacity', 01:11:56 INFO - u'tart', 01:11:56 INFO - u'tscrollx', 01:11:56 INFO - u'cart']}, 01:11:56 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:11:56 INFO - u'tests': [u'tp5o']}, 01:11:56 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:11:56 INFO - u'talos_options': [u'--e10s'], 01:11:56 INFO - u'tests': [u'tp5o']}, 01:11:56 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:11:56 INFO - u'talos_options': [u'--xperf_path', 01:11:56 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:11:56 INFO - u'tests': [u'tp5n']}, 01:11:56 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:11:56 INFO - u'talos_options': [u'--e10s', 01:11:56 INFO - u'--xperf_path', 01:11:56 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 01:11:56 INFO - u'C:/slave/talos-data/talos/xperf.config'], 01:11:56 INFO - u'tests': [u'tp5n']}}, 01:11:56 INFO - u'talos.zip': {u'path': u'', 01:11:56 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:11:56 INFO - Running post-action listener: _resource_record_post_action 01:11:56 INFO - ##### 01:11:56 INFO - ##### Running create-virtualenv step. 01:11:56 INFO - ##### 01:11:56 INFO - Running pre-action listener: _resource_record_pre_action 01:11:56 INFO - Running main action method: create_virtualenv 01:11:56 INFO - Creating virtualenv C:\slave\test-pgo\build/venv 01:11:56 INFO - mkdir: C:\slave\test-pgo\build\venv\Scripts 01:11:56 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test-pgo\build\venv\Scripts\python27.dll 01:11:56 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'! 01:11:56 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 01:11:56 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 01:12:02 INFO - New python executable in C:\slave\test-pgo\build/venv\Scripts\python.exe 01:12:05 INFO - Installing distribute......................................................................................................................................................................................done. 01:12:06 INFO - Return code: 0 01:12:06 INFO - Installing pip>=1.5 into virtualenv C:\slave\test-pgo\build/venv 01:12:06 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')]} 01:12:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:12:06 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')]} 01:12:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:12:06 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 0x019B8B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01978EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x013CE8C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012E8B48>, '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 0x0130A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01A39660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-129', 'USERDOMAIN': 'T-W732-IX-129', '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-129', '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 01:12:06 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 01:12:06 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 01:12:06 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 01:12:06 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 01:12:06 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 01:12:06 INFO - 'COMPUTERNAME': 'T-W732-IX-129', 01:12:06 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 01:12:06 INFO - 'CYGWINBASE': 'C:\\cygwin', 01:12:06 INFO - 'DCLOCATION': 'SCL3', 01:12:06 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 01:12:06 INFO - 'FP_NO_HOST_CHECK': 'NO', 01:12:06 INFO - 'HOMEDRIVE': 'C:', 01:12:06 INFO - 'HOMEPATH': '\\Users\\cltbld', 01:12:06 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 01:12:06 INFO - 'KTS_VERSION': '1.19c', 01:12:06 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 01:12:06 INFO - 'LOGONSERVER': '\\\\T-W732-IX-129', 01:12:06 INFO - 'MONDIR': 'C:\\Monitor_config\\', 01:12:06 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 01:12:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:12:06 INFO - 'MOZ_NO_REMOTE': '1', 01:12:06 INFO - 'NO_EM_RESTART': '1', 01:12:06 INFO - 'NUMBER_OF_PROCESSORS': '8', 01:12:06 INFO - 'OS': 'Windows_NT', 01:12:06 INFO - 'OURDRIVE': 'C:', 01:12:06 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;', 01:12:06 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 01:12:06 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 01:12:06 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 01:12:06 INFO - 'PROCESSOR_LEVEL': '6', 01:12:06 INFO - 'PROCESSOR_REVISION': '1e05', 01:12:06 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 01:12:06 INFO - 'PROGRAMFILES': 'C:\\Program Files', 01:12:06 INFO - 'PROMPT': '$P$G', 01:12:06 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 01:12:06 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 01:12:06 INFO - 'PUBLIC': 'C:\\Users\\Public', 01:12:06 INFO - 'PWD': 'C:\\slave\\test-pgo', 01:12:06 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 01:12:06 INFO - 'SLAVEDIR': 'C:\\slave\\', 01:12:06 INFO - 'SYSTEMDRIVE': 'C:', 01:12:06 INFO - 'SYSTEMROOT': 'C:\\windows', 01:12:06 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 01:12:06 INFO - 'TEST1': 'testie', 01:12:06 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 01:12:06 INFO - 'USERDOMAIN': 'T-W732-IX-129', 01:12:06 INFO - 'USERNAME': 'cltbld', 01:12:06 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 01:12:06 INFO - 'WINDIR': 'C:\\windows', 01:12:06 INFO - 'WINDOWS_TRACING_FLAGS': '3', 01:12:06 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 01:12:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 01:12:07 INFO - Ignoring indexes: http://pypi.python.org/simple/ 01:12:07 INFO - Downloading/unpacking pip>=1.5 01:12:07 INFO - Creating supposed download cache at C:\slave\test-pgo\build/venv\cache 01:12:11 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 01:12:11 INFO - Running setup.py egg_info for package pip 01:12:11 INFO - warning: no files found matching 'pip\cacert.pem' 01:12:11 INFO - warning: no files found matching '*.html' under directory 'docs' 01:12:11 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 01:12:11 INFO - no previously-included directories found matching 'docs\_build\_sources' 01:12:11 INFO - Installing collected packages: pip 01:12:11 INFO - Found existing installation: pip 0.8.2 01:12:11 INFO - Uninstalling pip: 01:12:11 INFO - Successfully uninstalled pip 01:12:11 INFO - Running setup.py install for pip 01:12:11 INFO - warning: no files found matching 'pip\cacert.pem' 01:12:11 INFO - warning: no files found matching '*.html' under directory 'docs' 01:12:11 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 01:12:11 INFO - no previously-included directories found matching 'docs\_build\_sources' 01:12:11 INFO - Installing pip-script.py script to C:\slave\test-pgo\build\venv\Scripts 01:12:11 INFO - Installing pip.exe script to C:\slave\test-pgo\build\venv\Scripts 01:12:11 INFO - Installing pip2.7-script.py script to C:\slave\test-pgo\build\venv\Scripts 01:12:11 INFO - Installing pip2.7.exe script to C:\slave\test-pgo\build\venv\Scripts 01:12:11 INFO - Installing pip2-script.py script to C:\slave\test-pgo\build\venv\Scripts 01:12:11 INFO - Installing pip2.exe script to C:\slave\test-pgo\build\venv\Scripts 01:12:11 INFO - Successfully installed pip 01:12:11 INFO - Cleaning up... 01:12:11 INFO - Return code: 0 01:12:11 INFO - Installing psutil>=0.7.1 into virtualenv C:\slave\test-pgo\build/venv 01:12: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')]} 01:12:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:12: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')]} 01:12:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:12:11 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x019B8B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01978EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x013CE8C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012E8B48>, '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 0x0130A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01A39660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-129', 'USERDOMAIN': 'T-W732-IX-129', '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-129', '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 01:12:11 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in C:\slave\test-pgo\build 01:12:11 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --download-cache C:\slave\test-pgo\build/venv\cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 01:12:11 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 01:12:11 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 01:12:11 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 01:12:11 INFO - 'COMPUTERNAME': 'T-W732-IX-129', 01:12:11 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 01:12:11 INFO - 'CYGWINBASE': 'C:\\cygwin', 01:12:11 INFO - 'DCLOCATION': 'SCL3', 01:12:11 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 01:12:11 INFO - 'FP_NO_HOST_CHECK': 'NO', 01:12:11 INFO - 'HOMEDRIVE': 'C:', 01:12:11 INFO - 'HOMEPATH': '\\Users\\cltbld', 01:12:11 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 01:12:11 INFO - 'KTS_VERSION': '1.19c', 01:12:11 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 01:12:11 INFO - 'LOGONSERVER': '\\\\T-W732-IX-129', 01:12:11 INFO - 'MONDIR': 'C:\\Monitor_config\\', 01:12:11 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 01:12:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:12:11 INFO - 'MOZ_NO_REMOTE': '1', 01:12:11 INFO - 'NO_EM_RESTART': '1', 01:12:11 INFO - 'NUMBER_OF_PROCESSORS': '8', 01:12:11 INFO - 'OS': 'Windows_NT', 01:12:11 INFO - 'OURDRIVE': 'C:', 01:12: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;', 01:12:11 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 01:12:11 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 01:12:11 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 01:12:11 INFO - 'PROCESSOR_LEVEL': '6', 01:12:11 INFO - 'PROCESSOR_REVISION': '1e05', 01:12:11 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 01:12:11 INFO - 'PROGRAMFILES': 'C:\\Program Files', 01:12:11 INFO - 'PROMPT': '$P$G', 01:12:11 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 01:12:11 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 01:12:11 INFO - 'PUBLIC': 'C:\\Users\\Public', 01:12:11 INFO - 'PWD': 'C:\\slave\\test-pgo', 01:12:11 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 01:12:11 INFO - 'SLAVEDIR': 'C:\\slave\\', 01:12:11 INFO - 'SYSTEMDRIVE': 'C:', 01:12:11 INFO - 'SYSTEMROOT': 'C:\\windows', 01:12:11 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 01:12:11 INFO - 'TEST1': 'testie', 01:12:11 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 01:12:11 INFO - 'USERDOMAIN': 'T-W732-IX-129', 01:12:11 INFO - 'USERNAME': 'cltbld', 01:12:11 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 01:12:11 INFO - 'WINDIR': 'C:\\windows', 01:12:11 INFO - 'WINDOWS_TRACING_FLAGS': '3', 01:12:11 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 01:12:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 01:12:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:12:13 INFO - Downloading/unpacking psutil>=0.7.1 01:12:13 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 01:12:13 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 01:12:14 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 01:12:14 INFO - Installing collected packages: psutil 01:12:14 INFO - Successfully installed psutil 01:12:14 INFO - Cleaning up... 01:12:14 INFO - Return code: 0 01:12:14 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv C:\slave\test-pgo\build/venv 01:12:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:12:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:12:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:12:14 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 0x019B8B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01978EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x013CE8C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012E8B48>, '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 0x0130A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01A39660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-129', 'USERDOMAIN': 'T-W732-IX-129', '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-129', '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 01:12:14 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 01:12:14 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 01:12:14 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 01:12:14 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 01:12:14 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 01:12:14 INFO - 'COMPUTERNAME': 'T-W732-IX-129', 01:12:14 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 01:12:14 INFO - 'CYGWINBASE': 'C:\\cygwin', 01:12:14 INFO - 'DCLOCATION': 'SCL3', 01:12:14 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 01:12:14 INFO - 'FP_NO_HOST_CHECK': 'NO', 01:12:14 INFO - 'HOMEDRIVE': 'C:', 01:12:14 INFO - 'HOMEPATH': '\\Users\\cltbld', 01:12:14 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 01:12:14 INFO - 'KTS_VERSION': '1.19c', 01:12:14 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 01:12:14 INFO - 'LOGONSERVER': '\\\\T-W732-IX-129', 01:12:14 INFO - 'MONDIR': 'C:\\Monitor_config\\', 01:12:14 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 01:12:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:12:14 INFO - 'MOZ_NO_REMOTE': '1', 01:12:14 INFO - 'NO_EM_RESTART': '1', 01:12:14 INFO - 'NUMBER_OF_PROCESSORS': '8', 01:12:14 INFO - 'OS': 'Windows_NT', 01:12:14 INFO - 'OURDRIVE': 'C:', 01:12:14 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 01:12:14 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 01:12:14 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 01:12:14 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 01:12:14 INFO - 'PROCESSOR_LEVEL': '6', 01:12:14 INFO - 'PROCESSOR_REVISION': '1e05', 01:12:14 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 01:12:14 INFO - 'PROGRAMFILES': 'C:\\Program Files', 01:12:14 INFO - 'PROMPT': '$P$G', 01:12:14 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 01:12:14 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 01:12:14 INFO - 'PUBLIC': 'C:\\Users\\Public', 01:12:14 INFO - 'PWD': 'C:\\slave\\test-pgo', 01:12:14 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 01:12:14 INFO - 'SLAVEDIR': 'C:\\slave\\', 01:12:14 INFO - 'SYSTEMDRIVE': 'C:', 01:12:14 INFO - 'SYSTEMROOT': 'C:\\windows', 01:12:14 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 01:12:14 INFO - 'TEST1': 'testie', 01:12:14 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 01:12:14 INFO - 'USERDOMAIN': 'T-W732-IX-129', 01:12:14 INFO - 'USERNAME': 'cltbld', 01:12:14 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 01:12:14 INFO - 'WINDIR': 'C:\\windows', 01:12:14 INFO - 'WINDOWS_TRACING_FLAGS': '3', 01:12:14 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 01:12:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 01:12:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:12:14 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:12:14 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 01:12:14 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 01:12:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:12:15 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 01:12:15 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor 01:12:15 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) 01:12:15 INFO - Installing collected packages: mozsystemmonitor 01:12:15 INFO - Running setup.py install for mozsystemmonitor 01:12:15 INFO - Successfully installed mozsystemmonitor 01:12:15 INFO - Cleaning up... 01:12:16 INFO - Return code: 0 01:12:16 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test-pgo\build/venv 01:12:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:12:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:12:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:12:16 INFO - retry: Calling run_command with args: [['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x019B8B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01978EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x013CE8C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012E8B48>, '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 0x0130A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01A39660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-129', 'USERDOMAIN': 'T-W732-IX-129', '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-129', '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 01:12:16 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test-pgo\\build/venv\\cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in C:\slave\test-pgo\build 01:12:16 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip install --download-cache C:\slave\test-pgo\build/venv\cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:12:16 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 01:12:16 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 01:12:16 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 01:12:16 INFO - 'COMPUTERNAME': 'T-W732-IX-129', 01:12:16 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 01:12:16 INFO - 'CYGWINBASE': 'C:\\cygwin', 01:12:16 INFO - 'DCLOCATION': 'SCL3', 01:12:16 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 01:12:16 INFO - 'FP_NO_HOST_CHECK': 'NO', 01:12:16 INFO - 'HOMEDRIVE': 'C:', 01:12:16 INFO - 'HOMEPATH': '\\Users\\cltbld', 01:12:16 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 01:12:16 INFO - 'KTS_VERSION': '1.19c', 01:12:16 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 01:12:16 INFO - 'LOGONSERVER': '\\\\T-W732-IX-129', 01:12:16 INFO - 'MONDIR': 'C:\\Monitor_config\\', 01:12:16 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 01:12:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:12:16 INFO - 'MOZ_NO_REMOTE': '1', 01:12:16 INFO - 'NO_EM_RESTART': '1', 01:12:16 INFO - 'NUMBER_OF_PROCESSORS': '8', 01:12:16 INFO - 'OS': 'Windows_NT', 01:12:16 INFO - 'OURDRIVE': 'C:', 01:12:16 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 01:12:16 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 01:12:16 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 01:12:16 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 01:12:16 INFO - 'PROCESSOR_LEVEL': '6', 01:12:16 INFO - 'PROCESSOR_REVISION': '1e05', 01:12:16 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 01:12:16 INFO - 'PROGRAMFILES': 'C:\\Program Files', 01:12:16 INFO - 'PROMPT': '$P$G', 01:12:16 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 01:12:16 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 01:12:16 INFO - 'PUBLIC': 'C:\\Users\\Public', 01:12:16 INFO - 'PWD': 'C:\\slave\\test-pgo', 01:12:16 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 01:12:16 INFO - 'SLAVEDIR': 'C:\\slave\\', 01:12:16 INFO - 'SYSTEMDRIVE': 'C:', 01:12:16 INFO - 'SYSTEMROOT': 'C:\\windows', 01:12:16 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 01:12:16 INFO - 'TEST1': 'testie', 01:12:16 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 01:12:16 INFO - 'USERDOMAIN': 'T-W732-IX-129', 01:12:16 INFO - 'USERNAME': 'cltbld', 01:12:16 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 01:12:16 INFO - 'WINDIR': 'C:\\windows', 01:12:16 INFO - 'WINDOWS_TRACING_FLAGS': '3', 01:12:16 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 01:12:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 01:12:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:12:16 INFO - Downloading/unpacking blobuploader==1.2.4 01:12:16 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 01:12:16 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 01:12:17 INFO - Downloading blobuploader-1.2.4.tar.gz 01:12:17 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 01:12:17 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader 01:12:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:12:17 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 01:12:17 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 01:12:17 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 01:12:17 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\requests\setup.py) egg_info for package requests 01:12:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:12:17 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 01:12:17 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 01:12:18 INFO - Downloading docopt-0.6.1.tar.gz 01:12:18 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 01:12:18 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\docopt\setup.py) egg_info for package docopt 01:12:18 INFO - Installing collected packages: blobuploader, requests, docopt 01:12:18 INFO - Running setup.py install for blobuploader 01:12:18 INFO - Running setup.py install for requests 01:12:19 INFO - Running setup.py install for docopt 01:12:19 INFO - Successfully installed blobuploader requests docopt 01:12:19 INFO - Cleaning up... 01:12:20 INFO - Return code: 0 01:12:20 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv 01:12: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')]} 01:12:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:12: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')]} 01:12:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:12:20 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 0x019B8B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01978EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x013CE8C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012E8B48>, '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 0x0130A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01A39660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-129', 'USERDOMAIN': 'T-W732-IX-129', '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-129', '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 01:12:20 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 01:12:20 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 01:12:20 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 01:12:20 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 01:12:20 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 01:12:20 INFO - 'COMPUTERNAME': 'T-W732-IX-129', 01:12:20 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 01:12:20 INFO - 'CYGWINBASE': 'C:\\cygwin', 01:12:20 INFO - 'DCLOCATION': 'SCL3', 01:12:20 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 01:12:20 INFO - 'FP_NO_HOST_CHECK': 'NO', 01:12:20 INFO - 'HOMEDRIVE': 'C:', 01:12:20 INFO - 'HOMEPATH': '\\Users\\cltbld', 01:12:20 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 01:12:20 INFO - 'KTS_VERSION': '1.19c', 01:12:20 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 01:12:20 INFO - 'LOGONSERVER': '\\\\T-W732-IX-129', 01:12:20 INFO - 'MONDIR': 'C:\\Monitor_config\\', 01:12:20 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 01:12:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:12:20 INFO - 'MOZ_NO_REMOTE': '1', 01:12:20 INFO - 'NO_EM_RESTART': '1', 01:12:20 INFO - 'NUMBER_OF_PROCESSORS': '8', 01:12:20 INFO - 'OS': 'Windows_NT', 01:12:20 INFO - 'OURDRIVE': 'C:', 01:12:20 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 01:12:20 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 01:12:20 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 01:12:20 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 01:12:20 INFO - 'PROCESSOR_LEVEL': '6', 01:12:20 INFO - 'PROCESSOR_REVISION': '1e05', 01:12:20 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 01:12:20 INFO - 'PROGRAMFILES': 'C:\\Program Files', 01:12:20 INFO - 'PROMPT': '$P$G', 01:12:20 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 01:12:20 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 01:12:20 INFO - 'PUBLIC': 'C:\\Users\\Public', 01:12:20 INFO - 'PWD': 'C:\\slave\\test-pgo', 01:12:20 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 01:12:20 INFO - 'SLAVEDIR': 'C:\\slave\\', 01:12:20 INFO - 'SYSTEMDRIVE': 'C:', 01:12:20 INFO - 'SYSTEMROOT': 'C:\\windows', 01:12:20 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 01:12:20 INFO - 'TEST1': 'testie', 01:12:20 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 01:12:20 INFO - 'USERDOMAIN': 'T-W732-IX-129', 01:12:20 INFO - 'USERNAME': 'cltbld', 01:12:20 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 01:12:20 INFO - 'WINDIR': 'C:\\windows', 01:12:20 INFO - 'WINDOWS_TRACING_FLAGS': '3', 01:12:20 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 01:12:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 01:12:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:12:21 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\manifestparser 01:12:21 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-kzlm7t-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/manifestparser 01:12:21 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozcrash 01:12:21 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-g9txwh-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozcrash 01:12:21 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdebug 01:12:21 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-xbrioe-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdebug 01:12:21 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdevice 01:12:21 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-lkvdw8-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdevice 01:12:21 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozfile 01:12:21 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-lxuhnm-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozfile 01:12:21 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozhttpd 01:12:21 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-bju1z_-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozhttpd 01:12:22 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinfo 01:12:22 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-dmdlij-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinfo 01:12:22 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinstall 01:12:22 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-yd7xgh-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinstall 01:12:22 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozleak 01:12:22 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-igpcr9-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozleak 01:12:22 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozlog 01:12:22 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-5iifrf-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozlog 01:12:22 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moznetwork 01:12:22 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-lwayoy-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moznetwork 01:12:22 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprocess 01:12:23 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-wtntct-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprocess 01:12:23 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprofile 01:12:23 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-p3hybd-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprofile 01:12:23 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozrunner 01:12:23 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-0eslxd-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozrunner 01:12:23 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozscreenshot 01:12:23 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-ud7jk_-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:12:23 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moztest 01:12:23 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-zqtqcc-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moztest 01:12:23 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozversion 01:12:23 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-xhqadg-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozversion 01:12:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:12:23 INFO - Running setup.py install for manifestparser 01:12:24 INFO - Installing manifestparser-script.py script to C:\slave\test-pgo\build\venv\Scripts 01:12:24 INFO - Installing manifestparser.exe script to C:\slave\test-pgo\build\venv\Scripts 01:12:24 INFO - Running setup.py install for mozcrash 01:12:24 INFO - Running setup.py install for mozdebug 01:12:25 INFO - Running setup.py install for mozdevice 01:12:25 INFO - Installing sutini-script.py script to C:\slave\test-pgo\build\venv\Scripts 01:12:25 INFO - Installing sutini.exe script to C:\slave\test-pgo\build\venv\Scripts 01:12:25 INFO - Installing dm-script.py script to C:\slave\test-pgo\build\venv\Scripts 01:12:25 INFO - Installing dm.exe script to C:\slave\test-pgo\build\venv\Scripts 01:12:25 INFO - Running setup.py install for mozfile 01:12:26 INFO - Running setup.py install for mozhttpd 01:12:26 INFO - Installing mozhttpd-script.py script to C:\slave\test-pgo\build\venv\Scripts 01:12:26 INFO - Installing mozhttpd.exe script to C:\slave\test-pgo\build\venv\Scripts 01:12:26 INFO - Running setup.py install for mozinfo 01:12:27 INFO - Installing mozinfo-script.py script to C:\slave\test-pgo\build\venv\Scripts 01:12:27 INFO - Installing mozinfo.exe script to C:\slave\test-pgo\build\venv\Scripts 01:12:27 INFO - Running setup.py install for mozInstall 01:12:27 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test-pgo\build\venv\Scripts 01:12:27 INFO - Installing moz_remove_from_system.exe script to C:\slave\test-pgo\build\venv\Scripts 01:12:27 INFO - Installing mozuninstall-script.py script to C:\slave\test-pgo\build\venv\Scripts 01:12:27 INFO - Installing mozuninstall.exe script to C:\slave\test-pgo\build\venv\Scripts 01:12:27 INFO - Installing mozinstall-script.py script to C:\slave\test-pgo\build\venv\Scripts 01:12:27 INFO - Installing mozinstall.exe script to C:\slave\test-pgo\build\venv\Scripts 01:12:27 INFO - Installing moz_add_to_system-script.py script to C:\slave\test-pgo\build\venv\Scripts 01:12:27 INFO - Installing moz_add_to_system.exe script to C:\slave\test-pgo\build\venv\Scripts 01:12:27 INFO - Running setup.py install for mozleak 01:12:27 INFO - Running setup.py install for mozlog 01:12:28 INFO - Installing structlog-script.py script to C:\slave\test-pgo\build\venv\Scripts 01:12:28 INFO - Installing structlog.exe script to C:\slave\test-pgo\build\venv\Scripts 01:12:28 INFO - Running setup.py install for moznetwork 01:12:29 INFO - Installing moznetwork-script.py script to C:\slave\test-pgo\build\venv\Scripts 01:12:29 INFO - Installing moznetwork.exe script to C:\slave\test-pgo\build\venv\Scripts 01:12:29 INFO - Running setup.py install for mozprocess 01:12:29 INFO - Running setup.py install for mozprofile 01:12:30 INFO - Installing mozprofile-script.py script to C:\slave\test-pgo\build\venv\Scripts 01:12:30 INFO - Installing mozprofile.exe script to C:\slave\test-pgo\build\venv\Scripts 01:12:30 INFO - Installing diff-profiles-script.py script to C:\slave\test-pgo\build\venv\Scripts 01:12:30 INFO - Installing diff-profiles.exe script to C:\slave\test-pgo\build\venv\Scripts 01:12:30 INFO - Installing view-profile-script.py script to C:\slave\test-pgo\build\venv\Scripts 01:12:30 INFO - Installing view-profile.exe script to C:\slave\test-pgo\build\venv\Scripts 01:12:30 INFO - Running setup.py install for mozrunner 01:12:30 INFO - Installing mozrunner-script.py script to C:\slave\test-pgo\build\venv\Scripts 01:12:30 INFO - Installing mozrunner.exe script to C:\slave\test-pgo\build\venv\Scripts 01:12:31 INFO - Running setup.py install for mozscreenshot 01:12:31 INFO - Running setup.py install for moztest 01:12:31 INFO - Running setup.py install for mozversion 01:12:32 INFO - Installing mozversion-script.py script to C:\slave\test-pgo\build\venv\Scripts 01:12:32 INFO - Installing mozversion.exe script to C:\slave\test-pgo\build\venv\Scripts 01:12:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:12:32 INFO - Cleaning up... 01:12:32 INFO - Return code: 0 01:12:32 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv 01:12:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:12:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:12:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:12:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:12:32 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 0x019B8B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01978EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x013CE8C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012E8B48>, '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 0x0130A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01A39660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-129', 'USERDOMAIN': 'T-W732-IX-129', '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-129', '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 01:12:32 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 01:12:32 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 01:12:32 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 01:12:32 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 01:12:32 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 01:12:32 INFO - 'COMPUTERNAME': 'T-W732-IX-129', 01:12:32 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 01:12:32 INFO - 'CYGWINBASE': 'C:\\cygwin', 01:12:32 INFO - 'DCLOCATION': 'SCL3', 01:12:32 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 01:12:32 INFO - 'FP_NO_HOST_CHECK': 'NO', 01:12:32 INFO - 'HOMEDRIVE': 'C:', 01:12:32 INFO - 'HOMEPATH': '\\Users\\cltbld', 01:12:32 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 01:12:32 INFO - 'KTS_VERSION': '1.19c', 01:12:32 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 01:12:32 INFO - 'LOGONSERVER': '\\\\T-W732-IX-129', 01:12:32 INFO - 'MONDIR': 'C:\\Monitor_config\\', 01:12:32 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 01:12:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:12:32 INFO - 'MOZ_NO_REMOTE': '1', 01:12:32 INFO - 'NO_EM_RESTART': '1', 01:12:32 INFO - 'NUMBER_OF_PROCESSORS': '8', 01:12:32 INFO - 'OS': 'Windows_NT', 01:12:32 INFO - 'OURDRIVE': 'C:', 01:12:32 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;', 01:12:32 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 01:12:32 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 01:12:32 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 01:12:32 INFO - 'PROCESSOR_LEVEL': '6', 01:12:32 INFO - 'PROCESSOR_REVISION': '1e05', 01:12:32 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 01:12:32 INFO - 'PROGRAMFILES': 'C:\\Program Files', 01:12:32 INFO - 'PROMPT': '$P$G', 01:12:32 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 01:12:32 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 01:12:32 INFO - 'PUBLIC': 'C:\\Users\\Public', 01:12:32 INFO - 'PWD': 'C:\\slave\\test-pgo', 01:12:32 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 01:12:32 INFO - 'SLAVEDIR': 'C:\\slave\\', 01:12:32 INFO - 'SYSTEMDRIVE': 'C:', 01:12:32 INFO - 'SYSTEMROOT': 'C:\\windows', 01:12:32 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 01:12:32 INFO - 'TEST1': 'testie', 01:12:32 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 01:12:32 INFO - 'USERDOMAIN': 'T-W732-IX-129', 01:12:32 INFO - 'USERNAME': 'cltbld', 01:12:32 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 01:12:32 INFO - 'WINDIR': 'C:\\windows', 01:12:32 INFO - 'WINDOWS_TRACING_FLAGS': '3', 01:12:32 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 01:12:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 01:12:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:12:32 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\manifestparser 01:12:32 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-uclbic-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/manifestparser 01:12:32 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)) 01:12:32 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozcrash 01:12:32 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-69tqh7-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozcrash 01:12:32 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)) 01:12:32 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdebug 01:12:32 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-hk2vbu-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdebug 01:12:33 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)) 01:12:33 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozdevice 01:12:33 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-amkklz-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozdevice 01:12:33 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)) 01:12:33 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozfile 01:12:33 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-egypdd-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozfile 01:12:33 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)) 01:12:33 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozhttpd 01:12:33 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-bupt__-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozhttpd 01:12:33 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)) 01:12:33 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinfo 01:12:33 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-3click-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinfo 01:12:33 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)) 01:12:33 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozinstall 01:12:33 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-zojzb3-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozinstall 01:12:33 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)) 01:12:33 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozleak 01:12:33 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-igppy6-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozleak 01:12:33 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)) 01:12:33 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozlog 01:12:33 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-ujhp8v-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozlog 01:12:34 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)) 01:12:34 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moznetwork 01:12:34 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-ggsgb3-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moznetwork 01:12:34 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)) 01:12:34 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprocess 01:12:34 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-lnpqyo-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprocess 01:12:34 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)) 01:12:34 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozprofile 01:12:34 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-bje14v-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozprofile 01:12:34 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)) 01:12:34 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozrunner 01:12:34 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-lfdaef-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozrunner 01:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///C:/slave/test-pgo/build/tests/mozbase/mozrunner in c:\slave\test-pgo\build\venv\lib\site-packages (from -r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 14)) 01:12:34 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozscreenshot 01:12:34 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-sviela-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:12:34 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)) 01:12:34 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\moztest 01:12:34 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-n4ksab-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/moztest 01:12:35 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)) 01:12:35 INFO - Unpacking c:\slave\test-pgo\build\tests\mozbase\mozversion 01:12:35 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-cpapim-build\setup.py) egg_info for package from file:///C:/slave/test-pgo/build/tests/mozbase/mozversion 01:12:35 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)) 01:12:35 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)) 01:12:35 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)) 01:12:35 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)) 01:12:35 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)) 01:12:35 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)) 01:12:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r C:\slave\test-pgo\build\tests\config\mozbase_requirements.txt (line 10)) 01:12:35 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 01:12:35 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 01:12:36 INFO - Downloading blessings-1.5.1.tar.gz 01:12:36 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 01:12:36 INFO - Running setup.py (path:C:\slave\test-pgo\build\venv\build\blessings\setup.py) egg_info for package blessings 01:12:36 INFO - Installing collected packages: blessings 01:12:36 INFO - Running setup.py install for blessings 01:12:36 INFO - Successfully installed blessings 01:12:36 INFO - Cleaning up... 01:12:39 INFO - Return code: 0 01:12:39 INFO - Done creating virtualenv C:\slave\test-pgo\build/venv. 01:12:39 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'freeze'] 01:12:39 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip freeze 01:12:39 INFO - Reading from file tmpfile_stdout 01:12:39 INFO - Using _rmtree_windows ... 01:12:39 INFO - Using _rmtree_windows ... 01:12:39 INFO - Current package versions: 01:12:39 INFO - blessings == 1.5.1 01:12:39 INFO - blobuploader == 1.2.4 01:12:39 INFO - docopt == 0.6.1 01:12:39 INFO - manifestparser == 1.1 01:12:39 INFO - mozInstall == 1.12 01:12:39 INFO - mozcrash == 0.16 01:12:39 INFO - mozdebug == 0.1 01:12:39 INFO - mozdevice == 0.46 01:12:39 INFO - mozfile == 1.2 01:12:39 INFO - mozhttpd == 0.7 01:12:39 INFO - mozinfo == 0.8 01:12:39 INFO - mozleak == 0.1 01:12:39 INFO - mozlog == 3.0 01:12:39 INFO - moznetwork == 0.27 01:12:39 INFO - mozprocess == 0.22 01:12:39 INFO - mozprofile == 0.27 01:12:39 INFO - mozrunner == 6.11 01:12:39 INFO - mozscreenshot == 0.1 01:12:39 INFO - mozsystemmonitor == 0.0 01:12:39 INFO - moztest == 0.7 01:12:39 INFO - mozversion == 1.4 01:12:39 INFO - psutil == 3.1.1 01:12:39 INFO - requests == 1.2.3 01:12:39 INFO - Installing None into virtualenv C:\slave\test-pgo\build/venv 01:12: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')]} 01:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:12: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')]} 01:12:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:12:39 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 0x019B8B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01978EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x013CE8C8>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012E8B48>, '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 0x0130A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01A39660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test-pgo\\build\\tests\\talos', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-129', 'USERDOMAIN': 'T-W732-IX-129', '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-129', '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 01:12:39 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 01:12:39 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 01:12:39 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 01:12:39 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 01:12:39 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 01:12:39 INFO - 'COMPUTERNAME': 'T-W732-IX-129', 01:12:39 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 01:12:39 INFO - 'CYGWINBASE': 'C:\\cygwin', 01:12:39 INFO - 'DCLOCATION': 'SCL3', 01:12:39 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 01:12:39 INFO - 'FP_NO_HOST_CHECK': 'NO', 01:12:39 INFO - 'HOMEDRIVE': 'C:', 01:12:39 INFO - 'HOMEPATH': '\\Users\\cltbld', 01:12:39 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 01:12:39 INFO - 'KTS_VERSION': '1.19c', 01:12:39 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 01:12:39 INFO - 'LOGONSERVER': '\\\\T-W732-IX-129', 01:12:39 INFO - 'MONDIR': 'C:\\Monitor_config\\', 01:12:39 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 01:12:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:12:39 INFO - 'MOZ_NO_REMOTE': '1', 01:12:39 INFO - 'NO_EM_RESTART': '1', 01:12:39 INFO - 'NUMBER_OF_PROCESSORS': '8', 01:12:39 INFO - 'OS': 'Windows_NT', 01:12:39 INFO - 'OURDRIVE': 'C:', 01:12:39 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;', 01:12:39 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 01:12:39 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 01:12:39 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 01:12:39 INFO - 'PROCESSOR_LEVEL': '6', 01:12:39 INFO - 'PROCESSOR_REVISION': '1e05', 01:12:39 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 01:12:39 INFO - 'PROGRAMFILES': 'C:\\Program Files', 01:12:39 INFO - 'PROMPT': '$P$G', 01:12:39 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 01:12:39 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 01:12:39 INFO - 'PUBLIC': 'C:\\Users\\Public', 01:12:39 INFO - 'PWD': 'C:\\slave\\test-pgo', 01:12:39 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 01:12:39 INFO - 'SLAVEDIR': 'C:\\slave\\', 01:12:39 INFO - 'SYSTEMDRIVE': 'C:', 01:12:39 INFO - 'SYSTEMROOT': 'C:\\windows', 01:12:39 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 01:12:39 INFO - 'TEST1': 'testie', 01:12:39 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 01:12:39 INFO - 'USERDOMAIN': 'T-W732-IX-129', 01:12:39 INFO - 'USERNAME': 'cltbld', 01:12:39 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 01:12:39 INFO - 'WINDIR': 'C:\\windows', 01:12:39 INFO - 'WINDOWS_TRACING_FLAGS': '3', 01:12:39 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 01:12:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 01:12:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:12:40 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)) 01:12:40 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)) 01:12:40 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)) 01:12:40 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)) 01:12:40 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)) 01:12:40 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)) 01:12:40 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)) 01:12:40 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)) 01:12:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in c:\slave\test-pgo\build\venv\lib\site-packages (from mozcrash>=0.15->-r C:\slave\test-pgo\build\tests\talos\requirements.txt (line 1)) 01:12:40 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)) 01:12:40 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)) 01:12:40 INFO - Cleaning up... 01:12:40 INFO - Return code: 0 01:12:40 INFO - Running post-action listener: _resource_record_post_action 01:12:40 INFO - Running post-action listener: _start_resource_monitoring 01:12:40 INFO - Starting resource monitoring. 01:12:40 INFO - ##### 01:12:40 INFO - ##### Running install step. 01:12:40 INFO - ##### 01:12:40 INFO - Running pre-action listener: _resource_record_pre_action 01:12:40 INFO - Running main action method: install 01:12:40 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\pip', 'freeze'] 01:12:40 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\pip freeze 01:12:40 INFO - Reading from file tmpfile_stdout 01:12:40 INFO - Using _rmtree_windows ... 01:12:40 INFO - Using _rmtree_windows ... 01:12:40 INFO - Detecting whether we're running mozinstall >=1.0... 01:12:40 INFO - Getting output from command: ['C:\\slave\\test-pgo\\build/venv/scripts/python', 'C:\\slave\\test-pgo\\build/venv/scripts/mozinstall-script.py', '-h'] 01:12:40 INFO - Copy/paste: C:\slave\test-pgo\build/venv/scripts/python C:\slave\test-pgo\build/venv/scripts/mozinstall-script.py -h 01:12:40 INFO - Reading from file tmpfile_stdout 01:12:40 INFO - Output received: 01:12:40 INFO - Usage: mozinstall-script.py [options] installer 01:12:40 INFO - Options: 01:12:40 INFO - -h, --help show this help message and exit 01:12:40 INFO - -d DEST, --destination=DEST 01:12:40 INFO - Directory to install application into. [default: 01:12:40 INFO - "C:\slave\test-pgo"] 01:12:40 INFO - --app=APP Application being installed. [default: firefox] 01:12:40 INFO - Using _rmtree_windows ... 01:12:40 INFO - Using _rmtree_windows ... 01:12:40 INFO - mkdir: C:\slave\test-pgo\build\application 01:12:40 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'] 01:12:40 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 01:12:43 INFO - Reading from file tmpfile_stdout 01:12:43 INFO - Output received: 01:12:43 INFO - C:\slave\test-pgo\build\application\firefox\firefox.exe 01:12:43 INFO - Using _rmtree_windows ... 01:12:43 INFO - Using _rmtree_windows ... 01:12:43 INFO - Running post-action listener: _resource_record_post_action 01:12:43 INFO - ##### 01:12:43 INFO - ##### Running run-tests step. 01:12:43 INFO - ##### 01:12:43 INFO - Running pre-action listener: _resource_record_pre_action 01:12:43 INFO - Running main action method: run_tests 01:12:43 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\python', '--version'] 01:12:43 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\python --version 01:12:43 INFO - Python 2.7.3 01:12:43 INFO - Return code: 0 01:12:43 INFO - grabbing minidump binary from tooltool 01:12: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')]} 01:12:43 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 0x012E8B48>, '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 0x0130A700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01A39660>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test-pgo\\build', 'privileged': False}, attempt #1 01:12:43 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 01:12:43 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 01:12:43 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 01:12:43 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test-pgo\build\tmpnnivao 01:12:43 INFO - INFO - File integrity verified, renaming tmpnnivao to win32-minidump_stackwalk.exe 01:12:43 INFO - Return code: 0 01:12:43 INFO - Chmoding C:\slave\test-pgo\build\win32-minidump_stackwalk.exe to 0755 01:12:43 INFO - mkdir: C:\slave\test-pgo\build\blobber_upload_dir 01:12:43 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test-pgo\build\blobber_upload_dir 01:12:43 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test-pgo\build\win32-minidump_stackwalk.exe 01:12:43 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test-pgo\build\blobber_upload_dir 01:12:43 INFO - Running command: ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\python', 'C:\\slave\\test-pgo\\build\\tests\\talos\\talos\\run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test-pgo\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/jjttMSC1SH2qP1pz_Ue9jA/artifacts/public/build/firefox-44.0a1.en-US.win32.crashreporter-symbols.zip', '--title', 'T-W732-IX-129', '--webServer', 'localhost'] in C:\slave\test-pgo\build 01:12:43 INFO - Copy/paste: C:\slave\test-pgo\build\venv\Scripts\python C:\slave\test-pgo\build\tests\talos\talos\run_tests.py --debug --branchName B2G-Inbound --suite dromaeojs --executablePath C:\slave\test-pgo\build\application\firefox\firefox --symbolsPath https://queue.taskcluster.net/v1/task/jjttMSC1SH2qP1pz_Ue9jA/artifacts/public/build/firefox-44.0a1.en-US.win32.crashreporter-symbols.zip --title T-W732-IX-129 --webServer localhost 01:12:43 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 01:12:43 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 01:12:43 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 01:12:43 INFO - 'COMPUTERNAME': 'T-W732-IX-129', 01:12:43 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 01:12:43 INFO - 'CYGWINBASE': 'C:\\cygwin', 01:12:43 INFO - 'DCLOCATION': 'SCL3', 01:12:43 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 01:12:43 INFO - 'FP_NO_HOST_CHECK': 'NO', 01:12:43 INFO - 'HOMEDRIVE': 'C:', 01:12:43 INFO - 'HOMEPATH': '\\Users\\cltbld', 01:12:43 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 01:12:43 INFO - 'KTS_VERSION': '1.19c', 01:12:43 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 01:12:43 INFO - 'LOGONSERVER': '\\\\T-W732-IX-129', 01:12:43 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test-pgo\\build\\blobber_upload_dir', 01:12:43 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test-pgo\\build\\win32-minidump_stackwalk.exe', 01:12:43 INFO - 'MONDIR': 'C:\\Monitor_config\\', 01:12:43 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 01:12:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:12:43 INFO - 'MOZ_NO_REMOTE': '1', 01:12:43 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test-pgo\\build\\blobber_upload_dir', 01:12:43 INFO - 'NO_EM_RESTART': '1', 01:12:43 INFO - 'NUMBER_OF_PROCESSORS': '8', 01:12:43 INFO - 'OS': 'Windows_NT', 01:12:43 INFO - 'OURDRIVE': 'C:', 01:12: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;', 01:12:43 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 01:12:43 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 01:12:43 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 01:12:43 INFO - 'PROCESSOR_LEVEL': '6', 01:12:43 INFO - 'PROCESSOR_REVISION': '1e05', 01:12:43 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 01:12:43 INFO - 'PROGRAMFILES': 'C:\\Program Files', 01:12:44 INFO - 'PROMPT': '$P$G', 01:12:44 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test-pgo/buildprops.json', 01:12:44 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 01:12:44 INFO - 'PUBLIC': 'C:\\Users\\Public', 01:12:44 INFO - 'PWD': 'C:\\slave\\test-pgo', 01:12:44 INFO - 'PYTHONPATH': 'C:\\slave\\test-pgo\\build\\tests\\talos', 01:12:44 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 01:12:44 INFO - 'SLAVEDIR': 'C:\\slave\\', 01:12:44 INFO - 'SYSTEMDRIVE': 'C:', 01:12:44 INFO - 'SYSTEMROOT': 'C:\\windows', 01:12:44 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 01:12:44 INFO - 'TEST1': 'testie', 01:12:44 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 01:12:44 INFO - 'USERDOMAIN': 'T-W732-IX-129', 01:12:44 INFO - 'USERNAME': 'cltbld', 01:12:44 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 01:12:44 INFO - 'WINDIR': 'C:\\windows', 01:12:44 INFO - 'WINDOWS_TRACING_FLAGS': '3', 01:12:44 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 01:12:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 01:12:44 INFO - Calling ['C:\\slave\\test-pgo\\build\\venv\\Scripts\\python', 'C:\\slave\\test-pgo\\build\\tests\\talos\\talos\\run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test-pgo\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/jjttMSC1SH2qP1pz_Ue9jA/artifacts/public/build/firefox-44.0a1.en-US.win32.crashreporter-symbols.zip', '--title', 'T-W732-IX-129', '--webServer', 'localhost'] with output_timeout 3600 01:12:44 INFO - mozversion INFO | application_buildid: 20151023203110 01:12:44 INFO - mozversion INFO | application_changeset: 19211c12647724e21cf63efc01817d28d5ebae52 01:12:44 INFO - mozversion INFO | application_display_name: Nightly 01:12:44 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:12:44 INFO - mozversion INFO | application_name: Firefox 01:12:44 INFO - mozversion INFO | application_remotingname: firefox 01:12:44 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 01:12:44 INFO - mozversion INFO | application_vendor: Mozilla 01:12:44 INFO - mozversion INFO | application_version: 44.0a1 01:12:44 INFO - mozversion INFO | platform_buildid: 20151023203110 01:12:44 INFO - mozversion INFO | platform_changeset: 19211c12647724e21cf63efc01817d28d5ebae52 01:12:44 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 01:12:44 INFO - mozversion INFO | platform_version: 44.0a1 01:12:44 INFO - 2015-10-24 01:12:44,957 DEBUG : using testdate: 1445674364 01:12:44 INFO - 2015-10-24 01:12:44,957 DEBUG : actual date: 1445674364 01:12:45 INFO - 2015-10-24 01:12:45,073 INFO : starting webserver on 'localhost:49896' 01:12:45 INFO - 2015-10-24 01:12:45,075 INFO : Starting test suite T-W732-IX-129 01:12:45 INFO - 2015-10-24 01:12:45,075 INFO : Starting test dromaeo_css 01:12:45 INFO - 2015-10-24 01:12:45,075 DEBUG : operating with platform_type : w7_ 01:12:45 INFO - 2015-10-24 01:12:45,076 INFO : Initialising browser for dromaeo_css test... 01:12:45 INFO - 2015-10-24 01:12:45,164 DEBUG : command line: C:\slave\test-pgo\build\application\firefox\firefox -profile c:\users\cltbld\appdata\local\temp\tmpomk3d5\profile http://localhost:49896/getInfo.html 01:12:52 INFO - 2015-10-24 01:12:52,924 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:12:52 INFO - 2015-10-24 01:12:52,924 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:12:52 INFO - 2015-10-24 01:12:52,924 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674 01:12:52 INFO - 2015-10-24 01:12:52,924 DEBUG : BROWSER_OUTPUT: __metrics 01:12:53 INFO - 2015-10-24 01:12:52,999 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:12:54 INFO - 2015-10-24 01:12:54,803 INFO : Browser initialized. 01:12:54 INFO - 2015-10-24 01:12:54,803 INFO : Running cycle 1/1 for dromaeo_css test... 01:12:54 INFO - 2015-10-24 01:12:54,803 DEBUG : command line: C:\slave\test-pgo\build\application\firefox\firefox -profile c:\users\cltbld\appdata\local\temp\tmpomk3d5\profile -tp file:\C:\slave\test-pgo\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:13:06 INFO - 2015-10-24 01:13:06,226 DEBUG : BROWSER_OUTPUT: RSS: Main: 130084864 01:13:06 INFO - 2015-10-24 01:13:06,226 DEBUG : BROWSER_OUTPUT: 01:13:57 INFO - 2015-10-24 01:13:57,921 DEBUG : BROWSER_OUTPUT: 1445674437916 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 01:16:06 INFO - 2015-10-24 01:16:06,709 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49896/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49896/tests/dromaeo/cssquery-ext.html) 01:16:07 INFO - 2015-10-24 01:16:07,783 DEBUG : BROWSER_OUTPUT: RSS: Main: 164896768 01:16:07 INFO - 2015-10-24 01:16:07,783 DEBUG : BROWSER_OUTPUT: 01:19:10 INFO - 2015-10-24 01:19:10,190 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49896/tests/dromaeo/cssquery-ext.html (next: http://localhost:49896/tests/dromaeo/cssquery-jquery.html) 01:19:10 INFO - 2015-10-24 01:19:10,746 DEBUG : BROWSER_OUTPUT: RSS: Main: 194621440 01:19:10 INFO - 2015-10-24 01:19:10,746 DEBUG : BROWSER_OUTPUT: 01:22:12 INFO - 2015-10-24 01:22:12,661 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49896/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49896/tests/dromaeo/cssquery-mootools.html) 01:22:13 INFO - 2015-10-24 01:22:13,224 DEBUG : BROWSER_OUTPUT: RSS: Main: 150765568 01:22:13 INFO - 2015-10-24 01:22:13,224 DEBUG : BROWSER_OUTPUT: 01:25:15 INFO - 2015-10-24 01:25:15,223 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49896/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49896/tests/dromaeo/cssquery-prototype.html) 01:25:15 INFO - 2015-10-24 01:25:15,799 DEBUG : BROWSER_OUTPUT: RSS: Main: 137785344 01:25:15 INFO - 2015-10-24 01:25:15,799 DEBUG : BROWSER_OUTPUT: 01:28:18 INFO - 2015-10-24 01:28:18,421 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49896/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49896/tests/dromaeo/cssquery-yui.html) 01:28:19 INFO - 2015-10-24 01:28:19,016 DEBUG : BROWSER_OUTPUT: RSS: Main: 134029312 01:28:19 INFO - 2015-10-24 01:28:19,016 DEBUG : BROWSER_OUTPUT: 01:31:21 INFO - 2015-10-24 01:31:21,394 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49896/tests/dromaeo/cssquery-yui.html (next: http://localhost:49896/tests/dromaeo/cssquery-dojo.html) 01:31:21 INFO - 2015-10-24 01:31:21,648 DEBUG : BROWSER_OUTPUT: RSS: Main: 184479744 01:31:21 INFO - 2015-10-24 01:31:21,648 DEBUG : BROWSER_OUTPUT: 01:31:21 INFO - 2015-10-24 01:31:21,648 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:31:21 INFO - 2015-10-24 01:31:21,648 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:31:21 INFO - 2015-10-24 01:31:21,648 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:31:21 INFO - 2015-10-24 01:31:21,648 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:31:21 INFO - 2015-10-24 01:31:21,648 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2728.8908443662253;2781.527140386135;2814.8733307001185;2816.6479190101236;2819.7180281971805;5283.894322113555;5301.6818990860575;5338.06583847827;5347.171188465789;5388.7305634718305;5303.761330740116;5318;5403.83788486345;5418.783248670048;5426.484483974026;4464.799084041209;4565.1098035883015;4575.1078539684695;4660.697054691451;4665.510121437234;4557.453105627329;4584.404027476424;4587.931181032271;4610.5850473457385;4626.861194164164;4593.104344652794;4596.218642830727;4614.192516309649;4614.56161664643;4616.584507394334;4324.459442569679;4509.932351014738;4532.546745325474;4583.541645835407;4608.308753686957;4510.887227819298;4553.362529245908;4555.612772914306;4564.5435456454425;4606.378138951266;5177.715225662587;5214.296070030536;5231.529162375405;5297.364316282033;5327.30745003151;5510.256115424447;5552.222688823568;5580.079286917654;5636.915446268309;5647.068233741427;5357.383900851413;5388.110961691355;5553.111502159675;5572.136318870541;5708.828735137952;4873.463918968911;4945.653804233705;5081.18701007837;5178.145605974972;5279.155335146396;5480.3971563128025;5691.658500489983;5700.458456446631;5792.4497172768515;5803.767849285981;4975.726335051534;5027.497250274943;5057.898842023139;5221.947780522146;5385.3268341457315;5254.632175747737;5289.867753306121;5330.413654498002;5334.093204155303;5336.226247194213;5204.297419848348;5247.003069416799;5297.735113244323;5306.336707911511;5533.446655334515;5305;5466.863328416822;5526;5563.972180139154;5573.41479144692;3265.297960938362;3317.7179939705397;3318.634950155481;3330.900072997814;3367.9494807577908;3003.8347890865775;3032.9393412132076;3054.9083527494213;3146.9685303147135;3216.292415668549;4915.58217551505;5038.244263360525;5126.564242039394;5166.483351664803;5230.686158830406;5314.3091398117995;5318.734063296897;5402.270693456412;5405.972970135124;5424.566034717213;5034.924476132861;5115.897682046339;5122.769475373617;5127.589792816566;5171.198464238049;4328.588784065571;4399.406080179199;4416.138852923649;4468.262736648481;4493.415855938772;5542.2795036644975;5562.054450743302;5688.203651488878;5713.885722285531;5993.130996005555;5285.550728188147;5289.7355132244;5422.430644782241;5428.83713488596;5474.644148130359;5454.672719636835;5533.446655334435;5712.857178570569;5790.218320526675;5891.882162356643;5143.691378517301;5260.368755749335;5269.631125821309;5272.894542109213;5323.787048518171;5264.842054738364;5278.5249327560705;5417.431169727122;5421;5432.456754324536;5019.247112933089;5062.974685126551;5228.947710522846;5473.233747275305;5497.47773961473;5012.022655582126;5182.9374978128635;5235.874287028307;5266.97366513165;5273.868153296198;5040.294358789845;5071.644984851025;5104;5150.587952963829;5158.484151584811;5071.797128114982;5149.304843846183;5244.947550524446;5538.280023596906;5544.833654990357;5100.566451851634;5188.896222075462;5212.166053431432;5381.19282107687;5481.588880833874 01:31:21 INFO - 2015-10-24 01:31:21,648 DEBUG : BROWSER_OUTPUT: |1;ext.html;477.172106395404;491.19689307981463;493.66924160812255;497.94024717033955;502.5552386138271;28528;35414.2917141657;36051.81974090132;36100.63899361012;36956.260874782485;37768.81115594418;38207.42688859662;38536.61463385366;39293.8035309823;39558.802205989;7364.852702945938;7370.778876633683;8053.999999999985;8083;8233;9747.658831940884;9997.850032249522;10001.74978127734;10057.295989280754;10223.948880255588;9461.195798357148;9569.3779904306;9666.90333096667;9981.201503879709;10114.44370559619;7582.545047297124;7781.727639532617;9618;9660.613575456973;9948.452835094067;9369.859452108223;9404;9439.433633981984;9831.410115393099;9996.250281228937;34681.78613748532;34741.82629086838;34779.6522034779;35517.82241088778;36690.44964325537;3088.7065728755733;3115.6572776994512;3159.4470967580583;3171.0645359618966;3217.078020121674;28463;28823.84704611813;28924.566131508043;28950.131496055154;29142.708572914213;2595.8572278524675;2626.500964816698;2643.7488438598302;2656.9468610627873;2678.973210267892;283524;291497;292852;302887;303246;42186;43657.76106867196;48343.5165648339;48587.271190932166;49064.7546762271;52285.47714522806;54188.72905635447;55429.722851386294;55659.72170139123;55908.720456398274;13469;13741.862581374058;14121.364538595788;14272.286385680674;14309.069910455786;10155.64455244063;10586.153107751361;10604.151667866552;10613.57545698179;10613.893861061291;16328.75506867398;16966.8971516851;16994.150292485327;17031.318747250218;17049.914750426167;7499.250074992567;7572.924270757332;7575.886361704579;7732.7680169595005;7754.3796496280165;863.87905693203;915.5651065743851;976.0971101731012;990.1583653894132;994.7612572982432;26052.869735651202;26234;26560.335991600365;26776.19671409861;26805;959.5058544849409;988.7478692933399;992.6079198716467;1046.56567524478;1066.9383962956908;13678.195969826162;14721.337539810735;14736.852631473763;14810.703785924221;15526.767098493532;341748;348282;348528;373019;375085;44943.011397720584;44983.875403115184;46805.29792053122;47118;47327.76336118297;1130.5929865248504;1165.6036947437913;1179.9705007374712;1191.106669997502;1209.1717173735842;21412;27776;27802.44395112127;29572.556411654274;29833.25416864596;42902.35646465243;42903.35644965265;43298.78350608227;45062.77468612636;45657.771711141235;264995;268878;268937;269855;271482;33359.49960750542;40008.3998740025;40671.1865762689;41852.37221441742;41870.95322616959;40826.59173408228;42262;42313.78843105765;44080.7795961031;44093.33859992167;34029.31941361209;35778.463323049655;36140.63859361373;36568;37278.06804829901;36385.9987700679;36865;37470;37942;38896;35307;35444.82277588596;35642.46536302009;36360;37658.62341376661;31639;31867.521987170676;32809.33696548583;33238;33681.15797105092;23617.922146738532;23698.52602947897;24097.51804963926;24310.878445607657;25575.872120639277 01:31:21 INFO - 2015-10-24 01:31:21,653 DEBUG : BROWSER_OUTPUT: |2;jquery.html;311.80667985848777;324.8651809499058;331.615326221583;334.72552506944317;335.1771401210029;11755.52977880886;11911.166218364719;16062.59843503913;16622.83377166228;17149.82850171498;10327.915568865274;11188.832167517494;16205.189740512986;16300.184990750475;16862.747058794128;4101.651359634435;4139.1100913303635;4189.245935731575;4316.870493885189;4343.174796788616;4073.877783666495;4121.587841215869;4193.81127849246;4208.705390622657;4255.702100852942;3615.975053969772;3657.9268414631824;4218.2196293685765;4291.914161716763;4299.742015479065;4492.550744925514;4641.535846415365;4668.253079507296;4673.948361618643;4741.2651039089;3871.6515513603913;3900.2394533066063;3990.2618015666903;3998.7200895937294;4003.619656132663;12333.383330833512;12605.747885042249;12612.81080783789;12769.170003949714;12965.35173241334;2045.7442819647545;2060.7733149353558;2079.4073688998715;2094.2460714142894;2186.8031877130975;9720.75698107546;9758.365706229073;9824.803503929881;10046.849297260547;10062.849057264148;1568.9058656480647;1594.2825728422256;1630.7227771278792;1676.9329226830912;1697.0496521947625;74346.25653743447;74502;75723;76052;76598.6170069146;6097.969510152509;6218.409251121137;6278;6317.210348706411;6339.207599050119;6901.585904845725;7003.124609423822;7265.636718164176;7303.598302093435;7327.780166595011;5297.443768404262;5316.787328506894;5327.280817089643;5368.892622147535;5369.973150134302;5604.187392828017;5693.886122277531;5727.8854422912145;5804.245448091806;5844.386339434298;2665.360313524779;2675.3579141006408;2789.693133755285;2821.0972488803386;2847.957280640792;966.7776411425411;983.4246965525105;1025.6922923123034;1033.266380869576;1078.6278733836814;402.96977726670616;405.30490209290616;409.5106347914273;457.7413761224897;467.92279273920104;10059.597616095274;10788.117551085297;10923.890761092447;11603.129765267639;11636.12729045325;443.2155085498649;460.6890349014402;471.74997251456784;475.2040332443144;478.1321900750127;6123.203983482119;6280.780172694025;6486.254080780676;6500.577462464925;6553.115329430561;130554.34722826515;130837;311969;411670;420100;79333;80219.19780802233;84099;87974.56012720024;90648;460.80185520225956;479.89922116355257;482.0647942990657;489.7061762942206;490.1006652792166;10817.770133569275;11228.382438965935;11324.37715925632;11383.54465821358;11388.772224555296;43178.13643727171;43195.56804432041;43759.343609845244;44024.339634906144;44333.359993601945;56279;58659.8154572084;58849.70575147097;60002.699986499785;60862;5823.592348535732;6168.629882207082;6194.690265486798;6198.659073750987;6202.34875338083;11571.884281157081;12630;12634.557790477289;12688.492460301484;12731.108822382344;10574.947125264325;10801.243912926335;10840;10850.457477125954;10860.728481788019;10312.845307320546;10427.739306517398;10491.68524944253;10557.366558006544;10609;10771.461426928465;10898.94550527274;10972;11064.778704426028;11066.723331916766;6151.9384806151365;6296.5277604178955;6303.936960630335;6309.968450157719;6318.747250109944;10579.4710264488;10617.840732389175;10828;10915.508802103766;10930.836037459285 01:31:21 INFO - 2015-10-24 01:31:21,654 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1131.734042500013;1283.6020833541602;1294.9352532373384;1414.9458653303288;1546.3273476037916;7473.738419155331;8048.758537243877;8204.548749818758;8626.22363987241;8651.091635378289;8571.785705357353;8575.356848236375;8645.703144528325;8728.214460698537;8733.781655458617;2021.5956808638257;2024.473636854421;2129.2547608337036;2219.411855858199;2233.36349140495;2114.45024293684;2116.523782149012;2117.830573554112;2247.179779380531;2256.7630398808137;2228.665700144975;2297.9195728149516;2302.9193978210765;2303.1478353009325;2304.2050492580033;1997.4407165993546;2012.9194832206695;2240.764719704424;2250.6624006399006;2266.4220623741007;2264.4904896398343;2266.5693518231647;2285.565742508918;2299.034405549673;2312.826538009656;8848.911510884873;8887.422317549403;8921.509316987564;8941.59762810675;8947.105289471066;4935.531124543163;4984.87537811554;4989.600831933437;4990.4011518617635;5000.649954503187;3296.8021918684954;3417.3507033663773;3444.121748954026;3455.3953058214965;3522.7357948153735;1064;1067;1099.9990009091769;1105.9170562207787;1113.821788513842;12885.162464439874;13150.868491315156;13171.341432928411;13194.934025329909;13200.47198112084;4359.149965756647;4366.126774645084;4418.9337159942625;4464.955350446519;4482.686211965131;10649.414282214553;10696.78606427867;10698.946505267579;10713;10730.89269107299;4881.633877459205;5027.120253955543;5030.547250747377;5031.471695471996;5035.320231768737;4421.9336709949375;4489.685721999429;4586.380838586815;4588.334691469719;4593.448786145684;3627.5284213052664;3685.262947410529;3692.8338224779413;3715.7398982070995;3722.571904231048;1104.1222228328497;1141.155544896787;1143.1483544759208;1144.5135817277624;1153.0717772193466;803.6745118227127;1102.5204036244259;1143.8856114388495;1174.6241202815017;1176.864660564029;7031.542949708252;7724.806879828049;7844.9607751960875;7850.646720897574;7864.095629002738;595.6128516464246;626.501930964884;631.9715612797435;644.3524258120652;645.7804346522205;5491.368492623399;5567.7750894803075;5577.163425486209;5836.212111364912;5940.376260492672;10654.893451065545;10726.249162558546;10729.89270107289;10796;11435.199536032564;11309.377984210783;11340.829887551694;11341;11349.773004539862;11356.829647555292;7600.657970391346;7881.684732610746;7978.6409611567615;8070.83858322842;8127.837443251102;7674.347680447225;7699.961500192463;7701;7703.648912722983;7713.344365728976;9243.630254789734;9367.578458969227;9547.947191353893;9678.77388200732;9723.270754693567;9539.427634341962;9802.950985245028;9945.502724863873;10145;10183.13443357323;7879.448438609243;7933.761987140395;7963.6814527418255;7964.84070318602;7968.641411136628;8619.138086191331;8648.956755216184;8679.045305016316;8691.348148888732;8697.521636310064;7764.495307804975;7942.08666003417;8197.508149511048;8232.053313868983;8246.876296855671;6837.418819400406;6936.358956080891;7239.601821899846;7499.962500187464;7559.433042521943;7489.325960663567;7493.250674932463;7495.925040749741;7507.099148102045;7522.134954480305;6704.530682852153;6962.512624116263;6981.685824137824;6989.930100698928;6996.335348141918;6245;6539.411452969255;6679.76620818269;6942.166939967236;6986.196587392515 01:31:21 INFO - 2015-10-24 01:31:21,742 DEBUG : BROWSER_OUTPUT: |4;prototype.html;322.0531636987259;324.3820521905769;326.9836508174591;331.4266319267667;333.4781067629162;5367.570594352453;5535.501804837564;5599.272094627693;5606.131049687295;5943.435373639502;5426.701531415771;5485.533729632976;5544.085225937715;5557.805476808313;5722.79970201043;4072.9389059164137;4077.408775727518;4089.897752556195;4342.761148136851;4351.0862718829085;4192.601702838226;4345.348197770344;4347.41309923161;4349.347597860315;4354.238008348542;3982.980085099585;4046.150308435232;4047.8785636430953;4057.0060335217763;4122.732022418548;4043.2317859606583;4048.453458783071;4163.354680024601;4303.182395344875;4317.15815415994;3798.126430920876;3798.2783271178387;3798.8290526926353;3801.8099095045136;3804.619538046201;5370.731463426813;5386.2997810284805;5395.379531353905;5428.945710542884;5711.371749107595;4835.5889749371345;4845.515448455161;4850.835799408152;5000.724960127228;5151.845444636667;5955.910661340084;5961.165436838846;5970.104484327342;6180.783672571483;6217.502599792006;4069.125138095294;4069.47096877407;4073;4232.76719780412;4241.681873859442;6185.288691800455;6459;6472.90290645636;6484.740610375579;6485.254195767453;4178.143480586473;4245.97877010613;4402.977985110118;4432.578905004019;4455.844045458393;4248.532661407243;4305.91388172241;4527.547245275512;4528.184926713223;4531.977340113278;4883.682560633548;4897.1185186666025;4967.180415231519;5194.92207616886;5200.843974680765;5841;5875.441833025856;6062.363451837582;6251.031090181029;6253.781117660951;1614.1041721844254;1632.6653036127566;1633.4691225351808;1633.7059329320598;1635.8445947634955;1076.1229597877705;1091.5415525479318;1101.146611376174;1103.8454616353717;1105.8672959244782;5967.940320596826;6020.187274717857;6022.066579680157;6046.244219472566;6052.969735151296;6056;6409.615423074631;6429.228492580826;6433.453156481752;6434.227892652818;5703.7433315500075;6037.45662890342;6044.33512313654;6045.879082418415;6056.273247210275;3150.354177393629;3233.514972754059;3368.2758206985613;3506.8246587670515;3547.184147646056;6459.289478157399;6729.899051514231;6742.292059333699;6757.797266082025;6760.391564759196;6478.578892371981;6487.54587178893;6489;6493.935060649427;6494.058361537551;6076.218634582986;6506.512011599149;6715.3620406061345;6747.325267473311;6748.29142939994;5970.791022314198;6070.605410648293;6177.073438984188;6187.381261873777;6190.597611155261;5758.942410575841;5968.940310597012;6016.308124565556;6322.525810564318;6323.747050117944;6817.931820681928;6835.213950395768;6839.2476827547935;6839.93160068393;6849.1780986281965;4205.222033923734;4258.276093064124;4409.867703968886;4470.1953648342305;4487.7307361557105;6283.842903927439;6464.191976003;6468.062130991074;6473.805785826433;6484.383983521558;6294.118823364641;6317.557770956173;6323.177986861679;6326.873462530815;6330.272018717722;5900.557458190567;5908.172855800105;5980.132880732356;6076.969615151896;6164.938350616616;5584.553235741212;5837.5329973601165;5901.203337549376;5920.585559011;5987.2815262168815;5896.262967129109;5927.585069045125;5946.226990491208;5978.133170690313;6148.600340977822;5820.097884827858;5821.970890145522;5874.295084589877;5923.111533270044;5971.462568368867 01:31:21 INFO - 2015-10-24 01:31:21,744 DEBUG : BROWSER_OUTPUT: |5;yui.html;692.1970514203525;693.4729605499818;696.5407471347526;709.4253654539823;721.678852910455;11868;12270.141090123694;12392.504299828008;12472;12674.98600111991;9627.229821614272;10709.303895246803;11446;11467;11865.7626847463;576.2710171632888;587.1017343464506;593.4125216036115;614.281290889658;615.8460384903774;602.1359349333699;603.0803025386277;605.2736715940889;609.9237595300588;615.3938370704852;607.6840043177546;618.4372221278637;619.8915189841782;622.6824319597016;623.4980840423457;600.4835841176584;624.3537938233951;628.0861346740481;629.6851574212893;630.6184758221302;420.4030277006658;436.9410129632491;445.4454204515367;448.9349044388578;456.5138127893782;10428.27002109845;10724.571017159304;10725.83911241332;10921.962413570778;11012.614558490495;9077.818443631157;9762.511874406251;10042.297039207258;10058.748531286703;10296.691099267035;7766.37868970481;8569.657213711507;8623.922009748781;8862.335324850597;8953.791238182892;3400.6429324920773;3414.829258537063;3460.2041530447887;3491.825408729553;3515.6484351564895;34782.30435391278;38767.61232387668;39540.60459395427;44024.779876100416;44566.874809396686;6754.729810807513;6987.17342504885;7040.718371265092;7585.886211706828;8910.688125915562;10200.928902465283;10504.527296271533;10824.13406927444;11296.774064518828;11309.943450282695;5847.795327163529;6070.3019152798;6293.527985401113;6324.33594472583;6334.493240540745;4016.658584020391;4120.690948178839;4126.525449573277;4168.916621667549;4238.427812245369;2465.4452748131885;2466.8273220874366;2467.1858286765323;2511.7613826686434;2577.2397142842906;446.69624655234105;449.341714388416;451.2644389644858;452.46609001378033;453.7232288304132;588.5556404914263;612.8988716861668;624.2633692243106;656.5929123943185;667.2993356975156;8376.371772117116;8749.912500875038;8966.148215919477;8986.05646407131;9010.189082982562;562.5274769193896;667.2460120064393;682.6825526130274;688.3598253624077;704.2778913442534;3932.311845427096;4193.370994350872;4234.428352172479;4288.549702281278;4511.88720281989;55067.72466137644;55516.16725749117;55877.72061139668;56026.71986640041;59746.70126649426;44884.55115448869;46969;47005;47107.29339059917;48254.517454825;35836.46245306323;36374.27251455009;38868.416973745414;39785;40705;8561.606188101456;8696.347773917108;8701.608427620646;8743.781405464913;9052.321075919464;27856.582151267343;28085.43829123447;28118.71881281161;28366.716332837233;29991.85004075053;36702.44946325754;36977;38964.22071558496;40934;41174.58825411707;11392.886071139514;11782.469788859351;12075.758484830078;12105.75788484243;12126.393680316125;13420.93289533585;13439.596812095653;13693.178409295475;13696.93151534236;13830.65423364424;12124.665716927915;12242.326672032767;12353.814692779435;12944.158629689417;13066.54267100647;11336.263142895685;11430.542778288775;11438.656840294805;11659.941700291443;11836;11575.594854180063;12006.819897701716;12185.939070304592;12449.37753112359;12578.874211258137;9978.501074946078;9997.900020999989;10016.966067864272;10091.344062635904;10790.608339232274;9251;9614.664609947124;10028.197744180303;10176.542055607368;10573.312734672221 01:31:21 INFO - 2015-10-24 01:31:21,744 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:31:21 INFO - 2015-10-24 01:31:21,744 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:31:21 INFO - 2015-10-24 01:31:21,744 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,817 01:31:21 INFO - 2015-10-24 01:31:21,744 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:31:21 INFO - 2015-10-24 01:31:21,744 DEBUG : BROWSER_OUTPUT: __startTimestamp1445675481641__endTimestamp 01:31:21 INFO - 2015-10-24 01:31:21,744 DEBUG : BROWSER_OUTPUT: 01:31:21 INFO - 2015-10-24 01:31:21,744 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:31:21 INFO - 2015-10-24 01:31:21,744 DEBUG : BROWSER_OUTPUT: Number of tests: 6 01:31:21 INFO - 2015-10-24 01:31:21,744 DEBUG : BROWSER_OUTPUT: 01:31:21 INFO - 2015-10-24 01:31:21,744 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4989.28 Median:5231.53 stddev:709.68 (13.6%) stddev-sans-first:689.35 01:31:21 INFO - 2015-10-24 01:31:21,746 DEBUG : BROWSER_OUTPUT: Values: 2728.9 2781.5 2814.9 2816.6 2819.7 5283.9 5301.7 5338.1 5347.2 5388.7 5303.8 5318.0 5403.8 5418.8 5426.5 4464.8 4565.1 4575.1 4660.7 4665.5 4557.5 4584.4 4587.9 4610.6 4626.9 4593.1 4596.2 4614.2 4614.6 4616.6 4324.5 4509.9 4532.5 4583.5 4608.3 4510.9 4553.4 4555.6 4564.5 4606.4 5177.7 5214.3 5231.5 5297.4 5327.3 5510.3 5552.2 5580.1 5636.9 5647.1 5357.4 5388.1 5553.1 5572.1 5708.8 4873.5 4945.7 5081.2 5178.1 5279.2 5480.4 5691.7 5700.5 5792.4 5803.8 4975.7 5027.5 5057.9 5221.9 5385.3 5254.6 5289.9 5330.4 5334.1 5336.2 5204.3 5247.0 5297.7 5306.3 5533.4 5305.0 5466.9 5526.0 5564.0 5573.4 3265.3 3317.7 3318.6 3330.9 3367.9 3003.8 3032.9 3054.9 3147.0 3216.3 4915.6 5038.2 5126.6 5166.5 5230.7 5314.3 5318.7 5402.3 5406.0 5424.6 5034.9 5115.9 5122.8 5127.6 5171.2 4328.6 4399.4 4416.1 4468.3 4493.4 5542.3 5562.1 5688.2 5713.9 5993.1 5285.6 5289.7 5422.4 5428.8 5474.6 5454.7 5533.4 5712.9 5790.2 5891.9 5143.7 5260.4 5269.6 5272.9 5323.8 5264.8 5278.5 5417.4 5421.0 5432.5 5019.2 5063.0 5228.9 5473.2 5497.5 5012.0 5182.9 5235.9 5267.0 5273.9 5040.3 5071.6 5104.0 5150.6 5158.5 5071.8 5149.3 5244.9 5538.3 5544.8 5100.6 5188.9 5212.2 5381.2 5481.6 01:31:21 INFO - 2015-10-24 01:31:21,755 DEBUG : BROWSER_OUTPUT: 01:31:21 INFO - 2015-10-24 01:31:21,755 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46426.90 Median:35915.14 stddev:81081.73 (225.8%) stddev-sans-first:81235.78 01:31:21 INFO - 2015-10-24 01:31:21,755 DEBUG : BROWSER_OUTPUT: Values: 477.2 491.2 493.7 497.9 502.6 28528.0 35414.3 36051.8 36100.6 36956.3 37768.8 38207.4 38536.6 39293.8 39558.8 7364.9 7370.8 8054.0 8083.0 8233.0 9747.7 9997.9 10001.7 10057.3 10223.9 9461.2 9569.4 9666.9 9981.2 10114.4 7582.5 7781.7 9618.0 9660.6 9948.5 9369.9 9404.0 9439.4 9831.4 9996.3 34681.8 34741.8 34779.7 35517.8 36690.4 3088.7 3115.7 3159.4 3171.1 3217.1 28463.0 28823.8 28924.6 28950.1 29142.7 2595.9 2626.5 2643.7 2656.9 2679.0 283524.0 291497.0 292852.0 302887.0 303246.0 42186.0 43657.8 48343.5 48587.3 49064.8 52285.5 54188.7 55429.7 55659.7 55908.7 13469.0 13741.9 14121.4 14272.3 14309.1 10155.6 10586.2 10604.2 10613.6 10613.9 16328.8 16966.9 16994.2 17031.3 17049.9 7499.3 7572.9 7575.9 7732.8 7754.4 863.9 915.6 976.1 990.2 994.8 26052.9 26234.0 26560.3 26776.2 26805.0 959.5 988.7 992.6 1046.6 1066.9 13678.2 14721.3 14736.9 14810.7 15526.8 341748.0 348282.0 348528.0 373019.0 375085.0 44943.0 44983.9 46805.3 47118.0 47327.8 1130.6 1165.6 1180.0 1191.1 1209.2 21412.0 27776.0 27802.4 29572.6 29833.3 42902.4 42903.4 43298.8 45062.8 45657.8 264995.0 268878.0 268937.0 269855.0 271482.0 33359.5 40008.4 40671.2 41852.4 41871.0 40826.6 42262.0 42313.8 44080.8 44093.3 34029.3 35778.5 36140.6 36568.0 37278.1 36386.0 36865.0 37470.0 37942.0 38896.0 35307.0 35444.8 35642.5 36360.0 37658.6 31639.0 31867.5 32809.3 33238.0 33681.2 23617.9 23698.5 24097.5 24310.9 25575.9 01:31:21 INFO - 2015-10-24 01:31:21,755 DEBUG : BROWSER_OUTPUT: 01:31:21 INFO - 2015-10-24 01:31:21,755 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:20725.58 Median:207895.79 stddev:52899.78 (25.4%) stddev-sans-first:53025.97 01:31:21 INFO - 2015-10-24 01:31:21,756 DEBUG : BROWSER_OUTPUT: Values: 311.8 324.9 331.6 334.7 335.2 11755.5 11911.2 16062.6 16622.8 17149.8 10327.9 11188.8 16205.2 16300.2 16862.7 4101.7 4139.1 4189.2 4316.9 4343.2 4073.9 4121.6 4193.8 4208.7 4255.7 3616.0 3657.9 4218.2 4291.9 4299.7 4492.6 4641.5 4668.3 4673.9 4741.3 3871.7 3900.2 3990.3 3998.7 4003.6 12333.4 12605.7 12612.8 12769.2 12965.4 2045.7 2060.8 2079.4 2094.2 2186.8 9720.8 9758.4 9824.8 10046.8 10062.8 1568.9 1594.3 1630.7 1676.9 1697.0 74346.3 74502.0 75723.0 76052.0 76598.6 6098.0 6218.4 6278.0 6317.2 6339.2 6901.6 7003.1 7265.6 7303.6 7327.8 5297.4 5316.8 5327.3 5368.9 5370.0 5604.2 5693.9 5727.9 5804.2 5844.4 2665.4 2675.4 2789.7 2821.1 2848.0 966.8 983.4 1025.7 1033.3 1078.6 403.0 405.3 409.5 457.7 467.9 10059.6 10788.1 10923.9 11603.1 11636.1 443.2 460.7 471.7 475.2 478.1 6123.2 6280.8 6486.3 6500.6 6553.1 130554.3 130837.0 311969.0 411670.0 420100.0 79333.0 80219.2 84099.0 87974.6 90648.0 460.8 479.9 482.1 489.7 490.1 10817.8 11228.4 11324.4 11383.5 11388.8 43178.1 43195.6 43759.3 44024.3 44333.4 56279.0 58659.8 58849.7 60002.7 60862.0 5823.6 6168.6 6194.7 6198.7 6202.3 11571.9 12630.0 12634.6 12688.5 12731.1 10574.9 10801.2 10840.0 10850.5 10860.7 10312.8 10427.7 10491.7 10557.4 10609.0 10771.5 10898.9 10972.0 11064.8 11066.7 6151.9 6296.5 6303.9 6310.0 6318.7 10579.5 10617.8 10828.0 10915.5 10930.8 01:31:21 INFO - 2015-10-24 01:31:21,760 DEBUG : BROWSER_OUTPUT: 01:31:21 INFO - 2015-10-24 01:31:21,760 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5987.56 Median:4995.53 stddev:3412.45 (68.3%) stddev-sans-first:3402.50 01:31:21 INFO - 2015-10-24 01:31:21,760 DEBUG : BROWSER_OUTPUT: Values: 1131.7 1283.6 1294.9 1414.9 1546.3 7473.7 8048.8 8204.5 8626.2 8651.1 8571.8 8575.4 8645.7 8728.2 8733.8 2021.6 2024.5 2129.3 2219.4 2233.4 2114.5 2116.5 2117.8 2247.2 2256.8 2228.7 2297.9 2302.9 2303.1 2304.2 1997.4 2012.9 2240.8 2250.7 2266.4 2264.5 2266.6 2285.6 2299.0 2312.8 8848.9 8887.4 8921.5 8941.6 8947.1 4935.5 4984.9 4989.6 4990.4 5000.6 3296.8 3417.4 3444.1 3455.4 3522.7 1064.0 1067.0 1100.0 1105.9 1113.8 12885.2 13150.9 13171.3 13194.9 13200.5 4359.1 4366.1 4418.9 4465.0 4482.7 10649.4 10696.8 10698.9 10713.0 10730.9 4881.6 5027.1 5030.5 5031.5 5035.3 4421.9 4489.7 4586.4 4588.3 4593.4 3627.5 3685.3 3692.8 3715.7 3722.6 1104.1 1141.2 1143.1 1144.5 1153.1 803.7 1102.5 1143.9 1174.6 1176.9 7031.5 7724.8 7845.0 7850.6 7864.1 595.6 626.5 632.0 644.4 645.8 5491.4 5567.8 5577.2 5836.2 5940.4 10654.9 10726.2 10729.9 10796.0 11435.2 11309.4 11340.8 11341.0 11349.8 11356.8 7600.7 7881.7 7978.6 8070.8 8127.8 7674.3 7700.0 7701.0 7703.6 7713.3 9243.6 9367.6 9547.9 9678.8 9723.3 9539.4 9803.0 9945.5 10145.0 10183.1 7879.4 7933.8 7963.7 7964.8 7968.6 8619.1 8649.0 8679.0 8691.3 8697.5 7764.5 7942.1 8197.5 8232.1 8246.9 6837.4 6936.4 7239.6 7500.0 7559.4 7489.3 7493.3 7495.9 7507.1 7522.1 6704.5 6962.5 6981.7 6989.9 6996.3 6245.0 6539.4 6679.8 6942.2 6986.2 01:31:21 INFO - 2015-10-24 01:31:21,760 DEBUG : BROWSER_OUTPUT: 01:31:21 INFO - 2015-10-24 01:31:21,760 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5081.23 Median:5740.87 stddev:1558.25 (27.1%) stddev-sans-first:1521.13 01:31:21 INFO - 2015-10-24 01:31:21,760 DEBUG : BROWSER_OUTPUT: Values: 322.1 324.4 327.0 331.4 333.5 5367.6 5535.5 5599.3 5606.1 5943.4 5426.7 5485.5 5544.1 5557.8 5722.8 4072.9 4077.4 4089.9 4342.8 4351.1 4192.6 4345.3 4347.4 4349.3 4354.2 3983.0 4046.2 4047.9 4057.0 4122.7 4043.2 4048.5 4163.4 4303.2 4317.2 3798.1 3798.3 3798.8 3801.8 3804.6 5370.7 5386.3 5395.4 5428.9 5711.4 4835.6 4845.5 4850.8 5000.7 5151.8 5955.9 5961.2 5970.1 6180.8 6217.5 4069.1 4069.5 4073.0 4232.8 4241.7 6185.3 6459.0 6472.9 6484.7 6485.3 4178.1 4246.0 4403.0 4432.6 4455.8 4248.5 4305.9 4527.5 4528.2 4532.0 4883.7 4897.1 4967.2 5194.9 5200.8 5841.0 5875.4 6062.4 6251.0 6253.8 1614.1 1632.7 1633.5 1633.7 1635.8 1076.1 1091.5 1101.1 1103.8 1105.9 5967.9 6020.2 6022.1 6046.2 6053.0 6056.0 6409.6 6429.2 6433.5 6434.2 5703.7 6037.5 6044.3 6045.9 6056.3 3150.4 3233.5 3368.3 3506.8 3547.2 6459.3 6729.9 6742.3 6757.8 6760.4 6478.6 6487.5 6489.0 6493.9 6494.1 6076.2 6506.5 6715.4 6747.3 6748.3 5970.8 6070.6 6177.1 6187.4 6190.6 5758.9 5968.9 6016.3 6322.5 6323.7 6817.9 6835.2 6839.2 6839.9 6849.2 4205.2 4258.3 4409.9 4470.2 4487.7 6283.8 6464.2 6468.1 6473.8 6484.4 6294.1 6317.6 6323.2 6326.9 6330.3 5900.6 5908.2 5980.1 6077.0 6164.9 5584.6 5837.5 5901.2 5920.6 5987.3 5896.3 5927.6 5946.2 5978.1 6148.6 5820.1 5822.0 5874.3 5923.1 5971.5 01:31:21 INFO - 2015-10-24 01:31:21,760 DEBUG : BROWSER_OUTPUT: 01:31:21 INFO - 2015-10-24 01:31:21,762 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12373.35 Median:2362.75 stddev:14249.35 (603.1%) stddev-sans-first:14262.33 01:31:21 INFO - 2015-10-24 01:31:21,762 DEBUG : BROWSER_OUTPUT: Values: 692.2 693.5 696.5 709.4 721.7 11868.0 12270.1 12392.5 12472.0 12675.0 9627.2 10709.3 11446.0 11467.0 11865.8 576.3 587.1 593.4 614.3 615.8 602.1 603.1 605.3 609.9 615.4 607.7 618.4 619.9 622.7 623.5 600.5 624.4 628.1 629.7 630.6 420.4 436.9 445.4 448.9 456.5 10428.3 10724.6 10725.8 10922.0 11012.6 9077.8 9762.5 10042.3 10058.7 10296.7 7766.4 8569.7 8623.9 8862.3 8953.8 3400.6 3414.8 3460.2 3491.8 3515.6 34782.3 38767.6 39540.6 44024.8 44566.9 6754.7 6987.2 7040.7 7585.9 8910.7 10200.9 10504.5 10824.1 11296.8 11309.9 5847.8 6070.3 6293.5 6324.3 6334.5 4016.7 4120.7 4126.5 4168.9 4238.4 2465.4 2466.8 2467.2 2511.8 2577.2 446.7 449.3 451.3 452.5 453.7 588.6 612.9 624.3 656.6 667.3 8376.4 8749.9 8966.1 8986.1 9010.2 562.5 667.2 682.7 688.4 704.3 3932.3 4193.4 4234.4 4288.5 4511.9 55067.7 55516.2 55877.7 56026.7 59746.7 44884.6 46969.0 47005.0 47107.3 48254.5 35836.5 36374.3 38868.4 39785.0 40705.0 8561.6 8696.3 8701.6 8743.8 9052.3 27856.6 28085.4 28118.7 28366.7 29991.9 36702.4 36977.0 38964.2 40934.0 41174.6 11392.9 11782.5 12075.8 12105.8 12126.4 13420.9 13439.6 13693.2 13696.9 13830.7 12124.7 12242.3 12353.8 12944.2 13066.5 11336.3 11430.5 11438.7 11659.9 11836.0 11575.6 12006.8 12185.9 12449.4 12578.9 9978.5 9997.9 10017.0 10091.3 10790.6 9251.0 9614.7 10028.2 10176.5 10573.3 01:31:21 INFO - 2015-10-24 01:31:21,770 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:31:21 INFO - 2015-10-24 01:31:21,772 DEBUG : BROWSER_OUTPUT: 01:31:22 INFO - 2015-10-24 01:31:22,213 INFO : Browser exited with error code: 0 01:31:22 INFO - 2015-10-24 01:31:22,944 INFO : Completed test dromaeo_css (00:18:37) 01:31:22 INFO - 2015-10-24 01:31:22,944 INFO : Starting test kraken 01:31:22 INFO - 2015-10-24 01:31:22,944 DEBUG : operating with platform_type : w7_ 01:31:22 INFO - 2015-10-24 01:31:22,944 INFO : Initialising browser for kraken test... 01:31:22 INFO - 2015-10-24 01:31:22,970 DEBUG : command line: C:\slave\test-pgo\build\application\firefox\firefox -profile c:\users\cltbld\appdata\local\temp\tmptzggku\profile http://localhost:49896/getInfo.html 01:31:28 INFO - 2015-10-24 01:31:28,515 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:31:28 INFO - 2015-10-24 01:31:28,515 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:31:28 INFO - 2015-10-24 01:31:28,515 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1010/674 01:31:28 INFO - 2015-10-24 01:31:28,515 DEBUG : BROWSER_OUTPUT: __metrics 01:31:28 INFO - 2015-10-24 01:31:28,589 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:31:29 INFO - 2015-10-24 01:31:29,289 DEBUG : BROWSER_OUTPUT: console.error: 01:31:29 INFO - 2015-10-24 01:31:29,289 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] 01:31:29 INFO - 2015-10-24 01:31:29,289 DEBUG : BROWSER_OUTPUT: Stack: 01:31:29 INFO - 2015-10-24 01:31:29,289 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<._executeStatement@resource://gre/modules/Sqlite.jsm:758:19 01:31:29 INFO - 2015-10-24 01:31:29,289 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached/<@resource://gre/modules/Sqlite.jsm:493:9 01:31:29 INFO - 2015-10-24 01:31:29,289 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached@resource://gre/modules/Sqlite.jsm:491:1 01:31:29 INFO - 2015-10-24 01:31:29,289 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeBeforeShutdown/loggedDb<.executeCached.value<@resource://gre/modules/Sqlite.jsm:368:51 01:31:29 INFO - 2015-10-24 01:31:29,289 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 01:31:29 INFO - 2015-10-24 01:31:29,289 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 01:31:29 INFO - 2015-10-24 01:31:29,289 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 01:31:29 INFO - 2015-10-24 01:31:29,289 DEBUG : BROWSER_OUTPUT: transaction@resource://gre/modules/Bookmarks.jsm:783:15 01:31:29 INFO - 2015-10-24 01:31:29,289 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 01:31:29 INFO - 2015-10-24 01:31:29,289 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 01:31:29 INFO - 2015-10-24 01:31:29,289 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 01:31:29 INFO - 2015-10-24 01:31:29,290 DEBUG : BROWSER_OUTPUT: Task_spawn@resource://gre/modules/Task.jsm:164:12 01:31:29 INFO - 2015-10-24 01:31:29,290 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promisedromaeo_css: 6404.80 01:33:05 INFO - RETURN: kraken: 1606.90 01:33:05 INFO - RETURN: v8_7: 20379.88 01:33:05 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,25]]", "result": "20379.88"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,25]]", "result": "1606.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,25]]", "result": "6404.80"}}} 01:33:05 INFO - Return code: 0 01:33:05 INFO - # TBPL SUCCESS # 01:33:05 INFO - Running post-action listener: _resource_record_post_action 01:33:05 INFO - Running post-run listener: _resource_record_post_run 01:33:06 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 803949056; Write bytes: 860132352; Read time: 35379200; Write time: 5524570 01:33:06 INFO - install - Wall time: 3s; CPU: 9.0%; Read bytes: 0; Write bytes: 5896192; Read time: 0; Write time: 469510 01:33:06 INFO - run-tests - Wall time: 1223s; CPU: 14.0%; Read bytes: 803949056; Write bytes: 834158080; Read time: 35379200; Write time: 4872620 01:33:06 INFO - Running post-run listener: _upload_blobber_files 01:33:06 INFO - Blob upload gear active. 01:33:06 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 01:33:06 INFO - Copying logs to upload dir... 01:33:06 INFO - mkdir: C:\slave\test-pgo\build\upload\logs program finished with exit code 0 elapsedTime=1419.947000 ========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 53 secs) (at 2015-10-24 01:33:19.649147) ========= ========= Started set props: build_url (results: 0, elapsed: 17 secs) (at 2015-10-24 01:33:19.653760) ========= '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-129 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-129 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-129 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/jjttMSC1SH2qP1pz_Ue9jA/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/jjttMSC1SH2qP1pz_Ue9jA/artifacts/public/build/firefox-44.0a1.en-US.win32.zip' ========= Finished set props: build_url (results: 0, elapsed: 17 secs) (at 2015-10-24 01:33:37.052799) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2015-10-24 01:33:37.053130) ========= '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-129 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-129 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-129 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: 1 secs) (at 2015-10-24 01:33:38.078550) ========= ========= Started reboot slave lost (results: 0, elapsed: 12 secs) (at 2015-10-24 01:33:38.078840) ========= ========= Finished reboot slave lost (results: 0, elapsed: 12 secs) (at 2015-10-24 01:33:51.037379) =========