Closed Bug 1511886 Opened 7 years ago Closed 6 years ago

Intermittent dom/media/tests/mochitest/test_peerConnection_replaceTrack.html | Error in test execution: NotFoundError: The object can not be found here.

Categories

(Core :: WebRTC, defect, P5)

Product:
Core
Component:
WebRTC
Type:
defect

Tracking

()

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

Filed by: ncsoregi [at] mozilla.com https://treeherder.mozilla.org/logviewer.html#?job_id=215303622&repo=mozilla-esr60 https://queue.taskcluster.net/v1/task/G4kvuhLsRFCUd0aSiP6jdA/runs/0/artifacts/public/logs/live_backing.log [task 2018-12-03T18:26:44.602Z] 18:26:44 INFO - TEST-PASS | dom/media/tests/mochitest/test_peerConnection_replaceTrack.html | Shouldn't have any remote streams without a corresponding receiver [task 2018-12-03T18:26:44.607Z] 18:26:44 INFO - Call getUserMedia for {"video":true,"audio":{"autoGainControl":false,"echoCancellation":false,"noiseSuppression":false}} [task 2018-12-03T18:26:44.617Z] 18:26:44 INFO - Buffered messages finished [task 2018-12-03T18:26:44.623Z] 18:26:44 INFO - TEST-UNEXPECTED-FAIL | dom/media/tests/mochitest/test_peerConnection_replaceTrack.html | Error in test execution: NotFoundError: The object can not be found here. [task 2018-12-03T18:26:44.630Z] 18:26:44 INFO - execute/<@dom/media/tests/mochitest/head.js:835:14 [task 2018-12-03T18:26:44.635Z] 18:26:44 INFO - TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_replaceTrack.html | The author of the test has indicated that flaky timeouts are expected. Reason: WebRTC inherently depends on timeouts [task 2018-12-03T18:26:44.643Z] 18:26:44 INFO - Closing peer connections [task 2018-12-03T18:26:44.651Z] 18:26:44 INFO - Waiting for track {de7006e5-d5e1-4c3e-8ac9-e56d45b27e31} (audio) to end. [task 2018-12-03T18:26:44.654Z] 18:26:44 INFO - TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_replaceTrack.html | The author of the test has indicated that flaky timeouts are expected. Reason: WebRTC inherently depends on timeouts [task 2018-12-03T18:26:44.662Z] 18:26:44 INFO - Waiting for track {31321bba-c1fe-499c-8acc-a947f0308dcc} (video) to end. [task 2018-12-03T18:26:44.667Z] 18:26:44 INFO - TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_replaceTrack.html | The author of the test has indicated that flaky timeouts are expected. Reason: WebRTC inherently depends on timeouts [task 2018-12-03T18:26:44.670Z] 18:26:44 INFO - TEST-PASS | dom/media/tests/mochitest/test_peerConnection_replaceTrack.html | iceConnectionState should not be undefined [task 2018-12-03T18:26:44.676Z] 18:26:44 INFO - PeerConnectionWrapper (pcLocal): oniceconnectionstatechange fired, new state is: closed [task 2018-12-03T18:26:44.678Z] 18:26:44 INFO - TEST-PASS | dom/media/tests/mochitest/test_peerConnection_replaceTrack.html | PeerConnectionWrapper (pcLocal): legal ICE state transition from connected to closed

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

Status: NEW → RESOLVED
Closed: 6 years ago
Resolution: --- → INCOMPLETE

This is still happening.

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

[task 2019-05-07T11:30:03.691Z] 11:30:03 INFO - TEST-PASS | dom/media/tests/mochitest/test_peerConnection_replaceTrack.html | RTP flowing for video track {2cadff94-5690-4b09-9c55-88d6a74aaeef}
[task 2019-05-07T11:30:03.694Z] 11:30:03 INFO - Checking for stats in [["inbound_rtp_audio_0",{"id":"inbound_rtp_audio_0","timestamp":1557228431813,"type":"inbound-rtp","kind":"audio","mediaType":"audio","ssrc":2147819036,"jitter":0,"packetsLost":0,"packetsReceived":41,"bytesReceived":7581,"nackCount":0}],["MmeL",{"id":"MmeL","timestamp":1557228431813,"type":"candidate-pair","bytesReceived":0,"bytesSent":0,"componentId":1,"lastPacketReceivedTimestamp":0,"lastPacketSentTimestamp":0,"localCandidateId":"2PGK","nominated":false,"priority":9115005270282338000,"readable":true,"remoteCandidateId":"ByuH","selected":false,"state":"cancelled","transportId":"transport_0","writable":true}],["H8kP",{"id":"H8kP","timestamp":1557228431813,"type":"candidate-pair","bytesReceived":14538,"bytesSent":5412,"componentId":1,"lastPacketReceivedTimestamp":1557228431832,"lastPacketSentTimestamp":1557228431833,"localCandidateId":"k5Sf","nominated":true,"priority":9114723795305497000,"readable":true,"remoteCandidateId":"kKxS","selected":true,"state":"succeeded","transportId":"transport_0","writable":true}],["k5Sf",{"id":"k5Sf","timestamp":1557228431813,"type":"local-candidate","address":"172.17.0.5","candidateType":"host","port":60797,"priority":2122187007,"protocol":"udp"}],["2PGK",{"id":"2PGK","timestamp":1557228431813,"type":"local-candidate","address":"fd15:4ba5:5a2b:100a:0:242:ac11:5","candidateType":"host","port":52127,"priority":2122252543,"protocol":"udp"}],["Uo4Z",{"id":"Uo4Z","timestamp":1557228431813,"type":"local-candidate","address":"172.17.0.5","candidateType":"host","port":63475,"priority":2105458943,"protocol":"tcp"}],["YALf",{"id":"YALf","timestamp":1557228431813,"type":"local-candidate","address":"fd15:4ba5:5a2b:100a:0:242:ac11:5","candidateType":"host","port":52259,"priority":2105524479,"protocol":"tcp"}],["kKxS",{"id":"kKxS","timestamp":1557228431813,"type":"remote-candidate","address":"172.17.0.5","candidateType":"host","port":34151,"priority":2122187007,"protocol":"udp"}],["ByuH",{"id":"ByuH","timestamp":1557228431813,"type":"remote-candidate","address":"fd15:4ba5:5a2b:100a:0:242:ac11:5","candidateType":"host","port":56002,"priority":2122252543,"protocol":"udp"}],["+GdI",{"id":"+GdI","timestamp":1557228431813,"type":"remote-candidate","address":"172.17.0.5","candidateType":"host","port":9,"priority":2105458943,"protocol":"tcp"}]] for audio track {05230926-1b54-4d51-ad0d-ea210b9221dc}retry number 0
[task 2019-05-07T11:30:03.695Z] 11:30:03 INFO - Should have RTP stats for track {05230926-1b54-4d51-ad0d-ea210b9221dc}
[task 2019-05-07T11:30:03.695Z] 11:30:03 INFO - RTP stats: {"id":"inbound_rtp_audio_0","timestamp":1557228431813,"type":"inbound-rtp","kind":"audio","mediaType":"audio","ssrc":2147819036,"jitter":0,"packetsLost":0,"packetsReceived":41,"bytesReceived":7581,"nackCount":0}
[task 2019-05-07T11:30:03.696Z] 11:30:03 INFO - Track {05230926-1b54-4d51-ad0d-ea210b9221dc} has 41 inbound-rtp RTP packets.
[task 2019-05-07T11:30:03.697Z] 11:30:03 INFO - TEST-PASS | dom/media/tests/mochitest/test_peerConnection_replaceTrack.html | RTP flowing for audio track {05230926-1b54-4d51-ad0d-ea210b9221dc}
[task 2019-05-07T11:30:03.697Z] 11:30:03 INFO - Buffered messages logged at 11:27:12
[task 2019-05-07T11:30:03.707Z] 11:30:03 INFO - Checking for stats in [["outbound_rtp_video_0",{"id":"outbound_rtp_video_0","timestamp":1557228431853,"type":"outbound-rtp","kind":"video","mediaType":"video","ssrc":816039364,"bytesSent":3820,"packetsSent":37,"bitrateMean":10453.5,"bitrateStdDev":14783.48147426715,"droppedFrames":2,"firCount":0,"framerateMean":13.5,"framerateStdDev":19.091883092036785,"framesEncoded":24,"nackCount":0,"pliCount":0,"qpSum":920,"remoteId":"outbound_rtcp_video_0"}],["outbound_rtcp_video_0",{"id":"outbound_rtcp_video_0","timestamp":1557228431853,"type":"remote-inbound-rtp","kind":"video","mediaType":"video","ssrc":816039364,"jitter":0.003,"packetsLost":0,"packetsReceived":24,"bytesReceived":2192,"localId":"outbound_rtp_video_0"}],["MmeL",{"id":"MmeL","timestamp":1557228431853,"type":"candidate-pair","bytesReceived":0,"bytesSent":0,"componentId":1,"lastPacketReceivedTimestamp":0,"lastPacketSentTimestamp":0,"localCandidateId":"2PGK","nominated":false,"priority":9115005270282338000,"readable":true,"remoteCandidateId":"ByuH","selected":false,"state":"cancelled","transportId":"transport_0","writable":true}],["H8kP",{"id":"H8kP","timestamp":1557228431853,"type":"candidate-pair","bytesReceived":14822,"bytesSent":5490,"componentId":1,"lastPacketReceivedTimestamp":1557228431862,"lastPacketSentTimestamp":1557228431860,"localCandidateId":"k5Sf","nominated":true,"priority":9114723795305497000,"readable":true,"remoteCandidateId":"kKxS","selected":true,"state":"succeeded","transportId":"transport_0","writable":true}],["k5Sf",{"id":"k5Sf","timestamp":1557228431853,"type":"local-candidate","address":"172.17.0.5","candidateType":"host","port":60797,"priority":2122187007,"protocol":"udp"}],["2PGK",{"id":"2PGK","timestamp":1557228431853,"type":"local-candidate","address":"fd15:4ba5:5a2b:100a:0:242:ac11:5","candidateType":"host","port":52127,"priority":2122252543,"protocol":"udp"}],["Uo4Z",{"id":"Uo4Z","timestamp":1557228431853,"type":"local-candidate","address":"172.17.0.5","candidateType":"host","port":63475,"priority":2105458943,"protocol":"tcp"}],["YALf",{"id":"YALf","timestamp":1557228431853,"type":"local-candidate","address":"fd15:4ba5:5a2b:100a:0:242:ac11:5","candidateType":"host","port":52259,"priority":2105524479,"protocol":"tcp"}],["kKxS",{"id":"kKxS","timestamp":1557228431853,"type":"remote-candidate","address":"172.17.0.5","candidateType":"host","port":34151,"priority":2122187007,"protocol":"udp"}],["ByuH",{"id":"ByuH","timestamp":1557228431853,"type":"remote-candidate","address":"fd15:4ba5:5a2b:100a:0:242:ac11:5","candidateType":"host","port":56002,"priority":2122252543,"protocol":"udp"}],["+GdI",{"id":"+GdI","timestamp":1557228431853,"type":"remote-candidate","address":"172.17.0.5","candidateType":"host","port":9,"priority":2105458943,"protocol":"tcp"}]] for video track {54868008-c70c-4def-8b0a-72ecab5eeed0}retry number 0
[task 2019-05-07T11:30:03.708Z] 11:30:03 INFO - Should have RTP stats for track {54868008-c70c-4def-8b0a-72ecab5eeed0}
[task 2019-05-07T11:30:03.709Z] 11:30:03 INFO - RTP stats: {"id":"outbound_rtp_video_0","timestamp":1557228431853,"type":"outbound-rtp","kind":"video","mediaType":"video","ssrc":816039364,"bytesSent":3820,"packetsSent":37,"bitrateMean":10453.5,"bitrateStdDev":14783.48147426715,"droppedFrames":2,"firCount":0,"framerateMean":13.5,"framerateStdDev":19.091883092036785,"framesEncoded":24,"nackCount":0,"pliCount":0,"qpSum":920,"remoteId":"outbound_rtcp_video_0"}
[task 2019-05-07T11:30:03.709Z] 11:30:03 INFO - Track {54868008-c70c-4def-8b0a-72ecab5eeed0} has 37 outbound-rtp RTP packets.
[task 2019-05-07T11:30:03.709Z] 11:30:03 INFO - TEST-PASS | dom/media/tests/mochitest/test_peerConnection_replaceTrack.html | RTP flowing for video track {54868008-c70c-4def-8b0a-72ecab5eeed0}
[task 2019-05-07T11:30:03.709Z] 11:30:03 INFO - Run step 39: PC_REMOTE_VIDEOONLY_REPLACE_VIDEOTRACK
[task 2019-05-07T11:30:03.709Z] 11:30:03 INFO - TEST-PASS | dom/media/tests/mochitest/test_peerConnection_replaceTrack.html | We have a sender for video
[task 2019-05-07T11:30:03.710Z] 11:30:03 INFO - TEST-PASS | dom/media/tests/mochitest/test_peerConnection_replaceTrack.html | Shouldn't have any local streams without a corresponding sender
[task 2019-05-07T11:30:03.710Z] 11:30:03 INFO - TEST-PASS | dom/media/tests/mochitest/test_peerConnection_replaceTrack.html | Shouldn't have any remote streams without a corresponding receiver
[task 2019-05-07T11:30:03.710Z] 11:30:03 INFO - Call getUserMedia for {"video":true,"audio":{"autoGainControl":false,"echoCancellation":false,"noiseSuppression":false}}
[task 2019-05-07T11:30:03.710Z] 11:30:03 INFO - Buffered messages finished
[task 2019-05-07T11:30:03.710Z] 11:30:03 INFO - TEST-UNEXPECTED-FAIL | dom/media/tests/mochitest/test_peerConnection_replaceTrack.html | Error in test execution: NotFoundError: The object can not be found here.
[task 2019-05-07T11:30:03.710Z] 11:30:03 INFO - SimpleTest.ok@https://example.com/tests/SimpleTest/SimpleTest.js:275:18
[task 2019-05-07T11:30:03.710Z] 11:30:03 INFO - execute/<@https://example.com/tests/dom/media/tests/mochitest/head.js:855:14
[task 2019-05-07T11:30:03.710Z] 11:30:03 INFO - promise callbackexecute@https://example.com/tests/dom/media/tests/mochitest/head.js:854:8
[task 2019-05-07T11:30:03.710Z] 11:30:03 INFO - PeerConnectionTest.prototype.run@https://example.com/tests/dom/media/tests/mochitest/pc.js:486:21
[task 2019-05-07T11:30:03.711Z] 11:30:03 INFO - @https://example.com/tests/dom/media/tests/mochitest/test_peerConnection_replaceTrack.html:182:10
[task 2019-05-07T11:30:03.711Z] 11:30:03 INFO - runNetworkTest/<@https://example.com/tests/dom/media/tests/mochitest/pc.js:2187:13
[task 2019-05-07T11:30:03.711Z] 11:30:03 INFO - asyncrunTestWhenReady/<@https://example.com/tests/dom/media/tests/mochitest/head.js:472:41
[task 2019-05-07T11:30:03.711Z] 11:30:03 INFO - promise callbackrunTestWhenReady@https://example.com/tests/dom/media/tests/mochitest/head.js:472:25
[task 2019-05-07T11:30:03.711Z] 11:30:03 INFO - runNetworkTest@https://example.com/tests/dom/media/tests/mochitest/pc.js:2169:9
[task 2019-05-07T11:30:03.711Z] 11:30:03 INFO - async@https://example.com/tests/dom/media/tests/mochitest/test_peerConnection_replaceTrack.html:69:3
[task 2019-05-07T11:30:03.712Z] 11:30:03 INFO - TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_replaceTrack.html | The author of the test has indicated that flaky timeouts are expected. Reason: WebRTC inherently depends on timeouts
[task 2019-05-07T11:30:03.712Z] 11:30:03 INFO - Closing peer connections
[task 2019-05-07T11:30:03.712Z] 11:30:03 INFO - Waiting for track {edc11944-ed5b-4bb2-9f4c-9c372c759553} (audio) to end.
[task 2019-05-07T11:30:03.713Z] 11:30:03 INFO - TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_replaceTrack.html | The author of the test has indicated that flaky timeouts are expected. Reason: WebRTC inherently depends on timeouts
[task 2019-05-07T11:30:03.713Z] 11:30:03 INFO - Waiting for track {d6ae2b2e-1199-4da2-aa61-1cb68362771e} (video) to end.

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 → 6 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.