Closed Bug 1537679 Opened 5 years ago Closed 2 years ago

Intermittent MessageLoop destroyed before MessageChannel that's bound to it dom/media/webaudio/test/test_mediaStreamAudioSourceNodeNoGC.html | unexpected-crash-dump-found - This test left crash dumps behind, but we weren't expecting it to!

Categories

(Core :: IPC, defect, P5)

defect

Tracking

()

RESOLVED INVALID

People

(Reporter: intermittent-bug-filer, Unassigned)

References

Details

(Keywords: intermittent-failure, regression)

#[markdown(off)]
Filed by: ncsoregi [at] mozilla.com

https://treeherder.mozilla.org/logviewer.html#?job_id=235135991&repo=mozilla-central

https://queue.taskcluster.net/v1/task/GzsV_eluTsqr7I4xUx0deQ/runs/0/artifacts/public/logs/live_backing.log

06:31:49 INFO - TEST-START | dom/media/webaudio/test/test_mediaStreamAudioSourceNodeNoGC.html
06:31:49 INFO - GECKO(9260) | ++DOMWINDOW == 7 (000001AC00859400) [pid = 2556] [serial = 7] [outer = 000001AC7FEDC6A0]
06:31:49 INFO - GECKO(9260) | ++DOMWINDOW == 8 (000001AC0085A800) [pid = 2556] [serial = 8] [outer = 000001AC7FEDC6A0]
06:31:49 INFO - GECKO(9260) | --DOMWINDOW == 7 (000001AC0084E800) [pid = 2556] [serial = 6] [outer = 0000000000000000] [url = about:blank]
06:31:49 INFO - GECKO(9260) | --DOMWINDOW == 6 (000001AC7E179400) [pid = 2556] [serial = 2] [outer = 0000000000000000] [url = about:blank]
06:31:49 INFO - GECKO(9260) | --DOMWINDOW == 5 (000001AC783B5000) [pid = 2556] [serial = 3] [outer = 0000000000000000] [url = about:blank]
06:31:49 INFO - GECKO(9260) | --DOMWINDOW == 4 (000001AC00859400) [pid = 2556] [serial = 7] [outer = 0000000000000000] [url = about:blank]
06:31:49 INFO - GECKO(9260) | MEMORY STAT | vsize 2102807MB | vsizeMaxContiguous 66484354MB | residentFast 92MB | heapAllocated 8MB
06:31:49 INFO - Buffered messages logged at 06:31:33
06:31:49 INFO - TEST-PASS | dom/media/webaudio/test/test_mediaStreamAudioSourceNodeNoGC.html | A valid string reason is expected
06:31:49 INFO - TEST-PASS | dom/media/webaudio/test/test_mediaStreamAudioSourceNodeNoGC.html | Reason cannot be empty
06:31:49 INFO - TEST-PASS | dom/media/webaudio/test/test_mediaStreamAudioSourceNodeNoGC.html | Waiting for audio to pass through the analyser
06:31:49 INFO - TEST-FAIL | dom/media/webaudio/test/test_mediaStreamAudioSourceNodeNoGC.html | The author of the test has indicated that flaky timeouts are expected. Reason: gUM and WebAudio data is async to main thread. We need a timeout to see that something does NOT happen to data.
06:31:49 INFO - TEST-PASS | dom/media/webaudio/test/test_mediaStreamAudioSourceNodeNoGC.html | Audio was detected by the analyser. Forcing CC.
06:31:49 INFO - Buffered messages logged at 06:31:34
06:31:49 INFO - Checking that GC didn't destroy the stream or source node
06:31:49 INFO - TEST-FAIL | dom/media/webaudio/test/test_mediaStreamAudioSourceNodeNoGC.html | The author of the test has indicated that flaky timeouts are expected. Reason: gUM and WebAudio data is async to main thread. We need a timeout to see that something does NOT happen to data.
06:31:49 INFO - Buffered messages logged at 06:31:39
06:31:49 INFO - TEST-PASS | dom/media/webaudio/test/test_mediaStreamAudioSourceNodeNoGC.html | Audio is still flowing
06:31:49 INFO - Buffered messages finished
06:31:49 INFO - TEST-UNEXPECTED-ERROR | dom/media/webaudio/test/test_mediaStreamAudioSourceNodeNoGC.html | unexpected-crash-dump-found - This test left crash dumps behind, but we weren't expecting it to!
06:31:49 INFO - Found unexpected crash dump file C:\Users\task_1553147339\AppData\Local\Temp\tmpek6el1.mozrunner\minidumps\d84ad0d5-d792-4032-9c3a-102d6222365e.dmp.
06:31:49 INFO - Found unexpected crash dump file C:\Users\task_1553147339\AppData\Local\Temp\tmpek6el1.mozrunner\minidumps\d84ad0d5-d792-4032-9c3a-102d6222365e.extra.
06:31:49 INFO - TEST-UNEXPECTED-CRASH | dom/media/webaudio/test/test_mediaStreamAudioSourceNodeNoGC.html | Finished in 6559ms
06:31:49 INFO - {u'runtime': 6559}
06:31:49 INFO - TEST-INFO took 6559ms

