Custom MIPI Camera:- Gstremaer error: streaming stopped, reason not-negotiated (-4)

Hi,
We have a custom MIPI camera board interfaced to the Jetson TX2i SOM on P3310 carrier board. The MIPI video output of the camera is similar to IMX219, operated in mode IMX219_3264x2464_21FPS. The custom camera board has no i2c line and the board starts streaming video as soon as it is powered on.

We are using tegra186-camera-e3326-a00.dtsi for device tree and OV5693 as a reference. for developing the driver. The driver had some problem initially but was solved here Driver for custom MIPI camera for Jetson TX2i - #8 by greivin.brenes and the driver was registered successfully.

[    3.780320] ov5693 2-0036: probing v4l2 sensor no i2c.
[    3.780359] ov5693 2-0036: Failed to find clocks
[    3.827153] ov5693 2-0036: tegracam sensor driver:ov5693_v2.0.6
[    3.827191] tegra-vi4 15700000.vi: subdev ov5693 2-0036 bound
[    3.850648] ov5693 2-0036: Detected OV5693 sensor
[    7.227548] ov5693 2-0036: ov5693_open:
[ 1620.221493] ov5693 2-0036: ov5693_open:

however, now I am getting the following error on using vte-developer@vtedeveloper-desktop:~$ gst-launch-1.0 v4l2src device=/dev/video0 ! videoconvert ! autovideosink:

vte-developer@vtedeveloper-desktop:~$ gst-launch-1.0 v4l2src device=/dev/video0 ! videoconvert ! autovideosink
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 stream error:
Additional debug info:
gstbasesrc.c(3055): gst_base_src_loop (): /GstPipeline:pipeline0/GstV4l2Src:v4l2src0:
streaming stopped, reason not-negotiated (-4)
Execution ended after 0:00:00.000675785
Setting pipeline to PAUSED ...
Setting pipeline to READY ...
Setting pipeline to NULL ...
Freeing pipeline ...
vte-developer@vtedeveloper-desktop:~$

Output for v4l2-ctl --list-formats-ext is:

vte-developer@vtedeveloper-desktop:~$ v4l2-ctl --list-formats-ext
ioctl: VIDIOC_ENUM_FMT
	Index       : 0
	Type        : Video Capture
	Pixel Format: 'RG10'
	Name        : 10-bit Bayer RGRG/GBGB
		Size: Discrete 3264x2464
			Interval: Discrete 0.048s (21.000 fps)

What should I do to debug this?

hello jetuser,

is this a bayer raw camera sensor? gst pipeline with v4l2src plugin doesn’t support with it.
you may refer to Camera Architecture Stack as see-also.

hence,
please have running Applications Using V4L2 IOCTL Directly, you may use V4L2 IOCTL to verify basic camera functionality.

Output for v4l2-ctl --set-fmt-video=width=3264,height=2464,pixelformat=RG10 --stream-mmap --stream-count=1 -d /dev/video0 --stream-to=ov5693.raw is: nothing, it is just stuck. dmesg output is as below:

[16902.385322] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[16902.391770] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[16902.605301] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[16902.611868] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[16902.825332] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[16902.831793] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[16903.045323] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[16903.051824] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[16903.265326] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[16903.271804] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[16903.485338] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[16903.491835] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[16903.705389] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[16903.711840] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[16903.925389] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[16903.931861] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel

and for v4l2-ctl -d /dev/video0 --set-fmt-video=width=3264,height=2464,pixelformat=RG10 --stream-mmap --set-ctrl bypass_mode=0 --stream-count=10 also, it is just stuck. dmesg output is:

[18061.691294] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[18061.697751] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[18061.911241] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[18061.917722] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[18062.131321] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[18062.137753] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[18062.351345] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[18062.357801] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[18062.571270] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[18062.577893] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel

what further should I do to resolve this?

UPDATE:
We have logged the trace as below:

     kworker/0:0-22411 [000] .... 27837.139140: rtos_queue_peek_from_isr_failed: tstamp:870187500114 queue:0x0b4b6398
 vi-output, ov56-24820 [004] .... 27837.180198: tegra_channel_capture_setup: vnc_id 0 W 3264 H 2464 fmt 20
 vi-output, ov56-24820 [004] .... 27837.180228: tegra_channel_capture_frame: sof:-549620698804.-271363728640
     kworker/0:0-22411 [000] .... 27837.195161: rtos_queue_send_from_isr_failed: tstamp:870189502008 queue:0x0b4a7698
     kworker/0:0-22411 [000] .... 27837.195168: rtos_queue_send_from_isr_failed: tstamp:870189502121 queue:0x0b4ab1a8
     kworker/0:0-22411 [000] .... 27837.195170: rtos_queue_send_from_isr_failed: tstamp:870189502231 queue:0x0b4acdd8
     kworker/0:0-22411 [000] .... 27837.195172: rtos_queue_send_from_isr_failed: tstamp:870189502337 queue:0x0b4ae958
     kworker/0:0-22411 [000] .... 27837.195175: rtos_queue_send_from_isr_failed: tstamp:870189502448 queue:0x0b4af718
     kworker/0:0-22411 [000] .... 27837.195177: rtos_queue_send_from_isr_failed: tstamp:870189502553 queue:0x0b4b04d8
     kworker/0:0-22411 [000] .... 27837.195179: rtos_queue_send_from_isr_failed: tstamp:870189502657 queue:0x0b4b1298
     kworker/0:0-22411 [000] .... 27837.195182: rtos_queue_send_from_isr_failed: tstamp:870189502764 queue:0x0b4b2058
     kworker/0:0-22411 [000] .... 27837.195185: rtos_queue_send_failed: tstamp:870189503338 queue:0x0b4a7698
     kworker/0:0-22411 [000] .... 27837.195187: rtos_queue_send_from_isr_failed: tstamp:870189509189 queue:0x0b4a7698
     kworker/0:0-22411 [000] .... 27837.195189: rtos_queue_send_from_isr_failed: tstamp:870189509307 queue:0x0b4ab1a8
     kworker/0:0-22411 [000] .... 27837.195192: rtos_queue_send_from_isr_failed: tstamp:870189509415 queue:0x0b4acdd8
     kworker/0:0-22411 [000] .... 27837.195194: rtos_queue_send_from_isr_failed: tstamp:870189509522 queue:0x0b4ae958
     kworker/0:0-22411 [000] .... 27837.195196: rtos_queue_send_from_isr_failed: tstamp:870189509629 queue:0x0b4af718
     kworker/0:0-22411 [000] .... 27837.195199: rtos_queue_send_from_isr_failed: tstamp:870189509732 queue:0x0b4b04d8
     kworker/0:0-22411 [000] .... 27837.195201: rtos_queue_send_from_isr_failed: tstamp:870189509844 queue:0x0b4b1298
     kworker/0:0-22411 [000] .... 27837.195203: rtos_queue_send_from_isr_failed: tstamp:870189509950 queue:0x0b4b2058
     kworker/0:0-22411 [000] .... 27837.195205: rtos_queue_send_failed: tstamp:870189510377 queue:0x0b4a7698
     kworker/0:0-22411 [000] .... 27837.195208: rtos_queue_send_from_isr_failed: tstamp:870189515221 queue:0x0b4a7698
     kworker/0:0-22411 [000] .... 27837.195210: rtos_queue_send_from_isr_failed: tstamp:870189515327 queue:0x0b4ab1a8
     kworker/0:0-22411 [000] .... 27837.195212: rtos_queue_send_from_isr_failed: tstamp:870189515434 queue:0x0b4acdd8
     kworker/0:0-22411 [000] .... 27837.195214: rtos_queue_send_from_isr_failed: tstamp:870189515540 queue:0x0b4ae958
     kworker/0:0-22411 [000] .... 27837.195216: rtos_queue_send_from_isr_failed: tstamp:870189515645 queue:0x0b4af718
     kworker/0:0-22411 [000] .... 27837.195219: rtos_queue_send_from_isr_failed: tstamp:870189515751 queue:0x0b4b04d8
     kworker/0:0-22411 [000] .... 27837.195221: rtos_queue_send_from_isr_failed: tstamp:870189515855 queue:0x0b4b1298
     kworker/0:0-22411 [000] .... 27837.195223: rtos_queue_send_from_isr_failed: tstamp:870189515972 queue:0x0b4b2058
     kworker/0:0-22411 [000] .... 27837.195225: rtos_queue_send_failed: tstamp:870189516410 queue:0x0b4a7698
     kworker/0:0-22411 [000] .... 27837.195227: rtos_queue_send_from_isr_failed: tstamp:870189519623 queue:0x0b4a7698
     kworker/0:0-22411 [000] .... 27837.195230: rtos_queue_send_from_isr_failed: tstamp:870189519731 queue:0x0b4ab1a8
     kworker/0:0-22411 [000] .... 27837.195232: rtos_queue_send_from_isr_failed: tstamp:870189519837 queue:0x0b4acdd8
     kworker/0:0-22411 [000] .... 27837.195234: rtos_queue_send_from_isr_failed: tstamp:870189519944 queue:0x0b4ae958
     kworker/0:0-22411 [000] .... 27837.195236: rtos_queue_send_from_isr_failed: tstamp:870189520049 queue:0x0b4af718
     kworker/0:0-22411 [000] .... 27837.195239: rtos_queue_send_from_isr_failed: tstamp:870189520152 queue:0x0b4b04d8
     kworker/0:0-22411 [000] .... 27837.195241: rtos_queue_send_from_isr_failed: tstamp:870189520259 queue:0x0b4b1298
     kworker/0:0-22411 [000] .... 27837.195243: rtos_queue_send_from_isr_failed: tstamp:870189520365 queue:0x0b4b2058
     kworker/0:0-22411 [000] .... 27837.195245: rtos_queue_send_failed: tstamp:870189521278 queue:0x0b4a7698
     kworker/0:0-22411 [000] .... 27837.307147: rtos_queue_peek_from_isr_failed: tstamp:870192500108 queue:0x0b4b6398
        v4l2-ctl-24819 [004] .... 27837.348631: tegra_channel_close: vi-output, ov5693 2-0036
 vi-output, ov56-24820 [004] .... 27837.399582: tegra_channel_capture_setup: vnc_id 0 W 3264 H 2464 fmt 20
 vi-output, ov56-24820 [004] .... 27837.399608: tegra_channel_capture_frame: sof:-549620698804.-271363728640
        v4l2-ctl-24819 [000] .... 27837.399870: tegra_channel_set_stream: enable : 0x0
        v4l2-ctl-24819 [000] .... 27837.399873: tegra_channel_set_stream: ov5693 2-0036 : 0x0
        v4l2-ctl-24819 [000] .... 27837.399909: tegra_channel_set_stream: 150c0000.nvcsi--1 : 0x0
        v4l2-ctl-24819 [000] .... 27837.399912: csi_s_stream: enable : 0x0
        v4l2-ctl-24819 [000] .... 27837.401634: tegra_channel_set_power: ov5693 2-0036 : 0x0
        v4l2-ctl-24819 [000] .... 27837.401641: camera_common_s_power: status : 0x0
        v4l2-ctl-24819 [000] .... 27837.401679: tegra_channel_set_power: 150c0000.nvcsi--1 : 0x0
        v4l2-ctl-24819 [000] .... 27837.401682: csi_s_power: enable : 0x0
     kworker/0:0-22411 [000] .... 27837.419067: rtos_queue_send_from_isr_failed: tstamp:870196366522 queue:0x0b4a7698
     kworker/0:0-22411 [000] .... 27837.419072: rtos_queue_send_from_isr_failed: tstamp:870196366642 queue:0x0b4ab1a8
     kworker/0:0-22411 [000] .... 27837.419074: rtos_queue_send_from_isr_failed: tstamp:870196366749 queue:0x0b4acdd8
     kworker/0:0-22411 [000] .... 27837.419075: rtos_queue_send_from_isr_failed: tstamp:870196366858 queue:0x0b4ae958
     kworker/0:0-22411 [000] .... 27837.419076: rtos_queue_send_from_isr_failed: tstamp:870196366963 queue:0x0b4af718
     kworker/0:0-22411 [000] .... 27837.419077: rtos_queue_send_from_isr_failed: tstamp:870196367068 queue:0x0b4b04d8
     kworker/0:0-22411 [000] .... 27837.419078: rtos_queue_send_from_isr_failed: tstamp:870196367175 queue:0x0b4b1298
     kworker/0:0-22411 [000] .... 27837.419079: rtos_queue_send_from_isr_failed: tstamp:870196367281 queue:0x0b4b2058
     kworker/0:0-22411 [000] .... 27837.419082: rtos_queue_send_failed: tstamp:870196367849 queue:0x0b4a7698
     kworker/0:0-22411 [000] .... 27837.419083: rtos_queue_send_from_isr_failed: tstamp:870196369991 queue:0x0b4a7698
     kworker/0:0-22411 [000] .... 27837.419084: rtos_queue_send_from_isr_failed: tstamp:870196370101 queue:0x0b4ab1a8
     kworker/0:0-22411 [000] .... 27837.419085: rtos_queue_send_from_isr_failed: tstamp:870196370209 queue:0x0b4acdd8
     kworker/0:0-22411 [000] .... 27837.419086: rtos_queue_send_from_isr_failed: tstamp:870196370315 queue:0x0b4ae958
     kworker/0:0-22411 [000] .... 27837.419087: rtos_queue_send_from_isr_failed: tstamp:870196370420 queue:0x0b4af718
     kworker/0:0-22411 [000] .... 27837.419089: rtos_queue_send_from_isr_failed: tstamp:870196370525 queue:0x0b4b04d8
     kworker/0:0-22411 [000] .... 27837.419090: rtos_queue_send_from_isr_failed: tstamp:870196370630 queue:0x0b4b1298
     kworker/0:0-22411 [000] .... 27837.419091: rtos_queue_send_from_isr_failed: tstamp:870196370735 queue:0x0b4b2058
     kworker/0:0-22411 [000] .... 27837.419092: rtos_queue_send_failed: tstamp:870196371168 queue:0x0b4a7698
     kworker/0:0-22411 [000] .... 27837.419093: rtos_queue_send_from_isr_failed: tstamp:870196374278 queue:0x0b4a7698
     kworker/0:0-22411 [000] .... 27837.419094: rtos_queue_send_from_isr_failed: tstamp:870196374384 queue:0x0b4ab1a8
     kworker/0:0-22411 [000] .... 27837.419095: rtos_queue_send_from_isr_failed: tstamp:870196374490 queue:0x0b4acdd8
     kworker/0:0-22411 [000] .... 27837.419097: rtos_queue_send_from_isr_failed: tstamp:870196374597 queue:0x0b4ae958
     kworker/0:0-22411 [000] .... 27837.419098: rtos_queue_send_from_isr_failed: tstamp:870196374706 queue:0x0b4af718
     kworker/0:0-22411 [000] .... 27837.419099: rtos_queue_send_from_isr_failed: tstamp:870196374816 queue:0x0b4b04d8
     kworker/0:0-22411 [000] .... 27837.419100: rtos_queue_send_from_isr_failed: tstamp:870196374922 queue:0x0b4b1298
     kworker/0:0-22411 [000] .... 27837.419101: rtos_queue_send_from_isr_failed: tstamp:870196375027 queue:0x0b4b2058
     kworker/0:0-22411 [000] .... 27837.419102: rtos_queue_send_failed: tstamp:870196375460 queue:0x0b4a7698

