Orin nx 8G
Jetson Linux 35.4.1
tegra234-p3767-0001-p3768-0000-a0.txt (410.3 KB)
kworker/1:4-126 [001] .... 200.286555: rtcpu_string: tstamp:7007948469 id:0x04010000 str:"VM0 deactivating."
kworker/1:4-126 [001] .... 215.874319: rtcpu_string: tstamp:7495788473 id:0x04010000 str:"VM0 activating."
kworker/1:4-126 [001] .... 215.929877: rtcpu_string: tstamp:7495868824 id:0x04010000 str:"NVCSILP clock rate = 408000000 Hz.
"
kworker/1:4-126 [001] .... 215.933500: rtcpu_string: tstamp:7496287051 id:0x04010000 str:"tegra_nvcsi_stream_set_config(vm0, stream=0, csi"
kworker/1:4-126 [001] .... 215.933750: rtcpu_string: tstamp:7496287155 id:0x04010000 str:"=0)
"
kworker/1:4-126 [001] .... 215.933765: rtcpu_string: tstamp:7496287529 id:0x04010000 str:"MIPI clock = 600000 kHz, tHS-SETTLE = 0, tCLK-SE"
kworker/1:4-126 [001] .... 215.933766: rtcpu_string: tstamp:7496287632 id:0x04010000 str:"TTLE = 0
"
kworker/1:4-126 [001] .... 215.933973: rtcpu_string: tstamp:7496287845 id:0x04010000 str:"===== NVCSI Stream Configuration =====
"
kworker/1:4-126 [001] .... 215.934091: rtcpu_string: tstamp:7496288090 id:0x04010000 str:"stream_id: PP 0, csi_port: PORT A
"
kworker/1:4-126 [001] .... 215.934245: rtcpu_string: tstamp:7496288344 id:0x04010000 str:"Brick: PHY 0, Mode: D-PHY
"
kworker/1:4-126 [001] .... 215.934390: rtcpu_string: tstamp:7496288628 id:0x04010000 str:"Partition: CIL A, LP bypass: Enabled, Lanes: 4
"
kworker/1:4-126 [001] .... 215.934509: rtcpu_string: tstamp:7496288807 id:0x04010000 str:"Clock information:
"
kworker/1:4-126 [001] .... 215.934640: rtcpu_string: tstamp:7496289108 id:0x04010000 str:"MIPI clock rate: 600.00 MHz
"
kworker/1:4-126 [001] .... 215.934745: rtcpu_string: tstamp:7496289353 id:0x04010000 str:"T_HS settle: 0, T_CLK settle: 0
"
kworker/1:4-126 [001] .... 215.934883: rtcpu_string: tstamp:7496289580 id:0x04010000 str:"======================================
"
kworker/1:4-126 [001] .... 215.935039: rtcpu_string: tstamp:7496291939 id:0x04010000 str:"tegra_nvcsi_stream_open(vm0, stream=0, csi=0)
"
kworker/1:4-126 [001] .... 215.935101: rtcpu_string: tstamp:7496298917 id:0x04010000 str:"nvcsi_calc_ths_settle ths_settle 55
"
kworker/1:4-126 [001] .... 215.935199: rtcpu_string: tstamp:7496299183 id:0x04010000 str:"nvcsi_calc_ths_settle ths_settle 55
"
kworker/1:4-126 [001] .... 215.935256: rtcpu_string: tstamp:7496299444 id:0x04010000 str:"nvcsi_calc_ths_settle ths_settle 55
"
kworker/1:4-126 [001] .... 215.935301: rtcpu_string: tstamp:7496299703 id:0x04010000 str:"nvcsi_calc_tclk_settle tclk_settle 75
"
kworker/1:4-126 [001] .... 215.935446: rtcpu_vinotify_event: tstamp:7496452230 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:239869298112 data:0x759d580010000000
kworker/1:4-126 [001] .... 215.935549: rtcpu_vinotify_event: tstamp:7496452369 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:239869304608 data:0x0000000031000001
kworker/1:4-126 [001] .... 215.935555: rtcpu_vinotify_event: tstamp:7496452525 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:239869350624 data:0x759d550010000000
kworker/1:4-126 [001] .... 215.935556: rtcpu_vinotify_event: tstamp:7496452660 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:239869357216 data:0x0000000031000002
kworker/1:4-126 [001] .... 218.741810: rtcpu_vinotify_event: tstamp:7584343100 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:242696164544 data:0x759d580010000000
kworker/1:4-126 [001] .... 218.741819: rtcpu_vinotify_event: tstamp:7584343239 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:242696207232 data:0x0000000031000001
kworker/1:4-126 [001] .... 218.741820: rtcpu_vinotify_event: tstamp:7585428715 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:242716815840 data:0x759d550010000000
kworker/1:4-126 [001] .... 218.741820: rtcpu_vinotify_event: tstamp:7585428854 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:242716859200 data:0x0000000031000002
kworker/1:4-126 [001] .... 221.545749: rtcpu_vinotify_event: tstamp:7671692295 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:245482496096 data:0x759d580010000000
kworker/1:4-126 [001] .... 221.545759: rtcpu_vinotify_event: tstamp:7671692431 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:245482538784 data:0x0000000031000001
kworker/1:4-126 [001] .... 221.545760: rtcpu_vinotify_event: tstamp:7671692587 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:245482556416 data:0x759d550010000000
kworker/1:4-126 [001] .... 221.545761: rtcpu_vinotify_event: tstamp:7671692718 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:245482616768 data:0x0000000031000002
kworker/1:4-126 [001] .... 224.349730: rtcpu_vinotify_event: tstamp:7759333030 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:248298449824 data:0x759d580010000000
kworker/1:4-126 [001] .... 224.349742: rtcpu_vinotify_event: tstamp:7759333170 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:248298492544 data:0x0000000031000001
kworker/1:4-126 [001] .... 224.349743: rtcpu_vinotify_event: tstamp:7759333327 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:248298510176 data:0x759d550010000000
kworker/1:4-126 [001] .... 224.349744: rtcpu_vinotify_event: tstamp:7759333462 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:248298570528 data:0x0000000031000002
kworker/1:4-126 [001] .... 227.157681: rtcpu_vinotify_event: tstamp:7847367075 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:251114521056 data:0x759d580010000000
kworker/1:4-126 [001] .... 227.157690: rtcpu_vinotify_event: tstamp:7847367211 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:251114563744 data:0x0000000031000001
kworker/1:4-126 [001] .... 227.157690: rtcpu_vinotify_event: tstamp:7847367365 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:251114581440 data:0x759d550010000000
kworker/1:4-126 [001] .... 227.157690: rtcpu_vinotify_event: tstamp:7847367499 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:251114641792 data:0x0000000031000002
The display is all green screen, I followed the instructions below to try to raise the clock of each module, only a few times the display was successful, and now the green screen is displayed all the time.
sudo su
echo 1 > /sys/kernel/debug/bpmp/debug/clk/vi/mrq_rate_locked
echo 1 > /sys/kernel/debug/bpmp/debug/clk/isp/mrq_rate_locked
echo 1 > /sys/kernel/debug/bpmp/debug/clk/nvcsi/mrq_rate_locked
cat /sys/kernel/debug/bpmp/debug/clk/vi/max_rate |tee /sys/kernel/debug/bpmp/debug/clk/vi/rate
cat /sys/kernel/debug/bpmp/debug/clk/isp/max_rate | tee /sys/kernel/debug/bpmp/debug/clk/isp/rate
cat /sys/kernel/debug/bpmp/debug/clk/nvcsi/max_rate | tee /sys/kernel/debug/bpmp/debug/clk/nvcsi/rate
What’s the trace log after boost the clocks.
Thanks
Hi ShaneCCC, thanks for your reply!
The following table describes the tracing logs after the clock is boosted. Same as before.
kworker/1:9-154 [001] .... 132.973964: rtcpu_string: tstamp:4789709323 id:0x04010000 str:"VM0 deactivating."
kworker/1:9-154 [001] .... 136.005983: rtcpu_string: tstamp:4883745560 id:0x04010000 str:"VM0 activating."
kworker/1:9-154 [001] .... 136.005995: rtcpu_string: tstamp:4883824098 id:0x04010000 str:"NVCSILP clock rate = 408000000 Hz.
"
kworker/1:9-154 [001] .... 136.009610: rtcpu_string: tstamp:4884163518 id:0x04010000 str:"tegra_nvcsi_stream_set_config(vm0, stream=0, csi"
kworker/1:9-154 [001] .... 136.009703: rtcpu_string: tstamp:4884163622 id:0x04010000 str:"=0)
"
kworker/1:9-154 [001] .... 136.009717: rtcpu_string: tstamp:4884163995 id:0x04010000 str:"MIPI clock = 600000 kHz, tHS-SETTLE = 0, tCLK-SE"
kworker/1:9-154 [001] .... 136.009718: rtcpu_string: tstamp:4884164100 id:0x04010000 str:"TTLE = 0
"
kworker/1:9-154 [001] .... 136.009721: rtcpu_string: tstamp:4884164314 id:0x04010000 str:"===== NVCSI Stream Configuration =====
"
kworker/1:9-154 [001] .... 136.009724: rtcpu_string: tstamp:4884164561 id:0x04010000 str:"stream_id: PP 0, csi_port: PORT A
"
kworker/1:9-154 [001] .... 136.009727: rtcpu_string: tstamp:4884164801 id:0x04010000 str:"Brick: PHY 0, Mode: D-PHY
"
kworker/1:9-154 [001] .... 136.009730: rtcpu_string: tstamp:4884165087 id:0x04010000 str:"Partition: CIL A, LP bypass: Enabled, Lanes: 4
"
kworker/1:9-154 [001] .... 136.009733: rtcpu_string: tstamp:4884165266 id:0x04010000 str:"Clock information:
"
kworker/1:9-154 [001] .... 136.009735: rtcpu_string: tstamp:4884165564 id:0x04010000 str:"MIPI clock rate: 600.00 MHz
"
kworker/1:9-154 [001] .... 136.009738: rtcpu_string: tstamp:4884165808 id:0x04010000 str:"T_HS settle: 0, T_CLK settle: 0
"
kworker/1:9-154 [001] .... 136.009741: rtcpu_string: tstamp:4884166032 id:0x04010000 str:"======================================
"
kworker/1:9-154 [001] .... 136.009744: rtcpu_string: tstamp:4884167990 id:0x04010000 str:"tegra_nvcsi_stream_open(vm0, stream=0, csi=0)
"
kworker/1:9-154 [001] .... 136.009747: rtcpu_string: tstamp:4884174865 id:0x04010000 str:"nvcsi_calc_ths_settle ths_settle 55
"
kworker/1:9-154 [001] .... 136.009750: rtcpu_string: tstamp:4884175129 id:0x04010000 str:"nvcsi_calc_ths_settle ths_settle 55
"
kworker/1:9-154 [001] .... 136.009753: rtcpu_string: tstamp:4884175389 id:0x04010000 str:"nvcsi_calc_ths_settle ths_settle 55
"
kworker/1:9-154 [001] .... 136.009755: rtcpu_string: tstamp:4884175648 id:0x04010000 str:"nvcsi_calc_tclk_settle tclk_settle 75
"
kworker/1:9-154 [001] .... 136.009760: rtcpu_vinotify_event: tstamp:4884195406 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:156283869280 data:0x759d580010000000
kworker/1:9-154 [001] .... 136.009760: rtcpu_vinotify_event: tstamp:4884195547 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:156283875744 data:0x0000000031000001
kworker/1:9-154 [001] .... 136.009760: rtcpu_vinotify_event: tstamp:4884195704 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:156283921536 data:0x759d550010000000
kworker/1:9-154 [001] .... 136.009761: rtcpu_vinotify_event: tstamp:4884195837 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:156283928032 data:0x0000000031000002
kworker/1:9-154 [001] .... 138.586001: rtcpu_vinotify_event: tstamp:4965326065 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:158883411776 data:0x759d580010000000
kworker/1:9-154 [001] .... 138.586013: rtcpu_vinotify_event: tstamp:4965326202 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:158883418272 data:0x0000000031000001
kworker/1:9-154 [001] .... 138.586013: rtcpu_vinotify_event: tstamp:4965664064 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:158898794368 data:0x759d550010000000
kworker/1:9-154 [001] .... 138.586014: rtcpu_vinotify_event: tstamp:4965664201 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:158898800896 data:0x0000000031000002
kworker/1:9-154 [001] .... 141.397743: rtcpu_vinotify_event: tstamp:5053217500 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:161699314304 data:0x759d580010000000
kworker/1:9-154 [001] .... 141.397753: rtcpu_vinotify_event: tstamp:5053217643 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:161699320800 data:0x0000000031000001
kworker/1:9-154 [001] .... 141.397754: rtcpu_vinotify_event: tstamp:5053217798 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:161699361536 data:0x759d550010000000
kworker/1:9-154 [001] .... 141.397754: rtcpu_vinotify_event: tstamp:5053217933 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:161699368096 data:0x0000000031000002
kworker/1:9-154 [001] .... 144.201159: rtcpu_vinotify_event: tstamp:5141082518 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:164514569664 data:0x759d580010000000
kworker/1:9-154 [001] .... 144.201168: rtcpu_vinotify_event: tstamp:5141082658 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:164514576096 data:0x0000000031000001
kworker/1:9-154 [001] .... 144.201168: rtcpu_vinotify_event: tstamp:5141082819 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:164514616448 data:0x759d550010000000
kworker/1:9-154 [001] .... 144.201169: rtcpu_vinotify_event: tstamp:5141082954 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:164514623008 data:0x0000000031000002
It doesn’t seem to be about raising the clock. Changing the carrier board without raising the clock captured some images, but it was unstable. The log is as follows:
kworker/1:7-141 [001] .... 510.981729: rtcpu_string: tstamp:16610608451 id:0x04010000 str:"NVCSILP clock rate = 408000000 Hz.
"
kworker/1:7-141 [001] .... 510.985358: rtcpu_dbg_set_loglevel: tstamp:16610637149 old:0 new:2
kworker/1:7-141 [001] .... 517.209590: rtcpu_string: tstamp:16805004251 id:0x04010000 str:"VM0 deactivating."
kworker/1:7-141 [001] .... 517.489593: rtcpu_string: tstamp:16815007214 id:0x04010000 str:"VM0 activating."
kworker/1:7-141 [001] .... 517.489604: rtcpu_string: tstamp:16815086130 id:0x04010000 str:"NVCSILP clock rate = 408000000 Hz.
"
kworker/1:7-141 [001] .... 517.493212: rtcpu_string: tstamp:16815473599 id:0x04010000 str:"tegra_nvcsi_stream_set_config(vm0, stream=0, csi"
kworker/1:7-141 [001] .... 517.493489: rtcpu_string: tstamp:16815473703 id:0x04010000 str:"=0)
"
kworker/1:7-141 [001] .... 517.493504: rtcpu_string: tstamp:16815474076 id:0x04010000 str:"MIPI clock = 600000 kHz, tHS-SETTLE = 0, tCLK-SE"
kworker/1:7-141 [001] .... 517.493504: rtcpu_string: tstamp:16815474181 id:0x04010000 str:"TTLE = 0
"
kworker/1:7-141 [001] .... 517.493583: rtcpu_string: tstamp:16815474395 id:0x04010000 str:"===== NVCSI Stream Configuration =====
"
kworker/1:7-141 [001] .... 517.493633: rtcpu_string: tstamp:16815474643 id:0x04010000 str:"stream_id: PP 0, csi_port: PORT A
"
kworker/1:7-141 [001] .... 517.493697: rtcpu_string: tstamp:16815474880 id:0x04010000 str:"Brick: PHY 0, Mode: D-PHY
"
kworker/1:7-141 [001] .... 517.493698: rtcpu_string: tstamp:16815475167 id:0x04010000 str:"Partition: CIL A, LP bypass: Enabled, Lanes: 4
"
kworker/1:7-141 [001] .... 517.493700: rtcpu_string: tstamp:16815475348 id:0x04010000 str:"Clock information:
"
kworker/1:7-141 [001] .... 517.493702: rtcpu_string: tstamp:16815475648 id:0x04010000 str:"MIPI clock rate: 600.00 MHz
"
kworker/1:7-141 [001] .... 517.493704: rtcpu_string: tstamp:16815475895 id:0x04010000 str:"T_HS settle: 0, T_CLK settle: 0
"
kworker/1:7-141 [001] .... 517.493706: rtcpu_string: tstamp:16815476122 id:0x04010000 str:"======================================
"
kworker/1:7-141 [001] .... 517.493708: rtcpu_string: tstamp:16815478038 id:0x04010000 str:"tegra_nvcsi_stream_open(vm0, stream=0, csi=0)
"
kworker/1:7-141 [001] .... 517.493709: rtcpu_string: tstamp:16815485007 id:0x04010000 str:"nvcsi_calc_ths_settle ths_settle 55
"
kworker/1:7-141 [001] .... 517.493711: rtcpu_string: tstamp:16815485273 id:0x04010000 str:"nvcsi_calc_ths_settle ths_settle 55
"
kworker/1:7-141 [001] .... 517.493713: rtcpu_string: tstamp:16815485532 id:0x04010000 str:"nvcsi_calc_ths_settle ths_settle 55
"
kworker/1:7-141 [001] .... 517.493714: rtcpu_string: tstamp:16815485793 id:0x04010000 str:"nvcsi_calc_tclk_settle tclk_settle 75
"
kworker/1:7-141 [001] .... 517.549579: rtcpu_vinotify_event: tstamp:16815663888 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:538084287616 data:0x759d580010000000
kworker/1:7-141 [001] .... 517.549590: rtcpu_vinotify_event: tstamp:16815664028 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:538084294048 data:0x0000000031000001
kworker/1:7-141 [001] .... 517.549590: rtcpu_vinotify_event: tstamp:16815664184 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:538084339872 data:0x759d550010000000
kworker/1:7-141 [001] .... 517.549591: rtcpu_vinotify_event: tstamp:16815664319 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:538084346400 data:0x0000000031000002
kworker/1:7-141 [001] .... 517.549591: rtcpu_vinotify_event: tstamp:16815664496 cch:0 vi:0 tag:FS channel:0x00 frame:31591 vi_tstamp:538096165152 data:0x00007b6700000010
kworker/1:7-141 [001] .... 517.549591: rtcpu_vinotify_event: tstamp:16815664632 cch:0 vi:0 tag:ATOMP_FS channel:0x00 frame:31591 vi_tstamp:538096165248 data:0x0000000800000000
kworker/1:7-141 [001] .... 517.549591: rtcpu_vinotify_event: tstamp:16815664784 cch:0 vi:0 tag:CHANSEL_PXL_SOF channel:0x23 frame:31591 vi_tstamp:538096180096 data:0x0000000000000001
kworker/1:7-141 [001] .... 517.549591: rtcpu_vinotify_event: tstamp:16815664918 cch:0 vi:0 tag:VIFALC_ACTIONLST channel:0x23 frame:31591 vi_tstamp:538096207232 data:0x0000000008020001
kworker/1:7-141 [001] .... 517.549593: rtcpu_string: tstamp:16815967571 id:0x04010000 str:"ISR PHY 0 CIL_A 0x110
"
kworker/1:7-141 [001] .... 517.549608: rtcpu_nvcsi_intr: tstamp:16815967276 class:GLOBAL type:PHY_INTR0 phy:0 cil:0 st:0 vc:0 status:0x00000110
kworker/1:7-141 [001] .... 517.549618: rtcpu_string: tstamp:16815968000 id:0x04010000 str:"ISR PHY 0 CIL_B 0x110
"
kworker/1:7-141 [001] .... 517.549625: rtcpu_nvcsi_intr: tstamp:16815967276 class:GLOBAL type:PHY_INTR0 phy:0 cil:1 st:0 vc:0 status:0x00000110
kworker/1:7-141 [001] .... 517.549625: rtcpu_string: tstamp:16815969914 id:0x04010000 str:"nvcsi_calc_ths_settle ths_settle 55
"
kworker/1:7-141 [001] .... 517.549632: rtcpu_string: tstamp:16815970180 id:0x04010000 str:"nvcsi_calc_ths_settle ths_settle 55
"
kworker/1:7-141 [001] .... 517.549635: rtcpu_string: tstamp:16815970439 id:0x04010000 str:"nvcsi_calc_ths_settle ths_settle 55
"
kworker/1:7-141 [001] .... 517.549638: rtcpu_string: tstamp:16815970697 id:0x04010000 str:"nvcsi_calc_tclk_settle tclk_settle 75
"
kworker/1:7-141 [001] .... 517.549641: rtcpu_string: tstamp:16815971274 id:0x04010000 str:"ISR PHY 0 CIL_A 0x10
"
kworker/1:7-141 [001] .... 517.549644: rtcpu_nvcsi_intr: tstamp:16815971003 class:GLOBAL type:PHY_INTR0 phy:0 cil:0 st:0 vc:0 status:0x00000010
kworker/1:7-141 [001] .... 517.549644: rtcpu_string: tstamp:16815971885 id:0x04010000 str:"ISR PHY 0 CIL_B 0x10
"
kworker/1:7-141 [001] .... 517.549647: rtcpu_nvcsi_intr: tstamp:16815971615 class:GLOBAL type:PHY_INTR0 phy:0 cil:1 st:0 vc:0 status:0x00000010
kworker/1:7-141 [001] .... 517.549647: rtcpu_string: tstamp:16815973943 id:0x04010000 str:"nvcsi_calc_ths_settle ths_settle 55
"
kworker/1:7-141 [001] .... 517.549650: rtcpu_string: tstamp:16815974206 id:0x04010000 str:"nvcsi_calc_ths_settle ths_settle 55
"
kworker/1:7-141 [001] .... 517.549653: rtcpu_string: tstamp:16815974464 id:0x04010000 str:"nvcsi_calc_ths_settle ths_settle 55
"
kworker/1:7-141 [001] .... 517.549656: rtcpu_string: tstamp:16815974722 id:0x04010000 str:"nvcsi_calc_tclk_settle tclk_settle 75
"
kworker/1:7-141 [001] .... 517.549658: rtcpu_vinotify_event: tstamp:16816032625 cch:0 vi:0 tag:FE channel:0x00 frame:31591 vi_tstamp:538112179616 data:0x00007b6700000020
kworker/1:7-141 [001] .... 517.549658: rtcpu_vinotify_event: tstamp:16816032760 cch:0 vi:0 tag:CHANSEL_SHORT_FRAME channel:0x01 frame:31591 vi_tstamp:538112179648 data:0x0426200001000000
kworker/1:7-141 [001] .... 517.549659: rtcpu_vinotify_event: tstamp:16816032913 cch:0 vi:0 tag:VIFALC_ACTIONLST channel:0x23 frame:31591 vi_tstamp:538112246400 data:0x0000000001020001
kworker/1:7-141 [001] .... 517.549659: rtcpu_vinotify_event: tstamp:16816033045 cch:0 vi:0 tag:ATOMP_FE channel:0x00 frame:31591 vi_tstamp:538112179712 data:0x0000000800000000
kworker/1:7-141 [001] .... 517.549660: rtcpu_vinotify_event: tstamp:16816033198 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:538112522080 data:0x759d580010000000
kworker/1:7-141 [001] .... 517.549660: rtcpu_vinotify_event: tstamp:16816033329 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:538112565440 data:0x0000000031000003
kworker/1:7-141 [001] .... 517.549660: rtcpu_vinotify_event: tstamp:16816033481 cch:0 vi:0 tag:FS channel:0x00 frame:31592 vi_tstamp:538112831456 data:0x00007b6800000010
kworker/1:7-141 [001] .... 517.549660: rtcpu_vinotify_event: tstamp:16816033613 cch:0 vi:0 tag:ATOMP_FS channel:0x00 frame:31592 vi_tstamp:538112831552 data:0x0000000800000000
kworker/1:7-141 [001] .... 517.549660: rtcpu_vinotify_event: tstamp:16816536887 cch:0 vi:0 tag:CHANSEL_PXL_SOF channel:0x23 frame:31592 vi_tstamp:538112846368 data:0x0000000000000001
kworker/1:7-141 [001] .... 517.549661: rtcpu_vinotify_event: tstamp:16816537024 cch:0 vi:0 tag:VIFALC_ACTIONLST channel:0x23 frame:31592 vi_tstamp:538112886016 data:0x0000000008020002
kworker/1:7-141 [001] .... 517.549661: rtcpu_vinotify_event: tstamp:16816537178 cch:0 vi:0 tag:CHANSEL_PXL_EOF channel:0x23 frame:31592 vi_tstamp:538128842976 data:0x0000000004370002
kworker/1:7-141 [001] .... 517.549662: rtcpu_vinotify_event: tstamp:16816537310 cch:0 vi:0 tag:ATOMP_FRAME_DONE channel:0x23 frame:31592 vi_tstamp:538128844000 data:0x0000000000000000
kworker/1:7-141 [001] .... 517.549662: rtcpu_vinotify_event: tstamp:16816537461 cch:0 vi:0 tag:VIFALC_ACTIONLST channel:0x23 frame:31592 vi_tstamp:538128867296 data:0x0000000002020002
kworker/1:7-141 [001] .... 517.549662: rtcpu_vinotify_event: tstamp:16816537594 cch:0 vi:0 tag:FE channel:0x00 frame:31592 vi_tstamp:538128845920 data:0x00007b6800000020
kworker/1:7-141 [001] .... 517.549662: rtcpu_vinotify_event: tstamp:16816537747 cch:0 vi:0 tag:ATOMP_FE channel:0x00 frame:31592 vi_tstamp:538128845984 data:0x0000000800000000
kworker/1:7-141 [001] .... 517.549662: rtcpu_vinotify_event: tstamp:16816537881 cch:0 vi:0 tag:VIFALC_ACTIONLST channel:0x23 frame:31592 vi_tstamp:538128912384 data:0x0000000000020002
kworker/1:7-141 [001] .... 517.549663: rtcpu_vinotify_event: tstamp:16817054915 cch:0 vi:0 tag:FS channel:0x00 frame:31593 vi_tstamp:538129497728 data:0x00007b6900000010
kworker/1:7-141 [001] .... 517.549663: rtcpu_vinotify_event: tstamp:16817055053 cch:0 vi:0 tag:ATOMP_FS channel:0x00 frame:31593 vi_tstamp:538129497856 data:0x0000000800000000
kworker/1:7-141 [001] .... 517.549665: rtcpu_vinotify_event: tstamp:16817055208 cch:0 vi:0 tag:CHANSEL_PXL_SOF channel:0x23 frame:31593 vi_tstamp:538129512672 data:0x0000000000000001
kworker/1:7-141 [001] .... 517.549666: rtcpu_vinotify_event: tstamp:16817055343 cch:0 vi:0 tag:VIFALC_ACTIONLST channel:0x23 frame:31593 vi_tstamp:538129539872 data:0x0000000008020003
kworker/1:7-141 [001] .... 517.549666: rtcpu_vinotify_event: tstamp:16817055496 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:538129783744 data:0x759d550010000000
kworker/1:7-141 [001] .... 517.549667: rtcpu_vinotify_event: tstamp:16817055630 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:538129827104 data:0x0000000031000004
kworker/1:7-141 [001] .... 517.549667: rtcpu_vinotify_event: tstamp:16817055781 cch:0 vi:0 tag:CHANSEL_PXL_EOF channel:0x23 frame:31593 vi_tstamp:538145509280 data:0x0000000004370002
kworker/1:7-141 [001] .... 517.549667: rtcpu_vinotify_event: tstamp:16817055916 cch:0 vi:0 tag:ATOMP_FRAME_DONE channel:0x23 frame:31593 vi_tstamp:538145510272 data:0x0000000000000000
kworker/1:7-141 [001] .... 517.549667: rtcpu_string: tstamp:16817106896 id:0x04010000 str:"ISR PHY 0 CIL_A 0x110
"
kworker/1:7-141 [001] .... 517.549669: rtcpu_nvcsi_intr: tstamp:16817106601 class:GLOBAL type:PHY_INTR0 phy:0 cil:0 st:0 vc:0 status:0x00000110
kworker/1:7-141 [001] .... 517.549670: rtcpu_string: tstamp:16817107323 id:0x04010000 str:"ISR PHY 0 CIL_B 0x110
"
kworker/1:7-141 [001] .... 517.549671: rtcpu_nvcsi_intr: tstamp:16817106601 class:GLOBAL type:PHY_INTR0 phy:0 cil:1 st:0 vc:0 status:0x00000110
kworker/1:7-141 [001] .... 517.605583: rtcpu_vinotify_event: tstamp:16817562107 cch:0 vi:0 tag:VIFALC_ACTIONLST channel:0x23 frame:31593 vi_tstamp:538145541888 data:0x0000000002020003
kworker/1:7-141 [001] .... 517.605593: rtcpu_vinotify_event: tstamp:16817562241 cch:0 vi:0 tag:FE channel:0x00 frame:31593 vi_tstamp:538145512224 data:0x00007b6900000020
kworker/1:7-141 [001] .... 517.605593: rtcpu_vinotify_event: tstamp:16817562394 cch:0 vi:0 tag:ATOMP_FE channel:0x00 frame:31593 vi_tstamp:538145512288 data:0x0000000800000000
kworker/1:7-141 [001] .... 517.605593: rtcpu_vinotify_event: tstamp:16817562527 cch:0 vi:0 tag:VIFALC_ACTIONLST channel:0x23 frame:31593 vi_tstamp:538145600000 data:0x0000000000020003
kworker/1:7-141 [001] .... 517.605593: rtcpu_vinotify_event: tstamp:16817562677 cch:0 vi:0 tag:FS channel:0x00 frame:31594 vi_tstamp:538146164032 data:0x00007b6a00000010
kworker/1:7-141 [001] .... 517.605594: rtcpu_vinotify_event: tstamp:16817562812 cch:0 vi:0 tag:ATOMP_FS channel:0x00 frame:31594 vi_tstamp:538146164128 data:0x0000000800000000
kworker/1:7-141 [001] .... 517.605594: rtcpu_vinotify_event: tstamp:16817562962 cch:0 vi:0 tag:CHANSEL_PXL_SOF channel:0x23 frame:31594 vi_tstamp:538146178976 data:0x0000000000000001
kworker/1:7-141 [001] .... 517.605594: rtcpu_vinotify_event: tstamp:16817563095 cch:0 vi:0 tag:VIFALC_ACTIONLST channel:0x23 frame:31594 vi_tstamp:538146206176 data:0x0000000008020004
kworker/1:7-141 [001] .... 517.605594: rtcpu_vinotify_event: tstamp:16818104688 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:538163805696 data:0x759d580010000000
kworker/1:7-141 [001] .... 517.605594: rtcpu_vinotify_event: tstamp:16818104824 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:538163849056 data:0x0000000031000005
kworker/1:7-141 [001] .... 520.249521: rtcpu_vinotify_event: tstamp:16900570707 cch:-1 vi:0 tag:FE channel:0x00 frame:31594 vi_tstamp:540806927232 data:0x0000000000000020
kworker/1:7-141 [001] .... 520.249531: rtcpu_vinotify_event: tstamp:16900570847 cch:-1 vi:0 tag:CHANSEL_SHORT_FRAME channel:0x01 frame:31594 vi_tstamp:540806927232 data:0x0053200001000000
kworker/1:7-141 [001] .... 520.249531: rtcpu_vinotify_event: tstamp:16900571004 cch:-1 vi:0 tag:ATOMP_FE channel:0x00 frame:31594 vi_tstamp:540806927328 data:0x0000000800000000
kworker/1:7-141 [001] .... 520.249531: rtcpu_vinotify_event: tstamp:16901397213 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:540844563872 data:0x759d580010000000
kworker/1:7-141 [001] .... 520.249532: rtcpu_vinotify_event: tstamp:16901397371 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:540844606560 data:0x0000000031000001
kworker/1:7-141 [001] .... 520.249532: rtcpu_vinotify_event: tstamp:16901397507 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:540844624224 data:0x759d550010000000
kworker/1:7-141 [001] .... 520.305523: rtcpu_vinotify_event: tstamp:16901927817 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:540844794560 data:0x0000000031000002
kworker/1:7-141 [001] .... 523.109460: rtcpu_vinotify_event: tstamp:16989818299 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:543660599488 data:0x759d580010000000
kworker/1:7-141 [001] .... 523.109471: rtcpu_vinotify_event: tstamp:16989818456 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:543660642144 data:0x0000000031000001
kworker/1:7-141 [001] .... 523.109472: rtcpu_vinotify_event: tstamp:16989818594 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:543660659840 data:0x759d550010000000
kworker/1:7-141 [001] .... 523.109472: rtcpu_vinotify_event: tstamp:16989818748 cch:0 vi:0 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:543660720192 data:0x0000000031000002
Checking if able to configure lt6911c output by lower speed.
The FAE said LT6911C cannot transmit video in LP mode.
BTW, about this clock rate “NVCSILP clock rate = 408000000 Hz”, He said the normal clock frequency of 1080P60 should be 460MHz.
It’s NVCSI logic working clock.
Looks like the MIPI clock should be 460*2 instead of 600
I tried changing the clock, but the video capture didn’t improve.
In addition, I have two Orin nx core boards, one of which unable to capture video (only image or green screen), and the other can only capture 19201080 video (only green screen at other resolutions).
Capture the 1920 1080, 1280*720 resolution logs as follows
trace_1920x1080.txt (1.2 MB)
trace_1280x720.txt (263.4 KB)
The following figure shows how to connect the LT6911c to the core board.
And the device tree I modified with reference to TX2 NX (
tegra186-camera-e2832.txt (10.5 KB)
)is as follows:
tegra234-camera-e2832.txt (12.3 KB)
Hi ShaneCCC!
Can you check it for me? I have no idea. ToT
Hi h1994213 ,
Have you tried setting the set_mode_delay_ms
property in the device tree, and also increase the system clock frequencies in same test?
Best,
Juan Diego Delgado
Embedded SW Engineer at RidgeRun
Contact us: support@ridgerun.com
Developers wiki: https://developer.ridgerun.com
Website: www.ridgerun.com
The trace log from 720p tell the lane control error.
jdiegodelgado:
set_mode_delay_ms
Hi jdiegodelgado,
Thanks for your advice. However, I set set_mode_delay_ms
to 1, 10, 100 and this did not work.
And I don’t even find the use of this property in the source files.
Hi ShaneCCC,
Yes, I have also noticed this message, how can I solve it? Why doesn’t 1080p have this problem. Previously used on the TX2 NX, it can normally capture multiple resolutions of video.
When it comes to camera drivers, I’m still a blank. Thank you for your patience.
Please boost the clocks to try.
sudo su
echo 1 > /sys/kernel/debug/bpmp/debug/clk/vi/mrq_rate_locked
echo 1 > /sys/kernel/debug/bpmp/debug/clk/isp/mrq_rate_locked
echo 1 > /sys/kernel/debug/bpmp/debug/clk/nvcsi/mrq_rate_locked
echo 1 > /sys/kernel/debug/bpmp/debug/clk/emc/mrq_rate_locked
cat /sys/kernel/debug/bpmp/debug/clk/vi/max_rate |tee /sys/kernel/debug/bpmp/debug/clk/vi/rate
cat /sys/kernel/debug/bpmp/debug/clk/isp/max_rate | tee /sys/kernel/debug/bpmp/debug/clk/isp/rate
cat /sys/kernel/debug/bpmp/debug/clk/nvcsi/max_rate | tee /sys/kernel/debug/bpmp/debug/clk/nvcsi/rate
cat /sys/kernel/debug/bpmp/debug/clk/emc/max_rate | tee /sys/kernel/debug/bpmp/debug/clk/emc/rate
Hi ShaneCCC,
Boosting the clocks didn’t help. The log is the same as before the clock was raised.
trace_log.txt (13.0 MB)
OK, if still the lane ctrl error that could be the output signal problem.
This error report due to CIL detects LP state 01 or 10 followed by a top state(LP11) instead of transitioning.
Correct sequence should be LP11->LP01->LP00->LP11
Hi ShaneCCC
I measured the mipi clock lane waveform, as shown below, and the data lane is similar.
sudo su
echo "file csi5_fops.c +p" > /sys/kernel/debug/dynamic_debug/control
echo "file sensor_common.c +p" > /sys/kernel/debug/dynamic_debug/control
echo "file deskew.c +p" > /sys/kernel/debug/dynamic_debug/control
After enabling dynamic debugging of nvcsi driver, I noticed that “mode not listed in DT, use default” when capturing 1280*720 resolution video.
[ 2107.017500] t194-nvcsi 13e40000.host1x:nvcsi@15a00000: csi5_start_streaming: csi_pt=0, st_id=0, vc_id=0, pg_mode=0x0
[ 2107.021134] t194-nvcsi 13e40000.host1x:nvcsi@15a00000: csi5_stream_set_config: stream_id=0, csi_port=0
[ 2107.021136] t194-nvcsi 13e40000.host1x:nvcsi@15a00000: cil_settingtime is pulled from device
[ 2107.021138] t194-nvcsi 13e40000.host1x:nvcsi@15a00000: mode not listed in DT, use default
I still don’t know why Non-1920x1080’s mode is not valid, eg:1280*720. For now, I justed modified nvidia/drivers/media/platform/tegra/camera/nvcsi/csi5_fops.c and it worked.
204 static int csi5_stream_set_config(struct tegra_csi_channel *chan, u32 stream_id,
205 u32 csi_port, int csi_lanes)
206 {
207 struct tegra_csi_device *csi = chan->csi;
208 struct tegra_channel *tegra_chan =
209 v4l2_get_subdev_hostdata(&chan->subdev);
210
211 struct camera_common_data *s_data = chan->s_data;
212 const struct sensor_mode_properties *mode = NULL;
213
214 unsigned int cil_settletime = 0;
215 unsigned int lane_polarity = 0;
216 unsigned int index = 0;
217 int vi_port = 0;
218
219 struct CAPTURE_CONTROL_MSG msg;
220 struct nvcsi_brick_config brick_config;
221 struct nvcsi_cil_config cil_config;
222 u32 phy_mode = read_phy_mode_from_dt(chan);
223 bool is_cphy = (phy_mode == CSI_PHY_MODE_CPHY);
224 dev_dbg(csi->dev, "%s: stream_id=%u, csi_port=%u\n",
225 __func__, stream_id, csi_port);
226
227 /* Attempt to find the brick config from the device tree */
228 if (s_data) {
229 int idx = s_data->mode_prop_idx;
230
231 dev_dbg(csi->dev, "cil_settingtime is pulled from device");
232 if (idx < s_data->sensor_props.num_modes) {
233 mode = &s_data->sensor_props.sensor_modes[idx];
234 cil_settletime = mode->signal_properties.cil_settletime;
235 lane_polarity = mode->signal_properties.lane_polarity;
236 } else {
237 dev_dbg(csi->dev, "mode not listed in DT, use default");
238 cil_settletime = 0;
239 - lane_polarity = 0;
239 + lane_polarity = 6;
240 }
Hi ShaneCCC,
I have another question here.
One of two “the other can only capture 1920x1080 video” can work well after setting default “lane_polarity = 6”. I numbered it Orin_NX_no1, and the other core board Orin_NX_no2.
On the same carrier board, the no1 can capture video normally, while no2 is abnormal.
I suspect there is something wrong with the core board. Is there any way to test it?
The capture logs of the two core boards are as follows:
dynamic_debug_1920x1080_Orin_NX_no1.txt (68.5 KB)
dynamic_debug_1920x1080_Orin_NX_no2.txt (19.8 KB)
trace_1920x1080_Orin_NX_no1.txt (233.3 KB)
trace_1920x1080_Orin_NX_no2.txt (21.1 KB)
Ignore the “Data lane [A/B] FIFO overflow”, which appears only at the beginning of the capture.