1632501 - Intermittent dom/media/tests/mochitest/test_peerConnection_localReofferRollback.html | Error in test execution: Error: Element _local_{9281520c-a844-49f1-9322-ccb735103966} should progress currentTime timeout/<..>

Status: RESOLVED INCOMPLETE

(Core :: WebRTC, defect, P5)

Description

[Treeherder Bug Filer]

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

---

[task 2020-04-23T11:07:40.097Z] 11:07:40 INFO - TEST-PASS | dom/media/tests/mochitest/test_peerConnection_localReofferRollback.html | RTP flowing for audio track {fa13f8ba-2970-464f-b709-4d4e065800bc}
[task 2020-04-23T11:07:40.098Z] 11:07:40 INFO - Checking for stats in [["9e2fff2e",{"id":"9e2fff2e","timestamp":1587640000315,"type":"candidate-pair","bytesReceived":0,"bytesSent":0,"lastPacketReceivedTimestamp":0,"lastPacketSentTimestamp":0,"localCandidateId":"8af5cb83","nominated":false,"priority":9115005270282338000,"readable":true,"remoteCandidateId":"a2a021cc","selected":false,"state":"cancelled","transportId":"transport_0","writable":true}],["2dada834",{"id":"2dada834","timestamp":1587640000315,"type":"candidate-pair","bytesReceived":1181,"bytesSent":1210,"lastPacketReceivedTimestamp":347211711811,"lastPacketSentTimestamp":347211711811,"localCandidateId":"8af5cb83","nominated":true,"priority":7962083765675491000,"readable":true,"remoteCandidateId":"85813aea","selected":true,"state":"succeeded","transportId":"transport_0","writable":true}],["8af5cb83",{"id":"8af5cb83","timestamp":1587640000315,"type":"local-candidate","address":"0484ce07-2e10-4af7-9dd1-7000b1eda937.local","candidateType":"host","port":58453,"priority":2122252543,"protocol":"udp"}],["70f53e94",{"id":"70f53e94","timestamp":1587640000315,"type":"local-candidate","address":"0484ce07-2e10-4af7-9dd1-7000b1eda937.local","candidateType":"host","port":49383,"priority":2105524479,"protocol":"tcp"}],["85813aea",{"id":"85813aea","timestamp":1587640000315,"type":"remote-candidate","address":"(redacted)","candidateType":"prflx","port":58456,"priority":1853817087,"protocol":"udp"}],["a2a021cc",{"id":"a2a021cc","timestamp":1587640000315,"type":"remote-candidate","address":"2fdb3ae0-5f2c-460d-a43a-6728776f28cb.local","candidateType":"host","port":58456,"priority":2122252543,"protocol":"udp"}],["ca6ca122",{"id":"ca6ca122","timestamp":1587640000315,"type":"remote-candidate","address":"2fdb3ae0-5f2c-460d-a43a-6728776f28cb.local","candidateType":"host","port":9,"priority":2105524479,"protocol":"tcp"}],["1311a8dd",{"id":"1311a8dd","timestamp":1587640000315,"type":"outbound-rtp","kind":"audio","mediaType":"audio","ssrc":1100057909,"bytesSent":289,"packetsSent":1,"nackCount":0}]] for audio track {9281520c-a844-49f1-9322-ccb735103966}retry number 1
[task 2020-04-23T11:07:40.098Z] 11:07:40 INFO - Should have RTP stats for track {9281520c-a844-49f1-9322-ccb735103966}
[task 2020-04-23T11:07:40.098Z] 11:07:40 INFO - RTP stats: {"id":"1311a8dd","timestamp":1587640000315,"type":"outbound-rtp","kind":"audio","mediaType":"audio","ssrc":1100057909,"bytesSent":289,"packetsSent":1,"nackCount":0}
[task 2020-04-23T11:07:40.098Z] 11:07:40 INFO - Track {9281520c-a844-49f1-9322-ccb735103966} has 1 outbound-rtp RTP packets.
[task 2020-04-23T11:07:40.098Z] 11:07:40 INFO - TEST-PASS | dom/media/tests/mochitest/test_peerConnection_localReofferRollback.html | RTP flowing for audio track {9281520c-a844-49f1-9322-ccb735103966}
[task 2020-04-23T11:07:40.098Z] 11:07:40 INFO - Buffered messages finished
[task 2020-04-23T11:07:40.098Z] 11:07:40 INFO - TEST-UNEXPECTED-FAIL | dom/media/tests/mochitest/test_peerConnection_localReofferRollback.html | Error in test execution: Error: Element local{9281520c-a844-49f1-9322-ccb735103966} should progress currentTime timeout/<@https://example.com/tests/dom/media/tests/mochitest/head.js:657:42 ... promise callbacktimeout@https://example.com/tests/dom/media/tests/mochitest/head.js:657:16 ... waitForMediaElementFlow@https://example.com/tests/dom/media/tests/mochitest/pc.js:1778:35 ... waitForMediaFlow/<@https://example.com/tests/dom/media/tests/mochitest/pc.js:1893:16 ... waitForMediaFlow@https://example.com/tests/dom/media/tests/mochitest/pc.js:1892:33 ... PC_LOCAL_WAIT_FOR_MEDIA_FLOW@https://example.com/tests/dom/media/tests/mochitest/templates.js:513:25 ... execute/</<@https://example.com/tests/dom/media/tests/mochitest/head.js:949:32 ...
[task 2020-04-23T11:07:40.098Z] 11:07:40 INFO - SimpleTest.ok@https://example.com/tests/SimpleTest/SimpleTest.js:299:16
[task 2020-04-23T11:07:40.098Z] 11:07:40 INFO - execute/<@https://example.com/tests/dom/media/tests/mochitest/head.js:953:11
[task 2020-04-23T11:07:40.098Z] 11:07:40 INFO - promise callbackexecute@https://example.com/tests/dom/media/tests/mochitest/head.js:952:8
[task 2020-04-23T11:07:40.098Z] 11:07:40 INFO - PeerConnectionTest.prototype.run@https://example.com/tests/dom/media/tests/mochitest/pc.js:568:6
[task 2020-04-23T11:07:40.099Z] 11:07:40 INFO - @https://example.com/tests/dom/media/tests/mochitest/test_peerConnection_localReofferRollback.html:54:10
[task 2020-04-23T11:07:40.099Z] 11:07:40 INFO - runNetworkTest/<@https://example.com/tests/dom/media/tests/mochitest/pc.js:2547:11
[task 2020-04-23T11:07:40.099Z] 11:07:40 INFO - asyncrunTestWhenReady/<@https://example.com/tests/dom/media/tests/mochitest/head.js:497:30
[task 2020-04-23T11:07:40.099Z] 11:07:40 INFO - promise callbackrunTestWhenReady@https://example.com/tests/dom/media/tests/mochitest/head.js:497:6
[task 2020-04-23T11:07:40.099Z] 11:07:40 INFO - runNetworkTest@https://example.com/tests/dom/media/tests/mochitest/pc.js:2528:9
[task 2020-04-23T11:07:40.099Z] 11:07:40 INFO - async*@https://example.com/tests/dom/media/tests/mochitest/test_peerConnection_localReofferRollback.html:15:17
[task 2020-04-23T11:07:40.099Z] 11:07:40 INFO - TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_localReofferRollback.html | The author of the test has indicated that flaky timeouts are expected. Reason: WebRTC inherently depends on timeouts
[task 2020-04-23T11:07:40.099Z] 11:07:40 INFO - Closing peer connections

