IMX214 Camera Works with V4L2-CTL but not GStreamer

Hi,

Using TX2 with JetPack 3.2, I have modified the stock OV5693 driver to work with my IMX214 sensor.

Using v4l2-ctl I’m able to retrieve a RAW image

nvidia@tegra-ubuntu:~$ v4l2-ctl -d /dev/video0 --set-fmt-video=width=4208,height=3120,pixelformat=RG10 --stream-mmap --set-ctrl bypass_mode=0 --stream-count=100
<<<<<<<<<<<<<<<<<<<<<<<<<<<<< 27.18 fps
<<<<<<<<<<<<<<<<<<<<<<<<<<< 27.22 fps
<<<<<<<<<<<<<<<<<<<<<<<<<<< 27.15 fps
<<<<<<<<<<<<<<<<<

Successful dmesg

...
[   15.686536] PD DISP1 index3 DOWN
[   15.686611] PD DISP0 index2 DOWN
[   15.704276] tegradc 15210000.nvdisplay: unblank
[   15.704288] PD DISP0 index2 UP
[   15.705395] PD DISP1 index3 UP
[   15.705475] PD DISP2 index4 UP
[   15.706943] Parent Clock set for DC plld2
[   15.708568] tegradc 15210000.nvdisplay: hdmi: pclk:148500K, set prod-setting:prod_c_150M
[   15.768266] tegradc 15210000.nvdisplay: unblank
[   16.268578] IPVS: Creating netns size=1424 id=3
[  150.156012] imx214 2-0010: imx214_power_on: power on
[  150.200629] imx214 2-0010: imx214_s_stream++
[  150.448161] imx214 2-0010: imx214_s_stream--
[  154.319991] imx214 2-0010: imx214_s_stream++
[  154.347606] imx214 2-0010: imx214_power_off: power off

Successful trace

# tracer: nop
#
# entries-in-buffer/entries-written: 543/543   #P:4
#
#                              _-----=> irqs-off
#                             / _----=> need-resched
#                            | / _---=> hardirq/softirq
#                            || / _--=> preempt-depth
#                            ||| /     delay
#           TASK-PID   CPU#  ||||    TIMESTAMP  FUNCTION
#              | |       |   ||||       |         |
     kworker/3:2-185   [003] ...1   150.246470: rtos_queue_peek_from_isr_failed: tstamp:5029021780 queue:0x0b4a3c58
     kworker/3:2-185   [003] ...1   150.246478: rtcpu_start: tstamp:5029022647
     kworker/3:2-185   [003] ...1   150.402455: rtos_queue_peek_from_isr_failed: tstamp:5034022686 queue:0x0b4a3c58
     kworker/3:2-185   [003] ...1   150.558471: rtos_queue_peek_from_isr_failed: tstamp:5039023169 queue:0x0b4a3c58
     kworker/3:2-185   [003] ...1   150.558476: rtcpu_vinotify_handle_msg: tstamp:5039138828 tag:ATOMP_FS channel:0x00 frame:3 vi_tstamp:744171087 data:0x00000000
     kworker/3:2-185   [003] ...1   150.558478: rtcpu_vinotify_handle_msg: tstamp:5039141281 tag:CHANSEL_PXL_SOF channel:0x00 frame:3 vi_tstamp:744173552 data:0x00000001
     kworker/3:2-185   [003] ...1   150.558480: rtcpu_vinotify_handle_msg: tstamp:5039144472 tag:CHANSEL_LOAD_FRAMED channel:0x10 frame:3 vi_tstamp:744176750 data:0x08000000
     kworker/3:2-185   [003] ...1   150.610488: rtcpu_vinotify_handle_msg: tstamp:5040271633 tag:CHANSEL_PXL_EOF channel:0x00 frame:3 vi_tstamp:745303721 data:0x0c2f0002
     kworker/3:2-185   [003] ...1   150.610492: rtcpu_vinotify_handle_msg: tstamp:5040271774 tag:ATOMP_FE channel:0x00 frame:3 vi_tstamp:745303738 data:0x00000000
     kworker/3:2-185   [003] ...1   150.610494: rtcpu_vinotify_handle_msg: tstamp:5040290816 tag:ATOMP_FS channel:0x00 frame:4 vi_tstamp:745323090 data:0x00000000
     kworker/3:2-185   [003] ...1   150.610495: rtcpu_vinotify_handle_msg: tstamp:5040293273 tag:CHANSEL_PXL_SOF channel:0x00 frame:4 vi_tstamp:745325553 data:0x00000001
     kworker/3:2-185   [003] ...1   150.610497: rtcpu_vinotify_handle_msg: tstamp:5040295820 tag:CHANSEL_LOAD_FRAMED channel:0x10 frame:4 vi_tstamp:745328097 data:0x08000000
     kworker/3:2-185   [003] ...1   150.610499: rtcpu_vinotify_handle_msg: tstamp:5041423622 tag:CHANSEL_PXL_EOF channel:0x00 frame:4 vi_tstamp:746455723 data:0x0c2f0002
     kworker/3:2-185   [003] ...1   150.610500: rtcpu_vinotify_handle_msg: tstamp:5041423762 tag:ATOMP_FE channel:0x00 frame:4 vi_tstamp:746455741 data:0x00000000
     kworker/3:2-185   [003] ...1   150.610502: rtcpu_vinotify_handle_msg: tstamp:5041442816 tag:ATOMP_FS channel:0x00 frame:5 vi_tstamp:746475092 data:0x00000000
     kworker/3:2-185   [003] ...1   150.610503: rtcpu_vinotify_handle_msg: tstamp:5041445278 tag:CHANSEL_PXL_SOF channel:0x00 frame:5 vi_tstamp:746477556 data:0x00000001
     kworker/3:2-185   [003] ...1   150.610505: rtcpu_vinotify_handle_msg: tstamp:5041447884 tag:CHANSEL_LOAD_FRAMED channel:0x10 frame:5 vi_tstamp:746480163 data:0x08000000
     kworker/3:2-185   [003] ...1   150.662490: rtcpu_vinotify_handle_msg: tstamp:5042575623 tag:CHANSEL_PXL_EOF channel:0x00 frame:5 vi_tstamp:747607725 data:0x0c2f0002
     kworker/3:2-185   [003] ...1   150.662496: rtcpu_vinotify_handle_msg: tstamp:5042575763 tag:ATOMP_FE channel:0x00 frame:5 vi_tstamp:747607743 data:0x00000000
     kworker/3:2-185   [003] ...1   150.662497: rtcpu_vinotify_handle_msg: tstamp:5042594825 tag:ATOMP_FS channel:0x00 frame:6 vi_tstamp:747627095 data:0x00000000
     kworker/3:2-185   [003] ...1   150.662499: rtcpu_vinotify_handle_msg: tstamp:5042597277 tag:CHANSEL_PXL_SOF channel:0x00 frame:6 vi_tstamp:747629558 data:0x00000001
     kworker/3:2-185   [003] ...1   150.662500: rtcpu_vinotify_handle_msg: tstamp:5042600037 tag:CHANSEL_LOAD_FRAMED channel:0x10 frame:6 vi_tstamp:747632308 data:0x08000000
     kworker/3:2-185   [003] ...1   150.714488: rtcpu_vinotify_handle_msg: tstamp:5043727661 tag:CHANSEL_PXL_EOF channel:0x00 frame:6 vi_tstamp:748759727 data:0x0c2f0002
     kworker/3:2-185   [003] ...1   150.714494: rtcpu_vinotify_handle_msg: tstamp:5043727814 tag:ATOMP_FE channel:0x00 frame:6 vi_tstamp:748759745 data:0x00000000
     kworker/3:2-185   [003] ...1   150.714496: rtcpu_vinotify_handle_msg: tstamp:5043746818 tag:ATOMP_FS channel:0x00 frame:7 vi_tstamp:748779097 data:0x00000000
     kworker/3:2-185   [003] ...1   150.714497: rtcpu_vinotify_handle_msg: tstamp:5043749277 tag:CHANSEL_PXL_SOF channel:0x00 frame:7 vi_tstamp:748781561 data:0x00000001
     kworker/3:2-185   [003] ...1   150.714499: rtcpu_vinotify_handle_msg: tstamp:5043752253 tag:CHANSEL_LOAD_FRAMED channel:0x10 frame:7 vi_tstamp:748784529 data:0x08000000
     kworker/3:2-185   [003] ...1   150.714503: rtos_queue_peek_from_isr_failed: tstamp:5044023676 queue:0x0b4a3c58

However, when I try to use GStreamer and nvcamerasrc, I get a blank (green) image and the command timed out.

nvidia@tegra-ubuntu:~$ gst-launch-1.0 -v nvcamerasrc num-buffers=1 ! 'video/x-raw(memory:NVMM), width=4208, height=3120' ! nvjpegenc ! filesink location=sample.jpg
Setting pipeline to PAUSED ...

Available Sensor modes : 
4208 x 3120 FR=30.000000 CF=0x1109208a10 SensorModeType=4 CSIPixelBitDepth=10 DynPixelBitDepth=10
Pipeline is live and does not need PREROLL ...
Setting pipeline to PLAYING ...
New clock: GstSystemClock

NvCameraSrc: Trying To Set Default Camera Resolution. Selected sensorModeIndex = 0 WxH = 4208x3120 FrameRate = 30.000000 ...

/GstPipeline:pipeline0/GstNvCameraSrc:nvcamerasrc0.GstPad:src: caps = "video/x-raw\(memory:NVMM\)\,\ width\=\(int\)4208\,\ height\=\(int\)3120\,\ format\=\(string\)I420\,\ framerate\=\(fraction\)30/1"
/GstPipeline:pipeline0/GstCapsFilter:capsfilter0.GstPad:src: caps = "video/x-raw\(memory:NVMM\)\,\ width\=\(int\)4208\,\ height\=\(int\)3120\,\ format\=\(string\)I420\,\ framerate\=\(fraction\)30/1"
/GstPipeline:pipeline0/GstNvJpegEnc:nvjpegenc0.GstPad:sink: caps = "video/x-raw\(memory:NVMM\)\,\ width\=\(int\)4208\,\ height\=\(int\)3120\,\ format\=\(string\)I420\,\ framerate\=\(fraction\)30/1"
/GstPipeline:pipeline0/GstCapsFilter:capsfilter0.GstPad:sink: caps = "video/x-raw\(memory:NVMM\)\,\ width\=\(int\)4208\,\ height\=\(int\)3120\,\ format\=\(string\)I420\,\ framerate\=\(fraction\)30/1"
/GstPipeline:pipeline0/GstNvJpegEnc:nvjpegenc0.GstPad:src: caps = "image/jpeg\,\ sof-marker\=\(int\)4\,\ width\=\(int\)4208\,\ height\=\(int\)3120\,\ pixel-aspect-ratio\=\(fraction\)1/1\,\ framerate\=\(fraction\)30/1"
/GstPipeline:pipeline0/GstFileSink:filesink0.GstPad:sink: caps = "image/jpeg\,\ sof-marker\=\(int\)4\,\ width\=\(int\)4208\,\ height\=\(int\)3120\,\ pixel-aspect-ratio\=\(fraction\)1/1\,\ framerate\=\(fraction\)30/1"
Got EOS from element "pipeline0".
Execution ended after 0:00:02.273078825
Setting pipeline to PAUSED ...
Setting pipeline to READY ...
Socket read error. Camera Daemon stopped functioning.....
Setting pipeline to NULL ...
Freeing pipeline ...
nvbuf_utils: dmabuf_fd -1 mapped entry NOT found
nvidia@tegra-ubuntu:~$

Unsuccessful dmesg

[   13.577078] tegradc 15210000.nvdisplay: hdmi: pclk:148500K, set prod-setting:prod_c_150M
[   13.638153] tegradc 15210000.nvdisplay: unblank
[   14.123662] IPVS: Creating netns size=1424 id=3
[   14.340452] ax88179_178a 1-2.4:1.0 eth1: ax88179 - Link status is: 1
[   14.353835] IPv6: ADDRCONF(NETDEV_CHANGE): eth1: link becomes ready
[  156.553553] imx214 2-0010: imx214_power_on: power on
[  156.562695] imx214 2-0010: imx214_power_off: power off
[  156.573094] imx214 2-0010: imx214_power_on: power on
[  156.580726] imx214 2-0010: imx214_power_off: power off
[  156.610130] imx214 2-0010: imx214_power_on: power on
[  156.617690] imx214 2-0010: imx214_power_off: power off
[  156.627476] imx214 2-0010: imx214_power_on: power on
[  156.635048] imx214 2-0010: imx214_power_off: power off
[  156.644085] imx214 2-0010: imx214_power_on: power on
[  156.651755] imx214 2-0010: imx214_power_off: power off
[  156.724070] imx214 2-0010: imx214_power_on: power on
[  156.731969] imx214 2-0010: imx214_set_group_hold: enter group hold
[  156.738231] imx214 2-0010: imx214_set_frame_length: val: 1240
[  156.748712] imx214 2-0010: imx214_set_coarse_time: val: 1234
[  156.760956] imx214 2-0010: imx214_set_group_hold: leave group hold
[  156.769441] misc tegra_camera_ctrl: ISO BW req 2147483647 > 3916800 (max) capping to max
[  156.777570] misc tegra_camera_ctrl: vi_v4l2_update_isobw: requested iso bw is larger than max
[  156.796958] imx214 2-0010: imx214_s_stream++
[  157.063335] imx214 2-0010: imx214_s_stream--
[  157.240749] tegra-vi4 15700000.vi: master error
[  158.731647] fence timeout on [ffffffc05d77c500] after 1500ms
[  158.731659] fence timeout on [ffffffc05d77c300] after 1500ms
[  158.731687] name=[nvhost_sync:28], current value=0 waiting value=1
[  158.731697] ---- mlocks ----
[  158.731715] 8: locked by channel 6

