Problems capturing image CHANSEL_SHORT_FRAME and PXL_SOF

I checked and it works on the camera that came with the TX2, so I changed the registry correctly.
When I try to capture an image through a serializer deserializer then I don’t get any NLINES events, so it looks like TX2 doesn’t get any strings. I have already tried TRIPLINE = 1, also no event.
What could be the reasons why TX2 does not receive strings?
Also, when using the complete camera, I saw SOF and FS events in the trace, in the case of a serializer deserializer, I do not receive such events, does this mean that TX2 does not receive SOF?
Why may TX2 not receive SOF?
I probed the mipi signal with an oscilloscope, the signal is good.

I got the tag:CHANSEL_NLINES in trace log when programming the REG as 0x3000100,
Don’t have idea why TX2 didn’t receive SOF, it could be others error block it.

     kworker/5:3-1997  [005] ....   223.576936: rtcpu_vinotify_event: tstamp:7351457853 tag:CHANSEL_NLINES channel:0x00 frame:28 vi_tstamp:7351457269 data:0x03ff0010
     kworker/5:3-1997  [005] ....   223.576944: rtcpu_vinotify_event: tstamp:7351592252 tag:CHANSEL_NLINES channel:0x00 frame:28 vi_tstamp:7351591669 data:0x04ff0010
     kworker/5:3-1997  [005] ....   223.576950: rtcpu_vinotify_event: tstamp:7351726658 tag:CHANSEL_NLINES channel:0x00 frame:28 vi_tstamp:7351726069 data:0x05ff0010
     kworker/5:3-1997  [005] ....   223.576955: rtcpu_vinotify_event: tstamp:7351861051 tag:CHANSEL_NLINES channel:0x00 frame:28 vi_tstamp:7351860470 data:0x06ff0010
     kworker/5:3-1997  [005] ....   223.576960: rtcpu_vinotify_event: tstamp:7351941271 tag:CHANSEL_PXL_EOF channel:0x00 frame:28 vi_tstamp:7351940270 data:0x07970002
     kworker/5:3-1997  [005] ....   223.576965: rtcpu_vinotify_event: tstamp:7351941787 tag:FE channel:0x00 frame:28 vi_tstamp:7351940305 data:0x00000020
     kworker/5:3-1997  [005] ....   223.576970: rtcpu_vinotify_event: tstamp:7351942277 tag:ATOMP_FE channel:0x00 frame:28 vi_tstamp:7351940310 data:0x00000000
     kworker/5:3-1997  [005] ....   223.576975: rtcpu_vinotify_event: tstamp:7351958209 tag:FS channel:0x00 frame:29 vi_tstamp:7351957661 data:0x00000010
     kworker/5:3-1997  [005] ....   223.576980: rtcpu_vinotify_event: tstamp:7351961998 tag:CHANSEL_PXL_SOF channel:0x00 frame:29 vi_tstamp:7351961309 data:0x00000001
     kworker/5:3-1997  [005] ....   223.576985: rtcpu_vinotify_event: tstamp:7351962654 tag:ATOMP_FS channel:0x00 frame:29 vi_tstamp:7351961316 data:0x00000000
     kworker/5:3-1997  [005] ....   223.576990: rtcpu_vinotify_event: tstamp:7352096259 tag:CHANSEL_NLINES channel:0x00 frame:29 vi_tstamp:7352095669 data:0x00ff0010
     kworker/5:3-1997  [005] ....   223.576995: rtcpu_vinotify_event: tstamp:7352230654 tag:CHANSEL_NLINES channel:0x00 frame:29 vi_tstamp:7352230070 data:0x01ff0010
     kworker/5:3-1997  [005] ....   223.577000: rtcpu_vinotify_event: tstamp:7352365081 tag:CHANSEL_NLINES channel:0x00 frame:29 vi_tstamp:7352364470 data:0x02ff0010
     kworker/5:3-1997  [005] ....   223.577007: rtcpu_vinotify_event: tstamp:7352499476 tag:CHANSEL_NLINES channel:0x00 frame:29 vi_tstamp:7352498871 data:0x03ff0010
     kworker/5:3-1997  [005] ....   223.577012: rtcpu_vinotify_event: tstamp:7352633878 tag:CHANSEL_NLINES channel:0x00 frame:29 vi_tstamp:7352633270 data:0x04ff0010

Now I’m stuck on this trace:

tracer: nop

entries-in-buffer/entries-written: 1073/1073 #P:4

_-----=> irqs-off

/ _----=> need-resched

| / _—=> hardirq/softirq

|| / _–=> preempt-depth

||| / delay

TASK-PID CPU# |||| TIMESTAMP FUNCTION

| | | |||| | |

 kworker/5:1-1587  [005] ....    58.207988: rtos_queue_peek_from_isr_failed: tstamp:2214924382 queue:0x0b4b4500
 kworker/5:1-1587  [005] ....    58.375847: rtos_queue_peek_from_isr_failed: tstamp:2219924519 queue:0x0b4b4500
 kworker/5:1-1587  [005] ....    58.543828: rtos_queue_peek_from_isr_failed: tstamp:2224924525 queue:0x0b4b4500
 kworker/5:1-1587  [005] ....    58.711939: rtos_queue_peek_from_isr_failed: tstamp:2229924537 queue:0x0b4b4500
 kworker/5:1-1587  [005] ....    58.879835: rtos_queue_peek_from_isr_failed: tstamp:2234924537 queue:0x0b4b4500
 kworker/5:1-1587  [005] ....    58.991828: rtos_queue_peek_from_isr_failed: tstamp:2239924544 queue:0x0b4b4500
 kworker/5:1-1587  [005] ....    59.159910: rtos_queue_peek_from_isr_failed: tstamp:2244924359 queue:0x0b4b4500
 kworker/5:1-1587  [005] ....    59.327860: rtos_queue_peek_from_isr_failed: tstamp:2249924558 queue:0x0b4b4500
 kworker/5:1-1587  [005] ....    59.495832: rtos_queue_peek_from_isr_failed: tstamp:2254924571 queue:0x0b4b4500
 kworker/5:1-1587  [005] ....    59.663852: rtos_queue_peek_from_isr_failed: tstamp:2259924577 queue:0x0b4b4500
 kworker/5:1-1587  [005] ....    59.831823: rtos_queue_peek_from_isr_failed: tstamp:2264924579 queue:0x0b4b4500
 kworker/5:1-1587  [005] ....    59.999844: rtos_queue_peek_from_isr_failed: tstamp:2269924595 queue:0x0b4b4500
 kworker/5:1-1587  [005] ....    60.111833: rtos_queue_peek_from_isr_failed: tstamp:2274924595 queue:0x0b4b4500
 kworker/5:1-1587  [005] ....    60.279804: rtos_queue_peek_from_isr_failed: tstamp:2279924605 queue:0x0b4b4500
 kworker/5:1-1587  [005] ....    60.447824: rtos_queue_peek_from_isr_failed: tstamp:2284924603 queue:0x0b4b4500
 kworker/5:1-1587  [005] ....    60.615820: rtos_queue_peek_from_isr_failed: tstamp:2289924610 queue:0x0b4b4500
 kworker/5:1-1587  [005] ....    60.783780: rtos_queue_peek_from_isr_failed: tstamp:2294924629 queue:0x0b4b4500
 kworker/5:1-1587  [005] ....    60.951825: rtos_queue_peek_from_isr_failed: tstamp:2299924631 queue:0x0b4b4500
 kworker/5:1-1587  [005] ....    61.119817: rtos_queue_peek_from_isr_failed: tstamp:2304924637 queue:0x0b4b4500
 kworker/5:1-1587  [005] ....    61.231817: rtos_queue_peek_from_isr_failed: tstamp:2309924887 queue:0x0b4b4500
 kworker/5:1-1587  [005] ....    61.399820: rtos_queue_peek_from_isr_failed: tstamp:2314924639 queue:0x0b4b4500
 kworker/5:1-1587  [005] ....    61.567823: rtos_queue_peek_from_isr_failed: tstamp:2319924659 queue:0x0b4b4500
 kworker/5:1-1587  [005] ....    61.735874: rtos_queue_peek_from_isr_failed: tstamp:2324924657 queue:0x0b4b4500
 kworker/5:1-1587  [005] ....    61.903822: rtos_queue_peek_from_isr_failed: tstamp:2329924672 queue:0x0b4b4500
 kworker/5:1-1587  [005] ....    62.071844: rtos_queue_peek_from_isr_failed: tstamp:2334924673 queue:0x0b4b4500
 kworker/5:1-1587  [005] ....    62.239785: rtos_queue_peek_from_isr_failed: tstamp:2339924673 queue:0x0b4b4500
 kworker/5:1-1587  [005] ....    62.351842: rtos_queue_peek_from_isr_failed: tstamp:2344924693 queue:0x0b4b4500
 kworker/5:1-1587  [005] ....    62.519820: rtos_queue_peek_from_isr_failed: tstamp:2349924692 queue:0x0b4b4500
 kworker/5:1-1587  [005] ....    62.687851: rtos_queue_peek_from_isr_failed: tstamp:2354924707 queue:0x0b4b4500
 kworker/5:1-1587  [005] ....    62.855838: rtos_queue_peek_from_isr_failed: tstamp:2359924706 queue:0x0b4b4500
 kworker/5:1-1587  [005] ....    63.023816: rtos_queue_peek_from_isr_failed: tstamp:2364924708 queue:0x0b4b4500
 kworker/5:1-1587  [005] ....    63.079808: rtos_queue_peek_from_isr_failed: tstamp:2367138322 queue:0x0b4b4500
    v4l2-ctl-8385  [000] ....    73.184312: tegra_channel_open: vi-output, imx390 30-001b
    v4l2-ctl-8385  [000] ....    73.185723: tegra_channel_set_power: imx390 30-001b : 0x1
    v4l2-ctl-8385  [000] ....    73.185740: camera_common_s_power: status : 0x1
    v4l2-ctl-8385  [000] ....    73.186236: tegra_channel_set_power: 150c0000.nvcsi--3 : 0x1
    v4l2-ctl-8385  [000] ....    73.186240: csi_s_power: enable : 0x1
    v4l2-ctl-8385  [000] ....    73.197582: tegra_channel_capture_setup: vnc_id 0 W 640 H 512 fmt 20

vi-output, imx3-8386 [003] … 73.197725: tegra_channel_set_stream: enable : 0x1
vi-output, imx3-8386 [000] … 73.201814: tegra_channel_set_stream: 150c0000.nvcsi–3 : 0x1
vi-output, imx3-8386 [000] … 73.201818: csi_s_stream: enable : 0x1
vi-output, imx3-8386 [000] … 73.201882: tegra_channel_set_stream: imx390 30-001b : 0x1
kworker/5:1-1587 [005] … 73.219727: rtos_queue_peek_from_isr_failed: tstamp:2683995092 queue:0x0b4b4500
kworker/5:1-1587 [005] … 73.219734: rtcpu_start: tstamp:2683996351
kworker/5:1-1587 [005] … 73.219737: rtos_queue_send_from_isr_failed: tstamp:2684057787 queue:0x0b4a7258
kworker/5:1-1587 [005] … 73.219739: rtos_queue_send_from_isr_failed: tstamp:2684057940 queue:0x0b4aad68
kworker/5:1-1587 [005] … 73.219741: rtos_queue_send_from_isr_failed: tstamp:2684058080 queue:0x0b4ac998
kworker/5:1-1587 [005] … 73.219742: rtos_queue_send_from_isr_failed: tstamp:2684058221 queue:0x0b4ae518
kworker/5:1-1587 [005] … 73.219744: rtos_queue_send_from_isr_failed: tstamp:2684058360 queue:0x0b4af2d8
kworker/5:1-1587 [005] … 73.219745: rtos_queue_send_from_isr_failed: tstamp:2684058497 queue:0x0b4b0098
kworker/5:1-1587 [005] … 73.219747: rtos_queue_send_from_isr_failed: tstamp:2684058635 queue:0x0b4b0e58
kworker/5:1-1587 [005] … 73.219749: rtos_queue_send_from_isr_failed: tstamp:2684058772 queue:0x0b4b1c18
kworker/5:1-1587 [005] … 73.219751: rtos_queue_send_failed: tstamp:2684059410 queue:0x0b4a7258
kworker/5:1-1587 [005] … 73.219753: rtos_queue_send_from_isr_failed: tstamp:2684061744 queue:0x0b4a7258
kworker/5:1-1587 [005] … 73.219755: rtos_queue_send_from_isr_failed: tstamp:2684061884 queue:0x0b4aad68
kworker/5:1-1587 [005] … 73.219756: rtos_queue_send_from_isr_failed: tstamp:2684062026 queue:0x0b4ac998
kworker/5:1-1587 [005] … 73.219758: rtos_queue_send_from_isr_failed: tstamp:2684062164 queue:0x0b4ae518
kworker/5:1-1587 [005] … 73.219759: rtos_queue_send_from_isr_failed: tstamp:2684062302 queue:0x0b4af2d8
kworker/5:1-1587 [005] … 73.219761: rtos_queue_send_from_isr_failed: tstamp:2684062439 queue:0x0b4b0098
kworker/5:1-1587 [005] … 73.219763: rtos_queue_send_from_isr_failed: tstamp:2684062578 queue:0x0b4b0e58
kworker/5:1-1587 [005] … 73.219764: rtos_queue_send_from_isr_failed: tstamp:2684062719 queue:0x0b4b1c18
kworker/5:1-1587 [005] … 73.219766: rtos_queue_send_failed: tstamp:2684064164 queue:0x0b4a7258
kworker/5:1-1587 [005] … 73.275732: rtcpu_vinotify_event: tstamp:2686358740 tag:CHANSEL_SHORT_FRAME channel:0x01 frame:0 vi_tstamp:2686358148 data:0x00000001
kworker/5:1-1587 [005] … 73.275735: rtcpu_vinotify_event: tstamp:2686358920 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:2686358148 data:0x00000001
kworker/5:1-1587 [005] … 73.387803: rtos_queue_peek_from_isr_failed: tstamp:2688995448 queue:0x0b4b4500
vi-output, imx3-8386 [004] … 73.456840: tegra_channel_capture_setup: vnc_id 0 W 640 H 512 fmt 20
vi-output, imx3-8386 [004] … 73.456884: tegra_channel_capture_frame: sof:-549620695332.-267565218816
kworker/5:1-1587 [005] … 73.499783: rtos_queue_send_from_isr_failed: tstamp:2692145178 queue:0x0b4a7258
kworker/5:1-1587 [005] … 73.499791: rtos_queue_send_from_isr_failed: tstamp:2692145325 queue:0x0b4aad68
kworker/5:1-1587 [005] … 73.499795: rtos_queue_send_from_isr_failed: tstamp:2692145465 queue:0x0b4ac998
kworker/5:1-1587 [005] … 73.499797: rtos_queue_send_from_isr_failed: tstamp:2692145606 queue:0x0b4ae518
kworker/5:1-1587 [005] … 73.499800: rtos_queue_send_from_isr_failed: tstamp:2692145744 queue:0x0b4af2d8
kworker/5:1-1587 [005] … 73.499802: rtos_queue_send_from_isr_failed: tstamp:2692145882 queue:0x0b4b0098
kworker/5:1-1587 [005] … 73.499805: rtos_queue_send_from_isr_failed: tstamp:2692146020 queue:0x0b4b0e58
kworker/5:1-1587 [005] … 73.499807: rtos_queue_send_from_isr_failed: tstamp:2692146157 queue:0x0b4b1c18
kworker/5:1-1587 [005] … 73.499811: rtos_queue_send_failed: tstamp:2692146902 queue:0x0b4a7258
kworker/5:1-1587 [005] … 73.499813: rtos_queue_send_from_isr_failed: tstamp:2692150228 queue:0x0b4a7258
kworker/5:1-1587 [005] … 73.499816: rtos_queue_send_from_isr_failed: tstamp:2692150370 queue:0x0b4aad68
kworker/5:1-1587 [005] … 73.499818: rtos_queue_send_from_isr_failed: tstamp:2692150510 queue:0x0b4ac998
kworker/5:1-1587 [005] … 73.499821: rtos_queue_send_from_isr_failed: tstamp:2692150665 queue:0x0b4ae518
kworker/5:1-1587 [005] … 73.499823: rtos_queue_send_from_isr_failed: tstamp:2692150802 queue:0x0b4af2d8
kworker/5:1-1587 [005] … 73.499826: rtos_queue_send_from_isr_failed: tstamp:2692150940 queue:0x0b4b0098
kworker/5:1-1587 [005] … 73.499828: rtos_queue_send_from_isr_failed: tstamp:2692151077 queue:0x0b4b0e58
kworker/5:1-1587 [005] … 73.499830: rtos_queue_send_from_isr_failed: tstamp:2692151214 queue:0x0b4b1c18
kworker/5:1-1587 [005] … 73.499833: rtos_queue_send_failed: tstamp:2692151793 queue:0x0b4a7258
kworker/5:1-1587 [005] … 73.499835: rtos_queue_send_from_isr_failed: tstamp:2692159438 queue:0x0b4a7258
kworker/5:1-1587 [005] … 73.499838: rtos_queue_send_from_isr_failed: tstamp:2692159578 queue:0x0b4aad68
kworker/5:1-1587 [005] … 73.499840: rtos_queue_send_from_isr_failed: tstamp:2692159717 queue:0x0b4ac998
kworker/5:1-1587 [005] … 73.499842: rtos_queue_send_from_isr_failed: tstamp:2692159857 queue:0x0b4ae518
kworker/5:1-1587 [005] … 73.499845: rtos_queue_send_from_isr_failed: tstamp:2692159994 queue:0x0b4af2d8
kworker/5:1-1587 [005] … 73.499847: rtos_queue_send_from_isr_failed: tstamp:2692160133 queue:0x0b4b0098
kworker/5:1-1587 [005] … 73.499849: rtos_queue_send_from_isr_failed: tstamp:2692160270 queue:0x0b4b0e58
kworker/5:1-1587 [005] … 73.499852: rtos_queue_send_from_isr_failed: tstamp:2692160408 queue:0x0b4b1c18
kworker/5:1-1587 [005] … 73.499854: rtos_queue_send_failed: tstamp:2692160980 queue:0x0b4a7258
kworker/5:1-1587 [005] … 73.499857: rtos_queue_send_from_isr_failed: tstamp:2692163507 queue:0x0b4a7258
kworker/5:1-1587 [005] … 73.499859: rtos_queue_send_from_isr_failed: tstamp:2692163669 queue:0x0b4aad68
kworker/5:1-1587 [005] … 73.499862: rtos_queue_send_from_isr_failed: tstamp:2692163810 queue:0x0b4ac998
kworker/5:1-1587 [005] … 73.499864: rtos_queue_send_from_isr_failed: tstamp:2692163949 queue:0x0b4ae518
kworker/5:1-1587 [005] … 73.499866: rtos_queue_send_from_isr_failed: tstamp:2692164088 queue:0x0b4af2d8
kworker/5:1-1587 [005] … 73.499869: rtos_queue_send_from_isr_failed: tstamp:2692164226 queue:0x0b4b0098
kworker/5:1-1587 [005] … 73.499871: rtos_queue_send_from_isr_failed: tstamp:2692164364 queue:0x0b4b0e58
kworker/5:1-1587 [005] … 73.499873: rtos_queue_send_from_isr_failed: tstamp:2692164503 queue:0x0b4b1c18
kworker/5:1-1587 [005] … 73.499876: rtos_queue_send_failed: tstamp:2692165937 queue:0x0b4a7258
kworker/5:1-1587 [005] … 73.499880: rtcpu_vinotify_event: tstamp:2692208159 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2692207765 data:0x00000001
kworker/5:1-1587 [005] … 73.555781: rtcpu_vinotify_event: tstamp:2693603892 tag:CHANSEL_SHORT_FRAME channel:0x01 frame:0 vi_tstamp:2693603297 data:0x00000001
kworker/5:1-1587 [005] … 73.555786: rtcpu_vinotify_event: tstamp:2693604069 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:2693603298 data:0x00000001
kworker/5:1-1587 [005] … 73.555790: rtos_queue_peek_from_isr_failed: tstamp:2693995461 queue:0x0b4b4500
vi-output, imx3-8386 [005] … 73.676694: tegra_channel_capture_setup: vnc_id 0 W 640 H 512 fmt 20
vi-output, imx3-8386 [005] … 73.676738: tegra_channel_capture_frame: sof:-549620695332.-267565218816
kworker/5:2-4273 [005] … 73.679764: rtos_queue_peek_from_isr_failed: tstamp:2698995466 queue:0x0b4b4500
kworker/5:2-4273 [005] … 73.679769: rtos_queue_send_from_isr_failed: tstamp:2699014851 queue:0x0b4a7258
kworker/5:2-4273 [005] … 73.679771: rtos_queue_send_from_isr_failed: tstamp:2699014995 queue:0x0b4aad68
kworker/5:2-4273 [005] … 73.679772: rtos_queue_send_from_isr_failed: tstamp:2699015136 queue:0x0b4ac998
kworker/5:2-4273 [005] … 73.679774: rtos_queue_send_from_isr_failed: tstamp:2699015280 queue:0x0b4ae518
kworker/5:2-4273 [005] … 73.679775: rtos_queue_send_from_isr_failed: tstamp:2699015419 queue:0x0b4af2d8
kworker/5:2-4273 [005] … 73.679777: rtos_queue_send_from_isr_failed: tstamp:2699015556 queue:0x0b4b0098
kworker/5:2-4273 [005] … 73.679778: rtos_queue_send_from_isr_failed: tstamp:2699015694 queue:0x0b4b0e58
kworker/5:2-4273 [005] … 73.679779: rtos_queue_send_from_isr_failed: tstamp:2699015831 queue:0x0b4b1c18
kworker/5:2-4273 [005] … 73.679782: rtos_queue_send_failed: tstamp:2699016547 queue:0x0b4a7258
kworker/5:2-4273 [005] … 73.679784: rtos_queue_send_from_isr_failed: tstamp:2699019423 queue:0x0b4a7258
kworker/5:2-4273 [005] … 73.679785: rtos_queue_send_from_isr_failed: tstamp:2699019562 queue:0x0b4aad68
kworker/5:2-4273 [005] … 73.679787: rtos_queue_send_from_isr_failed: tstamp:2699019702 queue:0x0b4ac998
kworker/5:2-4273 [005] … 73.679788: rtos_queue_send_from_isr_failed: tstamp:2699019842 queue:0x0b4ae518
kworker/5:2-4273 [005] … 73.679790: rtos_queue_send_from_isr_failed: tstamp:2699019979 queue:0x0b4af2d8
kworker/5:2-4273 [005] … 73.679791: rtos_queue_send_from_isr_failed: tstamp:2699020118 queue:0x0b4b0098
kworker/5:2-4273 [005] … 73.679793: rtos_queue_send_from_isr_failed: tstamp:2699020255 queue:0x0b4b0e58
kworker/5:2-4273 [005] … 73.679794: rtos_queue_send_from_isr_failed: tstamp:2699020396 queue:0x0b4b1c18
kworker/5:2-4273 [005] … 73.679795: rtos_queue_send_failed: tstamp:2699020957 queue:0x0b4a7258
kworker/5:2-4273 [005] … 73.679797: rtos_queue_send_from_isr_failed: tstamp:2699028950 queue:0x0b4a7258
kworker/5:2-4273 [005] … 73.679798: rtos_queue_send_from_isr_failed: tstamp:2699029100 queue:0x0b4aad68
kworker/5:2-4273 [005] … 73.679800: rtos_queue_send_from_isr_failed: tstamp:2699029240 queue:0x0b4ac998
kworker/5:2-4273 [005] … 73.679801: rtos_queue_send_from_isr_failed: tstamp:2699029383 queue:0x0b4ae518
kworker/5:2-4273 [005] … 73.679803: rtos_queue_send_from_isr_failed: tstamp:2699029522 queue:0x0b4af2d8
kworker/5:2-4273 [005] … 73.679805: rtos_queue_send_from_isr_failed: tstamp:2699029660 queue:0x0b4b0098
kworker/5:2-4273 [005] … 73.679806: rtos_queue_send_from_isr_failed: tstamp:2699029803 queue:0x0b4b0e58
kworker/5:2-4273 [005] … 73.679807: rtos_queue_send_from_isr_failed: tstamp:2699029940 queue:0x0b4b1c18
kworker/5:2-4273 [005] … 73.679809: rtos_queue_send_failed: tstamp:2699030525 queue:0x0b4a7258
kworker/5:2-4273 [005] … 73.679810: rtos_queue_send_from_isr_failed: tstamp:2699033837 queue:0x0b4a7258
kworker/5:2-4273 [005] … 73.679812: rtos_queue_send_from_isr_failed: tstamp:2699033976 queue:0x0b4aad68
kworker/5:2-4273 [005] … 73.679814: rtos_queue_send_from_isr_failed: tstamp:2699034113 queue:0x0b4ac998
kworker/5:2-4273 [005] … 73.679815: rtos_queue_send_from_isr_failed: tstamp:2699034252 queue:0x0b4ae518
kworker/5:2-4273 [005] … 73.679817: rtos_queue_send_from_isr_failed: tstamp:2699034389 queue:0x0b4af2d8
kworker/5:2-4273 [005] … 73.679818: rtos_queue_send_from_isr_failed: tstamp:2699034527 queue:0x0b4b0098
kworker/5:2-4273 [005] … 73.679820: rtos_queue_send_from_isr_failed: tstamp:2699034664 queue:0x0b4b0e58
kworker/5:2-4273 [005] … 73.679822: rtos_queue_send_from_isr_failed: tstamp:2699034803 queue:0x0b4b1c18
kworker/5:2-4273 [005] … 73.679823: rtos_queue_send_failed: tstamp:2699036207 queue:0x0b4a7258
kworker/5:2-4273 [005] … 73.679829: rtcpu_vinotify_event: tstamp:2699037679 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2699036879 data:0x00000001
kworker/5:1-1587 [005] … 73.735779: rtcpu_vinotify_event: tstamp:2700124524 tag:CHANSEL_SHORT_FRAME channel:0x01 frame:0 vi_tstamp:2700123932 data:0x00000001
kworker/5:1-1587 [005] … 73.735787: rtcpu_vinotify_event: tstamp:2700124706 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:2700123932 data:0x00000001
kworker/5:1-1587 [005] … 73.847824: rtos_queue_peek_from_isr_failed: tstamp:2703995474 queue:0x0b4b4500
vi-output, imx3-8386 [005] … 73.896730: tegra_channel_capture_setup: vnc_id 0 W 640 H 512 fmt 20
vi-output, imx3-8386 [005] … 73.896770: tegra_channel_capture_frame: sof:-549620695332.-267565218816
kworker/5:1-1587 [005] … 73.903736: rtos_queue_send_from_isr_failed: tstamp:2705894031 queue:0x0b4a7258
kworker/5:1-1587 [005] … 73.903739: rtos_queue_send_from_isr_failed: tstamp:2705894180 queue:0x0b4aad68
kworker/5:1-1587 [005] … 73.903740: rtos_queue_send_from_isr_failed: tstamp:2705894321 queue:0x0b4ac998
kworker/5:1-1587 [005] … 73.903742: rtos_queue_send_from_isr_failed: tstamp:2705894461 queue:0x0b4ae518
kworker/5:1-1587 [005] … 73.903743: rtos_queue_send_from_isr_failed: tstamp:2705894599 queue:0x0b4af2d8
kworker/5:1-1587 [005] … 73.903744: rtos_queue_send_from_isr_failed: tstamp:2705894735 queue:0x0b4b0098
kworker/5:1-1587 [005] … 73.903745: rtos_queue_send_from_isr_failed: tstamp:2705894872 queue:0x0b4b0e58
kworker/5:1-1587 [005] … 73.903746: rtos_queue_send_from_isr_failed: tstamp:2705895014 queue:0x0b4b1c18
kworker/5:1-1587 [005] … 73.903749: rtos_queue_send_failed: tstamp:2705895758 queue:0x0b4a7258
kworker/5:1-1587 [005] … 73.903750: rtos_queue_send_from_isr_failed: tstamp:2705898709 queue:0x0b4a7258
kworker/5:1-1587 [005] … 73.903751: rtos_queue_send_from_isr_failed: tstamp:2705898849 queue:0x0b4aad68
kworker/5:1-1587 [005] … 73.903752: rtos_queue_send_from_isr_failed: tstamp:2705899009 queue:0x0b4ac998
kworker/5:1-1587 [005] … 73.903753: rtos_queue_send_from_isr_failed: tstamp:2705899149 queue:0x0b4ae518
kworker/5:1-1587 [005] … 73.903754: rtos_queue_send_from_isr_failed: tstamp:2705899286 queue:0x0b4af2d8
kworker/5:1-1587 [005] … 73.903755: rtos_queue_send_from_isr_failed: tstamp:2705899425 queue:0x0b4b0098
kworker/5:1-1587 [005] … 73.903756: rtos_queue_send_from_isr_failed: tstamp:2705899565 queue:0x0b4b0e58
kworker/5:1-1587 [005] … 73.903757: rtos_queue_send_from_isr_failed: tstamp:2705899702 queue:0x0b4b1c18
kworker/5:1-1587 [005] … 73.903758: rtos_queue_send_failed: tstamp:2705900265 queue:0x0b4a7258
kworker/5:1-1587 [005] … 73.903759: rtos_queue_send_from_isr_failed: tstamp:2705906795 queue:0x0b4a7258
kworker/5:1-1587 [005] … 73.903760: rtos_queue_send_from_isr_failed: tstamp:2705906935 queue:0x0b4aad68
kworker/5:1-1587 [005] … 73.903761: rtos_queue_send_from_isr_failed: tstamp:2705907075 queue:0x0b4ac998
kworker/5:1-1587 [005] … 73.903762: rtos_queue_send_from_isr_failed: tstamp:2705907215 queue:0x0b4ae518
kworker/5:1-1587 [005] … 73.903763: rtos_queue_send_from_isr_failed: tstamp:2705907353 queue:0x0b4af2d8
kworker/5:1-1587 [005] … 73.903764: rtos_queue_send_from_isr_failed: tstamp:2705907490 queue:0x0b4b0098
kworker/5:1-1587 [005] … 73.903765: rtos_queue_send_from_isr_failed: tstamp:2705907629 queue:0x0b4b0e58
kworker/5:1-1587 [005] … 73.903766: rtos_queue_send_from_isr_failed: tstamp:2705907766 queue:0x0b4b1c18
kworker/5:1-1587 [005] … 73.903767: rtos_queue_send_failed: tstamp:2705908349 queue:0x0b4a7258
kworker/5:1-1587 [005] … 73.903768: rtos_queue_send_from_isr_failed: tstamp:2705910434 queue:0x0b4a7258
kworker/5:1-1587 [005] … 73.903769: rtos_queue_send_from_isr_failed: tstamp:2705910574 queue:0x0b4aad68
kworker/5:1-1587 [005] … 73.903770: rtos_queue_send_from_isr_failed: tstamp:2705910713 queue:0x0b4ac998
kworker/5:1-1587 [005] … 73.903771: rtos_queue_send_from_isr_failed: tstamp:2705910851 queue:0x0b4ae518
kworker/5:1-1587 [005] … 73.903772: rtos_queue_send_from_isr_failed: tstamp:2705910990 queue:0x0b4af2d8
kworker/5:1-1587 [005] … 73.903773: rtos_queue_send_from_isr_failed: tstamp:2705911127 queue:0x0b4b0098
kworker/5:1-1587 [005] … 73.903774: rtos_queue_send_from_isr_failed: tstamp:2705911265 queue:0x0b4b0e58
kworker/5:1-1587 [005] … 73.903775: rtos_queue_send_from_isr_failed: tstamp:2705911402 queue:0x0b4b1c18
kworker/5:1-1587 [005] … 73.903776: rtos_queue_send_failed: tstamp:2705912796 queue:0x0b4a7258
kworker/5:1-1587 [005] … 73.903779: rtcpu_vinotify_event: tstamp:2705914245 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2705913190 data:0x00000001
kworker/5:1-1587 [005] … 73.959797: rtcpu_vinotify_event: tstamp:2706645155 tag:CHANSEL_SHORT_FRAME channel:0x01 frame:0 vi_tstamp:2706644566 data:0x00000001
kworker/5:1-1587 [005] … 73.959802: rtcpu_vinotify_event: tstamp:2706645331 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:2706644566 data:0x00000001
kworker/5:1-1587 [005] … 74.015781: rtos_queue_peek_from_isr_failed: tstamp:2708995470 queue:0x0b4b4500
vi-output, imx3-8386 [005] … 74.117036: tegra_channel_capture_setup: vnc_id 0 W 640 H 512 fmt 20
vi-output, imx3-8386 [005] … 74.117147: tegra_channel_capture_frame: sof:-549620695332.-267565218816
kworker/5:1-1587 [005] … 74.127708: rtos_queue_send_from_isr_failed: tstamp:2712766678 queue:0x0b4a7258
kworker/5:1-1587 [005] … 74.127710: rtos_queue_send_from_isr_failed: tstamp:2712766845 queue:0x0b4aad68
kworker/5:1-1587 [005] … 74.127711: rtos_queue_send_from_isr_failed: tstamp:2712767007 queue:0x0b4ac998
kworker/5:1-1587 [005] … 74.127712: rtos_queue_send_from_isr_failed: tstamp:2712767147 queue:0x0b4ae518

