Porting new camera sensor driver

Autonomous Machines Jetson & Embedded Systems Jetson Orin NX
1

Hello,

I am attempting to get the Sony EV9500M camera working over the Orin NX module + Orin Nano carrier. The driver code and dtsi are based on one existing driver of this camera for Xavier NX board. I modified them using imx219 driver and dtsi files as a reference.

The camera is connected to CAM1 (J21) connector using 4 MIPI lanes and supplied externally. It doesn’t have I2C.

The OS was built from SDK Manager using JetPack 5.1.2 and L4T 35.4.1

cat /etc/nv_tegra_release
# R35 (release), REVISION: 4.1, GCID: 33958178, BOARD: t186ref, EABI: aarch64, DATE: Tue Aug  1 19:57:35 UTC 2023

uname -a
Linux orinnx-desktop 5.10.120-tegra #10 SMP PREEMPT Thu Nov 23 13:57:00 CET 2023 aarch64 aarch64 aarch64 GNU/Linux

The device node is created and NVCSI bound.

media-ctl -p -d /dev/media0
Media controller API version 5.10.120

Media device information
------------------------
driver      	tegra-camrtc-ca
model       	NVIDIA Tegra Video Input Device
serial     	 
bus info   	 
hw revision 	0x3
driver version  5.10.120

Device topology
- entity 1: 13e40000.host1x:nvcsi@15a00000- (2 pads, 2 links)
        	type V4L2 subdev subtype Unknown flags 0
        	device node name /dev/v4l-subdev0
    pad0: Sink
   	 <- "ev9500m 2-0010":0 [ENABLED]
    pad1: Source
   	 -> "vi-output, ev9500m 2-0010":0 [ENABLED]

- entity 4: ev9500m 2-0010 (1 pad, 1 link)
        	type V4L2 subdev subtype Sensor flags 0
        	device node name /dev/v4l-subdev1
    pad0: Source
   	 [fmt:UYVY8_1X16/1920x1080 field:none colorspace:srgb]
   	 -> "13e40000.host1x:nvcsi@15a00000-":0 [ENABLED]

- entity 6: vi-output, ev9500m 2-0010 (1 pad, 1 link)
        	type Node subtype V4L flags 0
        	device node name /dev/video0
    pad0: Sink
   	 <- "13e40000.host1x:nvcsi@15a00000-":1 [ENABLED]

v4l2-ctl -d /dev/video0 --list-formats-ext
ioctl: VIDIOC_ENUM_FMT
    Type: Video Capture

    [0]: 'UYVY' (UYVY 4:2:2)
   	 Size: Discrete 1920x1080
   		 Interval: Discrete 0.017s (60.000 fps)
    [1]: 'NV16' (Y/CbCr 4:2:2)
   	 Size: Discrete 1920x1080
   		 Interval: Discrete 0.017s (60.000 fps)
    [2]: 'UYVY' (UYVY 4:2:2)
   	 Size: Discrete 1920x1080
   		 Interval: Discrete 0.017s (60.000 fps)

The v4l2-compliance returns some failures that I don’t know how to solve.

v4l2-compliance -v -d /dev/media0
v4l2-compliance SHA: not available, 64 bits

Compliance test for tegra-camrtc-ca device /dev/media0:

Media Driver Info:
    Driver name  	: tegra-camrtc-ca
    Model        	: NVIDIA Tegra Video Input Device
    Serial       	:
    Bus info     	:
    Media version	: 5.10.120
    Hardware revision: 0x00000003 (3)
    Driver version   : 5.10.120

Required ioctls:
   	 warn: v4l2-test-media.cpp(51): empty bus_info
    test MEDIA_IOC_DEVICE_INFO: OK

Allow for multiple opens:
    test second /dev/media0 open: OK
   	 warn: v4l2-test-media.cpp(51): empty bus_info
    test MEDIA_IOC_DEVICE_INFO: OK
    test for unlimited opens: OK

Media Controller ioctls:
   	 Entity: 0x00000001 (Name: '13e40000.host1x:nvcsi@15a00000-', Function: Unknown sub-device (0002000a))
   	 fail: v4l2-test-media.cpp(110): (function & MEDIA_ENT_TYPE_MASK) == MEDIA_ENT_F_OLD_SUBDEV_BASE && function > MEDIA_ENT_F_TUNER
   	 fail: v4l2-test-media.cpp(202): checkFunction(ent.function, true)
    test MEDIA_IOC_G_TOPOLOGY: FAIL
   	 Entity: 0x00000001 (Name: '13e40000.host1x:nvcsi@15a00000-', Type: Unknown V4L2 Sub-Device, DevPath: /dev/v4l-subdev0)
   	 Entity: 0x00000004 (Name: 'ev9500m 2-0010', Type: Camera Sensor, DevPath: /dev/v4l-subdev1)
   	 Entity: 0x00000006 (Name: 'vi-output, ev9500m 2-0010', Type: V4L2 I/O, DevPath: /dev/video0)
   	 fail: v4l2-test-media.cpp(389): num_data_links != num_links
    test MEDIA_IOC_ENUM_ENTITIES/LINKS: FAIL
    test MEDIA_IOC_SETUP_LINK: OK

Total for tegra-camrtc-ca device /dev/media0: 7, Succeeded: 5, Failed: 2, Warnings: 2

For testing purposes, I boost clocks and enable trace logs:

sudo nvpmodel -m 0
sudo jetson_clocks
sudo su
echo 1 > /sys/kernel/debug/bpmp/debug/clk/vi/mrq_rate_locked
echo 1 > /sys/kernel/debug/bpmp/debug/clk/isp/mrq_rate_locked
echo 1 > /sys/kernel/debug/bpmp/debug/clk/nvcsi/mrq_rate_locked
echo 1 > /sys/kernel/debug/bpmp/debug/clk/emc/mrq_rate_locked
cat /sys/kernel/debug/bpmp/debug/clk/vi/max_rate |tee /sys/kernel/debug/bpmp/debug/clk/vi/rate
832000000
cat /sys/kernel/debug/bpmp/debug/clk/isp/max_rate | tee  /sys/kernel/debug/bpmp/debug/clk/isp/rate
1011200000
cat /sys/kernel/debug/bpmp/debug/clk/nvcsi/max_rate | tee /sys/kernel/debug/bpmp/debug/clk/nvcsi/rate
642900000
cat /sys/kernel/debug/bpmp/debug/clk/emc/max_rate | tee /sys/kernel/debug/bpmp/debug/clk/emc/rate
3199000000