[  158.731741] ---- syncpts ----
[  158.731762] id 4 (disp_d) min 843 max 843 refs 1 (previous client : )
[  158.731772] id 5 (disp_e) min 2 max 2 refs 1 (previous client : )
[  158.731784] id 7 (vblank1) min 9269 max 0 refs 1 (previous client : )
[  158.731810] id 18 (17000000.gp10b_507) min 24526 max 24526 refs 1 (previous client : )
[  158.731821] id 19 (17000000.gp10b_506) min 26 max 26 refs 1 (previous client : )
[  158.731834] id 21 (17000000.gp10b_505) min 4514 max 4514 refs 1 (previous client : 17000000.gp10b_505)
[  158.731846] id 22 (15340000.vic_gst-launch-1.0_0) min 10 max 10 refs 1 (previous client : 17000000.gp10b_504)
[  158.731855] id 23 (15600000.isp_nvcamera-daemon_0) min 0 max 4 refs 4 (previous client : )
[  158.731865] id 24 (15600000.isp_nvcamera-daemon_1) min 0 max 2 refs 4 (previous client : )
[  158.731875] id 25 (15600000.isp_nvcamera-daemon_2) min 0 max 2 refs 4 (previous client : )
[  158.731886] id 28 (15600000.isp_nvcamera-daemon_3) min 0 max 2 refs 4 (previous client : )
[  158.731896] id 29 (15600000.isp_nvcamera-daemon_4) min 15 max 26 refs 9 (previous client : )
[  158.731905] id 30 (15600000.isp_nvcamera-daemon_5) min 0 max 2 refs 4 (previous client : )
[  158.731917] id 32 (17000000.gp10b_503) min 8 max 8 refs 1 (previous client : )
[  158.731932] id 36 (17000000.gp10b_493) min 13 max 13 refs 1 (previous client : 15700000.vi_0)
[  158.731941] id 37 (15700000.vi_0) min 7 max 7 refs 2 (previous client : 15700000.vi_0)
[  158.731965] id 48 (17000000.gp10b_494) min 8 max 8 refs 1 (previous client : )
[  158.731975] id 49 (150c0000.nvcsi_0) min 20 max 20 refs 2 (previous client : )
[  158.731984] id 50 (17000000.gp10b_492) min 6 max 6 refs 1 (previous client : )
[  158.731993] id 51 (17000000.gp10b_491) min 6 max 6 refs 1 (previous client : )
[  158.732002] id 52 (17000000.gp10b_490) min 6 max 6 refs 1 (previous client : )
[  158.732011] id 53 (17000000.gp10b_489) min 6 max 6 refs 1 (previous client : )

[  158.732732] ---- channels ----
[  158.732759] 
               channel 1 - 15820000.se

[  158.732764] NvHost basic channel registers:
[  158.732772] CMDFIFO_STAT_0:  00002040
[  158.732778] CMDFIFO_RDATA_0: 40a14200
[  158.732787] CMDP_OFFSET_0:   00000000
[  158.732792] CMDP_CLASS_0:    00000000
[  158.732798] CHANNELSTAT_0:   00000000
[  158.732803] The CDMA sync queue is empty.

[  158.732815] 
               channel 2 - 15830000.se

[  158.732820] NvHost basic channel registers:
[  158.732826] CMDFIFO_STAT_0:  00002040
[  158.732831] CMDFIFO_RDATA_0: b2006200
[  158.732839] CMDP_OFFSET_0:   00000000
[  158.732844] CMDP_CLASS_0:    00000000
[  158.732849] CHANNELSTAT_0:   00000000
[  158.732853] The CDMA sync queue is empty.

[  158.732865] 
               channel 3 - 15840000.se

[  158.732869] NvHost basic channel registers:
[  158.732875] CMDFIFO_STAT_0:  00002040
[  158.732880] CMDFIFO_RDATA_0: 22289c24
[  158.732887] CMDP_OFFSET_0:   00000000
[  158.732892] CMDP_CLASS_0:    00000000
[  158.732897] CHANNELSTAT_0:   00000000
[  158.732901] The CDMA sync queue is empty.

[  158.732912] 
               channel 6 - 15600000.isp

[  158.732916] NvHost basic channel registers:
[  158.732922] CMDFIFO_STAT_0:  00004000
[  158.732927] CMDFIFO_RDATA_0: 004e0041
[  158.732935] CMDP_OFFSET_0:   00000050
[  158.732940] CMDP_CLASS_0:    00000001
[  158.732945] CHANNELSTAT_0:   00000000
[  158.732960] 
               ffffffc1e48f4000: JOB, syncpt_id=23, syncpt_val=2, first_get=000001f8, timeout=10000, num_slots=19
[  158.732982]     GATHER at 5a708000+3bec, 12 words
[  158.733028] 20000001 00006417 20000001 00006818 20000001 00006c19 20000001 00007c1c 20000001 0000741e 200c0001 00000005 
[  158.733039]     GATHER at 5a708000+3c1c, 2 words
[  158.733050] 20000001 0000001d 

[  158.733062] 
               channel 5 - 150c0000.nvcsi

[  158.733067] NvHost basic channel registers:
[  158.733072] CMDFIFO_STAT_0:  00002040
[  158.733078] CMDFIFO_RDATA_0: 00000031
[  158.733085] CMDP_OFFSET_0:   00000000
[  158.733090] CMDP_CLASS_0:    00000001
[  158.733095] CHANNELSTAT_0:   00000000
[  158.733099] The CDMA sync queue is empty.

[  158.733111] 
               channel 0 - 15700000.vi

[  158.733115] NvHost basic channel registers:
[  158.733120] CMDFIFO_STAT_0:  00002040
[  158.733125] CMDFIFO_RDATA_0: 00000025
[  158.733132] CMDP_OFFSET_0:   00000000
[  158.733137] CMDP_CLASS_0:    00000001
[  158.733142] CHANNELSTAT_0:   00000000
[  158.733146] The CDMA sync queue is empty.

[  158.733155] 
               ---- host general irq ----

[  158.733161] sync_intc0mask = 0x00000001
[  158.733166] sync_intmask = 0x50000003
[  158.733170] 
               ---- host syncpt irq mask ----

[  158.733174] 
               ---- host syncpt irq status ----

[  158.733182] syncpt_thresh_cpu0_int_status(0) = 0x00000000
[  158.733189] syncpt_thresh_cpu0_int_status(1) = 0x00000000
[  158.733195] syncpt_thresh_cpu0_int_status(2) = 0x00000000
[  158.733201] syncpt_thresh_cpu0_int_status(3) = 0x00000000
[  158.733207] syncpt_thresh_cpu0_int_status(4) = 0x00000000
[  158.733213] syncpt_thresh_cpu0_int_status(5) = 0x00000000
[  158.733219] syncpt_thresh_cpu0_int_status(6) = 0x00000000
[  158.733225] syncpt_thresh_cpu0_int_status(7) = 0x00000000
[  158.733231] syncpt_thresh_cpu0_int_status(8) = 0x00000000
[  158.733237] syncpt_thresh_cpu0_int_status(9) = 0x00000000
[  158.733243] syncpt_thresh_cpu0_int_status(10) = 0x00000000
[  158.733249] syncpt_thresh_cpu0_int_status(11) = 0x00000000
[  158.733255] syncpt_thresh_cpu0_int_status(12) = 0x00000000
[  158.733261] syncpt_thresh_cpu0_int_status(13) = 0x00000000
[  158.733267] syncpt_thresh_cpu0_int_status(14) = 0x00000000
[  158.733273] syncpt_thresh_cpu0_int_status(15) = 0x00000000
[  158.733279] syncpt_thresh_cpu0_int_status(16) = 0x00000000
[  158.733285] syncpt_thresh_cpu0_int_status(17) = 0x00000000
[  159.304022] name=[nvhost_sync:23], current value=0 waiting value=1
[  159.310393] ---- mlocks ----
[  159.313455] 8: locked by channel 6

[  159.318552] ---- syncpts ----
[  159.321582] id 4 (disp_d) min 844 max 845 refs 1 (previous client : )
[  159.328075] id 5 (disp_e) min 2 max 2 refs 1 (previous client : )
[  159.334211] id 7 (vblank1) min 9305 max 0 refs 1 (previous client : )
[  159.340726] id 18 (17000000.gp10b_507) min 24628 max 24630 refs 1 (previous client : )
[  159.348749] id 19 (17000000.gp10b_506) min 26 max 26 refs 1 (previous client : )
[  159.356232] id 21 (17000000.gp10b_505) min 4524 max 4528 refs 1 (previous client : 17000000.gp10b_505)
[  159.365660] id 22 (15340000.vic_gst-launch-1.0_0) min 10 max 10 refs 1 (previous client : 17000000.gp10b_504)
[  159.375643] id 23 (15600000.isp_nvcamera-daemon_0) min 0 max 4 refs 4 (previous client : )
[  159.384003] id 24 (15600000.isp_nvcamera-daemon_1) min 0 max 2 refs 4 (previous client : )
[  159.392305] id 25 (15600000.isp_nvcamera-daemon_2) min 0 max 2 refs 4 (previous client : )
[  159.400642] id 28 (15600000.isp_nvcamera-daemon_3) min 0 max 2 refs 4 (previous client : )
[  159.408916] id 29 (15600000.isp_nvcamera-daemon_4) min 15 max 26 refs 9 (previous client : )
[  159.417355] id 30 (15600000.isp_nvcamera-daemon_5) min 0 max 2 refs 4 (previous client : )
[  159.425618] id 32 (17000000.gp10b_503) min 8 max 8 refs 1 (previous client : )
[  159.432845] id 36 (17000000.gp10b_493) min 13 max 13 refs 1 (previous client : 15700000.vi_0)
[  159.441365] id 37 (15700000.vi_0) min 7 max 7 refs 2 (previous client : 15700000.vi_0)
[  159.449280] id 38 (15340000.vic_nvcamerasrc0:sr_0) min 2 max 2 refs 1 (previous client : 15700000.vi_0)
[  159.458669] id 39 (15380000.nvjpg_nvcamerasrc0:sr_0) min 4 max 4 refs 1 (previous client : 15700000.vi_1)
[  159.468237] id 40 (15340000.vic_nvcamerasrc0:sr_0) min 21 max 21 refs 1 (previous client : 15700000.vi_2)
[  159.477812] id 48 (17000000.gp10b_494) min 8 max 8 refs 1 (previous client : )
[  159.485037] id 49 (150c0000.nvcsi_0) min 20 max 20 refs 2 (previous client : )
[  159.492261] id 50 (17000000.gp10b_492) min 6 max 6 refs 1 (previous client : )
[  159.499538] id 51 (17000000.gp10b_491) min 6 max 6 refs 1 (previous client : )
[  159.506766] id 52 (17000000.gp10b_490) min 6 max 6 refs 1 (previous client : )
[  159.513994] id 53 (17000000.gp10b_489) min 6 max 6 refs 1 (previous client : )

[  159.523244] ---- channels ----
[  159.526318] 
               channel 1 - 15820000.se

[  159.532770] NvHost basic channel registers:
[  159.536960] CMDFIFO_STAT_0:  00002040
[  159.540631] CMDFIFO_RDATA_0: 40a14200
[  159.544286] CMDP_OFFSET_0:   00000000
[  159.547950] CMDP_CLASS_0:    00000000
[  159.551615] CHANNELSTAT_0:   00000000
[  159.555279] The CDMA sync queue is empty.

[  159.560789] 
               channel 2 - 15830000.se

[  159.567231] NvHost basic channel registers:
[  159.571417] CMDFIFO_STAT_0:  00002040
[  159.575088] CMDFIFO_RDATA_0: b2006200
[  159.578757] CMDP_OFFSET_0:   00000000
[  159.582421] CMDP_CLASS_0:    00000000
[  159.586086] CHANNELSTAT_0:   00000000
[  159.589750] The CDMA sync queue is empty.

[  159.595251] 
               channel 3 - 15840000.se

