1941312 - Intermittent dom/media/test/test_streams_element_capture_twice.html | single tracking bug

Status: RESOLVED INCOMPLETE

(Core :: Audio/Video: Playback, defect, P5)

Description

[Treeherder Bug Filer]

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

---

[task 2025-01-13T10:40:54.492Z] 10:40:54     INFO - TEST-START | dom/media/test/test_streams_element_capture_twice.html
[task 2025-01-13T10:46:10.866Z] 10:46:10     INFO - TEST-INFO | started process screenshot
[task 2025-01-13T10:46:10.969Z] 10:46:10     INFO - TEST-INFO | screenshot: exit 0
[task 2025-01-13T10:46:10.970Z] 10:46:10     INFO - Buffered messages logged at 10:40:54
[task 2025-01-13T10:46:10.971Z] 10:46:10     INFO - TEST-PASS | dom/media/test/test_streams_element_capture_twice.html | A valid string reason is expected 
[task 2025-01-13T10:46:10.971Z] 10:46:10     INFO - TEST-PASS | dom/media/test/test_streams_element_capture_twice.html | Reason cannot be empty 
[task 2025-01-13T10:46:10.971Z] 10:46:10     INFO - Buffered messages finished
[task 2025-01-13T10:46:10.972Z] 10:46:10     INFO - TEST-UNEXPECTED-FAIL | dom/media/test/test_streams_element_capture_twice.html | Test timed out. - 
[task 2025-01-13T10:46:11.892Z] 10:46:11     INFO - {"EMEInfo":{"keySystem":"","sessionsInfo":""},"compositorDroppedFrames":0,"decoder":{"PlayState":"","channels":0,"containerType":"","hasAudio":false,"hasVideo":false,"instance":"","rate":0,"reader":{"audioChannels":0,"audioDecoderName":"","audioFramesDecoded":0,"audioRate":0,"audioState":{"demuxEOS":0,"demuxQueueSize":0,"drainState":0,"hasDecoder":false,"hasDemuxRequest":false,"hasPromise":false,"lastStreamSourceID":0,"needInput":false,"numSamplesInput":0,"numSamplesOutput":0,"pending":0,"queueSize":0,"timeTreshold":0,"timeTresholdHasSeeked":false,"waitingForData":false,"waitingForKey":false,"waitingPromise":false},"audioType":"","frameStats":{"droppedCompositorFrames":0,"droppedDecodedFrames":0,"droppedSinkFrames":0},"totalReadMetadataTimeMs":0,"totalWaitingForVideoDataTimeMs":0,"videoDecoderName":"","videoHardwareAccelerated":false,"videoHeight":0,"videoNumSamplesOutputTotal":0,"videoNumSamplesSkippedTotal":0,"videoRate":0,"videoState":{"demuxEOS":0,"demuxQueueSize":0,"drainState":0,"hasDecoder":false,"hasDemuxRequest":false,"hasPromise":false,"lastStreamSourceID":0,"needInput":false,"numSamplesInput":0,"numSamplesOutput":0,"pending":0,"queueSize":0,"timeTreshold":0,"timeTresholdHasSeeked":false,"waitingForData":false,"waitingForKey":false,"waitingPromise":false},"videoType":"","videoWidth":0},"resource":{"cacheStream":{"cacheSuspended":false,"channelEnded":false,"channelOffset":0,"loadID":0,"streamLength":0}},"stateMachine":{"audioCompleted":false,"audioRequestStatus":"","clock":0,"decodedAudioEndTime":0,"decodedVideoEndTime":0,"duration":0,"isPlaying":false,"mediaSink":{"audioSinkWrapper":{"audioEnded":false,"audioSink":{"audioEnded":false,"hasErrored":false,"isPlaying":false,"isStarted":false,"lastGoodPosition":0,"outputRate":0,"playbackComplete":false,"startTime":0,"written":0},"isPlaying":false,"isStarted":false},"decodedStream":{"audioQueueFinished":false,"audioQueueSize":0,"data":{"audioFramesWritten":0,"haveSentFinishAudio":false,"haveSentFinishVideo":false,"instance":"","lastVideoEndTime":0,"lastVideoStartTime":0,"nextAudioTime":0,"streamAudioWritten":0,"streamVideoWritten":0},"instance":"","lastAudio":0,"lastOutputTime":0,"playing":0,"startTime":0},"videoSink":{"endPromiseHolderIsEmpty":false,"finished":false,"hasVideo":false,"isPlaying":false,"isStarted":false,"size":0,"videoFrameEndTime":0,"videoSinkEndRequestExists":false}},"mediaTime":0,"playState":0,"sentFirstFrameLoadedEvent":false,"state":"","stateObj":{"isPrerolling":false},"totalBufferingTimeMs":0,"videoCompleted":false,"videoRequestStatus":""}}}
[task 2025-01-13T10:46:11.892Z] 10:46:11     INFO - GECKO(5396) | MEMORY STAT | vsize 605MB | vsizeMaxContiguous 1806MB | residentFast 68MB | heapAllocated 7MB
[task 2025-01-13T10:46:40.868Z] 10:46:40     INFO - Not taking screenshot here: see the one that was previously logged
[task 2025-01-13T10:46:40.869Z] 10:46:40     INFO - TEST-UNEXPECTED-FAIL | dom/media/test/test_streams_element_capture_twice.html | Test timed out. - 
[task 2025-01-13T10:46:41.869Z] 10:46:41    ERROR - TEST-UNEXPECTED-FAIL | SimpleTest | this test already called finish!
[task 2025-01-13T10:46:41.871Z] 10:46:41     INFO - TEST-UNEXPECTED-ERROR | dom/media/test/test_streams_element_capture_twice.html | called finish() multiple times
[task 2025-01-13T10:46:41.871Z] 10:46:41     INFO - TEST-INFO took 347378ms
[task 2025-01-13T10:47:10.869Z] 10:47:10     INFO - Not taking screenshot here: see the one that was previously logged
[task 2025-01-13T10:47:10.870Z] 10:47:10     INFO - TEST-UNEXPECTED-FAIL | dom/media/test/test_streams_element_capture_twice.html | Test timed out. - 
[task 2025-01-13T10:47:11.871Z] 10:47:11    ERROR - TEST-UNEXPECTED-FAIL | SimpleTest | this test already called finish!
[task 2025-01-13T10:47:11.872Z] 10:47:11     INFO - TEST-UNEXPECTED-ERROR | dom/media/test/test_streams_element_capture_twice.html | called finish() multiple times
[task 2025-01-13T10:47:11.872Z] 10:47:11     INFO - TEST-INFO 
[task 2025-01-13T10:47:40.872Z] 10:47:40     INFO - Not taking screenshot here: see the one that was previously logged
[task 2025-01-13T10:47:40.872Z] 10:47:40     INFO - TEST-UNEXPECTED-FAIL | dom/media/test/test_streams_element_capture_twice.html | Test timed out. - 
[task 2025-01-13T10:47:40.873Z] 10:47:40     INFO - Not taking screenshot here: see the one that was previously logged
[task 2025-01-13T10:47:40.874Z] 10:47:40     INFO - TEST-UNEXPECTED-FAIL | (SimpleTest/TestRunner.js) | 4 test timeouts, giving up. - 
[task 2025-01-13T10:47:40.874Z] 10:47:40     INFO - Not taking screenshot here: see the one that was previously logged
[task 2025-01-13T10:47:40.876Z] 10:47:40     INFO - TEST-UNEXPECTED-FAIL | (SimpleTest/TestRunner.js) | Skipping 5 remaining tests. - 
[task 2025-01-13T10:47:41.873Z] 10:47:41    ERROR - TEST-UNEXPECTED-FAIL | SimpleTest | this test already called finish!
[task 2025-01-13T10:47:41.876Z] 10:47:41     INFO - TEST-UNEXPECTED-ERROR | (SimpleTest/TestRunner.js) | called finish() multiple times
[task 2025-01-13T10:47:41.876Z] 10:47:41     INFO - TEST-INFO 
[task 2025-01-13T10:53:51.878Z] 10:53:51     INFO - TEST-UNEXPECTED-TIMEOUT | (SimpleTest/TestRunner.js) (finished) | application timed out after 370 seconds with no output
[task 2025-01-13T10:53:51.878Z] 10:53:51     INFO - TEST-INFO 
[task 2025-01-13T10:53:51.878Z] 10:53:51     INFO - Buffered messages finished
[task 2025-01-13T10:53:51.879Z] 10:53:51  WARNING - Force-terminating active process(es).
[task 2025-01-13T10:53:51.879Z] 10:53:51     INFO - profiler Not sending a signal to start the profiler - not on MacOS or Linux. See Bug 1823370.
[task 2025-01-13T10:53:51.880Z] 10:53:51     INFO - Determining child pids from psutil...
[task 2025-01-13T10:53:51.882Z] 10:53:51     INFO - [9844]
[task 2025-01-13T10:53:51.883Z] 10:53:51     INFO - ==> process 9844 launched child process 8888 ("D:\task_173675879692052\build\application\firefox\firefox.exe" -contentproc -parentBuildID 20250113084730 -prefsHandle 2292 -prefsLen 26407 -prefMapHandle 2296 -prefMapSize 281984 -ipcHandle 2368 -initialChannelId {4680540b-41d4-488f-9ac4-6575d4cf16e1} -parentPid 9844 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9844" -appDir "D:\task_173675879692052\build\application\firefox\browser" - 1 gpu)
[task 2025-01-13T10:53:51.884Z] 10:53:51     INFO - ==> process 9844 launched child process 5604 ("D:\task_173675879692052\build\application\firefox\firefox.exe" -contentproc -parentBuildID 20250113084730 -prefsHandle 2296 -prefsLen 26407 -prefMapHandle 2292 -prefMapSize 281984 -ipcHandle 2492 -initialChannelId {bb3a7ade-468b-46d3-88dc-fce2e589ed4a} -parentPid 9844 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9844" -win32kLockedDown -appDir "D:\task_173675879692052\build\application\firefox\browser" - 2 socket)
[task 2025-01-13T10:53:51.885Z] 10:53:51     INFO - ==> process 9844 launched child process 5744 ("D:\task_173675879692052\build\application\firefox\firefox.exe" -contentproc -isForBrowser -prefsHandle 3172 -prefsLen 26165 -prefMapHandle 3176 -prefMapSize 281984 -jsInitHandle 3180 -jsInitLen 259924 -parentBuildID 20250113084730 -ipcHandle 3184 -initialChannelId {26e43a68-131a-4b9f-9e9e-b02bf4eb6303} -parentPid 9844 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9844" -win32kLockedDown -appDir "D:\task_173675879692052\build\application\firefox\browser" - 3 tab)
[task 2025-01-13T10:53:51.886Z] 10:53:51     INFO - ==> process 9844 launched child process 7588 ("D:\task_173675879692052\build\application\firefox\firefox.exe" -contentproc -parentBuildID 20250113084730 -prefsHandle 3448 -prefsLen 27667 -prefMapHandle 3452 -prefMapSize 281984 -ipcHandle 3312 -initialChannelId {940abd94-75ff-4978-978b-e34113df9863} -parentPid 9844 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9844" -appDir "D:\task_173675879692052\build\application\firefox\browser" - 4 rdd)
[task 2025-01-13T10:53:51.887Z] 10:53:51     INFO - ==> process 9844 launched child process 8976 ("D:\task_173675879692052\build\application\firefox\firefox.exe" -contentproc -isForBrowser -prefsHandle 3744 -prefsLen 27729 -prefMapHandle 3748 -prefMapSize 281984 -jsInitHandle 3756 -jsInitLen 259924 -parentBuildID 20250113084730 -ipcHandle 3764 -initialChannelId {c0ec01a6-057c-4d10-b845-e9a440839a91} -parentPid 9844 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9844" -win32kLockedDown -appDir "D:\task_173675879692052\build\application\firefox\browser" - 5 tab)
[task 2025-01-13T10:53:51.888Z] 10:53:51     INFO - ==> process 9844 launched child process 6916 ("D:\task_173675879692052\build\application\firefox\firefox.exe" -contentproc -isForBrowser -prefsHandle 4024 -prefsLen 26684 -prefMapHandle 4028 -prefMapSize 281984 -jsInitHandle 4032 -jsInitLen 259924 -parentBuildID 20250113084730 -ipcHandle 3792 -initialChannelId {8977de63-c245-44ad-bd06-6cf218718068} -parentPid 9844 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9844" -win32kLockedDown -appDir "D:\task_173675879692052\build\application\firefox\browser" - 6 tab)
[task 2025-01-13T10:53:51.889Z] 10:53:51     INFO - ==> process 9844 launched child process 952 ("D:\task_173675879692052\build\application\firefox\firefox.exe" -contentproc -parentBuildID 20250113084730 -sandboxingKind 0 -prefsHandle 4712 -prefsLen 38308 -prefMapHandle 4720 -prefMapSize 281984 -ipcHandle 4716 -initialChannelId {e1ffdf64-dc9d-49ad-b1ea-7f4e57ac9e90} -parentPid 9844 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9844" -win32kLockedDown -appDir "D:\task_173675879692052\build\application\firefox\browser" - 7 utility)
[task 2025-01-13T10:53:51.890Z] 10:53:51     INFO - ==> process 9844 launched child process 5300 ("D:\task_173675879692052\build\application\firefox\firefox.exe" -contentproc -isForBrowser -prefsHandle 4872 -prefsLen 35773 -prefMapHandle 4884 -prefMapSize 281984 -jsInitHandle 4880 -jsInitLen 259924 -parentBuildID 20250113084730 -ipcHandle 4892 -initialChannelId {8af8ab96-6f1d-4ca0-a838-755d006f964a} -parentPid 9844 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9844" -win32kLockedDown -appDir "D:\task_173675879692052\build\application\firefox\browser" - 8 tab)
[task 2025-01-13T10:53:51.891Z] 10:53:51     INFO - ==> process 9844 launched child process 4924 ("D:\task_173675879692052\build\application\firefox\firefox.exe" -contentproc -isForBrowser -prefsHandle 4972 -prefsLen 35825 -prefMapHandle 4976 -prefMapSize 281984 -jsInitHandle 4980 -jsInitLen 259924 -parentBuildID 20250113084730 -ipcHandle 4988 -initialChannelId {80cbbe17-e989-49d2-827f-13ea096c0d7d} -parentPid 9844 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9844" -win32kLockedDown -appDir "D:\task_173675879692052\build\application\firefox\browser" - 9 tab)
[task 2025-01-13T10:53:51.893Z] 10:53:51     INFO - ==> process 9844 launched child process 6680 ("D:\task_173675879692052\build\application\firefox\firefox.exe" -contentproc -isForBrowser -prefsHandle 5316 -prefsLen 35825 -prefMapHandle 5320 -prefMapSize 281984 -jsInitHandle 5324 -jsInitLen 259924 -parentBuildID 20250113084730 -ipcHandle 5328 -initialChannelId {141023b7-6cff-4b91-9748-a425319502af} -parentPid 9844 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9844" -win32kLockedDown -appDir "D:\task_173675879692052\build\application\firefox\browser" - 10 tab)
[task 2025-01-13T10:53:51.894Z] 10:53:51     INFO - ==> process 9844 launched child process 5016 ("D:\task_173675879692052\build\application\firefox\firefox.exe" -contentproc -isForBrowser -prefsHandle 5588 -prefsLen 38360 -prefMapHandle 5592 -prefMapSize 281984 -jsInitHandle 5596 -jsInitLen 259924 -parentBuildID 20250113084730 -ipcHandle 5608 -initialChannelId {0b06edcf-e1aa-494f-8a16-20cf6912fd04} -parentPid 9844 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9844" -win32kLockedDown -appDir "D:\task_173675879692052\build\application\firefox\browser" - 11 tab)
[task 2025-01-13T10:53:51.896Z] 10:53:51     INFO - ==> process 9844 launched child process 5332 ("D:\task_173675879692052\build\application\firefox\firefox.exe" -contentproc -isForBrowser -prefsHandle 4136 -prefsLen 35825 -prefMapHandle 4124 -prefMapSize 281984 -jsInitHandle 4112 -jsInitLen 259924 -parentBuildID 20250113084730 -ipcHandle 4236 -initialChannelId {3d4d230f-f156-442f-98fb-e3a4a14a2386} -parentPid 9844 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9844" -win32kLockedDown -appDir "D:\task_173675879692052\build\application\firefox\browser" - 12 tab)
[task 2025-01-13T10:53:51.897Z] 10:53:51     INFO - ==> process 9844 launched child process 1492 ("D:\task_173675879692052\build\application\firefox\firefox.exe" -contentproc -parentBuildID 20250113084730 -sandboxingKind 1 -prefsHandle 2832 -prefsLen 38647 -prefMapHandle 4080 -prefMapSize 281984 -ipcHandle 4980 -initialChannelId {81fe29ea-f672-4763-a039-13ed4893574d} -parentPid 9844 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9844" -win32kLockedDown -appDir "D:\task_173675879692052\build\application\firefox\browser" - 13 utility)
[task 2025-01-13T10:53:51.897Z] 10:53:51     INFO - Found child pids: {7588, 5604, 6916, 6680, 5744, 8976, 9844, 5300, 952, 5016, 8888, 5332, 1492, 4924}
[task 2025-01-13T10:53:51.898Z] 10:53:51     INFO - Failed to get child procs
[task 2025-01-13T10:53:51.898Z] 10:53:51     INFO - Killing process: 7588
[task 2025-01-13T10:53:51.899Z] 10:53:51     INFO - Not taking screenshot here: see the one that was previously logged
[task 2025-01-13T10:53:51.899Z] 10:53:51     INFO - mozcrash Using D:\task_173675879692052\build\tests\bin\minidumpwriter.exe to write a dump to C:\Users\task_173675879692052\AppData\Local\Temp\tmp_0t4e55w.mozrunner\minidumps\8cf05df8-7495-4957-b505-54029f38740d.dmp for [7588]
[task 2025-01-13T10:53:52.024Z] 10:53:52     INFO - Killing process: 5604
[task 2025-01-13T10:53:52.025Z] 10:53:52     INFO - Not taking screenshot here: see the one that was previously logged
[task 2025-01-13T10:53:52.025Z] 10:53:52     INFO - mozcrash Using D:\task_173675879692052\build\tests\bin\minidumpwriter.exe to write a dump to C:\Users\task_173675879692052\AppData\Local\Temp\tmp_0t4e55w.mozrunner\minidumps\ef322e18-a969-4984-a873-ce33d41d11ab.dmp for [5604]
[task 2025-01-13T10:53:52.125Z] 10:53:52     INFO - Killing process: 6916
[task 2025-01-13T10:53:52.125Z] 10:53:52     INFO - Not taking screenshot here: see the one that was previously logged
[task 2025-01-13T10:53:52.126Z] 10:53:52     INFO - mozcrash Using D:\task_173675879692052\build\tests\bin\minidumpwriter.exe to write a dump to C:\Users\task_173675879692052\AppData\Local\Temp\tmp_0t4e55w.mozrunner\minidumps\8be388ec-906e-46b2-a2dd-aab254cab682.dmp for [6916]
[task 2025-01-13T10:53:52.153Z] 10:53:52     INFO -  Couldn't get handle for 6916
[task 2025-01-13T10:53:52.158Z] 10:53:52    ERROR - mozcrash minidumpwriter exited with status: 1
[task 2025-01-13T10:53:52.159Z] 10:53:52  WARNING - mozcrash kill_pid(): unable to get handle for pid 6916: 87
[task 2025-01-13T10:53:52.159Z] 10:53:52     INFO - Killing process: 6680
[task 2025-01-13T10:53:52.160Z] 10:53:52     INFO - Not taking screenshot here: see the one that was previously logged
[task 2025-01-13T10:53:52.161Z] 10:53:52     INFO - mozcrash Using D:\task_173675879692052\build\tests\bin\minidumpwriter.exe to write a dump to C:\Users\task_173675879692052\AppData\Local\Temp\tmp_0t4e55w.mozrunner\minidumps\e9a43344-436b-4b39-ba41-6e77709b2625.dmp for [6680]
[task 2025-01-13T10:53:52.251Z] 10:53:52  WARNING - mozcrash kill_pid(): unable to get handle for pid 6680: 87
[task 2025-01-13T10:53:52.252Z] 10:53:52     INFO - Killing process: 5744
[task 2025-01-13T10:53:52.253Z] 10:53:52     INFO - Not taking screenshot here: see the one that was previously logged
[task 2025-01-13T10:53:52.253Z] 10:53:52     INFO - mozcrash Using D:\task_173675879692052\build\tests\bin\minidumpwriter.exe to write a dump to C:\Users\task_173675879692052\AppData\Local\Temp\tmp_0t4e55w.mozrunner\minidumps\62abea22-6330-4e45-8ce9-10512e3bc0d0.dmp for [5744]
[task 2025-01-13T10:53:52.271Z] 10:53:52     INFO -  Couldn't get handle for 5744
[task 2025-01-13T10:53:52.276Z] 10:53:52    ERROR - mozcrash minidumpwriter exited with status: 1
[task 2025-01-13T10:53:52.277Z] 10:53:52  WARNING - mozcrash kill_pid(): unable to get handle for pid 5744: 87
[task 2025-01-13T10:53:52.277Z] 10:53:52     INFO - Killing process: 8976
[task 2025-01-13T10:53:52.278Z] 10:53:52     INFO - Not taking screenshot here: see the one that was previously logged
[task 2025-01-13T10:53:52.279Z] 10:53:52     INFO - mozcrash Using D:\task_173675879692052\build\tests\bin\minidumpwriter.exe to write a dump to C:\Users\task_173675879692052\AppData\Local\Temp\tmp_0t4e55w.mozrunner\minidumps\9d551cb4-0ab2-4c71-8e21-513496574b81.dmp for [8976]
[task 2025-01-13T10:53:52.297Z] 10:53:52     INFO -  Couldn't get handle for 8976
[task 2025-01-13T10:53:52.301Z] 10:53:52    ERROR - mozcrash minidumpwriter exited with status: 1
[task 2025-01-13T10:53:52.301Z] 10:53:52  WARNING - mozcrash kill_pid(): unable to get handle for pid 8976: 87
[task 2025-01-13T10:53:52.302Z] 10:53:52     INFO - Killing process: 9844
[task 2025-01-13T10:53:52.302Z] 10:53:52     INFO - Not taking screenshot here: see the one that was previously logged
[task 2025-01-13T10:53:52.304Z] 10:53:52     INFO - mozcrash Using D:\task_173675879692052\build\tests\bin\minidumpwriter.exe to write a dump to C:\Users\task_173675879692052\AppData\Local\Temp\tmp_0t4e55w.mozrunner\minidumps\f573fefd-3d13-4682-a8ab-319e84f1e8bc.dmp for [9844]
[task 2025-01-13T10:53:52.620Z] 10:53:52     INFO - Killing process: 5300
[task 2025-01-13T10:53:52.623Z] 10:53:52     INFO - Not taking screenshot here: see the one that was previously logged
[task 2025-01-13T10:53:52.624Z] 10:53:52     INFO - mozcrash Using D:\task_173675879692052\build\tests\bin\minidumpwriter.exe to write a dump to C:\Users\task_173675879692052\AppData\Local\Temp\tmp_0t4e55w.mozrunner\minidumps\d4e3a40c-2faf-49af-8853-cff7f43317cf.dmp for [5300]
[task 2025-01-13T10:53:52.635Z] 10:53:52     INFO -  Couldn't get handle for 5300
[task 2025-01-13T10:53:52.643Z] 10:53:52    ERROR - mozcrash minidumpwriter exited with status: 1
[task 2025-01-13T10:53:52.644Z] 10:53:52  WARNING - mozcrash kill_pid(): unable to get handle for pid 5300: 87
[task 2025-01-13T10:53:52.644Z] 10:53:52     INFO - Killing process: 952
[task 2025-01-13T10:53:52.644Z] 10:53:52     INFO - Not taking screenshot here: see the one that was previously logged
[task 2025-01-13T10:53:52.645Z] 10:53:52     INFO - mozcrash Using D:\task_173675879692052\build\tests\bin\minidumpwriter.exe to write a dump to C:\Users\task_173675879692052\AppData\Local\Temp\tmp_0t4e55w.mozrunner\minidumps\34323f20-b23a-425f-80a7-4f799ec1bcb6.dmp for [952]
[task 2025-01-13T10:53:52.657Z] 10:53:52     INFO -  Couldn't get handle for 952
[task 2025-01-13T10:53:52.665Z] 10:53:52    ERROR - mozcrash minidumpwriter exited with status: 1
[task 2025-01-13T10:53:52.665Z] 10:53:52  WARNING - mozcrash kill_pid(): unable to get handle for pid 952: 87
[task 2025-01-13T10:53:52.665Z] 10:53:52     INFO - Killing process: 5016
[task 2025-01-13T10:53:52.666Z] 10:53:52     INFO - Not taking screenshot here: see the one that was previously logged
[task 2025-01-13T10:53:52.667Z] 10:53:52     INFO - mozcrash Using D:\task_173675879692052\build\tests\bin\minidumpwriter.exe to write a dump to C:\Users\task_173675879692052\AppData\Local\Temp\tmp_0t4e55w.mozrunner\minidumps\10d46efc-7651-4b5f-8963-41369196d003.dmp for [5016]
[task 2025-01-13T10:53:52.678Z] 10:53:52     INFO -  Couldn't get handle for 5016
[task 2025-01-13T10:53:52.684Z] 10:53:52    ERROR - mozcrash minidumpwriter exited with status: 1
[task 2025-01-13T10:53:52.685Z] 10:53:52  WARNING - mozcrash kill_pid(): unable to get handle for pid 5016: 87
[task 2025-01-13T10:53:52.685Z] 10:53:52     INFO - Killing process: 8888
[task 2025-01-13T10:53:52.686Z] 10:53:52     INFO - Not taking screenshot here: see the one that was previously logged
[task 2025-01-13T10:53:52.687Z] 10:53:52     INFO - mozcrash Using D:\task_173675879692052\build\tests\bin\minidumpwriter.exe to write a dump to C:\Users\task_173675879692052\AppData\Local\Temp\tmp_0t4e55w.mozrunner\minidumps\061597ad-5eea-4731-9695-c655f6dfb538.dmp for [8888]
[task 2025-01-13T10:53:52.699Z] 10:53:52     INFO -  Couldn't get handle for 8888
[task 2025-01-13T10:53:52.705Z] 10:53:52    ERROR - mozcrash minidumpwriter exited with status: 1
[task 2025-01-13T10:53:52.706Z] 10:53:52  WARNING - mozcrash kill_pid(): unable to get handle for pid 8888: 87
[task 2025-01-13T10:53:52.706Z] 10:53:52     INFO - Killing process: 5332
[task 2025-01-13T10:53:52.707Z] 10:53:52     INFO - Not taking screenshot here: see the one that was previously logged
[task 2025-01-13T10:53:52.708Z] 10:53:52     INFO - mozcrash Using D:\task_173675879692052\build\tests\bin\minidumpwriter.exe to write a dump to C:\Users\task_173675879692052\AppData\Local\Temp\tmp_0t4e55w.mozrunner\minidumps\23cdaaa9-ca88-4a45-bf78-f767009e9983.dmp for [5332]
[task 2025-01-13T10:53:52.719Z] 10:53:52     INFO -  Couldn't get handle for 5332
[task 2025-01-13T10:53:52.725Z] 10:53:52    ERROR - mozcrash minidumpwriter exited with status: 1
[task 2025-01-13T10:53:52.725Z] 10:53:52  WARNING - mozcrash kill_pid(): unable to get handle for pid 5332: 87
[task 2025-01-13T10:53:52.726Z] 10:53:52     INFO - Killing process: 1492
[task 2025-01-13T10:53:52.726Z] 10:53:52     INFO - Not taking screenshot here: see the one that was previously logged
[task 2025-01-13T10:53:52.727Z] 10:53:52     INFO - mozcrash Using D:\task_173675879692052\build\tests\bin\minidumpwriter.exe to write a dump to C:\Users\task_173675879692052\AppData\Local\Temp\tmp_0t4e55w.mozrunner\minidumps\0efb4d8f-72a1-4c04-8360-385ea6b30382.dmp for [1492]
[task 2025-01-13T10:53:52.738Z] 10:53:52     INFO -  Couldn't get handle for 1492
[task 2025-01-13T10:53:52.745Z] 10:53:52    ERROR - mozcrash minidumpwriter exited with status: 1
[task 2025-01-13T10:53:52.745Z] 10:53:52  WARNING - mozcrash kill_pid(): unable to get handle for pid 1492: 87
[task 2025-01-13T10:53:52.746Z] 10:53:52     INFO - Killing process: 4924
[task 2025-01-13T10:53:52.746Z] 10:53:52     INFO - Not taking screenshot here: see the one that was previously logged
[task 2025-01-13T10:53:52.747Z] 10:53:52     INFO - mozcrash Using D:\task_173675879692052\build\tests\bin\minidumpwriter.exe to write a dump to C:\Users\task_173675879692052\AppData\Local\Temp\tmp_0t4e55w.mozrunner\minidumps\51565499-5b0c-47df-ba2c-6fb024ba1bbf.dmp for [4924]
[task 2025-01-13T10:53:52.758Z] 10:53:52     INFO -  Couldn't get handle for 4924
[task 2025-01-13T10:53:52.767Z] 10:53:52    ERROR - mozcrash minidumpwriter exited with status: 1
[task 2025-01-13T10:53:52.768Z] 10:53:52  WARNING - mozcrash kill_pid(): unable to get handle for pid 4924: 87
[task 2025-01-13T10:53:52.768Z] 10:53:52     INFO - Killing process: 5396
[task 2025-01-13T10:53:52.768Z] 10:53:52     INFO - Not taking screenshot here: see the one that was previously logged
[task 2025-01-13T10:53:52.769Z] 10:53:52     INFO - mozcrash Using D:\task_173675879692052\build\tests\bin\minidumpwriter.exe to write a dump to C:\Users\task_173675879692052\AppData\Local\Temp\tmp_0t4e55w.mozrunner\minidumps\4f5ce038-8f5f-4d2d-8866-fe998b4f37b1.dmp for [5396]
[task 2025-01-13T10:53:52.780Z] 10:53:52     INFO -  Couldn't get handle for 5396
[task 2025-01-13T10:53:52.789Z] 10:53:52    ERROR - mozcrash minidumpwriter exited with status: 1
[task 2025-01-13T10:53:52.789Z] 10:53:52  WARNING - mozcrash kill_pid(): unable to get handle for pid 5396: 87
[task 2025-01-13T10:53:52.791Z] 10:53:52     INFO - psutil found pid 5396 dead
[task 2025-01-13T10:53:52.791Z] 10:53:52     INFO - TEST-INFO | Main app process: exit 1
[task 2025-01-13T10:53:52.791Z] 10:53:52     INFO - Buffered messages finished
[task 2025-01-13T10:53:52.792Z] 10:53:52     INFO - runtests.py | Application ran for: 0:20:47.266577
[task 2025-01-13T10:53:52.792Z] 10:53:52     INFO - zombiecheck | Reading PID log: C:\Users\task_173675879692052\AppData\Local\Temp\tmpcmwrvh7mpidlog
[task 2025-01-13T10:53:52.794Z] 10:53:52     INFO - ==> process 9844 launched child process 8888 ("D:\task_173675879692052\build\application\firefox\firefox.exe" -contentproc -parentBuildID 20250113084730 -prefsHandle 2292 -prefsLen 26407 -prefMapHandle 2296 -prefMapSize 281984 -ipcHandle 2368 -initialChannelId {4680540b-41d4-488f-9ac4-6575d4cf16e1} -parentPid 9844 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9844" -appDir "D:\task_173675879692052\build\application\firefox\browser" - 1 gpu)
[task 2025-01-13T10:53:52.795Z] 10:53:52     INFO - ==> process 9844 launched child process 5604 ("D:\task_173675879692052\build\application\firefox\firefox.exe" -contentproc -parentBuildID 20250113084730 -prefsHandle 2296 -prefsLen 26407 -prefMapHandle 2292 -prefMapSize 281984 -ipcHandle 2492 -initialChannelId {bb3a7ade-468b-46d3-88dc-fce2e589ed4a} -parentPid 9844 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9844" -win32kLockedDown -appDir "D:\task_173675879692052\build\application\firefox\browser" - 2 socket)
[task 2025-01-13T10:53:52.796Z] 10:53:52     INFO - ==> process 9844 launched child process 5744 ("D:\task_173675879692052\build\application\firefox\firefox.exe" -contentproc -isForBrowser -prefsHandle 3172 -prefsLen 26165 -prefMapHandle 3176 -prefMapSize 281984 -jsInitHandle 3180 -jsInitLen 259924 -parentBuildID 20250113084730 -ipcHandle 3184 -initialChannelId {26e43a68-131a-4b9f-9e9e-b02bf4eb6303} -parentPid 9844 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9844" -win32kLockedDown -appDir "D:\task_173675879692052\build\application\firefox\browser" - 3 tab)
[task 2025-01-13T10:53:52.797Z] 10:53:52     INFO - ==> process 9844 launched child process 7588 ("D:\task_173675879692052\build\application\firefox\firefox.exe" -contentproc -parentBuildID 20250113084730 -prefsHandle 3448 -prefsLen 27667 -prefMapHandle 3452 -prefMapSize 281984 -ipcHandle 3312 -initialChannelId {940abd94-75ff-4978-978b-e34113df9863} -parentPid 9844 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9844" -appDir "D:\task_173675879692052\build\application\firefox\browser" - 4 rdd)
[task 2025-01-13T10:53:52.798Z] 10:53:52     INFO - ==> process 9844 launched child process 8976 ("D:\task_173675879692052\build\application\firefox\firefox.exe" -contentproc -isForBrowser -prefsHandle 3744 -prefsLen 27729 -prefMapHandle 3748 -prefMapSize 281984 -jsInitHandle 3756 -jsInitLen 259924 -parentBuildID 20250113084730 -ipcHandle 3764 -initialChannelId {c0ec01a6-057c-4d10-b845-e9a440839a91} -parentPid 9844 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9844" -win32kLockedDown -appDir "D:\task_173675879692052\build\application\firefox\browser" - 5 tab)
[task 2025-01-13T10:53:52.800Z] 10:53:52     INFO - ==> process 9844 launched child process 6916 ("D:\task_173675879692052\build\application\firefox\firefox.exe" -contentproc -isForBrowser -prefsHandle 4024 -prefsLen 26684 -prefMapHandle 4028 -prefMapSize 281984 -jsInitHandle 4032 -jsInitLen 259924 -parentBuildID 20250113084730 -ipcHandle 3792 -initialChannelId {8977de63-c245-44ad-bd06-6cf218718068} -parentPid 9844 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9844" -win32kLockedDown -appDir "D:\task_173675879692052\build\application\firefox\browser" - 6 tab)
[task 2025-01-13T10:53:52.801Z] 10:53:52     INFO - ==> process 9844 launched child process 952 ("D:\task_173675879692052\build\application\firefox\firefox.exe" -contentproc -parentBuildID 20250113084730 -sandboxingKind 0 -prefsHandle 4712 -prefsLen 38308 -prefMapHandle 4720 -prefMapSize 281984 -ipcHandle 4716 -initialChannelId {e1ffdf64-dc9d-49ad-b1ea-7f4e57ac9e90} -parentPid 9844 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9844" -win32kLockedDown -appDir "D:\task_173675879692052\build\application\firefox\browser" - 7 utility)
[task 2025-01-13T10:53:52.802Z] 10:53:52     INFO - ==> process 9844 launched child process 5300 ("D:\task_173675879692052\build\application\firefox\firefox.exe" -contentproc -isForBrowser -prefsHandle 4872 -prefsLen 35773 -prefMapHandle 4884 -prefMapSize 281984 -jsInitHandle 4880 -jsInitLen 259924 -parentBuildID 20250113084730 -ipcHandle 4892 -initialChannelId {8af8ab96-6f1d-4ca0-a838-755d006f964a} -parentPid 9844 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9844" -win32kLockedDown -appDir "D:\task_173675879692052\build\application\firefox\browser" - 8 tab)
[task 2025-01-13T10:53:52.804Z] 10:53:52     INFO - ==> process 9844 launched child process 4924 ("D:\task_173675879692052\build\application\firefox\firefox.exe" -contentproc -isForBrowser -prefsHandle 4972 -prefsLen 35825 -prefMapHandle 4976 -prefMapSize 281984 -jsInitHandle 4980 -jsInitLen 259924 -parentBuildID 20250113084730 -ipcHandle 4988 -initialChannelId {80cbbe17-e989-49d2-827f-13ea096c0d7d} -parentPid 9844 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9844" -win32kLockedDown -appDir "D:\task_173675879692052\build\application\firefox\browser" - 9 tab)
[task 2025-01-13T10:53:52.805Z] 10:53:52     INFO - ==> process 9844 launched child process 6680 ("D:\task_173675879692052\build\application\firefox\firefox.exe" -contentproc -isForBrowser -prefsHandle 5316 -prefsLen 35825 -prefMapHandle 5320 -prefMapSize 281984 -jsInitHandle 5324 -jsInitLen 259924 -parentBuildID 20250113084730 -ipcHandle 5328 -initialChannelId {141023b7-6cff-4b91-9748-a425319502af} -parentPid 9844 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9844" -win32kLockedDown -appDir "D:\task_173675879692052\build\application\firefox\browser" - 10 tab)
[task 2025-01-13T10:53:52.806Z] 10:53:52     INFO - ==> process 9844 launched child process 5016 ("D:\task_173675879692052\build\application\firefox\firefox.exe" -contentproc -isForBrowser -prefsHandle 5588 -prefsLen 38360 -prefMapHandle 5592 -prefMapSize 281984 -jsInitHandle 5596 -jsInitLen 259924 -parentBuildID 20250113084730 -ipcHandle 5608 -initialChannelId {0b06edcf-e1aa-494f-8a16-20cf6912fd04} -parentPid 9844 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9844" -win32kLockedDown -appDir "D:\task_173675879692052\build\application\firefox\browser" - 11 tab)
[task 2025-01-13T10:53:52.808Z] 10:53:52     INFO - ==> process 9844 launched child process 5332 ("D:\task_173675879692052\build\application\firefox\firefox.exe" -contentproc -isForBrowser -prefsHandle 4136 -prefsLen 35825 -prefMapHandle 4124 -prefMapSize 281984 -jsInitHandle 4112 -jsInitLen 259924 -parentBuildID 20250113084730 -ipcHandle 4236 -initialChannelId {3d4d230f-f156-442f-98fb-e3a4a14a2386} -parentPid 9844 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9844" -win32kLockedDown -appDir "D:\task_173675879692052\build\application\firefox\browser" - 12 tab)
[task 2025-01-13T10:53:52.809Z] 10:53:52     INFO - ==> process 9844 launched child process 1492 ("D:\task_173675879692052\build\application\firefox\firefox.exe" -contentproc -parentBuildID 20250113084730 -sandboxingKind 1 -prefsHandle 2832 -prefsLen 38647 -prefMapHandle 4080 -prefMapSize 281984 -ipcHandle 4980 -initialChannelId {81fe29ea-f672-4763-a039-13ed4893574d} -parentPid 9844 -crashReporter "\\.\pipe\gecko-crash-server-pipe.9844" -win32kLockedDown -appDir "D:\task_173675879692052\build\application\firefox\browser" - 13 utility)
[task 2025-01-13T10:53:52.810Z] 10:53:52     INFO - zombiecheck | Checking for orphan process with PID: 7588
[task 2025-01-13T10:53:52.810Z] 10:53:52     INFO - zombiecheck | Checking for orphan process with PID: 5604
[task 2025-01-13T10:53:52.811Z] 10:53:52     INFO - zombiecheck | Checking for orphan process with PID: 6916
[task 2025-01-13T10:53:52.811Z] 10:53:52     INFO - zombiecheck | Checking for orphan process with PID: 6680
[task 2025-01-13T10:53:52.812Z] 10:53:52     INFO - zombiecheck | Checking for orphan process with PID: 8976
[task 2025-01-13T10:53:52.812Z] 10:53:52     INFO - zombiecheck | Checking for orphan process with PID: 5744
[task 2025-01-13T10:53:52.813Z] 10:53:52     INFO - zombiecheck | Checking for orphan process with PID: 5300
[task 2025-01-13T10:53:52.813Z] 10:53:52     INFO - zombiecheck | Checking for orphan process with PID: 5016
[task 2025-01-13T10:53:52.813Z] 10:53:52     INFO - zombiecheck | Checking for orphan process with PID: 952
[task 2025-01-13T10:53:52.814Z] 10:53:52     INFO - zombiecheck | Checking for orphan process with PID: 5332
[task 2025-01-13T10:53:52.814Z] 10:53:52     INFO - zombiecheck | Checking for orphan process with PID: 8888
[task 2025-01-13T10:53:52.814Z] 10:53:52     INFO - zombiecheck | Checking for orphan process with PID: 1492
[task 2025-01-13T10:53:52.815Z] 10:53:52     INFO - zombiecheck | Checking for orphan process with PID: 4924
[task 2025-01-13T10:53:52.815Z] 10:53:52     INFO - mozcrash Downloading symbols from: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/d2wrfEDkRjC_M7chKSYzXg/artifacts/public/build/target.crashreporter-symbols.zip
[task 2025-01-13T10:54:06.612Z] 10:54:06     INFO - mozcrash Copy/paste: D:/task_173675879692052/fetches\minidump-stackwalk\minidump-stackwalk.exe --symbols-url=https://symbols.mozilla.org/ --cyborg=C:\Users\task_173675879692052\AppData\Local\Temp\tmpb0dq9w6a\f573fefd-3d13-4682-a8ab-319e84f1e8bc.trace C:\Users\task_173675879692052\AppData\Local\Temp\tmp_0t4e55w.mozrunner\minidumps\f573fefd-3d13-4682-a8ab-319e84f1e8bc.dmp C:\Users\task_173675879692052\AppData\Local\Temp\tmpewz132e1
[task 2025-01-13T10:54:16.990Z] 10:54:16     INFO - mozcrash Saved minidump as D:\task_173675879692052\build\blobber_upload_dir\f573fefd-3d13-4682-a8ab-319e84f1e8bc.dmp
[task 2025-01-13T10:54:17.381Z] 10:54:17     INFO - PROCESS-CRASH | application crashed [None] | (SimpleTest/TestRunner.js) (finished) 
[task 2025-01-13T10:54:17.381Z] 10:54:17     INFO - Process type: unknown
[task 2025-01-13T10:54:17.381Z] 10:54:17     INFO - Process pid: 9844
[task 2025-01-13T10:54:17.385Z] 10:54:17     INFO - Crash dump filename: C:\Users\task_173675879692052\AppData\Local\Temp\tmp_0t4e55w.mozrunner\minidumps\f573fefd-3d13-4682-a8ab-319e84f1e8bc.dmp
[task 2025-01-13T10:54:17.385Z] 10:54:17     INFO - Operating system: Windows NT
[task 2025-01-13T10:54:17.385Z] 10:54:17     INFO -                   10.0.22621
[task 2025-01-13T10:54:17.385Z] 10:54:17     INFO - CPU: x86
[task 2025-01-13T10:54:17.385Z] 10:54:17     INFO -      GenuineIntel family 6 model 106 stepping 6
[task 2025-01-13T10:54:17.385Z] 10:54:17     INFO -      8 CPUs
[task 2025-01-13T10:54:17.385Z] 10:54:17     INFO - 
[task 2025-01-13T10:54:17.385Z] 10:54:17     INFO - No crash
[task 2025-01-13T10:54:17.385Z] 10:54:17     INFO - Process uptime: 1247 seconds
[task 2025-01-13T10:54:17.385Z] 10:54:17     INFO - 
[task 2025-01-13T10:54:17.385Z] 10:54:17     INFO - Thread 0 MainThread - tid: 2172
[task 2025-01-13T10:54:17.385Z] 10:54:17     INFO -  0  ntdll.dll!ZwWaitForAlertByThreadId + 0xc
[task 2025-01-13T10:54:17.385Z] 10:54:17     INFO -      eip = 0x77e2897c    esp = 0x0510e4f4    ebp = 0x0510e540    ebx = 0x05405ac0
[task 2025-01-13T10:54:17.385Z] 10:54:17     INFO -      esi = 0x00000000    edi = 0x00000000    eax = 0x00000000    ecx = 0x00000000
[task 2025-01-13T10:54:17.385Z] 10:54:17     INFO -      edx = 0x00000000 eflags = 0x00000202
[task 2025-01-13T10:54:17.385Z] 10:54:17     INFO -     Found by: given as instruction pointer in context
[task 2025-01-13T10:54:17.385Z] 10:54:17     INFO -  1  ntdll.dll!RtlSleepConditionVariableSRW + 0x113
[task 2025-01-13T10:54:17.385Z] 10:54:17     INFO -      eip = 0x77df3ff4    esp = 0x0510e4f8    ebp = 0x0510e540    ebx = 0x05405ac0
[task 2025-01-13T10:54:17.386Z] 10:54:17     INFO -      esi = 0x00000000    edi = 0x00000000
[task 2025-01-13T10:54:17.386Z] 10:54:17     INFO -     Found by: call frame info
[task 2025-01-13T10:54:17.386Z] 10:54:17     INFO -  2  KERNELBASE.dll!SleepConditionVariableSRW + 0x22
[task 2025-01-13T10:54:17.386Z] 10:54:17     INFO -      eip = 0x77566893    esp = 0x0510e548    ebp = 0x0510e564    ebx = 0x05405ac0
[task 2025-01-13T10:54:17.386Z] 10:54:17     INFO -      esi = 0x00000000    edi = 0x00000000
[task 2025-01-13T10:54:17.386Z] 10:54:17     INFO -     Found by: call frame info
[task 2025-01-13T10:54:17.386Z] 10:54:17     INFO -  3  mozglue.dll!mozilla::detail::ConditionVariableImpl::wait(mozilla::detail::MutexImpl&) [ConditionVariable_windows.cpp:06c0c8a8b4bbda66bde812fbbe40bbaaee3f1dd9 : 50 + 0xb]
[task 2025-01-13T10:54:17.386Z] 10:54:17     INFO -      eip = 0x6813d3ea    esp = 0x0510e56c    ebp = 0x0510e580    ebx = 0x05405ac0
[task 2025-01-13T10:54:17.386Z] 10:54:17     INFO -      esi = 0x00000000    edi = 0x00000000
[task 2025-01-13T10:54:17.386Z] 10:54:17     INFO -     Found by: call frame info
[task 2025-01-13T10:54:17.387Z] 10:54:17     INFO -  4  xul.dll!mozilla::OffTheBooksCondVar::Wait() [CondVar.h:06c0c8a8b4bbda66bde812fbbe40bbaaee3f1dd9 : 58]
[task 2025-01-13T10:54:17.387Z] 10:54:17     INFO -     Found by: inlining
[task 2025-01-13T10:54:17.387Z] 10:54:17     INFO -  5  xul.dll!mozilla::TaskController::GetRunnableForMTTask(bool) [TaskController.cpp:06c0c8a8b4bbda66bde812fbbe40bbaaee3f1dd9 : 739 + 0x10]
[task 2025-01-13T10:54:17.387Z] 10:54:17     INFO -      eip = 0x69f0a928    esp = 0x0510e588    ebp = 0x0510e5a4    ebx = 0x05405ac0
[task 2025-01-13T10:54:17.387Z] 10:54:17     INFO -      esi = 0x0545c030    edi = 0x00000000
[task 2025-01-13T10:54:17.387Z] 10:54:17     INFO -     Found by: call frame info
[task 2025-01-13T10:54:17.387Z] 10:54:17     INFO -  6  xul.dll!nsThread::ProcessNextEvent(bool, bool*) [nsThread.cpp:06c0c8a8b4bbda66bde812fbbe40bbaaee3f1dd9 : 1118 + 0x8]
[task 2025-01-13T10:54:17.387Z] 10:54:17     INFO -      eip = 0x69f25039    esp = 0x0510e5ac    ebp = 0x0510e6bc    ebx = 0x054b0084
[task 2025-01-13T10:54:17.387Z] 10:54:17     INFO -      esi = 0x0510e790    edi = 0x0510e790
[task 2025-01-13T10:54:17.387Z] 10:54:17     INFO -     Found by: call frame info
[task 2025-01-13T10:54:17.387Z] 10:54:17     INFO -  7  xul.dll!NS_ProcessNextEvent(nsIThread*, bool) [nsThreadUtils.cpp:06c0c8a8b4bbda66bde812fbbe40bbaaee3f1dd9 : 480]
[task 2025-01-13T10:54:17.387Z] 10:54:17     INFO -     Found by: inlining
[task 2025-01-13T10:54:17.387Z] 10:54:17     INFO -  8  xul.dll!mozilla::SpinEventLoopUntil(nsTSubstring<char> const&, nsThreadManager::SpinEventLoopUntilInternal::<lambda_6>&&, nsIThread*) [SpinEventLoopUntil.h:06c0c8a8b4bbda66bde812fbbe40bbaaee3f1dd9 : 176]
[task 2025-01-13T10:54:17.387Z] 10:54:17     INFO -     Found by: inlining
[task 2025-01-13T10:54:17.387Z] 10:54:17     INFO -  9  xul.dll!nsThreadManager::SpinEventLoopUntilInternal(nsTSubstring<char> const&, nsINestedEventLoopCondition*, mozilla::ShutdownPhase) [nsThreadManager.cpp:06c0c8a8b4bbda66bde812fbbe40bbaaee3f1dd9 : 699 + 0x480]
[task 2025-01-13T10:54:17.387Z] 10:54:17     INFO -      eip = 0x69f29606    esp = 0x0510e6c4    ebp = 0x0510e828    ebx = 0x2bdad880
[task 2025-01-13T10:54:17.387Z] 10:54:17     INFO -      esi = 0x00000000    edi = 0x0545d040
[task 2025-01-13T10:54:17.387Z] 10:54:17     INFO -     Found by: call frame info
<...>
[task 2025-01-13T11:05:21.082Z] 11:05:21     INFO - 0x77da0000 - 0x77da9fff  wow64cpu.dll  10.0.22621.2506
[task 2025-01-13T11:05:21.082Z] 11:05:21     INFO - 0x77db0000 - 0x77f61fff  ntdll.dll  10.0.22621.4541
[task 2025-01-13T11:05:21.082Z] 11:05:21     INFO - 
[task 2025-01-13T11:05:21.082Z] 11:05:21     INFO - Unloaded modules:
[task 2025-01-13T11:05:21.082Z] 11:05:21     INFO - 
[task 2025-01-13T11:05:21.082Z] 11:05:21     INFO - Unimplemented streams encountered:
[task 2025-01-13T11:05:21.082Z] 11:05:21     INFO - Stream 0x00000000 UnusedStream (Official) @ 0x00000000
[task 2025-01-13T11:05:21.082Z] 11:05:21     INFO - Stream 0x00000015 SystemMemoryInfoStream (Official) @ 0x000019e8
[task 2025-01-13T11:05:21.082Z] 11:05:21     INFO - Stream 0x00000016 ProcessVmCountersStream (Official) @ 0x00001bd4
[task 2025-01-13T11:05:21.082Z] 11:05:21     INFO - mozcrash Copy/paste: D:/task_173675879692052/fetches\minidump-stackwalk\minidump-stackwalk.exe --symbols-url=https://symbols.mozilla.org/ --cyborg=C:\Users\task_173675879692052\AppData\Local\Temp\tmp4alx7b1o\177c8929-8aeb-4edd-90c4-9dfd431618c9.trace C:\Users\task_173675879692052\AppData\Local\Temp\tmp_0t4e55w.mozrunner\minidumps\177c8929-8aeb-4edd-90c4-9dfd431618c9.dmp C:\Users\task_173675879692052\AppData\Local\Temp\tmpgy008ml6
[task 2025-01-13T11:05:21.082Z] 11:05:21     INFO - mozcrash Saved minidump as D:\task_173675879692052\build\blobber_upload_dir\177c8929-8aeb-4edd-90c4-9dfd431618c9.dmp
[task 2025-01-13T11:05:21.082Z] 11:05:21     INFO - PROCESS-CRASH | application crashed [None] | automation.py 
[task 2025-01-13T11:05:21.082Z] 11:05:21     INFO - Process type: unknown
[task 2025-01-13T11:05:21.082Z] 11:05:21     INFO - Process pid: None
[task 2025-01-13T11:05:21.082Z] 11:05:21     INFO - Crash dump filename: C:\Users\task_173675879692052\AppData\Local\Temp\tmp_0t4e55w.mozrunner\minidumps\177c8929-8aeb-4edd-90c4-9dfd431618c9.dmp
[task 2025-01-13T11:05:21.082Z] 11:05:21     INFO - stderr from minidump-stackwalk:
[task 2025-01-13T11:05:21.082Z] 11:05:21     INFO - ERROR MissingThreadList - Error processing dump: The thread list stream was not found
[task 2025-01-13T11:05:21.534Z] 11:05:21     INFO - Stopping web server
[task 2025-01-13T11:22:01.547Z] 11:22:01     INFO - Automation Error: mozharness timed out after 1000 seconds running ['D:\\task_173675879692052\\build\\venv\\Scripts\\python', '-u', 'D:\\task_173675879692052\\build\\tests\\mochitest\\runtests.py', 'dom/media/autoplay/test/mochitest/mochitest.toml', 'dom/media/mediasession/test/mochitest.toml', 'dom/media/mediasource/test/mochitest.toml', 'dom/media/mediasource/test/mochitest_compat.toml', 'dom/media/test/mochitest.toml', 'dom/media/test/mochitest_background_video.toml', 'dom/media/test/mochitest_bugs.toml', 'dom/media/test/mochitest_compat.toml', 'dom/media/test/mochitest_eme.toml', 'dom/media/test/mochitest_eme_compat.toml', 'dom/media/test/mochitest_media_engine.toml', 'dom/media/test/mochitest_media_recorder.toml', 'dom/media/test/mochitest_seek.toml', 'dom/media/test/mochitest_stream.toml', 'dom/media/webaudio/test/blink/mochitest.toml', 'dom/media/webaudio/test/mochitest.toml', 'dom/media/webaudio/test/mochitest_audio.toml', 'dom/media/webaudio/test/mochitest_bugs.toml', 'dom/media/webaudio/test/mochitest_media.toml', 'dom/media/webcodecs/test/mochitest.toml', 'dom/media/webrtc/tests/mochitests/identity/mochitest.toml', 'dom/media/webrtc/tests/mochitests/mochitest.toml', 'dom/media/webrtc/tests/mochitests/mochitest_datachannel.toml', 'dom/media/webrtc/tests/mochitests/mochitest_getusermedia.toml', 'dom/media/webrtc/tests/mochitests/mochitest_peerconnection.toml', 'dom/media/webspeech/recognition/test/mochitest.toml', 'dom/media/webspeech/synth/test/mochitest.toml', 'dom/media/webspeech/synth/test/startup/mochitest.toml', 'dom/media/webvtt/test/mochitest/mochitest.toml', 'ipc/glue/test/browser/mochitest_audio_off.toml', 'ipc/glue/test/browser/mochitest_audio_on.toml', '--setpref=layout.css.stylo-threads=4', '--setpref=media.peerconnection.mtransport_process=true', '--setpref=network.process.enabled=true', '--setpref=layers.d3d11.enable-blacklist=false', '--appname=D:\\task_173675879692052\\build\\application\\firefox\\firefox.exe', '--utility-path=tests/bin', '--extra-profile-file=tests/bin/plugins', '--symbols-path=https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/d2wrfEDkRjC_M7chKSYzXg/artifacts/public/build/target.crashreporter-symbols.zip', '--certificate-path=tests/certs', '--quiet', '--log-errorsummary=D:\\task_173675879692052\\build\\blobber_upload_dir\\mochitest-media_errorsummary.log', '--screenshot-on-fail', '--cleanup-crashes', '--marionette-startup-timeout=180', '--log-raw=-', '--subsuite=media']
[task 2025-01-13T11:22:01.549Z] 11:22:01     INFO - Return code: 1
[task 2025-01-13T11:22:01.550Z] 11:22:01  WARNING - Got 11 unexpected statuses
[task 2025-01-13T11:22:01.550Z] 11:22:01  WARNING - Got 7 unexpected crashes
[task 2025-01-13T11:22:01.550Z] 11:22:01    ERROR - No suite end message was emitted by this harness.
[task 2025-01-13T11:22:01.550Z] 11:22:01     INFO - TinderboxPrint: mochitest-mochitest-media<br/>1484/<em class="testfail">11</em>/0&nbsp;<em class="testfail">CRASH</em>
[task 2025-01-13T11:22:01.550Z] 11:22:01  WARNING - setting return code to 2
[task 2025-01-13T11:22:01.550Z] 11:22:01     INFO - The mochitest suite: mochitest-media ran with return status: FAILURE
[task 2025-01-13T11:22:01.551Z] 11:22:01     INFO - Running post-action listener: _package_coverage_data
[task 2025-01-13T11:22:01.551Z] 11:22:01     INFO - Running post-action listener: _resource_record_post_action
[task 2025-01-13T11:22:01.551Z] 11:22:01     INFO - Running post-action listener: process_java_coverage_data
[task 2025-01-13T11:22:01.551Z] 11:22:01     INFO - [mozharness: 2025-01-13 11:22:01.551249Z] Finished run-tests step (success)
[task 2025-01-13T11:22:01.551Z] 11:22:01     INFO - [mozharness: 2025-01-13 11:22:01.551249Z] Running uninstall step.
[task 2025-01-13T11:22:01.551Z] 11:22:01     INFO - Running pre-action listener: _resource_record_pre_action
[task 2025-01-13T11:22:01.551Z] 11:22:01     INFO - Running main action method: uninstall
[task 2025-01-13T11:22:01.551Z] 11:22:01     INFO - Skipping uninstall for non-MSIX test
[task 2025-01-13T11:22:01.551Z] 11:22:01     INFO - Running post-action listener: _resource_record_post_action
[task 2025-01-13T11:22:01.551Z] 11:22:01     INFO - [mozharness: 2025-01-13 11:22:01.551780Z] Finished uninstall step (success)
[task 2025-01-13T11:22:01.551Z] 11:22:01     INFO - Running post-run listener: _resource_record_post_run
[task 2025-01-13T11:22:05.190Z] 11:22:05     INFO - Validating Perfherder data against D:\task_173675879692052\mozharness\external_tools\performance-artifact-schema.json
[task 2025-01-13T11:22:05.197Z] 11:22:05     INFO - PERFHERDER_DATA: {"framework": {"name": "job_resource_usage"}, "suites": [{"name": "mochitest.mochitest-media.overall", "extraOptions": ["e10s", "taskcluster-Standard_F8s_v2"], "subtests": [{"name": "cpu_percent", "value": 47.7509145129225}, {"name": "io_write_bytes", "value": 10845640192}, {"name": "io.read_bytes", "value": 878460416}, {"name": "io_write_time", "value": 11}, {"name": "io_read_time", "value": 28}]}, {"name": "mochitest.mochitest-media.start-pulseaudio", "subtests": [{"name": "time", "value": 0.0}, {"name": "cpu_percent", "value": 0}]}, {"name": "mochitest.mochitest-media.install", "subtests": [{"name": "time", "value": 3.3899999999999864}, {"name": "cpu_percent", "value": 48.11874999999999}]}, {"name": "mochitest.mochitest-media.stage-files", "subtests": [{"name": "time", "value": 0.0}, {"name": "cpu_percent", "value": 0}]}, {"name": "mochitest.mochitest-media.run-tests", "subtests": [{"name": "time", "value": 4775.485}, {"name": "cpu_percent", "value": 47.75077398651482}]}, {"name": "mochitest.mochitest-media.uninstall", "subtests": [{"name": "time", "value": 0.0}, {"name": "cpu_percent", "value": 0}]}]}
[task 2025-01-13T11:22:05.197Z] 11:22:05     INFO - Total resource usage - Wall time: 4782s; CPU: Can't collect data; Read bytes: 878460416; Write bytes: 10845640192; Read time: 28; Write time: 11
[task 2025-01-13T11:22:05.197Z] 11:22:05     INFO - TinderboxPrint: I/O read bytes / time<br/>878,460,416 / 28
[task 2025-01-13T11:22:05.197Z] 11:22:05     INFO - TinderboxPrint: I/O write bytes / time<br/>10,845,640,192 / 11
[task 2025-01-13T11:22:05.197Z] 11:22:05     INFO - TinderboxPrint: CPU idle<br/>20,084.8 (52.5%)
[task 2025-01-13T11:22:05.197Z] 11:22:05     INFO - TinderboxPrint: CPU system<br/>6,548.0 (17.1%)
[task 2025-01-13T11:22:05.197Z] 11:22:05     INFO - TinderboxPrint: CPU user<br/>11,593.2 (30.3%)
[task 2025-01-13T11:22:05.209Z] 11:22:05     INFO - start-pulseaudio - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2025-01-13T11:22:05.227Z] 11:22:05     INFO - install - Wall time: 3s; CPU: 48%; Read bytes: 352256; Write bytes: 18550784; Read time: 0; Write time: 0
[task 2025-01-13T11:22:05.252Z] 11:22:05     INFO - stage-files - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2025-01-13T11:22:05.658Z] 11:22:05     INFO - run-tests - Wall time: 4775s; CPU: 48%; Read bytes: 878108160; Write bytes: 10827089408; Read time: 28; Write time: 11
[task 2025-01-13T11:22:05.705Z] 11:22:05     INFO - uninstall - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2025-01-13T11:22:25.159Z] 11:22:25  WARNING - returning nonzero exit status 2
[taskcluster 2025-01-13T11:22:25.782Z]    Exit Code: 2
[taskcluster 2025-01-13T11:22:25.782Z]    User Time: 0s
[taskcluster 2025-01-13T11:22:25.782Z]  Kernel Time: 46.875ms
[taskcluster 2025-01-13T11:22:25.782Z]    Wall Time: 1h22m52.6159415s
[taskcluster 2025-01-13T11:22:25.782Z]       Result: FAILED
[taskcluster 2025-01-13T11:22:25.782Z] === Task Finished ===
[taskcluster 2025-01-13T11:22:25.782Z] Task Duration: 1h22m52.618178s
[taskcluster 2025-01-13T11:22:27.557Z] Uploading artifact public/test_info/resource-usage.json from file D:\task_173675879692052\build\blobber_upload_dir\resource-usage.json with content encoding "gzip", mime type "application/json" and expiry 2026-01-13T08:54:07.558Z
[taskcluster 2025-01-13T11:22:27.558Z] Uploading artifact public/test_info/8cf05df8-7495-4957-b505-54029f38740d.dmp from file D:\task_173675879692052\build\blobber_upload_dir\8cf05df8-7495-4957-b505-54029f38740d.dmp with content encoding "gzip", mime type "application/octet-stream" and expiry 2026-01-13T08:54:07.558Z
[taskcluster 2025-01-13T11:22:27.558Z] Uploading artifact public/test_info/177c8929-8aeb-4edd-90c4-9dfd431618c9.dmp from file D:\task_173675879692052\build\blobber_upload_dir\177c8929-8aeb-4edd-90c4-9dfd431618c9.dmp with content encoding "gzip", mime type "application/octet-stream" and expiry 2026-01-13T08:54:07.558Z
[taskcluster 2025-01-13T11:22:27.561Z] Uploading artifact public/test_info/system-info.log from file D:\task_173675879692052\build\blobber_upload_dir\system-info.log with content encoding "gzip", mime type "text/plain" and expiry 2026-01-13T08:54:07.558Z
[taskcluster 2025-01-13T11:22:27.562Z] Uploading artifact public/logs/localconfig.json from file D:\task_173675879692052\logs\localconfig.json with content encoding "gzip", mime type "application/json" and expiry 2026-01-13T08:54:07.558Z
[taskcluster 2025-01-13T11:22:27.562Z] Uploading artifact public/test_info/f573fefd-3d13-4682-a8ab-319e84f1e8bc.dmp from file D:\task_173675879692052\build\blobber_upload_dir\f573fefd-3d13-4682-a8ab-319e84f1e8bc.dmp with content encoding "gzip", mime type "application/octet-stream" and expiry 2026-01-13T08:54:07.558Z
[taskcluster 2025-01-13T11:22:27.562Z] Uploading artifact public/test_info/ef322e18-a969-4984-a873-ce33d41d11ab.dmp from file D:\task_173675879692052\build\blobber_upload_dir\ef322e18-a969-4984-a873-ce33d41d11ab.dmp with content encoding "gzip", mime type "application/octet-stream" and expiry 2026-01-13T08:54:07.558Z
[taskcluster 2025-01-13T11:22:27.566Z] Uploading artifact public/test_info/profile_resource-usage.json from file D:\task_173675879692052\build\blobber_upload_dir\profile_resource-usage.json with content encoding "gzip", mime type "application/json" and expiry 2026-01-13T08:54:07.558Z
[taskcluster 2025-01-13T11:22:27.571Z] Uploading artifact public/test_info/mozilla-test-fail-screenshot_f_n8yjb7.png from file D:\task_173675879692052\build\blobber_upload_dir\mozilla-test-fail-screenshot_f_n8yjb7.png with content encoding "identity", mime type "image/png" and expiry 2026-01-13T08:54:07.558Z
[taskcluster 2025-01-13T11:22:27.571Z] Uploading artifact public/test_info/manifests.list from file D:\task_173675879692052\build\blobber_upload_dir\manifests.list with content encoding "gzip", mime type "application/octet-stream" and expiry 2026-01-13T08:54:07.558Z
[taskcluster 2025-01-13T11:22:27.572Z] Uploading artifact public/test_info/7d17af4e-ce27-4e6d-a4c2-7b73a4b7c459.dmp from file D:\task_173675879692052\build\blobber_upload_dir\7d17af4e-ce27-4e6d-a4c2-7b73a4b7c459.dmp with content encoding "gzip", mime type "application/octet-stream" and expiry 2026-01-13T08:54:07.558Z
[taskcluster 2025-01-13T11:22:27.573Z] Uploading artifact public/test_info/e9a43344-436b-4b39-ba41-6e77709b2625.dmp from file D:\task_173675879692052\build\blobber_upload_dir\e9a43344-436b-4b39-ba41-6e77709b2625.dmp with content encoding "gzip", mime type "application/octet-stream" and expiry 2026-01-13T08:54:07.558Z
[taskcluster 2025-01-13T11:22:27.577Z] Uploading artifact public/test_info/40b4b36d-a23f-4159-bdf2-01696550cd9c.dmp from file D:\task_173675879692052\build\blobber_upload_dir\40b4b36d-a23f-4159-bdf2-01696550cd9c.dmp with content encoding "gzip", mime type "application/octet-stream" and expiry 2026-01-13T08:54:07.558Z
[taskcluster 2025-01-13T11:22:27.599Z] Uploading artifact public/test_info/mochitest-media_errorsummary.log from file D:\task_173675879692052\build\blobber_upload_dir\mochitest-media_errorsummary.log with content encoding "gzip", mime type "text/plain" and expiry 2026-01-13T08:54:07.558Z
[taskcluster 2025-01-13T11:22:29.066Z] Uploading link artifact public/logs/live.log to artifact public/logs/live_backing.log with expiry 2026-01-13T08:54:07.558Z
[taskcluster:error] exit status 2

Comment 1

[Intermittent Failures Robot]

Summary

1 failures in 4508 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• windows11-32-2009-qr: 1
  • opt: 1

Table

	spi
windows11-32-2009-qr/-/opt	1

For more details, see:

https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1941312&startday=2025-01-13&endday=2025-01-19&tree=all

Comment 2

[BugBot [:suhaib / :marco/ :calixte]]

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit BugBot documentation.

Comment 3

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-esr140: 1

Table

	no_variant
windows11-x86/opt	1

For more details, see:

https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1941312&startday=2026-03-09&endday=2026-03-15&tree=all