1778693 - Intermittent position-dynamic-changes/multiple-changes.html == position-dynamic-changes/multiple-changes-ref.html | load failed: timed out waiting for test to complete (trying to get into WaitForTestEnd)

Status: RESOLVED INCOMPLETE

(Core :: Layout: Positioned, defect, P5)

Description

[Treeherder Bug Filer]

Filed by: smolnar [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=383725652&repo=mozilla-central
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/bhX6G63eRPm_AjXptWlQAQ/runs/0/artifacts/public/logs/live_backing.log
Reftest URL: https://hg.mozilla.org/mozilla-central/raw-file/tip/layout/tools/reftest/reftest-analyzer.xhtml#logurl=https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/bhX6G63eRPm_AjXptWlQAQ/runs/0/artifacts/public/logs/live_backing.log&only_show_unexpected=1

---

INFO - REFTEST TEST-START | layout/reftests/position-dynamic-changes/multiple-changes.html == layout/reftests/position-dynamic-changes/multiple-changes-ref.html
[task 2022-07-08T10:17:33.045Z] 10:17:33     INFO - [Parent 6800, Main Thread] WARNING: '!CanHandleWith(aPresContext)', file /builds/worker/checkouts/gecko/dom/events/IMEStateManager.cpp:498
[task 2022-07-08T10:17:33.046Z] 10:17:33     INFO - [Child 6496, Main Thread] WARNING: '!CanHandleWith(aPresContext)', file /builds/worker/checkouts/gecko/dom/events/IMEStateManager.cpp:498
[task 2022-07-08T10:17:33.048Z] 10:17:33     INFO - REFTEST TEST-LOAD | file:///Z:/task_165727107958605/build/tests/reftest/tests/layout/reftests/position-dynamic-changes/multiple-changes.html | 0 / 4 (0%)
[task 2022-07-08T10:17:33.065Z] 10:17:33     INFO - [Parent 6800, Main Thread] WARNING: WebProgress Ignored: no longer current window global: file /builds/worker/checkouts/gecko/dom/ipc/BrowserParent.cpp:3127
[task 2022-07-08T10:17:33.082Z] 10:17:33     INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to C:\Users\task_165727107958605\AppData\Local\Temp\tmp2y8v4zz9.mozrunner\runreftest_leaks_tab_pid6420.log
[task 2022-07-08T10:17:33.083Z] 10:17:33     INFO - [6420, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp:340
[task 2022-07-08T10:17:33.113Z] 10:17:33     INFO - [Child 6496, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3359
[task 2022-07-08T10:17:33.116Z] 10:17:33     INFO - [2022-07-08T10:17:33Z WARN  audioipc2::ipccore] AudioIPC Server RPC: EventLoop drop - closing connection for Token(3) failed: Custom { kind: NotFound, error: "I/O source not registered with `Registry`" }
[task 2022-07-08T10:17:33.117Z] 10:17:33     INFO - [Child 6496, Main Thread] WARNING: NS_ENSURE_TRUE(InitStaticMembers()) failed: file /builds/worker/workspace/obj-build/dist/include/mozilla/Preferences.h:129
[task 2022-07-08T10:17:33.124Z] 10:17:33     INFO - [Child 6496, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4595
[task 2022-07-08T10:17:33.176Z] 10:17:33     INFO - [Child 6420, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80520012 (NS_ERROR_FILE_NOT_FOUND): file /builds/worker/checkouts/gecko/layout/style/Loader.cpp:2041
[task 2022-07-08T10:17:33.199Z] 10:17:33     INFO - [2022-07-08T10:17:33Z WARN  glean_core::error_recording] search.engine.private.submission_url: "" does not start with a valid URL scheme.
[task 2022-07-08T10:17:33.200Z] 10:17:33     INFO - [2022-07-08T10:17:33Z WARN  webrender::device::gl] Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2022-07-08T10:17:33.200Z] 10:17:33     INFO - [2022-07-08T10:17:33Z WARN  webrender::device::gl] Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2022-07-08T10:17:33.201Z] 10:17:33     INFO - [2022-07-08T10:17:33Z WARN  webrender::device::gl] Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2022-07-08T10:17:33.656Z] 10:17:33     INFO - [Parent 6800, 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 2022-07-08T10:17:33.658Z] 10:17:33     INFO - [Parent 6800, Main Thread] WARNING: Failed to retarget HTML data delivery to the parser thread.: file /builds/worker/checkouts/gecko/parser/html/nsHtml5StreamParser.cpp:1234
[task 2022-07-08T10:17:33.721Z] 10:17:33     INFO - REFTEST INFO | drawWindow flags = DRAWWINDOW_DRAW_CARET | DRAWWINDOW_DRAW_VIEW | DRAWWINDOW_USE_WIDGET_LAYERS; window size = 816,1039; test browser size = 800,1000
[task 2022-07-08T10:17:33.777Z] 10:17:33     INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to C:\Users\task_165727107958605\AppData\Local\Temp\tmp2y8v4zz9.mozrunner\runreftest_leaks_tab_pid3460.log
[task 2022-07-08T10:17:33.779Z] 10:17:33     INFO - [3460, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp:340
[task 2022-07-08T10:17:33.786Z] 10:17:33     INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to C:\Users\task_165727107958605\AppData\Local\Temp\tmp2y8v4zz9.mozrunner\runreftest_leaks_tab_pid7692.log
[task 2022-07-08T10:17:33.787Z] 10:17:33     INFO - [7692, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp:340
[task 2022-07-08T10:17:37.886Z] 10:17:37     INFO - [Parent 6800, Main Thread] WARNING: NS_ENSURE_TRUE(!mHasOrHasHadOwnerWindow || mOwnerWindow) failed: file /builds/worker/checkouts/gecko/dom/events/DOMEventTargetHelper.cpp:306
[task 2022-07-08T10:22:33.647Z] 10:22:33     INFO - REFTEST TEST-UNEXPECTED-FAIL | layout/reftests/position-dynamic-changes/multiple-changes.html == layout/reftests/position-dynamic-changes/multiple-changes-ref.html | load failed: timed out waiting for test to complete (trying to get into WaitForTestEnd)
[task 2022-07-08T10:22:33.648Z] 10:22:33     INFO - REFTEST INFO | Saved log: START file:///Z:/task_165727107958605/build/tests/reftest/tests/layout/reftests/position-dynamic-changes/multiple-changes.html
[task 2022-07-08T10:22:33.648Z] 10:22:33     INFO - REFTEST INFO | Saved log: [CONTENT] Using browser remote=true
[task 2022-07-08T10:22:33.648Z] 10:22:33     INFO - 
[task 2022-07-08T10:22:33.649Z] 10:22:33     INFO - REFTEST INFO | Saved log: [CONTENT] OnDocumentLoad fired for previous document
[task 2022-07-08T10:22:33.649Z] 10:22:33     INFO - REFTEST INFO | Saved log: [CONTENT] OnDocumentLoad triggering WaitForTestEnd
[task 2022-07-08T10:22:33.650Z] 10:22:33     INFO - REFTEST INFO | Saved log: [CONTENT] WaitForTestEnd: Adding listeners
[task 2022-07-08T10:22:33.650Z] 10:22:33     INFO - REFTEST INFO | Saved log: Initializing canvas snapshot
[task 2022-07-08T10:22:33.651Z] 10:22:33     INFO - REFTEST INFO | Saved log: DoDrawWindow 0,0,800,1000
[task 2022-07-08T10:22:33.651Z] 10:22:33     INFO - REFTEST INFO | Saved log: [CONTENT] AfterPaintListener in file:///Z:/task_165727107958605/build/tests/reftest/tests/layout/reftests/position-dynamic-changes/multiple-changes.html
[task 2022-07-08T10:22:33.652Z] 10:22:33     INFO - REFTEST INFO | Saved log: [CONTENT] AfterPaintListener in file:///Z:/task_165727107958605/build/tests/reftest/tests/layout/reftests/position-dynamic-changes/multiple-changes.html
[task 2022-07-08T10:22:33.652Z] 10:22:33     INFO - REFTEST INFO | Saved log: [CONTENT] MakeProgress
[task 2022-07-08T10:22:33.652Z] 10:22:33     INFO - REFTEST TEST-END | layout/reftests/position-dynamic-changes/multiple-changes.html == layout/reftests/position-dynamic-changes/multiple-changes-ref.html

Comment 1

[Intermittent Failures Robot]

2 failures in 3072 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 2

Platform and build breakdown:

• windows10-32-2004-qr: 1
  • debug: 1
• windows10-64-2004-mingwclang-qr: 1
  • debug: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1778693&startday=2022-07-04&endday=2022-07-10&tree=all

Comment 2

[Iulian Moraru]

First occurrence in this backfill range and retriggers: https://treeherder.mozilla.org/jobs?repo=mozilla-central&searchStr=Windows%2C10%2Cx86%2C2004%2CWebRender%2Cdebug%2CReftests%2Ctest-windows10-32-2004-qr%2Fdebug-reftest%2CR2&group_state=expanded&tochange=e6e2286d2ac25001127a1cf54a87a95fb435c734&fromchange=f93461c8f7bac0491ec2acce3a98a58bea6acb9d&selectedTaskRun=bhX6G63eRPm_AjXptWlQAQ.0

Comment 3

[Intermittent Failures Robot]

1 failures in 3245 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 1

Platform and build breakdown:

• windows10-64-2004-mingwclang-qr: 1
  • debug: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1778693&startday=2022-07-25&endday=2022-07-31&tree=all

Comment 4

[BugBot [:suhaib / :marco/ :calixte]]

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