[  159.601691] NvHost basic channel registers:
[  159.605875] CMDFIFO_STAT_0:  00002040
[  159.609542] CMDFIFO_RDATA_0: 22289c24
[  159.613208] CMDP_OFFSET_0:   00000000
[  159.616872] CMDP_CLASS_0:    00000000
[  159.620538] CHANNELSTAT_0:   00000000
[  159.624221] The CDMA sync queue is empty.

[  159.629752] 
               channel 6 - 15600000.isp

[  159.636284] NvHost basic channel registers:
[  159.640475] CMDFIFO_STAT_0:  00004000
[  159.644135] CMDFIFO_RDATA_0: 004e0041
[  159.647807] CMDP_OFFSET_0:   00000050
[  159.651472] CMDP_CLASS_0:    00000001
[  159.655136] CHANNELSTAT_0:   00000000
[  159.658802] 
               ffffffc1e48f4000: JOB, syncpt_id=23, syncpt_val=2, first_get=000001f8, timeout=10000, num_slots=19
[  159.670272]     GATHER at 5a708000+3bec, 12 words
[  159.674974] 20000001 00006417 20000001 00006818 20000001 00006c19 20000001 00007c1c 20000001 0000741e 200c0001 00000005 
[  159.685984]     GATHER at 5a708000+3c1c, 2 words
[  159.690601] 20000001 0000001d 

[  159.695167] 
               channel 5 - 150c0000.nvcsi

[  159.701872] NvHost basic channel registers:
[  159.706062] CMDFIFO_STAT_0:  00002040
[  159.709733] CMDFIFO_RDATA_0: 00000031
[  159.713406] CMDP_OFFSET_0:   00000000
[  159.717076] CMDP_CLASS_0:    00000001
[  159.720746] CHANNELSTAT_0:   00000000
[  159.724399] The CDMA sync queue is empty.

[  159.729915] 
               channel 0 - 15700000.vi

[  159.736357] NvHost basic channel registers:
[  159.740541] CMDFIFO_STAT_0:  00002040
[  159.744195] CMDFIFO_RDATA_0: 00000025
[  159.747863] CMDP_OFFSET_0:   00000000
[  159.751556] CMDP_CLASS_0:    00000001
[  159.755222] CHANNELSTAT_0:   00000000
[  159.758886] The CDMA sync queue is empty.

[  159.764388] 
               ---- host general irq ----

[  159.771091] sync_intc0mask = 0x00000001
[  159.774931] sync_intmask = 0x50000003
[  159.778595] 
               ---- host syncpt irq mask ----

[  159.785648] 
               ---- host syncpt irq status ----

[  159.792872] syncpt_thresh_cpu0_int_status(0) = 0x00000000
[  159.798273] syncpt_thresh_cpu0_int_status(1) = 0x00000000
[  159.803671] syncpt_thresh_cpu0_int_status(2) = 0x00000000
[  159.809070] syncpt_thresh_cpu0_int_status(3) = 0x00000000
[  159.814471] syncpt_thresh_cpu0_int_status(4) = 0x00000000
[  159.819868] syncpt_thresh_cpu0_int_status(5) = 0x00000000
[  159.825265] syncpt_thresh_cpu0_int_status(6) = 0x00000000
[  159.830666] syncpt_thresh_cpu0_int_status(7) = 0x00000000
[  159.836064] syncpt_thresh_cpu0_int_status(8) = 0x00000000
[  159.841469] syncpt_thresh_cpu0_int_status(9) = 0x00000000
[  159.846870] syncpt_thresh_cpu0_int_status(10) = 0x00000000
[  159.852354] syncpt_thresh_cpu0_int_status(11) = 0x00000000
[  159.857840] syncpt_thresh_cpu0_int_status(12) = 0x00000000
[  159.863330] syncpt_thresh_cpu0_int_status(13) = 0x00000000
[  159.868814] syncpt_thresh_cpu0_int_status(14) = 0x00000000
[  159.874297] syncpt_thresh_cpu0_int_status(15) = 0x00000000
[  159.879811] syncpt_thresh_cpu0_int_status(16) = 0x00000000
[  159.885296] syncpt_thresh_cpu0_int_status(17) = 0x00000000
[  163.235334] host1x 13e10000.host1x: CaptureSchedule: syncpoint id 29 (15600000.isp_nvcamera-daemon_4) stuck waiting 18, timeout=-1
[  163.247210] ---- syncpts ----
[  163.250287] id 4 (disp_d) min 854 max 854 refs 1 (previous client : )
[  163.256872] id 5 (disp_e) min 2 max 2 refs 1 (previous client : )
[  163.263126] id 7 (vblank1) min 9541 max 0 refs 1 (previous client : )
[  163.269663] id 18 (17000000.gp10b_507) min 24870 max 24870 refs 1 (previous client : )
[  163.277632] id 19 (17000000.gp10b_506) min 26 max 26 refs 1 (previous client : )
[  163.285167] id 21 (17000000.gp10b_505) min 4570 max 4570 refs 1 (previous client : 17000000.gp10b_505)
[  163.294575] id 22 (15340000.vic_gst-launch-1.0_0) min 10 max 10 refs 1 (previous client : 17000000.gp10b_504)
[  163.304526] id 23 (15600000.isp_nvcamera-daemon_0) min 0 max 4 refs 4 (previous client : )
[  163.312884] id 24 (15600000.isp_nvcamera-daemon_1) min 0 max 2 refs 4 (previous client : )
[  163.321191] id 25 (15600000.isp_nvcamera-daemon_2) min 0 max 2 refs 4 (previous client : )
[  163.329531] id 28 (15600000.isp_nvcamera-daemon_3) min 0 max 2 refs 4 (previous client : )
[  163.337833] id 29 (15600000.isp_nvcamera-daemon_4) min 15 max 26 refs 9 (previous client : )
[  163.346333] id 30 (15600000.isp_nvcamera-daemon_5) min 0 max 2 refs 4 (previous client : )
[  163.354614] id 32 (17000000.gp10b_503) min 8 max 8 refs 1 (previous client : )
[  163.361887] id 36 (17000000.gp10b_493) min 13 max 13 refs 1 (previous client : 15700000.vi_0)
[  163.370432] id 37 (15700000.vi_0) min 7 max 7 refs 2 (previous client : 15700000.vi_0)
[  163.378399] id 38 (15340000.vic_nvcamerasrc0:sr_0) min 2 max 2 refs 1 (previous client : 15700000.vi_0)
[  163.387817] id 39 (15380000.nvjpg_nvcamerasrc0:sr_0) min 4 max 4 refs 1 (previous client : 15700000.vi_1)
[  163.397436] id 40 (15340000.vic_nvcamerasrc0:sr_0) min 21 max 21 refs 1 (previous client : 15700000.vi_2)
[  163.407021] id 48 (17000000.gp10b_494) min 8 max 8 refs 1 (previous client : )
[  163.414287] id 49 (150c0000.nvcsi_0) min 20 max 20 refs 2 (previous client : )
[  163.421510] id 50 (17000000.gp10b_492) min 6 max 6 refs 1 (previous client : )
[  163.428762] id 51 (17000000.gp10b_491) min 6 max 6 refs 1 (previous client : )
[  163.435981] id 52 (17000000.gp10b_490) min 6 max 6 refs 1 (previous client : )
[  163.443200] id 53 (17000000.gp10b_489) min 6 max 6 refs 1 (previous client : )

[  167.245653] host1x 13e10000.host1x: cdma_handle_timeout: timeout: 23 (15600000.isp_nvcamera-daemon_0) clientid 3, HW thresh 0, done 2
[  167.257781] host1x 13e10000.host1x: cdma_handle_timeout: timeout: 24 (15600000.isp_nvcamera-daemon_1) clientid 3, HW thresh 0, done 1
[  167.269821] host1x 13e10000.host1x: cdma_handle_timeout: timeout: 25 (15600000.isp_nvcamera-daemon_2) clientid 3, HW thresh 0, done 1
[  167.281863] host1x 13e10000.host1x: cdma_handle_timeout: timeout: 28 (15600000.isp_nvcamera-daemon_3) clientid 3, HW thresh 0, done 1
[  167.293883] host1x 13e10000.host1x: cdma_handle_timeout: timeout: 30 (15600000.isp_nvcamera-daemon_5) clientid 3, HW thresh 0, done 1
[  167.305948] host1x 13e10000.host1x: cdma_handle_timeout: timeout: 29 (15600000.isp_nvcamera-daemon_4) clientid 3, HW thresh 15, done 15
[  167.318150] ---- mlocks ----
[  167.321054] 8: locked by channel 6

[  167.326024] ---- syncpts ----
[  167.329006] id 4 (disp_d) min 863 max 863 refs 1 (previous client : )
[  167.335463] id 5 (disp_e) min 2 max 2 refs 1 (previous client : )
[  167.341576] id 7 (vblank1) min 9785 max 0 refs 1 (previous client : )
[  167.348051] id 18 (17000000.gp10b_507) min 25004 max 25004 refs 1 (previous client : )
[  167.355978] id 19 (17000000.gp10b_506) min 26 max 26 refs 1 (previous client : )
[  167.363386] id 21 (17000000.gp10b_505) min 4618 max 4618 refs 1 (previous client : 17000000.gp10b_505)
[  167.372693] id 22 (15340000.vic_gst-launch-1.0_0) min 10 max 10 refs 1 (previous client : 17000000.gp10b_504)
[  167.382609] id 23 (15600000.isp_nvcamera-daemon_0) min 0 max 4 refs 4 (previous client : )
[  167.390876] id 24 (15600000.isp_nvcamera-daemon_1) min 0 max 2 refs 4 (previous client : )
[  167.399155] id 25 (15600000.isp_nvcamera-daemon_2) min 0 max 2 refs 4 (previous client : )
[  167.407432] id 28 (15600000.isp_nvcamera-daemon_3) min 0 max 2 refs 4 (previous client : )
[  167.415694] id 29 (15600000.isp_nvcamera-daemon_4) min 15 max 26 refs 9 (previous client : )
[  167.424126] id 30 (15600000.isp_nvcamera-daemon_5) min 0 max 2 refs 4 (previous client : )
[  167.432419] id 32 (17000000.gp10b_503) min 8 max 8 refs 1 (previous client : )
[  167.439642] id 36 (17000000.gp10b_493) min 13 max 13 refs 1 (previous client : 15700000.vi_0)
[  167.448163] id 37 (15700000.vi_0) min 7 max 7 refs 2 (previous client : 15700000.vi_0)
[  167.456075] id 38 (15340000.vic_nvcamerasrc0:sr_0) min 2 max 2 refs 1 (previous client : 15700000.vi_0)
[  167.465463] id 39 (15380000.nvjpg_nvcamerasrc0:sr_0) min 4 max 4 refs 1 (previous client : 15700000.vi_1)
[  167.475021] id 40 (15340000.vic_nvcamerasrc0:sr_0) min 21 max 21 refs 1 (previous client : 15700000.vi_2)
[  167.484589] id 48 (17000000.gp10b_494) min 8 max 8 refs 1 (previous client : )
[  167.491807] id 49 (150c0000.nvcsi_0) min 20 max 20 refs 2 (previous client : )
[  167.499028] id 50 (17000000.gp10b_492) min 6 max 6 refs 1 (previous client : )
[  167.506248] id 51 (17000000.gp10b_491) min 6 max 6 refs 1 (previous client : )
[  167.513470] id 52 (17000000.gp10b_490) min 6 max 6 refs 1 (previous client : )
[  167.520688] id 53 (17000000.gp10b_489) min 6 max 6 refs 1 (previous client : )

[  167.529915] ---- channels ----
[  167.532969] 
               channel 1 - 15820000.se

[  167.539412] NvHost basic channel registers:
[  167.543597] CMDFIFO_STAT_0:  00002040
[  167.547262] CMDFIFO_RDATA_0: 40a14200
[  167.550928] CMDP_OFFSET_0:   00000000
[  167.554591] CMDP_CLASS_0:    00000000
[  167.558286] CHANNELSTAT_0:   00000000
[  167.561953] The CDMA sync queue is empty.

[  167.567451] 
               channel 2 - 15830000.se

[  167.573892] NvHost basic channel registers:
[  167.578080] CMDFIFO_STAT_0:  00002040
[  167.581744] CMDFIFO_RDATA_0: b2006200
[  167.585410] CMDP_OFFSET_0:   00000000
[  167.589063] CMDP_CLASS_0:    00000000
[  167.592729] CHANNELSTAT_0:   00000000
[  167.596395] The CDMA sync queue is empty.

[  167.601902] 
               channel 3 - 15840000.se

[  167.608344] NvHost basic channel registers:
[  167.612532] CMDFIFO_STAT_0:  00002040
[  167.616197] CMDFIFO_RDATA_0: 22289c24
[  167.619862] CMDP_OFFSET_0:   00000000
[  167.623527] CMDP_CLASS_0:    00000000
[  167.627192] CHANNELSTAT_0:   00000000
[  167.630855] The CDMA sync queue is empty.

[  167.636352] 
               channel 6 - 15600000.isp

