Closed Bug 1923469 Opened 1 year ago Closed 17 days ago

Frequent beta/esr140 /webrtc/RTCPeerConnection-getStats-timestamp.https.html | RTCRemoteInboundRtpStats.timestamp is expressed as Performance time - assert_less_than_equal: timestamp < t1 expected a number less than or equal to x but got x

Categories

(Core :: WebRTC, defect)

defect

Tracking

()

RESOLVED FIXED
140 Branch
Tracking Status
firefox-esr140 150.0.2+ fixed

People

(Reporter: intermittent-bug-filer, Assigned: RyanVM)

Details

(Keywords: intermittent-failure, intermittent-testcase, Whiteboard: [stockwell disable-recommended])

Attachments

(1 file, 1 obsolete file)

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


[task 2024-10-08T18:28:31.894Z] 18:28:31     INFO - TEST-PASS | /webrtc/RTCPeerConnection-getStats-timestamp.https.html | RTCStats.timestamp is expressed as Performance time 
[task 2024-10-08T18:28:31.894Z] 18:28:31     INFO - TEST-UNEXPECTED-FAIL | /webrtc/RTCPeerConnection-getStats-timestamp.https.html | RTCRemoteInboundRtpStats.timestamp is expressed as Performance time - assert_less_than_equal: expected a number less than or equal to 1728412111883.46 but got 1728412111883.48
[task 2024-10-08T18:28:31.894Z] 18:28:31     INFO - @https://web-platform.test:8443/webrtc/RTCPeerConnection-getStats-timestamp.https.html:67:25
[task 2024-10-08T18:28:31.895Z] 18:28:31     INFO - TEST-OK | /webrtc/RTCPeerConnection-getStats-timestamp.https.html | took 1824ms
[task 2024-10-08T18:28:31.897Z] 18:28:31     INFO - PID 7700 | 1728412111896	Marionette	INFO	Stopped listening on port 64386
[task 2024-10-08T18:28:31.964Z] 18:28:31     INFO - PID 7700 | [Child 8864: Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2526: Close: Closing PeerConnectionImpl {02da815d-f411-42eb-b73b-a9933b6b9066}; ending call
[task 2024-10-08T18:28:31.966Z] 18:28:31     INFO - PID 7700 | [Child 8864: Main Thread]: I/jsep [{02da815d-f411-42eb-b73b-a9933b6b9066} 1728412110542000 (id=195421011969 url=https://web-platform.test:8443/webrtc/RTCPeerConnection-getStats-timestamp.https.html)]: stable -> closed
[task 2024-10-08T18:28:31.967Z] 18:28:31     INFO - PID 7700 | (generic/EMERG) Error in recvfrom: -5961
[task 2024-10-08T18:28:32.026Z] 18:28:32     INFO - PID 7700 | [Socket 684: Socket Thread]: I/mtransport NrIceCtx(PC:{35e31a2d-1bf9-488f-9270-af0749a3d24c} 1728412110541000 (id=195421011969 url=https://web-platform.test:8443/webrtc/RTCPeerConnection-getStats-timestamp.https.html)): Destroy
[task 2024-10-08T18:28:32.027Z] 18:28:32     INFO - PID 7700 | [Socket 684: Socket Thread]: I/mtransport NrIceCtx(PC:{02da815d-f411-42eb-b73b-a9933b6b9066} 1728412110542000 (id=195421011969 url=https://web-platform.test:8443/webrtc/RTCPeerConnection-getStats-timestamp.https.html)): Destroy
[task 2024-10-08T18:28:32.198Z] 18:28:32     INFO - Browser exited with return code 572
[task 2024-10-08T18:28:32.201Z] 18:28:32     INFO - Closing logging queue
[task 2024-10-08T18:28:32.201Z] 18:28:32     INFO - queue closed
[task 2024-10-08T18:28:32.273Z] 18:28:32     INFO - Application command: D:\task_172840839544847\build\application\firefox\firefox.exe -marionette about:blank --wait-for-browser -profile C:\Users\task_172840839544847\AppData\Local\Temp\tmp7g7ptxwe
[task 2024-10-08T18:28:32.281Z] 18:28:32     INFO - PID 3584 | 1728411963678	Marionette	INFO	Marionette enabled
[task 2024-10-08T18:28:32.282Z] 18:28:32     INFO - PID 3584 | 1728411963781	Marionette	INFO	Listening on port 64418
[task 2024-10-08T18:28:32.282Z] 18:28:32     INFO - PID 3584 | [ERROR error_support::handling] suggest-unexpected: Error from Remote Settings: Error parsing URL: relative URL with a cannot-be-a-base base
[task 2024-10-08T18:28:32.283Z] 18:28:32     INFO - PID 3584 | console.error: URLBar - QuickSuggest.SuggestBackendRust: "Ingest error for Amo: Error from Remote Settings: Error parsing URL: relative URL with a cannot-be-a-base base"
[task 2024-10-08T18:28:32.284Z] 18:28:32     INFO - PID 3584 | [ERROR error_support::handling] suggest-unexpected: Error from Remote Settings: Error parsing URL: relative URL with a cannot-be-a-base base
[task 2024-10-08T18:28:32.285Z] 18:28:32     INFO - PID 3584 | console.error: URLBar - QuickSuggest.SuggestBackendRust: "Ingest error for Amp: Error from Remote Settings: Error parsing URL: relative URL with a cannot-be-a-base base"
[task 2024-10-08T18:28:32.286Z] 18:28:32     INFO - PID 3584 | [ERROR error_support::handling] suggest-unexpected: Error from Remote Settings: Error parsing URL: relative URL with a cannot-be-a-base base
[task 2024-10-08T18:28:32.287Z] 18:28:32     INFO - PID 3584 | console.error: URLBar - QuickSuggest.SuggestBackendRust: "Ingest error for Wikipedia: Error from Remote Settings: Error parsing URL: relative URL with a cannot-be-a-base base"
[task 2024-10-08T18:28:32.288Z] 18:28:32     INFO - PID 3584 | [ERROR error_support::handling] suggest-unexpected: Error from Remote Settings: Error parsing URL: relative URL with a cannot-be-a-base base
[task 2024-10-08T18:28:32.289Z] 18:28:32     INFO - PID 3584 | console.error: URLBar - QuickSuggest.SuggestBackendRust: "Ingest error for Mdn: Error from Remote Settings: Error parsing URL: relative URL with a cannot-be-a-base base"
[task 2024-10-08T18:28:32.290Z] 18:28:32     INFO - PID 3584 | [ERROR error_support::handling] suggest-unexpected: Error from Remote Settings: Error parsing URL: relative URL with a cannot-be-a-base base
[task 2024-10-08T18:28:32.290Z] 18:28:32     INFO - PID 3584 | console.error: URLBar - QuickSuggest.SuggestBackendRust: "Ingest error for Yelp: Error from Remote Settings: Error parsing URL: relative URL with a cannot-be-a-base base"
[task 2024-10-08T18:28:32.291Z] 18:28:32     INFO - Starting runner
[task 2024-10-08T18:28:33.852Z] 18:28:33     INFO - TEST-START | /webrtc/RTCPeerConnection-getStats.https.html
Summary: Intermittent /webrtc/RTCPeerConnection-getStats-timestamp.https.html | single tracking bug → High frequency /webrtc/RTCPeerConnection-getStats-timestamp.https.html | single tracking bug
Whiteboard: [stockwell disable-recommended]
Summary: High frequency /webrtc/RTCPeerConnection-getStats-timestamp.https.html | single tracking bug → Intermittent /webrtc/RTCPeerConnection-getStats-timestamp.https.html | single tracking bug
Severity: S4 → --
Priority: P5 → --
Summary: Intermittent /webrtc/RTCPeerConnection-getStats-timestamp.https.html | single tracking bug → Frequent beta /webrtc/RTCPeerConnection-getStats-timestamp.https.html | RTCRemoteInboundRtpStats.timestamp is expressed as Performance time - assert_less_than_equal: timestamp < t1 expected a number less than or equal to x but got x

Hi Michael, as the owner of this component, could you please assign this to someone? This has a high failure rate on Windows 11 x86 22H2 WebRender debug and Windows 11 x64 22H2 WebRender debug .
Recent failure log.
Thanks!

Flags: needinfo?(mfroman)
Severity: -- → S2
Flags: needinfo?(mfroman)
Whiteboard: [stockwell disable-recommended] → [stockwell needswork:owner]

We've looked at this a bit, trying to understand why only beta is impacted.

We think the best thing to do here is disable on beta.

Status: NEW → RESOLVED
Closed: 1 year ago
Resolution: --- → INCOMPLETE

dcsctp has internal round-robin logic, so we don't need it in the base class.
If, someday, we have a third DataChannel implementation with a library that
doesn't do round-robin, we could have another base-class to hold the
round-robin logic, but that's kinda unlikely.

Depends on D238876

A patch has been attached on this bug, which was already closed. Filing a separate bug will ensure better tracking. If this was not by mistake and further action is needed, please alert the appropriate party. (Or: if the patch doesn't change behavior -- e.g. landing a test case, or fixing a typo -- then feel free to disregard this message)

Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 1 year ago1 year ago
Resolution: --- → INCOMPLETE
No longer blocks: webrtc-triage

Comment on attachment 9467283 [details]
WIP: Bug 1923469: Move usrsctp-specific and round-robin logic into a subclass.

Revision D238877 was moved to bug 1927886. Setting attachment 9467283 [details] to obsolete.

Attachment #9467283 - Attachment is obsolete: true
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Severity: S2 → S3
Summary: Frequent beta /webrtc/RTCPeerConnection-getStats-timestamp.https.html | RTCRemoteInboundRtpStats.timestamp is expressed as Performance time - assert_less_than_equal: timestamp < t1 expected a number less than or equal to x but got x → Frequent beta/esr140 /webrtc/RTCPeerConnection-getStats-timestamp.https.html | RTCRemoteInboundRtpStats.timestamp is expressed as Performance time - assert_less_than_equal: timestamp < t1 expected a number less than or equal to x but got x
Assignee: nobody → ryanvm
Attachment #9572727 - Flags: approval-mozilla-esr140?
Attachment #9572727 - Attachment description: Bug 1923469 - Mark RTCRemoteInboundRtpStats.timestamp subtest as intermittent on Windows debug. r?Aryx → Bug 1923469 - Mark RTCRemoteInboundRtpStats.timestamp subtest as intermittent on Windows. r?Aryx
Attachment #9572727 - Flags: approval-mozilla-esr140? → approval-mozilla-esr140+
Status: REOPENED → RESOLVED
Closed: 1 year ago17 days ago
Resolution: --- → FIXED
Target Milestone: --- → 140 Branch
QA Whiteboard: [qa-triage-done-c152/b151]
You need to log in before you can comment on or make changes to this bug.

Attachment

General

Created:
Updated:
Size: