Closed Bug 1731906 Opened 4 years ago Closed 4 years ago

Intermittent Assertion failure: int32_t(mRefCnt) >= 0 (illegal refcnt), at /builds/worker/workspace/obj-build/dist/include/mozilla/layers/NativeLayer.h:128

Categories

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

Product:
Core
Component:
Audio/Video
Type:
defect

Tracking

()

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: assertion, intermittent-failure)

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

[task 2021-09-21T22:44:39.754Z] 22:44:39     INFO - TEST-START | dom/media/mediacontrol/tests/browser/browser_media_control_captured_audio.js
[task 2021-09-21T22:44:39.759Z] 22:44:39     INFO - GECKO(1352) | [Child 1406, Main Thread] WARNING: nsAppShell::Exit() called redundantly: file /builds/worker/checkouts/gecko/widget/cocoa/nsAppShell.mm:798
[task 2021-09-21T22:44:39.761Z] 22:44:39     INFO - GECKO(1352) | ###!!! [Parent][MessageChannel] Error: (msgtype=0x930001,name=PTexture::Msg___delete__) Channel closing: too late to send/recv, messages will be lost
[task 2021-09-21T22:44:39.761Z] 22:44:39     INFO - GECKO(1352) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-09-21T22:44:39.762Z] 22:44:39     INFO - GECKO(1352) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-09-21T22:44:39.764Z] 22:44:39     INFO - GECKO(1352) | [Child 1406, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:527
[task 2021-09-21T22:44:39.769Z] 22:44:39     INFO - GECKO(1352) | [Child 1407: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 104dcf800 == 1 [pid = 1407] [id = 0]
[task 2021-09-21T22:44:39.770Z] 22:44:39     INFO - GECKO(1352) | [Child 1407: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 1 (104ac3e40) [pid = 1407] [serial = 1] [outer = 0]
[task 2021-09-21T22:44:39.771Z] 22:44:39     INFO - GECKO(1352) | [Child 1407: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 2 (11ad8ec00) [pid = 1407] [serial = 2] [outer = 104ac3e40]
[task 2021-09-21T22:44:39.788Z] 22:44:39     INFO - GECKO(1352) | [Child 1406, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:527
[task 2021-09-21T22:44:39.788Z] 22:44:39     INFO - GECKO(1352) | [Child 1406, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:527
[task 2021-09-21T22:44:39.805Z] 22:44:39     INFO - GECKO(1352) | [Child 1406, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:527
[task 2021-09-21T22:44:39.809Z] 22:44:39     INFO - GECKO(1352) | [Child 1407, Main Thread] WARNING: NS_ENSURE_TRUE(info) failed: file /builds/worker/checkouts/gecko/extensions/permissions/PermissionDelegateHandler.cpp:348
[task 2021-09-21T22:44:39.810Z] 22:44:39     INFO - GECKO(1352) | [Child 1407: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 3 (11ad96400) [pid = 1407] [serial = 3] [outer = 104ac3e40]
[task 2021-09-21T22:44:39.816Z] 22:44:39     INFO - GECKO(1352) | [Child 1406: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 11cfdb800 == 1 [pid = 1406] [id = 0] [url = https://example.com/browser/dom/media/mediacontrol/tests/browser/file_non_autoplay.html]
[task 2021-09-21T22:44:39.816Z] 22:44:39     INFO - GECKO(1352) | [Child 1406: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 125f3b400 == 0 [pid = 1406] [id = 1] [url = https://example.com/browser/dom/media/mediacontrol/tests/browser/file_iframe_media.html]
[task 2021-09-21T22:44:39.833Z] 22:44:39     INFO - GECKO(1352) | [Child 1406, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:527
[task 2021-09-21T22:44:39.840Z] 22:44:39     INFO - GECKO(1352) | [Child 1406, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:527
[task 2021-09-21T22:44:39.844Z] 22:44:39     INFO - GECKO(1352) | [Child 1406: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 5 (11ccace40) [pid = 1406] [serial = 1] [outer = 0] [url = https://example.com/browser/dom/media/mediacontrol/tests/browser/file_non_autoplay.html]
[task 2021-09-21T22:44:39.844Z] 22:44:39     INFO - GECKO(1352) | [Child 1406: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 4 (125fe6740) [pid = 1406] [serial = 4] [outer = 0] [url = https://example.com/browser/dom/media/mediacontrol/tests/browser/file_iframe_media.html]
[task 2021-09-21T22:44:39.845Z] 22:44:39     INFO - GECKO(1352) | [Child 1406: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 3 (125f8bc00) [pid = 1406] [serial = 2] [outer = 0] [url = about:blank]
[task 2021-09-21T22:44:39.845Z] 22:44:39     INFO - GECKO(1352) | [Child 1406: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 2 (125f93800) [pid = 1406] [serial = 3] [outer = 0] [url = https://example.com/browser/dom/media/mediacontrol/tests/browser/file_non_autoplay.html]
[task 2021-09-21T22:44:39.846Z] 22:44:39     INFO - GECKO(1352) | [Child 1406: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (125f3cc00) [pid = 1406] [serial = 5] [outer = 0] [url = about:blank]
[task 2021-09-21T22:44:39.847Z] 22:44:39     INFO - GECKO(1352) | [Child 1406: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (126f33000) [pid = 1406] [serial = 6] [outer = 0] [url = https://example.com/browser/dom/media/mediacontrol/tests/browser/file_iframe_media.html]
[task 2021-09-21T22:44:39.847Z] 22:44:39     INFO - GECKO(1352) | [Child 1406, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3357
[task 2021-09-21T22:44:39.848Z] 22:44:39     INFO - GECKO(1352) | [Child 1406, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:527
[task 2021-09-21T22:44:39.850Z] 22:44:39     INFO - GECKO(1352) | [Child 1406, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:527
[task 2021-09-21T22:44:39.851Z] 22:44:39     INFO - GECKO(1352) | [Child 1406, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:527
[task 2021-09-21T22:44:39.852Z] 22:44:39     INFO - GECKO(1352) | [Child 1406, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:527
[task 2021-09-21T22:44:39.855Z] 22:44:39     INFO - GECKO(1352) | [Child 1406, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4438
[task 2021-09-21T22:44:39.857Z] 22:44:39     INFO - GECKO(1352) | [Child 1407: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 11ad5b800 == 2 [pid = 1407] [id = 1]
[task 2021-09-21T22:44:39.858Z] 22:44:39     INFO - GECKO(1352) | [Child 1407: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 4 (104d07580) [pid = 1407] [serial = 4] [outer = 0]
[task 2021-09-21T22:44:39.858Z] 22:44:39     INFO - GECKO(1352) | [Child 1407: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 5 (11ad5d000) [pid = 1407] [serial = 5] [outer = 104d07580]
[task 2021-09-21T22:44:39.891Z] 22:44:39     INFO - GECKO(1352) | Assertion failure: int32_t(mRefCnt) >= 0 (illegal refcnt), at /builds/worker/workspace/obj-build/dist/include/mozilla/layers/NativeLayer.h:128
[task 2021-09-21T22:44:39.894Z] 22:44:39     INFO -  Initializing stack-fixing for the first stack frame, this may take a while...
[task 2021-09-21T22:44:47.959Z] 22:44:47     INFO - GECKO(1352) | #01: mozilla::layers::NativeLayerRootCA::SetWindowIsFullscreen(bool) [gfx/layers/NativeLayerCA.mm:479]
[task 2021-09-21T22:44:47.960Z] 22:44:47     INFO - GECKO(1352) | #02: nsCocoaWindow::DoMakeFullScreen(bool, bool) [widget/cocoa/nsCocoaWindow.mm:1675]
[task 2021-09-21T22:44:47.960Z] 22:44:47     INFO - GECKO(1352) | #03: nsGlobalWindowOuter::SetWidgetFullscreen(FullscreenReason, bool, nsIWidget*, nsIScreen*) [dom/base/nsGlobalWindowOuter.cpp:4654]
[task 2021-09-21T22:44:47.961Z] 22:44:47     INFO - GECKO(1352) | #04: FullscreenTransitionTask::Run() [dom/base/nsGlobalWindowOuter.cpp:4406]
[task 2021-09-21T22:44:47.961Z] 22:44:47     INFO - GECKO(1352) | #05: mozilla::RunnableTask::Run() [xpcom/threads/TaskController.cpp:468]
[task 2021-09-21T22:44:47.961Z] 22:44:47     INFO - GECKO(1352) | #06: mozilla::TaskController::DoExecuteNextTaskOnlyMainThreadInternal(mozilla::detail::BaseAutoLock<mozilla::Mutex&> const&) [xpcom/threads/TaskController.cpp:770]
[task 2021-09-21T22:44:47.962Z] 22:44:47     INFO - GECKO(1352) | #07: mozilla::TaskController::ExecuteNextTaskOnlyMainThreadInternal(mozilla::detail::BaseAutoLock<mozilla::Mutex&> const&) [xpcom/threads/TaskController.cpp:606]
[task 2021-09-21T22:44:47.962Z] 22:44:47     INFO - GECKO(1352) | #08: mozilla::TaskController::ProcessPendingMTTask(bool) [xpcom/threads/TaskController.cpp:390]
[task 2021-09-21T22:44:47.962Z] 22:44:47     INFO - GECKO(1352) | #09: mozilla::detail::RunnableFunction<mozilla::TaskController::InitializeInternal()::$_0>::Run() [xpcom/threads/nsThreadUtils.h:532]
[task 2021-09-21T22:44:47.963Z] 22:44:47     INFO - GECKO(1352) | #10: nsThread::ProcessNextEvent(bool, bool*) [xpcom/threads/nsThread.cpp:1152]
[task 2021-09-21T22:44:47.963Z] 22:44:47     INFO - GECKO(1352) | #11: NS_ProcessPendingEvents(nsIThread*, unsigned int) [xpcom/threads/nsThreadUtils.cpp:431]
[task 2021-09-21T22:44:47.963Z] 22:44:47     INFO - GECKO(1352) | #12: nsBaseAppShell::NativeEventCallback() [widget/nsBaseAppShell.cpp:88]
[task 2021-09-21T22:44:47.963Z] 22:44:47     INFO - GECKO(1352) | #13: nsAppShell::ProcessGeckoEvents(void*) [widget/cocoa/nsAppShell.mm:502]
[task 2021-09-21T22:44:47.999Z] 22:44:47     INFO - GECKO(1352) | #14: __CFRUNLOOP_IS_CALLING_OUT_TO_A_SOURCE0_PERFORM_FUNCTION__ [/System/Library/Frameworks/CoreFoundation.framework/Versions/A/CoreFoundation + 0x83d52]
[task 2021-09-21T22:44:47.999Z] 22:44:47     INFO - GECKO(1352) | #15: __CFRunLoopDoSource0 [/System/Library/Frameworks/CoreFoundation.framework/Versions/A/CoreFoundation + 0x83cf1]
[task 2021-09-21T22:44:48.000Z] 22:44:48     INFO - GECKO(1352) | #16: __CFRunLoopDoSources0 [/System/Library/Frameworks/CoreFoundation.framework/Versions/A/CoreFoundation + 0x83b0b]
[task 2021-09-21T22:44:48.000Z] 22:44:48     INFO - GECKO(1352) | #17: __CFRunLoopRun [/System/Library/Frameworks/CoreFoundation.framework/Versions/A/CoreFoundation + 0x8283a]
[task 2021-09-21T22:44:48.000Z] 22:44:48     INFO - GECKO(1352) | #18: CFRunLoopRunSpecific [/System/Library/Frameworks/CoreFoundation.framework/Versions/A/CoreFoundation + 0x81e3e]
[task 2021-09-21T22:44:48.015Z] 22:44:48     INFO - GECKO(1352) | #19: RunCurrentEventLoopInMode [/System/Library/Frameworks/Carbon.framework/Versions/A/Frameworks/HIToolbox.framework/Versions/A/HIToolbox + 0x2fabd]
[task 2021-09-21T22:44:48.016Z] 22:44:48     INFO - GECKO(1352) | #20: ReceiveNextEventCommon [/System/Library/Frameworks/Carbon.framework/Versions/A/Frameworks/HIToolbox.framework/Versions/A/HIToolbox + 0x2f7d5]
[task 2021-09-21T22:44:48.016Z] 22:44:48     INFO - GECKO(1352) | #21: _BlockUntilNextEventMatchingListInModeWithFilter [/System/Library/Frameworks/Carbon.framework/Versions/A/Frameworks/HIToolbox.framework/Versions/A/HIToolbox + 0x2f579]
[task 2021-09-21T22:44:48.094Z] 22:44:48     INFO - GECKO(1352) | #22: _DPSNextEvent [/System/Library/Frameworks/AppKit.framework/Versions/C/AppKit + 0x41039]
[task 2021-09-21T22:44:48.095Z] 22:44:48     INFO - GECKO(1352) | #23: -[NSApplication(NSEvent) _nextEventMatchingEventMask:untilDate:inMode:dequeue:] [/System/Library/Frameworks/AppKit.framework/Versions/C/AppKit + 0x3f880]
[task 2021-09-21T22:44:48.095Z] 22:44:48     INFO - GECKO(1352) | #24: -[GeckoNSApplication nextEventMatchingMask:untilDate:inMode:dequeue:] [widget/cocoa/nsAppShell.mm:173]
[task 2021-09-21T22:44:48.096Z] 22:44:48     INFO - GECKO(1352) | #25: -[NSApplication run] [/System/Library/Frameworks/AppKit.framework/Versions/C/AppKit + 0x3158e]
[task 2021-09-21T22:44:48.096Z] 22:44:48     INFO - GECKO(1352) | #26: nsAppShell::Run() [widget/cocoa/nsAppShell.mm:775]
[task 2021-09-21T22:44:48.096Z] 22:44:48     INFO - GECKO(1352) | #27: nsAppStartup::Run() [toolkit/components/startup/nsAppStartup.cpp:290]
[task 2021-09-21T22:44:48.097Z] 22:44:48     INFO - GECKO(1352) | #28: XREMain::XRE_mainRun() [toolkit/xre/nsAppRunner.cpp:5291]
[task 2021-09-21T22:44:48.097Z] 22:44:48     INFO - GECKO(1352) | #29: XREMain::XRE_main(int, char**, mozilla::BootstrapConfig const&) [toolkit/xre/nsAppRunner.cpp:5476]
[task 2021-09-21T22:44:48.098Z] 22:44:48     INFO - GECKO(1352) | #30: XRE_main(int, char**, mozilla::BootstrapConfig const&) [toolkit/xre/nsAppRunner.cpp:5535]
[task 2021-09-21T22:44:48.098Z] 22:44:48     INFO - GECKO(1352) | #31: main [browser/app/nsBrowserApp.cpp:386]

This started to fail on tier 1: https://treeherder.mozilla.org/logviewer?job_id=354108894&repo=autoland&lineNumber=18178

Summary: Intermittent [tier 2] Assertion failure: int32_t(mRefCnt) >= 0 (illegal refcnt), at /builds/worker/workspace/obj-build/dist/include/mozilla/layers/NativeLayer.h:128 → Intermittent Assertion failure: int32_t(mRefCnt) >= 0 (illegal refcnt), at /builds/worker/workspace/obj-build/dist/include/mozilla/layers/NativeLayer.h:128

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.

Status: NEW → RESOLVED
Closed: 4 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.