echo 1 > /sys/kernel/debug/tracing/tracing_on
echo 30720 > /sys/kernel/debug/tracing/buffer_size_kb
echo 1 > /sys/kernel/debug/tracing/events/tegra_rtcpu/enable
echo 1 > /sys/kernel/debug/tracing/events/freertos/enable
echo 3 > /sys/kernel/debug/camrtc/log-level
echo 1 > /sys/kernel/debug/tracing/events/camera_common/enable
echo > /sys/kernel/debug/tracing/trace

But when I trigger my capture command I see the following in dmesg :

[  496.314693] tegra-camrtc-capture-vi tegra-capture-vi: uncorr_err: request timed out after 2500 ms
[  496.327460] tegra-camrtc-capture-vi tegra-capture-vi: err_rec: attempting to reset the capture channel
[  496.337641] (NULL device *): vi_capture_control_message: NULL VI channel received
[  496.345357] t194-nvcsi 13e40000.host1x:nvcsi@15a00000: csi5_stream_close: Error in closing stream_id=2, csi_port=2
[  496.356012] (NULL device *): vi_capture_control_message: NULL VI channel received
[  496.363732] t194-nvcsi 13e40000.host1x:nvcsi@15a00000: csi5_stream_open: VI channel not found for stream- 2 vc- 0
[  496.374623] tegra-camrtc-capture-vi tegra-capture-vi: err_rec: successfully reset the capture channel

And this is in the trace:

tracer: nop
#
# entries-in-buffer/entries-written: 59/59   #P:8
#
#                            	_-----=> irqs-off
#                           	/ _----=> need-resched
#                          	| / _---=> hardirq/softirq
#                          	|| / _--=> preempt-depth
#                          	||| / 	delay
#       	TASK-PID 	CPU#  ||||   TIMESTAMP  FUNCTION
#          	| |     	|   ||||  	|     	|
 	kworker/1:4-404 	[001] ....   106.431484: rtcpu_string: tstamp:3931035642 id:0x04010000 str:"VM0 deactivating."
 gst-plugin-scan-3462	[004] ....   413.551859: tegra_channel_open: vi-output, ev9500m 2-0010
 gst-plugin-scan-3462	[004] ....   413.551879: tegra_channel_close: vi-output, ev9500m 2-0010
    	v4l2-ctl-3499	[006] ....   438.469087: tegra_channel_open: vi-output, ev9500m 2-0010
    	v4l2-ctl-3499	[006] ....   438.469398: tegra_channel_close: vi-output, ev9500m 2-0010
 gst-plugin-scan-3512	[001] ....   493.460248: tegra_channel_open: vi-output, ev9500m 2-0010
 gst-plugin-scan-3512	[001] ....   493.460266: tegra_channel_close: vi-output, ev9500m 2-0010
  gst-launch-1.0-3511	[002] ....   493.524824: tegra_channel_open: vi-output, ev9500m 2-0010
  gst-launch-1.0-3511	[002] ....   493.524843: tegra_channel_close: vi-output, ev9500m 2-0010
  gst-launch-1.0-3511	[002] ....   493.570891: tegra_channel_open: vi-output, ev9500m 2-0010
	v4l2src0:src-3515	[000] ....   493.577559: tegra_channel_set_power: ev9500m 2-0010 : 0x1
	v4l2src0:src-3515	[000] ....   493.577570: camera_common_s_power: status : 0x1
	v4l2src0:src-3515	[000] ....   493.582423: tegra_channel_set_power: 13e40000.host1x:nvcsi@15a00000- : 0x1
	v4l2src0:src-3515	[000] ....   493.582427: csi_s_power: enable : 0x1
	v4l2src0:src-3515	[000] ....   493.583501: tegra_channel_capture_setup: vnc_id 0 W 1920 H 1080 fmt 13
	v4l2src0:src-3515	[000] ....   493.591136: tegra_channel_set_stream: enable : 0x1
	v4l2src0:src-3515	[000] ....   493.592625: tegra_channel_set_stream: 13e40000.host1x:nvcsi@15a00000- : 0x1
	v4l2src0:src-3515	[000] ....   493.592628: csi_s_stream: enable : 0x1
	v4l2src0:src-3515	[000] ....   493.592954: tegra_channel_set_stream: ev9500m 2-0010 : 0x1
 	kworker/1:4-404 	[001] ....   493.610502: rtcpu_string: tstamp:16030604309 id:0x04010000 str:"VM0 activating."
 	kworker/1:4-404 	[001] ....   493.610506: rtcpu_vinotify_event: tstamp:16031097037 cch:0 vi:1 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:512984809536 data:0x759e300010000000
 	kworker/1:4-404 	[001] ....   493.610507: rtcpu_vinotify_event: tstamp:16031097211 cch:0 vi:1 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:512984816032 data:0x0000000031000001
 	kworker/1:4-404 	[001] ....   493.610507: rtcpu_vinotify_event: tstamp:16031097408 cch:0 vi:1 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:512984861760 data:0x759e2d0010000000
 	kworker/1:4-404 	[001] ....   493.610507: rtcpu_vinotify_event: tstamp:16031097577 cch:0 vi:1 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:512984868352 data:0x0000000031000002
 vi-output, ev95-3518	[003] ....   496.374480: tegra_channel_capture_setup: vnc_id 0 W 1920 H 1080 fmt 13

I can’t see any frame, just a green picture. I probed the MIPI lanes and seems to be correct.

Any idea of what the problem might be or which way to go?

You can find attached the driver code, dtsi, system dts, dmesg logs and trace logs:

files.tar.gz (80.8 KB)

Thank you!

3

The trace log tell didn’t receive any validate data from the MIPI bus.

4

Thanks for your answer.

Could be due to a bad dts configuration?

5

If port-index/bus-width incorrect that could be the dts reason.

6

Thanks again.

In my opinion they are configured correctly, but probably I am wrong. Could you please check if them are correct?

tegra-capture-vi, host1x/nvcsi and module:

  • port-index = <2>; /* Use CSI-C */
  • bus-width = <4>;
  • tegra_sinterface = “serial_c”;

