Closed Bug 1710829 Opened 5 years ago Closed 1 year ago

Intermittent dom/media/webrtc/tests/mochitests/<test_name>| Error in test execution: Error: Checking stats for track {...} timed out after 30000 ms _waitForRtpFlow@https://example.com/tests/dom/media/webrtc/tests/mochitests/

Categories

(Core :: WebRTC: Audio/Video, defect, P5)

defect

Tracking

()

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

References

Details

(Keywords: intermittent-failure)

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


INFO - TEST-FAIL | dom/media/webrtc/tests/mochitests/test_peerConnection_remoteRollback.html | The author of the test has indicated that flaky timeouts are expected.  Reason: WebRTC inherently depends on timeouts 
[task 2021-05-12T11:16:45.853Z] 11:16:45     INFO - Buffered messages logged at 11:16:45
[task 2021-05-12T11:16:45.853Z] 11:16:45     INFO - Checking inbound-rtp for audio track {af922dbf-4a32-414b-bdd2-d459b0f3e2e0} try 59
[task 2021-05-12T11:16:45.853Z] 11:16:45     INFO - Checking outbound-rtp for audio track {38c31c30-ba50-4fd8-ab06-515c2ae17b36} try 59
[task 2021-05-12T11:16:45.854Z] 11:16:45     INFO - Track {af922dbf-4a32-414b-bdd2-d459b0f3e2e0} has 0 packetsReceived.
[task 2021-05-12T11:16:45.854Z] 11:16:45     INFO - TEST-FAIL | dom/media/webrtc/tests/mochitests/test_peerConnection_remoteRollback.html | The author of the test has indicated that flaky timeouts are expected.  Reason: WebRTC inherently depends on timeouts 
[task 2021-05-12T11:16:45.855Z] 11:16:45     INFO - Track {38c31c30-ba50-4fd8-ab06-515c2ae17b36} has 0 packetsSent.
[task 2021-05-12T11:16:45.855Z] 11:16:45     INFO - TEST-FAIL | dom/media/webrtc/tests/mochitests/test_peerConnection_remoteRollback.html | The author of the test has indicated that flaky timeouts are expected.  Reason: WebRTC inherently depends on timeouts 
[task 2021-05-12T11:16:45.855Z] 11:16:45     INFO - Buffered messages finished
[task 2021-05-12T11:16:45.855Z] 11:16:45     INFO - TEST-UNEXPECTED-FAIL | dom/media/webrtc/tests/mochitests/test_peerConnection_remoteRollback.html | Error in test execution: Error: Checking stats for track {af922dbf-4a32-414b-bdd2-d459b0f3e2e0} timed out after 30000 ms _waitForRtpFlow@https://example.com/tests/dom/media/webrtc/tests/mochitests/pc.js:1808:11 ...  
[task 2021-05-12T11:16:45.855Z] 11:16:45     INFO - SimpleTest.ok@https://example.com/tests/SimpleTest/SimpleTest.js:417:16
[task 2021-05-12T11:16:45.856Z] 11:16:45     INFO - execute/<@https://example.com/tests/dom/media/webrtc/tests/mochitests/head.js:958:11
[task 2021-05-12T11:16:45.856Z] 11:16:45     INFO - TEST-FAIL | dom/media/webrtc/tests/mochitests/test_peerConnection_remoteRollback.html | The author of the test has indicated that flaky timeouts are expected.  Reason: WebRTC inherently depends on timeouts 
[task 2021-05-12T11:16:45.856Z] 11:16:45     INFO - Closing peer connections
[task 2021-05-12T11:16:45.857Z] 11:16:45     INFO - Waiting for track {af922dbf-4a32-414b-bdd2-d459b0f3e2e0} (audio) to end.
[task 2021-05-12T11:16:45.857Z] 11:16:45     INFO - TEST-FAIL | dom/media/webrtc/tests/mochitests/test_peerConnection_remoteRollback.html | The author of the test has indicated that flaky timeouts are expected.  Reason: WebRTC inherently depends on timeouts 
[task 2021-05-12T11:16:45.858Z] 11:16:45     INFO - GECKO(9972) | [Child 4300: Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2109: CloseInt: Closing PeerConnectionImpl {276d89e1-1429-430e-9e5b-5e3a29529d74}; ending call
[task 2021-05-12T11:16:45.858Z] 11:16:45     INFO - GECKO(9972) | [Child 4300: Main Thread]: I/jsep [{276d89e1-1429-430e-9e5b-5e3a29529d74} 1620818175088000 (id=2147483968 url=https://example.com/tests/dom/media/webrtc/tests/moc]: stable -> closed
[task 2021-05-12T11:16:45.859Z] 11:16:45     INFO - PeerConnectionWrapper (pcLocal): Closed connection.
[task 2021-05-12T11:16:45.859Z] 11:16:45     INFO - Waiting for track {2d9e633a-cd5c-44c5-8908-8cd5a4464cc5} (audio) to end.
[task 2021-05-12T11:16:45.860Z] 11:16:45     INFO - TEST-FAIL | dom/media/webrtc/tests/mochitests/test_peerConnection_remoteRollback.html | The author of the test has indicated that flaky timeouts are expected.  Reason: WebRTC inherently depends on timeouts 
[task 2021-05-12T11:16:45.860Z] 11:16:45     INFO - GECKO(9972) | [Child 4300: Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2109: CloseInt: Closing PeerConnectionImpl {1bb523d0-25c5-4861-928a-3d0d50a95fdd}; ending call
[task 2021-05-12T11:16:45.861Z] 11:16:45     INFO - GECKO(9972) | [Child 4300: Main Thread]: I/jsep [{1bb523d0-25c5-4861-928a-3d0d50a95fdd} 1620818175090000 (id=2147483968 url=https://example.com/tests/dom/media/webrtc/tests/moc]: stable -> closed
[task 2021-05-12T11:16:45.861Z] 11:16:45     INFO - PeerConnectionWrapper (pcRemote): Closed connection.
[task 2021-05-12T11:16:45.862Z] 11:16:45     INFO - TEST-FAIL | dom/media/webrtc/tests/mochitests/test_peerConnection_remoteRollback.html | The author of the test has indicated that flaky timeouts are expected.  Reason: WebRTC inherently depends on timeouts 
[task 2021-05-12T11:16:45.862Z] 11:16:45     INFO - TEST-PASS | dom/media/webrtc/tests/mochitests/test_peerConnection_remoteRollback.html | Event target should be the correct track 
[task 2021-05-12T11:16:45.863Z] 11:16:45     INFO - PeerConnectionWrapper (pcLocal) ended fired for track {af922dbf-4a32-414b-bdd2-d459b0f3e2e0}
[task 2021-05-12T11:16:45.863Z] 11:16:45     INFO - TEST-PASS | dom/media/webrtc/tests/mochitests/test_peerConnection_remoteRollback.html | Event target should be the correct track 
[task 2021-05-12T11:16:45.863Z] 11:16:45     INFO - PeerConnectionWrapper (pcRemote) ended fired for track {2d9e633a-cd5c-44c5-8908-8cd5a4464cc5}
[task 2021-05-12T11:16:45.864Z] 11:16:45     INFO - GECKO(9972) | MEMORY STAT | vsize 697MB | vsizeMaxContiguous 1293MB | residentFast 110MB | heapAllocated 22MB
[task 2021-05-12T11:16:45.864Z] 11:16:45     INFO - TEST-OK | dom/media/webrtc/tests/mochitests/test_peerConnection_remoteRollback.html | took 30814ms
[task 2021-05-12T11:16:45.865Z] 11:16:45     INFO - TEST-START | dom/media/webrtc/tests/mochitests/test_peerConnection_removeAudioTrack.html```

Oh wow. Yes that's a good idea. How is that best done?

It looks like there's an uptick here overall but it's hard to tell across all these different bugs.

Flags: needinfo?(jib)
Summary: Intermittent dom/media/webrtc/tests/mochitests/test_peerConnection_remoteRollback.html | Error in test execution: Error: Checking stats for track {...} timed out after 30000 ms _waitForRtpFlow@https://example.com/tests/dom/media/webrtc/tests/mochitests/pc → Intermittent dom/media/webrtc/tests/mochitests/<test_name>| Error in test execution: Error: Checking stats for track {...} timed out after 30000 ms _waitForRtpFlow@https://example.com/tests/dom/media/webrtc/tests/mochitests/

(In reply to Jan-Ivar Bruaroey [:jib] (needinfo? me) from comment #2)

Oh wow. Yes that's a good idea. How is that best done?

It looks like there's an uptick here overall but it's hard to tell across all these different bugs.

I just made this one the general one, since all of them were tests in dom/media/webrtc/tests/mochitests and all timed out after 30000 ms _waitForRtpFlow.

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