hello jetuser,

sensor is not outputting frames, or, there’s no SOF/EOF sending to CSI channel according to those logs.
can you confirm the sensor streaming? is it possible for setting up oscilloscope to probe the MIPI signals?

Hi @JerryChang,

I probed the signal and found that there was no signal on data lines, I have fixed that but still I don’t see anything when I use this: v4l2-ctl --set-fmt-video=width=3264,height=2464,pixelformat=RG10 --stream-mmap --stream-count=1 -d /dev/video0 --stream-to=ov5693.raw Trace log is as below:

root@vtedeveloper-desktop:/home/vte-developer# cat /sys/kernel/debug/tracing/trace
# tracer: nop
#
# entries-in-buffer/entries-written: 12/12   #P:6
#
#                              _-----=> irqs-off
#                             / _----=> need-resched
#                            | / _---=> hardirq/softirq
#                            || / _--=> preempt-depth
#                            ||| /     delay
#           TASK-PID   CPU#  ||||    TIMESTAMP  FUNCTION
#              | |       |   ||||       |         |
        v4l2-ctl-10467 [004] ....  1268.988832: v4l2_qbuf: minor = 0, index = 0, type = VIDEO_CAPTURE, bytesused = 16400384, flags = MAPPED|QUEUED|TIMESTAMP_UNKNOWN|TIMESTAMP_MONOTONIC, field = ANY, timestamp = 0, timecode = { type = 0x0, flags = , frames = 0, seconds = 0, minutes = 0, hours = 0, userbits = { 0 0 0 0 } }, sequence = 0
        v4l2-ctl-10467 [004] ....  1268.989533: v4l2_qbuf: minor = 0, index = 1, type = VIDEO_CAPTURE, bytesused = 16400384, flags = MAPPED|QUEUED|TIMESTAMP_UNKNOWN|TIMESTAMP_MONOTONIC, field = ANY, timestamp = 0, timecode = { type = 0x0, flags = , frames = 0, seconds = 0, minutes = 0, hours = 0, userbits = { 0 0 0 0 } }, sequence = 0
        v4l2-ctl-10467 [004] ....  1268.990224: v4l2_qbuf: minor = 0, index = 2, type = VIDEO_CAPTURE, bytesused = 16400384, flags = MAPPED|QUEUED|TIMESTAMP_UNKNOWN|TIMESTAMP_MONOTONIC, field = ANY, timestamp = 0, timecode = { type = 0x0, flags = , frames = 0, seconds = 0, minutes = 0, hours = 0, userbits = { 0 0 0 0 } }, sequence = 0
        v4l2-ctl-10467 [004] ....  1268.990909: v4l2_qbuf: minor = 0, index = 3, type = VIDEO_CAPTURE, bytesused = 16400384, flags = MAPPED|QUEUED|TIMESTAMP_UNKNOWN|TIMESTAMP_MONOTONIC, field = ANY, timestamp = 0, timecode = { type = 0x0, flags = , frames = 0, seconds = 0, minutes = 0, hours = 0, userbits = { 0 0 0 0 } }, sequence = 0
        v4l2-ctl-10471 [000] ....  1308.762976: v4l2_qbuf: minor = 0, index = 0, type = VIDEO_CAPTURE, bytesused = 16400384, flags = MAPPED|QUEUED|TIMESTAMP_UNKNOWN|TIMESTAMP_MONOTONIC, field = ANY, timestamp = 0, timecode = { type = 0x0, flags = , frames = 0, seconds = 0, minutes = 0, hours = 0, userbits = { 0 0 0 0 } }, sequence = 0
        v4l2-ctl-10471 [000] ....  1308.763673: v4l2_qbuf: minor = 0, index = 1, type = VIDEO_CAPTURE, bytesused = 16400384, flags = MAPPED|QUEUED|TIMESTAMP_UNKNOWN|TIMESTAMP_MONOTONIC, field = ANY, timestamp = 0, timecode = { type = 0x0, flags = , frames = 0, seconds = 0, minutes = 0, hours = 0, userbits = { 0 0 0 0 } }, sequence = 0
        v4l2-ctl-10471 [000] ....  1308.764364: v4l2_qbuf: minor = 0, index = 2, type = VIDEO_CAPTURE, bytesused = 16400384, flags = MAPPED|QUEUED|TIMESTAMP_UNKNOWN|TIMESTAMP_MONOTONIC, field = ANY, timestamp = 0, timecode = { type = 0x0, flags = , frames = 0, seconds = 0, minutes = 0, hours = 0, userbits = { 0 0 0 0 } }, sequence = 0
        v4l2-ctl-10471 [000] ....  1308.765097: v4l2_qbuf: minor = 0, index = 3, type = VIDEO_CAPTURE, bytesused = 16400384, flags = MAPPED|QUEUED|TIMESTAMP_UNKNOWN|TIMESTAMP_MONOTONIC, field = ANY, timestamp = 0, timecode = { type = 0x0, flags = , frames = 0, seconds = 0, minutes = 0, hours = 0, userbits = { 0 0 0 0 } }, sequence = 0
        v4l2-ctl-12178 [004] ....  5733.431061: v4l2_qbuf: minor = 0, index = 0, type = VIDEO_CAPTURE, bytesused = 16400384, flags = MAPPED|QUEUED|TIMESTAMP_UNKNOWN|TIMESTAMP_MONOTONIC, field = ANY, timestamp = 0, timecode = { type = 0x0, flags = , frames = 0, seconds = 0, minutes = 0, hours = 0, userbits = { 0 0 0 0 } }, sequence = 0
        v4l2-ctl-12178 [004] ....  5733.431789: v4l2_qbuf: minor = 0, index = 1, type = VIDEO_CAPTURE, bytesused = 16400384, flags = MAPPED|QUEUED|TIMESTAMP_UNKNOWN|TIMESTAMP_MONOTONIC, field = ANY, timestamp = 0, timecode = { type = 0x0, flags = , frames = 0, seconds = 0, minutes = 0, hours = 0, userbits = { 0 0 0 0 } }, sequence = 0
        v4l2-ctl-12178 [004] ....  5733.432528: v4l2_qbuf: minor = 0, index = 2, type = VIDEO_CAPTURE, bytesused = 16400384, flags = MAPPED|QUEUED|TIMESTAMP_UNKNOWN|TIMESTAMP_MONOTONIC, field = ANY, timestamp = 0, timecode = { type = 0x0, flags = , frames = 0, seconds = 0, minutes = 0, hours = 0, userbits = { 0 0 0 0 } }, sequence = 0
        v4l2-ctl-12178 [004] ....  5733.433194: v4l2_qbuf: minor = 0, index = 3, type = VIDEO_CAPTURE, bytesused = 16400384, flags = MAPPED|QUEUED|TIMESTAMP_UNKNOWN|TIMESTAMP_MONOTONIC, field = ANY, timestamp = 0, timecode = { type = 0x0, flags = , frames = 0, seconds = 0, minutes = 0, hours = 0, userbits = { 0 0 0 0 } }, sequence = 0

hello jetuser,

is this v4l pipeline complete or not?

Hi @JerryChang,

This is the only set of commands I used. I also used v4l2-ctl -d /dev/video0 --set-fmt-video=width=3264,height=2464,pixelformat=RG10 --stream-mmap --set-ctrl bypass_mode=0 --stream-count=10 but met with same trace log.

hello jetuser,

I’m wondering what’s happened on kernel side, please check… $ dmesg > klogs.txt

Hi @JerryChang ,

This my dmesg log. klog.txt (167.9 KB)

Irrespective of my FPGA is ON or NOT, I noticed same error when I use the below command.
v4l2-ctl --set-fmt-video=width=3264,height=2464,pixelformat=RG10 --stream-mmap --stream-count=1 -d /dev/video0 --stream-to=ov5693.raw
First 4 TASK-PID when the stream is ON and next 4 when it is OFF.

