Adding second camera to TX2 p3310

Hi @ShaneCCC
update
now, the trace log shows PXL_SOF PXL_EOF etc.


     kworker/5:0-42    [005] ....   201.878667: rtos_queue_send_from_isr_failed: tstamp:6454814155 queue:0x0b4b2058
     kworker/5:0-42    [005] ....   201.878667: rtos_queue_send_failed: tstamp:6454815099 queue:0x0b4a7698
 vi-output, ov92-9110  [003] ....   201.878746: tegra_channel_set_stream: 150c0000.nvcsi--1 : 0x1
 vi-output, ov92-9110  [003] ....   201.878749: csi_s_stream: enable : 0x1
 vi-output, ov92-9110  [003] ....   201.878801: tegra_channel_set_stream: ov9281 2-0010 : 0x1
 vi-output, ov92-9110  [003] ....   202.001946: tegra_channel_capture_frame: sof:201.763182150
     kworker/5:0-42    [005] ....   202.046736: rtcpu_vinotify_event: tstamp:6458471157 tag:CSIMUX_FRAME channel:0x00 frame:1 vi_tstamp:6458470728 data:0x00400061
     kworker/5:0-42    [005] ....   202.046744: rtcpu_vinotify_event: tstamp:6458687020 tag:CSIMUX_FRAME channel:0x00 frame:2 vi_tstamp:6458686619 data:0x00400061
     kworker/5:0-42    [005] ....   202.046746: rtcpu_vinotify_event: tstamp:6458713467 tag:CHANSEL_PXL_SOF channel:0x00 frame:3 vi_tstamp:6458712936 data:0x00000001
     kworker/5:0-42    [005] ....   202.046749: rtcpu_vinotify_event: tstamp:6458713685 tag:ATOMP_FS channel:0x00 frame:3 vi_tstamp:6458712946 data:0x00000000
     kworker/5:0-42    [005] ....   202.046751: rtcpu_vinotify_event: tstamp:6458718501 tag:CHANSEL_LOAD_FRAMED channel:0x02 frame:3 vi_tstamp:6458718112 data:0x08000000
     kworker/5:0-42    [005] ....   202.046753: rtcpu_vinotify_event: tstamp:6458903243 tag:CSIMUX_FRAME channel:0x00 frame:3 vi_tstamp:6458902510 data:0x00400061
     kworker/5:0-42    [005] ....   202.046755: rtcpu_vinotify_event: tstamp:6458903480 tag:CHANSEL_SHORT_FRAME channel:0x02 frame:3 vi_tstamp:6458902510 data:0x00000001
     kworker/5:0-42    [005] ....   202.046757: rtcpu_vinotify_event: tstamp:6458903674 tag:ATOMP_FE channel:0x00 frame:3 vi_tstamp:6458902513 data:0x00000000
     kworker/5:0-42    [005] ....   202.046763: rtos_queue_peek_from_isr_failed: tstamp:6459801984 queue:0x0b4b4940
     kworker/5:0-42    [005] ....   202.218696: rtos_queue_peek_from_isr_failed: tstamp:6464801998 queue:0x0b4b4940
 vi-output, ov92-9110  [005] ....   202.261320: tegra_channel_capture_setup: vnc_id 0 W 1280 H 800 fmt 10
 vi-output, ov92-9110  [005] ....   202.261361: tegra_channel_capture_frame: sof:201.763182150
 vi-output, ov92-9110  [004] ....   202.264426: tegra_channel_capture_frame: sof:202.25696060
     kworker/5:0-42    [005] ....   202.270715: rtos_queue_send_from_isr_failed: tstamp:6465501487 queue:0x0b4a7698