System log:

[ 73.185760] imx390 30-001b: camera_common_mclk_enable: enable MCLK with 24000000 Hz
[ 73.186226] imx390 30-001b: camera_common_dpd_disable: csi 0
[ 73.186233] imx390 30-001b: imx390_power_on: power on
[ 73.187830] nvcsi 150c0000.nvcsi: csi_port: 0
[ 73.188018] nvcsi 150c0000.nvcsi: csi_port: 2
[ 73.188192] nvcsi 150c0000.nvcsi: csi_port: 4
[ 73.189392] imx390 30-001b: camera_common_try_fmt: size 640 x 512
[ 73.189403] imx390 30-001b: camera_common_try_fmt: use_sensor_mode_id 0
[ 73.189419] imx390 30-001b: camera_common_s_fmt(12303) size 640 x 512
[ 73.189429] imx390 30-001b: camera_common_try_fmt: size 640 x 512
[ 73.189435] imx390 30-001b: camera_common_try_fmt: use_sensor_mode_id 0
[ 73.197572] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[ 73.197614] tegra-vi4 15700000.vi: Create Surface with imgW=640, imgH=512, memFmt=32
[ 73.201828] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[ 73.201835] nvcsi 150c0000.nvcsi: csi4_stream_init
[ 73.201847] nvcsi 150c0000.nvcsi: csi4_stream_config
[ 73.201856] nvcsi 150c0000.nvcsi: csi4_stream_config (0) read VC0_DPCM_CTRL = 00000000
[ 73.201859] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 73.201864] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[ 73.201871] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 833
[ 73.201874] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[ 73.201877] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 18
[ 73.204555] max9296 30-0048: max9296_setup_pipeline: No mapping for GMSL_CSI_DT_UED_U1
[ 73.439844] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 73.446482] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 73.456424] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[ 73.456432] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 73.456440] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000002
[ 73.456449] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[ 73.456463] nvcsi 150c0000.nvcsi: csi4_cil_check_status 398
[ 73.456472] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[ 73.456477] nvcsi 150c0000.nvcsi: csi4_stream_init
[ 73.456490] nvcsi 150c0000.nvcsi: csi4_stream_config
[ 73.456500] nvcsi 150c0000.nvcsi: csi4_stream_config (0) read VC0_DPCM_CTRL = 00000000
[ 73.456505] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 73.456512] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[ 73.456521] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 833
[ 73.456526] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[ 73.456532] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 18
[ 73.456833] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[ 73.456871] tegra-vi4 15700000.vi: Create Surface with imgW=640, imgH=512, memFmt=32
[ 73.659844] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 73.666335] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 73.676250] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[ 73.676258] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 73.676266] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000002
[ 73.676274] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[ 73.676289] nvcsi 150c0000.nvcsi: csi4_cil_check_status 398
[ 73.676297] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[ 73.676301] nvcsi 150c0000.nvcsi: csi4_stream_init
[ 73.676314] nvcsi 150c0000.nvcsi: csi4_stream_config
[ 73.676325] nvcsi 150c0000.nvcsi: csi4_stream_config (0) read VC0_DPCM_CTRL = 00000000
[ 73.676329] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 73.676336] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[ 73.676346] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 833
[ 73.676351] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[ 73.676357] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 18
[ 73.676688] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[ 73.676726] tegra-vi4 15700000.vi: Create Surface with imgW=640, imgH=512, memFmt=32
[ 73.879810] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 73.886289] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 73.896352] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[ 73.896360] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 73.896368] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000002
[ 73.896376] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[ 73.896389] nvcsi 150c0000.nvcsi: csi4_cil_check_status 398
[ 73.896396] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[ 73.896400] nvcsi 150c0000.nvcsi: csi4_stream_init
[ 73.896412] nvcsi 150c0000.nvcsi: csi4_stream_config
[ 73.896423] nvcsi 150c0000.nvcsi: csi4_stream_config (0) read VC0_DPCM_CTRL = 00000000
[ 73.896426] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 73.896432] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[ 73.896441] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 833
[ 73.896446] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[ 73.896450] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 18
[ 73.896723] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[ 73.896759] tegra-vi4 15700000.vi: Create Surface with imgW=640, imgH=512, memFmt=32
[ 74.099816] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 74.106351] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 74.116487] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[ 74.116516] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 74.116526] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000002
[ 74.116535] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[ 74.116550] nvcsi 150c0000.nvcsi: csi4_cil_check_status 398
[ 74.116560] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[ 74.116565] nvcsi 150c0000.nvcsi: csi4_stream_init
[ 74.116610] nvcsi 150c0000.nvcsi: csi4_stream_config
[ 74.116622] nvcsi 150c0000.nvcsi: csi4_stream_config (0) read VC0_DPCM_CTRL = 00000000
[ 74.116627] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 74.116634] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[ 74.116645] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 833
[ 74.116651] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[ 74.116658] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 18
[ 74.117024] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[ 74.117082] tegra-vi4 15700000.vi: Create Surface with imgW=640, imgH=512, memFmt=32
[ 74.319804] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 74.326306] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 74.336420] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[ 74.336447] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 74.336456] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000002
[ 74.336464] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[ 74.336478] nvcsi 150c0000.nvcsi: csi4_cil_check_status 398
[ 74.336488] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[ 74.336493] nvcsi 150c0000.nvcsi: csi4_stream_init
[ 74.336506] nvcsi 150c0000.nvcsi: csi4_stream_config
[ 74.336548] nvcsi 150c0000.nvcsi: csi4_stream_config (0) read VC0_DPCM_CTRL = 00000000
[ 74.336553] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 74.336561] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[ 74.336572] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 833
[ 74.336577] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[ 74.336583] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 18
[ 74.336906] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[ 74.336945] tegra-vi4 15700000.vi: Create Surface with imgW=640, imgH=512, memFmt=32
[ 74.539829] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 74.546324] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 74.556165] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[ 74.556173] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 74.556181] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000002
[ 74.556188] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[ 74.556201] nvcsi 150c0000.nvcsi: csi4_cil_check_status 398
[ 74.556208] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[ 74.556212] nvcsi 150c0000.nvcsi: csi4_stream_init
[ 74.556223] nvcsi 150c0000.nvcsi: csi4_stream_config
[ 74.556233] nvcsi 150c0000.nvcsi: csi4_stream_config (0) read VC0_DPCM_CTRL = 00000000
[ 74.556236] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 74.556241] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[ 74.556250] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 833
[ 74.556254] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[ 74.556258] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 18
[ 74.556542] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[ 74.556578] tegra-vi4 15700000.vi: Create Surface with imgW=640, imgH=512, memFmt=32
[ 74.759811] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 74.766273] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 74.776340] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[ 74.776350] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 74.776360] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000002
[ 74.776370] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[ 74.776385] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) INTR_STATUS 0x00000004
[ 74.784286] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERR_INTR_STATUS 0x00000004
[ 74.792584] nvcsi 150c0000.nvcsi: csi4_cil_check_status 398
[ 74.792593] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[ 74.792597] nvcsi 150c0000.nvcsi: csi4_stream_init
[ 74.792609] nvcsi 150c0000.nvcsi: csi4_stream_config
[ 74.792620] nvcsi 150c0000.nvcsi: csi4_stream_config (0) read VC0_DPCM_CTRL = 00000000
[ 74.792624] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 74.792631] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[ 74.792640] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 833
[ 74.792645] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[ 74.792650] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 18
[ 74.792902] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[ 74.792932] tegra-vi4 15700000.vi: Create Surface with imgW=640, imgH=512, memFmt=32
[ 74.995876] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 75.002344] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 75.012364] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[ 75.012372] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 75.012382] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000002
[ 75.012391] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[ 75.012406] nvcsi 150c0000.nvcsi: csi4_cil_check_status 398
[ 75.012415] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[ 75.012421] nvcsi 150c0000.nvcsi: csi4_stream_init
[ 75.012434] nvcsi 150c0000.nvcsi: csi4_stream_config
[ 75.012445] nvcsi 150c0000.nvcsi: csi4_stream_config (0) read VC0_DPCM_CTRL = 00000000
[ 75.012450] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 75.012458] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[ 75.012470] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 833
[ 75.012475] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[ 75.012481] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 18
[ 75.012965] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[ 75.013021] tegra-vi4 15700000.vi: Create Surface with imgW=640, imgH=512, memFmt=32
[ 75.215810] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 75.222274] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 75.232258] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[ 75.232266] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 75.232275] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000002
[ 75.232283] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[ 75.232298] nvcsi 150c0000.nvcsi: csi4_cil_check_status 398
[ 75.232306] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[ 75.232311] nvcsi 150c0000.nvcsi: csi4_stream_init
[ 75.232323] nvcsi 150c0000.nvcsi: csi4_stream_config
[ 75.232333] nvcsi 150c0000.nvcsi: csi4_stream_config (0) read VC0_DPCM_CTRL = 00000000
[ 75.232338] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 75.232344] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[ 75.232354] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 833
[ 75.232359] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[ 75.232365] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 18
[ 75.232681] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[ 75.232719] tegra-vi4 15700000.vi: Create Surface with imgW=640, imgH=512, memFmt=32
[ 75.435715] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 75.442107] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 75.452071] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[ 75.452076] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 75.452082] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000002
[ 75.452087] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[ 75.452098] nvcsi 150c0000.nvcsi: csi4_cil_check_status 398
[ 75.452103] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[ 75.452106] nvcsi 150c0000.nvcsi: csi4_stream_init
[ 75.452115] nvcsi 150c0000.nvcsi: csi4_stream_config
[ 75.452123] nvcsi 150c0000.nvcsi: csi4_stream_config (0) read VC0_DPCM_CTRL = 00000000
[ 75.452125] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 75.452129] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[ 75.452135] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 833
[ 75.452138] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[ 75.452141] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 18
[ 75.452315] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[ 75.452344] tegra-vi4 15700000.vi: Create Surface with imgW=640, imgH=512, memFmt=32
[ 75.655825] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 75.662290] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 75.672314] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[ 75.672322] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 75.672331] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000002
[ 75.672339] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[ 75.672354] nvcsi 150c0000.nvcsi: csi4_cil_check_status 398
[ 75.672362] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[ 75.672368] nvcsi 150c0000.nvcsi: csi4_stream_init
[ 75.672380] nvcsi 150c0000.nvcsi: csi4_stream_config
[ 75.672392] nvcsi 150c0000.nvcsi: csi4_stream_config (0) read VC0_DPCM_CTRL = 00000000
[ 75.672396] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 75.672403] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[ 75.672414] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 833
[ 75.672419] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[ 75.672424] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 18
[ 75.672771] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[ 75.672810] tegra-vi4 15700000.vi: Create Surface with imgW=640, imgH=512, memFmt=32
[ 75.875808] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 75.882396] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 75.892421] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[ 75.892430] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 75.892441] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000002
[ 75.892450] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[ 75.892466] nvcsi 150c0000.nvcsi: csi4_cil_check_status 398
[ 75.892475] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[ 75.892481] nvcsi 150c0000.nvcsi: csi4_stream_init
[ 75.892494] nvcsi 150c0000.nvcsi: csi4_stream_config
[ 75.892506] nvcsi 150c0000.nvcsi: csi4_stream_config (0) read VC0_DPCM_CTRL = 00000000
[ 75.892511] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 75.892519] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[ 75.892530] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 833
[ 75.892536] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[ 75.892542] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 18
[ 75.892860] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[ 75.892901] tegra-vi4 15700000.vi: Create Surface with imgW=640, imgH=512, memFmt=32
[ 76.095733] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 76.102315] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 76.113105] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[ 76.113110] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 76.113115] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000002
[ 76.113121] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[ 76.113132] nvcsi 150c0000.nvcsi: csi4_cil_check_status 398
[ 76.113138] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[ 76.113140] nvcsi 150c0000.nvcsi: csi4_stream_init
[ 76.113149] nvcsi 150c0000.nvcsi: csi4_stream_config
[ 76.113157] nvcsi 150c0000.nvcsi: csi4_stream_config (0) read VC0_DPCM_CTRL = 00000000
[ 76.113159] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 76.113163] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[ 76.113170] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 833
[ 76.113172] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[ 76.113175] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 18
[ 76.113362] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[ 76.113393] tegra-vi4 15700000.vi: Create Surface with imgW=640, imgH=512, memFmt=32
[ 76.315712] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 76.322084] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 76.331917] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[ 76.331922] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 76.331928] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000002
[ 76.331934] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[ 76.331944] nvcsi 150c0000.nvcsi: csi4_cil_check_status 398
[ 76.331950] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[ 76.331952] nvcsi 150c0000.nvcsi: csi4_stream_init
[ 76.331962] nvcsi 150c0000.nvcsi: csi4_stream_config
[ 76.331969] nvcsi 150c0000.nvcsi: csi4_stream_config (0) read VC0_DPCM_CTRL = 00000000
[ 76.331971] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 76.331975] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[ 76.331982] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 833
[ 76.331984] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[ 76.331987] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 18
[ 76.332204] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[ 76.332234] tegra-vi4 15700000.vi: Create Surface with imgW=640, imgH=512, memFmt=32
[ 76.539721] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 76.546106] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 76.555878] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[ 76.555882] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 76.555888] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000002
[ 76.555893] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[ 76.555904] nvcsi 150c0000.nvcsi: csi4_cil_check_status 398
[ 76.555910] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[ 76.555912] nvcsi 150c0000.nvcsi: csi4_stream_init
[ 76.555921] nvcsi 150c0000.nvcsi: csi4_stream_config
[ 76.555929] nvcsi 150c0000.nvcsi: csi4_stream_config (0) read VC0_DPCM_CTRL = 00000000
[ 76.555931] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 76.555935] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[ 76.555942] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 833
[ 76.555944] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[ 76.555947] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 18
[ 76.556142] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[ 76.556172] tegra-vi4 15700000.vi: Create Surface with imgW=640, imgH=512, memFmt=32
[ 76.759801] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 76.766238] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel

Could these errors be caused by incorrect virtual channel settings?
In tracing, all 3 errors have different channel designations (channel: 0x00 / 0x01 / 0xff), which means the “channel:” extension in the trace? Does this apply to virtual channels?
Any ideas where to go next?

Doesn’t matter with the channel.
Only clue is the embedded data short frame.

short frame or short packet?
how do i control what is fine with the embedded data short frame?

It’s short frame means the output embedded data line less than embedded_metadata_height in DTS.

now embedded_metadata_height = “0” ;, I experimented with different values 0/1/2/10 others, it does not change the trace.
is it really possible to set the number of rows of embedded data to less than 0?

Not possible for negative value. Could you add code to print it to confirm it.

Do you need a dts code or the entire driver code?
dts:

/ {
host1x {
vi@15700000 {
num-channels = <3>;
ports {
#address-cells = <1>;
#size-cells = <0>;
port@0 {
reg = <0>;
imx390_vi_in0: endpoint {

  				port-index = <0>;
  				bus-width = <2>;
  				remote-endpoint = <&imx390_csi_out0>;
  			};
  		};
  		port@1 {
  			reg = <1>;
  			imx390_vi_in1: endpoint {
  			
  				port-index = <2>;
  				bus-width = <2>;
  				remote-endpoint = <&imx390_csi_out1>;
  			};
  		};
  		port@2 {
  			reg = <2>;
  			imx390_vi_in2: endpoint {
  			
  				port-index = <4>;
  				bus-width = <2>;
  				remote-endpoint = <&imx390_csi_out2>;
  			};
  		};

  	};
  };

  nvcsi@150c0000 {
  	num-channels = <3>;
  	#address-cells = <1>;
  	#size-cells = <0>;
  	channel@0 {
  		reg = <0>;
  		ports {
  			#address-cells = <1>;
  			#size-cells = <0>;
  			port@0 {
  				reg = <0>;
  				imx390_csi_in0: endpoint@0 {
  					port-index = <0>;
  					bus-width = <2>;
  					remote-endpoint = <&imx390_imx390_out0>;
  				};
  			};
  			port@1 {
  				reg = <1>;
  				imx390_csi_out0: endpoint@1 {
  					remote-endpoint = <&imx390_vi_in0>;
  				};
  			};
  		};
  	};

  	channel@1 {
  		reg = <1>;
  		ports {
  			#address-cells = <1>;
  			#size-cells = <0>;
  			port@0 {
  				reg = <0>;
  				imx390_csi_in1: endpoint@2 {
  					port-index = <2>;
  					bus-width = <2>;
  					remote-endpoint = <&imx390_imx390_out1>;
  				};
  			};
  			port@1 {
  				reg = <1>;
  				imx390_csi_out1: endpoint@3 {
  					remote-endpoint = <&imx390_vi_in1>;
  				};
  			};
  		};
  	};

  	channel@2 {
  		reg = <2>;
  		ports {
  			#address-cells = <1>;
  			#size-cells = <0>;
  			port@0 {
  				reg = <0>;
  				imx390_csi_in2: endpoint@4 {
  					port-index = <4>;
  					bus-width = <2>;
  					remote-endpoint = <&imx390_imx390_out2>;
  				};
  			};
  			port@1 {
  				reg = <1>;
  				imx390_csi_out2: endpoint@5 {
  					remote-endpoint = <&imx390_vi_in2>;
  				};
  			};
  		};
  	};

  };

};

i2c@3180000 {
tca9546@70 {
i2c@0 {
imx390_a@1b {
compatible = “nvidia,imx390”;

  		reg = <0x1b>;
  		reg_mux = <0>;
  		/* Physical dimensions of sensor */
  		physical_w = "15.0";
  		physical_h = "12.5";

  		sensor_model ="imx390";

  		/* Defines number of frames to be dropped by driver internally after applying */
  		/* sensor crop settings. Some sensors send corrupt frames after applying */
  		/* crop co-ordinates */
  		post_crop_frame_drop = "0";

  		/* Convert Gain to unit of dB (decibel) befor passing to kernel driver */
  		use_decibel_gain = "true";

  		/* enable CID_SENSOR_MODE_ID for sensor modes selection */
  		use_sensor_mode_id = "true";

  		/**
  		* A modeX node is required to support v4l2 driver
  		* implementation with NVIDIA camera software stack
  		*
  		* mclk_khz = "";
  		* Standard MIPI driving clock, typically 24MHz
  		*
  		* num_lanes = "";
  		* Number of lane channels sensor is programmed to output
  		*
  		* tegra_sinterface = "";
  		* The base tegra serial interface lanes are connected to
  		*
  		* vc_id = "";
  		* The virtual channel id of the sensor.
  		*
  		* discontinuous_clk = "";
  		* The sensor is programmed to use a discontinuous clock on MIPI lanes
  		*
  		* dpcm_enable = "true";
  		* The sensor is programmed to use a DPCM modes
  		*
  		* cil_settletime = "";
  		* MIPI lane settle time value.
  		* A "0" value attempts to autocalibrate based on mclk_khz and pix_clk_hz
  		*
  		* active_w = "";
  		* Pixel active region width
  		*
  		* active_h = "";
  		* Pixel active region height
  		*
  		* dynamic_pixel_bit_depth = "";
  		* sensor dynamic bit depth for sensor mode
  		*
  		* csi_pixel_bit_depth = "";
  		* sensor output bit depth for sensor mode
  		*
  		* mode_type="";
  		* Sensor mode type, For eg: yuv, Rgb, bayer, bayer_wdr_pwl
  		*
  		* pixel_phase="";
  		* Pixel phase for sensor mode, For eg: rggb, vyuy, rgb888
  		*
  		* readout_orientation = "0";
  		* Based on camera module orientation.
  		* Only change readout_orientation if you specifically
  		* Program a different readout order for this mode
  		*
  		* line_length = "";
  		* Pixel line length (width) for sensor mode.
  		* This is used to calibrate features in our camera stack.
  		*
  		* pix_clk_hz = "";
  		* Sensor pixel clock used for calculations like exposure and framerate
  		*
  		*
  		*
  		*
  		* inherent_gain = "";
  		* Gain obtained inherently from mode (ie. pixel binning)
  		*
  		* min_gain_val = ""; (floor to 6 decimal places)
  		* max_gain_val = ""; (floor to 6 decimal places)
  		* Gain limits for mode
  		* if use_decibel_gain = "true", please set the gain as decibel
  		*
  		* min_exp_time = ""; (ceil to integer)
  		* max_exp_time = ""; (ceil to integer)
  		* Exposure Time limits for mode (us)
  		*
  		*
  		* min_hdr_ratio = "";
  		* max_hdr_ratio = "";
  		* HDR Ratio limits for mode
  		*
  		* min_framerate = "";
  		* max_framerate = "";
  		* Framerate limits for mode (fps)
  		*
  		* embedded_metadata_height = "";
  		* Sensor embedded metadata height in units of rows.
  		* If sensor does not support embedded metadata value should be 0.
  		*/

  		mode0 {/*mode IMX390_MODE_1920X1080_CROP_30FPS*/
  			mclk_khz = "24000";
  			num_lanes = "2";
  			tegra_sinterface = "serial_a";
  			vc_id = "0";
  			discontinuous_clk = "no";
  			dpcm_enable = "false";
  			cil_settletime = "0";
  			dynamic_pixel_bit_depth = "10";
  			csi_pixel_bit_depth = "10";
  			mode_type = "bayer";
  			pixel_phase = "rggb";

  			active_w = "640";
  			active_h = "512";
  			readout_orientation = "0";
  			line_length = "900";
  			inherent_gain = "1";
  			pix_clk_hz = "200000000";
  			serdes_pix_clk_hz = "833333333";

  			gain_factor = "10";
  			min_gain_val = "0"; /* dB */
  			max_gain_val = "300"; /* dB */
  			step_gain_val = "3"; /* 0.3 */
  			default_gain = "0";
  			min_hdr_ratio = "1";
  			max_hdr_ratio = "1";
  			framerate_factor = "1000000";
  			min_framerate = "30000000";
  			max_framerate = "60000000";
  			step_framerate = "1";
  			default_framerate = "50000000";
  			exposure_factor = "1000000";
  			min_exp_time = "59"; /*us, 2 lines*/
  			max_exp_time = "33333";
  			step_exp_time = "1";
  			default_exp_time = "33333";/* us */
  			embedded_metadata_height = "0";
  		};
  		ports {
  			#address-cells = <1>;
  			#size-cells = <0>;
  			port@0 {
  				reg = <0>;
  				imx390_imx390_out0: endpoint {
  					vc-id = <0>;
  					port-index = <0>;
  					bus-width = <2>;
  					remote-endpoint = <&imx390_csi_in0>;
  					};
  				};
  			};
  		gmsl-link {
  			src-csi-port = "b";
  			dst-csi-port = "a";
  			serdes-csi-link = "a";
  			csi-mode = "1x4";
  			st-vc = <0>;
  			vc-id = <0>;
  			num-lanes = <2>;
  			streams = "ued-u1", "raw12";
  			};
  		};
  	};
  	i2c@1 {
  	imx390_c@1b {
  		compatible = "nvidia,imx390";

  		reg = <0x1b>;
  		reg_mux = <1>;
  		/* Physical dimensions of sensor */
  		physical_w = "15.0";
  		physical_h = "12.5";

  		sensor_model ="imx390";

  		/* Defines number of frames to be dropped by driver internally after applying */
  		/* sensor crop settings. Some sensors send corrupt frames after applying */
  		/* crop co-ordinates */
  		post_crop_frame_drop = "0";

  		/* Convert Gain to unit of dB (decibel) befor passing to kernel driver */
  		use_decibel_gain = "true";

  		/* enable CID_SENSOR_MODE_ID for sensor modes selection */
  		use_sensor_mode_id = "true";

  		/**
  		* A modeX node is required to support v4l2 driver
  		* implementation with NVIDIA camera software stack
  		*
  		* mclk_khz = "";
  		* Standard MIPI driving clock, typically 24MHz
  		*
  		* num_lanes = "";
  		* Number of lane channels sensor is programmed to output
  		*
  		* tegra_sinterface = "";
  		* The base tegra serial interface lanes are connected to
  		*
  		* vc_id = "";
  		* The virtual channel id of the sensor.
  		*
  		* discontinuous_clk = "";
  		* The sensor is programmed to use a discontinuous clock on MIPI lanes
  		*
  		* dpcm_enable = "true";
  		* The sensor is programmed to use a DPCM modes
  		*
  		* cil_settletime = "";
  		* MIPI lane settle time value.
  		* A "0" value attempts to autocalibrate based on mclk_khz and pix_clk_hz
  		*
  		* active_w = "";
  		* Pixel active region width
  		*
  		* active_h = "";
  		* Pixel active region height
  		*
  		* dynamic_pixel_bit_depth = "";
  		* sensor dynamic bit depth for sensor mode
  		*
  		* csi_pixel_bit_depth = "";
  		* sensor output bit depth for sensor mode
  		*
  		* mode_type="";
  		* Sensor mode type, For eg: yuv, Rgb, bayer, bayer_wdr_pwl
  		*
  		* pixel_phase="";
  		* Pixel phase for sensor mode, For eg: rggb, vyuy, rgb888
  		*
  		* readout_orientation = "0";
  		* Based on camera module orientation.
  		* Only change readout_orientation if you specifically
  		* Program a different readout order for this mode
  		*
  		* line_length = "";
  		* Pixel line length (width) for sensor mode.
  		* This is used to calibrate features in our camera stack.
  		*
  		* pix_clk_hz = "";
  		* Sensor pixel clock used for calculations like exposure and framerate
  		*
  		*
  		*
  		*
  		* inherent_gain = "";
  		* Gain obtained inherently from mode (ie. pixel binning)
  		*
  		* min_gain_val = ""; (floor to 6 decimal places)
  		* max_gain_val = ""; (floor to 6 decimal places)
  		* Gain limits for mode
  		* if use_decibel_gain = "true", please set the gain as decibel
  		*
  		* min_exp_time = ""; (ceil to integer)
  		* max_exp_time = ""; (ceil to integer)
  		* Exposure Time limits for mode (us)
  		*
  		*
  		* min_hdr_ratio = "";
  		* max_hdr_ratio = "";
  		* HDR Ratio limits for mode
  		*
  		* min_framerate = "";
  		* max_framerate = "";
  		* Framerate limits for mode (fps)
  		*
  		* embedded_metadata_height = "";
  		* Sensor embedded metadata height in units of rows.
  		* If sensor does not support embedded metadata value should be 0.
  		*/

  		mode0 {/*mode IMX390_MODE_1920X1080_CROP_30FPS*/
  			mclk_khz = "24000";
  			num_lanes = "2";
  			tegra_sinterface = "serial_c";
  			vc_id = "0";
  			discontinuous_clk = "no";
  			dpcm_enable = "false";
  			cil_settletime = "0";
  			dynamic_pixel_bit_depth = "10";
  			csi_pixel_bit_depth = "10";
  			mode_type = "bayer";
  			pixel_phase = "rggb";

  			active_w = "1920";
  			active_h = "1080";
  			readout_orientation = "0";
  			line_length = "2200";
  			inherent_gain = "1";
  			pix_clk_hz = "74250000";
  			serdes_pix_clk_hz = "833333333";

  			gain_factor = "10";
  			min_gain_val = "0"; /* dB */
  			max_gain_val = "300"; /* dB */
  			step_gain_val = "3"; /* 0.3 */
  			default_gain = "0";
  			min_hdr_ratio = "1";
  			max_hdr_ratio = "1";
  			framerate_factor = "1000000";
  			min_framerate = "30000000";
  			max_framerate = "30000000";
  			step_framerate = "1";
  			default_framerate = "30000000";
  			exposure_factor = "1000000";
  			min_exp_time = "59"; /*us, 2 lines*/
  			max_exp_time = "33333";
  			step_exp_time = "1";
  			default_exp_time = "33333";/* us */
  			embedded_metadata_height = "0";
  		};
  		ports {
  			#address-cells = <1>;
  			#size-cells = <0>;
  			port@0 {
  				reg = <0>;
  				imx390_imx390_out1: endpoint {
  					vc-id = <0>;
  					port-index = <2>;
  					bus-width = <2>;
  					remote-endpoint = <&imx390_csi_in1>;
  					};
  				};
  			};
  		gmsl-link {
  			src-csi-port = "b";
  			dst-csi-port = "a";
  			serdes-csi-link = "a";
  			csi-mode = "1x4";
  			st-vc = <0>;
  			vc-id = <0>;
  			num-lanes = <2>;
  			streams = "ued-u1", "raw12";
  			};
  		};
  	};
  	i2c@2 {
  	imx390_e@1b {
  		compatible = "nvidia,imx390";

  		reg = <0x1b>;
  		reg_mux = <2>;
  		/* Physical dimensions of sensor */
  		physical_w = "15.0";
  		physical_h = "12.5";

  		sensor_model ="imx390";

  		/* Defines number of frames to be dropped by driver internally after applying */
  		/* sensor crop settings. Some sensors send corrupt frames after applying */
  		/* crop co-ordinates */
  		post_crop_frame_drop = "0";

  		/* Convert Gain to unit of dB (decibel) befor passing to kernel driver */
  		use_decibel_gain = "true";

  		/* enable CID_SENSOR_MODE_ID for sensor modes selection */
  		use_sensor_mode_id = "true";

  		/**
  		* A modeX node is required to support v4l2 driver
  		* implementation with NVIDIA camera software stack
  		*
  		* mclk_khz = "";
  		* Standard MIPI driving clock, typically 24MHz
  		*
  		* num_lanes = "";
  		* Number of lane channels sensor is programmed to output
  		*
  		* tegra_sinterface = "";
  		* The base tegra serial interface lanes are connected to
  		*
  		* vc_id = "";
  		* The virtual channel id of the sensor.
  		*
  		* discontinuous_clk = "";
  		* The sensor is programmed to use a discontinuous clock on MIPI lanes
  		*
  		* dpcm_enable = "true";
  		* The sensor is programmed to use a DPCM modes
  		*
  		* cil_settletime = "";
  		* MIPI lane settle time value.
  		* A "0" value attempts to autocalibrate based on mclk_khz and pix_clk_hz
  		*
  		* active_w = "";
  		* Pixel active region width
  		*
  		* active_h = "";
  		* Pixel active region height
  		*
  		* dynamic_pixel_bit_depth = "";
  		* sensor dynamic bit depth for sensor mode
  		*
  		* csi_pixel_bit_depth = "";
  		* sensor output bit depth for sensor mode
  		*
  		* mode_type="";
  		* Sensor mode type, For eg: yuv, Rgb, bayer, bayer_wdr_pwl
  		*
  		* pixel_phase="";
  		* Pixel phase for sensor mode, For eg: rggb, vyuy, rgb888
  		*
  		* readout_orientation = "0";
  		* Based on camera module orientation.
  		* Only change readout_orientation if you specifically
  		* Program a different readout order for this mode
  		*
  		* line_length = "";
  		* Pixel line length (width) for sensor mode.
  		* This is used to calibrate features in our camera stack.
  		*
  		* pix_clk_hz = "";
  		* Sensor pixel clock used for calculations like exposure and framerate
  		*
  		*
  		*
  		*
  		* inherent_gain = "";
  		* Gain obtained inherently from mode (ie. pixel binning)
  		*
  		* min_gain_val = ""; (floor to 6 decimal places)
  		* max_gain_val = ""; (floor to 6 decimal places)
  		* Gain limits for mode
  		* if use_decibel_gain = "true", please set the gain as decibel
  		*
  		* min_exp_time = ""; (ceil to integer)
  		* max_exp_time = ""; (ceil to integer)
  		* Exposure Time limits for mode (us)
  		*
  		*
  		* min_hdr_ratio = "";
  		* max_hdr_ratio = "";
  		* HDR Ratio limits for mode
  		*
  		* min_framerate = "";
  		* max_framerate = "";
  		* Framerate limits for mode (fps)
  		*
  		* embedded_metadata_height = "";
  		* Sensor embedded metadata height in units of rows.
  		* If sensor does not support embedded metadata value should be 0.
  		*/

  		mode0 {/*mode IMX390_MODE_1920X1080_CROP_30FPS*/
  			mclk_khz = "24000";
  			num_lanes = "2";
  			tegra_sinterface = "serial_e";
  			vc_id = "0";
  			discontinuous_clk = "no";
  			dpcm_enable = "false";
  			cil_settletime = "0";
  			dynamic_pixel_bit_depth = "10";
  			csi_pixel_bit_depth = "10";
  			mode_type = "bayer";
  			pixel_phase = "rggb";

  			active_w = "1920";
  			active_h = "1080";
  			readout_orientation = "0";
  			line_length = "2200";
  			inherent_gain = "1";
  			pix_clk_hz = "74250000";
  			serdes_pix_clk_hz = "833333333";

  			gain_factor = "10";
  			min_gain_val = "0"; /* dB */
  			max_gain_val = "300"; /* dB */
  			step_gain_val = "3"; /* 0.3 */
  			default_gain = "0";
  			min_hdr_ratio = "1";
  			max_hdr_ratio = "1";
  			framerate_factor = "1000000";
  			min_framerate = "30000000";
  			max_framerate = "30000000";
  			step_framerate = "1";
  			default_framerate = "30000000";
  			exposure_factor = "1000000";
  			min_exp_time = "59"; /*us, 2 lines*/
  			max_exp_time = "33333";
  			step_exp_time = "1";
  			default_exp_time = "33333";/* us */
  			embedded_metadata_height = "0";
  		};
  		ports {
  			#address-cells = <1>;
  			#size-cells = <0>;
  			port@0 {
  				reg = <0>;
  				imx390_imx390_out2: endpoint {
  					vc-id = <0>;
  					port-index = <4>;
  					bus-width = <2>;
  					remote-endpoint = <&imx390_csi_in2>;
  					};
  				};
  			};
  		gmsl-link {
  			src-csi-port = "b";
  			dst-csi-port = "a";
  			serdes-csi-link = "a";
  			csi-mode = "1x4";
  			st-vc = <0>;
  			vc-id = <0>;
  			num-lanes = <2>;
  			streams = "ued-u1", "raw12";
  			};
  		};
  	};
  };

};
};

