1773175 - Intermittent position-dynamic-changes/horizontal/leftN-widthA-rightA.html?padding_parent == position-dynamic-changes/horizontal/leftN-widthA-rightA-ref.html?padding_parent | load failed: timed out waiting for test to complete (trying to get into WaitForTe

Status: RESOLVED INCOMPLETE

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

Description

[Treeherder Bug Filer]

Filed by: nfay [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=380522317&repo=mozilla-central
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/KerQYKBLSFCLsfBFlG7Vfg/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/KerQYKBLSFCLsfBFlG7Vfg/runs/0/artifacts/public/logs/live_backing.log&only_show_unexpected=1

---

[task 2022-06-07T22:32:56.202Z] 22:32:56     INFO - REFTEST TEST-START | layout/reftests/position-dynamic-changes/horizontal/leftN-widthA-rightA.html?padding_parent == layout/reftests/position-dynamic-changes/horizontal/leftN-widthA-rightA-ref.html?padding_parent
[task 2022-06-07T22:32:56.204Z] 22:32:56     INFO - [Parent 1864, Main Thread] WARNING: '!CanHandleWith(aPresContext)', file /builds/worker/checkouts/gecko/dom/events/IMEStateManager.cpp:499
[task 2022-06-07T22:32:56.205Z] 22:32:56     INFO - [Child 3176, Main Thread] WARNING: '!CanHandleWith(aPresContext)', file /builds/worker/checkouts/gecko/dom/events/IMEStateManager.cpp:499
[task 2022-06-07T22:32:56.206Z] 22:32:56     INFO - REFTEST TEST-LOAD | file:///Z:/task_165463943539837/build/tests/reftest/tests/layout/reftests/position-dynamic-changes/horizontal/leftN-widthA-rightA.html?padding_parent | 0 / 24 (0%)
[task 2022-06-07T22:32:56.212Z] 22:32:56     INFO - [2022-06-07T22:32:56Z WARN  xulstore::persist] tried to remove key that isn't in the store
[task 2022-06-07T22:32:56.212Z] 22:32:56     INFO - [2022-06-07T22:32:56Z WARN  xulstore::persist] tried to remove key that isn't in the store
[task 2022-06-07T22:32:56.221Z] 22:32:56     INFO - [Parent 1864, Main Thread] WARNING: WebProgress Ignored: no longer current window global: file /builds/worker/checkouts/gecko/dom/ipc/BrowserParent.cpp:3121
[task 2022-06-07T22:32:56.228Z] 22:32:56     INFO - [GPU 4472, Compositor] WARNING: IPC Connection Error: [Parent][PImageBridgeParent] RunMessage(msgname=PImageBridge::Msg_WillClose) Channel closing: too late to send/recv, messages will be lost: file /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:1908
[task 2022-06-07T22:32:56.232Z] 22:32:56     INFO - [Child 3176, Main Thread] WARNING: IPC message 'PIdleScheduler::Msg_StartedGC' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:509
[task 2022-06-07T22:32:56.239Z] 22:32:56     INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to C:\Users\task_165463943539837\AppData\Local\Temp\tmp8hlgejv4.mozrunner\runreftest_leaks_tab_pid3496.log
[task 2022-06-07T22:32:56.239Z] 22:32:56     INFO - [3496, 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-06-07T22:32:56.240Z] 22:32:56     INFO - [Child 3176, Main Thread] WARNING: IPC message 'PIdleScheduler::Msg_DoneGC' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:509
[task 2022-06-07T22:32:56.241Z] 22:32:56     INFO - [Child 3176, Main Thread] WARNING: IPC message 'PIdleScheduler::Msg_StartedGC' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:509
[task 2022-06-07T22:32:56.243Z] 22:32:56     INFO - [Child 3176, Main Thread] WARNING: IPC message 'PIdleScheduler::Msg_DoneGC' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:509
[task 2022-06-07T22:32:56.255Z] 22:32:56     INFO - [Child 3176, Main Thread] WARNING: IPC message 'PIdleScheduler::Msg_StartedGC' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:509
[task 2022-06-07T22:32:56.257Z] 22:32:56     INFO - [Child 3176, Main Thread] WARNING: IPC message 'PIdleScheduler::Msg_DoneGC' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:509
[task 2022-06-07T22:32:56.260Z] 22:32:56     INFO - [Child 3176, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3359
[task 2022-06-07T22:32:56.263Z] 22:32:56     INFO - [2022-06-07T22:32:56Z 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-06-07T22:32:56.263Z] 22:32:56     INFO - [Child 3176, Main Thread] WARNING: NS_ENSURE_TRUE(InitStaticMembers()) failed: file /builds/worker/workspace/obj-build/dist/include/mozilla/Preferences.h:129
[task 2022-06-07T22:32:56.263Z] 22:32:56     INFO - [Child 3176, Main Thread] WARNING: IPC message 'PIdleScheduler::Msg_StartedGC' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:509
[task 2022-06-07T22:32:56.265Z] 22:32:56     INFO - [Child 3176, Main Thread] WARNING: IPC message 'PIdleScheduler::Msg_DoneGC' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:509
[task 2022-06-07T22:32:56.265Z] 22:32:56     INFO - [Child 3176, Main Thread] WARNING: IPC message 'PIdleScheduler::Msg_StartedGC' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:509
[task 2022-06-07T22:32:56.266Z] 22:32:56     INFO - [Child 3176, Main Thread] WARNING: IPC message 'PIdleScheduler::Msg_DoneGC' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:509
[task 2022-06-07T22:32:56.270Z] 22:32:56     INFO - [Child 3176, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4571
[task 2022-06-07T22:32:56.327Z] 22:32:56     INFO - [Child 3496, 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:2039
[task 2022-06-07T22:32:56.342Z] 22:32:56     INFO - [2022-06-07T22:32:56Z WARN  webrender::device::gl] Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2022-06-07T22:32:56.343Z] 22:32:56     INFO - [2022-06-07T22:32:56Z WARN  webrender::device::gl] Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2022-06-07T22:32:56.343Z] 22:32:56     INFO - [2022-06-07T22:32:56Z WARN  webrender::device::gl] Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2022-06-07T22:32:56.435Z] 22:32:56     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-06-07T22:32:56.528Z] 22:32:56     INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to C:\Users\task_165463943539837\AppData\Local\Temp\tmp8hlgejv4.mozrunner\runreftest_leaks_tab_pid3068.log
[task 2022-06-07T22:32:56.529Z] 22:32:56     INFO - [3068, 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-06-07T22:32:56.539Z] 22:32:56     INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to C:\Users\task_165463943539837\AppData\Local\Temp\tmp8hlgejv4.mozrunner\runreftest_leaks_tab_pid3124.log
[task 2022-06-07T22:32:56.540Z] 22:32:56     INFO - [3124, 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-06-07T22:33:17.770Z] 22:33:17     INFO - [Parent 1864, 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-06-07T22:33:17.770Z] 22:33:17     INFO - [Parent 1864, 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-06-07T22:33:25.933Z] 22:33:25     INFO - JavaScript error: resource:///modules/UrlbarQuickSuggest.jsm, line 293: TypeError: can't access property "gBrowser", win is null
[task 2022-06-07T22:33:27.054Z] 22:33:27     INFO - [2022-06-07T22:33:27Z WARN  glean_core::error_recording] search.engine.private.submission_url: "" does not start with a valid URL scheme.
[task 2022-06-07T22:37:56.399Z] 22:37:56     INFO - REFTEST TEST-UNEXPECTED-FAIL | layout/reftests/position-dynamic-changes/horizontal/leftN-widthA-rightA.html?padding_parent == layout/reftests/position-dynamic-changes/horizontal/leftN-widthA-rightA-ref.html?padding_parent | load failed: timed out waiting for test to complete (trying to get into WaitForTestEnd)
[task 2022-06-07T22:37:56.400Z] 22:37:56     INFO - REFTEST INFO | Saved log: START file:///Z:/task_165463943539837/build/tests/reftest/tests/layout/reftests/position-dynamic-changes/horizontal/leftN-widthA-rightA.html?padding_parent
[task 2022-06-07T22:37:56.400Z] 22:37:56     INFO - REFTEST INFO | Saved log: [CONTENT] Using browser remote=true
[task 2022-06-07T22:37:56.400Z] 22:37:56     INFO - 
[task 2022-06-07T22:37:56.401Z] 22:37:56     INFO - REFTEST INFO | Saved log: [CONTENT] OnDocumentLoad fired for previous document
[task 2022-06-07T22:37:56.401Z] 22:37:56     INFO - REFTEST INFO | Saved log: [CONTENT] OnDocumentLoad triggering WaitForTestEnd
[task 2022-06-07T22:37:56.402Z] 22:37:56     INFO - REFTEST INFO | Saved log: [CONTENT] WaitForTestEnd: Adding listeners
[task 2022-06-07T22:37:56.402Z] 22:37:56     INFO - REFTEST INFO | Saved log: Initializing canvas snapshot
[task 2022-06-07T22:37:56.403Z] 22:37:56     INFO - REFTEST INFO | Saved log: DoDrawWindow 0,0,800,1000
[task 2022-06-07T22:37:56.403Z] 22:37:56     INFO - REFTEST INFO | Saved log: [CONTENT] AfterPaintListener in file:///Z:/task_165463943539837/build/tests/reftest/tests/layout/reftests/position-dynamic-changes/horizontal/leftN-widthA-rightA.html?padding_parent
[task 2022-06-07T22:37:56.404Z] 22:37:56     INFO - REFTEST INFO | Saved log: [CONTENT] AfterPaintListener in file:///Z:/task_165463943539837/build/tests/reftest/tests/layout/reftests/position-dynamic-changes/horizontal/leftN-widthA-rightA.html?padding_parent
[task 2022-06-07T22:37:56.404Z] 22:37:56     INFO - REFTEST INFO | Saved log: [CONTENT] MakeProgress
[task 2022-06-07T22:37:56.405Z] 22:37:56     INFO - REFTEST TEST-END | layout/reftests/position-dynamic-changes/horizontal/leftN-widthA-rightA.html?padding_parent == layout/reftests/position-dynamic-changes/horizontal/leftN-widthA-rightA-ref.html?padding_parent

Comment 1

[Intermittent Failures Robot]

1 failures in 3336 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-32-2004-qr: 1
  • debug: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1773175&startday=2022-06-06&endday=2022-06-12&tree=all

Comment 2

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

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

Comment 3

[Treeherder Bug Filer]

New failure instance: https://treeherder.mozilla.org/logviewer?job_id=386048012&repo=mozilla-beta

Comment 4

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-beta: 1

Platform and build breakdown:

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

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

Comment 5

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

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

Comment 6

[Treeherder Bug Filer]

New failure instance: https://treeherder.mozilla.org/logviewer?job_id=389649614&repo=autoland

Comment 7

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• linux1804-64-tsan-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1773175&startday=2022-09-05&endday=2022-09-11&tree=all

Comment 8

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• linux1804-64-asan-qr: 1
  • opt: 1

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

Comment 9

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

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