Closed Bug 1778008 Opened 3 years ago Closed 3 years ago

Intermittent svg/smil/event/event-begin-1.svg == svg/smil/event/green-box-ref.svg | load failed: timed out waiting for test to complete (trying to get into WaitForTestEnd) followed by more test failures

Categories

(Testing :: Reftest, defect, P5)

Product:
Testing
Component:
Reftest
Type:
defect

Tracking

(Not tracked)

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

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

[task 2022-07-04T13:24:40.838Z] 13:24:40     INFO - [Parent 5829, Main Thread] WARNING: ContentParent: id=619001945b80 - ShutDownProcess: Closing channel.: file /builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp:1825
[task 2022-07-04T13:24:40.839Z] 13:24:40     INFO - [Parent 5829, Main Thread] WARNING: ContentParent: id=619001945b80 - RemoveShutdownBlockers: file /builds/worker/checkouts/gecko/dom/ipc/ContentParent.cpp:3688
[task 2022-07-04T13:24:42.206Z] 13:24:42     INFO - REFTEST INFO | Process mode: e10s
[task 2022-07-04T13:24:42.207Z] 13:24:42  WARNING - leakcheck | refcount logging is off, so leaks can't be detected!
[task 2022-07-04T13:24:42.208Z] 13:24:42     INFO - REFTEST INFO | Running tests in file:///builds/worker/workspace/build/tests/reftest/tests/layout/reftests/svg/smil/event/reftest.list
[task 2022-07-04T13:24:42.220Z] 13:24:42     INFO - REFTEST INFO | Running with e10s: True
[task 2022-07-04T13:24:42.221Z] 13:24:42     INFO - REFTEST INFO | Running with fission: True
[task 2022-07-04T13:24:42.222Z] 13:24:42     INFO - REFTEST INFO | INFO | runtests.py | ASan using symbolizer at /builds/worker/workspace/build/application/firefox/llvm-symbolizer
[task 2022-07-04T13:24:42.231Z] 13:24:42     INFO - REFTEST INFO | INFO | runtests.py | ASan running in default memory configuration
[task 2022-07-04T13:24:42.231Z] 13:24:42     INFO - REFTEST INFO | UBSan enabled.
[task 2022-07-04T13:24:42.231Z] 13:24:42     INFO - REFTEST INFO | Application command: /builds/worker/workspace/build/application/firefox/firefox -marionette -profile /tmp/tmpf_g4x5d7.mozrunner
[task 2022-07-04T13:24:43.618Z] 13:24:43     INFO - 1656941083616	Marionette	INFO	Marionette enabled
[task 2022-07-04T13:24:43.625Z] 13:24:43     INFO - 1656941083622	Marionette	TRACE	Received observer notification final-ui-startup
[task 2022-07-04T13:24:43.629Z] 13:24:43     INFO - 1656941083628	Marionette	INFO	Listening on port 2828
[task 2022-07-04T13:24:43.631Z] 13:24:43     INFO - 1656941083628	Marionette	DEBUG	Marionette is listening
[task 2022-07-04T13:24:43.928Z] 13:24:43     INFO - 1656941083926	Marionette	DEBUG	Accepted connection 0 from 127.0.0.1:36096
[task 2022-07-04T13:24:44.021Z] 13:24:44     INFO - 1656941084019	Marionette	DEBUG	Accepted connection 1 from 127.0.0.1:36098
[task 2022-07-04T13:24:44.022Z] 13:24:44     INFO - 1656941084020	Marionette	DEBUG	Closed connection 0
[task 2022-07-04T13:24:44.482Z] 13:24:44     INFO - 1656941084481	Marionette	DEBUG	1 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
[task 2022-07-04T13:24:44.496Z] 13:24:44     INFO - 1656941084492	Marionette	DEBUG	Waiting for initial application window
[task 2022-07-04T13:24:50.346Z] 13:24:50     INFO - console.warn: SearchSettings: "get: No settings file exists, new profile?" (new NotFoundError("Could not open the file at /tmp/tmpf_g4x5d7.mozrunner/search.json.mozlz4", (void 0)))
[task 2022-07-04T13:24:52.666Z] 13:24:52     INFO - 1656941092665	Marionette	TRACE	Received observer notification browser-idle-startup-tasks-finished
[task 2022-07-04T13:24:52.710Z] 13:24:52     INFO - 1656941092709	RemoteAgent	TRACE	[24] Document already finished loading: about:blank
[task 2022-07-04T13:24:52.777Z] 13:24:52     INFO - 1656941092775	Marionette	DEBUG	1 <- [1,1,null,{"sessionId":"b0399629-8af2-4b2d-b4bb-0f2dfc23a242","capabilities":{"browserName":"firefox","browserVersion":"105.0 ... wnTimeout":300000,"moz:useNonSpecCompliantPointerOrigin":false,"moz:webdriverClick":true,"moz:windowless":false,"proxy":{}}}]
[task 2022-07-04T13:24:52.801Z] 13:24:52     INFO - 1656941092799	Marionette	DEBUG	1 -> [0,2,"Addon:Install",{"path":"/builds/worker/workspace/build/tests/reftest/specialpowers","temporary":true}]
[task 2022-07-04T13:24:52.909Z] 13:24:52     INFO - 1656941092908	Marionette	DEBUG	1 <- [1,2,null,{"value":"special-powers@mozilla.org"}]
[task 2022-07-04T13:24:52.932Z] 13:24:52     INFO - 1656941092931	Marionette	DEBUG	1 -> [0,3,"Addon:Install",{"path":"/builds/worker/workspace/build/tests/reftest/reftest","temporary":true}]
[task 2022-07-04T13:24:53.035Z] 13:24:53     INFO - 1656941093034	Marionette	TRACE	Received observer notification domwindowopened
[task 2022-07-04T13:24:53.045Z] 13:24:53     INFO - 1656941093043	Marionette	DEBUG	1 <- [1,3,null,{"value":"reftest@mozilla.org"}]
[task 2022-07-04T13:24:53.059Z] 13:24:53     INFO - 1656941093058	Marionette	DEBUG	1 -> [0,4,"WebDriver:DeleteSession",{}]
[task 2022-07-04T13:24:53.068Z] 13:24:53     INFO - 1656941093067	Marionette	DEBUG	1 <- [1,4,null,{"value":null}]
[task 2022-07-04T13:24:53.077Z] 13:24:53     INFO - 1656941093075	Marionette	DEBUG	Closed connection 1
[task 2022-07-04T13:24:53.954Z] 13:24:53     INFO - REFTEST TEST-START | layout/reftests/svg/smil/event/event-begin-1.svg == layout/reftests/svg/smil/event/green-box-ref.svg
[task 2022-07-04T13:24:53.957Z] 13:24:53     INFO - REFTEST TEST-LOAD | file:///builds/worker/workspace/build/tests/reftest/tests/layout/reftests/svg/smil/event/event-begin-1.svg | 0 / 28 (0%)
[task 2022-07-04T13:24:54.632Z] 13:24:54     INFO - REFTEST INFO | drawWindow flags = DRAWWINDOW_DRAW_CARET | DRAWWINDOW_DRAW_VIEW | DRAWWINDOW_USE_WIDGET_LAYERS; window size = 800,1000; test browser size = 800,1000
[task 2022-07-04T13:29:54.589Z] 13:29:54     INFO - REFTEST TEST-UNEXPECTED-FAIL | layout/reftests/svg/smil/event/event-begin-1.svg == layout/reftests/svg/smil/event/green-box-ref.svg | load failed: timed out waiting for test to complete (trying to get into WaitForTestEnd)
[task 2022-07-04T13:29:54.591Z] 13:29:54     INFO - REFTEST INFO | Saved log: START file:///builds/worker/workspace/build/tests/reftest/tests/layout/reftests/svg/smil/event/event-begin-1.svg
[task 2022-07-04T13:29:54.592Z] 13:29:54     INFO - REFTEST INFO | Saved log: [CONTENT] Using browser remote=true
[task 2022-07-04T13:29:54.593Z] 13:29:54     INFO - 
[task 2022-07-04T13:29:54.594Z] 13:29:54     INFO - REFTEST INFO | Saved log: [CONTENT] OnDocumentLoad fired for previous document
[task 2022-07-04T13:29:54.594Z] 13:29:54     INFO - REFTEST INFO | Saved log: [CONTENT] OnDocumentLoad triggering WaitForTestEnd
[task 2022-07-04T13:29:54.595Z] 13:29:54     INFO - REFTEST INFO | Saved log: [CONTENT] WaitForTestEnd: Adding listeners
[task 2022-07-04T13:29:54.596Z] 13:29:54     INFO - REFTEST INFO | Saved log: [CONTENT] AttrModifiedListener fired
[task 2022-07-04T13:29:54.599Z] 13:29:54     INFO - REFTEST INFO | Saved log: Initializing canvas snapshot
[task 2022-07-04T13:29:54.599Z] 13:29:54     INFO - REFTEST INFO | Saved log: DoDrawWindow 0,0,800,1000
[task 2022-07-04T13:29:54.599Z] 13:29:54     INFO - REFTEST INFO | Saved log: [CONTENT] AfterPaintListener in file:///builds/worker/workspace/build/tests/reftest/tests/layout/reftests/svg/smil/event/event-begin-1.svg
[task 2022-07-04T13:29:54.600Z] 13:29:54     INFO - REFTEST INFO | Saved log: [CONTENT] AfterPaintListener in file:///builds/worker/workspace/build/tests/reftest/tests/layout/reftests/svg/smil/event/event-begin-1.svg
[task 2022-07-04T13:29:54.600Z] 13:29:54     INFO - REFTEST INFO | Saved log: [CONTENT] MakeProgress
[task 2022-07-04T13:29:54.600Z] 13:29:54     INFO - REFTEST TEST-END | layout/reftests/svg/smil/event/event-begin-1.svg == layout/reftests/svg/smil/event/green-box-ref.svg

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
You need to log in before you can comment on or make changes to this bug.