gscam2 icon indicating copy to clipboard operation
gscam2 copied to clipboard

Pipeline Launches but No Data Published

Open carTloyal123 opened this issue 2 years ago • 3 comments

Hello there,

I am having an issue where my pipeline comes up totally fine when launching the node_params launch file but not data is being published to the topics. I have tried multiple version of my pipeline but none of them seem to fix the problem. Would love any help or insight on what I might be overlooking or issues in my setup. Thanks!

nvarguscamersrc ! video/x-raw(memory:NVMM), width=1280, height=720, framerate=30/1 ! nvvidconv flip-method=0 ! video/x-raw, format=BGRx ! videoconvert ! video/x-raw, format=BGR

I have tried with many combinations of videonconvert being place elsewhere but even the simplest pipeline I could make with the nvarguscamerasrc does not work so I am wondering if this is an NVIDIA bug.

carTloyal123 avatar Jul 24 '22 22:07 carTloyal123

Can you describe the hardware you are using?

Are you able to get it working with gst-launch-1.0?

Does GST_DEBUG give any clues? See: https://gstreamer.freedesktop.org/documentation/tutorials/basic/debugging-tools.html?gi-language=c

clydemcqueen avatar Jul 25 '22 15:07 clydemcqueen

Hey Clyde, thank you for the response. I am using an NVIDIA Jetson Nano with a CSI IMX219 camera. I am having issues where the appsink that you add manually to the pipeline will not connect to any source I put in front of it. gst-launch-1.0 works as expected. I am new to pipelines so it may be something simple here but I am not sure. My goal is to be able to use the rgb image stream from your node using the nvarguscamerasrc gstreamer source.

edit: I will try GST_DEBUG and see if that is informative!

carTloyal123 avatar Jul 25 '22 18:07 carTloyal123

I added the debug output and some of the output is attached shown below. It looks like something about the buffer not being flushed but I am not entirely sure what that is about. I have seen that you can drop buffers from an appsink so maybe that option would be helpful.

