1859720 - Intermittent Wayland remote/cdp/test/browser/page/browser_domContentEventFired.js | single tracking bug

Status: RESOLVED INVALID

(Remote Protocol :: CDP, defect, P5)

Description

[Treeherder Bug Filer]

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

---

[task 2023-10-18T08:07:36.505Z] 08:07:36     INFO - TEST-PASS | remote/cdp/test/browser/page/browser_domContentEventFired.js | Got expected amount of domContentEventFired events - 
[task 2023-10-18T08:07:36.507Z] 08:07:36     INFO - Buffered messages finished
[task 2023-10-18T08:07:36.523Z] 08:07:36     INFO - TEST-UNEXPECTED-FAIL | remote/cdp/test/browser/page/browser_domContentEventFired.js | Timestamp 1697616453.232 in expected range [1697616453.101 - 1697616452.987] - 
[task 2023-10-18T08:07:36.523Z] 08:07:36     INFO - Stack trace:
[task 2023-10-18T08:07:36.524Z] 08:07:36     INFO - chrome://mochikit/content/browser-test.js:test_ok:1583
[task 2023-10-18T08:07:36.524Z] 08:07:36     INFO - chrome://mochitests/content/browser/remote/cdp/test/browser/page/browser_domContentEventFired.js:runContentEventFiredTest:91
[task 2023-10-18T08:07:36.524Z] 08:07:36     INFO - chrome://mochitests/content/browser/remote/cdp/test/browser/page/browser_domContentEventFired.js:eventWhenNavigatingWithNestedFrames:52
[task 2023-10-18T08:07:36.524Z] 08:07:36     INFO - chrome://mochitests/content/browser/remote/cdp/test/browser/head.js:fn:87
[task 2023-10-18T08:07:36.524Z] 08:07:36     INFO - chrome://mochikit/content/browser-test.js:handleTask:1134
[task 2023-10-18T08:07:36.524Z] 08:07:36     INFO - chrome://mochikit/content/browser-test.js:_runTaskBasedTest:1206
[task 2023-10-18T08:07:36.525Z] 08:07:36     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1348
[task 2023-10-18T08:07:36.525Z] 08:07:36     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:1123
[task 2023-10-18T08:07:36.525Z] 08:07:36     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/<:1058
[task 2023-10-18T08:07:36.532Z] 08:07:36     INFO - GECKO(8046) | 1697616453022	RemoteAgent	DEBUG	CDPConnection 6f360c6e-4e76-4719-b03a-6a27dcc0929d closed
[task 2023-10-18T08:07:36.535Z] 08:07:36     INFO - GECKO(8046) | 1697616453022	RemoteAgent	DEBUG	CDPConnection 6e546bfb-422c-4861-822e-6166259627cf <- {"method":"Target.targetDestroyed","params":{"targetId":"5323bac6-bb82-48b1-b69a-68ddcfd3bea0"}}
[task 2023-10-18T08:07:36.543Z] 08:07:36     INFO - GECKO(8046) | 1697616453023	RemoteAgent	DEBUG	CDPConnection ebacff35-9011-452d-a43e-5684e24de87a <- {"method":"Target.targetDestroyed","params":{"targetId":"5323bac6-bb82-48b1-b69a-68ddcfd3bea0"}}
[task 2023-10-18T08:07:36.546Z] 08:07:36     INFO - GECKO(8046) | 1697616453023	RemoteAgent	DEBUG	CDPConnection f86a41f1-dfe8-483a-b76e-9abc539c1fda <- {"method":"Target.targetDestroyed","params":{"targetId":"5323bac6-bb82-48b1-b69a-68ddcfd3bea0"}}
[task 2023-10-18T08:07:36.561Z] 08:07:36     INFO - GECKO(8046) | 1697616453023	RemoteAgent	DEBUG	CDPConnection da8245c0-ffe6-4001-8443-7e3e78d9439f <- {"method":"Target.targetDestroyed","params":{"targetId":"5323bac6-bb82-48b1-b69a-68ddcfd3bea0"}}
<...>
[task 2023-10-18T08:07:36.724Z] 08:07:36     INFO - GECKO(8046) | 1697616453041	RemoteAgent	DEBUG	CDPConnection 79c6f9ed-ca8b-4012-a8de-852c1a889e3a <- {"method":"Target.targetDestroyed","params":{"targetId":"5323bac6-bb82-48b1-b69a-68ddcfd3bea0"}}
[task 2023-10-18T08:07:36.726Z] 08:07:36     INFO - GECKO(8046) | 1697616453041	RemoteAgent	DEBUG	CDPConnection a03d98e7-a031-44ec-a085-4a27235223bd <- {"method":"Target.targetDestroyed","params":{"targetId":"5323bac6-bb82-48b1-b69a-68ddcfd3bea0"}}
[task 2023-10-18T08:07:36.737Z] 08:07:36     INFO - GECKO(8046) | 1697616453042	RemoteAgent	DEBUG	CDPConnection 2a188412-fffc-4e86-8bd4-40328b145990 <- {"method":"Target.targetDestroyed","params":{"targetId":"5323bac6-bb82-48b1-b69a-68ddcfd3bea0"}}
[task 2023-10-18T08:07:36.743Z] 08:07:36     INFO - GECKO(8046) | 1697616453042	RemoteAgent	DEBUG	CDPConnection de28491c-c317-4057-bcce-f4a9def7216c <- {"method":"Target.targetDestroyed","params":{"targetId":"5323bac6-bb82-48b1-b69a-68ddcfd3bea0"}}
[task 2023-10-18T08:07:36.746Z] 08:07:36     INFO - GECKO(8046) | 1697616453042	RemoteAgent	DEBUG	CDPConnection 6f360c6e-4e76-4719-b03a-6a27dcc0929d <- {"method":"Target.targetDestroyed","params":{"targetId":"5323bac6-bb82-48b1-b69a-68ddcfd3bea0"}}
[task 2023-10-18T08:07:36.747Z] 08:07:36     INFO - CDP client closed
[task 2023-10-18T08:07:36.750Z] 08:07:36     INFO - Leaving test bound eventWhenNavigatingWithNestedFrames
[task 2023-10-18T08:07:36.752Z] 08:07:36     INFO - GECKO(8046) | MEMORY STAT | vsize 3284MB | residentFast 578MB | heapAllocated 286MB
[task 2023-10-18T08:07:36.759Z] 08:07:36     INFO - TEST-OK | remote/cdp/test/browser/page/browser_domContentEventFired.js | took 8376ms

