Feb 22 11:52:02 zenith kernel: Booting Linux on physical CPU 0x0000000000 [0x414fd0b1] Feb 22 11:52:02 zenith 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 22 11:52:02 zenith kernel: KASLR enabled Feb 22 11:52:02 zenith kernel: random: crng init done Feb 22 11:52:02 zenith kernel: Machine model: Raspberry Pi 5 Model B Rev 1.0 Feb 22 11:52:02 zenith kernel: efi: UEFI not found. Feb 22 11:52:02 zenith kernel: Reserved memory: created CMA memory pool at 0x000000003bc00000, size 64 MiB Feb 22 11:52:02 zenith kernel: OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool Feb 22 11:52:02 zenith kernel: OF: reserved mem: 0x000000003bc00000..0x000000003fbfffff (65536 KiB) map reusable linux,cma Feb 22 11:52:02 zenith kernel: OF: reserved mem: 0x0000000000000000..0x000000000007ffff (512 KiB) nomap non-reusable atf@0 Feb 22 11:52:02 zenith kernel: OF: reserved mem: 0x000000003fd23240..0x000000003fd23277 (0 KiB) nomap non-reusable nvram@0 Feb 22 11:52:02 zenith kernel: NUMA: Faking a node at [mem 0x0000000000000000-0x00000001ffffffff] Feb 22 11:52:02 zenith kernel: Faking node 0 at [mem 0x0000000000000000-0x000000003fffffff] (1024MB) Feb 22 11:52:02 zenith kernel: Faking node 1 at [mem 0x0000000040000000-0x000000007fffffff] (1024MB) Feb 22 11:52:02 zenith kernel: Faking node 2 at [mem 0x0000000080000000-0x00000000bfffffff] (1024MB) Feb 22 11:52:02 zenith kernel: Faking node 3 at [mem 0x00000000c0000000-0x00000000ffffffff] (1024MB) Feb 22 11:52:02 zenith kernel: Faking node 4 at [mem 0x0000000100000000-0x000000013fffffff] (1024MB) Feb 22 11:52:02 zenith kernel: Faking node 5 at [mem 0x0000000140000000-0x000000017fffffff] (1024MB) Feb 22 11:52:02 zenith kernel: Faking node 6 at [mem 0x0000000180000000-0x00000001bfffffff] (1024MB) Feb 22 11:52:02 zenith kernel: Faking node 7 at [mem 0x00000001c0000000-0x00000001ffffffff] (1024MB) Feb 22 11:52:02 zenith kernel: NUMA: Initialized distance table, cnt=8 Feb 22 11:52:02 zenith kernel: NODE_DATA(0) allocated [mem 0x3bbfd300-0x3bbfffff] Feb 22 11:52:02 zenith kernel: NODE_DATA(1) allocated [mem 0x7fffd300-0x7fffffff] Feb 22 11:52:02 zenith kernel: NODE_DATA(2) allocated [mem 0xbfffd300-0xbfffffff] Feb 22 11:52:02 zenith kernel: NODE_DATA(3) allocated [mem 0xffffd300-0xffffffff] Feb 22 11:52:02 zenith kernel: NODE_DATA(4) allocated [mem 0x13fffd300-0x13fffffff] Feb 22 11:52:02 zenith kernel: NODE_DATA(5) allocated [mem 0x17fffd300-0x17fffffff] Feb 22 11:52:02 zenith kernel: NODE_DATA(6) allocated [mem 0x1bfffd300-0x1bfffffff] Feb 22 11:52:02 zenith kernel: NODE_DATA(7) allocated [mem 0x1fefa1300-0x1fefa3fff] Feb 22 11:52:02 zenith kernel: Zone ranges: Feb 22 11:52:02 zenith kernel: DMA [mem 0x0000000000000000-0x00000000ffffffff] Feb 22 11:52:02 zenith kernel: DMA32 empty Feb 22 11:52:02 zenith kernel: Normal [mem 0x0000000100000000-0x00000001ffffffff] Feb 22 11:52:02 zenith kernel: Movable zone start for each node Feb 22 11:52:02 zenith kernel: Early memory node ranges Feb 22 11:52:02 zenith kernel: node 0: [mem 0x0000000000000000-0x000000000007ffff] Feb 22 11:52:02 zenith kernel: node 0: [mem 0x0000000000080000-0x000000003fbfffff] Feb 22 11:52:02 zenith kernel: node 1: [mem 0x0000000040000000-0x000000007fffffff] Feb 22 11:52:02 zenith kernel: node 2: [mem 0x0000000080000000-0x00000000bfffffff] Feb 22 11:52:02 zenith kernel: node 3: [mem 0x00000000c0000000-0x00000000ffffffff] Feb 22 11:52:02 zenith kernel: node 4: [mem 0x0000000100000000-0x000000013fffffff] Feb 22 11:52:02 zenith kernel: node 5: [mem 0x0000000140000000-0x000000017fffffff] Feb 22 11:52:02 zenith kernel: node 6: [mem 0x0000000180000000-0x00000001bfffffff] Feb 22 11:52:02 zenith kernel: node 7: [mem 0x00000001c0000000-0x00000001ffffffff] Feb 22 11:52:02 zenith kernel: Initmem setup node 0 [mem 0x0000000000000000-0x000000003fbfffff] Feb 22 11:52:02 zenith kernel: Initmem setup node 1 [mem 0x0000000040000000-0x000000007fffffff] Feb 22 11:52:02 zenith kernel: Initmem setup node 2 [mem 0x0000000080000000-0x00000000bfffffff] Feb 22 11:52:02 zenith kernel: Initmem setup node 3 [mem 0x00000000c0000000-0x00000000ffffffff] Feb 22 11:52:02 zenith kernel: Initmem setup node 4 [mem 0x0000000100000000-0x000000013fffffff] Feb 22 11:52:02 zenith kernel: Initmem setup node 5 [mem 0x0000000140000000-0x000000017fffffff] Feb 22 11:52:02 zenith kernel: Initmem setup node 6 [mem 0x0000000180000000-0x00000001bfffffff] Feb 22 11:52:02 zenith kernel: Initmem setup node 7 [mem 0x00000001c0000000-0x00000001ffffffff] Feb 22 11:52:02 zenith kernel: On node 1, zone DMA: 1024 pages in unavailable ranges Feb 22 11:52:02 zenith kernel: psci: probing for conduit method from DT. Feb 22 11:52:02 zenith kernel: psci: PSCIv1.1 detected in firmware. Feb 22 11:52:02 zenith kernel: psci: Using standard PSCI v0.2 function IDs Feb 22 11:52:02 zenith kernel: psci: MIGRATE_INFO_TYPE not supported. Feb 22 11:52:02 zenith kernel: psci: SMC Calling Convention v1.2 Feb 22 11:52:02 zenith kernel: percpu: Embedded 33 pages/cpu s95192 r8192 d31784 u135168 Feb 22 11:52:02 zenith kernel: pcpu-alloc: s95192 r8192 d31784 u135168 alloc=33*4096 Feb 22 11:52:02 zenith kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Feb 22 11:52:02 zenith kernel: Detected PIPT I-cache on CPU0 Feb 22 11:52:02 zenith kernel: CPU features: detected: Virtualization Host Extensions Feb 22 11:52:02 zenith kernel: CPU features: detected: Spectre-v4 Feb 22 11:52:02 zenith kernel: CPU features: detected: Spectre-BHB Feb 22 11:52:02 zenith kernel: CPU features: kernel page table isolation forced ON by KASLR Feb 22 11:52:02 zenith kernel: CPU features: detected: Kernel page table isolation (KPTI) Feb 22 11:52:02 zenith kernel: CPU features: detected: SSBS not fully self-synchronizing Feb 22 11:52:02 zenith kernel: alternatives: applying boot alternatives Feb 22 11:52:02 zenith 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:95:E5:67 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 arm_freq=2000 gpu_mem=64 quiet console=ttyAMA10,115200 console=tty1 imgpart=UUID=dafa3844-b779-48cd-9b4c-01ecfd09e0f4 imgfile=/volumio_current.sqsh bootpart=UUID=3B89-0B23 datapart=UUID=752d19ad-b702-471d-847a-f79ae83515d0 uuidconfig=cmdline.txt pcie_aspm=on pci=pcie_bus_safe rootwait bootdelay=7 logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd-bcm2835.enable_compat_alsa= snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 loglevel=0 nodebug use_kmsg=no Feb 22 11:52:02 zenith kernel: cgroup: Disabling memory control group subsystem Feb 22 11:52:02 zenith kernel: mempolicy: NUMA default policy overridden to 'interleave:0-7' Feb 22 11:52:02 zenith kernel: DMA IOMMU NUMA default policy overridden to 'interleave:0-7' Feb 22 11:52:02 zenith kernel: Unknown kernel command line parameters "splash nodebug arm_freq=2000 gpu_mem=64 imgpart=UUID=dafa3844-b779-48cd-9b4c-01ecfd09e0f4 imgfile=/volumio_current.sqsh bootpart=UUID=3B89-0B23 datapart=UUID=752d19ad-b702-471d-847a-f79ae83515d0 uuidconfig=cmdline.txt bootdelay=7 use_kmsg=no", will be passed to user space. Feb 22 11:52:02 zenith kernel: Fallback order for Node 0: 0 1 2 3 4 5 6 7 Feb 22 11:52:02 zenith kernel: Fallback order for Node 1: 1 2 3 4 5 6 7 0 Feb 22 11:52:02 zenith kernel: Fallback order for Node 2: 2 3 4 5 6 7 0 1 Feb 22 11:52:02 zenith kernel: Fallback order for Node 3: 3 4 5 6 7 0 1 2 Feb 22 11:52:02 zenith kernel: Fallback order for Node 4: 4 5 6 7 0 1 2 3 Feb 22 11:52:02 zenith kernel: Fallback order for Node 5: 5 6 7 0 1 2 3 4 Feb 22 11:52:02 zenith kernel: Fallback order for Node 6: 6 7 0 1 2 3 4 5 Feb 22 11:52:02 zenith kernel: Fallback order for Node 7: 7 0 1 2 3 4 5 6 Feb 22 11:52:02 zenith kernel: Built 8 zonelists, mobility grouping on. Total pages: 2096128 Feb 22 11:52:02 zenith kernel: Policy zone: Normal Feb 22 11:52:02 zenith kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Feb 22 11:52:02 zenith kernel: software IO TLB: area num 4. Feb 22 11:52:02 zenith kernel: software IO TLB: mapped [mem 0x00000000fae00000-0x00000000fee00000] (64MB) Feb 22 11:52:02 zenith kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=8 Feb 22 11:52:02 zenith kernel: ftrace: allocating 45342 entries in 178 pages Feb 22 11:52:02 zenith kernel: ftrace: allocated 178 pages with 4 groups Feb 22 11:52:02 zenith kernel: rcu: Preemptible hierarchical RCU implementation. Feb 22 11:52:02 zenith kernel: rcu: RCU event tracing is enabled. Feb 22 11:52:02 zenith kernel: Trampoline variant of Tasks RCU enabled. Feb 22 11:52:02 zenith kernel: Rude variant of Tasks RCU enabled. Feb 22 11:52:02 zenith kernel: Tracing variant of Tasks RCU enabled. Feb 22 11:52:02 zenith kernel: rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. Feb 22 11:52:02 zenith kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Feb 22 11:52:02 zenith kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Feb 22 11:52:02 zenith kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Feb 22 11:52:02 zenith kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Feb 22 11:52:02 zenith kernel: Root IRQ handler: gic_handle_irq Feb 22 11:52:02 zenith kernel: GIC: Using split EOI/Deactivate mode Feb 22 11:52:02 zenith kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Feb 22 11:52:02 zenith kernel: arch_timer: cp15 timer(s) running at 54.00MHz (phys). Feb 22 11:52:02 zenith kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0xc743ce346, max_idle_ns: 440795203123 ns Feb 22 11:52:02 zenith kernel: sched_clock: 56 bits at 54MHz, resolution 18ns, wraps every 4398046511102ns Feb 22 11:52:02 zenith kernel: Console: colour dummy device 80x25 Feb 22 11:52:02 zenith kernel: printk: legacy console [tty1] enabled Feb 22 11:52:02 zenith kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 108.00 BogoMIPS (lpj=216000) Feb 22 11:52:02 zenith kernel: pid_max: default: 32768 minimum: 301 Feb 22 11:52:02 zenith kernel: LSM: initializing lsm=capability Feb 22 11:52:02 zenith kernel: Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, vmalloc) Feb 22 11:52:02 zenith kernel: Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, vmalloc) Feb 22 11:52:02 zenith kernel: Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) Feb 22 11:52:02 zenith kernel: Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, vmalloc) Feb 22 11:52:02 zenith kernel: rcu: Hierarchical SRCU implementation. Feb 22 11:52:02 zenith kernel: rcu: Max phase no-delay instances is 1000. Feb 22 11:52:02 zenith kernel: Timer migration: 1 hierarchy levels; 8 children per group; 0 crossnode level Feb 22 11:52:02 zenith kernel: EFI services will not be available. Feb 22 11:52:02 zenith kernel: smp: Bringing up secondary CPUs ... Feb 22 11:52:02 zenith kernel: Detected PIPT I-cache on CPU1 Feb 22 11:52:02 zenith kernel: CPU1: Booted secondary processor 0x0000000100 [0x414fd0b1] Feb 22 11:52:02 zenith kernel: Detected PIPT I-cache on CPU2 Feb 22 11:52:02 zenith kernel: CPU2: Booted secondary processor 0x0000000200 [0x414fd0b1] Feb 22 11:52:02 zenith kernel: Detected PIPT I-cache on CPU3 Feb 22 11:52:02 zenith kernel: CPU3: Booted secondary processor 0x0000000300 [0x414fd0b1] Feb 22 11:52:02 zenith kernel: smp: Brought up 8 nodes, 4 CPUs Feb 22 11:52:02 zenith kernel: SMP: Total of 4 processors activated. Feb 22 11:52:02 zenith kernel: CPU: All CPU(s) started at EL2 Feb 22 11:52:02 zenith kernel: CPU features: detected: 32-bit EL0 Support Feb 22 11:52:02 zenith kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Feb 22 11:52:02 zenith kernel: CPU features: detected: Common not Private translations Feb 22 11:52:02 zenith kernel: CPU features: detected: CRC32 instructions Feb 22 11:52:02 zenith kernel: CPU features: detected: RCpc load-acquire (LDAPR) Feb 22 11:52:02 zenith kernel: CPU features: detected: LSE atomic instructions Feb 22 11:52:02 zenith kernel: CPU features: detected: Privileged Access Never Feb 22 11:52:02 zenith kernel: CPU features: detected: RAS Extension Support Feb 22 11:52:02 zenith kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Feb 22 11:52:02 zenith kernel: alternatives: applying system-wide alternatives Feb 22 11:52:02 zenith kernel: CPU features: detected: Hardware dirty bit management on CPU0-3 Feb 22 11:52:02 zenith kernel: Memory: 8014680K/8384512K available (14080K kernel code, 2406K rwdata, 4820K rodata, 5440K init, 577K bss, 278696K reserved, 65536K cma-reserved) Feb 22 11:52:02 zenith kernel: devtmpfs: initialized Feb 22 11:52:02 zenith kernel: Enabled cp15_barrier support Feb 22 11:52:02 zenith kernel: Enabled setend support Feb 22 11:52:02 zenith kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns Feb 22 11:52:02 zenith kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, vmalloc) Feb 22 11:52:02 zenith kernel: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Feb 22 11:52:02 zenith kernel: 0 pages in range for non-PLT usage Feb 22 11:52:02 zenith kernel: 517392 pages in range for PLT usage Feb 22 11:52:02 zenith kernel: pinctrl core: initialized pinctrl subsystem Feb 22 11:52:02 zenith kernel: DMI not present or invalid. Feb 22 11:52:02 zenith kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Feb 22 11:52:02 zenith kernel: DMA: preallocated 1024 KiB GFP_KERNEL pool for atomic allocations Feb 22 11:52:02 zenith kernel: DMA: preallocated 1024 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Feb 22 11:52:02 zenith kernel: DMA: preallocated 1024 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Feb 22 11:52:02 zenith kernel: audit: initializing netlink subsys (disabled) Feb 22 11:52:02 zenith kernel: audit: type=2000 audit(0.012:1): state=initialized audit_enabled=0 res=1 Feb 22 11:52:02 zenith kernel: thermal_sys: Registered thermal governor 'step_wise' Feb 22 11:52:02 zenith kernel: cpuidle: using governor menu Feb 22 11:52:02 zenith kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Feb 22 11:52:02 zenith kernel: ASID allocator initialised with 32768 entries Feb 22 11:52:02 zenith kernel: Serial: AMBA PL011 UART driver Feb 22 11:52:02 zenith kernel: /soc@107c000000/interrupt-controller@7fff9000: Fixed dependency cycle(s) with /soc@107c000000/interrupt-controller@7fff9000 Feb 22 11:52:02 zenith kernel: bcm2835-mbox 107c013880.mailbox: mailbox enabled Feb 22 11:52:02 zenith kernel: 107d001000.serial: ttyAMA10 at MMIO 0x107d001000 (irq = 16, base_baud = 0) is a PL011 rev3 Feb 22 11:52:02 zenith kernel: printk: legacy console [ttyAMA10] enabled Feb 22 11:52:02 zenith kernel: raspberrypi-firmware soc@107c000000:firmware: Attached to firmware from 2025-11-05T17:37:18, variant start_cd Feb 22 11:52:02 zenith kernel: raspberrypi-firmware soc@107c000000:firmware: Firmware hash is 57db150d00000000000000000000000000000000 Feb 22 11:52:02 zenith kernel: bcm2835-dma 1000010000.dma: DMA legacy API manager, dmachans=0x1 Feb 22 11:52:02 zenith kernel: iommu: Default domain type: Translated Feb 22 11:52:02 zenith kernel: iommu: DMA domain TLB invalidation policy: strict mode Feb 22 11:52:02 zenith kernel: SCSI subsystem initialized Feb 22 11:52:02 zenith kernel: usbcore: registered new interface driver usbfs Feb 22 11:52:02 zenith kernel: usbcore: registered new interface driver hub Feb 22 11:52:02 zenith kernel: usbcore: registered new device driver usb Feb 22 11:52:02 zenith kernel: pps_core: LinuxPPS API ver. 1 registered Feb 22 11:52:02 zenith kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Feb 22 11:52:02 zenith kernel: PTP clock support registered Feb 22 11:52:02 zenith kernel: vgaarb: loaded Feb 22 11:52:02 zenith kernel: clocksource: Switched to clocksource arch_sys_counter Feb 22 11:52:02 zenith kernel: VFS: Disk quotas dquot_6.6.0 Feb 22 11:52:02 zenith kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Feb 22 11:52:02 zenith kernel: NET: Registered PF_INET protocol family Feb 22 11:52:02 zenith kernel: IP idents hash table entries: 131072 (order: 8, 1048576 bytes, vmalloc) Feb 22 11:52:02 zenith kernel: tcp_listen_portaddr_hash hash table entries: 4096 (order: 4, 65536 bytes, vmalloc) Feb 22 11:52:02 zenith kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, vmalloc) Feb 22 11:52:02 zenith kernel: TCP established hash table entries: 65536 (order: 7, 524288 bytes, vmalloc) Feb 22 11:52:02 zenith kernel: TCP bind hash table entries: 65536 (order: 9, 2097152 bytes, vmalloc) Feb 22 11:52:02 zenith kernel: TCP: Hash tables configured (established 65536 bind 65536) Feb 22 11:52:02 zenith kernel: MPTCP token hash table entries: 8192 (order: 5, 196608 bytes, vmalloc) Feb 22 11:52:02 zenith kernel: UDP hash table entries: 4096 (order: 5, 131072 bytes, vmalloc) Feb 22 11:52:02 zenith kernel: UDP-Lite hash table entries: 4096 (order: 5, 131072 bytes, vmalloc) Feb 22 11:52:02 zenith kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Feb 22 11:52:02 zenith kernel: RPC: Registered named UNIX socket transport module. Feb 22 11:52:02 zenith kernel: RPC: Registered udp transport module. Feb 22 11:52:02 zenith kernel: RPC: Registered tcp transport module. Feb 22 11:52:02 zenith kernel: RPC: Registered tcp-with-tls transport module. Feb 22 11:52:02 zenith kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Feb 22 11:52:02 zenith kernel: PCI: CLS 0 bytes, default 64 Feb 22 11:52:02 zenith kernel: Trying to unpack rootfs image as initramfs... Feb 22 11:52:02 zenith kernel: kvm [1]: nv: 554 coarse grained trap handlers Feb 22 11:52:02 zenith kernel: kvm [1]: IPA Size Limit: 40 bits Feb 22 11:52:02 zenith kernel: kvm [1]: vgic interrupt IRQ9 Feb 22 11:52:02 zenith kernel: kvm [1]: VHE mode initialized successfully Feb 22 11:52:02 zenith kernel: Initialise system trusted keyrings Feb 22 11:52:02 zenith kernel: workingset: timestamp_bits=42 max_order=21 bucket_order=0 Feb 22 11:52:02 zenith kernel: NFS: Registering the id_resolver key type Feb 22 11:52:02 zenith kernel: Key type id_resolver registered Feb 22 11:52:02 zenith kernel: Key type id_legacy registered Feb 22 11:52:02 zenith kernel: nfs4filelayout_init: NFSv4 File Layout Driver Registering... Feb 22 11:52:02 zenith kernel: nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering... Feb 22 11:52:02 zenith kernel: Key type asymmetric registered Feb 22 11:52:02 zenith kernel: Asymmetric key parser 'x509' registered Feb 22 11:52:02 zenith kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) Feb 22 11:52:02 zenith kernel: io scheduler mq-deadline registered Feb 22 11:52:02 zenith kernel: io scheduler kyber registered Feb 22 11:52:02 zenith kernel: io scheduler bfq registered Feb 22 11:52:02 zenith kernel: irq_brcmstb_l2: registered L2 intc (/soc@107c000000/interrupt-controller@7d510600, parent irq: 27) Feb 22 11:52:02 zenith kernel: irq_brcmstb_l2: registered L2 intc (/soc@107c000000/interrupt-controller@7c502000, parent irq: 28) Feb 22 11:52:02 zenith kernel: irq_brcmstb_l2: registered L2 intc (/soc@107c000000/intc@7d508380, parent irq: 29) Feb 22 11:52:02 zenith kernel: irq_brcmstb_l2: registered L2 intc (/soc@107c000000/intc@7d508400, parent irq: 30) Feb 22 11:52:02 zenith kernel: irq_brcmstb_l2: registered L2 intc (/soc@107c000000/intc@7d503000, parent irq: 31) Feb 22 11:52:02 zenith kernel: ledtrig-cpu: registered to indicate activity on CPUs Feb 22 11:52:02 zenith kernel: Freeing initrd memory: 35752K Feb 22 11:52:02 zenith kernel: Serial: 8250/16550 driver, 1 ports, IRQ sharing enabled Feb 22 11:52:02 zenith kernel: 107d50c000.serial: ttyS0 at MMIO 0x107d50c000 (irq = 33, base_baud = 6000000) is a Broadcom BCM7271 UART Feb 22 11:52:02 zenith kernel: serial serial0: tty port ttyS0 registered Feb 22 11:52:02 zenith kernel: iproc-rng200 107d208000.rng: hwrng registered Feb 22 11:52:02 zenith kernel: vc-mem: phys_addr:0x00000000 mem_base=0x3fc00000 mem_size:0x40000000(1024 MiB) Feb 22 11:52:02 zenith kernel: bcm2712-iommu-cache 1000005b00.iommuc: bcm2712_iommu_cache_probe Feb 22 11:52:02 zenith kernel: brd: module loaded Feb 22 11:52:02 zenith kernel: loop: module loaded Feb 22 11:52:02 zenith kernel: bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver Feb 22 11:52:02 zenith kernel: Loading iSCSI transport class v2.0-870. Feb 22 11:52:02 zenith kernel: usbcore: registered new interface driver lan78xx Feb 22 11:52:02 zenith kernel: usbcore: registered new interface driver smsc95xx Feb 22 11:52:02 zenith kernel: dwc_otg: version 3.00a 10-AUG-2012 (platform bus) Feb 22 11:52:02 zenith kernel: dwc_otg: FIQ enabled Feb 22 11:52:02 zenith kernel: dwc_otg: NAK holdoff enabled Feb 22 11:52:02 zenith kernel: dwc_otg: FIQ split-transaction FSM enabled Feb 22 11:52:02 zenith kernel: Module dwc_common_port init Feb 22 11:52:02 zenith kernel: usbcore: registered new interface driver uas Feb 22 11:52:02 zenith kernel: usbcore: registered new interface driver usb-storage Feb 22 11:52:02 zenith kernel: mousedev: PS/2 mouse device common for all mice Feb 22 11:52:02 zenith kernel: rpi-rtc soc@107c000000:rpi_rtc: registered as rtc0 Feb 22 11:52:02 zenith kernel: rpi-rtc soc@107c000000:rpi_rtc: setting system clock to 2026-02-22T16:51:52 UTC (1771779112) Feb 22 11:52:02 zenith kernel: bcm2835-wdt bcm2835-wdt: Poweroff handler already present! Feb 22 11:52:02 zenith kernel: bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer Feb 22 11:52:02 zenith kernel: sdhci: Secure Digital Host Controller Interface driver Feb 22 11:52:02 zenith kernel: sdhci: Copyright(c) Pierre Ossman Feb 22 11:52:02 zenith kernel: sdhci-pltfm: SDHCI platform and OF driver helper Feb 22 11:52:02 zenith kernel: SMCCC: SOC_ID: ARCH_SOC_ID not implemented, skipping .... Feb 22 11:52:02 zenith kernel: hid: raw HID events driver (C) Jiri Kosina Feb 22 11:52:02 zenith kernel: usbcore: registered new interface driver usbhid Feb 22 11:52:02 zenith kernel: usbhid: USB HID core driver Feb 22 11:52:02 zenith kernel: hw perfevents: enabled with armv8_cortex_a76 PMU driver, 7 (0,8000003f) counters available Feb 22 11:52:02 zenith kernel: NET: Registered PF_PACKET protocol family Feb 22 11:52:02 zenith kernel: Key type dns_resolver registered Feb 22 11:52:02 zenith kernel: registered taskstats version 1 Feb 22 11:52:02 zenith kernel: Loading compiled-in X.509 certificates Feb 22 11:52:02 zenith kernel: Demotion targets for Node 0: null Feb 22 11:52:02 zenith kernel: Demotion targets for Node 1: null Feb 22 11:52:02 zenith kernel: Demotion targets for Node 2: null Feb 22 11:52:02 zenith kernel: Demotion targets for Node 3: null Feb 22 11:52:02 zenith kernel: Demotion targets for Node 4: null Feb 22 11:52:02 zenith kernel: Demotion targets for Node 5: null Feb 22 11:52:02 zenith kernel: Demotion targets for Node 6: null Feb 22 11:52:02 zenith kernel: Demotion targets for Node 7: null Feb 22 11:52:02 zenith kernel: Key type .fscrypt registered Feb 22 11:52:02 zenith kernel: Key type fscrypt-provisioning registered Feb 22 11:52:02 zenith kernel: brcm-pcie 1000110000.pcie: host bridge /axi/pcie@1000110000 ranges: Feb 22 11:52:02 zenith kernel: brcm-pcie 1000110000.pcie: No bus range found for /axi/pcie@1000110000, using [bus 00-ff] Feb 22 11:52:02 zenith kernel: brcm-pcie 1000110000.pcie: MEM 0x1b80000000..0x1bffffffff -> 0x0080000000 Feb 22 11:52:02 zenith kernel: brcm-pcie 1000110000.pcie: MEM 0x1800000000..0x1b7fffffff -> 0x0400000000 Feb 22 11:52:02 zenith kernel: brcm-pcie 1000110000.pcie: IB MEM 0x0000000000..0x0fffffffff -> 0x1000000000 Feb 22 11:52:02 zenith kernel: brcm-pcie 1000110000.pcie: IB MEM 0x1000131000..0x1000131fff -> 0xfffffff000 Feb 22 11:52:02 zenith kernel: brcm-pcie 1000110000.pcie: PCI host bridge to bus 0001:00 Feb 22 11:52:02 zenith kernel: pci_bus 0001:00: root bus resource [bus 00-ff] Feb 22 11:52:02 zenith kernel: pci_bus 0001:00: root bus resource [mem 0x1b80000000-0x1bffffffff] (bus address [0x80000000-0xffffffff]) Feb 22 11:52:02 zenith kernel: pci_bus 0001:00: root bus resource [mem 0x1800000000-0x1b7fffffff pref] (bus address [0x400000000-0x77fffffff]) Feb 22 11:52:02 zenith kernel: pci 0001:00:00.0: [14e4:2712] type 01 class 0x060400 PCIe Root Port Feb 22 11:52:02 zenith kernel: pci 0001:00:00.0: PCI bridge to [bus 00] Feb 22 11:52:02 zenith kernel: pci 0001:00:00.0: bridge window [mem 0x1b80000000-0x1bbfffffff] Feb 22 11:52:02 zenith kernel: pci 0001:00:00.0: PME# supported from D0 D3hot Feb 22 11:52:02 zenith kernel: pci 0001:00:00.0: bridge configuration invalid ([bus 00-00]), reconfiguring Feb 22 11:52:02 zenith kernel: brcm-pcie 1000110000.pcie: clkreq-mode set to safe Feb 22 11:52:02 zenith kernel: brcm-pcie 1000110000.pcie: link up, 5.0 GT/s PCIe x1 (!SSC) Feb 22 11:52:02 zenith kernel: pci 0001:01:00.0: [144d:a808] type 00 class 0x010802 PCIe Endpoint Feb 22 11:52:02 zenith kernel: pci 0001:01:00.0: BAR 0 [mem 0x00000000-0x00003fff 64bit] Feb 22 11:52:02 zenith kernel: pci 0001:01:00.0: 4.000 Gb/s available PCIe bandwidth, limited by 5.0 GT/s PCIe x1 link at 0001:00:00.0 (capable of 31.504 Gb/s with 8.0 GT/s PCIe x4 link) Feb 22 11:52:02 zenith kernel: pci_bus 0001:01: busn_res: [bus 01-ff] end is updated to 01 Feb 22 11:52:02 zenith kernel: pci 0001:00:00.0: bridge window [mem 0x1b80000000-0x1b800fffff]: assigned Feb 22 11:52:02 zenith kernel: pci 0001:01:00.0: BAR 0 [mem 0x1b80000000-0x1b80003fff 64bit]: assigned Feb 22 11:52:02 zenith kernel: pci 0001:00:00.0: PCI bridge to [bus 01] Feb 22 11:52:02 zenith kernel: pci 0001:00:00.0: bridge window [mem 0x1b80000000-0x1b800fffff] Feb 22 11:52:02 zenith kernel: pci_bus 0001:00: resource 4 [mem 0x1b80000000-0x1bffffffff] Feb 22 11:52:02 zenith kernel: pci_bus 0001:00: resource 5 [mem 0x1800000000-0x1b7fffffff pref] Feb 22 11:52:02 zenith kernel: pci_bus 0001:01: resource 1 [mem 0x1b80000000-0x1b800fffff] Feb 22 11:52:02 zenith kernel: pci 0001:00:00.0: Max Payload Size set to 256/ 512 (was 128), Max Read Rq 512 Feb 22 11:52:02 zenith kernel: pci 0001:01:00.0: Max Payload Size set to 256/ 256 (was 128), Max Read Rq 512 Feb 22 11:52:02 zenith kernel: pcieport 0001:00:00.0: enabling device (0000 -> 0002) Feb 22 11:52:02 zenith kernel: pcieport 0001:00:00.0: PME: Signaling with IRQ 38 Feb 22 11:52:02 zenith kernel: pcieport 0001:00:00.0: AER: enabled with IRQ 38 Feb 22 11:52:02 zenith kernel: nvme nvme0: pci function 0001:01:00.0 Feb 22 11:52:02 zenith kernel: nvme 0001:01:00.0: enabling device (0000 -> 0002) Feb 22 11:52:02 zenith kernel: nvme nvme0: missing or invalid SUBNQN field. Feb 22 11:52:02 zenith kernel: nvme nvme0: D3 entry latency set to 8 seconds Feb 22 11:52:02 zenith kernel: hwmon hwmon1: temp1_input not attached to any thermal zone Feb 22 11:52:02 zenith kernel: hwmon hwmon1: temp2_input not attached to any thermal zone Feb 22 11:52:02 zenith kernel: hwmon hwmon1: temp3_input not attached to any thermal zone Feb 22 11:52:02 zenith kernel: nvme nvme0: 4/0/0 default/read/poll queues Feb 22 11:52:02 zenith kernel: nvme0n1: p1 p2 p3 Feb 22 11:52:02 zenith kernel: brcm-pcie 1000120000.pcie: host bridge /axi/pcie@1000120000 ranges: Feb 22 11:52:02 zenith kernel: brcm-pcie 1000120000.pcie: No bus range found for /axi/pcie@1000120000, using [bus 00-ff] Feb 22 11:52:02 zenith kernel: brcm-pcie 1000120000.pcie: MEM 0x1f00000000..0x1ffffffffb -> 0x0000000000 Feb 22 11:52:02 zenith kernel: brcm-pcie 1000120000.pcie: MEM 0x1c00000000..0x1effffffff -> 0x0400000000 Feb 22 11:52:02 zenith kernel: brcm-pcie 1000120000.pcie: IB MEM 0x1f00000000..0x1f003fffff -> 0x0000000000 Feb 22 11:52:02 zenith kernel: brcm-pcie 1000120000.pcie: IB MEM 0x0000000000..0x0fffffffff -> 0x1000000000 Feb 22 11:52:02 zenith kernel: brcm-pcie 1000120000.pcie: IB MEM 0x1000130000..0x1000130fff -> 0xfffffff000 Feb 22 11:52:02 zenith kernel: brcm-pcie 1000120000.pcie: PCI host bridge to bus 0002:00 Feb 22 11:52:02 zenith kernel: pci_bus 0002:00: root bus resource [bus 00-ff] Feb 22 11:52:02 zenith kernel: pci_bus 0002:00: root bus resource [mem 0x1f00000000-0x1ffffffffb] (bus address [0x00000000-0xfffffffb]) Feb 22 11:52:02 zenith kernel: pci_bus 0002:00: root bus resource [mem 0x1c00000000-0x1effffffff pref] (bus address [0x400000000-0x6ffffffff]) Feb 22 11:52:02 zenith kernel: pci 0002:00:00.0: [14e4:2712] type 01 class 0x060400 PCIe Root Port Feb 22 11:52:02 zenith kernel: pci 0002:00:00.0: PCI bridge to [bus 00] Feb 22 11:52:02 zenith kernel: pci 0002:00:00.0: bridge window [mem 0x1f80000000-0x1fbfffffff] Feb 22 11:52:02 zenith kernel: pci 0002:00:00.0: PME# supported from D0 D3hot Feb 22 11:52:02 zenith kernel: pci 0002:00:00.0: bridge configuration invalid ([bus 00-00]), reconfiguring Feb 22 11:52:02 zenith kernel: brcm-pcie 1000120000.pcie: clkreq-mode set to default Feb 22 11:52:02 zenith kernel: brcm-pcie 1000120000.pcie: link up, 5.0 GT/s PCIe x4 (!SSC) Feb 22 11:52:02 zenith kernel: pci 0002:01:00.0: [1de4:0001] type 00 class 0x020000 PCIe Endpoint Feb 22 11:52:02 zenith kernel: pci 0002:01:00.0: BAR 0 [mem 0xffffc000-0xffffffff] Feb 22 11:52:02 zenith kernel: pci 0002:01:00.0: BAR 1 [mem 0xffc00000-0xffffffff] Feb 22 11:52:02 zenith kernel: pci 0002:01:00.0: BAR 2 [mem 0xffff0000-0xffffffff] Feb 22 11:52:02 zenith kernel: pci 0002:01:00.0: supports D1 Feb 22 11:52:02 zenith kernel: pci 0002:01:00.0: PME# supported from D0 D1 D3hot D3cold Feb 22 11:52:02 zenith kernel: pci_bus 0002:01: busn_res: [bus 01-ff] end is updated to 01 Feb 22 11:52:02 zenith kernel: pci 0002:00:00.0: bridge window [mem 0x1f00000000-0x1f005fffff]: assigned Feb 22 11:52:02 zenith kernel: pci 0002:01:00.0: BAR 1 [mem 0x1f00000000-0x1f003fffff]: assigned Feb 22 11:52:02 zenith kernel: pci 0002:01:00.0: BAR 2 [mem 0x1f00400000-0x1f0040ffff]: assigned Feb 22 11:52:02 zenith kernel: pci 0002:01:00.0: BAR 0 [mem 0x1f00410000-0x1f00413fff]: assigned Feb 22 11:52:02 zenith kernel: pci 0002:00:00.0: PCI bridge to [bus 01] Feb 22 11:52:02 zenith kernel: pci 0002:00:00.0: bridge window [mem 0x1f00000000-0x1f005fffff] Feb 22 11:52:02 zenith kernel: pci_bus 0002:00: resource 4 [mem 0x1f00000000-0x1ffffffffb] Feb 22 11:52:02 zenith kernel: pci_bus 0002:00: resource 5 [mem 0x1c00000000-0x1effffffff pref] Feb 22 11:52:02 zenith kernel: pci_bus 0002:01: resource 1 [mem 0x1f00000000-0x1f005fffff] Feb 22 11:52:02 zenith kernel: pci 0002:00:00.0: Max Payload Size set to 256/ 512 (was 128), Max Read Rq 512 Feb 22 11:52:02 zenith kernel: pci 0002:01:00.0: Max Payload Size set to 256/ 256 (was 128), Max Read Rq 512 Feb 22 11:52:02 zenith kernel: pcieport 0002:00:00.0: enabling device (0000 -> 0002) Feb 22 11:52:02 zenith kernel: pcieport 0002:00:00.0: PME: Signaling with IRQ 44 Feb 22 11:52:02 zenith kernel: pcieport 0002:00:00.0: AER: enabled with IRQ 44 Feb 22 11:52:02 zenith kernel: rp1 0002:01:00.0: bar0 len 0x4000, start 0x1f00410000, end 0x1f00413fff, flags, 0x40200 Feb 22 11:52:02 zenith kernel: rp1 0002:01:00.0: bar1 len 0x400000, start 0x1f00000000, end 0x1f003fffff, flags, 0x40200 Feb 22 11:52:02 zenith kernel: rp1 0002:01:00.0: enabling device (0000 -> 0002) Feb 22 11:52:02 zenith kernel: rp1 0002:01:00.0: chip_id 0x20001927 Feb 22 11:52:02 zenith kernel: bcm2712-iommu 1000005100.iommu: bcm2712_iommu_init: DEBUG_INFO = 0x20804774 Feb 22 11:52:02 zenith kernel: bcm2712-iommu 1000005100.iommu: bcm2712_iommu_probe: Success Feb 22 11:52:02 zenith kernel: bcm2712-iommu 1000005200.iommu: bcm2712_iommu_init: DEBUG_INFO = 0x20804774 Feb 22 11:52:02 zenith kernel: bcm2712-iommu 1000005200.iommu: bcm2712_iommu_probe: Success Feb 22 11:52:02 zenith kernel: bcm2712-iommu 1000005280.iommu: bcm2712_iommu_init: DEBUG_INFO = 0x20804774 Feb 22 11:52:02 zenith kernel: bcm2712-iommu 1000005280.iommu: bcm2712_iommu_probe: Success Feb 22 11:52:02 zenith kernel: genirq: irq_chip rp1_irq_chip did not update eff. affinity mask of irq 106 Feb 22 11:52:02 zenith kernel: sdhci-brcmstb 1000fff000.mmc: Got CD GPIO Feb 22 11:52:02 zenith kernel: mmc1: CQHCI version 5.10 Feb 22 11:52:02 zenith kernel: mmc0: CQHCI version 5.10 Feb 22 11:52:02 zenith kernel: macb 1f00100000.ethernet eth0: Cadence GEM rev 0x00070109 at 0x1f00100000 irq 112 (2c:cf:67:95:e5:67) Feb 22 11:52:02 zenith kernel: dw_axi_dmac_platform 1f00188000.dma: DesignWare AXI DMA Controller, 8 channels Feb 22 11:52:02 zenith kernel: xhci-hcd xhci-hcd.0: xHCI Host Controller Feb 22 11:52:02 zenith kernel: xhci-hcd xhci-hcd.0: new USB bus registered, assigned bus number 1 Feb 22 11:52:02 zenith kernel: xhci-hcd xhci-hcd.0: hcc params 0x0240fe6d hci version 0x110 quirks 0x0000808000000810 Feb 22 11:52:02 zenith kernel: xhci-hcd xhci-hcd.0: irq 137, io mem 0x1f00200000 Feb 22 11:52:02 zenith kernel: xhci-hcd xhci-hcd.0: xHCI Host Controller Feb 22 11:52:02 zenith kernel: xhci-hcd xhci-hcd.0: new USB bus registered, assigned bus number 2 Feb 22 11:52:02 zenith kernel: xhci-hcd xhci-hcd.0: Host supports USB 3.0 SuperSpeed Feb 22 11:52:02 zenith kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.12 Feb 22 11:52:02 zenith kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Feb 22 11:52:02 zenith kernel: usb usb1: Product: xHCI Host Controller Feb 22 11:52:02 zenith kernel: usb usb1: Manufacturer: Linux 6.12.47-v8+ xhci-hcd Feb 22 11:52:02 zenith kernel: usb usb1: SerialNumber: xhci-hcd.0 Feb 22 11:52:02 zenith kernel: hub 1-0:1.0: USB hub found Feb 22 11:52:02 zenith kernel: hub 1-0:1.0: 2 ports detected Feb 22 11:52:02 zenith kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 6.12 Feb 22 11:52:02 zenith kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Feb 22 11:52:02 zenith kernel: usb usb2: Product: xHCI Host Controller Feb 22 11:52:02 zenith kernel: usb usb2: Manufacturer: Linux 6.12.47-v8+ xhci-hcd Feb 22 11:52:02 zenith kernel: usb usb2: SerialNumber: xhci-hcd.0 Feb 22 11:52:02 zenith kernel: hub 2-0:1.0: USB hub found Feb 22 11:52:02 zenith kernel: hub 2-0:1.0: 1 port detected Feb 22 11:52:02 zenith kernel: xhci-hcd xhci-hcd.1: xHCI Host Controller Feb 22 11:52:02 zenith kernel: xhci-hcd xhci-hcd.1: new USB bus registered, assigned bus number 3 Feb 22 11:52:02 zenith kernel: xhci-hcd xhci-hcd.1: hcc params 0x0240fe6d hci version 0x110 quirks 0x0000808000000810 Feb 22 11:52:02 zenith kernel: xhci-hcd xhci-hcd.1: irq 142, io mem 0x1f00300000 Feb 22 11:52:02 zenith kernel: xhci-hcd xhci-hcd.1: xHCI Host Controller Feb 22 11:52:02 zenith kernel: xhci-hcd xhci-hcd.1: new USB bus registered, assigned bus number 4 Feb 22 11:52:02 zenith kernel: xhci-hcd xhci-hcd.1: Host supports USB 3.0 SuperSpeed Feb 22 11:52:02 zenith kernel: usb usb3: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.12 Feb 22 11:52:02 zenith kernel: usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Feb 22 11:52:02 zenith kernel: usb usb3: Product: xHCI Host Controller Feb 22 11:52:02 zenith kernel: usb usb3: Manufacturer: Linux 6.12.47-v8+ xhci-hcd Feb 22 11:52:02 zenith kernel: usb usb3: SerialNumber: xhci-hcd.1 Feb 22 11:52:02 zenith kernel: hub 3-0:1.0: USB hub found Feb 22 11:52:02 zenith kernel: hub 3-0:1.0: 2 ports detected Feb 22 11:52:02 zenith kernel: usb usb4: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 6.12 Feb 22 11:52:02 zenith kernel: usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Feb 22 11:52:02 zenith kernel: usb usb4: Product: xHCI Host Controller Feb 22 11:52:02 zenith kernel: usb usb4: Manufacturer: Linux 6.12.47-v8+ xhci-hcd Feb 22 11:52:02 zenith kernel: usb usb4: SerialNumber: xhci-hcd.1 Feb 22 11:52:02 zenith kernel: hub 4-0:1.0: USB hub found Feb 22 11:52:02 zenith kernel: hub 4-0:1.0: 1 port detected Feb 22 11:52:02 zenith kernel: of_cfs_init Feb 22 11:52:02 zenith kernel: of_cfs_init: OK Feb 22 11:52:02 zenith kernel: clk: Disabling unused clocks Feb 22 11:52:02 zenith kernel: PM: genpd: Disabling unused power domains Feb 22 11:52:02 zenith kernel: mmc0: SDHCI controller on 1000fff000.mmc [1000fff000.mmc] using ADMA 64-bit Feb 22 11:52:02 zenith kernel: mmc1: SDHCI controller on 1001100000.mmc [1001100000.mmc] using ADMA 64-bit Feb 22 11:52:02 zenith kernel: Freeing unused kernel memory: 5440K Feb 22 11:52:02 zenith kernel: Run /init as init process Feb 22 11:52:02 zenith kernel: with arguments: Feb 22 11:52:02 zenith kernel: /init Feb 22 11:52:02 zenith kernel: splash Feb 22 11:52:02 zenith kernel: nodebug Feb 22 11:52:02 zenith kernel: with environment: Feb 22 11:52:02 zenith kernel: HOME=/ Feb 22 11:52:02 zenith kernel: TERM=linux Feb 22 11:52:02 zenith kernel: arm_freq=2000 Feb 22 11:52:02 zenith kernel: gpu_mem=64 Feb 22 11:52:02 zenith kernel: imgpart=UUID=dafa3844-b779-48cd-9b4c-01ecfd09e0f4 Feb 22 11:52:02 zenith kernel: imgfile=/volumio_current.sqsh Feb 22 11:52:02 zenith kernel: bootpart=UUID=3B89-0B23 Feb 22 11:52:02 zenith kernel: datapart=UUID=752d19ad-b702-471d-847a-f79ae83515d0 Feb 22 11:52:02 zenith kernel: uuidconfig=cmdline.txt Feb 22 11:52:02 zenith kernel: bootdelay=7 Feb 22 11:52:02 zenith kernel: use_kmsg=no Feb 22 11:52:02 zenith kernel: mmc1: new ultra high speed DDR50 SDIO card at address 0001 Feb 22 11:52:02 zenith kernel: rp1-firmware rp1_firmware: RP1 Firmware version 23fca1cd776798b50bd3e640ecb242215778e7f8 Feb 22 11:52:02 zenith kernel: rp1-pio 1f00178000.pio: Created instance as pio0 Feb 22 11:52:02 zenith kernel: v3d 1002000000.v3d: [drm] Transparent Hugepage support is recommended for optimal performance on this platform! Feb 22 11:52:02 zenith kernel: input: pwr_button as /devices/platform/pwr_button/input/input0 Feb 22 11:52:02 zenith kernel: [drm] Initialized v3d 1.0.0 for 1002000000.v3d on minor 0 Feb 22 11:52:02 zenith kernel: brcmstb-i2c 107d508200.i2c: @97500hz registered in interrupt mode Feb 22 11:52:02 zenith kernel: brcmstb-i2c 107d508280.i2c: @97500hz registered in interrupt mode Feb 22 11:52:02 zenith kernel: vc4_hvs 107c580000.hvs: bcm2712_iommu_of_xlate: MMU 1000005200.iommu Feb 22 11:52:02 zenith kernel: vc4_hvs 107c580000.hvs: bcm2712_iommu_probe_device: MMU 1000005200.iommu Feb 22 11:52:02 zenith kernel: vc4_hvs 107c580000.hvs: bcm2712_iommu_device_group: MMU 1000005200.iommu Feb 22 11:52:02 zenith kernel: vc4_hvs 107c580000.hvs: Adding to iommu group 1 Feb 22 11:52:02 zenith kernel: vc4_hvs 107c580000.hvs: bcm2712_iommu_attach_dev: MMU 1000005200.iommu Feb 22 11:52:02 zenith kernel: vc4-drm axi:gpu: bcm2712_iommu_of_xlate: MMU 1000005200.iommu Feb 22 11:52:02 zenith kernel: vc4-drm axi:gpu: bcm2712_iommu_probe_device: MMU 1000005200.iommu Feb 22 11:52:02 zenith kernel: vc4-drm axi:gpu: bcm2712_iommu_device_group: MMU 1000005200.iommu Feb 22 11:52:02 zenith kernel: vc4-drm axi:gpu: Adding to iommu group 1 Feb 22 11:52:02 zenith kernel: vc4-drm axi:gpu: bcm2712_iommu_attach_dev: MMU 1000005200.iommu Feb 22 11:52:02 zenith kernel: vc4-drm axi:gpu: bound 107c580000.hvs (ops vc4_hvs_ops [vc4]) Feb 22 11:52:02 zenith kernel: Registered IR keymap rc-cec Feb 22 11:52:02 zenith kernel: rc rc0: vc4-hdmi-0 as /devices/platform/soc@107c000000/107c701400.hdmi/rc/rc0 Feb 22 11:52:02 zenith kernel: input: vc4-hdmi-0 as /devices/platform/soc@107c000000/107c701400.hdmi/rc/rc0/input1 Feb 22 11:52:02 zenith kernel: input: vc4-hdmi-0 HDMI Jack as /devices/platform/soc@107c000000/107c701400.hdmi/sound/card0/input2 Feb 22 11:52:02 zenith kernel: vc4-drm axi:gpu: bound 107c701400.hdmi (ops vc4_hdmi_ops [vc4]) Feb 22 11:52:02 zenith kernel: Registered IR keymap rc-cec Feb 22 11:52:02 zenith kernel: rc rc1: vc4-hdmi-1 as /devices/platform/soc@107c000000/107c706400.hdmi/rc/rc1 Feb 22 11:52:02 zenith kernel: input: vc4-hdmi-1 as /devices/platform/soc@107c000000/107c706400.hdmi/rc/rc1/input3 Feb 22 11:52:02 zenith kernel: input: vc4-hdmi-1 HDMI Jack as /devices/platform/soc@107c000000/107c706400.hdmi/sound/card1/input4 Feb 22 11:52:02 zenith kernel: vc4-drm axi:gpu: bound 107c706400.hdmi (ops vc4_hdmi_ops [vc4]) Feb 22 11:52:02 zenith kernel: vc4-drm axi:gpu: bound 107c500000.mop (ops vc4_txp_ops [vc4]) Feb 22 11:52:02 zenith kernel: vc4-drm axi:gpu: bound 107c501000.moplet (ops vc4_txp_ops [vc4]) Feb 22 11:52:03 zenith kernel: vc4-drm axi:gpu: bound 107c410000.pixelvalve (ops vc4_crtc_ops [vc4]) Feb 22 11:52:03 zenith kernel: vc4-drm axi:gpu: bound 107c411000.pixelvalve (ops vc4_crtc_ops [vc4]) Feb 22 11:52:03 zenith kernel: [drm] Initialized vc4 0.0.0 for axi:gpu on minor 1 Feb 22 11:52:03 zenith kernel: vc4-drm axi:gpu: [drm] Cannot find any crtc or sizes Feb 22 11:52:03 zenith kernel: vc4-drm axi:gpu: [drm] Cannot find any crtc or sizes Feb 22 11:52:03 zenith kernel: vc4-drm axi:gpu: [drm] Cannot find any crtc or sizes Feb 22 11:52:03 zenith kernel: fuse: init (API version 7.41) Feb 22 11:52:03 zenith kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Feb 22 11:52:03 zenith kernel: snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned. Feb 22 11:52:03 zenith kernel: snd_bcm2835: unknown parameter 'enable_compat_alsa' ignored Feb 22 11:52:03 zenith kernel: fbtft: module is from the staging directory, the quality is unknown, you have been warned. Feb 22 11:52:03 zenith kernel: fb_ili9340: module is from the staging directory, the quality is unknown, you have been warned. Feb 22 11:52:03 zenith kernel: SPI driver fb_ili9340 has no spi_device_id for ilitek,ili9340 Feb 22 11:52:03 zenith kernel: fb_ili9341: module is from the staging directory, the quality is unknown, you have been warned. Feb 22 11:52:03 zenith kernel: fb_st7735r: module is from the staging directory, the quality is unknown, you have been warned. Feb 22 11:52:03 zenith kernel: SPI driver fb_st7735r has no spi_device_id for sitronix,st7735r Feb 22 11:52:03 zenith kernel: SPI driver fb_st7735r has no spi_device_id for fbtft,sainsmart18 Feb 22 11:52:03 zenith kernel: SPI driver fb_st7735r has no spi_device_id for fbtft,adafruit18 Feb 22 11:52:03 zenith kernel: SPI driver fb_st7735r has no spi_device_id for fbtft,adafruit18_green Feb 22 11:52:03 zenith kernel: fb_st7789v: module is from the staging directory, the quality is unknown, you have been warned. Feb 22 11:52:03 zenith kernel: SPI driver fb_st7789v has no spi_device_id for sitronix,st7789v Feb 22 11:52:03 zenith kernel: SPI driver fb_st7789v has no spi_device_id for fbtft,minipitft13 Feb 22 11:52:03 zenith kernel: fb_hx8357d: module is from the staging directory, the quality is unknown, you have been warned. Feb 22 11:52:03 zenith kernel: SPI driver fb_hx8357d has no spi_device_id for himax,hx8357d Feb 22 11:52:03 zenith kernel: EXT4-fs (nvme0n1p2): recovery complete Feb 22 11:52:03 zenith kernel: EXT4-fs (nvme0n1p2): mounted filesystem dafa3844-b779-48cd-9b4c-01ecfd09e0f4 r/w with ordered data mode. Quota mode: none. Feb 22 11:52:03 zenith kernel: loop0: detected capacity change from 0 to 1422424 Feb 22 11:52:03 zenith kernel: EXT4-fs (nvme0n1p3): recovery complete Feb 22 11:52:03 zenith kernel: EXT4-fs (nvme0n1p3): mounted filesystem 752d19ad-b702-471d-847a-f79ae83515d0 r/w with ordered data mode. Quota mode: none. Feb 22 11:52:03 zenith kernel: NET: Registered PF_INET6 protocol family Feb 22 11:52:03 zenith kernel: Segment Routing with IPv6 Feb 22 11:52:03 zenith kernel: In-situ OAM (IOAM) with IPv6 Feb 22 11:52:03 zenith 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 22 11:52:03 zenith systemd[1]: Detected architecture arm64. Feb 22 11:52:03 zenith systemd[1]: Hostname set to . Feb 22 11:52:03 zenith systemd[1]: Queued start job for default target graphical.target. Feb 22 11:52:03 zenith systemd[1]: Created slice system-getty.slice - Slice /system/getty. Feb 22 11:52:03 zenith systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Feb 22 11:52:03 zenith systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Feb 22 11:52:03 zenith systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Feb 22 11:52:03 zenith systemd[1]: Created slice user.slice - User and Session Slice. Feb 22 11:52:03 zenith systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Feb 22 11:52:03 zenith systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Feb 22 11:52:03 zenith systemd[1]: Expecting device dev-disk-by\x2duuid-3B89\x2d0B23.device - /dev/disk/by-uuid/3B89-0B23... Feb 22 11:52:03 zenith systemd[1]: Expecting device dev-ttyAMA10.device - /dev/ttyAMA10... Feb 22 11:52:03 zenith systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Feb 22 11:52:03 zenith systemd[1]: Reached target remote-fs.target - Remote File Systems. Feb 22 11:52:03 zenith systemd[1]: Reached target slices.target - Slice Units. Feb 22 11:52:03 zenith systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Feb 22 11:52:03 zenith systemd[1]: Listening on systemd-fsckd.socket - fsck to fsckd communication Socket. Feb 22 11:52:03 zenith systemd[1]: Listening on systemd-initctl.socket - initctl Compatibility Named Pipe. Feb 22 11:52:03 zenith systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Feb 22 11:52:03 zenith systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Feb 22 11:52:03 zenith systemd[1]: Listening on systemd-journald.socket - Journal Socket. Feb 22 11:52:03 zenith systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Feb 22 11:52:03 zenith systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Feb 22 11:52:03 zenith systemd[1]: dev-hugepages.mount - Huge Pages File System was skipped because of an unmet condition check (ConditionPathExists=/sys/kernel/mm/hugepages). Feb 22 11:52:03 zenith systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Feb 22 11:52:03 zenith systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Feb 22 11:52:03 zenith systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Feb 22 11:52:03 zenith systemd[1]: Started dynamicswap.service - dynamicswap service. Feb 22 11:52:03 zenith systemd[1]: Reached target swap.target - Swaps. Feb 22 11:52:03 zenith systemd[1]: Starting fake-hwclock.service - Restore / save the current clock... Feb 22 11:52:03 zenith systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Feb 22 11:52:03 zenith systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Feb 22 11:52:03 zenith systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Feb 22 11:52:03 zenith systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Feb 22 11:52:03 zenith systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Feb 22 11:52:03 zenith systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Feb 22 11:52:03 zenith systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Feb 22 11:52:03 zenith systemd[1]: Starting systemd-journald.service - Journal Service... Feb 22 11:52:03 zenith systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Feb 22 11:52:03 zenith systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Feb 22 11:52:03 zenith systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Feb 22 11:52:03 zenith systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Feb 22 11:52:03 zenith systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Feb 22 11:52:03 zenith systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Feb 22 11:52:03 zenith systemd[1]: Finished fake-hwclock.service - Restore / save the current clock. Feb 22 11:52:03 zenith systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Feb 22 11:52:03 zenith systemd[1]: modprobe@configfs.service: Deactivated successfully. Feb 22 11:52:03 zenith systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Feb 22 11:52:03 zenith systemd[1]: modprobe@drm.service: Deactivated successfully. Feb 22 11:52:03 zenith systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Feb 22 11:52:03 zenith systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Feb 22 11:52:03 zenith systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Feb 22 11:52:03 zenith systemd[1]: modprobe@fuse.service: Deactivated successfully. Feb 22 11:52:03 zenith systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Feb 22 11:52:03 zenith systemd[1]: modprobe@loop.service: Deactivated successfully. Feb 22 11:52:03 zenith systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Feb 22 11:52:03 zenith kernel: i2c_dev: i2c /dev entries driver Feb 22 11:52:03 zenith systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Feb 22 11:52:03 zenith kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Feb 22 11:52:03 zenith systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Feb 22 11:52:03 zenith systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Feb 22 11:52:03 zenith systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Feb 22 11:52:03 zenith systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Feb 22 11:52:03 zenith systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Feb 22 11:52:03 zenith systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Feb 22 11:52:03 zenith systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Feb 22 11:52:03 zenith systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Feb 22 11:52:03 zenith systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Feb 22 11:52:03 zenith systemd[1]: systemd-firstboot.service - First Boot Wizard was skipped because of an unmet condition check (ConditionFirstBoot=yes). Feb 22 11:52:03 zenith systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Feb 22 11:52:03 zenith systemd[1]: Starting systemd-random-seed.service - Load/Save Random Seed... Feb 22 11:52:03 zenith systemd[1]: Starting systemd-sysusers.service - Create System Users... Feb 22 11:52:03 zenith systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Feb 22 11:52:03 zenith systemd[1]: dynamicswap.service: Deactivated successfully. Feb 22 11:52:03 zenith systemd-journald[525]: Journal started Feb 22 11:52:03 zenith systemd-journald[525]: Runtime Journal (/run/log/journal/35c4ab2cb79e0973fdebde8c693341bc) is 3.7M, max 30.0M, 26.2M free. Feb 22 11:52:02 zenith systemd-modules-load[526]: Inserted module 'i2c_dev' Feb 22 11:52:03 zenith fake-hwclock[515]: Current system time: 2026-02-22 16:52:02 Feb 22 11:52:03 zenith fake-hwclock[515]: fake-hwclock saved clock information is in the past: 2026-02-22 16:51:39 Feb 22 11:52:03 zenith fake-hwclock[515]: To set system time to this saved clock anyway, use "force" Feb 22 11:52:03 zenith systemd[1]: Started systemd-journald.service - Journal Service. Feb 22 11:52:03 zenith systemd[1]: Finished systemd-random-seed.service - Load/Save Random Seed. Feb 22 11:52:03 zenith systemd[1]: first-boot-complete.target - First Boot Complete was skipped because of an unmet condition check (ConditionFirstBoot=yes). Feb 22 11:52:03 zenith systemd[1]: Finished systemd-sysusers.service - Create System Users. Feb 22 11:52:03 zenith systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Feb 22 11:52:03 zenith systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Feb 22 11:52:03 zenith systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Feb 22 11:52:03 zenith systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Feb 22 11:52:03 zenith systemd-udevd[547]: Using default interface naming scheme 'v252'. Feb 22 11:52:03 zenith systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Feb 22 11:52:03 zenith systemd[1]: Starting ifupdown-pre.service - Helper to synchronize boot up for ifupdown... Feb 22 11:52:03 zenith systemd[1]: Finished ifupdown-pre.service - Helper to synchronize boot up for ifupdown. Feb 22 11:52:03 zenith systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Feb 22 11:52:03 zenith systemd[1]: Starting plymouth-start.service - Show Plymouth Boot Screen... Feb 22 11:52:03 zenith systemd[1]: Started plymouth-start.service - Show Plymouth Boot Screen. Feb 22 11:52:03 zenith 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 22 11:52:03 zenith systemd[1]: Started systemd-ask-password-plymouth.path - Forward Password Requests to Plymouth Directory Watch. Feb 22 11:52:03 zenith systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Feb 22 11:52:03 zenith systemd[1]: Reached target paths.target - Path Units. Feb 22 11:52:03 zenith (udev-worker)[563]: Network interface NamePolicy= disabled on kernel command line. Feb 22 11:52:03 zenith kernel: rpi-gpiomem 107d508500.gpiomem: window base 0x107d508500 size 0x00000040 Feb 22 11:52:03 zenith systemd[1]: Found device dev-disk-by\x2duuid-3B89\x2d0B23.device - Samsung SSD 970 EVO Plus 250GB boot. Feb 22 11:52:03 zenith systemd[1]: Found device dev-ttyAMA10.device - /dev/ttyAMA10. Feb 22 11:52:03 zenith kernel: rpi-gpiomem 107d508500.gpiomem: initialised 1 regions as /dev/gpiomem1 Feb 22 11:52:03 zenith kernel: rpi-gpiomem 107d517c00.gpiomem: window base 0x107d517c00 size 0x00000040 Feb 22 11:52:03 zenith kernel: rpi-gpiomem 107d517c00.gpiomem: initialised 1 regions as /dev/gpiomem2 Feb 22 11:52:03 zenith kernel: rpi-gpiomem 107d504100.gpiomem: window base 0x107d504100 size 0x00000020 Feb 22 11:52:03 zenith kernel: rpi-gpiomem 107d504100.gpiomem: initialised 1 regions as /dev/gpiomem3 Feb 22 11:52:03 zenith kernel: rpi-gpiomem 107d510700.gpiomem: window base 0x107d510700 size 0x00000020 Feb 22 11:52:03 zenith kernel: rpi-gpiomem 107d510700.gpiomem: initialised 1 regions as /dev/gpiomem4 Feb 22 11:52:03 zenith kernel: rpi-gpiomem 1f000d0000.gpiomem: window base 0x1f000d0000 size 0x00030000 Feb 22 11:52:03 zenith kernel: rpi-gpiomem 1f000d0000.gpiomem: initialised 1 regions as /dev/gpiomem0 Feb 22 11:52:03 zenith kernel: mc: Linux media interface: v0.10 Feb 22 11:52:03 zenith systemd[1]: Starting systemd-fsck@dev-disk-by\x2duuid-3B89\x2d0B23.service - File System Check on /dev/disk/by-uuid/3B89-0B23... Feb 22 11:52:03 zenith kernel: videodev: Linux video capture interface: v2.00 Feb 22 11:52:03 zenith systemd[1]: Expecting device sys-subsystem-net-devices-eth0.device - /sys/subsystem/net/devices/eth0... Feb 22 11:52:03 zenith systemd[1]: Started systemd-fsckd.service - File System Check Daemon to report status. Feb 22 11:52:03 zenith systemd-fsck[696]: fsck.fat 4.2 (2021-01-31) Feb 22 11:52:03 zenith systemd-fsck[696]: /dev/nvme0n1p1: 540 files, 24109/93500 clusters Feb 22 11:52:03 zenith systemd[1]: Finished systemd-fsck@dev-disk-by\x2duuid-3B89\x2d0B23.service - File System Check on /dev/disk/by-uuid/3B89-0B23. Feb 22 11:52:03 zenith kernel: rpi-hevc-dec 1000800000.codec: bcm2712_iommu_of_xlate: MMU 1000005100.iommu Feb 22 11:52:03 zenith kernel: rpi-hevc-dec 1000800000.codec: bcm2712_iommu_probe_device: MMU 1000005100.iommu Feb 22 11:52:03 zenith kernel: rpi-hevc-dec 1000800000.codec: bcm2712_iommu_device_group: MMU 1000005100.iommu Feb 22 11:52:03 zenith kernel: rpi-hevc-dec 1000800000.codec: Adding to iommu group 0 Feb 22 11:52:03 zenith kernel: rpi-hevc-dec 1000800000.codec: bcm2712_iommu_attach_dev: MMU 1000005100.iommu Feb 22 11:52:03 zenith kernel: pispbe 1000880000.pisp_be: bcm2712_iommu_of_xlate: MMU 1000005100.iommu Feb 22 11:52:03 zenith kernel: pispbe 1000880000.pisp_be: bcm2712_iommu_probe_device: MMU 1000005100.iommu Feb 22 11:52:03 zenith kernel: pispbe 1000880000.pisp_be: bcm2712_iommu_device_group: MMU 1000005100.iommu Feb 22 11:52:03 zenith kernel: rpi-hevc-dec 1000800000.codec: Device registered as /dev/video19 Feb 22 11:52:03 zenith kernel: pispbe 1000880000.pisp_be: Adding to iommu group 0 Feb 22 11:52:03 zenith kernel: pispbe 1000880000.pisp_be: bcm2712_iommu_attach_dev: MMU 1000005100.iommu Feb 22 11:52:03 zenith kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database Feb 22 11:52:03 zenith systemd[1]: Found device sys-subsystem-net-devices-eth0.device - /sys/subsystem/net/devices/eth0. Feb 22 11:52:03 zenith 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 22 11:52:03 zenith kernel: Loaded X.509 cert 'benh@debian.org: 577e021cb980e0e820821ba7b54b4961b8b4fadf' Feb 22 11:52:03 zenith kernel: Loaded X.509 cert 'romain.perier@gmail.com: 3abbc6ec146e09d1b6016ab9d6cf71dd233f0328' Feb 22 11:52:03 zenith kernel: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' Feb 22 11:52:03 zenith kernel: Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' Feb 22 11:52:03 zenith kernel: brcmfmac: F1 signature read @0x18000000=0x15264345 Feb 22 11:52:03 zenith kernel: Bluetooth: Core ver 2.22 Feb 22 11:52:03 zenith kernel: NET: Registered PF_BLUETOOTH protocol family Feb 22 11:52:03 zenith kernel: Bluetooth: HCI device and connection manager initialized Feb 22 11:52:03 zenith kernel: Bluetooth: HCI socket layer initialized Feb 22 11:52:03 zenith kernel: Bluetooth: L2CAP socket layer initialized Feb 22 11:52:03 zenith kernel: Bluetooth: SCO socket layer initialized Feb 22 11:52:03 zenith kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6 Feb 22 11:52:03 zenith kernel: usbcore: registered new interface driver brcmfmac Feb 22 11:52:03 zenith kernel: Bluetooth: HCI UART driver ver 2.3 Feb 22 11:52:03 zenith kernel: Bluetooth: HCI UART protocol H4 registered Feb 22 11:52:03 zenith kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered Feb 22 11:52:03 zenith systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Feb 22 11:52:03 zenith kernel: hci_uart_bcm serial0-0: supply vbat not found, using dummy regulator Feb 22 11:52:03 zenith kernel: hci_uart_bcm serial0-0: supply vddio not found, using dummy regulator Feb 22 11:52:03 zenith kernel: Bluetooth: HCI UART protocol Broadcom registered Feb 22 11:52:03 zenith systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Feb 22 11:52:03 zenith systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Feb 22 11:52:03 zenith systemd[1]: systemd-firstboot.service - First Boot Wizard was skipped because of an unmet condition check (ConditionFirstBoot=yes). Feb 22 11:52:03 zenith systemd[1]: first-boot-complete.target - First Boot Complete was skipped because of an unmet condition check (ConditionFirstBoot=yes). Feb 22 11:52:03 zenith systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Feb 22 11:52:03 zenith systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Feb 22 11:52:03 zenith systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Feb 22 11:52:03 zenith systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Feb 22 11:52:03 zenith systemd[1]: modprobe@loop.service: Deactivated successfully. Feb 22 11:52:03 zenith systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Feb 22 11:52:03 zenith systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Feb 22 11:52:03 zenith systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Feb 22 11:52:03 zenith systemd[1]: Listening on systemd-rfkill.socket - Load/Save RF Kill Switch Status /dev/rfkill Watch. Feb 22 11:52:03 zenith 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 22 11:52:03 zenith systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Feb 22 11:52:03 zenith systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Feb 22 11:52:03 zenith systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Feb 22 11:52:03 zenith systemd[1]: systemd-firstboot.service - First Boot Wizard was skipped because of an unmet condition check (ConditionFirstBoot=yes). Feb 22 11:52:03 zenith systemd[1]: first-boot-complete.target - First Boot Complete was skipped because of an unmet condition check (ConditionFirstBoot=yes). Feb 22 11:52:03 zenith systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Feb 22 11:52:03 zenith systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Feb 22 11:52:03 zenith systemd[1]: modprobe@loop.service: Deactivated successfully. Feb 22 11:52:03 zenith systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Feb 22 11:52:03 zenith systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Feb 22 11:52:03 zenith systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Feb 22 11:52:03 zenith systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Feb 22 11:52:03 zenith systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Feb 22 11:52:03 zenith kernel: brcmfmac: brcmf_c_process_txcap_blob: no txcap_blob available (err=-2) Feb 22 11:52:03 zenith 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 22 11:52:03 zenith (udev-worker)[560]: hci0: Process '/usr/bin/hciconfig hci0 up' failed with exit code 1. Feb 22 11:52:03 zenith systemd[1]: Starting systemd-rfkill.service - Load/Save RF Kill Switch Status... Feb 22 11:52:03 zenith systemd[1]: Reached target bluetooth.target - Bluetooth Support. Feb 22 11:52:03 zenith systemd[1]: Started systemd-rfkill.service - Load/Save RF Kill Switch Status. Feb 22 11:52:03 zenith (udev-worker)[561]: Network interface NamePolicy= disabled on kernel command line. Feb 22 11:52:03 zenith systemd[1]: Expecting device sys-subsystem-net-devices-wlan0.device - /sys/subsystem/net/devices/wlan0... Feb 22 11:52:03 zenith systemd[1]: Found device sys-subsystem-net-devices-wlan0.device - /sys/subsystem/net/devices/wlan0. Feb 22 11:52:03 zenith kernel: Bluetooth: hci0: BCM: chip id 107 Feb 22 11:52:03 zenith kernel: Bluetooth: hci0: BCM: features 0x2f Feb 22 11:52:03 zenith kernel: Bluetooth: hci0: BCM4345C0 Feb 22 11:52:03 zenith kernel: Bluetooth: hci0: BCM4345C0 (003.001.025) build 0000 Feb 22 11:52:03 zenith kernel: Bluetooth: hci0: BCM4345C0 'brcm/BCM4345C0.raspberrypi,5-model-b.hcd' Patch Feb 22 11:52:03 zenith systemd[1]: boot.mount: Directory /boot to mount over is not empty, mounting anyway. Feb 22 11:52:03 zenith systemd[1]: Mounting boot.mount - /boot... Feb 22 11:52:03 zenith systemd[1]: dev-hugepages.mount - Huge Pages File System was skipped because of an unmet condition check (ConditionPathExists=/sys/kernel/mm/hugepages). Feb 22 11:52:03 zenith systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Feb 22 11:52:03 zenith systemd[1]: Mounting tmp.mount - /tmp... Feb 22 11:52:03 zenith systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Feb 22 11:52:03 zenith systemd[1]: Mounting var-log.mount - /var/log... Feb 22 11:52:03 zenith systemd[1]: Mounting var-spool-cups.mount - /var/spool/cups... Feb 22 11:52:03 zenith systemd[1]: Mounted boot.mount - /boot. Feb 22 11:52:03 zenith systemd[1]: Mounted tmp.mount - /tmp. Feb 22 11:52:03 zenith systemd[1]: Mounted var-log.mount - /var/log. Feb 22 11:52:03 zenith systemd[1]: Mounted var-spool-cups.mount - /var/spool/cups. Feb 22 11:52:03 zenith systemd[1]: Mounting var-spool-cups-tmp.mount - /var/spool/cups/tmp... Feb 22 11:52:03 zenith systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Feb 22 11:52:03 zenith systemd[1]: Mounted var-spool-cups-tmp.mount - /var/spool/cups/tmp. Feb 22 11:52:03 zenith systemd[1]: Reached target local-fs.target - Local File Systems. Feb 22 11:52:03 zenith systemd-journald[525]: Runtime Journal (/run/log/journal/35c4ab2cb79e0973fdebde8c693341bc) is 3.7M, max 30.0M, 26.2M free. Feb 22 11:52:03 zenith systemd[1]: Started ifup@eth0.service - ifup for eth0. Feb 22 11:52:03 zenith systemd[1]: Started ifup@wlan0.service - ifup for wlan0. Feb 22 11:52:03 zenith systemd-journald[525]: Received client request to flush runtime journal. Feb 22 11:52:03 zenith systemd[1]: Starting networking.service - Raise network interfaces... Feb 22 11:52:03 zenith systemd[1]: Starting plymouth-read-write.service - Tell Plymouth To Write Out Runtime Data... Feb 22 11:52:03 zenith systemd[1]: Starting systemd-binfmt.service - Set Up Additional Binary Formats... Feb 22 11:52:03 zenith 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 22 11:52:03 zenith systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Feb 22 11:52:04 zenith systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Feb 22 11:52:04 zenith systemd[1]: Received SIGRTMIN+20 from PID 400 (plymouthd). Feb 22 11:52:04 zenith systemd[1]: Finished plymouth-read-write.service - Tell Plymouth To Write Out Runtime Data. Feb 22 11:52:04 zenith systemd[1]: proc-sys-fs-binfmt_misc.automount: Got automount request for /proc/sys/fs/binfmt_misc, triggered by 848 (systemd-binfmt) Feb 22 11:52:04 zenith kernel: warning: `iwconfig' uses wireless extensions which will stop working for Wi-Fi 7 hardware; use nl80211 Feb 22 11:52:04 zenith systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Feb 22 11:52:04 zenith sh[887]: dhcpcd-9.4.1 starting Feb 22 11:52:04 zenith dhcpcd[887]: dhcpcd-9.4.1 starting Feb 22 11:52:04 zenith dhcpcd[900]: DUID 00:01:00:01:30:c6:00:2d:2c:cf:67:95:e5:69 Feb 22 11:52:04 zenith dhcpcd[900]: dhcp_vendor: No such process Feb 22 11:52:04 zenith sh[887]: DUID 00:01:00:01:30:c6:00:2d:2c:cf:67:95:e5:69 Feb 22 11:52:04 zenith sh[887]: dhcp_vendor: No such process Feb 22 11:52:04 zenith systemd[1]: Started haveged.service - Entropy Daemon based on the HAVEGE algorithm. Feb 22 11:52:04 zenith systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Feb 22 11:52:04 zenith kernel: 8021q: 802.1Q VLAN Support v1.8 Feb 22 11:52:04 zenith systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Feb 22 11:52:04 zenith haveged[882]: haveged: command socket is listening at fd 3 Feb 22 11:52:04 zenith kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Feb 22 11:52:04 zenith dhcpcd[900]: eth0: waiting for carrier Feb 22 11:52:04 zenith kernel: macb 1f00100000.ethernet eth0: PHY [1f00100000.ethernet-ffffffff:01] driver [Broadcom BCM54213PE] (irq=POLL) Feb 22 11:52:04 zenith kernel: macb 1f00100000.ethernet eth0: configuring for phy/rgmii-id link mode Feb 22 11:52:04 zenith kernel: macb 1f00100000.ethernet: gem-ptp-timer ptp clock registered. Feb 22 11:52:04 zenith sh[887]: eth0: waiting for carrier Feb 22 11:52:04 zenith sh[970]: wlan0=wlan0 Feb 22 11:52:04 zenith systemd[1]: Finished networking.service - Raise network interfaces. Feb 22 11:52:04 zenith kernel: Bluetooth: hci0: BCM: features 0x2f Feb 22 11:52:04 zenith kernel: Bluetooth: hci0: BCM43455 37.4MHz Raspberry Pi 3+-0190 Feb 22 11:52:04 zenith kernel: Bluetooth: hci0: BCM4345C0 (003.001.025) build 0382 Feb 22 11:52:04 zenith kernel: Bluetooth: hci0: BCM: Using default device address (43:45:c0:00:1f:ac) Feb 22 11:52:04 zenith haveged[882]: haveged: ver: 1.9.14; arch: generic; vend: ; build: (gcc 10.2.1 CTV); collect: 128K Feb 22 11:52:04 zenith haveged[882]: haveged: cpu: (VC); data: 64K (V); inst: 64K (V); idx: 39/40; sz: 63356/63356 Feb 22 11:52:04 zenith haveged[882]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.99919 Feb 22 11:52:04 zenith haveged[882]: haveged: fills: 0, generated: 0 Feb 22 11:52:04 zenith systemd[1]: Mounting proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System... Feb 22 11:52:04 zenith systemd[1]: Mounted proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System. Feb 22 11:52:04 zenith systemd[1]: Finished systemd-binfmt.service - Set Up Additional Binary Formats. Feb 22 11:52:04 zenith systemd[1]: Reached target sysinit.target - System Initialization. Feb 22 11:52:04 zenith systemd[1]: Started apt-daily.timer - Daily apt download activities. Feb 22 11:52:04 zenith systemd[1]: Started apt-daily-upgrade.timer - Daily apt upgrade and clean activities. Feb 22 11:52:04 zenith systemd[1]: Started dpkg-db-backup.timer - Daily dpkg database backup timer. Feb 22 11:52:04 zenith systemd[1]: Started e2scrub_all.timer - Periodic ext4 Online Metadata Check for All Filesystems. Feb 22 11:52:04 zenith systemd[1]: Started fstrim.timer - Discard unused blocks once a week. Feb 22 11:52:04 zenith systemd[1]: Started ntpsec-rotate-stats.timer - Rotate ntpd stats daily. Feb 22 11:52:04 zenith systemd[1]: Started setdatetime-helper.timer - Volumio Time Sync Watchdog Timer. Feb 22 11:52:04 zenith systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Feb 22 11:52:04 zenith systemd[1]: Reached target timers.target - Timer Units. Feb 22 11:52:04 zenith systemd[1]: Listening on avahi-daemon.socket - Avahi mDNS/DNS-SD Stack Activation Socket. Feb 22 11:52:05 zenith systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Feb 22 11:52:05 zenith systemd[1]: Reached target sockets.target - Socket Units. Feb 22 11:52:05 zenith 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 22 11:52:05 zenith systemd[1]: Reached target basic.target - Basic System. Feb 22 11:52:05 zenith 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 22 11:52:05 zenith systemd[1]: Starting alsa-restore.service - Save/Restore Sound Card State... Feb 22 11:52:05 zenith systemd[1]: Starting avahi-daemon.service - Avahi mDNS/DNS-SD Stack... Feb 22 11:52:05 zenith systemd[1]: Starting dbus.service - D-Bus System Message Bus... Feb 22 11:52:05 zenith systemd[1]: Starting e2scrub_reap.service - Remove Stale Online ext4 Metadata Check Snapshots... Feb 22 11:52:05 zenith 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 22 11:52:05 zenith systemd[1]: headless_wireless.service - Copy user wpa_supplicant.conf was skipped because of an unmet condition check (ConditionPathExists=/boot/wpa_supplicant.conf). Feb 22 11:52:05 zenith systemd[1]: Starting dhcpcd.service - DHCP Client Daemon on all interfaces... Feb 22 11:52:05 zenith systemd[1]: Started iptables.service - Volumio Iptables Module. Feb 22 11:52:05 zenith systemd[1]: Starting loadcpufreq.service - LSB: Load kernel modules needed to enable cpufreq scaling... Feb 22 11:52:05 zenith systemd[1]: Starting rpi-eeprom-update.service - Check for Raspberry Pi EEPROM updates... Feb 22 11:52:05 zenith systemd[1]: Starting systemd-logind.service - User Login Management... Feb 22 11:52:05 zenith 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 22 11:52:05 zenith systemd[1]: Starting triggerhappy.service - triggerhappy global hotkey daemon... Feb 22 11:52:05 zenith systemd[1]: Started volumio-remote-updater.service - Volumio Remote OTA Updater. Feb 22 11:52:05 zenith systemd[1]: volumiossh.service - Volumio SSH enabler was skipped because of an unmet condition check (ConditionPathExistsGlob=/boot/ssh{,.txt}). Feb 22 11:52:05 zenith systemd[1]: Starting wireless.service - Wireless Services... Feb 22 11:52:05 zenith avahi-daemon[981]: Found user 'avahi' (UID 103) and group 'avahi' (GID 109). Feb 22 11:52:05 zenith avahi-daemon[981]: Successfully dropped root privileges. Feb 22 11:52:05 zenith avahi-daemon[981]: avahi-daemon 0.8 starting up. Feb 22 11:52:05 zenith alsactl[998]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Feb 22 11:52:05 zenith alsactl[998]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Feb 22 11:52:05 zenith alsactl[998]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2 Feb 22 11:52:05 zenith systemd[1]: e2scrub_reap.service: Deactivated successfully. Feb 22 11:52:05 zenith systemd[1]: Finished e2scrub_reap.service - Remove Stale Online ext4 Metadata Check Snapshots. Feb 22 11:52:05 zenith systemd[1]: Finished alsa-restore.service - Save/Restore Sound Card State. Feb 22 11:52:05 zenith systemd[1]: Reached target sound.target - Sound Card. Feb 22 11:52:05 zenith thd[992]: Unable to parse trigger line: Feb 22 11:52:05 zenith thd[992]: Unable to parse trigger line: Feb 22 11:52:05 zenith dhcpcd[984]: dhcpcd-9.4.1 starting Feb 22 11:52:05 zenith systemd[1]: Started triggerhappy.service - triggerhappy global hotkey daemon. Feb 22 11:52:05 zenith systemd[1]: Starting th-udev-rebind.service - Late rebind of input devices to triggerhappy... Feb 22 11:52:05 zenith th-udev-rebind.sh[1011]: Rebinding /dev/input/event0 to thd using --add... Feb 22 11:52:05 zenith dhcpcd[1008]: dev: loaded udev Feb 22 11:52:05 zenith th-udev-rebind.sh[1011]: Rebinding /dev/input/event1 to thd using --add... Feb 22 11:52:05 zenith th-udev-rebind.sh[1011]: Rebinding /dev/input/event2 to thd using --add... Feb 22 11:52:05 zenith rpi-eeprom-update[987]: WARNING: flashrom not found. Setting RPI_EEPROM_USE_FLASHROM to 0 Feb 22 11:52:05 zenith th-udev-rebind.sh[1011]: Rebinding /dev/input/event3 to thd using --add... Feb 22 11:52:05 zenith dhcpcd[984]: dhcp_vendor: No such process Feb 22 11:52:05 zenith dhcpcd[1008]: DUID 00:01:00:01:30:c6:00:2d:2c:cf:67:95:e5:69 Feb 22 11:52:05 zenith dhcpcd[1008]: dhcp_vendor: No such process Feb 22 11:52:05 zenith th-udev-rebind.sh[1011]: Rebinding /dev/input/event4 to thd using --add... Feb 22 11:52:05 zenith systemd[1]: Started dhcpcd.service - DHCP Client Daemon on all interfaces. Feb 22 11:52:05 zenith systemd[1]: th-udev-rebind.service: Deactivated successfully. Feb 22 11:52:05 zenith systemd[1]: Finished th-udev-rebind.service - Late rebind of input devices to triggerhappy. Feb 22 11:52:05 zenith systemd[1]: Started dbus.service - D-Bus System Message Bus. Feb 22 11:52:05 zenith avahi-daemon[981]: Successfully called chroot(). Feb 22 11:52:05 zenith avahi-daemon[981]: Successfully dropped remaining capabilities. Feb 22 11:52:05 zenith avahi-daemon[981]: Loading service file /services/volumio.service. Feb 22 11:52:05 zenith avahi-daemon[981]: Joining mDNS multicast group on interface lo.IPv4 with address 127.0.0.1. Feb 22 11:52:05 zenith avahi-daemon[981]: New relevant interface lo.IPv4 for mDNS. Feb 22 11:52:05 zenith avahi-daemon[981]: Network interface enumeration completed. Feb 22 11:52:05 zenith avahi-daemon[981]: Registering new address record for 127.0.0.1 on lo.IPv4. Feb 22 11:52:05 zenith dhcpcd[1008]: eth0: waiting for carrier Feb 22 11:52:05 zenith dhcpcd[1008]: wlan0: waiting for carrier Feb 22 11:52:05 zenith systemd[1]: Starting wpa_supplicant.service - WPA supplicant... Feb 22 11:52:05 zenith systemd[1]: Started avahi-daemon.service - Avahi mDNS/DNS-SD Stack. Feb 22 11:52:05 zenith systemd-logind[991]: New seat seat0. Feb 22 11:52:05 zenith systemd-logind[991]: Watching system buttons on /dev/input/event0 (pwr_button) Feb 22 11:52:05 zenith systemd-logind[991]: Watching system buttons on /dev/input/event1 (vc4-hdmi-0) Feb 22 11:52:05 zenith systemd-logind[991]: Watching system buttons on /dev/input/event3 (vc4-hdmi-1) Feb 22 11:52:05 zenith systemd[1]: Started systemd-logind.service - User Login Management. Feb 22 11:52:05 zenith loadcpufreq[986]: Loading cpufreq kernel modules...done (none). Feb 22 11:52:05 zenith systemd[1]: Started loadcpufreq.service - LSB: Load kernel modules needed to enable cpufreq scaling. Feb 22 11:52:05 zenith systemd[1]: Starting cpufrequtils.service - LSB: set CPUFreq kernel parameters... Feb 22 11:52:05 zenith wpa_supplicant[1032]: Successfully initialized wpa_supplicant Feb 22 11:52:05 zenith systemd[1]: Started wpa_supplicant.service - WPA supplicant. Feb 22 11:52:05 zenith systemd[1]: Reached target network.target - Network. Feb 22 11:52:05 zenith systemd[1]: Reached target network-online.target - Network is Online. Feb 22 11:52:05 zenith systemd[1]: Starting ifplugd.service - LSB: Brings up/down network automatically... Feb 22 11:52:05 zenith systemd[1]: Starting ntpsec.service - Network Time Service... Feb 22 11:52:05 zenith systemd[1]: Starting rc-local.service - /etc/rc.local Compatibility... Feb 22 11:52:05 zenith systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Feb 22 11:52:05 zenith systemd[1]: Starting ssh.service - OpenBSD Secure Shell server... Feb 22 11:52:05 zenith systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Feb 22 11:52:05 zenith systemd[1]: Started volumio-ipchange.service - Volumio IP Change Monitor. Feb 22 11:52:05 zenith systemd[1]: Started rc-local.service - /etc/rc.local Compatibility. Feb 22 11:52:05 zenith cpufrequtils[1089]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Feb 22 11:52:05 zenith systemd[1]: Started cpufrequtils.service - LSB: set CPUFreq kernel parameters. Feb 22 11:52:05 zenith systemd[1]: iptables.service: Deactivated successfully. Feb 22 11:52:05 zenith systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Feb 22 11:52:05 zenith systemd[1]: Starting plymouth-quit-wait.service - Hold until boot process finishes up... Feb 22 11:52:05 zenith ntpd[1110]: INIT: ntpd ntpsec-1.2.2: Starting Feb 22 11:52:05 zenith ntp-systemd-wrapper[1110]: 2026-02-22T11:52:05 ntpd[1110]: INIT: ntpd ntpsec-1.2.2: Starting Feb 22 11:52:05 zenith ntp-systemd-wrapper[1110]: 2026-02-22T11:52:05 ntpd[1110]: INIT: Command line: /usr/sbin/ntpd -p /run/ntpd.pid -c /etc/ntpsec/ntp.conf -g -N -u ntpsec:ntpsec Feb 22 11:52:05 zenith ntpd[1110]: INIT: Command line: /usr/sbin/ntpd -p /run/ntpd.pid -c /etc/ntpsec/ntp.conf -g -N -u ntpsec:ntpsec Feb 22 11:52:05 zenith systemd[1]: Started ntpsec.service - Network Time Service. Feb 22 11:52:05 zenith ifplugd(eth0)[1149]: ifplugd 0.28 initializing. Feb 22 11:52:05 zenith ifplugd(eth0)[1149]: Using interface eth0/2C:CF:67:95:E5:67 with driver (version: 6.12.47-v8+) Feb 22 11:52:05 zenith ifplugd(eth0)[1149]: Using detection mode: SIOCETHTOOL Feb 22 11:52:05 zenith ifplugd(eth0)[1149]: Initialization complete, link beat not detected. Feb 22 11:52:05 zenith rpi-eeprom-update[987]: BOOTLOADER: up to date Feb 22 11:52:05 zenith rpi-eeprom-update[987]: CURRENT: Wed Nov 5 17:37:18 UTC 2025 (1762364238) Feb 22 11:52:05 zenith rpi-eeprom-update[987]: LATEST: Wed Nov 5 17:37:18 UTC 2025 (1762364238) Feb 22 11:52:05 zenith rpi-eeprom-update[987]: RELEASE: default (/usr/lib/firmware/raspberrypi/bootloader-2712/default) Feb 22 11:52:05 zenith rpi-eeprom-update[987]: Use raspi-config to change the release. Feb 22 11:52:05 zenith systemd[1]: Finished rpi-eeprom-update.service - Check for Raspberry Pi EEPROM updates. Feb 22 11:52:05 zenith ntpd[1140]: INIT: precision = 0.370 usec (-21) Feb 22 11:52:05 zenith ntpd[1140]: INIT: successfully locked into RAM Feb 22 11:52:05 zenith ntpd[1140]: CONFIG: readconfig: parsing file: /etc/ntpsec/ntp.conf Feb 22 11:52:05 zenith ntpd[1140]: CONFIG: restrict nopeer ignored Feb 22 11:52:05 zenith ntpd[1140]: CLOCK: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Feb 22 11:52:05 zenith ntpd[1140]: CLOCK: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2026-06-28T00:00Z last=2017-01-01T00:00Z ofs=37 Feb 22 11:52:05 zenith ntpd[1140]: INIT: Using SO_TIMESTAMPNS(ns) Feb 22 11:52:05 zenith ntpd[1140]: IO: Listen and drop on 0 v6wildcard [::]:123 Feb 22 11:52:05 zenith ntpd[1140]: IO: Listen and drop on 1 v4wildcard 0.0.0.0:123 Feb 22 11:52:05 zenith ntpd[1140]: IO: Listen normally on 2 lo 127.0.0.1:123 Feb 22 11:52:05 zenith ntpd[1140]: IO: Listening on routing socket on fd #19 for interface updates Feb 22 11:52:05 zenith ntpd[1140]: INIT: This system has a 32-bit time_t. Feb 22 11:52:05 zenith ntpd[1140]: INIT: This ntpd will fail on 2038-01-19T03:14:07Z. Feb 22 11:52:05 zenith ntpd[1140]: INIT: MRU 13107 entries, 13 hash bits, 32768 bytes Feb 22 11:52:05 zenith ntpd[1140]: INIT: Built with OpenSSL 3.0.9 30 May 2023, 30000090 Feb 22 11:52:05 zenith ntpd[1140]: INIT: Running with OpenSSL 3.0.17 1 Jul 2025, 30000110 Feb 22 11:52:05 zenith ntpd[1140]: NTSc: Using system default root certificates. Feb 22 11:52:05 zenith ifplugd[1094]: Network Interface Plugging Daemon...start eth0...done. Feb 22 11:52:05 zenith systemd[1]: Started ifplugd.service - LSB: Brings up/down network automatically. Feb 22 11:52:05 zenith sshd[1164]: Server listening on 0.0.0.0 port 22. Feb 22 11:52:05 zenith sshd[1164]: Server listening on :: port 22. Feb 22 11:52:05 zenith systemd[1]: Started ssh.service - OpenBSD Secure Shell server. Feb 22 11:52:05 zenith volumio-remote-updater[993]: Volumio OTA Client: 1.7.0 Feb 22 11:52:05 zenith volumio-remote-updater[993]: Error: No active session Feb 22 11:52:05 zenith volumio-remote-updater[993]: [2026-02-22 11:52:05] [info] asio async_connect error: asio.system:111 (Connection refused) Feb 22 11:52:05 zenith volumio-remote-updater[993]: [2026-02-22 11:52:05] [info] Error getting remote endpoint: asio.system:107 (Transport endpoint is not connected) Feb 22 11:52:05 zenith volumio-remote-updater[993]: [2026-02-22 11:52:05] [error] handle_connect error: Connection refused Feb 22 11:52:05 zenith ntpd[1140]: statistics directory /var/log/ntpsec/ does not exist or is unwriteable, error No such file or directory Feb 22 11:52:05 zenith wireless.js[994]: WIRELESS.JS: Single Network Mode enabled, only one network device can be active at a time between ethernet and wireless Feb 22 11:52:05 zenith wireless.js[994]: WIRELESS.JS: Wireless.js initializing wireless flow Feb 22 11:52:05 zenith wireless.js[994]: WIRELESS.JS: Cleaning previous... Feb 22 11:52:05 zenith sudo[1192]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 Feb 22 11:52:05 zenith sudo[1192]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 22 11:52:05 zenith sudo[1192]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:05 zenith sudo[1194]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down Feb 22 11:52:05 zenith sudo[1194]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 22 11:52:05 zenith avahi-daemon[981]: Server startup complete. Host name is zenith.local. Local service cookie is 622962300. Feb 22 11:52:06 zenith sudo[1194]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:06 zenith wireless.js[994]: WIRELESS.JS: Stopped aP Feb 22 11:52:06 zenith sudo[1202]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Feb 22 11:52:06 zenith sudo[1202]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 11:52:06 zenith sudo[1202]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:06 zenith kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Feb 22 11:52:06 zenith sudo[1204]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Feb 22 11:52:06 zenith sudo[1204]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 11:52:06 zenith sudo[1204]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:06 zenith sudo[1212]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Feb 22 11:52:06 zenith sudo[1212]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 11:52:06 zenith sudo[1212]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:06 zenith sudo[1214]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Feb 22 11:52:06 zenith sudo[1214]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 11:52:06 zenith ntpd[1140]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101 Feb 22 11:52:06 zenith ntpd[1140]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101 Feb 22 11:52:06 zenith ntpd[1140]: DNS: dns_check: DNS error: -11, System error Feb 22 11:52:06 zenith ntpd[1140]: DNS: dns_take_status: 0.debian.pool.ntp.org=>error, 12 Feb 22 11:52:06 zenith avahi-daemon[981]: Service "Zenith" (/services/volumio.service) successfully established. Feb 22 11:52:07 zenith ntpd[1140]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101 Feb 22 11:52:07 zenith ntpd[1140]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101 Feb 22 11:52:07 zenith ntpd[1140]: DNS: dns_check: DNS error: -11, System error Feb 22 11:52:07 zenith ntpd[1140]: DNS: dns_take_status: 1.debian.pool.ntp.org=>error, 12 Feb 22 11:52:08 zenith ntpd[1140]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101 Feb 22 11:52:08 zenith ntpd[1140]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101 Feb 22 11:52:08 zenith ntpd[1140]: DNS: dns_check: DNS error: -11, System error Feb 22 11:52:08 zenith ntpd[1140]: DNS: dns_take_status: 2.debian.pool.ntp.org=>error, 12 Feb 22 11:52:08 zenith systemd[1]: systemd-rfkill.service: Deactivated successfully. Feb 22 11:52:09 zenith sudo[1214]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:09 zenith wireless.js[994]: WIRELESS.JS: SETTING APPROPRIATE REG DOMAIN: US Feb 22 11:52:09 zenith sudo[1241]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Feb 22 11:52:09 zenith sudo[1241]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 11:52:09 zenith sudo[1241]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:09 zenith sudo[1243]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set US Feb 22 11:52:09 zenith sudo[1243]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 11:52:09 zenith sudo[1243]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:09 zenith wireless.js[994]: WIRELESS.JS: SUCCESSFULLY SET NEW REGDOMAIN: US Feb 22 11:52:09 zenith wireless.js[994]: WIRELESS.JS: Start wireless flow Feb 22 11:52:09 zenith wireless.js[994]: WIRELESS.JS: Stopped hotspot (if there).. Feb 22 11:52:09 zenith sudo[1253]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 Feb 22 11:52:09 zenith sudo[1253]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 22 11:52:09 zenith sudo[1253]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:09 zenith sudo[1255]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down Feb 22 11:52:09 zenith sudo[1255]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 22 11:52:09 zenith ntpd[1140]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101 Feb 22 11:52:09 zenith ntpd[1140]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101 Feb 22 11:52:09 zenith ntpd[1140]: DNS: dns_check: DNS error: -11, System error Feb 22 11:52:09 zenith ntpd[1140]: DNS: dns_take_status: 3.debian.pool.ntp.org=>error, 12 Feb 22 11:52:09 zenith sudo[1255]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:09 zenith wireless.js[994]: WIRELESS.JS: DHCP IP fallback Feb 22 11:52:09 zenith wireless.js[994]: WIRELESS.JS: Start ap Feb 22 11:52:09 zenith wpa_supplicant[1261]: Successfully initialized wpa_supplicant Feb 22 11:52:09 zenith sudo[1262]: root : PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Feb 22 11:52:09 zenith sudo[1262]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 22 11:52:09 zenith dhcpcd[1008]: control command: /sbin/dhcpcd Feb 22 11:52:09 zenith sudo[1262]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:09 zenith dhcpcd[1008]: control_free: No such file or directory Feb 22 11:52:09 zenith dhcpcd[1008]: lo: IAID 00:00:00:00 Feb 22 11:52:09 zenith dhcpcd[1008]: lo: adding address fe80::6430:6751:43e0:3f69 Feb 22 11:52:09 zenith dhcpcd[1008]: ipv6_addaddr1: Permission denied Feb 22 11:52:09 zenith dhcpcd[1008]: lo: using static address 127.0.0.1/8 Feb 22 11:52:09 zenith dhcpcd[1008]: lo: adding route to 127.0.0.0/8 Feb 22 11:52:09 zenith kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Feb 22 11:52:09 zenith systemd[1]: Reached target ip-changed@lo.target - IP Address changed on lo. Feb 22 11:52:09 zenith wpa_supplicant[1261]: nl80211: kernel reports: Registration to specific type not supported Feb 22 11:52:10 zenith volumio-remote-updater[993]: [2026-02-22 11:52:10] [info] asio async_connect error: asio.system:111 (Connection refused) Feb 22 11:52:10 zenith volumio-remote-updater[993]: [2026-02-22 11:52:10] [info] Error getting remote endpoint: asio.system:107 (Transport endpoint is not connected) Feb 22 11:52:10 zenith volumio-remote-updater[993]: [2026-02-22 11:52:10] [error] handle_connect error: Connection refused Feb 22 11:52:10 zenith wireless.js[994]: WIRELESS.JS: trying... Feb 22 11:52:10 zenith sudo[1294]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 22 11:52:10 zenith sudo[1294]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 11:52:10 zenith sudo[1294]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:10 zenith bash[1104]: setdatetime-helper: all HTTPS Date fallbacks failed Feb 22 11:52:10 zenith systemd[1]: setdatetime-helper.service: Deactivated successfully. Feb 22 11:52:10 zenith systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Feb 22 11:52:11 zenith wireless.js[994]: WIRELESS.JS: trying... Feb 22 11:52:11 zenith sudo[1299]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 22 11:52:11 zenith sudo[1299]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 11:52:11 zenith sudo[1299]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:12 zenith wpa_supplicant[1291]: wlan0: Trying to associate with d8:8e:d4:11:15:e7 (SSID='18070Farm' freq=5500 MHz) Feb 22 11:52:12 zenith wireless.js[994]: WIRELESS.JS: trying... Feb 22 11:52:12 zenith sudo[1303]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 22 11:52:12 zenith sudo[1303]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 11:52:12 zenith sudo[1303]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:12 zenith wpa_supplicant[1291]: wlan0: Associated with d8:8e:d4:11:15:e7 Feb 22 11:52:12 zenith wpa_supplicant[1291]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Feb 22 11:52:12 zenith wpa_supplicant[1291]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=US Feb 22 11:52:12 zenith wpa_supplicant[1291]: wlan0: WPA: Key negotiation completed with d8:8e:d4:11:15:e7 [PTK=CCMP GTK=CCMP] Feb 22 11:52:12 zenith wpa_supplicant[1291]: wlan0: CTRL-EVENT-CONNECTED - Connection to d8:8e:d4:11:15:e7 completed [id=0 id_str=] Feb 22 11:52:12 zenith dhcpcd[1008]: wlan0: carrier acquired Feb 22 11:52:12 zenith dhcpcd[1008]: wlan0: connected to Access Point: 18070Farm Feb 22 11:52:12 zenith dhcpcd[1008]: wlan0: IAID 67:95:e5:69 Feb 22 11:52:12 zenith dhcpcd[1008]: wlan0: adding address fe80::422e:83e0:3e32:602d Feb 22 11:52:12 zenith dhcpcd[1008]: ipv6_addaddr1: Permission denied Feb 22 11:52:13 zenith dhcpcd[1008]: wlan0: soliciting an IPv6 router Feb 22 11:52:13 zenith wireless.js[994]: WIRELESS.JS: trying... Feb 22 11:52:13 zenith sudo[1308]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 22 11:52:13 zenith sudo[1308]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 11:52:13 zenith sudo[1308]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:14 zenith dhcpcd[1008]: wlan0: rebinding lease of 192.168.133.234 Feb 22 11:52:14 zenith dhcpcd[1008]: wlan0: probing address 192.168.133.234/24 Feb 22 11:52:14 zenith wireless.js[994]: WIRELESS.JS: trying... Feb 22 11:52:14 zenith sudo[1314]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 22 11:52:14 zenith sudo[1314]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 11:52:14 zenith sudo[1314]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:15 zenith wireless.js[994]: WIRELESS.JS: trying... Feb 22 11:52:15 zenith sudo[1318]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 22 11:52:15 zenith sudo[1318]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 11:52:15 zenith sudo[1318]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:16 zenith wireless.js[994]: WIRELESS.JS: trying... Feb 22 11:52:16 zenith sudo[1322]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 22 11:52:16 zenith sudo[1322]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 11:52:16 zenith sudo[1322]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:17 zenith wireless.js[994]: WIRELESS.JS: trying... Feb 22 11:52:17 zenith sudo[1326]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 22 11:52:17 zenith sudo[1326]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 11:52:17 zenith sudo[1326]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:17 zenith volumio-remote-updater[993]: [2026-02-22 11:52:17] [info] asio async_connect error: asio.system:111 (Connection refused) Feb 22 11:52:17 zenith volumio-remote-updater[993]: [2026-02-22 11:52:17] [info] Error getting remote endpoint: asio.system:107 (Transport endpoint is not connected) Feb 22 11:52:17 zenith volumio-remote-updater[993]: [2026-02-22 11:52:17] [error] handle_connect error: Connection refused Feb 22 11:52:18 zenith wireless.js[994]: WIRELESS.JS: trying... Feb 22 11:52:18 zenith sudo[1330]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 22 11:52:18 zenith sudo[1330]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 11:52:18 zenith sudo[1330]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:18 zenith dhcpcd[1008]: wlan0: leased 192.168.133.234 for 86400 seconds Feb 22 11:52:18 zenith avahi-daemon[981]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.133.234. Feb 22 11:52:18 zenith avahi-daemon[981]: New relevant interface wlan0.IPv4 for mDNS. Feb 22 11:52:18 zenith avahi-daemon[981]: Registering new address record for 192.168.133.234 on wlan0.IPv4. Feb 22 11:52:18 zenith dhcpcd[1008]: wlan0: adding route to 192.168.133.0/24 Feb 22 11:52:18 zenith dhcpcd[1008]: wlan0: adding default route via 192.168.133.1 Feb 22 11:52:18 zenith systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. Feb 22 11:52:19 zenith wireless.js[994]: WIRELESS.JS: trying... Feb 22 11:52:19 zenith sudo[1355]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 22 11:52:19 zenith sudo[1355]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 11:52:19 zenith sudo[1355]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:19 zenith wireless.js[994]: WIRELESS.JS: Connected to: ----18070Farm---- Feb 22 11:52:19 zenith sudo[1358]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 22 11:52:19 zenith sudo[1358]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 22 11:52:19 zenith sudo[1358]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:19 zenith wireless.js[994]: WIRELESS.JS: ... joined AP, wlan0 IPv4 is 192.168.133.234, ipV6 is undefined Feb 22 11:52:19 zenith wireless.js[994]: WIRELESS.JS: It's done! AP Feb 22 11:52:19 zenith wireless.js[994]: WIRELESS.JS: Restarting avahi-daemon... Feb 22 11:52:19 zenith avahi-daemon[981]: Got SIGTERM, quitting. Feb 22 11:52:19 zenith systemd[1]: Stopping avahi-daemon.service - Avahi mDNS/DNS-SD Stack... Feb 22 11:52:19 zenith avahi-daemon[981]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.133.234. Feb 22 11:52:19 zenith avahi-daemon[981]: Leaving mDNS multicast group on interface lo.IPv4 with address 127.0.0.1. Feb 22 11:52:19 zenith avahi-daemon[981]: avahi-daemon 0.8 exiting. Feb 22 11:52:19 zenith systemd[1]: avahi-daemon.service: Deactivated successfully. Feb 22 11:52:19 zenith systemd[1]: Stopped avahi-daemon.service - Avahi mDNS/DNS-SD Stack. Feb 22 11:52:19 zenith systemd[1]: Starting avahi-daemon.service - Avahi mDNS/DNS-SD Stack... Feb 22 11:52:19 zenith avahi-daemon[1364]: Process 981 died: No such process; trying to remove PID file. (/run/avahi-daemon//pid) Feb 22 11:52:19 zenith avahi-daemon[1364]: Found user 'avahi' (UID 103) and group 'avahi' (GID 109). Feb 22 11:52:19 zenith wireless.js[994]: WIRELESS.JS: Notified systemd about wireless ready Feb 22 11:52:19 zenith avahi-daemon[1364]: Successfully dropped root privileges. Feb 22 11:52:19 zenith avahi-daemon[1364]: avahi-daemon 0.8 starting up. Feb 22 11:52:19 zenith systemd[1]: Started avahi-daemon.service - Avahi mDNS/DNS-SD Stack. Feb 22 11:52:19 zenith avahi-daemon[1364]: Successfully called chroot(). Feb 22 11:52:19 zenith avahi-daemon[1364]: Successfully dropped remaining capabilities. Feb 22 11:52:19 zenith avahi-daemon[1364]: Loading service file /services/volumio.service. Feb 22 11:52:19 zenith avahi-daemon[1364]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.133.234. Feb 22 11:52:19 zenith avahi-daemon[1364]: New relevant interface wlan0.IPv4 for mDNS. Feb 22 11:52:19 zenith avahi-daemon[1364]: Joining mDNS multicast group on interface lo.IPv4 with address 127.0.0.1. Feb 22 11:52:19 zenith avahi-daemon[1364]: New relevant interface lo.IPv4 for mDNS. Feb 22 11:52:19 zenith avahi-daemon[1364]: Network interface enumeration completed. Feb 22 11:52:19 zenith avahi-daemon[1364]: Registering new address record for 192.168.133.234 on wlan0.IPv4. Feb 22 11:52:19 zenith avahi-daemon[1364]: Registering new address record for 127.0.0.1 on lo.IPv4. Feb 22 11:52:19 zenith kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Feb 22 11:52:19 zenith systemd[1]: Started wireless.service - Wireless Services. Feb 22 11:52:19 zenith systemd[1]: Started volumio.service - Volumio Backend Module. Feb 22 11:52:19 zenith systemd[1]: Starting plymouth-quit.service - Terminate Plymouth Boot Screen... Feb 22 11:52:19 zenith systemd[1]: Started volumio_cpu_tweak.service - Volumio Cpu Tweaker. Feb 22 11:52:19 zenith systemd[1]: Received SIGRTMIN+21 from PID 400 (plymouthd). Feb 22 11:52:19 zenith volumio-cpu-tweak[1370]: Setting RT Priority for mpd Feb 22 11:52:19 zenith volumio-cpu-tweak[1384]: pid 35's current scheduling policy: SCHED_OTHER Feb 22 11:52:19 zenith volumio-cpu-tweak[1384]: pid 35's current scheduling priority: 0 Feb 22 11:52:19 zenith volumio-cpu-tweak[1370]: Setting MPD Affinity Feb 22 11:52:19 zenith volumio-cpu-tweak[1385]: pid 3's current affinity mask: f Feb 22 11:52:19 zenith volumio-cpu-tweak[1370]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Feb 22 11:52:19 zenith volumio-cpu-tweak[1370]: VOLUMIO CPU TWEAK: Setting CPU Governor: conservative Feb 22 11:52:19 zenith systemd[1]: Finished plymouth-quit-wait.service - Hold until boot process finishes up. Feb 22 11:52:19 zenith systemd[1]: Finished plymouth-quit.service - Terminate Plymouth Boot Screen. Feb 22 11:52:19 zenith systemd[1]: Received SIGRTMIN+21 from PID 400 (plymouthd). Feb 22 11:52:19 zenith systemd[1]: Started getty@tty1.service - Getty on tty1. Feb 22 11:52:19 zenith systemd[1]: Started serial-getty@ttyAMA10.service - Serial Getty on ttyAMA10. Feb 22 11:52:19 zenith systemd[1]: Reached target getty.target - Login Prompts. Feb 22 11:52:19 zenith systemd[1]: Reached target multi-user.target - Multi-User System. Feb 22 11:52:19 zenith systemd[1]: Reached target graphical.target - Graphical Interface. Feb 22 11:52:19 zenith systemd[1]: Starting systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP... Feb 22 11:52:19 zenith systemd[1]: volumio_cpu_tweak.service: Deactivated successfully. Feb 22 11:52:19 zenith systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Feb 22 11:52:19 zenith systemd[1]: Finished systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP. Feb 22 11:52:19 zenith systemd[1]: Startup finished in 10.741s (kernel) + 17.235s (userspace) = 27.977s. Feb 22 11:52:20 zenith volumio[1368]: info: ------------------------------------------- Feb 22 11:52:20 zenith volumio[1368]: info: ----- Volumio3 ---- Feb 22 11:52:20 zenith volumio[1368]: info: ------------------------------------------- Feb 22 11:52:20 zenith volumio[1368]: info: ----- System startup ---- Feb 22 11:52:20 zenith volumio[1368]: info: ------------------------------------------- Feb 22 11:52:20 zenith ntpd[1140]: IO: Listen normally on 3 wlan0 192.168.133.234:123 Feb 22 11:52:20 zenith ntpd[1140]: IO: new interface(s) found: waking up resolver Feb 22 11:52:20 zenith ntpd[1140]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101 Feb 22 11:52:20 zenith ntpd[1140]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101 Feb 22 11:52:20 zenith ntpd[1140]: DNS: Pool taking: 23.168.24.210 Feb 22 11:52:20 zenith ntpd[1140]: DNS: Pool taking: 45.83.234.123 Feb 22 11:52:20 zenith ntpd[1140]: DNS: Pool taking: 64.142.122.38 Feb 22 11:52:20 zenith ntpd[1140]: DNS: Pool taking: 104.152.220.10 Feb 22 11:52:20 zenith ntpd[1140]: DNS: dns_take_status: 3.debian.pool.ntp.org=>good, 8 Feb 22 11:52:20 zenith volumio[1368]: info: MYVOLUMIO Environment detected Feb 22 11:52:20 zenith volumio[1368]: info: Plugin folders cleanup Feb 22 11:52:20 zenith volumio[1368]: info: Scanning into folder /volumio/app/plugins/ Feb 22 11:52:20 zenith volumio[1368]: info: Scanning category audio_interface Feb 22 11:52:20 zenith volumio[1368]: info: Scanning category miscellanea Feb 22 11:52:20 zenith volumio[1368]: info: Scanning category music_service Feb 22 11:52:20 zenith volumio[1368]: info: Scanning category plugins.json Feb 22 11:52:20 zenith volumio[1368]: info: Scanning category system_controller Feb 22 11:52:20 zenith volumio[1368]: info: Scanning category user_interface Feb 22 11:52:20 zenith volumio[1368]: info: Scanning into folder /data/plugins/ Feb 22 11:52:20 zenith volumio[1368]: info: Scanning category music_service Feb 22 11:52:20 zenith volumio[1368]: info: Scanning category system_controller Feb 22 11:52:20 zenith volumio[1368]: info: Scanning category user_interface Feb 22 11:52:20 zenith volumio[1368]: info: Plugin folders cleanup completed Feb 22 11:52:20 zenith volumio[1368]: info: ------------------------------------------- Feb 22 11:52:20 zenith volumio[1368]: info: ----- Core plugins startup ---- Feb 22 11:52:20 zenith volumio[1368]: info: ------------------------------------------- Feb 22 11:52:20 zenith volumio[1368]: info: Loading plugins from folder /volumio/app/plugins/ Feb 22 11:52:20 zenith volumio[1368]: info: Adding plugin upnp to MyMusic Plugins Feb 22 11:52:20 zenith volumio[1368]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 22 11:52:20 zenith volumio[1368]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 22 11:52:20 zenith volumio[1368]: info: Loading plugins from folder /data/plugins/ Feb 22 11:52:20 zenith volumio[1368]: info: Loading plugin "system"... Feb 22 11:52:20 zenith volumio[1368]: info: Loading plugin "appearance"... Feb 22 11:52:20 zenith avahi-daemon[1364]: Server startup complete. Host name is zenith.local. Local service cookie is 595150652. Feb 22 11:52:21 zenith volumio[1368]: info: Loading plugin "network"... Feb 22 11:52:21 zenith volumio[1368]: info: Refreshing Cached IP Addresses Feb 22 11:52:21 zenith sudo[1406]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 22 11:52:21 zenith sudo[1406]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 11:52:21 zenith sudo[1408]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 22 11:52:21 zenith sudo[1408]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 11:52:21 zenith sudo[1406]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:21 zenith sudo[1408]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:21 zenith volumio[1368]: info: Loading plugin "services"... Feb 22 11:52:21 zenith volumio[1368]: info: Loading plugin "alsa_controller"... Feb 22 11:52:21 zenith sudo[1417]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 22 11:52:21 zenith sudo[1417]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 11:52:21 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 22 11:52:21 zenith volumio[1368]: info: Loading plugin "wizard"... Feb 22 11:52:21 zenith volumio[1368]: info: Loading plugin "networkfs"... Feb 22 11:52:21 zenith volumio[1368]: info: Starting Udev Watcher for removable devices Feb 22 11:52:21 zenith sudo[1442]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=michel,password=mx68BL&BYF,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //library/data/media/music /mnt/NAS/Library Feb 22 11:52:21 zenith sudo[1442]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 11:52:21 zenith volumio[1368]: info: Ignoring mount for partition: boot Feb 22 11:52:21 zenith volumio[1368]: info: Ignoring mount for partition: volumio Feb 22 11:52:21 zenith volumio[1368]: info: Ignoring mount for partition: volumio_data Feb 22 11:52:21 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 22 11:52:21 zenith volumio[1368]: info: Loading plugin "volumio_command_line_client"... Feb 22 11:52:21 zenith volumio[1368]: info: Loading plugin "upnp"... Feb 22 11:52:21 zenith volumio[1368]: info: [1771779141102] Starting Upmpd Daemon Feb 22 11:52:21 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 22 11:52:21 zenith volumio[1368]: info: Loading plugin "my_music"... Feb 22 11:52:21 zenith volumio[1368]: info: Loading plugin "mpd"... Feb 22 11:52:21 zenith kernel: netfs: FS-Cache loaded Feb 22 11:52:21 zenith volumio[1368]: info: Loading plugin "upnp_browser"... Feb 22 11:52:21 zenith kernel: Key type cifs.spnego registered Feb 22 11:52:21 zenith kernel: Key type cifs.idmap registered Feb 22 11:52:21 zenith 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 22 11:52:21 zenith kernel: CIFS: Attempting to mount //library/data/media/music Feb 22 11:52:21 zenith ntpd[1140]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101 Feb 22 11:52:21 zenith avahi-daemon[1364]: Service "Zenith" (/services/volumio.service) successfully established. Feb 22 11:52:21 zenith volumio[1368]: info: Starting UPNP Browser Feb 22 11:52:21 zenith volumio[1368]: info: Loading plugin "alarm-clock"... Feb 22 11:52:21 zenith ntpd[1140]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101 Feb 22 11:52:21 zenith ntpd[1140]: DNS: Pool taking: 45.33.53.84 Feb 22 11:52:21 zenith ntpd[1140]: DNS: Pool taking: 51.81.226.229 Feb 22 11:52:21 zenith ntpd[1140]: DNS: Pool taking: 23.186.168.127 Feb 22 11:52:21 zenith ntpd[1140]: DNS: Pool taking: 23.186.168.123 Feb 22 11:52:21 zenith ntpd[1140]: DNS: Pool taking: 2602:fb95:16::123 Feb 22 11:52:21 zenith ntpd[1140]: DNS: Pool taking: 2a01:7e03::2000:93ff:fe22:34e4 Feb 22 11:52:21 zenith ntpd[1140]: DNS: Pool taking: 2602:feda:30:ae86:2fc:98ff:fecf:fe94 Feb 22 11:52:21 zenith ntpd[1140]: DNS: Pool taking: 2603:c024:c005:a600:efb6:d213:cad8:251d Feb 22 11:52:21 zenith ntpd[1140]: DNS: dns_take_status: 2.debian.pool.ntp.org=>good, 8 Feb 22 11:52:21 zenith volumio[1368]: info: Loading plugin "airplay_emulation"... Feb 22 11:52:21 zenith volumio[1368]: info: Starting Shairport Sync Feb 22 11:52:21 zenith volumio[1368]: info: Loading plugin "last_100"... Feb 22 11:52:21 zenith volumio[1368]: info: Loading plugin "webradio"... Feb 22 11:52:21 zenith volumio[1368]: info: Loading plugin "i2s_dacs"... Feb 22 11:52:21 zenith volumio[1368]: info: Loading plugin "volumiodiscovery"... Feb 22 11:52:21 zenith volumio[1368]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 22 11:52:21 zenith volumio[1368]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 22 11:52:21 zenith volumio[1368]: *** WARNING *** For more information see Feb 22 11:52:21 zenith volumio[1368]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 22 11:52:21 zenith volumio[1368]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 22 11:52:21 zenith volumio[1368]: *** WARNING *** For more information see Feb 22 11:52:21 zenith node[1368]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 22 11:52:21 zenith node[1368]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 22 11:52:21 zenith node[1368]: *** WARNING *** For more information see Feb 22 11:52:21 zenith node[1368]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 22 11:52:21 zenith node[1368]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 22 11:52:21 zenith node[1368]: *** WARNING *** For more information see Feb 22 11:52:21 zenith volumio[1368]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 22 11:52:21 zenith volumio[1368]: info: Discovery: Started advertising with name: Zenith Feb 22 11:52:21 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 22 11:52:21 zenith volumio[1368]: info: Loading plugin "spop"... Feb 22 11:52:21 zenith volumio[1368]: info: Loading plugin "outputs"... Feb 22 11:52:21 zenith volumio[1368]: info: Loading plugin "albumart"... Feb 22 11:52:21 zenith volumio[1368]: info: Plugin example_plugin is not enabled Feb 22 11:52:21 zenith volumio[1368]: info: Loading plugin "inputs"... Feb 22 11:52:21 zenith volumio[1368]: info: Loading plugin "updater_comm"... Feb 22 11:52:21 zenith volumio[1368]: info: Plugin mpdemulation is not enabled Feb 22 11:52:21 zenith volumio[1368]: info: Loading plugin "rest_api"... Feb 22 11:52:21 zenith volumio[1368]: info: Loading plugin "websocket"... Feb 22 11:52:21 zenith volumio[1368]: info: Starting Socket.io Server version 1.7.4 Feb 22 11:52:21 zenith volumio[1368]: info: Loading plugin "backup_restore"... Feb 22 11:52:22 zenith volumio[1471]: Forking 3 albumart workers Feb 22 11:52:22 zenith volumio[1368]: info: Applying required configuration parameters for plugin backup_restore Feb 22 11:52:22 zenith volumio[1368]: info: Loading plugin "Systeminfo"... Feb 22 11:52:22 zenith sudo[1442]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:22 zenith volumio[1368]: info: Loading i18n strings for locale en Feb 22 11:52:22 zenith volumio[1368]: Updating browse sources language Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::initPlayerControls Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 22 11:52:22 zenith volumio[1368]: Express server listening on port 3000 Feb 22 11:52:22 zenith volumio[1368]: [Metrics] WebUI: 2s 33.85ms Feb 22 11:52:22 zenith volumio[1368]: info: CoreStateMachine::resetVolumioState Feb 22 11:52:22 zenith volumio[1368]: info: CoreStateMachine::getcurrentVolume Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::volumioRetrievevolume Feb 22 11:52:22 zenith volumio[1368]: info: Volumio Network Manager: Network status updated: 2 Feb 22 11:52:22 zenith volumio[1368]: info: VolumeController:: Volume=32 Mute =false Feb 22 11:52:22 zenith volumio[1368]: info: CoreStateMachine::pushState Feb 22 11:52:22 zenith volumio[1368]: info: CorePlayQueue::getTrack 0 Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::volumioPushState Feb 22 11:52:22 zenith volumio[1368]: info: CoreStateMachine::updateTrackBlock Feb 22 11:52:22 zenith volumio[1368]: info: CorePlayQueue::getTrackBlock Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::volumioRetrievevolume Feb 22 11:52:22 zenith volumio[1482]: Starting albumart workers Feb 22 11:52:22 zenith volumio[1483]: Starting albumart workers Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 11:52:22 zenith volumio[1368]: info: Reloading queue from file Feb 22 11:52:22 zenith volumio[1368]: info: CoreStateMachine::setRepeat null single undefined Feb 22 11:52:22 zenith volumio[1368]: info: CoreStateMachine::pushState Feb 22 11:52:22 zenith volumio[1368]: info: CorePlayQueue::getTrack 0 Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::volumioPushState Feb 22 11:52:22 zenith volumio[1368]: info: CoreStateMachine::setRandom null Feb 22 11:52:22 zenith volumio[1368]: info: CoreStateMachine::pushState Feb 22 11:52:22 zenith volumio[1368]: info: CorePlayQueue::getTrack 0 Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::volumioPushState Feb 22 11:52:22 zenith volumio[1368]: info: Setting Device type: Raspberry PI Feb 22 11:52:22 zenith volumio[1368]: info: Completed loading Core Plugins Feb 22 11:52:22 zenith volumio[1368]: info: Preparing to generate the ALSA configuration file Feb 22 11:52:22 zenith volumio[1368]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Feb 22 11:52:22 zenith volumio[1368]: info: USB Boot Capable - System SBC Revision found in cpuinfo: d04170 Feb 22 11:52:22 zenith volumio[1368]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Feb 22 11:52:22 zenith volumio[1368]: info: VolumeController:: Volume=32 Mute =false Feb 22 11:52:22 zenith volumio[1368]: info: CoreStateMachine::pushState Feb 22 11:52:22 zenith volumio[1368]: info: CorePlayQueue::getTrack 0 Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::volumioPushState Feb 22 11:52:22 zenith volumio[1368]: info: Asound.conf file unchanged, so no further update is needed Feb 22 11:52:22 zenith volumio[1368]: info: Output device has changed, restarting MPD Feb 22 11:52:22 zenith volumio[1481]: Starting albumart workers Feb 22 11:52:22 zenith volumio[1368]: info: Output device has changed, restarting Shairport Sync Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 11:52:22 zenith sudo[1533]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 22 11:52:22 zenith sudo[1532]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 22 11:52:22 zenith sudo[1532]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 11:52:22 zenith sudo[1533]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 11:52:22 zenith sudo[1532]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:22 zenith volumio[1368]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 22 11:52:22 zenith volumio[1368]: info: ___________ START PLUGINS ___________ Feb 22 11:52:22 zenith volumio[1368]: info: ControllerMpd::onStart: Initializing MPD Feb 22 11:52:22 zenith volumio[1368]: info: Creating MPD Configuration file Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 22 11:52:22 zenith volumio[1368]: info: [1771779142414] CoreMusicLibrary::Adding element Media Servers Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 22 11:52:22 zenith volumio[1368]: info: UPNP Browser: Client initialized successfully Feb 22 11:52:22 zenith sudo[1542]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 22 11:52:22 zenith sudo[1542]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 11:52:22 zenith sudo[1542]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:22 zenith sudo[1544]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 22 11:52:22 zenith sudo[1544]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 11:52:22 zenith systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 22 11:52:22 zenith volumio[1368]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 11:52:22 zenith systemd[1]: Starting mpd.service - Music Player Daemon... Feb 22 11:52:22 zenith systemd[1]: mpd.service: Deactivated successfully. Feb 22 11:52:22 zenith volumio[1368]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 22 11:52:22 zenith volumio[1368]: info: [1771779142463] CoreMusicLibrary::Adding element Last_100 Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 22 11:52:22 zenith volumio[1368]: info: [1771779142464] CoreMusicLibrary::Adding element Webradio Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 22 11:52:22 zenith systemd[1]: Stopped mpd.service - Music Player Daemon. Feb 22 11:52:22 zenith systemd[1]: mpd.socket: Deactivated successfully. Feb 22 11:52:22 zenith systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Feb 22 11:52:22 zenith systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 22 11:52:22 zenith volumio[1368]: info: Initializing BBC Radios Feb 22 11:52:22 zenith systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 22 11:52:22 zenith systemd[1]: Starting mpd.service - Music Player Daemon... Feb 22 11:52:22 zenith ntpd[1140]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101 Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 11:52:22 zenith sudo[1557]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 22 11:52:22 zenith sudo[1557]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 22 11:52:22 zenith sudo[1588]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Feb 22 11:52:22 zenith sudo[1557]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:22 zenith volumio[1368]: info: Creating Spotify config file Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 11:52:22 zenith ntpd[1140]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101 Feb 22 11:52:22 zenith ntpd[1140]: DNS: Pool taking: 208.113.130.146 Feb 22 11:52:22 zenith ntpd[1140]: DNS: Pool taking: 141.11.89.193 Feb 22 11:52:22 zenith ntpd[1140]: DNS: Pool taking: 67.217.246.204 Feb 22 11:52:22 zenith ntpd[1140]: DNS: Pool taking: 69.10.208.170 Feb 22 11:52:22 zenith ntpd[1140]: DNS: dns_take_status: 1.debian.pool.ntp.org=>good, 8 Feb 22 11:52:22 zenith volumio[1368]: info: Volumio Calling Home Feb 22 11:52:22 zenith volumio[1368]: info: MPD Permissions set Feb 22 11:52:22 zenith volumio[1368]: info: MPD Permissions set Feb 22 11:52:22 zenith volumio[1368]: info: Spotify config file written Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::volumioGetState Feb 22 11:52:22 zenith volumio[1368]: info: CorePlayQueue::getTrack 0 Feb 22 11:52:22 zenith sudo[1603]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Feb 22 11:52:22 zenith sudo[1603]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 11:52:22 zenith systemd[1]: /lib/systemd/system/go-librespot-daemon.service:9: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Feb 22 11:52:22 zenith systemd[1]: /lib/systemd/system/go-librespot-daemon.service:10: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Feb 22 11:52:22 zenith volumio[1368]: 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 22 11:52:22 zenith volumio[1368]: info: No need to fix Spotify hosts Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 11:52:22 zenith systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 22 11:52:22 zenith go-librespot[1605]: go-librespot daemon starting... Feb 22 11:52:22 zenith volumio[1368]: info: Starting Shairport Sync Feb 22 11:52:22 zenith sudo[1603]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:22 zenith volumio[1368]: info: Starting Shairport Sync Feb 22 11:52:22 zenith volumio[1368]: info: Starting Shairport Sync Feb 22 11:52:22 zenith sudo[1620]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 22 11:52:22 zenith sudo[1619]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 22 11:52:22 zenith sudo[1620]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 11:52:22 zenith sudo[1619]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 11:52:22 zenith sudo[1622]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 22 11:52:22 zenith sudo[1622]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 11:52:22 zenith go-librespot[1616]: time="2026-02-22T11:52:22-05:00" level=info msg="running go-librespot 0.4.0" Feb 22 11:52:22 zenith go-librespot[1616]: time="2026-02-22T11:52:22-05:00" level=debug msg="app state loaded" Feb 22 11:52:22 zenith go-librespot[1616]: time="2026-02-22T11:52:22-05:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 22 11:52:22 zenith systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 22 11:52:22 zenith sudo[1619]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:22 zenith sudo[1620]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:22 zenith volumio[1368]: info: Shairport-Sync Started Feb 22 11:52:22 zenith volumio[1368]: Error adding Membership: Error: addMembership EINVAL Feb 22 11:52:22 zenith sudo[1622]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:22 zenith volumio[1368]: info: Shairport-Sync Started Feb 22 11:52:22 zenith volumio[1368]: info: Shairport-Sync Started Feb 22 11:52:22 zenith volumio[1368]: info: Listing playlists Feb 22 11:52:22 zenith volumio[1368]: info: Listing playlists Feb 22 11:52:22 zenith volumio[1368]: info: Discovery: adding c4f84076-c4bc-4d19-9ff3-91769836aab1 Feb 22 11:52:22 zenith volumio[1368]: info: Discovery: Found device Zenith Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::volumioGetState Feb 22 11:52:22 zenith volumio[1368]: info: CorePlayQueue::getTrack 0 Feb 22 11:52:22 zenith volumio[1368]: info: Discovery: this is already registered, c4f84076-c4bc-4d19-9ff3-91769836aab1 Feb 22 11:52:22 zenith volumio[1368]: info: Discovery: Found device Zenith Feb 22 11:52:22 zenith volumio[1368]: info: CoreCommandRouter::volumioGetState Feb 22 11:52:22 zenith volumio[1368]: info: CorePlayQueue::getTrack 0 Feb 22 11:52:22 zenith volumio[1368]: info: Volumio called home Feb 22 11:52:23 zenith volumio[1368]: info: CoreCommandRouter::volumioGetState Feb 22 11:52:23 zenith volumio[1368]: info: CorePlayQueue::getTrack 0 Feb 22 11:52:23 zenith volumio[1368]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Feb 22 11:52:23 zenith volumio[1368]: SPOTIFY: BQBVf71L2UDn4LWG2L-HFXiESDcYYiG-QCaHzxZ6NPValDi9Cfllx8UjJ_x3--2OhmAV_6kjfsUT-uaTLbVoCC-whC0abHf14TieT62TKYtrFsH4AEpy1hw-qiyJ9eLKnvZMCNjI_TcB1JCIEK0jIsLMtfZUtvjz7vJ9sd9svPlqYP-guW46o4RHaNp6SZPodjWneMIGJTzJni1XZMdEbNpXDTid-oQ9qDJL3RDfiVJBAH6xktmeI1odBGid4R1FcpotNlwA5e6jV7Go8cxRLyqjnLys5q1A5vg Feb 22 11:52:23 zenith volumio[1368]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Feb 22 11:52:23 zenith volumio[1368]: info: New Spotify access token = BQBVf71L2UDn4LWG2L-HFXiESDcYYiG-QCaHzxZ6NPValDi9Cfllx8UjJ_x3--2OhmAV_6kjfsUT-uaTLbVoCC-whC0abHf14TieT62TKYtrFsH4AEpy1hw-qiyJ9eLKnvZMCNjI_TcB1JCIEK0jIsLMtfZUtvjz7vJ9sd9svPlqYP-guW46o4RHaNp6SZPodjWneMIGJTzJni1XZMdEbNpXDTid-oQ9qDJL3RDfiVJBAH6xktmeI1odBGid4R1FcpotNlwA5e6jV7Go8cxRLyqjnLys5q1A5vg Feb 22 11:52:23 zenith volumio[1368]: info: Spotify credentials grant success - running version from March 24, 2019 Feb 22 11:52:23 zenith go-librespot[1616]: time="2026-02-22T11:52:23-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gae2.spotify.com:443 ap-gew1.spotify.com:80]" Feb 22 11:52:23 zenith go-librespot[1616]: time="2026-02-22T11:52:23-05:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Feb 22 11:52:23 zenith go-librespot[1616]: time="2026-02-22T11:52:23-05:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Feb 22 11:52:23 zenith go-librespot[1616]: time="2026-02-22T11:52:23-05:00" level=info msg="zeroconf server listening on port 39493" Feb 22 11:52:23 zenith volumio[1368]: SPOTIFY: User informations: {"country":"US","display_name":"Michel Alexander","email":"michel.alexander@gmail.com","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/126269301"},"followers":{"href":null,"total":5},"href":"https://api.spotify.com/v1/users/126269301","id":"126269301","images":[{"height":300,"url":"https://scontent-mrs2-1.xx.fbcdn.net/v/t39.30808-1/468535849_10160940685209385_6134084513883591725_n.jpg?stp=dst-jpg_s320x320_tt6&_nc_cat=109&ccb=1-7&_nc_sid=08baa4&_nc_ohc=xdn7m-rrdlwQ7kNvwE5n1RC&_nc_oc=Adl8euI4jQ8gE9qzm9X75YfAoCzCgpTSFpuyvUyMibqSEYu9jHC4sXYTSf86rp1414ZELpD6TXH-eE1ky_BLbAEp&_nc_zt=24&_nc_ht=scontent-mrs2-1.xx&edm=AP4hL3IEAAAA&_nc_gid=QKVhAYMiG2Eho0vsxQidhQ&_nc_tpa=Q5bMBQEsRfyaJiPK038cQC7HeZMoJHzY_ExL07cgf7mSWSAsiM_ihtMiWgzZ6MSFWqsZyDFW24Ws&oh=00_AftUnTxkpFd9nnDOUeIAmfBKcFbxDbUt8RryAvPsd9SNPA&oe=69A0D23F","width":300},{"height":64,"url":"https://scontent-mrs2-1.xx.fbcdn.net/v/t39.30808-1/468535849_10160940685209385_6134084513883591725_n.jpg?stp=cp0_dst-jpg_s50x50_tt6&_nc_cat=109&ccb=1-7&_nc_sid=28885b&_nc_ohc=xdn7m-rrdlwQ7kNvwE5n1RC&_nc_oc=Adl8euI4jQ8gE9qzm9X75YfAoCzCgpTSFpuyvUyMibqSEYu9jHC4sXYTSf86rp1414ZELpD6TXH-eE1ky_BLbAEp&_nc_zt=24&_nc_ht=scontent-mrs2-1.xx&edm=AP4hL3IEAAAA&_nc_gid=QKVhAYMiG2Eho0vsxQidhQ&_nc_tpa=Q5bMBQGaUQLGLeo418oWD5-YQAky79ob_dKmExrS23dhg5sG5YUHef4CL9dbrG5lTERMlPy8GmVE&oh=00_Afu8jA_iL9xJJAeIgnckgZv5sN6mULJ8DYx0VCzLE5fGoQ&oe=69A0D23F","width":64}],"product":"premium","type":"user","uri":"spotify:user:126269301"} Feb 22 11:52:23 zenith volumio[1368]: info: Spotify Successfully logged in Feb 22 11:52:23 zenith volumio[1368]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 22 11:52:23 zenith volumio[1368]: info: [1771779143471] CoreMusicLibrary::Adding element Spotify Feb 22 11:52:23 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 22 11:52:23 zenith volumio[1368]: Cannot find translation for source Spotify Feb 22 11:52:23 zenith ntpd[1140]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101 Feb 22 11:52:23 zenith ntpd[1140]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101 Feb 22 11:52:23 zenith ntpd[1140]: DNS: Pool taking: 23.186.168.129 Feb 22 11:52:23 zenith ntpd[1140]: DNS: Pool taking: 23.150.41.123 Feb 22 11:52:23 zenith ntpd[1140]: DNS: Pool taking: 158.51.99.19 Feb 22 11:52:23 zenith ntpd[1140]: DNS: Pool taking: 23.186.168.124 Feb 22 11:52:23 zenith ntpd[1140]: DNS: dns_take_status: 0.debian.pool.ntp.org=>good, 8 Feb 22 11:52:23 zenith go-librespot[1616]: time="2026-02-22T11:52:23-05:00" level=debug msg="obtained new client token: AABK3NPLm+6YlcW4XjY1gRToR3uyvkG0GdmrZ4ByYzV+R1RHPL7RGsGxz24N7oOWON8kIDGSm+jGHOnPBtjpddbkxmKGweG1G/Y7sBdr4+x8OAmFtOPi7JMne6EDaukuwb0W/xt+qOmjEF9Jn+EE4XIxEOoYcEo/ZbYKfzh2a9TY44h3xdCm1VH7AZ+gD05tzzyMv2fKE18nLQ5WJJyt5mI1Swhm2DxS5vqmbhWPV4DhUnLOHFb5xPZyeAs=" Feb 22 11:52:23 zenith go-librespot[1616]: time="2026-02-22T11:52:23-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070" Feb 22 11:52:23 zenith go-librespot[1616]: time="2026-02-22T11:52:23-05:00" level=debug msg="completed keyexchange" Feb 22 11:52:23 zenith go-librespot[1616]: time="2026-02-22T11:52:23-05:00" level=debug msg="completed challenge" Feb 22 11:52:24 zenith mpd[1589]: 2026-02-22T11:52:24 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 22 11:52:24 zenith systemd[1]: Started mpd.service - Music Player Daemon. Feb 22 11:52:24 zenith sudo[1533]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:24 zenith sudo[1544]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:24 zenith volumio[1368]: info: Completed starting Core Plugins Feb 22 11:52:24 zenith volumio[1368]: info: ------------------------------------------- Feb 22 11:52:24 zenith volumio[1368]: info: ----- MyVolumio plugins startup ---- Feb 22 11:52:24 zenith volumio[1368]: info: ------------------------------------------- Feb 22 11:52:24 zenith volumio[1368]: info: [MyVolumio PluginManager] Fetching plans data.... Feb 22 11:52:24 zenith volumio[1368]: error: MPD error: The expression evaluated to a falsy value: Feb 22 11:52:24 zenith volumio[1368]: assert.ok(self.idling) Feb 22 11:52:24 zenith volumio[1368]: error: The expression evaluated to a falsy value: Feb 22 11:52:24 zenith volumio[1368]: assert.ok(self.idling) Feb 22 11:52:24 zenith volumio[1368]: info: MPD running with PID1589 Feb 22 11:52:24 zenith volumio[1368]: ,establishing connection Feb 22 11:52:24 zenith volumio[1368]: error: updateQueue error: null Feb 22 11:52:24 zenith volumio[1368]: error: updateQueue error: null Feb 22 11:52:24 zenith go-librespot[1616]: time="2026-02-22T11:52:24-05:00" level=info msg="authenticated AP" username="12*****01" Feb 22 11:52:24 zenith go-librespot[1616]: time="2026-02-22T11:52:24-05:00" level=info msg="authenticated Login5" username="12*****01" Feb 22 11:52:24 zenith go-librespot[1616]: time="2026-02-22T11:52:24-05:00" level=debug msg="initializing zeroconf session" username="12*****01" Feb 22 11:52:24 zenith sudo[1417]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:24 zenith go-librespot[1616]: time="2026-02-22T11:52:24-05:00" level=debug msg="dealer connection opened" Feb 22 11:52:24 zenith go-librespot[1616]: time="2026-02-22T11:52:24-05:00" level=trace msg="starting accesspoint recv loop" Feb 22 11:52:24 zenith go-librespot[1616]: time="2026-02-22T11:52:24-05:00" level=trace msg="starting dealer recv loop" Feb 22 11:52:24 zenith go-librespot[1616]: time="2026-02-22T11:52:24-05:00" level=trace msg="received accesspoint ping" Feb 22 11:52:24 zenith go-librespot[1616]: time="2026-02-22T11:52:24-05:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Feb 22 11:52:24 zenith go-librespot[1616]: time="2026-02-22T11:52:24-05:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Feb 22 11:52:24 zenith go-librespot[1616]: time="2026-02-22T11:52:24-05:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Feb 22 11:52:24 zenith go-librespot[1616]: time="2026-02-22T11:52:24-05:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Feb 22 11:52:24 zenith go-librespot[1616]: time="2026-02-22T11:52:24-05:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Feb 22 11:52:24 zenith go-librespot[1616]: time="2026-02-22T11:52:24-05:00" level=debug msg="received connection id: NzNkZTM5ZWQtOGNl...MjY4MDAxNkE4Nw==" Feb 22 11:52:24 zenith go-librespot[1616]: time="2026-02-22T11:52:24-05:00" level=trace msg="received accesspoint pong ack" Feb 22 11:52:24 zenith go-librespot[1616]: time="2026-02-22T11:52:24-05:00" level=debug msg="put connect state because NEW_DEVICE" Feb 22 11:52:24 zenith volumio[1368]: verbose: New Socket.io Connection to 192.168.133.234 from 192.168.133.66 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:147.0) Gecko/20100101 Firefox/147.0 Engine version: 3 Transport: polling Total Clients: 2 Feb 22 11:52:25 zenith volumio[1368]: info: CoreCommandRouter::volumioGetVisibleSources Feb 22 11:52:25 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 22 11:52:25 zenith volumio[1368]: info: CoreCommandRouter::volumioGetState Feb 22 11:52:25 zenith volumio[1368]: info: CorePlayQueue::getTrack 0 Feb 22 11:52:25 zenith volumio[1368]: info: CoreCommandRouter::volumioGetQueue Feb 22 11:52:25 zenith volumio[1368]: info: CoreStateMachine::getQueue Feb 22 11:52:25 zenith volumio[1368]: info: CorePlayQueue::getQueue Feb 22 11:52:25 zenith volumio[1368]: info: Listing playlists Feb 22 11:52:25 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 22 11:52:25 zenith volumio[1368]: info: CoreCommandRouter::volumioGetVisibleSources Feb 22 11:52:25 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 22 11:52:25 zenith volumio[1368]: info: CoreCommandRouter::volumioGetState Feb 22 11:52:25 zenith volumio[1368]: info: CorePlayQueue::getTrack 0 Feb 22 11:52:25 zenith volumio[1368]: info: CoreCommandRouter::volumioGetQueue Feb 22 11:52:25 zenith volumio[1368]: info: CoreStateMachine::getQueue Feb 22 11:52:25 zenith volumio[1368]: info: CorePlayQueue::getQueue Feb 22 11:52:25 zenith volumio[1368]: info: Listing playlists Feb 22 11:52:25 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 22 11:52:25 zenith volumio[1368]: info: CoreCommandRouter::volumioGetVisibleSources Feb 22 11:52:25 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 22 11:52:25 zenith volumio[1368]: info: CoreCommandRouter::volumioGetState Feb 22 11:52:25 zenith volumio[1368]: info: CorePlayQueue::getTrack 0 Feb 22 11:52:25 zenith volumio[1368]: info: CoreCommandRouter::volumioGetQueue Feb 22 11:52:25 zenith volumio[1368]: info: CoreStateMachine::getQueue Feb 22 11:52:25 zenith volumio[1368]: info: CorePlayQueue::getQueue Feb 22 11:52:25 zenith volumio[1368]: info: Listing playlists Feb 22 11:52:25 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 22 11:52:25 zenith volumio[1368]: info: go-librespot daemon successfully initialized Feb 22 11:52:27 zenith sudo[1654]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Feb 22 11:52:27 zenith sudo[1654]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 11:52:27 zenith sudo[1656]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Feb 22 11:52:27 zenith sudo[1656]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 11:52:27 zenith systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Feb 22 11:52:27 zenith sudo[1654]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:27 zenith sudo[1656]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:27 zenith volumio[1368]: info: Successfully started MPD Monitor Feb 22 11:52:27 zenith volumio[1368]: info: Successfully started MPD Monitor Feb 22 11:52:27 zenith mpd_monitor.sh[1659]: MPD Monitor Service: Starting MPD Monitor Service Feb 22 11:52:27 zenith volumio-remote-updater[993]: [2026-02-22 11:52:27] [connect] Successful connection Feb 22 11:52:27 zenith volumio-remote-updater[993]: [2026-02-22 11:52:27] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1771779147 101 Feb 22 11:52:27 zenith volumio[1368]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 3 Transport: websocket Total Clients: 3 Feb 22 11:52:28 zenith volumio[1368]: info: Initializing connection to go-librespot Websocket Feb 22 11:52:28 zenith go-librespot[1616]: time="2026-02-22T11:52:28-05:00" level=debug msg="new websocket client" Feb 22 11:52:28 zenith volumio[1368]: info: Connection to go-librespot Websocket established Feb 22 11:52:29 zenith volumio[1368]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Feb 22 11:52:31 zenith sudo[1678]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 22 11:52:31 zenith sudo[1678]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 11:52:31 zenith sudo[1680]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 22 11:52:31 zenith sudo[1678]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:31 zenith sudo[1680]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 11:52:31 zenith sudo[1680]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:31 zenith sudo[1684]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Feb 22 11:52:31 zenith sudo[1684]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 11:52:31 zenith systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Feb 22 11:52:31 zenith sudo[1684]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:31 zenith volumio[1368]: info: Upmpdcli Daemon Started Feb 22 11:52:31 zenith volumio[1368]: info: Getting Spotify volume Feb 22 11:52:31 zenith volumio[1368]: info: Spotify volume: 100 Feb 22 11:52:31 zenith volumio[1368]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Feb 22 11:52:31 zenith volumio[1368]: info: CoreCommandRouter::volumioGetState Feb 22 11:52:31 zenith volumio[1368]: info: CorePlayQueue::getTrack 0 Feb 22 11:52:31 zenith volumio[1368]: SPOTIFY: RECEIVED VOLUMIO VOLUME 32 Feb 22 11:52:31 zenith volumio[1368]: SPOTIFY: SPOTIFY VOLUME 100 Feb 22 11:52:31 zenith volumio[1368]: SPOTIFY: VOLUMIO VOLUME 32 Feb 22 11:52:31 zenith volumio[1368]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 22 11:52:31 zenith volumio[1368]: info: Setting Spotify Volume from Volumio: 32 Feb 22 11:52:32 zenith volumio[1368]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Feb 22 11:52:32 zenith volumio[1368]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Feb 22 11:52:32 zenith volumio[1368]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Feb 22 11:52:32 zenith volumio[1368]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Feb 22 11:52:32 zenith volumio[1368]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Feb 22 11:52:32 zenith volumio[1368]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Feb 22 11:52:32 zenith volumio[1368]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Feb 22 11:52:32 zenith volumio[1368]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Feb 22 11:52:32 zenith volumio[1368]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Feb 22 11:52:32 zenith volumio[1368]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Feb 22 11:52:32 zenith volumio[1368]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Feb 22 11:52:32 zenith volumio[1368]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Feb 22 11:52:32 zenith volumio[1368]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Feb 22 11:52:32 zenith volumio[1368]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Feb 22 11:52:32 zenith volumio[1368]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Feb 22 11:52:32 zenith volumio[1368]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Feb 22 11:52:32 zenith volumio[1368]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Feb 22 11:52:32 zenith volumio[1368]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Feb 22 11:52:32 zenith volumio[1368]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Feb 22 11:52:32 zenith volumio[1368]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Feb 22 11:52:32 zenith volumio[1368]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Feb 22 11:52:32 zenith volumio[1368]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Feb 22 11:52:32 zenith volumio[1368]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Feb 22 11:52:32 zenith volumio[1368]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Feb 22 11:52:32 zenith volumio[1368]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Feb 22 11:52:32 zenith volumio[1368]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Feb 22 11:52:32 zenith volumio[1368]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Feb 22 11:52:32 zenith volumio[1368]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Feb 22 11:52:32 zenith volumio[1368]: info: Adding plugin bluetooth to MyMusic Plugins Feb 22 11:52:32 zenith volumio[1368]: info: Adding plugin multiroom to MyMusic Plugins Feb 22 11:52:32 zenith volumio[1368]: info: Adding plugin metavolumio to MyMusic Plugins Feb 22 11:52:32 zenith volumio[1368]: info: Adding plugin cd_controller to MyMusic Plugins Feb 22 11:52:32 zenith volumio[1368]: info: Adding plugin qobuzconnect to MyMusic Plugins Feb 22 11:52:32 zenith volumio[1368]: info: Adding plugin smart_inputs to MyMusic Plugins Feb 22 11:52:32 zenith volumio[1368]: info: Adding plugin tidalconnect to MyMusic Plugins Feb 22 11:52:32 zenith volumio[1368]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Feb 22 11:52:32 zenith volumio[1368]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Feb 22 11:52:32 zenith volumio[1368]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Feb 22 11:52:32 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 11:52:32 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 11:52:32 zenith volumio[1368]: info: Starting MyVolumio Remote Streaming Endpoints Feb 22 11:52:32 zenith volumio[1368]: info: MyVolumio login type: Token Feb 22 11:52:32 zenith volumio[1368]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Feb 22 11:52:32 zenith volumio[1368]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Feb 22 11:52:32 zenith volumio[1368]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Feb 22 11:52:32 zenith volumio[1368]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Feb 22 11:52:32 zenith volumio[1368]: info: Streaming services startup Feb 22 11:52:32 zenith volumio[1368]: info: Starting Streaming Daemon Feb 22 11:52:32 zenith sudo[1704]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Feb 22 11:52:32 zenith sudo[1704]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 11:52:32 zenith volumio[1368]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Feb 22 11:52:32 zenith sudo[1704]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:32 zenith volumio[1368]: error: Cannot start Volumio Streaming Daemon Feb 22 11:52:32 zenith volumio[1368]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Feb 22 11:52:32 zenith volumio[1368]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Feb 22 11:52:32 zenith volumio[1368]: info: CoreCommandRouter::volumioGetState Feb 22 11:52:32 zenith volumio[1368]: info: CorePlayQueue::getTrack 0 Feb 22 11:52:33 zenith volumio[1368]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Feb 22 11:52:33 zenith volumio[1368]: SPOTIFY: SETTING SPOTIFY VOLUME 32 Feb 22 11:52:33 zenith volumio[1368]: info: Sending Spotify command with payload to local API: /player/volume Feb 22 11:52:33 zenith go-librespot[1616]: time="2026-02-22T11:52:33-05:00" level=debug msg="update volume requested to 20971/65535" Feb 22 11:52:33 zenith systemd[1]: systemd-fsckd.service: Deactivated successfully. Feb 22 11:52:33 zenith volumio[1368]: info: MyVolumio token set successfully Feb 22 11:52:33 zenith volumio[1368]: info: MYVOLUMIO: Adding device Feb 22 11:52:33 zenith volumio[1368]: info: MYVOLUMIO: Evaluating Server Feb 22 11:52:33 zenith go-librespot[1616]: time="2026-02-22T11:52:33-05:00" level=debug msg="put connect state because VOLUME_CHANGED" Feb 22 11:52:33 zenith go-librespot[1616]: time="2026-02-22T11:52:33-05:00" level=trace msg="emitting websocket event: volume" Feb 22 11:52:33 zenith volumio[1368]: SPOTIFY: received: {"type":"volume","data":{"value":32,"max":100}} Feb 22 11:52:33 zenith volumio[1368]: SPOTIFY: RECEIVED SPOTIFY VOLUME 32 Feb 22 11:52:33 zenith volumio[1368]: info: MyVolumio Plan changed: premium Feb 22 11:52:33 zenith volumio[1368]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Feb 22 11:52:33 zenith volumio[1368]: info: Removing browser output: myVolumio user plan is not superstar Feb 22 11:52:33 zenith volumio[1368]: info: Removing audio output: Feb 22 11:52:33 zenith volumio[1368]: info: MYVOLUMIO: Adding device Feb 22 11:52:33 zenith volumio[1368]: info: MYVOLUMIO: Evaluating Server Feb 22 11:52:33 zenith volumio[1368]: info: Remote config written successfully Feb 22 11:52:33 zenith volumio[1368]: info: Starting Tunnel 1 Feb 22 11:52:33 zenith volumio[1368]: info: Starting Tunnel Connection Checker Feb 22 11:52:33 zenith volumio[1368]: info: Completed starting MyVolumio Plugin Feb 22 11:52:33 zenith volumio[1368]: info: Setting Geolocation for MyVolumio to us1 Feb 22 11:52:33 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 11:52:33 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 11:52:33 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 11:52:34 zenith dhcpcd[900]: timed out Feb 22 11:52:34 zenith sh[887]: timed out Feb 22 11:52:34 zenith sh[836]: ifup: failed to bring up eth0 Feb 22 11:52:34 zenith systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Feb 22 11:52:34 zenith systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Feb 22 11:52:34 zenith volumio[1368]: info: MYVolumio Device enabled Feb 22 11:52:34 zenith volumio[1368]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Feb 22 11:52:34 zenith volumio[1368]: info: MyVolumio status changed Feb 22 11:52:34 zenith volumio[1368]: info: Streaming services startup Feb 22 11:52:34 zenith volumio[1368]: info: Starting Streaming Daemon Feb 22 11:52:34 zenith sudo[1733]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Feb 22 11:52:34 zenith sudo[1733]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 11:52:34 zenith sudo[1733]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:34 zenith volumio[1368]: info: Successfully Added MyVolumio device Feb 22 11:52:34 zenith volumio[1368]: error: Cannot start Volumio Streaming Daemon Feb 22 11:52:34 zenith volumio[1368]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Feb 22 11:52:34 zenith volumio[1368]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Feb 22 11:52:34 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Feb 22 11:52:34 zenith volumio[1368]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Feb 22 11:52:34 zenith volumio[1368]: ------------------------------------ BT MESSAGE: [FUNC] onVolumioStart Feb 22 11:52:34 zenith volumio[1368]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Feb 22 11:52:34 zenith volumio[1368]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom Feb 22 11:52:34 zenith sudo[1756]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Feb 22 11:52:34 zenith sudo[1756]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 11:52:34 zenith sudo[1756]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:34 zenith volumio[1368]: info: MRS: MultiRoom plugin initialized Feb 22 11:52:34 zenith volumio[1368]: info: MRS: STOPPING SNAPCLIENT Feb 22 11:52:34 zenith volumio[1368]: info: MRS: Snap server stop Feb 22 11:52:34 zenith volumio[1368]: info: MRS: STOPPING volumioStreaming Feb 22 11:52:34 zenith volumio[1368]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Feb 22 11:52:34 zenith sudo[1777]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Feb 22 11:52:34 zenith sudo[1776]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Feb 22 11:52:34 zenith sudo[1779]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Feb 22 11:52:34 zenith sudo[1776]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 11:52:34 zenith sudo[1779]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 11:52:34 zenith sudo[1774]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Feb 22 11:52:34 zenith sudo[1774]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 11:52:34 zenith sudo[1777]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 11:52:34 zenith volumio[1368]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Feb 22 11:52:34 zenith volumio[1368]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Feb 22 11:52:34 zenith sudo[1779]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:34 zenith volumio[1368]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Feb 22 11:52:34 zenith volumio[1368]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Feb 22 11:52:34 zenith volumio[1368]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio Feb 22 11:52:34 zenith volumio[1368]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Feb 22 11:52:34 zenith volumio[1368]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Feb 22 11:52:34 zenith sudo[1776]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:34 zenith sudo[1774]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:34 zenith sudo[1777]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:34 zenith volumio[1368]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Feb 22 11:52:34 zenith volumio[1368]: info: [MyVolumio PluginManager] Loading plugin "qobuzconnect"... Feb 22 11:52:34 zenith volumio[1368]: info: Preparing to generate the ALSA configuration file Feb 22 11:52:34 zenith volumio[1368]: info: Setting Geolocation for MyVolumio to us4 Feb 22 11:52:34 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 11:52:34 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 11:52:34 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 11:52:34 zenith volumio[1368]: info: MRS: Removed streaming files Feb 22 11:52:34 zenith volumio[1368]: info: MRS: volumioStreaming STOPPED Feb 22 11:52:34 zenith volumio[1368]: info: MRS: SNAPSERVER STOPPED Feb 22 11:52:34 zenith volumio[1368]: info: MRS: SNAPCLIENT STOPPED Feb 22 11:52:34 zenith volumio[1368]: info: Asound.conf file unchanged, so no further update is needed Feb 22 11:52:34 zenith volumio[1368]: info: Output device has changed, restarting MPD Feb 22 11:52:34 zenith sudo[1785]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 22 11:52:34 zenith sudo[1785]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 11:52:34 zenith volumio[1368]: info: Output device has changed, restarting Shairport Sync Feb 22 11:52:34 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 11:52:34 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 11:52:34 zenith sudo[1787]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 22 11:52:34 zenith sudo[1787]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 11:52:34 zenith sudo[1785]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:34 zenith volumio[1368]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 22 11:52:34 zenith volumio[1368]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Feb 22 11:52:34 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 11:52:34 zenith volumio[1368]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth Feb 22 11:52:34 zenith volumio[1368]: ------------------------------------ BT MESSAGE: [FUNC] onStart Feb 22 11:52:34 zenith volumio[1368]: ------------------------------------ BT MESSAGE: Starting Volumio Bluetooth Service Feb 22 11:52:34 zenith systemd[1]: Stopping mpd.service - Music Player Daemon... Feb 22 11:52:34 zenith volumio[1368]: ------------------------------------ BT MESSAGE: Boot config /etc/bluetooth/volumio.conf: cache mode = tmp Feb 22 11:52:34 zenith volumio[1368]: ------------------------------------ BT MESSAGE: [metaCache] Created directory: /tmp/bluetooth-cache/ Feb 22 11:52:34 zenith volumio[1368]: ------------------------------------ BT MESSAGE: [metaCache] Directory exists and is ready. Feb 22 11:52:34 zenith dbus-daemon[982]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' requested by ':1.11' (uid=1000 pid=1368 comm="/usr/bin/node /volumio/index.js") Feb 22 11:52:34 zenith dbus-daemon[982]: [system] Activation via systemd failed for unit 'dbus-org.bluez.service': Unit dbus-org.bluez.service not found. Feb 22 11:52:34 zenith volumio[1368]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom Feb 22 11:52:34 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Feb 22 11:52:34 zenith volumio[1368]: info: MRS: Pushing multiroomSync output for this device Feb 22 11:52:34 zenith volumio[1368]: info: MRS: Pushing multiroomSync output Feb 22 11:52:34 zenith volumio[1368]: info: Adding audio output: Feb 22 11:52:34 zenith volumio[1368]: info: Adding audio output: Feb 22 11:52:34 zenith volumio[1368]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Feb 22 11:52:34 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 11:52:34 zenith volumio[1368]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio Feb 22 11:52:34 zenith volumio[1368]: info: Adding METAVOLUMIO REST API Endpoints Feb 22 11:52:34 zenith volumio[1368]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Feb 22 11:52:34 zenith volumio[1368]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Feb 22 11:52:34 zenith volumio[1368]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Feb 22 11:52:34 zenith volumio[1368]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Feb 22 11:52:34 zenith volumio[1368]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui Feb 22 11:52:34 zenith volumio[1368]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller Feb 22 11:52:34 zenith volumio[1368]: info: Preparing CD Folders Feb 22 11:52:34 zenith volumio[1368]: info: Adding CD REST API Endpoints Feb 22 11:52:34 zenith volumio[1368]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Feb 22 11:52:34 zenith volumio[1368]: info: Starting UDEV Watcher for CD Feb 22 11:52:34 zenith volumio[1368]: info: Detecting CD presence with UDEV Feb 22 11:52:34 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Feb 22 11:52:34 zenith systemd[1]: mpd.service: Deactivated successfully. Feb 22 11:52:34 zenith systemd[1]: Stopped mpd.service - Music Player Daemon. Feb 22 11:52:34 zenith systemd[1]: mpd.service: Consumed 1.328s CPU time. Feb 22 11:52:34 zenith systemd[1]: mpd.socket: Deactivated successfully. Feb 22 11:52:34 zenith systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Feb 22 11:52:34 zenith systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Feb 22 11:52:34 zenith systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 22 11:52:34 zenith systemd[1]: Starting mpd.service - Music Player Daemon... Feb 22 11:52:34 zenith sudo[1805]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 22 11:52:34 zenith sudo[1805]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 22 11:52:34 zenith sudo[1805]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:35 zenith mpd[1807]: 2026-02-22T11:52:35 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 22 11:52:35 zenith systemd[1]: Started mpd.service - Music Player Daemon. Feb 22 11:52:35 zenith sudo[1787]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:36 zenith upmpdcli[1810]: writing RSA key Feb 22 11:52:39 zenith volumio[1368]: warn: [cd-plugin] cdspeedctl: device or media not ready Feb 22 11:52:39 zenith volumio[1368]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs Feb 22 11:52:39 zenith volumio[1368]: info: Adding inputs REST Endpoints Feb 22 11:52:39 zenith volumio[1368]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Feb 22 11:52:39 zenith volumio[1368]: info: Scanning Audio Inputs Feb 22 11:52:39 zenith volumio[1368]: info: Checking against Known Cards name Feb 22 11:52:39 zenith volumio[1368]: info: Adding Server instance for streaming Feb 22 11:52:39 zenith volumio[1368]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio Feb 22 11:52:39 zenith volumio[1368]: error: Hi Res Audio Failed Login: Missing Login Data Feb 22 11:52:39 zenith volumio[1368]: info: Adding HIGHRESAUDIO REST API Endpoints Feb 22 11:52:39 zenith volumio[1368]: info: Adding saveAccountData_hi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Feb 22 11:52:39 zenith volumio[1368]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal Feb 22 11:52:39 zenith volumio[1368]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz Feb 22 11:52:39 zenith volumio[1368]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Feb 22 11:52:39 zenith volumio[1368]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuzconnect Feb 22 11:52:39 zenith volumio[1368]: info: Adding qc_getconfig REST Endpoint for plugin: music_service/qobuzconnect Feb 22 11:52:39 zenith sudo[1818]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 22 11:52:39 zenith sudo[1818]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 11:52:39 zenith volumio[1368]: info: QobuzConnect: Starting Qobuz Connect socket and service Feb 22 11:52:39 zenith volumio[1368]: info: QobuzConnect: Opened /tmp/qbz-connect.socket socket, listening for connections Feb 22 11:52:39 zenith volumio[1368]: info: Adding TIDAL REST API Endpoints Feb 22 11:52:39 zenith volumio[1368]: info: Stopping AccessToken refresher cron for QOBUZ Feb 22 11:52:39 zenith sudo[1825]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Feb 22 11:52:39 zenith sudo[1825]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 11:52:39 zenith sudo[1818]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:39 zenith volumio[1368]: info: AccessToken refresher cron started for QOBUZ Feb 22 11:52:39 zenith volumio[1368]: info: Adding QOBUZ REST API Endpoints Feb 22 11:52:39 zenith sudo[1825]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:39 zenith volumio[1368]: info: Updating MyVolumio device info Feb 22 11:52:39 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 11:52:39 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 11:52:39 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 11:52:39 zenith volumio[1368]: info: Updating MyVolumio device info Feb 22 11:52:39 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 11:52:39 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 11:52:39 zenith volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 11:52:39 zenith sudo[1828]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Feb 22 11:52:39 zenith sudo[1828]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 22 11:52:39 zenith volumio[1368]: info: MRS: Getting audio outputs on start Feb 22 11:52:39 zenith volumio[1368]: info: MRS: Requesting all other devices output Feb 22 11:52:39 zenith volumio[1368]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 22 11:52:39 zenith volumio[1368]: DBusError: Unit dbus-org.bluez.service not found. Feb 22 11:52:39 zenith volumio[1368]: at _methodReturnHandlers. (/myvolumio/plugins/audio_interface/bluetooth/node_modules/dbus-next/lib/bus.js:343:27) Feb 22 11:52:39 zenith volumio[1368]: at handleMessage (/myvolumio/plugins/audio_interface/bluetooth/node_modules/dbus-next/lib/bus.js:101:11) Feb 22 11:52:39 zenith volumio[1368]: at EventEmitter. (/myvolumio/plugins/audio_interface/bluetooth/node_modules/dbus-next/lib/bus.js:151:9) Feb 22 11:52:39 zenith volumio[1368]: at EventEmitter.emit (node:events:514:28) Feb 22 11:52:39 zenith volumio[1368]: at /myvolumio/plugins/audio_interface/bluetooth/node_modules/dbus-next/lib/connection.js:132:14 Feb 22 11:52:39 zenith volumio[1368]: at Socket. (/myvolumio/plugins/audio_interface/bluetooth/node_modules/dbus-next/lib/message.js:65:9) Feb 22 11:52:39 zenith volumio[1368]: at Socket.emit (node:events:514:28) Feb 22 11:52:39 zenith volumio[1368]: at emitReadable_ (node:internal/streams/readable:609:12) Feb 22 11:52:39 zenith volumio[1368]: at process.processTicksAndRejections (node:internal/process/task_queues:81:21) { Feb 22 11:52:39 zenith volumio[1368]: type: 'org.freedesktop.systemd1.NoSuchUnit', Feb 22 11:52:39 zenith volumio[1368]: text: 'Unit dbus-org.bluez.service not found.', Feb 22 11:52:39 zenith volumio[1368]: reply: Message { Feb 22 11:52:39 zenith volumio[1368]: type: 3, Feb 22 11:52:39 zenith volumio[1368]: _sent: false, Feb 22 11:52:39 zenith volumio[1368]: _serial: 3, Feb 22 11:52:39 zenith volumio[1368]: path: undefined, Feb 22 11:52:39 zenith volumio[1368]: interface: undefined, Feb 22 11:52:39 zenith volumio[1368]: member: undefined, Feb 22 11:52:39 zenith volumio[1368]: errorName: 'org.freedesktop.systemd1.NoSuchUnit', Feb 22 11:52:39 zenith volumio[1368]: replySerial: 2, Feb 22 11:52:39 zenith volumio[1368]: destination: ':1.11', Feb 22 11:52:39 zenith volumio[1368]: sender: 'org.freedesktop.DBus', Feb 22 11:52:39 zenith volumio[1368]: signature: 's', Feb 22 11:52:39 zenith volumio[1368]: body: [ 'Unit dbus-org.bluez.service not found.' ], Feb 22 11:52:39 zenith volumio[1368]: flags: 1 Feb 22 11:52:39 zenith volumio[1368]: } Feb 22 11:52:39 zenith volumio[1368]: } Feb 22 11:52:39 zenith volumio[1368]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 22 11:52:39 zenith systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Feb 22 11:52:39 zenith sudo[1828]: pam_unix(sudo:session): session closed for user root Feb 22 11:52:40 zenith sudo[1845]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-22 11:51' Feb 22 11:52:40 zenith sudo[1845]: 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="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"