raspberrypi / rpicam-apps

BSD 2-Clause "Simplified" License
420 stars 229 forks source link

[BUG] Libcamera-still/jpeg crash #384

Closed zahigeni closed 2 years ago

zahigeni commented 2 years ago

Hey all, Describe the bug

we running Libcamera-still or Libcamera-jpeg from python via subprocess in 10 seconds intervals :

subprocess.run(["libcamera-still", "-n", "-o", image_location, "--width", "1000", "--height", "754"])

and after a time period ( its occurs randomly, some times its happening after boot) we getting

INFO Camera camera manager.CD:293 libcamera v0.0.0+3424-e680fle\nERROR: no cameras available n'

only reboot solves the issue also swap memory is disabled

did not had the chance to use the bug-report-tool when this problem occurs this is the output in journalctl:

Oct 11 14:20:23 he01097 kernel: Unable to handle kernel paging request at virtual address 0000000000001008 Oct 11 14:20:23 he01097 kernel: Mem abort info: Oct 11 14:20:23 he01097 kernel: ESR = 0x96000005 Oct 11 14:20:24 he01097 kernel: EC = 0x25: DABT (current EL), IL = 32 bits Oct 11 14:20:24 he01097 kernel: SET = 0, FnV = 0 Oct 11 14:20:24 he01097 kernel: EA = 0, S1PTW = 0 Oct 11 14:20:24 he01097 kernel: Data abort info: Oct 11 14:20:24 he01097 kernel: ISV = 0, ISS = 0x00000005 Oct 11 14:20:24 he01097 kernel: CM = 0, WnR = 0 Oct 11 14:20:24 he01097 kernel: user pgtable: 4k pages, 39-bit VAs, pgdp=000000001a8c6000 Oct 11 14:20:24 he01097 kernel: [0000000000001008] pgd=0000000000000000, p4d=0000000000000000, pud=0000000000000000 Oct 11 14:20:24 he01097 kernel: Internal error: Oops: 96000005 [#1] PREEMPT SMP Oct 11 14:20:24 he01097 kernel: Modules linked in: algif_hash algif_skcipher af_alg bnep hci_uart btbcm bluetooth ecdh_generic ecc> Oct 11 14:20:24 he01097 kernel: CPU: 2 PID: 1105 Comm: libcamera-jpeg Tainted: G C 5.10.92-v8+ #1514 Oct 11 14:20:24 he01097 kernel: Hardware name: Raspberry Pi 3 Model B Rev 1.2 (DT) Oct 11 14:20:24 he01097 kernel: pstate: 60000005 (nZCv daif -PAN -UAO -TCO BTYPE=--) Oct 11 14:20:24 he01097 kernel: pc : kernfs_fop_open+0x6c/0x398 Oct 11 14:20:24 he01097 kernel: lr : kernfs_fop_open+0x44/0x398 Oct 11 14:20:24 he01097 kernel: sp : ffffffc012543ab0 Oct 11 14:20:24 he01097 kernel: x29: ffffffc012543ab0 x28: ffffffc012543c88 Oct 11 14:20:24 he01097 kernel: x27: 0000000000000000 x26: ffffff80063ffcf0 Oct 11 14:20:24 he01097 kernel: x25: 0000000000000000 x24: ffffff801a82ed00 Oct 11 14:20:24 he01097 kernel: x23: ffffffc01038c530 x22: 0000000000000000 Oct 11 14:20:24 he01097 kernel: x21: ffffffc010b28040 x20: ffffff8008f2c000 Oct 11 14:20:24 he01097 kernel: x19: 0000000000001000 x18: 0000000000000000 Oct 11 14:20:24 he01097 kernel: x17: 0000000000000000 x16: 0000000000000000 Oct 11 14:20:24 he01097 kernel: x15: 0000000000000000 x14: 0000000000000000 Oct 11 14:20:24 he01097 kernel: x13: 0000000000000000 x12: 0000000000000030 Oct 11 14:20:24 he01097 kernel: x11: 0000000000000030 x10: 0101010101010101 Oct 11 14:20:24 he01097 kernel: x9 : ffffffc01038c574 x8 : 7f7f7f7f7f7f7f7f Oct 11 14:20:24 he01097 kernel: x7 : ffffffc012543c10 x6 : 0000000000000000 Oct 11 14:20:24 he01097 kernel: x5 : ffffff8008f2c000 x4 : ffffff8008f2c004 Oct 11 14:20:24 he01097 kernel: x3 : 0000000000000000 x2 : 0000000000000001 Oct 11 14:20:24 he01097 kernel: x1 : ffffffc01038d2e0 x0 : 0000000000000001 Oct 11 14:20:24 he01097 kernel: Call trace: Oct 11 14:20:24 he01097 kernel: kernfs_fop_open+0x6c/0x398 Oct 11 14:20:24 he01097 kernel: do_dentry_open+0x134/0x398 Oct 11 14:20:24 he01097 kernel: vfs_open+0x34/0x40 Oct 11 14:20:24 he01097 kernel: path_openat+0xa18/0xe28 Oct 11 14:20:24 he01097 kernel: do_filp_open+0x84/0x100 Oct 11 14:20:24 he01097 kernel: do_sys_openat2+0x1f8/0x2a8 Oct 11 14:20:24 he01097 kernel: do_sys_open+0x60/0xa8 Oct 11 14:20:24 he01097 kernel: __arm64_sys_openat+0x2c/0x38 Oct 11 14:20:24 he01097 kernel: el0_svc_common.constprop.3+0xc0/0x1f8 Oct 11 14:20:24 he01097 kernel: do_el0_svc+0x2c/0x98 Oct 11 14:20:24 he01097 kernel: el0_svc+0x20/0x30 Oct 11 14:20:24 he01097 kernel: el0_sync_handler+0x90/0xb8 Oct 11 14:20:24 he01097 kernel: el0_sync+0x180/0x1c0 Oct 11 14:20:24 he01097 kernel: Code: b40015e0 f94026a1 52800020 b4001521 (b9400a61) Oct 11 14:20:24 he01097 kernel: ---[ end trace f63e4b96704c7504 ]--- Oct 11 14:20:24 he01097 NetworkManager[1003]: [1665498024.5908] manager: startup complete Oct 11 14:20:26 he01097 systemd[1]: systemd-fsckd.service: Succeeded. Oct 11 14:20:27 he01097 systemd-timesyncd[350]: Initial synchronization to time server 162.159.200.123:123 (2.debian.pool.ntp.org). Oct 11 14:20:30 he01097 systemd[1]: NetworkManager-dispatcher.service: Succeeded. Oct 11 14:20:33 he01097 kernel: Unable to handle kernel paging request at virtual address 0000000000001008 Oct 11 14:20:33 he01097 kernel: Mem abort info: Oct 11 14:20:33 he01097 kernel: ESR = 0x96000005 Oct 11 14:20:33 he01097 kernel: EC = 0x25: DABT (current EL), IL = 32 bits Oct 11 14:20:33 he01097 kernel: SET = 0, FnV = 0 Oct 11 14:20:33 he01097 kernel: EA = 0, S1PTW = 0 Oct 11 14:20:33 he01097 kernel: Data abort info: Oct 11 14:20:33 he01097 kernel: ISV = 0, ISS = 0x00000005 Oct 11 14:20:33 he01097 kernel: CM = 0, WnR = 0 Oct 11 14:20:33 he01097 kernel: user pgtable: 4k pages, 39-bit VAs, pgdp=0000000004b7d000 Oct 11 14:20:33 he01097 kernel: [0000000000001008] pgd=0000000000000000, p4d=0000000000000000, pud=0000000000000000 Oct 11 14:20:33 he01097 kernel: Internal error: Oops: 96000005 [#2] PREEMPT SMP Oct 11 14:20:33 he01097 kernel: Modules linked in: algif_hash algif_skcipher af_alg bnep hci_uart btbcm bluetooth ecdh_generic ecc> Oct 11 14:20:33 he01097 kernel: CPU: 0 PID: 1123 Comm: libcamera-jpeg Tainted: G D C 5.10.92-v8+ #1514 Oct 11 14:20:33 he01097 kernel: Hardware name: Raspberry Pi 3 Model B Rev 1.2 (DT) Oct 11 14:20:33 he01097 kernel: pstate: 60000005 (nZCv daif -PAN -UAO -TCO BTYPE=--) Oct 11 14:20:33 he01097 kernel: pc : kernfs_fop_open+0x6c/0x398 Oct 11 14:20:33 he01097 kernel: lr : kernfs_fop_open+0x44/0x398 Oct 11 14:20:33 he01097 kernel: sp : ffffffc01257bab0 Oct 11 14:20:33 he01097 kernel: x29: ffffffc01257bab0 x28: ffffffc01257bc88 Oct 11 14:20:33 he01097 kernel: x27: 0000000000000000 x26: ffffff80063ffcf0 Oct 11 14:20:33 he01097 kernel: x25: 0000000000000000 x24: ffffff801a8c9f00 Oct 11 14:20:33 he01097 kernel: x23: ffffffc01038c530 x22: 0000000000000000 Oct 11 14:20:33 he01097 kernel: x21: ffffffc010b28040 x20: ffffff8008f2c000 Oct 11 14:20:33 he01097 kernel: x19: 0000000000001000 x18: 0000000000000000 Oct 11 14:20:33 he01097 kernel: x17: 0000000000000000 x16: 0000000000000000 Oct 11 14:20:33 he01097 kernel: x15: 0000000000000000 x14: 0000000000000000 Oct 11 14:20:33 he01097 kernel: x13: 0000000000000000 x12: 0000000000000030 Oct 11 14:20:33 he01097 kernel: x11: 0000000000000030 x10: 0101010101010101 Oct 11 14:20:33 he01097 kernel: x9 : ffffffc01038c574 x8 : 7f7f7f7f7f7f7f7f Oct 11 14:20:33 he01097 kernel: x7 : ffffffc01257bc10 x6 : 0000000000000000 Oct 11 14:20:33 he01097 kernel: x5 : ffffff8008f2c000 x4 : ffffff8008f2c004 Oct 11 14:20:33 he01097 kernel: x3 : 0000000000000001 x2 : 0000000000000001 Oct 11 14:20:33 he01097 kernel: x1 : ffffffc01038d2e0 x0 : 0000000000000001 Oct 11 14:20:33 he01097 kernel: Call trace: Oct 11 14:20:33 he01097 kernel: kernfs_fop_open+0x6c/0x398 Oct 11 14:20:33 he01097 kernel: do_dentry_open+0x134/0x398 Oct 11 14:20:33 he01097 kernel: vfs_open+0x34/0x40 Oct 11 14:20:33 he01097 kernel: path_openat+0xa18/0xe28 Oct 11 14:20:33 he01097 kernel: do_filp_open+0x84/0x100 Oct 11 14:20:33 he01097 kernel: do_sys_openat2+0x1f8/0x2a8 Oct 11 14:20:33 he01097 kernel: do_sys_open+0x60/0xa8 Oct 11 14:20:33 he01097 kernel: __arm64_sys_openat+0x2c/0x38 Oct 11 14:20:33 he01097 kernel: el0_svc_common.constprop.3+0xc0/0x1f8 Oct 11 14:20:33 he01097 kernel: do_el0_svc+0x2c/0x98 Oct 11 14:20:33 he01097 kernel: el0_svc+0x20/0x30 Oct 11 14:20:33 he01097 kernel: el0_sync_handler+0x90/0xb8 Oct 11 14:20:33 he01097 kernel: el0_sync+0x180/0x1c0 Oct 11 14:20:33 he01097 kernel: Code: b40015e0 f94026a1 52800020 b4001521 (b9400a61) Oct 11 14:20:33 he01097 kernel: ---[ end trace f63e4b96704c7505 ]---

Bug report

libcamera-apps Bug Report

Date: 12-10-2022 (11:24:02) Command: /usr/bin/camera-bug-report


Hardware information

hostname he01097

cat /proc/cpuinfo processor : 0 BogoMIPS : 38.40 Features : fp asimd evtstrm crc32 cpuid CPU implementer : 0x41 CPU architecture: 8 CPU variant : 0x0 CPU part : 0xd03 CPU revision : 4

processor : 1 BogoMIPS : 38.40 Features : fp asimd evtstrm crc32 cpuid CPU implementer : 0x41 CPU architecture: 8 CPU variant : 0x0 CPU part : 0xd03 CPU revision : 4

processor : 2 BogoMIPS : 38.40 Features : fp asimd evtstrm crc32 cpuid CPU implementer : 0x41 CPU architecture: 8 CPU variant : 0x0 CPU part : 0xd03 CPU revision : 4

processor : 3 BogoMIPS : 38.40 Features : fp asimd evtstrm crc32 cpuid CPU implementer : 0x41 CPU architecture: 8 CPU variant : 0x0 CPU part : 0xd03 CPU revision : 4

Hardware : BCM2835 Revision : a02082 Serial : 000000007124af32 Model : Raspberry Pi 3 Model B Rev 1.2


Configuration

cat /boot/cmdline.txt console=serial0,115200 console=tty1 root=PARTUUID=6bbc826b-02 rootfstype=ext4 fsck.repair=yes rootwait

cat /boot/config.txt

For more options and information see

http://rpf.io/configtxt

Some settings may impact device functionality. See link above for details

uncomment if you get no picture on HDMI for a default "safe" mode

hdmi_safe=1

uncomment the following to adjust overscan. Use positive numbers if console

goes off screen, and negative if there is too much border

overscan_left=16

overscan_right=16

overscan_top=16

overscan_bottom=16

uncomment to force a console size. By default it will be display's size minus

overscan.

framebuffer_width=1280

framebuffer_height=720

uncomment if hdmi display is not detected and composite is being output

hdmi_force_hotplug=1

uncomment to force a specific HDMI mode (this will force VGA)

hdmi_group=1

hdmi_mode=1

uncomment to force a HDMI mode rather than DVI. This can make audio work in

DMT (computer monitor) modes

hdmi_drive=2

uncomment to increase signal to HDMI, if you have interference, blanking, or

no display

config_hdmi_boost=4

uncomment for composite PAL

sdtv_mode=2

uncomment to overclock the arm. 700 MHz is the default.

arm_freq=800

Uncomment some or all of these to enable the optional hardware interfaces

dtparam=i2c_arm=on

dtparam=i2s=on

dtparam=spi=on

Uncomment this to enable infrared communication.

dtoverlay=gpio-ir,gpio_pin=17

dtoverlay=gpio-ir-tx,gpio_pin=18

Additional overlays and parameters are documented /boot/overlays/README

Enable audio (loads snd_bcm2835)

dtparam=audio=on

Automatically load overlays for detected cameras

camera_auto_detect=1

Automatically load overlays for detected DSI displays

display_auto_detect=1

Enable DRM VC4 V3D driver

dtoverlay=vc4-kms-v3d max_framebuffers=2

Run in 64-bit mode

arm_64bit=1

Disable compensation for displays with overscan

disable_overscan=1

[cm4]

Enable host mode on the 2711 built-in XHCI USB controller.

This line should be removed if the legacy DWC2 controller is required

(e.g. for USB device mode) or if USB support is not required.

otg_mode=1

[all]

[pi4]

Run as fast as firmware / board allows

arm_boost=1

[all] gpu_mem=128


Logs

dmesg [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x410fd034] [ 0.000000] Linux version 5.10.92-v8+ (dom@buildbot) (aarch64-linux-gnu-gcc-8 (Ubuntu/Linaro 8.4.0-3ubuntu1) 8.4.0, GNU ld (GNU Binutils for Ubuntu) 2.34) #1514 SMP PREEMPT Mon Jan 17 17:39:38 GMT 2022 [ 0.000000] random: fast init done [ 0.000000] Machine model: Raspberry Pi 3 Model B Rev 1.2 [ 0.000000] efi: UEFI not found. [ 0.000000] Reserved memory: created CMA memory pool at 0x000000001ec00000, size 256 MiB [ 0.000000] OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000000000-0x0000000037ffffff] [ 0.000000] DMA32 empty [ 0.000000] Normal empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000000000-0x0000000037ffffff] [ 0.000000] Initmem setup node 0 [mem 0x0000000000000000-0x0000000037ffffff] [ 0.000000] On node 0 totalpages: 229376 [ 0.000000] DMA zone: 3584 pages used for memmap [ 0.000000] DMA zone: 0 pages reserved [ 0.000000] DMA zone: 229376 pages, LIFO batch:63 [ 0.000000] percpu: Embedded 32 pages/cpu s91416 r8192 d31464 u131072 [ 0.000000] pcpu-alloc: s91416 r8192 d31464 u131072 alloc=32*4096 [ 0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 [ 0.000000] Detected VIPT I-cache on CPU0 [ 0.000000] CPU features: detected: ARM erratum 845719 [ 0.000000] CPU features: detected: ARM erratum 843419 [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 225792 [ 0.000000] Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_compat_alsa=0 snd_bcm2835.enable_hdmi=1 video=Composite-1:720x480@60i vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 console=ttyS0,115200 console=tty1 root=PARTUUID=6bbc826b-02 rootfstype=ext4 fsck.repair=yes rootwait [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) [ 0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off [ 0.000000] Memory: 612732K/917504K available (11136K kernel code, 1950K rwdata, 3988K rodata, 3712K init, 1253K bss, 42628K reserved, 262144K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] ftrace: allocating 36801 entries in 144 pages [ 0.000000] ftrace: allocated 144 pages with 2 groups [ 0.000000] rcu: Preemptible hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=256 to nr_cpu_ids=4. [ 0.000000] Trampoline variant of Tasks RCU enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 [ 0.000000] random: get_random_bytes called from start_kernel+0x3b0/0x570 with crng_init=1 [ 0.000000] arch_timer: cp15 timer(s) running at 19.20MHz (phys). [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x46d987e47, max_idle_ns: 440795202767 ns [ 0.000007] sched_clock: 56 bits at 19MHz, resolution 52ns, wraps every 4398046511078ns [ 0.000308] Console: colour dummy device 80x25 [ 0.001189] printk: console [tty1] enabled [ 0.001264] Calibrating delay loop (skipped), value calculated using timer frequency.. 38.40 BogoMIPS (lpj=76800) [ 0.001330] pid_max: default: 32768 minimum: 301 [ 0.001564] LSM: Security Framework initializing [ 0.001850] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) [ 0.001915] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) [ 0.003551] cgroup: Disabling memory control group subsystem [ 0.006878] rcu: Hierarchical SRCU implementation. [ 0.008339] EFI services will not be available. [ 0.009124] smp: Bringing up secondary CPUs ... [ 0.010531] Detected VIPT I-cache on CPU1 [ 0.010627] CPU1: Booted secondary processor 0x0000000001 [0x410fd034] [ 0.012293] Detected VIPT I-cache on CPU2 [ 0.012358] CPU2: Booted secondary processor 0x0000000002 [0x410fd034] [ 0.013914] Detected VIPT I-cache on CPU3 [ 0.013969] CPU3: Booted secondary processor 0x0000000003 [0x410fd034] [ 0.014189] smp: Brought up 1 node, 4 CPUs [ 0.014344] SMP: Total of 4 processors activated. [ 0.014381] CPU features: detected: 32-bit EL0 Support [ 0.014418] CPU features: detected: CRC32 instructions [ 0.014454] CPU features: detected: 32-bit EL1 Support [ 0.052063] CPU: All CPU(s) started at EL2 [ 0.052213] alternatives: patching kernel code [ 0.054127] devtmpfs: initialized [ 0.076580] Enabled cp15_barrier support [ 0.076663] Enabled setend support [ 0.076983] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns [ 0.077052] futex hash table entries: 1024 (order: 4, 65536 bytes, linear) [ 0.089826] pinctrl core: initialized pinctrl subsystem [ 0.091012] DMI not present or invalid. [ 0.091553] NET: Registered protocol family 16 [ 0.102650] DMA: preallocated 1024 KiB GFP_KERNEL pool for atomic allocations [ 0.103561] DMA: preallocated 1024 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.105166] DMA: preallocated 1024 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.105373] audit: initializing netlink subsys (disabled) [ 0.105811] audit: type=2000 audit(0.104:1): state=initialized audit_enabled=0 res=1 [ 0.106665] thermal_sys: Registered thermal governor 'step_wise' [ 0.106999] cpuidle: using governor menu [ 0.107628] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. [ 0.107921] ASID allocator initialised with 65536 entries [ 0.108152] Serial: AMBA PL011 UART driver [ 0.151553] bcm2835-mbox 3f00b880.mailbox: mailbox enabled [ 0.161080] raspberrypi-firmware soc:firmware: Attached to firmware from 2022-01-20T13:58:22, variant start [ 0.165096] raspberrypi-firmware soc:firmware: Firmware hash is bd88f66f8952d34e4e0613a85c7a6d3da49e13e2 [ 0.215658] bcm2835-dma 3f007000.dma: DMA legacy API manager, dmachans=0x1 [ 0.221402] vgaarb: loaded [ 0.222061] SCSI subsystem initialized [ 0.222444] usbcore: registered new interface driver usbfs [ 0.222549] usbcore: registered new interface driver hub [ 0.222680] usbcore: registered new device driver usb [ 0.223260] usb_phy_generic phy: supply vcc not found, using dummy regulator [ 0.226071] clocksource: Switched to clocksource arch_sys_counter [ 1.895559] VFS: Disk quotas dquot_6.6.0 [ 1.895724] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 1.895985] FS-Cache: Loaded [ 1.896313] CacheFiles: Loaded [ 1.897710] simple-framebuffer 3eaa9000.framebuffer: framebuffer at 0x3eaa9000, 0x151800 bytes, mapped to 0x(ptrval) [ 1.897767] simple-framebuffer 3eaa9000.framebuffer: format=a8r8g8b8, mode=720x480x32, linelength=2880 [ 1.904221] Console: switching to colour frame buffer device 90x30 [ 1.912814] simple-framebuffer 3eaa9000.framebuffer: fb0: simplefb registered! [ 1.931263] NET: Registered protocol family 2 [ 1.934914] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) [ 1.939993] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) [ 1.946864] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) [ 1.950453] TCP bind hash table entries: 8192 (order: 5, 131072 bytes, linear) [ 1.954081] TCP: Hash tables configured (established 8192 bind 8192) [ 1.957756] UDP hash table entries: 512 (order: 2, 16384 bytes, linear) [ 1.961210] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear) [ 1.965092] NET: Registered protocol family 1 [ 1.969841] RPC: Registered named UNIX socket transport module. [ 1.973444] RPC: Registered udp transport module. [ 1.977090] RPC: Registered tcp transport module. [ 1.980609] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 1.984063] PCI: CLS 0 bytes, default 64 [ 1.990114] hw perfevents: enabled with armv8_cortex_a53 PMU driver, 7 counters available [ 1.997280] kvm [1]: IPA Size Limit: 40 bits [ 2.002590] kvm [1]: Hyp mode initialized successfully [ 2.011950] Initialise system trusted keyrings [ 2.015879] workingset: timestamp_bits=46 max_order=18 bucket_order=0 [ 2.029744] zbud: loaded [ 2.035762] FS-Cache: Netfs 'nfs' registered for caching [ 2.040124] NFS: Registering the id_resolver key type [ 2.043442] Key type id_resolver registered [ 2.046618] Key type id_legacy registered [ 2.049832] nfs4filelayout_init: NFSv4 File Layout Driver Registering... [ 2.052947] nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering... [ 2.057718] Key type asymmetric registered [ 2.060719] Asymmetric key parser 'x509' registered [ 2.063732] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) [ 2.067126] io scheduler mq-deadline registered [ 2.070102] io scheduler kyber registered [ 2.089429] bcm2835-rng 3f104000.rng: hwrng registered [ 2.093346] vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB) [ 2.101258] gpiomem-bcm2835 3f200000.gpiomem: Initialised: Registers at 0x3f200000 [ 2.105047] cacheinfo: Unable to detect cache hierarchy for CPU 0 [ 2.125866] brd: module loaded [ 2.147907] loop: module loaded [ 2.153842] Loading iSCSI transport class v2.0-870. [ 2.161829] libphy: Fixed MDIO Bus: probed [ 2.167173] usbcore: registered new interface driver r8152 [ 2.170342] usbcore: registered new interface driver lan78xx [ 2.173405] usbcore: registered new interface driver smsc95xx [ 2.177079] dwc_otg: version 3.00a 10-AUG-2012 (platform bus) [ 2.908604] Core Release: 2.80a [ 2.911469] Setting default values for core params [ 2.914362] Finished setting default values for core params [ 3.117708] Using Buffer DMA mode [ 3.120615] Periodic Transfer Interrupt Enhancement - disabled [ 3.123560] Multiprocessor Interrupt Enhancement - disabled [ 3.126475] OTG VER PARAM: 0, OTG VER FLAG: 0 [ 3.129300] Dedicated Tx FIFOs mode

[ 3.136867] WARN::dwc_otg_hcd_init:1074: FIQ DMA bounce buffers: virt = ffffffc011a19000 dma = 0x00000000df000000 len=9024 [ 3.145189] FIQ FSM acceleration enabled for : Non-periodic Split Transactions Periodic Split Transactions High-Speed Isochronous Endpoints Interrupt/Control Split Transaction hack enabled [ 3.158376] dwc_otg: Microframe scheduler enabled

[ 3.158440] WARN::hcd_init_fiq:497: MPHI regs_base at ffffffc011625000 [ 3.163538] dwc_otg 3f980000.usb: DWC OTG Controller [ 3.166199] dwc_otg 3f980000.usb: new USB bus registered, assigned bus number 1 [ 3.168925] dwc_otg 3f980000.usb: irq 74, io mem 0x00000000 [ 3.171611] Init: Port Power? op_state=1 [ 3.174295] Init: Power Port (0) [ 3.177466] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.10 [ 3.183027] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 3.185991] usb usb1: Product: DWC OTG Controller [ 3.188927] usb usb1: Manufacturer: Linux 5.10.92-v8+ dwc_otg_hcd [ 3.191890] usb usb1: SerialNumber: 3f980000.usb [ 3.195798] hub 1-0:1.0: USB hub found [ 3.198805] hub 1-0:1.0: 1 port detected [ 3.203309] dwc_otg: FIQ enabled [ 3.203327] dwc_otg: NAK holdoff enabled [ 3.203342] dwc_otg: FIQ split-transaction FSM enabled [ 3.203364] Module dwc_common_port init [ 3.204137] usbcore: registered new interface driver uas [ 3.207452] usbcore: registered new interface driver usb-storage [ 3.210683] mousedev: PS/2 mouse device common for all mice [ 3.216046] bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer [ 3.223082] sdhci: Secure Digital Host Controller Interface driver [ 3.225868] sdhci: Copyright(c) Pierre Ossman [ 3.229647] mmc-bcm2835 3f300000.mmcnr: could not get clk, deferring probe [ 3.233538] sdhost-bcm2835 3f202000.mmc: could not get clk, deferring probe [ 3.237027] sdhci-pltfm: SDHCI platform and OF driver helper [ 3.245486] ledtrig-cpu: registered to indicate activity on CPUs [ 3.249072] hid: raw HID events driver (C) Jiri Kosina [ 3.252342] usbcore: registered new interface driver usbhid [ 3.255301] usbhid: USB HID core driver [ 3.258631] ashmem: initialized [ 3.269433] Initializing XFRM netlink socket [ 3.272426] NET: Registered protocol family 17 [ 3.275555] Key type dns_resolver registered [ 3.279260] registered taskstats version 1 [ 3.281960] Loading compiled-in X.509 certificates [ 3.285375] Key type ._fscrypt registered [ 3.287989] Key type .fscrypt registered [ 3.290549] Key type fscrypt-provisioning registered [ 3.312887] uart-pl011 3f201000.serial: cts_event_workaround enabled [ 3.315739] 3f201000.serial: ttyAMA0 at MMIO 0x3f201000 (irq = 99, base_baud = 0) is a PL011 rev2 [ 3.326376] bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver [ 3.332185] mmc-bcm2835 3f300000.mmcnr: mmc_debug:0 mmc_debug2:0 [ 3.335203] mmc-bcm2835 3f300000.mmcnr: DMA channel allocated [ 3.338893] Indeed it is in host mode hprt0 = 00021501 [ 3.363797] sdhost: log_buf @ (ptrval) (c2bb6000) [ 3.434236] mmc0: sdhost-bcm2835 loaded - DMA enabled (>1) [ 3.441926] of_cfs_init [ 3.464974] of_cfs_init: OK [ 3.469236] Waiting for root device PARTUUID=6bbc826b-02... [ 3.484382] mmc1: queuing unknown CIS tuple 0x80 (2 bytes) [ 3.488910] mmc1: queuing unknown CIS tuple 0x80 (3 bytes) [ 3.493530] mmc1: queuing unknown CIS tuple 0x80 (3 bytes) [ 3.499290] mmc1: queuing unknown CIS tuple 0x80 (7 bytes) [ 3.550135] usb 1-1: new high-speed USB device number 2 using dwc_otg [ 3.552802] mmc0: host does not support reading read-only switch, assuming write-enable [ 3.555502] Indeed it is in host mode hprt0 = 00001101 [ 3.571633] mmc0: new high speed SDHC card at address aaaa [ 3.575947] mmcblk0: mmc0:aaaa SA16G 14.8 GiB [ 3.629830] mmcblk0: p1 p2 [ 3.641850] mmc1: new high speed SDIO card at address 0001 [ 3.659543] EXT4-fs (mmcblk0p2): INFO: recovery required on readonly filesystem [ 3.662490] EXT4-fs (mmcblk0p2): write access will be enabled during recovery [ 3.770739] usb 1-1: New USB device found, idVendor=0424, idProduct=9514, bcdDevice= 2.00 [ 3.776338] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 [ 3.780348] hub 1-1:1.0: USB hub found [ 3.783317] hub 1-1:1.0: 5 ports detected [ 4.074114] usb 1-1.1: new high-speed USB device number 3 using dwc_otg [ 4.125072] EXT4-fs (mmcblk0p2): orphan cleanup on readonly fs [ 4.128236] EXT4-fs (mmcblk0p2): 1 orphan inode deleted [ 4.131033] EXT4-fs (mmcblk0p2): recovery complete [ 4.147741] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null) [ 4.153434] VFS: Mounted root (ext4 filesystem) readonly on device 179:2. [ 4.166224] devtmpfs: mounted [ 4.174687] usb 1-1.1: New USB device found, idVendor=0424, idProduct=ec00, bcdDevice= 2.00 [ 4.181412] usb 1-1.1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 [ 4.183047] Freeing unused kernel memory: 3712K [ 4.188484] Run /sbin/init as init process [ 4.188662] smsc95xx v2.0.0 [ 4.191743] with arguments: [ 4.194909] /sbin/init [ 4.194924] with environment: [ 4.194938] HOME=/ [ 4.195041] TERM=linux [ 4.457754] random: crng init done [ 4.646985] libphy: smsc95xx-mdiobus: probed [ 4.651522] smsc95xx 1-1.1:1.0 eth0: register 'smsc95xx' at usb-3f980000.usb-1.1, smsc95xx USB 2.0 Ethernet, b8:27:eb:24:af:32 [ 4.742231] usb 1-1.3: new full-speed USB device number 4 using dwc_otg [ 4.830322] systemd[1]: System time before build time, advancing clock. [ 4.877314] usb 1-1.3: New USB device found, idVendor=0403, idProduct=6001, bcdDevice= 6.00 [ 4.883926] usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=3 [ 4.887444] usb 1-1.3: Product: FT232R USB UART [ 4.890949] usb 1-1.3: Manufacturer: FTDI [ 4.894321] usb 1-1.3: SerialNumber: fixture [ 4.940246] NET: Registered protocol family 10 [ 4.946090] Segment Routing with IPv6 [ 4.986176] usb 1-1.5: new full-speed USB device number 5 using dwc_otg [ 5.014328] systemd[1]: systemd 247.3-6 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +ZSTD +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=unified) [ 5.028819] systemd[1]: Detected architecture arm64. [ 5.061867] systemd[1]: Set hostname to . [ 5.092801] usb 1-1.5: New USB device found, idVendor=1546, idProduct=01a8, bcdDevice= 3.01 [ 5.099664] usb 1-1.5: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [ 5.103292] usb 1-1.5: Product: u-blox GNSS receiver [ 5.106941] usb 1-1.5: Manufacturer: u-blox AG - www.u-blox.com [ 5.762355] usb 1-1.4: new high-speed USB device number 6 using dwc_otg [ 5.876204] usb 1-1.4: New USB device found, idVendor=2c7c, idProduct=0125, bcdDevice= 3.18 [ 5.883044] usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [ 5.886522] usb 1-1.4: Product: EG25-G [ 5.889962] usb 1-1.4: Manufacturer: Quectel [ 6.173405] systemd[1]: Configuration file /etc/systemd/system/connect.service is marked executable. Please remove executable permission bits. Proceeding anyway. [ 6.217150] systemd[1]: Queued start job for default target Graphical Interface. [ 6.226547] systemd[1]: Created slice system-getty.slice. [ 6.236631] systemd[1]: Created slice system-modprobe.slice. [ 6.246335] systemd[1]: Created slice system-systemd\x2dfsck.slice. [ 6.255355] systemd[1]: Created slice User and Session Slice. [ 6.263852] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. [ 6.272646] systemd[1]: Started Forward Password Requests to Wall Directory Watch. [ 6.282642] systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. [ 6.295148] systemd[1]: Reached target Local Encrypted Volumes. [ 6.303984] systemd[1]: Reached target Paths. [ 6.312306] systemd[1]: Reached target Slices. [ 6.320546] systemd[1]: Reached target Swap. [ 6.329958] systemd[1]: Listening on Syslog Socket. [ 6.338944] systemd[1]: Listening on fsck to fsckd communication Socket. [ 6.347444] systemd[1]: Listening on initctl Compatibility Named Pipe. [ 6.357322] systemd[1]: Listening on Journal Audit Socket. [ 6.366532] systemd[1]: Listening on Journal Socket (/dev/log). [ 6.375906] systemd[1]: Listening on Journal Socket. [ 6.394474] systemd[1]: Listening on udev Control Socket. [ 6.403221] systemd[1]: Listening on udev Kernel Socket. [ 6.411880] systemd[1]: Condition check resulted in Huge Pages File System being skipped. [ 6.424165] systemd[1]: Mounting POSIX Message Queue File System... [ 6.438471] systemd[1]: Mounting RPC Pipe File System... [ 6.453376] systemd[1]: Mounting Kernel Debug File System... [ 6.468194] systemd[1]: Mounting Kernel Trace File System... [ 6.477236] systemd[1]: Condition check resulted in Kernel Module supporting RPCSEC_GSS being skipped. [ 6.495686] systemd[1]: Starting Restore / save the current clock... [ 6.512042] systemd[1]: Starting Set the console keyboard layout... [ 6.528090] systemd[1]: Starting Create list of static device nodes for the current kernel... [ 6.551136] systemd[1]: Starting Load Kernel Module configfs... [ 6.566989] systemd[1]: Starting Load Kernel Module drm... [ 6.587395] systemd[1]: Starting Load Kernel Module fuse... [ 6.608283] systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. [ 6.622887] systemd[1]: Starting File System Check on Root Device... [ 6.644676] systemd[1]: Starting Journal Service... [ 6.658943] fuse: init (API version 7.32) [ 6.688378] systemd[1]: Starting Load Kernel Modules... [ 6.705252] systemd[1]: Starting Coldplug All udev Devices... [ 6.750761] systemd[1]: Mounted POSIX Message Queue File System. [ 6.760246] systemd[1]: Mounted RPC Pipe File System. [ 6.769887] systemd[1]: Mounted Kernel Debug File System. [ 6.779087] systemd[1]: Mounted Kernel Trace File System. [ 6.789824] systemd[1]: Finished Restore / save the current clock. [ 6.801735] systemd[1]: Finished Create list of static device nodes for the current kernel. [ 6.828096] systemd[1]: modprobe@configfs.service: Succeeded. [ 6.833999] systemd[1]: Finished Load Kernel Module configfs. [ 6.845058] systemd[1]: modprobe@drm.service: Succeeded. [ 6.850368] cryptd: max_cpu_qlen set to 1000 [ 6.850640] systemd[1]: Finished Load Kernel Module drm. [ 6.865080] systemd[1]: modprobe@fuse.service: Succeeded. [ 6.871583] systemd[1]: Finished Load Kernel Module fuse. [ 6.889815] systemd[1]: Mounting FUSE Control File System... [ 6.905470] systemd[1]: Mounting Kernel Configuration File System... [ 6.920827] systemd[1]: Started File System Check Daemon to report status. [ 6.938411] systemd[1]: Mounted FUSE Control File System. [ 6.977635] i2c /dev entries driver [ 6.981680] systemd[1]: Mounted Kernel Configuration File System. [ 7.009800] systemd[1]: Finished Load Kernel Modules. [ 7.020917] systemd[1]: Finished File System Check on Root Device. [ 7.036844] systemd[1]: Starting Remount Root and Kernel File Systems... [ 7.051781] systemd[1]: Starting Apply Kernel Variables... [ 7.136603] systemd[1]: Finished Apply Kernel Variables. [ 7.247741] systemd[1]: Started Journal Service. [ 7.267041] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null) [ 7.377291] systemd-journald[146]: Received client request to flush runtime journal. [ 7.408404] systemd-journald[146]: File /var/log/journal/ae385e4c0ba94ed8acaa75498c10ac4f/system.journal corrupted or uncleanly shut down, renaming and replacing. [ 8.940629] vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned. [ 8.943218] bcm2835_vc_sm_cma_probe: Videocore shared memory driver

