builder: mozilla-inbound_ubuntu32_vm-debug_test-mochitest-browser-chrome-7 slave: tst-linux32-spot-287 starttime: 1448579629.95 results: success (0) buildid: 20151126135412 builduid: a6f63bb04be644bfadd7d5956ee0532b revision: 1bf6fd3421e6cb23b386e6e01e718b05453b373a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-26 15:13:49.951862) ========= master: http://buildbot-master02.bb.releng.use1.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-26 15:13:49.952277) ========= ========= Started set props: basedir (results: 0, elapsed: 2 secs) (at 2015-11-26 15:13:49.952591) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: HOME=/home/cltbld LANG=en_US.UTF-8 LOGNAME=cltbld MAIL=/var/mail/cltbld NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5a152710dd62cc268aad214e000002d8-1448579216.958613-1512602564 _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.019141 basedir: '/builds/slave/test' ========= master_lag: 2.28 ========= ========= Finished set props: basedir (results: 0, elapsed: 2 secs) (at 2015-11-26 15:13:52.249664) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 4 secs) (at 2015-11-26 15:13:52.249977) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 4 secs) (at 2015-11-26 15:13:56.476891) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 15:13:56.477159) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: HOME=/home/cltbld LANG=en_US.UTF-8 LOGNAME=cltbld MAIL=/var/mail/cltbld NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5a152710dd62cc268aad214e000002d8-1448579216.958613-1512602564 _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017760 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 15:13:56.541574) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-26 15:13:56.541841) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-26 15:13:56.542165) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2015-11-26 15:13:56.542436) ========= 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 /builds/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: HOME=/home/cltbld LANG=en_US.UTF-8 LOGNAME=cltbld MAIL=/var/mail/cltbld NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5a152710dd62cc268aad214e000002d8-1448579216.958613-1512602564 _=/tools/buildbot/bin/python using PTY: False --2015-11-26 15:13:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 10.8M=0.001s 2015-11-26 15:13:57 (10.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.738212 ========= master_lag: 3.84 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2015-11-26 15:14:01.119960) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 15:14:01.120270) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: HOME=/home/cltbld LANG=en_US.UTF-8 LOGNAME=cltbld MAIL=/var/mail/cltbld NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5a152710dd62cc268aad214e000002d8-1448579216.958613-1512602564 _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.030714 ========= master_lag: 0.65 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 15:14:01.796393) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 8 secs) (at 2015-11-26 15:14:01.796748) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 1bf6fd3421e6cb23b386e6e01e718b05453b373a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 1bf6fd3421e6cb23b386e6e01e718b05453b373a --destination scripts --debug'] environment: HOME=/home/cltbld LANG=en_US.UTF-8 LOGNAME=cltbld MAIL=/var/mail/cltbld NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5a152710dd62cc268aad214e000002d8-1448579216.958613-1512602564 _=/tools/buildbot/bin/python using PTY: False 2015-11-26 15:14:01,766 truncating revision to first 12 chars 2015-11-26 15:14:01,766 Setting DEBUG logging. 2015-11-26 15:14:01,766 attempt 1/10 2015-11-26 15:14:01,767 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/1bf6fd3421e6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-26 15:14:02,950 unpacking tar archive at: mozilla-inbound-1bf6fd3421e6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.760588 ========= master_lag: 6.27 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 8 secs) (at 2015-11-26 15:14:09.831254) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-26 15:14:09.831589) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-26 15:14:09.875172) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-26 15:14:09.875447) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-26 15:14:09.875836) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/desktop_unittest.py ...' (results: 0, elapsed: 34 mins, 23 secs) (at 2015-11-26 15:14:09.876122) ========= /tools/buildbot/bin/python scripts/scripts/desktop_unittest.py --cfg unittests/linux_unittest.py --mochitest-suite browser-chrome-chunked --total-chunks 7 --this-chunk 7 --blob-upload-branch mozilla-inbound --download-symbols true in dir /builds/slave/test/. (timeout 1800 secs) (maxTime 12000 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/desktop_unittest.py', '--cfg', 'unittests/linux_unittest.py', '--mochitest-suite', 'browser-chrome-chunked', '--total-chunks', '7', '--this-chunk', '7', '--blob-upload-branch', 'mozilla-inbound', '--download-symbols', 'true'] environment: CCACHE_DIR=/builds/ccache CCACHE_UMASK=002 DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_HIDE_RESULTS_TABLE=1 MOZ_NODE_PATH=/usr/bin/node MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_FAIL_ON_TEST_ERRORS=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5a152710dd62cc268aad214e000002d8-1448579216.958613-1512602564 _=/tools/buildbot/bin/python using PTY: False 15:14:09 INFO - MultiFileLogger online at 20151126 15:14:09 in /builds/slave/test 15:14:09 INFO - Run as scripts/scripts/desktop_unittest.py --cfg unittests/linux_unittest.py --mochitest-suite browser-chrome-chunked --total-chunks 7 --this-chunk 7 --blob-upload-branch mozilla-inbound --download-symbols true 15:14:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:14:09 INFO - {'all_cppunittest_suites': {'cppunittest': {'tests': ('tests/cppunittest',)}}, 15:14:09 INFO - 'all_gtest_suites': {'gtest': ()}, 15:14:09 INFO - 'all_jittest_suites': {'jittest': (), 15:14:09 INFO - 'jittest-chunked': (), 15:14:09 INFO - 'jittest1': ('--total-chunks=2', '--this-chunk=1'), 15:14:09 INFO - 'jittest2': ('--total-chunks=2', '--this-chunk=2')}, 15:14:09 INFO - 'all_mochitest_suites': {'a11y': ('--a11y',), 15:14:09 INFO - 'browser-chrome': ('--browser-chrome',), 15:14:09 INFO - 'browser-chrome-addons': ('--browser-chrome', 15:14:09 INFO - '--chunk-by-runtime', 15:14:09 INFO - '--tag=addons'), 15:14:09 INFO - 'browser-chrome-chunked': ('--browser-chrome', 15:14:09 INFO - '--chunk-by-runtime'), 15:14:09 INFO - 'chrome': ('--chrome',), 15:14:09 INFO - 'chrome-chunked': ('--chrome', '--chunk-by-dir=4'), 15:14:09 INFO - 'jetpack-addon': ('--jetpack-addon',), 15:14:09 INFO - 'jetpack-package': ('--jetpack-package',), 15:14:09 INFO - 'mochitest-devtools-chrome': ('--browser-chrome', 15:14:09 INFO - '--subsuite=devtools'), 15:14:09 INFO - 'mochitest-devtools-chrome-chunked': ('--browser-chrome', 15:14:09 INFO - '--subsuite=devtools', 15:14:09 INFO - '--chunk-by-runtime'), 15:14:09 INFO - 'mochitest-gl': ('--subsuite=webgl',), 15:14:09 INFO - 'mochitest-push': ('--subsuite=push',), 15:14:09 INFO - 'plain': (), 15:14:09 INFO - 'plain-chunked': ('--chunk-by-dir=4',)}, 15:14:09 INFO - 'all_mozbase_suites': {'mozbase': ()}, 15:14:09 INFO - 'all_reftest_suites': {'crashtest': {'options': ('--suite=crashtest',), 15:14:09 INFO - 'tests': ('tests/reftest/tests/testing/crashtest/crashtests.list',)}, 15:14:09 INFO - 'crashtest-ipc': {'env': {'MOZ_DISABLE_CONTEXT_SHARING_GLX': '1', 15:14:09 INFO - 'MOZ_OMTC_ENABLED': '1'}, 15:14:09 INFO - 'options': ('--suite=crashtest', 15:14:09 INFO - '--setpref=browser.tabs.remote=true', 15:14:09 INFO - '--setpref=browser.tabs.remote.autostart=true', 15:14:09 INFO - '--setpref=layers.offmainthreadcomposition.testing.enabled=true', 15:14:09 INFO - '--setpref=layers.async-pan-zoom.enabled=true'), 15:14:09 INFO - 'tests': ('tests/reftest/tests/testing/crashtest/crashtests.list',)}, 15:14:09 INFO - 'jsreftest': {'options': ('--extra-profile-file=tests/jsreftest/tests/user.js', 15:14:09 INFO - '--suite=jstestbrowser'), 15:14:09 INFO - 'tests': ('tests/jsreftest/tests/jstests.list',)}, 15:14:09 INFO - 'reftest': {'options': ('--suite=reftest',), 15:14:09 INFO - 'tests': ('tests/reftest/tests/layout/reftests/reftest.list',)}, 15:14:09 INFO - 'reftest-ipc': {'env': {'MOZ_DISABLE_CONTEXT_SHARING_GLX': '1', 15:14:09 INFO - 'MOZ_OMTC_ENABLED': '1'}, 15:14:09 INFO - 'options': ('--suite=reftest', 15:14:09 INFO - '--setpref=browser.tabs.remote=true', 15:14:09 INFO - '--setpref=browser.tabs.remote.autostart=true', 15:14:09 INFO - '--setpref=layers.offmainthreadcomposition.testing.enabled=true', 15:14:09 INFO - '--setpref=layers.async-pan-zoom.enabled=true'), 15:14:09 INFO - 'tests': ('tests/reftest/tests/layout/reftests/reftest-sanity/reftest.list',)}, 15:14:09 INFO - 'reftest-no-accel': {'options': ('--suite=reftest', 15:14:09 INFO - '--setpref=layers.acceleration.force-enabled=disabled'), 15:14:09 INFO - 'tests': ('tests/reftest/tests/layout/reftests/reftest.list',)}}, 15:14:09 INFO - 'all_webapprt_suites': {'chrome': ('--webapprt-chrome', 15:14:09 INFO - '--browser-arg=-test-mode'), 15:14:09 INFO - 'content': ('--webapprt-content',)}, 15:14:09 INFO - 'all_xpcshell_suites': {'xpcshell': {'options': ('--xpcshell=%(abs_app_dir)s/xpcshell', 15:14:09 INFO - '--manifest=tests/xpcshell/tests/all-test-dirs.list'), 15:14:09 INFO - 'tests': ()}, 15:14:09 INFO - 'xpcshell-addons': {'options': ('--xpcshell=%(abs_app_dir)s/xpcshell', 15:14:09 INFO - '--tag=addons', 15:14:09 INFO - '--manifest=tests/xpcshell/tests/all-test-dirs.list'), 15:14:09 INFO - 'tests': ()}}, 15:14:09 INFO - 'append_to_log': False, 15:14:09 INFO - 'base_work_dir': '/builds/slave/test', 15:14:09 INFO - 'binary_path': '/builds/slave/test/build/firefox/firefox-bin', 15:14:09 INFO - 'blob_upload_branch': 'mozilla-inbound', 15:14:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:14:09 INFO - 'buildbot_json_path': 'buildprops.json', 15:14:09 INFO - 'buildbot_max_log_size': 52428800, 15:14:09 INFO - 'code_coverage': False, 15:14:09 INFO - 'config_files': ('unittests/linux_unittest.py',), 15:14:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:14:09 INFO - 'download_minidump_stackwalk': True, 15:14:09 INFO - 'download_symbols': 'true', 15:14:09 INFO - 'e10s': False, 15:14:09 INFO - 'exe_suffix': '', 15:14:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:14:09 INFO - 'tooltool.py': '/tools/tooltool.py', 15:14:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:14:09 INFO - '/tools/misc-python/virtualenv.py')}, 15:14:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:14:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:14:09 INFO - 'installer_path': '/builds/slave/test/build/installer.tar.bz2', 15:14:09 INFO - 'log_level': 'info', 15:14:09 INFO - 'log_to_console': True, 15:14:09 INFO - 'minidump_save_path': '%(abs_work_dir)s/../minidumps', 15:14:09 INFO - 'minidump_stackwalk_path': 'linux32-minidump_stackwalk', 15:14:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux32/releng.manifest', 15:14:09 INFO - 'minimum_tests_zip_dirs': ('bin/*', 15:14:09 INFO - 'certs/*', 15:14:09 INFO - 'modules/*', 15:14:09 INFO - 'mozbase/*', 15:14:09 INFO - 'config/*'), 15:14:09 INFO - 'no_random': False, 15:14:09 INFO - 'opt_config_files': (), 15:14:09 INFO - 'pip_index': False, 15:14:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:14:09 INFO - 'cmd': ('xset', 's', 'off', 's', 'reset'), 15:14:09 INFO - 'enabled': True, 15:14:09 INFO - 'halt_on_failure': False, 15:14:09 INFO - 'name': 'disable_screen_saver'}, 15:14:09 INFO - {'architectures': ('32bit',), 15:14:09 INFO - 'cmd': ('python', 15:14:09 INFO - '../scripts/external_tools/mouse_and_screen_resolution.py', 15:14:09 INFO - '--configuration-url', 15:14:09 INFO - 'https://hg.mozilla.org/%(branch)s/raw-file/%(revision)s/testing/machine-configuration.json'), 15:14:09 INFO - 'enabled': False, 15:14:09 INFO - 'halt_on_failure': True, 15:14:09 INFO - 'name': 'run mouse & screen adjustment script'}), 15:14:09 INFO - 'require_test_zip': True, 15:14:09 INFO - 'run_all_suites': False, 15:14:09 INFO - 'run_cmd_checks_enabled': True, 15:14:09 INFO - 'run_file_names': {'cppunittest': 'runcppunittests.py', 15:14:09 INFO - 'gtest': 'rungtests.py', 15:14:09 INFO - 'jittest': 'jit_test.py', 15:14:09 INFO - 'mochitest': 'runtests.py', 15:14:09 INFO - 'mozbase': 'test.py', 15:14:09 INFO - 'mozmill': 'runtestlist.py', 15:14:09 INFO - 'reftest': 'runreftest.py', 15:14:09 INFO - 'webapprt': 'runtests.py', 15:14:09 INFO - 'xpcshell': 'runxpcshelltests.py'}, 15:14:09 INFO - 'specific_tests_zip_dirs': {'cppunittest': ('cppunittest/*',), 15:14:09 INFO - 'gtest': ('gtest/*',), 15:14:09 INFO - 'jittest': ('jit-test/*',), 15:14:09 INFO - 'mochitest': ('mochitest/*',), 15:14:09 INFO - 'mozbase': ('mozbase/*',), 15:14:09 INFO - 'mozmill': ('mozmill/*',), 15:14:09 INFO - 'reftest': ('reftest/*', 'jsreftest/*'), 15:14:09 INFO - 'webapprt': ('mochitest/*',), 15:14:09 INFO - 'xpcshell': ('xpcshell/*',)}, 15:14:09 INFO - 'specified_mochitest_suites': ('browser-chrome-chunked',), 15:14:09 INFO - 'strict_content_sandbox': False, 15:14:09 INFO - 'suite_definitions': {'cppunittest': {'options': ('--symbols-path=%(symbols_path)s', 15:14:09 INFO - '--xre-path=%(abs_app_dir)s'), 15:14:09 INFO - 'run_filename': 'runcppunittests.py', 15:14:09 INFO - 'testsdir': 'cppunittest'}, 15:14:09 INFO - 'gtest': {'options': ('--xre-path=%(abs_res_dir)s', 15:14:09 INFO - '--cwd=%(gtest_dir)s', 15:14:09 INFO - '--symbols-path=%(symbols_path)s', 15:14:09 INFO - '%(binary_path)s'), 15:14:09 INFO - 'run_filename': 'rungtests.py'}, 15:14:09 INFO - 'jittest': {'options': ('tests/bin/js', 15:14:09 INFO - '--no-slow', 15:14:09 INFO - '--no-progress', 15:14:09 INFO - '--format=automation', 15:14:09 INFO - '--jitflags=all'), 15:14:09 INFO - 'run_filename': 'jit_test.py', 15:14:09 INFO - 'testsdir': 'jit-test/jit-test'}, 15:14:09 INFO - 'luciddream-b2gdt': {'options': ('--startup-timeout=300', 15:14:09 INFO - '--log-raw=%(raw_log_file)s', 15:14:09 INFO - '--log-errorsummary=%(error_summary_file)s', 15:14:09 INFO - '--browser-path=%(browser_path)s', 15:14:09 INFO - '--b2g-desktop-path=%(fxos_desktop_path)s', 15:14:09 INFO - '--gaia-profile=%(gaia_profile)s', 15:14:09 INFO - '%(test_manifest)s')}, 15:14:09 INFO - 'luciddream-emulator': {'options': ('--startup-timeout=300', 15:14:09 INFO - '--log-raw=%(raw_log_file)s', 15:14:09 INFO - '--log-errorsummary=%(error_summary_file)s', 15:14:09 INFO - '--browser-path=%(browser_path)s', 15:14:09 INFO - '--b2gpath=%(emulator_path)s', 15:14:09 INFO - '%(test_manifest)s')}, 15:14:09 INFO - 'mochitest': {'options': ('--appname=%(binary_path)s', 15:14:09 INFO - '--utility-path=tests/bin', 15:14:09 INFO - '--extra-profile-file=tests/bin/plugins', 15:14:09 INFO - '--symbols-path=%(symbols_path)s', 15:14:09 INFO - '--certificate-path=tests/certs', 15:14:09 INFO - '--setpref=webgl.force-enabled=true', 15:14:10 INFO - '--quiet', 15:14:10 INFO - '--log-raw=%(raw_log_file)s', 15:14:10 INFO - '--log-errorsummary=%(error_summary_file)s', 15:14:10 INFO - '--use-test-media-devices', 15:14:10 INFO - '--screenshot-on-fail'), 15:14:10 INFO - 'run_filename': 'runtests.py', 15:14:10 INFO - 'testsdir': 'mochitest'}, 15:14:10 INFO - 'mozbase': {'options': ('-b', '%(binary_path)s'), 15:14:10 INFO - 'run_filename': 'test.py', 15:14:10 INFO - 'testsdir': 'mozbase'}, 15:14:10 INFO - 'mozmill': {'options': ('--binary=%(binary_path)s', 15:14:10 INFO - '--testing-modules-dir=test/modules', 15:14:10 INFO - '--symbols-path=%(symbols_path)s'), 15:14:10 INFO - 'run_filename': 'runtestlist.py', 15:14:10 INFO - 'testsdir': 'mozmill'}, 15:14:10 INFO - 'reftest': {'options': ('--appname=%(binary_path)s', 15:14:10 INFO - '--utility-path=tests/bin', 15:14:10 INFO - '--extra-profile-file=tests/bin/plugins', 15:14:10 INFO - '--symbols-path=%(symbols_path)s'), 15:14:10 INFO - 'run_filename': 'runreftest.py', 15:14:10 INFO - 'testsdir': 'reftest'}, 15:14:10 INFO - 'webapprt': {'options': ('--app=%(app_path)s', 15:14:10 INFO - '--utility-path=tests/bin', 15:14:10 INFO - '--extra-profile-file=tests/bin/plugins', 15:14:10 INFO - '--symbols-path=%(symbols_path)s', 15:14:10 INFO - '--certificate-path=tests/certs', 15:14:10 INFO - '--console-level=INFO', 15:14:10 INFO - '--testing-modules-dir=tests/modules', 15:14:10 INFO - '--quiet'), 15:14:10 INFO - 'run_filename': 'runtests.py', 15:14:10 INFO - 'testsdir': 'mochitest'}, 15:14:10 INFO - 'xpcshell': {'options': ('--symbols-path=%(symbols_path)s', 15:14:10 INFO - '--test-plugin-path=%(test_plugin_path)s', 15:14:10 INFO - '--log-raw=%(raw_log_file)s', 15:14:10 INFO - '--log-errorsummary=%(error_summary_file)s', 15:14:10 INFO - '--utility-path=tests/bin'), 15:14:10 INFO - 'run_filename': 'runxpcshelltests.py', 15:14:10 INFO - 'testsdir': 'xpcshell'}}, 15:14:10 INFO - 'this_chunk': '7', 15:14:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:14:10 INFO - 'total_chunks': '7', 15:14:10 INFO - 'vcs_output_timeout': 1000, 15:14:10 INFO - 'virtualenv_path': 'venv', 15:14:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:14:10 INFO - 'work_dir': 'build', 15:14:10 INFO - 'xpcshell_name': 'xpcshell'} 15:14:10 INFO - ##### 15:14:10 INFO - ##### Running clobber step. 15:14:10 INFO - ##### 15:14:10 INFO - Running pre-action listener: _resource_record_pre_action 15:14:10 INFO - Running main action method: clobber 15:14:10 INFO - rmtree: /builds/slave/test/build 15:14:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:14:10 INFO - Running post-action listener: _resource_record_post_action 15:14:10 INFO - ##### 15:14:10 INFO - ##### Running read-buildbot-config step. 15:14:10 INFO - ##### 15:14:10 INFO - Running pre-action listener: _resource_record_pre_action 15:14:10 INFO - Running main action method: read_buildbot_config 15:14:10 INFO - Using buildbot properties: 15:14:10 INFO - { 15:14:10 INFO - "properties": { 15:14:10 INFO - "buildnumber": 93, 15:14:10 INFO - "product": "firefox", 15:14:10 INFO - "script_repo_revision": "production", 15:14:10 INFO - "branch": "mozilla-inbound", 15:14:10 INFO - "repository": "", 15:14:10 INFO - "buildername": "Ubuntu VM 12.04 mozilla-inbound debug test mochitest-browser-chrome-7", 15:14:10 INFO - "buildid": "20151126135412", 15:14:10 INFO - "slavename": "tst-linux32-spot-287", 15:14:10 INFO - "pgo_build": "False", 15:14:10 INFO - "basedir": "/builds/slave/test", 15:14:10 INFO - "project": "", 15:14:10 INFO - "platform": "linux", 15:14:10 INFO - "master": "http://buildbot-master02.bb.releng.use1.mozilla.com:8201/", 15:14:10 INFO - "slavebuilddir": "test", 15:14:10 INFO - "scheduler": "tests-mozilla-inbound-ubuntu32_vm-debug-unittest-7-3600", 15:14:10 INFO - "repo_path": "integration/mozilla-inbound", 15:14:10 INFO - "moz_repo_path": "", 15:14:10 INFO - "stage_platform": "linux", 15:14:10 INFO - "builduid": "a6f63bb04be644bfadd7d5956ee0532b", 15:14:10 INFO - "revision": "1bf6fd3421e6cb23b386e6e01e718b05453b373a" 15:14:10 INFO - }, 15:14:10 INFO - "sourcestamp": { 15:14:10 INFO - "repository": "", 15:14:10 INFO - "hasPatch": false, 15:14:10 INFO - "project": "", 15:14:10 INFO - "branch": "mozilla-inbound-linux-debug-unittest", 15:14:10 INFO - "changes": [ 15:14:10 INFO - { 15:14:10 INFO - "category": null, 15:14:10 INFO - "files": [ 15:14:10 INFO - { 15:14:10 INFO - "url": null, 15:14:10 INFO - "name": "https://queue.taskcluster.net/v1/task/KKlMY5EFQ_iHocabRVXaPw/artifacts/public/build/firefox-45.0a1.en-US.linux-i686.tar.bz2" 15:14:10 INFO - }, 15:14:10 INFO - { 15:14:10 INFO - "url": null, 15:14:10 INFO - "name": "https://queue.taskcluster.net/v1/task/KKlMY5EFQ_iHocabRVXaPw/artifacts/public/build/test_packages.json" 15:14:10 INFO - } 15:14:10 INFO - ], 15:14:10 INFO - "repository": "", 15:14:10 INFO - "rev": "2fa7dd926187b890c08f8737de58c5b22e219da6", 15:14:10 INFO - "who": "tnikkel@gmail.com", 15:14:10 INFO - "when": 1448575134, 15:14:10 INFO - "number": 6712646, 15:14:10 INFO - "comments": "Bug 1228033. When not painting to a window (and hence not retained) only have one AGR, the root AGR. r=mattwoodrow\n\nThe document structure of when printing is as follows:\n\nViewportFrame\n nsSimplePageSequenceFrame\n nsPageFrame\n (the content of the page)\n nsPageFrame\n (the content of the page)\n (further pages)\n\nThe nsSimplePageSequenceFrame calls nsLayoutUtils::PaintFrame with each nsPageFrame as the frame to paint.\n\nnsPageFrame::BuildDisplayList will build display lists inside sibling nsPageFrames if it needs to descend into those sibling page frames to find placeholder frames for out of flow frames that are on the actual current page frame. Since these are sibling page frames they are not in the original page frame subtree, and hence we can't find an AGR for them that is in the original page frames subtree.\n\nHowever, when printing we don't retain painted content, so there is no point in having more than one AGR. So if we aren't retaining (IsPaintingToWindow is necessary for that) then just", 15:14:10 INFO - "project": "", 15:14:10 INFO - "at": "Thu 26 Nov 2015 13:58:54", 15:14:10 INFO - "branch": "mozilla-inbound-linux-debug-unittest", 15:14:10 INFO - "revlink": "", 15:14:10 INFO - "properties": [ 15:14:10 INFO - [ 15:14:10 INFO - "buildid", 15:14:10 INFO - "20151126125812", 15:14:10 INFO - "Change" 15:14:10 INFO - ], 15:14:10 INFO - [ 15:14:10 INFO - "builduid", 15:14:10 INFO - "547389da4efa496dba81d4fedb6fbb55", 15:14:10 INFO - "Change" 15:14:10 INFO - ], 15:14:10 INFO - [ 15:14:10 INFO - "pgo_build", 15:14:10 INFO - "False", 15:14:10 INFO - "Change" 15:14:10 INFO - ] 15:14:10 INFO - ], 15:14:10 INFO - "revision": "2fa7dd926187b890c08f8737de58c5b22e219da6" 15:14:10 INFO - }, 15:14:10 INFO - { 15:14:10 INFO - "category": null, 15:14:10 INFO - "files": [ 15:14:10 INFO - { 15:14:10 INFO - "url": null, 15:14:10 INFO - "name": "https://queue.taskcluster.net/v1/task/1HfgMipqQuOMhKR3jEKVbA/artifacts/public/build/firefox-45.0a1.en-US.linux-i686.tar.bz2" 15:14:10 INFO - }, 15:14:10 INFO - { 15:14:10 INFO - "url": null, 15:14:10 INFO - "name": "https://queue.taskcluster.net/v1/task/1HfgMipqQuOMhKR3jEKVbA/artifacts/public/build/test_packages.json" 15:14:10 INFO - } 15:14:10 INFO - ], 15:14:10 INFO - "repository": "", 15:14:10 INFO - "rev": "ff34a06cb439e6988e91cc78f3999e8012b7f835", 15:14:10 INFO - "who": "opettay@mozilla.com", 15:14:10 INFO - "when": 1448573773, 15:14:10 INFO - "number": 6712592, 15:14:10 INFO - "comments": "Bug 789315, notify MutationObservers before running
%20%20%20%20] 15:22:05 INFO - --DOMWINDOW == 213 (0x81971c00) [pid = 1906] [serial = 454] [outer = (nil)] [url = about:blank] 15:22:05 INFO - --DOMWINDOW == 212 (0x7cfba800) [pid = 1906] [serial = 520] [outer = (nil)] [url = about:blank] 15:22:05 INFO - --DOMWINDOW == 211 (0x7cfb4c00) [pid = 1906] [serial = 440] [outer = (nil)] [url = about:plugins] 15:22:05 INFO - --DOMWINDOW == 210 (0x90db7000) [pid = 1906] [serial = 487] [outer = (nil)] [url = about:customizing] 15:22:05 INFO - --DOMWINDOW == 209 (0x7ada0800) [pid = 1906] [serial = 512] [outer = (nil)] [url = about:blank] 15:22:05 INFO - --DOMWINDOW == 208 (0x909ad400) [pid = 1906] [serial = 484] [outer = (nil)] [url = http://example.org/browser/browser/base/content/test/general/dummy_page.html] 15:22:05 INFO - --DOMWINDOW == 207 (0x7d52e400) [pid = 1906] [serial = 442] [outer = (nil)] [url = about:buildconfig] 15:22:05 INFO - --DOMWINDOW == 206 (0x943fbc00) [pid = 1906] [serial = 506] [outer = (nil)] [url = about:customizing] 15:22:05 INFO - --DOMWINDOW == 205 (0x7d74d800) [pid = 1906] [serial = 444] [outer = (nil)] [url = data:text/html,
] 15:22:05 INFO - --DOMWINDOW == 204 (0x9099f400) [pid = 1906] [serial = 478] [outer = (nil)] [url = about:blank] 15:22:05 INFO - --DOMWINDOW == 203 (0x7c0fe000) [pid = 1906] [serial = 436] [outer = (nil)] [url = about:blank] 15:22:05 INFO - --DOMWINDOW == 202 (0x8f491c00) [pid = 1906] [serial = 474] [outer = (nil)] [url = data:text/html,%20] 15:22:05 INFO - --DOMWINDOW == 201 (0x7ccdd000) [pid = 1906] [serial = 516] [outer = (nil)] [url = about:blank] 15:22:05 INFO - --DOMWINDOW == 200 (0x8b64b400) [pid = 1906] [serial = 464] [outer = (nil)] [url = about:blank] 15:22:05 INFO - --DOMWINDOW == 199 (0x804c3c00) [pid = 1906] [serial = 271] [outer = (nil)] [url = about:newtab] 15:22:05 INFO - --DOMWINDOW == 198 (0x7b341000) [pid = 1906] [serial = 449] [outer = (nil)] [url = chrome://global/content/directionDetector.html] 15:22:05 INFO - --DOMWINDOW == 197 (0x91902000) [pid = 1906] [serial = 498] [outer = (nil)] [url = about:newtab] 15:22:05 INFO - --DOMWINDOW == 196 (0x7d34f000) [pid = 1906] [serial = 525] [outer = (nil)] [url = about:certerror?e=nssBadCert&u=https%3A//nocert.example.com/&s=expertBadCert&c=UTF-8&f=regular&d=nocert.example.com%20uses%20an%20invalid%20security%20certificate.%0A%0AThe%20certificate%20is%20only%20valid%20for%20the%20following%20names%3A%0A%20%20example.com%2C%20test1.example.com%2C%20test2.example.com%2C%20example.org%2C%20test1.example.org%2C%20test2.example.org%2C%20sub1.test1.example.com%2C%20sub1.test2.example.com%2C%20sub2.test1.example.com%2C%20sub2.test2.example.com%2C%20requestclientcert.example.com%2C%20requireclientcert.example.com%2C%20xn--hxajbheg2az3al.xn--jxalpdlp%2C%20sub1.xn--hxajbheg2az3al.xn--jxalpdlp%2C%20sectest1.example.org%2C%20sub.sectest2.example.org%2C%20sectest2.example.org%2C%20sub.sectest1.example.org%2C%20malware.example.com%2C%20tracking.example.com%2C%20not-tracking.example.com%2C%20tracking.example.org%2C%20redirproxy.example.com%2C%20w3c-test.org%2C%20www.w3c-test.org%2C%20www1.w3c-test.org%2C%20www2.w3c-test.org%2C%20xn--n8j6ds53lwwkrqhv28a.w3c-te] 15:22:05 INFO - --DOMWINDOW == 195 (0x7dba7800) [pid = 1906] [serial = 451] [outer = (nil)] [url = about:blank] 15:22:05 INFO - --DOMWINDOW == 194 (0x8f1f6c00) [pid = 1906] [serial = 468] [outer = (nil)] [url = http://mochi.test:8888/browser/browser/base/content/test/general/zoom_test.html] 15:22:05 INFO - --DOMWINDOW == 193 (0x7af72800) [pid = 1906] [serial = 514] [outer = (nil)] [url = data:text/html,test] 15:22:05 INFO - --DOMWINDOW == 192 (0x8f126800) [pid = 1906] [serial = 466] [outer = (nil)] [url = about:blank] 15:22:05 INFO - --DOMWINDOW == 191 (0x819dbc00) [pid = 1906] [serial = 457] [outer = (nil)] [url = data:text/html,
] 15:22:05 INFO - --DOMWINDOW == 190 (0x7c4de800) [pid = 1906] [serial = 524] [outer = (nil)] [url = about:blank] 15:22:05 INFO - --DOMWINDOW == 189 (0x7d532800) [pid = 1906] [serial = 526] [outer = (nil)] [url = about:blank] 15:22:05 INFO - --DOMWINDOW == 188 (0x7c2cb400) [pid = 1906] [serial = 438] [outer = (nil)] [url = about:config] 15:22:05 INFO - --DOMWINDOW == 187 (0x91d60800) [pid = 1906] [serial = 501] [outer = (nil)] [url = chrome://browser/content/browser.xul] 15:22:05 INFO - --DOMWINDOW == 186 (0x7ccda400) [pid = 1906] [serial = 439] [outer = (nil)] [url = about:blank] 15:22:05 INFO - --DOMWINDOW == 185 (0x80625c00) [pid = 1906] [serial = 453] [outer = (nil)] [url = about:blank] 15:22:05 INFO - --DOMWINDOW == 184 (0x98e97800) [pid = 1906] [serial = 510] [outer = (nil)] [url = about:blank] 15:22:05 INFO - --DOMWINDOW == 183 (0x7c112800) [pid = 1906] [serial = 437] [outer = (nil)] [url = about:blank] 15:22:05 INFO - --DOMWINDOW == 182 (0x96cabc00) [pid = 1906] [serial = 507] [outer = (nil)] [url = about:blank] 15:22:05 INFO - --DOMWINDOW == 181 (0x90827000) [pid = 1906] [serial = 475] [outer = (nil)] [url = about:blank] 15:22:05 INFO - --DOMWINDOW == 180 (0x7cfc2000) [pid = 1906] [serial = 522] [outer = (nil)] [url = about:blank] 15:22:05 INFO - --DOMWINDOW == 179 (0x7cf0ac00) [pid = 1906] [serial = 517] [outer = (nil)] [url = about:blank] 15:22:05 INFO - --DOMWINDOW == 178 (0x8ef04000) [pid = 1906] [serial = 465] [outer = (nil)] [url = about:blank] 15:22:05 INFO - --DOMWINDOW == 177 (0x90daf000) [pid = 1906] [serial = 485] [outer = (nil)] [url = about:blank] 15:22:05 INFO - --DOMWINDOW == 176 (0x7c4e0c00) [pid = 1906] [serial = 450] [outer = (nil)] [url = chrome://global/content/directionDetector.html] 15:22:05 INFO - --DOMWINDOW == 175 (0x90d94800) [pid = 1906] [serial = 481] [outer = (nil)] [url = about:blank] 15:22:05 INFO - --DOMWINDOW == 174 (0x9190a000) [pid = 1906] [serial = 496] [outer = (nil)] [url = about:blank] 15:22:05 INFO - --DOMWINDOW == 173 (0x91d63000) [pid = 1906] [serial = 499] [outer = (nil)] [url = about:blank] 15:22:05 INFO - --DOMWINDOW == 172 (0x8186c800) [pid = 1906] [serial = 452] [outer = (nil)] [url = about:blank] 15:22:05 INFO - --DOMWINDOW == 171 (0x8f66e000) [pid = 1906] [serial = 473] [outer = (nil)] [url = http://mochi.test:8888/browser/browser/base/content/test/general/zoom_test.html] 15:22:05 INFO - --DOMWINDOW == 170 (0x7b121800) [pid = 1906] [serial = 515] [outer = (nil)] [url = about:blank] 15:22:05 INFO - --DOMWINDOW == 169 (0x8f1f1c00) [pid = 1906] [serial = 467] [outer = (nil)] [url = about:blank] 15:22:05 INFO - --DOMWINDOW == 168 (0x8aed6800) [pid = 1906] [serial = 459] [outer = (nil)] [url = about:blank] 15:22:05 INFO - --DOMWINDOW == 167 (0x8b3d9000) [pid = 1906] [serial = 463] [outer = (nil)] [url = about:blank] 15:22:05 INFO - --DOMWINDOW == 166 (0x90d97c00) [pid = 1906] [serial = 482] [outer = (nil)] [url = about:blank] 15:22:05 INFO - --DOMWINDOW == 165 (0x8f473c00) [pid = 1906] [serial = 469] [outer = (nil)] [url = about:blank] 15:22:05 INFO - --DOMWINDOW == 164 (0x9082dc00) [pid = 1906] [serial = 477] [outer = (nil)] [url = data:text/html,text%20text] 15:22:05 INFO - --DOMWINDOW == 163 (0x8197a400) [pid = 1906] [serial = 455] [outer = (nil)] [url = about:blank] 15:22:05 INFO - --DOMWINDOW == 162 (0x7d347800) [pid = 1906] [serial = 521] [outer = (nil)] [url = about:blank] 15:22:05 INFO - --DOMWINDOW == 161 (0x819df000) [pid = 1906] [serial = 458] [outer = (nil)] [url = about:blank] 15:22:05 INFO - --DOMWINDOW == 160 (0x7cffb800) [pid = 1906] [serial = 441] [outer = (nil)] [url = about:blank] 15:22:05 INFO - --DOMWINDOW == 159 (0x9105c000) [pid = 1906] [serial = 488] [outer = (nil)] [url = about:blank] 15:22:05 INFO - --DOMWINDOW == 158 (0x7adad400) [pid = 1906] [serial = 470] [outer = (nil)] [url = about:blank] 15:22:05 INFO - --DOMWINDOW == 157 (0x8f488800) [pid = 1906] [serial = 471] [outer = (nil)] [url = http://mochi.test:8888/browser/browser/base/content/test/general/zoom_test.html] 15:22:05 INFO - --DOMWINDOW == 156 (0x7adc7400) [pid = 1906] [serial = 513] [outer = (nil)] [url = about:blank] 15:22:05 INFO - --DOMWINDOW == 155 (0x7db9f800) [pid = 1906] [serial = 445] [outer = (nil)] [url = about:blank] 15:22:05 INFO - --DOMWINDOW == 154 (0x909a9000) [pid = 1906] [serial = 479] [outer = (nil)] [url = about:blank] 15:22:05 INFO - --DOMWINDOW == 153 (0x8aedd000) [pid = 1906] [serial = 460] [outer = (nil)] [url = data:text/html,
] 15:22:05 INFO - --DOMWINDOW == 152 (0x7d5a2000) [pid = 1906] [serial = 443] [outer = (nil)] [url = about:blank] 15:22:05 INFO - ++DOMWINDOW == 153 (0x7cfba800) [pid = 1906] [serial = 649] [outer = 0x7cff6c00] 15:22:06 INFO - --DOMWINDOW == 152 (0x7d53a400) [pid = 1906] [serial = 527] [outer = (nil)] [url = about:certerror?e=nssBadCert&u=https%3A//nocert.example.com/&c=UTF-8&f=regular&d=nocert.example.com%20uses%20an%20invalid%20security%20certificate.%0A%0AThe%20certificate%20is%20only%20valid%20for%20the%20following%20names%3A%0A%20%20example.com%2C%20test1.example.com%2C%20test2.example.com%2C%20example.org%2C%20test1.example.org%2C%20test2.example.org%2C%20sub1.test1.example.com%2C%20sub1.test2.example.com%2C%20sub2.test1.example.com%2C%20sub2.test2.example.com%2C%20requestclientcert.example.com%2C%20requireclientcert.example.com%2C%20xn--hxajbheg2az3al.xn--jxalpdlp%2C%20sub1.xn--hxajbheg2az3al.xn--jxalpdlp%2C%20sectest1.example.org%2C%20sub.sectest2.example.org%2C%20sectest2.example.org%2C%20sub.sectest1.example.org%2C%20malware.example.com%2C%20tracking.example.com%2C%20not-tracking.example.com%2C%20tracking.example.org%2C%20redirproxy.example.com%2C%20w3c-test.org%2C%20www.w3c-test.org%2C%20www1.w3c-test.org%2C%20www2.w3c-test.org%2C%20xn--n8j6ds53lwwkrqhv28a.w3c-test.org%2C%20xn--] 15:22:06 INFO - --DOMWINDOW == 151 (0x80355000) [pid = 1906] [serial = 483] [outer = (nil)] [url = http://example.org/browser/browser/base/content/test/general/dummy_page.html] 15:22:06 INFO - --DOMWINDOW == 150 (0x8f495800) [pid = 1906] [serial = 472] [outer = (nil)] [url = http://mochi.test:8888/browser/browser/base/content/test/general/moz.png] 15:22:06 INFO - --DOMWINDOW == 149 (0x7d346400) [pid = 1906] [serial = 486] [outer = (nil)] [url = http://example.org/browser/browser/base/content/test/general/dummy_page.html] 15:22:06 INFO - --DOMWINDOW == 148 (0x80621000) [pid = 1906] [serial = 448] [outer = (nil)] [url = about:buildconfig] 15:22:06 INFO - --DOMWINDOW == 147 (0x7b1c4c00) [pid = 1906] [serial = 528] [outer = (nil)] [url = about:certerror?e=nssBadCert&u=https%3A//nocert.example.com/&s=expertBadCert&c=UTF-8&f=regular&d=nocert.example.com%20uses%20an%20invalid%20security%20certificate.%0A%0AThe%20certificate%20is%20only%20valid%20for%20the%20following%20names%3A%0A%20%20example.com%2C%20test1.example.com%2C%20test2.example.com%2C%20example.org%2C%20test1.example.org%2C%20test2.example.org%2C%20sub1.test1.example.com%2C%20sub1.test2.example.com%2C%20sub2.test1.example.com%2C%20sub2.test2.example.com%2C%20requestclientcert.example.com%2C%20requireclientcert.example.com%2C%20xn--hxajbheg2az3al.xn--jxalpdlp%2C%20sub1.xn--hxajbheg2az3al.xn--jxalpdlp%2C%20sectest1.example.org%2C%20sub.sectest2.example.org%2C%20sectest2.example.org%2C%20sub.sectest1.example.org%2C%20malware.example.com%2C%20tracking.example.com%2C%20not-tracking.example.com%2C%20tracking.example.org%2C%20redirproxy.example.com%2C%20w3c-test.org%2C%20www.w3c-test.org%2C%20www1.w3c-test.org%2C%20www2.w3c-test.org%2C%20xn--n8j6ds53lwwkrqhv28a.w3c-te] 15:22:06 INFO - ++DOMWINDOW == 148 (0x7b341800) [pid = 1906] [serial = 650] [outer = 0x7cff6c00] 15:22:06 INFO - JavaScript error: chrome://browser/content/browser.js, line 13356: TypeError: PanelUI.panel is undefined 15:22:06 INFO - --DOCSHELL 0x7c4dcc00 == 64 [pid = 1906] [id = 233] 15:22:06 INFO - MEMORY STAT | vsize 980MB | residentFast 326MB | heapAllocated 104MB 15:22:06 INFO - 132 INFO TEST-OK | browser/base/content/test/general/browser_bug484315.js | took 3149ms 15:22:06 INFO - ++DOCSHELL 0x7ccda400 == 65 [pid = 1906] [id = 235] 15:22:06 INFO - ++DOMWINDOW == 149 (0x7cff6800) [pid = 1906] [serial = 651] [outer = (nil)] 15:22:06 INFO - ++DOMWINDOW == 150 (0x7d74b400) [pid = 1906] [serial = 652] [outer = 0x7cff6800] 15:22:07 INFO - 133 INFO TEST-START | browser/base/content/test/general/browser_bug491431.js 15:22:07 INFO - ++DOCSHELL 0x7cff4800 == 66 [pid = 1906] [id = 236] 15:22:07 INFO - ++DOMWINDOW == 151 (0x7cff4c00) [pid = 1906] [serial = 653] [outer = (nil)] 15:22:07 INFO - ++DOMWINDOW == 152 (0x7d537800) [pid = 1906] [serial = 654] [outer = 0x7cff4c00] 15:22:07 INFO - ++DOCSHELL 0x7d596400 == 67 [pid = 1906] [id = 237] 15:22:07 INFO - ++DOMWINDOW == 153 (0x7d596c00) [pid = 1906] [serial = 655] [outer = (nil)] 15:22:07 INFO - ++DOMWINDOW == 154 (0x7d765400) [pid = 1906] [serial = 656] [outer = 0x7d596c00] 15:22:07 INFO - ++DOCSHELL 0x7d764c00 == 68 [pid = 1906] [id = 238] 15:22:07 INFO - ++DOMWINDOW == 155 (0x7dba5000) [pid = 1906] [serial = 657] [outer = (nil)] 15:22:07 INFO - ++DOMWINDOW == 156 (0x7dba6800) [pid = 1906] [serial = 658] [outer = 0x7dba5000] 15:22:08 INFO - ++DOCSHELL 0x7af72800 == 69 [pid = 1906] [id = 239] 15:22:08 INFO - ++DOMWINDOW == 157 (0x7b114c00) [pid = 1906] [serial = 659] [outer = (nil)] 15:22:08 INFO - ++DOCSHELL 0x7b116800 == 70 [pid = 1906] [id = 240] 15:22:08 INFO - ++DOMWINDOW == 158 (0x7b117000) [pid = 1906] [serial = 660] [outer = (nil)] 15:22:08 INFO - ++DOMWINDOW == 159 (0x7b11c000) [pid = 1906] [serial = 661] [outer = 0x7b117000] 15:22:08 INFO - ++DOCSHELL 0x7c2d4800 == 71 [pid = 1906] [id = 241] 15:22:08 INFO - ++DOMWINDOW == 160 (0x7c4de800) [pid = 1906] [serial = 662] [outer = (nil)] 15:22:09 INFO - ++DOMWINDOW == 161 (0x7ccdd800) [pid = 1906] [serial = 663] [outer = 0x7c4de800] 15:22:09 INFO - ++DOMWINDOW == 162 (0x7cfb7400) [pid = 1906] [serial = 664] [outer = 0x7b114c00] 15:22:09 INFO - ++DOMWINDOW == 163 (0x7b1cb400) [pid = 1906] [serial = 665] [outer = 0x7b117000] 15:22:09 INFO - ++DOMWINDOW == 164 (0x7d347800) [pid = 1906] [serial = 666] [outer = 0x7c4de800] 15:22:10 INFO - [1906] WARNING: NS_ENSURE_TRUE(!mParent || mParent == docLoaderService) failed: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/docshell/base/nsDocShell.cpp, line 3157 15:22:10 INFO - [1906] WARNING: NS_ENSURE_TRUE(!mParent || mParent == docLoaderService) failed: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/docshell/base/nsDocShell.cpp, line 3157 15:22:11 INFO - MEMORY STAT | vsize 980MB | residentFast 327MB | heapAllocated 105MB 15:22:11 INFO - 134 INFO TEST-OK | browser/base/content/test/general/browser_bug491431.js | took 4403ms 15:22:11 INFO - ++DOCSHELL 0x7b42b800 == 72 [pid = 1906] [id = 242] 15:22:11 INFO - ++DOMWINDOW == 165 (0x7b42fc00) [pid = 1906] [serial = 667] [outer = (nil)] 15:22:11 INFO - ++DOMWINDOW == 166 (0x7c2d2c00) [pid = 1906] [serial = 668] [outer = 0x7b42fc00] 15:22:12 INFO - 135 INFO TEST-START | browser/base/content/test/general/browser_bug495058.js 15:22:12 INFO - ++DOCSHELL 0x7dba9800 == 73 [pid = 1906] [id = 243] 15:22:12 INFO - ++DOMWINDOW == 167 (0x8034f000) [pid = 1906] [serial = 669] [outer = (nil)] 15:22:12 INFO - ++DOMWINDOW == 168 (0x80427000) [pid = 1906] [serial = 670] [outer = 0x8034f000] 15:22:12 INFO - ++DOCSHELL 0x80357000 == 74 [pid = 1906] [id = 244] 15:22:12 INFO - ++DOMWINDOW == 169 (0x803f7800) [pid = 1906] [serial = 671] [outer = (nil)] 15:22:12 INFO - ++DOMWINDOW == 170 (0x8042d800) [pid = 1906] [serial = 672] [outer = 0x803f7800] 15:22:12 INFO - ++DOMWINDOW == 171 (0x8047bc00) [pid = 1906] [serial = 673] [outer = 0x8034f000] 15:22:12 INFO - ++DOCSHELL 0x8061fc00 == 75 [pid = 1906] [id = 245] 15:22:12 INFO - ++DOMWINDOW == 172 (0x80620000) [pid = 1906] [serial = 674] [outer = (nil)] 15:22:12 INFO - ++DOCSHELL 0x80621000 == 76 [pid = 1906] [id = 246] 15:22:12 INFO - ++DOMWINDOW == 173 (0x80621400) [pid = 1906] [serial = 675] [outer = (nil)] 15:22:12 INFO - ++DOMWINDOW == 174 (0x80624800) [pid = 1906] [serial = 676] [outer = 0x80621400] 15:22:13 INFO - ++DOCSHELL 0x80efe800 == 77 [pid = 1906] [id = 247] 15:22:13 INFO - ++DOMWINDOW == 175 (0x80efec00) [pid = 1906] [serial = 677] [outer = (nil)] 15:22:13 INFO - ++DOMWINDOW == 176 (0x8166fc00) [pid = 1906] [serial = 678] [outer = 0x80efec00] 15:22:13 INFO - ++DOMWINDOW == 177 (0x81668c00) [pid = 1906] [serial = 679] [outer = 0x80620000] 15:22:13 INFO - ++DOMWINDOW == 178 (0x8172f800) [pid = 1906] [serial = 680] [outer = 0x80621400] 15:22:13 INFO - ++DOMWINDOW == 179 (0x81732400) [pid = 1906] [serial = 681] [outer = 0x80efec00] 15:22:14 INFO - [1906] WARNING: NS_ENSURE_TRUE(!mParent || mParent == docLoaderService) failed: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/docshell/base/nsDocShell.cpp, line 3157 15:22:14 INFO - [1906] WARNING: NS_ENSURE_TRUE(!mParent || mParent == docLoaderService) failed: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/docshell/base/nsDocShell.cpp, line 3157 15:22:14 INFO - ++DOCSHELL 0x81978000 == 78 [pid = 1906] [id = 248] 15:22:14 INFO - ++DOMWINDOW == 180 (0x8197c000) [pid = 1906] [serial = 682] [outer = (nil)] 15:22:14 INFO - ++DOMWINDOW == 181 (0x819d6000) [pid = 1906] [serial = 683] [outer = 0x8197c000] 15:22:15 INFO - ++DOMWINDOW == 182 (0x8186e800) [pid = 1906] [serial = 684] [outer = 0x8197c000] 15:22:15 INFO - [1906] WARNING: attempt to modify an immutable nsStandardURL: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/netwerk/base/nsStandardURL.cpp, line 1302 15:22:16 INFO - ++DOCSHELL 0x81872c00 == 79 [pid = 1906] [id = 249] 15:22:16 INFO - ++DOMWINDOW == 183 (0x81873000) [pid = 1906] [serial = 685] [outer = (nil)] 15:22:16 INFO - ++DOMWINDOW == 184 (0x81873800) [pid = 1906] [serial = 686] [outer = 0x81873000] 15:22:16 INFO - ++DOCSHELL 0x8ad74c00 == 80 [pid = 1906] [id = 250] 15:22:16 INFO - ++DOMWINDOW == 185 (0x8ad75400) [pid = 1906] [serial = 687] [outer = (nil)] 15:22:16 INFO - ++DOCSHELL 0x8ad76400 == 81 [pid = 1906] [id = 251] 15:22:16 INFO - ++DOMWINDOW == 186 (0x8ad77000) [pid = 1906] [serial = 688] [outer = (nil)] 15:22:16 INFO - ++DOMWINDOW == 187 (0x8ad7bc00) [pid = 1906] [serial = 689] [outer = 0x8ad77000] 15:22:16 INFO - ++DOCSHELL 0x8b3d5000 == 82 [pid = 1906] [id = 252] 15:22:16 INFO - ++DOMWINDOW == 188 (0x8b3d7000) [pid = 1906] [serial = 690] [outer = (nil)] 15:22:16 INFO - ++DOMWINDOW == 189 (0x8b606800) [pid = 1906] [serial = 691] [outer = 0x8b3d7000] 15:22:16 INFO - ++DOMWINDOW == 190 (0x8b3d8c00) [pid = 1906] [serial = 692] [outer = 0x8ad75400] 15:22:16 INFO - ++DOMWINDOW == 191 (0x8b60e400) [pid = 1906] [serial = 693] [outer = 0x8ad77000] 15:22:16 INFO - ++DOMWINDOW == 192 (0x8b63a400) [pid = 1906] [serial = 694] [outer = 0x8b3d7000] 15:22:17 INFO - [1906] WARNING: NS_ENSURE_TRUE(!mParent || mParent == docLoaderService) failed: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/docshell/base/nsDocShell.cpp, line 3157 15:22:17 INFO - [1906] WARNING: NS_ENSURE_TRUE(!mParent || mParent == docLoaderService) failed: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/docshell/base/nsDocShell.cpp, line 3157 15:22:18 INFO - [1906] WARNING: attempt to modify an immutable nsStandardURL: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/netwerk/base/nsStandardURL.cpp, line 1302 15:22:18 INFO - ++DOCSHELL 0x8f024c00 == 83 [pid = 1906] [id = 253] 15:22:18 INFO - ++DOMWINDOW == 193 (0x8f025400) [pid = 1906] [serial = 695] [outer = (nil)] 15:22:18 INFO - ++DOMWINDOW == 194 (0x8f1f5000) [pid = 1906] [serial = 696] [outer = 0x8f025400] 15:22:18 INFO - ++DOMWINDOW == 195 (0x8b35f800) [pid = 1906] [serial = 697] [outer = 0x8f025400] 15:22:19 INFO - [1906] WARNING: attempt to modify an immutable nsStandardURL: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/netwerk/base/nsStandardURL.cpp, line 1302 15:22:19 INFO - ++DOCSHELL 0x8b64c000 == 84 [pid = 1906] [id = 254] 15:22:19 INFO - ++DOMWINDOW == 196 (0x8b64e000) [pid = 1906] [serial = 698] [outer = (nil)] 15:22:19 INFO - ++DOMWINDOW == 197 (0x8ef01c00) [pid = 1906] [serial = 699] [outer = 0x8b64e000] 15:22:19 INFO - ++DOCSHELL 0x8f019c00 == 85 [pid = 1906] [id = 255] 15:22:19 INFO - ++DOMWINDOW == 198 (0x8f01b400) [pid = 1906] [serial = 700] [outer = (nil)] 15:22:19 INFO - ++DOCSHELL 0x8f01e800 == 86 [pid = 1906] [id = 256] 15:22:19 INFO - ++DOMWINDOW == 199 (0x8f025800) [pid = 1906] [serial = 701] [outer = (nil)] 15:22:19 INFO - ++DOMWINDOW == 200 (0x8f027400) [pid = 1906] [serial = 702] [outer = 0x8f025800] 15:22:20 INFO - ++DOCSHELL 0x8f666400 == 87 [pid = 1906] [id = 257] 15:22:20 INFO - ++DOMWINDOW == 201 (0x8f667c00) [pid = 1906] [serial = 703] [outer = (nil)] 15:22:20 INFO - ++DOMWINDOW == 202 (0x8f672c00) [pid = 1906] [serial = 704] [outer = 0x8f667c00] 15:22:20 INFO - ++DOMWINDOW == 203 (0x9080a000) [pid = 1906] [serial = 705] [outer = 0x8f01b400] 15:22:20 INFO - ++DOMWINDOW == 204 (0x90810800) [pid = 1906] [serial = 706] [outer = 0x8f025800] 15:22:20 INFO - ++DOMWINDOW == 205 (0x9082a400) [pid = 1906] [serial = 707] [outer = 0x8f667c00] 15:22:21 INFO - [1906] WARNING: NS_ENSURE_TRUE(!mParent || mParent == docLoaderService) failed: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/docshell/base/nsDocShell.cpp, line 3157 15:22:21 INFO - [1906] WARNING: NS_ENSURE_TRUE(!mParent || mParent == docLoaderService) failed: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/docshell/base/nsDocShell.cpp, line 3157 15:22:21 INFO - [1906] WARNING: attempt to modify an immutable nsStandardURL: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/netwerk/base/nsStandardURL.cpp, line 1302 15:22:22 INFO - MEMORY STAT | vsize 982MB | residentFast 338MB | heapAllocated 115MB 15:22:22 INFO - 136 INFO TEST-OK | browser/base/content/test/general/browser_bug495058.js | took 10431ms 15:22:22 INFO - ++DOCSHELL 0x8f47ec00 == 88 [pid = 1906] [id = 258] 15:22:22 INFO - ++DOMWINDOW == 206 (0x8f480800) [pid = 1906] [serial = 708] [outer = (nil)] 15:22:22 INFO - ++DOMWINDOW == 207 (0x8f493c00) [pid = 1906] [serial = 709] [outer = 0x8f480800] 15:22:23 INFO - 137 INFO TEST-START | browser/base/content/test/general/browser_bug517902.js 15:22:23 INFO - ++DOCSHELL 0x90998800 == 89 [pid = 1906] [id = 259] 15:22:23 INFO - ++DOMWINDOW == 208 (0x9099b400) [pid = 1906] [serial = 710] [outer = (nil)] 15:22:23 INFO - ++DOMWINDOW == 209 (0x909b3800) [pid = 1906] [serial = 711] [outer = 0x9099b400] 15:22:23 INFO - ++DOCSHELL 0x90dbc000 == 90 [pid = 1906] [id = 260] 15:22:23 INFO - ++DOMWINDOW == 210 (0x90fac400) [pid = 1906] [serial = 712] [outer = (nil)] 15:22:23 INFO - ++DOMWINDOW == 211 (0x9105cc00) [pid = 1906] [serial = 713] [outer = 0x90fac400] 15:22:25 INFO - MEMORY STAT | vsize 982MB | residentFast 339MB | heapAllocated 118MB 15:22:25 INFO - 138 INFO TEST-OK | browser/base/content/test/general/browser_bug517902.js | took 2687ms 15:22:25 INFO - ++DOCSHELL 0x910ce800 == 91 [pid = 1906] [id = 261] 15:22:25 INFO - ++DOMWINDOW == 212 (0x9127c800) [pid = 1906] [serial = 714] [outer = (nil)] 15:22:25 INFO - ++DOMWINDOW == 213 (0x918bd800) [pid = 1906] [serial = 715] [outer = 0x9127c800] 15:22:26 INFO - 139 INFO TEST-START | browser/base/content/test/general/browser_bug519216.js 15:22:26 INFO - ++DOMWINDOW == 214 (0x91fa4400) [pid = 1906] [serial = 716] [outer = 0x9127c800] 15:22:26 INFO - MEMORY STAT | vsize 982MB | residentFast 340MB | heapAllocated 118MB 15:22:26 INFO - 140 INFO TEST-OK | browser/base/content/test/general/browser_bug519216.js | took 548ms 15:22:26 INFO - ++DOCSHELL 0x941c8c00 == 92 [pid = 1906] [id = 262] 15:22:26 INFO - ++DOMWINDOW == 215 (0x941cb000) [pid = 1906] [serial = 717] [outer = (nil)] 15:22:26 INFO - ++DOMWINDOW == 216 (0x9430d400) [pid = 1906] [serial = 718] [outer = 0x941cb000] 15:22:27 INFO - 141 INFO TEST-START | browser/base/content/test/general/browser_bug520538.js 15:22:27 INFO - MEMORY STAT | vsize 982MB | residentFast 340MB | heapAllocated 119MB 15:22:27 INFO - 142 INFO TEST-OK | browser/base/content/test/general/browser_bug520538.js | took 396ms 15:22:27 INFO - ++DOCSHELL 0x943f7800 == 93 [pid = 1906] [id = 263] 15:22:27 INFO - ++DOMWINDOW == 217 (0x943fbc00) [pid = 1906] [serial = 719] [outer = (nil)] 15:22:27 INFO - ++DOMWINDOW == 218 (0x98a12000) [pid = 1906] [serial = 720] [outer = 0x943fbc00] 15:22:28 INFO - ++DOCSHELL 0x8b647000 == 94 [pid = 1906] [id = 264] 15:22:28 INFO - ++DOMWINDOW == 219 (0x92148800) [pid = 1906] [serial = 721] [outer = (nil)] 15:22:28 INFO - ++DOMWINDOW == 220 (0x99105000) [pid = 1906] [serial = 722] [outer = 0x92148800] 15:22:28 INFO - 143 INFO TEST-START | browser/base/content/test/general/browser_bug521216.js 15:22:28 INFO - ++DOCSHELL 0x98e8f400 == 95 [pid = 1906] [id = 265] 15:22:28 INFO - ++DOMWINDOW == 221 (0x99098000) [pid = 1906] [serial = 723] [outer = (nil)] 15:22:28 INFO - ++DOMWINDOW == 222 (0x9923c400) [pid = 1906] [serial = 724] [outer = 0x99098000] 15:22:28 INFO - ++DOMWINDOW == 223 (0x9952a800) [pid = 1906] [serial = 725] [outer = 0x92148800] 15:22:29 INFO - MEMORY STAT | vsize 982MB | residentFast 343MB | heapAllocated 121MB 15:22:29 INFO - 144 INFO TEST-OK | browser/base/content/test/general/browser_bug521216.js | took 1037ms 15:22:29 INFO - ++DOCSHELL 0x99811c00 == 96 [pid = 1906] [id = 266] 15:22:29 INFO - ++DOMWINDOW == 224 (0x9a547800) [pid = 1906] [serial = 726] [outer = (nil)] 15:22:29 INFO - ++DOMWINDOW == 225 (0x9a577800) [pid = 1906] [serial = 727] [outer = 0x9a547800] 15:22:29 INFO - 145 INFO TEST-START | browser/base/content/test/general/browser_bug533232.js 15:22:29 INFO - ++DOCSHELL 0x81726800 == 97 [pid = 1906] [id = 267] 15:22:29 INFO - ++DOMWINDOW == 226 (0x8f028400) [pid = 1906] [serial = 728] [outer = (nil)] 15:22:29 INFO - ++DOMWINDOW == 227 (0x9a668800) [pid = 1906] [serial = 729] [outer = 0x8f028400] 15:22:30 INFO - ++DOCSHELL 0x9a665c00 == 98 [pid = 1906] [id = 268] 15:22:30 INFO - ++DOMWINDOW == 228 (0x9a668000) [pid = 1906] [serial = 730] [outer = (nil)] 15:22:30 INFO - ++DOMWINDOW == 229 (0x9b219800) [pid = 1906] [serial = 731] [outer = 0x9a668000] 15:22:30 INFO - ++DOCSHELL 0x9b21c800 == 99 [pid = 1906] [id = 269] 15:22:30 INFO - ++DOMWINDOW == 230 (0x9b21cc00) [pid = 1906] [serial = 732] [outer = (nil)] 15:22:30 INFO - ++DOMWINDOW == 231 (0x9b331c00) [pid = 1906] [serial = 733] [outer = 0x9b21cc00] 15:22:30 INFO - ++DOCSHELL 0x9b33c800 == 100 [pid = 1906] [id = 270] 15:22:30 INFO - ++DOMWINDOW == 232 (0x9b3bb800) [pid = 1906] [serial = 734] [outer = (nil)] 15:22:30 INFO - ++DOMWINDOW == 233 (0x9b46d800) [pid = 1906] [serial = 735] [outer = 0x9b3bb800] 15:22:30 INFO - ++DOCSHELL 0x9b463c00 == 101 [pid = 1906] [id = 271] 15:22:30 INFO - ++DOMWINDOW == 234 (0x9b46c800) [pid = 1906] [serial = 736] [outer = (nil)] 15:22:30 INFO - ++DOMWINDOW == 235 (0x9bea2800) [pid = 1906] [serial = 737] [outer = 0x9b46c800] 15:22:31 INFO - MEMORY STAT | vsize 983MB | residentFast 345MB | heapAllocated 123MB 15:22:31 INFO - 146 INFO TEST-OK | browser/base/content/test/general/browser_bug533232.js | took 1852ms 15:22:31 INFO - ++DOCSHELL 0x9bea4800 == 102 [pid = 1906] [id = 272] 15:22:31 INFO - ++DOMWINDOW == 236 (0x9bea4c00) [pid = 1906] [serial = 738] [outer = (nil)] 15:22:31 INFO - ++DOMWINDOW == 237 (0x9cd19000) [pid = 1906] [serial = 739] [outer = 0x9bea4c00] 15:22:32 INFO - 147 INFO TEST-START | browser/base/content/test/general/browser_bug537013.js 15:22:32 INFO - ++DOCSHELL 0x9cd57800 == 103 [pid = 1906] [id = 273] 15:22:32 INFO - ++DOMWINDOW == 238 (0x9cd58c00) [pid = 1906] [serial = 740] [outer = (nil)] 15:22:32 INFO - ++DOMWINDOW == 239 (0x9d73e000) [pid = 1906] [serial = 741] [outer = 0x9cd58c00] 15:22:32 INFO - ++DOCSHELL 0x9da66000 == 104 [pid = 1906] [id = 274] 15:22:32 INFO - ++DOMWINDOW == 240 (0x9da67000) [pid = 1906] [serial = 742] [outer = (nil)] 15:22:32 INFO - ++DOMWINDOW == 241 (0x9e93c000) [pid = 1906] [serial = 743] [outer = 0x9da67000] 15:22:32 INFO - ++DOCSHELL 0x9da6ac00 == 105 [pid = 1906] [id = 275] 15:22:32 INFO - ++DOMWINDOW == 242 (0x9e93bc00) [pid = 1906] [serial = 744] [outer = (nil)] 15:22:32 INFO - ++DOMWINDOW == 243 (0x9ea65c00) [pid = 1906] [serial = 745] [outer = 0x9e93bc00] 15:22:33 INFO - ++DOCSHELL 0x7cfec800 == 106 [pid = 1906] [id = 276] 15:22:33 INFO - ++DOMWINDOW == 244 (0x9ea5f000) [pid = 1906] [serial = 746] [outer = (nil)] 15:22:33 INFO - ++DOMWINDOW == 245 (0x9f3de400) [pid = 1906] [serial = 747] [outer = 0x9ea5f000] 15:22:35 INFO - ++DOCSHELL 0xa4c57000 == 107 [pid = 1906] [id = 277] 15:22:35 INFO - ++DOMWINDOW == 246 (0xa4c57400) [pid = 1906] [serial = 748] [outer = (nil)] 15:22:35 INFO - ++DOMWINDOW == 247 (0xa4cd5800) [pid = 1906] [serial = 749] [outer = 0xa4c57400] 15:22:36 INFO - ++DOCSHELL 0xa4cdc000 == 108 [pid = 1906] [id = 278] 15:22:36 INFO - ++DOMWINDOW == 248 (0xa58afc00) [pid = 1906] [serial = 750] [outer = (nil)] 15:22:36 INFO - ++DOCSHELL 0xa58b9800 == 109 [pid = 1906] [id = 279] 15:22:36 INFO - ++DOMWINDOW == 249 (0xa6566000) [pid = 1906] [serial = 751] [outer = (nil)] 15:22:36 INFO - ++DOMWINDOW == 250 (0xa656e400) [pid = 1906] [serial = 752] [outer = 0xa6566000] 15:22:36 INFO - ++DOCSHELL 0xa90d1800 == 110 [pid = 1906] [id = 280] 15:22:36 INFO - ++DOMWINDOW == 251 (0xa90d2400) [pid = 1906] [serial = 753] [outer = (nil)] 15:22:36 INFO - ++DOMWINDOW == 252 (0xac1ab000) [pid = 1906] [serial = 754] [outer = 0xa90d2400] 15:22:36 INFO - ++DOMWINDOW == 253 (0xac1ae000) [pid = 1906] [serial = 755] [outer = 0xa58afc00] 15:22:36 INFO - ++DOMWINDOW == 254 (0xac1afc00) [pid = 1906] [serial = 756] [outer = 0xa6566000] 15:22:36 INFO - ++DOMWINDOW == 255 (0xac1b2c00) [pid = 1906] [serial = 757] [outer = 0xa90d2400] 15:22:37 INFO - [1906] WARNING: NS_ENSURE_TRUE(!mParent || mParent == docLoaderService) failed: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/docshell/base/nsDocShell.cpp, line 3157 15:22:37 INFO - [1906] WARNING: NS_ENSURE_TRUE(!mParent || mParent == docLoaderService) failed: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/docshell/base/nsDocShell.cpp, line 3157 15:22:40 INFO - MEMORY STAT | vsize 984MB | residentFast 355MB | heapAllocated 130MB 15:22:40 INFO - 148 INFO TEST-OK | browser/base/content/test/general/browser_bug537013.js | took 7673ms 15:22:40 INFO - ++DOCSHELL 0x79d29400 == 111 [pid = 1906] [id = 281] 15:22:40 INFO - ++DOMWINDOW == 256 (0x79d29800) [pid = 1906] [serial = 758] [outer = (nil)] 15:22:40 INFO - ++DOMWINDOW == 257 (0x7ab0fc00) [pid = 1906] [serial = 759] [outer = 0x79d29800] 15:22:40 INFO - 149 INFO TEST-START | browser/base/content/test/general/browser_bug537474.js 15:22:40 INFO - ++DOMWINDOW == 258 (0x7ab17000) [pid = 1906] [serial = 760] [outer = 0x79d29800] 15:22:41 INFO - MEMORY STAT | vsize 984MB | residentFast 355MB | heapAllocated 131MB 15:22:41 INFO - 150 INFO TEST-OK | browser/base/content/test/general/browser_bug537474.js | took 792ms 15:22:41 INFO - ++DOCSHELL 0x7ab1cc00 == 112 [pid = 1906] [id = 282] 15:22:41 INFO - ++DOMWINDOW == 259 (0x7ab1d000) [pid = 1906] [serial = 761] [outer = (nil)] 15:22:41 INFO - ++DOMWINDOW == 260 (0xa009a800) [pid = 1906] [serial = 762] [outer = 0x7ab1d000] 15:22:41 INFO - 151 INFO TEST-START | browser/base/content/test/general/browser_bug550565.js 15:22:41 INFO - ++DOCSHELL 0x7ab17800 == 113 [pid = 1906] [id = 283] 15:22:41 INFO - ++DOMWINDOW == 261 (0x7ab1b800) [pid = 1906] [serial = 763] [outer = (nil)] 15:22:41 INFO - ++DOMWINDOW == 262 (0xa8e5a400) [pid = 1906] [serial = 764] [outer = 0x7ab1b800] 15:22:41 INFO - ++DOMWINDOW == 263 (0x79d5dc00) [pid = 1906] [serial = 765] [outer = 0x7ab1b800] 15:22:42 INFO - [1906] WARNING: attempt to modify an immutable nsStandardURL: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/netwerk/base/nsStandardURL.cpp, line 1302 15:22:42 INFO - MEMORY STAT | vsize 985MB | residentFast 356MB | heapAllocated 130MB 15:22:42 INFO - 152 INFO TEST-OK | browser/base/content/test/general/browser_bug550565.js | took 754ms 15:22:42 INFO - ++DOCSHELL 0x79d5cc00 == 114 [pid = 1906] [id = 284] 15:22:42 INFO - ++DOMWINDOW == 264 (0x79d5d000) [pid = 1906] [serial = 766] [outer = (nil)] 15:22:42 INFO - ++DOMWINDOW == 265 (0x79d68000) [pid = 1906] [serial = 767] [outer = 0x79d5d000] 15:22:42 INFO - 153 INFO TEST-START | browser/base/content/test/general/browser_bug553455.js 15:22:43 INFO - ++DOCSHELL 0x7ab2dc00 == 115 [pid = 1906] [id = 285] 15:22:43 INFO - ++DOMWINDOW == 266 (0x7ab2e000) [pid = 1906] [serial = 768] [outer = (nil)] 15:22:43 INFO - ++DOMWINDOW == 267 (0x7ab32400) [pid = 1906] [serial = 769] [outer = 0x7ab2e000] 15:22:43 INFO - ++DOMWINDOW == 268 (0x7ab37c00) [pid = 1906] [serial = 770] [outer = 0x7ab2e000] 15:22:44 INFO - 1448580164152 addons.xpi DEBUG Cancelling download of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/unsigned.xpi 15:22:44 INFO - 1448580164156 addons.xpi DEBUG removeTemporaryFile: http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/unsigned.xpi does not own temp file 15:22:44 INFO - Sending InstallTriggered 15:22:44 INFO - [1906] WARNING: Image width or height is non-positive: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/layout/base/nsLayoutUtils.cpp, line 6466 15:22:44 INFO - ++DOCSHELL 0x7d748800 == 116 [pid = 1906] [id = 286] 15:22:44 INFO - ++DOMWINDOW == 269 (0x7d748c00) [pid = 1906] [serial = 771] [outer = (nil)] 15:22:44 INFO - ++DOMWINDOW == 270 (0x7f809800) [pid = 1906] [serial = 772] [outer = 0x7d748c00] 15:22:45 INFO - ++DOMWINDOW == 271 (0x7f80d400) [pid = 1906] [serial = 773] [outer = 0x7d748c00] 15:22:45 INFO - Sending InstallTriggered 15:22:46 INFO - 1448580166174 addons.xpi DEBUG Download started for http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/unsigned.xpi to file /tmp/tmp-j2i.xpi 15:22:46 INFO - 1448580166194 addons.xpi DEBUG Download of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/unsigned.xpi completed. 15:22:46 INFO - 1448580166324 addons.repository DEBUG cacheAddons: enabled false IDs ["unsigned-xpi@tests.mozilla.org"] 15:22:46 INFO - 1448580166551 addons.xpi DEBUG Starting install of unsigned-xpi@tests.mozilla.org from http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/unsigned.xpi 15:22:46 INFO - 1448580166683 addons.xpi DEBUG Addon unsigned-xpi@tests.mozilla.org will be installed as a packed xpi 15:22:46 INFO - 1448580166733 addons.xpi DEBUG Staged install of unsigned-xpi@tests.mozilla.org from http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/unsigned.xpi ready; waiting for restart. 15:22:46 INFO - 1448580166791 addons.xpi DEBUG removeTemporaryFile: http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/unsigned.xpi removing temp file /tmp/tmp-j2i.xpi 15:22:46 INFO - [1906] WARNING: Image width or height is non-positive: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/layout/base/nsLayoutUtils.cpp, line 6466 15:22:46 INFO - 1448580166920 addons.xpi DEBUG Cancelling install of unsigned-xpi@tests.mozilla.org 15:22:47 INFO - [1906] WARNING: Image width or height is non-positive: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/layout/base/nsLayoutUtils.cpp, line 6466 15:22:47 INFO - ++DOCSHELL 0x8f022c00 == 117 [pid = 1906] [id = 287] 15:22:47 INFO - ++DOMWINDOW == 272 (0x8f123400) [pid = 1906] [serial = 774] [outer = (nil)] 15:22:47 INFO - ++DOMWINDOW == 273 (0x90995800) [pid = 1906] [serial = 775] [outer = 0x8f123400] 15:22:47 INFO - ++DOMWINDOW == 274 (0x90db1c00) [pid = 1906] [serial = 776] [outer = 0x8f123400] 15:22:48 INFO - Sending InstallTriggered 15:22:48 INFO - 1448580168428 addons.xpi DEBUG Download started for http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/unsigned.xpi to file /tmp/tmp-jig.xpi 15:22:48 INFO - 1448580168432 addons.xpi DEBUG Download of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/unsigned.xpi completed. 15:22:48 INFO - 1448580168598 addons.repository DEBUG cacheAddons: enabled false IDs ["unsigned-xpi@tests.mozilla.org"] 15:22:48 INFO - 1448580168975 addons.xpi DEBUG Starting install of unsigned-xpi@tests.mozilla.org from http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/unsigned.xpi 15:22:49 INFO - 1448580169162 addons.xpi DEBUG Addon unsigned-xpi@tests.mozilla.org will be installed as a packed xpi 15:22:49 INFO - 1448580169204 addons.xpi DEBUG Staged install of unsigned-xpi@tests.mozilla.org from http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/unsigned.xpi ready; waiting for restart. 15:22:49 INFO - 1448580169261 addons.xpi DEBUG removeTemporaryFile: http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/unsigned.xpi removing temp file /tmp/tmp-jig.xpi 15:22:49 INFO - Sending InstallComplete 15:22:49 INFO - 1448580169359 addons.xpi DEBUG Cancelling install of unsigned-xpi@tests.mozilla.org 15:22:49 INFO - ++DOCSHELL 0x92144400 == 118 [pid = 1906] [id = 288] 15:22:49 INFO - ++DOMWINDOW == 275 (0x99535c00) [pid = 1906] [serial = 777] [outer = (nil)] 15:22:49 INFO - ++DOMWINDOW == 276 (0x9cd53400) [pid = 1906] [serial = 778] [outer = 0x99535c00] 15:22:50 INFO - ++DOMWINDOW == 277 (0x9f5c4c00) [pid = 1906] [serial = 779] [outer = 0x99535c00] 15:22:50 INFO - Sending InstallTriggered 15:22:50 INFO - 1448580170847 addons.xpi DEBUG Download started for http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/missing.xpi to file /tmp/tmp-lzq.xpi 15:22:50 INFO - 1448580170855 addons.xpi DEBUG Download of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/missing.xpi completed. 15:22:50 INFO - 1448580170859 addons.xpi WARN Download of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/missing.xpi failed: 404 Not Found 15:22:50 INFO - 1448580170916 addons.xpi DEBUG downloadFailed: removing temp file for http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/missing.xpi 15:22:50 INFO - 1448580170919 addons.xpi DEBUG removeTemporaryFile: http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/missing.xpi removing temp file /tmp/tmp-lzq.xpi 15:22:50 INFO - Sending InstallComplete 15:22:51 INFO - ++DOCSHELL 0x79eb8800 == 119 [pid = 1906] [id = 289] 15:22:51 INFO - ++DOMWINDOW == 278 (0x79eb8c00) [pid = 1906] [serial = 780] [outer = (nil)] 15:22:51 INFO - ++DOMWINDOW == 279 (0x79ec3400) [pid = 1906] [serial = 781] [outer = 0x79eb8c00] 15:22:51 INFO - ++DOMWINDOW == 280 (0xa82c5800) [pid = 1906] [serial = 782] [outer = 0x79eb8c00] 15:22:52 INFO - Sending InstallTriggered 15:22:52 INFO - 1448580172627 addons.xpi DEBUG Download started for http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/corrupt.xpi to file /tmp/tmp-pwr.xpi 15:22:52 INFO - 1448580172635 addons.xpi DEBUG Download of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/corrupt.xpi completed. 15:22:52 INFO - 1448580172648 addons.xpi WARN Download of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/corrupt.xpi failed: [Exception... "Component returned failure code: 0x8052000b (NS_ERROR_FILE_CORRUPTED) [nsIZipReader.open]" nsresult: "0x8052000b (NS_ERROR_FILE_CORRUPTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm :: AI_loadManifest :: line 5388" data: no] Stack trace: AI_loadManifest()@resource://gre/modules/addons/XPIProvider.jsm:5388 < TaskImpl_run()@resource://gre/modules/Task.jsm:314 < TaskImpl()@resource://gre/modules/Task.jsm:275 < createAsyncFunction/asyncFunction()@resource://gre/modules/Task.jsm:249 < AI_onStopRequest()@resource://gre/modules/addons/XPIProvider.jsm:5715 15:22:52 INFO - 1448580172713 addons.xpi DEBUG downloadFailed: removing temp file for http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/corrupt.xpi 15:22:52 INFO - 1448580172716 addons.xpi DEBUG removeTemporaryFile: http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/corrupt.xpi removing temp file /tmp/tmp-pwr.xpi 15:22:52 INFO - Sending InstallComplete 15:22:53 INFO - ++DOCSHELL 0x79fd7000 == 120 [pid = 1906] [id = 290] 15:22:53 INFO - ++DOMWINDOW == 281 (0x79fd7400) [pid = 1906] [serial = 783] [outer = (nil)] 15:22:53 INFO - ++DOMWINDOW == 282 (0x7a01e400) [pid = 1906] [serial = 784] [outer = 0x79fd7400] 15:22:53 INFO - ++DOMWINDOW == 283 (0x7a021400) [pid = 1906] [serial = 785] [outer = 0x79fd7400] 15:22:54 INFO - Sending InstallTriggered 15:22:54 INFO - 1448580174361 addons.xpi DEBUG Download started for http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/incompatible.xpi to file /tmp/tmp-5zj.xpi 15:22:54 INFO - 1448580174370 addons.xpi DEBUG Download of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/incompatible.xpi completed. 15:22:54 INFO - 1448580174448 addons.repository DEBUG cacheAddons: enabled false IDs ["incompatible-xpi@tests.mozilla.org"] 15:22:54 INFO - 1448580174487 addons.update-checker DEBUG Requesting http://127.0.0.1:8888/extensions-dummy/updateURL 15:22:54 INFO - 1448580174581 addons.update-checker WARN Request failed: http://127.0.0.1:8888/extensions-dummy/updateURL - 404: Not Found 15:22:54 INFO - 1448580174591 addons.xpi DEBUG Cancelling download of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/incompatible.xpi 15:22:54 INFO - 1448580174602 addons.xpi DEBUG removeTemporaryFile: http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/incompatible.xpi removing temp file /tmp/tmp-5zj.xpi 15:22:54 INFO - Sending InstallComplete 15:22:54 INFO - ++DOCSHELL 0x7a02b400 == 121 [pid = 1906] [id = 291] 15:22:54 INFO - ++DOMWINDOW == 284 (0x7a097400) [pid = 1906] [serial = 786] [outer = (nil)] 15:22:55 INFO - ++DOMWINDOW == 285 (0x7ab36c00) [pid = 1906] [serial = 787] [outer = 0x7a097400] 15:22:55 INFO - ++DOMWINDOW == 286 (0x7a1bd400) [pid = 1906] [serial = 788] [outer = 0x7a097400] 15:22:56 INFO - Sending InstallTriggered 15:22:56 INFO - 1448580176333 addons.xpi DEBUG Download started for http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/restartless.xpi to file /tmp/tmp-nrg.xpi 15:22:56 INFO - 1448580176342 addons.xpi DEBUG Download of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/restartless.xpi completed. 15:22:56 INFO - 1448580176425 addons.repository DEBUG cacheAddons: enabled false IDs ["restartless-xpi@tests.mozilla.org"] 15:22:56 INFO - 1448580176603 addons.xpi DEBUG Starting install of restartless-xpi@tests.mozilla.org from http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/restartless.xpi 15:22:56 INFO - 1448580176722 addons.xpi DEBUG Addon restartless-xpi@tests.mozilla.org will be installed as a packed xpi 15:22:56 INFO - 1448580176856 addons.xpi INFO Mapping restartless-xpi@tests.mozilla.org to /tmp/tmpHg5nYC.mozrunner/extensions/restartless-xpi@tests.mozilla.org.xpi 15:22:56 INFO - 1448580176863 addons.xpi-utils DEBUG Make addon app-profile:restartless-xpi@tests.mozilla.org visible 15:22:56 INFO - 1448580176868 DeferredSave.extensions.json DEBUG Save changes 15:22:56 INFO - 1448580176869 DeferredSave.extensions.json DEBUG Save changes 15:22:56 INFO - 1448580176872 addons.xpi DEBUG XPIStates adding add-on restartless-xpi@tests.mozilla.org in app-profile: /tmp/tmpHg5nYC.mozrunner/extensions/restartless-xpi@tests.mozilla.org.xpi 15:22:56 INFO - 1448580176877 addons.xpi DEBUG Updating XPIState for {"id":"restartless-xpi@tests.mozilla.org","syncGUID":"jFS4rWk2bPWY","location":"app-profile","version":"1.0","type":"extension","internalName":null,"updateURL":null,"updateKey":null,"optionsURL":null,"optionsType":null,"aboutURL":null,"icons":{},"iconURL":null,"icon64URL":null,"defaultLocale":{"name":"XPI Test","description":null,"creator":null,"homepageURL":null},"visible":true,"active":true,"userDisabled":false,"appDisabled":false,"descriptor":"/tmp/tmpHg5nYC.mozrunner/extensions/restartless-xpi@tests.mozilla.org.xpi","installDate":1448580176437,"updateDate":1448580176437,"applyBackgroundUpdates":1,"bootstrap":true,"size":637,"sourceURI":"http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/restartless.xpi","releaseNotesURI":null,"softDisabled":false,"foreignInstall":false,"hasBinaryComponents":false,"strictCompatibility":false,"locales":[],"targetApplications":[{"id":"toolkit@mozilla.org","minVersion":"0","maxVersion":"*"}],"targetPlatforms":[],"multiprocessCompatible":false,"signedState":0} 15:22:56 INFO - 1448580176884 addons.xpi DEBUG getModTime: Recursive scan of restartless-xpi@tests.mozilla.org 15:22:56 INFO - 1448580176885 DeferredSave.extensions.json DEBUG Save changes 15:22:56 INFO - 1448580176886 DeferredSave.extensions.json DEBUG Save changes 15:22:56 INFO - 1448580176899 addons.xpi DEBUG Loading bootstrap scope from /tmp/tmpHg5nYC.mozrunner/extensions/restartless-xpi@tests.mozilla.org.xpi 15:22:56 INFO - 1448580176914 addons.xpi WARN Error loading bootstrap.js for restartless-xpi@tests.mozilla.org: Error opening input stream (invalid filename?): jar:file:///tmp/tmpHg5nYC.mozrunner/extensions/restartless-xpi@tests.mozilla.org.xpi!/bootstrap.js 15:22:56 INFO - 1448580176918 addons.xpi WARN Add-on restartless-xpi@tests.mozilla.org is missing bootstrap method install 15:22:56 INFO - 1448580176933 addons.xpi DEBUG Install of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/restartless.xpi completed. 15:22:56 INFO - 1448580176964 addons.xpi DEBUG Registering manifest for /tmp/tmpHg5nYC.mozrunner/extensions/restartless-xpi@tests.mozilla.org.xpi 15:22:56 INFO - 1448580176968 addons.xpi WARN Add-on restartless-xpi@tests.mozilla.org is missing bootstrap method startup 15:22:56 INFO - 1448580176971 DeferredSave.extensions.json DEBUG Starting timer 15:22:57 INFO - 1448580177087 addons.xpi DEBUG removeTemporaryFile: http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/restartless.xpi removing temp file /tmp/tmp-nrg.xpi 15:22:57 INFO - Sending InstallComplete 15:22:57 INFO - 1448580177300 DeferredSave.extensions.json DEBUG Starting write 15:22:57 INFO - 1448580177399 addons.xpi WARN Add-on restartless-xpi@tests.mozilla.org is missing bootstrap method shutdown 15:22:57 INFO - 1448580177402 addons.xpi DEBUG Removing manifest for /tmp/tmpHg5nYC.mozrunner/extensions/restartless-xpi@tests.mozilla.org.xpi 15:22:57 INFO - 1448580177417 addons.xpi WARN Add-on restartless-xpi@tests.mozilla.org is missing bootstrap method uninstall 15:22:57 INFO - 1448580177434 addons.xpi DEBUG uninstallAddon: flushing jar cache /tmp/tmpHg5nYC.mozrunner/extensions/restartless-xpi@tests.mozilla.org.xpi for addon restartless-xpi@tests.mozilla.org 15:22:57 INFO - 1448580177439 DeferredSave.extensions.json DEBUG Save changes 15:22:57 INFO - 1448580177439 DeferredSave.extensions.json DEBUG Data changed while write in progress 15:22:57 INFO - 1448580177442 addons.xpi DEBUG Removing XPIState for app-profile:restartless-xpi@tests.mozilla.org 15:22:57 INFO - 1448580177831 DeferredSave.extensions.json DEBUG Write succeeded 15:22:57 INFO - 1448580177832 DeferredSave.extensions.json DEBUG Starting timer 15:22:57 INFO - ++DOCSHELL 0x7cf0c000 == 122 [pid = 1906] [id = 292] 15:22:57 INFO - ++DOMWINDOW == 287 (0x8f489800) [pid = 1906] [serial = 789] [outer = (nil)] 15:22:57 INFO - ++DOMWINDOW == 288 (0x99611000) [pid = 1906] [serial = 790] [outer = 0x8f489800] 15:22:58 INFO - 1448580178274 DeferredSave.extensions.json DEBUG Starting write 15:22:58 INFO - 1448580178449 DeferredSave.extensions.json DEBUG Write succeeded 15:22:58 INFO - ++DOMWINDOW == 289 (0x99613400) [pid = 1906] [serial = 791] [outer = 0x8f489800] 15:22:58 INFO - Sending InstallTriggered 15:22:59 INFO - 1448580179199 addons.xpi DEBUG Download started for http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/restartless.xpi to file /tmp/tmp-f3i.xpi 15:22:59 INFO - 1448580179207 addons.xpi DEBUG Download of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/restartless.xpi completed. 15:22:59 INFO - 1448580179229 addons.xpi DEBUG Download started for http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/unsigned.xpi to file /tmp/tmp-x85.xpi 15:22:59 INFO - 1448580179236 addons.xpi DEBUG Download of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/unsigned.xpi completed. 15:22:59 INFO - 1448580179313 addons.repository DEBUG cacheAddons: enabled false IDs ["restartless-xpi@tests.mozilla.org"] 15:22:59 INFO - 1448580179342 addons.repository DEBUG cacheAddons: enabled false IDs ["unsigned-xpi@tests.mozilla.org"] 15:22:59 INFO - 1448580179518 addons.xpi DEBUG Starting install of restartless-xpi@tests.mozilla.org from http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/restartless.xpi 15:22:59 INFO - 1448580179527 addons.xpi DEBUG Starting install of unsigned-xpi@tests.mozilla.org from http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/unsigned.xpi 15:22:59 INFO - 1448580179629 addons.xpi DEBUG Addon restartless-xpi@tests.mozilla.org will be installed as a packed xpi 15:22:59 INFO - 1448580179634 addons.xpi DEBUG Addon unsigned-xpi@tests.mozilla.org will be installed as a packed xpi 15:22:59 INFO - 1448580179786 addons.xpi INFO Mapping restartless-xpi@tests.mozilla.org to /tmp/tmpHg5nYC.mozrunner/extensions/restartless-xpi@tests.mozilla.org.xpi 15:22:59 INFO - 1448580179790 addons.xpi-utils DEBUG Make addon app-profile:restartless-xpi@tests.mozilla.org visible 15:22:59 INFO - 1448580179794 DeferredSave.extensions.json DEBUG Save changes 15:22:59 INFO - 1448580179796 DeferredSave.extensions.json DEBUG Save changes 15:22:59 INFO - 1448580179798 addons.xpi DEBUG XPIStates adding add-on restartless-xpi@tests.mozilla.org in app-profile: /tmp/tmpHg5nYC.mozrunner/extensions/restartless-xpi@tests.mozilla.org.xpi 15:22:59 INFO - 1448580179802 addons.xpi DEBUG Updating XPIState for {"id":"restartless-xpi@tests.mozilla.org","syncGUID":"QoVF54gCYfmS","location":"app-profile","version":"1.0","type":"extension","internalName":null,"updateURL":null,"updateKey":null,"optionsURL":null,"optionsType":null,"aboutURL":null,"icons":{},"iconURL":null,"icon64URL":null,"defaultLocale":{"name":"XPI Test","description":null,"creator":null,"homepageURL":null},"visible":true,"active":true,"userDisabled":false,"appDisabled":false,"descriptor":"/tmp/tmpHg5nYC.mozrunner/extensions/restartless-xpi@tests.mozilla.org.xpi","installDate":1448580179324,"updateDate":1448580179324,"applyBackgroundUpdates":1,"bootstrap":true,"size":637,"sourceURI":"http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/restartless.xpi","releaseNotesURI":null,"softDisabled":false,"foreignInstall":false,"hasBinaryComponents":false,"strictCompatibility":false,"locales":[],"targetApplications":[{"id":"toolkit@mozilla.org","minVersion":"0","maxVersion":"*"}],"targetPlatforms":[],"multiprocessCompatible":false,"signedState":0} 15:22:59 INFO - 1448580179808 addons.xpi DEBUG getModTime: Recursive scan of restartless-xpi@tests.mozilla.org 15:22:59 INFO - 1448580179810 DeferredSave.extensions.json DEBUG Save changes 15:22:59 INFO - 1448580179813 DeferredSave.extensions.json DEBUG Save changes 15:22:59 INFO - 1448580179821 addons.xpi DEBUG Loading bootstrap scope from /tmp/tmpHg5nYC.mozrunner/extensions/restartless-xpi@tests.mozilla.org.xpi 15:22:59 INFO - 1448580179833 addons.xpi WARN Error loading bootstrap.js for restartless-xpi@tests.mozilla.org: Error opening input stream (invalid filename?): jar:file:///tmp/tmpHg5nYC.mozrunner/extensions/restartless-xpi@tests.mozilla.org.xpi!/bootstrap.js 15:22:59 INFO - 1448580179836 addons.xpi WARN Add-on restartless-xpi@tests.mozilla.org is missing bootstrap method install 15:22:59 INFO - 1448580179849 addons.xpi DEBUG Install of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/restartless.xpi completed. 15:22:59 INFO - 1448580179853 addons.xpi DEBUG Registering manifest for /tmp/tmpHg5nYC.mozrunner/extensions/restartless-xpi@tests.mozilla.org.xpi 15:22:59 INFO - 1448580179857 addons.xpi WARN Add-on restartless-xpi@tests.mozilla.org is missing bootstrap method startup 15:22:59 INFO - 1448580179863 DeferredSave.extensions.json DEBUG Starting timer 15:22:59 INFO - 1448580179929 addons.xpi DEBUG removeTemporaryFile: http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/restartless.xpi removing temp file /tmp/tmp-f3i.xpi 15:23:00 INFO - Sending InstallComplete 15:23:00 INFO - 1448580180106 addons.xpi DEBUG Staged install of unsigned-xpi@tests.mozilla.org from http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/unsigned.xpi ready; waiting for restart. 15:23:00 INFO - 1448580180165 addons.xpi DEBUG removeTemporaryFile: http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/unsigned.xpi removing temp file /tmp/tmp-x85.xpi 15:23:00 INFO - 1448580180179 DeferredSave.extensions.json DEBUG Starting write 15:23:00 INFO - Sending InstallComplete 15:23:00 INFO - 1448580180269 DeferredSave.extensions.json DEBUG Write succeeded 15:23:00 INFO - 1448580180364 addons.xpi DEBUG Cancelling install of unsigned-xpi@tests.mozilla.org 15:23:00 INFO - 1448580180399 addons.xpi WARN Add-on restartless-xpi@tests.mozilla.org is missing bootstrap method shutdown 15:23:00 INFO - 1448580180400 addons.xpi DEBUG Removing manifest for /tmp/tmpHg5nYC.mozrunner/extensions/restartless-xpi@tests.mozilla.org.xpi 15:23:00 INFO - 1448580180415 addons.xpi WARN Add-on restartless-xpi@tests.mozilla.org is missing bootstrap method uninstall 15:23:00 INFO - 1448580180419 addons.xpi DEBUG uninstallAddon: flushing jar cache /tmp/tmpHg5nYC.mozrunner/extensions/restartless-xpi@tests.mozilla.org.xpi for addon restartless-xpi@tests.mozilla.org 15:23:00 INFO - 1448580180421 DeferredSave.extensions.json DEBUG Save changes 15:23:00 INFO - 1448580180425 addons.xpi DEBUG Removing XPIState for app-profile:restartless-xpi@tests.mozilla.org 15:23:00 INFO - 1448580180531 DeferredSave.extensions.json DEBUG Starting timer 15:23:00 INFO - ++DOCSHELL 0x9a0a3c00 == 123 [pid = 1906] [id = 293] 15:23:00 INFO - ++DOMWINDOW == 290 (0x9a0a4000) [pid = 1906] [serial = 792] [outer = (nil)] 15:23:00 INFO - ++DOMWINDOW == 291 (0x9a0aa000) [pid = 1906] [serial = 793] [outer = 0x9a0a4000] 15:23:01 INFO - 1448580181212 DeferredSave.extensions.json DEBUG Starting write 15:23:01 INFO - 1448580181339 DeferredSave.extensions.json DEBUG Write succeeded 15:23:01 INFO - ++DOMWINDOW == 292 (0x99f67400) [pid = 1906] [serial = 794] [outer = 0x9a0a4000] 15:23:01 INFO - Sending InstallTriggered 15:23:02 INFO - 1448580182233 addons.xpi DEBUG Download started for http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/restartless.xpi to file /tmp/tmp-qt7.xpi 15:23:02 INFO - 1448580182240 addons.xpi DEBUG Download of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/restartless.xpi completed. 15:23:02 INFO - 1448580182319 addons.repository DEBUG cacheAddons: enabled false IDs ["restartless-xpi@tests.mozilla.org"] 15:23:02 INFO - ++DOMWINDOW == 293 (0x7da5a400) [pid = 1906] [serial = 795] [outer = 0x9a0a4000] 15:23:03 INFO - Sending InstallTriggered 15:23:03 INFO - 1448580183514 addons.xpi DEBUG Download started for http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/theme.xpi to file /tmp/tmp-ggc.xpi 15:23:03 INFO - 1448580183522 addons.xpi DEBUG Download of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/theme.xpi completed. 15:23:03 INFO - 1448580183553 addons.repository DEBUG cacheAddons: enabled false IDs ["theme-xpi@tests.mozilla.org"] 15:23:03 INFO - 1448580183705 addons.xpi DEBUG Cancelling download of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/restartless.xpi 15:23:03 INFO - 1448580183710 addons.xpi DEBUG removeTemporaryFile: http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/restartless.xpi removing temp file /tmp/tmp-qt7.xpi 15:23:03 INFO - 1448580183759 addons.xpi DEBUG Cancelling download of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/theme.xpi 15:23:03 INFO - 1448580183764 addons.xpi DEBUG removeTemporaryFile: http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/theme.xpi removing temp file /tmp/tmp-ggc.xpi 15:23:03 INFO - ++DOCSHELL 0x79d69400 == 124 [pid = 1906] [id = 294] 15:23:03 INFO - ++DOMWINDOW == 294 (0x99f74400) [pid = 1906] [serial = 796] [outer = (nil)] 15:23:03 INFO - ++DOMWINDOW == 295 (0x9a0a5400) [pid = 1906] [serial = 797] [outer = 0x99f74400] 15:23:04 INFO - Sending InstallComplete 15:23:04 INFO - Sending InstallComplete 15:23:04 INFO - ++DOMWINDOW == 296 (0x9a0adc00) [pid = 1906] [serial = 798] [outer = 0x99f74400] 15:23:05 INFO - Sending InstallTriggered 15:23:05 INFO - 1448580185354 addons.xpi DEBUG Download started for http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/restartless.xpi to file /tmp/tmp-v8y.xpi 15:23:05 INFO - 1448580185366 addons.xpi DEBUG Download of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/restartless.xpi completed. 15:23:05 INFO - 1448580185398 addons.xpi DEBUG Download started for http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/theme.xpi to file /tmp/tmp-5vj.xpi 15:23:05 INFO - 1448580185406 addons.xpi DEBUG Download of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/theme.xpi completed. 15:23:05 INFO - 1448580185437 addons.repository DEBUG cacheAddons: enabled false IDs ["theme-xpi@tests.mozilla.org"] 15:23:05 INFO - 1448580185510 addons.repository DEBUG cacheAddons: enabled false IDs ["restartless-xpi@tests.mozilla.org"] 15:23:05 INFO - 1448580185713 addons.xpi DEBUG Starting install of restartless-xpi@tests.mozilla.org from http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/restartless.xpi 15:23:05 INFO - 1448580185723 addons.xpi DEBUG Starting install of theme-xpi@tests.mozilla.org from http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/theme.xpi 15:23:05 INFO - 1448580185879 addons.xpi DEBUG Addon restartless-xpi@tests.mozilla.org will be installed as a packed xpi 15:23:05 INFO - 1448580185883 addons.xpi DEBUG Addon theme-xpi@tests.mozilla.org will be installed as a packed xpi 15:23:05 INFO - 1448580185989 addons.xpi INFO Mapping restartless-xpi@tests.mozilla.org to /tmp/tmpHg5nYC.mozrunner/extensions/restartless-xpi@tests.mozilla.org.xpi 15:23:05 INFO - 1448580185994 addons.xpi-utils DEBUG Make addon app-profile:restartless-xpi@tests.mozilla.org visible 15:23:05 INFO - 1448580185997 DeferredSave.extensions.json DEBUG Save changes 15:23:06 INFO - 1448580186000 DeferredSave.extensions.json DEBUG Save changes 15:23:06 INFO - 1448580186001 addons.xpi DEBUG XPIStates adding add-on restartless-xpi@tests.mozilla.org in app-profile: /tmp/tmpHg5nYC.mozrunner/extensions/restartless-xpi@tests.mozilla.org.xpi 15:23:06 INFO - 1448580186005 addons.xpi DEBUG Updating XPIState for {"id":"restartless-xpi@tests.mozilla.org","syncGUID":"PgEqqLKEbPmX","location":"app-profile","version":"1.0","type":"extension","internalName":null,"updateURL":null,"updateKey":null,"optionsURL":null,"optionsType":null,"aboutURL":null,"icons":{},"iconURL":null,"icon64URL":null,"defaultLocale":{"name":"XPI Test","description":null,"creator":null,"homepageURL":null},"visible":true,"active":true,"userDisabled":false,"appDisabled":false,"descriptor":"/tmp/tmpHg5nYC.mozrunner/extensions/restartless-xpi@tests.mozilla.org.xpi","installDate":1448580185521,"updateDate":1448580185521,"applyBackgroundUpdates":1,"bootstrap":true,"size":637,"sourceURI":"http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/restartless.xpi","releaseNotesURI":null,"softDisabled":false,"foreignInstall":false,"hasBinaryComponents":false,"strictCompatibility":false,"locales":[],"targetApplications":[{"id":"toolkit@mozilla.org","minVersion":"0","maxVersion":"*"}],"targetPlatforms":[],"multiprocessCompatible":false,"signedState":0} 15:23:06 INFO - 1448580186010 addons.xpi DEBUG getModTime: Recursive scan of restartless-xpi@tests.mozilla.org 15:23:06 INFO - 1448580186012 DeferredSave.extensions.json DEBUG Save changes 15:23:06 INFO - 1448580186015 DeferredSave.extensions.json DEBUG Save changes 15:23:06 INFO - 1448580186029 addons.xpi DEBUG Loading bootstrap scope from /tmp/tmpHg5nYC.mozrunner/extensions/restartless-xpi@tests.mozilla.org.xpi 15:23:06 INFO - 1448580186040 addons.xpi WARN Error loading bootstrap.js for restartless-xpi@tests.mozilla.org: Error opening input stream (invalid filename?): jar:file:///tmp/tmpHg5nYC.mozrunner/extensions/restartless-xpi@tests.mozilla.org.xpi!/bootstrap.js 15:23:06 INFO - 1448580186043 addons.xpi WARN Add-on restartless-xpi@tests.mozilla.org is missing bootstrap method install 15:23:06 INFO - 1448580186062 addons.xpi DEBUG Install of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/restartless.xpi completed. 15:23:06 INFO - 1448580186066 addons.xpi DEBUG Registering manifest for /tmp/tmpHg5nYC.mozrunner/extensions/restartless-xpi@tests.mozilla.org.xpi 15:23:06 INFO - 1448580186070 addons.xpi WARN Add-on restartless-xpi@tests.mozilla.org is missing bootstrap method startup 15:23:06 INFO - 1448580186075 DeferredSave.extensions.json DEBUG Starting timer 15:23:06 INFO - 1448580186133 addons.xpi DEBUG removeTemporaryFile: http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/restartless.xpi removing temp file /tmp/tmp-v8y.xpi 15:23:06 INFO - Sending InstallComplete 15:23:06 INFO - 1448580186296 addons.xpi INFO Mapping theme-xpi@tests.mozilla.org to /tmp/tmpHg5nYC.mozrunner/extensions/theme-xpi@tests.mozilla.org.xpi 15:23:06 INFO - 1448580186300 addons.xpi-utils DEBUG Make addon app-profile:theme-xpi@tests.mozilla.org visible 15:23:06 INFO - 1448580186302 DeferredSave.extensions.json DEBUG Save changes 15:23:06 INFO - 1448580186304 DeferredSave.extensions.json DEBUG Save changes 15:23:06 INFO - 1448580186306 addons.xpi DEBUG XPIStates adding add-on theme-xpi@tests.mozilla.org in app-profile: /tmp/tmpHg5nYC.mozrunner/extensions/theme-xpi@tests.mozilla.org.xpi 15:23:06 INFO - 1448580186309 addons.xpi DEBUG Updating XPIState for {"id":"theme-xpi@tests.mozilla.org","syncGUID":"uGTtiXs5b9nA","location":"app-profile","version":"1.0","type":"theme","internalName":"test/1.0","updateURL":null,"updateKey":null,"optionsURL":null,"optionsType":null,"aboutURL":null,"icons":{},"iconURL":null,"icon64URL":null,"defaultLocale":{"name":"Theme Test","description":null,"creator":null,"homepageURL":null},"visible":true,"active":false,"userDisabled":true,"appDisabled":false,"descriptor":"/tmp/tmpHg5nYC.mozrunner/extensions/theme-xpi@tests.mozilla.org.xpi","installDate":1448580185449,"updateDate":1448580185449,"applyBackgroundUpdates":1,"skinnable":false,"size":668,"sourceURI":"http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/theme.xpi","releaseNotesURI":null,"softDisabled":false,"foreignInstall":false,"hasBinaryComponents":false,"strictCompatibility":true,"locales":[],"targetApplications":[{"id":"toolkit@mozilla.org","minVersion":"0","maxVersion":"*"}],"targetPlatforms":[]} 15:23:06 INFO - 1448580186314 addons.xpi DEBUG getModTime: Recursive scan of theme-xpi@tests.mozilla.org 15:23:06 INFO - 1448580186315 DeferredSave.extensions.json DEBUG Save changes 15:23:06 INFO - 1448580186321 DeferredSave.extensions.json DEBUG Save changes 15:23:06 INFO - 1448580186335 addons.xpi DEBUG Install of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/theme.xpi completed. 15:23:06 INFO - 1448580186347 DeferredSave.extensions.json DEBUG Save changes 15:23:06 INFO - 1448580186350 addons.xpi DEBUG Updating XPIState for {"id":"theme-xpi@tests.mozilla.org","syncGUID":"uGTtiXs5b9nA","location":"app-profile","version":"1.0","type":"theme","internalName":"test/1.0","updateURL":null,"updateKey":null,"optionsURL":null,"optionsType":null,"aboutURL":null,"icons":{},"iconURL":null,"icon64URL":null,"defaultLocale":{"name":"Theme Test","description":null,"creator":null,"homepageURL":null},"visible":true,"active":false,"userDisabled":false,"appDisabled":false,"descriptor":"/tmp/tmpHg5nYC.mozrunner/extensions/theme-xpi@tests.mozilla.org.xpi","installDate":1448580186000,"updateDate":1448580186000,"applyBackgroundUpdates":1,"skinnable":false,"size":668,"sourceURI":"http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/theme.xpi","releaseNotesURI":null,"softDisabled":false,"foreignInstall":false,"hasBinaryComponents":false,"strictCompatibility":true,"locales":[],"targetApplications":[{"id":"toolkit@mozilla.org","minVersion":"0","maxVersion":"*"}],"targetPlatforms":[]} 15:23:06 INFO - 1448580186357 addons.xpi DEBUG getModTime: Recursive scan of theme-xpi@tests.mozilla.org 15:23:06 INFO - 1448580186372 DeferredSave.extensions.json DEBUG Save changes 15:23:06 INFO - 1448580186375 addons.xpi DEBUG Updating XPIState for {"id":"{972ce4c6-7e08-4474-a285-3208198ce6fd}","syncGUID":"SgB_X9e5uTiv","location":"app-global","version":"45.0a1","type":"theme","internalName":"classic/1.0","updateURL":null,"updateKey":null,"optionsURL":null,"optionsType":null,"aboutURL":null,"icons":{"32":"icon.png","48":"icon.png"},"iconURL":null,"icon64URL":null,"defaultLocale":{"name":"Default","description":"The default theme.","creator":"Mozilla","homepageURL":null,"contributors":["Mozilla Contributors"]},"visible":true,"active":true,"userDisabled":true,"appDisabled":false,"descriptor":"/builds/slave/test/build/application/firefox/browser/extensions/{972ce4c6-7e08-4474-a285-3208198ce6fd}.xpi","installDate":1448575829000,"updateDate":1448575829000,"applyBackgroundUpdates":1,"skinnable":true,"size":5028,"sourceURI":null,"releaseNotesURI":null,"softDisabled":false,"foreignInstall":false,"hasBinaryComponents":false,"strictCompatibility":true,"locales":[],"targetApplications":[{"id":"{ec8030f7-c20a-464f-9b0e-13a3a9e97384}","minVersion":"45.0a1","maxVersion":"45.0a1"}],"targetPlatforms":[]} 15:23:06 INFO - 1448580186495 addons.xpi DEBUG removeTemporaryFile: http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/theme.xpi removing temp file /tmp/tmp-5vj.xpi 15:23:06 INFO - 1448580186600 DeferredSave.extensions.json DEBUG Starting write 15:23:06 INFO - Sending InstallComplete 15:23:06 INFO - 1448580186769 DeferredSave.extensions.json DEBUG Write succeeded 15:23:06 INFO - 1448580186885 addons.xpi WARN Add-on restartless-xpi@tests.mozilla.org is missing bootstrap method shutdown 15:23:06 INFO - 1448580186888 addons.xpi DEBUG Removing manifest for /tmp/tmpHg5nYC.mozrunner/extensions/restartless-xpi@tests.mozilla.org.xpi 15:23:06 INFO - 1448580186900 addons.xpi WARN Add-on restartless-xpi@tests.mozilla.org is missing bootstrap method uninstall 15:23:06 INFO - 1448580186904 addons.xpi DEBUG uninstallAddon: flushing jar cache /tmp/tmpHg5nYC.mozrunner/extensions/restartless-xpi@tests.mozilla.org.xpi for addon restartless-xpi@tests.mozilla.org 15:23:06 INFO - 1448580186908 DeferredSave.extensions.json DEBUG Save changes 15:23:06 INFO - 1448580186910 addons.xpi DEBUG Removing XPIState for app-profile:restartless-xpi@tests.mozilla.org 15:23:06 INFO - 1448580186917 addons.xpi DEBUG Activating default theme 15:23:06 INFO - 1448580186918 DeferredSave.extensions.json DEBUG Save changes 15:23:06 INFO - 1448580186920 addons.xpi DEBUG Updating XPIState for {"id":"{972ce4c6-7e08-4474-a285-3208198ce6fd}","syncGUID":"SgB_X9e5uTiv","location":"app-global","version":"45.0a1","type":"theme","internalName":"classic/1.0","updateURL":null,"updateKey":null,"optionsURL":null,"optionsType":null,"aboutURL":null,"icons":{"32":"icon.png","48":"icon.png"},"iconURL":null,"icon64URL":null,"defaultLocale":{"name":"Default","description":"The default theme.","creator":"Mozilla","homepageURL":null,"contributors":["Mozilla Contributors"]},"visible":true,"active":true,"userDisabled":false,"appDisabled":false,"descriptor":"/builds/slave/test/build/application/firefox/browser/extensions/{972ce4c6-7e08-4474-a285-3208198ce6fd}.xpi","installDate":1448575829000,"updateDate":1448575829000,"applyBackgroundUpdates":1,"skinnable":true,"size":5028,"sourceURI":null,"releaseNotesURI":null,"softDisabled":false,"foreignInstall":false,"hasBinaryComponents":false,"strictCompatibility":true,"locales":[],"targetApplications":[{"id":"{ec8030f7-c20a-464f-9b0e-13a3a9e97384}","minVersion":"45.0a1","maxVersion":"45.0a1"}],"targetPlatforms":[]} 15:23:06 INFO - 1448580186926 addons.xpi DEBUG getModTime: Recursive scan of {972ce4c6-7e08-4474-a285-3208198ce6fd} 15:23:06 INFO - 1448580186951 DeferredSave.extensions.json DEBUG Save changes 15:23:06 INFO - 1448580186957 addons.xpi DEBUG Updating XPIState for {"id":"theme-xpi@tests.mozilla.org","syncGUID":"uGTtiXs5b9nA","location":"app-profile","version":"1.0","type":"theme","internalName":"test/1.0","updateURL":null,"updateKey":null,"optionsURL":null,"optionsType":null,"aboutURL":null,"icons":{},"iconURL":null,"icon64URL":null,"defaultLocale":{"name":"Theme Test","description":null,"creator":null,"homepageURL":null},"visible":true,"active":false,"userDisabled":true,"appDisabled":false,"descriptor":"/tmp/tmpHg5nYC.mozrunner/extensions/theme-xpi@tests.mozilla.org.xpi","installDate":1448580186000,"updateDate":1448580186000,"applyBackgroundUpdates":1,"skinnable":false,"size":668,"sourceURI":"http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/theme.xpi","releaseNotesURI":null,"softDisabled":false,"foreignInstall":false,"hasBinaryComponents":false,"strictCompatibility":true,"locales":[],"targetApplications":[{"id":"toolkit@mozilla.org","minVersion":"0","maxVersion":"*"}],"targetPlatforms":[]} 15:23:07 INFO - 1448580187008 addons.xpi DEBUG uninstallAddon: flushing jar cache /tmp/tmpHg5nYC.mozrunner/extensions/theme-xpi@tests.mozilla.org.xpi for addon theme-xpi@tests.mozilla.org 15:23:07 INFO - 1448580187013 DeferredSave.extensions.json DEBUG Save changes 15:23:07 INFO - 1448580187014 addons.xpi DEBUG Removing XPIState for app-profile:theme-xpi@tests.mozilla.org 15:23:07 INFO - 1448580187116 DeferredSave.extensions.json DEBUG Starting timer 15:23:07 INFO - ++DOCSHELL 0x7a4a9400 == 125 [pid = 1906] [id = 295] 15:23:07 INFO - ++DOMWINDOW == 297 (0x7a4a9800) [pid = 1906] [serial = 799] [outer = (nil)] 15:23:07 INFO - ++DOMWINDOW == 298 (0x7a4ad800) [pid = 1906] [serial = 800] [outer = 0x7a4a9800] 15:23:07 INFO - 1448580187974 DeferredSave.extensions.json DEBUG Starting write 15:23:08 INFO - 1448580188067 DeferredSave.extensions.json DEBUG Write succeeded 15:23:08 INFO - ++DOMWINDOW == 299 (0x7a5ab800) [pid = 1906] [serial = 801] [outer = 0x7a4a9800] 15:23:08 INFO - Sending InstallTriggered 15:23:08 INFO - 1448580188957 addons.xpi DEBUG Download started for http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/restartless.xpi to file /tmp/tmp-nhx.xpi 15:23:08 INFO - 1448580188965 addons.xpi DEBUG Download of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/restartless.xpi completed. 15:23:09 INFO - 1448580189055 addons.repository DEBUG cacheAddons: enabled false IDs ["restartless-xpi@tests.mozilla.org"] 15:23:09 INFO - 1448580189236 addons.xpi DEBUG Starting install of restartless-xpi@tests.mozilla.org from http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/restartless.xpi 15:23:09 INFO - 1448580189343 addons.xpi DEBUG Addon restartless-xpi@tests.mozilla.org will be installed as a packed xpi 15:23:09 INFO - 1448580189377 addons.xpi INFO Mapping restartless-xpi@tests.mozilla.org to /tmp/tmpHg5nYC.mozrunner/extensions/restartless-xpi@tests.mozilla.org.xpi 15:23:09 INFO - 1448580189381 addons.xpi-utils DEBUG Make addon app-profile:restartless-xpi@tests.mozilla.org visible 15:23:09 INFO - 1448580189384 DeferredSave.extensions.json DEBUG Save changes 15:23:09 INFO - 1448580189385 DeferredSave.extensions.json DEBUG Save changes 15:23:09 INFO - 1448580189388 addons.xpi DEBUG XPIStates adding add-on restartless-xpi@tests.mozilla.org in app-profile: /tmp/tmpHg5nYC.mozrunner/extensions/restartless-xpi@tests.mozilla.org.xpi 15:23:09 INFO - 1448580189396 addons.xpi DEBUG Updating XPIState for {"id":"restartless-xpi@tests.mozilla.org","syncGUID":"7FP8V-KQY620","location":"app-profile","version":"1.0","type":"extension","internalName":null,"updateURL":null,"updateKey":null,"optionsURL":null,"optionsType":null,"aboutURL":null,"icons":{},"iconURL":null,"icon64URL":null,"defaultLocale":{"name":"XPI Test","description":null,"creator":null,"homepageURL":null},"visible":true,"active":true,"userDisabled":false,"appDisabled":false,"descriptor":"/tmp/tmpHg5nYC.mozrunner/extensions/restartless-xpi@tests.mozilla.org.xpi","installDate":1448580189067,"updateDate":1448580189067,"applyBackgroundUpdates":1,"bootstrap":true,"size":637,"sourceURI":"http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/restartless.xpi","releaseNotesURI":null,"softDisabled":false,"foreignInstall":false,"hasBinaryComponents":false,"strictCompatibility":false,"locales":[],"targetApplications":[{"id":"toolkit@mozilla.org","minVersion":"0","maxVersion":"*"}],"targetPlatforms":[],"multiprocessCompatible":false,"signedState":0} 15:23:09 INFO - 1448580189400 addons.xpi DEBUG getModTime: Recursive scan of restartless-xpi@tests.mozilla.org 15:23:09 INFO - 1448580189401 DeferredSave.extensions.json DEBUG Save changes 15:23:09 INFO - 1448580189404 DeferredSave.extensions.json DEBUG Save changes 15:23:09 INFO - 1448580189410 addons.xpi DEBUG Loading bootstrap scope from /tmp/tmpHg5nYC.mozrunner/extensions/restartless-xpi@tests.mozilla.org.xpi 15:23:09 INFO - 1448580189436 addons.xpi WARN Error loading bootstrap.js for restartless-xpi@tests.mozilla.org: Error opening input stream (invalid filename?): jar:file:///tmp/tmpHg5nYC.mozrunner/extensions/restartless-xpi@tests.mozilla.org.xpi!/bootstrap.js 15:23:09 INFO - 1448580189440 addons.xpi WARN Add-on restartless-xpi@tests.mozilla.org is missing bootstrap method install 15:23:09 INFO - 1448580189452 addons.xpi DEBUG Install of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/restartless.xpi completed. 15:23:09 INFO - 1448580189481 addons.xpi DEBUG Registering manifest for /tmp/tmpHg5nYC.mozrunner/extensions/restartless-xpi@tests.mozilla.org.xpi 15:23:09 INFO - 1448580189483 addons.xpi WARN Add-on restartless-xpi@tests.mozilla.org is missing bootstrap method startup 15:23:09 INFO - 1448580189485 DeferredSave.extensions.json DEBUG Starting timer 15:23:09 INFO - 1448580189565 addons.xpi DEBUG removeTemporaryFile: http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/restartless.xpi removing temp file /tmp/tmp-nhx.xpi 15:23:09 INFO - Sending InstallComplete 15:23:09 INFO - 1448580189813 DeferredSave.extensions.json DEBUG Starting write 15:23:09 INFO - 1448580189910 addons.xpi WARN Add-on restartless-xpi@tests.mozilla.org is missing bootstrap method shutdown 15:23:09 INFO - 1448580189912 addons.xpi DEBUG Removing manifest for /tmp/tmpHg5nYC.mozrunner/extensions/restartless-xpi@tests.mozilla.org.xpi 15:23:09 INFO - 1448580189925 addons.xpi WARN Add-on restartless-xpi@tests.mozilla.org is missing bootstrap method uninstall 15:23:09 INFO - 1448580189929 addons.xpi DEBUG uninstallAddon: flushing jar cache /tmp/tmpHg5nYC.mozrunner/extensions/restartless-xpi@tests.mozilla.org.xpi for addon restartless-xpi@tests.mozilla.org 15:23:09 INFO - 1448580189931 DeferredSave.extensions.json DEBUG Save changes 15:23:09 INFO - 1448580189934 DeferredSave.extensions.json DEBUG Data changed while write in progress 15:23:09 INFO - 1448580189937 addons.xpi DEBUG Removing XPIState for app-profile:restartless-xpi@tests.mozilla.org 15:23:10 INFO - 1448580190278 DeferredSave.extensions.json DEBUG Write succeeded 15:23:10 INFO - 1448580190279 DeferredSave.extensions.json DEBUG Starting timer 15:23:10 INFO - ++DOCSHELL 0x7c007400 == 126 [pid = 1906] [id = 296] 15:23:10 INFO - ++DOMWINDOW == 300 (0x7c007800) [pid = 1906] [serial = 802] [outer = (nil)] 15:23:10 INFO - ++DOMWINDOW == 301 (0x7c00b800) [pid = 1906] [serial = 803] [outer = 0x7c007800] 15:23:10 INFO - 1448580190742 DeferredSave.extensions.json DEBUG Starting write 15:23:10 INFO - ++DOMWINDOW == 302 (0x7c00d400) [pid = 1906] [serial = 804] [outer = 0x7c007800] 15:23:10 INFO - 1448580190906 DeferredSave.extensions.json DEBUG Write succeeded 15:23:11 INFO - 1448580191368 addons.xpi DEBUG Download started for http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/unsigned.xpi to file /tmp/tmp-x8s.xpi 15:23:11 INFO - 1448580191378 addons.xpi DEBUG Download of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/unsigned.xpi completed. 15:23:11 INFO - 1448580191454 addons.repository DEBUG cacheAddons: enabled false IDs ["unsigned-xpi@tests.mozilla.org"] 15:23:11 INFO - 1448580191612 addons.xpi DEBUG Starting install of unsigned-xpi@tests.mozilla.org from http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/unsigned.xpi 15:23:11 INFO - 1448580191721 addons.xpi DEBUG Addon unsigned-xpi@tests.mozilla.org will be installed as a packed xpi 15:23:11 INFO - 1448580191762 addons.xpi DEBUG Staged install of unsigned-xpi@tests.mozilla.org from http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/unsigned.xpi ready; waiting for restart. 15:23:11 INFO - 1448580191817 addons.xpi DEBUG removeTemporaryFile: http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/unsigned.xpi removing temp file /tmp/tmp-x8s.xpi 15:23:11 INFO - 1448580191919 addons.xpi DEBUG Cancelling install of unsigned-xpi@tests.mozilla.org 15:23:12 INFO - ++DOCSHELL 0x7a84a800 == 127 [pid = 1906] [id = 297] 15:23:12 INFO - ++DOMWINDOW == 303 (0x7a84ac00) [pid = 1906] [serial = 805] [outer = (nil)] 15:23:12 INFO - ++DOMWINDOW == 304 (0x7a84ec00) [pid = 1906] [serial = 806] [outer = 0x7a84ac00] 15:23:12 INFO - ++DOMWINDOW == 305 (0x7a848800) [pid = 1906] [serial = 807] [outer = 0x7a84ac00] 15:23:12 INFO - 1448580192848 addons.xpi WARN Invalid XPI: [Exception... "Component returned failure code: 0x8052000b (NS_ERROR_FILE_CORRUPTED) [nsIZipReader.open]" nsresult: "0x8052000b (NS_ERROR_FILE_CORRUPTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm :: AI_loadManifest :: line 5388" data: no] Stack trace: AI_loadManifest()@resource://gre/modules/addons/XPIProvider.jsm:5388 < TaskImpl_run()@resource://gre/modules/Task.jsm:314 < TaskImpl()@resource://gre/modules/Task.jsm:275 < createAsyncFunction/asyncFunction()@resource://gre/modules/Task.jsm:249 < AI_initLocalInstall()@resource://gre/modules/addons/XPIProvider.jsm:5057 < AI_createDownload()@resource://gre/modules/addons/XPIProvider.jsm:6113 < XPI_getInstallForURL()@resource://gre/modules/addons/XPIProvider.jsm:3795 < callProviderAsync()@resource://gre/modules/AddonManager.jsm:251 < AMI_getInstallForURL()@resource://gre/modules/AddonManager.jsm:1967 < AM_getInstallForURL()@resource://gre/modules/AddonManager.jsm:3149 < buildNextInstall()@resource://gre/components/addonManager.js:101 < AMC_installAddonsFromWebpage()@resource://gre/components/addonManager.js:142 < AMC_receiveMessage()@resource://gre/components/addonManager.js:178 15:23:12 INFO - 1448580192906 addons.xpi DEBUG removeTemporaryFile: file:///builds/slave/test/build/tests/mochitest/browser/toolkit/mozapps/extensions/test/xpinstall/corrupt.xpi does not own temp file 15:23:13 INFO - 1448580193014 addons.xpi DEBUG Download started for file:///builds/slave/test/build/tests/mochitest/browser/toolkit/mozapps/extensions/test/xpinstall/corrupt.xpi to file /tmp/tmp-gv2.xpi 15:23:13 INFO - 1448580193021 addons.xpi DEBUG Download of file:///builds/slave/test/build/tests/mochitest/browser/toolkit/mozapps/extensions/test/xpinstall/corrupt.xpi completed. 15:23:13 INFO - 1448580193030 addons.xpi WARN Download of file:///builds/slave/test/build/tests/mochitest/browser/toolkit/mozapps/extensions/test/xpinstall/corrupt.xpi failed: [Exception... "Component returned failure code: 0x8052000b (NS_ERROR_FILE_CORRUPTED) [nsIZipReader.open]" nsresult: "0x8052000b (NS_ERROR_FILE_CORRUPTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm :: AI_loadManifest :: line 5388" data: no] Stack trace: AI_loadManifest()@resource://gre/modules/addons/XPIProvider.jsm:5388 < TaskImpl_run()@resource://gre/modules/Task.jsm:314 < TaskImpl()@resource://gre/modules/Task.jsm:275 < createAsyncFunction/asyncFunction()@resource://gre/modules/Task.jsm:249 < AI_onStopRequest()@resource://gre/modules/addons/XPIProvider.jsm:5715 15:23:13 INFO - 1448580193091 addons.xpi DEBUG downloadFailed: removing temp file for file:///builds/slave/test/build/tests/mochitest/browser/toolkit/mozapps/extensions/test/xpinstall/corrupt.xpi 15:23:13 INFO - 1448580193094 addons.xpi DEBUG removeTemporaryFile: file:///builds/slave/test/build/tests/mochitest/browser/toolkit/mozapps/extensions/test/xpinstall/corrupt.xpi removing temp file /tmp/tmp-gv2.xpi 15:23:13 INFO - ++DOCSHELL 0x7a8f7000 == 128 [pid = 1906] [id = 298] 15:23:13 INFO - ++DOMWINDOW == 306 (0x7a8f7400) [pid = 1906] [serial = 808] [outer = (nil)] 15:23:13 INFO - ++DOMWINDOW == 307 (0x7a8fb400) [pid = 1906] [serial = 809] [outer = 0x7a8f7400] 15:23:13 INFO - ++DOMWINDOW == 308 (0x7a8fa000) [pid = 1906] [serial = 810] [outer = 0x7a8f7400] 15:23:14 INFO - 1448580194320 addons.xpi DEBUG Download started for http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/unsigned.xpi to file /tmp/tmp-twa.xpi 15:23:14 INFO - 1448580194327 addons.xpi DEBUG Download of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/unsigned.xpi completed. 15:23:17 INFO - --DOCSHELL 0x7af69c00 == 127 [pid = 1906] [id = 224] 15:23:17 INFO - --DOCSHELL 0x7d34ec00 == 126 [pid = 1906] [id = 186] 15:23:17 INFO - --DOCSHELL 0x7b42a800 == 125 [pid = 1906] [id = 185] 15:23:17 INFO - --DOCSHELL 0x7cff3c00 == 124 [pid = 1906] [id = 188] 15:23:17 INFO - --DOCSHELL 0x7cf04800 == 123 [pid = 1906] [id = 184] 15:23:17 INFO - --DOCSHELL 0x8f1f0400 == 122 [pid = 1906] [id = 201] 15:23:17 INFO - --DOCSHELL 0x803f1c00 == 121 [pid = 1906] [id = 202] 15:23:17 INFO - --DOCSHELL 0x99240c00 == 120 [pid = 1906] [id = 222] 15:23:17 INFO - --DOCSHELL 0x9952f800 == 119 [pid = 1906] [id = 223] 15:23:17 INFO - --DOCSHELL 0x806c5400 == 118 [pid = 1906] [id = 191] 15:23:17 INFO - --DOCSHELL 0x81729800 == 117 [pid = 1906] [id = 192] 15:23:17 INFO - --DOCSHELL 0x8b647800 == 116 [pid = 1906] [id = 198] 15:23:17 INFO - --DOCSHELL 0x9a665c00 == 115 [pid = 1906] [id = 268] 15:23:17 INFO - --DOCSHELL 0x9b21c800 == 114 [pid = 1906] [id = 269] 15:23:17 INFO - --DOCSHELL 0x9b33c800 == 113 [pid = 1906] [id = 270] 15:23:17 INFO - --DOCSHELL 0x7af72400 == 112 [pid = 1906] [id = 181] 15:23:17 INFO - --DOCSHELL 0x9b463c00 == 111 [pid = 1906] [id = 271] 15:23:17 INFO - --DOCSHELL 0x81871000 == 110 [pid = 1906] [id = 193] 15:23:17 INFO - --DOCSHELL 0x7adb7c00 == 109 [pid = 1906] [id = 187] 15:23:17 INFO - --DOCSHELL 0x7d59c400 == 108 [pid = 1906] [id = 189] 15:23:17 INFO - --DOCSHELL 0x80427400 == 107 [pid = 1906] [id = 190] 15:23:17 INFO - --DOCSHELL 0x819d5000 == 106 [pid = 1906] [id = 194] 15:23:17 INFO - --DOCSHELL 0x81976000 == 105 [pid = 1906] [id = 195] 15:23:17 INFO - --DOCSHELL 0x8aede000 == 104 [pid = 1906] [id = 196] 15:23:17 INFO - --DOCSHELL 0x7ad9dc00 == 103 [pid = 1906] [id = 180] 15:23:17 INFO - --DOCSHELL 0x909a4c00 == 102 [pid = 1906] [id = 204] 15:23:17 INFO - --DOCSHELL 0x9134ec00 == 101 [pid = 1906] [id = 175] 15:23:17 INFO - --DOCSHELL 0x91906800 == 100 [pid = 1906] [id = 216] 15:23:17 INFO - --DOCSHELL 0x8f671000 == 99 [pid = 1906] [id = 203] 15:23:17 INFO - --DOCSHELL 0x8f12b400 == 98 [pid = 1906] [id = 200] 15:23:17 INFO - --DOCSHELL 0x8b645c00 == 97 [pid = 1906] [id = 199] 15:23:17 INFO - --DOCSHELL 0x909b1c00 == 96 [pid = 1906] [id = 205] 15:23:17 INFO - --DOCSHELL 0x90d9c800 == 95 [pid = 1906] [id = 206] 15:23:17 INFO - --DOCSHELL 0x90d9d000 == 94 [pid = 1906] [id = 207] 15:23:17 INFO - --DOCSHELL 0x915b7000 == 93 [pid = 1906] [id = 209] 15:23:17 INFO - --DOCSHELL 0x91065000 == 92 [pid = 1906] [id = 208] 15:23:17 INFO - --DOCSHELL 0x91061c00 == 91 [pid = 1906] [id = 210] 15:23:17 INFO - --DOCSHELL 0x9105ec00 == 90 [pid = 1906] [id = 211] 15:23:17 INFO - --DOCSHELL 0x91062400 == 89 [pid = 1906] [id = 212] 15:23:17 INFO - --DOCSHELL 0x941c9800 == 88 [pid = 1906] [id = 214] 15:23:17 INFO - --DOCSHELL 0x91d3f800 == 87 [pid = 1906] [id = 215] 15:23:17 INFO - --DOCSHELL 0x91d38800 == 86 [pid = 1906] [id = 213] 15:23:17 INFO - --DOCSHELL 0x99241000 == 85 [pid = 1906] [id = 218] 15:23:17 INFO - --DOCSHELL 0x99f54000 == 84 [pid = 1906] [id = 221] 15:23:17 INFO - --DOCSHELL 0x9952fc00 == 83 [pid = 1906] [id = 219] 15:23:17 INFO - --DOCSHELL 0x99531400 == 82 [pid = 1906] [id = 220] 15:23:17 INFO - --DOCSHELL 0x91d37400 == 81 [pid = 1906] [id = 217] 15:23:17 INFO - --DOCSHELL 0x7b336000 == 80 [pid = 1906] [id = 226] 15:23:17 INFO - --DOCSHELL 0x7c0fc400 == 79 [pid = 1906] [id = 229] 15:23:17 INFO - --DOCSHELL 0x7b33dc00 == 78 [pid = 1906] [id = 227] 15:23:17 INFO - --DOCSHELL 0x7b33f400 == 77 [pid = 1906] [id = 228] 15:23:17 INFO - --DOCSHELL 0x7c0f3000 == 76 [pid = 1906] [id = 231] 15:23:17 INFO - --DOCSHELL 0x7cfedc00 == 75 [pid = 1906] [id = 234] 15:23:17 INFO - --DOCSHELL 0x7c4dbc00 == 74 [pid = 1906] [id = 232] 15:23:17 INFO - --DOCSHELL 0x7d764c00 == 73 [pid = 1906] [id = 238] 15:23:17 INFO - --DOCSHELL 0x7c2d4800 == 72 [pid = 1906] [id = 241] 15:23:17 INFO - --DOCSHELL 0x7af72800 == 71 [pid = 1906] [id = 239] 15:23:17 INFO - --DOCSHELL 0x7b116800 == 70 [pid = 1906] [id = 240] 15:23:17 INFO - --DOCSHELL 0x80357000 == 69 [pid = 1906] [id = 244] 15:23:17 INFO - --DOCSHELL 0x80efe800 == 68 [pid = 1906] [id = 247] 15:23:17 INFO - --DOCSHELL 0x8061fc00 == 67 [pid = 1906] [id = 245] 15:23:17 INFO - --DOCSHELL 0x80621000 == 66 [pid = 1906] [id = 246] 15:23:17 INFO - --DOCSHELL 0x81872c00 == 65 [pid = 1906] [id = 249] 15:23:17 INFO - --DOCSHELL 0x8b3d5000 == 64 [pid = 1906] [id = 252] 15:23:17 INFO - --DOCSHELL 0x8ad74c00 == 63 [pid = 1906] [id = 250] 15:23:17 INFO - --DOCSHELL 0x8ad76400 == 62 [pid = 1906] [id = 251] 15:23:17 INFO - --DOCSHELL 0x8b64c000 == 61 [pid = 1906] [id = 254] 15:23:17 INFO - --DOCSHELL 0x8f666400 == 60 [pid = 1906] [id = 257] 15:23:17 INFO - --DOCSHELL 0x8f019c00 == 59 [pid = 1906] [id = 255] 15:23:17 INFO - --DOCSHELL 0x8f01e800 == 58 [pid = 1906] [id = 256] 15:23:17 INFO - --DOCSHELL 0x90dbc000 == 57 [pid = 1906] [id = 260] 15:23:17 INFO - --DOCSHELL 0xa4c57000 == 56 [pid = 1906] [id = 277] 15:23:17 INFO - --DOCSHELL 0xa90d1800 == 55 [pid = 1906] [id = 280] 15:23:17 INFO - --DOCSHELL 0xa4cdc000 == 54 [pid = 1906] [id = 278] 15:23:17 INFO - --DOCSHELL 0xa58b9800 == 53 [pid = 1906] [id = 279] 15:23:19 INFO - --DOCSHELL 0x7cf0f400 == 52 [pid = 1906] [id = 183] 15:23:19 INFO - --DOCSHELL 0x7ccdc800 == 51 [pid = 1906] [id = 182] 15:23:20 INFO - --DOMWINDOW == 307 (0x91d66800) [pid = 1906] [serial = 500] [outer = (nil)] [url = about:newtab] 15:23:20 INFO - --DOMWINDOW == 306 (0x99533400) [pid = 1906] [serial = 511] [outer = (nil)] [url = about:customizing] 15:23:20 INFO - --DOMWINDOW == 305 (0x7cfbc000) [pid = 1906] [serial = 519] [outer = (nil)] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 304 (0x803ed800) [pid = 1906] [serial = 447] [outer = (nil)] [url = about:plugins] 15:23:20 INFO - --DOMWINDOW == 303 (0x91fa4c00) [pid = 1906] [serial = 502] [outer = (nil)] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 302 (0x91280800) [pid = 1906] [serial = 489] [outer = (nil)] [url = about:customizing] 15:23:20 INFO - --DOMWINDOW == 301 (0x7dba4400) [pid = 1906] [serial = 446] [outer = (nil)] [url = about:config] 15:23:20 INFO - --DOMWINDOW == 300 (0x803ec800) [pid = 1906] [serial = 274] [outer = (nil)] [url = about:newtab] 15:23:20 INFO - 1448580200295 addons.repository DEBUG cacheAddons: enabled false IDs ["unsigned-xpi@tests.mozilla.org"] 15:23:20 INFO - --DOMWINDOW == 299 (0xa656e400) [pid = 1906] [serial = 752] [outer = 0xa6566000] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 298 (0x7adafc00) [pid = 1906] [serial = 646] [outer = 0x7c4dc800] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 297 (0x8ad7bc00) [pid = 1906] [serial = 689] [outer = 0x8ad77000] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 296 (0x7c117c00) [pid = 1906] [serial = 635] [outer = 0x7b33f800] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 295 (0x80624800) [pid = 1906] [serial = 676] [outer = 0x80621400] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 294 (0x9a56ec00) [pid = 1906] [serial = 616] [outer = 0x99531c00] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 293 (0xac1afc00) [pid = 1906] [serial = 756] [outer = 0xa6566000] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 292 (0x9131a400) [pid = 1906] [serial = 581] [outer = 0x90d9dc00] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 291 (0x90da1400) [pid = 1906] [serial = 577] [outer = 0x90d9dc00] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 290 (0x7cfb7400) [pid = 1906] [serial = 664] [outer = 0x7b114c00] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 289 (0x99535800) [pid = 1906] [serial = 612] [outer = 0x99531c00] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 288 (0x9a56bc00) [pid = 1906] [serial = 615] [outer = 0x99531000] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 287 (0x91318400) [pid = 1906] [serial = 580] [outer = 0x90d9cc00] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 286 (0x8f027400) [pid = 1906] [serial = 702] [outer = 0x8f025800] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 285 (0x7d34b800) [pid = 1906] [serial = 647] [outer = 0x7c4dd400] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 284 (0x7b342800) [pid = 1906] [serial = 631] [outer = 0x7b33f800] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 283 (0x90810800) [pid = 1906] [serial = 706] [outer = 0x8f025800] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 282 (0x7b11c000) [pid = 1906] [serial = 661] [outer = 0x7b117000] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 281 (0x7b1cb400) [pid = 1906] [serial = 665] [outer = 0x7b117000] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 280 (0x7c116000) [pid = 1906] [serial = 634] [outer = 0x7b33ec00] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 279 (0xac1ae000) [pid = 1906] [serial = 755] [outer = 0xa58afc00] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 278 (0x7ccd8400) [pid = 1906] [serial = 643] [outer = 0x7c4dd400] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 277 (0x8172f800) [pid = 1906] [serial = 680] [outer = 0x80621400] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 276 (0x8b3d8c00) [pid = 1906] [serial = 692] [outer = 0x8ad75400] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 275 (0x9080a000) [pid = 1906] [serial = 705] [outer = 0x8f01b400] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 274 (0x81668c00) [pid = 1906] [serial = 679] [outer = 0x80620000] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 273 (0x9135a800) [pid = 1906] [serial = 591] [outer = 0x91063400] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 272 (0x91f97c00) [pid = 1906] [serial = 595] [outer = 0x91063400] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 271 (0x8b60e400) [pid = 1906] [serial = 693] [outer = 0x8ad77000] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 270 (0x91d62c00) [pid = 1906] [serial = 594] [outer = 0x9105f400] [url = about:blank] 15:23:20 INFO - 1448580200682 addons.xpi DEBUG Cancelling download of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/unsigned.xpi 15:23:20 INFO - 1448580200690 addons.xpi DEBUG removeTemporaryFile: http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/unsigned.xpi removing temp file /tmp/tmp-twa.xpi 15:23:20 INFO - --DOMWINDOW == 269 (0x90d9dc00) [pid = 1906] [serial = 576] [outer = (nil)] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 268 (0x7b33ec00) [pid = 1906] [serial = 629] [outer = (nil)] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 267 (0x9105f400) [pid = 1906] [serial = 589] [outer = (nil)] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 266 (0x99531000) [pid = 1906] [serial = 610] [outer = (nil)] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 265 (0xa6566000) [pid = 1906] [serial = 751] [outer = (nil)] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 264 (0x7c4dc800) [pid = 1906] [serial = 641] [outer = (nil)] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 263 (0x80621400) [pid = 1906] [serial = 675] [outer = (nil)] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 262 (0x8ad77000) [pid = 1906] [serial = 688] [outer = (nil)] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 261 (0x99531c00) [pid = 1906] [serial = 611] [outer = (nil)] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 260 (0x8f025800) [pid = 1906] [serial = 701] [outer = (nil)] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 259 (0x91063400) [pid = 1906] [serial = 590] [outer = (nil)] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 258 (0x7b114c00) [pid = 1906] [serial = 659] [outer = (nil)] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 257 (0x7b33f800) [pid = 1906] [serial = 630] [outer = (nil)] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 256 (0x90d9cc00) [pid = 1906] [serial = 575] [outer = (nil)] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 255 (0x7c4dd400) [pid = 1906] [serial = 642] [outer = (nil)] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 254 (0x7b117000) [pid = 1906] [serial = 660] [outer = (nil)] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 253 (0xa58afc00) [pid = 1906] [serial = 750] [outer = (nil)] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 252 (0x80620000) [pid = 1906] [serial = 674] [outer = (nil)] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 251 (0x8ad75400) [pid = 1906] [serial = 687] [outer = (nil)] [url = about:blank] 15:23:20 INFO - --DOMWINDOW == 250 (0x8f01b400) [pid = 1906] [serial = 700] [outer = (nil)] [url = about:blank] 15:23:21 INFO - ++DOCSHELL 0x79f2e000 == 52 [pid = 1906] [id = 299] 15:23:21 INFO - ++DOMWINDOW == 251 (0x79f2e400) [pid = 1906] [serial = 811] [outer = (nil)] 15:23:21 INFO - ++DOMWINDOW == 252 (0x79f36c00) [pid = 1906] [serial = 812] [outer = 0x79f2e400] 15:23:22 INFO - ++DOMWINDOW == 253 (0x79fd4000) [pid = 1906] [serial = 813] [outer = 0x79f2e400] 15:23:22 INFO - Sending InstallTriggered 15:23:22 INFO - 1448580202721 addons.xpi DEBUG Download started for http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/unsigned.xpi to file /tmp/tmp-b9p.xpi 15:23:22 INFO - 1448580202735 addons.xpi DEBUG Download of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/unsigned.xpi completed. 15:23:22 INFO - 1448580202894 addons.repository DEBUG cacheAddons: enabled false IDs ["unsigned-xpi@tests.mozilla.org"] 15:23:23 INFO - ++DOMWINDOW == 254 (0x7a1c5400) [pid = 1906] [serial = 814] [outer = 0x79f2e400] 15:23:23 INFO - 1448580203128 addons.xpi DEBUG Cancelling download of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/unsigned.xpi 15:23:23 INFO - 1448580203167 addons.xpi DEBUG removeTemporaryFile: http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/unsigned.xpi removing temp file /tmp/tmp-b9p.xpi 15:23:23 INFO - Sending InstallComplete 15:23:23 INFO - ++DOCSHELL 0x79fcdc00 == 53 [pid = 1906] [id = 300] 15:23:23 INFO - ++DOMWINDOW == 255 (0x7a1c8000) [pid = 1906] [serial = 815] [outer = (nil)] 15:23:23 INFO - ++DOMWINDOW == 256 (0x7a271000) [pid = 1906] [serial = 816] [outer = 0x7a1c8000] 15:23:23 INFO - ++DOMWINDOW == 257 (0x7a26ac00) [pid = 1906] [serial = 817] [outer = 0x7a1c8000] 15:23:24 INFO - 1448580204353 addons.xpi DEBUG Cancelling download of http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/unsigned.xpi 15:23:24 INFO - 1448580204357 addons.xpi DEBUG removeTemporaryFile: http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/unsigned.xpi does not own temp file 15:23:24 INFO - ++DOCSHELL 0x7a4ac800 == 54 [pid = 1906] [id = 301] 15:23:24 INFO - ++DOMWINDOW == 258 (0x7a4b1000) [pid = 1906] [serial = 818] [outer = (nil)] 15:23:24 INFO - ++DOMWINDOW == 259 (0x7a5ad800) [pid = 1906] [serial = 819] [outer = 0x7a4b1000] 15:23:25 INFO - ++DOMWINDOW == 260 (0x7a5b0400) [pid = 1906] [serial = 820] [outer = 0x7a4b1000] 15:23:25 INFO - Sending PageLoaded 15:23:28 INFO - --DOMWINDOW == 259 (0x7ab2e000) [pid = 1906] [serial = 768] [outer = (nil)] [url = http://example.com/browser/toolkit/mozapps/extensions/test/xpinstall/installtrigger.html?%7B%22XPI%22%3A%22unsigned.xpi%22%7D] 15:23:28 INFO - --DOMWINDOW == 258 (0x806c5c00) [pid = 1906] [serial = 538] [outer = (nil)] [url = about:blank] 15:23:28 INFO - --DOMWINDOW == 257 (0x7ab1b800) [pid = 1906] [serial = 763] [outer = (nil)] [url = chrome://mochitests/content/browser/browser/base/content/test/general/file_bug550565_popup.html] 15:23:28 INFO - --DOMWINDOW == 256 (0x8f028400) [pid = 1906] [serial = 728] [outer = (nil)] [url = about:blank] 15:23:28 INFO - --DOMWINDOW == 255 (0x8b60a800) [pid = 1906] [serial = 554] [outer = (nil)] [url = about:newtab] 15:23:28 INFO - --DOMWINDOW == 254 (0x7b42fc00) [pid = 1906] [serial = 667] [outer = (nil)] [url = about:blank] 15:23:28 INFO - --DOMWINDOW == 253 (0x8f667c00) [pid = 1906] [serial = 703] [outer = (nil)] [url = about:blank] 15:23:28 INFO - --DOMWINDOW == 252 (0x943fbc00) [pid = 1906] [serial = 719] [outer = (nil)] [url = about:blank] 15:23:28 INFO - --DOMWINDOW == 251 (0x8034f000) [pid = 1906] [serial = 669] [outer = (nil)] [url = about:blank] 15:23:28 INFO - --DOMWINDOW == 250 (0x7b341400) [pid = 1906] [serial = 637] [outer = (nil)] [url = about:blank] 15:23:28 INFO - --DOMWINDOW == 249 (0x9b46c800) [pid = 1906] [serial = 736] [outer = (nil)] [url = about:blank] 15:23:28 INFO - --DOMWINDOW == 248 (0x8b64bc00) [pid = 1906] [serial = 559] [outer = (nil)] [url = data:text/html,%20%20
%20%20%20%20
%20%20%20%20%20%20%20%20