root@vtedeveloper-desktop:/home/vte-developer# cat /sys/kernel/debug/tracing/trace
# tracer: nop
#
# entries-in-buffer/entries-written: 8/8   #P:6
#
#                              _-----=> irqs-off
#                             / _----=> need-resched
#                            | / _---=> hardirq/softirq
#                            || / _--=> preempt-depth
#                            ||| /     delay
#           TASK-PID   CPU#  ||||    TIMESTAMP  FUNCTION
#              | |       |   ||||       |         |
        v4l2-ctl-22593 [005] .... 28766.180623: v4l2_qbuf: minor = 0, index = 0, type = VIDEO_CAPTURE, bytesused = 16400384, flags = MAPPED|QUEUED|TIMESTAMP_UNKNOWN|TIMESTAMP_MONOTONIC, field = ANY, timestamp = 0, timecode = { type = 0x0, flags = , frames = 0, seconds = 0, minutes = 0, hours = 0, userbits = { 0 0 0 0 } }, sequence = 0
        v4l2-ctl-22593 [005] .... 28766.181312: v4l2_qbuf: minor = 0, index = 1, type = VIDEO_CAPTURE, bytesused = 16400384, flags = MAPPED|QUEUED|TIMESTAMP_UNKNOWN|TIMESTAMP_MONOTONIC, field = ANY, timestamp = 0, timecode = { type = 0x0, flags = , frames = 0, seconds = 0, minutes = 0, hours = 0, userbits = { 0 0 0 0 } }, sequence = 0
        v4l2-ctl-22593 [005] .... 28766.182088: v4l2_qbuf: minor = 0, index = 2, type = VIDEO_CAPTURE, bytesused = 16400384, flags = MAPPED|QUEUED|TIMESTAMP_UNKNOWN|TIMESTAMP_MONOTONIC, field = ANY, timestamp = 0, timecode = { type = 0x0, flags = , frames = 0, seconds = 0, minutes = 0, hours = 0, userbits = { 0 0 0 0 } }, sequence = 0
        v4l2-ctl-22593 [005] .... 28766.182772: v4l2_qbuf: minor = 0, index = 3, type = VIDEO_CAPTURE, bytesused = 16400384, flags = MAPPED|QUEUED|TIMESTAMP_UNKNOWN|TIMESTAMP_MONOTONIC, field = ANY, timestamp = 0, timecode = { type = 0x0, flags = , frames = 0, seconds = 0, minutes = 0, hours = 0, userbits = { 0 0 0 0 } }, sequence = 0
        v4l2-ctl-22597 [004] .n.. 28789.530038: v4l2_qbuf: minor = 0, index = 0, type = VIDEO_CAPTURE, bytesused = 16400384, flags = MAPPED|QUEUED|TIMESTAMP_UNKNOWN|TIMESTAMP_MONOTONIC, field = ANY, timestamp = 0, timecode = { type = 0x0, flags = , frames = 0, seconds = 0, minutes = 0, hours = 0, userbits = { 0 0 0 0 } }, sequence = 0
        v4l2-ctl-22597 [004] .... 28789.531383: v4l2_qbuf: minor = 0, index = 1, type = VIDEO_CAPTURE, bytesused = 16400384, flags = MAPPED|QUEUED|TIMESTAMP_UNKNOWN|TIMESTAMP_MONOTONIC, field = ANY, timestamp = 0, timecode = { type = 0x0, flags = , frames = 0, seconds = 0, minutes = 0, hours = 0, userbits = { 0 0 0 0 } }, sequence = 0
        v4l2-ctl-22597 [004] .... 28789.532186: v4l2_qbuf: minor = 0, index = 2, type = VIDEO_CAPTURE, bytesused = 16400384, flags = MAPPED|QUEUED|TIMESTAMP_UNKNOWN|TIMESTAMP_MONOTONIC, field = ANY, timestamp = 0, timecode = { type = 0x0, flags = , frames = 0, seconds = 0, minutes = 0, hours = 0, userbits = { 0 0 0 0 } }, sequence = 0
        v4l2-ctl-22597 [004] .... 28789.532934: v4l2_qbuf: minor = 0, index = 3, type = VIDEO_CAPTURE, bytesused = 16400384, flags = MAPPED|QUEUED|TIMESTAMP_UNKNOWN|TIMESTAMP_MONOTONIC, field = ANY, timestamp = 0, timecode = { type = 0x0, flags = , frames = 0, seconds = 0, minutes = 0, hours = 0, userbits = { 0 0 0 0 } }, sequence = 0
root@vtedeveloper-desktop:/home/vte-developer# 

I have verified the signals in oscilloscope and my board is streaming video.

Hi @JerryChang ,

I would like to clarify somethings. The above kernel trace was for when I used following commands:

sudo mount -t debugfs none /sys/kernel/debug
sudo echo 1 > /sys/kernel/debug/tracing/tracing_on
sudo echo 1 > /sys/kernel/debug/tracing/events/v4l2/enable
sudo cat /sys/kernel/debug/tracing/trace
sudo echo 0 > /sys/kernel/debug/tracing/tracing_on
cat /sys/kernel/debug/tracing/trace
root@vtedeveloper-desktop:/home/vte-developer# sudo cat /sys/kernel/debug/tracing/trace
# tracer: nop
#
# entries-in-buffer/entries-written: 4/4   #P:6
#
#                              _-----=> irqs-off
#                             / _----=> need-resched
#                            | / _---=> hardirq/softirq
#                            || / _--=> preempt-depth
#                            ||| /     delay
#           TASK-PID   CPU#  ||||    TIMESTAMP  FUNCTION
#              | |       |   ||||       |         |
        v4l2-ctl-10769 [004] ....   751.454107: v4l2_qbuf: minor = 0, index = 0, type = VIDEO_CAPTURE, bytesused = 16400384, flags = MAPPED|QUEUED|TIMESTAMP_UNKNOWN|TIMESTAMP_MONOTONIC, field = ANY, timestamp = 0, timecode = { type = 0x0, flags = , frames = 0, seconds = 0, minutes = 0, hours = 0, userbits = { 0 0 0 0 } }, sequence = 0
        v4l2-ctl-10769 [004] ....   751.454836: v4l2_qbuf: minor = 0, index = 1, type = VIDEO_CAPTURE, bytesused = 16400384, flags = MAPPED|QUEUED|TIMESTAMP_UNKNOWN|TIMESTAMP_MONOTONIC, field = ANY, timestamp = 0, timecode = { type = 0x0, flags = , frames = 0, seconds = 0, minutes = 0, hours = 0, userbits = { 0 0 0 0 } }, sequence = 0
        v4l2-ctl-10769 [004] ....   751.455586: v4l2_qbuf: minor = 0, index = 2, type = VIDEO_CAPTURE, bytesused = 16400384, flags = MAPPED|QUEUED|TIMESTAMP_UNKNOWN|TIMESTAMP_MONOTONIC, field = ANY, timestamp = 0, timecode = { type = 0x0, flags = , frames = 0, seconds = 0, minutes = 0, hours = 0, userbits = { 0 0 0 0 } }, sequence = 0
        v4l2-ctl-10769 [004] ....   751.456274: v4l2_qbuf: minor = 0, index = 3, type = VIDEO_CAPTURE, bytesused = 16400384, flags = MAPPED|QUEUED|TIMESTAMP_UNKNOWN|TIMESTAMP_MONOTONIC, field = ANY, timestamp = 0, timecode = { type = 0x0, flags = , frames = 0, seconds = 0, minutes = 0, hours = 0, userbits = { 0 0 0 0 } }, sequence = 0

when I used the following trace commands, I got the same trace error as earlier:

echo 1 > /sys/kernel/debug/tracing/tracing_on
echo 30720 > /sys/kernel/debug/tracing/buffer_size_kb
echo 1 > /sys/kernel/debug/tracing/events/tegra_rtcpu/enable
echo 1 > /sys/kernel/debug/tracing/events/freertos/enable
echo 2 > /sys/kernel/debug/camrtc/log-level
echo 1 > /sys/kernel/debug/tracing/events/camera_common/enable
echo > /sys/kernel/debug/tracing/trace
cat /sys/kernel/debug/tracing/trace
root@vtedeveloper-desktop:/home/vte-developer# cat /sys/kernel/debug/tracing/trace
# tracer: nop
#
# entries-in-buffer/entries-written: 34/34   #P:6
#
#                              _-----=> irqs-off
#                             / _----=> need-resched
#                            | / _---=> hardirq/softirq
#                            || / _--=> preempt-depth
#                            ||| /     delay
#           TASK-PID   CPU#  ||||    TIMESTAMP  FUNCTION
#              | |       |   ||||       |         |
     kworker/4:0-10619 [004] ....   980.388565: rtos_queue_peek_from_isr_failed: tstamp:30914068002 queue:0x0b4b6398
     kworker/4:0-10619 [004] ....   980.556645: rtos_queue_peek_from_isr_failed: tstamp:30919067986 queue:0x0b4b6398
     kworker/4:0-10619 [004] ....   980.724675: rtos_queue_peek_from_isr_failed: tstamp:30924067980 queue:0x0b4b6398
     kworker/4:0-10619 [004] ....   980.892671: rtos_queue_peek_from_isr_failed: tstamp:30929067970 queue:0x0b4b6398
     kworker/4:0-10619 [004] ....   981.004684: rtos_queue_peek_from_isr_failed: tstamp:30934067964 queue:0x0b4b6398
     kworker/4:0-10619 [004] ....   981.172754: rtos_queue_peek_from_isr_failed: tstamp:30939067970 queue:0x0b4b6398
     kworker/4:0-10619 [004] ....   981.340778: rtos_queue_peek_from_isr_failed: tstamp:30944067950 queue:0x0b4b6398
     kworker/4:0-10619 [004] ....   981.508759: rtos_queue_peek_from_isr_failed: tstamp:30949067950 queue:0x0b4b6398
     kworker/4:0-10619 [004] ....   981.676778: rtos_queue_peek_from_isr_failed: tstamp:30954067936 queue:0x0b4b6398
     kworker/4:0-10619 [004] ....   981.844852: rtos_queue_peek_from_isr_failed: tstamp:30959067929 queue:0x0b4b6398
     kworker/4:0-10619 [004] ....   982.012871: rtos_queue_peek_from_isr_failed: tstamp:30964067935 queue:0x0b4b6398
     kworker/4:0-10619 [004] ....   982.124939: rtos_queue_peek_from_isr_failed: tstamp:30969067917 queue:0x0b4b6398
     kworker/4:0-10619 [004] ....   982.292881: rtos_queue_peek_from_isr_failed: tstamp:30974067910 queue:0x0b4b6398
     kworker/4:0-10619 [004] ....   982.460946: rtos_queue_peek_from_isr_failed: tstamp:30979067901 queue:0x0b4b6398
     kworker/4:0-10619 [004] ....   982.628927: rtos_queue_peek_from_isr_failed: tstamp:30984067926 queue:0x0b4b6398
     kworker/4:0-10619 [004] ....   982.796938: rtos_queue_peek_from_isr_failed: tstamp:30989067888 queue:0x0b4b6398
     kworker/4:0-10619 [004] ....   982.965007: rtos_queue_peek_from_isr_failed: tstamp:30994067881 queue:0x0b4b6398
     kworker/4:0-10619 [004] ....   983.133029: rtos_queue_peek_from_isr_failed: tstamp:30999067875 queue:0x0b4b6398
     kworker/4:0-10619 [004] ....   983.244977: rtos_queue_peek_from_isr_failed: tstamp:31004067888 queue:0x0b4b6398
     kworker/4:0-10619 [004] ....   983.413025: rtos_queue_peek_from_isr_failed: tstamp:31009067890 queue:0x0b4b6398
     kworker/4:0-10619 [004] ....   983.581096: rtos_queue_peek_from_isr_failed: tstamp:31014067862 queue:0x0b4b6398
     kworker/4:0-10619 [004] ....   983.749036: rtos_queue_peek_from_isr_failed: tstamp:31019067875 queue:0x0b4b6398
     kworker/4:0-10619 [004] ....   983.917137: rtos_queue_peek_from_isr_failed: tstamp:31024067863 queue:0x0b4b6398
     kworker/4:0-10619 [004] ....   984.085141: rtos_queue_peek_from_isr_failed: tstamp:31029067835 queue:0x0b4b6398
     kworker/4:0-10619 [004] ....   984.253142: rtos_queue_peek_from_isr_failed: tstamp:31034067833 queue:0x0b4b6398
     kworker/4:0-10619 [004] ....   984.365180: rtos_queue_peek_from_isr_failed: tstamp:31039067820 queue:0x0b4b6398
     kworker/4:0-10619 [004] ....   984.533176: rtos_queue_peek_from_isr_failed: tstamp:31044067833 queue:0x0b4b6398
     kworker/4:0-10619 [004] ....   984.701251: rtos_queue_peek_from_isr_failed: tstamp:31049067828 queue:0x0b4b6398
     kworker/4:0-10619 [004] ....   984.869192: rtos_queue_peek_from_isr_failed: tstamp:31054067854 queue:0x0b4b6398
     kworker/4:0-10619 [004] ....   985.037303: rtos_queue_peek_from_isr_failed: tstamp:31059067819 queue:0x0b4b6398
     kworker/4:0-10619 [004] ....   985.205329: rtos_queue_peek_from_isr_failed: tstamp:31064067793 queue:0x0b4b6398
     kworker/4:0-10619 [004] ....   985.373320: rtos_queue_peek_from_isr_failed: tstamp:31069067777 queue:0x0b4b6398
     kworker/4:0-10619 [004] ....   985.485359: rtos_queue_peek_from_isr_failed: tstamp:31074067773 queue:0x0b4b6398
     kworker/4:0-10619 [004] ....   985.653384: rtos_queue_peek_from_isr_failed: tstamp:31079067766 queue:0x0b4b6398

