libargus and gstreamer not working with ported ov5647 driver

Hello,

I’ve spent some time to use the ov5693 driver as base to have a ov5647 driver.
I only needed to change the mode table and it worked out of the box with v4l2 as I already had experience with making a ar0135 driver using this method.
Both drivers are about the same.

But now we also had the requirement of having to use the ISP as we want to use the Debayering feature.
Only difference is that ov5647 currently uses RGGB8 instead of RGGB10 and a resolution of 640 x 480.
I hope this isn’t a problem because everything else is nearly the same.

I’ve tried to test this using these methods:

killall nvcamera-daemon
export enableCamScfLogs=1
export enableCamPclLogs=1
/usr/sbin/nvcamera-daemon

then in a different console

gst-launch-1.0 nvcamerasrc num-buffers=10 ! filesink location=dump.raw

which didn’t work.
And then I tried

export enableCamScfLogs=1
export enableCamPclLogs=1
/home/nvidia/tegra_multimedia_api/samples/10_camera_recording/camera_recording

with different problems.

First some words about my try with 10_camera_recording which seems to use libargus to do so.
I’ve tried the same on a normal TX2 dev kit with ov5693 and then with our custom board with ov5647 to compare. Here are my results:
First I get this strange message with ov5647 about /dev/tegra_dc_ctrl.
I assume this is because I’ve removed nvdisplay as our custom carrier doesn’t offer any.
As the process continues I’m not worried that this is a problem.

Worker thread V4L2CaptureScheduler checkCaptureComplete start
Worker thread V4L2CaptureScheduler issueCaptures start
nvdc: open: No such file or directory
nvdc: failed to open '/dev/tegra_dc_ctrl'.
Worker thread PS handleRequests start

After that I get these differences which seem to be logical for me

NvPclHwPrintCameraSubModule -- HwCamSubModule[0].Name: v4l2_sensor
NvPclHwPrintCameraSubModule -- HwCamSubModule[0].DevName: ov5693 2-0036
NvPclHwPrintCameraSubModule -- HwCamSubModule[1].Name: v4l2_lens
NvPclHwPrintCameraSubModule -- HwCamSubModule[1].DevName: lc898212 2-0072

to

NvPclHwPrintCameraSubModule -- HwCamSubModule[0].Name: v4l2_sensor
NvPclHwPrintCameraSubModule -- HwCamSubModule[0].DevName: ov5647 2-0036
NvPclHwPrintCameraSubModule -- HwCamSubModule[1].Name: v4l2_lens
NvPclHwPrintCameraSubModule -- HwCamSubModule[1].DevName:

I don’t really know why lc898212 is presented in default case as the camera of the dev kit doesn’t offer auto lens… or does it? :-O

After that I get these differences

lug++
 hotPlugfunc ++ 
 addWatch: Watch added wd='1'
CheckProcDTExists: INFO: accessing /proc/device-tree/tegra-virtual-camera-platform/modules/module0/drivernode1; No such file or directory
PCLHW_DTParser
CheckProcDTExists: INFO: accessing /proc/device-tree/tegra-virtual-camera-platform/modules/module1/drivernode0; No such file or directory
PCLHW_DTParser
setHotplugCallback: Registered new callback client
NvPclSetHotplugCallback: ----------------------

to

lug++
 hotPlugfunc ++ 
 addWatch: Watch added wd='1'
CheckProcDTExists: INFO: accessing /proc/device-tree/tegra-virtual-camera-platform/modules; No such file or directory
PCLHW_DTParser
setHotplugCallback: Registered new callback client
NvPclSetHotplugCallback: ----------------------

Now with my custom board I don’t have /proc/device-tree/tegra-virtual-camera-platform.
Only /proc/device-tree/tegra-camera-platform/ does exist.

After that

initialize: ov5693 2-0036
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 Frame Rate not found
Control Exposure not found

to

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 OTP Data not found
Control Frame Rate not found
Control Exposure not found

I hope this is ok. I don’t really have any EEPROM or so and I hope that the FuseID is not important.
Why should it? I’ve removed the V4L2 controls from the driver.

Then a real difference occurs which I can’t understand and need help with.
This is the output of the ov5693 run and I’ve made which lines are missing on ov5647 side fat.

findCustomCids: calculated MaxCoarseDiff 6
<b>loadBinaryBlob: Binary read 8</b>
<b>loadBinaryBlob: Binary read 512</b>
OFDPropertyGetString: could not read property [type]
loadSubType: Sensor type missing in DT, 180
<b>OFDPropertyCopyToLong: could not read property [mode0.csi_pixel_bit_depth]</b>
<b>OFDPropertyCopyToLong: could not read property [mode0.dynamic_pixel_bit_depth]</b>
<b>OFDPropertyGetString: could not read property [mode0.mode_type]</b>
<b>mode 0: Failed to load mode type</b>
<b>OFDPropertyGetString: could not read property [mode0.pixel_phase]</b>
<b>mode 0: Failed to load pixel phase</b>
<b>OFDPropertyCopyToLong: could not read property [mode0.embedded_metadata_height]</b>
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]
<b>OFDPropertyCopyToLong: could not read property [mode1.csi_pixel_bit_depth]</b>
<b>OFDPropertyCopyToLong: could not read property [mode1.dynamic_pixel_bit_depth]</b>
<b>OFDPropertyGetString: could not read property [mode1.mode_type]</b>
<b>mode 1: Failed to load mode type</b>
<b>OFDPropertyGetString: could not read property [mode1.pixel_phase]</b>
<b>mode 1: Failed to load pixel phase</b>
<b>OFDPropertyCopyToLong: could not read property [mode1.embedded_metadata_height]</b>
<b>OFDPropertyGetString: could not read property [mode1.x_start]</b>
<b>OFDPropertyGetString: could not read property [mode1.y_start]</b>
<b>OFDPropertyGetString: could not read property [mode1.x_end]</b>
<b>OFDPropertyGetString: could not read property [mode1.y_end]</b>
<b>OFDPropertyGetString: could not read property [mode1.h_scaling]</b>
<b>OFDPropertyGetString: could not read property [mode1.v_scaling]</b>
<b>OFDPropertyCopyToLong: could not read property [mode2.csi_pixel_bit_depth]</b>
<b>OFDPropertyCopyToLong: could not read property [mode2.dynamic_pixel_bit_depth]</b>
<b>OFDPropertyGetString: could not read property [mode2.mode_type]</b>
<b>mode 2: Failed to load mode type</b>
<b>OFDPropertyGetString: could not read property [mode2.pixel_phase]</b>
<b>mode 2: Failed to load pixel phase</b>
<b>OFDPropertyCopyToLong: could not read property [mode2.embedded_metadata_height]</b>
<b>OFDPropertyGetString: could not read property [mode2.x_start]</b>
<b>OFDPropertyGetString: could not read property [mode2.y_start]</b>
<b>OFDPropertyGetString: could not read property [mode2.x_end]</b>
<b>OFDPropertyGetString: could not read property [mode2.y_end]</b>
<b>OFDPropertyGetString: could not read property [mode2.h_scaling]</b>
<b>OFDPropertyGetString: could not read property [mode2.v_scaling]</b>
OFDPropertyGetString: could not read property [sensor_model]

It feels logical for me that mode 1 and mode 2 are missing as I only present one mode with my driver.
It’s interesting that with ov5693 I get more error messages but it still works after that.
loadBinaryBlob is missing with ov5647. What does it do?

Not much happens now.

With the ov5693 i get

initialize: Loaded Driver: 3 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: ----------------------
sourceRegistry[0] assigned

ispRegistry[0] assigned

Using Source GUID 0
Worker thread ViCsiHw frameComplete start
Worker thread ViCsiHw frameStart start
NvPclPowerOn: +++++++++++
NvPclPowerOn: -----------

and then it goes on.

but with my new driver i only get

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!
(Argus) Objects still active during exit: [CameraProvider (0x10380e0): refs: 1, cref: 1]
Create the CameraProvider object and get the core interface.

and then the program exits.

Do you have suggestions for me?

1 Like

Please change the badge information to some others don’t use any of string from the reference board.

badge = "e3326_front_P5V27C"

Ok then. But now it does even less.

