Closed Bug 1600298 Opened 5 years ago Closed 4 years ago

Intermittent TEST-UNEXPECTED-TIMEOUT | /webrtc/datachannel-emptystring.html | Can send empty strings across a WebRTC data channel. - Test timed out

Categories

(Core :: WebRTC, defect, P5)

defect

Tracking

()

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

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


[task 2019-11-29T13:09:56.317Z] 13:09:56 INFO - TEST-PASS | /webrtc/RTCTrackEvent-fire.html | Source-level msid should be parsed if media-level msid is absent
[task 2019-11-29T13:09:56.317Z] 13:09:56 INFO - TEST-PASS | /webrtc/RTCTrackEvent-fire.html | Source-level msid should be ignored, or an error should be thrown, if a different media-level msid is present
[task 2019-11-29T13:09:56.317Z] 13:09:56 INFO - TEST-PASS | /webrtc/RTCTrackEvent-fire.html | stream ids should be found even if msid-semantic is absent
[task 2019-11-29T13:09:56.317Z] 13:09:56 INFO - TEST-PASS | /webrtc/RTCTrackEvent-fire.html | a=msid:- should result in a track event with no streams
[task 2019-11-29T13:09:56.317Z] 13:09:56 INFO - TEST-PASS | /webrtc/RTCTrackEvent-fire.html | Duplicate a=msid should result in a track event with one stream
[task 2019-11-29T13:09:56.317Z] 13:09:56 INFO - TEST-PASS | /webrtc/RTCTrackEvent-fire.html | Applying a remote description with removed msid should trigger firing a removetrack event on the corresponding stream
[task 2019-11-29T13:09:56.317Z] 13:09:56 INFO - TEST-PASS | /webrtc/RTCTrackEvent-fire.html | Applying a remote description with a new msid should trigger firing an event with populated streams
[task 2019-11-29T13:09:56.317Z] 13:09:56 INFO - TEST-UNEXPECTED-TIMEOUT | /webrtc/datachannel-emptystring.html | Can send empty strings across a WebRTC data channel. - Test timed out
[task 2019-11-29T13:09:56.317Z] 13:09:56 INFO - TEST-INFO | expected FAIL
[task 2019-11-29T13:09:56.317Z] 13:09:56 INFO - TEST-UNEXPECTED-TIMEOUT | /webrtc/datachannel-emptystring.html | expected OK
[task 2019-11-29T13:09:56.317Z] 13:09:56 INFO - TEST-INFO took 10380ms
[task 2019-11-29T13:09:56.319Z] 13:09:56 INFO - PID 4717 | 1575032996309 Marionette INFO Stopped listening on port 50141
[task 2019-11-29T13:09:56.401Z] 13:09:56 INFO - PID 4717 | [Child 4806: Main Thread]: E/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2819: GetStats: Found no pipelines matching selector.
[task 2019-11-29T13:09:56.401Z] 13:09:56 INFO - PID 4717 | [Child 4806: Main Thread]: E/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2832: GetStats: Found no pipelines matching selector.
[task 2019-11-29T13:09:56.401Z] 13:09:56 INFO - PID 4717 | [Child 4806: Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2190: CloseInt: Closing PeerConnectionImpl 20139d26097248c7; ending call
[task 2019-11-29T13:09:56.401Z] 13:09:56 INFO - PID 4717 | [Child 4806: Main Thread]: I/jsep [1575032986297038 (id=150323855362 url=http://web-platform.test:8000/webrtc/datachannel-emptystring.html)]: stable -> closed
[task 2019-11-29T13:09:56.403Z] 13:09:56 INFO - PID 4717 | [Child 4806: Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2196: CloseInt: Destroying DataChannelConnection 0x11bd67800 for 20139d26097248c7
[task 2019-11-29T13:09:56.403Z] 13:09:56 INFO - PID 4717 | [Child 4806: Main Thread]: D/DataChannel Destroying DataChannelConnection 0x11bd67800
[task 2019-11-29T13:09:56.403Z] 13:09:56 INFO - PID 4717 | [Child 4806: Main Thread]: D/DataChannel Closing all channels (connection 0x11bd67800)
[task 2019-11-29T13:09:56.403Z] 13:09:56 INFO - PID 4717 | [Child 4806: Main Thread]: D/DataChannel DataChannelConnection labeled transport_0 (0x11bd67800) switching connection state CONNECTING -> CLOSED
[task 2019-11-29T13:09:56.403Z] 13:09:56 INFO - PID 4717 | [Child 4806: Main Thread]: D/DataChannel Connection 0x11bd67800/Channel 0x11c734040: Closing stream 1
[task 2019-11-29T13:09:56.403Z] 13:09:56 INFO - PID 4717 | [Child 4806: Main Thread]: D/DataChannel Removing channel 1 : 0x11c734040
[task 2019-11-29T13:09:56.403Z] 13:09:56 INFO - PID 4717 | [Child 4806: Main Thread]: D/DataChannel Connection 0x11bd67800: Resetting outgoing stream 1
[task 2019-11-29T13:09:56.417Z] 13:09:56 INFO - PID 4717 | [Child 4806: Main Thread]: D/DataChannel DataChannelConnection labeled sendDataChannel(0x11c734040) (stream 1) changing ready state CONNECTING -> CLOSING
[task 2019-11-29T13:09:56.417Z] 13:09:56 INFO - PID 4717 | [Child 4806: Main Thread]: D/DataChannel Destroying Data channel 1
[task 2019-11-29T13:09:56.417Z] 13:09:56 INFO - PID 4717 | [Child 4806: Main Thread]: D/DataChannel closing pending channel 0x11c734040, stream 1
[task 2019-11-29T13:09:56.417Z] 13:09:56 INFO - PID 4717 | [Child 4806: Main Thread]: D/DataChannel Connection 0x11bd67800/Channel 0x11c734040: Closing stream 1
[task 2019-11-29T13:09:56.417Z] 13:09:56 INFO - PID 4717 | [Child 4806: Main Thread]: D/DataChannel Removing channel 1 : 0x11c734040
[task 2019-11-29T13:09:56.417Z] 13:09:56 INFO - PID 4717 | [Child 4806: Main Thread]: D/DataChannel Channel already closing/closed (2)
[task 2019-11-29T13:09:56.417Z] 13:09:56 INFO - PID 4717 | [Child 4806: Main Thread]: D/DataChannel Connection 0x11bd67800: Sending outgoing stream reset for 1 streams
[task 2019-11-29T13:09:56.417Z] 13:09:56 INFO - PID 4717 | [Child 4806: Main Thread]: E/DataChannel ***failed: setsockopt RESET, errno 2
[task 2019-11-29T13:09:56.417Z] 13:09:56 INFO - PID 4717 | [Child 4806: Main Thread]: D/DataChannel Clearing resets for 1 streams
[task 2019-11-29T13:09:56.418Z] 13:09:56 INFO - PID 4717 | [Child 4806: Main Thread]: E/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2819: GetStats: Found no pipelines matching selector.
[task 2019-11-29T13:09:56.418Z] 13:09:56 INFO - PID 4717 | [Child 4806: Main Thread]: E/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2832: GetStats: Found no pipelines matching selector.
[task 2019-11-29T13:09:56.418Z] 13:09:56 INFO - PID 4717 | [Child 4806: Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2190: CloseInt: Closing PeerConnectionImpl b0452b783f75f087; ending call
[task 2019-11-29T13:09:56.418Z] 13:09:56 INFO - PID 4717 | [Child 4806: Main Thread]: I/jsep [1575032986300423 (id=150323855362 url=http://web-platform.test:8000/webrtc/datachannel-emptystring.html)]: stable -> closed
[task 2019-11-29T13:09:56.418Z] 13:09:56 INFO - PID 4717 | [Child 4806: Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2196: CloseInt: Destroying DataChannelConnection 0x11c74a000 for b0452b783f75f087
[task 2019-11-29T13:09:56.418Z] 13:09:56 INFO - PID 4717 | [Child 4806: Main Thread]: D/DataChannel Destroying DataChannelConnection 0x11c74a000
[task 2019-11-29T13:09:56.418Z] 13:09:56 INFO - PID 4717 | [Child 4806: Main Thread]: D/DataChannel Closing all channels (connection 0x11c74a000)
[task 2019-11-29T13:09:56.418Z] 13:09:56 INFO - PID 4717 | [Child 4806: Main Thread]: D/DataChannel DataChannelConnection labeled transport_0 (0x11c74a000) switching connection state CONNECTING -> CLOSED
[task 2019-11-29T13:09:56.418Z] 13:09:56 INFO - PID 4717 | [Child 4806: Main Thread]: D/DataChannel Connection 0x11c74a000: Sending outgoing stream reset for 0 streams
[task 2019-11-29T13:09:56.418Z] 13:09:56 INFO - PID 4717 | [Child 4806: Main Thread]: D/DataChannel No streams to reset
[task 2019-11-29T13:09:56.418Z] 13:09:56 INFO - PID 4717 | [Child 4806: Main Thread]: D/DataChannel DataChannelConnection labeled sendDataChannel(0x11c734040) (stream 1) changing ready state CLOSING -> CLOSED
[task 2019-11-29T13:09:56.418Z] 13:09:56 INFO - PID 4717 | [Child 4806: Main Thread]: D/DataChannel operator(): sending ON_CHANNEL_CLOSED for sendDataChannel/: 1
[task 2019-11-29T13:09:56.418Z] 13:09:56 INFO - PID 4717 | [Child 4806: Main Thread]: D/DataChannel 0x11bdfe660(0x11c734040): OnChannelClosed - Dispatching
[task 2019-11-29T13:09:56.418Z] 13:09:56 INFO - PID 4717 | [Child 4806: Socket Thread]: D/DataChannel Deregistered 0x11bd67800 from the SCTP stack.
[task 2019-11-29T13:09:56.418Z] 13:09:56 INFO - PID 4717 | [Child 4806: Socket Thread]: D/DataChannel Deregistered 0x11c74a000 from the SCTP stack.
[task 2019-11-29T13:09:56.697Z] 13:09:56 INFO - Browser exited with return code 0
[task 2019-11-29T13:09:56.697Z] 13:09:56 INFO - PROCESS LEAKS None
[task 2019-11-29T13:09:56.698Z] 13:09:56 INFO - PROCESS LEAKS None

Status: NEW → RESOLVED
Closed: 5 years ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 5 years ago5 years ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 5 years ago4 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.