Comment 1

[Henrik Skupin [:whimboo][⌚️UTC+2]]

The failure here is on Linux with Wayland enabled.

I really wonder why for this test the event that our CDP implementation sends out has a timestamp that is outside of the possible range. It's not something that we have seen before:

Timestamp 1697616453.232 in expected range [1697616453.101 - 1697616452.987]

The related code here is at:
https://searchfox.org/mozilla-central/rev/ac497ae160e664617e2f4286cdce3b03ef912d90/remote/cdp/test/browser/page/browser_domContentEventFired.js#76-79,90-94

Here we create a timestamp before and after the event has been received, which basically means that the timestamp of the event should be in that range. But with emitting the Page.domContentEventFired event from the content process the timestamp is off.

For now lets observe the bug and see how often it happens.

Comment 2

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 2

Platform and build breakdown:

• linux2204-64-wayland: 2
  • opt: 1
  • debug: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1859720&startday=2023-10-16&endday=2023-10-22&tree=all

Comment 3

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• linux2204-64-wayland: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1859720&startday=2023-10-23&endday=2023-10-29&tree=all

Comment 4

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• linux2204-64-wayland: 1
  • opt: 1

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

Comment 5

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-central: 1

Platform and build breakdown:

• linux2204-64-wayland: 1
  • debug: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1859720&startday=2023-11-13&endday=2023-11-19&tree=all

Comment 6

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-beta: 1

Platform and build breakdown:

• linux2204-64-wayland-shippable: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1859720&startday=2023-11-20&endday=2023-11-26&tree=all

Comment 7

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-release: 1

Platform and build breakdown:

• linux2204-64-wayland: 1
  • debug: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1859720&startday=2023-11-27&endday=2023-12-03&tree=all

Comment 8

[Intermittent Failures Robot]

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

Repository breakdown:

• try: 1
• mozilla-central: 1

Platform and build breakdown:

• linux2204-64-wayland-shippable: 2
  • opt: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1859720&startday=2023-12-11&endday=2023-12-17&tree=all

Comment 9

[Henrik Skupin [:whimboo][⌚️UTC+2]]

We stopped running the remote browser chrome tests on Wayland due to the unstable worker setup. Once we can re-enable these failures should not appear anymore.