This thread has been locked.

If you have a related question, please click the "Ask a related question" button in the top right corner. The newly created question will be automatically linked to this question.

DRA72XEVM: DRA72XEVM

Part Number: DRA72XEVM

Hi Experts,

I am developing the driver for the GMSL sensor.

 Our Sensor Configuration:

  1. 2 lane communication
  2. each of the data lanes processes speeds up to 800MHz.
  3. YUY422 mode
we tried to enable CAL Linux driver (kernel version 4.1.14)following the CAL guide from https://processors.wiki.ti.com/index.php/Linux_Core_CAL_User's_Guide

and met some issues. The signal path in our HW design is like this: TI host (TDA2Px-ACD CPU EVM Board) <--> MAX9296A <--> Fakra cable <--> MAX9295D <--> MIPI interface <--> Video capture module.

However, we can never capture the MIPI signal from cal driver, from the log we always see this timeout log when starting capture and no data can be captured, grep /proc/interrupts, no CAL interrupt generated.

cal-000: CAL_CSI2_COMPLEXIO_CFG(1) = 0x4a000321 Complex IO Reset Done (250) (timeout)

the message is from function: csi2_wait_for_phy [drivers/media/platform/ti-vpe/cal.c], what's the problem? is it cause by pixel rate or link rate?

I use "dmabuftest --debug --fps 60 -s 35:1280x720 -c 1280x720@YUYV -d /dev/video0" to capture video.

Please check the below log for reference.

Thanks.

root@dra7xx-evm:~# dmabuftest --debug --fps 60 -s 35:1280x720 -c 1280x720@YUYV -d /dev/video0
Opening Display..
Enabling dynamic debug.
Forcing playback rate at 60 fps.
using 1 connectors, 720x400 display, multiplanar: 1
Setting mode 1280x720 on connector 35, crtc 39
Opening V4L2..
[ 2583.236607] eSP876_enum_frame_size() +++ 
[ 2583.242017] eSP876_enum_frame_size() fse->index : 0, min_width : 1280, min_height : 720
[ 2583.250099] eSP876_enum_frame_size() --- 
[ 2583.254439] eSP876_set_fmt() +++ 
[ 2583.257991] eSP876_try_fmt_internal() +++ 
[ 2583.262300] eSP876_try_fmt_internal(), fr : 2, fmt->width : 1280, fmt->height : 720 
[ 2583.270205] eSP876_find_mode() +++ 
[ 2583.273879] eSP876_find_mode() --- 
[ 2583.277508] eSP876_try_fmt_internal(), find mode : 0, width : 1280, hight : 720 
[ 2583.285038] eSP876_try_fmt_internal(), find format : 2 ,code : 8200 
[ 2583.291590] eSP876_try_fmt_internal() --- 
[ 2583.295805] eSP876_set_fmt(), pixel_rate : 2798496 
[ 2583.300765] eSP876_set_fmt() --- 
Exported buffer fd = 6

Exported buffer fd = 8

Exported buffer fd = 10

Exported buffer fd = 12

Exported buffer fd = 14

Exported buffer f[ 2583.314124] eSP876_s_power() +++ 
d = 16

[ 2583.321186] eSP876 4-0060: eSP876_s_ctrl: set_ctrl_white_balance() NOT IMPLEMENT!
[ 2583.329601] eSP876 4-0060: eSP876_s_ctrl: set_ctrl_exposure() NOT IMPLEMENT!
[ 2583.336756] eSP876 4-0060: eSP876_s_ctrl: set_ctrl_gain() NOT IMPLEMENT!
[ 2583.343514] eSP876 4-0060: eSP876_s_ctrl: set_ctrl_saturation() NOT IMPLEMENT!
[ 2583.350819] eSP876 4-0060: eSP876_s_ctrl: set_ctrl_hue() NOT IMPLEMENT!
[ 2583.357476] eSP876 4-0060: eSP876_s_ctrl: set_ctrl_contrast() NOT IMPLEMENT!
[ 2583.364613] eSP876 4-0060: eSP876_s_ctrl: set_ctrl_test_pattern() NOT IMPLEMENT!
[ 2583.372067] eSP876 4-0060: eSP876_s_ctrl: set_ctrl_hflip() NOT IMPLEMENT!
[ 2583.378921] eSP876 4-0060: eSP876_s_ctrl: set_ctrl_vflip() NOT IMPLEMENT!
[ 2583.385763] eSP876 4-0060: eSP876_s_ctrl: set_ctrl_light_freq() NOT IMPLEMENT!
[ 2583.393077] eSP876_s_power() --- 
[ 2583.397605] eSP876_s_stream() +++ 
[ 2583.401015] video_mode_switch() +++ 
[ 2583.404631] switch mode to : 0 , enable : 1
[ 2583.422945] got eSP876 response 0x81
[ 2583.430138] After mode switch(Cmd start), polling 02
[ 2583.469602] got eSP876 response 0x02
[ 2583.473238] Cmd transfer finished, polling 0x00
[ 2583.479303] 
[ 2583.479303]  got eSP876 response 0x00
[ 2583.484479] 
[ 2583.484479]  open stream done
[ 2583.488936] video_mode_switch() --- 
[ 2583.492539] sensor->streaming : 1 
[ 2583.496036] eSP876_s_stream() --- 
[ 2583.778850] cal: CAL Registers @ 0x0x00000000489b0000:
[ 2583.784055] 00000000: 40000300 a3c90469 00000000 00000000
[ 2583.789683] 00000010: 00000004 00000000 00000000 00000000
[ 2583.795203] 00000020: 00000000 00000000 00000000 00000000
[ 2583.800763] 00000030: 00000000 00000000 00000001 00000001
[ 2583.806259] 00000040: 00000000 00000000 00000001 00000001
[ 2583.811886] 00000050: 00000000 00000000 00000000 00000000
[ 2583.817354] 00000060: 00000000 00000000 00000000 00000000
[ 2583.822845] 00000070: 00000000 00000000 00000000 00000000
[ 2583.828468] 00000080: 00000000 00000000 00000000 00000000
[ 2583.833936] 00000090: 00000000 00000000 00000000 00000000
[ 2583.839463] 000000a0: 00000000 00000000 00000000 00000000
[ 2583.844928] 000000b0: 00000000 00000000 00000000 00000000
[ 2583.850422] 000000c0: 000d0015 00050014 00050014 00050014
[ 2583.855890] 000000d0: 00000000 00000000 00000000 00000000
[ 2583.861403] 000000e0: 00000000 00000000 00000000 00000000
[ 2583.866873] 000000f0: 00000000 00000000 00000000 00000000
[ 2583.872410] 00000100: ff1fe07e 00000000 00000000 00000000
[ 2583.877857] 00000110: 00000000 00000000 00000000 00000000
[ 2583.883336] 00000120: 00000000 00010000 00000000 00000000
[ 2583.888862] 00000130: 08080000 00000000 00000000 00000000
[ 2583.894329] 00000140: 00000000 00000000 00000000 00000000
[ 2583.899788] 00000150: 00000000 00000000 00000000 00000000
[ 2583.905228] 00000160: 00000000 00000000 00000000 00000000
[ 2583.910687] 00000170: 00000000 00000000 00000000 00000000
[ 2583.916128] 00000180: 00000000 00000000 00000000 00000000
[ 2583.921603] 00000190: 00000000 00000000 00000000 00000000
[ 2583.927022] 000001a0: 00000000 00000000 00000000 00000000
[ 2583.932742] 000001b0: 00000000 00000000 00000000 00000000
[ 2583.938215] 000001c0: 00000000 00000000 00000000 00000000
[ 2583.943683] 000001d0: 00000000 00000000 00000000 00000000
[ 2583.949142] 000001e0: 00000000 00000000 00000000 00000000
[ 2583.954607] 000001f0: 00000000 00000000 00000000 00000000
[ 2583.960085] 00000200: 0b404304 7f4f0000 00000a00 0a000000
[ 2583.965563] 00000210: 00004000 00000000 00000000 00000000
[ 2583.971024] 00000220: 00004000 00000000 00000000 00000000
[ 2583.976475] 00000230: 00004000 00000000 00000000 00000000
[ 2583.981964] 00000240: 00004000 00000000 00000000 00000000
[ 2583.987400] 00000250: 00004000 00000000 00000000 00000000
[ 2583.992834] 00000260: 00004000 00000000 00000000 00000000
[ 2583.998300] 00000270: 00004000 00000000 00000000 00000000
[ 2584.003737] 00000280: 00000000 00000000 00000000 00000000
[ 2584.009196] 00000290: 00000000 00000000 00000000 00000000
[ 2584.014632] 000002a0: 00000000 00000000 00000000 00000000
[ 2584.020091] 000002b0: 00000000 00000000 00000000 00000000
[ 2584.025529] 000002c0: 00000000 00000000 00000000 00000000
[ 2584.030997] 000002d0: 00000000 00000000 00000000 00000000
[ 2584.036436] 000002e0: 00000000 00000000 00000000 00000000
[ 2584.041946] 000002f0: 00000000 00000000 00000000 00000000
[ 2584.047366] 00000300: 00000001 4a000321 00000000 00000000
[ 2584.052803] 00000310: 00000000 00004197 3f000000 00000000
[ 2584.058270] 00000320: 00000000 00000000 00000000 00000000
[ 2584.063709] 00000330: 00000101 00000000 00000000 00000000
[ 2584.069168] 00000340: 00000000 00000000 00000000 00000000
[ 2584.074604] 00000350: 00000000 00000000 00000000 00000000
[ 2584.080063] 00000360: 00000000 00000000 00000000 00000000
[ 2584.085499] 00000370: 00000000 00000000 00000000 00000000
[ 2584.090958] 00000380: 00000000 00000000 00000000 00000000
[ 2584.096861] 00000390: 00000000 00007fff 00000000 00000000
[ 2584.102300] 000003a0: 00000000 00000000 00000000 00000000
[ 2584.107771] 000003b0: 00000000 00000000 00000000 00000000
[ 2584.113210] 000003c0: 00000000 00000000 00000000 00000000
[ 2584.118668] 000003d0: 00000000 00000000 00000000 00000000
[ 2584.124104] 000003e0: 00000000 00000000 00000000 00000000
[ 2584.129575] 000003f0: 00000000 00000000 00000000 00000000
[ 2584.135011] cal: CSI2 Core 0 Registers @ 0x00000000489b0800:
[ 2584.140735] 00000000: 0100041b e002e10e 000000ff 0007c0a0
[ 2584.146175] 00000010: 00000000 860a262c 020e4000 00000200
[ 2584.151649] 00000020: 6bb80000 7e000000 00000000 00000000
[ 2584.157071] 00000030: 00000000 00000000 00000000 00000000
^C[ 2600.879202] eSP876_s_stream() +++ 
[ 2600.882816] video_mode_switch() +++ 
[ 2600.886545] switch mode to : 0 , enable : 0
[ 2600.905730] got eSP876 response 0x81
[ 2600.910512] After mode switch(Cmd start), polling 02
[ 2600.916935] got eSP876 response 0x02
[ 2600.920521] Cmd transfer finished, polling 0x00
[ 2600.926536] 
[ 2600.926536]  got eSP876 response 0x00
[ 2600.931756] 
[ 2600.931756]  cloase stream done
[ 2600.936427] video_mode_switch() --- 
[ 2600.940012] sensor->streaming : 0 
[ 2600.943502] eSP876_s_stream() --- 
[ 2600.946968] eSP876_s_power() +++ 
[ 2600.950291] eSP876_s_power() ---

