gscam2
gscam2 copied to clipboard
Pipeline Launches but No Data Published
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.
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
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!
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
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.
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!