[  167.642880] NvHost basic channel registers:
[  167.647068] CMDFIFO_STAT_0:  00004000
[  167.650733] CMDFIFO_RDATA_0: 004e0041
[  167.654397] CMDP_OFFSET_0:   00000050
[  167.658063] CMDP_CLASS_0:    00000001
[  167.661731] CHANNELSTAT_0:   00000000
[  167.665397] 
               ffffffc1e48f4000: JOB, syncpt_id=23, syncpt_val=2, first_get=000001f8, timeout=10000, num_slots=19
[  167.676865]     GATHER at 5a708000+3bec, 12 words
[  167.681571] 20000001 00006417 20000001 00006818 20000001 00006c19 20000001 00007c1c 20000001 0000741e 200c0001 00000005 
[  167.692591]     GATHER at 5a708000+3c1c, 2 words
[  167.697209] 20000001 0000001d 

[  167.701785] 
               channel 5 - 150c0000.nvcsi

[  167.708483] NvHost basic channel registers:
[  167.712669] CMDFIFO_STAT_0:  00002040
[  167.716333] CMDFIFO_RDATA_0: 00000031
[  167.719999] CMDP_OFFSET_0:   00000000
[  167.723663] CMDP_CLASS_0:    00000001
[  167.727326] CHANNELSTAT_0:   00000000
[  167.730992] The CDMA sync queue is empty.

[  167.736489] 
               channel 0 - 15700000.vi

[  167.742933] NvHost basic channel registers:
[  167.747119] CMDFIFO_STAT_0:  00002040
[  167.750784] CMDFIFO_RDATA_0: 00000025
[  167.754452] CMDP_OFFSET_0:   00000000
[  167.758116] CMDP_CLASS_0:    00000001
[  167.761786] CHANNELSTAT_0:   00000000
[  167.765449] The CDMA sync queue is empty.

[  167.770946] 
               ---- host general irq ----

[  167.777648] sync_intc0mask = 0x00000001
[  167.781493] sync_intmask = 0x50000003
[  167.785145] 
               ---- host syncpt irq mask ----

[  167.792194] 
               ---- host syncpt irq status ----

[  167.799419] syncpt_thresh_cpu0_int_status(0) = 0x00000000
[  167.804817] syncpt_thresh_cpu0_int_status(1) = 0x00000000
[  167.810215] syncpt_thresh_cpu0_int_status(2) = 0x00000000
[  167.815642] syncpt_thresh_cpu0_int_status(3) = 0x00000000
[  167.821041] syncpt_thresh_cpu0_int_status(4) = 0x00000000
[  167.826439] syncpt_thresh_cpu0_int_status(5) = 0x00000000
[  167.831839] syncpt_thresh_cpu0_int_status(6) = 0x00000000
[  167.837238] syncpt_thresh_cpu0_int_status(7) = 0x00000000
[  167.842635] syncpt_thresh_cpu0_int_status(8) = 0x00000000
[  167.848034] syncpt_thresh_cpu0_int_status(9) = 0x00000000
[  167.853433] syncpt_thresh_cpu0_int_status(10) = 0x00000000
[  167.858918] syncpt_thresh_cpu0_int_status(11) = 0x00000000
[  167.864406] syncpt_thresh_cpu0_int_status(12) = 0x00000000
[  167.869889] syncpt_thresh_cpu0_int_status(13) = 0x00000000
[  167.875374] syncpt_thresh_cpu0_int_status(14) = 0x00000000
[  167.880860] syncpt_thresh_cpu0_int_status(15) = 0x00000000
[  167.886342] syncpt_thresh_cpu0_int_status(16) = 0x00000000
[  167.891827] syncpt_thresh_cpu0_int_status(17) = 0x00000000
[  167.917747] isp 15600000.isp:     SYNCPT_ID   23
[  167.922363] isp 15600000.isp:     SYNCPT_VAL  2
[  167.926896] isp 15600000.isp:     FIRST_GET   0x1f8
[  167.931779] isp 15600000.isp:     TIMEOUT     10000
[  167.936658] isp 15600000.isp:     NUM_SLOTS   19
[  167.941308] isp 15600000.isp:     NUM_HANDLES 1
[  167.945863] isp 15600000.isp:     SYNCPT_ID   29
[  167.950485] isp 15600000.isp:     SYNCPT_VAL  17
[  167.955104] isp 15600000.isp:     FIRST_GET   0x290
[  167.959983] isp 15600000.isp:     TIMEOUT     10000
[  167.964913] isp 15600000.isp:     NUM_SLOTS   12
[  167.969536] isp 15600000.isp:     NUM_HANDLES 1
[  167.974120] isp 15600000.isp:     SYNCPT_ID   29
[  167.978782] isp 15600000.isp:     SYNCPT_VAL  19
[  167.983404] isp 15600000.isp:     FIRST_GET   0x2f0
[  167.988316] isp 15600000.isp:     TIMEOUT     10000
[  167.993208] isp 15600000.isp:     NUM_SLOTS   9
[  167.997778] isp 15600000.isp:     NUM_HANDLES 1
[  168.002323] isp 15600000.isp:     SYNCPT_ID   29
[  168.006973] isp 15600000.isp:     SYNCPT_VAL  21
[  168.011630] isp 15600000.isp:     FIRST_GET   0x338
[  168.016509] isp 15600000.isp:     TIMEOUT     10000
[  168.021425] isp 15600000.isp:     NUM_SLOTS   9
[  168.025957] isp 15600000.isp:     NUM_HANDLES 1
[  168.030533] isp 15600000.isp:     SYNCPT_ID   29
[  168.035184] isp 15600000.isp:     SYNCPT_VAL  23
[  168.039814] isp 15600000.isp:     FIRST_GET   0x380
[  168.044740] isp 15600000.isp:     TIMEOUT     10000
[  168.049654] isp 15600000.isp:     NUM_SLOTS   9
[  168.054201] isp 15600000.isp:     NUM_HANDLES 5
[  168.058783] isp 15600000.isp:     SYNCPT_ID   23
[  168.063410] isp 15600000.isp:     SYNCPT_VAL  4
[  168.067976] isp 15600000.isp:     FIRST_GET   0x3c8
[  168.072914] isp 15600000.isp:     TIMEOUT     10000
[  168.077798] isp 15600000.isp:     NUM_SLOTS   19
[  168.082449] isp 15600000.isp:     NUM_HANDLES 1
[  168.087000] isp 15600000.isp:     SYNCPT_ID   29
[  168.091657] isp 15600000.isp:     SYNCPT_VAL  26
[  168.096286] isp 15600000.isp:     FIRST_GET   0x460
[  168.101205] isp 15600000.isp:     TIMEOUT     10000
[  168.106123] isp 15600000.isp:     NUM_SLOTS   12
[  168.110781] isp 15600000.isp:     NUM_HANDLES 1
[  168.216043] CaptureSchedule[2151]: unhandled level 2 translation fault (11) at 0x000000a0, esr 0x92000006
[  168.225674] pgd = ffffffc1a26ac000
[  168.229194] [000000a0] *pgd=0000000259689003, *pud=0000000259689003, *pmd=0000000000000000

[  168.239074] CPU: 5 PID: 2151 Comm: CaptureSchedule Not tainted 4.4.38+ #73
[  168.246027] Hardware name: quill (DT)
[  168.249729] task: ffffffc1ac9d0c80 ti: ffffffc068ef0000 task.ti: ffffffc068ef0000
[  168.257255] PC is at 0x7f99a31f88
[  168.260566] LR is at 0x7f99e32be8
[  168.263941] pc : [<0000007f99a31f88>] lr : [<0000007f99e32be8>] pstate: 20000000
[  168.271361] sp : 0000007f8bcadee0
[  168.274696] x29: 0000007f8bcf39d0 x28: 0000000000710000 
[  168.280080] x27: 0000000000000000 x26: 0000000000000000 
[  168.285418] x25: 0000007f9a281900 x24: 0000000000000005 
[  168.290750] x23: 0000007f90b58640 x22: 0000000000000000 
[  168.296131] x21: 0000007f9a27f000 x20: 00000000000000a0 
[  168.301483] x19: 0000000000000000 x18: 000000000000000a 
[  168.306814] x17: 0000007f99a31f80 x16: 0000007f9a4e8fa0 
[  168.312176] x15: 001dcd6500000000 x14: 6e6f436572757470 
[  168.317588] x13: 61432f73746e656e x12: 6f706d6f632f6372 
[  168.322968] x11: 73206d6f72662067 x10: 6e6974616761706f 
[  168.328339] x9 : 72702820203a7475 x8 : 0000000000000040 
[  168.333710] x7 : 0000007f906b3620 x6 : 0000007f8bcab0bc 
[  168.339069] x5 : 0000000000000001 x4 : 0000007f8bcada50 
[  168.344408] x3 : 0000000000000166 x2 : 000000000000018f 
[  168.349775] x1 : 0000007f9a27fde0 x0 : 00000000000000a0 

[  168.356624] Library at 0x7f99a31f88: 0x7f99a22000 /usr/lib/aarch64-linux-gnu/tegra/libnvcamerautils.so
[  168.366032] Library at 0x7f99e32be8: 0x7f99dc9000 /usr/lib/aarch64-linux-gnu/tegra/libscf.so
[  168.374510] vdso base = 0x7f9a5d2000
[  168.806697] imx214 2-0010: imx214_s_stream++
[  168.861619] imx214 2-0010: imx214_power_off: power off
[  178.121167] host1x 13e10000.host1x: cdma_handle_timeout: timeout: 23 (15600000.isp_nvcamera-daemon_0) clientid 3, HW thresh 4, done 6
[  178.133696] host1x 13e10000.host1x: cdma_handle_timeout: timeout: 24 (15600000.isp_nvcamera-daemon_1) clientid 3, HW thresh 2, done 3
[  178.145919] host1x 13e10000.host1x: cdma_handle_timeout: timeout: 25 (15600000.isp_nvcamera-daemon_2) clientid 3, HW thresh 2, done 3
[  178.158001] host1x 13e10000.host1x: cdma_handle_timeout: timeout: 28 (15600000.isp_nvcamera-daemon_3) clientid 3, HW thresh 2, done 3
[  178.170140] host1x 13e10000.host1x: cdma_handle_timeout: timeout: 30 (15600000.isp_nvcamera-daemon_5) clientid 3, HW thresh 2, done 3
[  178.182263] host1x 13e10000.host1x: cdma_handle_timeout: timeout: 29 (15600000.isp_nvcamera-daemon_4) clientid 3, HW thresh 31, done 31
[  178.194543] ---- mlocks ----
[  178.197487] 8: locked by channel 6

[  178.202475] ---- syncpts ----
[  178.205494] id 4 (disp_d) min 909 max 909 refs 1 (previous client : )
[  178.212005] id 5 (disp_e) min 2 max 2 refs 1 (previous client : )
[  178.218131] id 7 (vblank1) min 10438 max 0 refs 1 (previous client : )
[  178.224694] id 18 (17000000.gp10b_507) min 27420 max 27420 refs 1 (previous client : )
[  178.232659] id 19 (17000000.gp10b_506) min 26 max 26 refs 1 (previous client : )
[  178.240083] id 21 (17000000.gp10b_505) min 4854 max 4854 refs 1 (previous client : 17000000.gp10b_505)
[  178.249430] id 23 (15600000.isp_nvcamera-daemon_0) min 4 max 6 refs 2 (previous client : )
[  178.257723] id 24 (15600000.isp_nvcamera-daemon_1) min 2 max 3 refs 2 (previous client : )
[  178.266033] id 25 (15600000.isp_nvcamera-daemon_2) min 2 max 3 refs 2 (previous client : )
[  178.274314] id 28 (15600000.isp_nvcamera-daemon_3) min 2 max 3 refs 2 (previous client : )
[  178.282616] id 29 (15600000.isp_nvcamera-daemon_4) min 31 max 33 refs 3 (previous client : )
[  178.291063] id 30 (15600000.isp_nvcamera-daemon_5) min 2 max 3 refs 2 (previous client : )

[  178.301372] ---- channels ----
[  178.304427] 
               channel 1 - 15820000.se

[  178.310878] NvHost basic channel registers:
[  178.315096] CMDFIFO_STAT_0:  00002040
[  178.318766] CMDFIFO_RDATA_0: 40a14200
[  178.322433] CMDP_OFFSET_0:   00000000
[  178.326109] CMDP_CLASS_0:    00000000
[  178.329805] CHANNELSTAT_0:   00000000
[  178.333481] The CDMA sync queue is empty.

[  178.338987] 
               channel 2 - 15830000.se

[  178.345466] NvHost basic channel registers:
[  178.349661] CMDFIFO_STAT_0:  00002040
[  178.353329] CMDFIFO_RDATA_0: b2006200
[  178.356986] CMDP_OFFSET_0:   00000000
[  178.360650] CMDP_CLASS_0:    00000000
[  178.364353] CHANNELSTAT_0:   00000000
[  178.368033] The CDMA sync queue is empty.

[  178.373555] 
               channel 3 - 15840000.se

