Closed Bug 1419011 Opened 7 years ago Closed 5 years ago

Intermittent dom/media/tests/mochitest/test_peerConnection_basicVideoVerifyRtpHeaderExtensions.html | number of received ids match sdp ids - got 3, expected 2

Categories

(Firefox for Android Graveyard :: Audio/Video, defect, P5)

Product:
Firefox for Android Graveyard
Component:
Audio/Video
Type:
defect

Tracking

(Not tracked)

Status:
RESOLVED DUPLICATE of bug 1559512

People

(Reporter: intermittent-bug-filer, Unassigned)

References

Details

(Keywords: intermittent-failure) 

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
Status: NEW → RESOLVED
Closed: 6 years ago
Resolution: --- → INCOMPLETE
Recent failure log: https://treeherder.mozilla.org/logviewer.html#?job_id=187346936&repo=mozilla-central&lineNumber=37332

11:35:54     INFO -  1272 INFO TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_basicVideoVerifyRtpHeaderExtensions.html | The author of the test has indicated that flaky timeouts are expected.  Reason: WebRTC inherently depends on timeouts
11:35:54     INFO -  1273 INFO TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_basicVideoVerifyRtpHeaderExtensions.html | The author of the test has indicated that flaky timeouts are expected.  Reason: WebRTC inherently depends on timeouts
11:35:54     INFO -  1274 INFO Found transceiver that should be receiving RTP: mid=sdparta_0 currentDirection=sendrecv kind=video track-id={d10b79a7-9629-49e6-8fb5-13a986659866}
11:35:54     INFO -  1275 INFO waitForRtpFlow({d10b79a7-9629-49e6-8fb5-13a986659866})
11:35:54     INFO -  1276 INFO waitForRtpFlow({1a3f957d-5642-4822-abd2-2596dc46ad21})
11:35:54     INFO -  1277 INFO Element _local_{1a3f957d-5642-4822-abd2-2596dc46ad21} has enough data.
11:35:54     INFO -  1278 INFO Checking for stats in {"inbound_rtp_video_0":{"id":"inbound_rtp_video_0","timestamp":1531222554280,"type":"inboundrtp","bitrateMean":4.94e-322,"bitrateStdDev":1.1676996780127e-311,"firCount":0,"framerateMean":1.6e-322,"framerateStdDev":6.95221088819877e-310,"isRemote":false,"mediaType":"video","nackCount":0,"pliCount":0,"ssrc":"1976564386","bytesReceived":1258,"discardedPackets":0,"framesDecoded":0,"jitter":0,"packetsLost":0,"packetsReceived":3},"rJav":{"id":"rJav","timestamp":1531222554280,"type":"candidatepair","bytesReceived":2163,"bytesSent":796,"componentId":1,"lastPacketReceivedTimestamp":18446744072446042000,"lastPacketSentTimestamp":18446744072446042000,"localCandidateId":"82h/","nominated":true,"priority":9115005270282338000,"readable":true,"remoteCandidateId":"aXqP","selected":true,"state":"succeeded","transportId":"0-1531222553948000 (id=4294967584 url=http://mochi.test:8888/tests/dom/media/tests/mochitest/test_peerConnection_basicVideoVerify aLevel=0","writable":true},"82h/":{"id":"82h/","timestamp":1531222554280,"type":"localcandidate","candidateType":"host","componentId":"0-1531222553948000 (id=4294967584 url=http://mochi.test:8888/tests/dom/media/tests/mochitest/test_peerConnection_basicVideoVerify aLevel=0","ipAddress":"10.143.36.32","mozLocalTransport":"udp","portNumber":49588,"transport":"udp"},"l1G/":{"id":"l1G/","timestamp":1531222554280,"type":"localcandidate","candidateType":"host","componentId":"0-1531222553948000 (id=4294967584 url=http://mochi.test:8888/tests/dom/media/tests/mochitest/test_peerConnection_basicVideoVerify aLevel=0","ipAddress":"2001:0:9d38:90d7:208f:18e6:c948:8bd4","mozLocalTransport":"udp","portNumber":49587,"transport":"udp"},"t9Ps":{"id":"t9Ps","timestamp":1531222554280,"type":"localcandidate","candidateType":"host","componentId":"0-1531222553948000 (id=4294967584 url=http://mochi.test:8888/tests/dom/media/tests/mochitest/test_peerConnection_basicVideoVerify aLevel=0","ipAddress":"10.143.36.32","mozLocalTransport":"tcp","portNumber":50658,"transport":"tcp"},"phmz":{"id":"phmz","timestamp":1531222554280,"type":"localcandidate","candidateType":"host","componentId":"0-1531222553948000 (id=4294967584 url=http://mochi.test:8888/tests/dom/media/tests/mochitest/test_peerConnection_basicVideoVerify aLevel=0","ipAddress":"2001:0:9d38:90d7:208f:18e6:c948:8bd4","mozLocalTransport":"tcp","portNumber":55209,"transport":"tcp"},"aXqP":{"id":"aXqP","timestamp":1531222554280,"type":"remotecandidate","candidateType":"host","componentId":"0-1531222553948000 (id=4294967584 url=http://mochi.test:8888/tests/dom/media/tests/mochitest/test_peerConnection_basicVideoVerify aLevel=0","ipAddress":"10.143.36.32","portNumber":49592,"transport":"udp"}} for video track {d10b79a7-9629-49e6-8fb5-13a986659866}, retry number 0
11:35:54     INFO -  1279 INFO Should have RTP stats for track {d10b79a7-9629-49e6-8fb5-13a986659866}
11:35:54     INFO -  1280 INFO RTP stats: {"id":"inbound_rtp_video_0","timestamp":1531222554280,"type":"inbound-rtp","bitrateMean":4.94e-322,"bitrateStdDev":1.1676996780127e-311,"firCount":0,"framerateMean":1.6e-322,"framerateStdDev":6.95221088819877e-310,"isRemote":false,"mediaType":"video","nackCount":0,"pliCount":0,"ssrc":"1976564386","bytesReceived":1258,"discardedPackets":0,"framesDecoded":0,"jitter":0,"packetsLost":0,"packetsReceived":3}
11:35:54     INFO -  1281 INFO Track {d10b79a7-9629-49e6-8fb5-13a986659866} has 3 inbound-rtp RTP packets.
11:35:54     INFO -  1282 INFO TEST-PASS | dom/media/tests/mochitest/test_peerConnection_basicVideoVerifyRtpHeaderExtensions.html | RTP flowing for video track {d10b79a7-9629-49e6-8fb5-13a986659866}
11:35:54     INFO -  1283 INFO Checking for stats in {"outbound_rtcp_video_0":{"id":"outbound_rtcp_video_0","timestamp":1428967,"type":"inboundrtp","isRemote":true,"mediaType":"video","remoteId":"outbound_rtp_video_0","ssrc":"1446908410","bytesReceived":730,"jitter":0,"packetsLost":0,"packetsReceived":1},"outbound_rtp_video_0":{"id":"outbound_rtp_video_0","timestamp":1531222554286,"type":"outboundrtp","bitrateMean":5.313029819126e-312,"bitrateStdDev":6.95218902368453e-310,"firCount":0,"framerateMean":1.167672550465e-311,"framerateStdDev":5.313029819126e-312,"isRemote":false,"mediaType":"video","nackCount":0,"pliCount":0,"remoteId":"outbound_rtcp_video_0","ssrc":"1446908410","bytesSent":766,"droppedFrames":0,"framesEncoded":0,"packetsSent":1},"rJav":{"id":"rJav","timestamp":1531222554286,"type":"candidatepair","bytesReceived":3195,"bytesSent":1666,"componentId":1,"lastPacketReceivedTimestamp":18446744072446042000,"lastPacketSentTimestamp":18446744072446042000,"localCandidateId":"82h/","nominated":true,"priority":9115005270282338000,"readable":true,"remoteCandidateId":"aXqP","selected":true,"state":"succeeded","transportId":"0-1531222553948000 (id=4294967584 url=http://mochi.test:8888/tests/dom/media/tests/mochitest/test_peerConnection_basicVideoVerify aLevel=0","writable":true},"82h/":{"id":"82h/","timestamp":1531222554286,"type":"localcandidate","candidateType":"host","componentId":"0-1531222553948000 (id=4294967584 url=http://mochi.test:8888/tests/dom/media/tests/mochitest/test_peerConnection_basicVideoVerify aLevel=0","ipAddress":"10.143.36.32","mozLocalTransport":"udp","portNumber":49588,"transport":"udp"},"l1G/":{"id":"l1G/","timestamp":1531222554286,"type":"localcandidate","candidateType":"host","componentId":"0-1531222553948000 (id=4294967584 url=http://mochi.test:8888/tests/dom/media/tests/mochitest/test_peerConnection_basicVideoVerify aLevel=0","ipAddress":"2001:0:9d38:90d7:208f:18e6:c948:8bd4","mozLocalTransport":"udp","portNumber":49587,"transport":"udp"},"t9Ps":{"id":"t9Ps","timestamp":1531222554286,"type":"localcandidate","candidateType":"host","componentId":"0-1531222553948000 (id=4294967584 url=http://mochi.test:8888/tests/dom/media/tests/mochitest/test_peerConnection_basicVideoVerify aLevel=0","ipAddress":"10.143.36.32","mozLocalTransport":"tcp","portNumber":50658,"transport":"tcp"},"phmz":{"id":"phmz","timestamp":1531222554286,"type":"localcandidate","candidateType":"host","componentId":"0-1531222553948000 (id=4294967584 url=http://mochi.test:8888/tests/dom/media/tests/mochitest/test_peerConnection_basicVideoVerify aLevel=0","ipAddress":"2001:0:9d38:90d7:208f:18e6:c948:8bd4","mozLocalTransport":"tcp","portNumber":55209,"transport":"tcp"},"aXqP":{"id":"aXqP","timestamp":1531222554286,"type":"remotecandidate","candidateType":"host","componentId":"0-1531222553948000 (id=4294967584 url=http://mochi.test:8888/tests/dom/media/tests/mochitest/test_peerConnection_basicVideoVerify aLevel=0","ipAddress":"10.143.36.32","portNumber":49592,"transport":"udp"}} for video track {1a3f957d-5642-4822-abd2-2596dc46ad21}, retry number 0
11:35:54     INFO -  1284 INFO Should have RTP stats for track {1a3f957d-5642-4822-abd2-2596dc46ad21}
11:35:54     INFO -  1285 INFO RTP stats: {"id":"outbound_rtp_video_0","timestamp":1531222554286,"type":"outbound-rtp","bitrateMean":5.313029819126e-312,"bitrateStdDev":6.95218902368453e-310,"firCount":0,"framerateMean":1.167672550465e-311,"framerateStdDev":5.313029819126e-312,"isRemote":false,"mediaType":"video","nackCount":0,"pliCount":0,"remoteId":"outbound_rtcp_video_0","ssrc":"1446908410","bytesSent":766,"droppedFrames":0,"framesEncoded":0,"packetsSent":1}
11:35:54     INFO -  1286 INFO Track {1a3f957d-5642-4822-abd2-2596dc46ad21} has 1 outbound-rtp RTP packets.
11:35:54     INFO -  1287 INFO TEST-PASS | dom/media/tests/mochitest/test_peerConnection_basicVideoVerifyRtpHeaderExtensions.html | RTP flowing for video track {1a3f957d-5642-4822-abd2-2596dc46ad21}
11:35:54     INFO -  1288 INFO Element _remote_{d10b79a7-9629-49e6-8fb5-13a986659866} has enough data.
11:35:54     INFO -  1289 INFO Run step 40: PC_REMOTE_CHECK_RTP_HEADER_EXTS_AGAINST_SDP
11:35:54     INFO -  Buffered messages finished
11:35:54    ERROR -  1290 INFO TEST-UNEXPECTED-FAIL | dom/media/tests/mochitest/test_peerConnection_basicVideoVerifyRtpHeaderExtensions.html | number of received ids match sdp ids - got 3, expected 2
11:35:54     INFO -      SimpleTest.is@SimpleTest/SimpleTest.js:312:5
11:35:54     INFO -      PC_REMOTE_CHECK_RTP_HEADER_EXTS_AGAINST_SDP@dom/media/tests/mochitest/test_peerConnection_basicVideoVerifyRtpHeaderExtensions.html:47:9
11:35:54     INFO -      async*execute/</<@dom/media/tests/mochitest/head.js:855:31
11:35:54     INFO -      promise callback*execute/<@dom/media/tests/mochitest/head.js:853:14
11:35:54     INFO -      execute@dom/media/tests/mochitest/head.js:848:12
11:35:54     INFO -      PeerConnectionTest.prototype.run@dom/media/tests/mochitest/pc.js:485:10
11:35:54     INFO -      @dom/media/tests/mochitest/test_peerConnection_basicVideoVerifyRtpHeaderExtensions.html:54:5
11:35:54     INFO -      runNetworkTest/<@dom/media/tests/mochitest/pc.js:2214:13
11:35:54     INFO -      async*runTestWhenReady/<@dom/media/tests/mochitest/head.js:476:41
11:35:54     INFO -      promise callback*runTestWhenReady@dom/media/tests/mochitest/head.js:476:10
11:35:54     INFO -      runNetworkTest@dom/media/tests/mochitest/pc.js:2196:9
11:35:54     INFO -      async*@dom/media/tests/mochitest/test_peerConnection_basicVideoVerifyRtpHeaderExtensions.html:17:3
11:35:54     INFO -  1291 INFO TEST-PASS | dom/media/tests/mochitest/test_peerConnection_basicVideoVerifyRtpHeaderExtensions.html | extension id arrays equivalent
11:35:54     INFO -  1292 INFO Run step 41: PC_REMOTE_WAIT_FOR_MEDIA_FLOW
11:35:54     INFO -  1293 INFO Checking data flow for element: _local_{664fbd82-26e3-4dcc-b567-667cb25b2391}
11:35:54     INFO -  1294 INFO TEST-PASS | dom/media/tests/mochitest/test_peerConnection_basicVideoVerifyRtpHeaderExtensions.html | Element ended should be the inverse of the MediaStream's active state
11:35:54     INFO -  1295 INFO TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_basicVideoVerifyRtpHeaderExtensions.html | The author of the test has indicated that flaky timeouts are expected.  Reason: WebRTC inherently depends on timeouts
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
Status: REOPENED → RESOLVED
Closed: 6 years ago → 6 years ago
Resolution: --- → INCOMPLETE

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup

Status: REOPENED → RESOLVED
Closed: 6 years ago → 5 years ago
Resolution: --- → INCOMPLETE

Recent failure log: https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=242097498&repo=autoland&lineNumber=3021

16:58:25 INFO - 151 INFO TEST-START | dom/media/tests/mochitest/test_peerConnection_basicVideo.html
16:58:25 INFO - 152 INFO TEST-OK | dom/media/tests/mochitest/test_peerConnection_basicVideo.html | took 2980ms
16:58:25 INFO - 153 INFO TEST-START | dom/media/tests/mochitest/test_peerConnection_basicVideoVerifyRtpHeaderExtensions.html
16:58:25 INFO - <snipped 258 output lines - if you need more context, please use SimpleTest.requestCompleteLog() in your test>
16:58:25 INFO - Buffered messages logged at 16:58:20
16:58:25 INFO - 154 INFO PeerConnectionWrapper (pcRemote): onicegatheringstatechange fired, new state is: complete
16:58:25 INFO - 155 INFO pcRemote: iceCandidate = {"candidate":"candidate:0 1 UDP 2122252543 10.7.205.35 49770 typ host","sdpMid":"0","sdpMLineIndex":0,"usernameFragment":"2444d52f"}
16:58:25 INFO - 156 INFO TEST-PASS | dom/media/tests/mochitest/test_peerConnection_basicVideoVerifyRtpHeaderExtensions.html | SDP mid not empty
16:58:25 INFO - 157 INFO TEST-PASS | dom/media/tests/mochitest/test_peerConnection_basicVideoVerifyRtpHeaderExtensions.html | usernameFragment not empty