[ 8.947001] [vc_sm_connected_init]: installed successfully [ 8.955194] mc: Linux media interface: v0.10 [ 9.016734] videodev: Linux video capture interface: v2.00 [ 9.069675] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. [ 9.071157] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. [ 9.079945] bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned. [ 9.089770] bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned. [ 9.091923] bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13 [ 9.092429] snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned. [ 9.092814] bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14 [ 9.093580] bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15 [ 9.094277] bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16 [ 9.094338] bcm2835-isp bcm2835-isp: Register output node 0 with media controller [ 9.094370] bcm2835-isp bcm2835-isp: Register capture node 1 with media controller [ 9.094415] bcm2835-isp bcm2835-isp: Register capture node 2 with media controller [ 9.094442] bcm2835-isp bcm2835-isp: Register capture node 3 with media controller [ 9.098732] bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned. [ 9.106281] bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video20 [ 9.107091] bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video21 [ 9.107658] bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video22 [ 9.108462] bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video23 [ 9.108517] bcm2835-isp bcm2835-isp: Register output node 0 with media controller [ 9.108561] bcm2835-isp bcm2835-isp: Register capture node 1 with media controller [ 9.108589] bcm2835-isp bcm2835-isp: Register capture node 2 with media controller [ 9.108615] bcm2835-isp bcm2835-isp: Register capture node 3 with media controller [ 9.109173] bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp [ 9.128047] bcm2835-codec bcm2835-codec: Device registered as /dev/video10 [ 9.128120] bcm2835-codec bcm2835-codec: Loaded V4L2 decode [ 9.129728] bcm2835_audio bcm2835_audio: card created with 8 channels [ 9.131930] bcm2835-codec bcm2835-codec: Device registered as /dev/video11 [ 9.132034] bcm2835-codec bcm2835-codec: Loaded V4L2 encode [ 9.142453] bcm2835-codec bcm2835-codec: Device registered as /dev/video12 [ 9.142537] bcm2835-codec bcm2835-codec: Loaded V4L2 isp [ 9.163139] bcm2835-codec bcm2835-codec: Device registered as /dev/video18 [ 9.163206] bcm2835-codec bcm2835-codec: Loaded V4L2 image_fx [ 9.310723] i2c i2c-11: Added multiplexed i2c bus 0 [ 9.324554] i2c i2c-11: Added multiplexed i2c bus 10 [ 9.600635] cfg80211: Loading compiled-in X.509 certificates for regulatory database [ 9.664136] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' [ 9.672137] checking generic (3eaa9000 151800) vs hw (0 ffffffffffffffff) [ 9.672171] fb0: switching to vc4drmfb from simple [ 9.672912] Console: switching to colour dummy device 80x25 [ 9.683956] vc4-drm soc:gpu: bound 3f400000.hvs (ops vc4_hvs_ops [vc4]) [ 9.685493] Registered IR keymap rc-cec [ 9.685808] rc rc0: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0 [ 9.686226] input: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0/input0 [ 9.875615] cfg80211: loaded regulatory.db is malformed or signature is missing/invalid [ 9.948250] vc4-drm soc:gpu: bound 3f400000.hvs (ops vc4_hvs_ops [vc4]) [ 9.955279] Registered IR keymap rc-cec [ 9.955596] rc rc0: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0 [ 9.955923] input: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0/input1 [ 9.971827] usbcore: registered new interface driver usbserial_generic [ 9.971940] usbserial: USB Serial support registered for generic [ 9.982045] cdc_acm 1-1.5:1.0: ttyACM0: USB ACM device [ 9.984488] brcmfmac: F1 signature read @0x18000000=0x1541a9a6 [ 9.989849] usbcore: registered new interface driver cdc_acm [ 9.989878] cdc_acm: USB Abstract Control Model driver for USB modems and ISDN adapters [ 10.000671] usbcore: registered new interface driver ftdi_sio [ 10.000815] usbserial: USB Serial support registered for FTDI USB Serial Device [ 10.001179] ftdi_sio 1-1.3:1.0: FTDI USB Serial Device converter detected [ 10.001511] usb 1-1.3: Detected FT232RL [ 10.018223] usb 1-1.3: FTDI USB Serial Device converter now attached to ttyUSB0 [ 10.021415] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43430-sdio for chip BCM43430/1 [ 10.022496] usbcore: registered new interface driver brcmfmac [ 10.047957] vc4-drm soc:gpu: bound 3f400000.hvs (ops vc4_hvs_ops [vc4]) [ 10.058370] Registered IR keymap rc-cec [ 10.058719] rc rc0: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0 [ 10.059037] input: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0/input2 [ 10.135293] usbcore: registered new interface driver cdc_wdm [ 10.138228] usbcore: registered new interface driver option [ 10.138367] usbserial: USB Serial support registered for GSM modem (1-port) [ 10.141160] option 1-1.4:1.0: GSM modem (1-port) converter detected [ 10.142525] usb 1-1.4: GSM modem (1-port) converter now attached to ttyUSB1 [ 10.150363] vc4-drm soc:gpu: bound 3f400000.hvs (ops vc4_hvs_ops [vc4]) [ 10.164814] qmi_wwan 1-1.4:1.4: cdc-wdm0: USB WDM device [ 10.166912] qmi_wwan 1-1.4:1.4 wwan0: register 'qmi_wwan' at usb-3f980000.usb-1.4, WWAN/QMI device, ca:f7:d8:26:6c:0c [ 10.167246] usbcore: registered new interface driver qmi_wwan [ 10.174343] Registered IR keymap rc-cec [ 10.174658] rc rc0: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0 [ 10.175021] input: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0/input3 [ 10.179984] option 1-1.4:1.1: GSM modem (1-port) converter detected [ 10.188517] usb 1-1.4: GSM modem (1-port) converter now attached to ttyUSB2 [ 10.189062] option 1-1.4:1.2: GSM modem (1-port) converter detected [ 10.194009] usb 1-1.4: GSM modem (1-port) converter now attached to ttyUSB3 [ 10.194611] option 1-1.4:1.3: GSM modem (1-port) converter detected [ 10.195404] usb 1-1.4: GSM modem (1-port) converter now attached to ttyUSB4 [ 10.237438] vc4-drm soc:gpu: bound 3f400000.hvs (ops vc4_hvs_ops [vc4]) [ 10.243560] Registered IR keymap rc-cec [ 10.244062] rc rc0: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0 [ 10.244763] input: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0/input4 [ 10.275928] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43430-sdio for chip BCM43430/1 [ 10.276132] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43430-sdio for chip BCM43430/1 [ 10.288228] brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM43430/1 wl0: Jul 19 2021 03:24:18 version 7.45.98 (TOB) (56df937 CY) FWID 01-8e14b897 [ 10.994012] vc4-drm soc:gpu: bound 3f400000.hvs (ops vc4_hvs_ops [vc4]) [ 11.002765] Registered IR keymap rc-cec [ 11.003116] rc rc0: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0 [ 11.003446] input: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0/input5 [ 11.084061] vc4-drm soc:gpu: bound 3f400000.hvs (ops vc4_hvs_ops [vc4]) [ 11.098504] Registered IR keymap rc-cec [ 11.101491] rc rc0: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0 [ 11.102329] input: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0/input6 [ 11.355608] vc4-drm soc:gpu: bound 3f400000.hvs (ops vc4_hvs_ops [vc4]) [ 11.369704] Registered IR keymap rc-cec [ 11.370322] rc rc0: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0 [ 11.370740] input: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0/input7 [ 11.384840] vc4-drm soc:gpu: bound 3f902000.hdmi (ops vc4_hdmi_ops [vc4]) [ 11.385389] vc4-drm soc:gpu: bound 3f004000.txp (ops vc4_txp_ops [vc4]) [ 11.386033] vc4-drm soc:gpu: bound 3f206000.pixelvalve (ops vc4_crtc_ops [vc4]) [ 11.399848] vc4-drm soc:gpu: bound 3f207000.pixelvalve (ops vc4_crtc_ops [vc4]) [ 11.400308] vc4-drm soc:gpu: bound 3f807000.pixelvalve (ops vc4_crtc_ops [vc4]) [ 11.400634] vc4-drm soc:gpu: bound 3fc00000.v3d (ops vc4_v3d_ops [vc4]) [ 11.422794] [drm] Initialized vc4 0.0.0 20140616 for soc:gpu on minor 0 [ 11.423501] vc4-drm soc:gpu: [drm] Cannot find any crtc or sizes [ 12.065356] imx219 10-0010: Consider updating driver imx219 to match on endpoints [ 12.100887] uart-pl011 3f201000.serial: no DMA platform data [ 13.691507] i2c i2c-1: new_device: Instantiated device ds1307 at 0x68 [ 13.761298] rtc-ds1307 1-0068: registered as rtc0 [ 13.769140] rtc-ds1307 1-0068: setting system clock to 2022-10-12T02:53:20 UTC (1665543200) [ 14.216761] SMSC LAN8700 usb-001:003:01: attached PHY driver [SMSC LAN8700] (mii_bus:phy_addr=usb-001:003:01, irq=POLL) [ 14.217164] smsc95xx 1-1.1:1.0 eth0: hardware isn't capable of remote wakeup [ 14.231758] smsc95xx 1-1.1:1.0 eth0: Link is Down [ 14.300331] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [ 14.854044] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [ 16.313415] Bluetooth: Core ver 2.22 [ 16.313534] NET: Registered protocol family 31 [ 16.313542] Bluetooth: HCI device and connection manager initialized [ 16.313569] Bluetooth: HCI socket layer initialized [ 16.313584] Bluetooth: L2CAP socket layer initialized [ 16.313613] Bluetooth: SCO socket layer initialized [ 16.329125] Bluetooth: HCI UART driver ver 2.3 [ 16.329147] Bluetooth: HCI UART protocol H4 registered [ 16.329273] Bluetooth: HCI UART protocol Three-wire (H5) registered [ 16.329654] Bluetooth: HCI UART protocol Broadcom registered [ 17.898736] Bluetooth: BNEP (Ethernet Emulation) ver 1.3 [ 17.898760] Bluetooth: BNEP filters: protocol multicast [ 17.898790] Bluetooth: BNEP socket layer initialized [ 17.933703] NET: Registered protocol family 38 [ 21.476343] vc4-drm soc:gpu: [drm] Cannot find any crtc or sizes [ 25.768614] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [ 32.837603] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [ 33.758147] cam-dummy-reg: disabling [ 33.758186] cam1-reg: disabling [ 115.691840] systemd-journald[146]: File /var/log/journal/ae385e4c0ba94ed8acaa75498c10ac4f/user-1000.journal corrupted or uncleanly shut down, renaming and replacing. [ 445.544506] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [ 858.539518] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [ 1271.531312] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [ 1684.555904] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [ 2097.547038] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [ 2510.548180] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [ 2923.532196] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [ 3336.524719] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [ 3749.548234] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [ 4162.544719] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [ 4575.547483] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [ 4988.548278] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [ 5401.575798] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [ 5814.572927] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [ 6227.570741] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [ 6640.593172] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [ 7053.587295] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [ 7466.617172] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [ 7879.610044] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [ 8292.603222] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [ 8705.596711] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [ 9118.632711] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [ 9531.618394] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [ 9944.611746] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [10357.606094] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [10770.631508] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [10966.376183] vc_sm_vpu_event: VC released a buffer that is already released, kernel_id 13 [11183.594611] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [11596.619365] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [12009.615876] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [12422.608499] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [12835.605966] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [13248.629223] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [13661.624297] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [14074.652942] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [14487.625504] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [14900.642715] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [15313.634871] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [15726.628234] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [16139.654140] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [16552.647272] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [16965.646589] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [17378.633923] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [17791.629420] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [18204.653766] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [18617.649622] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [19030.647156] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [19443.672653] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [19856.674236] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [20269.660984] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [20682.658368] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [21095.653101] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [21508.677502] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [21921.669538] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [22334.668399] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [22747.657461] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [23160.686115] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [23573.677941] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [23986.674642] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [24399.665537] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [24812.692688] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [25225.687801] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [25638.682351] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [26051.677477] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [26464.702766] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [26877.703032] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [27290.694843] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [27703.684322] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [28116.677958] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [28529.702490] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [28942.695922] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [29355.690818] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [29768.686018] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [30181.708332] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [30594.701632] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled

sudo vcdbg log msg sudo: vcdbg: command not found

sudo vcdbg log assert sudo: vcdbg: command not found

sudo vcdbg log ex sudo: vcdbg: command not found


Memory

cat /proc/meminfo MemTotal: 878588 kB MemFree: 124252 kB MemAvailable: 365324 kB Buffers: 45196 kB Cached: 228236 kB SwapCached: 0 kB Active: 131332 kB Inactive: 532292 kB Active(anon): 1004 kB Inactive(anon): 391968 kB Active(file): 130328 kB Inactive(file): 140324 kB Unevictable: 1960 kB Mlocked: 1960 kB SwapTotal: 0 kB SwapFree: 0 kB Dirty: 948 kB Writeback: 0 kB AnonPages: 392224 kB Mapped: 89968 kB Shmem: 1184 kB KReclaimable: 30948 kB Slab: 57004 kB SReclaimable: 30948 kB SUnreclaim: 26056 kB KernelStack: 3616 kB PageTables: 5376 kB NFS_Unstable: 0 kB Bounce: 0 kB WritebackTmp: 0 kB CommitLimit: 439292 kB Committed_AS: 919432 kB VmallocTotal: 262930368 kB VmallocUsed: 10544 kB VmallocChunk: 0 kB Percpu: 768 kB CmaTotal: 262144 kB CmaFree: 62052 kB