...
  kworker/5:0-42    [005] ....   202.270762: rtos_queue_send_from_isr_failed: tstamp:6466818433 queue:0x0b4acdd8
     kworker/5:0-42    [005] ....   202.270763: rtos_queue_send_from_isr_failed: tstamp:6466818573 queue:0x0b4ae958
     kworker/5:0-42    [005] ....   202.270765: rtos_queue_send_from_isr_failed: tstamp:6466818714 queue:0x0b4af718
     kworker/5:0-42    [005] ....   202.270766: rtos_queue_send_from_isr_failed: tstamp:6466818852 queue:0x0b4b04d8
     kworker/5:0-42    [005] ....   202.270767: rtos_queue_send_from_isr_failed: tstamp:6466818989 queue:0x0b4b1298
     kworker/5:0-42    [005] ....   202.270769: rtos_queue_send_from_isr_failed: tstamp:6466819128 queue:0x0b4b2058
     kworker/5:0-42    [005] ....   202.270770: rtos_queue_send_failed: tstamp:6466820561 queue:0x0b4a7698
     kworker/5:0-42    [005] ....   202.270773: rtcpu_vinotify_event: tstamp:6466917328 tag:CHANSEL_PXL_SOF channel:0x00 frame:41 vi_tstamp:6466916777 data:0x00000001
     kworker/5:0-42    [005] ....   202.270774: rtcpu_vinotify_event: tstamp:6466917538 tag:ATOMP_FS channel:0x00 frame:41 vi_tstamp:6466916787 data:0x00000000
     kworker/5:0-42    [005] ....   202.270776: rtcpu_vinotify_event: tstamp:6466920785 tag:CHANSEL_LOAD_FRAMED channel:0x02 frame:41 vi_tstamp:6466920387 data:0x08000000
     kworker/5:0-42    [005] ....   202.270777: rtcpu_vinotify_event: tstamp:6467107085 tag:CSIMUX_FRAME channel:0x00 frame:41 vi_tstamp:6467106351 data:0x00400061
     kworker/5:0-42    [005] ....   202.270778: rtcpu_vinotify_event: tstamp:6467107330 tag:CHANSEL_SHORT_FRAME channel:0x02 frame:41 vi_tstamp:6467106351 data:0x00000001
     kworker/5:0-42    [005] ....   202.270779: rtcpu_vinotify_event: tstamp:6467107502 tag:ATOMP_FE channel:0x00 frame:41 vi_tstamp:6467106355 data:0x00000000
     kworker/5:0-42    [005] ....   202.382769: rtos_queue_peek_from_isr_failed: tstamp:6469801993 queue:0x0b4b4940
     kworker/5:0-42    [005] ....   202.500073: rtos_queue_send_from_isr_failed: tstamp:6473748296 queue:0x0b4a7698
     kworker/5:0-42    [005] ....   202.500079: rtos_queue_send_from_isr_failed: tstamp:6473748458 queue:0x0b4ab1a8
     kworker/5:0-42    [005] ....   202.500080: rtos_queue_send_from_isr_failed: tstamp:6473748599 queue:0x0b4acdd8


demsg:

[   43.084470] ov9281 2-0010: ov9281_s_stream: write fsync table 2
[   43.158774] ov9281 2-0010: ov9281_s_stream: write fsync slave mode table 0
[   43.166213] ov9281 2-0010: ov9281_s_stream: stream on
[   43.386889] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[   43.393384] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[   43.403922] nvcsi 150c0000.nvcsi: csi4_stream_check_status (1) ERROR_STATUS2VI_VC0 = 0x00000004
[   43.412741] nvcsi 150c0000.nvcsi: csi4_cil_check_status (1) CILA_INTR_STATUS 0x0000000e
[   43.420844] nvcsi 150c0000.nvcsi: csi4_cil_check_status (1) CILA_ERR_INTR_STATUS 0x0000000e
[   43.638719] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[   43.645484] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[   43.656134] nvcsi 150c0000.nvcsi: csi4_stream_check_status (1) ERROR_STATUS2VI_VC0 = 0x00000004
[   43.664981] nvcsi 150c0000.nvcsi: csi4_cil_check_status (1) CILA_INTR_STATUS 0x0400011e
[   43.673173] nvcsi 150c0000.nvcsi: csi4_cil_check_status (1) CILA_ERR_INTR_STATUS 0x0400011e
[   43.886847] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[   43.893452] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[   43.904982] nvcsi 150c0000.nvcsi: csi4_stream_check_status (1) ERROR_STATUS2VI_VC0 = 0x00000004
[   43.913984] nvcsi 150c0000.nvcsi: csi4_cil_check_status (1) CILA_INTR_STATUS 0x0400011e
[   43.922165] nvcsi 150c0000.nvcsi: csi4_cil_check_status (1) CILA_ERR_INTR_STATUS 0x0400011e
[   44.134654] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[   44.141121] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[   44.153707] nvcsi 150c0000.nvcsi: csi4_stream_check_status (1) ERROR_STATUS2VI_VC0 = 0x00000004
[   44.162704] nvcsi 150c0000.nvcsi: csi4_cil_check_status (1) CILA_INTR_STATUS 0x0400011e
[   44.171107] nvcsi 150c0000.nvcsi: csi4_cil_check_status (1) CILA_ERR_INTR_STATUS 0x0400011e
[   44.382745] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[   44.389322] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[   44.400670] nvcsi 150c0000.nvcsi: csi4_stream_check_status (1) ERROR_STATUS2VI_VC0 = 0x00000004
[   44.409515] nvcsi 150c0000.nvcsi: csi4_cil_check_status (1) CILA_INTR_STATUS 0x0400011e
[   44.417662] nvcsi 150c0000.nvcsi: csi4_cil_check_status (1) CILA_ERR_INTR_STATUS 0x0400011e
[   44.630747] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11