Set governor to performance before enabling profiler
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
nvdc: open: No such file or directory
nvdc: failed to open '/dev/tegra_dc_ctrl'.
Worker thread PS handleRequests start
getInstance: s_instance(0x1002a60)
getInstance: s_instance(0x1002a60)
subscribe: create SensorType(gyroscope) sensor(0x1004be0)
subscribe: create SensorType(accelerometer) sensor(0x100a040)
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
NvPclHwGetModuleList: WARNING: Could not map module to ISP config string
NvPclHwGetModuleList: No module data found
NvPclHwPrintModuleDefinition -- Name: c5647_front_ov5647
NvPclHwPrintModuleDefinition -- Position: 0
NvPclHwPrintModuleDefinition -- CalibrationData Found: 1
NvPclHwPrintCameraSubModule -- HwCamSubModule[0].Name: v4l2_sensor
NvPclHwPrintCameraSubModule -- HwCamSubModule[0].DevName: ov5647 2-0036
NvPclHwPrintCameraSubModule -- HwCamSubModule[1].Name: v4l2_lens
NvPclHwPrintCameraSubModule -- HwCamSubModule[1].DevName: 
NvPclHwGetModuleList: OFParserListModules Succeeded
NvPclModuleListInitialize: NvPclModule list[0]: c5647_front_ov5647 position0
NvPclHwScanExternalCameras -- adding video0 to discover list
NvPclHwScanExternalCameras -- adding video0 to discover list
initialize: /dev/video0
NvPclHwScanExternalCameras -- adding video0 to discover list
initialize: /dev/video0
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
PCLHW_DTParser
setHotplugCallback: Registered new callback client
NvPclSetHotplugCallback: ----------------------
NvPclOpen: ++++++++++++++++++++++
NvPclStateControllerOpen: Found GUID 0 match at index[0]
NvPclHwInitializeModule: allocate overrides pathname @ 0x0103d110
NvPclHwInitializeModule: allocate overrides pathname @ 0x010345e0
NvPclHwInitializeModule: allocate overrides pathname @ 0x01034670
NvPclHwInitializeModule: allocate overrides pathname @ 0x01034700
NvPclHwInitializeModule: allocate overrides pathname @ 0x01034790
NvPclHwInitializeModule: allocate overrides pathname @ 0x01034820
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/c5647_front_ov5647.isp] 6/16CheckOverridesPermissions: cannot stat file [/data/nvcam/settings/c5647_front_ov5647.isp]
LoadOverridesFile: looking for override file [/opt/nvidia/nvcam/settings/c5647_front_ov5647.isp] 7/16CheckOverridesPermissions: cannot stat file [/opt/nvidia/nvcam/settings/c5647_front_ov5647.isp]
LoadOverridesFile: looking for override file [/var/nvidia/nvcam/settings/c5647_front_ov5647.isp] 8/16CheckOverridesPermissions: cannot stat file [/var/nvidia/nvcam/settings/c5647_front_ov5647.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/c5647_front_ov5647.bin] 2/16
Imager: looking for override file [/opt/nvidia/nvcam/settings/c5647_front_ov5647.bin] 3/16
Imager: looking for override file [/var/nvidia/nvcam/settings/c5647_front_ov5647.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: ov5647 2-0036
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 OTP Data not found
Control Frame Rate not found
Control Exposure not found
findCustomCids: calculated MaxCoarseDiff 6
OFDPropertyGetString: could not read property [type]
loadSubType: Sensor type missing in DT, 180
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!
(Argus) Objects still active during exit: [CameraProvider (0x10380e0): refs: 1, cref: 1]
Create the CameraProvider object and get the core interface.

It stops there and the program exists.

I may have noticed something. What I’m still missing is /proc/device-tree/tegra-virtual-camera-platform.
I assume it correlates with hardware/nvidia/platform/t18x/common/kernel-dts/t18x-common-modules/tegra186-camera-vivid.dtsi.

There is the vivid driver with the folllowing modes
VIVID_3840x2160
VIVID_1920x1080
VIVID_1280x720

At some point it says something like

* ==== Modes ====
* A modeX node is required to support v4l2 driver
* implementation with NVIDIA camera software stack

Is this important that only those modes are accepted?

/dev/tegra_dc_ctrl is now also present. I had some nvdisplay stuff commented out as we don’t have a display connector with our board. I’ve put them in again. But It doesn’t seem to change anything for this problem.

What I also really want to mention is that nvcamera-daemon + gst-launch have a different flow than 10_camera_recording with libargus as it actually does more:

Let’s say I call

gst-launch-1.0 nvcamerasrc num-buffers=10 ! filesink location=dump.raw

Setting pipeline to PAUSED ...

Available Sensor modes :
640 x 480 FR=54.000000 CF=0x1009208a10 SensorModeType=4 CSIPixelBitDepth=8 DynPixelBitDepth=8
Pipeline is live and does not need PREROLL ...

NvCameraSrc: Trying To Set Default Camera Resolution. Selected sensorModeIndex = 0 WxH = 640x480 FrameRate = 54.000000 ...

Setting pipeline to PLAYING ...
New clock: GstSystemClock
Got EOS from element "pipeline0".
Execution ended after 0:00:02.403075595
Setting pipeline to PAUSED ...
Setting pipeline to READY ...

The nvcamera-daemon actually prints something similar but continues even after libargus stopps:

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(0x7f70b90cc0)
getInstance: s_instance(0x7f70b90cc0)
subscribe: create SensorType(gyroscope) sensor(0x7f70b92e40)
subscribe: create SensorType(accelerometer) sensor(0x7f70b982a0)
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
NvPclHwGetModuleList: WARNING: Could not map module to ISP config string
NvPclHwGetModuleList: No module data found
NvPclHwPrintModuleDefinition -- Name: c5647_front_ov5647
NvPclHwPrintModuleDefinition -- Position: 0
NvPclHwPrintModuleDefinition -- CalibrationData Found: 1
NvPclHwPrintCameraSubModule -- HwCamSubModule[0].Name: v4l2_sensor
NvPclHwPrintCameraSubModule -- HwCamSubModule[0].DevName: ov5647 2-0036
NvPclHwPrintCameraSubModule -- HwCamSubModule[1].Name: v4l2_lens
NvPclHwPrintCameraSubModule -- HwCamSubModule[1].DevName: 
NvPclHwGetModuleList: OFParserListModules Succeeded
NvPclModuleListInitialize: NvPclModule list[0]: c5647_front_ov5647 position0
NvPclHwScanExternalCameras -- adding video0 to discover list
NvPclHwScanExternalCameras -- adding video0 to discover list
initialize: /dev/video0
NvPclHwScanExternalCameras -- adding video0 to discover list
initialize: /dev/video0
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
PCLHW_DTParser
setHotplugCallback: Registered new callback client
NvPclSetHotplugCallback: ----------------------
NvPclOpen: ++++++++++++++++++++++
NvPclStateControllerOpen: Found GUID 0 match at index[0]
NvPclHwInitializeModule: allocate overrides pathname @ 0x7f70bc2730
NvPclHwInitializeModule: allocate overrides pathname @ 0x7f70bc27c0
NvPclHwInitializeModule: allocate overrides pathname @ 0x7f70bc2850
NvPclHwInitializeModule: allocate overrides pathname @ 0x7f70bc28e0
NvPclHwInitializeModule: allocate overrides pathname @ 0x7f70bc2970
NvPclHwInitializeModule: allocate overrides pathname @ 0x7f70bc2a00
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/c5647_front_ov5647.isp] 6/16CheckOverridesPermissions: cannot stat file [/data/nvcam/settings/c5647_front_ov5647.isp]
LoadOverridesFile: looking for override file [/opt/nvidia/nvcam/settings/c5647_front_ov5647.isp] 7/16CheckOverridesPermissions: cannot stat file [/opt/nvidia/nvcam/settings/c5647_front_ov5647.isp]
LoadOverridesFile: looking for override file [/var/nvidia/nvcam/settings/c5647_front_ov5647.isp] 8/16CheckOverridesPermissions: cannot stat file [/var/nvidia/nvcam/settings/c5647_front_ov5647.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/c5647_front_ov5647.bin] 2/16
Imager: looking for override file [/opt/nvidia/nvcam/settings/c5647_front_ov5647.bin] 3/16
Imager: looking for override file [/var/nvidia/nvcam/settings/c5647_front_ov5647.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: ov5647 2-0036
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 OTP Data not found
Control Frame Rate not found
Control Exposure not found
findCustomCids: calculated MaxCoarseDiff 6
OFDPropertyGetString: could not read property [type]
loadSubType: Sensor type missing in DT, 180
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 640x480
setActiveBufferMemory: 2
INPUT: Width 640 Height 480 pixelformat RGGB
writeFrameRate:	INPUT frameLength:1345, frameRate:54.000000
writeExposure:	INPUT coarseTime:1339, expTime:0.018429
updateOutputSettings:	OUTPUT frameLength:1345, frameRate:54.019516
updateOutputSettings:	OUTPUT coarseTime:1339, expTime:0.018429
apply:-----------------------
NvPclSettingsApply: Reading PCL settings
PowerServiceUtils:calculateReqClock: entered
PowerServiceHw:addRequest: table size: before: 0, after:1
	request table for VI 0:
	req[0]: guID=0, stageID=SensorCapture
	req[0]: inW=640, inH=480, inBpp = 8, fps=54
	req[0]: outW=640, outH=480, outBpp=8
	req[0]: out1W=0, out1H=0, out1Bpp=0
	req[0]: out2W=0, out2H=0, out2Bpp=0
	req[0]: clock=8137500, pixelRate=46500000, timeout=900
	req[0]: isoBw=65096, timeout=900
	req[0]: non_isoBw=0, timeout=900
PowerServiceUtils:calculateReqClock: entered
PowerServiceHw:addRequest: table size: before: 0, after:1
	request table for CSI 0:
	req[0]: guID=0, stageID=SensorCapture
	req[0]: inW=640, inH=480, inBpp = 8, fps=54
	req[0]: outW=640, outH=480, outBpp=8
	req[0]: out1W=0, out1H=0, out1Bpp=0
	req[0]: out2W=0, out2H=0, out2Bpp=0
	req[0]: clock=7556249, pixelRate=46500000, timeout=900
	req[0]: isoBw=0, timeout=900
	req[0]: non_isoBw=0, timeout=900
PowerServiceHwVi:setIso: m_bwVal_Iso=65096
PowerServiceHw:setClock: PowerServiceHw[1]: requested_clock_Hz=8137500
PowerServiceHw:setClock: PowerServiceHw[0]: requested_clock_Hz=7556249
PowerServiceCore:setCameraBw: totalIsoBw=65096
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: 640x480 BayerS16RGGB 54.0fps
      | output 0: 640x480 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: [640, 480]
          | IspOut0: [640, 480]
      +  5: StatsBufferAcquireStage
          | Buffer Index: 1
          | BufferRequirements: 640x480 Pitch Y8 420
      +  6: TempBufferAcquireStage
          | Buffer Index: 2
          | BufferRequirements: 640x1 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

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

Thread 1 getting next capture
Thread 1 is waiting
NvPclSettingsUpdate: Sending Updated Settings through PCLThread 3 is waiting

NvPclSettingsApply: Applying last settings through PCL
apply:+++++++++++++++++++++++
writeFrameRate:	INPUT frameLength:2421, frameRate:30.000000
writeGain:	INPUT gainCtrl:100 analogGain:1.000100
writeExposure:	INPUT coarseTime:2415, expTime:0.033239
CC 102 session 0 completed step 4 in fiber 0x7f24000b70
CC 102 session 0 completed step 5 in fiber 0x7f24000b70
CC 102 session 0 completed step 6 in fiber 0x7f24000b70
CC 102 session 0 processing step 7 in fiber 0x7f24000b70
FiberScheduler: cc 102, session 0, fiber 0x7f24000b70 in progress...

Thread 2 getting next capture
Thread 4 is waiting
Thread 2 is waiting
updateOutputSettings:	OUTPUT frameLength:2421, frameRate:30.010843
updateOutputSettings:	OUTPUT analogGain:1.000000
updateOutputSettings:	OUTPUT coarseTime:2415, expTime:0.033239
apply:-----------------------
NvPclSettingsApply: Reading PCL settings
PowerServiceUtils:calculateReqClock: entered
PowerServiceHw:addRequest: table size: before: 1, after:2
	request table for VI 0:
	req[0]: guID=0, stageID=SensorCapture
	req[0]: inW=640, inH=480, inBpp = 8, fps=54
	req[0]: outW=640, outH=480, outBpp=8
	req[0]: out1W=0, out1H=0, out1Bpp=0
	req[0]: out2W=0, out2H=0, out2Bpp=0
	req[0]: clock=8137500, pixelRate=46500000, timeout=900
	req[0]: isoBw=65096, timeout=900
	req[0]: non_isoBw=0, timeout=900
	req[1]: guID=0, stageID=SensorIspCapture
	req[1]: inW=640, inH=480, inBpp = 8, fps=54
	req[1]: outW=640, outH=480, outBpp=16
	req[1]: out1W=0, out1H=0, out1Bpp=0
	req[1]: out2W=0, out2H=0, out2Bpp=0
	req[1]: clock=8137500, pixelRate=46500000, timeout=450
	req[1]: isoBw=0, timeout=450
	req[1]: non_isoBw=0, timeout=450
PowerServiceUtils:calculateReqClock: entered
PowerServiceHw:addRequest: table size: before: 1, after:2
	request table for CSI 0:
	req[0]: guID=0, stageID=SensorCapture
	req[0]: inW=640, inH=480, inBpp = 8, fps=54
	req[0]: outW=640, outH=480, outBpp=8
	req[0]: out1W=0, out1H=0, out1Bpp=0
	req[0]: out2W=0, out2H=0, out2Bpp=0
	req[0]: clock=7556249, pixelRate=46500000, timeout=900
	req[0]: isoBw=0, timeout=900
	req[0]: non_isoBw=0, timeout=900
	req[1]: guID=0, stageID=SensorIspCapture
	req[1]: inW=640, inH=480, inBpp = 8, fps=54
	req[1]: outW=640, outH=480, outBpp=16
	req[1]: out1W=0, out1H=0, out1Bpp=0
	req[1]: out2W=0, out2H=0, out2Bpp=0
	req[1]: clock=7556249, pixelRate=46500000, timeout=450
	req[1]: isoBw=0, timeout=450
	req[1]: non_isoBw=0, timeout=450
PowerServiceUtils:calculateReqClock: entered
PowerServiceHw:addRequest: table size: before: 0, after:1
	request table for ISP 0:
	req[0]: guID=0, stageID=SensorIspCapture
	req[0]: inW=640, inH=480, inBpp = 8, fps=54
	req[0]: outW=44, outH=34, outBpp=16
	req[0]: out1W=320, out1H=200, out1Bpp=16
	req[0]: out2W=320, out2H=200, out2Bpp=16
	req[0]: clock=25575000, pixelRate=46500000, timeout=450
	req[0]: isoBw=306900, timeout=450
	req[0]: non_isoBw=0, timeout=450
PowerServiceCore:handleRequests: timePassed = 782
PowerServiceHwIsp:setLaBw: m_bwVal_Iso=306900 and m_bwVal_NonIso=0 KBpS

PowerServiceHw:setClock: PowerServiceHw[2]: requested_clock_Hz=25575000
PowerServiceCore:setCameraBw: totalIsoBw=306900
SCF: Error BadParameter:  (propagating from src/services/capture/CaptureServiceDeviceViCsi.cpp, function startCapture(), line 707)
SCF: Error BadParameter:  (propagating from src/services/capture/CaptureServiceCore.cpp, function doCSItoISPCapture(), line 481)
SCF: Error BadParameter:  (propagating from src/services/capture/CaptureServiceCore.cpp, function issueCapture(), line 362)
SCF: Error BadParameter:  (propagating from src/services/capture/CaptureServiceDevice.cpp, function issueCaptures(), line 1213)
SCF: Error BadParameter:  (propagating from src/services/capture/CaptureServiceDevice.cpp, function issueCaptures(), line 1043)
FiberScheduler: cc 101, session 0, fiber 0x7f240008c0 aborted in async operation

SCF: Error Timeout:  (propagating from src/api/Buffer.cpp, function waitForUnlock(), line 511)
SCF: Error Timeout:  (propagating from src/components/CaptureContainerImpl.cpp, function returnBuffer(), line 354)
FiberScheduler: fiber 0x7f240008c0 exiting
SCF: Error BadParameter:  (propagating from src/common/Utils.cpp, function workerThread(), line 114)
SCF: Error BadParameter: Worker thread CaptureScheduler frameStart failed (in src/common/Utils.cpp, function workerThread(), line 131)
disposing CC 101 Session 0
SCF: Error Timeout:  (propagating from src/api/Buffer.cpp, function waitForUnlock(), line 511)
SCF: Error Timeout:  (propagating from src/components/CaptureContainerImpl.cpp, function returnBuffer(), line 354)
Thread 5 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 0x7f240008c0 for CC 103 globalID 103 session 0
Thread 6 is working on CC 103 session 0 globalID 103 step 0
Fiber 0x7f240008c0 is aborting in CC 103 Session 0
FiberScheduler: cc 103 session 0, fiber 0x7f240008c0 aborted

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

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

Thread 6 getting next capture
disposing CC 103 Session 0
launchCC abort cc 106 session 0
Thread 10 is waiting
Thread 9 is waiting
Thread 6 is waiting
Created fiber 0x7f70fb2010 for CC 106 globalID 106 session 0
Thread 11 is working on CC 106 session 0 globalID 106 step 0
SCF: Error Timeout:  (propagating from src/api/Session.cpp, function capture(), line 830)
Fiber 0x7f70fb2010 is aborting in CC 106 Session 0FiberScheduler: fiber 0x7f70c3db30 exiting
Thread 7 getting next capture
disposing CC 104 Session 0
launchCC abort cc 107 session 0
Thread 7 is waiting
Thread 12 is waiting

FiberScheduler: cc 106 session 0, fiber 0x7f70fb2010 aborted

FiberScheduler: fiber 0x7f70fb4890 exiting
Thread 1 is waiting
Created fiber 0x7f70fb4850 for CC 107 globalID 107 session 0
SCF: Error Timeout:  (propagating from src/api/Session.cpp, function capture(), line 830)
Thread 8 getting next capture
disposing CC 105 Session 0
Thread 3 is working on CC 107 session 0 globalID 107 step 0
Fiber 0x7f70fb4850 is aborting in CC 107 Session 0Thread 4 is waiting

Thread 2 is waiting
launchCC abort cc 108 session 0
Thread 8 is waiting
FiberScheduler: cc 107 session 0, fiber 0x7f70fb4850 aborted

Created fiber 0x7f70fb4810 for CC 108 globalID 108 session 0
Thread 5 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 0x7f70fb4810 is aborting in CC 108 Session 0
FiberScheduler: cc 108 session 0, fiber 0x7f70fb4810 aborted

launchCC abort cc 109 session 0
Created fiber 0x7f70fb4e80 for CC 109 globalID 109 session 0
FiberScheduler: fiber 0x7f70fb2010 exitingThread 10 is working on CC 109 session 0 globalID 109 step 0
Fiber 0x7f70fb4e80 is aborting in CC 109 Session 0
FiberScheduler: cc 109 session 0, fiber 0x7f70fb4e80 aborted


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

FiberScheduler: fiber 0x7f70fb4810 exiting
Thread 5 getting next capture
disposing CC 108 Session 0
Thread 5 is waiting
Thread 2 is waiting
Thread 7 is waiting
Thread 4 is working on CC 111 session 0 globalID 111 step 0
Created fiber 0x7f70fb1770 for CC 111 globalID 111 session 0Fiber 0x7f70fb1770 is aborting in CC 111 Session 0

FiberScheduler: cc 111 session 0, fiber 0x7f70fb1770 aborted

SCF: Error Timeout:  (propagating from src/api/Session.cpp, function capture(), line 830)
FiberScheduler: fiber 0x7f706a7bd0 exiting
Thread 8 is waiting
Thread 12 getting next capture
disposing CC 110 Session 0
launchCC abort cc 112 session 0
Thread 9 is waiting
Thread 11 is waiting
FiberScheduler: fiber 0x7f70fb4e80 exiting
Thread 10 getting next capture
disposing CC 109 Session 0
Thread 10 is waiting
Thread 12 is waiting
Thread 1 is waiting
FiberScheduler: fiber 0x7f70fb1770 exiting
Thread 3 is waiting
Created fiber 0x7f70fb1ba0 for CC 112 globalID 112 session 0
SCF: Error Timeout:  (propagating from src/api/Session.cpp, function capture(), line 830)
Thread 6 is working on CC 112 session 0 globalID 112 step 0
Fiber 0x7f70fb1ba0 is aborting in CC 112 Session 0
FiberScheduler: cc 112 session 0, fiber 0x7f70fb1ba0 aborted

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

launchCC abort cc 114 session 0
Created fiber 0x7f70fb5500 for CC 114 globalID 114 session 0Thread 9 is working on CC 114 session 0 globalID 114 step 0

Thread 2 is waiting
Fiber 0x7f70fb5500 is aborting in CC 114 Session 0
SCF: Error Timeout:  (propagating from src/api/Session.cpp, function capture(), line 830)
Thread 7 is waiting
Thread 4 getting next capturedisposing CC 111 Session 0FiberScheduler: fiber 0x7f706a7bd0 exiting


Thread 11 is waiting
Thread 5 is waiting
FiberScheduler: cc 114 session 0, fiber 0x7f70fb5500 aborted

launchCC abort cc 115 session 0
Thread 12 is working on CC 115 session 0 globalID 115 step 0
Fiber 0x7f70c3db70 is aborting in CC 115 Session 0
FiberScheduler: cc 115 session 0, fiber 0x7f70c3db70 aborted

Thread 8 getting next capture
disposing CC 113 Session 0
Thread 8 is waiting
Thread 4 is waiting
Thread 10 is waiting
Created fiber 0x7f70c3db70 for CC 115 globalID 115 session 0
Thread 1 is waiting
SCF: Error Timeout:  (propagating from src/api/Session.cpp, function capture(), line 830)
FiberScheduler: fiber 0x7f70fb5500 exiting
Thread 9 getting next capture
disposing CC 114 Session 0
Thread 9 is waiting
Thread 2 is waiting
Thread 3 is waiting
FiberScheduler: fiber 0x7f70c3db70 exiting
launchCC abort cc 116 session 0
Thread 12 getting next capturedisposing CC 115 Session 0

Thread 7 is waiting
Thread 11 is working on CC 116 session 0 globalID 116 step 0
Fiber 0x7f70fb55f0 is aborting in CC 116 Session 0
FiberScheduler: fiber 0x7f70fb1ba0 exitingCreated fiber 0x7f70fb55f0 for CC 116 globalID 116 session 0FiberScheduler: cc 116 session 0, fiber 0x7f70fb55f0 aborted



Thread 12 is waiting
SCF: Error Timeout:  (propagating from src/api/Session.cpp, function capture(), line 830)
Thread 5 is waiting
Thread 6 getting next capture
disposing CC 112 Session 0
Thread 4 is waiting
Thread 8 is waiting
FiberScheduler: fiber 0x7f70fb55f0 exiting
Thread 6 is waitinglaunchCC abort cc 117 session 0

Thread 11 getting next capture
disposing CC 116 Session 0
Thread 1 is waiting
Thread 10 is working on CC 117 session 0 globalID 117 step 0
Created fiber 0x7f70fb8260 for CC 117 globalID 117 session 0Thread 11 is waitingFiber 0x7f70fb8260 is aborting in CC 117 Session 0


Thread 9 is waiting
SCF: Error Timeout:  (propagating from src/api/Session.cpp, function capture(), line 830)
FiberScheduler: cc 117 session 0, fiber 0x7f70fb8260 aborted

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

Thread 10 getting next capture
disposing CC 117 Session 0
launchCC abort cc 119 session 0
Thread 10 is waiting
Thread 3 is waiting
Thread 7 is waiting
Created fiber 0x7f70fb8260 for CC 119 globalID 119 session 0
Thread 12 is working on CC 119 session 0 globalID 119 step 0
SCF: Error Timeout:  (propagating from src/api/Session.cpp, function capture(), line 830)
Fiber 0x7f70fb8260 is aborting in CC 119 Session 0
FiberScheduler: cc 119 session 0, fiber 0x7f70fb8260 aborted

FiberScheduler: fiber 0x7f70fb8220 exiting
Thread 2 getting next capture
disposing CC 118 Session 0
Thread 2 is waiting
FiberScheduler: fiber 0x7f70fb8260 exiting
Thread 4 is waiting
Thread 5 is waiting
Thread 12 getting next capture
Thread 6 is waiting
Thread 8 is waiting
Thread 12 is waiting
SCF: Error Timeout: ISP port 0 timed out! (in src/services/capture/CaptureServiceDeviceIsp.cpp, function waitIspFrameEnd(), line 702)
SCF: Error Timeout: ISP Stats timed out! (in src/services/capture/CaptureServiceDeviceIsp.cpp, function waitIspStatsFinished(), line 785)
SCF: Error Timeout: ISP port 1 timed out! (in src/services/capture/CaptureServiceDeviceIsp.cpp, function waitIspFrameEnd(), line 725)
SCF: Error Timeout: ISP port 2 timed out! (in src/services/capture/CaptureServiceDeviceIsp.cpp, function waitIspFrameEnd(), line 736)
SCF: Error Timeout:  (propagating from src/services/capture/CaptureServiceDeviceIsp.cpp, function waitIspFrameEnd(), line 743)
SCF: Error Timeout:  (propagating from src/common/Utils.cpp, function workerThread(), line 114)
SCF: Error Timeout: Worker thread IspHw frameComplete failed (in src/common/Utils.cpp, function workerThread(), line 131)
waitForIdleLocked remaining request 102 
SCF: Error Timeout: waitForIdle() timed out (in src/api/Session.cpp, function waitForIdleLocked(), line 916)
Session 0 aborting capture 102 (API ID: 1)
waitForIdleLocked remaining request 102 
SCF: Error Timeout: waitForIdle() timed out (in src/api/Session.cpp, function waitForIdleLocked(), line 916)
SCF: Error Timeout:  (propagating from src/api/Session.cpp, function abortCaptures(), line 882)
SCF: Error Timeout:  (propagating from src/api/Session.cpp, function shutdown(), line 398)
Worker thread CaptureDispatcher stop
disposing CC 119 Session 0

Sadly I get a ISP timeout of some sort. The resulting dump file is always 8080 byte in size but doesn’t really contain data that I can see as image.

Did you see the syncpt timeout from the UART console or kernel message?
Please confirm the “mclk_multiplier”, “mclk_multiplier” is correct and also try the discontinuous_clk as “yes”

mode1 { //OV5693_MODE_2592X1458
				mclk_khz = "24000";
				num_lanes = "2";
				tegra_sinterface = "serial_c";
				discontinuous_clk = "no";
				dpcm_enable = "false";
				cil_settletime = "0";

				active_w = "2592";
				active_h = "1458";
				pixel_t = "bayer_bggr";
				readout_orientation = "90";
				line_length = "2688";
				inherent_gain = "1";
				mclk_multiplier = "6.67";
				pix_clk_hz = "160000000";

				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";
			};

Sorry for the late reply.

I’ve checked mclk_multiplier and discontinuous_clk was already yes in my case.
I will give you the output of my UART.
Please be aware that I have massive amounts of custom debug prints.

It’s so confusing that V4L2 itself is working.

It’s not that I get the “classical” SOF timeout.
It’s more like a fence timeout.

Is there an overview on what has to be done for using nvcamerasrc?
I’ve only read the L27 driver guide but followed every step I could do.

[  104.230754] ov5647 2-0036: camera_common_mclk_enable: enable MCLK with 24000000 Hz
[  104.238364] ov5647 2-0036: camera_common_dpd_disable: csi 4
[  104.244072] ov5647 2-0036: ov5647_power_on: power on
[  104.253548] ov5647 2-0036: ov5647_power_off: power off
[  104.260820] ov5647 2-0036: camera_common_dpd_enable: csi 4
[  104.266306] Disabling clock was prohibited!
[  104.271522] ov5647 2-0036: camera_common_mclk_enable: enable MCLK with 24000000 Hz
[  104.279183] ov5647 2-0036: camera_common_dpd_disable: csi 4
[  104.284763] ov5647 2-0036: ov5647_power_on: power on
[  104.294181] ov5647 2-0036: ov5647_power_off: power off
[  104.301395] ov5647 2-0036: camera_common_dpd_enable: csi 4
[  104.306887] Disabling clock was prohibited!
[  104.317625] ov5647 2-0036: camera_common_mclk_enable: enable MCLK with 24000000 Hz
[  104.325204] ov5647 2-0036: camera_common_dpd_disable: csi 4
[  104.330779] ov5647 2-0036: ov5647_power_on: power on
[  104.340166] ov5647 2-0036: ov5647_power_off: power off
[  104.347384] ov5647 2-0036: camera_common_dpd_enable: csi 4
[  104.352872] Disabling clock was prohibited!
[  104.357304] ov5647 2-0036: camera_common_mclk_enable: enable MCLK with 24000000 Hz
[  104.364877] ov5647 2-0036: camera_common_dpd_disable: csi 4
[  104.370453] ov5647 2-0036: ov5647_power_on: power on
[  104.379821] ov5647 2-0036: ov5647_power_off: power off
[  104.387041] ov5647 2-0036: camera_common_dpd_enable: csi 4
[  104.392526] Disabling clock was prohibited!
[  104.397152] ov5647 2-0036: camera_common_mclk_enable: enable MCLK with 24000000 Hz
[  104.404799] ov5647 2-0036: camera_common_dpd_disable: csi 4
[  104.410377] ov5647 2-0036: ov5647_power_on: power on
[  104.419721] camera_common_enum_framesizes 615 30314752
[  104.424862] camera_common_evaluate_color_format 587
[  104.429745] camera_common_evaluate_color_format 596 1 30314752
[  104.435577] camera_common_enum_framesizes 634
[  104.439940] camera_common_enum_framesizes 615 30314752
[  104.445077] camera_common_evaluate_color_format 587
[  104.449957] camera_common_evaluate_color_format 596 1 30314752
[  104.455790] camera_common_enum_framesizes 634
[  104.460149] camera_common_enum_framesizes 615 30314752
[  104.465289] camera_common_enum_framesizes 615 30314742
[  104.470433] camera_common_evaluate_color_format 587
[  104.475319] camera_common_evaluate_color_format 596 2 30314742
[  104.481156] camera_common_enum_framesizes 634
[  104.485522] camera_common_enum_framesizes 615 30314742
[  104.490658] camera_common_evaluate_color_format 587
[  104.495536] camera_common_evaluate_color_format 596 2 30314742
[  104.501367] camera_common_enum_framesizes 634
[  104.505725] camera_common_enum_framesizes 615 30314742
[  104.510868] camera_common_enum_framesizes 615 32314752
[  104.516006] camera_common_evaluate_color_format 587
[  104.520883] camera_common_evaluate_color_format 596 0 32314752
[  104.526715] camera_common_enum_framesizes 634
[  104.531074] camera_common_enum_framesizes 615 32314752
[  104.536212] camera_common_evaluate_color_format 587
[  104.541088] camera_common_evaluate_color_format 596 0 32314752
[  104.546919] camera_common_enum_framesizes 634
[  104.551278] camera_common_enum_framesizes 615 32314752
[  104.556428] ov5647 2-0036: ov5647_power_off: power off
[  104.563652] ov5647 2-0036: camera_common_dpd_enable: csi 4
[  104.569186] Disabling clock was prohibited!
[  104.620120] ov5647 2-0036: camera_common_mclk_enable: enable MCLK with 24000000 Hz
[  104.627723] ov5647 2-0036: camera_common_dpd_disable: csi 4
[  104.633333] ov5647 2-0036: ov5647_power_on: power on
[  104.642731] try_or_set_cluster 2970 HDR enable
[  104.647307] try_or_set_cluster 2998 no change? 0 1
[  104.652145] try_or_set_cluster 2970 Bypass Mode
[  104.656719] try_or_set_cluster 2998 no change? 0 1
[  104.661550] try_or_set_cluster 2970 Override Enable
[  104.666435] try_or_set_cluster 2998 no change? 0 1
[  104.671277] ov5647 2-0036: camera_common_try_fmt: size 640 x 480
[  104.677292] camera_common_try_fmt s_data->use_sensor_mode_id 0
[  104.683123] camera_common_try_fmt s_data->sensor_mode_id 0
[  104.688611] min_bpl 640
[  104.691061] max_bpl 32768
[  104.693674] temp_bpl 768
[  104.696213] tegra_channel_fmt_align 196 bytesperline 768
[  104.701527] ov5647 2-0036: camera_common_s_fmt(12308) size 640 x 480
[  104.707877] camera_common_find_datafmt 3014 - Found code
[  104.713203] ov5647 2-0036: camera_common_try_fmt: size 640 x 480
[  104.719212] camera_common_try_fmt s_data->use_sensor_mode_id 0
[  104.725044] camera_common_try_fmt s_data->sensor_mode_id 0
[  104.730530] camera_common_find_datafmt 3014 - Found code
[  104.735858] min_bpl 640
[  104.738296] max_bpl 32768
[  104.740923] temp_bpl 768
[  104.743461] tegra_channel_fmt_align 196 bytesperline 768
[  104.748840] try_or_set_cluster 2970 Group Hold
[  104.753292] try_or_set_cluster 2970 Frame Length
[  104.757920] try_or_set_cluster 2970 Group Hold
[  104.762370] try_or_set_cluster 2998 no change? 0 1
[  104.767161] try_or_set_cluster 2970 Frame Length
[  104.771780] try_or_set_cluster 2998 no change? 0 1
[  104.776572] try_or_set_cluster 2970 Coarse Time
[  104.781102] try_or_set_cluster 2970 Group Hold
[  104.796828] vi4_channel_start_streaming
[  104.800676] ov5647 2-0036: camera_common_g_fmt++
[  104.805300] tegra_channel_set_stream 547
[  104.809227] tegra_channel_set_stream 552
[  104.813155] tegra_csi_s_stream
[  104.817378] nvcsi 150c0000.nvcsi: csi port:4
[  104.821655] csi4_phy_write 2 20 700000
[  105.322828] tegra_mipi_cal 3990000.mipical: Mipi cal timeout,val:8871, lanes:1000000
[  105.336775] tegra_mipi_cal 3990000.mipical: MIPI_CAL_CTRL                  0x04 0x2a000010
[  105.345397] tegra_mipi_cal 3990000.mipical: CIL_MIPI_CAL_STATUS            0x0c 0x00008871
[  105.353867] tegra_mipi_cal 3990000.mipical: CIL_MIPI_CAL_STATUS_2          0x10 0x00000000
[  105.362318] tegra_mipi_cal 3990000.mipical: CILA_MIPI_CAL_CONFIG           0x18 0x00000000
[  105.370798] tegra_mipi_cal 3990000.mipical: CILB_MIPI_CAL_CONFIG           0x1c 0x00000000
[  105.379140] tegra_mipi_cal 3990000.mipical: CILC_MIPI_CAL_CONFIG           0x20 0x00000000
[  105.387510] tegra_mipi_cal 3990000.mipical: CILD_MIPI_CAL_CONFIG           0x24 0x00000000
[  105.395865] tegra_mipi_cal 3990000.mipical: CILE_MIPI_CAL_CONFIG           0x28 0x00200000
[  105.404170] tegra_mipi_cal 3990000.mipical: CILF_MIPI_CAL_CONFIG           0x2c 0x00000000
[  105.412500] tegra_mipi_cal 3990000.mipical: DSIA_MIPI_CAL_CONFIG           0x3c 0x00000200
[  105.420815] tegra_mipi_cal 3990000.mipical: DSIB_MIPI_CAL_CONFIG           0x40 0x00000200
[  105.429120] tegra_mipi_cal 3990000.mipical: DSIC_MIPI_CAL_CONFIG           0x44 0x00000200
[  105.437434] tegra_mipi_cal 3990000.mipical: DSID_MIPI_CAL_CONFIG           0x48 0x00000200
[  105.445733] tegra_mipi_cal 3990000.mipical: MIPI_BIAS_PAD_CFG0             0x5c 0x00000000
[  105.454052] tegra_mipi_cal 3990000.mipical: MIPI_BIAS_PAD_CFG1             0x60 0x00000000
[  105.462365] tegra_mipi_cal 3990000.mipical: MIPI_BIAS_PAD_CFG2             0x64 0x00010010
[  105.470670] tegra_mipi_cal 3990000.mipical: DSIA_MIPI_CAL_CONFIG_2         0x68 0x00000002
[  105.478967] tegra_mipi_cal 3990000.mipical: DSIB_MIPI_CAL_CONFIG_2         0x6c 0x00000002
[  105.487265] tegra_mipi_cal 3990000.mipical: DSIC_MIPI_CAL_CONFIG_2         0x74 0x00000002
[  105.495547] tegra_mipi_cal 3990000.mipical: DSID_MIPI_CAL_CONFIG_2         0x78 0x00000002
[  105.503835] ov5647 2-0036: ov5647_s_stream++
[  105.517132] ov5647 2-0036: ov5647_s_stream--
[  105.552329] try_or_set_cluster 2970 Group Hold
[  105.556812] try_or_set_cluster 2970 Frame Length
[  105.561506] try_or_set_cluster 2970 Gain
[  105.565460] try_or_set_cluster 2998 no change? 0 1
[  105.570291] try_or_set_cluster 2970 Group Hold
[  105.574766] try_or_set_cluster 2998 no change? 0 1
[  105.579575] try_or_set_cluster 2970 Frame Length
[  105.584220] try_or_set_cluster 2998 no change? 0 1
[  105.589018] try_or_set_cluster 2970 Gain
[  105.592949] try_or_set_cluster 2998 no change? 0 1
[  105.597766] try_or_set_cluster 2970 Coarse Time
[  105.602318] try_or_set_cluster 2970 Group Hold
[  105.608019] tegra-ivc-vi-notify ivc-b000000.rtcpu:vinotify@12c0: vi_notify_channel_enable_reports: ch:0
[  107.107449] fence timeout on [ffffffc1c55c6d00] after 1500ms
[  107.113247] fence timeout on [ffffffc1c55c6b00] after 1500ms
[  107.118773] name=[nvhost_sync:12], current value=183 waiting value=184
[  107.118782] ---- mlocks ----
[  107.118797] 8: locked by channel 6
[  107.118815]
[  107.118818] ---- syncpts ----
[  107.118839] id 9 (17000000.gp10b_507) min 6108 max 6108 refs 1 (previous client : )
[  107.118847] id 11 (17000000.gp10b_506) min 4 max 4 refs 1 (previous client : )
[  107.118853] id 12 (15600000.isp_nvcamera-daemon_0) min 183 max 185 refs 3 (previous client : 15600000.isp_nvcamera-daemon_0)
[  107.118860] id 13 (15600000.isp_nvcamera-daemon_1) min 182 max 183 refs 3 (previous client : 15600000.isp_nvcamera-daemon_1)
[  107.118866] id 14 (15600000.isp_nvcamera-daemon_2) min 1 max 2 refs 3 (previous client : 15600000.isp_nvcamera-daemon_2)
[  107.118871] id 15 (15600000.isp_nvcamera-daemon_3) min 1 max 2 refs 3 (previous client : 15600000.isp_nvcamera-daemon_3)
[  107.118878] id 16 (15600000.isp_nvcamera-daemon_4) min 32 max 34 refs 4 (previous client : 15600000.isp_nvcamera-daemon_4)
[  107.118884] id 17 (15600000.isp_nvcamera-daemon_5) min 1 max 2 refs 3 (previous client : 15600000.isp_nvcamera-daemon_5)
[  107.118890] id 18 (17000000.gp10b_505) min 2 max 2 refs 1 (previous client : 15600000.isp_kworker/3:2_0)
[  107.118899] id 22 (17000000.gp10b_501) min 4 max 4 refs 1 (previous client : 17000000.gp10b_501)
[  107.118906] id 24 (17000000.gp10b_492) min 26 max 26 refs 1 (previous client : 15700000.vi_0)
[  107.118912] id 25 (17000000.gp10b_493) min 6 max 6 refs 1 (previous client : 15700000.vi_0)
[  107.118920] id 28 (17000000.gp10b_490) min 12 max 12 refs 1 (previous client : 15700000.vi_1)
[  107.118926] id 29 (17000000.gp10b_489) min 12 max 12 refs 1 (previous client : 15700000.vi_2)
[  107.118932] id 30 (17000000.gp10b_488) min 45 max 45 refs 1 (previous client : 150c0000.nvcsi_0)
[  107.118943] id 32 (17000000.gp10b_491) min 8 max 8 refs 1 (previous client : 17000000.gp10b_499)
[  107.118974] id 34 (17000000.gp10b_498) min 6 max 6 refs 1 (previous client : 17000000.gp10b_497)
[  107.118989] id 36 (17000000.gp10b_496) min 2 max 2 refs 1 (previous client : 17000000.gp10b_495)
[  107.118997] id 37 (15340000.vic_nvcamera-daemon_0) min 8 max 8 refs 1 (previous client : 17000000.gp10b_494)
[  107.119007] id 39 (17000000.gp10b_494) min 8 max 8 refs 1 (previous client : 17000000.gp10b_492)
[  107.119013] id 40 (15700000.vi_0) min 7 max 7 refs 2 (previous client : 15340000.vic_nvcamera-daemon_0)
[  107.119024] id 44 (150c0000.nvcsi_0) min 40 max 40 refs 2 (previous client : 150c0000.nvcsi_0)
[  107.119657]
[  107.119659] ---- channels ----
[  107.119681]
[  107.119681] channel 1 - 15820000.se
[  107.119681]
[  107.119684] NvHost basic channel registers:
[  107.119689] CMDFIFO_STAT_0:  00002040
[  107.119693] CMDFIFO_RDATA_0: c0013856
[  107.119698] CMDP_OFFSET_0:   00000000
[  107.119702] CMDP_CLASS_0:    00000000
[  107.119705] CHANNELSTAT_0:   00000000
[  107.119709] The CDMA sync queue is empty.
[  107.119710]
[  107.119716]
[  107.119716] channel 2 - 15830000.se
[  107.119716]
[  107.119717] NvHost basic channel registers:
[  107.119721] CMDFIFO_STAT_0:  00002040
[  107.119724] CMDFIFO_RDATA_0: 12040c82
[  107.119729] CMDP_OFFSET_0:   00000000
[  107.119732] CMDP_CLASS_0:    00000000
[  107.119735] CHANNELSTAT_0:   00000000
[  107.119736] The CDMA sync queue is empty.
[  107.119738]
[  107.119743]
[  107.119743] channel 3 - 15840000.se
[  107.119743]
[  107.119745] NvHost basic channel registers:
[  107.119748] CMDFIFO_STAT_0:  00002040
[  107.119751] CMDFIFO_RDATA_0: 85214010
[  107.119756] CMDP_OFFSET_0:   00000000
[  107.119760] CMDP_CLASS_0:    00000000
[  107.119763] CHANNELSTAT_0:   00000000
[  107.119765] The CDMA sync queue is empty.
[  107.119766]
[  107.119771]
[  107.119771] channel 6 - 15600000.isp
[  107.119771]
[  107.119773] NvHost basic channel registers:
[  107.119775] CMDFIFO_STAT_0:  0000000e
[  107.119778] CMDFIFO_RDATA_0: 004e0041
[  107.119783] CMDP_OFFSET_0:   00000050
[  107.119786] CMDP_CLASS_0:    00000001
[  107.119789] CHANNELSTAT_0:   00000000
[  107.119798]
[  107.119798] ffffffc1cb5ede00: JOB, syncpt_id=12, syncpt_val=185, first_get=000004e8, timeout=10000, num_slots=19
[  107.119815]     GATHER at 5a708000+3bec, 12 words
[  107.119840] 20000001 0000640c 20000001 0000680d 20000001 00006c0e 20000001 00007c0f 20000001 00007411 200c0001 00000005
[  107.119846]     GATHER at 5a708000+3c1c, 2 words
[  107.119852] 20000001 00000010
[  107.119853]
[  107.119859]
[  107.119859] channel 5 - 150c0000.nvcsi
[  107.119859]
[  107.119860] NvHost basic channel registers:
[  107.119864] CMDFIFO_STAT_0:  00002040
[  107.119867] CMDFIFO_RDATA_0: 0000002c
[  107.119872] CMDP_OFFSET_0:   00000000
[  107.119875] CMDP_CLASS_0:    00000001
[  107.119877] CHANNELSTAT_0:   00000000
[  107.119880] The CDMA sync queue is empty.
[  107.119881]
[  107.119887]
[  107.119887] channel 0 - 15700000.vi
[  107.119887]
[  107.119888] NvHost basic channel registers:
[  107.119891] CMDFIFO_STAT_0:  00002040
[  107.119894] CMDFIFO_RDATA_0: 00000028
[  107.119899] CMDP_OFFSET_0:   00000000
[  107.119902] CMDP_CLASS_0:    00000001
[  107.119908] CHANNELSTAT_0:   00000000
[  107.119909] The CDMA sync queue is empty.
[  107.119910]
[  107.119913]
[  107.119913] channel 4 - 15700000.vi
[  107.119913]
[  107.119915] NvHost basic channel registers:
[  107.119917] CMDFIFO_STAT_0:  00002040
[  107.119921] CMDFIFO_RDATA_0: 0402039c
[  107.119925] CMDP_OFFSET_0:   00000000
[  107.119928] CMDP_CLASS_0:    00000000
[  107.119931] CHANNELSTAT_0:   00000000
[  107.119934] The CDMA sync queue is empty.
[  107.119935]
[  107.119939]
[  107.119939] ---- host general irq ----
[  107.119939]
[  107.119943] sync_intc0mask = 0x00000001
[  107.119946] sync_intmask = 0x50000003
[  107.119948]
[  107.119948] ---- host syncpt irq mask ----
[  107.119948]
[  107.119950]
[  107.119950] ---- host syncpt irq status ----
[  107.119950]
[  107.119955] syncpt_thresh_cpu0_int_status(0) = 0x00000000
[  107.119959] syncpt_thresh_cpu0_int_status(1) = 0x00000000
[  107.119962] syncpt_thresh_cpu0_int_status(2) = 0x00000000
[  107.119965] syncpt_thresh_cpu0_int_status(3) = 0x00000000
[  107.119969] syncpt_thresh_cpu0_int_status(4) = 0x00000000
[  107.119972] syncpt_thresh_cpu0_int_status(5) = 0x00000000
[  107.119975] syncpt_thresh_cpu0_int_status(6) = 0x00000000
[  107.119978] syncpt_thresh_cpu0_int_status(7) = 0x00000000
[  107.119981] syncpt_thresh_cpu0_int_status(8) = 0x00000000
[  107.119984] syncpt_thresh_cpu0_int_status(9) = 0x00000000
[  107.119988] syncpt_thresh_cpu0_int_status(10) = 0x00000000
[  107.119991] syncpt_thresh_cpu0_int_status(11) = 0x00000000
[  107.119994] syncpt_thresh_cpu0_int_status(12) = 0x00000000
[  107.119997] syncpt_thresh_cpu0_int_status(13) = 0x00000000
[  107.120001] syncpt_thresh_cpu0_int_status(14) = 0x00000000
[  107.120004] syncpt_thresh_cpu0_int_status(15) = 0x00000000
[  107.120007] syncpt_thresh_cpu0_int_status(16) = 0x00000000
[  107.120010] syncpt_thresh_cpu0_int_status(17) = 0x00000000
[  107.744817] name=[nvhost_sync:15], current value=1 waiting value=2
[  107.751067] ---- mlocks ----
[  107.754004] 8: locked by channel 6
[  107.757473]
[  107.759033] ---- syncpts ----
[  107.762017] id 9 (17000000.gp10b_507) min 6108 max 6108 refs 1 (previous client : )
[  107.769722] id 11 (17000000.gp10b_506) min 4 max 4 refs 1 (previous client : )
[  107.776982] id 12 (15600000.isp_nvcamera-daemon_0) min 183 max 185 refs 3 (previous client : 15600000.isp_nvcamera-daemon_0)
[  107.788213] id 13 (15600000.isp_nvcamera-daemon_1) min 182 max 183 refs 3 (previous client : 15600000.isp_nvcamera-daemon_1)
[  107.799452] id 14 (15600000.isp_nvcamera-daemon_2) min 1 max 2 refs 3 (previous client : 15600000.isp_nvcamera-daemon_2)
[  107.810341] id 15 (15600000.isp_nvcamera-daemon_3) min 1 max 2 refs 3 (previous client : 15600000.isp_nvcamera-daemon_3)
[  107.821221] id 16 (15600000.isp_nvcamera-daemon_4) min 32 max 34 refs 4 (previous client : 15600000.isp_nvcamera-daemon_4)
[  107.832282] id 17 (15600000.isp_nvcamera-daemon_5) min 1 max 2 refs 3 (previous client : 15600000.isp_nvcamera-daemon_5)
[  107.843185] id 18 (17000000.gp10b_505) min 2 max 2 refs 1 (previous client : 15600000.isp_kworker/3:2_0)
[  107.852686] id 22 (17000000.gp10b_501) min 4 max 4 refs 1 (previous client : 17000000.gp10b_501)
[  107.861469] id 24 (17000000.gp10b_492) min 26 max 26 refs 1 (previous client : 15700000.vi_0)
[  107.869990] id 25 (17000000.gp10b_493) min 6 max 6 refs 1 (previous client : 15700000.vi_0)
[  107.878344] id 28 (17000000.gp10b_490) min 12 max 12 refs 1 (previous client : 15700000.vi_1)
[  107.886864] id 29 (17000000.gp10b_489) min 12 max 12 refs 1 (previous client : 15700000.vi_2)
[  107.895383] id 30 (17000000.gp10b_488) min 45 max 45 refs 1 (previous client : 150c0000.nvcsi_0)
[  107.904172] id 32 (17000000.gp10b_491) min 8 max 8 refs 1 (previous client : 17000000.gp10b_499)
[  107.912953] id 34 (17000000.gp10b_498) min 6 max 6 refs 1 (previous client : 17000000.gp10b_497)
[  107.921735] id 36 (17000000.gp10b_496) min 2 max 2 refs 1 (previous client : 17000000.gp10b_495)
[  107.930516] id 37 (15340000.vic_nvcamera-daemon_0) min 8 max 8 refs 1 (previous client : 17000000.gp10b_494)
[  107.940337] id 39 (17000000.gp10b_494) min 8 max 8 refs 1 (previous client : 17000000.gp10b_492)
[  107.949117] id 40 (15700000.vi_0) min 7 max 7 refs 2 (previous client : 15340000.vic_nvcamera-daemon_0)
[  107.958515] id 44 (150c0000.nvcsi_0) min 40 max 40 refs 2 (previous client : 150c0000.nvcsi_0)
[  107.967640]
[  107.969125] ---- channels ----
[  107.972188]
[  107.972188] channel 1 - 15820000.se
[  107.972188]
[  107.978626] NvHost basic channel registers:
[  107.982813] CMDFIFO_STAT_0:  00002040
[  107.986466] CMDFIFO_RDATA_0: c0013856
[  107.990132] CMDP_OFFSET_0:   00000000
[  107.993796] CMDP_CLASS_0:    00000000
[  107.997460] CHANNELSTAT_0:   00000000
[  108.001125] The CDMA sync queue is empty.
[  108.005135]
[  108.006623]
[  108.006623] channel 2 - 15830000.se
[  108.006623]
[  108.013068] NvHost basic channel registers:
[  108.017255] CMDFIFO_STAT_0:  00002040
[  108.020920] CMDFIFO_RDATA_0: 12040c82
[  108.024586] CMDP_OFFSET_0:   00000000
[  108.028250] CMDP_CLASS_0:    00000000
[  108.031915] CHANNELSTAT_0:   00000000
[  108.035580] The CDMA sync queue is empty.
[  108.039590]
[  108.041077]
[  108.041077] channel 3 - 15840000.se
[  108.041077]
[  108.047516] NvHost basic channel registers:
[  108.051701] CMDFIFO_STAT_0:  00002040
[  108.055365] CMDFIFO_RDATA_0: 85214010
[  108.059033] CMDP_OFFSET_0:   00000000
[  108.062686] CMDP_CLASS_0:    00000000
[  108.066357] CHANNELSTAT_0:   00000000
[  108.070024] The CDMA sync queue is empty.
[  108.074035]
[  108.075532]
[  108.075532] channel 6 - 15600000.isp
[  108.075532]
[  108.082056] NvHost basic channel registers:
[  108.086242] CMDFIFO_STAT_0:  0000000e
[  108.089908] CMDFIFO_RDATA_0: 004e0041
[  108.093573] CMDP_OFFSET_0:   00000050
[  108.097238] CMDP_CLASS_0:    00000001
[  108.100903] CHANNELSTAT_0:   00000000
[  108.104569]
[  108.104569] ffffffc1cb5ede00: JOB, syncpt_id=12, syncpt_val=185, first_get=000004e8, timeout=10000, num_slots=19
[  108.116214]     GATHER at 5a708000+3bec, 12 words
[  108.120924] 20000001 0000640c 20000001 0000680d 20000001 00006c0e 20000001 00007c0f 20000001 00007411 200c0001 00000005
[  108.131931]     GATHER at 5a708000+3c1c, 2 words
[  108.136551] 20000001 00000010
[  108.139631]
[  108.141118]
[  108.141118] channel 5 - 150c0000.nvcsi
[  108.141118]
[  108.147818] NvHost basic channel registers:
[  108.152003] CMDFIFO_STAT_0:  00002040
[  108.155668] CMDFIFO_RDATA_0: 0000002c
[  108.159335] CMDP_OFFSET_0:   00000000
[  108.162999] CMDP_CLASS_0:    00000001
[  108.166653] CHANNELSTAT_0:   00000000
[  108.170325] The CDMA sync queue is empty.
[  108.174336]
[  108.175834]
[  108.175834] channel 0 - 15700000.vi
[  108.175834]
[  108.182271] NvHost basic channel registers:
[  108.186457] CMDFIFO_STAT_0:  00002040
[  108.190122] CMDFIFO_RDATA_0: 00000028
[  108.193788] CMDP_OFFSET_0:   00000000
[  108.197452] CMDP_CLASS_0:    00000001
[  108.201126] CHANNELSTAT_0:   00000000
[  108.204790] The CDMA sync queue is empty.
[  108.208800]
[  108.210286]
[  108.210286] channel 4 - 15700000.vi
[  108.210286]
[  108.216724] NvHost basic channel registers:
[  108.220915] CMDFIFO_STAT_0:  00002040
[  108.224580] CMDFIFO_RDATA_0: 0402039c
[  108.228246] CMDP_OFFSET_0:   00000000
[  108.231913] CMDP_CLASS_0:    00000000
[  108.235577] CHANNELSTAT_0:   00000000
[  108.239241] The CDMA sync queue is empty.
[  108.243249]
[  108.244736]
[  108.244736] ---- host general irq ----
[  108.244736]
[  108.251436] sync_intc0mask = 0x00000001
[  108.255274] sync_intmask = 0x50000003
[  108.258937]
[  108.258937] ---- host syncpt irq mask ----
[  108.258937]
[  108.265981]
[  108.265981] ---- host syncpt irq status ----
[  108.265981]
[  108.273208] syncpt_thresh_cpu0_int_status(0) = 0x00000000
[  108.278608] syncpt_thresh_cpu0_int_status(1) = 0x00000000
[  108.284007] syncpt_thresh_cpu0_int_status(2) = 0x00000000
[  108.289404] syncpt_thresh_cpu0_int_status(3) = 0x00000000
[  108.294803] syncpt_thresh_cpu0_int_status(4) = 0x00000000
[  108.300202] syncpt_thresh_cpu0_int_status(5) = 0x00000000
[  108.305602] syncpt_thresh_cpu0_int_status(6) = 0x00000000
[  108.311001] syncpt_thresh_cpu0_int_status(7) = 0x00000000
[  108.316399] syncpt_thresh_cpu0_int_status(8) = 0x00000000
[  108.321797] syncpt_thresh_cpu0_int_status(9) = 0x00000000
[  108.327202] syncpt_thresh_cpu0_int_status(10) = 0x00000000
[  108.332689] syncpt_thresh_cpu0_int_status(11) = 0x00000000
[  108.338177] syncpt_thresh_cpu0_int_status(12) = 0x00000000
[  108.343663] syncpt_thresh_cpu0_int_status(13) = 0x00000000
[  108.349146] syncpt_thresh_cpu0_int_status(14) = 0x00000000
[  108.354632] syncpt_thresh_cpu0_int_status(15) = 0x00000000
[  108.360117] syncpt_thresh_cpu0_int_status(16) = 0x00000000
[  108.365600] syncpt_thresh_cpu0_int_status(17) = 0x00000000
[  108.618819] fence timeout on [ffffffc1c55c6f00] after 1500ms
[  108.624567] name=[nvhost_sync:13], current value=182 waiting value=183
[  108.631280] ---- mlocks ----
[  108.634230] 8: locked by channel 6
[  108.637750]
[  108.639337] ---- syncpts ----
[  108.642368] id 9 (17000000.gp10b_507) min 6108 max 6108 refs 1 (previous client : )
[  108.650120] id 11 (17000000.gp10b_506) min 4 max 4 refs 1 (previous client : )
[  108.657435] id 12 (15600000.isp_nvcamera-daemon_0) min 183 max 185 refs 3 (previous client : 15600000.isp_nvcamera-daemon_0)
[  108.668719] id 13 (15600000.isp_nvcamera-daemon_1) min 182 max 183 refs 3 (previous client : 15600000.isp_nvcamera-daemon_1)
[  108.679974] id 14 (15600000.isp_nvcamera-daemon_2) min 1 max 2 refs 3 (previous client : 15600000.isp_nvcamera-daemon_2)
[  108.690876] id 15 (15600000.isp_nvcamera-daemon_3) min 1 max 2 refs 3 (previous client : 15600000.isp_nvcamera-daemon_3)
[  108.701786] id 16 (15600000.isp_nvcamera-daemon_4) min 32 max 34 refs 4 (previous client : 15600000.isp_nvcamera-daemon_4)
[  108.712862] id 17 (15600000.isp_nvcamera-daemon_5) min 1 max 2 refs 3 (previous client : 15600000.isp_nvcamera-daemon_5)
[  108.723780] id 18 (17000000.gp10b_505) min 2 max 2 refs 1 (previous client : 15600000.isp_kworker/3:2_0)
[  108.733308] id 22 (17000000.gp10b_501) min 4 max 4 refs 1 (previous client : 17000000.gp10b_501)
[  108.742130] id 24 (17000000.gp10b_492) min 26 max 26 refs 1 (previous client : 15700000.vi_0)
[  108.750684] id 25 (17000000.gp10b_493) min 6 max 6 refs 1 (previous client : 15700000.vi_0)
[  108.759057] id 28 (17000000.gp10b_490) min 12 max 12 refs 1 (previous client : 15700000.vi_1)
[  108.767601] id 29 (17000000.gp10b_489) min 12 max 12 refs 1 (previous client : 15700000.vi_2)
[  108.776145] id 30 (17000000.gp10b_488) min 45 max 45 refs 1 (previous client : 150c0000.nvcsi_0)
[  108.784943] id 32 (17000000.gp10b_491) min 8 max 8 refs 1 (previous client : 17000000.gp10b_499)
[  108.793751] id 34 (17000000.gp10b_498) min 6 max 6 refs 1 (previous client : 17000000.gp10b_497)
[  108.802552] id 36 (17000000.gp10b_496) min 2 max 2 refs 1 (previous client : 17000000.gp10b_495)
[  108.811333] id 37 (15340000.vic_nvcamera-daemon_0) min 8 max 8 refs 1 (previous client : 17000000.gp10b_494)
[  108.821166] id 39 (17000000.gp10b_494) min 8 max 8 refs 1 (previous client : 17000000.gp10b_492)
[  108.829947] id 40 (15700000.vi_0) min 7 max 7 refs 2 (previous client : 15340000.vic_nvcamera-daemon_0)
[  108.839336] id 44 (150c0000.nvcsi_0) min 40 max 40 refs 2 (previous client : 150c0000.nvcsi_0)
[  108.848455]
[  108.849940] ---- channels ----
[  108.853004]
[  108.853004] channel 1 - 15820000.se
[  108.853004]
[  108.859444] NvHost basic channel registers:
[  108.863632] CMDFIFO_STAT_0:  00002040
[  108.867298] CMDFIFO_RDATA_0: c0013856
[  108.870965] CMDP_OFFSET_0:   00000000
[  108.874618] CMDP_CLASS_0:    00000000
[  108.878285] CHANNELSTAT_0:   00000000
[  108.881951] The CDMA sync queue is empty.
[  108.885960]
[  108.887458]
[  108.887458] channel 2 - 15830000.se
[  108.887458]
[  108.893899] NvHost basic channel registers:
[  108.898085] CMDFIFO_STAT_0:  00002040
[  108.901750] CMDFIFO_RDATA_0: 12040c82
[  108.905416] CMDP_OFFSET_0:   00000000
[  108.909081] CMDP_CLASS_0:    00000000
[  108.912746] CHANNELSTAT_0:   00000000
[  108.916409] The CDMA sync queue is empty.
[  108.920420]
[  108.921908]
[  108.921908] channel 3 - 15840000.se
[  108.921908]
[  108.928346] NvHost basic channel registers:
[  108.932530] CMDFIFO_STAT_0:  00002040
[  108.936193] CMDFIFO_RDATA_0: 85214010
[  108.939860] CMDP_OFFSET_0:   00000000
[  108.943526] CMDP_CLASS_0:    00000000
[  108.947190] CHANNELSTAT_0:   00000000
[  108.950853] The CDMA sync queue is empty.
[  108.954864]
[  108.956352]
[  108.956352] channel 6 - 15600000.isp
[  108.956352]
[  108.962880] NvHost basic channel registers:
[  108.967066] CMDFIFO_STAT_0:  0000000e
[  108.970729] CMDFIFO_RDATA_0: 004e0041
[  108.974386] CMDP_OFFSET_0:   00000050
[  108.978051] CMDP_CLASS_0:    00000001
[  108.981715] CHANNELSTAT_0:   00000000
[  108.985381]
[  108.985381] ffffffc1cb5ede00: JOB, syncpt_id=12, syncpt_val=185, first_get=000004e8, timeout=10000, num_slots=19
[  108.997022]     GATHER at 5a708000+3bec, 12 words
[  109.001726] 20000001 0000640c 20000001 0000680d 20000001 00006c0e 20000001 00007c0f 20000001 00007411 200c0001 00000005
[  109.012731]     GATHER at 5a708000+3c1c, 2 words
[  109.017349] 20000001 00000010
[  109.020428]
[  109.021915]
[  109.021915] channel 5 - 150c0000.nvcsi
[  109.021915]
[  109.028616] NvHost basic channel registers:
[  109.032801] CMDFIFO_STAT_0:  00002040
[  109.036465] CMDFIFO_RDATA_0: 0000002c
[  109.040133] CMDP_OFFSET_0:   00000000
[  109.043799] CMDP_CLASS_0:    00000001
[  109.047463] CHANNELSTAT_0:   00000000
[  109.051127] The CDMA sync queue is empty.
[  109.055137]
[  109.056623]
[  109.056623] channel 0 - 15700000.vi
[  109.056623]
[  109.063065] NvHost basic channel registers:
[  109.067249] CMDFIFO_STAT_0:  00002040
[  109.070913] CMDFIFO_RDATA_0: 00000028
[  109.074569] CMDP_OFFSET_0:   00000000
[  109.078232] CMDP_CLASS_0:    00000001
[  109.081898] CHANNELSTAT_0:   00000000
[  109.085562] The CDMA sync queue is empty.
[  109.089571]
[  109.091066]
[  109.091066] channel 4 - 15700000.vi
[  109.091066]
[  109.097506] NvHost basic channel registers:
[  109.101692] CMDFIFO_STAT_0:  00002040
[  109.105355] CMDFIFO_RDATA_0: 0402039c
[  109.109021] CMDP_OFFSET_0:   00000000
[  109.112684] CMDP_CLASS_0:    00000000
[  109.116348] CHANNELSTAT_0:   00000000
[  109.120012] The CDMA sync queue is empty.
[  109.124023]
[  109.125508]
[  109.125508] ---- host general irq ----
[  109.125508]
[  109.132212] sync_intc0mask = 0x00000001
[  109.136049] sync_intmask = 0x50000003
[  109.139712]
[  109.139712] ---- host syncpt irq mask ----
[  109.139712]
[  109.146757]
[  109.146757] ---- host syncpt irq status ----
[  109.146757]
[  109.153978] syncpt_thresh_cpu0_int_status(0) = 0x00000000
[  109.159378] syncpt_thresh_cpu0_int_status(1) = 0x00000000
[  109.164777] syncpt_thresh_cpu0_int_status(2) = 0x00000000
[  109.170175] syncpt_thresh_cpu0_int_status(3) = 0x00000000
[  109.175573] syncpt_thresh_cpu0_int_status(4) = 0x00000000
[  109.180974] syncpt_thresh_cpu0_int_status(5) = 0x00000000
[  109.186372] syncpt_thresh_cpu0_int_status(6) = 0x00000000
[  109.191770] syncpt_thresh_cpu0_int_status(7) = 0x00000000
[  109.197170] syncpt_thresh_cpu0_int_status(8) = 0x00000000
[  109.202568] syncpt_thresh_cpu0_int_status(9) = 0x00000000
[  109.207968] syncpt_thresh_cpu0_int_status(10) = 0x00000000
[  109.213452] syncpt_thresh_cpu0_int_status(11) = 0x00000000
[  109.218938] syncpt_thresh_cpu0_int_status(12) = 0x00000000
[  109.224423] syncpt_thresh_cpu0_int_status(13) = 0x00000000
[  109.229908] syncpt_thresh_cpu0_int_status(14) = 0x00000000
[  109.235394] syncpt_thresh_cpu0_int_status(15) = 0x00000000
[  109.240879] syncpt_thresh_cpu0_int_status(16) = 0x00000000
[  109.246363] syncpt_thresh_cpu0_int_status(17) = 0x00000000
[  109.586853] tegra_channel_set_stream 547
[  109.590849] tegra_channel_set_stream 552
[  109.594951] ov5647 2-0036: ov5647_s_stream++
[  109.599894] tegra_csi_s_stream
[  109.603592] ov5647 2-0036: ov5647_power_off: power off
[  109.610974] ov5647 2-0036: camera_common_dpd_enable: csi 4
[  109.616533] Disabling clock was prohibited!
[  115.610816] host1x 13e10000.host1x: cdma_handle_timeout: timeout: 12 (15600000.isp_nvcamera-daemon_0) clientid 12, HW thresh 183, done 185
[  115.623395] host1x 13e10000.host1x: cdma_handle_timeout: timeout: 13 (15600000.isp_nvcamera-daemon_1) clientid 12, HW thresh 182, done 183
[  115.635907] host1x 13e10000.host1x: cdma_handle_timeout: timeout: 14 (15600000.isp_nvcamera-daemon_2) clientid 12, HW thresh 1, done 2
[  115.648081] host1x 13e10000.host1x: cdma_handle_timeout: timeout: 15 (15600000.isp_nvcamera-daemon_3) clientid 12, HW thresh 1, done 2
[  115.660260] host1x 13e10000.host1x: cdma_handle_timeout: timeout: 17 (15600000.isp_nvcamera-daemon_5) clientid 12, HW thresh 1, done 2
[  115.672408] host1x 13e10000.host1x: cdma_handle_timeout: timeout: 16 (15600000.isp_nvcamera-daemon_4) clientid 12, HW thresh 32, done 32
[  115.684706] ---- mlocks ----
[  115.687648] 8: locked by channel 6
[  115.691117]
[  115.692609] ---- syncpts ----
[  115.695633] id 9 (17000000.gp10b_507) min 6108 max 6108 refs 1 (previous client : )
[  115.703342] id 11 (17000000.gp10b_506) min 4 max 4 refs 1 (previous client : )
[  115.710622] id 12 (15600000.isp_nvcamera-daemon_0) min 183 max 185 refs 2 (previous client : 15600000.isp_nvcamera-daemon_0)
[  115.721868] id 13 (15600000.isp_nvcamera-daemon_1) min 182 max 183 refs 2 (previous client : 15600000.isp_nvcamera-daemon_1)
[  115.733110] id 14 (15600000.isp_nvcamera-daemon_2) min 1 max 2 refs 2 (previous client : 15600000.isp_nvcamera-daemon_2)
[  115.744009] id 15 (15600000.isp_nvcamera-daemon_3) min 1 max 2 refs 2 (previous client : 15600000.isp_nvcamera-daemon_3)
[  115.754903] id 16 (15600000.isp_nvcamera-daemon_4) min 32 max 34 refs 3 (previous client : 15600000.isp_nvcamera-daemon_4)
[  115.765979] id 17 (15600000.isp_nvcamera-daemon_5) min 1 max 2 refs 2 (previous client : 15600000.isp_nvcamera-daemon_5)
[  115.777470]
[  115.779004] ---- channels ----
[  115.782069]
[  115.782069] channel 1 - 15820000.se
[  115.782069]
[  115.788545] NvHost basic channel registers:
[  115.792763] CMDFIFO_STAT_0:  00002040
[  115.796448] CMDFIFO_RDATA_0: c0013856
[  115.800132] CMDP_OFFSET_0:   00000000
[  115.803818] CMDP_CLASS_0:    00000000
[  115.807497] CHANNELSTAT_0:   00000000
[  115.811183] The CDMA sync queue is empty.
[  115.815213]
[  115.816701]
[  115.816701] channel 2 - 15830000.se
[  115.816701]
[  115.823156] NvHost basic channel registers:
[  115.827354] CMDFIFO_STAT_0:  00002040
[  115.831020] CMDFIFO_RDATA_0: 12040c82
[  115.834674] CMDP_OFFSET_0:   00000000
[  115.838339] CMDP_CLASS_0:    00000000
[  115.842005] CHANNELSTAT_0:   00000000
[  115.845666] The CDMA sync queue is empty.
[  115.849676]
[  115.851173]
[  115.851173] channel 3 - 15840000.se
[  115.851173]
[  115.857611] NvHost basic channel registers:
[  115.861795] CMDFIFO_STAT_0:  00002040
[  115.865460] CMDFIFO_RDATA_0: 85214010
[  115.869128] CMDP_OFFSET_0:   00000000
[  115.872792] CMDP_CLASS_0:    00000000
[  115.876457] CHANNELSTAT_0:   00000000
[  115.880120] The CDMA sync queue is empty.
[  115.884130]
[  115.885616]
[  115.885616] channel 6 - 15600000.isp
[  115.885616]
[  115.892141] NvHost basic channel registers:
[  115.896324] CMDFIFO_STAT_0:  0000000e
[  115.899987] CMDFIFO_RDATA_0: 004e0041
[  115.903653] CMDP_OFFSET_0:   00000050
[  115.907317] CMDP_CLASS_0:    00000001
[  115.910980] CHANNELSTAT_0:   00000000
[  115.914635]
[  115.914635] ffffffc1cb5ede00: JOB, syncpt_id=12, syncpt_val=185, first_get=000004e8, timeout=10000, num_slots=19
[  115.926276]     GATHER at 5a708000+3bec, 12 words
[  115.930981] 20000001 0000640c 20000001 0000680d 20000001 00006c0e 20000001 00007c0f 20000001 00007411 200c0001 00000005
[  115.941980]     GATHER at 5a708000+3c1c, 2 words
[  115.946598] 20000001 00000010
[  115.949676]
[  115.951175]
[  115.951175] ---- host general irq ----
[  115.951175]
[  115.957874] sync_intc0mask = 0x00000001
[  115.961710] sync_intmask = 0x50000003
[  115.965375]
[  115.965375] ---- host syncpt irq mask ----
[  115.965375]
[  115.972421]
[  115.972421] ---- host syncpt irq status ----
[  115.972421]
[  115.979643] syncpt_thresh_cpu0_int_status(0) = 0x00000000
[  115.985040] syncpt_thresh_cpu0_int_status(1) = 0x00000000
[  115.990439] syncpt_thresh_cpu0_int_status(2) = 0x00000000
[  115.995838] syncpt_thresh_cpu0_int_status(3) = 0x00000000
[  116.001237] syncpt_thresh_cpu0_int_status(4) = 0x00000000
[  116.006636] syncpt_thresh_cpu0_int_status(5) = 0x00000000
[  116.012034] syncpt_thresh_cpu0_int_status(6) = 0x00000000
[  116.017431] syncpt_thresh_cpu0_int_status(7) = 0x00000000
[  116.022830] syncpt_thresh_cpu0_int_status(8) = 0x00000000
[  116.028228] syncpt_thresh_cpu0_int_status(9) = 0x00000000
[  116.033626] syncpt_thresh_cpu0_int_status(10) = 0x00000000
[  116.039111] syncpt_thresh_cpu0_int_status(11) = 0x00000000
[  116.044594] syncpt_thresh_cpu0_int_status(12) = 0x00000000
[  116.050079] syncpt_thresh_cpu0_int_status(13) = 0x00000000
[  116.055563] syncpt_thresh_cpu0_int_status(14) = 0x00000000

What still bothers me… Does ISP even has support for 8 bit mode?
pixel_t says something like

Specifies the readout pixel pattern of the sensor.
The following examples shows the values for Bayer sensors with the “bggr” pixel pattern:
• 10 bit: bayer_bggr
• 12 bit: bayer_bggr12
• 14 bit: bayer_bggr14

Maybe here a view on my device tree entry

i2c@3180000 {
		ov5647_e@36 {
			compatible = "nvidia,ov5647";
			/* I2C device address */
			reg = <0x36>;

			/* V4L2 device node location */
			devnode = "video0";

			/* Physical dimensions of sensor */
			physical_w = "3.674";
			physical_h = "2.738";

			//sensor_model ="ov5647";

			/* Define any required hw resources needed by driver */
			/* ie. clocks, io pins, power sources */
			avdd-reg = "vana";
			iovdd-reg = "vif";

			/* enable CID_SENSOR_MODE_ID for sensor modes selection */
			//use_sensor_mode_id = "true";
			
			mode0 { // OV5647_MODE_640x480
				mclk_khz = "24000";
				num_lanes = "2";
				tegra_sinterface = "serial_e";
				discontinuous_clk = "yes";
				dpcm_enable = "false";
				cil_settletime = "0";

				active_w = "640";
				active_h = "480";
				mode_type = "bayer";
				pixel_phase = "rggb";

				readout_orientation = "0";
				line_length = "1783";
				inherent_gain = "1";
				mclk_multiplier = "8";
				pix_clk_hz = "68000000";

				dynamic_pixel_bit_depth = "8";
				csi_pixel_bit_depth = "8";

				min_gain_val = "0";
				max_gain_val = "16";
				min_hdr_ratio = "1";
				max_hdr_ratio = "64";
				min_framerate = "1.816577";
				max_framerate = "54";
				min_exp_time = "34";
				max_exp_time = "550385";
				embedded_metadata_height = "0";
			};

			ports {
				#address-cells = <1>;
				#size-cells = <0>;

				port@0 {
					reg = <0>;
					e3326_ov5647_out0: endpoint {
						csi-port = <4>;
						bus-width = <2>;
						remote-endpoint = <&e3326_csi_in0>;
					};
				};
			};
		};

	};

@azeps
Yes, 8 bits is supporting.
Could you try below

discontinuous_clk = “yes”;
cil_settletime = “20”;

and
discontinuous_clk = “no”;
cil_settletime = “20”;

I have good news!

While 640 x 480 x 8 bit is still not working with the ISP I have a working configuration with 1920 x 1080 x 10 bit. I’ll accept that for now as this is alright for further development.
I’m now able to save a video file using this command:

gst-launch-1.0 -v nvcamerasrc sensor-id=0 fpsRange="30 30" num-buffers=100 ! 'video/x-raw(memory:NVMM), width=(int)1920, height=(int)1080, format=(string)I420, framerate=(fraction)30/1' ! omxh264enc ! qtmux ! filesink location=test.ts

The Bayer Pattern was interpreted correctly. The colors are a little bit washed out but Red is Red and Blue is Blue. :-)
I have to look into the imager configuration to look for improvement…