sudo cat /sys/kernel/debug/dma_buf/bufinfo

Dma-buf Objects: size flags mode count exp_name ino
00032768 00000002 00080007 00000001 heap_helpers 01451039 ls_grid Attached Devices: Total 0 devices attached

02564096 00000002 00080007 00000001 videobuf2_dma_contig 00530118
Attached Devices: Total 0 devices attached

Total 2 objects, 2596864 bytes

sudo cat /sys/kernel/debug/vcsm-cma/state

VC-ServiceHandle 00000000438610fc

Resources

Resource 00000000f10c3e3b NAME sm-host-resource SIZE 32768 DMABUF 0000000059ba5b45 ATTACH 0000000000000000 SGT 0000000000000000 DMA_ADDR 0x00000000df010000 VC_HANDLE c0000006 VC_MAPPING 2

Resource 00000000c584a55e NAME sm-host-resource SIZE 2564096 DMABUF 0000000095a92aa6 ATTACH 0000000000000000 SGT 0000000000000000 DMA_ADDR 0x00000000e0400000 VC_HANDLE c000000d VC_MAPPING 2

Total resource count: 2


Media Devices

media-ctl -d 0 -p Media controller API version 5.10.92

Media device information

driver bcm2835-isp model bcm2835-isp serial
bus info platform:bcm2835-isp hw revision 0x0 driver version 5.10.92