[ 10.718333] cal: ioresource cal_top at 0x00000000489b0000 - 0x00000000489b03ff
[ 10.718413] cal: got irq# 106
[ 10.718449] cal: ioresource cal_rx_core0 at 0x00000000489b0800 - 0x00000000489b083f
[ 10.718456] cal: ioresource cal_rx_core1 at 0x00000000489b0900 - 0x00000000489b093f
[ 10.718462] cal-000: Scanning Port node for csi2 port: 0
[ 10.724106] cal-000: port:0 inst:0 <reg>:0
[ 10.729675] cal-000: Scanning sub-device for csi2 port: 0
[ 10.735243] cal-000: Port:0 v4l2-endpoint: CSI2
[ 10.739789] cal-000: Virtual Channel=0
[ 10.743669] cal-000: flags=0x00000100
[ 10.747343] cal-000: clock_lane=0
[ 10.752261] cal-000: num_data_lanes=2
[ 10.755935] cal-000: data_lanes= <
[ 10.759345] cal-000: 1
[ 10.764297] cal-000: 2
[ 10.768381] cal-000: >
[ 10.770957] cal-000: Port: 0 found sub-device eSP876
[ 10.777468] cal-001: Scanning Port node for csi2 port: 1
[ 10.784365] cal-001: port:0 inst:1 <reg>:0
[ 10.788477] cal-001: port:1 inst:1 <reg>:1
[ 10.792668] cal-001: Scanning sub-device for csi2 port: 1
[ 10.798089] cal-001: can't get next endpoint
[ 10.804022] cal: CAL_HL_REVISION = 0x40000300 (expecting 0x40000200)
[ 10.804026] cal: CAL_HL_HWINFO = 0xa3c90469 (expecting 0xA3C90469)
[ 10.909194] cal-000: Using sensor eSP876 4-0060 for capture
[ 10.909204] cal-000: subdev eSP876 4-0060: code: 4001 idx: 0
[ 10.909213] cal-000: subdev eSP876 4-0060: code: 2006 idx: 1
[ 10.909216] cal-000: matched fourcc: UYVY: code: 2006 idx: 0
[ 10.909224] cal-000: subdev eSP876 4-0060: code: 2008 idx: 2
[ 10.909227] cal-000: matched fourcc: YUYV: code: 2008 idx: 1
[ 10.909235] cal-000: subdev eSP876 4-0060: code: 1008 idx: 3
[ 10.909238] cal-000: matched fourcc: RGBP: code: 1008 idx: 2
[ 10.909245] cal-000: subdev eSP876 4-0060: code: 1007 idx: 4
[ 10.909248] cal-000: matched fourcc: RGBR: code: 1007 idx: 3
[ 10.909390] cal-000: V4L2 device registered as video0
[ 10.909420] cal-000: __subdev_get_format 1280x720 code:2008
[ 10.909423] cal-000: cal_calc_format_size: fourcc: YUYV size: 1280x720 bpl:2560 img_size:1843200
[ 13.912375] rpmsg_rpc virtio0.rpmsg-rpc.-1.101: probing service dce-callback with src 1024 dst 101
[ 70.134307] cal-000: cal_calc_format_size: fourcc: YUYV size: 1280x720 bpl:2560 img_size:1843200
[ 70.183375] cal-000: __subdev_set_format 1280x720 code:2008
[ 70.183382] cal-000: cal_calc_format_size: fourcc: YUYV size: 1280x720 bpl:2560 img_size:1843200
[ 70.183658] cal-000: nbuffers=6, size=1843200
[ 70.194353] cal-000: sensor Pixel Rate: 55969920
[ 70.277820] cal-000: CAL_CSI2_CTX0(1) = 0x00000101
[ 70.277825] cal-000: CAL_PIX_PROC(1) = 0x000d0015
[ 70.277830] cal-000: CAL_WR_DMA_CTRL(1) = 0x0b404304
[ 70.277834] cal-000: CAL_WR_DMA_OFST(1) = 0x00000a00
[ 70.277838] cal-000: CAL_WR_DMA_XSIZE(1) = 0x0a000000
[ 70.277842] cal-000: CAL_CTRL = 0xff1fe07e
[ 70.277846] cal-000: CAL_CSI2_COMPLEXIO_CFG(1) = 0x00000321
[ 70.277857] cal-000: CAL_CSI2_COMPLEXIO_CFG(1) = 0x40000321 De-assert Complex IO Reset
[ 70.277861] cal-000: csi2_ddrclk_khz: 223872
[ 70.277864] cal-000: ths_term: 4 (0x04)
[ 70.277867] cal-000: ths_settle: 27 (0x1b)
[ 70.277871] cal-000: CSI2_0_REG0 = 0x0100041b
[ 70.277876] cal-000: CSI2_0_REG1 = 0xe002e10e
[ 70.277881] cal-000: CAL_CSI2_TIMING(1) = 0x00004197 Stop States
[ 70.277885] cal-000: CAL_CSI2_TIMING(1) = 0x0000c197 Force RXMODE
[ 70.279002] cal-000: CAL_CSI2_COMPLEXIO_CFG(1) = 0x4a000321 Powered UP
[ 70.666477] cal-000: CAL_CSI2_COMPLEXIO_CFG(1) = 0x4a000321 Complex IO Reset Done (250) (timeout)
[ 70.666486] cal-000: CAL_CSI2_TIMING(1) = 0x00004197 Stop State Reached
[ 70.666494] cal-000: CSI2_0_REG1 = 0xe002e10e (Bit(31,28) should be set!)
[ 70.666501] cal: CAL Registers @ 0x0x00000000489b0000:
[ 71.028079] cal: CSI2 Core 0 Registers @ 0x00000000489b0800:
[ 122.078751] cal-000: CAL_CSI2_COMPLEXIO_CFG(1) = 0x40000321 Powered Down
[ 122.078762] cal-000: CAL_CSI2_COMPLEXIO_CFG(1) = 0x00000321 Complex IO in Reset (0)
[ 141.854218] cal-000: cal_calc_format_size: fourcc: YUYV size: 1280x720 bpl:2560 img_size:1843200
[ 141.903355] cal-000: __subdev_set_format 1280x720 code:2008
[ 141.903360] cal-000: cal_calc_format_size: fourcc: YUYV size: 1280x720 bpl:2560 img_size:1843200
[ 141.903625] cal-000: nbuffers=6, size=1843200
[ 141.914458] cal-000: sensor Pixel Rate: 55969920
[ 142.001146] cal-000: CAL_CSI2_CTX0(1) = 0x00000101
[ 142.001151] cal-000: CAL_PIX_PROC(1) = 0x000d0015
[ 142.001156] cal-000: CAL_WR_DMA_CTRL(1) = 0x0b404304
[ 142.001160] cal-000: CAL_WR_DMA_OFST(1) = 0x00000a00
[ 142.001164] cal-000: CAL_WR_DMA_XSIZE(1) = 0x0a000000
[ 142.001168] cal-000: CAL_CTRL = 0xff1fe07e
[ 142.001172] cal-000: CAL_CSI2_COMPLEXIO_CFG(1) = 0x00000321
[ 142.001182] cal-000: CAL_CSI2_COMPLEXIO_CFG(1) = 0x40000321 De-assert Complex IO Reset
[ 142.001186] cal-000: csi2_ddrclk_khz: 223872
[ 142.001189] cal-000: ths_term: 4 (0x04)
[ 142.001192] cal-000: ths_settle: 27 (0x1b)
[ 142.001196] cal-000: CSI2_0_REG0 = 0x0100041b
[ 142.001201] cal-000: CSI2_0_REG1 = 0xe002e10e
[ 142.001206] cal-000: CAL_CSI2_TIMING(1) = 0x00004197 Stop States
[ 142.001210] cal-000: CAL_CSI2_TIMING(1) = 0x0000c197 Force RXMODE
[ 142.002326] cal-000: CAL_CSI2_COMPLEXIO_CFG(1) = 0x4a000321 Powered UP
[ 142.383513] cal-000: CAL_CSI2_COMPLEXIO_CFG(1) = 0x4a000321 Complex IO Reset Done (250) (timeout)
[ 142.383523] cal-000: CAL_CSI2_TIMING(1) = 0x00004197 Stop State Reached
[ 142.383530] cal-000: CSI2_0_REG1 = 0xe002e10e (Bit(31,28) should be set!)
[ 148.053436] cal-000: CAL_CSI2_COMPLEXIO_CFG(1) = 0x40000321 Powered Down
[ 148.053448] cal-000: CAL_CSI2_COMPLEXIO_CFG(1) = 0x00000321 Complex IO in Reset (0)
[ 916.934186] cal-000: cal_calc_format_size: fourcc: YUYV size: 1280x720 bpl:2560 img_size:1843200
[ 916.989231] cal-000: __subdev_set_format 1280x720 code:2008
[ 916.989236] cal-000: cal_calc_format_size: fourcc: YUYV size: 1280x720 bpl:2560 img_size:1843200
[ 916.989523] cal-000: nbuffers=6, size=1843200
[ 916.999379] cal-000: sensor Pixel Rate: 55969920
[ 917.081925] cal-000: CAL_CSI2_CTX0(1) = 0x00000101
[ 917.081931] cal-000: CAL_PIX_PROC(1) = 0x000d0015
[ 917.081936] cal-000: CAL_WR_DMA_CTRL(1) = 0x0b404304
[ 917.081941] cal-000: CAL_WR_DMA_OFST(1) = 0x00000a00
[ 917.081946] cal-000: CAL_WR_DMA_XSIZE(1) = 0x0a000000
[ 917.081951] cal-000: CAL_CTRL = 0xff1fe07e
[ 917.081955] cal-000: CAL_CSI2_COMPLEXIO_CFG(1) = 0x00000321
[ 917.082004] cal-000: CAL_CSI2_COMPLEXIO_CFG(1) = 0x40000321 De-assert Complex IO Reset
[ 917.082008] cal-000: csi2_ddrclk_khz: 223872
[ 917.082012] cal-000: ths_term: 4 (0x04)
[ 917.082016] cal-000: ths_settle: 27 (0x1b)
[ 917.082020] cal-000: CSI2_0_REG0 = 0x0100041b
[ 917.082026] cal-000: CSI2_0_REG1 = 0xe002e10e
[ 917.082032] cal-000: CAL_CSI2_TIMING(1) = 0x00004197 Stop States
[ 917.082037] cal-000: CAL_CSI2_TIMING(1) = 0x0000c197 Force RXMODE
[ 917.083185] cal-000: CAL_CSI2_COMPLEXIO_CFG(1) = 0x4a000321 Powered UP
[ 917.464017] cal-000: CAL_CSI2_COMPLEXIO_CFG(1) = 0x4a000321 Complex IO Reset Done (250) (timeout)
[ 917.464026] cal-000: CAL_CSI2_TIMING(1) = 0x00004197 Stop State Reached
[ 917.464034] cal-000: CSI2_0_REG1 = 0xe002e10e (Bit(31,28) should be set!)
[ 917.464042] cal: CAL Registers @ 0x0x00000000489b0000:
[ 917.819889] cal: CSI2 Core 0 Registers @ 0x00000000489b0800:
[ 1858.964982] cal-000: CAL_CSI2_COMPLEXIO_CFG(1) = 0x40000321 Powered Down
[ 1858.964992] cal-000: CAL_CSI2_COMPLEXIO_CFG(1) = 0x00000321 Complex IO in Reset (0)
[ 1863.715981] cal-000: cal_calc_format_size: fourcc: YUYV size: 1280x720 bpl:2560 img_size:1843200
[ 1863.765881] cal-000: __subdev_set_format 1280x720 code:2008
[ 1863.765901] cal-000: cal_calc_format_size: fourcc: YUYV size: 1280x720 bpl:2560 img_size:1843200
[ 1863.766258] cal-000: nbuffers=6, size=1843200
[ 1863.776874] cal-000: sensor Pixel Rate: 55969920
[ 1863.859402] cal-000: CAL_CSI2_CTX0(1) = 0x00000101
[ 1863.859407] cal-000: CAL_PIX_PROC(1) = 0x000d0015
[ 1863.859412] cal-000: CAL_WR_DMA_CTRL(1) = 0x0b404304
[ 1863.859416] cal-000: CAL_WR_DMA_OFST(1) = 0x00000a00
[ 1863.859420] cal-000: CAL_WR_DMA_XSIZE(1) = 0x0a000000
[ 1863.859424] cal-000: CAL_CTRL = 0xff1fe07e
[ 1863.859428] cal-000: CAL_CSI2_COMPLEXIO_CFG(1) = 0x00000321
[ 1863.859438] cal-000: CAL_CSI2_COMPLEXIO_CFG(1) = 0x40000321 De-assert Complex IO Reset
[ 1863.859442] cal-000: csi2_ddrclk_khz: 223872
[ 1863.859445] cal-000: ths_term: 4 (0x04)
[ 1863.859448] cal-000: ths_settle: 27 (0x1b)
[ 1863.859452] cal-000: CSI2_0_REG0 = 0x0100041b
[ 1863.859457] cal-000: CSI2_0_REG1 = 0xe002e10e
[ 1863.859462] cal-000: CAL_CSI2_TIMING(1) = 0x00004197 Stop States
[ 1863.859466] cal-000: CAL_CSI2_TIMING(1) = 0x0000c197 Force RXMODE
[ 1863.860582] cal-000: CAL_CSI2_COMPLEXIO_CFG(1) = 0x4a000321 Powered UP
[ 1864.242110] cal-000: CAL_CSI2_COMPLEXIO_CFG(1) = 0x4a000321 Complex IO Reset Done (250) (timeout)
[ 1864.242119] cal-000: CAL_CSI2_TIMING(1) = 0x00004197 Stop State Reached
[ 1864.242127] cal-000: CSI2_0_REG1 = 0xe002e10e (Bit(31,28) should be set!)
[ 1864.242135] cal: CAL Registers @ 0x0x00000000489b0000:
[ 1864.596330] cal: CSI2 Core 0 Registers @ 0x00000000489b0800:
[ 1876.410778] cal-000: CAL_CSI2_COMPLEXIO_CFG(1) = 0x40000321 Powered Down
[ 1876.410789] cal-000: CAL_CSI2_COMPLEXIO_CFG(1) = 0x00000321 Complex IO in Reset (0)

