builder: mozilla-inbound_win7-ix_test-dromaeojs slave: t-w732-ix-001 starttime: 1445917594.84 results: success (0) buildid: 20151026192222 builduid: f2fdf86c07d64e60807f71b18dae627c revision: 0dd4a8dd56181365169aee7c6928cca302f9baf2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-26 20:46:34.836313) ========= master: http://buildbot-master112.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-26 20:46:34.838224) ========= ========= Started set props: basedir (results: 0, elapsed: 1 secs) (at 2015-10-26 20:46:34.838533) ========= 'cd' in dir C:\slave\test\. (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-001 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-001 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 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-001 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 program finished with exit code 0 elapsedTime=0.525000 basedir: 'C:\\slave\\test' ========= Finished set props: basedir (results: 0, elapsed: 1 secs) (at 2015-10-26 20:46:36.489950) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 3 secs) (at 2015-10-26 20:46:36.490249) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 3 secs) (at 2015-10-26 20:46:39.753942) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 9 secs) (at 2015-10-26 20:46:39.754271) ========= 'rm' '-rf' 'properties' in dir C:\slave\test\. (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-001 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-001 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 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-001 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.502000 ========= Finished 'rm -rf ...' (results: 0, elapsed: 9 secs) (at 2015-10-26 20:46:49.407445) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-26 20:46:49.407802) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-26 20:46:49.408484) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-26 20:46:49.408784) ========= '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\. (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-001 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-001 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 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-001 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 --20:46:49-- 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.45 GB/s 20:46:49 (2.45 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.845000 ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-26 20:46:50.398486) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 21 secs) (at 2015-10-26 20:46:50.398787) ========= 'rm' '-rf' 'scripts' in dir C:\slave\test\. (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-001 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-001 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 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-001 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.816000 ========= Finished 'rm -rf ...' (results: 0, elapsed: 21 secs) (at 2015-10-26 20:47:12.095102) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 9 secs) (at 2015-10-26 20:47:12.095470) ========= 'bash' '-c' u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 0dd4a8dd56181365169aee7c6928cca302f9baf2 --destination scripts --debug' in dir C:\slave\test\. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 0dd4a8dd56181365169aee7c6928cca302f9baf2 --destination scripts --debug'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files\Common Files COMPUTERNAME=T-W732-IX-001 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-001 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 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-001 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-26 20:47:12,029 truncating revision to first 12 chars 2015-10-26 20:47:12,029 Setting DEBUG logging. 2015-10-26 20:47:12,029 attempt 1/10 2015-10-26 20:47:12,029 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/0dd4a8dd5618?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-10-26 20:47:12,572 unpacking tar archive at: mozilla-inbound-0dd4a8dd5618/testing/mozharness/ program finished with exit code 0 elapsedTime=1.075000 ========= Finished 'bash -c ...' (results: 0, elapsed: 9 secs) (at 2015-10-26 20:47:21.807379) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-26 20:47:21.807692) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-26 20:47:21.935219) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-26 20:47:21.935478) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-26 20:47:21.939395) ========= ========= Started 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 36 secs) (at 2015-10-26 20:47:21.939774) ========= 'c:/mozilla-build/python27/python' '-u' 'scripts/scripts/talos_script.py' '--suite' 'dromaeojs' '--add-option' '--webServer,localhost' '--branch-name' 'Mozilla-Inbound-Non-PGO' '--system-bits' '32' '--cfg' 'talos/windows_config.py' '--download-symbols' 'ondemand' '--use-talos-json' '--blob-upload-branch' 'Mozilla-Inbound-Non-PGO' in dir C:\slave\test\. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['c:/mozilla-build/python27/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound-Non-PGO', '--system-bits', '32', '--cfg', 'talos/windows_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound-Non-PGO'] environment: ALLUSERSPROFILE=C:\ProgramData APPDATA=C:\Users\cltbld\AppData\Roaming COMMONPROGRAMFILES=C:\Program Files\Common Files COMPUTERNAME=T-W732-IX-001 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-001 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/buildprops.json PSMODULEPATH=C:\windows\system32\WindowsPowerShell\v1.0\Modules\ PUBLIC=C:\Users\Public PWD=C:\slave\test 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-001 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 20:47:22 INFO - MultiFileLogger online at 20151026 20:47:22 in C:\slave\test 20:47:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound-Non-PGO --system-bits 32 --cfg talos/windows_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound-Non-PGO 20:47:22 INFO - Dumping config to C:\slave\test\logs\localconfig.json. 20:47:22 INFO - {'append_to_log': False, 20:47:22 INFO - 'base_work_dir': 'C:\\slave\\test', 20:47:22 INFO - 'blob_upload_branch': 'Mozilla-Inbound-Non-PGO', 20:47:22 INFO - 'blob_uploader_auth_file': 'C:\\slave\\test\\oauth.txt', 20:47:22 INFO - 'branch': 'Mozilla-Inbound-Non-PGO', 20:47:22 INFO - 'buildbot_json_path': 'buildprops.json', 20:47:22 INFO - 'config_files': ('talos/windows_config.py',), 20:47:22 INFO - 'default_actions': ('clobber', 20:47:22 INFO - 'read-buildbot-config', 20:47:22 INFO - 'download-and-extract', 20:47:22 INFO - 'populate-webroot', 20:47:22 INFO - 'create-virtualenv', 20:47:22 INFO - 'install', 20:47:22 INFO - 'run-tests'), 20:47:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:47:22 INFO - 'download_minidump_stackwalk': True, 20:47:22 INFO - 'download_symbols': 'ondemand', 20:47:22 INFO - 'exes': {'easy_install': ('C:\\slave\\test\\build/venv/scripts/python', 20:47:22 INFO - 'C:\\slave\\test\\build/venv/scripts/easy_install-2.7-script.py'), 20:47:22 INFO - 'hg': 'c:/mozilla-build/hg/hg', 20:47:22 INFO - 'mozinstall': ('C:\\slave\\test\\build/venv/scripts/python', 20:47:22 INFO - 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py'), 20:47:22 INFO - 'python': 'c:/mozilla-build/python27/python.exe', 20:47:22 INFO - 'tooltool.py': ('c:/mozilla-build/python27/python.exe', 20:47:22 INFO - 'C:/mozilla-build/tooltool.py'), 20:47:22 INFO - 'virtualenv': ('c:/mozilla-build/python27/python.exe', 20:47:22 INFO - 'c:/mozilla-build/buildbotve/virtualenv.py')}, 20:47:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:47:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:47:22 INFO - 'installer_path': 'installer.exe', 20:47:22 INFO - 'log_level': 'info', 20:47:22 INFO - 'log_name': 'talos', 20:47:22 INFO - 'log_to_console': True, 20:47:22 INFO - 'metro_harness_path_frmt': '%(metro_base_path)s/metro/metrotestharness.exe', 20:47:22 INFO - 'minidump_stackwalk_path': 'win32-minidump_stackwalk.exe', 20:47:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/win32/releng.manifest', 20:47:22 INFO - 'opt_config_files': (), 20:47:22 INFO - 'pip_index': False, 20:47:22 INFO - 'sps_profile': False, 20:47:22 INFO - 'sps_profile_interval': 0, 20:47:22 INFO - 'suite': 'dromaeojs', 20:47:22 INFO - 'system_bits': '32', 20:47:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:47:22 INFO - 'title': 'T-W732-IX-001', 20:47:22 INFO - 'use_talos_json': True, 20:47:22 INFO - 'virtualenv_modules': ('pywin32', 'talos', 'mozinstall'), 20:47:22 INFO - 'virtualenv_path': 'C:\\slave\\test\\build/venv', 20:47:22 INFO - 'virtualenv_python_dll': 'c:/mozilla-build/python27/python27.dll', 20:47:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:47:22 INFO - 'work_dir': 'build'} 20:47:22 INFO - ##### 20:47:22 INFO - ##### Running clobber step. 20:47:22 INFO - ##### 20:47:22 INFO - Running pre-action listener: _resource_record_pre_action 20:47:22 INFO - Running main action method: clobber 20:47:22 INFO - rmtree: C:\slave\test\build 20:47:22 INFO - Using _rmtree_windows ... 20:47:22 INFO - retry: Calling _rmtree_windows with args: ('C:\\slave\\test\\build',), kwargs: {}, attempt #1 20:48:35 INFO - Running post-action listener: _resource_record_post_action 20:48:35 INFO - ##### 20:48:35 INFO - ##### Running read-buildbot-config step. 20:48:35 INFO - ##### 20:48:35 INFO - Running pre-action listener: _resource_record_pre_action 20:48:35 INFO - Running main action method: read_buildbot_config 20:48:35 INFO - Using buildbot properties: 20:48:35 INFO - { 20:48:35 INFO - "properties": { 20:48:35 INFO - "buildnumber": 2015, 20:48:35 INFO - "product": "firefox", 20:48:35 INFO - "script_repo_revision": "production", 20:48:35 INFO - "builddir": "mozilla-inbound_win7-ix_test-dromaeojs", 20:48:35 INFO - "repository": "", 20:48:35 INFO - "buildername": "Windows 7 32-bit mozilla-inbound talos dromaeojs", 20:48:35 INFO - "buildid": "20151026192222", 20:48:35 INFO - "slavename": "t-w732-ix-001", 20:48:35 INFO - "pgo_build": "False", 20:48:35 INFO - "basedir": "C:\\slave\\test", 20:48:35 INFO - "project": "", 20:48:35 INFO - "platform": "win7-ix", 20:48:35 INFO - "master": "http://buildbot-master112.bb.releng.scl3.mozilla.com:8201/", 20:48:35 INFO - "slavebuilddir": "test", 20:48:35 INFO - "scheduler": "tests-mozilla-inbound-win32-talos", 20:48:35 INFO - "branch": "mozilla-inbound", 20:48:35 INFO - "repo_path": "integration/mozilla-inbound", 20:48:35 INFO - "stage_platform": "win32", 20:48:35 INFO - "builduid": "f2fdf86c07d64e60807f71b18dae627c", 20:48:35 INFO - "revision": "0dd4a8dd56181365169aee7c6928cca302f9baf2" 20:48:35 INFO - }, 20:48:35 INFO - "sourcestamp": { 20:48:35 INFO - "repository": "", 20:48:35 INFO - "hasPatch": false, 20:48:35 INFO - "project": "", 20:48:35 INFO - "branch": "mozilla-inbound-win32-talos", 20:48:35 INFO - "changes": [ 20:48:35 INFO - { 20:48:35 INFO - "category": null, 20:48:35 INFO - "files": [ 20:48:35 INFO - { 20:48:35 INFO - "url": null, 20:48:35 INFO - "name": "https://queue.taskcluster.net/v1/task/FcMX6egQQlu8cGEfju8hZQ/artifacts/public/build/firefox-44.0a1.en-US.win32.zip" 20:48:35 INFO - } 20:48:35 INFO - ], 20:48:35 INFO - "repository": "", 20:48:35 INFO - "rev": "0dd4a8dd56181365169aee7c6928cca302f9baf2", 20:48:35 INFO - "who": "r@hev.cc", 20:48:35 INFO - "when": 1445917237, 20:48:35 INFO - "number": 6577865, 20:48:35 INFO - "comments": "Bug 1217873 - IonMonkey: MIPS: Move BailoutStack to architecture dependent. r=arai f=nbp\n\n---\n js/src/jit/mips-shared/Bailouts-mips-shared.cpp | 5 +----\n js/src/jit/mips32/Bailouts-mips32.cpp | 4 ++--\n .../Bailouts-mips-shared.h => mips32/Bailouts-mips32.h} | 6 +++---\n js/src/jit/mips32/Trampoline-mips32.cpp | 2 +-\n js/src/jit/mips64/Bailouts-mips64.cpp | 4 ++--\n .../Bailouts-mips-shared.h => mips64/Bailouts-mips64.h} | 6 +++---\n js/src/jit/mips64/Trampoline-mips64.cpp | 2 +-\n 7 files changed, 13 insertions(+), 16 deletions(-)\n copy js/src/jit/{mips-shared/Bailouts-mips-shared.h => mips32/Bailouts-mips32.h} (93%)\n rename js/src/jit/{mips-shared/Bailouts-mips-shared.h => mips64/Bailouts-mips64.h} (93%)", 20:48:35 INFO - "project": "", 20:48:35 INFO - "at": "Mon 26 Oct 2015 20:40:37", 20:48:35 INFO - "branch": "mozilla-inbound-win32-talos", 20:48:35 INFO - "revlink": "", 20:48:35 INFO - "properties": [ 20:48:35 INFO - [ 20:48:35 INFO - "buildid", 20:48:35 INFO - "20151026192222", 20:48:35 INFO - "Change" 20:48:35 INFO - ], 20:48:35 INFO - [ 20:48:35 INFO - "builduid", 20:48:35 INFO - "f2fdf86c07d64e60807f71b18dae627c", 20:48:35 INFO - "Change" 20:48:35 INFO - ], 20:48:35 INFO - [ 20:48:35 INFO - "pgo_build", 20:48:35 INFO - "False", 20:48:35 INFO - "Change" 20:48:35 INFO - ] 20:48:35 INFO - ], 20:48:35 INFO - "revision": "0dd4a8dd56181365169aee7c6928cca302f9baf2" 20:48:35 INFO - } 20:48:35 INFO - ], 20:48:35 INFO - "revision": "0dd4a8dd56181365169aee7c6928cca302f9baf2" 20:48:35 INFO - } 20:48:35 INFO - } 20:48:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/FcMX6egQQlu8cGEfju8hZQ/artifacts/public/build/firefox-44.0a1.en-US.win32.zip. 20:48:35 INFO - Running post-action listener: _resource_record_post_action 20:48:35 INFO - ##### 20:48:35 INFO - ##### Running download-and-extract step. 20:48:35 INFO - ##### 20:48:35 INFO - Running pre-action listener: _resource_record_pre_action 20:48:35 INFO - Running main action method: download_and_extract 20:48:35 INFO - mkdir: C:\slave\test\build\tests 20:48:35 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')]} 20:48:35 INFO - https://queue.taskcluster.net/v1/task/FcMX6egQQlu8cGEfju8hZQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 20:48:35 INFO - trying https://queue.taskcluster.net/v1/task/FcMX6egQQlu8cGEfju8hZQ/artifacts/public/build/test_packages.json 20:48:35 INFO - Downloading https://queue.taskcluster.net/v1/task/FcMX6egQQlu8cGEfju8hZQ/artifacts/public/build/test_packages.json to C:\slave\test\build\test_packages.json 20:48:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FcMX6egQQlu8cGEfju8hZQ/artifacts/public/build/test_packages.json', 'file_name': 'C:\\slave\\test\\build\\test_packages.json'}, attempt #1 20:48:36 INFO - Downloaded 1221 bytes. 20:48:36 INFO - Reading from file C:\slave\test\build\test_packages.json 20:48:36 INFO - Using the following test package requirements: 20:48:36 INFO - {u'common': [u'firefox-44.0a1.en-US.win32.common.tests.zip'], 20:48:36 INFO - u'cppunittest': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 20:48:36 INFO - u'firefox-44.0a1.en-US.win32.cppunittest.tests.zip'], 20:48:36 INFO - u'jittest': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 20:48:36 INFO - u'jsshell-win32.zip'], 20:48:36 INFO - u'mochitest': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 20:48:36 INFO - u'firefox-44.0a1.en-US.win32.mochitest.tests.zip'], 20:48:36 INFO - u'mozbase': [u'firefox-44.0a1.en-US.win32.common.tests.zip'], 20:48:36 INFO - u'reftest': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 20:48:36 INFO - u'firefox-44.0a1.en-US.win32.reftest.tests.zip'], 20:48:36 INFO - u'talos': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 20:48:36 INFO - u'firefox-44.0a1.en-US.win32.talos.tests.zip'], 20:48:36 INFO - u'web-platform': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 20:48:36 INFO - u'firefox-44.0a1.en-US.win32.web-platform.tests.zip'], 20:48:36 INFO - u'webapprt': [u'firefox-44.0a1.en-US.win32.common.tests.zip'], 20:48:36 INFO - u'xpcshell': [u'firefox-44.0a1.en-US.win32.common.tests.zip', 20:48:36 INFO - u'firefox-44.0a1.en-US.win32.xpcshell.tests.zip']} 20:48:36 INFO - Downloading packages: [u'firefox-44.0a1.en-US.win32.common.tests.zip'] for test suite category: common 20:48:36 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')]} 20:48:36 INFO - https://queue.taskcluster.net/v1/task/FcMX6egQQlu8cGEfju8hZQ/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip matches https://queue.taskcluster.net 20:48:36 INFO - trying https://queue.taskcluster.net/v1/task/FcMX6egQQlu8cGEfju8hZQ/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip 20:48:36 INFO - Downloading https://queue.taskcluster.net/v1/task/FcMX6egQQlu8cGEfju8hZQ/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip to C:\slave\test\build\firefox-44.0a1.en-US.win32.common.tests.zip 20:48:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FcMX6egQQlu8cGEfju8hZQ/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip', 'file_name': u'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win32.common.tests.zip'}, attempt #1 20:48:38 INFO - Downloaded 17990215 bytes. 20:48:38 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win32.common.tests.zip'] in C:\slave\test\build\tests 20:48:38 INFO - Copy/paste: unzip -q -o C:\slave\test\build\firefox-44.0a1.en-US.win32.common.tests.zip 20:48:38 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win32.common.tests.zip'] with output_timeout 1760 20:49:06 INFO - Return code: 0 20:49:06 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 20:49: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')]} 20:49:06 INFO - https://queue.taskcluster.net/v1/task/FcMX6egQQlu8cGEfju8hZQ/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip matches https://queue.taskcluster.net 20:49:06 INFO - trying https://queue.taskcluster.net/v1/task/FcMX6egQQlu8cGEfju8hZQ/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip 20:49:06 INFO - Downloading https://queue.taskcluster.net/v1/task/FcMX6egQQlu8cGEfju8hZQ/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip to C:\slave\test\build\firefox-44.0a1.en-US.win32.common.tests.zip 20:49:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FcMX6egQQlu8cGEfju8hZQ/artifacts/public/build/firefox-44.0a1.en-US.win32.common.tests.zip', 'file_name': u'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win32.common.tests.zip'}, attempt #1 20:49:07 INFO - Downloaded 17990215 bytes. 20:49:07 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win32.common.tests.zip'] in C:\slave\test\build\tests 20:49:07 INFO - Copy/paste: unzip -q -o C:\slave\test\build\firefox-44.0a1.en-US.win32.common.tests.zip 20:49:07 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win32.common.tests.zip'] with output_timeout 1760 20:49:27 INFO - Return code: 0 20:49:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:49:27 INFO - https://queue.taskcluster.net/v1/task/FcMX6egQQlu8cGEfju8hZQ/artifacts/public/build/firefox-44.0a1.en-US.win32.talos.tests.zip matches https://queue.taskcluster.net 20:49:27 INFO - trying https://queue.taskcluster.net/v1/task/FcMX6egQQlu8cGEfju8hZQ/artifacts/public/build/firefox-44.0a1.en-US.win32.talos.tests.zip 20:49:27 INFO - Downloading https://queue.taskcluster.net/v1/task/FcMX6egQQlu8cGEfju8hZQ/artifacts/public/build/firefox-44.0a1.en-US.win32.talos.tests.zip to C:\slave\test\build\firefox-44.0a1.en-US.win32.talos.tests.zip 20:49:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FcMX6egQQlu8cGEfju8hZQ/artifacts/public/build/firefox-44.0a1.en-US.win32.talos.tests.zip', 'file_name': u'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win32.talos.tests.zip'}, attempt #1 20:49:30 INFO - Downloaded 11131307 bytes. 20:49:30 INFO - Running command: ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win32.talos.tests.zip'] in C:\slave\test\build\tests 20:49:30 INFO - Copy/paste: unzip -q -o C:\slave\test\build\firefox-44.0a1.en-US.win32.talos.tests.zip 20:49:30 INFO - Calling ['unzip', '-q', '-o', u'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win32.talos.tests.zip'] with output_timeout 1760 20:49:33 INFO - Return code: 0 20:49:33 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')]} 20:49:33 INFO - https://queue.taskcluster.net/v1/task/FcMX6egQQlu8cGEfju8hZQ/artifacts/public/build/firefox-44.0a1.en-US.win32.zip matches https://queue.taskcluster.net 20:49:33 INFO - trying https://queue.taskcluster.net/v1/task/FcMX6egQQlu8cGEfju8hZQ/artifacts/public/build/firefox-44.0a1.en-US.win32.zip 20:49:33 INFO - Downloading https://queue.taskcluster.net/v1/task/FcMX6egQQlu8cGEfju8hZQ/artifacts/public/build/firefox-44.0a1.en-US.win32.zip to C:\slave\test\build\firefox-44.0a1.en-US.win32.zip 20:49:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FcMX6egQQlu8cGEfju8hZQ/artifacts/public/build/firefox-44.0a1.en-US.win32.zip', 'file_name': 'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win32.zip'}, attempt #1 20:49:36 INFO - Downloaded 51514782 bytes. 20:49:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FcMX6egQQlu8cGEfju8hZQ/artifacts/public/build/firefox-44.0a1.en-US.win32.zip 20:49:36 INFO - mkdir: C:\slave\test\properties 20:49:36 INFO - Writing buildbot properties ['build_url'] to C:\slave\test\properties\build_url 20:49:36 INFO - Writing to file C:\slave\test\properties\build_url 20:49:36 INFO - Contents: 20:49:36 INFO - build_url:https://queue.taskcluster.net/v1/task/FcMX6egQQlu8cGEfju8hZQ/artifacts/public/build/firefox-44.0a1.en-US.win32.zip 20:49:36 INFO - Running post-action listener: _resource_record_post_action 20:49:36 INFO - Running post-action listener: set_extra_try_arguments 20:49:36 INFO - ##### 20:49:36 INFO - ##### Running populate-webroot step. 20:49:36 INFO - ##### 20:49:36 INFO - Running pre-action listener: _resource_record_pre_action 20:49:36 INFO - Running main action method: populate_webroot 20:49:36 INFO - Guessing talos json url... 20:49:36 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')]} 20:49:36 INFO - https://queue.taskcluster.net/v1/task/FcMX6egQQlu8cGEfju8hZQ/artifacts/public/build/firefox-44.0a1.en-US.win32.txt matches https://queue.taskcluster.net 20:49:36 INFO - trying https://queue.taskcluster.net/v1/task/FcMX6egQQlu8cGEfju8hZQ/artifacts/public/build/firefox-44.0a1.en-US.win32.txt 20:49:36 INFO - Downloading https://queue.taskcluster.net/v1/task/FcMX6egQQlu8cGEfju8hZQ/artifacts/public/build/firefox-44.0a1.en-US.win32.txt to C:\slave\test\build\firefox-44.0a1.en-US.win32.txt 20:49:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FcMX6egQQlu8cGEfju8hZQ/artifacts/public/build/firefox-44.0a1.en-US.win32.txt', 'file_name': 'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win32.txt'}, attempt #1 20:49:37 INFO - Downloaded 111 bytes. 20:49:37 INFO - Reading from file C:\slave\test\build\firefox-44.0a1.en-US.win32.txt 20:49:37 INFO - Contents: 20:49:37 INFO - 20151026192222 20:49:37 INFO - https://hg.mozilla.org/integration/mozilla-inbound/rev/0dd4a8dd56181365169aee7c6928cca302f9baf2 20:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:49:37 INFO - trying https://hg.mozilla.org/integration/mozilla-inbound/raw-file/0dd4a8dd56/testing/talos/talos.json 20:49:37 INFO - Downloading https://hg.mozilla.org/integration/mozilla-inbound/raw-file/0dd4a8dd56/testing/talos/talos.json to C:\slave\test\build\talos.json 20:49:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/mozilla-inbound/raw-file/0dd4a8dd56/testing/talos/talos.json', 'file_name': 'C:\\slave\\test\\build\\talos.json'}, attempt #1 20:49:38 INFO - Downloaded 4264 bytes. 20:49:38 INFO - {u'extra_options': {u'android': [u'--apkPath=%(apk_path)s']}, 20:49:38 INFO - u'mobile-suites': {u'remote-tp4m_nochrome': {u'tests': [u'tp4m']}, 20:49:38 INFO - u'remote-trobocheck2': {u'talos_options': [u'--fennecIDs', 20:49:38 INFO - u'../fennec_ids.txt'], 20:49:38 INFO - u'tests': [u'tcheck2']}, 20:49:38 INFO - u'remote-tsvgx': {u'talos_options': [u'--noChrome', 20:49:38 INFO - u'--tppagecycles', 20:49:38 INFO - u'7'], 20:49:38 INFO - u'tests': [u'tsvgm']}}, 20:49:38 INFO - u'suites': {u'chromez': {u'tests': [u'tresize', u'tcanvasmark']}, 20:49:38 INFO - u'chromez-e10s': {u'talos_options': [u'--e10s'], 20:49:38 INFO - u'tests': [u'tresize', u'tcanvasmark']}, 20:49:38 INFO - u'dromaeojs': {u'tests': [u'dromaeo_css', u'kraken', u'v8_7']}, 20:49:38 INFO - u'dromaeojs-e10s': {u'talos_options': [u'--e10s'], 20:49:38 INFO - u'tests': [u'dromaeo_css', 20:49:38 INFO - u'kraken', 20:49:38 INFO - u'v8_7']}, 20:49:38 INFO - u'g1': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:49:38 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 20:49:38 INFO - u'g1-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:49:38 INFO - u'talos_options': [u'--e10s'], 20:49:38 INFO - u'tests': [u'tp5o_scroll', u'glterrain']}, 20:49:38 INFO - u'g2': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:49:38 INFO - u'tests': [u'damp', u'tps']}, 20:49:38 INFO - u'g2-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:49:38 INFO - u'talos_options': [u'--e10s'], 20:49:38 INFO - u'tests': [u'damp', u'tps']}, 20:49:38 INFO - u'g3': {u'tests': [u'dromaeo_dom']}, 20:49:38 INFO - u'g3-e10s': {u'tests': [u'dromaeo_dom']}, 20:49:38 INFO - u'other': {u'tests': [u'a11yr', 20:49:38 INFO - u'ts_paint', 20:49:38 INFO - u'tpaint', 20:49:38 INFO - u'sessionrestore', 20:49:38 INFO - u'sessionrestore_no_auto_restore']}, 20:49:38 INFO - u'other-e10s': {u'talos_options': [u'--e10s'], 20:49:38 INFO - u'tests': [u'a11yr', 20:49:38 INFO - u'ts_paint', 20:49:38 INFO - u'tpaint', 20:49:38 INFO - u'sessionrestore', 20:49:38 INFO - u'sessionrestore_no_auto_restore']}, 20:49:38 INFO - u'other-e10s_l64': {u'talos_options': [u'--e10s'], 20:49:38 INFO - u'tests': [u'a11yr', 20:49:38 INFO - u'ts_paint', 20:49:38 INFO - u'tpaint', 20:49:38 INFO - u'sessionrestore', 20:49:38 INFO - u'sessionrestore_no_auto_restore']}, 20:49:38 INFO - u'other-e10s_nol64': {u'talos_options': [u'--e10s'], 20:49:38 INFO - u'tests': [u'a11yr', 20:49:38 INFO - u'ts_paint', 20:49:38 INFO - u'tpaint', 20:49:38 INFO - u'sessionrestore', 20:49:38 INFO - u'sessionrestore_no_auto_restore']}, 20:49:38 INFO - u'other_l64': {u'tests': [u'a11yr', 20:49:38 INFO - u'ts_paint', 20:49:38 INFO - u'tpaint', 20:49:38 INFO - u'sessionrestore', 20:49:38 INFO - u'sessionrestore_no_auto_restore']}, 20:49:38 INFO - u'other_nol64': {u'tests': [u'a11yr', 20:49:38 INFO - u'ts_paint', 20:49:38 INFO - u'tpaint', 20:49:38 INFO - u'sessionrestore', 20:49:38 INFO - u'sessionrestore_no_auto_restore']}, 20:49:38 INFO - u'svgr': {u'tests': [u'tsvgx', 20:49:38 INFO - u'tsvgr_opacity', 20:49:38 INFO - u'tart', 20:49:38 INFO - u'tscrollx', 20:49:38 INFO - u'cart']}, 20:49:38 INFO - u'svgr-e10s': {u'talos_options': [u'--e10s'], 20:49:38 INFO - u'tests': [u'tsvgx', 20:49:38 INFO - u'tsvgr_opacity', 20:49:38 INFO - u'tart', 20:49:38 INFO - u'tscrollx', 20:49:38 INFO - u'cart']}, 20:49:38 INFO - u'tp5o': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:49:38 INFO - u'tests': [u'tp5o']}, 20:49:38 INFO - u'tp5o-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:49:38 INFO - u'talos_options': [u'--e10s'], 20:49:38 INFO - u'tests': [u'tp5o']}, 20:49:38 INFO - u'xperf': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:49:38 INFO - u'talos_options': [u'--xperf_path', 20:49:38 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:49:38 INFO - u'tests': [u'tp5n']}, 20:49:38 INFO - u'xperf-e10s': {u'pagesets_url': u'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:49:38 INFO - u'talos_options': [u'--e10s', 20:49:38 INFO - u'--xperf_path', 20:49:38 INFO - u'"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 20:49:38 INFO - u'C:/slave/talos-data/talos/xperf.config'], 20:49:38 INFO - u'tests': [u'tp5n']}}, 20:49:38 INFO - u'talos.zip': {u'path': u'', 20:49:38 INFO - u'url': u'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:49:38 INFO - Running post-action listener: _resource_record_post_action 20:49:38 INFO - ##### 20:49:38 INFO - ##### Running create-virtualenv step. 20:49:38 INFO - ##### 20:49:38 INFO - Running pre-action listener: _resource_record_pre_action 20:49:38 INFO - Running main action method: create_virtualenv 20:49:38 INFO - Creating virtualenv C:\slave\test\build/venv 20:49:38 INFO - mkdir: C:\slave\test\build\venv\Scripts 20:49:38 INFO - Copying c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll 20:49:38 WARNING - Can't copy c:/mozilla-build/python27/python27.dll to C:\slave\test\build\venv\Scripts\python27.dll: [Errno 2] No such file or directory: 'c:/mozilla-build/python27/python27.dll'! 20:49:38 INFO - Running command: ['c:/mozilla-build/python27/python.exe', 'c:/mozilla-build/buildbotve/virtualenv.py', '--no-site-packages', '--distribute', 'C:\\slave\\test\\build/venv'] in C:\slave\test\build 20:49:38 INFO - Copy/paste: c:/mozilla-build/python27/python.exe c:/mozilla-build/buildbotve/virtualenv.py --no-site-packages --distribute C:\slave\test\build/venv 20:49:41 INFO - New python executable in C:\slave\test\build/venv\Scripts\python.exe 20:49:44 INFO - Installing distribute......................................................................................................................................................................................done. 20:49:46 INFO - Return code: 0 20:49:46 INFO - Installing pip>=1.5 into virtualenv C:\slave\test\build/venv 20:49: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')]} 20:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:49: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')]} 20:49:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:49:46 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\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 0x018B3B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01904EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x017D0680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012C8B48>, '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 0x012EA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01E7F660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-001', 'USERDOMAIN': 'T-W732-IX-001', '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-001', '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', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 20:49:46 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\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\build 20:49:46 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --download-cache C:\slave\test\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 20:49:46 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 20:49:46 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 20:49:46 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 20:49:46 INFO - 'COMPUTERNAME': 'T-W732-IX-001', 20:49:46 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 20:49:46 INFO - 'CYGWINBASE': 'C:\\cygwin', 20:49:46 INFO - 'DCLOCATION': 'SCL3', 20:49:46 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 20:49:46 INFO - 'FP_NO_HOST_CHECK': 'NO', 20:49:46 INFO - 'HOMEDRIVE': 'C:', 20:49:46 INFO - 'HOMEPATH': '\\Users\\cltbld', 20:49:46 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 20:49:46 INFO - 'KTS_VERSION': '1.19c', 20:49:46 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 20:49:46 INFO - 'LOGONSERVER': '\\\\T-W732-IX-001', 20:49:46 INFO - 'MONDIR': 'C:\\Monitor_config\\', 20:49:46 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 20:49:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:49:46 INFO - 'MOZ_NO_REMOTE': '1', 20:49:46 INFO - 'NO_EM_RESTART': '1', 20:49:46 INFO - 'NUMBER_OF_PROCESSORS': '8', 20:49:46 INFO - 'OS': 'Windows_NT', 20:49:46 INFO - 'OURDRIVE': 'C:', 20:49:46 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 20:49:46 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 20:49:46 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 20:49:46 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 20:49:46 INFO - 'PROCESSOR_LEVEL': '6', 20:49:46 INFO - 'PROCESSOR_REVISION': '1e05', 20:49:46 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 20:49:46 INFO - 'PROGRAMFILES': 'C:\\Program Files', 20:49:46 INFO - 'PROMPT': '$P$G', 20:49:46 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 20:49:46 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 20:49:46 INFO - 'PUBLIC': 'C:\\Users\\Public', 20:49:46 INFO - 'PWD': 'C:\\slave\\test', 20:49:46 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 20:49:46 INFO - 'SLAVEDIR': 'C:\\slave\\', 20:49:46 INFO - 'SYSTEMDRIVE': 'C:', 20:49:46 INFO - 'SYSTEMROOT': 'C:\\windows', 20:49:46 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 20:49:46 INFO - 'TEST1': 'testie', 20:49:46 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 20:49:46 INFO - 'USERDOMAIN': 'T-W732-IX-001', 20:49:46 INFO - 'USERNAME': 'cltbld', 20:49:46 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 20:49:46 INFO - 'WINDIR': 'C:\\windows', 20:49:46 INFO - 'WINDOWS_TRACING_FLAGS': '3', 20:49:46 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 20:49:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 20:49:47 INFO - Ignoring indexes: http://pypi.python.org/simple/ 20:49:47 INFO - Downloading/unpacking pip>=1.5 20:49:47 INFO - Creating supposed download cache at C:\slave\test\build/venv\cache 20:49:51 INFO - Storing download in cache at c:\slave\test\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fpip-1.5.5.tar.gz 20:49:51 INFO - Running setup.py egg_info for package pip 20:49:51 INFO - warning: no files found matching 'pip\cacert.pem' 20:49:51 INFO - warning: no files found matching '*.html' under directory 'docs' 20:49:51 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 20:49:51 INFO - no previously-included directories found matching 'docs\_build\_sources' 20:49:51 INFO - Installing collected packages: pip 20:49:51 INFO - Found existing installation: pip 0.8.2 20:49:51 INFO - Uninstalling pip: 20:49:51 INFO - Successfully uninstalled pip 20:49:51 INFO - Running setup.py install for pip 20:49:51 INFO - warning: no files found matching 'pip\cacert.pem' 20:49:51 INFO - warning: no files found matching '*.html' under directory 'docs' 20:49:51 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs\_build' 20:49:51 INFO - no previously-included directories found matching 'docs\_build\_sources' 20:49:51 INFO - Installing pip-script.py script to C:\slave\test\build\venv\Scripts 20:49:51 INFO - Installing pip.exe script to C:\slave\test\build\venv\Scripts 20:49:51 INFO - Installing pip2.7-script.py script to C:\slave\test\build\venv\Scripts 20:49:51 INFO - Installing pip2.7.exe script to C:\slave\test\build\venv\Scripts 20:49:51 INFO - Installing pip2-script.py script to C:\slave\test\build\venv\Scripts 20:49:51 INFO - Installing pip2.exe script to C:\slave\test\build\venv\Scripts 20:49:51 INFO - Successfully installed pip 20:49:51 INFO - Cleaning up... 20:49:51 INFO - Return code: 0 20:49:51 INFO - Installing psutil>=0.7.1 into virtualenv C:\slave\test\build/venv 20:49: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')]} 20:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:49: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')]} 20:49:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:49:51 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\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 0x018B3B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01904EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x017D0680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012C8B48>, '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 0x012EA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01E7F660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-001', 'USERDOMAIN': 'T-W732-IX-001', '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-001', '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', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 20:49:51 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\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\build 20:49:51 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --download-cache C:\slave\test\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 20:49:51 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 20:49:51 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 20:49:51 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 20:49:51 INFO - 'COMPUTERNAME': 'T-W732-IX-001', 20:49:51 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 20:49:51 INFO - 'CYGWINBASE': 'C:\\cygwin', 20:49:51 INFO - 'DCLOCATION': 'SCL3', 20:49:51 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 20:49:51 INFO - 'FP_NO_HOST_CHECK': 'NO', 20:49:51 INFO - 'HOMEDRIVE': 'C:', 20:49:51 INFO - 'HOMEPATH': '\\Users\\cltbld', 20:49:51 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 20:49:51 INFO - 'KTS_VERSION': '1.19c', 20:49:51 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 20:49:51 INFO - 'LOGONSERVER': '\\\\T-W732-IX-001', 20:49:51 INFO - 'MONDIR': 'C:\\Monitor_config\\', 20:49:51 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 20:49:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:49:51 INFO - 'MOZ_NO_REMOTE': '1', 20:49:51 INFO - 'NO_EM_RESTART': '1', 20:49:51 INFO - 'NUMBER_OF_PROCESSORS': '8', 20:49:51 INFO - 'OS': 'Windows_NT', 20:49:51 INFO - 'OURDRIVE': 'C:', 20:49:51 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;', 20:49:51 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 20:49:51 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 20:49:51 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 20:49:51 INFO - 'PROCESSOR_LEVEL': '6', 20:49:51 INFO - 'PROCESSOR_REVISION': '1e05', 20:49:51 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 20:49:51 INFO - 'PROGRAMFILES': 'C:\\Program Files', 20:49:51 INFO - 'PROMPT': '$P$G', 20:49:51 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 20:49:51 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 20:49:51 INFO - 'PUBLIC': 'C:\\Users\\Public', 20:49:51 INFO - 'PWD': 'C:\\slave\\test', 20:49:51 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 20:49:51 INFO - 'SLAVEDIR': 'C:\\slave\\', 20:49:51 INFO - 'SYSTEMDRIVE': 'C:', 20:49:51 INFO - 'SYSTEMROOT': 'C:\\windows', 20:49:51 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 20:49:51 INFO - 'TEST1': 'testie', 20:49:51 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 20:49:51 INFO - 'USERDOMAIN': 'T-W732-IX-001', 20:49:51 INFO - 'USERNAME': 'cltbld', 20:49:51 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 20:49:51 INFO - 'WINDIR': 'C:\\windows', 20:49:51 INFO - 'WINDOWS_TRACING_FLAGS': '3', 20:49:51 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 20:49:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 20:49:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:49:52 INFO - Downloading/unpacking psutil>=0.7.1 20:49:52 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 20:49:52 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 20:49:53 INFO - Storing download in cache at c:\slave\test\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fpsutil-3.1.1-cp27-none-win32.whl 20:49:53 INFO - Installing collected packages: psutil 20:49:53 INFO - Successfully installed psutil 20:49:53 INFO - Cleaning up... 20:49:53 INFO - Return code: 0 20:49:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv C:\slave\test\build/venv 20:49:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:49:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:49:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:49:53 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\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 0x018B3B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01904EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x017D0680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012C8B48>, '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 0x012EA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01E7F660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-001', 'USERDOMAIN': 'T-W732-IX-001', '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-001', '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', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 20:49:54 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\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\build 20:49:54 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --download-cache C:\slave\test\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 20:49:54 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 20:49:54 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 20:49:54 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 20:49:54 INFO - 'COMPUTERNAME': 'T-W732-IX-001', 20:49:54 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 20:49:54 INFO - 'CYGWINBASE': 'C:\\cygwin', 20:49:54 INFO - 'DCLOCATION': 'SCL3', 20:49:54 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 20:49:54 INFO - 'FP_NO_HOST_CHECK': 'NO', 20:49:54 INFO - 'HOMEDRIVE': 'C:', 20:49:54 INFO - 'HOMEPATH': '\\Users\\cltbld', 20:49:54 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 20:49:54 INFO - 'KTS_VERSION': '1.19c', 20:49:54 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 20:49:54 INFO - 'LOGONSERVER': '\\\\T-W732-IX-001', 20:49:54 INFO - 'MONDIR': 'C:\\Monitor_config\\', 20:49:54 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 20:49:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:49:54 INFO - 'MOZ_NO_REMOTE': '1', 20:49:54 INFO - 'NO_EM_RESTART': '1', 20:49:54 INFO - 'NUMBER_OF_PROCESSORS': '8', 20:49:54 INFO - 'OS': 'Windows_NT', 20:49:54 INFO - 'OURDRIVE': 'C:', 20:49:54 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;', 20:49:54 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 20:49:54 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 20:49:54 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 20:49:54 INFO - 'PROCESSOR_LEVEL': '6', 20:49:54 INFO - 'PROCESSOR_REVISION': '1e05', 20:49:54 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 20:49:54 INFO - 'PROGRAMFILES': 'C:\\Program Files', 20:49:54 INFO - 'PROMPT': '$P$G', 20:49:54 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 20:49:54 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 20:49:54 INFO - 'PUBLIC': 'C:\\Users\\Public', 20:49:54 INFO - 'PWD': 'C:\\slave\\test', 20:49:54 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 20:49:54 INFO - 'SLAVEDIR': 'C:\\slave\\', 20:49:54 INFO - 'SYSTEMDRIVE': 'C:', 20:49:54 INFO - 'SYSTEMROOT': 'C:\\windows', 20:49:54 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 20:49:54 INFO - 'TEST1': 'testie', 20:49:54 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 20:49:54 INFO - 'USERDOMAIN': 'T-W732-IX-001', 20:49:54 INFO - 'USERNAME': 'cltbld', 20:49:54 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 20:49:54 INFO - 'WINDIR': 'C:\\windows', 20:49:54 INFO - 'WINDOWS_TRACING_FLAGS': '3', 20:49:54 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 20:49:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 20:49:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:49:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:49:54 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 20:49:54 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 20:49:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:49:55 INFO - Storing download in cache at c:\slave\test\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fmozsystemmonitor-0.0.tar.gz 20:49:55 INFO - Running setup.py (path:C:\slave\test\build\venv\build\mozsystemmonitor\setup.py) egg_info for package mozsystemmonitor 20:49:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in c:\slave\test\build\venv\lib\site-packages (from mozsystemmonitor==0.0.0) 20:49:55 INFO - Installing collected packages: mozsystemmonitor 20:49:55 INFO - Running setup.py install for mozsystemmonitor 20:49:55 INFO - Successfully installed mozsystemmonitor 20:49:55 INFO - Cleaning up... 20:49:55 INFO - Return code: 0 20:49:55 INFO - Installing blobuploader==1.2.4 into virtualenv C:\slave\test\build/venv 20:49: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')]} 20:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:49: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')]} 20:49:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:49:55 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\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 0x018B3B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01904EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x017D0680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012C8B48>, '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 0x012EA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01E7F660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-001', 'USERDOMAIN': 'T-W732-IX-001', '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-001', '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', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 20:49:55 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\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\build 20:49:55 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --download-cache C:\slave\test\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 20:49:55 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 20:49:55 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 20:49:55 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 20:49:55 INFO - 'COMPUTERNAME': 'T-W732-IX-001', 20:49:55 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 20:49:55 INFO - 'CYGWINBASE': 'C:\\cygwin', 20:49:55 INFO - 'DCLOCATION': 'SCL3', 20:49:55 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 20:49:55 INFO - 'FP_NO_HOST_CHECK': 'NO', 20:49:55 INFO - 'HOMEDRIVE': 'C:', 20:49:55 INFO - 'HOMEPATH': '\\Users\\cltbld', 20:49:55 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 20:49:55 INFO - 'KTS_VERSION': '1.19c', 20:49:55 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 20:49:55 INFO - 'LOGONSERVER': '\\\\T-W732-IX-001', 20:49:55 INFO - 'MONDIR': 'C:\\Monitor_config\\', 20:49:55 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 20:49:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:49:55 INFO - 'MOZ_NO_REMOTE': '1', 20:49:55 INFO - 'NO_EM_RESTART': '1', 20:49:55 INFO - 'NUMBER_OF_PROCESSORS': '8', 20:49:55 INFO - 'OS': 'Windows_NT', 20:49:55 INFO - 'OURDRIVE': 'C:', 20:49:55 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;', 20:49:55 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 20:49:55 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 20:49:55 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 20:49:55 INFO - 'PROCESSOR_LEVEL': '6', 20:49:55 INFO - 'PROCESSOR_REVISION': '1e05', 20:49:55 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 20:49:55 INFO - 'PROGRAMFILES': 'C:\\Program Files', 20:49:55 INFO - 'PROMPT': '$P$G', 20:49:55 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 20:49:55 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 20:49:55 INFO - 'PUBLIC': 'C:\\Users\\Public', 20:49:55 INFO - 'PWD': 'C:\\slave\\test', 20:49:55 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 20:49:55 INFO - 'SLAVEDIR': 'C:\\slave\\', 20:49:55 INFO - 'SYSTEMDRIVE': 'C:', 20:49:55 INFO - 'SYSTEMROOT': 'C:\\windows', 20:49:55 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 20:49:55 INFO - 'TEST1': 'testie', 20:49:55 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 20:49:55 INFO - 'USERDOMAIN': 'T-W732-IX-001', 20:49:55 INFO - 'USERNAME': 'cltbld', 20:49:55 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 20:49:55 INFO - 'WINDIR': 'C:\\windows', 20:49:55 INFO - 'WINDOWS_TRACING_FLAGS': '3', 20:49:55 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 20:49:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 20:49:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:49:56 INFO - Downloading/unpacking blobuploader==1.2.4 20:49:56 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 20:49:56 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 20:49:57 INFO - Downloading blobuploader-1.2.4.tar.gz 20:49:57 INFO - Storing download in cache at c:\slave\test\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fblobuploader-1.2.4.tar.gz 20:49:57 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blobuploader\setup.py) egg_info for package blobuploader 20:49:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:49:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:49:57 INFO - Storing download in cache at c:\slave\test\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2frequests-1.2.3.tar.gz 20:49:57 INFO - Running setup.py (path:C:\slave\test\build\venv\build\requests\setup.py) egg_info for package requests 20:49:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:49:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:49:57 INFO - Downloading docopt-0.6.1.tar.gz 20:49:57 INFO - Storing download in cache at c:\slave\test\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fdocopt-0.6.1.tar.gz 20:49:57 INFO - Running setup.py (path:C:\slave\test\build\venv\build\docopt\setup.py) egg_info for package docopt 20:49:57 INFO - Installing collected packages: blobuploader, requests, docopt 20:49:57 INFO - Running setup.py install for blobuploader 20:49:58 INFO - Running setup.py install for requests 20:49:58 INFO - Running setup.py install for docopt 20:49:59 INFO - Successfully installed blobuploader requests docopt 20:49:59 INFO - Cleaning up... 20:50:00 INFO - Return code: 0 20:50:00 INFO - Installing None into virtualenv C:\slave\test\build/venv 20:50:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:50:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:50:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:50:00 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--no-deps', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test\\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 0x018B3B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01904EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x017D0680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012C8B48>, '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 0x012EA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01E7F660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-001', 'USERDOMAIN': 'T-W732-IX-001', '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-001', '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', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 20:50:00 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--no-deps', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test\\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\build\tests\config 20:50:00 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --no-deps --download-cache C:\slave\test\build/venv\cache --timeout 120 -r C:\slave\test\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 20:50:00 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 20:50:00 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 20:50:00 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 20:50:00 INFO - 'COMPUTERNAME': 'T-W732-IX-001', 20:50:00 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 20:50:00 INFO - 'CYGWINBASE': 'C:\\cygwin', 20:50:00 INFO - 'DCLOCATION': 'SCL3', 20:50:00 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 20:50:00 INFO - 'FP_NO_HOST_CHECK': 'NO', 20:50:00 INFO - 'HOMEDRIVE': 'C:', 20:50:00 INFO - 'HOMEPATH': '\\Users\\cltbld', 20:50:00 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 20:50:00 INFO - 'KTS_VERSION': '1.19c', 20:50:00 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 20:50:00 INFO - 'LOGONSERVER': '\\\\T-W732-IX-001', 20:50:00 INFO - 'MONDIR': 'C:\\Monitor_config\\', 20:50:00 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 20:50:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:50:00 INFO - 'MOZ_NO_REMOTE': '1', 20:50:00 INFO - 'NO_EM_RESTART': '1', 20:50:00 INFO - 'NUMBER_OF_PROCESSORS': '8', 20:50:00 INFO - 'OS': 'Windows_NT', 20:50:00 INFO - 'OURDRIVE': 'C:', 20:50:00 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 20:50:00 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 20:50:00 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 20:50:00 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 20:50:00 INFO - 'PROCESSOR_LEVEL': '6', 20:50:00 INFO - 'PROCESSOR_REVISION': '1e05', 20:50:00 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 20:50:00 INFO - 'PROGRAMFILES': 'C:\\Program Files', 20:50:00 INFO - 'PROMPT': '$P$G', 20:50:00 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 20:50:00 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 20:50:00 INFO - 'PUBLIC': 'C:\\Users\\Public', 20:50:00 INFO - 'PWD': 'C:\\slave\\test', 20:50:00 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 20:50:00 INFO - 'SLAVEDIR': 'C:\\slave\\', 20:50:00 INFO - 'SYSTEMDRIVE': 'C:', 20:50:00 INFO - 'SYSTEMROOT': 'C:\\windows', 20:50:00 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 20:50:00 INFO - 'TEST1': 'testie', 20:50:00 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 20:50:00 INFO - 'USERDOMAIN': 'T-W732-IX-001', 20:50:00 INFO - 'USERNAME': 'cltbld', 20:50:00 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 20:50:00 INFO - 'WINDIR': 'C:\\windows', 20:50:00 INFO - 'WINDOWS_TRACING_FLAGS': '3', 20:50:00 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 20:50:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 20:50:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:50:00 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 20:50:00 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-f60skt-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 20:50:00 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 20:50:00 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-fxsmjg-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 20:50:00 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 20:50:00 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-bbcbyw-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 20:50:00 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 20:50:01 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-whbaon-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 20:50:01 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 20:50:01 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-71ej4k-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 20:50:01 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 20:50:01 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-yi9cr2-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 20:50:01 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 20:50:01 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-y9ordq-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 20:50:01 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 20:50:01 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-s44d8y-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 20:50:01 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 20:50:01 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-mvcl8n-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 20:50:02 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 20:50:02 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-fj2yak-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 20:50:02 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 20:50:02 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-zoyi10-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 20:50:02 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 20:50:02 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-8jhfvb-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 20:50:02 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 20:50:02 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-rrwhca-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 20:50:02 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 20:50:02 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-ztacgz-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 20:50:02 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 20:50:02 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-rhk7sd-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 20:50:02 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 20:50:02 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-pdcf3f-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 20:50:03 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 20:50:03 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-jp1ljn-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 20:50:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:50:03 INFO - Running setup.py install for manifestparser 20:50:03 INFO - Installing manifestparser-script.py script to C:\slave\test\build\venv\Scripts 20:50:03 INFO - Installing manifestparser.exe script to C:\slave\test\build\venv\Scripts 20:50:03 INFO - Running setup.py install for mozcrash 20:50:04 INFO - Running setup.py install for mozdebug 20:50:04 INFO - Running setup.py install for mozdevice 20:50:04 INFO - Installing sutini-script.py script to C:\slave\test\build\venv\Scripts 20:50:04 INFO - Installing sutini.exe script to C:\slave\test\build\venv\Scripts 20:50:04 INFO - Installing dm-script.py script to C:\slave\test\build\venv\Scripts 20:50:04 INFO - Installing dm.exe script to C:\slave\test\build\venv\Scripts 20:50:05 INFO - Running setup.py install for mozfile 20:50:05 INFO - Running setup.py install for mozhttpd 20:50:05 INFO - Installing mozhttpd-script.py script to C:\slave\test\build\venv\Scripts 20:50:05 INFO - Installing mozhttpd.exe script to C:\slave\test\build\venv\Scripts 20:50:05 INFO - Running setup.py install for mozinfo 20:50:06 INFO - Installing mozinfo-script.py script to C:\slave\test\build\venv\Scripts 20:50:06 INFO - Installing mozinfo.exe script to C:\slave\test\build\venv\Scripts 20:50:06 INFO - Running setup.py install for mozInstall 20:50:06 INFO - Installing moz_remove_from_system-script.py script to C:\slave\test\build\venv\Scripts 20:50:06 INFO - Installing moz_remove_from_system.exe script to C:\slave\test\build\venv\Scripts 20:50:06 INFO - Installing mozuninstall-script.py script to C:\slave\test\build\venv\Scripts 20:50:06 INFO - Installing mozuninstall.exe script to C:\slave\test\build\venv\Scripts 20:50:06 INFO - Installing mozinstall-script.py script to C:\slave\test\build\venv\Scripts 20:50:06 INFO - Installing mozinstall.exe script to C:\slave\test\build\venv\Scripts 20:50:06 INFO - Installing moz_add_to_system-script.py script to C:\slave\test\build\venv\Scripts 20:50:06 INFO - Installing moz_add_to_system.exe script to C:\slave\test\build\venv\Scripts 20:50:06 INFO - Running setup.py install for mozleak 20:50:06 INFO - Running setup.py install for mozlog 20:50:07 INFO - Installing structlog-script.py script to C:\slave\test\build\venv\Scripts 20:50:07 INFO - Installing structlog.exe script to C:\slave\test\build\venv\Scripts 20:50:08 INFO - Running setup.py install for moznetwork 20:50:08 INFO - Installing moznetwork-script.py script to C:\slave\test\build\venv\Scripts 20:50:08 INFO - Installing moznetwork.exe script to C:\slave\test\build\venv\Scripts 20:50:08 INFO - Running setup.py install for mozprocess 20:50:09 INFO - Running setup.py install for mozprofile 20:50:09 INFO - Installing mozprofile-script.py script to C:\slave\test\build\venv\Scripts 20:50:09 INFO - Installing mozprofile.exe script to C:\slave\test\build\venv\Scripts 20:50:09 INFO - Installing diff-profiles-script.py script to C:\slave\test\build\venv\Scripts 20:50:09 INFO - Installing diff-profiles.exe script to C:\slave\test\build\venv\Scripts 20:50:09 INFO - Installing view-profile-script.py script to C:\slave\test\build\venv\Scripts 20:50:09 INFO - Installing view-profile.exe script to C:\slave\test\build\venv\Scripts 20:50:09 INFO - Running setup.py install for mozrunner 20:50:10 INFO - Installing mozrunner-script.py script to C:\slave\test\build\venv\Scripts 20:50:10 INFO - Installing mozrunner.exe script to C:\slave\test\build\venv\Scripts 20:50:10 INFO - Running setup.py install for mozscreenshot 20:50:10 INFO - Running setup.py install for moztest 20:50:11 INFO - Running setup.py install for mozversion 20:50:11 INFO - Installing mozversion-script.py script to C:\slave\test\build\venv\Scripts 20:50:11 INFO - Installing mozversion.exe script to C:\slave\test\build\venv\Scripts 20:50:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:50:11 INFO - Cleaning up... 20:50:11 INFO - Return code: 0 20:50:11 INFO - Installing None into virtualenv C:\slave\test\build/venv 20:50: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')]} 20:50:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:50: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')]} 20:50:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:50:11 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test\\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 0x018B3B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01904EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x017D0680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012C8B48>, '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 0x012EA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01E7F660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build\\tests\\config', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-001', 'USERDOMAIN': 'T-W732-IX-001', '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-001', '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', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 20:50:11 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test\\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\build\tests\config 20:50:11 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --download-cache C:\slave\test\build/venv\cache --timeout 120 -r C:\slave\test\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 20:50:11 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 20:50:11 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 20:50:11 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 20:50:11 INFO - 'COMPUTERNAME': 'T-W732-IX-001', 20:50:11 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 20:50:11 INFO - 'CYGWINBASE': 'C:\\cygwin', 20:50:11 INFO - 'DCLOCATION': 'SCL3', 20:50:11 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 20:50:11 INFO - 'FP_NO_HOST_CHECK': 'NO', 20:50:11 INFO - 'HOMEDRIVE': 'C:', 20:50:11 INFO - 'HOMEPATH': '\\Users\\cltbld', 20:50:11 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 20:50:11 INFO - 'KTS_VERSION': '1.19c', 20:50:11 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 20:50:11 INFO - 'LOGONSERVER': '\\\\T-W732-IX-001', 20:50:11 INFO - 'MONDIR': 'C:\\Monitor_config\\', 20:50:11 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 20:50:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:50:11 INFO - 'MOZ_NO_REMOTE': '1', 20:50:11 INFO - 'NO_EM_RESTART': '1', 20:50:11 INFO - 'NUMBER_OF_PROCESSORS': '8', 20:50:11 INFO - 'OS': 'Windows_NT', 20:50:11 INFO - 'OURDRIVE': 'C:', 20:50: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;', 20:50:11 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 20:50:11 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 20:50:11 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 20:50:11 INFO - 'PROCESSOR_LEVEL': '6', 20:50:11 INFO - 'PROCESSOR_REVISION': '1e05', 20:50:11 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 20:50:11 INFO - 'PROGRAMFILES': 'C:\\Program Files', 20:50:11 INFO - 'PROMPT': '$P$G', 20:50:11 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 20:50:11 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 20:50:11 INFO - 'PUBLIC': 'C:\\Users\\Public', 20:50:11 INFO - 'PWD': 'C:\\slave\\test', 20:50:11 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 20:50:11 INFO - 'SLAVEDIR': 'C:\\slave\\', 20:50:11 INFO - 'SYSTEMDRIVE': 'C:', 20:50:11 INFO - 'SYSTEMROOT': 'C:\\windows', 20:50:11 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 20:50:11 INFO - 'TEST1': 'testie', 20:50:11 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 20:50:11 INFO - 'USERDOMAIN': 'T-W732-IX-001', 20:50:11 INFO - 'USERNAME': 'cltbld', 20:50:11 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 20:50:11 INFO - 'WINDIR': 'C:\\windows', 20:50:11 INFO - 'WINDOWS_TRACING_FLAGS': '3', 20:50:11 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 20:50:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 20:50:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:50:11 INFO - Unpacking c:\slave\test\build\tests\mozbase\manifestparser 20:50:12 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-znybpe-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/manifestparser 20:50:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///C:/slave/test/build/tests/mozbase/manifestparser in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 1)) 20:50:12 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozcrash 20:50:12 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-69q0vb-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozcrash 20:50:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///C:/slave/test/build/tests/mozbase/mozcrash in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2)) 20:50:12 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdebug 20:50:12 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-gsnmgo-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdebug 20:50:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///C:/slave/test/build/tests/mozbase/mozdebug in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 3)) 20:50:12 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozdevice 20:50:12 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-kqoan5-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozdevice 20:50:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 from file:///C:/slave/test/build/tests/mozbase/mozdevice in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4)) 20:50:12 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozfile 20:50:12 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-wm9rql-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozfile 20:50:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///C:/slave/test/build/tests/mozbase/mozfile in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 5)) 20:50:12 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozhttpd 20:50:12 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-3pwqxi-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozhttpd 20:50:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///C:/slave/test/build/tests/mozbase/mozhttpd in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 6)) 20:50:12 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinfo 20:50:12 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-ezfgkp-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinfo 20:50:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 from file:///C:/slave/test/build/tests/mozbase/mozinfo in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 7)) 20:50:12 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozinstall 20:50:12 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-qiicch-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozinstall 20:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///C:/slave/test/build/tests/mozbase/mozinstall in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 8)) 20:50:13 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozleak 20:50:13 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-bj5bli-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozleak 20:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///C:/slave/test/build/tests/mozbase/mozleak in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 9)) 20:50:13 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozlog 20:50:13 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-xlbph_-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozlog 20:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///C:/slave/test/build/tests/mozbase/mozlog in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10)) 20:50:13 INFO - Unpacking c:\slave\test\build\tests\mozbase\moznetwork 20:50:13 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-njfhyi-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moznetwork 20:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///C:/slave/test/build/tests/mozbase/moznetwork in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 11)) 20:50:13 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprocess 20:50:13 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-pgscl5-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprocess 20:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///C:/slave/test/build/tests/mozbase/mozprocess in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 12)) 20:50:13 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozprofile 20:50:13 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-bc4xhq-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozprofile 20:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///C:/slave/test/build/tests/mozbase/mozprofile in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 13)) 20:50:13 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozrunner 20:50:13 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-6o9az8-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozrunner 20:50:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///C:/slave/test/build/tests/mozbase/mozrunner in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 14)) 20:50:14 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozscreenshot 20:50:14 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-3mnkp4-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozscreenshot 20:50:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///C:/slave/test/build/tests/mozbase/mozscreenshot in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 15)) 20:50:14 INFO - Unpacking c:\slave\test\build\tests\mozbase\moztest 20:50:14 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-abtsyb-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/moztest 20:50:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///C:/slave/test/build/tests/mozbase/moztest in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 16)) 20:50:14 INFO - Unpacking c:\slave\test\build\tests\mozbase\mozversion 20:50:14 INFO - Running setup.py (path:c:\users\cltbld\appdata\local\temp\pip-ott1_n-build\setup.py) egg_info for package from file:///C:/slave/test/build/tests/mozbase/mozversion 20:50:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///C:/slave/test/build/tests/mozbase/mozversion in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 17)) 20:50:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==0.16->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2)) 20:50:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash==0.16->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 2)) 20:50:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in c:\slave\test\build\venv\lib\site-packages (from mozdebug==0.1->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 3)) 20:50:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test\build\venv\lib\site-packages (from mozdevice==0.46->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4)) 20:50:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in c:\slave\test\build\venv\lib\site-packages (from mozdevice==0.46->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 4)) 20:50:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r C:\slave\test\build\tests\config\mozbase_requirements.txt (line 10)) 20:50: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 20:50: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 20:50:15 INFO - Downloading blessings-1.5.1.tar.gz 20:50:15 INFO - Storing download in cache at c:\slave\test\build\venv\cache\http%3a%2f%2fpypi.pvt.build.mozilla.org%2fpub%2fblessings-1.5.1.tar.gz 20:50:15 INFO - Running setup.py (path:C:\slave\test\build\venv\build\blessings\setup.py) egg_info for package blessings 20:50:15 INFO - Installing collected packages: blessings 20:50:15 INFO - Running setup.py install for blessings 20:50:16 INFO - Successfully installed blessings 20:50:16 INFO - Cleaning up... 20:50:18 INFO - Return code: 0 20:50:18 INFO - Done creating virtualenv C:\slave\test\build/venv. 20:50:18 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 20:50:18 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 20:50:19 INFO - Reading from file tmpfile_stdout 20:50:19 INFO - Using _rmtree_windows ... 20:50:19 INFO - Using _rmtree_windows ... 20:50:19 INFO - Current package versions: 20:50:19 INFO - blessings == 1.5.1 20:50:19 INFO - blobuploader == 1.2.4 20:50:19 INFO - docopt == 0.6.1 20:50:19 INFO - manifestparser == 1.1 20:50:19 INFO - mozInstall == 1.12 20:50:19 INFO - mozcrash == 0.16 20:50:19 INFO - mozdebug == 0.1 20:50:19 INFO - mozdevice == 0.46 20:50:19 INFO - mozfile == 1.2 20:50:19 INFO - mozhttpd == 0.7 20:50:19 INFO - mozinfo == 0.8 20:50:19 INFO - mozleak == 0.1 20:50:19 INFO - mozlog == 3.0 20:50:19 INFO - moznetwork == 0.27 20:50:19 INFO - mozprocess == 0.22 20:50:19 INFO - mozprofile == 0.27 20:50:19 INFO - mozrunner == 6.11 20:50:19 INFO - mozscreenshot == 0.1 20:50:19 INFO - mozsystemmonitor == 0.0 20:50:19 INFO - moztest == 0.7 20:50:19 INFO - mozversion == 1.4 20:50:19 INFO - psutil == 3.1.1 20:50:19 INFO - requests == 1.2.3 20:50:19 INFO - Installing None into virtualenv C:\slave\test\build/venv 20:50:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:50:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:50:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:50:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:50:19 INFO - retry: Calling run_command with args: [['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test\\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 0x018B3B10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x01904EA8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x017D0680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012C8B48>, '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 0x012EA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01E7F660>, 'level': 'critical'}], 'cwd': 'C:\\slave\\test\\build\\tests\\talos', 'env': {'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 'TEST1': 'testie', 'COMPUTERNAME': 'T-W732-IX-001', 'USERDOMAIN': 'T-W732-IX-001', '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-001', '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', 'PROCESSOR_LEVEL': '6', 'KTS_HOME': 'C:\\Program Files\\KTS', 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'USERPROFILE': 'C:\\Users\\cltbld', 'OS': 'Windows_NT', 'PUBLIC': 'C:\\Users\\Public', 'WINDIR': 'C:\\windows'}}, attempt #1 20:50:19 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'install', '--download-cache', 'C:\\slave\\test\\build/venv\\cache', '--timeout', '120', '-r', 'C:\\slave\\test\\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\build\tests\talos 20:50:19 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip install --download-cache C:\slave\test\build/venv\cache --timeout 120 -r C:\slave\test\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 20:50:19 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 20:50:19 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 20:50:19 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 20:50:19 INFO - 'COMPUTERNAME': 'T-W732-IX-001', 20:50:19 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 20:50:19 INFO - 'CYGWINBASE': 'C:\\cygwin', 20:50:19 INFO - 'DCLOCATION': 'SCL3', 20:50:19 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 20:50:19 INFO - 'FP_NO_HOST_CHECK': 'NO', 20:50:19 INFO - 'HOMEDRIVE': 'C:', 20:50:19 INFO - 'HOMEPATH': '\\Users\\cltbld', 20:50:19 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 20:50:19 INFO - 'KTS_VERSION': '1.19c', 20:50:19 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 20:50:19 INFO - 'LOGONSERVER': '\\\\T-W732-IX-001', 20:50:19 INFO - 'MONDIR': 'C:\\Monitor_config\\', 20:50:19 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 20:50:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:50:19 INFO - 'MOZ_NO_REMOTE': '1', 20:50:19 INFO - 'NO_EM_RESTART': '1', 20:50:19 INFO - 'NUMBER_OF_PROCESSORS': '8', 20:50:19 INFO - 'OS': 'Windows_NT', 20:50:19 INFO - 'OURDRIVE': 'C:', 20:50:19 INFO - 'PATH': 'C:\\Python24;C:\\Python24\\Scripts;C:\\cygwin\\bin;C:\\WINDOWS\\System32;C:\\program files\\gnuwin32\\bin;C:\\WINDOWS;C:\\mozilla-build\\msys\\bin;C:\\mozilla-build\\python27;C:\\mozilla-build\\python27\\Scripts;C:\\mozilla-build\\info-zip;C:\\mozilla-build\\wget;C:\\Program Files (x86)\\GnuWin32\\bin;', 20:50:19 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 20:50:19 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 20:50:19 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 20:50:19 INFO - 'PROCESSOR_LEVEL': '6', 20:50:19 INFO - 'PROCESSOR_REVISION': '1e05', 20:50:19 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 20:50:19 INFO - 'PROGRAMFILES': 'C:\\Program Files', 20:50:19 INFO - 'PROMPT': '$P$G', 20:50:19 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 20:50:19 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 20:50:19 INFO - 'PUBLIC': 'C:\\Users\\Public', 20:50:19 INFO - 'PWD': 'C:\\slave\\test', 20:50:19 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 20:50:19 INFO - 'SLAVEDIR': 'C:\\slave\\', 20:50:19 INFO - 'SYSTEMDRIVE': 'C:', 20:50:19 INFO - 'SYSTEMROOT': 'C:\\windows', 20:50:19 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 20:50:19 INFO - 'TEST1': 'testie', 20:50:19 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 20:50:19 INFO - 'USERDOMAIN': 'T-W732-IX-001', 20:50:19 INFO - 'USERNAME': 'cltbld', 20:50:19 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 20:50:19 INFO - 'WINDIR': 'C:\\windows', 20:50:19 INFO - 'WINDOWS_TRACING_FLAGS': '3', 20:50:19 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 20:50:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 20:50:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:50:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 1)) 20:50:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 2)) 20:50:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 3)) 20:50:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 4)) 20:50:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 5)) 20:50:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 6)) 20:50:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 7)) 20:50:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in c:\slave\test\build\venv\lib\site-packages (from -r C:\slave\test\build\tests\talos\requirements.txt (line 8)) 20:50:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in c:\slave\test\build\venv\lib\site-packages (from mozcrash>=0.15->-r C:\slave\test\build\tests\talos\requirements.txt (line 1)) 20:50:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in c:\slave\test\build\venv\lib\site-packages (from mozhttpd>=0.7->-r C:\slave\test\build\tests\talos\requirements.txt (line 3)) 20:50:19 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in c:\slave\test\build\venv\lib\site-packages (from mozlog>=3.0->mozcrash>=0.15->-r C:\slave\test\build\tests\talos\requirements.txt (line 1)) 20:50:19 INFO - Cleaning up... 20:50:19 INFO - Return code: 0 20:50:19 INFO - Running post-action listener: _resource_record_post_action 20:50:19 INFO - Running post-action listener: _start_resource_monitoring 20:50:19 INFO - Starting resource monitoring. 20:50:19 INFO - ##### 20:50:19 INFO - ##### Running install step. 20:50:19 INFO - ##### 20:50:19 INFO - Running pre-action listener: _resource_record_pre_action 20:50:19 INFO - Running main action method: install 20:50:19 INFO - Getting output from command: ['C:\\slave\\test\\build\\venv\\Scripts\\pip', 'freeze'] 20:50:19 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\pip freeze 20:50:20 INFO - Reading from file tmpfile_stdout 20:50:20 INFO - Using _rmtree_windows ... 20:50:20 INFO - Using _rmtree_windows ... 20:50:20 INFO - Detecting whether we're running mozinstall >=1.0... 20:50:20 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', '-h'] 20:50:20 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py -h 20:50:20 INFO - Reading from file tmpfile_stdout 20:50:20 INFO - Output received: 20:50:20 INFO - Usage: mozinstall-script.py [options] installer 20:50:20 INFO - Options: 20:50:20 INFO - -h, --help show this help message and exit 20:50:20 INFO - -d DEST, --destination=DEST 20:50:20 INFO - Directory to install application into. [default: 20:50:20 INFO - "C:\slave\test"] 20:50:20 INFO - --app=APP Application being installed. [default: firefox] 20:50:20 INFO - Using _rmtree_windows ... 20:50:20 INFO - Using _rmtree_windows ... 20:50:20 INFO - mkdir: C:\slave\test\build\application 20:50:20 INFO - Getting output from command: ['C:\\slave\\test\\build/venv/scripts/python', 'C:\\slave\\test\\build/venv/scripts/mozinstall-script.py', 'C:\\slave\\test\\build\\firefox-44.0a1.en-US.win32.zip', '--destination', 'C:\\slave\\test\\build\\application'] 20:50:20 INFO - Copy/paste: C:\slave\test\build/venv/scripts/python C:\slave\test\build/venv/scripts/mozinstall-script.py C:\slave\test\build\firefox-44.0a1.en-US.win32.zip --destination C:\slave\test\build\application 20:50:21 INFO - Reading from file tmpfile_stdout 20:50:21 INFO - Output received: 20:50:21 INFO - C:\slave\test\build\application\firefox\firefox.exe 20:50:21 INFO - Using _rmtree_windows ... 20:50:21 INFO - Using _rmtree_windows ... 20:50:21 INFO - Running post-action listener: _resource_record_post_action 20:50:21 INFO - ##### 20:50:21 INFO - ##### Running run-tests step. 20:50:21 INFO - ##### 20:50:21 INFO - Running pre-action listener: _resource_record_pre_action 20:50:21 INFO - Running main action method: run_tests 20:50:21 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', '--version'] 20:50:21 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python --version 20:50:21 INFO - Python 2.7.3 20:50:21 INFO - Return code: 0 20:50:21 INFO - grabbing minidump binary from tooltool 20:50:21 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')]} 20:50:21 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\\build\\tests\\config/tooltool-manifests/win32/releng.manifest', '-o'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x012C8B48>, '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 0x012EA700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x01E7F660>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': 'C:\\slave\\test\\build', 'privileged': False}, attempt #1 20:50:21 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\\build\\tests\\config/tooltool-manifests/win32/releng.manifest', '-o'] in C:\slave\test\build 20:50:21 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\build\tests\config/tooltool-manifests/win32/releng.manifest -o 20:50:21 INFO - INFO - Attempting to fetch from 'https://api.pub.build.mozilla.org/tooltool/'... 20:50:23 INFO - INFO - File win32-minidump_stackwalk.exe fetched from https://api.pub.build.mozilla.org/tooltool/ as C:\slave\test\build\tmpmit6wd 20:50:23 INFO - INFO - File integrity verified, renaming tmpmit6wd to win32-minidump_stackwalk.exe 20:50:23 INFO - Return code: 0 20:50:23 INFO - Chmoding C:\slave\test\build\win32-minidump_stackwalk.exe to 0755 20:50:23 INFO - mkdir: C:\slave\test\build\blobber_upload_dir 20:50:23 INFO - ENV: MOZ_UPLOAD_DIR is now C:\slave\test\build\blobber_upload_dir 20:50:23 INFO - ENV: MINIDUMP_STACKWALK is now C:\slave\test\build\win32-minidump_stackwalk.exe 20:50:23 INFO - ENV: MINIDUMP_SAVE_PATH is now C:\slave\test\build\blobber_upload_dir 20:50:23 INFO - Running command: ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FcMX6egQQlu8cGEfju8hZQ/artifacts/public/build/firefox-44.0a1.en-US.win32.crashreporter-symbols.zip', '--title', 'T-W732-IX-001', '--webServer', 'localhost'] in C:\slave\test\build 20:50:23 INFO - Copy/paste: C:\slave\test\build\venv\Scripts\python C:\slave\test\build\tests\talos\talos\run_tests.py --debug --branchName Mozilla-Inbound-Non-PGO --suite dromaeojs --executablePath C:\slave\test\build\application\firefox\firefox --symbolsPath https://queue.taskcluster.net/v1/task/FcMX6egQQlu8cGEfju8hZQ/artifacts/public/build/firefox-44.0a1.en-US.win32.crashreporter-symbols.zip --title T-W732-IX-001 --webServer localhost 20:50:23 INFO - Using env: {'ALLUSERSPROFILE': 'C:\\ProgramData', 20:50:23 INFO - 'APPDATA': 'C:\\Users\\cltbld\\AppData\\Roaming', 20:50:23 INFO - 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 20:50:23 INFO - 'COMPUTERNAME': 'T-W732-IX-001', 20:50:23 INFO - 'COMSPEC': 'C:\\windows\\system32\\cmd.exe', 20:50:23 INFO - 'CYGWINBASE': 'C:\\cygwin', 20:50:23 INFO - 'DCLOCATION': 'SCL3', 20:50:23 INFO - 'DNSSUFFIX': 'wintest.releng.scl3.mozilla.com', 20:50:23 INFO - 'FP_NO_HOST_CHECK': 'NO', 20:50:23 INFO - 'HOMEDRIVE': 'C:', 20:50:23 INFO - 'HOMEPATH': '\\Users\\cltbld', 20:50:23 INFO - 'KTS_HOME': 'C:\\Program Files\\KTS', 20:50:23 INFO - 'KTS_VERSION': '1.19c', 20:50:23 INFO - 'LOCALAPPDATA': 'C:\\Users\\cltbld\\AppData\\Local', 20:50:23 INFO - 'LOGONSERVER': '\\\\T-W732-IX-001', 20:50:23 INFO - 'MINIDUMP_SAVE_PATH': 'C:\\slave\\test\\build\\blobber_upload_dir', 20:50:23 INFO - 'MINIDUMP_STACKWALK': 'C:\\slave\\test\\build\\win32-minidump_stackwalk.exe', 20:50:23 INFO - 'MONDIR': 'C:\\Monitor_config\\', 20:50:23 INFO - 'MOZBUILDDIR': 'C:\\mozilla-build\\', 20:50:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:50:23 INFO - 'MOZ_NO_REMOTE': '1', 20:50:23 INFO - 'MOZ_UPLOAD_DIR': 'C:\\slave\\test\\build\\blobber_upload_dir', 20:50:23 INFO - 'NO_EM_RESTART': '1', 20:50:23 INFO - 'NUMBER_OF_PROCESSORS': '8', 20:50:23 INFO - 'OS': 'Windows_NT', 20:50:23 INFO - 'OURDRIVE': 'C:', 20:50:23 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;', 20:50:23 INFO - 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 20:50:23 INFO - 'PROCESSOR_ARCHITECTURE': 'x86', 20:50:23 INFO - 'PROCESSOR_IDENTIFIER': 'x86 Family 6 Model 30 Stepping 5, GenuineIntel', 20:50:23 INFO - 'PROCESSOR_LEVEL': '6', 20:50:23 INFO - 'PROCESSOR_REVISION': '1e05', 20:50:23 INFO - 'PROGRAMDATA': 'C:\\ProgramData', 20:50:23 INFO - 'PROGRAMFILES': 'C:\\Program Files', 20:50:23 INFO - 'PROMPT': '$P$G', 20:50:23 INFO - 'PROPERTIES_FILE': 'C:\\slave\\test/buildprops.json', 20:50:23 INFO - 'PSMODULEPATH': 'C:\\windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 20:50:23 INFO - 'PUBLIC': 'C:\\Users\\Public', 20:50:23 INFO - 'PWD': 'C:\\slave\\test', 20:50:23 INFO - 'PYTHONPATH': 'C:\\slave\\test\\build\\tests\\talos', 20:50:23 INFO - 'RUNLOGFILE': 'C:\\slave\\\\runslave.log', 20:50:23 INFO - 'SLAVEDIR': 'C:\\slave\\', 20:50:23 INFO - 'SYSTEMDRIVE': 'C:', 20:50:23 INFO - 'SYSTEMROOT': 'C:\\windows', 20:50:23 INFO - 'TEMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 20:50:23 INFO - 'TEST1': 'testie', 20:50:23 INFO - 'TMP': 'C:\\Users\\cltbld\\AppData\\Local\\Temp', 20:50:23 INFO - 'USERDOMAIN': 'T-W732-IX-001', 20:50:23 INFO - 'USERNAME': 'cltbld', 20:50:23 INFO - 'USERPROFILE': 'C:\\Users\\cltbld', 20:50:23 INFO - 'WINDIR': 'C:\\windows', 20:50:23 INFO - 'WINDOWS_TRACING_FLAGS': '3', 20:50:23 INFO - 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 20:50:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn'} 20:50:23 INFO - Calling ['C:\\slave\\test\\build\\venv\\Scripts\\python', 'C:\\slave\\test\\build\\tests\\talos\\talos\\run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', 'C:\\slave\\test\\build\\application\\firefox\\firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FcMX6egQQlu8cGEfju8hZQ/artifacts/public/build/firefox-44.0a1.en-US.win32.crashreporter-symbols.zip', '--title', 'T-W732-IX-001', '--webServer', 'localhost'] with output_timeout 3600 20:50:24 INFO - mozversion INFO | application_buildid: 20151026192222 20:50:24 INFO - mozversion INFO | application_changeset: 0dd4a8dd56181365169aee7c6928cca302f9baf2 20:50:24 INFO - mozversion INFO | application_display_name: Nightly 20:50:24 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:50:24 INFO - mozversion INFO | application_name: Firefox 20:50:24 INFO - mozversion INFO | application_remotingname: firefox 20:50:24 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 20:50:24 INFO - mozversion INFO | application_vendor: Mozilla 20:50:24 INFO - mozversion INFO | application_version: 44.0a1 20:50:24 INFO - mozversion INFO | platform_buildid: 20151026192222 20:50:24 INFO - mozversion INFO | platform_changeset: 0dd4a8dd56181365169aee7c6928cca302f9baf2 20:50:24 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 20:50:24 INFO - mozversion INFO | platform_version: 44.0a1 20:50:24 INFO - 2015-10-26 20:50:24,647 DEBUG : using testdate: 1445917824 20:50:24 INFO - 2015-10-26 20:50:24,647 DEBUG : actual date: 1445917824 20:50:24 INFO - 2015-10-26 20:50:24,770 INFO : starting webserver on 'localhost:49794' 20:50:24 INFO - 2015-10-26 20:50:24,773 INFO : Starting test suite T-W732-IX-001 20:50:24 INFO - 2015-10-26 20:50:24,773 INFO : Starting test dromaeo_css 20:50:24 INFO - 2015-10-26 20:50:24,773 DEBUG : operating with platform_type : w7_ 20:50:24 INFO - 2015-10-26 20:50:24,773 INFO : Initialising browser for dromaeo_css test... 20:50:24 INFO - 2015-10-26 20:50:24,881 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld\appdata\local\temp\tmp1oinqx\profile http://localhost:49794/getInfo.html 20:50:32 INFO - 2015-10-26 20:50:32,917 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:50:32 INFO - 2015-10-26 20:50:32,917 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:50:32 INFO - 2015-10-26 20:50:32,917 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1008/673 20:50:32 INFO - 2015-10-26 20:50:32,917 DEBUG : BROWSER_OUTPUT: __metrics 20:50:32 INFO - 2015-10-26 20:50:32,992 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:50:33 INFO - 2015-10-26 20:50:33,947 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 20:50:34 INFO - 2015-10-26 20:50:34,823 INFO : Browser initialized. 20:50:34 INFO - 2015-10-26 20:50:34,823 INFO : Running cycle 1/1 for dromaeo_css test... 20:50:34 INFO - 2015-10-26 20:50:34,823 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld\appdata\local\temp\tmp1oinqx\profile -tp file:\C:\slave\test\build\tests\talos\talos\tests\dromaeo\css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:50:46 INFO - 2015-10-26 20:50:46,476 DEBUG : BROWSER_OUTPUT: RSS: Main: 141414400 20:50:46 INFO - 2015-10-26 20:50:46,476 DEBUG : BROWSER_OUTPUT: 20:51:39 INFO - 2015-10-26 20:51:39,244 DEBUG : BROWSER_OUTPUT: 1445917899234 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] 20:53:50 INFO - 2015-10-26 20:53:50,256 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49794/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49794/tests/dromaeo/cssquery-ext.html) 20:53:51 INFO - 2015-10-26 20:53:51,270 DEBUG : BROWSER_OUTPUT: RSS: Main: 178348032 20:53:51 INFO - 2015-10-26 20:53:51,270 DEBUG : BROWSER_OUTPUT: 20:56:54 INFO - 2015-10-26 20:56:54,404 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49794/tests/dromaeo/cssquery-ext.html (next: http://localhost:49794/tests/dromaeo/cssquery-jquery.html) 20:56:54 INFO - 2015-10-26 20:56:54,967 DEBUG : BROWSER_OUTPUT: RSS: Main: 193089536 20:56:54 INFO - 2015-10-26 20:56:54,967 DEBUG : BROWSER_OUTPUT: 20:59:57 INFO - 2015-10-26 20:59:57,223 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49794/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49794/tests/dromaeo/cssquery-mootools.html) 20:59:57 INFO - 2015-10-26 20:59:57,799 DEBUG : BROWSER_OUTPUT: RSS: Main: 151068672 20:59:57 INFO - 2015-10-26 20:59:57,799 DEBUG : BROWSER_OUTPUT: 21:02:59 INFO - 2015-10-26 21:02:59,907 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49794/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49794/tests/dromaeo/cssquery-prototype.html) 21:03:00 INFO - 2015-10-26 21:03:00,482 DEBUG : BROWSER_OUTPUT: RSS: Main: 140746752 21:03:00 INFO - 2015-10-26 21:03:00,482 DEBUG : BROWSER_OUTPUT: 21:06:03 INFO - 2015-10-26 21:06:03,572 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49794/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49794/tests/dromaeo/cssquery-yui.html) 21:06:04 INFO - 2015-10-26 21:06:04,167 DEBUG : BROWSER_OUTPUT: RSS: Main: 139563008 21:06:04 INFO - 2015-10-26 21:06:04,167 DEBUG : BROWSER_OUTPUT: 21:09:07 INFO - 2015-10-26 21:09:07,158 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49794/tests/dromaeo/cssquery-yui.html (next: http://localhost:49794/tests/dromaeo/cssquery-dojo.html) 21:09:07 INFO - 2015-10-26 21:09:07,414 DEBUG : BROWSER_OUTPUT: RSS: Main: 195006464 21:09:07 INFO - 2015-10-26 21:09:07,414 DEBUG : BROWSER_OUTPUT: 21:09:07 INFO - 2015-10-26 21:09:07,414 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:09:07 INFO - 2015-10-26 21:09:07,414 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:09:07 INFO - 2015-10-26 21:09:07,414 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:09:07 INFO - 2015-10-26 21:09:07,414 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:09:07 INFO - 2015-10-26 21:09:07,414 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2283.212291759343;2358.8230882683797;2372.3713215997773;2382.5949588569943;2387.438951846316;4110.93833592496;4113.115680128772;4113.856015039474;4159.9376009359885;4177.791110444481;4153.958460415395;4161.66706663467;4203.7057405981595;4223.873283801483;4235.152969406124;3541.5041894134843;3612.3858943979585;3625.4924310596407;3703;3704.3517384457678;3621.149029977953;3623.8912832615065;3641.581218159906;3643.8360273787744;3645.143391303042;3657.6342365763344;3670.376036073874;3677.191017976041;3683.650053244937;3686.078480379905;3596.352656521825;3600.8019558924248;3646.179609587835;3677.7057835373107;3695.3533131701843;3632.219072899313;3659.4693769403552;3730.8321125549414;3732.5894151643297;3738.065483629093;4060.634542891154;4115.773632450214;4143.047099167178;4175.227582897173;4198.3702444633245;4258.148370325916;4359.193549193409;4359.934600980988;4360.542143074995;4419.955800441987;4375.496817865955;4420.513743488214;4503;4503.954960450419;4504.864854054351;4095.201435720006;4127.711060225815;4188.476440444944;4193.287141186006;4196.055887425336;4382.671299652538;4408.316710909814;4566.908661826745;4571.702839315434;4581.473130589959;4328.43730315057;4328.740275583412;4360.738355698668;4394.077243778778;4407.2507673695545;4385.188740083095;4386.978065109654;4419.292913133883;4483.282674772021;4487.955120448819;4280.636145927569;4342.32693932441;4382.342648602735;4392.3191905254735;4454.844080457168;4348.456442944632;4367.235733746582;4424.668149888771;4432.3351497275025;4450.844220452269;3097.0399176255432;3146.3392687535875;3148.480500717402;3152.3064925716308;3161.2254997525292;2787.0106112330236;2799.496090703652;2859.5424732042775;2860.442213768295;2862.184277480908;4104.692148088905;4182.602652747984;4200.684948628865;4237.915241695149;4251.17102165081;4435.645148388186;4443.844465443694;4495.43807024122;4497.460304763449;4532.6827122101795;3831.7317787755146;4049.53430355507;4082.081531655413;4151.771652559078;4154.854580089683;3780.432935059763;3824.2733880562605;3834.654881060718;3848.422736589534;3854.69162467002;4507.864764057083;4535.938590369959;4566.45202575693;4614.423197100363;4639.048994956026;4293.441852559147;4365.519792822851;4381.386605875244;4387.539308372575;4472.575105364985;4477.753723545236;4486.573775491323;4556.544345565417;4571.222892108283;4580.221362368472;4315.611594956469;4327.588879056485;4413.24974754299;4415.977920110379;4421.712588681726;4345.239583073013;4382.496012958551;4469.910601788011;4496.7301961882395;4498.505164431976;4265.338872474771;4284.2930916398445;4365.2797288447055;4367.519572847048;4390.319500477431;4295.484541854998;4328.632066274402;4370.781460927004;4379.4525684289465;4385.846495372774;4090.365993271048;4095.7952102394165;4187.24629566681;4210.7894605269;4234.745915245096;4242.151569686013;4291.721038132511;4354.325079612665;4367.235733746518;4367.235733746646;4173.70784045126;4237.096916602014;4320.611144996966;4321.956780432155;4333.349997500274 21:09:07 INFO - 2015-10-26 21:09:07,414 DEBUG : BROWSER_OUTPUT: |1;ext.html;442.6790576831797;477.6942756635752;487.17423966377004;520.6095428428679;521.0438844719939;26345.341366465847;36553.81723091384;36629.81685091574;37058.8147059265;37355.43966840499;36403.63596364036;38287;38987.80506097473;39016.414753778714;39056;6303.2436107667145;6450.935490645081;7827.139014708363;8222.465539739927;8238.299744521722;9712.66005689801;9852.950735246313;9945.701628951143;9959.800803983915;9984.600615975352;9759.365641233333;9913.752156196117;9971.601135954554;9972.451515166664;9975.551100200508;6437.130987316723;6482.286948435668;9658.275629327793;10177.084062434342;10489.842652360221;9986.850197247048;10118.747031324203;10122;10179.54192061359;10196.38821670702;35902.28195436103;36176.81911590452;36439.81780091109;36777.63222367795;36857.26285474275;2642.141304076183;2663.813533052687;2736.2885649731015;2756.724327567227;2858.5140526110613;27548.449031019267;27678.861605692044;27911.86044069787;28062.158135255973;28635;2122.4269447249158;2147.5060736030646;2176.923807666724;2236.675682026097;2254.9436264093365;235467;237173;238891;239922.8003859987;240413;39284.4643982043;40081.39877901834;49606;52080.47919520756;53682.7315863426;49894;50077.24884126741;50336.748316258185;50444.49555504398;50509.24236136461;11915.821262681067;12020.819687704692;12066.034717222601;12086.395680215954;12094.758104837854;8986.505742184243;9011.684591039413;9032.593533291018;9036.367454278268;9055.728328150166;16093;16116.194190290438;16277.430289939795;16296.918515407348;16367.91816040912;7246.855062898712;7456.291652293024;7543.660535275926;7625.084989801259;7626.885596716053;764.5833021003566;827.842709885132;845.2603971524916;846.6909578003985;850.2177996243471;25041.12356067529;25763.48473030529;25916.74083259181;26028.8698556506;26314.342141446235;856.4133568505594;877.1228771228771;894.7136916186757;900.7703035725848;917.156216281023;13365.658898906398;13639.931800340935;13805.861941380457;13840.792388114187;13890.305484725723;260953;265760;265847;266961;267042;45073.32390014153;45306.77346613246;45504.772476137405;45518.54481455209;45522.317165242544;1090.4275255490932;1100.818364969771;1101.779644071173;1130.949107290174;1135.8693750218831;25099.74900250974;25876.482470350864;25946.351341215865;26036.08873689412;26104.8694756525;34539.82730086333;35058.64941350554;38653;40438.59561404349;41760.3735943955;217319;227644;228785;229292;229691;21990.45023874352;26410.603840942018;26484.14610977213;26713.599296010965;26746.50499072879;26501.33746656272;36248;36302;37157.071073223386;40099.398509021805;30899.667010227295;31255.53116703297;31512.36975260528;32179.356412871144;32530.186745331557;30020.84989575038;31464.842675786476;31607.367852643278;32181;32196.83901580477;27146.185614431597;27357.726422736316;27516.58725119085;30905.381892361576;31514.527282091247;26783.196504104908;27420;27753.722462775113;27842.721572784823;28019;20752;22060.708851919033;22129.557408852055;22153.224637137624;22238 21:09:07 INFO - 2015-10-26 21:09:07,423 DEBUG : BROWSER_OUTPUT: |2;jquery.html;273.53635587678883;287.4394929886721;288.53977905241146;294.53022429225376;298.40766079332536;11532.654020379381;12924.741505169892;15491.690166196684;15868.761968570481;15880;9036.548172591378;14781.704365912676;14920.179390133539;14929;14935.402583896632;4067.430559721634;4174.0817020255645;4175.979120104395;4181.017460896687;4181.7490950542915;3034.8027378220454;3097.504399296113;4118.217538667658;4335.328024156261;4513.842015529457;4551.158035763395;4563.429571303587;4564.292534657134;4567.840125595605;4573.405457290564;4268.829246830123;4439.866803995886;4554.2485489894125;4558.361829343895;4558.5213552577;3831.0230891122865;3867.806609669505;3886.24218277436;3907.7264591478606;3914.5693973662874;11198.216124871262;11511.769764604745;11854.28874267538;11932.164748467523;11989.64031079069;1691.9323227070902;1755.4645833020923;1785.2858856457392;1809.3034181839955;1827.9123921266826;7759.224077592252;8803.515806630632;8830.602622881986;8890.288776897898;8896.37725359225;1495.3046833222604;1508.102678906049;1538.6153461634592;1569.2467615544488;1595.2023988005997;56125.71937140288;56143.71928140374;57552.712236438965;57711.13433298504;58072;5635.267415236075;5708.457696518824;5711.343195532484;5775.653460792282;5801.361850196475;6691.26396096429;6707.496937729592;6708.765193218214;6715;6717.596944183267;4452.910941781146;4476.4180656514445;4482.148391805546;4512.729236245836;4516.277395616751;4463.955360446354;4559.270516717309;4621.23749581322;4634.281686338623;4641.930371044437;2587.961180582293;2598.5322641924636;2610.6345111684377;2617;2617.9135658701807;912.7763697893926;941.3457646935315;948.0519480519481;951.5860600638745;988.7676396046924;355.30715105543777;381.10820679609844;396.86109861548806;404.3207411548627;411.68917467311985;9894.55474503649;10138.695839124837;10212.234082443847;10663.880292569324;10749.731256718489;333.5180663940631;370.89614907825853;385.9498265225559;401.2376484679133;401.98794036178964;5508.256385388001;5627.859303517363;5723.799667011718;5775.942240577624;5800.070964163071;313187;322812;324001;324617;325776;65845;66060.33939660541;67309.66345168243;67953.66023169951;68263.73648348066;424.6772452935791;432.6603616161298;442.50881521510456;443.0695539367367;443.08502941425854;9806.264530160124;9932.255080869108;10086.394816311045;10203.795924081625;10219.7445063874;33166.66833331636;34207.315853683285;35412.291754165286;35417.645823542465;35672;46178;46629;46745.53254467412;47253.76373118113;47441;5471.124620060771;5517.779288828402;5691.117876729114;5702.914456283076;5726.914096288476;10708.143348532254;10742.89257107419;10774.569017239222;11389.202755807013;11390.37352945596;9292.767680808034;9484.857727134236;9528;9623.663171788954;9652.565634546321;9443.480608566595;9472.384295020802;9563.713088607354;9683.41899486033;10046.899531004596;9875.160611347828;10047.246456515644;10241.84637230457;10250.333728307636;10250.58997640086;5588.86027849307;5680.573956953162;5698.601097923106;5711.857203569944;5715.742791574306;9235.676751313671;9307;9334.813303734023;9491.098345657152;9491.905080949102 21:09:07 INFO - 2015-10-26 21:09:07,424 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1193.5762804204505;1193.9283642981416;1234.3272916260637;1363.372848489695;1548.6051056980461;5639.464250896163;6166.7841625543115;6643.501737369693;6647.833804154905;6653.168353955755;6238.84402889928;6414.198225221848;6424.8072557823225;6426.710798014089;6490.156279683634;1835.3301045118503;1890.1588792987127;1907.408703301974;1911.6463454261007;1918.1176658736997;1915.3870761356372;1937.893415862127;1937.9515512112168;1939.4957311099145;1948.0649288341533;1811.0763510609618;1844;1894.8957807320592;1896.468988683164;1898.1837809741874;1815.1757483728834;1837.6784062789025;1876.756021717168;1889.0932352470754;1892.0350621183295;1843.4746097362188;1847.8152184781413;1886.6792645250202;1891.6595012897674;1909.455805095555;5489.807856724996;5699;6213.906791398133;6410;6452;3781.735278530504;3796.54441467023;3863.3239183142837;3920;3920.09837737322;2321.8142548596243;2334.4864129891566;2344.0623750499767;2347.366211123004;2359.1624973134635;725.5755383100892;731.9158296795883;737.0823324960405;762.2111114995953;764.3923081150443;8405.789855253606;8620.353473489513;8638.395312328139;8693.956530217372;8703.825923481494;3477.5479187705437;3537.2218112015316;3579.2461693770388;3587.192881601671;3649.087728067983;7555.6977720890545;7564.167941526428;7575.431842611826;7580.734674286374;7582.393408527305;3876.186000939778;3879.9612003880166;3880.049387899926;3881.8059097045034;3883.436901649245;3510.297940411928;3537.646235376442;3539.964600354015;3543.0433782878995;3543.698785603201;2811.4658214939095;2917.9416411672073;2984.910452686423;2995.4907665696883;3014.623172103487;954.3939598355095;977.0620204603518;978.7406337320616;982.40564458503;982.5824024789579;838.7022606974558;1026.7946410717886;1077.6012875236213;1082.3235477826358;1085.7068591480256;6020.187274717945;6053.4551890330085;6054.7275372607455;6062.151298818169;6064.727087281083;405.63898130663733;412.9793510324472;415.0143409402669;416.3899886665988;416.7686933751797;4767.666263361601;4833.4441539222735;4958.528939750718;4967.130752118364;4973.154563724175;6987.685554150075;7237.3486386225495;7488.101427828587;7646.9617651911385;7653.732119375795;7348.742794002184;7493.437992150611;7515.736949206752;7519.323260906435;7534.962325188339;5773.134029895466;5966.582339236212;5977.163197152402;5978.073398623221;5979.372165922602;5657.066584013592;5766.452187042224;5782;5785.739641716217;5799.130130480293;6619.635920024445;6886.208086070166;6904.308444430945;6920.550164239509;6933.757318493828;6903.5167538273845;7040.119985001875;7051.823704407431;7054.435645148274;7079.433645308466;5767.192593037062;5872.618279811799;5879.676617786063;5881.7647294107755;5885.264341957255;6265.216847894013;6441.098246245623;6441.806745797634;6443.871122577429;6445.967770161119;5869.413058694267;5922.73347699346;6011.909821352596;6082.330943596113;6091.7258723358445;5844.444777746107;5962.344142144274;6004.939950600613;6006.579539432198;6008.669523176267;5964.612300200473;5972.223610930725;6000.159977603052;6006.519478441802;6013.6692481913915;5322.600804939568;5346.599005074557;5355.973220133875;5357.758900849393;5363.678179309254;5443.8094666686475;5620.718964051699;5624.128260119688;5625.606207565431;5628.268325117709 21:09:07 INFO - 2015-10-26 21:09:07,492 DEBUG : BROWSER_OUTPUT: |4;prototype.html;248.7823154739603;262.3402143608823;263.6598787564041;276.2031539009956;277.3786717752235;4478.574535419139;4563.429571303587;4584.656150788687;4656.092062047906;4664.860054198371;4418.867433976978;4448.33275008748;4529.682922195448;4532.456105267364;4547.386102876111;3390.2202493426526;3416.982915085421;3450.27544215715;3452.671996160367;3454.9481757773656;3265.363254165439;3433.227523807136;3444.0356700124007;3445.638207988163;3457.671521205494;3303.1081607965834;3393.592768867727;3415.4023045966983;3447.9310413791836;3449.223924616954;3393.932121357559;3394.473856552226;3410.437277849152;3441.8451169697423;3446.0867870014467;3034.666186719459;3055.3278278778635;3061.265296328865;3062.892798752033;3063.203567072555;4420.40324556184;4437.0460351024685;4453.287474004143;4468.240399132155;4473.418455600784;4069.532003819569;4099.344104943225;4099.815508302104;4104.384342348641;4104.610062044101;4811.061842940628;4817.855464336076;4818.951810481885;4820.8794780130775;4826.058918510892;3285.342931413703;3330.6835850594157;3371.2920286739813;3376.2741010682576;3379.0538649178025;4975.7263350515705;5012.198048312289;5045.899082018339;5048.596112311006;5057.165567681328;3460.8615655374006;3466.1681196512654;3471.409860323751;3471.7049050830456;3472.774269672463;3482.21650128719;3487.5814902211896;3491.528643633077;3492.5459690240104;3505.964940350615;4072.6741860651077;4078.775667338325;4079.3065178919655;4080.8571699990357;4085.22380747657;4888.242322440027;4894.657373983858;4901.019796040735;4901.534354236342;4902.068606964665;1205.5961252980173;1212.5574165429732;1254.9498020079277;1256.7486502699496;1256.9371531423392;834.94057741793;842.5660784695887;853.0658928473312;853.5774791478134;855.4567849415666;4596.701214421052;4598.701084429501;4610.308453731967;4614.238650622677;4615.14619795339;4980.153373926441;4980.252962055721;4980.9252861207115;4981.775820088104;4990.3762029746285;4576.336431217522;4599.563041511051;4623.237165867594;4632.652551058684;4645.790939407735;2697.892084316605;2721.142840005392;2722.8910843566036;2730.604062410939;2751.793615478847;5006.599472042228;5015.799368025311;5089;5127.435982041972;5154.201098829687;5100.464451232567;5169.017886601534;5171.612129090333;5178.404483484373;5179.326687530597;4949.752512374439;5038.496150385005;5075.1625981712605;5128.153854614022;5149.0474262261605;4929.359183306147;5023.949760502494;5034.899302014012;5038.823641172541;5048.293238946624;4579.015511665008;4860.149473842134;4905.264210368473;5008.348914641073;5016.448190698947;4695.765211739467;4973.726445045557;4982.551570358685;5045.722485263345;5132.5893928486375;3284.605847298244;3420.264643101745;3445.707114895162;3452.4476083826466;3486.0936156599973;4945.554900058868;4976.377952755905;4984.675996060245;4990.251462280687;4998.625103117208;4805.399325084364;4807.278908163804;4810.037992401463;4810.374651295309;4812.085703716282;4707.987782626752;4780.665353425227;4786.617070634271;4807.519248075165;4814.711117332971;4701.623870090316;4702.741349225688;4711.387519622427;4714.269288260325;4716.929246061381;4680.88857545843;4787.353707249476;4812.494688057844;4835.20219163834;4848.0303939213;4753.334533165291;4763.666543342071;4783.7129772213775;4787.018661174381;4789.808407663654 21:09:07 INFO - 2015-10-26 21:09:07,493 DEBUG : BROWSER_OUTPUT: |5;yui.html;608.6652341212332;655.8491546944201;718.7484380466834;730.9963450182748;732.7105793211681;12179.878201217985;12302.692432689188;12391.938040309797;12417.254964702102;12509.311987840665;10778.245522813386;10865.891341086586;11331;11455.770884582304;11724.179307448481;615.716770285668;616.5622408090261;616.9573420918633;627.5795217204461;630.0643544336656;618.2735286038909;624.5721680648747;624.6127401011379;624.8562830548976;625.2028663454109;647.7765171015992;650.3074225949373;651.244556314675;652.8759535688228;653.5229282623663;637.1971316141648;643.4048505132733;646.4375992886172;648.157395386001;648.52657559981;476.06928454870643;476.08829092288227;476.40687344256276;476.8855474686085;477.7420193095724;11073.16951228653;11243.269187502787;11257.099432045417;11290.774184516345;11317;9517.111584369246;9881.308308418413;10335.121514671187;10340.534675939602;10450.16398688103;8857.955710221408;8897.688580899638;9284.25725941923;9287.024862389488;9290.535473226311;3232.3535292941506;3277.0987978306157;3306.2230375861654;3348.2299071213515;3408.5398471206317;38028.23943521142;38744.418833717515;41900.37149442761;42650;43417.34873976893;9265.351425400157;9280.303977201736;9284.582193801296;9314.44113353201;9724.75688107803;15692.136932468824;15952.441664541686;15976.201189940457;16004.359825607078;16051.839481605268;6312.747490100344;6447.1296374989715;6487.772927947593;6541;6619.602823830489;3545.4859045438266;3550.6449355064287;3567.2152126532123;3584.605693373727;3590.730695197871;2484.925452236436;2488.7760101590943;2489.4149874779414;2528.342630915975;2538.2892790018823;388.8425187798946;396.2649285575274;396.35987879574856;402.20363679913936;403.3848381218665;542.5307109350383;578.5169383564687;580.3606738906892;592.6710675575097;605.6456972671036;7829.138794732575;8209.58952052395;8533.914660853436;8795.042230996078;8968.910310896938;471.32129733184104;477.1101894965933;530.2179285553777;573.3922042634737;619.3404024713666;3612.0789198754674;3723.404255319136;3982.38273067675;4020.638142567183;4046.2312160689376;52814;52819.47180528222;53306.73346633242;53427;53749;48668.51331486711;48695;48967.265491017664;49144.75427622839;49152.50847491479;39357;39784.40323395151;42291.36562951558;44405;44874.32688509675;8166.361417884921;8232.17678232172;8260.917390826015;8372.204640559137;8665.653373864974;29200.707992919797;35133.82433087818;35862.28275434529;35865.28269434544;36013.639863602075;38372.23255534929;41996.79001604972;42270.36594451024;42633.57366426296;43093;6729.629870357177;6741.764038258833;6824.522283440111;6863.691133899087;7154.713811447484;10976.341419514854;11021.952914473111;11155;11234.045106166068;11273.379964102052;10513;10604.310719803188;10654.094401975608;10825.296355736851;11247;10329.793404132026;10360.740981475223;10637.414942178255;10661.733456663645;10784.137269018616;9920.26673679106;10153.543090560795;10275.691729248134;10392.636257731245;10437.269391142547;8494.660213591387;8700.869486957574;9095.772605684911;9349.906500934903;9989.800203996025;8392.412531122764;8736.25741811953;8906.242969347679;8923.018467968648;9182 21:09:07 INFO - 2015-10-26 21:09:07,493 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:09:07 INFO - 2015-10-26 21:09:07,493 DEBUG : BROWSER_OUTPUT: __start_cc_report 21:09:07 INFO - 2015-10-26 21:09:07,493 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,800 21:09:07 INFO - 2015-10-26 21:09:07,493 DEBUG : BROWSER_OUTPUT: __end_cc_report 21:09:07 INFO - 2015-10-26 21:09:07,493 DEBUG : BROWSER_OUTPUT: __startTimestamp1445918947380__endTimestamp 21:09:07 INFO - 2015-10-26 21:09:07,493 DEBUG : BROWSER_OUTPUT: 21:09:07 INFO - 2015-10-26 21:09:07,493 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:09:07 INFO - 2015-10-26 21:09:07,493 DEBUG : BROWSER_OUTPUT: Number of tests: 6 21:09:07 INFO - 2015-10-26 21:09:07,494 DEBUG : BROWSER_OUTPUT: 21:09:07 INFO - 2015-10-26 21:09:07,494 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4074.35 Median:4251.17 stddev:507.23 (11.9%) stddev-sans-first:488.94 21:09:07 INFO - 2015-10-26 21:09:07,494 DEBUG : BROWSER_OUTPUT: Values: 2283.2 2358.8 2372.4 2382.6 2387.4 4110.9 4113.1 4113.9 4159.9 4177.8 4154.0 4161.7 4203.7 4223.9 4235.2 3541.5 3612.4 3625.5 3703.0 3704.4 3621.1 3623.9 3641.6 3643.8 3645.1 3657.6 3670.4 3677.2 3683.7 3686.1 3596.4 3600.8 3646.2 3677.7 3695.4 3632.2 3659.5 3730.8 3732.6 3738.1 4060.6 4115.8 4143.0 4175.2 4198.4 4258.1 4359.2 4359.9 4360.5 4420.0 4375.5 4420.5 4503.0 4504.0 4504.9 4095.2 4127.7 4188.5 4193.3 4196.1 4382.7 4408.3 4566.9 4571.7 4581.5 4328.4 4328.7 4360.7 4394.1 4407.3 4385.2 4387.0 4419.3 4483.3 4488.0 4280.6 4342.3 4382.3 4392.3 4454.8 4348.5 4367.2 4424.7 4432.3 4450.8 3097.0 3146.3 3148.5 3152.3 3161.2 2787.0 2799.5 2859.5 2860.4 2862.2 4104.7 4182.6 4200.7 4237.9 4251.2 4435.6 4443.8 4495.4 4497.5 4532.7 3831.7 4049.5 4082.1 4151.8 4154.9 3780.4 3824.3 3834.7 3848.4 3854.7 4507.9 4535.9 4566.5 4614.4 4639.0 4293.4 4365.5 4381.4 4387.5 4472.6 4477.8 4486.6 4556.5 4571.2 4580.2 4315.6 4327.6 4413.2 4416.0 4421.7 4345.2 4382.5 4469.9 4496.7 4498.5 4265.3 4284.3 4365.3 4367.5 4390.3 4295.5 4328.6 4370.8 4379.5 4385.8 4090.4 4095.8 4187.2 4210.8 4234.7 4242.2 4291.7 4354.3 4367.2 4367.2 4173.7 4237.1 4320.6 4322.0 4333.3 21:09:07 INFO - 2015-10-26 21:09:07,494 DEBUG : BROWSER_OUTPUT: 21:09:07 INFO - 2015-10-26 21:09:07,494 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39311.47 Median:31488.61 stddev:63540.94 (201.8%) stddev-sans-first:63652.17 21:09:07 INFO - 2015-10-26 21:09:07,494 DEBUG : BROWSER_OUTPUT: Values: 442.7 477.7 487.2 520.6 521.0 26345.3 36553.8 36629.8 37058.8 37355.4 36403.6 38287.0 38987.8 39016.4 39056.0 6303.2 6450.9 7827.1 8222.5 8238.3 9712.7 9853.0 9945.7 9959.8 9984.6 9759.4 9913.8 9971.6 9972.5 9975.6 6437.1 6482.3 9658.3 10177.1 10489.8 9986.9 10118.7 10122.0 10179.5 10196.4 35902.3 36176.8 36439.8 36777.6 36857.3 2642.1 2663.8 2736.3 2756.7 2858.5 27548.4 27678.9 27911.9 28062.2 28635.0 2122.4 2147.5 2176.9 2236.7 2254.9 235467.0 237173.0 238891.0 239922.8 240413.0 39284.5 40081.4 49606.0 52080.5 53682.7 49894.0 50077.2 50336.7 50444.5 50509.2 11915.8 12020.8 12066.0 12086.4 12094.8 8986.5 9011.7 9032.6 9036.4 9055.7 16093.0 16116.2 16277.4 16296.9 16367.9 7246.9 7456.3 7543.7 7625.1 7626.9 764.6 827.8 845.3 846.7 850.2 25041.1 25763.5 25916.7 26028.9 26314.3 856.4 877.1 894.7 900.8 917.2 13365.7 13639.9 13805.9 13840.8 13890.3 260953.0 265760.0 265847.0 266961.0 267042.0 45073.3 45306.8 45504.8 45518.5 45522.3 1090.4 1100.8 1101.8 1130.9 1135.9 25099.7 25876.5 25946.4 26036.1 26104.9 34539.8 35058.6 38653.0 40438.6 41760.4 217319.0 227644.0 228785.0 229292.0 229691.0 21990.5 26410.6 26484.1 26713.6 26746.5 26501.3 36248.0 36302.0 37157.1 40099.4 30899.7 31255.5 31512.4 32179.4 32530.2 30020.8 31464.8 31607.4 32181.0 32196.8 27146.2 27357.7 27516.6 30905.4 31514.5 26783.2 27420.0 27753.7 27842.7 28019.0 20752.0 22060.7 22129.6 22153.2 22238.0 21:09:07 INFO - 2015-10-26 21:09:07,494 DEBUG : BROWSER_OUTPUT: 21:09:07 INFO - 2015-10-26 21:09:07,494 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:19836.31 Median:2441.48 stddev:53480.78 (2190.5%) stddev-sans-first:53610.64 21:09:07 INFO - 2015-10-26 21:09:07,496 DEBUG : BROWSER_OUTPUT: Values: 273.5 287.4 288.5 294.5 298.4 11532.7 12924.7 15491.7 15868.8 15880.0 9036.5 14781.7 14920.2 14929.0 14935.4 4067.4 4174.1 4176.0 4181.0 4181.7 3034.8 3097.5 4118.2 4335.3 4513.8 4551.2 4563.4 4564.3 4567.8 4573.4 4268.8 4439.9 4554.2 4558.4 4558.5 3831.0 3867.8 3886.2 3907.7 3914.6 11198.2 11511.8 11854.3 11932.2 11989.6 1691.9 1755.5 1785.3 1809.3 1827.9 7759.2 8803.5 8830.6 8890.3 8896.4 1495.3 1508.1 1538.6 1569.2 1595.2 56125.7 56143.7 57552.7 57711.1 58072.0 5635.3 5708.5 5711.3 5775.7 5801.4 6691.3 6707.5 6708.8 6715.0 6717.6 4452.9 4476.4 4482.1 4512.7 4516.3 4464.0 4559.3 4621.2 4634.3 4641.9 2588.0 2598.5 2610.6 2617.0 2617.9 912.8 941.3 948.1 951.6 988.8 355.3 381.1 396.9 404.3 411.7 9894.6 10138.7 10212.2 10663.9 10749.7 333.5 370.9 385.9 401.2 402.0 5508.3 5627.9 5723.8 5775.9 5800.1 313187.0 322812.0 324001.0 324617.0 325776.0 65845.0 66060.3 67309.7 67953.7 68263.7 424.7 432.7 442.5 443.1 443.1 9806.3 9932.3 10086.4 10203.8 10219.7 33166.7 34207.3 35412.3 35417.6 35672.0 46178.0 46629.0 46745.5 47253.8 47441.0 5471.1 5517.8 5691.1 5702.9 5726.9 10708.1 10742.9 10774.6 11389.2 11390.4 9292.8 9484.9 9528.0 9623.7 9652.6 9443.5 9472.4 9563.7 9683.4 10046.9 9875.2 10047.2 10241.8 10250.3 10250.6 5588.9 5680.6 5698.6 5711.9 5715.7 9235.7 9307.0 9334.8 9491.1 9491.9 21:09:07 INFO - 2015-10-26 21:09:07,497 DEBUG : BROWSER_OUTPUT: 21:09:07 INFO - 2015-10-26 21:09:07,497 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4488.06 Median:5777.57 stddev:2334.30 (40.4%) stddev-sans-first:2327.72 21:09:07 INFO - 2015-10-26 21:09:07,497 DEBUG : BROWSER_OUTPUT: Values: 1193.6 1193.9 1234.3 1363.4 1548.6 5639.5 6166.8 6643.5 6647.8 6653.2 6238.8 6414.2 6424.8 6426.7 6490.2 1835.3 1890.2 1907.4 1911.6 1918.1 1915.4 1937.9 1938.0 1939.5 1948.1 1811.1 1844.0 1894.9 1896.5 1898.2 1815.2 1837.7 1876.8 1889.1 1892.0 1843.5 1847.8 1886.7 1891.7 1909.5 5489.8 5699.0 6213.9 6410.0 6452.0 3781.7 3796.5 3863.3 3920.0 3920.1 2321.8 2334.5 2344.1 2347.4 2359.2 725.6 731.9 737.1 762.2 764.4 8405.8 8620.4 8638.4 8694.0 8703.8 3477.5 3537.2 3579.2 3587.2 3649.1 7555.7 7564.2 7575.4 7580.7 7582.4 3876.2 3880.0 3880.0 3881.8 3883.4 3510.3 3537.6 3540.0 3543.0 3543.7 2811.5 2917.9 2984.9 2995.5 3014.6 954.4 977.1 978.7 982.4 982.6 838.7 1026.8 1077.6 1082.3 1085.7 6020.2 6053.5 6054.7 6062.2 6064.7 405.6 413.0 415.0 416.4 416.8 4767.7 4833.4 4958.5 4967.1 4973.2 6987.7 7237.3 7488.1 7647.0 7653.7 7348.7 7493.4 7515.7 7519.3 7535.0 5773.1 5966.6 5977.2 5978.1 5979.4 5657.1 5766.5 5782.0 5785.7 5799.1 6619.6 6886.2 6904.3 6920.6 6933.8 6903.5 7040.1 7051.8 7054.4 7079.4 5767.2 5872.6 5879.7 5881.8 5885.3 6265.2 6441.1 6441.8 6443.9 6446.0 5869.4 5922.7 6011.9 6082.3 6091.7 5844.4 5962.3 6004.9 6006.6 6008.7 5964.6 5972.2 6000.2 6006.5 6013.7 5322.6 5346.6 5356.0 5357.8 5363.7 5443.8 5620.7 5624.1 5625.6 5628.3 21:09:07 INFO - 2015-10-26 21:09:07,500 DEBUG : BROWSER_OUTPUT: 21:09:07 INFO - 2015-10-26 21:09:07,500 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4032.95 Median:4619.19 stddev:1206.84 (26.1%) stddev-sans-first:1176.32 21:09:07 INFO - 2015-10-26 21:09:07,500 DEBUG : BROWSER_OUTPUT: Values: 248.8 262.3 263.7 276.2 277.4 4478.6 4563.4 4584.7 4656.1 4664.9 4418.9 4448.3 4529.7 4532.5 4547.4 3390.2 3417.0 3450.3 3452.7 3454.9 3265.4 3433.2 3444.0 3445.6 3457.7 3303.1 3393.6 3415.4 3447.9 3449.2 3393.9 3394.5 3410.4 3441.8 3446.1 3034.7 3055.3 3061.3 3062.9 3063.2 4420.4 4437.0 4453.3 4468.2 4473.4 4069.5 4099.3 4099.8 4104.4 4104.6 4811.1 4817.9 4819.0 4820.9 4826.1 3285.3 3330.7 3371.3 3376.3 3379.1 4975.7 5012.2 5045.9 5048.6 5057.2 3460.9 3466.2 3471.4 3471.7 3472.8 3482.2 3487.6 3491.5 3492.5 3506.0 4072.7 4078.8 4079.3 4080.9 4085.2 4888.2 4894.7 4901.0 4901.5 4902.1 1205.6 1212.6 1254.9 1256.7 1256.9 834.9 842.6 853.1 853.6 855.5 4596.7 4598.7 4610.3 4614.2 4615.1 4980.2 4980.3 4980.9 4981.8 4990.4 4576.3 4599.6 4623.2 4632.7 4645.8 2697.9 2721.1 2722.9 2730.6 2751.8 5006.6 5015.8 5089.0 5127.4 5154.2 5100.5 5169.0 5171.6 5178.4 5179.3 4949.8 5038.5 5075.2 5128.2 5149.0 4929.4 5023.9 5034.9 5038.8 5048.3 4579.0 4860.1 4905.3 5008.3 5016.4 4695.8 4973.7 4982.6 5045.7 5132.6 3284.6 3420.3 3445.7 3452.4 3486.1 4945.6 4976.4 4984.7 4990.3 4998.6 4805.4 4807.3 4810.0 4810.4 4812.1 4708.0 4780.7 4786.6 4807.5 4814.7 4701.6 4702.7 4711.4 4714.3 4716.9 4680.9 4787.4 4812.5 4835.2 4848.0 4753.3 4763.7 4783.7 4787.0 4789.8 21:09:07 INFO - 2015-10-26 21:09:07,500 DEBUG : BROWSER_OUTPUT: 21:09:07 INFO - 2015-10-26 21:09:07,500 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12499.26 Median:476.65 stddev:14784.16 (3101.7%) stddev-sans-first:14798.66 21:09:07 INFO - 2015-10-26 21:09:07,500 DEBUG : BROWSER_OUTPUT: Values: 608.7 655.8 718.7 731.0 732.7 12179.9 12302.7 12391.9 12417.3 12509.3 10778.2 10865.9 11331.0 11455.8 11724.2 615.7 616.6 617.0 627.6 630.1 618.3 624.6 624.6 624.9 625.2 647.8 650.3 651.2 652.9 653.5 637.2 643.4 646.4 648.2 648.5 476.1 476.1 476.4 476.9 477.7 11073.2 11243.3 11257.1 11290.8 11317.0 9517.1 9881.3 10335.1 10340.5 10450.2 8858.0 8897.7 9284.3 9287.0 9290.5 3232.4 3277.1 3306.2 3348.2 3408.5 38028.2 38744.4 41900.4 42650.0 43417.3 9265.4 9280.3 9284.6 9314.4 9724.8 15692.1 15952.4 15976.2 16004.4 16051.8 6312.7 6447.1 6487.8 6541.0 6619.6 3545.5 3550.6 3567.2 3584.6 3590.7 2484.9 2488.8 2489.4 2528.3 2538.3 388.8 396.3 396.4 402.2 403.4 542.5 578.5 580.4 592.7 605.6 7829.1 8209.6 8533.9 8795.0 8968.9 471.3 477.1 530.2 573.4 619.3 3612.1 3723.4 3982.4 4020.6 4046.2 52814.0 52819.5 53306.7 53427.0 53749.0 48668.5 48695.0 48967.3 49144.8 49152.5 39357.0 39784.4 42291.4 44405.0 44874.3 8166.4 8232.2 8260.9 8372.2 8665.7 29200.7 35133.8 35862.3 35865.3 36013.6 38372.2 41996.8 42270.4 42633.6 43093.0 6729.6 6741.8 6824.5 6863.7 7154.7 10976.3 11022.0 11155.0 11234.0 11273.4 10513.0 10604.3 10654.1 10825.3 11247.0 10329.8 10360.7 10637.4 10661.7 10784.1 9920.3 10153.5 10275.7 10392.6 10437.3 8494.7 8700.9 9095.8 9349.9 9989.8 8392.4 8736.3 8906.2 8923.0 9182.0 21:09:07 INFO - 2015-10-26 21:09:07,503 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:09:07 INFO - 2015-10-26 21:09:07,503 DEBUG : BROWSER_OUTPUT: 21:09:07 INFO - 2015-10-26 21:09:07,992 INFO : Browser exited with error code: 0 21:09:08 INFO - 2015-10-26 21:09:08,726 INFO : Completed test dromaeo_css (00:18:43) 21:09:08 INFO - 2015-10-26 21:09:08,726 INFO : Starting test kraken 21:09:08 INFO - 2015-10-26 21:09:08,726 DEBUG : operating with platform_type : w7_ 21:09:08 INFO - 2015-10-26 21:09:08,726 INFO : Initialising browser for kraken test... 21:09:08 INFO - 2015-10-26 21:09:08,750 DEBUG : command line: C:\slave\test\build\application\firefox\firefox -profile c:\users\cltbld\appdata\local\temp\tmpamyquv\profile http://localhost:49794/getInfo.html 21:09:13 INFO - 2015-10-26 21:09:13,858 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:09:13 INFO - 2015-10-26 21:09:13,858 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:09:13 INFO - 2015-10-26 21:09:13,858 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1008/673 21:09:13 INFO - 2015-10-26 21:09:13,858 DEBUG : BROWSER_OUTPUT: __metrics 21:09:13 INFO - 2015-10-26 21:09:13,920 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:09:14 INFO - 2015-10-26 21:09:14,581 DEBUG : BROWSER_OUTPUT: console.error: 21:09:14 INFO - 2015-10-26 21:09:14,581 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] 21:09:14 INFO - 2015-10-26 21:09:14,581 DEBUG : BROWSER_OUTPUT: Stack: 21:09:14 INFO - 2015-10-26 21:09:14,581 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<._executeStatement@resource://gre/modules/Sqlite.jsm:758:19 21:09:14 INFO - 2015-10-26 21:09:14,581 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached/<@resource://gre/modules/Sqlite.jsm:493:9 21:09:14 INFO - 2015-10-26 21:09:14,581 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeCached@resource://gre/modules/Sqlite.jsm:491:1 21:09:14 INFO - 2015-10-26 21:09:14,581 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeBeforeShutdown/loggedDb<.executeCached.value<@resource://gre/modules/Sqlite.jsm:368:51 21:09:14 INFO - 2015-10-26 21:09:14,581 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 21:09:14 INFO - 2015-10-26 21:09:14,581 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 21:09:14 INFO - 2015-10-26 21:09:14,581 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 21:09:14 INFO - 2015-10-26 21:09:14,581 DEBUG : BROWSER_OUTPUT: transaction@resource://gre/modules/Bookmarks.jsm:783:15 21:09:14 INFO - 2015-10-26 21:09:14,581 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:314:40 21:09:14 INFO - 2015-10-26 21:09:14,581 DEBUG : BROWSER_OUTPUT: TaskImpl@resource://gre/modules/Task.jsm:275:3 21:09:14 INFO - 2015-10-26 21:09:14,582 DEBUG : BROWSER_OUTPUT: createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 21:09:14 INFO - 2015-10-26 21:09:14,582 DEBUG : BROWSER_OUTPUT: Task_spawn@resource://gre/modules/Task.jsm:164:12 21:09:14 INFO - 2015-10-26 21:09:14,582 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promisedromaeo_css: 5506.40 21:10:54 INFO - RETURN: kraken: 1620.30 21:10:54 INFO - RETURN: v8_7: 20477.07 21:10:54 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,131,25]]", "result": "20477.07"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,131,25]]", "result": "1620.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,131,25]]", "result": "5506.40"}}} 21:10:54 INFO - Return code: 0 21:10:54 INFO - # TBPL SUCCESS # 21:10:54 INFO - Running post-action listener: _resource_record_post_action 21:10:54 INFO - Running post-run listener: _resource_record_post_run 21:10:55 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 88526848; Write bytes: 395844608; Read time: 1125560; Write time: 4622950 21:10:55 INFO - install - Wall time: 2s; CPU: 13.0%; Read bytes: 0; Write bytes: 16384; Read time: 0; Write time: 50 21:10:55 INFO - run-tests - Wall time: 1233s; CPU: 13.0%; Read bytes: 88526848; Write bytes: 373007360; Read time: 1125560; Write time: 4383900 21:10:55 INFO - Running post-run listener: _upload_blobber_files 21:10:55 INFO - Blob upload gear active. 21:10:55 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 21:10:55 INFO - Copying logs to upload dir... 21:10:55 INFO - mkdir: C:\slave\test\build\upload\logs program finished with exit code 0 elapsedTime=1414.247000 ========= Finished 'c:/mozilla-build/python27/python -u ...' (results: 0, elapsed: 23 mins, 36 secs) (at 2015-10-26 21:10:58.432807) ========= ========= Started set props: build_url (results: 0, elapsed: 22 secs) (at 2015-10-26 21:10:58.436388) ========= 'cmd' '/C' 'for' '%f' 'in' '(*)' 'do' '@type' '%f' in dir C:\slave\test\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-001 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-001 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\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-001 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/FcMX6egQQlu8cGEfju8hZQ/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/FcMX6egQQlu8cGEfju8hZQ/artifacts/public/build/firefox-44.0a1.en-US.win32.zip' ========= Finished set props: build_url (results: 0, elapsed: 22 secs) (at 2015-10-26 21:11:21.114021) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 mins, 21 secs) (at 2015-10-26 21:11:21.114382) ========= 'rm' '-f' 'oauth.txt' in dir C:\slave\test\. (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-001 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-001 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 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-001 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 mins, 21 secs) (at 2015-10-26 21:12:42.374809) ========= ========= Started reboot slave lost (results: 0, elapsed: 1 mins, 2 secs) (at 2015-10-26 21:12:42.375117) ========= ========= Finished reboot slave lost (results: 0, elapsed: 1 mins, 2 secs) (at 2015-10-26 21:13:45.161474) =========