The trace log show the CHANSEL_SHORT_FRAME that tell the output size didn’t as expected.

Hi @ShaneCCC
We dump the two sensors, but their indexs are the same. We thought that there should be index0 and index1, refer to this post.

root@t-desktop:/home/t# v4l2-ctl -d /dev/video0 --list-formats-ext
ioctl: VIDIOC_ENUM_FMT
	Index       : 0
	Type        : Video Capture
	Pixel Format: 'GREY'
	Name        : 8-bit Greyscale
		Size: Discrete 640x400
			Interval: Discrete 0.008s (120.000 fps)

root@t-desktop:/home/t# 
root@t-desktop:/home/t# v4l2-ctl -d /dev/video1 --list-formats-ext
ioctl: VIDIOC_ENUM_FMT
	Index       : 0
	Type        : Video Capture
	Pixel Format: 'GREY'
	Name        : 8-bit Greyscale
		Size: Discrete 640x400
			Interval: Discrete 0.008s (120.000 fps)

is the mapping right?

What’s more, how to debug CHANSEL_SHORT_FRAME promble, we have been trapped in it.

update Dynamic debug log

[  838.458148] ov9281 2-0010: ov9281_s_stream: write mode table 3
[  838.477876] ov9281 2-0010: ov9281_s_stream: write fsync table 2
[  838.552777] ov9281 2-0010: ov9281_s_stream: write fsync slave mode table 3
[  838.560385] ov9281 2-0010: ov9281_s_stream: stream on
[  838.578577] video4linux video1: vi_notify_wait: vi4 got SOF syncpt buf[ffffffc17b2af800]
[  838.779593] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[  838.786418] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[  838.796677] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[  838.796689] nvcsi 150c0000.nvcsi: csi4_phy_config
[  838.796702] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000200
[  838.796716] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[  838.796736] nvcsi 150c0000.nvcsi: csi4_cil_check_status 407
[  838.796745] nvcsi 150c0000.nvcsi: csi4_cil_check_status (1) CILA_INTR_STATUS 0x0000000e
[  838.804854] nvcsi 150c0000.nvcsi: csi4_cil_check_status (1) CILA_ERR_INTR_STATUS 0x0000000e
[  838.813249] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[  838.813253] nvcsi 150c0000.nvcsi: csi4_stream_init
[  838.813264] nvcsi 150c0000.nvcsi: csi4_stream_config
[  838.813273] nvcsi 150c0000.nvcsi: csi4_stream_config (1) read VC0_DPCM_CTRL = 00000000
[  838.813277] nvcsi 150c0000.nvcsi: csi4_phy_config
[  838.813282] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[  838.813290] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 200
[  838.813294] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[  838.813297] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 22
[  838.813577] tegra-vi4 15700000.vi: Create Surface with imgW=640, imgH=400, memFmt=16
[  838.813588] video4linux video1: free_ring_buffers: capture init latency is 370 ms
[  838.820509] video4linux video1: vi_notify_wait: vi4 got SOF syncpt buf[ffffffc17b2ad000]
[  839.023620] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[  839.030209] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[  839.040141] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[  839.040148] nvcsi 150c0000.nvcsi: csi4_phy_config
[  839.040156] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000200
[  839.040165] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[  839.040180] nvcsi 150c0000.nvcsi: csi4_cil_check_status 407
[  839.040186] nvcsi 150c0000.nvcsi: csi4_cil_check_status (1) CILA_INTR_STATUS 0x0000000e
[  839.048240] nvcsi 150c0000.nvcsi: csi4_cil_check_status (1) CILA_ERR_INTR_STATUS 0x0000000e
[  839.056621] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[  839.056624] nvcsi 150c0000.nvcsi: csi4_stream_init
[  839.056638] nvcsi 150c0000.nvcsi: csi4_stream_config
[  839.056648] nvcsi 150c0000.nvcsi: csi4_stream_config (1) read VC0_DPCM_CTRL = 00000000
[  839.056651] nvcsi 150c0000.nvcsi: csi4_phy_config
[  839.056656] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[  839.056664] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 200
[  839.056667] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[  839.056670] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 22
[  839.056941] tegra-vi4 15700000.vi: Create Surface with imgW=640, imgH=400, memFmt=16
[  839.062509] video4linux video1: vi_notify_wait: vi4 got SOF syncpt buf[ffffffc17b2af800]
[  839.263583] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[  839.270240] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[  839.281008] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[  839.281020] nvcsi 150c0000.nvcsi: csi4_phy_config
[  839.281031] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000200
[  839.281043] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[  839.281061] nvcsi 150c0000.nvcsi: csi4_cil_check_status 407
[  839.281069] nvcsi 150c0000.nvcsi: csi4_cil_check_status (1) CILA_INTR_STATUS 0x0000000e
[  839.289177] nvcsi 150c0000.nvcsi: csi4_cil_check_status (1) CILA_ERR_INTR_STATUS 0x0000000e
[  839.297642] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[  839.297647] nvcsi 150c0000.nvcsi: csi4_stream_init
[  839.297661] nvcsi 150c0000.nvcsi: csi4_stream_config
[  839.297672] nvcsi 150c0000.nvcsi: csi4_stream_config (1) read VC0_DPCM_CTRL = 00000000
[  839.297676] nvcsi 150c0000.nvcsi: csi4_phy_config
[  839.297684] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[  839.297693] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 200
[  839.297698] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[  839.297701] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 22
[  839.298032] tegra-vi4 15700000.vi: Create Surface with imgW=640, imgH=400, memFmt=16
[  839.304509] video4linux video1: vi_notify_wait: vi4 got SOF syncpt buf[ffffffc17b2ad000]
[  839.507555] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[  839.514208] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[  839.525307] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[  839.525342] nvcsi 150c0000.nvcsi: csi4_phy_config
[  839.525367] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000200
[  839.525391] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[  839.525424] nvcsi 150c0000.nvcsi: csi4_cil_check_status 407
[  839.525443] nvcsi 150c0000.nvcsi: csi4_cil_check_status (1) CILA_INTR_STATUS 0x0000000e
[  839.533605] nvcsi 150c0000.nvcsi: csi4_cil_check_status (1) CILA_ERR_INTR_STATUS 0x0000000e
[  839.542002] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[  839.542009] nvcsi 150c0000.nvcsi: csi4_stream_init
[  839.542026] nvcsi 150c0000.nvcsi: csi4_stream_config
[  839.542036] nvcsi 150c0000.nvcsi: csi4_stream_config (1) read VC0_DPCM_CTRL = 00000000
[  839.542041] nvcsi 150c0000.nvcsi: csi4_phy_config
[  839.542049] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[  839.542058] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 200
[  839.542064] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[  839.542069] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 22
[  839.542412] tegra-vi4 15700000.vi: Create Surface with imgW=640, imgH=400, memFmt=16
[  839.546524] video4linux video1: vi_notify_wait: vi4 got SOF syncpt buf[ffffffc17b2af800]
[  839.747644] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[  839.754316] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[  839.765475] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2

