Closed Bug 1869556 Opened 11 months ago Closed 11 months ago

Intermittent application crashed [@ mozilla::TaskController::ExecuteNextTaskOnlyMainThreadInternal] | single tracking bug

Categories

(Core :: XPCOM, defect)

Product:
Core
Component:
XPCOM
Type:
defect

Tracking

()

Status:
RESOLVED FIXED
Milestone:
122 Branch
Tracking Flags:
Tracking Status
firefox-esr115 --- disabled
firefox120 --- disabled
firefox121 --- disabled
firefox122 --- fixed

People

(Reporter: intermittent-bug-filer, Assigned: gregp)

References

(Regression)

Details

(4 keywords)

Crash Data

Attachments

(1 file)

Bug 1869556 - Revert changes to test_youtube_flash_embed.html, set pref in mochitest.toml instead of using pushPrevEnv r?mccr8!
48 bytes, text/x-phabricator-request
Details | Review

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

[task 2023-12-12T14:07:57.328Z] 14:07:57     INFO - TEST-START | dom/base/test/test_youtube_flash_embed.html
[task 2023-12-12T14:07:57.718Z] 14:07:57     INFO - GECKO(1299) | [Parent 1299, Main Thread] WARNING: NS_ENSURE_TRUE(she && she->mInfo->mSharedState.Get()) failed: file /builds/worker/checkouts/gecko/docshell/shistory/SessionHistoryEntry.cpp:1159
[task 2023-12-12T14:07:57.946Z] 14:07:57     INFO - GECKO(1299) | [Parent 1299, Main Thread] WARNING: WebProgress Ignored: no longer current window global: file /builds/worker/checkouts/gecko/dom/ipc/BrowserParent.cpp:3118
[task 2023-12-12T14:07:58.174Z] 14:07:58     INFO - GECKO(1299) | [Child 4837, Main Thread] WARNING: Listener is not retargetable: file /builds/worker/checkouts/gecko/netwerk/protocol/http/HttpChannelChild.cpp:3046
[task 2023-12-12T14:07:58.175Z] 14:07:58     INFO - GECKO(1299) | [Child 4837, Main Thread] WARNING: Failed to retarget HTML data delivery to the parser thread.: file /builds/worker/checkouts/gecko/parser/html/nsHtml5StreamParser.cpp:1227
[task 2023-12-12T14:07:58.188Z] 14:07:58     INFO - GECKO(1299) | [Child 4837, Main Thread] WARNING: Listener is not retargetable: file /builds/worker/checkouts/gecko/netwerk/protocol/http/HttpChannelChild.cpp:3046
[task 2023-12-12T14:07:58.189Z] 14:07:58     INFO - GECKO(1299) | [Child 4837, Main Thread] WARNING: Failed to retarget HTML data delivery to the parser thread.: file /builds/worker/checkouts/gecko/parser/html/nsHtml5StreamParser.cpp:1227
[task 2023-12-12T14:07:58.313Z] 14:07:58     INFO - GECKO(1299) | [Child 4837, Main Thread] WARNING: Listener is not retargetable: file /builds/worker/checkouts/gecko/netwerk/protocol/http/HttpChannelChild.cpp:3046
[task 2023-12-12T14:07:58.314Z] 14:07:58     INFO - GECKO(1299) | [Child 4837, Main Thread] WARNING: Failed to retarget HTML data delivery to the parser thread.: file /builds/worker/checkouts/gecko/parser/html/nsHtml5StreamParser.cpp:1227
[task 2023-12-12T14:07:58.327Z] 14:07:58     INFO - GECKO(1299) | [Child 4837, Main Thread] WARNING: Listener is not retargetable: file /builds/worker/checkouts/gecko/netwerk/protocol/http/HttpChannelChild.cpp:3046
[task 2023-12-12T14:07:58.328Z] 14:07:58     INFO - GECKO(1299) | [Child 4837, Main Thread] WARNING: Failed to retarget HTML data delivery to the parser thread.: file /builds/worker/checkouts/gecko/parser/html/nsHtml5StreamParser.cpp:1227
[task 2023-12-12T14:07:58.395Z] 14:07:58     INFO - GECKO(1299) | MEMORY STAT | vsize 19212MB | residentFast 225MB | heapAllocated 35MB
[task 2023-12-12T14:07:58.476Z] 14:07:58     INFO - TEST-OK | dom/base/test/test_youtube_flash_embed.html | took 1148ms
[task 2023-12-12T14:07:58.632Z] 14:07:58     INFO - TEST-START | Shutdown
[task 2023-12-12T14:07:58.633Z] 14:07:58     INFO - Passed:  44812
[task 2023-12-12T14:07:58.633Z] 14:07:58     INFO - Failed:  0
[task 2023-12-12T14:07:58.634Z] 14:07:58     INFO - Todo:    110
[task 2023-12-12T14:07:58.636Z] 14:07:58     INFO - Mode:    e10s
[task 2023-12-12T14:07:58.637Z] 14:07:58     INFO - Slowest: 141650ms - /tests/dom/base/test/test_timeout_clamp.html
[task 2023-12-12T14:07:58.639Z] 14:07:58     INFO - SimpleTest FINISHED
[task 2023-12-12T14:07:58.644Z] 14:07:58     INFO - TEST-INFO | Ran 1 Loops
<...>
[task 2023-12-12T14:08:20.652Z] 14:08:20     INFO - zombiecheck | Checking for orphan process with PID: 1522
[task 2023-12-12T14:08:20.653Z] 14:08:20     INFO - mozcrash Copy/paste: /builds/worker/fetches/minidump-stackwalk/minidump-stackwalk --symbols-url=https://symbols.mozilla.org/ --cyborg=/tmp/tmpy3v4sl1v/6006e28f-adfe-e61c-5b8b-8d7059115d68.trace /tmp/tmp7u69n394.mozrunner/minidumps/6006e28f-adfe-e61c-5b8b-8d7059115d68.dmp /builds/worker/workspace/build/symbols
[task 2023-12-12T14:08:25.087Z] 14:08:25     INFO - mozcrash Saved minidump as /builds/worker/workspace/build/blobber_upload_dir/6006e28f-adfe-e61c-5b8b-8d7059115d68.dmp
[task 2023-12-12T14:08:25.154Z] 14:08:25     INFO - PROCESS-CRASH | application crashed [@ mozilla::TaskController::ExecuteNextTaskOnlyMainThreadInternal] | dom/base/test/mochitest.toml 
[task 2023-12-12T14:08:25.154Z] 14:08:25     INFO - Process type: unknown
[task 2023-12-12T14:08:25.155Z] 14:08:25     INFO - Process pid: None
[task 2023-12-12T14:08:25.155Z] 14:08:25     INFO - Crash dump filename: /tmp/tmp7u69n394.mozrunner/minidumps/6006e28f-adfe-e61c-5b8b-8d7059115d68.dmp
[task 2023-12-12T14:08:25.156Z] 14:08:25     INFO - Operating system: Linux
[task 2023-12-12T14:08:25.156Z] 14:08:25     INFO -                   4.4.0-1014-aws #14taskcluster1-Ubuntu SMP Tue Apr 3 10:27:00 UTC 2018
[task 2023-12-12T14:08:25.156Z] 14:08:25     INFO - CPU: amd64
[task 2023-12-12T14:08:25.157Z] 14:08:25     INFO -      family 6 model 85 stepping 7
[task 2023-12-12T14:08:25.157Z] 14:08:25     INFO -      2 CPUs
[task 2023-12-12T14:08:25.157Z] 14:08:25     INFO - Linux Ubuntu 18.04 - bionic (Ubuntu 18.04.6 LTS)
[task 2023-12-12T14:08:25.157Z] 14:08:25     INFO - 
[task 2023-12-12T14:08:25.157Z] 14:08:25     INFO - Crash reason:  SIGABRT
[task 2023-12-12T14:08:25.157Z] 14:08:25     INFO - Crash address: 0x0
[task 2023-12-12T14:08:25.158Z] 14:08:25     INFO - Crashing instruction: `test al, al`
[task 2023-12-12T14:08:25.158Z] 14:08:25     INFO - No memory accessed by instruction
[task 2023-12-12T14:08:25.158Z] 14:08:25     INFO - Process uptime: not available
[task 2023-12-12T14:08:25.158Z] 14:08:25     INFO - 
[task 2023-12-12T14:08:25.158Z] 14:08:25     INFO - Thread 0 Isolated Web Co (crashed)
[task 2023-12-12T14:08:25.158Z] 14:08:25     INFO -  0  libxul.so!mozilla::TaskController::ExecuteNextTaskOnlyMainThreadInternal(mozilla::detail::BaseAutoLock<mozilla::Mutex&> const&) [TaskController.cpp:378226435d1f217637869bc238a2bff9ae584e04 : 700 + 0x0]
[task 2023-12-12T14:08:25.158Z] 14:08:25     INFO -      rax = 0x00000000bea04d01    rdx = 0x00007f84f4a93ab0
[task 2023-12-12T14:08:25.158Z] 14:08:25     INFO -      rcx = 0x00007f84f339fca0    rbx = 0x00007f84f3331300
[task 2023-12-12T14:08:25.159Z] 14:08:25     INFO -      rsi = 0x0000000000000001    rdi = 0x0000000000000020
[task 2023-12-12T14:08:25.159Z] 14:08:25     INFO -      rbp = 0x00007ffeac839790    rsp = 0x00007ffeac839750
[task 2023-12-12T14:08:25.159Z] 14:08:25     INFO -       r8 = 0x0000000000000000     r9 = 0x0000000017e8820c
[task 2023-12-12T14:08:25.159Z] 14:08:25     INFO -      r10 = 0x00007f84de4c3640    r11 = 0x00000000ffffffff
[task 2023-12-12T14:08:25.159Z] 14:08:25     INFO -      r12 = 0x000002601bf263b7    r13 = 0x00007ffeac8397a8
[task 2023-12-12T14:08:25.159Z] 14:08:25     INFO -      r14 = 0x00007f84f33435e0    r15 = 0x00007f84f3331328
[task 2023-12-12T14:08:25.159Z] 14:08:25     INFO -      rip = 0x00007f84de56c50f
[task 2023-12-12T14:08:25.159Z] 14:08:25     INFO -     Found by: given as instruction pointer in context
[task 2023-12-12T14:08:25.159Z] 14:08:25     INFO -  1  libxul.so!mozilla::TaskController::ProcessPendingMTTask(bool) [TaskController.cpp:378226435d1f217637869bc238a2bff9ae584e04 : 485 + 0x7]
[task 2023-12-12T14:08:25.159Z] 14:08:25     INFO -      rbx = 0x00007f84f3331300    rbp = 0x00007ffeac8397e0
[task 2023-12-12T14:08:25.159Z] 14:08:25     INFO -      rsp = 0x00007ffeac8397a0    r12 = 0x000002601bf263b7
[task 2023-12-12T14:08:25.159Z] 14:08:25     INFO -      r13 = 0xaaaaaaaaaaaaaaaa    r14 = 0x0000000000000000
[task 2023-12-12T14:08:25.159Z] 14:08:25     INFO -      r15 = 0x00007f84f3331328    rip = 0x00007f84de56c986
[task 2023-12-12T14:08:25.159Z] 14:08:25     INFO -     Found by: call frame info
[task 2023-12-12T14:08:25.159Z] 14:08:25     INFO -  2  libxul.so!mozilla::TaskController::TaskController()::$_0::operator()() const [TaskController.cpp:378226435d1f217637869bc238a2bff9ae584e04 : 211]
[task 2023-12-12T14:08:25.159Z] 14:08:25     INFO -     Found by: inlining
[task 2023-12-12T14:08:25.159Z] 14:08:25     INFO -  3  libxul.so!mozilla::detail::RunnableFunction<mozilla::TaskController::TaskController()::$_0>::Run() [nsThreadUtils.h:378226435d1f217637869bc238a2bff9ae584e04 : 548 + 0x12]
[task 2023-12-12T14:08:25.160Z] 14:08:25     INFO -      rbx = 0x00007f84f33733c0    rbp = 0x00007ffeac8397f0
[task 2023-12-12T14:08:25.160Z] 14:08:25     INFO -      rsp = 0x00007ffeac8397f0    r12 = 0x000002601bf263b7
[task 2023-12-12T14:08:25.160Z] 14:08:25     INFO -      r13 = 0xaaaaaaaaaaaaaaaa    r14 = 0x0000000000000001
[task 2023-12-12T14:08:25.160Z] 14:08:25     INFO -      r15 = 0x00007ffeac839880    rip = 0x00007f84de57bd87
[task 2023-12-12T14:08:25.160Z] 14:08:25     INFO -     Found by: call frame info
[task 2023-12-12T14:08:25.160Z] 14:08:25     INFO -  4  libxul.so!nsThread::ProcessNextEvent(bool, bool*) [nsThread.cpp:378226435d1f217637869bc238a2bff9ae584e04 : 1199 + 0x5]
[task 2023-12-12T14:08:25.160Z] 14:08:25     INFO -      rbx = 0x00007f84f33733c0    rbp = 0x00007ffeac839920
[task 2023-12-12T14:08:25.161Z] 14:08:25     INFO -      rsp = 0x00007ffeac839800    r12 = 0x000002601bf263b7
[task 2023-12-12T14:08:25.161Z] 14:08:25     INFO -      r13 = 0xaaaaaaaaaaaaaaaa    r14 = 0x0000000000000001
[task 2023-12-12T14:08:25.161Z] 14:08:25     INFO -      r15 = 0x00007ffeac839880    rip = 0x00007f84de590393
[task 2023-12-12T14:08:25.162Z] 14:08:25     INFO -     Found by: call frame info
[task 2023-12-12T14:08:25.162Z] 14:08:25     INFO -  5  libxul.so!NS_ProcessPendingEvents(nsIThread*, unsigned int) [nsThreadUtils.cpp:378226435d1f217637869bc238a2bff9ae584e04 : 445 + 0x10]
[task 2023-12-12T14:08:25.162Z] 14:08:25     INFO -      rbx = 0x00000000ffffffff    rbp = 0x00007ffeac839970
[task 2023-12-12T14:08:25.162Z] 14:08:25     INFO -      rsp = 0x00007ffeac839930    r12 = 0x0000000000278816
[task 2023-12-12T14:08:25.162Z] 14:08:25     INFO -      r13 = 0x00007ffeac83993f    r14 = 0x00007f84f33733c0
[task 2023-12-12T14:08:25.162Z] 14:08:25     INFO -      r15 = 0x0000000000000000    rip = 0x00007f84de58cb2a
[task 2023-12-12T14:08:25.163Z] 14:08:25     INFO -     Found by: call frame info
[task 2023-12-12T14:08:25.163Z] 14:08:25     INFO -  6  libxul.so!mozilla::AppShutdown::AdvanceShutdownPhaseInternal(mozilla::ShutdownPhase, bool, char16_t const*, nsCOMPtr<nsISupports> const&) [AppShutdown.cpp:378226435d1f217637869bc238a2bff9ae584e04 : 437 + 0x9]
[task 2023-12-12T14:08:25.163Z] 14:08:25     INFO -      rbx = 0x0000000000000007    rbp = 0x00007ffeac8399d0
[task 2023-12-12T14:08:25.163Z] 14:08:25     INFO -      rsp = 0x00007ffeac839980    r12 = 0x00007f84db15322c
[task 2023-12-12T14:08:25.163Z] 14:08:25     INFO -      r13 = 0x0000000000000513    r14 = 0x0000000000000000
[task 2023-12-12T14:08:25.163Z] 14:08:25     INFO -      r15 = 0x00007ffeac839a00    rip = 0x00007f84de457363
[task 2023-12-12T14:08:25.163Z] 14:08:25     INFO -     Found by: call frame info
[task 2023-12-12T14:08:25.163Z] 14:08:25     INFO -  7  libxul.so!mozilla::ShutdownXPCOM(nsIServiceManager*) [XPCOMInit.cpp:378226435d1f217637869bc238a2bff9ae584e04 : 598 + 0xb]
[task 2023-12-12T14:08:25.164Z] 14:08:25     INFO -      rbx = 0x0000000000000000    rbp = 0x00007ffeac839a70
[task 2023-12-12T14:08:25.164Z] 14:08:25     INFO -      rsp = 0x00007ffeac8399e0    r12 = 0x00007ffeac839ab8
[task 2023-12-12T14:08:25.164Z] 14:08:25     INFO -      r13 = 0x0000000000000513    r14 = 0xaaaaaaaaaaaaaaaa
[task 2023-12-12T14:08:25.165Z] 14:08:25     INFO -      r15 = 0x00007f84f33bbf00    rip = 0x00007f84de5d36ec
[task 2023-12-12T14:08:25.165Z] 14:08:25     INFO -     Found by: call frame info
[task 2023-12-12T14:08:25.165Z] 14:08:25     INFO -  8  libxul.so!XRE_InitChildProcess(int, char**, XREChildData const*) [nsEmbedFunctions.cpp:378226435d1f217637869bc238a2bff9ae584e04 : 660 + 0x8]
[task 2023-12-12T14:08:25.165Z] 14:08:25     INFO -      rbx = 0x0000000000000001    rbp = 0x00007ffeac839d60
[task 2023-12-12T14:08:25.165Z] 14:08:25     INFO -      rsp = 0x00007ffeac839a80    r12 = 0x00007ffeac839ab8
[task 2023-12-12T14:08:25.165Z] 14:08:25     INFO -      r13 = 0x0000000000000513    r14 = 0x00007ffeac839ab8
[task 2023-12-12T14:08:25.165Z] 14:08:25     INFO -      r15 = 0x00007f84f33bbf00    rip = 0x00007f84e4719683
[task 2023-12-12T14:08:25.165Z] 14:08:25     INFO -     Found by: call frame info
[task 2023-12-12T14:08:25.165Z] 14:08:25     INFO -  9  firefox-bin!content_process_main(mozilla::Bootstrap*, int, char**) [plugin-container.cpp:378226435d1f217637869bc238a2bff9ae584e04 : 57]
[task 2023-12-12T14:08:25.166Z] 14:08:25     INFO -     Found by: inlining
[task 2023-12-12T14:08:25.166Z] 14:08:25     INFO - 10  firefox-bin!main [nsBrowserApp.cpp:378226435d1f217637869bc238a2bff9ae584e04 : 375 + 0x2a]
[task 2023-12-12T14:08:25.166Z] 14:08:25     INFO -      rbx = 0x0000000000000016    rbp = 0x00007ffeac83add0
[task 2023-12-12T14:08:25.166Z] 14:08:25     INFO -      rsp = 0x00007ffeac839d70    r12 = 0x00007ffeac83aeb8
[task 2023-12-12T14:08:25.166Z] 14:08:25     INFO -      r13 = 0xaaaaaaaaaaaaaaaa    r14 = 0x00007f84f33036e0
[task 2023-12-12T14:08:25.166Z] 14:08:25     INFO -      r15 = 0x00007ffeac83aeb8    rip = 0x000055876d43ffd9
[task 2023-12-12T14:08:25.166Z] 14:08:25     INFO -     Found by: call frame info
[task 2023-12-12T14:08:25.166Z] 14:08:25     INFO - 11  libc.so.6 + 0x21b96
[task 2023-12-12T14:08:25.166Z] 14:08:25     INFO -      rbx = 0x0000000000000000    rbp = 0x000055876d512d90
[task 2023-12-12T14:08:25.166Z] 14:08:25     INFO -      rsp = 0x00007ffeac83ade0    r12 = 0x000055876d43fa00
[task 2023-12-12T14:08:25.166Z] 14:08:25     INFO -      r13 = 0x00007ffeac83aeb0    r14 = 0x0000000000000000
[task 2023-12-12T14:08:25.166Z] 14:08:25     INFO -      r15 = 0x0000000000000000    rip = 0x00007f84f37e3b97
[task 2023-12-12T14:08:25.166Z] 14:08:25     INFO -     Found by: call frame info
[task 2023-12-12T14:08:25.166Z] 14:08:25     INFO - 12  ld-linux-x86-64.so.2 + 0x10782
[task 2023-12-12T14:08:25.167Z] 14:08:25     INFO -      rsp = 0x00007ffeac83ae60    rip = 0x00007f84f4925783
[task 2023-12-12T14:08:25.167Z] 14:08:25     INFO -     Found by: stack scanning
[task 2023-12-12T14:08:25.167Z] 14:08:25     INFO - 13  libmozsandbox.so!<.plt ELF section in libmozsandbox.so> + 0x15e7
[task 2023-12-12T14:08:25.167Z] 14:08:25     INFO -      rsp = 0x00007ffeac83ae68    rip = 0x00007f84f4b37418
[task 2023-12-12T14:08:25.167Z] 14:08:25     INFO -     Found by: stack scanning
[task 2023-12-12T14:08:25.167Z] 14:08:25     INFO - 14  libpthread.so.0 + 0x219baf
[task 2023-12-12T14:08:25.167Z] 14:08:25     INFO -      rsp = 0x00007ffeac83ae70    rip = 0x00007f84f490fbb0
[task 2023-12-12T14:08:25.167Z] 14:08:25     INFO -     Found by: stack scanning
[task 2023-12-12T14:08:25.167Z] 14:08:25     INFO - 15  firefox-bin!_start + 0x28
[task 2023-12-12T14:08:25.167Z] 14:08:25     INFO -      rsp = 0x00007ffeac83aea0    rip = 0x000055876d43fa29
[task 2023-12-12T14:08:25.167Z] 14:08:25     INFO -     Found by: stack scanning
[task 2023-12-12T14:08:25.167Z] 14:08:25     INFO -

