1602604 - Intermittent dom/media/tests/mochitest/test_peerConnection_remoteReofferRollback.html | Valid rtp timestamp 1575927553204 >= 1575927553427 (

Status: RESOLVED DUPLICATE of bug 1597254

(Core :: WebRTC, defect, P5)

Description

[Treeherder Bug Filer]

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

---

[task 2019-12-09T21:39:14.293Z] 21:39:14 INFO - TEST-START | dom/media/tests/mochitest/test_peerConnection_remoteReofferRollback.html
[task 2019-12-09T21:39:14.360Z] 21:39:14 INFO - GECKO(5344) | TEST DEVICES: No test device found in media.audio_loopback_dev, using fake audio streams.
[task 2019-12-09T21:39:14.360Z] 21:39:14 INFO - GECKO(5344) | TEST DEVICES: No test device found in media.video_loopback_dev, using fake video streams.
[task 2019-12-09T21:39:14.375Z] 21:39:14 INFO - GECKO(5344) | Timecard created 1575927520.215000
[task 2019-12-09T21:39:14.375Z] 21:39:14 INFO - GECKO(5344) | Timestamp | Delta | Event | File | Function
[task 2019-12-09T21:39:14.376Z] 21:39:14 INFO - GECKO(5344) | ======================================================================================================================
[task 2019-12-09T21:39:14.376Z] 21:39:14 INFO - GECKO(5344) | 0.000000 | 0.000000 | Constructor Completed | PeerConnectionImpl.cpp:329 | PeerConnectionImpl
[task 2019-12-09T21:39:14.377Z] 21:39:14 INFO - GECKO(5344) | 0.001000 | 0.001000 | Initializing PC Ctx | PeerConnectionImpl.cpp:455 | Initialize
[task 2019-12-09T21:39:14.377Z] 21:39:14 INFO - GECKO(5344) | 0.062000 | 0.061000 | Create Offer | PeerConnectionImpl.cpp:1251 | CreateOffer
[task 2019-12-09T21:39:14.377Z] 21:39:14 INFO - GECKO(5344) | 0.064000 | 0.002000 | Set Local Description | PeerConnectionImpl.cpp:1312 | SetLocalDescription
[task 2019-12-09T21:39:14.377Z] 21:39:14 INFO - GECKO(5344) | 0.096000 | 0.032000 | Set Remote Description | PeerConnectionImpl.cpp:1400 | SetRemoteDescription
[task 2019-12-09T21:39:14.377Z] 21:39:14 INFO - GECKO(5344) | 0.137000 | 0.041000 | Ice gathering state: gathering | PeerConnectionImpl.cpp:2537 | IceGatheringStateChange
[task 2019-12-09T21:39:14.377Z] 21:39:14 INFO - GECKO(5344) | 2.114000 | 1.977000 | Ice state: failed | PeerConnectionImpl.cpp:2446 | IceConnectionStateChange
[task 2019-12-09T21:39:14.377Z] 21:39:14 INFO - GECKO(5344) | 2.138000 | 0.024000 | Add Ice Candidate | PeerConnectionImpl.cpp:1538 | AddIceCandidate
[task 2019-12-09T21:39:14.378Z] 21:39:14 INFO - GECKO(5344) | 2.139000 | 0.001000 | Add Ice Candidate | PeerConnectionImpl.cpp:1538 | AddIceCandidate
[task 2019-12-09T21:39:14.378Z] 21:39:14 INFO - GECKO(5344) | 2.146000 | 0.007000 | Add Ice Candidate | PeerConnectionImpl.cpp:1538 | AddIceCandidate
[task 2019-12-09T21:39:14.378Z] 21:39:14 INFO - GECKO(5344) | 34.148000 | 32.002000 | Destructor Invoked | PeerConnectionImpl.cpp:338 | ~PeerConnectionImpl
[task 2019-12-09T21:39:14.378Z] 21:39:14 INFO - GECKO(5344) | [Child 5532: Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:363: ~PeerConnectionImpl: PeerConnectionImpl destructor invoked for 2e43f267e36d2e80
[task 2019-12-09T21:39:14.378Z] 21:39:14 INFO - GECKO(5344) | Timecard created 1575927520.218000

[task 2019-12-09T21:39:16.461Z] 21:39:16 INFO - TEST-PASS | dom/media/tests/mochitest/test_peerConnection_remoteReofferRollback.html | RTP flowing for audio track {8c8cdec0-2bdf-46a0-ba67-280cc9a4eb16}
[task 2019-12-09T21:39:16.461Z] 21:39:16 INFO - Run step 39: PC_LOCAL_CHECK_STATS
[task 2019-12-09T21:39:16.462Z] 21:39:16 INFO - PeerConnectionWrapper (pcLocal): Got stats: {}
[task 2019-12-09T21:39:16.462Z] 21:39:16 INFO - Checking stats for Bn/p : [object Object]
[task 2019-12-09T21:39:16.462Z] 21:39:16 INFO - TEST-PASS | dom/media/tests/mochitest/test_peerConnection_remoteReofferRollback.html | Coherent stats id
[task 2019-12-09T21:39:16.462Z] 21:39:16 INFO - Buffered messages finished
[task 2019-12-09T21:39:16.465Z] 21:39:16 INFO - TEST-UNEXPECTED-FAIL | dom/media/tests/mochitest/test_peerConnection_remoteReofferRollback.html | Valid rtp timestamp 1575927553204 >= 1575927553427 (
[task 2019-12-09T21:39:16.465Z] 21:39:16 INFO - -223 ms)
[task 2019-12-09T21:39:16.465Z] 21:39:16 INFO - SimpleTest.ok@https://example.com/tests/SimpleTest/SimpleTest.js:277:18
[task 2019-12-09T21:39:16.465Z] 21:39:16 INFO - checkStats@https://example.com/tests/dom/media/tests/mochitest/pc.js:2101:11
[task 2019-12-09T21:39:16.466Z] 21:39:16 INFO - PC_LOCAL_CHECK_STATS/<@https://example.com/tests/dom/media/tests/mochitest/templates.js:522:20
[task 2019-12-09T21:39:16.466Z] 21:39:16 INFO - promise callbackPC_LOCAL_CHECK_STATS@https://example.com/tests/dom/media/tests/mochitest/templates.js:521:36
[task 2019-12-09T21:39:16.466Z] 21:39:16 INFO - execute/</<@https://example.com/tests/dom/media/tests/mochitest/head.js:944:32
[task 2019-12-09T21:39:16.466Z] 21:39:16 INFO - promise callbackexecute/<@https://example.com/tests/dom/media/tests/mochitest/head.js:942:21
[task 2019-12-09T21:39:16.466Z] 21:39:16 INFO - execute@https://example.com/tests/dom/media/tests/mochitest/head.js:937:8
[task 2019-12-09T21:39:16.466Z] 21:39:16 INFO - PeerConnectionTest.prototype.run@https://example.com/tests/dom/media/tests/mochitest/pc.js:574:6
[task 2019-12-09T21:39:16.466Z] 21:39:16 INFO - @https://example.com/tests/dom/media/tests/mochitest/test_peerConnection_remoteReofferRollback.html:60:10
[task 2019-12-09T21:39:16.466Z] 21:39:16 INFO - runNetworkTest/<@https://example.com/tests/dom/media/tests/mochitest/pc.js:2556:11
[task 2019-12-09T21:39:16.467Z] 21:39:16 INFO - asyncrunTestWhenReady/<@https://example.com/tests/dom/media/tests/mochitest/head.js:492:30
[task 2019-12-09T21:39:16.467Z] 21:39:16 INFO - promise callbackrunTestWhenReady@https://example.com/tests/dom/media/tests/mochitest/head.js:492:6
[task 2019-12-09T21:39:16.467Z] 21:39:16 INFO - runNetworkTest@https://example.com/tests/dom/media/tests/mochitest/pc.js:2537:9
[task 2019-12-09T21:39:16.467Z] 21:39:16 INFO - async*@https://example.com/tests/dom/media/tests/mochitest/test_peerConnection_remoteReofferRollback.html:15:17
[task 2019-12-09T21:39:16.468Z] 21:39:16 INFO - TEST-PASS | dom/media/tests/mochitest/test_peerConnection_remoteReofferRollback.html | Valid rtp timestamp 1575927553204 <= 1575927557334 (
[task 2019-12-09T21:39:16.468Z] 21:39:16 INFO - -4130 ms)
[task 2019-12-09T21:39:16.468Z] 21:39:16 INFO - Checking stats for +Xha : [object Object]
[task 2019-12-09T21:39:16.468Z] 21:39:16 INFO - TEST-PASS | dom/media/tests/mochitest/test_peerConnection_remoteReofferRollback.html | Coherent stats id
[task 2019-12-09T21:39:16.469Z] 21:39:16 INFO - Not taking screenshot here: see the one that was previously logged
[task 2019-12-09T21:39:16.469Z] 21:39:16 INFO - TEST-UNEXPECTED-FAIL | dom/media/tests/mochitest/test_peerConnection_remoteReofferRollback.html | Valid rtp timestamp 1575927553204 >= 1575927553427 (
[task 2019-12-09T21:39:16.469Z] 21:39:16 INFO - -223 ms)

Comment 1

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1
• mozilla-beta: 1

Platform breakdown:

• windows7-32-shippable: 1
• macosx1014-64-shippable: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1602604&startday=2019-12-09&endday=2019-12-15&tree=all

Comment 2

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-beta: 1

Platform breakdown:

• macosx1014-64-devedition: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1602604&startday=2019-12-16&endday=2019-12-22&tree=all

Comment 3

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1
• try: 1

Platform breakdown:

• macosx1014-64-shippable: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1602604&startday=2019-12-23&endday=2019-12-29&tree=all