1597114 - Intermittent TEST-UNEXPECTED-TIMEOUT | /webrtc/RTCPeerConnection-ondatachannel.html | Negotiated channel should not fire datachannel event on remote peer - Test timed out

Status: RESOLVED INCOMPLETE

(Core :: WebRTC, defect, P5)

Description

[Treeherder Bug Filer]

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

---

[task 2019-11-17T13:41:38.670Z] 13:41:38 INFO - TEST-START | /webrtc/RTCPeerConnection-ondatachannel.html
[task 2019-11-17T13:41:38.670Z] 13:41:38 INFO - Clearing pref media.navigator.permission.disabled
[task 2019-11-17T13:41:38.677Z] 13:41:38 INFO - Clearing pref privacy.resistFingerprinting.reduceTimerPrecision.jitter
[task 2019-11-17T13:41:38.680Z] 13:41:38 INFO - Clearing pref media.navigator.streams.fake
[task 2019-11-17T13:41:38.687Z] 13:41:38 INFO - Clearing pref privacy.reduceTimerPrecision
[task 2019-11-17T13:41:38.694Z] 13:41:38 INFO - Setting pref media.navigator.permission.disabled (true)
[task 2019-11-17T13:41:38.709Z] 13:41:38 INFO - Setting pref privacy.resistFingerprinting.reduceTimerPrecision.jitter (false)
[task 2019-11-17T13:41:38.709Z] 13:41:38 INFO - Setting pref media.navigator.streams.fake (true)
[task 2019-11-17T13:41:38.724Z] 13:41:38 INFO - Setting pref privacy.reduceTimerPrecision (false)
[task 2019-11-17T13:41:38.724Z] 13:41:38 INFO - Closing window 85