Device topology

media-ctl -d 1 -p Media controller API version 5.10.92

Media device information

driver bcm2835-isp model bcm2835-isp serial
bus info platform:bcm2835-isp hw revision 0x0 driver version 5.10.92

Device topology

media-ctl -d 2 -p Media controller API version 5.10.92

Media device information

driver bcm2835-codec model bcm2835-codec serial 0000 bus info platform:bcm2835-codec hw revision 0x1 driver version 5.10.92

Device topology

media-ctl -d 3 -p Media controller API version 5.10.92

Media device information

driver unicam model unicam serial
bus info platform:3f801000.csi hw revision 0x0 driver version 5.10.92

Device topology

media-ctl -d 4 -p Failed to enumerate /dev/media4 (-2)


Cameras

libcamera-hello --list-cameras [8:30:56.894115458] [77933] INFO Camera camera_manager.cpp:293 libcamera v0.0.0+3424-e68e0f1e [8:30:56.986647173] [77934] WARN RPI raspberrypi.cpp:1202 Mismatch between Unicam and CamHelper for embedded data usage! [8:30:56.990021587] [77934] INFO RPI raspberrypi.cpp:1317 Registered camera /base/soc/i2c0mux/i2c@1/imx219@10 to Unicam device /dev/media3 and ISP device /dev/media0 Available cameras

