Closed Bug 1781822 Opened 3 years ago Closed 3 years ago

Intermittent gfx/tests/reftest/468496-1.html == gfx/tests/reftest/468496-1-ref.html | load failed: timed out waiting for test to complete (waiting for onload scripts to complete)

Categories

(Core :: Graphics, defect, P5)

Product:
Core
Component:
Graphics
Type:
defect

Tracking

()

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

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

[task 2022-07-27T14:51:35.813Z] 14:51:35     INFO - REFTEST TEST-START | gfx/tests/reftest/468496-1.html == gfx/tests/reftest/468496-1-ref.html
[task 2022-07-27T14:51:35.814Z] 14:51:35     INFO - [Parent 5352, Main Thread] WARNING: '!CanHandleWith(aPresContext)', file /builds/worker/checkouts/gecko/dom/events/IMEStateManager.cpp:498
[task 2022-07-27T14:51:35.815Z] 14:51:35     INFO - [Child 3984, Main Thread] WARNING: '!CanHandleWith(aPresContext)', file /builds/worker/checkouts/gecko/dom/events/IMEStateManager.cpp:498
[task 2022-07-27T14:51:35.817Z] 14:51:35     INFO - REFTEST TEST-LOAD | file:///Z:/task_165892942105706/build/tests/reftest/tests/gfx/tests/reftest/468496-1.html | 0 / 35 (0%)
[task 2022-07-27T14:51:35.843Z] 14:51:35     INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to C:\Users\task_165892942105706\AppData\Local\Temp\tmpc0yri_ao.mozrunner\runreftest_leaks_tab_pid8448.log
[task 2022-07-27T14:51:35.843Z] 14:51:35     INFO - [8448, 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-07-27T14:51:35.860Z] 14:51:35     INFO - [Parent 5352, Main Thread] WARNING: WebProgress Ignored: no longer current window global: file /builds/worker/checkouts/gecko/dom/ipc/BrowserParent.cpp:3097
[task 2022-07-27T14:51:35.904Z] 14:51:35     INFO - [Child 3984, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3359
[task 2022-07-27T14:51:35.905Z] 14:51:35     INFO - [2022-07-27T14:51:35Z 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-27T14:51:35.906Z] 14:51:35     INFO - [Child 3984, Main Thread] WARNING: NS_ENSURE_TRUE(InitStaticMembers()) failed: file /builds/worker/workspace/obj-build/dist/include/mozilla/Preferences.h:129
[task 2022-07-27T14:51:35.912Z] 14:51:35     INFO - [Child 3984, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4595
[task 2022-07-27T14:51:35.929Z] 14:51:35     INFO - [Child 8448, 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-27T14:51:35.945Z] 14:51:35     INFO - [2022-07-27T14:51:35Z WARN  webrender::device::gl] Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2022-07-27T14:51:35.946Z] 14:51:35     INFO - [2022-07-27T14:51:35Z WARN  webrender::device::gl] Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2022-07-27T14:51:35.946Z] 14:51:35     INFO - [2022-07-27T14:51:35Z WARN  webrender::device::gl] Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2022-07-27T14:51:36.450Z] 14:51:36     INFO - [Parent 5352, 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-27T14:51:36.451Z] 14:51:36     INFO - [Parent 5352, 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-27T14:51:36.561Z] 14:51:36     INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to C:\Users\task_165892942105706\AppData\Local\Temp\tmpc0yri_ao.mozrunner\runreftest_leaks_tab_pid4844.log
[task 2022-07-27T14:51:36.562Z] 14:51:36     INFO - [4844, 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-07-27T14:51:36.569Z] 14:51:36     INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to C:\Users\task_165892942105706\AppData\Local\Temp\tmpc0yri_ao.mozrunner\runreftest_leaks_tab_pid5880.log
[task 2022-07-27T14:51:36.571Z] 14:51:36     INFO - [5880, 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-07-27T14:51:41.584Z] 14:51:41     INFO - [Parent 5352, Main Thread] WARNING: NS_ENSURE_TRUE(!mHasOrHasHadOwnerWindow || mOwnerWindow) failed: file /builds/worker/checkouts/gecko/dom/events/DOMEventTargetHelper.cpp:306
[task 2022-07-27T14:51:45.328Z] 14:51:45     INFO - [Parent 5352, Main Thread] WARNING: early callback, or time went backwards: '!aAllowIdleDispatch', file /builds/worker/checkouts/gecko/xpcom/threads/IdleTaskRunner.cpp:198
[task 2022-07-27T14:56:36.397Z] 14:56:36     INFO - REFTEST TEST-UNEXPECTED-FAIL | gfx/tests/reftest/468496-1.html == gfx/tests/reftest/468496-1-ref.html | load failed: timed out waiting for test to complete (waiting for onload scripts to complete)
[task 2022-07-27T14:56:36.398Z] 14:56:36     INFO - REFTEST INFO | Saved log: START file:///Z:/task_165892942105706/build/tests/reftest/tests/gfx/tests/reftest/468496-1.html
[task 2022-07-27T14:56:36.398Z] 14:56:36     INFO - REFTEST INFO | Saved log: [CONTENT] Using browser remote=true
[task 2022-07-27T14:56:36.398Z] 14:56:36     INFO - 
[task 2022-07-27T14:56:36.398Z] 14:56:36     INFO - REFTEST INFO | Saved log: [CONTENT] OnDocumentLoad fired for previous document
[task 2022-07-27T14:56:36.399Z] 14:56:36     INFO - REFTEST INFO | Saved log: [CONTENT] OnDocumentLoad triggering AfterOnLoadScripts
[task 2022-07-27T14:56:36.399Z] 14:56:36     INFO - REFTEST TEST-END | gfx/tests/reftest/468496-1.html == gfx/tests/reftest/468496-1-ref.html
[task 2022-07-27T14:56:36.409Z] 14:56:36     INFO - [Parent 5352, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorParent.cpp:42
[task 2022-07-27T14:56:36.423Z] 14:56:36     INFO - REFTEST TEST-START | gfx/tests/reftest/611498-1.html == gfx/tests/reftest/611498-ref.html
[task 2022-07-27T14:56:36.423Z] 14:56:36     INFO - REFTEST TEST-LOAD | file:///Z:/task_165892942105706/build/tests/reftest/tests/gfx/tests/reftest/611498-1.html | 1 / 35 (2%)
[task 2022-07-27T14:56:36.428Z] 14:56:36     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-27T15:00:01.653Z] 15:00:01     INFO - [2022-07-27T15:00:01Z WARN  rkv::backend::impl_safe::environment] `load_ratio()` is irrelevant for this storage backend.
[task 2022-07-27T15:01:36.440Z] 15:01:36     INFO - REFTEST TEST-UNEXPECTED-FAIL | gfx/tests/reftest/611498-1.html == gfx/tests/reftest/611498-ref.html | load failed: timed out waiting for test to complete (trying to get into WaitForTestEnd)
[task 2022-07-27T15:01:36.441Z] 15:01:36     INFO - REFTEST INFO | Saved log: START file:///Z:/task_165892942105706/build/tests/reftest/tests/gfx/tests/reftest/611498-1.html
[task 2022-07-27T15:01:36.441Z] 15:01:36     INFO - REFTEST INFO | Saved log: Initializing canvas snapshot
[task 2022-07-27T15:01:36.441Z] 15:01:36     INFO - REFTEST INFO | Saved log: DoDrawWindow 0,0,800,1000
[task 2022-07-27T15:01:36.442Z] 15:01:36     INFO - REFTEST INFO | Saved log: [CONTENT] RecordResult fired for previous document
[task 2022-07-27T15:01:36.442Z] 15:01:36     INFO - REFTEST INFO | Saved log: [CONTENT] OnDocumentLoad triggering WaitForTestEnd
[task 2022-07-27T15:01:36.443Z] 15:01:36     INFO - REFTEST INFO | Saved log: [CONTENT] WaitForTestEnd: Adding listeners
[task 2022-07-27T15:01:36.443Z] 15:01:36     INFO - REFTEST INFO | Saved log: Initializing canvas snapshot
[task 2022-07-27T15:01:36.443Z] 15:01:36     INFO - REFTEST INFO | Saved log: DoDrawWindow 0,0,800,1000
[task 2022-07-27T15:01:36.446Z] 15:01:36     INFO - REFTEST INFO | Saved log: [CONTENT] AfterPaintListener in file:///Z:/task_165892942105706/build/tests/reftest/tests/gfx/tests/reftest/611498-1.html
[task 2022-07-27T15:01:36.447Z] 15:01:36     INFO - REFTEST INFO | Saved log: [CONTENT] MakeProgress
[task 2022-07-27T15:01:36.447Z] 15:01:36     INFO - REFTEST TEST-END | gfx/tests/reftest/611498-1.html == gfx/tests/reftest/611498-ref.html
[task 2022-07-27T15:01:36.452Z] 15:01:36     INFO - [Parent 5352, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorParent.cpp:42
[task 2022-07-27T15:01:36.464Z] 15:01:36     INFO - REFTEST TEST-START | gfx/tests/reftest/709477-1.html == gfx/tests/reftest/709477-1-ref.html
[task 2022-07-27T15:01:36.464Z] 15:01:36     INFO - REFTEST TEST-SKIP | gfx/tests/reftest/709477-1.html == gfx/tests/reftest/709477-1-ref.html | 
[task 2022-07-27T15:01:36.464Z] 15:01:36     INFO - REFTEST TEST-END | gfx/tests/reftest/709477-1.html == gfx/tests/reftest/709477-1-ref.html
[task 2022-07-27T15:01:36.465Z] 15:01:36     INFO - REFTEST TEST-START | gfx/tests/reftest/1086723.html == gfx/tests/reftest/1086723-ref.html

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

Status: NEW → RESOLVED
Closed: 3 years ago
Resolution: --- → INCOMPLETE

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

Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---

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

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