Hit MOZ_CRASH(MessageLoop destroyed before MessageChannel that's bound to it) at z:/build/build/src/ipc/glue/MessageChannel.cpp:713

Crash reason: EXCEPTION_BREAKPOINT
Crash address: 0x7ff8e307ea85
Assertion: Unknown assertion type 0x00000000
Process uptime: 1 seconds

Thread 0 (crashed)
0 xul.dll!mozilla::ipc::MessageChannel::WillDestroyCurrentMessageLoop() [MessageChannel.cpp:ac0cd1a710f30cc60a48a4edcb35a9499cc38c2e : 713 + 0x0]
rax = 0x00007ff8e9ff7b41 rdx = 0x00007ff92641a640
rcx = 0x00007ff91c71fae0 rbx = 0x0000000000000002
rsi = 0x0000004958dff420 rdi = 0x000001a79a8bc3d0
rbp = 0x0000000000001f10 rsp = 0x0000004958dff400
r8 = 0x0000004958df9558 r9 = 0x0000004958dfab70
r10 = 0x0000000000000000 r11 = 0x0000004958dfaa80
r12 = 0x000001a79a804040 r13 = 0x00007ff927b63fc0
r14 = 0x0000004958dff5f0 r15 = 0xffffffffffffffff
rip = 0x00007ff8e307ea85
Found by: given as instruction pointer in context
1 xul.dll!MessageLoop::~MessageLoop() [message_loop.cc:ac0cd1a710f30cc60a48a4edcb35a9499cc38c2e : 253 + 0x6]
rbx = 0x0000000000000002 rbp = 0x0000000000001f10
rsp = 0x0000004958dff440 r12 = 0x000001a79a804040
r13 = 0x00007ff927b63fc0 r14 = 0x0000004958dff5f0
r15 = 0xffffffffffffffff rip = 0x00007ff8e3034936
Found by: call frame info
2 xul.dll!XRE_InitChildProcess(int,char * * const,XREChildData const *) [nsEmbedFunctions.cpp:ac0cd1a710f30cc60a48a4edcb35a9499cc38c2e : 783 + 0x8]
rbx = 0x0000000000000002 rbp = 0x0000000000001f10
rsp = 0x0000004958dff500 r12 = 0x000001a79a804040
r13 = 0x00007ff927b63fc0 r14 = 0x0000004958dff5f0
r15 = 0xffffffffffffffff rip = 0x00007ff8e7ff4da8
Found by: call frame info

https://searchfox.org/mozilla-central/rev/7c20ad925005fbad7b8e08813115f1ec7fa1c248/ipc/glue/MessageChannel.cpp#713

Component: Web Audio → IPC
Summary: Intermittent dom/media/webaudio/test/test_mediaStreamAudioSourceNodeNoGC.html | unexpected-crash-dump-found - This test left crash dumps behind, but we weren't expecting it to! → Intermittent MessageLoop destroyed before MessageChannel that's bound to it dom/media/webaudio/test/test_mediaStreamAudioSourceNodeNoGC.html | unexpected-crash-dump-found - This test left crash dumps behind, but we weren't expecting it to!
Blocks: 1537985
Blocks: 1541247

MessageChannel::WillDestroyCurrentMessageLoop does not exist any more, we only have ChildLaxReaper::WillDestroyCurrentMessageLoop now. And this intermittent is not happening any more. Got here through bug 1730374 related investigation.

Status: NEW → RESOLVED
Closed: 2 years ago
Resolution: --- → INVALID
See Also: → 1730374
You need to log in before you can comment on or make changes to this bug.