Hi @ShaneCCC
refer to these topics, topic, we recheck DT and modify pix_clk_hz.
the trace log shows CHANSEL_FAULT, is this a progress?

vi-output, ov92-8943  [000] ....   113.905239: tegra_channel_set_stream: enable : 0x1
 vi-output, ov92-8943  [000] ....   113.906621: tegra_channel_set_stream: 150c0000.nvcsi--1 : 0x1
 vi-output, ov92-8943  [000] ....   113.906623: csi_s_stream: enable : 0x1
 vi-output, ov92-8943  [000] ....   113.906651: tegra_channel_set_stream: ov9281 2-0010 : 0x1 
     kworker/5:1-966   [005] ....   113.942019: rtos_queue_peek_from_isr_failed: tstamp:3715275092 queue:0x0b4b4940
     kworker/5:1-966   [005] ....   113.942023: rtcpu_start: tstamp:3715275892
     kworker/5:1-966   [005] ....   113.942025: rtos_queue_send_from_isr_failed: tstamp:3715284081 queue:0x0b4a7698
     kworker/5:1-966   [005] ....   114.057989: rtcpu_vinotify_event: tstamp:3719312002 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:3719311619 data:0x00000010
 vi-output, ov92-8943  [004] ....   114.075636: tegra_channel_capture_frame: sof:113.961614946
     kworker/5:1-966   [005] ....   114.113999: rtos_queue_peek_from_isr_failed: tstamp:3720275439 queue:0x0b4b4940
     kworker/5:1-966   [005] ....   114.114003: rtcpu_vinotify_event: tstamp:3720615716 tag:CHANSEL_PXL_SOF channel:0x00 frame:8 vi_tstamp:3720615203 data:0x00000001
     kworker/5:1-966   [005] ....   114.114004: rtcpu_vinotify_event: tstamp:3720615877 tag:ATOMP_FS channel:0x00 frame:8 vi_tstamp:3720615221 data:0x00000000
     kworker/5:1-966   [005] ....   114.114004: rtcpu_vinotify_event: tstamp:3720616690 tag:CHANSEL_FAULT channel:0x00 frame:8 vi_tstamp:3720616329 data:0x00010200
     kworker/5:1-966   [005] ....   114.114005: rtcpu_vinotify_event: tstamp:3720617138 tag:CHANSEL_LOAD_FRAMED channel:0x02 frame:8 vi_tstamp:3720616823 data:0x08000000
     kworker/5:1-966   [005] ....   114.114005: rtcpu_vinotify_event: tstamp:3720617689 tag:CHANSEL_FAULT_FE channel:0x02 frame:8 vi_tstamp:3720617194 data:0x00000001
     kworker/5:1-966   [005] ....   114.114006: rtcpu_vinotify_event: tstamp:3720617825 tag:ATOMP_FE channel:0x00 frame:8 vi_tstamp:3720617198 data:0x00000000
     kworker/5:1-966   [005] ....   114.226005: rtos_queue_peek_from_isr_failed: tstamp:3725275423 queue:0x0b4b4940
 vi-output, ov92-8943  [004] ....   114.335760: tegra_channel_capture_setup: vnc_id 0 W 640 H 400 fmt 10
 vi-output, ov92-8943  [004] ....   114.335792: tegra_channel_capture_frame: sof:113.961614946
     kworker/5:1-966   [005] ....   114.337984: rtos_queue_send_from_isr_failed: tstamp:3727441772 queue:0x0b4a7698
     kworker/5:1-966   [005] ....   114.338007: rtos_queue_send_from_isr_failed: tstamp:3728744461 queue:0x0b4b2058
     kworker/5:1-966   [005] ....   114.338007: rtos_queue_send_failed: tstamp:3728745335 queue:0x0b4a7698
     kworker/5:1-966   [005] ....   114.338009: rtcpu_vinotify_event: tstamp:3728746501 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:3728745547 data:0x00000010
 vi-output, ov92-8943  [003] ....   114.376085: tegra_channel_capture_frame: sof:114.262031169
     kworker/5:1-966   [005] ....   114.393992: rtcpu_vinotify_event: tstamp:3730003784 tag:CHANSEL_PXL_SOF channel:0x00 frame:44 vi_tstamp:3730003064 data:0x00000001
     kworker/5:1-966   [005] ....   114.393994: rtcpu_vinotify_event: tstamp:3730003945 tag:ATOMP_FS channel:0x00 frame:44 vi_tstamp:3730003082 data:0x00000000
     kworker/5:1-966   [005] ....   114.393995: rtcpu_vinotify_event: tstamp:3730004059 tag:CHANSEL_FAULT channel:0x00 frame:44 vi_tstamp:3730003335 data:0x00000200
     kworker/5:1-966   [005] ....   114.393995: rtcpu_vinotify_event: tstamp:3730004841 tag:CHANSEL_LOAD_FRAMED channel:0x02 frame:44 vi_tstamp:3730004193 data:0x08000000
     kworker/5:1-966   [005] ....   114.393996: rtcpu_vinotify_event: tstamp:3730004947 tag:CHANSEL_FAULT_FE channel:0x02 frame:44 vi_tstamp:3730004201 data:0x00000001
     kworker/5:1-966   [005] ....   114.393996: rtcpu_vinotify_event: tstamp:3730005085 tag:ATOMP_FE channel:0x00 frame:44 vi_tstamp:3730004204 data:0x00000000
     kworker/5:1-966   [005] ....   114.393998: rtos_queue_peek_from_isr_failed: tstamp:3730275430 queue:0x0b4b4940
     kworker/5:1-966   [005] ....   114.562043: rtos_queue_peek_from_isr_failed: tstamp:3735275462 queue:0x0b4b4940
