Closed sksamal closed 3 years ago
Hello @sksamal! :wave: we're sorry you found a bug... so first of all, thank you very much for reporting it.
To know about progress, check in Triage. All issues are considered Backlog Candidates until work priorities align and the issue is selected for development. It will then become part of our official Backlog.
I also encountered this problem. When using rtsp, because the URI needs to be followed by parameters, there will be the following format: rtsp://username:password@ip_address:rtsp_port/Streaming/Channels/(?parm1=value1&parm2 -=value2...), but this format is not supported by kurento, and an error is reported directly. Please take a look at the author, thank you very much.
Your bug report says Kurento 6.14, 6.15, but then your command output says 7.0. Note that 7.0 is a development branch that has been stalled for more than a year, you shouldn't use it.
Please, read Debug Logging to enable the PlayerEndpoint suggested debug logs, and read them to see if you find some obvious error that gives you a hint about what could be happening.
If in doubt, select the most relevant lines (like those referring to RTSP or to your URI) and paste them here for us to see.
I tested with a dummy address rtsp://admin:passw@rd@10.127.117.181:554/media/video1
(not available in my network, but anyway I wanted to see what happens) and the relevant logs are like this:
LOG uridecodebin gsturidecodebin.c:1316:gen_source_element:<uridecodebin0> finding source for rtsp://admin:passw@rd@10.127.117.181:554/media/video1
DEBUG rtspsrc gstrtspsrc.c:7899:gst_rtspsrc_uri_set_uri:<source> parsing URI
DEBUG rtspsrc gstrtspsrc.c:7906:gst_rtspsrc_uri_set_uri:<source> configuring URI
DEBUG rtspsrc gstrtspsrc.c:7922:gst_rtspsrc_uri_set_uri:<source> set uri: rtsp://admin:passw@rd@10.127.117.181:554/media/video1
DEBUG rtspsrc gstrtspsrc.c:7924:gst_rtspsrc_uri_set_uri:<source> request uri is: rtsp://rd@10.127.117.181:554/media/video1
LOG uridecodebin gsturidecodebin.c:1329:gen_source_element:<uridecodebin0> found source type GstRTSPSrc
DEBUG rtspsrc gstrtspsrc.c:4052:gst_rtsp_conninfo_connect:<source> creating connection (rtsp://admin:passw@rd@10.127.117.181:554/media/video1)...
DEBUG rtspsrc gstrtspsrc.c:4063:gst_rtsp_conninfo_connect:<source> sanitized uri rtsp://rd@10.127.117.181:554/media/video1
DEBUG rtspsrc gstrtspsrc.c:4095:gst_rtsp_conninfo_connect:<source> connecting (rtsp://admin:passw@rd@10.127.117.181:554/media/video1)...
ERROR default gstrtspconnection.c:960:gst_rtsp_connection_connect_with_response: failed to connect: Could not connect to 10.127.117.181: Socket I/O timed out
ERROR rtspsrc gstrtspsrc.c:4137:gst_rtsp_conninfo_connect:<source> Could not connect to server. (Generic error)
WARN rtspsrc gstrtspsrc.c:6795:gst_rtspsrc_retrieve_sdp:<source> error: Failed to connect. (Generic error)
Of course it failed because my network doesn't have such IP camera, but it goes to show that Kurento provides the correct URI as-is to the GStreamer player. And these lines:
creating connection (rtsp://admin:passw@rd@10.127.117.181:554/media/video1)...
sanitized uri rtsp://rd@10.127.117.181:554/media/video1
connecting (rtsp://admin:passw@rd@10.127.117.181:554/media/video1)...
Make me think that this is an issue in GStreamer and not Kurento itself. Looks like GStreamer assumes that the user:password ends where at the first @
, and the rest is part of the hostname. But, more logs from different tests could help confirm the problem.
Apart from testing with Kurento, I'd suggest a quick test: install and use GStreamer itself to see if playback works. Something like this, but with a custom RTSP uri:
# Install GStreamer.
sudo apt-get update && sudo apt-get install --yes \
gstreamer1.5-plugins-{good,bad,ugly} \
gstreamer1.5-{libav,tools}
# Play the RTSP source directly with GStreamer.
export GST_DEBUG="3,uridecodebin:6,rtspsrc:5"
gst-launch-1.5 \
uridecodebin uri='rtsp://wowzaec2demo.streamlock.net/vod/mp4:BigBuckBunny_115k.mov' \
! videorate ! videoconvert ! autovideosink
And also if you are on Ubuntu 18.04 or newer, try also with the system's official version, using 1.0
instead of 1.5
in the commands above.
Related issues:
Related GStreamer commit:
This added encoded-char support for URLs and was merged for GStreamer >= 1.11.1. Sadly, Kurento uses a fork of GStreamer 1.8.1, so it doesn't have the patch.
The experimental version of Kurento in the branch 7.0, however, should be using GStreamer 1.14.0 in Ubuntu 18.04. In other words, this issue should not happen with Kurento 7.0 on Ubuntu 18.04.
The original issue report states that they were actually testing Kurento 7.0:
Kurento Media Server version: 7.0.0~15.g692a6f5
Found modules:
'core' version 7.0.0~10.g1f1ce74d
'elements' version 7.0.0~25.gfe11a16
'filters' version 7.0.0~10.gf2d83e5
so I'm curious to hear if the issue did really happen or not, with that version.
Sorry for the late reply. I had used the experimental version 7 of kurento only after reading that it uses gstreamer 1.14.0. We use gstreamer >1.14.0 separately for streaming and i know that it streams perfectly with the encoded chars in the url (i.e %40 instead of @) however fails with the plain url with special characters.
Here are the debug logs that you requested:
The rtsp url is : rtsp://admin1:passw@rd123@10.127.117.210:554/media/video1
where username = "admin1" and password = "passw@rd123"
[Debug logs with v6.14.0 docker] =============Kurento 6.14.0 docker ============
0:43:06.117613336 1 0x7fbcf0003e40 DEBUG uridecodebin gsturidecodebin.c:2204:setup_source:<uridecodebin3> setup source
0:43:06.117622257 1 0x7fbcf0003e40 LOG uridecodebin gsturidecodebin.c:1316:gen_source_element:<uridecodebin3> finding source for rtsp://admin1:passw@rd123@10.127.117.210:554/media/video1
0:43:06.117859884 1 0x7fbcf0003e40 DEBUG rtspsrc gstrtspsrc.c:7899:gst_rtspsrc_uri_set_uri:<source> parsing URI
0:43:06.117877159 1 0x7fbcf0003e40 DEBUG rtspsrc gstrtspsrc.c:7906:gst_rtspsrc_uri_set_uri:<source> configuring URI
0:43:06.117889122 1 0x7fbcf0003e40 DEBUG rtspsrc gstrtspsrc.c:7922:gst_rtspsrc_uri_set_uri:<source> set uri: rtsp://admin1:passw@rd123@10.127.117.210:554/media/video1
0:43:06.117900178 1 0x7fbcf0003e40 DEBUG rtspsrc gstrtspsrc.c:7924:gst_rtspsrc_uri_set_uri:<source> request uri is: rtsp://rd123@10.127.117.210:554/media/video1
0:43:06.117911767 1 0x7fbcf0003e40 LOG uridecodebin gsturidecodebin.c:1329:gen_source_element:<uridecodebin3> found source type GstRTSPSrc
0:43:06.117934749 1 0x7fbcf0003e40 LOG uridecodebin gsturidecodebin.c:1339:gen_source_element:<uridecodebin3> source is stream: 0
0:43:06.117944673 1 0x7fbcf0003e40 LOG uridecodebin gsturidecodebin.c:1342:gen_source_element:<uridecodebin3> source needs queue: 0
0:43:06.117960706 1 0x7fbcf0003e40 DEBUG uridecodebin gsturidecodebin.c:1380:gen_source_element:<uridecodebin3> setting connection-speed=0 to source element
0:43:06.118021985 1 0x7fbcf0003e40 WARN playerendpoint kmsplayerendpoint.c:1270:kms_player_endpoint_uridecodebin_source_setup:<kmsplayerendpoint3> Skip setting latency probe, no src pad in <uridecodebin3> (GstRTSPSrc)
0:43:06.118046513 1 0x7fbcf0003e40 DEBUG uridecodebin gsturidecodebin.c:2258:setup_source:<uridecodebin3> Source has dynamic output pads
0:43:06.118068376 1 0x7fbcf0003e40 DEBUG rtspsrc gstrtspsrc.c:7673:gst_rtspsrc_start:<source> starting
0:43:06.118123993 1 0x7fbcf0003e40 DEBUG rtspsrc gstrtspsrc.c:5012:gst_rtspsrc_loop_send_cmd:<source> sending cmd OPEN
0:43:06.118135334 1 0x7fbcf0003e40 DEBUG rtspsrc gstrtspsrc.c:5037:gst_rtspsrc_loop_send_cmd:<source> not interrupting busy cmd unknown
0:43:06.118328054 1 0x7fbcf0003e40 DEBUG uridecodebin gsturidecodebin.c:917:do_async_done:<uridecodebin3> posting ASYNC_DONE
0:43:06.118377441 1 0x7fbc5c001e30 DEBUG rtspsrc gstrtspsrc.c:7628:gst_rtspsrc_thread:<source> got command OPEN
0:43:06.118409631 1 0x7fbc5c001e30 DEBUG rtspsrc gstrtspsrc.c:4182:gst_rtspsrc_connection_flush:<source> set flushing 0
0:43:06.118425142 1 0x7fbc5c001e30 DEBUG rtspsrc gstrtspsrc.c:4052:gst_rtsp_conninfo_connect:<source> creating connection (rtsp://admin1:passw@rd123@10.127.117.210:554/media/video1)...
0:43:06.118509024 1 0x7fbc5c001e30 DEBUG rtspsrc gstrtspsrc.c:4063:gst_rtsp_conninfo_connect:<source> sanitized uri rtsp://rd123@10.127.117.210:554/media/video1
0:43:06.118558403 1 0x7fbcf0003e40 DEBUG rtspsrc gstrtspsrc.c:5012:gst_rtspsrc_loop_send_cmd:<source> sending cmd WAIT
0:43:06.118590877 1 0x7fbcf0003e40 DEBUG rtspsrc gstrtspsrc.c:5024:gst_rtspsrc_loop_send_cmd:<source> cancel previous request LOOP
0:43:06.118617337 1 0x7fbcf0003e40 DEBUG rtspsrc gstrtspsrc.c:5037:gst_rtspsrc_loop_send_cmd:<source> not interrupting busy cmd OPEN
0:43:06.118560602 1 0x7fbc5c001e30 DEBUG rtspsrc gstrtspsrc.c:4095:gst_rtsp_conninfo_connect:<source> connecting (rtsp://admin1:passw@rd123@10.127.117.210:554/media/video1)...
0:43:06.118667781 1 0x7fbcf0003e40 DEBUG rtspsrc gstrtspsrc.c:5012:gst_rtspsrc_loop_send_cmd:<source> sending cmd PLAY
0:43:06.118680956 1 0x7fbcf0003e40 DEBUG rtspsrc gstrtspsrc.c:5037:gst_rtspsrc_loop_send_cmd:<source> not interrupting busy cmd OPEN
0:43:06.120377338 1 0x7fbc5c001e30 DEBUG rtspsrc gstrtspsrc.c:6695:gst_rtspsrc_retrieve_sdp:<source> create options...
0:43:06.120420832 1 0x7fbc5c001e30 DEBUG rtspsrc gstrtspsrc.c:6703:gst_rtspsrc_retrieve_sdp:<source> send options...
0:43:06.120456869 1 0x7fbc5c001e30 DEBUG rtspsrc gstrtspsrc.c:5401:gst_rtspsrc_try_send:<source> sending message
0:43:06.122622273 1 0x7fbc5c001e30 DEBUG rtspsrc gstrtspsrc.c:5430:gst_rtspsrc_try_send:<source> received response message
0:43:06.122647699 1 0x7fbc5c001e30 DEBUG rtspsrc gstrtspsrc.c:5445:gst_rtspsrc_try_send:<source> got response message 200
0:43:06.122672345 1 0x7fbc5c001e30 DEBUG rtspsrc gstrtspsrc.c:6718:gst_rtspsrc_retrieve_sdp:<source> create describe...
0:43:06.122682010 1 0x7fbc5c001e30 DEBUG rtspsrc gstrtspsrc.c:6730:gst_rtspsrc_retrieve_sdp:<source> send describe...
0:43:06.122719659 1 0x7fbc5c001e30 DEBUG rtspsrc gstrtspsrc.c:5401:gst_rtspsrc_try_send:<source> sending message
0:43:06.135348495 1 0x7fbc5c001e30 DEBUG rtspsrc gstrtspsrc.c:5430:gst_rtspsrc_try_send:<source> received response message
0:43:06.135379902 1 0x7fbc5c001e30 DEBUG rtspsrc gstrtspsrc.c:5445:gst_rtspsrc_try_send:<source> got response message 401
0:43:06.135404314 1 0x7fbc5c001e30 DEBUG rtspsrc gstrtspsrc.c:5332:gst_rtspsrc_setup_auth:<source> Attempting authentication using credentials from the URL
0:43:06.135415689 1 0x7fbc5c001e30 DEBUG rtspsrc gstrtspsrc.c:5361:gst_rtspsrc_setup_auth:<source> Attempting Digest authentication
0:43:06.135433512 1 0x7fbc5c001e30 DEBUG rtspsrc gstrtspsrc.c:5401:gst_rtspsrc_try_send:<source> sending message
0:43:07.694521401 1 0x7fbd00012ed0 DEBUG kmselement kmselement.c:959:kms_element_set_sink_input_stats:<kmswebrtcendpoint3> Generating average stats for pad <kmswebrtcendpoint3:sink_audio_default>
0:43:07.694749690 1 0x7fbd00012ed0 DEBUG kmselement kmselement.c:959:kms_element_set_sink_input_stats:<kmswebrtcendpoint3> Generating average stats for pad <kmswebrtcendpoint3:sink_video_default>
0:43:26.155788820 1 0x7fbc5c001e30 WARN rtspsrc gstrtspsrc.c:5500:gst_rtspsrc_try_send:<source> error: Could not receive message. (Timeout while waiting for server response)
0:43:26.156187724 1 0x7fbc5c001e30 DEBUG rtspsrc gstrtspsrc.c:5601:gst_rtspsrc_send:<source> got error -14
0:43:26.156217096 1 0x7fbc5c001e30 DEBUG rtspsrc gstrtspsrc.c:6840:gst_rtspsrc_retrieve_sdp:<source> free connection
0:43:26.156217601 1 0x7fbce00b0320 DEBUG playerendpoint kmsplayerendpoint.c:1166:kms_player_endpoint_emit_invalid_uri_signal: Emit 'Invalid URI' signal
0:43:26.156303112 1 0x55a45ee50730 ERROR playerendpoint kmsplayerendpoint.c:1338:process_bus_message:<kmsplayerendpoint3> Error code 9: 'Could not read from resource.', element: source, parent: internalpipeline
0:43:26.156329674 1 0x7fbc5c001e30 DEBUG rtspsrc gstrtspsrc.c:4150:gst_rtsp_conninfo_close:<source> closing connection...
0:43:26.156377176 1 0x55a45ee50730 ERROR playerendpoint kmsplayerendpoint.c:1341:process_bus_message:<kmsplayerendpoint3> Debugging info: gstrtspsrc.c(5500): gst_rtspsrc_try_send (): /GstPipeline:internalpipeline/GstURIDecodeBin:uridecodebin3/GstRTSPSrc:source:
Could not receive message. (Timeout while waiting for server response)
0:43:26.156613781 1 0x7fbc5c001e30 DEBUG rtspsrc gstrtspsrc.c:4156:gst_rtsp_conninfo_close:<source> freeing connection...
0:43:26.156652834 1 0x7fbc5c001e30 WARN rtspsrc gstrtspsrc.c:6874:gst_rtspsrc_open:<source> can't get sdp
0:43:26.156704100 1 0x7fbc5c001e30 DEBUG rtspsrc gstrtspsrc.c:7628:gst_rtspsrc_thread:<source> got command PLAY
0:43:26.156716263 1 0x7fbc5c001e30 DEBUG rtspsrc gstrtspsrc.c:4182:gst_rtspsrc_connection_flush:<source> set flushing 0
0:43:26.156726656 1 0x7fbc5c001e30 DEBUG rtspsrc gstrtspsrc.c:7208:gst_rtspsrc_play:<source> PLAY...
0:43:26.156734075 1 0x7fbc5c001e30 DEBUG rtspsrc gstrtspsrc.c:7181:gst_rtspsrc_ensure_open:<source> the stream was in error
0:43:26.156742169 1 0x7fbc5c001e30 DEBUG rtspsrc gstrtspsrc.c:7377:gst_rtspsrc_play:<source> failed to open stream
0:43:26.156762141 1 0x7fbc5c001e30 DEBUG rtspsrc gstrtspsrc.c:7628:gst_rtspsrc_thread:<source> got command LOOP
0:43:26.156771023 1 0x7fbc5c001e30 DEBUG rtspsrc gstrtspsrc.c:4182:gst_rtspsrc_connection_flush:<source> set flushing 0
0:43:26.156783168 1 0x7fbc5c001e30 WARN rtspsrc gstrtspsrc.c:5067:gst_rtspsrc_loop:<source> we are not connected
0:43:26.156793713 1 0x7fbc5c001e30 DEBUG rtspsrc gstrtspsrc.c:5075:gst_rtspsrc_loop:<source> pausing task, reason flushing
0:43:26.156803920 1 0x7fbc5c001e30 DEBUG rtspsrc gstrtspsrc.c:5012:gst_rtspsrc_loop_send_cmd:<source> sending cmd WAIT
0:43:26.156811865 1 0x7fbc5c001e30 DEBUG rtspsrc gstrtspsrc.c:5024:gst_rtspsrc_loop_send_cmd:<source> cancel previous request LOOP
0:43:26.156820457 1 0x7fbc5c001e30 DEBUG rtspsrc gstrtspsrc.c:5032:gst_rtspsrc_loop_send_cmd:<source> connection flush busy LOOP
0:43:26.156828085 1 0x7fbc5c001e30 DEBUG rtspsrc gstrtspsrc.c:4182:gst_rtspsrc_connection_flush:<source> set flushing 1
[Debug logs with v7 exp docker - kurento/kurento-media-server-exp:bionic-gstreamer
]
If you notice, there is no change. .
0:01:55.696838386 1 0x7f1d0c01d0f0 DEBUG uridecodebin gsturidecodebin.c:2184:setup_source:<uridecodebin0> setup source
0:01:55.696846542 1 0x7f1d0c01d0f0 LOG uridecodebin gsturidecodebin.c:1298:gen_source_element:<uridecodebin0> finding source for rtsp://admin1:passw@rd123@10.127.117.210:554/media/video1
0:01:55.699193119 1 0x7f1d0c01d0f0 DEBUG rtspsrc gstrtspsrc.c:8617:gst_rtspsrc_uri_set_uri:<source> parsing URI
0:01:55.699216662 1 0x7f1d0c01d0f0 DEBUG rtspsrc gstrtspsrc.c:8624:gst_rtspsrc_uri_set_uri:<source> configuring URI
0:01:55.699222869 1 0x7f1d0c01d0f0 DEBUG rtspsrc gstrtspsrc.c:8640:gst_rtspsrc_uri_set_uri:<source> set uri: rtsp://admin1:passw@rd123@10.127.117.210:554/media/video1
0:01:55.699226298 1 0x7f1d0c01d0f0 DEBUG rtspsrc gstrtspsrc.c:8642:gst_rtspsrc_uri_set_uri:<source> request uri is: rtsp://rd123@10.127.117.210:554/media/video1
0:01:55.699232192 1 0x7f1d0c01d0f0 LOG uridecodebin gsturidecodebin.c:1311:gen_source_element:<uridecodebin0> found source type GstRTSPSrc
0:01:55.699247305 1 0x7f1d0c01d0f0 LOG uridecodebin gsturidecodebin.c:1321:gen_source_element:<uridecodebin0> source is stream: 0
0:01:55.699250709 1 0x7f1d0c01d0f0 LOG uridecodebin gsturidecodebin.c:1324:gen_source_element:<uridecodebin0> source needs queue: 0
0:01:55.699257493 1 0x7f1d0c01d0f0 DEBUG uridecodebin gsturidecodebin.c:1362:gen_source_element:<uridecodebin0> setting connection-speed=0 to source element
0:01:55.699289598 1 0x7f1d0c01d0f0 WARN playerendpoint kmsplayerendpoint.c:1270:kms_player_endpoint_uridecodebin_source_setup:<kmsplayerendpoint0> Skip setting latency probe, no src pad in <uridecodebin0> (GstRTSPSrc)
0:01:55.699298308 1 0x7f1d0c01d0f0 DEBUG uridecodebin gsturidecodebin.c:2238:setup_source:<uridecodebin0> Source has dynamic output pads
0:01:55.699307201 1 0x7f1d0c01d0f0 DEBUG rtspsrc gstrtspsrc.c:8391:gst_rtspsrc_start:<source> starting
0:01:55.699346338 1 0x7f1d0c01d0f0 DEBUG rtspsrc gstrtspsrc.c:5567:gst_rtspsrc_loop_send_cmd:<source> sending cmd OPEN
0:01:55.699358482 1 0x7f1d0c01d0f0 DEBUG rtspsrc gstrtspsrc.c:5598:gst_rtspsrc_loop_send_cmd:<source> not interrupting busy cmd unknown
0:01:55.699455718 1 0x7f1d0c01d0f0 DEBUG uridecodebin gsturidecodebin.c:899:do_async_done:<uridecodebin0> posting ASYNC_DONE
0:01:55.699570846 1 0x7f1d0c01d0f0 DEBUG rtspsrc gstrtspsrc.c:5567:gst_rtspsrc_loop_send_cmd:<source> sending cmd WAIT
0:01:55.699595998 1 0x7f1cf8009b20 DEBUG rtspsrc gstrtspsrc.c:8346:gst_rtspsrc_thread:<source> got command OPEN
0:01:55.699624645 1 0x7f1cf8009b20 DEBUG rtspsrc gstrtspsrc.c:4748:gst_rtspsrc_connection_flush:<source> set flushing 0
0:01:55.699650216 1 0x7f1d0c01d0f0 DEBUG rtspsrc gstrtspsrc.c:5585:gst_rtspsrc_loop_send_cmd:<source> cancel previous request LOOP
0:01:55.699668220 1 0x7f1d0c01d0f0 DEBUG rtspsrc gstrtspsrc.c:5598:gst_rtspsrc_loop_send_cmd:<source> not interrupting busy cmd OPEN
0:01:55.699677654 1 0x7f1cf8009b20 DEBUG rtspsrc gstrtspsrc.c:4614:gst_rtsp_conninfo_connect:<source> creating connection (rtsp://admin1:passw@rd123@10.127.117.210:554/media/video1)...
0:01:55.699689439 1 0x7f1d0c01d0f0 DEBUG rtspsrc gstrtspsrc.c:5567:gst_rtspsrc_loop_send_cmd:<source> sending cmd PLAY
0:01:55.699693793 1 0x7f1d0c01d0f0 DEBUG rtspsrc gstrtspsrc.c:5598:gst_rtspsrc_loop_send_cmd:<source> not interrupting busy cmd OPEN
0:01:55.699889388 1 0x7f1cf8009b20 DEBUG rtspsrc gstrtspsrc.c:4625:gst_rtsp_conninfo_connect:<source> sanitized uri rtsp://rd123@10.127.117.210:554/media/video1
0:01:55.699932016 1 0x7f1cf8009b20 DEBUG rtspsrc gstrtspsrc.c:4659:gst_rtsp_conninfo_connect:<source> connecting (rtsp://admin1:passw@rd123@10.127.117.210:554/media/video1)...
0:01:55.798046571 1 0x7f1cf8009b20 DEBUG rtspsrc gstrtspsrc.c:7342:gst_rtspsrc_retrieve_sdp:<source> create options... (async)
0:01:55.798091490 1 0x7f1cf8009b20 DEBUG rtspsrc gstrtspsrc.c:7351:gst_rtspsrc_retrieve_sdp:<source> send options...
0:01:55.798179671 1 0x7f1cf8009b20 DEBUG rtspsrc gstrtspsrc.c:476:default_before_send:<source> default handler
0:01:55.798193030 1 0x7f1cf8009b20 DEBUG rtspsrc gstrtspsrc.c:476:default_before_send:<source> default handler
0:01:55.798202362 1 0x7f1cf8009b20 DEBUG rtspsrc gstrtspsrc.c:5964:gst_rtspsrc_try_send:<source> sending message
0:01:55.800196524 1 0x7f1cf8009b20 DEBUG rtspsrc gstrtspsrc.c:5866:gst_rtsp_src_receive_response:<source> received response message
0:01:55.800230913 1 0x7f1cf8009b20 DEBUG rtspsrc gstrtspsrc.c:5885:gst_rtsp_src_receive_response:<source> got response message 200
0:01:55.800248494 1 0x7f1cf8009b20 INFO rtspsrc gstrtspsrc.c:7364:gst_rtspsrc_retrieve_sdp:<source> Now using version: 1.0
0:01:55.800271638 1 0x7f1cf8009b20 DEBUG rtspsrc gstrtspsrc.c:7371:gst_rtspsrc_retrieve_sdp:<source> create describe...
0:01:55.800287852 1 0x7f1cf8009b20 DEBUG rtspsrc gstrtspsrc.c:7388:gst_rtspsrc_retrieve_sdp:<source> send describe...
0:01:55.800360356 1 0x7f1cf8009b20 DEBUG rtspsrc gstrtspsrc.c:476:default_before_send:<source> default handler
0:01:55.800388028 1 0x7f1cf8009b20 DEBUG rtspsrc gstrtspsrc.c:476:default_before_send:<source> default handler
0:01:55.800401287 1 0x7f1cf8009b20 DEBUG rtspsrc gstrtspsrc.c:5964:gst_rtspsrc_try_send:<source> sending message
0:01:55.812496819 1 0x7f1cf8009b20 DEBUG rtspsrc gstrtspsrc.c:5866:gst_rtsp_src_receive_response:<source> received response message
0:01:55.812536246 1 0x7f1cf8009b20 DEBUG rtspsrc gstrtspsrc.c:5885:gst_rtsp_src_receive_response:<source> got response message 401
0:01:55.812566240 1 0x7f1cf8009b20 DEBUG rtspsrc gstrtspsrc.c:5785:gst_rtspsrc_setup_auth:<source> Attempting authentication using credentials from the URL
0:01:55.812578929 1 0x7f1cf8009b20 DEBUG rtspsrc gstrtspsrc.c:5814:gst_rtspsrc_setup_auth:<source> Attempting Digest authentication
0:01:55.812595294 1 0x7f1cf8009b20 DEBUG rtspsrc gstrtspsrc.c:476:default_before_send:<source> default handler
0:01:55.812605732 1 0x7f1cf8009b20 DEBUG rtspsrc gstrtspsrc.c:476:default_before_send:<source> default handler
0:01:55.812614746 1 0x7f1cf8009b20 DEBUG rtspsrc gstrtspsrc.c:5964:gst_rtspsrc_try_send:<source> sending message
0:01:56.426543474 1 0x7f1d20083e30 WARN dtlssrtpdemux gstdtlssrtpdemux.c:134:sink_chain:<dtlssrtpdemux0> received invalid buffer: 1
0:01:57.236343982 1 0x7f1d20083e30 DEBUG kmselement kmselement.c:959:kms_element_set_sink_input_stats:<kmswebrtcendpoint0> Generating average stats for pad <kmswebrtcendpoint0:sink_audio_default>
0:01:57.236629535 1 0x7f1d20083e30 DEBUG kmselement kmselement.c:959:kms_element_set_sink_input_stats:<kmswebrtcendpoint0> Generating average stats for pad <kmswebrtcendpoint0:sink_video_default>
0:02:15.832990598 1 0x7f1cf8009b20 WARN rtspsrc gstrtspsrc.c:5917:gst_rtsp_src_receive_response:<source> error: Could not receive message. (Timeout while waiting for server response)
0:02:15.833257749 1 0x7f1cf8009b20 DEBUG rtspsrc gstrtspsrc.c:6102:gst_rtspsrc_send:<source> got error -14
0:02:15.833284956 1 0x7f1cf8009b20 DEBUG rtspsrc gstrtspsrc.c:7514:gst_rtspsrc_retrieve_sdp:<source> free connection
0:02:15.833296327 1 0x7f1cf8009b20 DEBUG rtspsrc gstrtspsrc.c:4715:gst_rtsp_conninfo_close:<source> closing connection...
0:02:15.833294074 1 0x7f1d0c014c00 DEBUG playerendpoint kmsplayerendpoint.c:1166:kms_player_endpoint_emit_invalid_uri_signal: Emit 'Invalid URI' signal
0:02:15.833435964 1 0x5592a94e3e40 ERROR playerendpoint kmsplayerendpoint.c:1338:process_bus_message:<kmsplayerendpoint0> Error code 9: 'Could not read from resource.', element: source, parent: internalpipeline
0:02:15.833481884 1 0x5592a94e3e40 ERROR playerendpoint kmsplayerendpoint.c:1341:process_bus_message:<kmsplayerendpoint0> Debugging info: gstrtspsrc.c(5917): gst_rtsp_src_receive_response (): /GstPipeline:internalpipeline/GstURIDecodeBin:uridecodebin0/GstRTSPSrc:source:
Could not receive message. (Timeout while waiting for server response)
0:02:15.833530296 1 0x7f1cf8009b20 DEBUG rtspsrc gstrtspsrc.c:4721:gst_rtsp_conninfo_close:<source> freeing connection...
0:02:15.833579573 1 0x7f1cf8009b20 WARN rtspsrc gstrtspsrc.c:7548:gst_rtspsrc_open:<source> can't get sdp
0:02:15.833718560 1 0x7f1cf8009b20 DEBUG rtspsrc gstrtspsrc.c:8346:gst_rtspsrc_thread:<source> got command PLAY
0:02:15.833748288 1 0x7f1cf8009b20 DEBUG rtspsrc gstrtspsrc.c:4748:gst_rtspsrc_connection_flush:<source> set flushing 0
0:02:15.833777574 1 0x7f1cf8009b20 DEBUG rtspsrc gstrtspsrc.c:7886:gst_rtspsrc_play:<source> PLAY...
0:02:15.833790257 1 0x7f1cf8009b20 DEBUG rtspsrc gstrtspsrc.c:7858:gst_rtspsrc_ensure_open:<source> the stream was in error
0:02:15.833802747 1 0x7f1cf8009b20 WARN rtspsrc gstrtspsrc.c:8086:gst_rtspsrc_play:<source> failed to open stream
0:02:15.833854991 1 0x7f1cf8009b20 DEBUG rtspsrc gstrtspsrc.c:8346:gst_rtspsrc_thread:<source> got command LOOP
0:02:15.833876829 1 0x7f1cf8009b20 DEBUG rtspsrc gstrtspsrc.c:4748:gst_rtspsrc_connection_flush:<source> set flushing 0
0:02:15.833885462 1 0x7f1cf8009b20 WARN rtspsrc gstrtspsrc.c:5628:gst_rtspsrc_loop:<source> we are not connected
0:02:15.833895270 1 0x7f1cf8009b20 DEBUG rtspsrc gstrtspsrc.c:5636:gst_rtspsrc_loop:<source> pausing task, reason flushing
0:02:15.833906737 1 0x7f1cf8009b20 DEBUG rtspsrc gstrtspsrc.c:5567:gst_rtspsrc_loop_send_cmd:<source> sending cmd WAIT
0:02:15.833915377 1 0x7f1cf8009b20 DEBUG rtspsrc gstrtspsrc.c:5585:gst_rtspsrc_loop_send_cmd:<source> cancel previous request LOOP
0:02:15.833923646 1 0x7f1cf8009b20 DEBUG rtspsrc gstrtspsrc.c:5593:gst_rtspsrc_loop_send_cmd:<source> connection flush busy LOOP
0:02:15.833932488 1 0x7f1cf8009b20 DEBUG rtspsrc gstrtspsrc.c:4748:gst_rtspsrc_connection_flush:<source> set flushing 1
This are logs from gstreamer 1.17.1. I will provide logs for gstreamer 1.5 once i am able to set it up. Below are logs of successful attempt when we use encoded chars (i.e %40 inplace of @ in password). Next one is a failed attempt where we use plain url (@) . The sanitized url seems to be correct in the first case.
gst-launch-1.0 rtspsrc location="rtsp://admin1:passw%40rd123@10.127.117.210:554/media/video1" ! videorate ! videoconvert ! autovideosink
0:00:00.019985657 17400 0x559ce80f1a90 DEBUG rtspsrc gstrtspsrc.c:9324:gst_rtspsrc_uri_set_uri:<rtspsrc0> parsing URI
0:00:00.020021099 17400 0x559ce80f1a90 DEBUG rtspsrc gstrtspsrc.c:9331:gst_rtspsrc_uri_set_uri:<rtspsrc0> configuring URI
0:00:00.020031630 17400 0x559ce80f1a90 DEBUG rtspsrc gstrtspsrc.c:9347:gst_rtspsrc_uri_set_uri:<rtspsrc0> set uri: rtsp://admin1:passw%40rd123@10.127.117.210:554/media/video1
0:00:00.020036653 17400 0x559ce80f1a90 DEBUG rtspsrc gstrtspsrc.c:9349:gst_rtspsrc_uri_set_uri:<rtspsrc0> request uri is: rtsp://10.127.117.210:554/media/video1
Setting pipeline to PAUSED ...
0:00:21.399957781 17400 0x559ce80f1a90 DEBUG rtspsrc gstrtspsrc.c:9076:gst_rtspsrc_start:<rtspsrc0> starting
0:00:21.400332775 17400 0x559ce80f1a90 DEBUG rtspsrc gstrtspsrc.c:6033:gst_rtspsrc_loop_send_cmd:<rtspsrc0> sending cmd OPEN
0:00:21.400357591 17400 0x559ce80f1a90 DEBUG rtspsrc gstrtspsrc.c:6071:gst_rtspsrc_loop_send_cmd:<rtspsrc0> not interrupting busy cmd unknown
Pipeline is live and does not need PREROLL ...
0:00:21.400779966 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:9023:gst_rtspsrc_thread:<rtspsrc0> got command OPEN
0:00:21.400856609 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:5190:gst_rtspsrc_connection_flush:<rtspsrc0> set flushing 0
0:00:21.400892867 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:5056:gst_rtsp_conninfo_connect:<rtspsrc0> creating connection (rtsp://admin1:passw%40rd123@10.127.117.210:554/media/video1)...
Got context from element 'autovideosink0': gst.gl.GLDisplay=context, gst.gl.GLDisplay=(GstGLDisplay)"\(GstGLDisplayX11\)\ gldisplayx11-0";
0:00:21.401311795 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:5067:gst_rtsp_conninfo_connect:<rtspsrc0> sanitized uri rtsp://10.127.117.210:554/media/video1
0:00:21.401407078 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:5101:gst_rtsp_conninfo_connect:<rtspsrc0> connecting (rtsp://admin1:passw%40rd123@10.127.117.210:554/media/video1)...
Progress: (open) Opening Stream
Progress: (connect) Connecting to rtsp://admin1:passw%40rd123@10.127.117.210:554/media/video1
0:00:21.415104121 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:7879:gst_rtspsrc_retrieve_sdp:<rtspsrc0> create options... (async)
0:00:21.415124497 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:7888:gst_rtspsrc_retrieve_sdp:<rtspsrc0> send options...
0:00:21.415162687 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:528:default_before_send:<rtspsrc0> default handler
0:00:21.415175132 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:528:default_before_send:<rtspsrc0> default handler
0:00:21.415182480 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:6462:gst_rtspsrc_try_send:<rtspsrc0> sending message
Progress: (open) Retrieving server options
0:00:21.417283560 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:6364:gst_rtsp_src_receive_response:<rtspsrc0> received response message
0:00:21.417301086 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:6383:gst_rtsp_src_receive_response:<rtspsrc0> got response message 200
0:00:21.417328402 17400 0x559ce80d66d0 INFO rtspsrc gstrtspsrc.c:7901:gst_rtspsrc_retrieve_sdp:<rtspsrc0> Now using version: 1.0
0:00:21.417337029 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:7908:gst_rtspsrc_retrieve_sdp:<rtspsrc0> create describe...
0:00:21.417342566 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:7925:gst_rtspsrc_retrieve_sdp:<rtspsrc0> send describe...
0:00:21.417369751 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:528:default_before_send:<rtspsrc0> default handler
0:00:21.417375077 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:528:default_before_send:<rtspsrc0> default handler
0:00:21.417379314 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:6462:gst_rtspsrc_try_send:<rtspsrc0> sending message
Progress: (open) Retrieving media info
0:00:21.428935534 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:6364:gst_rtsp_src_receive_response:<rtspsrc0> received response message
0:00:21.428953232 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:6383:gst_rtsp_src_receive_response:<rtspsrc0> got response message 401
0:00:21.428967918 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:6280:gst_rtspsrc_setup_auth:<rtspsrc0> Attempting authentication using credentials from the URL
0:00:21.428974714 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:6309:gst_rtspsrc_setup_auth:<rtspsrc0> Attempting Digest authentication
0:00:21.428986510 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:528:default_before_send:<rtspsrc0> default handler
0:00:21.428998918 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:528:default_before_send:<rtspsrc0> default handler
0:00:21.429004493 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:6462:gst_rtspsrc_try_send:<rtspsrc0> sending message
0:00:21.538578723 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:6364:gst_rtsp_src_receive_response:<rtspsrc0> received response message
0:00:21.538644726 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:6383:gst_rtsp_src_receive_response:<rtspsrc0> got response message 200
0:00:21.538670884 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:7983:gst_rtspsrc_retrieve_sdp:<rtspsrc0> parse SDP...
0:00:21.538852424 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:2130:gst_rtspsrc_collect_payloads: mapping sdp session level attributes to caps
0:00:21.538873928 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:2132:gst_rtspsrc_collect_payloads: mapping sdp media level attributes to caps
0:00:21.538899000 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:2150:gst_rtspsrc_collect_payloads:<rtspsrc0> looking at 0 pt: 105
0:00:21.538959319 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:2289:gst_rtspsrc_create_stream:<rtspsrc0> stream 0, (0x7efd5401acf0)
0:00:21.538971407 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:2290:gst_rtspsrc_create_stream:<rtspsrc0> port: 0
0:00:21.538992559 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:2291:gst_rtspsrc_create_stream:<rtspsrc0> container: 0
0:00:21.539020263 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:2292:gst_rtspsrc_create_stream:<rtspsrc0> control: rtsp://10.127.117.210/media/video1/video
0:00:21.539040409 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:2347:gst_rtspsrc_create_stream:<rtspsrc0> setup: rtsp://10.127.117.210/media/video1/video
0:00:21.539075114 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:2130:gst_rtspsrc_collect_payloads: mapping sdp session level attributes to caps
0:00:21.539087929 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:2132:gst_rtspsrc_collect_payloads: mapping sdp media level attributes to caps
0:00:21.539105093 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:2150:gst_rtspsrc_collect_payloads:<rtspsrc0> looking at 0 pt: 107
0:00:21.539142812 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:2289:gst_rtspsrc_create_stream:<rtspsrc0> stream 1, (0x7efd5401c110)
0:00:21.539160215 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:2290:gst_rtspsrc_create_stream:<rtspsrc0> port: 0
0:00:21.539170834 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:2291:gst_rtspsrc_create_stream:<rtspsrc0> container: 0
0:00:21.539182090 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:2292:gst_rtspsrc_create_stream:<rtspsrc0> control: rtsp://10.127.117.210/media/video1/metadata
0:00:21.539194078 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:2347:gst_rtspsrc_create_stream:<rtspsrc0> setup: rtsp://10.127.117.210/media/video1/metadata
0:00:21.539219399 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:507:default_select_stream:<rtspsrc0> default handler
0:00:21.539232683 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:518:select_stream_accum: accum 1
0:00:21.539250055 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:507:default_select_stream:<rtspsrc0> default handler
0:00:21.539266568 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:7318:gst_rtspsrc_setup_streams_start:<rtspsrc0> doing setup of stream 0x7efd5401acf0 with rtsp://10.127.117.210/media/video1/video
0:00:21.539280770 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:7333:gst_rtspsrc_setup_streams_start:<rtspsrc0> protocols = 0x7, protocol mask = 0x1
0:00:21.539293394 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:6797:gst_rtspsrc_create_transports_string:<rtspsrc0> got transports (NULL)
0:00:21.539304713 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:6827:gst_rtspsrc_create_transports_string:<rtspsrc0> adding UDP unicast
0:00:21.539316836 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:6854:gst_rtspsrc_create_transports_string:<rtspsrc0> prepared transports RTP/AVP;unicast;client_port=%%u1-%%u2
0:00:21.539333936 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:7348:gst_rtspsrc_setup_streams_start:<rtspsrc0> replace ports in RTP/AVP;unicast;client_port=%%u1-%%u2
0:00:21.541041162 17400 0x559ce80d66d0 WARN udpsrc gstudpsrc.c:1437:gst_udpsrc_open:<udpsrc0> warning: Could not create a buffer of requested 524288 bytes (Operation not permitted). Need net.admin privilege?
0:00:21.541122262 17400 0x559ce80d66d0 WARN udpsrc gstudpsrc.c:1447:gst_udpsrc_open:<udpsrc0> have udp buffer of 212992 bytes while 524288 were requested
0:00:21.541169552 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:2544:gst_rtspsrc_alloc_udp_ports:<rtspsrc0> got RTP port 34514
0:00:21.541474398 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:2576:gst_rtspsrc_alloc_udp_ports:<rtspsrc0> starting RTCP on port 34515
0:00:21.541612596 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:7359:gst_rtspsrc_setup_streams_start:<rtspsrc0> transport is now RTP/AVP;unicast;client_port=34514-34515
0:00:21.541700796 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:528:default_before_send:<rtspsrc0> default handler
0:00:21.541720542 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:528:default_before_send:<rtspsrc0> default handler
0:00:21.541737946 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:6462:gst_rtspsrc_try_send:<rtspsrc0> sending message
Progress: (request) SETUP stream 0
0:00:21.610170035 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:6364:gst_rtsp_src_receive_response:<rtspsrc0> received response message
0:00:21.610264420 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:6383:gst_rtsp_src_receive_response:<rtspsrc0> got response message 200
0:00:21.610309219 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:7071:gst_rtsp_src_setup_stream_from_response:<rtspsrc0> stream 0x7efd5401acf0 as UDP unicast
0:00:21.610323354 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:4670:gst_rtspsrc_stream_configure_transport:<rtspsrc0> configuring transport for stream 0x7efd5401acf0
0:00:21.610336234 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:4679:gst_rtspsrc_stream_configure_transport:<rtspsrc0> setting media type to application/x-rtp
0:00:21.610366974 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:3906:gst_rtspsrc_stream_configure_manager:<rtspsrc0> using manager rtpbin
0:00:21.613188871 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:3614:set_manager_buffer_mode:<rtspsrc0> auto buffering mode, have clock (NULL)
0:00:21.613229909 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:3634:set_manager_buffer_mode:<rtspsrc0> auto buffering mode
0:00:21.613249121 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:3639:set_manager_buffer_mode:<rtspsrc0> selected slave
0:00:21.613273087 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:4005:gst_rtspsrc_stream_configure_manager:<rtspsrc0> connect to signals on session manager, stream 0x7efd5401acf0
0:00:21.615996332 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:3673:request_rtp_decoder: decoder session 0, stream 0x7efd5401acf0, 0
0:00:21.616076026 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:3383:new_manager_pad:<rtspsrc0> got new manager pad <manager:recv_rtp_sink_0>
0:00:21.616092483 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:3456:new_manager_pad:<rtspsrc0> ignoring unknown stream
0:00:21.616203931 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:3673:request_rtp_decoder: decoder session 0, stream 0x7efd5401acf0, 0
0:00:21.616255987 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:3383:new_manager_pad:<rtspsrc0> got new manager pad <manager:recv_rtcp_sink_0>
0:00:21.616269027 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:3456:new_manager_pad:<rtspsrc0> ignoring unknown stream
0:00:21.616288614 17400 0x559ce80d66d0 INFO rtspsrc gstrtspsrc.c:4048:gst_rtspsrc_stream_configure_manager:<rtspsrc0> configure bandwidth in session 0x7efd5403a0e0
0:00:21.616320166 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:4396:gst_rtspsrc_stream_configure_udp:<rtspsrc0> setting up UDP source
0:00:21.616353605 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:4426:gst_rtspsrc_stream_configure_udp:<rtspsrc0> connecting UDP source 0 to manager
0:00:21.616394231 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:4457:gst_rtspsrc_stream_configure_udp:<rtspsrc0> connecting UDP source 1 to manager
0:00:21.616412596 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:4504:gst_rtspsrc_stream_configure_udp_sinks:<rtspsrc0> configure RTP UDP sink for 10.127.117.210:14184
0:00:21.617319175 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:4527:gst_rtspsrc_stream_configure_udp_sinks:<rtspsrc0> RTP UDP src has sock 0x7efd4c0107c0
0:00:21.617509523 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:4569:gst_rtspsrc_stream_configure_udp_sinks:<rtspsrc0> configure RTCP UDP sink for 10.127.117.210:14185
0:00:21.618007540 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:4593:gst_rtspsrc_stream_configure_udp_sinks:<rtspsrc0> RTCP UDP src has sock 0x7efd4c010910
0:00:21.618107614 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:3706:request_rtcp_encoder: decoder session 0, stream 0x7efd5401acf0, 0
0:00:21.618165096 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:3383:new_manager_pad:<rtspsrc0> got new manager pad <manager:send_rtcp_src_0>
0:00:21.618183999 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:3456:new_manager_pad:<rtspsrc0> ignoring unknown stream
0:00:21.618222771 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:507:default_select_stream:<rtspsrc0> default handler
0:00:21.618235663 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:518:select_stream_accum: accum 1
0:00:21.618246968 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:507:default_select_stream:<rtspsrc0> default handler
0:00:21.618260943 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:7318:gst_rtspsrc_setup_streams_start:<rtspsrc0> doing setup of stream 0x7efd5401c110 with rtsp://10.127.117.210/media/video1/metadata
0:00:21.618273990 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:7333:gst_rtspsrc_setup_streams_start:<rtspsrc0> protocols = 0x1, protocol mask = 0x1
0:00:21.618286574 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:6797:gst_rtspsrc_create_transports_string:<rtspsrc0> got transports (NULL)
0:00:21.618297787 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:6827:gst_rtspsrc_create_transports_string:<rtspsrc0> adding UDP unicast
0:00:21.618309564 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:6854:gst_rtspsrc_create_transports_string:<rtspsrc0> prepared transports RTP/AVP;unicast;client_port=%%u1-%%u2
0:00:21.618320814 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:7348:gst_rtspsrc_setup_streams_start:<rtspsrc0> replace ports in RTP/AVP;unicast;client_port=%%u1-%%u2
0:00:21.618531026 17400 0x559ce80d66d0 WARN udpsrc gstudpsrc.c:1437:gst_udpsrc_open:<udpsrc2> warning: Could not create a buffer of requested 524288 bytes (Operation not permitted). Need net.admin privilege?
0:00:21.618573846 17400 0x559ce80d66d0 WARN udpsrc gstudpsrc.c:1447:gst_udpsrc_open:<udpsrc2> have udp buffer of 212992 bytes while 524288 were requested
0:00:21.618604573 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:2544:gst_rtspsrc_alloc_udp_ports:<rtspsrc0> got RTP port 54683
0:00:21.618615827 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:2552:gst_rtspsrc_alloc_udp_ports:<rtspsrc0> RTP port not even
0:00:21.618625838 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:2554:gst_rtspsrc_alloc_udp_ports:<rtspsrc0> free RTP udpsrc
0:00:21.618665811 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:2559:gst_rtspsrc_alloc_udp_ports:<rtspsrc0> retry 1
0:00:21.618836774 17400 0x559ce80d66d0 WARN udpsrc gstudpsrc.c:1437:gst_udpsrc_open:<udpsrc3> warning: Could not create a buffer of requested 524288 bytes (Operation not permitted). Need net.admin privilege?
0:00:21.618873878 17400 0x559ce80d66d0 WARN udpsrc gstudpsrc.c:1447:gst_udpsrc_open:<udpsrc3> have udp buffer of 212992 bytes while 524288 were requested
0:00:21.618901110 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:2544:gst_rtspsrc_alloc_udp_ports:<rtspsrc0> got RTP port 54684
0:00:21.619022450 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:2576:gst_rtspsrc_alloc_udp_ports:<rtspsrc0> starting RTCP on port 54685
0:00:21.619092795 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:7359:gst_rtspsrc_setup_streams_start:<rtspsrc0> transport is now RTP/AVP;unicast;client_port=54684-54685
0:00:21.619142352 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:528:default_before_send:<rtspsrc0> default handler
0:00:21.619160612 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:528:default_before_send:<rtspsrc0> default handler
0:00:21.619172560 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:6462:gst_rtspsrc_try_send:<rtspsrc0> sending message
Progress: (request) SETUP stream 1
0:00:21.690384601 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:6364:gst_rtsp_src_receive_response:<rtspsrc0> received response message
0:00:21.690486148 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:6383:gst_rtsp_src_receive_response:<rtspsrc0> got response message 200
0:00:21.690527755 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:7071:gst_rtsp_src_setup_stream_from_response:<rtspsrc0> stream 0x7efd5401c110 as UDP unicast
0:00:21.690553471 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:4670:gst_rtspsrc_stream_configure_transport:<rtspsrc0> configuring transport for stream 0x7efd5401c110
0:00:21.690572539 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:4679:gst_rtspsrc_stream_configure_transport:<rtspsrc0> setting media type to application/x-rtp
0:00:21.690599949 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:3906:gst_rtspsrc_stream_configure_manager:<rtspsrc0> using manager rtpbin
0:00:21.691138751 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:3673:request_rtp_decoder: decoder session 1, stream 0x7efd5401acf0, 0
0:00:21.691176530 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:3673:request_rtp_decoder: decoder session 1, stream 0x7efd5401c110, 1
0:00:21.691263517 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:3383:new_manager_pad:<rtspsrc0> got new manager pad <manager:recv_rtp_sink_1>
0:00:21.691283793 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:3456:new_manager_pad:<rtspsrc0> ignoring unknown stream
0:00:21.691498858 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:3673:request_rtp_decoder: decoder session 1, stream 0x7efd5401acf0, 0
0:00:21.691529368 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:3673:request_rtp_decoder: decoder session 1, stream 0x7efd5401c110, 1
0:00:21.691614691 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:3383:new_manager_pad:<rtspsrc0> got new manager pad <manager:recv_rtcp_sink_1>
0:00:21.691629843 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:3456:new_manager_pad:<rtspsrc0> ignoring unknown stream
0:00:21.691660142 17400 0x559ce80d66d0 INFO rtspsrc gstrtspsrc.c:4048:gst_rtspsrc_stream_configure_manager:<rtspsrc0> configure bandwidth in session 0x7efd5403a440
0:00:21.691728531 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:4396:gst_rtspsrc_stream_configure_udp:<rtspsrc0> setting up UDP source
0:00:21.691785860 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:4426:gst_rtspsrc_stream_configure_udp:<rtspsrc0> connecting UDP source 0 to manager
0:00:21.691848352 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:4457:gst_rtspsrc_stream_configure_udp:<rtspsrc0> connecting UDP source 1 to manager
0:00:21.691880572 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:4504:gst_rtspsrc_stream_configure_udp_sinks:<rtspsrc0> configure RTP UDP sink for 10.127.117.210:14186
0:00:21.692838787 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:4527:gst_rtspsrc_stream_configure_udp_sinks:<rtspsrc0> RTP UDP src has sock 0x7efd4c010a60
0:00:21.692963134 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:4569:gst_rtspsrc_stream_configure_udp_sinks:<rtspsrc0> configure RTCP UDP sink for 10.127.117.210:14187
0:00:21.693482634 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:4593:gst_rtspsrc_stream_configure_udp_sinks:<rtspsrc0> RTCP UDP src has sock 0x7efd4c010bb0
0:00:21.693626184 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:3706:request_rtcp_encoder: decoder session 1, stream 0x7efd5401acf0, 0
0:00:21.693652055 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:3706:request_rtcp_encoder: decoder session 1, stream 0x7efd5401c110, 1
0:00:21.693731784 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:3383:new_manager_pad:<rtspsrc0> got new manager pad <manager:send_rtcp_src_1>
0:00:21.693763305 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:3456:new_manager_pad:<rtspsrc0> ignoring unknown stream
0:00:21.693845263 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:9023:gst_rtspsrc_thread:<rtspsrc0> got command LOOP
0:00:21.693877066 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:5190:gst_rtspsrc_connection_flush:<rtspsrc0> set flushing 0
0:00:21.693895879 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:5689:gst_rtspsrc_loop_udp:<rtspsrc0> doing receive with timeout 54 seconds
Progress: (open) Opened Stream
Setting pipeline to PLAYING ...
0:00:21.694370005 17400 0x559ce80f1a90 DEBUG rtspsrc gstrtspsrc.c:3614:set_manager_buffer_mode:<rtspsrc0> auto buffering mode, have clock (NULL)
0:00:21.694436894 17400 0x559ce80f1a90 DEBUG rtspsrc gstrtspsrc.c:3634:set_manager_buffer_mode:<rtspsrc0> auto buffering mode
0:00:21.694464958 17400 0x559ce80f1a90 DEBUG rtspsrc gstrtspsrc.c:3639:set_manager_buffer_mode:<rtspsrc0> selected slave
0:00:21.694511411 17400 0x559ce80f1a90 DEBUG rtspsrc gstrtspsrc.c:6033:gst_rtspsrc_loop_send_cmd:<rtspsrc0> sending cmd WAIT
0:00:21.694539262 17400 0x559ce80f1a90 DEBUG rtspsrc gstrtspsrc.c:6058:gst_rtspsrc_loop_send_cmd:<rtspsrc0> cancel previous request LOOP
0:00:21.694563138 17400 0x559ce80f1a90 DEBUG rtspsrc gstrtspsrc.c:6066:gst_rtspsrc_loop_send_cmd:<rtspsrc0> connection flush busy LOOP
0:00:21.694589580 17400 0x559ce80f1a90 DEBUG rtspsrc gstrtspsrc.c:5190:gst_rtspsrc_connection_flush:<rtspsrc0> set flushing 1
0:00:21.694611535 17400 0x559ce80f1a90 DEBUG rtspsrc gstrtspsrc.c:5193:gst_rtspsrc_connection_flush:<rtspsrc0> connection flush
0:00:21.694712156 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:5773:gst_rtspsrc_loop_udp:<rtspsrc0> got interrupted
0:00:21.694731484 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:6131:gst_rtspsrc_loop:<rtspsrc0> pausing task, reason flushing
0:00:21.694749798 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:6033:gst_rtspsrc_loop_send_cmd:<rtspsrc0> sending cmd WAIT
0:00:21.694766357 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:6066:gst_rtspsrc_loop_send_cmd:<rtspsrc0> connection flush busy LOOP
0:00:21.694782311 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:5190:gst_rtspsrc_connection_flush:<rtspsrc0> set flushing 1
0:00:21.694895566 17400 0x559ce80f1a90 DEBUG rtspsrc gstrtspsrc.c:6033:gst_rtspsrc_loop_send_cmd:<rtspsrc0> sending cmd PLAY
0:00:21.694931303 17400 0x559ce80f1a90 DEBUG rtspsrc gstrtspsrc.c:6071:gst_rtspsrc_loop_send_cmd:<rtspsrc0> not interrupting busy cmd WAIT
0:00:21.694984376 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:9023:gst_rtspsrc_thread:<rtspsrc0> got command PLAY
0:00:21.695004501 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:5190:gst_rtspsrc_connection_flush:<rtspsrc0> set flushing 0
0:00:21.695019450 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:5193:gst_rtspsrc_connection_flush:<rtspsrc0> connection flush
New clock: GstSystemClock
0:00:21.695041317 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:8496:gst_rtspsrc_play:<rtspsrc0> PLAY...
0:00:21.695062583 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:4786:gst_rtspsrc_send_dummy_packets:<rtspsrc0> sending dummy packet to stream 0x7efd5401acf0
Progress: (request) Sending PLAY request
0:00:21.695330443 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:4786:gst_rtspsrc_send_dummy_packets:<rtspsrc0> sending dummy packet to stream 0x7efd5401c110
0:00:21.695460304 17400 0x7efd5403c630 FIXME default gstutils.c:4026:gst_pad_create_stream_id_internal:<fakesrc0:src> Creating random stream-id, consider implementing a deterministic way of creating a stream-id
0:00:21.695702935 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:528:default_before_send:<rtspsrc0> default handler
0:00:21.695727183 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:528:default_before_send:<rtspsrc0> default handler
Progress: (request) Sending PLAY request
0:00:21.695744709 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:6462:gst_rtspsrc_try_send:<rtspsrc0> sending message
0:00:21.695889842 17400 0x7efd5403c590 FIXME default gstutils.c:4026:gst_pad_create_stream_id_internal:<fakesrc1:src> Creating random stream-id, consider implementing a deterministic way of creating a stream-id
0:00:21.709734683 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:6364:gst_rtsp_src_receive_response:<rtspsrc0> received response message
0:00:21.709769379 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:6383:gst_rtsp_src_receive_response:<rtspsrc0> got response message 200
0:00:21.709786177 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:7598:gst_rtspsrc_parse_range:<rtspsrc0> parsed range npt=0-
0:00:21.709802764 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:7611:gst_rtspsrc_parse_range:<rtspsrc0> range: type 0, min 0.000000 - type 2, max 0.000000
0:00:21.709818474 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:7621:gst_rtspsrc_parse_range:<rtspsrc0> range: min 0:00:00.000000000
0:00:21.709831028 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:7640:gst_rtspsrc_parse_range:<rtspsrc0> range: max 99:99:99.999999999
0:00:21.709840973 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:4864:gst_rtspsrc_configure_caps:<rtspsrc0> configuring stream caps
0:00:21.709907433 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:4904:gst_rtspsrc_configure_caps:<rtspsrc0> stream 0x7efd5401acf0, pt 105, caps application/x-rtp, media=(string)video, payload=(int)105, clock-rate=(int)90000, encoding-name=(string)H264, profile-level-id=(string)64002a, packetization-mode=(string)1, sprop-parameter-sets=(string)"Z2QAKq2EAQwgCGEAQwgCGEAQwgCEO1A8ARPyzcBAQFAAAD6AAAw1CEA\=\,aO4xshs\=", a-recvonly=(string)"", ssrc=(uint)199121528, npt-start=(guint64)0, play-speed=(double)1, play-scale=(double)1, onvif-mode=(boolean)false
0:00:21.709984154 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:4904:gst_rtspsrc_configure_caps:<rtspsrc0> stream 0x7efd5401c110, pt 107, caps application/x-rtp, media=(string)application, payload=(int)107, clock-rate=(int)90000, encoding-name=(string)VND.ONVIF.METADATA, decodertag=(string)"h3c-v3\ RTCP\=0", a-recvonly=(string)"", ssrc=(uint)156718676, npt-start=(guint64)0, play-speed=(double)1, play-scale=(double)1, onvif-mode=(boolean)false
0:00:21.710002966 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:4914:gst_rtspsrc_configure_caps:<rtspsrc0> clear session
0:00:21.711023967 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:8737:gst_rtspsrc_play:<rtspsrc0> mark DISCONT, we did a seek to another position
0:00:21.711052096 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:9023:gst_rtspsrc_thread:<rtspsrc0> got command LOOP
0:00:21.711065165 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:5190:gst_rtspsrc_connection_flush:<rtspsrc0> set flushing 0
0:00:21.711074645 17400 0x559ce80d66d0 DEBUG rtspsrc gstrtspsrc.c:5689:gst_rtspsrc_loop_udp:<rtspsrc0> doing receive with timeout 54 seconds
Progress: (request) Sent PLAY request
0:00:21.724808065 17400 0x7efd54039990 DEBUG rtspsrc gstrtspsrc.c:3291:pad_blocked:<rtspsrc0> pad udpsrc3:src blocked, activating streams
0:00:21.724928700 17400 0x7efd54039990 DEBUG rtspsrc gstrtspsrc.c:4807:gst_rtspsrc_activate_streams:<rtspsrc0> activating streams
0:00:21.724963288 17400 0x7efd54039990 DEBUG rtspsrc gstrtspsrc.c:4847:gst_rtspsrc_activate_streams:<rtspsrc0> unblocking stream pad 0x7efd5401acf0
0:00:21.724990643 17400 0x7efd54039990 DEBUG rtspsrc gstrtspsrc.c:4847:gst_rtspsrc_activate_streams:<rtspsrc0> unblocking stream pad 0x7efd5401c110
Redistribute latency...
Redistribute latency...
0:00:21.771364031 17400 0x7efd54039a30 DEBUG rtspsrc gstrtspsrc.c:3591:on_ssrc_active:<rtspsrc0> source in session 0 is active
0:00:23.725382528 17400 0x7efd28002590 DEBUG rtspsrc gstrtspsrc.c:3383:new_manager_pad:<rtspsrc0> got new manager pad <manager:recv_rtp_src_1_156718676_107>
0:00:23.725516060 17400 0x7efd28002590 DEBUG rtspsrc gstrtspsrc.c:3391:new_manager_pad:<rtspsrc0> stream: 1, SSRC 09575654, PT 107
0:00:23.725543195 17400 0x7efd28002590 DEBUG rtspsrc gstrtspsrc.c:3409:new_manager_pad:<rtspsrc0> stream 0x7efd5401acf0, container 0, added 0, setup 1
0:00:23.725690177 17400 0x7efd28002590 DEBUG rtspsrc gstrtspsrc.c:3335:copy_sticky_events:<'':recv_rtp_src_1_156718676_107> store sticky event stream-start event: 0x7efd2c0041e0, time 99:99:99.999999999, seq-num 228, GstEventStreamStart, stream-id=(string)6b5269251f9fe8a83d41dc9894ccbc9fa1062d04274415408d6a3dd45e3f9490, flags=(GstStreamFlags)GST_STREAM_FLAG_NONE, group-id=(uint)4;
0:00:23.725761985 17400 0x7efd28002590 DEBUG rtspsrc gstrtspsrc.c:3335:copy_sticky_events:<'':recv_rtp_src_1_156718676_107> store sticky event caps event: 0x7efd2801e1f0, time 99:99:99.999999999, seq-num 289, GstEventCaps, caps=(GstCaps)"application/x-rtp\,\ media\=\(string\)application\,\ payload\=\(int\)107\,\ clock-rate\=\(int\)90000\,\ encoding-name\=\(string\)VND.ONVIF.METADATA\,\ decodertag\=\(string\)\"h3c-v3\\\ RTCP\\\=0\"\,\ a-recvonly\=\(string\)\"\"\,\ ssrc\=\(uint\)156718676\,\ npt-start\=\(guint64\)0\,\ play-speed\=\(double\)1\,\ play-scale\=\(double\)1\,\ onvif-mode\=\(boolean\)false";
0:00:23.725826310 17400 0x7efd28002590 DEBUG rtspsrc gstrtspsrc.c:3335:copy_sticky_events:<'':recv_rtp_src_1_156718676_107> store sticky event segment event: 0x7efd2c004330, time 99:99:99.999999999, seq-num 213, GstEventSegment, segment=(GstSegment)"segment, flags=(GstSegmentFlags)GST_SEGMENT_FLAG_NONE, rate=(double)1, applied-rate=(double)1, format=(GstFormat)time, base=(guint64)0, offset=(guint64)0, start=(guint64)0, stop=(guint64)18446744073709551615, time=(guint64)0, position=(guint64)0, duration=(guint64)18446744073709551615;";
0:00:23.725865285 17400 0x7efd28002590 DEBUG rtspsrc gstrtspsrc.c:3115:gst_rtspsrc_handle_src_query:<rtspsrc0> pad rtspsrc0:recv_rtp_src_1_156718676_107 received query caps
0:00:23.728863347 17400 0x7efd28002590 DEBUG rtspsrc gstrtspsrc.c:3115:gst_rtspsrc_handle_src_query:<rtspsrc0> pad rtspsrc0:recv_rtp_src_1_156718676_107 received query caps
0:00:23.730939742 17400 0x7efd28002590 DEBUG rtspsrc gstrtspsrc.c:3115:gst_rtspsrc_handle_src_query:<rtspsrc0> pad rtspsrc0:recv_rtp_src_1_156718676_107 received query caps
0:00:23.757855236 17400 0x7efd2c002140 DEBUG rtspsrc gstrtspsrc.c:3383:new_manager_pad:<rtspsrc0> got new manager pad <manager:recv_rtp_src_0_199121528_105>
0:00:23.757958355 17400 0x7efd2c002140 DEBUG rtspsrc gstrtspsrc.c:3391:new_manager_pad:<rtspsrc0> stream: 0, SSRC 0bde5a78, PT 105
0:00:23.757989631 17400 0x7efd2c002140 DEBUG rtspsrc gstrtspsrc.c:3409:new_manager_pad:<rtspsrc0> stream 0x7efd5401acf0, container 0, added 1, setup 1
0:00:23.758020890 17400 0x7efd2c002140 DEBUG rtspsrc gstrtspsrc.c:3409:new_manager_pad:<rtspsrc0> stream 0x7efd5401c110, container 0, added 1, setup 1
0:00:23.758178557 17400 0x7efd2c002140 DEBUG rtspsrc gstrtspsrc.c:3335:copy_sticky_events:<'':recv_rtp_src_0_199121528_105> store sticky event stream-start event: 0x7efd380036d0, time 99:99:99.999999999, seq-num 221, GstEventStreamStart, stream-id=(string)b9049c323800fa1dbf0c9c2f5d6dcf0e63b50fc2c5030d1c14e44a893d14e333, flags=(GstStreamFlags)GST_STREAM_FLAG_NONE, group-id=(uint)3;
0:00:23.758262757 17400 0x7efd2c002140 DEBUG rtspsrc gstrtspsrc.c:3335:copy_sticky_events:<'':recv_rtp_src_0_199121528_105> store sticky event caps event: 0x7efd14005d10, time 99:99:99.999999999, seq-num 297, GstEventCaps, caps=(GstCaps)"application/x-rtp\,\ media\=\(string\)video\,\ payload\=\(int\)105\,\ clock-rate\=\(int\)90000\,\ encoding-name\=\(string\)H264\,\ profile-level-id\=\(string\)64002a\,\ packetization-mode\=\(string\)1\,\ sprop-parameter-sets\=\(string\)\"Z2QAKq2EAQwgCGEAQwgCGEAQwgCEO1A8ARPyzcBAQFAAAD6AAAw1CEA\\\=\\\,aO4xshs\\\=\"\,\ a-recvonly\=\(string\)\"\"\,\ ssrc\=\(uint\)199121528\,\ npt-start\=\(guint64\)0\,\ play-speed\=\(double\)1\,\ play-scale\=\(double\)1\,\ onvif-mode\=\(boolean\)false";
0:00:23.758346241 17400 0x7efd2c002140 DEBUG rtspsrc gstrtspsrc.c:3335:copy_sticky_events:<'':recv_rtp_src_0_199121528_105> store sticky event segment event: 0x7efd2c002880, time 99:99:99.999999999, seq-num 203, GstEventSegment, segment=(GstSegment)"segment, flags=(GstSegmentFlags)GST_SEGMENT_FLAG_NONE, rate=(double)1, applied-rate=(double)1, format=(GstFormat)time, base=(guint64)0, offset=(guint64)0, start=(guint64)0, stop=(guint64)18446744073709551615, time=(guint64)0, position=(guint64)0, duration=(guint64)18446744073709551615;";
0:00:23.758395812 17400 0x7efd2c002140 DEBUG rtspsrc gstrtspsrc.c:3115:gst_rtspsrc_handle_src_query:<rtspsrc0> pad rtspsrc0:recv_rtp_src_1_156718676_107 received query caps
0:00:23.763759037 17400 0x7efd2c002140 DEBUG rtspsrc gstrtspsrc.c:3115:gst_rtspsrc_handle_src_query:<rtspsrc0> pad rtspsrc0:recv_rtp_src_1_156718676_107 received query caps
0:00:23.763859770 17400 0x7efd2c002140 DEBUG rtspsrc gstrtspsrc.c:3115:gst_rtspsrc_handle_src_query:<rtspsrc0> pad rtspsrc0:recv_rtp_src_0_199121528_105 received query caps
0:00:23.767040747 17400 0x7efd2c002140 DEBUG rtspsrc gstrtspsrc.c:3115:gst_rtspsrc_handle_src_query:<rtspsrc0> pad rtspsrc0:recv_rtp_src_0_199121528_105 received query caps
0:00:23.769815298 17400 0x7efd2c002140 DEBUG rtspsrc gstrtspsrc.c:3115:gst_rtspsrc_handle_src_query:<rtspsrc0> pad rtspsrc0:recv_rtp_src_1_156718676_107 received query caps
0:00:23.771872423 17400 0x7efd2c002140 DEBUG rtspsrc gstrtspsrc.c:3115:gst_rtspsrc_handle_src_query:<rtspsrc0> pad rtspsrc0:recv_rtp_src_0_199121528_105 received query caps
0:00:23.773986637 17400 0x7efd2c002140 DEBUG rtspsrc gstrtspsrc.c:3445:new_manager_pad:<rtspsrc0> We added all streams
0:00:23.774060430 17400 0x7efd2c002140 WARN default subprojects/gstreamer/gst/parse/grammar.y:544:gst_parse_no_more_pads:<rtspsrc0> warning: Delayed linking failed.
0:00:23.774076075 17400 0x7efd2c002140 WARN default subprojects/gstreamer/gst/parse/grammar.y:544:gst_parse_no_more_pads:<rtspsrc0> warning: failed delayed linking some pad of GstRTSPSrc named rtspsrc0 to some pad of GstVideoRate named videorate0
WARNING: from element /GstPipeline:pipeline0/GstRTSPSrc:rtspsrc0: Delayed linking failed.
Additional debug info:
subprojects/gstreamer/gst/parse/grammar.y(544): gst_parse_no_more_pads (): /GstPipeline:pipeline0/GstRTSPSrc:rtspsrc0:
failed delayed linking some pad of GstRTSPSrc named rtspsrc0 to some pad of GstVideoRate named videorate0
0:00:23.782496128 17400 0x7efd540399e0 WARN basesrc gstbasesrc.c:3070:gst_base_src_loop:<udpsrc0> error: Internal data stream error.
0:00:23.782560680 17400 0x7efd540399e0 WARN basesrc gstbasesrc.c:3070:gst_base_src_loop:<udpsrc0> error: streaming stopped, reason not-linked (-1)
0:00:23.782620238 17400 0x7efd540399e0 DEBUG rtspsrc gstrtspsrc.c:8964:gst_rtspsrc_handle_message:<rtspsrc0> got error from udpsrc0
0:00:23.782650710 17400 0x7efd540399e0 DEBUG rtspsrc gstrtspsrc.c:8978:gst_rtspsrc_handle_message:<rtspsrc0> combined flows: ok
0:00:26.263221300 17400 0x7efd54039a30 DEBUG rtspsrc gstrtspsrc.c:3591:on_ssrc_active:<rtspsrc0> source in session 0 is active
0:00:31.262691905 17400 0x7efd54039a30 DEBUG rtspsrc gstrtspsrc.c:3591:on_ssrc_active:<rtspsrc0> source in session 0 is active
Below is unsuccessful attempt, if we dont encode the password:
gst-launch-1.0 rtspsrc location="rtsp://admin1:passw@rd123@10.127.117.210:554/media/video1" ! videorate ! videoconvert ! autovideosink
0:00:00.021370516 19165 0x562128c48a90 DEBUG rtspsrc gstrtspsrc.c:9324:gst_rtspsrc_uri_set_uri:<rtspsrc0> parsing URI
0:00:00.021444930 19165 0x562128c48a90 DEBUG rtspsrc gstrtspsrc.c:9331:gst_rtspsrc_uri_set_uri:<rtspsrc0> configuring URI
0:00:00.021465959 19165 0x562128c48a90 DEBUG rtspsrc gstrtspsrc.c:9347:gst_rtspsrc_uri_set_uri:<rtspsrc0> set uri: rtsp://admin1:passw@rd123@10.127.117.210:554/media/video1
0:00:00.021470441 19165 0x562128c48a90 DEBUG rtspsrc gstrtspsrc.c:9349:gst_rtspsrc_uri_set_uri:<rtspsrc0> request uri is: rtsp://rd123@10.127.117.210:554/media/video1
Setting pipeline to PAUSED ...
0:00:19.746313117 19165 0x562128c48a90 DEBUG rtspsrc gstrtspsrc.c:9076:gst_rtspsrc_start:<rtspsrc0> starting
0:00:19.746699209 19165 0x562128c48a90 DEBUG rtspsrc gstrtspsrc.c:6033:gst_rtspsrc_loop_send_cmd:<rtspsrc0> sending cmd OPEN
0:00:19.746739730 19165 0x562128c48a90 DEBUG rtspsrc gstrtspsrc.c:6071:gst_rtspsrc_loop_send_cmd:<rtspsrc0> not interrupting busy cmd unknown
Pipeline is live and does not need PREROLL ...
0:00:19.747699572 19165 0x562128c2d770 DEBUG rtspsrc gstrtspsrc.c:9023:gst_rtspsrc_thread:<rtspsrc0> got command OPEN
0:00:19.747761017 19165 0x562128c2d770 DEBUG rtspsrc gstrtspsrc.c:5190:gst_rtspsrc_connection_flush:<rtspsrc0> set flushing 0
0:00:19.747785231 19165 0x562128c2d770 DEBUG rtspsrc gstrtspsrc.c:5056:gst_rtsp_conninfo_connect:<rtspsrc0> creating connection (rtsp://admin1:passw@rd123@10.127.117.210:554/media/video1)...
Got context from element 'autovideosink0': gst.gl.GLDisplay=context, gst.gl.GLDisplay=(GstGLDisplay)"\(GstGLDisplayX11\)\ gldisplayx11-0";
0:00:19.748205939 19165 0x562128c2d770 DEBUG rtspsrc gstrtspsrc.c:5067:gst_rtsp_conninfo_connect:<rtspsrc0> sanitized uri rtsp://rd123@10.127.117.210:554/media/video1
0:00:19.748295747 19165 0x562128c2d770 DEBUG rtspsrc gstrtspsrc.c:5101:gst_rtsp_conninfo_connect:<rtspsrc0> connecting (rtsp://admin1:passw@rd123@10.127.117.210:554/media/video1)...
Progress: (open) Opening Stream
Progress: (connect) Connecting to rtsp://admin1:passw@rd123@10.127.117.210:554/media/video1
0:00:19.761606914 19165 0x562128c2d770 DEBUG rtspsrc gstrtspsrc.c:7879:gst_rtspsrc_retrieve_sdp:<rtspsrc0> create options... (async)
0:00:19.761648301 19165 0x562128c2d770 DEBUG rtspsrc gstrtspsrc.c:7888:gst_rtspsrc_retrieve_sdp:<rtspsrc0> send options...
0:00:19.761731873 19165 0x562128c2d770 DEBUG rtspsrc gstrtspsrc.c:528:default_before_send:<rtspsrc0> default handler
0:00:19.761762883 19165 0x562128c2d770 DEBUG rtspsrc gstrtspsrc.c:528:default_before_send:<rtspsrc0> default handler
0:00:19.761781860 19165 0x562128c2d770 DEBUG rtspsrc gstrtspsrc.c:6462:gst_rtspsrc_try_send:<rtspsrc0> sending message
Progress: (open) Retrieving server options
0:00:19.763915512 19165 0x562128c2d770 DEBUG rtspsrc gstrtspsrc.c:6364:gst_rtsp_src_receive_response:<rtspsrc0> received response message
0:00:19.763954927 19165 0x562128c2d770 DEBUG rtspsrc gstrtspsrc.c:6383:gst_rtsp_src_receive_response:<rtspsrc0> got response message 200
0:00:19.763981968 19165 0x562128c2d770 INFO rtspsrc gstrtspsrc.c:7901:gst_rtspsrc_retrieve_sdp:<rtspsrc0> Now using version: 1.0
0:00:19.764006933 19165 0x562128c2d770 DEBUG rtspsrc gstrtspsrc.c:7908:gst_rtspsrc_retrieve_sdp:<rtspsrc0> create describe...
0:00:19.764035418 19165 0x562128c2d770 DEBUG rtspsrc gstrtspsrc.c:7925:gst_rtspsrc_retrieve_sdp:<rtspsrc0> send describe...
0:00:19.764099614 19165 0x562128c2d770 DEBUG rtspsrc gstrtspsrc.c:528:default_before_send:<rtspsrc0> default handler
0:00:19.764128002 19165 0x562128c2d770 DEBUG rtspsrc gstrtspsrc.c:528:default_before_send:<rtspsrc0> default handler
0:00:19.764159137 19165 0x562128c2d770 DEBUG rtspsrc gstrtspsrc.c:6462:gst_rtspsrc_try_send:<rtspsrc0> sending message
Progress: (open) Retrieving media info
0:00:19.776494036 19165 0x562128c2d770 DEBUG rtspsrc gstrtspsrc.c:6364:gst_rtsp_src_receive_response:<rtspsrc0> received response message
0:00:19.776533054 19165 0x562128c2d770 DEBUG rtspsrc gstrtspsrc.c:6383:gst_rtsp_src_receive_response:<rtspsrc0> got response message 401
0:00:19.776561825 19165 0x562128c2d770 DEBUG rtspsrc gstrtspsrc.c:6280:gst_rtspsrc_setup_auth:<rtspsrc0> Attempting authentication using credentials from the URL
0:00:19.776574829 19165 0x562128c2d770 DEBUG rtspsrc gstrtspsrc.c:6309:gst_rtspsrc_setup_auth:<rtspsrc0> Attempting Digest authentication
0:00:19.776591260 19165 0x562128c2d770 DEBUG rtspsrc gstrtspsrc.c:528:default_before_send:<rtspsrc0> default handler
0:00:19.776607249 19165 0x562128c2d770 DEBUG rtspsrc gstrtspsrc.c:528:default_before_send:<rtspsrc0> default handler
0:00:19.776617266 19165 0x562128c2d770 DEBUG rtspsrc gstrtspsrc.c:6462:gst_rtspsrc_try_send:<rtspsrc0> sending message
0:00:39.793507115 19165 0x562128c2d770 WARN rtspsrc gstrtspsrc.c:6415:gst_rtsp_src_receive_response:<rtspsrc0> error: Could not receive message. (Timeout while waiting for server response)
0:00:39.793621838 19165 0x562128c2d770 WARN rtspsrc gstrtspsrc.c:6513:gst_rtspsrc_try_send:<rtspsrc0> error: Could not receive message. (Timeout while waiting for server response)
0:00:39.793646219 19165 0x562128c2d770 DEBUG rtspsrc gstrtspsrc.c:6618:gst_rtspsrc_send:<rtspsrc0> got error -14
0:00:39.793657028 19165 0x562128c2d770 DEBUG rtspsrc gstrtspsrc.c:8051:gst_rtspsrc_retrieve_sdp:<rtspsrc0> free connection
0:00:39.793669871 19165 0x562128c2d770 DEBUG rtspsrc gstrtspsrc.c:5157:gst_rtsp_conninfo_close:<rtspsrc0> closing connection...
ERROR: from element /GstPipeline:pipeline0/GstRTSPSrc:rtspsrc0: Could not read from resource.
Additional debug info:
../subprojects/gst-plugins-good/gst/rtsp/gstrtspsrc.c(6415): gst_rtsp_src_receive_response (): /GstPipeline:pipeline0/GstRTSPSrc:rtspsrc0:
Could not receive message. (Timeout while waiting for server response)
ERROR: pipeline doesn't want to preroll.
Setting pipeline to PAUSED ...
0:00:39.793764562 19165 0x562128c2d770 DEBUG rtspsrc gstrtspsrc.c:5163:gst_rtsp_conninfo_close:<rtspsrc0> freeing connection...
Setting pipeline to READY ...
0:00:39.793786035 19165 0x562128c2d770 WARN rtspsrc gstrtspsrc.c:8091:gst_rtspsrc_open:<rtspsrc0> can't get sdp
0:00:39.793813289 19165 0x562128c2d770 DEBUG rtspsrc gstrtspsrc.c:9023:gst_rtspsrc_thread:<rtspsrc0> got command LOOP
0:00:39.793822439 19165 0x562128c2d770 DEBUG rtspsrc gstrtspsrc.c:5190:gst_rtspsrc_connection_flush:<rtspsrc0> set flushing 0
0:00:39.793828582 19165 0x562128c2d770 WARN rtspsrc gstrtspsrc.c:6123:gst_rtspsrc_loop:<rtspsrc0> we are not connected
0:00:39.793836177 19165 0x562128c2d770 DEBUG rtspsrc gstrtspsrc.c:6131:gst_rtspsrc_loop:<rtspsrc0> pausing task, reason flushing
0:00:39.793849094 19165 0x562128c2d770 DEBUG rtspsrc gstrtspsrc.c:6033:gst_rtspsrc_loop_send_cmd:<rtspsrc0> sending cmd WAIT
0:00:39.793855097 19165 0x562128c2d770 DEBUG rtspsrc gstrtspsrc.c:6058:gst_rtspsrc_loop_send_cmd:<rtspsrc0> cancel previous request LOOP
0:00:39.793860664 19165 0x562128c2d770 DEBUG rtspsrc gstrtspsrc.c:6066:gst_rtspsrc_loop_send_cmd:<rtspsrc0> connection flush busy LOOP
0:00:39.793873078 19165 0x562128c2d770 DEBUG rtspsrc gstrtspsrc.c:5190:gst_rtspsrc_connection_flush:<rtspsrc0> set flushing 1
0:00:39.793912621 19165 0x562128c48a90 DEBUG rtspsrc gstrtspsrc.c:6033:gst_rtspsrc_loop_send_cmd:<rtspsrc0> sending cmd CLOSE
0:00:39.793928784 19165 0x562128c48a90 DEBUG rtspsrc gstrtspsrc.c:6066:gst_rtspsrc_loop_send_cmd:<rtspsrc0> connection flush busy WAIT
0:00:39.793934104 19165 0x562128c48a90 DEBUG rtspsrc gstrtspsrc.c:5190:gst_rtspsrc_connection_flush:<rtspsrc0> set flushing 1
0:00:39.793953960 19165 0x562128c2d770 DEBUG rtspsrc gstrtspsrc.c:9023:gst_rtspsrc_thread:<rtspsrc0> got command CLOSE
0:00:39.793966678 19165 0x562128c2d770 DEBUG rtspsrc gstrtspsrc.c:5190:gst_rtspsrc_connection_flush:<rtspsrc0> set flushing 0
0:00:39.793974834 19165 0x562128c2d770 DEBUG rtspsrc gstrtspsrc.c:8119:gst_rtspsrc_close:<rtspsrc0> TEARDOWN...
0:00:39.793983013 19165 0x562128c2d770 DEBUG rtspsrc gstrtspsrc.c:8124:gst_rtspsrc_close:<rtspsrc0> not ready, doing cleanup
0:00:39.793988146 19165 0x562128c2d770 DEBUG rtspsrc gstrtspsrc.c:8188:gst_rtspsrc_close:<rtspsrc0> closing connection...
0:00:39.793994014 19165 0x562128c2d770 DEBUG rtspsrc gstrtspsrc.c:2426:gst_rtspsrc_cleanup:<rtspsrc0> cleanup
Setting pipeline to NULL ...
0:00:39.795004275 19165 0x562128c48a90 DEBUG rtspsrc gstrtspsrc.c:9107:gst_rtspsrc_stop:<rtspsrc0> stopping
0:00:39.795023557 19165 0x562128c48a90 DEBUG rtspsrc gstrtspsrc.c:6033:gst_rtspsrc_loop_send_cmd:<rtspsrc0> sending cmd WAIT
0:00:39.795028859 19165 0x562128c48a90 DEBUG rtspsrc gstrtspsrc.c:6066:gst_rtspsrc_loop_send_cmd:<rtspsrc0> connection flush busy WAIT
0:00:39.795039698 19165 0x562128c48a90 DEBUG rtspsrc gstrtspsrc.c:5190:gst_rtspsrc_connection_flush:<rtspsrc0> set flushing 1
0:00:39.795082429 19165 0x562128c48a90 DEBUG rtspsrc gstrtspsrc.c:8119:gst_rtspsrc_close:<rtspsrc0> TEARDOWN...
0:00:39.795093536 19165 0x562128c48a90 DEBUG rtspsrc gstrtspsrc.c:8124:gst_rtspsrc_close:<rtspsrc0> not ready, doing cleanup
0:00:39.795097674 19165 0x562128c48a90 DEBUG rtspsrc gstrtspsrc.c:8188:gst_rtspsrc_close:<rtspsrc0> closing connection...
0:00:39.795101712 19165 0x562128c48a90 DEBUG rtspsrc gstrtspsrc.c:2426:gst_rtspsrc_cleanup:<rtspsrc0> cleanup
Freeing pipeline ...
So, the cleaned-up logs for the important bits of the logs are these:
In Kurento 6 and 7 (experimental), the behavior seems to be the same with non-urlencoded uri:
rtspsrc set uri: rtsp://admin1:passw@rd123@10.127.117.210:554/media/video1
rtspsrc request uri is: rtsp://rd123@10.127.117.210:554/media/video1
rtspsrc creating connection (rtsp://admin1:passw@rd123@10.127.117.210:554/media/video1)...
rtspsrc sanitized uri rtsp://rd123@10.127.117.210:554/media/video1
rtspsrc connecting (rtsp://admin1:passw@rd123@10.127.117.210:554/media/video1)...
The problem here is clear: after sanitizing the input (removing username and password, to leave only the server and port), GStreamer thinks that the RTSP server is located at the hostname rd123@10.127.117.210
. Obviously this won't work because this hostname doesn't exist.
The important learning of these logs is that, in the last line:
rtspsrc connecting (rtsp://admin1:passw@rd123@10.127.117.210:554/media/video1)...
the URI has been wrongly parsed as follows:
admin1
passw
rd123@10.127.117.210
554
/media/video1
This exact behavior seems to also happen when trying also a non-urlencoded uri with the much newer GStreamer 1.17. Only when the location is properly encoded, the GStreamer component works.
So, the conclusion is that PlayerEndpoint uris should always be urlencoded. I'll be adding this to the documentation.
Now, the question:
It would also be interesting if you can try whether it's possible to use colons (:
) inside the username
part. So a username like adm:in123
and a password like passw@rd123
. The url-encoded versions would be adm%3Ain123
and passw%40rd123
.
rtsp://admin1:passw%40rd123@10.127.117.210:554/media/video1
. 2:34:51.362922504 1 0x7f86b0005430 DEBUG uridecodebin gsturidecodebin.c:2184:setup_source:<uridecodebin0> setup source
2:34:51.362935757 1 0x7f86b0005430 LOG uridecodebin gsturidecodebin.c:1298:gen_source_element:<uridecodebin0> finding source for rtsp://admin1:passw@rd123@10.127.117.210:554/media/video1
2:34:51.368278787 1 0x7f86b0005430 DEBUG rtspsrc gstrtspsrc.c:8617:gst_rtspsrc_uri_set_uri:<source> parsing URI
2:34:51.368320716 1 0x7f86b0005430 DEBUG rtspsrc gstrtspsrc.c:8624:gst_rtspsrc_uri_set_uri:<source> configuring URI
2:34:51.368337430 1 0x7f86b0005430 DEBUG rtspsrc gstrtspsrc.c:8640:gst_rtspsrc_uri_set_uri:<source> set uri: rtsp://admin1:passw@rd123@10.127.117.210:554/media/video1
2:34:51.368346635 1 0x7f86b0005430 DEBUG rtspsrc gstrtspsrc.c:8642:gst_rtspsrc_uri_set_uri:<source> request uri is: rtsp://rd123@10.127.117.210:554/media/video1
2:34:51.368362793 1 0x7f86b0005430 LOG uridecodebin gsturidecodebin.c:1311:gen_source_element:<uridecodebin0> found source type GstRTSPSrc
2:34:51.368400096 1 0x7f86b0005430 LOG uridecodebin gsturidecodebin.c:1321:gen_source_element:<uridecodebin0> source is stream: 0
2:34:51.368408699 1 0x7f86b0005430 LOG uridecodebin gsturidecodebin.c:1324:gen_source_element:<uridecodebin0> source needs queue: 0
2:34:51.368425428 1 0x7f86b0005430 DEBUG uridecodebin gsturidecodebin.c:1362:gen_source_element:<uridecodebin0> setting connection-speed=0 to source element
2:34:51.368498862 1 0x7f86b0005430 WARN playerendpoint kmsplayerendpoint.c:1270:kms_player_endpoint_uridecodebin_source_setup:<kmsplayerendpoint0> Skip setting latency probe, no src pad in <uridecodebin0> (GstRTSPSrc)
2:34:51.368532619 1 0x7f86b0005430 DEBUG uridecodebin gsturidecodebin.c:2238:setup_source:<uridecodebin0> Source has dynamic output pads
2:34:51.368555342 1 0x7f86b0005430 DEBUG rtspsrc gstrtspsrc.c:8391:gst_rtspsrc_start:<source> starting
2:34:51.368643797 1 0x7f86b0005430 DEBUG rtspsrc gstrtspsrc.c:5567:gst_rtspsrc_loop_send_cmd:<source> sending cmd OPEN
2:34:51.368653893 1 0x7f86b0005430 DEBUG rtspsrc gstrtspsrc.c:5598:gst_rtspsrc_loop_send_cmd:<source> not interrupting busy cmd unknown
2:34:51.368849483 1 0x7f86b0005430 DEBUG uridecodebin gsturidecodebin.c:899:do_async_done:<uridecodebin0> posting ASYNC_DONE
2:34:51.369161142 1 0x7f86b0005430 DEBUG rtspsrc gstrtspsrc.c:5567:gst_rtspsrc_loop_send_cmd:<source> sending cmd WAIT
2:34:51.369191579 1 0x7f86c0056320 DEBUG rtspsrc gstrtspsrc.c:8346:gst_rtspsrc_thread:<source> got command OPEN
2:34:51.369228229 1 0x7f86c0056320 DEBUG rtspsrc gstrtspsrc.c:4748:gst_rtspsrc_connection_flush:<source> set flushing 0
2:34:51.369262650 1 0x7f86c0056320 DEBUG rtspsrc gstrtspsrc.c:4614:gst_rtsp_conninfo_connect:<source> creating connection (rtsp://admin1:passw@rd123@10.127.117.210:554/media/video1)...
2:34:51.369283946 1 0x7f86b0005430 DEBUG rtspsrc gstrtspsrc.c:5585:gst_rtspsrc_loop_send_cmd:<source> cancel previous request LOOP
2:34:51.369322618 1 0x7f86b0005430 DEBUG rtspsrc gstrtspsrc.c:5598:gst_rtspsrc_loop_send_cmd:<source> not interrupting busy cmd OPEN
2:34:51.369348346 1 0x7f86b0005430 DEBUG rtspsrc gstrtspsrc.c:5567:gst_rtspsrc_loop_send_cmd:<source> sending cmd PLAY
2:34:51.369365801 1 0x7f86b0005430 DEBUG rtspsrc gstrtspsrc.c:5598:gst_rtspsrc_loop_send_cmd:<source> not interrupting busy cmd OPEN
2:34:51.369583998 1 0x7f86c0056320 DEBUG rtspsrc gstrtspsrc.c:4625:gst_rtsp_conninfo_connect:<source> sanitized uri rtsp://rd123@10.127.117.210:554/media/video1
2:34:51.369758456 1 0x7f86c0056320 DEBUG rtspsrc gstrtspsrc.c:4659:gst_rtsp_conninfo_connect:<source> connecting (rtsp://admin1:passw@rd123@10.127.117.210:554/media/video1)...
2:34:51.382289375 1 0x7f86c0056320 DEBUG rtspsrc gstrtspsrc.c:7342:gst_rtspsrc_retrieve_sdp:<source> create options... (async)
2:34:51.382312589 1 0x7f86c0056320 DEBUG rtspsrc gstrtspsrc.c:7351:gst_rtspsrc_retrieve_sdp:<source> send options...
2:34:51.382350735 1 0x7f86c0056320 DEBUG rtspsrc gstrtspsrc.c:476:default_before_send:<source> default handler
2:34:51.382356149 1 0x7f86c0056320 DEBUG rtspsrc gstrtspsrc.c:476:default_before_send:<source> default handler
2:34:51.382360003 1 0x7f86c0056320 DEBUG rtspsrc gstrtspsrc.c:5964:gst_rtspsrc_try_send:<source> sending message
2:34:51.384450702 1 0x7f86c0056320 DEBUG rtspsrc gstrtspsrc.c:5866:gst_rtsp_src_receive_response:<source> received response message
2:34:51.384468060 1 0x7f86c0056320 DEBUG rtspsrc gstrtspsrc.c:5885:gst_rtsp_src_receive_response:<source> got response message 200
2:34:51.384477204 1 0x7f86c0056320 INFO rtspsrc gstrtspsrc.c:7364:gst_rtspsrc_retrieve_sdp:<source> Now using version: 1.0
2:34:51.384485087 1 0x7f86c0056320 DEBUG rtspsrc gstrtspsrc.c:7371:gst_rtspsrc_retrieve_sdp:<source> create describe...
2:34:51.384490098 1 0x7f86c0056320 DEBUG rtspsrc gstrtspsrc.c:7388:gst_rtspsrc_retrieve_sdp:<source> send describe...
2:34:51.384516217 1 0x7f86c0056320 DEBUG rtspsrc gstrtspsrc.c:476:default_before_send:<source> default handler
2:34:51.384520955 1 0x7f86c0056320 DEBUG rtspsrc gstrtspsrc.c:476:default_before_send:<source> default handler
2:34:51.384525022 1 0x7f86c0056320 DEBUG rtspsrc gstrtspsrc.c:5964:gst_rtspsrc_try_send:<source> sending message
2:34:51.396110623 1 0x7f86c0056320 DEBUG rtspsrc gstrtspsrc.c:5866:gst_rtsp_src_receive_response:<source> received response message
2:34:51.396137395 1 0x7f86c0056320 DEBUG rtspsrc gstrtspsrc.c:5885:gst_rtsp_src_receive_response:<source> got response message 401
2:34:51.396162229 1 0x7f86c0056320 DEBUG rtspsrc gstrtspsrc.c:5785:gst_rtspsrc_setup_auth:<source> Attempting authentication using credentials from the URL
2:34:51.396168416 1 0x7f86c0056320 DEBUG rtspsrc gstrtspsrc.c:5814:gst_rtspsrc_setup_auth:<source> Attempting Digest authentication
2:34:51.396179051 1 0x7f86c0056320 DEBUG rtspsrc gstrtspsrc.c:476:default_before_send:<source> default handler
2:34:51.396184689 1 0x7f86c0056320 DEBUG rtspsrc gstrtspsrc.c:476:default_before_send:<source> default handler
2:34:51.396189168 1 0x7f86c0056320 DEBUG rtspsrc gstrtspsrc.c:5964:gst_rtspsrc_try_send:<source> sending message
2:34:52.126246167 1 0x7f86a8085a30 WARN dtlssrtpdemux gstdtlssrtpdemux.c:134:sink_chain:<dtlssrtpdemux0> received invalid buffer: 1
2:34:52.937549482 1 0x7f86a8085a30 DEBUG kmselement kmselement.c:959:kms_element_set_sink_input_stats:<kmswebrtcendpoint0> Generating average stats for pad <kmswebrtcendpoint0:sink_audio_default>
2:34:52.937788832 1 0x7f86a8085a30 DEBUG kmselement kmselement.c:959:kms_element_set_sink_input_stats:<kmswebrtcendpoint0> Generating average stats for pad <kmswebrtcendpoint0:sink_video_default>
2:35:11.398584725 1 0x7f86c0056320 WARN rtspsrc gstrtspsrc.c:5917:gst_rtsp_src_receive_response:<source> error: Could not receive message. (Timeout while waiting for server response)
2:35:11.398825507 1 0x7f86c0056320 DEBUG rtspsrc gstrtspsrc.c:6102:gst_rtspsrc_send:<source> got error -14
2:35:11.398849343 1 0x7f86c0056320 DEBUG rtspsrc gstrtspsrc.c:7514:gst_rtspsrc_retrieve_sdp:<source> free connection
2:35:11.398859400 1 0x7f86c0056320 DEBUG rtspsrc gstrtspsrc.c:4715:gst_rtsp_conninfo_close:<source> closing connection...
2:35:11.398891319 1 0x55ebb1273e40 ERROR playerendpoint kmsplayerendpoint.c:1338:process_bus_message:<kmsplayerendpoint0> Error code 9: 'Could not read from resource.', element: source, parent: internalpipeline
My uri: rtsp://admin:admin123@192.168.8.109:554/cam/realmonitor?channel=1&subtype=1
and log
_2021-01-14T01:07:23,303967 789 0x00007ff2fa4a5700 debug uridecodebin gsturidecodebin.c:2204 setup_source()
the endpoint url like this rtsp://admin:password@192.168.110.205/h264/ch1/main/av_stream
it works well
but when i try another rstp source like
rtsp://10.10.110.2:1158/05772425679462770101?streamID=1&Token=mGuLFcjlGDqn6INHvdb74MwMNUHdB7t4
the Token param is required to play that media
it doesn't work
the extra param seems to be removed
I found a quick fix to this issue. The call to gst_uri_get_location() was having the unintended side effect of decoding the URI.
This fix is pushed to master, so it will be released as part of Kurento 6.16. But if you want to have it too on the Kurento 7 branch, you'll have to cherry-pick it into a custom fork, as for now we're not keeping the 7.0 branch up to date...
the endpoint url like this
rtsp://admin:password@192.168.110.205/h264/ch1/main/av_stream
it works well but when i try another rstp source likertsp://10.10.110.2:1158/05772425679462770101?streamID=1&Token=mGuLFcjlGDqn6INHvdb74MwMNUHdB7t4
the Token param is required to play that media it doesn't work the extra param seems to be removed
now, has the problem been solved?
I finally was able to test v6.16.0 but unfortunately still see the issue with special charachters. The % character has been fixed, but with other 3 special chars (/ ? @), issue is still occuring. Here is a detailed log that I see:
Character: "?"
1:38:18.873474625 1 0x7f6be8096460 LOG uridecodebin gsturidecodebin.c:1316:gen_source_element:<uridecodebin87> finding source for rtsp://admin1:test?123@10.127.117.245:554/basic/h264/ch1/sub/av-Stream
1:38:18.873737737 1 0x7f6be8096460 DEBUG rtspsrc gstrtspsrc.c:7899:gst_rtspsrc_uri_set_uri:<source> parsing URI
1:38:18.873769214 1 0x7f6be8096460 DEBUG rtspsrc gstrtspsrc.c:7906:gst_rtspsrc_uri_set_uri:<source> configuring URI
1:38:18.873781875 1 0x7f6be8096460 DEBUG rtspsrc gstrtspsrc.c:7922:gst_rtspsrc_uri_set_uri:<source> set uri: rtsp://admin1:test?123@10.127.117.245:554/basic/h264/ch1/sub/av-Stream
1:38:18.873793219 1 0x7f6be8096460 DEBUG rtspsrc gstrtspsrc.c:7924:gst_rtspsrc_uri_set_uri:<source> request uri is: rtsp://admin1?123@10.127.117.245:554/basic/h264/ch1/sub/av-Stream
1:38:18.873806731 1 0x7f6be8096460 LOG uridecodebin gsturidecodebin.c:1329:gen_source_element:<uridecodebin87> found source type GstRTSPSrc
1:38:18.873834244 1 0x7f6be8096460 LOG uridecodebin gsturidecodebin.c:1339:gen_source_element:<uridecodebin87> source is stream: 0
1:38:18.873857324 1 0x7f6be8096460 LOG uridecodebin gsturidecodebin.c:1342:gen_source_element:<uridecodebin87> source needs queue: 0
1:38:18.873877751 1 0x7f6be8096460 DEBUG uridecodebin gsturidecodebin.c:1380:gen_source_element:<uridecodebin87> setting connection-speed=0 to source element
1:38:18.873954017 1 0x7f6be8096460 WARN playerendpoint kmsplayerendpoint.c:1270:kms_player_endpoint_uridecodebin_source_setup:<kmsplayerendpoint87> Skip setting latency probe, no src pad in <uridecodebin87> (GstRTSPSrc)
1:38:18.873995551 1 0x7f6be8096460 DEBUG uridecodebin gsturidecodebin.c:2258:setup_source:<uridecodebin87> Source has dynamic output pads
1:38:18.874020223 1 0x7f6be8096460 DEBUG rtspsrc gstrtspsrc.c:7673:gst_rtspsrc_start:<source> starting
1:38:18.874078549 1 0x7f6be8096460 DEBUG rtspsrc gstrtspsrc.c:5012:gst_rtspsrc_loop_send_cmd:<source> sending cmd OPEN
1:38:18.874101391 1 0x7f6be8096460 DEBUG rtspsrc gstrtspsrc.c:5037:gst_rtspsrc_loop_send_cmd:<source> not interrupting busy cmd unknown
1:38:18.874347707 1 0x7f6be8096460 DEBUG uridecodebin gsturidecodebin.c:917:do_async_done:<uridecodebin87> posting ASYNC_DONE
1:38:18.874381092 1 0x7f6b0c005190 DEBUG rtspsrc gstrtspsrc.c:7628:gst_rtspsrc_thread:<source> got command OPEN
1:38:18.874429317 1 0x7f6b0c005190 DEBUG rtspsrc gstrtspsrc.c:4182:gst_rtspsrc_connection_flush:<source> set flushing 0
1:38:18.874447560 1 0x7f6b0c005190 DEBUG rtspsrc gstrtspsrc.c:4052:gst_rtsp_conninfo_connect:<source> creating connection (rtsp://admin1:test?123@10.127.117.245:554/basic/h264/ch1/sub/av-Stream)...
1:38:18.874534236 1 0x7f6b0c005190 DEBUG rtspsrc gstrtspsrc.c:4063:gst_rtsp_conninfo_connect:<source> sanitized uri rtsp://admin1?123@10.127.117.245:554/basic/h264/ch1/sub/av-Stream
1:38:18.874580691 1 0x7f6b0c005190 DEBUG rtspsrc gstrtspsrc.c:4095:gst_rtsp_conninfo_connect:<source> connecting (rtsp://admin1:test?123@10.127.117.245:554/basic/h264/ch1/sub/av-Stream)...
1:38:18.874588367 1 0x7f6be8096460 DEBUG rtspsrc gstrtspsrc.c:5012:gst_rtspsrc_loop_send_cmd:<source> sending cmd WAIT
1:38:18.874648724 1 0x7f6be8096460 DEBUG rtspsrc gstrtspsrc.c:5024:gst_rtspsrc_loop_send_cmd:<source> cancel previous request LOOP
1:38:18.874660967 1 0x7f6be8096460 DEBUG rtspsrc gstrtspsrc.c:5037:gst_rtspsrc_loop_send_cmd:<source> not interrupting busy cmd OPEN
1:38:18.874703776 1 0x7f6be8096460 DEBUG rtspsrc gstrtspsrc.c:5012:gst_rtspsrc_loop_send_cmd:<source> sending cmd PLAY
1:38:18.874726025 1 0x7f6be8096460 DEBUG rtspsrc gstrtspsrc.c:5037:gst_rtspsrc_loop_send_cmd:<source> not interrupting busy cmd OPEN
1:38:19.859831701 1 0x7f6aac007720 DEBUG kmselement kmselement.c:959:kms_element_set_sink_input_stats:<kmswebrtcendpoint87> Generating average stats for pad <kmswebrtcendpoint87:sink_audio_default>
1:38:19.860005387 1 0x7f6aac007720 DEBUG kmselement kmselement.c:959:kms_element_set_sink_input_stats:<kmswebrtcendpoint87> Generating average stats for pad <kmswebrtcendpoint87:sink_video_default>
1:38:38.892740107 1 0x7f6b0c005190 ERROR default gstrtspconnection.c:960:gst_rtsp_connection_connect_with_response: failed to connect: Error resolving 'admin1': Temporary failure in name resolution
1:38:38.892869101 1 0x7f6b0c005190 ERROR rtspsrc gstrtspsrc.c:4137:gst_rtsp_conninfo_connect:<source> Could not connect to server. (Generic error)
1:38:38.892893371 1 0x7f6b0c005190 WARN rtspsrc gstrtspsrc.c:6795:gst_rtspsrc_retrieve_sdp:<source> error: Failed to connect. (Generic error)
1:38:38.893124092 1 0x7f6b0c005190 DEBUG rtspsrc gstrtspsrc.c:6840:gst_rtspsrc_retrieve_sdp:<source> free connection
1:38:38.893145331 1 0x7f6b0c005190 DEBUG rtspsrc gstrtspsrc.c:4156:gst_rtsp_conninfo_close:<source> freeing connection...
1:38:38.893166180 1 0x7f6b0c005190 WARN rtspsrc gstrtspsrc.c:6874:gst_rtspsrc_open:<source> can't get sdp
1:38:38.893189741 1 0x7f6b0c005190 DEBUG rtspsrc gstrtspsrc.c:7628:gst_rtspsrc_thread:<source> got command PLAY
1:38:38.893213851 1 0x7f6b0c005190 DEBUG rtspsrc gstrtspsrc.c:4182:gst_rtspsrc_connection_flush:<source> set flushing 0
1:38:38.893211666 1 0x7f68dc0024a0 DEBUG playerendpoint kmsplayerendpoint.c:1166:kms_player_endpoint_emit_invalid_uri_signal: Emit 'Invalid URI' signal
1:38:38.893223698 1 0x7f6b0c005190 DEBUG rtspsrc gstrtspsrc.c:7208:gst_rtspsrc_play:<source> PLAY...
1:38:38.893300434 1 0x7f6b0c005190 DEBUG rtspsrc gstrtspsrc.c:7181:gst_rtspsrc_ensure_open:<source> the stream was in error
1:38:38.893308855 1 0x7f6b0c005190 DEBUG rtspsrc gstrtspsrc.c:7377:gst_rtspsrc_play:<source> failed to open stream
1:38:38.893224941 1 0x55eb19a66af0 ERROR playerendpoint kmsplayerendpoint.c:1338:process_bus_message:<kmsplayerendpoint87> Error code 7: 'Could not open resource for reading and writing.', element: source, parent: internalpipeline
1:38:38.893386629 1 0x55eb19a66af0 ERROR playerendpoint kmsplayerendpoint.c:1341:process_bus_message:<kmsplayerendpoint87> Debugging info: gstrtspsrc.c(6795): gst_rtspsrc_retrieve_sdp (): /GstPipeline:internalpipeline/GstURIDecodeBin:uridecodebin87/GstRTSPSrc:source:
Failed to connect. (Generic error)
1:38:38.893330267 1 0x7f6b0c005190 DEBUG rtspsrc gstrtspsrc.c:7628:gst_rtspsrc_thread:<source> got command LOOP
1:38:38.893453506 1 0x7f6b0c005190 DEBUG rtspsrc gstrtspsrc.c:4182:gst_rtspsrc_connection_flush:<source> set flushing 0
1:38:38.893463371 1 0x7f6b0c005190 WARN rtspsrc gstrtspsrc.c:5067:gst_rtspsrc_loop:<source> we are not connected
1:38:38.893471183 1 0x7f6b0c005190 DEBUG rtspsrc gstrtspsrc.c:5075:gst_rtspsrc_loop:<source> pausing task, reason flushing
1:38:38.893480064 1 0x7f6b0c005190 DEBUG rtspsrc gstrtspsrc.c:5012:gst_rtspsrc_loop_send_cmd:<source> sending cmd WAIT
1:38:38.893488997 1 0x7f6b0c005190 DEBUG rtspsrc gstrtspsrc.c:5024:gst_rtspsrc_loop_send_cmd:<source> cancel previous request LOOP
1:38:38.893497595 1 0x7f6b0c005190 DEBUG rtspsrc gstrtspsrc.c:5032:gst_rtspsrc_loop_send_cmd:<source> connection flush busy LOOP
1:38:38.893505477 1 0x7f6b0c005190 DEBUG rtspsrc gstrtspsrc.c:4182:gst_rtspsrc_connection_flush:<source> set flushing 1
Character:"@"
1:36:20.302457554 1 0x7f6be0016230 DEBUG rtspsrc gstrtspsrc.c:7899:gst_rtspsrc_uri_set_uri:<source> parsing URI
1:36:20.302500017 1 0x7f6be0016230 DEBUG rtspsrc gstrtspsrc.c:7906:gst_rtspsrc_uri_set_uri:<source> configuring URI
1:36:20.302516519 1 0x7f6be0016230 DEBUG rtspsrc gstrtspsrc.c:7922:gst_rtspsrc_uri_set_uri:<source> set uri: rtsp://admin1:test@123@10.127.117.245:554/basic/h264/ch1/sub/av-Stream
1:36:20.302531931 1 0x7f6be0016230 DEBUG rtspsrc gstrtspsrc.c:7924:gst_rtspsrc_uri_set_uri:<source> request uri is: rtsp://123@10.127.117.245:554/basic/h264/ch1/sub/av-Stream
1:36:20.302549804 1 0x7f6be0016230 LOG uridecodebin gsturidecodebin.c:1329:gen_source_element:<uridecodebin86> found source type GstRTSPSrc
1:36:20.302585839 1 0x7f6be0016230 LOG uridecodebin gsturidecodebin.c:1339:gen_source_element:<uridecodebin86> source is stream: 0
1:36:20.302613041 1 0x7f6be0016230 LOG uridecodebin gsturidecodebin.c:1342:gen_source_element:<uridecodebin86> source needs queue: 0
1:36:20.302636037 1 0x7f6be0016230 DEBUG uridecodebin gsturidecodebin.c:1380:gen_source_element:<uridecodebin86> setting connection-speed=0 to source element
1:36:20.302716990 1 0x7f6be0016230 WARN playerendpoint kmsplayerendpoint.c:1270:kms_player_endpoint_uridecodebin_source_setup:<kmsplayerendpoint86> Skip setting latency probe, no src pad in <uridecodebin86> (GstRTSPSrc)
1:36:20.302769210 1 0x7f6be0016230 DEBUG uridecodebin gsturidecodebin.c:2258:setup_source:<uridecodebin86> Source has dynamic output pads
1:36:20.302796982 1 0x7f6be0016230 DEBUG rtspsrc gstrtspsrc.c:7673:gst_rtspsrc_start:<source> starting
1:36:20.302866363 1 0x7f6be0016230 DEBUG rtspsrc gstrtspsrc.c:5012:gst_rtspsrc_loop_send_cmd:<source> sending cmd OPEN
1:36:20.302895141 1 0x7f6be0016230 DEBUG rtspsrc gstrtspsrc.c:5037:gst_rtspsrc_loop_send_cmd:<source> not interrupting busy cmd unknown
1:36:20.303128222 1 0x7f6be0016230 DEBUG uridecodebin gsturidecodebin.c:917:do_async_done:<uridecodebin86> posting ASYNC_DONE
1:36:20.303247046 1 0x7f6bf00862d0 DEBUG rtspsrc gstrtspsrc.c:7628:gst_rtspsrc_thread:<source> got command OPEN
1:36:20.303296024 1 0x7f6bf00862d0 DEBUG rtspsrc gstrtspsrc.c:4182:gst_rtspsrc_connection_flush:<source> set flushing 0
1:36:20.303313118 1 0x7f6bf00862d0 DEBUG rtspsrc gstrtspsrc.c:4052:gst_rtsp_conninfo_connect:<source> creating connection (rtsp://admin1:test@123@10.127.117.245:554/basic/h264/ch1/sub/av-Stream)...
1:36:20.303393448 1 0x7f6be0016230 DEBUG rtspsrc gstrtspsrc.c:5012:gst_rtspsrc_loop_send_cmd:<source> sending cmd WAIT
1:36:20.303422173 1 0x7f6be0016230 DEBUG rtspsrc gstrtspsrc.c:5024:gst_rtspsrc_loop_send_cmd:<source> cancel previous request LOOP
1:36:20.303431695 1 0x7f6be0016230 DEBUG rtspsrc gstrtspsrc.c:5037:gst_rtspsrc_loop_send_cmd:<source> not interrupting busy cmd OPEN
1:36:20.303399390 1 0x7f6bf00862d0 DEBUG rtspsrc gstrtspsrc.c:4063:gst_rtsp_conninfo_connect:<source> sanitized uri rtsp://123@10.127.117.245:554/basic/h264/ch1/sub/av-Stream
1:36:20.303456814 1 0x7f6be0016230 DEBUG rtspsrc gstrtspsrc.c:5012:gst_rtspsrc_loop_send_cmd:<source> sending cmd PLAY
1:36:20.303465619 1 0x7f6be0016230 DEBUG rtspsrc gstrtspsrc.c:5037:gst_rtspsrc_loop_send_cmd:<source> not interrupting busy cmd OPEN
1:36:20.303488129 1 0x7f6bf00862d0 DEBUG rtspsrc gstrtspsrc.c:4095:gst_rtsp_conninfo_connect:<source> connecting (rtsp://admin1:test@123@10.127.117.245:554/basic/h264/ch1/sub/av-Stream)...
1:36:20.304985319 1 0x7f6bf00862d0 DEBUG rtspsrc gstrtspsrc.c:6695:gst_rtspsrc_retrieve_sdp:<source> create options...
1:36:20.305018039 1 0x7f6bf00862d0 DEBUG rtspsrc gstrtspsrc.c:6703:gst_rtspsrc_retrieve_sdp:<source> send options...
1:36:20.305074561 1 0x7f6bf00862d0 DEBUG rtspsrc gstrtspsrc.c:5401:gst_rtspsrc_try_send:<source> sending message
1:36:20.311567041 1 0x7f6bf00862d0 DEBUG rtspsrc gstrtspsrc.c:5430:gst_rtspsrc_try_send:<source> received response message
1:36:20.311587955 1 0x7f6bf00862d0 DEBUG rtspsrc gstrtspsrc.c:5445:gst_rtspsrc_try_send:<source> got response message 200
1:36:20.311605287 1 0x7f6bf00862d0 DEBUG rtspsrc gstrtspsrc.c:6718:gst_rtspsrc_retrieve_sdp:<source> create describe...
1:36:20.311612157 1 0x7f6bf00862d0 DEBUG rtspsrc gstrtspsrc.c:6730:gst_rtspsrc_retrieve_sdp:<source> send describe...
1:36:20.311643701 1 0x7f6bf00862d0 DEBUG rtspsrc gstrtspsrc.c:5401:gst_rtspsrc_try_send:<source> sending message
1:36:20.313257771 1 0x7f6bf00862d0 DEBUG rtspsrc gstrtspsrc.c:5430:gst_rtspsrc_try_send:<source> received response message
1:36:20.313272478 1 0x7f6bf00862d0 DEBUG rtspsrc gstrtspsrc.c:5445:gst_rtspsrc_try_send:<source> got response message 401
1:36:20.313285144 1 0x7f6bf00862d0 DEBUG rtspsrc gstrtspsrc.c:5332:gst_rtspsrc_setup_auth:<source> Attempting authentication using credentials from the URL
1:36:20.313291265 1 0x7f6bf00862d0 DEBUG rtspsrc gstrtspsrc.c:5361:gst_rtspsrc_setup_auth:<source> Attempting Digest authentication
1:36:20.313297082 1 0x7f6bf00862d0 DEBUG rtspsrc gstrtspsrc.c:5401:gst_rtspsrc_try_send:<source> sending message
1:36:20.315586251 1 0x7f6bf00862d0 DEBUG rtspsrc gstrtspsrc.c:5430:gst_rtspsrc_try_send:<source> received response message
1:36:20.315600224 1 0x7f6bf00862d0 DEBUG rtspsrc gstrtspsrc.c:5445:gst_rtspsrc_try_send:<source> got response message 401
1:36:20.315610724 1 0x7f6bf00862d0 DEBUG rtspsrc gstrtspsrc.c:5337:gst_rtspsrc_setup_auth:<source> Attempting authentication using credentials from the properties
1:36:20.315617026 1 0x7f6bf00862d0 WARN rtspsrc gstrtspsrc.c:5615:gst_rtspsrc_send:<source> error: Unauthorized
1:36:20.315675966 1 0x7f6bf00862d0 DEBUG rtspsrc gstrtspsrc.c:6840:gst_rtspsrc_retrieve_sdp:<source> free connection
1:36:20.315687811 1 0x7f6bf00862d0 DEBUG rtspsrc gstrtspsrc.c:4150:gst_rtsp_conninfo_close:<source> closing connection...
1:36:20.315735086 1 0x7f6bf00862d0 DEBUG rtspsrc gstrtspsrc.c:4156:gst_rtsp_conninfo_close:<source> freeing connection...
1:36:20.315759029 1 0x7f6bf00862d0 WARN rtspsrc gstrtspsrc.c:6874:gst_rtspsrc_open:<source> can't get sdp
1:36:20.315747512 1 0x7f68d4004450 DEBUG playerendpoint kmsplayerendpoint.c:1166:kms_player_endpoint_emit_invalid_uri_signal: Emit 'Invalid URI' signal
1:36:20.315726367 1 0x55eb19a66af0 ERROR playerendpoint kmsplayerendpoint.c:1338:process_bus_message:<kmsplayerendpoint86> Error code 15: 'Not authorized to access resource.', element: source, parent: internalpipeline
1:36:20.315854657 1 0x55eb19a66af0 ERROR playerendpoint kmsplayerendpoint.c:1341:process_bus_message:<kmsplayerendpoint86> Debugging info: gstrtspsrc.c(5615): gst_rtspsrc_send (): /GstPipeline:internalpipeline/GstURIDecodeBin:uridecodebin86/GstRTSPSrc:source:
Character: "/"
1:40:10.989991112 1 0x55eb19a668d0 LOG uridecodebin gsturidecodebin.c:1316:gen_source_element:<uridecodebin88> finding source for rtsp://admin1:test/123@10.127.117.245:554/basic/h264/ch1/sub/av-Stream
1:40:10.990122537 1 0x55eb19a668d0 DEBUG rtspsrc gstrtspsrc.c:7899:gst_rtspsrc_uri_set_uri:<source> parsing URI
1:40:10.990137326 1 0x55eb19a668d0 DEBUG rtspsrc gstrtspsrc.c:7906:gst_rtspsrc_uri_set_uri:<source> configuring URI
1:40:10.990145311 1 0x55eb19a668d0 DEBUG rtspsrc gstrtspsrc.c:7922:gst_rtspsrc_uri_set_uri:<source> set uri: rtsp://admin1:test/123@10.127.117.245:554/basic/h264/ch1/sub/av-Stream
1:40:10.990152772 1 0x55eb19a668d0 DEBUG rtspsrc gstrtspsrc.c:7924:gst_rtspsrc_uri_set_uri:<source> request uri is: rtsp://admin1/123@10.127.117.245:554/basic/h264/ch1/sub/av-Stream
1:40:10.990161303 1 0x55eb19a668d0 LOG uridecodebin gsturidecodebin.c:1329:gen_source_element:<uridecodebin88> found source type GstRTSPSrc
1:40:10.990179378 1 0x55eb19a668d0 LOG uridecodebin gsturidecodebin.c:1339:gen_source_element:<uridecodebin88> source is stream: 0
1:40:10.990190050 1 0x55eb19a668d0 LOG uridecodebin gsturidecodebin.c:1342:gen_source_element:<uridecodebin88> source needs queue: 0
1:40:10.990201778 1 0x55eb19a668d0 DEBUG uridecodebin gsturidecodebin.c:1380:gen_source_element:<uridecodebin88> setting connection-speed=0 to source element
1:40:10.990242003 1 0x55eb19a668d0 WARN playerendpoint kmsplayerendpoint.c:1270:kms_player_endpoint_uridecodebin_source_setup:<kmsplayerendpoint88> Skip setting latency probe, no src pad in <uridecodebin88> (GstRTSPSrc)
1:40:10.990263414 1 0x55eb19a668d0 DEBUG uridecodebin gsturidecodebin.c:2258:setup_source:<uridecodebin88> Source has dynamic output pads
1:40:10.990279199 1 0x55eb19a668d0 DEBUG rtspsrc gstrtspsrc.c:7673:gst_rtspsrc_start:<source> starting
1:40:10.990360990 1 0x55eb19a668d0 DEBUG rtspsrc gstrtspsrc.c:5012:gst_rtspsrc_loop_send_cmd:<source> sending cmd OPEN
1:40:10.990372134 1 0x55eb19a668d0 DEBUG rtspsrc gstrtspsrc.c:5037:gst_rtspsrc_loop_send_cmd:<source> not interrupting busy cmd unknown
1:40:10.990492041 1 0x55eb19a668d0 DEBUG uridecodebin gsturidecodebin.c:917:do_async_done:<uridecodebin88> posting ASYNC_DONE
1:40:10.990577582 1 0x7f6840001c00 DEBUG rtspsrc gstrtspsrc.c:7628:gst_rtspsrc_thread:<source> got command OPEN
1:40:10.990947531 1 0x7f6840001c00 DEBUG rtspsrc gstrtspsrc.c:4182:gst_rtspsrc_connection_flush:<source> set flushing 0
1:40:10.990967841 1 0x7f6840001c00 DEBUG rtspsrc gstrtspsrc.c:4052:gst_rtsp_conninfo_connect:<source> creating connection (rtsp://admin1:test/123@10.127.117.245:554/basic/h264/ch1/sub/av-Stream)...
1:40:10.991004030 1 0x55eb19a668d0 DEBUG rtspsrc gstrtspsrc.c:5012:gst_rtspsrc_loop_send_cmd:<source> sending cmd WAIT
1:40:10.991041889 1 0x55eb19a668d0 DEBUG rtspsrc gstrtspsrc.c:5024:gst_rtspsrc_loop_send_cmd:<source> cancel previous request LOOP
1:40:10.991048919 1 0x55eb19a668d0 DEBUG rtspsrc gstrtspsrc.c:5037:gst_rtspsrc_loop_send_cmd:<source> not interrupting busy cmd OPEN
1:40:10.991052748 1 0x7f6840001c00 DEBUG rtspsrc gstrtspsrc.c:4063:gst_rtsp_conninfo_connect:<source> sanitized uri rtsp://admin1/123@10.127.117.245:554/basic/h264/ch1/sub/av-Stream
1:40:10.991077918 1 0x55eb19a668d0 DEBUG rtspsrc gstrtspsrc.c:5012:gst_rtspsrc_loop_send_cmd:<source> sending cmd PLAY
1:40:10.991088124 1 0x7f6840001c00 DEBUG rtspsrc gstrtspsrc.c:4095:gst_rtsp_conninfo_connect:<source> connecting (rtsp://admin1:test/123@10.127.117.245:554/basic/h264/ch1/sub/av-Stream)...
1:40:10.991090940 1 0x55eb19a668d0 DEBUG rtspsrc gstrtspsrc.c:5037:gst_rtspsrc_loop_send_cmd:<source> not interrupting busy cmd OPEN
1:40:11.980923696 1 0x7f6a24003ed0 DEBUG kmselement kmselement.c:959:kms_element_set_sink_input_stats:<kmswebrtcendpoint88> Generating average stats for pad <kmswebrtcendpoint88:sink_audio_default>
1:40:11.981127931 1 0x7f6a24003ed0 DEBUG kmselement kmselement.c:959:kms_element_set_sink_input_stats:<kmswebrtcendpoint88> Generating average stats for pad <kmswebrtcendpoint88:sink_video_default>
1:40:31.013088240 1 0x7f6840001c00 ERROR default gstrtspconnection.c:960:gst_rtsp_connection_connect_with_response: failed to connect: Error resolving 'admin1': Temporary failure in name resolution
1:40:31.013253582 1 0x7f6840001c00 ERROR rtspsrc gstrtspsrc.c:4137:gst_rtsp_conninfo_connect:<source> Could not connect to server. (Generic error)
1:40:31.013274844 1 0x7f6840001c00 WARN rtspsrc gstrtspsrc.c:6795:gst_rtspsrc_retrieve_sdp:<source> error: Failed to connect. (Generic error)
1:40:31.013440085 1 0x7f6840001c00 DEBUG rtspsrc gstrtspsrc.c:6840:gst_rtspsrc_retrieve_sdp:<source> free connection
1:40:31.013450417 1 0x7f6840001c00 DEBUG rtspsrc gstrtspsrc.c:4156:gst_rtsp_conninfo_close:<source> freeing connection...
1:40:31.013470913 1 0x7f6840001c00 WARN rtspsrc gstrtspsrc.c:6874:gst_rtspsrc_open:<source> can't get sdp
1:40:31.013481546 1 0x7f6b30083140 DEBUG playerendpoint kmsplayerendpoint.c:1166:kms_player_endpoint_emit_invalid_uri_signal: Emit 'Invalid URI' signal
1:40:31.013492571 1 0x7f6840001c00 DEBUG rtspsrc gstrtspsrc.c:7628:gst_rtspsrc_thread:<source> got command PLAY
1:40:31.013550738 1 0x7f6840001c00 DEBUG rtspsrc gstrtspsrc.c:4182:gst_rtspsrc_connection_flush:<source> set flushing 0
1:40:31.013561104 1 0x7f6840001c00 DEBUG rtspsrc gstrtspsrc.c:7208:gst_rtspsrc_play:<source> PLAY...
1:40:31.013568772 1 0x7f6840001c00 DEBUG rtspsrc gstrtspsrc.c:7181:gst_rtspsrc_ensure_open:<source> the stream was in error
1:40:31.013578846 1 0x7f6840001c00 DEBUG rtspsrc gstrtspsrc.c:7377:gst_rtspsrc_play:<source> failed to open stream
1:40:31.013600885 1 0x7f6840001c00 DEBUG rtspsrc gstrtspsrc.c:7628:gst_rtspsrc_thread:<source> got command LOOP
1:40:31.013554476 1 0x55eb19a66af0 ERROR playerendpoint kmsplayerendpoint.c:1338:process_bus_message:<kmsplayerendpoint88> Error code 7: 'Could not open resource for reading and writing.', element: source, parent: internalpipeline
1:40:31.013641644 1 0x55eb19a66af0 ERROR playerendpoint kmsplayerendpoint.c:1341:process_bus_message:<kmsplayerendpoint88> Debugging info: gstrtspsrc.c(6795): gst_rtspsrc_retrieve_sdp (): /GstPipeline:internalpipeline/GstURIDecodeBin:uridecodebin88/GstRTSPSrc:source:
Failed to connect. (Generic error)
1:40:31.013609976 1 0x7f6840001c00 DEBUG rtspsrc gstrtspsrc.c:4182:gst_rtspsrc_connection_flush:<source> set flushing 0
1:40:31.013706898 1 0x7f6840001c00 WARN rtspsrc gstrtspsrc.c:5067:gst_rtspsrc_loop:<source> we are not connected
1:40:31.013723766 1 0x7f6840001c00 DEBUG rtspsrc gstrtspsrc.c:5075:gst_rtspsrc_loop:<source> pausing task, reason flushing
1:40:31.013734441 1 0x7f6840001c00 DEBUG rtspsrc gstrtspsrc.c:5012:gst_rtspsrc_loop_send_cmd:<source> sending cmd WAIT
1:40:31.013742947 1 0x7f6840001c00 DEBUG rtspsrc gstrtspsrc.c:5024:gst_rtspsrc_loop_send_cmd:<source> cancel previous request LOOP
1:40:31.013753077 1 0x7f6840001c00 DEBUG rtspsrc gstrtspsrc.c:5032:gst_rtspsrc_loop_send_cmd:<source> connection flush busy LOOP
1:40:31.013766862 1 0x7f6840001c00 DEBUG rtspsrc gstrtspsrc.c:4182:gst_rtspsrc_connection_flush:<source> set flushing 1
Prerequisites
Issue description
Kurento-media-server streaming doesnot work with some special charachters in rtsp url's username/password . These four special characters are / ? @ % ( e.g rtsp://admin:passw@rd@10.127.117.181:554/media/video1 , where passw@rd has @ charachter).
Context
Nowadays, due to security, cameras have started making mandatory to include special characters in password. Since, we use kurento for streaming purposes, we aren't able to use the camera effectively with its secure configuration.
How to reproduce?
Expected & current behavior
Expected behavior: Kurento should start streaming from the Camera IP and display the streamed video in the browser. Current behavior: Streaming doesnot happen. There is a error "Invalid Stream" in the player command terminal. On the UI console error reported is "OperationError: Failed to parse SessionDescription."
(Optional) Possible solution
Possible1: It seems kurento is unable to retrieve the username/password properly from the rtsp url and hence not able to encode and send it to gstreamer properly. Note, we have seen that gstreamer > 1.14 is able to stream when it is given url encoding for the same 4 characters mentioned. Possible2: URL encoding to gstreamer is not happening properly with the mentioned 4 special characters
INFO about Kurento Media Server
INFO about your Application Server
INFO about end-user clients
INFO about your environment
Run these commands