CSI camera driver fro ADV7280-m : PXL_SOF syncpt timeout =-11

I am having a similar issue on with the adv7280-m , dmesg shows : PXL_SOF syncpt timeout! err = -11
and a captured trace of VI shows CSIMUX_STREAM after a frame with rtos_queue_peek_from_isr_failed every couple CSIMUX_STREAM.
[3] active_w=720 and active_h=507 I obtained from the datasheet of the encoder. I was not sure about the line_length, I am using 768 but in the datasheet it is mentioned as it is measure and predicted internally. It says it outputs a 720 active pixels per line.
any ideas?

I captured some of the frames that come through and they look fine. The VI block times out after a hard-coded time due to not reading a SOF frame.

using Jetpack3.3, tegra L4T 28.2.1, TX2, modified driver , DTS.

I tried adding all the patches and tried adding the delay as described on this forum:
https://devtalk.nvidia.com/default/topic/1032730/jetson-tx2/adv7280m-error-pxl_sof-syncpt-timeout-/

I seem to be getting like one frame per seconds , assuming that the trace below (TIMESTAMP ) is in seconds.

cat /sys/kernel/debug/tracing/trace
# tracer: nop
#
# entries-in-buffer/entries-written: 235/235   #P:4
#
#                              _-----=> irqs-off
#                             / _----=> need-resched
#                            | / _---=> hardirq/softirq
#                            || / _--=> preempt-depth
#                            ||| /     delay
#           TASK-PID   CPU#  ||||    TIMESTAMP  FUNCTION
#              | |       |   ||||       |         |
     kworker/4:2-263   [004] ...1   473.461352: rtos_queue_peek_from_isr_failed: tstamp:15130021067 queue:0x0b4a3c58
     kworker/4:2-263   [004] ...1   473.461359: rtcpu_start: tstamp:15130022968
     kworker/4:2-263   [004] ...1   473.461362: rtcpu_vinotify_handle_msg: tstamp:15130400028 tag:CHANSEL_PXL_SOF channel:0x00 frame:1 vi_tstamp:2245497585 data:0x00000001
     kworker/4:2-263   [004] ...1   473.461363: rtcpu_vinotify_handle_msg: tstamp:15130400237 tag:ATOMP_FS channel:0x00 frame:1 vi_tstamp:2245497613 data:0x00000000
     kworker/4:2-263   [004] ...1   473.461364: rtcpu_vinotify_handle_msg: tstamp:15130402415 tag:CHANSEL_LOAD_FRAMED channel:0x10 frame:1 vi_tstamp:2245500103 data:0x08000000
     kworker/4:2-263   [004] ...1   473.513423: rtcpu_vinotify_handle_msg: tstamp:15130903340 tag:CHANSEL_PXL_EOF channel:0x00 frame:1 vi_tstamp:2246000854 data:0x01fa0002
     kworker/4:2-263   [004] ...1   473.513430: rtcpu_vinotify_handle_msg: tstamp:15130903477 tag:ATOMP_FE channel:0x00 frame:1 vi_tstamp:2246000893 data:0x00000000
     kworker/4:2-263   [004] ...1   473.513432: rtcpu_vinotify_handle_msg: tstamp:15130912271 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2246009955 data:0x00010000
     kworker/4:2-263   [004] ...1   473.513434: rtcpu_vinotify_handle_msg: tstamp:15131433589 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2246531272 data:0x00010000
     kworker/4:2-263   [004] ...1   473.513435: rtcpu_vinotify_handle_msg: tstamp:15131954944 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2247052628 data:0x00010000
     kworker/4:2-263   [004] ...1   473.565425: rtcpu_vinotify_handle_msg: tstamp:15132476332 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2247574007 data:0x00010000
     kworker/4:2-263   [004] ...1   473.565433: rtcpu_vinotify_handle_msg: tstamp:15132997694 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2248095377 data:0x00010000
     kworker/4:2-263   [004] ...1   473.565436: rtcpu_vinotify_handle_msg: tstamp:15133519049 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2248616734 data:0x00010000
     kworker/4:2-263   [004] ...1   473.617409: rtcpu_vinotify_handle_msg: tstamp:15134040404 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2249138084 data:0x00010000
     kworker/4:2-263   [004] ...1   473.617415: rtcpu_vinotify_handle_msg: tstamp:15134561755 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2249659439 data:0x00010000
     kworker/4:2-263   [004] ...1   473.617420: rtos_queue_peek_from_isr_failed: tstamp:15135021959 queue:0x0b4a3c58
     kworker/4:2-263   [004] ...1   473.617422: rtcpu_vinotify_handle_msg: tstamp:15135083115 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2250180798 data:0x00010000
     kworker/4:2-263   [004] ...1   473.669416: rtcpu_vinotify_handle_msg: tstamp:15135604476 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2250702160 data:0x00010000
     kworker/4:2-263   [004] ...1   473.669423: rtcpu_vinotify_handle_msg: tstamp:15136125835 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2251223519 data:0x00010000
     kworker/4:2-263   [004] ...1   473.669426: rtcpu_vinotify_handle_msg: tstamp:15136647191 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2251744877 data:0x00010000
     kworker/4:2-263   [004] ...1   473.721391: rtcpu_vinotify_handle_msg: tstamp:15137168550 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2252266235 data:0x00010000
     kworker/4:2-263   [004] ...1   473.721395: rtcpu_vinotify_handle_msg: tstamp:15137689911 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2252787594 data:0x00010000
     kworker/4:2-263   [004] ...1   473.721397: rtcpu_vinotify_handle_msg: tstamp:15138211267 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2253308951 data:0x00010000
     kworker/4:2-263   [004] ...1   473.773383: rtcpu_vinotify_handle_msg: tstamp:15138732626 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2253830310 data:0x00010000
     kworker/4:2-263   [004] ...1   473.773387: rtcpu_vinotify_handle_msg: tstamp:15139253985 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2254351668 data:0x00010000
     kworker/4:2-263   [004] ...1   473.773389: rtcpu_vinotify_handle_msg: tstamp:15139775342 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2254873026 data:0x00010000
     kworker/4:2-263   [004] ...1   473.773395: rtos_queue_peek_from_isr_failed: tstamp:15140022464 queue:0x0b4a3c58
     kworker/4:2-263   [004] ...1   473.773397: rtcpu_vinotify_handle_msg: tstamp:15140296702 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2255394384 data:0x00010000
     kworker/4:2-263   [004] ...1   473.825406: rtcpu_vinotify_handle_msg: tstamp:15140818059 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2255915743 data:0x00010000
     kworker/4:2-263   [004] ...1   473.825410: rtcpu_vinotify_handle_msg: tstamp:15141339417 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2256437101 data:0x00010000
     kworker/4:2-263   [004] ...1   473.825413: rtcpu_vinotify_handle_msg: tstamp:15141860776 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2256958459 data:0x00010000
     kworker/4:2-263   [004] ...1   473.877387: rtcpu_vinotify_handle_msg: tstamp:15142382132 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2257479817 data:0x00010000
     kworker/4:2-263   [004] ...1   473.877392: rtcpu_vinotify_handle_msg: tstamp:15142903491 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2258001176 data:0x00010000
     kworker/4:2-263   [004] ...1   473.877394: rtcpu_vinotify_handle_msg: tstamp:15143424850 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2258522534 data:0x00010000
     kworker/4:2-263   [004] ...1   473.929423: rtcpu_vinotify_handle_msg: tstamp:15143946211 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2259043891 data:0x00010000
     kworker/4:2-263   [004] ...1   473.929432: rtcpu_vinotify_handle_msg: tstamp:15144467566 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2259565250 data:0x00010000
     kworker/4:2-263   [004] ...1   473.929434: rtcpu_vinotify_handle_msg: tstamp:15144988913 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2260086608 data:0x00010000
     kworker/4:2-263   [004] ...1   473.929440: rtos_queue_peek_from_isr_failed: tstamp:15145022968 queue:0x0b4a3c58
     kworker/4:2-263   [004] ...1   473.981391: rtcpu_vinotify_handle_msg: tstamp:15145510289 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2260607966 data:0x00010000
     kworker/4:2-263   [004] ...1   473.981395: rtcpu_vinotify_handle_msg: tstamp:15146031642 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2261129325 data:0x00010000
     kworker/4:2-263   [004] ...1   473.981398: rtcpu_vinotify_handle_msg: tstamp:15146553000 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2261650683 data:0x00010000
     kworker/4:2-263   [004] ...1   474.033383: rtcpu_vinotify_handle_msg: tstamp:15147074360 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2262172041 data:0x00010000
     kworker/4:2-263   [004] ...1   474.033387: rtcpu_vinotify_handle_msg: tstamp:15147595717 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2262693399 data:0x00010000
     kworker/4:2-263   [004] ...1   474.033389: rtcpu_vinotify_handle_msg: tstamp:15148117074 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2263214757 data:0x00010000
     kworker/4:2-263   [004] ...1   474.085383: rtcpu_vinotify_handle_msg: tstamp:15148638433 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2263736115 data:0x00010000
     kworker/4:2-263   [004] ...1   474.085386: rtcpu_vinotify_handle_msg: tstamp:15149159794 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2264257474 data:0x00010000
     kworker/4:2-263   [004] ...1   474.085389: rtcpu_vinotify_handle_msg: tstamp:15149681149 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2264778832 data:0x00010000
     kworker/4:2-263   [004] ...1   474.085392: rtos_queue_peek_from_isr_failed: tstamp:15150023482 queue:0x0b4a3c58
     kworker/4:2-263   [004] ...1   474.137414: rtcpu_vinotify_handle_msg: tstamp:15150202508 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2265300191 data:0x00010000
     kworker/4:2-263   [004] ...1   474.137422: rtcpu_vinotify_handle_msg: tstamp:15150723862 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2265821549 data:0x00010000
     kworker/4:2-263   [004] ...1   474.137425: rtcpu_vinotify_handle_msg: tstamp:15151245224 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2266342907 data:0x00010000
     kworker/4:2-263   [004] ...1   474.189450: rtcpu_vinotify_handle_msg: tstamp:15151766583 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2266864265 data:0x00010000
     kworker/4:2-263   [004] ...1   474.189455: rtcpu_vinotify_handle_msg: tstamp:15152287938 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2267385623 data:0x00010000
     kworker/4:2-263   [004] ...1   474.189458: rtcpu_vinotify_handle_msg: tstamp:15152809298 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2267906981 data:0x00010000
     kworker/4:2-263   [004] ...1   474.189460: rtcpu_vinotify_handle_msg: tstamp:15153330656 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2268428340 data:0x00010000
     kworker/4:2-263   [004] ...1   474.241435: rtcpu_vinotify_handle_msg: tstamp:15153852014 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2268949698 data:0x00010000
     kworker/4:2-263   [004] ...1   474.241438: rtcpu_vinotify_handle_msg: tstamp:15154373370 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2269471056 data:0x00010000
     kworker/4:2-263   [004] ...1   474.241441: rtcpu_vinotify_handle_msg: tstamp:15154894732 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2269992415 data:0x00010000
     kworker/4:2-263   [004] ...1   474.293432: rtos_queue_peek_from_isr_failed: tstamp:15155023986 queue:0x0b4a3c58
     kworker/4:2-263   [004] ...1   474.293441: rtcpu_vinotify_handle_msg: tstamp:15155416089 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2270513772 data:0x00010000
     kworker/4:2-263   [004] ...1   474.293443: rtcpu_vinotify_handle_msg: tstamp:15155937448 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2271035131 data:0x00010000
     kworker/4:2-263   [004] ...1   474.293446: rtcpu_vinotify_handle_msg: tstamp:15156458811 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2271556489 data:0x00010000
     kworker/4:2-263   [004] ...1   474.345414: rtcpu_vinotify_handle_msg: tstamp:15156980166 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2272077848 data:0x00010000
     kworker/4:2-263   [004] ...1   474.345419: rtcpu_vinotify_handle_msg: tstamp:15157501522 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2272599205 data:0x00010000
     kworker/4:2-263   [004] ...1   474.345422: rtcpu_vinotify_handle_msg: tstamp:15158022880 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2273120564 data:0x00010000
     kworker/4:2-263   [004] ...1   474.397419: rtcpu_vinotify_handle_msg: tstamp:15158544238 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2273641922 data:0x00010000
     kworker/4:2-263   [004] ...1   474.397427: rtcpu_vinotify_handle_msg: tstamp:15159065585 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2274163281 data:0x00010000
     kworker/4:2-263   [004] ...1   474.397430: rtcpu_vinotify_handle_msg: tstamp:15159586952 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2274684639 data:0x00010000
     kworker/4:2-263   [004] ...1   474.449403: rtos_queue_peek_from_isr_failed: tstamp:15160024504 queue:0x0b4a3c58
     kworker/4:2-263   [004] ...1   474.449407: rtcpu_vinotify_handle_msg: tstamp:15160108314 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2275205998 data:0x00010000
     kworker/4:2-263   [004] ...1   474.449409: rtcpu_vinotify_handle_msg: tstamp:15160629672 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2275727356 data:0x00010000
     kworker/4:2-263   [004] ...1   474.449411: rtcpu_vinotify_handle_msg: tstamp:15161151031 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2276248714 data:0x00010000
     kworker/4:2-263   [004] ...1   474.501400: rtcpu_vinotify_handle_msg: tstamp:15161672390 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2276770072 data:0x00010000
     kworker/4:2-263   [004] ...1   474.501410: rtos_queue_peek_from_isr_failed: tstamp:15162117675 queue:0x0b4a3c58
     kworker/4:2-263   [004] ...1   474.501413: rtos_queue_peek_from_isr_failed: tstamp:15162654422 queue:0x0b4a3c58
     kworker/4:2-263   [004] ...1   474.501417: rtcpu_start: tstamp:15162655576
     kworker/4:2-263   [004] ...1   474.501419: rtcpu_vinotify_handle_msg: tstamp:15162706051 tag:CSIMUX_FRAME channel:0x00 frame:1 vi_tstamp:2277803724 data:0x00800264
     kworker/4:2-263   [004] ...1   474.501422: rtcpu_vinotify_handle_msg: tstamp:15162715111 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2277812789 data:0x00010000
     kworker/4:2-263   [004] ...1   474.501424: rtcpu_vinotify_handle_msg: tstamp:15162724176 tag:CHANSEL_PXL_SOF channel:0x00 frame:1 vi_tstamp:2277821731 data:0x00000001
     kworker/4:2-263   [004] ...1   474.501426: rtcpu_vinotify_handle_msg: tstamp:15162724361 tag:ATOMP_FS channel:0x00 frame:1 vi_tstamp:2277821760 data:0x00000000
     kworker/4:2-263   [004] ...1   474.501429: rtcpu_vinotify_handle_msg: tstamp:15162728374 tag:CHANSEL_LOAD_FRAMED channel:0x10 frame:1 vi_tstamp:2277826066 data:0x08000000
     kworker/4:2-263   [004] ...1   474.553390: rtcpu_vinotify_handle_msg: tstamp:15163227529 tag:CHANSEL_PXL_EOF channel:0x00 frame:1 vi_tstamp:2278325045 data:0x01fa0002
     kworker/4:2-263   [004] ...1   474.553395: rtcpu_vinotify_handle_msg: tstamp:15163227696 tag:ATOMP_FE channel:0x00 frame:1 vi_tstamp:2278325084 data:0x00000000
     kworker/4:2-263   [004] ...1   474.553397: rtcpu_vinotify_handle_msg: tstamp:15163236462 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2278334146 data:0x00010000
     kworker/4:2-263   [004] ...1   474.553399: rtcpu_vinotify_handle_msg: tstamp:15163757822 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2278855505 data:0x00010000
     kworker/4:2-263   [004] ...1   474.553402: rtcpu_vinotify_handle_msg: tstamp:15164279181 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2279376864 data:0x00010000
     kworker/4:2-263   [004] ...1   474.605387: rtcpu_vinotify_handle_msg: tstamp:15164800540 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2279898222 data:0x00010000

The message “CSIMUX_STREAM data:0x00010000” tell Spurious data means VI sees some other packets before FS packet, as VI alwasy expect the 1st packet to be frame start

kworker/4:2-263   [004] ...1   474.501422: rtcpu_vinotify_handle_msg: tstamp:15162715111 tag:CSIMUX_STREAM channel:0xff frame:0 vi_tstamp:2277812789 data:0x00010000

any ideas why this is this happening ? Why is VI not seeing FS packet?

You have to check with the vendor.