For the above trace error, you asked me to verify if the sensor is outputting frames and I verified in the oscilloscope and I can see the signals.

What should I do next?

the error remain the same, there’s no SOF/EOF sending to CSI channel. however, you’ve confirm via oscilloscope
to check there’s output MIPI signaling.

since it starts streaming video as soon as it is powered on,
is it possible for sending a reset signal for software side to get alignment with the frame-start?

BTW,
in order to rule out clock config related issue,
please try below commands to boost all the VI/CSI/ISP clocks.
for example,

sudo su
echo 1 > /sys/kernel/debug/bpmp/debug/clk/vi/mrq_rate_locked
echo 1 > /sys/kernel/debug/bpmp/debug/clk/isp/mrq_rate_locked
echo 1 > /sys/kernel/debug/bpmp/debug/clk/nvcsi/mrq_rate_locked
echo 1 > /sys/kernel/debug/bpmp/debug/clk/emc/mrq_rate_locked
cat /sys/kernel/debug/bpmp/debug/clk/vi/max_rate |tee /sys/kernel/debug/bpmp/debug/clk/vi/rate
cat /sys/kernel/debug/bpmp/debug/clk/isp/max_rate | tee /sys/kernel/debug/bpmp/debug/clk/isp/rate
cat /sys/kernel/debug/bpmp/debug/clk/nvcsi/max_rate | tee /sys/kernel/debug/bpmp/debug/clk/nvcsi/rate
cat /sys/kernel/debug/bpmp/debug/clk/emc/max_rate | tee /sys/kernel/debug/bpmp/debug/clk/emc/rate

Hi @JerryChang ,

Boosting the clock did not give any different result, however, we have an external reset for the streaming MIPI signal. I used this command v4l2-ctl --set-fmt-video=width=3264,height=2464,pixelformat=RG10 --stream-mmap --stream-count=1 -d /dev/video0 --stream-to=ov5693.raw and then pressed reset.
dmesg and trace logs are as below:
dmesg log

[ 6995.271904] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 6995.278357] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 6995.491887] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 6995.498338] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 6995.711888] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 6995.718342] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 6995.935891] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 6995.942345] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 6996.159886] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 6996.166366] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 6996.379914] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 6996.386369] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 6996.599957] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 6996.606501] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 6996.819958] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 6996.826403] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 6997.039978] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 6997.046426] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 6997.259960] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 6997.266413] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 6997.479972] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 6997.486544] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 6997.699941] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 6997.706400] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 6997.716676] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 6997.725473] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) INTR_STATUS 0x00000004
[ 6997.733347] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERR_INTR_STATUS 0x00000004
[ 6997.943961] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 6997.950467] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 6997.960680] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 6998.171962] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 6998.178408] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 6998.188649] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 6998.399979] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 6998.406458] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 6998.416510] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 6998.628001] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 6998.634447] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 6998.644464] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 6998.855972] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 6998.862425] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 6998.872499] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 6999.083973] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 6999.090432] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 6999.100558] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 6999.312025] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 6999.318496] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 6999.328603] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 6999.540003] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 6999.546478] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 6999.556611] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 6999.767990] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 6999.774444] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 6999.784513] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 6999.996022] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7000.002473] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7000.012351] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 7000.224013] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7000.230432] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7000.240438] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 7000.452034] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7000.458530] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7000.468690] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 7000.680054] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7000.686514] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7000.696502] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 7000.908044] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7000.914504] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7000.924582] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 7001.136058] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7001.142509] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7001.152519] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 7001.364039] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7001.370524] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7001.381046] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 7001.592083] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7001.598543] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7001.609184] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 7001.820103] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7001.826566] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7001.836617] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 7002.048113] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7002.054575] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7002.064363] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 7002.276095] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7002.282553] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7002.292442] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 7002.301940] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 7085.684932] ov5693 2-0036: ov5693_open:
[ 7093.442562] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7093.449206] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7093.662483] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7093.668987] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7093.882536] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7093.889038] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7094.102520] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7094.109018] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7094.322488] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7094.329074] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7094.542521] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7094.549263] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7094.762514] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7094.768971] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7094.982493] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7094.988883] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7095.202529] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7095.208985] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7095.422586] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7095.429061] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7095.642574] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7095.649058] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7095.862544] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7095.869009] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7096.082545] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7096.088997] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7096.302580] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7096.309047] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7096.522568] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7096.529017] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7096.742558] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7096.749009] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7096.962593] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7096.969042] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7097.346621] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7097.353081] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7097.363321] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 7097.372126] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) INTR_STATUS 0x00000004
[ 7097.380121] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERR_INTR_STATUS 0x00000004
[ 7097.590592] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7097.597142] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7097.607175] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 7097.818602] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7097.825027] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7097.835277] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 7098.046618] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7098.053188] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7098.063213] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 7098.274621] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7098.281075] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7098.291094] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 7098.502721] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7098.509179] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7098.519176] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 7098.730594] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7098.737300] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7098.747430] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 7098.958601] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7098.965094] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7098.976532] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 7099.186584] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7099.193080] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7099.203293] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 7099.414645] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7099.421292] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7099.431350] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 7099.642690] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7099.649193] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7099.659229] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 7099.870668] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7099.877122] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7099.887271] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 7100.098873] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7100.105389] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7100.115445] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 7100.326678] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7100.333250] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7100.343284] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 7100.554683] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7100.561137] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7100.571365] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 7100.782835] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7100.789290] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7100.801226] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 7101.010676] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7101.017154] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7101.027036] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 7101.238735] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7101.245206] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7101.256721] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 7101.470716] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7101.477177] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7101.487061] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 7101.698726] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7101.705308] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7101.715531] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 7101.926698] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 7101.933153] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 7101.944683] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 7101.954012] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004

I am getting thses new errors:

[ 6997.716676] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 6997.725473] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) INTR_STATUS 0x00000004
[ 6997.733347] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERR_INTR_STATUS 0x00000004

