-- Logs begin at Sat 2026-02-21 17:27:10 GMT, end at Sat 2026-02-21 17:27:27 GMT. -- Feb 21 17:27:10 pi5 kernel: Booting Linux on physical CPU 0x0000000000 [0x414fd0b1] Feb 21 17:27:10 pi5 kernel: Linux version 6.6.62-v8+ (dom@buildbot) (aarch64-linux-gnu-gcc (Ubuntu 11.4.0-1ubuntu1~22.04) 11.4.0, GNU ld (GNU Binutils for Ubuntu) 2.38) #1816 SMP PREEMPT Mon Nov 18 15:35:52 GMT 2024 Feb 21 17:27:10 pi5 kernel: KASLR enabled Feb 21 17:27:10 pi5 kernel: random: crng init done Feb 21 17:27:10 pi5 kernel: Machine model: Raspberry Pi 5 Model B Rev 1.0 Feb 21 17:27:10 pi5 kernel: efi: UEFI not found. Feb 21 17:27:10 pi5 kernel: Reserved memory: created CMA memory pool at 0x0000000001c00000, size 64 MiB Feb 21 17:27:10 pi5 kernel: OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool Feb 21 17:27:10 pi5 kernel: OF: reserved mem: 0x0000000001c00000..0x0000000005bfffff (65536 KiB) map reusable linux,cma Feb 21 17:27:10 pi5 kernel: OF: reserved mem: 0x0000000000000000..0x000000000007ffff (512 KiB) nomap non-reusable atf@0 Feb 21 17:27:10 pi5 kernel: OF: reserved mem: 0x000000003fd16240..0x000000003fd16277 (0 KiB) nomap non-reusable nvram@0 Feb 21 17:27:10 pi5 kernel: NUMA: No NUMA configuration found Feb 21 17:27:10 pi5 kernel: NUMA: Faking a node at [mem 0x0000000000000000-0x000000007fffffff] Feb 21 17:27:10 pi5 kernel: NUMA: NODE_DATA [mem 0x7fb9b3c0-0x7fb9dfff] Feb 21 17:27:10 pi5 kernel: Zone ranges: Feb 21 17:27:10 pi5 kernel: DMA [mem 0x0000000000000000-0x000000007fffffff] Feb 21 17:27:10 pi5 kernel: DMA32 empty Feb 21 17:27:10 pi5 kernel: Normal empty Feb 21 17:27:10 pi5 kernel: Movable zone start for each node Feb 21 17:27:10 pi5 kernel: Early memory node ranges Feb 21 17:27:10 pi5 kernel: node 0: [mem 0x0000000000000000-0x000000000007ffff] Feb 21 17:27:10 pi5 kernel: node 0: [mem 0x0000000000080000-0x000000003fbfffff] Feb 21 17:27:10 pi5 kernel: node 0: [mem 0x0000000040000000-0x000000007fffffff] Feb 21 17:27:10 pi5 kernel: Initmem setup node 0 [mem 0x0000000000000000-0x000000007fffffff] Feb 21 17:27:10 pi5 kernel: On node 0, zone DMA: 1024 pages in unavailable ranges Feb 21 17:27:10 pi5 kernel: psci: probing for conduit method from DT. Feb 21 17:27:10 pi5 kernel: psci: PSCIv1.1 detected in firmware. Feb 21 17:27:10 pi5 kernel: psci: Using standard PSCI v0.2 function IDs Feb 21 17:27:10 pi5 kernel: psci: MIGRATE_INFO_TYPE not supported. Feb 21 17:27:10 pi5 kernel: psci: SMC Calling Convention v1.2 Feb 21 17:27:10 pi5 kernel: percpu: Embedded 30 pages/cpu s85928 r8192 d28760 u122880 Feb 21 17:27:10 pi5 kernel: pcpu-alloc: s85928 r8192 d28760 u122880 alloc=30*4096 Feb 21 17:27:10 pi5 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Feb 21 17:27:10 pi5 kernel: Detected PIPT I-cache on CPU0 Feb 21 17:27:10 pi5 kernel: CPU features: detected: Virtualization Host Extensions Feb 21 17:27:10 pi5 kernel: CPU features: detected: Hardware dirty bit management Feb 21 17:27:10 pi5 kernel: CPU features: detected: Spectre-v4 Feb 21 17:27:10 pi5 kernel: CPU features: detected: Spectre-BHB Feb 21 17:27:10 pi5 kernel: CPU features: kernel page table isolation forced ON by KASLR Feb 21 17:27:10 pi5 kernel: CPU features: detected: Kernel page table isolation (KPTI) Feb 21 17:27:10 pi5 kernel: CPU features: detected: SSBS not fully self-synchronizing Feb 21 17:27:10 pi5 kernel: alternatives: applying boot alternatives Feb 21 17:27:10 pi5 kernel: Kernel command line: reboot=w coherent_pool=1M 8250.nr_uarts=1 pci=pcie_bus_safe cgroup_disable=memory numa_policy=interleave smsc95xx.macaddr=2C:CF:67:7A:96:1F vc_mem.mem_base=0x3fc00000 vc_mem.mem_size=0x40000000 splash plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 quiet console=ttyAMA10,115200 console=tty1 imgpart=UUID=fb80cb44-b4d3-4b36-be35-613cba0a09fb imgfile=/volumio_current.sqsh bootpart=UUID=51B1-040D datapart=UUID=2899bccc-8620-4c7a-b56a-43fd2f7a836a uuidconfig=cmdline.txt pcie_aspm=off pci=pcie_bus_safe rootwait bootdelay=7 logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd-bcm2835.enable_compat_alsa= snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 loglevel=0 nodebug use_kmsg=no Feb 21 17:27:10 pi5 kernel: cgroup: Disabling memory control group subsystem Feb 21 17:27:10 pi5 kernel: mempolicy: NUMA default policy overridden to 'interleave:0' Feb 21 17:27:10 pi5 kernel: PCIe ASPM is disabled Feb 21 17:27:10 pi5 kernel: Unknown kernel command line parameters "splash nodebug imgpart=UUID=fb80cb44-b4d3-4b36-be35-613cba0a09fb imgfile=/volumio_current.sqsh bootpart=UUID=51B1-040D datapart=UUID=2899bccc-8620-4c7a-b56a-43fd2f7a836a uuidconfig=cmdline.txt bootdelay=7 use_kmsg=no", will be passed to user space. Feb 21 17:27:10 pi5 kernel: Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Feb 21 17:27:10 pi5 kernel: Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) Feb 21 17:27:10 pi5 kernel: Fallback order for Node 0: 0 Feb 21 17:27:10 pi5 kernel: Built 1 zonelists, mobility grouping on. Total pages: 515072 Feb 21 17:27:10 pi5 kernel: Policy zone: DMA Feb 21 17:27:10 pi5 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Feb 21 17:27:10 pi5 kernel: Memory: 1931920K/2093056K available (13440K kernel code, 2208K rwdata, 4284K rodata, 4864K init, 1086K bss, 95600K reserved, 65536K cma-reserved) Feb 21 17:27:10 pi5 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Feb 21 17:27:10 pi5 kernel: ftrace: allocating 43555 entries in 171 pages Feb 21 17:27:10 pi5 kernel: ftrace: allocated 171 pages with 5 groups Feb 21 17:27:10 pi5 kernel: trace event string verifier disabled Feb 21 17:27:10 pi5 kernel: rcu: Preemptible hierarchical RCU implementation. Feb 21 17:27:10 pi5 kernel: rcu: RCU event tracing is enabled. Feb 21 17:27:10 pi5 kernel: rcu: RCU restricting CPUs from NR_CPUS=256 to nr_cpu_ids=4. Feb 21 17:27:10 pi5 kernel: Trampoline variant of Tasks RCU enabled. Feb 21 17:27:10 pi5 kernel: Rude variant of Tasks RCU enabled. Feb 21 17:27:10 pi5 kernel: Tracing variant of Tasks RCU enabled. Feb 21 17:27:10 pi5 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. Feb 21 17:27:10 pi5 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Feb 21 17:27:10 pi5 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Feb 21 17:27:10 pi5 kernel: Root IRQ handler: gic_handle_irq Feb 21 17:27:10 pi5 kernel: GIC: Using split EOI/Deactivate mode Feb 21 17:27:10 pi5 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Feb 21 17:27:10 pi5 kernel: arch_timer: cp15 timer(s) running at 54.00MHz (phys). Feb 21 17:27:10 pi5 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0xc743ce346, max_idle_ns: 440795203123 ns Feb 21 17:27:10 pi5 kernel: sched_clock: 56 bits at 54MHz, resolution 18ns, wraps every 4398046511102ns Feb 21 17:27:10 pi5 kernel: Console: colour dummy device 80x25 Feb 21 17:27:10 pi5 kernel: printk: console [tty1] enabled Feb 21 17:27:10 pi5 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 108.00 BogoMIPS (lpj=216000) Feb 21 17:27:10 pi5 kernel: pid_max: default: 32768 minimum: 301 Feb 21 17:27:10 pi5 kernel: LSM: initializing lsm=capability,integrity Feb 21 17:27:10 pi5 kernel: Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) Feb 21 17:27:10 pi5 kernel: Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) Feb 21 17:27:10 pi5 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Feb 21 17:27:10 pi5 kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Feb 21 17:27:10 pi5 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Feb 21 17:27:10 pi5 kernel: rcu: Hierarchical SRCU implementation. Feb 21 17:27:10 pi5 kernel: rcu: Max phase no-delay instances is 1000. Feb 21 17:27:10 pi5 kernel: EFI services will not be available. Feb 21 17:27:10 pi5 kernel: smp: Bringing up secondary CPUs ... Feb 21 17:27:10 pi5 kernel: Detected PIPT I-cache on CPU1 Feb 21 17:27:10 pi5 kernel: CPU1: Booted secondary processor 0x0000000100 [0x414fd0b1] Feb 21 17:27:10 pi5 kernel: Detected PIPT I-cache on CPU2 Feb 21 17:27:10 pi5 kernel: CPU2: Booted secondary processor 0x0000000200 [0x414fd0b1] Feb 21 17:27:10 pi5 kernel: Detected PIPT I-cache on CPU3 Feb 21 17:27:10 pi5 kernel: CPU3: Booted secondary processor 0x0000000300 [0x414fd0b1] Feb 21 17:27:10 pi5 kernel: smp: Brought up 1 node, 4 CPUs Feb 21 17:27:10 pi5 kernel: SMP: Total of 4 processors activated. Feb 21 17:27:10 pi5 kernel: CPU features: detected: 32-bit EL0 Support Feb 21 17:27:10 pi5 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Feb 21 17:27:10 pi5 kernel: CPU features: detected: Common not Private translations Feb 21 17:27:10 pi5 kernel: CPU features: detected: CRC32 instructions Feb 21 17:27:10 pi5 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Feb 21 17:27:10 pi5 kernel: CPU features: detected: LSE atomic instructions Feb 21 17:27:10 pi5 kernel: CPU features: detected: Privileged Access Never Feb 21 17:27:10 pi5 kernel: CPU features: detected: RAS Extension Support Feb 21 17:27:10 pi5 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Feb 21 17:27:10 pi5 kernel: CPU: All CPU(s) started at EL2 Feb 21 17:27:10 pi5 kernel: alternatives: applying system-wide alternatives Feb 21 17:27:10 pi5 kernel: devtmpfs: initialized Feb 21 17:27:10 pi5 kernel: Enabled cp15_barrier support Feb 21 17:27:10 pi5 kernel: Enabled setend support Feb 21 17:27:10 pi5 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns Feb 21 17:27:10 pi5 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Feb 21 17:27:10 pi5 kernel: pinctrl core: initialized pinctrl subsystem Feb 21 17:27:10 pi5 kernel: DMI not present or invalid. Feb 21 17:27:10 pi5 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Feb 21 17:27:10 pi5 kernel: DMA: preallocated 1024 KiB GFP_KERNEL pool for atomic allocations Feb 21 17:27:10 pi5 kernel: DMA: preallocated 1024 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Feb 21 17:27:10 pi5 kernel: DMA: preallocated 1024 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Feb 21 17:27:10 pi5 kernel: audit: initializing netlink subsys (disabled) Feb 21 17:27:10 pi5 kernel: audit: type=2000 audit(0.008:1): state=initialized audit_enabled=0 res=1 Feb 21 17:27:10 pi5 kernel: thermal_sys: Registered thermal governor 'step_wise' Feb 21 17:27:10 pi5 kernel: cpuidle: using governor menu Feb 21 17:27:10 pi5 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Feb 21 17:27:10 pi5 kernel: ASID allocator initialised with 32768 entries Feb 21 17:27:10 pi5 kernel: Serial: AMBA PL011 UART driver Feb 21 17:27:10 pi5 kernel: bcm2835-mbox 107c013880.mailbox: mailbox enabled Feb 21 17:27:10 pi5 kernel: 107d001000.serial: ttyAMA10 at MMIO 0x107d001000 (irq = 15, base_baud = 0) is a PL011 rev2 Feb 21 17:27:10 pi5 kernel: printk: console [ttyAMA10] enabled Feb 21 17:27:10 pi5 kernel: raspberrypi-firmware soc:firmware: Attached to firmware from 2024-06-05T15:41:49, variant start_cd Feb 21 17:27:10 pi5 kernel: raspberrypi-firmware soc:firmware: Firmware hash is 6fe0b09100000000000000000000000000000000 Feb 21 17:27:10 pi5 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Feb 21 17:27:10 pi5 kernel: Modules: 0 pages in range for non-PLT usage Feb 21 17:27:10 pi5 kernel: Modules: 517776 pages in range for PLT usage Feb 21 17:27:10 pi5 kernel: bcm2835-dma 1000010000.dma: DMA legacy API manager, dmachans=0x1 Feb 21 17:27:10 pi5 kernel: iommu: Default domain type: Translated Feb 21 17:27:10 pi5 kernel: iommu: DMA domain TLB invalidation policy: strict mode Feb 21 17:27:10 pi5 kernel: SCSI subsystem initialized Feb 21 17:27:10 pi5 kernel: usbcore: registered new interface driver usbfs Feb 21 17:27:10 pi5 kernel: usbcore: registered new interface driver hub Feb 21 17:27:10 pi5 kernel: usbcore: registered new device driver usb Feb 21 17:27:10 pi5 kernel: pps_core: LinuxPPS API ver. 1 registered Feb 21 17:27:10 pi5 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Feb 21 17:27:10 pi5 kernel: PTP clock support registered Feb 21 17:27:10 pi5 kernel: vgaarb: loaded Feb 21 17:27:10 pi5 kernel: clocksource: Switched to clocksource arch_sys_counter Feb 21 17:27:10 pi5 kernel: VFS: Disk quotas dquot_6.6.0 Feb 21 17:27:10 pi5 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Feb 21 17:27:10 pi5 kernel: FS-Cache: Loaded Feb 21 17:27:10 pi5 kernel: CacheFiles: Loaded Feb 21 17:27:10 pi5 kernel: NET: Registered PF_INET protocol family Feb 21 17:27:10 pi5 kernel: IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear) Feb 21 17:27:10 pi5 kernel: tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear) Feb 21 17:27:10 pi5 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Feb 21 17:27:10 pi5 kernel: TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear) Feb 21 17:27:10 pi5 kernel: TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear) Feb 21 17:27:10 pi5 kernel: TCP: Hash tables configured (established 16384 bind 16384) Feb 21 17:27:10 pi5 kernel: MPTCP token hash table entries: 2048 (order: 3, 49152 bytes, linear) Feb 21 17:27:10 pi5 kernel: UDP hash table entries: 1024 (order: 3, 32768 bytes, linear) Feb 21 17:27:10 pi5 kernel: UDP-Lite hash table entries: 1024 (order: 3, 32768 bytes, linear) Feb 21 17:27:10 pi5 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Feb 21 17:27:10 pi5 kernel: RPC: Registered named UNIX socket transport module. Feb 21 17:27:10 pi5 kernel: RPC: Registered udp transport module. Feb 21 17:27:10 pi5 kernel: RPC: Registered tcp transport module. Feb 21 17:27:10 pi5 kernel: RPC: Registered tcp-with-tls transport module. Feb 21 17:27:10 pi5 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Feb 21 17:27:10 pi5 kernel: PCI: CLS 0 bytes, default 64 Feb 21 17:27:10 pi5 kernel: Trying to unpack rootfs image as initramfs... Feb 21 17:27:10 pi5 kernel: kvm [1]: IPA Size Limit: 40 bits Feb 21 17:27:10 pi5 kernel: kvm [1]: vgic interrupt IRQ9 Feb 21 17:27:10 pi5 kernel: kvm [1]: VHE mode initialized successfully Feb 21 17:27:10 pi5 kernel: Initialise system trusted keyrings Feb 21 17:27:10 pi5 kernel: workingset: timestamp_bits=42 max_order=19 bucket_order=0 Feb 21 17:27:10 pi5 kernel: zbud: loaded Feb 21 17:27:10 pi5 kernel: NFS: Registering the id_resolver key type Feb 21 17:27:10 pi5 kernel: Key type id_resolver registered Feb 21 17:27:10 pi5 kernel: Key type id_legacy registered Feb 21 17:27:10 pi5 kernel: nfs4filelayout_init: NFSv4 File Layout Driver Registering... Feb 21 17:27:10 pi5 kernel: nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering... Feb 21 17:27:10 pi5 kernel: Key type asymmetric registered Feb 21 17:27:10 pi5 kernel: Asymmetric key parser 'x509' registered Feb 21 17:27:10 pi5 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) Feb 21 17:27:10 pi5 kernel: io scheduler mq-deadline registered Feb 21 17:27:10 pi5 kernel: io scheduler kyber registered Feb 21 17:27:10 pi5 kernel: io scheduler bfq registered Feb 21 17:27:10 pi5 kernel: irq_brcmstb_l2: registered L2 intc (/soc/interrupt-controller@7c502000, parent irq: 26) Feb 21 17:27:10 pi5 kernel: irq_brcmstb_l2: registered L2 intc (/soc/intc@7d503000, parent irq: 27) Feb 21 17:27:10 pi5 kernel: irq_brcmstb_l2: registered L2 intc (/soc/intc@7d508380, parent irq: 28) Feb 21 17:27:10 pi5 kernel: irq_brcmstb_l2: registered L2 intc (/soc/intc@7d508400, parent irq: 29) Feb 21 17:27:10 pi5 kernel: irq_brcmstb_l2: registered L2 intc (/soc/interrupt-controller@7d510600, parent irq: 30) Feb 21 17:27:10 pi5 kernel: irq_brcmstb_l2: registered L2 intc (/soc/intc@7d517b00, parent irq: 31) Feb 21 17:27:10 pi5 kernel: Serial: 8250/16550 driver, 1 ports, IRQ sharing enabled Feb 21 17:27:10 pi5 kernel: 107d50c000.serial: ttyS0 at MMIO 0x107d50c000 (irq = 33, base_baud = 6000000) is a Broadcom BCM7271 UART Feb 21 17:27:10 pi5 kernel: serial serial0: tty port ttyS0 registered Feb 21 17:27:10 pi5 kernel: iproc-rng200 107d208000.rng: hwrng registered Feb 21 17:27:10 pi5 kernel: vc-mem: phys_addr:0x00000000 mem_base=0x3fc00000 mem_size:0x40000000(1024 MiB) Feb 21 17:27:10 pi5 kernel: bcm2712-iommu-cache 1000005b00.iommuc: bcm2712_iommu_cache_probe Feb 21 17:27:10 pi5 kernel: Freeing initrd memory: 28128K Feb 21 17:27:10 pi5 kernel: brd: module loaded Feb 21 17:27:10 pi5 kernel: loop: module loaded Feb 21 17:27:10 pi5 kernel: bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver Feb 21 17:27:10 pi5 kernel: Loading iSCSI transport class v2.0-870. Feb 21 17:27:10 pi5 kernel: usbcore: registered new device driver r8152-cfgselector Feb 21 17:27:10 pi5 kernel: usbcore: registered new interface driver r8152 Feb 21 17:27:10 pi5 kernel: usbcore: registered new interface driver lan78xx Feb 21 17:27:10 pi5 kernel: usbcore: registered new interface driver smsc95xx Feb 21 17:27:10 pi5 kernel: dwc_otg: version 3.00a 10-AUG-2012 (platform bus) Feb 21 17:27:10 pi5 kernel: dwc_otg: FIQ enabled Feb 21 17:27:10 pi5 kernel: dwc_otg: NAK holdoff enabled Feb 21 17:27:10 pi5 kernel: dwc_otg: FIQ split-transaction FSM enabled Feb 21 17:27:10 pi5 kernel: Module dwc_common_port init Feb 21 17:27:10 pi5 kernel: usbcore: registered new interface driver uas Feb 21 17:27:10 pi5 kernel: usbcore: registered new interface driver usb-storage Feb 21 17:27:10 pi5 kernel: mousedev: PS/2 mouse device common for all mice Feb 21 17:27:10 pi5 kernel: rpi-rtc soc:rpi_rtc: registered as rtc0 Feb 21 17:27:10 pi5 kernel: rpi-rtc soc:rpi_rtc: setting system clock to 2026-02-21T17:26:59 UTC (1771694819) Feb 21 17:27:10 pi5 kernel: bcm2835-wdt bcm2835-wdt: Poweroff handler already present! Feb 21 17:27:10 pi5 kernel: bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer Feb 21 17:27:10 pi5 kernel: sdhci: Secure Digital Host Controller Interface driver Feb 21 17:27:10 pi5 kernel: sdhci: Copyright(c) Pierre Ossman Feb 21 17:27:10 pi5 kernel: sdhci-pltfm: SDHCI platform and OF driver helper Feb 21 17:27:10 pi5 kernel: ledtrig-cpu: registered to indicate activity on CPUs Feb 21 17:27:10 pi5 kernel: SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping .... Feb 21 17:27:10 pi5 kernel: hid: raw HID events driver (C) Jiri Kosina Feb 21 17:27:10 pi5 kernel: usbcore: registered new interface driver usbhid Feb 21 17:27:10 pi5 kernel: usbhid: USB HID core driver Feb 21 17:27:10 pi5 kernel: hw perfevents: enabled with armv8_cortex_a76 PMU driver, 7 counters available Feb 21 17:27:10 pi5 kernel: NET: Registered PF_PACKET protocol family Feb 21 17:27:10 pi5 kernel: Key type dns_resolver registered Feb 21 17:27:10 pi5 kernel: registered taskstats version 1 Feb 21 17:27:10 pi5 kernel: Loading compiled-in X.509 certificates Feb 21 17:27:10 pi5 kernel: Key type .fscrypt registered Feb 21 17:27:10 pi5 kernel: Key type fscrypt-provisioning registered Feb 21 17:27:10 pi5 kernel: brcm-pcie 1000110000.pcie: host bridge /axi/pcie@110000 ranges: Feb 21 17:27:10 pi5 kernel: brcm-pcie 1000110000.pcie: No bus range found for /axi/pcie@110000, using [bus 00-ff] Feb 21 17:27:10 pi5 kernel: brcm-pcie 1000110000.pcie: MEM 0x1b80000000..0x1bffffffff -> 0x0080000000 Feb 21 17:27:10 pi5 kernel: brcm-pcie 1000110000.pcie: MEM 0x1800000000..0x1b7fffffff -> 0x0400000000 Feb 21 17:27:10 pi5 kernel: brcm-pcie 1000110000.pcie: IB MEM 0x0000000000..0x0fffffffff -> 0x1000000000 Feb 21 17:27:10 pi5 kernel: brcm-pcie 1000110000.pcie: Forcing gen 2 Feb 21 17:27:10 pi5 kernel: brcm-pcie 1000110000.pcie: PCI host bridge to bus 0000:00 Feb 21 17:27:10 pi5 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Feb 21 17:27:10 pi5 kernel: pci_bus 0000:00: root bus resource [mem 0x1b80000000-0x1bffffffff] (bus address [0x80000000-0xffffffff]) Feb 21 17:27:10 pi5 kernel: pci_bus 0000:00: root bus resource [mem 0x1800000000-0x1b7fffffff pref] (bus address [0x400000000-0x77fffffff]) Feb 21 17:27:10 pi5 kernel: pci 0000:00:00.0: [14e4:2712] type 01 class 0x060400 Feb 21 17:27:10 pi5 kernel: pci 0000:00:00.0: PME# supported from D0 D3hot Feb 21 17:27:10 pi5 kernel: pci 0000:00:00.0: bridge configuration invalid ([bus 00-00]), reconfiguring Feb 21 17:27:10 pi5 kernel: brcm-pcie 1000110000.pcie: link down Feb 21 17:27:10 pi5 kernel: pci_bus 0000:01: busn_res: [bus 01-ff] end is updated to 01 Feb 21 17:27:10 pi5 kernel: pci 0000:00:00.0: PCI bridge to [bus 01] Feb 21 17:27:10 pi5 kernel: pci 0000:00:00.0: Max Payload Size set to 512/ 512 (was 128), Max Read Rq 512 Feb 21 17:27:10 pi5 kernel: pcieport 0000:00:00.0: PME: Signaling with IRQ 38 Feb 21 17:27:10 pi5 kernel: pcieport 0000:00:00.0: AER: enabled with IRQ 38 Feb 21 17:27:10 pi5 kernel: pci_bus 0000:01: busn_res: [bus 01] is released Feb 21 17:27:10 pi5 kernel: pci_bus 0000:00: busn_res: [bus 00-ff] is released Feb 21 17:27:10 pi5 kernel: brcm-pcie 1000120000.pcie: host bridge /axi/pcie@120000 ranges: Feb 21 17:27:10 pi5 kernel: brcm-pcie 1000120000.pcie: No bus range found for /axi/pcie@120000, using [bus 00-ff] Feb 21 17:27:10 pi5 kernel: brcm-pcie 1000120000.pcie: MEM 0x1f00000000..0x1ffffffffb -> 0x0000000000 Feb 21 17:27:10 pi5 kernel: brcm-pcie 1000120000.pcie: MEM 0x1c00000000..0x1effffffff -> 0x0400000000 Feb 21 17:27:10 pi5 kernel: brcm-pcie 1000120000.pcie: IB MEM 0x1f00000000..0x1f003fffff -> 0x0000000000 Feb 21 17:27:10 pi5 kernel: brcm-pcie 1000120000.pcie: IB MEM 0x0000000000..0x0fffffffff -> 0x1000000000 Feb 21 17:27:10 pi5 kernel: brcm-pcie 1000120000.pcie: Forcing gen 2 Feb 21 17:27:10 pi5 kernel: brcm-pcie 1000120000.pcie: PCI host bridge to bus 0000:00 Feb 21 17:27:10 pi5 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Feb 21 17:27:10 pi5 kernel: pci_bus 0000:00: root bus resource [mem 0x1f00000000-0x1ffffffffb] (bus address [0x00000000-0xfffffffb]) Feb 21 17:27:10 pi5 kernel: pci_bus 0000:00: root bus resource [mem 0x1c00000000-0x1effffffff pref] (bus address [0x400000000-0x6ffffffff]) Feb 21 17:27:10 pi5 kernel: pci 0000:00:00.0: [14e4:2712] type 01 class 0x060400 Feb 21 17:27:10 pi5 kernel: pci 0000:00:00.0: PME# supported from D0 D3hot Feb 21 17:27:10 pi5 kernel: pci 0000:00:00.0: bridge configuration invalid ([bus 00-00]), reconfiguring Feb 21 17:27:10 pi5 kernel: brcm-pcie 1000120000.pcie: link up, 5.0 GT/s PCIe x4 (!SSC) Feb 21 17:27:10 pi5 kernel: pci 0000:01:00.0: [1de4:0001] type 00 class 0x020000 Feb 21 17:27:10 pi5 kernel: pci 0000:01:00.0: reg 0x10: [mem 0xffffc000-0xffffffff] Feb 21 17:27:10 pi5 kernel: pci 0000:01:00.0: reg 0x14: [mem 0xffc00000-0xffffffff] Feb 21 17:27:10 pi5 kernel: pci 0000:01:00.0: reg 0x18: [mem 0xffff0000-0xffffffff] Feb 21 17:27:10 pi5 kernel: pci 0000:01:00.0: supports D1 Feb 21 17:27:10 pi5 kernel: pci 0000:01:00.0: PME# supported from D0 D1 D3hot D3cold Feb 21 17:27:10 pi5 kernel: pci_bus 0000:01: busn_res: [bus 01-ff] end is updated to 01 Feb 21 17:27:10 pi5 kernel: pci 0000:00:00.0: BAR 8: assigned [mem 0x1f00000000-0x1f005fffff] Feb 21 17:27:10 pi5 kernel: pci 0000:01:00.0: BAR 1: assigned [mem 0x1f00000000-0x1f003fffff] Feb 21 17:27:10 pi5 kernel: pci 0000:01:00.0: BAR 2: assigned [mem 0x1f00400000-0x1f0040ffff] Feb 21 17:27:10 pi5 kernel: pci 0000:01:00.0: BAR 0: assigned [mem 0x1f00410000-0x1f00413fff] Feb 21 17:27:10 pi5 kernel: pci 0000:00:00.0: PCI bridge to [bus 01] Feb 21 17:27:10 pi5 kernel: pci 0000:00:00.0: bridge window [mem 0x1f00000000-0x1f005fffff] Feb 21 17:27:10 pi5 kernel: pci 0000:00:00.0: Max Payload Size set to 256/ 512 (was 128), Max Read Rq 512 Feb 21 17:27:10 pi5 kernel: pci 0000:01:00.0: Max Payload Size set to 256/ 256 (was 128), Max Read Rq 512 Feb 21 17:27:10 pi5 kernel: pcieport 0000:00:00.0: enabling device (0000 -> 0002) Feb 21 17:27:10 pi5 kernel: pcieport 0000:00:00.0: PME: Signaling with IRQ 39 Feb 21 17:27:10 pi5 kernel: pcieport 0000:00:00.0: AER: enabled with IRQ 39 Feb 21 17:27:10 pi5 kernel: rp1 0000:01:00.0: bar0 len 0x4000, start 0x1f00410000, end 0x1f00413fff, flags, 0x40200 Feb 21 17:27:10 pi5 kernel: rp1 0000:01:00.0: bar1 len 0x400000, start 0x1f00000000, end 0x1f003fffff, flags, 0x40200 Feb 21 17:27:10 pi5 kernel: rp1 0000:01:00.0: enabling device (0000 -> 0002) Feb 21 17:27:10 pi5 kernel: rp1 0000:01:00.0: chip_id 0x20001927 Feb 21 17:27:10 pi5 kernel: genirq: irq_chip rp1_irq_chip did not update eff. affinity mask of irq 101 Feb 21 17:27:10 pi5 kernel: macb 1f00100000.ethernet eth0: Cadence GEM rev 0x00070109 at 0x1f00100000 irq 107 (2c:cf:67:7a:96:1f) Feb 21 17:27:10 pi5 kernel: dw_axi_dmac_platform 1f00188000.dma: DesignWare AXI DMA Controller, 8 channels Feb 21 17:27:10 pi5 kernel: xhci-hcd xhci-hcd.0: xHCI Host Controller Feb 21 17:27:10 pi5 kernel: xhci-hcd xhci-hcd.0: new USB bus registered, assigned bus number 1 Feb 21 17:27:10 pi5 kernel: xhci-hcd xhci-hcd.0: hcc params 0x0240fe6d hci version 0x110 quirks 0x0000008000000810 Feb 21 17:27:10 pi5 kernel: xhci-hcd xhci-hcd.0: irq 132, io mem 0x1f00200000 Feb 21 17:27:10 pi5 kernel: xhci-hcd xhci-hcd.0: xHCI Host Controller Feb 21 17:27:10 pi5 kernel: xhci-hcd xhci-hcd.0: new USB bus registered, assigned bus number 2 Feb 21 17:27:10 pi5 kernel: xhci-hcd xhci-hcd.0: Host supports USB 3.0 SuperSpeed Feb 21 17:27:10 pi5 kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.06 Feb 21 17:27:10 pi5 kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Feb 21 17:27:10 pi5 kernel: usb usb1: Product: xHCI Host Controller Feb 21 17:27:10 pi5 kernel: usb usb1: Manufacturer: Linux 6.6.62-v8+ xhci-hcd Feb 21 17:27:10 pi5 kernel: usb usb1: SerialNumber: xhci-hcd.0 Feb 21 17:27:10 pi5 kernel: hub 1-0:1.0: USB hub found Feb 21 17:27:10 pi5 kernel: hub 1-0:1.0: 2 ports detected Feb 21 17:27:10 pi5 kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 6.06 Feb 21 17:27:10 pi5 kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Feb 21 17:27:10 pi5 kernel: usb usb2: Product: xHCI Host Controller Feb 21 17:27:10 pi5 kernel: usb usb2: Manufacturer: Linux 6.6.62-v8+ xhci-hcd Feb 21 17:27:10 pi5 kernel: usb usb2: SerialNumber: xhci-hcd.0 Feb 21 17:27:10 pi5 kernel: hub 2-0:1.0: USB hub found Feb 21 17:27:10 pi5 kernel: hub 2-0:1.0: 1 port detected Feb 21 17:27:10 pi5 kernel: xhci-hcd xhci-hcd.1: xHCI Host Controller Feb 21 17:27:10 pi5 kernel: xhci-hcd xhci-hcd.1: new USB bus registered, assigned bus number 3 Feb 21 17:27:10 pi5 kernel: xhci-hcd xhci-hcd.1: hcc params 0x0240fe6d hci version 0x110 quirks 0x0000008000000810 Feb 21 17:27:10 pi5 kernel: xhci-hcd xhci-hcd.1: irq 137, io mem 0x1f00300000 Feb 21 17:27:10 pi5 kernel: xhci-hcd xhci-hcd.1: xHCI Host Controller Feb 21 17:27:10 pi5 kernel: xhci-hcd xhci-hcd.1: new USB bus registered, assigned bus number 4 Feb 21 17:27:10 pi5 kernel: xhci-hcd xhci-hcd.1: Host supports USB 3.0 SuperSpeed Feb 21 17:27:10 pi5 kernel: usb usb3: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.06 Feb 21 17:27:10 pi5 kernel: usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Feb 21 17:27:10 pi5 kernel: usb usb3: Product: xHCI Host Controller Feb 21 17:27:10 pi5 kernel: usb usb3: Manufacturer: Linux 6.6.62-v8+ xhci-hcd Feb 21 17:27:10 pi5 kernel: usb usb3: SerialNumber: xhci-hcd.1 Feb 21 17:27:10 pi5 kernel: hub 3-0:1.0: USB hub found Feb 21 17:27:10 pi5 kernel: hub 3-0:1.0: 2 ports detected Feb 21 17:27:10 pi5 kernel: usb usb4: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 6.06 Feb 21 17:27:10 pi5 kernel: usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Feb 21 17:27:10 pi5 kernel: usb usb4: Product: xHCI Host Controller Feb 21 17:27:10 pi5 kernel: usb usb4: Manufacturer: Linux 6.6.62-v8+ xhci-hcd Feb 21 17:27:10 pi5 kernel: usb usb4: SerialNumber: xhci-hcd.1 Feb 21 17:27:10 pi5 kernel: hub 4-0:1.0: USB hub found Feb 21 17:27:10 pi5 kernel: hub 4-0:1.0: 1 port detected Feb 21 17:27:10 pi5 kernel: bcm2712-iommu 1000005100.iommu: bcm2712_iommu_init: DEBUG_INFO = 0x20804774 Feb 21 17:27:10 pi5 kernel: platform 1000800000.codec: bcm2712_iommu_probe_device: MMU 1000005100.iommu Feb 21 17:27:10 pi5 kernel: platform 1000800000.codec: bcm2712_iommu_device_group: MMU 1000005100.iommu Feb 21 17:27:10 pi5 kernel: platform 1000800000.codec: Adding to iommu group 0 Feb 21 17:27:10 pi5 kernel: platform 1000880000.pisp_be: bcm2712_iommu_probe_device: MMU 1000005100.iommu Feb 21 17:27:10 pi5 kernel: platform 1000880000.pisp_be: bcm2712_iommu_device_group: MMU 1000005100.iommu Feb 21 17:27:10 pi5 kernel: platform 1000880000.pisp_be: Adding to iommu group 0 Feb 21 17:27:10 pi5 kernel: platform 1000800000.codec: bcm2712_iommu_attach_dev: MMU 1000005100.iommu Feb 21 17:27:10 pi5 kernel: platform 1000880000.pisp_be: bcm2712_iommu_attach_dev: MMU 1000005100.iommu Feb 21 17:27:10 pi5 kernel: bcm2712-iommu 1000005100.iommu: bcm2712_iommu_probe: Success Feb 21 17:27:10 pi5 kernel: bcm2712-iommu 1000005200.iommu: bcm2712_iommu_init: DEBUG_INFO = 0x20804774 Feb 21 17:27:10 pi5 kernel: platform axi:gpu: bcm2712_iommu_probe_device: MMU 1000005200.iommu Feb 21 17:27:10 pi5 kernel: platform axi:gpu: bcm2712_iommu_device_group: MMU 1000005200.iommu Feb 21 17:27:10 pi5 kernel: platform axi:gpu: Adding to iommu group 1 Feb 21 17:27:10 pi5 kernel: platform axi:gpu: bcm2712_iommu_attach_dev: MMU 1000005200.iommu Feb 21 17:27:10 pi5 kernel: bcm2712-iommu 1000005200.iommu: bcm2712_iommu_probe: Success Feb 21 17:27:10 pi5 kernel: bcm2712-iommu 1000005280.iommu: bcm2712_iommu_init: DEBUG_INFO = 0x20804774 Feb 21 17:27:10 pi5 kernel: bcm2712-iommu 1000005280.iommu: bcm2712_iommu_probe: Success Feb 21 17:27:10 pi5 kernel: sdhci-brcmstb 1000fff000.mmc: Got CD GPIO Feb 21 17:27:10 pi5 kernel: mmc0: CQHCI version 5.10 Feb 21 17:27:10 pi5 kernel: of_cfs_init Feb 21 17:27:10 pi5 kernel: of_cfs_init: OK Feb 21 17:27:10 pi5 kernel: clk: Disabling unused clocks Feb 21 17:27:10 pi5 kernel: mmc1: CQHCI version 5.10 Feb 21 17:27:10 pi5 kernel: mmc0: SDHCI controller on 1000fff000.mmc [1000fff000.mmc] using ADMA 64-bit Feb 21 17:27:10 pi5 kernel: mmc0: new ultra high speed SDR104 SDHC card at address b368 Feb 21 17:27:10 pi5 kernel: mmcblk0: mmc0:b368 LX32G 29.5 GiB Feb 21 17:27:10 pi5 kernel: mmcblk0: p1 p2 p3 Feb 21 17:27:10 pi5 kernel: mmcblk0: mmc0:b368 LX32G 29.5 GiB Feb 21 17:27:10 pi5 kernel: mmc1: SDHCI controller on 1001100000.mmc [1001100000.mmc] using ADMA 64-bit Feb 21 17:27:10 pi5 kernel: Freeing unused kernel memory: 4864K Feb 21 17:27:10 pi5 kernel: Run /init as init process Feb 21 17:27:10 pi5 kernel: with arguments: Feb 21 17:27:10 pi5 kernel: /init Feb 21 17:27:10 pi5 kernel: splash Feb 21 17:27:10 pi5 kernel: nodebug Feb 21 17:27:10 pi5 kernel: with environment: Feb 21 17:27:10 pi5 kernel: HOME=/ Feb 21 17:27:10 pi5 kernel: TERM=linux Feb 21 17:27:10 pi5 kernel: imgpart=UUID=fb80cb44-b4d3-4b36-be35-613cba0a09fb Feb 21 17:27:10 pi5 kernel: imgfile=/volumio_current.sqsh Feb 21 17:27:10 pi5 kernel: bootpart=UUID=51B1-040D Feb 21 17:27:10 pi5 kernel: datapart=UUID=2899bccc-8620-4c7a-b56a-43fd2f7a836a Feb 21 17:27:10 pi5 kernel: uuidconfig=cmdline.txt Feb 21 17:27:10 pi5 kernel: bootdelay=7 Feb 21 17:27:10 pi5 kernel: use_kmsg=no Feb 21 17:27:10 pi5 kernel: mmc1: new ultra high speed DDR50 SDIO card at address 0001 Feb 21 17:27:10 pi5 kernel: snd_timer: Unknown symbol snd_info_register (err -2) Feb 21 17:27:10 pi5 kernel: snd_timer: Unknown symbol snd_info_create_module_entry (err -2) Feb 21 17:27:10 pi5 kernel: snd_timer: Unknown symbol snd_info_free_entry (err -2) Feb 21 17:27:10 pi5 kernel: snd_timer: Unknown symbol snd_fasync_helper (err -2) Feb 21 17:27:10 pi5 kernel: snd_timer: Unknown symbol snd_ecards_limit (err -2) Feb 21 17:27:10 pi5 kernel: snd_timer: Unknown symbol snd_oss_info_register (err -2) Feb 21 17:27:10 pi5 kernel: snd_timer: Unknown symbol snd_unregister_device (err -2) Feb 21 17:27:10 pi5 kernel: snd_timer: Unknown symbol snd_device_alloc (err -2) Feb 21 17:27:10 pi5 kernel: snd_timer: Unknown symbol snd_device_new (err -2) Feb 21 17:27:10 pi5 kernel: snd_timer: Unknown symbol snd_fasync_free (err -2) Feb 21 17:27:10 pi5 kernel: snd_timer: Unknown symbol snd_kill_fasync (err -2) Feb 21 17:27:10 pi5 kernel: snd_timer: Unknown symbol snd_register_device (err -2) Feb 21 17:27:10 pi5 kernel: snd_timer: Unknown symbol snd_info_register (err -2) Feb 21 17:27:10 pi5 kernel: snd_timer: Unknown symbol snd_info_create_module_entry (err -2) Feb 21 17:27:10 pi5 kernel: snd_timer: Unknown symbol snd_info_free_entry (err -2) Feb 21 17:27:10 pi5 kernel: snd_timer: Unknown symbol snd_fasync_helper (err -2) Feb 21 17:27:10 pi5 kernel: snd_timer: Unknown symbol snd_ecards_limit (err -2) Feb 21 17:27:10 pi5 kernel: snd_timer: Unknown symbol snd_oss_info_register (err -2) Feb 21 17:27:10 pi5 kernel: snd_timer: Unknown symbol snd_unregister_device (err -2) Feb 21 17:27:10 pi5 kernel: snd_timer: Unknown symbol snd_device_alloc (err -2) Feb 21 17:27:10 pi5 kernel: snd_timer: Unknown symbol snd_device_new (err -2) Feb 21 17:27:10 pi5 kernel: snd_timer: Unknown symbol snd_fasync_free (err -2) Feb 21 17:27:10 pi5 kernel: snd_timer: Unknown symbol snd_kill_fasync (err -2) Feb 21 17:27:10 pi5 kernel: snd_timer: Unknown symbol snd_register_device (err -2) Feb 21 17:27:10 pi5 kernel: brcmstb-i2c 107d508200.i2c: @97500hz registered in interrupt mode Feb 21 17:27:10 pi5 kernel: input: pwr_button as /devices/platform/pwr_button/input/input0 Feb 21 17:27:10 pi5 kernel: brcmstb-i2c 107d508280.i2c: @97500hz registered in interrupt mode Feb 21 17:27:10 pi5 kernel: [drm] Initialized v3d 1.0.0 20180419 for 1002000000.v3d on minor 0 Feb 21 17:27:10 pi5 kernel: fuse: init (API version 7.39) Feb 21 17:27:10 pi5 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Feb 21 17:27:10 pi5 kernel: EXT4-fs (mmcblk0p2): mounted filesystem fb80cb44-b4d3-4b36-be35-613cba0a09fb r/w with ordered data mode. Quota mode: none. Feb 21 17:27:10 pi5 kernel: loop0: detected capacity change from 0 to 1018800 Feb 21 17:27:10 pi5 kernel: EXT4-fs (mmcblk0p3): recovery complete Feb 21 17:27:10 pi5 kernel: EXT4-fs (mmcblk0p3): mounted filesystem 2899bccc-8620-4c7a-b56a-43fd2f7a836a r/w with ordered data mode. Quota mode: none. Feb 21 17:27:10 pi5 kernel: ext4 filesystem being mounted at /mnt/ext supports timestamps until 2038-01-19 (0x7fffffff) Feb 21 17:27:10 pi5 kernel: NET: Registered PF_INET6 protocol family Feb 21 17:27:10 pi5 kernel: Segment Routing with IPv6 Feb 21 17:27:10 pi5 kernel: In-situ OAM (IOAM) with IPv6 Feb 21 17:27:10 pi5 systemd[1]: systemd 241 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD -IDN2 +IDN -PCRE2 default-hierarchy=hybrid) Feb 21 17:27:10 pi5 systemd[1]: Detected architecture arm64. Feb 21 17:27:10 pi5 systemd[1]: Set hostname to . Feb 21 17:27:10 pi5 kernel: uart-pl011 107d001000.serial: no DMA platform data Feb 21 17:27:10 pi5 systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Feb 21 17:27:10 pi5 systemd[1]: Listening on fsck to fsckd communication Socket. Feb 21 17:27:10 pi5 systemd[1]: Listening on udev Kernel Socket. Feb 21 17:27:10 pi5 systemd[1]: Listening on Journal Socket (/dev/log). Feb 21 17:27:10 pi5 systemd[1]: Listening on Journal Socket. Feb 21 17:27:10 pi5 systemd[1]: Starting Remount Root and Kernel File Systems... Feb 21 17:27:10 pi5 systemd[1]: Condition check resulted in Kernel Module supporting RPCSEC_GSS being skipped. Feb 21 17:27:10 pi5 kernel: i2c_dev: i2c /dev entries driver Feb 21 17:27:10 pi5 systemd-journald[368]: Journal started Feb 21 17:27:10 pi5 systemd-journald[368]: Runtime journal (/run/log/journal/a89b7be63bc86b985c184d84675fe488) is 3.7M, max 30.0M, 26.2M free. Feb 21 17:27:10 pi5 systemd-modules-load[367]: Inserted module 'i2c_dev' Feb 21 17:27:10 pi5 systemd[1]: Started udev Coldplug all Devices. Feb 21 17:27:10 pi5 systemd[1]: Starting Helper to synchronize boot up for ifupdown... Feb 21 17:27:10 pi5 systemd[1]: Started Apply Kernel Variables. Feb 21 17:27:10 pi5 fake-hwclock[369]: Current system time: 2026-02-21 17:27:10 Feb 21 17:27:10 pi5 fake-hwclock[369]: fake-hwclock saved clock information is in the past: 2026-02-21 17:26:23 Feb 21 17:27:10 pi5 fake-hwclock[369]: To set system time to this saved clock anyway, use "force" Feb 21 17:27:10 pi5 systemd[1]: Started Restore / save the current clock. Feb 21 17:27:10 pi5 systemd[1]: Started Create System Users. Feb 21 17:27:10 pi5 systemd[1]: Starting Create Static Device Nodes in /dev... Feb 21 17:27:10 pi5 systemd[1]: Started Create Static Device Nodes in /dev. Feb 21 17:27:10 pi5 systemd[1]: Starting udev Kernel Device Manager... Feb 21 17:27:10 pi5 systemd[1]: Reached target Local File Systems (Pre). Feb 21 17:27:10 pi5 systemd[1]: Mounting /var/spool/cups... Feb 21 17:27:10 pi5 systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Feb 21 17:27:10 pi5 systemd[1]: Mounting /tmp... Feb 21 17:27:10 pi5 systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Feb 21 17:27:10 pi5 systemd[1]: Mounting /var/log... Feb 21 17:27:10 pi5 systemd[1]: dynamicswap.service: Succeeded. Feb 21 17:27:10 pi5 systemd[1]: Mounted /var/spool/cups. Feb 21 17:27:10 pi5 systemd[1]: Mounted /tmp. Feb 21 17:27:10 pi5 systemd[1]: Mounted /var/log. Feb 21 17:27:10 pi5 systemd-udevd[391]: Network interface NamePolicy= disabled on kernel command line, ignoring. Feb 21 17:27:10 pi5 systemd[1]: Starting Flush Journal to Persistent Storage... Feb 21 17:27:10 pi5 systemd[1]: Mounting /var/spool/cups/tmp... Feb 21 17:27:10 pi5 systemd[1]: Mounted /var/spool/cups/tmp. Feb 21 17:27:10 pi5 systemd[1]: Started udev Kernel Device Manager. Feb 21 17:27:10 pi5 systemd[1]: Starting Show Plymouth Boot Screen... Feb 21 17:27:10 pi5 systemd-journald[368]: Runtime journal (/run/log/journal/a89b7be63bc86b985c184d84675fe488) is 3.7M, max 30.0M, 26.2M free. Feb 21 17:27:10 pi5 systemd[1]: Started Flush Journal to Persistent Storage. Feb 21 17:27:10 pi5 systemd[1]: plymouth-start.service: Succeeded. Feb 21 17:27:10 pi5 systemd[1]: Started Show Plymouth Boot Screen. Feb 21 17:27:10 pi5 systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Feb 21 17:27:10 pi5 systemd[1]: Reached target Local Encrypted Volumes. Feb 21 17:27:10 pi5 systemd[1]: Reached target Paths. Feb 21 17:27:10 pi5 systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Feb 21 17:27:10 pi5 systemd-udevd[408]: Using default interface naming scheme 'v240'. Feb 21 17:27:10 pi5 systemd-udevd[408]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Feb 21 17:27:10 pi5 kernel: rpi-gpiomem 107d508500.gpiomem: window base 0x107d508500 size 0x00000040 Feb 21 17:27:10 pi5 kernel: rpi-gpiomem 107d508500.gpiomem: initialised 1 regions as /dev/gpiomem1 Feb 21 17:27:10 pi5 kernel: rpi-gpiomem 107d517c00.gpiomem: window base 0x107d517c00 size 0x00000040 Feb 21 17:27:10 pi5 kernel: rpi-gpiomem 107d517c00.gpiomem: initialised 1 regions as /dev/gpiomem2 Feb 21 17:27:10 pi5 kernel: rpi-gpiomem 107d504100.gpiomem: window base 0x107d504100 size 0x00000020 Feb 21 17:27:10 pi5 kernel: rpi-gpiomem 107d504100.gpiomem: initialised 1 regions as /dev/gpiomem3 Feb 21 17:27:10 pi5 kernel: rpi-gpiomem 107d510700.gpiomem: window base 0x107d510700 size 0x00000020 Feb 21 17:27:10 pi5 kernel: rpi-gpiomem 107d510700.gpiomem: initialised 1 regions as /dev/gpiomem4 Feb 21 17:27:10 pi5 kernel: rpi-gpiomem 1f000d0000.gpiomem: window base 0x1f000d0000 size 0x00030000 Feb 21 17:27:10 pi5 kernel: rpi-gpiomem 1f000d0000.gpiomem: initialised 1 regions as /dev/gpiomem0 Feb 21 17:27:10 pi5 kernel: rp1_pio: Unknown symbol rp1_firmware_message (err -2) Feb 21 17:27:10 pi5 kernel: rp1_pio: Unknown symbol devm_rp1_firmware_get (err -2) Feb 21 17:27:10 pi5 kernel: rp1_pio: Unknown symbol rp1_firmware_get_feature (err -2) Feb 21 17:27:10 pi5 kernel: mc: Linux media interface: v0.10 Feb 21 17:27:10 pi5 kernel: videodev: Linux video capture interface: v2.00 Feb 21 17:27:10 pi5 kernel: rpivid_hevc: module is from the staging directory, the quality is unknown, you have been warned. Feb 21 17:27:10 pi5 kernel: rpivid 1000800000.codec: bcm2712_iommu_of_xlate: MMU 1000005100.iommu Feb 21 17:27:10 pi5 kernel: pispbe 1000880000.pisp_be: bcm2712_iommu_of_xlate: MMU 1000005100.iommu Feb 21 17:27:10 pi5 kernel: rpivid 1000800000.codec: Device registered as /dev/video19 Feb 21 17:27:10 pi5 kernel: pispbe 1000880000.pisp_be: Runtime PM usage count underflow! Feb 21 17:27:10 pi5 kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database Feb 21 17:27:10 pi5 kernel: Loaded X.509 cert 'benh@debian.org: 577e021cb980e0e820821ba7b54b4961b8b4fadf' Feb 21 17:27:10 pi5 kernel: Loaded X.509 cert 'romain.perier@gmail.com: 3abbc6ec146e09d1b6016ab9d6cf71dd233f0328' Feb 21 17:27:10 pi5 kernel: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' Feb 21 17:27:10 pi5 kernel: Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' Feb 21 17:27:10 pi5 systemd[1]: Found device /dev/disk/by-uuid/51B1-040D. Feb 21 17:27:10 pi5 systemd[1]: Found device /dev/ttyAMA10. Feb 21 17:27:10 pi5 systemd[1]: Starting File System Check on /dev/disk/by-uuid/51B1-040D... Feb 21 17:27:10 pi5 kernel: wm8804 1-003b: revision E Feb 21 17:27:10 pi5 kernel: brcmfmac: F1 signature read @0x18000000=0x15264345 Feb 21 17:27:10 pi5 systemd[1]: Started File System Check Daemon to report status. Feb 21 17:27:10 pi5 kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6 Feb 21 17:27:10 pi5 kernel: usbcore: registered new interface driver brcmfmac Feb 21 17:27:10 pi5 kernel: brcmfmac mmc1:0001:1: Direct firmware load for brcm/brcmfmac43455-sdio.raspberrypi,5-model-b.bin failed with error -2 Feb 21 17:27:10 pi5 systemd-udevd[412]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Feb 21 17:27:10 pi5 kernel: Bluetooth: Core ver 2.22 Feb 21 17:27:10 pi5 kernel: NET: Registered PF_BLUETOOTH protocol family Feb 21 17:27:10 pi5 kernel: Bluetooth: HCI device and connection manager initialized Feb 21 17:27:10 pi5 kernel: Bluetooth: HCI socket layer initialized Feb 21 17:27:10 pi5 kernel: Bluetooth: L2CAP socket layer initialized Feb 21 17:27:10 pi5 kernel: Bluetooth: SCO socket layer initialized Feb 21 17:27:10 pi5 kernel: Bluetooth: HCI UART driver ver 2.3 Feb 21 17:27:10 pi5 kernel: Bluetooth: HCI UART protocol H4 registered Feb 21 17:27:10 pi5 kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered Feb 21 17:27:10 pi5 kernel: hci_uart_bcm serial0-0: supply vbat not found, using dummy regulator Feb 21 17:27:11 pi5 kernel: hci_uart_bcm serial0-0: supply vddio not found, using dummy regulator Feb 21 17:27:11 pi5 kernel: Bluetooth: HCI UART protocol Broadcom registered Feb 21 17:27:11 pi5 kernel: vc4-drm axi:gpu: bcm2712_iommu_of_xlate: MMU 1000005200.iommu Feb 21 17:27:11 pi5 kernel: vc4-drm axi:gpu: bound 107c580000.hvs (ops vc4_hvs_ops [vc4]) Feb 21 17:27:11 pi5 kernel: Registered IR keymap rc-cec Feb 21 17:27:11 pi5 kernel: rc rc0: vc4-hdmi-0 as /devices/platform/soc/107c701400.hdmi/rc/rc0 Feb 21 17:27:11 pi5 kernel: input: vc4-hdmi-0 as /devices/platform/soc/107c701400.hdmi/rc/rc0/input1 Feb 21 17:27:11 pi5 kernel: input: vc4-hdmi-0 HDMI Jack as /devices/platform/soc/107c701400.hdmi/sound/card1/input2 Feb 21 17:27:11 pi5 kernel: vc4-drm axi:gpu: bound 107c701400.hdmi (ops vc4_hdmi_ops [vc4]) Feb 21 17:27:11 pi5 kernel: Registered IR keymap rc-cec Feb 21 17:27:11 pi5 kernel: rc rc1: vc4-hdmi-1 as /devices/platform/soc/107c706400.hdmi/rc/rc1 Feb 21 17:27:11 pi5 kernel: input: vc4-hdmi-1 as /devices/platform/soc/107c706400.hdmi/rc/rc1/input3 Feb 21 17:27:11 pi5 kernel: input: vc4-hdmi-1 HDMI Jack as /devices/platform/soc/107c706400.hdmi/sound/card2/input4 Feb 21 17:27:11 pi5 kernel: vc4-drm axi:gpu: bound 107c706400.hdmi (ops vc4_hdmi_ops [vc4]) Feb 21 17:27:11 pi5 kernel: vc4-drm axi:gpu: bound 107c500000.mop (ops vc4_txp_ops [vc4]) Feb 21 17:27:11 pi5 kernel: vc4-drm axi:gpu: bound 107c501000.moplet (ops vc4_txp_ops [vc4]) Feb 21 17:27:11 pi5 kernel: vc4-drm axi:gpu: bound 107c410000.pixelvalve (ops vc4_crtc_ops [vc4]) Feb 21 17:27:11 pi5 kernel: vc4-drm axi:gpu: bound 107c411000.pixelvalve (ops vc4_crtc_ops [vc4]) Feb 21 17:27:11 pi5 kernel: [drm] Initialized vc4 0.0.0 20140616 for axi:gpu on minor 1 Feb 21 17:27:11 pi5 kernel: vc4-drm axi:gpu: [drm] Cannot find any crtc or sizes Feb 21 17:27:11 pi5 kernel: vc4-drm axi:gpu: [drm] Cannot find any crtc or sizes Feb 21 17:27:11 pi5 kernel: vc4-drm axi:gpu: [drm] Cannot find any crtc or sizes Feb 21 17:27:11 pi5 systemd-fsck[518]: fsck.fat 4.1 (2017-01-24) Feb 21 17:27:11 pi5 systemd-fsck[518]: /dev/mmcblk0p1: 404 files, 166420/184582 clusters Feb 21 17:27:10 pi5 systemd[1]: Found device /sys/subsystem/net/devices/eth0. Feb 21 17:27:10 pi5 systemd-udevd[402]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Feb 21 17:27:11 pi5 systemd[1]: Started File System Check on /dev/disk/by-uuid/51B1-040D. Feb 21 17:27:11 pi5 sh[628]: command failed: No such device (-19) Feb 21 17:27:11 pi5 systemd[1]: Mounting /boot... Feb 21 17:27:11 pi5 systemd[1]: Mounted /boot. Feb 21 17:27:11 pi5 systemd[1]: Reached target Local File Systems. Feb 21 17:27:11 pi5 systemd[1]: Started ifup for eth0. Feb 21 17:27:11 pi5 systemd[1]: Starting Preprocess NFS configuration... Feb 21 17:27:11 pi5 systemd[1]: Starting Create Volatile Files and Directories... Feb 21 17:27:11 pi5 systemd[1]: Condition check resulted in Huge Pages File System being skipped. Feb 21 17:27:11 pi5 systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Feb 21 17:27:11 pi5 systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Feb 21 17:27:11 pi5 systemd[1]: Starting Show Plymouth Boot Screen... Feb 21 17:27:11 pi5 systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Feb 21 17:27:11 pi5 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Feb 21 17:27:11 pi5 systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Feb 21 17:27:11 pi5 systemd[1]: Received SIGRTMIN+20 from PID 251 (plymouthd). Feb 21 17:27:11 pi5 systemd[1]: plymouth-read-write.service: Succeeded. Feb 21 17:27:11 pi5 systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Feb 21 17:27:11 pi5 systemd[1]: nfs-config.service: Succeeded. Feb 21 17:27:11 pi5 systemd[1]: Started Preprocess NFS configuration. Feb 21 17:27:11 pi5 systemd[1]: plymouth-start.service: Succeeded. Feb 21 17:27:11 pi5 systemd[1]: Started Show Plymouth Boot Screen. Feb 21 17:27:11 pi5 systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Feb 21 17:27:11 pi5 systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Feb 21 17:27:11 pi5 systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Feb 21 17:27:11 pi5 systemd[1]: Reached target NFS client services. Feb 21 17:27:11 pi5 systemd[1]: Started Create Volatile Files and Directories. Feb 21 17:27:11 pi5 systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Feb 21 17:27:11 pi5 systemd-udevd[405]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Feb 21 17:27:11 pi5 systemd[1]: Starting RPC bind portmap service... Feb 21 17:27:11 pi5 systemd[1]: Starting Update UTMP about System Boot/Shutdown... Feb 21 17:27:11 pi5 systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Feb 21 17:27:11 pi5 systemd-udevd[401]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Feb 21 17:27:11 pi5 systemd[1]: Started Update UTMP about System Boot/Shutdown. Feb 21 17:27:11 pi5 systemd-udevd[403]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Feb 21 17:27:11 pi5 systemd[1]: Reached target System Initialization. Feb 21 17:27:11 pi5 systemd[1]: Started Daily Cleanup of Temporary Directories. Feb 21 17:27:11 pi5 systemd-udevd[407]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Feb 21 17:27:11 pi5 systemd[1]: Listening on triggerhappy.socket. Feb 21 17:27:11 pi5 systemd[1]: Listening on D-Bus System Message Bus Socket. Feb 21 17:27:11 pi5 systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Feb 21 17:27:11 pi5 systemd[1]: Reached target Sockets. Feb 21 17:27:11 pi5 systemd[1]: Reached target Basic System. Feb 21 17:27:11 pi5 systemd[1]: Started Volumio Log Rotation Service. Feb 21 17:27:11 pi5 systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Feb 21 17:27:11 pi5 systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Feb 21 17:27:11 pi5 systemd[1]: Started UPnP Renderer front-end to MPD. Feb 21 17:27:11 pi5 systemd[1]: Started volumio-remote-updater.service. Feb 21 17:27:11 pi5 systemd[1]: Starting triggerhappy global hotkey daemon... Feb 21 17:27:11 pi5 systemd[1]: Condition check resulted in Configure Bluetooth Modems connected by UART being skipped. Feb 21 17:27:11 pi5 systemd[1]: Started D-Bus System Message Bus. Feb 21 17:27:11 pi5 kernel: brcmfmac: brcmf_c_process_txcap_blob: no txcap_blob available (err=-2) Feb 21 17:27:11 pi5 kernel: brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM4345/6 wl0: Nov 1 2021 00:37:25 version 7.45.241 (1a2f2fa CY) FWID 01-703fd60 Feb 21 17:27:11 pi5 systemd[1]: Starting Login Service... Feb 21 17:27:11 pi5 systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Feb 21 17:27:11 pi5 systemd[1]: Starting dhcpcd on all interfaces... Feb 21 17:27:11 pi5 systemd[1]: Starting Volumio Time Update Utility... Feb 21 17:27:11 pi5 systemd[1]: Started Manage Sound Card State (restore and store). Feb 21 17:27:11 pi5 alsactl[676]: alsactl 1.1.8 daemon started Feb 21 17:27:11 pi5 systemd[1]: Starting Save/Restore Sound Card State... Feb 21 17:27:11 pi5 systemd[1]: Starting Wireless Services... Feb 21 17:27:11 pi5 systemd[1]: Started Daily apt download activities. Feb 21 17:27:11 pi5 systemd[1]: Started Daily apt upgrade and clean activities. Feb 21 17:27:11 pi5 systemd[1]: Reached target Timers. Feb 21 17:27:11 pi5 systemd[1]: Starting WPA supplicant... Feb 21 17:27:11 pi5 systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Feb 21 17:27:11 pi5 systemd[1]: Started Volumio Iptables Module. Feb 21 17:27:11 pi5 systemd-udevd[401]: Using default interface naming scheme 'v240'. Feb 21 17:27:11 pi5 systemd-udevd[401]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Feb 21 17:27:11 pi5 volumio-time-update[675]: volumio-time-update-util: Fetching time from Volumio... Feb 21 17:27:11 pi5 thd[669]: Unable to parse trigger line: Feb 21 17:27:11 pi5 thd[669]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Feb 21 17:27:11 pi5 thd[669]: Unable to parse trigger line: Feb 21 17:27:11 pi5 thd[669]: Found socket passed from systemd Feb 21 17:27:11 pi5 dhcpcd[673]: Not running dhcpcd because /etc/network/interfaces Feb 21 17:27:11 pi5 dhcpcd[673]: defines some interfaces that will use a Feb 21 17:27:11 pi5 dhcpcd[673]: DHCP client or static address Feb 21 17:27:11 pi5 systemd-logind[672]: New seat seat0. Feb 21 17:27:11 pi5 kernel: Bluetooth: hci0: BCM: chip id 107 Feb 21 17:27:11 pi5 kernel: Bluetooth: hci0: BCM: features 0x2f Feb 21 17:27:11 pi5 kernel: Bluetooth: hci0: BCM4345C0 Feb 21 17:27:11 pi5 kernel: Bluetooth: hci0: BCM4345C0 (003.001.025) build 0000 Feb 21 17:27:11 pi5 systemd-logind[672]: Watching system buttons on /dev/input/event0 (pwr_button) Feb 21 17:27:11 pi5 systemd-logind[672]: Watching system buttons on /dev/input/event1 (vc4-hdmi-0) Feb 21 17:27:11 pi5 kernel: Bluetooth: hci0: BCM4345C0 'brcm/BCM4345C0.hcd' Patch Feb 21 17:27:11 pi5 systemd-logind[672]: Watching system buttons on /dev/input/event3 (vc4-hdmi-1) Feb 21 17:27:11 pi5 avahi-daemon[666]: Found user 'avahi' (UID 110) and group 'avahi' (GID 113). Feb 21 17:27:11 pi5 avahi-daemon[666]: Successfully dropped root privileges. Feb 21 17:27:11 pi5 avahi-daemon[666]: avahi-daemon 0.7 starting up. Feb 21 17:27:11 pi5 kernel: 8021q: 802.1Q VLAN Support v1.8 Feb 21 17:27:11 pi5 kernel: alsactl[676]: memfd_create() called without MFD_EXEC or MFD_NOEXEC_SEAL set Feb 21 17:27:11 pi5 avahi-daemon[666]: Successfully called chroot(). Feb 21 17:27:11 pi5 avahi-daemon[666]: Successfully dropped remaining capabilities. Feb 21 17:27:11 pi5 wpa_supplicant[679]: Successfully initialized wpa_supplicant Feb 21 17:27:11 pi5 kernel: macb 1f00100000.ethernet eth0: PHY [1f00100000.ethernet-ffffffff:01] driver [Broadcom BCM54213PE] (irq=POLL) Feb 21 17:27:11 pi5 kernel: macb 1f00100000.ethernet eth0: configuring for phy/rgmii-id link mode Feb 21 17:27:11 pi5 avahi-daemon[666]: Loading service file /services/volumio.service. Feb 21 17:27:11 pi5 sh[628]: eth0: waiting for carrier Feb 21 17:27:11 pi5 dhcpcd[663]: eth0: waiting for carrier Feb 21 17:27:11 pi5 kernel: pps pps0: new PPS source ptp0 Feb 21 17:27:11 pi5 kernel: macb 1f00100000.ethernet: gem-ptp-timer ptp clock registered. Feb 21 17:27:11 pi5 avahi-daemon[666]: Network interface enumeration completed. Feb 21 17:27:11 pi5 avahi-daemon[666]: Server startup complete. Host name is pi5.local. Local service cookie is 102326222. Feb 21 17:27:11 pi5 avahi-daemon[666]: Service "Pi5" (/services/volumio.service) successfully established. Feb 21 17:27:11 pi5 volumio-remote-updater[668]: Error: No active session Feb 21 17:27:11 pi5 volumio-remote-updater[668]: [2026-02-21 17:27:11] [info] asio async_connect error: system:111 (Connection refused) Feb 21 17:27:11 pi5 volumio-remote-updater[668]: [2026-02-21 17:27:11] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Feb 21 17:27:11 pi5 volumio-remote-updater[668]: [2026-02-21 17:27:11] [error] handle_connect error: Underlying Transport Error Feb 21 17:27:11 pi5 volumio[667]: Could not open config: /tmp/upmpdcli.conf Feb 21 17:27:11 pi5 haveged[657]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.2.0 CTV); collect: 128K Feb 21 17:27:11 pi5 haveged[657]: haveged: cpu: (VC); data: 64K (V); inst: 64K (V); idx: 39/40; sz: 63488/63488 Feb 21 17:27:11 pi5 haveged[657]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 8.00211 Feb 21 17:27:11 pi5 haveged[657]: haveged: fills: 0, generated: 0 Feb 21 17:27:11 pi5 systemd[1]: Started triggerhappy global hotkey daemon. Feb 21 17:27:11 pi5 systemd[1]: Started RPC bind portmap service. Feb 21 17:27:11 pi5 systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Feb 21 17:27:11 pi5 systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Feb 21 17:27:11 pi5 systemd[1]: dhcpcd.service: Control process exited, code=exited, status=6/NOTCONFIGURED Feb 21 17:27:11 pi5 systemd[1]: dhcpcd.service: Failed with result 'exit-code'. Feb 21 17:27:11 pi5 systemd[1]: Failed to start dhcpcd on all interfaces. Feb 21 17:27:11 pi5 systemd[1]: Started Save/Restore Sound Card State. Feb 21 17:27:11 pi5 dbus-daemon[670]: [system] Successfully activated service 'org.freedesktop.systemd1' Feb 21 17:27:11 pi5 systemd[1]: Starting Load/Save RF Kill Switch Status... Feb 21 17:27:11 pi5 systemd[1]: Reached target Sound Card. Feb 21 17:27:11 pi5 systemd[1]: Reached target Remote File Systems (Pre). Feb 21 17:27:11 pi5 systemd[1]: Reached target Remote File Systems. Feb 21 17:27:11 pi5 systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Feb 21 17:27:11 pi5 systemd[1]: Reached target RPC Port Mapper. Feb 21 17:27:11 pi5 systemd[1]: Created slice system-bthelper.slice. Feb 21 17:27:11 pi5 systemd[1]: Condition check resulted in Configure Bluetooth Modems connected by UART being skipped. Feb 21 17:27:11 pi5 systemd[1]: Starting Raspberry Pi bluetooth helper... Feb 21 17:27:11 pi5 volumio-time-update[675]: volumio-time-update-util: Date not found in response Feb 21 17:27:11 pi5 volumio-time-update[675]: volumio-time-update-util: Retrying in 5 seconds... Feb 21 17:27:11 pi5 systemd[1]: Started Load/Save RF Kill Switch Status. Feb 21 17:27:11 pi5 systemd[1]: Started Avahi mDNS/DNS-SD Stack. Feb 21 17:27:11 pi5 systemd[1]: Started Login Service. Feb 21 17:27:11 pi5 systemd[1]: Started WPA supplicant. Feb 21 17:27:11 pi5 systemd[1]: Found device /sys/subsystem/net/devices/wlan0. Feb 21 17:27:11 pi5 systemd[1]: Started ifup for wlan0. Feb 21 17:27:11 pi5 systemd[1]: iptables.service: Succeeded. Feb 21 17:27:11 pi5 kernel: warning: `iwconfig' uses wireless extensions which will stop working for Wi-Fi 7 hardware; use nl80211 Feb 21 17:27:11 pi5 loadcpufreq[731]: Loading cpufreq kernel modules...done (none). Feb 21 17:27:11 pi5 systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Feb 21 17:27:11 pi5 systemd[1]: Starting LSB: set CPUFreq kernel parameters... Feb 21 17:27:11 pi5 kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Feb 21 17:27:11 pi5 sh[749]: wlan0=wlan0 Feb 21 17:27:11 pi5 cpufrequtils[789]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Feb 21 17:27:11 pi5 systemd[1]: Started LSB: set CPUFreq kernel parameters. Feb 21 17:27:12 pi5 kernel: Bluetooth: hci0: BCM: features 0x2f Feb 21 17:27:12 pi5 kernel: Bluetooth: hci0: BCM43455 37.4MHz Raspberry Pi 3+ Feb 21 17:27:12 pi5 kernel: Bluetooth: hci0: BCM4345C0 (003.001.025) build 0342 Feb 21 17:27:12 pi5 kernel: Bluetooth: hci0: BCM: Using default device address (43:45:c0:00:1f:ac) Feb 21 17:27:12 pi5 bthelper[732]: Raspberry Pi BDADDR already set Feb 21 17:27:12 pi5 systemd[1]: Started Raspberry Pi bluetooth helper. Feb 21 17:27:12 pi5 systemd[1]: Starting Bluetooth service... Feb 21 17:27:12 pi5 wireless.js[678]: Cleaning previous... Feb 21 17:27:12 pi5 bluetoothd[833]: Bluetooth daemon 5.83 Feb 21 17:27:12 pi5 bluetoothd[833]: src/main.c:check_options() Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Feb 21 17:27:12 pi5 bluetoothd[833]: Starting SDP server Feb 21 17:27:12 pi5 bluetoothd[833]: Excluding (cli) hostname Feb 21 17:27:12 pi5 bluetoothd[833]: Excluding (cli) scanparam Feb 21 17:27:12 pi5 bluetoothd[833]: Excluding (cli) battery Feb 21 17:27:12 pi5 systemd[1]: Started Bluetooth service. Feb 21 17:27:12 pi5 systemd[1]: Reached target Bluetooth. Feb 21 17:27:12 pi5 kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Feb 21 17:27:12 pi5 kernel: Bluetooth: BNEP filters: protocol multicast Feb 21 17:27:12 pi5 kernel: Bluetooth: BNEP socket layer initialized Feb 21 17:27:12 pi5 bluetoothd[833]: Bluetooth management interface 1.22 initialized Feb 21 17:27:12 pi5 bluetoothd[833]: Battery Provider Manager created Feb 21 17:27:12 pi5 kernel: Bluetooth: MGMT ver 1.22 Feb 21 17:27:12 pi5 kernel: NET: Registered PF_ALG protocol family Feb 21 17:27:12 pi5 sudo[844]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Feb 21 17:27:12 pi5 sudo[844]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 17:27:12 pi5 sudo[844]: pam_unix(sudo:session): session closed for user root Feb 21 17:27:12 pi5 sudo[848]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Feb 21 17:27:12 pi5 sudo[848]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 17:27:12 pi5 bluetoothd[833]: Failed to set privacy: Rejected (0x0b) Feb 21 17:27:12 pi5 sudo[848]: pam_unix(sudo:session): session closed for user root Feb 21 17:27:12 pi5 wireless.js[678]: Stopped aP Feb 21 17:27:12 pi5 wireless.js[678]: Wireless Networking DISABLED, not starting wireless flow Feb 21 17:27:12 pi5 systemd[1]: wireless.service: Succeeded. Feb 21 17:27:12 pi5 systemd[1]: Started Wireless Services. Feb 21 17:27:12 pi5 systemd[1]: Started Volumio Backend Module. Feb 21 17:27:12 pi5 systemd[1]: Started Volumio Cpu Tweaker. Feb 21 17:27:12 pi5 volumio-cpu-tweak[857]: Setting RT Priority for mpd Feb 21 17:27:12 pi5 volumio-cpu-tweak[857]: pid 35's current scheduling policy: SCHED_OTHER Feb 21 17:27:12 pi5 volumio-cpu-tweak[857]: pid 35's current scheduling priority: 0 Feb 21 17:27:12 pi5 volumio-cpu-tweak[857]: Setting MPD Affinity Feb 21 17:27:12 pi5 volumio-cpu-tweak[857]: pid 3's current affinity mask: f Feb 21 17:27:12 pi5 volumio-cpu-tweak[857]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Feb 21 17:27:12 pi5 volumio-cpu-tweak[857]: VOLUMIO CPU TWEAK: Setting CPU Governor: conservative Feb 21 17:27:12 pi5 systemd[1]: volumio_cpu_tweak.service: Succeeded. Feb 21 17:27:13 pi5 systemd[1]: Started Helper to synchronize boot up for ifupdown. Feb 21 17:27:13 pi5 systemd[1]: Starting Raise network interfaces... Feb 21 17:27:13 pi5 systemd[1]: Started Raise network interfaces. Feb 21 17:27:13 pi5 systemd[1]: Reached target Network. Feb 21 17:27:13 pi5 systemd[1]: Starting Permit User Sessions... Feb 21 17:27:13 pi5 systemd[1]: Reached target Network is Online. Feb 21 17:27:13 pi5 systemd[1]: Starting LSB: Brings up/down network automatically... Feb 21 17:27:13 pi5 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 21 17:27:13 pi5 systemd[1]: Starting /etc/rc.local Compatibility... Feb 21 17:27:13 pi5 systemd[1]: Starting Samba NMB Daemon... Feb 21 17:27:13 pi5 systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Feb 21 17:27:13 pi5 systemd[1]: Starting Network Time Service... Feb 21 17:27:13 pi5 systemd[1]: Started Permit User Sessions. Feb 21 17:27:13 pi5 systemd[1]: Started /etc/rc.local Compatibility. Feb 21 17:27:13 pi5 systemd[1]: Starting Hold until boot process finishes up... Feb 21 17:27:13 pi5 systemd[1]: Starting Terminate Plymouth Boot Screen... Feb 21 17:27:13 pi5 systemd[1]: Received SIGRTMIN+21 from PID 251 (plymouthd). Feb 21 17:27:13 pi5 systemd[1]: Received SIGRTMIN+21 from PID 251 (plymouthd). Feb 21 17:27:13 pi5 ifplugd(eth0)[954]: ifplugd 0.28 initializing. Feb 21 17:27:13 pi5 ifplugd(eth0)[954]: Using interface eth0/2C:CF:67:7A:96:1F with driver (version: 6.6.62-v8+) Feb 21 17:27:13 pi5 ifplugd(eth0)[954]: Using detection mode: SIOCETHTOOL Feb 21 17:27:13 pi5 ifplugd(eth0)[954]: Initialization complete, link beat not detected. Feb 21 17:27:13 pi5 systemd[1]: plymouth-quit-wait.service: Succeeded. Feb 21 17:27:13 pi5 systemd[1]: Started Hold until boot process finishes up. Feb 21 17:27:13 pi5 systemd[1]: plymouth-quit.service: Succeeded. Feb 21 17:27:13 pi5 systemd[1]: Started Terminate Plymouth Boot Screen. Feb 21 17:27:13 pi5 systemd[1]: Started Serial Getty on ttyAMA10. Feb 21 17:27:13 pi5 systemd[1]: Started Getty on tty1. Feb 21 17:27:13 pi5 systemd[1]: Reached target Login Prompts. Feb 21 17:27:13 pi5 ntpd[936]: ntpd 4.2.8p12@1.3728-o (1): Starting Feb 21 17:27:13 pi5 ntpd[936]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103 Feb 21 17:27:13 pi5 systemd[1]: Started Network Time Service. Feb 21 17:27:13 pi5 ntpd[961]: proto: precision = 0.351 usec (-21) Feb 21 17:27:13 pi5 ntpd[961]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Feb 21 17:27:13 pi5 ntpd[961]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Feb 21 17:27:13 pi5 ntpd[961]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 421 days ago Feb 21 17:27:13 pi5 ntpd[961]: Listen and drop on 0 v6wildcard [::]:123 Feb 21 17:27:13 pi5 ntpd[961]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Feb 21 17:27:13 pi5 ntpd[961]: Listen normally on 2 lo 127.0.0.1:123 Feb 21 17:27:13 pi5 ntpd[961]: Listening on routing socket on fd #19 for interface updates Feb 21 17:27:13 pi5 ntpd[961]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Feb 21 17:27:13 pi5 ntpd[961]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Feb 21 17:27:13 pi5 ifplugd[930]: Network Interface Plugging Daemon...start eth0...done. Feb 21 17:27:13 pi5 systemd[1]: Started LSB: Brings up/down network automatically. Feb 21 17:27:13 pi5 nmbd[938]: [2026/02/21 17:27:13.533882, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Feb 21 17:27:13 pi5 nmbd[938]: started asyncdns process 963 Feb 21 17:27:13 pi5 nmbd[938]: [2026/02/21 17:27:13.534613, 0] ../lib/util/become_daemon.c:149(daemon_status) Feb 21 17:27:13 pi5 nmbd[938]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Feb 21 17:27:13 pi5 nmbd[938]: [2026/02/21 17:27:13.534657, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Feb 21 17:27:13 pi5 nmbd[938]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Feb 21 17:27:13 pi5 volumio[856]: info: ------------------------------------------- Feb 21 17:27:13 pi5 volumio[856]: info: ----- Volumio3 ---- Feb 21 17:27:13 pi5 volumio[856]: info: ------------------------------------------- Feb 21 17:27:13 pi5 volumio[856]: info: ----- System startup ---- Feb 21 17:27:13 pi5 volumio[856]: info: ------------------------------------------- Feb 21 17:27:13 pi5 volumio[856]: info: MYVOLUMIO Environment detected Feb 21 17:27:13 pi5 volumio[856]: info: Found new core plugin system_controller/volumio5onboarding. Adding it Feb 21 17:27:14 pi5 volumio[856]: info: Plugin folders cleanup Feb 21 17:27:14 pi5 volumio[856]: info: Scanning into folder /volumio/app/plugins/ Feb 21 17:27:14 pi5 volumio[856]: info: Scanning category audio_interface Feb 21 17:27:14 pi5 volumio[856]: info: Scanning category miscellanea Feb 21 17:27:14 pi5 volumio[856]: info: Scanning category music_service Feb 21 17:27:14 pi5 volumio[856]: info: Scanning category plugins.json Feb 21 17:27:14 pi5 volumio[856]: info: Scanning category system_controller Feb 21 17:27:14 pi5 volumio[856]: info: Scanning category user_interface Feb 21 17:27:14 pi5 volumio[856]: info: Scanning into folder /data/plugins/ Feb 21 17:27:14 pi5 volumio[856]: info: Plugin folders cleanup completed Feb 21 17:27:14 pi5 volumio[856]: info: ------------------------------------------- Feb 21 17:27:14 pi5 volumio[856]: info: ----- Core plugins startup ---- Feb 21 17:27:14 pi5 volumio[856]: info: ------------------------------------------- Feb 21 17:27:14 pi5 volumio[856]: info: Loading plugins from folder /volumio/app/plugins/ Feb 21 17:27:14 pi5 volumio[856]: info: Adding plugin upnp to MyMusic Plugins Feb 21 17:27:14 pi5 volumio[856]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 21 17:27:14 pi5 volumio[856]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 21 17:27:14 pi5 volumio[856]: info: Loading plugins from folder /data/plugins/ Feb 21 17:27:14 pi5 volumio[856]: info: Loading plugin "system"... Feb 21 17:27:14 pi5 volumio[856]: info: Loading plugin "appearance"... Feb 21 17:27:14 pi5 ntpd[961]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Feb 21 17:27:14 pi5 volumio[856]: info: Loading plugin "network"... Feb 21 17:27:14 pi5 volumio[856]: info: Refreshing Cached IP Addresses Feb 21 17:27:14 pi5 sudo[978]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 21 17:27:14 pi5 sudo[978]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 17:27:14 pi5 sudo[980]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 21 17:27:14 pi5 sudo[980]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 17:27:14 pi5 volumio[856]: info: Loading plugin "services"... Feb 21 17:27:14 pi5 sudo[978]: pam_unix(sudo:session): session closed for user root Feb 21 17:27:14 pi5 volumio[856]: info: Loading plugin "volumio5onboarding"... Feb 21 17:27:14 pi5 sudo[980]: pam_unix(sudo:session): session closed for user root Feb 21 17:27:14 pi5 volumio[856]: info: Loading plugin "alsa_controller"... Feb 21 17:27:14 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 21 17:27:14 pi5 volumio[856]: info: Loading plugin "wizard"... Feb 21 17:27:14 pi5 volumio[856]: info: Loading plugin "networkfs"... Feb 21 17:27:14 pi5 volumio[856]: info: Starting Udev Watcher for removable devices Feb 21 17:27:14 pi5 sudo[1001]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=music,password=Orange001122,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.20/lossless /mnt/NAS/lossless Feb 21 17:27:14 pi5 sudo[1001]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 17:27:14 pi5 volumio[856]: info: Ignoring mount for partition: boot Feb 21 17:27:14 pi5 volumio[856]: info: Ignoring mount for partition: volumio Feb 21 17:27:14 pi5 volumio[856]: info: Ignoring mount for partition: volumio_data Feb 21 17:27:14 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 21 17:27:14 pi5 volumio[856]: info: Loading plugin "volumio_command_line_client"... Feb 21 17:27:14 pi5 volumio[856]: info: Plugin upnp is not enabled Feb 21 17:27:14 pi5 volumio[856]: info: Loading plugin "my_music"... Feb 21 17:27:14 pi5 volumio[856]: info: Loading plugin "mpd"... Feb 21 17:27:14 pi5 kernel: Key type cifs.spnego registered Feb 21 17:27:14 pi5 kernel: Key type cifs.idmap registered Feb 21 17:27:14 pi5 sudo[1001]: pam_unix(sudo:session): session closed for user root Feb 21 17:27:14 pi5 kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. Feb 21 17:27:14 pi5 kernel: CIFS: Attempting to mount //192.168.0.20/lossless Feb 21 17:27:14 pi5 kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Feb 21 17:27:14 pi5 kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Feb 21 17:27:14 pi5 volumio[856]: info: Plugin upnp_browser is not enabled Feb 21 17:27:14 pi5 volumio[856]: info: Loading plugin "alarm-clock"... Feb 21 17:27:14 pi5 volumio[856]: info: Plugin airplay_emulation is not enabled Feb 21 17:27:14 pi5 volumio[856]: info: Loading plugin "last_100"... Feb 21 17:27:14 pi5 volumio[856]: info: Loading plugin "webradio"... Feb 21 17:27:14 pi5 volumio[856]: info: Loading plugin "i2s_dacs"... Feb 21 17:27:14 pi5 volumio[856]: info: Loading plugin "volumiodiscovery"... Feb 21 17:27:14 pi5 volumio[856]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 21 17:27:14 pi5 node[856]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 21 17:27:14 pi5 node[856]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 21 17:27:14 pi5 volumio[856]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 21 17:27:14 pi5 volumio[856]: *** WARNING *** For more information see Feb 21 17:27:14 pi5 volumio[856]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 21 17:27:14 pi5 volumio[856]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 21 17:27:14 pi5 volumio[856]: *** WARNING *** For more information see Feb 21 17:27:14 pi5 node[856]: *** WARNING *** For more information see Feb 21 17:27:14 pi5 node[856]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 21 17:27:14 pi5 node[856]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 21 17:27:14 pi5 node[856]: *** WARNING *** For more information see Feb 21 17:27:14 pi5 volumio[856]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 21 17:27:14 pi5 volumio[856]: info: Discovery: Started advertising with name: Pi5 Feb 21 17:27:14 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 21 17:27:14 pi5 volumio[856]: info: Loading plugin "outputs"... Feb 21 17:27:14 pi5 volumio[856]: info: Loading plugin "albumart"... Feb 21 17:27:14 pi5 volumio[856]: info: Plugin example_plugin is not enabled Feb 21 17:27:14 pi5 volumio[856]: info: Loading plugin "inputs"... Feb 21 17:27:14 pi5 volumio[856]: info: Loading plugin "updater_comm"... Feb 21 17:27:14 pi5 volumio[856]: info: Plugin mpdemulation is not enabled Feb 21 17:27:14 pi5 volumio[856]: info: Loading plugin "rest_api"... Feb 21 17:27:14 pi5 volumio[856]: info: Loading plugin "websocket"... Feb 21 17:27:14 pi5 volumio[856]: Forking 3 albumart workers Feb 21 17:27:14 pi5 volumio[856]: info: Starting Socket.io Server version 2.3.0 Feb 21 17:27:14 pi5 volumio[856]: info: Loading i18n strings for locale en Feb 21 17:27:14 pi5 volumio[856]: Updating browse sources language Feb 21 17:27:14 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 21 17:27:14 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 21 17:27:14 pi5 volumio[856]: info: CoreCommandRouter::initPlayerControls Feb 21 17:27:14 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 17:27:14 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 17:27:14 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 17:27:14 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 17:27:14 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 17:27:14 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 17:27:14 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 17:27:14 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 17:27:14 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 21 17:27:14 pi5 volumio[856]: Express server listening on port 3000 Feb 21 17:27:14 pi5 volumio[856]: [Metrics] WebUI: 1s 553.74ms Feb 21 17:27:14 pi5 volumio[856]: info: CoreStateMachine::resetVolumioState Feb 21 17:27:14 pi5 volumio[856]: info: CoreStateMachine::getcurrentVolume Feb 21 17:27:14 pi5 volumio[856]: info: CoreCommandRouter::volumioRetrievevolume Feb 21 17:27:14 pi5 volumio[856]: info: CoreStateMachine::pushState Feb 21 17:27:14 pi5 volumio[856]: info: CorePlayQueue::getTrack 0 Feb 21 17:27:14 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 17:27:14 pi5 volumio[856]: info: CoreCommandRouter::volumioPushState Feb 21 17:27:14 pi5 volumio[856]: info: Volumio Network Manager: Network status updated: 0 Feb 21 17:27:14 pi5 volumio[856]: info: Cannot mount NAS lossless at system boot, trial number 1 ,retrying in 5 seconds Feb 21 17:27:14 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 17:27:14 pi5 volumio[856]: info: Reloading queue from file Feb 21 17:27:14 pi5 volumio[856]: info: CoreStateMachine::setRepeat null single undefined Feb 21 17:27:14 pi5 volumio[856]: info: CoreStateMachine::pushState Feb 21 17:27:14 pi5 volumio[856]: info: CorePlayQueue::getTrack 0 Feb 21 17:27:14 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 17:27:14 pi5 volumio[856]: info: CoreCommandRouter::volumioPushState Feb 21 17:27:14 pi5 volumio[856]: info: CoreStateMachine::setRandom false Feb 21 17:27:14 pi5 volumio[856]: info: CoreStateMachine::pushState Feb 21 17:27:14 pi5 volumio[856]: info: CorePlayQueue::getTrack 0 Feb 21 17:27:14 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 17:27:14 pi5 volumio[856]: info: CoreCommandRouter::volumioPushState Feb 21 17:27:14 pi5 volumio[856]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Feb 21 17:27:14 pi5 volumio[856]: info: USB Boot Capable - System SBC Revision found in cpuinfo: b04170 Feb 21 17:27:14 pi5 volumio[856]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Feb 21 17:27:14 pi5 volumio[856]: info: Setting Device type: Raspberry PI Feb 21 17:27:14 pi5 volumio[856]: info: Completed loading Core Plugins Feb 21 17:27:14 pi5 volumio[856]: info: Preparing to generate the ALSA configuration file Feb 21 17:27:15 pi5 volumio[856]: info: Asound.conf file unchanged, so no further update is needed Feb 21 17:27:15 pi5 volumio[856]: info: Output device has changed, restarting MPD Feb 21 17:27:15 pi5 volumio[856]: info: ___________ START PLUGINS ___________ Feb 21 17:27:15 pi5 sudo[1054]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 21 17:27:15 pi5 sudo[1054]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 17:27:15 pi5 sudo[1054]: pam_unix(sudo:session): session closed for user root Feb 21 17:27:15 pi5 sudo[1056]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 21 17:27:15 pi5 sudo[1056]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 17:27:15 pi5 volumio[856]: info: ControllerMpd::onStart: Initializing MPD Feb 21 17:27:15 pi5 volumio[856]: info: Creating MPD Configuration file Feb 21 17:27:15 pi5 sudo[1060]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service Feb 21 17:27:15 pi5 sudo[1060]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 17:27:15 pi5 sudo[1063]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 21 17:27:15 pi5 sudo[1063]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 17:27:15 pi5 volumio[856]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 21 17:27:15 pi5 volumio[856]: info: [1771694835048] CoreMusicLibrary::Adding element Last_100 Feb 21 17:27:15 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 21 17:27:15 pi5 volumio[856]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 21 17:27:15 pi5 volumio[856]: info: [1771694835049] CoreMusicLibrary::Adding element Webradio Feb 21 17:27:15 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 21 17:27:15 pi5 sudo[1063]: pam_unix(sudo:session): session closed for user root Feb 21 17:27:15 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 21 17:27:15 pi5 volumio[856]: info: Initializing BBC Radios Feb 21 17:27:15 pi5 sudo[1067]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 21 17:27:15 pi5 sudo[1067]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 17:27:15 pi5 volumio[856]: Starting albumart workers Feb 21 17:27:15 pi5 systemd[1]: Listening on mpd.socket. Feb 21 17:27:15 pi5 systemd[1]: Starting Music Player Daemon... Feb 21 17:27:15 pi5 systemd[1]: Started Volumio5 Onboarding Server. Feb 21 17:27:15 pi5 sudo[1060]: pam_unix(sudo:session): session closed for user root Feb 21 17:27:15 pi5 systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Feb 21 17:27:15 pi5 systemd[1]: mpd.service: Succeeded. Feb 21 17:27:15 pi5 systemd[1]: Stopped Music Player Daemon. Feb 21 17:27:15 pi5 systemd[1]: Starting Music Player Daemon... Feb 21 17:27:15 pi5 volumio[856]: Starting albumart workers Feb 21 17:27:15 pi5 sudo[1074]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 21 17:27:15 pi5 sudo[1074]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 17:27:15 pi5 sudo[1074]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Feb 21 17:27:15 pi5 sudo[1074]: pam_unix(sudo:session): session closed for user root Feb 21 17:27:15 pi5 volumio[856]: Starting albumart workers Feb 21 17:27:15 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 21 17:27:15 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 17:27:15 pi5 volumio[856]: info: Volumio Calling Home Feb 21 17:27:15 pi5 volumio[856]: info: MPD Permissions set Feb 21 17:27:15 pi5 volumio[856]: info: MPD Permissions set Feb 21 17:27:15 pi5 ntpd[961]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Feb 21 17:27:15 pi5 volumio[856]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Feb 21 17:27:15 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 17:27:15 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 17:27:15 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 17:27:15 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 17:27:15 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 17:27:15 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 17:27:15 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 17:27:15 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 17:27:15 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 17:27:15 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 17:27:15 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 17:27:15 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 17:27:15 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 17:27:15 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 17:27:15 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 17:27:15 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 17:27:15 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 17:27:15 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 17:27:15 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 17:27:15 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 17:27:15 pi5 volumio[856]: info: CoreCommandRouter::volumioGetState Feb 21 17:27:15 pi5 volumio[856]: info: CorePlayQueue::getTrack 0 Feb 21 17:27:15 pi5 volumio5-onboarding[1073]: time=2026-02-21T17:27:15.411Z level=INFO msg="running volumio5-device-gateway" version=30d1950e+CHANGES buildDate=2026-01-29T13:10:08Z Feb 21 17:27:15 pi5 volumio[856]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Feb 21 17:27:15 pi5 volumio[856]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Feb 21 17:27:15 pi5 volumio[856]: info: Received Get System Info Feb 21 17:27:15 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 17:27:15 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 17:27:15 pi5 volumio[856]: info: Discovery: Getting this device information Feb 21 17:27:15 pi5 volumio[856]: info: CoreCommandRouter::volumioGetState Feb 21 17:27:15 pi5 volumio[856]: info: CorePlayQueue::getTrack 0 Feb 21 17:27:15 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 17:27:15 pi5 volumio5-onboarding[1073]: time=2026-02-21T17:27:15.429Z level=INFO msg="system info for 2515ee23b5c1607e2957e31b5bb3ec87" deviceName=Pi5 deviceVariant=volumio deviceModel= softwareVersion=3.908 Feb 21 17:27:15 pi5 volumio[856]: info: Received Get System Info Feb 21 17:27:15 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 17:27:15 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 17:27:15 pi5 volumio[856]: info: Discovery: Getting this device information Feb 21 17:27:15 pi5 volumio[856]: info: CoreCommandRouter::volumioGetState Feb 21 17:27:15 pi5 volumio[856]: info: CorePlayQueue::getTrack 0 Feb 21 17:27:15 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 17:27:15 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 21 17:27:15 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 21 17:27:15 pi5 volumio5-onboarding[1073]: time=2026-02-21T17:27:15.432Z level=INFO msg="enabling local network discovery" Feb 21 17:27:15 pi5 volumio5-onboarding[1073]: time=2026-02-21T17:27:15.444Z level=INFO msg="enabling BLE discovery" Feb 21 17:27:15 pi5 volumio5-onboarding[1073]: time=2026-02-21T17:27:15.515Z level=INFO msg="bootstrapping state" hasInternet=false Feb 21 17:27:15 pi5 sh[628]: eth0: carrier acquired Feb 21 17:27:15 pi5 dhcpcd[663]: eth0: carrier acquired Feb 21 17:27:15 pi5 kernel: macb 1f00100000.ethernet eth0: Link is Up - 1Gbps/Full - flow control off Feb 21 17:27:15 pi5 sh[628]: DUID 00:01:00:01:2e:f2:a2:d7:2c:cf:67:7a:96:1f Feb 21 17:27:15 pi5 sh[628]: eth0: IAID 67:7a:96:1f Feb 21 17:27:15 pi5 sh[628]: eth0: adding address fe80::2ecf:67ff:fe7a:961f Feb 21 17:27:15 pi5 sh[628]: ipv6_addaddr1: Permission denied Feb 21 17:27:15 pi5 dhcpcd[663]: DUID 00:01:00:01:2e:f2:a2:d7:2c:cf:67:7a:96:1f Feb 21 17:27:15 pi5 dhcpcd[663]: eth0: IAID 67:7a:96:1f Feb 21 17:27:15 pi5 dhcpcd[663]: eth0: adding address fe80::2ecf:67ff:fe7a:961f Feb 21 17:27:15 pi5 dhcpcd[663]: ipv6_addaddr1: Permission denied Feb 21 17:27:16 pi5 volumio[856]: info: Received Get System Info Feb 21 17:27:16 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 17:27:16 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 17:27:16 pi5 volumio[856]: info: Discovery: Getting this device information Feb 21 17:27:16 pi5 volumio[856]: info: CoreCommandRouter::volumioGetState Feb 21 17:27:16 pi5 volumio[856]: info: CorePlayQueue::getTrack 0 Feb 21 17:27:16 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 17:27:16 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 21 17:27:16 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 21 17:27:16 pi5 ntpd[961]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Feb 21 17:27:16 pi5 sh[628]: eth0: soliciting an IPv6 router Feb 21 17:27:16 pi5 dhcpcd[663]: eth0: soliciting an IPv6 router Feb 21 17:27:16 pi5 ifplugd(eth0)[954]: Link beat detected. Feb 21 17:27:16 pi5 ifplugd(eth0)[954]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Feb 21 17:27:16 pi5 ifplugd(eth0)[954]: client: ifup: waiting for lock on /run/network/ifstate.eth0 Feb 21 17:27:16 pi5 sh[628]: eth0: soliciting a DHCP lease Feb 21 17:27:16 pi5 dhcpcd[663]: eth0: soliciting a DHCP lease Feb 21 17:27:16 pi5 sh[628]: eth0: offered 192.168.1.130 from 192.168.1.1 Feb 21 17:27:16 pi5 dhcpcd[663]: eth0: offered 192.168.1.130 from 192.168.1.1 Feb 21 17:27:16 pi5 sh[628]: eth0: probing address 192.168.1.130/24 Feb 21 17:27:16 pi5 dhcpcd[663]: eth0: probing address 192.168.1.130/24 Feb 21 17:27:16 pi5 volumio-remote-updater[668]: [2026-02-21 17:27:16] [connect] Successful connection Feb 21 17:27:16 pi5 volumio-remote-updater[668]: [2026-02-21 17:27:16] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1771694836 101 Feb 21 17:27:16 pi5 volumio[856]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 3 Feb 21 17:27:16 pi5 volumio-time-update[675]: volumio-time-update-util: Fetching time from Volumio... Feb 21 17:27:16 pi5 volumio-time-update[675]: volumio-time-update-util: Date not found in response Feb 21 17:27:16 pi5 volumio-time-update[675]: volumio-time-update-util: Retrying in 5 seconds... Feb 21 17:27:16 pi5 systemd[1]: systemd-rfkill.service: Succeeded. Feb 21 17:27:16 pi5 mpd[1081]: Feb 21 17:27 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 21 17:27:16 pi5 systemd[1]: Started Music Player Daemon. Feb 21 17:27:16 pi5 sudo[1056]: pam_unix(sudo:session): session closed for user root Feb 21 17:27:16 pi5 sudo[1067]: pam_unix(sudo:session): session closed for user root Feb 21 17:27:16 pi5 volumio[856]: info: Completed starting Core Plugins Feb 21 17:27:16 pi5 volumio[856]: info: ------------------------------------------- Feb 21 17:27:16 pi5 volumio[856]: info: ----- MyVolumio plugins startup ---- Feb 21 17:27:16 pi5 volumio[856]: info: ------------------------------------------- Feb 21 17:27:16 pi5 volumio[856]: info: [MyVolumio PluginManager] Fetching plans data.... Feb 21 17:27:16 pi5 volumio[856]: error: MPD error: The expression evaluated to a falsy value: Feb 21 17:27:16 pi5 volumio[856]: assert.ok(self.idling) Feb 21 17:27:16 pi5 volumio[856]: error: The expression evaluated to a falsy value: Feb 21 17:27:16 pi5 volumio[856]: assert.ok(self.idling) Feb 21 17:27:16 pi5 volumio[856]: info: MPD running with PID1081 Feb 21 17:27:16 pi5 volumio[856]: ,establishing connection Feb 21 17:27:16 pi5 volumio[856]: error: MPD error: The expression evaluated to a falsy value: Feb 21 17:27:16 pi5 volumio[856]: assert.ok(self.idling) Feb 21 17:27:16 pi5 volumio[856]: error: The expression evaluated to a falsy value: Feb 21 17:27:16 pi5 volumio[856]: assert.ok(self.idling) Feb 21 17:27:16 pi5 volumio[856]: error: updateQueue error: null Feb 21 17:27:17 pi5 bluetoothd[833]: src/adv_monitor.c:btd_adv_monitor_power_down() Unexpected NULL btd_adv_monitor_manager object upon power down Feb 21 17:27:17 pi5 bthelper[732]: [NEW] Media /org/bluez/hci0 Feb 21 17:27:17 pi5 bthelper[732]: SupportedUUIDs: 0000110a-0000-1000-8000-00805f9b34fb Feb 21 17:27:17 pi5 bthelper[732]: SupportedUUIDs: 0000110b-0000-1000-8000-00805f9b34fb Feb 21 17:27:17 pi5 bthelper[732]: hci0 class of device changed: 0x000000 Feb 21 17:27:17 pi5 bthelper[732]: hci0 new_settings: connectable discoverable bondable ssp br/edr le secure-conn Feb 21 17:27:17 pi5 bthelper[732]: [CHG] Controller 2C:CF:67:7A:96:22 PowerState: on-disabling Feb 21 17:27:17 pi5 bthelper[732]: Changing power off succeeded Feb 21 17:27:17 pi5 bthelper[732]: [NEW] Media /org/bluez/hci0 Feb 21 17:27:17 pi5 bthelper[732]: SupportedUUIDs: 0000110a-0000-1000-8000-00805f9b34fb Feb 21 17:27:17 pi5 bthelper[732]: SupportedUUIDs: 0000110b-0000-1000-8000-00805f9b34fb Feb 21 17:27:17 pi5 bthelper[732]: [CHG] Controller 2C:CF:67:7A:96:22 PowerState: off-enabling Feb 21 17:27:17 pi5 bthelper[732]: hci0 class of device changed: 0x00041c Feb 21 17:27:17 pi5 bthelper[732]: [CHG] Controller 2C:CF:67:7A:96:22 Class: 0x0000041c (1052) Feb 21 17:27:17 pi5 bthelper[732]: hci0 new_settings: powered connectable discoverable bondable ssp br/edr le secure-conn Feb 21 17:27:17 pi5 bthelper[732]: Changing power on succeeded Feb 21 17:27:17 pi5 ntpd[961]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Feb 21 17:27:19 pi5 sudo[1147]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=music,password=Orange001122,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.20/lossless /mnt/NAS/lossless Feb 21 17:27:19 pi5 sudo[1147]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 17:27:19 pi5 sudo[1147]: pam_unix(sudo:session): session closed for user root Feb 21 17:27:19 pi5 kernel: CIFS: Attempting to mount //192.168.0.20/lossless Feb 21 17:27:19 pi5 kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Feb 21 17:27:19 pi5 kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Feb 21 17:27:19 pi5 volumio[856]: info: Cannot mount NAS lossless at system boot, trial number 2 ,retrying in 5 seconds Feb 21 17:27:21 pi5 volumio-time-update[675]: volumio-time-update-util: Fetching time from Volumio... Feb 21 17:27:21 pi5 volumio-time-update[675]: volumio-time-update-util: Date not found in response Feb 21 17:27:21 pi5 volumio-time-update[675]: volumio-time-update-util: Retrying in 5 seconds... Feb 21 17:27:21 pi5 sh[628]: eth0: leased 192.168.1.130 for 43200 seconds Feb 21 17:27:21 pi5 dhcpcd[663]: eth0: leased 192.168.1.130 for 43200 seconds Feb 21 17:27:21 pi5 sh[628]: eth0: adding route to 192.168.1.0/24 Feb 21 17:27:21 pi5 sh[628]: eth0: adding default route via 192.168.1.1 Feb 21 17:27:21 pi5 avahi-daemon[666]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.130. Feb 21 17:27:21 pi5 avahi-daemon[666]: New relevant interface eth0.IPv4 for mDNS. Feb 21 17:27:21 pi5 dhcpcd[663]: eth0: adding route to 192.168.1.0/24 Feb 21 17:27:21 pi5 dhcpcd[663]: eth0: adding default route via 192.168.1.1 Feb 21 17:27:21 pi5 avahi-daemon[666]: Registering new address record for 192.168.1.130 on eth0.IPv4. Feb 21 17:27:21 pi5 sh[628]: forked to background, child pid 1177 Feb 21 17:27:21 pi5 dhcpcd[663]: forked to background, child pid 1177 Feb 21 17:27:21 pi5 ifplugd(eth0)[954]: client: ifup: interface eth0 already configured Feb 21 17:27:21 pi5 sh[628]: eth0=eth0 Feb 21 17:27:21 pi5 ifplugd(eth0)[954]: Program executed successfully. Feb 21 17:27:21 pi5 volumio[856]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Feb 21 17:27:22 pi5 volumio[856]: info: Received Get System Info Feb 21 17:27:22 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 17:27:22 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 17:27:22 pi5 volumio[856]: info: Discovery: Getting this device information Feb 21 17:27:22 pi5 volumio[856]: info: CoreCommandRouter::volumioGetState Feb 21 17:27:22 pi5 volumio[856]: info: CorePlayQueue::getTrack 0 Feb 21 17:27:22 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 17:27:22 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 21 17:27:22 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 21 17:27:22 pi5 volumio5-onboarding[1073]: time=2026-02-21T17:27:22.580Z level=INFO msg="disabling BLE discovery" Feb 21 17:27:22 pi5 volumio5-onboarding[1073]: time=2026-02-21T17:27:22.581Z level=INFO msg="connection closed, stopping read loop" component=conn/multi net=ble addr=2C:CF:67:7A:96:22%00 Feb 21 17:27:22 pi5 volumio[856]: info: Discovery: adding da054e75-5a7c-484b-9c70-71a66efcecb4 Feb 21 17:27:22 pi5 volumio[856]: info: Discovery: Found device Pi5 Feb 21 17:27:22 pi5 volumio[856]: info: CoreCommandRouter::volumioGetState Feb 21 17:27:22 pi5 volumio[856]: info: CorePlayQueue::getTrack 0 Feb 21 17:27:23 pi5 ntpd[961]: Listen normally on 3 eth0 192.168.1.130:123 Feb 21 17:27:23 pi5 ntpd[961]: new interface(s) found: waking up resolver Feb 21 17:27:23 pi5 nmbd[938]: [2026/02/21 17:27:23.537835, 0] ../lib/util/become_daemon.c:138(daemon_ready) Feb 21 17:27:23 pi5 nmbd[938]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Feb 21 17:27:23 pi5 systemd[1]: Started Samba NMB Daemon. Feb 21 17:27:23 pi5 systemd[1]: Starting Samba Winbind Daemon... Feb 21 17:27:23 pi5 winbindd[1205]: [2026/02/21 17:27:23.661359, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Feb 21 17:27:23 pi5 winbindd[1205]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Feb 21 17:27:23 pi5 winbindd[1205]: [2026/02/21 17:27:23.685287, 0] ../lib/util/become_daemon.c:138(daemon_ready) Feb 21 17:27:23 pi5 winbindd[1205]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Feb 21 17:27:23 pi5 systemd[1]: Started Samba Winbind Daemon. Feb 21 17:27:23 pi5 systemd[1]: Starting Samba SMB Daemon... Feb 21 17:27:23 pi5 smbd[1210]: [2026/02/21 17:27:23.835739, 0] ../lib/util/become_daemon.c:138(daemon_ready) Feb 21 17:27:23 pi5 smbd[1210]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Feb 21 17:27:23 pi5 systemd[1]: Started Samba SMB Daemon. Feb 21 17:27:24 pi5 volumio[856]: info: Volumio Network Manager: Network status updated: 1 Feb 21 17:27:24 pi5 sudo[1233]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=music,password=Orange001122,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.20/lossless /mnt/NAS/lossless Feb 21 17:27:24 pi5 sudo[1233]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 17:27:24 pi5 kernel: CIFS: Attempting to mount //192.168.0.20/lossless Feb 21 17:27:25 pi5 volumio[856]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Feb 21 17:27:25 pi5 volumio[856]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Feb 21 17:27:25 pi5 volumio[856]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Feb 21 17:27:25 pi5 volumio[856]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Feb 21 17:27:25 pi5 volumio[856]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Feb 21 17:27:25 pi5 volumio[856]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Feb 21 17:27:25 pi5 volumio[856]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Feb 21 17:27:25 pi5 volumio[856]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Feb 21 17:27:25 pi5 volumio[856]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Feb 21 17:27:25 pi5 volumio[856]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Feb 21 17:27:25 pi5 volumio[856]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Feb 21 17:27:25 pi5 volumio[856]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Feb 21 17:27:25 pi5 volumio[856]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Feb 21 17:27:25 pi5 volumio[856]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Feb 21 17:27:25 pi5 volumio[856]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Feb 21 17:27:25 pi5 volumio[856]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Feb 21 17:27:25 pi5 volumio[856]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Feb 21 17:27:25 pi5 volumio[856]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Feb 21 17:27:25 pi5 volumio[856]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Feb 21 17:27:25 pi5 volumio[856]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Feb 21 17:27:25 pi5 volumio[856]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Feb 21 17:27:25 pi5 volumio[856]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Feb 21 17:27:25 pi5 volumio[856]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Feb 21 17:27:25 pi5 volumio[856]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Feb 21 17:27:25 pi5 volumio[856]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Feb 21 17:27:25 pi5 volumio[856]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Feb 21 17:27:25 pi5 volumio[856]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Feb 21 17:27:25 pi5 volumio[856]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Feb 21 17:27:25 pi5 volumio[856]: info: Adding plugin bluetooth to MyMusic Plugins Feb 21 17:27:25 pi5 volumio[856]: info: Adding plugin multiroom to MyMusic Plugins Feb 21 17:27:25 pi5 volumio[856]: info: Adding plugin metavolumio to MyMusic Plugins Feb 21 17:27:25 pi5 volumio[856]: info: Adding plugin cd_controller to MyMusic Plugins Feb 21 17:27:25 pi5 volumio[856]: info: Adding plugin qobuzconnect to MyMusic Plugins Feb 21 17:27:25 pi5 volumio[856]: info: Adding plugin smart_inputs to MyMusic Plugins Feb 21 17:27:25 pi5 volumio[856]: info: Adding plugin tidalconnect to MyMusic Plugins Feb 21 17:27:25 pi5 volumio[856]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Feb 21 17:27:25 pi5 volumio[856]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Feb 21 17:27:25 pi5 volumio[856]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Feb 21 17:27:25 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 17:27:25 pi5 volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 17:27:25 pi5 volumio[856]: info: Starting MyVolumio Remote Streaming Endpoints Feb 21 17:27:25 pi5 volumio[856]: info: MyVolumio login type: Token Feb 21 17:27:25 pi5 volumio[856]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Feb 21 17:27:25 pi5 volumio[856]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Feb 21 17:27:25 pi5 volumio[856]: info: Starting Streaming Service Transparent Proxy Feb 21 17:27:25 pi5 volumio[856]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Feb 21 17:27:25 pi5 volumio[856]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Feb 21 17:27:25 pi5 volumio[856]: info: Streaming services startup Feb 21 17:27:25 pi5 volumio[856]: info: Starting Streaming Daemon Feb 21 17:27:25 pi5 sudo[1244]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Feb 21 17:27:25 pi5 sudo[1244]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 17:27:25 pi5 volumio[856]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Feb 21 17:27:25 pi5 sudo[1244]: pam_unix(sudo:session): session closed for user root Feb 21 17:27:25 pi5 volumio[856]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=3.908&uuid=2515ee23b5c1607e2957e31b5bb3ec87" http://updates.volumio.org/downloader-v1/track-device Feb 21 17:27:25 pi5 volumio[856]: % Total % Received % Xferd Average Speed Time Time Time Current Feb 21 17:27:25 pi5 volumio[856]: Dload Upload Total Spent Left Speed Feb 21 17:27:25 pi5 volumio[856]: [132B blob data] Feb 21 17:27:25 pi5 volumio[856]: retrying in 5 seconds, trial 0 Feb 21 17:27:25 pi5 volumio[856]: info: Volumio Calling Home Feb 21 17:27:25 pi5 volumio[856]: error: Cannot start Volumio Streaming Daemon Feb 21 17:27:25 pi5 volumio[856]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Feb 21 17:27:25 pi5 volumio[856]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Feb 21 17:27:26 pi5 volumio[856]: STREAMING PROXY: Starting server on port 3245 Feb 21 17:27:26 pi5 volumio[856]: Node JS runtime: 14 Feb 21 17:27:26 pi5 volumio[856]: info: Volumio called home Feb 21 17:27:26 pi5 volumio[856]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Feb 21 17:27:26 pi5 volumio-time-update[675]: volumio-time-update-util: Fetching time from Volumio... Feb 21 17:27:26 pi5 volumio[856]: info: MyVolumio token set successfully Feb 21 17:27:26 pi5 volumio[856]: info: MYVOLUMIO: Adding device Feb 21 17:27:26 pi5 volumio[856]: info: MYVOLUMIO: Evaluating Server Feb 21 17:27:26 pi5 volumio-time-update[675]: volumio-time-update-util: Setting system time to: 2026-02-21 17:27:27 Feb 21 17:27:26 pi5 sudo[1269]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2026-02-21 17:27:27 Feb 21 17:27:26 pi5 sudo[1269]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 17:27:26 pi5 dbus-daemon[670]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.14' (uid=0 pid=1271 comm="timedatectl set-time 2026-02-21 17:27:27 ") Feb 21 17:27:27 pi5 systemd[1]: Starting Time & Date Service... Feb 21 17:27:27 pi5 volumio[856]: info: MyVolumio Plan changed: premium Feb 21 17:27:27 pi5 volumio[856]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Feb 21 17:27:27 pi5 volumio[856]: info: Removing browser output: myVolumio user plan is not superstar Feb 21 17:27:27 pi5 volumio[856]: info: Removing audio output: Feb 21 17:27:27 pi5 volumio[856]: info: MYVOLUMIO: Adding device Feb 21 17:27:27 pi5 volumio[856]: info: MYVOLUMIO: Evaluating Server Feb 21 17:27:27 pi5 volumio[856]: info: Remote config written successfully Feb 21 17:27:27 pi5 volumio[856]: info: Starting Tunnel 1 Feb 21 17:27:27 pi5 volumio[856]: info: Starting Tunnel Connection Checker Feb 21 17:27:27 pi5 volumio[856]: info: Completed starting MyVolumio Plugin Feb 21 17:27:27 pi5 dbus-daemon[670]: [system] Successfully activated service 'org.freedesktop.timedate1' Feb 21 17:27:27 pi5 systemd[1]: Started Time & Date Service. Feb 21 17:27:27 pi5 systemd-timedated[1276]: Changed local time to Sat Feb 21 17:27:27 2026 Feb 21 17:27:27 pi5 sudo[1269]: pam_unix(sudo:session): session closed for user root Feb 21 17:27:27 pi5 volumio-time-update[675]: volumio-time-update-util: System time updated successfully. Feb 21 17:27:27 pi5 systemd[1]: Started Volumio Time Update Utility. Feb 21 17:27:27 pi5 systemd[1]: Reached target Multi-User System. Feb 21 17:27:27 pi5 systemd[1]: Reached target Graphical Interface. Feb 21 17:27:27 pi5 systemd[1]: Starting Update UTMP about System Runlevel Changes... Feb 21 17:27:27 pi5 volumio[856]: error: Failed to ping endpoint eu11.myvolumio.org : unknown error Feb 21 17:27:27 pi5 volumio[856]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 21 17:27:27 pi5 systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Feb 21 17:27:27 pi5 volumio[856]: Error: Unable to resolve or reject the same promise twice Feb 21 17:27:27 pi5 volumio[856]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Feb 21 17:27:27 pi5 volumio[856]: at Socket. (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:32086) Feb 21 17:27:27 pi5 volumio[856]: at Socket.emit (events.js:327:22) Feb 21 17:27:27 pi5 volumio[856]: at endReadableNT (internal/streams/readable.js:1327:12) Feb 21 17:27:27 pi5 volumio[856]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Feb 21 17:27:27 pi5 volumio[856]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 21 17:27:27 pi5 systemd[1]: Started Update UTMP about System Runlevel Changes. Feb 21 17:27:27 pi5 systemd[1]: Startup finished in 10.939s (kernel) + 17.028s (userspace) = 27.968s. Feb 21 17:27:27 pi5 sudo[1293]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-21 17:26 Feb 21 17:27:27 pi5 sudo[1293]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 05 Feb 2026 01:46:18 PM CET" VOLUMIO_VERSION="3.908" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3e9dbaf8f44792d26e97456a18f12823"