1667627 - Intermittent dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.html | Error in test execution: Error: Checking stats for track {5e1798dc-2b29-40fd-941c-3c5c7e59a008} timed out after 30000 ms _waitForRtpFlow@https://example.com/tests/d

Status: RESOLVED DUPLICATE of bug 1710829

(Core :: WebRTC, defect, P5)

Description

[Treeherder Bug Filer]

Filed by: abutkovits [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=316814567&repo=mozilla-central
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/Tw3Zkmk6Q0qsioZrtvMljQ/runs/0/artifacts/public/logs/live_backing.log

---

[task 2020-09-26T23:28:47.547Z] 23:28:47     INFO - TEST-START | dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.html
[task 2020-09-26T23:28:47.730Z] 23:28:47     INFO - GECKO(9016) | TEST DEVICES: No test device found in media.audio_loopback_dev, using fake audio streams.
[task 2020-09-26T23:28:47.730Z] 23:28:47     INFO - GECKO(9016) | TEST DEVICES: No test device found in media.video_loopback_dev, using fake video streams.
[task 2020-09-26T23:28:47.789Z] 23:28:47     INFO - GECKO(9016) | Timecard created 1601162916.133000
[task 2020-09-26T23:28:47.789Z] 23:28:47     INFO - GECKO(9016) |  Timestamp   | Delta       | Event                          | File                         | Function
[task 2020-09-26T23:28:47.790Z] 23:28:47     INFO - GECKO(9016) | ======================================================================================================================
[task 2020-09-26T23:28:47.790Z] 23:28:47     INFO - GECKO(9016) |     0.000000 |    0.000000 | Constructor Completed          | PeerConnectionImpl.cpp:326   | PeerConnectionImpl
[task 2020-09-26T23:28:47.791Z] 23:28:47     INFO - GECKO(9016) |     0.001000 |    0.001000 | Initializing PC Ctx            | PeerConnectionImpl.cpp:455   | Initialize
[task 2020-09-26T23:28:47.791Z] 23:28:47     INFO - GECKO(9016) |     0.176000 |    0.175000 | Create Offer                   | PeerConnectionImpl.cpp:1217  | CreateOffer
[task 2020-09-26T23:28:47.791Z] 23:28:47     INFO - GECKO(9016) |     0.227000 |    0.051000 | Set Local Description          | PeerConnectionImpl.cpp:1286  | SetLocalDescription
[task 2020-09-26T23:28:47.791Z] 23:28:47     INFO - GECKO(9016) |     0.429000 |    0.202000 | Ice gathering state: gathering | PeerConnectionImpl.cpp:2528  | IceGatheringStateChange
[task 2020-09-26T23:28:47.791Z] 23:28:47     INFO - GECKO(9016) |     0.450000 |    0.021000 | Ice gathering state: complete  | PeerConnectionImpl.cpp:2531  | IceGatheringStateChange
[task 2020-09-26T23:28:47.791Z] 23:28:47     INFO - GECKO(9016) |     0.570000 |    0.120000 | Set Remote Description         | PeerConnectionImpl.cpp:1386  | SetRemoteDescription
[task 2020-09-26T23:28:47.791Z] 23:28:47     INFO - GECKO(9016) |     0.604000 |    0.034000 | Add Ice Candidate              | PeerConnectionImpl.cpp:1534  | AddIceCandidate
[task 2020-09-26T23:28:47.792Z] 23:28:47     INFO - GECKO(9016) |     0.613000 |    0.009000 | Look up mDNS name              | PeerConnectionImpl.cpp:1822  | StampTimecard
[task 2020-09-26T23:28:47.792Z] 23:28:47     INFO - GECKO(9016) |     0.614000 |    0.001000 | Add Ice Candidate              | PeerConnectionImpl.cpp:1534  | AddIceCandidate
[task 2020-09-26T23:28:47.792Z] 23:28:47     INFO - GECKO(9016) |     0.615000 |    0.001000 | Look up mDNS name              | PeerConnectionImpl.cpp:1822  | StampTimecard
[task 2020-09-26T23:28:47.792Z] 23:28:47     INFO - GECKO(9016) |     0.616000 |    0.001000 | Add Ice Candidate              | PeerConnectionImpl.cpp:1534  | AddIceCandidate
[task 2020-09-26T23:28:47.793Z] 23:28:47     INFO - GECKO(9016) |     0.617000 |    0.001000 | Done looking up mDNS name      | PeerConnectionImpl.cpp:1822  | StampTimecard
[task 2020-09-26T23:28:47.793Z] 23:28:47     INFO - GECKO(9016) |     0.617000 |    0.000000 | Done looking up mDNS name      | PeerConnectionImpl.cpp:1822  | StampTimecard
[task 2020-09-26T23:28:47.793Z] 23:28:47     INFO - GECKO(9016) |     0.633000 |    0.016000 | Ice state: checking            | PeerConnectionImpl.cpp:2472  | IceConnectionStateChange
[task 2020-09-26T23:28:47.794Z] 23:28:47     INFO - GECKO(9016) |     0.776000 |    0.143000 | Ice state: connected           | PeerConnectionImpl.cpp:2475  | IceConnectionStateChange
[task 2020-09-26T23:28:47.794Z] 23:28:47     INFO - GECKO(9016) |    11.645000 |   10.869000 | Destructor Invoked             | PeerConnectionImpl.cpp:335   | ~PeerConnectionImpl
[task 2020-09-26T23:28:47.795Z] 23:28:47     INFO - GECKO(9016) | [Child 8396: Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:360: ~PeerConnectionImpl: PeerConnectionImpl destructor invoked for a6724b52f46a1c06
[task 2020-09-26T23:28:47.795Z] 23:28:47     INFO - GECKO(9016) | Timecard created 1601162916.138000
[task 2020-09-26T23:28:47.795Z] 23:28:47     INFO - GECKO(9016) |  Timestamp   | Delta       | Event                          | File                         | Function
[task 2020-09-26T23:28:47.795Z] 23:28:47     INFO - GECKO(9016) | ======================================================================================================================
[task 2020-09-26T23:28:47.796Z] 23:28:47     INFO - GECKO(9016) |     0.000000 |    0.000000 | Constructor Completed          | PeerConnectionImpl.cpp:326   | PeerConnectionImpl
[task 2020-09-26T23:28:47.796Z] 23:28:47     INFO - GECKO(9016) |     0.001000 |    0.001000 | Initializing PC Ctx            | PeerConnectionImpl.cpp:455   | Initialize
[task 2020-09-26T23:28:47.796Z] 23:28:47     INFO - GECKO(9016) |     0.252000 |    0.251000 | Set Remote Description         | PeerConnectionImpl.cpp:1386  | SetRemoteDescription
[task 2020-09-26T23:28:47.796Z] 23:28:47     INFO - GECKO(9016) |     0.388000 |    0.136000 | Create Answer                  | PeerConnectionImpl.cpp:1248  | CreateAnswer
[task 2020-09-26T23:28:47.796Z] 23:28:47     INFO - GECKO(9016) |     0.474000 |    0.086000 | Add Ice Candidate              | PeerConnectionImpl.cpp:1534  | AddIceCandidate
[task 2020-09-26T23:28:47.797Z] 23:28:47     INFO - GECKO(9016) |     0.518000 |    0.044000 | Add Ice Candidate              | PeerConnectionImpl.cpp:1534  | AddIceCandidate
[task 2020-09-26T23:28:47.797Z] 23:28:47     INFO - GECKO(9016) |     0.522000 |    0.004000 | Add Ice Candidate              | PeerConnectionImpl.cpp:1534  | AddIceCandidate
[task 2020-09-26T23:28:47.797Z] 23:28:47     INFO - GECKO(9016) |     0.523000 |    0.001000 | Add Ice Candidate              | PeerConnectionImpl.cpp:1534  | AddIceCandidate
[task 2020-09-26T23:28:47.797Z] 23:28:47     INFO - GECKO(9016) |     0.524000 |    0.001000 | Add Ice Candidate              | PeerConnectionImpl.cpp:1534  | AddIceCandidate
[task 2020-09-26T23:28:47.797Z] 23:28:47     INFO - GECKO(9016) |     0.526000 |    0.002000 | Add Ice Candidate              | PeerConnectionImpl.cpp:1534  | AddIceCandidate
[task 2020-09-26T23:28:47.797Z] 23:28:47     INFO - GECKO(9016) |     0.527000 |    0.001000 | Add Ice Candidate              | PeerConnectionImpl.cpp:1534  | AddIceCandidate
[task 2020-09-26T23:28:47.799Z] 23:28:47     INFO - GECKO(9016) |     0.528000 |    0.001000 | Add Ice Candidate              | PeerConnectionImpl.cpp:1534  | AddIceCandidate
[task 2020-09-26T23:28:47.799Z] 23:28:47     INFO - GECKO(9016) |     0.529000 |    0.001000 | Add Ice Candidate              | PeerConnectionImpl.cpp:1534  | AddIceCandidate
[task 2020-09-26T23:28:47.799Z] 23:28:47     INFO - GECKO(9016) |     0.530000 |    0.001000 | Add Ice Candidate              | PeerConnectionImpl.cpp:1534  | AddIceCandidate
[task 2020-09-26T23:28:47.799Z] 23:28:47     INFO - GECKO(9016) |     0.538000 |    0.008000 | Set Local Description          | PeerConnectionImpl.cpp:1286  | SetLocalDescription
[task 2020-09-26T23:28:47.801Z] 23:28:47     INFO - GECKO(9016) |     0.584000 |    0.046000 | Look up mDNS name              | PeerConnectionImpl.cpp:1822  | StampTimecard
[task 2020-09-26T23:28:47.801Z] 23:28:47     INFO - GECKO(9016) |     0.584000 |    0.000000 | Look up mDNS name              | PeerConnectionImpl.cpp:1822  | StampTimecard
[task 2020-09-26T23:28:47.803Z] 23:28:47     INFO - GECKO(9016) |     0.584000 |    0.000000 | Look up mDNS name              | PeerConnectionImpl.cpp:1822  | StampTimecard
[task 2020-09-26T23:28:47.804Z] 23:28:47     INFO - GECKO(9016) |     0.584000 |    0.000000 | Look up mDNS name              | PeerConnectionImpl.cpp:1822  | StampTimecard
[task 2020-09-26T23:28:47.804Z] 23:28:47     INFO - GECKO(9016) |     0.584000 |    0.000000 | Ice gathering state: gathering | PeerConnectionImpl.cpp:2528  | IceGatheringStateChange
[task 2020-09-26T23:28:47.804Z] 23:28:47     INFO - GECKO(9016) |     0.593000 |    0.009000 | Ice gathering state: complete  | PeerConnectionImpl.cpp:2531  | IceGatheringStateChange
[task 2020-09-26T23:28:47.804Z] 23:28:47     INFO - GECKO(9016) |     0.607000 |    0.014000 | Done looking up mDNS name      | PeerConnectionImpl.cpp:1822  | StampTimecard
[task 2020-09-26T23:28:47.804Z] 23:28:47     INFO - GECKO(9016) |     0.607000 |    0.000000 | Done looking up mDNS name      | PeerConnectionImpl.cpp:1822  | StampTimecard
[task 2020-09-26T23:28:47.806Z] 23:28:47     INFO - GECKO(9016) |     0.607000 |    0.000000 | Done looking up mDNS name      | PeerConnectionImpl.cpp:1822  | StampTimecard
[task 2020-09-26T23:28:47.806Z] 23:28:47     INFO - GECKO(9016) |     0.607000 |    0.000000 | Done looking up mDNS name      | PeerConnectionImpl.cpp:1822  | StampTimecard
[task 2020-09-26T23:28:47.806Z] 23:28:47     INFO - GECKO(9016) |     0.616000 |    0.009000 | Ice state: checking            | PeerConnectionImpl.cpp:2472  | IceConnectionStateChange
[task 2020-09-26T23:28:47.806Z] 23:28:47     INFO - GECKO(9016) |     0.771000 |    0.155000 | Ice state: connected           | PeerConnectionImpl.cpp:2475  | IceConnectionStateChange
[task 2020-09-26T23:28:47.806Z] 23:28:47     INFO - GECKO(9016) |    11.649000 |   10.878000 | Destructor Invoked             | PeerConnectionImpl.cpp:335   | ~PeerConnectionImpl
[task 2020-09-26T23:28:47.806Z] 23:28:47     INFO - GECKO(9016) | [Child 8396: Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:360: ~PeerConnectionImpl: PeerConnectionImpl destructor invoked for ab7d303db649a1ca
[task 2020-09-26T23:28:47.969Z] 23:28:47     INFO - GECKO(9016) | [Child 8396: Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:325: PeerConnectionImpl: PeerConnectionImpl constructor for
[task 2020-09-26T23:28:47.969Z] 23:28:47     INFO - GECKO(9016) | [Parent 8596: Socket Thread]: D/mtransport NrIceCtx static call to find local stun addresses
[task 2020-09-26T23:28:47.969Z] 23:28:47     INFO - GECKO(9016) | [Child 8396: Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:325: PeerConnectionImpl: PeerConnectionImpl constructor for
[task 2020-09-26T23:28:47.974Z] 23:28:47     INFO - GECKO(9016) | [Parent 8596: Socket Thread]: D/mtransport NrIceCtx static call to find local stun addresses
[task 2020-09-26T23:28:47.979Z] 23:28:47     INFO - GECKO(9016) | TEST DEVICES: No test device found in media.audio_loopback_dev, using fake audio streams.
[task 2020-09-26T23:28:47.979Z] 23:28:47     INFO - GECKO(9016) | TEST DEVICES: No test device found in media.video_loopback_dev, using fake video streams.
[task 2020-09-26T23:28:47.979Z] 23:28:47     INFO - GECKO(9016) | TEST DEVICES: No test device found in media.audio_loopback_dev, using fake audio streams.
[task 2020-09-26T23:28:47.979Z] 23:28:47     INFO - GECKO(9016) | TEST DEVICES: No test device found in media.video_loopback_dev, using fake video streams.
[task 2020-09-26T23:28:47.985Z] 23:28:47     INFO - GECKO(9016) | [Child 8396: Main Thread]: I/signaling [main|PeerConnectionMedia] PeerConnectionMedia.cpp:74: OnStunAddrsAvailable: receiving (4) stun addrs
[task 2020-09-26T23:28:47.985Z] 23:28:47     INFO - GECKO(9016) | [Child 8396: Main Thread]: I/signaling [main|PeerConnectionMedia] PeerConnectionMedia.cpp:74: OnStunAddrsAvailable: receiving (4) stun addrs
[task 2020-09-26T23:28:48.128Z] 23:28:48     INFO - GECKO(9016) | TEST DEVICES: No test device found in media.audio_loopback_dev, using fake audio streams.
[task 2020-09-26T23:28:48.128Z] 23:28:48     INFO - GECKO(9016) | TEST DEVICES: No test device found in media.video_loopback_dev, using fake video streams.
[task 2020-09-26T23:28:48.128Z] 23:28:48     INFO - GECKO(9016) | TEST DEVICES: No test device found in media.audio_loopback_dev, using fake audio streams.
[task 2020-09-26T23:28:48.128Z] 23:28:48     INFO - GECKO(9016) | TEST DEVICES: No test device found in media.video_loopback_dev, using fake video streams.
[task 2020-09-26T23:28:48.273Z] 23:28:48     INFO - GECKO(9016) | [Child 8396: Main Thread]: I/signaling [main|sdp_config] sdp_config.c:86: SDP: Initialized config pointer: 0000116A795322C0
[task 2020-09-26T23:28:48.283Z] 23:28:48     INFO - GECKO(9016) | [Child 8396: Main Thread]: I/jsep [1601162927960000 (id=2147484259 url=https://example.com/tests/dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.htm]: stable -> have-local-offer
[task 2020-09-26T23:28:48.287Z] 23:28:48     INFO - GECKO(9016) | [Child 8396: Main Thread]: I/signaling [main|sdp_config] sdp_config.c:86: SDP: Initialized config pointer: 0000116A7934BDA0
[task 2020-09-26T23:28:48.297Z] 23:28:48     INFO - GECKO(9016) | [Child 8396: Main Thread]: I/jsep [1601162927964000 (id=2147484259 url=https://example.com/tests/dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.htm]: stable -> have-remote-offer
[task 2020-09-26T23:28:48.302Z] 23:28:48     INFO - GECKO(9016) | (generic/EMERG) Exit UDP socket connected
[task 2020-09-26T23:28:48.304Z] 23:28:48     INFO - GECKO(9016) | (ice/WARNING) z:/build/build/src/dom/media/webrtc/transport/third_party/nICEr/src/net/nr_socket_multi_tcp.c:617 function nr_socket_multi_tcp_listen failed with error 3
[task 2020-09-26T23:28:48.306Z] 23:28:48     INFO - GECKO(9016) | (ice/WARNING) ICE(PC:1601162927960000 (id=2147484259 url=https://example.com/tests/dom/media/tests/moc
[task 2020-09-26T23:28:48.306Z] 23:28:48     INFO - GECKO(9016) | hitest/test_peerConnection_twoAudioStreams.htm): failed to create passive TCP host candidate: 3
[task 2020-09-26T23:28:48.307Z] 23:28:48     INFO - GECKO(9016) | (ice/WARNING) z:/build/build/src/dom/media/webrtc/transport/third_party/nICEr/src/net/nr_socket_multi_tcp.c:617 function nr_socket_multi_tcp_listen failed with error 3
[task 2020-09-26T23:28:48.307Z] 23:28:48     INFO - GECKO(9016) | (ice/WARNING) ICE(PC:1601162927960000 (id=2147484259 url=https://example.com/tests/dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.htm): failed to create passive TCP host candidate: 3
[task 2020-09-26T23:28:48.308Z] 23:28:48     INFO - GECKO(9016) | [Child 8396: Socket Thread]: D/mtransport NrIceCtx(PC:1601162927960000 (id=2147484259 url=https://example.com/tests/dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.htm): trickling candidate candidate:0 1 UDP 2122252543 b7c9d400-cb7c-41c9-9d77-ba308c0a50b3.local 54927 typ host
[task 2020-09-26T23:28:48.308Z] 23:28:48     INFO - GECKO(9016) | [Child 8396: Socket Thread]: D/mtransport Couldn't get default ICE candidate for 'PC:1601162927960000 (id=2147484259 url=https://example.com/tests/dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.htm transport-id=transport_0', no candidates.
[task 2020-09-26T23:28:48.308Z] 23:28:48     INFO - GECKO(9016) | [Child 8396: Socket Thread]: D/mtransport NrIceCtx(PC:1601162927960000 (id=2147484259 url=https://example.com/tests/dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.htm): trickling candidate candidate:1 1 TCP 2105524479 b7c9d400-cb7c-41c9-9d77-ba308c0a50b3.local 9 typ host tcptype active
[task 2020-09-26T23:28:48.308Z] 23:28:48     INFO - GECKO(9016) | [Child 8396: Socket Thread]: D/mtransport Couldn't get default ICE candidate for 'PC:1601162927960000 (id=2147484259 url=https://example.com/tests/dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.htm transport-id=transport_0', no candidates.
[task 2020-09-26T23:28:48.309Z] 23:28:48     INFO - GECKO(9016) | [Child 8396: Socket Thread]: D/mtransport NrIceCtx(PC:1601162927960000 (id=2147484259 url=https://example.com/tests/dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.htm): trickling candidate candidate:0 2 UDP 2122252542 b7c9d400-cb7c-41c9-9d77-ba308c0a50b3.local 54928 typ host
[task 2020-09-26T23:28:48.309Z] 23:28:48     INFO - GECKO(9016) | [Child 8396: Socket Thread]: D/mtransport NrIceCtx(PC:1601162927960000 (id=2147484259 url=https://example.com/tests/dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.htm): trickling candidate candidate:1 2 TCP 2105524478 b7c9d400-cb7c-41c9-9d77-ba308c0a50b3.local 9 typ host tcptype active
[task 2020-09-26T23:28:48.309Z] 23:28:48     INFO - GECKO(9016) | (ice/INFO) ICE(PC:1601162927960000 (id=2147484259 url=https://example.com/tests/dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.htm): All candidates initialized
[task 2020-09-26T23:28:48.450Z] 23:28:48     INFO - GECKO(9016) | [Child 8396: Main Thread]: I/signaling [main|sdp_config] sdp_config.c:86: SDP: Initialized config pointer: 0000116A79577FF0
[task 2020-09-26T23:28:48.454Z] 23:28:48     INFO - GECKO(9016) | [Child 8396: Main Thread]: I/jsep [1601162927964000 (id=2147484259 url=https://example.com/tests/dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.htm]: have-remote-offer -> stable
[task 2020-09-26T23:28:48.455Z] 23:28:48     INFO - GECKO(9016) | (generic/EMERG) Exit UDP socket connected
[task 2020-09-26T23:28:48.455Z] 23:28:48     INFO - GECKO(9016) | (ice/WARNING) z:/build/build/src/dom/media/webrtc/transport/third_party/nICEr/src/net/nr_socket_multi_tcp.c:617 function nr_socket_multi_tcp_listen failed with error 3
[task 2020-09-26T23:28:48.455Z] 23:28:48     INFO - GECKO(9016) | (ice/WARNING) ICE(PC:1601162927964000 (id=2147484259 url=https://example.com/tests/dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.htm): failed to create passive TCP host ca[Child 8396: Main Thread]: I/signaling [main|WebrtcAudioSessionConduit] AudioConduit.cpp:255: SetDtmfPayloadType : setting dtmf payload 101
[task 2020-09-26T23:28:48.455Z] 23:28:48     INFO - GECKO(9016) | ndidate: 3
[task 2020-09-26T23:28:48.457Z] 23:28:48     INFO - GECKO(9016) | [Child 8396: Main Thread]: I/signaling 
.............
rack {5e1798dc-2b29-40fd-941c-3c5c7e59a008} has 0 packetsReceived.
[task 2020-09-26T23:29:19.177Z] 23:29:19     INFO - TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.html | The author of the test has indicated that flaky timeouts are expected.  Reason: WebRTC inherently depends on timeouts 
[task 2020-09-26T23:29:19.178Z] 23:29:19     INFO - Checking inbound-rtp for audio track {940cabbb-7b75-4784-9e56-2a1b164bc6dc} try 52
[task 2020-09-26T23:29:19.178Z] 23:29:19     INFO - Track {940cabbb-7b75-4784-9e56-2a1b164bc6dc} has 0 packetsReceived.
[task 2020-09-26T23:29:19.179Z] 23:29:19     INFO - TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.html | The author of the test has indicated that flaky timeouts are expected.  Reason: WebRTC inherently depends on timeouts 
[task 2020-09-26T23:29:19.179Z] 23:29:19     INFO - Checking outbound-rtp for audio track {68e36669-dbc2-4df2-9c36-19a19870fb8e} try 52
[task 2020-09-26T23:29:19.180Z] 23:29:19     INFO - Checking outbound-rtp for audio track {80b399c0-5bd9-4ec6-b6c4-7c6533598f02} try 52
[task 2020-09-26T23:29:19.180Z] 23:29:19     INFO - Track {68e36669-dbc2-4df2-9c36-19a19870fb8e} has 0 packetsSent.
[task 2020-09-26T23:29:19.180Z] 23:29:19     INFO - TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.html | The author of the test has indicated that flaky timeouts are expected.  Reason: WebRTC inherently depends on timeouts 
[task 2020-09-26T23:29:19.180Z] 23:29:19     INFO - Track {80b399c0-5bd9-4ec6-b6c4-7c6533598f02} has 0 packetsSent.
[task 2020-09-26T23:29:19.181Z] 23:29:19     INFO - TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.html | The author of the test has indicated that flaky timeouts are expected.  Reason: WebRTC inherently depends on timeouts 
[task 2020-09-26T23:29:19.181Z] 23:29:19     INFO - Buffered messages logged at 23:29:15
[task 2020-09-26T23:29:19.181Z] 23:29:19     INFO - Checking inbound-rtp for audio track {5e1798dc-2b29-40fd-941c-3c5c7e59a008} try 53
[task 2020-09-26T23:29:19.182Z] 23:29:19     INFO - Track {5e1798dc-2b29-40fd-941c-3c5c7e59a008} has 0 packetsReceived.
[task 2020-09-26T23:29:19.182Z] 23:29:19     INFO - TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.html | The author of the test has indicated that flaky timeouts are expected.  Reason: WebRTC inherently depends on timeouts 
[task 2020-09-26T23:29:19.183Z] 23:29:19     INFO - Checking inbound-rtp for audio track {940cabbb-7b75-4784-9e56-2a1b164bc6dc} try 53
[task 2020-09-26T23:29:19.183Z] 23:29:19     INFO - Track {940cabbb-7b75-4784-9e56-2a1b164bc6dc} has 0 packetsReceived.
[task 2020-09-26T23:29:19.184Z] 23:29:19     INFO - TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.html | The author of the test has indicated that flaky timeouts are expected.  Reason: WebRTC inherently depends on timeouts 
[task 2020-09-26T23:29:19.184Z] 23:29:19     INFO - Checking outbound-rtp for audio track {68e36669-dbc2-4df2-9c36-19a19870fb8e} try 53
[task 2020-09-26T23:29:19.185Z] 23:29:19     INFO - Checking outbound-rtp for audio track {80b399c0-5bd9-4ec6-b6c4-7c6533598f02} try 53
[task 2020-09-26T23:29:19.185Z] 23:29:19     INFO - Track {68e36669-dbc2-4df2-9c36-19a19870fb8e} has 0 packetsSent.
[task 2020-09-26T23:29:19.186Z] 23:29:19     INFO - TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.html | The author of the test has indicated that flaky timeouts are expected.  Reason: WebRTC inherently depends on timeouts 
[task 2020-09-26T23:29:19.186Z] 23:29:19     INFO - Track {80b399c0-5bd9-4ec6-b6c4-7c6533598f02} has 0 packetsSent.
[task 2020-09-26T23:29:19.187Z] 23:29:19     INFO - TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.html | The author of the test has indicated that flaky timeouts are expected.  Reason: WebRTC inherently depends on timeouts 
[task 2020-09-26T23:29:19.187Z] 23:29:19     INFO - Checking inbound-rtp for audio track {5e1798dc-2b29-40fd-941c-3c5c7e59a008} try 54
[task 2020-09-26T23:29:19.188Z] 23:29:19     INFO - Checking inbound-rtp for audio track {940cabbb-7b75-4784-9e56-2a1b164bc6dc} try 54
[task 2020-09-26T23:29:19.188Z] 23:29:19     INFO - Track {5e1798dc-2b29-40fd-941c-3c5c7e59a008} has 0 packetsReceived.
[task 2020-09-26T23:29:19.188Z] 23:29:19     INFO - TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.html | The author of the test has indicated that flaky timeouts are expected.  Reason: WebRTC inherently depends on timeouts 
[task 2020-09-26T23:29:19.189Z] 23:29:19     INFO - Track {940cabbb-7b75-4784-9e56-2a1b164bc6dc} has 0 packetsReceived.
[task 2020-09-26T23:29:19.189Z] 23:29:19     INFO - TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.html | The author of the test has indicated that flaky timeouts are expected.  Reason: WebRTC inherently depends on timeouts 
[task 2020-09-26T23:29:19.190Z] 23:29:19     INFO - Checking outbound-rtp for audio track {68e36669-dbc2-4df2-9c36-19a19870fb8e} try 54
[task 2020-09-26T23:29:19.190Z] 23:29:19     INFO - Track {68e36669-dbc2-4df2-9c36-19a19870fb8e} has 0 packetsSent.
[task 2020-09-26T23:29:19.191Z] 23:29:19     INFO - TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.html | The author of the test has indicated that flaky timeouts are expected.  Reason: WebRTC inherently depends on timeouts 
[task 2020-09-26T23:29:19.191Z] 23:29:19     INFO - Checking outbound-rtp for audio track {80b399c0-5bd9-4ec6-b6c4-7c6533598f02} try 54
[task 2020-09-26T23:29:19.192Z] 23:29:19     INFO - Track {80b399c0-5bd9-4ec6-b6c4-7c6533598f02} has 0 packetsSent.
[task 2020-09-26T23:29:19.192Z] 23:29:19     INFO - TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.html | The author of the test has indicated that flaky timeouts are expected.  Reason: WebRTC inherently depends on timeouts 
[task 2020-09-26T23:29:19.193Z] 23:29:19     INFO - Buffered messages logged at 23:29:16
[task 2020-09-26T23:29:19.193Z] 23:29:19     INFO - Checking inbound-rtp for audio track {5e1798dc-2b29-40fd-941c-3c5c7e59a008} try 55
[task 2020-09-26T23:29:19.193Z] 23:29:19     INFO - Checking inbound-rtp for audio track {940cabbb-7b75-4784-9e56-2a1b164bc6dc} try 55
[task 2020-09-26T23:29:19.194Z] 23:29:19     INFO - Track {5e1798dc-2b29-40fd-941c-3c5c7e59a008} has 0 packetsReceived.
[task 2020-09-26T23:29:19.194Z] 23:29:19     INFO - TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.html | The author of the test has indicated that flaky timeouts are expected.  Reason: WebRTC inherently depends on timeouts 
[task 2020-09-26T23:29:19.195Z] 23:29:19     INFO - Track {940cabbb-7b75-4784-9e56-2a1b164bc6dc} has 0 packetsReceived.
[task 2020-09-26T23:29:19.195Z] 23:29:19     INFO - TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.html | The author of the test has indicated that flaky timeouts are expected.  Reason: WebRTC inherently depends on timeouts 
[task 2020-09-26T23:29:19.196Z] 23:29:19     INFO - Checking outbound-rtp for audio track {68e36669-dbc2-4df2-9c36-19a19870fb8e} try 55
[task 2020-09-26T23:29:19.197Z] 23:29:19     INFO - Track {68e36669-dbc2-4df2-9c36-19a19870fb8e} has 0 packetsSent.
[task 2020-09-26T23:29:19.197Z] 23:29:19     INFO - TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.html | The author of the test has indicated that flaky timeouts are expected.  Reason: WebRTC inherently depends on timeouts 
[task 2020-09-26T23:29:19.198Z] 23:29:19     INFO - Checking outbound-rtp for audio track {80b399c0-5bd9-4ec6-b6c4-7c6533598f02} try 55
[task 2020-09-26T23:29:19.198Z] 23:29:19     INFO - Track {80b399c0-5bd9-4ec6-b6c4-7c6533598f02} has 0 packetsSent.
[task 2020-09-26T23:29:19.199Z] 23:29:19     INFO - TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.html | The author of the test has indicated that flaky timeouts are expected.  Reason: WebRTC inherently depends on timeouts 
[task 2020-09-26T23:29:19.199Z] 23:29:19     INFO - Checking inbound-rtp for audio track {5e1798dc-2b29-40fd-941c-3c5c7e59a008} try 56
[task 2020-09-26T23:29:19.200Z] 23:29:19     INFO - Checking inbound-rtp for audio track {940cabbb-7b75-4784-9e56-2a1b164bc6dc} try 56
[task 2020-09-26T23:29:19.201Z] 23:29:19     INFO - Track {5e1798dc-2b29-40fd-941c-3c5c7e59a008} has 0 packetsReceived.
[task 2020-09-26T23:29:19.201Z] 23:29:19     INFO - TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.html | The author of the test has indicated that flaky timeouts are expected.  Reason: WebRTC inherently depends on timeouts 
[task 2020-09-26T23:29:19.204Z] 23:29:19     INFO - Track {940cabbb-7b75-4784-9e56-2a1b164bc6dc} has 0 packetsReceived.
[task 2020-09-26T23:29:19.204Z] 23:29:19     INFO - TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.html | The author of the test has indicated that flaky timeouts are expected.  Reason: WebRTC inherently depends on timeouts 
[task 2020-09-26T23:29:19.204Z] 23:29:19     INFO - Checking outbound-rtp for audio track {68e36669-dbc2-4df2-9c36-19a19870fb8e} try 56
[task 2020-09-26T23:29:19.205Z] 23:29:19     INFO - Track {68e36669-dbc2-4df2-9c36-19a19870fb8e} has 0 packetsSent.
[task 2020-09-26T23:29:19.205Z] 23:29:19     INFO - TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.html | The author of the test has indicated that flaky timeouts are expected.  Reason: WebRTC inherently depends on timeouts 
[task 2020-09-26T23:29:19.205Z] 23:29:19     INFO - Checking outbound-rtp for audio track {80b399c0-5bd9-4ec6-b6c4-7c6533598f02} try 56
[task 2020-09-26T23:29:19.206Z] 23:29:19     INFO - Track {80b399c0-5bd9-4ec6-b6c4-7c6533598f02} has 0 packetsSent.
[task 2020-09-26T23:29:19.206Z] 23:29:19     INFO - TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.html | The author of the test has indicated that flaky timeouts are expected.  Reason: WebRTC inherently depends on timeouts 
[task 2020-09-26T23:29:19.206Z] 23:29:19     INFO - Buffered messages logged at 23:29:17
[task 2020-09-26T23:29:19.206Z] 23:29:19     INFO - Checking inbound-rtp for audio track {5e1798dc-2b29-40fd-941c-3c5c7e59a008} try 57
[task 2020-09-26T23:29:19.206Z] 23:29:19     INFO - Checking inbound-rtp for audio track {940cabbb-7b75-4784-9e56-2a1b164bc6dc} try 57
[task 2020-09-26T23:29:19.206Z] 23:29:19     INFO - Track {5e1798dc-2b29-40fd-941c-3c5c7e59a008} has 0 packetsReceived.
[task 2020-09-26T23:29:19.206Z] 23:29:19     INFO - TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.html | The author of the test has indicated that flaky timeouts are expected.  Reason: WebRTC inherently depends on timeouts 
[task 2020-09-26T23:29:19.206Z] 23:29:19     INFO - Track {940cabbb-7b75-4784-9e56-2a1b164bc6dc} has 0 packetsReceived.
[task 2020-09-26T23:29:19.207Z] 23:29:19     INFO - TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.html | The author of the test has indicated that flaky timeouts are expected.  Reason: WebRTC inherently depends on timeouts 
[task 2020-09-26T23:29:19.207Z] 23:29:19     INFO - Checking outbound-rtp for audio track {68e36669-dbc2-4df2-9c36-19a19870fb8e} try 57
[task 2020-09-26T23:29:19.207Z] 23:29:19     INFO - Track {68e36669-dbc2-4df2-9c36-19a19870fb8e} has 0 packetsSent.
[task 2020-09-26T23:29:19.207Z] 23:29:19     INFO - TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.html | The author of the test has indicated that flaky timeouts are expected.  Reason: WebRTC inherently depends on timeouts 
[task 2020-09-26T23:29:19.207Z] 23:29:19     INFO - Checking outbound-rtp for audio track {80b399c0-5bd9-4ec6-b6c4-7c6533598f02} try 57
[task 2020-09-26T23:29:19.208Z] 23:29:19     INFO - Track {80b399c0-5bd9-4ec6-b6c4-7c6533598f02} has 0 packetsSent.
[task 2020-09-26T23:29:19.208Z] 23:29:19     INFO - TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.html | The author of the test has indicated that flaky timeouts are expected.  Reason: WebRTC inherently depends on timeouts 
[task 2020-09-26T23:29:19.208Z] 23:29:19     INFO - Checking inbound-rtp for audio track {5e1798dc-2b29-40fd-941c-3c5c7e59a008} try 58
[task 2020-09-26T23:29:19.208Z] 23:29:19     INFO - Track {5e1798dc-2b29-40fd-941c-3c5c7e59a008} has 0 packetsReceived.
[task 2020-09-26T23:29:19.208Z] 23:29:19     INFO - TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.html | The author of the test has indicated that flaky timeouts are expected.  Reason: WebRTC inherently depends on timeouts 
[task 2020-09-26T23:29:19.208Z] 23:29:19     INFO - Checking inbound-rtp for audio track {940cabbb-7b75-4784-9e56-2a1b164bc6dc} try 58
[task 2020-09-26T23:29:19.208Z] 23:29:19     INFO - Track {940cabbb-7b75-4784-9e56-2a1b164bc6dc} has 0 packetsReceived.
[task 2020-09-26T23:29:19.208Z] 23:29:19     INFO - TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.html | The author of the test has indicated that flaky timeouts are expected.  Reason: WebRTC inherently depends on timeouts 
[task 2020-09-26T23:29:19.209Z] 23:29:19     INFO - Checking outbound-rtp for audio track {68e36669-dbc2-4df2-9c36-19a19870fb8e} try 58
[task 2020-09-26T23:29:19.209Z] 23:29:19     INFO - Track {68e36669-dbc2-4df2-9c36-19a19870fb8e} has 0 packetsSent.
[task 2020-09-26T23:29:19.209Z] 23:29:19     INFO - TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.html | The author of the test has indicated that flaky timeouts are expected.  Reason: WebRTC inherently depends on timeouts 
[task 2020-09-26T23:29:19.209Z] 23:29:19     INFO - Checking outbound-rtp for audio track {80b399c0-5bd9-4ec6-b6c4-7c6533598f02} try 58
[task 2020-09-26T23:29:19.209Z] 23:29:19     INFO - Track {80b399c0-5bd9-4ec6-b6c4-7c6533598f02} has 0 packetsSent.
[task 2020-09-26T23:29:19.209Z] 23:29:19     INFO - TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.html | The author of the test has indicated that flaky timeouts are expected.  Reason: WebRTC inherently depends on timeouts 
[task 2020-09-26T23:29:19.209Z] 23:29:19     INFO - Buffered messages logged at 23:29:18
[task 2020-09-26T23:29:19.210Z] 23:29:19     INFO - Checking inbound-rtp for audio track {5e1798dc-2b29-40fd-941c-3c5c7e59a008} try 59
[task 2020-09-26T23:29:19.210Z] 23:29:19     INFO - Track {5e1798dc-2b29-40fd-941c-3c5c7e59a008} has 0 packetsReceived.
[task 2020-09-26T23:29:19.210Z] 23:29:19     INFO - TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.html | The author of the test has indicated that flaky timeouts are expected.  Reason: WebRTC inherently depends on timeouts 
[task 2020-09-26T23:29:19.210Z] 23:29:19     INFO - Checking inbound-rtp for audio track {940cabbb-7b75-4784-9e56-2a1b164bc6dc} try 59
[task 2020-09-26T23:29:19.210Z] 23:29:19     INFO - Track {940cabbb-7b75-4784-9e56-2a1b164bc6dc} has 0 packetsReceived.
[task 2020-09-26T23:29:19.210Z] 23:29:19     INFO - TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.html | The author of the test has indicated that flaky timeouts are expected.  Reason: WebRTC inherently depends on timeouts 
[task 2020-09-26T23:29:19.210Z] 23:29:19     INFO - Checking outbound-rtp for audio track {68e36669-dbc2-4df2-9c36-19a19870fb8e} try 59
[task 2020-09-26T23:29:19.210Z] 23:29:19     INFO - Track {68e36669-dbc2-4df2-9c36-19a19870fb8e} has 0 packetsSent.
[task 2020-09-26T23:29:19.211Z] 23:29:19     INFO - TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.html | The author of the test has indicated that flaky timeouts are expected.  Reason: WebRTC inherently depends on timeouts 
[task 2020-09-26T23:29:19.211Z] 23:29:19     INFO - Checking outbound-rtp for audio track {80b399c0-5bd9-4ec6-b6c4-7c6533598f02} try 59
[task 2020-09-26T23:29:19.211Z] 23:29:19     INFO - Track {80b399c0-5bd9-4ec6-b6c4-7c6533598f02} has 0 packetsSent.
[task 2020-09-26T23:29:19.211Z] 23:29:19     INFO - TEST-FAIL | dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.html | The author of the test has indicated that flaky timeouts are expected.  Reason: WebRTC inherently depends on timeouts 
[task 2020-09-26T23:29:19.211Z] 23:29:19     INFO - Buffered messages finished
[task 2020-09-26T23:29:19.211Z] 23:29:19     INFO - TEST-UNEXPECTED-FAIL | dom/media/tests/mochitest/test_peerConnection_twoAudioStreams.html | Error in test execution: Error: Checking stats for track {5e1798dc-2b29-40fd-941c-3c5c7e59a008} timed out after 30000 ms _waitForRtpFlow@https://example.com/tests/dom/media/tests/mochitest/pc.js:1820:11 ... ```

Comment 1

[Intermittent Failures Robot]

1 failures in 4019 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=1667627&startday=2020-09-21&endday=2020-09-27&tree=all

Comment 3

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform breakdown:

• android-em-7-0-x86_64: 1

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

Comment 4

[BugBot [:suhaib / :marco]]

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

Comment 5

[Razvan Maries]

New occurrence: https://treeherder.mozilla.org/logviewer?job_id=322944692&repo=mozilla-central&lineNumber=52537

Comment 6

[Intermittent Failures Robot]

1 failures in 1479 pushes (0.001 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/bugdetails?bug=1667627&startday=2020-11-23&endday=2020-11-29&tree=all

Comment 7

[BugBot [:suhaib / :marco]]

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

Comment 8

[Bogdan Tara[:bogdan_tara | bogdant]]

This is still happening.

Recent failure: https://treeherder.mozilla.org/logviewer?job_id=325760067&repo=autoland&lineNumber=52916

Comment 9

[Intermittent Failures Robot]

1 failures in 2956 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/bugdetails?bug=1667627&startday=2021-01-04&endday=2021-01-10&tree=all

Comment 10

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• windows10-64: 1
  • asan: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1667627&startday=2021-01-25&endday=2021-01-31&tree=all

Comment 11

[Intermittent Failures Robot]

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

Repository breakdown:

• try: 1

Platform and build breakdown:

• windows10-64: 1
  • asan: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1667627&startday=2021-02-01&endday=2021-02-07&tree=all

Comment 12

[BugBot [:suhaib / :marco]]

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

Comment 13

[Atila Butkovits]

Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=337932066&repo=autoland&lineNumber=54261

Comment 14

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 2

Platform and build breakdown:

• windows10-64: 1
  • asan: 1
• windows10-64-qr: 1
  • debug: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1667627&startday=2021-04-26&endday=2021-05-02&tree=all

Comment 15

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• windows10-64: 1
  • debug: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1667627&startday=2021-05-03&endday=2021-05-09&tree=all