The camera is attached to J21 connector (CAM1) with a 4-line configuration.

Below you can find the complete camera dtsi:

/*
 * Copyright (c) 2022,Sony Electronics, Inc.  All rights reserved.
 *
 * This program is free software; you can redistribute it and/or modify
 * it under the terms of the GNU General Public License as published by
 * the Free Software Foundation; either version 2 of the License, or
 * (at your option) any later version.
 *
 * This program is distributed in the hope that it will be useful, but WITHOUT
 * ANY WARRANTY; without even the implied warranty of MERCHANTABILITY or
 * FITNESS FOR A PARTICULAR PURPOSE.  See the GNU General Public License for
 * more details.
 *
 * You should have received a copy of the GNU General Public License
 * along with this program.  If not, see <http://www.gnu.org/licenses/>.
 */
#include <dt-bindings/media/camera.h>
#include "dt-bindings/clock/tegra194-clock.h"

#define CAM0_RST_L	TEGRA234_MAIN_GPIO(H, 3)
#define CAMERA_I2C_MUX_BUS(x) (0x1E + x)

/ {
	tegra-capture-vi  {
		num-channels = <1>;
		ports {				
		status = "okay";
			#address-cells = <1>;
			#size-cells = <0>;
			vi_port0: port@0 {
				status = "okay";
				reg = <0>;
				ev9500m_vi_in0: endpoint {
					status = "okay";
					port-index = <2>; /* Use CSI-C */
					bus-width = <4>; 
					remote-endpoint = <&ev9500m_csi_out0>;
				};
			};
		};
	};

		
	host1x@13e00000 {
		nvcsi@15a00000 {
			status = "okay";
			//compatible = "nvidia,tegra194-nvcsi";
			num-channels = <1>;
			num-ports = <2>;
			#address-cells = <1>;
			#size-cells = <0>;
			csi_chan0: channel@0 {
				status = "okay";
				reg = <0>;
				ports {
					status = "okay";
					#address-cells = <1>;
					#size-cells = <0>;
					csi_chan0_port0: port@0 {
						status = "okay";
						reg = <0>;
						ev9500m_csi_in0: endpoint@0 {
							status = "okay";
							port-index = <2>;
							bus-width = <4>;
							remote-endpoint = <&ev9500m_out0>;
						};
					};
					csi_chan0_port1: port@1 {
						status = "okay";
						reg = <1>;
						ev9500m_csi_out0: endpoint@1 {
							status = "okay";
							remote-endpoint = <&ev9500m_vi_in0>;
						};
					};
				};
			};
		};
	};


	gpio@2200000 {
		status = "okay";
		camera-control-output-low {
			status = "okay";
			gpio-hog;
			output-low;
			gpios = <CAM0_RST_L 0>;
			label = "cam0-rst";
		};
	};

	i2c@3180000 {
		status = "okay";
		#address-cells = <1>;
		#size-cells = <0>;

		ev9500m_cam0: ev9500m@10 {
			status = "okay";
			compatible = "ev9500m";
			/* I2C device address */
			reg = <0x10>;
			/* V4L2 device node location */
			devnode = "video0";
			/* Physical dimensions of sensor */
			physical_w = "3.674";
			physical_h = "2.738";
			sensor_model = "ev9500m";

			/* Define any required hw resources needed by driver */
			/* ie. clocks, io pins, power sources */
			/* mclk-index indicates the index of the */
			/* mclk-name with in the clock-names array */
			avdd-reg = "vana";
			iovdd-reg = "vif";
			dvdd-reg = "vdig";

			//vana-supply = <&p3509_avdd_cam_2v8>;
			//vif-supply = <&p3509_vdd_1v8_cvb>;
			//vana-supply = <&p3509_vdd_3v3_cvb>;
			//vdig-supply = <&p3509_vdd_sys_en>;
			//clocks = <&bpmp_clks TEGRA194_CLK_EXTPERIPH1>,
			//	<&bpmp_clks TEGRA194_CLK_EXTPERIPH1>;
			//clock-names = "extperiph1", "pllp_grtba";
			//mclk = "extperiph1";
			reset-gpios = <&tegra_main_gpio CAM0_RST_L GPIO_ACTIVE_LOW>;
			camera_mipi_lanes = <0x4>;
		
		mode0{ //1920x1080_60Fps
				mclk_khz = "24000";
				set_mode_delay_ms = "5000";
				num_lanes = "4";
				tegra_sinterface = "serial_c"; //should be set to the CSI port where the sensor is connected
				vc_id = "0";
				phy_mode = "DPHY";
				discontinuous_clk = "yes";
				dpcm_enable = "false";
				cil_settletime = "0";
				active_w = "1920";
				active_h = "1080";
				lane_polarity = "0";
				//mode_type = "rgb";
				//pixel_phase = "rgb888";
				//csi_pixel_bit_depth = "24";
				mode_type = "yuv";
				pixel_phase = "uyvy";
				csi_pixel_bit_depth = "16";
				readout_orientation = "0";
				line_length = "2000";//"1920";
				inherent_gain = "1";
				mclk_multiplier = "18";//"24";//"6.67";
				pix_clk_hz = "576000000";//"160000000";

				gain_factor = "16";
				framerate_factor = "1000000";
				exposure_factor = "1000000";
				min_gain_val = "16"; /* 1.00x */
				max_gain_val = "170"; /* 10.66x */
				step_gain_val = "1";
				default_gain = "16"; /* 1.00x */
				min_hdr_ratio = "1";
				max_hdr_ratio = "1";
				min_framerate = "2000000"; /* 2.0 fps */
				max_framerate = "60000000"; /* 60.0 fps */
				step_framerate = "1";
				default_framerate = "60000000"; /* 60.0 fps */
				min_exp_time = "13"; /* us */
				max_exp_time = "683709"; /* us */
				step_exp_time = "1";
				default_exp_time = "16667"; /* us  */
				//embedded_metadata_height = "0";
		};

			ports {
				status = "okay";
				#address-cells = <1>;
				#size-cells = <0>;
				port@0 {
					status = "okay";
					reg = <0>;
					ev9500m_out0: endpoint {
						status = "okay";
						port-index = <2>;
						clock-lanes = <2>; /* CLOCK C */
						bus-width = <4>;
						remote-endpoint = <&ev9500m_csi_in0>;
					};
				};
			};
		};			
	};
};

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

		/**
		 * The general guideline for naming badge_info contains 3 parts, and is as follows,
		 * The first part is the camera_board_id for the module; if the module is in a FFD
		 * platform, then use the platform name for this part.
		 * The second part contains the position of the module, ex. "rear" or "front".
		 * The third part contains the last 6 characters of a part number which is found
		 * in the module's specsheet from the vendor.
		 */
		modules {
			status = "okay";
			cam_module0: module0 {
				badge = "ev9500m_front";
				position = "front";
				status = "okay";
				orientation = "1";
				cam_module0_drivernode0: drivernode0 {
					status = "okay";
					/* Declare PCL support driver (classically known as guid)  */
					pcl_id = "v4l2_sensor";
					/* Driver v4l2 device name */
					devname = "ev9500m 2-0010";
					/* Declare the device-tree hierarchy to driver instance */
					proc-device-tree = "/proc/device-tree/i2c@3180000/ev9500m@10";
				};
			};
		};
	};
};

