Orin camera v4l2

we use v4l2 utils test camera after power on ,but sometime these no video data ,the dmesg is t194-nvcsi 13e40000.host1x:nvcsi@15a00000: csi5_stream_close: Error in closing stream_id=0, csi_port=0
[23046.611112] (NULL device *): vi_capture_control_message: NULL VI channel received
[23046.611321] t194-nvcsi 13e40000.host1x:nvcsi@15a00000: csi5_stream_open: VI channel not found for stream- 0 vc- 3
[23046.611850] tegra-camrtc-capture-vi tegra-capture-vi: err_rec: successfully reset the capture channel
[23049.169320] tegra-camrtc-capture-vi tegra-capture-vi: uncorr_err: request timed out after 2500 ms
[23049.169615] tegra-camrtc-capture-vi tegra-capture-vi: err_rec: attempting to reset the capture channel
[23049.170613] (NULL device *): vi_capture_control_message: NULL VI channel received
[23049.170833] t194-nvcsi 13e40000.host1x:nvcsi@15a00000: csi5_stream_close: Error in closing stream_id=0, csi_port=0
[23049.171129] (NULL device *): vi_capture_control_message: NULL VI channel received
[23049.171337] t194-nvcsi 13e40000.host1x:nvcsi@15a00000: csi5_stream_open: VI channel not found for stream- 0 vc- 3
[23049.171858] tegra-camrtc-capture-vi tegra-capture-vi: err_rec: successfully reset the capture channel
[23051.729278] tegra-camrtc-capture-vi tegra-capture-vi: uncorr_err: request timed out after 2500 ms
[23051.729547] tegra-camrtc-capture-vi tegra-capture-vi: err_rec: attempting to reset the capture channel
[23051.730588] (NULL device *): vi_capture_control_message: NULL VI channel received
[23051.730788] t194-nvcsi 13e40000.host1x:nvcsi@15a00000: csi5_stream_close: Error in closing stream_id=0, csi_port=0
[23051.731073] (NULL device *): vi_capture_control_message: NULL VI channel received
[23051.731278] t194-nvcsi 13e40000.host1x:nvcsi@15a00000: csi5_stream_open: VI channel not found for stream- 0 vc- 3
[23051.731752] tegra-camrtc-capture-vi tegra-capture-vi: err_rec: successfully reset the capture channel
[23054.289429] tegra-camrtc-capture-vi tegra-capture-vi: uncorr_err: request timed out after 2500 ms
[23054.289719] tegra-camrtc-capture-vi tegra-capture-vi: err_rec: attempting to reset the capture channel
[23054.290665] (NULL device *): vi_capture_control_message: NULL VI channel received
[23054.290881] t194-nvcsi 13e40000.host1x:nvcsi@15a00000: csi5_stream_close: Error in closing stream_id=0, csi_port=0
[23054.291173] (NULL device *): vi_capture_control_message: NULL VI channel received
[23054.291376] t194-nvcsi 13e40000.host1x:nvcsi@15a00000: csi5_stream_open: VI channel not found for stream- 0 vc- 3
[23054.292062] tegra-camrtc-capture-vi tegra-capture-vi: err_rec: successfully reset the capture channel
;the trace log is below :
vi-output, ht_i-3661 [000] … 23077.331788: tegra_channel_capture_setup: vnc_id 0 W 1920 H 1080 fmt 13
kworker/8:1-322616 [008] … 23077.336984: rtcpu_vinotify_event: tstamp:721935415914 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:23101931868704 data:0x399d580010000000
kworker/8:1-322616 [008] … 23077.336987: rtcpu_vinotify_event: tstamp:721935416050 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:23101931911360 data:0x0000000031000001
kworker/8:1-322616 [008] … 23077.336987: rtcpu_vinotify_event: tstamp:721935416203 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:23101931928928 data:0x399d550010000000
kworker/8:1-322616 [008] … 23077.336988: rtcpu_vinotify_event: tstamp:721935416337 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:23101931989280 data:0x0000000031000002
vi-output, ht_i-3661 [000] … 23079.891712: tegra_channel_capture_setup: vnc_id 0 W 1920 H 1080 fmt 13
kworker/8:1-322616 [008] … 23079.916952: rtcpu_vinotify_event: tstamp:722015711630 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:23104491757088 data:0x399d580010000000
kworker/8:1-322616 [008] … 23079.916953: rtcpu_vinotify_event: tstamp:722015711769 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:23104491799744 data:0x0000000031000001
kworker/8:1-322616 [008] … 23079.916954: rtcpu_vinotify_event: tstamp:722015711923 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:23104491817248 data:0x399d550010000000
kworker/8:1-322616 [008] … 23079.916954: rtcpu_vinotify_event: tstamp:722015712054 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:23104491877600 data:0x0000000031000002
vi-output, ht_i-3661 [000] … 23082.451713: tegra_channel_capture_setup: vnc_id 0 W 1920 H 1080 fmt 13
kworker/8:1-322616 [008] … 23082.504919: rtcpu_vinotify_event: tstamp:722095465234 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:23107051767456 data:0x399d580010000000
kworker/8:1-322616 [008] … 23082.504921: rtcpu_vinotify_event: tstamp:722095465372 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:23107051810112 data:0x0000000031000001
kworker/8:1-322616 [008] … 23082.504922: rtcpu_vinotify_event: tstamp:722095465524 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:23107051827808 data:0x399d550010000000
kworker/8:1-322616 [008] … 23082.504923: rtcpu_vinotify_event: tstamp:722095465654 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:23107051888160 data:0x0000000031000002
vi-output, ht_i-3661 [000] … 23085.011729: tegra_channel_capture_setup: vnc_id 0 W 1920 H 1080 fmt 13
kworker/8:1-322616 [008] … 23085.025067: rtcpu_vinotify_event: tstamp:722175375114 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:23109611794592 data:0x399d580010000000
kworker/8:1-322616 [008] … 23085.025070: rtcpu_vinotify_event: tstamp:722175375248 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:23109611837248 data:0x0000000031000001
kworker/8:1-322616 [008] … 23085.025071: rtcpu_vinotify_event: tstamp:722175375402 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:23109611854848 data:0x399d550010000000
kworker/8:1-322616 [008] … 23085.025072: rtcpu_vinotify_event: tstamp:722175375530 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:23109611915264 data:0x0000000031000002
vi-output, ht_i-3661 [000] … 23087.571721: tegra_channel_capture_setup: vnc_id 0 W 1920 H 1080 fmt 13
kworker/8:1-322616 [008] … 23087.612875: rtcpu_vinotify_event: tstamp:722255406089 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:23112171767904 data:0x399d580010000000
kworker/8:1-322616 [008] … 23087.612878: rtcpu_vinotify_event: tstamp:722255406224 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:23112171810592 data:0x0000000031000001
kworker/8:1-322616 [008] … 23087.612878: rtcpu_vinotify_event: tstamp:722255406381 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:23112171828192 data:0x399d550010000000
kworker/8:1-322616 [008] … 23087.612878: rtcpu_vinotify_event: tstamp:722255406509 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:23112171888544 data:0x0000000031000002
vi-output, ht_i-3661 [000] … 23090.131744: tegra_channel_capture_setup: vnc_id 0 W 1920 H 1080 fmt 13
kworker/8:1-322616 [008] … 23090.193006: rtcpu_vinotify_event: tstamp:722335702791 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:23114731794656 data:0x399d580010000000
kworker/8:1-322616 [008] … 23090.193008: rtcpu_vinotify_event: tstamp:722335702925 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:23114731837344 data:0x0000000031000001
kworker/8:1-322616 [008] … 23090.193009: rtcpu_vinotify_event: tstamp:722335703077 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:23114731854912 data:0x399d550010000000
kworker/8:1-322616 [008] … 23090.193009: rtcpu_vinotify_event: tstamp:722335703209 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:23114731915264 data:0x0000000031000002
vi-output, ht_i-3661 [000] … 23092.690764: tegra_channel_capture_setup: vnc_id 0 W 1920 H 1080 fmt 13
kworker/8:1-322616 [008] … 23092.712805: rtcpu_vinotify_event: tstamp:722415455545 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:23117290813920 data:0x399d580010000000
kworker/8:1-322616 [008] … 23092.712807: rtcpu_vinotify_event: tstamp:722415455682 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:23117290856608 data:0x0000000031000001
kworker/8:1-322616 [008] … 23092.712808: rtcpu_vinotify_event: tstamp:722415455835 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:23117290874176 data:0x399d550010000000
kworker/8:1-322616 [008] … 23092.712808: rtcpu_vinotify_event: tstamp:722415455966 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:23117290934560 data:0x0000000031000002
vi-output, ht_i-3661 [000] … 23095.250745: tegra_channel_capture_setup: vnc_id 0 W 1920 H 1080 fmt 13

