Camera fails to capture frames with VIFALC_TDSTATE error

Hi ShaneCCC,

I use a new LI-JXAV-MIPI-ADPT-4CAM connection board. This time Orin is confirmed to receiver signal from sensor but it still cannot capture images.

The format of the output image is 1920 * 1080p @ 60fps bayer_bggr12. I have configured the sensor to disable all embedded data.

The dmesg shows the frame has been discarded:

[  261.610524] tegra-camrtc-capture-vi tegra-capture-vi: corr_err: discarding frame 0, flags: 0, err_data 131072

The trace log shows CHANSEL_NOMATCH error.

# tracer: nop
#
# entries-in-buffer/entries-written: 36/36   #P:12
#
#                                _-----=> irqs-off
#                               / _----=> need-resched
#                              | / _---=> hardirq/softirq
#                              || / _--=> preempt-depth
#                              ||| /     delay
#           TASK-PID     CPU#  ||||   TIMESTAMP  FUNCTION
#              | |         |   ||||      |         |
     simple_test-3699    [005] ....   261.557707: tegra_channel_open: vi-output, ox03c10_cam 3
     simple_test-3699    [005] ....   261.559995: tegra_channel_set_power: ox03c10_cam 30-0036 : 0x1
     simple_test-3699    [005] ....   261.560022: camera_common_s_power: status : 0x1
     simple_test-3699    [005] ....   261.560037: tegra_channel_set_power: 13e40000.host1x:nvcsi@15a00000- : 0x1
     simple_test-3699    [005] ....   261.560042: csi_s_power: enable : 0x1
     simple_test-3699    [005] ....   261.560580: tegra_channel_capture_setup: vnc_id 0 W 1920 H 1084 fmt c4
     simple_test-3699    [006] ....   261.561634: tegra_channel_set_stream: enable : 0x1
     simple_test-3699    [006] ....   261.579378: tegra_channel_set_stream: 13e40000.host1x:nvcsi@15a00000- : 0x1
     simple_test-3699    [006] ....   261.579382: csi_s_stream: enable : 0x1
     simple_test-3699    [006] ....   261.579709: tegra_channel_set_stream: ox03c10_cam 30-0036 : 0x1
     simple_test-3699    [006] ....   261.620830: tegra_channel_set_stream: enable : 0x0
     simple_test-3699    [006] ....   261.620832: tegra_channel_set_stream: ox03c10_cam 30-0036 : 0x0
     simple_test-3699    [006] ....   261.620841: tegra_channel_set_stream: 13e40000.host1x:nvcsi@15a00000- : 0x0
     simple_test-3699    [006] ....   261.620842: csi_s_stream: enable : 0x0
     simple_test-3699    [007] ....   261.633522: tegra_channel_set_power: ox03c10_cam 30-0036 : 0x0
     simple_test-3699    [007] ....   261.633534: camera_common_s_power: status : 0x0
     simple_test-3699    [007] ....   261.633545: tegra_channel_set_power: 13e40000.host1x:nvcsi@15a00000- : 0x0
     simple_test-3699    [007] ....   261.633548: csi_s_power: enable : 0x0
     simple_test-3699    [007] ....   261.633593: tegra_channel_close: vi-output, ox03c10_cam 3
     kworker/8:1-76      [008] ....   261.639044: rtcpu_vinotify_error: tstamp:9047838347 cch:-1 vi:0 tag:CSIMUX_STREAM channel:0x00 frame:0 vi_tstamp:289530803360 data:0x0000000000000001
     kworker/8:1-76      [008] ....   261.639051: rtcpu_vinotify_event: tstamp:9047845593 cch:-1 vi:0 tag:CSIMUX_STREAM channel:0x00 frame:0 vi_tstamp:289530803360 data:0x0000000000000001
     kworker/8:1-76      [008] ....   261.639052: rtcpu_vinotify_event: tstamp:9047845730 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:289530832768 data:0x399d580010000000
     kworker/8:1-76      [008] ....   261.639053: rtcpu_vinotify_event: tstamp:9047845885 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:289530839264 data:0x0000000031000001
     kworker/8:1-76      [008] ....   261.639054: rtcpu_vinotify_event: tstamp:9048521765 cch:0 vi:0 tag:FS channel:0x00 frame:0 vi_tstamp:289542489088 data:0x0000000000000010
     kworker/8:1-76      [008] ....   261.639055: rtcpu_vinotify_event: tstamp:9048521923 cch:0 vi:0 tag:ATOMP_FS channel:0x00 frame:0 vi_tstamp:289542489120 data:0x0000000800000000
     kworker/8:1-76      [008] ....   261.639056: rtcpu_vinotify_event: tstamp:9048522055 cch:0 vi:0 tag:CHANSEL_PXL_SOF channel:0x23 frame:0 vi_tstamp:289542524288 data:0x0000000000000001
     kworker/8:1-76      [008] ....   261.639057: rtcpu_vinotify_event: tstamp:9048522208 cch:0 vi:0 tag:VIFALC_ACTIONLST channel:0x23 frame:0 vi_tstamp:289542525824 data:0x0000000008020001
     kworker/8:1-76      [008] ....   261.639058: rtcpu_vinotify_error: tstamp:9048724850 cch:0 vi:0 tag:CHANSEL_NOMATCH channel:0x01 frame:0 vi_tstamp:289559171360 data:0x0000000000000589
     kworker/8:1-76      [008] ....   261.639058: rtcpu_vinotify_event: tstamp:9048859930 cch:0 vi:0 tag:FE channel:0x00 frame:0 vi_tstamp:289557800032 data:0x0000000000000020
     kworker/8:1-76      [008] ....   261.639059: rtcpu_vinotify_event: tstamp:9048860087 cch:0 vi:0 tag:CHANSEL_SHORT_FRAME channel:0x01 frame:0 vi_tstamp:289557800032 data:0x0438200001000000
     kworker/8:1-76      [008] ....   261.639060: rtcpu_vinotify_event: tstamp:9048860221 cch:0 vi:0 tag:VIFALC_ACTIONLST channel:0x23 frame:0 vi_tstamp:289557809312 data:0x0000000001020001
     kworker/8:1-76      [008] ....   261.639060: rtcpu_vinotify_event: tstamp:9048860380 cch:0 vi:0 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:289557800032 data:0x0000000800000000
     kworker/8:1-76      [008] ....   261.639062: rtcpu_vinotify_event: tstamp:9048860511 cch:0 vi:0 tag:FS channel:0x00 frame:0 vi_tstamp:289559136224 data:0x0000000000000010
     kworker/8:1-76      [008] ....   261.639062: rtcpu_vinotify_event: tstamp:9048860664 cch:0 vi:0 tag:CHANSEL_NOMATCH channel:0x01 frame:0 vi_tstamp:289559171360 data:0x0000000000000589
     kworker/8:1-76      [008] ....   261.639063: rtcpu_vinotify_event: tstamp:9049541901 cch:-1 vi:0 tag:FE channel:0x00 frame:0 vi_tstamp:289580334624 data:0x0000000000000020
     kworker/8:1-76      [008] ....   267.806032: rtcpu_string: tstamp:9241340550 id:0x04010000 str:"VM0 deactivating."