/ {

tegra-camera-platform {
compatible = “nvidia, tegra-camera-platform”;
/**
* Physical settings to calculate max ISO BW
*
* num_csi_lanes = <>;
* Total number of CSI lanes when all cameras are active
*
* max_lane_speed = <>;
* Max lane speed in Kbit/s
*
* min_bits_per_pixel = <>;
* Min bits per pixel
*
* vi_peak_byte_per_pixel = <>;
* Max byte per pixel for the VI ISO case
*
* vi_bw_margin_pct = <>;
* Vi bandwidth margin in percentage
*
* max_pixel_rate = <>;
* Max pixel rate in Kpixel/s for the ISP ISO case
*
* isp_peak_byte_per_pixel = <>;
* Max byte per pixel for the ISP ISO case
*
* isp_bw_margin_pct = <>;
* Isp bandwidth margin in percentage
*/
num_csi_lanes = <6>;
max_lane_speed = <4000000>;
min_bits_per_pixel = <10>;
vi_peak_byte_per_pixel = <2>;
vi_bw_margin_pct = <25>;
isp_peak_byte_per_pixel = <5>;
isp_bw_margin_pct = <25>;

  /**
   * The general guideline for naming badge_info contains 3 parts, and is as follows,
   * The first part is the camera_board_id for the module; if the module is in a FFD
   * platform, then use the platform name for this part.
   * The second part contains the position of the module, ex. "rear" or "front".
   * The third part contains the last 6 characters of a part number which is found
   * in the module's specsheet from the vender.
   */
  modules {
  	module0 {
  		badge = "imx390_bottom";
  		position = "bottom";
  		orientation = "1";
  		drivernode0 {
  			/* Declare PCL support driver (classically known as guid)  */
  			pcl_id = "v4l2_sensor";
  			/* Driver v4l2 device name */
  			devname = "imx390 30-001b";
  			/* Declare the device-tree hierarchy to driver instance */
  			proc-device-tree = "/proc/device-tree/i2c@3180000/tca9546@70/i2c@0/imx390_a@1b";
  		};
  	};

  	module1 {
  		badge = "imx390_top";
  		position = "top";
  		orientation = "1";
  		drivernode0 {
  			/* Declare PCL support driver (classically known as guid)  */
  			pcl_id = "v4l2_sensor";
  			/* Driver v4l2 device name */
  			devname = "imx390 31-001b";
  			/* Declare the device-tree hierarchy to driver instance */
  			proc-device-tree = "/proc/device-tree/i2c@3180000/tca9546@70/i2c@1/imx390_c@1b";
  		};
  	};
  	module2 {
  		badge = "imx390_center";
  		position = "center";
  		orientation = "1";
  		drivernode0 {
  			/* Declare PCL support driver (classically known as guid)  */
  			pcl_id = "v4l2_sensor";
  			/* Driver v4l2 device name */
  			devname = "imx390 32-001b";
  			/* Declare the device-tree hierarchy to driver instance */
  			proc-device-tree = "/proc/device-tree/i2c@3180000/tca9546@70/i2c@2/imx390_e@1b";
  		};
  	};

  };

};
};

I’m trying to capture only imx390_a@1b.

I mean add print the embedded_metadata_height in vi4_fops.c to confirm it.

How to do it? please tell me which line or case I need to change and how. Or where can you find information about it?

In the vi4_fops.c add pr_info to check the chan->embedded_data_height

        vi4_channel_write(chan, vnc_id, LINE_TIMER, 0x1000000);
        if (chan->embedded_data_height > 0) {
                vi4_channel_write(chan, vnc_id, EMBED_X,
                        chan->embedded_data_width * BPP_MEM);
                vi4_channel_write(chan, vnc_id, EMBED_Y,
                        chan->embedded_data_height | EXPECT);
        } else {
                vi4_channel_write(chan, vnc_id, EMBED_X, 0);
                vi4_channel_write(chan, vnc_id, EMBED_Y, 0);
        }

Hi ShaneCCC,
Thanks for your reply.
Now part of vi4_fops.c looks like this:

vi4_channel_write(chan, vnc_id, LINE_TIMER, 0x3000001);
pr_info(“embedded_data_height = %d\n”, chan->embedded_data_height);
if (chan->embedded_data_height > 0) {
vi4_channel_write(chan, vnc_id, EMBED_X,
chan->embedded_data_width * BPP_MEM);
vi4_channel_write(chan, vnc_id, EMBED_Y,
chan->embedded_data_height | EXPECT);
} else {
vi4_channel_write(chan, vnc_id, EMBED_X, 0);
vi4_channel_write(chan, vnc_id, EMBED_Y, 0);
}

dmesg:

[ 50.554973] imx390 30-001b: camera_common_mclk_enable: enable MCLK with 24000000 Hz
[ 50.555469] imx390 30-001b: camera_common_dpd_disable: csi 0
[ 50.555474] imx390 30-001b: imx390_power_on: power on
[ 50.556742] nvcsi 150c0000.nvcsi: csi_port: 0
[ 50.556942] nvcsi 150c0000.nvcsi: csi_port: 2
[ 50.557103] nvcsi 150c0000.nvcsi: csi_port: 4
[ 50.558056] imx390 30-001b: camera_common_try_fmt: size 1280 x 1024
[ 50.558064] imx390 30-001b: camera_common_try_fmt: use_sensor_mode_id 0
[ 50.558077] imx390 30-001b: camera_common_s_fmt(12303) size 1280 x 1024
[ 50.558085] imx390 30-001b: camera_common_try_fmt: size 1280 x 1024
[ 50.558090] imx390 30-001b: camera_common_try_fmt: use_sensor_mode_id 0
[ 50.565183] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[ 50.565212] embedded_data_height = 0
[ 50.565220] tegra-vi4 15700000.vi: Create Surface with imgW=1280, imgH=1024, memFmt=32
[ 50.566822] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[ 50.566828] nvcsi 150c0000.nvcsi: csi4_stream_init
[ 50.566840] nvcsi 150c0000.nvcsi: csi4_stream_config
[ 50.566851] nvcsi 150c0000.nvcsi: csi4_stream_config (0) read VC0_DPCM_CTRL = 00000000
[ 50.566857] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 50.566864] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[ 50.566872] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 833
[ 50.566877] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[ 50.566882] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 18
[ 50.569543] max9296 30-0048: max9296_setup_pipeline: No mapping for GMSL_CSI_DT_UED_U1
[ 50.807338] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 50.813858] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 50.824002] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[ 50.824042] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 50.824051] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000002
[ 50.824060] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[ 50.824076] nvcsi 150c0000.nvcsi: csi4_cil_check_status 398
[ 50.824085] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[ 50.824091] nvcsi 150c0000.nvcsi: csi4_stream_init
[ 50.824182] nvcsi 150c0000.nvcsi: csi4_stream_config
[ 50.824196] nvcsi 150c0000.nvcsi: csi4_stream_config (0) read VC0_DPCM_CTRL = 00000000
[ 50.824200] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 50.824207] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[ 50.824216] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 833
[ 50.824221] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[ 50.824226] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 18
[ 50.824523] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[ 50.824552] embedded_data_height = 0
[ 50.824561] tegra-vi4 15700000.vi: Create Surface with imgW=1280, imgH=1024, memFmt=32
[ 50.824571] video4linux video0: tegra_channel_capture_frame_single_thread: vi4 got SOF syncpt buf[ffffffc1aade3c00]
[ 51.027344] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 51.033875] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 51.043963] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[ 51.043970] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 51.044006] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000002
[ 51.044015] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[ 51.044030] nvcsi 150c0000.nvcsi: csi4_cil_check_status 398
[ 51.044038] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[ 51.044043] nvcsi 150c0000.nvcsi: csi4_stream_init
[ 51.044056] nvcsi 150c0000.nvcsi: csi4_stream_config
[ 51.044107] nvcsi 150c0000.nvcsi: csi4_stream_config (0) read VC0_DPCM_CTRL = 00000000
[ 51.044112] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 51.044119] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[ 51.044128] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 833
[ 51.044133] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[ 51.044139] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 18
[ 51.044435] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[ 51.044466] embedded_data_height = 0
[ 51.044475] tegra-vi4 15700000.vi: Create Surface with imgW=1280, imgH=1024, memFmt=32
[ 51.044484] video4linux video0: tegra_channel_capture_frame_single_thread: vi4 got SOF syncpt buf[ffffffc1d5c0c000]
[ 51.247344] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 51.253845] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 51.263935] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[ 51.263942] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 51.263950] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000002
[ 51.263985] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[ 51.264000] nvcsi 150c0000.nvcsi: csi4_cil_check_status 398
[ 51.264007] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[ 51.264012] nvcsi 150c0000.nvcsi: csi4_stream_init
[ 51.264024] nvcsi 150c0000.nvcsi: csi4_stream_config
[ 51.264035] nvcsi 150c0000.nvcsi: csi4_stream_config (0) read VC0_DPCM_CTRL = 00000000
[ 51.264040] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 51.264088] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[ 51.264098] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 833
[ 51.264103] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[ 51.264109] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 18
[ 51.264441] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[ 51.264482] embedded_data_height = 0
[ 51.264567] tegra-vi4 15700000.vi: Create Surface with imgW=1280, imgH=1024, memFmt=32
[ 51.264587] video4linux video0: tegra_channel_capture_frame_single_thread: vi4 got SOF syncpt buf[ffffffc1d5c0d800]
[ 51.467341] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 51.473845] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 51.483941] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[ 51.483949] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 51.483957] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000002
[ 51.483965] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[ 51.483979] nvcsi 150c0000.nvcsi: csi4_cil_check_status 398
[ 51.483987] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[ 51.483992] nvcsi 150c0000.nvcsi: csi4_stream_init
[ 51.484004] nvcsi 150c0000.nvcsi: csi4_stream_config
[ 51.484015] nvcsi 150c0000.nvcsi: csi4_stream_config (0) read VC0_DPCM_CTRL = 00000000
[ 51.484020] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 51.484026] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[ 51.484036] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 833
[ 51.484040] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[ 51.484046] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 18
[ 51.484345] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[ 51.484378] embedded_data_height = 0
[ 51.484388] tegra-vi4 15700000.vi: Create Surface with imgW=1280, imgH=1024, memFmt=32
[ 51.484396] video4linux video0: tegra_channel_capture_frame_single_thread: vi4 got SOF syncpt buf[ffffffc1d5c0f400]
[ 51.687340] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 51.693803] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 51.703705] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[ 51.703713] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 51.703721] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000002
[ 51.703729] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[ 51.703743] nvcsi 150c0000.nvcsi: csi4_cil_check_status 398
[ 51.703751] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[ 51.703756] nvcsi 150c0000.nvcsi: csi4_stream_init
[ 51.703768] nvcsi 150c0000.nvcsi: csi4_stream_config
[ 51.703779] nvcsi 150c0000.nvcsi: csi4_stream_config (0) read VC0_DPCM_CTRL = 00000000
[ 51.703783] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 51.703790] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[ 51.703799] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 833
[ 51.703804] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[ 51.703810] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 18
[ 51.704142] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[ 51.704202] embedded_data_height = 0
[ 51.704234] tegra-vi4 15700000.vi: Create Surface with imgW=1280, imgH=1024, memFmt=32
[ 51.704265] video4linux video0: tegra_channel_capture_frame_single_thread: vi4 got SOF syncpt buf[ffffffc1aade3c00]
[ 51.907347] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 51.913812] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 51.923741] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[ 51.923751] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 51.923760] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000002
[ 51.923769] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[ 51.923785] nvcsi 150c0000.nvcsi: csi4_cil_check_status 398
[ 51.923794] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[ 51.923800] nvcsi 150c0000.nvcsi: csi4_stream_init
[ 51.923813] nvcsi 150c0000.nvcsi: csi4_stream_config
[ 51.923825] nvcsi 150c0000.nvcsi: csi4_stream_config (0) read VC0_DPCM_CTRL = 00000000
[ 51.923830] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 51.923837] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[ 51.923848] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 833
[ 51.923854] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[ 51.923860] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 18
[ 51.924260] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[ 51.924392] embedded_data_height = 0
[ 51.924415] tegra-vi4 15700000.vi: Create Surface with imgW=1280, imgH=1024, memFmt=32
[ 51.924492] video4linux video0: tegra_channel_capture_frame_single_thread: vi4 got SOF syncpt buf[ffffffc1d5c0c000]
[ 52.127493] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 52.134053] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 52.144373] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[ 52.144380] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 52.144387] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000002
[ 52.144395] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[ 52.144409] nvcsi 150c0000.nvcsi: csi4_cil_check_status 398
[ 52.144417] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[ 52.144421] nvcsi 150c0000.nvcsi: csi4_stream_init
[ 52.144432] nvcsi 150c0000.nvcsi: csi4_stream_config
[ 52.144442] nvcsi 150c0000.nvcsi: csi4_stream_config (0) read VC0_DPCM_CTRL = 00000000
[ 52.144446] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 52.144452] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[ 52.144461] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 833
[ 52.144465] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[ 52.144469] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 18
[ 52.144746] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[ 52.144773] embedded_data_height = 0
[ 52.144780] tegra-vi4 15700000.vi: Create Surface with imgW=1280, imgH=1024, memFmt=32
[ 52.144788] video4linux video0: tegra_channel_capture_frame_single_thread: vi4 got SOF syncpt buf[ffffffc1d5c0d800]
[ 52.347347] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 52.353887] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 52.363928] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[ 52.363936] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 52.363943] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000002
[ 52.363974] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[ 52.363988] nvcsi 150c0000.nvcsi: csi4_cil_check_status 398
[ 52.363996] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[ 52.364000] nvcsi 150c0000.nvcsi: csi4_stream_init
[ 52.364012] nvcsi 150c0000.nvcsi: csi4_stream_config
[ 52.364022] nvcsi 150c0000.nvcsi: csi4_stream_config (0) read VC0_DPCM_CTRL = 00000000
[ 52.364026] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 52.364069] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[ 52.364078] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 833
[ 52.364081] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[ 52.364086] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 18
[ 52.364363] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[ 52.364391] embedded_data_height = 0
[ 52.364398] tegra-vi4 15700000.vi: Create Surface with imgW=1280, imgH=1024, memFmt=32
[ 52.364405] video4linux video0: tegra_channel_capture_frame_single_thread: vi4 got SOF syncpt buf[ffffffc1d5c0f400]
[ 52.567358] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 52.573878] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 52.584507] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[ 52.584516] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 52.584526] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000002
[ 52.584535] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[ 52.584551] nvcsi 150c0000.nvcsi: csi4_cil_check_status 398
[ 52.584560] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[ 52.584565] nvcsi 150c0000.nvcsi: csi4_stream_init
[ 52.584578] nvcsi 150c0000.nvcsi: csi4_stream_config
[ 52.584590] nvcsi 150c0000.nvcsi: csi4_stream_config (0) read VC0_DPCM_CTRL = 00000000
[ 52.584594] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 52.584602] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[ 52.584613] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 833
[ 52.584618] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[ 52.584624] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 18
[ 52.584936] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[ 52.584968] embedded_data_height = 0
[ 52.584978] tegra-vi4 15700000.vi: Create Surface with imgW=1280, imgH=1024, memFmt=32
[ 52.584987] video4linux video0: tegra_channel_capture_frame_single_thread: vi4 got SOF syncpt buf[ffffffc1aade3c00]
[ 52.787359] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 52.793827] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 52.803802] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[ 52.803811] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 52.803819] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000002
[ 52.803827] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[ 52.803840] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) INTR_STATUS 0x00000004
[ 52.811757] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERR_INTR_STATUS 0x00000004
[ 52.820011] nvcsi 150c0000.nvcsi: csi4_cil_check_status 398
[ 52.820019] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[ 52.820024] nvcsi 150c0000.nvcsi: csi4_stream_init
[ 52.820045] nvcsi 150c0000.nvcsi: csi4_stream_config
[ 52.820057] nvcsi 150c0000.nvcsi: csi4_stream_config (0) read VC0_DPCM_CTRL = 00000000
[ 52.820063] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 52.820069] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[ 52.820080] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 833
[ 52.820085] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[ 52.820092] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 18
[ 52.820386] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[ 52.820415] embedded_data_height = 0
[ 52.820424] tegra-vi4 15700000.vi: Create Surface with imgW=1280, imgH=1024, memFmt=32
[ 52.820432] video4linux video0: tegra_channel_capture_frame_single_thread: vi4 got SOF syncpt buf[ffffffc1d5c0c000]
[ 53.023388] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 53.029848] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 53.039761] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[ 53.039769] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 53.039778] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000002
[ 53.039786] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[ 53.039800] nvcsi 150c0000.nvcsi: csi4_cil_check_status 398
[ 53.039808] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[ 53.039812] nvcsi 150c0000.nvcsi: csi4_stream_init
[ 53.039824] nvcsi 150c0000.nvcsi: csi4_stream_config
[ 53.039835] nvcsi 150c0000.nvcsi: csi4_stream_config (0) read VC0_DPCM_CTRL = 00000000
[ 53.039839] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 53.039846] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[ 53.039855] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 833
[ 53.039860] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[ 53.039865] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 18
[ 53.040172] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[ 53.040203] embedded_data_height = 0
[ 53.040213] tegra-vi4 15700000.vi: Create Surface with imgW=1280, imgH=1024, memFmt=32
[ 53.040221] video4linux video0: tegra_channel_capture_frame_single_thread: vi4 got SOF syncpt buf[ffffffc1d5c0d800]
[ 53.243342] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 53.249959] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 53.259906] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[ 53.259914] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 53.259922] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000002
[ 53.259931] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[ 53.259945] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) INTR_STATUS 0x00000004
[ 53.267929] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERR_INTR_STATUS 0x00000004
[ 53.276153] nvcsi 150c0000.nvcsi: csi4_cil_check_status 398
[ 53.276160] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[ 53.276163] nvcsi 150c0000.nvcsi: csi4_stream_init
[ 53.276174] nvcsi 150c0000.nvcsi: csi4_stream_config
[ 53.276183] nvcsi 150c0000.nvcsi: csi4_stream_config (0) read VC0_DPCM_CTRL = 00000000
[ 53.276186] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 53.276191] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[ 53.276199] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 833
[ 53.276202] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[ 53.276205] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 18
[ 53.276462] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[ 53.276487] embedded_data_height = 0
[ 53.276493] tegra-vi4 15700000.vi: Create Surface with imgW=1280, imgH=1024, memFmt=32
[ 53.276500] video4linux video0: tegra_channel_capture_frame_single_thread: vi4 got SOF syncpt buf[ffffffc1d5c0f400]
[ 53.479350] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 53.485861] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 53.496415] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[ 53.496423] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 53.496432] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000002
[ 53.496442] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[ 53.496457] nvcsi 150c0000.nvcsi: csi4_cil_check_status 398
[ 53.496466] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[ 53.496472] nvcsi 150c0000.nvcsi: csi4_stream_init
[ 53.496485] nvcsi 150c0000.nvcsi: csi4_stream_config
[ 53.496497] nvcsi 150c0000.nvcsi: csi4_stream_config (0) read VC0_DPCM_CTRL = 00000000
[ 53.496502] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 53.496509] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[ 53.496520] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 833
[ 53.496525] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[ 53.496531] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 18
[ 53.496843] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[ 53.496874] embedded_data_height = 0
[ 53.496884] tegra-vi4 15700000.vi: Create Surface with imgW=1280, imgH=1024, memFmt=32
[ 53.496893] video4linux video0: tegra_channel_capture_frame_single_thread: vi4 got SOF syncpt buf[ffffffc1aade3c00]
[ 53.699377] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 53.706013] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 53.716165] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[ 53.716174] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 53.716184] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000002
[ 53.716194] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[ 53.716211] nvcsi 150c0000.nvcsi: csi4_cil_check_status 398
[ 53.716221] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[ 53.716228] nvcsi 150c0000.nvcsi: csi4_stream_init
[ 53.716242] nvcsi 150c0000.nvcsi: csi4_stream_config
[ 53.716255] nvcsi 150c0000.nvcsi: csi4_stream_config (0) read VC0_DPCM_CTRL = 00000000
[ 53.716261] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 53.716270] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[ 53.716282] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 833
[ 53.716288] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[ 53.716296] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 18
[ 53.716637] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[ 53.716670] embedded_data_height = 0
[ 53.716682] tegra-vi4 15700000.vi: Create Surface with imgW=1280, imgH=1024, memFmt=32
[ 53.716694] video4linux video0: tegra_channel_capture_frame_single_thread: vi4 got SOF syncpt buf[ffffffc1d5c0c000]
[ 53.919343] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 53.925800] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 53.936106] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[ 53.936116] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 53.936126] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000002
[ 53.936136] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[ 53.936153] nvcsi 150c0000.nvcsi: csi4_cil_check_status 398
[ 53.936163] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[ 53.936170] nvcsi 150c0000.nvcsi: csi4_stream_init
[ 53.936184] nvcsi 150c0000.nvcsi: csi4_stream_config
[ 53.936198] nvcsi 150c0000.nvcsi: csi4_stream_config (0) read VC0_DPCM_CTRL = 00000000
[ 53.936204] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 53.936213] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[ 53.936224] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 833
[ 53.936231] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[ 53.936239] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 18
[ 53.936578] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[ 53.936611] embedded_data_height = 0
[ 53.936623] tegra-vi4 15700000.vi: Create Surface with imgW=1280, imgH=1024, memFmt=32
[ 53.936635] video4linux video0: tegra_channel_capture_frame_single_thread: vi4 got SOF syncpt buf[ffffffc1d5c0d800]
[ 54.139348] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 54.145963] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 54.156142] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[ 54.156153] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 54.156162] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000002
[ 54.156173] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[ 54.156189] nvcsi 150c0000.nvcsi: csi4_cil_check_status 398
[ 54.156200] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[ 54.156207] nvcsi 150c0000.nvcsi: csi4_stream_init
[ 54.156221] nvcsi 150c0000.nvcsi: csi4_stream_config
[ 54.156234] nvcsi 150c0000.nvcsi: csi4_stream_config (0) read VC0_DPCM_CTRL = 00000000
[ 54.156240] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 54.156249] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[ 54.156261] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 833
[ 54.156268] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[ 54.156275] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 18
[ 54.156608] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[ 54.156641] embedded_data_height = 0
[ 54.156652] tegra-vi4 15700000.vi: Create Surface with imgW=1280, imgH=1024, memFmt=32
[ 54.156663] video4linux video0: tegra_channel_capture_frame_single_thread: vi4 got SOF syncpt buf[ffffffc1d5c0f400]
[ 54.359351] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 54.365846] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 54.376420] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[ 54.376431] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 54.376443] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000002
[ 54.376455] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[ 54.376472] nvcsi 150c0000.nvcsi: csi4_cil_check_status 398
[ 54.376483] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[ 54.376490] nvcsi 150c0000.nvcsi: csi4_stream_init
[ 54.376568] nvcsi 150c0000.nvcsi: csi4_stream_config
[ 54.376590] nvcsi 150c0000.nvcsi: csi4_stream_config (0) read VC0_DPCM_CTRL = 00000000
[ 54.376668] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 54.376685] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[ 54.376706] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 833
[ 54.376718] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[ 54.376732] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 18
[ 54.377416] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[ 54.377452] embedded_data_height = 0
[ 54.377466] tegra-vi4 15700000.vi: Create Surface with imgW=1280, imgH=1024, memFmt=32
[ 54.377480] video4linux video0: tegra_channel_capture_frame_single_thread: vi4 got SOF syncpt buf[ffffffc1aade3c00]
[ 54.579346] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 54.585837] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 54.598198] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[ 54.598206] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 54.598215] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000002
[ 54.598223] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[ 54.598237] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) INTR_STATUS 0x00000008
[ 54.606191] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERR_INTR_STATUS 0x00000008
[ 54.614544] nvcsi 150c0000.nvcsi: csi4_cil_check_status 398
[ 54.614558] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[ 54.614567] nvcsi 150c0000.nvcsi: csi4_stream_init
[ 54.614584] nvcsi 150c0000.nvcsi: csi4_stream_config
[ 54.614600] nvcsi 150c0000.nvcsi: csi4_stream_config (0) read VC0_DPCM_CTRL = 00000000
[ 54.614649] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 54.614661] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[ 54.614676] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 833
[ 54.614685] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[ 54.614695] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 18
[ 54.615094] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[ 54.615121] embedded_data_height = 0
[ 54.615128] tegra-vi4 15700000.vi: Create Surface with imgW=1280, imgH=1024, memFmt=32
[ 54.615134] video4linux video0: tegra_channel_capture_frame_single_thread: vi4 got SOF syncpt buf[ffffffc1d5c0c000]
[ 54.815335] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 54.821834] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 54.832375] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[ 54.832382] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 54.832390] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000002
[ 54.832398] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[ 54.832412] nvcsi 150c0000.nvcsi: csi4_cil_check_status 398
[ 54.832420] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[ 54.832424] nvcsi 150c0000.nvcsi: csi4_stream_init
[ 54.832436] nvcsi 150c0000.nvcsi: csi4_stream_config
[ 54.832447] nvcsi 150c0000.nvcsi: csi4_stream_config (0) read VC0_DPCM_CTRL = 00000000
[ 54.832451] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 54.832458] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[ 54.832468] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 833
[ 54.832472] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[ 54.832478] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 18
[ 54.832773] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[ 54.832800] embedded_data_height = 0
[ 54.832808] tegra-vi4 15700000.vi: Create Surface with imgW=1280, imgH=1024, memFmt=32
[ 54.832816] video4linux video0: tegra_channel_capture_frame_single_thread: vi4 got SOF syncpt buf[ffffffc1d5c0d800]
[ 55.035484] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 55.041967] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 55.051903] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[ 55.051975] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 55.051984] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000002
[ 55.051992] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[ 55.052006] nvcsi 150c0000.nvcsi: csi4_cil_check_status 398
[ 55.052014] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[ 55.052019] nvcsi 150c0000.nvcsi: csi4_stream_init
[ 55.052031] nvcsi 150c0000.nvcsi: csi4_stream_config
[ 55.052042] nvcsi 150c0000.nvcsi: csi4_stream_config (0) read VC0_DPCM_CTRL = 00000000
[ 55.052046] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 55.052053] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[ 55.052062] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 833
[ 55.052067] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[ 55.052072] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 18
[ 55.052360] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[ 55.052399] embedded_data_height = 0
[ 55.052418] tegra-vi4 15700000.vi: Create Surface with imgW=1280, imgH=1024, memFmt=32
[ 55.052440] video4linux video0: tegra_channel_capture_frame_single_thread: vi4 got SOF syncpt buf[ffffffc1d5c0f400]
[ 55.255486] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 55.262068] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 55.272101] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[ 55.272110] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 55.272121] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000002
[ 55.272131] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[ 55.272148] nvcsi 150c0000.nvcsi: csi4_cil_check_status 398
[ 55.272158] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[ 55.272164] nvcsi 150c0000.nvcsi: csi4_stream_init
[ 55.272179] nvcsi 150c0000.nvcsi: csi4_stream_config
[ 55.272192] nvcsi 150c0000.nvcsi: csi4_stream_config (0) read VC0_DPCM_CTRL = 00000000
[ 55.272198] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 55.272207] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[ 55.272219] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 833
[ 55.272226] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[ 55.272233] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 18
[ 55.272581] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[ 55.272615] embedded_data_height = 0
[ 55.272626] tegra-vi4 15700000.vi: Create Surface with imgW=1280, imgH=1024, memFmt=32
[ 55.272639] video4linux video0: tegra_channel_capture_frame_single_thread: vi4 got SOF syncpt buf[ffffffc1aade3c00]
[ 55.475359] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 55.481892] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 55.491815] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[ 55.491824] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 55.491833] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000002
[ 55.491841] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[ 55.491856] nvcsi 150c0000.nvcsi: csi4_cil_check_status 398
[ 55.491864] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[ 55.491869] nvcsi 150c0000.nvcsi: csi4_stream_init
[ 55.491881] nvcsi 150c0000.nvcsi: csi4_stream_config
[ 55.491892] nvcsi 150c0000.nvcsi: csi4_stream_config (0) read VC0_DPCM_CTRL = 00000000
[ 55.491896] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 55.491902] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[ 55.491912] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 833
[ 55.491916] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[ 55.491922] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 18
[ 55.492225] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[ 55.492259] embedded_data_height = 0
[ 55.492269] tegra-vi4 15700000.vi: Create Surface with imgW=1280, imgH=1024, memFmt=32
[ 55.492279] video4linux video0: tegra_channel_capture_frame_single_thread: vi4 got SOF syncpt buf[ffffffc1d5c0c000]
[ 55.695385] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 55.701998] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 55.714720] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[ 55.714728] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 55.714737] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000002
[ 55.714746] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[ 55.714760] nvcsi 150c0000.nvcsi: csi4_cil_check_status 398
[ 55.714769] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[ 55.714774] nvcsi 150c0000.nvcsi: csi4_stream_init
[ 55.714786] nvcsi 150c0000.nvcsi: csi4_stream_config
[ 55.714798] nvcsi 150c0000.nvcsi: csi4_stream_config (0) read VC0_DPCM_CTRL = 00000000
[ 55.714802] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 55.714809] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[ 55.714818] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 833
[ 55.714823] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[ 55.714829] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 18
[ 55.715138] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[ 55.715166] embedded_data_height = 0
[ 55.715176] tegra-vi4 15700000.vi: Create Surface with imgW=1280, imgH=1024, memFmt=32
[ 55.715187] video4linux video0: tegra_channel_capture_frame_single_thread: vi4 got SOF syncpt buf[ffffffc1d5c0d800]
[ 55.927356] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 55.933902] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 55.944541] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[ 55.944551] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 55.944560] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000002
[ 55.944569] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[ 55.944583] nvcsi 150c0000.nvcsi: csi4_cil_check_status 398
[ 55.944591] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[ 55.944596] nvcsi 150c0000.nvcsi: csi4_stream_init
[ 55.944608] nvcsi 150c0000.nvcsi: csi4_stream_config
[ 55.944620] nvcsi 150c0000.nvcsi: csi4_stream_config (0) read VC0_DPCM_CTRL = 00000000
[ 55.944624] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 55.944631] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[ 55.944641] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 833
[ 55.944646] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[ 55.944652] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 18
[ 55.944955] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[ 55.944987] embedded_data_height = 0
[ 55.945001] tegra-vi4 15700000.vi: Create Surface with imgW=1280, imgH=1024, memFmt=32
[ 55.945011] video4linux video0: tegra_channel_capture_frame_single_thread: vi4 got SOF syncpt buf[ffffffc1d5c0f400]
[ 56.147347] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 56.153806] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 56.163957] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[ 56.163968] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 56.163979] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000002
[ 56.163990] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[ 56.164007] nvcsi 150c0000.nvcsi: csi4_cil_check_status 398
[ 56.164017] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[ 56.164023] nvcsi 150c0000.nvcsi: csi4_stream_init
[ 56.164038] nvcsi 150c0000.nvcsi: csi4_stream_config
[ 56.164051] nvcsi 150c0000.nvcsi: csi4_stream_config (0) read VC0_DPCM_CTRL = 00000000
[ 56.164057] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 56.164066] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[ 56.164078] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 833
[ 56.164085] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[ 56.164092] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 18
[ 56.164445] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[ 56.164477] embedded_data_height = 0
[ 56.164489] tegra-vi4 15700000.vi: Create Surface with imgW=1280, imgH=1024, memFmt=32
[ 56.164501] video4linux video0: tegra_channel_capture_frame_single_thread: vi4 got SOF syncpt buf[ffffffc1aade3c00]
[ 56.367376] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 56.373831] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 56.383740] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[ 56.383747] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 56.383753] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000002
[ 56.383761] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[ 56.383775] nvcsi 150c0000.nvcsi: csi4_cil_check_status 398
[ 56.383783] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[ 56.383786] nvcsi 150c0000.nvcsi: csi4_stream_init
[ 56.383798] nvcsi 150c0000.nvcsi: csi4_stream_config
[ 56.383808] nvcsi 150c0000.nvcsi: csi4_stream_config (0) read VC0_DPCM_CTRL = 00000000
[ 56.383812] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 56.383818] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[ 56.383826] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 833
[ 56.383830] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[ 56.383835] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 18
[ 56.384104] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[ 56.384132] embedded_data_height = 0
[ 56.384139] tegra-vi4 15700000.vi: Create Surface with imgW=1280, imgH=1024, memFmt=32
[ 56.384146] video4linux video0: tegra_channel_capture_frame_single_thread: vi4 got SOF syncpt buf[ffffffc1d5c0c000]
[ 56.587339] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 56.593830] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 56.603817] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[ 56.603825] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 56.603832] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000002
[ 56.603840] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[ 56.603854] nvcsi 150c0000.nvcsi: csi4_cil_check_status 398
[ 56.603863] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[ 56.603867] nvcsi 150c0000.nvcsi: csi4_stream_init
[ 56.603878] nvcsi 150c0000.nvcsi: csi4_stream_config
[ 56.603888] nvcsi 150c0000.nvcsi: csi4_stream_config (0) read VC0_DPCM_CTRL = 00000000
[ 56.603892] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 56.603898] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[ 56.603907] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 833
[ 56.603910] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[ 56.603915] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 18
[ 56.604188] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[ 56.604217] embedded_data_height = 0
[ 56.604225] tegra-vi4 15700000.vi: Create Surface with imgW=1280, imgH=1024, memFmt=32
[ 56.604231] video4linux video0: tegra_channel_capture_frame_single_thread: vi4 got SOF syncpt buf[ffffffc1d5c0d800]
[ 56.807354] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 56.813814] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel
[ 56.823689] nvcsi 150c0000.nvcsi: csi4_stop_streaming port_idx=0, lanes=2
[ 56.823698] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 56.823706] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000002
[ 56.823715] nvcsi 150c0000.nvcsi: csi4_stream_check_status
[ 56.823728] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) INTR_STATUS 0x00000004
[ 56.831640] nvcsi 150c0000.nvcsi: csi4_stream_check_status (0) ERR_INTR_STATUS 0x00000004
[ 56.839905] nvcsi 150c0000.nvcsi: csi4_cil_check_status 398
[ 56.839925] nvcsi 150c0000.nvcsi: csi4_start_streaming port_idx=0, lanes=2
[ 56.839937] nvcsi 150c0000.nvcsi: csi4_stream_init
[ 56.839960] nvcsi 150c0000.nvcsi: csi4_stream_config
[ 56.839983] nvcsi 150c0000.nvcsi: csi4_stream_config (0) read VC0_DPCM_CTRL = 00000000
[ 56.840001] nvcsi 150c0000.nvcsi: csi4_phy_config
[ 56.840021] nvcsi 150c0000.nvcsi: NVCSI_CIL_CONFIG = 00000000
[ 56.840044] nvcsi 150c0000.nvcsi: cil core clock: 204, csi clock: 833
[ 56.840062] nvcsi 150c0000.nvcsi: cil_settingtime was autocalculated
[ 56.840075] nvcsi 150c0000.nvcsi: csi settle time: 33, cil settle time: 18
[ 56.840542] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[ 56.840587] embedded_data_height = 0
[ 56.840608] tegra-vi4 15700000.vi: Create Surface with imgW=1280, imgH=1024, memFmt=32
[ 56.840628] video4linux video0: tegra_channel_capture_frame_single_thread: vi4 got SOF syncpt buf[ffffffc1d5c0f400]
[ 57.043370] tegra-vi4 15700000.vi: PXL_SOF syncpt timeout! err = -11
[ 57.049836] tegra-vi4 15700000.vi: tegra_channel_error_recovery: attempting to reset the capture channel

