Closed Bug 1456758 Opened 7 years ago Closed 6 years ago

Intermittent dom/media/tests/mochitest/test_peerConnection_basicAudioDynamicPtMissingRtpmap.html | Error in test execution: Error: Timeout checking for stats for track {63277827-a21a-494e-b895-f872c5590e4f} after at least30000ms

Categories

(Core :: WebRTC, defect, P5)

defect

Tracking

()

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

Filed by: archaeopteryx [at] coole-files.de https://treeherder.mozilla.org/logviewer.html#?job_id=175282463&repo=autoland https://queue.taskcluster.net/v1/task/Hm2I_RkLSAaK9BnEBOhGtA/runs/0/artifacts/public/logs/live_backing.log 09:31:38 INFO - 1612 INFO TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_basicAudioDynamicPtMissingRtpmap.html | The author of the test has indicated that flaky timeouts are expected. Reason: WebRTC inherently depends on timeouts 09:31:38 INFO - 1613 INFO Checking for stats in {"outbound_rtp_audio_0":{"id":"outbound_rtp_audio_0","timestamp":1524562297580,"type":"outboundrtp","isRemote":false,"mediaType":"audio","nackCount":0,"remoteId":"","ssrc":"1595231551","bytesSent":0,"packetsSent":0},"M/zN":{"id":"M/zN","timestamp":1524562297580,"type":"candidatepair","bytesReceived":771,"bytesSent":791,"componentId":1,"lastPacketReceivedTimestamp":666136502,"lastPacketSentTimestamp":666136507,"localCandidateId":"TVA/","nominated":true,"priority":9115005270282338000,"readable":true,"remoteCandidateId":"FHem","selected":true,"state":"succeeded","transportId":"0-1524562265519000 (id=4294967498 url=http://mochi.test:8888/tests/dom/media/tests/mochitest/test_peerConnection_basicAudioDynami aLevel=0","writable":true},"TVA/":{"id":"TVA/","timestamp":1524562297580,"type":"localcandidate","candidateType":"host","componentId":"0-1524562265519000 (id=4294967498 url=http://mochi.test:8888/tests/dom/media/tests/mochitest/test_peerConnection_basicAudioDynami aLevel=0","ipAddress":"10.144.30.130","mozLocalTransport":"udp","portNumber":59084,"transport":"udp"},"bPpq":{"id":"bPpq","timestamp":1524562297580,"type":"localcandidate","candidateType":"host","componentId":"0-1524562265519000 (id=4294967498 url=http://mochi.test:8888/tests/dom/media/tests/mochitest/test_peerConnection_basicAudioDynami aLevel=0","ipAddress":"2001:0:9d38:953c:2864:3779:dd26:9390","mozLocalTransport":"udp","portNumber":59083,"transport":"udp"},"xD/t":{"id":"xD/t","timestamp":1524562297580,"type":"localcandidate","candidateType":"host","componentId":"0-1524562265519000 (id=4294967498 url=http://mochi.test:8888/tests/dom/media/tests/mochitest/test_peerConnection_basicAudioDynami aLevel=0","ipAddress":"10.144.30.130","mozLocalTransport":"tcp","portNumber":49696,"transport":"tcp"},"XzFb":{"id":"XzFb","timestamp":1524562297580,"type":"localcandidate","candidateType":"host","componentId":"0-1524562265519000 (id=4294967498 url=http://mochi.test:8888/tests/dom/media/tests/mochitest/test_peerConnection_basicAudioDynami aLevel=0","ipAddress":"2001:0:9d38:953c:2864:3779:dd26:9390","mozLocalTransport":"tcp","portNumber":49379,"transport":"tcp"},"FHem":{"id":"FHem","timestamp":1524562297580,"type":"remotecandidate","candidateType":"host","componentId":"0-1524562265519000 (id=4294967498 url=http://mochi.test:8888/tests/dom/media/tests/mochitest/test_peerConnection_basicAudioDynami aLevel=0","ipAddress":"10.144.30.130","portNumber":59088,"transport":"udp"}} for audio track {79d40543-f112-40a3-9fcd-49e5616fe14a}, retry number 60 09:31:38 INFO - 1614 INFO Should have RTP stats for track {79d40543-f112-40a3-9fcd-49e5616fe14a} 09:31:38 INFO - 1615 INFO RTP stats: {"id":"outbound_rtp_audio_0","timestamp":1524562297580,"type":"outbound-rtp","isRemote":false,"mediaType":"audio","nackCount":0,"remoteId":"","ssrc":"1595231551","bytesSent":0,"packetsSent":0} 09:31:38 INFO - 1616 INFO Track {79d40543-f112-40a3-9fcd-49e5616fe14a} has 0 outbound-rtp RTP packets. 09:31:38 INFO - 1617 INFO TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_basicAudioDynamicPtMissingRtpmap.html | The author of the test has indicated that flaky timeouts are expected. Reason: WebRTC inherently depends on timeouts 09:31:38 INFO - Buffered messages finished 09:31:38 ERROR - 1618 INFO TEST-UNEXPECTED-FAIL | dom/media/tests/mochitest/test_peerConnection_basicAudioDynamicPtMissingRtpmap.html | Error in test execution: Error: Timeout checking for stats for track {63277827-a21a-494e-b895-f872c5590e4f} after at least30000ms waitForRtpFlow@http://mochi.test:8888/tests/dom/media/tests/mochitest/pc.js:1555:11 ... async*waitForMediaFlow/<@http://mochi.test:8888/tests/dom/media/tests/mochitest/pc.js:1607:58 ... waitForMediaFlow@http://mochi.test:8888/tests/dom/media/tests/mochitest/pc.js:1607:7 ... PC_LOCAL_WAIT_FOR_MEDIA_FLOW@http://mochi.test:8888/tests/dom/media/tests/mochitest/templates.js:374:12 ... execute/</<@http://mochi.test:8888/tests/dom/media/tests/mochitest/head.js:854:31 ... promise callback*execute/<@http://mochi.test:8888/tests/dom/media/tests/mochitest/head.js:852:14 ... execute@http://mochi.test:8888/tests/dom/media/tests/mochitest/head.js:847:12 ... PeerConnectionTest.prototype.run@http://mochi.test:8888/tests/dom/media/tests/mochitest/pc.js:485:10 ... @http://mochi.test:8888/tests/dom/media/tests/mochitest/test_peerConnection_basicAudioDynamicPtMissingRtpmap.html:31:5 ... runNetworkTest/<@http://mochi.test:8888/tests/dom/media/tests/mochitest/pc.js:2214:13 ... async*runTestWhenReady/<@http://mochi.test:8888/tests/dom/media/tests/mochitest/head.js:475:41 ... promise callback*runTestWhenReady@http://mochi.test:8888/tests/dom/media/tests/mochitest/head.js:475:10 ... runNetworkTest@http://mochi.test:8888/tests/dom/media/tests/mochitest/pc.js:2196:9 ... async*@http://mochi.test:8888/tests/dom/media/tests/mochitest/test_peerConnection_basicAudioDynamicPtMissingRtpmap.html:15:3 ... 09:31:38 INFO - execute/<@dom/media/tests/mochitest/head.js:858:14 09:31:38 INFO - promise callback*execute@dom/media/tests/mochitest/head.js:847:12 09:31:38 INFO - PeerConnectionTest.prototype.run@dom/media/tests/mochitest/pc.js:485:10 09:31:38 INFO - @dom/media/tests/mochitest/test_peerConnection_basicAudioDynamicPtMissingRtpmap.html:31:5 09:31:38 INFO - runNetworkTest/<@dom/media/tests/mochitest/pc.js:2214:13 09:31:38 INFO - async*runTestWhenReady/<@dom/media/tests/mochitest/head.js:475:41 09:31:38 INFO - promise callback*runTestWhenReady@dom/media/tests/mochitest/head.js:475:10 09:31:38 INFO - runNetworkTest@dom/media/tests/mochitest/pc.js:2196:9 09:31:38 INFO - async*@dom/media/tests/mochitest/test_peerConnection_basicAudioDynamicPtMissingRtpmap.html:15:3 09:31:38 INFO - 1619 INFO TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_basicAudioDynamicPtMissingRtpmap.html | The author of the test has indicated that flaky timeouts are expected. Reason: WebRTC inherently depends on timeouts
Status: NEW → RESOLVED
Closed: 7 years ago
Resolution: --- → INCOMPLETE
Status: REOPENED → RESOLVED
Closed: 7 years ago6 years ago
Resolution: --- → INCOMPLETE

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

