Other Parts Discussed in Thread: AM4378,
Hello,
Continuing from the other thread (https://e2e.ti.com/support/processors-group/processors/f/processors-forum/1011387/am5728-ov2640-interfacing)
The basic problem is that on AM4378, OV2640 allows selection of resolution from the list of allowed resolutions in the driver, but in AM5728, it only works at 128x128.
I've modified the driver to only support 800x600 to see if that helps...it doesn't. VIP always calls OV2640 set_fmt function with size requested 0x0, not as per gstreamer command. Then OV2640 driver returns 800x600 as the default resolution and VIP driver prints that (see VIP debug=3 logs below), yet the output video is 128x128.
Logs and debug data below -
1) Querying supported formats does not display list of resolutions
root@am57xx-evm:~# v4l2-ctl -d 1 --list-formats-ext
ioctl: VIDIOC_ENUM_FMT
Index : 0
Type : Video Capture
Pixel Format: 'NV12'
Name : Y/CbCr 4:2:0
Index : 1
Type : Video Capture
Pixel Format: 'UYVY'
Name : UYVY 4:2:2
Index : 2
Type : Video Capture
Pixel Format: 'YUYV'
Name : YUYV 4:2:2
Index : 3
Type : Video Capture
Pixel Format: 'VYUY'
Name : VYUY 4:2:2
Index : 4
Type : Video Capture
Pixel Format: 'YVYU'
Name : YVYU 4:2:2
Index : 5
Type : Video Capture
Pixel Format: 'RGB3'
Name : 24-bit RGB 8-8-8
Index : 6
Type : Video Capture
Pixel Format: 'RGB4'
Name : 32-bit A/XRGB 8-8-8-8
Index : 7
Type : Video Capture
Pixel Format: 'BGR3'
Name : 24-bit BGR 8-8-8
Index : 8
Type : Video Capture
Pixel Format: 'BGR4'
Name : 32-bit BGRA/X 8-8-8-8
2) VIP debug=3 logs (always gets 800x600 after set_fmt)
[ 0.000000] CPU: PIPT / VIPT nonaliasing data cache, PIPT instruction cache [ 11.873278] vin1: vip_set_slice_path: [ 11.873289] vin1: vip_set_slice_path: DATA_PATH_SELECT(0000010C): 80008000 [ 11.873678] vin2: vip_set_slice_path: [ 11.873684] vin2: vip_set_slice_path: DATA_PATH_SELECT(00000110): 80008000 [ 11.873717] vip 48970000.vip: loading firmware vpdma-1b8.bin [ 11.886309] vin3: vip_set_slice_path: [ 11.886367] vin3: vip_set_slice_path: DATA_PATH_SELECT(0000010C): 80008000 [ 11.898165] vin4: vip_set_slice_path: [ 11.898170] vin4: vip_set_slice_path: DATA_PATH_SELECT(00000110): 80008000 [ 11.898210] vip 48990000.vip: loading firmware vpdma-1b8.bin [ 11.900830] vip 48970000.vip: VPDMA firmware loaded [ 11.920870] vip 48990000.vip: VPDMA firmware loaded [ 11.921016] vin3a: vip_async_bound [ 11.921298] vin3a: vip_async_complete [ 14.140178] vin3a-0: vip_open [ 14.140193] vin3a: vip_init_port: g_mbus_fmt subdev mbus_code: 2006 fourcc:NV12 size: 800x600 [ 14.140212] vin3a-0: vip_init_stream: stream instance 0x600f0013ee1ce000 [ 14.141208] vin3a-0: vip_release [ 14.141215] vin3a-0: vip_release_stream: stream instance 0x00000010ee1ce000 [ 14.141219] vin3a: vip_release_port: port instance 0xee0d96c0eebdb410 [ 87.271293] vin3a-0: vip_open [ 87.271313] vin3a: vip_init_port: g_mbus_fmt subdev mbus_code: 2006 fourcc:NV12 size: 800x600 [ 87.271342] vin3a-0: vip_init_stream: stream instance 0xffffe000ee1ce000 [ 87.272220] vin3a-0: vip_release [ 87.272230] vin3a-0: vip_release_stream: stream instance 0x00000008ee1ce000 [ 87.272236] vin3a: vip_release_port: port instance 0xee07cf00eebdb410 [ 161.175020] vin3a-0: vip_open [ 161.175040] vin3a: vip_init_port: g_mbus_fmt subdev mbus_code: 2006 fourcc:NV12 size: 800x600 [ 161.175070] vin3a-0: vip_init_stream: stream instance 0xffffe000ee1ce000 [ 161.175344] vin3a-0: vip_release [ 161.175353] vin3a-0: vip_release_stream: stream instance 0x00000008ee1ce000 [ 161.175359] vin3a: vip_release_port: port instance 0xee9fc0c0eebdb410 [ 161.526633] vin3a-0: vip_open [ 161.526653] vin3a: vip_init_port: g_mbus_fmt subdev mbus_code: 2006 fourcc:NV12 size: 800x600 [ 161.526682] vin3a-0: vip_init_stream: stream instance 0xffffe000ee1ce000 [ 161.526954] vin3a-0: vip_release [ 161.526963] vin3a-0: vip_release_stream: stream instance 0x00000008ee1ce000 [ 161.526969] vin3a: vip_release_port: port instance 0xee9fcb40eebdb410 [ 161.552381] vin3a-0: vip_open [ 161.552401] vin3a: vip_init_port: g_mbus_fmt subdev mbus_code: 2006 fourcc:NV12 size: 800x600 [ 161.552512] vin3a-0: vip_init_stream: stream instance 0xffffe000ee1ce000 [ 161.575023] vin3: vip_set_slice_path: [ 161.575030] vin3: vip_set_slice_path: DATA_PATH_SELECT(0000010C): 20008010 [ 161.575033] vin3: vip_set_slice_path: [ 161.575038] vin3: vip_set_slice_path: DATA_PATH_SELECT(0000010C): 60008210 [ 161.575042] vin3: vip_set_slice_path: [ 161.575046] vin3: vip_set_slice_path: DATA_PATH_SELECT(0000010C): 90018210 [ 161.575049] vin3: vip_set_slice_path: [ 161.575054] vin3: vip_set_slice_path: DATA_PATH_SELECT(0000010C): 50018210 [ 161.647680] vin3a-0: vip_load_vpdma_list_fifo: start_dma vb2 buf idx:0 [ 161.648803] vin3a-0: vip_load_vpdma_list_fifo: start_dma vb2 buf idx:1 [ 170.604552] vin3a-0: vip_stop_streaming: [ 170.604564] vin3: vip_set_slice_path: [ 170.604572] vin3: vip_set_slice_path: DATA_PATH_SELECT(0000010C): 20018200 [ 170.604578] vin3: vip_set_slice_path: [ 170.604585] vin3: vip_set_slice_path: DATA_PATH_SELECT(0000010C): 60018000 [ 170.604590] vin3: vip_set_slice_path: [ 170.604597] vin3: vip_set_slice_path: DATA_PATH_SELECT(0000010C): 90008000 [ 170.604602] vin3: vip_set_slice_path: [ 170.604608] vin3: vip_set_slice_path: DATA_PATH_SELECT(0000010C): 50008000 [ 170.605266] vin3a-0: vip_release [ 170.605285] vin3a-0: vip_release_stream: stream instance 0x00000008ee1ce000 [ 170.605292] vin3a: vip_release_port: port instance 0xee8d70c0eebdb410 [ 208.614577] vin3a-0: vip_open [ 208.614594] vin3a: vip_init_port: g_mbus_fmt subdev mbus_code: 2006 fourcc:NV12 size: 800x600 [ 208.614619] vin3a-0: vip_init_stream: stream instance 0xffffe000ee1ce000 [ 208.614841] vin3a-0: vip_release [ 208.614849] vin3a-0: vip_release_stream: stream instance 0x00000008ee1ce000 [ 208.614854] vin3a: vip_release_port: port instance 0xee9fd000eebdb410 [ 219.169843] vin3a-0: vip_open [ 219.169860] vin3a: vip_init_port: g_mbus_fmt subdev mbus_code: 2006 fourcc:NV12 size: 800x600 [ 219.169884] vin3a-0: vip_init_stream: stream instance 0xffffe000ee1ce000 [ 219.170100] vin3a-0: vip_release [ 219.170108] vin3a-0: vip_release_stream: stream instance 0x00000008ee1ce000 [ 219.170113] vin3a: vip_release_port: port instance 0xeea9a540eebdb410 [ 219.184393] vin3a-0: vip_open [ 219.184407] vin3a: vip_init_port: g_mbus_fmt subdev mbus_code: 2006 fourcc:NV12 size: 800x600 [ 219.184430] vin3a-0: vip_init_stream: stream instance 0xffffe000ee1ce000 [ 219.188519] vin3a-0: vip_release [ 219.188528] vin3a-0: vip_release_stream: stream instance 0x00000008ee1ce000 [ 219.188533] vin3a: vip_release_port: port instance 0xedd8da80eebdb410
3) GST_DEBUG=4 output for command `gst-launch-1.0 v4l2src device=/dev/video1 io-mode=4 ! waylandsink`
0:00:00.000673440 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_INIT gst.c:507:init_pre:[00m Initializing GStreamer Core Library version 1.12.2
0:00:00.000855138 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_INIT gst.c:508:init_pre:[00m Using library installed in /usr/lib
0:00:00.000906053 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_INIT gst.c:528:init_pre:[00m Linux am57xx-evm 4.14.79-ge669d52447 #24 SMP PREEMPT Thu Sep 30 11:36:34 IST 2021 armv7l
0:00:00.002709538 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_INIT gstmessage.c:127:_priv_gst_message_initialize:[00m init messages
0:00:00.005030629 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_INIT gstcontext.c:84:_priv_gst_context_initialize:[00m init contexts
0:00:00.005595245 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;36m GST_PLUGIN_LOADING gstplugin.c:317:_priv_gst_plugin_initialize:[00m registering 0 static plugins
0:00:00.005961245 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;36m GST_PLUGIN_LOADING gstplugin.c:225:gst_plugin_register_static:[00m registered static plugin "staticelements"
0:00:00.006005165 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;36m GST_PLUGIN_LOADING gstplugin.c:227:gst_plugin_register_static:[00m added static plugin "staticelements", result: 1
0:00:00.006097560 [334m 1143[00m 0x2f000 [36mINFO [00m [00m GST_REGISTRY gstregistry.c:1721:ensure_current_registry:[00m reading registry cache: /home/root/.cache/gstreamer-1.0/registry.arm.bin
0:00:00.058924048 [334m 1143[00m 0x2f000 [36mINFO [00m [00m GST_REGISTRY gstregistrybinary.c:621:priv_gst_registry_binary_read_cache:[00m loaded /home/root/.cache/gstreamer-1.0/registry.arm.bin in 0.052717 seconds
0:00:00.059099240 [334m 1143[00m 0x2f000 [36mINFO [00m [00m GST_REGISTRY gstregistry.c:1577:scan_and_update_registry:[00m Validating plugins from registry cache: /home/root/.cache/gstreamer-1.0/registry.arm.bin
0:00:00.061559085 [334m 1143[00m 0x2f000 [36mINFO [00m [00m GST_REGISTRY gstregistry.c:1679:scan_and_update_registry:[00m Registry cache has not changed
0:00:00.061601866 [334m 1143[00m 0x2f000 [36mINFO [00m [00m GST_REGISTRY gstregistry.c:1756:ensure_current_registry:[00m registry reading and updating done, result = 1
0:00:00.061629357 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_INIT gst.c:727:init_post:[00m GLib runtime version: 2.52.3
0:00:00.061658800 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_INIT gst.c:729:init_post:[00m GLib headers version: 2.52.3
0:00:00.061686941 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_INIT gst.c:730:init_post:[00m initialized GStreamer successfully
0:00:00.061777058 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;37;41m GST_PIPELINE gstparse.c:334:gst_parse_launch_full:[00m parsing pipeline description 'v4l2src device=/dev/video1 io-mode=4 ! waylandsink '
0:00:00.080035904 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;36m GST_PLUGIN_LOADING gstplugin.c:843:_priv_gst_plugin_load_file_for_registry:[00m plugin "/usr/lib/gstreamer-1.0/libgstvideo4linux2.so" loaded
0:00:00.080105850 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:361:gst_element_factory_create:[00m creating element "v4l2src"
0:00:00.082607176 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;37;41m GST_ELEMENT_PADS gstelement.c:670:gst_element_add_pad:<GstBaseSrc@0x16a0a0>[00m adding pad 'src'
0:00:00.084690773 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;36m GST_PLUGIN_LOADING gstplugin.c:843:_priv_gst_plugin_load_file_for_registry:[00m plugin "/usr/lib/gstreamer-1.0/libgstwaylandsink.so" loaded
0:00:00.084737296 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:361:gst_element_factory_create:[00m creating element "waylandsink"
0:00:00.085158277 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;37;41m GST_ELEMENT_PADS gstelement.c:670:gst_element_add_pad:<GstBaseSink@0x1725d0>[00m adding pad 'sink'
0:00:00.085234730 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:361:gst_element_factory_create:[00m creating element "pipeline"
0:00:00.085443106 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;37;41m GST_PIPELINE grammar.y:652:gst_parse_perform_link:[00m linking some pad of GstV4l2Src named v4l2src0 to some pad of GstWaylandSink named waylandsink0 (0/0) with caps "(NULL)"
0:00:00.085493045 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;37;41m GST_ELEMENT_PADS gstutils.c:1709:gst_element_link_pads_full:[00m trying to link element v4l2src0:(any) to element waylandsink0:(any)
0:00:00.085531272 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31;41m GST_PADS gstutils.c:1009:gst_pad_check_link:[00m trying to link v4l2src0:src and waylandsink0:sink
0:00:00.085662869 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31;41m GST_PADS gstutils.c:1523:prepare_link_maybe_ghosting:[00m v4l2src0 and waylandsink0 in same bin, no need for ghost pads
0:00:00.085714597 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31;41m GST_PADS gstpad.c:2316:gst_pad_link_prepare:[00m trying to link v4l2src0:src and waylandsink0:sink
0:00:00.085828626 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31;41m GST_PADS gstpad.c:2524:gst_pad_link_full:[00m linked v4l2src0:src and waylandsink0:sink, successful
0:00:00.085861648 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;34m GST_EVENT gstevent.c:1512:gst_event_new_reconfigure:[00m creating reconfigure event
0:00:00.085889464 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;34m GST_EVENT gstpad.c:5655:gst_pad_send_event_unchecked:<v4l2src0:src>[00m Received event on flushing pad. Discarding
0:00:00.086083525 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2491:gst_bin_element_set_state:<waylandsink0>[00m current NULL pending VOID_PENDING, desired next READY
0:00:00.086825773 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2467:gst_element_continue_state:<waylandsink0>[00m completed state change to READY
0:00:00.086875874 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<waylandsink0>[00m notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:00.086937037 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2939:gst_bin_change_state_func:<pipeline0>[00m child 'waylandsink0' changed state to 2(READY) successfully
0:00:00.086985674 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2491:gst_bin_element_set_state:<v4l2src0>[00m current NULL pending VOID_PENDING, desired next READY
0:00:00.087266762 [334m 1143[00m 0x2f000 [36mINFO [00m [00m v4l2 v4l2_calls.c:592:gst_v4l2_open:<v4l2src0>[00m Opened device 'vip' (/dev/video1) successfully
0:00:00.087334594 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2467:gst_element_continue_state:<v4l2src0>[00m completed state change to READY
0:00:00.087365176 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<v4l2src0>[00m notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:00.087405680 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2939:gst_bin_change_state_func:<pipeline0>[00m child 'v4l2src0' changed state to 2(READY) successfully
0:00:00.087446997 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2442:gst_element_continue_state:<pipeline0>[00m committing state from NULL to READY, pending PAUSED, next PAUSED
0:00:00.087500514 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<pipeline0>[00m notifying about state-changed NULL to READY (PAUSED pending)
0:00:00.087590957 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2449:gst_element_continue_state:<pipeline0>[00m continue state change READY to PAUSED, final PAUSED
0:00:00.087647077 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2491:gst_bin_element_set_state:<waylandsink0>[00m current READY pending VOID_PENDING, desired next PAUSED
0:00:00.087700269 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2945:gst_bin_change_state_func:<pipeline0>[00m child 'waylandsink0' is changing state asynchronously to PAUSED
0:00:00.087735080 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2491:gst_bin_element_set_state:<v4l2src0>[00m current READY pending VOID_PENDING, desired next PAUSED
0:00:00.087783554 [334m 1143[00m 0x2f000 [36mINFO [00m [00m basesrc gstbasesrc.c:1331:gst_base_src_do_seek:<v4l2src0>[00m seeking: 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
0:00:00.087870418 [334m 1143[00m 0x2f000 [36mINFO [00m [00m task gsttask.c:457:gst_task_set_lock:[00m setting stream lock 0x16c084 on task 0x17c028
0:00:00.087903277 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31;41m GST_PADS gstpad.c:6001:gst_pad_start_task:<v4l2src0:src>[00m created task 0x17c028
0:00:00.088035362 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2467:gst_element_continue_state:<v4l2src0>[00m completed state change to PAUSED
0:00:00.088072450 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<v4l2src0>[00m notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:00.088118973 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2982:gst_bin_change_state_func:<pipeline0>[00m child 'v4l2src0' changed state to 3(PAUSED) successfully without preroll
0:00:00.088122226 [334m 1143[00m 0x167e90 [36mINFO [00m [00;01;37;41m GST_ELEMENT_PADS gstelement.c:915:gst_element_get_static_pad:[00m no such pad 'sink' in element "v4l2src0"
0:00:00.088171677 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2467:gst_element_continue_state:<pipeline0>[00m completed state change to PAUSED
0:00:00.088235930 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<pipeline0>[00m notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:00.088457482 [334m 1143[00m 0x167e90 [36mINFO [00m [00m v4l2 gstv4l2object.c:1146:gst_v4l2_object_fill_format_list:<v4l2src0>[00m got 9 format(s):
0:00:00.088505957 [334m 1143[00m 0x167e90 [36mINFO [00m [00m v4l2 gstv4l2object.c:1152:gst_v4l2_object_fill_format_list:<v4l2src0>[00m YUYV
0:00:00.088546949 [334m 1143[00m 0x167e90 [36mINFO [00m [00m v4l2 gstv4l2object.c:1152:gst_v4l2_object_fill_format_list:<v4l2src0>[00m UYVY
0:00:00.088583386 [334m 1143[00m 0x167e90 [36mINFO [00m [00m v4l2 gstv4l2object.c:1152:gst_v4l2_object_fill_format_list:<v4l2src0>[00m BGR4
0:00:00.088615594 [334m 1143[00m 0x167e90 [36mINFO [00m [00m v4l2 gstv4l2object.c:1152:gst_v4l2_object_fill_format_list:<v4l2src0>[00m RGB4
0:00:00.088646338 [334m 1143[00m 0x167e90 [36mINFO [00m [00m v4l2 gstv4l2object.c:1152:gst_v4l2_object_fill_format_list:<v4l2src0>[00m BGR3
0:00:00.088697741 [334m 1143[00m 0x167e90 [36mINFO [00m [00m v4l2 gstv4l2object.c:1152:gst_v4l2_object_fill_format_list:<v4l2src0>[00m RGB3
0:00:00.088727509 [334m 1143[00m 0x167e90 [36mINFO [00m [00m v4l2 gstv4l2object.c:1152:gst_v4l2_object_fill_format_list:<v4l2src0>[00m NV12
0:00:00.088755325 [334m 1143[00m 0x167e90 [36mINFO [00m [00m v4l2 gstv4l2object.c:1152:gst_v4l2_object_fill_format_list:<v4l2src0>[00m YVYU
0:00:00.088782490 [334m 1143[00m 0x167e90 [36mINFO [00m [00m v4l2 gstv4l2object.c:1152:gst_v4l2_object_fill_format_list:<v4l2src0>[00m VYUY
0:00:00.089159552 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;34m GST_EVENT gstevent.c:1383:gst_event_new_latency:[00m creating latency event 0:00:00.000000000
0:00:00.089232752 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01m bin gstbin.c:2768:gst_bin_do_latency_func:<pipeline0>[00m configured latency of 0:00:00.000000000
0:00:00.089291149 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2491:gst_bin_element_set_state:<waylandsink0>[00m current READY pending PAUSED, desired next PLAYING
0:00:00.089325797 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2945:gst_bin_change_state_func:<pipeline0>[00m child 'waylandsink0' is changing state asynchronously to PLAYING
0:00:00.089370042 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2467:gst_element_continue_state:<v4l2src0>[00m completed state change to PLAYING
0:00:00.089399322 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<v4l2src0>[00m notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:00.089439664 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2939:gst_bin_change_state_func:<pipeline0>[00m child 'v4l2src0' changed state to 4(PLAYING) successfully
0:00:00.090921882 [334m 1143[00m 0x167e90 [36mINFO [00m [00m v4l2 gstv4l2object.c:3970:gst_v4l2_object_get_caps:<v4l2src0>[00m probed caps: video/x-raw, format=(string)YUY2, framerate=(fraction)30000/1001, width=(int)128, height=(int)128, interlace-mode=(string)progressive, pixel-aspect-ratio=(fraction)1/1, colorimetry=(string){ bt601 }; video/x-raw, format=(string)UYVY, framerate=(fraction)30000/1001, width=(int)128, height=(int)128, interlace-mode=(string)progressive, pixel-aspect-ratio=(fraction)1/1, colorimetry=(string){ bt601 }; video/x-raw, format=(string)BGRx, framerate=(fraction)30000/1001, width=(int)128, height=(int)128, interlace-mode=(string)progressive, pixel-aspect-ratio=(fraction)1/1, colorimetry=(string){ sRGB }; video/x-raw, format=(string)xRGB, framerate=(fraction)30000/1001, width=(int)128, height=(int)128, interlace-mode=(string)progressive, pixel-aspect-ratio=(fraction)1/1, colorimetry=(string){ sRGB }; video/x-raw, format=(string)BGR, framerate=(fraction)30000/1001, width=(int)128, height=(int)128, interlace-mode=(string)progressive, pixel-aspect-ratio=(fraction)1/1, colorimetry=(string){ sRGB }; video/x-raw, format=(string)RGB, framerate=(fraction)30000/1001, width=(int)128, height=(int)128, interlace-mode=(string)progressive, pixel-aspect-ratio=(fraction)1/1, colorimetry=(string){ sRGB }; video/x-raw, format=(string)NV12, framerate=(fraction)30000/1001, width=(int)128, height=(int)128, interlace-mode=(string)progressive, pixel-aspect-ratio=(fraction)1/1, colorimetry=(string){ bt601 }; video/x-raw, format=(string)YVYU, framerate=(fraction)30000/1001, width=(int)128, height=(int)128, interlace-mode=(string)progressive, pixel-aspect-ratio=(fraction)1/1, colorimetry=(string){ bt601 }
0:00:00.108216928 [334m 1143[00m 0x167e90 [36mINFO [00m [00m v4l2 gstv4l2object.c:3507:gst_v4l2_object_set_format_full:<v4l2src0>[00m Set capture framerate to 30/1
0:00:00.108285898 [334m 1143[00m 0x167e90 [36mINFO [00m [00m v4l2 gstv4l2object.c:2870:gst_v4l2_object_setup_pool:<v4l2src0>[00m accessing buffers via mode 4
0:00:00.108745432 [334m 1143[00m 0x167e90 [36mINFO [00m [00m v4l2bufferpool gstv4l2bufferpool.c:557:gst_v4l2_buffer_pool_set_config:<v4l2src0:pool:src>[00m increasing minimum buffers to 2
0:00:00.108782682 [334m 1143[00m 0x167e90 [36mINFO [00m [00m v4l2bufferpool gstv4l2bufferpool.c:570:gst_v4l2_buffer_pool_set_config:<v4l2src0:pool:src>[00m reducing maximum buffers to 32
0:00:00.108835549 [334m 1143[00m 0x167e90 [36mINFO [00m [00;01;34m GST_EVENT gstevent.c:809:gst_event_new_caps:[00m creating caps event video/x-raw, format=(string)YUY2, width=(int)128, height=(int)128, framerate=(fraction)30000/1001, interlace-mode=(string)progressive, pixel-aspect-ratio=(fraction)1/1, colorimetry=(string)bt601
0:00:00.109405045 [334m 1143[00m 0x167e90 [36mINFO [00m [00m v4l2bufferpool gstv4l2bufferpool.c:570:gst_v4l2_buffer_pool_set_config:<v4l2src0:pool:src>[00m reducing maximum buffers to 32
0:00:00.316097119 [334m 1143[00m 0x167e90 [32;01mFIXME [00m [00m v4l2bufferpool gstv4l2bufferpool.c:1257:gst_v4l2_buffer_pool_dqbuf:<v4l2src0:pool:src>[00m Unhandled enum v4l2_field 2 - treating as progressive
0:00:00.316196183 [334m 1143[00m 0x167e90 [36mINFO [00m [00m v4l2src gstv4l2src.c:825:gst_v4l2src_create:<v4l2src0>[00m sync to 0:00:00.033333333 out ts 0:00:00.226946535
0:00:00.316243356 [334m 1143[00m 0x167e90 [36mINFO [00m [00;01;34m GST_EVENT gstevent.c:890:gst_event_new_segment:[00m 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
0:00:00.316340631 [334m 1143[00m 0x167e90 [36mINFO [00m [00m basesrc gstbasesrc.c:2836:gst_base_src_loop:<v4l2src0>[00m marking pending DISCONT
0:00:00.317171044 [334m 1143[00m 0x167e90 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:3418:bin_handle_async_done:<pipeline0>[00m setting state from PAUSED to PAUSED, pending PLAYING
0:00:00.317240178 [334m 1143[00m 0x167e90 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:3438:bin_handle_async_done:<pipeline0>[00m continue state change, pending PLAYING
0:00:00.317684420 [334m 1143[00m 0xb5201e30 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:3235:gst_bin_continue_func:<pipeline0>[00m continue state change PAUSED to PLAYING, final PLAYING
0:00:00.317848226 [334m 1143[00m 0xb5201e30 [36mINFO [00m [00;01;34m GST_EVENT gstevent.c:1383:gst_event_new_latency:[00m creating latency event 0:00:00.033333333
0:00:00.317954772 [334m 1143[00m 0xb5201e30 [36mINFO [00m [00;01m bin gstbin.c:2768:gst_bin_do_latency_func:<pipeline0>[00m configured latency of 0:00:00.033333333
0:00:00.318081978 [334m 1143[00m 0xb5201e30 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2491:gst_bin_element_set_state:<waylandsink0>[00m current PAUSED pending VOID_PENDING, desired next PLAYING
0:00:00.318189663 [334m 1143[00m 0xb5201e30 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2467:gst_element_continue_state:<waylandsink0>[00m completed state change to PLAYING
0:00:00.318222847 [334m 1143[00m 0xb5201e30 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<waylandsink0>[00m notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:00.318392671 [334m 1143[00m 0xb5201e30 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2939:gst_bin_change_state_func:<pipeline0>[00m child 'waylandsink0' changed state to 4(PLAYING) successfully
0:00:00.318437730 [334m 1143[00m 0xb5201e30 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2491:gst_bin_element_set_state:<v4l2src0>[00m current PLAYING pending VOID_PENDING, desired next PLAYING
0:00:00.318545090 [334m 1143[00m 0xb5201e30 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2608:gst_bin_element_set_state:<v4l2src0>[00m skipping transition from PLAYING to PLAYING
0:00:00.318578924 [334m 1143[00m 0xb5201e30 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2939:gst_bin_change_state_func:<pipeline0>[00m child 'v4l2src0' changed state to 4(PLAYING) successfully
0:00:00.318619103 [334m 1143[00m 0xb5201e30 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2467:gst_element_continue_state:<pipeline0>[00m completed state change to PLAYING
0:00:00.318646268 [334m 1143[00m 0xb5201e30 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<pipeline0>[00m notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:00.384545951 [334m 1143[00m 0x167e90 [32;01mFIXME [00m [00m v4l2bufferpool gstv4l2bufferpool.c:1257:gst_v4l2_buffer_pool_dqbuf:<v4l2src0:pool:src>[00m Unhandled enum v4l2_field 2 - treating as progressive
0:00:00.384638996 [334m 1143[00m 0x167e90 [36mINFO [00m [00m v4l2src gstv4l2src.c:825:gst_v4l2src_create:<v4l2src0>[00m sync to 0:00:00.066666666 out ts 0:00:00.295391998
0:00:00.452976076 [334m 1143[00m 0x167e90 [32;01mFIXME [00m [00m v4l2bufferpool gstv4l2bufferpool.c:1257:gst_v4l2_buffer_pool_dqbuf:<v4l2src0:pool:src>[00m Unhandled enum v4l2_field 2 - treating as progressive
0:00:00.453055295 [334m 1143[00m 0x167e90 [36mINFO [00m [00m v4l2src gstv4l2src.c:825:gst_v4l2src_create:<v4l2src0>[00m sync to 0:00:00.099999999 out ts 0:00:00.363836674
0:00:00.521416124 [334m 1143[00m 0x167e90 [32;01mFIXME [00m [00m v4l2bufferpool gstv4l2bufferpool.c:1257:gst_v4l2_buffer_pool_dqbuf:<v4l2src0:pool:src>[00m Unhandled enum v4l2_field 2 - treating as progressive
0:00:00.521483468 [334m 1143[00m 0x167e90 [36mINFO [00m [00m v4l2src gstv4l2src.c:825:gst_v4l2src_create:<v4l2src0>[00m sync to 0:00:00.133333332 out ts 0:00:00.432283974
0:00:00.589874553 [334m 1143[00m 0x167e90 [32;01mFIXME [00m [00m v4l2bufferpool gstv4l2bufferpool.c:1257:gst_v4l2_buffer_pool_dqbuf:<v4l2src0:pool:src>[00m Unhandled enum v4l2_field 2 - treating as progressive
0:00:00.589938481 [334m 1143[00m 0x167e90 [36mINFO [00m [00m v4l2src gstv4l2src.c:825:gst_v4l2src_create:<v4l2src0>[00m sync to 0:00:00.166666665 out ts 0:00:00.500729975
0:00:00.658306630 [334m 1143[00m 0x167e90 [32;01mFIXME [00m [00m v4l2bufferpool gstv4l2bufferpool.c:1257:gst_v4l2_buffer_pool_dqbuf:<v4l2src0:pool:src>[00m Unhandled enum v4l2_field 2 - treating as progressive
0:00:00.658371046 [334m 1143[00m 0x167e90 [36mINFO [00m [00m v4l2src gstv4l2src.c:825:gst_v4l2src_create:<v4l2src0>[00m sync to 0:00:00.199999998 out ts 0:00:00.569175812
0:00:00.726751232 [334m 1143[00m 0x167e90 [32;01mFIXME [00m [00m v4l2bufferpool gstv4l2bufferpool.c:1257:gst_v4l2_buffer_pool_dqbuf:<v4l2src0:pool:src>[00m Unhandled enum v4l2_field 2 - treating as progressive
0:00:00.726814835 [334m 1143[00m 0x167e90 [36mINFO [00m [00m v4l2src gstv4l2src.c:825:gst_v4l2src_create:<v4l2src0>[00m sync to 0:00:00.233333331 out ts 0:00:00.637621812
0:00:00.795215030 [334m 1143[00m 0x167e90 [32;01mFIXME [00m [00m v4l2bufferpool gstv4l2bufferpool.c:1257:gst_v4l2_buffer_pool_dqbuf:<v4l2src0:pool:src>[00m Unhandled enum v4l2_field 2 - treating as progressive
0:00:00.795277494 [334m 1143[00m 0x167e90 [36mINFO [00m [00m v4l2src gstv4l2src.c:825:gst_v4l2src_create:<v4l2src0>[00m sync to 0:00:00.266666664 out ts 0:00:00.706068812
0:00:00.863644016 [334m 1143[00m 0x167e90 [32;01mFIXME [00m [00m v4l2bufferpool gstv4l2bufferpool.c:1257:gst_v4l2_buffer_pool_dqbuf:<v4l2src0:pool:src>[00m Unhandled enum v4l2_field 2 - treating as progressive
0:00:00.863710709 [334m 1143[00m 0x167e90 [36mINFO [00m [00m v4l2src gstv4l2src.c:825:gst_v4l2src_create:<v4l2src0>[00m sync to 0:00:00.299999997 out ts 0:00:00.774513650
0:00:00.932089920 [334m 1143[00m 0x167e90 [32;01mFIXME [00m [00m v4l2bufferpool gstv4l2bufferpool.c:1257:gst_v4l2_buffer_pool_dqbuf:<v4l2src0:pool:src>[00m Unhandled enum v4l2_field 2 - treating as progressive
0:00:00.932151408 [334m 1143[00m 0x167e90 [36mINFO [00m [00m v4l2src gstv4l2src.c:825:gst_v4l2src_create:<v4l2src0>[00m sync to 0:00:00.333333330 out ts 0:00:00.842960812
0:00:01.000532733 [334m 1143[00m 0x167e90 [32;01mFIXME [00m [00m v4l2bufferpool gstv4l2bufferpool.c:1257:gst_v4l2_buffer_pool_dqbuf:<v4l2src0:pool:src>[00m Unhandled enum v4l2_field 2 - treating as progressive
0:00:01.000593408 [334m 1143[00m 0x167e90 [36mINFO [00m [00m v4l2src gstv4l2src.c:825:gst_v4l2src_create:<v4l2src0>[00m sync to 0:00:00.366666663 out ts 0:00:00.911405974
0:00:01.068979287 [334m 1143[00m 0x167e90 [32;01mFIXME [00m [00m v4l2bufferpool gstv4l2bufferpool.c:1257:gst_v4l2_buffer_pool_dqbuf:<v4l2src0:pool:src>[00m Unhandled enum v4l2_field 2 - treating as progressive
0:00:01.069041751 [334m 1143[00m 0x167e90 [36mINFO [00m [00m v4l2src gstv4l2src.c:825:gst_v4l2src_create:<v4l2src0>[00m sync to 0:00:00.399999996 out ts 0:00:00.979851812
0:00:01.137444061 [334m 1143[00m 0x167e90 [32;01mFIXME [00m [00m v4l2bufferpool gstv4l2bufferpool.c:1257:gst_v4l2_buffer_pool_dqbuf:<v4l2src0:pool:src>[00m Unhandled enum v4l2_field 2 - treating as progressive
0:00:01.137504573 [334m 1143[00m 0x167e90 [36mINFO [00m [00m v4l2src gstv4l2src.c:825:gst_v4l2src_create:<v4l2src0>[00m sync to 0:00:00.433333329 out ts 0:00:01.048297812
0:00:01.205872071 [334m 1143[00m 0x167e90 [32;01mFIXME [00m [00m v4l2bufferpool gstv4l2bufferpool.c:1257:gst_v4l2_buffer_pool_dqbuf:<v4l2src0:pool:src>[00m Unhandled enum v4l2_field 2 - treating as progressive
0:00:01.205933559 [334m 1143[00m 0x167e90 [36mINFO [00m [00m v4l2src gstv4l2src.c:825:gst_v4l2src_create:<v4l2src0>[00m sync to 0:00:00.466666662 out ts 0:00:01.116743975
0:00:01.274320252 [334m 1143[00m 0x167e90 [32;01mFIXME [00m [00m v4l2bufferpool gstv4l2bufferpool.c:1257:gst_v4l2_buffer_pool_dqbuf:<v4l2src0:pool:src>[00m Unhandled enum v4l2_field 2 - treating as progressive
0:00:01.274384018 [334m 1143[00m 0x167e90 [36mINFO [00m [00m v4l2src gstv4l2src.c:825:gst_v4l2src_create:<v4l2src0>[00m sync to 0:00:00.499999995 out ts 0:00:01.185189812
0:00:01.342763716 [334m 1143[00m 0x167e90 [32;01mFIXME [00m [00m v4l2bufferpool gstv4l2bufferpool.c:1257:gst_v4l2_buffer_pool_dqbuf:<v4l2src0:pool:src>[00m Unhandled enum v4l2_field 2 - treating as progressive
0:00:01.342823415 [334m 1143[00m 0x167e90 [36mINFO [00m [00m v4l2src gstv4l2src.c:825:gst_v4l2src_create:<v4l2src0>[00m sync to 0:00:00.533333328 out ts 0:00:01.253635974
0:00:01.411211084 [334m 1143[00m 0x167e90 [32;01mFIXME [00m [00m v4l2bufferpool gstv4l2bufferpool.c:1257:gst_v4l2_buffer_pool_dqbuf:<v4l2src0:pool:src>[00m Unhandled enum v4l2_field 2 - treating as progressive
0:00:01.411270783 [334m 1143[00m 0x167e90 [36mINFO [00m [00m v4l2src gstv4l2src.c:825:gst_v4l2src_create:<v4l2src0>[00m sync to 0:00:00.566666661 out ts 0:00:01.322081812
0:00:01.479674230 [334m 1143[00m 0x167e90 [32;01mFIXME [00m [00m v4l2bufferpool gstv4l2bufferpool.c:1257:gst_v4l2_buffer_pool_dqbuf:<v4l2src0:pool:src>[00m Unhandled enum v4l2_field 2 - treating as progressive
0:00:01.479733766 [334m 1143[00m 0x167e90 [36mINFO [00m [00m v4l2src gstv4l2src.c:825:gst_v4l2src_create:<v4l2src0>[00m sync to 0:00:00.599999994 out ts 0:00:01.390527812
0:00:01.548121598 [334m 1143[00m 0x167e90 [32;01mFIXME [00m [00m v4l2bufferpool gstv4l2bufferpool.c:1257:gst_v4l2_buffer_pool_dqbuf:<v4l2src0:pool:src>[00m Unhandled enum v4l2_field 2 - treating as progressive
0:00:01.548182273 [334m 1143[00m 0x167e90 [36mINFO [00m [00m v4l2src gstv4l2src.c:825:gst_v4l2src_create:<v4l2src0>[00m sync to 0:00:00.633333327 out ts 0:00:01.458974812
0:00:01.616565387 [334m 1143[00m 0x167e90 [32;01mFIXME [00m [00m v4l2bufferpool gstv4l2bufferpool.c:1257:gst_v4l2_buffer_pool_dqbuf:<v4l2src0:pool:src>[00m Unhandled enum v4l2_field 2 - treating as progressive
0:00:01.616626875 [334m 1143[00m 0x167e90 [36mINFO [00m [00m v4l2src gstv4l2src.c:825:gst_v4l2src_create:<v4l2src0>[00m sync to 0:00:00.666666660 out ts 0:00:01.527419812
0:00:01.684996651 [334m 1143[00m 0x167e90 [32;01mFIXME [00m [00m v4l2bufferpool gstv4l2bufferpool.c:1257:gst_v4l2_buffer_pool_dqbuf:<v4l2src0:pool:src>[00m Unhandled enum v4l2_field 2 - treating as progressive
0:00:01.685057976 [334m 1143[00m 0x167e90 [36mINFO [00m [00m v4l2src gstv4l2src.c:825:gst_v4l2src_create:<v4l2src0>[00m sync to 0:00:00.699999993 out ts 0:00:01.595865812
0:00:01.753441091 [334m 1143[00m 0x167e90 [32;01mFIXME [00m [00m v4l2bufferpool gstv4l2bufferpool.c:1257:gst_v4l2_buffer_pool_dqbuf:<v4l2src0:pool:src>[00m Unhandled enum v4l2_field 2 - treating as progressive
0:00:01.753500464 [334m 1143[00m 0x167e90 [36mINFO [00m [00m v4l2src gstv4l2src.c:825:gst_v4l2src_create:<v4l2src0>[00m sync to 0:00:00.733333326 out ts 0:00:01.664311812
0:00:01.821904400 [334m 1143[00m 0x167e90 [32;01mFIXME [00m [00m v4l2bufferpool gstv4l2bufferpool.c:1257:gst_v4l2_buffer_pool_dqbuf:<v4l2src0:pool:src>[00m Unhandled enum v4l2_field 2 - treating as progressive
0:00:01.821963448 [334m 1143[00m 0x167e90 [36mINFO [00m [00m v4l2src gstv4l2src.c:825:gst_v4l2src_create:<v4l2src0>[00m sync to 0:00:00.766666659 out ts 0:00:01.732758650
0:00:01.890331597 [334m 1143[00m 0x167e90 [32;01mFIXME [00m [00m v4l2bufferpool gstv4l2bufferpool.c:1257:gst_v4l2_buffer_pool_dqbuf:<v4l2src0:pool:src>[00m Unhandled enum v4l2_field 2 - treating as progressive
0:00:01.890391621 [334m 1143[00m 0x167e90 [36mINFO [00m [00m v4l2src gstv4l2src.c:825:gst_v4l2src_create:<v4l2src0>[00m sync to 0:00:00.799999992 out ts 0:00:01.801203812
0:00:01.958794744 [334m 1143[00m 0x167e90 [32;01mFIXME [00m [00m v4l2bufferpool gstv4l2bufferpool.c:1257:gst_v4l2_buffer_pool_dqbuf:<v4l2src0:pool:src>[00m Unhandled enum v4l2_field 2 - treating as progressive
0:00:01.958854117 [334m 1143[00m 0x167e90 [36mINFO [00m [00m v4l2src gstv4l2src.c:825:gst_v4l2src_create:<v4l2src0>[00m sync to 0:00:00.833333325 out ts 0:00:01.869649974
0:00:02.027224869 [334m 1143[00m 0x167e90 [32;01mFIXME [00m [00m v4l2bufferpool gstv4l2bufferpool.c:1257:gst_v4l2_buffer_pool_dqbuf:<v4l2src0:pool:src>[00m Unhandled enum v4l2_field 2 - treating as progressive
0:00:02.027285218 [334m 1143[00m 0x167e90 [36mINFO [00m [00m v4l2src gstv4l2src.c:825:gst_v4l2src_create:<v4l2src0>[00m sync to 0:00:00.866666658 out ts 0:00:01.938095812
0:00:02.095675165 [334m 1143[00m 0x167e90 [32;01mFIXME [00m [00m v4l2bufferpool gstv4l2bufferpool.c:1257:gst_v4l2_buffer_pool_dqbuf:<v4l2src0:pool:src>[00m Unhandled enum v4l2_field 2 - treating as progressive
0:00:02.095735026 [334m 1143[00m 0x167e90 [36mINFO [00m [00m v4l2src gstv4l2src.c:825:gst_v4l2src_create:<v4l2src0>[00m sync to 0:00:00.899999991 out ts 0:00:02.006545812
0:00:02.164133594 [334m 1143[00m 0x167e90 [32;01mFIXME [00m [00m v4l2bufferpool gstv4l2bufferpool.c:1257:gst_v4l2_buffer_pool_dqbuf:<v4l2src0:pool:src>[00m Unhandled enum v4l2_field 2 - treating as progressive
0:00:02.164194756 [334m 1143[00m 0x167e90 [36mINFO [00m [00m v4l2src gstv4l2src.c:825:gst_v4l2src_create:<v4l2src0>[00m sync to 0:00:00.933333324 out ts 0:00:02.074987812
0:00:02.171933623 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2491:gst_bin_element_set_state:<waylandsink0>[00m current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:02.172073679 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2945:gst_bin_change_state_func:<pipeline0>[00m child 'waylandsink0' is changing state asynchronously to PAUSED
0:00:02.172131914 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2491:gst_bin_element_set_state:<v4l2src0>[00m current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:02.172194052 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2467:gst_element_continue_state:<v4l2src0>[00m completed state change to PAUSED
0:00:02.172237972 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<v4l2src0>[00m notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:02.172308570 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2982:gst_bin_change_state_func:<pipeline0>[00m child 'v4l2src0' changed state to 3(PAUSED) successfully without preroll
0:00:02.172368756 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2467:gst_element_continue_state:<pipeline0>[00m completed state change to PAUSED
0:00:02.172409423 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<pipeline0>[00m notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:02.172589983 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2491:gst_bin_element_set_state:<waylandsink0>[00m current PLAYING pending PAUSED, desired next READY
0:00:02.172830567 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2467:gst_element_continue_state:<waylandsink0>[00m completed state change to READY
0:00:02.172880018 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<waylandsink0>[00m notifying about state-changed PLAYING to READY (VOID_PENDING pending)
0:00:02.172939554 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2939:gst_bin_change_state_func:<pipeline0>[00m child 'waylandsink0' changed state to 2(READY) successfully
0:00:02.173029996 [334m 1143[00m 0x167e90 [36mINFO [00m [00m basesrc gstbasesrc.c:2849:gst_base_src_loop:<v4l2src0>[00m pausing after gst_pad_push() = flushing
0:00:02.173198844 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2467:gst_element_continue_state:<v4l2src0>[00m completed state change to READY
0:00:02.173245855 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<v4l2src0>[00m notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:02.173305716 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2939:gst_bin_change_state_func:<pipeline0>[00m child 'v4l2src0' changed state to 2(READY) successfully
0:00:02.173367204 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2467:gst_element_continue_state:<pipeline0>[00m completed state change to READY
0:00:02.173408034 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<pipeline0>[00m notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:02.173525316 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2080:gst_bin_get_state_func:<pipeline0>[00m getting state
0:00:02.173629260 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2491:gst_bin_element_set_state:<waylandsink0>[00m current READY pending VOID_PENDING, desired next NULL
0:00:02.174203636 [334m 1143[00m 0x2f000 [33;01mWARN [00m [00m v4l2allocator gstv4l2allocator.c:784:gst_v4l2_allocator_stop:<v4l2src0:pool:src:allocator>[00m error releasing buffers buffers: Device or resource busy
0:00:02.174671466 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2467:gst_element_continue_state:<waylandsink0>[00m completed state change to NULL
0:00:02.174733442 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<waylandsink0>[00m notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:02.174803551 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2939:gst_bin_change_state_func:<pipeline0>[00m child 'waylandsink0' changed state to 1(NULL) successfully
0:00:02.174863900 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2491:gst_bin_element_set_state:<v4l2src0>[00m current READY pending VOID_PENDING, desired next NULL
0:00:02.175217538 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2467:gst_element_continue_state:<v4l2src0>[00m completed state change to NULL
0:00:02.175270242 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<v4l2src0>[00m notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:02.175342303 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2939:gst_bin_change_state_func:<pipeline0>[00m child 'v4l2src0' changed state to 1(NULL) successfully
0:00:02.175502204 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2467:gst_element_continue_state:<pipeline0>[00m completed state change to NULL
0:00:02.175554583 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<pipeline0>[00m notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:02.175674956 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;37;41m GST_ELEMENT_PADS gstpad.c:2072:gst_pad_unlink:[00m unlinking v4l2src0:src(0x16c038) and waylandsink0:sink(0x16c188)
0:00:02.175758730 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;37;41m GST_ELEMENT_PADS gstpad.c:2126:gst_pad_unlink:[00m unlinked v4l2src0:src and waylandsink0:sink
0:00:02.175835508 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;37;41m GST_PARENTAGE gstbin.c:1792:gst_bin_remove_func:<pipeline0>[00m removed child "waylandsink0"
0:00:02.175910498 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31;44m GST_REFCOUNTING gstelement.c:3042:gst_element_dispose:<waylandsink0>[00m 0x1725d0 dispose
0:00:02.175956044 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;37;41m GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<waylandsink0>[00m removing pad 'sink'
0:00:02.176024527 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31;44m GST_REFCOUNTING gstelement.c:3088:gst_element_dispose:<waylandsink0>[00m 0x1725d0 parent class dispose
0:00:02.176076906 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31;44m GST_REFCOUNTING gstelement.c:3119:gst_element_finalize:<waylandsink0>[00m 0x1725d0 finalize
0:00:02.176119362 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31;44m GST_REFCOUNTING gstelement.c:3125:gst_element_finalize:<waylandsink0>[00m 0x1725d0 finalize parent
0:00:02.176183452 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;37;41m GST_PARENTAGE gstbin.c:1792:gst_bin_remove_func:<pipeline0>[00m removed child "v4l2src0"
0:00:02.176247706 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31;44m GST_REFCOUNTING gstelement.c:3042:gst_element_dispose:<v4l2src0>[00m 0x16a0a0 dispose
0:00:02.176291951 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;37;41m GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<v4l2src0>[00m removing pad 'src'
0:00:02.176346282 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31;44m GST_REFCOUNTING gstelement.c:3088:gst_element_dispose:<v4l2src0>[00m 0x16a0a0 parent class dispose
0:00:02.176427452 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31;44m GST_REFCOUNTING gstelement.c:3119:gst_element_finalize:<v4l2src0>[00m 0x16a0a0 finalize
0:00:02.176472348 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31;44m GST_REFCOUNTING gstelement.c:3125:gst_element_finalize:<v4l2src0>[00m 0x16a0a0 finalize parent
0:00:02.176517895 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31;44m GST_REFCOUNTING gstelement.c:3042:gst_element_dispose:<pipeline0>[00m 0x1750a0 dispose
0:00:02.176612892 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31;44m GST_REFCOUNTING gstelement.c:3088:gst_element_dispose:<pipeline0>[00m 0x1750a0 parent class dispose
0:00:02.176661855 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31;44m GST_REFCOUNTING gstelement.c:3119:gst_element_finalize:<pipeline0>[00m 0x1750a0 finalize
0:00:02.176703010 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31;44m GST_REFCOUNTING gstelement.c:3125:gst_element_finalize:<pipeline0>[00m 0x1750a0 finalize parent
0:00:02.176747255 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_INIT gst.c:998:gst_deinit:[00m deinitializing GStreamer
0:00:02.192144956 [334m 1143[00m 0x2f000 [36mINFO [00m [00;01;31m GST_INIT gst.c:1140:gst_deinit:[00m deinitialized GStreamer
4) GST_DEBUG=4 output for command `gst-launch-1.0 v4l2src device=/dev/video1 io-mode=4 ! video/x-raw,width=800,height=600 ! fakesink`
0:00:00.000573075 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_INIT gst.c:507:init_pre:[00m Initializing GStreamer Core Library version 1.12.2
0:00:00.000847331 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_INIT gst.c:508:init_pre:[00m Using library installed in /usr/lib
0:00:00.000899710 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_INIT gst.c:528:init_pre:[00m Linux am57xx-evm 4.14.79-ge669d52447 #24 SMP PREEMPT Thu Sep 30 11:36:34 IST 2021 armv7l
0:00:00.002303523 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_INIT gstmessage.c:127:_priv_gst_message_initialize:[00m init messages
0:00:00.004641206 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_INIT gstcontext.c:84:_priv_gst_context_initialize:[00m init contexts
0:00:00.005297403 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;36m GST_PLUGIN_LOADING gstplugin.c:317:_priv_gst_plugin_initialize:[00m registering 0 static plugins
0:00:00.005720499 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;36m GST_PLUGIN_LOADING gstplugin.c:225:gst_plugin_register_static:[00m registered static plugin "staticelements"
0:00:00.005771576 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;36m GST_PLUGIN_LOADING gstplugin.c:227:gst_plugin_register_static:[00m added static plugin "staticelements", result: 1
0:00:00.005886094 [334m 1131[00m 0x2f000 [36mINFO [00m [00m GST_REGISTRY gstregistry.c:1721:ensure_current_registry:[00m reading registry cache: /home/root/.cache/gstreamer-1.0/registry.arm.bin
0:00:00.062855539 [334m 1131[00m 0x2f000 [36mINFO [00m [00m GST_REGISTRY gstregistrybinary.c:621:priv_gst_registry_binary_read_cache:[00m loaded /home/root/.cache/gstreamer-1.0/registry.arm.bin in 0.056844 seconds
0:00:00.063033008 [334m 1131[00m 0x2f000 [36mINFO [00m [00m GST_REGISTRY gstregistry.c:1577:scan_and_update_registry:[00m Validating plugins from registry cache: /home/root/.cache/gstreamer-1.0/registry.arm.bin
0:00:00.065499523 [334m 1131[00m 0x2f000 [36mINFO [00m [00m GST_REGISTRY gstregistry.c:1679:scan_and_update_registry:[00m Registry cache has not changed
0:00:00.065542467 [334m 1131[00m 0x2f000 [36mINFO [00m [00m GST_REGISTRY gstregistry.c:1756:ensure_current_registry:[00m registry reading and updating done, result = 1
0:00:00.065571422 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_INIT gst.c:727:init_post:[00m GLib runtime version: 2.52.3
0:00:00.065601352 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_INIT gst.c:729:init_post:[00m GLib headers version: 2.52.3
0:00:00.065629006 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_INIT gst.c:730:init_post:[00m initialized GStreamer successfully
0:00:00.065721726 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;37;41m GST_PIPELINE gstparse.c:334:gst_parse_launch_full:[00m parsing pipeline description 'v4l2src device=/dev/video1 io-mode=4 ! video/x-raw,width=800,height=600 ! fakesink '
0:00:00.078864704 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;36m GST_PLUGIN_LOADING gstplugin.c:843:_priv_gst_plugin_load_file_for_registry:[00m plugin "/usr/lib/gstreamer-1.0/libgstvideo4linux2.so" loaded
0:00:00.078931398 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:361:gst_element_factory_create:[00m creating element "v4l2src"
0:00:00.081366518 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;37;41m GST_ELEMENT_PADS gstelement.c:670:gst_element_add_pad:<GstBaseSrc@0x16a0a0>[00m adding pad 'src'
0:00:00.083761134 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;36m GST_PLUGIN_LOADING gstplugin.c:843:_priv_gst_plugin_load_file_for_registry:[00m plugin "/usr/lib/gstreamer-1.0/libgstcoreelements.so" loaded
0:00:00.083824248 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:361:gst_element_factory_create:[00m creating element "fakesink"
0:00:00.084217251 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;37;41m GST_ELEMENT_PADS gstelement.c:670:gst_element_add_pad:<GstBaseSink@0x1762a0>[00m adding pad 'sink'
0:00:00.084292566 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:361:gst_element_factory_create:[00m creating element "pipeline"
0:00:00.084523064 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;37;41m GST_PIPELINE grammar.y:652:gst_parse_perform_link:[00m linking some pad of GstV4l2Src named v4l2src0 to some pad of GstFakeSink named fakesink0 (0/0) with caps "video/x-raw, width=(int)800, height=(int)600"
0:00:00.084594800 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;37;41m GST_ELEMENT_FACTORY gstelementfactory.c:361:gst_element_factory_create:[00m creating element "capsfilter"
0:00:00.084829528 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;37;41m GST_ELEMENT_PADS gstelement.c:670:gst_element_add_pad:<GstBaseTransform@0x17a148>[00m adding pad 'sink'
0:00:00.084892968 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;37;41m GST_ELEMENT_PADS gstelement.c:670:gst_element_add_pad:<GstBaseTransform@0x17a148>[00m adding pad 'src'
0:00:00.084983574 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2080:gst_bin_get_state_func:<pipeline0>[00m getting state
0:00:00.085055310 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2467:gst_element_continue_state:<capsfilter0>[00m completed state change to NULL
0:00:00.085101507 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;34m GST_EVENT gstevent.c:1512:gst_event_new_reconfigure:[00m creating reconfigure event
0:00:00.085141686 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;37;41m GST_ELEMENT_PADS gstutils.c:1709:gst_element_link_pads_full:[00m trying to link element v4l2src0:(any) to element capsfilter0:sink
0:00:00.085182027 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;37;41m GST_ELEMENT_PADS gstelement.c:918:gst_element_get_static_pad:[00m found pad capsfilter0:sink
0:00:00.085213259 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31;41m GST_PADS gstutils.c:1523:prepare_link_maybe_ghosting:[00m v4l2src0 and capsfilter0 in same bin, no need for ghost pads
0:00:00.085261571 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31;41m GST_PADS gstpad.c:2316:gst_pad_link_prepare:[00m trying to link v4l2src0:src and capsfilter0:sink
0:00:00.085321920 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31;41m GST_PADS gstpad.c:4115:gst_pad_peer_query:<capsfilter0:src>[00m pad has no peer
0:00:00.085368606 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31;41m GST_PADS gstpad.c:2524:gst_pad_link_full:[00m linked v4l2src0:src and capsfilter0:sink, successful
0:00:00.085401302 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;34m GST_EVENT gstevent.c:1512:gst_event_new_reconfigure:[00m creating reconfigure event
0:00:00.085429768 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;34m GST_EVENT gstpad.c:5655:gst_pad_send_event_unchecked:<v4l2src0:src>[00m Received event on flushing pad. Discarding
0:00:00.085474176 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;37;41m GST_ELEMENT_PADS gstutils.c:1709:gst_element_link_pads_full:[00m trying to link element capsfilter0:src to element fakesink0:(any)
0:00:00.085506547 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;37;41m GST_ELEMENT_PADS gstelement.c:918:gst_element_get_static_pad:[00m found pad capsfilter0:src
0:00:00.085539568 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31;41m GST_PADS gstutils.c:1009:gst_pad_check_link:[00m trying to link capsfilter0:src and fakesink0:sink
0:00:00.085639446 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31;41m GST_PADS gstutils.c:1523:prepare_link_maybe_ghosting:[00m capsfilter0 and fakesink0 in same bin, no need for ghost pads
0:00:00.085703374 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31;41m GST_PADS gstpad.c:2316:gst_pad_link_prepare:[00m trying to link capsfilter0:src and fakesink0:sink
0:00:00.085796094 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31;41m GST_PADS gstpad.c:2524:gst_pad_link_full:[00m linked capsfilter0:src and fakesink0:sink, successful
0:00:00.085827976 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;34m GST_EVENT gstevent.c:1512:gst_event_new_reconfigure:[00m creating reconfigure event
0:00:00.085855467 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;34m GST_EVENT gstpad.c:5655:gst_pad_send_event_unchecked:<capsfilter0:src>[00m Received event on flushing pad. Discarding
0:00:00.086066771 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2491:gst_bin_element_set_state:<fakesink0>[00m current NULL pending VOID_PENDING, desired next READY
0:00:00.086111667 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2467:gst_element_continue_state:<fakesink0>[00m completed state change to READY
0:00:00.086141110 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<fakesink0>[00m notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:00.086198206 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2939:gst_bin_change_state_func:<pipeline0>[00m child 'fakesink0' changed state to 2(READY) successfully
0:00:00.086239523 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2491:gst_bin_element_set_state:<capsfilter0>[00m current NULL pending VOID_PENDING, desired next READY
0:00:00.086274008 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2467:gst_element_continue_state:<capsfilter0>[00m completed state change to READY
0:00:00.086301662 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<capsfilter0>[00m notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:00.086340539 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2939:gst_bin_change_state_func:<pipeline0>[00m child 'capsfilter0' changed state to 2(READY) successfully
0:00:00.086376000 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2491:gst_bin_element_set_state:<v4l2src0>[00m current NULL pending VOID_PENDING, desired next READY
0:00:00.086655136 [334m 1131[00m 0x2f000 [36mINFO [00m [00m v4l2 v4l2_calls.c:592:gst_v4l2_open:<v4l2src0>[00m Opened device 'vip' (/dev/video1) successfully
0:00:00.086720040 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2467:gst_element_continue_state:<v4l2src0>[00m completed state change to READY
0:00:00.086750622 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<v4l2src0>[00m notifying about state-changed NULL to READY (VOID_PENDING pending)
0:00:00.086793403 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2939:gst_bin_change_state_func:<pipeline0>[00m child 'v4l2src0' changed state to 2(READY) successfully
0:00:00.086836998 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2442:gst_element_continue_state:<pipeline0>[00m committing state from NULL to READY, pending PAUSED, next PAUSED
0:00:00.086868067 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<pipeline0>[00m notifying about state-changed NULL to READY (PAUSED pending)
0:00:00.086950864 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2449:gst_element_continue_state:<pipeline0>[00m continue state change READY to PAUSED, final PAUSED
0:00:00.087026504 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2491:gst_bin_element_set_state:<fakesink0>[00m current READY pending VOID_PENDING, desired next PAUSED
0:00:00.087082624 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2945:gst_bin_change_state_func:<pipeline0>[00m child 'fakesink0' is changing state asynchronously to PAUSED
0:00:00.087122315 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2491:gst_bin_element_set_state:<capsfilter0>[00m current READY pending VOID_PENDING, desired next PAUSED
0:00:00.087167374 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2467:gst_element_continue_state:<capsfilter0>[00m completed state change to PAUSED
0:00:00.087195027 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<capsfilter0>[00m notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:00.087249846 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2939:gst_bin_change_state_func:<pipeline0>[00m child 'capsfilter0' changed state to 3(PAUSED) successfully
0:00:00.087288723 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2491:gst_bin_element_set_state:<v4l2src0>[00m current READY pending VOID_PENDING, desired next PAUSED
0:00:00.087339312 [334m 1131[00m 0x2f000 [36mINFO [00m [00m basesrc gstbasesrc.c:1331:gst_base_src_do_seek:<v4l2src0>[00m seeking: 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
0:00:00.087440979 [334m 1131[00m 0x2f000 [36mINFO [00m [00m task gsttask.c:457:gst_task_set_lock:[00m setting stream lock 0x16c084 on task 0x17d828
0:00:00.087474814 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31;41m GST_PADS gstpad.c:6001:gst_pad_start_task:<v4l2src0:src>[00m created task 0x17d828
0:00:00.087650006 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2467:gst_element_continue_state:<v4l2src0>[00m completed state change to PAUSED
0:00:00.087694902 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<v4l2src0>[00m notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:00.087745816 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2982:gst_bin_change_state_func:<pipeline0>[00m child 'v4l2src0' changed state to 3(PAUSED) successfully without preroll
0:00:00.087760782 [334m 1131[00m 0x168090 [36mINFO [00m [00;01;37;41m GST_ELEMENT_PADS gstelement.c:915:gst_element_get_static_pad:[00m no such pad 'sink' in element "v4l2src0"
0:00:00.087794942 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2467:gst_element_continue_state:<pipeline0>[00m completed state change to PAUSED
0:00:00.087860334 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<pipeline0>[00m notifying about state-changed READY to PAUSED (VOID_PENDING pending)
0:00:00.088086115 [334m 1131[00m 0x168090 [36mINFO [00m [00m v4l2 gstv4l2object.c:1146:gst_v4l2_object_fill_format_list:<v4l2src0>[00m got 9 format(s):
0:00:00.088134590 [334m 1131[00m 0x168090 [36mINFO [00m [00m v4l2 gstv4l2object.c:1152:gst_v4l2_object_fill_format_list:<v4l2src0>[00m YUYV
0:00:00.088176883 [334m 1131[00m 0x168090 [36mINFO [00m [00m v4l2 gstv4l2object.c:1152:gst_v4l2_object_fill_format_list:<v4l2src0>[00m UYVY
0:00:00.088213483 [334m 1131[00m 0x168090 [36mINFO [00m [00m v4l2 gstv4l2object.c:1152:gst_v4l2_object_fill_format_list:<v4l2src0>[00m BGR4
0:00:00.088267814 [334m 1131[00m 0x168090 [36mINFO [00m [00m v4l2 gstv4l2object.c:1152:gst_v4l2_object_fill_format_list:<v4l2src0>[00m RGB4
0:00:00.088299046 [334m 1131[00m 0x168090 [36mINFO [00m [00m v4l2 gstv4l2object.c:1152:gst_v4l2_object_fill_format_list:<v4l2src0>[00m BGR3
0:00:00.088328163 [334m 1131[00m 0x168090 [36mINFO [00m [00m v4l2 gstv4l2object.c:1152:gst_v4l2_object_fill_format_list:<v4l2src0>[00m RGB3
0:00:00.088357606 [334m 1131[00m 0x168090 [36mINFO [00m [00m v4l2 gstv4l2object.c:1152:gst_v4l2_object_fill_format_list:<v4l2src0>[00m NV12
0:00:00.088385747 [334m 1131[00m 0x168090 [36mINFO [00m [00m v4l2 gstv4l2object.c:1152:gst_v4l2_object_fill_format_list:<v4l2src0>[00m YVYU
0:00:00.088414051 [334m 1131[00m 0x168090 [36mINFO [00m [00m v4l2 gstv4l2object.c:1152:gst_v4l2_object_fill_format_list:<v4l2src0>[00m VYUY
0:00:00.088808680 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;34m GST_EVENT gstevent.c:1383:gst_event_new_latency:[00m creating latency event 0:00:00.000000000
0:00:00.088887248 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01m bin gstbin.c:2768:gst_bin_do_latency_func:<pipeline0>[00m configured latency of 0:00:00.000000000
0:00:00.088946622 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2491:gst_bin_element_set_state:<fakesink0>[00m current READY pending PAUSED, desired next PLAYING
0:00:00.088981758 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2945:gst_bin_change_state_func:<pipeline0>[00m child 'fakesink0' is changing state asynchronously to PLAYING
0:00:00.089020635 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2491:gst_bin_element_set_state:<capsfilter0>[00m current PAUSED pending VOID_PENDING, desired next PLAYING
0:00:00.089056096 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2467:gst_element_continue_state:<capsfilter0>[00m completed state change to PLAYING
0:00:00.089084238 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<capsfilter0>[00m notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:00.089124416 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2939:gst_bin_change_state_func:<pipeline0>[00m child 'capsfilter0' changed state to 4(PLAYING) successfully
0:00:00.089166872 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2467:gst_element_continue_state:<v4l2src0>[00m completed state change to PLAYING
0:00:00.089194851 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<v4l2src0>[00m notifying about state-changed PAUSED to PLAYING (VOID_PENDING pending)
0:00:00.089232590 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2939:gst_bin_change_state_func:<pipeline0>[00m child 'v4l2src0' changed state to 4(PLAYING) successfully
0:00:00.090598827 [334m 1131[00m 0x168090 [36mINFO [00m [00m v4l2 gstv4l2object.c:3970:gst_v4l2_object_get_caps:<v4l2src0>[00m probed caps: video/x-raw, format=(string)YUY2, framerate=(fraction)30000/1001, width=(int)128, height=(int)128, interlace-mode=(string)progressive, pixel-aspect-ratio=(fraction)1/1, colorimetry=(string){ bt601 }; video/x-raw, format=(string)UYVY, framerate=(fraction)30000/1001, width=(int)128, height=(int)128, interlace-mode=(string)progressive, pixel-aspect-ratio=(fraction)1/1, colorimetry=(string){ bt601 }; video/x-raw, format=(string)BGRx, framerate=(fraction)30000/1001, width=(int)128, height=(int)128, interlace-mode=(string)progressive, pixel-aspect-ratio=(fraction)1/1, colorimetry=(string){ sRGB }; video/x-raw, format=(string)xRGB, framerate=(fraction)30000/1001, width=(int)128, height=(int)128, interlace-mode=(string)progressive, pixel-aspect-ratio=(fraction)1/1, colorimetry=(string){ sRGB }; video/x-raw, format=(string)BGR, framerate=(fraction)30000/1001, width=(int)128, height=(int)128, interlace-mode=(string)progressive, pixel-aspect-ratio=(fraction)1/1, colorimetry=(string){ sRGB }; video/x-raw, format=(string)RGB, framerate=(fraction)30000/1001, width=(int)128, height=(int)128, interlace-mode=(string)progressive, pixel-aspect-ratio=(fraction)1/1, colorimetry=(string){ sRGB }; video/x-raw, format=(string)NV12, framerate=(fraction)30000/1001, width=(int)128, height=(int)128, interlace-mode=(string)progressive, pixel-aspect-ratio=(fraction)1/1, colorimetry=(string){ bt601 }; video/x-raw, format=(string)YVYU, framerate=(fraction)30000/1001, width=(int)128, height=(int)128, interlace-mode=(string)progressive, pixel-aspect-ratio=(fraction)1/1, colorimetry=(string){ bt601 }
0:00:00.090859907 [334m 1131[00m 0x168090 [33;01mWARN [00m [00m basesrc gstbasesrc.c:2939:gst_base_src_loop:<v4l2src0>[00m error: Internal data stream error.
0:00:00.090890163 [334m 1131[00m 0x168090 [33;01mWARN [00m [00m basesrc gstbasesrc.c:2939:gst_base_src_loop:<v4l2src0>[00m error: streaming stopped, reason not-negotiated (-4)
0:00:00.090943355 [334m 1131[00m 0x168090 [36mINFO [00m [00;01;31;47m GST_ERROR_SYSTEM gstelement.c:1938:gst_element_message_full_with_details:<v4l2src0>[00m posting message: Internal data stream error.
0:00:00.091023224 [334m 1131[00m 0x168090 [36mINFO [00m [00;01;31;47m GST_ERROR_SYSTEM gstelement.c:1965:gst_element_message_full_with_details:<v4l2src0>[00m posted error message: Internal data stream error.
0:00:00.091214358 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2491:gst_bin_element_set_state:<fakesink0>[00m current PAUSED pending VOID_PENDING, desired next PAUSED
0:00:00.091252096 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2608:gst_bin_element_set_state:<fakesink0>[00m skipping transition from PAUSED to PAUSED
0:00:00.091282027 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2939:gst_bin_change_state_func:<pipeline0>[00m child 'fakesink0' changed state to 3(PAUSED) successfully
0:00:00.091319928 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2491:gst_bin_element_set_state:<capsfilter0>[00m current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:00.091353926 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2467:gst_element_continue_state:<capsfilter0>[00m completed state change to PAUSED
0:00:00.091381091 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<capsfilter0>[00m notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:00.091420131 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2939:gst_bin_change_state_func:<pipeline0>[00m child 'capsfilter0' changed state to 3(PAUSED) successfully
0:00:00.091454616 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2491:gst_bin_element_set_state:<v4l2src0>[00m current PLAYING pending VOID_PENDING, desired next PAUSED
0:00:00.091489915 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2467:gst_element_continue_state:<v4l2src0>[00m completed state change to PAUSED
0:00:00.091516755 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<v4l2src0>[00m notifying about state-changed PLAYING to PAUSED (VOID_PENDING pending)
0:00:00.091554494 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2982:gst_bin_change_state_func:<pipeline0>[00m child 'v4l2src0' changed state to 3(PAUSED) successfully without preroll
0:00:00.091608499 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2467:gst_element_continue_state:<pipeline0>[00m completed state change to PAUSED
0:00:00.091686416 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2491:gst_bin_element_set_state:<fakesink0>[00m current PAUSED pending VOID_PENDING, desired next READY
0:00:00.091757827 [334m 1131[00m 0x168090 [36mINFO [00m [00m task gsttask.c:319:gst_task_func:<v4l2src0:src>[00m Task going to paused
0:00:00.091768888 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2467:gst_element_continue_state:<fakesink0>[00m completed state change to READY
0:00:00.094966264 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<fakesink0>[00m notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:00.095019131 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2939:gst_bin_change_state_func:<pipeline0>[00m child 'fakesink0' changed state to 2(READY) successfully
0:00:00.095063864 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2491:gst_bin_element_set_state:<capsfilter0>[00m current PAUSED pending VOID_PENDING, desired next READY
0:00:00.095119822 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2467:gst_element_continue_state:<capsfilter0>[00m completed state change to READY
0:00:00.095149427 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<capsfilter0>[00m notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:00.095189118 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2939:gst_bin_change_state_func:<pipeline0>[00m child 'capsfilter0' changed state to 2(READY) successfully
0:00:00.095267523 [334m 1131[00m 0x168090 [36mINFO [00m [00m task gsttask.c:321:gst_task_func:<v4l2src0:src>[00m Task resume from paused
0:00:00.095349182 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2467:gst_element_continue_state:<v4l2src0>[00m completed state change to READY
0:00:00.095381390 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<v4l2src0>[00m notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:00.095421731 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2939:gst_bin_change_state_func:<pipeline0>[00m child 'v4l2src0' changed state to 2(READY) successfully
0:00:00.095463699 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2467:gst_element_continue_state:<pipeline0>[00m completed state change to READY
0:00:00.095491678 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<pipeline0>[00m notifying about state-changed PAUSED to READY (VOID_PENDING pending)
0:00:00.095558371 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2080:gst_bin_get_state_func:<pipeline0>[00m getting state
0:00:00.095636776 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2491:gst_bin_element_set_state:<fakesink0>[00m current READY pending VOID_PENDING, desired next NULL
0:00:00.095682811 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2467:gst_element_continue_state:<fakesink0>[00m completed state change to NULL
0:00:00.095711278 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<fakesink0>[00m notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:00.095774392 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2939:gst_bin_change_state_func:<pipeline0>[00m child 'fakesink0' changed state to 1(NULL) successfully
0:00:00.095813432 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2491:gst_bin_element_set_state:<capsfilter0>[00m current READY pending VOID_PENDING, desired next NULL
0:00:00.095854587 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2467:gst_element_continue_state:<capsfilter0>[00m completed state change to NULL
0:00:00.095882728 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<capsfilter0>[00m notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:00.095921768 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2939:gst_bin_change_state_func:<pipeline0>[00m child 'capsfilter0' changed state to 1(NULL) successfully
0:00:00.095957067 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2491:gst_bin_element_set_state:<v4l2src0>[00m current READY pending VOID_PENDING, desired next NULL
0:00:00.096108672 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2467:gst_element_continue_state:<v4l2src0>[00m completed state change to NULL
0:00:00.096139579 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<v4l2src0>[00m notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:00.096178294 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstbin.c:2939:gst_bin_change_state_func:<pipeline0>[00m child 'v4l2src0' changed state to 1(NULL) successfully
0:00:00.096253934 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2467:gst_element_continue_state:<pipeline0>[00m completed state change to NULL
0:00:00.096283376 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_STATES gstelement.c:2372:_priv_gst_element_state_changed:<pipeline0>[00m notifying about state-changed READY to NULL (VOID_PENDING pending)
0:00:00.096355600 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;37;41m GST_ELEMENT_PADS gstpad.c:2072:gst_pad_unlink:[00m unlinking v4l2src0:src(0x16c038) and capsfilter0:sink(0x16c2d8)
0:00:00.096407328 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;37;41m GST_ELEMENT_PADS gstpad.c:2126:gst_pad_unlink:[00m unlinked v4l2src0:src and capsfilter0:sink
0:00:00.096455478 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;37;41m GST_ELEMENT_PADS gstpad.c:2072:gst_pad_unlink:[00m unlinking capsfilter0:src(0x16c428) and fakesink0:sink(0x16c188)
0:00:00.096499235 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;37;41m GST_ELEMENT_PADS gstpad.c:2126:gst_pad_unlink:[00m unlinked capsfilter0:src and fakesink0:sink
0:00:00.096542830 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;37;41m GST_PARENTAGE gstbin.c:1792:gst_bin_remove_func:<pipeline0>[00m removed child "capsfilter0"
0:00:00.096594558 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31;44m GST_REFCOUNTING gstelement.c:3042:gst_element_dispose:<capsfilter0>[00m 0x17a148 dispose
0:00:00.096625627 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;37;41m GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<capsfilter0>[00m removing pad 'sink'
0:00:00.096684024 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;37;41m GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<capsfilter0>[00m removing pad 'src'
0:00:00.096724040 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31;44m GST_REFCOUNTING gstelement.c:3088:gst_element_dispose:<capsfilter0>[00m 0x17a148 parent class dispose
0:00:00.096756086 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31;44m GST_REFCOUNTING gstelement.c:3119:gst_element_finalize:<capsfilter0>[00m 0x17a148 finalize
0:00:00.096803096 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31;44m GST_REFCOUNTING gstelement.c:3125:gst_element_finalize:<capsfilter0>[00m 0x17a148 finalize parent
0:00:00.096844088 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;37;41m GST_PARENTAGE gstbin.c:1792:gst_bin_remove_func:<pipeline0>[00m removed child "fakesink0"
0:00:00.096886382 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31;44m GST_REFCOUNTING gstelement.c:3042:gst_element_dispose:<fakesink0>[00m 0x1762a0 dispose
0:00:00.096915174 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;37;41m GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<fakesink0>[00m removing pad 'sink'
0:00:00.096952099 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31;44m GST_REFCOUNTING gstelement.c:3088:gst_element_dispose:<fakesink0>[00m 0x1762a0 parent class dispose
0:00:00.096983656 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31;44m GST_REFCOUNTING gstelement.c:3119:gst_element_finalize:<fakesink0>[00m 0x1762a0 finalize
0:00:00.097010822 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31;44m GST_REFCOUNTING gstelement.c:3125:gst_element_finalize:<fakesink0>[00m 0x1762a0 finalize parent
0:00:00.097054416 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;37;41m GST_PARENTAGE gstbin.c:1792:gst_bin_remove_func:<pipeline0>[00m removed child "v4l2src0"
0:00:00.097096222 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31;44m GST_REFCOUNTING gstelement.c:3042:gst_element_dispose:<v4l2src0>[00m 0x16a0a0 dispose
0:00:00.097124851 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;37;41m GST_ELEMENT_PADS gstelement.c:787:gst_element_remove_pad:<v4l2src0>[00m removing pad 'src'
0:00:00.097160800 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31;44m GST_REFCOUNTING gstelement.c:3088:gst_element_dispose:<v4l2src0>[00m 0x16a0a0 parent class dispose
0:00:00.097194635 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31;44m GST_REFCOUNTING gstelement.c:3119:gst_element_finalize:<v4l2src0>[00m 0x16a0a0 finalize
0:00:00.097221963 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31;44m GST_REFCOUNTING gstelement.c:3125:gst_element_finalize:<v4l2src0>[00m 0x16a0a0 finalize parent
0:00:00.097252056 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31;44m GST_REFCOUNTING gstelement.c:3042:gst_element_dispose:<pipeline0>[00m 0x178048 dispose
0:00:00.097326883 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31;44m GST_REFCOUNTING gstelement.c:3088:gst_element_dispose:<pipeline0>[00m 0x178048 parent class dispose
0:00:00.097361043 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31;44m GST_REFCOUNTING gstelement.c:3119:gst_element_finalize:<pipeline0>[00m 0x178048 finalize
0:00:00.097388859 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31;44m GST_REFCOUNTING gstelement.c:3125:gst_element_finalize:<pipeline0>[00m 0x178048 finalize parent
0:00:00.097420904 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_INIT gst.c:998:gst_deinit:[00m deinitializing GStreamer
0:00:00.106443048 [334m 1131[00m 0x2f000 [36mINFO [00m [00;01;31m GST_INIT gst.c:1140:gst_deinit:[00m deinitialized GStreamer
