NEWS
zigbee Adapter startet nicht "unavailable Cannot lock port"
-
@thomas-braun sagte in zigbee Adapter startet nicht "unavailable Cannot lock port":
Kann sein, das der Stick falsch erkannt wird. Läuft da der ModemManager??
Ich hatte ja bereits geschrieben, dass mein TI-Board auch seit einiger Zeit zickt und nach einem Reboot des Raspi die Zigbee-Instanz mehrmals gestartet werden muss, bis es wieder läuft.
Jetzt sehe ich auch das mögliche Problem.
thomas@rpizigbee:~ $ systemctl status ModemManager.service ● ModemManager.service - Modem Manager Loaded: loaded (/lib/systemd/system/ModemManager.service; enabled; preset: enabled) Active: active (running) since Sat 2024-06-29 20:35:46 CEST; 21h ago Main PID: 629 (ModemManager) Tasks: 3 (limit: 8737) CPU: 7.216s CGroup: /system.slice/ModemManager.service └─629 /usr/sbin/ModemManager Jun 29 20:35:45 rpizigbee systemd[1]: Starting ModemManager.service - Modem Manager... Jun 29 20:35:45 rpizigbee ModemManager[629]: <info> ModemManager (version 1.20.4) starting in system bus... Jun 29 20:35:46 rpizigbee systemd[1]: Started ModemManager.service - Modem Manager. Jun 29 20:35:48 rpizigbee ModemManager[629]: <info> [base-manager] couldn't check support for device '/sys/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-> Jun 29 20:35:48 rpizigbee ModemManager[629]: <info> [base-manager] couldn't check support for device '/sys/devices/platform/scb/fd580000.ethernet': not supported by any plugin Jun 29 20:35:48 rpizigbee ModemManager[629]: <info> [base-manager] couldn't check support for device '/sys/devices/platform/soc/fe300000.mmcnr/mmc_host/mmc1/mmc1:0001/mmc1:0001:1': not s> Jun 29 20:36:32 rpizigbee ModemManager[629]: <info> [device /sys/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.3] creating modem with plugin 'gener> Jun 29 20:36:32 rpizigbee ModemManager[629]: <warn> [plugin/generic] could not grab port ttyACM1: Cannot add port 'tty/ttyACM1', unhandled port type Jun 29 20:36:32 rpizigbee ModemManager[629]: <warn> [plugin/generic] could not grab port ttyACM0: Cannot add port 'tty/ttyACM0', unhandled port type Jun 29 20:36:32 rpizigbee ModemManager[629]: <warn> [base-manager] couldn't create modem for device '/sys/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1> lines 1-19/19 (END)
-
@edonisxp sagte in zigbee Adapter startet nicht "unavailable Cannot lock port":
Aber wo stoppe ich den Modemmanager ?
sudo systemctl status ModemManager.service sudo systemctl disable ModemManager.service
Man kann den auch komplett deinstallieren.
sudo apt purge modemmanager
-
Ja danke, das war offenbar auch mein Problem.
Ich habe mal mit
sudo systemctl disable ModemManager.service
den Dienst ausgeschaltet neu gebootet, und die Zigbee-Instanz kam sofort wieder hoch.Was macht dieser Manager eigentlich?
-
-
@thomas-braun sagte in zigbee Adapter startet nicht "unavailable Cannot lock port":
Der verwaltet halt Modems.
Hab' ihn 'gepurged', jetzt ist zum Glück wieder Ruhe im Zigbee-Karton.
-
@meister-mopper sagte in zigbee Adapter startet nicht "unavailable Cannot lock port":
jetzt ist zum Glück wieder Ruhe im Zigbee-Karton.
Zumidest balgen sich jetzt nicht zwei Dienste um das gleiche Gerät.
-
Also der Modem Manager lief tatsächlich, hab ihn gestoppt und deinstalliert.
Danach Stick raus und wieder rein, dann neu gestartet.Ich sehe hier nicht viel:
[Sun Jun 30 18:21:41 2024] Booting Linux on physical CPU 0x0000000000 [0x410fd083] [Sun Jun 30 18:21:41 2024] Linux version 6.6.31+rpt-rpi-v8 (serge@raspberrypi.com) (gcc-12 (Debian 12.2.0-14) 12.2.0, GNU ld (GNU Binutils for Debian) 2.40) #1 SMP PREEMPT Debian 1:6.6.31-1+rpt1 (2024-05-29) [Sun Jun 30 18:21:41 2024] KASLR enabled [Sun Jun 30 18:21:41 2024] random: crng init done [Sun Jun 30 18:21:41 2024] Machine model: Raspberry Pi 4 Model B Rev 1.1 [Sun Jun 30 18:21:41 2024] efi: UEFI not found. [Sun Jun 30 18:21:41 2024] Reserved memory: created CMA memory pool at 0x000000000e400000, size 512 MiB [Sun Jun 30 18:21:41 2024] OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool [Sun Jun 30 18:21:41 2024] OF: reserved mem: 0x000000000e400000..0x000000002e3fffff (524288 KiB) map reusable linux,cma [Sun Jun 30 18:21:41 2024] OF: reserved mem: 0x000000003ef646a0..0x000000003ef64a9f (1 KiB) nomap non-reusable nvram@1 [Sun Jun 30 18:21:41 2024] OF: reserved mem: 0x000000003ef64ae0..0x000000003ef64ecf (0 KiB) nomap non-reusable nvram@0 [Sun Jun 30 18:21:41 2024] Zone ranges: [Sun Jun 30 18:21:41 2024] DMA [mem 0x0000000000000000-0x000000003fffffff] [Sun Jun 30 18:21:41 2024] DMA32 [mem 0x0000000040000000-0x00000000fbffffff] [Sun Jun 30 18:21:41 2024] Normal empty [Sun Jun 30 18:21:41 2024] Movable zone start for each node [Sun Jun 30 18:21:41 2024] Early memory node ranges [Sun Jun 30 18:21:41 2024] node 0: [mem 0x0000000000000000-0x000000003b3fffff] [Sun Jun 30 18:21:41 2024] node 0: [mem 0x0000000040000000-0x00000000fbffffff] [Sun Jun 30 18:21:41 2024] Initmem setup node 0 [mem 0x0000000000000000-0x00000000fbffffff] [Sun Jun 30 18:21:41 2024] On node 0, zone DMA32: 19456 pages in unavailable ranges [Sun Jun 30 18:21:41 2024] On node 0, zone DMA32: 16384 pages in unavailable ranges [Sun Jun 30 18:21:41 2024] percpu: Embedded 30 pages/cpu s85672 r8192 d29016 u122880 [Sun Jun 30 18:21:41 2024] pcpu-alloc: s85672 r8192 d29016 u122880 alloc=30*4096 [Sun Jun 30 18:21:41 2024] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 [Sun Jun 30 18:21:41 2024] Detected PIPT I-cache on CPU0 [Sun Jun 30 18:21:41 2024] CPU features: detected: Spectre-v2 [Sun Jun 30 18:21:41 2024] CPU features: detected: Spectre-v3a [Sun Jun 30 18:21:41 2024] CPU features: detected: Spectre-v4 [Sun Jun 30 18:21:41 2024] CPU features: detected: Spectre-BHB [Sun Jun 30 18:21:41 2024] CPU features: kernel page table isolation forced ON by KASLR [Sun Jun 30 18:21:41 2024] CPU features: detected: Kernel page table isolation (KPTI) [Sun Jun 30 18:21:41 2024] CPU features: detected: ARM erratum 1742098 [Sun Jun 30 18:21:41 2024] CPU features: detected: ARM errata 1165522, 1319367, or 1530923 [Sun Jun 30 18:21:41 2024] alternatives: applying boot alternatives [Sun Jun 30 18:21:41 2024] Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_headphones=0 snd_bcm2835.enable_headphones=1 snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_hdmi=0 smsc95xx.macaddr=DC:A6:32:5B:71:67 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 console=ttyS0,115200 console=tty1 root=PARTUUID=92008878-02 rootfstype=ext4 fsck.repair=yes rootwait [Sun Jun 30 18:21:41 2024] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) [Sun Jun 30 18:21:41 2024] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) [Sun Jun 30 18:21:41 2024] Built 1 zonelists, mobility grouping on. Total pages: 996912 [Sun Jun 30 18:21:41 2024] mem auto-init: stack:all(zero), heap alloc:off, heap free:off [Sun Jun 30 18:21:41 2024] software IO TLB: area num 4. [Sun Jun 30 18:21:41 2024] software IO TLB: mapped [mem 0x0000000037400000-0x000000003b400000] (64MB) [Sun Jun 30 18:21:41 2024] Memory: 3342616K/4050944K available (13376K kernel code, 2210K rwdata, 4264K rodata, 4864K init, 1083K bss, 184040K reserved, 524288K cma-reserved) [Sun Jun 30 18:21:41 2024] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [Sun Jun 30 18:21:41 2024] ftrace: allocating 43180 entries in 169 pages [Sun Jun 30 18:21:41 2024] ftrace: allocated 169 pages with 4 groups [Sun Jun 30 18:21:41 2024] trace event string verifier disabled [Sun Jun 30 18:21:41 2024] rcu: Preemptible hierarchical RCU implementation. [Sun Jun 30 18:21:41 2024] rcu: RCU event tracing is enabled. [Sun Jun 30 18:21:41 2024] rcu: RCU restricting CPUs from NR_CPUS=256 to nr_cpu_ids=4. [Sun Jun 30 18:21:41 2024] Trampoline variant of Tasks RCU enabled. [Sun Jun 30 18:21:41 2024] Rude variant of Tasks RCU enabled. [Sun Jun 30 18:21:41 2024] Tracing variant of Tasks RCU enabled. [Sun Jun 30 18:21:41 2024] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. [Sun Jun 30 18:21:41 2024] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [Sun Jun 30 18:21:41 2024] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 [Sun Jun 30 18:21:41 2024] Root IRQ handler: gic_handle_irq [Sun Jun 30 18:21:41 2024] GIC: Using split EOI/Deactivate mode [Sun Jun 30 18:21:41 2024] rcu: srcu_init: Setting srcu_struct sizes based on contention. [Sun Jun 30 18:21:41 2024] arch_timer: cp15 timer(s) running at 54.00MHz (phys). [Sun Jun 30 18:21:41 2024] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0xc743ce346, max_idle_ns: 440795203123 ns [Sun Jun 30 18:21:41 2024] sched_clock: 56 bits at 54MHz, resolution 18ns, wraps every 4398046511102ns [Sun Jun 30 18:21:41 2024] Console: colour dummy device 80x25 [Sun Jun 30 18:21:41 2024] printk: console [tty1] enabled [Sun Jun 30 18:21:41 2024] Calibrating delay loop (skipped), value calculated using timer frequency.. 108.00 BogoMIPS (lpj=216000) [Sun Jun 30 18:21:41 2024] pid_max: default: 32768 minimum: 301 [Sun Jun 30 18:21:41 2024] LSM: initializing lsm=capability,integrity [Sun Jun 30 18:21:41 2024] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) [Sun Jun 30 18:21:41 2024] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) [Sun Jun 30 18:21:41 2024] cgroup: Disabling memory control group subsystem [Sun Jun 30 18:21:41 2024] RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. [Sun Jun 30 18:21:41 2024] RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. [Sun Jun 30 18:21:41 2024] RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. [Sun Jun 30 18:21:41 2024] rcu: Hierarchical SRCU implementation. [Sun Jun 30 18:21:41 2024] rcu: Max phase no-delay instances is 1000. [Sun Jun 30 18:21:41 2024] EFI services will not be available. [Sun Jun 30 18:21:41 2024] smp: Bringing up secondary CPUs ... [Sun Jun 30 18:21:41 2024] Detected PIPT I-cache on CPU1 [Sun Jun 30 18:21:41 2024] CPU1: Booted secondary processor 0x0000000001 [0x410fd083] [Sun Jun 30 18:21:41 2024] Detected PIPT I-cache on CPU2 [Sun Jun 30 18:21:41 2024] CPU2: Booted secondary processor 0x0000000002 [0x410fd083] [Sun Jun 30 18:21:41 2024] Detected PIPT I-cache on CPU3 [Sun Jun 30 18:21:41 2024] CPU3: Booted secondary processor 0x0000000003 [0x410fd083] [Sun Jun 30 18:21:41 2024] smp: Brought up 1 node, 4 CPUs [Sun Jun 30 18:21:41 2024] SMP: Total of 4 processors activated. [Sun Jun 30 18:21:41 2024] CPU features: detected: 32-bit EL0 Support [Sun Jun 30 18:21:41 2024] CPU features: detected: 32-bit EL1 Support [Sun Jun 30 18:21:41 2024] CPU features: detected: CRC32 instructions [Sun Jun 30 18:21:41 2024] CPU: All CPU(s) started at EL2 [Sun Jun 30 18:21:41 2024] alternatives: applying system-wide alternatives [Sun Jun 30 18:21:41 2024] devtmpfs: initialized [Sun Jun 30 18:21:41 2024] Enabled cp15_barrier support [Sun Jun 30 18:21:41 2024] Enabled setend support [Sun Jun 30 18:21:41 2024] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns [Sun Jun 30 18:21:41 2024] futex hash table entries: 1024 (order: 4, 65536 bytes, linear) [Sun Jun 30 18:21:41 2024] pinctrl core: initialized pinctrl subsystem [Sun Jun 30 18:21:41 2024] DMI not present or invalid. [Sun Jun 30 18:21:41 2024] NET: Registered PF_NETLINK/PF_ROUTE protocol family [Sun Jun 30 18:21:41 2024] DMA: preallocated 1024 KiB GFP_KERNEL pool for atomic allocations [Sun Jun 30 18:21:41 2024] DMA: preallocated 1024 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [Sun Jun 30 18:21:41 2024] DMA: preallocated 1024 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [Sun Jun 30 18:21:41 2024] audit: initializing netlink subsys (disabled) [Sun Jun 30 18:21:41 2024] audit: type=2000 audit(0.036:1): state=initialized audit_enabled=0 res=1 [Sun Jun 30 18:21:41 2024] thermal_sys: Registered thermal governor 'step_wise' [Sun Jun 30 18:21:41 2024] cpuidle: using governor menu [Sun Jun 30 18:21:41 2024] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. [Sun Jun 30 18:21:41 2024] ASID allocator initialised with 32768 entries [Sun Jun 30 18:21:41 2024] Serial: AMBA PL011 UART driver [Sun Jun 30 18:21:41 2024] bcm2835-mbox fe00b880.mailbox: mailbox enabled [Sun Jun 30 18:21:41 2024] raspberrypi-firmware soc:firmware: Attached to firmware from 2024-05-24T15:30:04, variant start [Sun Jun 30 18:21:41 2024] raspberrypi-firmware soc:firmware: Firmware hash is 4942b7633c0ff1af1ee95a51a33b56a9dae47529 [Sun Jun 30 18:21:41 2024] Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL [Sun Jun 30 18:21:41 2024] Modules: 0 pages in range for non-PLT usage [Sun Jun 30 18:21:41 2024] Modules: 517792 pages in range for PLT usage [Sun Jun 30 18:21:41 2024] bcm2835-dma fe007000.dma-controller: DMA legacy API manager, dmachans=0x1 [Sun Jun 30 18:21:41 2024] iommu: Default domain type: Translated [Sun Jun 30 18:21:41 2024] iommu: DMA domain TLB invalidation policy: strict mode [Sun Jun 30 18:21:41 2024] SCSI subsystem initialized [Sun Jun 30 18:21:41 2024] usbcore: registered new interface driver usbfs [Sun Jun 30 18:21:41 2024] usbcore: registered new interface driver hub [Sun Jun 30 18:21:41 2024] usbcore: registered new device driver usb [Sun Jun 30 18:21:41 2024] pps_core: LinuxPPS API ver. 1 registered [Sun Jun 30 18:21:41 2024] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it> [Sun Jun 30 18:21:41 2024] PTP clock support registered [Sun Jun 30 18:21:41 2024] vgaarb: loaded [Sun Jun 30 18:21:41 2024] clocksource: Switched to clocksource arch_sys_counter [Sun Jun 30 18:21:42 2024] VFS: Disk quotas dquot_6.6.0 [Sun Jun 30 18:21:42 2024] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [Sun Jun 30 18:21:42 2024] FS-Cache: Loaded [Sun Jun 30 18:21:42 2024] CacheFiles: Loaded [Sun Jun 30 18:21:42 2024] NET: Registered PF_INET protocol family [Sun Jun 30 18:21:42 2024] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) [Sun Jun 30 18:21:42 2024] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) [Sun Jun 30 18:21:42 2024] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) [Sun Jun 30 18:21:42 2024] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) [Sun Jun 30 18:21:42 2024] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) [Sun Jun 30 18:21:42 2024] TCP: Hash tables configured (established 32768 bind 32768) [Sun Jun 30 18:21:42 2024] MPTCP token hash table entries: 4096 (order: 4, 98304 bytes, linear) [Sun Jun 30 18:21:42 2024] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) [Sun Jun 30 18:21:42 2024] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) [Sun Jun 30 18:21:42 2024] NET: Registered PF_UNIX/PF_LOCAL protocol family [Sun Jun 30 18:21:42 2024] RPC: Registered named UNIX socket transport module. [Sun Jun 30 18:21:42 2024] RPC: Registered udp transport module. [Sun Jun 30 18:21:42 2024] RPC: Registered tcp transport module. [Sun Jun 30 18:21:42 2024] RPC: Registered tcp-with-tls transport module. [Sun Jun 30 18:21:42 2024] RPC: Registered tcp NFSv4.1 backchannel transport module. [Sun Jun 30 18:21:42 2024] PCI: CLS 0 bytes, default 64 [Sun Jun 30 18:21:42 2024] Trying to unpack rootfs image as initramfs... [Sun Jun 30 18:21:42 2024] kvm [1]: IPA Size Limit: 44 bits [Sun Jun 30 18:21:42 2024] kvm [1]: vgic interrupt IRQ9 [Sun Jun 30 18:21:42 2024] kvm [1]: Hyp mode initialized successfully [Sun Jun 30 18:21:42 2024] Initialise system trusted keyrings [Sun Jun 30 18:21:42 2024] workingset: timestamp_bits=46 max_order=20 bucket_order=0 [Sun Jun 30 18:21:42 2024] zbud: loaded [Sun Jun 30 18:21:42 2024] NFS: Registering the id_resolver key type [Sun Jun 30 18:21:42 2024] Key type id_resolver registered [Sun Jun 30 18:21:42 2024] Key type id_legacy registered [Sun Jun 30 18:21:42 2024] nfs4filelayout_init: NFSv4 File Layout Driver Registering... [Sun Jun 30 18:21:42 2024] nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering... [Sun Jun 30 18:21:42 2024] Key type asymmetric registered [Sun Jun 30 18:21:42 2024] Asymmetric key parser 'x509' registered [Sun Jun 30 18:21:42 2024] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) [Sun Jun 30 18:21:42 2024] io scheduler mq-deadline registered [Sun Jun 30 18:21:42 2024] io scheduler kyber registered [Sun Jun 30 18:21:42 2024] io scheduler bfq registered [Sun Jun 30 18:21:42 2024] irq_brcmstb_l2: registered L2 intc (/soc/interrupt-controller@7ef00100, parent irq: 23) [Sun Jun 30 18:21:42 2024] pinctrl-bcm2835 fe200000.gpio: GPIO_OUT persistence: yes [Sun Jun 30 18:21:42 2024] brcm-pcie fd500000.pcie: host bridge /scb/pcie@7d500000 ranges: [Sun Jun 30 18:21:42 2024] brcm-pcie fd500000.pcie: No bus range found for /scb/pcie@7d500000, using [bus 00-ff] [Sun Jun 30 18:21:42 2024] brcm-pcie fd500000.pcie: MEM 0x0600000000..0x063fffffff -> 0x00c0000000 [Sun Jun 30 18:21:42 2024] brcm-pcie fd500000.pcie: IB MEM 0x0000000000..0x00bfffffff -> 0x0400000000 [Sun Jun 30 18:21:42 2024] brcm-pcie fd500000.pcie: PCI host bridge to bus 0000:00 [Sun Jun 30 18:21:42 2024] pci_bus 0000:00: root bus resource [bus 00-ff] [Sun Jun 30 18:21:42 2024] pci_bus 0000:00: root bus resource [mem 0x600000000-0x63fffffff] (bus address [0xc0000000-0xffffffff]) [Sun Jun 30 18:21:42 2024] pci 0000:00:00.0: [14e4:2711] type 01 class 0x060400 [Sun Jun 30 18:21:42 2024] pci 0000:00:00.0: PME# supported from D0 D3hot [Sun Jun 30 18:21:42 2024] pci 0000:00:00.0: bridge configuration invalid ([bus 00-00]), reconfiguring [Sun Jun 30 18:21:42 2024] pci_bus 0000:01: supply vpcie3v3 not found, using dummy regulator [Sun Jun 30 18:21:42 2024] pci_bus 0000:01: supply vpcie3v3aux not found, using dummy regulator [Sun Jun 30 18:21:42 2024] pci_bus 0000:01: supply vpcie12v not found, using dummy regulator [Sun Jun 30 18:21:42 2024] brcm-pcie fd500000.pcie: link up, 5.0 GT/s PCIe x1 (SSC) [Sun Jun 30 18:21:42 2024] pci 0000:01:00.0: [1106:3483] type 00 class 0x0c0330 [Sun Jun 30 18:21:42 2024] pci 0000:01:00.0: reg 0x10: [mem 0x00000000-0x00000fff 64bit] [Sun Jun 30 18:21:42 2024] pci 0000:01:00.0: PME# supported from D0 D3cold [Sun Jun 30 18:21:42 2024] pci_bus 0000:01: busn_res: [bus 01-ff] end is updated to 01 [Sun Jun 30 18:21:42 2024] pci 0000:00:00.0: BAR 8: assigned [mem 0x600000000-0x6000fffff] [Sun Jun 30 18:21:42 2024] pci 0000:01:00.0: BAR 0: assigned [mem 0x600000000-0x600000fff 64bit] [Sun Jun 30 18:21:42 2024] pci 0000:00:00.0: PCI bridge to [bus 01] [Sun Jun 30 18:21:42 2024] pci 0000:00:00.0: bridge window [mem 0x600000000-0x6000fffff] [Sun Jun 30 18:21:42 2024] pcieport 0000:00:00.0: enabling device (0000 -> 0002) [Sun Jun 30 18:21:42 2024] pcieport 0000:00:00.0: PME: Signaling with IRQ 27 [Sun Jun 30 18:21:42 2024] pcieport 0000:00:00.0: AER: enabled with IRQ 27 [Sun Jun 30 18:21:42 2024] iproc-rng200 fe104000.rng: hwrng registered [Sun Jun 30 18:21:42 2024] vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB) [Sun Jun 30 18:21:42 2024] brd: module loaded [Sun Jun 30 18:21:42 2024] loop: module loaded [Sun Jun 30 18:21:42 2024] Loading iSCSI transport class v2.0-870. [Sun Jun 30 18:21:42 2024] bcmgenet fd580000.ethernet: GENET 5.0 EPHY: 0x0000 [Sun Jun 30 18:21:42 2024] Freeing initrd memory: 11296K [Sun Jun 30 18:21:42 2024] unimac-mdio unimac-mdio.-19: Broadcom UniMAC MDIO bus [Sun Jun 30 18:21:42 2024] usbcore: registered new device driver r8152-cfgselector [Sun Jun 30 18:21:42 2024] usbcore: registered new interface driver r8152 [Sun Jun 30 18:21:42 2024] usbcore: registered new interface driver lan78xx [Sun Jun 30 18:21:42 2024] usbcore: registered new interface driver smsc95xx [Sun Jun 30 18:21:42 2024] xhci_hcd 0000:01:00.0: enabling device (0000 -> 0002) [Sun Jun 30 18:21:42 2024] xhci_hcd 0000:01:00.0: xHCI Host Controller [Sun Jun 30 18:21:42 2024] xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 1 [Sun Jun 30 18:21:42 2024] xhci_hcd 0000:01:00.0: hcc params 0x002841eb hci version 0x100 quirks 0x0300240000000890 [Sun Jun 30 18:21:42 2024] xhci_hcd 0000:01:00.0: xHCI Host Controller [Sun Jun 30 18:21:42 2024] xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 2 [Sun Jun 30 18:21:42 2024] xhci_hcd 0000:01:00.0: Host supports USB 3.0 SuperSpeed [Sun Jun 30 18:21:42 2024] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.06 [Sun Jun 30 18:21:42 2024] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [Sun Jun 30 18:21:42 2024] usb usb1: Product: xHCI Host Controller [Sun Jun 30 18:21:42 2024] usb usb1: Manufacturer: Linux 6.6.31+rpt-rpi-v8 xhci-hcd [Sun Jun 30 18:21:42 2024] usb usb1: SerialNumber: 0000:01:00.0 [Sun Jun 30 18:21:42 2024] hub 1-0:1.0: USB hub found [Sun Jun 30 18:21:42 2024] hub 1-0:1.0: 1 port detected [Sun Jun 30 18:21:42 2024] usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 6.06 [Sun Jun 30 18:21:42 2024] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [Sun Jun 30 18:21:42 2024] usb usb2: Product: xHCI Host Controller [Sun Jun 30 18:21:42 2024] usb usb2: Manufacturer: Linux 6.6.31+rpt-rpi-v8 xhci-hcd [Sun Jun 30 18:21:42 2024] usb usb2: SerialNumber: 0000:01:00.0 [Sun Jun 30 18:21:42 2024] hub 2-0:1.0: USB hub found [Sun Jun 30 18:21:42 2024] hub 2-0:1.0: 4 ports detected [Sun Jun 30 18:21:42 2024] dwc_otg: version 3.00a 10-AUG-2012 (platform bus) [Sun Jun 30 18:21:42 2024] dwc_otg: FIQ enabled [Sun Jun 30 18:21:42 2024] dwc_otg: NAK holdoff enabled [Sun Jun 30 18:21:42 2024] dwc_otg: FIQ split-transaction FSM enabled [Sun Jun 30 18:21:42 2024] Module dwc_common_port init [Sun Jun 30 18:21:42 2024] usbcore: registered new interface driver uas [Sun Jun 30 18:21:42 2024] usbcore: registered new interface driver usb-storage [Sun Jun 30 18:21:42 2024] mousedev: PS/2 mouse device common for all mice [Sun Jun 30 18:21:42 2024] sdhci: Secure Digital Host Controller Interface driver [Sun Jun 30 18:21:42 2024] sdhci: Copyright(c) Pierre Ossman [Sun Jun 30 18:21:42 2024] sdhci-pltfm: SDHCI platform and OF driver helper [Sun Jun 30 18:21:42 2024] ledtrig-cpu: registered to indicate activity on CPUs [Sun Jun 30 18:21:42 2024] hid: raw HID events driver (C) Jiri Kosina [Sun Jun 30 18:21:42 2024] usbcore: registered new interface driver usbhid [Sun Jun 30 18:21:42 2024] usbhid: USB HID core driver [Sun Jun 30 18:21:42 2024] hw perfevents: enabled with armv8_cortex_a72 PMU driver, 7 counters available [Sun Jun 30 18:21:42 2024] NET: Registered PF_PACKET protocol family [Sun Jun 30 18:21:42 2024] Key type dns_resolver registered [Sun Jun 30 18:21:42 2024] registered taskstats version 1 [Sun Jun 30 18:21:42 2024] Loading compiled-in X.509 certificates [Sun Jun 30 18:21:42 2024] Key type .fscrypt registered [Sun Jun 30 18:21:42 2024] Key type fscrypt-provisioning registered [Sun Jun 30 18:21:42 2024] uart-pl011 fe201000.serial: there is not valid maps for state default [Sun Jun 30 18:21:42 2024] uart-pl011 fe201000.serial: cts_event_workaround enabled [Sun Jun 30 18:21:42 2024] fe201000.serial: ttyAMA1 at MMIO 0xfe201000 (irq = 36, base_baud = 0) is a PL011 rev2 [Sun Jun 30 18:21:42 2024] serial serial0: tty port ttyAMA1 registered [Sun Jun 30 18:21:42 2024] bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer [Sun Jun 30 18:21:42 2024] bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver [Sun Jun 30 18:21:42 2024] mmc-bcm2835 fe300000.mmcnr: mmc_debug:0 mmc_debug2:0 [Sun Jun 30 18:21:42 2024] mmc-bcm2835 fe300000.mmcnr: DMA channel allocated [Sun Jun 30 18:21:42 2024] of_cfs_init [Sun Jun 30 18:21:42 2024] of_cfs_init: OK [Sun Jun 30 18:21:42 2024] clk: Disabling unused clocks [Sun Jun 30 18:21:42 2024] mmc0: SDHCI controller on fe340000.mmc [fe340000.mmc] using ADMA [Sun Jun 30 18:21:42 2024] Freeing unused kernel memory: 4864K [Sun Jun 30 18:21:42 2024] Run /init as init process [Sun Jun 30 18:21:42 2024] with arguments: [Sun Jun 30 18:21:42 2024] /init [Sun Jun 30 18:21:42 2024] with environment: [Sun Jun 30 18:21:42 2024] HOME=/ [Sun Jun 30 18:21:42 2024] TERM=linux [Sun Jun 30 18:21:43 2024] mmc1: new high speed SDIO card at address 0001 [Sun Jun 30 18:21:43 2024] mmc0: new ultra high speed DDR50 SDHC card at address 0001 [Sun Jun 30 18:21:43 2024] mmcblk0: mmc0:0001 EB1QT 29.8 GiB [Sun Jun 30 18:21:43 2024] mmcblk0: p1 p2 [Sun Jun 30 18:21:43 2024] mmcblk0: mmc0:0001 EB1QT 29.8 GiB [Sun Jun 30 18:21:43 2024] usb 1-1: new high-speed USB device number 2 using xhci_hcd [Sun Jun 30 18:21:43 2024] usb 1-1: New USB device found, idVendor=2109, idProduct=3431, bcdDevice= 4.21 [Sun Jun 30 18:21:43 2024] usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0 [Sun Jun 30 18:21:43 2024] usb 1-1: Product: USB2.0 Hub [Sun Jun 30 18:21:43 2024] hub 1-1:1.0: USB hub found [Sun Jun 30 18:21:43 2024] hub 1-1:1.0: 4 ports detected [Sun Jun 30 18:21:43 2024] brcmstb-i2c fef04500.i2c: @97500hz registered in polling mode [Sun Jun 30 18:21:43 2024] brcmstb-i2c fef09500.i2c: @97500hz registered in polling mode [Sun Jun 30 18:21:43 2024] usb 1-1.3: new full-speed USB device number 3 using xhci_hcd [Sun Jun 30 18:21:43 2024] usb 1-1.3: New USB device found, idVendor=0a12, idProduct=0001, bcdDevice=88.91 [Sun Jun 30 18:21:43 2024] usb 1-1.3: New USB device strings: Mfr=0, Product=2, SerialNumber=0 [Sun Jun 30 18:21:43 2024] usb 1-1.3: Product: CSR8510 A10 [Sun Jun 30 18:21:43 2024] usb 1-1.4: new full-speed USB device number 4 using xhci_hcd [Sun Jun 30 18:21:44 2024] usb 1-1.4: New USB device found, idVendor=0451, idProduct=16c8, bcdDevice= 1.00 [Sun Jun 30 18:21:44 2024] usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [Sun Jun 30 18:21:44 2024] usb 1-1.4: Product: CC2538 USB CDC [Sun Jun 30 18:21:44 2024] usb 1-1.4: Manufacturer: Texas Instruments [Sun Jun 30 18:21:44 2024] EXT4-fs (mmcblk0p2): mounted filesystem 93c89e92-8f2e-4522-ad32-68faed883d2f ro with ordered data mode. Quota mode: none. [Sun Jun 30 18:21:45 2024] systemd[1]: System time before build time, advancing clock. [Sun Jun 30 18:21:45 2024] NET: Registered PF_INET6 protocol family [Sun Jun 30 18:21:45 2024] Segment Routing with IPv6 [Sun Jun 30 18:21:45 2024] In-situ OAM (IOAM) with IPv6 [Sun Jun 30 18:21:45 2024] systemd[1]: systemd 252.26-1~deb12u2 running in system mode (+PAM +AUDIT +SELINUX +APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP +SYSVINIT default-hierarchy=unified) [Sun Jun 30 18:21:45 2024] systemd[1]: Detected architecture arm64. [Sun Jun 30 18:21:45 2024] systemd[1]: Hostname set to <pi>. [Sun Jun 30 18:21:46 2024] systemd[1]: Queued start job for default target multi-user.target. [Sun Jun 30 18:21:46 2024] systemd[1]: Created slice system-getty.slice - Slice /system/getty. [Sun Jun 30 18:21:46 2024] systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. [Sun Jun 30 18:21:46 2024] systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. [Sun Jun 30 18:21:46 2024] systemd[1]: Created slice user.slice - User and Session Slice. [Sun Jun 30 18:21:46 2024] systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. [Sun Jun 30 18:21:46 2024] systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. [Sun Jun 30 18:21:46 2024] systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. [Sun Jun 30 18:21:46 2024] systemd[1]: Expecting device dev-disk-by\x2dpartuuid-92008878\x2d01.device - /dev/disk/by-partuuid/92008878-01... [Sun Jun 30 18:21:46 2024] systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. [Sun Jun 30 18:21:46 2024] systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. [Sun Jun 30 18:21:46 2024] systemd[1]: Reached target paths.target - Path Units. [Sun Jun 30 18:21:46 2024] systemd[1]: Reached target slices.target - Slice Units. [Sun Jun 30 18:21:46 2024] systemd[1]: Reached target swap.target - Swaps. [Sun Jun 30 18:21:46 2024] systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. [Sun Jun 30 18:21:46 2024] systemd[1]: Listening on systemd-fsckd.socket - fsck to fsckd communication Socket. [Sun Jun 30 18:21:46 2024] systemd[1]: Listening on systemd-initctl.socket - initctl Compatibility Named Pipe. [Sun Jun 30 18:21:46 2024] systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. [Sun Jun 30 18:21:46 2024] systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). [Sun Jun 30 18:21:46 2024] systemd[1]: Listening on systemd-journald.socket - Journal Socket. [Sun Jun 30 18:21:46 2024] systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. [Sun Jun 30 18:21:46 2024] systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. [Sun Jun 30 18:21:46 2024] systemd[1]: dev-hugepages.mount - Huge Pages File System was skipped because of an unmet condition check (ConditionPathExists=/sys/kernel/mm/hugepages). [Sun Jun 30 18:21:46 2024] systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... [Sun Jun 30 18:21:46 2024] systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... [Sun Jun 30 18:21:46 2024] systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... [Sun Jun 30 18:21:46 2024] systemd[1]: auth-rpcgss-module.service - Kernel Module supporting RPCSEC_GSS was skipped because of an unmet condition check (ConditionPathExists=/etc/krb5.keytab). [Sun Jun 30 18:21:46 2024] systemd[1]: Starting fake-hwclock.service - Restore / save the current clock... [Sun Jun 30 18:21:46 2024] systemd[1]: Starting keyboard-setup.service - Set the console keyboard layout... [Sun Jun 30 18:21:46 2024] systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... [Sun Jun 30 18:21:46 2024] systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... [Sun Jun 30 18:21:46 2024] systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... [Sun Jun 30 18:21:46 2024] systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... [Sun Jun 30 18:21:46 2024] systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... [Sun Jun 30 18:21:46 2024] systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... [Sun Jun 30 18:21:46 2024] systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... [Sun Jun 30 18:21:46 2024] systemd[1]: systemd-fsck-root.service - File System Check on Root Device was skipped because of an unmet condition check (ConditionPathExists=!/run/initramfs/fsck-root). [Sun Jun 30 18:21:46 2024] systemd[1]: Starting systemd-journald.service - Journal Service... [Sun Jun 30 18:21:46 2024] systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... [Sun Jun 30 18:21:46 2024] systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... [Sun Jun 30 18:21:46 2024] device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com [Sun Jun 30 18:21:46 2024] systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... [Sun Jun 30 18:21:46 2024] systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. [Sun Jun 30 18:21:46 2024] systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. [Sun Jun 30 18:21:46 2024] systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. [Sun Jun 30 18:21:46 2024] systemd[1]: Finished fake-hwclock.service - Restore / save the current clock. [Sun Jun 30 18:21:46 2024] systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. [Sun Jun 30 18:21:46 2024] systemd[1]: modprobe@configfs.service: Deactivated successfully. [Sun Jun 30 18:21:46 2024] fuse: init (API version 7.39) [Sun Jun 30 18:21:46 2024] systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. [Sun Jun 30 18:21:46 2024] systemd[1]: modprobe@dm_mod.service: Deactivated successfully. [Sun Jun 30 18:21:46 2024] systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. [Sun Jun 30 18:21:46 2024] systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. [Sun Jun 30 18:21:46 2024] systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. [Sun Jun 30 18:21:46 2024] systemd[1]: modprobe@fuse.service: Deactivated successfully. [Sun Jun 30 18:21:46 2024] systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. [Sun Jun 30 18:21:46 2024] systemd[1]: modprobe@loop.service: Deactivated successfully. [Sun Jun 30 18:21:46 2024] systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. [Sun Jun 30 18:21:46 2024] systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. [Sun Jun 30 18:21:46 2024] systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... [Sun Jun 30 18:21:46 2024] EXT4-fs (mmcblk0p2): re-mounted 93c89e92-8f2e-4522-ad32-68faed883d2f r/w. Quota mode: none. [Sun Jun 30 18:21:46 2024] systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... [Sun Jun 30 18:21:46 2024] systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. [Sun Jun 30 18:21:46 2024] systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... [Sun Jun 30 18:21:46 2024] systemd[1]: modprobe@drm.service: Deactivated successfully. [Sun Jun 30 18:21:46 2024] systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. [Sun Jun 30 18:21:46 2024] systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. [Sun Jun 30 18:21:46 2024] systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. [Sun Jun 30 18:21:46 2024] systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. [Sun Jun 30 18:21:46 2024] systemd[1]: systemd-firstboot.service - First Boot Wizard was skipped because of an unmet condition check (ConditionFirstBoot=yes). [Sun Jun 30 18:21:46 2024] systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). [Sun Jun 30 18:21:46 2024] systemd[1]: Starting systemd-random-seed.service - Load/Save Random Seed... [Sun Jun 30 18:21:46 2024] systemd[1]: Starting systemd-sysusers.service - Create System Users... [Sun Jun 30 18:21:46 2024] systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. [Sun Jun 30 18:21:46 2024] systemd[1]: Finished systemd-random-seed.service - Load/Save Random Seed. [Sun Jun 30 18:21:46 2024] systemd[1]: first-boot-complete.target - First Boot Complete was skipped because of an unmet condition check (ConditionFirstBoot=yes). [Sun Jun 30 18:21:46 2024] systemd[1]: Started systemd-journald.service - Journal Service. [Sun Jun 30 18:21:46 2024] systemd-journald[235]: Received client request to flush runtime journal. [Sun Jun 30 18:21:46 2024] systemd-journald[235]: File /var/log/journal/8e664e7ed3a84458a859152e4c106792/system.journal corrupted or uncleanly shut down, renaming and replacing. [Sun Jun 30 18:21:47 2024] mc: Linux media interface: v0.10 [Sun Jun 30 18:21:47 2024] vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned. [Sun Jun 30 18:21:47 2024] rpi-gpiomem fe200000.gpiomem: window base 0xfe200000 size 0x00001000 [Sun Jun 30 18:21:47 2024] rpi-gpiomem fe200000.gpiomem: initialised 1 regions as /dev/gpiomem [Sun Jun 30 18:21:48 2024] bcm2835_vc_sm_cma_probe: Videocore shared memory driver [Sun Jun 30 18:21:48 2024] [vc_sm_connected_init]: start [Sun Jun 30 18:21:48 2024] snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned. [Sun Jun 30 18:21:48 2024] [vc_sm_connected_init]: installed successfully [Sun Jun 30 18:21:48 2024] videodev: Linux video capture interface: v2.00 [Sun Jun 30 18:21:48 2024] bcm2835_audio bcm2835_audio: card created with 8 channels [Sun Jun 30 18:21:48 2024] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. [Sun Jun 30 18:21:48 2024] bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned. [Sun Jun 30 18:21:48 2024] bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned. [Sun Jun 30 18:21:48 2024] bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13 [Sun Jun 30 18:21:48 2024] bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14 [Sun Jun 30 18:21:48 2024] bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15 [Sun Jun 30 18:21:48 2024] bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16 [Sun Jun 30 18:21:48 2024] bcm2835-isp bcm2835-isp: Register output node 0 with media controller [Sun Jun 30 18:21:48 2024] bcm2835-isp bcm2835-isp: Register capture node 1 with media controller [Sun Jun 30 18:21:48 2024] bcm2835-isp bcm2835-isp: Register capture node 2 with media controller [Sun Jun 30 18:21:48 2024] bcm2835-isp bcm2835-isp: Register capture node 3 with media controller [Sun Jun 30 18:21:48 2024] [drm] Initialized v3d 1.0.0 20180419 for fec00000.v3d on minor 0 [Sun Jun 30 18:21:48 2024] rpivid_hevc: module is from the staging directory, the quality is unknown, you have been warned. [Sun Jun 30 18:21:48 2024] bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned. [Sun Jun 30 18:21:48 2024] rpivid feb10000.codec: Device registered as /dev/video19 [Sun Jun 30 18:21:48 2024] bcm2835-codec bcm2835-codec: Device registered as /dev/video10 [Sun Jun 30 18:21:48 2024] bcm2835-codec bcm2835-codec: Loaded V4L2 decode [Sun Jun 30 18:21:48 2024] bcm2835-codec bcm2835-codec: Device registered as /dev/video11 [Sun Jun 30 18:21:48 2024] bcm2835-codec bcm2835-codec: Loaded V4L2 encode [Sun Jun 30 18:21:48 2024] bcm2835-codec bcm2835-codec: Device registered as /dev/video12 [Sun Jun 30 18:21:48 2024] bcm2835-codec bcm2835-codec: Loaded V4L2 isp [Sun Jun 30 18:21:48 2024] bcm2835-codec bcm2835-codec: Device registered as /dev/video18 [Sun Jun 30 18:21:48 2024] bcm2835-codec bcm2835-codec: Loaded V4L2 image_fx [Sun Jun 30 18:21:48 2024] bcm2835-codec bcm2835-codec: Device registered as /dev/video31 [Sun Jun 30 18:21:48 2024] bcm2835-codec bcm2835-codec: Loaded V4L2 encode_image [Sun Jun 30 18:21:48 2024] bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video20 [Sun Jun 30 18:21:48 2024] bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video21 [Sun Jun 30 18:21:48 2024] bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video22 [Sun Jun 30 18:21:48 2024] bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video23 [Sun Jun 30 18:21:48 2024] bcm2835-isp bcm2835-isp: Register output node 0 with media controller [Sun Jun 30 18:21:48 2024] bcm2835-isp bcm2835-isp: Register capture node 1 with media controller [Sun Jun 30 18:21:48 2024] bcm2835-isp bcm2835-isp: Register capture node 2 with media controller [Sun Jun 30 18:21:48 2024] bcm2835-isp bcm2835-isp: Register capture node 3 with media controller [Sun Jun 30 18:21:48 2024] Bluetooth: Core ver 2.22 [Sun Jun 30 18:21:48 2024] NET: Registered PF_BLUETOOTH protocol family [Sun Jun 30 18:21:48 2024] Bluetooth: HCI device and connection manager initialized [Sun Jun 30 18:21:48 2024] Bluetooth: HCI socket layer initialized [Sun Jun 30 18:21:48 2024] Bluetooth: L2CAP socket layer initialized [Sun Jun 30 18:21:48 2024] Bluetooth: SCO socket layer initialized [Sun Jun 30 18:21:48 2024] cfg80211: Loading compiled-in X.509 certificates for regulatory database [Sun Jun 30 18:21:48 2024] Loaded X.509 cert 'benh@debian.org: 577e021cb980e0e820821ba7b54b4961b8b4fadf' [Sun Jun 30 18:21:48 2024] Loaded X.509 cert 'romain.perier@gmail.com: 3abbc6ec146e09d1b6016ab9d6cf71dd233f0328' [Sun Jun 30 18:21:48 2024] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' [Sun Jun 30 18:21:48 2024] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' [Sun Jun 30 18:21:48 2024] bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp [Sun Jun 30 18:21:48 2024] Bluetooth: HCI UART driver ver 2.3 [Sun Jun 30 18:21:48 2024] Bluetooth: HCI UART protocol H4 registered [Sun Jun 30 18:21:48 2024] Bluetooth: HCI UART protocol Three-wire (H5) registered [Sun Jun 30 18:21:48 2024] Bluetooth: HCI UART protocol Broadcom registered [Sun Jun 30 18:21:48 2024] hci_uart_bcm serial0-0: supply vbat not found, using dummy regulator [Sun Jun 30 18:21:48 2024] hci_uart_bcm serial0-0: supply vddio not found, using dummy regulator [Sun Jun 30 18:21:49 2024] uart-pl011 fe201000.serial: no DMA platform data [Sun Jun 30 18:21:49 2024] Bluetooth: hci0: CSR: Setting up dongle with HCI ver=6 rev=22bb [Sun Jun 30 18:21:49 2024] Bluetooth: hci0: LMP ver=6 subver=22bb; manufacturer=10 [Sun Jun 30 18:21:49 2024] brcmfmac: F1 signature read @0x18000000=0x15264345 [Sun Jun 30 18:21:49 2024] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6 [Sun Jun 30 18:21:49 2024] usbcore: registered new interface driver brcmfmac [Sun Jun 30 18:21:49 2024] usbcore: registered new interface driver btusb [Sun Jun 30 18:21:49 2024] cdc_acm 1-1.4:1.0: ttyACM0: USB ACM device [Sun Jun 30 18:21:49 2024] usbcore: registered new interface driver cdc_acm [Sun Jun 30 18:21:49 2024] cdc_acm: USB Abstract Control Model driver for USB modems and ISDN adapters [Sun Jun 30 18:21:49 2024] Bluetooth: hci1: BCM: chip id 107 [Sun Jun 30 18:21:49 2024] Bluetooth: hci1: BCM: features 0x2f [Sun Jun 30 18:21:49 2024] Bluetooth: hci1: BCM4345C0 [Sun Jun 30 18:21:49 2024] Bluetooth: hci1: BCM4345C0 (003.001.025) build 0000 [Sun Jun 30 18:21:49 2024] Bluetooth: hci1: BCM4345C0 'brcm/BCM4345C0.raspberrypi,4-model-b.hcd' Patch [Sun Jun 30 18:21:49 2024] vc4-drm gpu: bound fe400000.hvs (ops vc4_hvs_ops [vc4]) [Sun Jun 30 18:21:49 2024] Registered IR keymap rc-cec [Sun Jun 30 18:21:49 2024] rc rc0: vc4-hdmi-0 as /devices/platform/soc/fef00700.hdmi/rc/rc0 [Sun Jun 30 18:21:49 2024] input: vc4-hdmi-0 as /devices/platform/soc/fef00700.hdmi/rc/rc0/input0 [Sun Jun 30 18:21:49 2024] input: vc4-hdmi-0 HDMI Jack as /devices/platform/soc/fef00700.hdmi/sound/card1/input1 [Sun Jun 30 18:21:49 2024] vc4-drm gpu: bound fef00700.hdmi (ops vc4_hdmi_ops [vc4]) [Sun Jun 30 18:21:49 2024] Registered IR keymap rc-cec [Sun Jun 30 18:21:49 2024] rc rc1: vc4-hdmi-1 as /devices/platform/soc/fef05700.hdmi/rc/rc1 [Sun Jun 30 18:21:49 2024] input: vc4-hdmi-1 as /devices/platform/soc/fef05700.hdmi/rc/rc1/input2 [Sun Jun 30 18:21:49 2024] input: vc4-hdmi-1 HDMI Jack as /devices/platform/soc/fef05700.hdmi/sound/card2/input3 [Sun Jun 30 18:21:49 2024] vc4-drm gpu: bound fef05700.hdmi (ops vc4_hdmi_ops [vc4]) [Sun Jun 30 18:21:49 2024] vc4-drm gpu: bound fe004000.txp (ops vc4_txp_ops [vc4]) [Sun Jun 30 18:21:49 2024] vc4-drm gpu: bound fe206000.pixelvalve (ops vc4_crtc_ops [vc4]) [Sun Jun 30 18:21:49 2024] vc4-drm gpu: bound fe207000.pixelvalve (ops vc4_crtc_ops [vc4]) [Sun Jun 30 18:21:49 2024] vc4-drm gpu: bound fe20a000.pixelvalve (ops vc4_crtc_ops [vc4]) [Sun Jun 30 18:21:49 2024] vc4-drm gpu: bound fe216000.pixelvalve (ops vc4_crtc_ops [vc4]) [Sun Jun 30 18:21:49 2024] vc4-drm gpu: bound fec12000.pixelvalve (ops vc4_crtc_ops [vc4]) [Sun Jun 30 18:21:49 2024] brcmfmac: brcmf_c_process_txcap_blob: no txcap_blob available (err=-2) [Sun Jun 30 18:21:49 2024] brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM4345/6 wl0: Apr 15 2021 03:03:20 version 7.45.234 (4ca95bb CY) FWID 01-996384e2 [Sun Jun 30 18:21:49 2024] [drm] Initialized vc4 0.0.0 20140616 for gpu on minor 1 [Sun Jun 30 18:21:49 2024] vc4-drm gpu: [drm] Cannot find any crtc or sizes [Sun Jun 30 18:21:49 2024] vc4-drm gpu: [drm] Cannot find any crtc or sizes [Sun Jun 30 18:21:49 2024] vc4-drm gpu: [drm] Cannot find any crtc or sizes [Sun Jun 30 18:21:50 2024] Bluetooth: hci1: BCM: features 0x2f [Sun Jun 30 18:21:50 2024] Bluetooth: hci1: BCM43455 37.4MHz Raspberry Pi 3+-0190 [Sun Jun 30 18:21:50 2024] Bluetooth: hci1: BCM4345C0 (003.001.025) build 0382 [Sun Jun 30 18:21:50 2024] Adding 204796k swap on /var/swap. Priority:-2 extents:1 across:204796k SS [Sun Jun 30 18:21:50 2024] Bluetooth: BNEP (Ethernet Emulation) ver 1.3 [Sun Jun 30 18:21:50 2024] Bluetooth: BNEP filters: protocol multicast [Sun Jun 30 18:21:50 2024] Bluetooth: BNEP socket layer initialized [Sun Jun 30 18:21:50 2024] Bluetooth: MGMT ver 1.22 [Sun Jun 30 18:21:50 2024] NET: Registered PF_ALG protocol family [Sun Jun 30 18:21:50 2024] Bluetooth: MGMT ver 1.22 [Sun Jun 30 18:21:51 2024] bcmgenet fd580000.ethernet: configuring instance for external RGMII (RX delay) [Sun Jun 30 18:21:51 2024] bcmgenet fd580000.ethernet eth0: Link is Down [Sun Jun 30 18:21:51 2024] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [Sun Jun 30 18:21:53 2024] bcmgenet fd580000.ethernet eth0: Link is Up - 100Mbps/Full - flow control rx/tx [Sun Jun 30 18:21:59 2024] systemd-journald[235]: File /var/log/journal/8e664e7ed3a84458a859152e4c106792/user-1001.journal corrupted or uncleanly shut down, renaming and replacing. [Sun Jun 30 18:25:30 2024] systemd[1137]: memfd_create() called without MFD_EXEC or MFD_NOEXEC_SEAL set [Sun Jun 30 18:25:31 2024] systemd-journald[235]: File /var/log/journal/8e664e7ed3a84458a859152e4c106792/user-1000.journal corrupted or uncleanly shut down, renaming and replacing.
Die Fehlermeldung beim Start von Zigbee bleibt
-
@thomas-braun sagte in zigbee Adapter startet nicht "unavailable Cannot lock port":
@meister-mopper sagte in zigbee Adapter startet nicht "unavailable Cannot lock port":
jetzt ist zum Glück wieder Ruhe im Zigbee-Karton.
Zumidest balgen sich jetzt nicht zwei Dienste um das gleiche Gerät.
Und ich hoffe, dass dieses Thema jetzt auch für alle anderen mit ähnlichen Problemen gelöst ist.
Danke Thomas, den Rest müssen jetzt andere Betriebssystem-Entwickler machen.
-
@edonisxp sagte in zigbee Adapter startet nicht "unavailable Cannot lock port":
Ich sehe hier nicht viel:
Ich sehe da zu viel.
Bitte nur die handvoll Zeilen zeigen, die beim Einstecken des Sticks neu erscheinen. -
[Sun Jun 30 18:36:24 2024] usb 1-1.4: USB disconnect, device number 4 [Sun Jun 30 18:36:59 2024] usb 1-1.4: new full-speed USB device number 5 using xhci_hcd [Sun Jun 30 18:36:59 2024] usb 1-1.4: New USB device found, idVendor=0451, idProduct=16c8, bcdDevice= 1.00 [Sun Jun 30 18:36:59 2024] usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [Sun Jun 30 18:36:59 2024] usb 1-1.4: Product: CC2538 USB CDC [Sun Jun 30 18:36:59 2024] usb 1-1.4: Manufacturer: Texas Instruments [Sun Jun 30 18:36:59 2024] cdc_acm 1-1.4:1.0: ttyACM0: USB ACM device
-
Der service ist ausgeknipst?
sudo systemctl status ModemManager.service
sagt?
Kiste mal neugestartet?
-
Solange du als erstes die folgenden Meldungen bekommst wird der Stick korrekt erkannt, und das ganze Gehampel mit dem Modem-Manager ist ein Nebenkriegsschauplatz.
2024-06-30 16:22:09.529 - info: zigbee.0 (4896) starting. Version 1.10.3 in /opt/iobroker/node_modules/iobroker.zigbee, node: v20.15.0, js-controller: 6.0.5 2024-06-30 16:22:09.627 - info: zigbee.0 (4896) delete old Backup files. keep only last 10 2024-06-30 16:22:09.630 - info: zigbee.0 (4896) Starting Zigbee npm ... 2024-06-30 16:22:09.988 - info: zigbee.0 (4896) Installed Version: iobroker.zigbee@1.10.3 2024-06-30 16:22:44.649 - error: zigbee.0 (4896) Starting zigbee-herdsman problem : "network commissioning failed - timed out waiting for nib to settle" 2024-06-30 16:22:44.650 - error: zigbee.0 (4896) Failed to start Zigbee 2024-06-30 16:22:44.651 - error: zigbee.0 (4896) Error herdsman start
diese Meldungen:
2024-06-30 16:22:54.652 - info: zigbee.0 (4896) Try to reconnect. 1 attempts left 2024-06-30 16:22:54.653 - info: zigbee.0 (4896) Starting Zigbee npm ... 2024-06-30 16:22:54.668 - info: zigbee.0 (4896) Installed Version: iobroker.zigbee@1.10.3 2024-06-30 16:22:54.822 - error: zigbee.0 (4896) Starting zigbee-herdsman problem : "Error Resource temporarily unavailable Cannot lock port" 2024-06-30 16:22:54.823 - error: zigbee.0 (4896) Failed to start Zigbee 2024-06-30 16:22:54.824 - error: zigbee.0 (4896) Error herdsman start
Sind Folgefehler, da die Bibliothek den Port nicht wieder freigibt, und der Adapter beim Versuch erneut zu starten den Port nicht auf bekommt - er ist noch offen.
Die entscheidenden Fragen sind jetzt:
- welche Firmware ist auf dem Stick ? Erinnerst du was du darauf geflasht hast, oder hast du ggf. ältere Log-Dateien zum nachschauen
- wie sieht es um den Stick aus, insbesondere mit 2.4GHz Störquellen (USB3 Devices, DECT, WLAN, BT, aber auch Herstellerspezifische 2.4GHz dongle für Tastaturen/Mäuse/Kopfhörer, etc.
Was zumeist hilft solange die Firmware noch ok ist:
- Adapter anhalten
- Stick abziehen
- 30 Sekunden warten
- Stick wieder anstecken
- Adapter starten.
Zusätzlich kann es Sinnvoll sein den Stick an einen etwas anderen Ort zu bringen - das geht natürlich nur wenn er via USB Verlängerung angeschlossen ist. Das sollte er aber sowieso sein, da die meisten NUC / PI im 2.4GHz Bereich stören (oft durch USB3/WLan/BT)
A.
Nachtrag: Die Firmware auf den verschiedenen Sticks kann nur eine gewisse Menge an Kommunikationsproblemen abfangen bevor sie abstürzt. Daher ist davon auszugehen das mit dem Umfeld etwas nicht optimal ist wenn die Firmware regelmässig / häufig abstürzt. Ich hatte das Problem selber und habe es durch neu-platzieren des sticks lösen können.
Wichtig ist: Ein Neustart des PI / NUC führt üblicherweise keinen Hardware-Reset am USB Bus durch - nur ein Software-Reset findet statt, weswegen die Firmware erst dann neu initialisiert wird wenn der Stick stromlos wird (abschalten des PI/NUC oder abziehen des Stick) -
Der Modem Manager ist weg:
Unit ModemManager.service could not be found.Kiste neu gestartet und keine Änderung
[Sun Jun 30 18:51:21 2024] usb 1-1.3: USB disconnect, device number 3 [Sun Jun 30 18:51:21 2024] usb 1-1.4: USB disconnect, device number 4 [Sun Jun 30 18:52:04 2024] usb 1-1.4: new full-speed USB device number 5 using xhci_hcd [Sun Jun 30 18:52:04 2024] usb 1-1.4: New USB device found, idVendor=0451, idProduct=16c8, bcdDevice= 1.00 [Sun Jun 30 18:52:04 2024] usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [Sun Jun 30 18:52:04 2024] usb 1-1.4: Product: CC2538 USB CDC [Sun Jun 30 18:52:04 2024] usb 1-1.4: Manufacturer: Texas Instruments [Sun Jun 30 18:52:05 2024] cdc_acm 1-1.4:1.0: ttyACM0: USB ACM device
-
Dann halt jetzt auf die Umgebung schauen. Hat @Asgothian ja schon viel zu geschrieben.
-
Bei der Firmware müsste ich nochmal schauen.
Ich hab je örtlich nichts geändert, keine neuen Geräte oder ähnliches. Ohne erkennbaren Grund lief es einfach nicht mehr. Stick raus und wieder ein hab ich auch zig mal versucht.
-
@edonisxp sagte in zigbee Adapter startet nicht "unavailable Cannot lock port":
Ich hab je örtlich nichts geändert, keine neuen Geräte oder ähnliches.
Du hast vielleicht nicht aktiv etwas geändert. Das heisst aber nicht das alles so geblieben ist. WLAN und BT wählen ihre Frequenzen üblicherweise automatisch. Auch ein WLAN eines Nachbarn kann ggf. stören. Selbst das Umstellen einer Metalldose in der Nähe des Koordinators kann auf Grund der durch die Dose entstehenden Reflektionen der Funkwellen einen Effekt haben.
Stick an USB Kabel, und Stick anders platzieren (andere Ausrichtung ?) kann also helfen.
Die Meldung
2024-06-30 16:22:44.649 - error: zigbee.0 (4896) Starting zigbee-herdsman problem : "network commissioning failed - timed out waiting for nib to settle"
deutet darauf hin das es der Firmware nicht gelingt innerhalb von 40 Sekunden das Zigbee-Netz stabil aufzubauen. Das ist also ein Funk-Problem oder ein Firmware-Problem.
A.
-
Also ich hab die Vermutung das es tatsächlich die Firmware sein könnte.
2021 hab ich den Stick geholt und da war 20190523 drauf, ich kann mich nicht erinnern hier mal ein update gemacht zu haben, da alles bisher lief hab ich das nie beachtet. -
Hi,
Ich hatte auch häufiger das Problem, das nach einem Neustart auf den Zigbee Stick nicht zu gegriffen werden konnte.
Hab jetzt auch mal den Modem Manager raus geworfen und die letzten zwei Neustarts gingen ohne Probleme und mein Zigbee Netzwerk war gleich wieder da.
Ich hoffe es bleibt dabei.
Viele Grüße
Martin