webrtcsink: Incoming H.264 Stream from Arducam is not supported without manually specifying a cap (Renegotiation error)
Describe your issue
H.264 Stream of profile main and level 4.1 coming in from an Arducam is not supported by webrtcsink due to lack of renengotiation support. And when the cap is manually set with capsfilter between v4l2src and h264parse, the stream does open on chrome but takes about 2 minutes just loading.
Expected Behavior
Webrtcsink not crashing on lack of renegotiation as the caps are set on hardware end. The stream starting immediately when the caps are manually set.
Observed Behavior
Internal data stream error. from v4l2src.
Setup
- Operating System:
- Device: Computer / Tablet / Mobile / Virtual Machine
- gst-plugins-rs Version:
- GStreamer Version:
- Command line:
Steps to reproduce the bug
- open terminal
- run the command
gst-launch-1.0 v4l2src device=/dev/video1 ! h264parse ! webrtcsink
How reproducible is the bug?
Always
Screenshots if relevant
Solutions you have tried
Tried running the pipeline with a capsfilter inbetween v4l2src to h264parse:
GST_DEBUG=v4l2*:4,webrtc*:4 gst-launch-1.0 v4l2src device=/dev/video1 ! capsfilter caps="video/x-h264, stream-format=(string)byte-stream, alignment=(string)au, width=(int)1920, height=(int)1080, pixel-aspect-ratio=(fraction)1/1, framerate=(fraction)30/1, interlace-mode=(string)progressive, colorimetry=(string)2:4:7:1, coded-picture-structure=(string)frame, chroma-format=(string)4:2:0, bit-depth-luma=(uint)8, bit-depth-chroma=(uint)8, parsed=(boolean)true, profile=(string)main, level=(string)4.1" ! h264parse ! webrtcsink
The cap used is directly copied from the logs. While this did result in the stream being opened in Google Chrome, it took about 2 minutes before the stream started playing and was stuck on loading for a while.
Related non-duplicate issues
Additional Information
Output with GST_DEBUG=v4l2*:4,webrtc*:4
without manual capsfilter:
Setting pipeline to PAUSED ...
0:00:00.941874087 8521 0x23d36df0 INFO v4l2 v4l2_calls.c:592:gst_v4l2_open:<v4l2src0:src> Opened device 'USB 2.0 Camera' (/dev/video1) successfully
Pipeline is live and does not need PREROLL ...
0:00:00.945112184 8521 0x7f7c000b70 INFO v4l2src gstv4l2src.c:681:gst_v4l2src_query_preferred_size:<v4l2src0> Detect input 0 as `Camera 1`
0:00:00.945173174 8521 0x7f7c000b70 INFO v4l2 gstv4l2object.c:1249:gst_v4l2_object_fill_format_list:<v4l2src0:src> got 1 format(s):
0:00:00.945203590 8521 0x7f7c000b70 INFO v4l2 gstv4l2object.c:1253:gst_v4l2_objecPipeline is PREROLLED ...
t_fill_format_list:<v4l2src0:src> H264
Setting pipeline to PLAYING ...
0:00:00.945365935 8521 0x7f7c000b70 INFO v4l2 gstv4l2object.c:4798:gst_v4l2_object_probe_caps:<v4l2src0:src> probed caps: video/x-h264, stream-format=(string)byte-stream, alignment=(string)au, width=(int)1920, height=(int)1080, pixel-aspect-ratio=(fraction)1/1, framerate=(fraction)30/1; video/x-h264, stream-format=(string)byte-stream, alignment=(string)au, width=(int)1280, height=(int)720, pixel-aspect-ratio=(fraction)1/1, framerate=(fraction)30/1; video/x-h264, stream-format=(string)byte-stream, alignment=(string)au, width=(int)640, height=(int)480, pixel-aspect-ratio=(fraction)1/1, framerate=(fraction)30/1; video/x-h264, stream-format=(string)byte-stream, alignment=(string)au, width=(int)640, height=(int)360, pixel-aspect-ratio=(fraction)1/1, framerate=(fraction)30/1
New clock: GstSystemClock
0:00:00.961812410 8521 0x7f7c000b70 INFO v4l2src gstv4l2src.c:827:gst_v4l2src_negotiate:<v4l2src0> fixated to: video/x-h264, stream-format=(string)byte-stream, alignment=(string)au, width=(int)1920, height=(int)1080, pixel-aspect-ratio=(fraction)1/1, framerate=(fraction)30/1, interlace-mode=(string)progressive, colorimetry=(string)2:4:7:1
0:00:00.962068297 8521 0x7f7c000b70 INFO webrtcsink net/webrtc/src/webrtcsink/imp.rs:3490:gstrswebrtc::webrtcsink::imp::BaseWebRTCSink::sink_event:<webrtcsink0:video_0> Received caps event Caps { seqnum: Seqnum(39), running-time-offset: 0, structure: Some(GstEventCaps { caps: (GstCaps) video/x-h264, stream-format=(string)byte-stream, alignment=(string)au, width=(int)1920, height=(int)1080, pixel-aspect-ratio=(fraction)1/1, framerate=(fraction)30/1, interlace-mode=(string)progressive, colorimetry=(string)2:4:7:1, parsed=(boolean)true }), caps: Caps(video/x-h264(memory:SystemMemory) { stream-format: (gchararray) "byte-stream", alignment: (gchararray) "au", width: (gint) 1920, height: (gint) 1080, pixel-aspect-ratio: (GstFraction) 1/1, framerate: (GstFraction) 30/1, interlace-mode: (gchararray) "progressive", colorimetry: (gchararray) "2:4:7:1", parsed: (gboolean) TRUE }) }
0:00:00.962297101 8521 0x7f7c000b70 WARN v4l2 gstv4l2object.c:4453:gst_v4l2_object_set_crop:<v4l2src0:src> VIDIOC_S_CROP failed
0:00:00.993925822 8521 0x7f7c000b70 INFO v4l2 gstv4l2object.c:4047:gst_v4l2_object_set_format_full:<v4l2src0:src> Set capture framerate to 30/1
0:00:00.993999260 8521 0x7f7c000b70 WARN v4l2 gstv4l2object.c:3278:gst_v4l2_object_reset_compose_region:<v4l2src0:src> Failed to get default compose rectangle with VIDIOC_G_SELECTION: Invalid argument
0:00:00.994049261 8521 0x7f7c000b70 INFO v4l2 gstv4l2object.c:3214:gst_v4l2_object_setup_pool:<v4l2src0:src> accessing buffers via mode 4
0:00:00.994515306 8521 0x7f7c000b70 INFO v4l2bufferpool gstv4l2bufferpool.c:586:gst_v4l2_buffer_pool_set_config:<v4l2src0:pool0:src> increasing minimum buffers to 2
0:00:00.994573744 8521 0x7f7c000b70 INFO v4l2bufferpool gstv4l2bufferpool.c:599:gst_v4l2_buffer_pool_set_config:<v4l2src0:pool0:src> reducing maximum buffers to 32
0:00:00.994751662 8521 0x7f7c000b70 INFO v4l2bufferpool gstv4l2bufferpool.c:599:gst_v4l2_buffer_pool_set_config:<v4l2src0:pool0:src> reducing maximum buffers to 32
0:00:01.002990108 8521 0x7f7c000b70 WARN v4l2bufferpool gstv4l2bufferpool.c:850:gst_v4l2_buffer_pool_start:<v4l2src0:pool0:src> Uncertain or not enough buffers, enabling copy threshold
Redistribute latency...
0:00:01.937313569 8521 0x7f7c000b70 ERROR webrtcsink net/webrtc/src/webrtcsink/imp.rs:3480:gstrswebrtc::webrtcsink::imp::BaseWebRTCSink::sink_event:<webrtcsink0:video_0> Renegotiation is not supported (old: video/x-h264, stream-format=(string)byte-stream, alignment=(string)au, width=(int)1920, height=(int)1080, pixel-aspect-ratio=(fraction)1/1, framerate=(fraction)30/1, interlace-mode=(string)progressive, colorimetry=(string)2:4:7:1, parsed=(boolean)true, new: video/x-h264, stream-format=(string)byte-stream, alignment=(string)au, width=(int)1920, height=(int)1080, pixel-aspect-ratio=(fraction)1/1, framerate=(fraction)30/1, interlace-mode=(string)progressive, colorimetry=(string)2:4:7:1, coded-picture-structure=(string)frame, chroma-format=(string)4:2:0, bit-depth-luma=(uint)8, bit-depth-chroma=(uint)8, parsed=(boolean)true, profile=(string)main, level=(string)4.1)
0:00:01.937508154 8521 0x7f7c000b70 ERROR webrtcsink net/webrtc/src/webrtcsink/imp.rs:3480:gstrswebrtc::webrtcsink::imp::BaseWebRTCSink::sink_event:<webrtcsink0:video_0> Renegotiation is not supported (old: video/x-h264, stream-format=(string)byte-stream, alignment=(string)au, width=(int)1920, height=(int)1080, pixel-aspect-ratio=(fraction)1/1, framerate=(fraction)30/1, interlace-mode=(string)progressive, colorimetry=(string)2:4:7:1, parsed=(boolean)true, new: video/x-h264, stream-format=(string)byte-stream, alignment=(string)au, width=(int)1920, height=(int)1080, pixel-aspect-ratio=(fraction)1/1, framerate=(fraction)30/1, interlace-mode=(string)progressive, colorimetry=(string)2:4:7:1, coded-picture-structure=(string)frame, chroma-format=(string)4:2:0, bit-depth-luma=(uint)8, bit-depth-chroma=(uint)8, parsed=(boolean)true, profile=(string)main, level=(string)4.1)
0:00:01.937703676 8521 0x7f7c000b70 ERROR webrtcsink net/webrtc/src/webrtcsink/imp.rs:3480:gstrswebrtc::webrtcsink::imp::BaseWebRTCSink::sink_event:<webrtcsink0:video_0> Renegotiation is not supported (old: video/x-h264, stream-format=(string)byte-stream, alignment=(string)au, width=(int)1920, height=(int)1080, pixel-aspect-ratio=(fraction)1/1, framerate=(fraction)30/1, interlace-mode=(string)progressive, colorimetry=(string)2:4:7:1, parsed=(boolean)true, new: video/x-h264, stream-format=(string)byte-stream, alignment=(string)au, width=(int)1920, height=(int)1080, pixel-aspect-ratio=(fraction)1/1, framerate=(fraction)30/1, interlace-mode=(string)progressive, colorimetry=(string)2:4:7:1, coded-picture-structure=(string)frame, chroma-format=(string)4:2:0, bit-depth-luma=(uint)8, bit-depth-chroma=(uint)8, parsed=(boolean)true, profile=(string)main, level=(string)4.1)
0:00:01.937823781 8521 0x7f7c000b70 ERROR webrtcsink net/webrtc/src/webrtcsink/imp.rs:3480:gstrswebrtc::webrtcsink::imp::BaseWebRTCSink::sink_event:<webrtcsink0:video_0> Renegotiation is not supported (old: video/x-h264, stream-format=(string)byte-stream, alignment=(string)au, width=(int)1920, height=(int)1080, pixel-aspect-ratio=(fraction)1/1, framerate=(fraction)30/1, interlace-mode=(string)progressive, colorimetry=(string)2:4:7:1, parsed=(boolean)true, new: video/x-h264, stream-format=(string)byte-stream, alignment=(string)au, width=(int)1920, height=(int)1080, pixel-aspect-ratio=(fraction)1/1, framerate=(fraction)30/1, interlace-mode=(string)progressive, colorimetry=(string)2:4:7:1, coded-picture-structure=(string)frame, chroma-format=(string)4:2:0, bit-depth-luma=(uint)8, bit-depth-chroma=(uint)8, parsed=(boolean)true, profile=(string)main, level=(string)4.1)
ERROR: from element /GstPipeline:pipeline0/GstV4l2Src:v4l2src0: Internal data stream error.
Additional debug info:
../libs/gst/base/gstbasesrc.c(3177): gst_base_src_loop (): /GstPipeline:pipeline0/GstV4l2Src:v4l2src0:
streaming stopped, reason not-negotiated (-4)
Execution ended after 0:00:00.993184413
0:00:01.938513161 8521 0x7f7c000b70 ERROR webrtcsink net/webrtc/src/webrtcsink/imp.rs:3480:gstrswebrtc::webrtcsink::imp::BaseWebRTCSink::sink_event:<webrtcsink0:video_0> Renegotiation is not supported (old: video/x-h264, stream-format=(string)byte-stream, alignment=(string)au, width=(int)1920, height=(int)1080, pixel-aspect-ratio=(fraSetting pipeline to NULL ...
ction)1/1, framerate=(fraction)30/1, interlace-mode=(string)progressive, colorimetry=(string)2:4:7:1, parsed=(boolean)true, new: video/x-h264, stream-format=(string)byte-stream, alignment=(string)au, width=(int)1920, height=(int)1080, pixel-aspect-ratio=(fraction)1/1, framerate=(fraction)30/1, interlace-mode=(string)progressive, colorimetry=(string)2:4:7:1, coded-picture-structure=(string)frame, chroma-format=(string)4:2:0, bit-depth-luma=(uint)8, bit-depth-chroma=(uint)8, parsed=(boolean)true, profile=(string)main, level=(string)4.1)
0:00:01.938669517 8521 0x7f7c000b70 ERROR webrtcsink net/webrtc/src/webrtcsink/imp.rs:3480:gstrswebrtc::webrtcsink::imp::BaseWebRTCSink::sink_event:<webrtcsink0:video_0> Renegotiation is not supported (old: video/x-h264, stream-format=(string)byte-stream, alignment=(string)au, width=(int)1920, height=(int)1080, pixel-aspect-ratio=(fraction)1/1, framerate=(fraction)30/1, interlace-mode=(string)progressive, colorimetry=(string)2:4:7:1, parsed=(boolean)true, new: video/x-h264, stream-format=(string)byte-stream, alignment=(string)au, width=(int)1920, height=(int)1080, pixel-aspect-ratio=(fraction)1/1, framerate=(fraction)30/1, interlace-mode=(string)progressive, colorimetry=(string)2:4:7:1, coded-picture-structure=(string)frame, chroma-format=(string)4:2:0, bit-depth-luma=(uint)8, bit-depth-chroma=(uint)8, parsed=(boolean)true, profile=(string)main, level=(string)4.1)
0:00:01.938877226 8521 0x23d36df0 INFO webrtcsink net/webrtc/src/webrtcsink/imp.rs:1802:gstrswebrtc::webrtcsink::imp::BaseWebRTCSink::unprepare:<webrtcsink0> unpreparing
Freeing pipeline ...
Output with same debug levels but with capsfilter (works but takes 2 mins almost before stream is viewable):
Setting pipeline to PAUSED ...
0:00:00.936594974 8868 0x12bf15b0 INFO v4l2 v4l2_calls.c:592:gst_v4l2_open:<v4l2src0:src> Opened device 'USB 2.0 Camera' (/dev/video1) successfully
Pipeline is live and does not need PREROLL ...
0:00:00.939122067 8868 0x7f90000b70 INFO v4l2src gstv4l2src.c:681:gst_v4l2src_query_preferred_size:<v4l2src0> Detect input 0 as `Camera 1`
0:00:00.939181604 8868 0x7f90000b70 INFO v4l2 gstv4l2object.c:1249:gst_v4l2_object_fill_format_list:<v4l2src0:src> got 1 format(s):
0:00:00.939205253 8868 0x7f90000b70 INFO v4l2 gstv4l2object.c:1253:gst_v4l2_object_fill_format_list:<v4l2src0:src> H264
Pipeline is PREROLLED ...
Setting pipeline to PLAYING ...
0:00:00.939365114 8868 0x7f90000b70 INFO v4l2 gstv4l2object.c:4798:gst_v4l2_object_probe_caps:<v4l2src0:src> probed caps: video/x-h264, stream-format=(string)byte-stream, alignment=(string)au, width=(int)1920, height=(int)1080, pixel-aspect-ratio=(fraction)1/1, framerate=(fraction)30/1; video/x-h264, stream-format=(string)byte-stream, alignment=(string)au, width=(int)1280, height=(int)720, pixel-aspect-ratio=(fraction)1/1, framerate=(fraction)30/1; video/x-h264, stream-format=(string)byte-stream, alignment=(string)au, width=(int)640, height=(int)480, pixel-aspect-ratio=(fraction)1/1, framerate=(fraction)30/1; video/x-h264, stream-format=(string)byte-stream, alignment=(string)au, width=(int)640, height=(int)360, pixel-aspect-ratio=(fraction)1/1, framerate=(fraction)30/1
New clock: GstSystemClock
0:00:00.955699205 8868 0x7f90000b70 INFO v4l2src gstv4l2src.c:827:gst_v4l2src_negotiate:<v4l2src0> fixated to: video/x-h264, stream-format=(string)byte-stream, alignment=(string)au, width=(int)1920, height=(int)1080, pixel-aspect-ratio=(fraction)1/1, framerate=(fraction)30/1, interlace-mode=(string)progressive, colorimetry=(string)2:4:7:1, coded-picture-structure=(string)frame, chroma-format=(string)4:2:0, bit-depth-luma=(uint)8, bit-depth-chroma=(uint)8, parsed=(boolean)true, profile=(string)main, level=(string)4.1
0:00:00.956101175 8868 0x7f90000b70 INFO webrtcsink net/webrtc/src/webrtcsink/imp.rs:3490:gstrswebrtc::webrtcsink::imp::BaseWebRTCSink::sink_event:<webrtcsink0:video_0> Received caps event Caps { seqnum: Seqnum(47), running-time-offset: 0, structure: Some(GstEventCaps { caps: (GstCaps) video/x-h264, stream-format=(string)byte-stream, alignment=(string)au, width=(int)1920, height=(int)1080, pixel-aspect-ratio=(fraction)1/1, framerate=(fraction)30/1, interlace-mode=(string)progressive, colorimetry=(string)2:4:7:1, coded-picture-structure=(string)frame, chroma-format=(string)4:2:0, bit-depth-luma=(uint)8, bit-depth-chroma=(uint)8, parsed=(boolean)true, profile=(string)main, level=(string)4.1 }), caps: Caps(video/x-h264(memory:SystemMemory) { stream-format: (gchararray) "byte-stream", alignment: (gchararray) "au", width: (gint) 1920, height: (gint) 1080, pixel-aspect-ratio: (GstFraction) 1/1, framerate: (GstFraction) 30/1, interlace-mode: (gchararray) "progressive", colorimetry: (gchararray) "2:4:7:1", coded-picture-structure: (gchararray) "frame", chroma-format: (gchararray) "4:2:0", bit-depth-luma: (guint) 8, bit-depth-chroma: (guint) 8, parsed: (gboolean) TRUE, profile: (gchararray) "main", level: (gchararray) "4.1" }) }
0:00:00.956339221 8868 0x7f90000b70 WARN v4l2 gstv4l2object.c:4453:gst_v4l2_object_set_crop:<v4l2src0:src> VIDIOC_S_CROP failed
0:00:00.988499484 8868 0x7f90000b70 INFO v4l2 gstv4l2object.c:4047:gst_v4l2_object_set_format_full:<v4l2src0:src> Set capture framerate to 30/1
0:00:00.988573555 8868 0x7f90000b70 WARN v4l2 gstv4l2object.c:3278:gst_v4l2_object_reset_compose_region:<v4l2src0:src> Failed to get default compose rectangle with VIDIOC_G_SELECTION: Invalid argument
0:00:00.988601891 8868 0x7f90000b70 INFO v4l2 gstv4l2object.c:3214:gst_v4l2_object_setup_pool:<v4l2src0:src> accessing buffers via mode 4
0:00:00.988864315 8868 0x7f90000b70 INFO v4l2bufferpool gstv4l2bufferpool.c:586:gst_v4l2_buffer_pool_set_config:<v4l2src0:pool0:src> increasing minimum buffers to 2
0:00:00.988896766 8868 0x7f90000b70 INFO v4l2bufferpool gstv4l2bufferpool.c:599:gst_v4l2_buffer_pool_set_config:<v4l2src0:pool0:src> reducing maximum buffers to 32
0:00:00.989009695 8868 0x7f90000b70 INFO v4l2bufferpool gstv4l2bufferpool.c:599:gst_v4l2_buffer_pool_set_config:<v4l2src0:pool0:src> reducing maximum buffers to 32
0:00:00.996048417 8868 0x7f90000b70 WARN v4l2bufferpool gstv4l2bufferpool.c:850:gst_v4l2_buffer_pool_start:<v4l2src0:pool0:src> Uncertain or not enough buffers, enabling copy threshold
Redistribute latency...
0:00:01.930830810 8868 0x7f840010b0 INFO webrtcsink net/webrtc/src/webrtcsink/imp.rs:3367:gstrswebrtc::webrtcsink::imp::BaseWebRTCSink::lookup_caps::{{closure}}:<webrtcsink0> Stream is already encoded with codec H264, still need to payload it
Redistribute latency...
0:00:01.964880801 8868 0x7f90000b70 WARN v4l2src gstv4l2src.c:1337:gst_v4l2src_create:<v4l2src0> lost frames detected: count = 1 - ts: 0:00:00.993290159
0:00:01.966695213 8868 0x7f840010b0 INFO webrtcsink net/webrtc/src/webrtcsink/imp.rs:3315:gstrswebrtc::webrtcsink::imp::BaseWebRTCSink::run_discovery_pipeline::{{closure}}: Discovery pipeline got caps Caps(application/x-rtp(memory:SystemMemory) { media: (gchararray) "video", clock-rate: (gint) 90000, encoding-name: (gchararray) "H264", packetization-mode: (gchararray) "1", sprop-parameter-sets: (gchararray) "Z01AKZZUA8ARPyo=,aO44gA==", profile-level-id: (gchararray) "4d4029", profile: (gchararray) "main", payload: (gint) 97, ssrc: (guint) 662052141, timestamp-offset: (guint) 662875004, seqnum-offset: (guint) 27420, a-framerate: (gchararray) "30", extmap-1: (gchararray) "http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01" })
0:00:01.967943524 8868 0x7f840010b0 INFO webrtcsrc-signaller net/webrtc/src/signaller/imp.rs:598:<gstrswebrtc::signaller::imp::Signaller as gstrswebrtc::signaller::iface::SignallableImpl>::start:<GstWebRTCSignaller@0x12bbac80> Starting
0:00:01.968190165 8868 0x7f840010b0 INFO webrtcsrc-signaller net/webrtc/src/signaller/imp.rs:131:gstrswebrtc::signaller::imp::Signaller::connect::{{closure}}:<GstWebRTCSignaller@0x12bbac80> connecting to ws://127.0.0.1:8443/
0:00:01.969084583 8868 0x7f840010b0 INFO webrtcsrc-signaller net/webrtc/src/signaller/imp.rs:151:gstrswebrtc::signaller::imp::Signaller::connect::{{closure}}:<GstWebRTCSignaller@0x12bbac80> connected
0:00:03.630591555 8868 0x7f840010b0 INFO webrtcsink net/webrtc/src/webrtcsink/imp.rs:2359:gstrswebrtc::webrtcsink::imp::BaseWebRTCSink::start_session:<webrtcsink0> Adding session: 9bc1a52f-e6b3-40e9-8090-72d4a858e8c9 for peer: 849b2f54-2a45-4637-b458-a68dc83ea757
0:00:03.655229387 8868 0x7f840010b0 INFO webrtcsink net/webrtc/src/webrtcsink/imp.rs:1731:gstrswebrtc::webrtcsink::imp::BaseWebRTCSink::request_webrtcbin_pad::{{closure}}:<webrtcsink0> Requesting WebRTC pad with caps application/x-rtp, media=(string)video, clock-rate=(int)90000, encoding-name=(string)H264, packetization-mode=(string)1, profile-level-id=(string)4d4029, profile=(string)main, payload=(int)97, extmap-1=(string)http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01, ssrc=(uint)721575733
0:00:03.656211992 8868 0x7f84053310 INFO webrtcbin gstwebrtcbin.c:4847:_create_sdp_task:<webrtcbin-9bc1a52f-e6b3-40e9-8090-72d4a858e8c9> creating offer sdp with options (NULL)
0:00:04.141553256 8868 0x7f840010b0 INFO webrtcsink net/webrtc/src/webrtcsink/imp.rs:2671:gstrswebrtc::webrtcsink::imp::BaseWebRTCSink::start_session::{{closure}}:<session-pipeline-9bc1a52f-e6b3-40e9-8090-72d4a858e8c9> Recalculating latency
0:00:04.141807085 8868 0x7f840010b0 WARN webrtctransportsendbin transportsendbin.c:457:gst_transport_send_bin_element_query:<transportsendbin0> did not really configure latency of 0:00:00.000000000
0:00:04.143576753 8868 0x7f84053310 INFO webrtcbin gstwebrtcbin.c:6410:_set_description_task:<webrtcbin-9bc1a52f-e6b3-40e9-8090-72d4a858e8c9> Attempting to set local offer in the stable state
0:00:04.147515245 8868 0x7f84053310 INFO webrtcbin gstwebrtcbin.c:1633:_update_ice_gathering_state_task:<webrtcbin-9bc1a52f-e6b3-40e9-8090-72d4a858e8c9> ICE gathering state change from new(0) to gathering(1)
0:00:04.150519263 8868 0x7f84053310 INFO webrtcbin gstwebrtcbin.c:6410:_set_description_task:<webrtcbin-9bc1a52f-e6b3-40e9-8090-72d4a858e8c9> Attempting to set remote answer in the have-local-offer state
0:00:04.151930507 8868 0x7f84053310 WARN webrtcsink net/webrtc/src/webrtcsink/imp.rs:2440:gstrswebrtc::webrtcsink::imp::BaseWebRTCSink::start_session::{{closure}}::{{closure}}: rtprtxsend doesn't have a `stuffing-kbps` property, stuffing disabled
0:00:04.154153035 8868 0x7f84053310 INFO webrtcsink net/webrtc/src/webrtcsink/imp.rs:1209:gstrswebrtc::webrtcsink::imp::Session::connect_input_stream:<webrtcsink0> Connecting input stream video_0 for consumer 849b2f54-2a45-4637-b458-a68dc83ea757 and media 0
0:00:04.155280968 8868 0x7f840010b0 INFO webrtcsink net/webrtc/src/webrtcsink/imp.rs:2671:gstrswebrtc::webrtcsink::imp::BaseWebRTCSink::start_session::{{closure}}:<session-pipeline-9bc1a52f-e6b3-40e9-8090-72d4a858e8c9> Recalculating latency
0:00:04.155626994 8868 0x7f840010b0 WARN webrtctransportsendbin transportsendbin.c:457:gst_transport_send_bin_element_query:<transportsendbin0> did not really configure latency of 0:00:00.000000000
0:00:04.156626528 8868 0x7f84053310 INFO webrtcbin gstwebrtcbin.c:1660:_update_ice_connection_state_task:<webrtcbin-9bc1a52f-e6b3-40e9-8090-72d4a858e8c9> ICE connection state change from new(0) to checking(1)
0:00:04.156721225 8868 0x7f84053310 INFO webrtcbin gstwebrtcbin.c:1695:_update_peer_connection_state_task:<webrtcbin-9bc1a52f-e6b3-40e9-8090-72d4a858e8c9> Peer connection state change from new(0) to connecting(1)
0:00:04.157832177 8868 0x7f84053310 INFO webrtcstats gstwebrtcstats.c:699:_get_stats_from_ice_transport:<webrtcbin-9bc1a52f-e6b3-40e9-8090-72d4a858e8c9> No selected ICE candidate pair was found for transport webrtcnicetransport0
0:00:04.178561780 8868 0x7f840010b0 INFO webrtcsink net/webrtc/src/webrtcsink/imp.rs:2671:gstrswebrtc::webrtcsink::imp::BaseWebRTCSink::start_session::{{closure}}:<session-pipeline-9bc1a52f-e6b3-40e9-8090-72d4a858e8c9> Recalculating latency
0:00:04.178849154 8868 0x7f840010b0 WARN webrtctransportsendbin transportsendbin.c:457:gst_transport_send_bin_element_query:<transportsendbin0> did not really configure latency of 0:00:00.000000000
0:00:04.217572757 8868 0x7f84053310 INFO webrtcbin gstwebrtcbin.c:1660:_update_ice_connection_state_task:<webrtcbin-9bc1a52f-e6b3-40e9-8090-72d4a858e8c9> ICE connection state change from checking(1) to connected(2)
0:00:04.217684956 8868 0x7f84053310 INFO webrtcbin gstwebrtcbin.c:1660:_update_ice_connection_state_task:<webrtcbin-9bc1a52f-e6b3-40e9-8090-72d4a858e8c9> ICE connection state change from connected(2) to completed(3)
0:00:04.219040101 8868 0x7f840010b0 INFO webrtcsink net/webrtc/src/webrtcsink/imp.rs:2671:gstrswebrtc::webrtcsink::imp::BaseWebRTCSink::start_session::{{closure}}:<session-pipeline-9bc1a52f-e6b3-40e9-8090-72d4a858e8c9> Recalculating latency
0:00:04.219500358 8868 0x7f840010b0 INFO webrtctransportsendbin transportsendbin.c:454:gst_transport_send_bin_element_query:<transportsendbin0> configured latency of 0:00:00.000000000
0:00:04.232663062 8868 0x7f84053310 INFO webrtcbin gstwebrtcbin.c:1695:_update_peer_connection_state_task:<webrtcbin-9bc1a52f-e6b3-40e9-8090-72d4a858e8c9> Peer connection state change from connecting(1) to connected(2)
0:00:04.279551492 8868 0x7f8404cba0 ERROR webrtcnice nice.c:343:on_resolve_host: failed to resolve: Error resolving “5f81838d-cf6f-42d5-8e98-3baa3d15a655.local”: System error
0:00:04.279599466 8868 0x7f8404cba0 WARN webrtcnice nice.c:784:on_candidate_resolved:<webrtcbin-9bc1a52f-e6b3-40e9-8090-72d4a858e8c9:ice> Could not resolve candidate address: Error resolving “5f81838d-cf6f-42d5-8e98-3baa3d15a655.local”: System error
0:00:04.346521175 8868 0x7f84053310 INFO webrtcbin gstwebrtcbin.c:1633:_update_ice_gathering_state_task:<webrtcbin-9bc1a52f-e6b3-40e9-8090-72d4a858e8c9> ICE gathering state change from gathering(1) to complete(2)
0:00:23.7 / 99:99:99.
(gst-launch-1.0:8868): libsoup-CRITICAL **: 06:25:04.187: soup_uri_to_string_internal: assertion 'uri != NULL' failed
0:00:24.2 / 99:99:99.
(gst-launch-1.0:8868): libsoup-CRITICAL **: 06:25:04.709: soup_uri_to_string_internal: assertion 'uri != NULL' failed
0:01:48.717278910 8868 0x7f840010b0 INFO webrtcsink net/webrtc/src/webrtcsink/imp.rs:2671:gstrswebrtc::webrtcsink::imp::BaseWebRTCSink::start_session::{{closure}}:<session-pipeline-9bc1a52f-e6b3-40e9-8090-72d4a858e8c9> Recalculating latency
0:01:48.717691812 8868 0x7f840010b0 INFO webrtctransportsendbin transportsendbin.c:454:gst_transport_send_bin_element_query:<transportsendbin0> configured latency of 0:00:00.000000000
0:01:48.719724549 8868 0x7f90001af0 INFO webrtcbin gstwebrtcbin.c:5262:_connect_input_stream:<webrtcbin-9bc1a52f-e6b3-40e9-8090-72d4a858e8c9:sink_0> linking input stream 0
0:01:48.728628484 8868 0x7f90001890 INFO webrtcbin gstwebrtcbin.c:7791:on_rtpbin_new_sender_ssrc:<webrtcbin-9bc1a52f-e6b3-40e9-8090-72d4a858e8c9> session 0 ssrc 721575733 new sender ssrc
0:01:48.728689219 8868 0x7f90001890 INFO webrtctransportstream transportstream.c:352:transport_stream_add_ssrc_map_item:<transportstream0> Adding mapping for rtp session 0 media_idx 4294967295 direction sendonly ssrc 721575733
0:01:49.707492375 8868 0x7f90000fb0 INFO webrtcbin gstwebrtcbin.c:7712:on_rtpbin_new_ssrc:<webrtcbin-9bc1a52f-e6b3-40e9-8090-72d4a858e8c9> session 0 ssrc 1 new ssrc
0:01:49.707537848 8868 0x7f90000fb0 INFO webrtctransportstream transportstream.c:352:transport_stream_add_ssrc_map_item:<transportstream0> Adding mapping for rtp session 0 media_idx 4294967295 direction recvonly ssrc 1
^Chandling interrupt.
Interrupt: Stopping pipeline ...
Execution ended after 0:04:45.877092927
Setting pipeline to NULL ...
0:04:46.816981305 8868 0x12bf15b0 INFO webrtcsink net/webrtc/src/webrtcsink/imp.rs:1802:gstrswebrtc::webrtcsink::imp::BaseWebRTCSink::unprepare:<webrtcsink0> unpreparing
0:04:46.817038913 8868 0x12bf15b0 INFO webrtcsink net/webrtc/src/webrtcsink/imp.rs:1061:gstrswebrtc::webrtcsink::imp::State::finalize_session: Ending session 9bc1a52f-e6b3-40e9-8090-72d4a858e8c9
0:04:46.817575358 8868 0x12bf15b0 INFO webrtcsink net/webrtc/src/webrtcsink/imp.rs:1851:gstrswebrtc::webrtcsink::imp::BaseWebRTCSink::unprepare:<webrtcsink0> Stopping signaller
0:04:46.817773809 8868 0x12bf15b0 INFO webrtcsrc-signaller net/webrtc/src/signaller/imp.rs:607:<gstrswebrtc::signaller::imp::Signaller as gstrswebrtc::signaller::iface::SignallableImpl>::stop:<GstWebRTCSignaller@0x12bbac80> Stopping now
0:04:46.818406406 8868 0x7f840010b0 INFO webrtcsrc-signaller net/webrtc/src/signaller/imp.rs:469:gstrswebrtc::signaller::imp::Signaller::handle_message:<GstWebRTCSignaller@0x12bbac80> websocket connection closed: None
0:04:46.818447659 8868 0x7f840010b0 INFO webrtcsrc-signaller net/webrtc/src/signaller/imp.rs:207:gstrswebrtc::signaller::imp::Signaller::connect::{{closure}}::{{closure}}::{{closure}}:<GstWebRTCSignaller@0x12bbac80> Stopped websocket receiving
0:04:46.819206098 8868 0x12bf15b0 INFO webrtcsink net/webrtc/src/webrtcsink/imp.rs:1853:gstrswebrtc::webrtcsink::imp::BaseWebRTCSink::unprepare:<webrtcsink0> Stopped signaller
Freeing pipeline ...