traces log

     kworker/5:0-12174 [005] ....  7101.278777: rtos_queue_send_failed: tstamp:222192189491 queue:0x0b4a7698
     kworker/5:0-12174 [005] ....  7101.334679: rtos_queue_peek_from_isr_failed: tstamp:222193073799 queue:0x0b4b6398
 vi-output, ov56-17444 [004] ....  7101.496018: tegra_channel_capture_setup: vnc_id 0 W 3264 H 2464 fmt 20
 vi-output, ov56-17444 [004] ....  7101.496045: tegra_channel_capture_frame: sof:7096.862104123
     kworker/5:0-12174 [005] ....  7101.506656: rtos_queue_peek_from_isr_failed: tstamp:222198073795 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7101.506662: rtos_queue_send_from_isr_failed: tstamp:222199073169 queue:0x0b4a7698
     kworker/5:0-12174 [005] ....  7101.506664: rtos_queue_send_from_isr_failed: tstamp:222199073300 queue:0x0b4ab1a8
     kworker/5:0-12174 [005] ....  7101.506665: rtos_queue_send_from_isr_failed: tstamp:222199073421 queue:0x0b4acdd8
     kworker/5:0-12174 [005] ....  7101.506667: rtos_queue_send_from_isr_failed: tstamp:222199073530 queue:0x0b4ae958
     kworker/5:0-12174 [005] ....  7101.506668: rtos_queue_send_from_isr_failed: tstamp:222199073648 queue:0x0b4af718
     kworker/5:0-12174 [005] ....  7101.506669: rtos_queue_send_from_isr_failed: tstamp:222199073753 queue:0x0b4b04d8
     kworker/5:0-12174 [005] ....  7101.506671: rtos_queue_send_from_isr_failed: tstamp:222199073858 queue:0x0b4b1298
     kworker/5:0-12174 [005] ....  7101.506672: rtos_queue_send_from_isr_failed: tstamp:222199073966 queue:0x0b4b2058
     kworker/5:0-12174 [005] ....  7101.506674: rtos_queue_send_failed: tstamp:222199074537 queue:0x0b4a7698
     kworker/5:0-12174 [005] ....  7101.506676: rtos_queue_send_from_isr_failed: tstamp:222199076407 queue:0x0b4a7698
     kworker/5:0-12174 [005] ....  7101.506677: rtos_queue_send_from_isr_failed: tstamp:222199076515 queue:0x0b4ab1a8
     kworker/5:0-12174 [005] ....  7101.506678: rtos_queue_send_from_isr_failed: tstamp:222199076622 queue:0x0b4acdd8
     kworker/5:0-12174 [005] ....  7101.506680: rtos_queue_send_from_isr_failed: tstamp:222199076729 queue:0x0b4ae958
     kworker/5:0-12174 [005] ....  7101.506681: rtos_queue_send_from_isr_failed: tstamp:222199076835 queue:0x0b4af718
     kworker/5:0-12174 [005] ....  7101.506682: rtos_queue_send_from_isr_failed: tstamp:222199076939 queue:0x0b4b04d8
     kworker/5:0-12174 [005] ....  7101.506684: rtos_queue_send_from_isr_failed: tstamp:222199077044 queue:0x0b4b1298
     kworker/5:0-12174 [005] ....  7101.506685: rtos_queue_send_from_isr_failed: tstamp:222199077149 queue:0x0b4b2058
     kworker/5:0-12174 [005] ....  7101.506686: rtos_queue_send_failed: tstamp:222199077570 queue:0x0b4a7698
     kworker/5:0-12174 [005] ....  7101.506687: rtos_queue_send_from_isr_failed: tstamp:222199354127 queue:0x0b4a7698
     kworker/5:0-12174 [005] ....  7101.506689: rtos_queue_send_from_isr_failed: tstamp:222199354236 queue:0x0b4ab1a8
     kworker/5:0-12174 [005] ....  7101.506690: rtos_queue_send_from_isr_failed: tstamp:222199354349 queue:0x0b4acdd8
     kworker/5:0-12174 [005] ....  7101.506691: rtos_queue_send_from_isr_failed: tstamp:222199354455 queue:0x0b4ae958
     kworker/5:0-12174 [005] ....  7101.506693: rtos_queue_send_from_isr_failed: tstamp:222199354560 queue:0x0b4af718
     kworker/5:0-12174 [005] ....  7101.506694: rtos_queue_send_from_isr_failed: tstamp:222199354664 queue:0x0b4b04d8
     kworker/5:0-12174 [005] ....  7101.506695: rtos_queue_send_from_isr_failed: tstamp:222199354767 queue:0x0b4b1298
     kworker/5:0-12174 [005] ....  7101.506697: rtos_queue_send_from_isr_failed: tstamp:222199354874 queue:0x0b4b2058
     kworker/5:0-12174 [005] ....  7101.506698: rtos_queue_send_failed: tstamp:222199355317 queue:0x0b4a7698
     kworker/5:0-12174 [005] ....  7101.506699: rtos_queue_send_from_isr_failed: tstamp:222199356941 queue:0x0b4a7698
     kworker/5:0-12174 [005] ....  7101.506700: rtos_queue_send_from_isr_failed: tstamp:222199357051 queue:0x0b4ab1a8
     kworker/5:0-12174 [005] ....  7101.506702: rtos_queue_send_from_isr_failed: tstamp:222199357160 queue:0x0b4acdd8
     kworker/5:0-12174 [005] ....  7101.506703: rtos_queue_send_from_isr_failed: tstamp:222199357266 queue:0x0b4ae958
     kworker/5:0-12174 [005] ....  7101.506704: rtos_queue_send_from_isr_failed: tstamp:222199357371 queue:0x0b4af718
     kworker/5:0-12174 [005] ....  7101.506706: rtos_queue_send_from_isr_failed: tstamp:222199357476 queue:0x0b4b04d8
     kworker/5:0-12174 [005] ....  7101.506707: rtos_queue_send_from_isr_failed: tstamp:222199357581 queue:0x0b4b1298
     kworker/5:0-12174 [005] ....  7101.506708: rtos_queue_send_from_isr_failed: tstamp:222199357688 queue:0x0b4b2058
     kworker/5:0-12174 [005] ....  7101.506709: rtos_queue_send_failed: tstamp:222199358585 queue:0x0b4a7698
     kworker/5:0-12174 [005] ....  7101.618693: rtos_queue_peek_from_isr_failed: tstamp:222203073786 queue:0x0b4b6398
 vi-output, ov56-17444 [004] ....  7101.724611: tegra_channel_capture_setup: vnc_id 0 W 3264 H 2464 fmt 20
 vi-output, ov56-17444 [004] ....  7101.724639: tegra_channel_capture_frame: sof:7096.862104123
     kworker/5:0-12174 [005] ....  7101.730651: rtos_queue_send_from_isr_failed: tstamp:222206201450 queue:0x0b4a7698
     kworker/5:0-12174 [005] ....  7101.730660: rtos_queue_send_from_isr_failed: tstamp:222206201560 queue:0x0b4ab1a8
     kworker/5:0-12174 [005] ....  7101.730663: rtos_queue_send_from_isr_failed: tstamp:222206201668 queue:0x0b4acdd8
     kworker/5:0-12174 [005] ....  7101.730666: rtos_queue_send_from_isr_failed: tstamp:222206201773 queue:0x0b4ae958
     kworker/5:0-12174 [005] ....  7101.730668: rtos_queue_send_from_isr_failed: tstamp:222206201889 queue:0x0b4af718
     kworker/5:0-12174 [005] ....  7101.730670: rtos_queue_send_from_isr_failed: tstamp:222206201993 queue:0x0b4b04d8
     kworker/5:0-12174 [005] ....  7101.730673: rtos_queue_send_from_isr_failed: tstamp:222206202098 queue:0x0b4b1298
     kworker/5:0-12174 [005] ....  7101.730675: rtos_queue_send_from_isr_failed: tstamp:222206202203 queue:0x0b4b2058
     kworker/5:0-12174 [005] ....  7101.730679: rtos_queue_send_failed: tstamp:222206202758 queue:0x0b4a7698
     kworker/5:0-12174 [005] ....  7101.730681: rtos_queue_send_from_isr_failed: tstamp:222206208321 queue:0x0b4a7698
     kworker/5:0-12174 [005] ....  7101.730683: rtos_queue_send_from_isr_failed: tstamp:222206208427 queue:0x0b4ab1a8
     kworker/5:0-12174 [005] ....  7101.730685: rtos_queue_send_from_isr_failed: tstamp:222206208534 queue:0x0b4acdd8
     kworker/5:0-12174 [005] ....  7101.730688: rtos_queue_send_from_isr_failed: tstamp:222206208640 queue:0x0b4ae958
     kworker/5:0-12174 [005] ....  7101.730690: rtos_queue_send_from_isr_failed: tstamp:222206208744 queue:0x0b4af718
     kworker/5:0-12174 [005] ....  7101.730692: rtos_queue_send_from_isr_failed: tstamp:222206208849 queue:0x0b4b04d8
     kworker/5:0-12174 [005] ....  7101.730694: rtos_queue_send_from_isr_failed: tstamp:222206208954 queue:0x0b4b1298
     kworker/5:0-12174 [005] ....  7101.730697: rtos_queue_send_from_isr_failed: tstamp:222206209059 queue:0x0b4b2058
     kworker/5:0-12174 [005] ....  7101.730699: rtos_queue_send_failed: tstamp:222206209492 queue:0x0b4a7698
     kworker/5:0-12174 [005] ....  7101.730701: rtos_queue_send_from_isr_failed: tstamp:222206496207 queue:0x0b4a7698
     kworker/5:0-12174 [005] ....  7101.730703: rtos_queue_send_from_isr_failed: tstamp:222206496314 queue:0x0b4ab1a8
     kworker/5:0-12174 [005] ....  7101.730705: rtos_queue_send_from_isr_failed: tstamp:222206496422 queue:0x0b4acdd8
     kworker/5:0-12174 [005] ....  7101.730708: rtos_queue_send_from_isr_failed: tstamp:222206496531 queue:0x0b4ae958
     kworker/5:0-12174 [005] ....  7101.730710: rtos_queue_send_from_isr_failed: tstamp:222206496636 queue:0x0b4af718
     kworker/5:0-12174 [005] ....  7101.730712: rtos_queue_send_from_isr_failed: tstamp:222206496741 queue:0x0b4b04d8
     kworker/5:0-12174 [005] ....  7101.730714: rtos_queue_send_from_isr_failed: tstamp:222206496846 queue:0x0b4b1298
     kworker/5:0-12174 [005] ....  7101.730717: rtos_queue_send_from_isr_failed: tstamp:222206496951 queue:0x0b4b2058
     kworker/5:0-12174 [005] ....  7101.730719: rtos_queue_send_failed: tstamp:222206497414 queue:0x0b4a7698
     kworker/5:0-12174 [005] ....  7101.730721: rtos_queue_send_from_isr_failed: tstamp:222206499168 queue:0x0b4a7698
     kworker/5:0-12174 [005] ....  7101.730723: rtos_queue_send_from_isr_failed: tstamp:222206499276 queue:0x0b4ab1a8
     kworker/5:0-12174 [005] ....  7101.730726: rtos_queue_send_from_isr_failed: tstamp:222206499393 queue:0x0b4acdd8
     kworker/5:0-12174 [005] ....  7101.730728: rtos_queue_send_from_isr_failed: tstamp:222206499498 queue:0x0b4ae958
     kworker/5:0-12174 [005] ....  7101.730730: rtos_queue_send_from_isr_failed: tstamp:222206499612 queue:0x0b4af718
     kworker/5:0-12174 [005] ....  7101.730732: rtos_queue_send_from_isr_failed: tstamp:222206499717 queue:0x0b4b04d8
     kworker/5:0-12174 [005] ....  7101.730734: rtos_queue_send_from_isr_failed: tstamp:222206499823 queue:0x0b4b1298
     kworker/5:0-12174 [005] ....  7101.730737: rtos_queue_send_from_isr_failed: tstamp:222206499929 queue:0x0b4b2058
     kworker/5:0-12174 [005] ....  7101.730739: rtos_queue_send_failed: tstamp:222206500850 queue:0x0b4a7698
        v4l2-ctl-17443 [000] ....  7101.764561: tegra_channel_close: vi-output, ov5693 2-0036
     kworker/5:0-12174 [005] ....  7101.786720: rtos_queue_peek_from_isr_failed: tstamp:222208073780 queue:0x0b4b6398
 vi-output, ov56-17444 [005] ....  7101.953759: tegra_channel_capture_setup: vnc_id 0 W 3264 H 2464 fmt 20
 vi-output, ov56-17444 [005] ....  7101.953786: tegra_channel_capture_frame: sof:7096.862104123
        v4l2-ctl-17443 [005] ....  7101.953990: tegra_channel_set_stream: enable : 0x0
        v4l2-ctl-17443 [005] ....  7101.953991: tegra_channel_set_stream: ov5693 2-0036 : 0x0
        v4l2-ctl-17443 [005] ....  7101.954000: tegra_channel_set_stream: 150c0000.nvcsi--1 : 0x0
        v4l2-ctl-17443 [005] ....  7101.954002: csi_s_stream: enable : 0x0
     kworker/5:0-12174 [005] ....  7101.962892: rtos_queue_peek_from_isr_failed: tstamp:222213073772 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7101.962898: rtos_queue_send_from_isr_failed: tstamp:222213371738 queue:0x0b4a7698
     kworker/5:0-12174 [005] ....  7101.962901: rtos_queue_send_from_isr_failed: tstamp:222213371849 queue:0x0b4ab1a8
     kworker/5:0-12174 [005] ....  7101.962904: rtos_queue_send_from_isr_failed: tstamp:222213371958 queue:0x0b4acdd8
     kworker/5:0-12174 [005] ....  7101.962906: rtos_queue_send_from_isr_failed: tstamp:222213372066 queue:0x0b4ae958
     kworker/5:0-12174 [005] ....  7101.962908: rtos_queue_send_from_isr_failed: tstamp:222213372171 queue:0x0b4af718
     kworker/5:0-12174 [005] ....  7101.962911: rtos_queue_send_from_isr_failed: tstamp:222213372276 queue:0x0b4b04d8
     kworker/5:0-12174 [005] ....  7101.962913: rtos_queue_send_from_isr_failed: tstamp:222213372381 queue:0x0b4b1298
     kworker/5:0-12174 [005] ....  7101.962915: rtos_queue_send_from_isr_failed: tstamp:222213372486 queue:0x0b4b2058
     kworker/5:0-12174 [005] ....  7101.962919: rtos_queue_send_failed: tstamp:222213373059 queue:0x0b4a7698
     kworker/5:0-12174 [005] ....  7101.962921: rtos_queue_send_from_isr_failed: tstamp:222213376906 queue:0x0b4a7698
     kworker/5:0-12174 [005] ....  7101.962923: rtos_queue_send_from_isr_failed: tstamp:222213377024 queue:0x0b4ab1a8
     kworker/5:0-12174 [005] ....  7101.962926: rtos_queue_send_from_isr_failed: tstamp:222213377131 queue:0x0b4acdd8
     kworker/5:0-12174 [005] ....  7101.962928: rtos_queue_send_from_isr_failed: tstamp:222213377237 queue:0x0b4ae958
     kworker/5:0-12174 [005] ....  7101.962930: rtos_queue_send_from_isr_failed: tstamp:222213377341 queue:0x0b4af718
     kworker/5:0-12174 [005] ....  7101.962932: rtos_queue_send_from_isr_failed: tstamp:222213377446 queue:0x0b4b04d8
     kworker/5:0-12174 [005] ....  7101.962935: rtos_queue_send_from_isr_failed: tstamp:222213377552 queue:0x0b4b1298
     kworker/5:0-12174 [005] ....  7101.962937: rtos_queue_send_from_isr_failed: tstamp:222213377658 queue:0x0b4b2058
     kworker/5:0-12174 [005] ....  7101.962939: rtos_queue_send_failed: tstamp:222213378086 queue:0x0b4a7698
     kworker/5:0-12174 [005] ....  7101.962941: rtos_queue_send_from_isr_failed: tstamp:222213655268 queue:0x0b4a7698
     kworker/5:0-12174 [005] ....  7101.962944: rtos_queue_send_from_isr_failed: tstamp:222213655387 queue:0x0b4ab1a8
     kworker/5:0-12174 [005] ....  7101.962946: rtos_queue_send_from_isr_failed: tstamp:222213655494 queue:0x0b4acdd8
     kworker/5:0-12174 [005] ....  7101.962948: rtos_queue_send_from_isr_failed: tstamp:222213655600 queue:0x0b4ae958
     kworker/5:0-12174 [005] ....  7101.962950: rtos_queue_send_from_isr_failed: tstamp:222213655706 queue:0x0b4af718
     kworker/5:0-12174 [005] ....  7101.962953: rtos_queue_send_from_isr_failed: tstamp:222213655813 queue:0x0b4b04d8
     kworker/5:0-12174 [005] ....  7101.962955: rtos_queue_send_from_isr_failed: tstamp:222213655928 queue:0x0b4b1298
     kworker/5:0-12174 [005] ....  7101.962957: rtos_queue_send_from_isr_failed: tstamp:222213656034 queue:0x0b4b2058
     kworker/5:0-12174 [005] ....  7101.962959: rtos_queue_send_failed: tstamp:222213656484 queue:0x0b4a7698
     kworker/5:0-12174 [005] ....  7101.962961: rtos_queue_send_from_isr_failed: tstamp:222213659945 queue:0x0b4a7698
     kworker/5:0-12174 [005] ....  7101.962964: rtos_queue_send_from_isr_failed: tstamp:222213660053 queue:0x0b4ab1a8
     kworker/5:0-12174 [005] ....  7101.962966: rtos_queue_send_from_isr_failed: tstamp:222213660159 queue:0x0b4acdd8
     kworker/5:0-12174 [005] ....  7101.962967: rtos_queue_send_from_isr_failed: tstamp:222213660265 queue:0x0b4ae958
     kworker/5:0-12174 [005] ....  7101.962969: rtos_queue_send_from_isr_failed: tstamp:222213660370 queue:0x0b4af718
     kworker/5:0-12174 [005] ....  7101.962970: rtos_queue_send_from_isr_failed: tstamp:222213660482 queue:0x0b4b04d8
     kworker/5:0-12174 [005] ....  7101.962971: rtos_queue_send_from_isr_failed: tstamp:222213660587 queue:0x0b4b1298
     kworker/5:0-12174 [005] ....  7101.962973: rtos_queue_send_from_isr_failed: tstamp:222213660692 queue:0x0b4b2058
     kworker/5:0-12174 [005] ....  7101.962974: rtos_queue_send_failed: tstamp:222213661597 queue:0x0b4a7698
     kworker/5:0-12174 [005] ....  7101.962975: rtos_queue_send_from_isr_failed: tstamp:222213665770 queue:0x0b4a7698
     kworker/5:0-12174 [005] ....  7101.962977: rtos_queue_send_from_isr_failed: tstamp:222213665876 queue:0x0b4ab1a8
     kworker/5:0-12174 [005] ....  7101.962978: rtos_queue_send_from_isr_failed: tstamp:222213665982 queue:0x0b4acdd8
     kworker/5:0-12174 [005] ....  7101.962979: rtos_queue_send_from_isr_failed: tstamp:222213666089 queue:0x0b4ae958
     kworker/5:0-12174 [005] ....  7101.962980: rtos_queue_send_from_isr_failed: tstamp:222213666194 queue:0x0b4af718
     kworker/5:0-12174 [005] ....  7101.962982: rtos_queue_send_from_isr_failed: tstamp:222213666300 queue:0x0b4b04d8
     kworker/5:0-12174 [005] ....  7101.962983: rtos_queue_send_from_isr_failed: tstamp:222213666406 queue:0x0b4b1298
     kworker/5:0-12174 [005] ....  7101.962984: rtos_queue_send_from_isr_failed: tstamp:222213666510 queue:0x0b4b2058
     kworker/5:0-12174 [005] ....  7101.962986: rtos_queue_send_failed: tstamp:222213667064 queue:0x0b4a7698
     kworker/5:0-12174 [005] ....  7101.962987: rtos_queue_send_from_isr_failed: tstamp:222213668572 queue:0x0b4a7698
     kworker/5:0-12174 [005] ....  7101.962988: rtos_queue_send_from_isr_failed: tstamp:222213668678 queue:0x0b4ab1a8
     kworker/5:0-12174 [005] ....  7101.962990: rtos_queue_send_from_isr_failed: tstamp:222213668785 queue:0x0b4acdd8
     kworker/5:0-12174 [005] ....  7101.962991: rtos_queue_send_from_isr_failed: tstamp:222213668891 queue:0x0b4ae958
     kworker/5:0-12174 [005] ....  7101.962992: rtos_queue_send_from_isr_failed: tstamp:222213668996 queue:0x0b4af718
     kworker/5:0-12174 [005] ....  7101.962993: rtos_queue_send_from_isr_failed: tstamp:222213669101 queue:0x0b4b04d8
     kworker/5:0-12174 [005] ....  7101.962995: rtos_queue_send_from_isr_failed: tstamp:222213669206 queue:0x0b4b1298
     kworker/5:0-12174 [005] ....  7101.962996: rtos_queue_send_from_isr_failed: tstamp:222213669311 queue:0x0b4b2058
     kworker/5:0-12174 [005] ....  7101.962997: rtos_queue_send_failed: tstamp:222213669737 queue:0x0b4a7698
        v4l2-ctl-17443 [000] ....  7101.964647: tegra_channel_set_power: ov5693 2-0036 : 0x0
        v4l2-ctl-17443 [000] ....  7101.964661: camera_common_s_power: status : 0x0
        v4l2-ctl-17443 [000] ....  7101.964740: tegra_channel_set_power: 150c0000.nvcsi--1 : 0x0
        v4l2-ctl-17443 [000] ....  7101.964745: csi_s_power: enable : 0x0
     kworker/5:0-12174 [005] ....  7102.130802: rtos_queue_peek_from_isr_failed: tstamp:222218073793 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7102.298712: rtos_queue_peek_from_isr_failed: tstamp:222223073761 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7102.466717: rtos_queue_peek_from_isr_failed: tstamp:222228073769 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7102.578727: rtos_queue_peek_from_isr_failed: tstamp:222233073750 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7102.746669: rtos_queue_peek_from_isr_failed: tstamp:222238073757 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7102.914729: rtos_queue_peek_from_isr_failed: tstamp:222243073738 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7103.082629: rtos_queue_peek_from_isr_failed: tstamp:222248073730 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7103.250686: rtos_queue_peek_from_isr_failed: tstamp:222253073726 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7103.418732: rtos_queue_peek_from_isr_failed: tstamp:222258073709 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7103.586727: rtos_queue_peek_from_isr_failed: tstamp:222263073703 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7103.698748: rtos_queue_peek_from_isr_failed: tstamp:222268073716 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7103.866743: rtos_queue_peek_from_isr_failed: tstamp:222273073688 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7104.034751: rtos_queue_peek_from_isr_failed: tstamp:222278073713 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7104.202735: rtos_queue_peek_from_isr_failed: tstamp:222283073679 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7104.370745: rtos_queue_peek_from_isr_failed: tstamp:222288073673 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7104.538790: rtos_queue_peek_from_isr_failed: tstamp:222293073680 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7104.706774: rtos_queue_peek_from_isr_failed: tstamp:222298073653 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7104.818773: rtos_queue_peek_from_isr_failed: tstamp:222303073646 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7104.986745: rtos_queue_peek_from_isr_failed: tstamp:222308073640 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7105.154777: rtos_queue_peek_from_isr_failed: tstamp:222313073640 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7105.322795: rtos_queue_peek_from_isr_failed: tstamp:222318073628 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7105.490786: rtos_queue_peek_from_isr_failed: tstamp:222323073649 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7105.658800: rtos_queue_peek_from_isr_failed: tstamp:222328073639 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7105.826798: rtos_queue_peek_from_isr_failed: tstamp:222333073615 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7105.938829: rtos_queue_peek_from_isr_failed: tstamp:222338073625 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7106.106813: rtos_queue_peek_from_isr_failed: tstamp:222343073606 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7106.274810: rtos_queue_peek_from_isr_failed: tstamp:222348073585 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7106.442825: rtos_queue_peek_from_isr_failed: tstamp:222353073602 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7106.610812: rtos_queue_peek_from_isr_failed: tstamp:222358073575 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7106.778827: rtos_queue_peek_from_isr_failed: tstamp:222363073569 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7106.946898: rtos_queue_peek_from_isr_failed: tstamp:222368073582 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7107.058852: rtos_queue_peek_from_isr_failed: tstamp:222373073582 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7107.226752: rtos_queue_peek_from_isr_failed: tstamp:222378073551 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7107.394792: rtos_queue_peek_from_isr_failed: tstamp:222383073558 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7107.562835: rtos_queue_peek_from_isr_failed: tstamp:222388073533 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7107.730834: rtos_queue_peek_from_isr_failed: tstamp:222393073524 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7107.898842: rtos_queue_peek_from_isr_failed: tstamp:222398073549 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7108.066783: rtos_queue_peek_from_isr_failed: tstamp:222403073516 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7108.178876: rtos_queue_peek_from_isr_failed: tstamp:222408073527 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7108.346917: rtos_queue_peek_from_isr_failed: tstamp:222413073495 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7108.514856: rtos_queue_peek_from_isr_failed: tstamp:222418073490 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7108.682894: rtos_queue_peek_from_isr_failed: tstamp:222423073484 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7108.850866: rtos_queue_peek_from_isr_failed: tstamp:222428073508 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7109.018903: rtos_queue_peek_from_isr_failed: tstamp:222433073471 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7109.186879: rtos_queue_peek_from_isr_failed: tstamp:222438073482 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7109.298878: rtos_queue_peek_from_isr_failed: tstamp:222443073455 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7109.466798: rtos_queue_peek_from_isr_failed: tstamp:222448073461 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7109.634905: rtos_queue_peek_from_isr_failed: tstamp:222453073466 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7109.802886: rtos_queue_peek_from_isr_failed: tstamp:222458073437 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7109.970899: rtos_queue_peek_from_isr_failed: tstamp:222463073427 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7110.138943: rtos_queue_peek_from_isr_failed: tstamp:222468073458 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7110.306940: rtos_queue_peek_from_isr_failed: tstamp:222473073432 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7110.418915: rtos_queue_peek_from_isr_failed: tstamp:222478073429 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7110.586893: rtos_queue_peek_from_isr_failed: tstamp:222483073410 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7110.754871: rtos_queue_peek_from_isr_failed: tstamp:222488073404 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7110.922919: rtos_queue_peek_from_isr_failed: tstamp:222493073386 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7111.090928: rtos_queue_peek_from_isr_failed: tstamp:222498073379 queue:0x0b4b6398
     kworker/5:0-12174 [005] ....  7111.258942: rtos_queue_peek_from_isr_failed: tstamp:222503073392 queue:0x0b4b6398