...

Now the CHANSEL_FAULT show the PIXEL_SHORT_LINE that could be the output pixel less than expect(640)

Hi @ShaneCCC
could you give some suggestions?
we do not know what to do next step.

in the DT, active_w = “640”, but how to confirm the actural streaming width?

You can modify the sensor driver to report less lines one by one to narrow down it.

Hi @ShaneCCC

ov9281_mode_tbls.h

static const struct camera_common_frmfmt ov9281_frmfmt[] = {
	{ { 1280, 800 }, ov9281_60fps, ARRAY_SIZE(ov9281_60fps), 0,
	  OV9281_MODE_1280X800 },
	{ { 1280, 720 }, ov9281_60fps, ARRAY_SIZE(ov9281_60fps), 0,
	  OV9281_MODE_1280X720 },
	{ { 640, 400 }, ov9281_60fps, ARRAY_SIZE(ov9281_60fps), 0,
	  OV9281_MODE_640X400 },
};

should we change ov9281_frmfmt struct and narrow down 640?

Yes, also you can remove others mode for debugging.

Hi @ShaneCCC
good news: we got a frame.
t_928_4.raw (300 KB)

bad news: the fame is not perfect. and stream is not fluent.

root@t-desktop:/home/t# v4l2-ctl --set-fmt-video=width=640,height=400,pixelformat=GRAY8  --stream-mmap -d /dev/video0
<<<< 1.73 fps
< 1.46 fps
< 1.44 fps
<< 1.65 fps
< 1.52 fps
<< 1.66 fps
< 1.13 fps
<< 1.24 fps
< 1.06 fps
< 1.05 fps
< 1.05 fps
< 0.74 fps
< 0.75 fps
<< 0.80 fps
...