trace (no changes):

    v4l2-ctl-8005  [000] ....   231.286482: tegra_channel_open: vi-output, imx390 30-001b
    v4l2-ctl-8005  [000] ....   231.288509: tegra_channel_set_power: imx390 30-001b : 0x1
    v4l2-ctl-8005  [000] ....   231.288524: camera_common_s_power: status : 0x1
    v4l2-ctl-8005  [000] ....   231.289025: tegra_channel_set_power: 150c0000.nvcsi--3 : 0x1
    v4l2-ctl-8005  [000] ....   231.289029: csi_s_power: enable : 0x1
    v4l2-ctl-8005  [000] ....   231.298945: tegra_channel_capture_setup: vnc_id 0 W 1280 H 1024 fmt 20

vi-output, imx3-8006 [005] … 231.299069: tegra_channel_set_stream: enable : 0x1
vi-output, imx3-8006 [000] … 231.300564: tegra_channel_set_stream: 150c0000.nvcsi–3 : 0x1
vi-output, imx3-8006 [000] … 231.300567: csi_s_stream: enable : 0x1
vi-output, imx3-8006 [000] … 231.300625: tegra_channel_set_stream: imx390 30-001b : 0x1
kworker/5:1-1587 [005] … 231.322061: rtos_queue_peek_from_isr_failed: tstamp:7623611716 queue:0x0b4b4500
kworker/5:1-1587 [005] … 231.322066: rtcpu_start: tstamp:7623612987
kworker/5:1-1587 [005] … 231.322069: rtos_queue_send_from_isr_failed: tstamp:7623621863 queue:0x0b4a7258
kworker/5:1-1587 [005] … 231.322071: rtos_queue_send_from_isr_failed: tstamp:7623621971 queue:0x0b4aad68
kworker/5:1-1587 [005] … 231.322072: rtos_queue_send_from_isr_failed: tstamp:7623622077 queue:0x0b4ac998
kworker/5:1-1587 [005] … 231.322074: rtos_queue_send_from_isr_failed: tstamp:7623622183 queue:0x0b4ae518
kworker/5:1-1587 [005] … 231.322075: rtos_queue_send_from_isr_failed: tstamp:7623622288 queue:0x0b4af2d8
kworker/5:1-1587 [005] … 231.322076: rtos_queue_send_from_isr_failed: tstamp:7623622393 queue:0x0b4b0098
kworker/5:1-1587 [005] … 231.322078: rtos_queue_send_from_isr_failed: tstamp:7623622498 queue:0x0b4b0e58
kworker/5:1-1587 [005] … 231.322079: rtos_queue_send_from_isr_failed: tstamp:7623622603 queue:0x0b4b1c18
kworker/5:1-1587 [005] … 231.322081: rtos_queue_send_failed: tstamp:7623623065 queue:0x0b4a7258
kworker/5:1-1587 [005] … 231.322082: rtos_queue_send_from_isr_failed: tstamp:7623624880 queue:0x0b4a7258
kworker/5:1-1587 [005] … 231.322084: rtos_queue_send_from_isr_failed: tstamp:7623624987 queue:0x0b4aad68
kworker/5:1-1587 [005] … 231.322085: rtos_queue_send_from_isr_failed: tstamp:7623625093 queue:0x0b4ac998
kworker/5:1-1587 [005] … 231.322087: rtos_queue_send_from_isr_failed: tstamp:7623625199 queue:0x0b4ae518
kworker/5:1-1587 [005] … 231.322088: rtos_queue_send_from_isr_failed: tstamp:7623625304 queue:0x0b4af2d8
kworker/5:1-1587 [005] … 231.322089: rtos_queue_send_from_isr_failed: tstamp:7623625409 queue:0x0b4b0098
kworker/5:1-1587 [005] … 231.322090: rtos_queue_send_from_isr_failed: tstamp:7623625527 queue:0x0b4b0e58
kworker/5:1-1587 [005] … 231.322092: rtos_queue_send_from_isr_failed: tstamp:7623625632 queue:0x0b4b1c18
kworker/5:1-1587 [005] … 231.322093: rtos_queue_send_failed: tstamp:7623626585 queue:0x0b4a7258
kworker/5:1-1587 [005] … 231.378142: rtcpu_vinotify_event: tstamp:7625535194 tag:CHANSEL_SHORT_FRAME channel:0x01 frame:0 vi_tstamp:7625534598 data:0x00000001
kworker/5:1-1587 [005] … 231.378147: rtcpu_vinotify_event: tstamp:7625535379 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:7625534599 data:0x00000001
kworker/5:1-1587 [005] … 231.490126: rtos_queue_peek_from_isr_failed: tstamp:7628612089 queue:0x0b4b4500
vi-output, imx3-8006 [003] … 231.555489: tegra_channel_capture_setup: vnc_id 0 W 1280 H 1024 fmt 20
vi-output, imx3-8006 [003] … 231.555553: tegra_channel_capture_frame: sof:-549620695332.-267606436032
kworker/5:1-1587 [005] … 231.602084: rtos_queue_send_from_isr_failed: tstamp:7631618073 queue:0x0b4a7258
kworker/5:1-1587 [005] … 231.602092: rtos_queue_send_from_isr_failed: tstamp:7631618221 queue:0x0b4aad68
kworker/5:1-1587 [005] … 231.602095: rtos_queue_send_from_isr_failed: tstamp:7631618364 queue:0x0b4ac998
kworker/5:1-1587 [005] … 231.602097: rtos_queue_send_from_isr_failed: tstamp:7631618504 queue:0x0b4ae518
kworker/5:1-1587 [005] … 231.602099: rtos_queue_send_from_isr_failed: tstamp:7631618640 queue:0x0b4af2d8
kworker/5:1-1587 [005] … 231.602102: rtos_queue_send_from_isr_failed: tstamp:7631618779 queue:0x0b4b0098
kworker/5:1-1587 [005] … 231.602104: rtos_queue_send_from_isr_failed: tstamp:7631618916 queue:0x0b4b0e58
kworker/5:1-1587 [005] … 231.602106: rtos_queue_send_from_isr_failed: tstamp:7631619054 queue:0x0b4b1c18
kworker/5:1-1587 [005] … 231.602111: rtos_queue_send_failed: tstamp:7631619850 queue:0x0b4a7258
kworker/5:1-1587 [005] … 231.602113: rtos_queue_send_from_isr_failed: tstamp:7631623673 queue:0x0b4a7258
kworker/5:1-1587 [005] … 231.602116: rtos_queue_send_from_isr_failed: tstamp:7631623816 queue:0x0b4aad68
kworker/5:1-1587 [005] … 231.602118: rtos_queue_send_from_isr_failed: tstamp:7631623955 queue:0x0b4ac998
kworker/5:1-1587 [005] … 231.602120: rtos_queue_send_from_isr_failed: tstamp:7631624095 queue:0x0b4ae518
kworker/5:1-1587 [005] … 231.602123: rtos_queue_send_from_isr_failed: tstamp:7631624237 queue:0x0b4af2d8
kworker/5:1-1587 [005] … 231.602125: rtos_queue_send_from_isr_failed: tstamp:7631624374 queue:0x0b4b0098
kworker/5:1-1587 [005] … 231.602127: rtos_queue_send_from_isr_failed: tstamp:7631624511 queue:0x0b4b0e58
kworker/5:1-1587 [005] … 231.602130: rtos_queue_send_from_isr_failed: tstamp:7631624649 queue:0x0b4b1c18
kworker/5:1-1587 [005] … 231.602132: rtos_queue_send_failed: tstamp:7631625279 queue:0x0b4a7258
kworker/5:1-1587 [005] … 231.602134: rtos_queue_send_from_isr_failed: tstamp:7631634741 queue:0x0b4a7258
kworker/5:1-1587 [005] … 231.602137: rtos_queue_send_from_isr_failed: tstamp:7631634880 queue:0x0b4aad68
kworker/5:1-1587 [005] … 231.602139: rtos_queue_send_from_isr_failed: tstamp:7631635017 queue:0x0b4ac998
kworker/5:1-1587 [005] … 231.602142: rtos_queue_send_from_isr_failed: tstamp:7631635159 queue:0x0b4ae518
kworker/5:1-1587 [005] … 231.602144: rtos_queue_send_from_isr_failed: tstamp:7631635296 queue:0x0b4af2d8
kworker/5:1-1587 [005] … 231.602146: rtos_queue_send_from_isr_failed: tstamp:7631635435 queue:0x0b4b0098
kworker/5:1-1587 [005] … 231.602149: rtos_queue_send_from_isr_failed: tstamp:7631635594 queue:0x0b4b0e58
kworker/5:1-1587 [005] … 231.602151: rtos_queue_send_from_isr_failed: tstamp:7631635733 queue:0x0b4b1c18
kworker/5:1-1587 [005] … 231.602154: rtos_queue_send_failed: tstamp:7631636316 queue:0x0b4a7258
kworker/5:1-1587 [005] … 231.602156: rtos_queue_send_from_isr_failed: tstamp:7631639588 queue:0x0b4a7258
kworker/5:1-1587 [005] … 231.602159: rtos_queue_send_from_isr_failed: tstamp:7631639728 queue:0x0b4aad68
kworker/5:1-1587 [005] … 231.602161: rtos_queue_send_from_isr_failed: tstamp:7631639867 queue:0x0b4ac998
kworker/5:1-1587 [005] … 231.602163: rtos_queue_send_from_isr_failed: tstamp:7631640005 queue:0x0b4ae518
kworker/5:1-1587 [005] … 231.602166: rtos_queue_send_from_isr_failed: tstamp:7631640143 queue:0x0b4af2d8
kworker/5:1-1587 [005] … 231.602168: rtos_queue_send_from_isr_failed: tstamp:7631640283 queue:0x0b4b0098
kworker/5:1-1587 [005] … 231.602171: rtos_queue_send_from_isr_failed: tstamp:7631640420 queue:0x0b4b0e58
kworker/5:1-1587 [005] … 231.602173: rtos_queue_send_from_isr_failed: tstamp:7631640558 queue:0x0b4b1c18
kworker/5:1-1587 [005] … 231.602176: rtos_queue_send_failed: tstamp:7631641961 queue:0x0b4a7258
kworker/5:1-1587 [005] … 231.602181: rtcpu_vinotify_event: tstamp:7632780323 tag:CHANSEL_SHORT_FRAME channel:0x01 frame:0 vi_tstamp:7632779732 data:0x00000001
kworker/5:1-1587 [005] … 231.602183: rtcpu_vinotify_event: tstamp:7632780502 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:7632779732 data:0x00000001
kworker/5:1-1587 [005] … 231.658143: rtos_queue_peek_from_isr_failed: tstamp:7633612089 queue:0x0b4b4500
vi-output, imx3-8006 [004] .n… 231.775728: tegra_channel_capture_setup: vnc_id 0 W 1280 H 1024 fmt 20
vi-output, imx3-8006 [004] … 231.775928: tegra_channel_capture_frame: sof:-549620695332.-267606436032
kworker/5:1-1587 [005] … 231.778120: rtos_queue_send_from_isr_failed: tstamp:7638496828 queue:0x0b4a7258
kworker/5:1-1587 [005] … 231.778124: rtos_queue_send_from_isr_failed: tstamp:7638496973 queue:0x0b4aad68
kworker/5:1-1587 [005] … 231.778125: rtos_queue_send_from_isr_failed: tstamp:7638497116 queue:0x0b4ac998
kworker/5:1-1587 [005] … 231.778127: rtos_queue_send_from_isr_failed: tstamp:7638497260 queue:0x0b4ae518
kworker/5:1-1587 [005] … 231.778128: rtos_queue_send_from_isr_failed: tstamp:7638497397 queue:0x0b4af2d8
kworker/5:1-1587 [005] … 231.778129: rtos_queue_send_from_isr_failed: tstamp:7638497536 queue:0x0b4b0098
kworker/5:1-1587 [005] … 231.778130: rtos_queue_send_from_isr_failed: tstamp:7638497673 queue:0x0b4b0e58
kworker/5:1-1587 [005] … 231.778132: rtos_queue_send_from_isr_failed: tstamp:7638497811 queue:0x0b4b1c18
kworker/5:1-1587 [005] … 231.778135: rtos_queue_send_failed: tstamp:7638498541 queue:0x0b4a7258
kworker/5:1-1587 [005] … 231.778136: rtos_queue_send_from_isr_failed: tstamp:7638502030 queue:0x0b4a7258
kworker/5:1-1587 [005] … 231.778137: rtos_queue_send_from_isr_failed: tstamp:7638502169 queue:0x0b4aad68
kworker/5:1-1587 [005] … 231.778138: rtos_queue_send_from_isr_failed: tstamp:7638502308 queue:0x0b4ac998
kworker/5:1-1587 [005] … 231.778140: rtos_queue_send_from_isr_failed: tstamp:7638502446 queue:0x0b4ae518
kworker/5:1-1587 [005] … 231.778141: rtos_queue_send_from_isr_failed: tstamp:7638502584 queue:0x0b4af2d8
kworker/5:1-1587 [005] … 231.778143: rtos_queue_send_from_isr_failed: tstamp:7638502723 queue:0x0b4b0098
kworker/5:1-1587 [005] … 231.778144: rtos_queue_send_from_isr_failed: tstamp:7638502859 queue:0x0b4b0e58
kworker/5:1-1587 [005] … 231.778145: rtos_queue_send_from_isr_failed: tstamp:7638502996 queue:0x0b4b1c18
kworker/5:1-1587 [005] … 231.778147: rtos_queue_send_failed: tstamp:7638503554 queue:0x0b4a7258
kworker/5:1-1587 [005] … 231.778148: rtos_queue_send_from_isr_failed: tstamp:7638512467 queue:0x0b4a7258
kworker/5:1-1587 [005] … 231.778149: rtos_queue_send_from_isr_failed: tstamp:7638512611 queue:0x0b4aad68
kworker/5:1-1587 [005] … 231.778151: rtos_queue_send_from_isr_failed: tstamp:7638512751 queue:0x0b4ac998
kworker/5:1-1587 [005] … 231.778152: rtos_queue_send_from_isr_failed: tstamp:7638512892 queue:0x0b4ae518
kworker/5:1-1587 [005] … 231.778153: rtos_queue_send_from_isr_failed: tstamp:7638513039 queue:0x0b4af2d8
kworker/5:1-1587 [005] … 231.778154: rtos_queue_send_from_isr_failed: tstamp:7638513180 queue:0x0b4b0098
kworker/5:1-1587 [005] … 231.778156: rtos_queue_send_from_isr_failed: tstamp:7638513318 queue:0x0b4b0e58
kworker/5:1-1587 [005] … 231.778157: rtos_queue_send_from_isr_failed: tstamp:7638513455 queue:0x0b4b1c18
kworker/5:1-1587 [005] … 231.778158: rtos_queue_send_failed: tstamp:7638514022 queue:0x0b4a7258
kworker/5:1-1587 [005] … 231.778160: rtos_queue_send_from_isr_failed: tstamp:7638518445 queue:0x0b4a7258
kworker/5:1-1587 [005] … 231.778161: rtos_queue_send_from_isr_failed: tstamp:7638518585 queue:0x0b4aad68
kworker/5:1-1587 [005] … 231.778162: rtos_queue_send_from_isr_failed: tstamp:7638518734 queue:0x0b4ac998
kworker/5:1-1587 [005] … 231.778164: rtos_queue_send_from_isr_failed: tstamp:7638518874 queue:0x0b4ae518
kworker/5:1-1587 [005] … 231.778165: rtos_queue_send_from_isr_failed: tstamp:7638519012 queue:0x0b4af2d8
kworker/5:1-1587 [005] … 231.778166: rtos_queue_send_from_isr_failed: tstamp:7638519149 queue:0x0b4b0098
kworker/5:1-1587 [005] … 231.778168: rtos_queue_send_from_isr_failed: tstamp:7638519286 queue:0x0b4b0e58
kworker/5:1-1587 [005] … 231.778169: rtos_queue_send_from_isr_failed: tstamp:7638519424 queue:0x0b4b1c18
kworker/5:1-1587 [005] … 231.778171: rtos_queue_send_failed: tstamp:7638520815 queue:0x0b4a7258
kworker/5:1-1587 [005] … 231.834138: rtos_queue_peek_from_isr_failed: tstamp:7638612095 queue:0x0b4b4500
kworker/5:1-1587 [005] … 231.834148: rtcpu_vinotify_event: tstamp:7639300952 tag:CHANSEL_SHORT_FRAME channel:0x01 frame:0 vi_tstamp:7639300352 data:0x00000001
kworker/5:1-1587 [005] … 231.834150: rtcpu_vinotify_event: tstamp:7639301131 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:7639300352 data:0x00000001
kworker/5:1-1587 [005] … 231.946135: rtos_queue_peek_from_isr_failed: tstamp:7643612098 queue:0x0b4b4500
vi-output, imx3-8006 [004] … 231.995279: tegra_channel_capture_setup: vnc_id 0 W 1280 H 1024 fmt 20
vi-output, imx3-8006 [004] … 231.995334: tegra_channel_capture_frame: sof:-549620695332.-267606436032
kworker/5:1-1587 [005] … 232.006035: rtos_queue_send_from_isr_failed: tstamp:7645360839 queue:0x0b4a7258
kworker/5:1-1587 [005] … 232.006038: rtos_queue_send_from_isr_failed: tstamp:7645360986 queue:0x0b4aad68
kworker/5:1-1587 [005] … 232.006039: rtos_queue_send_from_isr_failed: tstamp:7645361127 queue:0x0b4ac998
kworker/5:1-1587 [005] … 232.006039: rtos_queue_send_from_isr_failed: tstamp:7645361267 queue:0x0b4ae518
kworker/5:1-1587 [005] … 232.006040: rtos_queue_send_from_isr_failed: tstamp:7645361405 queue:0x0b4af2d8
kworker/5:1-1587 [005] … 232.006041: rtos_queue_send_from_isr_failed: tstamp:7645361542 queue:0x0b4b0098
kworker/5:1-1587 [005] … 232.006042: rtos_queue_send_from_isr_failed: tstamp:7645361679 queue:0x0b4b0e58
kworker/5:1-1587 [005] … 232.006042: rtos_queue_send_from_isr_failed: tstamp:7645361817 queue:0x0b4b1c18
kworker/5:1-1587 [005] … 232.006044: rtos_queue_send_failed: tstamp:7645362534 queue:0x0b4a7258
kworker/5:1-1587 [005] … 232.006044: rtos_queue_send_from_isr_failed: tstamp:7645369938 queue:0x0b4a7258
kworker/5:1-1587 [005] … 232.006045: rtos_queue_send_from_isr_failed: tstamp:7645370077 queue:0x0b4aad68
kworker/5:1-1587 [005] … 232.006046: rtos_queue_send_from_isr_failed: tstamp:7645370236 queue:0x0b4ac998
kworker/5:1-1587 [005] … 232.006047: rtos_queue_send_from_isr_failed: tstamp:7645370376 queue:0x0b4ae518
kworker/5:1-1587 [005] … 232.006047: rtos_queue_send_from_isr_failed: tstamp:7645370514 queue:0x0b4af2d8
kworker/5:1-1587 [005] … 232.006048: rtos_queue_send_from_isr_failed: tstamp:7645370651 queue:0x0b4b0098
kworker/5:1-1587 [005] … 232.006049: rtos_queue_send_from_isr_failed: tstamp:7645370791 queue:0x0b4b0e58
kworker/5:1-1587 [005] … 232.006049: rtos_queue_send_from_isr_failed: tstamp:7645370951 queue:0x0b4b1c18
kworker/5:1-1587 [005] … 232.006050: rtos_queue_send_failed: tstamp:7645371512 queue:0x0b4a7258
kworker/5:1-1587 [005] … 232.006051: rtos_queue_send_from_isr_failed: tstamp:7645379755 queue:0x0b4a7258
kworker/5:1-1587 [005] … 232.006052: rtos_queue_send_from_isr_failed: tstamp:7645379913 queue:0x0b4aad68
kworker/5:1-1587 [005] … 232.006052: rtos_queue_send_from_isr_failed: tstamp:7645380052 queue:0x0b4ac998
kworker/5:1-1587 [005] … 232.006053: rtos_queue_send_from_isr_failed: tstamp:7645380191 queue:0x0b4ae518
kworker/5:1-1587 [005] … 232.006054: rtos_queue_send_from_isr_failed: tstamp:7645380328 queue:0x0b4af2d8
kworker/5:1-1587 [005] … 232.006054: rtos_queue_send_from_isr_failed: tstamp:7645380466 queue:0x0b4b0098
kworker/5:1-1587 [005] … 232.006055: rtos_queue_send_from_isr_failed: tstamp:7645380603 queue:0x0b4b0e58
kworker/5:1-1587 [005] … 232.006056: rtos_queue_send_from_isr_failed: tstamp:7645380742 queue:0x0b4b1c18
kworker/5:1-1587 [005] … 232.006057: rtos_queue_send_failed: tstamp:7645381349 queue:0x0b4a7258
kworker/5:1-1587 [005] … 232.006058: rtos_queue_send_from_isr_failed: tstamp:7645383552 queue:0x0b4a7258
kworker/5:1-1587 [005] … 232.006058: rtos_queue_send_from_isr_failed: tstamp:7645383710 queue:0x0b4aad68
kworker/5:1-1587 [005] … 232.006059: rtos_queue_send_from_isr_failed: tstamp:7645383849 queue:0x0b4ac998
kworker/5:1-1587 [005] … 232.006060: rtos_queue_send_from_isr_failed: tstamp:7645383988 queue:0x0b4ae518
kworker/5:1-1587 [005] … 232.006060: rtos_queue_send_from_isr_failed: tstamp:7645384125 queue:0x0b4af2d8
kworker/5:1-1587 [005] … 232.006061: rtos_queue_send_from_isr_failed: tstamp:7645384261 queue:0x0b4b0098
kworker/5:1-1587 [005] … 232.006062: rtos_queue_send_from_isr_failed: tstamp:7645384397 queue:0x0b4b0e58
kworker/5:1-1587 [005] … 232.006063: rtos_queue_send_from_isr_failed: tstamp:7645384535 queue:0x0b4b1c18
kworker/5:1-1587 [005] … 232.006063: rtos_queue_send_failed: tstamp:7645385933 queue:0x0b4a7258
kworker/5:1-1587 [005] … 232.006064: rtcpu_vinotify_event: tstamp:7645387411 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:7645386210 data:0x00000001
kworker/5:1-1587 [005] … 232.062149: rtcpu_vinotify_event: tstamp:7646546075 tag:CHANSEL_SHORT_FRAME channel:0x01 frame:0 vi_tstamp:7646545484 data:0x00000001
kworker/5:1-1587 [005] … 232.062155: rtcpu_vinotify_event: tstamp:7646546253 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:7646545485 data:0x00000001
kworker/5:1-1587 [005] … 232.118147: rtos_queue_peek_from_isr_failed: tstamp:7648612139 queue:0x0b4b4500
vi-output, imx3-8006 [004] … 232.215156: tegra_channel_capture_setup: vnc_id 0 W 1280 H 1024 fmt 20
vi-output, imx3-8006 [004] … 232.215208: tegra_channel_capture_frame: sof:-549620695332.-267606436032
kworker/5:1-1587 [005] … 232.230073: rtos_queue_send_from_isr_failed: tstamp:7652234054 queue:0x0b4a7258
kworker/5:1-1587 [005] … 232.230076: rtos_queue_send_from_isr_failed: tstamp:7652234202 queue:0x0b4aad68
kworker/5:1-1587 [005] … 232.230077: rtos_queue_send_from_isr_failed: tstamp:7652234343 queue:0x0b4ac998
kworker/5:1-1587 [005] … 232.230077: rtos_queue_send_from_isr_failed: tstamp:7652234486 queue:0x0b4ae518
kworker/5:1-1587 [005] … 232.230078: rtos_queue_send_from_isr_failed: tstamp:7652234624 queue:0x0b4af2d8
kworker/5:1-1587 [005] … 232.230079: rtos_queue_send_from_isr_failed: tstamp:7652234761 queue:0x0b4b0098
kworker/5:1-1587 [005] … 232.230080: rtos_queue_send_from_isr_failed: tstamp:7652234898 queue:0x0b4b0e58
kworker/5:1-1587 [005] … 232.230081: rtos_queue_send_from_isr_failed: tstamp:7652235036 queue:0x0b4b1c18
kworker/5:1-1587 [005] … 232.230082: rtos_queue_send_failed: tstamp:7652235796 queue:0x0b4a7258
kworker/5:1-1587 [005] … 232.230083: rtos_queue_send_from_isr_failed: tstamp:7652239809 queue:0x0b4a7258
kworker/5:1-1587 [005] … 232.230084: rtos_queue_send_from_isr_failed: tstamp:7652239952 queue:0x0b4aad68
kworker/5:1-1587 [005] … 232.230085: rtos_queue_send_from_isr_failed: tstamp:7652240090 queue:0x0b4ac998
kworker/5:1-1587 [005] … 232.230086: rtos_queue_send_from_isr_failed: tstamp:7652240230 queue:0x0b4ae518
kworker/5:1-1587 [005] … 232.230087: rtos_queue_send_from_isr_failed: tstamp:7652240368 queue:0x0b4af2d8
kworker/5:1-1587 [005] … 232.230088: rtos_queue_send_from_isr_failed: tstamp:7652240505 queue:0x0b4b0098
kworker/5:1-1587 [005] … 232.230089: rtos_queue_send_from_isr_failed: tstamp:7652240643 queue:0x0b4b0e58
kworker/5:1-1587 [005] … 232.230090: rtos_queue_send_from_isr_failed: tstamp:7652240785 queue:0x0b4b1c18
kworker/5:1-1587 [005] … 232.230090: rtos_queue_send_failed: tstamp:7652241358 queue:0x0b4a7258
kworker/5:1-1587 [005] … 232.230091: rtos_queue_send_from_isr_failed: tstamp:7652249736 queue:0x0b4a7258
kworker/5:1-1587 [005] … 232.230092: rtos_queue_send_from_isr_failed: tstamp:7652249880 queue:0x0b4aad68
kworker/5:1-1587 [005] … 232.230093: rtos_queue_send_from_isr_failed: tstamp:7652250020 queue:0x0b4ac998
kworker/5:1-1587 [005] … 232.230093: rtos_queue_send_from_isr_failed: tstamp:7652250160 queue:0x0b4ae518
kworker/5:1-1587 [005] … 232.230094: rtos_queue_send_from_isr_failed: tstamp:7652250304 queue:0x0b4af2d8
kworker/5:1-1587 [005] … 232.230095: rtos_queue_send_from_isr_failed: tstamp:7652250444 queue:0x0b4b0098
kworker/5:1-1587 [005] … 232.230096: rtos_queue_send_from_isr_failed: tstamp:7652250584 queue:0x0b4b0e58
kworker/5:1-1587 [005] … 232.230097: rtos_queue_send_from_isr_failed: tstamp:7652250723 queue:0x0b4b1c18
kworker/5:1-1587 [005] … 232.230098: rtos_queue_send_failed: tstamp:7652251300 queue:0x0b4a7258
kworker/5:1-1587 [005] … 232.230098: rtos_queue_send_from_isr_failed: tstamp:7652253952 queue:0x0b4a7258
kworker/5:1-1587 [005] … 232.230099: rtos_queue_send_from_isr_failed: tstamp:7652254096 queue:0x0b4aad68
kworker/5:1-1587 [005] … 232.230100: rtos_queue_send_from_isr_failed: tstamp:7652254235 queue:0x0b4ac998
kworker/5:1-1587 [005] … 232.230101: rtos_queue_send_from_isr_failed: tstamp:7652254373 queue:0x0b4ae518
kworker/5:1-1587 [005] … 232.230102: rtos_queue_send_from_isr_failed: tstamp:7652254511 queue:0x0b4af2d8
kworker/5:1-1587 [005] … 232.230103: rtos_queue_send_from_isr_failed: tstamp:7652254647 queue:0x0b4b0098
kworker/5:1-1587 [005] … 232.230104: rtos_queue_send_from_isr_failed: tstamp:7652254784 queue:0x0b4b0e58
kworker/5:1-1587 [005] … 232.230105: rtos_queue_send_from_isr_failed: tstamp:7652254922 queue:0x0b4b1c18
kworker/5:1-1587 [005] … 232.230106: rtos_queue_send_failed: tstamp:7652256400 queue:0x0b4a7258
kworker/5:1-1587 [005] … 232.286159: rtcpu_vinotify_event: tstamp:7653066696 tag:CHANSEL_SHORT_FRAME channel:0x01 frame:0 vi_tstamp:7653066104 data:0x00000001
kworker/5:1-1587 [005] … 232.286164: rtcpu_vinotify_event: tstamp:7653066874 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:7653066104 data:0x00000001
kworker/5:1-1587 [005] … 232.286169: rtos_queue_peek_from_isr_failed: tstamp:7653612108 queue:0x0b4b4500
vi-output, imx3-8006 [000] … 232.435243: tegra_channel_capture_setup: vnc_id 0 W 1280 H 1024 fmt 20
vi-output, imx3-8006 [000] … 232.435298: tegra_channel_capture_frame: sof:-549620695332.-267606436032
kworker/5:1-1587 [005] … 232.454047: rtos_queue_peek_from_isr_failed: tstamp:7658612111 queue:0x0b4b4500
kworker/5:1-1587 [005] … 232.454054: rtos_queue_send_from_isr_failed: tstamp:7659108342 queue:0x0b4a7258
kworker/5:1-1587 [005] … 232.454057: rtos_queue_send_from_isr_failed: tstamp:7659108488 queue:0x0b4aad68
kworker/5:1-1587 [005] … 232.454059: rtos_queue_send_from_isr_failed: tstamp:7659108630 queue:0x0b4ac998
kworker/5:1-1587 [005] … 232.454060: rtos_queue_send_from_isr_failed: tstamp:7659108770 queue:0x0b4ae518
kworker/5:1-1587 [005] … 232.454062: rtos_queue_send_from_isr_failed: tstamp:7659108907 queue:0x0b4af2d8
kworker/5:1-1587 [005] … 232.454064: rtos_queue_send_from_isr_failed: tstamp:7659109045 queue:0x0b4b0098
kworker/5:1-1587 [005] … 232.454066: rtos_queue_send_from_isr_failed: tstamp:7659109182 queue:0x0b4b0e58
kworker/5:1-1587 [005] … 232.454068: rtos_queue_send_from_isr_failed: tstamp:7659109319 queue:0x0b4b1c18
kworker/5:1-1587 [005] … 232.454070: rtos_queue_send_failed: tstamp:7659110034 queue:0x0b4a7258
kworker/5:1-1587 [005] … 232.454072: rtos_queue_send_from_isr_failed: tstamp:7659117842 queue:0x0b4a7258
kworker/5:1-1587 [005] … 232.454074: rtos_queue_send_from_isr_failed: tstamp:7659117981 queue:0x0b4aad68
kworker/5:1-1587 [005] … 232.454076: rtos_queue_send_from_isr_failed: tstamp:7659118124 queue:0x0b4ac998
kworker/5:1-1587 [005] … 232.454077: rtos_queue_send_from_isr_failed: tstamp:7659118264 queue:0x0b4ae518
kworker/5:1-1587 [005] … 232.454079: rtos_queue_send_from_isr_failed: tstamp:7659118401 queue:0x0b4af2d8
kworker/5:1-1587 [005] … 232.454081: rtos_queue_send_from_isr_failed: tstamp:7659118539 queue:0x0b4b0098
kworker/5:1-1587 [005] … 232.454083: rtos_queue_send_from_isr_failed: tstamp:7659118676 queue:0x0b4b0e58
kworker/5:1-1587 [005] … 232.454085: rtos_queue_send_from_isr_failed: tstamp:7659118814 queue:0x0b4b1c18
kworker/5:1-1587 [005] … 232.454086: rtos_queue_send_failed: tstamp:7659119367 queue:0x0b4a7258
kworker/5:1-1587 [005] … 232.454088: rtos_queue_send_from_isr_failed: tstamp:7659127833 queue:0x0b4a7258
kworker/5:1-1587 [005] … 232.454090: rtos_queue_send_from_isr_failed: tstamp:7659127972 queue:0x0b4aad68
kworker/5:1-1587 [005] … 232.454092: rtos_queue_send_from_isr_failed: tstamp:7659128111 queue:0x0b4ac998
kworker/5:1-1587 [005] … 232.454094: rtos_queue_send_from_isr_failed: tstamp:7659128251 queue:0x0b4ae518
kworker/5:1-1587 [005] … 232.454096: rtos_queue_send_from_isr_failed: tstamp:7659128389 queue:0x0b4af2d8
kworker/5:1-1587 [005] … 232.454098: rtos_queue_send_from_isr_failed: tstamp:7659128526 queue:0x0b4b0098
kworker/5:1-1587 [005] … 232.454099: rtos_queue_send_from_isr_failed: tstamp:7659128663 queue:0x0b4b0e58
kworker/5:1-1587 [005] … 232.454101: rtos_queue_send_from_isr_failed: tstamp:7659128801 queue:0x0b4b1c18
kworker/5:1-1587 [005] … 232.454103: rtos_queue_send_failed: tstamp:7659129375 queue:0x0b4a7258
kworker/5:1-1587 [005] … 232.454105: rtos_queue_send_from_isr_failed: tstamp:7659132264 queue:0x0b4a7258
kworker/5:1-1587 [005] … 232.454107: rtos_queue_send_from_isr_failed: tstamp:7659132404 queue:0x0b4aad68
kworker/5:1-1587 [005] … 232.454109: rtos_queue_send_from_isr_failed: tstamp:7659132543 queue:0x0b4ac998
kworker/5:1-1587 [005] … 232.454111: rtos_queue_send_from_isr_failed: tstamp:7659132683 queue:0x0b4ae518
kworker/5:1-1587 [005] … 232.454112: rtos_queue_send_from_isr_failed: tstamp:7659132821 queue:0x0b4af2d8
kworker/5:1-1587 [005] … 232.454114: rtos_queue_send_from_isr_failed: tstamp:7659132958 queue:0x0b4b0098
kworker/5:1-1587 [005] … 232.454116: rtos_queue_send_from_isr_failed: tstamp:7659133095 queue:0x0b4b0e58
kworker/5:1-1587 [005] … 232.454118: rtos_queue_send_from_isr_failed: tstamp:7659133233 queue:0x0b4b1c18
kworker/5:1-1587 [005] … 232.454120: rtos_queue_send_failed: tstamp:7659134636 queue:0x0b4a7258
kworker/5:1-1587 [005] … 232.454122: rtcpu_vinotify_event: tstamp:7659136069 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:7659134918 data:0x00000001
kworker/5:1-1587 [005] … 232.510156: rtcpu_vinotify_event: tstamp:7660311834 tag:CHANSEL_SHORT_FRAME channel:0x01 frame:0 vi_tstamp:7660311237 data:0x00000001
kworker/5:1-1587 [005] … 232.510163: rtcpu_vinotify_event: tstamp:7660312046 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:7660311237 data:0x00000001
kworker/5:1-1587 [005] … 232.622129: rtos_queue_peek_from_isr_failed: tstamp:7663612117 queue:0x0b4b4500
vi-output, imx3-8006 [004] … 232.655329: tegra_channel_capture_setup: vnc_id 0 W 1280 H 1024 fmt 20
vi-output, imx3-8006 [004] … 232.655384: tegra_channel_capture_frame: sof:-549620695332.-267606436032
kworker/5:1-1587 [005] … 232.678081: rtos_queue_send_from_isr_failed: tstamp:7665983362 queue:0x0b4a7258
kworker/5:1-1587 [005] … 232.678087: rtos_queue_send_from_isr_failed: tstamp:7665983515 queue:0x0b4aad68
kworker/5:1-1587 [005] … 232.678089: rtos_queue_send_from_isr_failed: tstamp:7665983656 queue:0x0b4ac998
kworker/5:1-1587 [005] … 232.678091: rtos_queue_send_from_isr_failed: tstamp:7665983800 queue:0x0b4ae518
kworker/5:1-1587 [005] … 232.678093: rtos_queue_send_from_isr_failed: tstamp:7665983936 queue:0x0b4af2d8
kworker/5:1-1587 [005] … 232.678095: rtos_queue_send_from_isr_failed: tstamp:7665984075 queue:0x0b4b0098
kworker/5:1-1587 [005] … 232.678097: rtos_queue_send_from_isr_failed: tstamp:7665984212 queue:0x0b4b0e58
kworker/5:1-1587 [005] … 232.678098: rtos_queue_send_from_isr_failed: tstamp:7665984350 queue:0x0b4b1c18
kworker/5:1-1587 [005] … 232.678102: rtos_queue_send_failed: tstamp:7665985080 queue:0x0b4a7258
kworker/5:1-1587 [005] … 232.678104: rtos_queue_send_from_isr_failed: tstamp:7665987768 queue:0x0b4a7258
kworker/5:1-1587 [005] … 232.678106: rtos_queue_send_from_isr_failed: tstamp:7665987908 queue:0x0b4aad68
kworker/5:1-1587 [005] … 232.678107: rtos_queue_send_from_isr_failed: tstamp:7665988047 queue:0x0b4ac998
kworker/5:1-1587 [005] … 232.678109: rtos_queue_send_from_isr_failed: tstamp:7665988189 queue:0x0b4ae518
kworker/5:1-1587 [005] … 232.678111: rtos_queue_send_from_isr_failed: tstamp:7665988327 queue:0x0b4af2d8
kworker/5:1-1587 [005] … 232.678113: rtos_queue_send_from_isr_failed: tstamp:7665988464 queue:0x0b4b0098
kworker/5:1-1587 [005] … 232.678115: rtos_queue_send_from_isr_failed: tstamp:7665988602 queue:0x0b4b0e58
kworker/5:1-1587 [005] … 232.678116: rtos_queue_send_from_isr_failed: tstamp:7665988739 queue:0x0b4b1c18
kworker/5:1-1587 [005] … 232.678118: rtos_queue_send_failed: tstamp:7665989315 queue:0x0b4a7258
kworker/5:1-1587 [005] … 232.678120: rtos_queue_send_from_isr_failed: tstamp:7665997650 queue:0x0b4a7258
kworker/5:1-1587 [005] … 232.678124: rtos_queue_send_from_isr_failed: tstamp:7665997799 queue:0x0b4aad68
kworker/5:1-1587 [005] … 232.678126: rtos_queue_send_from_isr_failed: tstamp:7665997938 queue:0x0b4ac998
kworker/5:1-1587 [005] … 232.678128: rtos_queue_send_from_isr_failed: tstamp:7665998076 queue:0x0b4ae518
kworker/5:1-1587 [005] … 232.678130: rtos_queue_send_from_isr_failed: tstamp:7665998214 queue:0x0b4af2d8
kworker/5:1-1587 [005] … 232.678132: rtos_queue_send_from_isr_failed: tstamp:7665998351 queue:0x0b4b0098
kworker/5:1-1587 [005] … 232.678134: rtos_queue_send_from_isr_failed: tstamp:7665998511 queue:0x0b4b0e58
kworker/5:1-1587 [005] … 232.678136: rtos_queue_send_from_isr_failed: tstamp:7665998648 queue:0x0b4b1c18