The rest of files (driver code, camera dtsi, system dts, dmesg and trace logs) are attached here:
files.tar.gz (80.8 KB)

Thanks for your support!

7

J21 should be CSI2/CSI3 that tell the port-index and tegra_sinterface is correct.

8

Sorry, but I’m not sure if I’m understanding you correctly. Are you indicating that the configuration is correct?

In any case, I realized that the board used to adapt the Sony camera connector with the carrier’s had the 4-CSI pair lines swapped (negative and positive of each differential pair swapped). I updated the device tree with lane_polarity=“15”.

After boosting clocks and enabling trace logs, when I trigger my capture command I continue seeing the same in dmesg log, but the trace log is different:

# tracer: nop
#
# entries-in-buffer/entries-written: 448194/448194   #P:8
#
#                                _-----=> irqs-off
#                               / _----=> need-resched
#                              | / _---=> hardirq/softirq
#                              || / _--=> preempt-depth
#                              ||| /     delay
#           TASK-PID     CPU#  ||||   TIMESTAMP  FUNCTION
#              | |         |   ||||      |         |
     kworker/4:2-136     [004] ....   170.482431: rtcpu_string: tstamp:5931562766 id:0x04010000 str:"VM0 deactivating."
 gst-plugin-scan-3383    [006] ....   215.382319: tegra_channel_open: vi-output, ev9500m 2-0010
 gst-plugin-scan-3383    [006] ....   215.382335: tegra_channel_close: vi-output, ev9500m 2-0010
  gst-launch-1.0-3382    [007] ....   215.443350: tegra_channel_open: vi-output, ev9500m 2-0010
  gst-launch-1.0-3382    [007] ....   215.443366: tegra_channel_close: vi-output, ev9500m 2-0010
  gst-launch-1.0-3382    [007] ....   215.450173: tegra_channel_open: vi-output, ev9500m 2-0010
    v4l2src0:src-3385    [003] ....   215.455855: tegra_channel_set_power: ev9500m 2-0010 : 0x1
    v4l2src0:src-3385    [003] ....   215.455864: camera_common_s_power: status : 0x1
    v4l2src0:src-3385    [003] ....   215.460704: tegra_channel_set_power: 13e40000.host1x:nvcsi@15a00000- : 0x1
    v4l2src0:src-3385    [003] ....   215.460707: csi_s_power: enable : 0x1
    v4l2src0:src-3385    [003] ....   215.461275: tegra_channel_capture_setup: vnc_id 0 W 1920 H 1080 fmt 13
    v4l2src0:src-3385    [001] ....   215.467036: tegra_channel_set_stream: enable : 0x1
    v4l2src0:src-3385    [000] ....   215.469127: tegra_channel_set_stream: 13e40000.host1x:nvcsi@15a00000- : 0x1
    v4l2src0:src-3385    [000] ....   215.469129: csi_s_stream: enable : 0x1
    v4l2src0:src-3385    [000] ....   215.469449: tegra_channel_set_stream: ev9500m 2-0010 : 0x1
     kworker/4:2-136     [004] ....   215.513018: rtcpu_string: tstamp:7338947154 id:0x04010000 str:"VM0 activating."
     kworker/4:2-136     [004] ....   215.513023: rtcpu_nvcsi_intr: tstamp:7339137570 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513023: rtcpu_nvcsi_intr: tstamp:7339138034 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513024: rtcpu_nvcsi_intr: tstamp:7339138959 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513024: rtcpu_nvcsi_intr: tstamp:7339140348 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513024: rtcpu_nvcsi_intr: tstamp:7339141272 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513024: rtcpu_nvcsi_intr: tstamp:7339144051 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513025: rtcpu_nvcsi_intr: tstamp:7339146828 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513025: rtcpu_nvcsi_intr: tstamp:7339147291 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513025: rtcpu_nvcsi_intr: tstamp:7339148217 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513025: rtcpu_nvcsi_intr: tstamp:7339148680 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513026: rtcpu_nvcsi_intr: tstamp:7339149606 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513026: rtcpu_nvcsi_intr: tstamp:7339153309 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513026: rtcpu_nvcsi_intr: tstamp:7339154235 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513026: rtcpu_nvcsi_intr: tstamp:7339157476 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513027: rtcpu_nvcsi_intr: tstamp:7339157941 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513027: rtcpu_nvcsi_intr: tstamp:7339159791 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513027: rtcpu_nvcsi_intr: tstamp:7339160253 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513027: rtcpu_nvcsi_intr: tstamp:7339162106 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513028: rtcpu_nvcsi_intr: tstamp:7339163958 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513028: rtcpu_nvcsi_intr: tstamp:7339164419 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513028: rtcpu_nvcsi_intr: tstamp:7339170438 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513028: rtcpu_nvcsi_intr: tstamp:7339172291 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513029: rtcpu_nvcsi_intr: tstamp:7339173680 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513029: rtcpu_nvcsi_intr: tstamp:7339175070 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513029: rtcpu_nvcsi_intr: tstamp:7339176456 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513029: rtcpu_nvcsi_intr: tstamp:7339179234 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513029: rtcpu_nvcsi_intr: tstamp:7339180625 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513030: rtcpu_nvcsi_intr: tstamp:7339181551 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513030: rtcpu_nvcsi_intr: tstamp:7339182013 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513030: rtcpu_nvcsi_intr: tstamp:7339182938 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513030: rtcpu_nvcsi_intr: tstamp:7339184327 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513030: rtcpu_nvcsi_intr: tstamp:7339185716 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513030: rtcpu_nvcsi_intr: tstamp:7339189419 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513031: rtcpu_nvcsi_intr: tstamp:7339189882 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513031: rtcpu_nvcsi_intr: tstamp:7339192661 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513031: rtcpu_nvcsi_intr: tstamp:7339194048 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513031: rtcpu_nvcsi_intr: tstamp:7339194511 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513031: rtcpu_nvcsi_intr: tstamp:7339195438 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513031: rtcpu_nvcsi_intr: tstamp:7339196363 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513031: rtcpu_nvcsi_intr: tstamp:7339197753 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513032: rtcpu_nvcsi_intr: tstamp:7339198216 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513032: rtcpu_nvcsi_intr: tstamp:7339198679 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513032: rtcpu_nvcsi_intr: tstamp:7339199143 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513032: rtcpu_nvcsi_intr: tstamp:7339200530 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513032: rtcpu_nvcsi_intr: tstamp:7339203308 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513032: rtcpu_nvcsi_intr: tstamp:7339204698 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513032: rtcpu_nvcsi_intr: tstamp:7339205161 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513033: rtcpu_nvcsi_intr: tstamp:7339206085 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513033: rtcpu_nvcsi_intr: tstamp:7339209790 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513033: rtcpu_nvcsi_intr: tstamp:7339210716 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513033: rtcpu_nvcsi_intr: tstamp:7339211639 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513033: rtcpu_nvcsi_intr: tstamp:7339212566 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513033: rtcpu_nvcsi_intr: tstamp:7339214419 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513033: rtcpu_nvcsi_intr: tstamp:7339215808 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513034: rtcpu_nvcsi_intr: tstamp:7339216735 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513034: rtcpu_nvcsi_intr: tstamp:7339218123 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513034: rtcpu_nvcsi_intr: tstamp:7339218582 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513034: rtcpu_nvcsi_intr: tstamp:7339222290 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513034: rtcpu_nvcsi_intr: tstamp:7339223216 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513034: rtcpu_nvcsi_intr: tstamp:7339225992 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513034: rtcpu_nvcsi_intr: tstamp:7339226455 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513035: rtcpu_nvcsi_intr: tstamp:7339226918 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513035: rtcpu_nvcsi_intr: tstamp:7339227381 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513035: rtcpu_nvcsi_intr: tstamp:7339227845 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513035: rtcpu_nvcsi_intr: tstamp:7339228772 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513035: rtcpu_nvcsi_intr: tstamp:7339229695 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513035: rtcpu_nvcsi_intr: tstamp:7339230621 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513035: rtcpu_nvcsi_intr: tstamp:7339231548 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513036: rtcpu_nvcsi_intr: tstamp:7339232473 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513036: rtcpu_nvcsi_intr: tstamp:7339232937 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513036: rtcpu_nvcsi_intr: tstamp:7339233400 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513036: rtcpu_nvcsi_intr: tstamp:7339235252 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513036: rtcpu_nvcsi_intr: tstamp:7339236640 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513036: rtcpu_nvcsi_intr: tstamp:7339237103 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513036: rtcpu_nvcsi_intr: tstamp:7339238955 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513037: rtcpu_nvcsi_intr: tstamp:7339239882 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513037: rtcpu_nvcsi_intr: tstamp:7339243584 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513037: rtcpu_nvcsi_intr: tstamp:7339244048 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513037: rtcpu_nvcsi_intr: tstamp:7339244973 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513037: rtcpu_nvcsi_intr: tstamp:7339245900 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513037: rtcpu_nvcsi_intr: tstamp:7339246363 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513037: rtcpu_nvcsi_intr: tstamp:7339248213 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513038: rtcpu_nvcsi_intr: tstamp:7339249603 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513038: rtcpu_nvcsi_intr: tstamp:7339250065 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513038: rtcpu_nvcsi_intr: tstamp:7339252382 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513038: rtcpu_nvcsi_intr: tstamp:7339253308 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513038: rtcpu_nvcsi_intr: tstamp:7339253770 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513038: rtcpu_nvcsi_intr: tstamp:7339255621 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513038: rtcpu_nvcsi_intr: tstamp:7339256084 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513039: rtcpu_nvcsi_intr: tstamp:7339257937 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513039: rtcpu_nvcsi_intr: tstamp:7339258863 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513039: rtcpu_nvcsi_intr: tstamp:7339259325 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513039: rtcpu_nvcsi_intr: tstamp:7339259786 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513039: rtcpu_nvcsi_intr: tstamp:7339261639 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513039: rtcpu_nvcsi_intr: tstamp:7339264882 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513039: rtcpu_nvcsi_intr: tstamp:7339267195 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513039: rtcpu_nvcsi_intr: tstamp:7339269047 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513040: rtcpu_nvcsi_intr: tstamp:7339269510 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513040: rtcpu_nvcsi_intr: tstamp:7339270900 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513040: rtcpu_nvcsi_intr: tstamp:7339272287 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513040: rtcpu_nvcsi_intr: tstamp:7339272750 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513040: rtcpu_nvcsi_intr: tstamp:7339274139 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513040: rtcpu_nvcsi_intr: tstamp:7339274602 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513040: rtcpu_nvcsi_intr: tstamp:7339275065 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513041: rtcpu_nvcsi_intr: tstamp:7339275992 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513041: rtcpu_nvcsi_intr: tstamp:7339279695 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513041: rtcpu_nvcsi_intr: tstamp:7339281547 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513041: rtcpu_nvcsi_intr: tstamp:7339284786 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513042: rtcpu_nvcsi_intr: tstamp:7339286175 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513042: rtcpu_nvcsi_intr: tstamp:7339286638 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513043: rtcpu_nvcsi_intr: tstamp:7339287565 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513043: rtcpu_nvcsi_intr: tstamp:7339288029 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513043: rtcpu_nvcsi_intr: tstamp:7339288952 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513043: rtcpu_nvcsi_intr: tstamp:7339290341 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513043: rtcpu_nvcsi_intr: tstamp:7339290805 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513043: rtcpu_nvcsi_intr: tstamp:7339291731 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513043: rtcpu_nvcsi_intr: tstamp:7339292194 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513044: rtcpu_nvcsi_intr: tstamp:7339293584 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513044: rtcpu_nvcsi_intr: tstamp:7339294510 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513044: rtcpu_nvcsi_intr: tstamp:7339295433 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513044: rtcpu_nvcsi_intr: tstamp:7339295897 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513044: rtcpu_nvcsi_intr: tstamp:7339299602 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513044: rtcpu_nvcsi_intr: tstamp:7339305157 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513044: rtcpu_nvcsi_intr: tstamp:7339309323 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513045: rtcpu_nvcsi_intr: tstamp:7339310249 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513045: rtcpu_nvcsi_intr: tstamp:7339310712 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513045: rtcpu_nvcsi_intr: tstamp:7339314878 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513045: rtcpu_nvcsi_intr: tstamp:7339318120 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513045: rtcpu_nvcsi_intr: tstamp:7339318583 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513045: rtcpu_nvcsi_intr: tstamp:7339319507 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513045: rtcpu_nvcsi_intr: tstamp:7339319970 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513046: rtcpu_nvcsi_intr: tstamp:7339324137 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513046: rtcpu_nvcsi_intr: tstamp:7339325528 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513046: rtcpu_nvcsi_intr: tstamp:7339326452 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513046: rtcpu_nvcsi_intr: tstamp:7339326915 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513046: rtcpu_nvcsi_intr: tstamp:7339329694 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513046: rtcpu_nvcsi_intr: tstamp:7339330157 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513046: rtcpu_nvcsi_intr: tstamp:7339332470 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513046: rtcpu_nvcsi_intr: tstamp:7339333396 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513047: rtcpu_nvcsi_intr: tstamp:7339334322 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513047: rtcpu_nvcsi_intr: tstamp:7339335248 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513047: rtcpu_nvcsi_intr: tstamp:7339335712 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513047: rtcpu_nvcsi_intr: tstamp:7339336174 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513047: rtcpu_nvcsi_intr: tstamp:7339336639 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513047: rtcpu_nvcsi_intr: tstamp:7339338488 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513047: rtcpu_nvcsi_intr: tstamp:7339338951 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513048: rtcpu_nvcsi_intr: tstamp:7339340804 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513048: rtcpu_nvcsi_intr: tstamp:7339342656 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513048: rtcpu_nvcsi_intr: tstamp:7339343117 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513048: rtcpu_nvcsi_intr: tstamp:7339345433 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513048: rtcpu_nvcsi_intr: tstamp:7339348211 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513048: rtcpu_nvcsi_intr: tstamp:7339350062 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513048: rtcpu_nvcsi_intr: tstamp:7339355617 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513049: rtcpu_nvcsi_intr: tstamp:7339356080 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513049: rtcpu_nvcsi_intr: tstamp:7339357470 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513049: rtcpu_nvcsi_intr: tstamp:7339358395 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513049: rtcpu_nvcsi_intr: tstamp:7339361635 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513049: rtcpu_nvcsi_intr: tstamp:7339363025 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513049: rtcpu_nvcsi_intr: tstamp:7339364877 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513049: rtcpu_nvcsi_intr: tstamp:7339366267 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513050: rtcpu_nvcsi_intr: tstamp:7339366730 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513050: rtcpu_nvcsi_intr: tstamp:7339367190 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513050: rtcpu_nvcsi_intr: tstamp:7339368117 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513050: rtcpu_nvcsi_intr: tstamp:7339369043 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513050: rtcpu_nvcsi_intr: tstamp:7339369506 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513050: rtcpu_nvcsi_intr: tstamp:7339372285 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513050: rtcpu_nvcsi_intr: tstamp:7339376451 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513051: rtcpu_nvcsi_intr: tstamp:7339377377 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513051: rtcpu_nvcsi_intr: tstamp:7339378304 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513051: rtcpu_nvcsi_intr: tstamp:7339381079 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513051: rtcpu_nvcsi_intr: tstamp:7339382932 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513051: rtcpu_nvcsi_intr: tstamp:7339383395 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513051: rtcpu_nvcsi_intr: tstamp:7339384782 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513051: rtcpu_nvcsi_intr: tstamp:7339386172 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513052: rtcpu_nvcsi_intr: tstamp:7339386635 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513052: rtcpu_nvcsi_intr: tstamp:7339387098 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513052: rtcpu_nvcsi_intr: tstamp:7339388024 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513052: rtcpu_nvcsi_intr: tstamp:7339389872 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513054: rtcpu_vinotify_event: tstamp:7339390442 cch:0 vi:1 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:234849999328 data:0x759e300010000000
     kworker/4:2-136     [004] ....   215.513054: rtcpu_vinotify_event: tstamp:7339390577 cch:0 vi:1 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:234850005760 data:0x0000000031000001
     kworker/4:2-136     [004] ....   215.513054: rtcpu_vinotify_event: tstamp:7339390728 cch:0 vi:1 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:234850046144 data:0x759e2d0010000000
     kworker/4:2-136     [004] ....   215.513054: rtcpu_vinotify_event: tstamp:7339390861 cch:0 vi:1 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:234850052672 data:0x0000000031000002
     kworker/4:2-136     [004] ....   215.513054: rtcpu_nvcsi_intr: tstamp:7339391730 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513054: rtcpu_nvcsi_intr: tstamp:7339392654 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513054: rtcpu_nvcsi_intr: tstamp:7339395432 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513055: rtcpu_nvcsi_intr: tstamp:7339396355 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513055: rtcpu_nvcsi_intr: tstamp:7339397284 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080
     kworker/4:2-136     [004] ....   215.513055: rtcpu_nvcsi_intr: tstamp:7339398208 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000080