[  178.380030] NvHost basic channel registers:
[  178.384217] CMDFIFO_STAT_0:  00002040
[  178.387881] CMDFIFO_RDATA_0: 22289c24
[  178.391549] CMDP_OFFSET_0:   00000000
[  178.395253] CMDP_CLASS_0:    00000000
[  178.398927] CHANNELSTAT_0:   00000000
[  178.402600] The CDMA sync queue is empty.

[  178.408108] 
               channel 6 - 15600000.isp

[  178.414672] NvHost basic channel registers:
[  178.418864] CMDFIFO_STAT_0:  0000000e
[  178.422530] CMDFIFO_RDATA_0: 004e0041
[  178.426198] CMDP_OFFSET_0:   00000050
[  178.429892] CMDP_CLASS_0:    00000001
[  178.433558] CHANNELSTAT_0:   00000000
[  178.437226] 
               ffffffc185ad9e00: JOB, syncpt_id=23, syncpt_val=6, first_get=00000550, timeout=10000, num_slots=19
[  178.448725]     GATHER at 5a708000+3c2c, 12 words
[  178.453432] 20000001 00006417 20000001 00006818 20000001 00006c19 20000001 00007c1c 20000001 0000741e 200c0001 00000005 
[  178.464456]     GATHER at 5a708000+3c5c, 2 words
[  178.469075] 20000001 0000001d 

[  178.473643] 
               ---- host general irq ----

[  178.480371] sync_intc0mask = 0x00000001
[  178.484210] sync_intmask = 0x50000003
[  178.487874] 
               ---- host syncpt irq mask ----

[  178.494949] 
               ---- host syncpt irq status ----

[  178.502175] syncpt_thresh_cpu0_int_status(0) = 0x00000000
[  178.507574] syncpt_thresh_cpu0_int_status(1) = 0x00000000
[  178.513011] syncpt_thresh_cpu0_int_status(2) = 0x00000000
[  178.518406] syncpt_thresh_cpu0_int_status(3) = 0x00000000
[  178.523804] syncpt_thresh_cpu0_int_status(4) = 0x00000000
[  178.529231] syncpt_thresh_cpu0_int_status(5) = 0x00000000
[  178.534630] syncpt_thresh_cpu0_int_status(6) = 0x00000000
[  178.540030] syncpt_thresh_cpu0_int_status(7) = 0x00000000
[  178.545454] syncpt_thresh_cpu0_int_status(8) = 0x00000000
[  178.550860] syncpt_thresh_cpu0_int_status(9) = 0x00000000
[  178.556266] syncpt_thresh_cpu0_int_status(10) = 0x00000000
[  178.561784] syncpt_thresh_cpu0_int_status(11) = 0x00000000
[  178.567274] syncpt_thresh_cpu0_int_status(12) = 0x00000000
[  178.572759] syncpt_thresh_cpu0_int_status(13) = 0x00000000
[  178.578275] syncpt_thresh_cpu0_int_status(14) = 0x00000000
[  178.583762] syncpt_thresh_cpu0_int_status(15) = 0x00000000
[  178.589246] syncpt_thresh_cpu0_int_status(16) = 0x00000000
[  178.594757] syncpt_thresh_cpu0_int_status(17) = 0x00000000
[  178.620449] isp 15600000.isp:     SYNCPT_ID   23
[  178.625102] isp 15600000.isp:     SYNCPT_VAL  6
[  178.629679] isp 15600000.isp:     FIRST_GET   0x550
[  178.634569] isp 15600000.isp:     TIMEOUT     10000
[  178.639454] isp 15600000.isp:     NUM_SLOTS   19
[  178.644075] isp 15600000.isp:     NUM_HANDLES 1
[  178.648640] isp 15600000.isp:     SYNCPT_ID   29
[  178.653265] isp 15600000.isp:     SYNCPT_VAL  33
[  178.657885] isp 15600000.isp:     FIRST_GET   0x5e8
[  178.662765] isp 15600000.isp:     TIMEOUT     10000
[  178.667646] isp 15600000.isp:     NUM_SLOTS   12
[  178.672265] isp 15600000.isp:     NUM_HANDLES 1

Unsuccessful trace

# tracer: nop
#
# entries-in-buffer/entries-written: 87/87   #P:4
#
#                              _-----=> irqs-off
#                             / _----=> need-resched
#                            | / _---=> hardirq/softirq
#                            || / _--=> preempt-depth
#                            ||| /     delay
#           TASK-PID   CPU#  ||||    TIMESTAMP  FUNCTION
#              | |       |   ||||       |         |
     kworker/0:3-605   [000] ...1   156.693640: rtos_queue_peek_from_isr_failed: tstamp:5230440306 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   156.693643: rtcpu_start: tstamp:5230441731
     kworker/0:3-605   [000] ...1   156.745678: rtos_queue_peek_from_isr_failed: tstamp:5231831186 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   156.797734: rtos_queue_peek_from_isr_failed: tstamp:5233243810 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   156.797738: rtcpu_start: tstamp:5233245078
     kworker/0:3-605   [000] ...1   156.953895: rtos_queue_peek_from_isr_failed: tstamp:5238244673 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   157.114049: rtos_queue_peek_from_isr_failed: tstamp:5243245153 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   157.270203: rtcpu_vinotify_handle_msg: tstamp:5248014831 tag:ISPBUF_FS channel:0x00 frame:13 vi_tstamp:953047113 data:0x00000000
     kworker/0:3-605   [000] ...1   157.270208: rtcpu_vinotify_handle_msg: tstamp:5248017529 tag:CHANSEL_PXL_SOF channel:0x00 frame:13 vi_tstamp:953049621 data:0x00000001
     kworker/0:3-605   [000] ...1   157.270209: rtcpu_vinotify_handle_msg: tstamp:5248017679 tag:ISPBUF_FIFO_OVERFLOW channel:0x00 frame:13 vi_tstamp:953049859 data:0x00000000
     kworker/0:3-605   [000] ...1   157.270210: rtcpu_vinotify_handle_msg: tstamp:5248018480 tag:CHANSEL_LOAD_FRAMED channel:0x10 frame:13 vi_tstamp:953050511 data:0x08000000
     kworker/0:3-605   [000] ...1   157.270211: rtcpu_vinotify_handle_msg: tstamp:5248018586 tag:CHANSEL_FAULT_FE channel:0x10 frame:13 vi_tstamp:953050512 data:0x00000001
     kworker/0:3-605   [000] ...1   157.270212: rtcpu_vinotify_handle_msg: tstamp:5248018724 tag:ISPBUF_FE channel:0x00 frame:13 vi_tstamp:953050513 data:0x00000000
     kworker/0:3-605   [000] ...1   157.270215: rtos_queue_peek_from_isr_failed: tstamp:5248245662 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   157.426397: rtos_queue_peek_from_isr_failed: tstamp:5253246177 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   157.582549: rtos_queue_peek_from_isr_failed: tstamp:5258246678 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   157.738703: rtos_queue_peek_from_isr_failed: tstamp:5263247181 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   157.894867: rtos_queue_peek_from_isr_failed: tstamp:5268247689 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   158.051055: rtos_queue_peek_from_isr_failed: tstamp:5273248194 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   158.259203: rtos_queue_peek_from_isr_failed: tstamp:5278248724 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   158.415341: rtos_queue_peek_from_isr_failed: tstamp:5283249212 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   158.571486: rtos_queue_peek_from_isr_failed: tstamp:5288249720 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   158.727651: rtos_queue_peek_from_isr_failed: tstamp:5293250224 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   159.303777: rtos_queue_peek_from_isr_failed: tstamp:5298250729 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   159.303938: rtos_queue_peek_from_isr_failed: tstamp:5303251251 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   159.303942: rtos_queue_peek_from_isr_failed: tstamp:5308251742 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   159.356207: rtos_queue_peek_from_isr_failed: tstamp:5313252290 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   159.521229: rtos_queue_peek_from_isr_failed: tstamp:5318252773 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   159.677081: rtos_queue_peek_from_isr_failed: tstamp:5323253259 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   159.841464: rtos_queue_peek_from_isr_failed: tstamp:5328253768 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   159.996772: rtos_queue_peek_from_isr_failed: tstamp:5333254301 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   160.152905: rtos_queue_peek_from_isr_failed: tstamp:5338254784 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   160.308994: rtos_queue_peek_from_isr_failed: tstamp:5343255293 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   160.465128: rtos_queue_peek_from_isr_failed: tstamp:5348255797 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   160.621256: rtos_queue_peek_from_isr_failed: tstamp:5353256307 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   160.777391: rtos_queue_peek_from_isr_failed: tstamp:5358256812 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   160.933513: rtos_queue_peek_from_isr_failed: tstamp:5363257321 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   161.089639: rtos_queue_peek_from_isr_failed: tstamp:5368257825 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   161.297806: rtos_queue_peek_from_isr_failed: tstamp:5373258354 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   161.453924: rtos_queue_peek_from_isr_failed: tstamp:5378258842 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   161.610047: rtos_queue_peek_from_isr_failed: tstamp:5383259346 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   161.766173: rtos_queue_peek_from_isr_failed: tstamp:5388259855 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   161.922293: rtos_queue_peek_from_isr_failed: tstamp:5393260359 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   162.078414: rtos_queue_peek_from_isr_failed: tstamp:5398260868 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   162.234530: rtos_queue_peek_from_isr_failed: tstamp:5403261376 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   162.390696: rtos_queue_peek_from_isr_failed: tstamp:5408261901 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   162.546808: rtos_queue_peek_from_isr_failed: tstamp:5413262389 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   162.702926: rtos_queue_peek_from_isr_failed: tstamp:5418262893 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   162.859037: rtos_queue_peek_from_isr_failed: tstamp:5423263402 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   163.015155: rtos_queue_peek_from_isr_failed: tstamp:5428263912 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   163.171261: rtos_queue_peek_from_isr_failed: tstamp:5433264414 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   163.391375: rtos_queue_peek_from_isr_failed: tstamp:5438264923 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   163.491458: rtos_queue_peek_from_isr_failed: tstamp:5443265427 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   163.699649: rtos_queue_peek_from_isr_failed: tstamp:5448265954 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   163.855759: rtos_queue_peek_from_isr_failed: tstamp:5453266441 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   164.011868: rtos_queue_peek_from_isr_failed: tstamp:5458266949 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   164.167994: rtos_queue_peek_from_isr_failed: tstamp:5463267475 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   164.324079: rtos_queue_peek_from_isr_failed: tstamp:5468267961 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   164.480203: rtos_queue_peek_from_isr_failed: tstamp:5473268467 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   164.636310: rtos_queue_peek_from_isr_failed: tstamp:5478268973 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   164.792406: rtos_queue_peek_from_isr_failed: tstamp:5483269503 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   164.948508: rtos_queue_peek_from_isr_failed: tstamp:5488269987 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   165.104622: rtos_queue_peek_from_isr_failed: tstamp:5493270496 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   165.260735: rtos_queue_peek_from_isr_failed: tstamp:5498270999 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   165.416817: rtos_queue_peek_from_isr_failed: tstamp:5503271515 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   165.572913: rtos_queue_peek_from_isr_failed: tstamp:5508272016 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   165.729016: rtos_queue_peek_from_isr_failed: tstamp:5513272523 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   165.937171: rtos_queue_peek_from_isr_failed: tstamp:5518273029 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   166.093254: rtos_queue_peek_from_isr_failed: tstamp:5523273555 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   166.249354: rtos_queue_peek_from_isr_failed: tstamp:5528274046 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   166.405455: rtos_queue_peek_from_isr_failed: tstamp:5533274550 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   166.561568: rtos_queue_peek_from_isr_failed: tstamp:5538275058 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   166.717661: rtos_queue_peek_from_isr_failed: tstamp:5543275563 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   166.873749: rtos_queue_peek_from_isr_failed: tstamp:5548276072 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   167.029784: rtos_queue_peek_from_isr_failed: tstamp:5553276580 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   167.185688: rtos_queue_peek_from_isr_failed: tstamp:5558277106 queue:0x0b4a3c58
     kworker/0:1-51    [000] ...1   167.897335: rtos_queue_peek_from_isr_failed: tstamp:5563277589 queue:0x0b4a3c58
     kworker/0:1-51    [000] ...1   167.897339: rtos_queue_peek_from_isr_failed: tstamp:5568278096 queue:0x0b4a3c58
     kworker/0:1-51    [000] ...1   167.897340: rtos_queue_peek_from_isr_failed: tstamp:5573278602 queue:0x0b4a3c58
     kworker/0:1-51    [000] ...1   167.897341: rtos_queue_peek_from_isr_failed: tstamp:5578279111 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   168.115349: rtos_queue_peek_from_isr_failed: tstamp:5583279615 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   168.164994: rtos_queue_peek_from_isr_failed: tstamp:5588280124 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   168.322776: rtos_queue_peek_from_isr_failed: tstamp:5593280649 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   168.476801: rtos_queue_peek_from_isr_failed: tstamp:5598281137 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   168.632713: rtos_queue_peek_from_isr_failed: tstamp:5603281646 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   168.788593: rtos_queue_peek_from_isr_failed: tstamp:5608282156 queue:0x0b4a3c58
     kworker/0:3-605   [000] ...1   168.840592: rtos_queue_peek_from_isr_failed: tstamp:5609093151 queue:0x0b4a3c58