root@dra7xx-evm:~# v4l2-ctl --all -d /dev/video0

Driver Info (not using libv4l2):
        Driver name   : cal
        Card type     : cal
        Bus info      : platform:cal-000
        Driver version: 4.14.79
        Capabilities  : 0x85200001
                Video Capture
                Read/Write
                Streaming
                Extended Pix Format
                Device Capabilities
        Device Caps   : 0x05200001
                Video Capture
                Read/Write
                Streaming
                Extended Pix Format
Priority: 2
Video input : 0 (Camera 0: ok)
Format Video Capture:
        Width/Height      : 1280/720
        Pixel Format      : 'YUYV'
        Field             : None
        Bytes per Line    : 2560
        Size Image        : 1843200
        Colorspace        : sRGB
        Transfer Function : sRGB
        YCbCr Encoding    : ITU-R 601
        Quantization      : Full Range
        Flags             : 

User Controls

                        contrast (int)    : min=0 max=255 step=1 default=0 value=0 flags=slider
                     saturation (int)    : min=0 max=255 step=1 default=64 value=64 flags=slider
                               hue (int)    : min=0 max=359 step=1 default=0 value=0 flags=slider
        white_balance_automatic (bool)   : default=1 value=1 flags=update
                     red_balance (int)    : min=0 max=4095 step=1 default=0 value=0 flags=inactive, slider
                   blue_balance (int)    : min=0 max=4095 step=1 default=0 value=0 flags=inactive, slider
                       exposure (int)    : min=0 max=65535 step=1 default=0 value=0 flags=inactive, volatile
                 gain_automatic (bool)   : default=1 value=1 flags=update
                           gain (int)    : min=0 max=1023 step=1 default=0 value=0 flags=inactive, volatile
                horizontal_flip (bool)   : default=0 value=0
                  vertical_flip (bool)   : default=0 value=0
           power_line_frequency (menu)   : min=0 max=3 default=1 value=1

