builder: mozilla-inbound_ubuntu32_vm-debug_test-mochitest-devtools-chrome-5 slave: tst-linux32-spot-549 starttime: 1448579647.19 results: success (0) buildid: 20151126135412 builduid: a6f63bb04be644bfadd7d5956ee0532b revision: 1bf6fd3421e6cb23b386e6e01e718b05453b373a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-26 15:14:07.190961) ========= master: http://buildbot-master07.bb.releng.usw2.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-26 15:14:07.191338) ========= ========= Started set props: basedir (results: 0, elapsed: 2 secs) (at 2015-11-26 15:14:07.191626) ========= 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-1448579446.6075-694935828 _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.019297 basedir: '/builds/slave/test' ========= master_lag: 2.09 ========= ========= Finished set props: basedir (results: 0, elapsed: 2 secs) (at 2015-11-26 15:14:09.301680) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-26 15:14:09.301988) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-26 15:14:09.333701) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 15:14:09.333956) ========= 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-1448579446.6075-694935828 _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017505 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 15:14:09.393916) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-26 15:14:09.394199) ========= 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:14:09.394530) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 15:14:09.394803) ========= 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-1448579446.6075-694935828 _=/tools/buildbot/bin/python using PTY: False --2015-11-26 15:14:09-- 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% 8.19M=0.001s 2015-11-26 15:14:09 (8.19 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.359929 ========= master_lag: 0.17 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 15:14:09.926728) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 15:14:09.927030) ========= 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-1448579446.6075-694935828 _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.057185 ========= master_lag: 0.24 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 15:14:10.226500) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 15:14:10.226810) ========= 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-1448579446.6075-694935828 _=/tools/buildbot/bin/python using PTY: False 2015-11-26 15:14:10,322 truncating revision to first 12 chars 2015-11-26 15:14:10,322 Setting DEBUG logging. 2015-11-26 15:14:10,323 attempt 1/10 2015-11-26 15:14:10,323 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:10,871 unpacking tar archive at: mozilla-inbound-1bf6fd3421e6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.826829 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 15:14:11.080845) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-26 15:14:11.081348) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-26 15:14:11.104416) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-26 15:14:11.104819) ========= 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:11.105424) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/desktop_unittest.py ...' (results: 0, elapsed: 28 mins, 3 secs) (at 2015-11-26 15:14:11.105873) ========= /tools/buildbot/bin/python scripts/scripts/desktop_unittest.py --cfg unittests/linux_unittest.py --mochitest-suite mochitest-devtools-chrome-chunked --total-chunks 8 --this-chunk 5 --blob-upload-branch mozilla-inbound --download-symbols true in dir /builds/slave/test/. (timeout 1800 secs) (maxTime 4800 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/desktop_unittest.py', '--cfg', 'unittests/linux_unittest.py', '--mochitest-suite', 'mochitest-devtools-chrome-chunked', '--total-chunks', '8', '--this-chunk', '5', '--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-1448579446.6075-694935828 _=/tools/buildbot/bin/python using PTY: False 15:14:11 INFO - MultiFileLogger online at 20151126 15:14:11 in /builds/slave/test 15:14:11 INFO - Run as scripts/scripts/desktop_unittest.py --cfg unittests/linux_unittest.py --mochitest-suite mochitest-devtools-chrome-chunked --total-chunks 8 --this-chunk 5 --blob-upload-branch mozilla-inbound --download-symbols true 15:14:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:14:11 INFO - {'all_cppunittest_suites': {'cppunittest': {'tests': ('tests/cppunittest',)}}, 15:14:11 INFO - 'all_gtest_suites': {'gtest': ()}, 15:14:11 INFO - 'all_jittest_suites': {'jittest': (), 15:14:11 INFO - 'jittest-chunked': (), 15:14:11 INFO - 'jittest1': ('--total-chunks=2', '--this-chunk=1'), 15:14:11 INFO - 'jittest2': ('--total-chunks=2', '--this-chunk=2')}, 15:14:11 INFO - 'all_mochitest_suites': {'a11y': ('--a11y',), 15:14:11 INFO - 'browser-chrome': ('--browser-chrome',), 15:14:11 INFO - 'browser-chrome-addons': ('--browser-chrome', 15:14:11 INFO - '--chunk-by-runtime', 15:14:11 INFO - '--tag=addons'), 15:14:11 INFO - 'browser-chrome-chunked': ('--browser-chrome', 15:14:11 INFO - '--chunk-by-runtime'), 15:14:11 INFO - 'chrome': ('--chrome',), 15:14:11 INFO - 'chrome-chunked': ('--chrome', '--chunk-by-dir=4'), 15:14:11 INFO - 'jetpack-addon': ('--jetpack-addon',), 15:14:11 INFO - 'jetpack-package': ('--jetpack-package',), 15:14:11 INFO - 'mochitest-devtools-chrome': ('--browser-chrome', 15:14:11 INFO - '--subsuite=devtools'), 15:14:11 INFO - 'mochitest-devtools-chrome-chunked': ('--browser-chrome', 15:14:11 INFO - '--subsuite=devtools', 15:14:11 INFO - '--chunk-by-runtime'), 15:14:11 INFO - 'mochitest-gl': ('--subsuite=webgl',), 15:14:11 INFO - 'mochitest-push': ('--subsuite=push',), 15:14:11 INFO - 'plain': (), 15:14:11 INFO - 'plain-chunked': ('--chunk-by-dir=4',)}, 15:14:11 INFO - 'all_mozbase_suites': {'mozbase': ()}, 15:14:11 INFO - 'all_reftest_suites': {'crashtest': {'options': ('--suite=crashtest',), 15:14:11 INFO - 'tests': ('tests/reftest/tests/testing/crashtest/crashtests.list',)}, 15:14:11 INFO - 'crashtest-ipc': {'env': {'MOZ_DISABLE_CONTEXT_SHARING_GLX': '1', 15:14:11 INFO - 'MOZ_OMTC_ENABLED': '1'}, 15:14:11 INFO - 'options': ('--suite=crashtest', 15:14:11 INFO - '--setpref=browser.tabs.remote=true', 15:14:11 INFO - '--setpref=browser.tabs.remote.autostart=true', 15:14:11 INFO - '--setpref=layers.offmainthreadcomposition.testing.enabled=true', 15:14:11 INFO - '--setpref=layers.async-pan-zoom.enabled=true'), 15:14:11 INFO - 'tests': ('tests/reftest/tests/testing/crashtest/crashtests.list',)}, 15:14:11 INFO - 'jsreftest': {'options': ('--extra-profile-file=tests/jsreftest/tests/user.js', 15:14:11 INFO - '--suite=jstestbrowser'), 15:14:11 INFO - 'tests': ('tests/jsreftest/tests/jstests.list',)}, 15:14:11 INFO - 'reftest': {'options': ('--suite=reftest',), 15:14:11 INFO - 'tests': ('tests/reftest/tests/layout/reftests/reftest.list',)}, 15:14:11 INFO - 'reftest-ipc': {'env': {'MOZ_DISABLE_CONTEXT_SHARING_GLX': '1', 15:14:11 INFO - 'MOZ_OMTC_ENABLED': '1'}, 15:14:11 INFO - 'options': ('--suite=reftest', 15:14:11 INFO - '--setpref=browser.tabs.remote=true', 15:14:11 INFO - '--setpref=browser.tabs.remote.autostart=true', 15:14:11 INFO - '--setpref=layers.offmainthreadcomposition.testing.enabled=true', 15:14:11 INFO - '--setpref=layers.async-pan-zoom.enabled=true'), 15:14:11 INFO - 'tests': ('tests/reftest/tests/layout/reftests/reftest-sanity/reftest.list',)}, 15:14:11 INFO - 'reftest-no-accel': {'options': ('--suite=reftest', 15:14:11 INFO - '--setpref=layers.acceleration.force-enabled=disabled'), 15:14:11 INFO - 'tests': ('tests/reftest/tests/layout/reftests/reftest.list',)}}, 15:14:11 INFO - 'all_webapprt_suites': {'chrome': ('--webapprt-chrome', 15:14:11 INFO - '--browser-arg=-test-mode'), 15:14:11 INFO - 'content': ('--webapprt-content',)}, 15:14:11 INFO - 'all_xpcshell_suites': {'xpcshell': {'options': ('--xpcshell=%(abs_app_dir)s/xpcshell', 15:14:11 INFO - '--manifest=tests/xpcshell/tests/all-test-dirs.list'), 15:14:11 INFO - 'tests': ()}, 15:14:11 INFO - 'xpcshell-addons': {'options': ('--xpcshell=%(abs_app_dir)s/xpcshell', 15:14:11 INFO - '--tag=addons', 15:14:11 INFO - '--manifest=tests/xpcshell/tests/all-test-dirs.list'), 15:14:11 INFO - 'tests': ()}}, 15:14:11 INFO - 'append_to_log': False, 15:14:11 INFO - 'base_work_dir': '/builds/slave/test', 15:14:11 INFO - 'binary_path': '/builds/slave/test/build/firefox/firefox-bin', 15:14:11 INFO - 'blob_upload_branch': 'mozilla-inbound', 15:14:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:14:11 INFO - 'buildbot_json_path': 'buildprops.json', 15:14:11 INFO - 'buildbot_max_log_size': 52428800, 15:14:11 INFO - 'code_coverage': False, 15:14:11 INFO - 'config_files': ('unittests/linux_unittest.py',), 15:14:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:14:11 INFO - 'download_minidump_stackwalk': True, 15:14:11 INFO - 'download_symbols': 'true', 15:14:11 INFO - 'e10s': False, 15:14:11 INFO - 'exe_suffix': '', 15:14:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:14:11 INFO - 'tooltool.py': '/tools/tooltool.py', 15:14:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:14:11 INFO - '/tools/misc-python/virtualenv.py')}, 15:14:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:14:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:14:11 INFO - 'installer_path': '/builds/slave/test/build/installer.tar.bz2', 15:14:11 INFO - 'log_level': 'info', 15:14:11 INFO - 'log_to_console': True, 15:14:11 INFO - 'minidump_save_path': '%(abs_work_dir)s/../minidumps', 15:14:11 INFO - 'minidump_stackwalk_path': 'linux32-minidump_stackwalk', 15:14:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux32/releng.manifest', 15:14:11 INFO - 'minimum_tests_zip_dirs': ('bin/*', 15:14:11 INFO - 'certs/*', 15:14:11 INFO - 'modules/*', 15:14:11 INFO - 'mozbase/*', 15:14:11 INFO - 'config/*'), 15:14:11 INFO - 'no_random': False, 15:14:11 INFO - 'opt_config_files': (), 15:14:11 INFO - 'pip_index': False, 15:14:11 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:14:11 INFO - 'cmd': ('xset', 's', 'off', 's', 'reset'), 15:14:11 INFO - 'enabled': True, 15:14:11 INFO - 'halt_on_failure': False, 15:14:11 INFO - 'name': 'disable_screen_saver'}, 15:14:11 INFO - {'architectures': ('32bit',), 15:14:11 INFO - 'cmd': ('python', 15:14:11 INFO - '../scripts/external_tools/mouse_and_screen_resolution.py', 15:14:11 INFO - '--configuration-url', 15:14:11 INFO - 'https://hg.mozilla.org/%(branch)s/raw-file/%(revision)s/testing/machine-configuration.json'), 15:14:11 INFO - 'enabled': False, 15:14:11 INFO - 'halt_on_failure': True, 15:14:11 INFO - 'name': 'run mouse & screen adjustment script'}), 15:14:11 INFO - 'require_test_zip': True, 15:14:11 INFO - 'run_all_suites': False, 15:14:11 INFO - 'run_cmd_checks_enabled': True, 15:14:11 INFO - 'run_file_names': {'cppunittest': 'runcppunittests.py', 15:14:11 INFO - 'gtest': 'rungtests.py', 15:14:11 INFO - 'jittest': 'jit_test.py', 15:14:11 INFO - 'mochitest': 'runtests.py', 15:14:11 INFO - 'mozbase': 'test.py', 15:14:11 INFO - 'mozmill': 'runtestlist.py', 15:14:11 INFO - 'reftest': 'runreftest.py', 15:14:11 INFO - 'webapprt': 'runtests.py', 15:14:11 INFO - 'xpcshell': 'runxpcshelltests.py'}, 15:14:11 INFO - 'specific_tests_zip_dirs': {'cppunittest': ('cppunittest/*',), 15:14:11 INFO - 'gtest': ('gtest/*',), 15:14:11 INFO - 'jittest': ('jit-test/*',), 15:14:11 INFO - 'mochitest': ('mochitest/*',), 15:14:11 INFO - 'mozbase': ('mozbase/*',), 15:14:11 INFO - 'mozmill': ('mozmill/*',), 15:14:11 INFO - 'reftest': ('reftest/*', 'jsreftest/*'), 15:14:11 INFO - 'webapprt': ('mochitest/*',), 15:14:11 INFO - 'xpcshell': ('xpcshell/*',)}, 15:14:11 INFO - 'specified_mochitest_suites': ('mochitest-devtools-chrome-chunked',), 15:14:11 INFO - 'strict_content_sandbox': False, 15:14:11 INFO - 'suite_definitions': {'cppunittest': {'options': ('--symbols-path=%(symbols_path)s', 15:14:11 INFO - '--xre-path=%(abs_app_dir)s'), 15:14:11 INFO - 'run_filename': 'runcppunittests.py', 15:14:11 INFO - 'testsdir': 'cppunittest'}, 15:14:11 INFO - 'gtest': {'options': ('--xre-path=%(abs_res_dir)s', 15:14:11 INFO - '--cwd=%(gtest_dir)s', 15:14:11 INFO - '--symbols-path=%(symbols_path)s', 15:14:11 INFO - '%(binary_path)s'), 15:14:11 INFO - 'run_filename': 'rungtests.py'}, 15:14:11 INFO - 'jittest': {'options': ('tests/bin/js', 15:14:11 INFO - '--no-slow', 15:14:11 INFO - '--no-progress', 15:14:11 INFO - '--format=automation', 15:14:11 INFO - '--jitflags=all'), 15:14:11 INFO - 'run_filename': 'jit_test.py', 15:14:11 INFO - 'testsdir': 'jit-test/jit-test'}, 15:14:11 INFO - 'luciddream-b2gdt': {'options': ('--startup-timeout=300', 15:14:11 INFO - '--log-raw=%(raw_log_file)s', 15:14:11 INFO - '--log-errorsummary=%(error_summary_file)s', 15:14:11 INFO - '--browser-path=%(browser_path)s', 15:14:11 INFO - '--b2g-desktop-path=%(fxos_desktop_path)s', 15:14:11 INFO - '--gaia-profile=%(gaia_profile)s', 15:14:11 INFO - '%(test_manifest)s')}, 15:14:11 INFO - 'luciddream-emulator': {'options': ('--startup-timeout=300', 15:14:11 INFO - '--log-raw=%(raw_log_file)s', 15:14:11 INFO - '--log-errorsummary=%(error_summary_file)s', 15:14:11 INFO - '--browser-path=%(browser_path)s', 15:14:11 INFO - '--b2gpath=%(emulator_path)s', 15:14:11 INFO - '%(test_manifest)s')}, 15:14:11 INFO - 'mochitest': {'options': ('--appname=%(binary_path)s', 15:14:11 INFO - '--utility-path=tests/bin', 15:14:11 INFO - '--extra-profile-file=tests/bin/plugins', 15:14:11 INFO - '--symbols-path=%(symbols_path)s', 15:14:11 INFO - '--certificate-path=tests/certs', 15:14:11 INFO - '--setpref=webgl.force-enabled=true', 15:14:11 INFO - '--quiet', 15:14:11 INFO - '--log-raw=%(raw_log_file)s', 15:14:11 INFO - '--log-errorsummary=%(error_summary_file)s', 15:14:11 INFO - '--use-test-media-devices', 15:14:11 INFO - '--screenshot-on-fail'), 15:14:11 INFO - 'run_filename': 'runtests.py', 15:14:11 INFO - 'testsdir': 'mochitest'}, 15:14:11 INFO - 'mozbase': {'options': ('-b', '%(binary_path)s'), 15:14:11 INFO - 'run_filename': 'test.py', 15:14:11 INFO - 'testsdir': 'mozbase'}, 15:14:11 INFO - 'mozmill': {'options': ('--binary=%(binary_path)s', 15:14:11 INFO - '--testing-modules-dir=test/modules', 15:14:11 INFO - '--symbols-path=%(symbols_path)s'), 15:14:11 INFO - 'run_filename': 'runtestlist.py', 15:14:11 INFO - 'testsdir': 'mozmill'}, 15:14:11 INFO - 'reftest': {'options': ('--appname=%(binary_path)s', 15:14:11 INFO - '--utility-path=tests/bin', 15:14:11 INFO - '--extra-profile-file=tests/bin/plugins', 15:14:11 INFO - '--symbols-path=%(symbols_path)s'), 15:14:11 INFO - 'run_filename': 'runreftest.py', 15:14:11 INFO - 'testsdir': 'reftest'}, 15:14:11 INFO - 'webapprt': {'options': ('--app=%(app_path)s', 15:14:11 INFO - '--utility-path=tests/bin', 15:14:11 INFO - '--extra-profile-file=tests/bin/plugins', 15:14:11 INFO - '--symbols-path=%(symbols_path)s', 15:14:11 INFO - '--certificate-path=tests/certs', 15:14:11 INFO - '--console-level=INFO', 15:14:11 INFO - '--testing-modules-dir=tests/modules', 15:14:11 INFO - '--quiet'), 15:14:11 INFO - 'run_filename': 'runtests.py', 15:14:11 INFO - 'testsdir': 'mochitest'}, 15:14:11 INFO - 'xpcshell': {'options': ('--symbols-path=%(symbols_path)s', 15:14:11 INFO - '--test-plugin-path=%(test_plugin_path)s', 15:14:11 INFO - '--log-raw=%(raw_log_file)s', 15:14:11 INFO - '--log-errorsummary=%(error_summary_file)s', 15:14:11 INFO - '--utility-path=tests/bin'), 15:14:11 INFO - 'run_filename': 'runxpcshelltests.py', 15:14:11 INFO - 'testsdir': 'xpcshell'}}, 15:14:11 INFO - 'this_chunk': '5', 15:14:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:14:11 INFO - 'total_chunks': '8', 15:14:11 INFO - 'vcs_output_timeout': 1000, 15:14:11 INFO - 'virtualenv_path': 'venv', 15:14:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:14:11 INFO - 'work_dir': 'build', 15:14:11 INFO - 'xpcshell_name': 'xpcshell'} 15:14:11 INFO - ##### 15:14:11 INFO - ##### Running clobber step. 15:14:11 INFO - ##### 15:14:11 INFO - Running pre-action listener: _resource_record_pre_action 15:14:11 INFO - Running main action method: clobber 15:14:11 INFO - rmtree: /builds/slave/test/build 15:14:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:14:13 INFO - Running post-action listener: _resource_record_post_action 15:14:13 INFO - ##### 15:14:13 INFO - ##### Running read-buildbot-config step. 15:14:13 INFO - ##### 15:14:13 INFO - Running pre-action listener: _resource_record_pre_action 15:14:13 INFO - Running main action method: read_buildbot_config 15:14:13 INFO - Using buildbot properties: 15:14:13 INFO - { 15:14:13 INFO - "properties": { 15:14:13 INFO - "buildnumber": 97, 15:14:13 INFO - "product": "firefox", 15:14:13 INFO - "script_repo_revision": "production", 15:14:13 INFO - "branch": "mozilla-inbound", 15:14:13 INFO - "repository": "", 15:14:13 INFO - "buildername": "Ubuntu VM 12.04 mozilla-inbound debug test mochitest-devtools-chrome-5", 15:14:13 INFO - "buildid": "20151126135412", 15:14:13 INFO - "slavename": "tst-linux32-spot-549", 15:14:13 INFO - "pgo_build": "False", 15:14:13 INFO - "basedir": "/builds/slave/test", 15:14:13 INFO - "project": "", 15:14:13 INFO - "platform": "linux", 15:14:13 INFO - "master": "http://buildbot-master07.bb.releng.usw2.mozilla.com:8201/", 15:14:13 INFO - "slavebuilddir": "test", 15:14:13 INFO - "scheduler": "tests-mozilla-inbound-ubuntu32_vm-debug-unittest-7-3600", 15:14:13 INFO - "repo_path": "integration/mozilla-inbound", 15:14:13 INFO - "moz_repo_path": "", 15:14:13 INFO - "stage_platform": "linux", 15:14:13 INFO - "builduid": "a6f63bb04be644bfadd7d5956ee0532b", 15:14:13 INFO - "revision": "1bf6fd3421e6cb23b386e6e01e718b05453b373a" 15:14:13 INFO - }, 15:14:13 INFO - "sourcestamp": { 15:14:13 INFO - "repository": "", 15:14:13 INFO - "hasPatch": false, 15:14:13 INFO - "project": "", 15:14:13 INFO - "branch": "mozilla-inbound-linux-debug-unittest", 15:14:13 INFO - "changes": [ 15:14:13 INFO - { 15:14:13 INFO - "category": null, 15:14:13 INFO - "files": [ 15:14:13 INFO - { 15:14:13 INFO - "url": null, 15:14:13 INFO - "name": "https://queue.taskcluster.net/v1/task/KKlMY5EFQ_iHocabRVXaPw/artifacts/public/build/firefox-45.0a1.en-US.linux-i686.tar.bz2" 15:14:13 INFO - }, 15:14:13 INFO - { 15:14:13 INFO - "url": null, 15:14:13 INFO - "name": "https://queue.taskcluster.net/v1/task/KKlMY5EFQ_iHocabRVXaPw/artifacts/public/build/test_packages.json" 15:14:13 INFO - } 15:14:13 INFO - ], 15:14:13 INFO - "repository": "", 15:14:13 INFO - "rev": "2fa7dd926187b890c08f8737de58c5b22e219da6", 15:14:13 INFO - "who": "tnikkel@gmail.com", 15:14:13 INFO - "when": 1448575134, 15:14:13 INFO - "number": 6712646, 15:14:13 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:13 INFO - "project": "", 15:14:13 INFO - "at": "Thu 26 Nov 2015 13:58:54", 15:14:13 INFO - "branch": "mozilla-inbound-linux-debug-unittest", 15:14:13 INFO - "revlink": "", 15:14:13 INFO - "properties": [ 15:14:13 INFO - [ 15:14:13 INFO - "buildid", 15:14:13 INFO - "20151126125812", 15:14:13 INFO - "Change" 15:14:13 INFO - ], 15:14:13 INFO - [ 15:14:13 INFO - "builduid", 15:14:13 INFO - "547389da4efa496dba81d4fedb6fbb55", 15:14:13 INFO - "Change" 15:14:13 INFO - ], 15:14:13 INFO - [ 15:14:13 INFO - "pgo_build", 15:14:13 INFO - "False", 15:14:13 INFO - "Change" 15:14:13 INFO - ] 15:14:13 INFO - ], 15:14:13 INFO - "revision": "2fa7dd926187b890c08f8737de58c5b22e219da6" 15:14:13 INFO - }, 15:14:13 INFO - { 15:14:13 INFO - "category": null, 15:14:13 INFO - "files": [ 15:14:13 INFO - { 15:14:13 INFO - "url": null, 15:14:13 INFO - "name": "https://queue.taskcluster.net/v1/task/1HfgMipqQuOMhKR3jEKVbA/artifacts/public/build/firefox-45.0a1.en-US.linux-i686.tar.bz2" 15:14:13 INFO - }, 15:14:13 INFO - { 15:14:13 INFO - "url": null, 15:14:13 INFO - "name": "https://queue.taskcluster.net/v1/task/1HfgMipqQuOMhKR3jEKVbA/artifacts/public/build/test_packages.json" 15:14:13 INFO - } 15:14:13 INFO - ], 15:14:13 INFO - "repository": "", 15:14:13 INFO - "rev": "ff34a06cb439e6988e91cc78f3999e8012b7f835", 15:14:13 INFO - "who": "opettay@mozilla.com", 15:14:13 INFO - "when": 1448573773, 15:14:13 INFO - "number": 6712592, 15:14:13 INFO - "comments": "Bug 789315, notify MutationObservers before running ] 15:40:34 INFO - --DOMWINDOW == 74 (0x9a530400) [pid = 2185] [serial = 27] [outer = (nil)] [url = data:application/vnd.mozilla.xul+xml;charset=utf-8,] 15:40:34 INFO - --DOMWINDOW == 73 (0xa90b4000) [pid = 2185] [serial = 18] [outer = (nil)] [url = about:newtab] 15:40:34 INFO - --DOMWINDOW == 72 (0x944da000) [pid = 2185] [serial = 22] [outer = (nil)] [url = about:newtab] 15:40:34 INFO - --DOMWINDOW == 71 (0x9f6e6400) [pid = 2185] [serial = 34] [outer = (nil)] [url = about:blank] 15:40:34 INFO - --DOMWINDOW == 70 (0xa474e400) [pid = 2185] [serial = 2] [outer = (nil)] [url = about:blank] 15:40:34 INFO - --DOMWINDOW == 69 (0xa57f0c00) [pid = 2185] [serial = 35] [outer = (nil)] [url = about:blank] 15:40:34 INFO - --DOMWINDOW == 68 (0x9ee3c000) [pid = 2185] [serial = 31] [outer = (nil)] [url = data:application/vnd.mozilla.xul+xml;charset=utf-8,] 15:40:34 INFO - --DOMWINDOW == 67 (0x91b63c00) [pid = 2185] [serial = 69] [outer = (nil)] [url = about:blank] 15:40:34 INFO - --DOMWINDOW == 66 (0x98418400) [pid = 2185] [serial = 13] [outer = (nil)] [url = about:blank] 15:40:34 INFO - --DOMWINDOW == 65 (0x98d6d000) [pid = 2185] [serial = 12] [outer = (nil)] [url = about:blank] 15:40:34 INFO - --DOMWINDOW == 64 (0x994ac800) [pid = 2185] [serial = 8] [outer = (nil)] [url = about:blank] 15:40:34 INFO - --DOMWINDOW == 63 (0x980c7800) [pid = 2185] [serial = 123] [outer = (nil)] [url = about:blank] 15:40:34 INFO - --DOMWINDOW == 62 (0x98f14400) [pid = 2185] [serial = 9] [outer = (nil)] [url = about:blank] 15:40:34 INFO - --DOMWINDOW == 61 (0x980c0400) [pid = 2185] [serial = 121] [outer = (nil)] [url = about:blank] 15:40:34 INFO - --DOMWINDOW == 60 (0x980ba800) [pid = 2185] [serial = 117] [outer = (nil)] [url = about:blank] 15:40:34 INFO - --DOMWINDOW == 59 (0xa8f5e800) [pid = 2185] [serial = 109] [outer = (nil)] [url = about:blank] 15:40:34 INFO - --DOMWINDOW == 58 (0xa6462c00) [pid = 2185] [serial = 107] [outer = (nil)] [url = about:blank] 15:40:34 INFO - --DOMWINDOW == 57 (0x9e81c800) [pid = 2185] [serial = 103] [outer = (nil)] [url = about:blank] 15:40:34 INFO - --DOMWINDOW == 56 (0x9ab3c800) [pid = 2185] [serial = 101] [outer = (nil)] [url = about:blank] 15:40:34 INFO - --DOMWINDOW == 55 (0x9a7a0800) [pid = 2185] [serial = 99] [outer = (nil)] [url = about:blank] 15:40:34 INFO - --DOMWINDOW == 54 (0x99c47c00) [pid = 2185] [serial = 97] [outer = (nil)] [url = about:blank] 15:40:34 INFO - --DOMWINDOW == 53 (0x989cf400) [pid = 2185] [serial = 95] [outer = (nil)] [url = about:blank] 15:40:34 INFO - --DOMWINDOW == 52 (0x985cbc00) [pid = 2185] [serial = 93] [outer = (nil)] [url = about:blank] 15:40:34 INFO - --DOMWINDOW == 51 (0x98187c00) [pid = 2185] [serial = 91] [outer = (nil)] [url = about:blank] 15:40:34 INFO - --DOMWINDOW == 50 (0x93cf8400) [pid = 2185] [serial = 89] [outer = (nil)] [url = about:blank] 15:40:34 INFO - --DOMWINDOW == 49 (0x93c58400) [pid = 2185] [serial = 87] [outer = (nil)] [url = about:blank] 15:40:34 INFO - --DOMWINDOW == 48 (0x916efc00) [pid = 2185] [serial = 85] [outer = (nil)] [url = about:blank] 15:40:34 INFO - --DOMWINDOW == 47 (0x916e7000) [pid = 2185] [serial = 83] [outer = (nil)] [url = about:blank] 15:40:34 INFO - --DOMWINDOW == 46 (0x91619000) [pid = 2185] [serial = 81] [outer = (nil)] [url = about:blank] 15:40:34 INFO - --DOMWINDOW == 45 (0x91610400) [pid = 2185] [serial = 79] [outer = (nil)] [url = about:blank] 15:40:34 INFO - --DOMWINDOW == 44 (0x91998800) [pid = 2185] [serial = 77] [outer = (nil)] [url = about:blank] 15:40:34 INFO - --DOMWINDOW == 43 (0x9193e800) [pid = 2185] [serial = 75] [outer = (nil)] [url = about:blank] 15:40:34 INFO - --DOMWINDOW == 42 (0x91bad400) [pid = 2185] [serial = 73] [outer = (nil)] [url = about:blank] 15:40:34 INFO - --DOMWINDOW == 41 (0x91b06400) [pid = 2185] [serial = 67] [outer = (nil)] [url = about:blank] 15:40:34 INFO - --DOMWINDOW == 40 (0x91eac800) [pid = 2185] [serial = 65] [outer = (nil)] [url = about:blank] 15:40:34 INFO - --DOMWINDOW == 39 (0x9800a800) [pid = 2185] [serial = 63] [outer = (nil)] [url = about:blank] 15:40:34 INFO - --DOMWINDOW == 38 (0x920f5000) [pid = 2185] [serial = 61] [outer = (nil)] [url = about:blank] 15:40:34 INFO - --DOMWINDOW == 37 (0x920ed800) [pid = 2185] [serial = 59] [outer = (nil)] [url = about:blank] 15:40:34 INFO - --DOMWINDOW == 36 (0x923fd800) [pid = 2185] [serial = 57] [outer = (nil)] [url = about:blank] 15:40:34 INFO - --DOMWINDOW == 35 (0x923f6800) [pid = 2185] [serial = 55] [outer = (nil)] [url = about:blank] 15:40:34 INFO - --DOMWINDOW == 34 (0x923ee400) [pid = 2185] [serial = 53] [outer = (nil)] [url = about:blank] 15:40:34 INFO - --DOMWINDOW == 33 (0x9233b000) [pid = 2185] [serial = 51] [outer = (nil)] [url = about:blank] 15:40:35 INFO - --DOMWINDOW == 32 (0x92333400) [pid = 2185] [serial = 49] [outer = (nil)] [url = about:blank] 15:40:35 INFO - --DOMWINDOW == 31 (0x93c55800) [pid = 2185] [serial = 47] [outer = (nil)] [url = about:blank] 15:40:35 INFO - --DOMWINDOW == 30 (0x99db9c00) [pid = 2185] [serial = 45] [outer = (nil)] [url = about:blank] 15:40:35 INFO - --DOMWINDOW == 29 (0x99daf800) [pid = 2185] [serial = 43] [outer = (nil)] [url = about:blank] 15:40:35 INFO - --DOMWINDOW == 28 (0x99818000) [pid = 2185] [serial = 41] [outer = (nil)] [url = about:blank] 15:40:35 INFO - --DOMWINDOW == 27 (0x9980d400) [pid = 2185] [serial = 39] [outer = (nil)] [url = about:blank] 15:40:35 INFO - --DOMWINDOW == 26 (0xa8de3000) [pid = 2185] [serial = 37] [outer = (nil)] [url = about:blank] 15:40:35 INFO - --DOMWINDOW == 25 (0xa008bc00) [pid = 2185] [serial = 33] [outer = (nil)] [url = about:blank] 15:40:35 INFO - --DOMWINDOW == 24 (0x9d59f000) [pid = 2185] [serial = 30] [outer = (nil)] [url = about:blank] 15:40:35 INFO - --DOMWINDOW == 23 (0x98f97400) [pid = 2185] [serial = 26] [outer = (nil)] [url = about:blank] 15:40:35 INFO - --DOMWINDOW == 22 (0x98725c00) [pid = 2185] [serial = 24] [outer = (nil)] [url = about:blank] 15:40:35 INFO - --DOMWINDOW == 21 (0x93f77c00) [pid = 2185] [serial = 21] [outer = (nil)] [url = about:blank] 15:40:35 INFO - --DOMWINDOW == 20 (0x944d8400) [pid = 2185] [serial = 17] [outer = (nil)] [url = about:blank] 15:40:35 INFO - --DOMWINDOW == 19 (0x980bd800) [pid = 2185] [serial = 119] [outer = (nil)] [url = data:text/html,

