builder: fx-team_snowleopard-debug_test-mochitest-jetpack
slave: t-snow-r4-0089
starttime: 1445635085.83
results: success (0)
buildid: 20151023122333
builduid: e8d8543cd3994a439ed135bb864aff1f
revision: 4169913a206bbde202bd75c8729879885ad66b1d
========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-10-23 14:18:05.829902) =========
master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-10-23 14:18:05.830356) =========
========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-23 14:18:05.830842) =========
bash -c pwd
in dir /builds/slave/test/. (timeout 1200 secs)
watching logfiles {}
argv: ['bash', '-c', 'pwd']
environment:
Apple_PubSub_Socket_Render=/tmp/launch-7zzVAa/Render
DISPLAY=/tmp/launch-316zHK/org.x:0
GIT_SHARE_BASE_DIR=/builds/git-shared
HG_SHARE_BASE_DIR=/builds/hg-shared
HOME=/Users/cltbld
IDLEIZER_DISABLE_SHUTDOWN=true
LOGNAME=cltbld
PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11
PWD=/builds/slave/test
RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg
SHELL=/bin/bash
SSH_AUTH_SOCK=/tmp/launch-Hys23i/Listeners
TMPDIR=/var/folders/wU/wUQ0E3SdEVy607ra9oMDOU+++-k/-Tmp-/
TWISTD_LOG_PATH=/builds/slave/twistd.log
USER=cltbld
VERSIONER_PYTHON_PREFER_32_BIT=no
VERSIONER_PYTHON_VERSION=2.6
__CF_USER_TEXT_ENCODING=0x1C:0:0
using PTY: False
/builds/slave/test
program finished with exit code 0
elapsedTime=0.009108
basedir: '/builds/slave/test'
========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-10-23 14:18:06.272438) =========
========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-23 14:18:06.272772) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-10-23 14:18:06.341436) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-23 14:18:06.341819) =========
rm -rf properties
in dir /builds/slave/test/. (timeout 1200 secs)
watching logfiles {}
argv: ['rm', '-rf', 'properties']
environment:
Apple_PubSub_Socket_Render=/tmp/launch-7zzVAa/Render
DISPLAY=/tmp/launch-316zHK/org.x:0
GIT_SHARE_BASE_DIR=/builds/git-shared
HG_SHARE_BASE_DIR=/builds/hg-shared
HOME=/Users/cltbld
IDLEIZER_DISABLE_SHUTDOWN=true
LOGNAME=cltbld
PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11
PWD=/builds/slave/test
RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg
SHELL=/bin/bash
SSH_AUTH_SOCK=/tmp/launch-Hys23i/Listeners
TMPDIR=/var/folders/wU/wUQ0E3SdEVy607ra9oMDOU+++-k/-Tmp-/
TWISTD_LOG_PATH=/builds/slave/twistd.log
USER=cltbld
VERSIONER_PYTHON_PREFER_32_BIT=no
VERSIONER_PYTHON_VERSION=2.6
__CF_USER_TEXT_ENCODING=0x1C:0:0
using PTY: False
program finished with exit code 0
elapsedTime=0.023180
========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-10-23 14:18:06.467646) =========
========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-23 14:18:06.467943) =========
script_repo_url: https://hg.mozilla.org/build/mozharness
========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-10-23 14:18:06.468297) =========
========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-23 14:18:06.468586) =========
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:
Apple_PubSub_Socket_Render=/tmp/launch-7zzVAa/Render
DISPLAY=/tmp/launch-316zHK/org.x:0
GIT_SHARE_BASE_DIR=/builds/git-shared
HG_SHARE_BASE_DIR=/builds/hg-shared
HOME=/Users/cltbld
IDLEIZER_DISABLE_SHUTDOWN=true
LOGNAME=cltbld
PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11
PWD=/builds/slave/test
RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg
SHELL=/bin/bash
SSH_AUTH_SOCK=/tmp/launch-Hys23i/Listeners
TMPDIR=/var/folders/wU/wUQ0E3SdEVy607ra9oMDOU+++-k/-Tmp-/
TWISTD_LOG_PATH=/builds/slave/twistd.log
USER=cltbld
VERSIONER_PYTHON_PREFER_32_BIT=no
VERSIONER_PYTHON_VERSION=2.6
__CF_USER_TEXT_ENCODING=0x1C:0:0
using PTY: False
--2015-10-23 14:18:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py
Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25
Connecting to hg.mozilla.org|63.245.215.102|:443... connected.
HTTP request sent, awaiting response... 200 Script output follows
Length: 12141 (12K) [text/x-python]
Saving to: `archiver_client.py'
0K .......... . 100% 579M=0s
2015-10-23 14:18:07 (579 MB/s) - `archiver_client.py' saved [12141/12141]
program finished with exit code 0
elapsedTime=0.608867
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-10-23 14:18:07.102332) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 4 secs) (at 2015-10-23 14:18:07.102654) =========
rm -rf scripts
in dir /builds/slave/test/. (timeout 1200 secs)
watching logfiles {}
argv: ['rm', '-rf', 'scripts']
environment:
Apple_PubSub_Socket_Render=/tmp/launch-7zzVAa/Render
DISPLAY=/tmp/launch-316zHK/org.x:0
GIT_SHARE_BASE_DIR=/builds/git-shared
HG_SHARE_BASE_DIR=/builds/hg-shared
HOME=/Users/cltbld
IDLEIZER_DISABLE_SHUTDOWN=true
LOGNAME=cltbld
PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11
PWD=/builds/slave/test
RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg
SHELL=/bin/bash
SSH_AUTH_SOCK=/tmp/launch-Hys23i/Listeners
TMPDIR=/var/folders/wU/wUQ0E3SdEVy607ra9oMDOU+++-k/-Tmp-/
TWISTD_LOG_PATH=/builds/slave/twistd.log
USER=cltbld
VERSIONER_PYTHON_PREFER_32_BIT=no
VERSIONER_PYTHON_VERSION=2.6
__CF_USER_TEXT_ENCODING=0x1C:0:0
using PTY: False
program finished with exit code 0
elapsedTime=0.162698
========= Finished 'rm -rf ...' (results: 0, elapsed: 4 secs) (at 2015-10-23 14:18:11.236394) =========
========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-10-23 14:18:11.236736) =========
bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4169913a206bbde202bd75c8729879885ad66b1d --destination scripts --debug'
in dir /builds/slave/test/. (timeout 1200 secs)
watching logfiles {}
argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 4169913a206bbde202bd75c8729879885ad66b1d --destination scripts --debug']
environment:
Apple_PubSub_Socket_Render=/tmp/launch-7zzVAa/Render
DISPLAY=/tmp/launch-316zHK/org.x:0
GIT_SHARE_BASE_DIR=/builds/git-shared
HG_SHARE_BASE_DIR=/builds/hg-shared
HOME=/Users/cltbld
IDLEIZER_DISABLE_SHUTDOWN=true
LOGNAME=cltbld
PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11
PWD=/builds/slave/test
RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg
SHELL=/bin/bash
SSH_AUTH_SOCK=/tmp/launch-Hys23i/Listeners
TMPDIR=/var/folders/wU/wUQ0E3SdEVy607ra9oMDOU+++-k/-Tmp-/
TWISTD_LOG_PATH=/builds/slave/twistd.log
USER=cltbld
VERSIONER_PYTHON_PREFER_32_BIT=no
VERSIONER_PYTHON_VERSION=2.6
__CF_USER_TEXT_ENCODING=0x1C:0:0
using PTY: False
2015-10-23 14:18:11,471 truncating revision to first 12 chars
2015-10-23 14:18:11,471 Setting DEBUG logging.
2015-10-23 14:18:11,471 attempt 1/10
2015-10-23 14:18:11,471 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4169913a206b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2015-10-23 14:18:11,816 unpacking tar archive at: fx-team-4169913a206b/testing/mozharness/
program finished with exit code 0
elapsedTime=1.021997
========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-10-23 14:18:12.582564) =========
========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-23 14:18:12.582832) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-10-23 14:18:12.656363) =========
========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-23 14:18:12.656613) =========
TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production
========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-10-23 14:18:12.656956) =========
========= Started '/tools/buildbot/bin/python scripts/scripts/desktop_unittest.py ...' (results: 0, elapsed: 34 mins, 43 secs) (at 2015-10-23 14:18:12.657262) =========
/tools/buildbot/bin/python scripts/scripts/desktop_unittest.py --cfg unittests/mac_unittest.py --mochitest-suite jetpack-package --mochitest-suite jetpack-addon --blob-upload-branch fx-team --download-symbols true
in dir /builds/slave/test/. (timeout 1800 secs) (maxTime 12000 secs)
watching logfiles {}
argv: ['/tools/buildbot/bin/python', 'scripts/scripts/desktop_unittest.py', '--cfg', 'unittests/mac_unittest.py', '--mochitest-suite', 'jetpack-package', '--mochitest-suite', 'jetpack-addon', '--blob-upload-branch', 'fx-team', '--download-symbols', 'true']
environment:
Apple_PubSub_Socket_Render=/tmp/launch-7zzVAa/Render
DISPLAY=/tmp/launch-316zHK/org.x:0
GIT_SHARE_BASE_DIR=/builds/git-shared
HG_SHARE_BASE_DIR=/builds/hg-shared
HOME=/Users/cltbld
IDLEIZER_DISABLE_SHUTDOWN=true
LOGNAME=cltbld
MOZ_HIDE_RESULTS_TABLE=1
MOZ_NO_REMOTE=1
NO_EM_RESTART=1
NO_FAIL_ON_TEST_ERRORS=1
PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11
PROPERTIES_FILE=/builds/slave/test/buildprops.json
PWD=/builds/slave/test
RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg
SHELL=/bin/bash
SSH_AUTH_SOCK=/tmp/launch-Hys23i/Listeners
TMPDIR=/var/folders/wU/wUQ0E3SdEVy607ra9oMDOU+++-k/-Tmp-/
TWISTD_LOG_PATH=/builds/slave/twistd.log
USER=cltbld
VERSIONER_PYTHON_PREFER_32_BIT=no
VERSIONER_PYTHON_VERSION=2.6
XPCOM_DEBUG_BREAK=warn
__CF_USER_TEXT_ENCODING=0x1C:0:0
using PTY: False
14:18:13 INFO - MultiFileLogger online at 20151023 14:18:13 in /builds/slave/test
14:18:13 INFO - Run as scripts/scripts/desktop_unittest.py --cfg unittests/mac_unittest.py --mochitest-suite jetpack-package --mochitest-suite jetpack-addon --blob-upload-branch fx-team --download-symbols true
14:18:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json.
14:18:13 INFO - {'all_cppunittest_suites': {'cppunittest': ('tests/cppunittest',)},
14:18:13 INFO - 'all_gtest_suites': {'gtest': ()},
14:18:13 INFO - 'all_jittest_suites': {'jittest': ()},
14:18:13 INFO - 'all_mochitest_suites': {'a11y': ('--a11y',),
14:18:13 INFO - 'browser-chrome': ('--browser-chrome',),
14:18:13 INFO - 'browser-chrome-addons': ('--browser-chrome',
14:18:13 INFO - '--chunk-by-runtime',
14:18:13 INFO - '--tag=addons'),
14:18:13 INFO - 'browser-chrome-chunked': ('--browser-chrome',
14:18:13 INFO - '--chunk-by-runtime'),
14:18:13 INFO - 'chrome': ('--chrome',),
14:18:13 INFO - 'chrome-chunked': ('--chrome', '--chunk-by-dir=4'),
14:18:13 INFO - 'jetpack-addon': ('--jetpack-addon',),
14:18:13 INFO - 'jetpack-package': ('--jetpack-package',),
14:18:13 INFO - 'mochitest-devtools-chrome': ('--browser-chrome',
14:18:13 INFO - '--subsuite=devtools'),
14:18:13 INFO - 'mochitest-devtools-chrome-chunked': ('--browser-chrome',
14:18:13 INFO - '--subsuite=devtools',
14:18:13 INFO - '--chunk-by-runtime'),
14:18:13 INFO - 'mochitest-gl': ('--subsuite=webgl',),
14:18:13 INFO - 'mochitest-push': ('--subsuite=push',),
14:18:13 INFO - 'plain': (),
14:18:13 INFO - 'plain-chunked': ('--chunk-by-dir=4',)},
14:18:13 INFO - 'all_mozbase_suites': {'mozbase': ()},
14:18:13 INFO - 'all_reftest_suites': {'crashtest': {'options': ('--suite=crashtest',),
14:18:13 INFO - 'tests': ('tests/reftest/tests/testing/crashtest/crashtests.list',)},
14:18:13 INFO - 'crashtest-ipc': {'options': ('--suite=crashtest',
14:18:13 INFO - '--setpref=browser.tabs.remote=true',
14:18:13 INFO - '--setpref=browser.tabs.remote.autostart=true',
14:18:13 INFO - '--setpref=layers.async-pan-zoom.enabled=true'),
14:18:13 INFO - 'tests': ('tests/reftest/tests/testing/crashtest/crashtests.list',)},
14:18:13 INFO - 'jsreftest': {'options': ('--extra-profile-file=tests/jsreftest/tests/user.js',),
14:18:13 INFO - 'tests': ('tests/jsreftest/tests/jstests.list',)},
14:18:13 INFO - 'reftest': {'options': ('--suite=reftest',),
14:18:13 INFO - 'tests': ('tests/reftest/tests/layout/reftests/reftest.list',)},
14:18:13 INFO - 'reftest-ipc': {'options': ('--suite=reftest',
14:18:13 INFO - '--setpref=browser.tabs.remote=true',
14:18:13 INFO - '--setpref=browser.tabs.remote.autostart=true',
14:18:13 INFO - '--setpref=layers.async-pan-zoom.enabled=true'),
14:18:13 INFO - 'tests': ('tests/reftest/tests/layout/reftests/reftest-sanity/reftest.list',)}},
14:18:13 INFO - 'all_webapprt_suites': {'chrome': ('--webapprt-chrome',
14:18:13 INFO - '--browser-arg=-test-mode'),
14:18:13 INFO - 'content': ('--webapprt-content',)},
14:18:13 INFO - 'all_xpcshell_suites': {'xpcshell': {'options': ('--xpcshell=%(abs_app_dir)s/xpcshell',
14:18:13 INFO - '--manifest=tests/xpcshell/tests/all-test-dirs.list'),
14:18:13 INFO - 'tests': ()},
14:18:13 INFO - 'xpcshell-addons': {'options': ('--xpcshell=%(abs_app_dir)s/xpcshell',
14:18:13 INFO - '--tag=addons',
14:18:13 INFO - '--manifest=tests/xpcshell/tests/all-test-dirs.list'),
14:18:13 INFO - 'tests': ()}},
14:18:13 INFO - 'append_to_log': False,
14:18:13 INFO - 'base_work_dir': '/builds/slave/test',
14:18:13 INFO - 'blob_upload_branch': 'fx-team',
14:18:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt',
14:18:13 INFO - 'buildbot_json_path': 'buildprops.json',
14:18:13 INFO - 'buildbot_max_log_size': 52428800,
14:18:13 INFO - 'code_coverage': False,
14:18:13 INFO - 'config_files': ('unittests/mac_unittest.py',),
14:18:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',),
14:18:13 INFO - 'download_minidump_stackwalk': True,
14:18:13 INFO - 'download_symbols': 'true',
14:18:13 INFO - 'e10s': False,
14:18:13 INFO - 'exe_suffix': '',
14:18:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python',
14:18:13 INFO - 'tooltool.py': '/tools/tooltool.py',
14:18:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python',
14:18:13 INFO - '/tools/misc-python/virtualenv.py')},
14:18:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub',
14:18:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'),
14:18:13 INFO - 'installer_path': '/builds/slave/test/installer.dmg',
14:18:13 INFO - 'log_level': 'info',
14:18:13 INFO - 'log_to_console': True,
14:18:13 INFO - 'minidump_save_path': '%(abs_work_dir)s/../minidumps',
14:18:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk',
14:18:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest',
14:18:13 INFO - 'minimum_tests_zip_dirs': ('bin/*',
14:18:13 INFO - 'certs/*',
14:18:13 INFO - 'modules/*',
14:18:13 INFO - 'mozbase/*',
14:18:13 INFO - 'config/*'),
14:18:13 INFO - 'no_random': False,
14:18:13 INFO - 'opt_config_files': (),
14:18:13 INFO - 'pip_index': False,
14:18:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'),
14:18:13 INFO - 'cmd': ('xset', 's', 'off', 's', 'reset'),
14:18:13 INFO - 'enabled': False,
14:18:13 INFO - 'halt_on_failure': False,
14:18:13 INFO - 'name': 'disable_screen_saver'},
14:18:13 INFO - {'architectures': ('32bit',),
14:18:13 INFO - 'cmd': ('python',
14:18:13 INFO - '../scripts/external_tools/mouse_and_screen_resolution.py',
14:18:13 INFO - '--configuration-url',
14:18:13 INFO - 'https://hg.mozilla.org/%(branch)s/raw-file/%(revision)s/testing/machine-configuration.json'),
14:18:13 INFO - 'enabled': False,
14:18:13 INFO - 'halt_on_failure': True,
14:18:13 INFO - 'name': 'run mouse & screen adjustment script'}),
14:18:13 INFO - 'require_test_zip': True,
14:18:13 INFO - 'run_all_suites': False,
14:18:13 INFO - 'run_cmd_checks_enabled': True,
14:18:13 INFO - 'run_file_names': {'cppunittest': 'runcppunittests.py',
14:18:13 INFO - 'gtest': 'rungtests.py',
14:18:13 INFO - 'jittest': 'jit_test.py',
14:18:13 INFO - 'mochitest': 'runtests.py',
14:18:13 INFO - 'mozbase': 'test.py',
14:18:13 INFO - 'mozmill': 'runtestlist.py',
14:18:13 INFO - 'reftest': 'runreftest.py',
14:18:13 INFO - 'webapprt': 'runtests.py',
14:18:13 INFO - 'xpcshell': 'runxpcshelltests.py'},
14:18:13 INFO - 'specific_tests_zip_dirs': {'cppunittest': ('cppunittest/*',),
14:18:13 INFO - 'gtest': ('gtest/*',),
14:18:13 INFO - 'jittest': ('jit-test/*',),
14:18:13 INFO - 'mochitest': ('mochitest/*',),
14:18:13 INFO - 'mozbase': ('mozbase/*',),
14:18:13 INFO - 'mozmill': ('mozmill/*',),
14:18:13 INFO - 'reftest': ('reftest/*', 'jsreftest/*'),
14:18:13 INFO - 'webapprt': ('mochitest/*',),
14:18:13 INFO - 'xpcshell': ('xpcshell/*',)},
14:18:13 INFO - 'specified_mochitest_suites': ('jetpack-package', 'jetpack-addon'),
14:18:13 INFO - 'strict_content_sandbox': False,
14:18:13 INFO - 'suite_definitions': {'cppunittest': {'options': ('--symbols-path=%(symbols_path)s',
14:18:13 INFO - '--xre-path=%(abs_app_dir)s'),
14:18:13 INFO - 'run_filename': 'runcppunittests.py',
14:18:13 INFO - 'testsdir': 'cppunittest'},
14:18:13 INFO - 'gtest': {'options': ('--xre-path=%(abs_res_dir)s',
14:18:13 INFO - '--cwd=%(gtest_dir)s',
14:18:13 INFO - '--symbols-path=%(symbols_path)s',
14:18:13 INFO - '%(binary_path)s'),
14:18:13 INFO - 'run_filename': 'rungtests.py'},
14:18:13 INFO - 'jittest': {'options': ('tests/bin/js',
14:18:13 INFO - '--no-slow',
14:18:13 INFO - '--no-progress',
14:18:13 INFO - '--format=automation',
14:18:13 INFO - '--jitflags=all'),
14:18:13 INFO - 'run_filename': 'jit_test.py',
14:18:13 INFO - 'testsdir': 'jit-test/jit-test'},
14:18:13 INFO - 'mochitest': {'options': ('--appname=%(binary_path)s',
14:18:13 INFO - '--utility-path=tests/bin',
14:18:13 INFO - '--extra-profile-file=tests/bin/plugins',
14:18:13 INFO - '--symbols-path=%(symbols_path)s',
14:18:13 INFO - '--certificate-path=tests/certs',
14:18:13 INFO - '--quiet',
14:18:13 INFO - '--log-raw=%(raw_log_file)s',
14:18:13 INFO - '--log-errorsummary=%(error_summary_file)s',
14:18:13 INFO - '--screenshot-on-fail'),
14:18:13 INFO - 'run_filename': 'runtests.py',
14:18:13 INFO - 'testsdir': 'mochitest'},
14:18:13 INFO - 'mozbase': {'options': ('-b', '%(binary_path)s'),
14:18:13 INFO - 'run_filename': 'test.py',
14:18:13 INFO - 'testsdir': 'mozbase'},
14:18:13 INFO - 'mozmill': {'options': ('--binary=%(binary_path)s',
14:18:13 INFO - '--testing-modules-dir=test/modules',
14:18:13 INFO - '--symbols-path=%(symbols_path)s'),
14:18:13 INFO - 'run_filename': 'runtestlist.py',
14:18:13 INFO - 'testsdir': 'mozmill'},
14:18:13 INFO - 'reftest': {'options': ('--appname=%(binary_path)s',
14:18:13 INFO - '--utility-path=tests/bin',
14:18:13 INFO - '--extra-profile-file=tests/bin/plugins',
14:18:13 INFO - '--symbols-path=%(symbols_path)s'),
14:18:13 INFO - 'run_filename': 'runreftest.py',
14:18:13 INFO - 'testsdir': 'reftest'},
14:18:13 INFO - 'webapprt': {'options': ('--app=%(app_path)s',
14:18:13 INFO - '--xre-path=%(abs_res_dir)s',
14:18:13 INFO - '--utility-path=tests/bin',
14:18:13 INFO - '--extra-profile-file=tests/bin/plugins',
14:18:13 INFO - '--symbols-path=%(symbols_path)s',
14:18:13 INFO - '--certificate-path=tests/certs',
14:18:13 INFO - '--console-level=INFO',
14:18:13 INFO - '--testing-modules-dir=tests/modules',
14:18:13 INFO - '--quiet'),
14:18:13 INFO - 'run_filename': 'runtests.py',
14:18:13 INFO - 'testsdir': 'mochitest'},
14:18:13 INFO - 'xpcshell': {'options': ('--symbols-path=%(symbols_path)s',
14:18:13 INFO - '--test-plugin-path=%(test_plugin_path)s',
14:18:13 INFO - '--log-raw=%(raw_log_file)s',
14:18:13 INFO - '--log-errorsummary=%(error_summary_file)s',
14:18:13 INFO - '--utility-path=tests/bin'),
14:18:13 INFO - 'run_filename': 'runxpcshelltests.py',
14:18:13 INFO - 'testsdir': 'xpcshell'}},
14:18:13 INFO - 'tooltool_cache': '/builds/tooltool_cache',
14:18:13 INFO - 'vcs_output_timeout': 1000,
14:18:13 INFO - 'virtualenv_path': 'venv',
14:18:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
14:18:13 INFO - 'work_dir': 'build',
14:18:13 INFO - 'xpcshell_name': 'xpcshell'}
14:18:13 INFO - #####
14:18:13 INFO - ##### Running clobber step.
14:18:13 INFO - #####
14:18:13 INFO - Running pre-action listener: _resource_record_pre_action
14:18:13 INFO - Running main action method: clobber
14:18:13 INFO - rmtree: /builds/slave/test/build
14:18:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1
14:18:14 INFO - Running post-action listener: _resource_record_post_action
14:18:14 INFO - #####
14:18:14 INFO - ##### Running read-buildbot-config step.
14:18:14 INFO - #####
14:18:14 INFO - Running pre-action listener: _resource_record_pre_action
14:18:14 INFO - Running main action method: read_buildbot_config
14:18:14 INFO - Using buildbot properties:
14:18:14 INFO - {
14:18:14 INFO - "properties": {
14:18:14 INFO - "buildnumber": 620,
14:18:14 INFO - "product": "firefox",
14:18:14 INFO - "script_repo_revision": "production",
14:18:14 INFO - "branch": "fx-team",
14:18:14 INFO - "repository": "",
14:18:14 INFO - "buildername": "Rev4 MacOSX Snow Leopard 10.6 fx-team debug test mochitest-jetpack",
14:18:14 INFO - "buildid": "20151023122333",
14:18:14 INFO - "slavename": "t-snow-r4-0089",
14:18:14 INFO - "pgo_build": "False",
14:18:14 INFO - "basedir": "/builds/slave/test",
14:18:14 INFO - "project": "",
14:18:14 INFO - "platform": "macosx64",
14:18:14 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/",
14:18:14 INFO - "slavebuilddir": "test",
14:18:14 INFO - "scheduler": "tests-fx-team-snowleopard-debug-unittest-7-3600",
14:18:14 INFO - "repo_path": "integration/fx-team",
14:18:14 INFO - "moz_repo_path": "",
14:18:14 INFO - "stage_platform": "macosx64",
14:18:14 INFO - "builduid": "e8d8543cd3994a439ed135bb864aff1f",
14:18:14 INFO - "revision": "4169913a206bbde202bd75c8729879885ad66b1d"
14:18:14 INFO - },
14:18:14 INFO - "sourcestamp": {
14:18:14 INFO - "repository": "",
14:18:14 INFO - "hasPatch": false,
14:18:14 INFO - "project": "",
14:18:14 INFO - "branch": "fx-team-macosx64-debug-unittest",
14:18:14 INFO - "changes": [
14:18:14 INFO - {
14:18:14 INFO - "category": null,
14:18:14 INFO - "files": [
14:18:14 INFO - {
14:18:14 INFO - "url": null,
14:18:14 INFO - "name": "https://queue.taskcluster.net/v1/task/K011WTKPR2a7cCBiHu-4XQ/artifacts/public/build/firefox-44.0a1.en-US.mac64.dmg"
14:18:14 INFO - },
14:18:14 INFO - {
14:18:14 INFO - "url": null,
14:18:14 INFO - "name": "https://queue.taskcluster.net/v1/task/K011WTKPR2a7cCBiHu-4XQ/artifacts/public/build/test_packages.json"
14:18:14 INFO - }
14:18:14 INFO - ],
14:18:14 INFO - "repository": "",
14:18:14 INFO - "rev": "aadaca56ce9962a7675e1b0dd88a52263c097ce9",
14:18:14 INFO - "who": "s.kaspari@gmail.com",
14:18:14 INFO - "when": 1445627252,
14:18:14 INFO - "number": 6567271,
14:18:14 INFO - "comments": "Bug 1204760 - Use snackbar instead of toast for \"undo close tab\" notification. r=mcomella",
14:18:14 INFO - "project": "",
14:18:14 INFO - "at": "Fri 23 Oct 2015 12:07:32",
14:18:14 INFO - "branch": "fx-team-macosx64-debug-unittest",
14:18:14 INFO - "revlink": "",
14:18:14 INFO - "properties": [
14:18:14 INFO - [
14:18:14 INFO - "buildid",
14:18:14 INFO - "20151023110808",
14:18:14 INFO - "Change"
14:18:14 INFO - ],
14:18:14 INFO - [
14:18:14 INFO - "builduid",
14:18:14 INFO - "86aa2d01660945b38913d7efba790948",
14:18:14 INFO - "Change"
14:18:14 INFO - ],
14:18:14 INFO - [
14:18:14 INFO - "pgo_build",
14:18:14 INFO - "False",
14:18:14 INFO - "Change"
14:18:14 INFO - ]
14:18:14 INFO - ],
14:18:14 INFO - "revision": "aadaca56ce9962a7675e1b0dd88a52263c097ce9"
14:18:14 INFO - },
14:18:14 INFO - {
14:18:14 INFO - "category": null,
14:18:14 INFO - "files": [
14:18:14 INFO - {
14:18:14 INFO - "url": null,
14:18:14 INFO - "name": "https://queue.taskcluster.net/v1/task/bof53cPQR-KDaiFFC59ubQ/artifacts/public/build/firefox-44.0a1.en-US.mac64.dmg"
14:18:14 INFO - },
14:18:14 INFO - {
14:18:14 INFO - "url": null,
14:18:14 INFO - "name": "https://queue.taskcluster.net/v1/task/bof53cPQR-KDaiFFC59ubQ/artifacts/public/build/test_packages.json"
14:18:14 INFO - }
14:18:14 INFO - ],
14:18:14 INFO - "repository": "",
14:18:14 INFO - "rev": "27a8c3b1f861dd56bb5f7c49c42305b0efc311b2",
14:18:14 INFO - "who": "steffen.wilberg@web.de",
14:18:14 INFO - "when": 1445628401,
14:18:14 INFO - "number": 6567357,
14:18:14 INFO - "comments": "Bug 1215249 - Keyboard shortcuts don't work with local media files without explicitly focusing the
14:22:53 INFO - TEST-PASS | remote/main.test frame detach on unload | Saw the correct hash change.
14:22:53 INFO - TEST-PASS | remote/main.test frame detach on unload | This test is done.
14:22:53 INFO - TEST-PASS | remote/main.test frame detach on unload | There was a clean UI.
14:22:54 INFO - TEST-END | remote/main.test frame detach on unload
14:22:54 INFO - TEST-START | remote/main.test frame event listeners
14:22:54 INFO - console.log: remote: Starting remote
14:22:54 INFO - console.log: remote[resource://gre/modules/commonjs/:29][1059]: module loaded
14:22:54 INFO - console.log: remote: Saw a process attach
14:22:54 INFO - console.log: remote: Saw a remote module load
14:22:54 INFO - console.log: remote: Remote ready
14:22:54 INFO - ++DOCSHELL 0x12fddd400 == 12 [pid = 1059] [id = 52]
14:22:54 INFO - ++DOMWINDOW == 26 (0x128d1c000) [pid = 1059] [serial = 142] [outer = 0x0]
14:22:54 INFO - ++DOMWINDOW == 27 (0x128d1cc00) [pid = 1059] [serial = 143] [outer = 0x128d1c000]
14:22:54 INFO - console.log: remote: Waiting for load
14:22:54 INFO - TEST-PASS | remote/main.test frame event listeners | Should have seen the new frame
14:22:54 INFO - console.log: remote: Waiting for sdk/test/sawreply
14:22:54 INFO - console.log: remote: Waiting for sdk/test/eventsent
14:22:54 INFO - console.log: remote: Saw sdk/test/sawreply
14:22:54 INFO - console.log: remote: Saw sdk/test/eventsent
14:22:54 INFO - console.log: remote: Waiting for sdk/test/eventsent
14:22:54 INFO - console.log: remote: Saw sdk/test/eventsent
14:22:54 INFO - TEST-PASS | remote/main.test frame event listeners | This test is done.
14:22:54 INFO - TEST-PASS | remote/main.test frame event listeners | There was a clean UI.
14:22:54 INFO - TEST-END | remote/main.test frame event listeners
14:22:54 INFO - TEST-START | remote/main.test frame list
14:22:54 INFO - TEST-PASS | remote/main.test frame list | Should have just the one tab to start with
14:22:54 INFO - console.log: remote: Starting remote
14:22:55 INFO - console.log: remote[resource://gre/modules/commonjs/:30][1059]: module loaded
14:22:55 INFO - console.log: remote: Saw a process attach
14:22:55 INFO - console.log: remote: Saw a remote module load
14:22:55 INFO - console.log: remote: Remote ready
14:22:55 INFO - TEST-PASS | remote/main.test frame list | Should be the right number of browser frames.
14:22:55 INFO - console.log: remote: Waiting for sdk/test/count
14:22:55 INFO - console.log: remote[resource://gre/modules/commonjs/:30][1059]: received count ping
14:22:55 INFO - console.log: remote: Saw sdk/test/count
14:22:55 INFO - TEST-PASS | remote/main.test frame list | Child processes should have the right number of frames
14:22:55 INFO - ++DOCSHELL 0x1303a5100 == 13 [pid = 1059] [id = 53]
14:22:55 INFO - ++DOMWINDOW == 28 (0x12c2c0800) [pid = 1059] [serial = 144] [outer = 0x0]
14:22:55 INFO - ++DOMWINDOW == 29 (0x12fd37400) [pid = 1059] [serial = 145] [outer = 0x12c2c0800]
14:22:55 INFO - TEST-PASS | remote/main.test frame list | Should have seen the new frame
14:22:55 INFO - TEST-PASS | remote/main.test frame list | Frame should not be remote
14:22:55 INFO - TEST-PASS | remote/main.test frame list | Should be the right number of browser frames.
14:22:55 INFO - console.log: remote: Waiting for sdk/test/count
14:22:55 INFO - ++DOMWINDOW == 30 (0x12e902400) [pid = 1059] [serial = 146] [outer = 0x12c2c0800]
14:22:55 INFO - console.log: remote[resource://gre/modules/commonjs/:30][1059]: received count ping
14:22:55 INFO - console.log: remote: Saw sdk/test/count
14:22:55 INFO - TEST-PASS | remote/main.test frame list | Child processes should have the right number of frames
14:22:55 INFO - ++DOCSHELL 0x14eca3500 == 14 [pid = 1059] [id = 54]
14:22:55 INFO - ++DOMWINDOW == 31 (0x12a311000) [pid = 1059] [serial = 147] [outer = 0x0]
14:22:55 INFO - ++DOMWINDOW == 32 (0x130edbc00) [pid = 1059] [serial = 148] [outer = 0x12a311000]
14:22:55 INFO - TEST-PASS | remote/main.test frame list | Should have seen the new frame
14:22:55 INFO - TEST-PASS | remote/main.test frame list | Frame should not be remote
14:22:55 INFO - TEST-PASS | remote/main.test frame list | Should be the right number of browser frames.
14:22:55 INFO - console.log: remote: Waiting for sdk/test/count
14:22:55 INFO - console.log: remote[resource://gre/modules/commonjs/:30][1059]: received count ping
14:22:55 INFO - [1059] WARNING: Image width or height is non-positive: file /builds/slave/fx-team-m64-d-0000000000000000/build/src/layout/base/nsLayoutUtils.cpp, line 6313
14:22:55 INFO - console.log: remote: Saw sdk/test/count
14:22:55 INFO - TEST-PASS | remote/main.test frame list | Child processes should have the right number of frames
14:22:55 INFO - console.log: remote[resource://gre/modules/commonjs/:30][1059]: received frame ping
14:22:55 INFO - console.log: remote[resource://gre/modules/commonjs/:30][1059]: received frame ping
14:22:55 INFO - console.log: remote[resource://gre/modules/commonjs/:30][1059]: received frame ping
14:22:55 INFO - console.log: remote[resource://gre/modules/commonjs/:30][1059]: received frame ping
14:22:55 INFO - console.log: remote[resource://gre/modules/commonjs/:30][1059]: received frame ping
14:22:55 INFO - console.log: remote[resource://gre/modules/commonjs/:30][1059]: received frame ping
14:22:55 INFO - console.log: remote: Saw pong
14:22:55 INFO - console.log: remote: Saw pong
14:22:55 INFO - console.log: remote: Saw pong
14:22:55 INFO - console.log: remote: Saw pong
14:22:55 INFO - console.log: remote: Saw pong
14:22:55 INFO - console.log: remote: Saw pong
14:22:55 INFO - console.log: remote: Waiting for sdk/test/pong
14:22:55 INFO - console.log: remote: Waiting for sdk/test/pong
14:22:55 INFO - console.log: remote[resource://gre/modules/commonjs/:30][1059]: received frame ping
14:22:55 INFO - console.log: remote: Saw sdk/test/pong
14:22:55 INFO - console.log: remote: Saw sdk/test/pong
14:22:55 INFO - TEST-PASS | remote/main.test frame list | Should have seen a container event for the right item
14:22:55 INFO - TEST-PASS | remote/main.test frame list | Arguments should have matched
14:22:55 INFO - TEST-PASS | remote/main.test frame list | Should have seen the right response
14:22:55 INFO - console.log: remote: Waiting for sdk/test/pong
14:22:55 INFO - console.log: remote: Waiting for sdk/test/pong
14:22:55 INFO - console.log: remote[resource://gre/modules/commonjs/:30][1059]: received frame ping
14:22:55 INFO - console.log: remote: Saw sdk/test/pong
14:22:55 INFO - console.log: remote: Saw sdk/test/pong
14:22:55 INFO - TEST-PASS | remote/main.test frame list | Should have seen a container event for the right item
14:22:55 INFO - TEST-PASS | remote/main.test frame list | Arguments should have matched
14:22:55 INFO - TEST-PASS | remote/main.test frame list | Should have seen the right response
14:22:55 INFO - console.log: remote: Waiting for detach
14:22:55 INFO - console.log: remote: Waiting for detach
14:22:55 INFO - console.log: remote: Saw detach
14:22:55 INFO - console.log: remote: Saw detach
14:22:55 INFO - TEST-PASS | remote/main.test frame list | Should have seen a container event for the right item
14:22:55 INFO - TEST-PASS | remote/main.test frame list | Arguments should have matched
14:22:55 INFO - TEST-PASS | remote/main.test frame list | Should be the right number of browser frames.
14:22:55 INFO - console.log: remote: Waiting for sdk/test/count
14:22:55 INFO - console.log: remote[resource://gre/modules/commonjs/:30][1059]: received count ping
14:22:55 INFO - console.log: remote: Saw sdk/test/count
14:22:55 INFO - TEST-PASS | remote/main.test frame list | Child processes should have the right number of frames
14:22:55 INFO - console.log: remote: Waiting for detach
14:22:55 INFO - console.log: remote: Waiting for detach
14:22:56 INFO - console.log: remote: Saw detach
14:22:56 INFO - console.log: remote: Saw detach
14:22:56 INFO - TEST-PASS | remote/main.test frame list | Should have seen a container event for the right item
14:22:56 INFO - TEST-PASS | remote/main.test frame list | Arguments should have matched
14:22:56 INFO - TEST-PASS | remote/main.test frame list | Should be the right number of browser frames.
14:22:56 INFO - console.log: remote: Waiting for sdk/test/count
14:22:56 INFO - console.log: remote[resource://gre/modules/commonjs/:30][1059]: received count ping
14:22:56 INFO - console.log: remote: Saw sdk/test/count
14:22:56 INFO - TEST-PASS | remote/main.test frame list | Child processes should have the right number of frames
14:22:56 INFO - TEST-PASS | remote/main.test frame list | This test is done.
14:22:56 INFO - TEST-PASS | remote/main.test frame list | There was a clean UI.
14:22:56 INFO - TEST-END | remote/main.test frame list
14:22:56 INFO - TEST-START | remote/main.test frame properties
14:22:56 INFO - console.log: remote: Starting remote
14:22:56 INFO - console.log: remote[resource://gre/modules/commonjs/:31][1059]: module loaded
14:22:56 INFO - console.log: remote: Saw a process attach
14:22:56 INFO - console.log: remote: Saw a remote module load
14:22:56 INFO - console.log: remote: Remote ready
14:22:56 INFO - TEST-PASS | remote/main.test frame properties | Child frame should have the same isTab property
14:22:56 INFO - TEST-PASS | remote/main.test frame properties | Child frame should have the same isTab property
14:22:56 INFO - TEST-PASS | remote/main.test frame properties | Child frame should have the same isTab property
14:22:56 INFO - TEST-PASS | remote/main.test frame properties | Child frame should have the same isTab property
14:22:56 INFO - TEST-PASS | remote/main.test frame properties | This test is done.
14:22:56 INFO - TEST-PASS | remote/main.test frame properties | There was a clean UI.
14:22:56 INFO - TEST-END | remote/main.test frame properties
14:22:56 INFO - TEST-START | remote/main.test frames event listeners
14:22:56 INFO - console.log: remote: Starting remote
14:22:57 INFO - console.log: remote[resource://gre/modules/commonjs/:32][1059]: module loaded
14:22:57 INFO - console.log: remote: Saw a process attach
14:22:57 INFO - console.log: remote: Saw a remote module load
14:22:57 INFO - console.log: remote: Remote ready
14:22:57 INFO - ++DOCSHELL 0x12c3be000 == 15 [pid = 1059] [id = 55]
14:22:57 INFO - ++DOMWINDOW == 33 (0x128226400) [pid = 1059] [serial = 149] [outer = 0x0]
14:22:57 INFO - ++DOMWINDOW == 34 (0x1273a8c00) [pid = 1059] [serial = 150] [outer = 0x128226400]
14:22:57 INFO - console.log: remote: Waiting for load
14:22:57 INFO - TEST-PASS | remote/main.test frames event listeners | Should have seen the new frame
14:22:57 INFO - console.log: remote: Waiting for sdk/test/sawreply
14:22:57 INFO - console.log: remote: Waiting for sdk/test/eventsent
14:22:57 INFO - console.log: remote: Saw sdk/test/sawreply
14:22:57 INFO - console.log: remote: Saw sdk/test/eventsent
14:22:57 INFO - console.log: remote: Waiting for sdk/test/eventsent
14:22:57 INFO - console.log: remote: Saw sdk/test/eventsent
14:22:57 INFO - TEST-PASS | remote/main.test frames event listeners | This test is done.
14:22:57 INFO - TEST-PASS | remote/main.test frames event listeners | There was a clean UI.
14:22:57 INFO - TEST-END | remote/main.test frames event listeners
14:22:57 INFO - TEST-START | remote/main.test new loader
14:22:57 INFO - console.log: remote: Starting remote
14:22:58 INFO - console.log: remote[resource://gre/modules/commonjs/:33][1059]: module loaded
14:22:58 INFO - console.log: remote: Saw a process attach
14:22:58 INFO - console.log: remote: Saw a remote module load
14:22:58 INFO - console.log: remote: Remote ready
14:22:58 INFO - console.log: remote: Starting remote
14:22:58 INFO - console.log: remote[resource://gre/modules/commonjs/:34][1059]: module loaded
14:22:58 INFO - console.log: remote: Saw a process attach
14:22:58 INFO - console.log: remote: Saw a remote module load
14:22:58 INFO - console.log: remote: Remote ready
14:22:58 INFO - console.log: remote: Waiting for sdk/test/pong
14:22:58 INFO - console.log: remote[resource://gre/modules/commonjs/:33][1059]: received process ping
14:22:58 INFO - TEST-PASS | remote/main.test new loader | Should have seen the right pong
14:22:58 INFO - console.log: remote: Saw sdk/test/pong
14:22:58 INFO - console.log: remote: Waiting for sdk/test/pong
14:22:58 INFO - console.log: remote[resource://gre/modules/commonjs/:34][1059]: received process ping
14:22:58 INFO - TEST-PASS | remote/main.test new loader | Should have seen the right pong
14:22:58 INFO - console.log: remote: Saw sdk/test/pong
14:22:58 INFO - console.log: remote: Waiting for sdk/test/pong
14:22:58 INFO - console.log: remote[resource://gre/modules/commonjs/:34][1059]: received process ping
14:22:58 INFO - TEST-PASS | remote/main.test new loader | Should have seen the right pong
14:22:58 INFO - console.log: remote: Saw sdk/test/pong
14:22:58 INFO - TEST-PASS | remote/main.test new loader | This test is done.
14:22:58 INFO - TEST-PASS | remote/main.test new loader | There was a clean UI.
14:22:58 INFO - TEST-END | remote/main.test new loader
14:22:58 INFO - TEST-START | remote/main.test process list
14:22:58 INFO - console.log: remote: Starting remote
14:22:58 INFO - console.log: remote[resource://gre/modules/commonjs/:35][1059]: module loaded
14:22:59 INFO - console.log: remote: Saw a process attach
14:22:59 INFO - console.log: remote: Saw a remote module load
14:22:59 INFO - console.log: remote: Remote ready
14:22:59 INFO - TEST-PASS | remote/main.test process list | Should always be one process
14:22:59 INFO - TEST-PASS | remote/main.test process list | Should be no remote processes
14:22:59 INFO - TEST-PASS | remote/main.test process list | Should have seen all processes
14:22:59 INFO - TEST-PASS | remote/main.test process list | forEvery should send existing processes to the listener
14:22:59 INFO - console.log: remote: Waiting for sdk/test/pong
14:22:59 INFO - console.log: remote: Waiting for sdk/test/pong
14:22:59 INFO - console.log: remote[resource://gre/modules/commonjs/:35][1059]: received process ping
14:22:59 INFO - TEST-PASS | remote/main.test process list | Should not have seen a pong from the local process with the wrong key
14:22:59 INFO - console.log: remote: Saw sdk/test/pong
14:22:59 INFO - console.log: remote: Saw sdk/test/pong
14:22:59 INFO - TEST-PASS | remote/main.test process list | Should have seen a container event for the right item
14:22:59 INFO - TEST-PASS | remote/main.test process list | Arguments should have matched
14:22:59 INFO - TEST-PASS | remote/main.test process list | Saw the process reply with the right key
14:22:59 INFO - TEST-PASS | remote/main.test process list | This test is done.
14:22:59 INFO - TEST-PASS | remote/main.test process list | There was a clean UI.
14:22:59 INFO - TEST-END | remote/main.test process list
14:22:59 INFO - TEST-START | remote/main.test process restart
14:22:59 INFO - TEST-PASS | remote/main.test process restart | Skipping test in non-e10s mode
14:22:59 INFO - TEST-PASS | remote/main.test process restart | This test is done.
14:22:59 INFO - TEST-PASS | remote/main.test process restart | There was a clean UI.
14:22:59 INFO - TEST-END | remote/main.test process restart
14:22:59 INFO - TEST-START | remote/main.test processID
14:22:59 INFO - console.log: remote: Starting remote
14:22:59 INFO - console.log: remote[resource://gre/modules/commonjs/:36][1059]: module loaded
14:22:59 INFO - console.log: remote: Saw a process attach
14:22:59 INFO - console.log: remote: Saw a remote module load
14:22:59 INFO - console.log: remote: Remote ready
14:22:59 INFO - console.log: remote: Waiting for sdk/test/processid
14:22:59 INFO - console.log: remote: Saw sdk/test/processid
14:22:59 INFO - TEST-PASS | remote/main.test processID | Remote processes should have the same process ID
14:22:59 INFO - TEST-PASS | remote/main.test processID | This test is done.
14:22:59 INFO - TEST-PASS | remote/main.test processID | There was a clean UI.
14:22:59 INFO - TEST-END | remote/main.test processID
14:22:59 INFO - TEST-START | remote/main.test unload
14:22:59 INFO - console.log: remote: Starting remote
14:23:00 INFO - --DOCSHELL 0x126fb1300 == 14 [pid = 1059] [id = 49]
14:23:00 INFO - --DOMWINDOW == 33 (0x12a9fe400) [pid = 1059] [serial = 133] [outer = 0x0] [url = data:application/vnd.mozilla.xul+xml;charset=utf-8,]
14:23:00 INFO - --DOMWINDOW == 32 (0x1283ff400) [pid = 1059] [serial = 112] [outer = 0x0] [url = data:application/vnd.mozilla.xul+xml;charset=utf-8,]
14:23:00 INFO - console.log: remote[resource://gre/modules/commonjs/:37][1059]: module loaded
14:23:00 INFO - console.log: remote: Saw a process attach
14:23:00 INFO - console.log: remote: Saw a remote module load
14:23:00 INFO - console.log: remote: Remote ready
14:23:00 INFO - ++DOCSHELL 0x127240400 == 15 [pid = 1059] [id = 56]
14:23:00 INFO - ++DOMWINDOW == 33 (0x126173000) [pid = 1059] [serial = 151] [outer = 0x0]
14:23:01 INFO - ++DOMWINDOW == 34 (0x125a1cc00) [pid = 1059] [serial = 152] [outer = 0x126173000]
14:23:01 INFO - console.log: remote: Waiting for load
14:23:01 INFO - TEST-PASS | remote/main.test unload | Should have seen the new frame
14:23:01 INFO - console.log: remote: Waiting for hashchange
14:23:01 INFO - TEST-PASS | remote/main.test unload | Saw the correct hash change.
14:23:01 INFO - TEST-PASS | remote/main.test unload | This test is done.
14:23:01 INFO - TEST-PASS | remote/main.test unload | There was a clean UI.
14:23:01 INFO - TEST-END | remote/main.test unload
14:23:01 INFO - TEST-START | remote/main.test unload removes frame event listeners
14:23:01 INFO - console.log: remote: Starting remote
14:23:01 INFO - console.log: remote[resource://gre/modules/commonjs/:38][1059]: module loaded
14:23:01 INFO - console.log: remote: Saw a process attach
14:23:01 INFO - console.log: remote: Saw a remote module load
14:23:01 INFO - console.log: remote: Remote ready
14:23:01 INFO - console.log: remote: Starting remote
14:23:01 INFO - console.log: remote[resource://gre/modules/commonjs/:39][1059]: module loaded
14:23:02 INFO - console.log: remote: Saw a process attach
14:23:02 INFO - console.log: remote: Saw a remote module load
14:23:02 INFO - console.log: remote: Remote ready
14:23:02 INFO - ++DOCSHELL 0x12bfb5f00 == 16 [pid = 1059] [id = 57]
14:23:02 INFO - ++DOMWINDOW == 35 (0x12aa60800) [pid = 1059] [serial = 153] [outer = 0x0]
14:23:02 INFO - ++DOMWINDOW == 36 (0x12a416000) [pid = 1059] [serial = 154] [outer = 0x12aa60800]
14:23:02 INFO - console.log: remote: Waiting for load
14:23:02 INFO - TEST-PASS | remote/main.test unload removes frame event listeners | Should have seen the new frame
14:23:02 INFO - console.log: remote: Waiting for sdk/test/sawreply
14:23:02 INFO - console.log: remote: Waiting for sdk/test/eventsent
14:23:02 INFO - console.log: remote: Saw sdk/test/sawreply
14:23:02 INFO - console.log: remote: Saw sdk/test/eventsent
14:23:02 INFO - console.log: remote: Waiting for sdk/test/eventsent
14:23:02 INFO - console.log: remote: Saw sdk/test/eventsent
14:23:02 INFO - TEST-PASS | remote/main.test unload removes frame event listeners | This test is done.
14:23:02 INFO - TEST-PASS | remote/main.test unload removes frame event listeners | There was a clean UI.
14:23:02 INFO - TEST-END | remote/main.test unload removes frame event listeners
14:23:02 INFO - TEST-START | remote/main.test unload removes frames event listeners
14:23:02 INFO - console.log: remote: Starting remote
14:23:02 INFO - console.log: remote[resource://gre/modules/commonjs/:40][1059]: module loaded
14:23:02 INFO - console.log: remote: Saw a process attach
14:23:02 INFO - console.log: remote: Saw a remote module load
14:23:02 INFO - console.log: remote: Remote ready
14:23:02 INFO - console.log: remote: Starting remote
14:23:03 INFO - console.log: remote[resource://gre/modules/commonjs/:41][1059]: module loaded
14:23:03 INFO - console.log: remote: Saw a process attach
14:23:03 INFO - console.log: remote: Saw a remote module load
14:23:03 INFO - console.log: remote: Remote ready
14:23:03 INFO - ++DOCSHELL 0x12f933c00 == 17 [pid = 1059] [id = 58]
14:23:03 INFO - ++DOMWINDOW == 37 (0x12c321c00) [pid = 1059] [serial = 155] [outer = 0x0]
14:23:03 INFO - ++DOMWINDOW == 38 (0x12e96c000) [pid = 1059] [serial = 156] [outer = 0x12c321c00]
14:23:03 INFO - console.log: remote: Waiting for load
14:23:03 INFO - TEST-PASS | remote/main.test unload removes frames event listeners | Should have seen the new frame
14:23:03 INFO - console.log: remote: Waiting for sdk/test/sawreply
14:23:03 INFO - console.log: remote: Waiting for sdk/test/eventsent
14:23:03 INFO - console.log: remote: Saw sdk/test/sawreply
14:23:03 INFO - console.log: remote: Saw sdk/test/eventsent
14:23:03 INFO - console.log: remote: Waiting for sdk/test/eventsent
14:23:03 INFO - console.log: remote: Saw sdk/test/eventsent
14:23:03 INFO - TEST-PASS | remote/main.test unload removes frames event listeners | This test is done.
14:23:03 INFO - TEST-PASS | remote/main.test unload removes frames event listeners | There was a clean UI.
14:23:03 INFO - TEST-END | remote/main.test unload removes frames event listeners
14:23:03 INFO - console.warn: remote: 4 warnings or errors were logged to the platform's nsIConsoleService, which could be of no consequence; however, they could also be indicative of aberrant behavior.
14:23:04 INFO - --DOCSHELL 0x12ff36800 == 16 [pid = 1059] [id = 51]
14:23:04 INFO - --DOCSHELL 0x14eca3500 == 15 [pid = 1059] [id = 54]
14:23:04 INFO - --DOCSHELL 0x1303a5100 == 14 [pid = 1059] [id = 53]
14:23:04 INFO - --DOCSHELL 0x12c3be000 == 13 [pid = 1059] [id = 55]
14:23:04 INFO - --DOCSHELL 0x12fddd400 == 12 [pid = 1059] [id = 52]
14:23:04 INFO - --DOMWINDOW == 37 (0x12feebc00) [pid = 1059] [serial = 140] [outer = 0x0] [url = data:,
]
14:23:04 INFO - --DOMWINDOW == 36 (0x128d1c000) [pid = 1059] [serial = 142] [outer = 0x0] [url = data:text/html,]
14:23:04 INFO - --DOMWINDOW == 35 (0x12a311000) [pid = 1059] [serial = 147] [outer = 0x0] [url = data:text/html;charset=utf-8,remote]
14:23:04 INFO - --DOMWINDOW == 34 (0x12c2c0800) [pid = 1059] [serial = 144] [outer = 0x0] [url = about:robots]
14:23:04 INFO - --DOMWINDOW == 33 (0x127893800) [pid = 1059] [serial = 136] [outer = 0x0] [url = data:application/vnd.mozilla.xul+xml;charset=utf-8,]
14:23:04 INFO - --DOMWINDOW == 32 (0x127378800) [pid = 1059] [serial = 134] [outer = 0x0] [url = data:application/vnd.mozilla.xul+xml;charset=utf-8,]
14:23:04 INFO - --DOMWINDOW == 31 (0x1291c2400) [pid = 1059] [serial = 138] [outer = 0x0] [url = about:blank]
14:23:04 INFO - --DOMWINDOW == 30 (0x128d1cc00) [pid = 1059] [serial = 143] [outer = 0x0] [url = about:blank]
14:23:04 INFO - --DOMWINDOW == 29 (0x130edbc00) [pid = 1059] [serial = 148] [outer = 0x0] [url = about:blank]
14:23:04 INFO - --DOMWINDOW == 28 (0x12fd37400) [pid = 1059] [serial = 145] [outer = 0x0] [url = about:blank]
14:23:04 INFO - 80 of 80 tests passed.
14:23:04 INFO - TEST-INFO | jetpack-addon-harness.js | Uninstalling test add-on remote@jetpack
14:23:04 INFO - TEST-INFO | jetpack-addon-harness.js | Uninstalled test add-on remote@jetpack
14:23:04 INFO - --DOMWINDOW == 27 (0x12ffacc00) [pid = 1059] [serial = 141] [outer = 0x0] [url = about:blank]
14:23:04 INFO - --DOMWINDOW == 26 (0x12e902400) [pid = 1059] [serial = 146] [outer = 0x0] [url = about:robots]
14:23:05 INFO - TEST-INFO | jetpack-addon-harness.js | Testing add-on addon-sdk/source/test/addons/remote is complete
14:23:05 INFO - TEST-INFO | jetpack-addon-harness.js | Starting test add-on addon-sdk/source/test/addons/require
14:23:05 INFO - TEST-INFO | jetpack-addon-harness.js | Installing test add-on addon-sdk/source/test/addons/require
14:23:05 INFO - console.info: test-require: hiddenWindow document.documentURI:chrome://browser/content/hiddenWindow.xul
14:23:05 INFO - console.info: test-require: hiddenWindow document.readyState:complete
14:23:05 INFO - ++DOCSHELL 0x128240900 == 13 [pid = 1059] [id = 59]
14:23:05 INFO - ++DOMWINDOW == 27 (0x127b8c400) [pid = 1059] [serial = 157] [outer = 0x0]
14:23:05 INFO - ++DOMWINDOW == 28 (0x127b8cc00) [pid = 1059] [serial = 158] [outer = 0x127b8c400]
14:23:05 INFO - ++DOMWINDOW == 29 (0x128226800) [pid = 1059] [serial = 159] [outer = 0x127b8c400]
14:23:06 INFO - [1059] WARNING: NS_ENSURE_TRUE(obj.isObject()) failed: file /builds/slave/fx-team-m64-d-0000000000000000/build/src/js/xpconnect/src/XPCComponents.cpp, line 3061
14:23:06 INFO - JavaScript error: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///var/folders/wU/wUQ0E3SdEVy607ra9oMDOU+++-k/-Tmp-/tmp6b6fp3.mozrunner/extensions/remote@jetpack.xpi!/bootstrap.js, line 303: NS_ERROR_ILLEGAL_VALUE: Component returned failure code: 0x80070057 (NS_ERROR_ILLEGAL_VALUE) [nsIXPCComponents_Utils.nukeSandbox]
14:23:06 INFO - Running tests on Firefox 44.0a1/Gecko 44.0a1 (Build 20151023122333) ({ec8030f7-c20a-464f-9b0e-13a3a9e97384}) under darwin/x86_64.
14:23:06 INFO - TEST-START | test-require/main.test 3rd party vs sdk module
14:23:06 INFO - TEST-PASS | test-require/main.test 3rd party vs sdk module | Third party modules don't overload sdk modules
14:23:06 INFO - TEST-PASS | test-require/main.test 3rd party vs sdk module | page-mod module is really the sdk one
14:23:06 INFO - TEST-PASS | test-require/main.test 3rd party vs sdk module | tabs/page-mod is the 3rd party
14:23:06 INFO - TEST-PASS | test-require/main.test 3rd party vs sdk module | Third party main module overload sdk modules
14:23:06 INFO - TEST-PASS | test-require/main.test 3rd party vs sdk module | require(tabs) maps to require(tabs/main)
14:23:06 INFO - TEST-PASS | test-require/main.test 3rd party vs sdk module | require(./tabs) maps to the local module
14:23:06 INFO - TEST-PASS | test-require/main.test 3rd party vs sdk module | We can bypass this overloading with absolute path to sdk modules
14:23:06 INFO - TEST-PASS | test-require/main.test 3rd party vs sdk module | Old and new layout both work
14:23:06 INFO - TEST-PASS | test-require/main.test 3rd party vs sdk module | This test is done.
14:23:06 INFO - TEST-PASS | test-require/main.test 3rd party vs sdk module | There was a clean UI.
14:23:06 INFO - TEST-END | test-require/main.test 3rd party vs sdk module
14:23:06 INFO - TEST-START | test-require/main.test local vs sdk module
14:23:06 INFO - TEST-PASS | test-require/main.test local vs sdk module | Local module takes the priority over sdk modules
14:23:06 INFO - TEST-PASS | test-require/main.test local vs sdk module | this module is really the local one
14:23:06 INFO - TEST-PASS | test-require/main.test local vs sdk module | This test is done.
14:23:06 INFO - TEST-PASS | test-require/main.test local vs sdk module | There was a clean UI.
14:23:06 INFO - TEST-END | test-require/main.test local vs sdk module
14:23:06 INFO - TEST-START | test-require/main.testMultipleRequirePerLine
14:23:06 INFO - TEST-PASS | test-require/main.testMultipleRequirePerLine | undefined
14:23:06 INFO - TEST-PASS | test-require/main.testMultipleRequirePerLine | undefined
14:23:06 INFO - TEST-PASS | test-require/main.testMultipleRequirePerLine | This test is done.
14:23:06 INFO - TEST-PASS | test-require/main.testMultipleRequirePerLine | There was a clean UI.
14:23:06 INFO - TEST-END | test-require/main.testMultipleRequirePerLine
14:23:06 INFO - TEST-START | test-require/main.testRelativeRequire
14:23:06 INFO - TEST-PASS | test-require/main.testRelativeRequire | undefined
14:23:06 INFO - TEST-PASS | test-require/main.testRelativeRequire | This test is done.
14:23:06 INFO - TEST-PASS | test-require/main.testRelativeRequire | There was a clean UI.
14:23:06 INFO - TEST-END | test-require/main.testRelativeRequire
14:23:06 INFO - TEST-START | test-require/main.testRelativeSubFolderRequire
14:23:06 INFO - TEST-PASS | test-require/main.testRelativeSubFolderRequire | undefined
14:23:06 INFO - TEST-PASS | test-require/main.testRelativeSubFolderRequire | This test is done.
14:23:06 INFO - TEST-PASS | test-require/main.testRelativeSubFolderRequire | There was a clean UI.
14:23:06 INFO - TEST-END | test-require/main.testRelativeSubFolderRequire
14:23:06 INFO - TEST-START | test-require/main.testSDKRequire
14:23:06 INFO - TEST-PASS | test-require/main.testSDKRequire | undefined
14:23:06 INFO - TEST-PASS | test-require/main.testSDKRequire | undefined
14:23:06 INFO - TEST-PASS | test-require/main.testSDKRequire | This test is done.
14:23:06 INFO - TEST-PASS | test-require/main.testSDKRequire | There was a clean UI.
14:23:06 INFO - TEST-END | test-require/main.testSDKRequire
14:23:07 INFO - --DOCSHELL 0x126fb3600 == 12 [pid = 1059] [id = 50]
14:23:07 INFO - 28 of 28 tests passed.
14:23:07 INFO - TEST-INFO | jetpack-addon-harness.js | Uninstalling test add-on test-require@jetpack
14:23:07 INFO - TEST-INFO | jetpack-addon-harness.js | Uninstalled test add-on test-require@jetpack
14:23:08 INFO - TEST-INFO | jetpack-addon-harness.js | Testing add-on addon-sdk/source/test/addons/require is complete
14:23:08 INFO - TEST-INFO | jetpack-addon-harness.js | Starting test add-on addon-sdk/source/test/addons/self
14:23:08 INFO - TEST-INFO | jetpack-addon-harness.js | Installing test add-on addon-sdk/source/test/addons/self
14:23:08 INFO - console.info: self: hiddenWindow document.documentURI:chrome://browser/content/hiddenWindow.xul
14:23:08 INFO - console.info: self: hiddenWindow document.readyState:complete
14:23:08 INFO - ++DOCSHELL 0x127360800 == 13 [pid = 1059] [id = 60]
14:23:08 INFO - ++DOMWINDOW == 30 (0x127b95400) [pid = 1059] [serial = 160] [outer = 0x0]
14:23:08 INFO - ++DOMWINDOW == 31 (0x127b95c00) [pid = 1059] [serial = 161] [outer = 0x127b95400]
14:23:08 INFO - ++DOMWINDOW == 32 (0x11fe75000) [pid = 1059] [serial = 162] [outer = 0x127b95400]
14:23:09 INFO - [1059] WARNING: NS_ENSURE_TRUE(obj.isObject()) failed: file /builds/slave/fx-team-m64-d-0000000000000000/build/src/js/xpconnect/src/XPCComponents.cpp, line 3061
14:23:09 INFO - JavaScript error: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///var/folders/wU/wUQ0E3SdEVy607ra9oMDOU+++-k/-Tmp-/tmp6b6fp3.mozrunner/extensions/test-require@jetpack.xpi!/bootstrap.js, line 303: NS_ERROR_ILLEGAL_VALUE: Component returned failure code: 0x80070057 (NS_ERROR_ILLEGAL_VALUE) [nsIXPCComponents_Utils.nukeSandbox]
14:23:10 INFO - Running tests on Firefox 44.0a1/Gecko 44.0a1 (Build 20151023122333) ({ec8030f7-c20a-464f-9b0e-13a3a9e97384}) under darwin/x86_64.
14:23:10 INFO - TEST-START | self/main.test self.data.load
14:23:10 INFO - TEST-PASS | self/main.test self.data.load | paths work
14:23:10 INFO - TEST-PASS | self/main.test self.data.load | relative paths work
14:23:10 INFO - TEST-PASS | self/main.test self.data.load | This test is done.
14:23:10 INFO - TEST-PASS | self/main.test self.data.load | There was a clean UI.
14:23:10 INFO - TEST-END | self/main.test self.data.load
14:23:10 INFO - TEST-START | self/main.test self.id
14:23:10 INFO - TEST-PASS | self/main.test self.id | self.id should be correct.
14:23:10 INFO - TEST-PASS | self/main.test self.id | This test is done.
14:23:10 INFO - TEST-PASS | self/main.test self.id | There was a clean UI.
14:23:10 INFO - TEST-END | self/main.test self.id
14:23:10 INFO - --DOCSHELL 0x128240900 == 12 [pid = 1059] [id = 59]
14:23:10 INFO - --DOCSHELL 0x127240400 == 11 [pid = 1059] [id = 56]
14:23:10 INFO - --DOCSHELL 0x12f933c00 == 10 [pid = 1059] [id = 58]
14:23:10 INFO - --DOCSHELL 0x12bfb5f00 == 9 [pid = 1059] [id = 57]
14:23:10 INFO - 7 of 7 tests passed.
14:23:10 INFO - TEST-INFO | jetpack-addon-harness.js | Uninstalling test add-on test-self@jetpack
14:23:11 INFO - TEST-INFO | jetpack-addon-harness.js | Uninstalled test add-on test-self@jetpack
14:23:11 INFO - TEST-INFO | jetpack-addon-harness.js | Testing add-on addon-sdk/source/test/addons/self is complete
14:23:11 INFO - TEST-INFO | jetpack-addon-harness.js | Starting test add-on addon-sdk/source/test/addons/simple-prefs-l10n
14:23:11 INFO - TEST-INFO | jetpack-addon-harness.js | Installing test add-on addon-sdk/source/test/addons/simple-prefs-l10n
14:23:11 INFO - console.info: simple-prefs-l10n: hiddenWindow document.documentURI:chrome://browser/content/hiddenWindow.xul
14:23:11 INFO - console.info: simple-prefs-l10n: hiddenWindow document.readyState:complete
14:23:11 INFO - ++DOCSHELL 0x127241800 == 10 [pid = 1059] [id = 61]
14:23:11 INFO - ++DOMWINDOW == 33 (0x127a70800) [pid = 1059] [serial = 163] [outer = 0x0]
14:23:11 INFO - ++DOMWINDOW == 34 (0x127a7f800) [pid = 1059] [serial = 164] [outer = 0x127a70800]
14:23:11 INFO - ++DOMWINDOW == 35 (0x127ef8000) [pid = 1059] [serial = 165] [outer = 0x127a70800]
14:23:12 INFO - [1059] WARNING: NS_ENSURE_TRUE(obj.isObject()) failed: file /builds/slave/fx-team-m64-d-0000000000000000/build/src/js/xpconnect/src/XPCComponents.cpp, line 3061
14:23:12 INFO - JavaScript error: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///var/folders/wU/wUQ0E3SdEVy607ra9oMDOU+++-k/-Tmp-/tmp6b6fp3.mozrunner/extensions/test-self@jetpack.xpi!/bootstrap.js, line 303: NS_ERROR_ILLEGAL_VALUE: Component returned failure code: 0x80070057 (NS_ERROR_ILLEGAL_VALUE) [nsIXPCComponents_Utils.nukeSandbox]
14:23:12 INFO - Running tests on Firefox 44.0a1/Gecko 44.0a1 (Build 20151023122333) ({ec8030f7-c20a-464f-9b0e-13a3a9e97384}) under darwin/x86_64.
14:23:13 INFO - TEST-START | simple-prefs-l10n/main.testAOMLocalization
14:23:13 INFO - ++DOCSHELL 0x128241d00 == 11 [pid = 1059] [id = 62]
14:23:13 INFO - ++DOMWINDOW == 36 (0x12fcc0800) [pid = 1059] [serial = 166] [outer = 0x0]
14:23:13 INFO - ++DOMWINDOW == 37 (0x12fd37400) [pid = 1059] [serial = 167] [outer = 0x12fcc0800]
14:23:13 INFO - ++DOMWINDOW == 38 (0x12fd47000) [pid = 1059] [serial = 168] [outer = 0x12fcc0800]
14:23:13 INFO - [1059] WARNING: attempt to modify an immutable nsStandardURL: file /builds/slave/fx-team-m64-d-0000000000000000/build/src/netwerk/base/nsStandardURL.cpp, line 1300
14:23:13 INFO - TEST-INFO | [JavaScript Warning: "Unknown property '-moz-window-shadow'. Declaration dropped." {file: "chrome://global/skin/global.css" line: 288 column: 20 source: " -moz-window-shadow: none;"}]
14:23:13 INFO - [1059] WARNING: Image width or height is non-positive: file /builds/slave/fx-team-m64-d-0000000000000000/build/src/layout/base/nsLayoutUtils.cpp, line 6313
14:23:13 INFO - ++DOCSHELL 0x12c118e00 == 12 [pid = 1059] [id = 63]
14:23:13 INFO - ++DOMWINDOW == 39 (0x12ffda400) [pid = 1059] [serial = 169] [outer = 0x0]
14:23:13 INFO - ++DOMWINDOW == 40 (0x1303b0400) [pid = 1059] [serial = 170] [outer = 0x12ffda400]
14:23:13 INFO - ++DOMWINDOW == 41 (0x12fd47400) [pid = 1059] [serial = 171] [outer = 0x12ffda400]
14:23:13 INFO - ++DOMWINDOW == 42 (0x12ae9f400) [pid = 1059] [serial = 172] [outer = 0x12ffda400]
14:23:14 INFO - TEST-PASS | simple-prefs-l10n/main.testAOMLocalization | somePreference title is correct
14:23:14 INFO - TEST-PASS | simple-prefs-l10n/main.testAOMLocalization | This test is done.
14:23:14 INFO - TEST-PASS | simple-prefs-l10n/main.testAOMLocalization | There was a clean UI.
14:23:14 INFO - TEST-END | simple-prefs-l10n/main.testAOMLocalization
14:23:14 INFO - console.warn: simple-prefs-l10n: 1 warnings or errors were logged to the platform's nsIConsoleService, which could be of no consequence; however, they could also be indicative of aberrant behavior.
14:23:15 INFO - --DOCSHELL 0x127360800 == 11 [pid = 1059] [id = 60]
14:23:15 INFO - --DOCSHELL 0x12c118e00 == 10 [pid = 1059] [id = 63]
14:23:15 INFO - --DOMWINDOW == 41 (0x12c321c00) [pid = 1059] [serial = 155] [outer = 0x0] [url = data:text/html,]
14:23:15 INFO - --DOMWINDOW == 40 (0x128226400) [pid = 1059] [serial = 149] [outer = 0x0] [url = data:text/html,]
14:23:15 INFO - --DOMWINDOW == 39 (0x126173000) [pid = 1059] [serial = 151] [outer = 0x0] [url = data:,