Closed Bug 1805780 Opened 2 years ago Closed 2 years ago

Intermittent Assertion failure: mFetchingModules.IsEmpty(), at /builds/worker/checkouts/gecko/js/loader/ModuleLoaderBase.cpp:989

Categories

(Core :: JavaScript Engine, defect, P5)

Product:
Core
Component:
JavaScript Engine
Type:
defect

Tracking

()

Status:
RESOLVED FIXED
Milestone:
110 Branch
Tracking Flags:
Tracking Status
firefox-esr102 --- unaffected
firefox109 --- unaffected
firefox110 --- fixed

People

(Reporter: intermittent-bug-filer, Unassigned)

References

Details

(Keywords: assertion, intermittent-failure, Whiteboard: [retriggered])

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

[task 2022-12-14T21:31:43.854Z] 21:31:43     INFO - TEST-START | /import-maps/acquiring/worker-request.html
[task 2022-12-14T21:31:43.861Z] 21:31:43     INFO - Closing window 9c0c95ef-7a2b-4c9a-b79d-da325552e22f
[task 2022-12-14T21:31:44.057Z] 21:31:44     INFO - PID 12910 | [Parent 12910, IPDL Background] WARNING: IPC Connection Error: [Parent][PBackgroundParent] RunMessage(msgname=PRemoteWorkerService::Msg___delete__) Channel closing: too late to send/recv, messages will be lost: file /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:1883
[task 2022-12-14T21:31:44.061Z] 21:31:44     INFO - PID 12910 | [Parent 12910, Compositor] WARNING: IPC Connection Error: [Parent][PCompositorManagerParent] RunMessage(msgname=PCompositorBridge::Msg___delete__) Channel closing: too late to send/recv, messages will be lost: file /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:1883
[task 2022-12-14T21:31:44.141Z] 21:31:44     INFO - PID 12910 | [Child 13072, Main Thread] WARNING: IPC message 'PContent::Msg_CleanupPendingLoadState' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:504
<...>
[task 2022-12-14T21:31:44.429Z] 21:31:44     INFO - PID 12910 | [Child 13072, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4660
[task 2022-12-14T21:31:44.564Z] 21:31:44     INFO - .
[task 2022-12-14T21:31:44.564Z] 21:31:44     INFO - TEST-OK | /import-maps/acquiring/worker-request.html | took 711ms
[task 2022-12-14T21:31:44.576Z] 21:31:44     INFO - Restarting browser for new test group
[task 2022-12-14T21:31:44.581Z] 21:31:44     INFO - PID 12910 | 1671053504580	Marionette	INFO	Stopped listening on port 53299
[task 2022-12-14T21:31:44.628Z] 21:31:44     INFO - PID 12910 | [Child 13003, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:44
[task 2022-12-14T21:31:44.629Z] 21:31:44     INFO - PID 12910 | [Child 13003, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:44
[task 2022-12-14T21:31:44.643Z] 21:31:44     INFO - PID 12910 | [Child 13003, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:44
[task 2022-12-14T21:31:44.649Z] 21:31:44     INFO - PID 12910 | [Child 13003, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:44
[task 2022-12-14T21:31:44.655Z] 21:31:44     INFO - PID 12910 | [Child 13003, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:44
[task 2022-12-14T21:31:44.656Z] 21:31:44     INFO - PID 12910 | [Child 13003, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:44
[task 2022-12-14T21:31:44.663Z] 21:31:44     INFO - PID 12910 | [Child 13003, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:44
[task 2022-12-14T21:31:44.841Z] 21:31:44     INFO - PID 12910 | Assertion failure: mFetchingModules.IsEmpty(), at /builds/worker/checkouts/gecko/js/loader/ModuleLoaderBase.cpp:989
[task 2022-12-14T21:31:44.852Z] 21:31:44     INFO - STDOUT: Initializing stack-fixing for the first stack frame, this may take a while...
[task 2022-12-14T21:31:50.262Z] 21:31:50     INFO - .............................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................
[task 2022-12-14T21:31:50.262Z] 21:31:50     INFO - TEST-OK | /html/the-xhtml-syntax/parsing-xhtml-documents/xhtml-mathml-dtd-entity-5.htm | took 17232ms
[task 2022-12-14T21:31:50.264Z] 21:31:50     INFO - TEST-START | /html/the-xhtml-syntax/parsing-xhtml-documents/xhtml-mathml-dtd-entity-6.htm
[task 2022-12-14T21:31:50.266Z] 21:31:50     INFO - Closing window 8fd75903-c1a1-4c12-ad09-7795d8f19d5b
[task 2022-12-14T21:31:50.476Z] 21:31:50     INFO - PID 12337 | [Parent 12337, IPDL Background] WARNING: IPC Connection Error: [Parent][PBackgroundParent] RunMessage(msgname=PRemoteWorkerService::Msg___delete__) Channel closing: too late to send/recv, messages will be lost: file /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:1883
[task 2022-12-14T21:31:50.811Z] 21:31:50     INFO - PID 12337 | [Child 12832, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3387
[task 2022-12-14T21:31:50.815Z] 21:31:50     INFO - PID 12337 | [Child 12832, Main Thread] WARNING: NS_ENSURE_TRUE(InitStaticMembers()) failed: file /builds/worker/workspace/obj-build/dist/include/mozilla/Preferences.h:129
[task 2022-12-14T21:31:50.824Z] 21:31:50     INFO - PID 12337 | [Child 12832, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4660
[task 2022-12-14T21:31:51.761Z] 21:31:51     INFO - PID 12337 | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpyuzx95e6/runtests_leaks_1165_tab_pid13205.log
[task 2022-12-14T21:31:51.761Z] 21:31:51     INFO - PID 12337 | [13205, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp:339
[task 2022-12-14T21:31:51.797Z] 21:31:51     INFO - PID 12337 | [Child 13205, Main Thread] WARNING: could not set real-time limit in CubebUtils::InitLibrary: file /builds/worker/checkouts/gecko/dom/media/CubebUtils.cpp:714
[task 2022-12-14T21:31:58.002Z] 21:31:58     INFO - PID 12910 | #01: JS::loader::ModuleLoaderBase::Shutdown() [js/loader/ModuleLoaderBase.cpp:989]
[task 2022-12-14T21:31:58.003Z] 21:31:58     INFO - PID 12910 | #02: mozilla::dom::WorkerGlobalScopeBase::NoteTerminating() [dom/workers/WorkerScope.cpp:266]
[task 2022-12-14T21:31:58.003Z] 21:31:58     INFO - PID 12910 | #03: mozilla::dom::WorkerPrivate::NotifyInternal(mozilla::dom::WorkerStatus) [dom/workers/WorkerPrivate.cpp:0]
[task 2022-12-14T21:31:58.004Z] 21:31:58     INFO - PID 12910 | #04: mozilla::dom::WorkerRunnable::Run() [dom/workers/WorkerRunnable.cpp:377]
[task 2022-12-14T21:31:58.004Z] 21:31:58     INFO - PID 12910 | #05: mozilla::dom::WorkerPrivate::ProcessAllControlRunnablesLocked() [dom/workers/WorkerPrivate.cpp:3820]
[task 2022-12-14T21:31:58.005Z] 21:31:58     INFO - PID 12910 | #06: mozilla::dom::WorkerPrivate::RunCurrentSyncLoop() [dom/workers/WorkerPrivate.cpp:4210]
[task 2022-12-14T21:31:58.005Z] 21:31:58     INFO - PID 12910 | #07: mozilla::dom::AutoSyncLoopHolder::Run() [dom/workers/WorkerPrivate.h:1511]
[task 2022-12-14T21:31:58.006Z] 21:31:58     INFO - PID 12910 | #08: mozilla::dom::workerinternals::(anonymous namespace)::LoadAllScripts(mozilla::dom::WorkerPrivate*, mozilla::UniquePtr<mozilla::dom::SerializedStackHolder, mozilla::DefaultDelete<mozilla::dom::SerializedStackHolder> >, nsTArray<nsTString<char16_t> > const&, bool, mozilla::dom::WorkerScriptType, mozilla::ErrorResult&, mozilla::Encoding const*) [dom/workers/ScriptLoader.cpp:247]
[task 2022-12-14T21:31:58.006Z] 21:31:58     INFO - PID 12910 | #09: mozilla::dom::workerinternals::LoadMainScript(mozilla::dom::WorkerPrivate*, mozilla::UniquePtr<mozilla::dom::SerializedStackHolder, mozilla::DefaultDelete<mozilla::dom::SerializedStackHolder> >, nsTSubstring<char16_t> const&, mozilla::dom::WorkerScriptType, mozilla::ErrorResult&, mozilla::Encoding const*) [dom/workers/ScriptLoader.cpp:1658]
[task 2022-12-14T21:31:58.007Z] 21:31:58     INFO - PID 12910 | #10: mozilla::dom::(anonymous namespace)::CompileScriptRunnable::WorkerRun(JSContext*, mozilla::dom::WorkerPrivate*) [dom/workers/WorkerPrivate.cpp:381]
[task 2022-12-14T21:31:58.008Z] 21:31:58     INFO - PID 12910 | #11: mozilla::dom::WorkerRunnable::Run() [dom/workers/WorkerRunnable.cpp:377]
[task 2022-12-14T21:31:58.009Z] 21:31:58     INFO - PID 12910 | #12: nsThread::ProcessNextEvent(bool, bool*) [xpcom/threads/nsThread.cpp:1199]
[task 2022-12-14T21:31:58.009Z] 21:31:58     INFO - PID 12910 | #13: NS_ProcessNextEvent(nsIThread*, bool) [xpcom/threads/nsThreadUtils.cpp:474]
[task 2022-12-14T21:31:58.010Z] 21:31:58     INFO - PID 12910 | #14: mozilla::dom::WorkerPrivate::DoRunLoop(JSContext*) [dom/workers/WorkerPrivate.cpp:3244]
[task 2022-12-14T21:31:58.010Z] 21:31:58     INFO - PID 12910 | #15: mozilla::dom::workerinternals::(anonymous namespace)::WorkerThreadPrimaryRunnable::Run() [dom/workers/RuntimeService.cpp:2046]
[task 2022-12-14T21:31:58.011Z] 21:31:58     INFO - PID 12910 | #16: nsThread::ProcessNextEvent(bool, bool*) [xpcom/threads/nsThread.cpp:1199]
[task 2022-12-14T21:31:58.011Z] 21:31:58     INFO - PID 12910 | #17: NS_ProcessNextEvent(nsIThread*, bool) [xpcom/threads/nsThreadUtils.cpp:474]
[task 2022-12-14T21:31:58.013Z] 21:31:58     INFO - PID 12910 | #18: mozilla::ipc::MessagePumpForNonMainThreads::Run(base::MessagePump::Delegate*) [ipc/glue/MessagePump.cpp:301]
[task 2022-12-14T21:31:58.013Z] 21:31:58     INFO - PID 12910 | #19: MessageLoop::RunInternal() [ipc/chromium/src/base/message_loop.cc:0]
[task 2022-12-14T21:31:58.013Z] 21:31:58     INFO - PID 12910 | #20: MessageLoop::Run() [ipc/chromium/src/base/message_loop.cc:357]
[task 2022-12-14T21:31:58.013Z] 21:31:58     INFO - PID 12910 | #21: nsThread::ThreadFunc(void*) [xpcom/threads/nsThread.cpp:385]
[task 2022-12-14T21:31:58.021Z] 21:31:58     INFO - PID 12910 | #22: _pt_root [nsprpub/pr/src/pthreads/ptthread.c:204]
[task 2022-12-14T21:31:58.079Z] 21:31:58     INFO - PID 12910 | #23: set_alt_signal_stack_and_start(PthreadCreateParams*) [toolkit/crashreporter/pthread_create_interposer/pthread_create_interposer.cpp:80]
[task 2022-12-14T21:31:58.079Z] 21:31:58     INFO - PID 12910 | #24: ??? [/lib/x86_64-linux-gnu/libpthread.so.0 + 0x76db]
[task 2022-12-14T21:31:58.084Z] 21:31:58     INFO - PID 12910 | #25: clone [/lib/x86_64-linux-gnu/libc.so.6 + 0x121a3f]
[task 2022-12-14T21:31:58.084Z] 21:31:58     INFO - PID 12910 | #26: ??? (???:???)
[task 2022-12-14T21:31:58.084Z] 21:31:58     INFO - PID 12910 | [Parent 12910, Compositor] WARNING: Possibly dropping task posted to updater thread: file /builds/worker/checkouts/gecko/gfx/layers/apz/src/APZUpdater.cpp:371

Hi Yulia! Can you please take a look at this? This seems to be caused by your recent changes from Bug 1247687.
Bug 1247687 was backed out today, but if it is related, it would be good to know when you land the bug again.
Thank you!

Flags: needinfo?(ystartsev)

Sure, thanks for the ping.

I will try to reland these changes now (i tried to reproduce the failure on the new patch stack and it wasn't appearing). I'll monitor this intermittent to see if there is a regression.

The changes have relanded, and this intermittent is no longer occuring.

Status: NEW → RESOLVED
Closed: 2 years ago
Flags: needinfo?(ystartsev)
Resolution: --- → FIXED
status-firefox109: --- → unaffected
status-firefox110: --- → fixed
status-firefox-esr102: --- → unaffected
Target Milestone: --- → 110 Branch
See Also: → 1822452
You need to log in before you can comment on or make changes to this bug.