Foo

Bar
] 15:40:35 INFO - --DOMWINDOW == 18 (0xac0a9400) [pid = 2185] [serial = 115] [outer = (nil)] [url = data:text/html,
] 15:40:35 INFO - --DOMWINDOW == 17 (0xac0a7400) [pid = 2185] [serial = 114] [outer = (nil)] [url = data:text/html,] 15:40:35 INFO - --DOMWINDOW == 16 (0x93eeb800) [pid = 2185] [serial = 111] [outer = (nil)] [url = data:text/html,'%20/>'%20/>'>'%20/>
'>'%20/>] 15:40:35 INFO - --DOMWINDOW == 15 (0x9eae0400) [pid = 2185] [serial = 105] [outer = (nil)] [url = data:text/html,] 15:40:35 INFO - --DOMWINDOW == 14 (0x9429f000) [pid = 2185] [serial = 19] [outer = (nil)] [url = about:blank] 15:40:35 INFO - --DOMWINDOW == 13 (0x9a6f6400) [pid = 2185] [serial = 28] [outer = (nil)] [url = about:blank] 15:40:35 INFO - --DOMWINDOW == 12 (0x91ba0800) [pid = 2185] [serial = 71] [outer = (nil)] [url = about:blank] 15:40:41 INFO - Completed ShutdownLeaks collections in process 2185 15:40:41 INFO - JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 208: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:40:41 INFO - ###!!! [Parent][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 15:40:41 INFO - --DOCSHELL 0x984a5800 == 5 [pid = 2185] [id = 6] 15:40:42 INFO - --DOCSHELL 0xa474b000 == 4 [pid = 2185] [id = 1] 15:40:42 INFO - --DOCSHELL 0x9a7a4800 == 3 [pid = 2185] [id = 3] 15:40:42 INFO - --DOCSHELL 0x9a942c00 == 2 [pid = 2185] [id = 4] 15:40:42 INFO - --DOCSHELL 0x980c9c00 == 1 [pid = 2185] [id = 60] 15:40:42 INFO - --DOCSHELL 0x9e817000 == 0 [pid = 2185] [id = 2] 15:40:42 INFO - JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 492: Error: forget() called twice 15:40:43 INFO - ###!!! [Parent][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 15:40:43 INFO - ###!!! [Parent][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 15:40:43 INFO - ###!!! [Parent][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 15:40:43 INFO - ###!!! [Parent][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 15:40:43 INFO - [2185] WARNING: NS_ENSURE_TRUE(context) failed: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/xpcom/threads/nsThread.cpp, line 769 15:40:45 INFO - --DOMWINDOW == 11 (0x92308400) [pid = 2185] [serial = 129] [outer = 0x9a943400] [url = about:blank] 15:40:45 INFO - --DOMWINDOW == 10 (0x92306400) [pid = 2185] [serial = 128] [outer = 0x9a941400] [url = about:blank] 15:40:45 INFO - --DOMWINDOW == 9 (0x9a943400) [pid = 2185] [serial = 7] [outer = (nil)] [url = about:blank] 15:40:45 INFO - --DOMWINDOW == 8 (0x9a941400) [pid = 2185] [serial = 6] [outer = (nil)] [url = about:blank] 15:40:46 INFO - --DOMWINDOW == 7 (0x9e817c00) [pid = 2185] [serial = 4] [outer = (nil)] [url = about:blank] 15:40:46 INFO - --DOMWINDOW == 6 (0xa474b400) [pid = 2185] [serial = 1] [outer = (nil)] [url = resource://gre-resources/hiddenWindow.html] 15:40:46 INFO - --DOMWINDOW == 5 (0x984a6400) [pid = 2185] [serial = 15] [outer = (nil)] [url = about:blank] 15:40:46 INFO - --DOMWINDOW == 4 (0x980ca000) [pid = 2185] [serial = 124] [outer = (nil)] [url = about:blank] 15:40:46 INFO - --DOMWINDOW == 3 (0x980cec00) [pid = 2185] [serial = 125] [outer = (nil)] [url = about:blank] 15:40:46 INFO - --DOMWINDOW == 2 (0x984a5c00) [pid = 2185] [serial = 14] [outer = (nil)] [url = chrome://mochikit/content/browser-harness.xul] 15:40:46 INFO - --DOMWINDOW == 1 (0x9e817400) [pid = 2185] [serial = 3] [outer = (nil)] [url = chrome://browser/content/browser.xul] 15:40:46 INFO - --DOMWINDOW == 0 (0x9e3ea400) [pid = 2185] [serial = 5] [outer = (nil)] [url = resource://gre-resources/hiddenWindow.html] 15:40:46 INFO - [2185] WARNING: OOPDeinit() without successful OOPInit(): file /builds/slave/m-in-lx-d-00000000000000000000/build/src/toolkit/crashreporter/nsExceptionHandler.cpp, line 2800 15:40:46 INFO - nsStringStats 15:40:46 INFO - => mAllocCount: 150101 15:40:46 INFO - => mReallocCount: 10239 15:40:46 INFO - => mFreeCount: 150101 15:40:46 INFO - => mShareCount: 132629 15:40:46 INFO - => mAdoptCount: 10392 15:40:46 INFO - => mAdoptFreeCount: 10392 15:40:46 INFO - => Process ID: 2185, Thread ID: 3074361088 15:40:46 INFO - TEST-INFO | Main app process: exit 0 15:40:46 INFO - runtests.py | Application ran for: 0:00:57.510491 15:40:46 INFO - zombiecheck | Reading PID log: /tmp/tmpXn0jurpidlog 15:40:46 INFO - Stopping web server 15:40:46 INFO - Stopping web socket server 15:40:46 INFO - Stopping ssltunnel 15:40:46 INFO - TEST-INFO | leakcheck | default process: leak threshold set at 0 bytes 15:40:46 INFO - TEST-INFO | leakcheck | plugin process: leak threshold set at 0 bytes 15:40:46 INFO - TEST-INFO | leakcheck | tab process: leak threshold set at 10000 bytes 15:40:46 INFO - TEST-INFO | leakcheck | geckomediaplugin process: leak threshold set at 20000 bytes 15:40:46 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, default process 2185 15:40:46 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->| 15:40:46 INFO - | | Per-Inst Leaked| Total Rem| 15:40:46 INFO - 0 |TOTAL | 20 0| 2094193 0| 15:40:46 INFO - nsTraceRefcnt::DumpStatistics: 1291 entries 15:40:46 INFO - TEST-PASS | leakcheck | default process: no leaks detected! 15:40:46 INFO - runtests.py | Running tests: end. 15:40:46 INFO - 280 INFO checking window state 15:40:46 INFO - 281 INFO TEST-START | Shutdown 15:40:46 INFO - 282 INFO Browser Chrome Test Summary 15:40:46 INFO - 283 INFO Passed: 310 15:40:46 INFO - 284 INFO Failed: 0 15:40:46 INFO - 285 INFO Todo: 0 15:40:46 INFO - 286 INFO *** End BrowserChrome Test Results *** 15:40:46 INFO - dir: devtools/client/webide/test 15:40:46 INFO - Setting pipeline to PAUSED ... 15:40:46 INFO - Pipeline is PREROLLING ... 15:40:46 INFO - Pipeline is PREROLLED ... 15:40:46 INFO - Setting pipeline to PLAYING ... 15:40:46 INFO - New clock: GstSystemClock 15:40:46 INFO - Got EOS from element "pipeline0". 15:40:46 INFO - Execution ended after 32674663 ns. 15:40:46 INFO - Setting pipeline to PAUSED ... 15:40:46 INFO - Setting pipeline to READY ... 15:40:46 INFO - Setting pipeline to NULL ... 15:40:46 INFO - Freeing pipeline ... 15:40:46 INFO - pk12util: PKCS12 IMPORT SUCCESSFUL 15:40:47 INFO - MochitestServer : launching [u'/builds/slave/test/build/tests/bin/xpcshell', '-g', '/builds/slave/test/build/application/firefox', '-v', '170', '-f', '/builds/slave/test/build/tests/bin/components/httpd.js', '-e', "const _PROFILE_PATH = '/tmp/tmpnuAEtO.mozrunner'; const _SERVER_PORT = '8888'; const _SERVER_ADDR = '127.0.0.1'; const _TEST_PREFIX = undefined; const _DISPLAY_RESULTS = false;", '-f', '/builds/slave/test/build/tests/mochitest/server.js'] 15:40:47 INFO - runtests.py | Server pid: 2274 15:40:47 INFO - runtests.py | Websocket server pid: 2277 15:40:47 INFO - runtests.py | SSL tunnel pid: 2280 15:40:47 INFO - runtests.py | Running tests: start. 15:40:47 INFO - runtests.py | Application pid: 2302 15:40:47 INFO - TEST-INFO | started process Main app process 15:40:47 INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpnuAEtO.mozrunner/runtests_leaks.log 15:40:51 INFO - ++DOCSHELL 0xa465dc00 == 1 [pid = 2302] [id = 1] 15:40:51 INFO - ++DOMWINDOW == 1 (0xa465e000) [pid = 2302] [serial = 1] [outer = (nil)] 15:40:51 INFO - [2302] WARNING: Hardware Vsync support not yet implemented. Falling back to software timers: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/gfx/thebes/gfxPlatform.cpp, line 2091 15:40:51 INFO - ++DOMWINDOW == 2 (0xa4661000) [pid = 2302] [serial = 2] [outer = 0xa465e000] 15:40:51 INFO - LoadPlugin() /tmp/tmpnuAEtO.mozrunner/plugins/libnptest.so returned a8dce1e0 15:40:51 INFO - LoadPlugin() /tmp/tmpnuAEtO.mozrunner/plugins/libnpthirdtest.so returned a8dce3e0 15:40:51 INFO - LoadPlugin() /tmp/tmpnuAEtO.mozrunner/plugins/libnptestjava.so returned a8dce440 15:40:51 INFO - LoadPlugin() /tmp/tmpnuAEtO.mozrunner/plugins/libnpctrltest.so returned a8dce6a0 15:40:51 INFO - LoadPlugin() /tmp/tmpnuAEtO.mozrunner/plugins/libnpsecondtest.so returned a8dcefa0 15:40:51 INFO - LoadPlugin() /tmp/tmpnuAEtO.mozrunner/plugins/libnpswftest.so returned b7203100 15:40:51 INFO - LoadPlugin() /usr/lib/mozilla/plugins/librhythmbox-itms-detection-plugin.so returned b728ae20 15:40:51 INFO - LoadPlugin() /usr/lib/mozilla/plugins/libtotem-narrowspace-plugin.so returned 9f4cd580 15:40:51 INFO - LoadPlugin() /usr/lib/mozilla/plugins/libtotem-cone-plugin.so returned 9f4d0f60 15:40:51 INFO - LoadPlugin() /usr/lib/mozilla/plugins/libtotem-gmp-plugin.so returned 9f4d1b80 15:40:51 INFO - LoadPlugin() /usr/lib/mozilla/plugins/libtotem-mully-plugin.so returned 9f4d98c0 15:40:52 INFO - ++DOCSHELL 0x9e82f400 == 2 [pid = 2302] [id = 2] 15:40:52 INFO - ++DOMWINDOW == 3 (0x9e82f800) [pid = 2302] [serial = 3] [outer = (nil)] 15:40:52 INFO - ++DOMWINDOW == 4 (0x9e830000) [pid = 2302] [serial = 4] [outer = 0x9e82f800] 15:40:52 INFO - ++DOMWINDOW == 5 (0x9e8ac400) [pid = 2302] [serial = 5] [outer = 0xa465e000] 15:40:54 INFO - [2302] WARNING: Failed to retarget HTML data delivery to the parser thread.: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/parser/html/nsHtml5StreamParser.cpp, line 966 15:40:54 INFO - ++DOCSHELL 0x9b181400 == 3 [pid = 2302] [id = 3] 15:40:54 INFO - ++DOMWINDOW == 6 (0x9b1c5400) [pid = 2302] [serial = 6] [outer = (nil)] 15:40:54 INFO - ++DOCSHELL 0x9b263c00 == 4 [pid = 2302] [id = 4] 15:40:54 INFO - ++DOMWINDOW == 7 (0x9b264400) [pid = 2302] [serial = 7] [outer = (nil)] 15:40:55 INFO - [2302] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80040111: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/dom/base/nsFrameLoader.cpp, line 272 15:40:55 INFO - ++DOCSHELL 0x99dc3400 == 5 [pid = 2302] [id = 5] 15:40:55 INFO - ++DOMWINDOW == 8 (0x99dc3800) [pid = 2302] [serial = 8] [outer = (nil)] 15:40:55 INFO - [2302] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80040111: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/dom/base/nsFrameLoader.cpp, line 272 15:40:55 INFO - ++DOMWINDOW == 9 (0x9980e000) [pid = 2302] [serial = 9] [outer = 0x99dc3800] 15:40:56 INFO - ++DOMWINDOW == 10 (0x9965e400) [pid = 2302] [serial = 10] [outer = 0x9b1c5400] 15:40:56 INFO - ++DOMWINDOW == 11 (0x99660000) [pid = 2302] [serial = 11] [outer = 0x9b264400] 15:40:56 INFO - ++DOMWINDOW == 12 (0x99662400) [pid = 2302] [serial = 12] [outer = 0x99dc3800] 15:40:57 INFO - ++DOMWINDOW == 13 (0x98d39400) [pid = 2302] [serial = 13] [outer = 0x99dc3800] 15:40:57 INFO - ++DOCSHELL 0x98ddf400 == 6 [pid = 2302] [id = 6] 15:40:57 INFO - ++DOMWINDOW == 14 (0x98ddf800) [pid = 2302] [serial = 14] [outer = (nil)] 15:40:57 INFO - ++DOMWINDOW == 15 (0x98de0000) [pid = 2302] [serial = 15] [outer = 0x98ddf800] 15:41:00 INFO - ++DOCSHELL 0x9446a800 == 7 [pid = 2302] [id = 7] 15:41:00 INFO - ++DOMWINDOW == 16 (0x944c0c00) [pid = 2302] [serial = 16] [outer = (nil)] 15:41:00 INFO - ++DOMWINDOW == 17 (0x944c4c00) [pid = 2302] [serial = 17] [outer = 0x944c0c00] 15:41:00 INFO - ++DOCSHELL 0xa7f59400 == 8 [pid = 2302] [id = 8] 15:41:00 INFO - ++DOMWINDOW == 18 (0xa90b4000) [pid = 2302] [serial = 18] [outer = (nil)] 15:41:00 INFO - ++DOMWINDOW == 19 (0x9418c000) [pid = 2302] [serial = 19] [outer = 0xa90b4000] 15:41:00 INFO - 287 INFO TEST-START | devtools/client/webide/test/browser_tabs.js 15:41:00 INFO - 288 INFO Adding tab: http://example.com/browser/devtools/client/webide/test/doc_tabs.html 15:41:00 INFO - ++DOCSHELL 0x93fb3000 == 9 [pid = 2302] [id = 9] 15:41:00 INFO - ++DOMWINDOW == 20 (0x93fb3c00) [pid = 2302] [serial = 20] [outer = (nil)] 15:41:01 INFO - ++DOMWINDOW == 21 (0x93ebd000) [pid = 2302] [serial = 21] [outer = 0x93fb3c00] 15:41:01 INFO - [2302] WARNING: Could not get disk status from nsIDiskSpaceWatcher: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/uriloader/prefetch/nsOfflineCacheUpdateService.cpp, line 319 15:41:01 INFO - ++DOMWINDOW == 22 (0x93ec2c00) [pid = 2302] [serial = 22] [outer = 0xa90b4000] 15:41:01 INFO - ++DOMWINDOW == 23 (0x9afc9800) [pid = 2302] [serial = 23] [outer = 0x93fb3c00] 15:41:02 INFO - 289 INFO Tab added and finished loading: http://example.com/browser/devtools/client/webide/test/doc_tabs.html 15:41:02 INFO - 290 INFO opening WebIDE 15:41:02 INFO - ++DOCSHELL 0x99091400 == 10 [pid = 2302] [id = 10] 15:41:02 INFO - ++DOMWINDOW == 24 (0x995ed000) [pid = 2302] [serial = 24] [outer = (nil)] 15:41:02 INFO - ++DOMWINDOW == 25 (0x99658000) [pid = 2302] [serial = 25] [outer = 0x995ed000] 15:41:02 INFO - ++DOCSHELL 0x9f2d7000 == 11 [pid = 2302] [id = 11] 15:41:02 INFO - ++DOMWINDOW == 26 (0x9f2d8000) [pid = 2302] [serial = 26] [outer = (nil)] 15:41:03 INFO - [2302] WARNING: RasterImage::Init failed: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/image/ImageFactory.cpp, line 109 15:41:03 INFO - ++DOMWINDOW == 27 (0x9f45ac00) [pid = 2302] [serial = 27] [outer = 0x9f2d8000] 15:41:04 INFO - ++DOCSHELL 0x91d9fc00 == 12 [pid = 2302] [id = 12] 15:41:04 INFO - ++DOMWINDOW == 28 (0x91da0400) [pid = 2302] [serial = 28] [outer = (nil)] 15:41:04 INFO - ++DOCSHELL 0x91da0800 == 13 [pid = 2302] [id = 13] 15:41:04 INFO - ++DOMWINDOW == 29 (0x91da0c00) [pid = 2302] [serial = 29] [outer = (nil)] 15:41:04 INFO - ++DOCSHELL 0x91da1000 == 14 [pid = 2302] [id = 14] 15:41:04 INFO - ++DOMWINDOW == 30 (0x91da1400) [pid = 2302] [serial = 30] [outer = (nil)] 15:41:04 INFO - ++DOCSHELL 0x91da1800 == 15 [pid = 2302] [id = 15] 15:41:04 INFO - ++DOMWINDOW == 31 (0x91da1c00) [pid = 2302] [serial = 31] [outer = (nil)] 15:41:04 INFO - ++DOCSHELL 0x91da2000 == 16 [pid = 2302] [id = 16] 15:41:04 INFO - ++DOMWINDOW == 32 (0x91da2400) [pid = 2302] [serial = 32] [outer = (nil)] 15:41:04 INFO - ++DOCSHELL 0x91da2800 == 17 [pid = 2302] [id = 17] 15:41:04 INFO - ++DOMWINDOW == 33 (0x91da2c00) [pid = 2302] [serial = 33] [outer = (nil)] 15:41:04 INFO - ++DOCSHELL 0x91da3000 == 18 [pid = 2302] [id = 18] 15:41:04 INFO - ++DOMWINDOW == 34 (0x91da3400) [pid = 2302] [serial = 34] [outer = (nil)] 15:41:04 INFO - ++DOCSHELL 0x91da3800 == 19 [pid = 2302] [id = 19] 15:41:04 INFO - ++DOMWINDOW == 35 (0x91da3c00) [pid = 2302] [serial = 35] [outer = (nil)] 15:41:04 INFO - ++DOCSHELL 0x91e0cc00 == 20 [pid = 2302] [id = 20] 15:41:04 INFO - ++DOMWINDOW == 36 (0x91e0d000) [pid = 2302] [serial = 36] [outer = (nil)] 15:41:04 INFO - ++DOCSHELL 0x9e8adc00 == 21 [pid = 2302] [id = 21] 15:41:04 INFO - ++DOMWINDOW == 37 (0x9f455000) [pid = 2302] [serial = 37] [outer = (nil)] 15:41:04 INFO - ++DOCSHELL 0xad24c000 == 22 [pid = 2302] [id = 22] 15:41:04 INFO - ++DOMWINDOW == 38 (0x91b64400) [pid = 2302] [serial = 38] [outer = (nil)] 15:41:04 INFO - ++DOCSHELL 0x91b64800 == 23 [pid = 2302] [id = 23] 15:41:04 INFO - ++DOMWINDOW == 39 (0x91b64c00) [pid = 2302] [serial = 39] [outer = (nil)] 15:41:04 INFO - ++DOCSHELL 0x91b65000 == 24 [pid = 2302] [id = 24] 15:41:04 INFO - ++DOMWINDOW == 40 (0x91b65400) [pid = 2302] [serial = 40] [outer = (nil)] 15:41:04 INFO - [2302] 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:41:04 INFO - ++DOMWINDOW == 41 (0x91b73400) [pid = 2302] [serial = 41] [outer = 0x91da0400] 15:41:04 INFO - ++DOMWINDOW == 42 (0x94e9c800) [pid = 2302] [serial = 42] [outer = 0x91da0c00] 15:41:04 INFO - ++DOMWINDOW == 43 (0x9f24ec00) [pid = 2302] [serial = 43] [outer = 0x91da1400] 15:41:04 INFO - ++DOMWINDOW == 44 (0x919ad400) [pid = 2302] [serial = 44] [outer = 0x91da1c00] 15:41:04 INFO - ++DOMWINDOW == 45 (0x919af000) [pid = 2302] [serial = 45] [outer = 0x91da2400] 15:41:04 INFO - ++DOMWINDOW == 46 (0x919b1000) [pid = 2302] [serial = 46] [outer = 0x91da2c00] 15:41:04 INFO - ++DOMWINDOW == 47 (0x919b3000) [pid = 2302] [serial = 47] [outer = 0x91da3400] 15:41:04 INFO - ++DOMWINDOW == 48 (0x919b5400) [pid = 2302] [serial = 48] [outer = 0x91da3c00] 15:41:04 INFO - ++DOMWINDOW == 49 (0x919b7800) [pid = 2302] [serial = 49] [outer = 0x91e0d000] 15:41:04 INFO - ++DOMWINDOW == 50 (0x919b9c00) [pid = 2302] [serial = 50] [outer = 0x9f455000] 15:41:04 INFO - ++DOMWINDOW == 51 (0x919bc000) [pid = 2302] [serial = 51] [outer = 0x91b64400] 15:41:04 INFO - ++DOMWINDOW == 52 (0x91ab8800) [pid = 2302] [serial = 52] [outer = 0x91b64c00] 15:41:04 INFO - ++DOMWINDOW == 53 (0x91ab9800) [pid = 2302] [serial = 53] [outer = 0x91b65400] 15:41:04 INFO - [2302] WARNING: GetDefaultCharsetForLocale: need to add multi locale support: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/intl/locale/unix/nsUNIXCharset.cpp, line 101 15:41:04 INFO - ++DOMWINDOW == 54 (0x91abd800) [pid = 2302] [serial = 54] [outer = 0x9f2d8000] 15:41:04 INFO - 291 INFO Console message: [JavaScript Error: "not well-formed" {file: "file:///builds/slave/test/build/tests/mochitest/chrome/devtools/client/webide/test/addons/simulators.json" line: 1 column: 1 source: "{"}] 15:41:04 INFO - 292 INFO Console message: [JavaScript Error: "syntax error" {file: "file:///builds/slave/test/build/tests/mochitest/chrome/devtools/client/webide/test/templates.json" line: 1 column: 1 source: "["}] 15:41:04 INFO - 293 INFO Console message: [JavaScript Error: "not well-formed" {file: "file:///builds/slave/test/build/tests/mochitest/chrome/devtools/client/webide/test/browser_devices.json" line: 1 column: 1 source: "{"}] 15:41:05 INFO - ++DOCSHELL 0x919b0000 == 25 [pid = 2302] [id = 25] 15:41:05 INFO - ++DOMWINDOW == 55 (0x919b2000) [pid = 2302] [serial = 55] [outer = (nil)] 15:41:05 INFO - ++DOMWINDOW == 56 (0x93ec5c00) [pid = 2302] [serial = 56] [outer = 0x919b2000] 15:41:05 INFO - 294 INFO Console message: [JavaScript Error: "not well-formed" {file: "file:///builds/slave/test/build/tests/mochitest/chrome/devtools/client/webide/test/addons/simulators.json" line: 1 column: 1 source: "{"}] 15:41:05 INFO - 295 INFO WebIDE open 15:41:06 INFO - console.log: Connection status changed: connecting 15:41:06 INFO - console.log: Connection status changed: connected 15:41:06 INFO - 296 INFO TEST-PASS | devtools/client/webide/test/browser_tabs.js | Locally connected - 15:41:06 INFO - 297 INFO Wait: runtime-targets 15:41:06 INFO - 298 INFO Got: runtime-targets 15:41:06 INFO - 299 INFO Wait: project 15:41:06 INFO - 300 INFO Got: before-project 15:41:06 INFO - 301 INFO Got: details 15:41:06 INFO - 302 INFO Got: project 15:41:06 INFO - 303 INFO TEST-PASS | devtools/client/webide/test/browser_tabs.js | Toolbox promise exists - 15:41:06 INFO - [2302] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80520012: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/js/xpconnect/loader/mozJSComponentLoader.cpp, line 841 15:41:06 INFO - [2302] WARNING: RasterImage::Init failed: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/image/ImageFactory.cpp, line 109 15:41:07 INFO - [2302] WARNING: RasterImage::Init failed: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/image/ImageFactory.cpp, line 109 15:41:07 INFO - [2302] WARNING: RasterImage::Init failed: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/image/ImageFactory.cpp, line 109 15:41:07 INFO - [2302] WARNING: RasterImage::Init failed: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/image/ImageFactory.cpp, line 109 15:41:07 INFO - ++DOCSHELL 0x9009c400 == 26 [pid = 2302] [id = 26] 15:41:07 INFO - ++DOMWINDOW == 57 (0x9009c800) [pid = 2302] [serial = 57] [outer = (nil)] 15:41:07 INFO - ++DOMWINDOW == 58 (0x9009e000) [pid = 2302] [serial = 58] [outer = 0x9009c800] 15:41:08 INFO - [2302] WARNING: RasterImage::Init failed: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/image/ImageFactory.cpp, line 109 15:41:09 INFO - ++DOCSHELL 0x8f5ba000 == 27 [pid = 2302] [id = 27] 15:41:09 INFO - ++DOMWINDOW == 59 (0x8f5bbc00) [pid = 2302] [serial = 59] [outer = (nil)] 15:41:09 INFO - ++DOMWINDOW == 60 (0x8f5bc400) [pid = 2302] [serial = 60] [outer = 0x8f5bbc00] 15:41:11 INFO - 304 INFO TEST-PASS | devtools/client/webide/test/browser_tabs.js | Location is correct - 15:41:11 INFO - 305 INFO TEST-PASS | devtools/client/webide/test/browser_tabs.js | Name is correct - 15:41:11 INFO - 306 INFO TEST-PASS | devtools/client/webide/test/browser_tabs.js | 2 tabs available - 15:41:11 INFO - 307 INFO Removing tab. 15:41:11 INFO - 308 INFO Tab removed and finished closing. 15:41:11 INFO - 309 INFO Wait: project 15:41:13 INFO - --DOCSHELL 0x8f5ba000 == 26 [pid = 2302] [id = 27] 15:41:13 INFO - --DOMWINDOW == 59 (0x9418c000) [pid = 2302] [serial = 19] [outer = (nil)] [url = about:blank] 15:41:13 INFO - --DOMWINDOW == 58 (0x93ebd000) [pid = 2302] [serial = 21] [outer = (nil)] [url = about:blank] 15:41:13 INFO - --DOMWINDOW == 57 (0x98d39400) [pid = 2302] [serial = 13] [outer = (nil)] [url = about:blank] 15:41:13 INFO - --DOMWINDOW == 56 (0x99662400) [pid = 2302] [serial = 12] [outer = (nil)] [url = about:blank] 15:41:13 INFO - --DOMWINDOW == 55 (0x99dc3800) [pid = 2302] [serial = 8] [outer = (nil)] [url = about:blank] 15:41:13 INFO - --DOMWINDOW == 54 (0x9980e000) [pid = 2302] [serial = 9] [outer = (nil)] [url = about:blank] 15:41:13 INFO - --DOMWINDOW == 53 (0x9f45ac00) [pid = 2302] [serial = 27] [outer = (nil)] [url = about:blank] 15:41:13 INFO - --DOMWINDOW == 52 (0xa4661000) [pid = 2302] [serial = 2] [outer = (nil)] [url = about:blank] 15:41:13 INFO - 310 INFO Got: before-project 15:41:13 INFO - 311 INFO Got: project 15:41:13 INFO - 312 INFO Wait: runtime-targets 15:41:13 INFO - 313 INFO Got: runtime-targets 15:41:13 INFO - 314 INFO TEST-PASS | devtools/client/webide/test/browser_tabs.js | 1 tab available - 15:41:13 INFO - 315 INFO Adding tab: http://example.com/browser/devtools/client/webide/test/doc_tabs.html 15:41:13 INFO - ++DOCSHELL 0x8f5ba000 == 27 [pid = 2302] [id = 28] 15:41:13 INFO - ++DOMWINDOW == 53 (0x8f5ba400) [pid = 2302] [serial = 61] [outer = (nil)] 15:41:13 INFO - ++DOMWINDOW == 54 (0x8f85d400) [pid = 2302] [serial = 62] [outer = 0x8f5ba400] 15:41:14 INFO - ++DOMWINDOW == 55 (0x8fc14000) [pid = 2302] [serial = 63] [outer = 0x8f5ba400] 15:41:14 INFO - 316 INFO Tab added and finished loading: http://example.com/browser/devtools/client/webide/test/doc_tabs.html 15:41:14 INFO - 317 INFO TEST-PASS | devtools/client/webide/test/browser_tabs.js | 2 tabs available - 15:41:14 INFO - 318 INFO Removing tab. 15:41:14 INFO - 319 INFO Tab removed and finished closing. 15:41:14 INFO - 320 INFO TEST-PASS | devtools/client/webide/test/browser_tabs.js | 2 tabs available - 15:41:14 INFO - 321 INFO Wait: runtime-targets 15:41:14 INFO - 322 INFO Got: runtime-targets 15:41:14 INFO - 323 INFO TEST-PASS | devtools/client/webide/test/browser_tabs.js | 1 tab available - 15:41:14 INFO - console.log: Connection status changed: disconnecting 15:41:14 INFO - console.log: Connection status changed: disconnected 15:41:14 INFO - 324 INFO Closing WebIDE 15:41:14 INFO - 325 INFO WebIDE closed 15:41:15 INFO - --DOCSHELL 0x91d9fc00 == 26 [pid = 2302] [id = 12] 15:41:15 INFO - --DOCSHELL 0x91da0800 == 25 [pid = 2302] [id = 13] 15:41:15 INFO - --DOCSHELL 0x91da1000 == 24 [pid = 2302] [id = 14] 15:41:15 INFO - --DOCSHELL 0x91da1800 == 23 [pid = 2302] [id = 15] 15:41:15 INFO - --DOCSHELL 0x91da2000 == 22 [pid = 2302] [id = 16] 15:41:15 INFO - --DOCSHELL 0x91da2800 == 21 [pid = 2302] [id = 17] 15:41:15 INFO - --DOCSHELL 0x91da3000 == 20 [pid = 2302] [id = 18] 15:41:15 INFO - --DOCSHELL 0x91da3800 == 19 [pid = 2302] [id = 19] 15:41:15 INFO - --DOCSHELL 0x91e0cc00 == 18 [pid = 2302] [id = 20] 15:41:15 INFO - --DOCSHELL 0x9e8adc00 == 17 [pid = 2302] [id = 21] 15:41:15 INFO - --DOCSHELL 0xad24c000 == 16 [pid = 2302] [id = 22] 15:41:15 INFO - --DOCSHELL 0x91b64800 == 15 [pid = 2302] [id = 23] 15:41:15 INFO - --DOCSHELL 0x91b65000 == 14 [pid = 2302] [id = 24] 15:41:15 INFO - --DOCSHELL 0x99091400 == 13 [pid = 2302] [id = 10] 15:41:15 INFO - MEMORY STAT vsizeMaxContiguous not supported in this build configuration. 15:41:15 INFO - MEMORY STAT | vsize 649MB | residentFast 244MB | heapAllocated 79MB 15:41:15 INFO - 326 INFO TEST-OK | devtools/client/webide/test/browser_tabs.js | took 14524ms 15:41:15 INFO - ++DOCSHELL 0x902e2800 == 14 [pid = 2302] [id = 29] 15:41:15 INFO - ++DOMWINDOW == 56 (0x902e2c00) [pid = 2302] [serial = 64] [outer = (nil)] 15:41:15 INFO - ++DOMWINDOW == 57 (0x90323800) [pid = 2302] [serial = 65] [outer = 0x902e2c00] 15:41:15 INFO - 327 INFO TEST-START | devtools/client/webide/test/browser_widget.js 15:41:15 INFO - ++DOCSHELL 0x902e5400 == 15 [pid = 2302] [id = 30] 15:41:15 INFO - ++DOMWINDOW == 58 (0x902e5800) [pid = 2302] [serial = 66] [outer = (nil)] 15:41:15 INFO - ++DOMWINDOW == 59 (0x90322000) [pid = 2302] [serial = 67] [outer = 0x902e5800] 15:41:15 INFO - ++DOCSHELL 0x918a4400 == 16 [pid = 2302] [id = 31] 15:41:15 INFO - ++DOMWINDOW == 60 (0x918a4c00) [pid = 2302] [serial = 68] [outer = (nil)] 15:41:15 INFO - ++DOCSHELL 0x918a5000 == 17 [pid = 2302] [id = 32] 15:41:15 INFO - ++DOMWINDOW == 61 (0x918a5400) [pid = 2302] [serial = 69] [outer = (nil)] 15:41:15 INFO - ++DOCSHELL 0x918a5c00 == 18 [pid = 2302] [id = 33] 15:41:15 INFO - ++DOMWINDOW == 62 (0x918a6000) [pid = 2302] [serial = 70] [outer = (nil)] 15:41:15 INFO - ++DOCSHELL 0x918a6400 == 19 [pid = 2302] [id = 34] 15:41:15 INFO - ++DOMWINDOW == 63 (0x918a6800) [pid = 2302] [serial = 71] [outer = (nil)] 15:41:15 INFO - ++DOCSHELL 0x918a6c00 == 20 [pid = 2302] [id = 35] 15:41:15 INFO - ++DOMWINDOW == 64 (0x918a7000) [pid = 2302] [serial = 72] [outer = (nil)] 15:41:15 INFO - ++DOCSHELL 0x918a7400 == 21 [pid = 2302] [id = 36] 15:41:15 INFO - ++DOMWINDOW == 65 (0x918a7c00) [pid = 2302] [serial = 73] [outer = (nil)] 15:41:15 INFO - ++DOCSHELL 0x918a8000 == 22 [pid = 2302] [id = 37] 15:41:15 INFO - ++DOMWINDOW == 66 (0x918a8400) [pid = 2302] [serial = 74] [outer = (nil)] 15:41:15 INFO - ++DOCSHELL 0x918a8800 == 23 [pid = 2302] [id = 38] 15:41:15 INFO - ++DOMWINDOW == 67 (0x918a9000) [pid = 2302] [serial = 75] [outer = (nil)] 15:41:15 INFO - ++DOCSHELL 0x918a9400 == 24 [pid = 2302] [id = 39] 15:41:15 INFO - ++DOMWINDOW == 68 (0x918a9800) [pid = 2302] [serial = 76] [outer = (nil)] 15:41:15 INFO - ++DOCSHELL 0x918aa000 == 25 [pid = 2302] [id = 40] 15:41:15 INFO - ++DOMWINDOW == 69 (0x918aa400) [pid = 2302] [serial = 77] [outer = (nil)] 15:41:15 INFO - ++DOCSHELL 0x918aa800 == 26 [pid = 2302] [id = 41] 15:41:15 INFO - ++DOMWINDOW == 70 (0x919ae800) [pid = 2302] [serial = 78] [outer = (nil)] 15:41:15 INFO - ++DOCSHELL 0x919af800 == 27 [pid = 2302] [id = 42] 15:41:15 INFO - ++DOMWINDOW == 71 (0x919afc00) [pid = 2302] [serial = 79] [outer = (nil)] 15:41:15 INFO - ++DOCSHELL 0x919b4c00 == 28 [pid = 2302] [id = 43] 15:41:15 INFO - ++DOMWINDOW == 72 (0x919b7000) [pid = 2302] [serial = 80] [outer = (nil)] 15:41:15 INFO - ++DOMWINDOW == 73 (0x91ac2400) [pid = 2302] [serial = 81] [outer = 0x918a4c00] 15:41:15 INFO - ++DOMWINDOW == 74 (0x91ac6c00) [pid = 2302] [serial = 82] [outer = 0x918a5400] 15:41:15 INFO - ++DOMWINDOW == 75 (0x91b70800) [pid = 2302] [serial = 83] [outer = 0x918a6000] 15:41:15 INFO - ++DOMWINDOW == 76 (0x91d96800) [pid = 2302] [serial = 84] [outer = 0x918a6800] 15:41:15 INFO - ++DOMWINDOW == 77 (0x91d99000) [pid = 2302] [serial = 85] [outer = 0x918a7000] 15:41:15 INFO - ++DOMWINDOW == 78 (0x91d9c000) [pid = 2302] [serial = 86] [outer = 0x918a7c00] 15:41:15 INFO - ++DOMWINDOW == 79 (0x91d9e400) [pid = 2302] [serial = 87] [outer = 0x918a8400] 15:41:15 INFO - ++DOMWINDOW == 80 (0x91e02000) [pid = 2302] [serial = 88] [outer = 0x918a9000] 15:41:15 INFO - ++DOMWINDOW == 81 (0x91e07400) [pid = 2302] [serial = 89] [outer = 0x918a9800] 15:41:15 INFO - ++DOMWINDOW == 82 (0x91e0cc00) [pid = 2302] [serial = 90] [outer = 0x918aa400] 15:41:15 INFO - ++DOMWINDOW == 83 (0x93ebe400) [pid = 2302] [serial = 91] [outer = 0x919ae800] 15:41:15 INFO - ++DOMWINDOW == 84 (0x93ec4000) [pid = 2302] [serial = 92] [outer = 0x919afc00] 15:41:15 INFO - ++DOMWINDOW == 85 (0x93ec6000) [pid = 2302] [serial = 93] [outer = 0x919b7000] 15:41:16 INFO - 328 INFO TEST-PASS | devtools/client/webide/test/browser_widget.js | Found WebIDE button - 15:41:16 INFO - 329 INFO TEST-PASS | devtools/client/webide/test/browser_widget.js | WebIDE button uninstalled - 15:41:16 INFO - 330 INFO Closing WebIDE 15:41:16 INFO - 331 INFO WebIDE closed 15:41:16 INFO - MEMORY STAT | vsize 650MB | residentFast 246MB | heapAllocated 82MB 15:41:16 INFO - 332 INFO TEST-OK | devtools/client/webide/test/browser_widget.js | took 1274ms 15:41:16 INFO - ++DOCSHELL 0x97dd8000 == 29 [pid = 2302] [id = 44] 15:41:16 INFO - ++DOMWINDOW == 86 (0x989abc00) [pid = 2302] [serial = 94] [outer = (nil)] 15:41:16 INFO - ++DOMWINDOW == 87 (0x98aa7000) [pid = 2302] [serial = 95] [outer = 0x989abc00] 15:41:17 INFO - ++DOMWINDOW == 88 (0x98aa3400) [pid = 2302] [serial = 96] [outer = 0x9b1c5400] 15:41:17 INFO - ++DOMWINDOW == 89 (0x98e91400) [pid = 2302] [serial = 97] [outer = 0x9b264400] 15:41:17 INFO - --DOCSHELL 0x9f2d7000 == 28 [pid = 2302] [id = 11] 15:41:17 INFO - ++DOMWINDOW == 90 (0x98e88800) [pid = 2302] [serial = 98] [outer = 0x9b1c5400] 15:41:17 INFO - ++DOMWINDOW == 91 (0x99090c00) [pid = 2302] [serial = 99] [outer = 0x9b264400] 15:41:18 INFO - --DOCSHELL 0x919b0000 == 27 [pid = 2302] [id = 25] 15:41:18 INFO - --DOCSHELL 0xa7f59400 == 26 [pid = 2302] [id = 8] 15:41:18 INFO - --DOCSHELL 0x99dc3400 == 25 [pid = 2302] [id = 5] 15:41:18 INFO - --DOCSHELL 0x93fb3000 == 24 [pid = 2302] [id = 9] 15:41:18 INFO - --DOCSHELL 0x9009c400 == 23 [pid = 2302] [id = 26] 15:41:18 INFO - --DOCSHELL 0x902e5400 == 22 [pid = 2302] [id = 30] 15:41:20 INFO - --DOCSHELL 0x902e2800 == 21 [pid = 2302] [id = 29] 15:41:20 INFO - --DOCSHELL 0x9446a800 == 20 [pid = 2302] [id = 7] 15:41:20 INFO - --DOMWINDOW == 90 (0x98e91400) [pid = 2302] [serial = 97] [outer = 0x9b264400] [url = about:blank] 15:41:20 INFO - --DOMWINDOW == 89 (0x99660000) [pid = 2302] [serial = 11] [outer = 0x9b264400] [url = about:blank] 15:41:20 INFO - --DOMWINDOW == 88 (0x98aa3400) [pid = 2302] [serial = 96] [outer = 0x9b1c5400] [url = about:blank] 15:41:20 INFO - --DOMWINDOW == 87 (0x9965e400) [pid = 2302] [serial = 10] [outer = 0x9b1c5400] [url = about:blank] 15:41:20 INFO - --DOCSHELL 0x919b4c00 == 19 [pid = 2302] [id = 43] 15:41:20 INFO - --DOCSHELL 0x919af800 == 18 [pid = 2302] [id = 42] 15:41:20 INFO - --DOCSHELL 0x918aa800 == 17 [pid = 2302] [id = 41] 15:41:20 INFO - --DOCSHELL 0x918aa000 == 16 [pid = 2302] [id = 40] 15:41:20 INFO - --DOCSHELL 0x918a9400 == 15 [pid = 2302] [id = 39] 15:41:20 INFO - --DOCSHELL 0x918a8800 == 14 [pid = 2302] [id = 38] 15:41:20 INFO - --DOCSHELL 0x918a8000 == 13 [pid = 2302] [id = 37] 15:41:20 INFO - --DOCSHELL 0x918a7400 == 12 [pid = 2302] [id = 36] 15:41:20 INFO - --DOCSHELL 0x918a6c00 == 11 [pid = 2302] [id = 35] 15:41:20 INFO - --DOCSHELL 0x918a6400 == 10 [pid = 2302] [id = 34] 15:41:20 INFO - --DOCSHELL 0x918a5c00 == 9 [pid = 2302] [id = 33] 15:41:20 INFO - --DOCSHELL 0x918a5000 == 8 [pid = 2302] [id = 32] 15:41:20 INFO - --DOCSHELL 0x918a4400 == 7 [pid = 2302] [id = 31] 15:41:20 INFO - --DOCSHELL 0x8f5ba000 == 6 [pid = 2302] [id = 28] 15:41:22 INFO - --DOMWINDOW == 86 (0x8f5bc400) [pid = 2302] [serial = 60] [outer = (nil)] [url = about:blank] 15:41:22 INFO - --DOMWINDOW == 85 (0x99658000) [pid = 2302] [serial = 25] [outer = (nil)] [url = about:blank] 15:41:22 INFO - --DOMWINDOW == 84 (0x9009e000) [pid = 2302] [serial = 58] [outer = (nil)] [url = about:blank] 15:41:22 INFO - --DOMWINDOW == 83 (0x93ec5c00) [pid = 2302] [serial = 56] [outer = (nil)] [url = about:blank] 15:41:22 INFO - --DOMWINDOW == 82 (0x919b2000) [pid = 2302] [serial = 55] [outer = (nil)] [url = about:blank] 15:41:22 INFO - --DOMWINDOW == 81 (0x91abd800) [pid = 2302] [serial = 54] [outer = (nil)] [url = data:application/vnd.mozilla.xul+xml;charset=utf-8,] 15:41:22 INFO - --DOMWINDOW == 80 (0xa90b4000) [pid = 2302] [serial = 18] [outer = (nil)] [url = about:newtab] 15:41:22 INFO - --DOMWINDOW == 79 (0x93fb3c00) [pid = 2302] [serial = 20] [outer = (nil)] [url = http://example.com/browser/devtools/client/webide/test/doc_tabs.html] 15:41:22 INFO - --DOMWINDOW == 78 (0x9f2d8000) [pid = 2302] [serial = 26] [outer = (nil)] [url = data:application/vnd.mozilla.xul+xml;charset=utf-8,] 15:41:22 INFO - --DOMWINDOW == 77 (0x944c4c00) [pid = 2302] [serial = 17] [outer = (nil)] [url = about:blank] 15:41:22 INFO - --DOMWINDOW == 76 (0x995ed000) [pid = 2302] [serial = 24] [outer = (nil)] [url = chrome://webide/content/webide.xul] 15:41:22 INFO - --DOMWINDOW == 75 (0x91da0c00) [pid = 2302] [serial = 29] [outer = (nil)] [url = chrome://webide/content/details.xhtml] 15:41:22 INFO - --DOMWINDOW == 74 (0x91da0400) [pid = 2302] [serial = 28] [outer = (nil)] [url = chrome://webide/content/project-listing.xhtml] 15:41:22 INFO - --DOMWINDOW == 73 (0x91b65400) [pid = 2302] [serial = 40] [outer = (nil)] [url = chrome://webide/content/runtime-listing.xhtml] 15:41:22 INFO - --DOMWINDOW == 72 (0x93ec2c00) [pid = 2302] [serial = 22] [outer = (nil)] [url = about:newtab] 15:41:22 INFO - --DOMWINDOW == 71 (0x91da2400) [pid = 2302] [serial = 32] [outer = (nil)] [url = chrome://webide/content/prefs.xhtml] 15:41:22 INFO - --DOMWINDOW == 70 (0x919b7800) [pid = 2302] [serial = 49] [outer = (nil)] [url = about:blank] 15:41:22 INFO - --DOMWINDOW == 69 (0x91e0d000) [pid = 2302] [serial = 36] [outer = (nil)] [url = about:blank] 15:41:22 INFO - --DOMWINDOW == 68 (0x91b64400) [pid = 2302] [serial = 38] [outer = (nil)] [url = chrome://webide/content/logs.xhtml] 15:41:22 INFO - --DOMWINDOW == 67 (0x919b1000) [pid = 2302] [serial = 46] [outer = (nil)] [url = about:blank] 15:41:22 INFO - --DOMWINDOW == 66 (0x91da2c00) [pid = 2302] [serial = 33] [outer = (nil)] [url = about:blank] 15:41:22 INFO - --DOMWINDOW == 65 (0x919b5400) [pid = 2302] [serial = 48] [outer = (nil)] [url = about:blank] 15:41:22 INFO - --DOMWINDOW == 64 (0x91da3c00) [pid = 2302] [serial = 35] [outer = (nil)] [url = about:blank] 15:41:22 INFO - --DOMWINDOW == 63 (0x91ab8800) [pid = 2302] [serial = 52] [outer = (nil)] [url = about:blank] 15:41:22 INFO - --DOMWINDOW == 62 (0x91b64c00) [pid = 2302] [serial = 39] [outer = (nil)] [url = about:blank] 15:41:22 INFO - --DOMWINDOW == 61 (0x919b3000) [pid = 2302] [serial = 47] [outer = (nil)] [url = about:blank] 15:41:22 INFO - --DOMWINDOW == 60 (0x91da3400) [pid = 2302] [serial = 34] [outer = (nil)] [url = about:blank] 15:41:22 INFO - --DOMWINDOW == 59 (0x9f24ec00) [pid = 2302] [serial = 43] [outer = (nil)] [url = about:blank] 15:41:22 INFO - --DOMWINDOW == 58 (0x91da1400) [pid = 2302] [serial = 30] [outer = (nil)] [url = about:blank] 15:41:22 INFO - --DOMWINDOW == 57 (0x91da1c00) [pid = 2302] [serial = 31] [outer = (nil)] [url = chrome://webide/content/addons.xhtml] 15:41:22 INFO - --DOMWINDOW == 56 (0x919b9c00) [pid = 2302] [serial = 50] [outer = (nil)] [url = about:blank] 15:41:22 INFO - --DOMWINDOW == 55 (0x9f455000) [pid = 2302] [serial = 37] [outer = (nil)] [url = about:blank] 15:41:22 INFO - --DOMWINDOW == 54 (0x8f85d400) [pid = 2302] [serial = 62] [outer = (nil)] [url = about:blank] 15:41:22 INFO - --DOMWINDOW == 53 (0x8f5ba400) [pid = 2302] [serial = 61] [outer = (nil)] [url = http://example.com/browser/devtools/client/webide/test/doc_tabs.html] 15:41:22 INFO - --DOMWINDOW == 52 (0x9009c800) [pid = 2302] [serial = 57] [outer = (nil)] [url = chrome://devtools/content/framework/toolbox.xul] 15:41:22 INFO - --DOMWINDOW == 51 (0x8f5bbc00) [pid = 2302] [serial = 59] [outer = (nil)] [url = chrome://devtools/content/webconsole/webconsole.xul] 15:41:22 INFO - --DOMWINDOW == 50 (0x944c0c00) [pid = 2302] [serial = 16] [outer = (nil)] [url = about:blank] 15:41:22 INFO - --DOMWINDOW == 49 (0x93ec4000) [pid = 2302] [serial = 92] [outer = (nil)] [url = about:blank] 15:41:22 INFO - --DOMWINDOW == 48 (0x91e0cc00) [pid = 2302] [serial = 90] [outer = (nil)] [url = about:blank] 15:41:22 INFO - --DOMWINDOW == 47 (0x91e07400) [pid = 2302] [serial = 89] [outer = (nil)] [url = about:blank] 15:41:22 INFO - --DOMWINDOW == 46 (0x91e02000) [pid = 2302] [serial = 88] [outer = (nil)] [url = about:blank] 15:41:22 INFO - --DOMWINDOW == 45 (0x91d9e400) [pid = 2302] [serial = 87] [outer = (nil)] [url = about:blank] 15:41:22 INFO - --DOMWINDOW == 44 (0x91d9c000) [pid = 2302] [serial = 86] [outer = (nil)] [url = about:blank] 15:41:22 INFO - --DOMWINDOW == 43 (0x91b70800) [pid = 2302] [serial = 83] [outer = (nil)] [url = about:blank] 15:41:22 INFO - --DOMWINDOW == 42 (0x919b7000) [pid = 2302] [serial = 80] [outer = (nil)] [url = chrome://webide/content/runtime-listing.xhtml] 15:41:22 INFO - --DOMWINDOW == 41 (0x919afc00) [pid = 2302] [serial = 79] [outer = (nil)] [url = about:blank] 15:41:22 INFO - --DOMWINDOW == 40 (0x919ae800) [pid = 2302] [serial = 78] [outer = (nil)] [url = chrome://webide/content/logs.xhtml] 15:41:22 INFO - --DOMWINDOW == 39 (0x918aa400) [pid = 2302] [serial = 77] [outer = (nil)] [url = about:blank] 15:41:22 INFO - --DOMWINDOW == 38 (0x918a9800) [pid = 2302] [serial = 76] [outer = (nil)] [url = about:blank] 15:41:22 INFO - --DOMWINDOW == 37 (0x918a9000) [pid = 2302] [serial = 75] [outer = (nil)] [url = about:blank] 15:41:22 INFO - --DOMWINDOW == 36 (0x918a8400) [pid = 2302] [serial = 74] [outer = (nil)] [url = about:blank] 15:41:22 INFO - --DOMWINDOW == 35 (0x918a7c00) [pid = 2302] [serial = 73] [outer = (nil)] [url = about:blank] 15:41:22 INFO - --DOMWINDOW == 34 (0x918a7000) [pid = 2302] [serial = 72] [outer = (nil)] [url = chrome://webide/content/prefs.xhtml] 15:41:22 INFO - --DOMWINDOW == 33 (0x918a6800) [pid = 2302] [serial = 71] [outer = (nil)] [url = chrome://webide/content/addons.xhtml] 15:41:22 INFO - --DOMWINDOW == 32 (0x918a6000) [pid = 2302] [serial = 70] [outer = (nil)] [url = about:blank] 15:41:22 INFO - --DOMWINDOW == 31 (0x918a5400) [pid = 2302] [serial = 69] [outer = (nil)] [url = chrome://webide/content/details.xhtml] 15:41:22 INFO - --DOMWINDOW == 30 (0x918a4c00) [pid = 2302] [serial = 68] [outer = (nil)] [url = chrome://webide/content/project-listing.xhtml] 15:41:22 INFO - --DOMWINDOW == 29 (0x90322000) [pid = 2302] [serial = 67] [outer = (nil)] [url = about:blank] 15:41:22 INFO - --DOMWINDOW == 28 (0x902e5800) [pid = 2302] [serial = 66] [outer = (nil)] [url = chrome://webide/content/webide.xul] 15:41:22 INFO - --DOMWINDOW == 27 (0x90323800) [pid = 2302] [serial = 65] [outer = (nil)] [url = about:blank] 15:41:22 INFO - --DOMWINDOW == 26 (0x902e2c00) [pid = 2302] [serial = 64] [outer = (nil)] [url = about:blank] 15:41:23 INFO - --DOMWINDOW == 25 (0x9afc9800) [pid = 2302] [serial = 23] [outer = (nil)] [url = http://example.com/browser/devtools/client/webide/test/doc_tabs.html] 15:41:23 INFO - --DOMWINDOW == 24 (0x91b73400) [pid = 2302] [serial = 41] [outer = (nil)] [url = chrome://webide/content/project-listing.xhtml] 15:41:23 INFO - --DOMWINDOW == 23 (0x94e9c800) [pid = 2302] [serial = 42] [outer = (nil)] [url = chrome://webide/content/details.xhtml] 15:41:23 INFO - --DOMWINDOW == 22 (0x91ab9800) [pid = 2302] [serial = 53] [outer = (nil)] [url = chrome://webide/content/runtime-listing.xhtml] 15:41:23 INFO - --DOMWINDOW == 21 (0x8fc14000) [pid = 2302] [serial = 63] [outer = (nil)] [url = http://example.com/browser/devtools/client/webide/test/doc_tabs.html] 15:41:23 INFO - --DOMWINDOW == 20 (0x919af000) [pid = 2302] [serial = 45] [outer = (nil)] [url = chrome://webide/content/prefs.xhtml] 15:41:23 INFO - --DOMWINDOW == 19 (0x919bc000) [pid = 2302] [serial = 51] [outer = (nil)] [url = chrome://webide/content/logs.xhtml] 15:41:23 INFO - --DOMWINDOW == 18 (0x919ad400) [pid = 2302] [serial = 44] [outer = (nil)] [url = chrome://webide/content/addons.xhtml] 15:41:23 INFO - --DOMWINDOW == 17 (0x93ec6000) [pid = 2302] [serial = 93] [outer = (nil)] [url = chrome://webide/content/runtime-listing.xhtml] 15:41:24 INFO - --DOMWINDOW == 16 (0x93ebe400) [pid = 2302] [serial = 91] [outer = (nil)] [url = chrome://webide/content/logs.xhtml] 15:41:24 INFO - --DOMWINDOW == 15 (0x91d99000) [pid = 2302] [serial = 85] [outer = (nil)] [url = chrome://webide/content/prefs.xhtml] 15:41:24 INFO - --DOMWINDOW == 14 (0x91d96800) [pid = 2302] [serial = 84] [outer = (nil)] [url = chrome://webide/content/addons.xhtml] 15:41:24 INFO - --DOMWINDOW == 13 (0x91ac6c00) [pid = 2302] [serial = 82] [outer = (nil)] [url = chrome://webide/content/details.xhtml] 15:41:24 INFO - --DOMWINDOW == 12 (0x91ac2400) [pid = 2302] [serial = 81] [outer = (nil)] [url = chrome://webide/content/project-listing.xhtml] 15:41:28 INFO - Completed ShutdownLeaks collections in process 2302 15:41:28 INFO - JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 208: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:41:29 INFO - ###!!! [Parent][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 15:41:29 INFO - --DOCSHELL 0x98ddf400 == 5 [pid = 2302] [id = 6] 15:41:29 INFO - --DOCSHELL 0xa465dc00 == 4 [pid = 2302] [id = 1] 15:41:30 INFO - --DOCSHELL 0x9b181400 == 3 [pid = 2302] [id = 3] 15:41:30 INFO - --DOCSHELL 0x9b263c00 == 2 [pid = 2302] [id = 4] 15:41:30 INFO - --DOCSHELL 0x97dd8000 == 1 [pid = 2302] [id = 44] 15:41:30 INFO - --DOCSHELL 0x9e82f400 == 0 [pid = 2302] [id = 2] 15:41:30 INFO - JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 492: Error: forget() called twice 15:41:30 INFO - ###!!! [Parent][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 15:41:31 INFO - ###!!! [Parent][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 15:41:31 INFO - ###!!! [Parent][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 15:41:31 INFO - ###!!! [Parent][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 15:41:32 INFO - [2302] WARNING: NS_ENSURE_TRUE(context) failed: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/xpcom/threads/nsThread.cpp, line 769 15:41:33 INFO - --DOMWINDOW == 11 (0x99090c00) [pid = 2302] [serial = 99] [outer = 0x9b264400] [url = about:blank] 15:41:33 INFO - --DOMWINDOW == 10 (0x98e88800) [pid = 2302] [serial = 98] [outer = 0x9b1c5400] [url = about:blank] 15:41:33 INFO - --DOMWINDOW == 9 (0x9b264400) [pid = 2302] [serial = 7] [outer = (nil)] [url = about:blank] 15:41:33 INFO - --DOMWINDOW == 8 (0x9b1c5400) [pid = 2302] [serial = 6] [outer = (nil)] [url = about:blank] 15:41:35 INFO - --DOMWINDOW == 7 (0x9e830000) [pid = 2302] [serial = 4] [outer = (nil)] [url = about:blank] 15:41:35 INFO - --DOMWINDOW == 6 (0xa465e000) [pid = 2302] [serial = 1] [outer = (nil)] [url = resource://gre-resources/hiddenWindow.html] 15:41:35 INFO - --DOMWINDOW == 5 (0x98de0000) [pid = 2302] [serial = 15] [outer = (nil)] [url = about:blank] 15:41:35 INFO - --DOMWINDOW == 4 (0x989abc00) [pid = 2302] [serial = 94] [outer = (nil)] [url = about:blank] 15:41:35 INFO - --DOMWINDOW == 3 (0x98aa7000) [pid = 2302] [serial = 95] [outer = (nil)] [url = about:blank] 15:41:35 INFO - --DOMWINDOW == 2 (0x98ddf800) [pid = 2302] [serial = 14] [outer = (nil)] [url = chrome://mochikit/content/browser-harness.xul] 15:41:35 INFO - --DOMWINDOW == 1 (0x9e82f800) [pid = 2302] [serial = 3] [outer = (nil)] [url = chrome://browser/content/browser.xul] 15:41:35 INFO - --DOMWINDOW == 0 (0x9e8ac400) [pid = 2302] [serial = 5] [outer = (nil)] [url = resource://gre-resources/hiddenWindow.html] 15:41:35 INFO - [2302] WARNING: OOPDeinit() without successful OOPInit(): file /builds/slave/m-in-lx-d-00000000000000000000/build/src/toolkit/crashreporter/nsExceptionHandler.cpp, line 2800 15:41:35 INFO - nsStringStats 15:41:35 INFO - => mAllocCount: 141810 15:41:35 INFO - => mReallocCount: 9886 15:41:35 INFO - => mFreeCount: 141810 15:41:35 INFO - => mShareCount: 130829 15:41:35 INFO - => mAdoptCount: 8954 15:41:35 INFO - => mAdoptFreeCount: 8954 15:41:35 INFO - => Process ID: 2302, Thread ID: 3074610944 15:41:35 INFO - TEST-INFO | Main app process: exit 0 15:41:35 INFO - runtests.py | Application ran for: 0:00:47.567609 15:41:35 INFO - zombiecheck | Reading PID log: /tmp/tmpDsFk5Spidlog 15:41:35 INFO - Stopping web server 15:41:35 INFO - Stopping web socket server 15:41:35 INFO - Stopping ssltunnel 15:41:35 INFO - TEST-INFO | leakcheck | default process: leak threshold set at 0 bytes 15:41:35 INFO - TEST-INFO | leakcheck | plugin process: leak threshold set at 0 bytes 15:41:35 INFO - TEST-INFO | leakcheck | tab process: leak threshold set at 10000 bytes 15:41:35 INFO - TEST-INFO | leakcheck | geckomediaplugin process: leak threshold set at 20000 bytes 15:41:35 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, default process 2302 15:41:35 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->| 15:41:35 INFO - | | Per-Inst Leaked| Total Rem| 15:41:35 INFO - 0 |TOTAL | 20 0| 2586731 0| 15:41:35 INFO - nsTraceRefcnt::DumpStatistics: 1365 entries 15:41:35 INFO - TEST-PASS | leakcheck | default process: no leaks detected! 15:41:35 INFO - runtests.py | Running tests: end. 15:41:35 INFO - 333 INFO checking window state 15:41:35 INFO - 334 INFO TEST-START | Shutdown 15:41:35 INFO - 335 INFO Browser Chrome Test Summary 15:41:35 INFO - 336 INFO Passed: 11 15:41:35 INFO - 337 INFO Failed: 0 15:41:35 INFO - 338 INFO Todo: 0 15:41:35 INFO - 339 INFO *** End BrowserChrome Test Results *** 15:41:35 INFO - dir: devtools/shared/worker/tests/browser 15:41:35 INFO - Setting pipeline to PAUSED ... 15:41:35 INFO - Pipeline is PREROLLING ... 15:41:35 INFO - Pipeline is PREROLLED ... 15:41:35 INFO - Setting pipeline to PLAYING ... 15:41:35 INFO - New clock: GstSystemClock 15:41:35 INFO - Got EOS from element "pipeline0". 15:41:35 INFO - Execution ended after 32670700 ns. 15:41:35 INFO - Setting pipeline to PAUSED ... 15:41:35 INFO - Setting pipeline to READY ... 15:41:35 INFO - Setting pipeline to NULL ... 15:41:35 INFO - Freeing pipeline ... 15:41:35 INFO - pk12util: PKCS12 IMPORT SUCCESSFUL 15:41:36 INFO - MochitestServer : launching [u'/builds/slave/test/build/tests/bin/xpcshell', '-g', '/builds/slave/test/build/application/firefox', '-v', '170', '-f', '/builds/slave/test/build/tests/bin/components/httpd.js', '-e', "const _PROFILE_PATH = '/tmp/tmpIL93bw.mozrunner'; const _SERVER_PORT = '8888'; const _SERVER_ADDR = '127.0.0.1'; const _TEST_PREFIX = undefined; const _DISPLAY_RESULTS = false;", '-f', '/builds/slave/test/build/tests/mochitest/server.js'] 15:41:36 INFO - runtests.py | Server pid: 2394 15:41:36 INFO - runtests.py | Websocket server pid: 2397 15:41:36 INFO - runtests.py | SSL tunnel pid: 2400 15:41:36 INFO - runtests.py | Running tests: start. 15:41:36 INFO - runtests.py | Application pid: 2422 15:41:36 INFO - TEST-INFO | started process Main app process 15:41:36 INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpIL93bw.mozrunner/runtests_leaks.log 15:41:40 INFO - ++DOCSHELL 0xa474bc00 == 1 [pid = 2422] [id = 1] 15:41:40 INFO - ++DOMWINDOW == 1 (0xa474c000) [pid = 2422] [serial = 1] [outer = (nil)] 15:41:40 INFO - [2422] WARNING: Hardware Vsync support not yet implemented. Falling back to software timers: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/gfx/thebes/gfxPlatform.cpp, line 2091 15:41:40 INFO - ++DOMWINDOW == 2 (0xa474f000) [pid = 2422] [serial = 2] [outer = 0xa474c000] 15:41:40 INFO - LoadPlugin() /tmp/tmpIL93bw.mozrunner/plugins/libnptest.so returned 9f5c8160 15:41:40 INFO - LoadPlugin() /tmp/tmpIL93bw.mozrunner/plugins/libnpthirdtest.so returned 9f5c8360 15:41:40 INFO - LoadPlugin() /tmp/tmpIL93bw.mozrunner/plugins/libnptestjava.so returned 9f5c83c0 15:41:40 INFO - LoadPlugin() /tmp/tmpIL93bw.mozrunner/plugins/libnpctrltest.so returned 9f5c8620 15:41:40 INFO - LoadPlugin() /tmp/tmpIL93bw.mozrunner/plugins/libnpsecondtest.so returned 9f5c8f20 15:41:40 INFO - LoadPlugin() /tmp/tmpIL93bw.mozrunner/plugins/libnpswftest.so returned 9f5c8f80 15:41:40 INFO - LoadPlugin() /usr/lib/mozilla/plugins/librhythmbox-itms-detection-plugin.so returned b728ada0 15:41:40 INFO - LoadPlugin() /usr/lib/mozilla/plugins/libtotem-narrowspace-plugin.so returned 9f5fe500 15:41:40 INFO - LoadPlugin() /usr/lib/mozilla/plugins/libtotem-cone-plugin.so returned 9f5afee0 15:41:40 INFO - LoadPlugin() /usr/lib/mozilla/plugins/libtotem-gmp-plugin.so returned 9f5b0b60 15:41:40 INFO - LoadPlugin() /usr/lib/mozilla/plugins/libtotem-mully-plugin.so returned 9f5b98a0 15:41:41 INFO - ++DOCSHELL 0x9ebe3000 == 2 [pid = 2422] [id = 2] 15:41:41 INFO - ++DOMWINDOW == 3 (0x9ebe4400) [pid = 2422] [serial = 3] [outer = (nil)] 15:41:41 INFO - ++DOMWINDOW == 4 (0x9ea1a800) [pid = 2422] [serial = 4] [outer = 0x9ebe4400] 15:41:41 INFO - ++DOMWINDOW == 5 (0x9eae6400) [pid = 2422] [serial = 5] [outer = 0xa474c000] 15:41:43 INFO - [2422] WARNING: Failed to retarget HTML data delivery to the parser thread.: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/parser/html/nsHtml5StreamParser.cpp, line 966 15:41:43 INFO - ++DOCSHELL 0x9af14800 == 3 [pid = 2422] [id = 3] 15:41:43 INFO - ++DOMWINDOW == 6 (0x9afa3000) [pid = 2422] [serial = 6] [outer = (nil)] 15:41:43 INFO - ++DOCSHELL 0x9afa3c00 == 4 [pid = 2422] [id = 4] 15:41:43 INFO - ++DOMWINDOW == 7 (0x9b368000) [pid = 2422] [serial = 7] [outer = (nil)] 15:41:44 INFO - [2422] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80040111: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/dom/base/nsFrameLoader.cpp, line 272 15:41:44 INFO - ++DOCSHELL 0x99dc6000 == 5 [pid = 2422] [id = 5] 15:41:44 INFO - ++DOMWINDOW == 8 (0x99dc6400) [pid = 2422] [serial = 8] [outer = (nil)] 15:41:44 INFO - [2422] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80040111: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/dom/base/nsFrameLoader.cpp, line 272 15:41:44 INFO - ++DOMWINDOW == 9 (0x99810c00) [pid = 2422] [serial = 9] [outer = 0x99dc6400] 15:41:45 INFO - ++DOMWINDOW == 10 (0x99661c00) [pid = 2422] [serial = 10] [outer = 0x9afa3000] 15:41:45 INFO - ++DOMWINDOW == 11 (0x99663800) [pid = 2422] [serial = 11] [outer = 0x9b368000] 15:41:45 INFO - ++DOMWINDOW == 12 (0x99665c00) [pid = 2422] [serial = 12] [outer = 0x99dc6400] 15:41:46 INFO - ++DOMWINDOW == 13 (0x98d0a800) [pid = 2422] [serial = 13] [outer = 0x99dc6400] 15:41:46 INFO - ++DOCSHELL 0x98da1800 == 6 [pid = 2422] [id = 6] 15:41:46 INFO - ++DOMWINDOW == 14 (0x98da1c00) [pid = 2422] [serial = 14] [outer = (nil)] 15:41:46 INFO - ++DOMWINDOW == 15 (0x98da2400) [pid = 2422] [serial = 15] [outer = 0x98da1c00] 15:41:49 INFO - ++DOCSHELL 0x94469c00 == 7 [pid = 2422] [id = 7] 15:41:49 INFO - ++DOMWINDOW == 16 (0x944e2400) [pid = 2422] [serial = 16] [outer = (nil)] 15:41:49 INFO - ++DOMWINDOW == 17 (0x944e6400) [pid = 2422] [serial = 17] [outer = 0x944e2400] 15:41:49 INFO - ++DOCSHELL 0x99810400 == 8 [pid = 2422] [id = 8] 15:41:49 INFO - ++DOMWINDOW == 18 (0x9eb7cc00) [pid = 2422] [serial = 18] [outer = (nil)] 15:41:49 INFO - ++DOMWINDOW == 19 (0x941b0800) [pid = 2422] [serial = 19] [outer = 0x9eb7cc00] 15:41:49 INFO - 340 INFO TEST-START | devtools/shared/worker/tests/browser/browser_worker-01.js 15:41:50 INFO - ++DOMWINDOW == 20 (0x93ff0c00) [pid = 2422] [serial = 20] [outer = 0x9eb7cc00] 15:41:50 INFO - [2422] WARNING: GetDefaultCharsetForLocale: need to add multi locale support: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/intl/locale/unix/nsUNIXCharset.cpp, line 101 15:41:51 INFO - console.warn: `workerify` should only be used in tests or measuring performance. 15:41:51 INFO - This creates an object URL on the browser window, and should not be used in production. 15:41:51 INFO - ###!!! [Parent][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 15:41:51 INFO - ###!!! [Parent][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 15:41:51 INFO - ++DOCSHELL 0x990fc800 == 9 [pid = 2422] [id = 9] 15:41:51 INFO - ++DOMWINDOW == 21 (0x992f2800) [pid = 2422] [serial = 21] [outer = (nil)] 15:41:51 INFO - ++DOMWINDOW == 22 (0x9af99000) [pid = 2422] [serial = 22] [outer = 0x992f2800] 15:41:52 INFO - ++DOMWINDOW == 23 (0x9b421800) [pid = 2422] [serial = 23] [outer = 0x992f2800] 15:41:52 INFO - ++DOCSHELL 0x9b427400 == 10 [pid = 2422] [id = 10] 15:41:52 INFO - ++DOMWINDOW == 24 (0x9b542c00) [pid = 2422] [serial = 24] [outer = (nil)] 15:41:52 INFO - ++DOMWINDOW == 25 (0x9ea26400) [pid = 2422] [serial = 25] [outer = 0x9b542c00] 15:41:52 INFO - [2422] WARNING: Could not get disk status from nsIDiskSpaceWatcher: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/uriloader/prefetch/nsOfflineCacheUpdateService.cpp, line 319 15:41:52 INFO - console.warn: `workerify` should only be used in tests or measuring performance. 15:41:52 INFO - This creates an object URL on the browser window, and should not be used in production. 15:41:52 INFO - ###!!! [Parent][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 15:41:52 INFO - ###!!! [Parent][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 15:41:52 INFO - MEMORY STAT vsizeMaxContiguous not supported in this build configuration. 15:41:52 INFO - MEMORY STAT | vsize 596MB | residentFast 213MB | heapAllocated 69MB 15:41:52 INFO - 341 INFO TEST-OK | devtools/shared/worker/tests/browser/browser_worker-01.js | took 3161ms 15:41:52 INFO - ++DOCSHELL 0x93ff3c00 == 11 [pid = 2422] [id = 11] 15:41:52 INFO - ++DOMWINDOW == 26 (0x944e7800) [pid = 2422] [serial = 26] [outer = (nil)] 15:41:52 INFO - ++DOMWINDOW == 27 (0x9ee42800) [pid = 2422] [serial = 27] [outer = 0x944e7800] 15:41:53 INFO - 342 INFO TEST-START | devtools/shared/worker/tests/browser/browser_worker-02.js 15:41:53 INFO - [2422] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80040111: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/netwerk/protocol/res/SubstitutingProtocolHandler.cpp, line 244 15:41:53 INFO - [2422] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80040111: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/netwerk/protocol/res/SubstitutingProtocolHandler.cpp, line 244 15:41:53 INFO - [2422] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80040111: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/netwerk/base/nsIOService.cpp, line 778 15:41:53 INFO - [2422] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80040111: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/netwerk/base/nsNetUtil.inl, line 179 15:41:53 INFO - [2422] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80040111: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/dom/workers/ScriptLoader.cpp, line 192 15:41:53 INFO - [2422] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80040111: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/dom/workers/WorkerPrivate.cpp, line 4352 15:41:53 INFO - [2422] WARNING: 'aRv.Failed()', file /builds/slave/m-in-lx-d-00000000000000000000/build/src/dom/workers/WorkerPrivate.cpp, line 5463 15:41:53 INFO - ###!!! [Parent][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 15:41:53 INFO - MEMORY STAT | vsize 596MB | residentFast 214MB | heapAllocated 69MB 15:41:53 INFO - 343 INFO TEST-OK | devtools/shared/worker/tests/browser/browser_worker-02.js | took 337ms 15:41:53 INFO - ++DOCSHELL 0xa4896400 == 12 [pid = 2422] [id = 12] 15:41:53 INFO - ++DOMWINDOW == 28 (0xa4896800) [pid = 2422] [serial = 28] [outer = (nil)] 15:41:53 INFO - ++DOMWINDOW == 29 (0xa57f8800) [pid = 2422] [serial = 29] [outer = 0xa4896800] 15:41:53 INFO - 344 INFO TEST-START | devtools/shared/worker/tests/browser/browser_worker-03.js 15:41:53 INFO - console.warn: `workerify` should only be used in tests or measuring performance. 15:41:53 INFO - This creates an object URL on the browser window, and should not be used in production. 15:41:53 INFO - console.warn: `workerify` should only be used in tests or measuring performance. 15:41:53 INFO - This creates an object URL on the browser window, and should not be used in production. 15:41:53 INFO - ###!!! [Parent][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 15:41:54 INFO - console.warn: `workerify` should only be used in tests or measuring performance. 15:41:54 INFO - This creates an object URL on the browser window, and should not be used in production. 15:41:54 INFO - ###!!! [Parent][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 15:41:54 INFO - [2422] WARNING: 'aRv.Failed()', file /builds/slave/m-in-lx-d-00000000000000000000/build/src/dom/workers/WorkerPrivate.cpp, line 5463 15:41:54 INFO - console.warn: `workerify` should only be used in tests or measuring performance. 15:41:54 INFO - This creates an object URL on the browser window, and should not be used in production. 15:41:54 INFO - ###!!! [Parent][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 15:41:54 INFO - MEMORY STAT | vsize 599MB | residentFast 215MB | heapAllocated 69MB 15:41:54 INFO - 345 INFO TEST-OK | devtools/shared/worker/tests/browser/browser_worker-03.js | took 542ms 15:41:54 INFO - ++DOCSHELL 0xa7f61000 == 13 [pid = 2422] [id = 13] 15:41:54 INFO - ++DOMWINDOW == 30 (0xa7f61c00) [pid = 2422] [serial = 30] [outer = (nil)] 15:41:54 INFO - ++DOMWINDOW == 31 (0xa8de2800) [pid = 2422] [serial = 31] [outer = 0xa7f61c00] 15:41:54 INFO - ++DOMWINDOW == 32 (0x9a052000) [pid = 2422] [serial = 32] [outer = 0x9afa3000] 15:41:54 INFO - ++DOMWINDOW == 33 (0xa8f24800) [pid = 2422] [serial = 33] [outer = 0x9b368000] 15:41:54 INFO - --DOCSHELL 0x990fc800 == 12 [pid = 2422] [id = 9] 15:41:54 INFO - ++DOMWINDOW == 34 (0xa8de4c00) [pid = 2422] [serial = 34] [outer = 0x9afa3000] 15:41:54 INFO - ++DOMWINDOW == 35 (0xa90b1000) [pid = 2422] [serial = 35] [outer = 0x9b368000] 15:41:56 INFO - --DOCSHELL 0x9b427400 == 11 [pid = 2422] [id = 10] 15:41:56 INFO - --DOCSHELL 0x99dc6000 == 10 [pid = 2422] [id = 5] 15:41:56 INFO - --DOCSHELL 0x94469c00 == 9 [pid = 2422] [id = 7] 15:41:56 INFO - --DOCSHELL 0x99810400 == 8 [pid = 2422] [id = 8] 15:41:57 INFO - --DOCSHELL 0x93ff3c00 == 7 [pid = 2422] [id = 11] 15:41:57 INFO - --DOCSHELL 0xa4896400 == 6 [pid = 2422] [id = 12] 15:41:57 INFO - --DOMWINDOW == 34 (0x99661c00) [pid = 2422] [serial = 10] [outer = 0x9afa3000] [url = about:blank] 15:41:57 INFO - --DOMWINDOW == 33 (0x99663800) [pid = 2422] [serial = 11] [outer = 0x9b368000] [url = about:blank] 15:41:57 INFO - --DOMWINDOW == 32 (0xa8f24800) [pid = 2422] [serial = 33] [outer = 0x9b368000] [url = about:blank] 15:41:57 INFO - --DOMWINDOW == 31 (0x9a052000) [pid = 2422] [serial = 32] [outer = 0x9afa3000] [url = about:blank] 15:41:59 INFO - --DOMWINDOW == 30 (0x944e7800) [pid = 2422] [serial = 26] [outer = (nil)] [url = about:blank] 15:41:59 INFO - --DOMWINDOW == 29 (0x9ea26400) [pid = 2422] [serial = 25] [outer = (nil)] [url = about:blank] 15:41:59 INFO - --DOMWINDOW == 28 (0x9b542c00) [pid = 2422] [serial = 24] [outer = (nil)] [url = about:blank] 15:41:59 INFO - --DOMWINDOW == 27 (0x9b421800) [pid = 2422] [serial = 23] [outer = (nil)] [url = data:application/vnd.mozilla.xul+xml;charset=utf-8,] 15:41:59 INFO - --DOMWINDOW == 26 (0x992f2800) [pid = 2422] [serial = 21] [outer = (nil)] [url = data:application/vnd.mozilla.xul+xml;charset=utf-8,] 15:41:59 INFO - --DOMWINDOW == 25 (0xa474f000) [pid = 2422] [serial = 2] [outer = (nil)] [url = about:blank] 15:41:59 INFO - --DOMWINDOW == 24 (0x9eb7cc00) [pid = 2422] [serial = 18] [outer = (nil)] [url = about:newtab] 15:41:59 INFO - --DOMWINDOW == 23 (0x941b0800) [pid = 2422] [serial = 19] [outer = (nil)] [url = about:blank] 15:41:59 INFO - --DOMWINDOW == 22 (0x93ff0c00) [pid = 2422] [serial = 20] [outer = (nil)] [url = about:newtab] 15:41:59 INFO - --DOMWINDOW == 21 (0x944e2400) [pid = 2422] [serial = 16] [outer = (nil)] [url = about:blank] 15:41:59 INFO - --DOMWINDOW == 20 (0x944e6400) [pid = 2422] [serial = 17] [outer = (nil)] [url = about:blank] 15:41:59 INFO - --DOMWINDOW == 19 (0xa4896800) [pid = 2422] [serial = 28] [outer = (nil)] [url = about:blank] 15:41:59 INFO - --DOMWINDOW == 18 (0x9af99000) [pid = 2422] [serial = 22] [outer = (nil)] [url = about:blank] 15:41:59 INFO - --DOMWINDOW == 17 (0x98d0a800) [pid = 2422] [serial = 13] [outer = (nil)] [url = about:blank] 15:41:59 INFO - --DOMWINDOW == 16 (0x99665c00) [pid = 2422] [serial = 12] [outer = (nil)] [url = about:blank] 15:41:59 INFO - --DOMWINDOW == 15 (0x99dc6400) [pid = 2422] [serial = 8] [outer = (nil)] [url = about:blank] 15:41:59 INFO - --DOMWINDOW == 14 (0x99810c00) [pid = 2422] [serial = 9] [outer = (nil)] [url = about:blank] 15:41:59 INFO - --DOMWINDOW == 13 (0xa57f8800) [pid = 2422] [serial = 29] [outer = (nil)] [url = about:blank] 15:41:59 INFO - --DOMWINDOW == 12 (0x9ee42800) [pid = 2422] [serial = 27] [outer = (nil)] [url = about:blank] 15:42:05 INFO - Completed ShutdownLeaks collections in process 2422 15:42:05 INFO - JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 208: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:42:06 INFO - ###!!! [Parent][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 15:42:06 INFO - --DOCSHELL 0x98da1800 == 5 [pid = 2422] [id = 6] 15:42:06 INFO - --DOCSHELL 0xa474bc00 == 4 [pid = 2422] [id = 1] 15:42:06 INFO - [2422] WARNING: A runnable was posted to a worker that is already shutting down!: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/dom/workers/WorkerPrivate.cpp, line 2264 15:42:06 INFO - [2422] WARNING: Failed to dispatch offline status change event!: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/dom/workers/WorkerPrivate.cpp, line 3030 15:42:07 INFO - --DOCSHELL 0x9ebe3000 == 3 [pid = 2422] [id = 2] 15:42:07 INFO - --DOCSHELL 0x9af14800 == 2 [pid = 2422] [id = 3] 15:42:07 INFO - --DOCSHELL 0x9afa3c00 == 1 [pid = 2422] [id = 4] 15:42:07 INFO - --DOCSHELL 0xa7f61000 == 0 [pid = 2422] [id = 13] 15:42:07 INFO - JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 492: Error: forget() called twice 15:42:07 INFO - ###!!! [Parent][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 15:42:07 INFO - ###!!! [Parent][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 15:42:07 INFO - ###!!! [Parent][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 15:42:07 INFO - ###!!! [Parent][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 15:42:07 INFO - ###!!! [Parent][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 15:42:07 INFO - JavaScript error: , line 0: NS_ERROR_UNEXPECTED: 15:42:08 INFO - [2422] WARNING: NS_ENSURE_TRUE(context) failed: file /builds/slave/m-in-lx-d-00000000000000000000/build/src/xpcom/threads/nsThread.cpp, line 769 15:42:09 INFO - --DOMWINDOW == 11 (0xa90b1000) [pid = 2422] [serial = 35] [outer = 0x9b368000] [url = about:blank] 15:42:09 INFO - --DOMWINDOW == 10 (0xa8de4c00) [pid = 2422] [serial = 34] [outer = 0x9afa3000] [url = about:blank] 15:42:09 INFO - --DOMWINDOW == 9 (0x9b368000) [pid = 2422] [serial = 7] [outer = (nil)] [url = about:blank] 15:42:09 INFO - --DOMWINDOW == 8 (0x9afa3000) [pid = 2422] [serial = 6] [outer = (nil)] [url = about:blank] 15:42:10 INFO - --DOMWINDOW == 7 (0x9ea1a800) [pid = 2422] [serial = 4] [outer = (nil)] [url = about:blank] 15:42:10 INFO - --DOMWINDOW == 6 (0xa474c000) [pid = 2422] [serial = 1] [outer = (nil)] [url = resource://gre-resources/hiddenWindow.html] 15:42:10 INFO - --DOMWINDOW == 5 (0x98da2400) [pid = 2422] [serial = 15] [outer = (nil)] [url = about:blank] 15:42:10 INFO - --DOMWINDOW == 4 (0xa7f61c00) [pid = 2422] [serial = 30] [outer = (nil)] [url = about:blank] 15:42:10 INFO - --DOMWINDOW == 3 (0xa8de2800) [pid = 2422] [serial = 31] [outer = (nil)] [url = about:blank] 15:42:10 INFO - --DOMWINDOW == 2 (0x98da1c00) [pid = 2422] [serial = 14] [outer = (nil)] [url = chrome://mochikit/content/browser-harness.xul] 15:42:10 INFO - --DOMWINDOW == 1 (0x9ebe4400) [pid = 2422] [serial = 3] [outer = (nil)] [url = chrome://browser/content/browser.xul] 15:42:10 INFO - --DOMWINDOW == 0 (0x9eae6400) [pid = 2422] [serial = 5] [outer = (nil)] [url = resource://gre-resources/hiddenWindow.html] 15:42:10 INFO - [2422] WARNING: OOPDeinit() without successful OOPInit(): file /builds/slave/m-in-lx-d-00000000000000000000/build/src/toolkit/crashreporter/nsExceptionHandler.cpp, line 2800 15:42:10 INFO - nsStringStats 15:42:10 INFO - => mAllocCount: 105464 15:42:10 INFO - => mReallocCount: 8306 15:42:10 INFO - => mFreeCount: 105464 15:42:10 INFO - => mShareCount: 93468 15:42:10 INFO - => mAdoptCount: 6402 15:42:10 INFO - => mAdoptFreeCount: 6402 15:42:10 INFO - => Process ID: 2422, Thread ID: 3074844416 15:42:10 INFO - TEST-INFO | Main app process: exit 0 15:42:10 INFO - runtests.py | Application ran for: 0:00:33.867609 15:42:10 INFO - zombiecheck | Reading PID log: /tmp/tmpHzPnbBpidlog 15:42:10 INFO - Stopping web server 15:42:10 INFO - Stopping web socket server 15:42:10 INFO - Stopping ssltunnel 15:42:10 INFO - TEST-INFO | leakcheck | default process: leak threshold set at 0 bytes 15:42:10 INFO - TEST-INFO | leakcheck | plugin process: leak threshold set at 0 bytes 15:42:10 INFO - TEST-INFO | leakcheck | tab process: leak threshold set at 10000 bytes 15:42:10 INFO - TEST-INFO | leakcheck | geckomediaplugin process: leak threshold set at 20000 bytes 15:42:10 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, default process 2422 15:42:10 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->| 15:42:10 INFO - | | Per-Inst Leaked| Total Rem| 15:42:10 INFO - 0 |TOTAL | 23 0| 937261 0| 15:42:10 INFO - nsTraceRefcnt::DumpStatistics: 1286 entries 15:42:10 INFO - TEST-PASS | leakcheck | default process: no leaks detected! 15:42:10 INFO - runtests.py | Running tests: end. 15:42:10 INFO - 346 INFO checking window state 15:42:10 INFO - 347 INFO TEST-START | Shutdown 15:42:10 INFO - 348 INFO Browser Chrome Test Summary 15:42:10 INFO - 349 INFO Passed: 12 15:42:10 INFO - 350 INFO Failed: 0 15:42:10 INFO - 351 INFO Todo: 0 15:42:10 INFO - 352 INFO *** End BrowserChrome Test Results *** 15:42:10 INFO - TEST-INFO | checking window state 15:42:10 INFO - Browser Chrome Test Summary 15:42:10 INFO - Passed: 2546 15:42:10 INFO - Failed: 0 15:42:10 INFO - Todo: 0 15:42:10 INFO - *** End BrowserChrome Test Results *** 15:42:10 INFO - SUITE-END | took 1574s 15:42:10 INFO - Return code: 0 15:42:10 INFO - TinderboxPrint: mochitest-mochitest-devtools-chrome-chunked
2546/0/0 15:42:10 INFO - # TBPL SUCCESS # 15:42:10 INFO - The mochitest suite: mochitest-devtools-chrome-chunked ran with return status: SUCCESS 15:42:10 INFO - Running post-action listener: _package_coverage_data 15:42:10 INFO - Running post-action listener: _resource_record_post_action 15:42:10 INFO - Running post-run listener: _resource_record_post_run 15:42:11 INFO - Total resource usage - Wall time: 1599s; CPU: 100.0%; Read bytes: 16310272; Write bytes: 281927680; Read time: 664; Write time: 161824 15:42:11 INFO - install - Wall time: 24s; CPU: 100.0%; Read bytes: 0; Write bytes: 101052416; Read time: 0; Write time: 95652 15:42:11 INFO - run-tests - Wall time: 1575s; CPU: 100.0%; Read bytes: 14389248; Write bytes: 180875264; Read time: 624; Write time: 66172 15:42:11 INFO - Running post-run listener: _upload_blobber_files 15:42:11 INFO - Blob upload gear active. 15:42:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:42:11 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:42:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'mozilla-inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:42:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b mozilla-inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:42:12 INFO - (blobuploader) - INFO - Open directory for files ... 15:42:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/mochitest-devtools-chrome-chunked_raw.log ... 15:42:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:42:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:42:14 INFO - (blobuploader) - INFO - TinderboxPrint: mochitest-devtools-chrome-chunked_raw.log: uploaded 15:42:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:42:14 INFO - (blobuploader) - INFO - Done attempting. 15:42:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/mochitest-devtools-chrome-chunked_errorsummary.log ... 15:42:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:42:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:42:14 INFO - (blobuploader) - INFO - TinderboxPrint: mochitest-devtools-chrome-chunked_errorsummary.log: uploaded 15:42:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:42:14 INFO - (blobuploader) - INFO - Done attempting. 15:42:14 INFO - (blobuploader) - INFO - Iteration through files over. 15:42:14 INFO - Return code: 0 15:42:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:42:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:42:14 INFO - Setting buildbot property blobber_files to {"mochitest-devtools-chrome-chunked_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/mozilla-inbound/sha512/940ae4d2f61453e9588712687620f44ad169154f4a5ea237406f2756c9db85f53c6db04a65478dc2147d3551fb1b45f6562956434374664034c72bab5570c55d", "mochitest-devtools-chrome-chunked_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/mozilla-inbound/sha512/b15ce456a6bb380b121c862e95003421d781d34021a46ab77036020745b560881ecfe8d3d817dfc4313b6d1790d67582572d25f491c94aa0f713714f01276ffe"} 15:42:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:42:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:42:14 INFO - Contents: 15:42:14 INFO - blobber_files:{"mochitest-devtools-chrome-chunked_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/mozilla-inbound/sha512/940ae4d2f61453e9588712687620f44ad169154f4a5ea237406f2756c9db85f53c6db04a65478dc2147d3551fb1b45f6562956434374664034c72bab5570c55d", "mochitest-devtools-chrome-chunked_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/mozilla-inbound/sha512/b15ce456a6bb380b121c862e95003421d781d34021a46ab77036020745b560881ecfe8d3d817dfc4313b6d1790d67582572d25f491c94aa0f713714f01276ffe"} 15:42:14 INFO - Copying logs to upload dir... 15:42:14 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1683.891839 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/desktop_unittest.py ...' (results: 0, elapsed: 28 mins, 3 secs) (at 2015-11-26 15:42:15.044051) ========= ========= Started set props: build_url blobber_files symbols_url (results: 0, elapsed: 0 secs) (at 2015-11-26 15:42:15.044908) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] 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/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5a152710dd62cc268aad214e000002d8-1448579446.6075-694935828 _=/tools/buildbot/bin/python using PTY: False blobber_files:{"mochitest-devtools-chrome-chunked_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/mozilla-inbound/sha512/940ae4d2f61453e9588712687620f44ad169154f4a5ea237406f2756c9db85f53c6db04a65478dc2147d3551fb1b45f6562956434374664034c72bab5570c55d", "mochitest-devtools-chrome-chunked_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/mozilla-inbound/sha512/b15ce456a6bb380b121c862e95003421d781d34021a46ab77036020745b560881ecfe8d3d817dfc4313b6d1790d67582572d25f491c94aa0f713714f01276ffe"} build_url:https://queue.taskcluster.net/v1/task/BwEY7NVAR9qjwXDLtZ2LYg/artifacts/public/build/firefox-45.0a1.en-US.linux-i686.tar.bz2 symbols_url:https://queue.taskcluster.net/v1/task/BwEY7NVAR9qjwXDLtZ2LYg/artifacts/public/build/firefox-45.0a1.en-US.linux-i686.crashreporter-symbols.zip program finished with exit code 0 elapsedTime=0.030987 build_url: 'https://queue.taskcluster.net/v1/task/BwEY7NVAR9qjwXDLtZ2LYg/artifacts/public/build/firefox-45.0a1.en-US.linux-i686.tar.bz2' blobber_files: '{"mochitest-devtools-chrome-chunked_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/mozilla-inbound/sha512/940ae4d2f61453e9588712687620f44ad169154f4a5ea237406f2756c9db85f53c6db04a65478dc2147d3551fb1b45f6562956434374664034c72bab5570c55d", "mochitest-devtools-chrome-chunked_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/mozilla-inbound/sha512/b15ce456a6bb380b121c862e95003421d781d34021a46ab77036020745b560881ecfe8d3d817dfc4313b6d1790d67582572d25f491c94aa0f713714f01276ffe"}' symbols_url: 'https://queue.taskcluster.net/v1/task/BwEY7NVAR9qjwXDLtZ2LYg/artifacts/public/build/firefox-45.0a1.en-US.linux-i686.crashreporter-symbols.zip' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files symbols_url (results: 0, elapsed: 0 secs) (at 2015-11-26 15:42:15.101157) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 15:42:15.101446) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] 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-1448579446.6075-694935828 _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015863 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 15:42:15.198000) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-26 15:42:15.198297) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-26 15:42:15.198556) ========= ========= Total master_lag: 2.73 =========