1669457 - Intermittent test_peerConnection_verifyAudioAfterRenegotiation.html | Error in test execution: Error: Element _remote_{<*>} should progress currentTime timeout/<@https://example.com/tests/dom/media/webrtc/tests/mochitests/head.js:633:42 ...

Status: RESOLVED INCOMPLETE

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

Description

[Treeherder Bug Filer]

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

---

...
[task 2020-10-06T09:30:47.002Z] 09:30:47 INFO - TEST-PASS | dom/media/webrtc/tests/mochitests/test_peerConnection_verifyAudioAfterRenegotiation.html | RTP flowing for audio track {264d1781-afb3-4a4b-a8a7-de776a558aca}
[task 2020-10-06T09:30:47.002Z] 09:30:47 INFO - Run step 36: PC_REMOTE_WAIT_FOR_MEDIA_FLOW
[task 2020-10-06T09:30:47.002Z] 09:30:47 INFO - Found transceiver that should be receiving RTP: mid=0 currentDirection=recvonly kind=audio track-id={4a647103-e678-4b80-9324-86d385278f57}
[task 2020-10-06T09:30:47.003Z] 09:30:47 INFO - Checking data flow for element: remote{4a647103-e678-4b80-9324-86d385278f57}
[task 2020-10-06T09:30:47.003Z] 09:30:47 INFO - TEST-PASS | dom/media/webrtc/tests/mochitests/test_peerConnection_verifyAudioAfterRenegotiation.html | Element ended should be the inverse of the MediaStream's active state
[task 2020-10-06T09:30:47.003Z] 09:30:47 INFO - TEST-FAIL | dom/media/webrtc/tests/mochitests/test_peerConnection_verifyAudioAfterRenegotiation.html | The author of the test has indicated that flaky timeouts are expected. Reason: WebRTC inherently depends on timeouts
[task 2020-10-06T09:30:47.003Z] 09:30:47 INFO - _waitForRtpFlow({4a647103-e678-4b80-9324-86d385278f57}, inbound-rtp)
[task 2020-10-06T09:30:47.003Z] 09:30:47 INFO - Checking inbound-rtp for audio track {4a647103-e678-4b80-9324-86d385278f57} try 0
[task 2020-10-06T09:30:47.003Z] 09:30:47 INFO - Element remote{4a647103-e678-4b80-9324-86d385278f57} has enough data.
[task 2020-10-06T09:30:47.003Z] 09:30:47 INFO - Track {4a647103-e678-4b80-9324-86d385278f57} has 10 packetsReceived.
[task 2020-10-06T09:30:47.004Z] 09:30:47 INFO - TEST-PASS | dom/media/webrtc/tests/mochitests/test_peerConnection_verifyAudioAfterRenegotiation.html | RTP flowing for audio track {4a647103-e678-4b80-9324-86d385278f57}
[task 2020-10-06T09:30:47.004Z] 09:30:47 INFO - Buffered messages finished
[task 2020-10-06T09:30:47.004Z] 09:30:47 INFO - TEST-UNEXPECTED-FAIL | dom/media/webrtc/tests/mochitests/test_peerConnection_verifyAudioAfterRenegotiation.html | Error in test execution: Error: Element remote{4a647103-e678-4b80-9324-86d385278f57} should progress currentTime timeout/<@https://example.com/tests/dom/media/webrtc/tests/mochitests/head.js:633:42 ...
[task 2020-10-06T09:30:47.004Z] 09:30:47 INFO - SimpleTest.ok@https://example.com/tests/SimpleTest/SimpleTest.js:417:16
[task 2020-10-06T09:30:47.004Z] 09:30:47 INFO - execute/<@https://example.com/tests/dom/media/webrtc/tests/mochitests/head.js:929:11
[task 2020-10-06T09:30:47.004Z] 09:30:47 INFO - TEST-FAIL | dom/media/webrtc/tests/mochitests/test_peerConnection_verifyAudioAfterRenegotiation.html | The author of the test has indicated that flaky timeouts are expected. Reason: WebRTC inherently depends on timeouts
[task 2020-10-06T09:30:47.004Z] 09:30:47 INFO - Closing peer connections
[task 2020-10-06T09:30:47.004Z] 09:30:47 INFO - Waiting for track {b45f3589-69be-4038-9c49-84bb3db81b97} (audio) to end.
[task 2020-10-06T09:30:47.005Z] 09:30:47 INFO - TEST-FAIL | dom/media/webrtc/tests/mochitests/test_peerConnection_verifyAudioAfterRenegotiation.html | The author of the test has indicated that flaky timeouts are expected. Reason: WebRTC inherently depends on timeouts
[task 2020-10-06T09:30:47.005Z] 09:30:47 INFO - GECKO(8648) | [Child 5340: Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2100: CloseInt: Closing PeerConnectionImpl 9f34076a063a657d; ending call
[task 2020-10-06T09:30:47.005Z] 09:30:47 INFO - GECKO(8648) | [Child 5340: Main Thread]: I/jsep [1601976586096000 (id=2147484291 url=https://example.com/tests/dom/media/webrtc/tests/mochitests/test_peerConnection_verifyAudio]: stable -> closed
[task 2020-10-06T09:30:47.005Z] 09:30:47 INFO - PeerConnectionWrapper (pcLocal): Closed connection.
...

Comment 1

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform breakdown:

• windows10-64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1669457&startday=2020-10-05&endday=2020-10-11&tree=all

Comment 2

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform breakdown:

• windows10-64-qr: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1669457&startday=2020-10-26&endday=2020-11-01&tree=all

Comment 3

[BugBot [:suhaib / :marco/ :calixte]]

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