This crash and also the ones from the "See also" section seem to occur after TEST-START | dom/base/test/test_youtube_flash_embed.html

Hi Nika! Can you please take a look at this? maybe you can spot something that is causing this crashes. Or maybe redirect this to someone?
Thank you!

Flags: needinfo?(nika)

The patch in bug 1847726 flipped a pref and updated a test to flip that pref back to keep the test working. It's not obvious why that would cause crashes

That test is the last thing that is run. Maybe something weird is going on with the "please flip the pref back" message used by the test harness? Though you'd think that the test harness stuff would deal with that correctly.

Perhaps pushPushEnv and then immediately creating an OOP iframe (as test_youtube_flash_embed.html does) is resulting in some weirdness?

I wonder if there are similar crashes happening after other tests that flip prefs

See Also: → 1870112
See Also: → 1870211
Assignee: nobody → gregp
Status: NEW → ASSIGNED
Pushed by gp3033@protonmail.com: https://hg.mozilla.org/integration/autoland/rev/33b0a0fecfd9 Revert changes to test_youtube_flash_embed.html, set pref in mochitest.toml instead of using pushPrevEnv r=mccr8
Pushed by gp3033@protonmail.com: https://hg.mozilla.org/integration/autoland/rev/319725b7dcfb Revert changes to test_youtube_flash_embed.html, set pref in mochitest.toml instead of using pushPrevEnv r=mccr8

https://hg.mozilla.org/mozilla-central/rev/319725b7dcfb

Status: ASSIGNED → RESOLVED
Closed: 11 months ago
status-firefox122: affected → fixed
Resolution: --- → FIXED
Target Milestone: --- → 122 Branch
See Also: → 1870499
See Also: → 1870509
See Also: → 1870510
Flags: needinfo?(gregp)
You need to log in before you can comment on or make changes to this bug.

Attachment

General

Creator:
Created:
Updated:
Size: