builder: mozilla-inbound_ubuntu64-asan_vm_test-mochitest-devtools-chrome-2 slave: tst-linux64-spot-1294 starttime: 1448583706.1 results: success (0) buildid: 20151126154612 builduid: 3ad565b3fde5423894dfb4942259f8fd revision: 496bd6468e61d8de9c8bc0e61bb641e3ed007a0a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-26 16:21:46.095506) ========= master: http://buildbot-master68.bb.releng.usw2.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-26 16:21:46.095947) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-26 16:21:46.096244) ========= 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=9ca12473fbb1d023794ffd180000023c-1448583697.130287-1221766036 _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.026829 basedir: '/builds/slave/test' ========= master_lag: 0.34 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-26 16:21:46.467209) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-26 16:21:46.467489) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-26 16:21:46.505469) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 16:21:46.505732) ========= 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=9ca12473fbb1d023794ffd180000023c-1448583697.130287-1221766036 _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.025984 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 16:21:46.570069) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-26 16:21:46.570341) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-26 16:21:46.570674) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 16:21:46.570973) ========= 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=9ca12473fbb1d023794ffd180000023c-1448583697.130287-1221766036 _=/tools/buildbot/bin/python using PTY: False --2015-11-26 16:21:46-- 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% 9.23M=0.001s 2015-11-26 16:21:46 (9.23 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.351744 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 16:21:46.959308) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 16:21:46.959589) ========= 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=9ca12473fbb1d023794ffd180000023c-1448583697.130287-1221766036 _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.041972 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 16:21:47.037484) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 16:21:47.037794) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 496bd6468e61d8de9c8bc0e61bb641e3ed007a0a --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 496bd6468e61d8de9c8bc0e61bb641e3ed007a0a --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=9ca12473fbb1d023794ffd180000023c-1448583697.130287-1221766036 _=/tools/buildbot/bin/python using PTY: False 2015-11-26 16:21:47,199 truncating revision to first 12 chars 2015-11-26 16:21:47,199 Setting DEBUG logging. 2015-11-26 16:21:47,200 attempt 1/10 2015-11-26 16:21:47,200 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/496bd6468e61?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-26 16:21:47,507 unpacking tar archive at: mozilla-inbound-496bd6468e61/testing/mozharness/ program finished with exit code 0 elapsedTime=0.626324 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 16:21:47.715320) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-26 16:21:47.715631) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-26 16:21:47.748317) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-26 16:21:47.748571) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-26 16:21:47.748963) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/desktop_unittest.py ...' (results: 0, elapsed: 23 mins, 50 secs) (at 2015-11-26 16:21:47.749259) ========= /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 2 --blob-upload-branch mozilla-inbound --download-symbols ondemand 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', '2', '--blob-upload-branch', 'mozilla-inbound', '--download-symbols', 'ondemand'] environment: DISPLAY=:0 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 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=9ca12473fbb1d023794ffd180000023c-1448583697.130287-1221766036 _=/tools/buildbot/bin/python using PTY: False 16:21:48 INFO - MultiFileLogger online at 20151126 16:21:48 in /builds/slave/test 16:21:48 INFO - Run as scripts/scripts/desktop_unittest.py --cfg unittests/linux_unittest.py --mochitest-suite mochitest-devtools-chrome-chunked --total-chunks 8 --this-chunk 2 --blob-upload-branch mozilla-inbound --download-symbols ondemand 16:21:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:21:48 INFO - {'all_cppunittest_suites': {'cppunittest': {'tests': ('tests/cppunittest',)}}, 16:21:48 INFO - 'all_gtest_suites': {'gtest': ()}, 16:21:48 INFO - 'all_jittest_suites': {'jittest': (), 16:21:48 INFO - 'jittest-chunked': (), 16:21:48 INFO - 'jittest1': ('--total-chunks=2', '--this-chunk=1'), 16:21:48 INFO - 'jittest2': ('--total-chunks=2', '--this-chunk=2')}, 16:21:48 INFO - 'all_mochitest_suites': {'a11y': ('--a11y',), 16:21:48 INFO - 'browser-chrome': ('--browser-chrome',), 16:21:48 INFO - 'browser-chrome-addons': ('--browser-chrome', 16:21:48 INFO - '--chunk-by-runtime', 16:21:48 INFO - '--tag=addons'), 16:21:48 INFO - 'browser-chrome-chunked': ('--browser-chrome', 16:21:48 INFO - '--chunk-by-runtime'), 16:21:48 INFO - 'chrome': ('--chrome',), 16:21:48 INFO - 'chrome-chunked': ('--chrome', '--chunk-by-dir=4'), 16:21:48 INFO - 'jetpack-addon': ('--jetpack-addon',), 16:21:48 INFO - 'jetpack-package': ('--jetpack-package',), 16:21:48 INFO - 'mochitest-devtools-chrome': ('--browser-chrome', 16:21:48 INFO - '--subsuite=devtools'), 16:21:48 INFO - 'mochitest-devtools-chrome-chunked': ('--browser-chrome', 16:21:48 INFO - '--subsuite=devtools', 16:21:48 INFO - '--chunk-by-runtime'), 16:21:48 INFO - 'mochitest-gl': ('--subsuite=webgl',), 16:21:48 INFO - 'mochitest-push': ('--subsuite=push',), 16:21:48 INFO - 'plain': (), 16:21:48 INFO - 'plain-chunked': ('--chunk-by-dir=4',)}, 16:21:48 INFO - 'all_mozbase_suites': {'mozbase': ()}, 16:21:48 INFO - 'all_reftest_suites': {'crashtest': {'options': ('--suite=crashtest',), 16:21:48 INFO - 'tests': ('tests/reftest/tests/testing/crashtest/crashtests.list',)}, 16:21:48 INFO - 'crashtest-ipc': {'env': {'MOZ_DISABLE_CONTEXT_SHARING_GLX': '1', 16:21:48 INFO - 'MOZ_OMTC_ENABLED': '1'}, 16:21:48 INFO - 'options': ('--suite=crashtest', 16:21:48 INFO - '--setpref=browser.tabs.remote=true', 16:21:48 INFO - '--setpref=browser.tabs.remote.autostart=true', 16:21:48 INFO - '--setpref=layers.offmainthreadcomposition.testing.enabled=true', 16:21:48 INFO - '--setpref=layers.async-pan-zoom.enabled=true'), 16:21:48 INFO - 'tests': ('tests/reftest/tests/testing/crashtest/crashtests.list',)}, 16:21:48 INFO - 'jsreftest': {'options': ('--extra-profile-file=tests/jsreftest/tests/user.js', 16:21:48 INFO - '--suite=jstestbrowser'), 16:21:48 INFO - 'tests': ('tests/jsreftest/tests/jstests.list',)}, 16:21:48 INFO - 'reftest': {'options': ('--suite=reftest',), 16:21:48 INFO - 'tests': ('tests/reftest/tests/layout/reftests/reftest.list',)}, 16:21:48 INFO - 'reftest-ipc': {'env': {'MOZ_DISABLE_CONTEXT_SHARING_GLX': '1', 16:21:48 INFO - 'MOZ_OMTC_ENABLED': '1'}, 16:21:48 INFO - 'options': ('--suite=reftest', 16:21:48 INFO - '--setpref=browser.tabs.remote=true', 16:21:48 INFO - '--setpref=browser.tabs.remote.autostart=true', 16:21:48 INFO - '--setpref=layers.offmainthreadcomposition.testing.enabled=true', 16:21:48 INFO - '--setpref=layers.async-pan-zoom.enabled=true'), 16:21:48 INFO - 'tests': ('tests/reftest/tests/layout/reftests/reftest-sanity/reftest.list',)}, 16:21:48 INFO - 'reftest-no-accel': {'options': ('--suite=reftest', 16:21:48 INFO - '--setpref=layers.acceleration.force-enabled=disabled'), 16:21:48 INFO - 'tests': ('tests/reftest/tests/layout/reftests/reftest.list',)}}, 16:21:48 INFO - 'all_webapprt_suites': {'chrome': ('--webapprt-chrome', 16:21:48 INFO - '--browser-arg=-test-mode'), 16:21:48 INFO - 'content': ('--webapprt-content',)}, 16:21:48 INFO - 'all_xpcshell_suites': {'xpcshell': {'options': ('--xpcshell=%(abs_app_dir)s/xpcshell', 16:21:48 INFO - '--manifest=tests/xpcshell/tests/all-test-dirs.list'), 16:21:48 INFO - 'tests': ()}, 16:21:48 INFO - 'xpcshell-addons': {'options': ('--xpcshell=%(abs_app_dir)s/xpcshell', 16:21:48 INFO - '--tag=addons', 16:21:48 INFO - '--manifest=tests/xpcshell/tests/all-test-dirs.list'), 16:21:48 INFO - 'tests': ()}}, 16:21:48 INFO - 'append_to_log': False, 16:21:48 INFO - 'base_work_dir': '/builds/slave/test', 16:21:48 INFO - 'binary_path': '/builds/slave/test/build/firefox/firefox-bin', 16:21:48 INFO - 'blob_upload_branch': 'mozilla-inbound', 16:21:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:21:48 INFO - 'buildbot_json_path': 'buildprops.json', 16:21:48 INFO - 'buildbot_max_log_size': 52428800, 16:21:48 INFO - 'code_coverage': False, 16:21:48 INFO - 'config_files': ('unittests/linux_unittest.py',), 16:21:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:21:48 INFO - 'download_minidump_stackwalk': True, 16:21:48 INFO - 'download_symbols': 'ondemand', 16:21:48 INFO - 'e10s': False, 16:21:48 INFO - 'exe_suffix': '', 16:21:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:21:48 INFO - 'tooltool.py': '/tools/tooltool.py', 16:21:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:21:48 INFO - '/tools/misc-python/virtualenv.py')}, 16:21:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:21:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:21:48 INFO - 'installer_path': '/builds/slave/test/build/installer.tar.bz2', 16:21:48 INFO - 'log_level': 'info', 16:21:48 INFO - 'log_to_console': True, 16:21:48 INFO - 'minidump_save_path': '%(abs_work_dir)s/../minidumps', 16:21:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:21:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:21:48 INFO - 'minimum_tests_zip_dirs': ('bin/*', 16:21:48 INFO - 'certs/*', 16:21:48 INFO - 'modules/*', 16:21:48 INFO - 'mozbase/*', 16:21:48 INFO - 'config/*'), 16:21:48 INFO - 'no_random': False, 16:21:48 INFO - 'opt_config_files': (), 16:21:48 INFO - 'pip_index': False, 16:21:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:21:48 INFO - 'cmd': ('xset', 's', 'off', 's', 'reset'), 16:21:48 INFO - 'enabled': True, 16:21:48 INFO - 'halt_on_failure': False, 16:21:48 INFO - 'name': 'disable_screen_saver'}, 16:21:48 INFO - {'architectures': ('32bit',), 16:21:48 INFO - 'cmd': ('python', 16:21:48 INFO - '../scripts/external_tools/mouse_and_screen_resolution.py', 16:21:48 INFO - '--configuration-url', 16:21:48 INFO - 'https://hg.mozilla.org/%(branch)s/raw-file/%(revision)s/testing/machine-configuration.json'), 16:21:48 INFO - 'enabled': False, 16:21:48 INFO - 'halt_on_failure': True, 16:21:48 INFO - 'name': 'run mouse & screen adjustment script'}), 16:21:48 INFO - 'require_test_zip': True, 16:21:48 INFO - 'run_all_suites': False, 16:21:48 INFO - 'run_cmd_checks_enabled': True, 16:21:48 INFO - 'run_file_names': {'cppunittest': 'runcppunittests.py', 16:21:48 INFO - 'gtest': 'rungtests.py', 16:21:48 INFO - 'jittest': 'jit_test.py', 16:21:48 INFO - 'mochitest': 'runtests.py', 16:21:48 INFO - 'mozbase': 'test.py', 16:21:48 INFO - 'mozmill': 'runtestlist.py', 16:21:48 INFO - 'reftest': 'runreftest.py', 16:21:48 INFO - 'webapprt': 'runtests.py', 16:21:48 INFO - 'xpcshell': 'runxpcshelltests.py'}, 16:21:48 INFO - 'specific_tests_zip_dirs': {'cppunittest': ('cppunittest/*',), 16:21:48 INFO - 'gtest': ('gtest/*',), 16:21:48 INFO - 'jittest': ('jit-test/*',), 16:21:48 INFO - 'mochitest': ('mochitest/*',), 16:21:48 INFO - 'mozbase': ('mozbase/*',), 16:21:48 INFO - 'mozmill': ('mozmill/*',), 16:21:48 INFO - 'reftest': ('reftest/*', 'jsreftest/*'), 16:21:48 INFO - 'webapprt': ('mochitest/*',), 16:21:48 INFO - 'xpcshell': ('xpcshell/*',)}, 16:21:48 INFO - 'specified_mochitest_suites': ('mochitest-devtools-chrome-chunked',), 16:21:48 INFO - 'strict_content_sandbox': False, 16:21:48 INFO - 'suite_definitions': {'cppunittest': {'options': ('--symbols-path=%(symbols_path)s', 16:21:48 INFO - '--xre-path=%(abs_app_dir)s'), 16:21:48 INFO - 'run_filename': 'runcppunittests.py', 16:21:48 INFO - 'testsdir': 'cppunittest'}, 16:21:48 INFO - 'gtest': {'options': ('--xre-path=%(abs_res_dir)s', 16:21:48 INFO - '--cwd=%(gtest_dir)s', 16:21:48 INFO - '--symbols-path=%(symbols_path)s', 16:21:48 INFO - '%(binary_path)s'), 16:21:48 INFO - 'run_filename': 'rungtests.py'}, 16:21:48 INFO - 'jittest': {'options': ('tests/bin/js', 16:21:48 INFO - '--no-slow', 16:21:48 INFO - '--no-progress', 16:21:48 INFO - '--format=automation', 16:21:48 INFO - '--jitflags=all'), 16:21:48 INFO - 'run_filename': 'jit_test.py', 16:21:48 INFO - 'testsdir': 'jit-test/jit-test'}, 16:21:48 INFO - 'luciddream-b2gdt': {'options': ('--startup-timeout=300', 16:21:48 INFO - '--log-raw=%(raw_log_file)s', 16:21:48 INFO - '--log-errorsummary=%(error_summary_file)s', 16:21:48 INFO - '--browser-path=%(browser_path)s', 16:21:48 INFO - '--b2g-desktop-path=%(fxos_desktop_path)s', 16:21:48 INFO - '--gaia-profile=%(gaia_profile)s', 16:21:48 INFO - '%(test_manifest)s')}, 16:21:48 INFO - 'luciddream-emulator': {'options': ('--startup-timeout=300', 16:21:48 INFO - '--log-raw=%(raw_log_file)s', 16:21:48 INFO - '--log-errorsummary=%(error_summary_file)s', 16:21:48 INFO - '--browser-path=%(browser_path)s', 16:21:48 INFO - '--b2gpath=%(emulator_path)s', 16:21:48 INFO - '%(test_manifest)s')}, 16:21:48 INFO - 'mochitest': {'options': ('--appname=%(binary_path)s', 16:21:48 INFO - '--utility-path=tests/bin', 16:21:48 INFO - '--extra-profile-file=tests/bin/plugins', 16:21:48 INFO - '--symbols-path=%(symbols_path)s', 16:21:48 INFO - '--certificate-path=tests/certs', 16:21:48 INFO - '--setpref=webgl.force-enabled=true', 16:21:48 INFO - '--quiet', 16:21:48 INFO - '--log-raw=%(raw_log_file)s', 16:21:48 INFO - '--log-errorsummary=%(error_summary_file)s', 16:21:48 INFO - '--use-test-media-devices', 16:21:48 INFO - '--screenshot-on-fail'), 16:21:48 INFO - 'run_filename': 'runtests.py', 16:21:48 INFO - 'testsdir': 'mochitest'}, 16:21:48 INFO - 'mozbase': {'options': ('-b', '%(binary_path)s'), 16:21:48 INFO - 'run_filename': 'test.py', 16:21:48 INFO - 'testsdir': 'mozbase'}, 16:21:48 INFO - 'mozmill': {'options': ('--binary=%(binary_path)s', 16:21:48 INFO - '--testing-modules-dir=test/modules', 16:21:48 INFO - '--symbols-path=%(symbols_path)s'), 16:21:48 INFO - 'run_filename': 'runtestlist.py', 16:21:48 INFO - 'testsdir': 'mozmill'}, 16:21:48 INFO - 'reftest': {'options': ('--appname=%(binary_path)s', 16:21:48 INFO - '--utility-path=tests/bin', 16:21:48 INFO - '--extra-profile-file=tests/bin/plugins', 16:21:48 INFO - '--symbols-path=%(symbols_path)s'), 16:21:48 INFO - 'run_filename': 'runreftest.py', 16:21:48 INFO - 'testsdir': 'reftest'}, 16:21:48 INFO - 'webapprt': {'options': ('--app=%(app_path)s', 16:21:48 INFO - '--utility-path=tests/bin', 16:21:48 INFO - '--extra-profile-file=tests/bin/plugins', 16:21:48 INFO - '--symbols-path=%(symbols_path)s', 16:21:48 INFO - '--certificate-path=tests/certs', 16:21:48 INFO - '--console-level=INFO', 16:21:48 INFO - '--testing-modules-dir=tests/modules', 16:21:48 INFO - '--quiet'), 16:21:48 INFO - 'run_filename': 'runtests.py', 16:21:48 INFO - 'testsdir': 'mochitest'}, 16:21:48 INFO - 'xpcshell': {'options': ('--symbols-path=%(symbols_path)s', 16:21:48 INFO - '--test-plugin-path=%(test_plugin_path)s', 16:21:48 INFO - '--log-raw=%(raw_log_file)s', 16:21:48 INFO - '--log-errorsummary=%(error_summary_file)s', 16:21:48 INFO - '--utility-path=tests/bin'), 16:21:48 INFO - 'run_filename': 'runxpcshelltests.py', 16:21:48 INFO - 'testsdir': 'xpcshell'}}, 16:21:48 INFO - 'this_chunk': '2', 16:21:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:21:48 INFO - 'total_chunks': '8', 16:21:48 INFO - 'vcs_output_timeout': 1000, 16:21:48 INFO - 'virtualenv_path': 'venv', 16:21:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:21:48 INFO - 'work_dir': 'build', 16:21:48 INFO - 'xpcshell_name': 'xpcshell'} 16:21:48 INFO - ##### 16:21:48 INFO - ##### Running clobber step. 16:21:48 INFO - ##### 16:21:48 INFO - Running pre-action listener: _resource_record_pre_action 16:21:48 INFO - Running main action method: clobber 16:21:48 INFO - rmtree: /builds/slave/test/build 16:21:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:21:49 INFO - Running post-action listener: _resource_record_post_action 16:21:49 INFO - ##### 16:21:49 INFO - ##### Running read-buildbot-config step. 16:21:49 INFO - ##### 16:21:49 INFO - Running pre-action listener: _resource_record_pre_action 16:21:49 INFO - Running main action method: read_buildbot_config 16:21:49 INFO - Using buildbot properties: 16:21:49 INFO - { 16:21:49 INFO - "properties": { 16:21:49 INFO - "buildnumber": 143, 16:21:49 INFO - "product": "firefox", 16:21:49 INFO - "script_repo_revision": "production", 16:21:49 INFO - "branch": "mozilla-inbound", 16:21:49 INFO - "repository": "", 16:21:49 INFO - "buildername": "Ubuntu ASAN VM 12.04 x64 mozilla-inbound opt test mochitest-devtools-chrome-2", 16:21:49 INFO - "buildid": "20151126154612", 16:21:49 INFO - "slavename": "tst-linux64-spot-1294", 16:21:49 INFO - "pgo_build": "False", 16:21:49 INFO - "basedir": "/builds/slave/test", 16:21:49 INFO - "project": "", 16:21:49 INFO - "platform": "linux64-asan", 16:21:49 INFO - "master": "http://buildbot-master68.bb.releng.usw2.mozilla.com:8201/", 16:21:49 INFO - "slavebuilddir": "test", 16:21:49 INFO - "scheduler": "tests-mozilla-inbound-ubuntu64-asan_vm-opt-unittest-7-3600", 16:21:49 INFO - "repo_path": "integration/mozilla-inbound", 16:21:49 INFO - "moz_repo_path": "", 16:21:49 INFO - "stage_platform": "linux64-asan", 16:21:49 INFO - "builduid": "3ad565b3fde5423894dfb4942259f8fd", 16:21:49 INFO - "revision": "496bd6468e61d8de9c8bc0e61bb641e3ed007a0a" 16:21:49 INFO - }, 16:21:49 INFO - "sourcestamp": { 16:21:49 INFO - "repository": "", 16:21:49 INFO - "hasPatch": false, 16:21:49 INFO - "project": "", 16:21:49 INFO - "branch": "mozilla-inbound-linux64-asan-opt-unittest", 16:21:49 INFO - "changes": [ 16:21:49 INFO - { 16:21:49 INFO - "category": null, 16:21:49 INFO - "files": [ 16:21:49 INFO - { 16:21:49 INFO - "url": null, 16:21:49 INFO - "name": "https://queue.taskcluster.net/v1/task/8tZBG5zRRuePVzQr1TSPwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64-asan.tar.bz2" 16:21:49 INFO - }, 16:21:49 INFO - { 16:21:49 INFO - "url": null, 16:21:49 INFO - "name": "https://queue.taskcluster.net/v1/task/8tZBG5zRRuePVzQr1TSPwg/artifacts/public/build/test_packages.json" 16:21:49 INFO - } 16:21:49 INFO - ], 16:21:49 INFO - "repository": "", 16:21:49 INFO - "rev": "2fa7dd926187b890c08f8737de58c5b22e219da6", 16:21:49 INFO - "who": "tnikkel@gmail.com", 16:21:49 INFO - "when": 1448574693, 16:21:49 INFO - "number": 6712631, 16:21:49 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", 16:21:49 INFO - "project": "", 16:21:49 INFO - "at": "Thu 26 Nov 2015 13:51:33", 16:21:49 INFO - "branch": "mozilla-inbound-linux64-asan-opt-unittest", 16:21:49 INFO - "revlink": "", 16:21:49 INFO - "properties": [ 16:21:49 INFO - [ 16:21:49 INFO - "buildid", 16:21:49 INFO - "20151126125812", 16:21:49 INFO - "Change" 16:21:49 INFO - ], 16:21:49 INFO - [ 16:21:49 INFO - "builduid", 16:21:49 INFO - "547389da4efa496dba81d4fedb6fbb55", 16:21:49 INFO - "Change" 16:21:49 INFO - ], 16:21:49 INFO - [ 16:21:49 INFO - "pgo_build", 16:21:49 INFO - "False", 16:21:49 INFO - "Change" 16:21:49 INFO - ] 16:21:49 INFO - ], 16:21:49 INFO - "revision": "2fa7dd926187b890c08f8737de58c5b22e219da6" 16:21:49 INFO - }, 16:21:49 INFO - { 16:21:49 INFO - "category": null, 16:21:49 INFO - "files": [ 16:21:49 INFO - { 16:21:49 INFO - "url": null, 16:21:49 INFO - "name": "https://queue.taskcluster.net/v1/task/apLqD06PQtexalqACkFY8Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64-asan.tar.bz2" 16:21:49 INFO - }, 16:21:49 INFO - { 16:21:49 INFO - "url": null, 16:21:49 INFO - "name": "https://queue.taskcluster.net/v1/task/apLqD06PQtexalqACkFY8Q/artifacts/public/build/test_packages.json" 16:21:49 INFO - } 16:21:49 INFO - ], 16:21:49 INFO - "repository": "", 16:21:49 INFO - "rev": "ff34a06cb439e6988e91cc78f3999e8012b7f835", 16:21:49 INFO - "who": "opettay@mozilla.com", 16:21:49 INFO - "when": 1448575335, 16:21:49 INFO - "number": 6712654, 16:21:49 INFO - "comments": "Bug 789315, notify MutationObservers before running ' 16:34:53 INFO - 3406 INFO Loading the helper frame script chrome://devtools/content/shared/frame-script-utils.js 16:34:53 INFO - 3407 INFO Image has been requested 16:34:54 INFO - 3408 INFO Image is responding 16:34:54 INFO - 3409 INFO URL 'data:text/html,