16:58:25 INFO - 236 INFO TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_basicVideoVerifyRtpHeaderExtensions.html | The author of the test has indicated that flaky timeouts are expected. Reason: WebRTC inherently depends on timeouts
16:58:25 INFO - Buffered messages logged at 16:58:21
16:58:25 INFO - 237 INFO Checking for stats in [["inbound_rtp_video_0",{"id":"inbound_rtp_video_0","timestamp":1556038701203,"type":"inbound-rtp","kind":"video","mediaType":"video","ssrc":0,"discardedPackets":0,"jitter":0,"packetsLost":0,"packetsReceived":0,"bitrateMean":-1.4064692027288192e+82,"bitrateStdDev":-2.9914453477557844e+217,"bytesReceived":0,"firCount":0,"framerateMean":0,"framerateStdDev":2.121995791e-314,"framesDecoded":0,"nackCount":0,"pliCount":0,"remoteId":"inbound_rtcp_video_0"}],["inbound_rtcp_video_0",{"id":"inbound_rtcp_video_0","timestamp":1556038701203,"type":"remote-outbound-rtp","kind":"video","mediaType":"video","ssrc":0,"bytesSent":0,"packetsSent":0,"localId":"inbound_rtp_video_0"}],["UJbC",{"id":"UJbC","timestamp":1556038701203,"type":"candidate-pair","bytesReceived":833,"bytesSent":8186,"componentId":1,"lastPacketReceivedTimestamp":1260540005,"lastPacketSentTimestamp":1260539984,"localCandidateId":"Fn2P","nominated":true,"priority":7962083765675491000,"readable":true,"remoteCandidateId":"8kCu","selected":true,"state":"succeeded","transportId":"transport_0","writable":true}],["Fn2P",{"id":"Fn2P","timestamp":1556038701203,"type":"local-candidate","address":"10.7.205.35","candidateType":"host","port":40482,"priority":2122252543,"protocol":"udp"}],["0BHX",{"id":"0BHX","timestamp":1556038701203,"type":"local-candidate","address":"10.7.205.35","candidateType":"host","port":50819,"priority":2105508095,"protocol":"tcp"}],["2ekU",{"id":"2ekU","timestamp":1556038701203,"type":"local-candidate","address":"10.7.205.35","candidateType":"host","port":54208,"priority":2105524479,"protocol":"tcp"}],["8kCu",{"id":"8kCu","timestamp":1556038701203,"type":"remote-candidate","address":"10.7.205.35","candidateType":"prflx","port":49770,"priority":1853817087,"protocol":"udp"}]] for video track {b26d5f51-8e21-46ca-80d8-7aea905b7763}retry number 1
16:58:25 INFO - 238 INFO Should have RTP stats for track {b26d5f51-8e21-46ca-80d8-7aea905b7763}
16:58:25 INFO - 239 INFO RTP stats: {"id":"inbound_rtp_video_0","timestamp":1556038701203,"type":"inbound-rtp","kind":"video","mediaType":"video","ssrc":0,"discardedPackets":0,"jitter":0,"packetsLost":0,"packetsReceived":0,"bitrateMean":-1.4064692027288192e+82,"bitrateStdDev":-2.9914453477557844e+217,"bytesReceived":0,"firCount":0,"framerateMean":0,"framerateStdDev":2.121995791e-314,"framesDecoded":0,"nackCount":0,"pliCount":0,"remoteId":"inbound_rtcp_video_0"}
16:58:25 INFO - 240 INFO Track {b26d5f51-8e21-46ca-80d8-7aea905b7763} has 0 inbound-rtp RTP packets.
16:58:25 INFO - 241 INFO TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_basicVideoVerifyRtpHeaderExtensions.html | The author of the test has indicated that flaky timeouts are expected. Reason: WebRTC inherently depends on timeouts
16:58:25 INFO - 242 INFO Checking for stats in [["outbound_rtp_video_0",{"id":"outbound_rtp_video_0","timestamp":1556038701221,"type":"outbound-rtp","kind":"video","mediaType":"video","ssrc":1668214667,"bytesSent":6854,"packetsSent":27,"bitrateMean":-1.4783618996577789e-86,"bitrateStdDev":4.0872021456e-314,"droppedFrames":0,"firCount":0,"framerateMean":4.0872021456e-314,"framerateStdDev":-1.3169942692898314e+161,"framesEncoded":0,"nackCount":0,"pliCount":0,"remoteId":""}],["UJbC",{"id":"UJbC","timestamp":1556038701221,"type":"candidate-pair","bytesReceived":833,"bytesSent":8186,"componentId":1,"lastPacketReceivedTimestamp":1260540005,"lastPacketSentTimestamp":1260539984,"localCandidateId":"Fn2P","nominated":true,"priority":7962083765675491000,"readable":true,"remoteCandidateId":"8kCu","selected":true,"state":"succeeded","transportId":"transport_0","writable":true}],["Fn2P",{"id":"Fn2P","timestamp":1556038701221,"type":"local-candidate","address":"10.7.205.35","candidateType":"host","port":40482,"priority":2122252543,"protocol":"udp"}],["0BHX",{"id":"0BHX","timestamp":1556038701221,"type":"local-candidate","address":"10.7.205.35","candidateType":"host","port":50819,"priority":2105508095,"protocol":"tcp"}],["2ekU",{"id":"2ekU","timestamp":1556038701221,"type":"local-candidate","address":"10.7.205.35","candidateType":"host","port":54208,"priority":2105524479,"protocol":"tcp"}],["8kCu",{"id":"8kCu","timestamp":1556038701221,"type":"remote-candidate","address":"10.7.205.35","candidateType":"prflx","port":49770,"priority":1853817087,"protocol":"udp"}]] for video track {d6020c9f-9650-400a-bcf3-fb6acd884540}retry number 1
16:58:25 INFO - 243 INFO Should have RTP stats for track {d6020c9f-9650-400a-bcf3-fb6acd884540}
16:58:25 INFO - 244 INFO RTP stats: {"id":"outbound_rtp_video_0","timestamp":1556038701221,"type":"outbound-rtp","kind":"video","mediaType":"video","ssrc":1668214667,"bytesSent":6854,"packetsSent":27,"bitrateMean":-1.4783618996577789e-86,"bitrateStdDev":4.0872021456e-314,"droppedFrames":0,"firCount":0,"framerateMean":4.0872021456e-314,"framerateStdDev":-1.3169942692898314e+161,"framesEncoded":0,"nackCount":0,"pliCount":0,"remoteId":""}
16:58:25 INFO - 245 INFO Track {d6020c9f-9650-400a-bcf3-fb6acd884540} has 27 outbound-rtp RTP packets.
16:58:25 INFO - 246 INFO TEST-PASS | dom/media/tests/mochitest/test_peerConnection_basicVideoVerifyRtpHeaderExtensions.html | RTP flowing for video track {d6020c9f-9650-400a-bcf3-fb6acd884540}
16:58:25 INFO - 247 INFO Element remote{b26d5f51-8e21-46ca-80d8-7aea905b7763} has enough data.
16:58:25 INFO - 248 INFO Checking for stats in [["inbound_rtp_video_0",{"id":"inbound_rtp_video_0","timestamp":1556038701740,"type":"inbound-rtp","kind":"video","mediaType":"video","ssrc":1284178038,"discardedPackets":0,"jitter":0,"packetsLost":0,"packetsReceived":28,"bitrateMean":318011,"bitrateStdDev":0,"bytesReceived":7251,"firCount":0,"framerateMean":0,"framerateStdDev":0,"framesDecoded":1,"nackCount":0,"pliCount":0,"remoteId":"inbound_rtcp_video_0"}],["inbound_rtcp_video_0",{"id":"inbound_rtcp_video_0","timestamp":1556038701740,"type":"remote-outbound-rtp","kind":"video","mediaType":"video","ssrc":1284178038,"bytesSent":0,"packetsSent":0,"localId":"inbound_rtp_video_0"}],["UJbC",{"id":"UJbC","timestamp":1556038701740,"type":"candidate-pair","bytesReceived":8780,"bytesSent":16777,"componentId":1,"lastPacketReceivedTimestamp":1260540441,"lastPacketSentTimestamp":1260540289,"localCandidateId":"Fn2P","nominated":true,"priority":7962083765675491000,"readable":true,"remoteCandidateId":"8kCu","selected":true,"state":"succeeded","transportId":"transport_0","writable":true}],["Fn2P",{"id":"Fn2P","timestamp":1556038701740,"type":"local-candidate","address":"10.7.205.35","candidateType":"host","port":40482,"priority":2122252543,"protocol":"udp"}],["0BHX",{"id":"0BHX","timestamp":1556038701740,"type":"local-candidate","address":"10.7.205.35","candidateType":"host","port":50819,"priority":2105508095,"protocol":"tcp"}],["2ekU",{"id":"2ekU","timestamp":1556038701740,"type":"local-candidate","address":"10.7.205.35","candidateType":"host","port":54208,"priority":2105524479,"protocol":"tcp"}],["8kCu",{"id":"8kCu","timestamp":1556038701740,"type":"remote-candidate","address":"10.7.205.35","candidateType":"prflx","port":49770,"priority":1853817087,"protocol":"udp"}]] for video track {b26d5f51-8e21-46ca-80d8-7aea905b7763}retry number 2
16:58:25 INFO - 249 INFO Should have RTP stats for track {b26d5f51-8e21-46ca-80d8-7aea905b7763}
16:58:25 INFO - 250 INFO RTP stats: {"id":"inbound_rtp_video_0","timestamp":1556038701740,"type":"inbound-rtp","kind":"video","mediaType":"video","ssrc":1284178038,"discardedPackets":0,"jitter":0,"packetsLost":0,"packetsReceived":28,"bitrateMean":318011,"bitrateStdDev":0,"bytesReceived":7251,"firCount":0,"framerateMean":0,"framerateStdDev":0,"framesDecoded":1,"nackCount":0,"pliCount":0,"remoteId":"inbound_rtcp_video_0"}
16:58:25 INFO - 251 INFO Track {b26d5f51-8e21-46ca-80d8-7aea905b7763} has 28 inbound-rtp RTP packets.
16:58:25 INFO - 252 INFO TEST-PASS | dom/media/tests/mochitest/test_peerConnection_basicVideoVerifyRtpHeaderExtensions.html | RTP flowing for video track {b26d5f51-8e21-46ca-80d8-7aea905b7763}
16:58:25 INFO - 253 INFO Run step 40: PC_REMOTE_CHECK_RTP_HEADER_EXTS_AGAINST_SDP
16:58:25 INFO - Buffered messages finished
16:58:25 INFO - 254 INFO TEST-UNEXPECTED-FAIL | dom/media/tests/mochitest/test_peerConnection_basicVideoVerifyRtpHeaderExtensions.html | number of received ids match sdp ids - got 3, expected 2
16:58:25 INFO - SimpleTest.is@SimpleTest/SimpleTest.js:320:16
16:58:25 INFO - PC_REMOTE_CHECK_RTP_HEADER_EXTS_AGAINST_SDP@dom/media/tests/mochitest/test_peerConnection_basicVideoVerifyRtpHeaderExtensions.html:47:9
16:58:25 INFO - 255 INFO TEST-PASS | dom/media/tests/mochitest/test_peerConnection_basicVideoVerifyRtpHeaderExtensions.html | extension id arrays equivalent
16:58:25 INFO - 256 INFO Run step 41: PC_REMOTE_WAIT_FOR_MEDIA_FLOW
16:58:25 INFO - 257 INFO Checking data flow for element: local{84ed6f2a-60da-4ebd-a280-806e04aa1cc8}
16:58:25 INFO - 258 INFO TEST-PASS | dom/media/tests/mochitest/test_peerConnection_basicVideoVerifyRtpHeaderExtensions.html | Element ended should be the inverse of the MediaStream's active state

Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---

