Hi, Guys,
I’m blocked by the issue of “CHANSEL_NOMATCH”, and couldn’t capture image from mipi csi port on Xavier with the below trace log.
I’m confuse of the value of “0x10” for “channel:”, is it means “virtual channel”? but i’m set vc as 0 only.
And i’m also don’t understand the means of value “0x00000489” for “data:”, I guess the value should be read from someone VI status register, but I chouldn’t found it from the TRM, can you help that?
Can you give any advice to debug it? Thank you in advance!
kworker/0:0-14093 [000] … 10777.694660: rtcpu_vinotify_event: tstamp:337161010390 tag:FS channel:0x00 frame:0 vi_tstamp:337160489545 data:0x00000014
kworker/0:0-14093 [000] … 10777.694660: rtcpu_vinotify_event: tstamp:337161010564 tag:CHANSEL_NOMATCH channel:0x10 frame:0 vi_tstamp:337160490507 data:0x00000489
kworker/0:0-14093 [000] … 10777.694661: rtcpu_vinotify_event: tstamp:337161553197 tag:FE channel:0x00 frame:0 vi_tstamp:337161500444 data:0x00000024
kworker/0:0-14093 [000] … 10777.694661: rtcpu_vinotify_error: tstamp:337161582690 tag:CHANSEL_NOMATCH channel:0x10 frame:0 vi_tstamp:337161579871 data:0x00000489
kworker/0:0-14093 [000] … 10777.694662: rtos_queue_peek_from_isr_failed: tstamp:337161896207 queue:0x0bcbcf78
kworker/0:0-14093 [000] … 10777.694663: rtcpu_vinotify_event: tstamp:337162096133 tag:FS channel:0x00 frame:0 vi_tstamp:337161578910 data:0x00000014
kworker/0:0-14093 [000] … 10777.694664: rtcpu_vinotify_event: tstamp:337162096281 tag:CHANSEL_NOMATCH channel:0x10 frame:0 vi_tstamp:337161579871 data:0x00000489
kworker/0:0-14093 [000] … 10777.750662: rtcpu_vinotify_event: tstamp:337162638147 tag:FE channel:0x00 frame:0 vi_tstamp:337162589808 data:0x00000024
kworker/0:0-14093 [000] … 10777.750662: rtcpu_vinotify_error: tstamp:337162672058 tag:CHANSEL_NOMATCH channel:0x10 frame:0 vi_tstamp:337162669235 data:0x00000489
kworker/0:0-14093 [000] … 10777.750663: rtcpu_vinotify_event: tstamp:337163181081 tag:FS channel:0x00 frame:0 vi_tstamp:337162668274 data:0x00000014
kworker/0:0-14093 [000] … 10777.750663: rtcpu_vinotify_event: tstamp:337163181252 tag:CHANSEL_NOMATCH channel:0x10 frame:0 vi_tstamp:337162669235 data:0x00000489
kworker/0:0-14093 [000] … 10777.750663: rtcpu_vinotify_event: tstamp:337163723090 tag:FE channel:0x00 frame:0 vi_tstamp:337163679173 data:0x00000024
kworker/0:0-14093 [000] … 10777.750663: rtcpu_vinotify_error: tstamp:337163761562 tag:CHANSEL_NOMATCH channel:0x10 frame:0 vi_tstamp:337163758600 data:0x00000489
kworker/0:0-14093 [000] … 10777.750664: rtcpu_vinotify_event: tstamp:337163761960 tag:FS channel:0x00 frame:0 vi_tstamp:337163757639 data:0x00000014
kworker/0:0-14093 [000] … 10777.750664: rtcpu_vinotify_event: tstamp:337163762108 tag:CHANSEL_NOMATCH channel:0x10 frame:0 vi_tstamp:337163758600 data:0x00000489
kworker/0:0-14093 [000] … 10777.806661: rtcpu_vinotify_event: tstamp:337164808332 tag:FE channel:0x00 frame:0 vi_tstamp:337164768536 data:0x00000024
kworker/0:0-14093 [000] … 10777.806662: rtcpu_vinotify_error: tstamp:337164850786 tag:CHANSEL_NOMATCH channel:0x10 frame:0 vi_tstamp:337164847964 data:0x00000489
kworker/0:0-14093 [000] … 10777.806662: rtcpu_vinotify_event: tstamp:337165351208 tag:FS channel:0x00 frame:0 vi_tstamp:337164847002 data:0x00000014
kworker/0:0-14093 [000] … 10777.806662: rtcpu_vinotify_event: tstamp:337165351382 tag:CHANSEL_NOMATCH channel:0x10 frame:0 vi_tstamp:337164847964 data:0x00000489
kworker/0:0-14093 [000] … 10777.806663: rtcpu_vinotify_event: tstamp:337165893218 tag:FE channel:0x00 frame:0 vi_tstamp:337165857902 data:0x00000024
kworker/0:0-14093 [000] … 10777.806663: rtcpu_vinotify_error: tstamp:337165940150 tag:CHANSEL_NOMATCH channel:0x10 frame:0 vi_tstamp:337165937329 data:0x00000489
kworker/0:0-14093 [000] … 10777.862671: rtcpu_vinotify_event: tstamp:337166436154 tag:FS channel:0x00 frame:0 vi_tstamp:337165936367 data:0x00000014
kworker/0:0-14093 [000] … 10777.862671: rtcpu_vinotify_event: tstamp:337166436304 tag:CHANSEL_NOMATCH channel:0x10 frame:0 vi_tstamp:337165937329 data:0x00000489
kworker/0:0-14093 [000] … 10777.862673: rtos_queue_peek_from_isr_failed: tstamp:337166896208 queue:0x0bcbcf78
kworker/0:0-14093 [000] … 10777.862674: rtcpu_vinotify_event: tstamp:337166978961 tag:FE channel:0x00 frame:0 vi_tstamp:337166947266 data:0x00000024
kworker/0:0-14093 [000] … 10777.862674: rtcpu_vinotify_error: tstamp:337167029512 tag:CHANSEL_NOMATCH channel:0x10 frame:0 vi_tstamp:337167026693 data:0x00000489
kworker/0:0-14093 [000] … 10777.862675: rtcpu_vinotify_event: tstamp:337167521093 tag:FS channel:0x00 frame:0 vi_tstamp:337167025732 data:0x00000014
kworker/0:0-14093 [000] … 10777.862675: rtcpu_vinotify_event: tstamp:337167521264 tag:CHANSEL_NOMATCH channel:0x10 frame:0 vi_tstamp:337167026693 data:0x00000489
kworker/0:0-14093 [000] … 10777.918662: rtcpu_vinotify_event: tstamp:337168063909 tag:FE channel:0x00 frame:0 vi_tstamp:337168036630 data:0x00000024
kworker/0:0-14093 [000] … 10777.918663: rtcpu_vinotify_error: tstamp:337168118878 tag:CHANSEL_NOMATCH channel:0x10 frame:0 vi_tstamp:337168116058 data:0x00000489
kworker/0:0-14093 [000] … 10777.918663: rtcpu_vinotify_event: tstamp:337168606042 tag:FS channel:0x00 frame:0 vi_tstamp:337168115096 data:0x00000014
kworker/0:0-14093 [000] … 10777.918664: rtcpu_vinotify_event: tstamp:337168606190 tag:CHANSEL_NOMATCH channel:0x10 frame:0 vi_tstamp:337168116058 data:0x00000489
kworker/0:0-14093 [000] … 10777.918664: rtcpu_vinotify_event: tstamp:337169148851 tag:FE channel:0x00 frame:0 vi_tstamp:337169125995 data:0x00000024
kworker/0:0-14093 [000] … 10777.918664: rtcpu_vinotify_error: tstamp:337169208240 tag:CHANSEL_NOMATCH channel:0x10 frame:0 vi_tstamp:337169205422 data:0x00000489
kworker/0:0-14093 [000] … 10777.974664: rtcpu_vinotify_event: tstamp:337169690990 tag:FS channel:0x00 frame:0 vi_tstamp:337169204461 data:0x00000014
kworker/0:0-14093 [000] … 10777.974665: rtcpu_vinotify_event: tstamp:337169691168 tag:CHANSEL_NOMATCH channel:0x10 frame:0 vi_tstamp:337169205422 data:0x00000489
kworker/0:0-14093 [000] … 10777.974665: rtcpu_vinotify_event: tstamp:337170217807 tag:FE channel:0x00 frame:0 vi_tstamp:337170215359 data:0x00000024
kworker/0:0-14093 [000] … 10777.974666: rtcpu_vinotify_error: tstamp:337170297615 tag:CHANSEL_NOMATCH channel:0x10 frame:0 vi_tstamp:337170294787 data:0x00000489
kworker/0:0-14093 [000] … 10777.974666: rtcpu_vinotify_event: tstamp:337170721946 tag:FS channel:0x00 frame:0 vi_tstamp:337170293825 data:0x00000014
kworker/0:0-14093 [000] … 10777.974666: rtcpu_vinotify_event: tstamp:337170722091 tag:CHANSEL_NOMATCH channel:0x10 frame:0 vi_tstamp:337170294787 data:0x00000489
kworker/0:0-14093 [000] … 10778.030665: rtcpu_vinotify_error: tstamp:337171386968 tag:CHANSEL_NOMATCH channel:0x10 frame:0 vi_tstamp:337171384151 data:0x00000489
kworker/0:0-14093 [000] … 10778.030668: rtcpu_vinotify_event: tstamp:337171806893 tag:FE channel:0x00 frame:0 vi_tstamp:337171304724 data:0x00000024
kworker/0:0-14093 [000] … 10778.030669: rtcpu_vinotify_event: tstamp:337171807041 tag:FS channel:0x00 frame:0 vi_tstamp:337171383190 data:0x00000014
kworker/0:0-14093 [000] … 10778.030669: rtcpu_vinotify_event: tstamp:337171807213 tag:CHANSEL_NOMATCH channel:0x10 frame:0 vi_tstamp:337171384151 data:0x00000489
kworker/0:0-14093 [000] … 10778.030672: rtos_queue_peek_from_isr_failed: tstamp:337171896204 queue:0x0bcbcf78
kworker/0:0-14093 [000] … 10778.030676: rtcpu_vinotify_error: tstamp:337172476335 tag:CHANSEL_NOMATCH channel:0x10 frame:0 vi_tstamp:337172473516 data:0x00000489
kworker/0:0-14093 [000] … 10778.030676: rtcpu_vinotify_event: tstamp:337172892641 tag:FE channel:0x00 frame:0 vi_tstamp:337172394088 data:0x00000024
kworker/0:0-14093 [000] … 10778.030676: rtcpu_vinotify_event: tstamp:337172892814 tag:FS channel:0x00 frame:0 vi_tstamp:337172472554 data:0x00000014
kworker/0:0-14093 [000] … 10778.030676: rtcpu_vinotify_event: tstamp:337172892964 tag:CHANSEL_NOMATCH channel:0x10 frame:0 vi_tstamp:337172473516 data:0x00000489
kworker/0:0-14093 [000] … 10778.086676: rtcpu_vinotify_error: tstamp:337173565713 tag:CHANSEL_NOMATCH channel:0x10 frame:0 vi_tstamp:337173562886 data:0x00000489
kworker/0:0-14093 [000] … 10778.086676: rtcpu_vinotify_event: tstamp:337173977593 tag:FE channel:0x00 frame:0 vi_tstamp:337173483453 data:0x00000024
kworker/0:0-14093 [000] … 10778.086677: rtcpu_vinotify_event: tstamp:337173977742 tag:FS channel:0x00 frame:0 vi_tstamp:337173561919 data:0x00000014
kworker/0:0-14093 [000] … 10778.086677: rtcpu_vinotify_event: tstamp:337173977916 tag:CHANSEL_NOMATCH channel:0x10 frame:0 vi_tstamp:337173562886 data:0x00000489
At the same time, the syslog as below:
[10478.670682] tegra194-vi5 15c10000.vi: no reply from camera processor
[10478.670848] tegra194-vi5 15c10000.vi: uncorr_err: request timed out after 2500 ms
[10478.670994] tegra194-vi5 15c10000.vi: err_rec: attempting to reset the capture channel
[10478.673875] tegra194-vi5 15c10000.vi: err_rec: successfully reset the capture channel
[10478.740271] tegra194-vi5 15c10000.vi: corr_err: discarding frame 0, flags: 128, err_data 131072
[10481.486682] tegra194-vi5 15c10000.vi: no reply from camera processor
[10481.486903] tegra194-vi5 15c10000.vi: uncorr_err: request timed out after 2500 ms
[10481.487043] tegra194-vi5 15c10000.vi: err_rec: attempting to reset the capture channel
[10481.490522] tegra194-vi5 15c10000.vi: err_rec: successfully reset the capture channel
[10481.529039] tegra194-vi5 15c10000.vi: corr_err: discarding frame 0, flags: 128, err_data 131072
[10484.046684] tegra194-vi5 15c10000.vi: no reply from camera processor
[10484.046849] tegra194-vi5 15c10000.vi: uncorr_err: request timed out after 2500 ms
[10484.046985] tegra194-vi5 15c10000.vi: err_rec: attempting to reset the capture channel
[10484.050687] tegra194-vi5 15c10000.vi: err_rec: successfully reset the capture channel
[10484.108686] tegra194-vi5 15c10000.vi: corr_err: discarding frame 0, flags: 128, err_data 131072
[10486.862675] tegra194-vi5 15c10000.vi: no reply from camera processor
[10486.862836] tegra194-vi5 15c10000.vi: uncorr_err: request timed out after 2500 ms
[10486.862970] tegra194-vi5 15c10000.vi: err_rec: attempting to reset the capture channel
[10486.864835] tegra194-vi5 15c10000.vi: err_rec: successfully reset the capture channel
[10486.932342] tegra194-vi5 15c10000.vi: corr_err: discarding frame 0, flags: 128, err_data 131072
[10489.678686] tegra194-vi5 15c10000.vi: no reply from camera processor
[10489.678853] tegra194-vi5 15c10000.vi: uncorr_err: request timed out after 2500 ms
[10489.678987] tegra194-vi5 15c10000.vi: err_rec: attempting to reset the capture channel
[10489.681875] tegra194-vi5 15c10000.vi: err_rec: successfully reset the capture channel
[10489.721092] tegra194-vi5 15c10000.vi: corr_err: discarding frame 0, flags: 128, err_data 131072
[10492.238694] tegra194-vi5 15c10000.vi: no reply from camera processor
[10492.238862] tegra194-vi5 15c10000.vi: uncorr_err: request timed out after 2500 ms
[10492.238996] tegra194-vi5 15c10000.vi: err_rec: attempting to reset the capture channel
[10492.242500] tegra194-vi5 15c10000.vi: err_rec: successfully reset the capture channel
[10492.300676] tegra194-vi5 15c10000.vi: corr_err: discarding frame 0, flags: 128, err_data 131072