Slow script

' loading complete 16:34:54 INFO - 3410 INFO Opening the inspector panel 16:34:56 INFO - 3411 INFO Console message: [JavaScript Warning: "Error in parsing value for 'text-anchor'. Declaration dropped." {file: "resource://devtools/server/actors/highlighters.css" line: 269 column: 15 source: " text-anchor: left;"}] 16:34:57 INFO - 3412 INFO The toolbox is open 16:34:58 INFO - 3413 INFO The inspector panel is active and ready 16:34:58 INFO - 3414 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_load_01.js | There is a markup view - 16:34:58 INFO - 3415 INFO Sending message devtools:test:reload to content 16:34:58 INFO - 3416 INFO Image has been requested 16:34:58 INFO - 3417 INFO Sending message Test:SynthesizeKey to content 16:34:58 INFO - 3418 INFO Expecting message Test:SynthesizeKey from content 16:34:59 INFO - 3419 INFO Console message: [JavaScript Warning: "Key event not available on some keyboard layouts: key="r" modifiers="accel alt"" {file: "chrome://marionette/content/EventUtils.js" line: 402}] 16:34:59 INFO - 3420 INFO Console message: [JavaScript Warning: "Key event not available on GTK2: key="u" modifiers="shift, accel"" {file: "chrome://marionette/content/EventUtils.js" line: 402}] 16:34:59 INFO - 3421 INFO Image is responding 16:35:00 INFO - 3422 INFO Console message: [JavaScript Warning: "Error in parsing value for 'text-anchor'. Declaration dropped." {file: "resource://devtools/server/actors/highlighters.css" line: 269 column: 15 source: " text-anchor: left;"}] 16:35:00 INFO - 3423 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_load_01.js | There is a markup view - 16:35:00 INFO - 3424 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_load_01.js | The markup view is rendering - 16:35:00 INFO - 3425 INFO Leaving test 16:35:00 INFO - console.error: 16:35:00 INFO - Message: Error: Connection closed, pending request to server1.conn41.domwalker28, type children failed 16:35:00 INFO - Request stack: 16:35:00 INFO - Front<.request@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:1178:7 16:35:00 INFO - frontProto/ resource://devtools/server/protocol.js:1338:14 16:35:00 INFO - MarkupView.prototype._getVisibleChildren@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/markupview/markup-view.js:1509:1 16:35:00 INFO - MarkupView.prototype._updateChildren@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/markupview/markup-view.js:1439:25 16:35:00 INFO - MarkupView.prototype._expandContainer@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/markupview/markup-view.js:981:12 16:35:00 INFO - MarkupView.prototype.expandNode@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/markupview/markup-view.js:995:5 16:35:00 INFO - MarkupView.prototype.showNode@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/markupview/markup-view.js:955:7 16:35:00 INFO - MarkupView.prototype._onNewSelection@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/markupview/markup-view.js:478:14 16:35:00 INFO - MarkupView@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/markupview/markup-view.js:126:3 16:35:00 INFO - InspectorPanel.prototype._onMarkupFrameLoad@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/inspector/inspector-panel.js:956:19 16:35:00 INFO - EventListener.handleEvent*InspectorPanel.prototype._initMarkup@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/inspector/inspector-panel.js:940:5 16:35:00 INFO - InspectorPanel.prototype.onNewRoot/onNodeSelected@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/inspector/inspector-panel.js:420:7 16:35:00 INFO - Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:934:23 16:35:00 INFO - this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 16:35:00 INFO - Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 16:35:00 INFO - this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 16:35:00 INFO - this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 16:35:00 INFO - Front<.onPacket/<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:1236:9 16:35:00 INFO - DevTools RDP*Front<.request@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:1178:7 16:35:00 INFO - frontProto/ resource://devtools/server/protocol.js:1338:14 16:35:00 INFO - exports.WalkerFront<.querySelector<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/actors/inspector.js:3338:12 16:35:00 INFO - InspectorPanel.prototype._getDefaultNodeForSelection/<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/inspector/inspector-panel.js:263:16 16:35:00 INFO - Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:934:23 16:35:00 INFO - this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 16:35:00 INFO - Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 16:35:00 INFO - this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 16:35:00 INFO - this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 16:35:00 INFO - Front<.onPacket/<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:1236:9 16:35:00 INFO - DevTools RDP*Front<.request@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:1178:7 16:35:00 INFO - frontProto/ resource://devtools/server/protocol.js:1338:14 16:35:00 INFO - exports.WalkerFront<.getMutations<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/actors/inspector.js:3464:12 16:35:00 INFO - exports.WalkerFront<.onMutations<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/actors/inspector.js:3594:5 16:35:00 INFO - Front<.onPacket/results<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:1201:44 16:35:00 INFO - Front<.onPacket@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:1201:23 16:35:00 INFO - DebuggerClient.prototype.onPacket@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/shared/client/main.js:930:7 16:35:00 INFO - LocalDebuggerTransport.prototype.send/<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/shared/transport/transport.js:569:11 16:35:00 INFO - makeInfallible/<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/shared/DevToolsUtils.js:87:14 16:35:00 INFO - makeInfallible/<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/shared/DevToolsUtils.js:87:14 16:35:00 INFO - Stack: 16:35:00 INFO - Front<.destroy@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:1125:23 16:35:00 INFO - exports.WalkerFront<.destroy@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/actors/inspector.js:3229:5 16:35:00 INFO - Pool<.destroy@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:820:9 16:35:00 INFO - Front<.destroy@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:1127:5 16:35:00 INFO - exports.InspectorFront<.destroy@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/actors/inspector.js:3896:5 16:35:00 INFO - Toolbox.prototype.destroyInspector/this._destroyingInspector<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/framework/toolbox.js:1834:13 16:35:00 INFO - TaskImpl_run@resource://gre/modules/Task.jsm:314:40 16:35:00 INFO - Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:934:23 16:35:00 INFO - this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 16:35:01 INFO - Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 16:35:01 INFO - this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 16:35:01 INFO - Promise.prototype.then@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:451:5 16:35:01 INFO - TaskImpl_handleResultValue@resource://gre/modules/Task.jsm:388:7 16:35:01 INFO - TaskImpl_run@resource://gre/modules/Task.jsm:322:13 16:35:01 INFO - TaskImpl@resource://gre/modules/Task.jsm:275:3 16:35:01 INFO - createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 16:35:01 INFO - Toolbox.prototype.destroyInspector/this._destroyingInspector<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/framework/toolbox.js:1833:13 16:35:01 INFO - TaskImpl_run@resource://gre/modules/Task.jsm:314:40 16:35:01 INFO - TaskImpl@resource://gre/modules/Task.jsm:275:3 16:35:01 INFO - createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 16:35:01 INFO - Task_spawn@resource://gre/modules/Task.jsm:164:12 16:35:01 INFO - Toolbox.prototype.destroyInspector@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/framework/toolbox.js:1818:40 16:35:01 INFO - Toolbox.prototype.destroy@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/framework/toolbox.js:1944:22 16:35:01 INFO - DT_closeToolbox@resource://devtools/client/framework/gDevTools.jsm:464:12 16:35:01 INFO - @chrome://mochitests/content/browser/devtools/client/markupview/test/head.js:44:9 16:35:01 INFO - TaskImpl_run@resource://gre/modules/Task.jsm:314:40 16:35:01 INFO - TaskImpl@resource://gre/modules/Task.jsm:275:3 16:35:01 INFO - createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 16:35:01 INFO - Task_spawn@resource://gre/modules/Task.jsm:164:12 16:35:01 INFO - TaskImpl_handleResultValue@resource://gre/modules/Task.jsm:381:1 16:35:01 INFO - TaskImpl_run@resource://gre/modules/Task.jsm:322:13 16:35:01 INFO - TaskImpl_handleResultValue@resource://gre/modules/Task.jsm:393:7 16:35:01 INFO - TaskImpl_run@resource://gre/modules/Task.jsm:322:13 16:35:01 INFO - TaskImpl_handleResultValue@resource://gre/modules/Task.jsm:393:7 16:35:01 INFO - TaskImpl_run@resource://gre/modules/Task.jsm:322:13 16:35:01 INFO - TaskImpl_handleResultValue@resource://gre/modules/Task.jsm:393:7 16:35:01 INFO - TaskImpl_run@resource://gre/modules/Task.jsm:322:13 16:35:01 INFO - TaskImpl@resource://gre/modules/Task.jsm:275:3 16:35:01 INFO - createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 16:35:01 INFO - testScope/test_finish/<@chrome://mochikit/content/browser-test.js:1067:11 16:35:01 INFO - testScope/test_executeSoon/<.run@chrome://mochikit/content/browser-test.js:969:9 16:35:01 INFO - console.error: 16:35:01 INFO - Message: Error: Connection closed, pending request to server1.conn41.domwalker28, type children failed 16:35:01 INFO - Request stack: 16:35:01 INFO - Front<.request@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:1178:7 16:35:01 INFO - frontProto/ resource://devtools/server/protocol.js:1338:14 16:35:01 INFO - MarkupView.prototype._getVisibleChildren@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/markupview/markup-view.js:1509:1 16:35:01 INFO - MarkupView.prototype._updateChildren@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/markupview/markup-view.js:1439:25 16:35:01 INFO - MarkupView.prototype.importNode@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/markupview/markup-view.js:813:5 16:35:01 INFO - MarkupView.prototype.showNode@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/markupview/markup-view.js:954:7 16:35:01 INFO - MarkupView.prototype._onNewSelection@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/markupview/markup-view.js:478:14 16:35:01 INFO - MarkupView@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/markupview/markup-view.js:126:3 16:35:01 INFO - InspectorPanel.prototype._onMarkupFrameLoad@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/inspector/inspector-panel.js:956:19 16:35:01 INFO - EventListener.handleEvent*InspectorPanel.prototype._initMarkup@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/inspector/inspector-panel.js:940:5 16:35:01 INFO - InspectorPanel.prototype.onNewRoot/onNodeSelected@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/inspector/inspector-panel.js:420:7 16:35:01 INFO - Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:934:23 16:35:01 INFO - this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 16:35:01 INFO - Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 16:35:01 INFO - this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 16:35:01 INFO - this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 16:35:01 INFO - Front<.onPacket/<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:1236:9 16:35:01 INFO - DevTools RDP*Front<.request@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:1178:7 16:35:01 INFO - frontProto/ resource://devtools/server/protocol.js:1338:14 16:35:01 INFO - exports.WalkerFront<.querySelector<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/actors/inspector.js:3338:12 16:35:01 INFO - InspectorPanel.prototype._getDefaultNodeForSelection/<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/inspector/inspector-panel.js:263:16 16:35:01 INFO - Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:934:23 16:35:01 INFO - this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 16:35:01 INFO - Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 16:35:01 INFO - this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 16:35:01 INFO - this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 16:35:01 INFO - Front<.onPacket/<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:1236:9 16:35:01 INFO - DevTools RDP*Front<.request@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:1178:7 16:35:01 INFO - frontProto/ resource://devtools/server/protocol.js:1338:14 16:35:01 INFO - exports.WalkerFront<.getMutations<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/actors/inspector.js:3464:12 16:35:01 INFO - exports.WalkerFront<.onMutations<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/actors/inspector.js:3594:5 16:35:01 INFO - Front<.onPacket/results<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:1201:44 16:35:01 INFO - Front<.onPacket@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:1201:23 16:35:01 INFO - DebuggerClient.prototype.onPacket@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/shared/client/main.js:930:7 16:35:01 INFO - LocalDebuggerTransport.prototype.send/<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/shared/transport/transport.js:569:11 16:35:01 INFO - makeInfallible/<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/shared/DevToolsUtils.js:87:14 16:35:01 INFO - makeInfallible/<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/shared/DevToolsUtils.js:87:14 16:35:01 INFO - Stack: 16:35:01 INFO - Front<.destroy@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:1125:23 16:35:01 INFO - exports.WalkerFront<.destroy@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/actors/inspector.js:3229:5 16:35:01 INFO - Pool<.destroy@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:820:9 16:35:01 INFO - Front<.destroy@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:1127:5 16:35:01 INFO - exports.InspectorFront<.destroy@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/actors/inspector.js:3896:5 16:35:01 INFO - Toolbox.prototype.destroyInspector/this._destroyingInspector<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/framework/toolbox.js:1834:13 16:35:01 INFO - TaskImpl_run@resource://gre/modules/Task.jsm:314:40 16:35:01 INFO - Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:934:23 16:35:01 INFO - this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 16:35:01 INFO - Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 16:35:01 INFO - this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 16:35:01 INFO - Promise.prototype.then@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:451:5 16:35:01 INFO - TaskImpl_handleResultValue@resource://gre/modules/Task.jsm:388:7 16:35:01 INFO - TaskImpl_run@resource://gre/modules/Task.jsm:322:13 16:35:01 INFO - TaskImpl@resource://gre/modules/Task.jsm:275:3 16:35:01 INFO - createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 16:35:01 INFO - Toolbox.prototype.destroyInspector/this._destroyingInspector<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/framework/toolbox.js:1833:13 16:35:01 INFO - TaskImpl_run@resource://gre/modules/Task.jsm:314:40 16:35:01 INFO - TaskImpl@resource://gre/modules/Task.jsm:275:3 16:35:01 INFO - createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 16:35:01 INFO - Task_spawn@resource://gre/modules/Task.jsm:164:12 16:35:01 INFO - Toolbox.prototype.destroyInspector@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/framework/toolbox.js:1818:40 16:35:01 INFO - Toolbox.prototype.destroy@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/framework/toolbox.js:1944:22 16:35:01 INFO - DT_closeToolbox@resource://devtools/client/framework/gDevTools.jsm:464:12 16:35:01 INFO - @chrome://mochitests/content/browser/devtools/client/markupview/test/head.js:44:9 16:35:01 INFO - TaskImpl_run@resource://gre/modules/Task.jsm:314:40 16:35:01 INFO - TaskImpl@resource://gre/modules/Task.jsm:275:3 16:35:01 INFO - createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 16:35:01 INFO - Task_spawn@resource://gre/modules/Task.jsm:164:12 16:35:01 INFO - TaskImpl_handleResultValue@resource://gre/modules/Task.jsm:381:1 16:35:01 INFO - TaskImpl_run@resource://gre/modules/Task.jsm:322:13 16:35:01 INFO - TaskImpl_handleResultValue@resource://gre/modules/Task.jsm:393:7 16:35:01 INFO - TaskImpl_run@resource://gre/modules/Task.jsm:322:13 16:35:01 INFO - TaskImpl_handleResultValue@resource://gre/modules/Task.jsm:393:7 16:35:01 INFO - TaskImpl_run@resource://gre/modules/Task.jsm:322:13 16:35:01 INFO - TaskImpl_handleResultValue@resource://gre/modules/Task.jsm:393:7 16:35:01 INFO - TaskImpl_run@resource://gre/modules/Task.jsm:322:13 16:35:01 INFO - TaskImpl@resource://gre/modules/Task.jsm:275:3 16:35:01 INFO - createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 16:35:01 INFO - testScope/test_finish/<@chrome://mochikit/content/browser-test.js:1067:11 16:35:01 INFO - testScope/test_executeSoon/<.run@chrome://mochikit/content/browser-test.js:969:9 16:35:01 INFO - console.error: 16:35:01 INFO - Message: Error: Connection closed, pending request to server1.conn41.domwalker28, type children failed 16:35:01 INFO - Request stack: 16:35:01 INFO - Front<.request@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:1178:7 16:35:01 INFO - frontProto/ resource://devtools/server/protocol.js:1338:14 16:35:01 INFO - MarkupView.prototype._getVisibleChildren@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/markupview/markup-view.js:1509:1 16:35:01 INFO - MarkupView.prototype._updateChildren@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/markupview/markup-view.js:1439:25 16:35:01 INFO - MarkupView.prototype._expandContainer@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/markupview/markup-view.js:981:12 16:35:01 INFO - MarkupView.prototype.expandNode@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/markupview/markup-view.js:995:5 16:35:01 INFO - InspectorPanel.prototype.onNewRoot/onNodeSelected/<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/inspector/inspector-panel.js:425:9 16:35:01 INFO - EventEmitter_once/handler@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/shared/event-emitter.js:92:1 16:35:01 INFO - EventEmitter_emit@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/shared/event-emitter.js:147:11 16:35:01 INFO - InspectorPanel.prototype._onMarkupFrameLoad@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/inspector/inspector-panel.js:958:5 16:35:01 INFO - EventListener.handleEvent*InspectorPanel.prototype._initMarkup@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/inspector/inspector-panel.js:940:5 16:35:01 INFO - InspectorPanel.prototype.onNewRoot/onNodeSelected@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/inspector/inspector-panel.js:420:7 16:35:01 INFO - Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:934:23 16:35:01 INFO - this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 16:35:01 INFO - Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 16:35:01 INFO - this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 16:35:01 INFO - this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 16:35:01 INFO - Front<.onPacket/<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:1236:9 16:35:01 INFO - DevTools RDP*Front<.request@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:1178:7 16:35:01 INFO - frontProto/ resource://devtools/server/protocol.js:1338:14 16:35:01 INFO - exports.WalkerFront<.querySelector<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/actors/inspector.js:3338:12 16:35:01 INFO - InspectorPanel.prototype._getDefaultNodeForSelection/<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/inspector/inspector-panel.js:263:16 16:35:01 INFO - Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:934:23 16:35:01 INFO - this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 16:35:01 INFO - Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 16:35:01 INFO - this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 16:35:01 INFO - this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 16:35:01 INFO - Front<.onPacket/<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:1236:9 16:35:01 INFO - DevTools RDP*Front<.request@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:1178:7 16:35:01 INFO - frontProto/ resource://devtools/server/protocol.js:1338:14 16:35:01 INFO - exports.WalkerFront<.getMutations<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/actors/inspector.js:3464:12 16:35:01 INFO - exports.WalkerFront<.onMutations<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/actors/inspector.js:3594:5 16:35:01 INFO - Front<.onPacket/results<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:1201:44 16:35:01 INFO - Front<.onPacket@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:1201:23 16:35:01 INFO - DebuggerClient.prototype.onPacket@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/shared/client/main.js:930:7 16:35:01 INFO - LocalDebuggerTransport.prototype.send/<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/shared/transport/transport.js:569:11 16:35:01 INFO - makeInfallible/<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/shared/DevToolsUtils.js:87:14 16:35:01 INFO - makeInfallible/<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/shared/DevToolsUtils.js:87:14 16:35:01 INFO - Stack: 16:35:01 INFO - Front<.destroy@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:1125:23 16:35:01 INFO - exports.WalkerFront<.destroy@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/actors/inspector.js:3229:5 16:35:01 INFO - Pool<.destroy@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:820:9 16:35:01 INFO - Front<.destroy@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:1127:5 16:35:01 INFO - exports.InspectorFront<.destroy@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/actors/inspector.js:3896:5 16:35:01 INFO - Toolbox.prototype.destroyInspector/this._destroyingInspector<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/framework/toolbox.js:1834:13 16:35:01 INFO - TaskImpl_run@resource://gre/modules/Task.jsm:314:40 16:35:01 INFO - Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:934:23 16:35:01 INFO - this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 16:35:01 INFO - Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 16:35:01 INFO - this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 16:35:01 INFO - Promise.prototype.then@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:451:5 16:35:01 INFO - TaskImpl_handleResultValue@resource://gre/modules/Task.jsm:388:7 16:35:01 INFO - TaskImpl_run@resource://gre/modules/Task.jsm:322:13 16:35:01 INFO - TaskImpl@resource://gre/modules/Task.jsm:275:3 16:35:01 INFO - createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 16:35:01 INFO - Toolbox.prototype.destroyInspector/this._destroyingInspector<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/framework/toolbox.js:1833:13 16:35:01 INFO - TaskImpl_run@resource://gre/modules/Task.jsm:314:40 16:35:01 INFO - TaskImpl@resource://gre/modules/Task.jsm:275:3 16:35:01 INFO - createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 16:35:01 INFO - Task_spawn@resource://gre/modules/Task.jsm:164:12 16:35:01 INFO - Toolbox.prototype.destroyInspector@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/framework/toolbox.js:1818:40 16:35:01 INFO - Toolbox.prototype.destroy@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/framework/toolbox.js:1944:22 16:35:01 INFO - DT_closeToolbox@resource://devtools/client/framework/gDevTools.jsm:464:12 16:35:01 INFO - @chrome://mochitests/content/browser/devtools/client/markupview/test/head.js:44:9 16:35:01 INFO - TaskImpl_run@resource://gre/modules/Task.jsm:314:40 16:35:01 INFO - TaskImpl@resource://gre/modules/Task.jsm:275:3 16:35:01 INFO - createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 16:35:01 INFO - Task_spawn@resource://gre/modules/Task.jsm:164:12 16:35:01 INFO - TaskImpl_handleResultValue@resource://gre/modules/Task.jsm:381:1 16:35:01 INFO - TaskImpl_run@resource://gre/modules/Task.jsm:322:13 16:35:01 INFO - TaskImpl_handleResultValue@resource://gre/modules/Task.jsm:393:7 16:35:01 INFO - TaskImpl_run@resource://gre/modules/Task.jsm:322:13 16:35:01 INFO - TaskImpl_handleResultValue@resource://gre/modules/Task.jsm:393:7 16:35:01 INFO - TaskImpl_run@resource://gre/modules/Task.jsm:322:13 16:35:01 INFO - TaskImpl_handleResultValue@resource://gre/modules/Task.jsm:393:7 16:35:01 INFO - TaskImpl_run@resource://gre/modules/Task.jsm:322:13 16:35:01 INFO - TaskImpl@resource://gre/modules/Task.jsm:275:3 16:35:01 INFO - createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 16:35:01 INFO - testScope/test_finish/<@chrome://mochikit/content/browser-test.js:1067:11 16:35:01 INFO - testScope/test_executeSoon/<.run@chrome://mochikit/content/browser-test.js:969:9 16:35:01 INFO - console.warn: Could not expand the node, the markup-view was destroyed 16:35:01 INFO - console.warn: Could not expand the node, the markup-view was destroyed 16:35:01 INFO - console.warn: Could not expand the node, the markup-view was destroyed 16:35:01 INFO - console.warn: Could not show the node, the markup-view was destroyed while waiting for children 16:35:01 INFO - console.warn: Could not mark node as selected, the markup-view was destroyed while showing the node. 16:35:01 INFO - MEMORY STAT | vsize 20973097MB | residentFast 833MB 16:35:01 INFO - 3426 INFO TEST-OK | devtools/client/markupview/test/browser_markupview_load_01.js | took 8554ms 16:35:01 INFO - 3427 INFO TEST-START | devtools/client/markupview/test/browser_markupview_mutation_01.js 16:35:01 INFO - 3428 INFO Entering test 16:35:01 INFO - 3429 INFO Adding a new tab with URL: 'http://mochi.test:8888/browser/devtools/client/markupview/test/doc_markup_mutation.html' 16:35:02 INFO - 3430 INFO Loading the helper frame script chrome://devtools/content/shared/frame-script-utils.js 16:35:02 INFO - 3431 INFO Console message: [JavaScript Error: "The character encoding of the HTML document was not declared. The document will render with garbled text in some browser configurations if the document contains characters from outside the US-ASCII range. The character encoding of the page must be declared in the document or in the transfer protocol." {file: "http://mochi.test:8888/browser/devtools/client/markupview/test/doc_markup_mutation.html" line: 0}] 16:35:02 INFO - 3432 INFO URL 'http://mochi.test:8888/browser/devtools/client/markupview/test/doc_markup_mutation.html' loading complete 16:35:02 INFO - 3433 INFO Opening the inspector panel 16:35:03 INFO - 3434 INFO Console message: [JavaScript Warning: "Error in parsing value for 'text-anchor'. Declaration dropped." {file: "resource://devtools/server/actors/highlighters.css" line: 269 column: 15 source: " text-anchor: left;"}] 16:35:06 INFO - 3435 INFO The toolbox is open 16:35:07 INFO - 3436 INFO The inspector panel is active and ready 16:35:07 INFO - 3437 INFO Expanding all markup-view nodes 16:35:08 INFO - 3438 INFO Starting test: Adding an attribute 16:35:08 INFO - 3439 INFO Executing the test markup mutation 16:35:08 INFO - 3440 INFO Getting the node for '#node1' 16:35:08 INFO - 3441 INFO Receieved 1 mutations, expecting at least 1 16:35:08 INFO - 3442 INFO Expanding all markup-view nodes to make sure new nodes are imported 16:35:08 INFO - 3443 INFO Checking the markup-view content 16:35:08 INFO - 3444 INFO Getting the markup-container for node #node1 16:35:08 INFO - 3445 INFO Found markup-container [MarkupContainer for [Front for domnode/server1.conn42.domnode42]] 16:35:08 INFO - 3446 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_01.js | newattr attribute found - 16:35:08 INFO - 3447 INFO Starting test: Removing an attribute 16:35:08 INFO - 3448 INFO Executing the test markup mutation 16:35:08 INFO - 3449 INFO Getting the node for '#node1' 16:35:08 INFO - 3450 INFO Receieved 1 mutations, expecting at least 1 16:35:08 INFO - 3451 INFO Expanding all markup-view nodes to make sure new nodes are imported 16:35:08 INFO - 3452 INFO Checking the markup-view content 16:35:09 INFO - 3453 INFO Getting the markup-container for node #node1 16:35:09 INFO - 3454 INFO Found markup-container [MarkupContainer for [Front for domnode/server1.conn42.domnode42]] 16:35:09 INFO - 3455 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_01.js | newattr attribute removed - 16:35:09 INFO - 3456 INFO Starting test: Re-adding an attribute 16:35:09 INFO - 3457 INFO Executing the test markup mutation 16:35:09 INFO - 3458 INFO Getting the node for '#node1' 16:35:09 INFO - 3459 INFO Receieved 1 mutations, expecting at least 1 16:35:09 INFO - 3460 INFO Expanding all markup-view nodes to make sure new nodes are imported 16:35:09 INFO - 3461 INFO Checking the markup-view content 16:35:09 INFO - 3462 INFO Getting the markup-container for node #node1 16:35:09 INFO - 3463 INFO Found markup-container [MarkupContainer for [Front for domnode/server1.conn42.domnode42]] 16:35:09 INFO - 3464 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_01.js | newattr attribute found - 16:35:09 INFO - 3465 INFO Starting test: Changing an attribute 16:35:09 INFO - 3466 INFO Executing the test markup mutation 16:35:09 INFO - 3467 INFO Getting the node for '#node1' 16:35:09 INFO - 3468 INFO Receieved 1 mutations, expecting at least 1 16:35:09 INFO - 3469 INFO Expanding all markup-view nodes to make sure new nodes are imported 16:35:09 INFO - 3470 INFO Checking the markup-view content 16:35:09 INFO - 3471 INFO Getting the markup-container for node #node1 16:35:09 INFO - 3472 INFO Found markup-container [MarkupContainer for [Front for domnode/server1.conn42.domnode42]] 16:35:09 INFO - 3473 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_01.js | newattr attribute found - 16:35:09 INFO - 3474 INFO Starting test: Adding ::after element 16:35:09 INFO - 3475 INFO Executing the test markup mutation 16:35:09 INFO - 3476 INFO Getting the node for '#node1' 16:35:09 INFO - 3477 INFO Receieved 2 mutations, expecting at least 2 16:35:09 INFO - 3478 INFO Expanding all markup-view nodes to make sure new nodes are imported 16:35:10 INFO - 3479 INFO Checking the markup-view content 16:35:10 INFO - 3480 INFO Getting the markup-container for node #node1 16:35:10 INFO - 3481 INFO Found markup-container [MarkupContainer for [Front for domnode/server1.conn42.domnode42]] 16:35:10 INFO - 3482 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_01.js | Node1 now has 2 children (text child and ::after - 16:35:10 INFO - 3483 INFO Starting test: Removing ::after element 16:35:10 INFO - 3484 INFO Executing the test markup mutation 16:35:10 INFO - 3485 INFO Getting the node for '#node1' 16:35:10 INFO - 3486 INFO Receieved 2 mutations, expecting at least 2 16:35:10 INFO - 3487 INFO Expanding all markup-view nodes to make sure new nodes are imported 16:35:10 INFO - 3488 INFO Checking the markup-view content 16:35:10 INFO - 3489 INFO Getting the markup-container for node #node1 16:35:10 INFO - 3490 INFO Found markup-container [MarkupContainer for [Front for domnode/server1.conn42.domnode42]] 16:35:10 INFO - 3491 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_01.js | Has single text child. - 16:35:10 INFO - 3492 INFO Starting test: Updating the text-content 16:35:10 INFO - 3493 INFO Executing the test markup mutation 16:35:10 INFO - 3494 INFO Getting the node for '#node1' 16:35:11 INFO - 3495 INFO Receieved 1 mutations, expecting at least 1 16:35:11 INFO - 3496 INFO Expanding all markup-view nodes to make sure new nodes are imported 16:35:11 INFO - 3497 INFO Checking the markup-view content 16:35:11 INFO - 3498 INFO Getting the markup-container for node #node1 16:35:11 INFO - 3499 INFO Found markup-container [MarkupContainer for [Front for domnode/server1.conn42.domnode42]] 16:35:11 INFO - 3500 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_01.js | Has single text child. - 16:35:11 INFO - 3501 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_01.js | Can't expand container with singleTextChild. - 16:35:11 INFO - 3502 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_01.js | Can't expand singleTextChild. - 16:35:11 INFO - 3503 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_01.js | Single text child editor updated. - 16:35:11 INFO - 3504 INFO Starting test: Adding a second text child 16:35:11 INFO - 3505 INFO Executing the test markup mutation 16:35:11 INFO - 3506 INFO Getting the node for '#node1' 16:35:11 INFO - 3507 INFO Receieved 1 mutations, expecting at least 1 16:35:11 INFO - 3508 INFO Expanding all markup-view nodes to make sure new nodes are imported 16:35:11 INFO - 3509 INFO Checking the markup-view content 16:35:11 INFO - 3510 INFO Getting the markup-container for node #node1 16:35:11 INFO - 3511 INFO Found markup-container [MarkupContainer for [Front for domnode/server1.conn42.domnode42]] 16:35:11 INFO - 3512 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_01.js | Does not have single text child. - 16:35:11 INFO - 3513 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_01.js | Can expand container with child nodes. - 16:35:11 INFO - 3514 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_01.js | Single text child editor removed. - 16:35:11 INFO - 3515 INFO Starting test: Go from 2 to 1 text child 16:35:11 INFO - 3516 INFO Executing the test markup mutation 16:35:11 INFO - 3517 INFO Getting the node for '#node1' 16:35:12 INFO - 3518 INFO Receieved 1 mutations, expecting at least 1 16:35:12 INFO - 3519 INFO Expanding all markup-view nodes to make sure new nodes are imported 16:35:12 INFO - 3520 INFO Checking the markup-view content 16:35:12 INFO - 3521 INFO Getting the markup-container for node #node1 16:35:12 INFO - 3522 INFO Found markup-container [MarkupContainer for [Front for domnode/server1.conn42.domnode42]] 16:35:12 INFO - 3523 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_01.js | Has single text child. - 16:35:12 INFO - 3524 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_01.js | Can't expand container with singleTextChild. - 16:35:12 INFO - 3525 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_01.js | Can't expand singleTextChild. - 16:35:12 INFO - 3526 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_01.js | newtext - 16:35:12 INFO - 3527 INFO Starting test: Removing an only text child 16:35:12 INFO - 3528 INFO Executing the test markup mutation 16:35:12 INFO - 3529 INFO Getting the node for '#node1' 16:35:12 INFO - 3530 INFO Receieved 1 mutations, expecting at least 1 16:35:12 INFO - 3531 INFO Expanding all markup-view nodes to make sure new nodes are imported 16:35:12 INFO - 3532 INFO Checking the markup-view content 16:35:12 INFO - 3533 INFO Getting the markup-container for node #node1 16:35:12 INFO - 3534 INFO Found markup-container [MarkupContainer for [Front for domnode/server1.conn42.domnode42]] 16:35:12 INFO - 3535 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_01.js | Does not have single text child. - 16:35:12 INFO - 3536 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_01.js | Can't expand empty container. - 16:35:12 INFO - 3537 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_01.js | Single text child editor removed. - 16:35:12 INFO - 3538 INFO Starting test: Go from 0 to 1 text child 16:35:12 INFO - 3539 INFO Executing the test markup mutation 16:35:12 INFO - 3540 INFO Getting the node for '#node1' 16:35:12 INFO - 3541 INFO Receieved 1 mutations, expecting at least 1 16:35:12 INFO - 3542 INFO Expanding all markup-view nodes to make sure new nodes are imported 16:35:12 INFO - 3543 INFO Checking the markup-view content 16:35:12 INFO - 3544 INFO Getting the markup-container for node #node1 16:35:12 INFO - 3545 INFO Found markup-container [MarkupContainer for [Front for domnode/server1.conn42.domnode42]] 16:35:12 INFO - 3546 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_01.js | Has single text child. - 16:35:12 INFO - 3547 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_01.js | Can't expand container with singleTextChild. - 16:35:12 INFO - 3548 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_01.js | Can't expand singleTextChild. - 16:35:12 INFO - 3549 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_01.js | newtext - 16:35:12 INFO - 3550 INFO Starting test: Updating the innerHTML 16:35:12 INFO - 3551 INFO Executing the test markup mutation 16:35:12 INFO - 3552 INFO Getting the node for '#node2' 16:35:12 INFO - 3553 INFO Receieved 1 mutations, expecting at least 1 16:35:12 INFO - 3554 INFO Expanding all markup-view nodes to make sure new nodes are imported 16:35:13 INFO - 3555 INFO Checking the markup-view content 16:35:13 INFO - 3556 INFO Getting the markup-container for node #node2 16:35:13 INFO - 3557 INFO Found markup-container [MarkupContainer for [Front for domnode/server1.conn42.domnode43]] 16:35:13 INFO - 3558 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_01.js | There are 2 tags in node2 - 16:35:13 INFO - 3559 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_01.js | The first tag is a div - 16:35:13 INFO - 3560 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_01.js | The second tag is a span - 16:35:13 INFO - 3561 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_01.js | The span's textcontent is correct - 16:35:13 INFO - 3562 INFO Starting test: Removing child nodes 16:35:13 INFO - 3563 INFO Executing the test markup mutation 16:35:13 INFO - 3564 INFO Getting the node for '#node4' 16:35:13 INFO - 3565 INFO Receieved 17 mutations, expecting at least 1 16:35:13 INFO - 3566 INFO Expanding all markup-view nodes to make sure new nodes are imported 16:35:13 INFO - 3567 INFO Checking the markup-view content 16:35:13 INFO - 3568 INFO Getting the markup-container for node #node4 16:35:13 INFO - 3569 INFO Found markup-container [MarkupContainer for [Front for domnode/server1.conn42.domnode46]] 16:35:13 INFO - 3570 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_01.js | Children have been removed - 16:35:13 INFO - 3571 INFO Starting test: Appending a child to a different parent 16:35:13 INFO - 3572 INFO Executing the test markup mutation 16:35:13 INFO - 3573 INFO Getting the node for '#node17' 16:35:13 INFO - 3574 INFO Getting the node for '#node2' 16:35:14 INFO - 3575 INFO Receieved 2 mutations, expecting at least 1 16:35:14 INFO - 3576 INFO Expanding all markup-view nodes to make sure new nodes are imported 16:35:14 INFO - 3577 INFO Checking the markup-view content 16:35:14 INFO - 3578 INFO Getting the markup-container for node #node16 16:35:14 INFO - 3579 INFO Found markup-container [MarkupContainer for [Front for domnode/server1.conn42.domnode34]] 16:35:14 INFO - 3580 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_01.js | Node17 has been removed from its node16 parent - 16:35:14 INFO - 3581 INFO Getting the markup-container for node #node2 16:35:14 INFO - 3582 INFO Found markup-container [MarkupContainer for [Front for domnode/server1.conn42.domnode43]] 16:35:14 INFO - 3583 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_01.js | There are now 3 tags in node2 - 16:35:14 INFO - 3584 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_01.js | The third tag is node17 - 16:35:14 INFO - 3585 INFO Starting test: Swapping a parent and child element, putting them in the same tree 16:35:14 INFO - 3586 INFO Executing the test markup mutation 16:35:14 INFO - 3587 INFO Getting the node for '#node18' 16:35:14 INFO - 3588 INFO Getting the node for '#node20' 16:35:14 INFO - 3589 INFO Getting the node for '#node1' 16:35:14 INFO - 3590 INFO Receieved 4 mutations, expecting at least 1 16:35:14 INFO - 3591 INFO Expanding all markup-view nodes to make sure new nodes are imported 16:35:14 INFO - 3592 INFO Checking the markup-view content 16:35:15 INFO - 3593 INFO Getting the markup-container for node #node1 16:35:15 INFO - 3594 INFO Found markup-container [MarkupContainer for [Front for domnode/server1.conn42.domnode42]] 16:35:15 INFO - 3595 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_01.js | Node1 now has 2 children (textnode and node20) - 16:35:15 INFO - 3596 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_01.js | Node20 has 2 children (21 and 18) - 16:35:15 INFO - 3597 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_01.js | Node21 has a single text child - 16:35:15 INFO - 3598 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_01.js | Node20's second child is indeed node18 - 16:35:15 INFO - 3599 INFO Leaving test 16:35:15 INFO - MEMORY STAT | vsize 20973093MB | residentFast 810MB 16:35:15 INFO - 3600 INFO TEST-OK | devtools/client/markupview/test/browser_markupview_mutation_01.js | took 13890ms 16:35:16 INFO - 3601 INFO TEST-START | devtools/client/markupview/test/browser_markupview_mutation_02.js 16:35:16 INFO - 3602 INFO Entering test 16:35:16 INFO - 3603 INFO Adding a new tab with URL: 'http://mochi.test:8888/browser/devtools/client/markupview/test/doc_markup_flashing.html' 16:35:16 INFO - 3604 INFO Loading the helper frame script chrome://devtools/content/shared/frame-script-utils.js 16:35:16 INFO - 3605 INFO URL 'http://mochi.test:8888/browser/devtools/client/markupview/test/doc_markup_flashing.html' loading complete 16:35:16 INFO - 3606 INFO Opening the inspector panel 16:35:17 INFO - 3607 INFO Console message: [JavaScript Warning: "Error in parsing value for 'text-anchor'. Declaration dropped." {file: "resource://devtools/server/actors/highlighters.css" line: 269 column: 15 source: " text-anchor: left;"}] 16:35:19 INFO - 3608 INFO The toolbox is open 16:35:20 INFO - 3609 INFO The inspector panel is active and ready 16:35:20 INFO - 3610 INFO Getting the root node to test mutations on 16:35:20 INFO - 3611 INFO Getting the node for '.list' 16:35:20 INFO - 3612 INFO Selecting the last element of the root node before starting 16:35:20 INFO - 3613 INFO Selecting the node for '.list .item:nth-child(2)' 16:35:21 INFO - 3614 INFO Starting test: Adding a new node should flash the new node 16:35:21 INFO - 3615 INFO Mutating the DOM and listening for markupmutation event 16:35:21 INFO - 3616 INFO Asserting that the correct markup-container is flashing 16:35:21 INFO - 3617 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_02.js | Markup container for node found - 16:35:21 INFO - 3618 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_02.js | Markup container for node is flashing - 16:35:21 INFO - 3619 INFO Starting test: Removing a node should flash its parent 16:35:21 INFO - 3620 INFO Mutating the DOM and listening for markupmutation event 16:35:21 INFO - 3621 INFO Asserting that the correct markup-container is flashing 16:35:21 INFO - 3622 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_02.js | Markup container for node found - 16:35:21 INFO - 3623 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_02.js | Markup container for node is flashing - 16:35:21 INFO - 3624 INFO Starting test: Re-appending an existing node should only flash this node 16:35:21 INFO - 3625 INFO Mutating the DOM and listening for markupmutation event 16:35:21 INFO - 3626 INFO Asserting that the correct markup-container is flashing 16:35:21 INFO - 3627 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_02.js | Markup container for node found - 16:35:21 INFO - 3628 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_02.js | Markup container for node is flashing - 16:35:21 INFO - 3629 INFO Starting test: Adding an attribute should flash the attribute 16:35:21 INFO - 3630 INFO Mutating the DOM and listening for markupmutation event 16:35:21 INFO - 3631 INFO Asserting that the correct markup-container is flashing 16:35:21 INFO - 3632 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_02.js | Markup container for node found - 16:35:21 INFO - 3633 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_02.js | Attribute exists on editor - 16:35:21 INFO - 3634 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_02.js | Element for test-name attribute is flashing - 16:35:21 INFO - 3635 INFO Starting test: Editing an attribute should flash the attribute 16:35:21 INFO - 3636 INFO Mutating the DOM and listening for markupmutation event 16:35:21 INFO - 3637 INFO Asserting that the correct markup-container is flashing 16:35:21 INFO - 3638 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_02.js | Markup container for node found - 16:35:21 INFO - 3639 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_02.js | Attribute exists on editor - 16:35:21 INFO - 3640 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_02.js | Element for class attribute is flashing - 16:35:21 INFO - 3641 INFO Starting test: Multiple changes to an attribute should flash the attribute 16:35:21 INFO - 3642 INFO Mutating the DOM and listening for markupmutation event 16:35:22 INFO - 3643 INFO Asserting that the correct markup-container is flashing 16:35:22 INFO - 3644 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_02.js | Markup container for node found - 16:35:22 INFO - 3645 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_02.js | Attribute exists on editor - 16:35:22 INFO - 3646 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_02.js | Element for class attribute is flashing - 16:35:22 INFO - 3647 INFO Starting test: Removing an attribute should flash the node 16:35:22 INFO - 3648 INFO Mutating the DOM and listening for markupmutation event 16:35:22 INFO - 3649 INFO Asserting that the correct markup-container is flashing 16:35:22 INFO - 3650 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_02.js | Markup container for node found - 16:35:22 INFO - 3651 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_mutation_02.js | Markup container for node is flashing - 16:35:22 INFO - 3652 INFO Leaving test 16:35:22 INFO - console.error: 16:35:22 INFO - Message: Error: Connection closed, pending request to server1.conn43.domwalker28, type children failed 16:35:22 INFO - Request stack: 16:35:22 INFO - Front<.request@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:1178:7 16:35:22 INFO - frontProto/ resource://devtools/server/protocol.js:1338:14 16:35:22 INFO - HTMLBreadcrumbs.prototype.getInterestingFirstNode/moreChildren@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/inspector/breadcrumbs.js:560:7 16:35:22 INFO - HTMLBreadcrumbs.prototype.getInterestingFirstNode@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/inspector/breadcrumbs.js:583:5 16:35:22 INFO - HTMLBreadcrumbs.prototype.ensureFirstChild@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/inspector/breadcrumbs.js:612:14 16:35:22 INFO - HTMLBreadcrumbs.prototype.update@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/inspector/breadcrumbs.js:765:5 16:35:22 INFO - EventEmitter_emit@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/shared/event-emitter.js:147:11 16:35:22 INFO - MarkupView.prototype._mutationObserver/<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/markupview/markup-view.js:872:7 16:35:22 INFO - Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:934:23 16:35:22 INFO - this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 16:35:22 INFO - Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 16:35:22 INFO - this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 16:35:22 INFO - this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 16:35:22 INFO - Front<.onPacket/<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:1236:9 16:35:22 INFO - DevTools RDP*Front<.request@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:1178:7 16:35:22 INFO - frontProto/ resource://devtools/server/protocol.js:1338:14 16:35:22 INFO - exports.WalkerFront<.getMutations<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/actors/inspector.js:3464:12 16:35:22 INFO - exports.WalkerFront<.onMutations<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/actors/inspector.js:3594:5 16:35:22 INFO - Front<.onPacket/results<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:1201:44 16:35:22 INFO - Front<.onPacket@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:1201:23 16:35:22 INFO - DebuggerClient.prototype.onPacket@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/shared/client/main.js:930:7 16:35:22 INFO - LocalDebuggerTransport.prototype.send/<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/shared/transport/transport.js:569:11 16:35:22 INFO - makeInfallible/<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/shared/DevToolsUtils.js:87:14 16:35:22 INFO - makeInfallible/<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/shared/DevToolsUtils.js:87:14 16:35:22 INFO - Stack: 16:35:22 INFO - Front<.destroy@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:1125:23 16:35:22 INFO - exports.WalkerFront<.destroy@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/actors/inspector.js:3229:5 16:35:22 INFO - Pool<.destroy@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:820:9 16:35:22 INFO - Front<.destroy@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:1127:5 16:35:22 INFO - exports.InspectorFront<.destroy@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/actors/inspector.js:3896:5 16:35:22 INFO - Toolbox.prototype.destroyInspector/this._destroyingInspector<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/framework/toolbox.js:1834:13 16:35:22 INFO - TaskImpl_run@resource://gre/modules/Task.jsm:314:40 16:35:22 INFO - Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:934:23 16:35:22 INFO - this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 16:35:22 INFO - Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 16:35:22 INFO - this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 16:35:22 INFO - Promise.prototype.then@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:451:5 16:35:22 INFO - TaskImpl_handleResultValue@resource://gre/modules/Task.jsm:388:7 16:35:22 INFO - TaskImpl_run@resource://gre/modules/Task.jsm:322:13 16:35:22 INFO - TaskImpl@resource://gre/modules/Task.jsm:275:3 16:35:22 INFO - createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 16:35:22 INFO - Toolbox.prototype.destroyInspector/this._destroyingInspector<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/framework/toolbox.js:1833:13 16:35:22 INFO - TaskImpl_run@resource://gre/modules/Task.jsm:314:40 16:35:22 INFO - TaskImpl@resource://gre/modules/Task.jsm:275:3 16:35:22 INFO - createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 16:35:22 INFO - Task_spawn@resource://gre/modules/Task.jsm:164:12 16:35:22 INFO - Toolbox.prototype.destroyInspector@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/framework/toolbox.js:1818:40 16:35:22 INFO - Toolbox.prototype.destroy@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/framework/toolbox.js:1944:22 16:35:22 INFO - DT_closeToolbox@resource://devtools/client/framework/gDevTools.jsm:464:12 16:35:22 INFO - @chrome://mochitests/content/browser/devtools/client/markupview/test/head.js:44:9 16:35:22 INFO - TaskImpl_run@resource://gre/modules/Task.jsm:314:40 16:35:22 INFO - TaskImpl@resource://gre/modules/Task.jsm:275:3 16:35:22 INFO - createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 16:35:22 INFO - Task_spawn@resource://gre/modules/Task.jsm:164:12 16:35:22 INFO - TaskImpl_handleResultValue@resource://gre/modules/Task.jsm:381:1 16:35:22 INFO - TaskImpl_run@resource://gre/modules/Task.jsm:322:13 16:35:22 INFO - TaskImpl_handleResultValue@resource://gre/modules/Task.jsm:393:7 16:35:22 INFO - TaskImpl_run@resource://gre/modules/Task.jsm:322:13 16:35:22 INFO - TaskImpl_handleResultValue@resource://gre/modules/Task.jsm:393:7 16:35:22 INFO - TaskImpl_run@resource://gre/modules/Task.jsm:322:13 16:35:22 INFO - TaskImpl_handleResultValue@resource://gre/modules/Task.jsm:393:7 16:35:22 INFO - TaskImpl_run@resource://gre/modules/Task.jsm:322:13 16:35:22 INFO - TaskImpl@resource://gre/modules/Task.jsm:275:3 16:35:22 INFO - createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 16:35:22 INFO - testScope/test_finish/<@chrome://mochikit/content/browser-test.js:1067:11 16:35:22 INFO - testScope/test_executeSoon/<.run@chrome://mochikit/content/browser-test.js:969:9 16:35:22 INFO - MEMORY STAT | vsize 20973083MB | residentFast 805MB 16:35:22 INFO - 3653 INFO TEST-OK | devtools/client/markupview/test/browser_markupview_mutation_02.js | took 6633ms 16:35:22 INFO - 3654 INFO TEST-START | devtools/client/markupview/test/browser_markupview_navigation.js 16:35:23 INFO - 3655 INFO Entering test 16:35:23 INFO - 3656 INFO Adding a new tab with URL: 'http://mochi.test:8888/browser/devtools/client/markupview/test/doc_markup_navigation.html' 16:35:23 INFO - 3657 INFO Loading the helper frame script chrome://devtools/content/shared/frame-script-utils.js 16:35:23 INFO - 3658 INFO URL 'http://mochi.test:8888/browser/devtools/client/markupview/test/doc_markup_navigation.html' loading complete 16:35:23 INFO - 3659 INFO Opening the inspector panel 16:35:24 INFO - 3660 INFO Console message: [JavaScript Warning: "Error in parsing value for 'text-anchor'. Declaration dropped." {file: "resource://devtools/server/actors/highlighters.css" line: 269 column: 15 source: " text-anchor: left;"}] 16:35:26 INFO - 3661 INFO The toolbox is open 16:35:27 INFO - 3662 INFO The inspector panel is active and ready 16:35:27 INFO - 3663 INFO Making sure the markup-view frame is focused 16:35:27 INFO - 3664 INFO Starting to iterate through the test data 16:35:27 INFO - 3665 INFO Testing step: pageup to navigate to *doctype* 16:35:27 INFO - 3666 INFO Making sure markup-view children get updated 16:35:27 INFO - 3667 INFO Waiting for queued children updates to be handled 16:35:27 INFO - 3668 INFO Console message: [JavaScript Warning: "Key event not available on some keyboard layouts: key="r" modifiers="accel alt"" {file: "chrome://mochikit/content/tests/SimpleTest/EventUtils.js" line: 693}] 16:35:27 INFO - 3669 INFO Console message: [JavaScript Warning: "Key event not available on GTK2: key="u" modifiers="shift, accel"" {file: "chrome://mochikit/content/tests/SimpleTest/EventUtils.js" line: 693}] 16:35:27 INFO - 3670 INFO Checking the right node is selected 16:35:27 INFO - 3671 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found the doctype after pressing pageup - 16:35:27 INFO - 3672 INFO Testing step: down to navigate to html 16:35:27 INFO - 3673 INFO Making sure markup-view children get updated 16:35:27 INFO - 3674 INFO Waiting for queued children updates to be handled 16:35:27 INFO - 3675 INFO Checking the right node is selected 16:35:27 INFO - 3676 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found node: html after pressing down - 16:35:27 INFO - 3677 INFO Testing step: down to navigate to head 16:35:27 INFO - 3678 INFO Making sure markup-view children get updated 16:35:27 INFO - 3679 INFO Waiting for queued children updates to be handled 16:35:27 INFO - console.warn: Asynchronous operation was aborted as selection changed. 16:35:27 INFO - 3680 INFO Checking the right node is selected 16:35:27 INFO - 3681 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found node: head after pressing down - 16:35:27 INFO - 3682 INFO Testing step: down to navigate to body 16:35:27 INFO - 3683 INFO Making sure markup-view children get updated 16:35:27 INFO - 3684 INFO Waiting for queued children updates to be handled 16:35:28 INFO - console.warn: Asynchronous operation was aborted as selection changed. 16:35:28 INFO - 3685 INFO Checking the right node is selected 16:35:28 INFO - 3686 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found node: body after pressing down - 16:35:28 INFO - 3687 INFO Testing step: down to navigate to node0 16:35:28 INFO - 3688 INFO Making sure markup-view children get updated 16:35:28 INFO - 3689 INFO Waiting for queued children updates to be handled 16:35:28 INFO - console.warn: Asynchronous operation was aborted as selection changed. 16:35:28 INFO - 3690 INFO Checking the right node is selected 16:35:28 INFO - 3691 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found node: node0 after pressing down - 16:35:28 INFO - 3692 INFO Testing step: right to navigate to node0 16:35:28 INFO - 3693 INFO Making sure markup-view children get updated 16:35:28 INFO - 3694 INFO Waiting for queued children updates to be handled 16:35:28 INFO - 3695 INFO Checking the right node is selected 16:35:28 INFO - 3696 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found node: node0 after pressing right - 16:35:28 INFO - 3697 INFO Testing step: down to navigate to node1 16:35:28 INFO - 3698 INFO Making sure markup-view children get updated 16:35:28 INFO - 3699 INFO Waiting for queued children updates to be handled 16:35:28 INFO - 3700 INFO Checking the right node is selected 16:35:28 INFO - 3701 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found node: node1 after pressing down - 16:35:28 INFO - 3702 INFO Testing step: down to navigate to node2 16:35:29 INFO - 3703 INFO Making sure markup-view children get updated 16:35:29 INFO - 3704 INFO Waiting for queued children updates to be handled 16:35:29 INFO - console.warn: Asynchronous operation was aborted as selection changed. 16:35:29 INFO - 3705 INFO Checking the right node is selected 16:35:29 INFO - 3706 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found node: node2 after pressing down - 16:35:29 INFO - 3707 INFO Testing step: down to navigate to node3 16:35:29 INFO - 3708 INFO Making sure markup-view children get updated 16:35:29 INFO - 3709 INFO Waiting for queued children updates to be handled 16:35:29 INFO - console.warn: Asynchronous operation was aborted as selection changed. 16:35:29 INFO - 3710 INFO Checking the right node is selected 16:35:29 INFO - 3711 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found node: node3 after pressing down - 16:35:29 INFO - 3712 INFO Testing step: down to navigate to *comment* 16:35:29 INFO - 3713 INFO Making sure markup-view children get updated 16:35:29 INFO - 3714 INFO Waiting for queued children updates to be handled 16:35:29 INFO - console.warn: Asynchronous operation was aborted as selection changed. 16:35:29 INFO - 3715 INFO Checking the right node is selected 16:35:29 INFO - 3716 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found a comment after pressing down - 16:35:29 INFO - 3717 INFO Testing step: down to navigate to node4 16:35:29 INFO - 3718 INFO Making sure markup-view children get updated 16:35:29 INFO - 3719 INFO Waiting for queued children updates to be handled 16:35:29 INFO - 3720 INFO Checking the right node is selected 16:35:29 INFO - 3721 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found node: node4 after pressing down - 16:35:29 INFO - 3722 INFO Testing step: right to navigate to node4 16:35:29 INFO - 3723 INFO Making sure markup-view children get updated 16:35:29 INFO - 3724 INFO Waiting for queued children updates to be handled 16:35:30 INFO - 3725 INFO Checking the right node is selected 16:35:30 INFO - 3726 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found node: node4 after pressing right - 16:35:30 INFO - 3727 INFO Testing step: down to navigate to *text* 16:35:30 INFO - 3728 INFO Making sure markup-view children get updated 16:35:30 INFO - 3729 INFO Waiting for queued children updates to be handled 16:35:30 INFO - 3730 INFO Checking the right node is selected 16:35:30 INFO - 3731 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found text after pressing down - 16:35:30 INFO - 3732 INFO Testing step: down to navigate to node5 16:35:30 INFO - 3733 INFO Making sure markup-view children get updated 16:35:30 INFO - 3734 INFO Waiting for queued children updates to be handled 16:35:30 INFO - 3735 INFO Checking the right node is selected 16:35:30 INFO - 3736 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found node: node5 after pressing down - 16:35:30 INFO - 3737 INFO Testing step: down to navigate to node6 16:35:30 INFO - 3738 INFO Making sure markup-view children get updated 16:35:30 INFO - 3739 INFO Waiting for queued children updates to be handled 16:35:30 INFO - console.warn: Asynchronous operation was aborted as selection changed. 16:35:31 INFO - 3740 INFO Checking the right node is selected 16:35:31 INFO - 3741 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found node: node6 after pressing down - 16:35:31 INFO - 3742 INFO Testing step: down to navigate to *comment* 16:35:31 INFO - 3743 INFO Making sure markup-view children get updated 16:35:31 INFO - 3744 INFO Waiting for queued children updates to be handled 16:35:31 INFO - console.warn: Asynchronous operation was aborted as selection changed. 16:35:31 INFO - 3745 INFO Checking the right node is selected 16:35:31 INFO - 3746 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found a comment after pressing down - 16:35:31 INFO - 3747 INFO Testing step: down to navigate to node7 16:35:31 INFO - 3748 INFO Making sure markup-view children get updated 16:35:31 INFO - 3749 INFO Waiting for queued children updates to be handled 16:35:31 INFO - 3750 INFO Checking the right node is selected 16:35:31 INFO - 3751 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found node: node7 after pressing down - 16:35:31 INFO - 3752 INFO Testing step: right to navigate to node7 16:35:31 INFO - 3753 INFO Making sure markup-view children get updated 16:35:31 INFO - 3754 INFO Waiting for queued children updates to be handled 16:35:31 INFO - 3755 INFO Checking the right node is selected 16:35:31 INFO - 3756 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found node: node7 after pressing right - 16:35:31 INFO - 3757 INFO Testing step: down to navigate to *text* 16:35:31 INFO - 3758 INFO Making sure markup-view children get updated 16:35:31 INFO - 3759 INFO Waiting for queued children updates to be handled 16:35:31 INFO - 3760 INFO Checking the right node is selected 16:35:31 INFO - 3761 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found text after pressing down - 16:35:31 INFO - 3762 INFO Testing step: down to navigate to node8 16:35:31 INFO - 3763 INFO Making sure markup-view children get updated 16:35:31 INFO - 3764 INFO Waiting for queued children updates to be handled 16:35:31 INFO - 3765 INFO Checking the right node is selected 16:35:31 INFO - 3766 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found node: node8 after pressing down - 16:35:31 INFO - 3767 INFO Testing step: left to navigate to node7 16:35:31 INFO - 3768 INFO Making sure markup-view children get updated 16:35:31 INFO - 3769 INFO Waiting for queued children updates to be handled 16:35:32 INFO - console.warn: Asynchronous operation was aborted as selection changed. 16:35:32 INFO - 3770 INFO Checking the right node is selected 16:35:32 INFO - 3771 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found node: node7 after pressing left - 16:35:32 INFO - 3772 INFO Testing step: left to navigate to node7 16:35:32 INFO - 3773 INFO Making sure markup-view children get updated 16:35:32 INFO - 3774 INFO Waiting for queued children updates to be handled 16:35:32 INFO - 3775 INFO Checking the right node is selected 16:35:32 INFO - 3776 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found node: node7 after pressing left - 16:35:32 INFO - 3777 INFO Testing step: right to navigate to node7 16:35:32 INFO - 3778 INFO Making sure markup-view children get updated 16:35:32 INFO - 3779 INFO Waiting for queued children updates to be handled 16:35:32 INFO - 3780 INFO Checking the right node is selected 16:35:32 INFO - 3781 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found node: node7 after pressing right - 16:35:32 INFO - 3782 INFO Testing step: right to navigate to *text* 16:35:32 INFO - 3783 INFO Making sure markup-view children get updated 16:35:32 INFO - 3784 INFO Waiting for queued children updates to be handled 16:35:32 INFO - 3785 INFO Checking the right node is selected 16:35:32 INFO - 3786 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found text after pressing right - 16:35:32 INFO - 3787 INFO Testing step: down to navigate to node8 16:35:32 INFO - 3788 INFO Making sure markup-view children get updated 16:35:32 INFO - 3789 INFO Waiting for queued children updates to be handled 16:35:32 INFO - 3790 INFO Checking the right node is selected 16:35:32 INFO - 3791 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found node: node8 after pressing down - 16:35:32 INFO - 3792 INFO Testing step: down to navigate to node9 16:35:32 INFO - 3793 INFO Making sure markup-view children get updated 16:35:32 INFO - 3794 INFO Waiting for queued children updates to be handled 16:35:32 INFO - console.warn: Asynchronous operation was aborted as selection changed. 16:35:32 INFO - 3795 INFO Checking the right node is selected 16:35:32 INFO - 3796 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found node: node9 after pressing down - 16:35:32 INFO - 3797 INFO Testing step: down to navigate to node10 16:35:32 INFO - 3798 INFO Making sure markup-view children get updated 16:35:32 INFO - 3799 INFO Waiting for queued children updates to be handled 16:35:32 INFO - console.warn: Asynchronous operation was aborted as selection changed. 16:35:32 INFO - 3800 INFO Checking the right node is selected 16:35:32 INFO - 3801 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found node: node10 after pressing down - 16:35:32 INFO - 3802 INFO Testing step: down to navigate to node11 16:35:32 INFO - 3803 INFO Making sure markup-view children get updated 16:35:33 INFO - 3804 INFO Waiting for queued children updates to be handled 16:35:33 INFO - console.warn: Asynchronous operation was aborted as selection changed. 16:35:33 INFO - 3805 INFO Checking the right node is selected 16:35:33 INFO - 3806 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found node: node11 after pressing down - 16:35:33 INFO - 3807 INFO Testing step: down to navigate to node12 16:35:33 INFO - 3808 INFO Making sure markup-view children get updated 16:35:33 INFO - 3809 INFO Waiting for queued children updates to be handled 16:35:33 INFO - console.warn: Asynchronous operation was aborted as selection changed. 16:35:33 INFO - 3810 INFO Checking the right node is selected 16:35:33 INFO - 3811 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found node: node12 after pressing down - 16:35:33 INFO - 3812 INFO Testing step: right to navigate to node12 16:35:33 INFO - 3813 INFO Making sure markup-view children get updated 16:35:33 INFO - 3814 INFO Waiting for queued children updates to be handled 16:35:33 INFO - 3815 INFO Checking the right node is selected 16:35:33 INFO - 3816 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found node: node12 after pressing right - 16:35:33 INFO - 3817 INFO Testing step: down to navigate to *text* 16:35:33 INFO - 3818 INFO Making sure markup-view children get updated 16:35:33 INFO - 3819 INFO Waiting for queued children updates to be handled 16:35:33 INFO - 3820 INFO Checking the right node is selected 16:35:33 INFO - 3821 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found text after pressing down - 16:35:33 INFO - 3822 INFO Testing step: down to navigate to node13 16:35:33 INFO - 3823 INFO Making sure markup-view children get updated 16:35:33 INFO - 3824 INFO Waiting for queued children updates to be handled 16:35:33 INFO - 3825 INFO Checking the right node is selected 16:35:33 INFO - 3826 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found node: node13 after pressing down - 16:35:33 INFO - 3827 INFO Testing step: down to navigate to node14 16:35:33 INFO - 3828 INFO Making sure markup-view children get updated 16:35:33 INFO - 3829 INFO Waiting for queued children updates to be handled 16:35:33 INFO - console.warn: Asynchronous operation was aborted as selection changed. 16:35:34 INFO - 3830 INFO Checking the right node is selected 16:35:34 INFO - 3831 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found node: node14 after pressing down - 16:35:34 INFO - 3832 INFO Testing step: down to navigate to node15 16:35:34 INFO - 3833 INFO Making sure markup-view children get updated 16:35:34 INFO - 3834 INFO Waiting for queued children updates to be handled 16:35:34 INFO - console.warn: Asynchronous operation was aborted as selection changed. 16:35:34 INFO - 3835 INFO Checking the right node is selected 16:35:34 INFO - 3836 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found node: node15 after pressing down - 16:35:34 INFO - 3837 INFO Testing step: down to navigate to node15 16:35:34 INFO - 3838 INFO Making sure markup-view children get updated 16:35:34 INFO - 3839 INFO Waiting for queued children updates to be handled 16:35:34 INFO - 3840 INFO Checking the right node is selected 16:35:34 INFO - 3841 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found node: node15 after pressing down - 16:35:34 INFO - 3842 INFO Testing step: down to navigate to node15 16:35:34 INFO - 3843 INFO Making sure markup-view children get updated 16:35:34 INFO - 3844 INFO Waiting for queued children updates to be handled 16:35:34 INFO - 3845 INFO Checking the right node is selected 16:35:34 INFO - 3846 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found node: node15 after pressing down - 16:35:34 INFO - 3847 INFO Testing step: up to navigate to node14 16:35:34 INFO - 3848 INFO Making sure markup-view children get updated 16:35:34 INFO - 3849 INFO Waiting for queued children updates to be handled 16:35:34 INFO - 3850 INFO Checking the right node is selected 16:35:34 INFO - 3851 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found node: node14 after pressing up - 16:35:34 INFO - 3852 INFO Testing step: up to navigate to node13 16:35:34 INFO - 3853 INFO Making sure markup-view children get updated 16:35:34 INFO - 3854 INFO Waiting for queued children updates to be handled 16:35:34 INFO - console.warn: Asynchronous operation was aborted as selection changed. 16:35:34 INFO - 3855 INFO Checking the right node is selected 16:35:34 INFO - 3856 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found node: node13 after pressing up - 16:35:34 INFO - 3857 INFO Testing step: up to navigate to *text* 16:35:34 INFO - 3858 INFO Making sure markup-view children get updated 16:35:34 INFO - 3859 INFO Waiting for queued children updates to be handled 16:35:34 INFO - console.warn: Asynchronous operation was aborted as selection changed. 16:35:34 INFO - 3860 INFO Checking the right node is selected 16:35:34 INFO - 3861 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found text after pressing up - 16:35:34 INFO - 3862 INFO Testing step: up to navigate to node12 16:35:34 INFO - 3863 INFO Making sure markup-view children get updated 16:35:34 INFO - 3864 INFO Waiting for queued children updates to be handled 16:35:35 INFO - 3865 INFO Checking the right node is selected 16:35:35 INFO - 3866 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found node: node12 after pressing up - 16:35:35 INFO - 3867 INFO Testing step: left to navigate to node12 16:35:35 INFO - 3868 INFO Making sure markup-view children get updated 16:35:35 INFO - 3869 INFO Waiting for queued children updates to be handled 16:35:35 INFO - 3870 INFO Checking the right node is selected 16:35:35 INFO - 3871 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found node: node12 after pressing left - 16:35:35 INFO - 3872 INFO Testing step: down to navigate to node14 16:35:35 INFO - 3873 INFO Making sure markup-view children get updated 16:35:35 INFO - 3874 INFO Waiting for queued children updates to be handled 16:35:35 INFO - 3875 INFO Checking the right node is selected 16:35:35 INFO - 3876 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found node: node14 after pressing down - 16:35:35 INFO - 3877 INFO Testing step: home to navigate to *doctype* 16:35:35 INFO - 3878 INFO Making sure markup-view children get updated 16:35:35 INFO - 3879 INFO Waiting for queued children updates to be handled 16:35:35 INFO - console.warn: Asynchronous operation was aborted as selection changed. 16:35:35 INFO - 3880 INFO Checking the right node is selected 16:35:35 INFO - 3881 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found the doctype after pressing home - 16:35:35 INFO - 3882 INFO Testing step: pagedown to navigate to *text* 16:35:35 INFO - 3883 INFO Making sure markup-view children get updated 16:35:35 INFO - 3884 INFO Waiting for queued children updates to be handled 16:35:35 INFO - 3885 INFO Checking the right node is selected 16:35:35 INFO - 3886 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found text after pressing pagedown - 16:35:35 INFO - 3887 INFO Testing step: down to navigate to node5 16:35:35 INFO - 3888 INFO Making sure markup-view children get updated 16:35:35 INFO - 3889 INFO Waiting for queued children updates to be handled 16:35:35 INFO - 3890 INFO Checking the right node is selected 16:35:35 INFO - 3891 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found node: node5 after pressing down - 16:35:35 INFO - 3892 INFO Testing step: down to navigate to node6 16:35:35 INFO - 3893 INFO Making sure markup-view children get updated 16:35:35 INFO - 3894 INFO Waiting for queued children updates to be handled 16:35:35 INFO - console.warn: Asynchronous operation was aborted as selection changed. 16:35:35 INFO - 3895 INFO Checking the right node is selected 16:35:35 INFO - 3896 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found node: node6 after pressing down - 16:35:35 INFO - 3897 INFO Testing step: down to navigate to *comment* 16:35:35 INFO - 3898 INFO Making sure markup-view children get updated 16:35:35 INFO - 3899 INFO Waiting for queued children updates to be handled 16:35:36 INFO - console.warn: Asynchronous operation was aborted as selection changed. 16:35:36 INFO - 3900 INFO Checking the right node is selected 16:35:36 INFO - 3901 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found a comment after pressing down - 16:35:36 INFO - 3902 INFO Testing step: down to navigate to node7 16:35:36 INFO - 3903 INFO Making sure markup-view children get updated 16:35:36 INFO - 3904 INFO Waiting for queued children updates to be handled 16:35:36 INFO - 3905 INFO Checking the right node is selected 16:35:36 INFO - 3906 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found node: node7 after pressing down - 16:35:36 INFO - 3907 INFO Testing step: left to navigate to node7 16:35:36 INFO - 3908 INFO Making sure markup-view children get updated 16:35:36 INFO - 3909 INFO Waiting for queued children updates to be handled 16:35:36 INFO - 3910 INFO Checking the right node is selected 16:35:36 INFO - 3911 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found node: node7 after pressing left - 16:35:36 INFO - 3912 INFO Testing step: down to navigate to node9 16:35:36 INFO - 3913 INFO Making sure markup-view children get updated 16:35:36 INFO - 3914 INFO Waiting for queued children updates to be handled 16:35:36 INFO - 3915 INFO Checking the right node is selected 16:35:36 INFO - 3916 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found node: node9 after pressing down - 16:35:36 INFO - 3917 INFO Testing step: down to navigate to node10 16:35:36 INFO - 3918 INFO Making sure markup-view children get updated 16:35:36 INFO - 3919 INFO Waiting for queued children updates to be handled 16:35:36 INFO - console.warn: Asynchronous operation was aborted as selection changed. 16:35:36 INFO - 3920 INFO Checking the right node is selected 16:35:36 INFO - 3921 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found node: node10 after pressing down - 16:35:36 INFO - 3922 INFO Testing step: pageup to navigate to node2 16:35:36 INFO - 3923 INFO Making sure markup-view children get updated 16:35:36 INFO - 3924 INFO Waiting for queued children updates to be handled 16:35:36 INFO - console.warn: Asynchronous operation was aborted as selection changed. 16:35:36 INFO - 3925 INFO Checking the right node is selected 16:35:36 INFO - 3926 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found node: node2 after pressing pageup - 16:35:36 INFO - 3927 INFO Testing step: pageup to navigate to *doctype* 16:35:36 INFO - 3928 INFO Making sure markup-view children get updated 16:35:36 INFO - 3929 INFO Waiting for queued children updates to be handled 16:35:37 INFO - console.warn: Asynchronous operation was aborted as selection changed. 16:35:37 INFO - 3930 INFO Checking the right node is selected 16:35:37 INFO - 3931 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found the doctype after pressing pageup - 16:35:37 INFO - 3932 INFO Testing step: down to navigate to html 16:35:37 INFO - 3933 INFO Making sure markup-view children get updated 16:35:37 INFO - 3934 INFO Waiting for queued children updates to be handled 16:35:37 INFO - 3935 INFO Checking the right node is selected 16:35:37 INFO - 3936 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found node: html after pressing down - 16:35:37 INFO - 3937 INFO Testing step: left to navigate to html 16:35:37 INFO - 3938 INFO Making sure markup-view children get updated 16:35:37 INFO - 3939 INFO Waiting for queued children updates to be handled 16:35:37 INFO - 3940 INFO Checking the right node is selected 16:35:37 INFO - 3941 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found node: html after pressing left - 16:35:37 INFO - 3942 INFO Testing step: down to navigate to head 16:35:37 INFO - 3943 INFO Making sure markup-view children get updated 16:35:37 INFO - 3944 INFO Waiting for queued children updates to be handled 16:35:37 INFO - 3945 INFO Checking the right node is selected 16:35:37 INFO - 3946 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_navigation.js | Found node: head after pressing down - 16:35:37 INFO - 3947 INFO Leaving test 16:35:37 INFO - MEMORY STAT | vsize 20973095MB | residentFast 825MB 16:35:37 INFO - 3948 INFO TEST-OK | devtools/client/markupview/test/browser_markupview_navigation.js | took 15013ms 16:35:38 INFO - 3949 INFO TEST-START | devtools/client/markupview/test/browser_markupview_node_not_displayed_01.js 16:35:38 INFO - 3950 INFO Entering test 16:35:38 INFO - 3951 INFO Adding a new tab with URL: 'http://mochi.test:8888/browser/devtools/client/markupview/test/doc_markup_not_displayed.html' 16:35:38 INFO - 3952 INFO Loading the helper frame script chrome://devtools/content/shared/frame-script-utils.js 16:35:38 INFO - 3953 INFO Console message: [JavaScript Error: "The character encoding of the HTML document was not declared. The document will render with garbled text in some browser configurations if the document contains characters from outside the US-ASCII range. The character encoding of the page must be declared in the document or in the transfer protocol." {file: "http://mochi.test:8888/browser/devtools/client/markupview/test/doc_markup_not_displayed.html" line: 0}] 16:35:38 INFO - 3954 INFO URL 'http://mochi.test:8888/browser/devtools/client/markupview/test/doc_markup_not_displayed.html' loading complete 16:35:38 INFO - 3955 INFO Opening the inspector panel 16:35:39 INFO - 3956 INFO Console message: [JavaScript Warning: "Error in parsing value for 'text-anchor'. Declaration dropped." {file: "resource://devtools/server/actors/highlighters.css" line: 269 column: 15 source: " text-anchor: left;"}] 16:35:41 INFO - 3957 INFO The toolbox is open 16:35:42 INFO - 3958 INFO The inspector panel is active and ready 16:35:42 INFO - 3959 INFO Getting node #normal-div 16:35:42 INFO - 3960 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_node_not_displayed_01.js | The container for #normal-div is marked as displayed true - 16:35:42 INFO - 3961 INFO Getting node head 16:35:42 INFO - 3962 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_node_not_displayed_01.js | The container for head is marked as displayed false - 16:35:42 INFO - 3963 INFO Getting node #display-none 16:35:42 INFO - 3964 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_node_not_displayed_01.js | The container for #display-none is marked as displayed false - 16:35:42 INFO - 3965 INFO Getting node #hidden-true 16:35:42 INFO - 3966 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_node_not_displayed_01.js | The container for #hidden-true is marked as displayed false - 16:35:42 INFO - 3967 INFO Getting node #visibility-hidden 16:35:42 INFO - 3968 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_node_not_displayed_01.js | The container for #visibility-hidden is marked as displayed true - 16:35:42 INFO - 3969 INFO Leaving test 16:35:42 INFO - MEMORY STAT | vsize 20973098MB | residentFast 838MB 16:35:42 INFO - 3970 INFO TEST-OK | devtools/client/markupview/test/browser_markupview_node_not_displayed_01.js | took 4442ms 16:35:43 INFO - 3971 INFO TEST-START | devtools/client/markupview/test/browser_markupview_node_not_displayed_02.js 16:35:43 INFO - 3972 INFO Entering test 16:35:43 INFO - 3973 INFO Adding a new tab with URL: 'http://mochi.test:8888/browser/devtools/client/markupview/test/doc_markup_not_displayed.html' 16:35:43 INFO - 3974 INFO Loading the helper frame script chrome://devtools/content/shared/frame-script-utils.js 16:35:43 INFO - 3975 INFO Console message: [JavaScript Error: "The character encoding of the HTML document was not declared. The document will render with garbled text in some browser configurations if the document contains characters from outside the US-ASCII range. The character encoding of the page must be declared in the document or in the transfer protocol." {file: "http://mochi.test:8888/browser/devtools/client/markupview/test/doc_markup_not_displayed.html" line: 0}] 16:35:43 INFO - 3976 INFO URL 'http://mochi.test:8888/browser/devtools/client/markupview/test/doc_markup_not_displayed.html' loading complete 16:35:43 INFO - 3977 INFO Opening the inspector panel 16:35:44 INFO - 3978 INFO Console message: [JavaScript Warning: "Error in parsing value for 'text-anchor'. Declaration dropped." {file: "resource://devtools/server/actors/highlighters.css" line: 269 column: 15 source: " text-anchor: left;"}] 16:35:46 INFO - 3979 INFO The toolbox is open 16:35:47 INFO - 3980 INFO The inspector panel is active and ready 16:35:47 INFO - 3981 INFO Running test case: Hiding a node by creating a new stylesheet 16:35:47 INFO - 3982 INFO Getting the #normal-div test node 16:35:47 INFO - 3983 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_node_not_displayed_02.js | The container is marked as shown - 16:35:47 INFO - 3984 INFO Listening for the display-change event 16:35:47 INFO - 3985 INFO Making style changes 16:35:47 INFO - 3986 INFO Getting the node for '#normal-div' 16:35:48 INFO - 3987 INFO Verifying that the list of changed nodes include our container 16:35:48 INFO - 3988 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_node_not_displayed_02.js | The display-change event was received with a nodes - 16:35:48 INFO - 3989 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_node_not_displayed_02.js | Container is part of the list of changed nodes - 16:35:48 INFO - 3990 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_node_not_displayed_02.js | The container is marked as hidden - 16:35:48 INFO - 3991 INFO Running test case: Showing a node by deleting an existing stylesheet 16:35:48 INFO - 3992 INFO Getting the #normal-div test node 16:35:48 INFO - 3993 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_node_not_displayed_02.js | The container is marked as hidden - 16:35:48 INFO - 3994 INFO Listening for the display-change event 16:35:48 INFO - 3995 INFO Making style changes 16:35:48 INFO - 3996 INFO Getting the node for '#normal-div' 16:35:48 INFO - 3997 INFO Verifying that the list of changed nodes include our container 16:35:48 INFO - 3998 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_node_not_displayed_02.js | The display-change event was received with a nodes - 16:35:48 INFO - 3999 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_node_not_displayed_02.js | Container is part of the list of changed nodes - 16:35:48 INFO - 4000 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_node_not_displayed_02.js | The container is marked as shown - 16:35:48 INFO - 4001 INFO Running test case: Hiding a node by changing its style property 16:35:48 INFO - 4002 INFO Getting the #display-none test node 16:35:48 INFO - 4003 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_node_not_displayed_02.js | The container is marked as hidden - 16:35:48 INFO - 4004 INFO Listening for the display-change event 16:35:48 INFO - 4005 INFO Making style changes 16:35:48 INFO - 4006 INFO Getting the node for '#display-none' 16:35:48 INFO - 4007 INFO Verifying that the list of changed nodes include our container 16:35:48 INFO - 4008 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_node_not_displayed_02.js | The display-change event was received with a nodes - 16:35:48 INFO - 4009 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_node_not_displayed_02.js | Container is part of the list of changed nodes - 16:35:48 INFO - 4010 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_node_not_displayed_02.js | The container is marked as shown - 16:35:48 INFO - 4011 INFO Running test case: Showing a node by removing its hidden attribute 16:35:48 INFO - 4012 INFO Getting the #hidden-true test node 16:35:48 INFO - 4013 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_node_not_displayed_02.js | The container is marked as hidden - 16:35:48 INFO - 4014 INFO Listening for the display-change event 16:35:48 INFO - 4015 INFO Making style changes 16:35:48 INFO - 4016 INFO Getting the node for '#hidden-true' 16:35:48 INFO - 4017 INFO Verifying that the list of changed nodes include our container 16:35:48 INFO - 4018 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_node_not_displayed_02.js | The display-change event was received with a nodes - 16:35:48 INFO - 4019 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_node_not_displayed_02.js | Container is part of the list of changed nodes - 16:35:48 INFO - 4020 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_node_not_displayed_02.js | The container is marked as shown - 16:35:48 INFO - 4021 INFO Running test case: Hiding a node by adding a hidden attribute 16:35:48 INFO - 4022 INFO Getting the #hidden-true test node 16:35:49 INFO - 4023 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_node_not_displayed_02.js | The container is marked as shown - 16:35:49 INFO - 4024 INFO Listening for the display-change event 16:35:49 INFO - 4025 INFO Making style changes 16:35:49 INFO - 4026 INFO Getting the node for '#hidden-true' 16:35:49 INFO - 4027 INFO Verifying that the list of changed nodes include our container 16:35:49 INFO - 4028 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_node_not_displayed_02.js | The display-change event was received with a nodes - 16:35:49 INFO - 4029 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_node_not_displayed_02.js | Container is part of the list of changed nodes - 16:35:49 INFO - 4030 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_node_not_displayed_02.js | The container is marked as hidden - 16:35:49 INFO - 4031 INFO Running test case: Showing a node by changin a stylesheet's rule 16:35:49 INFO - 4032 INFO Getting the #hidden-via-stylesheet test node 16:35:49 INFO - 4033 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_node_not_displayed_02.js | The container is marked as hidden - 16:35:49 INFO - 4034 INFO Listening for the display-change event 16:35:49 INFO - 4035 INFO Making style changes 16:35:49 INFO - 4036 INFO Getting the node for '#hidden-via-stylesheet' 16:35:49 INFO - 4037 INFO Verifying that the list of changed nodes include our container 16:35:49 INFO - 4038 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_node_not_displayed_02.js | The display-change event was received with a nodes - 16:35:49 INFO - 4039 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_node_not_displayed_02.js | Container is part of the list of changed nodes - 16:35:49 INFO - 4040 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_node_not_displayed_02.js | The container is marked as shown - 16:35:49 INFO - 4041 INFO Running test case: Hiding a node by adding a new rule to a stylesheet 16:35:49 INFO - 4042 INFO Getting the #hidden-via-stylesheet test node 16:35:49 INFO - 4043 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_node_not_displayed_02.js | The container is marked as shown - 16:35:49 INFO - 4044 INFO Listening for the display-change event 16:35:49 INFO - 4045 INFO Making style changes 16:35:49 INFO - 4046 INFO Getting the node for '#hidden-via-stylesheet' 16:35:49 INFO - 4047 INFO Verifying that the list of changed nodes include our container 16:35:49 INFO - 4048 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_node_not_displayed_02.js | The display-change event was received with a nodes - 16:35:49 INFO - 4049 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_node_not_displayed_02.js | Container is part of the list of changed nodes - 16:35:49 INFO - 4050 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_node_not_displayed_02.js | The container is marked as hidden - 16:35:49 INFO - 4051 INFO Running test case: Hiding a node by adding a class that matches an existing rule 16:35:49 INFO - 4052 INFO Getting the #normal-div test node 16:35:50 INFO - 4053 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_node_not_displayed_02.js | The container is marked as shown - 16:35:50 INFO - 4054 INFO Listening for the display-change event 16:35:50 INFO - 4055 INFO Making style changes 16:35:50 INFO - 4056 INFO Getting the node for '#normal-div' 16:35:50 INFO - 4057 INFO Verifying that the list of changed nodes include our container 16:35:50 INFO - 4058 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_node_not_displayed_02.js | The display-change event was received with a nodes - 16:35:50 INFO - 4059 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_node_not_displayed_02.js | Container is part of the list of changed nodes - 16:35:50 INFO - 4060 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_node_not_displayed_02.js | The container is marked as hidden - 16:35:50 INFO - 4061 INFO Leaving test 16:35:50 INFO - MEMORY STAT | vsize 20973098MB | residentFast 849MB 16:35:50 INFO - 4062 INFO TEST-OK | devtools/client/markupview/test/browser_markupview_node_not_displayed_02.js | took 7747ms 16:35:51 INFO - 4063 INFO TEST-START | devtools/client/markupview/test/browser_markupview_pagesize_01.js 16:35:51 INFO - 4064 INFO Entering test 16:35:51 INFO - 4065 INFO Adding a new tab with URL: 'http://mochi.test:8888/browser/devtools/client/markupview/test/doc_markup_pagesize_01.html' 16:35:51 INFO - 4066 INFO Loading the helper frame script chrome://devtools/content/shared/frame-script-utils.js 16:35:51 INFO - 4067 INFO Console message: [JavaScript Error: "The character encoding of the HTML document was not declared. The document will render with garbled text in some browser configurations if the document contains characters from outside the US-ASCII range. The character encoding of the page must be declared in the document or in the transfer protocol." {file: "http://mochi.test:8888/browser/devtools/client/markupview/test/doc_markup_pagesize_01.html" line: 0}] 16:35:51 INFO - 4068 INFO URL 'http://mochi.test:8888/browser/devtools/client/markupview/test/doc_markup_pagesize_01.html' loading complete 16:35:51 INFO - 4069 INFO Opening the inspector panel 16:35:53 INFO - 4070 INFO Console message: [JavaScript Warning: "Error in parsing value for 'text-anchor'. Declaration dropped." {file: "resource://devtools/server/actors/highlighters.css" line: 269 column: 15 source: " text-anchor: left;"}] 16:35:55 INFO - 4071 INFO The toolbox is open 16:35:56 INFO - 4072 INFO The inspector panel is active and ready 16:35:56 INFO - 4073 INFO Start iterating through the test data 16:35:56 INFO - 4074 INFO Start test: Select the last item 16:35:56 INFO - 4075 INFO Selecting the node that corresponds to #z 16:35:56 INFO - 4076 INFO Selecting the node for '#z' 16:35:56 INFO - 4077 INFO Checking that the right nodes are shwon 16:35:56 INFO - 4078 INFO Getting the markup-container for node body 16:35:56 INFO - 4079 INFO Found markup-container [MarkupContainer for [Front for domnode/server1.conn47.domnode31]] 16:35:56 INFO - 4080 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_pagesize_01.js | Got the expected children. - 16:35:56 INFO - 4081 INFO Start test: Select the first item 16:35:56 INFO - 4082 INFO Selecting the node that corresponds to #a 16:35:56 INFO - 4083 INFO Selecting the node for '#a' 16:35:57 INFO - 4084 INFO Checking that the right nodes are shwon 16:35:57 INFO - 4085 INFO Getting the markup-container for node body 16:35:57 INFO - 4086 INFO Found markup-container [MarkupContainer for [Front for domnode/server1.conn47.domnode31]] 16:35:57 INFO - 4087 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_pagesize_01.js | Got the expected children. - 16:35:57 INFO - 4088 INFO Start test: Select the last item 16:35:57 INFO - 4089 INFO Selecting the node that corresponds to #z 16:35:57 INFO - 4090 INFO Selecting the node for '#z' 16:35:57 INFO - 4091 INFO Checking that the right nodes are shwon 16:35:57 INFO - 4092 INFO Getting the markup-container for node body 16:35:57 INFO - 4093 INFO Found markup-container [MarkupContainer for [Front for domnode/server1.conn47.domnode31]] 16:35:57 INFO - 4094 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_pagesize_01.js | Got the expected children. - 16:35:57 INFO - 4095 INFO Start test: Select an already-visible item 16:35:57 INFO - 4096 INFO Selecting the node that corresponds to #v 16:35:57 INFO - 4097 INFO Selecting the node for '#v' 16:35:58 INFO - 4098 INFO Checking that the right nodes are shwon 16:35:58 INFO - 4099 INFO Getting the markup-container for node body 16:35:58 INFO - 4100 INFO Found markup-container [MarkupContainer for [Front for domnode/server1.conn47.domnode31]] 16:35:58 INFO - 4101 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_pagesize_01.js | Got the expected children. - 16:35:58 INFO - 4102 INFO Start test: Verify childrenDirty reloads the page 16:35:58 INFO - 4103 INFO Getting the markup-container for node body 16:35:58 INFO - 4104 INFO Found markup-container [MarkupContainer for [Front for domnode/server1.conn47.domnode31]] 16:35:58 INFO - 4105 INFO Selecting the node that corresponds to #w 16:35:58 INFO - 4106 INFO Selecting the node for '#w' 16:35:59 INFO - 4107 INFO Checking that the right nodes are shwon 16:35:59 INFO - 4108 INFO Getting the markup-container for node body 16:35:59 INFO - 4109 INFO Found markup-container [MarkupContainer for [Front for domnode/server1.conn47.domnode31]] 16:35:59 INFO - 4110 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_pagesize_01.js | Got the expected children. - 16:35:59 INFO - 4111 INFO Checking that clicking the more button loads everything 16:35:59 INFO - 4112 INFO Getting the markup-container for node body 16:35:59 INFO - 4113 INFO Found markup-container [MarkupContainer for [Front for domnode/server1.conn47.domnode31]] 16:35:59 INFO - 4114 INFO Getting the markup-container for node body 16:36:00 INFO - 4115 INFO Found markup-container [MarkupContainer for [Front for domnode/server1.conn47.domnode31]] 16:36:00 INFO - 4116 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_pagesize_01.js | Got the expected children. - 16:36:00 INFO - 4117 INFO Leaving test 16:36:00 INFO - MEMORY STAT | vsize 20973089MB | residentFast 834MB 16:36:00 INFO - 4118 INFO TEST-OK | devtools/client/markupview/test/browser_markupview_pagesize_01.js | took 9423ms 16:36:00 INFO - 4119 INFO TEST-START | devtools/client/markupview/test/browser_markupview_pagesize_02.js 16:36:00 INFO - 4120 INFO Entering test 16:36:00 INFO - 4121 INFO Adding a new tab with URL: 'http://mochi.test:8888/browser/devtools/client/markupview/test/doc_markup_pagesize_02.html' 16:36:01 INFO - 4122 INFO Loading the helper frame script chrome://devtools/content/shared/frame-script-utils.js 16:36:01 INFO - 4123 INFO Console message: [JavaScript Error: "The character encoding of the HTML document was not declared. The document will render with garbled text in some browser configurations if the document contains characters from outside the US-ASCII range. The character encoding of the page must be declared in the document or in the transfer protocol." {file: "http://mochi.test:8888/browser/devtools/client/markupview/test/doc_markup_pagesize_02.html" line: 0}] 16:36:01 INFO - 4124 INFO URL 'http://mochi.test:8888/browser/devtools/client/markupview/test/doc_markup_pagesize_02.html' loading complete 16:36:01 INFO - 4125 INFO Opening the inspector panel 16:36:02 INFO - 4126 INFO Console message: [JavaScript Warning: "Error in parsing value for 'text-anchor'. Declaration dropped." {file: "resource://devtools/server/actors/highlighters.css" line: 269 column: 15 source: " text-anchor: left;"}] 16:36:04 INFO - 4127 INFO The toolbox is open 16:36:05 INFO - 4128 INFO The inspector panel is active and ready 16:36:05 INFO - 4129 INFO Selecting the UL node 16:36:05 INFO - 4130 INFO Clicking on the markup-container for node ul 16:36:06 INFO - 4131 INFO Reloading the page with the UL node selected will expand its children 16:36:06 INFO - 4132 INFO Reloading the page 16:36:06 INFO - 4133 INFO Console message: [JavaScript Error: "The character encoding of the HTML document was not declared. The document will render with garbled text in some browser configurations if the document contains characters from outside the US-ASCII range. The character encoding of the page must be declared in the document or in the transfer protocol." {file: "http://mochi.test:8888/browser/devtools/client/markupview/test/doc_markup_pagesize_02.html" line: 0}] 16:36:07 INFO - 4134 INFO Console message: [JavaScript Warning: "Error in parsing value for 'text-anchor'. Declaration dropped." {file: "resource://devtools/server/actors/highlighters.css" line: 269 column: 15 source: " text-anchor: left;"}] 16:36:08 INFO - 4135 INFO Click on the 'show all nodes' button in the UL's list of children 16:36:08 INFO - 4136 INFO Getting the markup-container for node ul 16:36:08 INFO - 4137 INFO Found markup-container [MarkupContainer for [Front for domnode/server1.conn48.domnode61]] 16:36:08 INFO - 4138 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_pagesize_02.js | All nodes button is here - 16:36:09 INFO - 4139 INFO Getting the markup-container for node ul 16:36:09 INFO - 4140 INFO Found markup-container [MarkupContainer for [Front for domnode/server1.conn48.domnode61]] 16:36:09 INFO - 4141 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_pagesize_02.js | All nodes button isn't here anymore - 16:36:09 INFO - 4142 INFO Getting the node for 'ul' 16:36:09 INFO - 4143 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_pagesize_02.js | undefined assertion name - 16:36:09 INFO - 4144 INFO Leaving test 16:36:10 INFO - MEMORY STAT | vsize 20973094MB | residentFast 826MB 16:36:10 INFO - 4145 INFO TEST-OK | devtools/client/markupview/test/browser_markupview_pagesize_02.js | took 9456ms 16:36:10 INFO - 4146 INFO TEST-START | devtools/client/markupview/test/browser_markupview_remove_xul_attributes.js 16:36:10 INFO - 4147 INFO Entering test 16:36:10 INFO - 4148 INFO Adding a new tab with URL: 'http://mochi.test:8888/browser/devtools/client/markupview/test/doc_markup_xul.xul' 16:36:10 INFO - 4149 INFO Loading the helper frame script chrome://devtools/content/shared/frame-script-utils.js 16:36:10 INFO - 4150 INFO URL 'http://mochi.test:8888/browser/devtools/client/markupview/test/doc_markup_xul.xul' loading complete 16:36:11 INFO - 4151 INFO Opening the inspector panel 16:36:13 INFO - console.error: 16:36:13 INFO - Error writing response to: getUniqueSelector 16:36:13 INFO - console.error: 16:36:13 INFO - Message: Error: undefined passed where a value is required 16:36:13 INFO - Stack: 16:36:13 INFO - identityWrite@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:110:1 16:36:13 INFO - RetVal<.write@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:529:12 16:36:13 INFO - Response<.write/<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:682:1 16:36:13 INFO - Response<.write@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:680:23 16:36:13 INFO - actorProto/ resource://devtools/server/protocol.js:1023:24 16:36:13 INFO - Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:934:23 16:36:13 INFO - this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 16:36:13 INFO - Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 16:36:13 INFO - this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 16:36:13 INFO - Promise.prototype.then@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:451:5 16:36:13 INFO - actorProto/ resource://devtools/server/protocol.js:1043:18 16:36:13 INFO - Actor<._queueResponse@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:920:20 16:36:13 INFO - actorProto/ resource://devtools/server/protocol.js:1042:9 16:36:13 INFO - DSC_onPacket@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/main.js:1643:15 16:36:13 INFO - LocalDebuggerTransport.prototype.send/<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/shared/transport/transport.js:569:11 16:36:13 INFO - makeInfallible/<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/shared/DevToolsUtils.js:87:14 16:36:13 INFO - makeInfallible/<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/shared/DevToolsUtils.js:87:14 16:36:13 INFO - identityWrite@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:110:1 16:36:13 INFO - RetVal<.write@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:529:12 16:36:13 INFO - Response<.write/<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:682:1 16:36:13 INFO - Response<.write@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:680:23 16:36:13 INFO - actorProto/ resource://devtools/server/protocol.js:1023:24 16:36:13 INFO - Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:934:23 16:36:13 INFO - this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 16:36:13 INFO - Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 16:36:13 INFO - this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 16:36:13 INFO - Promise.prototype.then@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:451:5 16:36:13 INFO - actorProto/ resource://devtools/server/protocol.js:1043:18 16:36:13 INFO - Actor<._queueResponse@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:920:20 16:36:13 INFO - actorProto/ resource://devtools/server/protocol.js:1042:9 16:36:13 INFO - DSC_onPacket@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/main.js:1643:15 16:36:13 INFO - LocalDebuggerTransport.prototype.send/<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/shared/transport/transport.js:569:11 16:36:13 INFO - makeInfallible/<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/shared/DevToolsUtils.js:87:14 16:36:13 INFO - makeInfallible/<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/shared/DevToolsUtils.js:87:14 16:36:13 INFO - console.error: 16:36:13 INFO - Protocol error (unknownError): Error: undefined passed where a value is required 16:36:14 INFO - 4152 INFO The toolbox is open 16:36:14 INFO - 4153 INFO The inspector panel is active and ready 16:36:14 INFO - 4154 INFO Getting the node for '#test' 16:36:14 INFO - 4155 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_remove_xul_attributes.js | panelFront has id attribute in the beginning - 16:36:14 INFO - 4156 INFO Removing panel's id attribute 16:36:14 INFO - 4157 INFO Waiting for markupmutation 16:36:14 INFO - 4158 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_remove_xul_attributes.js | panelFront doesn't have id attribute anymore - 16:36:14 INFO - 4159 INFO Leaving test 16:36:15 INFO - console.error: 16:36:15 INFO - Message: Error: Connection closed, pending request to server1.conn49.domwalker28, type children failed 16:36:15 INFO - Request stack: 16:36:15 INFO - Front<.request@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:1178:7 16:36:15 INFO - frontProto/ resource://devtools/server/protocol.js:1338:14 16:36:15 INFO - HTMLBreadcrumbs.prototype.getInterestingFirstNode/moreChildren@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/inspector/breadcrumbs.js:560:7 16:36:15 INFO - HTMLBreadcrumbs.prototype.getInterestingFirstNode@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/inspector/breadcrumbs.js:583:5 16:36:15 INFO - HTMLBreadcrumbs.prototype.ensureFirstChild@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/inspector/breadcrumbs.js:612:14 16:36:15 INFO - HTMLBreadcrumbs.prototype.update@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/inspector/breadcrumbs.js:765:5 16:36:15 INFO - EventEmitter_emit@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/shared/event-emitter.js:147:11 16:36:15 INFO - MarkupView.prototype._mutationObserver/<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/markupview/markup-view.js:872:7 16:36:15 INFO - Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:934:23 16:36:15 INFO - this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 16:36:15 INFO - Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 16:36:15 INFO - this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 16:36:15 INFO - this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 16:36:15 INFO - Front<.onPacket/<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:1236:9 16:36:15 INFO - DevTools RDP*Front<.request@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:1178:7 16:36:15 INFO - frontProto/ resource://devtools/server/protocol.js:1338:14 16:36:15 INFO - exports.WalkerFront<.getMutations<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/actors/inspector.js:3464:12 16:36:15 INFO - exports.WalkerFront<.onMutations<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/actors/inspector.js:3594:5 16:36:15 INFO - Front<.onPacket/results<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:1201:44 16:36:15 INFO - Front<.onPacket@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:1201:23 16:36:15 INFO - DebuggerClient.prototype.onPacket@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/shared/client/main.js:930:7 16:36:15 INFO - LocalDebuggerTransport.prototype.send/<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/shared/transport/transport.js:569:11 16:36:15 INFO - makeInfallible/<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/shared/DevToolsUtils.js:87:14 16:36:15 INFO - makeInfallible/<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/shared/DevToolsUtils.js:87:14 16:36:15 INFO - Stack: 16:36:15 INFO - Front<.destroy@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:1125:23 16:36:15 INFO - exports.WalkerFront<.destroy@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/actors/inspector.js:3229:5 16:36:15 INFO - Pool<.destroy@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:820:9 16:36:15 INFO - Front<.destroy@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/protocol.js:1127:5 16:36:15 INFO - exports.InspectorFront<.destroy@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/server/actors/inspector.js:3896:5 16:36:15 INFO - Toolbox.prototype.destroyInspector/this._destroyingInspector<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/framework/toolbox.js:1834:13 16:36:15 INFO - TaskImpl_run@resource://gre/modules/Task.jsm:314:40 16:36:15 INFO - Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:934:23 16:36:15 INFO - this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 16:36:15 INFO - Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 16:36:15 INFO - this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 16:36:15 INFO - Promise.prototype.then@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:451:5 16:36:15 INFO - TaskImpl_handleResultValue@resource://gre/modules/Task.jsm:388:7 16:36:15 INFO - TaskImpl_run@resource://gre/modules/Task.jsm:322:13 16:36:15 INFO - TaskImpl@resource://gre/modules/Task.jsm:275:3 16:36:15 INFO - createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 16:36:15 INFO - Toolbox.prototype.destroyInspector/this._destroyingInspector<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/framework/toolbox.js:1833:13 16:36:15 INFO - TaskImpl_run@resource://gre/modules/Task.jsm:314:40 16:36:15 INFO - TaskImpl@resource://gre/modules/Task.jsm:275:3 16:36:15 INFO - createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 16:36:15 INFO - Task_spawn@resource://gre/modules/Task.jsm:164:12 16:36:15 INFO - Toolbox.prototype.destroyInspector@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/framework/toolbox.js:1818:40 16:36:15 INFO - Toolbox.prototype.destroy@resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/client/framework/toolbox.js:1944:22 16:36:15 INFO - DT_closeToolbox@resource://devtools/client/framework/gDevTools.jsm:464:12 16:36:15 INFO - @chrome://mochitests/content/browser/devtools/client/markupview/test/head.js:44:9 16:36:15 INFO - TaskImpl_run@resource://gre/modules/Task.jsm:314:40 16:36:15 INFO - TaskImpl@resource://gre/modules/Task.jsm:275:3 16:36:15 INFO - createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 16:36:15 INFO - Task_spawn@resource://gre/modules/Task.jsm:164:12 16:36:15 INFO - TaskImpl_handleResultValue@resource://gre/modules/Task.jsm:381:1 16:36:15 INFO - TaskImpl_run@resource://gre/modules/Task.jsm:322:13 16:36:15 INFO - TaskImpl_handleResultValue@resource://gre/modules/Task.jsm:393:7 16:36:15 INFO - TaskImpl_run@resource://gre/modules/Task.jsm:322:13 16:36:15 INFO - TaskImpl_handleResultValue@resource://gre/modules/Task.jsm:393:7 16:36:15 INFO - TaskImpl_run@resource://gre/modules/Task.jsm:322:13 16:36:15 INFO - TaskImpl_handleResultValue@resource://gre/modules/Task.jsm:393:7 16:36:15 INFO - TaskImpl_run@resource://gre/modules/Task.jsm:322:13 16:36:15 INFO - TaskImpl@resource://gre/modules/Task.jsm:275:3 16:36:15 INFO - createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:249:14 16:36:15 INFO - testScope/test_finish/<@chrome://mochikit/content/browser-test.js:1067:11 16:36:15 INFO - testScope/test_executeSoon/<.run@chrome://mochikit/content/browser-test.js:969:9 16:36:15 INFO - MEMORY STAT | vsize 20973097MB | residentFast 832MB 16:36:15 INFO - 4160 INFO TEST-OK | devtools/client/markupview/test/browser_markupview_remove_xul_attributes.js | took 4902ms 16:36:15 INFO - 4161 INFO TEST-START | devtools/client/markupview/test/browser_markupview_search_01.js 16:36:15 INFO - 4162 INFO Entering test 16:36:15 INFO - 4163 INFO Adding a new tab with URL: 'http://mochi.test:8888/browser/devtools/client/markupview/test/doc_markup_search.html' 16:36:15 INFO - 4164 INFO Loading the helper frame script chrome://devtools/content/shared/frame-script-utils.js 16:36:16 INFO - 4165 INFO Console message: [JavaScript Error: "The character encoding of the HTML document was not declared. The document will render with garbled text in some browser configurations if the document contains characters from outside the US-ASCII range. The character encoding of the page must be declared in the document or in the transfer protocol." {file: "http://mochi.test:8888/browser/devtools/client/markupview/test/doc_markup_search.html" line: 0}] 16:36:16 INFO - 4166 INFO URL 'http://mochi.test:8888/browser/devtools/client/markupview/test/doc_markup_search.html' loading complete 16:36:16 INFO - 4167 INFO Opening the inspector panel 16:36:17 INFO - 4168 INFO Console message: [JavaScript Warning: "Error in parsing value for 'text-anchor'. Declaration dropped." {file: "resource://devtools/server/actors/highlighters.css" line: 269 column: 15 source: " text-anchor: left;"}] 16:36:19 INFO - 4169 INFO The toolbox is open 16:36:20 INFO - 4170 INFO The inspector panel is active and ready 16:36:20 INFO - 4171 INFO Getting the markup-container for node em 16:36:20 INFO - 4172 INFO Found markup-container undefined 16:36:20 INFO - 4173 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_search_01.js | The tag isn't present yet in the markup-view - 16:36:20 INFO - 4174 INFO searching for the innermost child: 16:36:20 INFO - 4175 INFO Entering "em" into the selector-search input field 16:36:20 INFO - 4176 INFO Console message: [JavaScript Warning: "Key event not available on some keyboard layouts: key="r" modifiers="accel alt"" {file: "chrome://mochikit/content/tests/SimpleTest/EventUtils.js" line: 683}] 16:36:20 INFO - 4177 INFO Console message: [JavaScript Warning: "Key event not available on GTK2: key="u" modifiers="shift, accel"" {file: "chrome://mochikit/content/tests/SimpleTest/EventUtils.js" line: 683}] 16:36:21 INFO - 4178 INFO Console message: [JavaScript Warning: "XUL box for box element contained an inline #text child, forcing all its children to be wrapped in a block." {file: "chrome://devtools/content/inspector/inspector.xul" line: 0}] 16:36:22 INFO - 4179 INFO Getting the markup-container for node em 16:36:22 INFO - 4180 INFO Found markup-container [MarkupContainer for [Front for domnode/server1.conn50.domnode38]] 16:36:22 INFO - 4181 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_search_01.js | The tag is now imported in the markup-view - 16:36:22 INFO - 4182 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_search_01.js | The tag is the currently selected node - 16:36:22 INFO - 4183 INFO searching for other nodes too 16:36:22 INFO - 4184 INFO Entering "span" into the selector-search input field 16:36:22 INFO - 4185 INFO Console message: [JavaScript Warning: "XUL box for box element contained an inline #text child, forcing all its children to be wrapped in a block." {file: "resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/shared/layout/utils.js" line: 450}] 16:36:23 INFO - 4186 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_search_01.js | The tag is the currently selected node - 16:36:23 INFO - 4187 INFO Entering "li" into the selector-search input field 16:36:23 INFO - 4188 INFO Console message: [JavaScript Warning: "XUL box for box element contained an inline #text child, forcing all its children to be wrapped in a block." {file: "resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/shared/layout/utils.js" line: 450}] 16:36:24 INFO - 4189 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_search_01.js | The
  • tag is the currently selected node - 16:36:24 INFO - 4190 INFO Entering "ul" into the selector-search input field 16:36:24 INFO - 4191 INFO Console message: [JavaScript Warning: "XUL box for box element contained an inline #text child, forcing all its children to be wrapped in a block." {file: "resource://gre/modules/commonjs/toolkit/loader.js -> resource://devtools/shared/layout/utils.js" line: 450}] 16:36:25 INFO - 4192 INFO TEST-PASS | devtools/client/markupview/test/browser_markupview_search_01.js | The