Hi Jerry,
After our HW engineer double confirm with camera vendor, we found that the MAX9296 CSI port A lane mapping configuration was incorrect. After changing the MAX9296 CSI port A PHY lane map register(0x333) to 0x4E, the err_intr_stat_ph_ecc_multi_bit_err disappeared, but the v4l2-ctl still can’t capture video data. New error messages:
v4l2-ctl -d /dev/video0 --set-ctrl bypass_mode=0 --stream-mmap --stream-count=5
[ 102.093554] bwmgr API not supported
[ 102.889515] tegra-camrtc-capture-vi tegra-capture-vi: corr_err: discarding frame 0, flags: 0, err_data 512
[ 102.922781] tegra-camrtc-capture-vi tegra-capture-vi: corr_err: discarding frame 0, flags: 0, err_data 512
[ 102.956133] tegra-camrtc-capture-vi tegra-capture-vi: corr_err: discarding frame 0, flags: 0, err_data 512
[ 102.989349] tegra-camrtc-capture-vi tegra-capture-vi: corr_err: discarding frame 0, flags: 0, err_data 512
and the kernel trace log:
cat /sys/kernel/debug/tracing/trace
# tracer: nop
#
# entries-in-buffer/entries-written: 211/211 #P:8
#
# _-----=> irqs-off
# / _----=> need-resched
# | / _—=> hardirq/softirq
# || / _–=> preempt-depth
# ||| / delay
# TASK-PID CPU# |||| TIMESTAMP FUNCTION
# | | | |||| | |
kworker/0:4-179 [000] … 232.597854: rtcpu_string: tstamp:8059626625 id:0x04010000 str:“VM0 deactivating.”
v4l2-ctl-2612 [007] … 237.838348: tegra_channel_open: vi-output, imx390 34-001b
v4l2-ctl-2612 [007] … 237.857225: tegra_channel_set_power: imx390 34-001b : 0x1
v4l2-ctl-2612 [007] … 237.857244: camera_common_s_power: status : 0x1
v4l2-ctl-2612 [007] … 237.857279: tegra_channel_set_power: 13e40000.host1x:nvcsi@15a00000- : 0x1
v4l2-ctl-2612 [007] … 237.857283: csi_s_power: enable : 0x1
v4l2-ctl-2612 [007] … 237.857425: tegra_channel_capture_setup: vnc_id 0 W 2880 H 1860 fmt c4
kworker/0:4-179 [000] … 237.861692: rtcpu_string: tstamp:8224568451 id:0x04010000 str:“VM0 activating.”
v4l2-ctl-2612 [007] … 237.866547: tegra_channel_set_stream: enable : 0x1
v4l2-ctl-2612 [007] … 237.880653: tegra_channel_set_stream: 13e40000.host1x:nvcsi@15a00000- : 0x1
v4l2-ctl-2612 [007] … 237.880656: csi_s_stream: enable : 0x1
v4l2-ctl-2612 [007] … 237.880965: tegra_channel_set_stream: imx390 34-001b : 0x1
kworker/0:4-179 [000] … 237.917670: rtcpu_vinotify_event: tstamp:8225232001 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:263192599200 data:0x379d580010000000
kworker/0:4-179 [000] … 237.917671: rtcpu_vinotify_event: tstamp:8225232159 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:263192605632 data:0x0000000031000001
kworker/0:4-179 [000] … 237.917671: rtcpu_vinotify_event: tstamp:8225232311 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:263192666272 data:0x379d550010000000
kworker/0:4-179 [000] … 237.917671: rtcpu_vinotify_event: tstamp:8225232447 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:263192672800 data:0x0000000031000002
kworker/0:4-179 [000] … 238.309656: rtcpu_vinotify_event: tstamp:8237710995 cch:0 vi:0 tag:FS channel:0x00 frame:0 vi_tstamp:263598495552 data:0x0000000000000014
kworker/0:4-179 [000] … 238.309657: rtcpu_vinotify_event: tstamp:8237711132 cch:0 vi:0 tag:ATOMP_FS channel:0x00 frame:0 vi_tstamp:263598495648 data:0x0000000800000000
kworker/0:4-179 [000] … 238.309657: rtcpu_vinotify_event: tstamp:8237711283 cch:0 vi:0 tag:CHANSEL_PXL_SOF channel:0x23 frame:0 vi_tstamp:263598512320 data:0x0000000000000001
kworker/0:4-179 [000] … 238.309657: rtcpu_vinotify_event: tstamp:8237711412 cch:0 vi:0 tag:VIFALC_ACTIONLST channel:0x23 frame:0 vi_tstamp:263598539200 data:0x0000000008020001
kworker/0:4-179 [000] … 238.309657: rtcpu_vinotify_event: tstamp:8237711560 cch:0 vi:0 tag:CHANSEL_FAULT channel:0x23 frame:0 vi_tstamp:263598518336 data:0x0000000000000200
kworker/0:4-179 [000] … 238.309658: rtcpu_vinotify_event: tstamp:8237711687 cch:0 vi:0 tag:VIFALC_ACTIONLST channel:0x23 frame:0 vi_tstamp:263598617088 data:0x0000000001020001
kworker/0:4-179 [000] … 238.309658: rtcpu_vinotify_event: tstamp:8238446782 cch:0 vi:0 tag:FE channel:0x00 frame:0 vi_tstamp:263628085312 data:0x0000000000000024
kworker/0:4-179 [000] … 238.309658: rtcpu_vinotify_event: tstamp:8238446914 cch:0 vi:0 tag:CHANSEL_SHORT_FRAME channel:0x10 frame:0 vi_tstamp:263628085344 data:0x06ef200001000000
kworker/0:4-179 [000] … 238.309658: rtcpu_vinotify_event: tstamp:8238447066 cch:0 vi:0 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:263628085440 data:0x0000000800000000
kworker/0:4-179 [000] … 238.309658: rtcpu_vinotify_event: tstamp:8238447197 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:263628241024 data:0x379d580010000000
kworker/0:4-179 [000] … 238.309658: rtcpu_vinotify_event: tstamp:8238447346 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:263628284384 data:0x0000000031000003
kworker/0:4-179 [000] … 238.309659: rtcpu_vinotify_event: tstamp:8238447474 cch:0 vi:0 tag:FS channel:0x00 frame:0 vi_tstamp:263630180192 data:0x0000000000000014
kworker/0:4-179 [000] … 238.365666: rtcpu_vinotify_event: tstamp:8238958963 cch:0 vi:0 tag:ATOMP_FS channel:0x00 frame:0 vi_tstamp:263630180288 data:0x0000000800000000
kworker/0:4-179 [000] … 238.365667: rtcpu_vinotify_event: tstamp:8238959099 cch:0 vi:0 tag:CHANSEL_PXL_SOF channel:0x23 frame:0 vi_tstamp:263630428736 data:0x0000000000000001
kworker/0:4-179 [000] … 238.365668: rtcpu_vinotify_event: tstamp:8238959249 cch:0 vi:0 tag:VIFALC_ACTIONLST channel:0x23 frame:0 vi_tstamp:263630439616 data:0x0000000008020002
kworker/0:4-179 [000] … 238.365668: rtcpu_vinotify_event: tstamp:8238959379 cch:0 vi:0 tag:CHANSEL_FAULT channel:0x23 frame:0 vi_tstamp:263630434688 data:0x0000000000000200
kworker/0:4-179 [000] … 238.365668: rtcpu_vinotify_event: tstamp:8238959528 cch:0 vi:0 tag:VIFALC_ACTIONLST channel:0x23 frame:0 vi_tstamp:263630519744 data:0x0000000001020002
kworker/0:4-179 [000] … 238.365669: rtcpu_vinotify_event: tstamp:8239501248 cch:0 vi:0 tag:CHANSEL_FAULT channel:0x23 frame:0 vi_tstamp:263661417888 data:0x0000000007430202
kworker/0:4-179 [000] … 238.365669: rtcpu_vinotify_event: tstamp:8239501401 cch:0 vi:0 tag:FE channel:0x00 frame:0 vi_tstamp:263661418464 data:0x0000000000000024
kworker/0:4-179 [000] … 238.365670: rtcpu_vinotify_event: tstamp:8239501537 cch:0 vi:0 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:263661418560 data:0x0000000800000000
kworker/0:4-179 [000] … 238.365670: rtcpu_vinotify_event: tstamp:8239501690 cch:0 vi:0 tag:ATOMP_FRAME_DONE channel:0x23 frame:0 vi_tstamp:263661418784 data:0x0000000000000000
kworker/0:4-179 [000] … 238.365670: rtcpu_vinotify_event: tstamp:8239501818 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:263661583872 data:0x379d550010000000
kworker/0:4-179 [000] … 238.365671: rtcpu_vinotify_event: tstamp:8239501966 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:263661627232 data:0x0000000031000004
kworker/0:4-179 [000] … 238.365671: rtcpu_vinotify_event: tstamp:8239502093 cch:0 vi:0 tag:FS channel:0x00 frame:0 vi_tstamp:263663513344 data:0x0000000000000014
kworker/0:4-179 [000] … 238.365671: rtcpu_vinotify_event: tstamp:8239502242 cch:0 vi:0 tag:ATOMP_FS channel:0x00 frame:0 vi_tstamp:263663513440 data:0x0000000800000000
kworker/0:4-179 [000] … 238.365672: rtcpu_vinotify_event: tstamp:8239502369 cch:0 vi:0 tag:CHANSEL_PXL_SOF channel:0x23 frame:0 vi_tstamp:263663761856 data:0x0000000000000001
kworker/0:4-179 [000] … 238.365672: rtcpu_vinotify_event: tstamp:8239502517 cch:0 vi:0 tag:VIFALC_ACTIONLST channel:0x23 frame:0 vi_tstamp:263663772704 data:0x0000000008020003
kworker/0:4-179 [000] … 238.365673: rtcpu_vinotify_event: tstamp:8239502644 cch:0 vi:0 tag:CHANSEL_FAULT channel:0x23 frame:0 vi_tstamp:263663767840 data:0x0000000000000200
kworker/0:4-179 [000] … 238.365673: rtcpu_vinotify_event: tstamp:8239989963 cch:0 vi:0 tag:VIFALC_ACTIONLST channel:0x23 frame:0 vi_tstamp:263663861024 data:0x0000000001020003
kworker/0:4-179 [000] … 238.421660: rtcpu_vinotify_event: tstamp:8240531889 cch:0 vi:0 tag:CHANSEL_FAULT channel:0x23 frame:0 vi_tstamp:263694750912 data:0x0000000007430202
kworker/0:4-179 [000] … 238.421661: rtcpu_vinotify_event: tstamp:8240532044 cch:0 vi:0 tag:FE channel:0x00 frame:0 vi_tstamp:263694751456 data:0x0000000000000024
kworker/0:4-179 [000] … 238.421661: rtcpu_vinotify_event: tstamp:8240532177 cch:0 vi:0 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:263694751552 data:0x0000000800000000
kworker/0:4-179 [000] … 238.421661: rtcpu_vinotify_event: tstamp:8240532328 cch:0 vi:0 tag:ATOMP_FRAME_DONE channel:0x23 frame:0 vi_tstamp:263694751744 data:0x0000000000000000
kworker/0:4-179 [000] … 238.421662: rtcpu_vinotify_event: tstamp:8240532457 cch:0 vi:0 tag:FS channel:0x00 frame:0 vi_tstamp:263696846464 data:0x0000000000000014
Could you help have a look and give us some debug direction?
Thanks!