PHY_INTR0 and VIFALC_TDSTATE are present.

What could be the reason, and how should I continue debugging?

Thank you so much for your support!

9

I realized that the dts was not updated correctly with lane_polarity=“15” on the module, so please forget last trace logs. The current trace logs are:

tracer: nop
#
# entries-in-buffer/entries-written: 871355/1265494   #P:8
#
#                                _-----=> irqs-off
#                               / _----=> need-resched
#                              | / _---=> hardirq/softirq
#                              || / _--=> preempt-depth
#                              ||| /     delay
#           TASK-PID     CPU#  ||||   TIMESTAMP  FUNCTION
#              | |         |   ||||      |         |
 gst-plugin-scan-4227    [005] ....   396.580247: tegra_channel_open: vi-output, ev9500m 2-0010
 gst-plugin-scan-4227    [005] ....   396.580262: tegra_channel_close: vi-output, ev9500m 2-0010
##### CPU 6 buffer started ####
  gst-launch-1.0-4226    [006] ....   396.643967: tegra_channel_open: vi-output, ev9500m 2-0010
  gst-launch-1.0-4226    [006] ....   396.643983: tegra_channel_close: vi-output, ev9500m 2-0010
  gst-launch-1.0-4226    [006] ....   396.650822: tegra_channel_open: vi-output, ev9500m 2-0010
