Open Bug 1837186 Opened 1 year ago Updated 4 months ago

Intermittent Assertion failure: aCx == mWorkerPrivate->GetJSContext(), at /builds/worker/checkouts/gecko/dom/workers/RuntimeService.cpp:612 [dom/promise/tests/test_webassembly_compile.html]

Categories

(Core :: DOM: Workers, defect, P2)

defect

Tracking

()

ASSIGNED

People

(Reporter: intermittent-bug-filer, Assigned: asuth, NeedInfo)

Details

(Keywords: assertion, intermittent-failure)

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


[task 2023-06-07T12:20:19.354Z] 12:20:19     INFO - TEST-OK | dom/promise/tests/test_thenable_vs_promise_ordering.html | took 1077ms
[task 2023-06-07T12:20:19.363Z] 12:20:19     INFO - GECKO(3464) | [Child 4088, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/toolkit/xre/nsXREDirProvider.cpp:475
[task 2023-06-07T12:20:19.370Z] 12:20:19     INFO - GECKO(3464) | [Parent 2104, Main Thread] WARNING: Received `load` event on unbridged BrowserParent!: file /builds/worker/checkouts/gecko/dom/ipc/BrowserParent.cpp:3890
[task 2023-06-07T12:20:19.371Z] 12:20:19     INFO - GECKO(3464) | [Parent 2104, Main Thread] WARNING: Received `load` event on unbridged BrowserParent!: file /builds/worker/checkouts/gecko/dom/ipc/BrowserParent.cpp:3890
[task 2023-06-07T12:20:19.399Z] 12:20:19     INFO - GECKO(3464) | [Child 4088, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/toolkit/xre/nsXREDirProvider.cpp:475
[task 2023-06-07T12:20:19.399Z] 12:20:19     INFO - GECKO(3464) | [Child 4088, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/toolkit/xre/nsXREDirProvider.cpp:475
[task 2023-06-07T12:20:19.415Z] 12:20:19     INFO - GECKO(3464) | [Child 4088, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/toolkit/xre/nsXREDirProvider.cpp:475
[task 2023-06-07T12:20:19.429Z] 12:20:19     INFO - GECKO(3464) | [Child 5740, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3426
[task 2023-06-07T12:20:19.432Z] 12:20:19     INFO - GECKO(3464) | [Child 5740, Main Thread] WARNING: NS_ENSURE_TRUE(InitStaticMembers()) failed: file /builds/worker/workspace/obj-build/dist/include/mozilla/Preferences.h:129
[task 2023-06-07T12:20:19.439Z] 12:20:19     INFO - GECKO(3464) | [Child 5740, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4687
[task 2023-06-07T12:20:19.462Z] 12:20:19     INFO - TEST-START | dom/promise/tests/test_webassembly_compile.html
[task 2023-06-07T12:20:19.509Z] 12:20:19     INFO - GECKO(3464) | [Parent 2104, Main Thread] WARNING: WebProgress Ignored: no longer current window global: file /builds/worker/checkouts/gecko/dom/ipc/BrowserParent.cpp:2995
[task 2023-06-07T12:20:19.949Z] 12:20:19     INFO - GECKO(3464) | [Child 1112, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/toolkit/xre/nsXREDirProvider.cpp:475
[task 2023-06-07T12:20:19.996Z] 12:20:19     INFO - GECKO(3464) | Assertion failure: aCx == mWorkerPrivate->GetJSContext(), at /builds/worker/checkouts/gecko/dom/workers/RuntimeService.cpp:612
[task 2023-06-07T12:20:20.004Z] 12:20:20     INFO - GECKO(3464) | [Child 1112, TaskController #3] WARNING: A runnable was posted to a worker that is already shutting down!: file /builds/worker/checkouts/gecko/dom/workers/WorkerPrivate.cpp:1591
[task 2023-06-07T12:20:20.012Z] 12:20:20     INFO - GECKO(3464) | [Child 1112, TaskController #2] WARNING: A runnable was posted to a worker that is already shutting down!: file /builds/worker/checkouts/gecko/dom/workers/WorkerPrivate.cpp:1591
[task 2023-06-07T12:20:20.012Z] 12:20:20     INFO - GECKO(3464) | [Child 1112, TaskController #1] WARNING: A runnable was posted to a worker that is already shutting down!: file /builds/worker/checkouts/gecko/dom/workers/WorkerPrivate.cpp:1591
[task 2023-06-07T12:20:20.015Z] 12:20:20     INFO - GECKO(3464) | [Child 1112, TaskController #0] WARNING: A runnable was posted to a worker that is already shutting down!: file /builds/worker/checkouts/gecko/dom/workers/WorkerPrivate.cpp:1591
[task 2023-06-07T12:20:20.023Z] 12:20:20     INFO - GECKO(3464) | [Child 1112, TaskController #2] WARNING: A runnable was posted to a worker that is already shutting down!: file /builds/worker/checkouts/gecko/dom/workers/WorkerPrivate.cpp:1591
[task 2023-06-07T12:20:20.023Z] 12:20:20     INFO - GECKO(3464) | [Child 1112, TaskController #4] WARNING: A runnable was posted to a worker that is already shutting down!: file /builds/worker/checkouts/gecko/dom/workers/WorkerPrivate.cpp:1591
[task 2023-06-07T12:20:20.030Z] 12:20:20     INFO - GECKO(3464) | [Child 1112, TaskController #5] WARNING: A runnable was posted to a worker that is already shutting down!: file /builds/worker/checkouts/gecko/dom/workers/WorkerPrivate.cpp:1591
<...>
[task 2023-06-07T12:20:20.296Z] 12:20:20     INFO - GECKO(3464) | [Child 1112, TaskController #2] WARNING: A runnable was posted to a worker that is already shutting down!: file /builds/worker/checkouts/gecko/dom/workers/WorkerPrivate.cpp:1591
[task 2023-06-07T12:20:20.311Z] 12:20:20     INFO -  Initializing stack-fixing for the first stack frame, this may take a while...
[task 2023-06-07T12:20:41.856Z] 12:20:41     INFO - GECKO(3464) | #01: mozilla::dom::workerinternals::(anonymous namespace)::JSDispatchableRunnable::WorkerRun(JSContext*, mozilla::dom::WorkerPrivate*) [dom/workers/RuntimeService.cpp:612]
[task 2023-06-07T12:20:41.872Z] 12:20:41     INFO - GECKO(3464) | #02: mozilla::dom::WorkerRunnable::Run() [dom/workers/WorkerRunnable.cpp:372]
[task 2023-06-07T12:20:41.872Z] 12:20:41     INFO - GECKO(3464) | #03: nsThread::ProcessNextEvent(bool, bool*) [xpcom/threads/nsThread.cpp:1235]
[task 2023-06-07T12:20:41.873Z] 12:20:41     INFO - GECKO(3464) | #04: NS_ProcessPendingEvents(nsIThread*, unsigned int) [xpcom/threads/nsThreadUtils.cpp:444]
[task 2023-06-07T12:20:41.873Z] 12:20:41     INFO - GECKO(3464) | #05: mozilla::dom::workerinternals::(anonymous namespace)::WorkerThreadPrimaryRunnable::Run() [dom/workers/RuntimeService.cpp:2167]
[task 2023-06-07T12:20:41.874Z] 12:20:41     INFO - GECKO(3464) | #06: nsThread::ProcessNextEvent(bool, bool*) [xpcom/threads/nsThread.cpp:1235]
[task 2023-06-07T12:20:41.874Z] 12:20:41     INFO - GECKO(3464) | #07: NS_ProcessNextEvent(nsIThread*, bool) [xpcom/threads/nsThreadUtils.cpp:479]
[task 2023-06-07T12:20:41.874Z] 12:20:41     INFO - GECKO(3464) | #08: mozilla::ipc::MessagePumpForNonMainThreads::Run(base::MessagePump::Delegate*) [ipc/glue/MessagePump.cpp:300]
[task 2023-06-07T12:20:41.875Z] 12:20:41     INFO - GECKO(3464) | #09: MessageLoop::RunInternal() [ipc/chromium/src/base/message_loop.cc:370]
[task 2023-06-07T12:20:41.875Z] 12:20:41     INFO - GECKO(3464) | #10: MessageLoop::RunHandler() [ipc/chromium/src/base/message_loop.cc:364]
[task 2023-06-07T12:20:41.875Z] 12:20:41     INFO - GECKO(3464) | #11: MessageLoop::Run() [ipc/chromium/src/base/message_loop.cc:346]
[task 2023-06-07T12:20:41.876Z] 12:20:41     INFO - GECKO(3464) | #12: nsThread::ThreadFunc(void*) [xpcom/threads/nsThread.cpp:393]
[task 2023-06-07T12:20:42.059Z] 12:20:42     INFO - GECKO(3464) | #13: _PR_NativeRunThread(void*) [nsprpub/pr/src/threads/combined/pruthr.c:399]
[task 2023-06-07T12:20:42.073Z] 12:20:42     INFO - GECKO(3464) | #14: pr_root(void*) [nsprpub/pr/src/md/windows/w95thred.c:139]
[task 2023-06-07T12:20:42.076Z] 12:20:42     INFO -  fix-stacks: error: failed to read debug info file `ucrtbase.pdb` for `C:\Windows\System32\ucrtbase.dll`
[task 2023-06-07T12:20:42.076Z] 12:20:42     INFO -  fix-stacks: note: this is expected and harmless for all PDB files on opt automation runs
[task 2023-06-07T12:20:42.076Z] 12:20:42     INFO -  fix-stacks: The system cannot find the file specified. (os error 2)
[task 2023-06-07T12:20:42.077Z] 12:20:42     INFO - GECKO(3464) | #15: time32 [C:\Windows\System32\ucrtbase.dll + 0x459d3]
[task 2023-06-07T12:20:42.079Z] 12:20:42     INFO -  fix-stacks: error: failed to read debug info file `wkernel32.pdb` for `C:\Windows\System32\KERNEL32.DLL`
[task 2023-06-07T12:20:42.079Z] 12:20:42     INFO -  fix-stacks: note: this is expected and harmless for all PDB files on opt automation runs
[task 2023-06-07T12:20:42.080Z] 12:20:42     INFO -  fix-stacks: The system cannot find the file specified. (os error 2)
[task 2023-06-07T12:20:42.080Z] 12:20:42     INFO - GECKO(3464) | #16: BaseThreadInitThunk [C:\Windows\System32\KERNEL32.DLL + 0x17d49]
[task 2023-06-07T12:20:42.169Z] 12:20:42     INFO - GECKO(3464) | #17: DllBlocklist_Initialize [Z:\task_168613220897371\build\application\firefox\mozglue.dll + 0x80203]
[task 2023-06-07T12:20:42.177Z] 12:20:42     INFO -  fix-stacks: error: failed to read debug info file `wntdll.pdb` for `C:\Windows\SYSTEM32\ntdll.dll`
[task 2023-06-07T12:20:42.178Z] 12:20:42     INFO -  fix-stacks: note: this is expected and harmless for all PDB files on opt automation runs
[task 2023-06-07T12:20:42.178Z] 12:20:42     INFO -  fix-stacks: The system cannot find the file specified. (os error 2)
[task 2023-06-07T12:20:42.178Z] 12:20:42     INFO - GECKO(3464) | #18: RtlInitializeExceptionChain [C:\Windows\SYSTEM32\ntdll.dll + 0x6b74b]
[task 2023-06-07T12:20:42.179Z] 12:20:42     INFO - GECKO(3464) | #19: RtlClearBits [C:\Windows\SYSTEM32\ntdll.dll + 0x6b6cf]
[task 2023-06-07T12:20:42.180Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, IPC I/O Parent] WARNING: [1.1]: Ignoring message 'EVENT_MESSAGE' to unknown peer 60B96A41BECB19E7.C198956E182210C5: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:344
[task 2023-06-07T12:20:42.181Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, IPC I/O Parent] WARNING: [1.1]: Ignoring message 'EVENT_MESSAGE' to unknown peer 60B96A41BECB19E7.C198956E182210C5: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:344
[task 2023-06-07T12:20:42.181Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, IPC I/O Parent] WARNING: [1.1]: Ignoring message 'EVENT_MESSAGE' to unknown peer 60B96A41BECB19E7.C198956E182210C5: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:344
[task 2023-06-07T12:20:42.182Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, IPC I/O Parent] WARNING: [1.1]: Ignoring message 'EVENT_MESSAGE' to unknown peer 60B96A41BECB19E7.C198956E182210C5: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:344
[task 2023-06-07T12:20:42.183Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, IPC I/O Parent] WARNING: [1.1]: Ignoring message 'EVENT_MESSAGE' to unknown peer 60B96A41BECB19E7.C198956E182210C5: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:344
[task 2023-06-07T12:20:42.183Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, IPC I/O Parent] WARNING: [1.1]: Ignoring message 'EVENT_MESSAGE' to unknown peer 60B96A41BECB19E7.C198956E182210C5: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:344
[task 2023-06-07T12:20:42.184Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, IPC I/O Parent] WARNING: [1.1]: Ignoring message 'EVENT_MESSAGE' to unknown peer 60B96A41BECB19E7.C198956E182210C5: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:344
[task 2023-06-07T12:20:42.184Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, IPC I/O Parent] WARNING: [1.1]: Ignoring message 'EVENT_MESSAGE' to unknown peer 60B96A41BECB19E7.C198956E182210C5: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:344
[task 2023-06-07T12:20:42.185Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, Main Thread] WARNING: IPC Connection Error: [Parent][PContentParent] Send(msgname=PBrowser::Msg_StopIMEStateManagement) Channel error: cannot send/recv: file /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:1934
[task 2023-06-07T12:20:42.185Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, IPC I/O Parent] WARNING: [1.1]: Rejecting introduction request from '3AA81E3309EDD25.2824B44CD7B81E9E' for unknown peer '60B96A41BECB19E7.C198956E182210C5': file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:675
[task 2023-06-07T12:20:42.186Z] 12:20:42     INFO - GECKO(3464) | [GPU 7792, IPC I/O Child] WARNING: [3AA81E3309EDD25.2824B44CD7B81E9E]: Could not be introduced to peer 60B96A41BECB19E7.C198956E182210C5: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:605
[task 2023-06-07T12:20:42.187Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, ProcessHangMon] WARNING: IPC message 'PProcessHangMonitor::Msg_RequestContentJSInterrupt' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:507
[task 2023-06-07T12:20:42.188Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, Main Thread] WARNING: No build ID mismatch: file /builds/worker/checkouts/gecko/dom/base/nsFrameLoader.cpp:3802
[task 2023-06-07T12:20:42.188Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, Main Thread] WARNING: IPC Connection Error: [Parent][PContentParent] Send(msgname=PContent::Msg_CommitBrowsingContextTransaction) Channel error: cannot send/recv: file /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:1934
[task 2023-06-07T12:20:42.189Z] 12:20:42    ERROR - GECKO(3464) | A content process crashed and MOZ_CRASHREPORTER_SHUTDOWN is set, shutting down
[task 2023-06-07T12:20:42.189Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, Main Thread] WARNING: IPC message 'PSessionStore::Msg_FlushTabState' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:507
[task 2023-06-07T12:20:42.190Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, Main Thread] WARNING: IPC message 'PContent::Msg_CommitBrowsingContextTransaction' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:507
[task 2023-06-07T12:20:42.191Z] 12:20:42     INFO - GECKO(3464) | [Child 9648, Main Thread] WARNING: JSWindowActorChild::SendRawMessage (Conduits, ConduitClosed) not sent: !CanSend() || !mManager || !mManager->CanSend(): file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:61
[task 2023-06-07T12:20:42.191Z] 12:20:42     INFO - GECKO(3464) | [Child 9648, Main Thread] WARNING: JSWindowActorChild::SendRawMessage (Conduits, ConduitClosed) not sent: !CanSend() || !mManager || !mManager->CanSend(): file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:61
[task 2023-06-07T12:20:42.192Z] 12:20:42     INFO - GECKO(3464) | [Child 9648, Main Thread] WARNING: JSWindowActorChild::SendRawMessage (Conduits, ConduitClosed) not sent: !CanSend() || !mManager || !mManager->CanSend(): file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:61
[task 2023-06-07T12:20:42.192Z] 12:20:42     INFO - GECKO(3464) | [Child 9648, Main Thread] WARNING: JSWindowActorChild::SendRawMessage (Conduits, ConduitClosed) not sent: !CanSend() || !mManager || !mManager->CanSend(): file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:61
[task 2023-06-07T12:20:42.193Z] 12:20:42     INFO - GECKO(3464) | [Child 9648, Main Thread] WARNING: JSWindowActorChild::SendRawMessage (Conduits, ConduitClosed) not sent: !CanSend() || !mManager || !mManager->CanSend(): file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:61
[task 2023-06-07T12:20:42.193Z] 12:20:42     INFO - GECKO(3464) | [Child 9648, Main Thread] WARNING: JSWindowActorChild::SendRawMessage (Conduits, ConduitClosed) not sent: !CanSend() || !mManager || !mManager->CanSend(): file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:61
[task 2023-06-07T12:20:42.194Z] 12:20:42     INFO - GECKO(3464) | [Child 9648, Main Thread] WARNING: JSWindowActorChild::SendRawMessage (Conduits, ConduitClosed) not sent: !CanSend() || !mManager || !mManager->CanSend(): file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:61
[task 2023-06-07T12:20:42.195Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, Main Thread] WARNING: IPC message 'PBrowser::Msg_WillChangeProcess' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:507
[task 2023-06-07T12:20:42.195Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, Main Thread] WARNING: IPC message 'PContent::Msg_HistoryCommitIndexAndLength' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:507
[task 2023-06-07T12:20:42.196Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, Main Thread] WARNING: IPC message 'PBrowser::Msg_Destroy' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:507
[task 2023-06-07T12:20:42.196Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, Main Thread] WARNING: IPC message 'PContent::Msg_CommitBrowsingContextTransaction' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:507
[task 2023-06-07T12:20:42.197Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, Main Thread] WARNING: IPC message 'PContent::Msg_CommitBrowsingContextTransaction' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:507
[task 2023-06-07T12:20:42.197Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, Main Thread] WARNING: IPC message 'PContent::Msg_CommitBrowsingContextTransaction' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:507
[task 2023-06-07T12:20:42.198Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, Main Thread] WARNING: IPC message 'PContent::Msg_CommitBrowsingContextTransaction' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:507
[task 2023-06-07T12:20:42.198Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, Main Thread] WARNING: IPC message 'PContent::Msg_CreateWindowContext' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:507
[task 2023-06-07T12:20:42.199Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, Main Thread] WARNING: IPC message 'PContent::Msg_CommitBrowsingContextTransaction' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:507
[task 2023-06-07T12:20:42.199Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, Main Thread] WARNING: IPC message 'PContent::Msg_CommitWindowContextTransaction' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:507
[task 2023-06-07T12:20:42.200Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, Main Thread] WARNING: IPC message 'PContent::Msg_CommitBrowsingContextTransaction' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:507
[task 2023-06-07T12:20:42.201Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, Main Thread] WARNING: IPC message 'PContent::Msg_CommitBrowsingContextTransaction' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:507
[task 2023-06-07T12:20:42.202Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/dom/base/ThirdPartyUtil.cpp:421
[task 2023-06-07T12:20:42.202Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, Main Thread] WARNING: IPC message 'PContent::Msg_CommitBrowsingContextTransaction' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:507
[task 2023-06-07T12:20:42.203Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, Main Thread] WARNING: IPC message 'PContent::Msg_UnsetActiveBrowsingContext' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:507
[task 2023-06-07T12:20:42.203Z] 12:20:42     INFO - GECKO(3464) | 1686140421369	Marionette	TRACE	Received observer notification quit-application
[task 2023-06-07T12:20:42.203Z] 12:20:42     INFO - GECKO(3464) | 1686140421369	Marionette	INFO	Stopped listening on port 2828
[task 2023-06-07T12:20:42.204Z] 12:20:42     INFO - GECKO(3464) | 1686140421371	Marionette	DEBUG	Marionette stopped listening
[task 2023-06-07T12:20:42.204Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, Main Thread] WARNING: '!mCancelable', file /builds/worker/checkouts/gecko/image/imgRequestProxy.cpp:476
[task 2023-06-07T12:20:42.205Z] 12:20:42     INFO - GECKO(3464) | [GPU 7792, Compositor] WARNING: Possibly dropping task posted to updater thread: file /builds/worker/checkouts/gecko/gfx/layers/apz/src/APZUpdater.cpp:371
[task 2023-06-07T12:20:42.205Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, Socket Thread] WARNING: cannot post event if not initialized: file /builds/worker/checkouts/gecko/netwerk/protocol/http/nsHttpConnectionMgr.cpp:232
[task 2023-06-07T12:20:42.206Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, Socket Thread] WARNING: cannot post event if not initialized: file /builds/worker/checkouts/gecko/netwerk/protocol/http/nsHttpConnectionMgr.cpp:232
[task 2023-06-07T12:20:42.206Z] 12:20:42     INFO - GECKO(3464) | [Child 6072, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3426
[task 2023-06-07T12:20:42.207Z] 12:20:42     INFO - GECKO(3464) | [Child 6072, Main Thread] WARNING: NS_ENSURE_TRUE(InitStaticMembers()) failed: file /builds/worker/workspace/obj-build/dist/include/mozilla/Preferences.h:129
[task 2023-06-07T12:20:42.207Z] 12:20:42     INFO - GECKO(3464) | [Child 6072, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4687
[task 2023-06-07T12:20:42.208Z] 12:20:42     INFO - GECKO(3464) | [Child 9648, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3426
[task 2023-06-07T12:20:42.208Z] 12:20:42     INFO - GECKO(3464) | [Child 9648, Main Thread] WARNING: NS_ENSURE_TRUE(InitStaticMembers()) failed: file /builds/worker/workspace/obj-build/dist/include/mozilla/Preferences.h:129
[task 2023-06-07T12:20:42.209Z] 12:20:42     INFO - GECKO(3464) | [Child 9648, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4687
[task 2023-06-07T12:20:42.209Z] 12:20:42     INFO - GECKO(3464) | [Child 3952, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3426
[task 2023-06-07T12:20:42.210Z] 12:20:42     INFO - GECKO(3464) | [Child 3952, Main Thread] WARNING: NS_ENSURE_TRUE(InitStaticMembers()) failed: file /builds/worker/workspace/obj-build/dist/include/mozilla/Preferences.h:129
[task 2023-06-07T12:20:42.210Z] 12:20:42     INFO - GECKO(3464) | [Child 3952, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4687
[task 2023-06-07T12:20:42.211Z] 12:20:42     INFO - GECKO(3464) | [Child 1020, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3426
[task 2023-06-07T12:20:42.212Z] 12:20:42     INFO - GECKO(3464) | [Child 4088, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3426
[task 2023-06-07T12:20:42.212Z] 12:20:42     INFO - GECKO(3464) | [Child 1020, Main Thread] WARNING: NS_ENSURE_TRUE(InitStaticMembers()) failed: file /builds/worker/workspace/obj-build/dist/include/mozilla/Preferences.h:129
[task 2023-06-07T12:20:42.213Z] 12:20:42     INFO - GECKO(3464) | [Child 4088, Main Thread] WARNING: NS_ENSURE_TRUE(InitStaticMembers()) failed: file /builds/worker/workspace/obj-build/dist/include/mozilla/Preferences.h:129
[task 2023-06-07T12:20:42.213Z] 12:20:42     INFO - GECKO(3464) | [Child 1020, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4687
[task 2023-06-07T12:20:42.214Z] 12:20:42     INFO - GECKO(3464) | [Child 4088, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4687
[task 2023-06-07T12:20:42.214Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, IPDL Background] WARNING: quota manager shutdown step: '0.000000s: startCrashBrowserTimer', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3383
[task 2023-06-07T12:20:42.215Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, IPDL Background] WARNING: quota manager shutdown step: '0.000000s: initiateShutdownWorkThreads', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3383
[task 2023-06-07T12:20:42.215Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, IPDL Background] WARNING: idb: '0.000000s: starting', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3383
[task 2023-06-07T12:20:42.216Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, IPDL Background] WARNING: cache: '0.000000s: starting', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3383
[task 2023-06-07T12:20:42.216Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, IPDL Background] WARNING: sdb: '0.000000s: starting', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3383
[task 2023-06-07T12:20:42.217Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, IPDL Background] WARNING: fs: '0.000000s: starting', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3383
[task 2023-06-07T12:20:42.217Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, IPDL Background] WARNING: ls: '0.000000s: starting', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3383
[task 2023-06-07T12:20:42.218Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, IPDL Background] WARNING: quota manager shutdown step: '0.000000s: startKillActorsTimer', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3383
[task 2023-06-07T12:20:42.218Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, IPDL Background] WARNING: idb: '0.000000s: Live database entry removed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3383
[task 2023-06-07T12:20:42.219Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, IPDL Background] WARNING: idb: '0.000000s: gLiveDatabaseHashtable entry removed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3383
[task 2023-06-07T12:20:42.219Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, QuotaManager IO] WARNING: quota manager shutdown step: '0.000000s: ClearRequestBase: Starting deleting files', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3383
[task 2023-06-07T12:20:42.220Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, QuotaManager IO] WARNING: quota manager shutdown step: '0.000000s: ClearRequestBase: Starting repeated directory removal #0', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3383
[task 2023-06-07T12:20:42.221Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, QuotaManager IO] WARNING: quota manager shutdown step: '0.000000s: ClearRequestBase: Completed repeated directory removal #0', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3383
[task 2023-06-07T12:20:42.221Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, QuotaManager IO] WARNING: quota manager shutdown step: '0.000000s: ClearRequestBase: Completed deleting files', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3383
[task 2023-06-07T12:20:42.222Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, IPDL Background] WARNING: idb: '0.015000s: Live database entry removed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3383
[task 2023-06-07T12:20:42.222Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, IPDL Background] WARNING: idb: '0.015000s: Live database entry removed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3383
[task 2023-06-07T12:20:42.223Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, IPDL Background] WARNING: idb: '0.015000s: gLiveDatabaseHashtable entry removed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3383
[task 2023-06-07T12:20:42.223Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, IPDL Background] WARNING: quota manager shutdown step: '0.047000s: stopKillActorsTimer', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3383
[task 2023-06-07T12:20:42.223Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, IPDL Background] WARNING: quota manager shutdown step: '0.047000s: shutdownAndJoinWorkThreads', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3383
[task 2023-06-07T12:20:42.224Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, IPDL Background] WARNING: idb: '0.047000s: completed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3383
[task 2023-06-07T12:20:42.225Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, IPDL Background] WARNING: cache: '0.047000s: completed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3383
[task 2023-06-07T12:20:42.225Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, IPDL Background] WARNING: sdb: '0.047000s: completed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3383
[task 2023-06-07T12:20:42.225Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, IPDL Background] WARNING: fs: '0.047000s: completed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3383
[task 2023-06-07T12:20:42.226Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, IPDL Background] WARNING: ls: '0.047000s: completed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3383
[task 2023-06-07T12:20:42.226Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, IPDL Background] WARNING: quota manager shutdown step: '0.047000s: shutdownAndJoinIOThread', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3383
[task 2023-06-07T12:20:42.227Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, IPDL Background] WARNING: quota manager shutdown step: '0.047000s: invalidatePendingDirectoryLocks', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3383
[task 2023-06-07T12:20:42.227Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, IPDL Background] WARNING: quota manager shutdown step: '0.047000s: stopCrashBrowserTimer', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:3383
[task 2023-06-07T12:20:42.228Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/toolkit/xre/nsXREDirProvider.cpp:475
[task 2023-06-07T12:20:42.228Z] 12:20:42     INFO - GECKO(3464) | [Utility 4800, Main Thread] WARNING: IPC message 'PUtilityProcess::Msg_FOGData' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:507
[task 2023-06-07T12:20:42.229Z] 12:20:42     INFO - GECKO(3464) | [GPU 7792, Main Thread] WARNING: IPC message 'PGPU::Msg_FOGData' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:507
[task 2023-06-07T12:20:42.230Z] 12:20:42     INFO - GECKO(3464) | [Utility 4800, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4687
[task 2023-06-07T12:20:42.230Z] 12:20:42     INFO - GECKO(3464) | Destroying context 06A74000 surface 04E81CA0 on display 06A3B000
[task 2023-06-07T12:20:42.231Z] 12:20:42     INFO - GECKO(3464) | [GPU 7792, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4687
[task 2023-06-07T12:20:42.231Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, Main Thread] WARNING: '!top', file /builds/worker/checkouts/gecko/dom/xul/MenuBarListener.cpp:99
[task 2023-06-07T12:20:42.232Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3426
[task 2023-06-07T12:20:42.232Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, Main Thread] WARNING: NS_ENSURE_TRUE(InitStaticMembers()) failed: file /builds/worker/workspace/obj-build/dist/include/mozilla/Preferences.h:129
[task 2023-06-07T12:20:42.233Z] 12:20:42     INFO - GECKO(3464) | [Parent 2104, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4687
[task 2023-06-07T12:20:42.233Z] 12:20:42     INFO - TEST-INFO | Main app process: exit f5
[task 2023-06-07T12:20:42.233Z] 12:20:42     INFO - Buffered messages logged at 12:20:19
[task 2023-06-07T12:20:42.234Z] 12:20:42     INFO - TEST-PASS | dom/promise/tests/test_webassembly_compile.html | WebAssembly object should exist 

Tier 1 failure here

Summary: Intermittent [tier 2] Assertion failure: aCx == mWorkerPrivate->GetJSContext(), at /builds/worker/checkouts/gecko/dom/workers/RuntimeService.cpp:612 → Intermittent Assertion failure: aCx == mWorkerPrivate->GetJSContext(), at /builds/worker/checkouts/gecko/dom/workers/RuntimeService.cpp:612

Hm, yeah, the tier 1 failure log (and also the tier 2 log which seems identical) definitely seems to suggest there are some lifecycle problems relating to the worker runtime embedding and that the test at https://searchfox.org/mozilla-central/source/dom/promise/tests/test_webassembly_compile.html is great at showing this and in particular terminateCompileInWorker is an amazing stress test to create this situation.

Specifically, the log shows:

It seems like:

I'm setting a needinfo on myself to revisit this after letting my brain sleep on this, but others should feel free to chime in.

Severity: S4 → S3
Flags: needinfo?(bugmail)
Priority: P5 → P2
Summary: Intermittent Assertion failure: aCx == mWorkerPrivate->GetJSContext(), at /builds/worker/checkouts/gecko/dom/workers/RuntimeService.cpp:612 → Intermittent Assertion failure: aCx == mWorkerPrivate->GetJSContext(), at /builds/worker/checkouts/gecko/dom/workers/RuntimeService.cpp:612 [dom/promise/tests/test_webassembly_compile.html]
Assignee: nobody → bugmail
Status: NEW → ASSIGNED
You need to log in before you can comment on or make changes to this bug.