Camera Controls

                  auto_exposure (menu)   : min=0 max=1 default=0 value=0 flags=update

Image Processing Controls

                 link_frequency (intmenu): min=0 max=4 default=0 value=0 flags=read-only
                     pixel_rate (int64)  : min=0 max=0 step=0 default=0 value=55969920 flags=read-only
                   test_pattern (menu)   : min=0 max=1 default=0 value=0

  • Hi,

    this is mostly caused by the sequence in which CAL driver and sensor is started. Can you please follow one of the existing sensor example and use the same sequence?

    Also is your CSI2 DDR speed correct and matching with the sensor output?

    Rgds,

    Brijesh

  • Hi Brijesh,

    this is mostly caused by the sequence in which CAL driver and sensor is started. Can you please follow one of the existing sensor example and use the same sequence?

    [ans] our sensor is based on 0V5640 sensor to modify. so I think the sequence should be the same as OV5640.

    Also is your CSI2 DDR speed correct and matching with the sensor output?

    [ans] not sure what do you mean? how to check this one?

    can you help to check the below logs? is any abnormal behavior?

    Below is dmesg log when device boot up.  eSP876 is our sensor.

    [  OK  ] Started Load/Save Random Seed.
             Starting Create Volatile Files and Directories...
    [  OK  ] Started Create Volatile Files and Directories.
             Starting Network Time Synchronization...
             Starting Update UTMP about System Boot/Shutdown...
    [    6.866074] omap-rproc 58820000.ipu: assigned reserved memory node ipu1_cma@9d000000
    [    6.884326] remoteproc remoteproc0: 58820000.ipu is available
    [  OK  ] Started udev Coldplug all Devices.
    [    6.903640] omap-rproc 55020000.ipu: assigned reserved memory node ipu2_cma@95800000
    [    6.942302] remoteproc remoteproc1: 55020000.ipu is available
    [  OK  ] Started Update UTMP about System Boot/Shutdown.
    [    6.958448] omap-rproc 40800000.dsp: assigned reserved memory node dsp1_cma@99000000
    [    6.968809] remoteproc remoteproc2: 40800000.dsp is available
    [    6.975830] omap-rproc 41000000.dsp: assigned reserved memory node dsp2_cma@9f000000
    [    6.987097] remoteproc remoteproc3: 41000000.dsp is available
    [  OK  ] Found device /dev/ttyS0.
    [    7.168835] remoteproc remoteproc0: powering up 58820000.ipu
    [    7.174545] remoteproc remoteproc0: Booting fw image dra7-ipu1-fw.xem4, size 4846744
    [    7.189237] omap-iommu 58882000.mmu: 58882000.mmu: version 2.1
    [    7.214788] virtio_rpmsg_bus virtio0: rpmsg host is online
    [    7.215040] CAN device driver interface
    [    7.220526] virtio_rpmsg_bus virtio0: creating channel rpmsg-client-sample addr 0x32
    [    7.220609] virtio_rpmsg_bus virtio0: creating channel rpmsg-client-sample addr 0x33
    [    7.220676] virtio_rpmsg_bus virtio0: creating channel rpmsg-omx addr 0x3c
    [    7.220737] virtio_rpmsg_bus virtio0: creating channel rpmsg-rpc addr 0x65
    [    7.261221] remoteproc remoteproc0: registered virtio0 (type 7)
    [    7.268112] remoteproc remoteproc0: remote processor 58820000.ipu is now up
    [    7.441161] remoteproc remoteproc1: powering up 55020000.ipu
    [    7.446852] remoteproc remoteproc1: Booting fw image dra7-ipu2-fw.xem4, size 3747220
    [    7.454721] omap-iommu 55082000.mmu: 55082000.mmu: version 2.1
    [    7.495839] virtio_rpmsg_bus virtio1: rpmsg host is online
    [    7.501400] remoteproc remoteproc1: registered virtio1 (type 7)
    [    7.504068] virtio_rpmsg_bus virtio1: creating channel rpmsg-rpc addr 0x65
    [    7.505000] virtio_rpmsg_bus virtio1: creating channel rpmsg-rpc addr 0x66
    [    7.522011] remoteproc remoteproc1: remote processor 55020000.ipu is now up
    [    7.787661] ov1063x: probe of 4-0037 failed with error -121
    [    7.807928] Etron 0-eSP876 fwnode_graph_get_next_endpoint done.
    [    7.815434] Etron 1-eSP876 v4l2_fwnode_endpoint_parse done.
    [    7.824149] Etron 2-eSP876 v4l2_i2c_subdev_init done.
    [    7.830480] Etron 3-eSP876 media_entity_pads_init done.
    [    7.838214] eSP876 4-0060: 4-0060 supply DOVDD not found, using dummy regulator
    [    7.845619] eSP876 4-0060: 4-0060 supply DVDD not found, using dummy regulator
    [    7.857616] eSP876 4-0060: 4-0060 supply AVDD not found, using dummy regulator
    [    7.867151] Etron 3-eSP876 eSP876_get_regulators done.
    [[    7.877140] Etron 4-eSP876 eSP876_check_chip_id done.
      OK  ] Started Network Time Synchronization.[    7.883303] Etron 5-eSP876 eSP876_init_controls done.
    
    [    7.893915] Etron eSP876 entries driver (v0.10)
    [  OK  ] Reached target System Initialization.
    [  OK  ] Listening on D-Bus System Message Bus Socket.
    [    7.973622] omap-des 480a5000.des: OMAP DES hw accel rev: 2.2
    [    7.979623] omap-des 480a5000.des: will run requests pump with realtime priority
    [    7.987242] max9295D_probe: check chip id done
             Starting Docker Socket for the API.
    [    8.071597] m_can 42c01a00.mcan: m_can device registered (irq=107, version=32)
    [    8.077493] sleep 80ms
    [    8.167496] sleep 80ms
    [    8.243812] cal-000: Scanning Port node for csi2 port: 0
    [    8.250928] cal-000: port:0 inst:0 <reg>:0
    [    8.257899] sleep 80ms
    [    8.268759] cal-000: Scanning sub-device for csi2 port: 0
    [    8.268842] cal-000: Port:0 v4l2-endpoint: CSI2
    [    8.268844] cal-000: Virtual Channel=0
    [    8.268846] cal-000: flags=0x00000100
    [    8.268848] cal-000: clock_lane=0
    [    8.268851] cal-000: num_data_lanes=2
    [    8.268852] cal-000: data_lanes= <
    [    8.268854] cal-000:         1
    [    8.268856] cal-000:         2
    [    8.268857] cal-000:         >
    [    8.268859] cal-000: Port: 0 found sub-device eSP876
    [    8.268865] eSP876_enum_mbus_code() +++ 
    [    8.268867] code->code : 16385 
    [    8.268869] eSP876_enum_mbus_code() --- 
    [    8.268874] eSP876_enum_mbus_code() +++ 
    [    8.268876] code->code : 8198 
    [    8.268878] eSP876_enum_mbus_code() --- 
    [    8.268883] eSP876_enum_mbus_code() +++ 
    [    8.268885] code->code : 8200 
    [    8.268886] eSP876_enum_mbus_code() --- 
    [    8.268893] eSP876_enum_mbus_code() +++ 
    [    8.268894] code->code : 4104 
    [    8.268895] eSP876_enum_mbus_code() --- 
    [    8.268901] eSP876_enum_mbus_code() +++ 
    [    8.268903] code->code : 4103 
    [    8.268904] eSP876_enum_mbus_code() --- 
    [    8.268910] eSP876_enum_mbus_code() +++ 
    [    8.269279] cal-000: V4L2 device registered as video0
    [    8.269304] eSP876_get_fmt() +++ 
    [    8.269307] eSP876_get_fmt(), width : 1280, height : 720, code : 8200 
    [    8.269309] eSP876_get_fmt() --- 
    [    8.269322] cal-001: Scanning Port node for csi2 port: 1
    [    8.269327] cal-001: port:0 inst:1 <reg>:0
    [    8.269331] cal-001: port:1 inst:1 <reg>:1
    [    8.269333] cal-001: Scanning sub-device for csi2 port: 1
    [    8.269335] cal-001: can't get next endpoint
    [    8.347492] sleep 80ms
    [    8.349872] Register list loaded
    [    8.349875] max9295D_probe: set init reg values done
    [    8.349876] eys3D MAX-9295D entries driver (v0.10)
    [    8.351522] max9296A_probe: check chip id done
    [  OK  ] Listening on dropbear.socket.
             Starting Network Service...
    [  OK  ] Started Daily Cleanup of Temporary Directories.
    [  OK  ] Listening on Avahi mDNS/DNS-SD Stack Activation Socket.
    [  OK  ] Listening on RPCbind Server Activation Socket.
    [  OK  ] Reached target System Time Synchronized.
    [    8.668057] Register list loaded
    [    8.671581] max9296A_probe: set initial reg values done
    [    8.677362] eys3D MAX-9296A entries driver (v0.10)
    [    9.233334] remoteproc remoteproc2: powering up 40800000.dsp
    [    9.239048] remoteproc remoteproc2: Booting fw image dra7-dsp1-fw.xe66, size 20430580
    [    9.245679] omap_hwmod: mmu0_dsp1: _wait_target_disable failed
    [    9.245706] omap-iommu 40d01000.mmu: 40d01000.mmu: version 3.0
    [    9.245731] omap-iommu 40d02000.mmu: 40d02000.mmu: version 3.0
    [  OK  ] Started Daily rotation of log files.
    [    9.270263] vpe 489d0000.vpe: loading firmware vpdma-1b8.bin
    [    9.281318] virtio_rpmsg_bus virtio2: rpmsg host is online
    [    9.281354] remoteproc remoteproc2: registered virtio2 (type 7)
    [    9.281358] remoteproc remoteproc2: remote processor 40800000.dsp is now up
    [    9.281390] virtio_rpmsg_bus virtio2: creating channel rpmsg-proto addr 0x3d
    [  OK  ] Reached target Timers.
    [    9.317180] omap-sham 4b101000.sham: hw accel on OMAP rev 4.3
    [    9.326602] vpe 489d0000.vpe: Device registered as /dev/video1
    [    9.337230] omap_wdt: OMAP Watchdog Timer Rev 0x01: initial timeout 60 sec
    [    9.351947] omap-aes 4b500000.aes: OMAP AES hw accel rev: 3.3
    [FAILED] Failed to listen on Docker Socket for the A[    9.358869] omap-aes 4b500000.aes: will run requests pump with realtime priority
    PI.
    [    9.376891] omap-aes 4b700000.aes: OMAP AES hw accel rev: 3.3
    [    9.386428] omap-aes 4b700000.aes: will run requests pump with realtime priority
    See 'systemctl status docker.socket' for details.
    [DEPEND] Dependency failed for Docker Application Container Engine.
    [  OK  ] Reached target Sockets.
    [    9.474338] remoteproc remoteproc3: powering up 41000000.dsp
    [    9.480067] remoteproc remoteproc3: Booting fw image dra7-dsp2-fw.xe66, size 20430580
    [  OK  ] Reached target Basic System.
    [    9.494594] omap_hwmod: mmu0_dsp2: _wait_target_disable failed
    [    9.500474] omap-iommu 41501000.mmu: 41501000.mmu: version 3.0
    [    9.506373] omap-iommu 41502000.mmu: 41502000.mmu: version 3.0
    [    9.512619] SCSI subsystem initialized
    [  OK  ] Started Job spooling tools.
    [    9.527201] virtio_rpmsg_bus virtio3: rpmsg host is online
    [    9.529822] virtio_rpmsg_bus virtio3: creating channel rpmsg-proto addr 0x3d
    [    9.540679] remoteproc remoteproc3: registered virtio3 (type 7)
    [    9.546632] remoteproc remoteproc3: remote processor 41000000.dsp is now up
    [  OK  ] Reached target Containers.
             Starting TI MultiCore Tools Daemon...
    [  OK  ] Started Periodic Command Scheduler.
    [    9.641806] ahci 4a140000.sata: forcing port_map 0x0 -> 0x1
             Starting Print notice about GPLv3 packages...
             Starting uim-sysfs.service...
             Starting TI IPC Daemon...
    [    9.670019] ahci 4a140000.sata: Enable 32-bit DMA instead of 64-bit.
    [    9.676430] ahci 4a140000.sata: AHCI 0001.0300 32 slots 1 ports 3 Gbps 0x1 impl platform mode
    [    9.686430] ahci 4a140000.sata: flags: 64bit ncq sntf pm led clo only pmp pio slum part ccc apst 
    [    9.696720] scsi host0: ahci
    [    9.700295] ata1: SATA max UDMA/133 mmio [mem 0x4a140000-0x4a1410ff] port 0x100 irq 86
             Starting RPC Bind Service...
             Starting Login Service...
    [  OK  ] Started D-Bus System Message Bus.
    [    9.846038] vip 48970000.vip: loading firmware vpdma-1b8.bin
    [    9.877520] vip 48970000.vip: VPDMA firmware loaded
    [    9.969798] [drm] Initialized pvr 1.14.3699939 20110701 for 56000000.gpu on minor 1
    [   10.038400] ata1: SATA link down (SStatus 0 SControl 300)
    [   10.061876] omap-hdmi-audio omap-hdmi-audio.0.auto: snd-soc-dummy-dai <-> 58040000.encoder mapping ok
    [   10.108710] omap-hdmi-audio omap-hdmi-audio.0.auto: ASoC: no DMI vendor name!
    [  OK  ] Started System Logging Service.
    [  OK  ] Started Kernel Logging Service.
             Starting Avahi mDNS/DNS-SD Stack...
             Starting Save/Restore Sound Card State...
    [  OK  ] Started Hardware RNG Entropy Gatherer Daemon.
    [FAILED] Failed to start TI MultiCore Tools Daemon.
    See 'systemctl status ti-mct-daemon.service' for details.
    [  OK  ] Started uim-sysfs.service.
    [  OK  ] Started TI IPC Daemon.
    [  OK  ] Started RPC Bind Service.
    [  OK  ] Started Network Service.
    [   10.411805] net eth1: initializing cpsw version 1.15 (0)
    [  OK  ] Reached target Network.
             Starting Simple Network Management Protocol (SNMP) Daemon....
             Starting Enable and configure wl18xx bluetooth stack...
             Starting Lightning Fast Webserver With Light System Requirements...
             Starting Network Name Resolution...
             Starting Permit User Sessions...
             Starting DNS forwarder and DHCP server...
    [   10.494285] random: crng init done
    [   10.494289] random: 7 urandom warning(s) missed due to ratelimiting
    [  OK  ] Started Redis In-Memory Data Store.
    [   10.521479] TI DP83867 48485000.mdio:03: attached PHY driver [TI DP83867] (mii_bus:phy_addr=48485000.mdio:03, irq=POLL)
             Starting Wait for Network to be Configured...
             Starting rc.pvr.service...
    [   10.554213] IPv6: ADDRCONF(NETDEV_UP): eth1: link is not ready
    [  OK  ] Started Login Service.
    [  OK  ] Started Avahi mDNS/DNS-SD Stack.
    [  OK  ] Started Save/Restore Sound Card State.
    [   10.593274] net eth0: initializing cpsw version 1.15 (0)
    [   10.610211] asoc-simple-card sound0: tlv320aic3x-hifi <-> 48468000.mcasp mapping ok
    [   10.652262] asoc-simple-card sound0: ASoC: no DMI vendor name!
    [   10.712258] TI DP83867 48485000.mdio:02: attached PHY driver [TI DP83867] (mii_bus:phy_addr=48485000.mdio:02, irq=POLL)
    [   10.739661] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
    [  OK  ] Stopped Redis In-Memory Data Store.
    [  OK  ] Started Redis In-Memory Data Store.
    [  OK  ] Started Permit User Sessions.
    [  OK  ] Started Getty on tty1.
    [  OK  ] Started Serial Getty on ttyS0.
    [  OK  ] Reached target Login Prompts.
             Starting Synchronize System and HW clocks...
    [  OK  ] Started Network Name Resolution.
    [  OK  ] Reached target Host and Network Name Lookups.
    [  OK  ] Started NFS status monitor for NFSv2/3 locking..
    [  OK  ] Started Enable and configure wl18xx bluetooth stack.
    [  OK  ] Started DNS forwarder and DHCP server.
    [  OK  ] Stopped Redis In-Memory Data Store.
    [  OK  ] Started Redis In-Memory Data Store.
    [  OK  ] Started Lightning Fast Webserver With Light System Requirements.
    [   11.047389] PVR_K: UM DDK-(3699939) and KM DDK-(3699939) match. [ OK ]
    [FAILED] Failed to start Synchronize System and HW clocks.
    See 'systemctl status sync-clocks.service' for details.
    [  OK  ] Stopped Redis In-Memory Data Store.
    [  OK  ] Started Redis In-Memory Data Store.
    [  OK  ] Started rc.pvr.service.
             Starting weston.service...
    [  OK  ] Started weston.service.
             Starting telnetd.service...
             Starting Matrix GUI...
    [  OK  ] Started telnetd.service.
             Starting thttpd.service...
    [   11.357903] FAT-fs (mmcblk0p1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck.
    [  OK  ] Started Matrix GUI.
    [  OK  ] Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
    [  OK  ] Stopped Redis In-Memory Data Store.
    [  OK  ] Started Redis In-Memory Data Store.
    [  OK  ] Started thttpd.service.
             Starting rng-tools.service...
    [  OK  ] Stopped Redis In-Memory Data Store.
    [FAILED] Failed to start Redis In-Memory Data Store.
    See 'systemctl status redis.service' for details.
    [  OK  ] Started Simple Network Management Protocol (SNMP) Daemon..
    [  OK  ] Started rng-tools.service.
    [   12.088623] rpmsg_rpc virtio0.rpmsg-rpc.-1.101: probing service rpc_example_2 with src 1024 dst 101
    [   12.126836] NET: Registered protocol family 44
    [   12.213335] rpmsg_rpc virtio1.rpmsg-rpc.-1.101: probing service dce-callback with src 1024 dst 101
    [   12.213792] rpmsg_rpc virtio0.rpmsg-rpc.-1.101: published functions = 8
    [   12.369836] rpmsg_rpc virtio1.rpmsg-rpc.-1.102: probing service rpmsg-dce with src 1025 dst 102
    [   12.370136] rpmsg_rpc virtio1.rpmsg-rpc.-1.101: published functions = 4
    [   12.388744] rpmsg_rpc virtio1.rpmsg-rpc.-1.102: published functions = 9
    [  OK  ] Reached target Sound Card.
    [   12.659207] xhci-hcd xhci-hcd.3.auto: xHCI Host Controller
    [   12.665594] xhci-hcd xhci-hcd.3.auto: new USB bus registered, assigned bus number 1
    [   12.677170] xhci-hcd xhci-hcd.3.auto: hcc params 0x0220f04c hci version 0x100 quirks 0x02010010
    [   12.686970] xhci-hcd xhci-hcd.3.auto: irq 187, io mem 0x48890000
    [   12.693442] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
    [   12.700508] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
    [   12.707878] usb usb1: Product: xHCI Host Controller
    [   12.712793] usb usb1: Manufacturer: Linux 4.14.79-ge669d52447 xhci-hcd
    [   12.720361] usb usb1: SerialNumber: xhci-hcd.3.auto
    [   12.725750] hub 1-0:1.0: USB hub found
    [   12.729583] hub 1-0:1.0: 1 port detected
    [   12.733907] xhci-hcd xhci-hcd.3.auto: xHCI Host Controller
    [   12.739463] xhci-hcd xhci-hcd.3.auto: new USB bus registered, assigned bus number 2
    [   12.747325] xhci-hcd xhci-hcd.3.auto: Host supports USB 3.0  SuperSpeed
    [   12.754041] usb usb2: We don't know the algorithms for LPM for this host, disabling LPM.
    [   12.762942] usb usb2: New USB device found, idVendor=1d6b, idProduct=0003
    [   12.770925] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
    [   12.779328] usb usb2: Product: xHCI Host Controller
    [   12.784835] usb usb2: Manufacturer: Linux 4.14.79-ge669d52447 xhci-hcd
    [   12.792983] usb usb2: SerialNumber: xhci-hcd.3.auto
    [   12.799152] hub 2-0:1.0: USB hub found
    [   12.802964] hub 2-0:1.0: 1 port detected
    [   12.807540] xhci-hcd xhci-hcd.4.auto: xHCI Host Controller
    [   12.813209] xhci-hcd xhci-hcd.4.auto: new USB bus registered, assigned bus number 3
    [   12.822542] xhci-hcd xhci-hcd.4.auto: hcc params 0x0220f04c hci version 0x100 quirks 0x02010010
    [   12.831407] xhci-hcd xhci-hcd.4.auto: irq 190, io mem 0x488d0000
    [   12.837488] cpsw 48484000.ethernet eth0: Link is Up - 100Mbps/Full - flow control rx/tx
    [   12.837527] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
    [   12.863116] usb usb3: New USB device found, idVendor=1d6b, idProduct=0002
    [   12.870021] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1
    [   12.877348] usb usb3: Product: xHCI Host Controller
    [   12.897675] usb usb3: Manufacturer: Linux 4.14.79-ge669d52447 xhci-hcd
    [   12.904643] usb usb3: SerialNumber: xhci-hcd.4.auto
    [   12.910620] hub 3-0:1.0: USB hub found
    [   12.914734] hub 3-0:1.0: 1 port detected
    [   12.919082] xhci-hcd xhci-hcd.4.auto: xHCI Host Controller
    [   12.924608] xhci-hcd xhci-hcd.4.auto: new USB bus registered, assigned bus number 4
    [   12.932362] xhci-hcd xhci-hcd.4.auto: Host supports USB 3.0  SuperSpeed
    [   12.939143] usb usb4: We don't know the algorithms for LPM for this host, disabling LPM.
    [   12.948058] usb usb4: New USB device found, idVendor=1d6b, idProduct=0003
    [   12.954894] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1
    [   12.962205] usb usb4: Product: xHCI Host Controller
    [   12.967108] usb usb4: Manufacturer: Linux 4.14.79-ge669d52447 xhci-hcd
    [   12.973704] usb usb4: SerialNumber: xhci-hcd.4.auto
    [   12.979483] hub 4-0:1.0: USB hub found
    [   12.983295] hub 4-0:1.0: 1 port detected
    [   13.287519] usb 3-1: new high-speed USB device number 2 using xhci-hcd
    [   13.467829] usb 3-1: New USB device found, idVendor=0451, idProduct=8027
    [   13.474592] usb 3-1: New USB device strings: Mfr=0, Product=0, SerialNumber=1
    [   13.483497] usb 3-1: SerialNumber: 05020079913E
    [   13.515311] hub 3-1:1.0: USB hub found
    [   13.519230] hub 3-1:1.0: 2 ports detected
    
     _____                    _____           _         _   
    |  _  |___ ___ ___ ___   |  _  |___ ___  |_|___ ___| |_ 
    |     |  _| .'| . | . |  |   __|  _| . | | | -_|  _|  _|
    |__|__|_| |__,|_  |___|  |__|  |_| |___|_| |___|___|_|  
                  |___|                    |___|            
    
    Arago Project http://arago-project.org dra7xx-evm ttyS0
    
    Arago 2018.10 dra7xx-evm ttyS0
    
    dra7xx-evm login: ***************************************************************
    ***************************************************************
    

    and below log is run "dmabuftest"

    root@dra7xx-evm:~# dmabuftest --debug --fps 60 -s 35:1280x720 -c 1280x720@YUYV -d /dev/video0
    Opening Display..
    Enabling dynamic debug.
    Forcing playback rate at 60 fps.
    using 1 connectors, 720x400 display, multiplanar: 1
    Setting mode 1280x720 on connector 35, crtc 39
    Opening V4L2..
    [  179.290577] eSP876_enum_frame_size() +++ 
    [  179.295970] eSP876_enum_frame_size() fse->index : 0, min_width : 1280, min_height : 720
    [  179.304007] eSP876_enum_frame_size() --- 
    [  179.308285] eSP876_set_fmt() +++ 
    [  179.311641] eSP876_try_fmt_internal() +++ 
    [  179.316046] eSP876_try_fmt_internal(), fr : 2, fmt->width : 1280, fmt->height : 720 
    [  179.323853] eSP876_find_mode() +++ 
    [  179.327520] eSP876_find_mode() --- 
    [  179.331044] eSP876_try_fmt_internal(), find mode : 0, width : 1280, hight : 720 
    [  179.338617] eSP876_try_fmt_internal(), find format : 2 ,code : 8200 
    [  179.345022] eSP876_try_fmt_internal() --- 
    [  179.349350] eSP876_set_fmt(), pixel_rate : 500000 
    [  179.354178] eSP876_set_fmt() --- 
    Exported buffer fd = 6
    
    Exported buffer fd = 8
    
    Exported buffer fd = 10
    
    Exported buffer fd = 12
    
    Exported buffer fd = 14
    
    Exported buffer fd [  179.366792] eSP876_s_power() +++ 
    = 16
    
    [  179.374512] eSP876 4-0060: eSP876_s_ctrl: set_ctrl_white_balance() NOT IMPLEMENT!
    [  179.382755] eSP876 4-0060: eSP876_s_ctrl: set_ctrl_exposure() NOT IMPLEMENT!
    [  179.389863] eSP876 4-0060: eSP876_s_ctrl: set_ctrl_gain() NOT IMPLEMENT!
    [  179.396607] eSP876 4-0060: eSP876_s_ctrl: set_ctrl_saturation() NOT IMPLEMENT!
    [  179.403858] eSP876 4-0060: eSP876_s_ctrl: set_ctrl_hue() NOT IMPLEMENT!
    [  179.410525] eSP876 4-0060: eSP876_s_ctrl: set_ctrl_contrast() NOT IMPLEMENT!
    [  179.417694] eSP876 4-0060: eSP876_s_ctrl: set_ctrl_test_pattern() NOT IMPLEMENT!
    [  179.425118] eSP876 4-0060: eSP876_s_ctrl: set_ctrl_hflip() NOT IMPLEMENT!
    [  179.431977] eSP876 4-0060: eSP876_s_ctrl: set_ctrl_vflip() NOT IMPLEMENT!
    [  179.438806] eSP876 4-0060: eSP876_s_ctrl: set_ctrl_light_freq() NOT IMPLEMENT!
    [  179.446081] eSP876_s_power() --- 
    [  179.450606] eSP876_s_stream() +++ 
    [  179.454016] video_mode_switch() +++ 
    [  179.457636] switch mode to : 0 , enable : 1
    [  179.475772] got eSP876 response 0x81
    [  179.483002] After mode switch(Cmd start), polling 02
    [  179.522623] got eSP876 response 0x02
    [  179.526242] Cmd transfer finished, polling 0x00
    [  179.532205] 
    [  179.532205]  got eSP876 response 0x00
    [  179.537424] 
    [  179.537424]  open stream done
    [  179.541886] video_mode_switch() --- 
    [  179.545520] sensor->streaming : 1 
    [  179.548932] eSP876_s_stream() --- 
    [  179.831415] cal: CAL Registers @ 0x0x00000000489b0000:
    [  179.836620] 00000000: 40000300 a3c90469 00000000 00000000
    [  179.842045] 00000010: 00000004 00000000 00000000 00000000
    [  179.847508] 00000020: 00000000 00000000 00000000 00000000
    [  179.852928] 00000030: 00000000 00000000 00000001 00000001
    [  179.858382] 00000040: 00000000 00000000 00000001 00000001
    [  179.863801] 00000050: 00000000 00000000 00000000 00000000
    [  179.869254] 00000060: 00000000 00000000 00000000 00000000
    [  179.874672] 00000070: 00000000 00000000 00000000 00000000
    [  179.880121] 00000080: 00000000 00000000 00000000 00000000
    [  179.885567] 00000090: 00000000 00000000 00000000 00000000
    [  179.890984] 000000a0: 00000000 00000000 00000000 00000000
    [  179.896430] 000000b0: 00000000 00000000 00000000 00000000
    [  179.901849] 000000c0: 000d0015 00050014 00050014 00050014
    [  179.907296] 000000d0: 00000000 00000000 00000000 00000000
    [  179.912715] 000000e0: 00000000 00000000 00000000 00000000
    [  179.918162] 000000f0: 00000000 00000000 00000000 00000000
    [  179.923644] 00000100: ff1fe07e 00000000 00000000 00000000
    [  179.929080] 00000110: 00000000 00000000 00000000 00000000
    [  179.934497] 00000120: 00000000 00010000 00000000 00000000
    [  179.939944] 00000130: 08080000 00000000 00000000 00000000
    [  179.945362] 00000140: 00000000 00000000 00000000 00000000
    [  179.950794] 00000150: 00000000 00000000 00000000 00000000
    [  179.956244] 00000160: 00000000 00000000 00000000 00000000
    [  179.961664] 00000170: 00000000 00000000 00000000 00000000
    [  179.967111] 00000180: 00000000 00000000 00000000 00000000
    [  179.972530] 00000190: 00000000 00000000 00000000 00000000
    [  179.977974] 000001a0: 00000000 00000000 00000000 00000000
    [  179.983392] 000001b0: 00000000 00000000 00000000 00000000
    [  179.988827] 000001c0: 00000000 00000000 00000000 00000000
    [  179.994245] 000001d0: 00000000 00000000 00000000 00000000
    [  179.999690] 000001e0: 00000000 00000000 00000000 00000000
    [  180.005108] 000001f0: 00000000 00000000 00000000 00000000
    [  180.010553] 00000200: 0b404304 7f4f0000 00000a00 0a000000
    [  180.016006] 00000210: 00004000 00000000 00000000 00000000
    [  180.021424] 00000220: 00004000 00000000 00000000 00000000
    [  180.026927] 00000230: 00004000 00000000 00000000 00000000
    [  180.032346] 00000240: 00004000 00000000 00000000 00000000
    [  180.037803] 00000250: 00004000 00000000 00000000 00000000
    [  180.043220] 00000260: 00004000 00000000 00000000 00000000
    [  180.048654] 00000270: 00004000 00000000 00000000 00000000
    [  180.054073] 00000280: 00000000 00000000 00000000 00000000
    [  180.059525] 00000290: 00000000 00000000 00000000 00000000
    [  180.064943] 000002a0: 00000000 00000000 00000000 00000000
    [  180.070395] 000002b0: 00000000 00000000 00000000 00000000
    [  180.075840] 000002c0: 00000000 00000000 00000000 00000000
    [  180.081258] 000002d0: 00000000 00000000 00000000 00000000
    [  180.086715] 000002e0: 00000000 00000000 00000000 00000000
    [  180.092134] 000002f0: 00000000 00000000 00000000 00000000
    [  180.097569] 00000300: 00000001 4a000321 00000000 00000000
    [  180.102988] 00000310: 00000000 00004197 3f000000 00000000
    [  180.108431] 00000320: 00000000 00000000 00000000 00000000
    [  180.113850] 00000330: 00000101 00000000 00000000 00000000
    [  180.119284] 00000340: 00000000 00000000 00000000 00000000
    [  180.124703] 00000350: 00000000 00000000 00000000 00000000
    [  180.130212] 00000360: 00000000 00000000 00000000 00000000
    [  180.135647] 00000370: 00000000 00000000 00000000 00000000
    [  180.141064] 00000380: 00000000 00000000 00000000 00000000
    [  180.146519] 00000390: 00000000 00007fff 00000000 00000000
    [  180.151937] 000003a0: 00000000 00000000 00000000 00000000
    [  180.157383] 000003b0: 00000000 00000000 00000000 00000000
    [  180.162802] 000003c0: 00000000 00000000 00000000 00000000
    [  180.168235] 000003d0: 00000000 00000000 00000000 00000000
    [  180.173655] 000003e0: 00000000 00000000 00000000 00000000
    [  180.179108] 000003f0: 00000000 00000000 00000000 00000000
    [  180.184525] cal: CSI2 Core 0 Registers @ 0x00000000489b0800:
    [  180.190225] 00000000: 01000004 e002e10e 000000ff 0007c0a0
    [  180.195682] 00000010: 00000000 860a262c 020e4000 00000200
    [  180.201105] 00000020: 6bb80000 7e000000 00000000 00000000
    [  180.206560] 00000030: 00000000 00000000 00000000 00000000
    ^C[  230.238706] eSP876_s_stream() +++ 
    [  230.242124] video_mode_switch() +++ 
    [  230.245959] switch mode to : 0 , enable : 0
    [  230.265221] got eSP876 response 0x81
    [  230.270088] After mode switch(Cmd start), polling 02
    [  230.276522] got eSP876 response 0x02
    [  230.280107] Cmd transfer finished, polling 0x00
    [  230.286030] 
    [  230.286030]  got eSP876 response 0x00
    [  230.291799] 
    [  230.291799]  cloase stream done
    [  230.296527] video_mode_switch() --- 
    [  230.300112] sensor->streaming : 0 
    [  230.303522] eSP876_s_stream() --- 
    [  230.307005] eSP876_s_power() +++ 
    [  230.310328] eSP876_s_power() --- 
    
    root@dra7xx-evm:~# dmesg | grep cal
    [    0.000000] Booting Linux on physical CPU 0x0
    [    0.000000] Preemptible hierarchical RCU implementation.
    [    0.000842] Calibrating delay loop (skipped), value calculated using timer frequency.. 12.29 BogoMIPS (lpj=61475)
    [    0.059877] Hierarchical SRCU implementation.
    [    0.188322] random: get_random_u32 called from bucket_table_alloc+0x108/0x230 with crng_init=0
    [    5.665143] no physical memory specified
    [    8.243693] cal: ioresource cal_top at 0x00000000489b0000 - 0x00000000489b03ff
    [    8.243761] cal: got irq# 106
    [    8.243799] cal: ioresource cal_rx_core0 at 0x00000000489b0800 - 0x00000000489b083f
    [    8.243806] cal: ioresource cal_rx_core1 at 0x00000000489b0900 - 0x00000000489b093f
    [    8.243812] cal-000: Scanning Port node for csi2 port: 0
    [    8.250928] cal-000: port:0 inst:0 <reg>:0
    [    8.268759] cal-000: Scanning sub-device for csi2 port: 0
    [    8.268842] cal-000: Port:0 v4l2-endpoint: CSI2
    [    8.268844] cal-000: Virtual Channel=0
    [    8.268846] cal-000: flags=0x00000100
    [    8.268848] cal-000: clock_lane=0
    [    8.268851] cal-000: num_data_lanes=2
    [    8.268852] cal-000: data_lanes= <
    [    8.268854] cal-000:         1
    [    8.268856] cal-000:         2
    [    8.268857] cal-000:         >
    [    8.268859] cal-000: Port: 0 found sub-device eSP876
    [    8.268863] cal-000: Using sensor eSP876 4-0060 for capture
    [    8.268872] cal-000: subdev eSP876 4-0060: code: 4001 idx: 0
    [    8.268879] cal-000: subdev eSP876 4-0060: code: 2006 idx: 1
    [    8.268882] cal-000: matched fourcc: UYVY: code: 2006 idx: 0
    [    8.268888] cal-000: subdev eSP876 4-0060: code: 2008 idx: 2
    [    8.268891] cal-000: matched fourcc: YUYV: code: 2008 idx: 1
    [    8.268898] cal-000: subdev eSP876 4-0060: code: 1008 idx: 3
    [    8.268900] cal-000: matched fourcc: RGBP: code: 1008 idx: 2
    [    8.268906] cal-000: subdev eSP876 4-0060: code: 1007 idx: 4
    [    8.268908] cal-000: matched fourcc: RGBR: code: 1007 idx: 3
    [    8.269279] cal-000: V4L2 device registered as video0
    [    8.269312] cal-000: __subdev_get_format 1280x720 code:2008
    [    8.269315] cal-000: cal_calc_format_size: fourcc: YUYV size: 1280x720 bpl:2560 img_size:1843200
    [    8.269322] cal-001: Scanning Port node for csi2 port: 1
    [    8.269327] cal-001: port:0 inst:1 <reg>:0
    [    8.269331] cal-001: port:1 inst:1 <reg>:1
    [    8.269333] cal-001: Scanning sub-device for csi2 port: 1
    [    8.269335] cal-001: can't get next endpoint
    [    8.269381] cal: CAL_HL_REVISION = 0x40000300 (expecting 0x40000200)
    [    8.269384] cal: CAL_HL_HWINFO = 0xa3c90469 (expecting 0xA3C90469)
    [   12.213335] rpmsg_rpc virtio1.rpmsg-rpc.-1.101: probing service dce-callback with src 1024 dst 101
    [  179.308279] cal-000: cal_calc_format_size: fourcc: YUYV size: 1280x720 bpl:2560 img_size:1843200
    [  179.357566] cal-000: __subdev_set_format 1280x720 code:2008
    [  179.357571] cal-000: cal_calc_format_size: fourcc: YUYV size: 1280x720 bpl:2560 img_size:1843200
    [  179.357870] cal-000: nbuffers=6, size=1843200
    [  179.366776] cal-000: cal_start_streaming()
    [  179.366785] cal-000: sensor Pixel Rate: 21475336480
    [  179.366789] cal-000: sensor Pixel Rate: 21475336480
    [  179.449423] cal-000: CAL_CSI2_CTX0(1) = 0x00000101
    [  179.449428] cal-000: CAL_PIX_PROC(1) = 0x000d0015
    [  179.449433] cal-000: CAL_WR_DMA_CTRL(1) = 0x0b404304
    [  179.449437] cal-000: CAL_WR_DMA_OFST(1) = 0x00000a00
    [  179.449441] cal-000: CAL_WR_DMA_XSIZE(1) = 0x0a000000
    [  179.449445] cal-000: CAL_CTRL = 0xff1fe07e
    [  179.449449] cal-000: CAL_CSI2_COMPLEXIO_CFG(1) = 0x00000321
    [  179.449460] cal-000: CAL_CSI2_COMPLEXIO_CFG(1) = 0x40000321 De-assert Complex IO Reset
    [  179.449463] cal-000: csi2_ddrclk_khz: 2000
    [  179.449466] cal-000: ths_term: 0 (0x00)
    [  179.449469] cal-000: ths_settle: 4 (0x04)
    [  179.449473] cal-000: CSI2_0_REG0 = 0x01000004
    [  179.449478] cal-000: CSI2_0_REG1 = 0xe002e10e
    [  179.449483] cal-000: CAL_CSI2_TIMING(1) = 0x00004197 Stop States
    [  179.449487] cal-000: CAL_CSI2_TIMING(1) = 0x0000c197 Force RXMODE
    [  179.450603] cal-000: CAL_CSI2_COMPLEXIO_CFG(1) = 0x4a000321 Powered UP 
    [  179.831391] cal-000: CAL_CSI2_COMPLEXIO_CFG(1) = 0x4a000321 Complex IO Reset Done (250) (timeout)
    [  179.831400] cal-000: CAL_CSI2_TIMING(1) = 0x00004197 Stop State Reached 
    [  179.831407] cal-000: CSI2_0_REG1 = 0xe002e10e (Bit(31,28) should be set!)
    [  179.831415] cal: CAL Registers @ 0x0x00000000489b0000:
    [  180.184525] cal: CSI2 Core 0 Registers @ 0x00000000489b0800:
    [  230.238673] cal-000: cal_stop_streaming()
    [  230.238687] cal-000: CAL_CSI2_COMPLEXIO_CFG(1) = 0x40000321 Powered Down 
    [  230.238696] cal-000: CAL_CSI2_COMPLEXIO_CFG(1) = 0x00000321 Complex IO in Reset (0) 
    root@dra7xx-evm:~# 
    
    root@dra7xx-evm:~# v4l2-ctl --all
    Driver Info (not using libv4l2):
            Driver name   : cal
            Card type     : cal
            Bus info      : platform:cal-000
            Driver version: 4.14.79
            Capabilities  : 0x85200001
                    Video Capture
                    Read/Write
                    Streaming
                    Extended Pix Format
                    Device Capabilities
            Device Caps   : 0x05200001
                    Video Capture
                    Read/Write
                    Streaming
                    Extended Pix Format
    Priority: 2
    Video input : 0 (Camera 0: ok)
    Format Video Capture:
            Width/Height      : 1280/720
            Pixel Format      : 'YUYV'
            Field             : None
            Bytes per Line    : 2560
            Size Image        : 1843200
            Colorspace        : sRGB
            Transfer Function : sRGB
            YCbCr Encoding    : ITU-R 601
            Quantization      : Full Range
            Flags             : 
    
    User Controls
    
                           contrast (int)    : min=0 max=255 step=1 default=0 value=0 flags=slider
                         saturation (int)    : min=0 max=255 step=1 default=64 value=64 flags=slider
                                hue (int)    : min=0 max=359 step=1 default=0 value=0 flags=slider
            white_balance_automatic (bool)   : default=1 value=1 flags=update
                        red_balance (int)    : min=0 max=4095 step=1 default=0 value=0 flags=inactive, slider
                       blue_balance (int)    : min=0 max=4095 step=1 default=0 value=0 flags=inactive, slider
                           exposure (int)    : min=0 max=65535 step=1 default=0 value=0 flags=inactive, volatile
                     gain_automatic (bool)   : default=1 value=1 flags=update
                               gain (int)    : min=0 max=1023 step=1 default=0 value=0 flags=inactive, volatile
                    horizontal_flip (bool)   : default=0 value=0
                      vertical_flip (bool)   : default=0 value=0
               power_line_frequency (menu)   : min=0 max=3 default=1 value=1
    
    Camera Controls
    
                      auto_exposure (menu)   : min=0 max=1 default=0 value=0 flags=update
    
    Image Processing Controls
    
                     link_frequency (intmenu): min=0 max=0 default=0 value=0 flags=read-only
                         pixel_rate (int64)  : min=0 max=0 step=0 default=0 value=500000 flags=read-only
                       test_pattern (menu)   : min=0 max=1 default=0 value=0
    root@dra7xx-evm:~# 

  • Hi Experts,

    Any update?

  • Hi Expert,

    Any update? could you give me a hint why cal reports "cal-000: CAL_CSI2_COMPLEXIO_CFG(1) = 0x4a000321 Complex IO Reset Done (250) (timeout)" ?

    thanks.
  • ethan wu said:

    Any update? could you give me a hint why cal reports "cal-000: CAL_CSI2_COMPLEXIO_CFG(1) = 0x4a000321 Complex IO Reset Done (250) (timeout)" ?

    It means CAL is not able to receive a byte clock from the external device.

    Have you verified that something is being transmitted on the CSI-2 lanes, or even better, that they are valid CSI-2 transmissions with the expected rates?

     Tomi

  • Thank you for helping us.

    I will check the camera sensor whether it is output valid data.

    Thanks. 

  • Hi Ethan,

    Have you found anything new about this issue?

     Tomi