trace log still shows CHANSEL_SHORT_FRAME

Short frame tell the height less than driver report. Modify driver to report less to try.

Hi @ShaneCCC
at 640400 setting, v4l2 shows " size image 307200"
but at 640
480 setting, shows “size image 368640”
only at 1280*800, 102400.
how to config it?

root@t-desktop:/home/t# v4l2-ctl --set-fmt-video=width=640,height=480,pixelformat=RAW8  --stream-mmap -d /dev/video0 --verbose
VIDIOC_QUERYCAP: ok
VIDIOC_G_FMT: ok
VIDIOC_S_FMT: ok
Format Video Capture:
	Width/Height      : 640/480
	Pixel Format      : 'GREY'
	Field             : None
	Bytes per Line    : 768
	Size Image        : 368640
	Colorspace        : sRGB
	Transfer Function : Default (maps to sRGB)
	YCbCr/HSV Encoding: Default (maps to ITU-R 601)
	Quantization      : Default (maps to Full Range)

root@t-desktop:/home/t# v4l2-ctl --set-fmt-video=width=640,height=400,pixelformat=RAW8  --stream-mmap -d /dev/video0 --verbose
VIDIOC_QUERYCAP: ok
VIDIOC_G_FMT: ok
VIDIOC_S_FMT: ok
Format Video Capture:
	Width/Height      : 640/400
	Pixel Format      : 'GREY'
	Field             : None
	Bytes per Line    : 768
	Size Image        : 307200
	Colorspace        : sRGB
	Transfer Function : Default (maps to sRGB)
	YCbCr/HSV Encoding: Default (maps to ITU-R 601)
	Quantization      : Default (maps to Full Range)

root@t-desktop:/home/t# v4l2-ctl --set-fmt-video=width=1280,height=800,pixelformat=RAW8  --stream-mmap -d /dev/video0 --verbose
VIDIOC_QUERYCAP: ok
VIDIOC_G_FMT: ok
VIDIOC_S_FMT: ok
Format Video Capture:
	Width/Height      : 1280/800
	Pixel Format      : 'GREY'
	Field             : None
	Bytes per Line    : 1280
	Size Image        : 1024000
	Colorspace        : sRGB
	Transfer Function : Default (maps to sRGB)
	YCbCr/HSV Encoding: Default (maps to ITU-R 601)
	Quantization      : Default (maps to Full Range)

That could be the 256 alignment cause the size didn’t as expect.
Suppose it doesn’t matter with the short frame error.