1561638 - Intermittent dom/media/tests/mochitest/test_peerConnection_webAudio.html | Error in test execution: Error: Timeout checking for stats for track {e314df0a-831d-443c-9c0d-cd91fb4aada1} after at least30000ms waitForRtpFlow@http://mochi.test:8888/tests/dom/me

Status: RESOLVED INCOMPLETE

(Core :: WebRTC, defect, P5)

Description

[Treeherder Bug Filer]

Filed by: nbeleuzu [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=253518191&repo=autoland
Full log: https://queue.taskcluster.net/v1/task/UTGJqyxlR8K4i4bV-VhA1Q/runs/0/artifacts/public/logs/live_backing.log

---

13:19:39 INFO - TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_webAudio.html | The author of the test has indicated that flaky timeouts are expected. Reason: WebRTC inherently depends on timeouts
13:19:39 INFO - Buffered messages logged at 13:19:39
13:19:39 INFO - Checking for stats in [["outbound_rtp_audio_0",{"id":"outbound_rtp_audio_0","timestamp":1561555179139,"type":"outbound-rtp","kind":"audio","mediaType":"audio","ssrc":2690798996,"bytesSent":0,"packetsSent":0,"nackCount":0,"remoteId":""}],["aFTL",{"id":"aFTL","timestamp":1561555179139,"type":"candidate-pair","bytesReceived":0,"bytesSent":0,"componentId":1,"lastPacketReceivedTimestamp":0,"lastPacketSentTimestamp":0,"localCandidateId":"vyIE","nominated":false,"priority":9115005270282338000,"readable":true,"remoteCandidateId":"6h4t","selected":false,"state":"cancelled","transportId":"transport_0","writable":true}],["f+6O",{"id":"f+6O","timestamp":1561555179139,"type":"candidate-pair","bytesReceived":917,"bytesSent":797,"componentId":1,"lastPacketReceivedTimestamp":321126888504,"lastPacketSentTimestamp":321126860911,"localCandidateId":"vyIE","nominated":true,"priority":7962083765675491000,"readable":true,"remoteCandidateId":"E2u8","selected":true,"state":"succeeded","transportId":"transport_0","writable":true}],["vyIE",{"id":"vyIE","timestamp":1561555179139,"type":"local-candidate","address":"10.143.25.199","candidateType":"host","port":57001,"priority":2122252543,"protocol":"udp"}],["n1Bz",{"id":"n1Bz","timestamp":1561555179139,"type":"local-candidate","address":"10.143.25.199","candidateType":"host","port":59048,"priority":2105524479,"protocol":"tcp"}],["E2u8",{"id":"E2u8","timestamp":1561555179139,"type":"remote-candidate","address":"10.143.25.199","candidateType":"prflx","port":57005,"priority":1853817087,"protocol":"udp"}],["6h4t",{"id":"6h4t","timestamp":1561555179139,"type":"remote-candidate","address":"10.143.25.199","candidateType":"host","port":57005,"priority":2122252543,"protocol":"udp"}],["dKQJ",{"id":"dKQJ","timestamp":1561555179139,"type":"remote-candidate","address":"10.143.25.199","candidateType":"host","port":9,"priority":2105524479,"protocol":"tcp"}]] for audio track {e314df0a-831d-443c-9c0d-cd91fb4aada1}retry number 60
13:19:39 INFO - Should have RTP stats for track {e314df0a-831d-443c-9c0d-cd91fb4aada1}
13:19:39 INFO - RTP stats: {"id":"outbound_rtp_audio_0","timestamp":1561555179139,"type":"outbound-rtp","kind":"audio","mediaType":"audio","ssrc":2690798996,"bytesSent":0,"packetsSent":0,"nackCount":0,"remoteId":""}
13:19:39 INFO - Track {e314df0a-831d-443c-9c0d-cd91fb4aada1} has 0 outbound-rtp RTP packets.
13:19:39 INFO - TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_webAudio.html | The author of the test has indicated that flaky timeouts are expected. Reason: WebRTC inherently depends on timeouts
13:19:39 INFO - Buffered messages finished
13:19:39 INFO - TEST-UNEXPECTED-FAIL | dom/media/tests/mochitest/test_peerConnection_webAudio.html | Error in test execution: Error: Timeout checking for stats for track {e314df0a-831d-443c-9c0d-cd91fb4aada1} after at least30000ms waitForRtpFlow@http://mochi.test:8888/tests/dom/media/tests/mochitest/pc.js:1612:11 ... asyncwaitForMediaFlow/<@http://mochi.test:8888/tests/dom/media/tests/mochitest/pc.js:1653:54 ... waitForMediaFlow@http://mochi.test:8888/tests/dom/media/tests/mochitest/pc.js:1653:36 ... PC_LOCAL_WAIT_FOR_MEDIA_FLOW@http://mochi.test:8888/tests/dom/media/tests/mochitest/templates.js:356:25 ... execute/</<@http://mochi.test:8888/tests/dom/media/tests/mochitest/head.js:851:31 ...
13:19:39 INFO - SimpleTest.ok@SimpleTest/SimpleTest.js:275:18
13:19:39 INFO - execute/<@dom/media/tests/mochitest/head.js:855:14
13:19:39 INFO - promise callbackexecute@dom/media/tests/mochitest/head.js:854:8
13:19:39 INFO - PeerConnectionTest.prototype.run@dom/media/tests/mochitest/pc.js:498:21
13:19:39 INFO - @dom/media/tests/mochitest/test_peerConnection_webAudio.html:38:8
13:19:39 INFO - runNetworkTest/<@dom/media/tests/mochitest/pc.js:2197:13
13:19:39 INFO - asyncrunTestWhenReady/<@dom/media/tests/mochitest/head.js:472:41
13:19:39 INFO - promise callbackrunTestWhenReady@dom/media/tests/mochitest/head.js:472:25
13:19:39 INFO - runNetworkTest@dom/media/tests/mochitest/pc.js:2179:9
13:19:39 INFO - async*@dom/media/tests/mochitest/test_peerConnection_webAudio.html:18:1
13:19:39 INFO - TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_webAudio.html | The author of the test has indicated that flaky timeouts are expected. Reason: WebRTC inherently depends on timeouts
13:19:39 INFO - Closing peer connections
13:19:39 INFO - Waiting for track {7084c072-a1b0-4dcb-83f2-996216ba7773} (audio) to end.
13:19:39 INFO - TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_webAudio.html | The author of the test has indicated that flaky timeouts are expected. Reason: WebRTC inherently depends on timeouts
13:19:39 INFO - TEST-PASS | dom/media/tests/mochitest/test_peerConnection_webAudio.html | iceConnectionState should not be undefined
13:19:39 INFO - PeerConnectionWrapper (pcLocal): oniceconnectionstatechange fired, new state is: closed

Comment 1

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform breakdown:

• windows10-64-shippable-qr: 1

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

Comment 2

[Firefox Bug Husbandry Bot]

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

Comment 3

[Noemi Erli[:noemi_erli]]

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

[task 2019-08-02T10:22:30.410Z] 10:22:30 INFO - Buffered messages finished
[task 2019-08-02T10:22:30.411Z] 10:22:30 INFO - TEST-UNEXPECTED-FAIL | dom/media/tests/mochitest/test_peerConnection_webAudio.html | Error in test execution: Error: Timeout checking for stats for track {f18e681b-da00-4169-9816-3fd258798d44} after at least30000ms waitForRtpFlow@http://mochi.test:8888/tests/dom/media/tests/mochitest/pc.js:1851:11 ... asyncwaitForMediaFlow/<@http://mochi.test:8888/tests/dom/media/tests/mochitest/pc.js:1917:56 ... waitForMediaFlow@http://mochi.test:8888/tests/dom/media/tests/mochitest/pc.js:1917:38 ... PC_LOCAL_WAIT_FOR_MEDIA_FLOW@http://mochi.test:8888/tests/dom/media/tests/mochitest/templates.js:513:25 ... execute/</<@http://mochi.test:8888/tests/dom/media/tests/mochitest/head.js:944:32 ...
[task 2019-08-02T10:22:30.411Z] 10:22:30 INFO - SimpleTest.ok@SimpleTest/SimpleTest.js:275:18
[task 2019-08-02T10:22:30.411Z] 10:22:30 INFO - execute/<@dom/media/tests/mochitest/head.js:948:11
[task 2019-08-02T10:22:30.411Z] 10:22:30 INFO - promise callbackexecute@dom/media/tests/mochitest/head.js:947:8
[task 2019-08-02T10:22:30.412Z] 10:22:30 INFO - PeerConnectionTest.prototype.run@dom/media/tests/mochitest/pc.js:574:6
[task 2019-08-02T10:22:30.412Z] 10:22:30 INFO - @dom/media/tests/mochitest/test_peerConnection_webAudio.html:38:8
[task 2019-08-02T10:22:30.412Z] 10:22:30 INFO - runNetworkTest/<@dom/media/tests/mochitest/pc.js:2564:11
[task 2019-08-02T10:22:30.413Z] 10:22:30 INFO - asyncrunTestWhenReady/<@dom/media/tests/mochitest/head.js:492:30
[task 2019-08-02T10:22:30.413Z] 10:22:30 INFO - promise callbackrunTestWhenReady@dom/media/tests/mochitest/head.js:492:6
[task 2019-08-02T10:22:30.413Z] 10:22:30 INFO - runNetworkTest@dom/media/tests/mochitest/pc.js:2545:9
[task 2019-08-02T10:22:30.413Z] 10:22:30 INFO - async*@dom/media/tests/mochitest/test_peerConnection_webAudio.html:18:15
[task 2019-08-02T10:22:30.414Z] 10:22:30 INFO - TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_webAudio.html | The author of the test has indicated that flaky timeouts are expected. Reason: WebRTC inherently depends on timeouts
[task 2019-08-02T10:22:30.415Z] 10:22:30 INFO - Closing peer connections

Comment 4

[Intermittent Failures Robot]

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

Comment 5

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform breakdown:

• windows10-64-shippable: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1561638&startday=2019-08-05&endday=2019-08-11&tree=all

Comment 6

[Firefox Bug Husbandry Bot]

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

Comment 7

[Natalia Csoregi [:nataliaCs]]

https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=276078814&repo=autoland&lineNumber=20161

Comment 8

[Intermittent Failures Robot]

1 failures in 4207 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=1561638&startday=2019-11-11&endday=2019-11-17&tree=all

Comment 9

[BugBot [:suhaib / :marco]]

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

Comment 10

[Razvan Maries]

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

Comment 11

[Intermittent Failures Robot]

1 failures in 4472 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=1561638&startday=2020-01-06&endday=2020-01-12&tree=all

Comment 12

[Intermittent Failures Robot]

1 failures in 4004 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=1561638&startday=2020-01-20&endday=2020-01-26&tree=all

Comment 13

[Intermittent Failures Robot]

1 failures in 4690 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=1561638&startday=2020-02-10&endday=2020-02-16&tree=all

Comment 14

[BugBot [:suhaib / :marco]]

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

Comment 15

[Daniel Varga [:dvarga]]

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

Comment 16

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform breakdown:

• windows10-64-shippable-qr: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1561638&startday=2020-04-13&endday=2020-04-19&tree=all

Comment 17

[BugBot [:suhaib / :marco]]

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

Comment 18

[Natalia Csoregi [:nataliaCs]]

https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=315544945&repo=mozilla-central&lineNumber=84709

Comment 19

[Intermittent Failures Robot]

1 failures in 3410 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=1561638&startday=2020-09-07&endday=2020-09-13&tree=all

Comment 20

[BugBot [:suhaib / :marco]]

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