root@vtedeveloper-desktop:/home/vte-developer# 

and some new errors in traces:

 kworker/5:0-12174 [005] ....  7101.962997: rtos_queue_send_failed: tstamp:222213669737 queue:0x0b4a7698
        v4l2-ctl-17443 [000] ....  7101.964647: tegra_channel_set_power: ov5693 2-0036 : 0x0
        v4l2-ctl-17443 [000] ....  7101.964661: camera_common_s_power: status : 0x0
        v4l2-ctl-17443 [000] ....  7101.964740: tegra_channel_set_power: 150c0000.nvcsi--1 : 0x0
        v4l2-ctl-17443 [000] ....  7101.964745: csi_s_power: enable : 0x0
     kworker/5:0-12174 [005] ....  7102.130802: rtos_queue_peek_from_isr_failed: tstamp:222218073793

hello jetuser,

may I have more details of… an external reset.
what’s this reset done? is it something like force-stop the sensor signaling?

Hi @JerryChang,

We have a sensor which outputs LVDS. We intend to use an FPGA to convert LVDS to MIPI. Currently, we are simulating an image and outputting it through an FPGA (implementing exactly this CSI-2 Image Simulator Lattice CrosslinkFPGA to Jetson Nano - Hackster.io using Jetson TX2 instead of nano.
In the attached link code, it expects a start stream signal to start streaming, however, we have modified it so that instead of receiving start stream signal, it continuously streams the video, in the blog there was a tip to do this).