[task 2019-11-17T13:41:50.307Z] 13:41:50 INFO - TEST-PASS | /webrtc/RTCPeerConnection-ondatachannel.html | Open event should not be raised when sending and immediately closing the channel in the datachannel event
[task 2019-11-17T13:41:50.307Z] 13:41:50 INFO - TEST-FAIL | /webrtc/RTCPeerConnection-ondatachannel.html | In-band negotiated channel created on remote peer should match the same configuration as local peer - assert_equals: expected (string) "high" but got (undefined) undefined
[task 2019-11-17T13:41:50.307Z] 13:41:50 INFO - @http://web-platform.test:8000/webrtc/RTCPeerConnection-ondatachannel.html:220:16
[task 2019-11-17T13:41:50.307Z] 13:41:50 INFO - Test.prototype.step@http://web-platform.test:8000/resources/testharness.js:1908:25
[task 2019-11-17T13:41:50.307Z] 13:41:50 INFO - promise_test/tests.promise_tests</<@http://web-platform.test:8000/resources/testharness.js:591:36
[task 2019-11-17T13:41:50.307Z] 13:41:50 INFO - promise_test/tests.promise_tests<@http://web-platform.test:8000/resources/testharness.js:590:20
[task 2019-11-17T13:41:50.307Z] 13:41:50 INFO - TEST-FAIL | /webrtc/RTCPeerConnection-ondatachannel.html | In-band negotiated channel created on remote peer should match the same (default) configuration as local peer - assert_equals: expected (string) "low" but got (undefined) undefined
[task 2019-11-17T13:41:50.307Z] 13:41:50 INFO - @http://web-platform.test:8000/webrtc/RTCPeerConnection-ondatachannel.html:253:16
[task 2019-11-17T13:41:50.307Z] 13:41:50 INFO - Test.prototype.step@http://web-platform.test:8000/resources/testharness.js:1908:25
[task 2019-11-17T13:41:50.308Z] 13:41:50 INFO - promise_test/tests.promise_tests</<@http://web-platform.test:8000/resources/testharness.js:591:36
[task 2019-11-17T13:41:50.308Z] 13:41:50 INFO - promise_test/tests.promise_tests<@http://web-platform.test:8000/resources/testharness.js:590:20
[task 2019-11-17T13:41:50.308Z] 13:41:50 INFO - TEST-UNEXPECTED-TIMEOUT | /webrtc/RTCPeerConnection-ondatachannel.html | Negotiated channel should not fire datachannel event on remote peer - Test timed out
[task 2019-11-17T13:41:50.308Z] 13:41:50 INFO - TEST-UNEXPECTED-TIMEOUT | /webrtc/RTCPeerConnection-ondatachannel.html | expected OK
[task 2019-11-17T13:41:50.308Z] 13:41:50 INFO - TEST-INFO took 11637ms
[task 2019-11-17T13:41:50.323Z] 13:41:50 INFO - PID 3552 | 1573998110298 Marionette INFO Stopped listening on port 49461
[task 2019-11-17T13:41:50.382Z] 13:41:50 INFO - PID 3552 | [Child 5916: Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2190: CloseInt: Closing PeerConnectionImpl 1bd00156cf61a286; ending call
[task 2019-11-17T13:41:50.382Z] 13:41:50 INFO - PID 3552 | [Child 5916: Main Thread]: I/jsep [1573998110124000 (id=70866960386 url=http://web-platform.test:8000/webrtc/RTCPeerConnection-ondatachannel.html)]: stable -> closed
[task 2019-11-17T13:41:50.383Z] 13:41:50 INFO - PID 3552 | [Child 5916: Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2196: CloseInt: Destroying DataChannelConnection 0C84B760 for 1bd00156cf61a286
[task 2019-11-17T13:41:50.384Z] 13:41:50 INFO - PID 3552 | [Child 5916: Main Thread]: D/DataChannel Destroying DataChannelConnection 0C84B760
[task 2019-11-17T13:41:50.384Z] 13:41:50 INFO - PID 3552 | [Child 5916: Main Thread]: D/DataChannel Closing all channels (connection 0C84B760)
[task 2019-11-17T13:41:50.385Z] 13:41:50 INFO - PID 3552 | [Child 5916: Main Thread]: D/DataChannel DataChannelConnection labeled transport_0 (0C84B760) switching connection state CONNECTING -> CLOSED
[task 2019-11-17T13:41:50.385Z] 13:41:50 INFO - PID 3552 | [Child 5916: Main Thread]: D/DataChannel Connection 0C84B760/Channel 0C85DB80: Closing stream 42
[task 2019-11-17T13:41:50.386Z] 13:41:50 INFO - PID 3552 | [Child 5916: Main Thread]: D/DataChannel Removing channel 42 : 0C85DB80
[task 2019-11-17T13:41:50.386Z] 13:41:50 INFO - PID 3552 | [Child 5916: Main Thread]: D/DataChannel Channel already closing/closed (2)
[task 2019-11-17T13:41:50.386Z] 13:41:50 INFO - PID 3552 | [Child 5916: Main Thread]: D/DataChannel closing pending channel 0C85DB80, stream 42
[task 2019-11-17T13:41:50.387Z] 13:41:50 INFO - PID 3552 | [Child 5916: Main Thread]: D/DataChannel Connection 0C84B760/Channel 0C85DB80: Closing stream 42

Comment 1

[Intermittent Failures Robot]

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

Repository breakdown:

• try: 1

Platform breakdown:

• windows7-32-devedition: 1

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

Comment 2

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-central: 1
• autoland: 1

Platform breakdown:

• windows7-32: 1
• windows7-32-shippable: 1

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

Comment 3

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-central: 2
• try: 1

Platform breakdown:

• windows7-32-shippable: 1
• windows7-32-devedition: 1
• windows7-32: 1

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

Comment 4

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform breakdown:

• windows7-32-shippable: 1

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

Comment 5

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

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

Comment 6

[Natalia Csoregi [:nataliaCs]]

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

Comment 7

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-central: 2
• autoland: 1

Platform breakdown:

• windows7-32-shippable: 3

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

Comment 8

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 2
• mozilla-central: 2

Platform breakdown:

• windows7-32-shippable: 3
• windows7-32: 1

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

Comment 9

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-central: 2
• autoland: 2
• try: 2

Platform breakdown:

• windows7-32: 2
• windows7-32-shippable: 4

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

Comment 10

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

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