Open Bug 1863918 Opened 1 year ago Updated 4 days ago

Intermittent MOZ_ASSERT(mAudioEnded) [@ mozilla::DecodedStreamGraphListener::NotifyOutput] | single tracking bug

Categories

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

defect

Tracking

()

REOPENED

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure, intermittent-testcase)

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


[task 2023-11-09T09:35:29.719Z] 09:35:29     INFO -  TEST-PASS | dom/media/test/test_streams_element_capture_mediatrack.html | [started opus-mapping2.mp4-64 t=8.425] Length of array should match number of running tests
[task 2023-11-09T09:35:49.853Z] 09:35:49     INFO -  wait for org.mozilla.geckoview.test_runner complete; top activity=com.android.launcher3
[task 2023-11-09T09:35:49.853Z] 09:35:49     INFO -  runtestsremote.py | Application ran for: 0:00:44.545282
[task 2023-11-09T09:35:49.920Z] 09:35:49     INFO -  mozcrash Copy/paste: /builds/worker/fetches/minidump-stackwalk/minidump-stackwalk --symbols-url=https://symbols.mozilla.org/ --cyborg=/tmp/tmp6q0gxvvn/7a1fa6ed-5271-bcaf-2827-1875ed4f3e25.trace /tmp/tmpqlhyumpa/7a1fa6ed-5271-bcaf-2827-1875ed4f3e25.dmp /builds/worker/workspace/build/symbols
[task 2023-11-09T09:35:53.656Z] 09:35:53     INFO -  mozcrash Saved minidump as /builds/worker/workspace/build/blobber_upload_dir/7a1fa6ed-5271-bcaf-2827-1875ed4f3e25.dmp
[task 2023-11-09T09:35:53.656Z] 09:35:53     INFO -  mozcrash Saved app info as /builds/worker/workspace/build/blobber_upload_dir/7a1fa6ed-5271-bcaf-2827-1875ed4f3e25.extra
[task 2023-11-09T09:35:53.657Z] 09:35:53  WARNING -  PROCESS-CRASH | MOZ_ASSERT(mAudioEnded) [@ mozilla::DecodedStreamGraphListener::NotifyOutput] | dom/media/test/mochitest_stream.toml
[task 2023-11-09T09:35:53.657Z] 09:35:53     INFO -  Process type: content
[task 2023-11-09T09:35:53.657Z] 09:35:53     INFO -  Process pid: None
[task 2023-11-09T09:35:53.658Z] 09:35:53     INFO -  Mozilla crash reason: MOZ_ASSERT(mAudioEnded)
[task 2023-11-09T09:35:53.658Z] 09:35:53     INFO -  Crash dump filename: /tmp/tmpqlhyumpa/7a1fa6ed-5271-bcaf-2827-1875ed4f3e25.dmp
[task 2023-11-09T09:35:53.658Z] 09:35:53     INFO -  Operating system: Android
[task 2023-11-09T09:35:53.658Z] 09:35:53     INFO -                    0.0.0 Linux 3.10.0+ #260 SMP PREEMPT Fri May 19 12:48:14 PDT 2017 x86_64
[task 2023-11-09T09:35:53.658Z] 09:35:53     INFO -  CPU: amd64
[task 2023-11-09T09:35:53.658Z] 09:35:53     INFO -       family 6 model 6 stepping 3
[task 2023-11-09T09:35:53.658Z] 09:35:53     INFO -       4 CPUs
[task 2023-11-09T09:35:53.658Z] 09:35:53     INFO -  Crash reason:  SIGSEGV / SEGV_MAPERR
[task 2023-11-09T09:35:53.658Z] 09:35:53     INFO -  Crash address: 0x0
[task 2023-11-09T09:35:53.658Z] 09:35:53     INFO -  Crashing instruction: `mov dword [0x0], 0xb4`
[task 2023-11-09T09:35:53.658Z] 09:35:53     INFO -  Memory accessed by instruction:
[task 2023-11-09T09:35:53.658Z] 09:35:53     INFO -    0. Address: 0x0000000000000000
[task 2023-11-09T09:35:53.658Z] 09:35:53     INFO -       Size: 4
[task 2023-11-09T09:35:53.658Z] 09:35:53     INFO -  Process uptime: not available
[task 2023-11-09T09:35:53.658Z] 09:35:53     INFO -  Thread 32 Thread-9 (crashed)
[task 2023-11-09T09:35:53.658Z] 09:35:53     INFO -   0  libxul.so!mozilla::DecodedStreamGraphListener::NotifyOutput(mozilla::MediaSegment::Type, long) [DecodedStream.cpp:5392006086fa6f66b9c2f5919b8c65d04cf44936 : 180 + 0x0]
[task 2023-11-09T09:35:53.658Z] 09:35:53     INFO -       rax = 0x00007b978627f8eb    rdx = 0x00007b977d284840
[task 2023-11-09T09:35:53.658Z] 09:35:53     INFO -       rcx = 0x00007b97aa104d50    rbx = 0x00007b977d0a7d00
[task 2023-11-09T09:35:53.658Z] 09:35:53     INFO -       rsi = 0x0000000000000001    rdi = 0x00007b977d2848c0
[task 2023-11-09T09:35:53.658Z] 09:35:53     INFO -       rbp = 0x00007b977d284c90    rsp = 0x00007b977d284c60
[task 2023-11-09T09:35:53.659Z] 09:35:53     INFO -        r8 = 0x00007b97a9fc0d2c     r9 = 0x00007b977d284550
[task 2023-11-09T09:35:53.659Z] 09:35:53     INFO -       r10 = 0x00000000ffffff80    r11 = 0x0000000000000246
[task 2023-11-09T09:35:53.659Z] 09:35:53     INFO -       r12 = 0x000000007c319000    r13 = 0x00007b977d284d30
[task 2023-11-09T09:35:53.659Z] 09:35:53     INFO -       r14 = 0x0000000000003300    r15 = 0x0000000000000001
[task 2023-11-09T09:35:53.659Z] 09:35:53     INFO -       rip = 0x00007b978be16455
[task 2023-11-09T09:35:53.659Z] 09:35:53     INFO -      Found by: given as instruction pointer in context
[task 2023-11-09T09:35:53.659Z] 09:35:53     INFO -   1  libxul.so!mozilla::SourceVideoTrackListener::NotifyOutput(mozilla::MediaTrackGraph*, long)::$_0::operator()() const [DecodedStream.cpp:5392006086fa6f66b9c2f5919b8c65d04cf44936 : 303]
[task 2023-11-09T09:35:53.659Z] 09:35:53     INFO -      Found by: inlining
[task 2023-11-09T09:35:53.659Z] 09:35:53     INFO -   2  libxul.so!mozilla::detail::RunnableFunction<mozilla::SourceVideoTrackListener::NotifyOutput(mozilla::MediaTrackGraph*, long)::$_0>::Run() [nsThreadUtils.h:5392006086fa6f66b9c2f5919b8c65d04cf44936 : 548 + 0x1c]
[task 2023-11-09T09:35:53.659Z] 09:35:53     INFO -       rbx = 0x00007b977c2e3f80    rbp = 0x00007b977d284cb0
[task 2023-11-09T09:35:53.659Z] 09:35:53     INFO -       rsp = 0x00007b977d284ca0    r12 = 0x000000007c319000
[task 2023-11-09T09:35:53.659Z] 09:35:53     INFO -       r13 = 0x00007b977d284d30    r14 = 0xaaaaaaaaaaaaaaaa
[task 2023-11-09T09:35:53.659Z] 09:35:53     INFO -       r15 = 0x00007b977d284d20    rip = 0x00007b978be1dfac
[task 2023-11-09T09:35:53.659Z] 09:35:53     INFO -      Found by: call frame info
[task 2023-11-09T09:35:53.659Z] 09:35:53     INFO -   3  libxul.so!mozilla::TaskQueue::Runner::Run() [TaskQueue.cpp:5392006086fa6f66b9c2f5919b8c65d04cf44936 : 257 + 0x10]
[task 2023-11-09T09:35:53.660Z] 09:35:53     INFO -       rbx = 0x00007b977c489d28    rbp = 0x00007b977d284dd0
[task 2023-11-09T09:35:53.660Z] 09:35:53     INFO -       rsp = 0x00007b977d284cc0    r12 = 0x000000007c319000
[task 2023-11-09T09:35:53.660Z] 09:35:53     INFO -       r13 = 0x00007b977d284d30    r14 = 0xaaaaaaaaaaaaaaaa
[task 2023-11-09T09:35:53.660Z] 09:35:53     INFO -       r15 = 0x00007b977d284d20    rip = 0x00007b9789a7d740
[task 2023-11-09T09:35:53.660Z] 09:35:53     INFO -      Found by: call frame info
[task 2023-11-09T09:35:53.660Z] 09:35:53     INFO -   4  libxul.so!nsThreadPool::Run() [nsThreadPool.cpp:5392006086fa6f66b9c2f5919b8c65d04cf44936 : 341 + 0x10]
[task 2023-11-09T09:35:53.660Z] 09:35:53     INFO -       rbx = 0x00007b977ec458a0    rbp = 0x00007b977d284f00
[task 2023-11-09T09:35:53.660Z] 09:35:53     INFO -       rsp = 0x00007b977d284de0    r12 = 0x00007b977d284e40
[task 2023-11-09T09:35:53.660Z] 09:35:53     INFO -       r13 = 0x00007b977d284e30    r14 = 0x00007b977d284e60
[task 2023-11-09T09:35:53.660Z] 09:35:53     INFO -       r15 = 0x0000000000000000    rip = 0x00007b9789a9bbba
[task 2023-11-09T09:35:53.660Z] 09:35:53     INFO -      Found by: call frame info
[task 2023-11-09T09:35:53.660Z] 09:35:53     INFO -   5  libxul.so!nsThread::ProcessNextEvent(bool, bool*) [nsThread.cpp:5392006086fa6f66b9c2f5919b8c65d04cf44936 : 1192 + 0xd]
[task 2023-11-09T09:35:53.660Z] 09:35:53     INFO -       rbx = 0x00007b977d7810a0    rbp = 0x00007b977d285040
[task 2023-11-09T09:35:53.660Z] 09:35:53     INFO -       rsp = 0x00007b977d284f10    r12 = 0x00007b977d7811c8
[task 2023-11-09T09:35:53.660Z] 09:35:53     INFO -       r13 = 0x000000ad18cdc65a    r14 = 0xaaaaaaaaaaaaaaaa
[task 2023-11-09T09:35:53.660Z] 09:35:53     INFO -       r15 = 0x00007b977d284fa0    rip = 0x00007b9789a96041
[task 2023-11-09T09:35:53.660Z] 09:35:53     INFO -      Found by: call frame info
[task 2023-11-09T09:35:53.661Z] 09:35:53     INFO -   6  libxul.so!NS_ProcessNextEvent(nsIThread*, bool) [nsThreadUtils.cpp:5392006086fa6f66b9c2f5919b8c65d04cf44936 : 480 + 0x11]
[task 2023-11-09T09:35:53.661Z] 09:35:53     INFO -       rbx = 0x0000000000000000    rbp = 0x00007b977d285080
[task 2023-11-09T09:35:53.661Z] 09:35:53     INFO -       rsp = 0x00007b977d285050    r12 = 0x00007b977d285098
[task 2023-11-09T09:35:53.661Z] 09:35:53     INFO -       r13 = 0x00007b977d77b1a0    r14 = 0x00007b977d7810a0
[task 2023-11-09T09:35:53.661Z] 09:35:53     INFO -       r15 = 0x00007b977d28505f    rip = 0x00007b9789a9a23c
[task 2023-11-09T09:35:53.661Z] 09:35:53     INFO -      Found by: call frame info
[task 2023-11-09T09:35:53.661Z] 09:35:53     INFO -   7  libxul.so!mozilla::ipc::MessagePumpForNonMainThreads::Run(base::MessagePump::Delegate*) [MessagePump.cpp:5392006086fa6f66b9c2f5919b8c65d04cf44936 : 300 + 0x9]
[task 2023-11-09T09:35:53.661Z] 09:35:53     INFO -       rbx = 0x00007b977d77b180    rbp = 0x00007b977d2850d0
[task 2023-11-09T09:35:53.661Z] 09:35:53     INFO -       rsp = 0x00007b977d285090    r12 = 0x00007b977d285098
[task 2023-11-09T09:35:53.661Z] 09:35:53     INFO -       r13 = 0x00007b977d77b1a0    r14 = 0x00007b977d2851a0
[task 2023-11-09T09:35:53.661Z] 09:35:53     INFO -       r15 = 0x00007b977d7810a0    rip = 0x00007b978a1b2292
[task 2023-11-09T09:35:53.661Z] 09:35:53     INFO -      Found by: call frame info
[task 2023-11-09T09:35:53.661Z] 09:35:53     INFO -   8  libxul.so!MessageLoop::RunInternal() [message_loop.cc:5392006086fa6f66b9c2f5919b8c65d04cf44936 : 370 + 0x16]
[task 2023-11-09T09:35:53.661Z] 09:35:53     INFO -       rbx = 0x00007b977d2851a0    rbp = 0x00007b977d285110
[task 2023-11-09T09:35:53.661Z] 09:35:53     INFO -       rsp = 0x00007b977d2850e0    r12 = 0x00007b977d2854f8
[task 2023-11-09T09:35:53.661Z] 09:35:53     INFO -       r13 = 0x0000000000000002    r14 = 0x00007b977d285120
[task 2023-11-09T09:35:53.662Z] 09:35:53     INFO -       r15 = 0x000000000000001b    rip = 0x00007b978a1542ae
[task 2023-11-09T09:35:53.662Z] 09:35:53     INFO -      Found by: call frame info
[task 2023-11-09T09:35:53.662Z] 09:35:53     INFO -   9  libxul.so!MessageLoop::RunHandler() [message_loop.cc:5392006086fa6f66b9c2f5919b8c65d04cf44936 : 363]
[task 2023-11-09T09:35:53.662Z] 09:35:53     INFO -      Found by: inlining
[task 2023-11-09T09:35:53.662Z] 09:35:53     INFO -  10  libxul.so!MessageLoop::Run() [message_loop.cc:5392006086fa6f66b9c2f5919b8c65d04cf44936 : 345 + 0x7]
[task 2023-11-09T09:35:53.662Z] 09:35:53     INFO -       rbx = 0x00007b977d2851a0    rbp = 0x00007b977d285150
[task 2023-11-09T09:35:53.662Z] 09:35:53     INFO -       rsp = 0x00007b977d285120    r12 = 0x00007b977d2854f8
[task 2023-11-09T09:35:53.662Z] 09:35:53     INFO -       r13 = 0x0000000000000002    r14 = 0x00007b977d285120
[task 2023-11-09T09:35:53.662Z] 09:35:53     INFO -       r15 = 0x000000000000001b    rip = 0x00007b978a154217
[task 2023-11-09T09:35:53.662Z] 09:35:53     INFO -      Found by: call frame info
[task 2023-11-09T09:35:53.662Z] 09:35:53     INFO -  11  libxul.so!nsThread::ThreadFunc(void*) [nsThread.cpp:5392006086fa6f66b9c2f5919b8c65d04cf44936 : 370 + 0x7]
[task 2023-11-09T09:35:53.662Z] 09:35:53     INFO -       rbx = 0x00007b977d7b02c0    rbp = 0x00007b977d285340
[task 2023-11-09T09:35:53.662Z] 09:35:53     INFO -       rsp = 0x00007b977d285160    r12 = 0x00007b977d2854f8
[task 2023-11-09T09:35:53.662Z] 09:35:53     INFO -       r13 = 0x0000000000000002    r14 = 0x00007b977d2851a0
[task 2023-11-09T09:35:53.662Z] 09:35:53     INFO -       r15 = 0x000000000000001b    rip = 0x00007b9789a9301b
[task 2023-11-09T09:35:53.662Z] 09:35:53     INFO -      Found by: call frame info
[task 2023-11-09T09:35:53.662Z] 09:35:53     INFO -  12  libnss3.so!_pt_root [ptthread.c:5392006086fa6f66b9c2f5919b8c65d04cf44936 : 201 + 0x6]
[task 2023-11-09T09:35:53.662Z] 09:35:53     INFO -       rbx = 0x00007b977e51a680    rbp = 0x00007b977d285380
[task 2023-11-09T09:35:53.663Z] 09:35:53     INFO -       rsp = 0x00007b977d285350    r12 = 0x00007b977d2854f8
[task 2023-11-09T09:35:53.663Z] 09:35:53     INFO -       r13 = 0x0000000000000002    r14 = 0x0000000000004de4
[task 2023-11-09T09:35:53.663Z] 09:35:53     INFO -       r15 = 0x00007b977d285450    rip = 0x00007b979152981e
[task 2023-11-09T09:35:53.663Z] 09:35:53     INFO -      Found by: call frame info
[task 2023-11-09T09:35:53.663Z] 09:35:53     INFO -  13  libmozglue.so!set_alt_signal_stack_and_start(PthreadCreateParams*) [pthread_create_interposer.cpp:5392006086fa6f66b9c2f5919b8c65d04cf44936 : 81 + 0x5]
[task 2023-11-09T09:35:53.663Z] 09:35:53     INFO -       rbx = 0x00007b977e51a680    rbp = 0x00007b977d2853e0
[task 2023-11-09T09:35:53.663Z] 09:35:53     INFO -       rsp = 0x00007b977d285390    r12 = 0x00007b9791700000
[task 2023-11-09T09:35:53.663Z] 09:35:53     INFO -       r13 = 0x00007b97aa02c06e    r14 = 0x00007b977d2853a0
[task 2023-11-09T09:35:53.663Z] 09:35:53     INFO -       r15 = 0x00007b97915296e9    rip = 0x00007b97aa02c13c
[task 2023-11-09T09:35:53.663Z] 09:35:53     INFO -      Found by: call frame info
[task 2023-11-09T09:35:53.663Z] 09:35:53     INFO -  14  libc.so + 0x89771
[task 2023-11-09T09:35:53.663Z] 09:35:53     INFO -       rbx = 0x00007b977d2854d0    rbp = 0x0000000000004da3
[task 2023-11-09T09:35:53.663Z] 09:35:53     INFO -       rsp = 0x00007b977d2853f0    r12 = 0x00007b977d285450
[task 2023-11-09T09:35:53.663Z] 09:35:53     INFO -       r13 = 0x00007b97aa02c06e    r14 = 0x00007b977d285450
[task 2023-11-09T09:35:53.663Z] 09:35:53     INFO -       r15 = 0x00007b977d2854e8    rip = 0x00007b97af646772
[task 2023-11-09T09:35:53.663Z] 09:35:53     INFO -      Found by: call frame info
[task 2023-11-09T09:35:53.663Z] 09:35:53     INFO -  15  libmozglue.so!getdelim [getline_interposer.cpp:5392006086fa6f66b9c2f5919b8c65d04cf44936 : 105 + 0x5]
[task 2023-11-09T09:35:53.664Z] 09:35:53     INFO -       rsp = 0x00007b977d285428    rip = 0x00007b97aa02c06e
[task 2023-11-09T09:35:53.664Z] 09:35:53     INFO -      Found by: stack scanning
[task 2023-11-09T09:35:53.664Z] 09:35:53     INFO -  16  0x7b977d28544f
[task 2023-11-09T09:35:53.664Z] 09:35:53     INFO -       rbp = 0x00007b97aa02c06e    rsp = 0x00007b977d285430
[task 2023-11-09T09:35:53.664Z] 09:35:53     INFO -       rip = 0x00007b977d285450
[task 2023-11-09T09:35:53.664Z] 09:35:53     INFO -      Found by: call frame info
[task 2023-11-09T09:35:53.664Z] 09:35:53     INFO -  17  libc.so + 0x299eb
[task 2023-11-09T09:35:53.664Z] 09:35:53     INFO -       rbp = 0x00007b97aa02c06e    rsp = 0x00007b977d285440
[task 2023-11-09T09:35:53.664Z] 09:35:53     INFO -       rip = 0x00007b97af5e69ec
[task 2023-11-09T09:35:53.664Z] 09:35:53     INFO -      Found by: stack scanning
[task 2023-11-09T09:35:53.664Z] 09:35:53     INFO -  18  libc.so + 0x896bf
[task 2023-11-09T09:35:53.664Z] 09:35:53     INFO -       rsp = 0x00007b977d285448    rip = 0x00007b97af6466c0
[task 2023-11-09T09:35:53.664Z] 09:35:53     INFO -      Found by: stack scanning
[task 2023-11-09T09:35:53.664Z] 09:35:53     INFO -  19  libc.so + 0x1ca65
[task 2023-11-09T09:35:53.664Z] 09:35:53     INFO -       rsp = 0x00007b977d285450    rip = 0x00007b97af5d9a66
[task 2023-11-09T09:35:53.664Z] 09:35:53     INFO -      Found by: stack scanning
[task 2023-11-09T09:35:53.664Z] 09:35:53     INFO -  20  libmozglue.so!getdelim [getline_interposer.cpp:5392006086fa6f66b9c2f5919b8c65d04cf44936 : 105 + 0x5]
[task 2023-11-09T09:35:53.664Z] 09:35:53     INFO -       rsp = 0x00007b977d2854b8    rip = 0x00007b97aa02c06e
[task 2023-11-09T09:35:53.664Z] 09:35:53     INFO -      Found by: stack scanning
[task 2023-11-09T09:35:53.664Z] 09:35:53     INFO -  21  0x7b977d9d4e7f
[task 2023-11-09T09:35:53.664Z] 09:35:53     INFO -       rbp = 0x00007b97aa02c06e    rsp = 0x00007b977d2854c0
[task 2023-11-09T09:35:53.664Z] 09:35:53     INFO -       rip = 0x00007b977d9d4e80
[task 2023-11-09T09:35:53.665Z] 09:35:53     INFO -      Found by: call frame info
[task 2023-11-09T09:35:53.665Z] 09:35:53     INFO -  Thread 0 st_runner:tab15
Status: NEW → RESOLVED
Closed: 1 year ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 1 year ago10 months ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 10 months ago5 months ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 5 months ago3 months ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
You need to log in before you can comment on or make changes to this bug.