Closed Bug 1889140 Opened 1 year ago Closed 1 year ago

Intermittent accessible/tests/mochitest/events/docload/test_docload_aria.html | single tracking bug

Categories

(Core :: Disability Access APIs, defect, P5)

defect

Tracking

()

RESOLVED DUPLICATE of bug 1888649

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: assertion, intermittent-failure, intermittent-testcase)

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


[task 2024-04-02T14:03:28.660Z] 14:03:28     INFO - TEST-START | accessible/tests/mochitest/events/docload/test_docload_aria.html
<...>
[task 2024-04-02T14:03:58.037Z] 14:03:58     INFO - GECKO(7292) | #09: nsRefreshDriver::TickObserverArray(unsigned int, mozilla::TimeStamp) [layout/base/nsRefreshDriver.cpp:2527]
[task 2024-04-02T14:03:58.039Z] 14:03:58     INFO - GECKO(7292) | #10: nsRefreshDriver::Tick(mozilla::layers::BaseTransactionId<mozilla::VsyncIdType>, mozilla::TimeStamp, nsRefreshDriver::IsExtraTick) [layout/base/nsRefreshDriver.cpp:2757]
[task 2024-04-02T14:03:58.039Z] 14:03:58     INFO - GECKO(7292) | #11: mozilla::detail::RunnableFunction<`lambda at /builds/worker/checkouts/gecko/layout/base/nsRefreshDriver.cpp:1853:15'>::Run() [xpcom/threads/nsThreadUtils.h:549]
[task 2024-04-02T14:03:58.040Z] 14:03:58     INFO - GECKO(7292) | #12: mozilla::RunnableTask::Run() [xpcom/threads/TaskController.cpp:579]
[task 2024-04-02T14:03:58.041Z] 14:03:58     INFO - GECKO(7292) | #13: mozilla::TaskController::DoExecuteNextTaskOnlyMainThreadInternal(mozilla::detail::BaseAutoLock<mozilla::Mutex &> const&) [xpcom/threads/TaskController.cpp:905]
[task 2024-04-02T14:03:58.042Z] 14:03:58     INFO - GECKO(7292) | #14: mozilla::TaskController::ExecuteNextTaskOnlyMainThreadInternal(mozilla::detail::BaseAutoLock<mozilla::Mutex &> const&) [xpcom/threads/TaskController.cpp:728]
[task 2024-04-02T14:03:58.042Z] 14:03:58     INFO - GECKO(7292) | #15: mozilla::TaskController::ProcessPendingMTTask(bool) [xpcom/threads/TaskController.cpp:514]
[task 2024-04-02T14:03:58.042Z] 14:03:58     INFO - GECKO(7292) | #16: mozilla::detail::RunnableFunction<`lambda at /builds/worker/checkouts/gecko/xpcom/threads/TaskController.cpp:232:7'>::Run() [xpcom/threads/nsThreadUtils.h:549]
[task 2024-04-02T14:03:58.043Z] 14:03:58     INFO - GECKO(7292) | #17: nsThread::ProcessNextEvent(bool, bool*) [xpcom/threads/nsThread.cpp:1203]
[task 2024-04-02T14:03:58.043Z] 14:03:58     INFO - GECKO(7292) | #18: NS_ProcessNextEvent(nsIThread*, bool) [xpcom/threads/nsThreadUtils.cpp:480]
[task 2024-04-02T14:03:58.044Z] 14:03:58     INFO - GECKO(7292) | #19: mozilla::ipc::MessagePump::Run(base::MessagePump::Delegate*) [ipc/glue/MessagePump.cpp:85]
[task 2024-04-02T14:03:58.044Z] 14:03:58     INFO - GECKO(7292) | #20: MessageLoop::RunHandler() [ipc/chromium/src/base/message_loop.cc:364]
[task 2024-04-02T14:03:58.045Z] 14:03:58     INFO - GECKO(7292) | #21: MessageLoop::Run() [ipc/chromium/src/base/message_loop.cc:346]
[task 2024-04-02T14:03:58.046Z] 14:03:58     INFO - GECKO(7292) | #22: nsBaseAppShell::Run() [widget/nsBaseAppShell.cpp:150]
[task 2024-04-02T14:03:58.046Z] 14:03:58     INFO - GECKO(7292) | #23: nsAppShell::Run() [widget/windows/nsAppShell.cpp:822]
[task 2024-04-02T14:03:58.046Z] 14:03:58     INFO - GECKO(7292) | #24: nsAppStartup::Run() [toolkit/components/startup/nsAppStartup.cpp:297]
[task 2024-04-02T14:03:58.047Z] 14:03:58     INFO - GECKO(7292) | #25: XREMain::XRE_mainRun() [toolkit/xre/nsAppRunner.cpp:5746]
[task 2024-04-02T14:03:58.047Z] 14:03:58     INFO - GECKO(7292) | #26: XREMain::XRE_main(int, char**, mozilla::BootstrapConfig const&) [toolkit/xre/nsAppRunner.cpp:5958]
[task 2024-04-02T14:03:58.048Z] 14:03:58     INFO - GECKO(7292) | #27: XRE_main(int, char**, mozilla::BootstrapConfig const&) [toolkit/xre/nsAppRunner.cpp:6015]
[task 2024-04-02T14:03:58.049Z] 14:03:58     INFO - GECKO(7292) | #28: NS_internal_main(int, char**, char**) [browser/app/nsBrowserApp.cpp:445]
[task 2024-04-02T14:03:58.049Z] 14:03:58     INFO - GECKO(7292) | #29: wmain(int, wchar_t**) [toolkit/xre/nsWindowsWMain.cpp:174]
[task 2024-04-02T14:03:58.050Z] 14:03:58     INFO - GECKO(7292) | #30: __scrt_common_main_seh() [/builds/worker/workspace/obj-build/browser/app/D:/a/_work/1/s/src/vctools/crt/vcstartup/src/startup/exe_common.inl:288]
[task 2024-04-02T14:03:58.050Z] 14:03:58     INFO - GECKO(7292) | #31: BaseThreadInitThunk [C:\Windows\System32\KERNEL32.DLL + 0x1257d]
[task 2024-04-02T14:03:58.051Z] 14:03:58     INFO - GECKO(7292) | #32: RtlUserThreadStart [C:\Windows\SYSTEM32\ntdll.dll + 0x5aa58]
[task 2024-04-02T14:03:58.051Z] 14:03:58     INFO - GECKO(7292) | [Parent 8272, Main Thread] ###!!! ASSERTION: Can't create an accessible for the document!: 'parentDocAcc', file /builds/worker/checkouts/gecko/accessible/base/DocManager.cpp:467
[task 2024-04-02T14:03:58.052Z] 14:03:58     INFO - GECKO(7292) | #01: NS_DebugBreak(unsigned int, char const*, char const*, char const*, int) [xpcom/base/nsDebugImpl.cpp:491]
[task 2024-04-02T14:03:58.052Z] 14:03:58     INFO - GECKO(7292) | #02: mozilla::a11y::DocManager::CreateDocOrRootAccessible(mozilla::dom::Document*) [accessible/base/DocManager.cpp:467]
[task 2024-04-02T14:03:58.053Z] 14:03:58     INFO - GECKO(7292) | #03: nsAccessibilityService::ContentRangeInserted(mozilla::PresShell*, nsIContent*, nsIContent*) [accessible/base/nsAccessibilityService.cpp:667]
[task 2024-04-02T14:03:58.053Z] 14:03:58     INFO - GECKO(7292) | #04: nsCSSFrameConstructor::ContentAppended(nsIContent*, nsCSSFrameConstructor::InsertionKind) [layout/base/nsCSSFrameConstructor.cpp:6674]
[task 2024-04-02T14:03:58.054Z] 14:03:58     INFO - GECKO(7292) | #05: mozilla::RestyleManager::ProcessRestyledFrames(nsStyleChangeList&) [layout/base/RestyleManager.cpp:1625]
[task 2024-04-02T14:03:58.054Z] 14:03:58     INFO - GECKO(7292) | #06: mozilla::RestyleManager::DoProcessPendingRestyles(mozilla::ServoTraversalFlags) [layout/base/RestyleManager.cpp:3284]
[task 2024-04-02T14:03:58.056Z] 14:03:58     INFO - GECKO(7292) | #07: mozilla::RestyleManager::ProcessPendingRestyles() [layout/base/RestyleManager.cpp:3370]
[task 2024-04-02T14:03:58.056Z] 14:03:58     INFO - GECKO(7292) | #08: mozilla::PresShell::DoFlushPendingNotifications(mozilla::ChangesToFlush) [layout/base/PresShell.cpp:4420]
[task 2024-04-02T14:03:58.056Z] 14:03:58     INFO - GECKO(7292) | #09: mozilla::dom::Document::FlushPendingNotifications(mozilla::ChangesToFlush) [dom/base/Document.cpp:10949]
[task 2024-04-02T14:03:58.058Z] 14:03:58     INFO - GECKO(7292) | #10: InsertAnonymousContentInContainer(mozilla::dom::Document&, mozilla::dom::Element&) [layout/generic/nsCanvasFrame.cpp:100]
[task 2024-04-02T14:03:58.058Z] 14:03:58     INFO - GECKO(7292) | #11: mozilla::detail::RunnableFunction<`lambda at /builds/worker/checkouts/gecko/layout/generic/nsCanvasFrame.cpp:148:9'>::Run() [xpcom/threads/nsThreadUtils.h:549]
[task 2024-04-02T14:03:58.059Z] 14:03:58     INFO - GECKO(7292) | #12: nsContentUtils::RemoveScriptBlocker() [dom/base/nsContentUtils.cpp:6145]
[task 2024-04-02T14:03:58.060Z] 14:03:58     INFO - GECKO(7292) | #13: mozilla::PresShell::DoFlushPendingNotifications(mozilla::ChangesToFlush) [layout/base/PresShell.cpp:4423]
[task 2024-04-02T14:03:58.060Z] 14:03:58     INFO - GECKO(7292) | #14: nsRefreshDriver::TickObserverArray(unsigned int, mozilla::TimeStamp) [layout/base/nsRefreshDriver.cpp:2527]
[task 2024-04-02T14:03:58.061Z] 14:03:58     INFO - GECKO(7292) | #15: nsRefreshDriver::Tick(mozilla::layers::BaseTransactionId<mozilla::VsyncIdType>, mozilla::TimeStamp, nsRefreshDriver::IsExtraTick) [layout/base/nsRefreshDriver.cpp:2757]
[task 2024-04-02T14:03:58.062Z] 14:03:58     INFO - GECKO(7292) | #16: mozilla::detail::RunnableFunction<`lambda at /builds/worker/checkouts/gecko/layout/base/nsRefreshDriver.cpp:1853:15'>::Run() [xpcom/threads/nsThreadUtils.h:549]
[task 2024-04-02T14:03:58.062Z] 14:03:58     INFO - GECKO(7292) | #17: mozilla::RunnableTask::Run() [xpcom/threads/TaskController.cpp:579]
[task 2024-04-02T14:03:58.063Z] 14:03:58     INFO - GECKO(7292) | #18: mozilla::TaskController::DoExecuteNextTaskOnlyMainThreadInternal(mozilla::detail::BaseAutoLock<mozilla::Mutex &> const&) [xpcom/threads/TaskController.cpp:905]
[task 2024-04-02T14:03:58.064Z] 14:03:58     INFO - GECKO(7292) | #19: mozilla::TaskController::ExecuteNextTaskOnlyMainThreadInternal(mozilla::detail::BaseAutoLock<mozilla::Mutex &> const&) [xpcom/threads/TaskController.cpp:728]
[task 2024-04-02T14:03:58.064Z] 14:03:58     INFO - GECKO(7292) | #20: mozilla::TaskController::ProcessPendingMTTask(bool) [xpcom/threads/TaskController.cpp:514]
[task 2024-04-02T14:03:58.065Z] 14:03:58     INFO - GECKO(7292) | #21: mozilla::detail::RunnableFunction<`lambda at /builds/worker/checkouts/gecko/xpcom/threads/TaskController.cpp:232:7'>::Run() [xpcom/threads/nsThreadUtils.h:549]
[task 2024-04-02T14:03:58.066Z] 14:03:58     INFO - GECKO(7292) | #22: nsThread::ProcessNextEvent(bool, bool*) [xpcom/threads/nsThread.cpp:1203]
[task 2024-04-02T14:03:58.066Z] 14:03:58     INFO - GECKO(7292) | #23: NS_ProcessNextEvent(nsIThread*, bool) [xpcom/threads/nsThreadUtils.cpp:480]
[task 2024-04-02T14:03:58.067Z] 14:03:58     INFO - GECKO(7292) | #24: mozilla::ipc::MessagePump::Run(base::MessagePump::Delegate*) [ipc/glue/MessagePump.cpp:85]
[task 2024-04-02T14:03:58.067Z] 14:03:58     INFO - GECKO(7292) | #25: MessageLoop::RunHandler() [ipc/chromium/src/base/message_loop.cc:364]
[task 2024-04-02T14:03:58.068Z] 14:03:58     INFO - GECKO(7292) | #26: MessageLoop::Run() [ipc/chromium/src/base/message_loop.cc:346]
[task 2024-04-02T14:03:58.068Z] 14:03:58     INFO - GECKO(7292) | #27: nsBaseAppShell::Run() [widget/nsBaseAppShell.cpp:150]
[task 2024-04-02T14:03:58.069Z] 14:03:58     INFO - GECKO(7292) | #28: nsAppShell::Run() [widget/windows/nsAppShell.cpp:822]
[task 2024-04-02T14:03:58.069Z] 14:03:58     INFO - GECKO(7292) | #29: nsAppStartup::Run() [toolkit/components/startup/nsAppStartup.cpp:297]
[task 2024-04-02T14:03:58.070Z] 14:03:58     INFO - GECKO(7292) | #30: XREMain::XRE_mainRun() [toolkit/xre/nsAppRunner.cpp:5746]
[task 2024-04-02T14:03:58.071Z] 14:03:58     INFO - GECKO(7292) | #31: XREMain::XRE_main(int, char**, mozilla::BootstrapConfig const&) [toolkit/xre/nsAppRunner.cpp:5958]
[task 2024-04-02T14:03:58.071Z] 14:03:58     INFO - GECKO(7292) | #32: XRE_main(int, char**, mozilla::BootstrapConfig const&) [toolkit/xre/nsAppRunner.cpp:6015]
[task 2024-04-02T14:03:58.072Z] 14:03:58     INFO - GECKO(7292) | #33: NS_internal_main(int, char**, char**) [browser/app/nsBrowserApp.cpp:445]
[task 2024-04-02T14:03:58.072Z] 14:03:58     INFO - GECKO(7292) | #34: wmain(int, wchar_t**) [toolkit/xre/nsWindowsWMain.cpp:174]
[task 2024-04-02T14:03:58.073Z] 14:03:58     INFO - GECKO(7292) | #35: __scrt_common_main_seh() [/builds/worker/workspace/obj-build/browser/app/D:/a/_work/1/s/src/vctools/crt/vcstartup/src/startup/exe_common.inl:288]
[task 2024-04-02T14:03:58.073Z] 14:03:58     INFO - GECKO(7292) | #36: BaseThreadInitThunk [C:\Windows\System32\KERNEL32.DLL + 0x1257d]
[task 2024-04-02T14:03:58.074Z] 14:03:58     INFO - GECKO(7292) | #37: RtlUserThreadStart [C:\Windows\SYSTEM32\ntdll.dll + 0x5aa58]
[task 2024-04-02T14:03:58.074Z] 14:03:58     INFO - GECKO(7292) | MEMORY STAT | vsize 2112928MB | vsizeMaxContiguous 65543424MB | residentFast 506MB | heapAllocated 159MB
[task 2024-04-02T14:03:58.076Z] 14:03:58     INFO - GECKO(7292) | [Parent 8272, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/chrome/nsChromeRegistry.cpp:182
[task 2024-04-02T14:03:58.076Z] 14:03:58     INFO - GECKO(7292) | [Parent 8272, Main Thread] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/chrome/nsChromeProtocolHandler.cpp:73
[task 2024-04-02T14:03:58.077Z] 14:03:58     INFO - GECKO(7292) | [Parent 8272, Main Thread] WARNING: Failed to retarget HTML data delivery to the parser thread.: file /builds/worker/checkouts/gecko/parser/html/nsHtml5StreamParser.cpp:1215
[task 2024-04-02T14:03:58.077Z] 14:03:58     INFO - TEST-UNEXPECTED-FAIL | accessible/tests/mochitest/events/docload/test_docload_aria.html | assertion count 111 is more than expected 0 assertions
[task 2024-04-02T14:03:58.078Z] 14:03:58     INFO - Buffered messages logged at 14:03:29
[task 2024-04-02T14:03:58.078Z] 14:03:58     INFO - must wait for load
[task 2024-04-02T14:03:58.079Z] 14:03:58     INFO - Buffered messages logged at 14:03:31
[task 2024-04-02T14:03:58.079Z] 14:03:58     INFO - Invoke the 'show ARIA dialog' test { scenario #0: expected 'document load complete' event;  }
[task 2024-04-02T14:03:58.079Z] 14:03:58     INFO - TEST-PASS | accessible/tests/mochitest/events/docload/test_docload_aria.html | Test with ID = 'show ARIA dialog' succeed.  Event 'document load complete' was handled. 
[task 2024-04-02T14:03:58.081Z] 14:03:58     INFO - Invoke the 'show ARIA dialog' test { scenario #0: expected 'document load complete' event;  }
[task 2024-04-02T14:03:58.081Z] 14:03:58     INFO - TEST-PASS | accessible/tests/mochitest/events/docload/test_docload_aria.html | Test with ID = 'show ARIA dialog' succeed.  Event 'document load complete' was handled. 
[task 2024-04-02T14:03:58.081Z] 14:03:58     INFO - Buffered messages finished
[task 2024-04-02T14:03:58.082Z] 14:03:58     INFO - TEST-UNEXPECTED-ERROR | accessible/tests/mochitest/events/docload/test_docload_aria.html | Assertion Count - 111 is more than expected 0 assertions
[task 2024-04-02T14:03:58.083Z] 14:03:58     INFO - TEST-OK | accessible/tests/mochitest/events/docload/test_docload_aria.html | took 2789ms
Depends on: 1888649
Status: NEW → RESOLVED
Closed: 1 year ago
No longer depends on: 1888649
Duplicate of bug: 1888649
Resolution: --- → DUPLICATE
You need to log in before you can comment on or make changes to this bug.