Jetson TX2 NX + SerDes single-link camera: stream starts, then repeated PXL_SOF syncpt timeout / CHANSEL_SHORT_FRAME / CHANSEL_NOMATCH – Jetson TX2

111.145411 ftrace tegra_channel_open: vi-output, sc130gs 9-0025 111.148156 ftrace tegra_channel_set_power: sc130gs 9-0025 : 0x1 111.148163 ftrace camera_common_s_power: status : 0x1 111.148203 dmesg sc130gs 9-0025: sc130gs_power_on: power on 111.157436 dmesg aim946x 9-0048: aim946x_gpio_set_value: GPIO0 set value 0 111.164488 ftrace tegra_channel_set_power: 150c0000.nvcsi--1 : 0x1 111.164493 ftrace csi_s_power: enable : 0x1 111.165710 dmesg nvcsi 150c0000.nvcsi: csi_port: 2 111.166956 ftrace tegra_channel_capture_setup: vnc_id 0 W 1280 H 1024 fmt 10 111.166988 dmesg tegra-vi4 15700000.vi: Create Surface with imgW=1280, imgH=1024, memFmt=16 111.167078 ftrace tegra_channel_set_stream: enable : 0x1 111.168142 ftrace tegra_channel_set_stream: 150c0000.nvcsi--1 : 0x1 111.168145 ftrace csi_s_stream: enable : 0x1 111.168152 dmesg nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2 111.168156 dmesg nvcsi 150c0000.nvcsi: csi4_stream_init 111.168166 dmesg nvcsi 150c0000.nvcsi: csi4_stream_config 111.168174 dmesg nvcsi 150c0000.nvcsi: csi4_stream_config (2) read VC0_DPCM_CTRL = 00000000 111.168177 dmesg nvcsi 150c0000.nvcsi: csi4_phy_config 111.168182 dmesg nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000 111.168188 dmesg nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 375 111.168190 dmesg nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 7 111.168196 ftrace tegra_channel_set_stream: sc130gs 9-0025 : 0x1 111.185545 ftrace rtos_queue_peek_from_isr_failed: tstamp:3809535591 queue:0x0b4b4940 111.185549 ftrace rtcpu_start: tstamp:3809536548 111.185551 ftrace rtos_queue_send_from_isr_failed: tstamp:3809543728 queue:0x0b4a7698 111.185556 ftrace rtos_queue_send_failed: tstamp:3809544820 queue:0x0b4a7698 111.333550 dmesg sc130gs 9-0025: sc130gs_start_streaming: stream started 111.353548 ftrace rtcpu_vinotify_event: tstamp:3813954609 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:3813954219 data:0x00000100 111.353552 ftrace rtcpu_vinotify_event: tstamp:3813955598 tag:CSIMUX_STREAM channel:0xff frame:48 vi_tstamp:3813955185 data:0x00000100 111.529566 dmesg video4linux video0: vi_notify_wait: vi4 got SOF syncpt buf[000000001f451abd] 111.529576 ftrace tegra_channel_capture_frame: sof:111.419959232 111.577548 ftrace rtcpu_vinotify_event: tstamp:3820866083 tag:FS channel:0x00 frame:23 vi_tstamp:3820865699 data:0x00000012 111.577551 ftrace rtcpu_vinotify_event: tstamp:3820877493 tag:CHANSEL_PXL_SOF channel:0x00 frame:23 vi_tstamp:3820876982 data:0x00000001 111.577552 ftrace rtcpu_vinotify_event: tstamp:3820877662 tag:ATOMP_FS channel:0x00 frame:23 vi_tstamp:3820876989 data:0x00000000 111.577552 ftrace rtcpu_vinotify_event: tstamp:3820881526 tag:CHANSEL_LOAD_FRAMED channel:0x04 frame:23 vi_tstamp:3820881152 data:0x08000000 111.733573 dmesg tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11 111.739928 dmesg tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel 111.751139 dmesg nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2 111.751151 dmesg nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000002 111.751161 dmesg nvcsi 150c0000.nvcsi: csi4_stream_check_status (2) ERROR_STATUS2VI_VC0 = 0x00000006 111.759862 dmesg nvcsi 150c0000.nvcsi: csi4_stream_check_status (2) ERROR_STATUS2VI_VC2 = 0x0000000a 111.768552 dmesg nvcsi 150c0000.nvcsi: csi4_stream_check_status (2) INTR_STATUS 0x0001a006 111.776376 dmesg nvcsi 150c0000.nvcsi: csi4_stream_check_status (2) ERR_INTR_STATUS 0x0001a006 111.784547 dmesg nvcsi 150c0000.nvcsi: csi4_cil_check_status 397 111.784554 dmesg nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2 111.801560 ftrace rtcpu_vinotify_event: tstamp:3827754351 tag:CHANSEL_LOAD_FRAMED channel:0x04 frame:23 vi_tstamp:3827753333 data:0x08000000 111.801561 ftrace rtcpu_vinotify_event: tstamp:3827799387 tag:CHANSEL_FAULT_FE channel:0x04 frame:23 vi_tstamp:3827775070 data:0x00000001 111.801561 ftrace rtcpu_vinotify_event: tstamp:3827799590 tag:ATOMP_FE channel:0x00 frame:23 vi_tstamp:3827775073 data:0x00000000 112.001640 dmesg nvcsi 150c0000.nvcsi: csi4_stream_check_status (2) ERROR_STATUS2VI_VC0 = 0x00000006 112.010337 dmesg nvcsi 150c0000.nvcsi: csi4_stream_check_status (2) ERROR_STATUS2VI_VC2 = 0x0000000e 112.019029 dmesg nvcsi 150c0000.nvcsi: csi4_stream_check_status (2) INTR_STATUS 0x0001e006 112.026857 dmesg nvcsi 150c0000.nvcsi: csi4_stream_check_status (2) ERR_INTR_STATUS 0x0001e006 112.035029 dmesg nvcsi 150c0000.nvcsi: csi4_cil_check_status 397 112.035036 dmesg nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2 112.081570 ftrace rtcpu_vinotify_event: tstamp:3837788748 tag:FS channel:0x00 frame:17 vi_tstamp:3837788361 data:0x00000012 112.081571 ftrace rtcpu_vinotify_event: tstamp:3837794596 tag:CHANSEL_PXL_SOF channel:0x00 frame:17 vi_tstamp:3837794085 data:0x00000001 112.081571 ftrace rtcpu_vinotify_event: tstamp:3837794764 tag:ATOMP_FS channel:0x00 frame:17 vi_tstamp:3837794094 data:0x00000000 112.081572 ftrace rtcpu_vinotify_event: tstamp:3837797634 tag:CHANSEL_LOAD_FRAMED channel:0x04 frame:17 vi_tstamp:3837797261 data:0x08000000 112.137544 ftrace rtcpu_vinotify_event: tstamp:3838985100 tag:CSIMUX_FRAME channel:0x00 frame:17 vi_tstamp:3838984358 data:0x00600062 112.137548 ftrace rtcpu_vinotify_event: tstamp:3838985309 tag:CHANSEL_SHORT_FRAME channel:0x04 frame:17 vi_tstamp:3838984358 data:0x00000001 112.137548 ftrace rtcpu_vinotify_event: tstamp:3838985449 tag:ATOMP_FE channel:0x00 frame:17 vi_tstamp:3838984361 data:0x00000000 112.273573 to 125.349869 dmesg tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11 / `tegra_channel_error_recovery: attempting to reset the capture channel/csi4_stop_streaming port_idx=0, lanes=2/csi4_stream_check_status …/csi4_cil_check_status 397/csi4_start_streaming port_idx=0, lanes=2` 115.893551 ftrace rtcpu_vinotify_event: tstamp:3956147902 tag:CHANSEL_PXL_EOF channel:0x00 frame:14 vi_tstamp:3956147339 data:0x03ff0002 115.893554 ftrace rtcpu_vinotify_event: tstamp:3956148020 tag:ATOMP_FRAME_DONE channel:0x00 frame:14 vi_tstamp:3956147353 data:0x00000000 115.893555 ftrace rtcpu_vinotify_event: tstamp:3956150503 tag:CHANSEL_FAULT channel:0x00 frame:14 vi_tstamp:3956150132 data:0x04000040 117.685582 ftrace rtcpu_vinotify_event: tstamp:4013057196 tag:CHANSEL_NOMATCH channel:0x84 frame:34560 vi_tstamp:4013056812 data:0x078003e9 122.309632 dmesg nvcsi 150c0000.nvcsi: csi4_stream_check_status (2) ERROR_STATUS2VI_VC0 = 0x0000000e 122.318329 dmesg nvcsi 150c0000.nvcsi: csi4_stream_check_status (2) ERROR_STATUS2VI_VC1 = 0x00000008 122.327024 dmesg nvcsi 150c0000.nvcsi: csi4_stream_check_status (2) ERROR_STATUS2VI_VC2 = 0x0000000a 122.335719 dmesg nvcsi 150c0000.nvcsi: csi4_stream_check_status (2) ERROR_STATUS2VI_VC2 = 0x0000000e 122.344413 dmesg nvcsi 150c0000.nvcsi: csi4_stream_check_status (2) INTR_STATUS 0x0001a006 122.352239 dmesg nvcsi 150c0000.nvcsi: csi4_stream_check_status (2) ERR_INTR_STATUS 0x0001a006 122.360413 dmesg nvcsi 150c0000.nvcsi: csi4_cil_check_status 397 122.577696 dmesg nvcsi 150c0000.nvcsi: csi4_stream_check_status (2) ERROR_STATUS2VI_VC0 = 0x0000000e 122.620289 dmesg nvcsi 150c0000.nvcsi: csi4_stream_check_status (2) ERR_INTR_STATUS 0x0001a086 124.342708 dmesg video4linux video0: vi_notify_wait: vi4 got SOF syncpt buf[000000001bd2493a] 125.339982 ftrace tegra_channel_close: vi-output, sc130gs 9-0025 125.417167 ftrace tegra_channel_set_stream: enable : 0x0 125.417168 ftrace tegra_channel_set_stream: sc130gs 9-0025 : 0x0 125.417923 dmesg nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2 125.417946 dmesg nvcsi 150c0000.nvcsi: csi4_stream_check_status (2) ERROR_STATUS2VI_VC0 = 0x00000006 125.426644 dmesg nvcsi 150c0000.nvcsi: csi4_stream_check_status (2) ERROR_STATUS2VI_VC1 = 0x00000008 125.435337 dmesg nvcsi 150c0000.nvcsi: csi4_stream_check_status (2) ERROR_STATUS2VI_VC2 = 0x0000000a 125.444032 dmesg nvcsi 150c0000.nvcsi: csi4_stream_check_status (2) ERROR_STATUS2VI_VC2 = 0x0000000e 125.452728 dmesg nvcsi 150c0000.nvcsi: csi4_stream_check_status (2) INTR_STATUS 0x00010004 125.460630 dmesg nvcsi 150c0000.nvcsi: csi4_stream_check_status (2) ERR_INTR_STATUS 0x00010004 125.468803 dmesg nvcsi 150c0000.nvcsi: csi4_cil_check_status 397 125.469963 ftrace tegra_channel_set_power: sc130gs 9-0025 : 0x0 125.469968 ftrace camera_common_s_power: status : 0x0 125.469972 dmesg sc130gs 9-0025: sc130gs_power_off: power off 125.475286 dmesg aim946x 9-0048: aim946x_gpio_set_value: GPIO0 set value 1 125.482340 ftrace tegra_channel_set_power: 150c0000.nvcsi--1 : 0x0 125.482344 ftrace csi_s_power: enable : 0x0 125.484272 ftrace tracing_mark_write: === STOP_CAMERA_CAPTURE ===