0 : imx219 [3280x2464] (/base/soc/i2c0mux/i2c@1/imx219@10) Modes: 'SRGGB10_CSI2P' : 640x480 1640x1232 1920x1080 3280x2464 'SRGGB8' : 640x480 1640x1232 1920x1080 3280x2464


Versions

uname -a Linux he01097 5.10.92-v8+ #1514 SMP PREEMPT Mon Jan 17 17:39:38 GMT 2022 aarch64 GNU/Linux

cat /etc/os-release PRETTY_NAME="Debian GNU/Linux 11 (bullseye)" NAME="Debian GNU/Linux" VERSION_ID="11" VERSION="11 (bullseye)" VERSION_CODENAME=bullseye ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/"

vcgencmd version Jan 20 2022 13:58:22 Copyright (c) 2012 Broadcom version bd88f66f8952d34e4e0613a85c7a6d3da49e13e2 (clean) (release) (start)

libcamera-hello --version libcamera-apps build: 0dc5ea038c79 04-03-2022 (10:35:06) libcamera build: v0.0.0+3424-e68e0f1e

naushir commented 2 years ago

Thank you for the report.

First off, your libcamera/libcamera-apps and kernel version is very out of date. I suggest you either run an update (sudo apt update && sudo apt upgrade) or start fresh with the most reason Raspberry Pi OS image release and try this again.

naushir commented 2 years ago

Are there any updates on this issue? If not, I will close this down.

naushir commented 2 years ago

Closing due to inactivity. Please re-open if you still have problems.

zahigeni commented 2 years ago

hey @naushir for now I started from the newest bullseye os image and running my app , its happen randomly and I'm waiting to see if the issue repeat itself with the updated os, will update if do

naushir commented 2 years ago

Thank you! Do let me know if you run into the problem again.