But I still need your help as this topic is not yet complete. While gstreamer is now working libargus does not. As before I use 10_camera_recording as an example.

Is there a better example to use?
I don’t need any display. Just streaming imager data to something like OpenCV.

I figures out 11_camera_object_identification would be perfect.
Sadly I don’t know how to disable the usage of the display as I want to run my program headless.

It says

(Argus) Error NotSupported: Failed to initialize EGLDisplay (in src/eglutils/EGLUtils.cpp, function getDefaultDisplay(), line 75)
(Argus) Error NotSupported: Failed to get default display (in src/api/OutputStreamImpl.cpp, function initialize(), line 80)
(Argus) Error NotSupported:  (propagating from src/api/CaptureSessionImpl.cpp, function createOutputStreamInternal(), line 565)

I’m confused here as the outputStream is needed for the frameConsumer.
10_camera_recording doesn’t work but it still doesn’t complain about something like EGLDisplay.

Also I’ll give you my output from 10_camera_recording again:

Set governor to performance before enabling profiler
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(0x1002d30)
getInstance: s_instance(0x1002d30)
subscribe: create SensorType(gyroscope) sensor(0x1004eb0)
subscribe: create SensorType(accelerometer) sensor(0x100a310)
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
NvPclHwGetModuleList: WARNING: Could not map module to ISP config string
NvPclHwGetModuleList: No module data found
NvPclHwPrintModuleDefinition -- Name: c5647_front_ov5647
NvPclHwPrintModuleDefinition -- Position: 0
NvPclHwPrintModuleDefinition -- CalibrationData Found: 1
NvPclHwPrintCameraSubModule -- HwCamSubModule[0].Name: v4l2_sensor
NvPclHwPrintCameraSubModule -- HwCamSubModule[0].DevName: ov5647 2-0036
NvPclHwPrintCameraSubModule -- HwCamSubModule[1].Name: v4l2_lens
NvPclHwPrintCameraSubModule -- HwCamSubModule[1].DevName: 
NvPclHwGetModuleList: OFParserListModules Succeeded
NvPclModuleListInitialize: NvPclModule list[0]: c5647_front_ov5647 position0
NvPclHwScanExternalCameras -- adding video0 to discover list
NvPclHwScanExternalCameras -- adding video0 to discover list
initialize: /dev/video0
NvPclHwScanExternalCameras -- adding video0 to discover list
initialize: /dev/video0
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
PCLHW_DTParser
setHotplugCallback: Registered new callback client
NvPclSetHotplugCallback: ----------------------
NvPclOpen: ++++++++++++++++++++++
NvPclStateControllerOpen: Found GUID 0 match at index[0]
NvPclHwInitializeModule: allocate overrides pathname @ 0x010343b0
NvPclHwInitializeModule: allocate overrides pathname @ 0x01034440
NvPclHwInitializeModule: allocate overrides pathname @ 0x010344d0
NvPclHwInitializeModule: allocate overrides pathname @ 0x01034560
NvPclHwInitializeModule: allocate overrides pathname @ 0x010345f0
NvPclHwInitializeModule: allocate overrides pathname @ 0x01034680
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/c5647_front_ov5647.isp] 6/16CheckOverridesPermissions: cannot stat file [/data/nvcam/settings/c5647_front_ov5647.isp]
LoadOverridesFile: looking for override file [/opt/nvidia/nvcam/settings/c5647_front_ov5647.isp] 7/16CheckOverridesPermissions: cannot stat file [/opt/nvidia/nvcam/settings/c5647_front_ov5647.isp]
LoadOverridesFile: looking for override file [/var/nvidia/nvcam/settings/c5647_front_ov5647.isp] 8/16CheckOverridesPermissions: cannot stat file [/var/nvidia/nvcam/settings/c5647_front_ov5647.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/c5647_front_ov5647.bin] 2/16
Imager: looking for override file [/opt/nvidia/nvcam/settings/c5647_front_ov5647.bin] 3/16
Imager: looking for override file [/var/nvidia/nvcam/settings/c5647_front_ov5647.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: ov5647 2-0036
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 OTP Data not found
Control Frame Rate not found
Control Exposure not found
findCustomCids: calculated MaxCoarseDiff 6
OFDPropertyGetString: could not read property [type]
loadSubType: Sensor type missing in DT, 180
OFDPropertyCopyToLong: could not read property [mode0.embedded_metadata_height]
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 [mode1.x_start]
OFDPropertyGetString: could not read property [mode1.y_start]
OFDPropertyGetString: could not read property [mode1.x_end]
OFDPropertyGetString: could not read property [mode1.y_end]
OFDPropertyGetString: could not read property [mode1.h_scaling]
OFDPropertyGetString: could not read property [mode1.v_scaling]
OFDPropertyCopyToLong: could not read property [mode2.csi_pixel_bit_depth]
OFDPropertyCopyToLong: could not read property [mode2.dynamic_pixel_bit_depth]
OFDPropertyCopyToLong: could not read property [mode2.embedded_metadata_height]
OFDPropertyGetString: could not read property [mode2.x_start]
OFDPropertyGetString: could not read property [mode2.y_start]
OFDPropertyGetString: could not read property [mode2.x_end]
OFDPropertyGetString: could not read property [mode2.y_end]
OFDPropertyGetString: could not read property [mode2.h_scaling]
OFDPropertyGetString: could not read property [mode2.v_scaling]
OFDPropertyCopyToLong: could not read property [mode3.csi_pixel_bit_depth]
OFDPropertyCopyToLong: could not read property [mode3.dynamic_pixel_bit_depth]
OFDPropertyGetString: could not read property [mode3.mode_type]
mode 3: Failed to load mode type
OFDPropertyGetString: could not read property [mode3.pixel_phase]
mode 3: Failed to load pixel phase
OFDPropertyCopyToLong: could not read property [mode3.embedded_metadata_height]
OFDPropertyGetString: could not read property [mode3.dpcm_enable]
OFDPropertyGetString: could not read property [mode3.x_start]
OFDPropertyGetString: could not read property [mode3.y_start]
OFDPropertyGetString: could not read property [mode3.x_end]
OFDPropertyGetString: could not read property [mode3.y_end]
OFDPropertyGetString: could not read property [mode3.h_scaling]
OFDPropertyGetString: could not read property [mode3.v_scaling]
OFDPropertyGetString: could not read property [sensor_model]
initialize: Loaded Driver: 4 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!
(Argus) Objects still active during exit: [CameraProvider (0x102d370): refs: 1, cref: 1]
Create the CameraProvider object and get the core interface.
1 Like