I see in the system log “embedded_data_height = 0”, it seems embedded_data_height is really 0 lines.
Any ideas where to go next?

Sorry, I am confuse with Xavier. The short frame message for TX2 is talking normal pixel.
Could you program the LINE_TIMER to output lines event to confirm. Have a check the REG VI_CH_LINE_TIMER_0 from TRM.

We seem to be moving in a circle. I have already done this a few posts above. I experimented with different number of rows in REG VI_CH_LINE_TIMER_0 according to TRM information. I’m not receiving CHANSEL_NLINES events. That is, it seems that TX2 does not receive a single line. I checked my changes with camera ov5693, I successfully get CHANSEL_NLINES events every N lines according to what value I write in REG VI_CH_LINE_TIMER_0.

Sorry, too many topic to confuse me.
Could you try 0x3000001 to check each line if can get the event.

I’m not getting any CHANSEL_NLINES events when LINE_TIMER=0x3000001. The same with other values. It seems that TX2 does not receive a single line.

Hello! I have exactly the same issue. I try to launch IMX252C sensor on TX2 NX with jetson-xavier-nx-devkit-tx2-nx ( tegra186-p3636-0001-p3509-0000-a01) I have successfully install vc-mipi-nvidia driver from manufacturer of sensor and turned on nlines options. Driver have to be worked (at least no errors) And there are no any valid data from sensor… Could you help to dig deeper?
dmesg of setting driver

