Feb 21 14:15:42 volumiorp5 kernel: Booting Linux on physical CPU 0x0000000000 [0x414fd0b1] Feb 21 14:15:42 volumiorp5 kernel: Linux version 6.12.47-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) #1904 SMP PREEMPT Mon Sep 15 13:10:52 BST 2025 Feb 21 14:15:42 volumiorp5 kernel: KASLR enabled Feb 21 14:15:42 volumiorp5 kernel: random: crng init done Feb 21 14:15:42 volumiorp5 kernel: Machine model: Raspberry Pi 5 Model B Rev 1.1 Feb 21 14:15:42 volumiorp5 kernel: efi: UEFI not found. Feb 21 14:15:42 volumiorp5 kernel: Reserved memory: created CMA memory pool at 0x000000003b800000, size 64 MiB Feb 21 14:15:42 volumiorp5 kernel: OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool Feb 21 14:15:42 volumiorp5 kernel: OF: reserved mem: 0x000000003b800000..0x000000003f7fffff (65536 KiB) map reusable linux,cma Feb 21 14:15:42 volumiorp5 kernel: OF: reserved mem: 0x0000000000000000..0x000000000007ffff (512 KiB) nomap non-reusable atf@0 Feb 21 14:15:42 volumiorp5 kernel: OF: reserved mem: 0x000000003fd23220..0x000000003fd23257 (0 KiB) nomap non-reusable nvram@0 Feb 21 14:15:42 volumiorp5 kernel: NUMA: Faking a node at [mem 0x0000000000000000-0x00000001ffffffff] Feb 21 14:15:42 volumiorp5 kernel: Faking node 0 at [mem 0x0000000000000000-0x000000003fffffff] (1024MB) Feb 21 14:15:42 volumiorp5 kernel: Faking node 1 at [mem 0x0000000040000000-0x000000007fffffff] (1024MB) Feb 21 14:15:42 volumiorp5 kernel: Faking node 2 at [mem 0x0000000080000000-0x00000000bfffffff] (1024MB) Feb 21 14:15:42 volumiorp5 kernel: Faking node 3 at [mem 0x00000000c0000000-0x00000000ffffffff] (1024MB) Feb 21 14:15:42 volumiorp5 kernel: Faking node 4 at [mem 0x0000000100000000-0x000000013fffffff] (1024MB) Feb 21 14:15:42 volumiorp5 kernel: Faking node 5 at [mem 0x0000000140000000-0x000000017fffffff] (1024MB) Feb 21 14:15:42 volumiorp5 kernel: Faking node 6 at [mem 0x0000000180000000-0x00000001bfffffff] (1024MB) Feb 21 14:15:42 volumiorp5 kernel: Faking node 7 at [mem 0x00000001c0000000-0x00000001ffffffff] (1024MB) Feb 21 14:15:42 volumiorp5 kernel: NUMA: Initialized distance table, cnt=8 Feb 21 14:15:42 volumiorp5 kernel: NODE_DATA(0) allocated [mem 0x3b7fd300-0x3b7fffff] Feb 21 14:15:42 volumiorp5 kernel: NODE_DATA(1) allocated [mem 0x7fffd300-0x7fffffff] Feb 21 14:15:42 volumiorp5 kernel: NODE_DATA(2) allocated [mem 0xbfffd300-0xbfffffff] Feb 21 14:15:42 volumiorp5 kernel: NODE_DATA(3) allocated [mem 0xffffd300-0xffffffff] Feb 21 14:15:42 volumiorp5 kernel: NODE_DATA(4) allocated [mem 0x13fffd300-0x13fffffff] Feb 21 14:15:42 volumiorp5 kernel: NODE_DATA(5) allocated [mem 0x17fffd300-0x17fffffff] Feb 21 14:15:42 volumiorp5 kernel: NODE_DATA(6) allocated [mem 0x1bfffd300-0x1bfffffff] Feb 21 14:15:42 volumiorp5 kernel: NODE_DATA(7) allocated [mem 0x1fefa3300-0x1fefa5fff] Feb 21 14:15:42 volumiorp5 kernel: Zone ranges: Feb 21 14:15:42 volumiorp5 kernel: DMA [mem 0x0000000000000000-0x00000000ffffffff] Feb 21 14:15:42 volumiorp5 kernel: DMA32 empty Feb 21 14:15:42 volumiorp5 kernel: Normal [mem 0x0000000100000000-0x00000001ffffffff] Feb 21 14:15:42 volumiorp5 kernel: Movable zone start for each node Feb 21 14:15:42 volumiorp5 kernel: Early memory node ranges Feb 21 14:15:42 volumiorp5 kernel: node 0: [mem 0x0000000000000000-0x000000000007ffff] Feb 21 14:15:42 volumiorp5 kernel: node 0: [mem 0x0000000000080000-0x000000003f7fffff] Feb 21 14:15:42 volumiorp5 kernel: node 1: [mem 0x0000000040000000-0x000000007fffffff] Feb 21 14:15:42 volumiorp5 kernel: node 2: [mem 0x0000000080000000-0x00000000bfffffff] Feb 21 14:15:42 volumiorp5 kernel: node 3: [mem 0x00000000c0000000-0x00000000ffffffff] Feb 21 14:15:42 volumiorp5 kernel: node 4: [mem 0x0000000100000000-0x000000013fffffff] Feb 21 14:15:42 volumiorp5 kernel: node 5: [mem 0x0000000140000000-0x000000017fffffff] Feb 21 14:15:42 volumiorp5 kernel: node 6: [mem 0x0000000180000000-0x00000001bfffffff] Feb 21 14:15:42 volumiorp5 kernel: node 7: [mem 0x00000001c0000000-0x00000001ffffffff] Feb 21 14:15:42 volumiorp5 kernel: Initmem setup node 0 [mem 0x0000000000000000-0x000000003f7fffff] Feb 21 14:15:42 volumiorp5 kernel: Initmem setup node 1 [mem 0x0000000040000000-0x000000007fffffff] Feb 21 14:15:42 volumiorp5 kernel: Initmem setup node 2 [mem 0x0000000080000000-0x00000000bfffffff] Feb 21 14:15:42 volumiorp5 kernel: Initmem setup node 3 [mem 0x00000000c0000000-0x00000000ffffffff] Feb 21 14:15:42 volumiorp5 kernel: Initmem setup node 4 [mem 0x0000000100000000-0x000000013fffffff] Feb 21 14:15:42 volumiorp5 kernel: Initmem setup node 5 [mem 0x0000000140000000-0x000000017fffffff] Feb 21 14:15:42 volumiorp5 kernel: Initmem setup node 6 [mem 0x0000000180000000-0x00000001bfffffff] Feb 21 14:15:42 volumiorp5 kernel: Initmem setup node 7 [mem 0x00000001c0000000-0x00000001ffffffff] Feb 21 14:15:42 volumiorp5 kernel: On node 1, zone DMA: 2048 pages in unavailable ranges Feb 21 14:15:42 volumiorp5 kernel: psci: probing for conduit method from DT. Feb 21 14:15:42 volumiorp5 kernel: psci: PSCIv1.1 detected in firmware. Feb 21 14:15:42 volumiorp5 kernel: psci: Using standard PSCI v0.2 function IDs Feb 21 14:15:42 volumiorp5 kernel: psci: MIGRATE_INFO_TYPE not supported. Feb 21 14:15:42 volumiorp5 kernel: psci: SMC Calling Convention v1.2 Feb 21 14:15:42 volumiorp5 kernel: percpu: Embedded 33 pages/cpu s95192 r8192 d31784 u135168 Feb 21 14:15:42 volumiorp5 kernel: pcpu-alloc: s95192 r8192 d31784 u135168 alloc=33*4096 Feb 21 14:15:42 volumiorp5 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Feb 21 14:15:42 volumiorp5 kernel: Detected PIPT I-cache on CPU0 Feb 21 14:15:42 volumiorp5 kernel: CPU features: detected: Virtualization Host Extensions Feb 21 14:15:42 volumiorp5 kernel: CPU features: detected: Spectre-v4 Feb 21 14:15:42 volumiorp5 kernel: CPU features: detected: Spectre-BHB Feb 21 14:15:42 volumiorp5 kernel: CPU features: kernel page table isolation forced ON by KASLR Feb 21 14:15:42 volumiorp5 kernel: CPU features: detected: Kernel page table isolation (KPTI) Feb 21 14:15:42 volumiorp5 kernel: CPU features: detected: SSBS not fully self-synchronizing Feb 21 14:15:42 volumiorp5 kernel: alternatives: applying boot alternatives Feb 21 14:15:42 volumiorp5 kernel: Kernel command line: reboot=w coherent_pool=1M 8250.nr_uarts=1 pci=pcie_bus_safe cgroup_disable=memory numa_policy=interleave nvme.max_host_mem_size_mb=0 numa=fake=8 system_heap.max_order=0 iommu_dma_numa_policy=interleave smsc95xx.macaddr=2C:CF:67:C3:39:7B 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=b0b466fc-4556-43af-9f97-ebe56fe4abe4 imgfile=/volumio_current.sqsh bootpart=UUID=0428-C7E4 datapart=UUID=82051e0e-a859-4f54-aa9f-0cc23a932af8 uuidconfig=cmdline.txt rootwait bootdelay=7 logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 loglevel=0 nodebug use_kmsg=no video=HDMI-A-1:320x1480M@60,rotate=270 plymouth=270 fbcon=rotate:3 Feb 21 14:15:42 volumiorp5 kernel: cgroup: Disabling memory control group subsystem Feb 21 14:15:42 volumiorp5 kernel: mempolicy: NUMA default policy overridden to 'interleave:0-7' Feb 21 14:15:42 volumiorp5 kernel: DMA IOMMU NUMA default policy overridden to 'interleave:0-7' Feb 21 14:15:42 volumiorp5 kernel: Unknown kernel command line parameters "splash nodebug imgpart=UUID=b0b466fc-4556-43af-9f97-ebe56fe4abe4 imgfile=/volumio_current.sqsh bootpart=UUID=0428-C7E4 datapart=UUID=82051e0e-a859-4f54-aa9f-0cc23a932af8 uuidconfig=cmdline.txt bootdelay=7 use_kmsg=no plymouth=270", will be passed to user space. Feb 21 14:15:42 volumiorp5 kernel: Fallback order for Node 0: 0 1 2 3 4 5 6 7 Feb 21 14:15:42 volumiorp5 kernel: Fallback order for Node 1: 1 2 3 4 5 6 7 0 Feb 21 14:15:42 volumiorp5 kernel: Fallback order for Node 2: 2 3 4 5 6 7 0 1 Feb 21 14:15:42 volumiorp5 kernel: Fallback order for Node 3: 3 4 5 6 7 0 1 2 Feb 21 14:15:42 volumiorp5 kernel: Fallback order for Node 4: 4 5 6 7 0 1 2 3 Feb 21 14:15:42 volumiorp5 kernel: Fallback order for Node 5: 5 6 7 0 1 2 3 4 Feb 21 14:15:42 volumiorp5 kernel: Fallback order for Node 6: 6 7 0 1 2 3 4 5 Feb 21 14:15:42 volumiorp5 kernel: Fallback order for Node 7: 7 0 1 2 3 4 5 6 Feb 21 14:15:42 volumiorp5 kernel: Built 8 zonelists, mobility grouping on. Total pages: 2095104 Feb 21 14:15:42 volumiorp5 kernel: Policy zone: Normal Feb 21 14:15:42 volumiorp5 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Feb 21 14:15:42 volumiorp5 kernel: software IO TLB: area num 4. Feb 21 14:15:42 volumiorp5 kernel: software IO TLB: mapped [mem 0x00000000fae00000-0x00000000fee00000] (64MB) Feb 21 14:15:42 volumiorp5 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=8 Feb 21 14:15:42 volumiorp5 kernel: ftrace: allocating 45342 entries in 178 pages Feb 21 14:15:42 volumiorp5 kernel: ftrace: allocated 178 pages with 4 groups Feb 21 14:15:42 volumiorp5 kernel: rcu: Preemptible hierarchical RCU implementation. Feb 21 14:15:42 volumiorp5 kernel: rcu: RCU event tracing is enabled. Feb 21 14:15:42 volumiorp5 kernel: Trampoline variant of Tasks RCU enabled. Feb 21 14:15:42 volumiorp5 kernel: Rude variant of Tasks RCU enabled. Feb 21 14:15:42 volumiorp5 kernel: Tracing variant of Tasks RCU enabled. Feb 21 14:15:42 volumiorp5 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. Feb 21 14:15:42 volumiorp5 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Feb 21 14:15:42 volumiorp5 kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Feb 21 14:15:42 volumiorp5 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Feb 21 14:15:42 volumiorp5 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Feb 21 14:15:42 volumiorp5 kernel: Root IRQ handler: gic_handle_irq Feb 21 14:15:42 volumiorp5 kernel: GIC: Using split EOI/Deactivate mode Feb 21 14:15:42 volumiorp5 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Feb 21 14:15:42 volumiorp5 kernel: arch_timer: cp15 timer(s) running at 54.00MHz (phys). Feb 21 14:15:42 volumiorp5 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0xc743ce346, max_idle_ns: 440795203123 ns Feb 21 14:15:42 volumiorp5 kernel: sched_clock: 56 bits at 54MHz, resolution 18ns, wraps every 4398046511102ns Feb 21 14:15:42 volumiorp5 kernel: Console: colour dummy device 80x25 Feb 21 14:15:42 volumiorp5 kernel: printk: legacy console [tty1] enabled Feb 21 14:15:42 volumiorp5 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 108.00 BogoMIPS (lpj=216000) Feb 21 14:15:42 volumiorp5 kernel: pid_max: default: 32768 minimum: 301 Feb 21 14:15:42 volumiorp5 kernel: LSM: initializing lsm=capability Feb 21 14:15:42 volumiorp5 kernel: Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) Feb 21 14:15:42 volumiorp5 kernel: Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) Feb 21 14:15:42 volumiorp5 kernel: Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) Feb 21 14:15:42 volumiorp5 kernel: Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) Feb 21 14:15:42 volumiorp5 kernel: rcu: Hierarchical SRCU implementation. Feb 21 14:15:42 volumiorp5 kernel: rcu: Max phase no-delay instances is 1000. Feb 21 14:15:42 volumiorp5 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 0 crossnode level Feb 21 14:15:42 volumiorp5 kernel: EFI services will not be available. Feb 21 14:15:42 volumiorp5 kernel: smp: Bringing up secondary CPUs ... Feb 21 14:15:42 volumiorp5 kernel: Detected PIPT I-cache on CPU1 Feb 21 14:15:42 volumiorp5 kernel: CPU1: Booted secondary processor 0x0000000100 [0x414fd0b1] Feb 21 14:15:42 volumiorp5 kernel: Detected PIPT I-cache on CPU2 Feb 21 14:15:42 volumiorp5 kernel: CPU2: Booted secondary processor 0x0000000200 [0x414fd0b1] Feb 21 14:15:42 volumiorp5 kernel: Detected PIPT I-cache on CPU3 Feb 21 14:15:42 volumiorp5 kernel: CPU3: Booted secondary processor 0x0000000300 [0x414fd0b1] Feb 21 14:15:42 volumiorp5 kernel: smp: Brought up 8 nodes, 4 CPUs Feb 21 14:15:42 volumiorp5 kernel: SMP: Total of 4 processors activated. Feb 21 14:15:42 volumiorp5 kernel: CPU: All CPU(s) started at EL2 Feb 21 14:15:42 volumiorp5 kernel: CPU features: detected: 32-bit EL0 Support Feb 21 14:15:42 volumiorp5 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Feb 21 14:15:42 volumiorp5 kernel: CPU features: detected: Common not Private translations Feb 21 14:15:42 volumiorp5 kernel: CPU features: detected: CRC32 instructions Feb 21 14:15:42 volumiorp5 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Feb 21 14:15:42 volumiorp5 kernel: CPU features: detected: LSE atomic instructions Feb 21 14:15:42 volumiorp5 kernel: CPU features: detected: Privileged Access Never Feb 21 14:15:42 volumiorp5 kernel: CPU features: detected: RAS Extension Support Feb 21 14:15:42 volumiorp5 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Feb 21 14:15:42 volumiorp5 kernel: alternatives: applying system-wide alternatives Feb 21 14:15:42 volumiorp5 kernel: CPU features: detected: Hardware dirty bit management on CPU0-3 Feb 21 14:15:42 volumiorp5 kernel: Memory: 8010596K/8380416K available (14080K kernel code, 2406K rwdata, 4820K rodata, 5440K init, 577K bss, 278684K reserved, 65536K cma-reserved) Feb 21 14:15:42 volumiorp5 kernel: devtmpfs: initialized Feb 21 14:15:42 volumiorp5 kernel: Enabled cp15_barrier support Feb 21 14:15:42 volumiorp5 kernel: Enabled setend support Feb 21 14:15:42 volumiorp5 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns Feb 21 14:15:42 volumiorp5 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) Feb 21 14:15:42 volumiorp5 kernel: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Feb 21 14:15:42 volumiorp5 kernel: 0 pages in range for non-PLT usage Feb 21 14:15:42 volumiorp5 kernel: 517392 pages in range for PLT usage Feb 21 14:15:42 volumiorp5 kernel: pinctrl core: initialized pinctrl subsystem Feb 21 14:15:42 volumiorp5 kernel: DMI not present or invalid. Feb 21 14:15:42 volumiorp5 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Feb 21 14:15:42 volumiorp5 kernel: DMA: preallocated 1024 KiB GFP_KERNEL pool for atomic allocations Feb 21 14:15:42 volumiorp5 kernel: DMA: preallocated 1024 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Feb 21 14:15:42 volumiorp5 kernel: DMA: preallocated 1024 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Feb 21 14:15:42 volumiorp5 kernel: audit: initializing netlink subsys (disabled) Feb 21 14:15:42 volumiorp5 kernel: audit: type=2000 audit(0.012:1): state=initialized audit_enabled=0 res=1 Feb 21 14:15:42 volumiorp5 kernel: thermal_sys: Registered thermal governor 'step_wise' Feb 21 14:15:42 volumiorp5 kernel: cpuidle: using governor menu Feb 21 14:15:42 volumiorp5 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Feb 21 14:15:42 volumiorp5 kernel: ASID allocator initialised with 32768 entries Feb 21 14:15:42 volumiorp5 kernel: Serial: AMBA PL011 UART driver Feb 21 14:15:42 volumiorp5 kernel: /soc@107c000000/interrupt-controller@7fff9000: Fixed dependency cycle(s) with /soc@107c000000/interrupt-controller@7fff9000 Feb 21 14:15:42 volumiorp5 kernel: bcm2835-mbox 107c013880.mailbox: mailbox enabled Feb 21 14:15:42 volumiorp5 kernel: 107d001000.serial: ttyAMA10 at MMIO 0x107d001000 (irq = 16, base_baud = 0) is a PL011 rev3 Feb 21 14:15:42 volumiorp5 kernel: printk: legacy console [ttyAMA10] enabled Feb 21 14:15:42 volumiorp5 kernel: raspberrypi-firmware soc@107c000000:firmware: Attached to firmware from 2025-12-08T19:29:54, variant start_cd Feb 21 14:15:42 volumiorp5 kernel: raspberrypi-firmware soc@107c000000:firmware: Firmware hash is 2226a85300000000000000000000000000000000 Feb 21 14:15:42 volumiorp5 kernel: bcm2835-dma 1000010000.dma: DMA legacy API manager, dmachans=0x1 Feb 21 14:15:42 volumiorp5 kernel: iommu: Default domain type: Translated Feb 21 14:15:42 volumiorp5 kernel: iommu: DMA domain TLB invalidation policy: strict mode Feb 21 14:15:42 volumiorp5 kernel: SCSI subsystem initialized Feb 21 14:15:42 volumiorp5 kernel: usbcore: registered new interface driver usbfs Feb 21 14:15:42 volumiorp5 kernel: usbcore: registered new interface driver hub Feb 21 14:15:42 volumiorp5 kernel: usbcore: registered new device driver usb Feb 21 14:15:42 volumiorp5 kernel: pps_core: LinuxPPS API ver. 1 registered Feb 21 14:15:42 volumiorp5 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Feb 21 14:15:42 volumiorp5 kernel: PTP clock support registered Feb 21 14:15:42 volumiorp5 kernel: vgaarb: loaded Feb 21 14:15:42 volumiorp5 kernel: clocksource: Switched to clocksource arch_sys_counter Feb 21 14:15:42 volumiorp5 kernel: VFS: Disk quotas dquot_6.6.0 Feb 21 14:15:42 volumiorp5 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Feb 21 14:15:42 volumiorp5 kernel: NET: Registered PF_INET protocol family Feb 21 14:15:42 volumiorp5 kernel: IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) Feb 21 14:15:42 volumiorp5 kernel: tcp_listen_portaddr_hash hash table entries: 4096 (order: 4, 65536 bytes, vmalloc) Feb 21 14:15:42 volumiorp5 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, vmalloc) Feb 21 14:15:42 volumiorp5 kernel: TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) Feb 21 14:15:42 volumiorp5 kernel: TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) Feb 21 14:15:42 volumiorp5 kernel: TCP: Hash tables configured (established 65536 bind 65536) Feb 21 14:15:42 volumiorp5 kernel: MPTCP token hash table entries: 8192 (order: 5, 196608 bytes, vmalloc) Feb 21 14:15:42 volumiorp5 kernel: UDP hash table entries: 4096 (order: 5, 131072 bytes, vmalloc) Feb 21 14:15:42 volumiorp5 kernel: UDP-Lite hash table entries: 4096 (order: 5, 131072 bytes, vmalloc) Feb 21 14:15:42 volumiorp5 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Feb 21 14:15:42 volumiorp5 kernel: RPC: Registered named UNIX socket transport module. Feb 21 14:15:42 volumiorp5 kernel: RPC: Registered udp transport module. Feb 21 14:15:42 volumiorp5 kernel: RPC: Registered tcp transport module. Feb 21 14:15:42 volumiorp5 kernel: RPC: Registered tcp-with-tls transport module. Feb 21 14:15:42 volumiorp5 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Feb 21 14:15:42 volumiorp5 kernel: PCI: CLS 0 bytes, default 64 Feb 21 14:15:42 volumiorp5 kernel: Trying to unpack rootfs image as initramfs... Feb 21 14:15:42 volumiorp5 kernel: kvm [1]: nv: 554 coarse grained trap handlers Feb 21 14:15:42 volumiorp5 kernel: kvm [1]: IPA Size Limit: 40 bits Feb 21 14:15:42 volumiorp5 kernel: kvm [1]: vgic interrupt IRQ9 Feb 21 14:15:42 volumiorp5 kernel: kvm [1]: VHE mode initialized successfully Feb 21 14:15:42 volumiorp5 kernel: Initialise system trusted keyrings Feb 21 14:15:42 volumiorp5 kernel: workingset: timestamp_bits=42 max_order=21 bucket_order=0 Feb 21 14:15:42 volumiorp5 kernel: NFS: Registering the id_resolver key type Feb 21 14:15:42 volumiorp5 kernel: Key type id_resolver registered Feb 21 14:15:42 volumiorp5 kernel: Key type id_legacy registered Feb 21 14:15:42 volumiorp5 kernel: nfs4filelayout_init: NFSv4 File Layout Driver Registering... Feb 21 14:15:42 volumiorp5 kernel: nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering... Feb 21 14:15:42 volumiorp5 kernel: Key type asymmetric registered Feb 21 14:15:42 volumiorp5 kernel: Asymmetric key parser 'x509' registered Feb 21 14:15:42 volumiorp5 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) Feb 21 14:15:42 volumiorp5 kernel: io scheduler mq-deadline registered Feb 21 14:15:42 volumiorp5 kernel: io scheduler kyber registered Feb 21 14:15:42 volumiorp5 kernel: io scheduler bfq registered Feb 21 14:15:42 volumiorp5 kernel: irq_brcmstb_l2: registered L2 intc (/soc@107c000000/interrupt-controller@7d510600, parent irq: 27) Feb 21 14:15:42 volumiorp5 kernel: irq_brcmstb_l2: registered L2 intc (/soc@107c000000/interrupt-controller@7c502000, parent irq: 28) Feb 21 14:15:42 volumiorp5 kernel: irq_brcmstb_l2: registered L2 intc (/soc@107c000000/intc@7d508380, parent irq: 29) Feb 21 14:15:42 volumiorp5 kernel: irq_brcmstb_l2: registered L2 intc (/soc@107c000000/intc@7d508400, parent irq: 30) Feb 21 14:15:42 volumiorp5 kernel: irq_brcmstb_l2: registered L2 intc (/soc@107c000000/intc@7d503000, parent irq: 31) Feb 21 14:15:42 volumiorp5 kernel: ledtrig-cpu: registered to indicate activity on CPUs Feb 21 14:15:42 volumiorp5 kernel: Freeing initrd memory: 35748K Feb 21 14:15:42 volumiorp5 kernel: simple-framebuffer 3f800000.framebuffer: framebuffer at 0x3f800000, 0x3f4800 bytes Feb 21 14:15:42 volumiorp5 kernel: simple-framebuffer 3f800000.framebuffer: format=r5g6b5, mode=1920x1080x16, linelength=3840 Feb 21 14:15:42 volumiorp5 kernel: Console: switching to colour frame buffer device 135x120 Feb 21 14:15:42 volumiorp5 kernel: simple-framebuffer 3f800000.framebuffer: fb0: simplefb registered! Feb 21 14:15:42 volumiorp5 kernel: Serial: 8250/16550 driver, 1 ports, IRQ sharing enabled Feb 21 14:15:42 volumiorp5 kernel: 107d50c000.serial: ttyS0 at MMIO 0x107d50c000 (irq = 33, base_baud = 6000000) is a Broadcom BCM7271 UART Feb 21 14:15:42 volumiorp5 kernel: serial serial0: tty port ttyS0 registered Feb 21 14:15:42 volumiorp5 kernel: iproc-rng200 107d208000.rng: hwrng registered Feb 21 14:15:42 volumiorp5 kernel: vc-mem: phys_addr:0x00000000 mem_base=0x3fc00000 mem_size:0x40000000(1024 MiB) Feb 21 14:15:42 volumiorp5 kernel: bcm2712-iommu-cache 1000005b00.iommuc: bcm2712_iommu_cache_probe Feb 21 14:15:42 volumiorp5 kernel: brd: module loaded Feb 21 14:15:42 volumiorp5 kernel: loop: module loaded Feb 21 14:15:42 volumiorp5 kernel: bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver Feb 21 14:15:42 volumiorp5 kernel: Loading iSCSI transport class v2.0-870. Feb 21 14:15:42 volumiorp5 kernel: usbcore: registered new interface driver lan78xx Feb 21 14:15:42 volumiorp5 kernel: usbcore: registered new interface driver smsc95xx Feb 21 14:15:42 volumiorp5 kernel: dwc_otg: version 3.00a 10-AUG-2012 (platform bus) Feb 21 14:15:42 volumiorp5 kernel: dwc_otg: FIQ enabled Feb 21 14:15:42 volumiorp5 kernel: dwc_otg: NAK holdoff enabled Feb 21 14:15:42 volumiorp5 kernel: dwc_otg: FIQ split-transaction FSM enabled Feb 21 14:15:42 volumiorp5 kernel: Module dwc_common_port init Feb 21 14:15:42 volumiorp5 kernel: usbcore: registered new interface driver uas Feb 21 14:15:42 volumiorp5 kernel: usbcore: registered new interface driver usb-storage Feb 21 14:15:42 volumiorp5 kernel: mousedev: PS/2 mouse device common for all mice Feb 21 14:15:42 volumiorp5 kernel: rpi-rtc soc@107c000000:rpi_rtc: registered as rtc0 Feb 21 14:15:42 volumiorp5 kernel: rpi-rtc soc@107c000000:rpi_rtc: setting system clock to 2026-02-21T13:15:30 UTC (1771679730) Feb 21 14:15:42 volumiorp5 kernel: bcm2835-wdt bcm2835-wdt: Poweroff handler already present! Feb 21 14:15:42 volumiorp5 kernel: bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer Feb 21 14:15:42 volumiorp5 kernel: sdhci: Secure Digital Host Controller Interface driver Feb 21 14:15:42 volumiorp5 kernel: sdhci: Copyright(c) Pierre Ossman Feb 21 14:15:42 volumiorp5 kernel: sdhci-pltfm: SDHCI platform and OF driver helper Feb 21 14:15:42 volumiorp5 kernel: SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping .... Feb 21 14:15:42 volumiorp5 kernel: hid: raw HID events driver (C) Jiri Kosina Feb 21 14:15:42 volumiorp5 kernel: usbcore: registered new interface driver usbhid Feb 21 14:15:42 volumiorp5 kernel: usbhid: USB HID core driver Feb 21 14:15:42 volumiorp5 kernel: hw perfevents: enabled with armv8_cortex_a76 PMU driver, 7 (0,8000003f) counters available Feb 21 14:15:42 volumiorp5 kernel: NET: Registered PF_PACKET protocol family Feb 21 14:15:42 volumiorp5 kernel: Key type dns_resolver registered Feb 21 14:15:42 volumiorp5 kernel: registered taskstats version 1 Feb 21 14:15:42 volumiorp5 kernel: Loading compiled-in X.509 certificates Feb 21 14:15:42 volumiorp5 kernel: Demotion targets for Node 0: null Feb 21 14:15:42 volumiorp5 kernel: Demotion targets for Node 1: null Feb 21 14:15:42 volumiorp5 kernel: Demotion targets for Node 2: null Feb 21 14:15:42 volumiorp5 kernel: Demotion targets for Node 3: null Feb 21 14:15:42 volumiorp5 kernel: Demotion targets for Node 4: null Feb 21 14:15:42 volumiorp5 kernel: Demotion targets for Node 5: null Feb 21 14:15:42 volumiorp5 kernel: Demotion targets for Node 6: null Feb 21 14:15:42 volumiorp5 kernel: Demotion targets for Node 7: null Feb 21 14:15:42 volumiorp5 kernel: Key type .fscrypt registered Feb 21 14:15:42 volumiorp5 kernel: Key type fscrypt-provisioning registered Feb 21 14:15:42 volumiorp5 kernel: brcm-pcie 1000110000.pcie: host bridge /axi/pcie@1000110000 ranges: Feb 21 14:15:42 volumiorp5 kernel: brcm-pcie 1000110000.pcie: No bus range found for /axi/pcie@1000110000, using [bus 00-ff] Feb 21 14:15:42 volumiorp5 kernel: brcm-pcie 1000110000.pcie: MEM 0x1b80000000..0x1bffffffff -> 0x0080000000 Feb 21 14:15:42 volumiorp5 kernel: brcm-pcie 1000110000.pcie: MEM 0x1800000000..0x1b7fffffff -> 0x0400000000 Feb 21 14:15:42 volumiorp5 kernel: brcm-pcie 1000110000.pcie: IB MEM 0x0000000000..0x0fffffffff -> 0x1000000000 Feb 21 14:15:42 volumiorp5 kernel: brcm-pcie 1000110000.pcie: IB MEM 0x1000131000..0x1000131fff -> 0xfffffff000 Feb 21 14:15:42 volumiorp5 kernel: brcm-pcie 1000110000.pcie: PCI host bridge to bus 0001:00 Feb 21 14:15:42 volumiorp5 kernel: pci_bus 0001:00: root bus resource [bus 00-ff] Feb 21 14:15:42 volumiorp5 kernel: pci_bus 0001:00: root bus resource [mem 0x1b80000000-0x1bffffffff] (bus address [0x80000000-0xffffffff]) Feb 21 14:15:42 volumiorp5 kernel: pci_bus 0001:00: root bus resource [mem 0x1800000000-0x1b7fffffff pref] (bus address [0x400000000-0x77fffffff]) Feb 21 14:15:42 volumiorp5 kernel: pci 0001:00:00.0: [14e4:2712] type 01 class 0x060400 PCIe Root Port Feb 21 14:15:42 volumiorp5 kernel: pci 0001:00:00.0: PCI bridge to [bus 00] Feb 21 14:15:42 volumiorp5 kernel: pci 0001:00:00.0: bridge window [mem 0x00000000-0x000fffff] Feb 21 14:15:42 volumiorp5 kernel: pci 0001:00:00.0: bridge window [mem 0x00000000-0x000fffff 64bit pref] Feb 21 14:15:42 volumiorp5 kernel: pci 0001:00:00.0: PME# supported from D0 D3hot Feb 21 14:15:42 volumiorp5 kernel: pci 0001:00:00.0: bridge configuration invalid ([bus 00-00]), reconfiguring Feb 21 14:15:42 volumiorp5 kernel: brcm-pcie 1000110000.pcie: link down Feb 21 14:15:42 volumiorp5 kernel: pci_bus 0001:01: busn_res: [bus 01-ff] end is updated to 01 Feb 21 14:15:42 volumiorp5 kernel: pci 0001:00:00.0: PCI bridge to [bus 01] Feb 21 14:15:42 volumiorp5 kernel: pci_bus 0001:00: resource 4 [mem 0x1b80000000-0x1bffffffff] Feb 21 14:15:42 volumiorp5 kernel: pci_bus 0001:00: resource 5 [mem 0x1800000000-0x1b7fffffff pref] Feb 21 14:15:42 volumiorp5 kernel: pci 0001:00:00.0: Max Payload Size set to 512/ 512 (was 128), Max Read Rq 512 Feb 21 14:15:42 volumiorp5 kernel: pcieport 0001:00:00.0: PME: Signaling with IRQ 38 Feb 21 14:15:42 volumiorp5 kernel: pcieport 0001:00:00.0: AER: enabled with IRQ 38 Feb 21 14:15:42 volumiorp5 kernel: pci_bus 0001:01: busn_res: [bus 01] is released Feb 21 14:15:42 volumiorp5 kernel: pci_bus 0001:00: busn_res: [bus 00-ff] is released Feb 21 14:15:42 volumiorp5 kernel: brcm-pcie 1000120000.pcie: host bridge /axi/pcie@1000120000 ranges: Feb 21 14:15:42 volumiorp5 kernel: brcm-pcie 1000120000.pcie: No bus range found for /axi/pcie@1000120000, using [bus 00-ff] Feb 21 14:15:42 volumiorp5 kernel: brcm-pcie 1000120000.pcie: MEM 0x1f00000000..0x1ffffffffb -> 0x0000000000 Feb 21 14:15:42 volumiorp5 kernel: brcm-pcie 1000120000.pcie: MEM 0x1c00000000..0x1effffffff -> 0x0400000000 Feb 21 14:15:42 volumiorp5 kernel: brcm-pcie 1000120000.pcie: IB MEM 0x1f00000000..0x1f003fffff -> 0x0000000000 Feb 21 14:15:42 volumiorp5 kernel: brcm-pcie 1000120000.pcie: IB MEM 0x0000000000..0x0fffffffff -> 0x1000000000 Feb 21 14:15:42 volumiorp5 kernel: brcm-pcie 1000120000.pcie: IB MEM 0x1000130000..0x1000130fff -> 0xfffffff000 Feb 21 14:15:42 volumiorp5 kernel: brcm-pcie 1000120000.pcie: PCI host bridge to bus 0002:00 Feb 21 14:15:42 volumiorp5 kernel: pci_bus 0002:00: root bus resource [bus 00-ff] Feb 21 14:15:42 volumiorp5 kernel: pci_bus 0002:00: root bus resource [mem 0x1f00000000-0x1ffffffffb] (bus address [0x00000000-0xfffffffb]) Feb 21 14:15:42 volumiorp5 kernel: pci_bus 0002:00: root bus resource [mem 0x1c00000000-0x1effffffff pref] (bus address [0x400000000-0x6ffffffff]) Feb 21 14:15:42 volumiorp5 kernel: pci 0002:00:00.0: [14e4:2712] type 01 class 0x060400 PCIe Root Port Feb 21 14:15:42 volumiorp5 kernel: pci 0002:00:00.0: PCI bridge to [bus 00] Feb 21 14:15:42 volumiorp5 kernel: pci 0002:00:00.0: bridge window [mem 0x1f80000000-0x1fbfffffff] Feb 21 14:15:42 volumiorp5 kernel: pci 0002:00:00.0: PME# supported from D0 D3hot Feb 21 14:15:42 volumiorp5 kernel: pci 0002:00:00.0: bridge configuration invalid ([bus 00-00]), reconfiguring Feb 21 14:15:42 volumiorp5 kernel: brcm-pcie 1000120000.pcie: clkreq-mode set to default Feb 21 14:15:42 volumiorp5 kernel: brcm-pcie 1000120000.pcie: link up, 5.0 GT/s PCIe x4 (!SSC) Feb 21 14:15:42 volumiorp5 kernel: pci 0002:01:00.0: [1de4:0001] type 00 class 0x020000 PCIe Endpoint Feb 21 14:15:42 volumiorp5 kernel: pci 0002:01:00.0: BAR 0 [mem 0xffffc000-0xffffffff] Feb 21 14:15:42 volumiorp5 kernel: pci 0002:01:00.0: BAR 1 [mem 0xffc00000-0xffffffff] Feb 21 14:15:42 volumiorp5 kernel: pci 0002:01:00.0: BAR 2 [mem 0xffff0000-0xffffffff] Feb 21 14:15:42 volumiorp5 kernel: pci 0002:01:00.0: supports D1 Feb 21 14:15:42 volumiorp5 kernel: pci 0002:01:00.0: PME# supported from D0 D1 D3hot D3cold Feb 21 14:15:42 volumiorp5 kernel: pci_bus 0002:01: busn_res: [bus 01-ff] end is updated to 01 Feb 21 14:15:42 volumiorp5 kernel: pci 0002:00:00.0: bridge window [mem 0x1f00000000-0x1f005fffff]: assigned Feb 21 14:15:42 volumiorp5 kernel: pci 0002:01:00.0: BAR 1 [mem 0x1f00000000-0x1f003fffff]: assigned Feb 21 14:15:42 volumiorp5 kernel: pci 0002:01:00.0: BAR 2 [mem 0x1f00400000-0x1f0040ffff]: assigned Feb 21 14:15:42 volumiorp5 kernel: pci 0002:01:00.0: BAR 0 [mem 0x1f00410000-0x1f00413fff]: assigned Feb 21 14:15:42 volumiorp5 kernel: pci 0002:00:00.0: PCI bridge to [bus 01] Feb 21 14:15:42 volumiorp5 kernel: pci 0002:00:00.0: bridge window [mem 0x1f00000000-0x1f005fffff] Feb 21 14:15:42 volumiorp5 kernel: pci_bus 0002:00: resource 4 [mem 0x1f00000000-0x1ffffffffb] Feb 21 14:15:42 volumiorp5 kernel: pci_bus 0002:00: resource 5 [mem 0x1c00000000-0x1effffffff pref] Feb 21 14:15:42 volumiorp5 kernel: pci_bus 0002:01: resource 1 [mem 0x1f00000000-0x1f005fffff] Feb 21 14:15:42 volumiorp5 kernel: pci 0002:00:00.0: Max Payload Size set to 256/ 512 (was 128), Max Read Rq 512 Feb 21 14:15:42 volumiorp5 kernel: pci 0002:01:00.0: Max Payload Size set to 256/ 256 (was 128), Max Read Rq 512 Feb 21 14:15:42 volumiorp5 kernel: pcieport 0002:00:00.0: enabling device (0000 -> 0002) Feb 21 14:15:42 volumiorp5 kernel: pcieport 0002:00:00.0: PME: Signaling with IRQ 39 Feb 21 14:15:42 volumiorp5 kernel: pcieport 0002:00:00.0: AER: enabled with IRQ 39 Feb 21 14:15:42 volumiorp5 kernel: rp1 0002:01:00.0: bar0 len 0x4000, start 0x1f00410000, end 0x1f00413fff, flags, 0x40200 Feb 21 14:15:42 volumiorp5 kernel: rp1 0002:01:00.0: bar1 len 0x400000, start 0x1f00000000, end 0x1f003fffff, flags, 0x40200 Feb 21 14:15:42 volumiorp5 kernel: rp1 0002:01:00.0: enabling device (0000 -> 0002) Feb 21 14:15:42 volumiorp5 kernel: rp1 0002:01:00.0: chip_id 0x20001927 Feb 21 14:15:42 volumiorp5 kernel: bcm2712-iommu 1000005100.iommu: bcm2712_iommu_init: DEBUG_INFO = 0x20804774 Feb 21 14:15:42 volumiorp5 kernel: bcm2712-iommu 1000005100.iommu: bcm2712_iommu_probe: Success Feb 21 14:15:42 volumiorp5 kernel: bcm2712-iommu 1000005200.iommu: bcm2712_iommu_init: DEBUG_INFO = 0x20804774 Feb 21 14:15:42 volumiorp5 kernel: bcm2712-iommu 1000005200.iommu: bcm2712_iommu_probe: Success Feb 21 14:15:42 volumiorp5 kernel: bcm2712-iommu 1000005280.iommu: bcm2712_iommu_init: DEBUG_INFO = 0x20804774 Feb 21 14:15:42 volumiorp5 kernel: bcm2712-iommu 1000005280.iommu: bcm2712_iommu_probe: Success Feb 21 14:15:42 volumiorp5 kernel: sdhci-brcmstb 1000fff000.mmc: Got CD GPIO Feb 21 14:15:42 volumiorp5 kernel: mmc1: CQHCI version 5.10 Feb 21 14:15:42 volumiorp5 kernel: mmc0: CQHCI version 5.10 Feb 21 14:15:42 volumiorp5 kernel: genirq: irq_chip rp1_irq_chip did not update eff. affinity mask of irq 101 Feb 21 14:15:42 volumiorp5 kernel: macb 1f00100000.ethernet eth0: Cadence GEM rev 0x00070109 at 0x1f00100000 irq 107 (2c:cf:67:c3:39:7b) Feb 21 14:15:42 volumiorp5 kernel: dw_axi_dmac_platform 1f00188000.dma: DesignWare AXI DMA Controller, 8 channels Feb 21 14:15:42 volumiorp5 kernel: xhci-hcd xhci-hcd.0: xHCI Host Controller Feb 21 14:15:42 volumiorp5 kernel: xhci-hcd xhci-hcd.0: new USB bus registered, assigned bus number 1 Feb 21 14:15:42 volumiorp5 kernel: xhci-hcd xhci-hcd.0: hcc params 0x0240fe6d hci version 0x110 quirks 0x0000808000000810 Feb 21 14:15:42 volumiorp5 kernel: xhci-hcd xhci-hcd.0: irq 132, io mem 0x1f00200000 Feb 21 14:15:42 volumiorp5 kernel: xhci-hcd xhci-hcd.0: xHCI Host Controller Feb 21 14:15:42 volumiorp5 kernel: xhci-hcd xhci-hcd.0: new USB bus registered, assigned bus number 2 Feb 21 14:15:42 volumiorp5 kernel: xhci-hcd xhci-hcd.0: Host supports USB 3.0 SuperSpeed Feb 21 14:15:42 volumiorp5 kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.12 Feb 21 14:15:42 volumiorp5 kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Feb 21 14:15:42 volumiorp5 kernel: usb usb1: Product: xHCI Host Controller Feb 21 14:15:42 volumiorp5 kernel: usb usb1: Manufacturer: Linux 6.12.47-v8+ xhci-hcd Feb 21 14:15:42 volumiorp5 kernel: usb usb1: SerialNumber: xhci-hcd.0 Feb 21 14:15:42 volumiorp5 kernel: hub 1-0:1.0: USB hub found Feb 21 14:15:42 volumiorp5 kernel: hub 1-0:1.0: 2 ports detected Feb 21 14:15:42 volumiorp5 kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 6.12 Feb 21 14:15:42 volumiorp5 kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Feb 21 14:15:42 volumiorp5 kernel: usb usb2: Product: xHCI Host Controller Feb 21 14:15:42 volumiorp5 kernel: usb usb2: Manufacturer: Linux 6.12.47-v8+ xhci-hcd Feb 21 14:15:42 volumiorp5 kernel: usb usb2: SerialNumber: xhci-hcd.0 Feb 21 14:15:42 volumiorp5 kernel: hub 2-0:1.0: USB hub found Feb 21 14:15:42 volumiorp5 kernel: hub 2-0:1.0: 1 port detected Feb 21 14:15:42 volumiorp5 kernel: xhci-hcd xhci-hcd.1: xHCI Host Controller Feb 21 14:15:42 volumiorp5 kernel: xhci-hcd xhci-hcd.1: new USB bus registered, assigned bus number 3 Feb 21 14:15:42 volumiorp5 kernel: xhci-hcd xhci-hcd.1: hcc params 0x0240fe6d hci version 0x110 quirks 0x0000808000000810 Feb 21 14:15:42 volumiorp5 kernel: xhci-hcd xhci-hcd.1: irq 137, io mem 0x1f00300000 Feb 21 14:15:42 volumiorp5 kernel: xhci-hcd xhci-hcd.1: xHCI Host Controller Feb 21 14:15:42 volumiorp5 kernel: xhci-hcd xhci-hcd.1: new USB bus registered, assigned bus number 4 Feb 21 14:15:42 volumiorp5 kernel: xhci-hcd xhci-hcd.1: Host supports USB 3.0 SuperSpeed Feb 21 14:15:42 volumiorp5 kernel: usb usb3: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.12 Feb 21 14:15:42 volumiorp5 kernel: usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Feb 21 14:15:42 volumiorp5 kernel: usb usb3: Product: xHCI Host Controller Feb 21 14:15:42 volumiorp5 kernel: usb usb3: Manufacturer: Linux 6.12.47-v8+ xhci-hcd Feb 21 14:15:42 volumiorp5 kernel: usb usb3: SerialNumber: xhci-hcd.1 Feb 21 14:15:42 volumiorp5 kernel: hub 3-0:1.0: USB hub found Feb 21 14:15:42 volumiorp5 kernel: hub 3-0:1.0: 2 ports detected Feb 21 14:15:42 volumiorp5 kernel: usb usb4: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 6.12 Feb 21 14:15:42 volumiorp5 kernel: usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Feb 21 14:15:42 volumiorp5 kernel: usb usb4: Product: xHCI Host Controller Feb 21 14:15:42 volumiorp5 kernel: usb usb4: Manufacturer: Linux 6.12.47-v8+ xhci-hcd Feb 21 14:15:42 volumiorp5 kernel: usb usb4: SerialNumber: xhci-hcd.1 Feb 21 14:15:42 volumiorp5 kernel: hub 4-0:1.0: USB hub found Feb 21 14:15:42 volumiorp5 kernel: hub 4-0:1.0: 1 port detected Feb 21 14:15:42 volumiorp5 kernel: of_cfs_init Feb 21 14:15:42 volumiorp5 kernel: of_cfs_init: OK Feb 21 14:15:42 volumiorp5 kernel: clk: Disabling unused clocks Feb 21 14:15:42 volumiorp5 kernel: PM: genpd: Disabling unused power domains Feb 21 14:15:42 volumiorp5 kernel: mmc0: SDHCI controller on 1000fff000.mmc [1000fff000.mmc] using ADMA 64-bit Feb 21 14:15:42 volumiorp5 kernel: mmc0: new ultra high speed SDR104 SDHC card at address b369 Feb 21 14:15:42 volumiorp5 kernel: mmcblk0: mmc0:b369 MSSD0 29.2 GiB Feb 21 14:15:42 volumiorp5 kernel: mmcblk0: p1 p2 p3 Feb 21 14:15:42 volumiorp5 kernel: mmcblk0: mmc0:b369 MSSD0 29.2 GiB (quirks 0x40000000) Feb 21 14:15:42 volumiorp5 kernel: mmc1: SDHCI controller on 1001100000.mmc [1001100000.mmc] using ADMA 64-bit Feb 21 14:15:42 volumiorp5 kernel: Freeing unused kernel memory: 5440K Feb 21 14:15:42 volumiorp5 kernel: Run /init as init process Feb 21 14:15:42 volumiorp5 kernel: with arguments: Feb 21 14:15:42 volumiorp5 kernel: /init Feb 21 14:15:42 volumiorp5 kernel: splash Feb 21 14:15:42 volumiorp5 kernel: nodebug Feb 21 14:15:42 volumiorp5 kernel: with environment: Feb 21 14:15:42 volumiorp5 kernel: HOME=/ Feb 21 14:15:42 volumiorp5 kernel: TERM=linux Feb 21 14:15:42 volumiorp5 kernel: imgpart=UUID=b0b466fc-4556-43af-9f97-ebe56fe4abe4 Feb 21 14:15:42 volumiorp5 kernel: imgfile=/volumio_current.sqsh Feb 21 14:15:42 volumiorp5 kernel: bootpart=UUID=0428-C7E4 Feb 21 14:15:42 volumiorp5 kernel: datapart=UUID=82051e0e-a859-4f54-aa9f-0cc23a932af8 Feb 21 14:15:42 volumiorp5 kernel: uuidconfig=cmdline.txt Feb 21 14:15:42 volumiorp5 kernel: bootdelay=7 Feb 21 14:15:42 volumiorp5 kernel: use_kmsg=no Feb 21 14:15:42 volumiorp5 kernel: plymouth=270 Feb 21 14:15:42 volumiorp5 kernel: mmc1: new ultra high speed DDR50 SDIO card at address 0001 Feb 21 14:15:42 volumiorp5 kernel: usb 1-1: new full-speed USB device number 2 using xhci-hcd Feb 21 14:15:42 volumiorp5 kernel: rp1-firmware rp1_firmware: RP1 Firmware version 23fca1cd776798b50bd3e640ecb242215778e7f8 Feb 21 14:15:42 volumiorp5 kernel: v3d 1002000000.v3d: [drm] Transparent Hugepage support is recommended for optimal performance on this platform! Feb 21 14:15:42 volumiorp5 kernel: input: pwr_button as /devices/platform/pwr_button/input/input0 Feb 21 14:15:42 volumiorp5 kernel: [drm] Initialized v3d 1.0.0 for 1002000000.v3d on minor 0 Feb 21 14:15:42 volumiorp5 kernel: brcmstb-i2c 107d508200.i2c: @97500hz registered in interrupt mode Feb 21 14:15:42 volumiorp5 kernel: brcmstb-i2c 107d508280.i2c: @97500hz registered in interrupt mode Feb 21 14:15:42 volumiorp5 kernel: rp1-pio 1f00178000.pio: Created instance as pio0 Feb 21 14:15:42 volumiorp5 kernel: vc4_hvs 107c580000.hvs: bcm2712_iommu_of_xlate: MMU 1000005200.iommu Feb 21 14:15:42 volumiorp5 kernel: vc4_hvs 107c580000.hvs: bcm2712_iommu_probe_device: MMU 1000005200.iommu Feb 21 14:15:42 volumiorp5 kernel: vc4_hvs 107c580000.hvs: bcm2712_iommu_device_group: MMU 1000005200.iommu Feb 21 14:15:42 volumiorp5 kernel: vc4_hvs 107c580000.hvs: Adding to iommu group 1 Feb 21 14:15:42 volumiorp5 kernel: vc4_hvs 107c580000.hvs: bcm2712_iommu_attach_dev: MMU 1000005200.iommu Feb 21 14:15:42 volumiorp5 kernel: vc4-drm axi:gpu: bcm2712_iommu_of_xlate: MMU 1000005200.iommu Feb 21 14:15:42 volumiorp5 kernel: vc4-drm axi:gpu: bcm2712_iommu_probe_device: MMU 1000005200.iommu Feb 21 14:15:42 volumiorp5 kernel: vc4-drm axi:gpu: bcm2712_iommu_device_group: MMU 1000005200.iommu Feb 21 14:15:42 volumiorp5 kernel: vc4-drm axi:gpu: Adding to iommu group 1 Feb 21 14:15:42 volumiorp5 kernel: vc4-drm axi:gpu: bcm2712_iommu_attach_dev: MMU 1000005200.iommu Feb 21 14:15:42 volumiorp5 kernel: Console: switching to colour dummy device 80x25 Feb 21 14:15:42 volumiorp5 kernel: vc4-drm axi:gpu: bound 107c580000.hvs (ops vc4_hvs_ops [vc4]) Feb 21 14:15:42 volumiorp5 kernel: Registered IR keymap rc-cec Feb 21 14:15:42 volumiorp5 kernel: rc rc0: vc4-hdmi-0 as /devices/platform/soc@107c000000/107c701400.hdmi/rc/rc0 Feb 21 14:15:42 volumiorp5 kernel: input: vc4-hdmi-0 as /devices/platform/soc@107c000000/107c701400.hdmi/rc/rc0/input1 Feb 21 14:15:42 volumiorp5 kernel: input: vc4-hdmi-0 HDMI Jack as /devices/platform/soc@107c000000/107c701400.hdmi/sound/card0/input2 Feb 21 14:15:42 volumiorp5 kernel: vc4-drm axi:gpu: bound 107c701400.hdmi (ops vc4_hdmi_ops [vc4]) Feb 21 14:15:42 volumiorp5 kernel: Registered IR keymap rc-cec Feb 21 14:15:42 volumiorp5 kernel: rc rc1: vc4-hdmi-1 as /devices/platform/soc@107c000000/107c706400.hdmi/rc/rc1 Feb 21 14:15:42 volumiorp5 kernel: input: vc4-hdmi-1 as /devices/platform/soc@107c000000/107c706400.hdmi/rc/rc1/input3 Feb 21 14:15:42 volumiorp5 kernel: input: vc4-hdmi-1 HDMI Jack as /devices/platform/soc@107c000000/107c706400.hdmi/sound/card1/input4 Feb 21 14:15:42 volumiorp5 kernel: vc4-drm axi:gpu: bound 107c706400.hdmi (ops vc4_hdmi_ops [vc4]) Feb 21 14:15:42 volumiorp5 kernel: vc4-drm axi:gpu: bound 107c500000.mop (ops vc4_txp_ops [vc4]) Feb 21 14:15:42 volumiorp5 kernel: vc4-drm axi:gpu: bound 107c501000.moplet (ops vc4_txp_ops [vc4]) Feb 21 14:15:42 volumiorp5 kernel: vc4-drm axi:gpu: bound 107c410000.pixelvalve (ops vc4_crtc_ops [vc4]) Feb 21 14:15:42 volumiorp5 kernel: vc4-drm axi:gpu: bound 107c411000.pixelvalve (ops vc4_crtc_ops [vc4]) Feb 21 14:15:42 volumiorp5 kernel: [drm] Initialized vc4 0.0.0 for axi:gpu on minor 1 Feb 21 14:15:42 volumiorp5 kernel: Console: switching to colour frame buffer device 185x20 Feb 21 14:15:42 volumiorp5 kernel: vc4-drm axi:gpu: [drm] fb0: vc4drmfb frame buffer device Feb 21 14:15:42 volumiorp5 kernel: usb 1-1: New USB device found, idVendor=1852, idProduct=7022, bcdDevice= 0.01 Feb 21 14:15:42 volumiorp5 kernel: usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Feb 21 14:15:42 volumiorp5 kernel: usb 1-1: Product: DigiHug USB Audio Feb 21 14:15:42 volumiorp5 kernel: usb 1-1: Manufacturer: FiiO Feb 21 14:15:42 volumiorp5 kernel: input: FiiO DigiHug USB Audio as /devices/platform/axi/1000120000.pcie/1f00200000.usb/xhci-hcd.0/usb1/1-1/1-1:1.0/0003:1852:7022.0001/input/input5 Feb 21 14:15:42 volumiorp5 kernel: hid-generic 0003:1852:7022.0001: input,hidraw0: USB HID v1.00 Device [FiiO DigiHug USB Audio] on usb-xhci-hcd.0-1/input0 Feb 21 14:15:42 volumiorp5 kernel: fuse: init (API version 7.41) Feb 21 14:15:42 volumiorp5 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Feb 21 14:15:42 volumiorp5 kernel: snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned. Feb 21 14:15:42 volumiorp5 kernel: fbtft: module is from the staging directory, the quality is unknown, you have been warned. Feb 21 14:15:42 volumiorp5 kernel: fb_ili9340: module is from the staging directory, the quality is unknown, you have been warned. Feb 21 14:15:42 volumiorp5 kernel: SPI driver fb_ili9340 has no spi_device_id for ilitek,ili9340 Feb 21 14:15:42 volumiorp5 kernel: fb_ili9341: module is from the staging directory, the quality is unknown, you have been warned. Feb 21 14:15:42 volumiorp5 kernel: fb_st7735r: module is from the staging directory, the quality is unknown, you have been warned. Feb 21 14:15:42 volumiorp5 kernel: SPI driver fb_st7735r has no spi_device_id for sitronix,st7735r Feb 21 14:15:42 volumiorp5 kernel: SPI driver fb_st7735r has no spi_device_id for fbtft,sainsmart18 Feb 21 14:15:42 volumiorp5 kernel: SPI driver fb_st7735r has no spi_device_id for fbtft,adafruit18 Feb 21 14:15:42 volumiorp5 kernel: SPI driver fb_st7735r has no spi_device_id for fbtft,adafruit18_green Feb 21 14:15:42 volumiorp5 kernel: fb_st7789v: module is from the staging directory, the quality is unknown, you have been warned. Feb 21 14:15:42 volumiorp5 kernel: SPI driver fb_st7789v has no spi_device_id for sitronix,st7789v Feb 21 14:15:42 volumiorp5 kernel: SPI driver fb_st7789v has no spi_device_id for fbtft,minipitft13 Feb 21 14:15:42 volumiorp5 kernel: fb_hx8357d: module is from the staging directory, the quality is unknown, you have been warned. Feb 21 14:15:42 volumiorp5 kernel: SPI driver fb_hx8357d has no spi_device_id for himax,hx8357d Feb 21 14:15:42 volumiorp5 kernel: EXT4-fs (mmcblk0p2): recovery complete Feb 21 14:15:42 volumiorp5 kernel: EXT4-fs (mmcblk0p2): mounted filesystem b0b466fc-4556-43af-9f97-ebe56fe4abe4 r/w with ordered data mode. Quota mode: none. Feb 21 14:15:42 volumiorp5 kernel: loop0: detected capacity change from 0 to 1423840 Feb 21 14:15:42 volumiorp5 kernel: EXT4-fs (mmcblk0p3): recovery complete Feb 21 14:15:42 volumiorp5 kernel: EXT4-fs (mmcblk0p3): mounted filesystem 82051e0e-a859-4f54-aa9f-0cc23a932af8 r/w with ordered data mode. Quota mode: none. Feb 21 14:15:42 volumiorp5 kernel: NET: Registered PF_INET6 protocol family Feb 21 14:15:42 volumiorp5 kernel: Segment Routing with IPv6 Feb 21 14:15:42 volumiorp5 kernel: In-situ OAM (IOAM) with IPv6 Feb 21 14:15:42 volumiorp5 systemd[1]: systemd 252.39-1~deb12u1+rpi1 running in system mode (+PAM +AUDIT +SELINUX +APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP +SYSVINIT default-hierarchy=unified) Feb 21 14:15:42 volumiorp5 systemd[1]: Detected architecture arm64. Feb 21 14:15:42 volumiorp5 systemd[1]: Hostname set to . Feb 21 14:15:42 volumiorp5 systemd[1]: Queued start job for default target graphical.target. Feb 21 14:15:42 volumiorp5 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Feb 21 14:15:42 volumiorp5 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Feb 21 14:15:42 volumiorp5 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Feb 21 14:15:42 volumiorp5 systemd[1]: Created slice user.slice - User and Session Slice. Feb 21 14:15:42 volumiorp5 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Feb 21 14:15:42 volumiorp5 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Feb 21 14:15:42 volumiorp5 systemd[1]: Expecting device dev-disk-by\x2duuid-0428\x2dC7E4.device - /dev/disk/by-uuid/0428-C7E4... Feb 21 14:15:42 volumiorp5 systemd[1]: Expecting device dev-ttyAMA10.device - /dev/ttyAMA10... Feb 21 14:15:42 volumiorp5 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Feb 21 14:15:42 volumiorp5 systemd[1]: Reached target slices.target - Slice Units. Feb 21 14:15:42 volumiorp5 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Feb 21 14:15:42 volumiorp5 systemd[1]: Listening on rpcbind.socket - RPCbind Server Activation Socket. Feb 21 14:15:42 volumiorp5 systemd[1]: Listening on systemd-fsckd.socket - fsck to fsckd communication Socket. Feb 21 14:15:42 volumiorp5 systemd[1]: Listening on systemd-initctl.socket - initctl Compatibility Named Pipe. Feb 21 14:15:42 volumiorp5 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Feb 21 14:15:42 volumiorp5 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Feb 21 14:15:42 volumiorp5 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Feb 21 14:15:42 volumiorp5 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Feb 21 14:15:42 volumiorp5 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Feb 21 14:15:42 volumiorp5 systemd[1]: dev-hugepages.mount - Huge Pages File System was skipped because of an unmet condition check (ConditionPathExists=/sys/kernel/mm/hugepages). Feb 21 14:15:42 volumiorp5 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Feb 21 14:15:42 volumiorp5 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Feb 21 14:15:42 volumiorp5 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Feb 21 14:15:42 volumiorp5 systemd[1]: auth-rpcgss-module.service - Kernel Module supporting RPCSEC_GSS was skipped because of an unmet condition check (ConditionPathExists=/etc/krb5.keytab). Feb 21 14:15:42 volumiorp5 systemd[1]: Started dynamicswap.service - dynamicswap service. Feb 21 14:15:42 volumiorp5 systemd[1]: Reached target swap.target - Swaps. Feb 21 14:15:42 volumiorp5 systemd[1]: Starting fake-hwclock.service - Restore / save the current clock... Feb 21 14:15:42 volumiorp5 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Feb 21 14:15:42 volumiorp5 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Feb 21 14:15:42 volumiorp5 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Feb 21 14:15:42 volumiorp5 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Feb 21 14:15:42 volumiorp5 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Feb 21 14:15:42 volumiorp5 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Feb 21 14:15:42 volumiorp5 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Feb 21 14:15:42 volumiorp5 systemd[1]: Starting systemd-journald.service - Journal Service... Feb 21 14:15:42 volumiorp5 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Feb 21 14:15:42 volumiorp5 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Feb 21 14:15:42 volumiorp5 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Feb 21 14:15:42 volumiorp5 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Feb 21 14:15:42 volumiorp5 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Feb 21 14:15:42 volumiorp5 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Feb 21 14:15:42 volumiorp5 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Feb 21 14:15:42 volumiorp5 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Feb 21 14:15:42 volumiorp5 systemd[1]: modprobe@configfs.service: Deactivated successfully. Feb 21 14:15:42 volumiorp5 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Feb 21 14:15:42 volumiorp5 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Feb 21 14:15:42 volumiorp5 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Feb 21 14:15:42 volumiorp5 systemd[1]: modprobe@drm.service: Deactivated successfully. Feb 21 14:15:42 volumiorp5 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Feb 21 14:15:42 volumiorp5 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Feb 21 14:15:42 volumiorp5 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Feb 21 14:15:42 volumiorp5 systemd[1]: modprobe@fuse.service: Deactivated successfully. Feb 21 14:15:42 volumiorp5 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Feb 21 14:15:42 volumiorp5 systemd[1]: modprobe@loop.service: Deactivated successfully. Feb 21 14:15:42 volumiorp5 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Feb 21 14:15:42 volumiorp5 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Feb 21 14:15:42 volumiorp5 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Feb 21 14:15:42 volumiorp5 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Feb 21 14:15:42 volumiorp5 systemd[1]: Finished fake-hwclock.service - Restore / save the current clock. Feb 21 14:15:42 volumiorp5 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Feb 21 14:15:42 volumiorp5 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Feb 21 14:15:42 volumiorp5 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Feb 21 14:15:42 volumiorp5 systemd[1]: systemd-firstboot.service - First Boot Wizard was skipped because of an unmet condition check (ConditionFirstBoot=yes). Feb 21 14:15:42 volumiorp5 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Feb 21 14:15:42 volumiorp5 kernel: i2c_dev: i2c /dev entries driver Feb 21 14:15:42 volumiorp5 systemd[1]: Starting systemd-random-seed.service - Load/Save Random Seed... Feb 21 14:15:42 volumiorp5 systemd[1]: Starting systemd-sysusers.service - Create System Users... Feb 21 14:15:42 volumiorp5 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Feb 21 14:15:42 volumiorp5 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Feb 21 14:15:42 volumiorp5 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Feb 21 14:15:42 volumiorp5 systemd[1]: Finished systemd-random-seed.service - Load/Save Random Seed. Feb 21 14:15:42 volumiorp5 systemd[1]: first-boot-complete.target - First Boot Complete was skipped because of an unmet condition check (ConditionFirstBoot=yes). Feb 21 14:15:42 volumiorp5 systemd[1]: dynamicswap.service: Deactivated successfully. Feb 21 14:15:42 volumiorp5 systemd-journald[532]: Journal started Feb 21 14:15:42 volumiorp5 systemd-journald[532]: Runtime Journal (/run/log/journal/5d75154b0edd470a8cb44210694cfe4a) is 3.7M, max 30.0M, 26.2M free. Feb 21 14:15:42 volumiorp5 systemd-modules-load[533]: Inserted module 'i2c_dev' Feb 21 14:15:42 volumiorp5 fake-hwclock[522]: Current system time: 2026-02-21 13:15:42 Feb 21 14:15:42 volumiorp5 fake-hwclock[522]: fake-hwclock saved clock information is in the past: 2026-02-21 13:15:19 Feb 21 14:15:42 volumiorp5 fake-hwclock[522]: To set system time to this saved clock anyway, use "force" Feb 21 14:15:42 volumiorp5 systemd[1]: Started systemd-journald.service - Journal Service. Feb 21 14:15:42 volumiorp5 systemd[1]: Finished systemd-sysusers.service - Create System Users. Feb 21 14:15:42 volumiorp5 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Feb 21 14:15:42 volumiorp5 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Feb 21 14:15:42 volumiorp5 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Feb 21 14:15:42 volumiorp5 systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Feb 21 14:15:42 volumiorp5 systemd[1]: Mounting tmp.mount - /tmp... Feb 21 14:15:42 volumiorp5 systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Feb 21 14:15:42 volumiorp5 systemd[1]: Mounting var-log.mount - /var/log... Feb 21 14:15:42 volumiorp5 systemd[1]: Mounting var-spool-cups.mount - /var/spool/cups... Feb 21 14:15:42 volumiorp5 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Feb 21 14:15:42 volumiorp5 systemd[1]: Mounted tmp.mount - /tmp. Feb 21 14:15:42 volumiorp5 systemd[1]: Mounted var-log.mount - /var/log. Feb 21 14:15:42 volumiorp5 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Feb 21 14:15:42 volumiorp5 systemd[1]: Mounted var-spool-cups.mount - /var/spool/cups. Feb 21 14:15:42 volumiorp5 systemd[1]: Starting ifupdown-pre.service - Helper to synchronize boot up for ifupdown... Feb 21 14:15:42 volumiorp5 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Feb 21 14:15:42 volumiorp5 systemd-journald[532]: Runtime Journal (/run/log/journal/5d75154b0edd470a8cb44210694cfe4a) is 3.7M, max 30.0M, 26.2M free. Feb 21 14:15:42 volumiorp5 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Feb 21 14:15:42 volumiorp5 systemd-journald[532]: Received client request to flush runtime journal. Feb 21 14:15:42 volumiorp5 systemd-udevd[557]: Using default interface naming scheme 'v252'. Feb 21 14:15:42 volumiorp5 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Feb 21 14:15:42 volumiorp5 (udev-worker)[567]: Network interface NamePolicy= disabled on kernel command line. Feb 21 14:15:42 volumiorp5 kernel: mc: Linux media interface: v0.10 Feb 21 14:15:42 volumiorp5 kernel: rpi-gpiomem 107d508500.gpiomem: window base 0x107d508500 size 0x00000040 Feb 21 14:15:42 volumiorp5 kernel: rpi-gpiomem 107d508500.gpiomem: initialised 1 regions as /dev/gpiomem1 Feb 21 14:15:42 volumiorp5 kernel: rpi-gpiomem 107d517c00.gpiomem: window base 0x107d517c00 size 0x00000040 Feb 21 14:15:42 volumiorp5 kernel: rpi-gpiomem 107d517c00.gpiomem: initialised 1 regions as /dev/gpiomem2 Feb 21 14:15:42 volumiorp5 kernel: rpi-gpiomem 107d504100.gpiomem: window base 0x107d504100 size 0x00000020 Feb 21 14:15:42 volumiorp5 kernel: rpi-gpiomem 107d504100.gpiomem: initialised 1 regions as /dev/gpiomem3 Feb 21 14:15:42 volumiorp5 kernel: rpi-gpiomem 107d510700.gpiomem: window base 0x107d510700 size 0x00000020 Feb 21 14:15:42 volumiorp5 kernel: rpi-gpiomem 107d510700.gpiomem: initialised 1 regions as /dev/gpiomem4 Feb 21 14:15:42 volumiorp5 kernel: rpi-gpiomem 1f000d0000.gpiomem: window base 0x1f000d0000 size 0x00030000 Feb 21 14:15:42 volumiorp5 kernel: rpi-gpiomem 1f000d0000.gpiomem: initialised 1 regions as /dev/gpiomem0 Feb 21 14:15:42 volumiorp5 kernel: videodev: Linux video capture interface: v2.00 Feb 21 14:15:42 volumiorp5 systemd[1]: Found device dev-disk-by\x2duuid-0428\x2dC7E4.device - /dev/disk/by-uuid/0428-C7E4. Feb 21 14:15:42 volumiorp5 kernel: rpi-hevc-dec 1000800000.codec: bcm2712_iommu_of_xlate: MMU 1000005100.iommu Feb 21 14:15:42 volumiorp5 kernel: rpi-hevc-dec 1000800000.codec: bcm2712_iommu_probe_device: MMU 1000005100.iommu Feb 21 14:15:42 volumiorp5 kernel: rpi-hevc-dec 1000800000.codec: bcm2712_iommu_device_group: MMU 1000005100.iommu Feb 21 14:15:42 volumiorp5 kernel: rpi-hevc-dec 1000800000.codec: Adding to iommu group 0 Feb 21 14:15:42 volumiorp5 kernel: rpi-hevc-dec 1000800000.codec: bcm2712_iommu_attach_dev: MMU 1000005100.iommu Feb 21 14:15:42 volumiorp5 kernel: rpi-hevc-dec 1000800000.codec: Device registered as /dev/video19 Feb 21 14:15:42 volumiorp5 kernel: pispbe 1000880000.pisp_be: bcm2712_iommu_of_xlate: MMU 1000005100.iommu Feb 21 14:15:42 volumiorp5 kernel: pispbe 1000880000.pisp_be: bcm2712_iommu_probe_device: MMU 1000005100.iommu Feb 21 14:15:42 volumiorp5 kernel: pispbe 1000880000.pisp_be: bcm2712_iommu_device_group: MMU 1000005100.iommu Feb 21 14:15:42 volumiorp5 kernel: pispbe 1000880000.pisp_be: Adding to iommu group 0 Feb 21 14:15:42 volumiorp5 kernel: pispbe 1000880000.pisp_be: bcm2712_iommu_attach_dev: MMU 1000005100.iommu Feb 21 14:15:42 volumiorp5 systemd[1]: Starting systemd-fsck@dev-disk-by\x2duuid-0428\x2dC7E4.service - File System Check on /dev/disk/by-uuid/0428-C7E4... Feb 21 14:15:42 volumiorp5 systemd[1]: Expecting device sys-subsystem-net-devices-eth0.device - /sys/subsystem/net/devices/eth0... Feb 21 14:15:42 volumiorp5 systemd[1]: Started systemd-fsckd.service - File System Check Daemon to report status. Feb 21 14:15:42 volumiorp5 systemd[1]: Found device dev-ttyAMA10.device - /dev/ttyAMA10. Feb 21 14:15:42 volumiorp5 systemd[1]: Found device sys-subsystem-net-devices-eth0.device - /sys/subsystem/net/devices/eth0. Feb 21 14:15:42 volumiorp5 kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database Feb 21 14:15:42 volumiorp5 kernel: Loaded X.509 cert 'benh@debian.org: 577e021cb980e0e820821ba7b54b4961b8b4fadf' Feb 21 14:15:42 volumiorp5 kernel: Loaded X.509 cert 'romain.perier@gmail.com: 3abbc6ec146e09d1b6016ab9d6cf71dd233f0328' Feb 21 14:15:42 volumiorp5 kernel: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' Feb 21 14:15:42 volumiorp5 kernel: Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' Feb 21 14:15:42 volumiorp5 systemd-fsck[770]: fsck.fat 4.2 (2021-01-31) Feb 21 14:15:42 volumiorp5 systemd-fsck[770]: /dev/mmcblk0p1: 425 files, 23454/93500 clusters Feb 21 14:15:42 volumiorp5 kernel: Bluetooth: Core ver 2.22 Feb 21 14:15:42 volumiorp5 kernel: NET: Registered PF_BLUETOOTH protocol family Feb 21 14:15:42 volumiorp5 kernel: Bluetooth: HCI device and connection manager initialized Feb 21 14:15:42 volumiorp5 kernel: Bluetooth: HCI socket layer initialized Feb 21 14:15:42 volumiorp5 kernel: Bluetooth: L2CAP socket layer initialized Feb 21 14:15:42 volumiorp5 kernel: Bluetooth: SCO socket layer initialized Feb 21 14:15:42 volumiorp5 kernel: Bluetooth: HCI UART driver ver 2.3 Feb 21 14:15:42 volumiorp5 kernel: Bluetooth: HCI UART protocol H4 registered Feb 21 14:15:42 volumiorp5 kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered Feb 21 14:15:42 volumiorp5 kernel: hci_uart_bcm serial0-0: supply vbat not found, using dummy regulator Feb 21 14:15:42 volumiorp5 kernel: hci_uart_bcm serial0-0: supply vddio not found, using dummy regulator Feb 21 14:15:42 volumiorp5 kernel: Bluetooth: HCI UART protocol Broadcom registered Feb 21 14:15:42 volumiorp5 kernel: brcmfmac: F1 signature read @0x18000000=0x15264345 Feb 21 14:15:42 volumiorp5 kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6 Feb 21 14:15:42 volumiorp5 kernel: usbcore: registered new interface driver brcmfmac Feb 21 14:15:42 volumiorp5 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Feb 21 14:15:42 volumiorp5 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Feb 21 14:15:42 volumiorp5 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Feb 21 14:15:42 volumiorp5 systemd[1]: systemd-firstboot.service - First Boot Wizard was skipped because of an unmet condition check (ConditionFirstBoot=yes). Feb 21 14:15:42 volumiorp5 systemd[1]: first-boot-complete.target - First Boot Complete was skipped because of an unmet condition check (ConditionFirstBoot=yes). Feb 21 14:15:42 volumiorp5 systemd[1]: Finished systemd-fsck@dev-disk-by\x2duuid-0428\x2dC7E4.service - File System Check on /dev/disk/by-uuid/0428-C7E4. Feb 21 14:15:42 volumiorp5 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Feb 21 14:15:42 volumiorp5 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Feb 21 14:15:42 volumiorp5 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Feb 21 14:15:42 volumiorp5 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Feb 21 14:15:42 volumiorp5 systemd[1]: modprobe@loop.service: Deactivated successfully. Feb 21 14:15:42 volumiorp5 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Feb 21 14:15:42 volumiorp5 systemd[1]: Listening on systemd-rfkill.socket - Load/Save RF Kill Switch Status /dev/rfkill Watch. Feb 21 14:15:42 volumiorp5 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Feb 21 14:15:42 volumiorp5 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Feb 21 14:15:42 volumiorp5 systemd[1]: systemd-firstboot.service - First Boot Wizard was skipped because of an unmet condition check (ConditionFirstBoot=yes). Feb 21 14:15:42 volumiorp5 systemd[1]: first-boot-complete.target - First Boot Complete was skipped because of an unmet condition check (ConditionFirstBoot=yes). Feb 21 14:15:42 volumiorp5 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Feb 21 14:15:42 volumiorp5 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Feb 21 14:15:42 volumiorp5 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Feb 21 14:15:42 volumiorp5 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Feb 21 14:15:42 volumiorp5 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Feb 21 14:15:42 volumiorp5 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Feb 21 14:15:42 volumiorp5 (udev-worker)[593]: hci0: Process '/usr/bin/hciconfig hci0 up' failed with exit code 1. Feb 21 14:15:42 volumiorp5 kernel: brcmfmac: brcmf_c_process_txcap_blob: no txcap_blob available (err=-2) Feb 21 14:15:42 volumiorp5 kernel: brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM4345/6 wl0: Aug 29 2023 01:47:08 version 7.45.265 (28bca26 CY) FWID 01-b677b91b Feb 21 14:15:42 volumiorp5 systemd[1]: Starting systemd-rfkill.service - Load/Save RF Kill Switch Status... Feb 21 14:15:42 volumiorp5 systemd[1]: Started systemd-rfkill.service - Load/Save RF Kill Switch Status. Feb 21 14:15:42 volumiorp5 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Feb 21 14:15:42 volumiorp5 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Feb 21 14:15:42 volumiorp5 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Feb 21 14:15:42 volumiorp5 systemd[1]: systemd-firstboot.service - First Boot Wizard was skipped because of an unmet condition check (ConditionFirstBoot=yes). Feb 21 14:15:42 volumiorp5 systemd[1]: first-boot-complete.target - First Boot Complete was skipped because of an unmet condition check (ConditionFirstBoot=yes). Feb 21 14:15:42 volumiorp5 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Feb 21 14:15:42 volumiorp5 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Feb 21 14:15:42 volumiorp5 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Feb 21 14:15:42 volumiorp5 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Feb 21 14:15:42 volumiorp5 systemd[1]: modprobe@loop.service: Deactivated successfully. Feb 21 14:15:42 volumiorp5 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Feb 21 14:15:42 volumiorp5 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Feb 21 14:15:42 volumiorp5 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Feb 21 14:15:42 volumiorp5 systemd[1]: Expecting device sys-subsystem-net-devices-wlan0.device - /sys/subsystem/net/devices/wlan0... Feb 21 14:15:42 volumiorp5 systemd[1]: Found device sys-subsystem-net-devices-wlan0.device - /sys/subsystem/net/devices/wlan0. Feb 21 14:15:42 volumiorp5 kernel: Bluetooth: hci0: BCM: chip id 107 Feb 21 14:15:42 volumiorp5 kernel: Bluetooth: hci0: BCM: features 0x2f Feb 21 14:15:42 volumiorp5 kernel: Bluetooth: hci0: BCM4345C0 Feb 21 14:15:42 volumiorp5 kernel: Bluetooth: hci0: BCM4345C0 (003.001.025) build 0000 Feb 21 14:15:42 volumiorp5 kernel: Bluetooth: hci0: BCM4345C0 'brcm/BCM4345C0.raspberrypi,5-model-b.hcd' Patch Feb 21 14:15:43 volumiorp5 systemd[1]: boot.mount: Directory /boot to mount over is not empty, mounting anyway. Feb 21 14:15:43 volumiorp5 systemd[1]: Mounting boot.mount - /boot... Feb 21 14:15:43 volumiorp5 systemd[1]: dev-hugepages.mount - Huge Pages File System was skipped because of an unmet condition check (ConditionPathExists=/sys/kernel/mm/hugepages). Feb 21 14:15:43 volumiorp5 systemd[1]: Mounting var-spool-cups-tmp.mount - /var/spool/cups/tmp... Feb 21 14:15:43 volumiorp5 systemd[1]: Mounted var-spool-cups-tmp.mount - /var/spool/cups/tmp. Feb 21 14:15:43 volumiorp5 systemd[1]: Mounted boot.mount - /boot. Feb 21 14:15:43 volumiorp5 systemd[1]: Reached target local-fs.target - Local File Systems. Feb 21 14:15:43 volumiorp5 systemd[1]: Started ifup@eth0.service - ifup for eth0. Feb 21 14:15:43 volumiorp5 systemd[1]: Started ifup@wlan0.service - ifup for wlan0. Feb 21 14:15:43 volumiorp5 systemd[1]: Starting plymouth-read-write.service - Tell Plymouth To Write Out Runtime Data... Feb 21 14:15:43 volumiorp5 systemd[1]: Starting plymouth-rotation.service - Plymouth rotation detection for shutdown/reboot... Feb 21 14:15:43 volumiorp5 systemd[1]: Starting systemd-binfmt.service - Set Up Additional Binary Formats... Feb 21 14:15:43 volumiorp5 systemd[1]: systemd-machine-id-commit.service - Commit a transient machine-id on disk was skipped because of an unmet condition check (ConditionPathIsMountPoint=/etc/machine-id). Feb 21 14:15:43 volumiorp5 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Feb 21 14:15:43 volumiorp5 systemd[1]: proc-sys-fs-binfmt_misc.automount: Got automount request for /proc/sys/fs/binfmt_misc, triggered by 857 (systemd-binfmt) Feb 21 14:15:43 volumiorp5 systemd[1]: Received SIGRTMIN+20 from PID 408 (plymouthd). Feb 21 14:15:43 volumiorp5 systemd[1]: Finished plymouth-read-write.service - Tell Plymouth To Write Out Runtime Data. Feb 21 14:15:43 volumiorp5 systemd[1]: Mounting proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System... Feb 21 14:15:43 volumiorp5 systemd[1]: Finished plymouth-rotation.service - Plymouth rotation detection for shutdown/reboot. Feb 21 14:15:43 volumiorp5 systemd[1]: Starting plymouth-start.service - Show Plymouth Boot Screen... Feb 21 14:15:43 volumiorp5 systemd[1]: Mounted proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System. Feb 21 14:15:43 volumiorp5 systemd[1]: Finished systemd-binfmt.service - Set Up Additional Binary Formats. Feb 21 14:15:43 volumiorp5 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Feb 21 14:15:43 volumiorp5 kernel: warning: `iwconfig' uses wireless extensions which will stop working for Wi-Fi 7 hardware; use nl80211 Feb 21 14:15:43 volumiorp5 systemd[1]: Started haveged.service - Entropy Daemon based on the HAVEGE algorithm. Feb 21 14:15:43 volumiorp5 systemd[1]: Starting rpcbind.service - RPC bind portmap service... Feb 21 14:15:43 volumiorp5 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Feb 21 14:15:43 volumiorp5 systemd[1]: Started plymouth-start.service - Show Plymouth Boot Screen. Feb 21 14:15:43 volumiorp5 systemd[1]: systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch was skipped because of an unmet condition check (ConditionPathExists=!/run/plymouth/pid). Feb 21 14:15:43 volumiorp5 systemd[1]: Started systemd-ask-password-plymouth.path - Forward Password Requests to Plymouth Directory Watch. Feb 21 14:15:43 volumiorp5 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Feb 21 14:15:43 volumiorp5 systemd[1]: Reached target paths.target - Path Units. Feb 21 14:15:43 volumiorp5 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Feb 21 14:15:43 volumiorp5 systemd[1]: Reached target sysinit.target - System Initialization. Feb 21 14:15:43 volumiorp5 systemd[1]: Started apt-daily.timer - Daily apt download activities. Feb 21 14:15:43 volumiorp5 systemd[1]: Started apt-daily-upgrade.timer - Daily apt upgrade and clean activities. Feb 21 14:15:43 volumiorp5 systemd[1]: Started dpkg-db-backup.timer - Daily dpkg database backup timer. Feb 21 14:15:43 volumiorp5 systemd[1]: Started e2scrub_all.timer - Periodic ext4 Online Metadata Check for All Filesystems. Feb 21 14:15:43 volumiorp5 systemd[1]: Started fstrim.timer - Discard unused blocks once a week. Feb 21 14:15:43 volumiorp5 systemd[1]: Started man-db.timer - Daily man-db regeneration. Feb 21 14:15:43 volumiorp5 systemd[1]: Started ntpsec-rotate-stats.timer - Rotate ntpd stats daily. Feb 21 14:15:43 volumiorp5 systemd[1]: Started setdatetime-helper.timer - Volumio Time Sync Watchdog Timer. Feb 21 14:15:43 volumiorp5 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Feb 21 14:15:43 volumiorp5 systemd[1]: Reached target timers.target - Timer Units. Feb 21 14:15:43 volumiorp5 systemd[1]: Listening on avahi-daemon.socket - Avahi mDNS/DNS-SD Stack Activation Socket. Feb 21 14:15:43 volumiorp5 sh[898]: dhcpcd-9.4.1 starting Feb 21 14:15:43 volumiorp5 dhcpcd[898]: dhcpcd-9.4.1 starting Feb 21 14:15:43 volumiorp5 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Feb 21 14:15:43 volumiorp5 systemd[1]: Reached target sockets.target - Socket Units. Feb 21 14:15:43 volumiorp5 dhcpcd[902]: DUID 00:01:00:01:31:13:aa:2c:2c:cf:67:c3:39:7b Feb 21 14:15:43 volumiorp5 sh[898]: DUID 00:01:00:01:31:13:aa:2c:2c:cf:67:c3:39:7b Feb 21 14:15:43 volumiorp5 sh[898]: dhcp_vendor: No such process Feb 21 14:15:43 volumiorp5 dhcpcd[902]: dhcp_vendor: No such process Feb 21 14:15:43 volumiorp5 systemd[1]: systemd-pcrphase-sysinit.service - TPM2 PCR Barrier (Initialization) was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/StubPcrKernelImage-4a67b082-0a4c-41cf-b6c7-440b29bb8c4f). Feb 21 14:15:43 volumiorp5 systemd[1]: Reached target basic.target - Basic System. Feb 21 14:15:43 volumiorp5 systemd[1]: alsa-state.service - Manage Sound Card State (restore and store) was skipped because of an unmet condition check (ConditionPathExists=/etc/alsa/state-daemon.conf). Feb 21 14:15:43 volumiorp5 haveged[886]: haveged: command socket is listening at fd 3 Feb 21 14:15:43 volumiorp5 systemd[1]: Starting alsa-restore.service - Save/Restore Sound Card State... Feb 21 14:15:43 volumiorp5 systemd[1]: Starting avahi-daemon.service - Avahi mDNS/DNS-SD Stack... Feb 21 14:15:43 volumiorp5 systemd[1]: Starting bluetooth.service - Bluetooth service... Feb 21 14:15:43 volumiorp5 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Feb 21 14:15:43 volumiorp5 systemd[1]: Starting e2scrub_reap.service - Remove Stale Online ext4 Metadata Check Snapshots... Feb 21 14:15:43 volumiorp5 systemd[1]: getty-static.service - getty on tty2-tty6 if dbus and logind are not available was skipped because of an unmet condition check (ConditionPathExists=!/usr/bin/dbus-daemon). Feb 21 14:15:43 volumiorp5 systemd[1]: Starting glamor-test.service - Check for glamor... Feb 21 14:15:43 volumiorp5 systemd[1]: headless_wireless.service - Copy user wpa_supplicant.conf was skipped because of an unmet condition check (ConditionPathExists=/boot/wpa_supplicant.conf). Feb 21 14:15:43 volumiorp5 systemd[1]: Started iptables.service - Volumio Iptables Module. Feb 21 14:15:43 volumiorp5 systemd[1]: Starting rp1-test.service - Check for RP1 displays for Xorg... Feb 21 14:15:43 volumiorp5 systemd[1]: Starting rpi-eeprom-update.service - Check for Raspberry Pi EEPROM updates... Feb 21 14:15:43 volumiorp5 kernel: 8021q: 802.1Q VLAN Support v1.8 Feb 21 14:15:43 volumiorp5 kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Feb 21 14:15:43 volumiorp5 systemd[1]: Starting systemd-logind.service - User Login Management... Feb 21 14:15:43 volumiorp5 systemd[1]: Starting triggerhappy.service - triggerhappy global hotkey daemon... Feb 21 14:15:43 volumiorp5 systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Feb 21 14:15:43 volumiorp5 systemd[1]: Started volumio-remote-updater.service - Volumio Remote OTA Updater. Feb 21 14:15:43 volumiorp5 systemd[1]: Starting volumio_rfkill_unblock.service - Manage nl80211 modules blocking state... Feb 21 14:15:43 volumiorp5 systemd[1]: volumiossh.service - Volumio SSH enabler was skipped because of an unmet condition check (ConditionPathExistsGlob=/boot/ssh{,.txt}). Feb 21 14:15:43 volumiorp5 systemd[1]: Starting wireless.service - Wireless Services... Feb 21 14:15:43 volumiorp5 volumio_rfkill_unblock.sh[929]: Volumio WiFi Soft Blocked check script Feb 21 14:15:43 volumiorp5 volumio_rfkill_unblock.sh[929]: Check if rfkill is available Feb 21 14:15:43 volumiorp5 kernel: usbcore: registered new interface driver snd-usb-audio Feb 21 14:15:43 volumiorp5 systemd[1]: e2scrub_reap.service: Deactivated successfully. Feb 21 14:15:43 volumiorp5 systemd[1]: Finished e2scrub_reap.service - Remove Stale Online ext4 Metadata Check Snapshots. Feb 21 14:15:43 volumiorp5 alsactl[944]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Feb 21 14:15:43 volumiorp5 alsactl[944]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Feb 21 14:15:43 volumiorp5 thd[926]: Unable to parse trigger line: Feb 21 14:15:43 volumiorp5 thd[926]: Unable to parse trigger line: Feb 21 14:15:43 volumiorp5 systemd[1]: Started triggerhappy.service - triggerhappy global hotkey daemon. Feb 21 14:15:43 volumiorp5 systemd[1]: Starting th-udev-rebind.service - Late rebind of input devices to triggerhappy... Feb 21 14:15:43 volumiorp5 avahi-daemon[908]: Found user 'avahi' (UID 103) and group 'avahi' (GID 109). Feb 21 14:15:43 volumiorp5 avahi-daemon[908]: Successfully dropped root privileges. Feb 21 14:15:43 volumiorp5 avahi-daemon[908]: avahi-daemon 0.8 starting up. Feb 21 14:15:43 volumiorp5 volumio_rfkill_unblock.sh[929]: Check if rfkill listed devices are already unblocked Feb 21 14:15:43 volumiorp5 systemd[1]: Started rpcbind.service - RPC bind portmap service. Feb 21 14:15:43 volumiorp5 systemd[1]: Reached target rpcbind.target - RPC Port Mapper. Feb 21 14:15:43 volumiorp5 th-udev-rebind.sh[963]: Rebinding /dev/input/event0 to thd using --add... Feb 21 14:15:43 volumiorp5 th-udev-rebind.sh[963]: Rebinding /dev/input/event1 to thd using --add... Feb 21 14:15:43 volumiorp5 th-udev-rebind.sh[963]: Rebinding /dev/input/event2 to thd using --add... Feb 21 14:15:43 volumiorp5 systemd-logind[918]: New seat seat0. Feb 21 14:15:43 volumiorp5 th-udev-rebind.sh[963]: Rebinding /dev/input/event3 to thd using --add... Feb 21 14:15:43 volumiorp5 th-udev-rebind.sh[963]: Rebinding /dev/input/event4 to thd using --add... Feb 21 14:15:43 volumiorp5 systemd-logind[918]: Watching system buttons on /dev/input/event0 (pwr_button) Feb 21 14:15:43 volumiorp5 systemd-logind[918]: Watching system buttons on /dev/input/event1 (vc4-hdmi-0) Feb 21 14:15:43 volumiorp5 systemd-logind[918]: Watching system buttons on /dev/input/event3 (vc4-hdmi-1) Feb 21 14:15:43 volumiorp5 th-udev-rebind.sh[963]: Rebinding /dev/input/event5 to thd using --add... Feb 21 14:15:43 volumiorp5 sh[993]: wlan0=wlan0 Feb 21 14:15:43 volumiorp5 systemd[1]: th-udev-rebind.service: Deactivated successfully. Feb 21 14:15:43 volumiorp5 systemd[1]: Finished th-udev-rebind.service - Late rebind of input devices to triggerhappy. Feb 21 14:15:43 volumiorp5 volumio_rfkill_unblock.sh[929]: Wi-Fi is already unblocked. Feb 21 14:15:43 volumiorp5 systemd[1]: Finished volumio_rfkill_unblock.service - Manage nl80211 modules blocking state. Feb 21 14:15:43 volumiorp5 rpi-eeprom-update[915]: WARNING: flashrom not found. Setting RPI_EEPROM_USE_FLASHROM to 0 Feb 21 14:15:43 volumiorp5 bluetoothd[909]: Bluetooth daemon 5.83 Feb 21 14:15:43 volumiorp5 systemd[1]: Starting dhcpcd.service - DHCP Client Daemon on all interfaces... Feb 21 14:15:43 volumiorp5 systemd[1]: Finished alsa-restore.service - Save/Restore Sound Card State. Feb 21 14:15:43 volumiorp5 systemd[1]: alsa-state.service - Manage Sound Card State (restore and store) was skipped because of an unmet condition check (ConditionPathExists=/etc/alsa/state-daemon.conf). Feb 21 14:15:43 volumiorp5 systemd[1]: Reached target sound.target - Sound Card. Feb 21 14:15:43 volumiorp5 dhcpcd[994]: dhcpcd-9.4.1 starting Feb 21 14:15:43 volumiorp5 kernel: macb 1f00100000.ethernet eth0: PHY [1f00100000.ethernet-ffffffff:01] driver [Broadcom BCM54213PE] (irq=POLL) Feb 21 14:15:43 volumiorp5 kernel: macb 1f00100000.ethernet eth0: configuring for phy/rgmii-id link mode Feb 21 14:15:43 volumiorp5 dhcpcd[902]: eth0: waiting for carrier Feb 21 14:15:43 volumiorp5 sh[898]: eth0: waiting for carrier Feb 21 14:15:43 volumiorp5 kernel: macb 1f00100000.ethernet: gem-ptp-timer ptp clock registered. Feb 21 14:15:43 volumiorp5 dhcpcd[1013]: dev: loaded udev Feb 21 14:15:43 volumiorp5 dhcpcd[1013]: DUID 00:01:00:01:31:13:aa:2c:2c:cf:67:c3:39:7b Feb 21 14:15:43 volumiorp5 dhcpcd[1013]: dhcp_vendor: No such process Feb 21 14:15:43 volumiorp5 dhcpcd[994]: dhcp_vendor: No such process Feb 21 14:15:43 volumiorp5 systemd[1]: Started dhcpcd.service - DHCP Client Daemon on all interfaces. Feb 21 14:15:43 volumiorp5 systemd[1]: Started dbus.service - D-Bus System Message Bus. Feb 21 14:15:43 volumiorp5 avahi-daemon[908]: Successfully called chroot(). Feb 21 14:15:43 volumiorp5 avahi-daemon[908]: Successfully dropped remaining capabilities. Feb 21 14:15:43 volumiorp5 dbus-daemon[910]: [system] Successfully activated service 'org.freedesktop.systemd1' Feb 21 14:15:43 volumiorp5 bluetoothd[909]: Starting SDP server Feb 21 14:15:43 volumiorp5 bluetoothd[909]: Excluding (cli) sap Feb 21 14:15:43 volumiorp5 bluetoothd[909]: Excluding (cli) midi Feb 21 14:15:43 volumiorp5 bluetoothd[909]: Excluding (cli) battery Feb 21 14:15:43 volumiorp5 avahi-daemon[908]: Loading service file /services/volumio.service. Feb 21 14:15:43 volumiorp5 avahi-daemon[908]: Joining mDNS multicast group on interface lo.IPv4 with address 127.0.0.1. Feb 21 14:15:43 volumiorp5 avahi-daemon[908]: New relevant interface lo.IPv4 for mDNS. Feb 21 14:15:43 volumiorp5 avahi-daemon[908]: Network interface enumeration completed. Feb 21 14:15:43 volumiorp5 avahi-daemon[908]: Registering new address record for 127.0.0.1 on lo.IPv4. Feb 21 14:15:43 volumiorp5 dhcpcd[1013]: eth0: waiting for carrier Feb 21 14:15:43 volumiorp5 dhcpcd[1013]: wlan0: waiting for carrier Feb 21 14:15:43 volumiorp5 systemd[1]: Starting wpa_supplicant.service - WPA supplicant... Feb 21 14:15:43 volumiorp5 systemd[1]: Finished glamor-test.service - Check for glamor. Feb 21 14:15:43 volumiorp5 systemd[1]: Started systemd-logind.service - User Login Management. Feb 21 14:15:43 volumiorp5 systemd[1]: Started bluetooth.service - Bluetooth service. Feb 21 14:15:43 volumiorp5 systemd[1]: Started avahi-daemon.service - Avahi mDNS/DNS-SD Stack. Feb 21 14:15:43 volumiorp5 systemd[1]: Starting bluealsa.service - BlueALSA service... Feb 21 14:15:43 volumiorp5 kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Feb 21 14:15:43 volumiorp5 kernel: Bluetooth: BNEP filters: protocol multicast Feb 21 14:15:43 volumiorp5 kernel: Bluetooth: BNEP socket layer initialized Feb 21 14:15:43 volumiorp5 dbus-daemon[910]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.1' (uid=0 pid=909 comm="/usr/libexec/bluetooth/bluetoothd --noplugin=sap,b") Feb 21 14:15:43 volumiorp5 bluetoothd[909]: Bluetooth management interface 1.23 initialized Feb 21 14:15:43 volumiorp5 systemd[1]: Starting systemd-hostnamed.service - Hostname Service... Feb 21 14:15:43 volumiorp5 systemd[1]: Finished rp1-test.service - Check for RP1 displays for Xorg. Feb 21 14:15:43 volumiorp5 systemd[1]: iptables.service: Deactivated successfully. Feb 21 14:15:43 volumiorp5 dbus-daemon[910]: [system] Successfully activated service 'org.freedesktop.hostname1' Feb 21 14:15:43 volumiorp5 systemd[1]: Started systemd-hostnamed.service - Hostname Service. Feb 21 14:15:43 volumiorp5 kernel: Bluetooth: hci0: BCM: features 0x2f Feb 21 14:15:43 volumiorp5 kernel: Bluetooth: hci0: BCM43455 37.4MHz Raspberry Pi 3+-0190 Feb 21 14:15:43 volumiorp5 kernel: Bluetooth: hci0: BCM4345C0 (003.001.025) build 0382 Feb 21 14:15:43 volumiorp5 kernel: Bluetooth: hci0: BCM: Using default device address (43:45:c0:00:1f:ac) Feb 21 14:15:43 volumiorp5 systemd[1]: Started wpa_supplicant.service - WPA supplicant. Feb 21 14:15:43 volumiorp5 wpa_supplicant[1051]: Successfully initialized wpa_supplicant Feb 21 14:15:43 volumiorp5 haveged[886]: haveged: ver: 1.9.14; arch: generic; vend: ; build: (gcc 10.2.1 CTV); collect: 128K Feb 21 14:15:43 volumiorp5 haveged[886]: haveged: cpu: (VC); data: 64K (V); inst: 64K (V); idx: 39/40; sz: 63356/63356 Feb 21 14:15:43 volumiorp5 haveged[886]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.99925 Feb 21 14:15:43 volumiorp5 haveged[886]: haveged: fills: 0, generated: 0 Feb 21 14:15:43 volumiorp5 bluetoothd[909]: Battery Provider Manager created Feb 21 14:15:43 volumiorp5 kernel: Bluetooth: MGMT ver 1.23 Feb 21 14:15:43 volumiorp5 kernel: NET: Registered PF_ALG protocol family Feb 21 14:15:43 volumiorp5 volumio-remote-updater[928]: Volumio OTA Client: 1.7.0 Feb 21 14:15:43 volumiorp5 volumio-remote-updater[928]: Error: No active session Feb 21 14:15:43 volumiorp5 volumio-remote-updater[928]: [2026-02-21 14:15:43] [info] asio async_connect error: asio.system:111 (Connection refused) Feb 21 14:15:43 volumiorp5 volumio-remote-updater[928]: [2026-02-21 14:15:43] [info] Error getting remote endpoint: asio.system:107 (Transport endpoint is not connected) Feb 21 14:15:43 volumiorp5 volumio-remote-updater[928]: [2026-02-21 14:15:43] [error] handle_connect error: Connection refused Feb 21 14:15:43 volumiorp5 upmpdcli[927]: Could not open config: /tmp/upmpdcli.conf Feb 21 14:15:43 volumiorp5 systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Feb 21 14:15:43 volumiorp5 systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Feb 21 14:15:43 volumiorp5 bluetoothd[909]: profiles/audio/bap.c:bap_adapter_probe() BAP requires ISO Socket which is not enabled Feb 21 14:15:43 volumiorp5 bluetoothd[909]: bap: Operation not supported (95) Feb 21 14:15:43 volumiorp5 (udev-worker)[593]: pcmC5D0c: Process '/bin/bash -c '/usr/local/bin/volumio scanaudioinputs'' failed with exit code 7. Feb 21 14:15:43 volumiorp5 (udev-worker)[567]: pcmC5D0p: Process '/bin/bash -c '/usr/local/bin/volumio usbattach'' failed with exit code 7. Feb 21 14:15:43 volumiorp5 rpi-eeprom-update[915]: BOOTLOADER: up to date Feb 21 14:15:43 volumiorp5 systemd[1]: Finished ifupdown-pre.service - Helper to synchronize boot up for ifupdown. Feb 21 14:15:43 volumiorp5 rpi-eeprom-update[915]: CURRENT: Mon Dec 8 19:29:54 UTC 2025 (1765222194) Feb 21 14:15:43 volumiorp5 bluetoothd[909]: Adv Monitor Manager created with supported features:0x00000000, enabled features:0x00000000, max number of supported monitors:32, max number of supported patterns:16 Feb 21 14:15:43 volumiorp5 rpi-eeprom-update[915]: LATEST: Mon Dec 8 19:29:54 UTC 2025 (1765222194) Feb 21 14:15:43 volumiorp5 rpi-eeprom-update[915]: RELEASE: default (/usr/lib/firmware/raspberrypi/bootloader-2712/default) Feb 21 14:15:43 volumiorp5 rpi-eeprom-update[915]: Use raspi-config to change the release. Feb 21 14:15:43 volumiorp5 systemd[1]: Starting networking.service - Raise network interfaces... Feb 21 14:15:43 volumiorp5 systemd[1]: Finished rpi-eeprom-update.service - Check for Raspberry Pi EEPROM updates. Feb 21 14:15:44 volumiorp5 systemd[1]: Mounting run-rpc_pipefs.mount - RPC Pipe File System... Feb 21 14:15:44 volumiorp5 systemd[1]: Mounted run-rpc_pipefs.mount - RPC Pipe File System. Feb 21 14:15:44 volumiorp5 systemd[1]: Reached target rpc_pipefs.target. Feb 21 14:15:44 volumiorp5 systemd[1]: rpc-gssd.service - RPC security service for NFS client and server was skipped because of an unmet condition check (ConditionPathExists=/etc/krb5.keytab). Feb 21 14:15:44 volumiorp5 systemd[1]: Reached target nfs-client.target - NFS client services. Feb 21 14:15:44 volumiorp5 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Feb 21 14:15:44 volumiorp5 systemd[1]: Reached target remote-fs.target - Remote File Systems. Feb 21 14:15:44 volumiorp5 systemd[1]: Starting loadcpufreq.service - LSB: Load kernel modules needed to enable cpufreq scaling... Feb 21 14:15:44 volumiorp5 systemd[1]: systemd-pcrphase.service - TPM2 PCR Barrier (User) was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/StubPcrKernelImage-4a67b082-0a4c-41cf-b6c7-440b29bb8c4f). Feb 21 14:15:44 volumiorp5 bluealsa[1063]: ../src/storage.c:90: Initializing persistent storage: /var/lib/bluealsa Feb 21 14:15:44 volumiorp5 bluealsa[1063]: main.c:663: Starting main dispatching loop Feb 21 14:15:44 volumiorp5 bluealsa[1063]: main.c:118: Acquired D-Bus service name: org.bluealsa Feb 21 14:15:44 volumiorp5 bluealsa[1063]: bluealsa-dbus.c:358: Registering BlueALSA D-Bus manager: /org/bluealsa Feb 21 14:15:44 volumiorp5 bluealsa[1063]: bluez.c:153: Registering media application: /org/bluez/hci0 Feb 21 14:15:44 volumiorp5 bluealsa[1063]: bluez.c:743: Exporting media endpoint object: /org/bluez/hci0/A2DP/SBC/source/1 Feb 21 14:15:44 volumiorp5 bluealsa[1063]: bluez.c:743: Exporting media endpoint object: /org/bluez/hci0/A2DP/SBC/source/2 Feb 21 14:15:44 volumiorp5 bluealsa[1063]: bluez.c:743: Exporting media endpoint object: /org/bluez/hci0/A2DP/SBC/sink/1 Feb 21 14:15:44 volumiorp5 bluealsa[1063]: bluez.c:743: Exporting media endpoint object: /org/bluez/hci0/A2DP/SBC/sink/2 Feb 21 14:15:44 volumiorp5 dbus-daemon[910]: [system] Activating via systemd: service name='org.freedesktop.UPower' unit='upower.service' requested by ':1.6' (uid=0 pid=1063 comm="/usr/bin/bluealsa -S -p a2dp-source -p a2dp-sink") Feb 21 14:15:44 volumiorp5 systemd[1]: Started bluealsa.service - BlueALSA service. Feb 21 14:15:44 volumiorp5 systemd[1]: Finished networking.service - Raise network interfaces. Feb 21 14:15:44 volumiorp5 systemd[1]: Reached target bluetooth.target - Bluetooth Support. Feb 21 14:15:44 volumiorp5 systemd[1]: Reached target network.target - Network. Feb 21 14:15:44 volumiorp5 systemd[1]: Reached target network-online.target - Network is Online. Feb 21 14:15:44 volumiorp5 systemd[1]: Starting ifplugd.service - LSB: Brings up/down network automatically... Feb 21 14:15:44 volumiorp5 systemd[1]: Starting nmbd.service - Samba NMB Daemon... Feb 21 14:15:44 volumiorp5 systemd[1]: Starting ntpsec.service - Network Time Service... Feb 21 14:15:44 volumiorp5 systemd[1]: Starting rc-local.service - /etc/rc.local Compatibility... Feb 21 14:15:44 volumiorp5 systemd[1]: Starting rpc-statd-notify.service - Notify NFS peers of a restart... Feb 21 14:15:44 volumiorp5 systemd[1]: Starting samba-ad-dc.service - Samba AD Daemon... Feb 21 14:15:44 volumiorp5 sm-notify[1181]: Version 2.6.2 starting Feb 21 14:15:44 volumiorp5 systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Feb 21 14:15:44 volumiorp5 systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 21 14:15:44 volumiorp5 loadcpufreq[1131]: Loading cpufreq kernel modules...done (none). Feb 21 14:15:44 volumiorp5 ntpd[1193]: INIT: ntpd ntpsec-1.2.2: Starting Feb 21 14:15:44 volumiorp5 ntp-systemd-wrapper[1193]: 2026-02-21T14:15:44 ntpd[1193]: INIT: ntpd ntpsec-1.2.2: Starting Feb 21 14:15:44 volumiorp5 ntp-systemd-wrapper[1193]: 2026-02-21T14:15:44 ntpd[1193]: INIT: Command line: /usr/sbin/ntpd -p /run/ntpd.pid -c /etc/ntpsec/ntp.conf -g -N -u ntpsec:ntpsec Feb 21 14:15:44 volumiorp5 ntpd[1193]: INIT: Command line: /usr/sbin/ntpd -p /run/ntpd.pid -c /etc/ntpsec/ntp.conf -g -N -u ntpsec:ntpsec Feb 21 14:15:44 volumiorp5 systemd[1]: Starting ssh.service - OpenBSD Secure Shell server... Feb 21 14:15:44 volumiorp5 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Feb 21 14:15:44 volumiorp5 ntpd[1221]: INIT: precision = 0.370 usec (-21) Feb 21 14:15:44 volumiorp5 systemd[1]: Starting upower.service - Daemon for power management... Feb 21 14:15:44 volumiorp5 ntpd[1221]: INIT: successfully locked into RAM Feb 21 14:15:44 volumiorp5 systemd[1]: Started volumio-ipchange.service - Volumio IP Change Monitor. Feb 21 14:15:44 volumiorp5 systemd[1]: Starting welcome.service - Show a welcome message on console... Feb 21 14:15:44 volumiorp5 ntpd[1221]: CONFIG: readconfig: parsing file: /etc/ntpsec/ntp.conf Feb 21 14:15:44 volumiorp5 systemd[1]: Started loadcpufreq.service - LSB: Load kernel modules needed to enable cpufreq scaling. Feb 21 14:15:44 volumiorp5 ntpd[1221]: CONFIG: restrict nopeer ignored Feb 21 14:15:44 volumiorp5 systemd[1]: Started ntpsec.service - Network Time Service. Feb 21 14:15:44 volumiorp5 systemd[1]: Started rc-local.service - /etc/rc.local Compatibility. Feb 21 14:15:44 volumiorp5 systemd[1]: Started rpc-statd-notify.service - Notify NFS peers of a restart. Feb 21 14:15:44 volumiorp5 ntpd[1221]: CLOCK: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Feb 21 14:15:44 volumiorp5 ntpd[1221]: CLOCK: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2026-06-28T00:00Z last=2017-01-01T00:00Z ofs=37 Feb 21 14:15:44 volumiorp5 ntpd[1221]: INIT: Using SO_TIMESTAMPNS(ns) Feb 21 14:15:44 volumiorp5 ntpd[1221]: IO: Listen and drop on 0 v6wildcard [::]:123 Feb 21 14:15:44 volumiorp5 ntpd[1221]: IO: Listen and drop on 1 v4wildcard 0.0.0.0:123 Feb 21 14:15:44 volumiorp5 ntpd[1221]: IO: Listen normally on 2 lo 127.0.0.1:123 Feb 21 14:15:44 volumiorp5 ntpd[1221]: IO: Listening on routing socket on fd #19 for interface updates Feb 21 14:15:44 volumiorp5 welcome[1228]: Resolved ip:[0] Feb 21 14:15:44 volumiorp5 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Feb 21 14:15:44 volumiorp5 systemd[1]: Starting cpufrequtils.service - LSB: set CPUFreq kernel parameters... Feb 21 14:15:44 volumiorp5 systemd[1]: Starting plymouth-quit-wait.service - Hold until boot process finishes up... Feb 21 14:15:44 volumiorp5 ntpd[1221]: INIT: This system has a 32-bit time_t. Feb 21 14:15:44 volumiorp5 ntpd[1221]: INIT: This ntpd will fail on 2038-01-19T03:14:07Z. Feb 21 14:15:44 volumiorp5 ntpd[1221]: INIT: MRU 13107 entries, 13 hash bits, 32768 bytes Feb 21 14:15:44 volumiorp5 ntpd[1221]: INIT: Built with OpenSSL 3.0.9 30 May 2023, 30000090 Feb 21 14:15:44 volumiorp5 ntpd[1221]: INIT: Running with OpenSSL 3.0.18 30 Sep 2025, 30000120 Feb 21 14:15:44 volumiorp5 ntpd[1221]: NTSc: Using system default root certificates. Feb 21 14:15:44 volumiorp5 ifplugd(eth0)[1257]: ifplugd 0.28 initializing. Feb 21 14:15:44 volumiorp5 ifplugd(eth0)[1257]: Using interface eth0/2C:CF:67:C3:39:7B with driver (version: 6.12.47-v8+) Feb 21 14:15:44 volumiorp5 ifplugd(eth0)[1257]: Using detection mode: SIOCETHTOOL Feb 21 14:15:44 volumiorp5 ifplugd(eth0)[1257]: Initialization complete, link beat not detected. Feb 21 14:15:44 volumiorp5 dbus-daemon[910]: [system] Successfully activated service 'org.freedesktop.UPower' Feb 21 14:15:44 volumiorp5 systemd[1]: Started upower.service - Daemon for power management. Feb 21 14:15:44 volumiorp5 avahi-daemon[908]: Server startup complete. Host name is volumiorp5.local. Local service cookie is 3135373146. Feb 21 14:15:44 volumiorp5 bluetoothd[909]: Endpoint registered: sender=:1.6 path=/org/bluez/hci0/A2DP/SBC/source/1 Feb 21 14:15:44 volumiorp5 bluetoothd[909]: Endpoint registered: sender=:1.6 path=/org/bluez/hci0/A2DP/SBC/sink/2 Feb 21 14:15:44 volumiorp5 bluetoothd[909]: Endpoint registered: sender=:1.6 path=/org/bluez/hci0/A2DP/SBC/source/2 Feb 21 14:15:44 volumiorp5 bluetoothd[909]: Endpoint registered: sender=:1.6 path=/org/bluez/hci0/A2DP/SBC/sink/1 Feb 21 14:15:44 volumiorp5 ntpd[1221]: statistics directory /var/log/ntpsec/ does not exist or is unwriteable, error No such file or directory Feb 21 14:15:44 volumiorp5 cpufrequtils[1237]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Feb 21 14:15:44 volumiorp5 systemd[1]: Started cpufrequtils.service - LSB: set CPUFreq kernel parameters. Feb 21 14:15:44 volumiorp5 sshd[1264]: Server listening on 0.0.0.0 port 22. Feb 21 14:15:44 volumiorp5 sshd[1264]: Server listening on :: port 22. Feb 21 14:15:44 volumiorp5 systemd[1]: Started ssh.service - OpenBSD Secure Shell server. Feb 21 14:15:44 volumiorp5 systemd[1]: Finished welcome.service - Show a welcome message on console. Feb 21 14:15:44 volumiorp5 ifplugd[1175]: Network Interface Plugging Daemon...start eth0...done. Feb 21 14:15:44 volumiorp5 systemd[1]: Started ifplugd.service - LSB: Brings up/down network automatically. Feb 21 14:15:44 volumiorp5 systemd[1]: samba-ad-dc.service: Skipped due to 'exec-condition'. Feb 21 14:15:44 volumiorp5 systemd[1]: Condition check resulted in samba-ad-dc.service - Samba AD Daemon being skipped. Feb 21 14:15:44 volumiorp5 wireless.js[930]: WIRELESS.JS - INFO: Single Network Mode enabled (default) - only one network device can be active at a time between ethernet and wireless Feb 21 14:15:44 volumiorp5 wireless.js[930]: WIRELESS.JS - INFO: Wireless.js initializing wireless flow Feb 21 14:15:44 volumiorp5 nmbd[1296]: [2026/02/21 14:15:44.952816, 0] ../../source3/nmbd/nmbd.c:901(main) Feb 21 14:15:44 volumiorp5 nmbd[1296]: nmbd version 4.17.8-Raspbian started. Feb 21 14:15:44 volumiorp5 nmbd[1296]: Copyright Andrew Tridgell and the Samba Team 1992-2022 Feb 21 14:15:44 volumiorp5 nmbd[1296]: [2026/02/21 14:15:44.959527, 0] ../../source3/nmbd/asyncdns.c:158(start_async_dns) Feb 21 14:15:44 volumiorp5 nmbd[1296]: started asyncdns process 1306 Feb 21 14:15:44 volumiorp5 nmbd[1296]: [2026/02/21 14:15:44.959919, 0] ../../lib/util/become_daemon.c:150(daemon_status) Feb 21 14:15:44 volumiorp5 nmbd[1296]: daemon_status: daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Feb 21 14:15:44 volumiorp5 nmbd[1296]: [2026/02/21 14:15:44.959941, 0] ../../source3/nmbd/nmbd_subnetdb.c:252(create_subnets) Feb 21 14:15:44 volumiorp5 nmbd[1296]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Feb 21 14:15:45 volumiorp5 sudo[1305]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Feb 21 14:15:45 volumiorp5 sudo[1305]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 21 14:15:45 volumiorp5 sudo[1305]: pam_unix(sudo:session): session closed for user root Feb 21 14:15:45 volumiorp5 sudo[1309]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Feb 21 14:15:45 volumiorp5 sudo[1309]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 21 14:15:45 volumiorp5 avahi-daemon[908]: Service "VolumioRP5" (/services/volumio.service) successfully established. Feb 21 14:15:45 volumiorp5 ntpd[1221]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101 Feb 21 14:15:45 volumiorp5 ntpd[1221]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101 Feb 21 14:15:45 volumiorp5 ntpd[1221]: DNS: dns_check: DNS error: -11, System error Feb 21 14:15:45 volumiorp5 ntpd[1221]: DNS: dns_take_status: 0.debian.pool.ntp.org=>error, 12 Feb 21 14:15:45 volumiorp5 sudo[1309]: pam_unix(sudo:session): session closed for user root Feb 21 14:15:45 volumiorp5 wireless.js[930]: WIRELESS.JS - INFO: Cleaning previous... Feb 21 14:15:45 volumiorp5 sudo[1317]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Feb 21 14:15:45 volumiorp5 sudo[1317]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 21 14:15:45 volumiorp5 sudo[1317]: pam_unix(sudo:session): session closed for user root Feb 21 14:15:45 volumiorp5 kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Feb 21 14:15:45 volumiorp5 wireless.js[930]: WIRELESS.JS - INFO: InterfaceValidator: READY - wlan0 is ready for operations Feb 21 14:15:45 volumiorp5 wireless.js[930]: WIRELESS.JS - INFO: InterfaceValidator: wlan0 became ready after 0ms Feb 21 14:15:45 volumiorp5 wireless.js[930]: WIRELESS.JS - INFO: ensureInterfaceReady: Interface ready (MAC: 2c:cf:67:c3:39:7c) Feb 21 14:15:45 volumiorp5 sudo[1324]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Feb 21 14:15:45 volumiorp5 sudo[1324]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 14:15:45 volumiorp5 sudo[1324]: pam_unix(sudo:session): session closed for user root Feb 21 14:15:45 volumiorp5 sudo[1332]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Feb 21 14:15:45 volumiorp5 sudo[1332]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 14:15:46 volumiorp5 ntpd[1221]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101 Feb 21 14:15:46 volumiorp5 ntpd[1221]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101 Feb 21 14:15:46 volumiorp5 ntpd[1221]: DNS: dns_check: DNS error: -11, System error Feb 21 14:15:46 volumiorp5 ntpd[1221]: DNS: dns_take_status: 1.debian.pool.ntp.org=>error, 12 Feb 21 14:15:47 volumiorp5 ntpd[1221]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101 Feb 21 14:15:47 volumiorp5 ntpd[1221]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101 Feb 21 14:15:47 volumiorp5 ntpd[1221]: DNS: dns_check: DNS error: -11, System error Feb 21 14:15:47 volumiorp5 ntpd[1221]: DNS: dns_take_status: 2.debian.pool.ntp.org=>error, 12 Feb 21 14:15:47 volumiorp5 dhcpcd[902]: eth0: carrier acquired Feb 21 14:15:47 volumiorp5 sh[898]: eth0: carrier acquired Feb 21 14:15:47 volumiorp5 dhcpcd[1013]: eth0: carrier acquired Feb 21 14:15:47 volumiorp5 kernel: macb 1f00100000.ethernet eth0: Link is Up - 1Gbps/Full - flow control off Feb 21 14:15:47 volumiorp5 dhcpcd[1013]: eth0: IAID 67:c3:39:7b Feb 21 14:15:47 volumiorp5 dhcpcd[902]: eth0: IAID 67:c3:39:7b Feb 21 14:15:47 volumiorp5 sh[898]: eth0: IAID 67:c3:39:7b Feb 21 14:15:47 volumiorp5 dhcpcd[1013]: eth0: adding address fe80::b14b:725c:cb1a:88ca Feb 21 14:15:47 volumiorp5 dhcpcd[902]: eth0: adding address fe80::b14b:725c:cb1a:88ca Feb 21 14:15:47 volumiorp5 sh[898]: eth0: adding address fe80::b14b:725c:cb1a:88ca Feb 21 14:15:47 volumiorp5 dhcpcd[1013]: ipv6_addaddr1: Permission denied Feb 21 14:15:47 volumiorp5 dhcpcd[902]: ipv6_addaddr1: Permission denied Feb 21 14:15:47 volumiorp5 sh[898]: ipv6_addaddr1: Permission denied Feb 21 14:15:47 volumiorp5 dhcpcd[1013]: eth0: soliciting an IPv6 router Feb 21 14:15:47 volumiorp5 ifplugd(eth0)[1257]: Link beat detected. Feb 21 14:15:47 volumiorp5 dhcpcd[1013]: eth0: soliciting a DHCP lease Feb 21 14:15:47 volumiorp5 ifplugd(eth0)[1257]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Feb 21 14:15:47 volumiorp5 ifplugd(eth0)[1257]: client: ifup: waiting for lock on /run/network/ifstate.eth0 Feb 21 14:15:47 volumiorp5 sh[898]: eth0: soliciting a DHCP lease Feb 21 14:15:47 volumiorp5 dhcpcd[902]: eth0: soliciting a DHCP lease Feb 21 14:15:47 volumiorp5 dhcpcd[1013]: eth0: offered 192.168.9.131 from 192.168.9.1 Feb 21 14:15:47 volumiorp5 dhcpcd[902]: eth0: offered 192.168.9.131 from 192.168.9.1 Feb 21 14:15:47 volumiorp5 sh[898]: eth0: offered 192.168.9.131 from 192.168.9.1 Feb 21 14:15:47 volumiorp5 dhcpcd[1013]: eth0: probing address 192.168.9.131/24 Feb 21 14:15:47 volumiorp5 sh[898]: eth0: probing address 192.168.9.131/24 Feb 21 14:15:47 volumiorp5 dhcpcd[902]: eth0: probing address 192.168.9.131/24 Feb 21 14:15:47 volumiorp5 systemd[1]: systemd-rfkill.service: Deactivated successfully. Feb 21 14:15:48 volumiorp5 dhcpcd[902]: eth0: soliciting an IPv6 router Feb 21 14:15:48 volumiorp5 sh[898]: eth0: soliciting an IPv6 router Feb 21 14:15:48 volumiorp5 ntpd[1221]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101 Feb 21 14:15:48 volumiorp5 ntpd[1221]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101 Feb 21 14:15:48 volumiorp5 ntpd[1221]: DNS: dns_check: DNS error: -11, System error Feb 21 14:15:48 volumiorp5 ntpd[1221]: DNS: dns_take_status: 3.debian.pool.ntp.org=>error, 12 Feb 21 14:15:48 volumiorp5 sudo[1332]: pam_unix(sudo:session): session closed for user root Feb 21 14:15:48 volumiorp5 wireless.js[930]: WIRELESS.JS - INFO: SETTING APPROPRIATE REG DOMAIN: DE Feb 21 14:15:48 volumiorp5 sudo[1372]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set DE Feb 21 14:15:48 volumiorp5 sudo[1372]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 14:15:48 volumiorp5 sudo[1372]: pam_unix(sudo:session): session closed for user root Feb 21 14:15:48 volumiorp5 wireless.js[930]: WIRELESS.JS - INFO: SUCCESSFULLY SET NEW REGDOMAIN: DE Feb 21 14:15:48 volumiorp5 wireless.js[930]: WIRELESS.JS - INFO: refreshEthernetState: Corrected ethernet state: connected Feb 21 14:15:48 volumiorp5 wireless.js[930]: WIRELESS.JS - INFO: Single Network Mode: Ethernet active, maintaining WiFi scan capability Feb 21 14:15:48 volumiorp5 wireless.js[930]: WIRELESS.JS - INFO: SNM: Maintaining wlan0 UP without IP (scan mode) Feb 21 14:15:48 volumiorp5 wireless.js[930]: WIRELESS.JS - INFO: SNM: Users can configure WiFi via WebUI while ethernet is active Feb 21 14:15:48 volumiorp5 sudo[1381]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Feb 21 14:15:48 volumiorp5 sudo[1381]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 21 14:15:48 volumiorp5 sudo[1381]: pam_unix(sudo:session): session closed for user root Feb 21 14:15:48 volumiorp5 sudo[1384]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Feb 21 14:15:48 volumiorp5 sudo[1384]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 21 14:15:48 volumiorp5 sudo[1384]: pam_unix(sudo:session): session closed for user root Feb 21 14:15:48 volumiorp5 wpa_supplicant[1387]: Successfully initialized wpa_supplicant Feb 21 14:15:48 volumiorp5 wpa_supplicant[1387]: nl80211: kernel reports: Registration to specific type not supported Feb 21 14:15:48 volumiorp5 wpa_supplicant[1390]: wlan0: CTRL-EVENT-DSCP-POLICY clear_all Feb 21 14:15:48 volumiorp5 wireless.js[930]: WIRELESS.JS - INFO: SNM: wlan0 is UP without IP, scan capable Feb 21 14:15:48 volumiorp5 wireless.js[930]: WIRELESS.JS - INFO: Notified systemd about wireless ready Feb 21 14:15:48 volumiorp5 systemd[1]: Started wireless.service - Wireless Services. Feb 21 14:15:48 volumiorp5 kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Feb 21 14:15:48 volumiorp5 systemd[1]: Started volumio.service - Volumio Backend Module. Feb 21 14:15:48 volumiorp5 systemd[1]: Starting plymouth-quit.service - Terminate Plymouth Boot Screen... Feb 21 14:15:48 volumiorp5 systemd[1]: Started volumio_cpu_tweak.service - Volumio Cpu Tweaker. Feb 21 14:15:48 volumiorp5 systemd[1]: Received SIGRTMIN+21 from PID 408 (plymouthd). Feb 21 14:15:48 volumiorp5 volumio-cpu-tweak[1410]: Setting RT Priority for mpd Feb 21 14:15:48 volumiorp5 volumio-cpu-tweak[1424]: pid 35's current scheduling policy: SCHED_OTHER Feb 21 14:15:48 volumiorp5 volumio-cpu-tweak[1424]: pid 35's current scheduling priority: 0 Feb 21 14:15:48 volumiorp5 volumio-cpu-tweak[1410]: Setting MPD Affinity Feb 21 14:15:48 volumiorp5 volumio-cpu-tweak[1425]: pid 3's current affinity mask: f Feb 21 14:15:48 volumiorp5 volumio-cpu-tweak[1410]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Feb 21 14:15:48 volumiorp5 volumio-cpu-tweak[1410]: VOLUMIO CPU TWEAK: Setting CPU Governor: conservative Feb 21 14:15:48 volumiorp5 systemd[1]: volumio_cpu_tweak.service: Deactivated successfully. Feb 21 14:15:48 volumiorp5 systemd[1]: Received SIGRTMIN+21 from PID 408 (plymouthd). Feb 21 14:15:48 volumiorp5 systemd[1]: Finished plymouth-quit.service - Terminate Plymouth Boot Screen. Feb 21 14:15:48 volumiorp5 systemd[1]: Finished plymouth-quit-wait.service - Hold until boot process finishes up. Feb 21 14:15:48 volumiorp5 systemd[1]: Started serial-getty@ttyAMA10.service - Serial Getty on ttyAMA10. Feb 21 14:15:48 volumiorp5 systemd[1]: Reached target getty.target - Login Prompts. Feb 21 14:15:48 volumiorp5 volumio-remote-updater[928]: [2026-02-21 14:15:48] [info] asio async_connect error: asio.system:111 (Connection refused) Feb 21 14:15:48 volumiorp5 volumio-remote-updater[928]: [2026-02-21 14:15:48] [info] Error getting remote endpoint: asio.system:107 (Transport endpoint is not connected) Feb 21 14:15:48 volumiorp5 volumio-remote-updater[928]: [2026-02-21 14:15:48] [error] handle_connect error: Connection refused Feb 21 14:15:49 volumiorp5 volumio[1408]: info: ------------------------------------------- Feb 21 14:15:49 volumiorp5 volumio[1408]: info: ----- Volumio3 ---- Feb 21 14:15:49 volumiorp5 volumio[1408]: info: ------------------------------------------- Feb 21 14:15:49 volumiorp5 volumio[1408]: info: ----- System startup ---- Feb 21 14:15:49 volumiorp5 volumio[1408]: info: ------------------------------------------- Feb 21 14:15:49 volumiorp5 wireless.js[930]: WIRELESS.JS - INFO: === SNM TRANSITION === Feb 21 14:15:49 volumiorp5 wireless.js[930]: WIRELESS.JS - INFO: Previous ethernet state: disconnected Feb 21 14:15:49 volumiorp5 wireless.js[930]: WIRELESS.JS - INFO: New ethernet state: connected Feb 21 14:15:49 volumiorp5 wireless.js[930]: WIRELESS.JS - INFO: Single Network Mode: enabled Feb 21 14:15:49 volumiorp5 wireless.js[930]: WIRELESS.JS - INFO: First start: no Feb 21 14:15:49 volumiorp5 wireless.js[930]: WIRELESS.JS - INFO: Action: Switch to ethernet (WiFi scan mode) Feb 21 14:15:49 volumiorp5 wireless.js[930]: WIRELESS.JS - INFO: === END TRANSITION === Feb 21 14:15:49 volumiorp5 wireless.js[930]: WIRELESS.JS - INFO: SNM: Ethernet connected, switching to ethernet (WiFi scan mode) Feb 21 14:15:49 volumiorp5 sudo[1444]: root : PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd -k wlan0 Feb 21 14:15:49 volumiorp5 sudo[1444]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 21 14:15:49 volumiorp5 dhcpcd[1445]: dhcpcd not running Feb 21 14:15:49 volumiorp5 sudo[1444]: pam_unix(sudo:session): session closed for user root Feb 21 14:15:49 volumiorp5 wireless.js[930]: dhcpcd not running Feb 21 14:15:49 volumiorp5 wireless.js[930]: WIRELESS.JS - INFO: Wireless.js initializing wireless flow Feb 21 14:15:49 volumiorp5 wpa_supplicant[1390]: p2p-dev-wlan0: CTRL-EVENT-DSCP-POLICY clear_all Feb 21 14:15:49 volumiorp5 wpa_supplicant[1390]: p2p-dev-wlan0: CTRL-EVENT-DSCP-POLICY clear_all Feb 21 14:15:49 volumiorp5 wpa_supplicant[1390]: nl80211: deinit ifname=p2p-dev-wlan0 disabled_11b_rates=0 Feb 21 14:15:49 volumiorp5 sudo[1453]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Feb 21 14:15:49 volumiorp5 sudo[1453]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 21 14:15:49 volumiorp5 sudo[1453]: pam_unix(sudo:session): session closed for user root Feb 21 14:15:49 volumiorp5 sudo[1455]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Feb 21 14:15:49 volumiorp5 sudo[1455]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 21 14:15:49 volumiorp5 volumio[1408]: info: MYVOLUMIO Environment detected Feb 21 14:15:49 volumiorp5 volumio[1408]: info: Plugin folders cleanup Feb 21 14:15:49 volumiorp5 volumio[1408]: info: Scanning into folder /volumio/app/plugins/ Feb 21 14:15:49 volumiorp5 volumio[1408]: info: Scanning category audio_interface Feb 21 14:15:49 volumiorp5 volumio[1408]: info: Scanning category miscellanea Feb 21 14:15:49 volumiorp5 volumio[1408]: info: Scanning category music_service Feb 21 14:15:49 volumiorp5 volumio[1408]: info: Scanning category plugins.json Feb 21 14:15:49 volumiorp5 volumio[1408]: info: Scanning category system_controller Feb 21 14:15:49 volumiorp5 volumio[1408]: info: Scanning category user_interface Feb 21 14:15:49 volumiorp5 volumio[1408]: info: Scanning into folder /data/plugins/ Feb 21 14:15:49 volumiorp5 volumio[1408]: info: Scanning category music_service Feb 21 14:15:49 volumiorp5 volumio[1408]: info: Scanning category system_controller Feb 21 14:15:49 volumiorp5 volumio[1408]: info: Scanning category system_hardware Feb 21 14:15:49 volumiorp5 volumio[1408]: info: Scanning category user_interface Feb 21 14:15:49 volumiorp5 volumio[1408]: info: Plugin folders cleanup completed Feb 21 14:15:49 volumiorp5 volumio[1408]: info: ------------------------------------------- Feb 21 14:15:49 volumiorp5 volumio[1408]: info: ----- Core plugins startup ---- Feb 21 14:15:49 volumiorp5 volumio[1408]: info: ------------------------------------------- Feb 21 14:15:49 volumiorp5 volumio[1408]: info: Loading plugins from folder /volumio/app/plugins/ Feb 21 14:15:49 volumiorp5 volumio[1408]: info: Adding plugin upnp to MyMusic Plugins Feb 21 14:15:49 volumiorp5 volumio[1408]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 21 14:15:49 volumiorp5 volumio[1408]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 21 14:15:49 volumiorp5 volumio[1408]: info: Loading plugins from folder /data/plugins/ Feb 21 14:15:49 volumiorp5 volumio[1408]: info: Loading plugin "system"... Feb 21 14:15:49 volumiorp5 volumio[1408]: info: Loading plugin "appearance"... Feb 21 14:15:50 volumiorp5 volumio[1408]: info: Loading plugin "network"... Feb 21 14:15:50 volumiorp5 volumio[1408]: info: Refreshing Cached IP Addresses Feb 21 14:15:50 volumiorp5 volumio[1408]: info: Loading plugin "services"... Feb 21 14:15:50 volumiorp5 volumio[1408]: info: Loading plugin "alsa_controller"... Feb 21 14:15:50 volumiorp5 sudo[1455]: pam_unix(sudo:session): session closed for user root Feb 21 14:15:50 volumiorp5 wireless.js[930]: WIRELESS.JS - INFO: Cleaning previous... Feb 21 14:15:50 volumiorp5 sudo[1466]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 21 14:15:50 volumiorp5 wpa_supplicant[1390]: p2p-dev-wlan0: CTRL-EVENT-TERMINATING Feb 21 14:15:50 volumiorp5 sudo[1466]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 14:15:50 volumiorp5 wpa_supplicant[1390]: wlan0: CTRL-EVENT-DSCP-POLICY clear_all Feb 21 14:15:50 volumiorp5 sudo[1464]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 21 14:15:50 volumiorp5 sudo[1466]: pam_unix(sudo:session): session closed for user root Feb 21 14:15:50 volumiorp5 sudo[1464]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 14:15:50 volumiorp5 sudo[1477]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 21 14:15:50 volumiorp5 sudo[1464]: pam_unix(sudo:session): session closed for user root Feb 21 14:15:50 volumiorp5 sudo[1486]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Feb 21 14:15:50 volumiorp5 sudo[1486]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 21 14:15:50 volumiorp5 sudo[1477]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 14:15:50 volumiorp5 bash[1195]: setdatetime-helper: all HTTPS Date fallbacks failed Feb 21 14:15:50 volumiorp5 systemd[1]: setdatetime-helper.service: Deactivated successfully. Feb 21 14:15:50 volumiorp5 systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Feb 21 14:15:50 volumiorp5 sudo[1486]: pam_unix(sudo:session): session closed for user root Feb 21 14:15:50 volumiorp5 kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Feb 21 14:15:50 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 21 14:15:50 volumiorp5 volumio[1408]: info: Loading plugin "wizard"... Feb 21 14:15:50 volumiorp5 wireless.js[930]: WIRELESS.JS - INFO: InterfaceValidator: READY - wlan0 is ready for operations Feb 21 14:15:50 volumiorp5 wireless.js[930]: WIRELESS.JS - INFO: InterfaceValidator: wlan0 became ready after 1ms Feb 21 14:15:50 volumiorp5 wireless.js[930]: WIRELESS.JS - INFO: ensureInterfaceReady: Interface ready (MAC: 2c:cf:67:c3:39:7c) Feb 21 14:15:50 volumiorp5 volumio[1408]: info: Loading plugin "networkfs"... Feb 21 14:15:50 volumiorp5 sudo[1507]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Feb 21 14:15:50 volumiorp5 sudo[1507]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 14:15:50 volumiorp5 sudo[1507]: pam_unix(sudo:session): session closed for user root Feb 21 14:15:50 volumiorp5 volumio[1408]: info: Starting Udev Watcher for removable devices Feb 21 14:15:50 volumiorp5 sudo[1519]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=volumio,password=TsmYk&35,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.9.106/music\\ /mnt/NAS/music Feb 21 14:15:50 volumiorp5 sudo[1519]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 14:15:50 volumiorp5 sudo[1516]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Feb 21 14:15:50 volumiorp5 sudo[1516]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 14:15:50 volumiorp5 sudo[1516]: pam_unix(sudo:session): session closed for user root Feb 21 14:15:50 volumiorp5 volumio[1408]: info: Ignoring mount for partition: boot Feb 21 14:15:50 volumiorp5 volumio[1408]: info: Ignoring mount for partition: volumio Feb 21 14:15:50 volumiorp5 wireless.js[930]: command failed: Device or resource busy (-16) Feb 21 14:15:50 volumiorp5 wireless.js[930]: WIRELESS.JS - INFO: Single Network Mode: Ethernet active, maintaining WiFi scan capability Feb 21 14:15:50 volumiorp5 wireless.js[930]: WIRELESS.JS - INFO: SNM: Maintaining wlan0 UP without IP (scan mode) Feb 21 14:15:50 volumiorp5 wireless.js[930]: WIRELESS.JS - INFO: SNM: Users can configure WiFi via WebUI while ethernet is active Feb 21 14:15:50 volumiorp5 volumio[1408]: info: Ignoring mount for partition: volumio_data Feb 21 14:15:50 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 21 14:15:50 volumiorp5 volumio[1408]: info: Loading plugin "pi_screen_setup"... Feb 21 14:15:50 volumiorp5 wpa_supplicant[1390]: wlan0: CTRL-EVENT-DSCP-POLICY clear_all Feb 21 14:15:50 volumiorp5 wpa_supplicant[1390]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Feb 21 14:15:50 volumiorp5 kernel: netfs: FS-Cache loaded Feb 21 14:15:50 volumiorp5 wpa_supplicant[1390]: wlan0: CTRL-EVENT-TERMINATING Feb 21 14:15:50 volumiorp5 sudo[1532]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Feb 21 14:15:50 volumiorp5 sudo[1532]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 21 14:15:50 volumiorp5 sudo[1532]: pam_unix(sudo:session): session closed for user root Feb 21 14:15:50 volumiorp5 sudo[1535]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Feb 21 14:15:50 volumiorp5 sudo[1535]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 21 14:15:50 volumiorp5 sudo[1535]: pam_unix(sudo:session): session closed for user root Feb 21 14:15:50 volumiorp5 kernel: Key type cifs.spnego registered Feb 21 14:15:50 volumiorp5 kernel: Key type cifs.idmap registered Feb 21 14:15:50 volumiorp5 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 14:15:50 volumiorp5 kernel: CIFS: Attempting to mount //192.168.9.106/music Feb 21 14:15:50 volumiorp5 kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Feb 21 14:15:50 volumiorp5 kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Feb 21 14:15:50 volumiorp5 sudo[1519]: pam_unix(sudo:session): session closed for user root Feb 21 14:15:50 volumiorp5 wpa_supplicant[1547]: Successfully initialized wpa_supplicant Feb 21 14:15:50 volumiorp5 wpa_supplicant[1547]: nl80211: kernel reports: Registration to specific type not supported Feb 21 14:15:50 volumiorp5 wpa_supplicant[1550]: wlan0: CTRL-EVENT-DSCP-POLICY clear_all Feb 21 14:15:50 volumiorp5 wireless.js[930]: WIRELESS.JS - INFO: SNM: Transition to scan mode completed in 851ms Feb 21 14:15:50 volumiorp5 wireless.js[930]: WIRELESS.JS - INFO: SNM: wlan0 is UP without IP, scan capable Feb 21 14:15:50 volumiorp5 wpa_supplicant[1550]: wlan0: CTRL-EVENT-SCAN-FAILED ret=-16 Feb 21 14:15:50 volumiorp5 wireless.js[930]: WIRELESS.JS - INFO: Notified systemd about wireless ready Feb 21 14:15:50 volumiorp5 volumio[1408]: info: Loading plugin "volumio_command_line_client"... Feb 21 14:15:50 volumiorp5 volumio[1408]: info: Loading plugin "upnp"... Feb 21 14:15:50 volumiorp5 volumio[1408]: info: [1771679750418] Starting Upmpd Daemon Feb 21 14:15:50 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 21 14:15:50 volumiorp5 volumio[1408]: info: Loading plugin "my_music"... Feb 21 14:15:50 volumiorp5 volumio[1408]: info: Loading plugin "mpd"... Feb 21 14:15:50 volumiorp5 volumio[1408]: info: Loading plugin "upnp_browser"... Feb 21 14:15:50 volumiorp5 volumio[1408]: info: Starting UPNP Browser Feb 21 14:15:50 volumiorp5 volumio[1408]: info: Loading plugin "alarm-clock"... Feb 21 14:15:50 volumiorp5 volumio[1408]: info: Plugin airplay_emulation is not enabled Feb 21 14:15:50 volumiorp5 volumio[1408]: info: Loading plugin "last_100"... Feb 21 14:15:50 volumiorp5 volumio[1408]: info: Loading plugin "webradio"... Feb 21 14:15:50 volumiorp5 volumio[1408]: info: Loading plugin "i2s_dacs"... Feb 21 14:15:50 volumiorp5 volumio[1408]: info: I2S DAC not set, start Auto-detection Feb 21 14:15:50 volumiorp5 volumio[1408]: info: Loading plugin "volumiodiscovery"... Feb 21 14:15:50 volumiorp5 volumio[1408]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 21 14:15:50 volumiorp5 volumio[1408]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 21 14:15:50 volumiorp5 volumio[1408]: *** WARNING *** For more information see Feb 21 14:15:50 volumiorp5 volumio[1408]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 21 14:15:50 volumiorp5 node[1408]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 21 14:15:50 volumiorp5 volumio[1408]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 21 14:15:50 volumiorp5 volumio[1408]: *** WARNING *** For more information see Feb 21 14:15:50 volumiorp5 node[1408]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 21 14:15:50 volumiorp5 node[1408]: *** WARNING *** For more information see Feb 21 14:15:50 volumiorp5 node[1408]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 21 14:15:50 volumiorp5 node[1408]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 21 14:15:50 volumiorp5 node[1408]: *** WARNING *** For more information see Feb 21 14:15:50 volumiorp5 volumio[1408]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 21 14:15:50 volumiorp5 volumio[1408]: info: Discovery: Started advertising with name: VolumioRP5 Feb 21 14:15:50 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 21 14:15:50 volumiorp5 volumio[1408]: info: Loading plugin "spop"... Feb 21 14:15:51 volumiorp5 volumio[1408]: info: Loading plugin "squeezelite_mc"... Feb 21 14:15:51 volumiorp5 volumio[1408]: info: Plugin now_playing is not enabled Feb 21 14:15:51 volumiorp5 volumio[1408]: info: Loading plugin "outputs"... Feb 21 14:15:51 volumiorp5 volumio[1408]: info: Loading plugin "albumart"... Feb 21 14:15:51 volumiorp5 volumio[1408]: info: Plugin example_plugin is not enabled Feb 21 14:15:51 volumiorp5 volumio[1408]: info: Loading plugin "inputs"... Feb 21 14:15:51 volumiorp5 volumio[1408]: info: Loading plugin "updater_comm"... Feb 21 14:15:51 volumiorp5 volumio[1408]: info: Plugin mpdemulation is not enabled Feb 21 14:15:51 volumiorp5 volumio[1408]: info: Loading plugin "rest_api"... Feb 21 14:15:51 volumiorp5 volumio[1408]: info: Loading plugin "websocket"... Feb 21 14:15:51 volumiorp5 volumio[1408]: info: Starting Socket.io Server version 1.7.4 Feb 21 14:15:51 volumiorp5 volumio[1408]: info: Loading plugin "backup_restore"... Feb 21 14:15:51 volumiorp5 volumio[1568]: Forking 3 albumart workers Feb 21 14:15:51 volumiorp5 volumio[1408]: info: Applying required configuration parameters for plugin backup_restore Feb 21 14:15:51 volumiorp5 volumio[1408]: info: Loading plugin "peppymeterbasic"... Feb 21 14:15:52 volumiorp5 volumio[1408]: info: Plugin peppyspectrum is not enabled Feb 21 14:15:52 volumiorp5 volumio[1408]: info: Loading plugin "touch_display"... Feb 21 14:15:52 volumiorp5 volumio[1579]: Starting albumart workers Feb 21 14:15:52 volumiorp5 volumio[1578]: Starting albumart workers Feb 21 14:15:52 volumiorp5 volumio[1580]: Starting albumart workers Feb 21 14:15:52 volumiorp5 volumio[1408]: info: Applying required configuration parameters for plugin touch_display Feb 21 14:15:52 volumiorp5 volumio[1408]: info: Loading i18n strings for locale pl Feb 21 14:15:52 volumiorp5 volumio[1408]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Feb 21 14:15:52 volumiorp5 volumio[1408]: Updating browse sources language Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::initPlayerControls Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 21 14:15:52 volumiorp5 volumio[1408]: Express server listening on port 3000 Feb 21 14:15:52 volumiorp5 volumio[1408]: [Metrics] WebUI: 3s 151.88ms Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreStateMachine::resetVolumioState Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreStateMachine::getcurrentVolume Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::volumioRetrievevolume Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 14:15:52 volumiorp5 volumio[1408]: info: Volumio Network Manager: Network status updated: 0 Feb 21 14:15:52 volumiorp5 volumio[1408]: info: Cannot mount NAS music at system boot, trial number 1 ,retrying in 5 seconds Feb 21 14:15:52 volumiorp5 volumio[1408]: 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 14:15:52 volumiorp5 volumio[1408]: info: Reloading queue from file Feb 21 14:15:52 volumiorp5 volumio[1408]: info: VolumeController:: Volume=100 Mute =false Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreStateMachine::pushState Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CorePlayQueue::getTrack 0 Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::volumioPushState Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreStateMachine::updateTrackBlock Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CorePlayQueue::getTrackBlock Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::volumioRetrievevolume Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreStateMachine::setRepeat null single undefined Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreStateMachine::pushState Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CorePlayQueue::getTrack 0 Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::volumioPushState Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreStateMachine::setRandom null Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreStateMachine::pushState Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CorePlayQueue::getTrack 0 Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::volumioPushState Feb 21 14:15:52 volumiorp5 volumio[1408]: info: Setting Device type: Raspberry PI Feb 21 14:15:52 volumiorp5 volumio[1408]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Feb 21 14:15:52 volumiorp5 volumio[1408]: info: USB Boot Capable - System SBC Revision found in cpuinfo: d04171 Feb 21 14:15:52 volumiorp5 volumio[1408]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Feb 21 14:15:52 volumiorp5 volumio[1408]: info: Discovery: adding 82adc299-9234-4335-b46e-a5c8e9170831 Feb 21 14:15:52 volumiorp5 volumio[1408]: info: Discovery: Found device VolumioRP5 Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::volumioGetState Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CorePlayQueue::getTrack 0 Feb 21 14:15:52 volumiorp5 volumio[1408]: info: VolumeController:: Volume=100 Mute =false Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreStateMachine::pushState Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CorePlayQueue::getTrack 0 Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::volumioPushState Feb 21 14:15:52 volumiorp5 volumio[1408]: info: Completed loading Core Plugins Feb 21 14:15:52 volumiorp5 volumio[1408]: info: Preparing to generate the ALSA configuration file Feb 21 14:15:52 volumiorp5 volumio[1408]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Feb 21 14:15:52 volumiorp5 volumio[1408]: info: Reading ALSA contributions from plugins. Feb 21 14:15:52 volumiorp5 volumio[1408]: info: Asound.conf file unchanged, so no further update is needed Feb 21 14:15:52 volumiorp5 volumio[1408]: info: Output device has changed, restarting MPD Feb 21 14:15:52 volumiorp5 volumio[1408]: info: ___________ START PLUGINS ___________ Feb 21 14:15:52 volumiorp5 volumio[1408]: info: pi_screen_setup: Starting plugin Feb 21 14:15:52 volumiorp5 sudo[1645]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 21 14:15:52 volumiorp5 sudo[1645]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 14:15:52 volumiorp5 sudo[1647]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 21 14:15:52 volumiorp5 sudo[1647]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 14:15:52 volumiorp5 sudo[1645]: pam_unix(sudo:session): session closed for user root Feb 21 14:15:52 volumiorp5 volumio[1408]: info: pi_screen_setup: Loaded cached presets v1.5.6 Feb 21 14:15:52 volumiorp5 volumio[1408]: info: pi_screen_setup: Active presets source: cached, 227 presets loaded Feb 21 14:15:52 volumiorp5 volumio[1408]: info: pi_screen_setup: Detected model: Raspberry Pi 5 Model B Rev 1.1 Feb 21 14:15:52 volumiorp5 volumio[1408]: info: pi_screen_setup: Detected SoC: bcm2712 Feb 21 14:15:52 volumiorp5 volumio[1408]: info: pi_screen_setup: Detected RAM: 7952 MB Feb 21 14:15:52 volumiorp5 volumio[1408]: info: pi_screen_setup: Hardware detection complete - {"model":"Pi 5","model_raw":"Raspberry Pi 5 Model B Rev 1.1","soc":"bcm2712","ram_mb":7952,"hdmi_ports":2,"dsi_ports":["dsi0","dsi1"],"has_composite":true,"kms_supported":true,"kms_overlay":"vc4-kms-v3d-pi5","is_pi":true} Feb 21 14:15:52 volumiorp5 volumio[1408]: info: ControllerMpd::onStart: Initializing MPD Feb 21 14:15:52 volumiorp5 volumio[1408]: info: Creating MPD Configuration file Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 21 14:15:52 volumiorp5 volumio[1408]: info: [1771679752435] CoreMusicLibrary::Adding element Serwery Mediów Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 21 14:15:52 volumiorp5 sudo[1651]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 21 14:15:52 volumiorp5 sudo[1651]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 14:15:52 volumiorp5 volumio[1408]: info: UPNP Browser: Client initialized successfully Feb 21 14:15:52 volumiorp5 sudo[1651]: pam_unix(sudo:session): session closed for user root Feb 21 14:15:52 volumiorp5 sudo[1653]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 21 14:15:52 volumiorp5 sudo[1653]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 21 14:15:52 volumiorp5 volumio[1408]: info: [1771679752441] CoreMusicLibrary::Adding element Last_100 Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 21 14:15:52 volumiorp5 volumio[1408]: info: [1771679752442] CoreMusicLibrary::Adding element Webradio Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 21 14:15:52 volumiorp5 volumio[1408]: info: Initializing BBC Radios Feb 21 14:15:52 volumiorp5 systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 21 14:15:52 volumiorp5 systemd[1]: Starting mpd.service - Music Player Daemon... Feb 21 14:15:52 volumiorp5 systemd[1]: mpd.service: Deactivated successfully. Feb 21 14:15:52 volumiorp5 systemd[1]: Stopped mpd.service - Music Player Daemon. Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 14:15:52 volumiorp5 systemd[1]: mpd.socket: Deactivated successfully. Feb 21 14:15:52 volumiorp5 systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Feb 21 14:15:52 volumiorp5 systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Feb 21 14:15:52 volumiorp5 systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 21 14:15:52 volumiorp5 volumio[1408]: info: Creating Spotify config file Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:15:52 volumiorp5 systemd[1]: Starting mpd.service - Music Player Daemon... Feb 21 14:15:52 volumiorp5 sudo[1672]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 21 14:15:52 volumiorp5 sudo[1672]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 21 14:15:52 volumiorp5 sudo[1673]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Feb 21 14:15:52 volumiorp5 sudo[1672]: pam_unix(sudo:session): session closed for user root Feb 21 14:15:52 volumiorp5 volumio[1408]: info: [squeezelite_mc] Starting proxy server... Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Feb 21 14:15:52 volumiorp5 volumio[1408]: info: Loading i18n strings for locale pl Feb 21 14:15:52 volumiorp5 sudo[1676]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd_aloop index=7 pcm_substreams=2 Feb 21 14:15:52 volumiorp5 sudo[1676]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 14:15:52 volumiorp5 volumio[1408]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 21 14:15:52 volumiorp5 volumio[1408]: info: Volumio Calling Home Feb 21 14:15:52 volumiorp5 sudo[1680]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/mkdir -p /data/volumiokioskextensions/IframeKeyboardBridge Feb 21 14:15:52 volumiorp5 sudo[1680]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 14:15:52 volumiorp5 volumio[1408]: info: pi_screen_setup: Detected prior configuration (backup=true, banner=true) - restoring wizard_complete Feb 21 14:15:52 volumiorp5 sudo[1676]: pam_unix(sudo:session): session closed for user root Feb 21 14:15:52 volumiorp5 volumio[1408]: info: pi_screen_setup: Boot validation - {"valid":true,"drift_detected":false,"missing_videoconfig":false,"missing_include":false,"config_mismatch":false,"volumioconfig_mismatch":false,"errors":[]} Feb 21 14:15:52 volumiorp5 sudo[1680]: pam_unix(sudo:session): session closed for user root Feb 21 14:15:52 volumiorp5 volumio[1408]: info: [squeezelite_mc] Proxy server started on port 37179 Feb 21 14:15:52 volumiorp5 volumio[1408]: info: Preparing to generate the ALSA configuration file Feb 21 14:15:52 volumiorp5 volumio[1408]: info: pi_screen_setup: Management server started on port 4567 Feb 21 14:15:52 volumiorp5 sudo[1692]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Feb 21 14:15:52 volumiorp5 sudo[1692]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 14:15:52 volumiorp5 sudo[1690]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Feb 21 14:15:52 volumiorp5 sudo[1694]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Feb 21 14:15:52 volumiorp5 sudo[1690]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 14:15:52 volumiorp5 sudo[1694]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 14:15:52 volumiorp5 systemd[1]: Reloading. Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::volumioRetrievevolume Feb 21 14:15:52 volumiorp5 volumio[1408]: Unhandled rejection Error: No sockets available, cannot start. Feb 21 14:15:52 volumiorp5 volumio[1408]: at SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Feb 21 14:15:52 volumiorp5 volumio[1408]: at SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Feb 21 14:15:52 volumiorp5 volumio[1408]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Feb 21 14:15:52 volumiorp5 volumio[1408]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Feb 21 14:15:52 volumiorp5 volumio[1408]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Feb 21 14:15:52 volumiorp5 volumio[1408]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Feb 21 14:15:52 volumiorp5 volumio[1408]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Feb 21 14:15:52 volumiorp5 volumio[1408]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Feb 21 14:15:52 volumiorp5 volumio[1408]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:156:14) Feb 21 14:15:52 volumiorp5 volumio[1408]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24) Feb 21 14:15:52 volumiorp5 volumio[1408]: at HashMap. (/volumio/app/pluginmanager.js:496:31) Feb 21 14:15:52 volumiorp5 volumio[1408]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Feb 21 14:15:52 volumiorp5 volumio[1408]: at proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Feb 21 14:15:52 volumiorp5 volumio[1408]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20) Feb 21 14:15:52 volumiorp5 volumio[1408]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29) Feb 21 14:15:52 volumiorp5 volumio[1408]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Feb 21 14:15:52 volumiorp5 volumio[1408]: info: An error occurred while refreshing Spotify Token Error: getaddrinfo EBUSY oauth-performer.prod.vlmapi.io Feb 21 14:15:52 volumiorp5 volumio[1408]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Feb 21 14:15:52 volumiorp5 volumio[1408]: info: Reading ALSA contributions from plugins. Feb 21 14:15:52 volumiorp5 volumio[1408]: info: touch_display: No backlight interface detected. Feb 21 14:15:52 volumiorp5 volumio[1408]: info: snd_dummy loaded Feb 21 14:15:52 volumiorp5 volumio[1408]: info: MPD Permissions set Feb 21 14:15:52 volumiorp5 volumio[1408]: info: MPD Permissions set Feb 21 14:15:52 volumiorp5 volumio[1408]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Feb 21 14:15:52 volumiorp5 volumio[1408]: info: Spotify config file written Feb 21 14:15:52 volumiorp5 sudo[1701]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/cp -r /data/plugins/user_interface/touch_display/iframe_keyboard_bridge/content.js /data/plugins/user_interface/touch_display/iframe_keyboard_bridge/manifest.json /data/volumiokioskextensions/IframeKeyboardBridge/ Feb 21 14:15:52 volumiorp5 sudo[1701]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 14:15:52 volumiorp5 volumio[1408]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Feb 21 14:15:52 volumiorp5 sudo[1718]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Feb 21 14:15:52 volumiorp5 volumio[1408]: info: No need to fix Spotify hosts Feb 21 14:15:52 volumiorp5 sudo[1718]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:15:52 volumiorp5 sudo[1701]: pam_unix(sudo:session): session closed for user root Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:15:52 volumiorp5 volumio[1408]: info: VolumeController:: Volume=100 Mute =false Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreStateMachine::pushState Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CorePlayQueue::getTrack 0 Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::volumioPushState Feb 21 14:15:52 volumiorp5 volumio[1408]: info: [squeezelite_mc] Server discovery started Feb 21 14:15:52 volumiorp5 volumio[1408]: info: [squeezelite_mc] Player finder started Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:15:52 volumiorp5 volumio[1408]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 21 14:15:52 volumiorp5 volumio[1408]: info: [squeezelite_mc] Executing aplay -D hw:5 --nonblock -f MPEG /dev/zero 2>&1 || true Feb 21 14:15:52 volumiorp5 volumio[1408]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 21 14:15:52 volumiorp5 volumio[1408]: Error: send ENETUNREACH 255.255.255.255:3483 Feb 21 14:15:52 volumiorp5 volumio[1408]: at doSend (node:dgram:717:16) Feb 21 14:15:52 volumiorp5 volumio[1408]: at defaultTriggerAsyncIdScope (node:internal/async_hooks:464:18) Feb 21 14:15:52 volumiorp5 volumio[1408]: at afterDns (node:dgram:663:5) Feb 21 14:15:52 volumiorp5 volumio[1408]: at process.processTicksAndRejections (node:internal/process/task_queues:83:21) { Feb 21 14:15:52 volumiorp5 volumio[1408]: errno: -101, Feb 21 14:15:52 volumiorp5 volumio[1408]: code: 'ENETUNREACH', Feb 21 14:15:52 volumiorp5 volumio[1408]: syscall: 'send', Feb 21 14:15:52 volumiorp5 volumio[1408]: address: '255.255.255.255', Feb 21 14:15:52 volumiorp5 volumio[1408]: port: 3483 Feb 21 14:15:52 volumiorp5 volumio[1408]: } Feb 21 14:15:52 volumiorp5 volumio[1408]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 21 14:15:52 volumiorp5 dhcpcd[1013]: eth0: leased 192.168.9.131 for 86400 seconds Feb 21 14:15:52 volumiorp5 avahi-daemon[908]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.9.131. Feb 21 14:15:52 volumiorp5 avahi-daemon[908]: New relevant interface eth0.IPv4 for mDNS. Feb 21 14:15:52 volumiorp5 avahi-daemon[908]: Registering new address record for 192.168.9.131 on eth0.IPv4. Feb 21 14:15:52 volumiorp5 dhcpcd[1013]: eth0: adding route to 192.168.9.0/24 Feb 21 14:15:52 volumiorp5 dhcpcd[1013]: eth0: adding default route via 192.168.9.1 Feb 21 14:15:52 volumiorp5 sudo[1772]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-21 14:14' Feb 21 14:15:52 volumiorp5 sudo[1772]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="b05a530ca81d05eb9a84d0acf82089f0a60b8ee6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="4ad85e2147d972f0b838d33c21382d2d813b2ae8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Dec 25 09:13:19 UTC 2025" VOLUMIO_VERSION="4.084" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="792f09af7488531aecd1aadcaa9b175e"