Unsuccessful nvcamera-daemon debug

Thread 1 getting next capture
Thread 1 is waiting
Thread 2 getting next capture
Thread 2 is waiting
Thread 3 getting next capture
Thread 3 is waiting
Thread 4 getting next capture
Thread 4 is waiting
Thread 5 getting next capture
Thread 5 is waiting
Thread 6 getting next capture
Thread 6 is waiting
Thread 7 getting next capture
Thread 7 is waiting
Thread 8 getting next capture
Thread 8 is waiting
Thread 9 getting next capture
Thread 9 is waiting
Thread 10 getting next capture
Thread 10 is waiting
Thread 11 getting next capture
Thread 11 is waiting
Thread 12 getting next capture
Thread 12 is waiting
Starting services...
Worker thread IspHw statsComplete start
Worker thread IspHw frameComplete start
Worker thread CaptureScheduler checkFramePending start
Worker thread CaptureScheduler frameStart start
Worker thread V4L2CaptureScheduler checkCaptureComplete start
Worker thread V4L2CaptureScheduler issueCaptures start
Worker thread PS handleRequests start
getInstance: s_instance(0x7f90b29800)
getInstance: s_instance(0x7f90b29800)
subscribe: create SensorType(gyroscope) sensor(0x7f90b2b980)
subscribe: create SensorType(accelerometer) sensor(0x7f90b30de0)
AC plugin not present: dlopen "acplugin.so", acplugin.so: cannot open shared object file: No such file or directory
Services are started
NvPclSetHotplugCallback: ++++++++++++++++++++++
---- Imager: Calibration blob file handling supported in this build ----
NvPclHwGetModuleList: OFParserListModules Succeeded
NvPclHwMatchPartNum: Found calibration Part#:P5V27CCV, P5V27C:"P5V27C"
NvPclHwPrintModuleDefinition -- Name: e3326_front_P5V27C
NvPclHwPrintModuleDefinition -- Position: 0
NvPclHwPrintModuleDefinition -- CalibrationData Found: 1
NvPclHwPrintCameraSubModule -- HwCamSubModule[0].Name: v4l2_sensor
NvPclHwPrintCameraSubModule -- HwCamSubModule[0].DevName: imx214 2-0010
NvPclHwPrintCameraSubModule -- HwCamSubModule[1].Name: v4l2_lens
NvPclHwPrintCameraSubModule -- HwCamSubModule[1].DevName: 
NvPclHwGetModuleList: OFParserListModules Succeeded
NvPclModuleListInitialize: NvPclModule list[0]: e3326_front_P5V27C position0
NvPclHwScanExternalCameras -- adding video0 to discover list
NvPclHwScanExternalCameras -- adding video0 to discover list
initialize: /dev/video0
queryControls: 10100736 control Frame Length
queryControls: 10100737 control Coarse Time
queryControls: 10100738 control Coarse Time Short
queryControls: 10100739 control Group Hold
queryControls: 10100740 control HDR enable
queryControls: 10100742 control OTP Data
queryControls: 10100745 control Gain
queryControls: 10100836 control Bypass Mode
queryControls: 10100837 control Override Enable
queryControls: 10100838 control Height Align
queryControls: 10100839 control Size Align
queryControls: 10100840 control Write ISP format
queryControls: 10100841 control Sensor Signal Properties
queryControls: 10100842 control Sensor Image Properties
queryControls: 10100843 control Sensor Control Properties
queryControls: 10100844 control Sensor DV Timings
queryControls: 10100866 control Sensor Modes
Ioctl failed: Invalid argument
NvPclHwScanExternalCameras -- adding video0 to discover list
initialize: /dev/video0
queryControls: 10100736 control Frame Length
queryControls: 10100737 control Coarse Time
queryControls: 10100738 control Coarse Time Short
queryControls: 10100739 control Group Hold
queryControls: 10100740 control HDR enable
queryControls: 10100742 control OTP Data
queryControls: 10100745 control Gain
queryControls: 10100836 control Bypass Mode
queryControls: 10100837 control Override Enable
queryControls: 10100838 control Height Align
queryControls: 10100839 control Size Align
queryControls: 10100840 control Write ISP format
queryControls: 10100841 control Sensor Signal Properties
queryControls: 10100842 control Sensor Image Properties
queryControls: 10100843 control Sensor Control Properties
queryControls: 10100844 control Sensor DV Timings
queryControls: 10100866 control Sensor Modes
Ioctl failed: Invalid argument
getHotplugMonitor: Getting hotplug monitor instance
 initializeHotplug++
 hotPlugfunc ++ 
 addWatch: Watch added wd='1'
CheckProcDTExists: INFO: accessing /proc/device-tree/tegra-virtual-camera-platform/modules; No such file or directory
OFParserGetVirtualDevice: NVIDIA Camera virtual enumerator not found in proc device-tree
setHotplugCallback: Registered new callback client
NvPclSetHotplugCallback: ----------------------
 hotPlugfunc: reading from inotify FD, Thread waiting 
NvPclOpen: ++++++++++++++++++++++
NvPclStateControllerOpen: Found GUID 0 match at index[0]
NvPclHwInitializeModule: allocate overrides pathname @ 0x7f90b5ae70
NvPclHwInitializeModule: allocate overrides pathname @ 0x7f90b5af00
NvPclHwInitializeModule: allocate overrides pathname @ 0x7f90b5af90
NvPclHwInitializeModule: allocate overrides pathname @ 0x7f90b5b020
NvPclHwInitializeModule: allocate overrides pathname @ 0x7f90b5b0b0
NvPclHwInitializeModule: allocate overrides pathname @ 0x7f90b5b140
LoadOverridesFile: looking for override file [/Calib/camera_override.isp] 1/16CheckOverridesPermissions: cannot stat file [/Calib/camera_override.isp]
LoadOverridesFile: looking for override file [/data/nvcam/settings/camera_overrides.isp] 2/16CheckOverridesPermissions: cannot stat file [/data/nvcam/settings/camera_overrides.isp]
LoadOverridesFile: looking for override file [/opt/nvidia/nvcam/settings/camera_overrides.isp] 3/16CheckOverridesPermissions: cannot stat file [/opt/nvidia/nvcam/settings/camera_overrides.isp]
LoadOverridesFile: looking for override file [/var/nvidia/nvcam/settings/camera_overrides.isp] 4/16CheckOverridesPermissions: cannot stat file [/var/nvidia/nvcam/settings/camera_overrides.isp]
LoadOverridesFile: looking for override file [/data/nvcam/camera_overrides.isp] 5/16CheckOverridesPermissions: cannot stat file [/data/nvcam/camera_overrides.isp]
LoadOverridesFile: looking for override file [/data/nvcam/settings/e3326_front_P5V27C.isp] 6/16CheckOverridesPermissions: cannot stat file [/data/nvcam/settings/e3326_front_P5V27C.isp]
LoadOverridesFile: looking for override file [/opt/nvidia/nvcam/settings/e3326_front_P5V27C.isp] 7/16CheckOverridesPermissions: cannot stat file [/opt/nvidia/nvcam/settings/e3326_front_P5V27C.isp]
LoadOverridesFile: looking for override file [/var/nvidia/nvcam/settings/e3326_front_P5V27C.isp] 8/16CheckOverridesPermissions: cannot stat file [/var/nvidia/nvcam/settings/e3326_front_P5V27C.isp]
---- imager: No override file found. ----
Imager: looking for override file [/mnt/factory/camera/factory.bin] 1/16
Imager: looking for override file [/Calib/factory.bin] 2/16
Imager: looking for override file [/Calib/calibration.bin] 3/16
Imager: looking for override file [(null)] 4/16
Imager: looking for override file [(null)] 5/16
Imager: looking for override file [(null)] 6/16
Imager: looking for override file [(null)] 7/16
Imager: looking for override file [(null)] 8/16
Imager: looking for override file [(null)] 9/16
Imager: looking for override file [(null)] 10/16
Imager: looking for override file [(null)] 11/16
Imager: looking for override file [(null)] 12/16
Imager: looking for override file [(null)] 13/16
Imager: looking for override file [(null)] 14/16
Imager: looking for override file [(null)] 15/16
Imager: looking for override file [(null)] 16/16
Imager: looking for override file [/data/nvcam/settings/factory.bin] 1/16
Imager: looking for override file [/data/nvcam/settings/e3326_front_P5V27C.bin] 2/16
Imager: looking for override file [/opt/nvidia/nvcam/settings/e3326_front_P5V27C.bin] 3/16
Imager: looking for override file [/var/nvidia/nvcam/settings/e3326_front_P5V27C.bin] 4/16
Imager: looking for override file [(null)] 5/16
Imager: looking for override file [(null)] 6/16
Imager: looking for override file [(null)] 7/16
Imager: looking for override file [(null)] 8/16
Imager: looking for override file [(null)] 9/16
Imager: looking for override file [(null)] 10/16
Imager: looking for override file [(null)] 11/16
Imager: looking for override file [(null)] 12/16
Imager: looking for override file [(null)] 13/16
Imager: looking for override file [(null)] 14/16
Imager: looking for override file [(null)] 15/16
Imager: looking for override file [(null)] 16/16
NvPclCreateDriver: Found NvPcl Driver Hal dev_name match (v4l2_sensor)
NvPclCreateDriver: Found a Driver name match (v4l2_sensor)
NvPclCreateDriver: Found NvPcl Driver Hal dev_name match (v4l2_lens)
NvPclCreateDriver: Found a Driver name match (v4l2_lens)
NvPclConnectDrivers: hImager was NULL, creating new imager
NvPclInitializeDrivers: v4l2_sensor ++++++++++++++++++
OFDPropertyGetString: could not read property [devnode-bus]
initialize: imx214 2-0010
queryControls: 10100736 control Frame Length
queryControls: 10100737 control Coarse Time
queryControls: 10100738 control Coarse Time Short
queryControls: 10100739 control Group Hold
queryControls: 10100740 control HDR enable
queryControls: 10100742 control OTP Data
queryControls: 10100745 control Gain
queryControls: 10100836 control Bypass Mode
queryControls: 10100837 control Override Enable
queryControls: 10100838 control Height Align
queryControls: 10100839 control Size Align
queryControls: 10100840 control Write ISP format
queryControls: 10100841 control Sensor Signal Properties
queryControls: 10100842 control Sensor Image Properties
queryControls: 10100843 control Sensor Control Properties
queryControls: 10100844 control Sensor DV Timings
queryControls: 10100866 control Sensor Modes
Ioctl failed: Invalid argument
OFDPropertyGetString: could not read property [use_decibel_gain]
OFDPropertyGetString: could not read property [use_sensor_mode_id]
OFDPropertyGetString: could not read property [delayed_gain]
OFDPropertyCopyToLong: could not read property [has-eeprom]
Control Fuse ID not found
Control Frame Rate not found
Control Exposure not found
findCustomCids: calculated MaxCoarseDiff 6
queryPixelFormats: type: 1, pixelformat 0x30314742 "BG10"
Ioctl failed: Invalid argument
Ioctl failed: Invalid argument
Ioctl failed: Invalid argument
Ioctl failed: Invalid argument
Ioctl failed: Invalid argument
Ioctl failed: Invalid argument
Ioctl failed: Invalid argument
Ioctl failed: Invalid argument
Ioctl failed: Invalid argument
Ioctl failed: Invalid argument
queryFormatSizes: Discrete frameSize 4208x3120
Ioctl failed: Invalid argument
Ioctl failed: Invalid argument
loadBinaryBlob: Binary read 0
OFDPropertyGetString: could not read property [type]
loadSubType: Sensor type missing in DT, 199
OFDPropertyCopyToLong: could not read property [mode0.csi_pixel_bit_depth]
OFDPropertyCopyToLong: could not read property [mode0.dynamic_pixel_bit_depth]
OFDPropertyGetString: could not read property [mode0.mode_type]
mode 0: Failed to load mode type
OFDPropertyGetString: could not read property [mode0.pixel_phase]
mode 0: Failed to load pixel phase
OFDPropertyCopyToLongLong: could not read property [mode0.exp_time_1h]
OFDPropertyCopyToFloat: could not read property [mode0.gain_step_pitch]
OFDPropertyGetString: could not read property [mode0.x_start]
OFDPropertyGetString: could not read property [mode0.y_start]
OFDPropertyGetString: could not read property [mode0.x_end]
OFDPropertyGetString: could not read property [mode0.y_end]
OFDPropertyGetString: could not read property [mode0.h_scaling]
OFDPropertyGetString: could not read property [mode0.v_scaling]
OFDPropertyGetString: could not read property [sensor_model]
initialize: Loaded Driver: 1 Modes Available--------------
NvPclInitializeDrivers: v4l2_sensor ------------------
NvPclInitializeDrivers: v4l2_lens ++++++++++++++++++
initialize WARNING: No focuser object, allocating for lens
OFDPropertyCopyToLong: could not read property [maxslewrate]
loadLensMetadata: maxslewrate not set in driver
NvPclInitializeDrivers: NvOdmLensStub ------------------
NvPclOpen: ----------------------
LSC: LSC surface is not based on full res!
sourceRegistry[0] assigned

