1449841 - Intermittent PROCESS-CRASH | Main app process exited normally | application crashed [@ mozilla::MediaEngineWebRTCMicrophoneSource::Stop]

Status: RESOLVED INCOMPLETE

(Core :: General, defect, P5)

Description

[Treeherder Bug Filer]

Filed by: dluca [at] mozilla.com

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

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

Comment 1

[Andreea Pavel [:apavel]]

Tier 2 failure log: https://treeherder.mozilla.org/logviewer.html#?job_id=171036314&repo=mozilla-inbound&lineNumber=59095

15:17:02     INFO -  1797 INFO TEST-OK | dom/media/tests/mochitest/test_peerConnection_verifyAudioAfterRenegotiation.html | took 5480ms
15:17:02     INFO -  GECKO(1600) | ++DOMWINDOW == 7 (000001994C747000) [pid = 6764] [serial = 591] [outer = 000001994B610000]
15:17:02     INFO -  1798 INFO None1799 INFO TEST-START | dom/media/tests/mochitest/test_peerConnection_verifyDescriptions.html
15:17:02     INFO -  GECKO(1600) | --DOCSHELL 000001994CBA0000 == 2 [pid = 6764] [id = {d22bc2b0-9a7b-44c4-8585-353e99eb3852}]
15:17:02     INFO -  GECKO(1600) | ++DOMWINDOW == 8 (000001994C754800) [pid = 6764] [serial = 592] [outer = 000001994B610000]
15:17:02     INFO -  GECKO(1600) | 967884 url=http://mochi.test:8888/tests/dom/media/tests/mochitest/test_peerConnection_verifyAudioAfter:default) in nr_ice_peer_ctx_start_checks2 all streams were done
15:17:02     INFO -  GECKO(1600) | (ice/WARNING) ICE(PC:1522336617831000 (id=4294967884 url=http://mochi.test:8888/tests/dom/media/tests/mochitest/test_peerConnection_verifyAudioAfter): peer (PC:1522336617831000 (id=4294967884 url=http://mochi.test:8888/tests/dom/media/tests/mochitest/test_peerConnection_verifyAudioAfter:default) has no stream matching stream 0-1522336617831000 (id=4294967884 url=http://mochi.test:8888/tests/dom/media/tests/mochitest/test_peerConnection_verifyAudioAfter aLevel=1
15:17:02     INFO -  GECKO(1600) | (ice/INFO) ICE-PEER(PC:1522336617831000 (id=4294967884 url=http://mochi.test:8888/tests/dom/media/tests/mochitest/test_peerConnection_verifyAudioAfter:default): all checks completed success=1 fail=0
15:17:02     INFO -  GECKO(1600) | (ice/ERR) ICE(PC:1522336617831000 (id=4294967884 url=http://mochi.test:8888/tests/dom/media/tests/mochitest/test_peerConnection_verifyAudioAfter): peer (PC:1522336617831000 (id=4294967884 url=http://mochi.test:8888/tests/dom/media/tests/mochitest/test_peerConnection_verifyAudioAfter:default) in nr_ice_peer_ctx_start_checks2 all streams were done
15:17:02     INFO -  GECKO(1600) | (stun/INFO) STUN-CLIENT(Lxif|IP4:10.144.26.218:50306/UDP|IP4:10.144.26.218:50302/UDP(host(IP4:10.144.26.218:50306/UDP)|candidate:0 1 UDP 2122252543 10.144.26.218 50302 typ host)): Timed out
15:17:02     INFO -  GECKO(1600) | (ice/INFO) ICE-PEER(PC:1522336617840000 (id=4294967884 url=http://mochi.test:8888/tests/dom/media/tests/mochitest/test_peerConnection_verifyAudioAfter:default)/CAND-PAIR(Lxif): setting pair to state FAILED: Lxif|IP4:10.144.26.218:50306/UDP|IP4:10.144.26.218:50302/UDP(host(IP4:10.144.26.218:50306/UDP)|candidate:0 1 UDP 2122252543 10.144.26.218 50302 typ host)
15:17:02     INFO -  GECKO(1600) | Assertion failure: mState == kStarted, at z:/build/build/src/dom/media/webrtc/MediaEngineDefault.cpp:506
15:17:23     INFO -  GECKO(1600) | #01: mozilla::MediaDevice::Stop() [dom/media/MediaManager.cpp:1013]
15:17:23     INFO -  GECKO(1600) | #02: nsresult mozilla::detail::RunnableFunction<<lambda_2e06c9ec7f345f21d45db9c47f741efa> >::Run() [xpcom/threads/nsThreadUtils.h:551]
15:17:23     INFO -  GECKO(1600) | #03: MessageLoop::RunTask(already_AddRefed<nsIRunnable>) [ipc/chromium/src/base/message_loop.cc:453]
15:17:23     INFO -  GECKO(1600) | #04: MessageLoop::DeferOrRunPendingTask(MessageLoop::PendingTask &&) [ipc/chromium/src/base/message_loop.cc:463]
15:17:23     INFO -  GECKO(1600) | #05: MessageLoop::DoWork() [ipc/chromium/src/base/message_loop.cc:535]
15:17:23     INFO -  GECKO(1600) | #06: mozilla::ipc::MessagePumpForNonMainUIThreads::DoRunLoop() [ipc/glue/MessagePump.cpp:404]
15:17:23     INFO -  GECKO(1600) | #07: base::MessagePumpWin::RunWithDispatcher(base::MessagePump::Delegate *,base::MessagePumpWin::Dispatcher *) [ipc/chromium/src/base/message_pump_win.cc:58]
15:17:23     INFO -  GECKO(1600) | #08: MessageLoop::RunHandler() [ipc/chromium/src/base/message_loop.cc:320]
15:17:23     INFO -  GECKO(1600) | #09: MessageLoop::Run() [ipc/chromium/src/base/message_loop.cc:300]
15:17:23     INFO -  GECKO(1600) | #10: base::Thread::ThreadMain() [ipc/chromium/src/base/thread.cc:184]
15:17:23     INFO -  GECKO(1600) | #11: static unsigned long `anonymous namespace'::ThreadFunc(void *) [ipc/chromium/src/base/platform_thread_win.cc:29]
15:17:23     INFO -  GECKO(1600) | #12: KERNEL32.DLL + 0x12774
15:17:23     INFO -  GECKO(1600) | #13: ntdll.dll + 0x70d51
15:17:23     INFO -  GECKO(1600) | [6764:Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:357: mozilla::PeerConnectionImpl::PeerConnectionImpl: PeerConnectionImpl constructor for
15:17:23     INFO -  GECKO(1600) | [1600:Socket Thread]: D/mtransport NrIceCtx static call to find local stun addresses
15:17:23     INFO -  GECKO(1600) | [6764:Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:357: mozilla::PeerConnectionImpl::PeerConnectionImpl: PeerConnectionImpl constructor for
15:17:23     INFO -  GECKO(1600) | [1600:Socket Thread]: D/mtransport NrIceCtx static call to find local stun addresses
15:17:23     INFO -  GECKO(1600) | [6764:Main Thread]: I/signaling [main|PeerConnectionMedia] PeerConnectionMedia.cpp:64: mozilla::PeerConnectionMedia::ProtocolProxyQueryHandler::OnProxyAvailable: Proxy Available: 0
15:17:23     INFO -  GECKO(1600) | [6764:Main Thread]: I/signaling [main|PeerConnectionMedia] PeerConnectionMedia.cpp:122: mozilla::PeerConnectionMedia::StunAddrsHandler::OnStunAddrsAvailable: receiving (6) stun addrs
15:17:23     INFO -  GECKO(1600) | [6764:Main Thread]: I/signaling [main|PeerConnectionMedia] PeerConnectionMedia.cpp:64: mozilla::PeerConnectionMedia::ProtocolProxyQueryHandler::OnProxyAvailable: Proxy Available: 0
15:17:23     INFO -  GECKO(1600) | [6764:Main Thread]: I/signaling [main|PeerConnectionMedia] PeerConnectionMedia.cpp:122: mozilla::PeerConnectionMedia::StunAddrsHandler::OnStunAddrsAvailable: receiving (6) stun addrs
15:17:23     INFO -  GECKO(1600) | ++DOCSHELL 000001994D597000 == 3 [pid = 6764] [id = {a89fe04c-8391-415d-8b4a-dd61645ca53c}]
15:17:23     INFO -  GECKO(1600) | ++DOMWINDOW == 9 (000001994CA3F800) [pid = 6764] [serial = 593] [outer = 0000000000000000]
15:17:23     INFO -  GECKO(1600) | ###!!! [Parent][MessageChannel] Error: (msgtype=0x16008C,name=PBrowser::Msg_UpdateNativeWindowHandle) Channel error: cannot send/recv
15:17:23     INFO -  GECKO(1600) | ###!!! [Parent][MessageChannel] Error: (msgtype=0x16007F,name=PBrowser::Msg_Destroy) Channel error: cannot send/recv
15:17:23     INFO -  GECKO(1600) | ++DOCSHELL 000001C48A695000 == 4 [pid = 1600] [id = {8f0586fe-323f-4a6c-91b6-6b2ecd3c20ca}]


15:17:32  WARNING -  PROCESS-CRASH | Main app process exited normally | application crashed [@ mozilla::MediaEngineDefaultAudioSource::Stop(RefPtr<mozilla::AllocationHandle const > const &)]
15:17:32     INFO -  Crash dump filename: c:\users\genericworker\appdata\local\temp\tmpct8zv0.mozrunner\minidumps\48431568-c50c-442b-8817-2d0343178791.dmp
15:17:32     INFO -  Operating system: Windows NT
15:17:32     INFO -                    10.0.15063
15:17:32     INFO -  CPU: amd64
15:17:32     INFO -       family 6 model 62 stepping 4
15:17:32     INFO -       8 CPUs
15:17:32     INFO -  GPU: UNKNOWN
15:17:32     INFO -  Crash reason:  EXCEPTION_BREAKPOINT
15:17:32     INFO -  Crash address: 0x7ff9f5f57bc2
15:17:32     INFO -  Assertion: Unknown assertion type 0x00000000
15:17:32     INFO -  Process uptime: 491 seconds
15:17:32     INFO -  Thread 33 (crashed)
15:17:32     INFO -   0  xul.dll!mozilla::MediaEngineDefaultAudioSource::Stop(RefPtr<mozilla::AllocationHandle const > const &) [MediaEngineDefault.cpp:9125b9cf1730aac801ab8a6811557e10eec7bea1 : 506 + 0x1b]
15:17:32     INFO -      rax = 0x0000000000000000   rdx = 0x0000005af59ff508
15:17:32     INFO -      rcx = 0x00000000ffffffff   rbx = 0x00000000000001fa
15:17:32     INFO -      rsi = 0x000001994c8c0290   rdi = 0x000001994c866de0
15:17:32     INFO -      rbp = 0x0000005af59ff5e0   rsp = 0x0000005af59ff4f0
15:17:32     INFO -       r8 = 0x0000005af59ff500    r9 = 0x0000005af59ff4f8
15:17:32     INFO -      r10 = 0x0000000000000000   r11 = 0x0000005af59faa50
15:17:32     INFO -      r12 = 0x0000000000000000   r13 = 0x0000000000000000
15:17:32     INFO -      r14 = 0x0000000000000000   r15 = 0x0000000000000000
15:17:32     INFO -      rip = 0x00007ff9f5f57bc2
15:17:32     INFO -      Found by: given as instruction pointer in context
15:17:32     INFO -   1  xul.dll!mozilla::MediaDevice::Stop() [MediaManager.cpp:9125b9cf1730aac801ab8a6811557e10eec7bea1 : 1013 + 0x48]
15:17:32     INFO -      rbx = 0x00000000000001fa   rbp = 0x0000005af59ff5e0
15:17:32     INFO -      rsp = 0x0000005af59ff540   r12 = 0x0000000000000000
15:17:32     INFO -      r13 = 0x0000000000000000   r14 = 0x0000000000000000
15:17:32     INFO -      r15 = 0x0000000000000000   rip = 0x00007ff9f5d453f6
15:17:32     INFO -      Found by: call frame info
15:17:32     INFO -   2  xul.dll!nsresult mozilla::detail::RunnableFunction<<lambda_2e06c9ec7f345f21d45db9c47f741efa> >::Run() [nsThreadUtils.h:9125b9cf1730aac801ab8a6811557e10eec7bea1 : 551 + 0x24]
15:17:32     INFO -      rbx = 0x00000000000001fa   rbp = 0x0000005af59ff5e0
15:17:32     INFO -      rsp = 0x0000005af59ff570   r12 = 0x0000000000000000
15:17:32     INFO -      r13 = 0x0000000000000000   r14 = 0x0000000000000000
15:17:32     INFO -      r15 = 0x0000000000000000   rip = 0x00007ff9f5d3fffa
15:17:32     INFO -      Found by: call frame info
15:17:32     INFO -   3  xul.dll!MessageLoop::RunTask(already_AddRefed<nsIRunnable>) [message_loop.cc:9125b9cf1730aac801ab8a6811557e10eec7bea1 : 452 + 0xf]
15:17:32     INFO -      rbx = 0x00000000000001fa   rbp = 0x0000005af59ff5e0
15:17:32     INFO -      rsp = 0x0000005af59ff5a0   r12 = 0x0000000000000000
15:17:32     INFO -      r13 = 0x0000000000000000   r14 = 0x0000000000000000
15:17:32     INFO -      r15 = 0x0000000000000000   rip = 0x00007ff9f3de6a15
15:17:32     INFO -      Found by: call frame info
15:17:32     INFO -   4  xul.dll!MessageLoop::DeferOrRunPendingTask(MessageLoop::PendingTask &&) [message_loop.cc:9125b9cf1730aac801ab8a6811557e10eec7bea1 : 460 + 0x34]
15:17:32     INFO -      rbx = 0x00000000000001fa   rbp = 0x0000005af59ff5e0
15:17:32     INFO -      rsp = 0x0000005af59ff5f0   r12 = 0x0000000000000000
15:17:32     INFO -      r13 = 0x0000000000000000   r14 = 0x0000000000000000
15:17:32     INFO -      r15 = 0x0000000000000000   rip = 0x00007ff9f3ddedfe
15:17:32     INFO -      Found by: call frame info
15:17:32     INFO -   5  xul.dll!MessageLoop::DoWork() [message_loop.cc:9125b9cf1730aac801ab8a6811557e10eec7bea1 : 535 + 0x5]
15:17:32     INFO -      rbx = 0x00000000000001fa   rbp = 0x0000005af59ff5e0
15:17:32     INFO -      rsp = 0x0000005af59ff620   r12 = 0x0000000000000000
15:17:32     INFO -      r13 = 0x0000000000000000   r14 = 0x0000000000000000
15:17:32     INFO -      r15 = 0x0000000000000000   rip = 0x00007ff9f3ddf659
15:17:32     INFO -      Found by: call frame info
15:17:32     INFO -   6  xul.dll!mozilla::ipc::MessagePumpForNonMainUIThreads::DoRunLoop() [MessagePump.cpp:9125b9cf1730aac801ab8a6811557e10eec7bea1 : 403 + 0x9]
15:17:32     INFO -      rbx = 0x00000000000001fa   rbp = 0x0000005af59ff5e0
15:17:32     INFO -      rsp = 0x0000005af59ff670   r12 = 0x0000000000000000
15:17:32     INFO -      r13 = 0x0000000000000000   r14 = 0x0000000000000000
15:17:32     INFO -      r15 = 0x0000000000000000   rip = 0x00007ff9f3e1aa26
15:17:32     INFO -      Found by: call frame info
15:17:32     INFO -   7  xul.dll!base::MessagePumpWin::RunWithDispatcher(base::MessagePump::Delegate *,base::MessagePumpWin::Dispatcher *) [message_pump_win.cc:9125b9cf1730aac801ab8a6811557e10eec7bea1 : 56 + 0x6]
15:17:32     INFO -      rbx = 0x00000000000001fa   rbp = 0x0000005af59ff5e0
15:17:32     INFO -      rsp = 0x0000005af59ff6a0   r12 = 0x0000000000000000
15:17:32     INFO -      r13 = 0x0000000000000000   r14 = 0x0000000000000000
15:17:32     INFO -      r15 = 0x0000000000000000   rip = 0x00007ff9f3dce356
15:17:32     INFO -      Found by: call frame info
15:17:32     INFO -   8  xul.dll!MessageLoop::RunHandler() [message_loop.cc:9125b9cf1730aac801ab8a6811557e10eec7bea1 : 319 + 0x5]
15:17:32     INFO -      rbx = 0x00000000000001fa   rbp = 0x0000005af59ff5e0
15:17:32     INFO -      rsp = 0x0000005af59ff6f0   r12 = 0x0000000000000000
15:17:32     INFO -      r13 = 0x0000000000000000   r14 = 0x0000000000000000
15:17:32     INFO -      r15 = 0x0000000000000000   rip = 0x00007ff9f3de6902
15:17:32     INFO -      Found by: call frame info
15:17:32     INFO -   9  xul.dll!MessageLoop::Run() [message_loop.cc:9125b9cf1730aac801ab8a6811557e10eec7bea1 : 299 + 0x8]
15:17:32     INFO -      rbx = 0x00000000000001fa   rbp = 0x0000005af59ff5e0
15:17:32     INFO -      rsp = 0x0000005af59ff720   r12 = 0x0000000000000000
15:17:32     INFO -      r13 = 0x0000000000000000   r14 = 0x0000000000000000
15:17:32     INFO -      r15 = 0x0000000000000000   rip = 0x00007ff9f3de64d6
15:17:32     INFO -      Found by: call frame info
15:17:32     INFO -  10  xul.dll!base::Thread::ThreadMain() [thread.cc:9125b9cf1730aac801ab8a6811557e10eec7bea1 : 181 + 0xa]
15:17:32     INFO -      rbx = 0x00000000000001fa   rbp = 0x0000005af59ff5e0
15:17:32     INFO -      rsp = 0x0000005af59ff770   r12 = 0x0000000000000000
15:17:32     INFO -      r13 = 0x0000000000000000   r14 = 0x0000000000000000
15:17:32     INFO -      r15 = 0x0000000000000000   rip = 0x00007ff9f3de7d51
15:17:32     INFO -      Found by: call frame info

Comment 2

[Andreea Pavel [:apavel]]

Please ignore comment 1, there already is a bug for that: https://bugzilla.mozilla.org/show_bug.cgi?id=1450000

Comment 3

[Intermittent Failures Robot]

8 failures in 718 pushes (0.011 failures/push) were associated with this bug in the last 7 days.    

Repository breakdown:
* mozilla-inbound: 6
* autoland: 2

Platform breakdown:
* linux64-qr: 4
* linux32: 2
* windows10-64-qr: 1
* linux64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1449841&startday=2018-03-26&endday=2018-04-01&tree=trunk

Comment 4

[Intermittent Failures Robot]

13 failures in 765 pushes (0.017 failures/push) were associated with this bug in the last 7 days.    

Repository breakdown:
* mozilla-inbound: 7
* autoland: 4
* try: 1
* mozilla-central: 1

Platform breakdown:
* linux64-qr: 7
* linux64: 5
* linux64-nightly: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1449841&startday=2018-04-02&endday=2018-04-08&tree=trunk

Comment 5

[Intermittent Failures Robot]

5 failures in 792 pushes (0.006 failures/push) were associated with this bug in the last 7 days.    

Repository breakdown:
* try: 2
* mozilla-inbound: 1
* mozilla-central: 1
* autoland: 1

Platform breakdown:
* linux64-qr: 2
* linux32: 2
* linux64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1449841&startday=2018-04-09&endday=2018-04-15&tree=trunk

Comment 6

[Intermittent Failures Robot]

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

Repository breakdown:
* autoland: 1

Platform breakdown:
* linux32: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1449841&startday=2018-04-16&endday=2018-04-22&tree=trunk

Comment 7

[Intermittent Failures Robot]

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

Repository breakdown:
* mozilla-release: 1

Platform breakdown:
* linux32-stylo-disabled: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1449841&startday=2018-04-23&endday=2018-04-29&tree=trunk

Comment 8

[Firefox Bug Husbandry Bot]

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup