1476214 - Intermittent dom/media/tests/mochitest/test_peerConnection_constructedStream.html | Error in test execution: Error: Timeout checking for stats for track {eb03eccb-325e-4f11-95c6-ee9c7608d7a5} after at least30000ms waitForRtpFlow

Status: RESOLVED INCOMPLETE

(Core :: WebRTC, defect, P5)

Description

[Treeherder Bug Filer]

Filed by: ebalazs [at] mozilla.com

https://treeherder.mozilla.org/logviewer.html#?job_id=188512166&repo=mozilla-inbound

https://queue.taskcluster.net/v1/task/JVwlpbn9Sm27EGFljFVH5g/runs/0/artifacts/public/logs/live_backing.log

ERROR -  1323 INFO TEST-UNEXPECTED-FAIL | dom/media/tests/mochitest/test_peerConnection_constructedStream.html | Error in test execution: Error: Timeout checking for stats for track {eb03eccb-325e-4f11-95c6-ee9c7608d7a5} 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:1608:49 ... waitForMediaFlow@http://mochi.test:8888/tests/dom/media/tests/mochitest/pc.js:1608: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:855:31 ...
06:52:05     INFO -      execute/<@dom/media/tests/mochitest/head.js:859:14
06:52:05     INFO -      promise callback*execute@dom/media/tests/mochitest/head.js:848:12
06:52:05     INFO -      PeerConnectionTest.prototype.run@dom/media/tests/mochitest/pc.js:485:10
06:52:05     INFO -      @dom/media/tests/mochitest/test_peerConnection_constructedStream.html:65:3
06:52:05     INFO -      runNetworkTest/<@dom/media/tests/mochitest/pc.js:2214:13
06:52:05     INFO -      async*runTestWhenReady/<@dom/media/tests/mochitest/head.js:476:41
06:52:05     INFO -      promise callback*runTestWhenReady@dom/media/tests/mochitest/head.js:476:10
06:52:05     INFO -      runNetworkTest@dom/media/tests/mochitest/pc.js:2196:9
06:52:05     INFO -      async*@dom/media/tests/mochitest/test_peerConnection_constructedStream.html:15:1

Comment 1

[Sebastian Hengst [:aryx] (needinfo me if it's about an intermittent or backout)]

06:52:05     INFO -  1312 INFO TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_constructedStream.html | The author of the test has indicated that flaky timeouts are expected.  Reason: WebRTC inherently depends on timeouts
06:52:05     INFO -  Buffered messages logged at 06:52:05
06:52:05     INFO -  1313 INFO Checking for stats in {"outbound_rtp_audio_0":{"id":"outbound_rtp_audio_0","timestamp":1531810325000,"type":"outboundrtp","isRemote":false,"mediaType":"audio","nackCount":0,"remoteId":"","ssrc":"3779384023","bytesSent":0,"packetsSent":0},"irxo":{"id":"irxo","timestamp":1531810325000,"type":"candidatepair","bytesReceived":2979,"bytesSent":798,"componentId":1,"lastPacketReceivedTimestamp":291382036872,"lastPacketSentTimestamp":291382006441,"localCandidateId":"ydsJ","nominated":true,"priority":9115005270282338000,"readable":true,"remoteCandidateId":"bSph","selected":true,"state":"succeeded","transportId":"0-1531810293549000 (id=4294967652 url=http://mochi.test:8888/tests/dom/media/tests/mochitest/test_peerConnection_constructedStrea aLevel=0","writable":true},"ydsJ":{"id":"ydsJ","timestamp":1531810325000,"type":"localcandidate","candidateType":"host","componentId":"0-1531810293549000 (id=4294967652 url=http://mochi.test:8888/tests/dom/media/tests/mochitest/test_peerConnection_constructedStrea aLevel=0","ipAddress":"10.143.42.77","mozLocalTransport":"udp","portNumber":54621,"transport":"udp"},"sVTW":{"id":"sVTW","timestamp":1531810325000,"type":"localcandidate","candidateType":"host","componentId":"0-1531810293549000 (id=4294967652 url=http://mochi.test:8888/tests/dom/media/tests/mochitest/test_peerConnection_constructedStrea aLevel=0","ipAddress":"2001:0:9d38:90d7:40f:150d:c93e:aca4","mozLocalTransport":"udp","portNumber":54620,"transport":"udp"},"rFYi":{"id":"rFYi","timestamp":1531810325000,"type":"localcandidate","candidateType":"host","componentId":"0-1531810293549000 (id=4294967652 url=http://mochi.test:8888/tests/dom/media/tests/mochitest/test_peerConnection_constructedStrea aLevel=0","ipAddress":"10.143.42.77","mozLocalTransport":"tcp","portNumber":65153,"transport":"tcp"},"atqf":{"id":"atqf","timestamp":1531810325000,"type":"localcandidate","candidateType":"host","componentId":"0-1531810293549000 (id=4294967652 url=http://mochi.test:8888/tests/dom/media/tests/mochitest/test_peerConnection_constructedStrea aLevel=0","ipAddress":"2001:0:9d38:90d7:40f:150d:c93e:aca4","mozLocalTransport":"tcp","portNumber":57252,"transport":"tcp"},"bSph":{"id":"bSph","timestamp":1531810325000,"type":"remotecandidate","candidateType":"host","componentId":"0-1531810293549000 (id=4294967652 url=http://mochi.test:8888/tests/dom/media/tests/mochitest/test_peerConnection_constructedStrea aLevel=0","ipAddress":"10.143.42.77","portNumber":54631,"transport":"udp"}} for audio track {73ca332a-34be-4e08-9f0d-2b4d8b322415}, retry number 60
06:52:05     INFO -  1314 INFO Should have RTP stats for track {73ca332a-34be-4e08-9f0d-2b4d8b322415}
06:52:05     INFO -  1315 INFO RTP stats: {"id":"outbound_rtp_audio_0","timestamp":1531810325000,"type":"outbound-rtp","isRemote":false,"mediaType":"audio","nackCount":0,"remoteId":"","ssrc":"3779384023","bytesSent":0,"packetsSent":0}
06:52:05     INFO -  1316 INFO Track {73ca332a-34be-4e08-9f0d-2b4d8b322415} has 0 outbound-rtp RTP packets.
06:52:05     INFO -  1317 INFO TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_constructedStream.html | The author of the test has indicated that flaky timeouts are expected.  Reason: WebRTC inherently depends on timeouts
06:52:05     INFO -  1318 INFO Checking for stats in {"outbound_rtcp_video_0":{"id":"outbound_rtcp_video_0","timestamp":3038147,"type":"inboundrtp","isRemote":true,"mediaType":"video","remoteId":"outbound_rtp_video_0","ssrc":"3417244000","bytesReceived":0,"jitter":0,"packetsLost":0,"packetsReceived":0},"outbound_rtp_video_0":{"id":"outbound_rtp_video_0","timestamp":1531810325008,"type":"outboundrtp","bitrateMean":0,"bitrateStdDev":0,"firCount":0,"framerateMean":0,"framerateStdDev":0,"isRemote":false,"mediaType":"video","nackCount":0,"pliCount":0,"remoteId":"outbound_rtcp_video_0","ssrc":"3417244000","bytesSent":0,"droppedFrames":0,"framesEncoded":0,"packetsSent":0},"irxo":{"id":"irxo","timestamp":1531810325008,"type":"candidatepair","bytesReceived":2979,"bytesSent":798,"componentId":1,"lastPacketReceivedTimestamp":291382036872,"lastPacketSentTimestamp":291382006441,"localCandidateId":"ydsJ","nominated":true,"priority":9115005270282338000,"readable":true,"remoteCandidateId":"bSph","selected":true,"state":"succeeded","transportId":"0-1531810293549000 (id=4294967652 url=http://mochi.test:8888/tests/dom/media/tests/mochitest/test_peerConnection_constructedStrea aLevel=0","writable":true},"ydsJ":{"id":"ydsJ","timestamp":1531810325008,"type":"localcandidate","candidateType":"host","componentId":"0-1531810293549000 (id=4294967652 url=http://mochi.test:8888/tests/dom/media/tests/mochitest/test_peerConnection_constructedStrea aLevel=0","ipAddress":"10.143.42.77","mozLocalTransport":"udp","portNumber":54621,"transport":"udp"},"sVTW":{"id":"sVTW","timestamp":1531810325008,"type":"localcandidate","candidateType":"host","componentId":"0-1531810293549000 (id=4294967652 url=http://mochi.test:8888/tests/dom/media/tests/mochitest/test_peerConnection_constructedStrea aLevel=0","ipAddress":"2001:0:9d38:90d7:40f:150d:c93e:aca4","mozLocalTransport":"udp","portNumber":54620,"transport":"udp"},"rFYi":{"id":"rFYi","timestamp":1531810325008,"type":"localcandidate","candidateType":"host","componentId":"0-1531810293549000 (id=4294967652 url=http://mochi.test:8888/tests/dom/media/tests/mochitest/test_peerConnection_constructedStrea aLevel=0","ipAddress":"10.143.42.77","mozLocalTransport":"tcp","portNumber":65153,"transport":"tcp"},"atqf":{"id":"atqf","timestamp":1531810325008,"type":"localcandidate","candidateType":"host","componentId":"0-1531810293549000 (id=4294967652 url=http://mochi.test:8888/tests/dom/media/tests/mochitest/test_peerConnection_constructedStrea aLevel=0","ipAddress":"2001:0:9d38:90d7:40f:150d:c93e:aca4","mozLocalTransport":"tcp","portNumber":57252,"transport":"tcp"},"bSph":{"id":"bSph","timestamp":1531810325008,"type":"remotecandidate","candidateType":"host","componentId":"0-1531810293549000 (id=4294967652 url=http://mochi.test:8888/tests/dom/media/tests/mochitest/test_peerConnection_constructedStrea aLevel=0","ipAddress":"10.143.42.77","portNumber":54631,"transport":"udp"}} for video track {cc648680-cd1f-449a-b73d-a29a1881575d}, retry number 60
06:52:05     INFO -  1319 INFO Should have RTP stats for track {cc648680-cd1f-449a-b73d-a29a1881575d}
06:52:05     INFO -  1320 INFO RTP stats: {"id":"outbound_rtp_video_0","timestamp":1531810325008,"type":"outbound-rtp","bitrateMean":0,"bitrateStdDev":0,"firCount":0,"framerateMean":0,"framerateStdDev":0,"isRemote":false,"mediaType":"video","nackCount":0,"pliCount":0,"remoteId":"outbound_rtcp_video_0","ssrc":"3417244000","bytesSent":0,"droppedFrames":0,"framesEncoded":0,"packetsSent":0}
06:52:05     INFO -  1321 INFO Track {cc648680-cd1f-449a-b73d-a29a1881575d} has 0 outbound-rtp RTP packets.
06:52:05     INFO -  1322 INFO TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_constructedStream.html | The author of the test has indicated that flaky timeouts are expected.  Reason: WebRTC inherently depends on timeouts
06:52:05     INFO -  Buffered messages finished
06:52:05    ERROR -  1323 INFO TEST-UNEXPECTED-FAIL | dom/media/tests/mochitest/test_peerConnection_constructedStream.html | Error in test execution: Error: Timeout checking for stats for track {eb03eccb-325e-4f11-95c6-ee9c7608d7a5} 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:1608:49 ... waitForMediaFlow@http://mochi.test:8888/tests/dom/media/tests/mochitest/pc.js:1608: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:855:31 ...
06:52:05     INFO -      execute/<@dom/media/tests/mochitest/head.js:859:14
06:52:05     INFO -      promise callback*execute@dom/media/tests/mochitest/head.js:848:12
06:52:05     INFO -      PeerConnectionTest.prototype.run@dom/media/tests/mochitest/pc.js:485:10
06:52:05     INFO -      @dom/media/tests/mochitest/test_peerConnection_constructedStream.html:65:3
06:52:05     INFO -      runNetworkTest/<@dom/media/tests/mochitest/pc.js:2214:13
06:52:05     INFO -      async*runTestWhenReady/<@dom/media/tests/mochitest/head.js:476:41
06:52:05     INFO -      promise callback*runTestWhenReady@dom/media/tests/mochitest/head.js:476:10
06:52:05     INFO -      runNetworkTest@dom/media/tests/mochitest/pc.js:2196:9
06:52:05     INFO -      async*@dom/media/tests/mochitest/test_peerConnection_constructedStream.html:15:1

Comment 2

[Intermittent Failures Robot]

2 failures in 653 pushes (0.003 failures/push) were associated with this bug in the last 7 days.    

Repository breakdown:
* mozilla-inbound: 2

Platform breakdown:
* windows10-64: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1476214&startday=2018-07-16&endday=2018-07-22&tree=trunk

Comment 3

[Firefox Bug Husbandry Bot]

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

Comment 4

[Raul Gurzau (:RaulG)]

https://treeherder.mozilla.org/logviewer.html#?job_id=207589459&repo=mozilla-inbound&lineNumber=23225

18:42:20     INFO - TEST-UNEXPECTED-FAIL | dom/media/tests/mochitest/test_peerConnection_constructedStream.html | Error in test execution: Error: Timeout checking for stats for track {d85d2de3-5bee-4cc5-ad41-b53ed1196cd1} after at least30000ms waitForRtpFlow@http://mochi.test:8888/tests/dom/media/tests/mochitest/pc.js:1556:11 ... async*waitForMediaFlow/<@http://mochi.test:8888/tests/dom/media/tests/mochitest/pc.js:1609:49 ... waitForMediaFlow@http://mochi.test:8888/tests/dom/media/tests/mochitest/pc.js:1609:36 ... 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:850:31 ...  
18:42:20     INFO -     execute/<@dom/media/tests/mochitest/head.js:854:14
18:42:20     INFO -     promise callback*execute@dom/media/tests/mochitest/head.js:853:8
18:42:20     INFO -     PeerConnectionTest.prototype.run@dom/media/tests/mochitest/pc.js:486:10
18:42:20     INFO -     @dom/media/tests/mochitest/test_peerConnection_constructedStream.html:65:3
18:42:20     INFO -     runNetworkTest/<@dom/media/tests/mochitest/pc.js:2211:13
18:42:20     INFO -     async*runTestWhenReady/<@dom/media/tests/mochitest/head.js:471:41
18:42:20     INFO -     promise callback*runTestWhenReady@dom/media/tests/mochitest/head.js:471:10
18:42:20     INFO -     runNetworkTest@dom/media/tests/mochitest/pc.js:2193:9
18:42:20     INFO -     async*@dom/media/tests/mochitest/test_peerConnection_constructedStream.html:15:1

Comment 5

[Intermittent Failures Robot]

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

Repository breakdown:
* mozilla-inbound: 1

Platform breakdown:
* windows10-64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1476214&startday=2018-10-22&endday=2018-10-28&tree=all

Comment 6

[Firefox Bug Husbandry Bot]

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

Comment 7

[Cristian Brindusan [:cbrindusan]]

Recent log failure:
https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=234520057&repo=mozilla-inbound&lineNumber=25741

Comment 8

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-inbound: 1

Platform breakdown:

• windows10-64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1476214&startday=2019-03-18&endday=2019-03-24&tree=all

Comment 9

[Firefox Bug Husbandry Bot]

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

Comment 10

[Intermittent Failures Robot]

1 failures in 4439 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=1476214&startday=2019-07-29&endday=2019-08-04&tree=all

Comment 11

[Firefox Bug Husbandry Bot]

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

Comment 12

[Cristina Coroiu [:ccoroiu]]

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

Comment 13

[Intermittent Failures Robot]

2 failures in 2190 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 2

Platform breakdown:

• windows10-64: 2

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

Comment 14

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

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

Comment 15

[Intermittent Failures Robot]

1 failures in 5233 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=1476214&startday=2020-02-24&endday=2020-03-01&tree=all

Comment 16

[Cristian Brindusan [:cbrindusan]]

New occurrence:
https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=299913713&repo=autoland&lineNumber=28857

Comment 17

[Intermittent Failures Robot]

1 failures in 5423 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=1476214&startday=2020-04-27&endday=2020-05-03&tree=all

Comment 18

[Intermittent Failures Robot]

1 failures in 5276 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=1476214&startday=2020-05-04&endday=2020-05-10&tree=all

Comment 19

[Intermittent Failures Robot]

1 failures in 5458 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=1476214&startday=2020-05-25&endday=2020-05-31&tree=all

Comment 20

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

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

Comment 21

[Cristina Coroiu [:ccoroiu]]

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

Comment 22

[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=1476214&startday=2020-07-06&endday=2020-07-12&tree=all

Comment 23

[Intermittent Failures Robot]

1 failures in 4310 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=1476214&startday=2020-07-20&endday=2020-07-26&tree=all

Comment 24

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

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