##### CPU 3 buffer started ####
    v4l2src0:src-4229    [003] ....   396.656353: tegra_channel_set_power: ev9500m 2-0010 : 0x1
    v4l2src0:src-4229    [003] ....   396.656364: camera_common_s_power: status : 0x1
    v4l2src0:src-4229    [003] ....   396.661210: tegra_channel_set_power: 13e40000.host1x:nvcsi@15a00000- : 0x1
    v4l2src0:src-4229    [003] ....   396.661214: csi_s_power: enable : 0x1
    v4l2src0:src-4229    [003] ....   396.661787: tegra_channel_capture_setup: vnc_id 0 W 1920 H 1080 fmt 13
##### CPU 2 buffer started ####
    v4l2src0:src-4229    [002] ....   396.667508: tegra_channel_set_stream: enable : 0x1
##### CPU 0 buffer started ####
    v4l2src0:src-4229    [000] .N..   396.669201: tegra_channel_set_stream: 13e40000.host1x:nvcsi@15a00000- : 0x1
    v4l2src0:src-4229    [000] ....   396.669226: csi_s_stream: enable : 0x1
    v4l2src0:src-4229    [000] ....   396.680655: tegra_channel_set_stream: ev9500m 2-0010 : 0x1
##### CPU 1 buffer started ####
 vi-output, ev95-4232    [001] ....   399.351411: tegra_channel_capture_setup: vnc_id 0 W 1920 H 1080 fmt 13