ispRegistry[0] assigned

Using Source GUID 0
Worker thread ViCsiHw frameComplete start
Worker thread ViCsiHw frameStart start
NvPclPowerOn: +++++++++++
NvPclPowerOn: -----------
Using ISP A
LSC: LSC surface is not based on full res!
AC plugin not present: dlopen "acplugin.so", acplugin.so: cannot open shared object file: No such file or directory
No library found, disabling AC plugin.
Worker thread CaptureDispatcher start
NvPclSettingsUpdate: Sending Updated Settings through PCL
NvPclSettingsApply: Applying last settings through PCL
apply:+++++++++++++++++++++++
writeMode: Target mode Id(0): Resolution 4208x3120
setActiveBufferMemory: 2
INPUT: Width 4208 Height 3120 pixelformat BG10
writeFrameRate:	INPUT frameLength:1240, frameRate:30.000000
writeGain:	INPUT gainCtrl:100 analogGain:1.000000
writeExposure:	INPUT coarseTime:1234, expTime:0.033164
updateOutputSettings:	OUTPUT frameLength:1240, frameRate:30.007502
updateOutputSettings:	OUTPUT analogGain:1.000000
updateOutputSettings:	OUTPUT coarseTime:1234, expTime:0.033164
apply:-----------------------
NvPclSettingsApply: Reading PCL settings
PowerServiceHw:addRequest: table size: before: 0, after:1
	request table for VI 0:
	req[0]: output Bpp=10
	req[0]: sensor pixelRate=160000000 pixels/sec
	req[0]: input width=4208, input height=3120, input Bpp=10
	pixels per clock=8
	req[0]: input width=4208, input height=3120, input Bpp=10
	req[0]: output width=4208, output height=3120, output Bpp=10
	req[0]: input fps=30
	req[0]: guID=0, stage type=SensorCapture
	req[0]: clock=20000000 Hz, iso bw=2147483647 KB/s, non-iso bw=0 KB/s
	req[900]: timeout=0
PowerServiceHw:addRequest: table size: before: 0, after:1
	request table for CSI 0:
	req[0]: sensor pixelRate=160000000 pixels/sec
	req[0]: input width=4208, input height=3120, input Bpp=10
	pixels per clock=8
	req[0]: input width=4208, input height=3120, input Bpp=10
	req[0]: output width=4208, output height=3120, output Bpp=10
	req[0]: input fps=30
	req[0]: guID=0, stage type=SensorCapture
	req[0]: clock=25000000 Hz, iso bw=0 KB/s, non-iso bw=0 KB/s
	req[900]: timeout=0
PowerServiceHwVi:setIso: m_bwVal_Iso=2147483647
PowerServiceHw:setClock: PowerServiceHw[1]: requested_clock_Hz=225000000
PowerServiceHw:setClock: PowerServiceHw[0]: requested_clock_Hz=225000000
PowerServiceCore:setCameraBw: totalIsoBw=2147483647
SCF: Error InvalidState:  NonFatal ISO BW requested not set. Requested = 2147483647 Set = 3916800 (in src/services/power/PowerServiceCore.cpp, function setCameraBw(), line 653)
NvPclSettingsUpdate: Sending Updated Settings through PCL
NvPclSettingsApply: Applying last settings through PCL
apply:+++++++++++++++++++++++
apply:-----------------------
NvPclSettingsApply: Reading PCL settings
No output buffers for 2

No output buffers for 1

InstructionList:
  + GraphSettings
      | SensorMode: 4208x3120 BayerS16BGGR 30.0fps
      | output 0: 4208x3120 BL Y8 420

  + Instruction List
      | id: 0
      +  0: CCDataSetupStage
          | EstimatedIspOutLatencyFrames: 5
          | NumConcurrentCaptures: 1
          | UnprocessedYuvBufferMask: 0
      +  1: ACSynchronizeStage
      +  2: AeAfApplyStage
      +  3: AcPluginStage
          | operation: opApply
      +  4: AcMergeStage
          | IspIn: [4208, 3120]
          | IspOut0: [4208, 3120]
          | IspOut1: [0, 0]
          | IspOut2: [640, 476]
      +  5: StatsBufferAcquireStage
          | Buffer Index: 1
          | BufferRequirements: 640x476 Pitch Y8 420
      +  6: TempBufferAcquireStage
          | Buffer Index: 2
          | BufferRequirements: 4208x1 Pitch NonColor8
      +  7: SensorISPCaptureStage
          | Source GUID: 0
          | Output A Buffer: 0
          | Output Thumb Buffer: 1
          | SensorMetadata Buffer: 2
      +  8: StatsUpdateStage
          | Outut Meta Buffer: 2
      +  9: BufferReturnStage
          | Output A Buffer: 2
      + 10: AcPluginStage

          | operation: opAnalyze
      + 11: AfAnalysisStage
      + 12: MonitorStage
      + 13: ExifStage
      + 14: MakerNoteStage
      + 15: BufferReturnStage
          | Output A Buffer: 0
      + 16: MetadataReturnStage
      + 17: PerfStatsStage

Created fiber 0x7f480008c0 for CC 101 globalID 101 session 0
Thread 1 is working on CC 101 session 0 globalID 101 step 0
CC 101 session 0 completed step 0 in fiber 0x7f480008c0
cc 101(0) session 0 runCount=0 runIspOut=0, latest ccId=0
CC 101 session 0 completed step 1 in fiber 0x7f480008c0
NV AE and AfApply algorithms are active.
CC 101 session 0 completed step 2 in fiber 0x7f480008c0
CC 101 session 0 completed step 3 in fiber 0x7f480008c0
CC 101 session 0 completed step 4 in fiber 0x7f480008c0
Created fiber 0x7f48000b70 for CC 102 globalID 102 session 0
CC 101 session 0 completed step 5 in fiber 0x7f480008c0
CC 101 session 0 completed step 6 in fiber 0x7f480008c0
CC 101 session 0 processing step 7 in fiber 0x7f480008c0
FiberScheduler: cc 101, session 0, fiber 0x7f480008c0 in progress...

Thread 1 getting next capture
Thread 1 is working on CC 102 session 0 globalID 102 step 0
Thread 3 is waiting
CC 102 session 0 completed step 0 in fiber 0x7f48000b70Thread 2 is waiting

cc 102(1) session 0 runCount=1 runIspOut=0, latest ccId=0
CC 102 session 0 completed step 1 in fiber 0x7f48000b70
NV AE and AfApply algorithms are active.
NvPclSettingsUpdate: Sending Updated Settings through PCL
NvPclSettingsApply: Applying last settings through PCL
apply:+++++++++++++++++++++++
apply:-----------------------
NvPclSettingsApply: Reading PCL settings
CC 102 session 0 completed step 2 in fiber 0x7f48000b70
CC 102 session 0 completed step 3 in fiber 0x7f48000b70
PowerServiceHw:addRequest: table size: before: 1, after:2
	request table for VI 0:
	req[0]: output Bpp=10
	req[0]: sensor pixelRate=160000000 pixels/sec
	req[0]: input width=4208, input height=3120, input Bpp=10
	pixels per clock=8
	req[0]: input width=4208, input height=3120, input Bpp=10
	req[0]: output width=4208, output height=3120, output Bpp=10
	req[0]: input fps=30
	req[0]: guID=0, stage type=SensorCapture
	req[0]: clock=20000000 Hz, iso bw=2147483647 KB/s, non-iso bw=0 KB/s
	req[900]: timeout=0
	req[1]: output Bpp=16
	req[1]: sensor pixelRate=160000000 pixels/sec
	req[1]: input width=4208, input height=3120, input Bpp=10
	pixels per clock=8
	req[1]: input width=4208, input height=3120, input Bpp=10
	req[1]: output width=4208, output height=3120, output Bpp=16
	req[1]: input fps=30
	req[1]: guID=0, stage type=SensorIspCapture
	req[1]: clock=20000000 Hz, iso bw=0 KB/s, non-iso bw=0 KB/s
	req[450]: timeout=0
PowerServiceHw:addRequest: table size: before: 1, after:2
	request table for CSI 0:
	req[0]: sensor pixelRate=160000000 pixels/sec
	req[0]: input width=4208, input height=3120, input Bpp=10
	pixels per clock=8
	req[0]: input width=4208, input height=3120, input Bpp=10
	req[0]: output width=4208, output height=3120, output Bpp=10
	req[0]: input fps=30
	req[0]: guID=0, stage type=SensorCapture
	req[0]: clock=25000000 Hz, iso bw=0 KB/s, non-iso bw=0 KB/s
	req[900]: timeout=0
	req[1]: sensor pixelRate=160000000 pixels/sec
	req[1]: input width=4208, input height=3120, input Bpp=10
	pixels per clock=8
	req[1]: input width=4208, input height=3120, input Bpp=10
	req[1]: output width=4208, output height=3120, output Bpp=16
	req[1]: input fps=30
	req[1]: guID=0, stage type=SensorIspCapture
	req[1]: clock=25000000 Hz, iso bw=0 KB/s, non-iso bw=0 KB/s
	req[450]: timeout=0
PowerServiceCore:handleRequests: timePassed = 462
PowerServiceHw:addRequest: table size: before: 0, after:1CC 102 session 0 completed step 4 in fiber 0x7f48000b70

	request table for ISP 0:
	req[0]: output1 width=320, output1 height=200, output1 Bpp=16
	req[0]: output2 width=320, output2 height=200, output2 Bpp=16
	req[0]: output Bpp=16
	req[0]: sensor pixelRate=160000000 pixels/sec
	req[0]: input width=4208, input height=3120, input Bpp=10
	pixels per clock=2
	req[0]: input width=4208, input height=3120, input Bpp=10
	req[0]: output width=282, output height=210, output Bpp=16
	req[0]: input fps=30
	req[0]: guID=0, stage type=SensorIspCapture
	req[0]: clock=81600000 Hz, iso bw=76150 KB/s, non-iso bw=0 KB/s
	req[450]: timeout=0
PowerServiceHwIsp:setLaBw: m_bwVal_Iso=76150 and m_bwVal_NonIso=0 KBpS

PowerServiceHw:setClock: PowerServiceHw[2]: requested_clock_Hz=81600000
CC 102 session 0 completed step 5 in fiber 0x7f48000b70
CC 102 session 0 completed step 6 in fiber 0x7f48000b70
CC 102 session 0 processing step 7 in fiber 0x7f48000b70
FiberScheduler: cc 102, session 0, fiber 0x7f48000b70 in progress...

Thread 1 getting next capture
Thread 4 is waiting
Thread 1 is waiting
NvPclSettingsUpdate: Sending Updated Settings through PCL
NvPclSettingsApply: Applying last settings through PCL
apply:+++++++++++++++++++++++
apply:-----------------------
NvPclSettingsApply: Reading PCL settings
NvPclSettingsUpdate: Sending Updated Settings through PCL
NvPclSettingsApply: Applying last settings through PCL
apply:+++++++++++++++++++++++
apply:-----------------------
NvPclSettingsApply: Reading PCL settings
PowerServiceHw:addRequest: table size: before: 1, after:2
	request table for ISP 0:
	req[0]: output1 width=320, output1 height=200, output1 Bpp=16
	req[0]: output2 width=320, output2 height=200, output2 Bpp=16
	req[0]: output Bpp=16
	req[0]: sensor pixelRate=160000000 pixels/sec
	req[0]: input width=4208, input height=3120, input Bpp=10
	pixels per clock=2
	req[0]: input width=4208, input height=3120, input Bpp=10
	req[0]: output width=282, output height=210, output Bpp=16
	req[0]: input fps=30
	req[0]: guID=0, stage type=SensorIspCapture
	req[0]: clock=81600000 Hz, iso bw=76150 KB/s, non-iso bw=0 KB/s
	req[448]: timeout=0
	req[1]: output1 width=320, output1 height=200, output1 Bpp=16
	req[1]: output2 width=640, output2 height=476, output2 Bpp=13
	req[1]: output Bpp=12
	req[1]: sensor pixelRate=160000000 pixels/sec
	req[1]: input width=4208, input height=3120, input Bpp=10
	pixels per clock=2
	req[1]: input width=4208, input height=3120, input Bpp=10
	req[1]: output width=4208, output height=3120, output Bpp=12
	req[1]: input fps=30
	req[1]: guID=0, stage type=SensorIspCapture
	req[1]: clock=81600000 Hz, iso bw=391472 KB/s, non-iso bw=0 KB/s
	req[450]: timeout=0
PowerServiceHwIsp:setLaBw: m_bwVal_Iso=391472 and m_bwVal_NonIso=0 KBpS

