The pixel format shouldn’t be YUYV? Have a check your sensor driver to report the correct format.
We have always tested with Pattern Generator untill now. But today we’ve connected our camera, and we can get record video with;
v4l2-ctl --set-fmt-video=width=1280,height=720,pixelformat=YUYV --set-ctrl bypass_mode=0 --stream-mmap --stream-count=100 -d /dev/video0 --stream-to=ov491.raw
mplayer /home/burak/Desktop/ov491.raw -demuxer rawvideo -rawvideo w=1280:h=720:fps=30:format=yuy2
However when we try to stream this video with VLC, we have errors.
[0000007f74000e30] v4l2 demux error: cannot get streaming parameters: Inappropriate ioctl for device
Could not initialize OpenGL for RasterGLSurface, reverting to RasterSurface.
Could not initialize OpenGL for RasterGLSurface, reverting to RasterSurface.
Could not initialize OpenGL for RasterGLSurface, reverting to RasterSurface.
Could not initialize OpenGL for RasterGLSurface, reverting to RasterSurface.
I think this error is because of;
nvidia@tegra-ubuntu:~$ v4l2-ctl --list-devices
VIDIOC_QUERYCAP: failed: Inappropriate ioctl for device
VIDIOC_QUERYCAP: failed: Inappropriate ioctl for device
vi-output, ov5693 6-0036 (platform:54080000.vi:0):
/dev/video0
So how can I make these ioctl correct? I couldn’t locate them.
It just show driver doesn’t support VIDIOC_QUERYCAP ioctl . it is harmless so you can ignore it.
You may need to trace the real failed by debug VLC.
We can get the vidoe, %100 fine with rawdata.
v4l2-ctl --set-fmt-video=width=1280,height=720,pixelformat=YUYV --set-ctrl bypass_mode=0 --stream-mmap --stream-count=100 -d /dev/video0 --stream-to=ov491.raw
We only need to stream it to the host pc, and capture it in real-time. Do you have any suggestions for this?
gst-launch-1.0 v4l2src device=/dev/video0 ! videorate max-rate=25 ! videoconvert ! omxh265enc qp-range=30,50:30,50:30,50 control-rate=4 bitrate=3000000 ! "video/x-h265, stream-format=(string)byte-stream" ! rtph265pay mtu=1400 ! udpsink host=192.168.1.100 port=5600 sync=false async=false
still gives;
nvidia@tegra-ubuntu:~$ gst-launch-1.0 v4l2src device=/dev/video0 ! videorate max-rate=25 ! videoconvert ! omxh265enc qp-range=30,50:30,50:30,50 control-rate=4 bitrate=3000000 ! "video/x-h265, stream-format=(string)byte-stream" ! rtph265pay mtu=1400 ! udpsink host=192.168.1.100 port=5600 sync=false async=false
Setting pipeline to PAUSED ...
Pipeline is live and does not need PREROLL ...
Setting pipeline to PLAYING ...
New clock: GstSystemClock
ERROR: from element /GstPipeline:pipeline0/GstV4l2Src:v4l2src0: Device '/dev/video0' cannot capture in the specified format
Additional debug info:
gstv4l2object.c(3481): gst_v4l2_object_set_format_full (): /GstPipeline:pipeline0/GstV4l2Src:v4l2src0:
Tried to capture in YU12, but device returned format YUYV
Execution ended after 0:00:00.000772812
Setting pipeline to PAUSED ...
Setting pipeline to READY ...
Setting pipeline to NULL ...
Freeing pipeline ...
First you need a gstreamer command line can working, then to figure out a pipeline for RTP use case.
You can’t capture YV12 that your driver doesn’t support. You must capture YUYV then convert it by another gstreamer element if must need YV12.
You may try this on Jetson:
gst-launch-1.0 v4l2src device=/dev/video0 ! video/x-raw,format=YUY2,width=1280,height=720 ! nvvidconv ! 'video/x-raw(memory:NVMM),format=NV12,width=1280,height=720,framerate=30/1' ! omxh265enc ! rtph265pay pt=96 ! udpsink host=<receiver_ip> port=5000
where <receiver_ip> can be your target client 192.168.1.100, or 127.0.0.1 for client on the same Jetson.
And this on receiver:
gst-launch-1.0 udpsrc port=5000 ! application/x-rtp,encoding-name=H265,payload=96 ! rtph265depay ! h265parse ! decodebin ! videoconvert ! xvimagesink
Additional note: if you’re using high resolution and framerate, you may face a bottleneck with kernel buffers for sockets with UDP. See this post for setting these to 25MB per socket. This might apply to both Jetson and host.
First I used this command;
nvidia@tegra-ubuntu:~$ gst-launch-1.0 -v v4l2src device="/dev/video0" ! "video/x-raw, format=(string)YUY2" ! fakesink
Setting pipeline to PAUSED ...
Pipeline is live and does not need PREROLL ...
Setting pipeline to PLAYING ...
New clock: GstSystemClock
ERROR: from element /GstPipeline:pipeline0/GstV4l2Src:v4l2src0: Internal data flow error.
Additional debug info:
gstbasesrc.c(2948): gst_base_src_loop (): /GstPipeline:pipeline0/GstV4l2Src:v4l2src0:
streaming task paused, reason not-negotiated (-4)
Execution ended after 0:00:00.000409531
Setting pipeline to PAUSED ...
Setting pipeline to READY ...
Setting pipeline to NULL ...
Freeing pipeline ...
Then, this command:
nvidia@tegra-ubuntu:~$ gst-launch-1.0 v4l2src device=/dev/video0 ! video/x-raw,format=YUY2 ! nvvidconv ! 'video/x-raw(memory:NVMM),format=NV12,width=640,height=480,framerate=30/1' ! omxh265enc ! rtph265pay pt=96 ! udpsink host=192.168.1.100 port=5000
Setting pipeline to PAUSED ...
Pipeline is live and does not need PREROLL ...
Setting pipeline to PLAYING ...
ERROR: from element /GstPipeline:pipeline0/GstV4l2Src:v4l2src0: Internal data flow error.
Additional debug info:
gstbasesrc.c(2948): gst_base_src_loop (): /GstPipeline:pipeline0/GstV4l2Src:v4l2src0:
streaming task paused, reason not-negotiated (-4)
Execution ended after 0:00:00.000151510
Setting pipeline to PAUSED ...
Setting pipeline to READY ...
Setting pipeline to NULL ...
Freeing pipeline ...
What I find interesting is that;
nvidia@tegra-ubuntu:~$ v4l2-ctl -d /dev/video0 --list-formats-ext
ioctl: VIDIOC_ENUM_FMT
Index : 0
Type : Video Capture
Pixel Format: 'RG10'
Name : 10-bit Bayer RGRG/GBGB
^C^C
This command crashes(hangs) the v4l2-ctl for some reason, notice that eventhough I use CTRL+C I cant leave the terminal, and every gstreamer command after that crash hangs on as well.
nvidia@tegra-ubuntu:~$ gst-launch-1.0 v4l2src device=/dev/video0 ! video/x-raw,format=YUY2,width=1280,height=720 ! nvvidconv ! 'video/x-raw(memory:NVMM),format=NV12,width=1280,height=720,framerate=30/1' ! omxh265enc ! rtph265pay pt=96 ! udpsink host=192.168.1.100 port=5000
Setting pipeline to PAUSED ... //Notice this crashed as well
I know that this shouldn’t show RG10 and 10-bit Bayer RGRG/GBGB, but do I really need to fix these at kernel/driver side?
This might be a reason because we “dummy” the i2c, but if so, how can we record and play the video with this command?
v4l2-ctl --set-fmt-video=width=1280,height=720,pixelformat=YUYV --set-ctrl bypass_mode=0 --stream-mmap --stream-count=100 -d /dev/video0 --stream-to=ov491.raw
mplayer /home/burak/Desktop/ov491.raw -demuxer rawvideo -rawvideo w=1280:h=720:fps=50:format=yuy2
Reply To Additional Note: The video we try to stream is 1280x720 with 50 fps. I don’t think our bitrate is enough to bottleneck it.
You must fixed that.
What gives the following commands:
GST_DEBUG=v4l2src:4 gst-launch-1.0 -v v4l2src ! fakesink
GST_DEBUG=v4l2src:4 gst-launch-1.0 -v v4l2src ! video/x-raw,format=YUY2 ! fakesink
nvidia@tegra-ubuntu:~$ GST_DEBUG=v4l2src:4 gst-launch-1.0 -v v4l2src ! fakesink
Setting pipeline to PAUSED ...
Pipeline is live and does not need PREROLL ...
Setting pipeline to PLAYING ...
New clock: GstSystemClock
ERROR: from element /GstPipeline:pipeline0/GstV4l2Src:v4l2src0: Device '/dev/video0' cannot capture in the specified format
Additional debug info:
gstv4l2object.c(3482): gst_v4l2_object_set_format_full (): /GstPipeline:pipeline0/GstV4l2Src:v4l2src0:
Tried to capture in YU12, but device returned format YUYV
Execution ended after 0:00:00.000180885
Setting pipeline to PAUSED ...
Setting pipeline to READY ...
Setting pipeline to NULL ...
Freeing pipeline ...
nvidia@tegra-ubuntu:~$ GST_DEBUG=v4l2src:4 gst-launch-1.0 -v v4l2src ! video/x-raw,format=YUY2 ! fakesink
Setting pipeline to PAUSED ...
Pipeline is live and does not need PREROLL ...
Setting pipeline to PLAYING ...
New clock: GstSystemClock
ERROR: from element /GstPipeline:pipeline0/GstV4l2Src:v4l2src0: Internal data flow error.
Additional debug info:
gstbasesrc.c(2948): gst_base_src_loop (): /GstPipeline:pipeline0/GstV4l2Src:v4l2src0:
streaming task paused, reason not-negotiated (-4)
Execution ended after 0:00:00.000154114
Setting pipeline to PAUSED ...
Setting pipeline to READY ...
Setting pipeline to NULL ...
Freeing pipeline ...
@ShaneCCC How can I fix it? I think setting it from device-tree is not gonna make it.
Have a reference to the tc358840.c to report correct pixel format.
Hello there! It’s been some time…
I couldn’t manage to make it work with YUYV. So I tried to switching to RGB888. Now,
nvidia@tegra-ubuntu:~$ GST_DEBUG=v4l2src:4 gst-launch-1.0 v4l2src ! videoconvert ! ximagesink
Setting pipeline to PAUSED ...
Pipeline is live and does not need PREROLL ...
Setting pipeline to PLAYING ...
New clock: GstSystemClock
0:00:00.576145280 5371 0x628190 WARN v4l2src gstv4l2src.c:797:gst_v4l2src_create:<v4l2src0> Timestamp does not correlate with any clock, ignoring driver timestamps
0:00:00.576215360 5371 0x628190 INFO v4l2src gstv4l2src.c:843:gst_v4l2src_create:<v4l2src0> sync to 0:00:00.010000000 out ts 0:00:00.408193184
0:00:03.999994848 5371 0x628190 WARN v4l2src gstv4l2src.c:884:gst_v4l2src_create:<v4l2src0> error: Failed to allocate a buffer
ERROR: from element /GstPipeline:pipeline0/GstV4l2Src:v4l2src0: Could not read from resource.
Additional debug info:
gstv4l2bufferpool.c(1054): gst_v4l2_buffer_pool_poll (): /GstPipeline:pipeline0/GstV4l2Src:v4l2src0:
poll error 1: Resource temporarily unavailable (11)
Execution ended after 0:00:03.843480448
Setting pipeline to PAUSED ...
Setting pipeline to READY ...
Setting pipeline to NULL ...
Freeing pipeline ...
I can see a single frame with this command, the gstreamer opens, shows 1 frame, then closes.
How can I fix this “Failed to allocate a buffer” and “Could not read from resource” ?
If v4l2-ctl confirm can capture multiple frames. The problem could be the v4l2src cause.
So what do you suggest that I should do? Thank you! :)
root@tegra-ubuntu:/home/nvidia# echo 1 > /sys/kernel/debug/tracing/tracing_on
root@tegra-ubuntu:/home/nvidia# echo 30720 > /sys/kernel/debug/tracing/buffer_size_kb
root@tegra-ubuntu:/home/nvidia# echo 1 > /sys/kernel/debug/tracing/events/tegra_rtcpu/enable
root@tegra-ubuntu:/home/nvidia# echo 1 > /sys/kernel/debug/tracing/events/freertos/enable
root@tegra-ubuntu:/home/nvidia# echo 2 > /sys/kernel/debug/camrtc/log-level
root@tegra-ubuntu:/home/nvidia# echo > /sys/kernel/debug/tracing/trace
root@tegra-ubuntu:/home/nvidia# v4l2-ctl -d /dev/video0 --set-fmt-video=width=1280,height=720,pixelformat=RG10 --set-ctrl bypass_mode=0 --stream-mmap --stream-count=1 --stream-to=test.raw
<
root@tegra-ubuntu:/home/nvidia# sudo cat /sys/kernel/debug/tracing/trace
# tracer: nop
#
# entries-in-buffer/entries-written: 345/345 #P:4
#
# _-----=> irqs-off
# / _----=> need-resched
# | / _---=> hardirq/softirq
# || / _--=> preempt-depth
# ||| / delay
# TASK-PID CPU# |||| TIMESTAMP FUNCTION
# | | | |||| | |
kworker/0:2-2803 [000] ...1 1231.584335: rtos_queue_peek_from_isr_failed: tstamp:38816056863 queue:0x0b4a3c58
kworker/0:2-2803 [000] ...1 1231.584341: rtcpu_start: tstamp:38816058023
kworker/0:2-2803 [000] ...1 1231.584343: rtcpu_vinotify_handle_msg: tstamp:38816090291 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:161384185 data:0x00000001
kworker/0:2-2803 [000] ...1 1231.584345: rtcpu_vinotify_handle_msg: tstamp:38816980849 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:162274448 data:0x00400060
kworker/0:2-2803 [000] ...1 1231.584346: rtcpu_vinotify_handle_msg: tstamp:38816981009 tag:CHANSEL_SHORT_FRAME channel:0x01 frame:0 vi_tstamp:162274448 data:0x00000001
kworker/0:2-2803 [000] ...1 1231.584347: rtcpu_vinotify_handle_msg: tstamp:38816981168 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:162274451 data:0x00000001
kworker/0:2-2803 [000] ...1 1231.636249: rtcpu_vinotify_handle_msg: tstamp:38817501378 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:162795276 data:0x00400060
kworker/0:2-2803 [000] ...1 1231.636252: rtcpu_vinotify_handle_msg: tstamp:38818022212 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:163316105 data:0x00400060
kworker/0:2-2803 [000] ...1 1231.636253: rtcpu_vinotify_handle_msg: tstamp:38818543033 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:163836933 data:0x00400060
kworker/0:2-2803 [000] ...1 1231.688437: rtcpu_vinotify_handle_msg: tstamp:38819063861 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:164357761 data:0x00400060
kworker/0:2-2803 [000] ...1 1231.688449: rtcpu_vinotify_handle_msg: tstamp:38819584691 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:164878589 data:0x00400060
kworker/0:2-2803 [000] ...1 1231.688459: rtcpu_vinotify_handle_msg: tstamp:38820105994 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:165399418 data:0x00400060
kworker/0:2-2803 [000] ...1 1231.740422: rtcpu_vinotify_handle_msg: tstamp:38820626823 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:165920246 data:0x00400060
kworker/0:2-2803 [000] ...1 1231.740438: rtos_queue_peek_from_isr_failed: tstamp:38821057774 queue:0x0b4a3c58
kworker/0:2-2803 [000] ...1 1231.740449: rtcpu_vinotify_handle_msg: tstamp:38821147184 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:166441076 data:0x00400060
kworker/0:2-2803 [000] ...1 1231.740459: rtcpu_vinotify_handle_msg: tstamp:38821668486 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:166961904 data:0x00400060
kworker/0:2-2803 [000] ...1 1231.792432: rtcpu_vinotify_handle_msg: tstamp:38822189313 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:167482732 data:0x00400060
kworker/0:2-2803 [000] ...1 1231.792447: rtcpu_vinotify_handle_msg: tstamp:38822710142 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:168003561 data:0x00400060
kworker/0:2-2803 [000] ...1 1231.792456: rtcpu_vinotify_handle_msg: tstamp:38823230969 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:168524391 data:0x00400060
kworker/0:2-2803 [000] ...1 1231.792465: rtcpu_vinotify_handle_msg: tstamp:38823751773 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:169045219 data:0x00400060
kworker/0:2-2803 [000] ...1 1231.844660: rtcpu_vinotify_handle_msg: tstamp:38824272629 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:169566048 data:0x00400060
kworker/0:2-2803 [000] ...1 1231.844710: rtcpu_vinotify_handle_msg: tstamp:38824793426 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:170086877 data:0x00400060
kworker/0:2-2803 [000] ...1 1231.844720: rtcpu_vinotify_handle_msg: tstamp:38825314260 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:170607706 data:0x00400060
kworker/0:2-2803 [000] ...1 1231.896379: rtcpu_vinotify_handle_msg: tstamp:38825834655 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:171128536 data:0x00400060
kworker/0:2-2803 [000] ...1 1231.896389: rtos_queue_peek_from_isr_failed: tstamp:38826058327 queue:0x0b4a3c58
kworker/0:2-2803 [000] ...1 1231.896391: rtcpu_vinotify_handle_msg: tstamp:38826355484 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:171649364 data:0x00400060
kworker/0:2-2803 [000] ...1 1231.896393: rtcpu_vinotify_handle_msg: tstamp:38826876331 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:172170194 data:0x00400060
kworker/0:2-2803 [000] ...1 1231.948330: rtcpu_vinotify_handle_msg: tstamp:38827397143 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:172691022 data:0x00400060
kworker/0:2-2803 [000] ...1 1231.948333: rtcpu_vinotify_handle_msg: tstamp:38827917970 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:173211851 data:0x00400060
kworker/0:2-2803 [000] ...1 1231.948335: rtcpu_vinotify_handle_msg: tstamp:38828438799 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:173732681 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.000327: rtcpu_vinotify_handle_msg: tstamp:38828959628 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:174253510 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.000330: rtcpu_vinotify_handle_msg: tstamp:38829480459 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:174774339 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.000332: rtcpu_vinotify_handle_msg: tstamp:38830001288 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:175295168 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.052751: rtcpu_vinotify_handle_msg: tstamp:38830522569 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:175815996 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.052803: rtcpu_vinotify_handle_msg: tstamp:38831043399 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:176336826 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.052838: rtos_queue_peek_from_isr_failed: tstamp:38831059243 queue:0x0b4a3c58
kworker/0:2-2803 [000] ...1 1232.052847: rtcpu_vinotify_handle_msg: tstamp:38831564230 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:176857655 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.104360: rtcpu_vinotify_handle_msg: tstamp:38832085058 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:177378483 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.104375: rtcpu_vinotify_handle_msg: tstamp:38832605889 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:177899313 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.104388: rtcpu_vinotify_handle_msg: tstamp:38833126719 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:178420141 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.156344: rtcpu_vinotify_handle_msg: tstamp:38833647552 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:178940971 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.156354: rtcpu_vinotify_handle_msg: tstamp:38834168379 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:179461800 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.156365: rtcpu_vinotify_handle_msg: tstamp:38834689207 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:179982629 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.208327: rtcpu_vinotify_handle_msg: tstamp:38835210042 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:180503458 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.208338: rtcpu_vinotify_handle_msg: tstamp:38835730866 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:181024286 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.208352: rtos_queue_peek_from_isr_failed: tstamp:38836059756 queue:0x0b4a3c58
kworker/0:2-2803 [000] ...1 1232.208362: rtcpu_vinotify_handle_msg: tstamp:38836251667 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:181545116 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.260374: rtcpu_vinotify_handle_msg: tstamp:38836772524 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:182065945 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.260391: rtcpu_vinotify_handle_msg: tstamp:38837293371 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:182586773 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.260402: rtcpu_vinotify_handle_msg: tstamp:38837814184 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:183107603 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.260411: rtcpu_vinotify_handle_msg: tstamp:38838335014 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:183628431 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.312336: rtcpu_vinotify_handle_msg: tstamp:38838855839 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:184149261 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.312346: rtcpu_vinotify_handle_msg: tstamp:38839376671 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:184670090 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.312356: rtcpu_vinotify_handle_msg: tstamp:38839897498 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:185190919 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.364330: rtcpu_vinotify_handle_msg: tstamp:38840418329 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:185711747 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.364341: rtcpu_vinotify_handle_msg: tstamp:38840939218 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:186232576 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.364355: rtos_queue_peek_from_isr_failed: tstamp:38841060256 queue:0x0b4a3c58
kworker/0:2-2803 [000] ...1 1232.364368: rtcpu_vinotify_handle_msg: tstamp:38841459979 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:186753406 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.416340: rtcpu_vinotify_handle_msg: tstamp:38841980809 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:187274235 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.416354: rtcpu_vinotify_handle_msg: tstamp:38842501638 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:187795064 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.416363: rtcpu_vinotify_handle_msg: tstamp:38843022465 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:188315892 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.468342: rtcpu_vinotify_handle_msg: tstamp:38843543297 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:188836722 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.468353: rtcpu_vinotify_handle_msg: tstamp:38844064125 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:189357551 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.468363: rtcpu_vinotify_handle_msg: tstamp:38844584953 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:189878380 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.520527: rtcpu_vinotify_handle_msg: tstamp:38845105784 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:190399209 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.520557: rtcpu_vinotify_handle_msg: tstamp:38845626614 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:190920037 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.520579: rtos_queue_peek_from_isr_failed: tstamp:38846060738 queue:0x0b4a3c58
kworker/0:2-2803 [000] ...1 1232.520588: rtcpu_vinotify_handle_msg: tstamp:38846147412 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:191440867 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.572457: rtcpu_vinotify_handle_msg: tstamp:38846668270 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:191961696 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.572498: rtcpu_vinotify_handle_msg: tstamp:38847189098 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:192482525 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.572508: rtcpu_vinotify_handle_msg: tstamp:38847709947 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:193003354 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.624405: rtcpu_vinotify_handle_msg: tstamp:38848231126 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:193524183 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.624426: rtcpu_vinotify_handle_msg: tstamp:38848232162 tag:CHANSEL_SHORT_FRAME channel:0x01 frame:0 vi_tstamp:193524183 data:0x00000001
kworker/0:2-2803 [000] ...1 1232.624435: rtcpu_vinotify_handle_msg: tstamp:38848233203 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:193524185 data:0x00000001
kworker/0:2-2803 [000] ...1 1232.624445: rtcpu_vinotify_handle_msg: tstamp:38848751593 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:194045011 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.624454: rtcpu_vinotify_handle_msg: tstamp:38849272422 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:194565841 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.676582: rtcpu_vinotify_handle_msg: tstamp:38849793243 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:195086670 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.676645: rtcpu_vinotify_handle_msg: tstamp:38850314043 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:195607498 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.676656: rtcpu_vinotify_handle_msg: tstamp:38850834448 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:196128326 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.676699: rtos_queue_peek_from_isr_failed: tstamp:38851061434 queue:0x0b4a3c58
kworker/0:2-2803 [000] ...1 1232.676709: rtcpu_vinotify_handle_msg: tstamp:38851355730 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:196649155 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.728372: rtcpu_vinotify_handle_msg: tstamp:38851876563 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:197169985 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.728387: rtcpu_vinotify_handle_msg: tstamp:38852397389 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:197690813 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.728396: rtcpu_vinotify_handle_msg: tstamp:38852918220 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:198211642 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.780399: rtcpu_vinotify_handle_msg: tstamp:38853439052 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:198732471 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.780422: rtcpu_vinotify_handle_msg: tstamp:38853959877 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:199253301 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.780432: rtcpu_vinotify_handle_msg: tstamp:38854480708 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:199774130 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.832313: rtcpu_vinotify_handle_msg: tstamp:38855001603 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:200294959 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.832324: rtcpu_vinotify_handle_msg: tstamp:38855522363 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:200815787 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.832334: rtcpu_vinotify_handle_msg: tstamp:38856043194 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:201336616 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.832351: rtos_queue_peek_from_isr_failed: tstamp:38856061782 queue:0x0b4a3c58
kworker/0:2-2803 [000] ...1 1232.884349: rtcpu_vinotify_handle_msg: tstamp:38856564019 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:201857446 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.884360: rtcpu_vinotify_handle_msg: tstamp:38857084850 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:202378274 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.884370: rtcpu_vinotify_handle_msg: tstamp:38857605678 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:202899103 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.936338: rtcpu_vinotify_handle_msg: tstamp:38858126523 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:203419931 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.936348: rtcpu_vinotify_handle_msg: tstamp:38858647334 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:203940761 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.936357: rtcpu_vinotify_handle_msg: tstamp:38859168164 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:204461590 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.988338: rtcpu_vinotify_handle_msg: tstamp:38859688993 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:204982419 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.988351: rtcpu_vinotify_handle_msg: tstamp:38860209824 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:205503248 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.988360: rtcpu_vinotify_handle_msg: tstamp:38860730654 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:206024077 data:0x00400060
kworker/0:2-2803 [000] ...1 1232.988378: rtos_queue_peek_from_isr_failed: tstamp:38861062285 queue:0x0b4a3c58
kworker/0:2-2803 [000] ...1 1233.040646: rtcpu_vinotify_handle_msg: tstamp:38861251480 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:206544906 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.040704: rtcpu_vinotify_handle_msg: tstamp:38861772283 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:207065735 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.040714: rtcpu_vinotify_handle_msg: tstamp:38862293216 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:207586565 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.092317: rtcpu_vinotify_handle_msg: tstamp:38862813958 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:208107394 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.092323: rtcpu_vinotify_handle_msg: tstamp:38863334352 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:208628223 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.092326: rtcpu_vinotify_handle_msg: tstamp:38863855190 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:209149051 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.092327: rtcpu_vinotify_handle_msg: tstamp:38864375991 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:209669881 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.144412: rtcpu_vinotify_handle_msg: tstamp:38864897292 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:210190710 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.144431: rtcpu_vinotify_handle_msg: tstamp:38865418121 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:210711539 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.144440: rtcpu_vinotify_handle_msg: tstamp:38865938948 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:211232368 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.196388: rtos_queue_peek_from_isr_failed: tstamp:38866062799 queue:0x0b4a3c58
kworker/0:2-2803 [000] ...1 1233.196411: rtcpu_vinotify_handle_msg: tstamp:38866459777 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:211753196 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.196421: rtcpu_vinotify_handle_msg: tstamp:38866980145 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:212274025 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.196430: rtcpu_vinotify_handle_msg: tstamp:38867501434 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:212794855 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.248414: rtcpu_vinotify_handle_msg: tstamp:38868022263 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:213315683 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.248444: rtcpu_vinotify_handle_msg: tstamp:38868543111 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:213836513 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.248454: rtcpu_vinotify_handle_msg: tstamp:38869063924 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:214357342 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.300330: rtcpu_vinotify_handle_msg: tstamp:38869584289 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:214878170 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.300342: rtcpu_vinotify_handle_msg: tstamp:38870105649 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:215399000 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.300351: rtcpu_vinotify_handle_msg: tstamp:38870626414 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:215919829 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.352336: rtos_queue_peek_from_isr_failed: tstamp:38871063303 queue:0x0b4a3c58
kworker/0:2-2803 [000] ...1 1233.352346: rtcpu_vinotify_handle_msg: tstamp:38871147241 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:216440658 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.352356: rtcpu_vinotify_handle_msg: tstamp:38871668068 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:216961487 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.352366: rtcpu_vinotify_handle_msg: tstamp:38872188897 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:217482316 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.404332: rtcpu_vinotify_handle_msg: tstamp:38872709728 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:218003145 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.404347: rtcpu_vinotify_handle_msg: tstamp:38873230558 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:218523975 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.404357: rtcpu_vinotify_handle_msg: tstamp:38873751383 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:219044804 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.456375: rtcpu_vinotify_handle_msg: tstamp:38874272212 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:219565633 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.456386: rtcpu_vinotify_handle_msg: tstamp:38874793043 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:220086462 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.456395: rtcpu_vinotify_handle_msg: tstamp:38875313873 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:220607291 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.508615: rtcpu_vinotify_handle_msg: tstamp:38875834702 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:221128120 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.508659: rtos_queue_peek_from_isr_failed: tstamp:38876063813 queue:0x0b4a3c58
kworker/0:2-2803 [000] ...1 1233.508668: rtcpu_vinotify_handle_msg: tstamp:38876355529 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:221648949 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.508679: rtcpu_vinotify_handle_msg: tstamp:38876876361 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:222169779 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.560943: rtcpu_vinotify_handle_msg: tstamp:38877397222 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:222690608 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.560996: rtcpu_vinotify_handle_msg: tstamp:38877918013 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:223211436 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.561006: rtcpu_vinotify_handle_msg: tstamp:38878438842 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:223732265 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.561015: rtcpu_vinotify_handle_msg: tstamp:38878959656 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:224253094 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.612401: rtcpu_vinotify_handle_msg: tstamp:38879480795 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:224773924 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.612420: rtcpu_vinotify_handle_msg: tstamp:38879481827 tag:CHANSEL_SHORT_FRAME channel:0x01 frame:0 vi_tstamp:224773924 data:0x00000001
kworker/0:2-2803 [000] ...1 1233.612429: rtcpu_vinotify_handle_msg: tstamp:38879482871 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:224773927 data:0x00000001
kworker/0:2-2803 [000] ...1 1233.612439: rtcpu_vinotify_handle_msg: tstamp:38880001332 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:225294752 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.612449: rtcpu_vinotify_handle_msg: tstamp:38880522159 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:225815580 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.664360: rtcpu_vinotify_handle_msg: tstamp:38881042980 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:226336409 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.664407: rtos_queue_peek_from_isr_failed: tstamp:38881064309 queue:0x0b4a3c58
kworker/0:2-2803 [000] ...1 1233.664418: rtcpu_vinotify_handle_msg: tstamp:38881563814 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:226857237 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.664427: rtcpu_vinotify_handle_msg: tstamp:38882084639 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:227378065 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.716336: rtcpu_vinotify_handle_msg: tstamp:38882605468 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:227898895 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.716346: rtcpu_vinotify_handle_msg: tstamp:38883126298 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:228419724 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.716355: rtcpu_vinotify_handle_msg: tstamp:38883647127 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:228940554 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.768335: rtcpu_vinotify_handle_msg: tstamp:38884167961 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:229461382 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.768346: rtcpu_vinotify_handle_msg: tstamp:38884688788 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:229982210 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.768355: rtcpu_vinotify_handle_msg: tstamp:38885209617 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:230503039 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.820338: rtcpu_vinotify_handle_msg: tstamp:38885730444 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:231023866 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.820353: rtos_queue_peek_from_isr_failed: tstamp:38886064821 queue:0x0b4a3c58
kworker/0:2-2803 [000] ...1 1233.820363: rtcpu_vinotify_handle_msg: tstamp:38886251273 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:231544695 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.820372: rtcpu_vinotify_handle_msg: tstamp:38886772103 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:232065524 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.872324: rtcpu_vinotify_handle_msg: tstamp:38887292932 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:232586353 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.872332: rtcpu_vinotify_handle_msg: tstamp:38887813729 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:233107182 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.872334: rtcpu_vinotify_handle_msg: tstamp:38888334118 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:233628011 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.924285: rtcpu_vinotify_handle_msg: tstamp:38888854973 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:234148840 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.924288: rtcpu_vinotify_handle_msg: tstamp:38889375788 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:234669670 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.924290: rtcpu_vinotify_handle_msg: tstamp:38889896618 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:235190498 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.976293: rtcpu_vinotify_handle_msg: tstamp:38890417446 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:235711327 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.976296: rtcpu_vinotify_handle_msg: tstamp:38890938274 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:236232156 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.976301: rtos_queue_peek_from_isr_failed: tstamp:38891064870 queue:0x0b4a3c58
kworker/0:2-2803 [000] ...1 1233.976303: rtcpu_vinotify_handle_msg: tstamp:38891459110 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:236752985 data:0x00400060
kworker/0:2-2803 [000] ...1 1233.976305: rtcpu_vinotify_handle_msg: tstamp:38891979934 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:237273815 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.028655: rtcpu_vinotify_handle_msg: tstamp:38892500763 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:237794644 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.028702: rtcpu_vinotify_handle_msg: tstamp:38893022017 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:238315473 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.028714: rtcpu_vinotify_handle_msg: tstamp:38893542873 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:238836302 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.080458: rtcpu_vinotify_handle_msg: tstamp:38894063703 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:239357131 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.080473: rtcpu_vinotify_handle_msg: tstamp:38894584532 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:239877960 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.080482: rtcpu_vinotify_handle_msg: tstamp:38895105363 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:240398790 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.132369: rtcpu_vinotify_handle_msg: tstamp:38895626194 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:240919619 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.132408: rtos_queue_peek_from_isr_failed: tstamp:38896065829 queue:0x0b4a3c58
kworker/0:2-2803 [000] ...1 1234.132418: rtcpu_vinotify_handle_msg: tstamp:38896147022 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:241440448 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.132427: rtcpu_vinotify_handle_msg: tstamp:38896667845 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:241961276 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.184341: rtcpu_vinotify_handle_msg: tstamp:38897188678 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:242482105 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.184352: rtcpu_vinotify_handle_msg: tstamp:38897709508 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:243002935 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.184361: rtcpu_vinotify_handle_msg: tstamp:38898230335 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:243523764 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.236424: rtcpu_vinotify_handle_msg: tstamp:38898751164 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:244044593 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.236442: rtcpu_vinotify_handle_msg: tstamp:38899272072 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:244565423 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.236451: rtcpu_vinotify_handle_msg: tstamp:38899792836 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:245086251 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.288843: rtcpu_vinotify_handle_msg: tstamp:38900313632 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:245607081 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.288895: rtcpu_vinotify_handle_msg: tstamp:38900834016 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:246127910 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.288928: rtos_queue_peek_from_isr_failed: tstamp:38901065902 queue:0x0b4a3c58
kworker/0:2-2803 [000] ...1 1234.288937: rtcpu_vinotify_handle_msg: tstamp:38901355321 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:246648737 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.340411: rtcpu_vinotify_handle_msg: tstamp:38901876144 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:247169565 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.340421: rtcpu_vinotify_handle_msg: tstamp:38902396976 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:247690395 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.340433: rtcpu_vinotify_handle_msg: tstamp:38902917803 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:248211222 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.392408: rtcpu_vinotify_handle_msg: tstamp:38903438634 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:248732051 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.392418: rtcpu_vinotify_handle_msg: tstamp:38903959463 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:249252880 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.392429: rtcpu_vinotify_handle_msg: tstamp:38904480291 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:249773709 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.392438: rtcpu_vinotify_handle_msg: tstamp:38905001120 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:250294536 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.444382: rtcpu_vinotify_handle_msg: tstamp:38905521947 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:250815365 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.444393: rtcpu_vinotify_handle_msg: tstamp:38906042774 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:251336195 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.444406: rtos_queue_peek_from_isr_failed: tstamp:38906066851 queue:0x0b4a3c58
kworker/0:2-2803 [000] ...1 1234.444417: rtcpu_vinotify_handle_msg: tstamp:38906563667 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:251857024 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.496391: rtcpu_vinotify_handle_msg: tstamp:38907084428 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:252377852 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.496401: rtcpu_vinotify_handle_msg: tstamp:38907605255 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:252898681 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.496412: rtcpu_vinotify_handle_msg: tstamp:38908126083 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:253419509 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.548836: rtcpu_vinotify_handle_msg: tstamp:38908646887 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:253940339 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.548880: rtcpu_vinotify_handle_msg: tstamp:38909167743 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:254461167 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.548889: rtcpu_vinotify_handle_msg: tstamp:38909688566 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:254981995 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.601032: rtcpu_vinotify_handle_msg: tstamp:38910209400 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:255502825 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.601040: rtcpu_vinotify_handle_msg: tstamp:38910730195 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:256023653 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.601045: rtos_queue_peek_from_isr_failed: tstamp:38911067324 queue:0x0b4a3c58
kworker/0:2-2803 [000] ...1 1234.601048: rtcpu_vinotify_handle_msg: tstamp:38911250884 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:256544482 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.601049: rtcpu_vinotify_handle_msg: tstamp:38911251076 tag:CHANSEL_SHORT_FRAME channel:0x01 frame:0 vi_tstamp:256544482 data:0x00000001
kworker/0:2-2803 [000] ...1 1234.601052: rtcpu_vinotify_handle_msg: tstamp:38911251269 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:256544486 data:0x00000001
kworker/0:2-2803 [000] ...1 1234.652469: rtcpu_vinotify_handle_msg: tstamp:38911771433 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:257065311 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.652501: rtcpu_vinotify_handle_msg: tstamp:38912292248 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:257586140 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.652510: rtcpu_vinotify_handle_msg: tstamp:38912813547 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:258106969 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.704366: rtcpu_vinotify_handle_msg: tstamp:38913334374 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:258627797 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.704378: rtcpu_vinotify_handle_msg: tstamp:38913855204 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:259148626 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.704387: rtcpu_vinotify_handle_msg: tstamp:38914375575 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:259669456 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.756337: rtcpu_vinotify_handle_msg: tstamp:38914896858 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:260190284 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.756348: rtcpu_vinotify_handle_msg: tstamp:38915417692 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:260711113 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.756358: rtcpu_vinotify_handle_msg: tstamp:38915938523 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:261231941 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.756376: rtos_queue_peek_from_isr_failed: tstamp:38916067860 queue:0x0b4a3c58
kworker/0:2-2803 [000] ...1 1234.808365: rtcpu_vinotify_handle_msg: tstamp:38916459348 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:261752771 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.808379: rtcpu_vinotify_handle_msg: tstamp:38916980178 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:262273600 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.808389: rtcpu_vinotify_handle_msg: tstamp:38917501007 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:262794429 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.860330: rtcpu_vinotify_handle_msg: tstamp:38918021838 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:263315258 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.860341: rtcpu_vinotify_handle_msg: tstamp:38918542665 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:263836087 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.860351: rtcpu_vinotify_handle_msg: tstamp:38919063497 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:264356916 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.860360: rtcpu_vinotify_handle_msg: tstamp:38919584324 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:264877746 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.912444: rtcpu_vinotify_handle_msg: tstamp:38920105154 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:265398575 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.912467: rtcpu_vinotify_handle_msg: tstamp:38920625980 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:265919404 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.912500: rtos_queue_peek_from_isr_failed: tstamp:38921068430 queue:0x0b4a3c58
kworker/0:2-2803 [000] ...1 1234.912510: rtcpu_vinotify_handle_msg: tstamp:38921146808 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:266440233 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.964350: rtcpu_vinotify_handle_msg: tstamp:38921667183 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:266961063 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.964362: rtcpu_vinotify_handle_msg: tstamp:38922188467 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:267481891 data:0x00400060
kworker/0:2-2803 [000] ...1 1234.964371: rtcpu_vinotify_handle_msg: tstamp:38922709291 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:268002721 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.016654: rtcpu_vinotify_handle_msg: tstamp:38923230119 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:268523550 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.016695: rtcpu_vinotify_handle_msg: tstamp:38923750950 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:269044378 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.016705: rtcpu_vinotify_handle_msg: tstamp:38924271745 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:269565206 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.068338: rtcpu_vinotify_handle_msg: tstamp:38924792606 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:270086036 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.068346: rtcpu_vinotify_handle_msg: tstamp:38925313400 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:270606865 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.068348: rtcpu_vinotify_handle_msg: tstamp:38925833811 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:271127694 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.068355: rtos_queue_peek_from_isr_failed: tstamp:38926068431 queue:0x0b4a3c58
kworker/0:2-2803 [000] ...1 1235.120487: rtcpu_vinotify_handle_msg: tstamp:38926354749 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:271648523 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.120517: rtcpu_vinotify_handle_msg: tstamp:38926875924 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:272169353 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.120527: rtcpu_vinotify_handle_msg: tstamp:38927396754 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:272690181 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.172458: rtcpu_vinotify_handle_msg: tstamp:38927917583 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:273211011 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.172473: rtcpu_vinotify_handle_msg: tstamp:38928438769 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:273731840 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.172488: rtcpu_vinotify_handle_msg: tstamp:38928959248 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:274252669 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.224392: rtcpu_vinotify_handle_msg: tstamp:38929480078 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:274773497 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.224403: rtcpu_vinotify_handle_msg: tstamp:38930000903 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:275294326 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.224412: rtcpu_vinotify_handle_msg: tstamp:38930521734 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:275815156 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.276379: rtcpu_vinotify_handle_msg: tstamp:38931042563 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:276335985 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.276404: rtos_queue_peek_from_isr_failed: tstamp:38931069385 queue:0x0b4a3c58
kworker/0:2-2803 [000] ...1 1235.276414: rtcpu_vinotify_handle_msg: tstamp:38931563389 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:276856814 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.276423: rtcpu_vinotify_handle_msg: tstamp:38932084222 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:277377642 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.276432: rtcpu_vinotify_handle_msg: tstamp:38932605049 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:277898472 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.328396: rtcpu_vinotify_handle_msg: tstamp:38933125879 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:278419301 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.328407: rtcpu_vinotify_handle_msg: tstamp:38933646708 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:278940131 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.328417: rtcpu_vinotify_handle_msg: tstamp:38934167540 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:279460960 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.380389: rtcpu_vinotify_handle_msg: tstamp:38934688367 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:279981788 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.380402: rtcpu_vinotify_handle_msg: tstamp:38935209194 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:280502617 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.380411: rtcpu_vinotify_handle_msg: tstamp:38935730023 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:281023446 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.432389: rtos_queue_peek_from_isr_failed: tstamp:38936069948 queue:0x0b4a3c58
kworker/0:2-2803 [000] ...1 1235.432400: rtcpu_vinotify_handle_msg: tstamp:38936250848 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:281544274 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.432409: rtcpu_vinotify_handle_msg: tstamp:38936771675 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:282065104 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.432418: rtcpu_vinotify_handle_msg: tstamp:38937292507 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:282585932 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.484341: rtcpu_vinotify_handle_msg: tstamp:38937813309 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:283106762 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.484348: rtcpu_vinotify_handle_msg: tstamp:38938333701 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:283627591 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.484350: rtcpu_vinotify_handle_msg: tstamp:38938854556 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:284148420 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.536479: rtcpu_vinotify_handle_msg: tstamp:38939375370 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:284669250 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.536522: rtcpu_vinotify_handle_msg: tstamp:38939896628 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:285190079 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.536531: rtcpu_vinotify_handle_msg: tstamp:38940417483 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:285710908 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.588314: rtcpu_vinotify_handle_msg: tstamp:38940938314 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:286231738 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.588327: rtos_queue_peek_from_isr_failed: tstamp:38941070394 queue:0x0b4a3c58
kworker/0:2-2803 [000] ...1 1235.588330: rtcpu_vinotify_handle_msg: tstamp:38941459143 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:286752567 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.588333: rtcpu_vinotify_handle_msg: tstamp:38941979969 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:287273396 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.640361: rtcpu_vinotify_handle_msg: tstamp:38942500641 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:287794225 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.640376: rtcpu_vinotify_handle_msg: tstamp:38942500830 tag:CHANSEL_SHORT_FRAME channel:0x01 frame:0 vi_tstamp:287794225 data:0x00000001
kworker/0:2-2803 [000] ...1 1235.640386: rtcpu_vinotify_handle_msg: tstamp:38942501025 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:287794227 data:0x00000001
kworker/0:2-2803 [000] ...1 1235.640394: rtcpu_vinotify_handle_msg: tstamp:38943021637 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:288315053 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.640404: rtcpu_vinotify_handle_msg: tstamp:38943542462 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:288835881 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.692353: rtcpu_vinotify_handle_msg: tstamp:38944063289 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:289356710 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.692372: rtcpu_vinotify_handle_msg: tstamp:38944584122 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:289877537 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.692382: rtcpu_vinotify_handle_msg: tstamp:38945104946 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:290398366 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.692391: rtcpu_vinotify_handle_msg: tstamp:38945625774 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:290919196 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.744367: rtos_queue_peek_from_isr_failed: tstamp:38946070908 queue:0x0b4a3c58
kworker/0:2-2803 [000] ...1 1235.744386: rtcpu_vinotify_handle_msg: tstamp:38946146608 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:291440025 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.744395: rtcpu_vinotify_handle_msg: tstamp:38946667436 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:291960853 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.744405: rtcpu_vinotify_handle_msg: tstamp:38947188263 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:292481681 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.796361: rtcpu_vinotify_handle_msg: tstamp:38947709088 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:293002511 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.796373: rtcpu_vinotify_handle_msg: tstamp:38948229919 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:293523339 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.796382: rtcpu_vinotify_handle_msg: tstamp:38948750748 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:294044166 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.848368: rtcpu_vinotify_handle_msg: tstamp:38949271574 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:294564996 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.848378: rtcpu_vinotify_handle_msg: tstamp:38949792407 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:295085824 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.848388: rtcpu_vinotify_handle_msg: tstamp:38950313296 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:295606653 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.900340: rtcpu_vinotify_handle_msg: tstamp:38950834055 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:296127482 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.900362: rtos_queue_peek_from_isr_failed: tstamp:38951071408 queue:0x0b4a3c58
kworker/0:2-2803 [000] ...1 1235.900372: rtcpu_vinotify_handle_msg: tstamp:38951354887 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:296648311 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.900387: rtcpu_vinotify_handle_msg: tstamp:38951875715 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:297169141 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.952328: rtcpu_vinotify_handle_msg: tstamp:38952396543 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:297689970 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.952340: rtcpu_vinotify_handle_msg: tstamp:38952917370 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:298210799 data:0x00400060
kworker/0:2-2803 [000] ...1 1235.952350: rtcpu_vinotify_handle_msg: tstamp:38953438205 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:298731629 data:0x00400060
kworker/0:2-2803 [000] ...1 1236.004328: rtcpu_vinotify_handle_msg: tstamp:38953959033 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:299252458 data:0x00400060
kworker/0:2-2803 [000] ...1 1236.004338: rtcpu_vinotify_handle_msg: tstamp:38954479863 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:299773288 data:0x00400060
kworker/0:2-2803 [000] ...1 1236.004349: rtcpu_vinotify_handle_msg: tstamp:38955000688 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:300294116 data:0x00400060
kworker/0:2-2803 [000] ...1 1236.056367: rtcpu_vinotify_handle_msg: tstamp:38955521492 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:300814946 data:0x00400060
kworker/0:2-2803 [000] ...1 1236.056377: rtcpu_vinotify_handle_msg: tstamp:38956041893 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:301335776 data:0x00400060
kworker/0:2-2803 [000] ...1 1236.056383: rtos_queue_peek_from_isr_failed: tstamp:38956071458 queue:0x0b4a3c58
kworker/0:2-2803 [000] ...1 1236.056386: rtcpu_vinotify_handle_msg: tstamp:38956562725 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:301856605 data:0x00400060
kworker/0:2-2803 [000] ...1 1236.108381: rtcpu_vinotify_handle_msg: tstamp:38957083553 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:302377434 data:0x00400060
kworker/0:2-2803 [000] ...1 1236.108408: rtcpu_vinotify_handle_msg: tstamp:38957604389 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:302898263 data:0x00400060
kworker/0:2-2803 [000] ...1 1236.108417: rtcpu_vinotify_handle_msg: tstamp:38958125672 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:303419091 data:0x00400060
kworker/0:2-2803 [000] ...1 1236.160300: rtcpu_vinotify_handle_msg: tstamp:38958646499 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:303939920 data:0x00400060
kworker/0:2-2803 [000] ...1 1236.160313: rtcpu_vinotify_handle_msg: tstamp:38959167328 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:304460750 data:0x00400060
kworker/0:2-2803 [000] ...1 1236.160322: rtcpu_vinotify_handle_msg: tstamp:38959688162 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:304981579 data:0x00400060
kworker/0:2-2803 [000] ...1 1236.160332: rtcpu_vinotify_handle_msg: tstamp:38960208984 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:305502409 data:0x00400060
kworker/0:2-2803 [000] ...1 1236.212348: rtcpu_vinotify_handle_msg: tstamp:38960729816 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:306023238 data:0x00400060
kworker/0:2-2803 [000] ...1 1236.212371: rtos_queue_peek_from_isr_failed: tstamp:38961072421 queue:0x0b4a3c58
kworker/0:2-2803 [000] ...1 1236.212380: rtcpu_vinotify_handle_msg: tstamp:38961250647 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:306544068 data:0x00400060
kworker/0:2-2803 [000] ...1 1236.212389: rtcpu_vinotify_handle_msg: tstamp:38961771474 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:307064898 data:0x00400060
kworker/0:2-2803 [000] ...1 1236.264732: rtcpu_vinotify_handle_msg: tstamp:38962292306 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:307585726 data:0x00400060
kworker/0:2-2803 [000] ...1 1236.264780: rtcpu_vinotify_handle_msg: tstamp:38962813108 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:308106556 data:0x00400060
kworker/0:2-2803 [000] ...1 1236.264789: rtcpu_vinotify_handle_msg: tstamp:38963333936 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:308627386 data:0x00400060
kworker/0:2-2803 [000] ...1 1236.316375: rtcpu_vinotify_handle_msg: tstamp:38963854378 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:309148215 data:0x00400060
kworker/0:2-2803 [000] ...1 1236.316382: rtcpu_vinotify_handle_msg: tstamp:38964375162 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:309669045 data:0x00400060
kworker/0:2-2803 [000] ...1 1236.316384: rtcpu_vinotify_handle_msg: tstamp:38964895990 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:310189873 data:0x00400060
kworker/0:2-2803 [000] ...1 1236.368328: rtcpu_vinotify_handle_msg: tstamp:38965416827 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:310710701 data:0x00400060
kworker/0:2-2803 [000] ...1 1236.368331: rtcpu_vinotify_handle_msg: tstamp:38965937648 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:311231530 data:0x00400060
kworker/0:2-2803 [000] ...1 1236.368337: rtos_queue_peek_from_isr_failed: tstamp:38966072471 queue:0x0b4a3c58
kworker/0:2-2803 [000] ...1 1236.368339: rtcpu_vinotify_handle_msg: tstamp:38966458475 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:311752358 data:0x00400060
kworker/0:2-2803 [000] ...1 1236.420327: rtcpu_vinotify_handle_msg: tstamp:38966979308 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:312273187 data:0x00400060
kworker/0:2-2803 [000] ...1 1236.420330: rtcpu_vinotify_handle_msg: tstamp:38967500133 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:312794015 data:0x00400060
kworker/0:2-2803 [000] ...1 1236.420332: rtcpu_vinotify_handle_msg: tstamp:38968020963 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:313314843 data:0x00400060
kworker/0:2-2803 [000] ...1 1236.472325: rtcpu_vinotify_handle_msg: tstamp:38968541792 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:313835672 data:0x00400060
kworker/0:2-2803 [000] ...1 1236.472328: rtcpu_vinotify_handle_msg: tstamp:38969062620 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:314356500 data:0x00400060
kworker/0:2-2803 [000] ...1 1236.472330: rtcpu_vinotify_handle_msg: tstamp:38969583445 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:314877328 data:0x00400060
kworker/0:2-2803 [000] ...1 1236.524626: rtcpu_vinotify_handle_msg: tstamp:38970104278 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:315398157 data:0x00400060
kworker/0:2-2803 [000] ...1 1236.524682: rtcpu_vinotify_handle_msg: tstamp:38970625103 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:315918986 data:0x00400060
kworker/0:2-2803 [000] ...1 1236.524715: rtos_queue_peek_from_isr_failed: tstamp:38971072967 queue:0x0b4a3c58
kworker/0:2-2803 [000] ...1 1236.524724: rtcpu_vinotify_handle_msg: tstamp:38971146401 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:316439815 data:0x00400060
kworker/0:2-2803 [000] ...1 1236.580435: rtcpu_vinotify_handle_msg: tstamp:38971667214 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:316960643 data:0x00400060
kworker/0:2-2803 [000] ...1 1236.580481: rtcpu_vinotify_handle_msg: tstamp:38972188045 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:317481471 data:0x00400060
kworker/0:2-2803 [000] ...1 1236.580490: rtcpu_vinotify_handle_msg: tstamp:38972708947 tag:CSIMUX_FRAME channel:0x00 frame:0 vi_tstamp:318002300 data:0x00400060
kworker/0:2-2803 [000] ...1 1236.580515: rtos_queue_peek_from_isr_failed: tstamp:38972996119 queue:0x0b4a3c58
root@tegra-ubuntu:/home/nvidia#
Disabled the ECC checks, now we can get the video, and the gstreamer pipelines
RGB888 3_3 Video Stream GSTREAMER
gst-launch-1.0 v4l2src device=/dev/video0 ! videorate max-rate=60 ! videoconvert ! omxh265enc qp-range=30,50:30,50:30,50 control-rate=4 bitrate=6000000 ! "video/x-h265, stream-format=(string)byte-stream" ! rtph265pay mtu=1400 ! udpsink host=192.168.1.100 port=5600 sync=false async=false
RGB888 3_3 Video Play GSTREAMER
gst-launch-1.0 udpsrc port=5600 ! application/x-rtp, encoding-name=H265, payload=96 ! rtph265depay ! h265parse ! queue ! avdec_h265 ! xvimagesink sync = false
Work perfectly. But it feels like it’s fps is lower than intended.
When we used;
nvidia@tegra-ubuntu:~$ v4l2-ctl --set-fmt-video=width=1280,height=720,pixelformat=BGRA --set-ctrl bypass_mode=0 --stream-mmap --stream-count=100 -d /dev/video0 --stream-to=ov491.raw
<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<< 30.69 fps
<<<<<<<<<<<<<<<<<<<<<<<<<<<<<< 30.34 fps
<<<<<<<<<<<<<<<<<<<<<<<<<<<<<< 30.23 fps
<<<<<<<<
nvidia@tegra-ubuntu:~$
It reports 30 fps as well, whereas the pattern generator generates at 60 fps.
[ 7701.632368] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 7702.658090] ov5693 2-0046: camera_common_try_fmt: size 1 x 1
[ 7702.663789] ov5693 2-0046: camera_common_try_fmt: invalid resolution supplied to set mode 1280 720
[ 7702.672863] ov5693 2-0046: camera_common_try_fmt: size 32768 x 32768
[ 7702.679284] ov5693 2-0046: camera_common_try_fmt: invalid resolution supplied to set mode 1280 720
[ 7702.688332] ov5693 2-0046: camera_common_try_fmt: size 1280 x 720
[ 7702.694470] ov5693 2-0046: camera_common_try_fmt: size 1280 x 720
[ 7702.700625] ov5693 2-0046: camera_common_try_fmt: size 1280 x 720
[ 7702.706803] ov5693 2-0046: camera_common_try_fmt: size 1 x 1
[ 7702.712490] ov5693 2-0046: camera_common_try_fmt: invalid resolution supplied to set mode 1280 720
[ 7702.721483] ov5693 2-0046: camera_common_try_fmt: size 8 x 2
[ 7702.727187] ov5693 2-0046: camera_common_try_fmt: invalid resolution supplied to set mode 1280 720
[ 7702.736169] ov5693 2-0046: camera_common_try_fmt: size 32768 x 32768
[ 7702.742546] ov5693 2-0046: camera_common_try_fmt: invalid resolution supplied to set mode 1280 720
[ 7702.751524] ov5693 2-0046: camera_common_try_fmt: size 32775 x 32769
[ 7702.757899] ov5693 2-0046: camera_common_try_fmt: invalid resolution supplied to set mode 1280 720
[ 7702.766894] ov5693 2-0046: camera_common_try_fmt: size 1280 x 720
[ 7702.773025] ov5693 2-0046: camera_common_try_fmt: size 1280 x 720
[ 7702.779178] ov5693 2-0046: camera_common_try_fmt: size 1280 x 720
[ 7702.785348] ov5693 2-0046: camera_common_try_fmt: size 1 x 1
[ 7702.791014] ov5693 2-0046: camera_common_try_fmt: invalid resolution supplied to set mode 1280 720
[ 7702.799973] ov5693 2-0046: camera_common_try_fmt: size 8 x 2
[ 7702.805634] ov5693 2-0046: camera_common_try_fmt: invalid resolution supplied to set mode 1280 720
[ 7702.814594] ov5693 2-0046: camera_common_try_fmt: size 32768 x 32768
[ 7702.820946] ov5693 2-0046: camera_common_try_fmt: invalid resolution supplied to set mode 1280 720
[ 7702.829904] ov5693 2-0046: camera_common_try_fmt: size 32775 x 32769
[ 7702.836258] ov5693 2-0046: camera_common_try_fmt: invalid resolution supplied to set mode 1280 720
[ 7702.845226] ov5693 2-0046: camera_common_try_fmt: size 1280 x 720
[ 7702.851326] ov5693 2-0046: camera_common_try_fmt: size 1280 x 720
[ 7702.857432] ov5693 2-0046: camera_common_try_fmt: size 1280 x 720
[ 7702.863544] ov5693 2-0046: camera_common_try_fmt: size 1 x 1
[ 7702.869208] ov5693 2-0046: camera_common_try_fmt: invalid resolution supplied to set mode 1280 720
[ 7702.878163] ov5693 2-0046: camera_common_try_fmt: size 8 x 2
[ 7702.883826] ov5693 2-0046: camera_common_try_fmt: invalid resolution supplied to set mode 1280 720
[ 7702.892781] ov5693 2-0046: camera_common_try_fmt: size 32768 x 32768
[ 7702.899138] ov5693 2-0046: camera_common_try_fmt: invalid resolution supplied to set mode 1280 720
[ 7702.908093] ov5693 2-0046: camera_common_try_fmt: size 32775 x 32769
[ 7702.914464] ov5693 2-0046: camera_common_try_fmt: invalid resolution supplied to set mode 1280 720
[ 7702.923430] ov5693 2-0046: camera_common_try_fmt: size 1280 x 720
[ 7702.929534] ov5693 2-0046: camera_common_try_fmt: size 1280 x 720
[ 7702.935637] ov5693 2-0046: camera_common_try_fmt: size 1280 x 720
[ 7702.941745] ov5693 2-0046: camera_common_try_fmt: size 1 x 1
[ 7702.947405] ov5693 2-0046: camera_common_try_fmt: invalid resolution supplied to set mode 1280 720
[ 7702.956364] ov5693 2-0046: camera_common_try_fmt: size 8 x 2
[ 7702.962022] ov5693 2-0046: camera_common_try_fmt: invalid resolution supplied to set mode 1280 720
[ 7702.970979] ov5693 2-0046: camera_common_try_fmt: size 32768 x 32768
[ 7702.977333] ov5693 2-0046: camera_common_try_fmt: invalid resolution supplied to set mode 1280 720
[ 7702.986291] ov5693 2-0046: camera_common_try_fmt: size 32775 x 32769
[ 7702.992647] ov5693 2-0046: camera_common_try_fmt: invalid resolution supplied to set mode 1280 720
[ 7703.001640] ov5693 2-0046: camera_common_try_fmt: size 1280 x 720
[ 7703.007752] ov5693 2-0046: camera_common_try_fmt: size 1280 x 720
[ 7703.013868] ov5693 2-0046: camera_common_try_fmt: size 1280 x 720
[ 7703.021055] ov5693 2-0046: camera_common_try_fmt: size 1280 x 720
[ 7703.027158] ov5693 2-0046: camera_common_try_fmt: size 1280 x 720
[ 7703.033258] ov5693 2-0046: camera_common_s_fmt(4106) size 1280 x 720
[ 7703.039612] ov5693 2-0046: camera_common_try_fmt: size 1280 x 720
[ 7703.059764] ov5693 2-0046: camera_common_g_fmt++
The kernel logs are like this.
And the trace is;
root@tegra-ubuntu:/home/nvidia# cat /sys/kernel/debug/tracing/trace
# tracer: nop
#
# entries-in-buffer/entries-written: 698/698 #P:4
#
# _-----=> irqs-off
# / _----=> need-resched
# | / _---=> hardirq/softirq
# || / _--=> preempt-depth
# ||| / delay
# TASK-PID CPU# |||| TIMESTAMP FUNCTION
# | | | |||| | |
kworker/0:1-3543 [000] ...1 8155.240258: rtcpu_vinotify_handle_msg: tstamp:255180020507 tag:CHANSEL_PXL_SOF channel:0x00 frame:0 vi_tstamp:1776949496 data:0x00000001
kworker/0:1-3543 [000] ...1 8155.240262: rtcpu_vinotify_handle_msg: tstamp:255180020665 tag:ATOMP_FS channel:0x00 frame:0 vi_tstamp:1776949504 data:0x00000000
kworker/0:1-3543 [000] ...1 8155.240262: rtcpu_vinotify_handle_msg: tstamp:255180520220 tag:CHANSEL_PXL_EOF channel:0x00 frame:0 vi_tstamp:1777449350 data:0x02cf0002
kworker/0:1-3543 [000] ...1 8155.240263: rtcpu_vinotify_handle_msg: tstamp:255180541148 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:1777470235 data:0x00000000
kworker/0:1-3543 [000] ...1 8155.292273: rtos_queue_peek_from_isr_failed: tstamp:255182538960 queue:0x0b4a3c58
kworker/0:1-3543 [000] ...1 8155.292276: rtcpu_vinotify_handle_msg: tstamp:255182624611 tag:CHANSEL_PXL_SOF channel:0x00 frame:0 vi_tstamp:1779553610 data:0x00000001
kworker/0:1-3543 [000] ...1 8155.292277: rtcpu_vinotify_handle_msg: tstamp:255182624758 tag:ATOMP_FS channel:0x00 frame:0 vi_tstamp:1779553618 data:0x00000000
kworker/0:1-3543 [000] ...1 8155.292278: rtcpu_vinotify_handle_msg: tstamp:255183124346 tag:CHANSEL_PXL_EOF channel:0x00 frame:0 vi_tstamp:1780053464 data:0x02cf0002
kworker/0:1-3543 [000] ...1 8155.292278: rtcpu_vinotify_handle_msg: tstamp:255183145275 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:1780074348 data:0x00000000
kworker/0:1-3543 [000] ...1 8155.396271: rtcpu_vinotify_handle_msg: tstamp:255185228732 tag:CHANSEL_PXL_SOF channel:0x00 frame:0 vi_tstamp:1782157724 data:0x00000001
kworker/0:1-3543 [000] ...1 8155.396274: rtcpu_vinotify_handle_msg: tstamp:255185228892 tag:ATOMP_FS channel:0x00 frame:0 vi_tstamp:1782157732 data:0x00000000
kworker/0:1-3543 [000] ...1 8155.396275: rtcpu_vinotify_handle_msg: tstamp:255185728447 tag:CHANSEL_PXL_EOF channel:0x00 frame:0 vi_tstamp:1782657577 data:0x02cf0002
kworker/0:1-3543 [000] ...1 8155.396275: rtcpu_vinotify_handle_msg: tstamp:255185749386 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:1782678462 data:0x00000000
kworker/0:1-3543 [000] ...1 8155.448265: rtos_queue_peek_from_isr_failed: tstamp:255187539447 queue:0x0b4a3c58
kworker/0:1-3543 [000] ...1 8155.448269: rtcpu_vinotify_handle_msg: tstamp:255187832847 tag:CHANSEL_PXL_SOF channel:0x00 frame:0 vi_tstamp:1784761837 data:0x00000001
kworker/0:1-3543 [000] ...1 8155.448270: rtcpu_vinotify_handle_msg: tstamp:255187833002 tag:ATOMP_FS channel:0x00 frame:0 vi_tstamp:1784761845 data:0x00000000
kworker/0:1-3543 [000] ...1 8155.500257: rtcpu_vinotify_handle_msg: tstamp:255188332570 tag:CHANSEL_PXL_EOF channel:0x00 frame:0 vi_tstamp:1785261691 data:0x02cf0002
kworker/0:1-3543 [000] ...1 8155.500259: rtcpu_vinotify_handle_msg: tstamp:255188353503 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:1785282575 data:0x00000000
kworker/0:1-3543 [000] ...1 8155.552267: rtcpu_vinotify_handle_msg: tstamp:255190436954 tag:CHANSEL_PXL_SOF channel:0x00 frame:0 vi_tstamp:1787365951 data:0x00000001
kworker/0:1-3543 [000] ...1 8155.552270: rtcpu_vinotify_handle_msg: tstamp:255190437114 tag:ATOMP_FS channel:0x00 frame:0 vi_tstamp:1787365960 data:0x00000000
kworker/0:1-3543 [000] ...1 8155.552271: rtcpu_vinotify_handle_msg: tstamp:255190936677 tag:CHANSEL_PXL_EOF channel:0x00 frame:0 vi_tstamp:1787865804 data:0x02cf0002
kworker/0:1-3543 [000] ...1 8155.552271: rtcpu_vinotify_handle_msg: tstamp:255190957604 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:1787886690 data:0x00000000
kworker/0:1-3543 [000] ...1 8155.604267: rtos_queue_peek_from_isr_failed: tstamp:255192539949 queue:0x0b4a3c58
kworker/0:1-3543 [000] ...1 8155.656263: rtcpu_vinotify_handle_msg: tstamp:255193041073 tag:CHANSEL_PXL_SOF channel:0x00 frame:0 vi_tstamp:1789970065 data:0x00000001
kworker/0:1-3543 [000] ...1 8155.656265: rtcpu_vinotify_handle_msg: tstamp:255193041233 tag:ATOMP_FS channel:0x00 frame:0 vi_tstamp:1789970073 data:0x00000000
kworker/0:1-3543 [000] ...1 8155.656265: rtcpu_vinotify_handle_msg: tstamp:255193540810 tag:CHANSEL_PXL_EOF channel:0x00 frame:0 vi_tstamp:1790469919 data:0x02cf0002
kworker/0:1-3543 [000] ...1 8155.656266: rtcpu_vinotify_handle_msg: tstamp:255193561729 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:1790490803 data:0x00000000
kworker/0:1-3543 [000] ...1 8155.708265: rtcpu_vinotify_handle_msg: tstamp:255195645176 tag:CHANSEL_PXL_SOF channel:0x00 frame:0 vi_tstamp:1792574178 data:0x00000001
kworker/0:1-3543 [000] ...1 8155.708268: rtcpu_vinotify_handle_msg: tstamp:255195645331 tag:ATOMP_FS channel:0x00 frame:0 vi_tstamp:1792574186 data:0x00000000
kworker/0:1-3543 [000] ...1 8155.708269: rtcpu_vinotify_handle_msg: tstamp:255196144913 tag:CHANSEL_PXL_EOF channel:0x00 frame:0 vi_tstamp:1793074032 data:0x02cf0002
kworker/0:1-3543 [000] ...1 8155.708269: rtcpu_vinotify_handle_msg: tstamp:255196165830 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:1793094917 data:0x00000000
kworker/0:1-3543 [000] ...1 8155.760253: rtos_queue_peek_from_isr_failed: tstamp:255197540446 queue:0x0b4a3c58
kworker/0:1-3543 [000] ...1 8155.812245: rtcpu_vinotify_handle_msg: tstamp:255198249299 tag:CHANSEL_PXL_SOF channel:0x00 frame:0 vi_tstamp:1795178291 data:0x00000001
kworker/0:1-3543 [000] ...1 8155.812247: rtcpu_vinotify_handle_msg: tstamp:255198249460 tag:ATOMP_FS channel:0x00 frame:0 vi_tstamp:1795178299 data:0x00000000
kworker/0:1-3543 [000] ...1 8155.812248: rtcpu_vinotify_handle_msg: tstamp:255198749026 tag:CHANSEL_PXL_EOF channel:0x00 frame:0 vi_tstamp:1795678145 data:0x02cf0002
kworker/0:1-3543 [000] ...1 8155.812249: rtcpu_vinotify_handle_msg: tstamp:255198769956 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:1795699030 data:0x00000000
kworker/0:1-3543 [000] ...1 8155.864261: rtcpu_vinotify_handle_msg: tstamp:255200853405 tag:CHANSEL_PXL_SOF channel:0x00 frame:0 vi_tstamp:1797782404 data:0x00000001
kworker/0:1-3543 [000] ...1 8155.864264: rtcpu_vinotify_handle_msg: tstamp:255200853560 tag:ATOMP_FS channel:0x00 frame:0 vi_tstamp:1797782413 data:0x00000000
kworker/0:1-3543 [000] ...1 8155.916265: rtcpu_vinotify_handle_msg: tstamp:255201353153 tag:CHANSEL_PXL_EOF channel:0x00 frame:0 vi_tstamp:1798282258 data:0x02cf0002
kworker/0:1-3543 [000] ...1 8155.916268: rtcpu_vinotify_handle_msg: tstamp:255201374057 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:1798303144 data:0x00000000
kworker/0:1-3543 [000] ...1 8155.916270: rtos_queue_peek_from_isr_failed: tstamp:255202540925 queue:0x0b4a3c58
kworker/0:1-3543 [000] ...1 8155.968260: rtcpu_vinotify_handle_msg: tstamp:255203457522 tag:CHANSEL_PXL_SOF channel:0x00 frame:0 vi_tstamp:1800386518 data:0x00000001
kworker/0:1-3543 [000] ...1 8155.968263: rtcpu_vinotify_handle_msg: tstamp:255203457696 tag:ATOMP_FS channel:0x00 frame:0 vi_tstamp:1800386526 data:0x00000000
kworker/0:1-3543 [000] ...1 8155.968264: rtcpu_vinotify_handle_msg: tstamp:255203957250 tag:CHANSEL_PXL_EOF channel:0x00 frame:0 vi_tstamp:1800886372 data:0x02cf0002
kworker/0:1-3543 [000] ...1 8155.968264: rtcpu_vinotify_handle_msg: tstamp:255203978183 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:1800907256 data:0x00000000
kworker/0:1-3543 [000] ...1 8156.072256: rtcpu_vinotify_handle_msg: tstamp:255206061638 tag:CHANSEL_PXL_SOF channel:0x00 frame:0 vi_tstamp:1802990631 data:0x00000001
kworker/0:1-3543 [000] ...1 8156.072259: rtcpu_vinotify_handle_msg: tstamp:255206061787 tag:ATOMP_FS channel:0x00 frame:0 vi_tstamp:1802990640 data:0x00000000
kworker/0:1-3543 [000] ...1 8156.072259: rtcpu_vinotify_handle_msg: tstamp:255206561379 tag:CHANSEL_PXL_EOF channel:0x00 frame:0 vi_tstamp:1803490485 data:0x02cf0002
kworker/0:1-3543 [000] ...1 8156.072260: rtcpu_vinotify_handle_msg: tstamp:255206582296 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:1803511370 data:0x00000000
kworker/0:1-3543 [000] ...1 8156.072262: rtos_queue_peek_from_isr_failed: tstamp:255207541418 queue:0x0b4a3c58
kworker/0:1-3543 [000] ...1 8156.124253: rtcpu_vinotify_handle_msg: tstamp:255208665753 tag:CHANSEL_PXL_SOF channel:0x00 frame:0 vi_tstamp:1805594745 data:0x00000001
kworker/0:1-3543 [000] ...1 8156.124256: rtcpu_vinotify_handle_msg: tstamp:255208665902 tag:ATOMP_FS channel:0x00 frame:0 vi_tstamp:1805594753 data:0x00000000
kworker/0:1-3543 [000] ...1 8156.124257: rtcpu_vinotify_handle_msg: tstamp:255209165483 tag:CHANSEL_PXL_EOF channel:0x00 frame:0 vi_tstamp:1806094599 data:0x02cf0002
kworker/0:1-3543 [000] ...1 8156.124257: rtcpu_vinotify_handle_msg: tstamp:255209186396 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:1806115483 data:0x00000000
kworker/0:1-3543 [000] ...1 8156.228269: rtcpu_vinotify_handle_msg: tstamp:255211269867 tag:CHANSEL_PXL_SOF channel:0x00 frame:0 vi_tstamp:1808198858 data:0x00000001
kworker/0:1-3543 [000] ...1 8156.228272: rtcpu_vinotify_handle_msg: tstamp:255211270016 tag:ATOMP_FS channel:0x00 frame:0 vi_tstamp:1808198866 data:0x00000000
kworker/0:1-3543 [000] ...1 8156.228272: rtcpu_vinotify_handle_msg: tstamp:255211769593 tag:CHANSEL_PXL_EOF channel:0x00 frame:0 vi_tstamp:1808698712 data:0x02cf0002
kworker/0:1-3543 [000] ...1 8156.228273: rtcpu_vinotify_handle_msg: tstamp:255211790519 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:1808719597 data:0x00000000
kworker/0:1-3543 [000] ...1 8156.280263: rtos_queue_peek_from_isr_failed: tstamp:255212541910 queue:0x0b4a3c58
kworker/0:1-3543 [000] ...1 8156.280267: rtcpu_vinotify_handle_msg: tstamp:255213873974 tag:CHANSEL_PXL_SOF channel:0x00 frame:0 vi_tstamp:1810802971 data:0x00000001
kworker/0:1-3543 [000] ...1 8156.280268: rtcpu_vinotify_handle_msg: tstamp:255213874123 tag:ATOMP_FS channel:0x00 frame:0 vi_tstamp:1810802979 data:0x00000000
kworker/0:1-3543 [000] ...1 8156.332264: rtcpu_vinotify_handle_msg: tstamp:255214373718 tag:CHANSEL_PXL_EOF channel:0x00 frame:0 vi_tstamp:1811302825 data:0x02cf0002
kworker/0:1-3543 [000] ...1 8156.332266: rtcpu_vinotify_handle_msg: tstamp:255214394636 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:1811323710 data:0x00000000
kworker/0:1-3543 [000] ...1 8156.384263: rtcpu_vinotify_handle_msg: tstamp:255216478083 tag:CHANSEL_PXL_SOF channel:0x00 frame:0 vi_tstamp:1813407084 data:0x00000001
kworker/0:1-3543 [000] ...1 8156.384266: rtcpu_vinotify_handle_msg: tstamp:255216478226 tag:ATOMP_FS channel:0x00 frame:0 vi_tstamp:1813407093 data:0x00000000
kworker/0:1-3543 [000] ...1 8156.384266: rtcpu_vinotify_handle_msg: tstamp:255216977830 tag:CHANSEL_PXL_EOF channel:0x00 frame:0 vi_tstamp:1813906938 data:0x02cf0002
kworker/0:1-3543 [000] ...1 8156.384267: rtcpu_vinotify_handle_msg: tstamp:255216998747 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:1813927823 data:0x00000000
kworker/0:1-3543 [000] ...1 8156.436256: rtos_queue_peek_from_isr_failed: tstamp:255217542404 queue:0x0b4a3c58
kworker/0:1-3543 [000] ...1 8156.488269: rtcpu_vinotify_handle_msg: tstamp:255219082198 tag:CHANSEL_PXL_SOF channel:0x00 frame:0 vi_tstamp:1816011197 data:0x00000001
kworker/0:1-3543 [000] ...1 8156.488272: rtcpu_vinotify_handle_msg: tstamp:255219082342 tag:ATOMP_FS channel:0x00 frame:0 vi_tstamp:1816011206 data:0x00000000
kworker/0:1-3543 [000] ...1 8156.488272: rtcpu_vinotify_handle_msg: tstamp:255219581945 tag:CHANSEL_PXL_EOF channel:0x00 frame:0 vi_tstamp:1816511052 data:0x02cf0002
kworker/0:1-3543 [000] ...1 8156.488273: rtcpu_vinotify_handle_msg: tstamp:255219602863 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:1816531936 data:0x00000000
kworker/0:1-3543 [000] ...1 8156.540254: rtcpu_vinotify_handle_msg: tstamp:255222207143 tag:CHANSEL_PXL_SOF channel:0x00 frame:0 vi_tstamp:1819136133 data:0x00000001
kworker/0:1-3543 [000] ...1 8156.540257: rtcpu_vinotify_handle_msg: tstamp:255222207302 tag:ATOMP_FS channel:0x00 frame:0 vi_tstamp:1819136142 data:0x00000000
kworker/0:1-3543 [000] ...1 8156.592262: rtos_queue_peek_from_isr_failed: tstamp:255222542897 queue:0x0b4a3c58
The trace shows no any problem.
Double confirm the sensor really gen 60 fps.
We thought, the dmesg messages showing
[ 7701.632368] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 7702.658090] ov5693 2-0046: camera_common_try_fmt: size 1 x 1
[ 7702.663789] ov5693 2-0046: camera_common_try_fmt: invalid resolution supplied to set mode 1280 720
[ 7702.672863] ov5693 2-0046: camera_common_try_fmt: size 32768 x 32768
[ 7702.679284] ov5693 2-0046: camera_common_try_fmt: invalid resolution supplied to set mode 1280 720
[ 7702.863544] ov5693 2-0046: camera_common_try_fmt: size 1 x 1
[ 7702.869208] ov5693 2-0046: camera_common_try_fmt: invalid resolution supplied to set mode 1280 720
[ 7702.878163] ov5693 2-0046: camera_common_try_fmt: size 8 x 2
and
kworker/0:1-3543 [000] ...1 8155.240258: rtcpu_vinotify_handle_msg: tstamp:255180020507 tag:CHANSEL_PXL_SOF channel:0x00 frame:0 vi_tstamp:1776949496 data:0x00000001
kworker/0:1-3543 [000] ...1 8155.240262: rtcpu_vinotify_handle_msg: tstamp:255180020665 tag:ATOMP_FS channel:0x00 frame:0 vi_tstamp:1776949504 data:0x00000000
kworker/0:1-3543 [000] ...1 8155.240262: rtcpu_vinotify_handle_msg: tstamp:255180520220 tag:CHANSEL_PXL_EOF channel:0x00 frame:0 vi_tstamp:1777449350 data:0x02cf0002
kworker/0:1-3543 [000] ...1 8155.240263: rtcpu_vinotify_handle_msg: tstamp:255180541148 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:1777470235 data:0x00000000
kworker/0:1-3543 [000] ...1 8155.292273: : tstamp:255182538960 queue:0x0b4a3c58
can mean that our driver can’t catch Start Of Frame and End Of Frame’s, so that it mixes/stacks up the frames. Why else should kernel give an error of invalid resolution of 32768 x 32768 ? And 1x1 and 8x2? rtos_queue_peek_from_isr_failed? Can we ignore these?
Our FPGA engineer is sure that the FPGA is outputting 60 fps to the MIPI input of Tx1. How can we check it on oscilloscope? What do we need to look for?
Later, we also changed the driver to the YUYV2, to test with the real camera instead of the Pattern Generator.
Pattern Generator generated 60 RGB888 fps and we could only get 30.
Now, the camera generates 50 fps but we can only capture 25.
It always downsamples the FPS by 1/2. Do you know why is that?
same as:
https://devtalk.nvidia.com/default/topic/1027275/jetson-tx2/why-my-camera-in-tx2-always-12-496-fps-/
https://devtalk.nvidia.com/default/topic/1030053/jetson-tx2/framerate-and-latency-issues-questions-on-tx2/
https://devtalk.nvidia.com/default/topic/1026128/jetson-tx2/tegra-multimedia-apis-could-get-raw-image-via-v4l2-only-at-15fps/6
Followed the topics, but couldn’t find a solution.
You suggested boosting up the Tegra clock, (we did), no FPS increase.
You suggested writing to camera registers at init, (we didnt), since our CSI stream is fed from an FPGA.