##### CPU 4 buffer started ####
     kworker/4:4-418     [004] ....   400.125568: rtcpu_nvcsi_intr: tstamp:13024310509 class:GLOBAL type:PHY_INTR0 phy:1 cil:1 st:0 vc:0 status:0x00000044
     kworker/4:4-418     [004] ....   400.125568: rtcpu_nvcsi_intr: tstamp:13024311007 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000044
     kworker/4:4-418     [004] ....   400.125569: rtcpu_nvcsi_intr: tstamp:13024311347 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000044
     kworker/4:4-418     [004] ....   400.125570: rtcpu_nvcsi_intr: tstamp:13024311347 class:GLOBAL type:PHY_INTR0 phy:1 cil:1 st:0 vc:0 status:0x00000044
     kworker/4:4-418     [004] ....   400.125570: rtcpu_nvcsi_intr: tstamp:13024311846 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000044
     kworker/4:4-418     [004] ....   400.125570: rtcpu_nvcsi_intr: tstamp:13024311846 class:GLOBAL type:PHY_INTR0 phy:1 cil:1 st:0 vc:0 status:0x00000044
     kworker/4:4-418     [004] ....   400.125571: rtcpu_nvcsi_intr: tstamp:13024312345 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000044
     kworker/4:4-418     [004] ....   400.125571: rtcpu_nvcsi_intr: tstamp:13024312345 class:GLOBAL type:PHY_INTR0 phy:1 cil:1 st:0 vc:0 status:0x00000044
     kworker/4:4-418     [004] ....   400.125571: rtcpu_nvcsi_intr: tstamp:13024312839 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000044
     kworker/4:4-418     [004] ....   400.125571: rtcpu_nvcsi_intr: tstamp:13024312839 class:GLOBAL type:PHY_INTR0 phy:1 cil:1 st:0 vc:0 status:0x00000044
     kworker/4:4-418     [004] ....   400.125571: rtcpu_nvcsi_intr: tstamp:13024313333 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000044
     kworker/4:4-418     [004] ....   400.125572: rtcpu_nvcsi_intr: tstamp:13024313672 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000044
     kworker/4:4-418     [004] ....   400.125573: rtcpu_nvcsi_intr: tstamp:13024313672 class:GLOBAL type:PHY_INTR0 phy:1 cil:1 st:0 vc:0 status:0x00000044
     kworker/4:4-418     [004] ....   400.125573: rtcpu_nvcsi_intr: tstamp:13024314172 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000044
     kworker/4:4-418     [004] ....   400.125573: rtcpu_nvcsi_intr: tstamp:13024314172 class:GLOBAL type:PHY_INTR0 phy:1 cil:1 st:0 vc:0 status:0x00000044
     kworker/4:4-418     [004] ....   400.125573: rtcpu_nvcsi_intr: tstamp:13024314671 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000044
     kworker/4:4-418     [004] ....   400.125573: rtcpu_nvcsi_intr: tstamp:13024314671 class:GLOBAL type:PHY_INTR0 phy:1 cil:1 st:0 vc:0 status:0x00000044
     kworker/4:4-418     [004] ....   400.125573: rtcpu_nvcsi_intr: tstamp:13024315172 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000044
     kworker/4:4-418     [004] ....   400.125573: rtcpu_nvcsi_intr: tstamp:13024315510 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000044
     kworker/4:4-418     [004] ....   400.125574: rtcpu_nvcsi_intr: tstamp:13024315510 class:GLOBAL type:PHY_INTR0 phy:1 cil:1 st:0 vc:0 status:0x00000044
     kworker/4:4-418     [004] ....   400.125574: rtcpu_nvcsi_intr: tstamp:13024316004 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000044
     kworker/4:4-418     [004] ....   400.125574: rtcpu_nvcsi_intr: tstamp:13024316004 class:GLOBAL type:PHY_INTR0 phy:1 cil:1 st:0 vc:0 status:0x00000044
     kworker/4:4-418     [004] ....   400.125575: rtcpu_nvcsi_intr: tstamp:13024316501 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000044
     kworker/4:4-418     [004] ....   400.125576: rtcpu_nvcsi_intr: tstamp:13024316501 class:GLOBAL type:PHY_INTR0 phy:1 cil:1 st:0 vc:0 status:0x00000044
     kworker/4:4-418     [004] ....   400.125576: rtcpu_nvcsi_intr: tstamp:13024316995 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000044
     kworker/4:4-418     [004] ....   400.125576: rtcpu_nvcsi_intr: tstamp:13024316995 class:GLOBAL type:PHY_INTR0 phy:1 cil:1 st:0 vc:0 status:0x00000044
     kworker/4:4-418     [004] ....   400.125576: rtcpu_nvcsi_intr: tstamp:13024317490 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000044
     kworker/4:4-418     [004] ....   400.125576: rtcpu_nvcsi_intr: tstamp:13024317830 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000044
     kworker/4:4-418     [004] ....   400.125576: rtcpu_nvcsi_intr: tstamp:13024317830 class:GLOBAL type:PHY_INTR0 phy:1 cil:1 st:0 vc:0 status:0x00000044
     kworker/4:4-418     [004] ....   400.125576: rtcpu_nvcsi_intr: tstamp:13024318322 class:GLOBAL type:PHY_INTR0 phy:1 cil:0 st:0 vc:0 status:0x00000044