Created fiber 0x7f48000d10 for CC 103 globalID 103 session 0
Thread 5 is working on CC 103 session 0 globalID 103 step 0
CC 103 session 0 completed step 0 in fiber 0x7f48000d10
cc 103(2) session 0 runCount=2 runIspOut=0, latest ccId=0
CC 103 session 0 completed step 1 in fiber 0x7f48000d10
NV AE and AfApply algorithms are active.
CC 103 session 0 completed step 2 in fiber 0x7f48000d10
CC 103 session 0 completed step 3 in fiber 0x7f48000d10
CC 103 session 0 completed step 4 in fiber 0x7f48000d10
CC 103 session 0 completed step 5 in fiber 0x7f48000d10
CC 103 session 0 completed step 6 in fiber 0x7f48000d10
CC 103 session 0 processing step 7 in fiber 0x7f48000d10
FiberScheduler: cc 103, session 0, fiber 0x7f48000d10 in progress...

Thread 5 getting next capture
Thread 6 is waiting
Thread 5 is waiting
NvViErrorDecode Stream 4.0 failed: ts 167936548960 frame 13 error 11 data 0x00000000
NvViErrorDecode CaptureError: IspBufFifoOverflow (11)
NvViErrorDecode See https://wiki.nvidia.com/wmpwiki/index.php/Camera_Debugging/CaptureError_debugging for more information and links to documents.
NvViCsiAbort - close channel, release syncpts
captureErrorCallback Stream 4.0 capture 1 failed: ts 167936548960 frame 13 error 11 data 0x00000000

Created fiber 0x7f48000eb0 for CC 104 globalID 104 session 0Thread 7 is working on CC 104 session 0 globalID 104 step 0

CC 104 session 0 completed step 0 in fiber 0x7f48000eb0
cc 104(3) session 0 runCount=3 runIspOut=0, latest ccId=0
CC 104 session 0 completed step 1 in fiber 0x7f48000eb0
NV AE and AfApply algorithms are active.
CC 104 session 0 completed step 2 in fiber 0x7f48000eb0
CC 104 session 0 completed step 3 in fiber 0x7f48000eb0
CC 104 session 0 completed step 4 in fiber 0x7f48000eb0
CC 104 session 0 completed step 5 in fiber 0x7f48000eb0
CC 104 session 0 completed step 6 in fiber 0x7f48000eb0
CC 104 session 0 processing step 7 in fiber 0x7f48000eb0
FiberScheduler: cc 104, session 0, fiber 0x7f48000eb0 in progress...

Thread 7 getting next capture
Thread 8 is waiting
Thread 7 is waiting
SCF: Error Timeout:  (propagating from src/services/capture/CaptureServiceEvent.cpp, function wait(), line 59)
Error: Camera HwEvents wait, this may indicate a hardware timeout occured,abort current/incoming cc
Created fiber 0x7f48001050 for CC 105 globalID 105 session 0
Thread 9 is working on CC 105 session 0 globalID 105 step 0
Fiber 0x7f48001050 is aborting in CC 105 Session 0
FiberScheduler: cc 105 session 0, fiber 0x7f48001050 aborted

launchCC abort cc 106 session 0
Created fiber 0x7f90f6d570 for CC 106 globalID 106 session 0
SCF: Error Timeout:  (propagating from src/api/Session.cpp, function capture(), line 830)
Thread 10 is working on CC 106 session 0 globalID 106 step 0
Fiber 0x7f90f6d570 is aborting in CC 106 Session 0
FiberScheduler: cc 106 session 0, fiber 0x7f90f6d570 aborted

FiberScheduler: fiber 0x7f48001050 exiting
Thread 9 getting next capture
disposing CC 105 Session 0
launchCC abort cc 107 session 0
Thread 9 is waiting
Thread 11 is waiting
Created fiber 0x7f90f79120 for CC 107 globalID 107 session 0
SCF: Error Timeout:  (propagating from src/api/Session.cpp, function capture(), line 830)
launchCC abort cc 108 session 0
Thread 3 is working on CC 107 session 0 globalID 107 step 0
Thread 12 is waiting
Fiber 0x7f90f79120 is aborting in CC 107 Session 0
FiberScheduler: cc 107 session 0, fiber 0x7f90f79120 aborted

FiberScheduler: fiber 0x7f90f79120 exiting
Thread 3 getting next capture
disposing CC 107 Session 0
Thread 2 is waiting
FiberScheduler: fiber 0x7f90f6d570 exiting
Thread 4 is waiting
Created fiber 0x7f90f79610 for CC 108 globalID 108 session 0
Thread 3 is working on CC 108 session 0 globalID 108 step 0
SCF: Error Timeout:  (propagating from src/api/Session.cpp, function capture(), line 830)
Fiber 0x7f90f79610 is aborting in CC 108 Session 0
FiberScheduler: cc 108 session 0, fiber 0x7f90f79610 aborted

FiberScheduler: fiber 0x7f90f79610 exiting
Thread 3 getting next capture
launchCC abort cc 109 session 0
disposing CC 108 Session 0
Thread 3 is waiting
Thread 1 is waiting
Thread 6 is waiting
Thread 5 is waiting
Thread 8 is waiting
Created fiber 0x7f90f79f10 for CC 109 globalID 109 session 0
disposing CC 106 Session 0
Thread 7 is working on CC 109 session 0 globalID 109 step 0
Fiber 0x7f90f79f10 is aborting in CC 109 Session 0
Thread 9 is waiting
FiberScheduler: cc 109 session 0, fiber 0x7f90f79f10 aborted

SCF: Error Timeout:  (propagating from src/api/Session.cpp, function capture(), line 830)
launchCC abort cc 110 session 0
Thread 11 is working on CC 110 session 0 globalID 110 step 0
Fiber 0x7f90f7a400 is aborting in CC 110 Session 0
FiberScheduler: cc 110 session 0, fiber 0x7f90f7a400 aborted

Thread 10 getting next capture
Thread 10 is waiting
FiberScheduler: fiber 0x7f90f79f10 exiting
Thread 7 getting next capture
disposing CC 109 Session 0
Thread 7 is waiting
Thread 2 is waiting
Thread 12 is waiting
FiberScheduler: fiber 0x7f90f7a400 exiting
Thread 11 getting next capture
Thread 4 is waiting
Thread 11 is waiting
Created fiber 0x7f90f7a400 for CC 110 globalID 110 session 0
SCF: Error Timeout:  (propagating from src/api/Session.cpp, function capture(), line 830)
Thread 3 is waiting
disposing CC 110 Session 0
launchCC abort cc 111 session 0
Created fiber 0x7f90f75010 for CC 111 globalID 111 session 0
Thread 1 is working on CC 111 session 0 globalID 111 step 0SCF: Error Timeout:  (propagating from src/api/Session.cpp, function capture(), line 830)

Fiber 0x7f90f75010 is aborting in CC 111 Session 0
FiberScheduler: cc 111 session 0, fiber 0x7f90f75010 aborted

FiberScheduler: fiber 0x7f90f75010 exiting
Thread 1 getting next capture
Thread 5 is waiting
Thread 1 is waiting
Thread 6 is waiting
SCF: Error Timeout: ISP port 0 timed out! (in src/services/capture/CaptureServiceDeviceIsp.cpp, function waitIspFrameEnd(), line 702)
waitForIdleLocked remaining request 104 
waitForIdleLocked remaining request 103 
waitForIdleLocked remaining request 102 
waitForIdleLocked remaining request 101 
SCF: Error Timeout: waitForIdle() timed out (in src/api/Session.cpp, function waitForIdleLocked(), line 916)
Session 0 aborting capture 104 (API ID: 3)
Session 0 aborting capture 103 (API ID: 2)
Session 0 aborting capture 102 (API ID: 1)
Session 0 aborting capture 101 (API ID: 0)
SCF: Error Timeout: ISP Stats timed out! (in src/services/capture/CaptureServiceDeviceIsp.cpp, function waitIspStatsFinished(), line 785)
SCF: Error InvalidState:  (propagating from src/services/capture/CaptureServiceDeviceViCsi.cpp, function startCapture(), line 708)
SCF: Error InvalidState:  (propagating from src/services/capture/CaptureServiceCore.cpp, function doCSItoISPCapture(), line 481)
FiberScheduler: cc 101, session 0, fiber 0x7f480008c0 aborted in async operation

SCF: Error InvalidState:  (propagating from src/services/capture/CaptureServiceCore.cpp, function issueCapture(), line 362)
SCF: Error InvalidState:  (propagating from src/services/capture/CaptureServiceDevice.cpp, function issueCaptures(), line 1213)
SCF: Error InvalidState:  (propagating from src/services/capture/CaptureServiceDevice.cpp, function issueCaptures(), line 1043)
SCF: Error OverFlow:  (propagating from src/services/capture/CaptureServiceDevice.cpp, function returnRequestPoolCaptures(), line 1163)
FiberScheduler: cc 101, session 0, fiber 0x7f480008c0 aborted in async operation

SCF: Error BadParameter: Fiber not present (in src/components/CaptureContainerImpl.cpp, function detachFiber(), line 606)
SCF: Error Timeout:  (propagating from src/api/Buffer.cpp, function waitForUnlock(), line 591)
SCF: Error Timeout:  (propagating from src/components/CaptureContainerImpl.cpp, function returnBuffer(), line 358)
SCF: Error Timeout:  (propagating from src/api/Buffer.cpp, function waitForUnlock(), line 591)
SCF: Error Timeout:  (propagating from src/components/CaptureContainerImpl.cpp, function returnBuffer(), line 358)
FiberScheduler: fiber 0x7f480008c0 exiting
SCF: Error OverFlow:  (propagating from src/services/capture/CaptureServiceDevice.cpp, function checkCaptureComplete(), line 1135)
SCF: Error OverFlow:  (propagating from src/common/Utils.cpp, function workerThread(), line 114)
SCF: Error OverFlow: Worker thread CaptureScheduler checkFramePending failed (in src/common/Utils.cpp, function workerThread(), line 131)
Thread 8 is waiting
Segmentation fault (core dumped)
root@tegra-ubuntu:/home/nvidia#

I’m not sure where to look now. None of the error messages stand out to me. Any comments or suggestions would be greatly appreciated.

Thanks.

hello acsmith,

are you able to launch camera sensors via gstreamer with lower resolution, say 1080p or 720p.
thanks

Thanks for the response.

I tried with 1080 (1920 x 1080). I can get a picture using v4l2-ctl but gstreamer is giving me the same error.

hello acsmith,

sensor drivers should be fine if v4l2-ctl works,
please review the signal settings in the sensor device tree. thanks
for example,
mclk_khz, mclk_multiplier, pix_clk_hz

Thanks for the suggestions. I’ve tried some different settings and verified clock configurations and still nothing new. Here is a section of my device tree

mode0 { // IMX214_MODE_4208X3120
                                mclk_khz = "24000";
                                num_lanes = "4";
                                tegra_sinterface = "serial_e";
                                discontinuous_clk = "no";
                                dpcm_enable = "true";
                                cil_settletime = "0";

                                active_w = "4208";
                                active_h = "3120";
                                embedded_metadata_height = "4";
                                pixel_t = "bayer_bggr";
                                readout_orientation = "0";
                                line_length = "4300";
                                inherent_gain = "1";
                                mclk_multiplier = "4.5";
                                pix_clk_hz = "108000000";

                                min_gain_val = "1.0";
                                max_gain_val = "16";
                                min_hdr_ratio = "1";
                                max_hdr_ratio = "64";
                                min_framerate = "1.816577";
                                max_framerate = "30";
                                min_exp_time = "34";
                                max_exp_time = "550385";
                        };

Thanks.

hello acsmith,

you pix_clk_hz seems slightly lower, could you please check this again?
also, please try below commands to boost the system performance (VI and ISP)

sudo ./jetson_clocks.sh
echo 1 > /sys/kernel/debug/bpmp/debug/clk/vi/mrq_rate_locked
echo 1 > /sys/kernel/debug/bpmp/debug/clk/isp/mrq_rate_locked
cat /sys/kernel/debug/bpmp/debug/clk/vi/max_rate
cat /sys/kernel/debug/bpmp/debug/clk/isp/max_rate
echo max_rate > /sys/kernel/debug/bpmp/debug/clk/vi/rate
echo max_rate > /sys/kernel/debug/bpmp/debug/clk/isp/rate

Thanks a lot for the pointer on pix_clk_hz, that was the issue. I needed to multiply it by 4, that fixed things up.

Next thing to do is tweak settings to improve the color. It’s correct (RGB wise) but it has a pinkish tint to it. Any suggestions on how to tune the color? Things to try first?

Thanks again.

hello acsmith,

good to knew its signal issue.
let’s have another new topic to discuss color pinkish issue.
thanks

Hello acsmith,

I am also looking to use IMX214 for jetson nano with Jetpack-4.4, but no luck yet.
Is it possible to share your IMX214 driver for reference that works on TX1/TX2 .
Any help will be appreciable.

Thanks
Surya