We are using R32.7.3.

By external reset I mean, resetting the FPGA, which means the FPGA stops and then initializes again and starts outputting MIPI signals. That is what I did.

hello jetuser,

please refer to below code snippet,
it uses syncpt for waiting hardware signal, there’s default timeout as 200ms.
please give it a try to increase timeout value.
$public_sources/kernel_src/kernel/nvidia/drivers/media/platform/tegra/camera/vi/vi4_fops.c

static bool vi_notify_wait(...)
{
...                err = nvhost_syncpt_wait_timeout_ext(chan->vi->ndev,
                                chan->syncpt[i][SOF_SYNCPT_IDX], thresh[i],
                                chan->timeout, NULL, NULL);

and…
there’s a ring buffer. even you request for --stream-count=1, it still capture several frames internally.
you may also adding some debug logs within below, please confirm there’s already buffers.
$public_sources/kernel_src/kernel/nvidia/drivers/media/platform/tegra/camera/vi/channel.c

void free_ring_buffers(struct tegra_channel *chan, int frames){...}

HI @JerryChang,

Got the same error in dmesg, however, some extra info on traces. I changed the timeout value to 500ms, was that enough? I made following modifications in vi4_fops.c

static int vi4_channel_start_streaming(struct vb2_queue *vq, u32 count)
...
chan->sequence = 0;
	chan->timeout = msecs_to_jiffies(500); /* Modified ovalue from 200 to 500 millisconds*/
	if (!chan->low_latency)
		tegra_channel_i`Preformatted text`nit_ring_buffer(chan);
 
	INIT_WORK(&chan->error_work, tegra_channel_error_worker);
	INIT_WORK(&chan->status_work, tegra_channel_status_worker);

Furhter, I added some debug logs in channel.c as below:

void free_ring_buffers(struct tegra_channel *chan, int frames)
{
	struct vb2_v4l2_buffer *vbuf;
	s64 frame_arrived_ts = 0;
 
        pr_debug("free_ring_buffers: entering function\n");
 
 
	spin_lock(&chan->buffer_lock);
 
	if (frames == 0)
		frames = chan->num_buffers;
 
 
        pr_debug("free_ring_buffers: freeing %d frames\n", frames);
 
 
	while (frames > 0) {
		vbuf = chan->buffers[chan->free_index];
 
		/* Skip updating the buffer sequence with channel sequence
		 * for interlaced captures and this instead will be updated
		 * with frame id received from CSI with capture complete
		 */
		if (!chan->is_interlaced)
			vbuf->sequence = chan->sequence++;
		else
			chan->sequence++;
		/* release one frame */
		vbuf->field = V4L2_FIELD_NONE;
		vb2_set_plane_payload(&vbuf->vb2_buf,
			0, chan->format.sizeimage);
 
		/*
		 * WAR to force buffer state if capture state is not good
		 * WAR - After sync point timeout or error frame capture
		 * the second buffer is intermittently frame of zeros
		 * with no error status or padding.
		 */
#if 0
		/* This will drop the first two frames. Disable for now. */
		if (chan->capture_state != CAPTURE_GOOD ||
			chan->released_bufs < 2)
			chan->buffer_state[chan->free_index] =
						VB2_BUF_STATE_REQUEUEING;
#endif
 
		if (chan->sequence == 1) {
			/*
			 * Evaluate the initial capture latency
			 * between videobuf2 queue and first captured
			 * frame release to user-space.
			 */
			frame_arrived_ts = ktime_to_ms(ktime_get());
			dev_dbg(&chan->video->dev,
				"%s: capture init latency is %lld ms\n",
				__func__, (frame_arrived_ts - queue_init_ts));
		}
		vb2_buffer_done(&vbuf->vb2_buf,
			chan->buffer_state[chan->free_index++]);
 
		if (chan->free_index >= chan->capture_queue_depth)
			chan->free_index = 0;
		chan->num_buffers--;
		chan->released_bufs++;
	        pr_debug("free_ring_buffers: freed frame %d\n", frames);
		frames--;
	}
 
        pr_debug("free_ring_buffers: exiting function\n");
 
	spin_unlock(&chan->buffer_lock);
}

Follwoing the modifications, please find below the dmesg and traces log.
dmesg:

[ 8002.914880] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 8002.921337] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 8003.458754] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 8003.465241] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 8004.002640] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 8004.009085] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 8004.546509] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 8004.552965] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 8005.090405] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 8005.096901] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 8005.634287] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 8005.640743] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 8006.178181] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 8006.184632] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 8006.722032] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 8006.728482] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 8007.489918] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 8007.496438] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 8007.506447] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 8007.515296] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) INTR_STATUS 0x00000004
[ 8007.523176] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERR_INTR_STATUS 0x00000004
[ 8008.033782] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 8008.040206] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 8008.050323] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 8008.577704] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 8008.584198] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 8008.594173] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 8009.121592] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 8009.128081] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 8009.138013] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 8009.665467] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 8009.672014] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 8009.682076] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 8010.209537] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 8010.216035] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 8010.226077] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 8010.753375] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 8010.759878] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 8010.769774] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 8011.297296] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 8011.303824] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 8011.314011] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 8011.841156] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 8011.847696] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 8011.858537] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 8012.385138] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 8012.391766] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 8012.401781] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 8012.929056] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 8012.935567] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 8012.945576] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 8013.472984] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 8013.479520] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 8013.489565] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 8014.016974] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 8014.023428] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 8014.033363] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 8014.560870] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 8014.567442] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 8014.577636] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 8015.104753] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 8015.111291] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 8015.121334] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 8015.648799] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 8015.655257] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 8015.665375] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 8016.192722] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 8016.199174] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 8016.211686] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 8016.736624] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 8016.743063] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 8016.752951] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[ 8016.762188] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004

traces
traces.txt (580.4 KB)

 vi-output, ov56-28057 [005] ....  8006.969626: tegra_channel_capture_frame: sof:8006.611660938
     kworker/5:0-26992 [005] ....  8006.985978: rtcpu_vinotify_event: tstamp:250495586936 tag:ATOMP_FS channel:0x00 frame:1 vi_tstamp:250495586458 data:0x00000000
     kworker/5:0-26992 [005] ....  8006.985982: rtcpu_vinotify_event: tstamp:250495587057 tag:CHANSEL_PXL_SOF channel:0x00 frame:1 vi_tstamp:250495586496 data:0x00000001
     kworker/5:0-26992 [005] ....  8006.985985: rtcpu_vinotify_event: tstamp:250495591572 tag:CHANSEL_LOAD_FRAMED channel:0x01 frame:1 vi_tstamp:250495591233 data:0x08000000
     kworker/5:0-26992 [005] ....  8007.042002: rtcpu_vinotify_event: tstamp:250497018188 tag:CHANSEL_PXL_EOF channel:0x00 frame:1 vi_tstamp:250497017521 data:0x099f0002
     kworker/5:0-26992 [005] ....  8007.042009: rtcpu_vinotify_event: tstamp:250497018312 tag:CSIMUX_FRAME channel:0x00 frame:1 vi_tstamp:250497017540 data:0x00400060
     kworker/5:0-26992 [005] ....  8007.042011: rtcpu_vinotify_event: tstamp:250497018496 tag:ATOMP_FE channel:0x00 frame:1 vi_tstamp:250497017544 data:0x00000000
     kworker/5:0-26992 [005] ....  8007.097937: rtos_queue_peek_from_isr_failed: tstamp:250498735423 queue:0x0b4b6398
     kworker/5:0-26992 [005] ....  8007.265916: rtos_queue_peek_from_isr_failed: tstamp:250503735409 queue:0x0b4b6398
     kworker/5:0-26992 [005] ....  8007.433909: rtos_queue_peek_from_isr_failed: tstamp:250508735402 queue:0x0b4b6398
 vi-output, ov56-28057 [003] ....  8007.531720: tegra_channel_capture_setup: vnc_id 0 W 3264 H 2464 fmt 20
 vi-output, ov56-28057 [003] ....  8007.531748: tegra_channel_capture_frame: sof:8006.611660938
     kworker/5:0-26992 [005] ....  8007.549800: rtos_queue_send_from_isr_failed: tstamp:250512354642 queue:0x0b4a7698
     kworker/5:0-26992 [005] ....  8007.549805: rtos_queue_send_from_isr_failed: tstamp:250512354755 queue:0x0b4ab1a8
     kworker/5:0-26992 [005] ....  8007.549806: rtos_queue_send_from_isr_failed: tstamp:250512354864 queue:0x0b4acdd8
     kworker/5:0-26992 [005] ....  8007.549807: rtos_queue_send_from_isr_failed: tstamp:250512354972 queue:0x0b4ae958
     kworker/5:0-26992 [005] ....  8007.549808: rtos_queue_send_from_isr_failed: tstamp:250512355077 queue:0x0b4af718
     

In this setup, I again reset the stream.

How do I confirm this?

Hi @JerryChang,

Any update on this? how do we resolve this?

hello jetuser,

BTW, there’re two ways for TX2 series to fetch the stream.
could you please try $ v4l2-ctl --set-ctrl low_latency_mode=<0 or, 1>.
please see-also VI-4 driver, vi4_fops.c, it’s controlling property for chan->low_latency.

moreover,
you may see-also TRM for register description, NVCSI_STREAM_0_ERROR_STATUS2VI_VC0_0
ERROR_STATUS2VI_VC0 = 0x00000004 means there’s packet payload CRC error.

Hi @JerryChang,

As suggested, I tried changing mode to both 0 and 1.
setting mode=0 resulted in no change in the error:

[16976.677566] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[16977.215139] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[16977.221653] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[16978.111188] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[16978.117696] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[16978.127677] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[16978.136440] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) INTR_STATUS 0x00000004
[16978.144373] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERR_INTR_STATUS 0x00000004
[16978.655188] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[16978.661690] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[16978.671665] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[16979.199251] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[16979.205706] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[16979.215748] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[16979.743246] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[16979.749768] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[16979.759822] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[16980.287291] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[16980.293790] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[16980.303819] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[16980.831395] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[16980.837956] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[16980.848922] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[16981.375322] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[16981.381774] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[16981.392603] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[16981.919434] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[16981.926100] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[16981.935943] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[16982.463477] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[16982.470212] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[16982.480587] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[16982.490055] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004

however, setting mode=1 also does not change anything, except the errors as shown below in dmesg:

[16779.988956] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[16780.500930] tegra-vi4 15700000.vi: ATOMP_FE syncpt timeout! err = -11
[16780.500942] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[16781.012988] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[16781.524994] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[16782.037025] tegra-vi4 15700000.vi: ATOMP_FE syncpt timeout! err = -11
[16782.037045] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[16782.549059] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[16783.061069] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[16783.573099] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[16783.573145] tegra-vi4 15700000.vi: ATOMP_FE syncpt timeout! err = -11
[16784.117122] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[16784.629178] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[16784.629192] tegra-vi4 15700000.vi: ATOMP_FE syncpt timeout! err = -11
[16785.173181] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[16785.685226] tegra-vi4 15700000.vi: ATOMP_FE syncpt timeout! err = -11
[16785.685239] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[16786.197189] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[16786.709279] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[16787.221393] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[16787.221407] tegra-vi4 15700000.vi: ATOMP_FE syncpt timeout! err = -11
[16787.765408] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[16788.277445] tegra-vi4 15700000.vi: ATOMP_FE syncpt timeout! err = -11
[16788.277459] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[16788.789516] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[16789.301393] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[16789.813493] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[16789.813507] tegra-vi4 15700000.vi: ATOMP_FE syncpt timeout! err = -11
[16790.357452] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[16790.869490] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[16790.869503] tegra-vi4 15700000.vi: ATOMP_FE syncpt timeout! err = -11
[16791.413590] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[16791.925596] tegra-vi4 15700000.vi: ATOMP_FE syncpt timeout! err = -11
[16792.437568] tegra-vi4 15700000.vi: ATOMP_FE syncpt timeout!
[16792.443440] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel

Further, when use this command v4l2-ctl --set-fmt-video=width=3264,height=2464,pixelformat=RG10 --stream-mmap --stream-count=100 -d /dev/video0 --stream-to=ov5693.raw and reset the FPGA, the pipeline immediately terminates and gives following error:

vte-developer@vtedeveloper-desktop:~$ v4l2-ctl --set-fmt-video=width=3264,height=2464,pixelformat=RG10 --stream-mmap --stream-count=100 -d /dev/video0 --stream-to=ov5693.raw
VIDIOC_DQBUF: failed: Input/output error

vte-developer@vtedeveloper-desktop:~$ 

I would like to report one thing, when mode=0, and I reset the FPGA 3-4 times, then after that on further pressing the reset buttons each time I get some fps info on the terminal as below:

vte-developer@vtedeveloper-desktop:~$ v4l2-ctl --set-fmt-video=width=3264,height=2464,pixelformat=RG10 --stream-mmap --stream-count=100 -d /dev/video0 --stream-to=ov5693.raw
<< 0.25 fps
< 0.25 fps
< 0.27 fps
< 0.21 fps
< 0.19 fps
< 0.21 fps
VIDIOC_DQBUF: failed: Input/output error

vte-developer@vtedeveloper-desktop:~$ 

and finally after pressing reset multiple times, i get VUDIOC_DBUF error.

The trace error when these fps are reported in the terminal are like below:

kworker/4:0-4776  [004] .... 17487.366464: rtos_queue_send_failed: tstamp:546756404536 queue:0x0b4a7698
     kworker/4:0-4776  [004] .... 17487.478458: rtos_queue_peek_from_isr_failed: tstamp:546761184301 queue:0x0b4b6398
     kworker/4:0-4776  [004] .... 17487.646711: rtos_queue_peek_from_isr_failed: tstamp:546766184235 queue:0x0b4b6398
     kworker/4:0-4776  [004] .... 17487.702527: rtcpu_vinotify_event: tstamp:546768096483 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:546768096022 data:0x00000001
 vi-output, ov56-4769  [003] .... 17487.740465: tegra_channel_capture_frame: sof:17487.165990538
     kworker/4:0-4776  [004] .... 17487.758690: rtcpu_vinotify_event: tstamp:546769527187 tag:ATOMP_FS channel:0x00 frame:2 vi_tstamp:546769526628 data:0x00000000
     kworker/4:0-4776  [004] .... 17487.758705: rtcpu_vinotify_event: tstamp:546769527491 tag:CHANSEL_PXL_SOF channel:0x00 frame:2 vi_tstamp:546769526667 data:0x00000001
     kworker/4:0-4776  [004] .... 17487.758708: rtcpu_vinotify_event: tstamp:546769535074 tag:CHANSEL_LOAD_FRAMED channel:0x01 frame:2 vi_tstamp:546769534659 data:0x08000000
 vi-output, ov56-4769  [005] .... 17487.786339: tegra_channel_capture_frame: sof:17487.211799146
     kworker/4:0-4776  [004] .... 17487.814400: rtcpu_vinotify_event: tstamp:546770958092 tag:CHANSEL_PXL_EOF channel:0x00 frame:2 vi_tstamp:546770957204 data:0x099f0002
     kworker/4:0-4776  [004] .... 17487.814409: rtcpu_vinotify_event: tstamp:546770958774 tag:CSIMUX_FRAME channel:0x00 frame:2 vi_tstamp:546770957222 data:0x00400060
     kworker/4:0-4776  [004] .... 17487.814412: rtcpu_vinotify_event: tstamp:546770959552 tag:ATOMP_FE channel:0x00 frame:2 vi_tstamp:546770957226 data:0x00000000
     kworker/4:0-4776  [004] .... 17487.814414: rtcpu_vinotify_event: tstamp:546770960255 tag:ATOMP_FS channel:0x00 frame:3 vi_tstamp:546770958147 data:0x00000000
     kworker/4:0-4776  [004] .... 17487.814417: rtcpu_vinotify_event: tstamp:546770960540 tag:CHANSEL_PXL_SOF channel:0x00 frame:3 vi_tstamp:546770958186 data:0x00000001
     kworker/4:0-4776  [004] .... 17487.814420: rtcpu_vinotify_event: tstamp:546770960950 tag:CHANSEL_LOAD_FRAMED channel:0x01 frame:3 vi_tstamp:546770958980 data:0x08000000
     kworker/4:0-4776  [004] .... 17487.814423: rtcpu_vinotify_event: tstamp:546770961223 tag:CHANSEL_FAULT_FE channel:0x01 frame:3 vi_tstamp:546770958981 data:0x00000001
     kworker/4:0-4776  [004] .... 17487.814426: rtcpu_vinotify_event: tstamp:546770961520 tag:ATOMP_FE channel:0x00 frame:3 vi_tstamp:546770958984 data:0x00000000
     kworker/4:0-4776  [004] .... 17487.814440: rtos_queue_peek_from_isr_failed: tstamp:546771184223 queue:0x0b4b6398
     kworker/4:0-4776  [004] .... 17487.982474: rtos_queue_peek_from_isr_failed: tstamp:546776184218 queue:0x0b4b6398
     kworker/4:0-4776  [004] .... 17488.150411: rtos_queue_peek_from_isr_failed: tstamp:546781184215 queue:0x0b4b6398
     kworker/4:0-4776  [004] .... 17488.318327: rtos_queue_peek_from_isr_failed: tstamp:546786184204 queue:0x0b4b6398
 vi-output, ov56-4769  [004] .... 17488.362114: tegra_channel_capture_setup: vnc_id 0 W 3264 H 2464 fmt 20
 vi-output, ov56-4769  [004] .... 17488.362146: tegra_channel_capture_frame: sof:17487.211799146
     kworker/4:0-4776  [004] .... 17488.374209: rtos_queue_send_from_isr_failed: tstamp:546788107465 queue:0x0b4a7698
     kworker/4:0-4776  [004] .... 17488.374212: rtos_queue_send_from_isr_failed: tstamp:546788107758 queue:0x0b4ab1a8

Hey,

Yes, same can be inferred from traces also:

tag:CSIMUX_FRAME channel:0x00 frame:2 vi_tstamp:546770957222 data:0x00400060

How do i resolve this? can I disable CRC checks? will disabling the error checks solve the problem?

UPDATE:
I realised that my FPGA was set in continuous DPHY clock mode, instead of Non_continuous mode.
I did the modification and now I don’t have to press reset every time(however, do need to sometimes and sometimes i get fps info automatically after waiting some time), for the following command v4l2-ctl --set-fmt-video=width=3264,height=2464,pixelformat=RG10 --stream-mmap --stream-count=100 -d /dev/video0 --stream-to=ov5693.raw I am getting this error:

vte-developer@vtedeveloper-desktop:~$ v4l2-ctl --set-fmt-video=width=3264,height=2464,pixelformat=RG10 --stream-mmap --stream-count=100 -d /dev/video0 --stream-to=ov5693.raw
<< 0.84 fps
< 0.83 fps
< 0.42 fps
< 0.48 fps
< 0.49 fps
^C
vte-developer@vtedeveloper-desktop:~$ 

dmsg

[25122.035073] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[25122.045796] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[25122.054583] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) INTR_STATUS 0x00000004
[25122.062671] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERR_INTR_STATUS 0x00000004
[25122.604308] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[25122.610906] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[25122.621166] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[25122.630041] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) INTR_STATUS 0x00000004
[25122.637984] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERR_INTR_STATUS 0x00000004
[25123.212302] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[25123.218759] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[25123.228690] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[25123.237493] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) INTR_STATUS 0x00000004
[25123.245509] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERR_INTR_STATUS 0x00000004
[25123.784208] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[25123.790643] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[25123.800393] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[25123.809511] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) INTR_STATUS 0x00000004
[25123.817581] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERR_INTR_STATUS 0x00000004
[25123.826870] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERROR_STATUS2VI_VC0 = 0x00000004
[25123.836337] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) INTR_STATUS 0x00000004
[25123.844672] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERR_INTR_STATUS 0x00000004

traces

    kworker/4:0-8357  [004] .... 25119.700268: rtcpu_vinotify_event: tstamp:785266907016 tag:ATOMP_FS channel:0x00 frame:30 vi_tstamp:785266906504 data:0x00000000
     kworker/4:0-8357  [004] .... 25119.700279: rtcpu_vinotify_event: tstamp:785266907135 tag:CHANSEL_PXL_SOF channel:0x00 frame:30 vi_tstamp:785266906592 data:0x00000001
     kworker/4:0-8357  [004] .... 25119.700282: rtcpu_vinotify_event: tstamp:785266910277 tag:CHANSEL_LOAD_FRAMED channel:0x01 frame:30 vi_tstamp:785266909948 data:0x08000000
 vi-output, ov56-9692  [003] .... 25119.704551: tegra_channel_capture_frame: sof:25118.956048041
     kworker/4:0-8357  [004] .... 25119.756276: rtcpu_vinotify_event: tstamp:785268395986 tag:CHANSEL_PXL_EOF channel:0x00 frame:30 vi_tstamp:785268395182 data:0x099f0002
     kworker/4:0-8357  [004] .... 25119.756288: rtcpu_vinotify_event: tstamp:785268396598 tag:CSIMUX_FRAME channel:0x00 frame:30 vi_tstamp:785268395226 data:0x00400060
     kworker/4:0-8357  [004] .... 25119.756292: rtcpu_vinotify_event: tstamp:785268397415 tag:ATOMP_FE channel:0x00 frame:30 vi_tstamp:785268395229 data:0x00000000
     kworker/4:0-8357  [004] .... 25119.756295: rtcpu_vinotify_event: tstamp:785268398186 tag:ATOMP_FS channel:0x00 frame:31 vi_tstamp:785268396197 data:0x00000000
     kworker/4:0-8357  [004] .... 25119.756298: rtcpu_vinotify_event: tstamp:785268398478 tag:CHANSEL_PXL_SOF channel:0x00 frame:31 vi_tstamp:785268396284 data:0x00000001
     kworker/4:0-8357  [004] .... 25119.756302: rtcpu_vinotify_event: tstamp:785268398888 tag:CHANSEL_LOAD_FRAMED channel:0x01 frame:31 vi_tstamp:785268396804 data:0x08000000
     kworker/4:0-8357  [004] .... 25119.756305: rtcpu_vinotify_event: tstamp:785268399161 tag:CHANSEL_FAULT_FE channel:0x01 frame:31 vi_tstamp:785268396806 data:0x00000001
     kworker/4:0-8357  [004] .... 25119.756308: rtcpu_vinotify_event: tstamp:785268399466 tag:ATOMP_FE channel:0x00 frame:31 vi_tstamp:785268396809 data:0x00000000
     kworker/4:0-8357  [004] .... 25119.812206: rtos_queue_peek_from_isr_failed: tstamp:785270858664 queue:0x0b4b6398