2039989 - Intermittent mozilla/tests/webdriver/harness/shutdown.py | test_firefox_quits_on_signal[2] - AssertionError: Firefox process still running after geckodriver was terminated

Status: NEW

(Remote Protocol :: Marionette, defect, P5)

Description

[Treeherder Bug Filer]

Filed by: agoloman [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=566789982&repo=autoland&task=MHpIWJVbRzSaqjGxxZiNrg.0
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/MHpIWJVbRzSaqjGxxZiNrg/runs/0/artifacts/public/logs/live_backing.log

---

[task 2026-05-15T18:07:58.735+00:00] 18:07:58     INFO - STDOUT: PASSED
[task 2026-05-15T18:07:58.736+00:00] 18:07:58     INFO - STDOUT: =================================== FAILURES ===================================
[task 2026-05-15T18:07:58.737+00:00] 18:07:58     INFO - STDOUT: _______________________ test_firefox_quits_on_signal[2] ________________________
[task 2026-05-15T18:07:58.738+00:00] 18:07:58     INFO - STDOUT: configuration = {'browser': {'args': ['--profile', '/tmp/tmpz8p8emfj.mozrunner'], 'binary': '/builds/worker/workspace/build/applicatio...0e4b31d4817d5927c792216a075be0', 'DEBIAN_FRONTEND': 'noninteractive', ...}}}, 'display': 'x11', 'headless': False, ...}
[task 2026-05-15T18:07:58.739+00:00] 18:07:58     INFO - STDOUT: geckodriver = <function geckodriver.<locals>._geckodriver at 0x7faac8d4b060>
[task 2026-05-15T18:07:58.740+00:00] 18:07:58     INFO - STDOUT: signal = <Signals.SIGINT: 2>
[task 2026-05-15T18:07:58.740+00:00] 18:07:58     INFO - STDOUT:     @pytest.mark.parametrize("signal", SIGNALS)
[task 2026-05-15T18:07:58.741+00:00] 18:07:58     INFO - STDOUT:     def test_firefox_quits_on_signal(configuration, geckodriver, signal):
[task 2026-05-15T18:07:58.742+00:00] 18:07:58     INFO - STDOUT:         popen_kwargs = {}
[task 2026-05-15T18:07:58.743+00:00] 18:07:58     INFO - STDOUT:         if IS_WINDOWS:
[task 2026-05-15T18:07:58.743+00:00] 18:07:58     INFO - STDOUT:             # Start geckodriver in its own process group so that
[task 2026-05-15T18:07:58.744+00:00] 18:07:58     INFO - STDOUT:             # CTRL_BREAK_EVENT is only delivered to it and not to the
[task 2026-05-15T18:07:58.745+00:00] 18:07:58     INFO - STDOUT:             # parent cmd.exe, which would otherwise prompt
[task 2026-05-15T18:07:58.745+00:00] 18:07:58     INFO - STDOUT:             # "Terminate batch job (Y/N)?" and hang.
[task 2026-05-15T18:07:58.746+00:00] 18:07:58     INFO - STDOUT:             popen_kwargs["creationflags"] = subprocess.CREATE_NEW_PROCESS_GROUP
[task 2026-05-15T18:07:58.747+00:00] 18:07:58     INFO - STDOUT:     
[task 2026-05-15T18:07:58.747+00:00] 18:07:58     INFO - STDOUT:         driver = geckodriver(config=configuration, popen_kwargs=popen_kwargs)
[task 2026-05-15T18:07:58.748+00:00] 18:07:58     INFO - STDOUT:         driver.new_session()
[task 2026-05-15T18:07:58.749+00:00] 18:07:58     INFO - STDOUT:     
[task 2026-05-15T18:07:58.749+00:00] 18:07:58     INFO - STDOUT:         firefox_pid = driver.session.capabilities["moz:processID"]
[task 2026-05-15T18:07:58.750+00:00] 18:07:58     INFO - STDOUT:     
[task 2026-05-15T18:07:58.751+00:00] 18:07:58     INFO - STDOUT:         driver.proc.send_signal(signal)
[task 2026-05-15T18:07:58.751+00:00] 18:07:58     INFO - STDOUT:     
[task 2026-05-15T18:07:58.777+00:00] 18:07:58     INFO - 
[task 2026-05-15T18:07:58.777+00:00] 18:07:58     INFO - TEST-UNEXPECTED-FAIL | /_mozilla/webdriver/harness/shutdown.py | test_firefox_quits_on_signal[2] - AssertionError: Firefox process still running after geckodriver was terminated
[task 2026-05-15T18:07:58.777+00:00] 18:07:58     INFO - configuration = {'browser': {'args': ['--profile', '/tmp/tmpz8p8emfj.mozrunner'], 'binary': '/builds/worker/workspace/build/applicatio...0e4b31d4817d5927c792216a075be0', 'DEBIAN_FRONTEND': 'noninteractive', ...}}}, 'display': 'x11', 'headless': False, ...}
[task 2026-05-15T18:07:58.777+00:00] 18:07:58     INFO - geckodriver = <function geckodriver.<locals>._geckodriver at 0x7faac8d4b060>
[task 2026-05-15T18:07:58.777+00:00] 18:07:58     INFO - signal = <Signals.SIGINT: 2>
[task 2026-05-15T18:07:58.777+00:00] 18:07:58     INFO - 
[task 2026-05-15T18:07:58.777+00:00] 18:07:58     INFO -     @pytest.mark.parametrize("signal", SIGNALS)
[task 2026-05-15T18:07:58.777+00:00] 18:07:58     INFO -     def test_firefox_quits_on_signal(configuration, geckodriver, signal):
[task 2026-05-15T18:07:58.777+00:00] 18:07:58     INFO -         popen_kwargs = {}
[task 2026-05-15T18:07:58.777+00:00] 18:07:58     INFO -         if IS_WINDOWS:
[task 2026-05-15T18:07:58.777+00:00] 18:07:58     INFO -             # Start geckodriver in its own process group so that
[task 2026-05-15T18:07:58.777+00:00] 18:07:58     INFO -             # CTRL_BREAK_EVENT is only delivered to it and not to the
[task 2026-05-15T18:07:58.777+00:00] 18:07:58     INFO -             # parent cmd.exe, which would otherwise prompt
[task 2026-05-15T18:07:58.777+00:00] 18:07:58     INFO -             # "Terminate batch job (Y/N)?" and hang.
[task 2026-05-15T18:07:58.777+00:00] 18:07:58     INFO -             popen_kwargs["creationflags"] = subprocess.CREATE_NEW_PROCESS_GROUP
[task 2026-05-15T18:07:58.777+00:00] 18:07:58     INFO -     
[task 2026-05-15T18:07:58.777+00:00] 18:07:58     INFO -         driver = geckodriver(config=configuration, popen_kwargs=popen_kwargs)
[task 2026-05-15T18:07:58.777+00:00] 18:07:58     INFO -         driver.new_session()
[task 2026-05-15T18:07:58.777+00:00] 18:07:58     INFO -     
[task 2026-05-15T18:07:58.777+00:00] 18:07:58     INFO -         firefox_pid = driver.session.capabilities["moz:processID"]
[task 2026-05-15T18:07:58.777+00:00] 18:07:58     INFO -     
[task 2026-05-15T18:07:58.777+00:00] 18:07:58     INFO -         driver.proc.send_signal(signal)
[task 2026-05-15T18:07:58.777+00:00] 18:07:58     INFO -     
[task 2026-05-15T18:07:58.777+00:00] 18:07:58     INFO - >       assert wait_for_process_exit(firefox_pid), (
[task 2026-05-15T18:07:58.777+00:00] 18:07:58     INFO -             "Firefox process still running after geckodriver was terminated"
[task 2026-05-15T18:07:58.777+00:00] 18:07:58     INFO -         )
[task 2026-05-15T18:07:58.777+00:00] 18:07:58     INFO - E       AssertionError: Firefox process still running after geckodriver was terminated
[task 2026-05-15T18:07:58.777+00:00] 18:07:58     INFO - E       assert False
[task 2026-05-15T18:07:58.777+00:00] 18:07:58     INFO - E        +  where False = wait_for_process_exit(45639)
[task 2026-05-15T18:07:58.777+00:00] 18:07:58     INFO - 
[task 2026-05-15T18:07:58.777+00:00] 18:07:58     INFO - configuration = {'browser': {'args': ['--profile', '/tmp/tmpz8p8emfj.mozrunner'],
[task 2026-05-15T18:07:58.777+00:00] 18:07:58     INFO -              'binary': '/builds/worker/workspace/build/application/firefox/firefox',
[task 2026-05-15T18:07:58.777+00:00] 18:07:58     INFO -              'env': {'ASAN_OPTIONS': 'detect_leaks=1',
[task 2026-05-15T18:07:58.777+00:00] 18:07:58     INFO -                      'ASAN_SYMBOLIZER_PATH': '/builds/worker/workspace/build/application/firefox/llvm-symbolizer',
[task 2026-05-15T18:07:58.777+00:00] 18:07:58     INFO -                      'DBUS_SESSION_BUS_ADDRESS': 'unix:path=/tmp/dbus-rb49AJQdUV,guid=540e4b31d4817d5927c792216a075be0',
[task 2026-05-15T18:07:58.777+00:00] 18:07:58     INFO -                      'DEBIAN_FRONTEND': 'noninteractive',
[task 2026-05-15T18:07:58.777+00:00] 18:07:58     INFO -                      'DISPLAY': ':0',
[task 2026-05-15T18:07:58.777+00:00] 18:07:58     INFO -                      'ENABLE_E10S': 'false',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'EXTRA_MOZHARNESS_CONFIG': '{"installer_url":"https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/NQWNYd2WRge6wSN_A_HqlA/artifacts/public/build/target.tar.xz","test_packages_url":"https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/NQWNYd2WRge6wSN_A_HqlA/artifacts/public/build/target.test_packages.json"}',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'GECKO_BASE_REPOSITORY': 'https://hg.mozilla.org/mozilla-unified',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'GECKO_HEAD_REF': 'dc46ad078d7ac2617ce4d348b6e30c26d173dfbe',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'GECKO_HEAD_REPOSITORY': 'https://hg.mozilla.org/integration/autoland',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'GECKO_HEAD_REV': 'dc46ad078d7ac2617ce4d348b6e30c26d173dfbe',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'GECKO_PATH': '/builds/worker/checkouts/gecko',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'GECKO_REPOSITORY_TYPE': 'hg',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'GNOME_DISABLE_CRASH_DIALOG': '1',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'HG_STORE_PATH': '/builds/worker/checkouts/hg-store',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'HOME': '/builds/worker',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'HOSTNAME': 'taskcluster-worker',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'LANG': 'en_US.UTF-8',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'LC_ALL': 'en_US.UTF-8',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'LD_LIBRARY_PATH': '/builds/worker/workspace/build/application/firefox',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'LOGNAME': 'worker',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'LSAN_OPTIONS': 'exitcode=0',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'MINIDUMP_SAVE_PATH': '/builds/worker/workspace/build/blobber_upload_dir',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'MOZHARNESS_CONFIG': 'web_platform_tests/prod_config.py '
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                                           'remove_executables.py',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'MOZHARNESS_SCRIPT': 'web_platform_tests.py',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'MOZHARNESS_TEST_PATHS': '{"web-platform-tests-wdspec":["/_mozilla/webdriver/bidi/session/end","/_mozilla/webdriver/bidi/storage/set_cookie","/_mozilla/webdriver/classic/protocol","/_mozilla/webdriver/classic/switch_to_window","/_mozilla/webdriver/classic/take_full_screenshot","/_mozilla/webdriver/harness","/webdriver/tests/bidi/browser/create_user_context","/webdriver/tests/bidi/browsing_context/download_will_begin","/webdriver/tests/bidi/emulation/set_screen_settings_override","/webdriver/tests/bidi/errors","/webdriver/tests/bidi/input/file_dialog_opened","/webdriver/tests/bidi/network/set_cache_behavior","/webdriver/tests/bidi/script/evaluate","/webdriver/tests/classic/delete_all_cookies","/webdriver/tests/classic/element_clear","/webdriver/tests/classic/execute_async_script","/webdriver/tests/classic/find_elements_from_element","/webdriver/tests/classic/get_computed_label","/webdriver/tests/classic/get_title","/webdriver/tests/classic/is_element_selected","/webdriver/tests/classic/minimize_window"]}',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'MOZHARNESS_URL': 'https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/NQWNYd2WRge6wSN_A_HqlA/artifacts/public/build/mozharness.zip',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'MOZILLA_BUILD_URL': 'https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/NQWNYd2WRge6wSN_A_HqlA/artifacts/public/build/target.tar.xz',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'MOZ_AUTOMATION': '1',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'MOZ_BUILD_DATE': '20260515164621',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'MOZ_CRASHREPORTER': '1',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'MOZ_CRASHREPORTER_NO_REPORT': '1',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'MOZ_CRASHREPORTER_SHUTDOWN': '1',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'MOZ_DEVELOPER_OBJ_DIR': '/builds/worker/workspace/obj-build',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'MOZ_DEVELOPER_REPO_DIR': '/builds/worker/checkouts/gecko',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'MOZ_FETCHES': '[{"artifact":"public/build/fix-stacks.tar.zst","extract":true,"task":"bbq_bE5CSRibjedWE_gOyA"},{"artifact":"public/build/geckodriver.tar.gz","extract":true,"task":"Nz49iamzSWCda3iIAXoqcA"},{"artifact":"public/build/minidump-stackwalk.tar.zst","extract":true,"task":"do1y5RZ6So-meXFYbktJEA"}]',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'MOZ_FETCHES_DIR': '/builds/worker/fetches',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'MOZ_GMP_PATH': '/builds/worker/workspace/build/tests/bin/plugins/gmp-fake/1.0:/builds/worker/workspace/build/tests/bin/plugins/gmp-fakeopenh264/1.0',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'MOZ_HEADLESS': '1',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'MOZ_HEADLESS_HEIGHT': '1200',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'MOZ_HEADLESS_WIDTH': '1600',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'MOZ_LAYERS_ALLOW_SOFTWARE_GL': '1',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'MOZ_LOG': 'signaling:3,mtransport:4,DataChannel:3,jsep:4',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'MOZ_NODE_PATH': '/usr/local/bin/node',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'MOZ_SCM_LEVEL': '3',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'MOZ_SOURCE_CHANGESET': 'dc46ad078d7ac2617ce4d348b6e30c26d173dfbe',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'MOZ_SOURCE_REPO': 'https://hg.mozilla.org/integration/autoland',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'MOZ_WINDOW_OCCLUSION': '0',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'NEED_PIPEWIRE': 'true',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'NEED_WINDOW_MANAGER': 'true',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'NSS_MAX_MP_PBE_ITERATION_COUNT': '10',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'OLDPWD': '/builds/worker/workspace',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'PATH': '/builds/worker/workspace/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/builds/worker/bin',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'PERFHERDER_FETCH_CONTENT_JSON_PATH': '/builds/worker/perf/perfherder-data-fetch-content.json',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'PIP_CACHE_DIR': '/builds/worker/.task-cache/pip',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'PWD': '/builds/worker/workspace',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'PYTHON': 'python3',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'REPOSITORIES': '{"gecko":"Mozilla Firefox"}',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'REQUIRE_GPU': '0',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'RUN_ID': '0',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'RUST_BACKTRACE': '1',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'R_LOG_DESTINATION': 'stderr',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'R_LOG_LEVEL': '6',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'R_LOG_VERBOSE': '1',
[task 2026-05-15T18:07:58.778+00:00] 18:07:58     INFO -                      'SCCACHE_DISABLE': '1',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                      'SHELL': '/bin/bash',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                      'SHLVL': '1',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                      'TASKCLUSTER_INSTANCE_TYPE': 'projects/887720501152/machineTypes/c3d-standard-8',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                      'TASKCLUSTER_PROXY_URL': 'http://172.17.0.1:80',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                      'TASKCLUSTER_ROOT_URL': 'https://firefox-ci-tc.services.mozilla.com',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                      'TASKCLUSTER_WORKER_LOCATION': '{"cloud":"google","region":"us-central1","zone":"us-central1-a"}',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                      'TASK_GROUP_ID': 'X1LvbKt8QlK1gwEOn4ZQuQ',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                      'TASK_ID': 'MHpIWJVbRzSaqjGxxZiNrg',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                      'TASK_WORKDIR': '/builds/worker',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                      'TERM': 'xterm',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                      'TESTS_BY_MANIFEST_URL': 'https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/X1LvbKt8QlK1gwEOn4ZQuQ/artifacts/public/tests-by-manifest.json.gz',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                      'TOOLTOOL_CACHE': '/builds/worker/tooltool-cache',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                      'UPLOAD_DIR': '/builds/worker/artifacts',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                      'USER': 'worker',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                      'UV_CACHE_DIR': '/builds/worker/.task-cache/uv',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                      'VIRTUAL_ENV': '/builds/worker/workspace/build/venv',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                      'WORKING_DIR': '/builds/worker',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                      'WPT_STASH_CONFIG': '["/tmp/pymp-ktewfx88/listener-cuf9krb1", '
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                                          '"SetvxdUbTGbmkzSg40qUWVbuGi482rAnAZRZRANZoqE="]',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                      'XDG_RUNTIME_DIR': '/builds/worker',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                      'XRE_NO_WINDOWS_CRASH_DIALOG': '1'}},
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -  'capabilities': {'moz:firefoxOptions': {'args': ['--profile',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                                                   '/tmp/tmpz8p8emfj.mozrunner'],
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                                          'env': {'ASAN_OPTIONS': 'detect_leaks=1',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                                                  'ASAN_SYMBOLIZER_PATH': '/builds/worker/workspace/build/application/firefox/llvm-symbolizer',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                                                  'DBUS_SESSION_BUS_ADDRESS': 'unix:path=/tmp/dbus-rb49AJQdUV,guid=540e4b31d4817d5927c792216a075be0',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                                                  'DEBIAN_FRONTEND': 'noninteractive',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                                                  'DISPLAY': ':0',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                                                  'ENABLE_E10S': 'false',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                                                  'EXTRA_MOZHARNESS_CONFIG': '{"installer_url":"https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/NQWNYd2WRge6wSN_A_HqlA/artifacts/public/build/target.tar.xz","test_packages_url":"https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/NQWNYd2WRge6wSN_A_HqlA/artifacts/public/build/target.test_packages.json"}',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                                                  'GECKO_BASE_REPOSITORY': 'https://hg.mozilla.org/mozilla-unified',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                                                  'GECKO_HEAD_REF': 'dc46ad078d7ac2617ce4d348b6e30c26d173dfbe',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                                                  'GECKO_HEAD_REPOSITORY': 'https://hg.mozilla.org/integration/autoland',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                                                  'GECKO_HEAD_REV': 'dc46ad078d7ac2617ce4d348b6e30c26d173dfbe',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                                                  'GECKO_PATH': '/builds/worker/checkouts/gecko',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                                                  'GECKO_REPOSITORY_TYPE': 'hg',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                                                  'GNOME_DISABLE_CRASH_DIALOG': '1',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                                                  'HG_STORE_PATH': '/builds/worker/checkouts/hg-store',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                                                  'HOME': '/builds/worker',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                                                  'HOSTNAME': 'taskcluster-worker',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                                                  'LANG': 'en_US.UTF-8',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                                                  'LC_ALL': 'en_US.UTF-8',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                                                  'LD_LIBRARY_PATH': '/builds/worker/workspace/build/application/firefox',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                                                  'LOGNAME': 'worker',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                                                  'LSAN_OPTIONS': 'exitcode=0',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                                                  'MINIDUMP_SAVE_PATH': '/builds/worker/workspace/build/blobber_upload_dir',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                                                  'MOZHARNESS_CONFIG': 'web_platform_tests/prod_config.py '
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                                                                       'remove_executables.py',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                                                  'MOZHARNESS_SCRIPT': 'web_platform_tests.py',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                                                  'MOZHARNESS_TEST_PATHS': '{"web-platform-tests-wdspec":["/_mozilla/webdriver/bidi/session/end","/_mozilla/webdriver/bidi/storage/set_cookie","/_mozilla/webdriver/classic/protocol","/_mozilla/webdriver/classic/switch_to_window","/_mozilla/webdriver/classic/take_full_screenshot","/_mozilla/webdriver/harness","/webdriver/tests/bidi/browser/create_user_context","/webdriver/tests/bidi/browsing_context/download_will_begin","/webdriver/tests/bidi/emulation/set_screen_settings_override","/webdriver/tests/bidi/errors","/webdriver/tests/bidi/input/file_dialog_opened","/webdriver/tests/bidi/network/set_cache_behavior","/webdriver/tests/bidi/script/evaluate","/webdriver/tests/classic/delete_all_cookies","/webdriver/tests/classic/element_clear","/webdriver/tests/classic/execute_async_script","/webdriver/tests/classic/find_elements_from_element","/webdriver/tests/classic/get_computed_label","/webdriver/tests/classic/get_title","/webdriver/tests/classic/is_element_selected","/webdriver/tests/classic/minimize_window"]}',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                                                  'MOZHARNESS_URL': 'https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/NQWNYd2WRge6wSN_A_HqlA/artifacts/public/build/mozharness.zip',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                                                  'MOZILLA_BUILD_URL': 'https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/NQWNYd2WRge6wSN_A_HqlA/artifacts/public/build/target.tar.xz',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                                                  'MOZ_AUTOMATION': '1',
[task 2026-05-15T18:07:58.779+00:00] 18:07:58     INFO -                                                  'MOZ_BUILD_DATE': '20260515164621',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'MOZ_CRASHREPORTER': '1',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'MOZ_CRASHREPORTER_NO_REPORT': '1',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'MOZ_CRASHREPORTER_SHUTDOWN': '1',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'MOZ_DEVELOPER_OBJ_DIR': '/builds/worker/workspace/obj-build',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'MOZ_DEVELOPER_REPO_DIR': '/builds/worker/checkouts/gecko',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'MOZ_FETCHES': '[{"artifact":"public/build/fix-stacks.tar.zst","extract":true,"task":"bbq_bE5CSRibjedWE_gOyA"},{"artifact":"public/build/geckodriver.tar.gz","extract":true,"task":"Nz49iamzSWCda3iIAXoqcA"},{"artifact":"public/build/minidump-stackwalk.tar.zst","extract":true,"task":"do1y5RZ6So-meXFYbktJEA"}]',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'MOZ_FETCHES_DIR': '/builds/worker/fetches',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'MOZ_GMP_PATH': '/builds/worker/workspace/build/tests/bin/plugins/gmp-fake/1.0:/builds/worker/workspace/build/tests/bin/plugins/gmp-fakeopenh264/1.0',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'MOZ_HEADLESS': '1',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'MOZ_HEADLESS_HEIGHT': '1200',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'MOZ_HEADLESS_WIDTH': '1600',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'MOZ_LAYERS_ALLOW_SOFTWARE_GL': '1',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'MOZ_LOG': 'signaling:3,mtransport:4,DataChannel:3,jsep:4',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'MOZ_NODE_PATH': '/usr/local/bin/node',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'MOZ_SCM_LEVEL': '3',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'MOZ_SOURCE_CHANGESET': 'dc46ad078d7ac2617ce4d348b6e30c26d173dfbe',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'MOZ_SOURCE_REPO': 'https://hg.mozilla.org/integration/autoland',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'MOZ_WINDOW_OCCLUSION': '0',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'NEED_PIPEWIRE': 'true',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'NEED_WINDOW_MANAGER': 'true',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'NSS_MAX_MP_PBE_ITERATION_COUNT': '10',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'OLDPWD': '/builds/worker/workspace',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'PATH': '/builds/worker/workspace/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/builds/worker/bin',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'PERFHERDER_FETCH_CONTENT_JSON_PATH': '/builds/worker/perf/perfherder-data-fetch-content.json',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'PIP_CACHE_DIR': '/builds/worker/.task-cache/pip',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'PWD': '/builds/worker/workspace',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'PYTHON': 'python3',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'REPOSITORIES': '{"gecko":"Mozilla '
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                                  'Firefox"}',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'REQUIRE_GPU': '0',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'RUN_ID': '0',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'RUST_BACKTRACE': '1',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'R_LOG_DESTINATION': 'stderr',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'R_LOG_LEVEL': '6',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'R_LOG_VERBOSE': '1',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'SCCACHE_DISABLE': '1',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'SHELL': '/bin/bash',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'SHLVL': '1',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'TASKCLUSTER_INSTANCE_TYPE': 'projects/887720501152/machineTypes/c3d-standard-8',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'TASKCLUSTER_PROXY_URL': 'http://172.17.0.1:80',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'TASKCLUSTER_ROOT_URL': 'https://firefox-ci-tc.services.mozilla.com',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'TASKCLUSTER_WORKER_LOCATION': '{"cloud":"google","region":"us-central1","zone":"us-central1-a"}',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'TASK_GROUP_ID': 'X1LvbKt8QlK1gwEOn4ZQuQ',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'TASK_ID': 'MHpIWJVbRzSaqjGxxZiNrg',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'TASK_WORKDIR': '/builds/worker',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'TERM': 'xterm',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'TESTS_BY_MANIFEST_URL': 'https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/X1LvbKt8QlK1gwEOn4ZQuQ/artifacts/public/tests-by-manifest.json.gz',
[task 2026-05-15T18:07:58.780+00:00] 18:07:58     INFO -                                                  'TOOLTOOL_CACHE': '/builds/worker/tooltool-cache',
[task 2026-05-15T18:07:58.781+00:00] 18:07:58     INFO -                                                  'UPLOAD_DIR': '/builds/worker/artifacts',
[task 2026-05-15T18:07:58.781+00:00] 18:07:58     INFO -                                                  'USER': 'worker',
[task 2026-05-15T18:07:58.781+00:00] 18:07:58     INFO -                                                  'UV_CACHE_DIR': '/builds/worker/.task-cache/uv',
[task 2026-05-15T18:07:58.781+00:00] 18:07:58     INFO -                                                  'VIRTUAL_ENV': '/builds/worker/workspace/build/venv',
[task 2026-05-15T18:07:58.781+00:00] 18:07:58     INFO -                                                  'WORKING_DIR': '/builds/worker',
[task 2026-05-15T18:07:58.781+00:00] 18:07:58     INFO -                                                  'WPT_STASH_CONFIG': '["/tmp/pymp-ktewfx88/listener-cuf9krb1", '
[task 2026-05-15T18:07:58.781+00:00] 18:07:58     INFO -                                                                      '"SetvxdUbTGbmkzSg40qUWVbuGi482rAnAZRZRANZoqE="]',
[task 2026-05-15T18:07:58.781+00:00] 18:07:58     INFO -                                                  'XDG_RUNTIME_DIR': '/builds/worker',
[task 2026-05-15T18:07:58.781+00:00] 18:07:58     INFO -                                                  'XRE_NO_WINDOWS_CRASH_DIALOG': '1'}}},
[task 2026-05-15T18:07:58.781+00:00] 18:07:58     INFO -  'display': 'x11',
[task 2026-05-15T18:07:58.781+00:00] 18:07:58     INFO -  'headless': False,
[task 2026-05-15T18:07:58.781+00:00] 18:07:58     INFO -  'host': '127.0.0.1',
[task 2026-05-15T18:07:58.781+00:00] 18:07:58     INFO -  'port': 37363,
[task 2026-05-15T18:07:58.781+00:00] 18:07:58     INFO -  'target_platform': 'linux',
[task 2026-05-15T18:07:58.781+00:00] 18:07:58     INFO -  'timeout': 105,
[task 2026-05-15T18:07:58.781+00:00] 18:07:58     INFO -  'timeout_multiplier': 4,
[task 2026-05-15T18:07:58.781+00:00] 18:07:58     INFO -  'webdriver': {'args': ['-vv',
[task 2026-05-15T18:07:58.781+00:00] 18:07:58     INFO -                         '--binary',
[task 2026-05-15T18:07:58.781+00:00] 18:07:58     INFO -                         '/builds/worker/workspace/build/application/firefox/firefox'],
[task 2026-05-15T18:07:58.781+00:00] 18:07:58     INFO -                'binary': '/builds/worker/fetches/geckodriver'}}
[task 2026-05-15T18:07:58.781+00:00] 18:07:58     INFO - driver     = <support.helpers.Geckodriver object at 0x7faac8d32c30>
[task 2026-05-15T18:07:58.781+00:00] 18:07:58     INFO - firefox_pid = 45639
[task 2026-05-15T18:07:58.781+00:00] 18:07:58     INFO - geckodriver = <function geckodriver.<locals>._geckodriver at 0x7faac8d4b060>
[task 2026-05-15T18:07:58.781+00:00] 18:07:58     INFO - popen_kwargs = {}
[task 2026-05-15T18:07:58.781+00:00] 18:07:58     INFO - signal     = <Signals.SIGINT: 2>
[task 2026-05-15T18:07:58.781+00:00] 18:07:58     INFO - 
[task 2026-05-15T18:07:58.781+00:00] 18:07:58     INFO - tests/web-platform/mozilla/tests/webdriver/harness/shutdown.py:59: AssertionError
[task 2026-05-15T18:07:58.782+00:00] 18:07:58     INFO - .
[task 2026-05-15T18:07:58.782+00:00] 18:07:58     INFO - TEST-OK | /_mozilla/webdriver/harness/shutdown.py | took 21831ms
[task 2026-05-15T18:07:58.782+00:00] 18:07:58     INFO - No more tests
[task 2026-05-15T18:07:58.821+00:00] 18:07:58     INFO - PID 45171 | 1778868478820	webdriver::server	DEBUG	-> GET /status
[task 2026-05-15T18:07:58.823+00:00] 18:07:58     INFO - PID 45171 | 1778868478820	webdriver::server	DEBUG	<- 200 OK {"value":{"message":"","ready":true}}
[task 2026-05-15T18:07:58.823+00:00] 18:07:58     INFO - PID 45171 | 1778868478821	webdriver::server	INFO	Shutting down
[task 2026-05-15T18:07:58.824+00:00] 18:07:58     INFO - PID 45171 | 1778868478821	webdriver::server	DEBUG	Quit signal received, tearing down session
[task 2026-05-15T18:07:58.825+00:00] 18:07:58     INFO - PID 45171 | 1778868478821	webdriver::server	DEBUG	Teardown session
[task 2026-05-15T18:07:58.842+00:00] 18:07:58     INFO - STDOUT: >       assert wait_for_process_exit(firefox_pid), (
[task 2026-05-15T18:07:58.843+00:00] 18:07:58     INFO - STDOUT:             "Firefox process still running after geckodriver was terminated"
[task 2026-05-15T18:07:58.843+00:00] 18:07:58     INFO - STDOUT:         )
[task 2026-05-15T18:07:58.844+00:00] 18:07:58     INFO - STDOUT: E       AssertionError: Firefox process still running after geckodriver was terminated
<...>
[task 2026-05-15T18:07:58.904+00:00] 18:07:58     INFO - wptserve Stopped http server on 127.0.0.1:8443
[task 2026-05-15T18:07:58.906+00:00] 18:07:58     INFO - wptserve Stopped http server on 127.0.0.1:8446
[task 2026-05-15T18:07:58.906+00:00] 18:07:58     INFO - wptserve Stopped http server on 127.0.0.1:8444
[task 2026-05-15T18:07:58.907+00:00] 18:07:58     INFO - wptserve Stopped http server on 127.0.0.1:9000
[task 2026-05-15T18:07:58.910+00:00] 18:07:58     INFO - wptserve Stopped WebTransport over HTTP/3 server on 127.0.0.1:11000
[task 2026-05-15T18:07:59.117+00:00] 18:07:59     INFO - wptserve Close on: (<AddressFamily.AF_INET: 2>, <SocketKind.SOCK_STREAM: 1>, 6, '', ('127.0.0.1', 8889))
[task 2026-05-15T18:07:59.139+00:00] 18:07:59     INFO - wptserve Close on: (<AddressFamily.AF_INET: 2>, <SocketKind.SOCK_STREAM: 1>, 6, '', ('127.0.0.1', 8888))
[task 2026-05-15T18:07:59.230+00:00] 18:07:59     INFO - Closing logging queue
[task 2026-05-15T18:07:59.231+00:00] 18:07:59     INFO - queue closed
[task 2026-05-15T18:07:59.883+00:00] 18:07:59     INFO - Return code: 1
[task 2026-05-15T18:07:59.883+00:00] 18:07:59  WARNING - Got 1 unexpected statuses
[task 2026-05-15T18:07:59.883+00:00] 18:07:59  WARNING - setting return code to 1
[task 2026-05-15T18:07:59.883+00:00] 18:07:59     INFO - Running post-action listener: _package_coverage_data
[task 2026-05-15T18:07:59.883+00:00] 18:07:59     INFO - Running post-action listener: _resource_record_post_action
[task 2026-05-15T18:07:59.884+00:00] 18:07:59     INFO - Running post-action listener: process_java_coverage_data
[task 2026-05-15T18:07:59.884+00:00] 18:07:59     INFO - Running post-action listener: stop_device
[task 2026-05-15T18:07:59.884+00:00] 18:07:59     INFO - [mozharness: 2026-05-15 18:07:59.884138Z] Finished run-tests step (success)
[task 2026-05-15T18:07:59.884+00:00] 18:07:59     INFO - Running post-run listener: _resource_record_post_run
[task 2026-05-15T18:08:00.007+00:00] 18:08:00     INFO - Total resource usage - Wall time: 1221s; CPU: 35%; Read bytes: 81920; Write bytes: 9163280384; Read time: 58; Write time: 1223174
[task 2026-05-15T18:08:00.007+00:00] 18:08:00     INFO - TinderboxPrint: CPU usage<br/>35.5%
[task 2026-05-15T18:08:00.007+00:00] 18:08:00     INFO - TinderboxPrint: I/O read bytes / time<br/>81,920 / 58
[task 2026-05-15T18:08:00.007+00:00] 18:08:00     INFO - TinderboxPrint: I/O write bytes / time<br/>9,163,280,384 / 1,223,174
[task 2026-05-15T18:08:00.007+00:00] 18:08:00     INFO - TinderboxPrint: CPU idle<br/>6,228.3 (63.9%)
[task 2026-05-15T18:08:00.007+00:00] 18:08:00     INFO - TinderboxPrint: CPU system<br/>787.8 (8.1%)
[task 2026-05-15T18:08:00.007+00:00] 18:08:00     INFO - TinderboxPrint: CPU user<br/>2,663.2 (27.3%)
[task 2026-05-15T18:08:00.007+00:00] 18:08:00     INFO - TinderboxPrint: Swap in / out<br/>0 / 0
[task 2026-05-15T18:08:00.008+00:00] 18:08:00     INFO - pull - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2026-05-15T18:08:00.010+00:00] 18:08:00     INFO - start-emulator - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2026-05-15T18:08:00.011+00:00] 18:08:00     INFO - verify-device - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2026-05-15T18:08:00.014+00:00] 18:08:00     INFO - install - Wall time: 23s; CPU: 13%; Read bytes: 0; Write bytes: 48775168; Read time: 0; Write time: 975
[task 2026-05-15T18:08:00.093+00:00] 18:08:00     INFO - run-tests - Wall time: 1197s; CPU: 36%; Read bytes: 81920; Write bytes: 9114505216; Read time: 58; Write time: 1222199
[task 2026-05-15T18:08:01.020+00:00] 18:08:01  WARNING - returning nonzero exit status 1
[task 2026-05-15T18:08:01.219+00:00] cleanup
[task 2026-05-15T18:08:01.219+00:00] + cleanup
[task 2026-05-15T18:08:01.219+00:00] + local rv=1
[task 2026-05-15T18:08:01.219+00:00] + true
[task 2026-05-15T18:08:01.219+00:00] + cleanup_pipewire
[task 2026-05-15T18:08:01.219+00:00] + '[' -n 1010 ']'
[task 2026-05-15T18:08:01.219+00:00] + '[' false = false ']'
[task 2026-05-15T18:08:01.219+00:00] + kill 1010 1017 1018
[task 2026-05-15T18:08:01.219+00:00] + '[' ']'
[task 2026-05-15T18:08:01.219+00:00] + true
[task 2026-05-15T18:08:01.219+00:00] + cleanup_xvfb
[task 2026-05-15T18:08:01.220+00:00] M 18:08:01.219937        wireplumber ../src/main.c:372:signal_handler: stopped by signal: Terminated
[task 2026-05-15T18:08:01.221+00:00] ++ pidof Xvfb
[task 2026-05-15T18:08:01.222+00:00] M 18:08:01.221931        wireplumber ../src/main.c:364:on_disconnected: disconnected from pipewire
[task 2026-05-15T18:08:01.226+00:00] + local xvfb_pid=44
[task 2026-05-15T18:08:01.226+00:00] + local vnc=false
[task 2026-05-15T18:08:01.226+00:00] + local interactive=false
[task 2026-05-15T18:08:01.226+00:00] + '[' -n 44 ']'
[task 2026-05-15T18:08:01.226+00:00] + [[ false == false ]]
[task 2026-05-15T18:08:01.226+00:00] + [[ false == false ]]
[task 2026-05-15T18:08:01.226+00:00] + kill 44
[task 2026-05-15T18:08:01.226+00:00] + exit 1
[taskcluster 2026-05-15T18:08:01.397Z]                        Exit Code: 1
[taskcluster 2026-05-15T18:08:01.397Z]                        User Time: 324.512ms
[taskcluster 2026-05-15T18:08:01.397Z]                      Kernel Time: 546.347ms
[taskcluster 2026-05-15T18:08:01.397Z]                        Wall Time: 21m53.694448357s
[taskcluster 2026-05-15T18:08:01.397Z]  Average Available System Memory: 26.84 GiB
[taskcluster 2026-05-15T18:08:01.397Z]       Average System Memory Used: 4.50 GiB
[taskcluster 2026-05-15T18:08:01.397Z]          Peak System Memory Used: 7.83 GiB
[taskcluster 2026-05-15T18:08:01.397Z]              Total System Memory: 31.34 GiB
[taskcluster 2026-05-15T18:08:01.397Z]                           Result: FAILED
[taskcluster 2026-05-15T18:08:01.397Z] === Task Finished ===
[taskcluster 2026-05-15T18:08:01.397Z] Task Duration: 21m53.694858807s
[taskcluster 2026-05-15T18:08:02.237Z] [mounts] Preserving cache: Moving "/home/task_177886716523186/cache0" to "/home/generic-worker/caches/QUD0yxQzSSGbTmi0z-gbwg"
[taskcluster 2026-05-15T18:08:02.237Z] [mounts] Preserving cache: Moving "/home/task_177886716523186/cache1" to "/home/generic-worker/caches/enVPKD3JRyOT3lknP1p7IQ"
[taskcluster 2026-05-15T18:08:02.237Z] [mounts] Preserving cache: Moving "/home/task_177886716523186/cache2" to "/home/generic-worker/caches/Zq6pBbrHSeyKhDDG1rwj_Q"
[taskcluster:error] exit status 1