00:16:11 INFO - TEST-START | dom/media/tests/mochitest/test_peerConnection_basicAudioDynamicPtMissingRtpmap.html

00:16:47 INFO - TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_basicAudioDynamicPtMissingRtpmap.html | The author of the test has indicated that flaky timeouts are expected. Reason: WebRTC inherently depends on timeouts
00:16:47 INFO - Checking for stats in [["outbound_rtp_audio_0",{"id":"outbound_rtp_audio_0","timestamp":1551485806441,"type":"outbound-rtp","kind":"audio","mediaType":"audio","nackCount":0,"remoteId":"","ssrc":2903051305,"bytesSent":0,"packetsSent":0}],["C2RO",{"id":"C2RO","timestamp":1551485806441,"type":"candidate-pair","bytesReceived":0,"bytesSent":0,"componentId":1,"lastPacketReceivedTimestamp":0,"lastPacketSentTimestamp":0,"localCandidateId":"wLK1","nominated":false,"priority":9115005270282338000,"readable":true,"remoteCandidateId":"gXd6","selected":false,"state":"cancelled","transportId":"transport_0","writable":true}],["Y/uK",{"id":"Y/uK","timestamp":1551485806441,"type":"candidate-pair","bytesReceived":917,"bytesSent":993,"componentId":1,"lastPacketReceivedTimestamp":311057512917,"lastPacketSentTimestamp":311057515369,"localCandidateId":"wLK1","nominated":true,"priority":7962083765675491000,"readable":true,"remoteCandidateId":"X/xi","selected":true,"state":"succeeded","transportId":"transport_0","writable":true}],["wLK1",{"id":"wLK1","timestamp":1551485806441,"type":"local-candidate","address":"10.145.20.57","candidateType":"host","port":61202,"priority":2122252543,"protocol":"udp"}],["eiwL",{"id":"eiwL","timestamp":1551485806441,"type":"local-candidate","address":"10.145.20.57","candidateType":"host","port":50284,"priority":2105524479,"protocol":"tcp"}],["X/xi",{"id":"X/xi","timestamp":1551485806441,"type":"remote-candidate","address":"10.145.20.57","candidateType":"prflx","port":61206,"priority":1853817087,"protocol":"udp"}],["gXd6",{"id":"gXd6","timestamp":1551485806441,"type":"remote-candidate","address":"10.145.20.57","candidateType":"host","port":61206,"priority":2122252543,"protocol":"udp"}],["Y/Zj",{"id":"Y/Zj","timestamp":1551485806441,"type":"remote-candidate","address":"10.145.20.57","candidateType":"host","port":9,"priority":2105524479,"protocol":"tcp"}]] for audio track {4cffec41-fb5c-431a-988f-e54eb14329bc}retry number 60
00:16:47 INFO - Should have RTP stats for track {4cffec41-fb5c-431a-988f-e54eb14329bc}
00:16:47 INFO - RTP stats: {"id":"outbound_rtp_audio_0","timestamp":1551485806441,"type":"outbound-rtp","kind":"audio","mediaType":"audio","nackCount":0,"remoteId":"","ssrc":2903051305,"bytesSent":0,"packetsSent":0}
00:16:47 INFO - Track {4cffec41-fb5c-431a-988f-e54eb14329bc} has 0 outbound-rtp RTP packets.
00:16:47 INFO - TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_basicAudioDynamicPtMissingRtpmap.html | The author of the test has indicated that flaky timeouts are expected. Reason: WebRTC inherently depends on timeouts
00:16:47 INFO - Buffered messages finished
00:16:47 INFO - TEST-UNEXPECTED-FAIL | dom/media/tests/mochitest/test_peerConnection_basicAudioDynamicPtMissingRtpmap.html | Error in test execution: Error: Timeout checking for stats for track {87f0e3b1-63fc-42cb-bc94-16097a405740} after at least30000ms waitForRtpFlow@http://mochi.test:8888/tests/dom/media/tests/mochitest/pc.js:1582:11 ... asyncwaitForMediaFlow/<@http://mochi.test:8888/tests/dom/media/tests/mochitest/pc.js:1634:63 ... waitForMediaFlow@http://mochi.test:8888/tests/dom/media/tests/mochitest/pc.js:1634:45 ... PC_LOCAL_WAIT_FOR_MEDIA_FLOW@http://mochi.test:8888/tests/dom/media/tests/mochitest/templates.js:372:25 ... execute/</<@http://mochi.test:8888/tests/dom/media/tests/mochitest/head.js:852:31 ...
00:16:47 INFO - SimpleTest.ok@SimpleTest/SimpleTest.js:275:18
00:16:47 INFO - execute/<@dom/media/tests/mochitest/head.js:856:14
00:16:47 INFO - promise callback
execute@dom/media/tests/mochitest/head.js:855:8
00:16:47 INFO - PeerConnectionTest.prototype.run@dom/media/tests/mochitest/pc.js:486:21
00:16:47 INFO - @dom/media/tests/mochitest/test_peerConnection_basicAudioDynamicPtMissingRtpmap.html:31:10
00:16:47 INFO - runNetworkTest/<@dom/media/tests/mochitest/pc.js:2187:13
00:16:47 INFO - asyncrunTestWhenReady/<@dom/media/tests/mochitest/head.js:473:41
00:16:47 INFO - promise callback
runTestWhenReady@dom/media/tests/mochitest/head.js:473:25
00:16:47 INFO - runNetworkTest@dom/media/tests/mochitest/pc.js:2169:9
00:16:47 INFO - async*@dom/media/tests/mochitest/test_peerConnection_basicAudioDynamicPtMissingRtpmap.html:15:3

Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 6 years ago6 years ago
Resolution: --- → INCOMPLETE
Status: REOPENED → RESOLVED
Closed: 6 years ago6 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.