[libcamera-devel] gstreamer libcamerasrc to v4l2h264enc hardware encoder

[Xishan Sun]

>
> Could you run this with the following environment variable set please?
>
> LIBCAMERA_LOG_LEVELS=*:0


Let me put this part first, since I still need to learn how to do the
gstreamer debug.

[21:47:35.037907606] [23382] DEBUG Pipeline pipeline_handler.cpp:664
Registered pipeline handler "PipelineHandlerRPi"
[21:47:35.038069268] [23382] DEBUG IPAProxy ipa_proxy.cpp:280 Registered
proxy "IPAProxyLinux"
[21:47:35.038114360] [23382] DEBUG IPAProxy ipa_proxy.cpp:280 Registered
proxy "IPAProxyThread"
Setting pipeline to PAUSED ...
[21:47:35.066294301] [23382] DEBUG IPAModule ipa_module.cpp:330 ipa_rpi.so:
IPA module /usr/local/lib/arm-linux-gnueabihf/libcamera/ipa_rpi.so is signed
[21:47:35.066534036] [23382] DEBUG IPAManager ipa_manager.cpp:238 Loaded
IPA module '/usr/local/lib/arm-linux-gnueabihf/libcamera/ipa_rpi.so'
[21:47:35.066611830] [23382]  INFO Camera camera_manager.cpp:280 libcamera
v0.0.0+1-96fab38e-dirty
[21:47:35.066840140] [23383] DEBUG Camera camera_manager.cpp:102 Starting
camera manager
[21:47:35.067216316] [23383] DEBUG DeviceEnumerator
device_enumerator.cpp:223 New media device "bcm2835-isp" created from
/dev/media0
[21:47:35.067544659] [23383] DEBUG DeviceEnumerator
device_enumerator.cpp:241 Added device /dev/media0: bcm2835-isp
[21:47:35.067848096] [23383] DEBUG DeviceEnumerator
device_enumerator.cpp:223 New media device "bcm2835-codec" created from
/dev/media1
[21:47:35.068222902] [23383] DEBUG DeviceEnumerator
device_enumerator.cpp:241 Added device /dev/media1: bcm2835-codec
[21:47:35.068377935] [23383] DEBUG DeviceEnumerator
device_enumerator.cpp:223 New media device "unicam" created from /dev/media2
[21:47:35.068608485] [23383] DEBUG DeviceEnumerator
device_enumerator.cpp:241 Added device /dev/media2: unicam
[21:47:35.068746204] [23383] DEBUG DeviceEnumerator
device_enumerator.cpp:298 Successful match for media device "unicam"
[21:47:35.068797499] [23383] DEBUG DeviceEnumerator
device_enumerator.cpp:298 Successful match for media device "bcm2835-isp"
[21:47:35.069326616] [23383] DEBUG V4L2 v4l2_videodevice.cpp:567
/dev/video0[cap]: Opened device platform:unicam fe801000.csi: unicam: unicam
[21:47:35.069431724] [23383] DEBUG V4L2 v4l2_videodevice.cpp:567
/dev/video1[cap]: Opened device platform:unicam fe801000.csi: unicam: unicam
[21:47:35.069803030] [23383] DEBUG V4L2 v4l2_videodevice.cpp:567
/dev/video13[out]: Opened device platform:bcm2835-isp: bcm2835-isp:
bcm2835-isp
[21:47:35.069885676] [23383] DEBUG V4L2 v4l2_videodevice.cpp:567
/dev/video14[cap]: Opened device platform:bcm2835-isp: bcm2835-isp:
bcm2835-isp
[21:47:35.069964674] [23383] DEBUG V4L2 v4l2_videodevice.cpp:567
/dev/video15[cap]: Opened device platform:bcm2835-isp: bcm2835-isp:
bcm2835-isp
[21:47:35.070105615] [23383] DEBUG V4L2 v4l2_videodevice.cpp:567
/dev/video16[cap]: Opened device platform:bcm2835-isp: bcm2835-isp:
bcm2835-isp
[21:47:35.155269238] [23383] DEBUG IPAManager ipa_manager.cpp:316 IPA
module /usr/local/lib/arm-linux-gnueabihf/libcamera/ipa_rpi.so signature is
valid
[21:47:35.159059609] [23383] DEBUG Camera camera_manager.cpp:144 Pipeline
handler "PipelineHandlerRPi" matched
Pipeline is live and does not need PREROLL ...
[21:47:35.161101003] [23385]  WARN V4L2 v4l2_pixelformat.cpp:177
Unsupported V4L2 pixel format YU12
Setting pipeline to PLAYING ...
[21:47:35.161209427] [23385]  WARN V4L2 v4l2_pixelformat.cpp:177
Unsupported V4L2 pixel format YV12
[21:47:35.161277240] [23385]  WARN V4L2 v4l2_pixelformat.cpp:177
Unsupported V4L2 pixel format RGBP
New clock: GstSystemClock
[21:47:35.161827912] [23385] DEBUG Camera camera.cpp:715 streams
configuration: (0) 1920x1080-0x3231564e
[21:47:35.165740816] [23385]  INFO Camera camera.cpp:770 configuring
streams: (0) 1600x1200-0x3132564e
[21:47:35.166021587] [23383]  INFO RPI raspberrypi.cpp:115 Mode: 1600x1200
fmt BG10 Score: 1500 (best 1500)
[21:47:35.166095381] [23383]  INFO RPI raspberrypi.cpp:115 Mode: 1280x720
fmt BG10 Score: 3266.67 (best 1500)
[21:47:35.166148176] [23383]  INFO RPI raspberrypi.cpp:115 Mode: 1600x1200
fmt BA81 Score: 2500 (best 1500)
[21:47:35.166193638] [23383]  INFO RPI raspberrypi.cpp:115 Mode: 1280x720
fmt BA81 Score: 4266.67 (best 1500)
[21:47:35.166243915] [23383]  INFO RPI raspberrypi.cpp:115 Mode: 1600x1200
fmt pBAA Score: 1000 (best 1000)
[21:47:35.166287877] [23383]  INFO RPI raspberrypi.cpp:115 Mode: 1280x720
fmt pBAA Score: 2766.67 (best 1000)
[21:47:35.166349838] [23383]  INFO RPI raspberrypi.cpp:639 Sensor: og02b10
- Selected mode: 1600x1200-pBAA
[21:47:35.167042229] [23383] DEBUG RPI raspberrypi.cpp:726 Setting embedded
data format.
[21:47:35.168514952] [23383]  INFO RPI_S_W staggered_ctrl.cpp:36 Init ctrl
0x00980911 with delay 2
[21:47:35.168591746] [23383]  INFO RPI_S_W staggered_ctrl.cpp:36 Init ctrl
0x009e0903 with delay 2
[21:47:35.228661723] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:104 Setting
ctrl 0x00980911 to 1769 at index 0
[21:47:35.228767647] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:104 Setting
ctrl 0x009e0903 to 1 at index 0
[21:47:35.229350151] [23385] ERROR Allocator framebuffer_allocator.cpp:97
Stream is not part of og02b10 active configuration
[21:47:35.235707033] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1104
/dev/video14[cap]: 4 buffers requested.
[21:47:35.235968582] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1104
/dev/video14[cap]: 0 buffers requested.
[21:47:35.236153837] [23385] ERROR Allocator framebuffer_allocator.cpp:97
Stream is not part of og02b10 active configuration
[21:47:35.236215205] [23385] ERROR Allocator framebuffer_allocator.cpp:97
Stream is not part of og02b10 active configuration
[21:47:35.236510920] [23385] DEBUG Camera camera.cpp:903 Starting capture
[21:47:35.242417091] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1104
/dev/video0[cap]: 4 buffers requested.
[21:47:35.242836821] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1104
/dev/video1[cap]: 4 buffers requested.
[21:47:35.243287033] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1104
/dev/video13[out]: 4 buffers requested.
[21:47:35.243338939] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1317
/dev/video13[out]: Prepared to import 4 buffers
[21:47:35.243593914] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1104
/dev/video14[cap]: 4 buffers requested.
[21:47:35.243641320] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1317
/dev/video14[cap]: Prepared to import 4 buffers
[21:47:35.249736468] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1104
/dev/video15[cap]: 4 buffers requested.
[21:47:35.250391285] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1104
/dev/video16[cap]: 4 buffers requested.
[21:47:35.251092472] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video0[cap]: Queueing buffer 0
[21:47:35.251205173] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video0[cap]: Queueing buffer 1
[21:47:35.251266930] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video0[cap]: Queueing buffer 2
[21:47:35.251321744] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video0[cap]: Queueing buffer 3
[21:47:35.251376835] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video1[cap]: Queueing buffer 0
[21:47:35.251438037] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video1[cap]: Queueing buffer 1
[21:47:35.251491666] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video1[cap]: Queueing buffer 2
[21:47:35.251544164] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video1[cap]: Queueing buffer 3
[21:47:35.251598848] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video15[cap]: Queueing buffer 0
[21:47:35.251670069] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video15[cap]: Queueing buffer 1
[21:47:35.251729308] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video15[cap]: Queueing buffer 2
[21:47:35.251788103] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video15[cap]: Queueing buffer 3
[21:47:35.251845435] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video16[cap]: Queueing buffer 0
[21:47:35.251907563] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video16[cap]: Queueing buffer 1
[21:47:35.251965654] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video16[cap]: Queueing buffer 2
[21:47:35.252023875] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video16[cap]: Queueing buffer 3
[21:47:35.252347941] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:127 Writing
ctrl 0x009e0903 to 1 at index 0
[21:47:35.252408976] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:127 Writing
ctrl 0x00980911 to 1769 at index 0
[21:47:35.252448050] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:164 Next
frame, set index is 1
[21:47:35.339856933] [23383] DEBUG RPI raspberrypi.cpp:1133 frame start 0
[21:47:35.339938153] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:164 Next
frame, set index is 2
[21:47:35.353875220] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video0[cap]: Dequeuing buffer 0
[21:47:35.353957792] [23383] DEBUG RPI raspberrypi.cpp:1267 Stream Unicam
Image buffer dequeue, buffer id 0, timestamp: 78455339794000
[21:47:35.354032827] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video1[cap]: Dequeuing buffer 0
[21:47:35.354086270] [23383] DEBUG RPI raspberrypi.cpp:1267 Stream Unicam
Embedded buffer dequeue, buffer id 0, timestamp: 78455339794000
[21:47:35.354149102] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:150 Getting
ctrl 0x009e0903 to 1 at index 0
[21:47:35.354197286] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:150 Getting
ctrl 0x00980911 to 1769 at index 0
[21:47:35.354390818] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video14[cap]: Queueing buffer 0
[21:47:35.354612239] [23383] DEBUG RPI raspberrypi.cpp:1560 Signalling
RPI_IPA_EVENT_SIGNAL_ISP_PREPARE: Bayer buffer id: 0 Embedded buffer id: 0
[21:47:35.354902287] [23384] DEBUG IPARPI raspberrypi.cpp:745 Metadata -
Exposure : 19989.7 Gain : 1
[21:47:35.355379516] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video1[cap]: Queueing buffer 0
[21:47:35.356004038] [23384] DEBUG IPARPI raspberrypi.cpp:784 Applying WB
R: 1.27095 B: 1.47244
[21:47:35.357684627] [23383] DEBUG RPI raspberrypi.cpp:1232 Input re-queue
to ISP, buffer id 0, timestamp: 78455339794000
[21:47:35.357769514] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video13[out]: Queueing buffer 0
[21:47:35.368626322] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video13[out]: Dequeuing buffer 0
[21:47:35.368710431] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video0[cap]: Queueing buffer 0
[21:47:35.368781948] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video14[cap]: Dequeuing buffer 0
[21:47:35.368841799] [23383] DEBUG RPI raspberrypi.cpp:1328 Stream ISP
Output0 buffer complete, buffer id 0, timestamp: 78455339794000
[21:47:35.368902816] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video15[cap]: Dequeuing buffer 0
[21:47:35.368953481] [23383] DEBUG RPI raspberrypi.cpp:1328 Stream ISP
Output1 buffer complete, buffer id 0, timestamp: 78455339794000
[21:47:35.369005184] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video15[cap]: Queueing buffer 0
[21:47:35.369077219] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video16[cap]: Dequeuing buffer 0
[21:47:35.369133403] [23383] DEBUG RPI raspberrypi.cpp:1328 Stream ISP
Stats buffer complete, buffer id 0, timestamp: 78455339794000
[21:47:35.369184901] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video16[cap]: Queueing buffer 0
[21:47:35.369618761] [23383]  INFO RPI raspberrypi.cpp:1481 Dropping frame
at the request of the IPA
[21:47:35.373184859] [23383] DEBUG RPI raspberrypi.cpp:1133 frame start 1
[21:47:35.373244339] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:164 Next
frame, set index is 3
[21:47:35.387206072] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video0[cap]: Dequeuing buffer 1
[21:47:35.387279570] [23383] DEBUG RPI raspberrypi.cpp:1267 Stream Unicam
Image buffer dequeue, buffer id 1, timestamp: 78455373128000
[21:47:35.387350661] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video1[cap]: Dequeuing buffer 1
[21:47:35.387402956] [23383] DEBUG RPI raspberrypi.cpp:1267 Stream Unicam
Embedded buffer dequeue, buffer id 1, timestamp: 78455373128000
[21:47:35.387463325] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:150 Getting
ctrl 0x009e0903 to 1 at index 0
[21:47:35.387511268] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:150 Getting
ctrl 0x00980911 to 1769 at index 0
[21:47:35.387763448] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video14[cap]: Queueing buffer 0
[21:47:35.387867963] [23383] DEBUG RPI raspberrypi.cpp:1560 Signalling
RPI_IPA_EVENT_SIGNAL_ISP_PREPARE: Bayer buffer id: 1 Embedded buffer id: 1
[21:47:35.387999016] [23384] DEBUG IPARPI raspberrypi.cpp:745 Metadata -
Exposure : 19989.7 Gain : 1
[21:47:35.388345748] [23384] DEBUG IPARPI raspberrypi.cpp:784 Applying WB
R: 1.27095 B: 1.47244
[21:47:35.388624223] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video1[cap]: Queueing buffer 1
[21:47:35.389352001] [23383] DEBUG RPI raspberrypi.cpp:1232 Input re-queue
to ISP, buffer id 1, timestamp: 78455373128000
[21:47:35.389652624] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video13[out]: Queueing buffer 1
[21:47:35.400533710] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video13[out]: Dequeuing buffer 1
[21:47:35.400817425] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video0[cap]: Queueing buffer 1
[21:47:35.401067067] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video14[cap]: Dequeuing buffer 0
[21:47:35.401292524] [23383] DEBUG RPI raspberrypi.cpp:1328 Stream ISP
Output0 buffer complete, buffer id 0, timestamp: 78455373128000
[21:47:35.401556611] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video15[cap]: Dequeuing buffer 1
[21:47:35.401799697] [23383] DEBUG RPI raspberrypi.cpp:1328 Stream ISP
Output1 buffer complete, buffer id 0, timestamp: 78455373128000
[21:47:35.402031358] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video15[cap]: Queueing buffer 1
[21:47:35.402283778] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video16[cap]: Dequeuing buffer 1
[21:47:35.402519013] [23383] DEBUG RPI raspberrypi.cpp:1328 Stream ISP
Stats buffer complete, buffer id 1, timestamp: 78455373128000
[21:47:35.402748970] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video16[cap]: Queueing buffer 1
[21:47:35.403232607] [23383]  INFO RPI raspberrypi.cpp:1481 Dropping frame
at the request of the IPA
[21:47:35.406519286] [23383] DEBUG RPI raspberrypi.cpp:1133 frame start 2
[21:47:35.406753354] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:164 Next
frame, set index is 4
[21:47:35.420543499] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video0[cap]: Dequeuing buffer 2
[21:47:35.420791085] [23383] DEBUG RPI raspberrypi.cpp:1267 Stream Unicam
Image buffer dequeue, buffer id 2, timestamp: 78455406464000
[21:47:35.421034394] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video1[cap]: Dequeuing buffer 2
[21:47:35.421258722] [23383] DEBUG RPI raspberrypi.cpp:1267 Stream Unicam
Embedded buffer dequeue, buffer id 2, timestamp: 78455406464000
[21:47:35.421491049] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:150 Getting
ctrl 0x009e0903 to 1 at index 1
[21:47:35.421707581] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:150 Getting
ctrl 0x00980911 to 1769 at index 1
[21:47:35.422054128] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video14[cap]: Queueing buffer 0
[21:47:35.422348251] [23383] DEBUG RPI raspberrypi.cpp:1560 Signalling
RPI_IPA_EVENT_SIGNAL_ISP_PREPARE: Bayer buffer id: 2 Embedded buffer id: 2
[21:47:35.422660021] [23384] DEBUG IPARPI raspberrypi.cpp:745 Metadata -
Exposure : 19989.7 Gain : 1
[21:47:35.422928125] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video1[cap]: Queueing buffer 2
[21:47:35.422943699] [23384] DEBUG IPARPI raspberrypi.cpp:784 Applying WB
R: 1.27095 B: 1.47244
[21:47:35.424153281] [23383] DEBUG RPI raspberrypi.cpp:1232 Input re-queue
to ISP, buffer id 2, timestamp: 78455406464000
[21:47:35.424449773] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video13[out]: Queueing buffer 2
[21:47:35.435355785] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video13[out]: Dequeuing buffer 2
[21:47:35.435628389] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video0[cap]: Queueing buffer 2
[21:47:35.435872698] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video14[cap]: Dequeuing buffer 0
[21:47:35.436100100] [23383] DEBUG RPI raspberrypi.cpp:1328 Stream ISP
Output0 buffer complete, buffer id 0, timestamp: 78455406464000
[21:47:35.436335353] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video15[cap]: Dequeuing buffer 2
[21:47:35.436557978] [23383] DEBUG RPI raspberrypi.cpp:1328 Stream ISP
Output1 buffer complete, buffer id 0, timestamp: 78455406464000
[21:47:35.436784380] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video15[cap]: Queueing buffer 2
[21:47:35.437039058] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video16[cap]: Dequeuing buffer 2
[21:47:35.437267405] [23383] DEBUG RPI raspberrypi.cpp:1328 Stream ISP
Stats buffer complete, buffer id 2, timestamp: 78455406464000
[21:47:35.437492918] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video16[cap]: Queueing buffer 2
[21:47:35.438531892] [23384] DEBUG IPARPI raspberrypi.cpp:811 Applying AGC
Exposure: 5017.02 (Shutter lines: 443) Gain: 1 (Gain Code: 1)
[21:47:35.438897106] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:104 Setting
ctrl 0x00980911 to 443 at index 4
[21:47:35.439176210] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:104 Setting
ctrl 0x009e0903 to 1 at index 4
[21:47:35.439453203] [23383]  INFO RPI raspberrypi.cpp:1481 Dropping frame
at the request of the IPA
[21:47:35.439855230] [23383] DEBUG RPI raspberrypi.cpp:1133 frame start 3
[21:47:35.440136835] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:127 Writing
ctrl 0x009e0903 to 1 at index 4
[21:47:35.440368199] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:127 Writing
ctrl 0x00980911 to 443 at index 4
[21:47:35.440571731] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:164 Next
frame, set index is 5
[21:47:35.453916017] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video0[cap]: Dequeuing buffer 3
[21:47:35.454263082] [23383] DEBUG RPI raspberrypi.cpp:1267 Stream Unicam
Image buffer dequeue, buffer id 3, timestamp: 78455439799000
[21:47:35.454523668] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video1[cap]: Dequeuing buffer 3
[21:47:35.454760126] [23383] DEBUG RPI raspberrypi.cpp:1267 Stream Unicam
Embedded buffer dequeue, buffer id 3, timestamp: 78455439799000
[21:47:35.454998231] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:150 Getting
ctrl 0x009e0903 to 1 at index 2
[21:47:35.455213874] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:150 Getting
ctrl 0x00980911 to 1769 at index 2
[21:47:35.455588587] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video14[cap]: Queueing buffer 0
[21:47:35.455900524] [23383] DEBUG RPI raspberrypi.cpp:1560 Signalling
RPI_IPA_EVENT_SIGNAL_ISP_PREPARE: Bayer buffer id: 3 Embedded buffer id: 3
[21:47:35.456230330] [23384] DEBUG IPARPI raspberrypi.cpp:745 Metadata -
Exposure : 19989.7 Gain : 1
[21:47:35.456507583] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video1[cap]: Queueing buffer 3
[21:47:35.456555582] [23384] DEBUG IPARPI raspberrypi.cpp:784 Applying WB
R: 1.68369 B: 1.18478
[21:47:35.458030823] [23383] DEBUG RPI raspberrypi.cpp:1232 Input re-queue
to ISP, buffer id 3, timestamp: 78455439799000
[21:47:35.458330946] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video13[out]: Queueing buffer 3
[21:47:35.469276401] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video13[out]: Dequeuing buffer 3
[21:47:35.469554672] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video0[cap]: Queueing buffer 3
[21:47:35.469796999] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video14[cap]: Dequeuing buffer 0
[21:47:35.470047122] [23383] DEBUG RPI raspberrypi.cpp:1328 Stream ISP
Output0 buffer complete, buffer id 0, timestamp: 78455439799000
[21:47:35.470286191] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video15[cap]: Dequeuing buffer 3
[21:47:35.470506556] [23383] DEBUG RPI raspberrypi.cpp:1328 Stream ISP
Output1 buffer complete, buffer id 0, timestamp: 78455439799000
[21:47:35.470731995] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video15[cap]: Queueing buffer 3
[21:47:35.470981229] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video16[cap]: Dequeuing buffer 3
[21:47:35.471219779] [23383] DEBUG RPI raspberrypi.cpp:1328 Stream ISP
Stats buffer complete, buffer id 3, timestamp: 78455439799000
[21:47:35.471442570] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video16[cap]: Queueing buffer 3
[21:47:35.472044018] [23384] DEBUG IPARPI raspberrypi.cpp:811 Applying AGC
Exposure: 5017.02 (Shutter lines: 443) Gain: 1 (Gain Code: 1)
[21:47:35.472371603] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:104 Setting
ctrl 0x00980911 to 443 at index 5
[21:47:35.472634467] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:104 Setting
ctrl 0x009e0903 to 1 at index 5
[21:47:35.472900905] [23383]  INFO RPI raspberrypi.cpp:1481 Dropping frame
at the request of the IPA
[21:47:35.473189916] [23383] DEBUG RPI raspberrypi.cpp:1133 frame start 4
[21:47:35.473423077] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:127 Writing
ctrl 0x009e0903 to 1 at index 5
[21:47:35.473649405] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:127 Writing
ctrl 0x00980911 to 443 at index 5
[21:47:35.473848252] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:164 Next
frame, set index is 6
[21:47:35.487215962] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video0[cap]: Dequeuing buffer 0
[21:47:35.487473012] [23383] DEBUG RPI raspberrypi.cpp:1267 Stream Unicam
Image buffer dequeue, buffer id 0, timestamp: 78455473134000
[21:47:35.487715617] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video1[cap]: Dequeuing buffer 0
[21:47:35.487937408] [23383] DEBUG RPI raspberrypi.cpp:1267 Stream Unicam
Embedded buffer dequeue, buffer id 0, timestamp: 78455473134000
[21:47:35.488169976] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:150 Getting
ctrl 0x009e0903 to 1 at index 3
[21:47:35.488381360] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:150 Getting
ctrl 0x00980911 to 1769 at index 3
[21:47:35.488729481] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video14[cap]: Queueing buffer 0
[21:47:35.489024233] [23383] DEBUG RPI raspberrypi.cpp:1560 Signalling
RPI_IPA_EVENT_SIGNAL_ISP_PREPARE: Bayer buffer id: 0 Embedded buffer id: 0
[21:47:35.489335133] [23384] DEBUG IPARPI raspberrypi.cpp:745 Metadata -
Exposure : 19989.7 Gain : 1
[21:47:35.489600441] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video1[cap]: Queueing buffer 0
[21:47:35.489632514] [23384] DEBUG IPARPI raspberrypi.cpp:784 Applying WB
R: 1.68369 B: 1.18478
[21:47:35.490870503] [23383] DEBUG RPI raspberrypi.cpp:1232 Input re-queue
to ISP, buffer id 0, timestamp: 78455473134000
[21:47:35.491173606] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video13[out]: Queueing buffer 0
[21:47:35.501972435] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video13[out]: Dequeuing buffer 0
[21:47:35.502242373] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video0[cap]: Queueing buffer 0
[21:47:35.502501848] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video14[cap]: Dequeuing buffer 0
[21:47:35.502740046] [23383] DEBUG RPI raspberrypi.cpp:1328 Stream ISP
Output0 buffer complete, buffer id 0, timestamp: 78455473134000
[21:47:35.503015410] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video15[cap]: Dequeuing buffer 0
[21:47:35.503235108] [23383] DEBUG RPI raspberrypi.cpp:1328 Stream ISP
Output1 buffer complete, buffer id 0, timestamp: 78455473134000
[21:47:35.503461343] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video15[cap]: Queueing buffer 0
[21:47:35.503707522] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video16[cap]: Dequeuing buffer 0
[21:47:35.503926313] [23383] DEBUG RPI raspberrypi.cpp:1328 Stream ISP
Stats buffer complete, buffer id 0, timestamp: 78455473134000
[21:47:35.504149049] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video16[cap]: Queueing buffer 0
[21:47:35.504769163] [23384] DEBUG IPARPI raspberrypi.cpp:811 Applying AGC
Exposure: 5017.02 (Shutter lines: 443) Gain: 1 (Gain Code: 1)
[21:47:35.505091711] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:104 Setting
ctrl 0x00980911 to 443 at index 6
[21:47:35.505353038] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:104 Setting
ctrl 0x009e0903 to 1 at index 6
[21:47:35.505629420] [23383]  INFO RPI raspberrypi.cpp:1481 Dropping frame
at the request of the IPA
[21:47:35.506524379] [23383] DEBUG RPI raspberrypi.cpp:1133 frame start 5
[21:47:35.506764040] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:127 Writing
ctrl 0x009e0903 to 1 at index 6
[21:47:35.506980591] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:127 Writing
ctrl 0x00980911 to 443 at index 6
[21:47:35.507180419] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:164 Next
frame, set index is 7
[21:47:35.520553852] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video0[cap]: Dequeuing buffer 1
[21:47:35.520801345] [23383] DEBUG RPI raspberrypi.cpp:1267 Stream Unicam
Image buffer dequeue, buffer id 1, timestamp: 78455506470000
[21:47:35.521040932] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video1[cap]: Dequeuing buffer 1
[21:47:35.521270408] [23383] DEBUG RPI raspberrypi.cpp:1267 Stream Unicam
Embedded buffer dequeue, buffer id 1, timestamp: 78455506470000
[21:47:35.521501310] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:150 Getting
ctrl 0x009e0903 to 1 at index 4
[21:47:35.521716508] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:150 Getting
ctrl 0x00980911 to 443 at index 4
[21:47:35.522066759] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video14[cap]: Queueing buffer 0
[21:47:35.522374863] [23383] DEBUG RPI raspberrypi.cpp:1560 Signalling
RPI_IPA_EVENT_SIGNAL_ISP_PREPARE: Bayer buffer id: 1 Embedded buffer id: 1
[21:47:35.522683355] [23384] DEBUG IPARPI raspberrypi.cpp:745 Metadata -
Exposure : 5005.9 Gain : 1
[21:47:35.522949626] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video1[cap]: Queueing buffer 1
[21:47:35.522975996] [23384] DEBUG IPARPI raspberrypi.cpp:784 Applying WB
R: 1.68369 B: 1.18478
[21:47:35.524248965] [23383] DEBUG RPI raspberrypi.cpp:1232 Input re-queue
to ISP, buffer id 1, timestamp: 78455506470000
[21:47:35.524545050] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video13[out]: Queueing buffer 1
[21:47:35.535312028] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video13[out]: Dequeuing buffer 1
[21:47:35.535576022] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video0[cap]: Queueing buffer 1
[21:47:35.535828423] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video14[cap]: Dequeuing buffer 0
[21:47:35.536064121] [23383] DEBUG RPI raspberrypi.cpp:1328 Stream ISP
Output0 buffer complete, buffer id 0, timestamp: 78455506470000
[21:47:35.536296708] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video15[cap]: Dequeuing buffer 1
[21:47:35.536524998] [23383] DEBUG RPI raspberrypi.cpp:1328 Stream ISP
Output1 buffer complete, buffer id 0, timestamp: 78455506470000
[21:47:35.536751104] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video15[cap]: Queueing buffer 1
[21:47:35.537005820] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video16[cap]: Dequeuing buffer 1
[21:47:35.537227296] [23383] DEBUG RPI raspberrypi.cpp:1328 Stream ISP
Stats buffer complete, buffer id 1, timestamp: 78455506470000
[21:47:35.537447624] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video16[cap]: Queueing buffer 1
[21:47:35.538033443] [23384] DEBUG IPARPI raspberrypi.cpp:811 Applying AGC
Exposure: 1256.38 (Shutter lines: 111) Gain: 1 (Gain Code: 1)
[21:47:35.538366472] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:104 Setting
ctrl 0x00980911 to 111 at index 7
[21:47:35.538632706] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:104 Setting
ctrl 0x009e0903 to 1 at index 7
[21:47:35.538906144] [23383]  INFO RPI raspberrypi.cpp:1481 Dropping frame
at the request of the IPA
[21:47:35.539857676] [23383] DEBUG RPI raspberrypi.cpp:1133 frame start 6
[21:47:35.540136355] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:127 Writing
ctrl 0x009e0903 to 1 at index 7
[21:47:35.540361682] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:127 Writing
ctrl 0x00980911 to 111 at index 7
[21:47:35.540560881] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:164 Next
frame, set index is 8
[21:47:35.553923796] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video0[cap]: Dequeuing buffer 2
[21:47:35.554265361] [23383] DEBUG RPI raspberrypi.cpp:1267 Stream Unicam
Image buffer dequeue, buffer id 2, timestamp: 78455539805000
[21:47:35.554523929] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video1[cap]: Dequeuing buffer 2
[21:47:35.554748998] [23383] DEBUG RPI raspberrypi.cpp:1267 Stream Unicam
Embedded buffer dequeue, buffer id 2, timestamp: 78455539805000
[21:47:35.554995344] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:150 Getting
ctrl 0x009e0903 to 1 at index 5
[21:47:35.555213209] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:150 Getting
ctrl 0x00980911 to 443 at index 5
[21:47:35.555577255] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video14[cap]: Queueing buffer 0
[21:47:35.555882600] [23383] DEBUG RPI raspberrypi.cpp:1560 Signalling
RPI_IPA_EVENT_SIGNAL_ISP_PREPARE: Bayer buffer id: 2 Embedded buffer id: 2
[21:47:35.556199407] [23384] DEBUG IPARPI raspberrypi.cpp:745 Metadata -
Exposure : 5005.9 Gain : 1
[21:47:35.556470141] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video1[cap]: Queueing buffer 2
[21:47:35.556507436] [23384] DEBUG IPARPI raspberrypi.cpp:784 Applying WB
R: 1.68369 B: 1.18478
[21:47:35.557788553] [23383] DEBUG RPI raspberrypi.cpp:1232 Input re-queue
to ISP, buffer id 2, timestamp: 78455539805000
[21:47:35.558087249] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video13[out]: Queueing buffer 2
[21:47:35.568898930] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video13[out]: Dequeuing buffer 2
[21:47:35.569174590] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video0[cap]: Queueing buffer 2
[21:47:35.569421491] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video14[cap]: Dequeuing buffer 0
[21:47:35.569652652] [23383] DEBUG RPI raspberrypi.cpp:1328 Stream ISP
Output0 buffer complete, buffer id 0, timestamp: 78455539805000
[21:47:35.569905553] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video15[cap]: Dequeuing buffer 2
[21:47:35.570152455] [23383] DEBUG RPI raspberrypi.cpp:1328 Stream ISP
Output1 buffer complete, buffer id 0, timestamp: 78455539805000
[21:47:35.570382727] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video15[cap]: Queueing buffer 2
[21:47:35.570644480] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video16[cap]: Dequeuing buffer 2
[21:47:35.570868326] [23383] DEBUG RPI raspberrypi.cpp:1328 Stream ISP
Stats buffer complete, buffer id 2, timestamp: 78455539805000
[21:47:35.571093969] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video16[cap]: Queueing buffer 2
[21:47:35.571684991] [23384] DEBUG IPARPI raspberrypi.cpp:811 Applying AGC
Exposure: 1256.38 (Shutter lines: 111) Gain: 1 (Gain Code: 1)
[21:47:35.572010891] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:104 Setting
ctrl 0x00980911 to 111 at index 8
[21:47:35.572276532] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:104 Setting
ctrl 0x009e0903 to 1 at index 8
[21:47:35.573211621] [23383] DEBUG RPI raspberrypi.cpp:1133 frame start 7
[21:47:35.573548613] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:127 Writing
ctrl 0x009e0903 to 1 at index 8
[21:47:35.573776292] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:127 Writing
ctrl 0x00980911 to 111 at index 8
[21:47:35.573992602] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:164 Next
frame, set index is 9
[21:47:35.587223278] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video0[cap]: Dequeuing buffer 3
[21:47:35.587486031] [23383] DEBUG RPI raspberrypi.cpp:1267 Stream Unicam
Image buffer dequeue, buffer id 3, timestamp: 78455573142000
[21:47:35.587731766] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video1[cap]: Dequeuing buffer 3
[21:47:35.587952205] [23383] DEBUG RPI raspberrypi.cpp:1267 Stream Unicam
Embedded buffer dequeue, buffer id 3, timestamp: 78455573142000
[21:47:35.588182922] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:150 Getting
ctrl 0x009e0903 to 1 at index 6
[21:47:35.588408064] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:150 Getting
ctrl 0x00980911 to 443 at index 6
[21:47:35.588761259] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video14[cap]: Queueing buffer 1
[21:47:35.589180897] [23383] DEBUG RPI raspberrypi.cpp:1560 Signalling
RPI_IPA_EVENT_SIGNAL_ISP_PREPARE: Bayer buffer id: 3 Embedded buffer id: 3
[21:47:35.589523741] [23384] DEBUG IPARPI raspberrypi.cpp:745 Metadata -
Exposure : 5005.9 Gain : 1
[21:47:35.589796493] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video1[cap]: Queueing buffer 3
[21:47:35.589824548] [23384] DEBUG IPARPI raspberrypi.cpp:784 Applying WB
R: 1.68369 B: 1.18478
[21:47:35.591072907] [23383] DEBUG RPI raspberrypi.cpp:1232 Input re-queue
to ISP, buffer id 3, timestamp: 78455573142000
[21:47:35.591373399] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video13[out]: Queueing buffer 3
[21:47:35.602148543] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video13[out]: Dequeuing buffer 3
[21:47:35.602424796] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video0[cap]: Queueing buffer 3
[21:47:35.602670771] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video14[cap]: Dequeuing buffer 1
[21:47:35.602902340] [23383] DEBUG RPI raspberrypi.cpp:1328 Stream ISP
Output0 buffer complete, buffer id 0, timestamp: 78455573142000
[21:47:35.603179926] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video15[cap]: Dequeuing buffer 3
[21:47:35.603405457] [23383] DEBUG RPI raspberrypi.cpp:1328 Stream ISP
Output1 buffer complete, buffer id 0, timestamp: 78455573142000
[21:47:35.603632192] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video15[cap]: Queueing buffer 3
[21:47:35.603877538] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1475
/dev/video16[cap]: Dequeuing buffer 3
[21:47:35.604111940] [23383] DEBUG RPI raspberrypi.cpp:1328 Stream ISP
Stats buffer complete, buffer id 3, timestamp: 78455573142000
[21:47:35.604334601] [23383] DEBUG V4L2 v4l2_videodevice.cpp:1406
/dev/video16[cap]: Queueing buffer 3
[21:47:35.604925402] [23384] DEBUG IPARPI raspberrypi.cpp:811 Applying AGC
Exposure: 1256.38 (Shutter lines: 111) Gain: 1 (Gain Code: 1)
[21:47:35.605266967] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:104 Setting
ctrl 0x00980911 to 111 at index 9
[21:47:35.605532405] [23383] DEBUG RPI_S_W staggered_ctrl.cpp:104 Setting
ctrl 0x009e0903 to 1 at index 9

-- 
Xishan Sun
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <https://lists.libcamera.org/pipermail/libcamera-devel/attachments/20200612/dc6de319/attachment-0001.htm>