trace log: kworker/10:2-1718117 [010] .... 17772.824713: rtcpu_vinotify_event: tstamp:556118811059 cch:4 vi:0 tag:FE channel:0x01 frame:0 vi_tstamp:17795795202112 data:0x0000000000000024 kworker/10:2-1718117 [010] .... 17772.824714: rtcpu_vinotify_event: tstamp:556118811217 cch:4 vi:0 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:17795795202144 data:0x0000000080000000 kworker/10:2-1718117 [010] .... 17772.824714: rtcpu_vinotify_event: tstamp:556118811352 cch:4 vi:0 tag:VIFALC_ACTIONLST channel:0x1f frame:0 vi_tstamp:17795795206880 data:0x0000000000022412 kworker/10:2-1718117 [010] .... 17772.824715: rtcpu_vinotify_event: tstamp:556118811500 cch:0 vi:0 tag:FS channel:0x01 frame:0 vi_tstamp:17795796317472 data:0x0000000000000010 kworker/10:2-1718117 [010] .... 17772.824715: rtcpu_vinotify_event: tstamp:556118811633 cch:0 vi:0 tag:ATOMP_FS channel:0x00 frame:0 vi_tstamp:17795796317504 data:0x0000000800000000 kworker/10:2-1718117 [010] .... 17772.824715: rtcpu_vinotify_event: tstamp:556118811784 cch:0 vi:0 tag:CHANSEL_PXL_SOF channel:0x23 frame:0 vi_tstamp:17795796348064 data:0x0000000000000001 kworker/10:2-1718117 [010] .... 17772.824715: rtcpu_vinotify_event: tstamp:556118811915 cch:0 vi:0 tag:VIFALC_ACTIONLST channel:0x23 frame:0 vi_tstamp:17795796349600 data:0x00000000080214ee kworker/10:2-1718117 [010] .... 17772.824716: rtcpu_vinotify_event: tstamp:556118812064 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:17795796414624 data:0x399d580010000000 kworker/10:2-1718117 [010] .... 17772.824716: rtcpu_vinotify_event: tstamp:556118812194 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:17795796421568 data:0x00000000310014ef kworker/10:2-1718117 [010] .... 17772.824716: rtcpu_vinotify_event: tstamp:556118812344 cch:8 vi:0 tag:FE channel:0x00 frame:0 vi_tstamp:17795798157888 data:0x0000000000000024 kworker/10:2-1718117 [010] .... 17772.824716: rtcpu_vinotify_event: tstamp:556118812479 cch:8 vi:0 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:17795798157920 data:0x0000000040000000 kworker/10:2-1718117 [010] .... 17772.824717: rtcpu_vinotify_event: tstamp:556118812628 cch:8 vi:0 tag:VIFALC_ACTIONLST channel:0x1e frame:0 vi_tstamp:17795798162624 data:0x0000000000022412 kworker/10:2-1718117 [010] .... 17772.824717: rtcpu_vinotify_event: tstamp:556118812760 cch:4 vi:0 tag:FS channel:0x01 frame:0 vi_tstamp:17795798973536 data:0x0000000000000014 kworker/10:2-1718117 [010] .... 17772.824717: rtcpu_vinotify_event: tstamp:556118812909 cch:4 vi:0 tag:ATOMP_FS channel:0x00 frame:0 vi_tstamp:17795798973536 data:0x0000000080000000 kworker/10:2-1718117 [010] .... 17772.824717: rtcpu_vinotify_event: tstamp:556118813040 cch:8 vi:0 tag:FS channel:0x00 frame:0 vi_tstamp:17795801929312 data:0x0000000000000014 kworker/10:2-1718117 [010] .... 17772.824717: rtcpu_vinotify_event: tstamp:556118862008 cch:9 vi:1 tag:VIFALC_ACTIONLST channel:0x20 frame:0 vi_tstamp:17795793792320 data:0x0000000008021a74 kworker/10:2-1718117 [010] .... 17772.824717: rtcpu_vinotify_event: tstamp:556118862140 cch:9 vi:1 tag:VIFALC_TDSTATE channel:0x20 frame:0 vi_tstamp:17795793865312 data:0x399e1e0010000000 kworker/10:2-1718117 [010] .... 17772.824717: rtcpu_vinotify_event: tstamp:556118862296 cch:9 vi:1 tag:VIFALC_TDSTATE channel:0x20 frame:0 vi_tstamp:17795793872224 data:0x0000000031001a75 kworker/10:2-1718117 [010] .... 17772.824717: rtcpu_vinotify_event: tstamp:556118862427 cch:10 vi:1 tag:CHANSEL_PXL_SOF channel:0x1f frame:0 vi_tstamp:17795795664704 data:0x0000000000000001 kworker/10:2-1718117 [010] .... 17772.824718: rtcpu_vinotify_event: tstamp:556118862575 cch:10 vi:1 tag:VIFALC_ACTIONLST channel:0x1f frame:0 vi_tstamp:17795795666240 data:0x0000000008022412 kworker/10:2-1718117 [010] .... 17772.824718: rtcpu_vinotify_event: tstamp:556118862703 cch:10 vi:1 tag:VIFALC_TDSTATE channel:0x1f frame:0 vi_tstamp:17795795732736 data:0x399e180010000000 kworker/10:2-1718117 [010] .... 17772.824718: rtcpu_vinotify_event: tstamp:556118862851 cch:10 vi:1 tag:VIFALC_TDSTATE channel:0x1f frame:0 vi_tstamp:17795795739584 data:0x0000000031002413 kworker/10:2-1718117 [010] .... 17772.824718: rtcpu_vinotify_event: tstamp:556119044595 cch:8 vi:0 tag:ATOMP_FS channel:0x00 frame:0 vi_tstamp:17795801929344 data:0x0000000040000000 kworker/10:2-1718117 [010] .... 17772.824718: rtcpu_vinotify_event: tstamp:556119044731 cch:3 vi:0 tag:CHANSEL_PXL_EOF channel:0x20 frame:0 vi_tstamp:17795802167200 data:0x0000000002cf0002 kworker/10:2-1718117 [010] .... 17772.824718: rtcpu_vinotify_event: tstamp:556119044884 cch:3 vi:0 tag:ATOMP_FRAME_DONE channel:0x20 frame:0 vi_tstamp:17795802167776 data:0x0000000000000000 kworker/10:2-1718117 [010] .... 17772.824718: rtcpu_vinotify_event: tstamp:556119045015 cch:3 vi:0 tag:VIFALC_ACTIONLST channel:0x20 frame:0 vi_tstamp:17795802170688 data:0x00000000020214ea kworker/10:2-1718117 [010] .... 17772.824719: rtcpu_vinotify_event: tstamp:556119045163 cch:3 vi:0 tag:FE channel:0x01 frame:0 vi_tstamp:17795802167840 data:0x0000000000000021 dmesg: [12812.560565] cpufreq: cpu0,cur:2082000,set:2201600,set ndiv:172 [12823.665872] cpufreq: cpu0,cur:1817000,set:2201600,set ndiv:172 [12864.683076] cpufreq: cpu4,cur:1214000,set:2201600,set ndiv:172 [12883.265251] cpufreq: cpu0,cur:1517000,set:2201600,set ndiv:172 [12892.830343] tegra-camrtc-capture-vi tegra-capture-vi: corr_err: discarding frame 0, flags: 0, err_data 131072 [12892.840751] tegra-camrtc-capture-vi tegra-capture-vi: corr_err: discarding frame 0, flags: 0, err_data 512 [12924.207152] cpufreq: cpu0,cur:1324000,set:2201600,set ndiv:172 [12935.300730] cpufreq: cpu0,cur:1172000,set:2201600,set ndiv:172 [12939.078777] cpufreq: cpu0,cur:1603000,set:2201600,set ndiv:172 [12954.081793] cpufreq: cpu4,cur:1200000,set:2201600,set ndiv:172 [13002.466002] cpufreq: cpu0,cur:1100000,set:2201600,set ndiv:172 [13018.098042] tegra-camrtc-capture-vi tegra-capture-vi: corr_err: discarding frame 0, flags: 0, err_data 131072 [13018.132022] tegra-camrtc-capture-vi tegra-capture-vi: corr_err: discarding frame 0, flags: 0, err_data 131072 [13028.681068] cpufreq: cpu4,cur:1099000,set:2201600,set ndiv:172 [13076.869002] cpufreq: cpu4,cur:2072000,set:2201600,set ndiv:172 [13106.586229] cpufreq: cpu0,cur:1374000,set:2201600,set ndiv:172 [13118.765051] tegra-camrtc-capture-vi tegra-capture-vi: corr_err: discarding frame 0, flags: 0, err_data 131072 [13118.778359] tegra-camrtc-capture-vi tegra-capture-vi: corr_err: discarding frame 0, flags: 0, err_data 131072 [13118.822974] tegra-camrtc-capture-vi tegra-capture-vi: uncorr_err: flags 2, err_data 0 [13118.834272] tegra-camrtc-capture-vi tegra-capture-vi: corr_err: discarding frame 0, flags: 0, err_data 131072 [13118.840724] [RCE] ERROR: camera-ip/vi5/vi5.c:745 [vi5_handle_eof] "General error queue is out of sync with frame queue. ts=13141790612896 sof_ts=13141806110528 gerror_code=2 gerror_data=a3 notify_bits=0" [13118.876003] tegra-camrtc-capture-vi tegra-capture-vi: corr_err: discarding frame 0, flags: 0, err_data 131072 [13118.921967] tegra-camrtc-capture-vi tegra-capture-vi: uncorr_err: flags 2, err_data 0 [13118.952924] [RCE] ERROR: camera-ip/vi5/vi5.c:745 [vi5_handle_eof] "General error queue is out of sync with frame queue. ts=13141859839648 sof_ts=13141904819360 gerror_code=2 gerror_data=a3 notify_bits=0" [13119.649372] tegra-camrtc-capture-vi tegra-capture-vi: corr_err: discarding frame 0, flags: 0, err_data 131072 [13119.691103] tegra-camrtc-capture-vi tegra-capture-vi: corr_err: discarding frame 0, flags: 0, err_data 131072 [13119.736776] [RCE] ERROR: camera-ip/vi5/vi5.c:745 [vi5_handle_eof] "General error queue is out of sync with frame queue. ts=13142674941152 sof_ts=13142719920896 gerror_code=2 gerror_data=a2 notify_bits=0" [13119.736966] tegra-camrtc-capture-vi tegra-capture-vi: uncorr_err: flags 2, err_data 0 [13121.556692] tegra-camrtc-capture-vi tegra-capture-vi: uncorr_err: request timed out after 2500 ms [13121.565897] tegra-camrtc-capture-vi tegra-capture-vi: uncorr_err: request timed out after 2500 ms [13121.579776] tegra-camrtc-capture-vi tegra-capture-vi: err_rec: attempting to reset the capture channel [13121.589004] tegra-camrtc-capture-vi tegra-capture-vi: err_rec: attempting to reset the capture channel [13121.593477] (NULL device *): vi_capture_control_message: NULL VI channel received [13121.608520] t194-nvcsi 13e40000.host1x:nvcsi@15a00000: csi5_stream_close: Error in closing stream_id=3, csi_port=3 [13121.619306] (NULL device *): vi_capture_control_message: NULL VI channel received [13121.621714] (NULL device *): vi_capture_control_message: NULL VI channel received [13121.627032] t194-nvcsi 13e40000.host1x:nvcsi@15a00000: csi5_stream_open: VI channel not found for stream- 3 vc- 0 [13121.634726] t194-nvcsi 13e40000.host1x:nvcsi@15a00000: csi5_stream_close: Error in closing stream_id=3, csi_port=3 [13121.645570] tegra-camrtc-capture-vi tegra-capture-vi: err_rec: successfully reset the capture channel [13121.656117] (NULL device *): vi_capture_control_message: NULL VI channel received [13121.673280] t194-nvcsi 13e40000.host1x:nvcsi@15a00000: csi5_stream_open: VI channel not found for stream- 3 vc- 1 [13121.684268] tegra-camrtc-capture-vi tegra-capture-vi: err_rec: successfully reset the capture channel [13122.328692] tegra-camrtc-capture-vi tegra-capture-vi: uncorr_err: request timed out after 2500 ms [13122.337964] tegra-camrtc-capture-vi tegra-capture-vi: err_rec: attempting to reset the capture channel