but when we stop the v4l2 command and restart it ,it also get the valid video data ,the trace log is: rtcpu_vinotify_error: tstamp:728920434890 cch:-1 vi:0 tag:CHANSEL_NOMATCH channel:0x41 frame:0 vi_tstamp:23325453788960 data:0x00000000000003c9
vi-output, ht_i-335027 [002] … 23300.860415: tegra_channel_capture_frame: sof:23325.427887040
vi-output, ht_i-335027 [002] … 23300.860417: tegra_channel_capture_frame: eof:23325.459868576
vi-output, ht_i-335027 [002] … 23300.893780: tegra_channel_capture_frame: sof:23325.461220288
vi-output, ht_i-335027 [002] … 23300.893782: tegra_channel_capture_frame: eof:23325.493201824
kworker/8:1-322616 [008] … 23300.910490: rtcpu_vinotify_event: tstamp:728920628159 cch:-1 vi:0 tag:FE channel:0x03 frame:0 vi_tstamp:23325450961568 data:0x0000000000000020
kworker/8:1-322616 [008] … 23300.910492: rtcpu_vinotify_event: tstamp:728920628289 cch:-1 vi:0 tag:FS channel:0x03 frame:0 vi_tstamp:23325451809344 data:0x0000000000000010
kworker/8:1-322616 [008] … 23300.910493: rtcpu_vinotify_event: tstamp:728920628439 cch:-1 vi:0 tag:CHANSEL_NOMATCH channel:0xc1 frame:0 vi_tstamp:23325452318720 data:0x00000000000003c9
kworker/8:1-322616 [008] … 23300.910494: rtcpu_vinotify_event: tstamp:728920628566 cch:-1 vi:0 tag:FE channel:0x01 frame:0 vi_tstamp:23325452437216 data:0x0000000000000020
kworker/8:1-322616 [008] … 23300.910495: rtcpu_vinotify_event: tstamp:728920628710 cch:-1 vi:0 tag:FS channel:0x01 frame:0 vi_tstamp:23325453291040 data:0x0000000000000010
kworker/8:1-322616 [008] … 23300.910496: rtcpu_vinotify_event: tstamp:728920628838 cch:-1 vi:0 tag:CHANSEL_NOMATCH channel:0x41 frame:0 vi_tstamp:23325453788960 data:0x00000000000003c9
kworker/8:1-322616 [008] … 23300.910496: rtcpu_vinotify_event: tstamp:728920628993 cch:0 vi:0 tag:CHANSEL_PXL_EOF channel:0x23 frame:0 vi_tstamp:23325459862240 data:0x0000000004370002
kworker/8:1-322616 [008] … 23300.910497: rtcpu_vinotify_event: tstamp:728920629126 cch:0 vi:0 tag:ATOMP_FRAME_DONE channel:0x23 frame:0 vi_tstamp:23325459863232 data:0x0000000000000000
kworker/8:1-322616 [008] … 23300.910498: rtcpu_vinotify_event: tstamp:728920629278 cch:0 vi:0 tag:VIFALC_ACTIONLST channel:0x23 frame:0 vi_tstamp:23325459887296 data:0x0000000002020019
kworker/8:1-322616 [008] … 23300.910498: rtcpu_vinotify_event: tstamp:728920629406 cch:0 vi:0 tag:FE channel:0x00 frame:0 vi_tstamp:23325459868512 data:0x0000000000000020
kworker/8:1-322616 [008] … 23300.910499: rtcpu_vinotify_event: tstamp:728920629555 cch:0 vi:0 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:23325459868576 data:0x0000000800000000
kworker/8:1-322616 [008] … 23300.910500: rtcpu_vinotify_event: tstamp:728920629686 cch:0 vi:0 tag:VIFALC_ACTIONLST channel:0x23 frame:0 vi_tstamp:23325459932384 data:0x0000000000020019
kworker/8:1-322616 [008] … 23300.910502: rtcpu_vinotify_event: tstamp:728921147769 cch:0 vi:0 tag:FS channel:0x00 frame:0 vi_tstamp:23325460723712 data:0x0000000000000010
kworker/8:1-322616 [008] … 23300.910503: rtcpu_vinotify_event: tstamp:728921147907 cch:0 vi:0 tag:ATOMP_FS channel:0x00 frame:0 vi_tstamp:23325460723808 data:0x0000000800000000
kworker/8:1-322616 [008] … 23300.910504: rtcpu_vinotify_event: tstamp:728921148060 cch:0 vi:0 tag:CHANSEL_PXL_SOF channel:0x23 frame:0 vi_tstamp:23325461220288 data:0x0000000000000001
kworker/8:1-322616 [008] … 23300.910505: rtcpu_vinotify_event: tstamp:728921148191 cch:0 vi:0 tag:VIFALC_ACTIONLST channel:0x23 frame:0 vi_tstamp:23325461231136 data:0x000000000802001a
kworker/8:1-322616 [008] … 23300.910506: rtcpu_vinotify_event: tstamp:728921148343 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:23325461458944 data:0x399d580010000000
kworker/8:1-322616 [008] … 23300.910506: rtcpu_vinotify_event: tstamp:728921148473 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:23325461502272 data:0x000000003100001b
kworker/8:1-322616 [008] … 23300.910507: rtcpu_vinotify_event: tstamp:728921148624 cch:-1 vi:0 tag:FE channel:0x02 frame:0 vi_tstamp:23325476294752 data:0x0000000000000020
kworker/8:1-322616 [008] … 23300.910508: rtcpu_vinotify_error: tstamp:728921180428 cch:-1 vi:0 tag:CHANSEL_NOMATCH channel:0x81 frame:0 vi_tstamp:23325477646144 data:0x00000000000003c9
kworker/8:1-322616 [008] … 23300.910509: rtcpu_vinotify_error: tstamp:728921430608 cch:-1 vi:0 tag:CHANSEL_NOMATCH channel:0xc1 frame:0 vi_tstamp:23325485651904 data:0x00000000000003c9
kworker/8:1-322616 [008] … 23300.910510: rtcpu_vinotify_error: tstamp:728921476572 cch:-1 vi:0 tag:CHANSEL_NOMATCH channel:0x41 frame:0 vi_tstamp:23325487121856 data:0x00000000000003c9
kworker/8:1-322616 [008] … 23300.910511: rtcpu_vinotify_event: tstamp:728921670790 cch:-1 vi:0 tag:FS channel:0x02 frame:0 vi_tstamp:23325477142528 data:0x0000000000000010
kworker/8:1-322616 [008] … 23300.910511: rtcpu_vinotify_event: tstamp:728921670938 cch:-1 vi:0 tag:CHANSEL_NOMATCH channel:0x81 frame:0 vi_tstamp:23325477646144 data:0x00000000000003c9
kworker/8:1-322616 [008] … 23300.910512: rtcpu_vinotify_event: tstamp:728921671066 cch:-1 vi:0 tag:FE channel:0x03 frame:0 vi_tstamp:23325484294496 data:0x0000000000000020
kworker/8:1-322616 [008] … 23300.910513: rtcpu_vinotify_event: tstamp:728921671210 cch:-1 vi:0 tag:FS channel:0x03 frame:0 vi_tstamp:23325485142592 data:0x0000000000000010
kworker/8:1-322616 [008] … 23300.910513: rtcpu_vinotify_event: tstamp:728921671337 cch:-1 vi:0 tag:CHANSEL_NOMATCH channel:0xc1 frame:0 vi_tstamp:23325485651904 data:0x00000000000003c9
kworker/8:1-322616 [008] … 23300.910514: rtcpu_vinotify_event: tstamp:728921671482 cch:-1 vi:0 tag:FE channel:0x01 frame:0 vi_tstamp:23325485770432 data:0x0000000000000020
kworker/8:1-322616 [008] … 23300.910515: rtcpu_vinotify_event: tstamp:728921671609 cch:-1 vi:0 tag:FS channel:0x01 frame:0 vi_tstamp:23325486623904 data:0x0000000000000010
kworker/8:1-322616 [008] … 23300.910515: rtcpu_vinotify_event: tstamp:728921671756 cch:-1 vi:0 tag:CHANSEL_NOMATCH channel:0x41 frame:0 vi_tstamp:23325487121856 data:0x00000000000003c9
kworker/8:1-322616 [008] … 23300.910516: rtcpu_vinotify_event: tstamp:728921671888 cch:0 vi:0 tag:CHANSEL_PXL_EOF channel:0x23 frame:0 vi_tstamp:23325493195488 data:0x0000000004370002
kworker/8:1-322616 [008] … 23300.910517: rtcpu_vinotify_event: tstamp:728922178894 cch:0 vi:0 tag:ATOMP_FRAME_DONE channel:0x23 frame:0 vi_tstamp:23325493196448 data:0x0000000000000000
kworker/8:1-322616 [008] … 23300.910518: rtcpu_vinotify_event: tstamp:728922179026 cch:0 vi:0 tag:VIFALC_ACTIONLST channel:0x23 frame:0 vi_tstamp:23325493232992 data:0x000000000202001a
kworker/8:1-322616 [008] … 23300.910518: rtcpu_vinotify_event: tstamp:728922179178 cch:0 vi:0 tag:FE channel:0x00 frame:0 vi_tstamp:23325493201728 data:0x0000000000000020
kworker/8:1-322616 [008] … 23300.910519: rtcpu_vinotify_event: tstamp:728922179310 cch:0 vi:0 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:23325493201824 data:0x0000000800000000
kworker/8:1-322616 [008] … 23300.910520: rtcpu_vinotify_event: tstamp:728922179462 cch:0 vi:0 tag:VIFALC_ACTIONLST channel:0x23 frame:0 vi_tstamp:23325493312608 data:0x000000000002001a
kworker/8:1-322616 [008] … 23300.910520: rtcpu_vinotify_event: tstamp:728922179590 cch:0 vi:0 tag:FS channel:0x00 frame:0 vi_tstamp:23325494056096 data:0x0000000000000010
kworker/8:1-322616 [008] … 23300.910521: rtcpu_vinotify_event: tstamp:728922179743 cch:0 vi:0 tag:ATOMP_FS channel:0x00 frame:0 vi_tstamp:23325494056224 data:0x0000000800000000
kworker/8:1-322616 [008] … 23300.910522: rtcpu_vinotify_event: tstamp:728922179874 cch:0 vi:0 tag:CHANSEL_PXL_SOF channel:0x23 frame:0 vi_tstamp:23325494553152 data:0x0000000000000001
kworker/8:1-322616 [008] … 23300.910522: rtcpu_vinotify_event: tstamp:728922180022 cch:0 vi:0 tag:VIFALC_ACTIONLST channel:0x23 frame:0 vi_tstamp:23325494564000 data:0x000000000802001b
kworker/8:1-322616 [008] … 23300.910523: rtcpu_vinotify_event: tstamp:728922180153 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:23325494811040 data:0x399d550010000000
kworker/8:1-322616 [008] … 23300.910524: rtcpu_vinotify_event: tstamp:728922180301 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:23325494857248 data:0x000000003100001c
kworker/8:1-322616 [008] … 23300.910524: rtcpu_vinotify_event: tstamp:728922180429 cch:-1 vi:0 tag:FE channel:0x02 frame:0 vi_tstamp:23325509627616 data:0x0000000000000020

Looks like didn’t receive any validate data from the sensor.
Maybe need to probe the signal and sensor power sequency.

when the situation occur ,just stop the v4l2 commad ,and execute the cmd again ,it could get the video data;

For this I would suspect it could be the sensor power on sequency problem or the THS_Settle timing problem.
Please confirm the timing by MIPI spec.

This topic was automatically closed 14 days after the last reply. New replies are no longer allowed.