Comment 1

[Intermittent Failures Robot]

6 failures were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 5
• mozilla-central: 1

Table

	headless	no_variant
android-x86_64/opt		2
linux2404-x86_64/asan	1	1
linux2404-x86_64/opt		1
windows11-x86_64/opt		1

For more details, see:

https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=2039989&startday=2026-05-11&endday=2026-05-17&tree=all

Comment 2

[Henrik Skupin [:whimboo][⌚️UTC+2]]

This is a new test as added on bug 1430064.

Comment 3

[Henrik Skupin [:whimboo][⌚️UTC+2]]

Most of the failures here are happening on Android. As I can see in the Android emulator logcat the Marionette:Quit command is successfully received by GeckoView and the application shutdown. But some services got restarted:

https://firefoxci.taskcluster-artifacts.net/bpOqoC0GQRW0pswW3yIb6A/0/public/test_info/logcat-emulator-5554.log

05-18 13:03:59.872  2168  2198 I Gecko   : 1779109439872	Marionette	DEBUG	0 -> [0,2,"Marionette:Quit",{"flags":["eForceQuit"]}]
[..]
05-18 13:04:00.870  2168  2198 I Gecko   : 1779109440870	Marionette	TRACE	Received observer notification xpcom-shutdown
[..]
05-18 13:04:00.907   570   603 I libprocessgroup: Successfully killed process cgroup uid 10192 pid 2296 in 0ms
05-18 13:04:00.907   376   376 I Zygote  : Process 2296 exited due to signal 15 (Terminated)
[..]
05-18 13:04:00.908   570   585 W ActivityManager: Scheduling restart of crashed service org.mozilla.geckoview.test_runner/org.mozilla.gecko.process.GeckoChildProcessServices$gpu in 1000ms for connection
05-18 13:04:00.918  2451  2493 D GeckoThread: State changed to RUNNING
05-18 13:04:00.936   570   585 I ActivityManager: Process org.mozilla.geckoview.test_runner:tab_disable_art_image_12 (pid 2451) has died: fg  BTOP
05-18 13:04:00.937   570   585 W ActivityManager: Scheduling restart of crashed service org.mozilla.geckoview.test_runner/org.mozilla.gecko.process.GeckoChildProcessServices$tab12 in 10971ms for connection
05-18 13:04:00.937   570   603 I libprocessgroup: Successfully killed process cgroup uid 10192 pid 2451 in 0ms
05-18 13:04:00.937   376   376 I Zygote  : Process 2451 exited cleanly (0)
05-18 13:04:00.947   570  1737 I ActivityManager: Process org.mozilla.geckoview.test_runner (pid 2168) has died: fg  TOP 
05-18 13:04:00.949   570  2380 I WindowManager: WIN DEATH: Window{bcf0b3e u0 org.mozilla.geckoview.test_runner/org.mozilla.geckoview.test_runner.App}
05-18 13:04:00.951   376   376 I Zygote  : Process 2168 exited cleanly (0)
[..]
05-18 13:04:01.129   570  1737 I ActivityManager: Force stopping org.mozilla.geckoview.test_runner appid=10192 user=0: from pid 2537
0

