Filed by: agoloman [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=575337709&repo=autoland&task=VFOKJ-CmS9-zrGEBSE2pPQ.0
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/VFOKJ-CmS9-zrGEBSE2pPQ/runs/0/artifacts/public/logs/live_backing.log
[task 2026-06-27T05:04:42.391+00:00] 05:04:42 INFO - TEST-START | TestWebrtcVideoDecoderFactory.RacyGmpPluginForwards
[task 2026-06-27T05:04:42.391+00:00] 05:04:42 INFO - [Parent 11594, GMPThread] WARNING: Failed to delete GMP storage directory: file checkouts/gecko/dom/media/gmp/GMPServiceParent.cpp:1890
[task 2026-06-27T05:04:42.397+00:00] 05:04:42 INFO - TEST-UNEXPECTED-FAIL | TestWebrtcVideoDecoderFactory.RacyGmpPluginForwards | Expected equality of these values:
[task 2026-06-27T05:04:42.397+00:00] 05:04:42 INFO - h264GmpSupport
[task 2026-06-27T05:04:42.397+00:00] 05:04:42 INFO - Which is: 16-byte object <00-00 00-00 00-00 00-00 00-00 00-00 00-00 00-00>
[task 2026-06-27T05:04:42.397+00:00] 05:04:42 INFO - media::DecodeSupportSet{media::DecodeSupport::SoftwareDecode}
[task 2026-06-27T05:04:42.397+00:00] 05:04:42 INFO - Which is: 16-byte object <01-00 00-00 00-00 00-00 01-00 00-00 00-00 00-00>
[task 2026-06-27T05:04:42.397+00:00] 05:04:42 INFO -
[task 2026-06-27T05:04:42.397+00:00] 05:04:42 INFO - ./../../../../../checkouts/gecko/dom/media/gtest/TestWebrtcCodecFactory.cpp:47
[task 2026-06-27T05:04:42.398+00:00] 05:04:42 INFO - TEST-UNEXPECTED-FAIL | TestWebrtcVideoDecoderFactory.RacyGmpPluginForwards | expected PASS
[task 2026-06-27T05:04:42.398+00:00] 05:04:42 INFO - TEST-INFO took 7ms
[task 2026-06-27T05:04:42.398+00:00] 05:04:42 INFO - SUITE-END | took 0s
[task 2026-06-27T05:04:42.398+00:00] 05:04:42 INFO - Couldn't convert chrome URL: chrome://branding/locale/brand.properties
[task 2026-06-27T05:04:42.404+00:00] 05:04:42 INFO - [Parent 11594, Main Thread] WARNING: '!gBasePath', file checkouts/gecko/dom/quota/ActorsParent.cpp:1716
[task 2026-06-27T05:04:42.405+00:00] 05:04:42 INFO - [Parent 11594, Main Thread] WARNING: profile-do-change must precede profile-before-change-qm!: file checkouts/gecko/dom/quota/ActorsParent.cpp:1717
[task 2026-06-27T05:04:42.406+00:00] 05:04:42 INFO - [WARN glean_core::storage] Failed to clear lifetime storage: Error { kind: Rkv(IoError(Os { code: 2, kind: NotFound, message: "No such file or directory" })) }
[task 2026-06-27T05:04:42.406+00:00] 05:04:42 INFO - [Parent 11594, Main Thread] WARNING: Problem removing profile directory: file /builds/worker/workspace/obj-build/dist/include/testing/TestHarness.h:106
[task 2026-06-27T05:04:42.407+00:00] 05:04:42 INFO - [WARN glean_core::storage] Failed to clear lifetime storage: Error { kind: Rkv(IoError(Os { code: 2, kind: NotFound, message: "No such file or directory" })) }
[task 2026-06-27T05:04:42.408+00:00] 05:04:42 INFO - [WARN glean_core::storage] Failed to clear lifetime storage: Error { kind: Rkv(IoError(Os { code: 2, kind: NotFound, message: "No such file or directory" })) }
[task 2026-06-27T05:04:42.408+00:00] 05:04:42 INFO - [WARN glean_core::storage] Failed to clear lifetime storage: Error { kind: Rkv(IoError(Os { code: 2, kind: NotFound, message: "No such file or directory" })) }
[task 2026-06-27T05:04:42.409+00:00] 05:04:42 INFO - [WARN glean_core::storage] Failed to clear lifetime storage: Error { kind: Rkv(IoError(Os { code: 2, kind: NotFound, message: "No such file or directory" })) }
[task 2026-06-27T05:04:42.423+00:00] 05:04:42 INFO - Finished running GTest tests.
[task 2026-06-27T05:04:42.464+00:00] 05:04:42 INFO - [Parent 11594, Main Thread] WARNING: XPCOM object nsLocalFile released from static ctor/dtor: file checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp:212
[task 2026-06-27T05:04:42.465+00:00] 05:04:42 INFO - [Parent 11594, Main Thread] WARNING: XPCOM object StringBuffer released from static ctor/dtor: file checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp:212
[task 2026-06-27T05:04:42.465+00:00] 05:04:42 INFO - [Parent 11594, Main Thread] WARNING: XPCOM object StringBuffer released from static ctor/dtor: file checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp:212
[task 2026-06-27T05:04:42.465+00:00] 05:04:42 INFO - [Parent 11594, Main Thread] WARNING: XPCOM object StringBuffer released from static ctor/dtor: file checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp:212
[task 2026-06-27T05:04:42.466+00:00] 05:04:42 INFO - [Parent 11594, Main Thread] WARNING: XPCOM object StringBuffer released from static ctor/dtor: file checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp:212
[task 2026-06-27T05:04:42.466+00:00] 05:04:42 INFO - [Parent 11594, Main Thread] WARNING: XPCOM object StringBuffer released from static ctor/dtor: file checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp:212
[task 2026-06-27T05:04:42.467+00:00] 05:04:42 INFO - [Parent 11594, Main Thread] WARNING: XPCOM object StringBuffer released from static ctor/dtor: file checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp:212
[task 2026-06-27T05:04:42.467+00:00] 05:04:42 INFO - [Parent 11594, Main Thread] WARNING: XPCOM object StringBuffer released from static ctor/dtor: file checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp:212
[task 2026-06-27T05:04:42.468+00:00] 05:04:42 INFO - [Parent 11594, Main Thread] WARNING: XPCOM object StringBuffer released from static ctor/dtor: file checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp:212
[task 2026-06-27T05:04:42.472+00:00] 05:04:42 INFO - [Parent 11594, Main Thread] WARNING: XPCOM object StringBuffer released from static ctor/dtor: file checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp:212
[task 2026-06-27T05:04:42.473+00:00] 05:04:42 INFO - [Parent 11594, Main Thread] WARNING: XPCOM object StringBuffer released from static ctor/dtor: file checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp:212
[task 2026-06-27T05:04:42.473+00:00] 05:04:42 INFO - [Parent 11594, Main Thread] WARNING: XPCOM object StringBuffer released from static ctor/dtor: file checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp:212
[task 2026-06-27T05:04:42.473+00:00] 05:04:42 INFO - [Parent 11594, Main Thread] WARNING: XPCOM object StringBuffer released from static ctor/dtor: file checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp:212
[task 2026-06-27T05:04:42.474+00:00] 05:04:42 INFO - [Parent 11594, Main Thread] WARNING: XPCOM object StringBuffer released from static ctor/dtor: file checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp:212
[task 2026-06-27T05:04:42.480+00:00] 05:04:42 INFO - gtest.TestWebrtcVideoDecoderFactory | process wait complete, returncode=1
[task 2026-06-27T05:04:42.481+00:00] 05:04:42 INFO - mozcrash checking /opt/worker/tasks/task_178252627735703/build/tests/gtest for minidumps...
[task 2026-06-27T05:04:42.481+00:00] 05:04:42 ERROR - gtest.TestWebrtcVideoDecoderFactory | test failed with return code 1
[task 2026-06-27T05:04:42.482+00:00] 05:04:42 INFO - rungtests.py exits with code 1
[task 2026-06-27T05:04:42.510+00:00] 05:04:42 INFO - Return code: 1
[task 2026-06-27T05:04:42.510+00:00] 05:04:42 WARNING - Got 2 unexpected statuses
[task 2026-06-27T05:04:42.510+00:00] 05:04:42 INFO - TinderboxPrint: gtest-gtest<br/>4569/<em class="testfail">2</em>/3
[task 2026-06-27T05:04:42.510+00:00] 05:04:42 WARNING - setting return code to 2
[task 2026-06-27T05:04:42.510+00:00] 05:04:42 INFO - The gtest suite: gtest ran with return status: FAILURE
[task 2026-06-27T05:04:42.511+00:00] 05:04:42 INFO - Running post-action listener: _package_coverage_data
[task 2026-06-27T05:04:42.511+00:00] 05:04:42 INFO - Running post-action listener: _resource_record_post_action
[task 2026-06-27T05:04:42.511+00:00] 05:04:42 INFO - Running post-action listener: process_java_coverage_data
[task 2026-06-27T05:04:42.511+00:00] 05:04:42 INFO - [mozharness: 2026-06-27 05:04:42.511200Z] Finished run-tests step (success)
[task 2026-06-27T05:04:42.511+00:00] 05:04:42 INFO - [mozharness: 2026-06-27 05:04:42.511259Z] Running uninstall step.
[task 2026-06-27T05:04:42.511+00:00] 05:04:42 INFO - Running pre-action listener: _resource_record_pre_action
[task 2026-06-27T05:04:42.511+00:00] 05:04:42 INFO - Running main action method: uninstall
[task 2026-06-27T05:04:42.511+00:00] 05:04:42 INFO - Skipping uninstall for non-MSIX test
[task 2026-06-27T05:04:42.511+00:00] 05:04:42 INFO - Running post-action listener: _resource_record_post_action
[task 2026-06-27T05:04:42.511+00:00] 05:04:42 INFO - [mozharness: 2026-06-27 05:04:42.511698Z] Finished uninstall step (success)
[task 2026-06-27T05:04:42.512+00:00] 05:04:42 INFO - Running post-run listener: _resource_record_post_run
[task 2026-06-27T05:04:42.705+00:00] 05:04:42 INFO - instance_metadata.json not found; unable to determine instance type
[task 2026-06-27T05:04:42.735+00:00] 05:04:42 INFO - Validating Perfherder data against /opt/worker/tasks/task_178252627735703/mozharness/external_tools/performance-artifact-schema.json
[task 2026-06-27T05:04:42.738+00:00] 05:04:42 INFO - PERFHERDER_DATA: {"framework": {"name": "job_resource_usage"}, "suites": [{"name": "gtest.gtest.overall", "extraOptions": ["buildbot-unknown"], "subtests": [{"name": "cpu_percent", "value": 17.728333721426676}, {"name": "io_write_bytes", "value": 2168725504}, {"name": "io.read_bytes", "value": 264626176}, {"name": "io_write_time", "value": 8329}, {"name": "io_read_time", "value": 3727}]}, {"name": "gtest.gtest.start-pulseaudio", "subtests": [{"name": "time", "value": 0.0002567369992902968}, {"name": "cpu_percent", "value": 0}]}, {"name": "gtest.gtest.unlock-keyring", "subtests": [{"name": "time", "value": 0.00010965299952658825}, {"name": "cpu_percent", "value": 0}]}, {"name": "gtest.gtest.install", "subtests": [{"name": "time", "value": 35.351396674999705}, {"name": "cpu_percent", "value": 10.236119116234393}]}, {"name": "gtest.gtest.stage-files", "subtests": [{"name": "time", "value": 0.2261627990010311}, {"name": "cpu_percent", "value": 5.683333333333334}]}, {"name": "gtest.gtest.run-tests", "subtests": [{"name": "time", "value": 829.0083778799999}, {"name": "cpu_percent", "value": 18.0480964518348}]}, {"name": "gtest.gtest.uninstall", "subtests": [{"name": "time", "value": 0.00020000600125058554}, {"name": "cpu_percent", "value": 0}]}]}
[task 2026-06-27T05:04:42.739+00:00] 05:04:42 INFO - Total resource usage - Wall time: 865s; CPU: Can't collect data; Read bytes: 264626176; Write bytes: 2168725504; Read time: 3727; Write time: 8329
[task 2026-06-27T05:04:42.739+00:00] 05:04:42 INFO - TinderboxPrint: I/O read bytes / time<br/>264,626,176 / 3,727
[task 2026-06-27T05:04:42.739+00:00] 05:04:42 INFO - TinderboxPrint: I/O write bytes / time<br/>2,168,725,504 / 8,329
[task 2026-06-27T05:04:42.739+00:00] 05:04:42 INFO - TinderboxPrint: CPU idle<br/>8,507.9 (82.3%)
[task 2026-06-27T05:04:42.739+00:00] 05:04:42 INFO - TinderboxPrint: CPU system<br/>541.8 (5.2%)
[task 2026-06-27T05:04:42.739+00:00] 05:04:42 INFO - TinderboxPrint: CPU user<br/>1,286.2 (12.4%)
[task 2026-06-27T05:04:42.739+00:00] 05:04:42 INFO - TinderboxPrint: Swap in / out<br/>683,393,024 / 0
[task 2026-06-27T05:04:42.742+00:00] 05:04:42 INFO - start-pulseaudio - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2026-06-27T05:04:42.744+00:00] 05:04:42 INFO - unlock-keyring - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2026-06-27T05:04:42.749+00:00] 05:04:42 INFO - install - Wall time: 35s; CPU: 10%; Read bytes: 8466432; Write bytes: 466759680; Read time: 419; Write time: 976
[task 2026-06-27T05:04:42.750+00:00] 05:04:42 INFO - stage-files - Wall time: 0s; CPU: 6%; Read bytes: 0; Write bytes: 169652224; Read time: 0; Write time: 426
[task 2026-06-27T05:04:42.827+00:00] 05:04:42 INFO - run-tests - Wall time: 829s; CPU: 18%; Read bytes: 254119936; Write bytes: 1401311232; Read time: 3218; Write time: 6661
[task 2026-06-27T05:04:42.831+00:00] 05:04:42 INFO - uninstall - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2026-06-27T05:04:44.058+00:00] 05:04:44 WARNING - returning nonzero exit status 2
[taskcluster 2026-06-27T05:04:44.191Z] Exit Code: 2
[taskcluster 2026-06-27T05:04:44.191Z] User Time: 13m56.703158s
[taskcluster 2026-06-27T05:04:44.191Z] Kernel Time: 6m19.973732s
[taskcluster 2026-06-27T05:04:44.191Z] Wall Time: 15m59.02991s
[taskcluster 2026-06-27T05:04:44.191Z] Result: FAILED
[taskcluster 2026-06-27T05:04:44.191Z] === Task Finished ===
[taskcluster 2026-06-27T05:04:44.191Z] Task Duration: 15m59.03481s
[taskcluster 2026-06-27T05:04:44.571Z] Uploading artifact public/build/perfherder-data-mozharness-actions.json from file /opt/worker/tasks/task_178252627735703/public/build/perfherder-data-mozharness-actions.json with content encoding "gzip", mime type "application/json" and expiry 2027-06-27T04:22:49.657Z
[taskcluster 2026-06-27T05:04:45.005Z] Uploading artifact public/logs/localconfig.json from file /opt/worker/tasks/task_178252627735703/logs/localconfig.json with content encoding "gzip", mime type "application/json" and expiry 2027-06-27T04:22:49.657Z
[taskcluster 2026-06-27T05:04:45.358Z] Uploading artifact public/test_info/perfherder-data-resource-usage.json from file /opt/worker/tasks/task_178252627735703/build/blobber_upload_dir/perfherder-data-resource-usage.json with content encoding "gzip", mime type "application/json" and expiry 2027-06-27T04:22:49.657Z
[taskcluster 2026-06-27T05:04:45.722Z] Uploading artifact public/test_info/profile_resource-usage.json from file /opt/worker/tasks/task_178252627735703/build/blobber_upload_dir/profile_resource-usage.json with content encoding "gzip", mime type "application/json" and expiry 2027-06-27T04:22:49.657Z
[taskcluster 2026-06-27T05:04:46.200Z] Uploading artifact public/test_info/system-info.log from file /opt/worker/tasks/task_178252627735703/build/blobber_upload_dir/system-info.log with content encoding "gzip", mime type "text/plain" and expiry 2027-06-27T04:22:49.657Z
[taskcluster 2026-06-27T05:04:46.546Z] Uploading artifact public/fetch/perfherder-data-fetch-content.json from file /opt/worker/tasks/task_178252627735703/perf/perfherder-data-fetch-content.json with content encoding "gzip", mime type "application/json" and expiry 2027-06-27T04:22:49.657Z
[taskcluster 2026-06-27T05:04:46.771Z] [mounts] Preserving cache: Moving "/opt/worker/tasks/task_178252627735703/.task-cache/pip" to "/opt/worker/cache/KMKQPjkoSoqgkF5KTRPghw"
[taskcluster 2026-06-27T05:04:46.772Z] [mounts] Preserving cache: Moving "/opt/worker/tasks/task_178252627735703/.task-cache/uv" to "/opt/worker/cache/Ubr2IVPaRGuCvCTB0cQ3pw"
[taskcluster 2026-06-27T05:04:46.917Z] Uploading link artifact public/logs/live.log to artifact public/logs/live_backing.log with expiry 2027-06-27T04:22:49.657Z
[taskcluster:error] exit status 2
Description
•