[    3.500296] i2c /dev entries driver
[    3.501600] i2c i2c-2: Added multiplexed i2c bus 9
[    3.501603] i2c-mux-gpio i2c-camera-mux: 1 port mux on 3180000.i2c adapter
[    3.502014] vc_mipi 9-001a: vc_probe(): Probing UNIVERSAL VC MIPI Driver
[    3.502019] vc_mipi 9-001a: vc_mod_setup(): Setup the module
[    3.593207] i2c 9-0010: +--- VC MIPI Camera -----------------------------------+
[    3.593212] i2c 9-0010: | MANUF. | Vision Components               MID: 0x0427 |
[    3.593215] i2c 9-0010: | MODULE | ID:  0x0252                     REV: 0x0008 |
[    3.593218] i2c 9-0010: | SENSOR | SONY IMX252C                                |
[    3.593221] i2c 9-0010: +--------+---------------------------------------------+
[    3.593223] i2c 9-0010: +--- Sensor Registers ------+--------+--------+--------+
[    3.593225] i2c 9-0010: |                           | low    | mid    | high   |
[    3.593227] i2c 9-0010: +---------------------------+--------+--------+--------+
[    3.593230] i2c 9-0010: | idle                      | 0x7000 |        |        |
[    3.593233] i2c 9-0010: | horizontal start          | 0x6013 | 0x6014 |        |
[    3.593236] i2c 9-0010: | vertical start            | 0x600e | 0x600f |        |
[    3.593239] i2c 9-0010: | horizontal end            | 0x0000 | 0x0000 |        |
[    3.593241] i2c 9-0010: | vertical end              | 0x0000 | 0x0000 |        |
[    3.593244] i2c 9-0010: | hor. output width         | 0x6015 | 0x6016 |        |
[    3.593246] i2c 9-0010: | ver. output height        | 0x6010 | 0x6011 |        |
[    3.593249] i2c 9-0010: | exposure                  | 0x028d | 0x028e | 0x028f |
[    3.593251] i2c 9-0010: | gain                      | 0x0404 | 0x0405 |        |
[    3.593253] i2c 9-0010: +---------------------------+--------+--------+--------+
[    3.593256] i2c 9-0010: | clock for ext. trigger    | 74250000 Hz              |
[    3.593259] i2c 9-0010: | pixel clock               | 74250000 Hz              |
[    3.593261] i2c 9-0010: | shutter offset            |    12540 us              |
[    3.593263] i2c 9-0010: +---------------------------+--------------------------+
[    3.593265] i2c 9-0010: +--- Module Modes -------+---------+---------+---------+
[    3.593267] i2c 9-0010: |  # | rate    | lanes   | format  | type    | binning |
[    3.593269] i2c 9-0010: +----+---------+---------+---------+---------+---------+
[    3.593273] i2c 9-0010: |  0 |    1500 |       2 | RAW08   | STREAM  |       0 |
[    3.593277] i2c 9-0010: |  1 |    1500 |       2 | RAW10   | STREAM  |       0 |
[    3.593281] i2c 9-0010: |  2 |    1500 |       2 | RAW12   | STREAM  |       0 |
[    3.593284] i2c 9-0010: |  3 |    1500 |       2 | RAW08   | EXT.TRG |       0 |
[    3.593287] i2c 9-0010: |  4 |    1500 |       2 | RAW10   | EXT.TRG |       0 |
[    3.593290] i2c 9-0010: |  5 |    1500 |       2 | RAW12   | EXT.TRG |       0 |
[    3.593293] i2c 9-0010: |  6 |    1500 |       4 | RAW08   | STREAM  |       0 |
[    3.593296] i2c 9-0010: |  7 |    1500 |       4 | RAW10   | STREAM  |       0 |
[    3.593299] i2c 9-0010: |  8 |    1500 |       4 | RAW12   | STREAM  |       0 |
[    3.593301] i2c 9-0010: |  9 |    1500 |       4 | RAW08   | EXT.TRG |       0 |
[    3.593305] i2c 9-0010: | 10 |    1500 |       4 | RAW10   | EXT.TRG |       0 |
[    3.593307] i2c 9-0010: | 11 |    1500 |       4 | RAW12   | EXT.TRG |       0 |
[    3.593309] i2c 9-0010: +----+---------+---------+---------+---------+---------+
[    3.593312] i2c 9-0010: vc_init_ctrl_imx252(): Initialising module control for IMX252
[    3.594016] vc_mipi 9-001a: vc_sen_read_image_size(): Read image size (width: 2048, height: 1536)
[    3.594019] i2c 9-0010: VC MIPI Core succesfully initialized
[    3.594021] vc_mipi 9-001a: vc_init_io(): Init trigger and flash mode
[    3.594026] i2c 9-0010: vc_mod_set_trigger_mode(): Set trigger mode: DISABLED
[    3.594030] i2c 9-0010: vc_mod_set_io_mode(): Set IO mode: DISABLED
[    3.594035] vc_mipi 9-001a: vc_init_frmfmt(): Init frame (width: 2048, height: 1536, fps: 1000)
[    3.594154] vc_mipi 9-001a: tegracam sensor driver:vc_mipi_v2.0.6
[    3.594192] vc_mipi 9-001a: vc_core_get_format(): Get format 0x3014 (RGGB)
[    3.594196] vc_mipi 9-001a: vc_init_image(): Init image (width: 2048, height: 1536, line_length: 2048, pixel_t: RGGB)
[    3.594199] vc_mipi 9-001a: vc_init_controls(): Read control gain (min: 0, max: 100000, default: 0)
[    3.594202] vc_mipi 9-001a: vc_init_controls(): Overwrite control exposure (min: 1, max: 100000000, default: 10000)
[    3.594206] vc_mipi 9-001a: vc_init_controls(): Overwrite control framerate (min: 0, max: 1000, default: 1000)
[    3.594209] vc_mipi 9-001a: vc_core_set_num_lanes(): Set number of lanes 2
[    3.594211] vc_mipi 9-001a: vc_init_lanes(): Init lanes (num_lanes: 2)
[    3.594214] vc_mipi 9-001a: vc_core_get_num_lanes(): Get number of lanes: 2
[    3.594216] vc_mipi 9-001a: vc_core_get_format(): Get format 0x3014 (RGGB)

V4l2-ctl --set-fmt-video=pixelformat=RGGB,width=2048,height=1536

[   83.854037] vc_mipi 9-001a: vc_sen_set_exposure(): Set sensor exposure: 1 us
[   83.861131] vc_mipi 9-001a: vc_calculate_exposure_vmax(): flags: 0x1e34, toffset: 2903 period_1H: 10000
[   83.861848] vc_mipi 9-001a: vc_sen_read_vmax(): Read sensor VMAX: 0x0000062e (1582)
[   83.861852] vc_mipi 9-001a: vc_sen_write_shs(): Write sensor SHS: 0x00000606 (1542)
[   83.861855] vc_mipi 9-001a: vc_sen_write_shs():   addr: 0x028d <= value: 0x06
[   83.864013] vc_mipi 9-001a: vc_sen_write_shs():   addr: 0x028e <= value: 0x06
[   83.866189] vc_mipi 9-001a: vc_sen_write_shs():   addr: 0x028f <= value: 0x00
[   83.868368] vc_mipi 9-001a: vc_sen_set_exposure(): VMAX:  1582, SHS:  1542, EXPC:      0, RETC:      0

./vcmipidemo -s 1000 -g 10

