builder: mozilla-aurora_ubuntu32_vm-debug_test-mochitest-browser-chrome-3 slave: tst-linux32-spot-784 starttime: 1484776843.12 results: success (0) buildid: 20170118123627 builduid: d5373cf167444fe8b2680f95a336b94a revision: 20159d1481827415258184fb689253639f93d705 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-18 14:00:43.123654) ========= master: http://buildbot-master03.bb.releng.use1.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-18 14:00:43.124091) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-18 14:00:43.124396) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-18 14:00:43.333654) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 14:00:43.333977) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: HOME=/home/cltbld LANG=en_US.UTF-8 LOGNAME=cltbld MAIL=/var/mail/cltbld NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5a152710dd62cc268aad214e000002d8-1484776837.271193-1674387213 _=/tools/buildbot/bin/python using PTY: False --2017-01-18 14:00:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 10.7M=0.001s 2017-01-18 14:00:43 (10.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.572658 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 14:00:43.927492) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 14:00:43.927803) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: HOME=/home/cltbld LANG=en_US.UTF-8 LOGNAME=cltbld MAIL=/var/mail/cltbld NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5a152710dd62cc268aad214e000002d8-1484776837.271193-1674387213 _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.080831 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 14:00:44.026008) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-18 14:00:44.026435) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 20159d1481827415258184fb689253639f93d705 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 20159d1481827415258184fb689253639f93d705 --destination scripts --debug'] environment: HOME=/home/cltbld LANG=en_US.UTF-8 LOGNAME=cltbld MAIL=/var/mail/cltbld NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5a152710dd62cc268aad214e000002d8-1484776837.271193-1674387213 _=/tools/buildbot/bin/python using PTY: False 2017-01-18 14:00:44,135 truncating revision to first 12 chars 2017-01-18 14:00:44,135 Setting DEBUG logging. 2017-01-18 14:00:44,136 attempt 1/10 2017-01-18 14:00:44,136 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/20159d148182?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-18 14:00:45,908 unpacking tar archive at: mozilla-aurora-20159d148182/testing/mozharness/ program finished with exit code 0 elapsedTime=2.288182 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-18 14:00:46.350784) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-18 14:00:46.351111) ========= script_repo_revision: 20159d1481827415258184fb689253639f93d705 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-18 14:00:46.354533) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-18 14:00:46.354803) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-18 14:00:46.380729) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 48 mins, 4 secs) (at 2017-01-18 14:00:46.381004) ========= /tools/buildbot/bin/python -u scripts/scripts/desktop_unittest.py --cfg unittests/linux_unittest.py --mochitest-suite browser-chrome-chunked --total-chunks 7 --this-chunk 3 --blob-upload-branch mozilla-aurora --download-symbols true in dir /builds/slave/test/. (timeout 1800 secs) (maxTime 12000 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/desktop_unittest.py', '--cfg', 'unittests/linux_unittest.py', '--mochitest-suite', 'browser-chrome-chunked', '--total-chunks', '7', '--this-chunk', '3', '--blob-upload-branch', 'mozilla-aurora', '--download-symbols', 'true'] environment: CCACHE_DIR=/builds/ccache CCACHE_UMASK=002 DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_HIDE_RESULTS_TABLE=1 MOZ_NODE_PATH=/usr/bin/node MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_FAIL_ON_TEST_ERRORS=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5a152710dd62cc268aad214e000002d8-1484776837.271193-1674387213 _=/tools/buildbot/bin/python using PTY: False 14:00:46 INFO - MultiFileLogger online at 20170118 14:00:46 in /builds/slave/test 14:00:46 INFO - Run as scripts/scripts/desktop_unittest.py --cfg unittests/linux_unittest.py --mochitest-suite browser-chrome-chunked --total-chunks 7 --this-chunk 3 --blob-upload-branch mozilla-aurora --download-symbols true 14:00:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:00:46 INFO - {'all_cppunittest_suites': {'cppunittest': {'tests': ('tests/cppunittest',)}}, 14:00:46 INFO - 'all_gtest_suites': {'gtest': ()}, 14:00:46 INFO - 'all_jittest_suites': {'jittest': (), 14:00:46 INFO - 'jittest-chunked': (), 14:00:46 INFO - 'jittest1': ('--total-chunks=2', '--this-chunk=1'), 14:00:46 INFO - 'jittest2': ('--total-chunks=2', '--this-chunk=2')}, 14:00:46 INFO - 'all_mochitest_suites': {'a11y': ('--flavor=a11y',), 14:00:46 INFO - 'browser-chrome': ('--flavor=browser',), 14:00:46 INFO - 'browser-chrome-addons': ('--flavor=browser', 14:00:46 INFO - '--chunk-by-runtime', 14:00:46 INFO - '--tag=addons'), 14:00:46 INFO - 'browser-chrome-chunked': ('--flavor=browser', 14:00:46 INFO - '--chunk-by-runtime'), 14:00:46 INFO - 'browser-chrome-clipboard': ('--flavor=browser', 14:00:46 INFO - '--subsuite=clipboard'), 14:00:46 INFO - 'browser-chrome-coverage': ('--flavor=browser', 14:00:46 INFO - '--chunk-by-runtime', 14:00:46 INFO - '--timeout=1200'), 14:00:46 INFO - 'browser-chrome-gpu': ('--flavor=browser', 14:00:46 INFO - '--subsuite=gpu'), 14:00:46 INFO - 'browser-chrome-screenshots': ('--flavor=browser', 14:00:46 INFO - '--subsuite=screenshots'), 14:00:46 INFO - 'chrome': ('--flavor=chrome',), 14:00:46 INFO - 'chrome-chunked': ('--flavor=chrome', 14:00:46 INFO - '--chunk-by-dir=4'), 14:00:46 INFO - 'chrome-clipboard': ('--flavor=chrome', 14:00:46 INFO - '--subsuite=clipboard'), 14:00:46 INFO - 'chrome-gpu': ('--flavor=chrome', '--subsuite=gpu'), 14:00:46 INFO - 'jetpack-addon': ('--flavor=jetpack-addon',), 14:00:46 INFO - 'jetpack-package': ('--flavor=jetpack-package',), 14:00:46 INFO - 'jetpack-package-clipboard': ('--flavor=jetpack-package', 14:00:46 INFO - '--subsuite=clipboard'), 14:00:46 INFO - 'mochitest-devtools-chrome': ('--flavor=browser', 14:00:46 INFO - '--subsuite=devtools'), 14:00:46 INFO - 'mochitest-devtools-chrome-chunked': ('--flavor=browser', 14:00:46 INFO - '--subsuite=devtools', 14:00:46 INFO - '--chunk-by-runtime'), 14:00:46 INFO - 'mochitest-devtools-chrome-coverage': ('--flavor=browser', 14:00:46 INFO - '--subsuite=devtools', 14:00:46 INFO - '--chunk-by-runtime', 14:00:46 INFO - '--timeout=1200'), 14:00:46 INFO - 'mochitest-gl': ('--subsuite=webgl',), 14:00:46 INFO - 'mochitest-media': ('--subsuite=media',), 14:00:46 INFO - 'plain': (), 14:00:46 INFO - 'plain-chunked': ('--chunk-by-dir=4',), 14:00:46 INFO - 'plain-clipboard': ('--subsuite=clipboard',), 14:00:46 INFO - 'plain-gpu': ('--subsuite=gpu',), 14:00:46 INFO - 'valgrind-plain': ('--valgrind=/usr/bin/valgrind', 14:00:46 INFO - '--valgrind-supp-files=/builds/slave/test/build/tests/mochitest/i386-redhat-linux-gnu.sup,/builds/slave/test/build/tests/mochitest/cross-architecture.sup', 14:00:46 INFO - '--timeout=900', 14:00:46 INFO - '--max-timeouts=50')}, 14:00:46 INFO - 'all_mozbase_suites': {'mozbase': ()}, 14:00:46 INFO - 'all_reftest_suites': {'crashtest': {'options': ('--suite=crashtest',), 14:00:46 INFO - 'tests': ('tests/reftest/tests/testing/crashtest/crashtests.list',)}, 14:00:46 INFO - 'jsreftest': {'options': ('--extra-profile-file=tests/jsreftest/tests/user.js', 14:00:46 INFO - '--suite=jstestbrowser'), 14:00:46 INFO - 'tests': ('tests/jsreftest/tests/jstests.list',)}, 14:00:46 INFO - 'reftest': {'options': ('--suite=reftest',), 14:00:46 INFO - 'tests': ('tests/reftest/tests/layout/reftests/reftest.list',)}, 14:00:46 INFO - 'reftest-no-accel': {'options': ('--suite=reftest', 14:00:46 INFO - '--setpref=layers.acceleration.force-enabled=disabled'), 14:00:46 INFO - 'tests': ('tests/reftest/tests/layout/reftests/reftest.list',)}}, 14:00:46 INFO - 'all_xpcshell_suites': {'xpcshell': {'options': ('--xpcshell=%(abs_app_dir)s/xpcshell', 14:00:46 INFO - '--manifest=tests/xpcshell/tests/xpcshell.ini'), 14:00:46 INFO - 'tests': ()}, 14:00:46 INFO - 'xpcshell-addons': {'options': ('--xpcshell=%(abs_app_dir)s/xpcshell', 14:00:46 INFO - '--tag=addons', 14:00:46 INFO - '--manifest=tests/xpcshell/tests/xpcshell.ini'), 14:00:46 INFO - 'tests': ()}, 14:00:46 INFO - 'xpcshell-coverage': {'options': ('--xpcshell=%(abs_app_dir)s/xpcshell', 14:00:46 INFO - '--manifest=tests/xpcshell/tests/xpcshell.ini'), 14:00:46 INFO - 'tests': ()}}, 14:00:46 INFO - 'allow_software_gl_layers': False, 14:00:46 INFO - 'append_to_log': False, 14:00:46 INFO - 'base_work_dir': '/builds/slave/test', 14:00:46 INFO - 'binary_path': '/builds/slave/test/build/application/firefox/firefox-bin', 14:00:46 INFO - 'blob_upload_branch': 'mozilla-aurora', 14:00:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:00:46 INFO - 'buildbot_json_path': 'buildprops.json', 14:00:46 INFO - 'buildbot_max_log_size': 52428800, 14:00:46 INFO - 'code_coverage': False, 14:00:46 INFO - 'config_files': ('unittests/linux_unittest.py',), 14:00:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:00:46 INFO - 'download_minidump_stackwalk': True, 14:00:46 INFO - 'download_nodejs': True, 14:00:46 INFO - 'download_symbols': 'true', 14:00:46 INFO - 'e10s': False, 14:00:46 INFO - 'exe_suffix': '', 14:00:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:00:46 INFO - 'tooltool.py': '/tools/tooltool.py', 14:00:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:00:46 INFO - '/tools/misc-python/virtualenv.py')}, 14:00:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:00:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:00:46 INFO - 'installer_path': '/builds/slave/test/build/installer.tar.bz2', 14:00:46 INFO - 'log_level': 'info', 14:00:46 INFO - 'log_to_console': True, 14:00:46 INFO - 'minidump_save_path': '%(abs_work_dir)s/../minidumps', 14:00:46 INFO - 'minidump_stackwalk_path': 'linux32-minidump_stackwalk', 14:00:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux32/releng.manifest', 14:00:46 INFO - 'minimum_tests_zip_dirs': ('bin/*', 14:00:46 INFO - 'certs/*', 14:00:46 INFO - 'config/*', 14:00:46 INFO - 'mach', 14:00:46 INFO - 'marionette/*', 14:00:46 INFO - 'modules/*', 14:00:46 INFO - 'mozbase/*', 14:00:46 INFO - 'tools/*'), 14:00:46 INFO - 'no_random': False, 14:00:46 INFO - 'nodejs_path': 'node-linux-x86/bin/node', 14:00:46 INFO - 'nodejs_tooltool_manifest_path': 'config/tooltool-manifests/linux32/nodejs.manifest', 14:00:46 INFO - 'opt_config_files': (), 14:00:46 INFO - 'pip_index': False, 14:00:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:00:46 INFO - 'cmd': ('xset', 's', 'off', 's', 'reset'), 14:00:46 INFO - 'enabled': True, 14:00:46 INFO - 'halt_on_failure': False, 14:00:46 INFO - 'name': 'disable_screen_saver'}, 14:00:46 INFO - {'architectures': ('32bit',), 14:00:46 INFO - 'cmd': ('python', 14:00:46 INFO - '../scripts/external_tools/mouse_and_screen_resolution.py', 14:00:46 INFO - '--configuration-file', 14:00:46 INFO - '../scripts/external_tools/machine-configuration.json'), 14:00:46 INFO - 'enabled': False, 14:00:46 INFO - 'halt_on_failure': True, 14:00:46 INFO - 'name': 'run mouse & screen adjustment script'}), 14:00:46 INFO - 'require_test_zip': True, 14:00:46 INFO - 'run_all_suites': False, 14:00:46 INFO - 'run_cmd_checks_enabled': True, 14:00:46 INFO - 'run_file_names': {'cppunittest': 'runcppunittests.py', 14:00:46 INFO - 'gtest': 'rungtests.py', 14:00:46 INFO - 'jittest': 'jit_test.py', 14:00:46 INFO - 'mochitest': 'runtests.py', 14:00:46 INFO - 'mozbase': 'test.py', 14:00:46 INFO - 'mozmill': 'runtestlist.py', 14:00:46 INFO - 'reftest': 'runreftest.py', 14:00:46 INFO - 'xpcshell': 'runxpcshelltests.py'}, 14:00:46 INFO - 'specific_tests_zip_dirs': {'cppunittest': ('cppunittest/*',), 14:00:46 INFO - 'gtest': ('gtest/*',), 14:00:46 INFO - 'jittest': ('jit-test/*',), 14:00:46 INFO - 'mochitest': ('mochitest/*',), 14:00:46 INFO - 'mozbase': ('mozbase/*',), 14:00:46 INFO - 'mozmill': ('mozmill/*',), 14:00:46 INFO - 'reftest': ('reftest/*', 'jsreftest/*'), 14:00:46 INFO - 'xpcshell': ('xpcshell/*',)}, 14:00:46 INFO - 'specified_mochitest_suites': ('browser-chrome-chunked',), 14:00:46 INFO - 'strict_content_sandbox': False, 14:00:46 INFO - 'suite_definitions': {'cppunittest': {'options': ('--symbols-path=%(symbols_path)s', 14:00:46 INFO - '--xre-path=%(abs_app_dir)s'), 14:00:46 INFO - 'run_filename': 'runcppunittests.py', 14:00:46 INFO - 'testsdir': 'cppunittest'}, 14:00:46 INFO - 'gtest': {'options': ('--xre-path=%(abs_res_dir)s', 14:00:46 INFO - '--cwd=%(gtest_dir)s', 14:00:46 INFO - '--symbols-path=%(symbols_path)s', 14:00:46 INFO - '--utility-path=tests/bin', 14:00:46 INFO - '%(binary_path)s'), 14:00:46 INFO - 'run_filename': 'rungtests.py'}, 14:00:46 INFO - 'jittest': {'options': ('tests/bin/js', 14:00:46 INFO - '--no-slow', 14:00:46 INFO - '--no-progress', 14:00:46 INFO - '--format=automation', 14:00:46 INFO - '--jitflags=all', 14:00:46 INFO - '--timeout=970'), 14:00:46 INFO - 'run_filename': 'jit_test.py', 14:00:46 INFO - 'run_timeout': 1000, 14:00:46 INFO - 'testsdir': 'jit-test/jit-test'}, 14:00:46 INFO - 'mochitest': {'options': ('--appname=%(binary_path)s', 14:00:46 INFO - '--utility-path=tests/bin', 14:00:46 INFO - '--extra-profile-file=tests/bin/plugins', 14:00:46 INFO - '--symbols-path=%(symbols_path)s', 14:00:46 INFO - '--certificate-path=tests/certs', 14:00:46 INFO - '--setpref=webgl.force-enabled=true', 14:00:46 INFO - '--quiet', 14:00:46 INFO - '--log-raw=%(raw_log_file)s', 14:00:46 INFO - '--log-errorsummary=%(error_summary_file)s', 14:00:46 INFO - '--use-test-media-devices', 14:00:46 INFO - '--screenshot-on-fail', 14:00:46 INFO - '--cleanup-crashes'), 14:00:46 INFO - 'run_filename': 'runtests.py', 14:00:46 INFO - 'testsdir': 'mochitest'}, 14:00:46 INFO - 'mozbase': {'options': ('-b', '%(binary_path)s'), 14:00:46 INFO - 'run_filename': 'test.py', 14:00:46 INFO - 'testsdir': 'mozbase'}, 14:00:46 INFO - 'mozmill': {'options': ('--binary=%(binary_path)s', 14:00:46 INFO - '--testing-modules-dir=test/modules', 14:00:46 INFO - '--plugins-path=%(test_plugin_path)s', 14:00:46 INFO - '--symbols-path=%(symbols_path)s'), 14:00:46 INFO - 'run_filename': 'runtestlist.py', 14:00:46 INFO - 'testsdir': 'mozmill'}, 14:00:46 INFO - 'reftest': {'options': ('--appname=%(binary_path)s', 14:00:46 INFO - '--utility-path=tests/bin', 14:00:46 INFO - '--extra-profile-file=tests/bin/plugins', 14:00:46 INFO - '--symbols-path=%(symbols_path)s', 14:00:46 INFO - '--log-raw=%(raw_log_file)s', 14:00:46 INFO - '--log-errorsummary=%(error_summary_file)s', 14:00:46 INFO - '--cleanup-crashes'), 14:00:46 INFO - 'run_filename': 'runreftest.py', 14:00:46 INFO - 'testsdir': 'reftest'}, 14:00:46 INFO - 'xpcshell': {'options': ('--symbols-path=%(symbols_path)s', 14:00:46 INFO - '--test-plugin-path=%(test_plugin_path)s', 14:00:46 INFO - '--log-raw=%(raw_log_file)s', 14:00:46 INFO - '--log-errorsummary=%(error_summary_file)s', 14:00:46 INFO - '--utility-path=tests/bin'), 14:00:46 INFO - 'run_filename': 'runxpcshelltests.py', 14:00:46 INFO - 'testsdir': 'xpcshell'}}, 14:00:46 INFO - 'this_chunk': '3', 14:00:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:00:46 INFO - 'total_chunks': '7', 14:00:46 INFO - 'unstructured_flavors': {'cppunittest': (), 14:00:46 INFO - 'gtest': (), 14:00:46 INFO - 'jittest': (), 14:00:46 INFO - 'mochitest': ('jetpack',), 14:00:46 INFO - 'mozbase': (), 14:00:46 INFO - 'mozmill': (), 14:00:46 INFO - 'xpcshell': ()}, 14:00:46 INFO - 'vcs_output_timeout': 1000, 14:00:46 INFO - 'virtualenv_path': 'venv', 14:00:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:00:46 INFO - 'work_dir': 'build', 14:00:46 INFO - 'xpcshell_name': 'xpcshell'} 14:00:46 INFO - [mozharness: 2017-01-18 22:00:46.747178Z] Running clobber step. 14:00:46 INFO - Running pre-action listener: _resource_record_pre_action 14:00:46 INFO - Running main action method: clobber 14:00:46 INFO - rmtree: /builds/slave/test/build 14:00:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:00:48 INFO - Running post-action listener: _resource_record_post_action 14:00:48 INFO - [mozharness: 2017-01-18 22:00:48.607718Z] Finished clobber step (success) 14:00:48 INFO - [mozharness: 2017-01-18 22:00:48.608069Z] Running read-buildbot-config step. 14:00:48 INFO - Running pre-action listener: _resource_record_pre_action 14:00:48 INFO - Running main action method: read_buildbot_config 14:00:48 INFO - Using buildbot properties: 14:00:48 INFO - { 14:00:48 INFO - "project": "", 14:00:48 INFO - "product": "firefox", 14:00:48 INFO - "script_repo_revision": "production", 14:00:48 INFO - "scheduler": "tests-mozilla-aurora-ubuntu32_vm-debug-unittest", 14:00:48 INFO - "repository": "", 14:00:48 INFO - "buildername": "Ubuntu VM 12.04 mozilla-aurora debug test mochitest-browser-chrome-3", 14:00:48 INFO - "buildid": "20170118123627", 14:00:48 INFO - "pgo_build": "False", 14:00:48 INFO - "basedir": "/builds/slave/test", 14:00:48 INFO - "buildnumber": 35, 14:00:48 INFO - "slavename": "tst-linux32-spot-784", 14:00:48 INFO - "revision": "20159d1481827415258184fb689253639f93d705", 14:00:48 INFO - "master": "http://buildbot-master03.bb.releng.use1.mozilla.com:8201/", 14:00:48 INFO - "platform": "linux", 14:00:48 INFO - "branch": "mozilla-aurora", 14:00:48 INFO - "repo_path": "releases/mozilla-aurora", 14:00:48 INFO - "moz_repo_path": "", 14:00:48 INFO - "stage_platform": "linux", 14:00:48 INFO - "builduid": "d5373cf167444fe8b2680f95a336b94a", 14:00:48 INFO - "slavebuilddir": "test" 14:00:48 INFO - } 14:00:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/D3ivTSNOT8SBF_J4Li9sVw/artifacts/public/build/firefox-52.0a2.en-US.linux-i686.tar.bz2. 14:00:48 INFO - Found a test packages url https://queue.taskcluster.net/v1/task/D3ivTSNOT8SBF_J4Li9sVw/artifacts/public/build/firefox-52.0a2.en-US.linux-i686.test_packages.json. 14:00:48 INFO - Running post-action listener: _resource_record_post_action 14:00:48 INFO - [mozharness: 2017-01-18 22:00:48.617296Z] Finished read-buildbot-config step (success) 14:00:48 INFO - [mozharness: 2017-01-18 22:00:48.617619Z] Running download-and-extract step. 14:00:48 INFO - Running pre-action listener: _pre_download_and_extract 14:00:48 WARNING - Try message not found. 14:00:48 INFO - Running pre-action listener: _resource_record_pre_action 14:00:48 INFO - Running main action method: download_and_extract 14:00:48 INFO - mkdir: /builds/slave/test/build/tests 14:00:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:00:48 INFO - trying https://queue.taskcluster.net/v1/task/D3ivTSNOT8SBF_J4Li9sVw/artifacts/public/build/firefox-52.0a2.en-US.linux-i686.test_packages.json 14:00:48 INFO - Downloading https://queue.taskcluster.net/v1/task/D3ivTSNOT8SBF_J4Li9sVw/artifacts/public/build/firefox-52.0a2.en-US.linux-i686.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-i686.test_packages.json 14:00:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D3ivTSNOT8SBF_J4Li9sVw/artifacts/public/build/firefox-52.0a2.en-US.linux-i686.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-i686.test_packages.json'}, attempt #1 14:00:49 INFO - Downloaded 1325 bytes. 14:00:49 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-i686.test_packages.json 14:00:49 INFO - Using the following test package requirements: 14:00:49 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-i686.common.tests.zip'], 14:00:49 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-i686.common.tests.zip', 14:00:49 INFO - u'firefox-52.0a2.en-US.linux-i686.cppunittest.tests.zip'], 14:00:49 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-i686.common.tests.zip', 14:00:49 INFO - u'firefox-52.0a2.en-US.linux-i686.gtest.tests.zip'], 14:00:49 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-i686.common.tests.zip', 14:00:49 INFO - u'jsshell-linux-i686.zip'], 14:00:49 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-i686.common.tests.zip', 14:00:49 INFO - u'firefox-52.0a2.en-US.linux-i686.mochitest.tests.zip'], 14:00:49 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-i686.common.tests.zip'], 14:00:49 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-i686.common.tests.zip', 14:00:49 INFO - u'firefox-52.0a2.en-US.linux-i686.reftest.tests.zip'], 14:00:49 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-i686.common.tests.zip', 14:00:49 INFO - u'firefox-52.0a2.en-US.linux-i686.talos.tests.zip'], 14:00:49 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-i686.common.tests.zip', 14:00:49 INFO - u'firefox-52.0a2.en-US.linux-i686.web-platform.tests.zip'], 14:00:49 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-i686.common.tests.zip', 14:00:49 INFO - u'firefox-52.0a2.en-US.linux-i686.xpcshell.tests.zip']} 14:00:50 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-i686.common.tests.zip', u'firefox-52.0a2.en-US.linux-i686.mochitest.tests.zip'] for test suite category: mochitest 14:00:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs bin/*, certs/*, config/*, mach, marionette/*, modules/*, mozbase/*, tools/*, mochitest/* from https://queue.taskcluster.net/v1/task/D3ivTSNOT8SBF_J4Li9sVw/artifacts/public/build/firefox-52.0a2.en-US.linux-i686.common.tests.zip 14:00:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D3ivTSNOT8SBF_J4Li9sVw/artifacts/public/build/firefox-52.0a2.en-US.linux-i686.common.tests.zip'}, attempt #1 14:00:50 INFO - Fetch https://queue.taskcluster.net/v1/task/D3ivTSNOT8SBF_J4Li9sVw/artifacts/public/build/firefox-52.0a2.en-US.linux-i686.common.tests.zip into memory 14:00:52 INFO - Http code: 200 14:00:52 INFO - x-amz-expiration: expiry-date="Fri, 20 Jan 2017 00:00:00 GMT", rule-id="us-east-1-1-day" 14:00:52 INFO - x-amz-id-2: GFO5Ky5N4t5xsG4HxDdhzVQfBTDqkJbEt2jirLIwZLhn1DwDlgYd/VHnpZNgK3p6I/dHFYIZApY= 14:00:52 INFO - x-amz-meta-cloud-mirror-addresses: [{"c":200,"u":"https://s3-us-west-2.amazonaws.com/taskcluster-public-artifacts/D3ivTSNOT8SBF_J4Li9sVw/0/public/build/firefox-52.0a2.en-US.linux-i686.common.tests.zip","t":"2017-01-18T21:48:10.268Z"}] 14:00:52 INFO - x-amz-meta-cloud-mirror-stored: 2017-01-18T21:48:10.329Z 14:00:52 INFO - x-amz-meta-cloud-mirror-upstream-content-length: 20511813 14:00:52 INFO - x-amz-meta-cloud-mirror-upstream-etag: "e3812ac710daa42922b74776d91c347d" 14:00:52 INFO - x-amz-meta-cloud-mirror-upstream-url: https://s3-us-west-2.amazonaws.com/taskcluster-public-artifacts/D3ivTSNOT8SBF_J4Li9sVw/0/public/build/firefox-52.0a2.en-US.linux-i686.common.tests.zip 14:00:52 INFO - x-amz-request-id: ADAB12B54259F483 14:01:01 INFO - Expected file size: 20511813 14:01:01 INFO - Obtained file size: 20511813 14:01:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs bin/*, certs/*, config/*, mach, marionette/*, modules/*, mozbase/*, tools/*, mochitest/* from https://queue.taskcluster.net/v1/task/D3ivTSNOT8SBF_J4Li9sVw/artifacts/public/build/firefox-52.0a2.en-US.linux-i686.mochitest.tests.zip 14:01:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D3ivTSNOT8SBF_J4Li9sVw/artifacts/public/build/firefox-52.0a2.en-US.linux-i686.mochitest.tests.zip'}, attempt #1 14:01:02 INFO - Fetch https://queue.taskcluster.net/v1/task/D3ivTSNOT8SBF_J4Li9sVw/artifacts/public/build/firefox-52.0a2.en-US.linux-i686.mochitest.tests.zip into memory 14:01:04 INFO - Http code: 200 14:01:04 INFO - x-amz-expiration: expiry-date="Fri, 20 Jan 2017 00:00:00 GMT", rule-id="us-east-1-1-day" 14:01:04 INFO - x-amz-id-2: boqZe2H22BMzmuCCk6yCwOyacA5yfDRBkSbnXNiAPzvLfu66jrtYJbd91lTvUUm5K1xUztA+CFE= 14:01:04 INFO - x-amz-meta-cloud-mirror-addresses: [{"c":200,"u":"https://s3-us-west-2.amazonaws.com/taskcluster-public-artifacts/D3ivTSNOT8SBF_J4Li9sVw/0/public/build/firefox-52.0a2.en-US.linux-i686.mochitest.tests.zip","t":"2017-01-18T21:48:30.207Z"}] 14:01:04 INFO - x-amz-meta-cloud-mirror-stored: 2017-01-18T21:48:30.256Z 14:01:04 INFO - x-amz-meta-cloud-mirror-upstream-content-length: 73618211 14:01:04 INFO - x-amz-meta-cloud-mirror-upstream-etag: "2189fb4264a5bfbcb1ed869fd2c83e38" 14:01:04 INFO - x-amz-meta-cloud-mirror-upstream-url: https://s3-us-west-2.amazonaws.com/taskcluster-public-artifacts/D3ivTSNOT8SBF_J4Li9sVw/0/public/build/firefox-52.0a2.en-US.linux-i686.mochitest.tests.zip 14:01:04 INFO - x-amz-request-id: ECE1A9F6D6A8575D 14:01:05 INFO - Expected file size: 73618211 14:01:05 INFO - Obtained file size: 73618211 14:01:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:01:20 INFO - trying https://queue.taskcluster.net/v1/task/D3ivTSNOT8SBF_J4Li9sVw/artifacts/public/build/firefox-52.0a2.en-US.linux-i686.tar.bz2 14:01:20 INFO - Downloading https://queue.taskcluster.net/v1/task/D3ivTSNOT8SBF_J4Li9sVw/artifacts/public/build/firefox-52.0a2.en-US.linux-i686.tar.bz2 to /builds/slave/test/build/installer.tar.bz2 14:01:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D3ivTSNOT8SBF_J4Li9sVw/artifacts/public/build/firefox-52.0a2.en-US.linux-i686.tar.bz2', 'file_name': '/builds/slave/test/build/installer.tar.bz2'}, attempt #1 14:01:52 INFO - Downloaded 70998089 bytes. 14:01:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D3ivTSNOT8SBF_J4Li9sVw/artifacts/public/build/firefox-52.0a2.en-US.linux-i686.tar.bz2 14:01:52 INFO - mkdir: /builds/slave/test/properties 14:01:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:01:52 INFO - Writing to file /builds/slave/test/properties/build_url 14:01:52 INFO - Contents: 14:01:52 INFO - build_url:https://queue.taskcluster.net/v1/task/D3ivTSNOT8SBF_J4Li9sVw/artifacts/public/build/firefox-52.0a2.en-US.linux-i686.tar.bz2 14:01:52 INFO - retry: Calling query_symbols_url with args: (), kwargs: {'raise_on_failure': True}, attempt #1 14:01:54 INFO - Setting buildbot property symbols_url to https://queue.taskcluster.net/v1/task/D3ivTSNOT8SBF_J4Li9sVw/artifacts/public/build/firefox-52.0a2.en-US.linux-i686.crashreporter-symbols.zip 14:01:54 INFO - Writing buildbot properties ['symbols_url'] to /builds/slave/test/properties/symbols_url 14:01:54 INFO - Writing to file /builds/slave/test/properties/symbols_url 14:01:54 INFO - Contents: 14:01:54 INFO - symbols_url:https://queue.taskcluster.net/v1/task/D3ivTSNOT8SBF_J4Li9sVw/artifacts/public/build/firefox-52.0a2.en-US.linux-i686.crashreporter-symbols.zip 14:01:54 INFO - Downloading and extracting to /builds/slave/test/build/symbols these dirs * from https://queue.taskcluster.net/v1/task/D3ivTSNOT8SBF_J4Li9sVw/artifacts/public/build/firefox-52.0a2.en-US.linux-i686.crashreporter-symbols.zip 14:01:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D3ivTSNOT8SBF_J4Li9sVw/artifacts/public/build/firefox-52.0a2.en-US.linux-i686.crashreporter-symbols.zip'}, attempt #1 14:01:54 INFO - Fetch https://queue.taskcluster.net/v1/task/D3ivTSNOT8SBF_J4Li9sVw/artifacts/public/build/firefox-52.0a2.en-US.linux-i686.crashreporter-symbols.zip into memory 14:01:56 INFO - Http code: 200 14:01:56 INFO - x-amz-expiration: expiry-date="Fri, 20 Jan 2017 00:00:00 GMT", rule-id="us-east-1-1-day" 14:01:56 INFO - x-amz-id-2: xaG1wP+d68uEiH6LD5wEaqG04FrDa1fR2Iov6SW4aU51cPnlFzSro0DN0Da1ryqqGzTcLNQbnOU= 14:01:56 INFO - x-amz-meta-cloud-mirror-addresses: [{"c":200,"u":"https://s3-us-west-2.amazonaws.com/taskcluster-public-artifacts/D3ivTSNOT8SBF_J4Li9sVw/0/public/build/firefox-52.0a2.en-US.linux-i686.crashreporter-symbols.zip","t":"2017-01-18T21:49:16.816Z"}] 14:01:56 INFO - x-amz-meta-cloud-mirror-stored: 2017-01-18T21:49:16.917Z 14:01:56 INFO - x-amz-meta-cloud-mirror-upstream-content-length: 175310437 14:01:56 INFO - x-amz-meta-cloud-mirror-upstream-etag: "7ea3ca68935c8b7f26c594c5e4238a07" 14:01:56 INFO - x-amz-meta-cloud-mirror-upstream-url: https://s3-us-west-2.amazonaws.com/taskcluster-public-artifacts/D3ivTSNOT8SBF_J4Li9sVw/0/public/build/firefox-52.0a2.en-US.linux-i686.crashreporter-symbols.zip 14:01:56 INFO - x-amz-request-id: A27C49C9DFF907CF 14:03:11 INFO - Expected file size: 175310437 14:03:11 INFO - Obtained file size: 175310437 14:03:32 INFO - Running post-action listener: _resource_record_post_action 14:03:32 INFO - Running post-action listener: set_extra_try_arguments 14:03:32 INFO - [mozharness: 2017-01-18 22:03:32.469380Z] Finished download-and-extract step (success) 14:03:32 INFO - [mozharness: 2017-01-18 22:03:32.469721Z] Running create-virtualenv step. 14:03:32 INFO - Running pre-action listener: _install_mozbase 14:03:32 INFO - Running pre-action listener: _pre_create_virtualenv 14:03:32 INFO - Running pre-action listener: _resource_record_pre_action 14:03:32 INFO - Running main action method: create_virtualenv 14:03:32 INFO - Creating virtualenv /builds/slave/test/build/venv 14:03:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:03:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:03:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:03:33 INFO - Using real prefix '/usr' 14:03:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:03:34 INFO - Installing distribute.............................................................................................................................................................................................done. 14:03:37 INFO - Installing pip.................done. 14:03:37 INFO - Return code: 0 14:03:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:03:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:03:38 INFO - Reading from file tmpfile_stdout 14:03:38 INFO - Output received: 14:03:38 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 14:03:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:03:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:03:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.use1.mozilla.com/pub 14:03:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:03:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.use1.mozilla.com/pub 14:03:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.use1.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.use1.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb72fc5e0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb72d7e30>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x8ca1d50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x8c96520>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x8c9cdd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x8c9a870>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'TMOUT': '86400', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'HOME': '/home/cltbld', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'DISPLAY': ':0', 'CCACHE_UMASK': '002', 'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NODE_PATH': '/usr/bin/node', 'XDG_SESSION_COOKIE': '5a152710dd62cc268aad214e000002d8-1484776837.271193-1674387213', 'SHLVL': '1', 'NO_FAIL_ON_TEST_ERRORS': '1', 'MOZ_NO_REMOTE': '1', 'MOZ_HIDE_RESULTS_TABLE': '1', 'MAIL': '/var/mail/cltbld', '_': '/tools/buildbot/bin/python', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'CCACHE_DIR': '/builds/ccache'}}, attempt #1 14:03:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.use1.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.use1.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:03:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.use1.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.use1.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:03:38 INFO - Using env: {'CCACHE_DIR': '/builds/ccache', 14:03:38 INFO - 'CCACHE_UMASK': '002', 14:03:38 INFO - 'DISPLAY': ':0', 14:03:38 INFO - 'HOME': '/home/cltbld', 14:03:38 INFO - 'LANG': 'en_US.UTF-8', 14:03:38 INFO - 'LOGNAME': 'cltbld', 14:03:38 INFO - 'MAIL': '/var/mail/cltbld', 14:03:38 INFO - 'MOZ_HIDE_RESULTS_TABLE': '1', 14:03:38 INFO - 'MOZ_NODE_PATH': '/usr/bin/node', 14:03:38 INFO - 'MOZ_NO_REMOTE': '1', 14:03:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:38 INFO - 'NO_FAIL_ON_TEST_ERRORS': '1', 14:03:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:38 INFO - 'PWD': '/builds/slave/test', 14:03:38 INFO - 'SHELL': '/bin/bash', 14:03:38 INFO - 'SHLVL': '1', 14:03:38 INFO - 'TERM': 'linux', 14:03:38 INFO - 'TMOUT': '86400', 14:03:38 INFO - 'USER': 'cltbld', 14:03:38 INFO - 'XDG_SESSION_COOKIE': '5a152710dd62cc268aad214e000002d8-1484776837.271193-1674387213', 14:03:38 INFO - '_': '/tools/buildbot/bin/python'} 14:03:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:39 INFO - Downloading/unpacking psutil>=3.1.1 14:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.use1.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.use1.mozilla.com has it available 14:03:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.use1.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.use1.mozilla.com has it available 14:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:03:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:03:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects
%20%20%20%20%20%20%20%20%20%20 This%20is%20a%20paragraph %20%20%20%20%20%20%20%20%20%20This%20is%20a%20link%20%20%20%20%20%20%20%20%20%20
| %20%20%20%20%20%20
abc
%20%20%20%20%20%20%20%20%20%20] 14:07:36 INFO - --DOMWINDOW == 128 (0xa18bc000) [pid = 1970] [serial = 120] [outer = (nil)] [url = data:text/html,] 14:07:36 INFO - --DOMWINDOW == 127 (0xa55b0c00) [pid = 1970] [serial = 80] [outer = (nil)] [url = about:blank] 14:07:36 INFO - --DOMWINDOW == 126 (0x9b5b8000) [pid = 1970] [serial = 112] [outer = (nil)] [url = about:blank] 14:07:36 INFO - --DOMWINDOW == 125 (0x93263400) [pid = 1970] [serial = 84] [outer = (nil)] [url = about:blank] 14:07:36 INFO - --DOMWINDOW == 124 (0x99817c00) [pid = 1970] [serial = 86] [outer = (nil)] [url = data:text/html,%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20text
%20%20text%20%20%20%20%20%20%20%20] 14:07:48 INFO - --DOMWINDOW == 79 (0x8f6c8800) [pid = 1970] [serial = 163] [outer = (nil)] [url = about:blank] 14:07:48 INFO - --DOMWINDOW == 78 (0x8e2c7800) [pid = 1970] [serial = 161] [outer = (nil)] [url = data:text/html,%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20
cell1 | %20%20%20%20%20%20cell2 | %20%20%20%20
cell1 | %20%20%20%20%20%20%20%20cell2 | %20%20%20%20%20%20
%20%20%20%20%20%20%20%20%20%20 This%20is%20a%20paragraph %20%20%20%20%20%20%20%20%20%20This%20is%20a%20link%20%20%20%20%20%20%20%20%20%20
aria%20description %20%20another%20description %20%20%20%20%20%20%20%20%20%20] 14:07:49 INFO - --DOMWINDOW == 61 (0xa55b7000) [pid = 1970] [serial = 82] [outer = (nil)] [url = data:text/html,%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20 %20%20%20%20%20%20%20%20]
14:07:49 INFO - --DOMWINDOW == 60 (0x9d4d7800) [pid = 1970] [serial = 44] [outer = (nil)] [url = data:text/html,%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20Hallo%20Welt!] 14:36:17 INFO - --DOMWINDOW == 51 (0x8f46ec00) [pid = 2846] [serial = 41] [outer = (nil)] [url = about:blank] 14:36:17 INFO - --DOMWINDOW == 50 (0x8f260400) [pid = 2846] [serial = 53] [outer = (nil)] [url = data:text/html;charset=utf-8,Hallo%20Welt!] 14:36:17 INFO - --DOMWINDOW == 49 (0x9d80e800) [pid = 2846] [serial = 47] [outer = (nil)] [url = data:text/html;charset=utf-8,%C3%90%C2%9F%C3%91%C2%80%C3%90%C2%B8%C3%90%C2%B2%C3%90%C2%B5%C3%91%C2%82,%20%C3%90%C2%BC%C3%90%C2%B8%C3%91%C2%80!] 14:36:17 INFO - --DOMWINDOW == 48 (0x9d816800) [pid = 2846] [serial = 49] [outer = (nil)] [url = data:text/html;charset=utf-8,Hallo%20Welt!Bratwurst!] 14:36:17 INFO - --DOMWINDOW == 47 (0x95308c00) [pid = 2846] [serial = 39] [outer = (nil)] [url = chrome://browser/content/preferences/translation.xul] 14:36:17 INFO - --DOMWINDOW == 46 (0x921b3400) [pid = 2846] [serial = 37] [outer = (nil)] [url = chrome://browser/content/preferences/translation.xul] 14:36:17 INFO - --DOMWINDOW == 45 (0x9941e000) [pid = 2846] [serial = 55] [outer = (nil)] [url = data:text/html;charset=utf-8,Hallo%20Welt!] 14:36:18 INFO - ++DOCSHELL 0x8f46a400 == 20 [pid = 2846] [id = 27] 14:36:18 INFO - ++DOMWINDOW == 46 (0x8f46b800) [pid = 2846] [serial = 61] [outer = (nil)] 14:36:18 INFO - ++DOMWINDOW == 47 (0x8f471400) [pid = 2846] [serial = 62] [outer = 0x8f46b800] 14:36:18 INFO - [2846] WARNING: We should have hit the document element...: file /builds/slave/m-aurora-lx-d-0000000000000000/build/src/layout/xul/BoxObject.cpp, line 175 14:36:19 INFO - ++DOCSHELL 0x8f25f400 == 21 [pid = 2846] [id = 28] 14:36:19 INFO - ++DOMWINDOW == 48 (0x93003800) [pid = 2846] [serial = 63] [outer = (nil)] 14:36:19 INFO - ++DOMWINDOW == 49 (0x930f0800) [pid = 2846] [serial = 64] [outer = 0x93003800] 14:36:20 INFO - [2846] WARNING: We should have hit the document element...: file /builds/slave/m-aurora-lx-d-0000000000000000/build/src/layout/xul/BoxObject.cpp, line 175 14:36:21 INFO - ++DOCSHELL 0x8f315800 == 22 [pid = 2846] [id = 29] 14:36:21 INFO - ++DOMWINDOW == 50 (0x8f470800) [pid = 2846] [serial = 65] [outer = (nil)] 14:36:21 INFO - ++DOMWINDOW == 51 (0x921b7000) [pid = 2846] [serial = 66] [outer = 0x8f470800] 14:36:22 INFO - [2846] WARNING: We should have hit the document element...: file /builds/slave/m-aurora-lx-d-0000000000000000/build/src/layout/xul/BoxObject.cpp, line 175 14:36:23 INFO - ++DOCSHELL 0x935d3c00 == 23 [pid = 2846] [id = 30] 14:36:23 INFO - ++DOMWINDOW == 52 (0x93939800) [pid = 2846] [serial = 67] [outer = (nil)] 14:36:23 INFO - ++DOMWINDOW == 53 (0x9530e400) [pid = 2846] [serial = 68] [outer = 0x93939800] 14:36:24 INFO - [2846] WARNING: We should have hit the document element...: file /builds/slave/m-aurora-lx-d-0000000000000000/build/src/layout/xul/BoxObject.cpp, line 175 14:36:25 INFO - ++DOCSHELL 0x97006c00 == 24 [pid = 2846] [id = 31] 14:36:25 INFO - ++DOMWINDOW == 54 (0x97007c00) [pid = 2846] [serial = 69] [outer = (nil)] 14:36:25 INFO - ++DOMWINDOW == 55 (0x97074800) [pid = 2846] [serial = 70] [outer = 0x97007c00] 14:36:25 INFO - [2846] WARNING: We should have hit the document element...: file /builds/slave/m-aurora-lx-d-0000000000000000/build/src/layout/xul/BoxObject.cpp, line 175 14:36:26 INFO - ++DOCSHELL 0x9348d000 == 25 [pid = 2846] [id = 32] 14:36:26 INFO - ++DOMWINDOW == 56 (0x9348d400) [pid = 2846] [serial = 71] [outer = (nil)] 14:36:26 INFO - ++DOMWINDOW == 57 (0x9348fc00) [pid = 2846] [serial = 72] [outer = 0x9348d400] 14:36:28 INFO - MEMORY STAT | vsize 747MB | residentFast 225MB | heapAllocated 89MB 14:36:28 INFO - TEST-OK | browser/components/translation/test/browser_translation_telemetry.js | took 22074ms 14:36:28 INFO - ++DOCSHELL 0x93945400 == 26 [pid = 2846] [id = 33] 14:36:28 INFO - ++DOMWINDOW == 58 (0x93945800) [pid = 2846] [serial = 73] [outer = (nil)] 14:36:28 INFO - ++DOMWINDOW == 59 (0x9717f000) [pid = 2846] [serial = 74] [outer = 0x93945800] 14:36:28 INFO - checking window state 14:36:28 INFO - TEST-START | browser/components/translation/test/browser_translation_yandex.js 14:36:28 INFO - Chrome file doesn't exist: /builds/slave/test/build/tests/mochitest/browser/browser/components/translation/test/head.js 14:36:28 INFO - ++DOCSHELL 0x98cf8800 == 27 [pid = 2846] [id = 34] 14:36:28 INFO - ++DOMWINDOW == 60 (0x9941fc00) [pid = 2846] [serial = 75] [outer = (nil)] 14:36:28 INFO - ++DOMWINDOW == 61 (0x99425c00) [pid = 2846] [serial = 76] [outer = 0x9941fc00] 14:36:29 INFO - ++DOMWINDOW == 62 (0x99428800) [pid = 2846] [serial = 77] [outer = 0x9941fc00] 14:36:29 INFO - YANDEX-SERVER-MOCK: {"key":"yandexValidKey","format":"html","lang":"fr-en","text":["Coupe du monde de football de 2014","La Coupe du monde de football de 2014 est la 20e édition de la Coupe du monde de football, compétition organisée par la FIFA et qui réunit les trente-deux meilleures sélections nationales. Sa phase finale a lieu à l'été 2014 au Brésil. Avec le pays organisateur, toutes les équipes championnes du monde depuis 1930 (Uruguay, Italie, Allemagne, Angleterre, Argentine, France et Espagne) se sont qualifiées pour cette compétition. Elle est aussi la première compétition internationale de la Bosnie-Herzégovine."]} 14:36:29 INFO - YANDEX-SERVER-MOCK: SHA1 hash of content: d448894848 14:36:29 INFO - YANDEX-SERVER-MOCK: PATH: browser/browser/components/translation/test/fixtures/result-yandex-d448894848.json 14:36:29 INFO - ++DOCSHELL 0x9a525800 == 28 [pid = 2846] [id = 35] 14:36:29 INFO - ++DOMWINDOW == 63 (0x9aa12800) [pid = 2846] [serial = 78] [outer = (nil)] 14:36:29 INFO - ++DOMWINDOW == 64 (0x9ad19400) [pid = 2846] [serial = 79] [outer = 0x9aa12800] 14:36:30 INFO - ++DOMWINDOW == 65 (0x9ad92800) [pid = 2846] [serial = 80] [outer = 0x9aa12800] 14:36:30 INFO - [2846] WARNING: 'NS_FAILED(rv)', file /builds/slave/m-aurora-lx-d-0000000000000000/build/src/dom/xhr/XMLHttpRequestMainThread.cpp, line 1832 14:36:30 INFO - [2846] WARNING: We should have hit the document element...: file /builds/slave/m-aurora-lx-d-0000000000000000/build/src/layout/xul/BoxObject.cpp, line 175 14:36:31 INFO - ++DOCSHELL 0x9333d000 == 29 [pid = 2846] [id = 36] 14:36:31 INFO - ++DOMWINDOW == 66 (0x9ad19c00) [pid = 2846] [serial = 81] [outer = (nil)] 14:36:31 INFO - ++DOMWINDOW == 67 (0x9c7f2400) [pid = 2846] [serial = 82] [outer = 0x9ad19c00] 14:36:31 INFO - ++DOMWINDOW == 68 (0x9d54b800) [pid = 2846] [serial = 83] [outer = 0x9ad19c00] 14:36:32 INFO - [2846] WARNING: attempt to modify an immutable nsStandardURL: file /builds/slave/m-aurora-lx-d-0000000000000000/build/src/netwerk/base/nsStandardURL.cpp, line 1567 14:36:32 INFO - ++DOCSHELL 0xa5237c00 == 30 [pid = 2846] [id = 37] 14:36:32 INFO - ++DOMWINDOW == 69 (0xa5238000) [pid = 2846] [serial = 84] [outer = (nil)] 14:36:32 INFO - ++DOMWINDOW == 70 (0xa5243400) [pid = 2846] [serial = 85] [outer = 0xa5238000] 14:36:33 INFO - [2846] WARNING: NS_ENSURE_TRUE(alertsDND) failed: file /builds/slave/m-aurora-lx-d-0000000000000000/build/src/toolkit/components/alerts/nsAlertsService.cpp, line 288 14:36:33 INFO - ++DOMWINDOW == 71 (0x8ff30c00) [pid = 2846] [serial = 86] [outer = 0xa5238000] 14:36:34 INFO - MEMORY STAT | vsize 770MB | residentFast 242MB | heapAllocated 117MB 14:36:34 INFO - TEST-OK | browser/components/translation/test/browser_translation_yandex.js | took 6012ms 14:36:34 INFO - ++DOCSHELL 0x8ff5fc00 == 31 [pid = 2846] [id = 38] 14:36:34 INFO - ++DOMWINDOW == 72 (0x8ff60000) [pid = 2846] [serial = 87] [outer = (nil)] 14:36:34 INFO - ++DOMWINDOW == 73 (0x8ff63000) [pid = 2846] [serial = 88] [outer = 0x8ff60000] 14:36:34 INFO - checking window state 14:36:35 INFO - ++DOMWINDOW == 74 (0x8f46f400) [pid = 2846] [serial = 89] [outer = 0x9987c400] 14:36:35 INFO - --DOCSHELL 0xa4324800 == 30 [pid = 2846] [id = 8] 14:36:35 INFO - ++DOMWINDOW == 75 (0x8ff69c00) [pid = 2846] [serial = 90] [outer = 0x9987c400] 14:36:38 INFO - --DOCSHELL 0x97009400 == 29 [pid = 2846] [id = 11] 14:36:38 INFO - --DOCSHELL 0xa5314800 == 28 [pid = 2846] [id = 9] 14:36:40 INFO - --DOCSHELL 0xa5237c00 == 27 [pid = 2846] [id = 37] 14:36:40 INFO - --DOCSHELL 0x9d5c3800 == 26 [pid = 2846] [id = 19] 14:36:40 INFO - --DOCSHELL 0x9d60dc00 == 25 [pid = 2846] [id = 20] 14:36:40 INFO - --DOCSHELL 0x9a525800 == 24 [pid = 2846] [id = 35] 14:36:40 INFO - --DOCSHELL 0x8f260000 == 23 [pid = 2846] [id = 23] 14:36:40 INFO - --DOCSHELL 0x8f46a400 == 22 [pid = 2846] [id = 27] 14:36:40 INFO - --DOCSHELL 0x935d3c00 == 21 [pid = 2846] [id = 30] 14:36:40 INFO - --DOCSHELL 0x9941dc00 == 20 [pid = 2846] [id = 24] 14:36:40 INFO - --DOCSHELL 0x97006c00 == 19 [pid = 2846] [id = 31] 14:36:40 INFO - --DOCSHELL 0x9348d000 == 18 [pid = 2846] [id = 32] 14:36:40 INFO - --DOCSHELL 0x92122c00 == 17 [pid = 2846] [id = 13] 14:36:40 INFO - --DOCSHELL 0xa6bd9800 == 16 [pid = 2846] [id = 22] 14:36:40 INFO - --DOCSHELL 0x8f25f400 == 15 [pid = 2846] [id = 28] 14:36:40 INFO - --DOCSHELL 0x8f315800 == 14 [pid = 2846] [id = 29] 14:36:40 INFO - --DOCSHELL 0x8f25bc00 == 13 [pid = 2846] [id = 25] 14:36:40 INFO - --DOCSHELL 0x9333d000 == 12 [pid = 2846] [id = 36] 14:36:40 INFO - --DOCSHELL 0x8f62c400 == 11 [pid = 2846] [id = 26] 14:36:40 INFO - --DOCSHELL 0x93945400 == 10 [pid = 2846] [id = 33] 14:36:40 INFO - --DOCSHELL 0x9690ac00 == 9 [pid = 2846] [id = 21] 14:36:40 INFO - --DOCSHELL 0x98cf8800 == 8 [pid = 2846] [id = 34] 14:36:40 INFO - --DOCSHELL 0x8f46e400 == 7 [pid = 2846] [id = 17] 14:36:40 INFO - --DOCSHELL 0x8f46f800 == 6 [pid = 2846] [id = 18] 14:36:40 INFO - --DOMWINDOW == 74 (0x99421000) [pid = 2846] [serial = 56] [outer = (nil)] [url = about:blank] 14:36:40 INFO - --DOMWINDOW == 73 (0xa745e000) [pid = 2846] [serial = 54] [outer = (nil)] [url = about:blank] 14:36:40 INFO - --DOMWINDOW == 72 (0xa6d42400) [pid = 2846] [serial = 52] [outer = (nil)] [url = about:blank] 14:36:40 INFO - --DOMWINDOW == 71 (0xa2b30400) [pid = 2846] [serial = 50] [outer = (nil)] [url = about:blank] 14:36:40 INFO - --DOMWINDOW == 70 (0x9d9a1000) [pid = 2846] [serial = 48] [outer = (nil)] [url = about:blank] 14:36:40 INFO - --DOMWINDOW == 69 (0x97075c00) [pid = 2846] [serial = 44] [outer = (nil)] [url = about:blank] 14:36:40 INFO - --DOMWINDOW == 68 (0x967db000) [pid = 2846] [serial = 42] [outer = (nil)] [url = about:blank] 14:36:40 INFO - --DOMWINDOW == 67 (0x8f46ac00) [pid = 2846] [serial = 36] [outer = (nil)] [url = http://example.com/] 14:36:40 INFO - --DOMWINDOW == 66 (0x8f319000) [pid = 2846] [serial = 35] [outer = (nil)] [url = about:blank] 14:36:40 INFO - --DOMWINDOW == 65 (0x9d577800) [pid = 2846] [serial = 33] [outer = (nil)] [url = about:blank] 14:36:40 INFO - --DOMWINDOW == 64 (0x921b4800) [pid = 2846] [serial = 31] [outer = (nil)] [url = http://127.0.0.1:8888/browser/browser/components/translation/test/fixtures/bug1022725-fr.html] 14:36:40 INFO - --DOMWINDOW == 63 (0x9700ec00) [pid = 2846] [serial = 25] [outer = (nil)] [url = http://127.0.0.1:8888/browser/browser/components/translation/test/fixtures/bug1022725-fr.html] 14:36:40 INFO - --DOMWINDOW == 62 (0xa530d400) [pid = 2846] [serial = 17] [outer = (nil)] [url = about:blank] 14:36:40 INFO - --DOMWINDOW == 61 (0x9333dc00) [pid = 2846] [serial = 13] [outer = (nil)] [url = about:blank] 14:36:40 INFO - --DOMWINDOW == 60 (0x99807400) [pid = 2846] [serial = 23] [outer = (nil)] [url = about:blank] 14:36:40 INFO - --DOMWINDOW == 59 (0xa18b8800) [pid = 2846] [serial = 2] [outer = (nil)] [url = about:blank] 14:36:40 INFO - --DOMWINDOW == 58 (0xa6bd8800) [pid = 2846] [serial = 20] [outer = (nil)] [url = about:blank] 14:36:40 INFO - --DOMWINDOW == 57 (0x99802400) [pid = 2846] [serial = 22] [outer = (nil)] [url = about:blank] 14:36:40 INFO - --DOMWINDOW == 56 (0x9211d000) [pid = 2846] [serial = 30] [outer = (nil)] [url = about:blank] 14:36:40 INFO - --DOMWINDOW == 55 (0x98ced400) [pid = 2846] [serial = 12] [outer = (nil)] [url = about:blank] 14:36:40 INFO - --DOMWINDOW == 54 (0x98b4f400) [pid = 2846] [serial = 9] [outer = (nil)] [url = about:blank] 14:36:40 INFO - --DOMWINDOW == 53 (0x921b6800) [pid = 2846] [serial = 38] [outer = (nil)] [url = about:blank] 14:36:40 INFO - --DOMWINDOW == 52 (0x9530c800) [pid = 2846] [serial = 40] [outer = (nil)] [url = about:blank] 14:36:42 INFO - --DOMWINDOW == 51 (0x9530e400) [pid = 2846] [serial = 68] [outer = (nil)] [url = about:blank] 14:36:42 INFO - --DOMWINDOW == 50 (0x921b7000) [pid = 2846] [serial = 66] [outer = (nil)] [url = about:blank] 14:36:42 INFO - --DOMWINDOW == 49 (0x9d54b800) [pid = 2846] [serial = 83] [outer = (nil)] [url = about:preferences#content] 14:36:42 INFO - --DOMWINDOW == 48 (0x9942a400) [pid = 2846] [serial = 58] [outer = (nil)] [url = about:blank] 14:36:42 INFO - --DOMWINDOW == 47 (0x8f46b800) [pid = 2846] [serial = 61] [outer = (nil)] [url = data:text/html;charset=utf-8,Hallo%20Welt!Bratwurst!] 14:36:42 INFO - --DOMWINDOW == 46 (0x8f62c800) [pid = 2846] [serial = 59] [outer = (nil)] [url = data:text/html;charset=utf-8,Hallo%20Welt!] 14:36:42 INFO - --DOMWINDOW == 45 (0x8f318000) [pid = 2846] [serial = 57] [outer = (nil)] [url = data:text/html;charset=utf-8,Hallo%20Welt!] 14:36:42 INFO - --DOMWINDOW == 44 (0x8f470800) [pid = 2846] [serial = 65] [outer = (nil)] [url = data:text/html;charset=utf-8,Hallo%20Welt!] 14:36:42 INFO - --DOMWINDOW == 43 (0x93003800) [pid = 2846] [serial = 63] [outer = (nil)] [url = data:text/html;charset=utf-8,Hallo%20Welt!] 14:36:42 INFO - --DOMWINDOW == 42 (0x9d5c3c00) [pid = 2846] [serial = 45] [outer = (nil)] [url = about:blank] 14:36:42 INFO - --DOMWINDOW == 41 (0x9d601400) [pid = 2846] [serial = 46] [outer = (nil)] [url = about:blank] 14:36:42 INFO - --DOMWINDOW == 40 (0x99808c00) [pid = 2846] [serial = 24] [outer = (nil)] [url = about:newtab] 14:36:42 INFO - --DOMWINDOW == 39 (0x9ad19400) [pid = 2846] [serial = 79] [outer = (nil)] [url = about:blank] 14:36:42 INFO - --DOMWINDOW == 38 (0x9aa12800) [pid = 2846] [serial = 78] [outer = (nil)] [url = http://127.0.0.1:8888/browser/browser/components/translation/test/fixtures/bug1022725-fr.html] 14:36:42 INFO - --DOMWINDOW == 37 (0x9717f000) [pid = 2846] [serial = 74] [outer = (nil)] [url = about:blank] 14:36:42 INFO - --DOMWINDOW == 36 (0x9348fc00) [pid = 2846] [serial = 72] [outer = (nil)] [url = about:blank] 14:36:42 INFO - --DOMWINDOW == 35 (0x9348d400) [pid = 2846] [serial = 71] [outer = (nil)] [url = data:text/html;charset=utf-8,Hallo%20Welt!] 14:36:42 INFO - --DOMWINDOW == 34 (0x97005800) [pid = 2846] [serial = 26] [outer = (nil)] [url = data:application/vnd.mozilla.xul+xml;charset=utf-8,Hallo%20Welt!] 14:36:42 INFO - --DOMWINDOW == 29 (0x93945800) [pid = 2846] [serial = 73] [outer = (nil)] [url = about:blank] 14:36:42 INFO - --DOMWINDOW == 28 (0xa431e400) [pid = 2846] [serial = 11] [outer = (nil)] [url = about:blank] 14:36:42 INFO - --DOMWINDOW == 27 (0xa5315000) [pid = 2846] [serial = 19] [outer = (nil)] [url = about:newtab] 14:36:42 INFO - --DOMWINDOW == 26 (0x93939800) [pid = 2846] [serial = 67] [outer = (nil)] [url = data:text/html;charset=utf-8,Hallo%20Welt!] 14:36:42 INFO - --DOMWINDOW == 25 (0x99810400) [pid = 2846] [serial = 28] [outer = (nil)] [url = about:blank] 14:36:42 INFO - --DOMWINDOW == 24 (0x9c7f2400) [pid = 2846] [serial = 82] [outer = (nil)] [url = about:blank] 14:36:42 INFO - --DOMWINDOW == 23 (0x9700e000) [pid = 2846] [serial = 27] [outer = (nil)] [url = about:blank] 14:36:42 INFO - --DOMWINDOW == 22 (0x9ad19c00) [pid = 2846] [serial = 81] [outer = (nil)] [url = about:preferences#content] 14:36:42 INFO - --DOMWINDOW == 21 (0xa5313c00) [pid = 2846] [serial = 18] [outer = (nil)] [url = data:application/vnd.mozilla.xul+xml;charset=utf-8,hello! ]
14:46:26 INFO - --DOMWINDOW == 52 (0x8971dc00) [pid = 3789] [serial = 39] [outer = (nil)] [url = about:blank]
14:46:26 INFO - --DOMWINDOW == 51 (0x93528000) [pid = 3789] [serial = 46] [outer = (nil)] [url = about:blank]
14:46:26 INFO - --DOMWINDOW == 50 (0x996e0400) [pid = 3789] [serial = 52] [outer = (nil)] [url = https://example.com/browser/toolkit/content/tests/browser/file_multipleAudio.html]
14:46:26 INFO - --DOMWINDOW == 49 (0x9d1edc00) [pid = 3789] [serial = 60] [outer = (nil)] [url = about:blank]
14:46:26 INFO - --DOMWINDOW == 48 (0x89bda400) [pid = 3789] [serial = 32] [outer = (nil)] [url = about:blank]
14:46:26 INFO - --DOMWINDOW == 47 (0x97119400) [pid = 3789] [serial = 29] [outer = (nil)] [url = https://example.com/browser/toolkit/content/tests/browser/file_multipleAudio.html]
14:46:26 INFO - --DOMWINDOW == 46 (0x89ae4400) [pid = 3789] [serial = 36] [outer = (nil)] [url = about:blank]
14:46:26 INFO - --DOMWINDOW == 45 (0x9a5de000) [pid = 3789] [serial = 26] [outer = (nil)] [url = about:blank]
14:46:26 INFO - --DOMWINDOW == 44 (0x9ae05400) [pid = 3789] [serial = 21] [outer = (nil)] [url = about:blank]
14:46:26 INFO - --DOMWINDOW == 43 (0x9c722800) [pid = 3789] [serial = 57] [outer = (nil)] [url = about:blank]
14:46:26 INFO - --DOMWINDOW == 42 (0x93741c00) [pid = 3789] [serial = 48] [outer = (nil)] [url = about:blank]
14:46:26 INFO - --DOMWINDOW == 41 (0x8979b400) [pid = 3789] [serial = 42] [outer = (nil)] [url = about:blank]
14:46:26 INFO - --DOMWINDOW == 40 (0xa5312800) [pid = 3789] [serial = 67] [outer = (nil)] [url = about:blank]
14:46:26 INFO - --DOMWINDOW == 39 (0x98caac00) [pid = 3789] [serial = 51] [outer = (nil)] [url = about:blank]
14:46:26 INFO - --DOMWINDOW == 38 (0x9d9a3400) [pid = 3789] [serial = 62] [outer = (nil)] [url = data:text/html,hello! ]
14:46:27 INFO - ++DOMWINDOW == 39 (0x89bb1c00) [pid = 3789] [serial = 86] [outer = 0xa57bdc00]
14:46:27 INFO - [3789] WARNING: aTargetFrame should be related with aTargetContent: '!aTargetFrame || !aTargetFrame->GetContent() || aTargetFrame->GetContent() == aTargetContent || aTargetFrame->GetContent()->GetFlattenedTreeParent() == aTargetContent || aTargetFrame->IsGeneratedContentFrame()', file /builds/slave/m-aurora-lx-d-0000000000000000/build/src/dom/events/EventStateManager.cpp, line 532
14:46:27 INFO - [3789] WARNING: aTargetFrame should be related with aTargetContent: '!aTargetFrame || !aTargetFrame->GetContent() || aTargetFrame->GetContent() == aTargetContent || aTargetFrame->GetContent()->GetFlattenedTreeParent() == aTargetContent || aTargetFrame->IsGeneratedContentFrame()', file /builds/slave/m-aurora-lx-d-0000000000000000/build/src/dom/events/EventStateManager.cpp, line 532
14:46:27 INFO - [3789] WARNING: aTargetFrame should be related with aTargetContent: '!aTargetFrame || !aTargetFrame->GetContent() || aTargetFrame->GetContent() == aTargetContent || aTargetFrame->GetContent()->GetFlattenedTreeParent() == aTargetContent || aTargetFrame->IsGeneratedContentFrame()', file /builds/slave/m-aurora-lx-d-0000000000000000/build/src/dom/events/EventStateManager.cpp, line 532
14:46:27 INFO - ++DOCSHELL 0x89ae1400 == 25 [pid = 3789] [id = 32]
14:46:27 INFO - ++DOMWINDOW == 40 (0x89ae1c00) [pid = 3789] [serial = 87] [outer = (nil)]
14:46:27 INFO - ++DOMWINDOW == 41 (0x9553f400) [pid = 3789] [serial = 88] [outer = 0x89ae1c00]
14:46:27 INFO - ++DOMWINDOW == 42 (0x96674400) [pid = 3789] [serial = 89] [outer = 0x89ae1c00]
14:46:27 INFO - [3789] WARNING: aTargetFrame should be related with aTargetContent: '!aTargetFrame || !aTargetFrame->GetContent() || aTargetFrame->GetContent() == aTargetContent || aTargetFrame->GetContent()->GetFlattenedTreeParent() == aTargetContent || aTargetFrame->IsGeneratedContentFrame()', file /builds/slave/m-aurora-lx-d-0000000000000000/build/src/dom/events/EventStateManager.cpp, line 532
14:46:27 INFO - [3789] WARNING: aTargetFrame should be related with aTargetContent: '!aTargetFrame || !aTargetFrame->GetContent() || aTargetFrame->GetContent() == aTargetContent || aTargetFrame->GetContent()->GetFlattenedTreeParent() == aTargetContent || aTargetFrame->IsGeneratedContentFrame()', file /builds/slave/m-aurora-lx-d-0000000000000000/build/src/dom/events/EventStateManager.cpp, line 532
14:46:27 INFO - [3789] WARNING: aTargetFrame should be related with aTargetContent: '!aTargetFrame || !aTargetFrame->GetContent() || aTargetFrame->GetContent() == aTargetContent || aTargetFrame->GetContent()->GetFlattenedTreeParent() == aTargetContent || aTargetFrame->IsGeneratedContentFrame()', file /builds/slave/m-aurora-lx-d-0000000000000000/build/src/dom/events/EventStateManager.cpp, line 532
14:46:28 INFO - ++DOCSHELL 0x966c6400 == 26 [pid = 3789] [id = 33]
14:46:28 INFO - ++DOMWINDOW == 43 (0x9ae09000) [pid = 3789] [serial = 90] [outer = (nil)]
14:46:28 INFO - ++DOMWINDOW == 44 (0x9ae12000) [pid = 3789] [serial = 91] [outer = 0x9ae09000]
14:46:28 INFO - ++DOMWINDOW == 45 (0x9ae16400) [pid = 3789] [serial = 92] [outer = 0x9ae09000]
14:46:28 INFO - --DOMWINDOW == 44 (0xa2b72c00) [pid = 3789] [serial = 64] [outer = (nil)] [url = about:blank]
14:46:29 INFO - ++DOMWINDOW == 45 (0x9c71e800) [pid = 3789] [serial = 93] [outer = 0xa57bdc00]
14:46:31 INFO - MEMORY STAT | vsize 837MB | residentFast 241MB | heapAllocated 100MB
14:46:31 INFO - TEST-OK | toolkit/content/tests/browser/browser_bug295977_autoscroll_overflow.js | took 14977ms
14:46:31 INFO - ++DOCSHELL 0x9d8da000 == 27 [pid = 3789] [id = 34]
14:46:31 INFO - ++DOMWINDOW == 46 (0x9d8da800) [pid = 3789] [serial = 94] [outer = (nil)]
14:46:31 INFO - ++DOMWINDOW == 47 (0x9d97f000) [pid = 3789] [serial = 95] [outer = 0x9d8da800]
14:46:31 INFO - checking window state
14:46:31 INFO - [3789] WARNING: Unable to retrieve the tooltip node document.: file /builds/slave/m-aurora-lx-d-0000000000000000/build/src/layout/xul/nsXULTooltipListener.cpp, line 564
14:46:31 INFO - TEST-START | toolkit/content/tests/browser/browser_bug594509.js
14:46:31 INFO - ++DOCSHELL 0x9d549c00 == 28 [pid = 3789] [id = 35]
14:46:31 INFO - ++DOMWINDOW == 48 (0x9d54a800) [pid = 3789] [serial = 96] [outer = (nil)]
14:46:31 INFO - ++DOMWINDOW == 49 (0x9e457800) [pid = 3789] [serial = 97] [outer = 0x9d54a800]
14:46:31 INFO - ++DOMWINDOW == 50 (0xa2702400) [pid = 3789] [serial = 98] [outer = 0x9d54a800]
14:46:32 INFO - MEMORY STAT | vsize 838MB | residentFast 230MB | heapAllocated 89MB
14:46:32 INFO - TEST-OK | toolkit/content/tests/browser/browser_bug594509.js | took 1276ms
14:46:32 INFO - ++DOCSHELL 0x89a44000 == 29 [pid = 3789] [id = 36]
14:46:32 INFO - ++DOMWINDOW == 51 (0x89aea000) [pid = 3789] [serial = 99] [outer = (nil)]
14:46:32 INFO - ++DOMWINDOW == 52 (0x9ae15800) [pid = 3789] [serial = 100] [outer = 0x89aea000]
14:46:33 INFO - checking window state
14:46:33 INFO - TEST-START | toolkit/content/tests/browser/browser_bug982298.js
14:46:33 INFO - ++DOCSHELL 0x9d603400 == 30 [pid = 3789] [id = 37]
14:46:33 INFO - ++DOMWINDOW == 53 (0x9d611400) [pid = 3789] [serial = 101] [outer = (nil)]
14:46:33 INFO - ++DOMWINDOW == 54 (0xa18b8c00) [pid = 3789] [serial = 102] [outer = 0x9d611400]
14:46:34 INFO - [3789] WARNING: bad indx: 'indx >= 0', file /builds/slave/m-aurora-lx-d-0000000000000000/build/src/dom/base/nsContentIterator.cpp, line 659
14:46:34 INFO - [3789] WARNING: bad indx: 'indx >= 0', file /builds/slave/m-aurora-lx-d-0000000000000000/build/src/dom/base/nsContentIterator.cpp, line 668
14:46:34 INFO - [3789] WARNING: bad indx: 'indx >= 0', file /builds/slave/m-aurora-lx-d-0000000000000000/build/src/dom/base/nsContentIterator.cpp, line 659
14:46:34 INFO - [3789] WARNING: bad indx: 'indx >= 0', file /builds/slave/m-aurora-lx-d-0000000000000000/build/src/dom/base/nsContentIterator.cpp, line 668
14:46:34 INFO - ++DOMWINDOW == 55 (0x9351f400) [pid = 3789] [serial = 103] [outer = 0x9d611400]
14:46:35 INFO - MEMORY STAT | vsize 838MB | residentFast 230MB | heapAllocated 89MB
14:46:35 INFO - TEST-OK | toolkit/content/tests/browser/browser_bug982298.js | took 1808ms
14:46:35 INFO - ++DOCSHELL 0x93a5d800 == 31 [pid = 3789] [id = 38]
14:46:35 INFO - ++DOMWINDOW == 56 (0x93a5dc00) [pid = 3789] [serial = 104] [outer = (nil)]
14:46:35 INFO - ++DOMWINDOW == 57 (0x93a61000) [pid = 3789] [serial = 105] [outer = 0x93a5dc00]
14:46:35 INFO - checking window state
14:46:35 INFO - TEST-START | toolkit/content/tests/browser/browser_contentTitle.js
14:46:35 INFO - ++DOCSHELL 0x93a64400 == 32 [pid = 3789] [id = 39]
14:46:35 INFO - ++DOMWINDOW == 58 (0x93a66000) [pid = 3789] [serial = 106] [outer = (nil)]
14:46:35 INFO - ++DOMWINDOW == 59 (0xa2b69400) [pid = 3789] [serial = 107] [outer = 0x93a66000]
14:46:36 INFO - ++DOMWINDOW == 60 (0x96620c00) [pid = 3789] [serial = 108] [outer = 0x93a66000]
14:46:36 INFO - Script!
14:46:36 INFO - MEMORY STAT | vsize 838MB | residentFast 232MB | heapAllocated 91MB
14:46:36 INFO - TEST-OK | toolkit/content/tests/browser/browser_contentTitle.js | took 1329ms
14:46:36 INFO - ++DOCSHELL 0xa57bfc00 == 33 [pid = 3789] [id = 40]
14:46:36 INFO - ++DOMWINDOW == 61 (0xa57c0000) [pid = 3789] [serial = 109] [outer = (nil)]
14:46:36 INFO - ++DOMWINDOW == 62 (0xa6c1fc00) [pid = 3789] [serial = 110] [outer = 0xa57c0000]
14:46:37 INFO - checking window state
14:46:37 INFO - TEST-START | toolkit/content/tests/browser/browser_default_image_filename.js
14:46:39 INFO - spec=/index
14:46:39 INFO - [3789] WARNING: malformed url: no scheme: file /builds/slave/m-aurora-lx-d-0000000000000000/build/src/netwerk/base/nsStandardURL.cpp, line 1008
14:46:39 INFO - MEMORY STAT | vsize 842MB | residentFast 249MB | heapAllocated 106MB
14:46:39 INFO - TEST-OK | toolkit/content/tests/browser/browser_default_image_filename.js | took 2349ms
14:46:39 INFO - ++DOCSHELL 0x93aa7800 == 34 [pid = 3789] [id = 41]
14:46:39 INFO - ++DOMWINDOW == 63 (0x93aa7c00) [pid = 3789] [serial = 111] [outer = (nil)]
14:46:39 INFO - ++DOMWINDOW == 64 (0x89402c00) [pid = 3789] [serial = 112] [outer = 0x93aa7c00]
14:46:39 INFO - [3789] WARNING: NS_ENSURE_TRUE(mDoneSetup) failed: file /builds/slave/m-aurora-lx-d-0000000000000000/build/src/editor/composer/nsEditingSession.cpp, line 1283
14:46:39 INFO - checking window state
14:46:40 INFO - TEST-START | toolkit/content/tests/browser/browser_f7_caret_browsing.js
14:46:40 INFO - ++DOCSHELL 0x8940a400 == 35 [pid = 3789] [id = 42]
14:46:40 INFO - ++DOMWINDOW == 65 (0x8940ac00) [pid = 3789] [serial = 113] [outer = (nil)]
14:46:40 INFO - ++DOMWINDOW == 66 (0x8940e000) [pid = 3789] [serial = 114] [outer = 0x8940ac00]
14:46:41 INFO - ++DOCSHELL 0x93aae800 == 36 [pid = 3789] [id = 43]
14:46:41 INFO - ++DOMWINDOW == 67 (0x93ab0000) [pid = 3789] [serial = 115] [outer = (nil)]
14:46:41 INFO - ++DOMWINDOW == 68 (0x93ab0c00) [pid = 3789] [serial = 116] [outer = 0x93ab0000]
14:46:41 INFO - --DOCSHELL 0x93aae800 == 35 [pid = 3789] [id = 43]
14:46:42 INFO - ++DOCSHELL 0xa8862400 == 36 [pid = 3789] [id = 44]
14:46:42 INFO - ++DOMWINDOW == 69 (0xa8862800) [pid = 3789] [serial = 117] [outer = (nil)]
14:46:42 INFO - ++DOMWINDOW == 70 (0xa8863000) [pid = 3789] [serial = 118] [outer = 0xa8862800]
14:46:42 INFO - --DOCSHELL 0xa8862400 == 35 [pid = 3789] [id = 44]
14:46:43 INFO - ++DOCSHELL 0x999d7400 == 36 [pid = 3789] [id = 45]
14:46:43 INFO - ++DOMWINDOW == 71 (0x999d7800) [pid = 3789] [serial = 119] [outer = (nil)]
14:46:43 INFO - ++DOMWINDOW == 72 (0x999d8000) [pid = 3789] [serial = 120] [outer = 0x999d7800]
14:46:44 INFO - --DOCSHELL 0x999d7400 == 35 [pid = 3789] [id = 45]
14:46:44 INFO - ++DOCSHELL 0x89404c00 == 36 [pid = 3789] [id = 46]
14:46:44 INFO - ++DOMWINDOW == 73 (0x89408c00) [pid = 3789] [serial = 121] [outer = (nil)]
14:46:45 INFO - ++DOMWINDOW == 74 (0xa8863800) [pid = 3789] [serial = 122] [outer = 0x89408c00]
14:46:45 INFO - ++DOCSHELL 0x83c89000 == 37 [pid = 3789] [id = 47]
14:46:45 INFO - ++DOMWINDOW == 75 (0x83c89800) [pid = 3789] [serial = 123] [outer = (nil)]
14:46:45 INFO - ++DOMWINDOW == 76 (0x83c8a400) [pid = 3789] [serial = 124] [outer = 0x83c89800]
14:46:46 INFO - --DOCSHELL 0x83c89000 == 36 [pid = 3789] [id = 47]
14:46:47 INFO - ++DOCSHELL 0x83c81c00 == 37 [pid = 3789] [id = 48]
14:46:47 INFO - ++DOMWINDOW == 77 (0x83d66c00) [pid = 3789] [serial = 125] [outer = (nil)]
14:46:47 INFO - ++DOMWINDOW == 78 (0x83d6b400) [pid = 3789] [serial = 126] [outer = 0x83d66c00]
14:46:47 INFO - ++DOCSHELL 0x83d70000 == 38 [pid = 3789] [id = 49]
14:46:47 INFO - ++DOMWINDOW == 79 (0x83d71000) [pid = 3789] [serial = 127] [outer = (nil)]
14:46:47 INFO - ++DOMWINDOW == 80 (0x83d72000) [pid = 3789] [serial = 128] [outer = 0x83d71000]
14:46:48 INFO - --DOCSHELL 0x83d70000 == 37 [pid = 3789] [id = 49]
14:46:48 INFO - --DOCSHELL 0x9a5de800 == 36 [pid = 3789] [id = 31]
14:46:48 INFO - --DOCSHELL 0x9a5dc400 == 35 [pid = 3789] [id = 30]
14:46:48 INFO - --DOCSHELL 0x99118000 == 34 [pid = 3789] [id = 29]
14:46:48 INFO - --DOCSHELL 0x930a5800 == 33 [pid = 3789] [id = 28]
14:46:48 INFO - --DOCSHELL 0x97193000 == 32 [pid = 3789] [id = 19]
14:46:48 INFO - --DOCSHELL 0x93585c00 == 31 [pid = 3789] [id = 27]
14:46:48 INFO - --DOMWINDOW == 79 (0xa2bf0c00) [pid = 3789] [serial = 65] [outer = (nil)] [url = about:blank]
14:46:49 INFO - MEMORY STAT | vsize 846MB | residentFast 249MB | heapAllocated 99MB
14:46:49 INFO - TEST-OK | toolkit/content/tests/browser/browser_f7_caret_browsing.js | took 9361ms
14:46:49 INFO - ++DOCSHELL 0x83d71c00 == 32 [pid = 3789] [id = 50]
14:46:49 INFO - ++DOMWINDOW == 80 (0x83d73000) [pid = 3789] [serial = 129] [outer = (nil)]
14:46:49 INFO - ++DOMWINDOW == 81 (0x8971d000) [pid = 3789] [serial = 130] [outer = 0x83d73000]
14:46:49 INFO - checking window state
14:46:49 INFO - TEST-START | toolkit/content/tests/browser/browser_findbar.js
14:46:49 INFO - ++DOCSHELL 0x89a44400 == 33 [pid = 3789] [id = 51]
14:46:49 INFO - ++DOMWINDOW == 82 (0x89a44800) [pid = 3789] [serial = 131] [outer = (nil)]
14:46:49 INFO - ++DOMWINDOW == 83 (0x89ae0c00) [pid = 3789] [serial = 132] [outer = 0x89a44800]
14:46:51 INFO - ++DOCSHELL 0x9309f000 == 34 [pid = 3789] [id = 52]
14:46:51 INFO - ++DOMWINDOW == 84 (0x930a5800) [pid = 3789] [serial = 133] [outer = (nil)]
14:46:52 INFO - ++DOMWINDOW == 85 (0x930aa400) [pid = 3789] [serial = 134] [outer = 0x930a5800]
14:46:52 INFO - ++DOCSHELL 0x9334e400 == 35 [pid = 3789] [id = 53]
14:46:52 INFO - ++DOMWINDOW == 86 (0x93584400) [pid = 3789] [serial = 135] [outer = (nil)]
14:46:53 INFO - ++DOMWINDOW == 87 (0x93748c00) [pid = 3789] [serial = 136] [outer = 0x93584400]
14:46:53 INFO - --DOMWINDOW == 86 (0x930a8000) [pid = 3789] [serial = 76] [outer = (nil)] [url = about:blank]
14:46:53 INFO - --DOMWINDOW == 85 (0x9a5df000) [pid = 3789] [serial = 82] [outer = (nil)] [url = about:blank]
14:46:53 INFO - --DOMWINDOW == 84 (0x99821800) [pid = 3789] [serial = 80] [outer = (nil)] [url = about:blank]
14:46:53 INFO - --DOMWINDOW == 83 (0x89717000) [pid = 3789] [serial = 70] [outer = (nil)] [url = about:blank]
14:46:53 INFO - --DOMWINDOW == 82 (0x9ae09000) [pid = 3789] [serial = 90] [outer = (nil)] [url = about:blank]
14:46:53 INFO - --DOMWINDOW == 81 (0x93586000) [pid = 3789] [serial = 73] [outer = (nil)] [url = about:blank]
14:46:53 INFO - --DOMWINDOW == 80 (0x9a5dd800) [pid = 3789] [serial = 81] [outer = (nil)] [url = data:text/html,]
14:46:53 INFO - --DOMWINDOW == 79 (0xa57bdc00) [pid = 3789] [serial = 68] [outer = (nil)] [url = data:text/html,]
14:46:53 INFO - --DOMWINDOW == 78 (0x89ae1c00) [pid = 3789] [serial = 87] [outer = (nil)] [url = about:blank]
14:46:56 INFO - ++DOCSHELL 0x83974c00 == 36 [pid = 3789] [id = 54]
14:46:56 INFO - ++DOMWINDOW == 79 (0x83975400) [pid = 3789] [serial = 137] [outer = (nil)]
14:46:56 INFO - ++DOMWINDOW == 80 (0x83c8d800) [pid = 3789] [serial = 138] [outer = 0x83975400]
14:46:56 INFO - ++DOCSHELL 0x83d6c400 == 37 [pid = 3789] [id = 55]
14:46:56 INFO - ++DOMWINDOW == 81 (0x83d6f800) [pid = 3789] [serial = 139] [outer = (nil)]
14:46:56 INFO - ++DOMWINDOW == 82 (0x89426400) [pid = 3789] [serial = 140] [outer = 0x83d6f800]
14:47:03 INFO - MEMORY STAT | vsize 857MB | residentFast 252MB | heapAllocated 97MB
14:47:03 INFO - TEST-OK | toolkit/content/tests/browser/browser_findbar.js | took 13355ms
14:47:03 INFO - ++DOCSHELL 0x89421400 == 38 [pid = 3789] [id = 56]
14:47:03 INFO - ++DOMWINDOW == 83 (0x89421c00) [pid = 3789] [serial = 141] [outer = (nil)]
14:47:03 INFO - ++DOMWINDOW == 84 (0x895b1800) [pid = 3789] [serial = 142] [outer = 0x89421c00]
14:47:03 INFO - checking window state
14:47:03 INFO - TEST-START | toolkit/content/tests/browser/browser_isSynthetic.js
14:47:04 INFO - ++DOCSHELL 0x89420000 == 39 [pid = 3789] [id = 57]
14:47:04 INFO - ++DOMWINDOW == 85 (0x89701400) [pid = 3789] [serial = 143] [outer = (nil)]
14:47:04 INFO - ++DOMWINDOW == 86 (0x89717000) [pid = 3789] [serial = 144] [outer = 0x89701400]
14:47:04 INFO - ++DOMWINDOW == 87 (0x89422000) [pid = 3789] [serial = 145] [outer = 0x89701400]
14:47:04 INFO - ++DOMWINDOW == 88 (0x89429800) [pid = 3789] [serial = 146] [outer = 0x89701400]
14:47:05 INFO - --DOCSHELL 0x9309f000 == 38 [pid = 3789] [id = 52]
14:47:05 INFO - --DOCSHELL 0x9ae20400 == 37 [pid = 3789] [id = 20]
14:47:05 INFO - --DOCSHELL 0x89a44400 == 36 [pid = 3789] [id = 51]
14:47:05 INFO - --DOCSHELL 0x83c81c00 == 35 [pid = 3789] [id = 48]
14:47:05 INFO - --DOCSHELL 0x8940a400 == 34 [pid = 3789] [id = 42]
14:47:05 INFO - --DOCSHELL 0x93aa7800 == 33 [pid = 3789] [id = 41]
14:47:05 INFO - --DOCSHELL 0xa57bfc00 == 32 [pid = 3789] [id = 40]
14:47:05 INFO - --DOCSHELL 0x93a64400 == 31 [pid = 3789] [id = 39]
14:47:05 INFO - --DOCSHELL 0x93a5d800 == 30 [pid = 3789] [id = 38]
14:47:05 INFO - --DOCSHELL 0x89a44000 == 29 [pid = 3789] [id = 36]
14:47:05 INFO - --DOMWINDOW == 87 (0x9553f400) [pid = 3789] [serial = 88] [outer = (nil)] [url = about:blank]
14:47:05 INFO - --DOMWINDOW == 86 (0x9ad8fc00) [pid = 3789] [serial = 85] [outer = (nil)] [url = about:blank]
14:47:05 INFO - --DOMWINDOW == 85 (0x9a5d4c00) [pid = 3789] [serial = 83] [outer = (nil)] [url = about:blank]
14:47:05 INFO - --DOMWINDOW == 84 (0x9ae12000) [pid = 3789] [serial = 91] [outer = (nil)] [url = about:blank]
14:47:05 INFO - --DOMWINDOW == 83 (0x9ad89400) [pid = 3789] [serial = 84] [outer = (nil)] [url = data:text/html,]
14:47:05 INFO - --DOMWINDOW == 82 (0x8f565c00) [pid = 3789] [serial = 77] [outer = (nil)] [url = about:blank]
14:47:05 INFO - --DOMWINDOW == 81 (0x83974400) [pid = 3789] [serial = 71] [outer = (nil)] [url = about:blank]
14:47:05 INFO - --DOMWINDOW == 80 (0x96674400) [pid = 3789] [serial = 89] [outer = (nil)] [url = about:blank]
14:47:05 INFO - --DOMWINDOW == 79 (0x9ae16400) [pid = 3789] [serial = 92] [outer = (nil)] [url = about:blank]
14:47:05 INFO - --DOMWINDOW == 78 (0x9358c000) [pid = 3789] [serial = 74] [outer = (nil)] [url = about:blank]
14:47:05 INFO - --DOMWINDOW == 77 (0x9334a000) [pid = 3789] [serial = 72] [outer = (nil)] [url = data:text/html,%20%20%20%20%20%20%20%20%20%20%20%20]
14:47:05 INFO - --DOMWINDOW == 76 (0x9309c800) [pid = 3789] [serial = 75] [outer = (nil)] [url = data:text/html,%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20%20]
14:47:05 INFO - --DOMWINDOW == 75 (0x97074400) [pid = 3789] [serial = 78] [outer = (nil)] [url = data:text/html,]
14:47:05 INFO - --DOMWINDOW == 74 (0x996dc000) [pid = 3789] [serial = 79] [outer = (nil)] [url = data:text/html,"> filler%20to%20make%20document%20overflow:%20scroll; ]
14:47:05 INFO - --DOMWINDOW == 73 (0x89bb1c00) [pid = 3789] [serial = 86] [outer = (nil)] [url = data:text/html,link]
14:47:05 INFO - --DOMWINDOW == 72 (0x9c71e800) [pid = 3789] [serial = 93] [outer = (nil)] [url = data:text/html,]
14:47:05 INFO - --DOMWINDOW == 71 (0xa57c1000) [pid = 3789] [serial = 69] [outer = (nil)] [url = about:blank]
14:47:05 INFO - --DOMWINDOW == 70 (0x9e457800) [pid = 3789] [serial = 97] [outer = (nil)] [url = about:blank]
14:47:05 INFO - ++DOMWINDOW == 71 (0x8940f800) [pid = 3789] [serial = 147] [outer = 0x89701400]
14:47:07 INFO - MEMORY STAT | vsize 851MB | residentFast 243MB | heapAllocated 93MB
14:47:07 INFO - TEST-OK | toolkit/content/tests/browser/browser_isSynthetic.js | took 3218ms
14:47:07 INFO - ++DOCSHELL 0x89ae9c00 == 30 [pid = 3789] [id = 58]
14:47:07 INFO - ++DOMWINDOW == 72 (0x89aea800) [pid = 3789] [serial = 148] [outer = (nil)]
14:47:07 INFO - ++DOMWINDOW == 73 (0x89bb1000) [pid = 3789] [serial = 149] [outer = 0x89aea800]
14:47:07 INFO - checking window state
14:47:07 INFO - TEST-START | toolkit/content/tests/browser/browser_keyevents_during_autoscrolling.js
14:47:08 INFO - MEMORY STAT | vsize 852MB | residentFast 247MB | heapAllocated 97MB
14:47:08 INFO - TEST-OK | toolkit/content/tests/browser/browser_keyevents_during_autoscrolling.js | took 992ms
14:47:08 INFO - ++DOCSHELL 0x93524c00 == 31 [pid = 3789] [id = 59]
14:47:08 INFO - ++DOMWINDOW == 74 (0x93526800) [pid = 3789] [serial = 150] [outer = (nil)]
14:47:08 INFO - ++DOMWINDOW == 75 (0x93582800) [pid = 3789] [serial = 151] [outer = 0x93526800]
14:47:09 INFO - checking window state
14:47:09 INFO - TEST-START | toolkit/content/tests/browser/browser_label_textlink.js
14:47:09 INFO - ++DOCSHELL 0x9309bc00 == 32 [pid = 3789] [id = 60]
14:47:09 INFO - ++DOMWINDOW == 76 (0x9309c000) [pid = 3789] [serial = 152] [outer = (nil)]
14:47:09 INFO - ++DOMWINDOW == 77 (0x93a63c00) [pid = 3789] [serial = 153] [outer = 0x9309c000]
14:47:09 INFO - ++DOMWINDOW == 78 (0x9309e800) [pid = 3789] [serial = 154] [outer = 0x9309c000]
14:47:10 INFO - --DOMWINDOW == 77 (0x89a44800) [pid = 3789] [serial = 131] [outer = (nil)] [url = data:text/html;charset=utf-8,The%20letter%20s.]
14:47:10 INFO - --DOMWINDOW == 76 (0x8940ac00) [pid = 3789] [serial = 113] [outer = (nil)] [url = data:text/html;charset=utf-8,Caret%20browsing%20is%20fun.]
14:47:10 INFO - --DOMWINDOW == 75 (0x89408c00) [pid = 3789] [serial = 121] [outer = (nil)] [url = data:text/html;charset=utf-8,Caret%20browsing%20is%20fun.]
14:47:10 INFO - --DOMWINDOW == 74 (0x83d66c00) [pid = 3789] [serial = 125] [outer = (nil)] [url = data:text/html;charset=utf-8,Caret%20browsing%20is%20fun.]
14:47:10 INFO - --DOMWINDOW == 73 (0x83d71000) [pid = 3789] [serial = 127] [outer = (nil)] [url = chrome://global/content/commonDialog.xul]
14:47:10 INFO - --DOMWINDOW == 72 (0x9d8da800) [pid = 3789] [serial = 94] [outer = (nil)] [url = about:blank]
14:47:10 INFO - --DOMWINDOW == 71 (0x9d54a800) [pid = 3789] [serial = 96] [outer = (nil)] [url = about:rights]
14:47:10 INFO - --DOMWINDOW == 70 (0x89aea000) [pid = 3789] [serial = 99] [outer = (nil)] [url = about:blank]
14:47:10 INFO - --DOMWINDOW == 69 (0x9d611400) [pid = 3789] [serial = 101] [outer = (nil)] [url = about:blank]
14:47:10 INFO - --DOMWINDOW == 68 (0x93a5dc00) [pid = 3789] [serial = 104] [outer = (nil)] [url = about:blank]
14:47:10 INFO - --DOMWINDOW == 67 (0x93a66000) [pid = 3789] [serial = 106] [outer = (nil)] [url = https://example.com/browser/toolkit/content/tests/browser/file_contentTitle.html]
14:47:10 INFO - --DOMWINDOW == 66 (0xa57c0000) [pid = 3789] [serial = 109] [outer = (nil)] [url = data:image/gif;base64,R0lGODlhEAAOALMAAOazToeHh0tLS/7LZv/0jvb29t/f3//Ub//ge8WSLf/rhf/3kdbW1mxsbP//mf///yH5BAAAAAAALAAAAAAQAA4AAARe8L1Ekyky67QZ1hLnjM5UUde0ECwLJoExKcppV0aCcGCmTIHEIUEqjgaORCMxIC6e0CcguWw6aFjsVMkkIr7g77ZKPJjPZqIyd7sJAgVGoEGv2xsBxqNgYPj/gAwXEQA7]
14:47:10 INFO - --DOMWINDOW == 65 (0x93aa7c00) [pid = 3789] [serial = 111] [outer = (nil)] [url = about:blank]
14:47:10 INFO - --DOMWINDOW == 64 (0x930a5800) [pid = 3789] [serial = 133] [outer = (nil)] [url = data:text/html;charset=utf-8,The%20letter%20s.]
14:47:10 INFO - --DOMWINDOW == 63 (0x9d157000) [pid = 3789] [serial = 58] [outer = (nil)] [url = about:preferences]
14:47:11 INFO - ++DOCSHELL 0x96629800 == 33 [pid = 3789] [id = 61]
14:47:11 INFO - ++DOMWINDOW == 64 (0x96629c00) [pid = 3789] [serial = 155] [outer = (nil)]
14:47:11 INFO - ++DOMWINDOW == 65 (0x966c8800) [pid = 3789] [serial = 156] [outer = 0x96629c00]
14:47:11 INFO - ++DOMWINDOW == 66 (0x9690e800) [pid = 3789] [serial = 157] [outer = 0x96629c00]
14:47:12 INFO - ++DOCSHELL 0x83c83c00 == 34 [pid = 3789] [id = 62]
14:47:12 INFO - ++DOMWINDOW == 67 (0x83c86c00) [pid = 3789] [serial = 158] [outer = (nil)]
14:47:12 INFO - ++DOMWINDOW == 68 (0x8940f400) [pid = 3789] [serial = 159] [outer = 0x83c86c00]
14:47:13 INFO - ++DOMWINDOW == 69 (0x8970e400) [pid = 3789] [serial = 160] [outer = 0x83c86c00]
14:47:13 INFO - ++DOCSHELL 0x83973800 == 35 [pid = 3789] [id = 63]
14:47:13 INFO - ++DOMWINDOW == 70 (0x895ae000) [pid = 3789] [serial = 161] [outer = (nil)]
14:47:13 INFO - ++DOMWINDOW == 71 (0x8979a000) [pid = 3789] [serial = 162] [outer = 0x895ae000]
14:47:14 INFO - ++DOMWINDOW == 72 (0x89be1c00) [pid = 3789] [serial = 163] [outer = 0x895ae000]
14:47:15 INFO - MEMORY STAT | vsize 856MB | residentFast 249MB | heapAllocated 97MB
14:47:15 INFO - TEST-OK | toolkit/content/tests/browser/browser_label_textlink.js | took 6404ms
14:47:15 INFO - ++DOCSHELL 0x93523400 == 36 [pid = 3789] [id = 64]
14:47:15 INFO - ++DOMWINDOW == 73 (0x93523c00) [pid = 3789] [serial = 164] [outer = (nil)]
14:47:15 INFO - ++DOMWINDOW == 74 (0x9374d400) [pid = 3789] [serial = 165] [outer = 0x93523c00]
14:47:15 INFO - checking window state
14:47:16 INFO - TEST-START | toolkit/content/tests/browser/browser_mediaPlayback.js
14:47:16 INFO - ++DOCSHELL 0x93aa1000 == 37 [pid = 3789] [id = 65]
14:47:16 INFO - ++DOMWINDOW == 75 (0x93aa1400) [pid = 3789] [serial = 166] [outer = (nil)]
14:47:16 INFO - ++DOMWINDOW == 76 (0x9553e400) [pid = 3789] [serial = 167] [outer = 0x93aa1400]
14:47:16 INFO - ++DOMWINDOW == 77 (0x89be2000) [pid = 3789] [serial = 168] [outer = 0x93aa1400]
14:47:16 INFO - ++DOMWINDOW == 78 (0x9710d800) [pid = 3789] [serial = 169] [outer = 0x93aa1400]
14:47:19 INFO - ++DOCSHELL 0x98b7a400 == 38 [pid = 3789] [id = 66]
14:47:19 INFO - ++DOMWINDOW == 79 (0x98b82800) [pid = 3789] [serial = 170] [outer = (nil)]
14:47:20 INFO - ++DOMWINDOW == 80 (0x98cee800) [pid = 3789] [serial = 171] [outer = 0x98b82800]
14:47:20 INFO - ++DOMWINDOW == 81 (0x9374bc00) [pid = 3789] [serial = 172] [outer = 0x98b82800]
14:47:20 INFO - ++DOMWINDOW == 82 (0x9982c400) [pid = 3789] [serial = 173] [outer = 0x98b82800]
14:47:21 INFO - ++DOCSHELL 0x99884400 == 39 [pid = 3789] [id = 67]
14:47:21 INFO - ++DOMWINDOW == 83 (0x99884800) [pid = 3789] [serial = 174] [outer = (nil)]
14:47:21 INFO - ++DOMWINDOW == 84 (0x89be8800) [pid = 3789] [serial = 175] [outer = 0x99884800]
14:47:23 INFO - --DOCSHELL 0x96629800 == 38 [pid = 3789] [id = 61]
14:47:23 INFO - --DOCSHELL 0x89ae9c00 == 37 [pid = 3789] [id = 58]
14:47:23 INFO - --DOMWINDOW == 83 (0x9d907000) [pid = 3789] [serial = 63] [outer = (nil)] [url = about:preferences]
14:47:23 INFO - --DOMWINDOW == 82 (0x83d72000) [pid = 3789] [serial = 128] [outer = (nil)] [url = about:blank]
14:47:23 INFO - --DOCSHELL 0x89420000 == 36 [pid = 3789] [id = 57]
14:47:23 INFO - --DOCSHELL 0x83d71c00 == 35 [pid = 3789] [id = 50]
14:47:23 INFO - --DOCSHELL 0x89421400 == 34 [pid = 3789] [id = 56]
14:47:23 INFO - --DOMWINDOW == 81 (0xa2b69400) [pid = 3789] [serial = 107] [outer = (nil)] [url = about:blank]
14:47:23 INFO - --DOMWINDOW == 80 (0x930aa400) [pid = 3789] [serial = 134] [outer = (nil)] [url = about:blank]
14:47:23 INFO - --DOMWINDOW == 79 (0x89ae0c00) [pid = 3789] [serial = 132] [outer = (nil)] [url = about:blank]
14:47:23 INFO - --DOMWINDOW == 78 (0x83d6b400) [pid = 3789] [serial = 126] [outer = (nil)] [url = about:blank]
14:47:23 INFO - --DOMWINDOW == 77 (0xa8863800) [pid = 3789] [serial = 122] [outer = (nil)] [url = about:blank]
14:47:23 INFO - --DOMWINDOW == 76 (0x8940e000) [pid = 3789] [serial = 114] [outer = (nil)] [url = about:blank]
14:47:23 INFO - --DOMWINDOW == 75 (0x89402c00) [pid = 3789] [serial = 112] [outer = (nil)] [url = about:blank]
14:47:23 INFO - --DOMWINDOW == 74 (0xa6c1fc00) [pid = 3789] [serial = 110] [outer = (nil)] [url = about:blank]
14:47:23 INFO - --DOMWINDOW == 73 (0x96620c00) [pid = 3789] [serial = 108] [outer = (nil)] [url = https://example.com/browser/toolkit/content/tests/browser/file_contentTitle.html]
14:47:23 INFO - --DOMWINDOW == 72 (0x93a61000) [pid = 3789] [serial = 105] [outer = (nil)] [url = about:blank]
14:47:23 INFO - --DOMWINDOW == 71 (0xa18b8c00) [pid = 3789] [serial = 102] [outer = (nil)] [url = about:blank]
14:47:23 INFO - --DOMWINDOW == 70 (0x9351f400) [pid = 3789] [serial = 103] [outer = (nil)] [url = about:blank]
14:47:23 INFO - --DOMWINDOW == 69 (0x9ae15800) [pid = 3789] [serial = 100] [outer = (nil)] [url = about:blank]
14:47:23 INFO - --DOMWINDOW == 68 (0xa2702400) [pid = 3789] [serial = 98] [outer = (nil)] [url = about:rights]
14:47:23 INFO - --DOMWINDOW == 67 (0x9d97f000) [pid = 3789] [serial = 95] [outer = (nil)] [url = about:blank]
14:47:24 INFO - MEMORY STAT | vsize 853MB | residentFast 244MB | heapAllocated 94MB
14:47:24 INFO - TEST-OK | toolkit/content/tests/browser/browser_mediaPlayback.js | took 8316ms
14:47:24 INFO - ++DOCSHELL 0x8941e800 == 35 [pid = 3789] [id = 68]
14:47:24 INFO - ++DOMWINDOW == 68 (0x8941ec00) [pid = 3789] [serial = 176] [outer = (nil)]
14:47:24 INFO - ++DOMWINDOW == 69 (0x89427800) [pid = 3789] [serial = 177] [outer = 0x8941ec00]
14:47:24 INFO - checking window state
14:47:24 INFO - TEST-START | toolkit/content/tests/browser/browser_mediaPlayback_mute.js
14:47:24 INFO - ++DOCSHELL 0x89716800 == 36 [pid = 3789] [id = 69]
14:47:24 INFO - ++DOMWINDOW == 70 (0x8971a800) [pid = 3789] [serial = 178] [outer = (nil)]
14:47:24 INFO - ++DOMWINDOW == 71 (0x8979a800) [pid = 3789] [serial = 179] [outer = 0x8971a800]
14:47:25 INFO - ++DOMWINDOW == 72 (0x89ae1c00) [pid = 3789] [serial = 180] [outer = 0x8971a800]
14:47:25 INFO - ++DOMWINDOW == 73 (0x89be3000) [pid = 3789] [serial = 181] [outer = 0x8971a800]
14:47:27 INFO - --DOMWINDOW == 72 (0x89aea800) [pid = 3789] [serial = 148] [outer = (nil)] [url = data:text/html,]
14:47:27 INFO - --DOMWINDOW == 71 (0x83d73000) [pid = 3789] [serial = 129] [outer = (nil)] [url = about:blank]
14:47:27 INFO - --DOMWINDOW == 70 (0x93584400) [pid = 3789] [serial = 135] [outer = (nil)] [url = data:text/html;charset=utf-8,The%20letter%20s.]
14:47:27 INFO - --DOMWINDOW == 69 (0x83d6f800) [pid = 3789] [serial = 139] [outer = (nil)] [url = data:text/html;charset=utf-8,The%20letter%20s.]
14:47:27 INFO - --DOMWINDOW == 68 (0x89421c00) [pid = 3789] [serial = 141] [outer = (nil)] [url = about:blank]
14:47:27 INFO - --DOMWINDOW == 67 (0x89701400) [pid = 3789] [serial = 143] [outer = (nil)] [url = http://example.com/browser/toolkit/content/tests/browser/empty.png]
14:47:27 INFO - --DOMWINDOW == 66 (0x96629c00) [pid = 3789] [serial = 155] [outer = (nil)] [url = http://www.example.com/]
14:47:28 INFO - ++DOCSHELL 0x930a9c00 == 37 [pid = 3789] [id = 70]
14:47:28 INFO - ++DOMWINDOW == 67 (0x93343400) [pid = 3789] [serial = 182] [outer = (nil)]
14:47:28 INFO - ++DOMWINDOW == 68 (0x9334ec00) [pid = 3789] [serial = 183] [outer = 0x93343400]
14:47:28 INFO - ++DOMWINDOW == 69 (0x93520800) [pid = 3789] [serial = 184] [outer = 0x93343400]
14:47:29 INFO - ++DOMWINDOW == 70 (0x93a9d000) [pid = 3789] [serial = 185] [outer = 0x93343400]
14:47:29 INFO - ++DOCSHELL 0x930a0c00 == 38 [pid = 3789] [id = 71]
14:47:29 INFO - ++DOMWINDOW == 71 (0x955c1000) [pid = 3789] [serial = 186] [outer = (nil)]
14:47:29 INFO - ++DOMWINDOW == 72 (0x96620c00) [pid = 3789] [serial = 187] [outer = 0x955c1000]
14:47:32 INFO - ++DOCSHELL 0x89429000 == 39 [pid = 3789] [id = 72]
14:47:32 INFO - ++DOMWINDOW == 73 (0x895af000) [pid = 3789] [serial = 188] [outer = (nil)]
14:47:32 INFO - ++DOMWINDOW == 74 (0x89a44800) [pid = 3789] [serial = 189] [outer = 0x895af000]
14:47:32 INFO - ++DOMWINDOW == 75 (0x89be3c00) [pid = 3789] [serial = 190] [outer = 0x895af000]
14:47:32 INFO - ++DOMWINDOW == 76 (0x9334bc00) [pid = 3789] [serial = 191] [outer = 0x895af000]
14:47:33 INFO - ++DOCSHELL 0x93aae800 == 40 [pid = 3789] [id = 73]
14:47:33 INFO - ++DOMWINDOW == 77 (0x93af5c00) [pid = 3789] [serial = 192] [outer = (nil)]
14:47:33 INFO - ++DOMWINDOW == 78 (0x9710e800) [pid = 3789] [serial = 193] [outer = 0x93af5c00]
14:47:33 INFO - ++DOMWINDOW == 79 (0x9358c000) [pid = 3789] [serial = 194] [outer = 0x93af5c00]
14:47:36 INFO - MEMORY STAT | vsize 855MB | residentFast 250MB | heapAllocated 98MB
14:47:36 INFO - TEST-OK | toolkit/content/tests/browser/browser_mediaPlayback_mute.js | took 11643ms
14:47:36 INFO - ++DOCSHELL 0x9987d000 == 41 [pid = 3789] [id = 74]
14:47:36 INFO - ++DOMWINDOW == 80 (0x9987dc00) [pid = 3789] [serial = 195] [outer = (nil)]
14:47:36 INFO - ++DOMWINDOW == 81 (0x999db400) [pid = 3789] [serial = 196] [outer = 0x9987dc00]
14:47:36 INFO - checking window state
14:47:36 INFO - TEST-START | toolkit/content/tests/browser/browser_mediaPlayback_suspended.js
14:47:36 INFO - ++DOCSHELL 0x89428c00 == 42 [pid = 3789] [id = 75]
14:47:36 INFO - ++DOMWINDOW == 82 (0x999e1000) [pid = 3789] [serial = 197] [outer = (nil)]
14:47:36 INFO - ++DOMWINDOW == 83 (0x999f2000) [pid = 3789] [serial = 198] [outer = 0x999e1000]
14:47:37 INFO - ++DOMWINDOW == 84 (0x9a534400) [pid = 3789] [serial = 199] [outer = 0x999e1000]
14:47:37 INFO - ++DOMWINDOW == 85 (0x9ad84000) [pid = 3789] [serial = 200] [outer = 0x999e1000]
14:47:38 INFO - ++DOCSHELL 0x9ae03400 == 43 [pid = 3789] [id = 76]
14:47:38 INFO - ++DOMWINDOW == 86 (0x9ae03800) [pid = 3789] [serial = 201] [outer = (nil)]
14:47:38 INFO - ++DOMWINDOW == 87 (0x9ae14000) [pid = 3789] [serial = 202] [outer = 0x9ae03800]
14:47:38 INFO - ++DOMWINDOW == 88 (0x9ae20000) [pid = 3789] [serial = 203] [outer = 0x9ae03800]
14:47:38 INFO - ++DOMWINDOW == 89 (0x9af5ac00) [pid = 3789] [serial = 204] [outer = 0x9ae03800]
14:47:39 INFO - ++DOCSHELL 0x9b65c000 == 44 [pid = 3789] [id = 77]
14:47:39 INFO - ++DOMWINDOW == 90 (0x9b65d000) [pid = 3789] [serial = 205] [outer = (nil)]
14:47:39 INFO - ++DOMWINDOW == 91 (0x9c722c00) [pid = 3789] [serial = 206] [outer = 0x9b65d000]
14:47:40 INFO - ++DOMWINDOW == 92 (0x9d1e4000) [pid = 3789] [serial = 207] [outer = 0x9b65d000]
14:47:40 INFO - ++DOMWINDOW == 93 (0x9d676800) [pid = 3789] [serial = 208] [outer = 0x9b65d000]
14:47:41 INFO - ++DOCSHELL 0xa1885c00 == 45 [pid = 3789] [id = 78]
14:47:41 INFO - ++DOMWINDOW == 94 (0xa188d800) [pid = 3789] [serial = 209] [outer = (nil)]
14:47:41 INFO - ++DOMWINDOW == 95 (0xa27b2800) [pid = 3789] [serial = 210] [outer = 0xa188d800]
14:47:41 INFO - ++DOMWINDOW == 96 (0xa2b31c00) [pid = 3789] [serial = 211] [outer = 0xa188d800]
14:47:41 INFO - ++DOMWINDOW == 97 (0xa2dc0400) [pid = 3789] [serial = 212] [outer = 0xa188d800]
14:47:43 INFO - --DOCSHELL 0x930a0c00 == 44 [pid = 3789] [id = 71]
14:47:43 INFO - --DOCSHELL 0x89716800 == 43 [pid = 3789] [id = 69]
14:47:43 INFO - --DOCSHELL 0x99884400 == 42 [pid = 3789] [id = 67]
14:47:43 INFO - --DOCSHELL 0x93aa1000 == 41 [pid = 3789] [id = 65]
14:47:43 INFO - --DOCSHELL 0x93523400 == 40 [pid = 3789] [id = 64]
14:47:43 INFO - --DOCSHELL 0x83973800 == 39 [pid = 3789] [id = 63]
14:47:43 INFO - --DOMWINDOW == 96 (0x93a63c00) [pid = 3789] [serial = 153] [outer = (nil)] [url = about:blank]
14:47:43 INFO - --DOCSHELL 0x83c83c00 == 38 [pid = 3789] [id = 62]
14:47:43 INFO - --DOCSHELL 0x9d603400 == 37 [pid = 3789] [id = 37]
14:47:43 INFO - --DOMWINDOW == 95 (0x8971d000) [pid = 3789] [serial = 130] [outer = (nil)] [url = about:blank]
14:47:43 INFO - --DOMWINDOW == 94 (0x89717000) [pid = 3789] [serial = 144] [outer = (nil)] [url = about:blank]
14:47:43 INFO - --DOMWINDOW == 93 (0x966c8800) [pid = 3789] [serial = 156] [outer = (nil)] [url = about:blank]
14:47:43 INFO - --DOMWINDOW == 92 (0x9690e800) [pid = 3789] [serial = 157] [outer = (nil)] [url = http://www.example.com/]
14:47:43 INFO - --DOMWINDOW == 91 (0x8940f800) [pid = 3789] [serial = 147] [outer = (nil)] [url = http://example.com/browser/toolkit/content/tests/browser/empty.png]
14:47:43 INFO - --DOMWINDOW == 90 (0x89426400) [pid = 3789] [serial = 140] [outer = (nil)] [url = about:blank]
14:47:43 INFO - --DOMWINDOW == 89 (0x89422000) [pid = 3789] [serial = 145] [outer = (nil)] [url = about:blank]
14:47:43 INFO - --DOMWINDOW == 88 (0x93748c00) [pid = 3789] [serial = 136] [outer = (nil)] [url = about:blank]
14:47:43 INFO - --DOMWINDOW == 87 (0x89429800) [pid = 3789] [serial = 146] [outer = (nil)] [url = data:text/html;charset=utf-8,foo ]
14:48:27 INFO - --DOMWINDOW == 26 (0x89ae1800) [pid = 3789] [serial = 245] [outer = (nil)] [url = data:text/html,]
14:48:27 INFO - --DOMWINDOW == 25 (0x89bdec00) [pid = 3789] [serial = 246] [outer = (nil)] [url = about:blank]
14:48:27 INFO - --DOMWINDOW == 24 (0x9ae10000) [pid = 3789] [serial = 22] [outer = (nil)] [url = about:newtab]
14:48:27 INFO - --DOMWINDOW == 23 (0x98b82800) [pid = 3789] [serial = 253] [outer = (nil)] [url = about:blank]
14:48:27 INFO - --DOMWINDOW == 22 (0x93ab0c00) [pid = 3789] [serial = 116] [outer = (nil)] [url = about:blank]
14:48:27 INFO - --DOMWINDOW == 21 (0x93520c00) [pid = 3789] [serial = 247] [outer = (nil)] [url = about:blank]
14:48:27 INFO - --DOMWINDOW == 20 (0x97194400) [pid = 3789] [serial = 263] [outer = (nil)] [url = http://mochi.test:8888/browser/toolkit/content/tests/browser/data/post_form_inner.sjs]
14:48:27 INFO - --DOMWINDOW == 19 (0x9ae07400) [pid = 3789] [serial = 18] [outer = (nil)] [url = data:application/vnd.mozilla.xul+xml;charset=utf-8,287/0/0 14:48:43 INFO - # TBPL SUCCESS # 14:48:43 INFO - The mochitest suite: browser-chrome-chunked ran with return status: SUCCESS 14:48:43 INFO - Running post-action listener: _package_coverage_data 14:48:43 INFO - Running post-action listener: _resource_record_post_action 14:48:43 INFO - [mozharness: 2017-01-18 22:48:43.818587Z] Finished run-tests step (success) 14:48:43 INFO - Running post-run listener: _resource_record_post_run 14:48:44 INFO - Validating Perfherder data against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:48:44 INFO - PERFHERDER_DATA: {"framework": {"name": "job_resource_usage"}, "suites": [{"subtests": [{"name": "cpu_percent", "value": 98.20227010388608}, {"name": "io_write_bytes", "value": 764338176}, {"name": "io.read_bytes", "value": 31649792}, {"name": "io_write_time", "value": 285296}, {"name": "io_read_time", "value": 1432}], "extraOptions": ["buildbot-m1.medium"], "name": "mochitest.browser-chrome-chunked.3.overall"}, {"subtests": [{"name": "time", "value": 31.833250045776367}, {"name": "cpu_percent", "value": 100.0}], "name": "mochitest.browser-chrome-chunked.3.install"}, {"subtests": [{"name": "time", "value": 0.00051116943359375}], "name": "mochitest.browser-chrome-chunked.3.stage-files"}, {"subtests": [{"name": "time", "value": 2570.2164599895477}, {"name": "cpu_percent", "value": 98.1798597584729}], "name": "mochitest.browser-chrome-chunked.3.run-tests"}]} 14:48:44 INFO - Total resource usage - Wall time: 2602s; CPU: 98.0%; Read bytes: 31649792; Write bytes: 764338176; Read time: 1432; Write time: 285296 14:48:44 INFO - TinderboxPrint: CPU usage 98.2% 14:48:44 INFO - TinderboxPrint: I/O read bytes / time 31,649,792 / 1,432 14:48:44 INFO - TinderboxPrint: I/O write bytes / time 764,338,176 / 285,296 14:48:44 INFO - TinderboxPrint: CPU idle 45.8 (1.8%) 14:48:44 INFO - TinderboxPrint: CPU system 201.1 (7.7%) 14:48:44 INFO - TinderboxPrint: CPU user 2,339.8 (90.0%) 14:48:44 INFO - TinderboxPrint: Swap in / out 0 / 0 14:48:44 INFO - install - Wall time: 32s; CPU: 100.0%; Read bytes: 16384; Write bytes: 135200768; Read time: 12; Write time: 130016 14:48:44 INFO - stage-files - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 14:48:44 INFO - run-tests - Wall time: 2570s; CPU: 98.0%; Read bytes: 30515200; Write bytes: 594300928; Read time: 1376; Write time: 118448 14:48:44 INFO - Running post-run listener: _upload_blobber_files 14:48:44 INFO - Blob upload gear active. 14:48:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:48:44 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with |