Checking other posts, this error “tell the SOT(Start Of Transfer) multiple bits error. That could be the settle time cause the issue. You can try discontinuous/continuous clocks.”

I tried with discontinous and continous clock updating the dts, but I captured the same stream error 0x00000044.

Any suggestion to try?

Thanks!

10
  1. Confirm the pix_clk_hz/serdes_pix_clk_hz are correct.
  2. Modify the sensor to output discontinous/continuous mode not just modify the device tree only.
11

I updated the design of the hardware used to adapt the camera connector with the carrier one fixing the CSI pair polarity. Now, with lane_polarity=“0” the camera works with a good quality stream. Great!

great_frame
great_frame1838×1052 176 KB

To view this stream I use the following gstreamer pipeline:

gst-launch-1.0 v4l2src device=/dev/video0 ! videoconvert ! xvimagesink sync=false

The problem now is that it does not work always that I trigger the command. It usually works the first time, but then it works randomly or does not work anymore until I reboot everything. When it works, the stream is stable.

When it fails, the trace logs are:

 vi-output, ev95-7322    [004] ....  3375.248303: tegra_channel_capture_setup: vnc_id 0 W 1920 H 1080 fmt 13
     kworker/4:1-6719    [004] ....  3375.284395: rtcpu_vinotify_event: tstamp:106078944879 cch:0 vi:1 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:3394526161152 data:0x759e300010000000
     kworker/4:1-6719    [004] ....  3375.284396: rtcpu_vinotify_event: tstamp:106078945015 cch:0 vi:1 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:3394526167584 data:0x0000000031000001
     kworker/4:1-6719    [004] ....  3375.284397: rtcpu_vinotify_event: tstamp:106078945168 cch:0 vi:1 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:3394526207936 data:0x759e2d0010000000
     kworker/4:1-6719    [004] ....  3375.284397: rtcpu_vinotify_event: tstamp:106078945299 cch:0 vi:1 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:3394526214496 data:0x0000000031000002
 vi-output, ev95-7322    [004] ....  3378.064281: tegra_channel_capture_setup: vnc_id 0 W 1920 H 1080 fmt 13
     kworker/4:1-6719    [004] ....  3378.100314: rtcpu_vinotify_event: tstamp:106166949748 cch:0 vi:1 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:3397342171104 data:0x759e300010000000
     kworker/4:1-6719    [004] ....  3378.100315: rtcpu_vinotify_event: tstamp:106166949884 cch:0 vi:1 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:3397342177568 data:0x0000000031000001
     kworker/4:1-6719    [004] ....  3378.100316: rtcpu_vinotify_event: tstamp:106166950037 cch:0 vi:1 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:3397342217920 data:0x759e2d0010000000
     kworker/4:1-6719    [004] ....  3378.100316: rtcpu_vinotify_event: tstamp:106166950168 cch:0 vi:1 tag:VIFALC_TDSTATE channel:0x23 frame:0 vi_tstamp:3397342224448 data:0x0000000031000002

I though that could be due to a bad pixel clock configuration. As you suggested me to check, I read in Nvidia documentation that firstly is needed to know the “Output data rate” of the camera using next formula:

Output data rate = (sensor or deserializer pixel clock in hertz)*(bits per pixel) / (number of CSI lanes)

In my case:

Output_data_rate = 148.5MHz*16bits/4lanes = 594MHz

Currently in the dts the pix_clk_hz is “576000000”. Should it be “594000000”?

Thanks again for your support!

12

I am porting everything to the new Jetpack 6, but the problem is still there in JP 5.1.2. Any suggestion to try?

13

Suppose it could be the settle time problem.
Maybe need to make sure the sensor timing as the MIPI spec.

15

I decrease the pixel clock and now it works, but I don’t know why. My fear is that this lower pixel clock affects the camera performance.

16

Did you decrease the sensor output clocks? Or others?

17

I decrease pix_clk_hz in the DTS. The sensor pixel clock is fixed.

18

The pix_clk_hz would be used for calculating the settle time and acquire the NVCSI/VI bandwidth. You can try manual set the cil_settletime to try.

Due to you are decrease the pix_clk_hz that could be impact the settle time calculating.

19

Maybe I’m wrong, but for set the cil_settletime is needed to probe the signal, right? I don’t know which cil_settletime right now.

20

The cil_settletime is in the device tree.

21

Yes, I know that it is in the DTS, but I mean that I don’t know what value set to cil_settletime to test.

Following Nvidia documentation, it says that it is needed to know the value of “ui - unit interval” that it is equal to the duration of the HS state of the clock lane, but I don’t know how to do that.

cil_settletime
cil_settletime1289×253 31.1 KB

What cil_settetime value would you use to test?

Thanks Shane!

22

This topic was automatically closed 14 days after the last reply. New replies are no longer allowed.