GNOME Bugzilla – Bug 775483
for some reason my gstreamer rtsp server fails on this error : ERROR:rtsp-stream.c:1222:alloc_ports_one_family: assertion failed: (!udpsrc_out[0])
Last modified: 2018-01-20 13:53:01 UTC
Hello My application is based on gst-rstp-server is an RTSP server and fail occasionally on this assertion ERROR:rtsp-stream.c:1222:alloc_ports_one_family: assertion failed: (!udpsrc_out[0]) My processor is imx6, using debian os, version of gstramer-rtsp-server is root@ENC-1:~# dpkg -l | grep rtsp | grep 1.0 ii gir1.2-gst-rtsp-server-1.0 1.10.0-1 armhf GObject introspection data for the GStreamer RTSP Server ii libgstrtspserver-1.0-0 1.10.0-1 armhf GStreamer RTSP Server (shared library) ii libgstrtspserver-1.0-0-dbg 1.10.0-1 armhf GStreamer RTSP Server (debug symbols) ii libgstrtspserver-1.0-doc 1.10.0-1 all GStreamer RTSP Server (documentation) my pipeline is done on using appsrc/appink plugins 1) imxv4l2videosrc ! imxipuvideotransform ! appsink 2) appsrc ! alsasrc device=hw:0,0 do-timestamp=true latency-time=20000 buffer-time=800000 ! audio/x-raw,rate=48000,channels=2,depth=16 ! audioconvert ! voaacenc ! rtpmp4apay name=pay1 pt=97 \ imxipuvideotransform name=caps0 ! imxvpuenc_h264 bitrate=15000 name=enc0 gop-size=32 ! video/x-h264,profile=high ! rtph264pay name=pay0 pt=96 this problem appear when trying to close/restart the pipeline dynamically by invoking manually gst_rtsp_media_suspend(get_SI_Instance()->media); gst_rtsp_media_unprepare(get_SI_Instance()->media); gst_element_set_state(get_SI_Instance()->video_source_pipeline, GST_STATE_NULL); and after this trying to restart by this gst_element_set_state ( get_SI_Instance()->video_source_pipeline, GST_STATE_PLAYING); gst_rtsp_media_unsuspend(get_SI_Instance()->media); gst_rtsp_media_prepare(get_SI_Instance()->media,NULL); What's wrong with this method ?? The log of the application -------------------------- 2016-12-01 - 16:52:10 - [1]:main:1957 - set debug level to: 4 2016-12-01 - 16:52:10 - [1]:main:1970 - set user pipeline to: alsasrc device=hw:0,0 do-timestamp=true latency-time=20000 buffer-time=800000 ! audio/x-raw,rate=48000,channels=2,depth=16 ! audioconvert ! voaacenc ! rtpmp4apay name=pay1 pt=97 2016-12-01 - 16:52:10 - [1]:main:1974 - set user pipeline to: imxipuvideotransform name=caps0 ! imxvpuenc_h264 bitrate=15000 name=enc0 gop-size=32 ! video/x-h264,profile=high ! rtph264pay name=pay0 pt=96 ... 2016-12-01 - 16:52:12 - [4]:rtsp_pipeline_build:1698 - launch = ( appsrc name=mysrc ! imxipuvideotransform name=caps0 ! imxvpuenc_h264 bitrate=15000 name=enc0 gop-size=32 ! video/x-h264,profile=high ! rtph264pay name=pay0 pt=96 alsasrc device=hw:0,0 do-timestamp=true latency-time=20000 buffer-time=800000 ! audio/x-raw,rate=48000,channels=2,depth=16 ! audioconvert ! voaacenc ! rtpmp4apay name=pay1 pt=97 ) RTSP Server started...2016-12-01 - 16:52:12 - [4]:tc_interrupt_thread:907 - Starting tc_interrupt_thread (gst-variable-rtsp-server:25161): GLib-CRITICAL **: g_timeout_add_seconds: assertion 'function != NULL' failed tc358743_int_task begin. 2016-12-01 - 16:52:12 - [2]:rtsp_pipeline_build:1720 - Creating 'client-connected' signal handler (gst-variable-rtsp-server:25161): GLib-GObject-WARNING **: /build/glib2.0-ASajuE/glib2.0-2.50.1/./gobject/gsignal.c:2523: signal 'message' is invalid for instance '0x1cf6cd8' of type 'GstRTSPServer' 2016-12-01 - 16:52:12 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline 2016-12-01 - 16:52:12 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline 2016-12-01 - 16:52:12 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline 2016-12-01 - 16:52:12 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline 2016-12-01 - 16:52:12 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline 2016-12-01 - 16:52:12 - [4]:bus_callback:1544 - receive stream-status on appsink pipeline 2016-12-01 - 16:52:12 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline 2016-12-01 - 16:52:12 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline 2016-12-01 - 16:52:12 - [4]:bus_callback:1544 - receive stream-status on appsink pipeline 2016-12-01 - 16:52:12 - [4]:bus_callback:1544 - receive new-clock on appsink pipeline 2016-12-01 - 16:52:12 - [4]:bus_callback:1544 - receive stream-start on appsink pipeline 2016-12-01 - 16:52:12 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline 2016-12-01 - 16:52:12 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline 2016-12-01 - 16:52:12 - [4]:new_client_handler:1124 - called 2016-12-01 - 16:52:12 - [4]:new_client_handler:1150 - [1] A new client has connected 127.0.0.1 2016-12-01 - 16:52:12 - [2]:new_client_handler:1166 - Creating 'media-configure' signal handler 2016-12-01 - 16:52:12 - [2]:new_client_handler:1188 - Creating 'closed' signal handler 2016-12-01 - 16:52:12 - [4]:media_configure:1430 - called2016-12-01 - 16:52:13 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline 2016-12-01 - 16:52:13 - [4]:bus_callback:1544 - receive async-done on appsink pipeline 2016-12-01 - 16:52:13 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline 2016-12-01 - 16:52:13 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline 2016-12-01 - 16:52:13 - [4]:new_client_handler:1124 - called 2016-12-01 - 16:52:13 - [4]:new_client_handler:1150 - [2] A new client has connected 192.168.68.151 2016-12-01 - 16:52:13 - [2]:new_client_handler:1188 - Creating 'closed' signal handler 2016-12-01 - 16:52:13 - [3]:get_video_signal_resolution:465 - detect hsize=0, vsize=3280 mode=24 2016-12-01 - 16:52:14 - [4]:check_no_video_signal_input:196 - ### PHY_PLL ret=0 val=0x9F ### 2016-12-01 - 16:52:15 - [3]:get_video_signal_resolution:465 - detect hsize=3072, vsize=0 mode=24 2016-12-01 - 16:52:15 - [4]:check_no_video_signal_input_at_boot:253 - check_no_video_signal_input_at_boot 2016-12-01 - 16:52:16 - [4]:check_no_video_signal_input_at_boot:262 - ### PHY_PLL[0] ret=1 val=0x9F n_net_i_true=1 ### 2016-12-01 - 16:52:16 - [4]:check_no_video_signal_input_at_boot:262 - ### PHY_PLL[1] ret=1 val=0x9F n_net_i_true=2 ### 2016-12-01 - 16:52:17 - [3]:get_video_signal_resolution:465 - detect hsize=0, vsize=720 mode=24 2016-12-01 - 16:52:17 - [4]:check_no_video_signal_input_at_boot:262 - ### PHY_PLL[3] ret=1 val=0x9F n_net_i_true=3 ### 2016-12-01 - 16:52:18 - [3]:get_video_signal_resolution:465 - detect hsize=1280, vsize=720 mode=8 2016-12-01 - 16:52:18 - [4]:tc358743_black_screen:290 - called (gst-variable-rtsp-server:25161): GStreamer-CRITICAL **: gst_bus_create_watch: assertion 'bus->priv->poll != NULL' failed (gst-variable-rtsp-server:25161): GStreamer-CRITICAL **: Creating bus watch failed 2016-12-01 - 16:52:18 - [4]:media_configure_ex:1313 - Call configuring pipeline extended... 2016-12-01 - 16:52:18 - [4]:media_configure:1478 - Setting 5 second before showing video 2016-12-01 - 16:52:18 - [4]:reset_open_video_timeout_cb:496 - called 2016-12-01 - 16:52:18 - [4]:reset_open_video_timeout_cb:503 - call reopen_pipeline() 2016-12-01 - 16:52:18 - [4]:reopen_pipeline:466 - called 2016-12-01 - 16:52:18 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline 2016-12-01 - 16:52:18 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline 2016-12-01 - 16:52:18 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline 2016-12-01 - 16:52:18 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline 2016-12-01 - 16:52:18 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline 2016-12-01 - 16:52:18 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline 2016-12-01 - 16:52:18 - [4]:bus_callback:1544 - receive stream-status on appsink pipeline 2016-12-01 - 16:52:18 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline 2016-12-01 - 16:52:18 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline 2016-12-01 - 16:52:18 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline 2016-12-01 - 16:52:18 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline 2016-12-01 - 16:52:18 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline 2016-12-01 - 16:52:18 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline 2016-12-01 - 16:52:18 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline 2016-12-01 - 16:52:18 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline 2016-12-01 - 16:52:18 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline 2016-12-01 - 16:52:18 - [4]:check_no_video_signal_input_at_boot:262 - ### PHY_PLL[4] ret=1 val=0x9F n_net_i_true=4 ### 2016-12-01 - 16:52:18 - [4]:bus_callback:1544 - receive stream-status on appsink pipeline 2016-12-01 - 16:52:18 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline 2016-12-01 - 16:52:18 - [4]:bus_callback:1544 - receive stream-status on appsink pipeline 2016-12-01 - 16:52:18 - [4]:bus_callback:1544 - receive stream-start on appsink pipeline 2016-12-01 - 16:52:18 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline 2016-12-01 - 16:52:18 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline 2016-12-01 - 16:52:18 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline [INFO] ringBufferEnable 0, chromaInterleave 0, mapType 0, linear2TiledEnable 1 2016-12-01 - 16:52:18 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline 2016-12-01 - 16:52:18 - [4]:bus_callback:1544 - receive async-done on appsink pipeline 2016-12-01 - 16:52:18 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline 2016-12-01 - 16:52:18 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline 2016-12-01 - 16:52:18 - [4]:client_close_handler:1039 - called 2016-12-01 - 16:52:18 - [4]:client_close_handler:1044 - [1] Client is closing down 192.168.68.151 2016-12-01 - 16:52:18 - [4]:check_no_video_signal_input_at_boot:269 - ### PHY_PLL ret=0 val=0x9F ### 2016-12-01 - 16:52:19 - [4]:open_video_timeout_cb_sec:413 - called 2016-12-01 - 16:52:19 - [4]:open_video_timeout_cb_sec:416 - g_to = 4 2016-12-01 - 16:52:19 - [4]:open_fw_timeout_cb:394 - called 2016-12-01 - 16:52:19 - [3]:check_video_signal_res_not_supported:431 - detect hsize=1280, vsize=720 2016-12-01 - 16:52:19 - [3]:check_video_signal_res_not_supported:435 - known as supported. 2016-12-01 - 16:52:19 - [4]:tc358743_int_task:634 - Setting 5 second before showing video 2016-12-01 - 16:52:19 - [4]:draw_text_overlay_set_text:68 - with 'Please wait...' 2016-12-01 - 16:52:19 - [4]:reset_open_video_timeout_cb:496 - called 2016-12-01 - 16:52:19 - [4]:reset_open_video_timeout_cb:508 - note: global timeout was already set to 4 sec reset to 5 2016-12-01 - 16:52:20 - [4]:open_video_timeout_cb_sec:413 - called 2016-12-01 - 16:52:20 - [4]:open_video_timeout_cb_sec:416 - g_to = 4 2016-12-01 - 16:52:20 - [4]:open_fw_timeout_cb:394 - called 2016-12-01 - 16:52:21 - [4]:new_client_handler:1124 - called 2016-12-01 - 16:52:21 - [4]:new_client_handler:1150 - [2] A new client has connected 192.168.68.151 2016-12-01 - 16:52:21 - [2]:new_client_handler:1188 - Creating 'closed' signal handler 2016-12-01 - 16:52:21 - [4]:open_video_timeout_cb_sec:413 - called 2016-12-01 - 16:52:21 - [4]:open_video_timeout_cb_sec:416 - g_to = 3 2016-12-01 - 16:52:22 - [4]:open_video_timeout_cb_sec:413 - called 2016-12-01 - 16:52:22 - [4]:open_video_timeout_cb_sec:416 - g_to = 2 2016-12-01 - 16:52:23 - [4]:open_video_timeout_cb_sec:413 - called 2016-12-01 - 16:52:23 - [4]:open_video_timeout_cb_sec:416 - g_to = 1 2016-12-01 - 16:52:24 - [4]:open_video_timeout_cb_sec:413 - called 2016-12-01 - 16:52:24 - [4]:open_video_timeout_cb_sec:416 - g_to = 0 2016-12-01 - 16:52:24 - [4]:open_video_timeout_cb_sec:434 - call g_timeout_add_seconds( 1 , open_video_timeout_cb,NULL) 2016-12-01 - 16:52:25 - [4]:open_video_timeout_cb:455 - called 2016-12-01 - 16:52:25 - [4]:tc358743_normal_screen:302 - called 2016-12-01 - 16:53:23 - [4]:tc358743_int_task:656 - tc358743_int_task after read ret=4 2016-12-01 - 16:53:23 - [4]:draw_text_overlay_set_text:68 - with 'Please wait...' 2016-12-01 - 16:53:23 - [4]:tc358743_black_screen:290 - called 2016-12-01 - 16:53:23 - [4]:check_no_video_signal_input:196 - ### PHY_PLL ret=0 val=0xDF ### 2016-12-01 - 16:53:23 - [4]:check_video_signal_notsync_2:306 - ### S_SYNC ret=0 val=0xDF old=0x9F old_bit=1 new_bit=1### 2016-12-01 - 16:53:24 - [4]:tc358743_int_task:768 - tc358743_int_task : Exit from process cause resolution change detected... 2016-12-01 - 16:53:24 - [4]:draw_text_overlay_set_text:68 - with 'Please wait...' 2016-12-01 - 16:53:24 - [4]:tc358743_exit_from_pipeline:249 - called 0:01:14.321759441 25161 0x1cf5d50 ERROR rtspstream rtsp-stream.c:2928:gst_rtsp_stream_leave_bin:<GstRTSPStream@0x1d38a60> can't leave bin (transports not removed) 0:01:14.321886441 25161 0x1cf5d50 ERROR rtspstream rtsp-stream.c:2928:gst_rtsp_stream_leave_bin:<GstRTSPStream@0x1d38bb0> can't leave bin (transports not removed) 2016-12-01 - 16:53:24 - [4]:remove_clients:677 - removing all clients 2016-12-01 - 16:53:24 - [4]:remove_sessions:641 - removing all sessions 2016-12-01 - 16:53:25 - [3]:check_video_signal_res_not_supported:431 - detect hsize=1920, vsize=1080 2016-12-01 - 16:53:25 - [3]:check_video_signal_res_not_supported:435 - known as supported. 2016-12-01 - 16:53:25 - [4]:draw_text_overlay_set_text:68 - with 'Please wait...' 2016-12-01 - 16:53:25 - [4]:check_no_video_signal_input:196 - ### PHY_PLL ret=0 val=0x9F ### 2016-12-01 - 16:53:26 - [4]:check_no_video_signal_input:196 - ### PHY_PLL ret=0 val=0x9F ### 2016-12-01 - 16:53:27 - [4]:check_no_video_signal_input_at_boot:253 - check_no_video_signal_input_at_boot 2016-12-01 - 16:53:27 - [4]:check_no_video_signal_input_at_boot:262 - ### PHY_PLL[0] ret=1 val=0x9F n_net_i_true=1 ### 2016-12-01 - 16:53:27 - [4]:check_no_video_signal_input_at_boot:262 - ### PHY_PLL[1] ret=1 val=0x9F n_net_i_true=2 ### 2016-12-01 - 16:53:28 - [4]:check_no_video_signal_input_at_boot:262 - ### PHY_PLL[2] ret=1 val=0x9F n_net_i_true=3 ### 2016-12-01 - 16:53:28 - [4]:check_no_video_signal_input_at_boot:262 - ### PHY_PLL[3] ret=1 val=0x9F n_net_i_true=4 ### 2016-12-01 - 16:53:29 - [4]:check_no_video_signal_input_at_boot:262 - ### PHY_PLL[4] ret=1 val=0x9F n_net_i_true=5 ### 2016-12-01 - 16:53:29 - [4]:check_no_video_signal_input_at_boot:269 - ### PHY_PLL ret=0 val=0x9F ### 2016-12-01 - 16:53:30 - [3]:check_video_signal_res_not_supported:431 - detect hsize=1920, vsize=1080 2016-12-01 - 16:53:30 - [3]:check_video_signal_res_not_supported:435 - known as supported. 2016-12-01 - 16:53:30 - [4]:tc358743_int_task:634 - Setting 5 second before showing video 2016-12-01 - 16:53:30 - [4]:draw_text_overlay_set_text:68 - with 'Please wait...' 2016-12-01 - 16:53:30 - [4]:reset_open_video_timeout_cb:496 - called 2016-12-01 - 16:53:30 - [4]:reset_open_video_timeout_cb:503 - call reopen_pipeline() 2016-12-01 - 16:53:30 - [4]:reopen_pipeline:466 - called 0:01:39.215907267 25161 0xb440e8f0 WARN rtspsrc gstrtspsrc.c:2684:on_timeout:<rtspsrc0> source b32c35bb, stream b32c35bb in session 1 timed out 0:01:39.216184267 25161 0xb440e9b0 INFO basesrc gstbasesrc.c:2743:gst_base_src_loop:<udpsrc13> pausing after gst_base_src_get_range() = eos 0:01:39.216385933 25161 0xb440e9b0 INFO task gsttask.c:318:gst_task_func:<udpsrc13:src> Task going to paused 0:01:41.204582466 25161 0x1cfaba0 WARN rtspmedia rtsp-media.c:2728:wait_preroll: failed to preroll pipeline 0:01:41.204670799 25161 0x1cfaba0 WARN rtspmedia rtsp-media.c:3032:gst_rtsp_media_prepare: failed to preroll pipeline 0:01:41.204704799 25161 0x1cfaba0 INFO rtspmedia rtsp-media.c:3158:gst_rtsp_media_unprepare: unprepare media 0x1d38910 0:01:41.204768466 25161 0x1cfaba0 INFO rtspmedia rtsp-media.c:2340:set_target_state: set target state to NULL for media 0x1d38910 0:01:41.204824466 25161 0x1cfaba0 INFO rtspmedia rtsp-media.c:2327:set_state: set state to NULL for media 0x1d38910 0:01:41.205067799 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2515:gst_bin_element_set_state:<appsink3> current NULL pending VOID_PENDING, desired next NULL 0:01:41.205163133 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2632:gst_bin_element_set_state:<appsink3> skipping transition from NULL to NULL 0:01:41.205207799 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2963:gst_bin_change_state_func:<media-pipeline> child 'appsink3' changed state to 1(NULL) successfully 0:01:41.205273799 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2515:gst_bin_element_set_state:<multiudpsink3> current NULL pending VOID_PENDING, desired next NULL 0:01:41.205317799 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2632:gst_bin_element_set_state:<multiudpsink3> skipping transition from NULL to NULL 0:01:41.205355799 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2963:gst_bin_change_state_func:<media-pipeline> child 'multiudpsink3' changed state to 1(NULL) successfully 0:01:41.205412133 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2515:gst_bin_element_set_state:<appsink2> current NULL pending VOID_PENDING, desired next NULL 0:01:41.205456466 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2632:gst_bin_element_set_state:<appsink2> skipping transition from NULL to NULL 0:01:41.205494133 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2963:gst_bin_change_state_func:<media-pipeline> child 'appsink2' changed state to 1(NULL) successfully 0:01:41.205552133 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2515:gst_bin_element_set_state:<multiudpsink2> current NULL pending VOID_PENDING, desired next NULL 0:01:41.205595133 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2632:gst_bin_element_set_state:<multiudpsink2> skipping transition from NULL to NULL 0:01:41.205632466 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2963:gst_bin_change_state_func:<media-pipeline> child 'multiudpsink2' changed state to 1(NULL) successfully 0:01:41.205686799 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2515:gst_bin_element_set_state:<appsink1> current NULL pending VOID_PENDING, desired next NULL 0:01:41.205727466 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2632:gst_bin_element_set_state:<appsink1> skipping transition from NULL to NULL 0:01:41.205762799 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2963:gst_bin_change_state_func:<media-pipeline> child 'appsink1' changed state to 1(NULL) successfully 0:01:41.205818466 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2515:gst_bin_element_set_state:<multiudpsink1> current NULL pending VOID_PENDING, desired next NULL 0:01:41.205861133 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2632:gst_bin_element_set_state:<multiudpsink1> skipping transition from NULL to NULL 0:01:41.205898799 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2963:gst_bin_change_state_func:<media-pipeline> child 'multiudpsink1' changed state to 1(NULL) successfully 0:01:41.205955133 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2515:gst_bin_element_set_state:<appsink0> current NULL pending VOID_PENDING, desired next NULL 0:01:41.205997799 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2632:gst_bin_element_set_state:<appsink0> skipping transition from NULL to NULL 0:01:41.206034466 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2963:gst_bin_change_state_func:<media-pipeline> child 'appsink0' changed state to 1(NULL) successfully 0:01:41.206091799 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2515:gst_bin_element_set_state:<multiudpsink0> current NULL pending VOID_PENDING, desired next NULL 0:01:41.206133799 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2632:gst_bin_element_set_state:<multiudpsink0> skipping transition from NULL to NULL 0:01:41.206172466 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2963:gst_bin_change_state_func:<media-pipeline> child 'multiudpsink0' changed state to 1(NULL) successfully 0:01:41.206227133 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2515:gst_bin_element_set_state:<queue7> current NULL pending VOID_PENDING, desired next NULL 0:01:41.206269466 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2632:gst_bin_element_set_state:<queue7> skipping transition from NULL to NULL 0:01:41.206304799 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2963:gst_bin_change_state_func:<media-pipeline> child 'queue7' changed state to 1(NULL) successfully 0:01:41.206359799 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2515:gst_bin_element_set_state:<queue6> current NULL pending VOID_PENDING, desired next NULL 0:01:41.206406466 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2632:gst_bin_element_set_state:<queue6> skipping transition from NULL to NULL 0:01:41.206443799 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2963:gst_bin_change_state_func:<media-pipeline> child 'queue6' changed state to 1(NULL) successfully 0:01:41.206498133 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2515:gst_bin_element_set_state:<queue5> current NULL pending VOID_PENDING, desired next NULL 0:01:41.206540133 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2632:gst_bin_element_set_state:<queue5> skipping transition from NULL to NULL 0:01:41.206581133 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2963:gst_bin_change_state_func:<media-pipeline> child 'queue5' changed state to 1(NULL) successfully 0:01:41.206637133 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2515:gst_bin_element_set_state:<queue4> current NULL pending VOID_PENDING, desired next NULL 0:01:41.206677466 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2632:gst_bin_element_set_state:<queue4> skipping transition from NULL to NULL 0:01:41.206713466 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2963:gst_bin_change_state_func:<media-pipeline> child 'queue4' changed state to 1(NULL) successfully 0:01:41.206777466 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2515:gst_bin_element_set_state:<queue3> current NULL pending VOID_PENDING, desired next NULL 0:01:41.206820799 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2632:gst_bin_element_set_state:<queue3> skipping transition from NULL to NULL 0:01:41.206857799 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2963:gst_bin_change_state_func:<media-pipeline> child 'queue3' changed state to 1(NULL) successfully 0:01:41.206957133 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2515:gst_bin_element_set_state:<queue2> current NULL pending VOID_PENDING, desired next NULL 0:01:41.207004466 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2632:gst_bin_element_set_state:<queue2> skipping transition from NULL to NULL 0:01:41.207044799 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2963:gst_bin_change_state_func:<media-pipeline> child 'queue2' changed state to 1(NULL) successfully 0:01:41.207099799 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2515:gst_bin_element_set_state:<queue1> current NULL pending VOID_PENDING, desired next NULL 0:01:41.207142799 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2632:gst_bin_element_set_state:<queue1> skipping transition from NULL to NULL 0:01:41.207182799 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2963:gst_bin_change_state_func:<media-pipeline> child 'queue1' changed state to 1(NULL) successfully 0:01:41.207237466 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2515:gst_bin_element_set_state:<queue0> current NULL pending VOID_PENDING, desired next NULL 0:01:41.207280133 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2632:gst_bin_element_set_state:<queue0> skipping transition from NULL to NULL 0:01:41.207316133 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2963:gst_bin_change_state_func:<media-pipeline> child 'queue0' changed state to 1(NULL) successfully 0:01:41.207366133 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2515:gst_bin_element_set_state:<tee3> current NULL pending VOID_PENDING, desired next NULL 0:01:41.207406799 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2632:gst_bin_element_set_state:<tee3> skipping transition from NULL to NULL 0:01:41.207444799 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2963:gst_bin_change_state_func:<media-pipeline> child 'tee3' changed state to 1(NULL) successfully 0:01:41.207492466 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2515:gst_bin_element_set_state:<tee2> current NULL pending VOID_PENDING, desired next NULL 0:01:41.207534466 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2632:gst_bin_element_set_state:<tee2> skipping transition from NULL to NULL 0:01:41.207571133 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2963:gst_bin_change_state_func:<media-pipeline> child 'tee2' changed state to 1(NULL) successfully 0:01:41.207622799 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2515:gst_bin_element_set_state:<tee1> current NULL pending VOID_PENDING, desired next NULL 0:01:41.207664466 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2632:gst_bin_element_set_state:<tee1> skipping transition from NULL to NULL 0:01:41.207700799 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2963:gst_bin_change_state_func:<media-pipeline> child 'tee1' changed state to 1(NULL) successfully 0:01:41.207751799 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2515:gst_bin_element_set_state:<tee0> current NULL pending VOID_PENDING, desired next NULL 0:01:41.207794133 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2632:gst_bin_element_set_state:<tee0> skipping transition from NULL to NULL 0:01:41.207830133 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2963:gst_bin_change_state_func:<media-pipeline> child 'tee0' changed state to 1(NULL) successfully 0:01:41.207886133 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2515:gst_bin_element_set_state:<rtpbin1> current NULL pending VOID_PENDING, desired next NULL 0:01:41.207952133 25161 0x1cfaba0 INFO GST_STATES gstelement.c:2419:gst_element_continue_state:<rtpbin1> completed state change to NULL 0:01:41.207995133 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2963:gst_bin_change_state_func:<media-pipeline> child 'rtpbin1' changed state to 1(NULL) successfully 0:01:41.208069133 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2515:gst_bin_element_set_state:<funnel1> current NULL pending VOID_PENDING, desired next NULL 0:01:41.208111799 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2632:gst_bin_element_set_state:<funnel1> skipping transition from NULL to NULL 0:01:41.208153799 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2963:gst_bin_change_state_func:<media-pipeline> child 'funnel1' changed state to 1(NULL) successfully 0:01:41.208206466 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2963:gst_bin_change_state_func:<media-pipeline> child 'udpsrc5' changed state to 1(NULL) successfully 0:01:41.208258133 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2963:gst_bin_change_state_func:<media-pipeline> child 'udpsrc7' changed state to 1(NULL) successfully 0:01:41.208310466 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2963:gst_bin_change_state_func:<media-pipeline> child 'appsrc2' changed state to 1(NULL) successfully 0:01:41.208388466 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2515:gst_bin_element_set_state:<funnel0> current NULL pending VOID_PENDING, desired next NULL 0:01:41.208430800 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2632:gst_bin_element_set_state:<funnel0> skipping transition from NULL to NULL 0:01:41.208466133 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2963:gst_bin_change_state_func:<media-pipeline> child 'funnel0' changed state to 1(NULL) successfully 0:01:41.208517800 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2963:gst_bin_change_state_func:<media-pipeline> child 'udpsrc1' changed state to 1(NULL) successfully 0:01:41.208565800 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2963:gst_bin_change_state_func:<media-pipeline> child 'udpsrc3' changed state to 1(NULL) successfully 0:01:41.208615133 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2963:gst_bin_change_state_func:<media-pipeline> child 'appsrc1' changed state to 1(NULL) successfully 0:01:41.208678133 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2515:gst_bin_element_set_state:<bin0> current NULL pending VOID_PENDING, desired next NULL 0:01:41.208812133 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2515:gst_bin_element_set_state:<pay1> current NULL pending VOID_PENDING, desired next NULL 0:01:41.208863133 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2632:gst_bin_element_set_state:<pay1> skipping transition from NULL to NULL 0:01:41.208902466 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2963:gst_bin_change_state_func:<bin0> child 'pay1' changed state to 1(NULL) successfully 0:01:41.208957800 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2515:gst_bin_element_set_state:<voaacenc0> current NULL pending VOID_PENDING, desired next NULL 0:01:41.209000133 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2632:gst_bin_element_set_state:<voaacenc0> skipping transition from NULL to NULL 0:01:41.209036133 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2963:gst_bin_change_state_func:<bin0> child 'voaacenc0' changed state to 1(NULL) successfully 0:01:41.209090800 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2515:gst_bin_element_set_state:<audioconvert0> current NULL pending VOID_PENDING, desired next NULL 0:01:41.209137800 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2632:gst_bin_element_set_state:<audioconvert0> skipping transition from NULL to NULL 0:01:41.209173800 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2963:gst_bin_change_state_func:<bin0> child 'audioconvert0' changed state to 1(NULL) successfully 0:01:41.209228800 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2515:gst_bin_element_set_state:<capsfilter1> current NULL pending VOID_PENDING, desired next NULL 0:01:41.209275133 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2632:gst_bin_element_set_state:<capsfilter1> skipping transition from NULL to NULL 0:01:41.209314466 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2963:gst_bin_change_state_func:<bin0> child 'capsfilter1' changed state to 1(NULL) successfully 0:01:41.209367800 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2515:gst_bin_element_set_state:<alsasrc0> current NULL pending VOID_PENDING, desired next NULL 0:01:41.209409800 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2632:gst_bin_element_set_state:<alsasrc0> skipping transition from NULL to NULL 0:01:41.209445133 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2963:gst_bin_change_state_func:<bin0> child 'alsasrc0' changed state to 1(NULL) successfully 0:01:41.209508133 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2515:gst_bin_element_set_state:<pay0> current NULL pending VOID_PENDING, desired next NULL 0:01:41.209548800 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2632:gst_bin_element_set_state:<pay0> skipping transition from NULL to NULL 0:01:41.209584800 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2963:gst_bin_change_state_func:<bin0> child 'pay0' changed state to 1(NULL) successfully 0:01:41.209640133 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2515:gst_bin_element_set_state:<capsfilter0> current NULL pending VOID_PENDING, desired next NULL 0:01:41.209682133 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2632:gst_bin_element_set_state:<capsfilter0> skipping transition from NULL to NULL 0:01:41.209719466 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2963:gst_bin_change_state_func:<bin0> child 'capsfilter0' changed state to 1(NULL) successfully 0:01:41.209775800 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2515:gst_bin_element_set_state:<enc0> current NULL pending VOID_PENDING, desired next NULL 0:01:41.209817133 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2632:gst_bin_element_set_state:<enc0> skipping transition from NULL to NULL 0:01:41.209852466 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2963:gst_bin_change_state_func:<bin0> child 'enc0' changed state to 1(NULL) successfully 0:01:41.209910800 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2515:gst_bin_element_set_state:<caps0> current NULL pending VOID_PENDING, desired next NULL 0:01:41.209952800 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2632:gst_bin_element_set_state:<caps0> skipping transition from NULL to NULL 0:01:41.209988466 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2963:gst_bin_change_state_func:<bin0> child 'caps0' changed state to 1(NULL) successfully 0:01:41.210036133 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2515:gst_bin_element_set_state:<mysrc> current NULL pending VOID_PENDING, desired next NULL 0:01:41.210082133 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2632:gst_bin_element_set_state:<mysrc> skipping transition from NULL to NULL 0:01:41.210118466 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2963:gst_bin_change_state_func:<bin0> child 'mysrc' changed state to 1(NULL) successfully 0:01:41.210174133 25161 0x1cfaba0 INFO GST_STATES gstelement.c:2419:gst_element_continue_state:<bin0> completed state change to NULL 0:01:41.210245466 25161 0x1cfaba0 INFO GST_STATES gstbin.c:2963:gst_bin_change_state_func:<media-pipeline> child 'bin0' changed state to 1(NULL) successfully 0:01:41.210318800 25161 0x1cfaba0 INFO GST_STATES gstelement.c:2419:gst_element_continue_state:<media-pipeline> completed state change to NULL 0:01:41.210358466 25161 0x1cfaba0 INFO rtspmedia rtsp-media.c:3058:finish_unprepare: Removing elements of stream 0 from pipeline 0:01:41.210392133 25161 0x1cfaba0 INFO rtspmedia rtsp-media.c:3058:finish_unprepare: Removing elements of stream 1 from pipeline 0:01:41.210458800 25161 0x1cfaba0 INFO GST_PARENTAGE gstbin.c:1816:gst_bin_remove_func:<media-pipeline> removed child "rtpbin1" 0:01:41.210566133 25161 0x1cfaba0 INFO GST_REFCOUNTING gstelement.c:2994:gst_element_dispose:<rtpbin1> 0xb447b088 dispose 0:01:41.210607466 25161 0x1cfaba0 INFO GST_REFCOUNTING gstelement.c:3040:gst_element_dispose:<rtpbin1> 0xb447b088 parent class dispose 0:01:41.210655466 25161 0x1cfaba0 INFO GST_REFCOUNTING gstelement.c:3071:gst_element_finalize:<rtpbin1> 0xb447b088 finalize 0:01:41.210696466 25161 0x1cfaba0 INFO GST_REFCOUNTING gstelement.c:3077:gst_element_finalize:<rtpbin1> 0xb447b088 finalize parent 2016-12-01 - 16:53:51 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline 2016-12-01 - 16:53:51 - [4]:open_video_timeout_cb_sec:413 - called 2016-12-01 - 16:53:51 - [4]:open_video_timeout_cb_sec:416 - g_to = 4 2016-12-01 - 16:53:51 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline 2016-12-01 - 16:53:51 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline 2016-12-01 - 16:53:51 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline 2016-12-01 - 16:53:51 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline 2016-12-01 - 16:53:51 - [4]:bus_callback:1544 - receive stream-status on appsink pipeline 2016-12-01 - 16:53:51 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline 2016-12-01 - 16:53:51 - [4]:bus_callback:1544 - receive stream-status on appsink pipeline 2016-12-01 - 16:53:51 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline 2016-12-01 - 16:53:51 - [4]:bus_callback:1544 - receive stream-start on appsink pipeline 2016-12-01 - 16:53:51 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline 2016-12-01 - 16:53:51 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline 2016-12-01 - 16:53:51 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline 2016-12-01 - 16:53:51 - [4]:bus_callback:1544 - receive async-done on appsink pipeline 2016-12-01 - 16:53:51 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline 2016-12-01 - 16:53:51 - [4]:bus_callback:1544 - receive state-changed on appsink pipeline 0:01:41.211939133 25161 0x1cfaba0 INFO rtspmedia rtsp-media.c:2817:start_prepare: media is no longer preparing 2016-12-01 - 16:53:51 - [4]:open_fw_timeout_cb:394 - called 0:01:41.769461189 25161 0x1cf5e30 ERROR rtspclient rtsp-client.c:2976:handle_request: client 0x1bc9cd0: session not found 0:01:41.770405856 25161 0x1cf5e30 ERROR rtspclient rtsp-client.c:2976:handle_request: client 0x1bc9cd0: session not found 2016-12-01 - 16:53:52 - [4]:client_close_handler:1039 - called 2016-12-01 - 16:53:52 - [4]:client_close_handler:1044 - [1] Client is closing down 192.168.68.151 2016-12-01 - 16:53:53 - [4]:open_video_timeout_cb_sec:413 - called 2016-12-01 - 16:53:53 - [4]:open_video_timeout_cb_sec:416 - g_to = 3 2016-12-01 - 16:53:54 - [4]:open_video_timeout_cb_sec:413 - called 2016-12-01 - 16:53:54 - [4]:open_video_timeout_cb_sec:416 - g_to = 2 2016-12-01 - 16:53:54 - [4]:new_client_handler:1124 - called 2016-12-01 - 16:53:54 - [4]:new_client_handler:1150 - [2] A new client has connected 192.168.68.151 2016-12-01 - 16:53:54 - [2]:new_client_handler:1188 - Creating 'closed' signal handler 0:01:44.063873085 25161 0x1cf5e30 INFO rtspmountpoints rtsp-mount-points.c:294:gst_rtsp_mount_points_match: found media factory 0x1b9d200 for path /stream 0:01:44.063951085 25161 0x1cf5e30 INFO rtspmediafactory rtsp-media-factory.c:1239:gst_rtsp_media_factory_construct: constructed media 0x1d38910 for url /stream 0:01:44.064121085 25161 0x1cf5e30 INFO rtspmedia rtsp-media.c:2952:gst_rtsp_media_prepare: preparing media 0x1d38910 0:01:44.064147085 25161 0x1d20a30 INFO rtspthreadpool rtsp-thread-pool.c:330:do_loop: enter mainloop of thread 0x1d18288 0:01:44.064181085 25161 0x1cf5e30 INFO GST_ELEMENT_FACTORY gstelementfactory.c:364:gst_element_factory_create: creating element "rtpbin" 0:01:44.064626752 25161 0x1d20a30 INFO rtspstream rtsp-stream.c:2675:gst_rtsp_stream_join_bin: stream 0x1d38a60 joining bin as session 0 ** ERROR:rtsp-stream.c:1222:alloc_ports_one_family: assertion failed: (!udpsrc_out[0]) /opt/linux/scripts/gst/rtsp_h264_enc_variable.aac: line 21: 25161 Aborted $base_gst -u "alsasrc device=hw:0,0 do-timestamp=true latency-time=20000 buffer-time=800000 ! audio/x-raw,rate=${audio_rate},channels=2,depth=16 ! audioconvert ! voaacenc ! rtpmp4apay name=pay1 pt=97" -w "imxipuvideotransform name=caps0 ! imxvpuenc_h264 bitrate=15000 name=enc0 gop-size=32 ! video/x-h264,profile=high ! rtph264pay name=pay0 pt=96 "
Can you provide a testcase that we can run and which reproduces this problem?
I think I''ve found a way to prevent this problem in my application: The way that I was closing the media was: gst_rtsp_media_suspend(get_SI_Instance()->media); gst_rtsp_media_unprepare(get_SI_Instance()->media); gst_element_set_state(get_SI_Instance()->video_source_pipeline, GST_STATE_NULL); Then when I reopen gst_rtsp_media_unsuspend(get_SI_Instance()->media); gst_rtsp_media_prepare(get_SI_Instance()->media,NULL); gst_element_set_state(get_SI_Instance()->video_source_pipeline, GST_STATE_RUNNING); The assertion disappear if swap between the calls prepare then unsuspend ret=gst_rtsp_media_prepare(get_SI_Instance()->media,thread); ret=gst_rtsp_media_unsuspend(get_SI_Instance()->media);
Looks like some rather unconventional use of rtsp-server. The server should be managing the media and pipeline states really. And you found a workaround, so closing.