The geckodriver logs show:
https://treeherder.mozilla.org/logviewer?job_id=567136456&repo=autoland&task=bpOqoC0GQRW0pswW3yIb6A.0&lineNumber=19596-19635

[task 2026-05-18T13:04:00.929+00:00] 13:04:00     INFO - STDOUT: 1779109440924	mozdevice	TRACE	execute_host_command: >> "shell:kill -0 2168 2>/dev/null; echo $?"
[task 2026-05-18T13:04:00.997+00:00] 13:04:00     INFO - STDOUT: 1779109440996	mozdevice	TRACE	execute_host_command: << "0\n"
[task 2026-05-18T13:04:01.098+00:00] 13:04:01     INFO - STDOUT: 1779109441096	mozdevice	TRACE	execute_host_command: >> "host:transport:emulator-5554"
[task 2026-05-18T13:04:01.099+00:00] 13:04:01     INFO - STDOUT: 1779109441096	mozdevice	TRACE	execute_host_command: << []
[task 2026-05-18T13:04:01.100+00:00] 13:04:01     INFO - STDOUT: 1779109441096	mozdevice	TRACE	execute_host_command: >> "shell:kill -0 2168 2>/dev/null; echo $?"
[task 2026-05-18T13:04:01.109+00:00] 13:04:01     INFO - STDOUT: 1779109441108	mozdevice	TRACE	execute_host_command: << "0\n"
[task 2026-05-18T13:04:01.210+00:00] 13:04:01     INFO - STDOUT: 1779109441208	mozdevice	TRACE	execute_host_command: >> "host:transport:emulator-5554"
[task 2026-05-18T13:04:01.210+00:00] 13:04:01     INFO - STDOUT: 1779109441208	mozdevice	TRACE	execute_host_command: << []
[task 2026-05-18T13:04:01.211+00:00] 13:04:01     INFO - STDOUT: 1779109441208	mozdevice	TRACE	execute_host_command: >> "shell:kill -0 2168 2>/dev/null; echo $?"
[task 2026-05-18T13:04:01.224+00:00] 13:04:01     INFO - STDOUT: 1779109441223	mozdevice	TRACE	execute_host_command: << "0\n"
[task 2026-05-18T13:04:01.325+00:00] 13:04:01     INFO - STDOUT: 1779109441324	mozdevice	TRACE	execute_host_command: >> "host:transport:emulator-5554"
[..]
[task 2026-05-18T13:04:02.036+00:00] 13:04:02     INFO - STDOUT: 1779109442032	mozdevice	TRACE	execute_host_command: << "1\n"
[task 2026-05-18T13:04:02.038+00:00] 13:04:02     INFO - STDOUT: 1779109442032	geckodriver::browser	DEBUG	Android package org.mozilla.geckoview.test_runner has exited
[task 2026-05-18T13:04:02.038+00:00] 13:04:02     INFO - STDOUT: 1779109442032	geckodriver::android	DEBUG	Force stopping the Android package: org.mozilla.geckoview.test_runner
[task 2026-05-18T13:04:02.038+00:00] 13:04:02     INFO - STDOUT: 1779109442032	mozdevice	DEBUG	Force stopping Android package: org.mozilla.geckoview.test_runner
[task 2026-05-18T13:04:02.040+00:00] 13:04:02     INFO - STDOUT: 1779109442032	mozdevice	TRACE	execute_host_command: >> "host:transport:emulator-5554"