mjf: Could you look at this failure and let us know if there is anything that can be done about it? Is it significant or a false positive?

Flags: needinfo?(mfroman)

I'm on RDD process stuff at the moment. Byron?

Flags: needinfo?(mfroman) → needinfo?(docfaraday)

Not sure. Nico? Can you think of any reason why an extra RTP extension might show up here?

Flags: needinfo?(docfaraday) → needinfo?(na-g)

I have no clue as to why an extra extension would show up intermittently.

Flags: needinfo?(na-g)

16:58:25 INFO - 255 INFO TEST-PASS | dom/media/tests/mochitest/test_peerConnection_basicVideoVerifyRtpHeaderExtensions.html | extension id arrays equivalent

Leads me to suspect that we are getting a duplicate id. I am going to add some more logging to this test.

Maybe this is a dupe of bug 1559512? Hasn't happened since that landed. Pretty low frequency, I'll check back next week.

Flags: needinfo?(docfaraday)
See Also: → 1559512

No failures last week. I'll wait a couple more and see.

Hasn't happened anywhere bug 1559512 has landed, but has happened on esr68 along with bug 1559512.

Status: REOPENED → RESOLVED
Closed: 5 years ago → 5 years ago
Flags: needinfo?(docfaraday)
Resolution: --- → DUPLICATE
Product: Firefox for Android → Firefox for Android Graveyard
You need to log in before you can comment on or make changes to this bug.