[gscam_main-1] 0:00:02.399179931  9581   0x55ae0aeaa0 LOG               GST_BUFFER gstbuffer.c:895:gst_buffer_new_allocate: new buffer 0x55ae410b40 of size 1008 from allocator 0x55ae1d6df0
[gscam_main-1] 0:00:02.399198890  9581   0x55ae0aeaa0 LOG               bufferpool gstbufferpool.c:286:do_alloc_buffer:<bufferpool0> allocated buffer 4/8, 0x55ae410b40
[gscam_main-1] 0:00:02.399213786  9581   0x55ae0aeaa0 LOG               bufferpool gstbufferpool.c:1285:default_release_buffer:<bufferpool0> released buffer 0x55ae410b40 0
[gscam_main-1] 0:00:02.399227172  9581   0x55ae0aeaa0 DEBUG             GST_BUFFER gstbuffer.c:1448:gst_buffer_is_memory_range_writable: idx 0, length -1
[gscam_main-1] 0:00:02.399230193  9581   0x55ae14fa00 DEBUG                    bin gstbin.c:2165:add_to_queue:<pipeline0> adding 'nvvconv0' to queue
[gscam_main-1] 0:00:02.399263422  9581   0x55ae14fa00 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<capsfilter0> current PAUSED pending VOID_PENDING, desired next PLAYING
[gscam_main-1] 0:00:02.399280506  9581   0x55ae14fa00 LOG                      bin gstbin.c:860:message_check: looking at message 0x55ae3f2ea0: 0
[gscam_main-1] 0:00:02.399291652  9581   0x55ae0aeaa0 DEBUG             GST_MEMORY gstmemory.c:138:gst_memory_init: new memory 0x7f5400b0e0, maxsize:1008 offset:0 size:1008
[gscam_main-1] 0:00:02.399315038  9581   0x55ae0aeaa0 LOG               GST_BUFFER gstbuffer.c:841:gst_buffer_new: new 0x55ae410c60
[gscam_main-1] 0:00:02.399294829  9581   0x55ae14fa00 DEBUG                    bin gstbin.c:882:find_message:<pipeline0> no message found matching types 00100000
[gscam_main-1] 0:00:02.399331340  9581   0x55ae0aeaa0 LOG               GST_BUFFER gstbuffer.c:447:_memory_add: buffer 0x55ae410c60, idx -1, mem 0x7f5400b0e0
[gscam_main-1] 0:00:02.399338945  9581   0x55ae14fa00 DEBUG                    bin gstbin.c:889:find_message:<pipeline0>   async-start
[gscam_main-1] 0:00:02.399347018  9581   0x55ae0aeaa0 LOG               GST_BUFFER gstbuffer.c:895:gst_buffer_new_allocate: new buffer 0x55ae410c60 of size 1008 from allocator 0x55ae1d6df0
[gscam_main-1] 0:00:02.399360299  9581   0x55ae14fa00 DEBUG                    bin gstbin.c:2599:gst_bin_element_set_state:<pipeline0> setting element capsfilter0 to PLAYING, base_time 0:12:41.516844767
[gscam_main-1] 0:00:02.399363320  9581   0x55ae0aeaa0 LOG               bufferpool gstbufferpool.c:286:do_alloc_buffer:<bufferpool0> allocated buffer 5/8, 0x55ae410c60
[gscam_main-1] 0:00:02.399388581  9581   0x55ae0aeaa0 LOG               bufferpool gstbufferpool.c:1285:default_release_buffer:<bufferpool0> released buffer 0x55ae410c60 0
[gscam_main-1] 0:00:02.399412852  9581   0x55ae0aeaa0 DEBUG             GST_BUFFER gstbuffer.c:1448:gst_buffer_is_memory_range_writable: idx 0, length -1
[gscam_main-1] 0:00:02.399418165  9581   0x55ae14fa00 DEBUG             GST_STATES gstelement.c:2826:gst_element_set_state_func:<capsfilter0> set_state to PLAYING
[gscam_main-1] 0:00:02.399460457  9581   0x55ae14fa00 DEBUG             GST_STATES gstelement.c:2851:gst_element_set_state_func:<capsfilter0> setting target state to PLAYING
[gscam_main-1] 0:00:02.399530094  9581   0x55ae14fa00 DEBUG             GST_STATES gstelement.c:2860:gst_element_set_state_func:<capsfilter0> current PAUSED, old_pending VOID_PENDING, next VOID_PENDING, old return SUCCESS
[gscam_main-1] 0:00:02.399555667  9581   0x55ae14fa00 DEBUG             GST_STATES gstelement.c:2896:gst_element_set_state_func:<capsfilter0> final: setting state from PAUSED to PLAYING
[gscam_main-1] 0:00:02.399577438  9581   0x55ae14fa00 LOG               GST_STATES gstelement.c:3151:gst_element_change_state_func:<capsfilter0> default handler tries setting state from PAUSED to PLAYING (001c)
[gscam_main-1] 0:00:02.399591761  9581   0x55ae14fa00 DEBUG             GST_STATES gstelement.c:2987:gst_element_change_state:<capsfilter0> element changed state SUCCESS
[gscam_main-1] 0:00:02.399674731  9581   0x55ae14fa00 INFO              GST_STATES gstelement.c:2675:gst_element_continue_state:<capsfilter0> completed state change to PLAYING
[gscam_main-1] 0:00:02.399698065  9581   0x55ae14fa00 INFO              GST_STATES gstelement.c:2575:_priv_gst_element_state_changed:<capsfilter0> notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
[gscam_main-1] 0:00:02.399779056  9581   0x55ae14fa00 LOG              GST_MESSAGE gstmessage.c:303:gst_message_new_custom: source capsfilter0: creating new message 0x55ae411290 state-changed
[gscam_main-1] 0:00:02.399836401  9581   0x55ae14fa00 DEBUG                GST_BUS gstbus.c:315:gst_bus_post:<bus0> [msg 0x55ae411290] posting on bus state-changed message: 0x55ae411290, time 99:99:99.999999999, seq-num 31, element 'capsfilter0', GstMessageStateChanged, old-state=(GstState)GST_STATE_PAUSED, new-state=(GstState)GST_STATE_PLAYING, pending-state=(GstState)GST_STATE_VOID_PENDING;
[gscam_main-1] 0:00:02.399860516  9581   0x55ae14fa00 DEBUG                    bin gstbin.c:3718:gst_bin_handle_message_func:<pipeline0> [msg 0x55ae411290] handling child capsfilter0 message of type state-changed
[gscam_main-1] 0:00:02.399874370  9581   0x55ae14fa00 DEBUG                    bin gstbin.c:4065:gst_bin_handle_message_func:<pipeline0> posting message upward
[gscam_main-1] 0:00:02.399907079  9581   0x55ae14fa00 DEBUG                GST_BUS gstbus.c:315:gst_bus_post:<bus1> [msg 0x55ae411290] posting on bus state-changed message: 0x55ae411290, time 99:99:99.999999999, seq-num 31, element 'capsfilter0', GstMessageStateChanged, old-state=(GstState)GST_STATE_PAUSED, new-state=(GstState)GST_STATE_PLAYING, pending-state=(GstState)GST_STATE_VOID_PENDING;
[gscam_main-1] 0:00:02.399925725  9581   0x55ae14fa00 DEBUG                GST_BUS gstbus.c:355:gst_bus_post:<bus1> [msg 0x55ae411290] pushing on async queue
[gscam_main-1] 0:00:02.399940830  9581   0x55ae14fa00 DEBUG                GST_BUS gstbus.c:358:gst_bus_post:<bus1> [msg 0x55ae411290] pushed on async queue
[gscam_main-1] 0:00:02.399957080  9581   0x55ae14fa00 DEBUG                GST_BUS gstbus.c:351:gst_bus_post:<bus0> [msg 0x55ae411290] dropped
[gscam_main-1] 0:00:02.399975518  9581   0x55ae14fa00 LOG               GST_STATES gstelement.c:3004:gst_element_change_state:<capsfilter0> exit state change 1
[gscam_main-1] 0:00:02.399992028  9581   0x55ae14fa00 DEBUG             GST_STATES gstelement.c:2910:gst_element_set_state_func:<capsfilter0> returned SUCCESS
[gscam_main-1] 0:00:02.400010570  9581   0x55ae14fa00 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<pipeline0> child 'capsfilter0' changed state to 4(PLAYING) successfully
[gscam_main-1] 0:00:02.400031925  9581   0x55ae14fa00 DEBUG                    bin gstbin.c:2373:gst_bin_sort_iterator_next:<pipeline0> queue head gives nvvconv0
[gscam_main-1] 0:00:02.400051717  9581   0x55ae14fa00 LOG                      bin gstbin.c:860:message_check: looking at message 0x55ae3f2ea0: 0
[gscam_main-1] 0:00:02.400066821  9581   0x55ae14fa00 DEBUG                    bin gstbin.c:882:find_message:<pipeline0> no message found matching types 00001000
[gscam_main-1] 0:00:02.400080572  9581   0x55ae14fa00 DEBUG                    bin gstbin.c:889:find_message:<pipeline0>   structure-change
[gscam_main-1] 0:00:02.400095207  9581   0x55ae14fa00 DEBUG                    bin gstbin.c:2305:update_degree:<pipeline0> element nvvconv0 not linked on any sinkpads
[gscam_main-1] 0:00:02.400115520  9581   0x55ae14fa00 INFO              GST_STATES gstbin.c:2503:gst_bin_element_set_state:<nvvconv0> current PAUSED pending VOID_PENDING, desired next PLAYING
[gscam_main-1] 0:00:02.400132135  9581   0x55ae14fa00 LOG                      bin gstbin.c:860:message_check: looking at message 0x55ae3f2ea0: 0
[gscam_main-1] 0:00:02.400146041  9581   0x55ae14fa00 DEBUG                    bin gstbin.c:882:find_message:<pipeline0> no message found matching types 00100000
[gscam_main-1] 0:00:02.400159635  9581   0x55ae14fa00 DEBUG                    bin gstbin.c:889:find_message:<pipeline0>   async-start
[gscam_main-1] 0:00:02.400180313  9581   0x55ae14fa00 DEBUG                    bin gstbin.c:2599:gst_bin_element_set_state:<pipeline0> setting element nvvconv0 to PLAYING, base_time 0:12:41.516844767
[gscam_main-1] 0:00:02.400195209  9581   0x55ae14fa00 DEBUG             GST_STATES gstelement.c:2826:gst_element_set_state_func:<nvvconv0> set_state to PLAYING
[gscam_main-1] 0:00:02.400210105  9581   0x55ae14fa00 DEBUG             GST_STATES gstelement.c:2851:gst_element_set_state_func:<nvvconv0> setting target state to PLAYING
[gscam_main-1] 0:00:02.400227918  9581   0x55ae14fa00 DEBUG             GST_STATES gstelement.c:2860:gst_element_set_state_func:<nvvconv0> current PAUSED, old_pending VOID_PENDING, next VOID_PENDING, old return SUCCESS
[gscam_main-1] 0:00:02.400244272  9581   0x55ae14fa00 DEBUG             GST_STATES gstelement.c:2896:gst_element_set_state_func:<nvvconv0> final: setting state from PAUSED to PLAYING
[gscam_main-1] 0:00:02.400257710  9581   0x55ae0aeaa0 INFO               GST_EVENT gstevent.c:820:gst_event_new_caps: creating caps event video/x-raw(memory:NVMM), width=(int)1920, height=(int)1080, format=(string)NV12, framerate=(fraction)30/1
[gscam_main-1] 0:00:02.400266096  9581   0x55ae14fa00 LOG               GST_STATES gstelement.c:3151:gst_element_change_state_func:<nvvconv0> default handler tries setting state from PAUSED to PLAYING (001c)
[gscam_main-1] 0:00:02.400314482  9581   0x55ae14fa00 DEBUG             GST_STATES gstelement.c:2987:gst_element_change_state:<nvvconv0> element changed state SUCCESS
[gscam_main-1] 0:00:02.400333128  9581   0x55ae14fa00 INFO              GST_STATES gstelement.c:2675:gst_element_continue_state:<nvvconv0> completed state change to PLAYING
[gscam_main-1] 0:00:02.400350524  9581   0x55ae14fa00 INFO              GST_STATES gstelement.c:2575:_priv_gst_element_state_changed:<nvvconv0> notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
[gscam_main-1] 0:00:02.400411411  9581   0x55ae14fa00 LOG              GST_MESSAGE gstmessage.c:303:gst_message_new_custom: source nvvconv0: creating new message 0x55ae411310 state-changed
[gscam_main-1] 0:00:02.400451932  9581   0x55ae14fa00 DEBUG                GST_BUS gstbus.c:315:gst_bus_post:<bus0> [msg 0x55ae411310] posting on bus state-changed message: 0x55ae411310, time 99:99:99.999999999, seq-num 32, element 'nvvconv0', GstMessageStateChanged, old-state=(GstState)GST_STATE_PAUSED, new-state=(GstState)GST_STATE_PLAYING, pending-state=(GstState)GST_STATE_VOID_PENDING;
[gscam_main-1] 0:00:02.400472870  9581   0x55ae14fa00 DEBUG                    bin gstbin.c:3718:gst_bin_handle_message_func:<pipeline0> [msg 0x55ae411310] handling child nvvconv0 message of type state-changed
[gscam_main-1] 0:00:02.400486464  9581   0x55ae14fa00 DEBUG                    bin gstbin.c:4065:gst_bin_handle_message_func:<pipeline0> posting message upward
[gscam_main-1] 0:00:02.400518339  9581   0x55ae14fa00 DEBUG                GST_BUS gstbus.c:315:gst_bus_post:<bus1> [msg 0x55ae411310] posting on bus state-changed message: 0x55ae411310, time 99:99:99.999999999, seq-num 32, element 'nvvconv0', GstMessageStateChanged, old-state=(GstState)GST_STATE_PAUSED, new-state=(GstState)GST_STATE_PLAYING, pending-state=(GstState)GST_STATE_VOID_PENDING;
[gscam_main-1] 0:00:02.400534329  9581   0x55ae14fa00 DEBUG                GST_BUS gstbus.c:355:gst_bus_post:<bus1> [msg 0x55ae411310] pushing on async queue
[gscam_main-1] 0:00:02.400548809  9581   0x55ae14fa00 DEBUG                GST_BUS gstbus.c:358:gst_bus_post:<bus1> [msg 0x55ae411310] pushed on async queue
[gscam_main-1] 0:00:02.400563548  9581   0x55ae14fa00 DEBUG                GST_BUS gstbus.c:351:gst_bus_post:<bus0> [msg 0x55ae411310] dropped
[gscam_main-1] 0:00:02.400579122  9581   0x55ae14fa00 LOG               GST_STATES gstelement.c:3004:gst_element_change_state:<nvvconv0> exit state change 1
[gscam_main-1] 0:00:02.400593393  9581   0x55ae14fa00 DEBUG             GST_STATES gstelement.c:2910:gst_element_set_state_func:<nvvconv0> returned SUCCESS
[gscam_main-1] 0:00:02.400610737  9581   0x55ae14fa00 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<pipeline0> child 'nvvconv0' changed state to 4(PLAYING) successfully
[gscam_main-1] 0:00:02.400628914  9581   0x55ae14fa00 DEBUG                    bin gstbin.c:2357:gst_bin_sort_iterator_next:<pipeline0> queue empty, next best: nvarguscamerasrc0
[gscam_main-1] 0:00:02.400645529  9581   0x55ae14fa00 DEBUG                    bin gstbin.c:2373:gst_bin_sort_iterator_next:<pipeline0> queue head gives nvarguscamerasrc0
[gscam_main-1] 0:00:02.400659436  9581   0x55ae14fa00 DEBUG                    bin gstbin.c:2305:update_degree:<pipeline0> element nvarguscamerasrc0 not linked on any sinkpads
[gscam_main-1] 0:00:02.400672457  9581   0x55ae14fa00 DEBUG                    bin gstbin.c:2499:gst_bin_element_set_state:<nvarguscamerasrc0> element is NO_PREROLL, ignore async elements
[gscam_main-1] 0:00:02.400692144  9581   0x55ae14fa00 DEBUG                    bin gstbin.c:2599:gst_bin_element_set_state:<pipeline0> setting element nvarguscamerasrc0 to PLAYING, base_time 0:12:41.516844767
[gscam_main-1] 0:00:02.400706572  9581   0x55ae14fa00 DEBUG             GST_STATES gstelement.c:2826:gst_element_set_state_func:<nvarguscamerasrc0> set_state to PLAYING
[gscam_main-1] 0:00:02.400720582  9581   0x55ae14fa00 DEBUG             GST_STATES gstelement.c:2851:gst_element_set_state_func:<nvarguscamerasrc0> setting target state to PLAYING
[gscam_main-1] 0:00:02.400737718  9581   0x55ae14fa00 DEBUG             GST_STATES gstelement.c:2860:gst_element_set_state_func:<nvarguscamerasrc0> current PAUSED, old_pending VOID_PENDING, next VOID_PENDING, old return NO PREROLL
[gscam_main-1] 0:00:02.400753500  9581   0x55ae14fa00 DEBUG             GST_STATES gstelement.c:2896:gst_element_set_state_func:<nvarguscamerasrc0> final: setting state from PAUSED to PLAYING
[gscam_main-1] 0:00:02.400768500  9581   0x55ae14fa00 DEBUG                basesrc gstbasesrc.c:3910:gst_base_src_change_state:<nvarguscamerasrc0> PAUSED->PLAYING
[gscam_main-1] 0:00:02.400780948  9581   0x55ae14fa00 DEBUG                basesrc gstbasesrc.c:3759:gst_base_src_set_playing:<nvarguscamerasrc0> unschedule clock
[gscam_main-1] 0:00:02.400793761  9581   0x55ae14fa00 DEBUG                basesrc gstbasesrc.c:3766:gst_base_src_set_playing:<nvarguscamerasrc0> live running 1
[gscam_main-1] 0:00:02.400806626  9581   0x55ae14fa00 DEBUG               GST_PADS gstpad.c:6150:gst_pad_start_task:<nvarguscamerasrc0:src> start task
[gscam_main-1] 0:00:02.400824699  9581   0x55ae14fa00 DEBUG                   task gsttask.c:684:gst_task_set_state:<nvarguscamerasrc0:src> Changing task 0x55ae410050 to state 0
[gscam_main-1] 0:00:02.400836261  9581   0x55ae14fa00 DEBUG                basesrc gstbasesrc.c:3784:gst_base_src_set_playing:<nvarguscamerasrc0> signal
[gscam_main-1] 0:00:02.400854595  9581   0x55ae14fa00 LOG               GST_STATES gstelement.c:3151:gst_element_change_state_func:<nvarguscamerasrc0> default handler tries setting state from PAUSED to PLAYING (001c)
[gscam_main-1] 0:00:02.400867772  9581   0x55ae14fa00 DEBUG             GST_STATES gstelement.c:2987:gst_element_change_state:<nvarguscamerasrc0> element changed state SUCCESS
[gscam_main-1] 0:00:02.400880950  9581   0x55ae14fa00 INFO              GST_STATES gstelement.c:2675:gst_element_continue_state:<nvarguscamerasrc0> completed state change to PLAYING
[gscam_main-1] 0:00:02.400896731  9581   0x55ae14fa00 INFO              GST_STATES gstelement.c:2575:_priv_gst_element_state_changed:<nvarguscamerasrc0> notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
[gscam_main-1] 0:00:02.400915794  9581   0x55ae14fa00 LOG              GST_MESSAGE gstmessage.c:303:gst_message_new_custom: source nvarguscamerasrc0: creating new message 0x55ae411390 state-changed
[gscam_main-1] 0:00:02.400951628  9581   0x55ae14fa00 DEBUG                GST_BUS gstbus.c:315:gst_bus_post:<bus0> [msg 0x55ae411390] posting on bus state-changed message: 0x55ae411390, time 99:99:99.999999999, seq-num 33, element 'nvarguscamerasrc0', GstMessageStateChanged, old-state=(GstState)GST_STATE_PAUSED, new-state=(GstState)GST_STATE_PLAYING, pending-state=(GstState)GST_STATE_VOID_PENDING;
[gscam_main-1] 0:00:02.400972097  9581   0x55ae14fa00 DEBUG                    bin gstbin.c:3718:gst_bin_handle_message_func:<pipeline0> [msg 0x55ae411390] handling child nvarguscamerasrc0 message of type state-changed
[gscam_main-1] 0:00:02.400984076  9581   0x55ae14fa00 DEBUG                    bin gstbin.c:4065:gst_bin_handle_message_func:<pipeline0> posting message upward
[gscam_main-1] 0:00:02.401014233  9581   0x55ae14fa00 DEBUG                GST_BUS gstbus.c:315:gst_bus_post:<bus1> [msg 0x55ae411390] posting on bus state-changed message: 0x55ae411390, time 99:99:99.999999999, seq-num 33, element 'nvarguscamerasrc0', GstMessageStateChanged, old-state=(GstState)GST_STATE_PAUSED, new-state=(GstState)GST_STATE_PLAYING, pending-state=(GstState)GST_STATE_VOID_PENDING;
[gscam_main-1] 0:00:02.401029754  9581   0x55ae14fa00 DEBUG                GST_BUS gstbus.c:355:gst_bus_post:<bus1> [msg 0x55ae411390] pushing on async queue
[gscam_main-1] 0:00:02.401043557  9581   0x55ae14fa00 DEBUG                GST_BUS gstbus.c:358:gst_bus_post:<bus1> [msg 0x55ae411390] pushed on async queue
[gscam_main-1] 0:00:02.401058036  9581   0x55ae14fa00 DEBUG                GST_BUS gstbus.c:351:gst_bus_post:<bus0> [msg 0x55ae411390] dropped
[gscam_main-1] 0:00:02.401074599  9581   0x55ae14fa00 LOG               GST_STATES gstelement.c:3004:gst_element_change_state:<nvarguscamerasrc0> exit state change 1
[gscam_main-1] 0:00:02.401089443  9581   0x55ae14fa00 DEBUG             GST_STATES gstelement.c:2910:gst_element_set_state_func:<nvarguscamerasrc0> returned SUCCESS
[gscam_main-1] 0:00:02.401108558  9581   0x55ae14fa00 INFO              GST_STATES gstbin.c:2952:gst_bin_change_state_func:<pipeline0> child 'nvarguscamerasrc0' changed state to 4(PLAYING) successfully
[gscam_main-1] 0:00:02.401125016  9581   0x55ae14fa00 DEBUG                    bin gstbin.c:2362:gst_bin_sort_iterator_next:<pipeline0> queue empty, elements exhausted
[gscam_main-1] 0:00:02.401138610  9581   0x55ae14fa00 DEBUG             GST_STATES gstbin.c:3014:gst_bin_change_state_func:<pipeline0> iterator done
[gscam_main-1] 0:00:02.401156371  9581   0x55ae14fa00 LOG               GST_STATES gstelement.c:3151:gst_element_change_state_func:<pipeline0> default handler tries setting state from PAUSED to PLAYING (001c)
[gscam_main-1] 0:00:02.401170538  9581   0x55ae14fa00 DEBUG             GST_STATES gstbin.c:3030:gst_bin_change_state_func:<pipeline0> we have ASYNC elements SUCCESS -> ASYNC
[gscam_main-1] 0:00:02.401183663  9581   0x55ae14fa00 DEBUG                    bin gstbin.c:2404:gst_bin_sort_iterator_free:<pipeline0> free
[gscam_main-1] 0:00:02.401198768  9581   0x55ae14fa00 DEBUG                    bin gstbin.c:3060:gst_bin_change_state_func:<pipeline0> check async elements
[gscam_main-1] 0:00:02.401213612  9581   0x55ae14fa00 LOG                      bin gstbin.c:860:message_check: looking at message 0x55ae3f2ea0: 1
[gscam_main-1] 0:00:02.401229601  9581   0x55ae14fa00 DEBUG                    bin gstbin.c:878:find_message:<pipeline0> we found a message 0x55ae3f2ea0 from appsink0 matching types 00100000
[gscam_main-1] 0:00:02.401251946  9581   0x55ae14fa00 DEBUG             GST_STATES gstbin.c:3078:gst_bin_change_state_func:<pipeline0> done changing bin's state from PAUSED to PLAYING, now in PAUSED, ret ASYNC
[gscam_main-1] 0:00:02.401264602  9581   0x55ae14fa00 DEBUG             GST_STATES gstelement.c:2969:gst_element_change_state:<pipeline0> element will change state ASYNC
[gscam_main-1] 0:00:02.401277311  9581   0x55ae14fa00 LOG               GST_STATES gstelement.c:3009:gst_element_change_state:<pipeline0> exit async state change 2
[gscam_main-1] 0:00:02.401289915  9581   0x55ae14fa00 DEBUG             GST_STATES gstelement.c:2910:gst_element_set_state_func:<pipeline0> returned ASYNC
[gscam_main-1] [INFO] [1658776300.635444262] [my_camera.gscam_publisher]: Pipeline running
[gscam_main-1] [INFO] [1658776300.635744476] [my_camera.gscam_publisher]: Thread running: 1
[gscam_main-1] [INFO] [1658776300.636169587] [my_camera.gscam_publisher]: Process Frame!
[gscam_main-1] 0:00:02.402360402  9581   0x7f48003410 DEBUG                appsink gstappsink.c:1644:gst_app_sink_try_pull_sample:<appsink0> trying to grab a buffer
[gscam_main-1] 0:00:02.402441341  9581   0x7f48003410 DEBUG                appsink gstappsink.c:1655:gst_app_sink_try_pull_sample:<appsink0> waiting for a buffer
[gscam_main-1] 0:00:02.402870358  9581   0x55ae0aeaa0 DEBUG              GST_EVENT gstevent.c:308:gst_event_new_custom: creating new event 0x55ae3fe580 caps 12814
[gscam_main-1] 0:00:02.402904161  9581   0x55ae0aeaa0 LOG                 GST_PADS gstpad.c:5224:store_sticky_event:<nvarguscamerasrc0:src> stored sticky event caps
[gscam_main-1] 0:00:02.402918849  9581   0x55ae0aeaa0 DEBUG               GST_PADS gstpad.c:5230:store_sticky_event:<nvarguscamerasrc0:src> notify caps
[gscam_main-1] 0:00:02.402952651  9581   0x55ae0aeaa0 LOG           GST_PROPERTIES gstobject.c:471:gst_object_dispatch_properties_changed:<nvarguscamerasrc0> deep notification from src (caps)
[gscam_main-1] 0:00:02.402976089  9581   0x55ae0aeaa0 LOG           GST_PROPERTIES gstobject.c:471:gst_object_dispatch_properties_changed:<pipeline0> deep notification from src (caps)
[gscam_main-1] 0:00:02.402992339  9581   0x55ae0aeaa0 DEBUG               GST_PADS gstpad.c:3985:check_sticky:<nvarguscamerasrc0:src> pushing all sticky events
[gscam_main-1] 0:00:02.403008850  9581   0x55ae0aeaa0 DEBUG               GST_PADS gstpad.c:3914:push_sticky:<nvarguscamerasrc0:src> event stream-start was already received
[gscam_main-1] 0:00:02.403026298  9581   0x55ae0aeaa0 DEBUG               GST_PADS gstpad.c:5464:gst_pad_push_event_unchecked:<nvarguscamerasrc0:src> Dropping event caps because pad is not linked
[gscam_main-1] 0:00:02.403040205  9581   0x55ae0aeaa0 DEBUG               GST_PADS gstpad.c:3956:push_sticky:<nvarguscamerasrc0:src> pad was not linked, mark pending
[gscam_main-1] 0:00:02.403079633  9581   0x55ae0aeaa0 DEBUG               GST_CAPS gstpad.c:2732:gst_pad_get_current_caps:<nvarguscamerasrc0:src> get current pad caps video/x-raw(memory:NVMM), width=(int)1920, height=(int)1080, format=(string)NV12, framerate=(fraction)30/1
[gscam_main-1] 0:00:02.403106248  9581   0x55ae0aeaa0 DEBUG                  query gstquery.c:679:gst_query_new_custom: creating new query 0x55ae264f20 allocation
[gscam_main-1] 0:00:02.403126508  9581   0x55ae0aeaa0 DEBUG               GST_PADS gstpad.c:4180:gst_pad_peer_query:<nvarguscamerasrc0:src> peer query 0x55ae264f20 (allocation)
[gscam_main-1] 0:00:02.403138592  9581   0x55ae0aeaa0 DEBUG               GST_PADS gstpad.c:3985:check_sticky:<nvarguscamerasrc0:src> pushing all sticky events
[gscam_main-1] 0:00:02.403157342  9581   0x55ae0aeaa0 DEBUG               GST_PADS gstpad.c:3914:push_sticky:<nvarguscamerasrc0:src> event stream-start was already received
[gscam_main-1] 0:00:02.403172967  9581   0x55ae0aeaa0 DEBUG               GST_PADS gstpad.c:3914:push_sticky:<nvarguscamerasrc0:src> event caps was already received
[gscam_main-1] 0:00:02.403185676  9581   0x55ae0aeaa0 INFO                GST_PADS gstpad.c:4237:gst_pad_peer_query:<nvarguscamerasrc0:src> pad has no peer
[gscam_main-1] 0:00:02.403198957  9581   0x55ae0aeaa0 DEBUG                basesrc gstbasesrc.c:3254:gst_base_src_prepare_allocation:<nvarguscamerasrc0> peer ALLOCATION query failed
[gscam_main-1] 0:00:02.403303907  9581   0x55ae0aeaa0 WARN               structure gststructure.c:1861:priv_gst_structure_append_to_gstring: No value transform to serialize field 'allocator' of type 'GArray'
[gscam_main-1] 0:00:02.403326460  9581   0x55ae0aeaa0 WARN               structure gststructure.c:1861:priv_gst_structure_append_to_gstring: No value transform to serialize field 'pool' of type 'GArray'
[gscam_main-1] 0:00:02.403344325  9581   0x55ae0aeaa0 DEBUG                basesrc gstbasesrc.c:3260:gst_base_src_prepare_allocation:<nvarguscamerasrc0> ALLOCATION (1) params: allocation query: 0x55ae264f20, GstQueryAllocation, caps=(GstCaps)"video/x-raw\(memory:NVMM\)\,\ width\=\(int\)1920\,\ height\=\(int\)1080\,\ format\=\(string\)NV12\,\ framerate\=\(fraction\)30/1", need-pool=(boolean)true, allocator=(GArray)NULL, pool=(GArray)NULL;
[gscam_main-1] 0:00:02.403375158  9581   0x55ae0aeaa0 LOG                  basesrc gstbasesrc.c:2842:gst_base_src_loop:<nvarguscamerasrc0> next_ts 99:99:99.999999999 size 4096
[gscam_main-1] 0:00:02.403391773  9581   0x55ae0aeaa0 DEBUG                basesrc gstbasesrc.c:2519:gst_base_src_get_range:<nvarguscamerasrc0> calling create offset 18446744073709551615 length 4096, time 0
[gscam_main-1] GST_ARGUS: Creating output stream
[gscam_main-1] CONSUMER: Waiting until producer is connected...
[gscam_main-1] GST_ARGUS: Available Sensor modes :
[gscam_main-1] GST_ARGUS: 3264 x 2464 FR = 21.000000 fps Duration = 47619048 ; Analog Gain range min 1.000000, max 10.625000; Exposure Range min 13000, max 683709000;
[gscam_main-1] 
[gscam_main-1] GST_ARGUS: 3264 x 1848 FR = 28.000001 fps Duration = 35714284 ; Analog Gain range min 1.000000, max 10.625000; Exposure Range min 13000, max 683709000;
[gscam_main-1] 
[gscam_main-1] GST_ARGUS: 1920 x 1080 FR = 29.999999 fps Duration = 33333334 ; Analog Gain range min 1.000000, max 10.625000; Exposure Range min 13000, max 683709000;
[gscam_main-1] 
[gscam_main-1] GST_ARGUS: 1640 x 1232 FR = 29.999999 fps Duration = 33333334 ; Analog Gain range min 1.000000, max 10.625000; Exposure Range min 13000, max 683709000;
[gscam_main-1] 
[gscam_main-1] GST_ARGUS: 1280 x 720 FR = 59.999999 fps Duration = 16666667 ; Analog Gain range min 1.000000, max 10.625000; Exposure Range min 13000, max 683709000;
[gscam_main-1] 
[gscam_main-1] GST_ARGUS: 1280 x 720 FR = 120.000005 fps Duration = 8333333 ; Analog Gain range min 1.000000, max 10.625000; Exposure Range min 13000, max 683709000;
[gscam_main-1] 
[gscam_main-1] GST_ARGUS: Running with following settings:
[gscam_main-1]    Camera index = 0 
[gscam_main-1]    Camera mode  = 4 
[gscam_main-1]    Output Stream W = 1280 H = 720 
[gscam_main-1]    seconds to Run    = 0 
[gscam_main-1]    Frame Rate = 59.999999 
[gscam_main-1] GST_ARGUS: Setup Complete, Starting captures for 0 seconds
[gscam_main-1] GST_ARGUS: Starting repeat capture requests.
[gscam_main-1] CONSUMER: Producer has connected; continuing.
[gscam_main-1] 0:00:02.790681841  9581   0x55ae411d80 LOG               bufferpool gstbufferpool.c:1123:default_acquire_buffer:<bufferpool0> acquired buffer 0x55ae4106c0
[gscam_main-1] 0:00:02.790737883  9581   0x55ae411d80 DEBUG        GST_PERFORMANCE gstminiobject.c:527:ensure_priv_data: allocating private data GstBuffer miniobject 0x55ae4106c0
[gscam_main-1] 0:00:02.794994622  9581   0x55ae0aeaa0 DEBUG                basesrc gstbasesrc.c:2261:gst_base_src_do_sync:<nvarguscamerasrc0> no latency needed, live 1, sync 0
[gscam_main-1] 0:00:02.795048529  9581   0x55ae0aeaa0 DEBUG              GST_CLOCK gstclock.c:1091:gst_clock_get_internal_time:<GstSystemClock> internal time 0:12:41.947283061
[gscam_main-1] 0:00:02.795071446  9581   0x55ae0aeaa0 DEBUG              GST_CLOCK gstclock.c:1136:gst_clock_get_time:<GstSystemClock> adjusted time 0:12:41.947283061
[gscam_main-1] 0:00:02.795099103  9581   0x55ae0aeaa0 LOG                  basesrc gstbasesrc.c:2284:gst_base_src_do_sync:<nvarguscamerasrc0> startup PTS: 99:99:99.999999999, DTS 99:99:99.999999999, running_time 0:00:00.430438294
[gscam_main-1] 0:00:02.795112332  9581   0x55ae0aeaa0 LOG                  basesrc gstbasesrc.c:2299:gst_base_src_do_sync:<nvarguscamerasrc0> no timestamp offset needed
[gscam_main-1] 0:00:02.795128270  9581   0x55ae0aeaa0 LOG                  basesrc gstbasesrc.c:2314:gst_base_src_do_sync:<nvarguscamerasrc0> created DTS 0:00:00.430438294
[gscam_main-1] 0:00:02.795143739  9581   0x55ae0aeaa0 LOG                  basesrc gstbasesrc.c:2336:gst_base_src_do_sync:<nvarguscamerasrc0> created PTS 0:00:00.430438294
[gscam_main-1] 0:00:02.795154572  9581   0x55ae0aeaa0 DEBUG                basesrc gstbasesrc.c:2375:gst_base_src_do_sync:<nvarguscamerasrc0> no sync needed
[gscam_main-1] 0:00:02.795166396  9581   0x55ae0aeaa0 DEBUG                basesrc gstbasesrc.c:2612:gst_base_src_get_range:<nvarguscamerasrc0> buffer ok
[gscam_main-1] 0:00:02.795201709  9581   0x55ae0aeaa0 INFO               GST_EVENT gstevent.c:900:gst_event_new_segment: creating segment event time segment start=0:00:00.000000000, offset=0:00:00.000000000, stop=99:99:99.999999999, rate=1.000000, applied_rate=1.000000, flags=0x00, time=0:00:00.000000000, base=0:00:00.000000000, position 0:00:00.000000000, duration 99:99:99.999999999
[gscam_main-1] 0:00:02.795227803  9581   0x55ae0aeaa0 DEBUG              GST_EVENT gstevent.c:308:gst_event_new_custom: creating new event 0x55ae3fe5f0 segment 17934
[gscam_main-1] 0:00:02.795251866  9581   0x55ae0aeaa0 LOG                 GST_PADS gstpad.c:5224:store_sticky_event:<nvarguscamerasrc0:src> stored sticky event segment
[gscam_main-1] 0:00:02.795265408  9581   0x55ae0aeaa0 DEBUG               GST_PADS gstpad.c:3985:check_sticky:<nvarguscamerasrc0:src> pushing all sticky events
[gscam_main-1] 0:00:02.795280616  9581   0x55ae0aeaa0 DEBUG               GST_PADS gstpad.c:3914:push_sticky:<nvarguscamerasrc0:src> event stream-start was already received
[gscam_main-1] 0:00:02.795295929  9581   0x55ae0aeaa0 DEBUG               GST_PADS gstpad.c:3914:push_sticky:<nvarguscamerasrc0:src> event caps was already received
[gscam_main-1] 0:00:02.795313429  9581   0x55ae0aeaa0 DEBUG               GST_PADS gstpad.c:5464:gst_pad_push_event_unchecked:<nvarguscamerasrc0:src> Dropping event segment because pad is not linked
[gscam_main-1] 0:00:02.795326554  9581   0x55ae0aeaa0 DEBUG               GST_PADS gstpad.c:3956:push_sticky:<nvarguscamerasrc0:src> pad was not linked, mark pending
[gscam_main-1] 0:00:02.795339680  9581   0x55ae0aeaa0 INFO                 basesrc gstbasesrc.c:2962:gst_base_src_loop:<nvarguscamerasrc0> marking pending DISCONT
[gscam_main-1] 0:00:02.795359680  9581   0x55ae0aeaa0 DEBUG               GST_PADS gstpad.c:3985:check_sticky:<nvarguscamerasrc0:src> pushing all sticky events
[gscam_main-1] 0:00:02.795373743  9581   0x55ae0aeaa0 DEBUG               GST_PADS gstpad.c:3914:push_sticky:<nvarguscamerasrc0:src> event stream-start was already received
[gscam_main-1] 0:00:02.795387753  9581   0x55ae0aeaa0 DEBUG               GST_PADS gstpad.c:3914:push_sticky:<nvarguscamerasrc0:src> event caps was already received
[gscam_main-1] 0:00:02.795401764  9581   0x55ae0aeaa0 DEBUG               GST_PADS gstpad.c:3914:push_sticky:<nvarguscamerasrc0:src> event segment was already received
[gscam_main-1] 0:00:02.795415462  9581   0x55ae0aeaa0 LOG           GST_SCHEDULING gstpad.c:4661:gst_pad_push_data:<nvarguscamerasrc0:src> pushing, but it was not linked
[gscam_main-1] 0:00:02.795447390  9581   0x55ae0aeaa0 LOG               GST_BUFFER gstbuffer.c:750:_gst_buffer_dispose: release 0x55ae4106c0 to pool 0x55ae410630
[gscam_main-1] 0:00:02.795471609  9581   0x55ae0aeaa0 LOG               GST_BUFFER gstbuffer.c:1653:gst_buffer_resize_range: trim 0x55ae4106c0 0-1008 size:1008 offs:0 max:1008
[gscam_main-1] 0:00:02.795487807  9581   0x55ae0aeaa0 LOG               bufferpool gstbufferpool.c:1285:default_release_buffer:<bufferpool0> released buffer 0x55ae4106c0 0
[gscam_main-1] 0:00:02.795501766  9581   0x55ae0aeaa0 DEBUG             GST_BUFFER gstbuffer.c:1448:gst_buffer_is_memory_range_writable: idx 0, length -1
[gscam_main-1] 0:00:02.795519787  9581   0x55ae0aeaa0 INFO                 basesrc gstbasesrc.c:2981:gst_base_src_loop:<nvarguscamerasrc0> pausing after gst_pad_push() = not-linked
[gscam_main-1] 0:00:02.795532964  9581   0x55ae0aeaa0 DEBUG                basesrc gstbasesrc.c:3025:gst_base_src_loop:<nvarguscamerasrc0> pausing task, reason not-linked
[gscam_main-1] 0:00:02.795544996  9581   0x55ae0aeaa0 DEBUG               GST_PADS gstpad.c:6206:gst_pad_pause_task:<nvarguscamerasrc0:src> pause task
[gscam_main-1] 0:00:02.795562496  9581   0x55ae0aeaa0 DEBUG                   task gsttask.c:684:gst_task_set_state:<nvarguscamerasrc0:src> Changing task 0x55ae410050 to state 2
[gscam_main-1] 0:00:02.795588851  9581   0x55ae0aeaa0 DEBUG              GST_EVENT gstevent.c:308:gst_event_new_custom: creating new event 0x55ae3fe660 eos 28174
[gscam_main-1] 0:00:02.795614736  9581   0x55ae0aeaa0 WARN                 basesrc gstbasesrc.c:3072:gst_base_src_loop:<nvarguscamerasrc0> error: Internal data stream error.
[gscam_main-1] 0:00:02.795628799  9581   0x55ae0aeaa0 WARN                 basesrc gstbasesrc.c:3072:gst_base_src_loop:<nvarguscamerasrc0> error: streaming stopped, reason not-linked (-1)
[gscam_main-1] 0:00:02.795661716  9581   0x55ae0aeaa0 DEBUG            GST_MESSAGE gstelement.c:2110:gst_element_message_full_with_details:<nvarguscamerasrc0> start
[gscam_main-1] 0:00:02.795696769  9581   0x55ae0aeaa0 INFO        GST_ERROR_SYSTEM gstelement.c:2140:gst_element_message_full_with_details:<nvarguscamerasrc0> posting message: Internal data stream error.
[gscam_main-1] 0:00:02.795749426  9581   0x55ae0aeaa0 LOG              GST_MESSAGE gstmessage.c:303:gst_message_new_custom: source nvarguscamerasrc0: creating new message 0x55ae411710 error
[gscam_main-1] 0:00:02.795890991  9581   0x55ae0aeaa0 WARN               structure gststructure.c:1861:priv_gst_structure_append_to_gstring: No value transform to serialize field 'gerror' of type 'GError'
[gscam_main-1] 0:00:02.795931356  9581   0x55ae0aeaa0 DEBUG                GST_BUS gstbus.c:315:gst_bus_post:<bus0> [msg 0x55ae411710] posting on bus error message: 0x55ae411710, time 99:99:99.999999999, seq-num 38, element 'nvarguscamerasrc0', GstMessageError, gerror=(GError)NULL, debug=(string)"gstbasesrc.c\(3072\):\ gst_base_src_loop\ \(\):\ /GstPipeline:pipeline0/GstNvArgusCameraSrc:nvarguscamerasrc0:\012streaming\ stopped\,\ reason\ not-linked\ \(-1\)", details=(structure)"details\,\ flow-return\=\(int\)-1\;";
[gscam_main-1] 0:00:02.795952815  9581   0x55ae0aeaa0 DEBUG                    bin gstbin.c:3718:gst_bin_handle_message_func:<pipeline0> [msg 0x55ae411710] handling child nvarguscamerasrc0 message of type error
[gscam_main-1] 0:00:02.795966669  9581   0x55ae0aeaa0 DEBUG                    bin gstbin.c:3727:gst_bin_handle_message_func:<pipeline0> got ERROR message, unlocking state change
[gscam_main-1] 0:00:02.795980888  9581   0x55ae0aeaa0 DEBUG                    bin gstbin.c:4065:gst_bin_handle_message_func:<pipeline0> posting message upward
[gscam_main-1] 0:00:02.796014691  9581   0x55ae0aeaa0 WARN               structure gststructure.c:1861:priv_gst_structure_append_to_gstring: No value transform to serialize field 'gerror' of type 'GError'
[gscam_main-1] 0:00:02.796045577  9581   0x55ae0aeaa0 DEBUG                GST_BUS gstbus.c:315:gst_bus_post:<bus1> [msg 0x55ae411710] posting on bus error message: 0x55ae411710, time 99:99:99.999999999, seq-num 38, element 'nvarguscamerasrc0', GstMessageError, gerror=(GError)NULL, debug=(string)"gstbasesrc.c\(3072\):\ gst_base_src_loop\ \(\):\ /GstPipeline:pipeline0/GstNvArgusCameraSrc:nvarguscamerasrc0:\012streaming\ stopped\,\ reason\ not-linked\ \(-1\)", details=(structure)"details\,\ flow-return\=\(int\)-1\;";
[gscam_main-1] 0:00:02.796061671  9581   0x55ae0aeaa0 DEBUG                GST_BUS gstbus.c:355:gst_bus_post:<bus1> [msg 0x55ae411710] pushing on async queue
[gscam_main-1] 0:00:02.796076723  9581   0x55ae0aeaa0 DEBUG                GST_BUS gstbus.c:358:gst_bus_post:<bus1> [msg 0x55ae411710] pushed on async queue
[gscam_main-1] 0:00:02.796091880  9581   0x55ae0aeaa0 DEBUG                GST_BUS gstbus.c:351:gst_bus_post:<bus0> [msg 0x55ae411710] dropped
[gscam_main-1] 0:00:02.796107974  9581   0x55ae0aeaa0 INFO        GST_ERROR_SYSTEM gstelement.c:2167:gst_element_message_full_with_details:<nvarguscamerasrc0> posted error message: Internal data stream error.
[gscam_main-1] 0:00:02.796126828  9581   0x55ae0aeaa0 LOG                 GST_PADS gstpad.c:5224:store_sticky_event:<nvarguscamerasrc0:src> stored sticky event eos
[gscam_main-1] 0:00:02.796145006  9581   0x55ae0aeaa0 DEBUG               GST_PADS gstpad.c:3985:check_sticky:<nvarguscamerasrc0:src> pushing all sticky events
[gscam_main-1] 0:00:02.796160110  9581   0x55ae0aeaa0 DEBUG               GST_PADS gstpad.c:3914:push_sticky:<nvarguscamerasrc0:src> event stream-start was already received
[gscam_main-1] 0:00:02.796174537  9581   0x55ae0aeaa0 DEBUG               GST_PADS gstpad.c:3914:push_sticky:<nvarguscamerasrc0:src> event caps was already received
[gscam_main-1] 0:00:02.796188392  9581   0x55ae0aeaa0 DEBUG               GST_PADS gstpad.c:3914:push_sticky:<nvarguscamerasrc0:src> event segment was already received
[gscam_main-1] 0:00:02.796203548  9581   0x55ae0aeaa0 DEBUG               GST_PADS gstpad.c:5464:gst_pad_push_event_unchecked:<nvarguscamerasrc0:src> Dropping event eos because pad is not linked
[gscam_main-1] 0:00:02.796216153  9581   0x55ae0aeaa0 DEBUG               GST_PADS gstpad.c:3956:push_sticky:<nvarguscamerasrc0:src> pad was not linked, mark pending
[gscam_main-1] 0:00:02.796242247  9581   0x55ae0aeaa0 INFO                    task gsttask.c:312:gst_task_func:<nvarguscamerasrc0:src> Task going to paused
[gscam_main-1] 0:00:02.822668577  9581   0x55ae411d80 LOG               bufferpool gstbufferpool.c:1123:default_acquire_buffer:<bufferpool0> acquired buffer 0x55ae4107e0
[gscam_main-1] 0:00:02.822709359  9581   0x55ae411d80 DEBUG        GST_PERFORMANCE gstminiobject.c:527:ensure_priv_data: allocating private data GstBuffer miniobject 0x55ae4107e0
[gscam_main-1] 0:00:02.855596372  9581   0x55ae411d80 LOG               bufferpool gstbufferpool.c:1123:default_acquire_buffer:<bufferpool0> acquired buffer 0x55ae410900
[gscam_main-1] 0:00:02.855640226  9581   0x55ae411d80 DEBUG        GST_PERFORMANCE gstminiobject.c:527:ensure_priv_data: allocating private data GstBuffer miniobject 0x55ae410900
[gscam_main-1] 0:00:02.890172214  9581   0x55ae411d80 LOG               bufferpool gstbufferpool.c:1123:default_acquire_buffer:<bufferpool0> acquired buffer 0x55ae410a20
[gscam_main-1] 0:00:02.890382895  9581   0x55ae411d80 DEBUG        GST_PERFORMANCE gstminiobject.c:527:ensure_priv_data: allocating private data GstBuffer miniobject 0x55ae410a20
[gscam_main-1] 0:00:02.922177597  9581   0x55ae411d80 LOG               bufferpool gstbufferpool.c:1123:default_acquire_buffer:<bufferpool0> acquired buffer 0x55ae410b40
[gscam_main-1] 0:00:02.922217650  9581   0x55ae411d80 DEBUG        GST_PERFORMANCE gstminiobject.c:527:ensure_priv_data: allocating private data GstBuffer miniobject 0x55ae410b40
[gscam_main-1] 0:00:02.956419528  9581   0x55ae411d80 LOG               bufferpool gstbufferpool.c:1123:default_acquire_buffer:<bufferpool0> acquired buffer 0x55ae410c60
[gscam_main-1] 0:00:02.956459477  9581   0x55ae411d80 DEBUG        GST_PERFORMANCE gstminiobject.c:527:ensure_priv_data: allocating private data GstBuffer miniobject 0x55ae410c60
[gscam_main-1] 0:00:02.990251973  9581   0x55ae411d80 LOG               bufferpool gstbufferpool.c:1123:default_acquire_buffer:<bufferpool0> acquired buffer 0x55ae4106c0
[gscam_main-1] 0:00:02.990294213  9581   0x55ae411d80 DEBUG        GST_PERFORMANCE gstminiobject.c:527:ensure_priv_data: allocating private data GstBuffer miniobject 0x55ae4106c0
[gscam_main-1] 0:00:03.020528785  9581   0x55ae411d80 LOG               bufferpool gstbufferpool.c:1128:default_acquire_buffer:<bufferpool0> no buffer, trying to allocate
[gscam_main-1] 0:00:03.020834832  9581   0x55ae411d80 DEBUG             GST_MEMORY gstmemory.c:138:gst_memory_init: new memory 0x7f5400b440, maxsize:1008 offset:0 size:1008
[gscam_main-1] 0:00:03.020886082  9581   0x55ae411d80 LOG               GST_BUFFER gstbuffer.c:841:gst_buffer_new: new 0x7f5400e120
[gscam_main-1] 0:00:03.020903895  9581   0x55ae411d80 LOG               GST_BUFFER gstbuffer.c:447:_memory_add: buffer 0x7f5400e120, idx -1, mem 0x7f5400b440
[gscam_main-1] 0:00:03.020920927  9581   0x55ae411d80 LOG               GST_BUFFER gstbuffer.c:895:gst_buffer_new_allocate: new buffer 0x7f5400e120 of size 1008 from allocator 0x55ae1d6df0
[gscam_main-1] 0:00:03.020972907  9581   0x55ae411d80 LOG               bufferpool gstbufferpool.c:286:do_alloc_buffer:<bufferpool0> allocated buffer 6/8, 0x7f5400e120
[gscam_main-1] 0:00:03.020995199  9581   0x55ae411d80 DEBUG        GST_PERFORMANCE gstminiobject.c:527:ensure_priv_data: allocating private data GstBuffer miniobject 0x7f5400e120
[gscam_main-1] 0:00:03.053820960  9581   0x55ae411d80 LOG               bufferpool gstbufferpool.c:1128:default_acquire_buffer:<bufferpool0> no buffer, trying to allocate
[gscam_main-1] 0:00:03.054034089  9581   0x55ae411d80 DEBUG             GST_MEMORY gstmemory.c:138:gst_memory_init: new memory 0x7f5400b4d0, maxsize:1008 offset:0 size:1008
[gscam_main-1] 0:00:03.054055443  9581   0x55ae411d80 LOG               GST_BUFFER gstbuffer.c:841:gst_buffer_new: new 0x7f5400e240
[gscam_main-1] 0:00:03.054072110  9581   0x55ae411d80 LOG               GST_BUFFER gstbuffer.c:447:_memory_add: buffer 0x7f5400e240, idx -1, mem 0x7f5400b4d0
[gscam_main-1] 0:00:03.054087892  9581   0x55ae411d80 LOG               GST_BUFFER gstbuffer.c:895:gst_buffer_new_allocate: new buffer 0x7f5400e240 of size 1008 from allocator 0x55ae1d6df0
[gscam_main-1] 0:00:03.054105340  9581   0x55ae411d80 LOG               bufferpool gstbufferpool.c:286:do_alloc_buffer:<bufferpool0> allocated buffer 7/8, 0x7f5400e240
[gscam_main-1] 0:00:03.054123621  9581   0x55ae411d80 DEBUG        GST_PERFORMANCE gstminiobject.c:527:ensure_priv_data: allocating private data GstBuffer miniobject 0x7f5400e240
[gscam_main-1] 0:00:03.086744587  9581   0x55ae411d80 LOG               bufferpool gstbufferpool.c:1128:default_acquire_buffer:<bufferpool0> no buffer, trying to allocate
[gscam_main-1] 0:00:03.086778911  9581   0x55ae411d80 DEBUG             bufferpool gstbufferpool.c:299:do_alloc_buffer:<bufferpool0> max buffers reached
[gscam_main-1] 0:00:03.086797401  9581   0x55ae411d80 LOG                 GST_POLL gstpoll.c:314:release_wakeup: 0x55ae264ed0: release
[gscam_main-1] 0:00:03.086829589  9581   0x55ae411d80 LOG               bufferpool gstbufferpool.c:1168:default_acquire_buffer:<bufferpool0> waiting for free buffers or flushing
[gscam_main-1] 0:00:03.086850579  9581   0x55ae411d80 DEBUG               GST_POLL gstpoll.c:1414:gst_poll_wait: 0x55ae264ed0: timeout :99:99:99.999999999



carTloyal123 avatar Jul 25 '22 19:07 carTloyal123

Hi, I'm sorry for the long radio silence. If this is still relevant, I can help debug. First step is to try to get it working w/o gscam2, just using gst-launch-1.0. Perhaps something like:

export GST_DEBUG=4
gst-launch-1.0 -v nvarguscamersrc ! video/x-raw(memory:NVMM), width=1280, height=720, framerate=30/1 ! nvvidconv flip-method=0 ! videoconvert ! autovideosink

If this works, next step is to see if we can impose caps that gscam2 can handle.

clydemcqueen avatar Nov 22 '22 23:11 clydemcqueen

Hi @clydemcqueen thank you for getting back to me! This was for a project a little ways back and honestly I can't remember how I solved the issue. I think we used gscam2 and I crafted a pipeline that matched our requirements. If I remember correctly, I did not have an app sink in my pipeline which upon further research was an obvious flaw. Happy to close the issue, thank you!

carTloyal123 avatar Dec 02 '22 04:12 carTloyal123