[  117.182515] embedded_data_height = 0
[  117.183590] vc_mipi 9-001a: vc_core_get_num_lanes(): Get number of lanes: 2
[  117.183595] vc_mipi 9-001a: vc_core_get_format(): Get format 0x3014 (RGGB)
[  117.183599] vc_mipi 9-001a: vc_core_set_format(): Set format 0x3014 (RGGB)
[  117.183603] vc_mipi 9-001a: vc_core_try_format(): Try format 0x3014 (RGGB, format: 0x2a)
[  117.183606] vc_mipi 9-001a: vc_core_try_format(): Checking mode 0 (format: 0x2a)
[  117.183613] i2c 9-0010: vc_mod_set_mode(): Set module mode: (lanes: 2, format: 0x2a, type: 0x01)
[  117.183617] i2c 9-0010: vc_mod_find_mode(): Checking mode (#00, lanes: 2, format: 0x2a, type: 0x01, binning: 0x00)
[  117.183619] i2c 9-0010: vc_mod_reset_module(): Reset the module!
[  117.183622] i2c 9-0010: vc_mod_set_power(): Set module power: down
[  117.183625] i2c 9-0010: vc_mod_set_power():   addr: 0x0100 <= value: 0x02
[  117.185780] i2c 9-0010: vc_mod_write_mode(): Write module mode: 0x00
[  117.185783] i2c 9-0010: vc_mod_write_mode():   addr: 0x0102 <= value: 0x00
[  117.187924] i2c 9-0010: vc_mod_set_power(): Set module power: up
[  117.187929] i2c 9-0010: vc_mod_set_power():   addr: 0x0100 <= value: 0x00
[  117.190082] i2c 9-0010: vc_mod_wait_until_module_is_ready(): Wait until module is ready
[  117.290285] i2c 9-0010: vc_mod_read_status(): Get module status: 0x00
[  117.390482] i2c 9-0010: vc_mod_read_status(): Get module status: 0x00
[  117.490690] i2c 9-0010: vc_mod_read_status(): Get module status: 0x80
[  117.490695] i2c 9-0010: vc_mod_wait_until_module_is_ready(): Module is ready!
[  117.490700] vc_mipi 9-001a: vc_sen_set_roi(): Set sensor roi: (width: 2048, height: 1536)
[  117.490704] vc_mipi 9-001a: vc_sen_write_mode(): Write sensor mode: standby
[  117.490707] vc_mipi 9-001a: vc_sen_write_mode():   addr: 0x7000 <= value: 0x00
[  117.492847] vc_mipi 9-001a: vc_sen_set_roi():   addr: 0x6015 <= value: 0x00
[  117.494988] vc_mipi 9-001a: vc_sen_set_roi():   addr: 0x6016 <= value: 0x08
[  117.497142] vc_mipi 9-001a: vc_sen_set_roi():   addr: 0x6010 <= value: 0x00
[  117.499289] vc_mipi 9-001a: vc_sen_set_roi():   addr: 0x6011 <= value: 0x06
[  117.501432] vc_mipi 9-001a: vc_sen_write_mode(): Write sensor mode: operating
[  117.501435] vc_mipi 9-001a: vc_sen_write_mode():   addr: 0x7000 <= value: 0x01
[  117.503576] vc_mipi 9-001a: vc_sen_set_gain(): Set sensor gain: 0
[  117.509793] vc_mipi 9-001a: vc_sen_set_gain():   addr: 0x0404 <= value: 0x00
[  117.511943] vc_mipi 9-001a: vc_sen_set_gain():   addr: 0x0405 <= value: 0x00
[  117.514086] vc_mipi 9-001a: vc_sen_set_exposure(): Set sensor exposure: 1 us
[  117.521157] vc_mipi 9-001a: vc_calculate_exposure_vmax(): flags: 0x1e34, toffset: 2903 period_1H: 10000
[  117.521852] vc_mipi 9-001a: vc_sen_read_vmax(): Read sensor VMAX: 0x0000062e (1582)
[  117.521856] vc_mipi 9-001a: vc_sen_write_shs(): Write sensor SHS: 0x00000606 (1542)
[  117.521859] vc_mipi 9-001a: vc_sen_write_shs():   addr: 0x028d <= value: 0x06
[  117.523997] vc_mipi 9-001a: vc_sen_write_shs():   addr: 0x028e <= value: 0x06
[  117.526139] vc_mipi 9-001a: vc_sen_write_shs():   addr: 0x028f <= value: 0x00
[  117.528288] vc_mipi 9-001a: vc_sen_set_exposure(): VMAX:  1582, SHS:  1542, EXPC:      0, RETC:      0
[  117.528292] vc_mipi 9-001a: vc_sen_start_stream(): Start streaming
[  117.528296] i2c 9-0010: vc_mod_write_trigger_mode(): Write trigger mode: 0x00
[  117.528299] i2c 9-0010: vc_mod_write_trigger_mode():   addr: 0x0108 <= value: 0x00
[  117.530443] i2c 9-0010: vc_mod_write_io_mode(): Write IO mode: OFF
[  117.530447] i2c 9-0010: vc_mod_write_io_mode():   addr: 0x0103 <= value: 0x00
[  117.532605] vc_mipi 9-001a: vc_sen_start_stream(): MM: 0x00, TM: 0x00, IO: 0x00
[  117.532609] vc_mipi 9-001a: vc_sen_write_mode(): Write sensor mode: operating
[  117.532612] vc_mipi 9-001a: vc_sen_write_mode():   addr: 0x7000 <= value: 0x01
[  118.806980] vc_mipi 9-001a: vc_sen_stop_stream(): Stop streaming
[  118.806988] i2c 9-0010: vc_mod_write_trigger_mode(): Write trigger mode: 0x00
[  118.806992] i2c 9-0010: vc_mod_write_trigger_mode():   addr: 0x0108 <= value: 0x00
[  118.809146] i2c 9-0010: vc_mod_write_io_mode(): Write IO mode: OFF
[  118.809151] i2c 9-0010: vc_mod_write_io_mode():   addr: 0x0103 <= value: 0x00
[  118.812395] vc_mipi 9-001a: vc_sen_write_mode(): Write sensor mode: standby
[  118.812401] vc_mipi 9-001a: vc_sen_write_mode():   addr: 0x7000 <= value: 0x00 

echo 1 > /sys/kernel/debug/tracing/tracing_on
echo 30720 > /sys/kernel/debug/tracing/buffer_size_kb
echo 1 > /sys/kernel/debug/tracing/events/tegra_rtcpu/enable
echo 1 > /sys/kernel/debug/tracing/events/freertos/enable
echo 2 > /sys/kernel/debug/camrtc/log-level
echo > /sys/kernel/debug/tracing/trace
v4l2-ctl -d /dev/video0 --set-ctrl bypass_mode=0 --stream-mmap --stream-count=3
cat /sys/kernel/debug/tracing/trace

kworker/3:3-3019  [003] ....   131.414208: rtos_queue_peek_from_isr_failed: tstamp:4230451618 queue:0x0b4b4940
     kworker/3:3-3019  [003] ....   131.414212: rtcpu_vinotify_event: tstamp:4230791676 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:4230791196 data:0x00000001
     kworker/3:3-3019  [003] ....   131.470207: rtcpu_vinotify_event: tstamp:4231710585 tag:CHANSEL_PXL_SOF channel:0x00 frame:0 vi_tstamp:4231710059 data:0x00000001
     kworker/3:3-3019  [003] ....   131.470210: rtcpu_vinotify_event: tstamp:4231710764 tag:ATOMP_FS channel:0x00 frame:0 vi_tstamp:4231710066 data:0x00000000
     kworker/3:3-3019  [003] ....   131.470210: rtcpu_vinotify_event: tstamp:4231713536 tag:CHANSEL_LOAD_FRAMED channel:0x01 frame:0 vi_tstamp:4231713160 data:0x08000000
     kworker/3:3-3019  [003] ....   131.470211: rtcpu_vinotify_event: tstamp:4231759985 tag:CHANSEL_NLINES channel:0x00 frame:0 vi_tstamp:4231759600 data:0x00ff0010
     kworker/3:3-3019  [003] ....   131.470212: rtcpu_vinotify_event: tstamp:4231809549 tag:CHANSEL_NLINES channel:0x00 frame:0 vi_tstamp:4231809164 data:0x01ff0010
     kworker/3:3-3019  [003] ....   131.470212: rtcpu_vinotify_event: tstamp:4231859113 tag:CHANSEL_NLINES channel:0x00 frame:0 vi_tstamp:4231858727 data:0x02ff0010
     kworker/3:3-3019  [003] ....   131.470213: rtcpu_vinotify_event: tstamp:4231908679 tag:CHANSEL_NLINES channel:0x00 frame:0 vi_tstamp:4231908291 data:0x03ff0010
     kworker/3:3-3019  [003] ....   131.470213: rtcpu_vinotify_event: tstamp:4231958241 tag:CHANSEL_NLINES channel:0x00 frame:0 vi_tstamp:4231957854 data:0x04ff0010
     kworker/3:3-3019  [003] ....   131.470214: rtcpu_vinotify_event: tstamp:4232008119 tag:CHANSEL_PXL_EOF channel:0x00 frame:0 vi_tstamp:4232007418 data:0x05ff0012
     kworker/3:3-3019  [003] ....   131.470214: rtcpu_vinotify_event: tstamp:4232008237 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:4232007441 data:0x00000000
     kworker/3:3-3019  [003] ....   131.470215: rtcpu_vinotify_event: tstamp:4232016858 tag:CHANSEL_PXL_SOF channel:0x00 frame:0 vi_tstamp:4232016346 data:0x00000001
     kworker/3:3-3019  [003] ....   131.470215: rtcpu_vinotify_event: tstamp:4232017025 tag:ATOMP_FS channel:0x00 frame:0 vi_tstamp:4232016353 data:0x00000000
     kworker/3:3-3019  [003] ....   131.470216: rtcpu_vinotify_event: tstamp:4232020838 tag:CHANSEL_LOAD_FRAMED channel:0x01 frame:0 vi_tstamp:4232020463 data:0x08000000
     kworker/3:3-3019  [003] ....   131.470216: rtcpu_vinotify_event: tstamp:4232066390 tag:CHANSEL_NLINES channel:0x00 frame:0 vi_tstamp:4232065888 data:0x00ff0010
     kworker/3:3-3019  [003] ....   131.470217: rtcpu_vinotify_event: tstamp:4232115999 tag:CHANSEL_NLINES channel:0x00 frame:0 vi_tstamp:4232115451 data:0x01ff0010
     kworker/3:3-3019  [003] ....   131.470217: rtcpu_vinotify_event: tstamp:4232165403 tag:CHANSEL_NLINES channel:0x00 frame:0 vi_tstamp:4232165015 data:0x02ff0010
     kworker/3:3-3019  [003] ....   131.470218: rtcpu_vinotify_event: tstamp:4232215075 tag:CHANSEL_NLINES channel:0x00 frame:0 vi_tstamp:4232214578 data:0x03ff0010
     kworker/3:3-3019  [003] ....   131.470219: rtcpu_vinotify_event: tstamp:4232264674 tag:CHANSEL_NLINES channel:0x00 frame:0 vi_tstamp:4232264142 data:0x04ff0010
     kworker/3:3-3019  [003] ....   131.470219: rtcpu_vinotify_event: tstamp:4232314511 tag:CHANSEL_PXL_EOF channel:0x00 frame:0 vi_tstamp:4232313706 data:0x05ff0012
     kworker/3:3-3019  [003] ....   131.470220: rtcpu_vinotify_event: tstamp:4232314806 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:4232313730 data:0x00000000
     kworker/3:3-3019  [003] ....   131.470220: rtcpu_vinotify_event: tstamp:4232323229 tag:CHANSEL_PXL_SOF channel:0x00 frame:0 vi_tstamp:4232322634 data:0x00000001
     kworker/3:3-3019  [003] ....   131.470221: rtcpu_vinotify_event: tstamp:4232323618 tag:ATOMP_FS channel:0x00 frame:0 vi_tstamp:4232322640 data:0x00000000
     kworker/3:3-3019  [003] ....   131.470221: rtcpu_vinotify_event: tstamp:4232326931 tag:CHANSEL_LOAD_FRAMED channel:0x01 frame:0 vi_tstamp:4232326474 data:0x08000000
     kworker/3:3-3019  [003] ....   131.470222: rtcpu_vinotify_event: tstamp:4232372562 tag:CHANSEL_NLINES channel:0x00 frame:0 vi_tstamp:4232372175 data:0x00ff0010
     kworker/3:3-3019  [003] ....   131.470222: rtcpu_vinotify_event: tstamp:4232422127 tag:CHANSEL_NLINES channel:0x00 frame:0 vi_tstamp:4232421738 data:0x01ff0010
     kworker/3:3-3019  [003] ....   131.470223: rtcpu_vinotify_event: tstamp:4232471690 tag:CHANSEL_NLINES channel:0x00 frame:0 vi_tstamp:4232471302 data:0x02ff0010
     kworker/3:3-3019  [003] ....   131.470223: rtcpu_vinotify_event: tstamp:4232521363 tag:CHANSEL_NLINES channel:0x00 frame:0 vi_tstamp:4232520866 data:0x03ff0010
     kworker/3:3-3019  [003] ....   131.470224: rtcpu_vinotify_event: tstamp:4232570921 tag:CHANSEL_NLINES channel:0x00 frame:0 vi_tstamp:4232570430 data:0x04ff0010
     kworker/3:3-3019  [003] ....   131.470224: rtcpu_vinotify_event: tstamp:4232620733 tag:CHANSEL_PXL_EOF channel:0x00 frame:0 vi_tstamp:4232619993 data:0x05ff0012
     kworker/3:3-3019  [003] ....   131.470225: rtcpu_vinotify_event: tstamp:4232620851 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:4232620017 data:0x00000000
     kworker/3:3-3019  [003] ....   131.470225: rtcpu_vinotify_event: tstamp:4232629430 tag:CHANSEL_PXL_SOF channel:0x00 frame:0 vi_tstamp:4232628921 data:0x00000001
     kworker/3:3-3019  [003] ....   131.470226: rtcpu_vinotify_event: tstamp:4232629597 tag:ATOMP_FS channel:0x00 frame:0 vi_tstamp:4232628928 data:0x00000000
     kworker/3:3-3019  [003] ....   131.470226: rtcpu_vinotify_event: tstamp:4232632245 tag:CHANSEL_LOAD_FRAMED channel:0x01 frame:0 vi_tstamp:4232631868 data:0x08000000
     kworker/3:3-3019  [003] ....   131.470227: rtcpu_vinotify_event: tstamp:4232678847 tag:CHANSEL_NLINES channel:0x00 frame:0 vi_tstamp:4232678462 data:0x00ff0010
     kworker/3:3-3019  [003] ....   131.470227: rtcpu_vinotify_event: tstamp:4232728521 tag:CHANSEL_NLINES channel:0x00 frame:0 vi_tstamp:4232728026 data:0x01ff0010
     kworker/3:3-3019  [003] ....   131.470228: rtcpu_vinotify_event: tstamp:4232778083 tag:CHANSEL_NLINES channel:0x00 frame:0 vi_tstamp:4232777589 data:0x02ff0010
     kworker/3:3-3019  [003] ....   131.470228: rtcpu_vinotify_event: tstamp:4232827541 tag:CHANSEL_NLINES channel:0x00 frame:0 vi_tstamp:4232827153 data:0x03ff0010
     kworker/3:3-3019  [003] ....   131.470229: rtcpu_vinotify_event: tstamp:4232877102 tag:CHANSEL_NLINES channel:0x00 frame:0 vi_tstamp:4232876717 data:0x04ff0010
     kworker/3:3-3019  [003] ....   131.470229: rtcpu_vinotify_event: tstamp:4232926980 tag:CHANSEL_PXL_EOF channel:0x00 frame:0 vi_tstamp:4232926280 data:0x05ff0012
     kworker/3:3-3019  [003] ....   131.470230: rtcpu_vinotify_event: tstamp:4232927098 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:4232926304 data:0x00000000
     kworker/3:3-3019  [003] ....   131.470230: rtcpu_vinotify_event: tstamp:4232935731 tag:CHANSEL_PXL_SOF channel:0x00 frame:0 vi_tstamp:4232935209 data:0x00000001
     kworker/3:3-3019  [003] ....   131.470231: rtcpu_vinotify_event: tstamp:4232935899 tag:ATOMP_FS channel:0x00 frame:0 vi_tstamp:4232935215 data:0x00000000
     kworker/3:3-3019  [003] ....   131.470231: rtcpu_vinotify_event: tstamp:4232938819 tag:CHANSEL_LOAD_FRAMED channel:0x01 frame:0 vi_tstamp:4232938444 data:0x08000000
     kworker/3:3-3019  [003] ....   131.470232: rtcpu_vinotify_event: tstamp:4232985136 tag:CHANSEL_NLINES channel:0x00 frame:0 vi_tstamp:4232984750 data:0x00ff0010
     kworker/3:3-3019  [003] ....   131.470232: rtcpu_vinotify_event: tstamp:4233034697 tag:CHANSEL_NLINES channel:0x00 frame:0 vi_tstamp:4233034313 data:0x01ff0010
     kworker/3:3-3019  [003] ....   131.470233: rtcpu_vinotify_event: tstamp:4233084265 tag:CHANSEL_NLINES channel:0x00 frame:0 vi_tstamp:4233083877 data:0x02ff0010
     kworker/3:3-3019  [003] ....   131.470234: rtcpu_vinotify_event: tstamp:4233133830 tag:CHANSEL_NLINES channel:0x00 frame:0 vi_tstamp:4233133441 data:0x03ff0010
     kworker/3:3-3019  [003] ....   131.526354: rtcpu_vinotify_event: tstamp:4233183388 tag:CHANSEL_NLINES channel:0x00 frame:0 vi_tstamp:4233183004 data:0x04ff0010
     kworker/3:3-3019  [003] ....   131.526370: rtcpu_vinotify_event: tstamp:4233233382 tag:CHANSEL_PXL_EOF channel:0x00 frame:0 vi_tstamp:4233232567 data:0x05ff0012
     kworker/3:3-3019  [003] ....   131.526373: rtcpu_vinotify_event: tstamp:4233233685 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:4233232592 data:0x00000000
     kworker/3:3-3019  [003] ....   131.526376: rtcpu_vinotify_event: tstamp:4233242092 tag:CHANSEL_PXL_SOF channel:0x00 frame:0 vi_tstamp:4233241496 data:0x00000001
     kworker/3:3-3019  [003] ....   131.526384: rtcpu_vinotify_event: tstamp:4233242464 tag:ATOMP_FS channel:0x00 frame:0 vi_tstamp:4233241503 data:0x00000000
     kworker/3:3-3019  [003] ....   131.526387: rtcpu_vinotify_event: tstamp:4233253104 tag:CHANSEL_LOAD_FRAMED channel:0x01 frame:0 vi_tstamp:4233252631 data:0x08000000
     kworker/3:3-3019  [003] ....   131.526390: rtcpu_vinotify_event: tstamp:4233291530 tag:CHANSEL_NLINES channel:0x00 frame:0 vi_tstamp:4233291037 data:0x00ff0010
     kworker/3:3-3019  [003] ....   131.526393: rtcpu_vinotify_event: tstamp:4233340984 tag:CHANSEL_NLINES channel:0x00 frame:0 vi_tstamp:4233340600 data:0x01ff0010
     kworker/3:3-3019  [003] ....   131.526396: rtcpu_vinotify_event: tstamp:4233390548 tag:CHANSEL_NLINES channel:0x00 frame:0 vi_tstamp:4233390164 data:0x02ff0010
     kworker/3:3-3019  [003] ....   131.526399: rtcpu_vinotify_event: tstamp:4233440220 tag:CHANSEL_NLINES channel:0x00 frame:0 vi_tstamp:4233439728 data:0x03ff0010
     kworker/3:3-3019  [003] ....   131.526401: rtcpu_vinotify_event: tstamp:4233489676 tag:CHANSEL_NLINES channel:0x00 frame:0 vi_tstamp:4233489292 data:0x04ff0010
     kworker/3:3-3019  [003] ....   131.526404: rtcpu_vinotify_event: tstamp:4233539553 tag:CHANSEL_PXL_EOF channel:0x00 frame:0 vi_tstamp:4233538855 data:0x05ff0012
     kworker/3:3-3019  [003] ....   131.526407: rtcpu_vinotify_event: tstamp:4233539671 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:4233538879 data:0x00000000
     kworker/3:3-3019  [003] ....   131.526409: rtcpu_vinotify_event: tstamp:4233548299 tag:CHANSEL_PXL_SOF channel:0x00 frame:0 vi_tstamp:4233547783 data:0x00000001
     kworker/3:3-3019  [003] ....   131.526412: rtcpu_vinotify_event: tstamp:4233548464 tag:ATOMP_FS channel:0x00 frame:0 vi_tstamp:4233547790 data:0x00000000
     kworker/3:3-3019  [003] ....   131.526414: rtcpu_vinotify_event: tstamp:4233597718 tag:CHANSEL_NLINES channel:0x00 frame:0 vi_tstamp:4233597324 data:0x00ff0010
     kworker/3:3-3019  [003] ....   131.526417: rtcpu_vinotify_event: tstamp:4233647276 tag:CHANSEL_NLINES channel:0x00 frame:0 vi_tstamp:4233646887 data:0x01ff0010
     kworker/3:3-3019  [003] ....   131.526420: rtcpu_vinotify_event: tstamp:4233696835 tag:CHANSEL_NLINES channel:0x00 frame:0 vi_tstamp:4233696452 data:0x02ff0010
     kworker/3:3-3019  [003] ....   131.526422: rtcpu_vinotify_event: tstamp:4233746396 tag:CHANSEL_NLINES channel:0x00 frame:0 vi_tstamp:4233746015 data:0x03ff0010
     kworker/3:3-3019  [003] ....   131.526425: rtcpu_vinotify_event: tstamp:4233796061 tag:CHANSEL_NLINES channel:0x00 frame:0 vi_tstamp:4233795579 data:0x04ff0010
     kworker/3:3-3019  [003] ....   131.526428: rtcpu_vinotify_event: tstamp:4233845929 tag:CHANSEL_PXL_EOF channel:0x00 frame:0 vi_tstamp:4233845142 data:0x05ff0012
     kworker/3:3-3019  [003] ....   131.526430: rtcpu_vinotify_event: tstamp:4233846224 tag:ATOMP_FE channel:0x00 frame:0 vi_tstamp:4233845166 data:0x00000000
     kworker/3:3-3019  [003] ....   131.526444: rtos_queue_send_from_isr_failed: tstamp:4233852553 queue:0x0b4a7698

dmesg

[  131.064579] embedded_data_height = 0
[  131.065658] vc_mipi 9-001a: vc_core_get_num_lanes(): Get number of lanes: 2
[  131.065662] vc_mipi 9-001a: vc_core_get_format(): Get format 0x3014 (RGGB)
[  131.065666] vc_mipi 9-001a: vc_core_set_format(): Set format 0x3014 (RGGB)
[  131.065670] vc_mipi 9-001a: vc_core_try_format(): Try format 0x3014 (RGGB, format: 0x2a)
[  131.065673] vc_mipi 9-001a: vc_core_try_format(): Checking mode 0 (format: 0x2a)
[  131.065680] i2c 9-0010: vc_mod_set_mode(): Set module mode: (lanes: 2, format: 0x2a, type: 0x01)
[  131.065684] i2c 9-0010: vc_mod_find_mode(): Checking mode (#00, lanes: 2, format: 0x2a, type: 0x01, binning: 0x00)
[  131.065686] i2c 9-0010: vc_mod_reset_module(): Reset the module!
[  131.065689] i2c 9-0010: vc_mod_set_power(): Set module power: down
[  131.065692] i2c 9-0010: vc_mod_set_power():   addr: 0x0100 <= value: 0x02
[  131.067851] i2c 9-0010: vc_mod_write_mode(): Write module mode: 0x00
[  131.067855] i2c 9-0010: vc_mod_write_mode():   addr: 0x0102 <= value: 0x00
[  131.070017] i2c 9-0010: vc_mod_set_power(): Set module power: up
[  131.070022] i2c 9-0010: vc_mod_set_power():   addr: 0x0100 <= value: 0x00
[  131.072171] i2c 9-0010: vc_mod_wait_until_module_is_ready(): Wait until module is ready
[  131.172420] i2c 9-0010: vc_mod_read_status(): Get module status: 0x00
[  131.272622] i2c 9-0010: vc_mod_read_status(): Get module status: 0x00
[  131.372816] i2c 9-0010: vc_mod_read_status(): Get module status: 0x80
[  131.372820] i2c 9-0010: vc_mod_wait_until_module_is_ready(): Module is ready!
[  131.372825] vc_mipi 9-001a: vc_sen_set_roi(): Set sensor roi: (width: 2048, height: 1536)
[  131.372829] vc_mipi 9-001a: vc_sen_write_mode(): Write sensor mode: standby
[  131.372832] vc_mipi 9-001a: vc_sen_write_mode():   addr: 0x7000 <= value: 0x00
[  131.374979] vc_mipi 9-001a: vc_sen_set_roi():   addr: 0x6015 <= value: 0x00
[  131.377125] vc_mipi 9-001a: vc_sen_set_roi():   addr: 0x6016 <= value: 0x08
[  131.379269] vc_mipi 9-001a: vc_sen_set_roi():   addr: 0x6010 <= value: 0x00
[  131.381419] vc_mipi 9-001a: vc_sen_set_roi():   addr: 0x6011 <= value: 0x06
[  131.383560] vc_mipi 9-001a: vc_sen_write_mode(): Write sensor mode: operating
[  131.383563] vc_mipi 9-001a: vc_sen_write_mode():   addr: 0x7000 <= value: 0x01
[  131.385706] vc_mipi 9-001a: vc_sen_set_gain(): Set sensor gain: 0
[  131.391893] vc_mipi 9-001a: vc_sen_set_gain():   addr: 0x0404 <= value: 0x00
[  131.394176] vc_mipi 9-001a: vc_sen_set_gain():   addr: 0x0405 <= value: 0x00
[  131.396386] vc_mipi 9-001a: vc_sen_set_exposure(): Set sensor exposure: 1 us
[  131.403469] vc_mipi 9-001a: vc_calculate_exposure_vmax(): flags: 0x1e34, toffset: 2903 period_1H: 10000
[  131.404148] vc_mipi 9-001a: vc_sen_read_vmax(): Read sensor VMAX: 0x0000062e (1582)
[  131.404151] vc_mipi 9-001a: vc_sen_write_shs(): Write sensor SHS: 0x00000606 (1542)
[  131.404154] vc_mipi 9-001a: vc_sen_write_shs():   addr: 0x028d <= value: 0x06
[  131.406292] vc_mipi 9-001a: vc_sen_write_shs():   addr: 0x028e <= value: 0x06
[  131.408435] vc_mipi 9-001a: vc_sen_write_shs():   addr: 0x028f <= value: 0x00
[  131.410578] vc_mipi 9-001a: vc_sen_set_exposure(): VMAX:  1582, SHS:  1542, EXPC:      0, RETC:      0
[  131.410582] vc_mipi 9-001a: vc_sen_start_stream(): Start streaming
[  131.410585] i2c 9-0010: vc_mod_write_trigger_mode(): Write trigger mode: 0x00
[  131.410588] i2c 9-0010: vc_mod_write_trigger_mode():   addr: 0x0108 <= value: 0x00
[  131.412732] i2c 9-0010: vc_mod_write_io_mode(): Write IO mode: OFF
[  131.412735] i2c 9-0010: vc_mod_write_io_mode():   addr: 0x0103 <= value: 0x00
[  131.414884] vc_mipi 9-001a: vc_sen_start_stream(): MM: 0x00, TM: 0x00, IO: 0x00
[  131.414887] vc_mipi 9-001a: vc_sen_write_mode(): Write sensor mode: operating
[  131.414889] vc_mipi 9-001a: vc_sen_write_mode():   addr: 0x7000 <= value: 0x01
[  131.493557] vc_mipi 9-001a: vc_sen_stop_stream(): Stop streaming
[  131.493596] i2c 9-0010: vc_mod_write_trigger_mode(): Write trigger mode: 0x00
[  131.493617] i2c 9-0010: vc_mod_write_trigger_mode():   addr: 0x0108 <= value: 0x00
[  131.495933] i2c 9-0010: vc_mod_write_io_mode(): Write IO mode: OFF
[  131.495958] i2c 9-0010: vc_mod_write_io_mode():   addr: 0x0103 <= value: 0x00
[  131.498343] vc_mipi 9-001a: vc_sen_write_mode(): Write sensor mode: standby
[  131.498363] vc_mipi 9-001a: vc_sen_write_mode():   addr: 0x7000 <= value: 0x00

What do you mean there are no any valid data from sensor?
From the trace log look like capture done well.

In output - black screen, if we output to file - data like this

10 0f 0f 0f 0f 0f 0f 0e 0f 0f 10 0f 10 0f 0f 0f
10 0f 0f 0f 10 0f 0f 0e 10 0f 0f 10 10 10 0f 0f
0f 10 0f 0f 10 0f 0f 0f 0f 0f 0f 0f 0f 0e 0f 0f
0f 10 10 0f 0f 0f 10 0f 0f 0f 0f 0f 0f 0f 0f 0f
0f 0f 0f 0f 0f 0f 0f 0f 0f 0f 0f 0f 0f 0f 0f 0f
0f 0f 0f 0f 0f 0f 0f 0f 0f 0f 0f 0f 0f 0e 0f 0f

that is why I am asking for help … In the debug and trace log I do not see what to catch on to…