The code is around:
https://searchfox.org/firefox-main/rev/0a95d145f781bc57ef4183545cbb88e35d27b66d/testing/geckodriver/src/browser.rs#337-358

And we get:

where False = wait_for_process_exit(2168)

So there is actually an issue with wait_for_process_exit() or in more detail with is_process_alive():

https://searchfox.org/firefox-main/rev/0a95d145f781bc57ef4183545cbb88e35d27b66d/testing/web-platform/mozilla/tests/webdriver/harness/shutdown.py#27

There we call os.kill() which is always run on the host machine but not on the Android device. So we cannot actually determine the process status. We should check how to get the process status from the device.

Comment 4

[Intermittent Failures Robot]

30 failures were associated with this bug in the last 7 days.

This failure happened more than 30 times this week! Resolving this bug is a high priority.

Try to resolve this bug as soon as possible. If unresolved for 2 weeks, the affected test(s) may be disabled.

Repository breakdown:

• autoland: 10
• try: 4
• mozilla-beta: 16

Table

	headless	no_variant
android-x86_64/opt		20
linux2404-x86_64/asan	7	3

For more details, see:

https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=2039989&startday=2026-05-18&endday=2026-05-24&tree=all

Comment 5

[Henrik Skupin [:whimboo][⌚️UTC+2]]

The failures for Linux ASAN happen because we only wait 10s for Firefox to shutdown. This is very unlikely to happen for ASAN builds. As best we should probably use the toolkit.asyncshutdown.crash_timeout value. Here a try build:

https://treeherder.mozilla.org/jobs?repo=try&landoInstance=lando-prod-2025&landoCommitID=50128

Comment 6

[Intermittent Failures Robot]

18 failures were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 4
• mozilla-central: 4
• mozilla-beta: 10

Table

	headless	no_variant
android-x86_64/opt		10
linux2404-x86_64/asan	4	4

For more details, see:

https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=2039989&startday=2026-05-25&endday=2026-05-31&tree=all