Comment 1

[Intermittent Failures Robot]

1 failures in 5582 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=1632501&startday=2020-04-20&endday=2020-04-26&tree=all

Comment 2

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

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

Comment 3

[Alexandru Michis [:malexandru]]

Recent failure log: https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=306892742&repo=mozilla-central&lineNumber=35323

Comment 4

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-central: 1

Platform breakdown:

• windows10-64-qr: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1632501&startday=2020-06-15&endday=2020-06-21&tree=all

Comment 5

[Intermittent Failures Robot]

1 failures in 5265 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=1632501&startday=2020-07-06&endday=2020-07-12&tree=all

Comment 6

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

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

Comment 7

[Cristian Brindusan [:cbrindusan]]

New occurrence:
https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=314520952&repo=mozilla-central&lineNumber=33401

Comment 8

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-central: 1

Platform breakdown:

• windows10-64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1632501&startday=2020-08-31&endday=2020-09-06&tree=all

Comment 9

[Intermittent Failures Robot]

1 failures in 4195 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=1632501&startday=2020-09-28&endday=2020-10-04&tree=all

Comment 10

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

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

Comment 11

[Alexandru Michis [:malexandru]]

Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=338394483&repo=autoland

Comment 12

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• windows10-64-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1632501&startday=2021-04-26&endday=2021-05-02&tree=all

Comment 13

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

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